EFTA00504331.pdf

From: File "Nolumes/BuildData/pulse- datathgents/599758/recipes/986239094/base/b/drb/googleclient/apps/webdrive_sync/osx/dist/Google Drive.app/Contents/ftesources/_boot_.py", line 77, in <module> File "Nolumes/BuildData/pulse- datathgents/599758/recipes/986239094/base/b/drb/googleclient/apps/webdrive_sync/osxklist/Google Drive.app/Contents/ftesources/_boot_.py", line 62, in _run File "/Applications/Google 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 "osx/GSyncAppDelegate.pyo", line 296, in applicationWillTerminate_ File "osx/mac_sync_app_controller.pyo", line 266, in Exit File "common/ui_action_handler.pyo", line 444, in Quit File "common/sync_app.pyo", line 1793, in Quit 2016-07-28 16:59:26,761 -0400 INFO pid=19999 140735151050752:MainThread thread_manager.pyo:116 Stop was called 2016-07-28 16:59:26,761 -0400 INFO pid=19999 140735151050752:MainThread thread_manager.pyo:253 Asking <IpcServerThread(IpcServerThread, started 123145311952896)> with tid 123145311952896 to stop. 2016-07-28 16:59:26,761 -0400 INFO pid=19999 140735151050752:MainThread thread_manager.pyo:253 Asking <LocalWatcher(LocalWatcher, started 123145329315840)> with tid 123145329315840 to stop. 2016-07-28 16:59:26,762 -0400 INFO pid=19999 140735151050752:MainThread thread_manager.pyo:253 Asking <SyncClientImpressionsThread(SyncClientImpressionsThread, started 123145388208128)> with tid 123145388208128 to stop. 2016-07-28 16:59:26,762 -0400 INFO pid=19999 123145325109248:FilewatcherMonitor sync_client_thread.pyo:83 ThreadExit: thread FilewatcherMonitor exiting normalish 2016-07-28 16:59:26,763 -0400 INFO pid=19999 123145329315840:LocalWatcher sync_client_thread.pyo:83 ThreadExit: thread LocalWatcher exiting normalish 2016-07-28 16:59:26,763 -0400 INFO pid=19999 140735151050752:MainThread thread_manager.pyo:253 Asking <FeatureSwitchPoller(FeatureSwitchPoller, started 123145341935616)> with tid 123145341935616 to stop. 2016-07-28 16:59:26,763 -0400 INFO pid=19999 123145388208128:SyncClientImpressionsThread sync_client_thread.pyo:212 SyncClientImpressionsThread run loop has terminated. 2016-07-28 16:59:26,764 -0400 INFO pid=19999 123145388208128:SyncClientImpressionsThread sync_client_thread.pyo: 83 ThreadExit: thread SyncClientImpressionsThread exiting normalish 2016-07-28 16:59:26,764 -0400 INFO pid=19999 140735151050752:MainThread thread_manager.pyo:253 Asking <PauseTelemetryThread(PauseTelemetryThread, started 123145337729024)> with tid 123145337729024 to stop. 2016-07-28 16:59:26,764 -0400 INFO pid=19999 123145341935616:FeatureSwitchPoller sync_client_thread.pyo:212 FeatureSwitchPoller run loop has terminated. 2016-07-28 16:59:26,765 -0400 INFO pid=19999 140735151050752:MainThread thread_manager.pyo:253 Asking <LocalFSPoller(LocalFSPoller, started 123145346142208)> with tid 123145346142208 to stop. 2016-07-28 16:59:26,765 -0400 INFO pid=19999 123145341935616:FeatureSwitchPoller sync_client_thread.pyo:83 ThreadExit: thread FeatureSwitchPoller exiting normalish 2016-07-28 16:59:26,765 -0400 INFO pid=19999 123145337729024:PauseTelemetryThread sync_client_thread.pyo:212 PauseTelemetryThread run loop has terminated. 2016-07-28 16:59:26,765 -0400 INFO pid=19999 140735151050752:MainThread thread manager.pyo:253 Asking <SyncClientWaitingThreadWithCallback(DocIdsFetcherThread- , started 123145350348800)> with tid 123145350348800 to stop. 2016-07-28 16:59:26,765 -0400 INFO pid=19999 123145346142208:LocalFSPoller sync_client_thread.pyo:212 LocalFSPoller run loop has terminated. 2016-07-28 16:59:26,766 -0400 INFO pid=19999 140735151050752:MainThread thread_manager.pyo:253 Asking <PushTelemetryThread(PushTelemetryThread, started 123145426067456)> with tid 123145426067456 to stop. 2016-07-28 16:59:26,766 -0400 INFO pid=19999 123145350348800:DocIdsFetcherThread- sync_client_thread.pyo:272 DocldsFetcherThread- run loop has terminated. 2016-07-28 16:59:26,766 -0400 INFO pid=19999 123145337729024:PauseTelemetryThread pause_telemetry.pyo:127 Attempting final telemetry harvest. 2016-07-28 16:59:26,766 -0400 INFO pid=19999 123145346142208:LocalFSPoller sync_client_thread.pyo:83 ThreadExit: thread LocalFSPoller exiting normalish EFTA00504331 2016-07-28 16:59:26,766 -0400 INFO pid=19999 140735151050752:MainThread thread_manager.pyo:253 Asking <PushNotificationKeepaliveThread(PushNotificationKeepaliveThread, started 123145354555392)> with tid 123145354555392 to stop. 2016-07-28 16:59:26,766 -0400 INFO pid=19999 123145426067456:PushTelemetryThread sync_client thread.pyo:212 PushTelemetryThread run loop has terminated. 2016-07-28 16:59:26,766 -0400 INFO pid=19999 123145350348800:DocIdsFetcherThread- sync_client_thread.pyo:83 ThreadExit: thread DocldsFetcherThread- exiting normalish 2016-07-28 16:59:26,766 -0400 INFO pid=19999 123145337729024:PauseTelemetryThread pause_telemetry.pyo:188 Harvested pause statistics at t=1469739566.77: (‹PauseReason.API ERRORS: 'pause api err'>: _HarvestStat(paused=0.0, trial=0.0, occurrences=0), <17.auseReason.BLOEKIN5_ERRORS: 'pause blocking_err'>: _HarvestStat(paused=0.0, trial=0.0, occurrences=0), <PauseReason.NETWORK_ERROTLS: 'pause_net err'>: HarvestStat(paused=0.0, _ _ _HarvestStat(paused=0.0, trial=0.0, trial=0.0, occurrences=0), occurrences=0), <PauseReason.USER: 'pause user'>: <PauseReason.OFFLINE: 'pause offline'>: _ HarvestStat(paused=0.0, trial=0.0, occurrences=0), <PauseReason.NO LOCAL DISK SfiACE: _ _ 'pause no space'>: _HarvestStat(paused=0.0, trial=0.0, occurrences=0)) 2016-07-28 16:59:26,767 -0400 INFO pid=19999 123145426067456:PushTelemetryThread telemetry.pyo:207 Attempting final telemetry harvest. 2016-07-28 16:59:26,767 -0400 INFO pid=19999 123145354555392:PushNotificationKeepaliveThread sync client thread.pyo:212 PushNotificationKeepaliveThread run loop has terminated. 2016-07-28 16:59:26,767 -0400 INFO pid=19999 140735151050752:MainThread thread_manager.pyo:253 Asking <CrashReportUploaderThread(CrashReportUploaderThread, started 123145371381760)> with tid 123145371381760 to stop. 2016-07-28 16:59:26,767 -0400 INFO pid=19999 123145337729024:PauseTelemetryThread sync_client thread.pyo:83 ThreadExit: thread PauseTelemetryThread exiting normalish 2016-07-28 16:59:26,767 -0400 INFO pid=19999 123145426067456:PushTelemetryThread telemetry.pyo:167 PushStates.ONLINE: +2923.46 => 28118.8 2016-07-28 16:59:26,767 -0400 INFO pid=19999 123145354555392:PushNotificationKeepaliveThread sync_client_thread.pyo: 83 ThreadExit: thread PushNotificationKeepaliveThread exiting normalish 2016-07-28 16:59:26,768 -0400 INFO pid=19999 140735151050752:MainThread thread_manager.pyo:253 Asking <TelemetryStoreSizeMonitor(TelemetryStoreSizeMonitorThread, started 123145358761984)> with tid 123145358761984 to stop. 2016-07-28 16:59:26,768 -0400 INFO pid=19999 123145371381760:CrashReportUploaderThread sync_client thread.pyo:83 ThreadExit: thread CrashReportUploaderThread exiting normalish 2016-07-28 16:59:26,768 -0400 INFO pid=19999 123145426067456:PushTelemetryThread sync_client thread.pyo:83 ThreadExit: thread PushTelemetryThread exiting normalish 2016-07-28 16:59:26,769 -0400 INFO pid=19999 123145358761984:TelemetryStoreSizeMonitorThread sync_client thread.pyo:212 TelemetryStoreSizeMonitorThread run loop has terminated. 2016-07-28 16:59:26,769 -0400 INFO pid=19999 140735151050752:MainThread thread_manager.pyo:253 Asking <OverlayStatusCleaner(OverlayStatusCleaner, started 123145362968576)> with tid 123145362968576 to stop. 2016-07-28 16:59:26,769 -0400 INFO pid=19999 123145358761984:TelemetryStoreSizeMonitorThread sync_client_thread.pyo: 83 ThreadExit: thread TelemetryStoreSizeMonitorThread exiting normalish 2016-07-28 16:59:26,769 -0400 INFO pid=19999 140735151050752:MainThread thread_manager.pyo:253 Asking <Batcher(Batcher, started 123145367175168)> with tid 123145367175168 to stop. 2016-07-28 16:59:26,769 -0400 INFO pid=19999 123145362968576:OverlayStatusCleaner sync_client thread.pyo:212 OverlayStatusCleaner run loop has terminated. 2016-07-28 16:59:26,769 -0400 INFO pid=19999 123145362968576:OverlayStatusCleaner sync_client thread.pyo:83 ThreadExit: thread OverlayStatusCleaner exiting normalish 2016-07-28 16:59:26,769 -0400 INFO pid=19999 140735151050752:MainThread thread_manager.pyo:253 Asking <ConnectivityThread(ConnectivityThread, started 123145400827904)> with tid 123145400827904 to stop. 2016-07-28 16:59:26,770 -0400 INFO pid=19999 123145367175168:Batcher sync_client thread.pyo:272 Batcher run loop has terminated. 2016-07-28 16:59:26,770 -0400 INFO pid=19999 123145400827904:ConnectivityThread sync_client thread.pyo:83 ThreadExit: thread ConnectivityThread exiting normalish 2016-07-28 16:59:26,770 -0400 INFO pid=19999 123145367175168:Batcher sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user default/snapshot.db 2016-07-28 16:59:26,770 -0400 INFO pid=19999 140735151050752:MainThread EFTA00504332 thread_manager.pyo:253 Asking <SchedulerThread(ListenerScheduler, started 123145375588352)> with tid 123145375588352 to stop. 2016-07-28 16:59:26,771 -0400 INFO pid=19999 140735151050752:MainThread thread_manager.pyo:253 Asking <SchedulerThread(InternalScheduler, started 123145417654272)> with tid 123145417654272 to stop. 2016-07-28 16:59:26,771 -0400 INFO pid=19999 123145375588352:ListenerScheduler sync_client_thread.pyo:83 ThreadExit: thread ListenerScheduler exiting normalish 2016-07-28 16:59:26,771 -0400 INFO pid=19999 140735151050752:MainThread thread_manager.pyo:253 Asking <GroupingConfirmationThread(ConfirmationHandler, started 123145379794944)> with tid 123145379794944 to stop. 2016-07-28 16:59:26,771 -0400 INFO pid=19999 123145417654272:InternalScheduler sync_client_thread.pyo:83 ThreadExit: thread InternalScheduler exiting normalish 2016-07-28 16:59:26,772 -0400 INFO pid=19999 140735151050752:MainThread thread_manager.pyo:253 Asking <Worker(Worker-0, started 123145384001536)> with tid 123145384001536 to stop. 2016-07-28 16:59:26,772 -0400 INFO pid=19999 123145379794944:ConfirmationHandler sync_client_thread.pyo:212 ConfirmationHandler run loop has terminated. 2016-07-28 16:59:26,772 -0400 INFO pid=19999 123145379794944:ConfirmationHandler sync_client_thread.pyo:83 ThreadExit: thread ConfirmationHandler exiting normalish 2016-07-28 16:59:26,772 -0400 INFO pid=19999 123145367175168:Batcher sync_client_thread.pyo:83 ThreadExit: thread Batcher exiting normalish 2016-07-28 16:59:26,772 -0400 INFO pid=19999 140735151050752:MainThread thread_manager.pyo:253 Asking <RawEventUpgrader(RawEventUpgrader, started 123145405034496)> with tid 123145405034496 to stop. 2016-07-28 16:59:26,773 -0400 INFO pid=19999 123145367175168:Batcher threads.pyo:109 Execute cleanup callback 'persistence_sqlite:c19b5be659e34clla3540b6006b743bb/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2016-07-28 16:59:26,773 -0400 INFO pid=19999 123145384001536:Worker-0 sync_client_thread.pyo:212 Worker-0 run loop has terminated. 2016-07-28 16:59:26,773 -0400 INFO pid=19999 140735151050752:MainThread thread_manager.pyo:253 Asking <RootWrangler(RootWrangler, started 123145396621312)> with tid 123145396621312 to stop. 2016-07-28 16:59:26,773 -0400 INFO pid=19999 123145405034496:RawEventUpgrader sync_client_thread.pyo:212 RawEventUpgrader run loop has terminated. 2016-07-28 16:59:26,773 -0400 INFO pid=19999 123145367175168:Batcher sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-07-28 16:59:26,774 -0400 INFO pid=19999 123145384001536:Worker-0 sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-07-28 16:59:26,774 -0400 INFO pid=19999 123145405034496:RawEventUpgrader sync_client_thread.pyo:83 ThreadExit: thread RawEventUpgrader exiting normalish 2016-07-28 16:59:26,774 -0400 INFO pid=19999 140735151050752:MainThread thread_manager.pyo:253 Asking <CloudWatcher(CloudWatcher, started 123145392414720)> with tid 123145392414720 to stop. 2016-07-28 16:59:26,774 -0400 INFO pid=19999 123145396621312:RootWrangler sync_client_thread.pyo:212 RootWrangler run loop has terminated. 2016-07-28 16:59:26,774 -0400 INFO pid=19999 123145367175168:Batcher threads.pyo:109 Execute cleanup callback 'persistence_sqlite:36600b5537424fc197b2fd07461fl0bc/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2016-07-28 16:59:26,775 -0400 INFO pid=19999 123145396621312:RootWrangler root_wrangler.pyo:128 RootWrangler.Root0bserverUnregistered 2016-07-28 16:59:26,775 -0400 INFO pid=19999 140735151050752:MainThread thread_manager.pyo:253 Asking <PushXmppClient(XmppClient, started 123145409241088)> with tid 123145409241088 to stop. 2016-07-28 16:59:26,775 -0400 INFO pid=19999 123145392414720:CloudWatcher cloud_watcher.pyo:1075 Stop detected 2016-07-28 16:59:26,775 -0400 INFO pid=19999 123145384001536:Worker-0 sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-07-28 16:59:26,775 -0400 INFO pid=19999 123145396621312:RootWrangler sync_client_thread.pyo:83 ThreadExit: thread RootWrangler exiting normalish 2016-07-28 16:59:26,775 -0400 WARNING pid=19999 140735151050752:MainThread task.pyo:242 EFTA00504333 DriveXmppTask-0x1124dcal0 aborting: abort 2016-07-28 16:59:26,776 -0400 WARNING pid=19999 123145392414720:CloudWatcher cloud_watcher.pyo:1121 Exiting CloudWatcher.PushRunLoop() 2016-07-28 16:59:26,776 -0400 INFO pid=19999 123145384001536:Worker-0 sync_client_thread.pyo:83 ThreadExit: thread Worker-0 exiting normalish 2016-07-28 16:59:26,776 -0400 INFO pid=19999 140735151050752:MainThread task.pyo:254 Task <common.push.push_xmpp_client.DriveXmppTask object at 0x1124dcal0> complete. 2016-07-28 16:59:26,776 -0400 INFO pid=19999 123145392414720:CloudWatcher sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-07-28 16:59:26,776 -0400 INFO pid=19999 123145384001536:Worker-0 threads.pyo:109 Execute cleanup callback 'persistence_sqlite:94358a181fd944148672abf624d61f9b/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2016-07-28 16:59:26,776 -0400 INFO pid=19999 140735151050752:MainThread xmpplib.pyo:143 Close called with 'why' reason = Client initiated close 2016-07-28 16:59:26,776 -0400 INFO pid=19999 123145384001536:Worker-0 threads.pyo:109 Execute cleanup callback 'persistence_sqlite:6b54a92761a34a3abc5e0e9d434a6ba7/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2016-07-28 16:59:26,777 -0400 INFO pid=19999 123145392414720:CloudWatcher sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-07-28 16:59:26,777 -0400 INFO pid=19999 123145392414720:CloudWatcher sync_client_thread.pyo:83 ThreadExit: thread CloudWatcher exiting normalish 2016-07-28 16:59:26,778 -0400 INFO pid=19999 123145392414720:CloudWatcher threads.pyo:109 Execute cleanup callback 'persistence_sqlite:aelfb7baf90e46cf8f1701d178d0bc0a/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2016-07-28 16:59:26,778 -0400 INFO pid=19999 123145392414720:CloudWatcher threads.pyo:109 Execute cleanup callback 'persistence_sqlite:aea0fe0d7e3849198ffafal70e8d4dbb/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2016-07-28 16:59:26,778 -0400 INFO pid=19999 123145392414720:CloudWatcher threads.pyo:109 Execute cleanup callback 'DBConnectionManagerCleanupCallback' 2016-07-28 16:59:26,778 -0400 INFO pid=19999 123145392414720:CloudWatcher db_connection.pyo:433 Closing ManagedConnection(id=11295AD50, thread=CloudWatcher- 7000055EE000, path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/cloud_graph/dict_2.db, closed=False) 2016-08-08 09:12:03,098 -0400 INFO pid=1033 140735306059776:MainThread logging_config.pyo:257 OS: Darwin/10.11.5 2016-08-08 09:12:03,099 -0400 INFO pid=1033 140735306059776:MainThread logging_config.pyo:260 Google Drive (build 1.30.2170.0459) 2016-08-08 09:12:03,099 -0400 INFO pid=1033 140735306059776:MainThread logging_config.pyo:261 SSL: OpenSSL 0.9.8zh 14 Jan 2016 2016-08-08 09:12:03,153 -0400 INFO pid=1033 140735306059776:MainThread GSyncAppDelegate.pyo:199 Application did finish launching. 2016-08-08 09:12:03,286 -0400 INFO pid=1033 140735306059776:MainThread service.pyo:132 Creating singleton service instance of '<class 'common.file_lock.FileLocki> 1 2016-08-08 09:12:03,287 -0400 INFO pid=1033 140735306059776:MainThread service.pyo:132 Creating singleton service instance of '<class 'common.file_lock.FileLocki> 1 2016-08-08 09:12:03,288 -0400 INFO pid=1033 123145309270016:RunAsync-_InitializeSyncAppAsync- 1 service.pyo:132 Creating singleton service instance of '<class 'common.service.user.User'> 1 2016-08-08 09:12:03,289 -0400 INFO pid=1033 123145309270016:RunAsync-_InitializeSyncAppAsync- 1 service.pyo:132 Creating singleton service instance of '<class 'common. roots. roots. RootManager'>' 2016-08-08 09:12:03,289 -0400 INFO pid=1033 123145309270016:RunAsync-_InitializeSyncAppAsync- 1 service.pyo:132 Creating singleton service instance of '<class 'common.thread_manager.ThreadManager'> 1 2016-08-08 09:12:03,289 -0400 INFO pid=1033 123145309270016:RunAsync-_InitializeSyncAppAsync- 1 service.pyo:132 Creating singleton service instance of '<class 'common.pause_manager.Service'>' 2016-08-08 09:12:03,289 -0400 INFO pid=1033 123145309270016:RunAsync-_InitializeSyncAppAsync- 1 sync_app.pyo:348 Getting TokenStorage... 2016-08-08 09:12:03,290 -0400 INFO pid=1033 123145309270016:RunAsync-_InitializeSyncAppAsync- EFTA00504334 1 sync_app.pyo:350 Got token storage: <platforms.token_storage.TokenStorage object at 0x10fa29990> 2016-08-08 09:12:03,290 -0400 INFO pid=1033 123145309270016:RunAsync-_InitializeSyncAppAsync- 1 service.pyo:132 Creating singleton service instance of '<class 'common.features.AppFeatures'>' 2016-08-08 09:12:03,290 -0400 INFO pid=1033 123145309270016:RunAsync-_InitializeSyncAppAsync- 1 service.pyo:132 Creating singleton service instance of '<class 'common.cert.Manager'> 1 2016-08-08 09:12:03,299 -0400 INFO pid=1033 123145309270016:RunAsync-_InitializeSyncAppAsync- 1 service.pyo:132 Creating singleton service instance of '<class 'common.net.bandwidth.BandwidthThrottler'> 1 2016-08-08 09:12:03,303 -0400 INFO pid=1033 123145309270016:RunAsync-_InitializeSyncAppAsync- 1 service.pyo:132 Creating singleton service instance of '<class 'common.persistence.persistence.Factory'>' 2016-08-08 09:12:03,303 -0400 INFO pid=1033 123145309270016:RunAsync-_InitializeSyncAppAsync- 1 persistence.pyo:39 Initialize factory with policy PlatformPolicy(google_drive_config_directorypath=u'/Users/lgroff/Library/Application Support/Google/Drive', main_sync_root=None, system_download_cache_folder=None, process_id=None) 2016-08-08 09:12:03,303 -0400 INFO pid=1033 123145309270016:RunAsync-_InitializeSyncAppAsync- 1 service.pyo:132 Creating singleton service instance of '<class 'common.persistence.sync_config_sqlite.SyncConfignLitel> 1 2016-08-08 09:12:03,303 -0400 INFO pid=1033 123145309270016:RunAsync-_InitializeSyncAppAsync- 1 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-08-08 09:12:03,305 -0400 INFO pid=1033 123145309270016:RunAsync-_InitializeSyncAppAsync- 1 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-08-08 09:12:03,305 -0400 INFO pid=1033 123145309270016:RunAsync-_InitializeSyncAppAsync- 1 threads. pyo:130 AddCleanupCallback persistence_sqlite:d383a59af9b540ed85881467a0aafb2e/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-08-08 09:12:03,306 -0400 INFO pid=1033 123145309270016:RunAsync-_InitializeSyncAppAsync- 1 threads.pyo:130 AddCleanupCallback persistence_sqlite:620139e14e474ddbbf25f07791b7e293/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-08-08 09:12:03,313 -0400 INFO pid=1033 123145309270016:RunAsync-_InitializeSyncAppAsync- 1 sync_app.pyo:565 BandwidthThrottler configured via sync_config 2016-08-08 09:12:03,314 -0400 INFO pid=1033 123145309270016:RunAsync-_InitializeSyncAppAsync- 1 bandwidth.pyo:59 BandwidthThrottler.SetRxBytesPerSecond 0 2016-08-08 09:12:03,314 -0400 INFO pid=1033 123145309270016:RunAsync-_InitializeSyncAppAsync- 1 bandwidth.pyo:68 BandwidthThrottler.SetTxBytesPerSecond 0 2016-08-08 09:12:03,314 -0400 INFO pid=1033 123145309270016:RunAsync-_InitializeSyncAppAsync- 1 sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-08-08 09:12:03,314 -0400 INFO pid=1033 123145309270016:RunAsync-_InitializeSyncAppAsync- 1 sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-08-08 09:12:03,315 -0400 INFO pid=1033 123145309270016:RunAsync-_InitializeSyncAppAsync- 1 threads.pyo:109 Execute cleanup callback 'persistence_sqlite:d383a59af9b540ed85881467a0aafb2e/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2016-08-08 09:12:03,316 -0400 INFO pid=1033 123145309270016:RunAsync-_InitializeSyncAppAsync- 1 threads.pyo:109 Execute cleanup callback 'persistence_sqlite:620139e14e474ddbbf25f07791b7e293/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2016-08-08 09:12:03,393 -0400 INFO pid=1033 140735306059776:MainThread image_resources.py:253 Loading image images/ic_drawer_24.png 2016-08-08 09:12:03,397 -0400 INFO pid=1033 140735306059776:MainThread image_resources.py:253 Loading image images/menu_drive-logo.png 2016-08-08 09:12:03,399 -0400 INFO pid=1033 140735306059776:MainThread image_resources.py:253 Loading image images/menu_google-logo-gray.png 2016-08-08 09:12:03,403 -0400 INFO pid=1033 140735306059776:MainThread image_resources.py:253 Loading image images/ic_folder_mydrive_24.png 2016-08-08 09:12:03,406 -0400 INFO pid=1033 140735306059776:MainThread image_resources.py:253 Loading image images/ic_web_24.png EFTA00504335 2016-08-08 09:12:03,408 -0400 INFO pid=1033 140735306059776:MainThread image_resources.py:253 Loading image images/ic_sync_problem_24.png 2016-08-08 09:12:03,417 -0400 INFO pid=1033 140735306059776:MainThread image_resources.py:253 Loading image images/ic_done.png 2016-08-08 09:12:03,482 -0400 INFO pid=1033 123145316159488:ThreadMonitor thread_manager.pyo:339 Waiting on exit condition. Wake up after 3600s. 2016-08-08 09:12:03,482 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-08-08 09:12:03,484 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-08-08 09:12:03,485 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp threads.pyo:130 AddCleanupCallback persistence_sqlite:12e6e92de6a940a589b2a2lbe43caaad/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-08-08 09:12:03,485 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp threads.pyo:130 AddCleanupCallback persistence_sqlite:c8fa083ea7c6481e8ea7eb482fa80e82/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-08-08 09:12:03,527 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp user.pyo:68 Initializing User instance with new credentials. None 2016-08-08 09:12:03,527 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp docs_client_factory.pyo:86 Creating a new DriveClient 2016-08-08 09:12:03,527 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.quota.Quotalnfo'>' 2016-08-08 09:12:03,529 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.token_bucket.CloudRucketManager'> 1 2016-08-08 09:12:03,529 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive_api.drive_resource.Manager'>. 2016-08-08 09:12:03,530 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive_api.http.Manager'>. 2016-08-08 09:12:03,530 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp drive_resource.pyo:167 Initialize apiclient Drive resource for current user token 2016-08-08 09:12:03,531 -0400 ERROR pid=1033 123145324572672:IpcServerThread ipc_socket_base.pyo:247 Failed to bind to socket /Users/lgroff/Library/Group Containers/google_drive/tmpnfutrE (attempt 1 of 3) Traceback (most recent call last): File "common/ipc/ipc_socket_base.pyo", line 242, in Bind File "common/ipc/ipc_socket_base.pyo", line 176, in Bind File "socket.pyo", line 228, in meth error: (Errno 48] Address already in use 2016-08-08 09:12:03,541 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp drive_resource.pyo:228 Drive SDK baseUrl = https://www.googleapis.com/drive/v2internal/ 2016-08-08 09:12:03,542 -0400 ERROR pid=1033 123145324572672:IpcServerThread ipc_socket_base.pyo:247 Failed to bind to socket /Users/lgroff/Library/Group Containers/google_drive/tmpnfutrE (attempt 2 of 3) Traceback (most recent call last): File "common/ipc/ipc_socket_base.pyo", line 242, in Bind File "common/ipc/ipc_socket_base.pyo", line 176, in Bind File "socket.pyo", line 228, in meth error: (Errno 48] Address already in use 2016-08-08 09:12:03,543 -0400 ERROR pid=1033 123145324572672:IpcServerThread ipc_socket_base.pyo:247 Failed to bind to socket /Users/lgroff/Library/Group Containers/google_drive/tmpnfutrE (attempt 3 of 3) Traceback (most recent call last): File "common/ipc/ipc_socket_base.pyo", line 242, in Bind File "common/ipc/ipc_socket_base.pyo", line 176, in Bind File "socket.pyo", line 228, in meth error: (Errno 48] Address already in use 2016-08-08 09:12:03,544 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive_api.http.AccessTokenInMemoryCache'>. 2016-08-08 09:12:03,544 -0400 WARNING pid=1033 123145324572672:IpcServerThread server.pyo:145 Socket (/Users/lgroff/Library/Application Support/Google/Drive/GoogleDrivelpcPipe) already in EFTA00504336 use, deleting it. 2016-08-08 09:12:03,544 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp drive_request.pyo:297 Drive request: About (tags=Reason.SYNC_OTHER(SyncType.UNKNOWN_SYNC_TYPE) ) - Read request - None 2016-08-08 09:12:03,547 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp discovery.pyo:762 URL being requested: GET https://www.googleapis.com/drive/v2internal/about? fields=rootFolderld%2CquotaBytesTotal%2CquotaBytesUsedAggregate%2CquotaBytesUsedInTrash%2Cquo taType%2Cuser%2FemailAddress&reason=304Salt=json 2016-08-08 09:12:03,548 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp client.pyo:515 Attempting refresh to obtain initial access_token 2016-08-08 09:12:03,549 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp client.pyo:755 Refreshing access_token 2016-08-08 09:12:03,552 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp system_proxy_resolver.pyo:62 OS proxy config: ExceptionsList = "*.local", "169.254/16" FTPPassive = 1; " SCOPED " = enl = ExceptionsList = "*.local", "169.254/16" ); FTPPassive = 1; ( 2016-08-08 09:12:03,553 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp system_proxy_resolver.pyo:89 no manual proxies found 2016-08-08 09:12:03,553 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.net.dapper.DapperService'>' 2016-08-08 09:12:03,553 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp http.pyo:257 Request user-agent: Python-httplib2/0.9.2 (gzip) 2016-08-08 09:12:03,553 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp sync_http_client.pyo:238 Opening direct connection to accounts.google.com:443. 2016-08-08 09:12:03,708 -0400 INFO pid=1033 123145320366080: LaunchSyncApp http.pyo:276 Response: 154 bytes - application/json; charset=utf-8 (encoding:gzip) 2016-08-08 09:12:03,708 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp system_proxy_resolver.pyo:62 OS proxy config: ExceptionsList = "*.local", "169.254/16" FTPPassive = 1; " SCOPED " = enl = ExceptionsList "*.local", "169.254/16" I; 1; ); FTPPassive = 1; ( 2016-08-08 09:12:03,709 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp system_proxy_resolver.pyo:89 no manual proxies found 2016-08-08 09:12:03,709 -0400 INFO pid=1033 123145320366080: LaunchSyncApp http.pyo:257 Request user-agent: googledrivesync-1.30.2170.0459 google-api-python-client/1.3.1 (gzip) (Darwin/10.11.5) 2016-08-08 09:12:03,709 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp sync_http_client.pyo:238 Opening direct connection to www.googleapis.com:443. 2016-08-08 09:12:04,438 -0400 INFO pid=1033 140735306059776:MainThread sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application EFTA00504337 Support/Google/Drive/user_default/snapshot.db 2016-08-08 09:12:04,439 -0400 INFO pid=1033 140735306059776:MainThread sqlite.pyo:276 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-08-08 09:12:04,439 -0400 INFO pid=1033 140735306059776:MainThread sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-08-08 09:12:04,439 -0400 INFO pid=1033 140735306059776:MainThread sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user default/sync_config.db 2016-08-08 09:12:04,721 -0400 INFO pid=1033 123145320366080: LaunchSyncApp http.pyo:276 Response: 242 bytes - application/json; charset=UTF-8 (encoding:gzip) 2016-08-08 09:12:04,723 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp drive_request.pyo:304 Drive response: Request (None): About (tags=Reason.SYNC_OTHER(SyncType.UNKNOWN_SYNC_TYPE) ) Response: About(root_id=0ABNN8iEiWGvgUk9PVA, email address quota bytes_total=107374182400, quota_bytes used aggregate=17316388172, quota—bytes used_in_trash=413949529, quota iype=IIMITED) 2016-08-08 09:12:04,724 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive_api.doc_id_provider.Store'>' 2016-08-08 09:12:04,724 -0400 INFO pid=1033 123145320366080: LaunchSyncApp user.pyo:68 Initializing User instance with new credentials. 2016-08-08 09:12:04,724 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp sync_app.pyo:1368 Configuring sync app from feature switches. 2016-08-08 09:12:04,724 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp features.pyo:112 Loads feature switches. 2016-08-08 09:12:04,724 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp feature_switch manager.pyo:674 Calling server to get feature switches. 2016-08-08 09:12:04,725 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp drive request.pyo:297 Drive request: ListFiatureSwitches(tags=Reason.SYNC_OTHER(SyncType.UNKNOWN_SYNC_TYPE)) - Read request - 2016-08-08 09:12:04,727 -0400 INFO pid=1033 123145320366080: LaunchSyncApp discovery.pyo:762 URL being requested: GET https://www.googleapis.com/drive/v2internal/settings? fields=items%2Fkey%2Citems%2Fvalue&reason=304&namespace=FEATURE_SWITCHfialt=json 2016-08-08 09:12:04,728 -0400 INFO pid=1033 123145320366080: LaunchSyncApp http.pyo:257 Request user-agent: googledrivesync-1.30.2170.0459 google-api-python-client/1.3.1 (gzip) (Darwin/10.11.5) 2016-08-08 09:12:04,805 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp http.pyo:276 Response: 1734 bytes - application/json; charset=UTF-8 (encoding:gzip) 2016-08-08 09:12:04,807 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp drive_request.pyo:304 Drive response: Request ( ): ListFeatureSwitches(tags=Reason.SYNC_OTHER(SyncType.UNKNOWN_SYNC_TYPE)) Response: (u'cloud_graph_disk_generation': u'5', u'crash_throttle_percentage': u'0 1, u'download_in_place': u'true', u'enable_arbitrary_sync': u'false', u'enable_change_filters': u'true', u'enable_disk_check_on_preferences': u'true', u'enable_disk_check_on_setup': u'true', u'enable_feedback': u'true', u'enable_impressions_library': u'true', u'enable_local_v2 1: u'false', u'enable_multipause': u'true', u'enable_multiple_accounts': u'false', u'enable_push': u'true', u'enable_recursivesize': u'true', u'enable_shared_move_confirmation': u'true', u'enable_sync_options_in_setup_flow': u'true', u'enable_usb_detection': u'false', u'log_backup_count': u'0', EFTA00504338 u'max_batch_upload_files': u'30', u'max_page_size_changes.: u'1000', u'max_page_size_cloud_graph': u'4000', u'max_page_size_selective_sync': u'4000', u'perf_throttle_percentage': u'100', u'query_strategy': u'root', u'selective_sub_folder_synci: u'true', u'test.featureswitch.name': u", u'use_drive_api': u'true'} 2016-08-08 09:12:04,809 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp sync_app.pyo:1389 Feature Switches: FeatureSwitchSettings( accept_blob_download_gzip_encoding=True, backup_polling_interval_secs=7200, change_filters=('DRIVE_SYNC 1], cloud_graph_disk_generation=5, crash_log_size_limit=10000000, crash_throttle_percentage=0.0, disabled_cloud_graph_disk_app_versions=]], docs_list_page_size=1000, download in_place=True, download_strategy=turl_template', download_url=thttps://googledrive.com/p/host/(doc_id]', enable_arbitrary_sync=False, enable_batch_upload=True, enable_change_filters=True, enable_context_menu=True, enable_dapper_trace=False, enable_disk_check_on_preferences=True, enable_disk_check_on_setup=True, enable_feedback=True, enable_file_sync_status=True, enable_local_v2=False, enable_multipause=True, enable_multiple_accounts=False, enable_native_opener=True, enable_no_default_folder=False, enable_push=True, enable_recursive_si ze=True, enable_shared_move_confirmation=True, enable_sync_options_in_setup_flow=True, enable_usb_detection=False, feedback_type='prod', ghost_all_files=False, help_url=lhttps://support.google.com/drivein1=%s&p=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, max_page_size_changes=1000, max_page_size_cloud_graph=4000, max_page_size_cloud_graph_fallback=1000, max_page_size_selective_sync=4000, max_page_size_selective_sync_fallback=1000, new document url='https://docs.google.com/document?usp=drive_sync', new_presentation_ur1='https://docs.google.comipresentation?usp=drive_synci, 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=]'10.7', '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_client_version=1, EFTA00504339 push_keepalive_interval=72000.0, query_strategy=u'root', regular_polling_interval_secs=30, selective_sub_folder_sync=True, share_template_url=lhttps://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_qps=10, token_bucketwrite_gps=3, use_drive_api=True, user_confirmation_delay=2.0,) 2016-08-08 09:12:04,810 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp logging_config.pyo:257 OS: Darwin/10.11.5 2016-08-08 09:12:04,811 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp logging_config.pyo:260 Google Drive (build 1.30.2170.0459) 2016-08-08 09:12:04,811 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp logging_config.pyo:261 SSL: OpenSSL 0.9.8zh 14 Jan 2016 2016-08-08 09:12:04,811 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp sync_app.pyo:1398 Config: Email: Sync root: /Users/lgroff/Google Drive Sync collections: set([]) Upgrade number: 24 App version: 1.30.2170.0459 Selective sync: False Cloud Graph generation: 5 Folder sync: [] Local app whitelist: set([]) Local app blacklist: set([]) Bandwidth RX Rate kpBs: 0 Bandwidth TX Rate kpBs: 0 Yosemite icons upgraded: True Win10 icons upgraded: False USB sync enabled: True Do sync default folder: True 2016-08-08 09:12:04,814 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp telemetry.pyo:228 SetPushClientVersion: 1 (3, 20130807) 2016-08-08 09:12:04,815 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.push.telemetry.PushTelemetry'>' 2016-08-08 09:12:04,815 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common. telemetry. impression_logger_manager. ImpressionLoggerManager' >1 2016-08-08 09:12:04,902 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'platforms.volumes.Volumelnfo'>' 2016-08-08 09:12:04,902 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp volumes.pyo:72 Refreshing volume information table. 2016-08-08 09:12:06,880 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp volumes.pyo:116 Volume information refresh complete in 1.97743s. 2016-08-08 09:12:06,881 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.managers.LockManager'>' 2016-08-08 09:12:06,882 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.downloads.DownloadCreate 2016-08-08 09:12:06,882 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.downloads.DownloadModify 2016-08-08 09:12:06,882 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadCreate 2016-08-08 09:12:06,883 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: EFTA00504340 common.aggregator_rules.uploads.UploadDelete 2016-08-08 09:12:06,883 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadModify 2016-08-08 09:12:06,883 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadMove 2016-08-08 09:12:06,883 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadMoveFrom 2016-08-08 09:12:06,883 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadMoveTo 2016-08-08 09:12:06,886 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.roots.root_wrangler.RootWrangler'>' 2016-08-08 09:12:06,886 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.machine_folder.Manager'>. 2016-08-08 09:12:06,886 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.secure_user_storage.Manager'>. 2016-08-08 09:12:07,102 -0400 INFO pid=1033 123145311952896:FilewatcherMonitor filewatcher.pyo:71 filewatcher_ext initialized 2016-08-08 09:12:07,103 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp docs_client_factory.pyo:86 Creating a new DriveClient 2016-08-08 09:12:07,104 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp docs_client_factory.pyo:86 Creating a new DriveClient 2016-08-08 09:12:07,104 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp docs_client_factory.pyo:86 Creating a new DriveClient 2016-08-08 09:12:07,104 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp docs_client_factory.pyo:86 Creating a new DriveClient 2016-08-08 09:12:07,105 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp docs_client_factory.pyo:86 Creating a new DriveClient 2016-08-08 09:12:07,106 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp docs_client_factory.pyo:86 Creating a new DriveClient 2016-08-08 09:12:07,106 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp docs_client_factory.pyo:86 Creating a new DriveClient 2016-08-08 09:12:07,107 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp xmpplib_notifier.pyo:34 Configure storage: <common.push.tango.storage.SyncConfigStorage; proxy of <Swig Object of type 'invalidation::Storage *' at 0x1122d3f00> > 2016-08-08 09:12:07,107 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp xmpplib_notifier.pyo:59 Creating client thread 2016-08-08 09:12:07,108 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp push_xmpp_client.pyo:223 Using talk server: talk.google.com:5222 2016-08-08 09:12:07,108 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp xmpplib_notifier.pyo:68 Creating notification bridge 2016-08-08 09:12:07,110 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp docs_client_factory.pyo:86 Creating a new DriveClient 2016-08-08 09:12:07,114 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp image_resources.py:304 Loading custom image images/folder-mac-yosemite.icns with function _CreateNSImage 2016-08-08 09:12:07,116 -0400 INFO pid=1033 123145332985856:RawEventUpgrader sync_client_thread.pyo:178 RawEventUpgrader run loop has started. 2016-08-08 09:12:07,116 -0400 INFO pid=1033 123145337192448:RootWrangler root_wrangler.pyo: 124 RootWrangler.Root0bserverRegistered with roots (_MyDriveRoot(u'/Users/lgroff/Google Drive', LocalID(inode=435288), 'root', <RootState.INITED: 2>)] 2016-08-08 09:12:07,116 -0400 INFO pid=1033 123145337192448:RootWrangler root_wrangler.pyo:132 RootWrangler.RootsAdded with roots ]_MyDriveRoot(u'/Users/lgroff/Google Drive', LocalID(inode=435288), 'root', <RootState.INITED: 2>)] 2016-08-08 09:12:07,117 -0400 INFO pid=1033 123145337192448:RootWrangler sync_client_thread.pyo:178 RootWrangler run loop has started. 2016-08-08 09:12:07,117 -0400 INFO pid=1033 123145337192448:RootWrangler root_wrangler.pyo: 111 RootWrangler got inited root _MyDriveRoot(u'/Users/lgroff/Google Drive', LocalID(inode=435288), 'root', <RootState.INITED: 2>) 2016-08-08 09:12:07,117 -0400 INFO pid=1033 123145341399040:LocalFSPoller sync_client_thread.pyo:178 LocalFSPoller run loop has started. EFTA00504341 2016-08-08 09:12:07,118 -0400 INFO pid=1033 123145345605632:SyncClientImpressionsThread sync_client_thread.pyo:178 SyncClientImpressionsThread run loop has started. 2016-08-08 09:12:07,119 -0400 INFO pid=1033 123145349812224:Worker-2 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-08-08 09:12:07,119 -0400 INFO pid=1033 123145354018816:FeatureSwitchPoller sync_client_thread.pyo:178 FeatureSwitchPoller run loop has started. 2016-08-08 09:12:07,119 -0400 INFO pid=1033 123145354018816:FeatureSwitchPoller feature_switch_manager.pyo:674 Calling server to get feature switches. 2016-08-08 09:12:07,120 -0400 INFO pid=1033 123145354018816:FeatureSwitchPoller drive_resource.pyo:167 Initialize apiclient Drive resource for 2016-08-08 09:12:07,120 -0400 INFO pid=1033 123145354018816:FeatureSwitchPoller drive_resource.pyo:228 Drive SDK baseUrl = https://www.googleapis.com/drive/v2internal/ 2016-08-08 09:12:07,121 -0400 INFO pid=1033 123145349812224:Worker-2 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-08-08 09:12:07,122 -0400 INFO pid=1033 123145349812224:Worker-2 threads.pyo:130 AddCleanupCallback persistence_sqlite:19a9fed5518c4ce08b44737a3877fe84/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-08-08 09:12:07,122 -0400 INFO pid=1033 123145349812224:Worker-2 threads.pyo:130 AddCleanupCallback persistence_sqlite:389b93aeb30644129327bc73f7a0dfb4/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-08-08 09:12:07,123 -0400 INFO pid=1033 123145354018816:FeatureSwitchPoller drive_request.pyo:297 Drive request: ListFeatureSwitches(tags=Reason.SYNC_OTHER(SyncType.UNKNOWN_SYNC_TYPE)) - Read request - 2016-08-08 09:12:07,125 -0400 INFO pid=1033 123145362432000:PushNotificationKeepaliveThread sync_client_thread.pyo:178 PushNotificationKeepaliveThread run loop has started. 2016-08-08 09:12:07,128 -0400 INFO pid=1033 123145362432000:PushNotificationKeepaliveThread push_notification_keepalive_thread.pyo:49 Sent push keepalive message at: Mon Aug 8 09:12:07 2016 2016-08-08 09:12:07,128 -0400 INFO pid=1033 123145366638592:TelemetryStoreSizeMonitorThread sync_client_thread.pyo:178 TelemetryStoreSizeMonitorThread run loop has started. 2016-08-08 09:12:07,125 -0400 INFO pid=1033 123145349812224:Worker-2 command_factory.pyo:175 Registered worker command types: common.worker.downloads.DownloadChangeACL for Direction. DOWNLOAD Action.CHANGE_ACL common.worker.downloads.DownloadCreate for Direction.DOWNLOAD Action.CREATE common.worker.downloads.DownloadDelete for Direction.DOWNLOAD Action.DELETE common.worker.downloads.DownloadModify for Direction.DOWNLOAD Action.MODIFY common.worker.downloads.DownloadMove for Direction.DOWNLOAD Action.MOVE common.worker.downloads.DownloadRename for Direction.DOWNLOAD Action.RENAME common.worker.internals.InternalCreate for Direction.INTERNAL Action.CREATE common.worker.internals.InternalModify for Direction.INTERNAL Action.MODIFY common.worker.undo.UndoCloudDelete for Direction. DOWNLOAD Action. DELETE undo common.worker.undo.UndoLocalDelete for Direction.UPLOAD Action. DELETE undo common.worker.undo.UndoLocalMove for Direction.UPLOAD Action.MOVE undo common.worker.uploads.BatchUploadCreate for Direction.UPLOAD Action.CREATE is_batch common.worker.uploads.UploadCreate for Direction.UPLOAD Action.CREATE common.worker.uploads.UploadDelete for Direction.UPLOAD Action.DELETE common.worker.uploads.UploadModify for Direction.UPLOAD Action.MODIFY common.worker.uploads.UploadMove for Direction.UPLOAD Action.MOVE common.worker.uploads.UploadRename for Direction.UPLOAD Action.RENAME 2016-08-08 09:12:07,129 -0400 INFO pid=1033 123145349812224:Worker-2 workers.pyo:127 Waiting for batcher to initialize 2016-08-08 09:12:07,129 -0400 INFO pid=1033 123145370845184:OverlayStatusCleaner sync_client_thread.pyo:178 OverlayStatusCleaner run loop has started. 2016-08-08 09:12:07,128 -0400 INFO pid=1033 123145354018816:FeatureSwitchPoller discovery.pyo:762 UAL being requested: GET https://www.googleapis.com/drive/v2internal/settings? fields=items%2Fkey%2Citems%2FValue&reason=304&namespace=FEATURE_SWITCH&alt=json 2016-08-08 09:12:07,129 -0400 INFO pid=1033 123145366638592:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo:44 Checking Telemetry store size. EFTA00504342 2016-08-08 09:12:07,130 -0400 INFO pid=1033 123145354018816:FeatureSwitchPoller client.pyo:515 Attempting refresh to obtain initial access_token 2016-08-08 09:12:07,130 -0400 INFO pid=1033 123145354018816:FeatureSwitchPoller client.pyo:735 Updated access_token read from Storage 2016-08-08 09:12:07,130 -0400 INFO pid=1033 123145354018816:FeatureSwitchPoller http.pyo:257 Request user-agent: googledrivesync-1.30.2170.0459 google-api-python-client/1.3.1 (gzip) (Darwin/10.11.5) 2016-08-08 09:12:07,130 -0400 INFO pid=1033 123145354018816:FeatureSwitchPoller sync_http_client.pyo:238 Opening direct connection to www.googleapis.com:443. 2016-08-08 09:12:07,131 -0400 INFO pid=1033 123145375051776:CrashReportUploaderThread crash_report_uploader_thread.pyo:60 Starting CrashReportUploaderThread. 2016-08-08 09:12:07,141 -0400 INFO pid=1033 123145379258368:ConfirmationHandler sync_client_thread.pyo:178 ConfirmationHandler run loop has started. 2016-08-08 09:12:07,142 -0400 INFO pid=1033 123145387671552:LocalDiskSpaceChecker sync_client_thread.pyo:178 LocalDiskSpaceChecker run loop has started. 2016-08-08 09:12:07,143 -0400 INFO pid=1033 123145391878144:Worker-0 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-08-08 09:12:07,143 -0400 INFO pid=1033 123145396084736:PushTelemetryThread sync_client_thread.pyo:178 PushTelemetryThread run loop has started. 2016-08-08 09:12:07,143 -0400 INFO pid=1033 123145400291328:CloudWatcher sqlite.pyo:276 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-08-08 09:12:07,144 -0400 INFO pid=1033 123145404497920:LocalWatcher watcher.pyo:342 LocalWatcher Run invoked.Waiting for first pass of local scan from poller to start 2016-08-08 09:12:07,155 -0400 INFO pid=1033 123145408704512:Batcher sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-08-08 09:12:07,155 -0400 INFO pid=1033 123145391878144:Worker-0 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-08-08 09:12:07,156 -0400 INFO pid=1033 123145408704512:Batcher sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-08-08 09:12:07,157 -0400 INFO pid=1033 123145408704512:Batcher threads.pyo:130 AddCleanupCallback persistence_sqlite:63f5c16faa384ac481d5aba6d80b837d/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-08-08 09:12:07,157 -0400 INFO pid=1033 123145408704512:Batcher threads.pyo:130 AddCleanupCallback persistence_sqlite:be2034f39ffa4603bled546eee4dcc9c/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-08-08 09:12:07,158 -0400 INFO pid=1033 123145391878144:Worker-0 threads.pyo:130 AddCleanupCallback persistence_sqlite:a5d184e1d23e4018b50a57ecf575b535/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-08-08 09:12:07,158 -0400 INFO pid=1033 123145391878144:Worker-0 threads.pyo:130 AddCleanupCallback persistence_sqlite:c790fc03a1e14727bda194564adcd346/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-08-08 09:12:07,158 -0400 INFO pid=1033 123145391878144:Worker-0 workers.pyo:127 Waiting for batcher to initialize 2016-08-08 09:12:07,158 -0400 INFO pid=1033 123145400291328:CloudWatcher sqlite.pyo:276 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-08-08 09:12:07,159 -0400 INFO pid=1033 123145400291328:CloudWatcher threads.pyo:130 AddCleanupCallback persistence_sqlite:b8f2673f08164ac2ad8d66bc95699a29/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-08-08 09:12:07,159 -0400 INFO pid=1033 123145400291328:CloudWatcher threads.pyo:130 AddCleanupCallback persistence_sqlite:02b7a295f8374b50b93573e8eab8d087/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-08-08 09:12:07,159 -0400 INFO pid=1033 123145400291328:CloudWatcher cloud_graph.pyo:162 Initialize persistent graph with generation 5 EFTA00504343 2016-08-08 09:12:07,159 -0400 INFO pid=1033 123145400291328:CloudWatcher cloud_graph.pyo:1374 Current sync config generation: 5 2016-08-08 09:12:07,160 -0400 INFO pid=1033 123145400291328:CloudWatcher cloud_disk_dict.pyo:618 Cleanup cloud graph directory '/Users/lgroff/Library/Application Support/Google/Drive/user_default/cloud_graph' of files 'dict_*.db,'" except ['dict_2.db 1, ldict2.db-shre, 'dict2.db-wal'] 2016-08-08 09:12:07,161 -0400 INFO pid=1033 123145400291328:CloudWatcher cloud_disk_dict.pyo: 104 Reuse CloudDiskDict database: /Users/lgroff/Library/Application Support/Google/Drive/user_default/cloud_graph/dict_2.db 2016-08-08 09:12:07,162 -0400 INFO pid=1033 123145349812224:Worker-2 sync_client_thread.pyo:178 Worker-2 run loop has started. 2016-08-08 09:12:07,162 -0400 INFO pid=1033 123145391878144:Worker-0 sync_client_thread.pyo:178 Worker-0 run loop has started. 2016-08-08 09:12:07,163 -0400 INFO pid=1033 123145417117696:PauseTelemetryThread sync_client_thread.pyo:178 PauseTelemetryThread run loop has started. 2016-08-08 09:12:07,163 -0400 INFO pid=1033 123145421324288:XmppClient telemetry.pyo:153 Push state None => PushStates.CONNECTING 2016-08-08 09:12:07,164 -0400 INFO pid=1033 123145421324288:XmppClient connection_task.pyo:151 Recalculated LoginTask timeout: 16.000000 2016-08-08 09:12:07,164 -0400 INFO pid=1033 123145421324288:XmppClient telemetry.pyo:167 PushStates.CONNECTING: +0.0010194 => 0.0010194 2016-08-08 09:12:07,164 -0400 INFO pid=1033 123145421324288:XmppClient xmpplib.pyo:80 Connecting to talk.google.com:5222 2016-08-08 09:12:07,175 -0400 INFO pid=1033 123145400291328:CloudWatcher threads.pyo:130 AddCleanupCallback DBConnectionManagerCleanupCallback 2016-08-08 09:12:07,175 -0400 INFO pid=1033 123145400291328:CloudWatcher db_connection.pyo:202 Created thread connection on database /Users/lgroff/Library/Application Support/Google/Drive/user_default/cloud_graph/dict_2.db 2016-08-08 09:12:07,176 -0400 INFO pid=1033 123145425530880:Worker-1 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-08-08 09:12:07,178 -0400 INFO pid=1033 123145425530880:Worker-1 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-08-08 09:12:07,177 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp doc_id_provider.pyo:226 Pre-fetching triggered by caller. Threshold 900. 0 available doc IDs in store. Requesting more doc IDs... 2016-08-08 09:12:07,178 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp doc_id_provider.pyo:235 Waking up fetcher thread 'DocIdsFetcherThread- to get more doc IDs. Currently running. 2016-08-08 09:12:07,179 -0400 INFO pid=1033 123145320366080:_LaunchSyncApp drive_extension_installer.pyo:175 Uninstalling extension nknebiagdodnminbdpflhpkgfpeijdbf 2016-08-08 09:12:07,179 -0400 INFO pid=1033 123145425530880:Worker-1 threads.pyo:130 AddCleanupCallback persistence_sqlite:5cf4da48c6104f4c961ecal2ebf1039e/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-08-08 09:12:07,179 -0400 INFO pid=1033 123145425530880:Worker-1 threads.pyo:130 AddCleanupCallback persistence_sqlite: f57f8089f49b4588b93f330242ce701e/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-08-08 09:12:07,180 -0400 INFO pid=1033 123145425530880:Worker-1 workers.pyo:127 Waiting for batcher to initialize 2016-08-08 09:12:07,180 -0400 INFO pid=1033 123145425530880:Worker-1 sync_client_thread.pyo:178 Worker-1 run loop has started. 2016-08-08 09:12:07,181 -0400 ERROR pid=1033 123145320366080:_LaunchSyncApp chrome_utils.pyo:79 Deleting file /Users/lgroff/Library/Application Support/Google/Chrome/External Extensions/nknebiagdodnminbdpflhpkgfpeijdbf.json failed because: [Errno 2] No such file or directory: '/Users/lgroff/Library/Application Support/Google/Chrome/External Extensions/nknebiagdodnminbdpflhpkgfpeijdbf.json' 2016-08-08 09:12:07,182 -0400 ERROR pid=1033 123145320366080:_LaunchSyncApp fatal_exceptions.pyo:55 Ignoring non-fatal error: OSError: [Errno 2] No such file or directory: '/Users/lgroff/Library/Application Support/Google/Chrome', Traceback: File "common/exception_utils.pyo", line 72, in SuppressExceptions File "common/sync_app.pyo", line 1528, in _PostSetup File "common/drive_extension_installer.pyo", line 142, in InstallExtension EFTA00504344 File ncommon/drive_extension_installer.pyo", line 106, in CheckExtensionlnstalled File "osx/fileutils.pyo", line 157, in ListDir EFTA00504345