Page MenuHomePhorge
Create Task
Maniphest T1207

kolab list-mailboxes throws an EOF error on a clean system
Closed, ResolvedPublic
Actions

Description

If there is no email account created yet, kolab lm will give this output:

[root@052-centos7k16 ~]# kolab lm
Traceback (most recent call last):
  File "/usr/sbin/kolab", line 39, in <module>
    kolab = Cli()
  File "/usr/lib/python2.7/site-packages/pykolab/cli/__init__.py", line 73, in __init__
    commands.execute('_'.join(to_execute))
  File "/usr/lib/python2.7/site-packages/pykolab/cli/commands.py", line 138, in execute
    commands[cmd_name]['function'](conf.cli_args, kw)
  File "/usr/lib/python2.7/site-packages/pykolab/cli/cmd_list_mailboxes.py", line 88, in execute
    folders.extend(imap.lm(imap_utf7.encode(search)))
  File "/usr/lib/python2.7/site-packages/pykolab/imap/__init__.py", line 1140, in lm
    return self.imap.lm(*args, **kw)
  File "/usr/lib/python2.7/site-packages/cyruslib.py", line 512, in lm
    res, ml = self.__docommand('list', '""', self.decode(pattern))
  File "/usr/lib/python2.7/site-packages/cyruslib.py", line 389, in __docommand
    self.__doexception(function, error, *args)
  File "/usr/lib/python2.7/site-packages/cyruslib.py", line 358, in __doexception
    self.__doraise( function.upper(), msg )
  File "/usr/lib/python2.7/site-packages/cyruslib.py", line 367, in __doraise
    raise CYRUSError( idError[0], mode, msg )
cyruslib.CYRUSError: (99, 'LIST', 'EOF')

This is a bother, because the docs say in https://docs.kolab.org/administrator-guide/verifying-the-installation.html to check kolab lm first.

Details

Ticket Type
Task

Event Timeline

pokorra lowered the priority of this task from 60 to 40.Apr 15 2016, 6:01 PM
pokorra created this task.
pokorra added a project: PyKolab.
pokorra added a subscriber: PyKolab Developers.
pokorra added a comment.Apr 15 2016, 6:12 PM

I checked a little bit.

IMAP4_SSL.list is called in "/usr/lib/python2.7/site-packages/cyruslib.py", line 389

The exception is thrown in /usr/lib64/python2.7/imaplib.py, line 1023

def _get_line(self):

    line = self.readline()
    if not line:
        raise self.abort('socket error: EOF')
pokorra updated the task description. (Show Details)Apr 15 2016, 6:14 PM
vanmeeuwen subscribed.Jun 3 2016, 6:17 AM

Run this command with -d 9 to see more literal output all the way down to imaplib.

pokorra added a comment.Jun 8 2016, 3:14 PM

This does not happen in Winterfell, just in Kolab 16.

here is the output:

