Nach Update auf 3.3.4 holt OTRS keine Mails mehr ab

[DerMatze]

hallo,

Ich habe heute auf OTRS 3.3.4 geupdatet und nun funktioniert bei mir auch kein Email-Empfang mehr.

OTRS holt diese Emails nicht ab, wenn ich über OTRS die mails manuell abhole, klappt es wunderbar...

in der syslog findet sich immer wieder der eintrag

Code: Select all

Jan 29 18:51:01 gabelmalsch /USR/SBIN/CRON[14296]: (otrs) CMD (otrs $HOME/bin/otrs.PostMasterMailbox.pl)
Jan 29 18:51:01 gabelmalsch postfix/pickup[3995]: 974061700D82: uid=120 from=<otrs>
Jan 29 18:51:01 gabelmalsch postfix/cleanup[10223]: 974061700D82: message-id=<20140129175101.974061700D82@mail.gabelmalsch.de>
Jan 29 18:51:01 gabelmalsch postfix/qmgr[28836]: 974061700D82: from=<otrs@mail.gabelmalsch.de>, size=576, nrcpt=1 (queue active)
Jan 29 18:51:01 gabelmalsch postfix/smtp[10227]: 974061700D82: to=<otrs@mail.gabelmalsch.de>, orig_to=<otrs>, relay=none, delay=0.13, delays=0.12/0/0.02/0, dsn=5.4.6, status=bounced (mail for mail.gabelmalsch.de loops back to myself)
Jan 29 18:51:01 gabelmalsch postfix/cleanup[10223]: AE5E71700DE6: message-id=<20140129175101.AE5E71700DE6@mail.gabelmalsch.de>
Jan 29 18:51:01 gabelmalsch postfix/bounce[10228]: 974061700D82: sender non-delivery notification: AE5E71700DE6
Jan 29 18:51:01 gabelmalsch postfix/qmgr[28836]: AE5E71700DE6: from=<>, size=2487, nrcpt=1 (queue active)
Jan 29 18:51:01 gabelmalsch postfix/qmgr[28836]: 974061700D82: removed
Jan 29 18:51:01 gabelmalsch postfix/smtp[10227]: AE5E71700DE6: to=<otrs@mail.gabelmalsch.de>, relay=none, delay=0.09, delays=0.07/0/0.02/0, dsn=5.4.6, status=bounced (mail for mail.gabelmalsch.de loops back to myself)
Jan 29 18:51:01 gabelmalsch postfix/qmgr[28836]: AE5E71700DE6: removed
Jan 29 18:52:01 gabelmalsch /USR/SBIN/CRON[14300]: (otrs) CMD (otrs $HOME/bin/otrs.PostMasterMailbox.pl)
Jan 29 18:52:01 gabelmalsch postfix/pickup[3995]: A1E8D1700D82: uid=120 from=<otrs>
Jan 29 18:52:01 gabelmalsch postfix/cleanup[10223]: A1E8D1700D82: message-id=<20140129175201.A1E8D1700D82@mail.gabelmalsch.de>
Jan 29 18:52:01 gabelmalsch postfix/qmgr[28836]: A1E8D1700D82: from=<otrs@mail.gabelmalsch.de>, size=576, nrcpt=1 (queue active)
Jan 29 18:52:01 gabelmalsch postfix/smtp[10227]: A1E8D1700D82: to=<otrs@mail.gabelmalsch.de>, orig_to=<otrs>, relay=none, delay=0.07, delays=0.05/0/0.01/0, dsn=5.4.6, status=bounced (mail for mail.gabelmalsch.de loops back to myself)
Jan 29 18:52:01 gabelmalsch postfix/cleanup[10223]: B0BE91700DE6: message-id=<20140129175201.B0BE91700DE6@mail.gabelmalsch.de>
Jan 29 18:52:01 gabelmalsch postfix/bounce[10228]: A1E8D1700D82: sender non-delivery notification: B0BE91700DE6
Jan 29 18:52:01 gabelmalsch postfix/qmgr[28836]: B0BE91700DE6: from=<>, size=2487, nrcpt=1 (queue active)
Jan 29 18:52:01 gabelmalsch postfix/qmgr[28836]: A1E8D1700D82: removed
Jan 29 18:52:01 gabelmalsch postfix/smtp[10227]: B0BE91700DE6: to=<otrs@mail.gabelmalsch.de>, relay=none, delay=0.04, delays=0.03/0/0.02/0, dsn=5.4.6, status=bounced (mail for mail.gabelmalsch.de loops back to myself)
Jan 29 18:52:01 gabelmalsch postfix/qmgr[28836]: B0BE91700DE6: removed
Jan 29 18:53:01 gabelmalsch /USR/SBIN/CRON[14304]: (otrs) CMD (otrs $HOME/bin/otrs.PostMasterMailbox.pl)
Jan 29 18:53:01 gabelmalsch postfix/pickup[14307]: B06C71700D82: uid=120 from=<otrs>
Jan 29 18:53:01 gabelmalsch postfix/cleanup[10223]: B06C71700D82: message-id=<20140129175301.B06C71700D82@mail.gabelmalsch.de>
Jan 29 18:53:01 gabelmalsch postfix/qmgr[28836]: B06C71700D82: from=<otrs@mail.gabelmalsch.de>, size=576, nrcpt=1 (queue active)
Jan 29 18:53:01 gabelmalsch postfix/smtp[10227]: B06C71700D82: to=<otrs@mail.gabelmalsch.de>, orig_to=<otrs>, relay=none, delay=0.11, delays=0.1/0/0.02/0, dsn=5.4.6, status=bounced (mail for mail.gabelmalsch.de loops back to myself)
Jan 29 18:53:01 gabelmalsch postfix/cleanup[10223]: C79F21700DE6: message-id=<20140129175301.C79F21700DE6@mail.gabelmalsch.de>
Jan 29 18:53:01 gabelmalsch postfix/bounce[10228]: B06C71700D82: sender non-delivery notification: C79F21700DE6
Jan 29 18:53:01 gabelmalsch postfix/qmgr[28836]: C79F21700DE6: from=<>, size=2487, nrcpt=1 (queue active)
Jan 29 18:53:01 gabelmalsch postfix/qmgr[28836]: B06C71700D82: removed
Jan 29 18:53:01 gabelmalsch postfix/smtp[10227]: C79F21700DE6: to=<otrs@mail.gabelmalsch.de>, relay=none, delay=0.08, delays=0.06/0/0.02/0, dsn=5.4.6, status=bounced (mail for mail.gabelmalsch.de loops back to myself)
Jan 29 18:53:01 gabelmalsch postfix/qmgr[28836]: C79F21700DE6: removed

