[horde] Horde not logging, no ActiveSync

Sun May 7 06:42:39 UTC 2017

----- Nachricht von Michael J Rubinsky <mrubinsk at horde.org> ---------
      Datum: Sun, 07 May 2017 01:09:33 +0000
        Von: Michael J Rubinsky <mrubinsk at horde.org>
Antwort an: mrubinsk at horde.org
    Betreff: Re: [horde] Horde not logging, no ActiveSync
         An: horde at lists.horde.org

> Quoting Andreas Mauser <andreas at mauser.info>:
>
>> ----- Nachricht von Andreas Mauser <andreas at mauser.info> ---------
>>  Datum: Sat, 06 May 2017 10:31:56 +0200
>>    Von: Andreas Mauser <andreas at mauser.info>
>> Betreff: Re: [horde] Horde not logging, no ActiveSync
>>     An: horde at lists.horde.org
>>
>>
>>> ----- Nachricht von Michael J Rubinsky <mrubinsk at horde.org> ---------
>>>    Datum: Fri, 05 May 2017 18:27:09 +0000
>>>      Von: Michael J Rubinsky <mrubinsk at horde.org>
>>> Antwort an: mrubinsk at horde.org
>>>  Betreff: Re: [horde] Horde not logging, no ActiveSync
>>>       An: horde at lists.horde.org
>>>
>>>
>>>> Quoting Andreas Mauser <andreas at mauser.info>:
>>>>
>>>>> ----- Nachricht von Michael J Rubinsky <mrubinsk at horde.org> ---------
>>>>>  Datum: Fri, 05 May 2017 18:11:38 +0000
>>>>>    Von: Michael J Rubinsky <mrubinsk at horde.org>
>>>>> Antwort an: mrubinsk at horde.org
>>>>> Betreff: Re: [horde] Horde not logging, no ActiveSync
>>>>>     An: horde at lists.horde.org
>>>>>
>>>>>
>>>>>> Quoting Andreas Mauser <andreas at mauser.info>:
>>>>>>
>>>>>>> ----- Nachricht von Michael J Rubinsky <mrubinsk at horde.org> ---------
>>>>>>> Datum: Fri, 05 May 2017 17:04:59 +0000
>>>>>>>  Von: Michael J Rubinsky <mrubinsk at horde.org>
>>>>>>> Antwort an: mrubinsk at horde.org
>>>>>>> Betreff: Re: [horde] Horde not logging, no ActiveSync
>>>>>>>   An: horde at lists.horde.org
>>>>>>>
>>>>>>>
>>>>>>>> Quoting Andreas Mauser <andreas at mauser.info>:
>>>>>>>>
>>>>>>>>> ----- Nachricht von Michael J Rubinsky <mrubinsk at horde.org> ---------
>>>>>>>>> Datum: Fri, 05 May 2017 14:35:15 +0000
>>>>>>>>> Von: Michael J Rubinsky <mrubinsk at horde.org>
>>>>>>>>> Antwort an: mrubinsk at horde.org
>>>>>>>>> Betreff: Re: [horde] Horde not logging, no ActiveSync
>>>>>>>>> An: horde at lists.horde.org
>>>>>>>>>
>>>>>>>>>
>>>>>>>>>> Quoting Andreas Mauser <andreas at mauser.info>:
>>>>>>>>>>
>>>>>>>>>>> ----- Nachricht von Andreas Mauser <andreas at mauser.info> ---------
>>>>>>>>>>> Datum: Thu, 04 May 2017 16:46:30 +0200
>>>>>>>>>>> Von: Andreas Mauser <andreas at mauser.info>
>>>>>>>>>>> Betreff: [horde] Horde not logging, no ActiveSync
>>>>>>>>>>> An: "Mailingliste, Horde" <horde at lists.horde.org>
>>>>>>>>>>>
>>>>>>>>>>>
>>>>>>>>>>>> Hi,
>>>>>>>>>>>>
>>>>>>>>>>>> my Horde does not log anything anymore (to horde.log)
>>>>>>>>>>>
>>>>>>>>>>> Sry, Horde log does log, but activesync stopped working.
>>>>>>>>>>> Any idea?
>>>>>>>>>>> Many thanks,
>>>>>>>>>>> Andreas
>>>>>>>>>>>
>>>>>>>>>>>
>>>>>>>>>>>> ActiveSync seems not to be working at all.
>>>>>>>>>>>> I am not able to generate an Activesync log, which I set  
>>>>>>>>>>>> to logging per device.
>>>>>>>>>>>> Devices I remove via Horde Activesync page, the clients  
>>>>>>>>>>>> say they do sync (Nine), but the web panel doesnt show  
>>>>>>>>>>>> them up again.
>>>>>>>>>>>>
>>>>>>>>>>>> In log/httpd/access.log I find:
>>>>>>>>>>>> [04/May/2017:16:32:13 +0200] "POST  
>>>>>>>>>>>> /Microsoft-Server-ActiveSync?jQkJBCBRaW5lQkE1OTJFREM0MDFCBNo3IVUHQW                                                                                                                                     5kcm9pZAcBAA== HTTP/1.1" 302 - "-"  
>>>>>>>>>>>> "Nine-pmeuhl_00401/NRD90M"
>>>>>>>>>>
>>>>>>>>>> The 302 response doesn't look right to me. Did you change  
>>>>>>>>>> any webserver configuration recently?
>>>>>>>>>
>>>>>>>>> not afaik. Horde is reachable, works fine. Way through my  
>>>>>>>>> firewall is with no security for test reason and I dont have  
>>>>>>>>> and mod_security at the moment.
>>>>>>>>> I did a complete resync with Nine, but still get the 302.
>>>>>>>>
>>>>>>>> Did the resync work? If so, that might be fine - maybe you configured
>>>>>>>
>>>>>>> No I still get the error 302
>>>>>>>
>>>>>>>> the Microsoft-Server-Active sync endpoint as a Redirect  
>>>>>>>> instead of an Alias?
>>>>>>>
>>>>>>> I have this in my conf file:
>>>>>>>   Alias /Microsoft-Server-ActiveSync "/var/www/html/mail/rpc.php"
>>>>>>>   Alias /autodiscover/autodiscover.xml "/var/www/html/mail/rpc.php"
>>>>>>>   Alias /AutoDiscover/AutoDiscover.xml "/var/www/html/mail/rpc.php"
>>>>>>>   Alias /Autodiscover/Autodiscover.xml "/var/www/html/mail/rpc.php"
>>>>>>>   RewriteEngine On
>>>>>>>   RewriteRule ^/Microsoft-Server-ActiveSync  
>>>>>>> /var/www/html/mail/rpc.php [PT,L,QSA]
>>>>>>>   RewriteRule .* -  
>>>>>>> [E=HTTP_MS_ASPROTOCOLVERSION:%{HTTP:Ms-Asprotocolversion}]
>>>>>>>   RewriteRule .* - [E=HTTP_X_MS_POLICYKEY:%{HTTP:X-Ms-Policykey}]
>>>>>>>   RewriteRule .* - [E=HTTP_AUTHORIZATION:%{HTTP:Authorization}]
>>>>>>>   RewriteCond %{REQUEST_METHOD} ^(TRACE|TRACK)
>>>>>>>   RewriteRule .* - [F]
>>>>>>>
>>>>>>> And never changed it.
>>>>>>
>>>>>>
>>>>>> You'll need to figure out where the redirect is coming from.  
>>>>>> *Something* is causing it. Do you do any http -> https redirect?
>>>>>
>>>>> The only redirects I have is from letsencrypt, and it redirects  
>>>>> http to https. But I never changed this.
>>>>
>>>> Is the ActiveSync client configured to use the https url?
>>>>
>>>
>>> It was a typo in the config file and I found it.
>>> Now, instead of a 302 I get a 500.
>>>
>>> Activesynclogs are being generated again.
>>>
>>> [8092][2017-05-06T10:25:03+02:00] INFO: ----------PROVISION  
>>> request received for user andreas
>>> [8075][2017-05-06T10:25:04+02:00] INFO:  
>>> ----------Horde_Core_ActiveSync_Driver::authenticate() attempt for  
>>> andreas----------
>>> [8075][2017-05-06T10:25:04+02:00] INFO: ----------PROVISION  
>>> request received for user andreas
>>> [8072][2017-05-06T10:25:05+02:00] INFO:  
>>> ----------Horde_Core_ActiveSync_Driver::authenticate() attempt for  
>>> andreas----------
>>> [8072][2017-05-06T10:25:05+02:00] INFO: ----------FOLDERSYNC  
>>> request received for user andreas
>>>
>>> But it still does not sync. It wants, but it cant.
>>>
>>
>> and I found this in the horde log:
>> 2017-05-06T10:53:24+02:00 EMERG: HORDE Call to a member function  
>> save() on null [pid 9525 on line 936 of  
>> "/usr/share/pear/Horde/ActiveSync.php"]
>
> Do you have any activesync related hooks set in horde/config/hooks.php?