[root@052-centos7k16 kolab]# kolab lm -d 9
2016-06-08 15:12:40,123 pykolab.conf DEBUG [19639]: Setting kolab_default_locale to 'en_US' (from defaults)
2016-06-08 15:12:40,124 pykolab.conf DEBUG [19639]: Setting mail_attributes to ['mail', 'alias'] (from defaults)
2016-06-08 15:12:40,124 pykolab.conf DEBUG [19639]: Setting mailserver_attribute to 'mailhost' (from defaults)
2016-06-08 15:12:40,124 pykolab.conf DEBUG [19639]: Setting loglevel to 50 (from defaults)
2016-06-08 15:12:40,124 pykolab.conf DEBUG [19639]: Setting imap_virtual_domains to 'userid' (from defaults)
2016-06-08 15:12:40,124 pykolab.conf DEBUG [19639]: Setting cyrus_annotations_retry_interval to 1 (from defaults)
2016-06-08 15:12:40,124 pykolab.conf DEBUG [19639]: Setting ldap_unique_attribute to 'nsuniqueid' (from defaults)
2016-06-08 15:12:40,125 pykolab.conf DEBUG [19639]: Setting kolab_domain_sync_interval to 600 (from defaults)
2016-06-08 15:12:40,125 pykolab.conf DEBUG [19639]: Setting wallace_resource_calendar_expire_days to 100 (from defaults)
2016-06-08 15:12:40,125 pykolab.conf DEBUG [19639]: Setting address_search_attrs to ['mail', 'alias'] (from defaults)
2016-06-08 15:12:40,125 pykolab.conf DEBUG [19639]: Setting config_file to '/etc/kolab/kolab.conf' (from the default values for CLI options)
2016-06-08 15:12:40,125 pykolab.conf DEBUG [19639]: Setting answer_default to False (from the default values for CLI options)
2016-06-08 15:12:40,125 pykolab.conf DEBUG [19639]: Setting loglevel to 'CRITICAL' (from the default values for CLI options)
2016-06-08 15:12:40,126 pykolab.conf DEBUG [19639]: Setting answer_yes to False (from the default values for CLI options)
2016-06-08 15:12:40,126 pykolab.conf DEBUG [19639]: Setting quiet to False (from the default values for CLI options)
2016-06-08 15:12:40,126 pykolab.conf DEBUG [19639]: Setting raw to False (from the default values for CLI options)
2016-06-08 15:12:40,126 pykolab.conf DEBUG [19639]: Setting connect_server to None (from the default values for CLI options)
2016-06-08 15:12:40,126 pykolab.conf DEBUG [19639]: Setting debuglevel to 0 (from the default values for CLI options)
2016-06-08 15:12:40,126 pykolab.conf DEBUG [19639]: Setting logfile to '/var/log/kolab/pykolab.log' (from the default values for CLI options)
2016-06-08 15:12:40,126 pykolab.conf DEBUG [19639]: Setting options from configuration file
2016-06-08 15:12:40,127 pykolab.conf DEBUG [19639]: Reading configuration file /etc/kolab/kolab.conf
2016-06-08 15:12:40,130 pykolab.conf DEBUG [19639]: Setting config_file to '/etc/kolab/kolab.conf' (from CLI, verified)
2016-06-08 15:12:40,130 pykolab.conf DEBUG [19639]: Setting answer_default to False (from CLI, not checked)
2016-06-08 15:12:40,130 pykolab.conf DEBUG [19639]: Setting loglevel to 'CRITICAL' (from CLI, not checked)
2016-06-08 15:12:40,130 pykolab.conf DEBUG [19639]: Setting answer_yes to False (from CLI, not checked)
2016-06-08 15:12:40,130 pykolab.conf DEBUG [19639]: Setting quiet to False (from CLI, not checked)
2016-06-08 15:12:40,131 pykolab.conf DEBUG [19639]: Setting raw to False (from CLI, not checked)
2016-06-08 15:12:40,131 pykolab.conf DEBUG [19639]: Setting connect_server to None (from CLI, not checked)
2016-06-08 15:12:40,131 pykolab.conf DEBUG [19639]: Setting debuglevel to 9 (from CLI, verified)
2016-06-08 15:12:40,131 pykolab.conf DEBUG [19639]: Setting logfile to '/var/log/kolab/pykolab.log' (from CLI, not checked)
* OK [CAPABILITY IMAP4rev1 LITERAL+ ID ENABLE AUTH=PLAIN AUTH=LOGIN SASL-IR] 052-centos7k16.kolab.pokorra.de Cyrus IMAP 2.5.8.12-Kolab-2.5.8-13.1.el7.kolab_16 server ready

* CAPABILITY IMAP4rev1 LITERAL+ ID ENABLE ACL RIGHTS=kxten QUOTA MAILBOX-REFERRALS NAMESPACE UIDPLUS NO_ATOMIC_RENAME UNSELECT CHILDREN MULTIAPPEND BINARY CATENATE CONDSTORE ESEARCH SORT SORT=MODSEQ SORT=DISPLAY SORT=UID THREAD=ORDEREDSUBJECT THREAD=REFERENCES ANNOTATEMORE ANNOTATE-EXPERIMENT-1 METADATA LIST-EXTENDED LIST-STATUS LIST-MYRIGHTS WITHIN QRESYNC SCAN XLIST XMOVE MOVE SPECIAL-USE CREATE-SPECIAL-USE URLAUTH URLAUTH=BINARY X-NETSCAPE AUTH=PLAIN AUTH=LOGIN SASL-IR X-QUOTA=STORAGE X-QUOTA=MESSAGE X-QUOTA=X-ANNOTATION-STORAGE X-QUOTA=X-NUM-FOLDERS IDLE

NOPB0 OK Completed

2016-06-08 15:12:40,261 pykolab.imap DEBUG [19639]: Logging on to Cyrus IMAP server localhost
  12:40.26 > NOPB1 LOGIN cyrus-admin "aaeMYBGdG-b1hNl"
