Cyrus-IMAP läuft nach Update von Debian Wheezy auf Jessie nicht mehr

[AndreasMeier]

Hallo zusammen,

ich bräuchte bitte eure Mithilfe, um heraus zu finden, warum mein Cyrus-IMAP nach dem Update von Debian Wheezy auf Jessie nicht mehr läuft.
Fehlermeldungen sind mir bei Update erstmal nicht aufgefallen.

Wenn ich den Cyrus neu starte, erhalte ich in den relevanten Logdateien folgende Einträge:
in der "Mail.log":

Jul 20 14:31:30 server cyrus/master[25741]: exiting on SIGTERM/SIGINT
Jul 20 14:31:30 server cyrus/master[26713]: process started
Jul 20 14:31:30 server cyrus/master[26715]: about to exec /usr/sbin/cyrus
Jul 20 14:31:30 server cyrus/ctl_cyrusdb[26715]: recovering cyrus databases
Jul 20 14:31:30 server cyrus/ctl_cyrusdb[26715]: skiplist: checkpointed /var/lib/cyrus/mailboxes.db (708 records, 88420 bytes) in 0 seconds
Jul 20 14:31:31 server cyrus/ctl_cyrusdb[26715]: skiplist: checkpointed /var/lib/cyrus/annotations.db (0 records, 144 bytes) in 1 second
Jul 20 14:31:31 server cyrus/ctl_cyrusdb[26715]: done recovering cyrus databases
Jul 20 14:31:31 server cyrus/master[26718]: about to exec /usr/sbin/cyrus
Jul 20 14:31:31 server cyrus/cyr_expire[26718]: skiplist: checkpointed /var/lib/cyrus/deliver.db (4562 records, 610824 bytes) in 0 seconds
Jul 20 14:31:31 server cyrus/cyr_expire[26718]: Expunged 0 out of 37624 messages from 708 mailboxes
Jul 20 14:31:31 server cyrus/cyr_expire[26718]: duplicate_prune: pruning back 3.00 days
Jul 20 14:31:31 server cyrus/cyr_expire[26718]: duplicate_prune: purged 0 out of 4562 entries
Jul 20 14:31:31 server cyrus/master[26721]: about to exec /usr/sbin/cyrus
Jul 20 14:31:32 server cyrus/tls_prune[26721]: skiplist: checkpointed /var/lib/cyrus/tls_sessions.db (0 records, 144 bytes) in 1 second
Jul 20 14:31:32 server cyrus/tls_prune[26721]: tls_prune: purged 0 out of 0 entries
Jul 20 14:31:32 server cyrus/master[26713]: WARNING: cannot find executable for service 'pop3' -- ignored
Jul 20 14:31:32 server cyrus/master[26713]: WARNING: cannot find executable for service 'nntp' -- ignored
Jul 20 14:31:32 server cyrus/master[26713]: WARNING: cannot find executable for service 'http' -- ignored
Jul 20 14:31:32 server cyrus/master[26713]: unable to setsocketopt(IP_TOS): Operation not supported
Jul 20 14:31:32 server cyrus/master[26713]: unable to create sieve listener socket: Address already in use
Jul 20 14:31:32 server cyrus/master[26713]: unable to setsocketopt(IP_TOS): Operation not supported
Jul 20 14:31:32 server cyrus/master[26713]: ready for work
Jul 20 14:31:32 server cyrus/master[26724]: about to exec /usr/sbin/cyrus
Jul 20 14:31:32 server cyrus/master[26725]: about to exec /usr/lib/cyrus/bin/notifyd
Jul 20 14:31:32 server cyrus/notify[26725]: executed
Jul 20 14:31:32 server cyrus/ctl_cyrusdb[26724]: checkpointing cyrus databases
Jul 20 14:31:32 server cyrus/ctl_cyrusdb[26724]: archiving database file: /var/lib/cyrus/mailboxes.db
Jul 20 14:31:32 server cyrus/ctl_cyrusdb[26724]: archiving database file: /var/lib/cyrus/annotations.db
Jul 20 14:31:32 server cyrus/ctl_cyrusdb[26724]: done checkpointing cyrus databases
Jul 20 14:31:32 server cyrus/master[26713]: process 26724 exited, status 0

