b1gMail 7.4.0 Beta 3

bcmAlex

B1G-Software-Kunde
Der code von Heute......


Code:
04/12/2017 22:35:19 [18676] [ INFO] [unknown] AuthenticationRequiredException: Access denied. Please send authorisation information - code: 0 - file: /var/www/vhosts/bigcitymail.de/zpush/index.php:90
04/12/2017 22:35:19 [18676] [ INFO] [unknown] User-agent: 'Mozilla/5.0 (Windows NT 10.0; rv:57.0) Gecko/20100101 Firefox/57.0'
04/12/2017 22:35:19 [18676] [FATAL] [unknown] Exception: (AuthenticationRequiredException) - Access denied. Please send authorisation information
04/12/2017 22:35:19 [18676] [ INFO] [unknown] cmd='' memory='2.30 MiB/2.75 MiB' time='0.02s' devType='' devId='' getUser='unknown' from='200373600494961061' version='2.3.0' method='GET' httpcode='401'
04/12/2017 22:35:45 [18677] [ INFO] [unknown] AuthenticationRequiredException: Access denied. Please send authorisation information - code: 0 - file: /var/www/vhosts/bigcitymail.de/zpush/index.php:90
04/12/2017 22:35:45 [18677] [ INFO] [unknown] User-agent: 'Mozilla/5.0 (Windows NT 10.0; rv:57.0) Gecko/20100101 Firefox/57.0'
04/12/2017 22:35:45 [18677] [FATAL] [unknown] Exception: (AuthenticationRequiredException) - Access denied. Please send authorisation information
04/12/2017 22:35:45 [18677] [ INFO] [unknown] cmd='' memory='1.72 MiB/2.00 MiB' time='0.02s' devType='' devId='' getUser='unknown' from='200373600494961061' version='2.3.0' method='GET' httpcode='401'
04/12/2017 23:03:44 [23187] [ INFO] [unknown] AuthenticationRequiredException: Access denied. Please send authorisation information - code: 0 - file: /var/www/vhosts/bigcitymail.de/zpush/index.php:90
04/12/2017 23:03:44 [23187] [ INFO] [unknown] User-agent: 'Mozilla/5.0 (Windows NT 10.0; rv:57.0) Gecko/20100101 Firefox/57.0'
04/12/2017 23:03:44 [23187] [FATAL] [unknown] Exception: (AuthenticationRequiredException) - Access denied. Please send authorisation information
04/12/2017 23:03:44 [23187] [ INFO] [unknown] cmd='' memory='2.13 MiB/2.50 MiB' time='0.02s' devType='' devId='' getUser='unknown' from='200373600494961061' version='2.3.0' method='GET' httpcode='401'
04/12/2017 23:04:10 [23197] [ INFO] [unknown] AuthenticationRequiredException: Access denied. Please send authorisation information - code: 0 - file: /var/www/vhosts/bigcitymail.de/zpush/index.php:90
04/12/2017 23:04:10 [23197] [ INFO] [unknown] User-agent: 'Mozilla/5.0 (Windows NT 10.0; rv:57.0) Gecko/20100101 Firefox/57.0'
04/12/2017 23:04:10 [23197] [FATAL] [unknown] Exception: (AuthenticationRequiredException) - Access denied. Please send authorisation information
04/12/2017 23:04:10 [23197] [ INFO] [unknown] cmd='' memory='1.72 MiB/2.00 MiB' time='0.01s' devType='' devId='' getUser='unknown' from='200373600494961061' version='2.3.0' method='GET' httpcode='401'
04/12/2017 23:09:40 [24150] [ INFO] [unknown] AuthenticationRequiredException: Access denied. Please send authorisation information - code: 0 - file: /var/www/vhosts/bigcitymail.de/zpush/index.php:90
04/12/2017 23:09:40 [24150] [ INFO] [unknown] User-agent: 'Mozilla/5.0 (Windows NT 10.0; rv:57.0) Gecko/20100101 Firefox/57.0'
04/12/2017 23:09:40 [24150] [FATAL] [unknown] Exception: (AuthenticationRequiredException) - Access denied. Please send authorisation information
04/12/2017 23:09:40 [24150] [ INFO] [unknown] cmd='' memory='1.72 MiB/2.00 MiB' time='0.01s' devType='' devId='' getUser='unknown' from='200373600494961061' version='2.3.0' method='GET' httpcode='401'
04/12/2017 23:09:55 [24151] [ INFO] [unknown] AuthenticationRequiredException: Access denied. Please send authorisation information - code: 0 - file: /var/www/vhosts/bigcitymail.de/zpush/index.php:90
04/12/2017 23:09:55 [24151] [ INFO] [unknown] User-agent: 'Mozilla/5.0 (Windows NT 10.0; rv:57.0) Gecko/20100101 Firefox/57.0'
04/12/2017 23:09:55 [24151] [FATAL] [unknown] Exception: (AuthenticationRequiredException) - Access denied. Please send authorisation information
04/12/2017 23:09:55 [24151] [ INFO] [unknown] cmd='' memory='1.72 MiB/2.00 MiB' time='0.01s' devType='' devId='' getUser='unknown' from='200373600494961061' version='2.3.0' method='GET' httpcode='401'
04/12/2017 23:10:09 [24995] [ INFO] [unknown] AuthenticationRequiredException: Access denied. Please send authorisation information - code: 0 - file: /var/www/vhosts/bigcitymail.de/zpush/index.php:90
04/12/2017 23:10:09 [24995] [ INFO] [unknown] User-agent: 'Mozilla/5.0 (Windows NT 10.0; rv:57.0) Gecko/20100101 Firefox/57.0'
04/12/2017 23:10:09 [24995] [FATAL] [unknown] Exception: (AuthenticationRequiredException) - Access denied. Please send authorisation information
04/12/2017 23:10:09 [24995] [ INFO] [unknown] cmd='' memory='1.72 MiB/2.00 MiB' time='0.01s' devType='' devId='' getUser='unknown' from='200373600494961061' version='2.3.0' method='GET' httpcode='401'
 