NOPB1 OK [CAPABILITY IMAP4rev1 LITERAL+ ID ENABLE ACL RIGHTS=kxten QUOTA MAILBOX-REFERRALS NAMESPACE UIDPLUS NO_ATOMIC_RENAME UNSELECT CHILDREN MULTIAPPEND BINARY CATENATE CONDSTORE ESEARCH SORT SORT=MODSEQ SORT=DISPLAY SORT=UID THREAD=ORDEREDSUBJECT THREAD=REFERENCES ANNOTATEMORE ANNOTATE-EXPERIMENT-1 METADATA LIST-EXTENDED LIST-STATUS LIST-MYRIGHTS WITHIN QRESYNC SCAN XLIST XMOVE MOVE SPECIAL-USE CREATE-SPECIAL-USE URLAUTH URLAUTH=BINARY X-NETSCAPE LOGINDISABLED AUTH=PLAIN AUTH=LOGIN X-QUOTA=STORAGE X-QUOTA=MESSAGE X-QUOTA=X-ANNOTATION-STORAGE X-QUOTA=X-NUM-FOLDERS IDLE] User logged in SESSIONID=<052-centos7k16.kolab.pokorra.de-19548-1465391560-1-17193005221587135862>

  12:40.56 < NOPB1 OK [CAPABILITY IMAP4rev1 LITERAL+ ID ENABLE ACL RIGHTS=kxten QUOTA MAILBOX-REFERRALS NAMESPACE UIDPLUS NO_ATOMIC_RENAME UNSELECT CHILDREN MULTIAPPEND BINARY CATENATE CONDSTORE ESEARCH SORT SORT=MODSEQ SORT=DISPLAY SORT=UID THREAD=ORDEREDSUBJECT THREAD=REFERENCES ANNOTATEMORE ANNOTATE-EXPERIMENT-1 METADATA LIST-EXTENDED LIST-STATUS LIST-MYRIGHTS WITHIN QRESYNC SCAN XLIST XMOVE MOVE SPECIAL-USE CREATE-SPECIAL-USE URLAUTH URLAUTH=BINARY X-NETSCAPE LOGINDISABLED AUTH=PLAIN AUTH=LOGIN X-QUOTA=STORAGE X-QUOTA=MESSAGE X-QUOTA=X-ANNOTATION-STORAGE X-QUOTA=X-NUM-FOLDERS IDLE] User logged in SESSIONID=<052-centos7k16.kolab.pokorra.de-19548-1465391560-1-17193005221587135862>
  12:40.56 	matched r'(?P<tag>NOPB\d+) (?P<type>[A-Z]+) (?P<data>.*)' => ('NOPB1', 'OK', '[CAPABILITY IMAP4rev1 LITERAL+ ID ENABLE ACL RIGHTS=kxten QUOTA MAILBOX-REFERRALS NAMESPACE UIDPLUS NO_ATOMIC_RENAME UNSELECT CHILDREN MULTIAPPEND BINARY CATENATE CONDSTORE ESEARCH SORT SORT=MODSEQ SORT=DISPLAY SORT=UID THREAD=ORDEREDSUBJECT THREAD=REFERENCES ANNOTATEMORE ANNOTATE-EXPERIMENT-1 METADATA LIST-EXTENDED LIST-STATUS LIST-MYRIGHTS WITHIN QRESYNC SCAN XLIST XMOVE MOVE SPECIAL-USE CREATE-SPECIAL-USE URLAUTH URLAUTH=BINARY X-NETSCAPE LOGINDISABLED AUTH=PLAIN AUTH=LOGIN X-QUOTA=STORAGE X-QUOTA=MESSAGE X-QUOTA=X-ANNOTATION-STORAGE X-QUOTA=X-NUM-FOLDERS IDLE] User logged in SESSIONID=<052-centos7k16.kolab.pokorra.de-19548-1465391560-1-17193005221587135862>')
  12:40.56 	matched r'\[(?P<type>[A-Z-]+)( (?P<data>[^\]]*))?\]' => ('CAPABILITY', ' IMAP4rev1 LITERAL+ ID ENABLE ACL RIGHTS=kxten QUOTA MAILBOX-REFERRALS NAMESPACE UIDPLUS NO_ATOMIC_RENAME UNSELECT CHILDREN MULTIAPPEND BINARY CATENATE CONDSTORE ESEARCH SORT SORT=MODSEQ SORT=DISPLAY SORT=UID THREAD=ORDEREDSUBJECT THREAD=REFERENCES ANNOTATEMORE ANNOTATE-EXPERIMENT-1 METADATA LIST-EXTENDED LIST-STATUS LIST-MYRIGHTS WITHIN QRESYNC SCAN XLIST XMOVE MOVE SPECIAL-USE CREATE-SPECIAL-USE URLAUTH URLAUTH=BINARY X-NETSCAPE LOGINDISABLED AUTH=PLAIN AUTH=LOGIN X-QUOTA=STORAGE X-QUOTA=MESSAGE X-QUOTA=X-ANNOTATION-STORAGE X-QUOTA=X-NUM-FOLDERS IDLE', 'IMAP4rev1 LITERAL+ ID ENABLE ACL RIGHTS=kxten QUOTA MAILBOX-REFERRALS NAMESPACE UIDPLUS NO_ATOMIC_RENAME UNSELECT CHILDREN MULTIAPPEND BINARY CATENATE CONDSTORE ESEARCH SORT SORT=MODSEQ SORT=DISPLAY SORT=UID THREAD=ORDEREDSUBJECT THREAD=REFERENCES ANNOTATEMORE ANNOTATE-EXPERIMENT-1 METADATA LIST-EXTENDED LIST-STATUS LIST-MYRIGHTS WITHIN QRESYNC SCAN XLIST XMOVE MOVE SPECIAL-USE CREATE-SPECIAL-USE URLAUTH URLAUTH=BINARY X-NETSCAPE LOGINDISABLED AUTH=PLAIN AUTH=LOGIN X-QUOTA=STORAGE X-QUOTA=MESSAGE X-QUOTA=X-ANNOTATION-STORAGE X-QUOTA=X-NUM-FOLDERS IDLE')
  12:40.56 untagged_responses[CAPABILITY] 0 += ["IMAP4rev1 LITERAL+ ID ENABLE ACL RIGHTS=kxten QUOTA MAILBOX-REFERRALS NAMESPACE UIDPLUS NO_ATOMIC_RENAME UNSELECT CHILDREN MULTIAPPEND BINARY CATENATE CONDSTORE ESEARCH SORT SORT=MODSEQ SORT=DISPLAY SORT=UID THREAD=ORDEREDSUBJECT THREAD=REFERENCES ANNOTATEMORE ANNOTATE-EXPERIMENT-1 METADATA LIST-EXTENDED LIST-STATUS LIST-MYRIGHTS WITHIN QRESYNC SCAN XLIST XMOVE MOVE SPECIAL-USE CREATE-SPECIAL-USE URLAUTH URLAUTH=BINARY X-NETSCAPE LOGINDISABLED AUTH=PLAIN AUTH=LOGIN X-QUOTA=STORAGE X-QUOTA=MESSAGE X-QUOTA=X-ANNOTATION-STORAGE X-QUOTA=X-NUM-FOLDERS IDLE"]
  12:40.56 > NOPB2 DUMP NIL