...in der "Mail.err":

Jul 20 14:31:32 server cyrus/master[26713]: unable to create sieve listener socket: Address already in use

...in der "Mail.info":

Jul 20 14:31:32 server cyrus/tls_prune[26721]: tls_prune: purged 0 out of 0 entries
Jul 20 14:31:32 server cyrus/master[26713]: WARNING: cannot find executable for service 'pop3' -- ignored
Jul 20 14:31:32 server cyrus/master[26713]: WARNING: cannot find executable for service 'nntp' -- ignored
Jul 20 14:31:32 server cyrus/master[26713]: WARNING: cannot find executable for service 'http' -- ignored
Jul 20 14:31:32 server cyrus/master[26713]: unable to setsocketopt(IP_TOS): Operation not supported
Jul 20 14:31:32 server cyrus/master[26713]: unable to create sieve listener socket: Address already in use
Jul 20 14:31:32 server cyrus/master[26713]: unable to setsocketopt(IP_TOS): Operation not supported
Jul 20 14:31:32 server cyrus/master[26713]: ready for work
Jul 20 14:31:32 server cyrus/ctl_cyrusdb[26724]: checkpointing cyrus databases
Jul 20 14:31:32 server cyrus/ctl_cyrusdb[26724]: done checkpointing cyrus databases

...in der Syslog:

Jul 20 14:31:30 server cyrus/master[25741]: exiting on SIGTERM/SIGINT
Jul 20 14:31:30 server cyrus/master[26713]: process started
Jul 20 14:31:30 server cyrus/master[26715]: about to exec /usr/sbin/cyrus
Jul 20 14:31:30 server cyrus/ctl_cyrusdb[26715]: recovering cyrus databases
Jul 20 14:31:30 server cyrus/ctl_cyrusdb[26715]: skiplist: checkpointed /var/lib/cyrus/mailboxes.db (708 records, 88420 bytes) in 0 seconds
Jul 20 14:31:31 server cyrus/ctl_cyrusdb[26715]: skiplist: checkpointed /var/lib/cyrus/annotations.db (0 records, 144 bytes) in 1 second
Jul 20 14:31:31 server cyrus/ctl_cyrusdb[26715]: done recovering cyrus databases
Jul 20 14:31:31 server cyrus/master[26718]: about to exec /usr/sbin/cyrus
Jul 20 14:31:31 server cyrus/cyr_expire[26718]: skiplist: checkpointed /var/lib/cyrus/deliver.db (4562 records, 610824 bytes) in 0 seconds
Jul 20 14:31:31 server cyrus/cyr_expire[26718]: Expunged 0 out of 37624 messages from 708 mailboxes
Jul 20 14:31:31 server cyrus/cyr_expire[26718]: duplicate_prune: pruning back 3.00 days
Jul 20 14:31:31 server cyrus/cyr_expire[26718]: duplicate_prune: purged 0 out of 4562 entries
Jul 20 14:31:31 server cyrus/master[26721]: about to exec /usr/sbin/cyrus
Jul 20 14:31:32 server cyrus/tls_prune[26721]: skiplist: checkpointed /var/lib/cyrus/tls_sessions.db (0 records, 144 bytes) in 1 second
Jul 20 14:31:32 server cyrus/tls_prune[26721]: tls_prune: purged 0 out of 0 entries
Jul 20 14:31:32 server cyrus/master[26713]: WARNING: cannot find executable for service 'pop3' -- ignored
Jul 20 14:31:32 server cyrus/master[26713]: WARNING: cannot find executable for service 'nntp' -- ignored
Jul 20 14:31:32 server cyrus/master[26713]: WARNING: cannot find executable for service 'http' -- ignored
Jul 20 14:31:32 server cyrus/master[26713]: unable to setsocketopt(IP_TOS): Operation not supported
Jul 20 14:31:32 server cyrus/master[26713]: unable to create sieve listener socket: Address already in use
Jul 20 14:31:32 server cyrus/master[26713]: unable to setsocketopt(IP_TOS): Operation not supported
Jul 20 14:31:32 server cyrus/master[26713]: ready for work
Jul 20 14:31:32 server cyrus/master[26724]: about to exec /usr/sbin/cyrus
Jul 20 14:31:32 server cyrus/master[26725]: about to exec /usr/lib/cyrus/bin/notifyd
Jul 20 14:31:32 server cyrus/notify[26725]: executed
Jul 20 14:31:32 server cyrus/ctl_cyrusdb[26724]: checkpointing cyrus databases
Jul 20 14:31:32 server cyrus/ctl_cyrusdb[26724]: archiving database file: /var/lib/cyrus/mailboxes.db
Jul 20 14:31:32 server cyrus/ctl_cyrusdb[26724]: archiving database file: /var/lib/cyrus/annotations.db
Jul 20 14:31:32 server cyrus/ctl_cyrusdb[26724]: done checkpointing cyrus databases
Jul 20 14:31:32 server cyrus/master[26713]: process 26724 exited, status 0

