Kolab 3.1 Active Sync Problems with Nokia N8

Sat Nov 16 18:24:30 CET 2013

Hi,
I've got a freshly installed Kolab 3.1 on CentOS 6.4 with all updates so far.
I try to do EAS with a Nokia N8 and the built in Mail for Exchange app.
Basically, it does not work. Sometimes it does sync a little, e.g. contacts, tasks, calendar get synced or some new mail give the buzz on the mobile or I can send mails, but there are no mails in the Inbox and mostly I get a "connect error, retry later" message on the mobile.
To prune some possible eror sources my tests took place via WLAN (mobile in the same network as server) and without "Secure Connection".
In Roundcube I selected options to only sync one calendar and address book.

kolab-syncroton/imap.log:
[16-Nov-2013 17:08:20,000000 +0100]: [00A8] S: * OK [CAPABILITY IMAP4rev1 LITERAL+ ID ENABLE STARTTLS AUTH=LOGIN AUTH=PLAIN SASL-IR] server.domain.local Cyrus IMAP v2.4.17-Kolab-2.4.17-30.1.el6.kolab_3.1 server ready
[16-Nov-2013 17:08:20,000000 +0100]: [00A8] C: A0001 STARTTLS
[16-Nov-2013 17:08:20,000000 +0100]: [00A8] S: A0001 OK Begin TLS negotiation now
[16-Nov-2013 17:08:20,000000 +0100]: [00A8] C: A0002 CAPABILITY
[16-Nov-2013 17:08:20,000000 +0100]: [00A8] S: * CAPABILITY IMAP4rev1 LITERAL+ ID ENABLE ACL RIGHTS=kxte QUOTA MAILBOX-REFERRALS NAMESPACE UIDPLUS NO_ATOMIC_RENAME UNSELECT CHILDREN MULTIAPPEND BINARY CATENATE CONDSTORE ESEARCH SORT SORT=MODSEQ SORT=DISPLAY THREAD=ORDEREDSUBJECT THREAD=REFERENCES ANNOTATEMORE LIST-EXTENDED WITHIN QRESYNC SCAN XLIST URLAUTH URLAUTH=BINARY X-NETSCAPE AUTH=LOGIN AUTH=PLAIN SASL-IR COMPRESS=DEFLATE IDLE
[16-Nov-2013 17:08:20,000000 +0100]: [00A8] S: A0002 OK Completed
[16-Nov-2013 17:08:20,000000 +0100]: [00A8] C: A0003 ID ("name" "Roundcube" "version" "1.0-git" "php" "5.3.3" "os" "Linux" "command" "/Microsoft-Server-ActiveSync?User=XXXXX&DeviceId=IMEIXXXXXXXXXXX&DeviceType=NokiaEmail&Cmd=FolderSync")
[16-Nov-2013 17:08:20,000000 +0100]: [00A8] S: A0003 NO Only one Id allowed in non-authenticated state
[16-Nov-2013 17:08:20,000000 +0100]: [00A8] C: A0004 AUTHENTICATE PLAIN AHRob21hcy56aWVnbGVyQGZyaXR6LmJveABDNG9aWDBqcXdzUXZFM04=
[16-Nov-2013 17:08:20,000000 +0100]: [00A8] S: A0004 OK [CAPABILITY IMAP4rev1 LITERAL+ ID ENABLE ACL RIGHTS=kxte QUOTA MAILBOX-REFERRALS NAMESPACE UIDPLUS NO_ATOMIC_RENAME UNSELECT CHILDREN MULTIAPPEND BINARY CATENATE CONDSTORE ESEARCH SORT SORT=MODSEQ SORT=DISPLAY THREAD=ORDEREDSUBJECT THREAD=REFERENCES ANNOTATEMORE LIST-EXTENDED WITHIN QRESYNC SCAN XLIST URLAUTH URLAUTH=BINARY X-NETSCAPE LOGINDISABLED COMPRESS=DEFLATE IDLE] Success (tls protection) SESSIONID=<server.domain.local-27948-1384618100-1>
[16-Nov-2013 17:08:20,000000 +0100]: [00A8] C: A0005 NAMESPACE
[16-Nov-2013 17:08:20,000000 +0100]: [00A8] S: * NAMESPACE (("" "/")) (("Other Users/" "/")) (("Shared Folders/" "/"))
[16-Nov-2013 17:08:20,000000 +0100]: [00A8] S: A0005 OK Completed
[16-Nov-2013 17:08:20,000000 +0100]: [00A8] C: A0006 LOGOUT
[16-Nov-2013 17:08:20,000000 +0100]: [00A8] S: * BYE LOGOUT received
[16-Nov-2013 17:08:20,000000 +0100]: [00A8] S: A0006 OK Completed