NOPB2 NO Mailbox does not exist

  12:40.57 < NOPB2 NO Mailbox does not exist
  12:40.57 	matched r'(?P<tag>NOPB\d+) (?P<type>[A-Z]+) (?P<data>.*)' => ('NOPB2', 'NO', 'Mailbox does not exist')
  12:40.57 NO response: Mailbox does not exist
  12:40.57 > NOPB3 LIST "" ""
* LIST (\Noselect) "/" ""

  12:40.61 < * LIST (\Noselect) "/" ""
  12:40.61 	matched r'\* (?P<type>[A-Z-]+)( (?P<data>.*))?' => ('LIST', ' (\\Noselect) "/" ""', '(\\Noselect) "/" ""')
  12:40.61 untagged_responses[LIST] 0 += ["(\Noselect) "/" """]
NOPB3 OK Completed (0.000 secs)

  12:40.61 < NOPB3 OK Completed (0.000 secs)
  12:40.61 	matched r'(?P<tag>NOPB\d+) (?P<type>[A-Z]+) (?P<data>.*)' => ('NOPB3', 'OK', 'Completed (0.000 secs)')
  12:40.61 untagged_responses[LIST] => ['(\\Noselect) "/" ""']
[LOGIN cyrus-admin] OK: [CAPABILITY IMAP4rev1 LITERAL+ ID ENABLE ACL RIGHTS=kxten QUOTA MAILBOX-REFERRALS NAMESPACE UIDPLUS NO_ATOMIC_RENAME UNSELECT CHILDREN MULTIAPPEND BINARY CATENATE CONDSTORE ESEARCH SORT SORT=MODSEQ SORT=DISPLAY SORT=UID THREAD=ORDEREDSUBJECT THREAD=REFERENCES ANNOTATEMORE ANNOTATE-EXPERIMENT-1 METADATA LIST-EXTENDED LIST-STATUS LIST-MYRIGHTS WITHIN QRESYNC SCAN XLIST XMOVE MOVE SPECIAL-USE CREATE-SPECIAL-USE URLAUTH URLAUTH=BINARY X-NETSCAPE LOGINDISABLED AUTH=PLAIN AUTH=LOGIN X-QUOTA=STORAGE X-QUOTA=MESSAGE X-QUOTA=X-ANNOTATION-STORAGE X-QUOTA=X-NUM-FOLDERS IDLE] User logged in SESSIONID=<052-centos7k16.kolab.pokorra.de-19548-1465391560-1-17193005221587135862>
2016-06-08 15:12:40,612 pykolab.imap DEBUG [19639]: Continuing with separator: '/'
2016-06-08 15:12:40,612 pykolab.imap DEBUG [19639]: This system is not part of a murder topology
2016-06-08 15:12:40,612 pykolab.cli DEBUG [19639]: Appending folder search for ''
  12:40.61 > NOPB4 LIST "" *
  12:40.64 last 4 IMAP4 interactions:
  12:40.20 < * OK [CAPABILITY IMAP4rev1 LITERAL+ ID ENABLE AUTH=PLAIN AUTH=LOGIN SASL-IR] 052-centos7k16.kolab.pokorra.de Cyrus IMAP 2.5.8.12-Kolab-2.5.8-13.1.el7.kolab_16 server ready
  12:40.20 > NOPB0 CAPABILITY
  12:40.26 < * CAPABILITY IMAP4rev1 LITERAL+ ID ENABLE ACL RIGHTS=kxten QUOTA MAILBOX-REFERRALS NAMESPACE UIDPLUS NO_ATOMIC_RENAME UNSELECT CHILDREN MULTIAPPEND BINARY CATENATE CONDSTORE ESEARCH SORT SORT=MODSEQ SORT=DISPLAY SORT=UID THREAD=ORDEREDSUBJECT THREAD=REFERENCES ANNOTATEMORE ANNOTATE-EXPERIMENT-1 METADATA LIST-EXTENDED LIST-STATUS LIST-MYRIGHTS WITHIN QRESYNC SCAN XLIST XMOVE MOVE SPECIAL-USE CREATE-SPECIAL-USE URLAUTH URLAUTH=BINARY X-NETSCAPE AUTH=PLAIN AUTH=LOGIN SASL-IR X-QUOTA=STORAGE X-QUOTA=MESSAGE X-QUOTA=X-ANNOTATION-STORAGE X-QUOTA=X-NUM-FOLDERS IDLE
  12:40.26 < NOPB0 OK Completed
