[horde] Problem with Horde_ActiveSync 2.8.3

[Michael J Rubinsky]

Quoting lst_hoe02 at kwsoft.de:

> Hello,
>
> after updating from 2.8.2 -> 2.8.3 teh follwoing errors pop up in the log:
>
> iPhone iOS7
>
> /tmp/APPLDNYGYUDPDTC0.txt:2013-10-10T07:15:58+02:00 ERR: [25263]  
> Unable to initialize state for @Contacts at . Ignoring during  
> pollForChanges: [25263] Empty synckey for @Contacts at ..
> /tmp/APPLDNYGYUDPDTC0.txt:2013-10-10T07:15:58+02:00 ERR: [25263]  
> Unable to initialize state for @Notes at . Ignoring during  
> pollForChanges: [25263] Empty synckey for @Notes at ..
> /tmp/APPLDNYGYUDPDTC0.txt:2013-10-10T07:15:58+02:00 ERR: [25263]  
> Unable to initialize state for @Tasks at . Ignoring during  
> pollForChanges: [25263] Empty synckey for @Tasks at ..
> /tmp/APPLDNYGYUDPDTC0.txt:2013-10-10T07:16:01+02:00 ERR: [29685]  
> Attempting to add a collection
> /tmp/APPLDNYGYUDPDTC0.txt:2013-10-10T07:16:01+02:00 ERR: [29685]  
> Attempting to add a collection
> /tmp/APPLDNYGYUDPDTC0.txt:2013-10-10T07:16:01+02:00 ERR: [29685]  
> Attempting to add a collection
> /tmp/APPLDNYGYUDPDTC0.txt:2013-10-10T07:16:01+02:00 ERR: [29685]  
> Attempting to add a collection
> /tmp/APPLDNYGYUDPDTC0.txt:2013-10-10T07:16:01+02:00 ERR: [29685]  
> Attempting to add a collection

There should be more to that error statement and another INFO  
statement right after that.

Does anything actually break though? The ERR should actually be more  
of a WARN or even INFO as this is only an ERR is certain situations.


> Some Android Galaxy 3
>
> /tmp/SEC19833384CD514.txt:2013-10-10T13:56:39+02:00 ERR: Permission Denied
> /tmp/SEC19833384CD514.txt:2013-10-10T14:10:43+02:00 ERR: Permission Denied
> /tmp/SEC19833384CD514.txt:2013-10-10T14:59:35+02:00 ERR: Permission Denied
>
>
> For this second one we also have the following in syslog
>
> Oct 10 14:59:35 h2118808 HORDE: [kronolith] Share name  not found  
> [pid 9479 on line 199 of "/usr/share/php/Horde/Share/Base.php"]
> Oct 10 14:59:35 h2118808 HORDE: [horde] Returning HTTP 500 while  
> handling Sync command. [pid 9479 on line 156 of  
> "/var/www/horde/rpc.php"]
> Oct 10 14:59:35 h2118808 HORDE: [horde] Error in communicating with  
> ActiveSync server: Permission Denied [pid 9479 on line 160 of  
> "/usr/share/php/Horde/Rpc/ActiveSync.php"]
> Oct 10 14:59:35 h2118808 HORDE: [horde] #0 [internal function]:  
> Kronolith_Api->listEvents(1380099084, 1380200375, NULL, false,  
> false, false, true, false)
> #1 /usr/share/php/Horde/Registry.php(1116):  
> call_user_func_array(Array, Array)
> #2 /usr/share/php/Horde/Registry.php(1073):  
> Horde_Registry->callByPackage('kronolith', 'listEvents', Array)
> #3 /usr/share/php/Horde/Registry/Caller.php(41):  
> Horde_Registry->call('calendar/listEv...', Array)
> #4 /usr/share/php/Horde/Core/ActiveSync/Connector.php(801):  
> Horde_Registry_Caller->__call('listEvents', Array)
> #5 /usr/share/php/Horde/Core/ActiveSync/Connector.php(801):  
> Horde_Registry_Caller->listEvents(1380099084, 1380200375, NULL,  
> false, false, false, true, false)
> #6 /usr/share/php/Horde/Core/ActiveSync/Driver.php(596):  
> Horde_Core_ActiveSync_Connector->softDelete('calendar', 1380099084,  
> 1380200375)
> #7 /usr/share/php/Horde/ActiveSync/State/Sql.php(920):  
> Horde_Core_ActiveSync_Driver->getServerChanges(Object(Horde_ActiveSync_Folder_Collection), 5636, 5661, 1380200375, true,  
> true)
> #8 /usr/share/php/Horde/ActiveSync/Collections.php(1143):  
> Horde_ActiveSync_State_Sql->getChanges(Array)
> #9 /usr/share/php/Horde/ActiveSync/Collections.php(1159):  
> Horde_ActiveSync_Collections->getCollectionChanges(true)
> #10 /usr/share/php/Horde/ActiveSync/Collections.php(1019):  
> Horde_ActiveSync_Collections->getCollectionChangeCount(true)
> #11 /usr/share/php/Horde/ActiveSync/Request/Sync.php(289):  
> Horde_ActiveSync_Collections->pollForChanges('1370', 25)
> #12 /usr/share/php/Horde/ActiveSync/Request/Base.php(249):  
> Horde_ActiveSync_Request_Sync->_handle()
> #13 /usr/share/php/Horde/ActiveSync.php(848):  
> Horde_ActiveSync_Request_Base->handle()
> #14 /usr/share/php/Horde/Rpc/ActiveSync.php(141):  
> Horde_ActiveSync->handleRequest('Sync', 'SEC19833384CD51...')
> #15 /var/www/horde/rpc.php(156): Horde_Rpc_ActiveSync->getResponse(NULL)
> #16 {main} [pid 9479 on line 160 of  
> "/usr/share/php/Horde/Rpc/ActiveSync.php"]
> Oct 10 14:59:35 h2118808 HORDE: [horde] Buffer contents:  [pid 9479  
> on line 160 of "/usr/share/php/Horde/Rpc/ActiveSync.php"]

The code path looks normal, no idea why you are getting Permission  
denied error though, unless for some reason your user no longer has  
permissions to the same calendars that were setup to sync with  
originally, or the calendars disappeared. Try resetting the sync prefs  
for kronolith and see if that helps.

-- 
mike

The Horde Project (www.horde.org)
mrubinsk at horde.org
-------------- next part --------------
A non-text attachment was scrubbed...
Name: smime.p7s
Type: application/pkcs7-signature
Size: 5849 bytes
Desc: S/MIME Signature
URL: <http://lists.horde.org/archives/horde/attachments/20131010/44349e83/attachment.bin>