bcmAlex

B1G-Software-Kunde
Sry vergessen zu speichern :p

Ist der Log so besser ?

Code:
04/12/2017 23:32:23 [28774] [DEBUG] [unknown] -------- Start
04/12/2017 23:32:23 [28774] [DEBUG] [unknown] cmd='' devType='' devId='' getUser='unknown' from='200373600494961061' version='2.3.0' method='GET'
04/12/2017 23:32:23 [28774] [DEBUG] [unknown] Used timezone 'Europe/Berlin'
04/12/2017 23:32:23 [28774] [DEBUG] [unknown] ZPush::GetBackend(): autoload register ZPush::IncludeBackend
04/12/2017 23:32:23 [28774] [DEBUG] [unknown] Including backend file: '/var/www/vhosts/bigcitymail.de/zpush/backend/b1gmail/b1gmail.php'
04/12/2017 23:32:23 [28774] [DEBUG] [unknown] ZPush::GetBackend(): autoload unregister ZPush::IncludeBackend
04/12/2017 23:32:23 [28774] [DEBUG] [unknown] Request::ProcessHeaders() ASVersion: 14.0
04/12/2017 23:32:23 [28774] [ INFO] [unknown] AuthenticationRequiredException: Access denied. Please send authorisation information - code: 0 - file: /var/www/vhosts/bigcitymail.de/zpush/index.php:90
04/12/2017 23:32:23 [28774] [ INFO] [unknown] User-agent: 'Mozilla/5.0 (Windows NT 10.0; rv:57.0) Gecko/20100101 Firefox/57.0'
04/12/2017 23:32:23 [28774] [FATAL] [unknown] Exception: (AuthenticationRequiredException) - Access denied. Please send authorisation information
04/12/2017 23:32:23 [28774] [DEBUG] [unknown] ZPush::PrintZPushLegal()
04/12/2017 23:32:23 [28774] [DEBUG] [unknown] TopCollector(): Initialized mutexid Resource id #46 and memid Resource id #47.
04/12/2017 23:32:23 [28774] [DEBUG] [unknown] TopCollector initialised with IPC provider 'IpcSharedMemoryProvider' with type '20'
04/12/2017 23:32:23 [28774] [ INFO] [unknown] cmd='' memory='1.72 MiB/2.00 MiB' time='0.00s' devType='' devId='' getUser='unknown' from='200373600494961061' version='2.3.0' method='GET' httpcode='401'
04/12/2017 23:32:23 [28774] [DEBUG] [unknown] -------- End
 

