[horde] Activesync | WP7 cannot sync

Martin Hochreiter linuxbox at wavenet.at
Sun Jan 29 16:53:54 UTC 2012


Am 29.01.2012 17:20 schrieb Michael J Rubinsky:
> Quoting Martin Hochreiter <linuxbox at wavenet.at>:
>
>> Hi!
>>
>> I have a massive problem with one user and its wp 7(.5) phone.
>>
>> If I configure active sync, as I did on the iphone, wm 6.5 and android
>> it ends in that error message on the phone:
>>
>>
>> xxx.xxxx.xxx requires that certain security policies be enforced 
>> before you can sync your information. Contact a support person or 
>> your service provider. Last tried x minutes ago. Error code:
>> The error code is 0x85010013.
>>
>> I tried to force provision - to turn of provision (but still if 
>> provision is turned off completely
>
> You should only get that message if you have forced provisioning and 
> either the phone doesn't support the configured security requirements 
> (unlikely since this is a Windows phone), or the user didn't 
> enable/refused to enable the requested features. Another possibility 
> is that maybe these newer phones don't fully support the older EAS 2.5 
> style of provisioning rules. The newer protocol versions use a 
> different format when pushing out the rules to the device. I'll have 
> to look into that when I get back home. Horde currently only supports 
> up to version EAS 2.5.
>
>> there is this line "PROVISION request received for user user_user" in 
>> the log)
>
> Was this log generated while provisioning support was completely 
> disabled? It doesn't look like it was; If you look at the entry where 
> it is "checking policykey for...", the user should not be immediately 
> logged off after that check if provisioning is disabled. Additionally, 
> the device should NEVER send a PROVISION request unless told to do so 
> by the server and this should never happen with provisioning support 
> disabled.
>
> Otherwise, if this was done during "Allow"  provisioning, this issue 
> sounds similar to an issue early android devices had, in that they 
> would incorrectly send a POLICYKEY of zero, even though the device did 
> not support PROVISION. We work around this in code by sniffing 
> versions and device strings. Though I would really be surprised that 
> this is the issue, seeing how it's a Windows phone and, presumably, 
> designed to work well with other Microsoft technology.
>
> Can you provide a wireshark trace or tcpdump of the conversation? I 
> don't have access to a Windows phone and it's the only way I can see 
> exactly what is being sent.
>
I will try to get a wireshark trace for you - as it isnt my phone I is a 
little bit complicated - but I will do

Meanwhile:
I tried many combinations ( with ssl/without ssl - force provision, 
allow provision, disable provision - allow provision with pin/force 
provision with pin) without any success.
I enclose the whole log of my tries today - unfortunately I cant tell 
anymore what logs are belong to what combinations and i have not logged 
everything
as I was searching for the error in the password first ... maybe you see 
more out of them

It is a htc with the latest updates but you dont have any options to 
controll anything related to active sync on the phone.
I found that article http://support.microsoft.com/kb/2464593 and so I 
see the only solution in "method 3" - but as i said - it seems to me 
that regardless of what the
provision is set in horde - the phone requests that....

ok I talk to much - here are the complete logs and I try to get a trace 
immediately