I had. And I disabled that on 1.5.2017. *sigh* It was the last } I  
also commented out, which was wrong.

Many thanks, it does sync now!

>
>>>>>>>>>>>> Logging and Activesync logging is enabled in Horde, the  
>>>>>>>>>>>> path (and file horde.log) does exist. Permissions granted.
>>>>>>>>>>>>
>>>>>>>>>>>> Any hint please to fix this?
>>>>>>>>>>>>
>>>>>>>>>>>> Many thanks,
>>>>>>>>>>>> Andreas
>>>>>>>>>>>>
>>>>>>>>>>>> -- 
>>>>>>>>>>>> Mail checked by UTM
>>>>>>>>>>>
>>>>>>>>>>>
>>>>>>>>>>> ----- Ende der Nachricht von Andreas Mauser  
>>>>>>>>>>> <andreas at mauser.info> -----
>>>>>>>>>>>
>>>>>>>>>>>
>>>>>>>>>>>
>>>>>>>>>>> -- 
>>>>>>>>>>> Mail checked by UTM
>>>>>>>>>
>>>>>>>>>
>>>>>>>>> ----- Ende der Nachricht von Michael J Rubinsky  
>>>>>>>>> <mrubinsk at horde.org> -----
>>>>>>>
>>>>>>>
>>>>>>> ----- Ende der Nachricht von Michael J Rubinsky  
>>>>>>> <mrubinsk at horde.org> -----
>>>>>
>>>>>
>>>>> ----- Ende der Nachricht von Michael J Rubinsky  
>>>>> <mrubinsk at horde.org> -----
>>>
>>>
>>> ----- Ende der Nachricht von Michael J Rubinsky <mrubinsk at horde.org> -----
>>
>>
>> ----- Ende der Nachricht von Andreas Mauser <andreas at mauser.info> -----

----- Ende der Nachricht von Michael J Rubinsky <mrubinsk at horde.org> -----

-------------- next part --------------
A non-text attachment was scrubbed...
Name: not available
Type: application/pgp-keys
Size: 3871 bytes
Desc: ?ffentlicher PGP-Schl?ssel
URL: <https://lists.horde.org/archives/horde/attachments/20170507/7ffd4f0e/attachment-0001.bin>