bcmAlex

B1G-Software-Kunde
Hey,

habe durch Zufall einen Fehler gefunden.

Wenn eine signierte Mail reinkommt und man auf das Zertifikat klickt erscheint in der Zertifikatsinformation ein Fehler:

Code:
Warning: strlen() expects parameter 1 to be string, array given in /var/www/vhosts/bigcitymail.de/mailcenter/serverlib/common.inc.php on line 709
 

Attachments

oyoony

B1G-Software-Kunde
Hallo Patrick,

hier nochmal das Detailierte Loglfile

05/12/2017 16:37:11 [ 3630] [DEBUG] [unknown] -------- Start
05/12/2017 16:37:11 [ 3630] [DEBUG] [unknown] cmd='' devType='' devId='' getUser='unknown' from='78.48.218.217' version='2.3.8' method='GET'
05/12/2017 16:37:11 [ 3630] [ INFO] [unknown] AuthenticationRequiredException: Access denied. Please send authorisation information - code: 0 - file: /var/www/vhosts/domain.de/httpdocs/Microsoft-Server-ActiveSync/index.php:56
05/12/2017 16:37:11 [ 3630] [ INFO] [unknown] User-agent: 'unknown'
05/12/2017 16:37:11 [ 3630] [FATAL] [unknown] Exception: (AuthenticationRequiredException) - Access denied. Please send authorisation information
05/12/2017 16:37:11 [ 3630] [DEBUG] [unknown] ZPush::printZPushLegal()
05/12/2017 16:37:11 [ 3630] [DEBUG] [unknown] TopCollector(): Initialized mutexid Resource id #14 and memid Resource id #15.
05/12/2017 16:37:11 [ 3630] [DEBUG] [unknown] TopCollector initialised with IPC provider 'IpcSharedMemoryProvider' with type '20'
05/12/2017 16:37:11 [ 3630] [ INFO] [unknown] cmd='' memory='1.50 MiB/2.00 MiB' time='0.01s' devType='' devId='' getUser='unknown' from='78.48.218.217' idle='0s' version='2.3.8' method='GET' httpcode='401'
05/12/2017 16:37:11 [ 3630] [DEBUG] [unknown] -------- End
Hier die ERROR.LOG
05/12/2017 16:37:11 [ 3630] [FATAL] [unknown] Exception: (AuthenticationRequiredException) - Access denied. Please send authorisation information
Das Merkwürdeige ist, dass er nicht mal den UserAgent identifiziert.
Username und Passwort wurden eingegeben wie gwohnt, wenn man sich über den Browser einloggt...

Gruss OYOONY
 

patrick

Staff member
B1G-Software-Kunde
Sieht für mich fast so aus, als wenn der Authorization-Header nicht an PHP durchgereicht wird vom Webserver. Am unproblematischsten ist hier, wenn man PHP als Modul in Apache einbindet. Wenn man andere Webserver oder Einbindungsmethoden (FastCGI/FPM, ...) verwendet, ist ggf. eine entsprechende Konfigurationsänderung im Webserver nötig. Siehe auch hier bzw hier.

@bcmAlex: Danke für den Hinweis.
 

bcmAlex

B1G-Software-Kunde
Nicht dafür Patrick.

