EFTA00502545.pdf

From: File "Nolumes/BuildData/pulse- datathgents/599758/recipes/859788647/base/b/drb/googleclient/apps/webdrive_sync/osiddist/Google Drive.app/Contents/ftesources/_boot_.py", line 77, in <module> File "Nolumes/BuildData/pulse- datathgents/599758/recipes/859788647/base/b/drb/googleclient/apps/webdrive_sync/osiddist/Google Drive.app/Contents/ftesources/_boot_.py", line 62, in _run File "/ApplicationslGoogle Drive.app/Contents/Resourceslmain.py", line 12, in <module> File "osx/run_googledrive.pyo", line 31, in Main File "PyObjCTools/AppHelper.pyo", line 235, in runEventLoop File "osic/GSyncAppDelegate.pyo", line 297, in applicationWillTerminate_ File "osxlmac_sync_app_controller.pyo", line 252, in Exit File "common/ui_action_handler.pyo", line 450, in Quit File "common/sync_app.pyo", line 1643, in Quit 2016-01-05 16:53:54,689 -0500 INFO pid=1127 140735233524496:MainThread thread manager.pyo:114 Stop was called 2016-0Y-05 16:53:54,689 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <PauseTelemetryThread(PauseTelemetryThread, started 4567298048)> to stop. 2016-01-05 16:53:54,690 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <Worker(Worker-2, started 45715046401> to stop. 2016-01-05 16:53:54,690 -0500 INFO pid=1127 4567298048:PauseTelemetryThread sync_client thread.pyo:209 PauseTelemetryThread run loop has terminated. 2016-01-05 16:53:54,690 -0500 INFO pid=1127 4567298048:PauseTelemetryThread pause telemetry.pyo:127 Attempting final telemetry harvest. 2016-01-05 16:53:54,690 -0500 WARNING pid=1127 140735233524496:MainThread sync_client thread.pyo:237 Wake() called while thread was running, should be a N0P 2016-01-05 16:53:54,690 -0500 INFO pid=1127 4567298048:PauseTelemetryThread pause_telemetry.pyo:190 Harvested pause statistics at t=1452030834.69: (<PauseReason.API ERRORS: 'pause api err'>: _HarvestStat(paused=0.0, trial=0.0, occurrences=0), nauseReason.BLCZKINa_ERRORS: 'pause blocking_err'>: _HarvestStat(paused=0.0, trial=0.0, occurrences=0), <PauseReason.NETWORK_ERRCES: 'pause_net err'>: HarvestStat(paused=0.0, trial=0.0, occurrences=0), <PauseReason.USER: 'pause user'>: HarvestStat(paused=0.0, trial=0.0, occurrences=0), <PauseReason.OFFLINE: 'pause offline'>: HarvestStat(paused=26.812599214998045, trial=0.0, occurrences=1), irisauseReason.NO_LOCAL_DISK_SPACE: 'pause_no_space'>: _HarvestStat(paused=0.0, trial=0.0, occurrences=0)1 2016-01-05 16:53:54,691 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <CloudWatcher(CloudWatcher, started 45757112321> to stop. 2016-0Y-05 16:53:54,692 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <FinderInjector(FinderInjector, started 4533010432)> to stop. 2016-01-05 16:53:54,692 -0500 INFO pid=1127 4575711232:CloudWatcher cloud_watcher.pyo:680 Stop detected 2016-01-05 16:53:54,692 -0500 INFO pid=1127 4571504640:Worker-2 sync_client thread.pyo:209 Worker-2 run loop has terminated. 2016-01-05 16:53:54,693 -0500 INFO pid=1127 4571504640:Worker-2 sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user default/snapshot.db 2016-01-05 16:53:54,693 -0500 INFO pid=1127 4533010432:Finderlnjector sync_client thread.pyo:209 Finderlnjector run loop has terminated. 2016-01-05 16:53:54,693 -0500 WARNING pid=1127 4575711232:CloudWatcher cloud watcher.pyo:726 Exiting CloudWatcher.PushRunLoop() 2016-01-05 16:53:54,694 -0500 INFO pid=1127 4575711232:CloudWatcher sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user default/snapshot.db 2016-01-05 16:53:54,694 -0500 INFO pid=1127 4571504640:Worker-2 sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user default/sync_config.db 2016-01-05 16:53:54,692 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <SchedulerThread(ListenerScheduler, started 45967441921> to stop. 2016-01-05 16:53:54,694 -0500 INFO pid=1127 4575711232:CloudWatcher sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application EFTA00502545 Support/Google/Drive/user_default/sync_config.db 2016-01-05 16:53:54,694 -0500 INFO pid=1127 4571504640:Worker-2 utils.pyo:714 Execute cleanup callback 'persistence_sqlite:d9ed232924594d9e9d2ee000e2acfd77/Users/lgroff/Library/Application Support/Google/Drive/user default/snapshot.db' 2016-01-05 16:53:54,695 -0500 INFO pid=1127 4575711232:CloudWatcher utils.pyo:714 Execute cleanup callback 'persistence_sqlite:27bcf7450c524dd5b45eald09ff47118/Users/lgroff/Library/Application Support/Google/Drive/user default/sync_config.db' 2016-01-05 16:53:54,695 -0500 INFO pid=1127 4575711232:CloudWatcher utils.pyo:714 Execute cleanup callback 'persistence_sqlite:a0157bdf8488435181a3b5bb45b13f17/Users/lgroff/Library/Application Support/Google/Drive/user default/snapshot.db' 2016-01-05 16:53:54,695 -0500 INFO pid=1127 4575711232:CloudWatcher utils.pyo:714 Execute cleanup callback 'DBConnectionManagerCleanupCallback' 2016-01-05 16:53:54,696 -0500 INFO pid=1127 4575711232:CloudWatcher db_connection.pyo:431 Closing ManagedConnection(id=10F7633D0, thread=CloudWatcher-110BBD000, path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/cloud_graph/dict_2.db, closed=False) 2016-01-05 16:53:54,695 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <CrashReportUploaderThread(CrashReportUploaderThread, started 4588331008)> to stop. 2016-01-05 16:53:54,695 -0500 INFO pid=1127 4571504640:Worker-2 utils.pyo:714 Execute cleanup callback 'persistence_sqlite:f0dlade8e3494dc6a75669d253cbdae3/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2016-01-05 16:53:54,696 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <LocalDiskSpaceChecker(LocalDiskSpaceChecker, started 4600950784)> to stop. 2016-01-05 16:53:54,697 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <PushNotificationKeepaliveThread(PushNotificationKeepaliveThread, started 4579917824)> to stop. 2016-01-05 16:53:54,697 -0500 INFO pid=1127 4600950784:LocalDiskSpaceChecker sync_client_thread.pyo:209 LocalDiskSpaceChecker run loop has terminated. 2016-01-05 16:53:54,698 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <OverlayStatusCleaner(OverlayStatusCleaner, started 4584124416)> to stop. 2016-01-05 16:53:54,698 -0500 INFO pid=1127 4579917824:PushNotificationKeepaliveThread sync_client_thread.pyo:209 PushNotificationKeepaliveThread run loop has terminated. 2016-01-05 16:53:54,698 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <LocalFSPoller(LocalFSPoller, started 4592537600)> to stop. 2016-01-05 16:53:54,699 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <Worker(Worker-1, started 4605157376)> to stop. 2016-01-05 16:53:54,699 -0500 WARNING pid=1127 140735233524496:MainThread sync_client_thread.pyo:237 Wake() called while thread was running, should be a N0P 2016-01-05 16:53:54,698 -0500 INFO pid=1127 4584124416:OverlayStatusCleaner sync_client_thread.pyo:209 OverlayStatusCleaner run loop has terminated. 2016-01-05 16:53:54,699 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <RawEventUpgrader(RawEventUpgrader, started 4609363968)> to stop. 2016-01-05 16:53:54,700 -0500 INFO pid=1127 4592537600:LocalFSPoller sync_client_thread.pyo:209 LocalFSPoller run loop has terminated. 2016-01-05 16:53:54,700 -0500 INFO pid=1127 4605157376:Worker-1 sync_client_thread.pyo:209 Worker-1 run loop has terminated. 2016-01-05 16:53:54,700 -0500 INFO pid=1127 4605157376:Worker-1 sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-01-05 16:53:54,701 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <ConnectivityThread(ConnectivityThread, started 4613570560)> to stop. 2016-01-05 16:53:54,701 -0500 INFO pid=1127 4609363968:RawEventUpgrader sync_client_thread.pyo:209 RawEventUpgrader run loop has terminated. 2016-01-05 16:53:54,701 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <PushXmppClient(XmppClient, started 4617777152)> to stop. EFTA00502546 2016-01-05 16:53:54,702 -0500 INFO pid=1127 4605157376:Worker-1 sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-01-05 16:53:54,702 -0500 WARNING pid=1127 140735233524496:MainThread task.pyo:242 DriveXmppTask-0xl0f8c9050 aborting: abort 2016-01-05 16:53:54,702 -0500 INFO pid=1127 4605157376:Worker-1 utils.pyo:714 Execute cleanup callback 'persistence_sqlite:cbe430af8d264a86800b4823dad79ff3/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2016-01-05 16:53:54,702 -0500 INFO pid=1127 140735233524496:MainThread task.pyo:254 Task <common.push.push_xmpp_client.DriveXmppTask object at 0xl0f8c9050> complete. 2016-01-05 16:53:54,703 -0500 INFO pid=1127 4605157376:Worker-1 utils.pyo:714 Execute cleanup callback 'persistence_sqlite:d44536ccdb6e45caabc8a3ec9a42eee2/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2016-01-05 16:53:54,703 -0500 INFO pid=1127 140735233524496:MainThread xmpplib.pyo:143 Close called with 'why' reason = Client initiated close 2016-01-05 16:53:56,951 -0500 INFO pid=1127 140735233524496:MainThread task.pyo:254 Task <common.push.push_xmpp_client.DriveXmppTask object at 0x10f8c9050> complete. 2016-01-05 16:53:56,952 -0500 INFO pid=1127 140735233524496:MainThread xmpplib.pyo:143 Close called with 'why' reason = Client initiated close 2016-01-05 16:53:56,952 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <Batcher(Batcher, started 4621983744)> to stop. 2016-01-05 16:53:56,952 -0500 INFO pid=1127 4617777152:XmppClient push_xmpp_client.pyo:135 Exiting run loop 2016-01-05 16:53:56,952 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <IpcServerThread(IpcServerThread, started 4542644224)> to stop. 2016-01-05 16:53:56,952 -0500 INFO pid=1127 4621983744:Batcher sync_client_thread.pyo:270 Batcher run loop has terminated. 2016-01-05 16:53:56,953 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <SchedulerThread(InternalScheduler, started 4630396928)> to stop. 2016-01-05 16:53:56,953 -0500 INFO pid=1127 4621983744:Batcher sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-01-05 16:53:56,953 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <FilewatcherMonitor(FilewatcherMonitor, started 4563091456)> to stop. 2016-01-05 16:53:56,954 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <FeatureSwitchPoller(FeatureSwitchPoller, started 4651429888)> to stop. 2016-01-05 16:53:56,954 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <Worker(Worker-0, started 4634603520)> to stop. 2016-01-05 16:53:56,955 -0500 INFO pid=1127 4621983744:Batcher utils.pyo:714 Execute cleanup callback 'persistence_sqlite:bd56e47ealf74b1f955ab1562d0eedcf/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2016-01-05 16:53:56,955 -0500 INFO pid=1127 4651429888:FeatureSwitchPoller sync_client_thread.pyo:209 FeatureSwitchPoller run loop has terminated. 2016-01-05 16:53:56,955 -0500 INFO pid=1127 4621983744:Batcher sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-01-05 16:53:56,956 -0500 WARNING pid=1127 140735233524496:MainThread sync_client_thread.pyo:237 Wake() called while thread was running, should be a N0P 2016-01-05 16:53:56,956 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <PushTelemetryThread(PushTelemetryThread, started 4638810112)> to stop. 2016-01-05 16:53:56,956 -0500 INFO pid=1127 4621983744:Batcher utils.pyo:714 Execute cleanup callback 'persistence_sqlite:965da7da010f4e55ba677749f9b5a984/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2016-01-05 16:53:56,956 -0500 INFO pid=1127 4634603520:Worker-0 sync_client_thread.pyo:209 Worker-0 run loop has terminated. 2016-01-05 16:53:56,957 -0500 INFO pid=1127 4634603520:Worker-0 sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application EFTA00502547 Support/Google/Drive/user_default/snapshot.db 2016-01-05 16:53:56,957 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <LocalWatcher(LocalWatcher, started 4643016704)> to stop. 2016-01-05 16:53:56,957 -0500 INFO pid=1127 4638810112:PushTelemetryThread sync_client_thread.pyo:209 PushTelemetryThread run loop has terminated. 2016-01-05 16:53:56,957 -0500 INFO pid=1127 4638810112:PushTelemetryThread telemetry.pyo:207 Attempting final telemetry harvest. 2016-01-05 16:53:56,958 -0500 INFO pid=1127 4638810112:PushTelemetryThread telemetry.pyo:167 PushStates.ONLINE: +2229.78 => 27399.6 2016-01-05 16:53:56,958 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <TelemetryUploaderThread(TelemetryUploaderThread, started 4647223296)> to stop. 2016-01-05 16:53:57,119 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:250 Asking <TelemetryStoreSizeMonitor(TelemetryStoreSizeMonitorThread, started 4626190336)> to stop. 2016-01-05 16:53:57,120 -0500 INFO pid=1127 4647223296:TelemetryUploaderThread sync_client_thread.pyo:209 TelemetryUploaderThread run loop has terminated. 2016-01-05 16:53:57,120 -0500 INFO pid=1127 140735233524496:MainThread thread_manager.pyo:261 Stop completed successfully. 2016-01-05 16:53:57,121 -0500 INFO pid=1127 4626190336:TelemetryStoreSizeMonitorThread sync_client_thread.pyo:209 TelemetryStoreSizeMonitorThread run loop has terminated. 2016-01-05 16:53:57,121 -0500 INFO pid=1127 4546850816:ThreadMonitor thread_manager.pyo:339 Waking up. 2016-01-05 16:53:57,384 -0500 INFO pid=1127 4634603520:Worker-0 sglite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-01-05 16:53:57,384 -0500 INFO pid=1127 4634603520:Worker-0 utils.pyo:714 Execute cleanup callback 'persistence_sglite:7f525224b40a474eafff2e69b3edb7c6/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2016-01-05 16:53:57,384 -0500 INFO pid=1127 4634603520:Worker-0 utils.pyo:714 Execute cleanup callback 'persistence_sglite:7b43b7e888044bc78d564ba6a296fd15/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2016-01-05 16:53:58,545 -0500 WARNING pid=1127 4542644224:IpcServerThread utils.pyo:766 interrupt_condition is set in Sleeper.Wait, waiting 0.2 seconds 2016-01-05 16:53:58,797 -0500 INFO pid=1127 140735233524496:MainThread sync_app.pyo:1671 Repr caching stats: <class 'common.worker.worker_event.WorkerCreateCloudEvent'>: max hits: 1 mean hits: 1.0 max miss: 0 mean miss: 0.0 <class 'common.raw_event.ImmutableRawEvent'>: max hits: 7 mean hits: 7.0 max miss: 0 mean miss: 0.0 <class 'common.delivery.ImmutableChange'>: max hits: 3 mean hits: 3.0 max miss: 0 mean miss: 0.0 <class 'common.worker.worker_event.WorkerModifyCloudEvent'>: max hits: 1 mean hits: 1.0 max miss: 0 mean miss: 0.0 <class 'common.worker.worker_event.WorkerDeleteCloudEvent'>: max hits: 1 mean hits: 1.0 max miss: 0 mean miss: 0.0 2016-01-06 09:08:41,580 -0500 INFO pid=367 140735165244176:MainThread logging_config.pyo:249 OS: Darwin/10.9.5 2016-01-06 09:08:41,607 -0500 INFO pid=367 140735165244176:MainThread EFTA00502548 logging_config.pyo:252 Google Drive (build 1.26.0707.2863) 2016-01-06 09:08:41,607 -0500 INFO pid=367 140735165244176:MainThread logging_config.pyo:253 SSL: OpenSSL 0.9.8zg 14 July 2015 2016-01-06 09:08:41,692 -0500 INFO pid=367 140735165244176:MainThread GSyncAppDelegate.pyo:198 Application did finish launching. 2016-01-06 09:08:42,189 -0500 INFO pid=367 140735165244176:MainThread service.pyo:132 Creating singleton service instance of '<class 'common.file_lock.FileLock'>' 2016-01-06 09:08:42,190 -0500 INFO pid=367 140735165244176:MainThread service.pyo:132 Creating singleton service instance of '<class 'common.file_lock.FileLock'>' 2016-01-06 09:08:42,192 -0500 INFO pid=367 4523048960:RunAsync-_InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.service.user.User'>' 2016-01-06 09:08:42,192 -0500 INFO pid=367 4523048960:RunAsync-_InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.roots.roots.RootManager'>' 2016-01-06 09:08:42,192 -0500 INFO pid=367 4523048960:RunAsync-_InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.thread_manager.ThreadManager'> 1 2016-01-06 09:08:42,193 -0500 INFO pid=367 4523048960:RunAsync-_InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.pause_manager.Service'>' 2016-01-06 09:08:42,193 -0500 INFO pid=367 4523048960:RunAsync-_InitializeSyncAppAsync-1 sync_app.pyo:330 Getting TokenStorage... 2016-01-06 09:08:42,194 -0500 INFO pid=367 4523048960:RunAsync-_InitializeSyncAppAsync-1 sync_app.pyo:332 Got token storage: <token_storage.TokenStorage object at 0x1092b6ed0> 2016-01-06 09:08:42,194 -0500 INFO pid=367 4523048960:RunAsync-_InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.features.AppFeatures'>' 2016-01-06 09:08:42,194 -0500 INFO pid=367 4523048960:RunAsync-_InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.cert.Manager'>' 2016-01-06 09:08:42,202 -0500 INFO pid=367 4523048960:RunAsync-_InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.net.bandwidth.BandwidthThrottler'>' 2016-01-06 09:08:42,204 -0500 INFO pid=367 4523048960:RunAsync-_InitializeSyncAppAsync-1 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-01-06 09:08:42,216 -0500 INFO pid=367 4523048960:RunAsync-_InitializeSyncAppAsync-1 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-01-06 09:08:42,216 -0500 INFO pid=367 4523048960:RunAsync-_InitializeSyncAppAsync-1 utils.pyo:737 AddCleanupCallback persistence_sqlite:3c85132154e049868f2e2ea182b0a493/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-01-06 09:08:42,217 -0500 INFO pid=367 4523048960:RunAsync-_InitializeSyncAppAsync-1 utils.pyo:737 AddCleanupCallback persistence_sqlite:da27ac62c788484997ca6840799cca5f/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-01-06 09:08:42,288 -0500 INFO pid=367 4523048960:RunAsync-_InitializeSyncAppAsync-1 sync_app.pyo:506 BandwidthThrottler configured via sync_config 2016-01-06 09:08:42,288 -0500 INFO pid=367 4523048960:RunAsync-_InitializeSyncAppAsync-1 bandwidth.pyo:59 BandwidthThrottler.SetRxBytesPerSecond 0 2016-01-06 09:08:42,288 -0500 INFO pid=367 4523048960:RunAsync-_InitializeSyncAppAsync-1 bandwidth.pyo:68 BandwidthThrottler.SetTxBytesPerSecond 0 2016-01-06 09:08:42,289 -0500 INFO pid=367 4523048960:RunAsync-_InitializeSyncAppAsync-1 sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-01-06 09:08:42,296 -0500 INFO pid=367 4523048960:RunAsync-_InitializeSyncAppAsync-1 sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-01-06 09:08:42,305 -0500 INFO pid=367 4523048960:RunAsync-_InitializeSyncAppAsync-1 utils.pyo:714 Execute cleanup callback 'persistence_sqlite:3c85132154e049868f2e2ea182b0a493/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2016-01-06 09:08:42,305 -0500 INFO pid=367 4523048960:RunAsync-_InitializeSyncAppAsync-1 utils.pyo:714 Execute cleanup callback 'persistence_sqlite:da27ac62c788484997ca6840799cca5f/Users/lgroff/Library/Application EFTA00502549 Support/Google/Drive/user_default/sync_config.db' 2016-01-06 09:08:42,307 -0500 INFO pid=367 4531724288:Finderlnjector sync_client_thread.pyo:175 Finderlnjector run loop has started. 2016-01-06 09:08:42,335 -0500 INFO pid=367 140735165244176:MainThread image_resources.py:292 Loading image resources/images/ic_drawer_24.png 2016-01-06 09:08:42,349 -0500 INFO pid=367 140735165244176:MainThread image_resources.py:292 Loading image resources/images/menu_drive-logo.png 2016-01-06 09:08:42,350 -0500 INFO pid=367 140735165244176:MainThread image_resources.py:292 Loading image resources/images/menu_google-logo-gray.png 2016-01-06 09:08:42,352 -0500 INFO pid=367 140735165244176:MainThread image_resources.py:292 Loading image resources/images/ic_folder_mydrive_24.png 2016-01-06 09:08:42,353 -0500 INFO pid=367 140735165244176:MainThread image_resources.py:292 Loading image resources/images/ic_web_24.png 2016-01-06 09:08:42,354 -0500 INFO pid=367 140735165244176:MainThread image_resources.py:292 Loading image resources/images/ic_sync_problem_24.png 2016-01-06 09:08:42,365 -0500 INFO pid=367 140735165244176:MainThread image_resources.py:292 Loading image resources/images/ic_done.png 2016-01-06 09:08:42,502 -0500 INFO pid=367 4545564672:ThreadMonitor thread_manager.pyo:336 Waiting on exit condition. Wake up after 3600s. 2016-01-06 09:08:42,503 -0500 INFO pid=367 4549771264:_LaunchSyncApp sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-01-06 09:08:42,632 -0500 INFO pid=367 4549771264:_LaunchSyncApp sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-01-06 09:08:42,700 -0500 INFO pid=367 4549771264:_LaunchSyncApp utils.pyo:737 AddCleanupCallback persistence_sqlite:05608d5e2f434484a3847a2bb8065ad2/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-01-06 09:08:42,700 -0500 INFO pid=367 4549771264:_LaunchSyncApp utils.pyo:737 AddCleanupCallback persistence_sqlite:f338fba003914a38a893e59fal3ea586/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-01-06 09:08:42,838 -0500 INFO pid=367 4549771264:_LaunchSyncApp user.pyo:66 Initializing User instance with new credentials. None 2016-01-06 09:08:42,838 -0500 INFO pid=367 4549771264:_LaunchSyncApp docs_client_factory.pyo:89 Creating a new DriveClient 2016-01-06 09:08:42,839 -0500 INFO pid=367 4549771264:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.quota.Quotalnfo'>' 2016-01-06 09:08:42,840 -0500 INFO pid=367 4549771264:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.token_bucket.CloudBucketManager'>' 2016-01-06 09:08:42,840 -0500 INFO pid=367 4549771264:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive_api.drive_resource.Manager'>. 2016-01-06 09:08:42,840 -0500 INFO pid=367 4549771264:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive_api.http.Manager'>. 2016-01-06 09:08:42,840 -0500 INFO pid=367 4549771264:_LaunchSyncApp drive_resource.pyo:130 Initialize apiclient Drive resource for current user token 2016-01-06 09:08:42,851 -0500 INFO pid=367 4549771264:_LaunchSyncApp drive_resource.pyo:178 Drive SDK baseUrl = https://www.googleapis.com/drive/v2internal/ 2016-01-06 09:08:42,869 -0500 INFO pid=367 4549771264:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive_api.http.AccessTokenInMemoryCache'>. 2016-01-06 09:08:42,870 -0500 INFO pid=367 4549771264:_LaunchSyncApp drive_request.pyo:285 Drive request: About(tags=Reason.SYNC_OTHER) - Read request - None 2016-01-06 09:08:42,872 -0500 INFO pid=367 4549771264:_LaunchSyncApp discovery.pyo:762 UAL being requested: GET https://www.googleapis.com/drive/v2internal/about? fields=rootFolderld%2CquotaBytesTotal%2CquotaBytesUsedAggregate%2CquotaBytesUsedInTrash%2Cquo taType%2Cuser%2FemailAddress&reason=304Salt=json 2016-01-06 09:08:42,873 -0500 INFO pid=367 4549771264:_LaunchSyncApp client.pyo:515 Attempting refresh to obtain initial access_token 2016-01-06 09:08:42,873 -0500 INFO pid=367 4549771264:_LaunchSyncApp client.pyo:755 Refreshing access_token 2016-01-06 09:08:42,883 -0500 INFO pid=367 4549771264:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.net.dapper.DapperServicel> 1 2016-01-06 09:08:42,883 -0500 INFO pid=367 4549771264:_LaunchSyncApp http.pyo:248 Request EFTA00502550 user-agent: Python-httplib2/0.9 (gzip) 2016-01-06 09:08:42,883 -0500 INFO pid=367 4549771264:_LaunchSyncApp sync_http_client.pyo:236 Opening direct connecton to accounts.google.com:443. 2016-01-06 09:08:43,047 -0500 INFO pid=367 4549771264:_LaunchSyncApp http.pyo:267 Response: 151 bytes - application/json; charset=utf-8 (encoding:gzip) 2016-01-06 09:08:43,048 -0500 INFO pid=367 4549771264:_LaunchSyncApp http.pyo:248 Request user-agent: googledrivesync-1.26.0707.2863 google-api-python-client/1.3.1 (gzip) (Darwin/10.9.5) 2016-01-06 09:08:43,048 -0500 INFO pid=367 4549771264:_LaunchSyncApp sync_http_client.pyo:236 Opening direct connecton to www.googleapis.com:443. 2016-01-06 09:08:43,396 -0500 INFO pid=367 140735165244176:MainThread sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-01-06 09:08:43,397 -0500 INFO pid=367 140735165244176:MainThread sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-01-06 09:08:43,397 -0500 INFO pid=367 140735165244176:MainThread sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-01-06 09:08:43,398 -0500 INFO pid=367 140735165244176:MainThread sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-01-06 09:08:43,741 -0500 INFO pid=367 4549771264:_LaunchSyncApp http.pyo:267 Response: 241 bytes - application/json; charset=UTF-8 (encoding:gzip) 2016-01-06 09:08:43,850 -0500 INFO pid=367 4549771264:_LaunchSyncApp drive_request.pyo:292 Drive response: Request (None): About(tags=Reason.SYNC OTHER) Response: About(root_id=0ABNN8iEiWGvgUk9PVA, [email protected], quota_bytes_total=16106127360, quota_bytes_used_aggregate=15473309603, quota_bytes_used_in_trash=405248647, quota_type=LIMITED) 2016-01-06 09:08:43,850 -0500 INFO pid=367 4549771264:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive_api.doc_id_provider.Store'>' 2016-01-06 09:08:43,850 -0500 INFO pid=367 4549771264:_LaunchSyncApp user.pyo:66 Initializing User instance with new credentials. [email protected] 2016-01-06 09:08:43,850 -0500 INFO pid=367 4549771264:_LaunchSyncApp sync_app.pyo:1235 Configuring sync app from feature switches. 2016-01-06 09:08:43,851 -0500 INFO pid=367 4549771264:_LaunchSyncApp features.pyo:112 Loads feature switches. 2016-01-06 09:08:43,851 -0500 INFO pid=367 4549771264:_LaunchSyncApp feature_switch_manager.pyo:644 Calling server to get feature switches. 2016-01-06 09:08:43,851 -0500 INFO pid=367 4549771264:_LaunchSyncApp drive_request.pyo:285 Drive request: ListFeatureSwitches(tags=Reason.SYNC_OTHER) - Read request - [email protected] 2016-01-06 09:08:43,853 -0500 INFO pid=367 4549771264:_LaunchSyncApp discovery.pyo:762 URL being requested: GET https://www.googleapis.com/drive/v2internal/settings? fields=items%2Fkey%2Citems%2Fvalue&reason=304&namespace=FEATURE_SWITCHSalt=json 2016-01-06 09:08:43,864 -0500 INFO pid=367 4549771264:_LaunchSyncApp http.pyo:248 Request user-agent: googledrivesync-1.26.0707.2863 google-api-python-client/1.3.1 (gzip) (Darwin/10.9.5) 2016-01-06 09:08:43,932 -0500 INFO pid=367 4549771264:_LaunchSyncApp http.pyo:267 Response: 1434 bytes - application/json; charset=UTF-8 (encoding:gzip) 2016-01-06 09:08:43,941 -0500 INFO pid=367 4549771264:_LaunchSyncApp drive_request.pyo:292 Drive response: Request ([email protected]): ListFeatureSwitches(tags=Reason.SYNC_OTHER) Response: (u'enable_impressions_library': u'false', u'selective_sub_folder_sync.: u'false., u'crash_throttle_percentage': u'99.7', u'enable_feedback': u'true', u'enable_usb_detection': u'false', u'max_page_size_selective_syncl: u'1000 1 , u'enable_shared_move_confirmation': u'false', u'enable_disk_check_on_preferences': u'false', u'enable_recursive_size': u'false', u'enable_push': u'true', u'enable_sync_options_in_setup_flow': u'false', u'enable_multipause': u'true', u'log_backup_count': u'0', u'enable_arbitrary_sync': u'false', u'enable_disk_check_on_setup': u'false', u'max_batch_upload_files': u'30', EFTA00502551 u'cloud_graph_disk_generation': u'2', u'use_drive_api': u'false', u'query_strategy': u'all', u'enable_multipleaccounts': u'false', u'perf_throttle_percentage': u'100', u'test.feature_switch.name': u") 2016-01-06 09:08:43,943 -0500 INFO pid=367 4549771264:_LaunchSyncApp sync_app.pyo:1260 Feature Switches: FeatureSwitchSettings( accept_blob_download_gzip_encoding=True, backup_polling_interval_secs=7200, change_filters=('DRIVE_SYNC'), cloud_graph_disk_generation=2, crash_log_size_limit=10000000, crash_throttle_percentage=99.7, disabled_cloud_graph_disk_app_versions=[], docs_list_page_size=1000, download_in_place=False, download_progress_bar=False, download_strategy=turl_template', download_url=thttps://googledrive.com/p/host/(doc_id1 1 , enable_arbitrary_sync=False, enable_batch_upload=True, enable_change_filters=False, enable_context_menu=True, enable_dapper_trace=False, enable_disk_dict=False, enable_feedback=True, enable_file_sync_status=True, enable_impressions_library=False, enable_local_v2=False, enable_multipause=True, enable_multiple_accounts=False, enable_native_opener=True, enable_push=True, enable_recursive_size=False, enableshared_moveconfirmation=False, enable_usb_detection=False, feedback_type='prod', ghost_all_files=False, help_ur1='https://support.google.com/drivern1=%ssp=desktop_home., impressions_heartbeat_interval_secs=10800, impressions_upload_interval_secs=1800, log_backup_count=0, log_size_mb=256, logging_level='info', max_batch_upload_files=30, new_document_url=thttps://docs.google.com/document?usp=drive_syncl, new_presentation_ur1= 1 https://docs.google.com/presentation?usp=drive_sync'„ new_spreadsheet_ur1='https://docs.google.com/spreadsheets?usp=drive_synci, numworkers=3, open_ur1='https://docs.google.com/open?id=fdoc_id)', overlays_enabled_finder_versions=[ 1 10.7 1 , '10.7.1', '10.7.2', '10.7.3', '10.7.5', '10.8', '10.8.1', '10.8.2', '10.8.3', '10.9', '10.9.1', '10.9.2', '10.9.3', '10.9.4'], perf_throttle_percentage=100.0, push_clientversion=1, push_keepalive_interval=72000.0, query_strategy=u'all', regular_polling_interval_secs=30, selective_sub_folder_sync=False, share_template_ur1='https://drive.google.com/sharing/share? subapp=10&shareProtocolVersion=2&theme=2&command=settings&shareUiType=default&authuser=0&clie nt=desktop', show_confirmation_dialog_on_delete=True, telemetry_enabled=True, telemetry_upload_interval_secs=1800, telemetry_ur1='https://drive.google.com/syncclient_impressions., token_bucket_read_gps=10, EFTA00502552 token_bucketwrite_qps=3, use_drive_api=False,) 2016-01-06 09:08:43,963 -0500 INFO pid=367 4549771264:_LaunchSyncApp logging_config.pyo:249 OS: Darwin/10.9.5 2016-01-06 09:08:43,963 -0500 INFO pid=367 4549771264:_LaunchSyncApp logging_config.pyo:252 Google Drive (build 1.26.0707.2863) 2016-01-06 09:08:43,963 -0500 INFO pid=367 4549771264:_LaunchSyncApp logging_config.pyo:253 SSL: OpenSSL 0.9.8zg 14 July 2015 2016-01-06 09:08:43,964 -0500 INFO pid=367 4549771264:_LaunchSyncApp sync_app.pyo:1269 Config: Email: [email protected] Sync root: /Users/lgroff/Google Drive Sync collections: set([]) Upgrade number: 22 App version: 1.26.0707.2863 Selective sync: False Cloud Graph generation: 2 Folder sync: [] Local app whitelist: set([]) Local app blacklist: set([]) Bandwidth RX Rate kpBs: 0 Bandwidth TX Rate kpBs: 0 Yosemite icons upgraded: False Win10 icons upgraded: False USB sync enabled: True Do sync default folder: True 2016-01-06 09:08:43,966 -0500 INFO pid=367 4549771264:_LaunchSyncApp sync_app.pyo:1274 Switching cloud client based on new feature switches 2016-01-06 09:08:43,966 -0500 INFO pid=367 4549771264:_LaunchSyncApp docs_client_factory.pyo:97 Creating a new Wapi DocsClient 2016-01-06 09:08:43,967 -0500 INFO pid=367 4549771264:_LaunchSyncApp telemetry.pyo:228 SetPushClientVersion: 1 (3, 20130807) 2016-01-06 09:08:43,967 -0500 INFO pid=367 4549771264:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.push.telemetry.PushTelemetry'>' 2016-01-06 09:08:43,967 -0500 INFO pid=367 4549771264:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.telemetry.telemetry_manager.TelemetryManager'>' 2016-01-06 09:08:44,517 -0500 INFO pid=367 4549771264:_LaunchSyncApp image_resources.py:268 Loading custom image resources/images/folder-mac.icns with function _CreateNSlmage 2016-01-06 09:08:44,519 -0500 INFO pid=367 4549771264:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.roots.root_wrangler.RootWrangler'>. 2016-01-06 09:08:44,522 -0500 INFO pid=367 4549771264:_LaunchSyncApp root_wrangler.pyo:65 RootWrangler.RootObserverRegistered with roots [_MyDriveRoot(u'/Users/lgroff/Google Drive', 'root', <RootState.INITED: 2>)] 2016-01-06 09:08:44,524 -0500 INFO pid=367 4549771264:_LaunchSyncApp root_wrangler.pyo:73 RootWrangler.RootsAdded with roots (24yDriveRoot(u'/Users/lgroff/Google Drive', 'root', <RootState.INITED: 2>)] 2016-01-06 09:08:44,524 -0500 INFO pid=367 4549771264:_LaunchSyncApp root_wrangler.pyo:79 RootWrangler got inited root _MyDriveRoot(u'/Users/lgroff/Google Drive', 'root', <RootState.INITED: 2>) 2016-01-06 09:08:44,524 -0500 INFO pid=367 4549771264:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.downloads.DownloadCreate 2016-01-06 09:08:44,525 -0500 INFO pid=367 4549771264:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.downloads.DownloadModify 2016-01-06 09:08:44,525 -0500 INFO pid=367 4549771264:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadCreate 2016-01-06 09:08:44,525 -0500 INFO pid=367 4549771264:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadDelete 2016-01-06 09:08:44,525 -0500 INFO pid=367 4549771264:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadModify 2016-01-06 09:08:44,525 -0500 INFO pid=367 4549771264:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadMove 2016-01-06 09:08:44,526 -0500 INFO pid=367 4549771264:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadMoveFrom 2016-01-06 09:08:44,526 -0500 INFO pid=367 4549771264:_LaunchSyncApp rule_factory.pyo:159 EFTA00502553 Registering aggregation rule type: common.aggregator_rules.uploads.UploadMoveTo 2016-01-06 09:08:44,650 -0500 INFO pid=367 4563394560:FilewatcherMonitor filewatcher.pyo:71 filewatcher_ext initialized 2016-01-06 09:08:44,651 -0500 INFO pid=367 4549771264:_LaunchSyncApp docs_client_factory.pyo:97 Creating a new Wapi DocsClient 2016-01-06 09:08:44,653 -0500 INFO pid=367 4549771264:_LaunchSyncApp docs_client_factory.pyo:97 Creating a new Wapi DocsClient 2016-01-06 09:08:44,653 -0500 INFO pid=367 4549771264:_LaunchSyncApp docs_client_factory.pyo:97 Creating a new Wapi DocsClient 2016-01-06 09:08:44,654 -0500 INFO pid=367 4549771264:_LaunchSyncApp docs_client_factory.pyo:97 Creating a new Wapi DocsClient 2016-01-06 09:08:44,654 -0500 INFO pid=367 4549771264:_LaunchSyncApp docs_client_factory.pyo:97 Creating a new Wapi DocsClient 2016-01-06 09:08:44,655 -0500 INFO pid=367 4549771264:_LaunchSyncApp docs_client_factory.pyo:97 Creating a new Wapi DocsClient 2016-01-06 09:08:44,656 -0500 INFO pid=367 4549771264:_LaunchSyncApp docs_client_factory.pyo:97 Creating a new Wapi DocsClient 2016-01-06 09:08:44,656 -0500 INFO pid=367 4549771264:_LaunchSyncApp xmpplib_notifier.pyo:34 Configure storage: <common.push.tango.storage.SyncConfigStorage; proxy of <Swig Object of type 'invalidation::Storage *' at 0xl0f8a6c00> > 2016-01-06 09:08:44,657 -0500 INFO pid=367 4549771264:_LaunchSyncApp xmpplib_notifier.pyo:59 Creating client thread 2016-01-06 09:08:44,657 -0500 INFO pid=367 4549771264:_LaunchSyncApp push_xmpp_client.pyo:223 Using talk server: talk.google.com:5222 2016-01-06 09:08:44,657 -0500 INFO pid=367 4549771264:_LaunchSyncApp xmpplib_notifier.pyo:68 Creating notification bridge 2016-01-06 09:08:44,659 -0500 INFO pid=367 4549771264:_LaunchSyncApp docs_client_factory.pyo:97 Creating a new Wapi DocsClient 2016-01-06 09:08:44,661 -0500 INFO pid=367 4567601152:LocalWatcher watcher.pyo:347 LocalWatcher Run invoked.Waiting for first pass of local scan from poller to start 2016-01-06 09:08:44,662 -0500 INFO pid=367 4571807744:CloudWatcher sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-01-06 09:08:44,662 -0500 INFO pid=367 4576014336:PushNotificationKeepaliveThread sync_client_thread.pyo:175 PushNotificationKeepaliveThread run loop has started. 2016-01-06 09:08:44,662 -0500 INFO pid=367 4580220928:CrashReportUploaderThread crash_report_uploader_thread.pyo:60 Starting CrashReportUploaderThread. 2016-01-06 09:08:44,662 -0500 INFO pid=367 4584427520:LocalDiskSpaceChecker sync_client_thread.pyo:175 LocalDiskSpaceChecker run loop has started. 2016-01-06 09:08:44,663 -0500 INFO pid=367 4592840704:FeatureSwitchPoller sync_client_thread.pyo:175 FeatureSwitchPoller run loop has started. 2016-01-06 09:08:44,663 -0500 INFO pid=367 4597047296:Worker-1 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-01-06 09:08:44,663 -0500 INFO pid=367 4601253888:Worker-0 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-01-06 09:08:44,664 -0500 INFO pid=367 4605460480:LocalFSPoller sync_client_thread.pyo:175 LocalFSPoller run loop has started. 2016-01-06 09:08:44,664 -0500 INFO pid=367 4609667072:XmppClient telemetry.pyo:153 Push state None => PushStates.CONNECTING 2016-01-06 09:08:44,664 -0500 INFO pid=367 4613873664:TelemetryUploaderThread sync_client_thread.pyo:175 TelemetryUploaderThread run loop has started. 2016-01-06 09:08:44,665 -0500 INFO pid=367 4626493440:TelemetryStoreSizeMonitorThread sync_client_thread.pyo:175 TelemetryStoreSizeMonitorThread run loop has started. 2016-01-06 09:08:44,665 -0500 INFO pid=367 4622286848:Batcher sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-01-06 09:08:44,665 -0500 INFO pid=367 4630700032:PushTelemetryThread sync_client_thread.pyo:175 PushTelemetryThread run loop has started. 2016-01-06 09:08:44,665 -0500 INFO pid=367 4634906624:PauseTelemetryThread sync_client_thread.pyo:175 PauseTelemetryThread run loop has started. 2016-01-06 09:08:44,665 -0500 INFO pid=367 4643319808:Worker-2 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db EFTA00502554 2016-01-06 09:08:44,666 -0500 INFO pid=367 4647526400:RawEventUpgrader sync_client_thread.pyo:175 RawEventUpgrader run loop has started. 2016-01-06 09:08:44,666 -0500 INFO pid=367 4651732992:OverlayStatusCleaner sync_client_thread.pyo:175 OverlayStatusCleaner run loop has started. 2016-01-06 09:08:44,666 -0500 INFO pid=367 4549771264:_LaunchSyncApp drive_extension_installer.pyo:174 Uninstalling extension nknebiagdodnminbdpflhpkgfpeijdbf 2016-01-06 09:08:44,697 -0500 INFO pid=367 4592840704:FeatureSwitchPoller feature_switch_manager.pyo:644 Calling server to get feature switches. 2016-01-06 09:08:44,698 -0500 INFO pid=367 4576014336:PushNotificationKeepaliveThread sync_http_client.pyo:236 Opening direct connecton to accounts.google.com:443. 2016-01-06 09:08:44,700 -0500 INFO pid=367 4571807744:CloudWatcher sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-01-06 09:08:44,701 -0500 INFO pid=367 4609667072:XmppClient connection_task.pyo:151 Recalculated LoginTask timeout: 16.000000 2016-01-06 09:08:44,701 -0500 INFO pid=367 4597047296:Worker-1 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-01-06 09:08:44,702 -0500 INFO pid=367 4601253888:Worker-0 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-01-06 09:08:44,702 -0500 INFO pid=367 4626493440:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo:44 Checking Telemetry store size. 2016-01-06 09:08:44,703 -0500 INFO pid=367 4622286848:Batcher sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-01-06 09:08:44,705 -0500 INFO pid=367 4592840704:FeatureSwitchPoller drive_resource.pyo:130 Initialize apiclient Drive resource for [email protected] 2016-01-06 09:08:44,705 -0500 INFO pid=367 4643319808:Worker-2 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-01-06 09:08:44,706 -0500 INFO pid=367 4549771264:_LaunchSyncApp utils.pyo:714 Execute cleanup callback 'persistence_sqlite:f338fba003914a38a893e59fal3ea586/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2016-01-06 09:08:44,706 -0500 INFO pid=367 4609667072:XmppClient telemetry.pyo:167 PushStates.CONNECTING: +0.0421033 => 0.0421033 2016-01-06 09:08:44,707 -0500 INFO pid=367 4592840704:FeatureSwitchPoller drive_resource.pyo:178 Drive SDK baseUrl = https://www.googleapis.com/drive/v2internal/ 2016-01-06 09:08:44,707 -0500 INFO pid=367 4571807744:CloudWatcher utils.pyo:737 AddCleanupCallback persistence_sqlite:50d8c5f8e02d4ee09c8f789a0c00403d/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-01-06 09:08:44,708 -0500 INFO pid=367 4549771264:_LaunchSyncApp sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-01-06 09:08:44,708 -0500 INFO pid=367 4609667072:XmppClient xmpplib.pyo:80 Connecting to talk.google.com:5222 2016-01-06 09:08:44,708 -0500 INFO pid=367 4601253888:Worker-0 utils.pyo:737 AddCleanupCallback persistence_sqlite:795elfalc7344f34b5b3dc4e1c6a52de/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-01-06 09:08:44,709 -0500 INFO pid=367 4571807744:CloudWatcher utils.pyo:737 AddCleanupCallback persistence_sqlite:6df27f3bc70e449ba2cf5310ec45ffff/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-01-06 09:08:44,709 -0500 INFO pid=367 4597047296:Worker-1 utils.pyo:737 AddCleanupCallback persistence_sqlite:6b41e95ed0874f43beld0368932a9553/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-01-06 09:08:44,710 -0500 INFO pid=367 4622286848:Batcher utils.pyo:737 AddCleanupCallback persistence_sqlite:2556513e2e074b69a66fe4b083deale2/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-01-06 09:08:44,710 -0500 INFO pid=367 4643319808:Worker-2 utils.pyo:737 EFTA00502555 AddCleanupCallback persistence_sqlite:11e9ae6c3eeb434f9b56b63cbb94099d/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-01-06 09:08:44,710 -0500 INFO pid=367 4549771264:_LaunchSyncApp utils.pyo:714 Execute cleanup callback 'persistence_sqlite:05608d5e2f434484a3847a2bb8065ad2/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2016-01-06 09:08:44,710 -0500 INFO pid=367 4601253888:Worker-0 utils.pyo:737 AddCleanupCallback persistence_sqlite:b17c8cacf2f74e16a6adb6a5677772a7/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-01-06 09:08:44,711 -0500 INFO pid=367 4571807744:CloudWatcher cloud_graph.pyo:115 Initialize persistent graph with generation 2 2016-01-06 09:08:44,711 -0500 INFO pid=367 4597047296:Worker-1 utils.pyo:737 AddCleanupCallback persistence_sqlite:498edfd045b54234b42d85f729adcf5d/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-01-06 09:08:44,711 -0500 INFO pid=367 4622286848:Batcher utils.pyo:737 AddCleanupCallback persistence_sqlite:de378073cf064ebc9b9cb47c25b9826f/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-01-06 09:08:44,711 -0500 INFO pid=367 4643319808:Worker-2 utils.pyo:737 AddCleanupCallback persistence_sqlite:0ed7293bfe904b67af727c22ef13276c/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-01-06 09:08:44,711 -0500 INFO pid=367 4549771264:_LaunchSyncApp sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-01-06 09:08:44,712 -0500 INFO pid=367 4601253888:Worker-0 command_factory.pyo:186 Registering worker command type: common.worker.downloads.DownloadChangeACL 2016-01-06 09:08:44,712 -0500 INFO pid=367 4571807744:CloudWatcher cloud_graph.pyo:1563 Current sync config generation: 2 2016-01-06 09:08:44,713 -0500 INFO pid=367 4597047296:Worker-1 command_factory.pyo:186 Registering worker command type: common.worker.downloads.DownloadChangeACL 2016-01-06 09:08:44,713 -0500 INFO pid=367 4643319808:Worker-2 command_factory.pyo:186 Registering worker command type: common.worker.downloads.DownloadChangeACL 2016-01-06 09:08:44,745 -0500 INFO pid=367 4609667072:XmppClient telemetry.pyo:167 PushStates.CONNECTING: +0.0392416 => 0.081345 2016-01-06 09:08:44,746 -0500 INFO pid=367 4592840704:FeatureSwitchPoller drive_request.pyo:285 Drive request: ListFeatureSwitches(tags=Reason.SYNC_OTHER) - Read request - [email protected] 2016-01-06 09:08:44,746 -0500 INFO pid=367 4601253888:Worker-0 command_factory.pyo:186 Registering worker command type: common.worker.downloads.DownloadCreate 2016-01-06 09:08:44,746 -0500 INFO pid=367 4571807744:CloudWatcher cloud_graph.pyo:1415 Cleanup cloud graph directory '/Users/lgroff/Library/Application Support/Google/Drive/user_default/cloud_graph' of files idict_*.db" except ( 1 dict_2.db 1 , Idict_2.db-shml, idict_2.db-wal') 2016-01-06 09:08:44,747 -0500 INFO pid=367 4597047296:Worker-1 command_factory.pyo:186 Registering worker command type: common.worker.downloads.DownloadCreate 2016-01-06 09:08:44,747 -0500 INFO pid=367 4643319808:Worker-2 command_factory.pyo:186 Registering worker command type: common.worker.downloads.DownloadCreate 2016-01-06 09:08:44,747 -0500 INFO pid=367 4609667072:XmppClient telemetry.pyo:153 Push state PushStates.CONNECTING => PushStates.NEGOTIATING 2016-01-06 09:08:44,750 -0500 INFO pid=367 4592840704:FeatureSwitchPoller discovery.pyo:762 URL being requested: GET https://www.googleapis.com/drive/v2internal/settings? fields=items%2Fkey%2Citems%2FValue&reason=304&namespace=FEATURE_SWITCH&alt=json 2016-01-06 09:08:44,750 -0500 INFO pid=367 4601253888:Worker-0 command_factory.pyo:186 Registering worker command type: common.worker.downloads.DownloadDelete 2016-01-06 09:08:44,751 -0500 INFO pid=367 4597047296:Worker-1 command_factory.pyo:186 Registering worker command type: common.worker.downloads.DownloadDelete 2016-01-06 09:08:44,751 -0500 INFO pid=367 4643319808:Worker-2 command_factory.pyo:186 Registering worker command type: common.worker.downloads.DownloadDelete 2016-01-06 09:08:44,751 -0500 INFO pi