Ich bin gerade ratlos

[DerMatze]

ich habe jetzt mittlerweile "mail.gabelmalsch.de" in mydestination in der postifx main.cf eingefügt

nun erhalte ich folgende fehlermeldungen

Code: Select all

Jan 29 21:12:01 gabelmalsch postfix/pickup[8819]: 1A26E170115C: uid=120 from=<otrs>
Jan 29 21:12:01 gabelmalsch postfix/cleanup[8833]: 1A26E170115C: message-id=<20140129201201.1A26E170115C@mail.gabelmalsch.de>
Jan 29 21:12:01 gabelmalsch postfix/qmgr[8822]: 1A26E170115C: from=<otrs@mail.gabelmalsch.de>, size=576, nrcpt=1 (queue active)
Jan 29 21:12:01 gabelmalsch postfix/local[8840]: 1A26E170115C: to=<otrs@mail.gabelmalsch.de>, orig_to=<otrs>, relay=local, delay=0.08, delays=0.05/0/0/0.03, dsn=5.2.0, status=bounced (cannot update mailbox /var/mail/otrs for user otrs. cannot open file: Permission denied)
Jan 29 21:12:01 gabelmalsch postfix/cleanup[8833]: 26F98170115D: message-id=<20140129201201.26F98170115D@mail.gabelmalsch.de>
Jan 29 21:12:01 gabelmalsch postfix/bounce[8847]: 1A26E170115C: sender non-delivery notification: 26F98170115D
Jan 29 21:12:01 gabelmalsch postfix/qmgr[8822]: 26F98170115D: from=<>, size=2568, nrcpt=1 (queue active)
Jan 29 21:12:01 gabelmalsch postfix/qmgr[8822]: 1A26E170115C: removed
Jan 29 21:12:01 gabelmalsch postfix/local[8840]: 26F98170115D: to=<otrs@mail.gabelmalsch.de>, relay=local, delay=0.14, delays=0.08/0/0/0.06, dsn=5.2.0, status=bounced (cannot update mailbox /var/mail/otrs for user otrs. cannot open file: Permission denied)
Jan 29 21:12:01 gabelmalsch postfix/qmgr[8822]: 26F98170115D: removed

[DerMatze]

Ich habe nun OTRS manuell instaliert, nun funktioniert alles soweit wieder...

Nur bekomme ich jetzt immer die Fehlermeldung

Code: Select all

ERROR: Permission denied: /opt/otrs/Kernel/Config/Files/ZZZAAuto.pm
ERROR: Permission denied: /opt/otrs/Kernel/Config/Files/ZZZAuto.pm

