The full logs are 1.37MB, so here's a segment.
User5 is another Google Apps user - Verified same results.
email/usernames and actual URLs have been edited. I can send you the
actual URLs, etc privately if you like.
2009-06-29 15:27:13,250 [6924] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyRequest - Request received
from GCal. [body=[1,0,[Us...@domain.tld],
20090620/20090708,20090629T152347,America/Los_Angeles]]
2009-06-29 15:27:13,250 [6924] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@domain.tld
2009-06-29 15:27:13,250 [6924] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Searching
Active Directory [Server=LDAP://owa.domain.tld,
User=gcaldom...@exchange.domain]
2009-06-29 15:27:13,250 [6924] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Issuing LDAP
query '(&(mail=Us...@exchange.domain)(|(objectcategory=user)
(objectcategory=contact)))'
2009-06-29 15:27:13,250 [6924] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Found 0 users
in Active Directory.
2009-06-29 15:27:13,250 [6924] INFO
Google.GCalExchangeSync.Library.ExchangeService - Unable to find
Active Directory user where 'mail'='Us...@exchange.domain'.
2009-06-29 15:27:13,250 [6924] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - GCal Free/Busy
response successfully generated.
2009-06-29 15:27:13,250 [6924] DEBUG
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - Response =
['1','0',['_ME_AddData','20090620/20090708','20090629T152347',[]]]
2009-06-29 15:27:13,250 [6924] DEBUG
GCalExchangeLookup.ExchangeQuerier - Use SSL True
2009-06-29 15:27:13,250 [6924] DEBUG
GCalExchangeLookup.ExchangeQuerier - Request URL
http://owa.domain.tld/GCalExchangeLookup/Exchangequerier.aspx
2009-06-29 15:27:13,250 [6924] DEBUG
GCalExchangeLookup.ExchangeQuerier - Referrer URL
2009-06-29 15:27:24,437 [6924] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyRequest - Request received
from GCal. [body=[1,1,[Us...@domain.tld],
20090620/20090708,20090629T152347,America/Los_Angeles]]
2009-06-29 15:27:24,437 [6924] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@domain.tld
2009-06-29 15:27:24,437 [6924] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Searching
Active Directory [Server=LDAP://owa.domain.tld,
User=gcaldom...@exchange.domain]
2009-06-29 15:27:24,437 [6924] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Issuing LDAP
query '(&(mail=Us...@exchange.domain)(|(objectcategory=user)
(objectcategory=contact)))'
2009-06-29 15:27:24,453 [6924] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Found 1 users
in Active Directory.
2009-06-29 15:27:24,453 [6924] INFO
Google.GCalExchangeSync.Library.ExchangeService - Found and added
'Us...@exchange.domain' as an ExchangeUser.
2009-06-29 15:27:24,453 [6924] DEBUG
Google.GCalExchangeSync.Library.ExchangeService - LDAP object debug
info: [ProxyAddresses=SMTP:Us...@exchange.domain,
sAMAccountName=User2, mailnickname=User2, mail=Us...@exchange.domain,
CN=Kevin O'Keefe, legacyExchangeDN=/o=Maxiscale WebMail/ou=First
Administrative Group/cn=Recipients/cn=User2, DN=CN=Kevin
O'Keefe,OU=UsersExchange,DC=webmail,DC=maxiscale,DC=com, objectClass=
[ top, person, organizationalPerson, user ]]
2009-06-29 15:27:24,453 [6924] DEBUG
Google.GCalExchangeSync.Library.WebDav.XmlRequestImpl - Issuing WebDAV
Request: GET to
http://owa.domain.tld/public/?cmd=freebusy&start=2009-06-20T07:00:00Z&end=2009-07-08T07:00:00Z&interval=15&u=Us...@exchange.domain
- Group Exchange
2009-06-29 15:27:24,468 [6924] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Parsing the raster
000000000000000000000000000000000000000000000000000000000000000000000000000000000022220000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000022000002200000000000000000000000000000000000000000000000000000000000000222200222222000000000000000022220000000000000000000000000000000000000000000000000000000000000000000000000000222222222222000000002222222222222222000000000000000000000000000000000000000000000000222222222222222222220000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000222222222222000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000001122000000000000000000000000000000000000000000000000000000000000000000000000222222222222222200002222222200002200000000000000000000000000000000000000000000000000000000000000000000222222000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000222222222222000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000002200000000000000000000000000000000000000000000000000000000000000222222222222111100000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000111122222200000000000000000000000000
2009-06-29 15:27:24,468 [6924] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Parsed the raster
into 19 busy and 3 tentative ranges
2009-06-29 15:27:24,468 [6924] INFO
Google.GCalExchangeSync.Library.Util.BlockTimer - [Timer] -
LookupFreeBusyTimes - Total Execution Time: 16 ms.
2009-06-29 15:27:24,468 [6924] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Merged 19 + 3 into
22 ranges
2009-06-29 15:27:24,468 [6924] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Compressed 19 + 3
into 19 ranges
2009-06-29 15:27:24,468 [6924] INFO
Google.GCalExchangeSync.Library.ExchangeService - Merge Result of 19 +
Appointment 0 -> 19
2009-06-29 15:27:24,468 [6924] INFO
Google.GCalExchangeSync.Library.Util.BlockTimer - [Timer] -
MergeFreeBusyWithAppointments - Total Execution Time: 0 ms.
2009-06-29 15:27:24,468 [6924] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@exchange.domain
2009-06-29 15:27:24,468 [6924] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - GCal Free/Busy
response successfully generated.
2009-06-29 15:27:24,468 [6924] DEBUG
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - Response =
['1','1',['_ME_AddData','20090620/20090708','20090629T152347',['Kevin
O'Keefe','Us...@domain.tld','20',
[['','20090620T203000','20090620T213000','','Kevin O\047Keefe',1],
['','20090623T151500','20090623T154500','','Kevin O\047Keefe',1],
['','20090623T170000','20090623T173000','','Kevin O\047Keefe',1],
['','20090624T090000','20090624T100000','','Kevin O\047Keefe',1],
['','20090624T103000','20090624T120000','','Kevin O\047Keefe',1],
['','20090624T160000','20090624T170000','','Kevin O\047Keefe',1],
['','20090625T120000','20090625T150000','','Kevin O\047Keefe',1],
['','20090625T170000','20090625T210000','','Kevin O\047Keefe',1],
['','20090626T090000','20090626T140000','','Kevin O\047Keefe',1],
['','20090627T180000','20090627T210000','','Kevin O\047Keefe',1],
['','20090629T140000','20090629T150000','','Kevin O\047Keefe',1],
['','20090630T090000','20090630T130000','','Kevin O\047Keefe',1],
['','20090630T140000','20090630T160000','','Kevin O\047Keefe',1],
['','20090630T170000','20090630T173000','','Kevin O\047Keefe',1],
['','20090701T103000','20090701T120000','','Kevin O\047Keefe',1],
['','20090703T090000','20090703T120000','','Kevin O\047Keefe',1],
['','20090705T170000','20090705T173000','','Kevin O\047Keefe',1],
['','20090706T090000','20090706T130000','','Kevin O\047Keefe',1],
['','20090707T150000','20090707T173000','','Kevin O\047Keefe',1]]]]]
2009-06-29 15:27:24,468 [6924] DEBUG
GCalExchangeLookup.ExchangeQuerier - Use SSL True
2009-06-29 15:27:24,468 [6924] DEBUG
GCalExchangeLookup.ExchangeQuerier - Request URL
http://owa.domain.tld/GCalExchangeLookup/Exchangequerier.aspx
2009-06-29 15:27:24,468 [6924] DEBUG
GCalExchangeLookup.ExchangeQuerier - Referrer URL
2009-06-29 15:27:31,687 [6924] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyRequest - Request received
from GCal. [body=[1,2,[Us...@domain.tld],
20090620/20090708,00001231T000000,America/Los_Angeles]]
2009-06-29 15:27:31,687 [6924] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@domain.tld
2009-06-29 15:27:31,687 [6924] WARN
Google.GCalExchangeSync.Library.GCalFreeBusyRequest - Ignoring
incorrect since request parameter 00001231T000000
Google.GCalExchangeSync.Library.GCalExchangeException: Date to parse
is not in proper GCal supplied format. [00001231T000000] --->
System.FormatException: String was not recognized as a valid DateTime.
at System.DateTimeParse.ParseExactMultiple(String s, String[]
formats, DateTimeFormatInfo dtfi, DateTimeStyles style)
at System.DateTime.ParseExact(String s, String[] formats,
IFormatProvider provider, DateTimeStyles style)
at Google.GCalExchangeSync.Library.Util.DateUtil.ParseGoogleDate
(String dateString)
--- End of inner exception stack trace ---
at Google.GCalExchangeSync.Library.Util.DateUtil.ParseGoogleDate
(String dateString)
at Google.GCalExchangeSync.Library.GCalFreeBusyRequest.Parse(String
rawInput)
2009-06-29 15:27:31,687 [6924] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Searching
Active Directory [Server=LDAP://owa.domain.tld,
User=gcaldom...@exchange.domain]
2009-06-29 15:27:31,687 [6924] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Issuing LDAP
query '(&(mail=Us...@exchange.domain)(|(objectcategory=user)
(objectcategory=contact)))'
2009-06-29 15:27:31,687 [6924] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Found 1 users
in Active Directory.
2009-06-29 15:27:31,687 [6924] INFO
Google.GCalExchangeSync.Library.ExchangeService - Found and added
'Us...@exchange.domain' as an ExchangeUser.
2009-06-29 15:27:31,687 [6924] DEBUG
Google.GCalExchangeSync.Library.ExchangeService - LDAP object debug
info: [ProxyAddresses=SMTP:Us...@exchange.domain,
sAMAccountName=User1, mailnickname=User1, mail=Us...@exchange.domain,
CN=Gianluca Rattazzi, legacyExchangeDN=/o=Maxiscale WebMail/ou=First
Administrative Group/cn=Recipients/cn=User1, DN=CN=Gianluca
Rattazzi,OU=UsersExchange,DC=webmail,DC=maxiscale,DC=com, objectClass=
[ top, person, organizationalPerson, user ]]
2009-06-29 15:27:31,687 [6924] DEBUG
Google.GCalExchangeSync.Library.WebDav.XmlRequestImpl - Issuing WebDAV
Request: GET to
http://owa.domain.tld/public/?cmd=freebusy&start=2009-06-20T07:00:00Z&end=2009-07-08T07:00:00Z&interval=15&u=Us...@exchange.domain
- Group Exchange
2009-06-29 15:27:31,703 [6924] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Parsing the raster
000000000000000000000000000000000000000000000022220000000000000000000000000000000000000000000000222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222000000000000000000000000000000000000000022000000000000111100000000002222000000000222200000000000000000000000000000000000000000000000220000002200222222000000000000002200000022000000000000000000000000000000000000000000000000000000222200000022222200000000222200000000000000000000000000000000000000000000000000000000000000000000000000000000222222222222000000000022000022220000000000000000000000000000000000000000000000220000222222222222000022220022222222000000000000222222220000000000000000000000000000000000000000000000000000000000000000000000000000000000000000002222222200000000000000000000000000000000000000000000000000000000000000000000000000002200000000000000000000000000000000000000000000000000000000000000220000000000000000000000000022220000000000220000000000000000222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222000000000000000000000000000000000000000000002222000022222200000000000000000000000000000000000000000000000000000000000000000000000000222200000000222222000000000000000000000000000000000000000000222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222000000000000000000000000000000000000000022000000000022222222000000000000000000000000000000000000000000000000000000000000000000000000222222222222000000002222000000002200000000000000000000000000000000000000000000000000000000002222000000000000000022222222000000002200000000000000000000000000
2009-06-29 15:27:31,703 [6924] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Parsed the raster
into 40 busy and 1 tentative ranges
2009-06-29 15:27:31,703 [6924] INFO
Google.GCalExchangeSync.Library.Util.BlockTimer - [Timer] -
LookupFreeBusyTimes - Total Execution Time: 16 ms.
2009-06-29 15:27:31,703 [6924] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Merged 40 + 1 into
41 ranges
2009-06-29 15:27:31,703 [6924] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Compressed 40 + 1
into 41 ranges
2009-06-29 15:27:31,703 [6924] INFO
Google.GCalExchangeSync.Library.ExchangeService - Merge Result of 41 +
Appointment 0 -> 41
2009-06-29 15:27:31,703 [6924] INFO
Google.GCalExchangeSync.Library.Util.BlockTimer - [Timer] -
MergeFreeBusyWithAppointments - Total Execution Time: 0 ms.
2009-06-29 15:27:31,703 [6924] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@exchange.domain
2009-06-29 15:27:31,703 [6924] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - GCal Free/Busy
response successfully generated.
2009-06-29 15:27:31,703 [6924] DEBUG
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - Response =
['1','2',['_ME_AddData','20090620/20090708','00010101T000000',
['Gianluca Rattazzi','Us...@domain.tld','20',
[['','20090620T113000','20090620T123000','','Gianluca Rattazzi',1],
['','20090621T000000','20090622T000000','','Gianluca Rattazzi',1],
['','20090622T100000','20090622T103000','','Gianluca Rattazzi',1],
['','20090622T133000','20090622T143000','','Gianluca Rattazzi',1],
['','20090622T170000','20090622T180000','','Gianluca Rattazzi',1],
['','20090622T201500','20090622T211500','','Gianluca Rattazzi',1],
['','20090623T090000','20090623T093000','','Gianluca Rattazzi',1],
['','20090623T110000','20090623T113000','','Gianluca Rattazzi',1],
['','20090623T120000','20090623T133000','','Gianluca Rattazzi',1],
['','20090623T170000','20090623T173000','','Gianluca Rattazzi',1],
['','20090623T190000','20090623T193000','','Gianluca Rattazzi',1],
['','20090624T090000','20090624T100000','','Gianluca Rattazzi',1],
['','20090624T113000','20090624T130000','','Gianluca Rattazzi',1],
['','20090624T150000','20090624T160000','','Gianluca Rattazzi',1],
['','20090625T120000','20090625T150000','','Gianluca Rattazzi',1],
['','20090625T173000','20090625T180000','','Gianluca Rattazzi',1],
['','20090625T190000','20090625T200000','','Gianluca Rattazzi',1],
['','20090626T073000','20090626T080000','','Gianluca Rattazzi',1],
['','20090626T090000','20090626T120000','','Gianluca Rattazzi',1],
['','20090626T130000','20090626T140000','','Gianluca Rattazzi',1],
['','20090626T143000','20090626T163000','','Gianluca Rattazzi',1],
['','20090626T193000','20090626T213000','','Gianluca Rattazzi',1],
['','20090627T200000','20090627T220000','','Gianluca Rattazzi',1],
['','20090628T170000','20090628T173000','','Gianluca Rattazzi',1],
['','20090629T090000','20090629T093000','','Gianluca Rattazzi',1],
['','20090629T160000','20090629T170000','','Gianluca Rattazzi',1],
['','20090629T193000','20090629T200000','','Gianluca Rattazzi',1],
['','20090630T000000','20090701T000000','','Gianluca Rattazzi',1],
['','20090701T110000','20090701T120000','','Gianluca Rattazzi',1],
['','20090701T130000','20090701T143000','','Gianluca Rattazzi',1],
['','20090702T090000','20090702T100000','','Gianluca Rattazzi',1],
['','20090702T120000','20090702T133000','','Gianluca Rattazzi',1],
['','20090703T000000','20090705T000000','','Gianluca Rattazzi',1],
['','20090705T100000','20090705T103000','','Gianluca Rattazzi',1],
['','20090705T130000','20090705T150000','','Gianluca Rattazzi',1],
['','20090706T090000','20090706T120000','','Gianluca Rattazzi',1],
['','20090706T140000','20090706T150000','','Gianluca Rattazzi',1],
['','20090706T170000','20090706T173000','','Gianluca Rattazzi',1],
['','20090707T080000','20090707T090000','','Gianluca Rattazzi',1],
['','20090707T130000','20090707T150000','','Gianluca Rattazzi',1],
['','20090707T170000','20090707T173000','','Gianluca Rattazzi',1]]]]]
2009-06-29 15:27:31,703 [6924] DEBUG
GCalExchangeLookup.ExchangeQuerier - Use SSL True
2009-06-29 15:27:31,703 [6924] DEBUG
GCalExchangeLookup.ExchangeQuerier - Request URL
http://owa.domain.tld/GCalExchangeLookup/Exchangequerier.aspx
2009-06-29 15:27:31,703 [6924] DEBUG
GCalExchangeLookup.ExchangeQuerier - Referrer URL
2009-06-29 15:28:10,500 [6924] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyRequest - Request received
from GCal. [body=[1,0,[Us...@domain.tld],
20090620/20090708,20090629T152444,America/Los_Angeles]]
2009-06-29 15:28:10,500 [6924] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@domain.tld
2009-06-29 15:28:10,500 [6924] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Searching
Active Directory [Server=LDAP://owa.domain.tld,
User=gcaldom...@exchange.domain]
2009-06-29 15:28:10,500 [6924] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Issuing LDAP
query '(&(mail=Us...@exchange.domain)(|(objectcategory=user)
(objectcategory=contact)))'
2009-06-29 15:28:10,500 [6924] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Found 0 users
in Active Directory.
2009-06-29 15:28:10,500 [6924] INFO
Google.GCalExchangeSync.Library.ExchangeService - Unable to find
Active Directory user where 'mail'='Us...@exchange.domain'.
2009-06-29 15:28:10,500 [6924] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - GCal Free/Busy
response successfully generated.
2009-06-29 15:28:10,500 [6924] DEBUG
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - Response =
['1','0',['_ME_AddData','20090620/20090708','20090629T152444',[]]]
2009-06-29 15:28:10,500 [6924] DEBUG
GCalExchangeLookup.ExchangeQuerier - Use SSL True
2009-06-29 15:28:10,500 [6924] DEBUG
GCalExchangeLookup.ExchangeQuerier - Request URL
http://owa.domain.tld/GCalExchangeLookup/Exchangequerier.aspx
2009-06-29 15:28:10,500 [6924] DEBUG
GCalExchangeLookup.ExchangeQuerier - Referrer URL
2009-06-29 15:28:17,203 [6924] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyRequest - Request received
from GCal. [body=[1,1,[Us...@domain.tld],
20090620/20090708,20090629T152445,America/Los_Angeles]]
2009-06-29 15:28:17,203 [6924] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@domain.tld
2009-06-29 15:28:17,203 [6924] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Searching
Active Directory [Server=LDAP://owa.domain.tld,
User=gcaldom...@exchange.domain]
2009-06-29 15:28:17,203 [6924] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Issuing LDAP
query '(&(mail=Us...@exchange.domain)(|(objectcategory=user)
(objectcategory=contact)))'
2009-06-29 15:28:17,203 [6924] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Found 1 users
in Active Directory.
2009-06-29 15:28:17,203 [6924] INFO
Google.GCalExchangeSync.Library.ExchangeService - Found and added
'Us...@exchange.domain' as an ExchangeUser.
2009-06-29 15:28:17,203 [6924] DEBUG
Google.GCalExchangeSync.Library.ExchangeService - LDAP object debug
info: [ProxyAddresses=SMTP:Us...@exchange.domain,
sAMAccountName=User2, mailnickname=User2, mail=Us...@exchange.domain,
CN=Kevin O'Keefe, legacyExchangeDN=/o=Maxiscale WebMail/ou=First
Administrative Group/cn=Recipients/cn=User2, DN=CN=Kevin
O'Keefe,OU=UsersExchange,DC=webmail,DC=maxiscale,DC=com, objectClass=
[ top, person, organizationalPerson, user ]]
2009-06-29 15:28:17,203 [6924] DEBUG
Google.GCalExchangeSync.Library.WebDav.XmlRequestImpl - Issuing WebDAV
Request: GET to
http://owa.domain.tld/public/?cmd=freebusy&start=2009-06-20T07:00:00Z&end=2009-07-08T07:00:00Z&interval=15&u=Us...@exchange.domain
- Group Exchange
2009-06-29 15:28:17,203 [6924] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Parsing the raster
000000000000000000000000000000000000000000000000000000000000000000000000000000000022220000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000022000002200000000000000000000000000000000000000000000000000000000000000222200222222000000000000000022220000000000000000000000000000000000000000000000000000000000000000000000000000222222222222000000002222222222222222000000000000000000000000000000000000000000000000222222222222222222220000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000222222222222000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000001122000000000000000000000000000000000000000000000000000000000000000000000000222222222222222200002222222200002200000000000000000000000000000000000000000000000000000000000000000000222222000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000222222222222000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000002200000000000000000000000000000000000000000000000000000000000000222222222222111100000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000111122222200000000000000000000000000
2009-06-29 15:28:17,203 [6924] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Parsed the raster
into 19 busy and 3 tentative ranges
2009-06-29 15:28:17,203 [6924] INFO
Google.GCalExchangeSync.Library.Util.BlockTimer - [Timer] -
LookupFreeBusyTimes - Total Execution Time: 0 ms.
2009-06-29 15:28:17,203 [6924] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Merged 19 + 3 into
22 ranges
2009-06-29 15:28:17,203 [6924] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Compressed 19 + 3
into 19 ranges
2009-06-29 15:28:17,203 [6924] INFO
Google.GCalExchangeSync.Library.ExchangeService - Merge Result of 19 +
Appointment 0 -> 19
2009-06-29 15:28:17,203 [6924] INFO
Google.GCalExchangeSync.Library.Util.BlockTimer - [Timer] -
MergeFreeBusyWithAppointments - Total Execution Time: 0 ms.
2009-06-29 15:28:17,203 [6924] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@exchange.domain
2009-06-29 15:28:17,203 [6924] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - GCal Free/Busy
response successfully generated.
2009-06-29 15:28:17,203 [6924] DEBUG
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - Response =
['1','1',['_ME_AddData','20090620/20090708','20090629T152445',['Kevin
O'Keefe','Us...@domain.tld','20',
[['','20090620T203000','20090620T213000','','Kevin O\047Keefe',1],
['','20090623T151500','20090623T154500','','Kevin O\047Keefe',1],
['','20090623T170000','20090623T173000','','Kevin O\047Keefe',1],
['','20090624T090000','20090624T100000','','Kevin O\047Keefe',1],
['','20090624T103000','20090624T120000','','Kevin O\047Keefe',1],
['','20090624T160000','20090624T170000','','Kevin O\047Keefe',1],
['','20090625T120000','20090625T150000','','Kevin O\047Keefe',1],
['','20090625T170000','20090625T210000','','Kevin O\047Keefe',1],
['','20090626T090000','20090626T140000','','Kevin O\047Keefe',1],
['','20090627T180000','20090627T210000','','Kevin O\047Keefe',1],
['','20090629T140000','20090629T150000','','Kevin O\047Keefe',1],
['','20090630T090000','20090630T130000','','Kevin O\047Keefe',1],
['','20090630T140000','20090630T160000','','Kevin O\047Keefe',1],
['','20090630T170000','20090630T173000','','Kevin O\047Keefe',1],
['','20090701T103000','20090701T120000','','Kevin O\047Keefe',1],
['','20090703T090000','20090703T120000','','Kevin O\047Keefe',1],
['','20090705T170000','20090705T173000','','Kevin O\047Keefe',1],
['','20090706T090000','20090706T130000','','Kevin O\047Keefe',1],
['','20090707T150000','20090707T173000','','Kevin O\047Keefe',1]]]]]
2009-06-29 15:28:17,203 [6924] DEBUG
GCalExchangeLookup.ExchangeQuerier - Use SSL True
2009-06-29 15:28:17,203 [6924] DEBUG
GCalExchangeLookup.ExchangeQuerier - Request URL
http://owa.domain.tld/GCalExchangeLookup/Exchangequerier.aspx
2009-06-29 15:28:17,203 [6924] DEBUG
GCalExchangeLookup.ExchangeQuerier - Referrer URL
2009-06-29 16:07:33,484 [8200] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyRequest - Request received
from GCal. [body=[1,1,[Us...@domain.tld],
20090620/20090708,20090629T160344,America/Los_Angeles]]
2009-06-29 16:07:33,500 [8200] INFO
Google.GCalExchangeSync.Library.ConfigCache - Added Domain Map.
domain.tld <-> exchange.domain
2009-06-29 16:07:33,500 [8200] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@domain.tld
2009-06-29 16:07:33,593 [8200] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Searching
Active Directory [Server=LDAP://owa.domain.tld,
User=gcaldom...@exchange.domain]
2009-06-29 16:07:33,609 [8200] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Issuing LDAP
query '(&(mail=Us...@exchange.domain)(|(objectcategory=user)
(objectcategory=contact)))'
2009-06-29 16:07:33,687 [8200] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Found 1 users
in Active Directory.
2009-06-29 16:07:33,703 [8200] INFO
Google.GCalExchangeSync.Library.ExchangeService - Found and added
'Us...@exchange.domain' as an ExchangeUser.
2009-06-29 16:07:33,703 [8200] DEBUG
Google.GCalExchangeSync.Library.ExchangeService - LDAP object debug
info: [ProxyAddresses=SMTP:Us...@exchange.domain,
sAMAccountName=User2, mailnickname=User2, mail=Us...@exchange.domain,
CN=Kevin O'Keefe, legacyExchangeDN=/o=Maxiscale WebMail/ou=First
Administrative Group/cn=Recipients/cn=User2, DN=CN=Kevin
O'Keefe,OU=UsersExchange,DC=webmail,DC=maxiscale,DC=com, objectClass=
[ top, person, organizationalPerson, user ]]
2009-06-29 16:07:33,703 [8200] DEBUG
Google.GCalExchangeSync.Library.WebDav.XmlRequestImpl - Issuing WebDAV
Request: GET to
http://owa.domain.tld/public/?cmd=freebusy&start=2009-06-20T07:00:00Z&end=2009-07-08T07:00:00Z&interval=15&u=Us...@exchange.domain
- Group Exchange
2009-06-29 16:07:33,750 [8200] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Parsing the raster
000000000000000000000000000000000000000000000000000000000000000000000000000000000022220000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000022000002200000000000000000000000000000000000000000000000000000000000000222200222222000000000000000022220000000000000000000000000000000000000000000000000000000000000000000000000000222222222222000000002222222222222222000000000000000000000000000000000000000000000000222222222222222222220000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000222222222222000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000001122000000000000000000000000000000000000000000000000000000000000000000000000222222222222222200002222222200002200000000000000000000000000000000000000000000000000000000000000000000222222000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000222222222222000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000002200000000000000000000000000000000000000000000000000000000000000222222222222111100000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000111122222200000000000000000000000000
2009-06-29 16:07:33,750 [8200] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Parsed the raster
into 19 busy and 3 tentative ranges
2009-06-29 16:07:33,750 [8200] INFO
Google.GCalExchangeSync.Library.Util.BlockTimer - [Timer] -
LookupFreeBusyTimes - Total Execution Time: 47 ms.
2009-06-29 16:07:33,765 [8200] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Merged 19 + 3 into
22 ranges
2009-06-29 16:07:33,765 [8200] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Compressed 19 + 3
into 19 ranges
2009-06-29 16:07:33,781 [8200] INFO
Google.GCalExchangeSync.Library.ExchangeService - Merge Result of 19 +
Appointment 0 -> 19
2009-06-29 16:07:33,781 [8200] INFO
Google.GCalExchangeSync.Library.Util.BlockTimer - [Timer] -
MergeFreeBusyWithAppointments - Total Execution Time: 16 ms.
2009-06-29 16:07:33,781 [8200] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@exchange.domain
2009-06-29 16:07:33,781 [8200] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - GCal Free/Busy
response successfully generated.
2009-06-29 16:07:33,781 [8200] DEBUG
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - Response =
['1','1',['_ME_AddData','20090620/20090708','20090629T160344',['Kevin
O'Keefe','Us...@domain.tld','20',
[['','20090620T203000','20090620T213000','','Kevin O\047Keefe',1],
['','20090623T151500','20090623T154500','','Kevin O\047Keefe',1],
['','20090623T170000','20090623T173000','','Kevin O\047Keefe',1],
['','20090624T090000','20090624T100000','','Kevin O\047Keefe',1],
['','20090624T103000','20090624T120000','','Kevin O\047Keefe',1],
['','20090624T160000','20090624T170000','','Kevin O\047Keefe',1],
['','20090625T120000','20090625T150000','','Kevin O\047Keefe',1],
['','20090625T170000','20090625T210000','','Kevin O\047Keefe',1],
['','20090626T090000','20090626T140000','','Kevin O\047Keefe',1],
['','20090627T180000','20090627T210000','','Kevin O\047Keefe',1],
['','20090629T140000','20090629T150000','','Kevin O\047Keefe',1],
['','20090630T090000','20090630T130000','','Kevin O\047Keefe',1],
['','20090630T140000','20090630T160000','','Kevin O\047Keefe',1],
['','20090630T170000','20090630T173000','','Kevin O\047Keefe',1],
['','20090701T103000','20090701T120000','','Kevin O\047Keefe',1],
['','20090703T090000','20090703T120000','','Kevin O\047Keefe',1],
['','20090705T170000','20090705T173000','','Kevin O\047Keefe',1],
['','20090706T090000','20090706T130000','','Kevin O\047Keefe',1],
['','20090707T150000','20090707T173000','','Kevin O\047Keefe',1]]]]]
2009-06-29 16:07:33,859 [8200] DEBUG
GCalExchangeLookup.ExchangeQuerier - Use SSL True
2009-06-29 16:07:33,859 [8200] DEBUG
GCalExchangeLookup.ExchangeQuerier - Request URL
http://owa.domain.tld/GCalExchangeLookup/Exchangequerier.aspx
2009-06-29 16:07:33,859 [8200] DEBUG
GCalExchangeLookup.ExchangeQuerier - Referrer URL
2009-06-29 16:08:16,687 [8200] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyRequest - Request received
from GCal. [body=[1,0,[Us...@domain.tld],
20090620/20090708,20090629T160450,America/Los_Angeles]]
2009-06-29 16:08:16,687 [8200] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@domain.tld
2009-06-29 16:08:16,687 [8200] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Searching
Active Directory [Server=LDAP://owa.domain.tld,
User=gcaldom...@exchange.domain]
2009-06-29 16:08:16,687 [8200] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Issuing LDAP
query '(&(mail=Us...@exchange.domain)(|(objectcategory=user)
(objectcategory=contact)))'
2009-06-29 16:08:16,703 [8200] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Found 0 users
in Active Directory.
2009-06-29 16:08:16,703 [8200] INFO
Google.GCalExchangeSync.Library.ExchangeService - Unable to find
Active Directory user where 'mail'='Us...@exchange.domain'.
2009-06-29 16:08:16,703 [8200] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - GCal Free/Busy
response successfully generated.
2009-06-29 16:08:16,703 [8200] DEBUG
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - Response =
['1','0',['_ME_AddData','20090620/20090708','20090629T160450',[]]]
2009-06-29 16:08:16,703 [8200] DEBUG
GCalExchangeLookup.ExchangeQuerier - Use SSL True
2009-06-29 16:08:16,703 [8200] DEBUG
GCalExchangeLookup.ExchangeQuerier - Request URL
http://owa.domain.tld/GCalExchangeLookup/Exchangequerier.aspx
2009-06-29 16:08:16,703 [8200] DEBUG
GCalExchangeLookup.ExchangeQuerier - Referrer URL
2009-06-29 16:08:24,875 [8200] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyRequest - Request received
from GCal. [body=[1,1,[Us...@domain.tld],
20090620/20090708,20090629T160453,America/Los_Angeles]]
2009-06-29 16:08:24,875 [8200] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@domain.tld
2009-06-29 16:08:24,875 [8200] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Searching
Active Directory [Server=LDAP://owa.domain.tld,
User=gcaldom...@exchange.domain]
2009-06-29 16:08:24,875 [8200] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Issuing LDAP
query '(&(mail=Us...@exchange.domain)(|(objectcategory=user)
(objectcategory=contact)))'
2009-06-29 16:08:24,890 [8200] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Found 1 users
in Active Directory.
2009-06-29 16:08:24,890 [8200] INFO
Google.GCalExchangeSync.Library.ExchangeService - Found and added
'Us...@exchange.domain' as an ExchangeUser.
2009-06-29 16:08:24,890 [8200] DEBUG
Google.GCalExchangeSync.Library.ExchangeService - LDAP object debug
info: [ProxyAddresses=SMTP:Us...@exchange.domain,
sAMAccountName=User1, mailnickname=User1, mail=Us...@exchange.domain,
CN=Gianluca Rattazzi, legacyExchangeDN=/o=Maxiscale WebMail/ou=First
Administrative Group/cn=Recipients/cn=User1, DN=CN=Gianluca
Rattazzi,OU=UsersExchange,DC=webmail,DC=maxiscale,DC=com, objectClass=
[ top, person, organizationalPerson, user ]]
2009-06-29 16:08:24,890 [8200] DEBUG
Google.GCalExchangeSync.Library.WebDav.XmlRequestImpl - Issuing WebDAV
Request: GET to
http://owa.domain.tld/public/?cmd=freebusy&start=2009-06-20T07:00:00Z&end=2009-07-08T07:00:00Z&interval=15&u=Us...@exchange.domain
- Group Exchange
2009-06-29 16:08:24,890 [8200] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Parsing the raster
000000000000000000000000000000000000000000000022220000000000000000000000000000000000000000000000222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222000000000000000000000000000000000000000022000000000000111100000000002222000000000222200000000000000000000000000000000000000000000000220000002200222222000000000000002200000022000000000000000000000000000000000000000000000000000000222200000022222200000000222200000000000000000000000000000000000000000000000000000000000000000000000000000000222222222222000000000022000022220000000000000000000000000000000000000000000000220000222222222222000022220022222222000000000000222222220000000000000000000000000000000000000000000000000000000000000000000000000000000000000000002222222200000000000000000000000000000000000000000000000000000000000000000000000000002200000000000000000000000000000000000000000000000000000000000000220000000000000000000000000000002222000000220000000000000000222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222000000000000000000000000000000000000000000002222000022222200000000000000000000000000000000000000000000000000000000000000000000000000222200000000222222000000000000000000000000000000000000000000222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222000000000000000000000000000000000000000022000000000022222222000000000000000000000000000000000000000000000000000000000000000000000000222222222222000000002222000000002200000000000000000000000000000000000000000000000000000000002222000000000000000022222222000000002200000000000000000000000000
2009-06-29 16:08:24,890 [8200] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Parsed the raster
into 40 busy and 1 tentative ranges
2009-06-29 16:08:24,890 [8200] INFO
Google.GCalExchangeSync.Library.Util.BlockTimer - [Timer] -
LookupFreeBusyTimes - Total Execution Time: 0 ms.
2009-06-29 16:08:24,890 [8200] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Merged 40 + 1 into
41 ranges
2009-06-29 16:08:24,890 [8200] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Compressed 40 + 1
into 41 ranges
2009-06-29 16:08:24,890 [8200] INFO
Google.GCalExchangeSync.Library.ExchangeService - Merge Result of 41 +
Appointment 0 -> 41
2009-06-29 16:08:24,890 [8200] INFO
Google.GCalExchangeSync.Library.Util.BlockTimer - [Timer] -
MergeFreeBusyWithAppointments - Total Execution Time: 0 ms.
2009-06-29 16:08:24,890 [8200] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@exchange.domain
2009-06-29 16:08:24,890 [8200] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - GCal Free/Busy
response successfully generated.
2009-06-29 16:08:24,890 [8200] DEBUG
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - Response =
['1','1',['_ME_AddData','20090620/20090708','20090629T160453',
['Gianluca Rattazzi','Us...@domain.tld','20',
[['','20090620T113000','20090620T123000','','Gianluca Rattazzi',1],
['','20090621T000000','20090622T000000','','Gianluca Rattazzi',1],
['','20090622T100000','20090622T103000','','Gianluca Rattazzi',1],
['','20090622T133000','20090622T143000','','Gianluca Rattazzi',1],
['','20090622T170000','20090622T180000','','Gianluca Rattazzi',1],
['','20090622T201500','20090622T211500','','Gianluca Rattazzi',1],
['','20090623T090000','20090623T093000','','Gianluca Rattazzi',1],
['','20090623T110000','20090623T113000','','Gianluca Rattazzi',1],
['','20090623T120000','20090623T133000','','Gianluca Rattazzi',1],
['','20090623T170000','20090623T173000','','Gianluca Rattazzi',1],
['','20090623T190000','20090623T193000','','Gianluca Rattazzi',1],
['','20090624T090000','20090624T100000','','Gianluca Rattazzi',1],
['','20090624T113000','20090624T130000','','Gianluca Rattazzi',1],
['','20090624T150000','20090624T160000','','Gianluca Rattazzi',1],
['','20090625T120000','20090625T150000','','Gianluca Rattazzi',1],
['','20090625T173000','20090625T180000','','Gianluca Rattazzi',1],
['','20090625T190000','20090625T200000','','Gianluca Rattazzi',1],
['','20090626T073000','20090626T080000','','Gianluca Rattazzi',1],
['','20090626T090000','20090626T120000','','Gianluca Rattazzi',1],
['','20090626T130000','20090626T140000','','Gianluca Rattazzi',1],
['','20090626T143000','20090626T163000','','Gianluca Rattazzi',1],
['','20090626T193000','20090626T213000','','Gianluca Rattazzi',1],
['','20090627T200000','20090627T220000','','Gianluca Rattazzi',1],
['','20090628T170000','20090628T173000','','Gianluca Rattazzi',1],
['','20090629T090000','20090629T093000','','Gianluca Rattazzi',1],
['','20090629T170000','20090629T180000','','Gianluca Rattazzi',1],
['','20090629T193000','20090629T200000','','Gianluca Rattazzi',1],
['','20090630T000000','20090701T000000','','Gianluca Rattazzi',1],
['','20090701T110000','20090701T120000','','Gianluca Rattazzi',1],
['','20090701T130000','20090701T143000','','Gianluca Rattazzi',1],
['','20090702T090000','20090702T100000','','Gianluca Rattazzi',1],
['','20090702T120000','20090702T133000','','Gianluca Rattazzi',1],
['','20090703T000000','20090705T000000','','Gianluca Rattazzi',1],
['','20090705T100000','20090705T103000','','Gianluca Rattazzi',1],
['','20090705T130000','20090705T150000','','Gianluca Rattazzi',1],
['','20090706T090000','20090706T120000','','Gianluca Rattazzi',1],
['','20090706T140000','20090706T150000','','Gianluca Rattazzi',1],
['','20090706T170000','20090706T173000','','Gianluca Rattazzi',1],
['','20090707T080000','20090707T090000','','Gianluca Rattazzi',1],
['','20090707T130000','20090707T150000','','Gianluca Rattazzi',1],
['','20090707T170000','20090707T173000','','Gianluca Rattazzi',1]]]]]
2009-06-29 16:08:24,890 [8200] DEBUG
GCalExchangeLookup.ExchangeQuerier - Use SSL True
2009-06-29 16:08:24,890 [8200] DEBUG
GCalExchangeLookup.ExchangeQuerier - Request URL
http://owa.domain.tld/GCalExchangeLookup/Exchangequerier.aspx
2009-06-29 16:08:24,890 [8200] DEBUG
GCalExchangeLookup.ExchangeQuerier - Referrer URL
2009-06-29 16:10:05,437 [5744] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyRequest - Request received
from GCal. [body=[1,1,[Us...@domain.tld],
20090620/20090708,20090629T160633,America/Los_Angeles]]
2009-06-29 16:10:05,437 [5744] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@domain.tld
2009-06-29 16:10:05,437 [5744] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Searching
Active Directory [Server=LDAP://owa.domain.tld,
User=gcaldom...@exchange.domain]
2009-06-29 16:10:05,437 [5744] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Issuing LDAP
query '(&(mail=Us...@exchange.domain)(|(objectcategory=user)
(objectcategory=contact)))'
2009-06-29 16:10:05,437 [5744] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Found 1 users
in Active Directory.
2009-06-29 16:10:05,437 [5744] INFO
Google.GCalExchangeSync.Library.ExchangeService - Found and added
'Us...@exchange.domain' as an ExchangeUser.
2009-06-29 16:10:05,437 [5744] DEBUG
Google.GCalExchangeSync.Library.ExchangeService - LDAP object debug
info: [ProxyAddresses=SMTP:Us...@exchange.domain,
sAMAccountName=User1, mailnickname=User1, mail=Us...@exchange.domain,
CN=Gianluca Rattazzi, legacyExchangeDN=/o=Maxiscale WebMail/ou=First
Administrative Group/cn=Recipients/cn=User1, DN=CN=Gianluca
Rattazzi,OU=UsersExchange,DC=webmail,DC=maxiscale,DC=com, objectClass=
[ top, person, organizationalPerson, user ]]
2009-06-29 16:10:05,437 [5744] DEBUG
Google.GCalExchangeSync.Library.WebDav.XmlRequestImpl - Issuing WebDAV
Request: GET to
http://owa.domain.tld/public/?cmd=freebusy&start=2009-06-20T07:00:00Z&end=2009-07-08T07:00:00Z&interval=15&u=Us...@exchange.domain
- Group Exchange
2009-06-29 16:10:05,437 [5744] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Parsing the raster
000000000000000000000000000000000000000000000022220000000000000000000000000000000000000000000000222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222000000000000000000000000000000000000000022000000000000111100000000002222000000000222200000000000000000000000000000000000000000000000220000002200222222000000000000002200000022000000000000000000000000000000000000000000000000000000222200000022222200000000222200000000000000000000000000000000000000000000000000000000000000000000000000000000222222222222000000000022000022220000000000000000000000000000000000000000000000220000222222222222000022220022222222000000000000222222220000000000000000000000000000000000000000000000000000000000000000000000000000000000000000002222222200000000000000000000000000000000000000000000000000000000000000000000000000002200000000000000000000000000000000000000000000000000000000000000220000000000000000000000000000002222000000220000000000000000222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222000000000000000000000000000000000000000000002222000022222200000000000000000000000000000000000000000000000000000000000000000000000000222200000000222222000000000000000000000000000000000000000000222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222000000000000000000000000000000000000000022000000000022222222000000000000000000000000000000000000000000000000000000000000000000000000222222222222000000002222000000002200000000000000000000000000000000000000000000000000000000002222000000000000000022222222000000002200000000000000000000000000
2009-06-29 16:10:05,437 [5744] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Parsed the raster
into 40 busy and 1 tentative ranges
2009-06-29 16:10:05,437 [5744] INFO
Google.GCalExchangeSync.Library.Util.BlockTimer - [Timer] -
LookupFreeBusyTimes - Total Execution Time: 0 ms.
2009-06-29 16:10:05,437 [5744] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Merged 40 + 1 into
41 ranges
2009-06-29 16:10:05,437 [5744] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Compressed 40 + 1
into 41 ranges
2009-06-29 16:10:05,437 [5744] INFO
Google.GCalExchangeSync.Library.ExchangeService - Merge Result of 41 +
Appointment 0 -> 41
2009-06-29 16:10:05,437 [5744] INFO
Google.GCalExchangeSync.Library.Util.BlockTimer - [Timer] -
MergeFreeBusyWithAppointments - Total Execution Time: 0 ms.
2009-06-29 16:10:05,437 [5744] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@exchange.domain
2009-06-29 16:10:05,453 [5744] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - GCal Free/Busy
response successfully generated.
2009-06-29 16:10:05,453 [5744] DEBUG
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - Response =
['1','1',['_ME_AddData','20090620/20090708','20090629T160633',
['Gianluca Rattazzi','Us...@domain.tld','20',
[['','20090620T113000','20090620T123000','','Gianluca Rattazzi',1],
['','20090621T000000','20090622T000000','','Gianluca Rattazzi',1],
['','20090622T100000','20090622T103000','','Gianluca Rattazzi',1],
['','20090622T133000','20090622T143000','','Gianluca Rattazzi',1],
['','20090622T170000','20090622T180000','','Gianluca Rattazzi',1],
['','20090622T201500','20090622T211500','','Gianluca Rattazzi',1],
['','20090623T090000','20090623T093000','','Gianluca Rattazzi',1],
['','20090623T110000','20090623T113000','','Gianluca Rattazzi',1],
['','20090623T120000','20090623T133000','','Gianluca Rattazzi',1],
['','20090623T170000','20090623T173000','','Gianluca Rattazzi',1],
['','20090623T190000','20090623T193000','','Gianluca Rattazzi',1],
['','20090624T090000','20090624T100000','','Gianluca Rattazzi',1],
['','20090624T113000','20090624T130000','','Gianluca Rattazzi',1],
['','20090624T150000','20090624T160000','','Gianluca Rattazzi',1],
['','20090625T120000','20090625T150000','','Gianluca Rattazzi',1],
['','20090625T173000','20090625T180000','','Gianluca Rattazzi',1],
['','20090625T190000','20090625T200000','','Gianluca Rattazzi',1],
['','20090626T073000','20090626T080000','','Gianluca Rattazzi',1],
['','20090626T090000','20090626T120000','','Gianluca Rattazzi',1],
['','20090626T130000','20090626T140000','','Gianluca Rattazzi',1],
['','20090626T143000','20090626T163000','','Gianluca Rattazzi',1],
['','20090626T193000','20090626T213000','','Gianluca Rattazzi',1],
['','20090627T200000','20090627T220000','','Gianluca Rattazzi',1],
['','20090628T170000','20090628T173000','','Gianluca Rattazzi',1],
['','20090629T090000','20090629T093000','','Gianluca Rattazzi',1],
['','20090629T170000','20090629T180000','','Gianluca Rattazzi',1],
['','20090629T193000','20090629T200000','','Gianluca Rattazzi',1],
['','20090630T000000','20090701T000000','','Gianluca Rattazzi',1],
['','20090701T110000','20090701T120000','','Gianluca Rattazzi',1],
['','20090701T130000','20090701T143000','','Gianluca Rattazzi',1],
['','20090702T090000','20090702T100000','','Gianluca Rattazzi',1],
['','20090702T120000','20090702T133000','','Gianluca Rattazzi',1],
['','20090703T000000','20090705T000000','','Gianluca Rattazzi',1],
['','20090705T100000','20090705T103000','','Gianluca Rattazzi',1],
['','20090705T130000','20090705T150000','','Gianluca Rattazzi',1],
['','20090706T090000','20090706T120000','','Gianluca Rattazzi',1],
['','20090706T140000','20090706T150000','','Gianluca Rattazzi',1],
['','20090706T170000','20090706T173000','','Gianluca Rattazzi',1],
['','20090707T080000','20090707T090000','','Gianluca Rattazzi',1],
['','20090707T130000','20090707T150000','','Gianluca Rattazzi',1],
['','20090707T170000','20090707T173000','','Gianluca Rattazzi',1]]]]]
2009-06-29 16:10:05,453 [5744] DEBUG
GCalExchangeLookup.ExchangeQuerier - Use SSL True
2009-06-29 16:10:05,453 [5744] DEBUG
GCalExchangeLookup.ExchangeQuerier - Request URL
http://owa.domain.tld/GCalExchangeLookup/Exchangequerier.aspx
2009-06-29 16:10:05,453 [5744] DEBUG
GCalExchangeLookup.ExchangeQuerier - Referrer URL
2009-06-29 16:10:17,625 [8200] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyRequest - Request received
from GCal. [body=[1,2,[Us...@domain.tld],
20090625/20090713,20090629T160633,America/Los_Angeles]]
2009-06-29 16:10:17,625 [8200] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@domain.tld
2009-06-29 16:10:17,625 [8200] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Searching
Active Directory [Server=LDAP://owa.domain.tld,
User=gcaldom...@exchange.domain]
2009-06-29 16:10:17,625 [8200] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Issuing LDAP
query '(&(mail=Us...@exchange.domain)(|(objectcategory=user)
(objectcategory=contact)))'
2009-06-29 16:10:17,625 [8200] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Found 1 users
in Active Directory.
2009-06-29 16:10:17,625 [8200] INFO
Google.GCalExchangeSync.Library.ExchangeService - Found and added
'Us...@exchange.domain' as an ExchangeUser.
2009-06-29 16:10:17,625 [8200] DEBUG
Google.GCalExchangeSync.Library.ExchangeService - LDAP object debug
info: [ProxyAddresses=SMTP:Us...@exchange.domain,
sAMAccountName=User2, mailnickname=User2, mail=Us...@exchange.domain,
CN=Kevin O'Keefe, legacyExchangeDN=/o=Maxiscale WebMail/ou=First
Administrative Group/cn=Recipients/cn=User2, DN=CN=Kevin
O'Keefe,OU=UsersExchange,DC=webmail,DC=maxiscale,DC=com, objectClass=
[ top, person, organizationalPerson, user ]]
2009-06-29 16:10:17,625 [8200] DEBUG
Google.GCalExchangeSync.Library.WebDav.XmlRequestImpl - Issuing WebDAV
Request: GET to
http://owa.domain.tld/public/?cmd=freebusy&start=2009-06-25T07:00:00Z&end=2009-07-13T07:00:00Z&interval=15&u=Us...@exchange.domain
- Group Exchange
2009-06-29 16:10:17,625 [8200] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Parsing the raster
000000000000000000000000000000000000000000000000222222222222000000002222222222222222000000000000000000000000000000000000000000000000222222222222222222220000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000222222222222000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000001122000000000000000000000000000000000000000000000000000000000000000000000000222222222222222200002222222200002200000000000000000000000000000000000000000000000000000000000000000000222222000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000222222222222000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000002200000000000000000000000000000000000000000000000000000000000000222222222222111100000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000111122222200000000000000000000000000000000000000000000000000000000000000000000000000000000002222000000000000000000000000000000000000000000000000000000000000000000000000000000002222000000000000000000000000000000000000000000000000000000000000000000000000000000000000222222222222000022222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222
2009-06-29 16:10:17,625 [8200] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Parsed the raster
into 17 busy and 3 tentative ranges
2009-06-29 16:10:17,625 [8200] INFO
Google.GCalExchangeSync.Library.Util.BlockTimer - [Timer] -
LookupFreeBusyTimes - Total Execution Time: 0 ms.
2009-06-29 16:10:17,625 [8200] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Merged 17 + 3 into
20 ranges
2009-06-29 16:10:17,625 [8200] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Compressed 17 + 3
into 17 ranges
2009-06-29 16:10:17,625 [8200] INFO
Google.GCalExchangeSync.Library.ExchangeService - Merge Result of 17 +
Appointment 0 -> 17
2009-06-29 16:10:17,625 [8200] INFO
Google.GCalExchangeSync.Library.Util.BlockTimer - [Timer] -
MergeFreeBusyWithAppointments - Total Execution Time: 0 ms.
2009-06-29 16:10:17,625 [8200] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@exchange.domain
2009-06-29 16:10:17,625 [8200] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - GCal Free/Busy
response successfully generated.
2009-06-29 16:10:17,625 [8200] DEBUG
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - Response =
['1','2',['_ME_AddData','20090625/20090713','20090629T160633',['Kevin
O'Keefe','Us...@domain.tld','20',
[['','20090625T120000','20090625T150000','','Kevin O\047Keefe',1],
['','20090625T170000','20090625T210000','','Kevin O\047Keefe',1],
['','20090626T090000','20090626T140000','','Kevin O\047Keefe',1],
['','20090627T180000','20090627T210000','','Kevin O\047Keefe',1],
['','20090629T140000','20090629T150000','','Kevin O\047Keefe',1],
['','20090630T090000','20090630T130000','','Kevin O\047Keefe',1],
['','20090630T140000','20090630T160000','','Kevin O\047Keefe',1],
['','20090630T170000','20090630T173000','','Kevin O\047Keefe',1],
['','20090701T103000','20090701T120000','','Kevin O\047Keefe',1],
['','20090703T090000','20090703T120000','','Kevin O\047Keefe',1],
['','20090705T170000','20090705T173000','','Kevin O\047Keefe',1],
['','20090706T090000','20090706T130000','','Kevin O\047Keefe',1],
['','20090707T150000','20090707T173000','','Kevin O\047Keefe',1],
['','20090708T140000','20090708T150000','','Kevin O\047Keefe',1],
['','20090709T110000','20090709T120000','','Kevin O\047Keefe',1],
['','20090710T090000','20090710T120000','','Kevin O\047Keefe',1],
['','20090710T130000','20090713T000000','','Kevin O\047Keefe',1]]]]]
2009-06-29 16:10:17,625 [8200] DEBUG
GCalExchangeLookup.ExchangeQuerier - Use SSL True
2009-06-29 16:10:17,625 [8200] DEBUG
GCalExchangeLookup.ExchangeQuerier - Request URL
http://owa.domain.tld/GCalExchangeLookup/Exchangequerier.aspx
2009-06-29 16:10:17,625 [8200] DEBUG
GCalExchangeLookup.ExchangeQuerier - Referrer URL
2009-06-29 16:11:01,453 [8200] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyRequest - Request received
from GCal. [body=[1,0,[Us...@domain.tld],
20090620/20090708,20090629T160733,America/Los_Angeles]]
2009-06-29 16:11:01,453 [8200] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@domain.tld
2009-06-29 16:11:01,453 [8200] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Searching
Active Directory [Server=LDAP://owa.domain.tld,
User=gcaldom...@exchange.domain]
2009-06-29 16:11:01,453 [8200] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Issuing LDAP
query '(&(mail=Us...@exchange.domain)(|(objectcategory=user)
(objectcategory=contact)))'
2009-06-29 16:11:01,453 [8200] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Found 0 users
in Active Directory.
2009-06-29 16:11:01,453 [8200] INFO
Google.GCalExchangeSync.Library.ExchangeService - Unable to find
Active Directory user where 'mail'='Us...@exchange.domain'.
2009-06-29 16:11:01,453 [8200] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - GCal Free/Busy
response successfully generated.
2009-06-29 16:11:01,453 [8200] DEBUG
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - Response =
['1','0',['_ME_AddData','20090620/20090708','20090629T160733',[]]]
2009-06-29 16:11:01,453 [8200] DEBUG
GCalExchangeLookup.ExchangeQuerier - Use SSL True
2009-06-29 16:11:01,453 [8200] DEBUG
GCalExchangeLookup.ExchangeQuerier - Request URL
http://owa.domain.tld/GCalExchangeLookup/Exchangequerier.aspx
2009-06-29 16:11:01,453 [8200] DEBUG
GCalExchangeLookup.ExchangeQuerier - Referrer URL
2009-06-29 16:11:07,140 [5744] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyRequest - Request received
from GCal. [body=[1,1,[Us...@domain.tld],
20090620/20090708,20090629T160733,America/Los_Angeles]]
2009-06-29 16:11:07,140 [5744] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@domain.tld
2009-06-29 16:11:07,140 [5744] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Searching
Active Directory [Server=LDAP://owa.domain.tld,
User=gcaldom...@exchange.domain]
2009-06-29 16:11:07,140 [5744] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Issuing LDAP
query '(&(mail=Us...@exchange.domain)(|(objectcategory=user)
(objectcategory=contact)))'
2009-06-29 16:11:07,140 [5744] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Found 1 users
in Active Directory.
2009-06-29 16:11:07,140 [5744] INFO
Google.GCalExchangeSync.Library.ExchangeService - Found and added
'Us...@exchange.domain' as an ExchangeUser.
2009-06-29 16:11:07,140 [5744] DEBUG
Google.GCalExchangeSync.Library.ExchangeService - LDAP object debug
info: [ProxyAddresses=SMTP:Us...@exchange.domain,
sAMAccountName=User1, mailnickname=User1, mail=Us...@exchange.domain,
CN=Gianluca Rattazzi, legacyExchangeDN=/o=Maxiscale WebMail/ou=First
Administrative Group/cn=Recipients/cn=User1, DN=CN=Gianluca
Rattazzi,OU=UsersExchange,DC=webmail,DC=maxiscale,DC=com, objectClass=
[ top, person, organizationalPerson, user ]]
2009-06-29 16:11:07,140 [5744] DEBUG
Google.GCalExchangeSync.Library.WebDav.XmlRequestImpl - Issuing WebDAV
Request: GET to
http://owa.domain.tld/public/?cmd=freebusy&start=2009-06-20T07:00:00Z&end=2009-07-08T07:00:00Z&interval=15&u=Us...@exchange.domain
- Group Exchange
2009-06-29 16:11:07,140 [5744] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Parsing the raster
000000000000000000000000000000000000000000000022220000000000000000000000000000000000000000000000222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222000000000000000000000000000000000000000022000000000000111100000000002222000000000222200000000000000000000000000000000000000000000000220000002200222222000000000000002200000022000000000000000000000000000000000000000000000000000000222200000022222200000000222200000000000000000000000000000000000000000000000000000000000000000000000000000000222222222222000000000022000022220000000000000000000000000000000000000000000000220000222222222222000022220022222222000000000000222222220000000000000000000000000000000000000000000000000000000000000000000000000000000000000000002222222200000000000000000000000000000000000000000000000000000000000000000000000000002200000000000000000000000000000000000000000000000000000000000000220000000000000000000000000000002222000000220000000000000000222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222000000000000000000000000000000000000000000002222000022222200000000000000000000000000000000000000000000000000000000000000000000000000222200000000222222000000000000000000000000000000000000000000222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222000000000000000000000000000000000000000022000000000022222222000000000000000000000000000000000000000000000000000000000000000000000000222222222222000000002222000000002200000000000000000000000000000000000000000000000000000000002222000000000000000022222222000000002200000000000000000000000000
2009-06-29 16:11:07,140 [5744] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Parsed the raster
into 40 busy and 1 tentative ranges
2009-06-29 16:11:07,140 [5744] INFO
Google.GCalExchangeSync.Library.Util.BlockTimer - [Timer] -
LookupFreeBusyTimes - Total Execution Time: 0 ms.
2009-06-29 16:11:07,140 [5744] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Merged 40 + 1 into
41 ranges
2009-06-29 16:11:07,140 [5744] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Compressed 40 + 1
into 41 ranges
2009-06-29 16:11:07,140 [5744] INFO
Google.GCalExchangeSync.Library.ExchangeService - Merge Result of 41 +
Appointment 0 -> 41
2009-06-29 16:11:07,140 [5744] INFO
Google.GCalExchangeSync.Library.Util.BlockTimer - [Timer] -
MergeFreeBusyWithAppointments - Total Execution Time: 0 ms.
2009-06-29 16:11:07,140 [5744] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@exchange.domain
2009-06-29 16:11:07,156 [5744] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - GCal Free/Busy
response successfully generated.
2009-06-29 16:11:07,156 [5744] DEBUG
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - Response =
['1','1',['_ME_AddData','20090620/20090708','20090629T160733',
['Gianluca Rattazzi','Us...@domain.tld','20',
[['','20090620T113000','20090620T123000','','Gianluca Rattazzi',1],
['','20090621T000000','20090622T000000','','Gianluca Rattazzi',1],
['','20090622T100000','20090622T103000','','Gianluca Rattazzi',1],
['','20090622T133000','20090622T143000','','Gianluca Rattazzi',1],
['','20090622T170000','20090622T180000','','Gianluca Rattazzi',1],
['','20090622T201500','20090622T211500','','Gianluca Rattazzi',1],
['','20090623T090000','20090623T093000','','Gianluca Rattazzi',1],
['','20090623T110000','20090623T113000','','Gianluca Rattazzi',1],
['','20090623T120000','20090623T133000','','Gianluca Rattazzi',1],
['','20090623T170000','20090623T173000','','Gianluca Rattazzi',1],
['','20090623T190000','20090623T193000','','Gianluca Rattazzi',1],
['','20090624T090000','20090624T100000','','Gianluca Rattazzi',1],
['','20090624T113000','20090624T130000','','Gianluca Rattazzi',1],
['','20090624T150000','20090624T160000','','Gianluca Rattazzi',1],
['','20090625T120000','20090625T150000','','Gianluca Rattazzi',1],
['','20090625T173000','20090625T180000','','Gianluca Rattazzi',1],
['','20090625T190000','20090625T200000','','Gianluca Rattazzi',1],
['','20090626T073000','20090626T080000','','Gianluca Rattazzi',1],
['','20090626T090000','20090626T120000','','Gianluca Rattazzi',1],
['','20090626T130000','20090626T140000','','Gianluca Rattazzi',1],
['','20090626T143000','20090626T163000','','Gianluca Rattazzi',1],
['','20090626T193000','20090626T213000','','Gianluca Rattazzi',1],
['','20090627T200000','20090627T220000','','Gianluca Rattazzi',1],
['','20090628T170000','20090628T173000','','Gianluca Rattazzi',1],
['','20090629T090000','20090629T093000','','Gianluca Rattazzi',1],
['','20090629T170000','20090629T180000','','Gianluca Rattazzi',1],
['','20090629T193000','20090629T200000','','Gianluca Rattazzi',1],
['','20090630T000000','20090701T000000','','Gianluca Rattazzi',1],
['','20090701T110000','20090701T120000','','Gianluca Rattazzi',1],
['','20090701T130000','20090701T143000','','Gianluca Rattazzi',1],
['','20090702T090000','20090702T100000','','Gianluca Rattazzi',1],
['','20090702T120000','20090702T133000','','Gianluca Rattazzi',1],
['','20090703T000000','20090705T000000','','Gianluca Rattazzi',1],
['','20090705T100000','20090705T103000','','Gianluca Rattazzi',1],
['','20090705T130000','20090705T150000','','Gianluca Rattazzi',1],
['','20090706T090000','20090706T120000','','Gianluca Rattazzi',1],
['','20090706T140000','20090706T150000','','Gianluca Rattazzi',1],
['','20090706T170000','20090706T173000','','Gianluca Rattazzi',1],
['','20090707T080000','20090707T090000','','Gianluca Rattazzi',1],
['','20090707T130000','20090707T150000','','Gianluca Rattazzi',1],
['','20090707T170000','20090707T173000','','Gianluca Rattazzi',1]]]]]
2009-06-29 16:11:07,156 [5744] DEBUG
GCalExchangeLookup.ExchangeQuerier - Use SSL True
2009-06-29 16:11:07,156 [5744] DEBUG
GCalExchangeLookup.ExchangeQuerier - Request URL
http://owa.domain.tld/GCalExchangeLookup/Exchangequerier.aspx
2009-06-29 16:11:07,156 [5744] DEBUG
GCalExchangeLookup.ExchangeQuerier - Referrer URL
2009-06-29 16:11:12,625 [5744] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyRequest - Request received
from GCal. [body=[1,2,[Us...@domain.tld],
20090620/20090708,20090629T160733,America/Los_Angeles]]
2009-06-29 16:11:12,625 [5744] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@domain.tld
2009-06-29 16:11:12,625 [5744] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Searching
Active Directory [Server=LDAP://owa.domain.tld,
User=gcaldom...@exchange.domain]
2009-06-29 16:11:12,625 [5744] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Issuing LDAP
query '(&(mail=Us...@exchange.domain)(|(objectcategory=user)
(objectcategory=contact)))'
2009-06-29 16:11:12,625 [5744] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Found 1 users
in Active Directory.
2009-06-29 16:11:12,625 [5744] INFO
Google.GCalExchangeSync.Library.ExchangeService - Found and added
'Us...@exchange.domain' as an ExchangeUser.
2009-06-29 16:11:12,625 [5744] DEBUG
Google.GCalExchangeSync.Library.ExchangeService - LDAP object debug
info: [ProxyAddresses=SMTP:Us...@exchange.domain,
sAMAccountName=User2, mailnickname=User2, mail=Us...@exchange.domain,
CN=Kevin O'Keefe, legacyExchangeDN=/o=Maxiscale WebMail/ou=First
Administrative Group/cn=Recipients/cn=User2, DN=CN=Kevin
O'Keefe,OU=UsersExchange,DC=webmail,DC=maxiscale,DC=com, objectClass=
[ top, person, organizationalPerson, user ]]
2009-06-29 16:11:12,625 [5744] DEBUG
Google.GCalExchangeSync.Library.WebDav.XmlRequestImpl - Issuing WebDAV
Request: GET to
http://owa.domain.tld/public/?cmd=freebusy&start=2009-06-20T07:00:00Z&end=2009-07-08T07:00:00Z&interval=15&u=Us...@exchange.domain
- Group Exchange
2009-06-29 16:11:12,640 [5744] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Parsing the raster
000000000000000000000000000000000000000000000000000000000000000000000000000000000022220000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000022000002200000000000000000000000000000000000000000000000000000000000000222200222222000000000000000022220000000000000000000000000000000000000000000000000000000000000000000000000000222222222222000000002222222222222222000000000000000000000000000000000000000000000000222222222222222222220000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000222222222222000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000001122000000000000000000000000000000000000000000000000000000000000000000000000222222222222222200002222222200002200000000000000000000000000000000000000000000000000000000000000000000222222000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000222222222222000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000002200000000000000000000000000000000000000000000000000000000000000222222222222111100000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000111122222200000000000000000000000000
2009-06-29 16:11:12,640 [5744] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Parsed the raster
into 19 busy and 3 tentative ranges
2009-06-29 16:11:12,640 [5744] INFO
Google.GCalExchangeSync.Library.Util.BlockTimer - [Timer] -
LookupFreeBusyTimes - Total Execution Time: 16 ms.
2009-06-29 16:11:12,640 [5744] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Merged 19 + 3 into
22 ranges
2009-06-29 16:11:12,640 [5744] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Compressed 19 + 3
into 19 ranges
2009-06-29 16:11:12,640 [5744] INFO
Google.GCalExchangeSync.Library.ExchangeService - Merge Result of 19 +
Appointment 0 -> 19
2009-06-29 16:11:12,640 [5744] INFO
Google.GCalExchangeSync.Library.Util.BlockTimer - [Timer] -
MergeFreeBusyWithAppointments - Total Execution Time: 0 ms.
2009-06-29 16:11:12,640 [5744] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@exchange.domain
2009-06-29 16:11:12,640 [5744] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - GCal Free/Busy
response successfully generated.
2009-06-29 16:11:12,640 [5744] DEBUG
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - Response =
['1','2',['_ME_AddData','20090620/20090708','20090629T160733',['Kevin
O'Keefe','Us...@domain.tld','20',
[['','20090620T203000','20090620T213000','','Kevin O\047Keefe',1],
['','20090623T151500','20090623T154500','','Kevin O\047Keefe',1],
['','20090623T170000','20090623T173000','','Kevin O\047Keefe',1],
['','20090624T090000','20090624T100000','','Kevin O\047Keefe',1],
['','20090624T103000','20090624T120000','','Kevin O\047Keefe',1],
['','20090624T160000','20090624T170000','','Kevin O\047Keefe',1],
['','20090625T120000','20090625T150000','','Kevin O\047Keefe',1],
['','20090625T170000','20090625T210000','','Kevin O\047Keefe',1],
['','20090626T090000','20090626T140000','','Kevin O\047Keefe',1],
['','20090627T180000','20090627T210000','','Kevin O\047Keefe',1],
['','20090629T140000','20090629T150000','','Kevin O\047Keefe',1],
['','20090630T090000','20090630T130000','','Kevin O\047Keefe',1],
['','20090630T140000','20090630T160000','','Kevin O\047Keefe',1],
['','20090630T170000','20090630T173000','','Kevin O\047Keefe',1],
['','20090701T103000','20090701T120000','','Kevin O\047Keefe',1],
['','20090703T090000','20090703T120000','','Kevin O\047Keefe',1],
['','20090705T170000','20090705T173000','','Kevin O\047Keefe',1],
['','20090706T090000','20090706T130000','','Kevin O\047Keefe',1],
['','20090707T150000','20090707T173000','','Kevin O\047Keefe',1]]]]]
2009-06-29 16:11:12,640 [5744] DEBUG
GCalExchangeLookup.ExchangeQuerier - Use SSL True
2009-06-29 16:11:12,640 [5744] DEBUG
GCalExchangeLookup.ExchangeQuerier - Request URL
http://owa.domain.tld/GCalExchangeLookup/Exchangequerier.aspx
2009-06-29 16:11:12,640 [5744] DEBUG
GCalExchangeLookup.ExchangeQuerier - Referrer URL
2009-06-29 16:36:53,125 [8200] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyRequest - Request received
from GCal. [body=[1,0,[Us...@domain.tld],
20090709/20090727,20090629T163326,America/Los_Angeles]]
2009-06-29 16:36:53,125 [8200] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@domain.tld
2009-06-29 16:36:53,125 [8200] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Searching
Active Directory [Server=LDAP://owa.domain.tld,
User=gcaldom...@exchange.domain]
2009-06-29 16:36:53,125 [8200] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Issuing LDAP
query '(&(mail=Us...@exchange.domain)(|(objectcategory=user)
(objectcategory=contact)))'
2009-06-29 16:36:53,125 [8200] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Found 0 users
in Active Directory.
2009-06-29 16:36:53,125 [8200] INFO
Google.GCalExchangeSync.Library.ExchangeService - Unable to find
Active Directory user where 'mail'='Us...@exchange.domain'.
2009-06-29 16:36:53,125 [8200] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - GCal Free/Busy
response successfully generated.
2009-06-29 16:36:53,125 [8200] DEBUG
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - Response =
['1','0',['_ME_AddData','20090709/20090727','20090629T163326',[]]]
2009-06-29 16:36:53,125 [8200] DEBUG
GCalExchangeLookup.ExchangeQuerier - Use SSL True
2009-06-29 16:36:53,125 [8200] DEBUG
GCalExchangeLookup.ExchangeQuerier - Request URL
http://owa.domain.tld/GCalExchangeLookup/Exchangequerier.aspx
2009-06-29 16:36:53,125 [8200] DEBUG
GCalExchangeLookup.ExchangeQuerier - Referrer URL
2009-06-29 16:36:59,171 [8200] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyRequest - Request received
from GCal. [body=[1,1,[Us...@exchange.domain],
20090709/20090727,20090629T163326,America/Los_Angeles]]
2009-06-29 16:36:59,171 [8200] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Searching
Active Directory [Server=LDAP://owa.domain.tld,
User=gcaldom...@exchange.domain]
2009-06-29 16:36:59,171 [8200] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Issuing LDAP
query '(&(mail=Us...@exchange.domain)(|(objectcategory=user)
(objectcategory=contact)))'
2009-06-29 16:36:59,171 [8200] INFO
Google.GCalExchangeSync.Library.ActiveDirectoryService - Found 1 users
in Active Directory.
2009-06-29 16:36:59,171 [8200] INFO
Google.GCalExchangeSync.Library.ExchangeService - Found and added
'Us...@exchange.domain' as an ExchangeUser.
2009-06-29 16:36:59,171 [8200] DEBUG
Google.GCalExchangeSync.Library.ExchangeService - LDAP object debug
info: [ProxyAddresses=SMTP:Us...@exchange.domain,
sAMAccountName=User2, mailnickname=User2, mail=Us...@exchange.domain,
CN=Kevin O'Keefe, legacyExchangeDN=/o=Maxiscale WebMail/ou=First
Administrative Group/cn=Recipients/cn=User2, DN=CN=Kevin
O'Keefe,OU=UsersExchange,DC=webmail,DC=maxiscale,DC=com, objectClass=
[ top, person, organizationalPerson, user ]]
2009-06-29 16:36:59,171 [8200] DEBUG
Google.GCalExchangeSync.Library.WebDav.XmlRequestImpl - Issuing WebDAV
Request: GET to
http://owa.domain.tld/public/?cmd=freebusy&start=2009-07-09T07:00:00Z&end=2009-07-27T07:00:00Z&interval=15&u=Us...@exchange.domain
- Group Exchange
2009-06-29 16:36:59,187 [8200] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Parsing the raster
000000000000000000000000000000000000000000002222000000000000000000000000000000000000000000000000000000000000000000000000000000000000222222222222000022222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222222000000000000111122222200000000000000000000000000000000000000000000000000000000000000222222220000000000002222000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000222222222222002222220000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000222222222222000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000111122222200000000000000000000000000000000000000000000000000000000000000222200222222000000002222000000000000000000000000000000000000000000000000000000000000000000000000000000000000222200000000000000000000000000000000000000000000000000000000000000000000000000000000222222222222002222220000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000
2009-06-29 16:36:59,203 [8200] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Parsed the raster
into 16 busy and 2 tentative ranges
2009-06-29 16:36:59,203 [8200] INFO
Google.GCalExchangeSync.Library.Util.BlockTimer - [Timer] -
LookupFreeBusyTimes - Total Execution Time: 31 ms.
2009-06-29 16:36:59,203 [8200] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Merged 16 + 2 into
18 ranges
2009-06-29 16:36:59,203 [8200] DEBUG
Google.GCalExchangeSync.Library.FreeBusyConverter - Compressed 16 + 2
into 16 ranges
2009-06-29 16:36:59,203 [8200] INFO
Google.GCalExchangeSync.Library.ExchangeService - Merge Result of 16 +
Appointment 0 -> 16
2009-06-29 16:36:59,203 [8200] INFO
Google.GCalExchangeSync.Library.Util.BlockTimer - [Timer] -
MergeFreeBusyWithAppointments - Total Execution Time: 0 ms.
2009-06-29 16:36:59,203 [8200] DEBUG
Google.GCalExchangeSync.Library.ConfigCache - Mapping:
Us...@exchange.domain
2009-06-29 16:36:59,203 [8200] INFO
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - GCal Free/Busy
response successfully generated.
2009-06-29 16:36:59,203 [8200] DEBUG
Google.GCalExchangeSync.Library.GCalFreeBusyResponse - Response =
['1','1',['_ME_AddData','20090709/20090727','20090629T163326',['Kevin
O'Keefe','Us...@domain.tld','20',
[['','20090709T110000','20090709T120000','','Kevin O\047Keefe',1],
['','20090710T090000','20090710T120000','','Kevin O\047Keefe',1],
['','20090710T130000','20090714T120000','','Kevin O\047Keefe',1],
['','20090714T150000','20090714T173000','','Kevin O\047Keefe',1],
['','20090715T090000','20090715T110000','','Kevin O\047Keefe',1],
['','20090715T140000','20090715T150000','','Kevin O\047Keefe',1],
['','20090717T090000','20090717T120000','','Kevin O\047Keefe',1],
['','20090717T123000','20090717T140000','','Kevin O\047Keefe',1],
['','20090720T090000','20090720T120000','','Kevin O\047Keefe',1],
['','20090721T150000','20090721T173000','','Kevin O\047Keefe',1],
['','20090722T090000','20090722T100000','','Kevin O\047Keefe',1],
['','20090722T103000','20090722T120000','','Kevin O\047Keefe',1],
['','20090722T140000','20090722T150000','','Kevin O\047Keefe',1],
['','20090723T120000','20090723T130000','','Kevin O\047Keefe',1],
['','20090724T090000','20090724T120000','','Kevin O\047Keefe',1],
['','20090724T123000','20090724T140000','','Kevin O\047Keefe',1]]]]]
2009-06-29 16:36:59,203 [8200] DEBUG
GCalExchangeLookup.ExchangeQuerier - Use SSL True
2009-06-29 16:36:59,203 [8200] DEBUG
GCalExchangeLookup.ExchangeQuerier - Request URL
http://owa.exchange.domain/GCalExchangeLookup/Exchangequerier.aspx
2009-06-29 16:36:59,203 [8200] DEBUG
GCalExchangeLookup.ExchangeQuerier - Referrer URL