Horde app: Anmeldung nicht möglich

mail
german

#1

Hallo,
ich habe meinen Server neu installiert (inkl. horde app) und nun ist bei Horde keine Anmeldung möglich.
Hier die Zeile aus dem horde-log:
ERR: HORDE [horde] FAILED LOGIN for user [xxx.xxx.xxx.xxx] to Horde [pid 16717 on line 199 of “/usr/share/horde/login.php”]
(das pw stimmt jedoch …)
Kann mir jemand Hinweise zur Fehlersuche geben?

Danke und Gruß
Rainer Rau


#2

Hallo,

funktioniert denn eine Anmeldung über IMAP?

Ansonsten können Sie die UCR-Variable “horde/log/priority” z.B. auf “DEBUG” stellen, um mehr im horde.log zu sehen Standardwert ist “ERR”.

Viele Grüße,
Dirk Ahrnke


#3

zunächst: Danke für die Unterstützung

Anmeldung über IMAP schlägt ebenfalls fehl (Test mit Thunderbird).

Nach setzen der Logausgabe auf debug erhalte ich folgende einträge im Log:

2013-09-15T11:49:06+00:00 DEBUG: HORDE Load config file (conf.php; app: horde) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:06+00:00 DEBUG: HORDE Setting sam inactive because the fileroot does not exist or the application is not configured yet. [pid 20269 on line 698 of "/usr/share/php/Horde/Registry.php"] 2013-09-15T11:49:06+00:00 DEBUG: HORDE Setting ansel inactive because the fileroot does not exist or the application is not configured yet. [pid 20269 on line 698 of "/usr/share/php/Horde/Registry.php"] 2013-09-15T11:49:06+00:00 DEBUG: HORDE Setting wicked inactive because the fileroot does not exist or the application is not configured yet. [pid 20269 on line 698 of "/usr/share/php/Horde/Registry.php"] 2013-09-15T11:49:06+00:00 DEBUG: HORDE Setting chora inactive because the fileroot does not exist or the application is not configured yet. [pid 20269 on line 698 of "/usr/share/php/Horde/Registry.php"] 2013-09-15T11:49:06+00:00 DEBUG: HORDE Setting whups inactive because the fileroot does not exist or the application is not configured yet. [pid 20269 on line 698 of "/usr/share/php/Horde/Registry.php"] 2013-09-15T11:49:06+00:00 DEBUG: HORDE Setting luxor inactive because the fileroot does not exist or the application is not configured yet. [pid 20269 on line 698 of "/usr/share/php/Horde/Registry.php"] 2013-09-15T11:49:06+00:00 DEBUG: HORDE Setting klutz inactive because the fileroot does not exist or the application is not configured yet. [pid 20269 on line 698 of "/usr/share/php/Horde/Registry.php"] 2013-09-15T11:49:06+00:00 DEBUG: HORDE Setting jonah inactive because the fileroot does not exist or the application is not configured yet. [pid 20269 on line 698 of "/usr/share/php/Horde/Registry.php"] 2013-09-15T11:49:06+00:00 DEBUG: HORDE Setting hermes inactive because the fileroot does not exist or the application is not configured yet. [pid 20269 on line 698 of "/usr/share/php/Horde/Registry.php"] 2013-09-15T11:49:06+00:00 DEBUG: HORDE Setting sesha inactive because the fileroot does not exist or the application is not configured yet. [pid 20269 on line 698 of "/usr/share/php/Horde/Registry.php"] 2013-09-15T11:49:06+00:00 DEBUG: HORDE Setting kolab inactive because the fileroot does not exist or the application is not configured yet. [pid 20269 on line 698 of "/usr/share/php/Horde/Registry.php"] 2013-09-15T11:49:06+00:00 DEBUG: HORDE Setting passwd inactive because the fileroot does not exist or the application is not configured yet. [pid 20269 on line 698 of "/usr/share/php/Horde/Registry.php"] 2013-09-15T11:49:06+00:00 DEBUG: HORDE Setting agora inactive because the fileroot does not exist or the application is not configured yet. [pid 20269 on line 698 of "/usr/share/php/Horde/Registry.php"] 2013-09-15T11:49:06+00:00 DEBUG: HORDE Setting ulaform inactive because the fileroot does not exist or the application is not configured yet. [pid 20269 on line 698 of "/usr/share/php/Horde/Registry.php"] 2013-09-15T11:49:06+00:00 DEBUG: HORDE Setting vilma inactive because the fileroot does not exist or the application is not configured yet. [pid 20269 on line 698 of "/usr/share/php/Horde/Registry.php"] 2013-09-15T11:49:06+00:00 DEBUG: HORDE Load config file (nls.php; app: horde) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:06+00:00 DEBUG: HORDE Load config file (hooks.php; app: imp) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:06+00:00 DEBUG: HORDE Hook preauthenticate in application imp called. [pid 20269 on line 1137 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:07+00:00 DEBUG: HORDE [imp] Load config file (conf.php; app: imp) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:07+00:00 DEBUG: HORDE [imp] Load config file (prefs.php; app: horde) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:07+00:00 DEBUG: HORDE [imp] Load config file (prefs.php; app: imp) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:07+00:00 DEBUG: HORDE [imp] Hook prefs_init in application imp called. [pid 20269 on line 1137 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:07+00:00 DEBUG: HORDE [imp] Hook prefs_init in application imp called. [pid 20269 on line 1137 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:07+00:00 DEBUG: HORDE [imp] Hook prefs_init in application imp called. [pid 20269 on line 1137 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:07+00:00 DEBUG: HORDE [imp] Load config file (backends.php; app: imp) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:08+00:00 DEBUG: HORDE Hook preauthenticate in application imp called. [pid 20269 on line 1137 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:08+00:00 DEBUG: HORDE Load config file (hooks.php; app: ingo) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:08+00:00 DEBUG: HORDE [gollem] Load config file (conf.php; app: gollem) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:08+00:00 DEBUG: HORDE [gollem] Load config file (prefs.php; app: gollem) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:08+00:00 DEBUG: HORDE [gollem] Load config file (backends.php; app: gollem) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:08+00:00 DEBUG: HORDE [horde] Max memory usage: 6815744 bytes [pid 20269 on line 559 of "/usr/share/php/Horde/Registry.php"] 2013-09-15T11:49:08+00:00 DEBUG: HORDE Load config file (conf.php; app: horde) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:08+00:00 DEBUG: HORDE Horde_Registry: retrieved app with cache ID horde_registry|app|1379189153|d6b1684acbf6496d8cb99733f3524d84 [pid 20269 on line 1987 of "/usr/share/php/Horde/Registry.php"] 2013-09-15T11:49:08+00:00 DEBUG: HORDE Load config file (hooks.php; app: imp) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:08+00:00 DEBUG: HORDE Hook preauthenticate in application imp called. [pid 20269 on line 1137 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:09+00:00 DEBUG: HORDE [imp] Load config file (conf.php; app: imp) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:09+00:00 DEBUG: HORDE [imp] Load config file (backends.php; app: imp) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:09+00:00 DEBUG: HORDE Hook preauthenticate in application imp called. [pid 20269 on line 1137 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:09+00:00 DEBUG: HORDE Load config file (hooks.php; app: ingo) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:09+00:00 DEBUG: HORDE [gollem] Load config file (conf.php; app: gollem) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:09+00:00 DEBUG: HORDE [horde] Hook preauthenticate in application imp called. [pid 20269 on line 1137 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:10+00:00 DEBUG: HORDE [horde] Load config file (nls.php; app: horde) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:10+00:00 DEBUG: HORDE [horde] Hook preauthenticate in application imp called. [pid 20269 on line 1137 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:10+00:00 DEBUG: HORDE [horde] Hook preauthenticate in application imp called. [pid 20269 on line 1137 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:11+00:00 DEBUG: HORDE [horde] SQL (0,0685s) SELECT alarm_id, alarm_uid, alarm_start, alarm_end, alarm_methods, alarm_params, alarm_title, alarm_text, alarm_snooze, alarm_internal FROM horde_alarms WHERE alarm_dismissed = 0 AND ((alarm_snooze IS NULL AND alarm_start <= '2013-09-15T11:49:10') OR alarm_snooze <= '2013-09-15T11:49:10') AND (alarm_end IS NULL OR alarm_end >= '2013-09-15T11:49:10') AND (alarm_uid IS NULL OR alarm_uid = '' OR alarm_uid = '') ORDER BY alarm_start, alarm_end [pid 20269 on line 558 of "/usr/share/php/Horde/Db/Adapter/Base.php"] 2013-09-15T11:49:11+00:00 DEBUG: HORDE [horde] Load config file (motd.php; app: horde) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:11+00:00 DEBUG: HORDE [horde] Max memory usage: 7340032 bytes [pid 20269 on line 559 of "/usr/share/php/Horde/Registry.php"] 2013-09-15T11:49:17+00:00 DEBUG: HORDE Load config file (conf.php; app: horde) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:17+00:00 DEBUG: HORDE Horde_Registry: retrieved app with cache ID horde_registry|app|1379189153|d6b1684acbf6496d8cb99733f3524d84 [pid 20269 on line 1987 of "/usr/share/php/Horde/Registry.php"] 2013-09-15T11:49:17+00:00 DEBUG: HORDE Load config file (hooks.php; app: imp) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:17+00:00 DEBUG: HORDE Hook preauthenticate in application imp called. [pid 20269 on line 1137 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:18+00:00 DEBUG: HORDE [imp] Load config file (conf.php; app: imp) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:18+00:00 DEBUG: HORDE [imp] Load config file (backends.php; app: imp) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:18+00:00 DEBUG: HORDE Hook preauthenticate in application imp called. [pid 20269 on line 1137 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:19+00:00 DEBUG: HORDE Load config file (hooks.php; app: ingo) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:19+00:00 DEBUG: HORDE [gollem] Load config file (conf.php; app: gollem) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:19+00:00 DEBUG: HORDE [horde] Hook preauthenticate in application imp called. [pid 20269 on line 1137 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:19+00:00 DEBUG: HORDE [horde] Hook preauthenticate in application imp called. [pid 20269 on line 1137 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:30+00:00 ERR: HORDE [horde] FAILED LOGIN for rainer [192.168.178.20] to Horde [pid 20269 on line 199 of "/usr/share/horde/login.php"] 2013-09-15T11:49:30+00:00 DEBUG: HORDE [horde] Load config file (nls.php; app: horde) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:30+00:00 DEBUG: HORDE [horde] Die Anmeldung ist fehlgeschlagen, weil Sie Ihren Benutzernamen oder Ihr Passwort falsch eingegeben haben. [pid 20269 on line 27 of "/usr/share/php/Horde/Core/Notification/Handler/Decorator/Hordelog.php"] 2013-09-15T11:49:31+00:00 DEBUG: HORDE [horde] SQL (0,0394s) SELECT alarm_id, alarm_uid, alarm_start, alarm_end, alarm_methods, alarm_params, alarm_title, alarm_text, alarm_snooze, alarm_internal FROM horde_alarms WHERE alarm_dismissed = 0 AND ((alarm_snooze IS NULL AND alarm_start <= '2013-09-15T11:49:31') OR alarm_snooze <= '2013-09-15T11:49:31') AND (alarm_end IS NULL OR alarm_end >= '2013-09-15T11:49:31') AND (alarm_uid IS NULL OR alarm_uid = '' OR alarm_uid = '') ORDER BY alarm_start, alarm_end [pid 20269 on line 558 of "/usr/share/php/Horde/Db/Adapter/Base.php"] 2013-09-15T11:49:31+00:00 DEBUG: HORDE [horde] Load config file (motd.php; app: horde) [pid 20269 on line 401 of "/usr/share/php/Horde.php"] 2013-09-15T11:49:31+00:00 DEBUG: HORDE [horde] Max memory usage: 9437184 bytes [pid 20269 on line 559 of "/usr/share/php/Horde/Registry.php"]

Ich habe den Verdacht, das Horde nicht richtig konfiguriert ist ergeben Sie hieraus Hinweise in diese Richtung?

Gruß Rainer Rau


#4

Hallo,
das sieht schon so aus als wäre Horde nicht konfiguriert, aber ohne funktionierendes IMAP-Backend wird das auch so nicht gehen.

Sie schrieben, dass Sie den Server neu installiert haben. Haben Sie dabei Daten aus Ihrer vorherigen Installation übernommen oder ist das eine komplett frische Installation?

Viele Grüße,
Dirk Ahrnke


#5

Hallo Herr Ahrnke,
ich habe komplett neu von der DVD (UCS_3.1-1-i386.iso) installiert und dann Horde WebMail und Fetchmail über das App-center installiert.
Gruß Rainer Rau


#6

Hallo,

sind die Installationsskripte und insbesondere die Joinskripte fehlerfrei durchgelaufen? Sie könnten mal prophylaktisch ein “univention-run-join-scripts” starten.
Ansonsten wären noch die Logs der Installation interessant (/var/log/univention/management-console-module-appcenter.log).

Ein grundsätzliches Problem scheint es nicht zu geben. Ich habe gerade mal eine Testinstallation (Single-Server/Master) auf 32Bit durchlaufen lassen und konnte mich mit einem neuen Nutzer sofort an Horde anmelden. Ansonsten tendiere ich eher zu 64Bit, deshalb hab ich das noch mal getestet.

Viele Grüße,
Dirk Ahrnke


#7

Hallo,

das join-script hat keine Änderung erzielt. Hier die Ausgabe:

[code]login as: root

root@home:~# univention-run-join-scripts
univention-run-join-scripts: runs all join scripts existing on local computer.
copyright © 2001-2013 Univention GmbH, Germany

Running 01univention-ldap-server-init.inst skipped (already executed)
Running 02univention-directory-notifier.inst skipped (already executed)
Running 03univention-directory-listener.inst skipped (already executed)
Running 04univention-ldap-client.inst skipped (already executed)
Running 05univention-bind.inst skipped (already executed)
Running 08univention-apache.inst skipped (already executed)
Running 10univention-ldap-server.inst skipped (already executed)
Running 11univention-heimdal-init.inst skipped (already executed)
Running 11univention-pam.inst skipped (already executed)
Running 15univention-directory-notifier-post.inst skipped (already executed)
Running 15univention-heimdal-kdc.inst skipped (already executed)
Running 20univention-directory-policy.inst skipped (already executed)
Running 20univention-join.inst skipped (already executed)
Running 26univention-nagios-common.inst skipped (already executed)
Running 30univention-nagios-client.inst skipped (already executed)
Running 34univention-management-console-server.inst skipped (already executed)
Running 34univention-management-console-web-server.inst skipped (already executed)
Running 35univention-management-console-module-appcenter.inskipped (already executed)
Running 35univention-management-console-module-ipchange.insskipped (already executed)
Running 35univention-management-console-module-join.inst skipped (already executed)
Running 35univention-management-console-module-lib.inst skipped (already executed)
Running 35univention-management-console-module-mrtg.inst skipped (already executed)
Running 35univention-management-console-module-quota.inst skipped (already executed)
Running 35univention-management-console-module-reboot.inst skipped (already executed)
Running 35univention-management-console-module-services.insskipped (already executed)
Running 35univention-management-console-module-setup.inst skipped (already executed)
Running 35univention-management-console-module-sysinfo.instskipped (already executed)
Running 35univention-management-console-module-top.inst skipped (already executed)
Running 35univention-management-console-module-ucr.inst skipped (already executed)
Running 35univention-management-console-module-udm.inst skipped (already executed)
Running 35univention-management-console-module-updater.instskipped (already executed)
Running 36univention-management-console-module-apps.inst skipped (already executed)
Running 40univention-postgresql.inst skipped (already executed)
Running 40univention-virtual-machine-manager-schema.inst skipped (already executed)
Running 67univention-mail-server.inst skipped (already executed)
Running 78univention-kde.inst skipped (already executed)
Running 81univention-mail-cyrus.inst skipped (already executed)
Running 81univention-nfs-server.inst skipped (already executed)
Running 85univention-mail-horde.inst skipped (already executed)
Running 90univention-bind-post.inst skipped (already executed)
Running 92univention-fetchmail-schema.inst skipped (already executed)
Running 92univention-fetchmail.inst skipped (already executed)
Running 96univention-samba4.inst skipped (already executed)
Running 97univention-s4-connector.inst skipped (already executed)
Running 98univention-pkgdb-tools.inst skipped (already executed)
Running 98univention-samba4-dns.inst skipped (already executed)[/code]

Als Anlage ist noch das Log hochgeladen (/var/log/univention/management-console-module-appcenter.log).

Event. noch relevant:
-System läuft als virt. Maschine in virtual box
-Ich habe diesmal nur “deutsch” sprache installiert.

Danke weiterhin für die Unterstützung.
Grüße Rainer Rau
management-console-module-appcenter.zip (62.8 KB)


#8

Hallo,

wie es der Zufall will ist meine Testinstallation auch unter Virtualbox und hat ebenfalls de_DE.UTF-8 als locale. Das sollte somit kein Problem sein.

Falls Sie auf dem System keine weiteren Dienste am Start haben, könnten Sie ja mal mit einem beherzten “ucr commit” alle Konfigurationsdateien neu generieren lassen.

Viele Grüße,
Dirk Ahrnke


#9

Die Sitution ist auch nach “ucr commit” unverändert…


#10

Hallo,

Es wäre sicher sinnvoll, zunächst zu sehen, was mit dem IMAP-Backend ist.

  1. Läuft er überhaupt?

# netstat -ntpl | grep cyr tcp 0 0 0.0.0.0:110 0.0.0.0:* LISTEN 1339/cyrmaster tcp 0 0 0.0.0.0:143 0.0.0.0:* LISTEN 1339/cyrmaster tcp 0 0 127.0.0.1:2003 0.0.0.0:* LISTEN 1339/cyrmaster tcp 0 0 0.0.0.0:4190 0.0.0.0:* LISTEN 1339/cyrmaster tcp 0 0 0.0.0.0:993 0.0.0.0:* LISTEN 1339/cyrmaster tcp 0 0 0.0.0.0:995 0.0.0.0:* LISTEN 1339/cyrmaster tcp6 0 0 :::110 :::* LISTEN 1339/cyrmaster tcp6 0 0 :::143 :::* LISTEN 1339/cyrmaster tcp6 0 0 ::1:2003 :::* LISTEN 1339/cyrmaster tcp6 0 0 :::4190 :::* LISTEN 1339/cyrmaster tcp6 0 0 :::993 :::* LISTEN 1339/cyrmaster tcp6 0 0 :::995 :::* LISTEN 1339/cyrmaster

  1. Gibt es Mailboxen?

# cyradm localhost Password: (root passwort) localhost> lm user/(uid)/Ham@domain.de (\HasNoChildren) user/(uid)/Spam@domain.de (\HasNoChildren) user/(uid)@domain.de (\HasChildren) ...
3. Funktioniert die Anmeldung über IMAP?

[code]root@master386:~# telnet localhost imap
Trying ::1…
Connected to localhost.
Escape character is ‘^]’.

  • OK [CAPABILITY IMAP4rev1 LITERAL+ ID ENABLE STARTTLS AUTH=PLAIN SASL-IR] master386 Cyrus IMAP v2.4.9-Debian-2.4.9-1.26.201308091535 server ready
    .a1 login uid passwort # bitte reale Daten für uid und passwort nehmen
    .a1 OK [CAPABILITY IMAP4rev1 LITERAL+ ID ENABLE ACL RIGHTS=kxte QUOTA MAILBOX-REFERRALS NAMESPACE UIDPLUS NO_ATOMIC_RENAME UNSELECT CHILDREN MULTIAPPEND BINARY CATENATE CONDSTORE ESEARCH SORT SORT=MODSEQ THREAD=ORDEREDSUBJECT THREAD=REFERENCES ANNOTATEMORE LIST-EXTENDED WITHIN QRESYNC SCAN XLIST URLAUTH URLAUTH=BINARY LOGINDISABLED COMPRESS=DEFLATE IDLE] User logged in SESSIONID=
    .a2 logout
  • BYE LOGOUT received
    .a2 OK Completed
    Connection closed by foreign host.
    [/code]
    Bei Fehlern immer mit “ls -lrt /var/log/” nach den zuletzt geänderten Protokollen suchen und nachsehen.

Viele Grüße,
Dirk Ahrnke


#11

“lm” wars!
Offensichtlich gibt es keine Mailboxen. Werden diese nicht automatisch für die Benutzer angelegt?
Unter Management Console -> user -> Kontakt (Geschäftich, E-Mail-Adresse) steht eine Mailadresse …

Wie gehe ich hier am besten vor?

Danke und Gruß Rainer Rau


#12

Meiner Meinung nach muss für das Konto mit aktivierter Mail-Option (Objektklasse “univentionMail”) im Register “Allgemein” eine primäre Mailadresse und im Register “Mail” unter “Erweiterte Einstellungen” ein “Mail Home Server” gewählt sein.
Jedenfalls würde ich das Listener-Skript für den Cyrus so interpretieren.


#13

Ich habe die aktuellen Updates installiert und danach nach der primären Mailadresse geschaut. Das Feld war leer. Nach dem Eintragen der Mailadresse hat die Anmeldung funktioniert. Ich weiss das klingt jetzt nicht sehr überzeugend, aber das Feld war bei der letzten Prüfung nicht leer…
Wie dem auch sei: Nochmals herzlichen Dank für Ihre Unterstützung!!