Free/Busy Visibility

7 views
Skip to first unread message

Jonathan

unread,
Jun 29, 2009, 6:54:36 PM6/29/09
to google-calendar-connectors
Error message I am seeing is "Calendar doesn't exist or isn't shared"
when trying to view an exchange calendar from a Google Apps account.

Mail Flow is Internet -> Google Apps -> Exchange
I am using the global routing for all unknown emails to be delivered
to Exchange.
Initially all users were on Google Apps, and some needed added
functionality of Exchange/Outlook/BES, so most of our users are still
on GA, and a few have been moved to Exchange.

User1 - Exchange User, Calendar is visible from Google, Entourage is
unable to view certain (maybe all) google calendars
User2 - Exchange User, Calendar is not visible from Google, Outlook is
able to view all google and exchange calendars
User3 - Google User, able to see Calendar for User1 but not User2
User4 - Same as User3

Enabling Debug logging and I am able to see the results for the
calendar, and the diagnostics page works fine as well. Eg, currently
it returns 19 busy slots and 2 tenative slots. The webdav URL that is
in the debug log returns proper xml reply for both the working and non-
working calendars.

Timing wise...
Last week I had their calendars configured to not share with other
users, and if they were shared with others then the google users would
display the empty google-based calendar for the exchange user
This morning (Monday 6/29) at aprox. 11AM, I archived all their docs
and deleted their google apps accounts, and added an alternative
account using their first name as the account name. Almost
Immediately User1 calendar started working properly, but User2 still
failed. Around 12:30PM I deleted the alternative account to ensure
that wasn't causing issues. Still no change over 3 hours later.

I can post logs, etc...

Suman

unread,
Jun 29, 2009, 9:29:33 PM6/29/09
to google-calendar-connectors
Please post the WebService logs here. Thanks!

Jonathan

unread,
Jun 29, 2009, 10:34:36 PM6/29/09
to google-calendar-connectors
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
Reply all
Reply to author
Forward
0 new messages