Sieht m.E. eigentlich relativ normal, bis auf diese Fehlermeldung:

unable to create sieve listener socket: Address already in use

Ich kann dazu aber weder was Gescheites auf Google finden, was mir weiterhelfen würde, noch weiß ich, ob das überhaupt für das Fehlerbild relevant ist.

Eine andere Fehlermeldung "couldnt connect to lmtp socket" konnte ich beheben, indem ich die Datei manuell angelegt hatte.

Der Postfix scheint zu arbeiten (entsprechende Einträge in den Logfiles), aber ich kann mein Kmail Mailclient nicht überreden, auf die Cyrus-IMAP-Mailbox zuzugreifen...

Über Hinweise auf mögliche Fehler wäre ich sehr dankbar...

Danke und Gruß
Andreas

[corresponder]

Jul 20 14:31:32 server cyrus/master[26713]: unable to create sieve listener socket: Address already in use

sicher, das der cyrus nicht schon läuft und den socket blockiert?
oder was sagt:
netstat -an |grep LISTEN
ps faxuww |grep cyrus

gruss

c.

[AndreasMeier]

Nein, sicher bin ich nicht...

Darum...

root@server:/home/andreas# netstat -an |grep LISTEN
tcp        0      0 0.0.0.0:41804           0.0.0.0:*               LISTEN     
tcp        0      0 0.0.0.0:111             0.0.0.0:*               LISTEN     
tcp        0      0 0.0.0.0:10000           0.0.0.0:*               LISTEN     
tcp        0      0 0.0.0.0:465             0.0.0.0:*               LISTEN     
tcp        0      0 0.0.0.0:631             0.0.0.0:*               LISTEN     
tcp        0      0 0.0.0.0:25              0.0.0.0:*               LISTEN     
tcp        0      0 0.0.0.0:445             0.0.0.0:*               LISTEN     
tcp        0      0 0.0.0.0:4190            0.0.0.0:*               LISTEN     
tcp        0      0 0.0.0.0:22              0.0.0.0:*               LISTEN     
tcp        0      0 127.0.0.1:3306          0.0.0.0:*               LISTEN     
tcp        0      0 0.0.0.0:139             0.0.0.0:*               LISTEN     
tcp6       0      0 :::111                  :::*                    LISTEN     
tcp6       0      0 :::80                   :::*                    LISTEN     
tcp6       0      0 :::465                  :::*                    LISTEN     
tcp6       0      0 :::631                  :::*                    LISTEN     
tcp6       0      0 :::25                   :::*                    LISTEN     
tcp6       0      0 :::443                  :::*                    LISTEN     
tcp6       0      0 :::445                  :::*                    LISTEN     
tcp6       0      0 :::51741                :::*                    LISTEN     
tcp6       0      0 :::10022                :::*                    LISTEN     
tcp6       0      0 :::139                  :::*                    LISTEN

