[horde] AS not downloading emails

Fri Dec 27 03:24:37 UTC 2013

----- Message from Simon Wilson <simon at simonandkate.net> ---------
     Date: Fri, 27 Dec 2013 03:21:00 +0000
     From: Simon Wilson <simon at simonandkate.net>
Reply-To: simon at simonandkate.net
  Subject: Re: [horde] AS not downloading emails
       To: Michael J Rubinsky <mrubinsk at horde.org>
       Cc: horde at lists.horde.org

> ----- Message from Michael J Rubinsky <mrubinsk at horde.org> ---------
>     Date: Thu, 26 Dec 2013 22:12:55 -0500
>     From: Michael J Rubinsky <mrubinsk at horde.org>
> Reply-To: mrubinsk at horde.org
>  Subject: Re: [horde] AS not downloading emails
>       To: Simon Wilson <simon at simonandkate.net>
>       Cc: horde at lists.horde.org
>
>
>> Quoting Simon Wilson <simon at simonandkate.net>:
>>
>>> ----- Message from Michael J Rubinsky <mrubinsk at horde.org> ---------
>>>   Date: Thu, 26 Dec 2013 22:04:08 -0500
>>>   From: Michael J Rubinsky <mrubinsk at horde.org>
>>> Reply-To: mrubinsk at horde.org
>>> Subject: Re: [horde] AS not downloading emails
>>>     To: Simon Wilson <simon at simonandkate.net>, horde at lists.horde.org
>>>
>>>
>>>> Quoting Simon Wilson <simon at simonandkate.net>:
>>>>
>>>>>> Inbox now works as it should, but other folders don't. 
>>>>>>
>>>>>> I have attached log. 
>>>>>>
>>>>>> Simon.
>>>>>>
>>>>>> If I try and look in other folders, it either never updates, resets
>>>>>> the connection and does a full mail resync, or comes up saying ""Could
>>>>>> not open connection to server"
>>>>>>
>>>>>> --
>>>>>> Simon Wilson
>>>>>> M: 0400 12 11 16
>>>>>
>>>>>
>>>>> ----- End message from Simon Wilson <simon at simonandkate.net> -----
>>>>>
>>>>> This one is probably more useful, sorry....
>>>>>
>>>>> This has an Inbox sync, which is successful, followed by me trying
>>>>> to update my Horde mailing list folder, which does not work.
>>>>
>>>> Anything in the server or horde error log? The server finds 80
>>>> messages to transfer from the mailing list folder, but then dies after
>>>> starting to stream the first one.
>>>> --
>>>> mike
>>>>
>>> Good thinking 99...
>>>
>>> 192.168.1.155 - simon at simonandkate.net [27/Dec/2013:13:08:15 +1000]
>>> "POST
>>> /Microsoft-Server-ActiveSync?Cmd=Sync&User=simon%40simonandkate.net&DeviceId=androidc1491890991&DeviceType=SonySGP321  
>>> HTTP/1.1"
>>> 500
>>> 5025
>>>
>>> 2013-12-27T02:34:58+00:00 ERR: HORDE [horde] Returning HTTP 500
>>> while handling ItemOperations command. [pid 14155 on line 156 of
>>> "/var/www/horde/rpc.php"]
>>> 2013-12-27T02:34:58+00:00 ERR: HORDE [horde] Error in communicating
>>> with ActiveSync server: Not Found [pid 14155 on line 162 of
>>> "/usr/share/pear/Horde/Rpc/ActiveSync.php"]
>>> 2013-12-27T02:34:58+00:00 ERR: HORDE [horde] #0
>>> /usr/share/pear/Horde/ActiveSync/Driver/Base.php(254):
>>> Horde_Core_ActiveSync_Driver->getMessage('INBOX', '58056', Array)
>>> #1 /usr/share/pear/Horde/ActiveSync/Request/ItemOperations.php(243):
>>> Horde_ActiveSync_Driver_Base->fetch('INBOX', '58056', Array)
>>> #2 /usr/share/pear/Horde/ActiveSync/Request/Base.php(249):
>>> Horde_ActiveSync_Request_ItemOperations->_handle()
>>> #3 /usr/share/pear/Horde/ActiveSync.php(898):
>>> Horde_ActiveSync_Request_Base->handle()
>>> #4 /usr/share/pear/Horde/Rpc/ActiveSync.php(143):
>>> Horde_ActiveSync->handleRequest('ItemOperations',
>>> 'androidc1491890...')
>>> #5 /var/www/horde/rpc.php(156): Horde_Rpc_ActiveSync->getResponse(NULL)
>>> #6 {main} [pid 14155 on line 162 of
>>> "/usr/share/pear/Horde/Rpc/ActiveSync.php"]
>>> 2013-12-27T02:34:58+00:00 ERR: HORDE [horde] Buffer contents:
>>> jEM1NFM1RF52c16c15M58056PEmail [pid 14155 on line 162
>>> of "/usr/share/pear/Horde/Rpc/ActiveSync.php"]
>>
>> This is most likely from the earlier issue with the ITEMOPERATIONS request.
>> --
>> mike
>>
>
> The 500 errors are occurring now, every time the device tries to sync email.
>
> 192.168.1.155 - simon at simonandkate.net [27/Dec/2013:13:15:40 +1000]
> "POST
> /Microsoft-Server-ActiveSync?Cmd=Sync&User=simon%40simonandkate.net&DeviceId=androidc1491890991&DeviceType=SonySGP321 HTTP/1.1"  
> 500
> 5025
> 192.168.1.155 - simon at simonandkate.net [27/Dec/2013:13:15:41 +1000]
> "POST
> /Microsoft-Server-ActiveSync?Cmd=Sync&User=simon%40simonandkate.net&DeviceId=androidc1491890991&DeviceType=SonySGP321 HTTP/1.1"  
> 500
> 5025
> 192.168.1.155 - simon at simonandkate.net [27/Dec/2013:13:15:43 +1000]
> "POST
> /Microsoft-Server-ActiveSync?Cmd=Sync&User=simon%40simonandkate.net&DeviceId=androidc1491890991&DeviceType=SonySGP321 HTTP/1.1"  
> 500
> 5025
> 192.168.1.155 - simon at simonandkate.net [27/Dec/2013:13:15:45 +1000]
> "POST
> /Microsoft-Server-ActiveSync?Cmd=Sync&User=simon%40simonandkate.net&DeviceId=androidc1491890991&DeviceType=SonySGP321 HTTP/1.1"  
> 500
> 5025
> 192.168.1.155 - simon at simonandkate.net [27/Dec/2013:13:15:47 +1000]
> "POST
> /Microsoft-Server-ActiveSync?Cmd=Sync&User=simon%40simonandkate.net&DeviceId=androidc1491890991&DeviceType=SonySGP321 HTTP/1.1"  
> 500
> 5025
> 192.168.1.155 - simon at simonandkate.net [27/Dec/2013:13:15:48 +1000]
> "POST
> /Microsoft-Server-ActiveSync?Cmd=Sync&User=simon%40simonandkate.net&DeviceId=androidc1491890991&DeviceType=SonySGP321 HTTP/1.1"  
> 500
> 5025
> 192.168.1.155 - simon at simonandkate.net [27/Dec/2013:13:15:50 +1000]
> "POST
> /Microsoft-Server-ActiveSync?Cmd=Sync&User=simon%40simonandkate.net&DeviceId=androidc1491890991&DeviceType=SonySGP321 HTTP/1.1"  
> 500
> 5025
> 192.168.1.155 - simon at simonandkate.net [27/Dec/2013:13:15:52 +1000]
> "POST
> /Microsoft-Server-ActiveSync?Cmd=Sync&User=simon%40simonandkate.net&DeviceId=androidc1491890991&DeviceType=SonySGP321 HTTP/1.1"  
> 500
> 5025
> 192.168.1.155 - simon at simonandkate.net [27/Dec/2013:13:15:53 +1000]
> "POST
> /Microsoft-Server-ActiveSync?Cmd=Sync&User=simon%40simonandkate.net&DeviceId=androidc1491890991&DeviceType=SonySGP321 HTTP/1.1"  
> 500
> 5025
> 192.168.1.155 - simon at simonandkate.net [27/Dec/2013:13:15:55 +1000]
> "POST
> /Microsoft-Server-ActiveSync?Cmd=Sync&User=simon%40simonandkate.net&DeviceId=androidc1491890991&DeviceType=SonySGP321 HTTP/1.1"  
> 500
> 5025
> 192.168.1.155 - simon at simonandkate.net [27/Dec/2013:13:15:56 +1000]
> "POST
> /Microsoft-Server-ActiveSync?Cmd=Sync&User=simon%40simonandkate.net&DeviceId=androidc1491890991&DeviceType=SonySGP321 HTTP/1.1"  
> 500
> 5025
> 192.168.1.155 - simon at simonandkate.net [27/Dec/2013:13:15:58 +1000]
> "POST
> /Microsoft-Server-ActiveSync?Cmd=Sync&User=simon%40simonandkate.net&DeviceId=androidc1491890991&DeviceType=SonySGP321 HTTP/1.1"  
> 500
> 5025
>
> With Horde logging at info I get no data on these 500 errors.
>
> I just did a full AS reset, removed in Horde, removed account on the tablet.
>
> Calendar and Contacts sync fine, email now does not sync at all, it
> just sits and continually retries.
>
> My S4 continues to work fine, syncing all folders.
>
> Simon.
>
> --
> Simon Wilson
> M: 0400 12 11 16

