[horde] Activesync

Sat Jan 28 11:48:08 UTC 2012

Hi,
Am 21.01.2012 18:41, schrieb Michael J Rubinsky:

> Quoting Hanns Mattes <hanns at hannsmattes.de>:
> [Device not syncing]
> 
> These are all expected for an initial device sync, though the double
> Resetting PING state message seems odd.  Read
> http://wiki.horde.org/ActiveSync for instructions on how to get a more
> informative log.

New Device (Samsung Galaxy Nexus), same game. Difference is, that I
can't finish the Account creation. Sync-log is showing:

,----[ /var/log/sync.log ]
| 2012-01-27T23:09:09+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon attempt for: hannsldap at hannsmattes.de
| 2012-01-27T23:09:09+01:00 DEBUG: [] OPTIONS request received for user hannsldap at hannsmattes.de
| 2012-01-27T23:09:09+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon attempt for: hannsldap at hannsmattes.de
| 2012-01-27T23:09:09+01:00 DEBUG: [androidc1405421619] FOLDERSYNC request received for user hannsldap at hannsmattes.de
| 2012-01-27T23:09:09+01:00 DEBUG: [androidc1405421619] loadDeviceInfo: 
| 2012-01-27T23:09:09+01:00 DEBUG: Resetting PING state
| 2012-01-27T23:09:09+01:00 DEBUG: Resetting PING state
| 2012-01-27T23:09:09+01:00 DEBUG: [androidc1405421619] Device entry does not exist for user hannsldap at hannsmattes.de, creating it.
`----

tshark is showing:
,----[tshark 'tcp port 80 and (((ip[2:2] - ((ip[0]&0xf)<<2)) - ((tcp[12]&0xf0)>>2)) != 0)' -w /test/capture]
| ¡     #Oˆ~ &ˆu‹òoE”@@9Å$V›P3rvQ?€6‘L
| .ž„nHTTP/1.1 200 OK
| Date: Fri, 27 Jan 2012 21:20:13 GMT
| Server: Apache/2.2.15 (Linux/SUSE)
| X-Powered-By: PHP/5.3.9
| Set-Cookie: Horde=rnpcdq91ts4sgdkef5mtkv6jmi75u3pk; path=/; domain=mail.bruecko.de; HttpOnly
| Expires: Thu, 19 Nov 1981 08:52:00 GMT
| Cache-Control: no-store, no-cache, must-revalidate, post-check=0, pre-check=0
| Pragma: no-cache
| Set-Cookie: Horde=oolnuqilal5dpag8moembgrd5i2ue8tb; path=/; domain=mail.bruecko.de; HttpOnly
| Set-Cookie: auth_key=oolnuqilal5dpag8moembgrd5i2ue8tb; path=/; domain=mail.bruecko.de
| Set-Cookie: default_horde_view=auto; expires=Sun, 26-Feb-2012 21:20:13 GMT; path=/; domain=mail.bruecko.de
| MS-Server-ActiveSync: 6.5.7638.1
| MS-ASProtocolVersions: 1.0,2.0,2.1,2.5
| MS-ASProtocolCommands: Sync,SendMail,SmartForward,SmartReply,GetAttachment,GetHierarchy,CreateCollection,DeleteCollection,MoveCollection,FolderSync,FolderCreate,FolderDelete,FolderUpdate,MoveItems,GetItemEstimate,MeetingResponse,ResolveRecipients,ValidateCert,Provision,Search,Ping
| Content-Length: 0
| Keep-Alive: timeout=15, max=100
| Connection: Keep-Alive
| Content-Type: application/vnd.ms-sync.wbxml
| 
| #O	WW ¾o&ˆu‹EI[@:sV›Å$P5z€.b
| „n.Ÿ
| POST /Microsoft-Server-ActiveSync?Cmd=FolderSync&User=hannsldap%40hannsmattes.de&DeviceId=androidc1405421619&DeviceType=Android HTTP/1.0
| Content-Type: application/vnd.ms-sync.wbxml
| Authorization: Basic aGFubnNsZGFwQGhhbm5zbWF0dGVzLmRlOmZhYmVyTA==
| MS-ASProtocolVersion: 2.5
| User-Agent: Android/4.0.2-EAS-1.3
| Accept-Encoding: gzip
| X-MS-PolicyKey: 0
| Content-Length: 13
| Host: mail.bruecko.de
| Via: 1.1 linux.hanns:3128 (squid/2.6.STABLE6)
| X-Forwarded-For: 192.168.0.192
| Cache-Control: max-age=259200
| Connection: keep-alive
| 
| #O OO ¾o&ˆu‹EA[@:zV›Å$P7z€. 
| „n.Ÿ
| jVR0#OE &ˆu‹òoER@@u$V›Pzè7€6U
| .Ÿ$„nHTTP/1.0 500 Internal Server Error
| Date: Fri, 27 Jan 2012 21:20:13 GMT
| Server: Apache/2.2.15 (Linux/SUSE)
| X-Powered-By: PHP/5.3.9
| Set-Cookie: Horde=k997di7t785njn2qfh69ea785nafq3gv; path=/; domain=mail.bruecko.de; HttpOnly
| Expires: Thu, 19 Nov 1981 08:52:00 GMT
| Cache-Control: no-store, no-cache, must-revalidate, post-check=0, pre-check=0
| Pragma: no-cache
| Set-Cookie: Horde=1gjvjnv18143511sa10iv8ou3br2f1si; path=/; domain=mail.bruecko.de; HttpOnly
| Set-Cookie: auth_key=1gjvjnv18143511sa10iv8ou3br2f1si; path=/; domain=mail.bruecko.de
| Set-Cookie: default_horde_view=auto; expires=Sun, 26-Feb-2012 21:20:13 GMT; path=/; domain=mail.bruecko.de
| MS-Server-ActiveSync: 6.5.7638.1
| Content-Length: 89
| Connection: close
| Content-Type: text/html
| 
| SQLSTATE[42S22]: Column not found: 1054 Unknown column 'device_policykey' in 'field list'#O2”vv ¾o&ˆu‹Eh#@:‡V›Å$	™PRXE+X€.0
| „{.OPTIONS /Microsoft-Server-ActiveSync HTTP/1.0
| Authorization: Basic aGFubnNsZGFwQGhhbm5zbWF0dGVzLmRlOmZhYmVyTA==
| User-Agent: Android/4.0.2-EAS-1.3
| Host: mail.bruecko.de
| Via: 1.1 linux.hanns:3128 (squid/2.6.STABLE6)
| X-Forwarded-For: 192.168.0.192
| Cache-Control: max-age=259200
| Connection: keep-alive
| 
| #On &ˆu‹òoE@@8$V›P	™+XRYy€6™
| .„{HTTP/1.1 200 OK
| Date: Fri, 27 Jan 2012 21:20:26 GMT
| Server: Apache/2.2.15 (Linux/SUSE)
| X-Powered-By: PHP/5.3.9
| Set-Cookie: Horde=uplgijs1gb7ne70792h7tq0i5vaup2j9; path=/; domain=mail.bruecko.de; HttpOnly
| Expires: Thu, 19 Nov 1981 08:52:00 GMT
| Cache-Control: no-store, no-cache, must-revalidate, post-check=0, pre-check=0
| Pragma: no-cache
| Set-Cookie: Horde=t1agvrsgo9i69o0pkmk812nc5ba9348b; path=/; domain=mail.bruecko.de; HttpOnly
| Set-Cookie: auth_key=t1agvrsgo9i69o0pkmk812nc5ba9348b; path=/; domain=mail.bruecko.de
| Set-Cookie: default_horde_view=auto; expires=Sun, 26-Feb-2012 21:20:26 GMT; path=/; domain=mail.bruecko.de
| MS-Server-ActiveSync: 6.5.7638.1
| MS-ASProtocolVersions: 1.0,2.0,2.1,2.5
| MS-ASProtocolCommands: Sync,SendMail,SmartForward,SmartReply,GetAttachment,GetHierarchy,CreateCollection,DeleteCollection,MoveCollection,FolderSync,FolderCreate,FolderDelete,FolderUpdate,MoveItems,GetItemEstimate,MeetingResponse,ResolveRecipients,ValidateCert,Provision,Search,Ping
| Content-Length: 0
| Keep-Alive: timeout=15, max=100
| Connection: Keep-Alive
| Content-Type: application/vnd.ms-sync.wbxml
| 
| #OWWW ¾o&ˆu‹EIN@:ÙV›Å$MP53+›™€.t9
| „{.POST /Microsoft-Server-ActiveSync?Cmd=FolderSync&User=hannsldap%40hannsmattes.de&DeviceId=androidc1405421619&DeviceType=Android HTTP/1.0
| Content-Type: application/vnd.ms-sync.wbxml
| Authorization: Basic aGFubnNsZGFwQGhhbm5zbWF0dGVzLmRlOmZhYmVyTA==
| MS-ASProtocolVersion: 2.5
| User-Agent: Android/4.0.2-EAS-1.3
| Accept-Encoding: gzip
| X-MS-PolicyKey: 0
| Content-Length: 13
| Host: mail.bruecko.de
| Via: 1.1 linux.hanns:3128 (squid/2.6.STABLE6)
| X-Forwarded-For: 192.168.0.192
| Cache-Control: max-age=259200
| Connection: keep-alive
| 
| #OWOO ¾o&ˆu‹EAN@:ÙV›Å$MP7H+›™€. 
| „{.jVR0#O	 &ˆu‹òoE5@@›$V›PM+›™7U€6w
| ./„{HTTP/1.0 500 Internal Server Error
| Date: Fri, 27 Jan 2012 21:20:26 GMT
| Server: Apache/2.2.15 (Linux/SUSE)
| X-Powered-By: PHP/5.3.9
| Set-Cookie: Horde=3g0f4bibmr7odpu9r75m453fkjtv37e0; path=/; domain=mail.bruecko.de; HttpOnly
| Expires: Thu, 19 Nov 1981 08:52:00 GMT
| Cache-Control: no-store, no-cache, must-revalidate, post-check=0, pre-check=0
| Pragma: no-cache
| Set-Cookie: Horde=3i18a2bp1ngnd6c6e4frhbckqfjn28k6; path=/; domain=mail.bruecko.de; HttpOnly
| Set-Cookie: auth_key=3i18a2bp1ngnd6c6e4frhbckqfjn28k6; path=/; domain=mail.bruecko.de
| Set-Cookie: default_horde_view=auto; expires=Sun, 26-Feb-2012 21:20:26 GMT; path=/; domain=mail.bruecko.de
| MS-Server-ActiveSync: 6.5.7638.1
| Content-Length: 89
| Connection: close
| Content-Type: text/html
| 
| SQLSTATE[42S22]: Column not found: 1054 Unknown column 'device_policykey' in 'field list'
`----

(There are also some lines with non-printable characters)

Any help appreciated.

Regards Hanns