[LIST "" *] BAD: EOF
Traceback (most recent call last):
  File "/usr/sbin/kolab", line 39, in <module>
    kolab = Cli()
  File "/usr/lib/python2.7/site-packages/pykolab/cli/__init__.py", line 73, in __init__
    commands.execute('_'.join(to_execute))
  File "/usr/lib/python2.7/site-packages/pykolab/cli/commands.py", line 138, in execute
    commands[cmd_name]['function'](conf.cli_args, kw)
  File "/usr/lib/python2.7/site-packages/pykolab/cli/cmd_list_mailboxes.py", line 88, in execute
    folders.extend(imap.lm(imap_utf7.encode(search)))
  File "/usr/lib/python2.7/site-packages/pykolab/imap/__init__.py", line 1140, in lm
    return self.imap.lm(*args, **kw)
  File "/usr/lib/python2.7/site-packages/cyruslib.py", line 512, in lm
    res, ml = self.__docommand('list', '""', self.decode(pattern))
  File "/usr/lib/python2.7/site-packages/cyruslib.py", line 389, in __docommand
    self.__doexception(function, error, *args)
  File "/usr/lib/python2.7/site-packages/cyruslib.py", line 358, in __doexception
    self.__doraise( function.upper(), msg )
  File "/usr/lib/python2.7/site-packages/cyruslib.py", line 367, in __doraise
    raise CYRUSError( idError[0], mode, msg )
cyruslib.CYRUSError: (99, 'LIST', 'EOF')
vanmeeuwen added a comment.Jul 13 2016, 11:53 AM

This is not occurred for me since the original report. If it still happens, can you reopen the ticket?

vanmeeuwen closed this task as Resolved.Jul 13 2016, 11:54 AM
vanmeeuwen claimed this task.