----- End message from Simon Wilson <simon at simonandkate.net> -----

I missed these in the HTTPD error log:

[Fri Dec 27 13:23:06 2013] [error] [client 192.168.1.155] PHP Fatal  
error:  Call to a member function toString() on a non-object in  
/usr/share/pear/Horde/Mime/Part.php on line 1248
[Fri Dec 27 13:23:08 2013] [error] [client 192.168.1.155] PHP Fatal  
error:  Call to a member function toString() on a non-object in  
/usr/share/pear/Horde/Mime/Part.php on line 1248
[Fri Dec 27 13:23:09 2013] [error] [client 192.168.1.155] PHP Fatal  
error:  Call to a member function toString() on a non-object in  
/usr/share/pear/Horde/Mime/Part.php on line 1248

Simon.

--
Simon Wilson
M: 0400 12 11 16
-------------- next part --------------
A non-text attachment was scrubbed...
Name: not available
Type: application/pgp-keys
Size: 1339 bytes
Desc: PGP Public Key
URL: <http://lists.horde.org/archives/horde/attachments/20131227/f2825a7a/attachment-0002.bin>
-------------- next part --------------
A non-text attachment was scrubbed...
Name: not available
Type: application/pgp-signature
Size: 198 bytes
Desc: PGP Digital Signature
URL: <http://lists.horde.org/archives/horde/attachments/20131227/f2825a7a/attachment-0003.bin>