What irritates me is the "A0003 NO Only one Id allowed in non-authenticated state" message, which shows up mostly, but not always. I don't know if this means anything, but for exmple at the moment I get
[16-Nov-2013 17:49:42,000000 +0100]: [E485] S: A0003 OK Completed

On my mobile I find logged by Mail for Exchange:
16/11/2013 17:07:37 Profile Info
Peak sync schedule: Always on
Peak sync days: Mo,Tu,We,Th,Fr,Sa,Su
Peak start time 08:00 - Peak end time 17:00
Off-peak sync schedule: Every 4 hours
Peak sync while roaming: No
Off-peak sync while roaming: No
Heartbeat interval: 11
Access point: 4097, Destination: Internet
Secure connection: No
Port number: 80
E-mail sync: Enable
If conflict: Server wins
Remove email older than: 1 week
Calendar sync: Enable
...
16/11/2013 17:07:37 Profile Updated
16/11/2013 17:07:47 Connected to connection method named Nibelungen with type WLAN
16/11/2013 17:07:54 start Calendar sync
16/11/2013 17:07:54 HTTP Server Error 501: Not Implemented
16/11/2013 17:07:54 end Calendar sync
16/11/2013 17:08:03 Connected to connection method named Nibelungen with type WLAN
16/11/2013 17:08:04 start Calendar sync
16/11/2013 17:08:04 HTTP Server Error 501: Not Implemented
16/11/2013 17:08:04 end Calendar sync
16/11/2013 17:08:16 Connected to connection method named Nibelungen with type WLAN
16/11/2013 17:08:17 start Calendar sync
16/11/2013 17:08:17 HTTP Server Error 501: Not Implemented
16/11/2013 17:08:17 end Calendar sync

httpd/access.log
192.168.178.22 - XXXXX [16/Nov/2013:17:07:58 +0100] "POST /Microsoft-Server-ActiveSync?User=XXXXX&DeviceId=IMEIXXXXXXXXXXXX&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 - "-" "NokiaN800/1.00(0)ActiveSync 3gpp-gba"

This "HTTP Server Error 501: Not Implemented" message is most disturbing, as nothing gets logged in httpd/error, kolab-syncroton/error, so I don't have a clue where to look for it.

At other times the log looks like this, but also no mails show up:
14/11/2013 16:59:17 Connected to connection method named YYYY with type WLAN
14/11/2013 16:59:18 HTTP error code=500
14/11/2013 16:59:18 HTTP Server Error 500: Internal Server Error
14/11/2013 18:36:44 syncSettings.iDeviceRoamingAndReqManualSyncPolicyOn : 0
14/11/2013 18:36:50 Connected to connection method named XXXXX with type WLAN
14/11/2013 18:36:52 start E-mail sync
14/11/2013 18:36:55 client->server adds=0 changes=1 deletes=0 fails=0
14/11/2013 18:36:55 server->client adds=5 changes=0 deletes=0 fails=0
14/11/2013 18:36:57 client->server adds=0 changes=1 deletes=0 fails=0
14/11/2013 18:36:57 server->client adds=10 changes=0 deletes=0 fails=0
14/11/2013 18:37:00 client->server adds=0 changes=1 deletes=0 fails=0
14/11/2013 18:37:00 server->client adds=15 changes=0 deletes=0 fails=0
14/11/2013 18:37:02 client->server adds=0 changes=1 deletes=0 fails=0
14/11/2013 18:37:02 server->client adds=19 changes=0 deletes=0 fails=0
14/11/2013 18:37:02 end E-mail sync
14/11/2013 18:37:02 clearing device entries for resync
14/11/2013 18:37:02 start Calendar sync

It would be great if somebody could help me with this.
Thanks in advance,
Thomas

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.kolab.org/pipermail/users/attachments/20131116/4a335afe/attachment.html>