Bei versendeten Mails mit Zertifikat erscheint der Fehler nicht und alle Angaben sind korrekt.

Bezüglich zpush sehe ich mir nachher die Thematik genauer an. Im Moment versuche ich die S MIME Zertifikatsangelegenheit einzubinden :D
 

oyoony

B1G-Software-Kunde
Hallo Patrick,

also ich habe auf dem selbern Server mehrere Webanwendungen ausser B1GMail laufen. Da funktioniert das durchreichen des Auth einwandfrei und ohne Probleme.
Daher verstehe ich nicht, dass hier bei z-push das Auth nicht funzt...

Verwendet wird FPM für PHP 7.0 von Apache.
 

oyoony

B1G-Software-Kunde
Also ich denke ich habe den Fehler gefunden...
Soweit ich das verstanden habe, liegt das am FPM für nginx ...
Da ich den nginx als Proxy vor den Apache geschaltet habe....
Die Features dafür kommen erst ab der z-push Version 2.4, was natürlich etwas doof ist...

Heute Abend mal sehen wie ich das Problem lösen kann...?(


Gruß OYO
 

oyoony

B1G-Software-Kunde
Soo...
Also ich habs soweit geschafft, dass nun nginx den Authorization-Header an PHP durchreicht. Dies geschieht allerdings bisher nur bei PHP5. Mit PHP7 bin ich noch nicht soweit.

Jetzt erhalte ich folgende Log

Code:
07/12/2017 19:20:12 [26949] [DEBUG] [user@domain.de] -------- Start
07/12/2017 19:20:12 [26949] [DEBUG] [user@domain.de] cmd='Ping' devType='Android' devId='androidc339228027' getUser='user@domain.de' from='85.181.107.9' version='2.3.8' method='GET'
07/12/2017 19:20:12 [26949] [DEBUG] [user@domain.de] Used timezone 'Europe/Amsterdam'
07/12/2017 19:20:12 [26949] [DEBUG] [user@domain.de] Including backend file: '/var/www/vhosts/domain.de/httpdocs/Microsoft-Server-ActiveSync/backend/b1gmail/b1gmail.php'
07/12/2017 19:20:12 [26949] [WARN] [user@domain.de] /var/www/vhosts/domain.de/httpdocs/Microsoft-Server-ActiveSync/backend/b1gmail/b1gmail.php:62 mysql_connect(): Connection refused (2)
07/12/2017 19:20:12 [26949] [FATAL] [user@domain.de] FatalException: Failed to connect to b1gMail MySQL server - code: 0 - file: /var/www/vhosts/domain.de/httpdocs/Microsoft-Server-ActiveSync/backend/b1gmail/b1gmail.php:64
07/12/2017 19:20:12 [26949] [ INFO] [user@domain.de] User-agent: 'unknown'
07/12/2017 19:20:12 [26949] [FATAL] [user@domain.de] Exception: (FatalException) - Failed to connect to b1gMail MySQL server
07/12/2017 19:20:12 [26949] [DEBUG] [user@domain.de] ZPush::PrintZPushLegal()
07/12/2017 19:20:12 [26949] [DEBUG] [user@domain.de] TopCollector(): Initialized mutexid Resource id #41 and memid Resource id #42.
07/12/2017 19:20:12 [26949] [DEBUG] [user@domain.de] TopCollector initialised with IPC provider 'IpcSharedMemoryProvider' with type '20'
07/12/2017 19:20:12 [26949] [ INFO] [user@domain.de] cmd='Ping' memory='1.66 MiB/2.00 MiB' time='0.01s' devType='Android' devId='androidc339228027' getUser='user@domain.de' from='85.181.107.9' idle='0s' version='2.3.8' method='GET' httpcode='500'
07/12/2017 19:20:12 [26949] [DEBUG] [user@domain.de] -------- End
Nun stellt sich mir die Frage, warum er die Verbindung trotz richtiger Nuterdaten, herstellen kann..
*grüberl*


Gruß OYO
 
Last edited:

bcmAlex

B1G-Software-Kunde
Knnst du bitte mitteilen wie du so weit gekommen bist ? Würde mich echt interessieren weil ich hier kein Stück weiter komme.
 

oyoony

B1G-Software-Kunde
@bcmAlex

Also in meinem Fall musste der Authorization-Header über den NGINX weitergereicht werden. Demnach musste FastCGI/FPM mitgeteilt werden, welcher Webserver für die Weiterleitung des AuthHeader zuständig ist, da ich den NGINX als Proxy vor den Apache geschaltet habe. Dies muss man dann in der ServerConfig entsprechend anpassen.

Das funzt nun super...

Was nun noch Probleme macht ist das let´s encrypt Zertifikat....
Das will irgendwie nicht mit IOS 11 zusammenarbeiten.
Unter Android funzt let´s encrypt super...

IOS 11 lehnt aus Sicherheitsgründen let´s encrypt Zertifikate ab, da Apple die Root CA aus dem CA Stamm entfernt hat.
Ich denke das Problem dürfte dann auch ab Januar behoben sein, wenn let´s encrypt auch Subdomains unterstützt. Dann dürfte let´s encrypt zwei neue Sicherheitsinstanzen eingefügt haben. Die alten sollen wollen Mist gebaut haben.

Gruß OYO
 
Last edited:

oyoony

B1G-Software-Kunde
Hallo Pratick,

ich hab da wohl doch noch nen Problem am Strart:

Offensichtlich klappt der Login, aber z-push kann so wie es ausschaut keine Daten zurück liefern.

Logfile:

Code:
12/12/2017 08:16:03 [26950] [DEBUG] [user@domain.de] -------- Start
12/12/2017 08:16:03 [26950] [DEBUG] [user@domain.de] cmd='Ping' devType='Android' devId='androidc1744440925' getUser='user@domain.de' from='85.182.87.97' version='2.3.8' method='GET'
12/12/2017 08:16:03 [26950] [DEBUG] [user@domain.de] Used timezone 'Europe/Amsterdam'
12/12/2017 08:16:03 [26950] [DEBUG] [user@domain.de] Including backend file: '/var/www/vhosts/domain.de/httpdocs/Microsoft-Server-ActiveSync/backend/b1gmail/b1gmail.php'
12/12/2017 08:16:03 [26950] [DEBUG] [user@domain.de] Request::ProcessHeaders() ASVersion: 14.0
12/12/2017 08:16:03 [26950] [DEBUG] [user@domain.de] ZPush::CommandNeedsAuthentication(18): true
12/12/2017 08:16:03 [26950] [DEBUG] [user@domain.de] NoPostRequestException: This is the Z-Push location and can only be accessed by Microsoft ActiveSync-capable devices - code: 2 - file: /var/www/vhosts/domain.de/httpdocs/Microsoft-Server-ActiveSync/index.php:90
12/12/2017 08:16:03 [26950] [ INFO] [user@domain.de] User-agent: 'Android-Mail/7.11.5.177402951.release'
12/12/2017 08:16:03 [26950] [DEBUG] [user@domain.de] ZPush::PrintZPushLegal()
12/12/2017 08:16:03 [26950] [ INFO] [user@domain.de] cmd='Ping' memory='1.83 MiB/2.25 MiB' time='0.01s' devType='Android' devId='androidc1744440925' getUser='user@domain.de' from='85.182.87.97' idle='0s' version='2.3.8' method='GET' httpcode='200'
12/12/2017 08:16:03 [26950] [DEBUG] [user@domain.de] -------- End
Z-push error_log bleibt leer

und auf dem Tablet, erschein folgende Meldung:

Sie haben eine falsche Serveradresse eingegeben oder der Server erfordert eine Protokollversion, die zur Zeit nicht unterstützt wird
Serveradresse ist aber soweit ich sehen kann okay.


Gruß OYO
 
Last edited:
Top