und...

root@server:/home/andreas# ps faxuww |grep cyrus
root      8858  0.0  0.2   4556  2064 pts/0    S+   16:51   0:00                      \_ grep cyrus

Also, sieht so aus, als wenn der bereits läuft.
Aber ich versteh noch nicht genau, warum der Cyrus dann den Socket blockiert?
Ich will ihn ja nicht zweimal zum laufen bringen.
Nach einem Neustart des Systems sollten doch alle Dienste passend gestartet werden (und nicht etwa doppelt) - und nen Neustart des kompletten Rechners als auch des Dienstes hab ich schon mal probiert.

Danke und Gruß
Andreas

[cane]

Eine sehr gute Gelegenheit die Kröte zu beerdigen und durch Dovecot zu ersetzen ;-) *flame*

mfg
cane

[corresponder]

nein, er läuft nicht,
das was du bei ps fauxww findest ist der grep nach cyrus....
was sagen sonstige logs, messages?
was sagt der dienst beim restart?

/etc/init.d/cyrus-imapd start

gruss

c.

[AndreasMeier]

Wenn ich den Status abfrage, erscheint das hier:

root@server:/etc/init.d# service cyrus-imapd status
● cyrus-imapd.service - Cyrus IMAP/POP3 daemons
   Loaded: loaded (/lib/systemd/system/cyrus-imapd.service; disabled)
   Active: active (running) since Di 2015-07-21 12:35:49 CEST; 58s ago
  Process: 12305 ExecStartPre=/usr/sbin/cyrus init-helper start (code=exited, status=0/SUCCESS)
 Main PID: 12319 (cyrmaster)
   CGroup: /system.slice/cyrus-imapd.service
           ├─12319 /usr/sbin/cyrmaster -l 32 -C /etc/imapd.conf -M /etc/cyrus.conf
           └─12332 notifyd

Jul 21 12:35:55 server.home.int cyrus/master[12319]: unable to create sieve listener socket: Address already in use
Jul 21 12:35:55 server.home.int cyrus/master[12319]: unable to setsocketopt(IP_TOS): Operation not supported
Jul 21 12:35:55 server.home.int cyrus/master[12319]: ready for work
Jul 21 12:35:55 server.home.int cyrus/master[12332]: about to exec /usr/lib/cyrus/bin/notifyd
Jul 21 12:35:55 server.home.int cyrus/master[12331]: about to exec /usr/sbin/cyrus
Jul 21 12:35:56 server.home.int cyrus/ctl_cyrusdb[12331]: checkpointing cyrus databases
Jul 21 12:35:56 server.home.int cyrus/ctl_cyrusdb[12331]: archiving database file: /var/lib/cyrus/mailboxes.db
Jul 21 12:35:56 server.home.int cyrus/ctl_cyrusdb[12331]: archiving database file: /var/lib/cyrus/annotations.db
Jul 21 12:35:56 server.home.int cyrus/master[12319]: process 12331 exited, status 0
Jul 21 12:35:56 server.home.int cyrus/notify[12332]: executed

[AndreasMeier]

Eine sehr gute Gelegenheit die Kröte zu beerdigen und durch Dovecot zu ersetzen ;-) *flame*

Ich hab die Imap-Server verglichen und den Vorschlag von Cane in die Tat umgesetzt.
Konnte das Ablagesystem von Cyrus nie richtig leiden, auch die Backup- bzw. Restore-Möglichkeiten haben genervt.

Danke an corresponder für die Hilfe!!