EFTA00504287.pdf

From: File "Nolumes/BuildData/pulse- datathgents/599758/recipes/986239094/base/b/drb/googleclient/apps/webdrive_sync/osiddist/Google Drive.app/Contents/ftesources/_boot_.py", line 77, in <module> File "Nolumes/BuildData/pulse- datathgents/599758/recipes/986239094/base/b/drb/googleclient/apps/webdrive_sync/osiddist/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 "osxlmac_sync_app_controller.pyo", line 266, in Exit File "common/ui_action_handler.pyo", line 444, in Quit File "common/sync_app.pyo", line 1793, in Quit 2016-07-25 16:57:08,851 -0400 INFO pid=18095 140735151050752:MainThread thread_manager.pyo:116 Stop was called 2016-07-25 16:57:08,852 -0400 INFO pid=18095 140735151050752:MainThread thread_manager.pyo:253 Asking <IpcServerThread(IpcServerThread, started 123145325109248)> with tid 123145325109248 to stop. 2016-07-25 16:57:08,852 -0400 INFO pid=18095 140735151050752:MainThread thread_manager.pyo:253 Asking <RawEventUpgrader(RawEventUpgrader, started 123145388208128)> with tid 123145388208128 to stop. 2016-07-25 16:57:08,852 -0400 INFO pid=18095 140735151050752:MainThread thread_manager.pyo:253 Asking <LocalFSPoller(LocalFSPoller, started 123145337729024)> with tid 123145337729024 to stop. 2016-07-25 16:57:08,852 -0400 INFO pid=18095 140735151050752:MainThread thread_manager.pyo:253 Asking <SyncClientImpressionsThread(SyncClientImpressionsThread, started 123145379794944)> with tid 123145379794944 to stop. 2016-07-25 16:57:08,852 -0400 INFO pid=18095 123145388208128:RawEventUpgrader sync_client_thread.pyo:212 RawEventUpgrader run loop has terminated. 2016-07-25 16:57:08,852 -0400 INFO pid=18095 123145337729024:LocalFSPoller sync_client_thread.pyo:212 LocalFSPoller run loop has terminated. 2016-07-25 16:57:08,853 -0400 INFO pid=18095 123145388208128:RawEventUpgrader sync_client_thread.pyo:83 ThreadExit: thread RawEventUpgrader exiting normalish 2016-07-25 16:57:08,853 -0400 INFO pid=18095 123145337729024:LocalFSPoller sync_client_thread.pyo:83 ThreadExit: thread LocalFSPoller exiting normalish 2016-07-25 16:57:08,853 -0400 INFO pid=18095 140735151050752:MainThread thread_manager.pyo:253 Asking <FeatureSwitchPoller(FeatureSwitchPoller, started 123145346142208)> with tid 123145346142208 to stop. 2016-07-25 16:57:08,853 -0400 INFO pid=18095 123145379794944:SyncClientImpressionsThread sync_client_thread.pyo:212 SyncClientImpressionsThread run loop has terminated. 2016-07-25 16:57:08,854 -0400 INFO pid=18095 123145379794944:SyncClientImpressionsThread sync_client_thread.pyo:83 ThreadExit: thread SyncClientImpressionsThread exiting normalish 2016-07-25 16:57:08,854 -0400 INFO pid=18095 140735151050752:MainThread thread_manager.pyo:253 Asking <Worker(Worker-2, started 123145426067456)> with tid 123145426067456 to stop. 2016-07-25 16:57:08,854 -0400 INFO pid=18095 123145346142208:FeatureSwitchPoller sync_client_thread.pyo:212 FeatureSwitchPoller run loop has terminated. 2016-07-25 16:57:08,855 -0400 INFO pid=18095 140735151050752:MainThread thread_manager.pyo:253 Asking <PauseTelemetryThread(PauseTelemetryThread, started 123145350348800)> with tid 123145350348800 to stop. 2016-07-25 16:57:08,855 -0400 INFO pid=18095 123145346142208:FeatureSwitchPoller sync_client_thread.pyo:83 ThreadExit: thread FeatureSwitchPoller exiting normalish 2016-07-25 16:57:08,856 -0400 INFO pid=18095 123145426067456:Worker-2 sync_client_thread.pyo:212 Worker-2 run loop has terminated. 2016-07-25 16:57:08,856 -0400 INFO pid=18095 123145426067456:Worker-2 sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-07-25 16:57:08,856 -0400 INFO pid=18095 140735151050752:MainThread thread_manager.pyo:253 Asking <TelemetryStoreSizeMonitor(TelemetryStoreSizeMonitorThread, started 123145362968576)> with tid 123145362968576 to stop. 2016-07-25 16:57:08,857 -0400 INFO pid=18095 123145350348800:PauseTelemetryThread sync_client_thread.pyo:212 PauseTelemetryThread run loop has terminated. EFTA00504287 2016-07-25 16:57:08,857 -0400 INFO pid=18095 123145350348800:PauseTelemetryThread pause telemetry.pyo:127 Attempting final telemetry harvest. 2016-07-25 16:57:08,857 -0400 INFO pid=18095 123145350348800:PauseTelemetryThread pause_telemetry.pyo:188 Harvested pause statistics at t=1469480228.86: (‹PauseReason.API ERRORS: 'pause api err'>: _HarvestStat(paused=0.0, trial=0.0, occurrences=0), <5auseReason.BLOeKINa_ERRORS: 'pause blocking_err'>: _HarvestStat(paused=0.0, trial=0.0, occurrences=0), <PauseReason.NETWORK_ERRO5S: '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-07-25 16:57:08,858 -0400 INFO pid=18095 123145350348800:PauseTelemetryThread sync_client_thread.pyo:83 ThreadExit: thread PauseTelemetryThread exiting normalish 2016-07-25 16:57:08,858 -0400 INFO pid=18095 140735151050752:MainThread thread_manager.pyo:253 Asking <Batcher(Batcher, started 123145358761984)> with tid 123145358761984 to stop. 2016-07-25 16:57:08,858 -0400 INFO pid=18095 123145362968576:TelemetryStoreSizeMonitorThread sync_client thread.pyo:212 TelemetryStoreSizeMonitorThread run loop has terminated. 2016-07-25 16:57:08,858 -0400 INFO pid=18095 123145358761984:Batcher sync_client thread.pyo:272 Batcher run loop has terminated. 2016-07-25 16:57:08,858 -0400 INFO pid=18095 140735151050752:MainThread thread manager.pyo:253 Asking <SyncClientWaitingThreadWithCallback(DocIdsFetcherThread- , started 123145354555392)> with tid 123145354555392 to stop. 2016-07-25 16:57:08,858 -0400 INFO pid=18095 123145362968576:TelemetryStoreSizeMonitorThread sync_client_thread.pyo: 83 ThreadExit: thread TelemetryStoreSizeMonitorThread exiting normalish 2016-07-25 16:57:08,858 -0400 INFO pid=18095 123145358761984:Batcher sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user default/snapshot.db 2016-07-25 16:57:08,859 -0400 INFO pid=18095 140735151050752:MainThread thread_manager.pyo:253 Asking <OverlayStatusCleaner(OverlayStatusCleaner, started 123145367175168)> with tid 123145367175168 to stop. 2016-07-25 16:57:08,859 -0400 INFO pid=18095 123145354555392:DocIdsFetcherThread- sync_client_thread.pyo:272 DocldsFetcherThread- run loop has terminated. 2016-07-25 16:57:08,859 -0400 INFO pid=18095 123145426067456:Worker-2 sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user default/sync_config.db 2016-07-25 16:57:08,859 -0400 INFO pid=18095 123145354555392:DocIdsFetcherThread- sync_client_thread.pyo:83 ThreadExit: thread DocldsFetcherThread- exiting normalish 2016-07-25 16:57:08,860 -0400 INFO pid=18095 140735151050752:MainThread thread_manager.pyo:253 Asking <ConnectivityThread(ConnectivityThread, started 123145396621312)> with tid 123145396621312 to stop. 2016-07-25 16:57:08,860 -0400 INFO pid=18095 123145367175168:OverlayStatusCleaner sync_client thread.pyo:212 OverlayStatusCleaner run loop has terminated. 2016-07-25 16:57:08,860 -0400 INFO pid=18095 123145396621312:ConnectivityThread sync_client_thread.pyo:83 ThreadExit: thread ConnectivityThread exiting normalish 2016-07-25 16:57:08,860 -0400 INFO pid=18095 123145426067456:Worker-2 sync_client_thread.pyo:83 ThreadExit: thread Worker-2 exiting normalish 2016-07-25 16:57:08,861 -0400 INFO pid=18095 123145367175168:OverlayStatusCleaner sync_client_thread.pyo:83 ThreadExit: thread OverlayStatusCleaner exiting normalish 2016-07-25 16:57:08,861 -0400 INFO pid=18095 140735151050752:MainThread thread_manager.pyo:253 Asking <SchedulerThread(ListenerScheduler, started 123145413447680)> with tid 123145413447680 to stop. 2016-07-25 16:57:08,861 -0400 INFO pid=18095 123145358761984:Batcher sync_client_thread.pyo:83 ThreadExit: thread Batcher exiting normalish 2016-07-25 16:57:08,862 -0400 INFO pid=18095 123145426067456:Worker-2 threads.pyo:109 Execute cleanup callback 'persistence_sqlite:8d8ef761028e43f196370aa2ec22224b/Users/lgroff/Library/Application Support/Google/Drive/user default/snapshot.db' 2016-07-25 16:57:08,862 -0400 INFO pid=18095 123145413447680:ListenerScheduler sync_client_thread.pyo:83 ThreadExit: thread ListenerScheduler exiting normalish 2016-07-25 16:57:08,862 -0400 INFO pid=18095 140735151050752:MainThread thread_manager.pyo:253 Asking <SchedulerThread(InternalScheduler, started 123145417654272)> EFTA00504288 with tid 123145417654272 to stop. 2016-07-25 16:57:08,862 -0400 INFO pid=18095 123145426067456:Worker-2 threads.pyo:109 Execute cleanup callback 'persistence_sqlite:86a149fbad5441be9e2fled8d30e02d9/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2016-07-25 16:57:08,862 -0400 INFO pid=18095 123145358761984:Batcher threads.pyo:109 Execute cleanup callback 'persistence_sqlite:8aa82083269a4216aedlaba6b32706f9/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2016-07-25 16:57:08,863 -0400 INFO pid=18095 123145417654272:InternalScheduler sync_client_thread.pyo:83 ThreadExit: thread InternalScheduler exiting normalish 2016-07-25 16:57:08,863 -0400 INFO pid=18095 140735151050752:MainThread thread_manager.pyo:253 Asking <Worker(Worker-0, started 1231453840015361> with tid 123145384001536 to stop. 2016-07-25 16:57:08,863 -0400 INFO pid=18095 123145358761984:Batcher sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-07-25 16:57:08,864 -0400 INFO pid=18095 140735151050752:MainThread thread_manager.pyo:253 Asking <LocalWatcher(LocalWatcher, started 1231453335224321> with tid 123145333522432 to stop. 2016-07-25 16:57:08,864 -0400 INFO pid=18095 123145358761984:Batcher threads.pyo:109 Execute cleanup callback 'persistence_sqlite: 8643e0e567cb4ab5a189c8309c83fd31/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2016-07-25 16:57:08,864 -0400 INFO pid=18095 123145384001536:Worker-0 sync_client_thread.pyo:212 Worker-0 run loop has terminated. 2016-07-25 16:57:08,865 -0400 INFO pid=18095 140735151050752:MainThread thread_manager.pyo:253 Asking <CloudWatcher(CloudWatcher, started 1231453924147201> with tid 123145392414720 to stop. 2016-07-25 16:57:08,865 -0400 INFO pid=18095 123145312489472:FilewatcherMonitor sync_client_thread.pyo:83 ThreadExit: thread FilewatcherMonitor exiting normalish 2016-07-25 16:57:08,865 -0400 INFO pid=18095 123145333522432:LocalWatcher sync_client_thread.pyo:83 ThreadExit: thread LocalWatcher exiting normalish 2016-07-25 16:57:08,865 -0400 INFO pid=18095 123145384001536:Worker-0 sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-07-25 16:57:08,865 -0400 INFO pid=18095 140735151050752:MainThread thread_manager.pyo:253 Asking <CrashReportUploaderThread(CrashReportUploaderThread, started 1231453713817601> with tid 123145371381760 to stop. 2016-07-25 16:57:08,866 -0400 INFO pid=18095 123145392414720:CloudWatcher cloud watcher.pyo:1075 Stop detected 2016-07-25 16:57:08,866 -0400 INFO pid=18095 140735151050752:MainThread thread_manager.pyo:253 Asking <RootWrangler(RootWrangler, started 1231454008279041> with tid 123145400827904 to stop. 2016-07-25 16:57:08,866 -0400 INFO pid=18095 123145371381760:CrashReportUploaderThread sync_client_thread.pyo: 83 ThreadExit: thread CrashReportUploaderThread exiting normalish 2016-07-25 16:57:08,866 -0400 WARNING pid=18095 123145392414720:CloudWatcher cloud watcher.pyo: 1121 Exiting CloudWatcher.PushRunLoop() 2016-07-25 16:57:08,867 -0400 INFO pid=18095 123145392414720:CloudWatcher sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-07-25 16:57:08,867 -0400 INFO pid=18095 140735151050752:MainThread thread_manager.pyo:253 Asking <PushXmppelient(Xmppelient, started 1231454050344961> with tid 123145405034496 to stop. 2016-07-25 16:57:08,867 -0400 INFO pid=18095 123145400827904:RootWrangler sync_client_thread.pyo:212 RootWrangler run loop has terminated. 2016-07-25 16:57:08,868 -0400 WARNING pid=18095 140735151050752:MainThread task.pyo:242 DriveXmppTask-0x1123d9a10 aborting: abort 2016-07-25 16:57:08,868 -0400 INFO pid=18095 123145400827904:RootWrangler root_wrangler.pyo: 128 RootWrangler.Root0bserverUnregistered 2016-07-25 16:57:08,868 -0400 INFO pid=18095 140735151050752:MainThread task.pyo:254 Task <common.push.push_xmpp_client.DriveXmppTask object at 0x1123d9a10> complete. 2016-07-25 16:57:08,869 -0400 INFO pid=18095 140735151050752:MainThread xmpplib.pyo:143 Close called with 'why' reason = Client initiated close 2016-07-25 16:57:08,868 -0400 INFO pid=18095 123145400827904:RootWrangler EFTA00504289 sync_client_thread.pyo:83 ThreadExit: thread RootWrangler exiting normalish 2016-07-25 16:57:08,870 -0400 INFO pid=18095 123145384001536:Worker-0 sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-07-25 16:57:08,871 -0400 INFO pid=18095 123145384001536:Worker-0 sync_client_thread.pyo:83 ThreadExit: thread Worker-0 exiting normalish 2016-07-25 16:57:08,872 -0400 INFO pid=18095 123145384001536:Worker-0 threads.pyo:109 Execute cleanup callback 'persistence_sqlite:14bde6eae8d44469affl4e8a20443856/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2016-07-25 16:57:08,872 -0400 INFO pid=18095 123145384001536:Worker-0 threads.pyo:109 Execute cleanup callback 'persistence_sqlite:35ee61d43fal4ce0ab72e05c38cc692d/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2016-07-25 16:57:08,872 -0400 INFO pid=18095 123145392414720:CloudWatcher sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-07-25 16:57:08,872 -0400 INFO pid=18095 123145392414720:CloudWatcher sync_client_thread.pyo:83 ThreadExit: thread CloudWatcher exiting normalish 2016-07-25 16:57:08,873 -0400 INFO pid=18095 123145392414720:CloudWatcher threads.pyo:109 Execute cleanup callback 'persistence_sqlite: 80fac2cf6b424e999201ca0c15ff681d/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2016-07-25 16:57:08,873 -0400 INFO pid=18095 123145392414720:CloudWatcher threads.pyo:109 Execute cleanup callback 'DBConnectionManagerCleanupCallback' 2016-07-25 16:57:08,873 -0400 INFO pid=18095 123145392414720:CloudWatcher db_connection.pyo:433 Closing ManagedConnection(id=1111C3A50, thread=CloudWatcher- 7000055EE000, path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/cloud_graph/dict_2.db, closed=False) 2016-07-25 16:57:08,876 -0400 INFO pid=18095 123145392414720:CloudWatcher threads.pyo:109 Execute cleanup callback 'persistence_sqlite:9cccbad98ab34c5694ccd84eafd0f7ce/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2016-07-26 09:03:49,046 -0400 INFO pid=19182 140735151050752:MainThread logging_config.pyo:257 OS: Darwin/10.11.5 2016-07-26 09:03:49,047 -0400 INFO pid=19182 140735151050752:MainThread logging_config.pyo:260 Google Drive (build 1.30.2170.0459) 2016-07-26 09:03:49,047 -0400 INFO pid=19182 140735151050752:MainThread logging_config.pyo:261 SSL: OpenSSL 0.9.8zh 14 Jan 2016 2016-07-26 09:03:49,089 -0400 INFO pid=19182 140735151050752:MainThread GSyncAppDelegate.pyo:199 Application did finish launching. 2016-07-26 09:03:49,224 -0400 INFO pid=19182 140735151050752:MainThread service.pyo:132 Creating singleton service instance of '<class 'common.file_lock.FileLock'>' 2016-07-26 09:03:49,225 -0400 INFO pid=19182 140735151050752:MainThread service.pyo:132 Creating singleton service instance of '<class 'common.file_lock.FileLock'>' 2016-07-26 09:03:49,226 -0400 INFO pid=19182 123145309270016:RunAsync- InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.service.user.User'>' 2016-07-26 09:03:49,226 -0400 INFO pid=19182 123145309270016:RunAsync- _InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common. roots. roots. RootManager'>' 2016-07-26 09:03:49,226 -0400 INFO pid=19182 123145309270016:RunAsync- _InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.thread_manager.ThreadManager'>' 2016-07-26 09:03:49,227 -0400 INFO pid=19182 123145309270016:RunAsync- InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.pause_manager.Service'>' 2016-07-26 09:03:49,227 -0400 INFO pid=19182 123145309270016:RunAsync- _InitializeSyncAppAsync-1 sync_app.pyo:348 Getting TokenStorage... 2016-07-26 09:03:49,227 -0400 INFO pid=19182 123145309270016:RunAsync- _InitializeSyncAppAsync-1 sync_app.pyo:350 Got token storage: <platforms.token_storage.TokenStorage object at 0x10f82c150> 2016-07-26 09:03:49,227 -0400 INFO pid=19182 123145309270016:RunAsync- _InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.features.AppFeatures'>' EFTA00504290 2016-07-26 09:03:49,228 -0400 INFO pid=19182 123145309270016:RunAsync- InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.cert.Manager'>' 2016-07-26 09:03:49,237 -0400 INFO pid=19182 123145309270016:RunAsync- InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.net.bandwidth.BandwidthThrottler'>' 2016-07-26 09:03:49,240 -0400 INFO pid=19182 123145309270016:RunAsync- InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.persistence.persistence.Factory'>' 2016-07-26 09:03:49,240 -0400 INFO pid=19182 123145309270016: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-07-26 09:03:49,241 -0400 INFO pid=19182 123145309270016:RunAsync- InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.persistence.sync_config_sqlite.SyncConfigSOLite'>' 2016-07-26 09:03:49,241 -0400 INFO pid=19182 123145309270016:RunAsync- _InitializeSyncAppAsync-1 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-07-26 09:03:49,242 -0400 INFO pid=19182 123145309270016:RunAsync- _InitializeSyncAppAsync-1 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-07-26 09:03:49,243 -0400 INFO pid=19182 123145309270016:RunAsync- InitializeSyncAppAsync-1 threads.pyo:130 AddCleanupCallback persistence_sqlite:55a359af0cfe4bbba27aaa944e902765/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-07-26 09:03:49,243 -0400 INFO pid=19182 123145309270016:RunAsync- InitializeSyncAppAsync-1 threads.pyo:130 AddCleanupCallback persistence_sqlite:2f9be5d6ef87454c856b1206155fbf0b/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-07-26 09:03:49,250 -0400 INFO pid=19182 123145309270016:RunAsync- _InitializeSyncAppAsync-1 sync_app.pyo: 565 BandwidthThrottler configured via sync_config 2016-07-26 09:03:49,250 -0400 INFO pid=19182 123145309270016:RunAsync- _InitializeSyncAppAsync-1 bandwidth.pyo: 59 BandwidthThrottler.SetRxBytesPerSecond 0 2016-07-26 09:03:49,251 -0400 INFO pid=19182 123145309270016:RunAsync- _InitializeSyncAppAsync-1 bandwidth.pyo: 68 BandwidthThrottler.SetTxBytesPerSecond 0 2016-07-26 09:03:49,251 -0400 INFO pid=19182 123145309270016:RunAsync- InitializeSyncAppAsync-1 sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-07-26 09:03:49,251 -0400 INFO pid=19182 123145309270016:RunAsync- InitializeSyncAppAsync-1 sqlite.pyo:366 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-07-26 09:03:49,255 -0400 INFO pid=19182 123145309270016:RunAsync- InitializeSyncAppAsync-1 threads.pyo:109 Execute cleanup callback 'persistence_sqlite:55a359af0cfe4bbba27aaa944e902765/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2016-07-26 09:03:49,259 -0400 INFO pid=19182 123145309270016:RunAsync- InitializeSyncAppAsync-1 threads.pyo:109 Execute cleanup callback 'persistence_sqlite:2f9be5d6ef87454c856b1206155fbf0b/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2016-07-26 09:03:49,329 -0400 INFO pid=19182 140735151050752:MainThread image_resources.py:253 Loading image images/ic_drawer_24.png 2016-07-26 09:03:49,333 -0400 INFO pid=19182 140735151050752:MainThread image_resources.py:253 Loading image images/menu_drive-logo.png 2016-07-26 09:03:49,335 -0400 INFO pid=19182 140735151050752:MainThread image_resources.py:253 Loading image images/menu_google-logo-gray.png 2016-07-26 09:03:49,339 -0400 INFO pid=19182 140735151050752:MainThread image_resources.py:253 Loading image images/ic_folder_mydrive_24.png 2016-07-26 09:03:49,343 -0400 INFO pid=19182 140735151050752:MainThread image_resources.py:253 Loading image images/ic_web_24.png 2016-07-26 09:03:49,345 -0400 INFO pid=19182 140735151050752:MainThread image_resources.py:253 Loading image images/ic_sync_problem_24.png 2016-07-26 09:03:49,359 -0400 INFO pid=19182 140735151050752:MainThread image_resources.py:253 Loading image images/ic_done.png EFTA00504291 2016-07-26 09:03:49,441 -0400 INFO pid=19182 123145315622912:ThreadMonitor thread_manager.pyo:339 Waiting on exit condition. Wake up after 3600s. 2016-07-26 09:03:49,444 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp sqlite.pyo:276 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-07-26 09:03:49,446 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp sqlite.pyo:276 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-07-26 09:03:49,446 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp threads.pyo:130 AddCleanupCallback persistence_sqlite:c9ab0b62c5d949819e3c073d3dae6ef8/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-07-26 09:03:49,447 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp threads.pyo:130 AddCleanupCallback persistence_sqlite:96cb11211c5841c0928190ff97829826/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-07-26 09:03:49,482 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp user.pyo:68 Initializing User instance with new credentials. None 2016-07-26 09:03:49,483 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp docs_client_factory.pyo:86 Creating a new DriveClient 2016-07-26 09:03:49,483 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.quota.Quotalnfo'>' 2016-07-26 09:03:49,485 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.token_bucket.CloudBucketManager'>' 2016-07-26 09:03:49,486 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive_api.drive_resource.Manager'>. 2016-07-26 09:03:49,486 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive_api.http.Manager'>' 2016-07-26 09:03:49,486 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp drive_resource.pyo:167 Initialize apiclient Drive resource for current user token 2016-07-26 09:03:49,487 -0400 ERROR pid=19182 123145324036096:IpcServerThread ipc_socket_base.pyo:247 Failed to bind to socket /Users/lgroff/Library/Group Containers/google_drive/tmpP_XzbR (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-07-26 09:03:49,488 -0400 ERROR pid=19182 123145324036096:IpcServerThread ipc_socket_base.pyo:247 Failed to bind to socket /Users/lgroff/Library/Group Containers/google_drive/tmpP_XzbR (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-07-26 09:03:49,488 -0400 ERROR pid=19182 123145324036096:IpcServerThread ipc_socket_base.pyo:247 Failed to bind to socket /Users/lgroff/Library/Group Containers/google_drive/tmpP_XzbR (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-07-26 09:03:49,488 -0400 WARNING pid=19182 123145324036096:IpcServerThread server.pyo:145 Socket (/Users/lgroff/Library/Application Support/Google/Drive/GoogleDrivelpcPipe) already in use, deleting it. 2016-07-26 09:03:49,497 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp drive_resource.pyo:228 Drive SDK baseUrl = https://www.googleapis.com/drive/v2internal/ 2016-07-26 09:03:49,499 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive_api.http.AccessTokenInMemoryCache'> 1 2016-07-26 09:03:49,500 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp drive_request.pyo:297 Drive request: About(tags=Reason.SYNC_OTHER(SyncType.UNKNOWN_SYNC_TYPE)) - Read request - None EFTA00504292 2016-07-26 09:03:49,503 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp discovery.pyo:762 UAL being requested: GET https://www.googleapis.com/drive/v2internal/about? fields=rootFolderld%2CquotaBytesTotal%2CquotaBytesUsedAggregate%2CquotaBytesUsedInTrash%2Cquo taType%2Cuser%2FemailAddress&reason=304Salt=json 2016-07-26 09:03:49,504 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp client.pyo:515 Attempting refresh to obtain initial access_token 2016-07-26 09:03:49,504 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp client.pyo:755 Refreshing access_token 2016-07-26 09:03:49,507 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp system_proxy_resolver.pyo:62 OS proxy config: ExceptionsList = "*.local", "169.254/16" ); FTPPassive = 1; " SCOPED " = enl = ExceptionsList = "*.local", "169.254/16" ); 1; ); FTPPassive = 1; ( 2016-07-26 09:03:49,508 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp system_proxy_resolver.pyo:89 no manual proxies found 2016-07-26 09:03:49,508 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.net.dapper.DapperService'>' 2016-07-26 09:03:49,509 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp http.pyo:257 Request user-agent: Python-httplib2/0.9.2 (gzip) 2016-07-26 09:03:49,509 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp sync_http_client.pyo:238 Opening direct connection to accounts.google.com:443. 2016-07-26 09:03:49,652 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp http.pyo:276 Response: 154 bytes - application/json; charset=utf-8 (encoding:gzip) 2016-07-26 09:03:49,653 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp system_proxy_resolver.pyo:62 OS proxy config: ExceptionsList = "*.local", "169.254/16" ; FTPPassive = 1; " SCOPED " = enl = ExceptionsList = "*.local", "169.254/16" ); 1; ); FTPPassive = 1; ( 2016-07-26 09:03:49,653 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp system_proxy_resolver.pyo:89 no manual proxies found 2016-07-26 09:03:49,654 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp http.pyo:257 Request user-agent: googledrivesync-1.30.2170.0459 google-api-python-client/1.3.1 (gzip) (Darwin/10.11.5) 2016-07-26 09:03:49,654 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp sync_http_client.pyo:238 Opening direct connection to www.googleapis.com:443. 2016-07-26 09:03:50,262 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp http.pyo:276 Response: 242 bytes - application/json; charset=UTF-8 (encoding:gzip) 2016-07-26 09:03:50,263 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp drive_request.pyo:304 Drive response: Request (None): About (tags=Reason.SYNC_OTHER(SyncType.UNKNOWN_SYNC_TYPE) ) EFTA00504293 Response: About(root_id=0ABNN8iEiWGvgUk9EVA, email address quota bytes_total=107374182400, quota_bytes used aggregate=17308943195, quota—bytes used_in_trash=413710768, quota iype=IIMITED) 2016-07-26 09:03:50,264 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive_api.doc id_provider.Store'>' 2016-07-26 09:03:50,264 -0400 INFO pid=19182 123145319829504: LaunchSyncApp user.pyo:68 Initializing User instance with new credentials. 2016-07-26 09:03:50,264 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp sync_app.pyo:1368 Configuring sync app from feature switches. 2016-07-26 09:03:50,264 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp features.pyo:112 Loads feature switches. 2016-07-26 09:03:50,264 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp feature_switch manager.pyo:674 Calling server to get feature switches. 2016-07-26 09:03:50,265 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp drive request.pyo:297 Drive request: ListFiatureSwitches(tags=Reason.SYNC_OTHER(SyncType.UNKNOWN_SYNC_TYPE)) - Read request - 2016-07-26 09:03:50,267 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp discovery.pyo:762 UAL being requested: GET https://www.googleapis.com/drive/v2internal/settings? fields=items%2Fkey%2Citems%2FValue&reason=304&namespace=FEATURE_SWITCHfialt=json 2016-07-26 09:03:50,267 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp http.pyo:257 Request user-agent: googledrivesync-1.30.2170.0459 google-api-python-client/1.3.1 (gzip) (Darwin/10.11.5) 2016-07-26 09:03:50,325 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp http.pyo:276 Response: 1734 bytes - application/json; charset=UTF-8 (encoding:gzip) 2016-07-26 09:03:50,326 -0400 INFO pid=19182 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'5', u'crash_throttle_percentage': u'0 1, u'download_in_place': u'true', u'enable_arbitrary_sync': u'false', u'enable_change_filters': u'true', u'enable_disk_check_on_preferences': u'true', u'enable_disk_check_on_setup': u'true', u'enable_feedback': u'true', u'enable_impressions_library': u'true', u'enable_local_v2 1: u'false', u'enable_multipause': u'true', u'enable_multiple_accounts': u'false', u'enable_push': u'true', u'enable_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'4000', 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-07-26 09:03:50,327 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp sync_app.pyo:1389 Feature Switches: FeatureSwitchSettings( accept_blob_download_gzip_encoding=True, backup_polling_interval_secs=7200, change_filters=('DRIVE_SYNC1], EFTA00504294 cloud_graph_disk_generation=5, crash_log_size_limit=10000000, crash_throttle_percentage=0.0, disabled_cloud_graph_disk_app_versions=[], docs_list_page_size=1000, download in_place=True, download_strategy=turl_template', download_ur1= 1 https://googledrive.com/p/host/(doc_id)', enable_arbitrary_sync=False, enable_batch_upload=True, enable_change_filters=True, enable_context_menu=True, enable_dapper_trace=False, enable_disk_check_on_preferences=True, enable_disk_check_on_setup=True, enable_feedback=True, enable_file_sync_status=True, enable_local_v2=False, enable_multipause=True, enable_multiple_accounts=False, enable_native_opener=True, enable_no_default_folder=False, enable_push=True, enable_recursive_si ze=True, enable_shared_move_confirmation=True, enable_sync_options_in_setup_flow=True, enable_usb_detection=False, feedback_type='prod', ghost_all_files=False, help_ur1=1 https://support.google.com/drive/?h1=%ssp=desktop_homel, impressions_heartbeat_interval_secs=10800, impressions_upload_interval_secs=1800, log_backup_count=0, log_size_mb=256, logging_level='info', max_batch_upload_files=30, max_page_size_changes=1000, max_page_size_cloud_graph=4000, max_page_size_cloud_graph_fallback=1000, max_page_size_selective_sync=4000, max_page_size_selective_sync_fallback=1000, new document ur1='https://docs.google.com/document?usp=drive_sync', new_presentation_ur1= 1https://docs.google.com/presentation?usp=drive_synct, new_spreadsheet_ur1=Ihttps://docs.google.com/spreadsheets?usp=drive_sync', numworkers=3, open_ur1='https://docs.google.com/open?id=fdoc_id)', overlays_enabled_finder_versions=[.10.71, '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='https://drive.google.com/sharing/share? subapp=10&shareProtocolVersion=2&theme=2&command=settings&shareUiType=default&authuser=0&clie nt=desktop', show_confirmation_dialog_on_delete=True, telemetry_enabled=True, telemetry_upload_interval_secs=1800, telemetry_ur1='https://drive.google.com/syncclient_impressions', token_bucket_read_qps=10, token_bucketwrite_qps=3, use_drive_api=True, user_confirmation_delay=2.0,) EFTA00504295 2016-07-26 09:03:50,328 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp logging_config.pyo:257 OS: Darwin/10.11.5 2016-07-26 09:03:50,328 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp logging_config.pyo:260 Google Drive (build 1.30.2170.0459) 2016-07-26 09:03:50,329 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp logging_config.pyo:261 SSL: OpenSSL 0.9.8zh 14 Jan 2016 2016-07-26 09:03:50,329 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp sync_app.pyo:1398 Config: Email: Sync root: /Users/lgroff/Google Drive Sync collections: set((]) Upgrade number: 24 App version: 1.30.2170.0459 Selective sync: False Cloud Graph generation: 5 Folder sync: (] Local app whitelist: set([]) Local app blacklist: set([]) Bandwidth RX Rate kpBs: 0 Bandwidth TX Rate kpBs: 0 Yosemite icons upgraded: True Win10 icons upgraded: False USB sync enabled: True Do sync default folder: True 2016-07-26 09:03:50,331 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp telemetry.pyo:228 SetPushClientVersion: 1 (3, 20130807) 2016-07-26 09:03:50,331 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.push.telemetry.PushTelemetry'> 1 2016-07-26 09:03:50,331 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.telemetry.impression_logger_manager.ImpressionLoggerManager'>' 2016-07-26 09:03:50,398 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'platforms.volumes.Volumelnfo'>' 2016-07-26 09:03:50,399 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp volumes.pyo:72 Refreshing volume information table. 2016-07-26 09:03:52,664 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp volumes.pyo:116 Volume information refresh complete in 2.26542s. 2016-07-26 09:03:52,665 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.managers.LockManager'>' 2016-07-26 09:03:52,665 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.downloads.DownloadCreate 2016-07-26 09:03:52,665 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.downloads.DownloadModify 2016-07-26 09:03:52,665 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator rules.uploads.UploadCreate 2016-07-26 09:03:52,666 -0400 INFO pid=19182 rule_factory.pyo:159 Registering aggregation common.aggregator rules.uploads.UploadDelete 2016-07-26 09:03:52,666 -0400 INFO pid=19182 rule_factory.pyo:159 Registering aggregation common.aggregator rules.uploads.UploadModify 2016-07-26 09:03:52,666 -0400 INFO pid=19182 rule_factory.pyo:159 Registering aggregation common.aggregator rules.uploads.UploadMove 2016-07-26 09:03:52,666 -0400 INFO pid=19182 123145319829504: rule_factory.pyo:159 Registering aggregation rule type: common.aggregator rules.uploads.UploadMoveFrom 2016-07-26 09:03:52,666 -0400 INFO pid=19182 123145319829504: rule_factory.pyo:159 Registering aggregation rule type: common.aggregator rules.uploads.UploadMoveTo 2016-07-26 09:03:52,668 -0400 INFO pid=19182 123145319829504: Creating singleton service instance of '<class 'common.roots. 123145319829504:_LaunchSyncApp rule type: 123145319829504:_LaunchSyncApp rule type: 123145319829504:_LaunchSyncApp rule type: _LaunchSyncApp _LaunchSyncApp _LaunchSyncApp service.pyo:132 root_wrangler.RootWrangler'>1 EFTA00504296 2016-07-26 09:03:52,668 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.machine_folder.Manager'>. 2016-07-26 09:03:52,668 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.secure_user_storage.Manager'>. 2016-07-26 09:03:52,789 -0400 INFO pid=19182 123145328242688:FilewatcherMonitor filewatcher.pyo:71 filewatcher_ext initialized 2016-07-26 09:03:52,790 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp docs_client_factory.pyo:86 Creating a new DriveClient 2016-07-26 09:03:52,790 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp docs_client_factory.pyo:86 Creating a new DriveClient 2016-07-26 09:03:52,791 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp docs_client_factory.pyo:86 Creating a new DriveClient 2016-07-26 09:03:52,791 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp docs_client_factory.pyo:86 Creating a new DriveClient 2016-07-26 09:03:52,791 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp docs_client_factory.pyo:86 Creating a new DriveClient 2016-07-26 09:03:52,791 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp docs_client_factory.pyo:86 Creating a new DriveClient 2016-07-26 09:03:52,791 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp docs_client_factory.pyo:86 Creating a new DriveClient 2016-07-26 09:03:52,793 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp xmpplib_notifier.pyo:34 Configure storage: <common.push.tango.storage.SyncConfigStorage; proxy of <Swig Object of type 'invalidation::Storage *' at 0x1124d90c0> > 2016-07-26 09:03:52,793 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp xmpplib_notifier.pyo:59 Creating client thread 2016-07-26 09:03:52,793 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp push_xmpp_client.pyo:223 Using talk server: talk.google.com:5222 2016-07-26 09:03:52,793 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp xmpplib_notifier.pyo:68 Creating notification bridge 2016-07-26 09:03:52,795 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp docs_client_factory.pyo:86 Creating a new DriveClient 2016-07-26 09:03:52,798 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp image_resources.py:304 Loading custom image images/folder-mac-yosemite.icns with function _CreateNSImage 2016-07-26 09:03:52,799 -0400 INFO pid=19182 123145332449280:Worker-2 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-07-26 09:03:52,800 -0400 INFO pid=19182 123145336655872:FeatureSwitchPoller sync_client_thread.pyo:178 FeatureSwitchPoller run loop has started. 2016-07-26 09:03:52,800 -0400 INFO pid=19182 123145340862464:LocalWatcher watcher.pyo:342 LocalWatcher Run invoked.Waiting for first pass of local scan from poller to start 2016-07-26 09:03:52,800 -0400 INFO pid=19182 123145336655872:FeatureSwitchPoller feature_switch_manager.pyo:674 Calling server to get feature switches. 2016-07-26 09:03:52,801 -0400 INFO pid=19182 123145345069056:RawEventUpgrader sync_client_thread.pyo:178 RawEventUpgrader run loop has started. 2016-07-26 09:03:52,801 -0400 INFO pid=19182 123145349275648:PauseTelemetryThread sync_client_thread.pyo:178 PauseTelemetryThread run loop has started. 2016-07-26 09:03:52,802 -0400 INFO pid=19182 123145336655872:FeatureSwitchPoller drive_resource.pyo:167 Initialize apiclient Drive resource for 2016-07-26 09:03:52,802 -0400 INFO pid=19182 123145332449280:Worker-2 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-07-26 09:03:52,802 -0400 INFO pid=19182 123145353482240:LocalDiskSpaceChecker sync_client_thread.pyo:178 LocalDiskSpaceChecker run loop has started. 2016-07-26 09:03:52,802 -0400 INFO pid=19182 123145357688832:PushNotificationKeepaliveThread sync_client_thread.pyo:178 PushNotificationKeepaliveThread run loop has started. 2016-07-26 09:03:52,803 -0400 INFO pid=19182 123145366102016:TelemetryStoreSizeMonitorThread sync_client_thread.pyo:178 TelemetryStoreSizeMonitorThread run loop has started. 2016-07-26 09:03:52,803 -0400 INFO pid=19182 123145336655872:FeatureSwitchPoller drive_resource.pyo:228 Drive SDK baseUrl = https://www.googleapis.com/drive/v2internal/ 2016-07-26 09:03:52,804 -0400 INFO pid=19182 123145370308608:OverlayStatusCleaner sync_client_thread.pyo:178 OverlayStatusCleaner run loop has started. 2016-07-26 09:03:52,804 -0400 INFO pid=19182 123145374515200:Batcher sqlite.pyo:276 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/snapshot.db EFTA00504297 2016-07-26 09:03:52,804 -0400 INFO pid=19182 123145382928384:ConfirmationHandler sync_client_thread.pyo:178 ConfirmationHandler run loop has started. 2016-07-26 09:03:52,805 -0400 INFO pid=19182 123145357688832:PushNotificationKeepaliveThread push_notification_keepalive_thread.pyo:49 Sent push keepalive message at: Tue Jul 26 09:03:52 2016 2016-07-26 09:03:52,805 -0400 INFO pid=19182 123145387134976:LocalFSPoller sync_client_thread.pyo:178 LocalFSPoller run loop has started. 2016-07-26 09:03:52,805 -0400 INFO pid=19182 123145366102016:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2016-07-26 09:03:52,806 -0400 INFO pid=19182 123145332449280:Worker-2 threads.pyo:130 AddCleanupcallback persistence_sqlite:eda034bbda9741c0a33093ed97bd42e9/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-07-26 09:03:52,806 -0400 INFO pid=19182 123145391341568:PushTelemetryThread sync_client_thread.pyo:178 PushTelemetryThread run loop has started. 2016-07-26 09:03:52,806 -0400 INFO pid=19182 123145395548160:Worker-0 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-07-26 09:03:52,807 -0400 INFO pid=19182 123145399754752:CloudWatcher sqlite.pyo:276 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-07-26 09:03:52,808 -0400 INFO pid=19182 123145408167936:RootWrangler root_wrangler.pyo: 124 RootWrangler.RootObserverRegistered with roots (_MyDriveRoot(u'/Users/lgroff/Google Drive', LocalID(inode=435288), 'root', <RootState.INITED: 2>)] 2016-07-26 09:03:52,808 -0400 INFO pid=19182 123145336655872:FeatureSwitchPoller drive_request.pyo:297 Drive request: ListFeatureSwitches(tags=Reason.SYNC_OTHER(SyncType.UNKNOWN_SYNC_TYPE)) - Read request - 2016-07-26 09:03:52,809 -0400 INFO pid=19182 123145332449280:Worker-2 threads.pyo:130 AddCleanupCallback persistence_sqlite:9b3a89536bbf409fac9db4acea49e029/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-07-26 09:03:52,809 -0400 INFO pid=19182 123145420787712:SyncClientImpressionsThread sync_client_thread.pyo:178 SyncClientImpressionsThread run loop has started. 2016-07-26 09:03:52,809 -0400 INFO pid=19182 123145374515200:Batcher sqlite.pyo:276 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-07-26 09:03:52,810 -0400 INFO pid=19182 123145424994304:CrashReportUploaderThread crash_report_uploader_thread.pyo:60 Starting CrashReportUploaderThread. 2016-07-26 09:03:52,810 -0400 INFO pid=19182 123145412374528:Worker-1 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-07-26 09:03:52,810 -0400 INFO pid=19182 123145429200896:XmppClient telemetry.pyo:153 Push state None => PushStates.CONNECTING 2016-07-26 09:03:52,810 -0400 INFO pid=19182 123145408167936:RootWrangler root_wrangler.pyo: 132 RootWrangler.RootsAdded with roots ]_MyDriveRoot(u'/Users/lgroff/Google Drive', LocalID(inode=435288), 'root', <RootState.INITED: 2>)] 2016-07-26 09:03:52,810 -0400 INFO pid=19182 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-07-26 09:03:52,812 -0400 INFO pid=19182 123145336655872:FeatureSwitchPoller discovery.pyo:762 UAL being requested: GET https://www.googleapis.com/drive/v2internal/settings? fields=items%2Fkey%2Citems%2FValue&reason=304finamespace=FEATURE_SWITCH&alt=json 2016-07-26 09:03:52,812 -0400 INFO pid=19182 123145395548160:Worker-0 sqlite.pyo:276 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-07-26 09:03:52,814 -0400 INFO pid=19182 123145332449280:Worker-2 command_factory.pyo:175 Registered worker command types: common.worker.downloads.DownloadChangeACL for Direction. DOWNLOAD Action.CHANGE_ACL common.worker.downloads.DownloadCreate for Direction.DOWNLOAD Action.CREATE common.worker.downloads.DownloadDelete for Direction.DOWNLOAD Action.DELETE common.worker.downloads.DownloadModify for Direction.DOWNLOAD Action.MODIFY common.worker.downloads.DownloadMove for Direction.DOWNLOAD Action.MOVE EFTA00504298 common.worker.downloads.DownloadRename for Direction.DOWNLOAD Action.RENAME common.worker.internals.InternalCreate for Direction.INTERNAL Action.CREATE common.worker.internals.InternalModify for Direction.INTERNAL Action.MODIFY common.worker.undo.UndoCloudDelete for Direction. DOWNLOAD Action. DELETE undo common.worker.undo.UndoLocalDelete for Direction.UPLOAD Action. DELETE undo common.worker.undo.UndoLocalMove for Direction.UPLOAD Action.MOVE undo common.worker.uploads.BatchUploadCreate for Direction.UPLOAD Action.CREATE is_batch common.worker.uploads.UploadCreate for Direction.UPLOAD Action.CREATE common.worker.uploads.UploadDelete for Direction.UPLOAD Action.DELETE common.worker.uploads.UploadModify for Direction.UPLOAD Action.MODIFY common.worker.uploads.UploadMove for Direction.UPLOAD Action.MOVE common.worker.uploads.UploadRename for Direction.UPLOAD Action.RENAME 2016-07-26 09:03:52,814 -0400 INFO pid=19182 123145399754752:CloudWatcher sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-07-26 09:03:52,814 -0400 INFO pid=19182 123145374515200:Batcher threads.pyo:130 AddCleanupCallback persistence_sqlite:0375ee8913c34c9ca9e70bbbedfd6dde/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-07-26 09:03:52,815 -0400 INFO pid=19182 123145429200896:XmppClient connection_task.pyo:151 Recalculated LoginTask timeout: 16.000000 2016-07-26 09:03:52,815 -0400 INFO pid=19182 123145408167936:RootWrangler sync_client_thread.pyo:178 RootWrangler run loop has started. 2016-07-26 09:03:52,815 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp doc_id_provider.pyo:235 Waking up fetcher thread 'DocIdsFetcherThread- to get more doc IDs. Currently running. 2016-07-26 09:03:52,816 -0400 INFO pid=19182 123145336655872:FeatureSwitchPoller client.pyo:515 Attempting refresh to obtain initial access_token 2016-07-26 09:03:52,816 -0400 INFO pid=19182 123145332449280:Worker-2 workers.pyo:127 Waiting for batcher to initialize 2016-07-26 09:03:52,816 -0400 INFO pid=19182 123145412374528:Worker-1 sqlite.pyo:276 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-07-26 09:03:52,817 -0400 INFO pid=19182 123145374515200:Batcher threads.pyo:130 AddCleanupCallback persistence_sqlite:047eba964beb48e296cfdd3d1c61177b/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-07-26 09:03:52,817 -0400 INFO pid=19182 123145429200896:XmppClient telemetry.pyo:167 PushStates.CONNECTING: +0.00696244 => 0.00696244 2016-07-26 09:03:52,817 -0400 INFO pid=19182 123145408167936:RootWrangler root_wrangler.pyo: 111 RootWrangler got inited root _MyDriveRoot(u'/Users/lgroff/Google Drive', LocalID(inode=435288), 'root', <RootState.INITED: 2>) 2016-07-26 09:03:52,818 -0400 INFO pid=19182 123145336655872:FeatureSwitchPoller client.pyo:735 Updated access_token read from Storage 2016-07-26 09:03:52,818 -0400 INFO pid=19182 123145319829504:_LaunchSyncApp drive_extension_installer.pyo:175 Uninstalling extension nknebiagdodnminbdpflhpkgfpeijdbf 2016-07-26 09:03:52,818 -0400 INFO pid=19182 123145395548160:Worker-0 threads.pyo:130 AddCleanupCallback persistence_sqlite:8dee5e1447824da596aa0003f0lffb75/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-07-26 09:03:52,818 -0400 INFO pid=19182 123145399754752:CloudWatcher threads.pyo:130 AddCleanupCallback persistence_sqlite:54b7e6be431e4ff595103a11797a9532/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-07-26 09:03:52,819 -0400 INFO pid=19182 123145332449280:Worker-2 sync_client_thread.pyo:178 Worker-2 run loop has started. 2016-07-26 09:03:52,819 -0400 INFO pid=19182 123145429200896:XmppClient xmpplib.pyo:80 Connecting to talk.google.com: 5222 2016-07-26 09:03:52,819 -0400 INFO pid=19182 123145412374528:Worker-1 threads.pyo:130 AddCleanupCallback persistence_sqlite:d77305ee555a4lfb9ae6d1bflb9921b3/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2016-07-26 09:03:52,819 -0400 INFO pid=19182 123145336655872:FeatureSwitchPoller http.pyo:257 Request user-agent: googledrivesync-1.30.2170.0459 google-api-python-client/1.3.1 (gzip) EFTA00504299 (Darwin/10.11.5) 2016-07-26 09:03:52,819 -0400 INFO pid=19182 123145395548160:Worker-0 threads.pyo:130 Addeleanupeallback persistence_scilite:b12fcl7f57584db18c92aef28b3346fa/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-07-26 09:03:52,820 -0400 INFO pid=19182 123145399754752:CloudWatcher threads.pyo:130 AddCleanupCallback persistence_sglite:4f6962189dea40629839cb9e39f0d290/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-07-26 09:03:52,821 -0400 INFO pid=19182 123145412374528:Worker-1 threads.pyo:130 Addeleanupeallback persistence_sglite:b3890534d6be4dbaaalcb0b65c347765/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2016-07-26 09:03:52,821 -0400 ERROR pid=19182 123145319829504:_LaunchSyncApp chrome_utils.pyo:79 Deleting file /Users/lgroff/Library/Application Support/Google/Chrome/External Extensions/nknebiagdodnminbdpflhpkgfpeijdbf.json failed because: [Errno 2] No such file or directory: '/Users/lgroff/Library/Application Support/Google/Chrome/External Extensions/nknebiagdodnminbdpflhpkgfpeijdbf.json' 2016-07-26 09:03:52,821 -0400 INFO pid=19182 123145336655872:FeatureSwitchPoller sync_http_client.pyo:238 Opening direct connection to www.googleapis.com:443. 2016-07-26 09:03:52,821 -0400 INFO pid=19182 123145395548160:Worker-0 workers.pyo:127 Waiting for batcher to initialize 2016-07-26 09:03:52,822 -0400 INFO pid=19182 123145399754752:CloudWatcher cloud_graph.pyo:162 Initialize persistent graph with generation 5 2016-07-26 09:03:52,822 -0400 INFO pid=19182 123145412374528:Worker-1 workers.pyo:127 Waiting for batcher to initialize 2016-07-26 09:03:52,823 -0400 INFO pid=19182 123145395548160:Worker-0 sync_client_thread.pyo:178 Worker-0 run loop has started. 2016-07-26 09:03:52,823 -0400 INFO pid=19182 123145399754752:CloudWatcher cloud_graph.pyo:1374 Current sync config generation: 5 2016-07-26 09:03:52,823 -0400 INFO pid=19182 123145412374528:Worker-1 sync_client_thread.pyo:178 Worker-1 run loop has started. 2016-07-26 09:03:52,823 -0400 ERROR pid=19182 123145319829504:_LaunchSyncApp fatal_exceptions.pyo:55 Ignoring non-fatal error: OSError: [Errno 2] No such file or directory: '/Users/lgroff/Library/Application Support/Google/Chrome', Traceback: File "common/exception_utils.pyo", line 72, in SuppressExceptions File ucommon/sync_app.pyou, line 1528, in _PostSetup File ucommon/drive_extension_installer.pyo", line 142, in InstallExtension File ucommon/drive_extension_installer.pyo", line 106, in CheckExtensionlnstalled File "osx/fileutils.pyo", line 157, in ListDir EFTA00504300