irgendwas stellt immer die berechtigung der beiden dateien auf www-data:www-data

[wurzel]

Hi,

das otrs.RebuildConfig als User otrs, das setPermissions als root. (wie im #otrs ircChannel beschrieben)
Und korrekte Parameter verwenden.

Oder manuell die beiden Dateien auf otrs:www-data setzen

Flo

[DerMatze]

Hallo flo,

ich bin jetzt erst von der arbeit...

Muss ich bestimmte parameter bei otrs.RebuildConfig anwenden, außer das ich es als user otrs ausführen muss?

[steste123]

Nein - einfach nur ausführen

[DerMatze]

Irgendwas setzt trotzdem die 2 Dateien immer wieder auf www-data:www-data

Sie sind schon wieder auf

Code: Select all

drwxrwx--- 2 otrs     www-data 4.0K Jan 30 21:36 .
drwxrwx--- 3 otrs     www-data 4.0K Jan 29 22:02 ..
-rw-rw---- 1 otrs     www-data 296K Jan 17 06:41 Framework.xml
-rw-rw---- 1 otrs     www-data  21K Jan 17 06:41 GenericInterface.xml
-rw-rw---- 1 otrs     www-data  17K Jan 17 06:41 ProcessManagement.xml
-rw-rw---- 1 otrs     www-data 4.1K Jan 17 06:41 Scheduler.xml
-rw-rw---- 1 otrs     www-data 7.5K Jan 29 22:18 Support.xml
-rw-rw---- 1 otrs     www-data 508K Jan 17 06:41 Ticket.xml
-rw-rw---- 1 www-data www-data 175K Jan 30 21:36 ZZZAAuto.pm
-rw-rw---- 1 www-data www-data 3.6K Jan 30 21:36 ZZZAuto.pm

eingestellt :/

[jojo]

läuft ggf. irgendwo ein zusätzlicher Cronjob? Die ZZZAuto.pm wird nur bei Nutzung der Sysconfig geändert.

[DerMatze]

Ich wüsste nicht wo

www-data hat keine cronjobs...

[schulmann]

Irgendwas setzt trotzdem die 2 Dateien immer wieder auf www-data:www-data

Gibt es irgendwelche Syslog-Einträge zu der Zeit die mit "ls -lcd --full-time ..." angezeigt wird?
Bei einem cron-Job ist die Sekunde typischerweise einstellig.

[DerMatze]

Ich verstehe gerade nicht, was du meinst...

[schulmann]

Ich verstehe gerade nicht, was du meinst...

Um 21:54 Uhr hattest Du geschrieben: Irgendwas setzt trotzdem die 2 Dateien immer wieder auf www-data:www-data.

Mit "ls -lcd --full-time ..." kann man den letzten Status-Change der fraglichen Dateien sekundengenau sehen.
Nun schaut man sich alle Syslog-Dateien an ob um diese Sekunde irgendwelche verdächtigen Einträge vorhanden sind.
Damit sollten z. B. cron-Jobs, die man evtl. übersehen hat, zutage treten weil sie in den Syslog-Dateien protokolliert werden.

[DerMatze]

Die Datei wurde 23:03:46 geändert

In der Zeit ist folgendes passiert

Code: Select all

Jan 30 23:03:45 gabelmalsch OTRS-otrs.Scheduler-10[24391]: [Notice][main::_AutoRestart] Config.pm changed, unsafe to continue! #012Scheduler is restarting...!
Jan 30 23:03:45 gabelmalsch OTRS-otrs.Scheduler-10[24397]: [Notice][/opt/otrs/bin/otrs.Scheduler.pl] Scheduler Daemon start! PID 24397
Jan 30 23:03:47 gabelmalsch OTRS-otrs.Scheduler-10[24397]: [Notice][main::_AutoRestart] Config.pm changed, unsafe to continue! #012Scheduler is restarting...!
Jan 30 23:03:47 gabelmalsch OTRS-otrs.Scheduler-10[24401]: [Notice][/opt/otrs/bin/otrs.Scheduler.pl] Scheduler Daemon start! PID 24401

[DerMatze]

Hats du ne Idee, woran es liegen könnte

[jojo]

irgendwas ändert Deine Dateien, prüf alle Cronjobs auf dem Server.

[DerMatze]

Es laufen aber alle Crons über den User "otrs", habe sogar den "otrs.Scheduler" über den user "otrs" laufen lassen, aber das hat auch keine lösung gebracht (weil ich ja über die homepage den scheduler gestartet hatte)

Derzeit kommen aber auch keine Cron-Fehlermeldungen dafür...

Ich beobachte weiter