2012-01-29T14:12:05+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:12:05+01:00 DEBUG: [] OPTIONS request received for user 
user_user
2012-01-29T14:12:06+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:12:06+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
FOLDERSYNC request received for user user_user
2012-01-29T14:12:06+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:12:06+01:00 DEBUG: Resetting PING state
2012-01-29T14:12:06+01:00 INFO: Request being handled for device: 
8BCFCF4D1B57DEA7E3C2FA17703BC03C Supporting protocol version: 2.5
2012-01-29T14:12:06+01:00 INFO: [Horde_ActiveSync::handleFolderSync] 
Beginning FOLDERSYNC
2012-01-29T14:12:06+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Checking policykey for device  Key: 0 User: user_user
2012-01-29T14:12:06+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:12:06+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Stored key: 3444973398
2012-01-29T14:12:06+01:00 INFO: User user_user logged off
2012-01-29T14:12:08+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:12:09+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
PROVISION request received for user user_user
2012-01-29T14:12:09+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:12:09+01:00 DEBUG: Resetting PING state
2012-01-29T14:12:09+01:00 INFO: Request being handled for device: 
8BCFCF4D1B57DEA7E3C2FA17703BC03C Supporting protocol version: 2.5
2012-01-29T14:12:09+01:00 DEBUG: I <Provision:Provision>
2012-01-29T14:12:09+01:00 DEBUG: I <Provision:Policies>
2012-01-29T14:12:09+01:00 DEBUG: I <Provision:Policy>
2012-01-29T14:12:09+01:00 DEBUG: I <Provision:PolicyType>
2012-01-29T14:12:09+01:00 DEBUG: I      MS-WAP-Provisioning-XML
2012-01-29T14:12:09+01:00 DEBUG: I </Provision:PolicyType>
2012-01-29T14:12:09+01:00 DEBUG: I </Provision:Policy>
2012-01-29T14:12:09+01:00 DEBUG: I </Provision:Policies>
2012-01-29T14:12:09+01:00 DEBUG: I </Provision:Provision>
2012-01-29T14:12:09+01:00 DEBUG: O <Provision:Provision>
2012-01-29T14:12:09+01:00 DEBUG: O <Provision:Status>
2012-01-29T14:12:09+01:00 DEBUG: O    1
2012-01-29T14:12:09+01:00 DEBUG: O <Provision:Status/>
2012-01-29T14:12:09+01:00 DEBUG: O <Provision:Policies>
2012-01-29T14:12:09+01:00 DEBUG: O <Provision:Policy>
2012-01-29T14:12:09+01:00 DEBUG: O <Provision:PolicyType>
2012-01-29T14:12:09+01:00 DEBUG: O      MS-WAP-Provisioning-XML
2012-01-29T14:12:09+01:00 DEBUG: O <Provision:PolicyType/>
2012-01-29T14:12:09+01:00 DEBUG: O <Provision:Status>
2012-01-29T14:12:09+01:00 DEBUG: O      1
2012-01-29T14:12:09+01:00 DEBUG: O <Provision:Status/>
2012-01-29T14:12:09+01:00 DEBUG: O <Provision:PolicyKey>
2012-01-29T14:12:09+01:00 DEBUG: O      7290726955
2012-01-29T14:12:09+01:00 DEBUG: O <Provision:PolicyKey/>
2012-01-29T14:12:09+01:00 DEBUG: O <Provision:Data>
2012-01-29T14:12:09+01:00 DEBUG: O <wap-provisioningdoc><characteristic 
type="SecurityPolicy"><parm name="4131" value="1"/><parm name="4133" 
value="1"/></characteristic><characteristic 
type="Registry"><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\AE\{50C13377-C66D-400C-889E-C316FC4AB374}"><parm 
name="AEFrequencyType" value="1"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD"><parm name="DeviceWipeThreshold" 
value="10"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD"><parm name="CodewordFrequency" 
value="5"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\LAP\lap_pw"><parm 
name="MinimumPasswordLength" value="5"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\LAP\lap_pw"><parm 
name="PasswordComplexity" 
value="2"/></characteristic></characteristic></wap-provisioningdoc>
2012-01-29T14:12:09+01:00 DEBUG: O <Provision:Data/>
2012-01-29T14:12:09+01:00 DEBUG: O <Provision:Policy/>
2012-01-29T14:12:09+01:00 DEBUG: O <Provision:Policies/>
2012-01-29T14:12:09+01:00 DEBUG: O <Provision:Provision/>
2012-01-29T14:12:09+01:00 INFO: User user_user logged off
2012-01-29T14:13:23+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:13:23+01:00 DEBUG: [] OPTIONS request received for user 
user_user
2012-01-29T14:13:23+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:13:23+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
FOLDERSYNC request received for user user_user
2012-01-29T14:13:23+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Device entry does not exist, creating it.
2012-01-29T14:13:23+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Device entry does not exist for user user_user, creating it.
2012-01-29T14:13:23+01:00 INFO: Request being handled for device: 
8BCFCF4D1B57DEA7E3C2FA17703BC03C Supporting protocol version: 2.5
2012-01-29T14:13:23+01:00 INFO: [Horde_ActiveSync::handleFolderSync] 
Beginning FOLDERSYNC
2012-01-29T14:13:23+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Checking policykey for device  Key: 0 User: user_user
2012-01-29T14:13:23+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:13:23+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Stored key: 0
2012-01-29T14:13:23+01:00 INFO: User user_user logged off
2012-01-29T14:13:25+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:13:25+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
PROVISION request received for user user_user
2012-01-29T14:13:25+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:13:25+01:00 DEBUG: Resetting PING state
2012-01-29T14:13:25+01:00 INFO: Request being handled for device: 
8BCFCF4D1B57DEA7E3C2FA17703BC03C Supporting protocol version: 2.5
2012-01-29T14:13:25+01:00 DEBUG: I <Provision:Provision>
2012-01-29T14:13:25+01:00 DEBUG: I <Provision:Policies>
2012-01-29T14:13:25+01:00 DEBUG: I <Provision:Policy>
2012-01-29T14:13:25+01:00 DEBUG: I <Provision:PolicyType>
2012-01-29T14:13:25+01:00 DEBUG: I      MS-WAP-Provisioning-XML
2012-01-29T14:13:25+01:00 DEBUG: I </Provision:PolicyType>
2012-01-29T14:13:25+01:00 DEBUG: I </Provision:Policy>
2012-01-29T14:13:25+01:00 DEBUG: I </Provision:Policies>
2012-01-29T14:13:25+01:00 DEBUG: I </Provision:Provision>
2012-01-29T14:13:25+01:00 DEBUG: O <Provision:Provision>
2012-01-29T14:13:25+01:00 DEBUG: O <Provision:Status>
2012-01-29T14:13:25+01:00 DEBUG: O    1
2012-01-29T14:13:25+01:00 DEBUG: O <Provision:Status/>
2012-01-29T14:13:25+01:00 DEBUG: O <Provision:Policies>
2012-01-29T14:13:25+01:00 DEBUG: O <Provision:Policy>
2012-01-29T14:13:25+01:00 DEBUG: O <Provision:PolicyType>
2012-01-29T14:13:25+01:00 DEBUG: O      MS-WAP-Provisioning-XML
2012-01-29T14:13:25+01:00 DEBUG: O <Provision:PolicyType/>
2012-01-29T14:13:25+01:00 DEBUG: O <Provision:Status>
2012-01-29T14:13:25+01:00 DEBUG: O      1
2012-01-29T14:13:25+01:00 DEBUG: O <Provision:Status/>
2012-01-29T14:13:25+01:00 DEBUG: O <Provision:PolicyKey>
2012-01-29T14:13:25+01:00 DEBUG: O      7178692908
2012-01-29T14:13:25+01:00 DEBUG: O <Provision:PolicyKey/>
2012-01-29T14:13:25+01:00 DEBUG: O <Provision:Data>
2012-01-29T14:13:25+01:00 DEBUG: O <wap-provisioningdoc><characteristic 
type="SecurityPolicy"><parm name="4131" value="1"/><parm name="4133" 
value="1"/></characteristic><characteristic 
type="Registry"><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\AE\{50C13377-C66D-400C-889E-C316FC4AB374}"><parm 
name="AEFrequencyType" value="1"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD"><parm name="DeviceWipeThreshold" 
value="10"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD"><parm name="CodewordFrequency" 
value="5"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\LAP\lap_pw"><parm 
name="MinimumPasswordLength" value="5"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\LAP\lap_pw"><parm 
name="PasswordComplexity" 
value="2"/></characteristic></characteristic></wap-provisioningdoc>
2012-01-29T14:13:25+01:00 DEBUG: O <Provision:Data/>
2012-01-29T14:13:25+01:00 DEBUG: O <Provision:Policy/>
2012-01-29T14:13:25+01:00 DEBUG: O <Provision:Policies/>
2012-01-29T14:13:25+01:00 DEBUG: O <Provision:Provision/>
2012-01-29T14:13:25+01:00 INFO: User user_user logged off
2012-01-29T14:15:16+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:15:17+01:00 DEBUG: [] OPTIONS request received for user 
user_user
2012-01-29T14:15:17+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:15:17+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
FOLDERSYNC request received for user user_user
2012-01-29T14:15:17+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:15:17+01:00 DEBUG: Resetting PING state
2012-01-29T14:15:17+01:00 INFO: Request being handled for device: 
8BCFCF4D1B57DEA7E3C2FA17703BC03C Supporting protocol version: 2.5
2012-01-29T14:15:17+01:00 INFO: [Horde_ActiveSync::handleFolderSync] 
Beginning FOLDERSYNC
2012-01-29T14:15:17+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Checking policykey for device  Key: 0 User: user_user
2012-01-29T14:15:17+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:15:17+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Stored key: 7178692908
2012-01-29T14:15:17+01:00 INFO: User user_user logged off
2012-01-29T14:15:19+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:15:19+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
PROVISION request received for user user_user
2012-01-29T14:15:19+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:15:19+01:00 DEBUG: Resetting PING state
2012-01-29T14:15:19+01:00 INFO: Request being handled for device: 
8BCFCF4D1B57DEA7E3C2FA17703BC03C Supporting protocol version: 2.5
2012-01-29T14:15:19+01:00 DEBUG: I <Provision:Provision>
2012-01-29T14:15:19+01:00 DEBUG: I <Provision:Policies>
2012-01-29T14:15:19+01:00 DEBUG: I <Provision:Policy>
2012-01-29T14:15:19+01:00 DEBUG: I <Provision:PolicyType>
2012-01-29T14:15:19+01:00 DEBUG: I      MS-WAP-Provisioning-XML
2012-01-29T14:15:19+01:00 DEBUG: I </Provision:PolicyType>
2012-01-29T14:15:19+01:00 DEBUG: I </Provision:Policy>
2012-01-29T14:15:19+01:00 DEBUG: I </Provision:Policies>
2012-01-29T14:15:19+01:00 DEBUG: I </Provision:Provision>
2012-01-29T14:15:19+01:00 DEBUG: O <Provision:Provision>
2012-01-29T14:15:19+01:00 DEBUG: O <Provision:Status>
2012-01-29T14:15:19+01:00 DEBUG: O    1
2012-01-29T14:15:19+01:00 DEBUG: O <Provision:Status/>
2012-01-29T14:15:19+01:00 DEBUG: O <Provision:Policies>
2012-01-29T14:15:19+01:00 DEBUG: O <Provision:Policy>
2012-01-29T14:15:19+01:00 DEBUG: O <Provision:PolicyType>
2012-01-29T14:15:19+01:00 DEBUG: O      MS-WAP-Provisioning-XML
2012-01-29T14:15:19+01:00 DEBUG: O <Provision:PolicyType/>
2012-01-29T14:15:19+01:00 DEBUG: O <Provision:Status>
2012-01-29T14:15:19+01:00 DEBUG: O      1
2012-01-29T14:15:19+01:00 DEBUG: O <Provision:Status/>
2012-01-29T14:15:19+01:00 DEBUG: O <Provision:PolicyKey>
2012-01-29T14:15:19+01:00 DEBUG: O      6438767794
2012-01-29T14:15:19+01:00 DEBUG: O <Provision:PolicyKey/>
2012-01-29T14:15:19+01:00 DEBUG: O <Provision:Data>
2012-01-29T14:15:19+01:00 DEBUG: O <wap-provisioningdoc><characteristic 
type="SecurityPolicy"><parm name="4131" value="1"/><parm name="4133" 
value="1"/></characteristic><characteristic 
type="Registry"><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\AE\{50C13377-C66D-400C-889E-C316FC4AB374}"><parm 
name="AEFrequencyType" value="1"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD"><parm name="DeviceWipeThreshold" 
value="10"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD"><parm name="CodewordFrequency" 
value="5"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\LAP\lap_pw"><parm 
name="MinimumPasswordLength" value="5"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\LAP\lap_pw"><parm 
name="PasswordComplexity" 
value="2"/></characteristic></characteristic></wap-provisioningdoc>
2012-01-29T14:15:19+01:00 DEBUG: O <Provision:Data/>
2012-01-29T14:15:19+01:00 DEBUG: O <Provision:Policy/>
2012-01-29T14:15:19+01:00 DEBUG: O <Provision:Policies/>
2012-01-29T14:15:19+01:00 DEBUG: O <Provision:Provision/>
2012-01-29T14:15:19+01:00 INFO: User user_user logged off
2012-01-29T14:19:33+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:19:34+01:00 DEBUG: [] OPTIONS request received for user 
user_user
2012-01-29T14:19:34+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:19:34+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
FOLDERSYNC request received for user user_user
2012-01-29T14:19:34+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:19:34+01:00 DEBUG: Resetting PING state
2012-01-29T14:19:34+01:00 INFO: Request being handled for device: 
8BCFCF4D1B57DEA7E3C2FA17703BC03C Supporting protocol version: 2.5
2012-01-29T14:19:34+01:00 INFO: [Horde_ActiveSync::handleFolderSync] 
Beginning FOLDERSYNC
2012-01-29T14:19:34+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Checking policykey for device  Key: 0 User: user_user
2012-01-29T14:19:34+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:19:34+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Stored key: 6438767794
2012-01-29T14:19:34+01:00 INFO: User user_user logged off
2012-01-29T14:19:34+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:19:34+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
PROVISION request received for user user_user
2012-01-29T14:19:34+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:19:34+01:00 DEBUG: Resetting PING state
2012-01-29T14:19:34+01:00 INFO: Request being handled for device: 
8BCFCF4D1B57DEA7E3C2FA17703BC03C Supporting protocol version: 2.5
2012-01-29T14:19:34+01:00 DEBUG: I <Provision:Provision>
2012-01-29T14:19:34+01:00 DEBUG: I <Provision:Policies>
2012-01-29T14:19:34+01:00 DEBUG: I <Provision:Policy>
2012-01-29T14:19:34+01:00 DEBUG: I <Provision:PolicyType>
2012-01-29T14:19:34+01:00 DEBUG: I      MS-WAP-Provisioning-XML
2012-01-29T14:19:34+01:00 DEBUG: I </Provision:PolicyType>
2012-01-29T14:19:34+01:00 DEBUG: I </Provision:Policy>
2012-01-29T14:19:34+01:00 DEBUG: I </Provision:Policies>
2012-01-29T14:19:34+01:00 DEBUG: I </Provision:Provision>
2012-01-29T14:19:35+01:00 DEBUG: O <Provision:Provision>
2012-01-29T14:19:35+01:00 DEBUG: O <Provision:Status>
2012-01-29T14:19:35+01:00 DEBUG: O    1
2012-01-29T14:19:35+01:00 DEBUG: O <Provision:Status/>
2012-01-29T14:19:35+01:00 DEBUG: O <Provision:Policies>
2012-01-29T14:19:35+01:00 DEBUG: O <Provision:Policy>
2012-01-29T14:19:35+01:00 DEBUG: O <Provision:PolicyType>
2012-01-29T14:19:35+01:00 DEBUG: O      MS-WAP-Provisioning-XML
2012-01-29T14:19:35+01:00 DEBUG: O <Provision:PolicyType/>
2012-01-29T14:19:35+01:00 DEBUG: O <Provision:Status>
2012-01-29T14:19:35+01:00 DEBUG: O      1
2012-01-29T14:19:35+01:00 DEBUG: O <Provision:Status/>
2012-01-29T14:19:35+01:00 DEBUG: O <Provision:PolicyKey>
2012-01-29T14:19:35+01:00 DEBUG: O      1920532449
2012-01-29T14:19:35+01:00 DEBUG: O <Provision:PolicyKey/>
2012-01-29T14:19:35+01:00 DEBUG: O <Provision:Data>
2012-01-29T14:19:35+01:00 DEBUG: O <wap-provisioningdoc><characteristic 
type="SecurityPolicy"><parm name="4131" value="1"/><parm name="4133" 
value="1"/></characteristic><characteristic 
type="Registry"><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\AE\{50C13377-C66D-400C-889E-C316FC4AB374}"><parm 
name="AEFrequencyType" value="1"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD"><parm name="DeviceWipeThreshold" 
value="10"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD"><parm name="CodewordFrequency" 
value="5"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\LAP\lap_pw"><parm 
name="MinimumPasswordLength" value="5"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\LAP\lap_pw"><parm 
name="PasswordComplexity" 
value="2"/></characteristic></characteristic></wap-provisioningdoc>
2012-01-29T14:19:35+01:00 DEBUG: O <Provision:Data/>
2012-01-29T14:19:35+01:00 DEBUG: O <Provision:Policy/>
2012-01-29T14:19:35+01:00 DEBUG: O <Provision:Policies/>
2012-01-29T14:19:35+01:00 DEBUG: O <Provision:Provision/>
2012-01-29T14:19:35+01:00 INFO: User user_user logged off
2012-01-29T14:22:20+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:22:20+01:00 DEBUG: [] OPTIONS request received for user 
user_user
2012-01-29T14:22:22+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:22:22+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
FOLDERSYNC request received for user user_user
2012-01-29T14:22:22+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Device entry does not exist, creating it.
2012-01-29T14:22:22+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Device entry does not exist for user user_user, creating it.
2012-01-29T14:22:22+01:00 INFO: Request being handled for device: 
8BCFCF4D1B57DEA7E3C2FA17703BC03C Supporting protocol version: 2.5
2012-01-29T14:22:22+01:00 INFO: [Horde_ActiveSync::handleFolderSync] 
Beginning FOLDERSYNC
2012-01-29T14:22:22+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Checking policykey for device  Key: 0 User: user_user
2012-01-29T14:22:22+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:22:22+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Stored key: 0
2012-01-29T14:22:22+01:00 INFO: User user_user logged off
2012-01-29T14:22:23+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:22:23+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
PROVISION request received for user user_user
2012-01-29T14:22:23+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:22:23+01:00 DEBUG: Resetting PING state
2012-01-29T14:22:24+01:00 INFO: Request being handled for device: 
8BCFCF4D1B57DEA7E3C2FA17703BC03C Supporting protocol version: 2.5
2012-01-29T14:22:24+01:00 DEBUG: I <Provision:Provision>
2012-01-29T14:22:24+01:00 DEBUG: I <Provision:Policies>
2012-01-29T14:22:24+01:00 DEBUG: I <Provision:Policy>
2012-01-29T14:22:24+01:00 DEBUG: I <Provision:PolicyType>
2012-01-29T14:22:24+01:00 DEBUG: I      MS-WAP-Provisioning-XML
2012-01-29T14:22:24+01:00 DEBUG: I </Provision:PolicyType>
2012-01-29T14:22:24+01:00 DEBUG: I </Provision:Policy>
2012-01-29T14:22:24+01:00 DEBUG: I </Provision:Policies>
2012-01-29T14:22:24+01:00 DEBUG: I </Provision:Provision>
2012-01-29T14:22:24+01:00 DEBUG: O <Provision:Provision>
2012-01-29T14:22:24+01:00 DEBUG: O <Provision:Status>
2012-01-29T14:22:24+01:00 DEBUG: O    1
2012-01-29T14:22:24+01:00 DEBUG: O <Provision:Status/>
2012-01-29T14:22:24+01:00 DEBUG: O <Provision:Policies>
2012-01-29T14:22:24+01:00 DEBUG: O <Provision:Policy>
2012-01-29T14:22:24+01:00 DEBUG: O <Provision:PolicyType>
2012-01-29T14:22:24+01:00 DEBUG: O      MS-WAP-Provisioning-XML
2012-01-29T14:22:24+01:00 DEBUG: O <Provision:PolicyType/>
2012-01-29T14:22:24+01:00 DEBUG: O <Provision:Status>
2012-01-29T14:22:24+01:00 DEBUG: O      1
2012-01-29T14:22:24+01:00 DEBUG: O <Provision:Status/>
2012-01-29T14:22:24+01:00 DEBUG: O <Provision:PolicyKey>
2012-01-29T14:22:24+01:00 DEBUG: O      9040206133
2012-01-29T14:22:24+01:00 DEBUG: O <Provision:PolicyKey/>
2012-01-29T14:22:24+01:00 DEBUG: O <Provision:Data>
2012-01-29T14:22:24+01:00 DEBUG: O <wap-provisioningdoc><characteristic 
type="SecurityPolicy"><parm name="4131" value="0"/><parm name="4133" 
value="1"/></characteristic><characteristic 
type="Registry"><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\AE\{50C13377-C66D-400C-889E-C316FC4AB374}"><parm 
name="AEFrequencyType" value="1"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD"><parm name="DeviceWipeThreshold" 
value="10"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD"><parm name="CodewordFrequency" 
value="5"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\LAP\lap_pw"><parm 
name="MinimumPasswordLength" value="5"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\LAP\lap_pw"><parm 
name="PasswordComplexity" 
value="2"/></characteristic></characteristic></wap-provisioningdoc>
2012-01-29T14:22:24+01:00 DEBUG: O <Provision:Data/>
2012-01-29T14:22:24+01:00 DEBUG: O <Provision:Policy/>
2012-01-29T14:22:24+01:00 DEBUG: O <Provision:Policies/>
2012-01-29T14:22:24+01:00 DEBUG: O <Provision:Provision/>
2012-01-29T14:22:24+01:00 INFO: User user_user logged off
2012-01-29T14:23:09+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:23:09+01:00 DEBUG: [] OPTIONS request received for user 
user_user
2012-01-29T14:23:10+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:23:10+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
FOLDERSYNC request received for user user_user
2012-01-29T14:23:10+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Device entry does not exist, creating it.
2012-01-29T14:23:10+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Device entry does not exist for user user_user, creating it.
2012-01-29T14:23:10+01:00 INFO: Request being handled for device: 
8BCFCF4D1B57DEA7E3C2FA17703BC03C Supporting protocol version: 2.5
2012-01-29T14:23:10+01:00 INFO: [Horde_ActiveSync::handleFolderSync] 
Beginning FOLDERSYNC
2012-01-29T14:23:10+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Checking policykey for device  Key: 0 User: user_user
2012-01-29T14:23:10+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:23:10+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Stored key: 0
2012-01-29T14:23:10+01:00 INFO: User user_user logged off
2012-01-29T14:23:12+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:23:12+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
PROVISION request received for user user_user
2012-01-29T14:23:12+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:23:12+01:00 DEBUG: Resetting PING state
2012-01-29T14:23:12+01:00 INFO: Request being handled for device: 
8BCFCF4D1B57DEA7E3C2FA17703BC03C Supporting protocol version: 2.5
2012-01-29T14:23:12+01:00 DEBUG: I <Provision:Provision>
2012-01-29T14:23:12+01:00 DEBUG: I <Provision:Policies>
2012-01-29T14:23:12+01:00 DEBUG: I <Provision:Policy>
2012-01-29T14:23:12+01:00 DEBUG: I <Provision:PolicyType>
2012-01-29T14:23:12+01:00 DEBUG: I      MS-WAP-Provisioning-XML
2012-01-29T14:23:12+01:00 DEBUG: I </Provision:PolicyType>
2012-01-29T14:23:12+01:00 DEBUG: I </Provision:Policy>
2012-01-29T14:23:12+01:00 DEBUG: I </Provision:Policies>
2012-01-29T14:23:12+01:00 DEBUG: I </Provision:Provision>
2012-01-29T14:23:12+01:00 DEBUG: O <Provision:Provision>
2012-01-29T14:23:12+01:00 DEBUG: O <Provision:Status>
2012-01-29T14:23:12+01:00 DEBUG: O    1
2012-01-29T14:23:12+01:00 DEBUG: O <Provision:Status/>
2012-01-29T14:23:12+01:00 DEBUG: O <Provision:Policies>
2012-01-29T14:23:12+01:00 DEBUG: O <Provision:Policy>
2012-01-29T14:23:12+01:00 DEBUG: O <Provision:PolicyType>
2012-01-29T14:23:12+01:00 DEBUG: O      MS-WAP-Provisioning-XML
2012-01-29T14:23:12+01:00 DEBUG: O <Provision:PolicyType/>
2012-01-29T14:23:12+01:00 DEBUG: O <Provision:Status>
2012-01-29T14:23:12+01:00 DEBUG: O      1
2012-01-29T14:23:12+01:00 DEBUG: O <Provision:Status/>
2012-01-29T14:23:12+01:00 DEBUG: O <Provision:PolicyKey>
2012-01-29T14:23:12+01:00 DEBUG: O      9106427468
2012-01-29T14:23:12+01:00 DEBUG: O <Provision:PolicyKey/>
2012-01-29T14:23:12+01:00 DEBUG: O <Provision:Data>
2012-01-29T14:23:12+01:00 DEBUG: O <wap-provisioningdoc><characteristic 
type="SecurityPolicy"><parm name="4131" value="0"/><parm name="4133" 
value="1"/></characteristic><characteristic 
type="Registry"><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\AE\{50C13377-C66D-400C-889E-C316FC4AB374}"><parm 
name="AEFrequencyType" value="1"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD"><parm name="DeviceWipeThreshold" 
value="10"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD"><parm name="CodewordFrequency" 
value="5"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\LAP\lap_pw"><parm 
name="MinimumPasswordLength" value="5"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\LAP\lap_pw"><parm 
name="PasswordComplexity" 
value="2"/></characteristic></characteristic></wap-provisioningdoc>
2012-01-29T14:23:12+01:00 DEBUG: O <Provision:Data/>
2012-01-29T14:23:12+01:00 DEBUG: O <Provision:Policy/>
2012-01-29T14:23:12+01:00 DEBUG: O <Provision:Policies/>
2012-01-29T14:23:12+01:00 DEBUG: O <Provision:Provision/>
2012-01-29T14:23:12+01:00 INFO: User user_user logged off
2012-01-29T14:26:44+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:26:54+01:00 DEBUG: [] OPTIONS request received for user 
user_user
2012-01-29T14:27:51+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:27:51+01:00 DEBUG: [] OPTIONS request received for user 
user_user
2012-01-29T14:27:52+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:27:52+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
FOLDERSYNC request received for user user_user
2012-01-29T14:27:52+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Device entry does not exist, creating it.
2012-01-29T14:27:52+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Device entry does not exist for user user_user, creating it.
2012-01-29T14:27:52+01:00 INFO: Request being handled for device: 
8BCFCF4D1B57DEA7E3C2FA17703BC03C Supporting protocol version: 2.5
2012-01-29T14:27:52+01:00 INFO: [Horde_ActiveSync::handleFolderSync] 
Beginning FOLDERSYNC
2012-01-29T14:27:52+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Checking policykey for device  Key: 0 User: user_user
2012-01-29T14:27:52+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:27:52+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Stored key: 0
2012-01-29T14:27:52+01:00 INFO: User user_user logged off
2012-01-29T14:27:54+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:27:54+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
PROVISION request received for user user_user
2012-01-29T14:27:54+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:27:54+01:00 DEBUG: Resetting PING state
2012-01-29T14:27:54+01:00 INFO: Request being handled for device: 
8BCFCF4D1B57DEA7E3C2FA17703BC03C Supporting protocol version: 2.5
2012-01-29T14:27:54+01:00 DEBUG: I <Provision:Provision>
2012-01-29T14:27:54+01:00 DEBUG: I <Provision:Policies>
2012-01-29T14:27:54+01:00 DEBUG: I <Provision:Policy>
2012-01-29T14:27:54+01:00 DEBUG: I <Provision:PolicyType>
2012-01-29T14:27:54+01:00 DEBUG: I      MS-WAP-Provisioning-XML
2012-01-29T14:27:54+01:00 DEBUG: I </Provision:PolicyType>
2012-01-29T14:27:54+01:00 DEBUG: I </Provision:Policy>
2012-01-29T14:27:54+01:00 DEBUG: I </Provision:Policies>
2012-01-29T14:27:54+01:00 DEBUG: I </Provision:Provision>
2012-01-29T14:27:54+01:00 DEBUG: O <Provision:Provision>
2012-01-29T14:27:54+01:00 DEBUG: O <Provision:Status>
2012-01-29T14:27:54+01:00 DEBUG: O    1
2012-01-29T14:27:54+01:00 DEBUG: O <Provision:Status/>
2012-01-29T14:27:54+01:00 DEBUG: O <Provision:Policies>
2012-01-29T14:27:54+01:00 DEBUG: O <Provision:Policy>
2012-01-29T14:27:54+01:00 DEBUG: O <Provision:PolicyType>
2012-01-29T14:27:54+01:00 DEBUG: O      MS-WAP-Provisioning-XML
2012-01-29T14:27:54+01:00 DEBUG: O <Provision:PolicyType/>
2012-01-29T14:27:54+01:00 DEBUG: O <Provision:Status>
2012-01-29T14:27:54+01:00 DEBUG: O      1
2012-01-29T14:27:54+01:00 DEBUG: O <Provision:Status/>
2012-01-29T14:27:54+01:00 DEBUG: O <Provision:PolicyKey>
2012-01-29T14:27:54+01:00 DEBUG: O      1074429552
2012-01-29T14:27:54+01:00 DEBUG: O <Provision:PolicyKey/>
2012-01-29T14:27:54+01:00 DEBUG: O <Provision:Data>
2012-01-29T14:27:54+01:00 DEBUG: O <wap-provisioningdoc><characteristic 
type="SecurityPolicy"><parm name="4131" value="0"/><parm name="4133" 
value="1"/></characteristic><characteristic 
type="Registry"><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\AE\{50C13377-C66D-400C-889E-C316FC4AB374}"><parm 
name="AEFrequencyType" value="1"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD"><parm name="DeviceWipeThreshold" 
value="10"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD"><parm name="CodewordFrequency" 
value="5"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\LAP\lap_pw"><parm 
name="MinimumPasswordLength" value="5"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\LAP\lap_pw"><parm 
name="PasswordComplexity" 
value="2"/></characteristic></characteristic></wap-provisioningdoc>
2012-01-29T14:27:54+01:00 DEBUG: O <Provision:Data/>
2012-01-29T14:27:54+01:00 DEBUG: O <Provision:Policy/>
2012-01-29T14:27:54+01:00 DEBUG: O <Provision:Policies/>
2012-01-29T14:27:54+01:00 DEBUG: O <Provision:Provision/>
2012-01-29T14:27:54+01:00 INFO: User user_user logged off
2012-01-29T14:27:55+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:27:55+01:00 DEBUG: [] OPTIONS request received for user 
user_user
2012-01-29T14:27:57+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:27:57+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
FOLDERSYNC request received for user user_user
2012-01-29T14:27:57+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:27:57+01:00 DEBUG: Resetting PING state
2012-01-29T14:27:57+01:00 INFO: Request being handled for device: 
8BCFCF4D1B57DEA7E3C2FA17703BC03C Supporting protocol version: 2.5
2012-01-29T14:27:57+01:00 INFO: [Horde_ActiveSync::handleFolderSync] 
Beginning FOLDERSYNC
2012-01-29T14:27:57+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Checking policykey for device  Key: 0 User: user_user
2012-01-29T14:27:57+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:27:57+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Stored key: 1074429552
2012-01-29T14:27:57+01:00 INFO: User user_user logged off
2012-01-29T14:27:59+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:27:59+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
PROVISION request received for user user_user
2012-01-29T14:27:59+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:27:59+01:00 DEBUG: Resetting PING state
2012-01-29T14:27:59+01:00 INFO: Request being handled for device: 
8BCFCF4D1B57DEA7E3C2FA17703BC03C Supporting protocol version: 2.5
2012-01-29T14:27:59+01:00 DEBUG: I <Provision:Provision>
2012-01-29T14:27:59+01:00 DEBUG: I <Provision:Policies>
2012-01-29T14:27:59+01:00 DEBUG: I <Provision:Policy>
2012-01-29T14:27:59+01:00 DEBUG: I <Provision:PolicyType>
2012-01-29T14:27:59+01:00 DEBUG: I      MS-WAP-Provisioning-XML
2012-01-29T14:27:59+01:00 DEBUG: I </Provision:PolicyType>
2012-01-29T14:27:59+01:00 DEBUG: I </Provision:Policy>
2012-01-29T14:27:59+01:00 DEBUG: I </Provision:Policies>
2012-01-29T14:27:59+01:00 DEBUG: I </Provision:Provision>
2012-01-29T14:27:59+01:00 DEBUG: O <Provision:Provision>
2012-01-29T14:27:59+01:00 DEBUG: O <Provision:Status>
2012-01-29T14:27:59+01:00 DEBUG: O    1
2012-01-29T14:27:59+01:00 DEBUG: O <Provision:Status/>
2012-01-29T14:27:59+01:00 DEBUG: O <Provision:Policies>
2012-01-29T14:27:59+01:00 DEBUG: O <Provision:Policy>
2012-01-29T14:27:59+01:00 DEBUG: O <Provision:PolicyType>
2012-01-29T14:27:59+01:00 DEBUG: O      MS-WAP-Provisioning-XML
2012-01-29T14:27:59+01:00 DEBUG: O <Provision:PolicyType/>
2012-01-29T14:27:59+01:00 DEBUG: O <Provision:Status>
2012-01-29T14:27:59+01:00 DEBUG: O      1
2012-01-29T14:27:59+01:00 DEBUG: O <Provision:Status/>
2012-01-29T14:27:59+01:00 DEBUG: O <Provision:PolicyKey>
2012-01-29T14:27:59+01:00 DEBUG: O      6323188864
2012-01-29T14:27:59+01:00 DEBUG: O <Provision:PolicyKey/>
2012-01-29T14:27:59+01:00 DEBUG: O <Provision:Data>
2012-01-29T14:27:59+01:00 DEBUG: O <wap-provisioningdoc><characteristic 
type="SecurityPolicy"><parm name="4131" value="0"/><parm name="4133" 
value="1"/></characteristic><characteristic 
type="Registry"><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\AE\{50C13377-C66D-400C-889E-C316FC4AB374}"><parm 
name="AEFrequencyType" value="1"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD"><parm name="DeviceWipeThreshold" 
value="10"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD"><parm name="CodewordFrequency" 
value="5"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\LAP\lap_pw"><parm 
name="MinimumPasswordLength" value="5"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\LAP\lap_pw"><parm 
name="PasswordComplexity" 
value="2"/></characteristic></characteristic></wap-provisioningdoc>
2012-01-29T14:27:59+01:00 DEBUG: O <Provision:Data/>
2012-01-29T14:27:59+01:00 DEBUG: O <Provision:Policy/>
2012-01-29T14:27:59+01:00 DEBUG: O <Provision:Policies/>
2012-01-29T14:27:59+01:00 DEBUG: O <Provision:Provision/>
2012-01-29T14:27:59+01:00 INFO: User user_user logged off
2012-01-29T14:32:34+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:32:34+01:00 DEBUG: [] OPTIONS request received for user 
user_user
2012-01-29T14:32:35+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:32:35+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
FOLDERSYNC request received for user user_user
2012-01-29T14:32:35+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:32:35+01:00 DEBUG: Resetting PING state
2012-01-29T14:32:35+01:00 INFO: Request being handled for device: 
8BCFCF4D1B57DEA7E3C2FA17703BC03C Supporting protocol version: 2.5
2012-01-29T14:32:35+01:00 INFO: [Horde_ActiveSync::handleFolderSync] 
Beginning FOLDERSYNC
2012-01-29T14:32:35+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Checking policykey for device  Key: 0 User: user_user
2012-01-29T14:32:35+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:32:35+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Stored key: 6323188864
2012-01-29T14:32:35+01:00 INFO: User user_user logged off
2012-01-29T14:32:38+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:32:38+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
PROVISION request received for user user_user
2012-01-29T14:32:38+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:32:38+01:00 DEBUG: Resetting PING state
2012-01-29T14:32:38+01:00 INFO: Request being handled for device: 
8BCFCF4D1B57DEA7E3C2FA17703BC03C Supporting protocol version: 2.5
2012-01-29T14:32:38+01:00 DEBUG: I <Provision:Provision>
2012-01-29T14:32:38+01:00 DEBUG: I <Provision:Policies>
2012-01-29T14:32:38+01:00 DEBUG: I <Provision:Policy>
2012-01-29T14:32:38+01:00 DEBUG: I <Provision:PolicyType>
2012-01-29T14:32:38+01:00 DEBUG: I      MS-WAP-Provisioning-XML
2012-01-29T14:32:38+01:00 DEBUG: I </Provision:PolicyType>
2012-01-29T14:32:38+01:00 DEBUG: I </Provision:Policy>
2012-01-29T14:32:38+01:00 DEBUG: I </Provision:Policies>
2012-01-29T14:32:38+01:00 DEBUG: I </Provision:Provision>
2012-01-29T14:32:38+01:00 DEBUG: O <Provision:Provision>
2012-01-29T14:32:38+01:00 DEBUG: O <Provision:Status>
2012-01-29T14:32:38+01:00 DEBUG: O    1
2012-01-29T14:32:38+01:00 DEBUG: O <Provision:Status/>
2012-01-29T14:32:38+01:00 DEBUG: O <Provision:Policies>
2012-01-29T14:32:38+01:00 DEBUG: O <Provision:Policy>
2012-01-29T14:32:38+01:00 DEBUG: O <Provision:PolicyType>
2012-01-29T14:32:38+01:00 DEBUG: O      MS-WAP-Provisioning-XML
2012-01-29T14:32:38+01:00 DEBUG: O <Provision:PolicyType/>
2012-01-29T14:32:38+01:00 DEBUG: O <Provision:Status>
2012-01-29T14:32:38+01:00 DEBUG: O      1
2012-01-29T14:32:38+01:00 DEBUG: O <Provision:Status/>
2012-01-29T14:32:38+01:00 DEBUG: O <Provision:PolicyKey>
2012-01-29T14:32:38+01:00 DEBUG: O      8822478889
2012-01-29T14:32:38+01:00 DEBUG: O <Provision:PolicyKey/>
2012-01-29T14:32:38+01:00 DEBUG: O <Provision:Data>
2012-01-29T14:32:38+01:00 DEBUG: O <wap-provisioningdoc><characteristic 
type="SecurityPolicy"><parm name="4131" value="0"/><parm name="4133" 
value="1"/></characteristic><characteristic 
type="Registry"><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\AE\{50C13377-C66D-400C-889E-C316FC4AB374}"><parm 
name="AEFrequencyType" value="1"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD"><parm name="DeviceWipeThreshold" 
value="10"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD"><parm name="CodewordFrequency" 
value="5"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\LAP\lap_pw"><parm 
name="MinimumPasswordLength" value="5"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\LAP\lap_pw"><parm 
name="PasswordComplexity" 
value="1"/></characteristic></characteristic></wap-provisioningdoc>
2012-01-29T14:32:38+01:00 DEBUG: O <Provision:Data/>
2012-01-29T14:32:38+01:00 DEBUG: O <Provision:Policy/>
2012-01-29T14:32:38+01:00 DEBUG: O <Provision:Policies/>
2012-01-29T14:32:38+01:00 DEBUG: O <Provision:Provision/>
2012-01-29T14:32:38+01:00 INFO: User user_user logged off
2012-01-29T14:33:23+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:33:24+01:00 DEBUG: [] OPTIONS request received for user 
user_user
2012-01-29T14:33:26+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:33:26+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
FOLDERSYNC request received for user user_user
2012-01-29T14:33:26+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Device entry does not exist, creating it.
2012-01-29T14:33:26+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Device entry does not exist for user user_user, creating it.
2012-01-29T14:33:26+01:00 INFO: Request being handled for device: 
8BCFCF4D1B57DEA7E3C2FA17703BC03C Supporting protocol version: 2.5
2012-01-29T14:33:26+01:00 INFO: [Horde_ActiveSync::handleFolderSync] 
Beginning FOLDERSYNC
2012-01-29T14:33:26+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Checking policykey for device  Key: 0 User: user_user
2012-01-29T14:33:26+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:33:26+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
Stored key: 0
2012-01-29T14:33:26+01:00 INFO: User user_user logged off
2012-01-29T14:33:27+01:00 INFO: Horde_ActiveSync_Driver_Horde::logon 
attempt for: user_user
2012-01-29T14:33:27+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
PROVISION request received for user user_user
2012-01-29T14:33:27+01:00 DEBUG: [8BCFCF4D1B57DEA7E3C2FA17703BC03C] 
loadDeviceInfo: user_user
2012-01-29T14:33:27+01:00 DEBUG: Resetting PING state
2012-01-29T14:33:27+01:00 INFO: Request being handled for device: 
8BCFCF4D1B57DEA7E3C2FA17703BC03C Supporting protocol version: 2.5
2012-01-29T14:33:27+01:00 DEBUG: I <Provision:Provision>
2012-01-29T14:33:27+01:00 DEBUG: I <Provision:Policies>
2012-01-29T14:33:27+01:00 DEBUG: I <Provision:Policy>
2012-01-29T14:33:27+01:00 DEBUG: I <Provision:PolicyType>
2012-01-29T14:33:27+01:00 DEBUG: I      MS-WAP-Provisioning-XML
2012-01-29T14:33:27+01:00 DEBUG: I </Provision:PolicyType>
2012-01-29T14:33:27+01:00 DEBUG: I </Provision:Policy>
2012-01-29T14:33:27+01:00 DEBUG: I </Provision:Policies>
2012-01-29T14:33:27+01:00 DEBUG: I </Provision:Provision>
2012-01-29T14:33:27+01:00 DEBUG: O <Provision:Provision>
2012-01-29T14:33:27+01:00 DEBUG: O <Provision:Status>
2012-01-29T14:33:27+01:00 DEBUG: O    1
2012-01-29T14:33:27+01:00 DEBUG: O <Provision:Status/>
2012-01-29T14:33:27+01:00 DEBUG: O <Provision:Policies>
2012-01-29T14:33:27+01:00 DEBUG: O <Provision:Policy>
2012-01-29T14:33:27+01:00 DEBUG: O <Provision:PolicyType>
2012-01-29T14:33:27+01:00 DEBUG: O      MS-WAP-Provisioning-XML
2012-01-29T14:33:27+01:00 DEBUG: O <Provision:PolicyType/>
2012-01-29T14:33:27+01:00 DEBUG: O <Provision:Status>
2012-01-29T14:33:27+01:00 DEBUG: O      1
2012-01-29T14:33:27+01:00 DEBUG: O <Provision:Status/>
2012-01-29T14:33:27+01:00 DEBUG: O <Provision:PolicyKey>
2012-01-29T14:33:27+01:00 DEBUG: O      5887728924
2012-01-29T14:33:27+01:00 DEBUG: O <Provision:PolicyKey/>
2012-01-29T14:33:27+01:00 DEBUG: O <Provision:Data>
2012-01-29T14:33:27+01:00 DEBUG: O <wap-provisioningdoc><characteristic 
type="SecurityPolicy"><parm name="4131" value="0"/><parm name="4133" 
value="1"/></characteristic><characteristic 
type="Registry"><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\AE\{50C13377-C66D-400C-889E-C316FC4AB374}"><parm 
name="AEFrequencyType" value="1"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD"><parm name="DeviceWipeThreshold" 
value="10"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD"><parm name="CodewordFrequency" 
value="5"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\LAP\lap_pw"><parm 
name="MinimumPasswordLength" value="5"/></characteristic><characteristic 
type="HKLM\Comm\Security\Policy\LASSD\LAP\lap_pw"><parm 
name="PasswordComplexity" 
value="1"/></characteristic></characteristic></wap-provisioningdoc>
2012-01-29T14:33:27+01:00 DEBUG: O <Provision:Data/>
2012-01-29T14:33:27+01:00 DEBUG: O <Provision:Policy/>
2012-01-29T14:33:27+01:00 DEBUG: O <Provision:Policies/>
2012-01-29T14:33:27+01:00 DEBUG: O <Provision:Provision/>
2012-01-29T14:33:27+01:00 INFO: User user_user logged off




More information about the horde mailing list