EFTA00503989.pdf

From: File "Nolumes/BuildData/pulse- datathgents/599850/recipes/961180334/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/599850/recipes/961180334/base/b/drb/googleclient/apps/webdrive_sync/osx/dist/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 "osic/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 1753, in Quit 2016-05-09 15:12:11,611 -0400 INFO pid=9261 140735190016000:MainThread thread_manager.pyo:116 Stop was called 2016-05-09 15:12:11,612 -0400 INFO pid=9261 140735190016000:MainThread thread_manager.pyo:253 Asking <LocalFSPoller(LocalFSPoller, started 123145328779264)> with tid 123145328779264 to stop. 2016-05-09 15:12:11,612 -0400 INFO pid=9261 140735190016000:MainThread thread_manager.pyo:253 Asking <Batcher(Batcher, started 123145332985856)> with tid 123145332985856 to stop. 2016-05-09 15:12:11,612 -0400 INFO pid=9261 123145328779264:LocalFSPoller sync_client_thread.pyo:212 LocalFSPoller run loop has terminated. 2016-05-09 15:12:11,612 -0400 INFO pid=9261 140735190016000:MainThread thread_manager.pyo:253 Asking <Worker(Worker-2, started 123145337192448)> with tid 123145337192448 to stop. 2016-05-09 15:12:11,612 -0400 INFO pid=9261 123145332985856:Batcher sync_client_thread.pyo:272 Batcher run loop has terminated. 2016-05-09 15:12:11,612 -0400 INFO pid=9261 123145328779264:LocalFSPoller sync_client_thread.pyo:83 ThreadExit: thread LocalFSPoller exiting normalish 2016-05-09 15:12:11,613 -0400 INFO pid=9261 123145332985856:Batcher sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-05-09 15:12:11,613 -0400 INFO pid=9261 140735190016000:MainThread thread_manager.pyo:253 Asking <IpcServerThread(IpcServerThread, started 123145324572672)> with tid 123145324572672 to stop. 2016-05-09 15:12:11,614 -0400 INFO pid=9261 123145337192448:Worker-2 sync_client_thread.pyo:212 Worker-2 run loop has terminated. 2016-05-09 15:12:11,615 -0400 INFO pid=9261 140735190016000:MainThread thread_manager.pyo:253 Asking <RawEventUpgrader(RawEventUpgrader, started 123145341399040)> with tid 123145341399040 to stop. 2016-05-09 15:12:11,615 -0400 INFO pid=9261 123145332985856:Batcher sync_client_thread.pyo:83 ThreadExit: thread Batcher exiting normalish 2016-05-09 15:12:11,615 -0400 INFO pid=9261 123145337192448:Worker-2 sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-05-09 15:12:11,615 -0400 INFO pid=9261 123145332985856:Batcher threads.pyo:109 Execute cleanup callback 'persistence_sqlite:b441e9a109ff43dabe142b4304b433b0/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2016-05-09 15:12:11,615 -0400 INFO pid=9261 123145332985856:Batcher sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-05-09 15:12:11,616 -0400 INFO pid=9261 123145337192448:Worker-2 sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-05-09 15:12:11,616 -0400 INFO pid=9261 140735190016000:MainThread thread_manager.pyo:253 Asking <SchedulerThread(InternalScheduler, started 123145345605632)> with tid 123145345605632 to stop. 2016-05-09 15:12:11,616 -0400 INFO pid=9261 123145332985856:Batcher threads.pyo:109 Execute cleanup callback 'persistence_sqlite:b8c4ddaad8434642b1217cdd4445f836/Users/lgroff/Library/Application EFTA00503989 Support/Google/Drive/user default/snapshot.db' 2016-05-09 15:12:11,616 -0400 INFO pid=9261 123145341399040:RawEventUpgrader sync_client thread.pyo:212 RawEventUpgrader run loop has terminated. 2016-05-09 15:12:11,616 -0400 INFO pid=9261 123145337192448:Worker-2 sync_client thread.pyo:83 ThreadExit: thread Worker-2 exiting normalish 2016-05-09 15:12:11,616 -0400 INFO pid=9261 140735190016000:MainThread thread manager.pyo:253 Asking <SyncClientImpressionsThread(SyncClientImpressionsThread, started 123145349812224)> with tid 123145349812224 to stop. 2016-05-09 15:12:11,616 -0400 INFO pid=9261 123145345605632:InternalScheduler sync_client thread.pyo:83 ThreadExit: thread InternalScheduler exiting normalish 2016-05-09 15:12:11,617 -0400 INFO pid=9261 123145341399040:RawEventUpgrader sync_client thread.pyo:83 ThreadExit: thread RawEventUpgrader exiting normalish 2016-05-09 15:12:11,617 -0400 INFO pid=9261 123145337192448:Worker-2 threads.pyo:109 Execute cleanup callback 'persistence sqlite:1d0486e708004defablc5fec7c54bcab/Users/lgroff/Library/Application Support/Googie/Drive/user default/sync_config.db' 2016-05-09 15:12:11,617 -0400 INFO pid=9261 123145349812224:SyncClientImpressionsThread sync_client thread.pyo:212 SyncClientImpressionsThread run loop has terminated. 2016-05-09 15:12:11,618 -0400 INFO pid=9261 123145349812224:SyncClientImpressionsThread sync_client thread.pyo:83 ThreadExit: thread SyncClientImpressionsThread exiting normalish 2016-05-09 15:12:11,618 -0400 INFO pid=9261 123145337192448:Worker-2 threads.pyo:109 Execute cleanup callback 'persistence sqlite:aa4c4ded93c54cfda8259dd299347aa9/Users/lgroff/Library/Application Support/Googie/Drive/user default/snapshot.db' 2016-05-09 15:12:11,618 -0400 INFO pid=9261 140735190016000:MainThread thread_manager.pyo:253 Asking <RunFunctionThread(_LaunchSyncApp, stopped 123145320366080)> with tid 123145320366080 to stop. 2016-05-09 15:12:11,618 -0400 INFO pid=9261 140735190016000:MainThread thread manager.pyo:253 Asking <Worker(Worker-0, started 123145354018816)> with tid 123145354018816 to stop. 2016-05-09 15:12:11,619 -0400 INFO pid=9261 140735190016000:MainThread thread manager.pyo:253 Asking <PauseTelemetryThread(PauseTelemetryThread, started 123145358225408)> with tid 123145358225408 to stop. 2016-05-09 15:12:11,619 -0400 INFO pid=9261 123145354018816:Worker-0 sync_client thread.pyo:212 Worker-0 run loop has terminated. 2016-05-09 15:12:11,620 -0400 INFO pid=9261 123145354018816:Worker-0 sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user default/snapshot.db 2016-05-09 15:12:11,620 -0400 INFO pid=9261 140735190016000:MainThread thread manager.pyo:253 Asking <FeatureSwitchPoller(FeatureSwitchPoller, started 123145362432000)> with tid 123145362432000 to stop. 2016-05-09 15:12:11,620 -0400 INFO pid=9261 123145358225408:PauseTelemetryThread sync_client thread.pyo:212 PauseTelemetryThread run loop has terminated. 2016-05-09 15:12:11,620 -0400 INFO pid=9261 123145358225408:PauseTelemetryThread pause telemetry.pyo:127 Attempting final telemetry harvest. 2016-05-09 15:12:11,620 -0400 INFO pid=9261 123145354018816:Worker-0 sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user default/sync_config.db 2016-05-09 15:12:11,621 -0400 INFO pid=9261 140735190016000:MainThread thread manager.pyo:253 Asking <CloudWatcher(CloudWatcher, started 123145366638592)> with tid 123145366638592 to stop. 2016-05-09 15:12:11,621 -0400 INFO pid=9261 123145358225408:PauseTelemetryThread pause_telemetry.pyo:190 Harvested pause statistics at t=1462821131.62: (‹PauseReason.API ERRORS: 'pause api err'>: _HarvestStat(paused=0.0, trial=0.0, occurrences=0), nauseReason.BLOeKIN5_ERRORS: 'pause blocking_err'>: _HarvestStat(paused=0.0, trial=0.0, occurrences=0), <PauseReason.NETWORK_ERROTLS: '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=0.0, trial=0.0, occurrences=0), <PauseReason.NO LOCAL_ DISK_ST,ACE: 'pause no space'>: _HarvestStat(paused=0.0, trial=0.0, occurrences=5)) 2016-05-09 15:12:11,621 -0400 INFO pid=9261 123145354018816:Worker-0 sync_client thread.pyo:83 ThreadExit: thread Worker-0 exiting normalish 2016-05-09 15:12:11,622 -0400 INFO pid=9261 123145362432000:FeatureSwitchPoller sync_client thread.pyo:212 FeatureSwitchPoller run loop has terminated. 2016-05-09 15:12:11,622 -0400 INFO pid=9261 123145358225408:PauseTelemetryThread EFTA00503990 sync_client_thread.pyo:83 ThreadExit: thread PauseTelemetryThread exiting normalish 2016-05-09 15:12:11,622 -0400 INFO pid=9261 123145354018816:Worker-0 threads.pyo:109 Execute cleanup callback 'persistence_sqlite:9392909c1d8a4fb6b9a9cf802aea22f1/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2016-05-09 15:12:11,622 -0400 INFO pid=9261 140735190016000:MainThread thread_manager.pyo:253 Asking <PushTelemetryThread(PushTelemetryThread, started 123145370845184)> with tid 123145370845184 to stop. 2016-05-09 15:12:11,622 -0400 INFO pid=9261 123145366638592:CloudWatcher cloud_watcher.pyo:1076 Stop detected 2016-05-09 15:12:11,622 -0400 INFO pid=9261 123145362432000:FeatureSwitchPoller sync_client_thread.pyo:83 ThreadExit: thread FeatureSwitchPoller exiting normalish 2016-05-09 15:12:11,622 -0400 INFO pid=9261 123145354018816:Worker-0 threads.pyo:109 Execute cleanup callback 'persistence_sglite:5aeb3d40edcd462c8d1910921486acee/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2016-05-09 15:12:11,623 -0400 WARNING pid=9261 123145366638592:CloudWatcher cloud_watcher.pyo:1122 Exiting CloudWatcher.PushRunLoop() 2016-05-09 15:12:11,623 -0400 INFO pid=9261 140735190016000:MainThread thread_manager.pyo:253 Asking <CrashReportUploaderThread(CrashReportUploaderThread, started 123145375051776)> with tid 123145375051776 to stop. 2016-05-09 15:12:11,623 -0400 INFO pid=9261 123145366638592:CloudWatcher scilite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-05-09 15:12:11,623 -0400 INFO pid=9261 140735190016000:MainThread thread_manager.pyo:253 Asking <ConnectivityThread(ConnectivityThread, started 123145379258368)> with tid 123145379258368 to stop. 2016-05-09 15:12:11,623 -0400 INFO pid=9261 123145370845184:PushTelemetryThread sync_client_thread.pyo:212 PushTelemetryThread run loop has terminated. 2016-05-09 15:12:11,624 -0400 INFO pid=9261 123145375051776:CrashReportUploaderThread sync_client_thread.pyo:83 ThreadExit: thread CrashReportUploaderThread exiting normalish 2016-05-09 15:12:11,624 -0400 INFO pid=9261 123145379258368:ConnectivityThread sync_client_thread.pyo:83 ThreadExit: thread ConnectivityThread exiting normalish 2016-05-09 15:12:11,624 -0400 INFO pid=9261 123145370845184:PushTelemetryThread telemetry.pyo:207 Attempting final telemetry harvest. 2016-05-09 15:12:11,624 -0400 INFO pid=9261 140735190016000:MainThread thread_manager.pyo:253 Asking <PushNotificationKeepaliveThread(PushNotificationKeepaliveThread, started 123145383464960)> with tid 123145383464960 to stop. 2016-05-09 15:12:11,624 -0400 INFO pid=9261 123145370845184:PushTelemetryThread telemetry.pyo:167 PushStates.0NLINE: +322.104 => 322.104 2016-05-09 15:12:11,625 -0400 INFO pid=9261 123145370845184:PushTelemetryThread sync_client_thread.pyo:83 ThreadExit: thread PushTelemetryThread exiting normalish 2016-05-09 15:12:11,625 -0400 INFO pid=9261 123145383464960:PushNotificationKeepaliveThread sync_client_thread.pyo:212 PushNotificationKeepaliveThread run loop has terminated. 2016-05-09 15:12:11,625 -0400 INFO pid=9261 140735190016000:MainThread thread_manager.pyo:253 Asking <LocalDiskSpaceChecker(LocalDiskSpaceChecker, started 123145387671552)> with tid 123145387671552 to stop. 2016-05-09 15:12:11,625 -0400 INFO pid=9261 123145366638592:CloudWatcher scilite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-05-09 15:12:11,625 -0400 INFO pid=9261 123145383464960:PushNotificationKeepaliveThread sync_client_thread.pyo:83 ThreadExit: thread PushNotificationKeepaliveThread exiting normalish 2016-05-09 15:12:11,626 -0400 INFO pid=9261 123145387671552:LocalDiskSpaceChecker sync_client_thread.pyo:212 LocalDiskSpaceChecker run loop has terminated. 2016-05-09 15:12:11,626 -0400 INFO pid=9261 140735190016000:MainThread thread_manager.pyo:253 Asking <GroupingConfirmationThread(ConfirmationNandler, started 123145391878144)> with tid 123145391878144 to stop. 2016-05-09 15:12:11,626 -0400 INFO pid=9261 123145366638592:CloudWatcher sync_client_thread.pyo:83 ThreadExit: thread CloudWatcher exiting normalish 2016-05-09 15:12:11,626 -0400 INFO pid=9261 123145387671552:LocalDiskSpaceChecker sync_client_thread.pyo:83 ThreadExit: thread LocalDiskSpaceChecker exiting normalish 2016-05-09 15:12:11,626 -0400 INFO pid=9261 140735190016000:MainThread thread_manager.pyo:253 Asking <TelemetryStoreSizeMonitor(TelemetryStoreSizeMonitorThread, EFTA00503991 started 123145396084736)> with tid 123145396084736 to stop. 2016-05-09 15:12:11,626 -0400 INFO pid=9261 123145366638592:CloudWatcher threads.pyo:109 Execute cleanup callback 'persistence_sqlite:607ab76457014ef79aff315fcc783cc9/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2016-05-09 15:12:11,627 -0400 INFO pid=9261 123145391878144:ConfirmationHandler sync_client_thread.pyo:212 ConfirmationHandler run loop has terminated. 2016-05-09 15:12:11,627 -0400 INFO pid=9261 123145366638592:CloudWatcher threads.pyo:109 Execute cleanup callback 'persistence_sqlite:5847e40f7a6d4c9997d36f52a8d44f95/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2016-05-09 15:12:11,627 -0400 INFO pid=9261 140735190016000:MainThread thread_manager.pyo:253 Asking <PushXmppClient(XmppClient, started 123145400291328)> with tid 123145400291328 to stop. 2016-05-09 15:12:11,627 -0400 INFO pid=9261 123145391878144:ConfirmationHandler sync_client_thread.pyo:83 ThreadExit: thread ConfirmationHandler exiting normalish 2016-05-09 15:12:11,627 -0400 INFO pid=9261 123145366638592:CloudWatcher threads.pyo:109 Execute cleanup callback 'DBConnectionManagerCleanupCallback' 2016-05-09 15:12:11,627 -0400 INFO pid=9261 123145396084736:TelemetryStoreSizeMonitorThread sync_client_thread.pyo:212 TelemetryStoreSizeMonitorThread run loop has terminated. 2016-05-09 15:12:11,627 -0400 WARNING pid=9261 140735190016000:MainThread task.pyo:242 DriveXmppTask-0x1124389d0 aborting: abort 2016-05-09 15:12:11,632 -0400 INFO pid=9261 123145366638592:CloudWatcher db_connection.pyo:433 Closing ManagedConnection(id=111DA32D0, thread=CloudWatcher- 700003D59000, path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/cloud_graph/dict_2.db, closed=False) 2016-05-09 15:12:11,632 -0400 INFO pid=9261 123145396084736:TelemetryStoreSizeMonitorThread sync_client_thread.pyo:83 ThreadExit: thread TelemetryStoreSizeMonitorThread exiting normalish 2016-05-09 15:12:11,632 -0400 INFO pid=9261 140735190016000:MainThread task.pyo:254 Task <common.push.push_xmpp_client.DriveXmppTask object at 0x1124389d0> complete. 2016-05-09 15:12:11,633 -0400 INFO pid=9261 140735190016000:MainThread xmpplib.pyo:143 Close called with 'why' reason = Client initiated close 2016-05-09 15:12:11,753 -0400 WARNING pid=9261 123145324572672:IpcServerThread threads.pyo:160 interrupt_condition is set in Sleeper.Wait, waiting 0.2 seconds 2016-05-18 09:30:27,723 -0400 INFO pid=10005 140735190016000:MainThread logging_config.pyo:257 OS: Darwin/10.11.3 2016-05-18 09:30:27,723 -0400 INFO pid=10005 140735190016000:MainThread logging_config.pyo:260 Google Drive (build 1.29.1861.9751) 2016-05-18 09:30:27,723 -0400 INFO pid=10005 140735190016000:MainThread logging_config.pyo:261 SSL: OpenSSL 0.9.8zg 14 July 2015 2016-05-18 09:30:27,735 -0400 INFO pid=10005 140735190016000:MainThread GSyncAppDelegate.pyo:198 Application did finish launching. 2016-05-18 09:30:27,834 -0400 INFO pid=10005 140735190016000:MainThread service.pyo:132 Creating singleton service instance of '<class 'common.file_lock.FileLock'>' 2016-05-18 09:30:27,835 -0400 INFO pid=10005 140735190016000:MainThread service.pyo:132 Creating singleton service instance of '<class 'common.file_lock.FileLock'>' 2016-05-18 09:30:27,836 -0400 INFO pid=10005 123145309806592:RunAsync- InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.service.user.User'>' 2016-05-18 09:30:27,836 -0400 INFO pid=10005 123145309806592:RunAsync- _InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.roots.roots.RootManager'>' 2016-05-18 09:30:27,836 -0400 INFO pid=10005 123145309806592:RunAsync- _InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.thread_manager.ThreadManager'>' 2016-05-18 09:30:27,836 -0400 INFO pid=10005 123145309806592:RunAsync- InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.pause_manager.Service'>' 2016-05-18 09:30:27,836 -0400 INFO pid=10005 123145309806592:RunAsync- _InitializeSyncAppAsync-1 sync_app.pyo:347 Getting TokenStorage... 2016-05-18 09:30:27,836 -0400 INFO pid=10005 123145309806592:RunAsync- _InitializeSyncAppAsync-1 sync_app.pyo:349 Got token storage: <platforms.token_storage.TokenStorage object at 0x10f8ec850> 2016-05-18 09:30:27,836 -0400 INFO pid=10005 123145309806592:RunAsync- EFTA00503992  InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.features.AppFeatures'>' 2016-05-18 09:30:27,837 -0400 INFO pid=10005 123145309806592:RunAsync- _InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.cert.Manager'> 1 2016-05-18 09:30:27,844 -0400 INFO pid=10005 123145309806592:RunAsync- _InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.net.bandwidth.BandwidthThrottler'> 1 2016-05-18 09:30:27,847 -0400 INFO pid=10005 123145309806592:RunAsync- InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.persistence.persistence.Factory'>' 2016-05-18 09:30:27,847 -0400 INFO pid=10005 123145309806592:RunAsync- _InitializeSyncAppAsync-1 persistence.pyo:39 Initialize factory with policy PlatformPolicy(google_drive_config_directory_path=u'/Users/lgroff/Library/Application Support/Google/Drive', main_sync_root=None, system_download_cache_folder=None, process_id=None) 2016-05-18 09:30:27,847 -0400 INFO pid=10005 123145309806592:RunAsync- InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.persistence.sync_config_sqlite.SyncConfigSOLitel> 1 2016-05-18 09:30:27,847 -0400 INFO pid=10005 123145309806592:RunAsync- _InitializeSyncAppAsync-1 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-05-18 09:30:27,848 -0400 INFO pid=10005 123145309806592:RunAsync- _InitializeSyncAppAsync-1 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-05-18 09:30:27,848 -0400 INFO pid=10005 123145309806592:RunAsync- _InitializeSyncAppAsync-1 threads.pyo:130 AddCleanupCallback persistence_sqlite:7ad3a02b596e456f92c08ca9ae9aeb69/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-05-18 09:30:27,848 -0400 INFO pid=10005 123145309806592:RunAsync- _InitializeSyncAppAsync-1 threads.pyo:130 AddCleanupCallback persistence_sqlite:a57b24d4ef3e42799a0dd75b294427b1/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-05-18 09:30:27,854 -0400 INFO pid=10005 123145309806592:RunAsync- _InitializeSyncAppAsync-1 sync_app.pyo:525 BandwidthThrottler configured via sync_config 2016-05-18 09:30:27,854 -0400 INFO pid=10005 123145309806592:RunAsync- _InitializeSyncAppAsync-1 bandwidth.pyo:59 BandwidthThrottler.SetRxBytesPerSecond 0 2016-05-18 09:30:27,854 -0400 INFO pid=10005 123145309806592:RunAsync- _InitializeSyncAppAsync-1 bandwidth.pyo:68 BandwidthThrottler.SetTxBytesPerSecond 0 2016-05-18 09:30:27,854 -0400 INFO pid=10005 123145309806592:RunAsync- _InitializeSyncAppAsync-1 sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-05-18 09:30:27,854 -0400 INFO pid=10005 123145309806592:RunAsync- InitializeSyncAppAsync-1 sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-05-18 09:30:27,855 -0400 INFO pid=10005 123145309806592:RunAsync- InitializeSyncAppAsync-1 threads.pyo:109 Execute cleanup callback 'persistence_sqlite:a57b24d4ef3e42799a0dd75b294427b1/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2016-05-18 09:30:27,855 -0400 INFO pid=10005 123145309806592:RunAsync- InitializeSyncAppAsync-1 threads.pyo:109 Execute cleanup callback 'persistence_sqlite:7ad3a02b596e456f92c08ca9ae9aeb69/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2016-05-18 09:30:27,916 -0400 INFO pid=10005 140735190016000:MainThread image_resources.py:253 Loading image images/ic_drawer_24.png 2016-05-18 09:30:27,920 -0400 INFO pid=10005 140735190016000:MainThread image_resources.py:253 Loading image images/menu_drive-logo.png 2016-05-18 09:30:27,921 -0400 INFO pid=10005 140735190016000:MainThread image_resources.py:253 Loading image images/menu_google-logo-gray.png 2016-05-18 09:30:27,925 -0400 INFO pid=10005 140735190016000:MainThread image_resources.py:253 Loading image images/ic_folder_mydrive_24.png 2016-05-18 09:30:27,929 -0400 INFO pid=10005 140735190016000:MainThread image_resources.py:253 Loading image images/ic_web_24.png 2016-05-18 09:30:27,931 -0400 INFO pid=10005 140735190016000:MainThread image_resources.py:253 Loading image images/ic_sync_problem_24.png EFTA00503993 2016-05-18 09:30:27,939 -0400 INFO pid=10005 140735190016000:MainThread image_resources.py:253 Loading image images/ic_done.png 2016-05-18 09:30:27,984 -0400 INFO pid=10005 123145315622912:ThreadMonitor thread_manager.pyo:339 Waiting on exit condition. Wake up after 3600s. 2016-05-18 09:30:27,984 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-05-18 09:30:27,985 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-05-18 09:30:27,986 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp threads.pyo:130 AddCleanupCallback persistence_sqlite:05c21400d5804e49a23f69d1dcb7d583/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-05-18 09:30:27,986 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp threads.pyo:130 AddCleanupCallback persistence_sqlite:750eff2891344c68b2f0b15fd25178c9/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-05-18 09:30:28,006 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp user.pyo:68 Initializing User instance with new credentials. None 2016-05-18 09:30:28,007 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp docs_client_factory.pyo:89 Creating a new DriveClient 2016-05-18 09:30:28,007 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.quota.Quotalnfo'>' 2016-05-18 09:30:28,008 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.token_bucket.CloudBucketManager'>' 2016-05-18 09:30:28,008 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive_api.drive_resource.Manager'>. 2016-05-18 09:30:28,009 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive_api.http.Manager'>. 2016-05-18 09:30:28,009 -0400 ERROR pid=10005 123145324036096:IpcServerThread ipc_socket_base.pyo:247 Failed to bind to socket /Users/lgroff/Library/Group Containers/google_drive/tmp8UbQuM (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-05-18 09:30:28,009 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp drive_resource.pyo:149 Initialize apiclient Drive resource for current user token 2016-05-18 09:30:28,009 -0400 ERROR pid=10005 123145324036096:IpcServerThread ipc_socket_base.pyo:247 Failed to bind to socket /Users/lgroff/Library/Group Containers/google_drive/tmp8UbQuM (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-05-18 09:30:28,010 -0400 ERROR pid=10005 123145324036096:IpcServerThread ipc_socket_base.pyo:247 Failed to bind to socket /Users/lgroff/Library/Group Containers/google_drive/tmp8UbQuM (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-05-18 09:30:28,010 -0400 WARNING pid=10005 123145324036096:IpcServerThread server.pyo:145 Socket (/Users/lgroff/Library/Application Support/Google/Drive/GoogleDrivelpcPipe) already in use, deleting it. 2016-05-18 09:30:28,016 -0400 INFO pid=10005 123145319829504: LaunchSyncApp drive_resource.pyo:210 Drive SDK baseUrl = 2016-05-18 09:30:28,017 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive_api.http.AccessTokenInMemoryCache'> 1 2016-05-18 09:30:28,017 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp EFTA00503994 drive request.pyo:297 Drive request: About(tags=Reason.SYNC OTHER(SyncType.UNKNOWN SYNC TYPE)) - Read request - None 2016-05-18 09:30:28,018 -0400 INFO pid=10005 123145319829504: LaunchSyncApp discovery.pyo:762 URL being requested: GET fields=rootFolderld%2CquotaBytesTota182CquotaBytesUsedAggregate%2CquotaBytesUsedInTrash%2Cquo taType%2Cuser%2FemailAddress&reason=304Salt=json 2016-05-18 09:30:28,019 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp client.pyo:515 Attempting refresh to obtain initial access token 2016-05-18 09:30:28,019 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp client.pyo:755 Refreshing access token 2016-05-18 09:30:28,023 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.net.dapper.DapperService'>' 2016-05-18 09:30:28,023 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp http.pyo:257 Request user-agent: Python-httplib2/0.9.2 (gzip) 2016-05-18 09:30:28,023 -0400 INFO pid=10005 123145319829504: LaunchSyncApp sync_http_client.pyo:238 Opening direct connection to 2016-05-18 09:30:28,952 -0400 INFO pid=10005 140735190016000:MainThread sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user default/snapshot.db 2016-05-18 09:30:28,953 -0400 INFO pid=10005 140735190016000:MainThread sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user default/sync_config.db 2016-05-18 09:30:28,953 -0400 INFO pid=10005 140735190016000:MainThread sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user default/snapshot.db 2016-05-18 09:30:28,953 -0400 INFO pid=10005 140735190016000:MainThread sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user default/sync_config.db 2016-05-18 09:30:41,460 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp http.pyo:276 Response: 154 bytes - application/json; charset=utf-8 (encoding:gzip) 2016-05-18 09:30:41,461 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp http.pyo:257 Request user-agent: googledrivesync-1.29.1861.9751 google-api-python-client/1.3.1 (gzip) (Darwin/10.11.3) 2016-05-18 09:30:41,461 -0400 INFO pid=10005 123145319829504: LaunchSyncApp sync_http_client.pyo:238 Opening direct connection to 2016-05-18 09:30:42,195 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp http.pyo:276 Response: 242 bytes - application/json; charset=UTF-8 (encoding:gzip) 2016-05-18 09:30:42,196 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp drive_request.pyo:304 Drive response: Request (None): About(tags=Reason.SYNC_OTHER(SyncType.UNKNOWN_SYNC_TYPE)) Response: About(root_id=0ABNN8iEiWGvgUk9PVA, quota bytes_total=107374182400, quota_bytes used aggregate=16958542435, quota—bytes used_in_trash=410787069, quota iype=IIMITED) 2016-05-18 09:30:42,197 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive_api.doc id_provider.Store'>' 2016-05-18 09:30:42,197 -0400 INFO pid=10005 123145319829504: LaunchSyncApp user.pyo:68 Initializing User instance with new credentials. 2016-05-18 09:30:42,197 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp sync_app.pyo:1333 Configuring sync app from feature switches. 2016-05-18 09:30:42,197 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp features.pyo:112 Loads feature switches. 2016-05-18 09:30:42,198 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp feature_switch manager.pyo:682 Calling server to get feature switches. 2016-05-18 09:30:42,198 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp drive request.pyo:297 Drive request: ListFiatureSwitches(tags=Reason.SYNC_OTHER(SyncType.UNKNOWN_SYNC_TYPE)) - Read request - 2016-05-18 09:30:42,200 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp discovery.pyo:762 URL being requested: GET fields=items%2Fkey%2Citems%2FValue&reason=304&namespace=FEATURE_SWITCHfialt=json 2016-05-18 09:30:42,201 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp http.pyo:257 Request user-agent: googledrivesync-1.29.1861.9751 google-api-python-client/1.3.1 (gzip) EFTA00503995 (Darwin/10.11.3) 2016-05-18 09:30:42,255 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp http.pyo:276 Response: 1736 bytes - application/json; charset=UTF-8 (encoding:gzip) 2016-05-18 09:30:42,263 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp drive_request.pyo:304 Drive response: Request ( ListFeatureSwitches(tags=Reason.SYNC_OTHER(SyncType.UNKNOWN_SYNC_TYPE)) Response: (u'cloud_graph_disk_generation': u'2', u'crash_throttle_percentage': u'0', u'download_in_place': u'false', u'enable_arbitrary_sync': u'false', u'enable_change_filters': u'false', 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_recursive_size': 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', u'max_batch_upload_files': u'30', u'max_page_size_changes': u'1000', u'max_page_size_cloud_graph': u'1000', u'max_page_size_selective_sync': u'4000', u'perf_throttle_percentage': u'100', u'query_strategy': u'root', u'selective_sub_folder_sync': u'true', uttest.featureswitch.name': u", u'use_drive_api': u'true') 2016-05-18 09:30:42,293 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp sync_app.pyo:1357 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=0.0, disabled_cloud_graph_disk_app_versions=(), docs_list_page_size=1000, download_in_place=False, download_progress_bar=False, download_strategy='url template', download_ur1= 1 (doc_id)', enable_arbitrary_sync=False, enable_batch_upload=True, enable_change_filters=False, 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_impressions_library=True, enable_local_v2=False, enable_multipause=True, enable_multiple_accounts=False, enable_native_opener=True, enable_no_default_folder=False, EFTA00503996 enable_push=True, enable_recursive_size=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_ur1=' 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=1000, max_page_size_cloud_graph_fallback=1000, max_page_size_selective_sync=4000, max_page_size_selective sync fallback=1000, new_document_ur1= 1 new_presentation_ur1=' new_spreadsheet_ur1=' numworkers=3, open_ur1= 1 (doc_id)', overlays_enabled_finder_versions=(.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'root', regular_polling_interval_secs=30, selective_sub_folder sync=True, share_template_ur1=' 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=' tokenbucket_read_qps=10, token_bucketwrite_qps=3, use_drive_api=True, user_confirmation_delay=2.0,) 2016-05-18 09:30:42,294 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp logging_config.pyo:257 OS: Darwin/10.11.3 2016-05-18 09:30:42,294 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp logging_config.pyo:260 Google Drive (build 1.29.1861.9751) 2016-05-18 09:30:42,295 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp logging_config.pyo:261 SSL: OpenSSL 0.9.8zg 14 July 2015 2016-05-18 09:30:42,295 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp sync_app.pyo:1366 Config: Email: Sync root: /Users/lgroff/Google Drive Sync collections: set(()) Upgrade number: 24 App version: 1.29.1861.9751 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: True Win10 icons upgraded: False EFTA00503997 USB sync enabled: True Do sync default folder: True 2016-05-18 09:30:42,299 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp telemetry.pyo:228 SetPushClientVersion: 1 (3, 20130807) 2016-05-18 09:30:42,299 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.push.telemetry.PushTelemetry'>' 2016-05-18 09:30:42,299 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.telemetry.impression_logger_manager.ImpressionLoggerManager'>1 2016-05-18 09:30:42,786 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.managers.LockManager'>' 2016-05-18 09:30:42,787 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.downloads.DownloadCreate 2016-05-18 09:30:42,787 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.downloads.DownloadModify 2016-05-18 09:30:42,787 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadCreate 2016-05-18 09:30:42,788 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadDelete 2016-05-18 09:30:42,788 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadModify 2016-05-18 09:30:42,788 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadMove 2016-05-18 09:30:42,788 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadMoveFrom 2016-05-18 09:30:42,788 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadMoveTo 2016-05-18 09:30:42,788 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.roots.root_wrangler.RootWrangler'>. 2016-05-18 09:30:42,789 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.machine_folder.Manager'>. 2016-05-18 09:30:42,789 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.secure_user_storage.Manager'>. 2016-05-18 09:30:42,948 -0400 INFO pid=10005 123145311416320:FilewatcherMonitor filewatcher.pyo:71 filewatcher_ext initialized 2016-05-18 09:30:42,948 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp docs_client_factory.pyo:89 Creating a new DriveClient 2016-05-18 09:30:42,949 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp docs_client_factory.pyo:89 Creating a new DriveClient 2016-05-18 09:30:42,949 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp docs_client_factory.pyo:89 Creating a new DriveClient 2016-05-18 09:30:42,949 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp docs_client_factory.pyo:89 Creating a new DriveClient 2016-05-18 09:30:42,949 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp docs_client_factory.pyo:89 Creating a new DriveClient 2016-05-18 09:30:42,950 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp docs_client_factory.pyo:89 Creating a new DriveClient 2016-05-18 09:30:42,950 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp docs_client_factory.pyo:89 Creating a new DriveClient 2016-05-18 09:30:42,951 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp xmpplib_notifier.pyo:34 Configure storage: <common.push.tango.storage.SyncConfigStorage; proxy of <Swig Object of type 'invalidation::Storage *' at 0x1123d6fc0> > 2016-05-18 09:30:42,952 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp xmpplib_notifier.pyo:59 Creating client thread 2016-05-18 09:30:42,952 -0400 INFO pid=10005 123145319829504: LaunchSyncApp push_xmpp_client.pyo:223 Using talk server: 2016-05-18 09:30:42,952 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp EFTA00503998 xmpplib_notifier.pyo:68 Creating notification bridge 2016-05-18 09:30:42,958 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp docs_client_factory.pyo:89 Creating a new DriveClient 2016-05-18 09:30:42,962 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp image_resources.py:304 Loading custom image images/folder-mac-yosemite.icns with function _CreateNSImage 2016-05-18 09:30:42,963 -0400 INFO pid=10005 123145328242688:LocalFSPoller sync_client_thread.pyo:178 LocalFSPoller run loop has started. 2016-05-18 09:30:42,963 -0400 INFO pid=10005 123145332449280:FeatureSwitchPoller sync_client_thread.pyo:178 FeatureSwitchPoller run loop has started. 2016-05-18 09:30:42,963 -0400 INFO pid=10005 123145332449280:FeatureSwitchPoller feature_switch_manager.pyo:682 Calling server to get feature switches. 2016-05-18 09:30:42,964 -0400 INFO pid=10005 123145336655872:RawEventUpgrader sync_client_thread.pyo:178 RawEventUpgrader run loop has started. 2016-05-18 09:30:42,964 -0400 INFO pid=10005 123145332449280:FeatureSwitchPoller drive_resource.pyo:149 Initialize apiclient Drive resource for 2016-05-18 09:30:42,964 -0400 INFO pid=10005 123145340862464:Worker-0 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-05-18 09:30:42,965 -0400 INFO pid=10005 123145332449280:FeatureSwitchPoller drive_resource.pyo:210 Drive SDK baseUrl = 2016-05-18 09:30:42,965 -0400 INFO pid=10005 123145345069056:LocalDiskSpaceChecker sync_client_thread.pyo:178 LocalDiskSpaceChecker run loop has started. 2016-05-18 09:30:42,966 -0400 INFO pid=10005 123145353482240:Batcher sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-05-18 09:30:42,967 -0400 INFO pid=10005 123145357688832:ConfirmationHandler sync_client_thread.pyo:178 ConfirmationHandler run loop has started. 2016-05-18 09:30:42,968 -0400 INFO pid=10005 123145361895424:CloudWatcher sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-05-18 09:30:42,968 -0400 INFO pid=10005 123145366102016:CrashReportUploaderThread crash_report_uploader_thread.pyo:60 Starting CrashReportUploaderThread. 2016-05-18 09:30:42,969 -0400 INFO pid=10005 123145332449280:FeatureSwitchPoller drive_request.pyo:297 Drive request: ListFeatureSwitches(tags=Reason.SYNC_OTHER(SyncType.UNKNOWN_SYNC_TYPE)) - Read request - 2016-05-18 09:30:42,969 -0400 INFO pid=10005 123145340862464:Worker-0 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-05-18 09:30:42,970 -0400 INFO pid=10005 123145370308608:PauseTelemetryThread sync_client_thread.pyo:178 PauseTelemetryThread run loop has started. 2016-05-18 09:30:42,970 -0400 INFO pid=10005 123145374515200:PushNotificationKeepaliveThread sync_client_thread.pyo:178 PushNotificationKeepaliveThread run loop has started. 2016-05-18 09:30:42,972 -0400 INFO pid=10005 123145332449280:FeatureSwitchPoller discovery.pyo:762 UAL being requested: GET fields=items%2Fkey%2Citems%2FValue&reason=304&namespace=FEATURE_SWITCH&alt=json 2016-05-18 09:30:42,973 -0400 INFO pid=10005 123145378721792:PushTelemetryThread sync_client_thread.pyo:178 PushTelemetryThread run loop has started. 2016-05-18 09:30:42,973 -0400 INFO pid=10005 123145353482240:Batcher sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-05-18 09:30:42,973 -0400 INFO pid=10005 123145382928384:OverlayStatusCleaner sync_client_thread.pyo:178 OverlayStatusCleaner run loop has started. 2016-05-18 09:30:42,973 -0400 INFO pid=10005 123145361895424:CloudWatcher sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-05-18 09:30:42,975 -0400 INFO pid=10005 123145374515200:PushNotificationKeepaliveThread push_notification_keepalive_thread.pyo:49 Sent push keepalive message at: Wed May 18 09:30:42 2016 2016-05-18 09:30:42,976 -0400 INFO pid=10005 123145340862464:Worker-0 threads.pyo:130 AddCleanupCallback persistence_sqlite:a026e6b14e35430e95ab3fbe8ae3bb71/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db EFTA00503999 2016-05-18 09:30:42,976 -0400 INFO pid=10005 123145395548160:TelemetryStoreSizeMonitorThread sync_client_thread.pyo:178 TelemetryStoreSizeMonitorThread run loop has started. 2016-05-18 09:30:42,976 -0400 INFO pid=10005 123145399754752:XmppClient telemetry.pyo:153 Push state None => PushStates.CONNECTING 2016-05-18 09:30:42,977 -0400 INFO pid=10005 123145332449280:FeatureSwitchPoller client.pyo:515 Attempting refresh to obtain initial access_token 2016-05-18 09:30:42,977 -0400 INFO pid=10005 123145403961344:RootWrangler root_wrangler.pyo:120 RootWrangler.RootObserverRegistered with roots (_MyDriveRoot(u'/Users/lgroff/Google Drive', LocallD(inode=435288), 'root', <RootState.INITED: 2>)] 2016-05-18 09:30:42,978 -0400 INFO pid=10005 123145408167936:Worker-2 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-05-18 09:30:42,978 -0400 INFO pid=10005 123145353482240:Batcher threads.pyo:130 AddCleanupCallback persistence_sqlite:027f14ec34f94e44be69052bdd9flebl/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-05-18 09:30:42,979 -0400 INFO pid=10005 123145416581120:SyncClientlmpressionsThread sync_client_thread.pyo:178 SyncClientlmpressionsThread run loop has started. 2016-05-18 09:30:42,979 -0400 INFO pid=10005 123145420787712:LocalWatcher watcher.pyo:342 LocalWatcher Run invoked.Waiting for first pass of local scan from poller to start 2016-05-18 09:30:42,979 -0400 INFO pid=10005 123145340862464:Worker-0 threads.pyo:130 AddCleanupCallback persistence_sqlite:ab79700e011c46ceb5d6e24b04d6bbbd/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-05-18 09:30:42,979 -0400 INFO pid=10005 123145395548160:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo:44 Checking Telemetry store size. 2016-05-18 09:30:42,979 -0400 INFO pid=10005 123145424994304:Worker-1 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-05-18 09:30:42,980 -0400 INFO pid=10005 123145319829504:_LaunchSyncApp doc_id_provider.pyo:226 Pre-fetching triggered by caller. Threshold 900. 0 available doc IDs in store. Requesting more doc IDs... 2016-05-18 09:30:42,980 -0400 INFO pid=10005 123145399754752:XmppClient connection_task.pyo:151 Recalculated LoginTask timeout: 16.000000 2016-05-18 09:30:42,981 -0400 INFO pid=10005 123145361895424:CloudWatcher threads.pyo:130 AddCleanupCallback persistence_sqlite:70b5159dc7b843baab109f2037d1d8b6/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-05-18 09:30:42,984 -0400 INFO pid=10005 123145361895424:CloudWatcher threads.pyo:130 AddCleanupCallback persistence_sqlite:17def5afa4924f65abe0f56f4dfbb5ca/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-05-18 09:30:42,981 -0400 INFO pid=10005 123145332449280:FeatureSwitchPoller client.pyo:735 Updated access_token read from Storage 2016-05-18 09:30:42,981 -0400 INFO pid=10005 123145353482240:Batcher threads.pyo:130 AddCleanupCallback persistence_sqlite:cffbf47957cd4eb98304b3fbla3c8a29/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-05-18 09:30:42,983 -0400 INFO pid=10005 123145340862464:Worker-0 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 EFTA00504000 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-05-18 09:30:42,983 -0400 INFO pid=10005 12314