EFTA00503468.pdf

From: File "Nolumes/BuildData/pulse- datathgents/599942/recipes/941592543/base/b/drb/googleclient/apps/webdrive_sync/osiddist/Google Drive.app/Contents/ftesources/_boot_.py", line 77, in <module> File "Nolumes/BuildData/pulse- datathgents/599942/recipes/941592543/base/b/drb/googleclient/apps/webdrive_sync/osiddist/Google Drive.app/Contents/ftesources/_boot_.py", line 62, in _run File "/ApplicationslGoogle Drive.app/Contents/Resourceslmain.py", line 12, in <module> File "osx/run_googledrive.pyo", line 31, in Main File "PyObjCTools/AppHelper.pyo", line 235, in runEventLoop File "osic/GSyncAppDelegate.pyo", line 296, in applicationWillTerminate_ File "osx/mac_sync_app_controller.pyo", line 263, in Exit File "common/ui_action_handler.pyo", line 444, in Quit File "common/sync_app.pyo", line 1742, in Quit 2016-03-29 09:21:01,305 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:116 Stop was called 2016-03-29 09:21:01,306 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <IpcServerThread(IpcServerThread, started 123145311416320)> with tid 123145311416320 to stop. 2016-03-29 09:21:01,306 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <LocalFSPoller(LocalFSPoller, started 123145329852416)> with tid 123145329852416 to stop. 2016-03-29 09:21:01,306 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <Worker(Worker-0, started 123145334059008)> with tid 123145334059008 to stop. 2016-03-29 09:21:01,306 -0400 INFO pid=487 123145329852416:LocalFSPoller sync_client_thread.pyo:212 LocalFSPoller run loop has terminated. 2016-03-29 09:21:01,306 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <FeatureSwitchPoller(FeatureSwitchPoller, started 123145338265600)> with tid 123145338265600 to stop. 2016-03-29 09:21:01,307 -0400 INFO pid=487 123145329852416:LocalFSPoller sync_client_thread.pyo:83 ThreadExit: thread LocalFSPoller exiting normalish 2016-03-29 09:21:01,307 -0400 INFO pid=487 123145334059008:Worker-0 sync_client_thread.pyo:212 Worker-0 run loop has terminated. 2016-03-29 09:21:01,308 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <RawEventUpgrader(RawEventUpgrader, started 123145342472192)> with tid 123145342472192 to stop. 2016-03-29 09:21:01,308 -0400 INFO pid=487 123145338265600:FeatureSwitchPoller sync_client_thread.pyo:212 FeatureSwitchPoller run loop has terminated. 2016-03-29 09:21:01,308 -0400 INFO pid=487 123145334059008:Worker-0 sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-03-29 09:21:01,308 -0400 INFO pid=487 123145338265600:FeatureSwitchPoller sync_client_thread.pyo:83 ThreadExit: thread FeatureSwitchPoller exiting normalish 2016-03-29 09:21:01,309 -0400 INFO pid=487 123145342472192:RawEventUpgrader sync_client_thread.pyo:212 RawEventUpgrader run loop has terminated. 2016-03-29 09:21:01,309 -0400 INFO pid=487 123145342472192:RawEventUpgrader sync_client_thread.pyo:83 ThreadExit: thread RawEventUpgrader exiting normalish 2016-03-29 09:21:01,309 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <SchedulerThread(InternalScheduler, started 123145346678784)> with tid 123145346678784 to stop. 2016-03-29 09:21:01,310 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <CloudWatcher(CloudWatcher, started 123145350885376)> with tid 123145350885376 to stop. 2016-03-29 09:21:01,310 -0400 INFO pid=487 123145346678784:InternalScheduler sync_client_thread.pyo:83 ThreadExit: thread InternalScheduler exiting normalish 2016-03-29 09:21:01,310 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <ConnectivityThread(ConnectivityThread, started 123145355091968)> with tid 123145355091968 to stop. 2016-03-29 09:21:01,311 -0400 INFO pid=487 123145350885376:CloudWatcher cloud_watcher.pyo:650 Stop detected 2016-03-29 09:21:01,311 -0400 INFO pid=487 123145334059008:Worker-0 sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application EFTA00503468 Support/Google/Drive/user_default/sync_config.db 2016-03-29 09:21:01,311 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <Worker(Worker-2, started 123145359298560)> with tid 123145359298560 to stop. 2016-03-29 09:21:01,311 -0400 INFO pid=487 123145355091968:ConnectivityThread sync_clientthread.pyo:83 ThreadExit: thread ConnectivityThread exiting normalish 2016-03-29 09:21:01,311 -0400 WARNING pid=487 123145350885376:CloudWatcher cloud_watcher.pyo:696 Exiting CloudWatcher.PushRunLoop() 2016-03-29 09:21:01,312 -0400 INFO pid=487 123145334059008:Worker-0 sync_client_thread.pyo:83 ThreadExit: thread Worker-0 exiting normalish 2016-03-29 09:21:01,312 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <PushTelemetryThread(PushTelemetryThread, started 123145363505152)> with tid 123145363505152 to stop. 2016-03-29 09:21:01,312 -0400 INFO pid=487 123145350885376:CloudWatcher sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-03-29 09:21:01,312 -0400 INFO pid=487 123145359298560:Worker-2 sync_client_thread.pyo:212 Worker-2 run loop has terminated. 2016-03-29 09:21:01,312 -0400 INFO pid=487 123145334059008:Worker-0 threads.pyo:109 Execute cleanup callback 'persistence_sqlite:7fa8715180ea49498e418662c79387e9/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2016-03-29 09:21:01,313 -0400 INFO pid=487 123145359298560:Worker-2 sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-03-29 09:21:01,313 -0400 INFO pid=487 123145363505152:PushTelemetryThread sync_client_thread.pyo:212 PushTelemetryThread run loop has terminated. 2016-03-29 09:21:01,313 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <OverlayStatusCleaner(OverlayStatusCleaner, started 123145367711744)> with tid 123145367711744 to stop. 2016-03-29 09:21:01,313 -0400 INFO pid=487 123145334059008:Worker-0 threads.pyo:109 Execute cleanup callback 'persistence_sqlite:7fe6b7ed3e0a45c49322075417f884ef/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2016-03-29 09:21:01,313 -0400 INFO pid=487 123145363505152:PushTelemetryThread telemetry.pyo:207 Attempting final telemetry harvest. 2016-03-29 09:21:01,314 -0400 INFO pid=487 123145363505152:PushTelemetryThread telemetry.pyo:167 PushStates.0NLINE: +627.471 => 627.471 2016-03-29 09:21:01,314 -0400 INFO pid=487 123145363505152:PushTelemetryThread sync_client_thread.pyo:83 ThreadExit: thread PushTelemetryThread exiting normalish 2016-03-29 09:21:01,315 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <SyncClientImpressionsThread(SyncClientImpressionsThread, started 123145371918336)> with tid 123145371918336 to stop. 2016-03-29 09:21:01,315 -0400 INFO pid=487 123145367711744:OverlayStatusCleaner sync_client_thread.pyo:212 OverlayStatusCleaner run loop has terminated. 2016-03-29 09:21:01,315 -0400 INFO pid=487 123145367711744:OverlayStatusCleaner sync_client_thread.pyo:83 ThreadExit: thread OverlayStatusCleaner exiting normalish 2016-03-29 09:21:01,316 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <SchedulerThread(ListenerScheduler, started 123145376124928)> with tid 123145376124928 to stop. 2016-03-29 09:21:01,316 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <PauseTelemetryThread(PauseTelemetryThread, started 123145380331520)> with tid 123145380331520 to stop. 2016-03-29 09:21:01,316 -0400 INFO pid=487 123145376124928:ListenerScheduler sync_client_thread.pyo:83 ThreadExit: thread ListenerScheduler exiting normalish 2016-03-29 09:21:01,316 -0400 INFO pid=487 123145371918336:SyncClientImpressionsThread sync_client_thread.pyo:212 SyncClientImpressionsThread run loop has terminated. 2016-03-29 09:21:01,317 -0400 INFO pid=487 123145359298560:Worker-2 sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-03-29 09:21:01,317 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <RootWrangler(RootWrangler, started 123145384538112)> with tid 123145384538112 to stop. 2016-03-29 09:21:01,317 -0400 INFO pid=487 123145350885376:CloudWatcher sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application EFTA00503469 Support/Google/Drive/user default/sync_config.db 2016-03-29 09:21:01,317 -0400 INFO pid=487 123145371918336:SyncClientImpressionsThread sync_client thread.pyo:83 ThreadExit: thread SyncClientImpressionsThread exiting normalish 2016-03-29 09:21:01,317 -0400 INFO pid=487 123145380331520:PauseTelemetryThread sync_client thread.pyo:212 PauseTelemetryThread run loop has terminated. 2016-03-29 09:21:01,317 -0400 INFO pid=487 123145359298560:Worker-2 sync_client thread.pyo:83 ThreadExit: thread Worker-2 exiting normalish 2016-03-29 09:21:01,318 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <FilewatcherMonitor(FilewatcherMonitor, started 123145325645824)> with tid 123145325645824 to stop. 2016-03-29 09:21:01,318 -0400 INFO pid=487 123145350885376:CloudWatcher sync_client thread.pyo:83 ThreadExit: thread CloudWatcher exiting normalish 2016-03-29 09:21:01,318 -0400 INFO pid=487 123145384538112:RootWrangler sync client thread.pyo:212 RootWrangler run loop has terminated. 2016-03-29 59:21:01,318 -0400 INFO pid=487 123145380331520:PauseTelemetryThread pause telemetry.pyo:127 Attempting final telemetry harvest. 2016-03-29 09:21:01,318 -0400 INFO pid=487 123145359298560:Worker-2 threads.pyo:109 Execute cleanup callback 'persistence sqlite:79ed962930584ad38456986420b93e82/Users/lgroff/Library/Application Support/Googie/Drive/user default/sync_config.db' 2016-03-29 09:21:01,319 -0400 INFO pid=487 123145359298560:Worker-2 threads.pyo:109 Execute cleanup callback 'persistence sqlite:3fec09da3e2c4cbbbc8894d42d7e8623/Users/lgroff/Library/Application Support/Googie/Drive/user default/snapshot.db' 2016-03-29 09:21:01,319 -0400 INFO pid=487 123145325645824:FilewatcherMonitor sync_client thread.pyo:83 ThreadExit: thread FilewatcherMonitor exiting normalish 2016-03-29 09:21:01,319 -0400 INFO pid=487 123145350885376:CloudWatcher threads.pyo:109 Execute cleanup callback 'persistence sqlite:16ff5428315041b08503d483ebaa4640/Users/lgroff/Library/Application Support/Googie/Drive/user default/snapshot.db' 2016-03-29 09:21:01,319 -0400 INFO pid=487 123145384538112:RootWrangler root_wrangler.pyo:96 RootWrangler.RootObserverUnregistered 2016-03-29 09:21:01,319 -0400 INFO pid=487 123145380331520:PauseTelemetryThread pause_telemetry.pyo:190 Harvested pause statistics at t=1459257661.32: (‹PauseReason.API ERRORS: 'pause api err'>: _HarvestStat(paused=0.0, trial=0.0, occurrences=0), aauseReason.BLOeKINa_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-03-29 09:21:01,319 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <Batcher(Batcher, started 123145388744704)> with tid 123145388744704 to stop. 2016-03-29 09:21:01,320 -0400 INFO pid=487 123145350885376:CloudWatcher threads.pyo:109 Execute cleanup callback 'persistence sqlite:6a4a6b2704ef485cb09764e40093d4f2/Users/lgroff/Library/Application Support/Googie/Drive/user default/sync_config.db' 2016-03-29 09:21:01,320 -0400 INFO pid=487 123145384538112:RootWrangler sync client thread.pyo:83 ThreadExit: thread RootWrangler exiting normalish 2016-03-29 59:21:01,320 -0400 INFO pid=487 123145380331520:PauseTelemetryThread sync_client thread.pyo:83 ThreadExit: thread PauseTelemetryThread exiting normalish 2016-03-29 09:21:01,320 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <PushNotificationKeepaliveThread(PushNotificationKeepaliveThread, started 123145392951296)> with tid 123145392951296 to stop. 2016-03-29 09:21:01,320 -0400 INFO pid=487 123145388744704:Batcher sync client thread.pyo:272 Batcher run loop has terminated. 2016-03-29 59:21:01,320 -0400 INFO pid=487 123145350885376:CloudWatcher threads.pyo:109 Execute cleanup callback 'DBConnectionManagerCleanupCallback' 2016-03-29 09:21:01,321 -0400 INFO pid=487 123145388744704:Batcher sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user default/snapshot.db 2016-03-29 09:21:01,321 -0400 INFO pid=487 123145350885376:CloudWatcher db_connection.pyo:433 Closing ManagedConnection(id=1123610D0, thread=CloudWatcher- EFTA00503470 700002E53000, path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/cloud_graph/dict_2.db, closed=False) 2016-03-29 09:21:01,322 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <RunFunctionThread(_LaunchSyncApp, stopped 123145319829504)> with tid 123145319829504 to stop. 2016-03-29 09:21:01,322 -0400 INFO pid=487 123145392951296:PushNotificationKeepaliveThread sync_client_thread.pyo:212 PushNotificationKeepaliveThread run loop has terminated. 2016-03-29 09:21:01,322 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <LocalDiskSpaceChecker(LocalDiskSpaceChecker, started 123145397157888)> with tid 123145397157888 to stop. 2016-03-29 09:21:01,322 -0400 INFO pid=487 123145392951296:PushNotificationKeepaliveThread sync_client_thread.pyo:83 ThreadExit: thread PushNotificationKeepaliveThread exiting normalish 2016-03-29 09:21:01,323 -0400 INFO pid=487 123145397157888:LocalDiskSpaceChecker sync_client_thread.pyo:212 LocalDiskSpaceChecker run loop has terminated. 2016-03-29 09:21:01,323 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <TelemetryStoreSizeMonitor(TelemetryStoreSizeMonitorThread, started 123145401364480)> with tid 123145401364480 to stop. 2016-03-29 09:21:01,323 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <CrashReportUploaderThread(CrashReportUploaderThread, started 123145405571072)> with tid 123145405571072 to stop. 2016-03-29 09:21:01,323 -0400 INFO pid=487 123145397157888:LocalDiskSpaceChecker sync_client_thread.pyo:83 ThreadExit: thread LocalDiskSpaceChecker exiting normalish 2016-03-29 09:21:01,323 -0400 INFO pid=487 123145388744704:Batcher sync_client_thread.pyo:83 ThreadExit: thread Batcher exiting normalish 2016-03-29 09:21:01,323 -0400 INFO pid=487 123145401364480:TelemetryStoreSizeMonitorThread sync_client_thread.pyo:212 TelemetryStoreSizeMonitorThread run loop has terminated. 2016-03-29 09:21:01,323 -0400 INFO pid=487 123145405571072:CrashReportUploaderThread sync_client_thread.pyo:83 ThreadExit: thread CrashReportUploaderThread exiting normalish 2016-03-29 09:21:01,324 -0400 INFO pid=487 140735239327744:MainThread thread manager.pyo:253 Asking <SyncClientWaitingThreadWithCallback(DocIdsFetcherThread- , started 123145409777664)> with tid 123145409777664 to stop. 2016-03-29 09:21:01,324 -0400 INFO pid=487 123145401364480:TelemetryStoreSizeMonitorThread sync_client_thread.pyo:83 ThreadExit: thread TelemetryStoreSizeMonitorThread exiting normalish 2016-03-29 09:21:01,324 -0400 INFO pid=487 123145388744704:Batcher threads.pyo:109 Execute cleanup callback 'persistence_sglite:b0dc86ef686c4bc48e6ebbacb499cca5/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2016-03-29 09:21:01,324 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <Worker(Worker-1, started 123145413984256)> with tid 123145413984256 to stop. 2016-03-29 09:21:01,324 -0400 INFO pid=487 123145409777664:DocIdsFetcherThread- sync_client_thread.pyo:272 run loop has terminated. 2016-03-29 09:21:01,325 -0400 INFO pid=487 123145388744704:Batcher threads.pyo:109 Execute cleanup callback 'persistence_sglite:9d4383fa565f44a49ac4a152cca77e54/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2016-03-29 09:21:01,325 -0400 INFO pid=487 123145409777664:DocIdsFetcherThread- sync_client_thread.pyo:83 ThreadExit: thread DocldsFetcherThread- exiting normalish 2016-03-29 09:21:01,325 -0400 INFO pid=487 123145388744704:Batcher sglite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-03-29 09:21:01,325 -0400 INFO pid=487 140735239327744:MainThread thread_manager.pyo:253 Asking <PushXmppClient(XmppClient, started 123145418190848)> with tid 123145418190848 to stop. 2016-03-29 09:21:01,326 -0400 INFO pid=487 123145413984256:Worker-1 sync_client_thread.pyo:212 Worker-1 run loop has terminated. 2016-03-29 09:21:01,326 -0400 WARNING pid=487 140735239327744:MainThread task.pyo:242 DriveXmppTask-0x111f82950 aborting: abort 2016-03-29 09:21:01,326 -0400 INFO pid=487 123145413984256:Worker-1 sglite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db EFTA00503471 2016-03-29 09:21:01,326 -0400 INFO pid=487 140735239327744:MainThread task.pyo:254 Task <common.push.push_xmpp_client.DriveXmppTask object at 0x111f82950> complete. 2016-03-29 09:21:01,327 -0400 INFO pid=487 140735239327744:MainThread xmpplib.pyo:143 Close called with 'why' reason = Client initiated close 2016-03-29 09:21:01,328 -0400 INFO pid=487 123145413984256:Worker-1 sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-03-29 09:21:01,328 -0400 INFO pid=487 123145413984256:Worker-1 sync_client_thread.pyo:83 ThreadExit: thread Worker-1 exiting normalish 2016-03-29 09:21:01,328 -0400 INFO pid=487 123145413984256:Worker-1 threads.pyo:109 Execute cleanup callback 'persistence_sqlite:d9c7ba76de4946748588ef9d39eccbbl/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2016-03-29 09:21:01,328 -0400 INFO pid=487 123145413984256:Worker-1 threads.pyo:109 Execute cleanup callback 'persistence_sqlite:dcb2e3ddfc784c75b858122a09e27ded/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2016-03-29 09:22:40,372 -0400 INFO pid=348 140735095025664:MainThread logging_config.pyo:257 OS: Darwin/10.11.3 2016-03-29 09:22:40,373 -0400 INFO pid=348 140735095025664:MainThread logging_config.pyo:260 Google Drive (build 1.28.1549.1322) 2016-03-29 09:22:40,373 -0400 INFO pid=348 140735095025664:MainThread logging_config.pyo:261 SSL: OpenSSL 0.9.8zg 14 July 2015 2016-03-29 09:22:40,390 -0400 INFO pid=348 140735095025664:MainThread GSyncAppDelegate.pyo:198 Application did finish launching. 2016-03-29 09:22:40,407 -0400 INFO pid=348 140735095025664:MainThread service.pyo:132 Creating singleton service instance of '<class 'common.file_lock.FileLock'>' 2016-03-29 09:22:40,408 -0400 INFO pid=348 140735095025664:MainThread service.pyo:132 Creating singleton service instance of '<class 'common.file lock.FileLocki> 1 2016-03-29 09:22:40,408 -0400 INFO pid=348 123145309270016:RunAsync-_InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.service.user.User'>' 2016-03-29 09:22:40,409 -0400 INFO pid=348 123145309270016:RunAsync-_InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.roots.roots.RootManager'>. 2016-03-29 09:22:40,409 -0400 INFO pid=348 123145309270016:RunAsync-_InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.thread_manager.ThreadManager'> 1 2016-03-29 09:22:40,409 -0400 INFO pid=348 123145309270016:RunAsync-_InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.pause_manager.Service'>' 2016-03-29 09:22:40,409 -0400 INFO pid=348 123145309270016:RunAsync-_InitializeSyncAppAsync-1 sync_app.pyo:344 Getting TokenStorage... 2016-03-29 09:22:40,409 -0400 INFO pid=348 123145309270016:RunAsync-_InitializeSyncAppAsync-1 sync_app.pyo:346 Got token storage: <platforms.token_storage.TokenStorage object at 0x10fa23d50> 2016-03-29 09:22:40,410 -0400 INFO pid=348 123145309270016:RunAsync-_InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.features.AppFeatures'>' 2016-03-29 09:22:40,410 -0400 INFO pid=348 123145309270016:RunAsync-_InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.cert.Manager'>' 2016-03-29 09:22:40,415 -0400 INFO pid=348 123145309270016:RunAsync-_InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.net.bandwidth.BandwidthThrottler'>' 2016-03-29 09:22:40,416 -0400 INFO pid=348 123145309270016:RunAsync-_InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.persistence.persistence.Factory'>' 2016-03-29 09:22:40,416 -0400 INFO pid=348 123145309270016:RunAsync-_InitializeSyncAppAsync-1 persistence.pyo:39 Initialize factory with policy ElatformEolicy(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-03-29 09:22:40,416 -0400 INFO pid=348 123145309270016:RunAsync-_InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.persistence.sync_config_sqlite.SyncConfigSOLite'>' 2016-03-29 09:22:40,417 -0400 INFO pid=348 123145309270016:RunAsync-_InitializeSyncAppAsync-1 EFTA00503472 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-03-29 09:22:40,417 -0400 INFO pid=348 123145309270016:RunAsync-_InitializeSyncAppAsync-1 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-03-29 09:22:40,418 -0400 INFO pid=348 123145309270016:RunAsync-_InitializeSyncAppAsync-1 threads.pyo:130 AddcleanupCallback persistence_sqlite:4dc74edlba85449990c555dd284e28eb/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-03-29 09:22:40,418 -0400 INFO pid=348 123145309270016:RunAsync-_InitializeSyncAppAsync-1 threads.pyo:130 AddcleanupCallback persistence_sqlite:a0046772aae743488d9c05a78a68celd/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-03-29 09:22:40,420 -0400 INFO pid=348 123145309270016:RunAsync-_InitializeSyncAppAsync-1 sync_app.pyo:522 BandwidthThrottler configured via sync_config 2016-03-29 09:22:40,420 -0400 INFO pid=348 123145309270016:RunAsync-_InitializeSyncAppAsync-1 bandwidth.pyo:59 BandwidthThrottler.SetRxBytesPerSecond 0 2016-03-29 09:22:40,421 -0400 INFO pid=348 123145309270016:RunAsync-_InitializeSyncAppAsync-1 bandwidth.pyo:68 BandwidthThrottler.SetTxBytesPerSecond 0 2016-03-29 09:22:40,421 -0400 INFO pid=348 123145309270016:RunAsync-_InitializeSyncAppAsync-1 sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-03-29 09:22:40,421 -0400 INFO pid=348 123145309270016:RunAsync-_InitializeSyncAppAsync-1 sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-03-29 09:22:40,421 -0400 INFO pid=348 123145309270016:RunAsync-_InitializeSyncAppAsync-1 threads.pyo:109 Execute cleanup callback 'persistence_sqlite:a0046772aae743488d9c05a78a68celd/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2016-03-29 09:22:40,422 -0400 INFO pid=348 123145309270016:RunAsync-_InitializeSyncAppAsync-1 threads.pyo:109 Execute cleanup callback 'persistence_sqlite:4dc74edlba85449990c555dd284e28eb/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2016-03-29 09:22:40,451 -0400 INFO pid=348 140735095025664:MainThread image_resources.py:228 Loading image images/ic_drawer_24.png 2016-03-29 09:22:40,453 -0400 INFO pid=348 140735095025664:MainThread image_resources.py:228 Loading image images/menu_drive-logo.png 2016-03-29 09:22:40,453 -0400 INFO pid=348 140735095025664:MainThread image_resources.py:228 Loading image images/menu_google-logo-gray.png 2016-03-29 09:22:40,455 -0400 INFO pid=348 140735095025664:MainThread image_resources.py:228 Loading image images/ic_folder_mydrive_24.png 2016-03-29 09:22:40,456 -0400 INFO pid=348 140735095025664:MainThread image_resources.py:228 Loading image images/ic_web_24.png 2016-03-29 09:22:40,457 -0400 INFO pid=348 140735095025664:MainThread image_resources.py:228 Loading image images/ic_sync_problem_24.png 2016-03-29 09:22:40,472 -0400 INFO pid=348 140735095025664:MainThread image_resources.py:228 Loading image images/ic_done.png 2016-03-29 09:22:40,512 -0400 INFO pid=348 123145316159488:ThreadMonitor thread_manager.pyo:339 Waiting on exit condition. Wake up after 3600s. 2016-03-29 09:22:40,512 -0400 INFO pid=348 123145320366080:_LaunchSyncApp sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-03-29 09:22:40,513 -0400 INFO pid=348 123145320366080:_LaunchSyncApp sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-03-29 09:22:40,514 -0400 INFO pid=348 123145320366080:_LaunchSyncApp threads.pyo:130 AddCleanupCallback persistence_sqlite:8d314a3972814fbcb773a7bb957c5403/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-03-29 09:22:40,514 -0400 INFO pid=348 123145320366080:_LaunchSyncApp threads.pyo:130 AddCleanupCallback persistence_sqlite:aafe2e583825492b97773600129eb333/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-03-29 09:22:40,539 -0400 INFO pid=348 123145320366080:_LaunchSyncApp user.pyo:68 Initializing User instance with new credentials. None EFTA00503473 2016-03-29 09:22:40,539 -0400 INFO pid=348 123145320366080:_LaunchSyncApp docs_client_factory.pyo:89 Creating a new DriveClient 2016-03-29 09:22:40,539 -0400 INFO pid=348 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.quota.Quotalnfo'>' 2016-03-29 09:22:40,540 -0400 INFO pid=348 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.token_bucket.CloudBucketManager'>' 2016-03-29 09:22:40,540 -0400 INFO pid=348 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive_api.drive_resource.Manager'>. 2016-03-29 09:22:40,540 -0400 INFO pid=348 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive_api.http.Manager'>. 2016-03-29 09:22:40,540 -0400 ERROR pid=348 123145311952896:IpcServerThread ipc_socket_base.pyo:247 Failed to bind to socket /Users/lgroff/Library/Group Containers/google_drive/tmpic4vec (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: [Erma 48] Address already in use 2016-03-29 09:22:40,540 -0400 INFO pid=348 123145320366080:_LaunchSyncApp drive_resource.pyo:134 Initialize apiclient Drive resource for current user token 2016-03-29 09:22:40,541 -0400 ERROR pid=348 123145311952896:IpcServerThread ipc_socket_base.pyo:247 Failed to bind to socket /Users/lgroff/Library/Group Containers/google_drive/tmpic4vec (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: [Erma 48] Address already in use 2016-03-29 09:22:40,541 -0400 ERROR pid=348 123145311952896:IpcServerThread ipc_socket_base.pyo:247 Failed to bind to socket /Users/lgroff/Library/Group Containers/google_drive/tmpic4vec (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: [Erma 48] Address already in use 2016-03-29 09:22:40,542 -0400 WARNING pid=348 123145311952896:IpcServerThread server.pyo:145 Socket (/Users/lgroff/Library/Application Support/Google/Drive/GoogleDrivelpcPipe) already in use, deleting it. 2016-03-29 09:22:40,549 -0400 INFO pid=348 123145320366080: LaunchSyncApp drive_resource.pyo:195 Drive SDK baseUrl = 2016-03-29 09:22:40,549 -0400 INFO pid=348 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive_api.http.AccessTokenlnMemoryCache'>' 2016-03-29 09:22:40,550 -0400 INFO pid=348 123145320366080:_LaunchSyncApp drive_request.pyo:290 Drive request: About(tags=Reason.SYNC_OTHER) - Read request - None 2016-03-29 09:22:40,551 -0400 INFO pid=348 123145320366080: LaunchSyncApp discovery.pyo:762 URL being requested: GET fields=rootFolderld%2CquotaBytesTotal%2CquotaBytesUsedAggregate%2CquotaBytesUsedInTrash%2Cquo taType%2Cuser%2FemailAddress&reason=304Salt=json 2016-03-29 09:22:40,551 -0400 INFO pid=348 123145320366080:_LaunchSyncApp client.pyo:515 Attempting refresh to obtain initial access_token 2016-03-29 09:22:40,551 -0400 INFO pid=348 123145320366080:_LaunchSyncApp client.pyo:755 Refreshing access_token 2016-03-29 09:22:40,554 -0400 INFO pid=348 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.net.dapper.DapperService'>' 2016-03-29 09:22:40,554 -0400 INFO pid=348 123145320366080:_LaunchSyncApp http.pyo:256 Request user-agent: Python-httplib2/0.9.2 (gzip) 2016-03-29 09:22:40,554 -0400 INFO pid=348 123145320366080: LaunchSyncApp sync_http_client.pyo:238 Opening direct connection to 2016-03-29 09:22:40,705 -0400 INFO pid=348 123145320366080:_LaunchSyncApp http.pyo:275 Response: 151 bytes - application/json; charset=utf-8 (encoding:gzip) 2016-03-29 09:22:40,706 -0400 INFO pid=348 123145320366080:_LaunchSyncApp http.pyo:256 Request user-agent: googledrivesync-1.28.1549.1322 google-api-python-client/1.3.1 (gzip) (Darwin/10.11.3) EFTA00503474 2016-03-29 09:22:40,706 -0400 INFO pid=348 123145320366080: LaunchSyncApp sync_http_client.pyo:238 Opening direct connection to 2016-03-29 09:22:41,286 -0400 INFO pid=348 123145320366080: LaunchSyncApp http.pyo:275 Response: 242 bytes - application/json; charset=UTF-8 (encoding:gzip) 2016-03-29 09:22:41,287 -0400 INFO pid=348 123145320366080:_LaunchSyncApp drive_request.pyo:297 Drive response: Request (None): About(tags=Reason.SYNC_OTHER) Response: About(root_id=OABNN8iEiWGvgUk9PVA, quota bytes_total=107374182400, quota_bytes used aggregate=16725665732, quota—bytes used_in_trash=410211811, quota_type=LIMITED) 2016-03-29 09:22:41,288 -0400 INFO pid=348 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive api.doc_id_provider.Store'>' 2016-03-29 09:22:41,288 -0400 INFO pid=348 123145320366080: EaunchSyncApp user.pyo:68 Initializing User instance with new credentials. 2016-03-29 09:22:41,288 -0400 INFO pid=348 123145320366080:_LaunchSyncApp sync_app.pyo:1322 Configuring sync app from feature switches. 2016-03-29 09:22:41,288 -0400 INFO pid=348 123145320366080:_LaunchSyncApp features.pyo:112 Loads feature switches. 2016-03-29 09:22:41,289 -0400 INFO pid=348 123145320366080:_LaunchSyncApp feature_switch manager.pyo:672 Calling server to get feature switches. 2016-03-29 09:22:41,290 -0400 INFO pid=348 123145320366080:_LaunchSyncApp drive_request.pyo:290 Drive request: ListFeatureSwitches(tags=Reason.SYNC_OTHER) - Read request - 2016-03-29 09:22:41,291 -0400 INFO pid=348 123145320366080: LaunchSyncApp discovery.pyo:762 URL being requested: GET fields=items%2Fkey%2Citems%2FValue&reason=304&namespace=FEATURE_SWITCHSalt=json 2016-03-29 09:22:41,292 -0400 INFO pid=348 123145320366080:_LaunchSyncApp http.pyo:256 Request user-agent: googledrivesync-1.28.1549.1322 google-api-python-client/1.3.1 (gzip) (Darwin/10.11.3) 2016-03-29 09:22:41,356 -0400 INFO pid=348 123145320366080:_LaunchSyncApp http.pyo:275 Response: 1546 bytes - application/json; charset=UTF-8 (encoding:gzip) 2016-03-29 09:22:41,357 -0400 INFO pid=348 123145320366080:_LaunchSyncApp drive_request.pyo:297 Drive response: Request ( ) ListFeatureSwitches(tags=Reason.SYNC_OTHER) Response: (u'cloud_graph disk_generation': u'2', u'crash_throttle_percentage': u'0', u'enable_arbitrary_sync': u'false', u'enable_change filters': u'false., u'enable_disk clieck_on_preferences': u'true', u'enable_disk—check_on setup': u'true', u'enable_feedtiack': 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_aetection': u'false', u'log_backup_count': u'0', u'max_batch_upload files': u'30', u'max_page_size_seiective_sync': u'1000', u'perf_throttle_percentage': u'100', u'query_strategy': u'all', u'selective_sub_folder_sync': u'false', u'test.featureswitch.name': u", u'use drive api': u'true') 2016-03-29 09:22:41,360 -0400 INFO pid=348 123145320366080:_LaunchSyncApp sync_app.pyo:1346 Feature Switches: FeatureSwitchSettings( EFTA00503475 accept_blob_download_gzip_encoding=True, backup_polling_interval_secs=7200, change_filters=('DRIVE_SYNCI), 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=iurl 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, 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= 1 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_selective sync=1000, new_document_ur1= 1 new_presentation_ur1=' new_spreadsheet_ur1=' numworkers=3, open_ur1= 1 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_clientversion=1, push_keepalive_interval=72000.0, query_strategy=u'all', regular_polling_interval_secs=30, selective_sub_folder sync=False, 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=' token_bucket_read_gps=10, EFTA00503476 token_bucketwrite_qps=3, use_drive_api=True, user_confirmation_delay=2.0,) 2016-03-29 09:22:41,361 -0400 INFO pid=348 123145320366080:_LaunchSyncApp logging_config.pyo:257 OS: Darwin/10.11.3 2016-03-29 09:22:41,361 -0400 INFO pid=348 123145320366080:_LaunchSyncApp logging_config.pyo:260 Google Drive (build 1.28.1549.1322) 2016-03-29 09:22:41,361 -0400 INFO pid=348 123145320366080:_LaunchSyncApp logging_config.pyo:261 SSL: OpenSSL 0.9.8zg 14 July 2015 2016-03-29 09:22:41,361 -0400 INFO pid=348 123145320366080:_LaunchSyncApp sync_app.pyo:1355 Config: Email: Sync root: /Users/lgroff/Google Drive Sync collections: set([]) Upgrade number: 23 App version: 1.28.1549.1322 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 USB sync enabled: True Do sync default folder: True 2016-03-29 09:22:41,364 -0400 INFO pid=348 123145320366080:_LaunchSyncApp telemetry.pyo:228 SetPushClientVersion: 1 (3, 20130807) 2016-03-29 09:22:41,364 -0400 INFO pid=348 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.push.telemetry.PushTelemetry'> 1 2016-03-29 09:22:41,364 -0400 INFO pid=348 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.telemetry.impression_logger_manager.ImpressionLoggerManager'>. 2016-03-29 09:22:41,840 -0400 INFO pid=348 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.managers.LockManager'>' 2016-03-29 09:22:41,841 -0400 INFO pid=348 123145320366080:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.downloads.DownloadCreate 2016-03-29 09:22:41,841 -0400 INFO pid=348 123145320366080:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.downloads.DownloadModify 2016-03-29 09:22:41,841 -0400 INFO pid=348 123145320366080:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadCreate 2016-03-29 09:22:41,841 -0400 INFO pid=348 123145320366080:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadDelete 2016-03-29 09:22:41,841 -0400 INFO pid=348 123145320366080:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadModify 2016-03-29 09:22:41,841 -0400 INFO pid=348 123145320366080:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadMove 2016-03-29 09:22:41,841 -0400 INFO pid=348 123145320366080:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadMoveFrom 2016-03-29 09:22:41,841 -0400 INFO pid=348 123145320366080:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadMoveTo 2016-03-29 09:22:41,842 -0400 INFO pid=348 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.roots.root_wrangler.RootWrangler'>' 2016-03-29 09:22:41,842 -0400 INFO pid=348 123145320366080:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.machine_folder.Manager'>' 2016-03-29 09:22:41,842 -0400 INFO pid=348 123145320366080:_LaunchSyncApp service.pyo:132 EFTA00503477 Creating singleton service instance of '<class 'common.secure_user_storage.Manager'>. 2016-03-29 09:22:41,922 -0400 INFO pid=348 123145324572672:FilewatcherMonitor filewatcher.pyo:71 filewatcher_ext initialized 2016-03-29 09:22:41,922 -0400 INFO pid=348 123145320366080:_LaunchSyncApp docs_client_factory.pyo:89 Creating a new DriveClient 2016-03-29 09:22:41,922 -0400 INFO pid=348 123145320366080:_LaunchSyncApp docs_client_factory.pyo:89 Creating a new DriveClient 2016-03-29 09:22:41,923 -0400 INFO pid=348 123145320366080:_LaunchSyncApp docs_client_factory.pyo:89 Creating a new DriveClient 2016-03-29 09:22:41,923 -0400 INFO pid=348 123145320366080:_LaunchSyncApp docs_client_factory.pyo:89 Creating a new DriveClient 2016-03-29 09:22:41,923 -0400 INFO pid=348 123145320366080:_LaunchSyncApp docs_client_factory.pyo:89 Creating a new DriveClient 2016-03-29 09:22:41,923 -0400 INFO pid=348 123145320366080:_LaunchSyncApp docs_client_factory.pyo:89 Creating a new DriveClient 2016-03-29 09:22:41,923 -0400 INFO pid=348 123145320366080:_LaunchSyncApp docs_client_factory.pyo:89 Creating a new DriveClient 2016-03-29 09:22:41,924 -0400 INFO pid=348 123145320366080:_LaunchSyncApp xmpplib_notifier.pyo:34 Configure storage: <common.push.tango.storage.SyncConfigStorage; proxy of <Swig Object of type 'invalidation::Storage *' at 0x1120d7ed0> > 2016-03-29 09:22:41,924 -0400 INFO pid=348 123145320366080:_LaunchSyncApp xmpplib_notifier.pyo:59 Creating client thread 2016-03-29 09:22:41,924 -0400 INFO pid=348 123145320366080: LaunchSyncApp push_xmpp_client.pyo:223 Using talk server: 2016-03-29 09:22:41,924 -0400 INFO pid=348 123145320366080:_LaunchSyncApp xmpplib_notifier.pyo:68 Creating notification bridge 2016-03-29 09:22:41,925 -0400 INFO pid=348 123145320366080:_LaunchSyncApp docs_client_factory.pyo:89 Creating a new DriveClient 2016-03-29 09:22:41,927 -0400 INFO pid=348 123145320366080:_LaunchSyncApp image_resources.py:279 Loading custom image images/folder-mac-yosemite.icns with function CreateNSImage 2016-03-29 09:22:41,928 -0400 INFO pid=348 123145328779264:LocalFSPoller sync_client_thread.pyo:178 LocalFSPoller run loop has started. 2016-03-29 09:22:41,928 -0400 INFO pid=348 123145332985856:CrashReportUploaderThread crash report uploader thread.pyo:60 Starting CrashReportUploaderThread. 2016-03-29 09:22:41,929 -0400 INFO pid=348 123145337192448:PushNotificationKeepaliveThread sync_client_thread.pyo:178 PushNotificationKeepaliveThread run loop has started. 2016-03-29 09:22:41,929 -0400 INFO pid=348 123145337192448:PushNotificationKeepaliveThread push_notification_keepalive_thread.pyo:49 Sent push keepalive message at: Tue Mar 29 09:22:41 2016 2016-03-29 09:22:41,929 -0400 INFO pid=348 123145341399040:TelemetryStoreSizeMonitorThread sync_client_thread.pyo:178 TelemetryStoreSizeMonitorThread run loop has started. 2016-03-29 09:22:41,929 -0400 INFO pid=348 123145341399040:TelemetryStoreSizeMonitorThread telemetry_store monitor_thread.pyo:44 Checking Telemetry store size. 2016-03-29 09:22:41,930 -0400 INFO pid=348 123145345605632:PushTelemetryThread sync_client_thread.pyo:178 PushTelemetryThread run loop has started. 2016-03-29 09:22:41,930 -0400 INFO pid=348 123145349812224:LocalWatcher watcher.pyo:342 LocalWatcher Run invoked.Waiting for first pass of local scan from poller to start 2016-03-29 09:22:41,931 -0400 INFO pid=348 123145362432000:XmppClient telemetry.pyo:153 Push state None => PushStates.CONNECTING 2016-03-29 09:22:41,931 -0400 INFO pid=348 123145362432000:XmppClient connection_task.pyo:151 Recalculated LoginTask timeout: 16.000000 2016-03-29 09:22:41,932 -0400 INFO pid=348 123145366638592:Worker-2 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-03-29 09:22:41,932 -0400 INFO pid=348 123145362432000:XmppClient telemetry.pyo:167 PushStates.CONNECTING: +0.00149503 => 0.00149503 2016-03-29 09:22:41,933 -0400 INFO pid=348 123145362432000:XmppClient xmpplib.pyo:80 Connecting to 2016-03-29 09:22:41,933 -0400 INFO pid=348 123145370845184:SyncClientImpressionsThread sync_client_thread.pyo:178 SyncClientImpressionsThread run loop has started. 2016-03-29 09:22:41,933 -0400 INFO pid=348 123145375051776:CloudWatcher sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-03-29 09:22:41,934 -0400 INFO pid=348 123145379258368:OverlayStatusCleaner EFTA00503478 sync_client_thread.pyo:178 OverlayStatusCleaner run loop has started. 2016-03-29 09:22:41,934 -0400 INFO pid=348 123145366638592:Worker-2 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-03-29 09:22:41,935 -0400 INFO pid=348 123145383464960:Worker-0 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-03-29 09:22:41,935 -0400 INFO pid=348 123145387671552:LocalDiskSpaceChecker sync_client_thread.pyo:178 LocalDiskSpaceChecker run loop has started. 2016-03-29 09:22:41,937 -0400 INFO pid=348 123145396084736:RootWrangler root_wrangler.pyo:92 RootWrangler.RootObserverRegistered with roots r_MyDriveRoot(u'/Users/lgroff/Google Drive', LocallD(inode=435288), 'root', <RootState.INITED: 2>)] 2016-03-29 09:22:41,938 -0400 INFO pid=348 123145396084736:RootWrangler root_wrangler.pyo:100 RootWrangler.RootsAdded with roots ]_MyDriveRoot(u'/Users/lgroff/Google Drive', LocallD(inode=435288), 'root', <RootState.INITED: 2>)] 2016-03-29 09:22:41,938 -0400 INFO pid=348 123145396084736:RootWrangler sync_client_thread.pyo:178 RootWrangler run loop has started. 2016-03-29 09:22:41,938 -0400 INFO pid=348 123145400291328:Hatcher sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-03-29 09:22:41,938 -0400 INFO pid=348 123145366638592:Worker-2 threads.pyo:130 AddCleanupCallback persistence_sqlite:144e25bal8e9431cb0ff8662f3f08e7f/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-03-29 09:22:41,939 -0400 INFO pid=348 123145375051776:CloudWatcher sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-03-29 09:22:41,939 -0400 INFO pid=348 123145408704512:Worker-1 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-03-29 09:22:41,939 -0400 INFO pid=348 123145412911104:RawEventUpgrader sync_client_thread.pyo:178 RawEventUpgrader run loop has started. 2016-03-29 09:22:41,939 -0400 INFO pid=348 123145396084736:RootWrangler root_wrangler.pyo:82 RootWrangler got inited root _MyDriveRoot(u'/Users/lgroff/Google Drive', LocallD(inode=435288), 'root', <RootState.INITED: 2>) 2016-03-29 09:22:41,940 -0400 INFO pid=348 123145417117696:PauseTelemetryThread sync_client_thread.pyo:178 PauseTelemetryThread run loop has started. 2016-03-29 09:22:41,940 -0400 INFO pid=348 123145425530880:ConfirmationHandler sync_client_thread.pyo:178 ConfirmationHandler run loop has started. 2016-03-29 09:22:41,940 -0400 INFO pid=348 123145366638592:Worker-2 threads.pyo:130 AddCleanupCallback persistence_sqlite:736fc7c53850472e952733075fc94017/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-03-29 09:22:41,940 -0400 INFO pid=348 123145421324288:FeatureSwitchPoller sync_client_thread.pyo:178 FeatureSwitchPoller run loop has started. 2016-03-29 09:22:41,941 -0400 INFO pid=348 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-03-29 09:22:41,941 -0400 INFO pid=348 123145383464960:Worker-0 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-03-29 09:22:41,941 -0400 INFO pid=348 123145400291328:Batcher sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-03-29 09:22:41,942 -0400 INFO pid=348 123145375051776:CloudWatcher threads.pyo:130 AddCleanupCallback persistence_sqlite:7535a8bal8c2450c9febde1876096b82/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-03-29 09:22:41,942 -0400 INFO pid=348 123145366638592:Worker-2 command_factory.pyo:186 Registering worker command type: common.worker.downloads.DownloadChangeACL 2016-03-29 09:22:41,942 -0400 INFO pid=348 123145408704512:Worker-1 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db EFTA00503479 2016-03-29 09:22:41,942 -0400 INFO pid=348 123145421324288:FeatureSwitchPoller feature_switch_manager.pyo:672 Calling server to get feature switches. 2016-03-29 09:22:41,942 -0400 INFO pid=348 123145320366080: LaunchSyncApp doc_id_provider.pyo:235 Waking up fetcher thread to get more doc IDs. Currently running. 2016-03-29 09:22:41,943 -0400 INFO pid=348 123