EFTA00503159.pdf

From: File "Nolumes/BuildData/pulse- datathgents/wpyt4.hot/recipes/670045187/base/b/drb/googleclient/apps/webdrive_syndosx/dist/Googl e Drive.app/Contents/Resources/_boot_.py", line 43, in <module> File "Nolumes/BuildData/pulse- datathgents/wpyt4.hot/recipes/670045187/base/b/drb/googleclientJapps/webdrive_sync/osx/dist/Googl e Drive.app/Contents/Resources/_boot_.py", line 38, in _run File "/Applications/Google Drive.app/Contents/Resources/main.py", line 12, in <module> File "osx/run_googledrive.pyo", line 31, in Main File "PyObjCTools/AppHelper.pyo", line 235, in runEventLoop File "osx/GSyncAppDelegate.pyo", line 315, in applicationWillTerminate_ File "osx/mac_sync_app_controller.pyo", line 302, in Exit File "common/ui_action_handler.pyo", line 457, in Quit File "common/sync_app.pyo", line 1487, in Quit 2015-04-23 16:35:06,039 -0400 INFO pid=2518 -1603214936:MainThread thread manager.pyo:77 Stop was called 2015-04-23 16:35:06,040 -0400 INFO pid=2518 -1311092736:FeatureSwitchPoller sync_client_thread.pyo:203 FeatureSwitchPoller run loop has terminated. 2015-04-23 16:35:06,101 -0400 INFO pid=2518 -1311092736:FeatureSwitchPoller utils.pyo:640 Execute cleanup callback 'persistence_sqlite:baaebe7b23774f7caf8bf2e72bd68e44/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2015-04-23 16:35:06,122 -0400 INFO pid=2518 -1311092736:FeatureSwitchPoller sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:35:06,159 -0400 INFO pid=2518 -1302687744:Batcher sync_client_thread.pyo:255 Batcher run loop has terminated. 2015-04-23 16:35:06,159 -0400 INFO pid=2518 -1306890240:TelemetryStoreSizeMonitorThread sync_client_thread.pyo:203 TelemetryStoreSizeMonitorThread run loop has terminated. 2015-04-23 16:35:06,160 -0400 INFO pid=2518 -1290080256:PushNotificationKeepaliveThread sync_client_thread.pyo:203 PushNotificationKeepaliveThread run loop has terminated. 2015-04-23 16:35:06,160 -0400 INFO pid=2518 -1264865280:OverlayStatusCleaner sync_client_thread.pyo:203 OverlayStatusCleaner run loop has terminated. 2015-04-23 16:35:06,160 -0400 INFO pid=2518 -1294282752:RawEventUpgrader sync_client_thread.pyo:203 RawEventUpgrader run loop has terminated. 2015-04-23 16:35:06,160 -0400 INFO pid=2518 -1302687744:Batcher sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:35:06,161 -0400 INFO pid=2518 -1285877760:Worker-1 sync_client_thread.pyo:203 Worker-1 run loop has terminated. 2015-04-23 16:35:06,162 -0400 INFO pid=2518 -1277472768:LocalDiskSpaceChecker sync_client_thread.pyo:203 LocalDiskSpaceChecker run loop has terminated. 2015-04-23 16:35:06,162 -0400 WARNING pid=2518 -1603214936:MainThread task.pyo:245 DriveXmppTask-0xb6faa08 aborting: abort 2015-04-23 16:35:06,162 -0400 INFO pid=2518 -1273270272:CloudWatcher cloud_watcher.pyo:637 Stop detected 2015-04-23 16:35:06,163 -0400 INFO pid=2518 -1285877760:Worker-1 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:35:06,164 -0400 INFO pid=2518 -1603214936:MainThread task.pyo:257 Task <common.push.push_xmpp_client.DriveXmppTask instance at 0xb6faa08> complete. 2015-04-23 16:35:06,164 -0400 WARNING pid=2518 -1273270272:CloudWatcher cloud_watcher.pyo:682 Exiting CloudWatcher.PushRunLoop() 2015-04-23 16:35:06,164 -0400 INFO pid=2518 -1603214936:MainThread xmpplib.pyo:114 Close called with 'why' reason = Client initiated close 2015-04-23 16:35:06,165 -0400 INFO pid=2518 -1273270272:CloudWatcher sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:35:06,193 -0400 INFO pid=2518 -1311092736:FeatureSwitchPoller utils.pyo:640 Execute cleanup callback 'persistence_sqlite:6532e70785f54071b3209f151dc13654/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-04-23 16:35:06,194 -0400 INFO pid=2518 -1311092736:FeatureSwitchPoller sqlite.pyo:379 EFTA00503159 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:35:06,196 -0400 INFO pid=2518 -1302687744:Batcher utils.pyo:640 Execute cleanup callback 'persistence_sqlite:cb0e26ea706c4beab3896dfd2d748c0b/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2015-04-23 16:35:06,196 -0400 INFO pid=2518 -1285877760:Worker-1 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:35:06,197 -0400 INFO pid=2518 -1302687744:Batcher sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:35:06,197 -0400 INFO pid=2518 -1273270272:CloudWatcher sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:35:06,198 -0400 INFO pid=2518 -1285877760:Worker-1 utils.pyo:640 Execute cleanup callback 'persistence_sqlite:a3acb29cf7f647d8ac91973a9253d75a/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2015-04-23 16:35:06,203 -0400 INFO pid=2518 -1302687744:Batcher utils.pyo:640 Execute cleanup callback 'persistence_sqlite:f440ae895b9a493a82bbce5bldde8566/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-04-23 16:35:06,203 -0400 INFO pid=2518 -1285877760:Worker-1 utils.pyo:640 Execute cleanup callback 'persistence_sqlite:bb7bad1932c341349876f5e3e49cd636/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-04-23 16:35:06,204 -0400 INFO pid=2518 -1273270272:CloudWatcher utils.pyo:640 Execute cleanup callback 'persistence_sqlite:7551a79708b34951b845ceabac2d0Odf/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-04-23 16:35:06,204 -0400 INFO pid=2518 -1273270272:CloudWatcher utils.pyo:640 Execute cleanup callback 'persistence_sqlite:397045cfbc114dd5a9c576c6b2190a8b/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2015-04-23 16:35:06,204 -0400 INFO pid=2518 -1273270272:CloudWatcher utils.pyo:640 Execute cleanup callback 'DBConnectionManagerCleanupCallback' 2015-04-23 16:35:06,205 -0400 INFO pid=2518 -1273270272:CloudWatcher db_connection.pyo:441 Closing ManagedConnection(id=B5EF870, thread=CloudWatcher--48E49000, path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/cloud_graph/dict_2.db, closed=False) 2015-04-23 16:35:06,869 -0400 INFO pid=2518 -1603214936:MainThread task.pyo:257 Task <common.push.push_xmpp_client.DriveXmppTask instance at 0xb6faa08> complete. 2015-04-23 16:35:06,869 -0400 INFO pid=2518 -1603214936:MainThread xmpplib.pyo:114 Close called with 'why' reason = Client initiated close 2015-04-23 16:35:07,764 -0400 INFO pid=2518 -1298485248:XmppClient push_xmpp_client.pyo:137 Exiting run loop 2015-04-23 16:35:07,765 -0400 INFO pid=2518 -1315295232:FinderInjector sync_client_thread.pyo:203 Finderlnjector run loop has terminated. 2015-04-23 16:35:07,815 -0400 INFO pid=2518 -1243852800:LocalFSPoller sync_client_thread.pyo:203 LocalFSPoller run loop has terminated. 2015-04-23 16:35:07,815 -0400 INFO pid=2518 -1252257792:Worker-2 sync_client_thread.pyo:203 Worker-2 run loop has terminated. 2015-04-23 16:35:07,816 -0400 INFO pid=2518 -1323700224:ThreadMonitor thread_manager.pyo:262 Waking up. 2015-04-23 16:35:07,816 -0400 INFO pid=2518 -1252257792:Worker-2 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:35:07,816 -0400 INFO pid=2518 -1239650304:Worker-0 sync_client_thread.pyo:203 Worker-0 run loop has terminated. 2015-04-23 16:35:07,817 -0400 INFO pid=2518 -1235447808:TelemetryUploaderThread sync_client_thread.pyo:203 TelemetryUploaderThread run loop has terminated. 2015-04-23 16:35:07,817 -0400 INFO pid=2518 -1239650304:Worker-0 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db EFTA00503160 2015-04-23 16:35:07,819 -0400 INFO pid=2518 -1252257792:Worker-2 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:35:07,819 -0400 INFO pid=2518 -1239650304:Worker-0 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:35:07,820 -0400 INFO pid=2518 -1252257792:Worker-2 utils.pyo:640 Execute cleanup callback 'persistence_sqlite:b95b0a69087e4feeae96c6242d9a5786/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-04-23 16:35:08,266 -0400 INFO pid=2518 -1252257792:Worker-2 utils.pyo:640 Execute cleanup callback 'persistence_sqlite:a9a6c4c20bdd4c14a70f2de9c5b9e2a2/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2015-04-23 16:35:08,266 -0400 INFO pid=2518 -1239650304:Worker-0 utils.pyo:640 Execute cleanup callback 'persistence_sqlite:7d56elba0d56437da9fe49341fa78f04/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2015-04-23 16:35:08,267 -0400 INFO pid=2518 -1239650304:Worker-0 utils.pyo:640 Execute cleanup callback 'persistence_sqlite:87fa39aa9d06447cbldefb1449eb9816/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-04-23 16:39:55,347 -0400 INFO pid=293 -1587232344:MainThread logging_config.pyo:249 OS: Darwin/10.9.5 2015-04-23 16:39:55,373 -0400 INFO pid=293 -1587232344:MainThread logging_config.pyo:252 Google Drive (build 1.20.8672.3137) 2015-04-23 16:39:55,373 -0400 INFO pid=293 -1587232344:MainThread logging_config.pyo:253 SSL: OpenSSL 0.9.8zd 8 Jan 2015 2015-04-23 16:39:55,505 -0400 INFO pid=293 -1587232344:MainThread GSyncAppDelegate.pyo:216 Application did finish launching. 2015-04-23 16:39:57,779 -0400 INFO pid=293 -1336307712:Thread-1 service.pyo:71 Creating user scope service instance of '<class 'common.service.user.User'>' 2015-04-23 16:39:57,780 -0400 INFO pid=293 -1336307712:Thread-1 service.pyo:71 Creating user scope service instance of '<class 'common.local.roots.RootManager'>' 2015-04-23 16:39:57,780 -0400 INFO pid=293 -1336307712:Thread-1 service.pyo:71 Creating user scope service instance of '<class 'common.pause_manager.Service'>. 2015-04-23 16:39:57,780 -0400 INFO pid=293 -1336307712:Thread-1 sync_app.pyo:301 Getting TokenStorage... 2015-04-23 16:39:57,780 -0400 INFO pid=293 -1336307712:Thread-1 sync_app.pyo:303 Got token storage: <token_storage.TokenStorage object at 0x7fe0360> 2015-04-23 16:39:57,815 -0400 INFO pid=293 -1336307712:Thread-1 service.pyo:71 Creating user scope service instance of '<class 'common.features.AppFeatures'>' 2015-04-23 16:39:57,816 -0400 INFO pid=293 -1336307712:Thread-1 service.pyo:71 Creating user scope service instance of '<class 'common.cert.Manager'>' 2015-04-23 16:39:57,816 -0400 INFO pid=293 -1336307712:Thread-1 service.pyo:156 Creating singleton service instance of '<class 'common.sync_http_client.BandwidthThrottler'> 1 2015-04-23 16:39:57,843 -0400 INFO pid=293 -1336307712:Thread-1 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:39:57,865 -0400 INFO pid=293 -1336307712:Thread-1 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:39:57,866 -0400 INFO pid=293 -1336307712:Thread-1 utils.pyo:663 ADDING persistence_sqlite:13371b77002e434da5bcelf8d219b35f/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:39:57,866 -0400 INFO pid=293 -1336307712:Thread-1 utils.pyo:663 ADDING persistence_sqlite:9375ebd0aae44197903a29453cb3e098/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:39:58,068 -0400 INFO pid=293 -1336307712:Thread-1 sync_app.pyo:477 BandwidthThrottler configured via sync_config 2015-04-23 16:39:58,068 -0400 INFO pid=293 -1336307712:Thread-1 sync_http_client.pyo:91 BandwidthThrottler.SetRxBytesPerSecond 0 2015-04-23 16:39:58,068 -0400 INFO pid=293 -1336307712:Thread-1 sync_http_client.pyo:100 BandwidthThrottler.SetTxBytesPerSecond 0 2015-04-23 16:39:58,068 -0400 INFO pid=293 -1336307712:Thread-1 sqlite.pyo:379 Close EFTA00503161 connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:39:58,079 -0400 INFO pid=293 -1336307712:Thread-1 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:39:58,110 -0400 INFO pid=293 -1336307712:Thread-1 utils.pyo:640 Execute cleanup callback 'persistence_sqlite:13371b77002e434da5bcelf8d219b35f/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-04-23 16:39:58,111 -0400 INFO pid=293 -1336307712:Thread-1 utils.pyo:640 Execute cleanup callback 'persistence_sqlite:9375ebd0aae44197903a29453cb3e098/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2015-04-23 16:39:58,304 -0400 INFO pid=293 -1332105216:Thread-2 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:39:58,347 -0400 INFO pid=293 -1332105216:Thread-2 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:39:58,348 -0400 INFO pid=293 -1332105216:Thread-2 utils.pyo:663 ADDING persistence_sqlite:5c940ccd7b5643408b636eeb67a3e6ec/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:39:58,348 -0400 INFO pid=293 -1332105216:Thread-2 utils.pyo:663 ADDING persistence_sqlite:e6a1f1f409f9415b94e1882432a4a636/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:39:58,349 -0400 INFO pid=293 -1332105216:Thread-2 feature_switch_manager.pyo:479 Successfully read persisted feature switches. 2015-04-23 16:39:59,318 -0400 INFO pid=293 -1587232344:MainThread image_resources.py:246 Loading image resources/images/ic_drawer_24.png 2015-04-23 16:39:59,447 -0400 INFO pid=293 -1587232344:MainThread image_resources.py:246 Loading image resources/images/menu_drive-logo.png 2015-04-23 16:39:59,457 -0400 INFO pid=293 -1587232344:MainThread image_resources.py:246 Loading image resources/images/menu_google-logo-gray.png 2015-04-23 16:39:59,477 -0400 INFO pid=293 -1587232344:MainThread image_resources.py:246 Loading image resources/images/ic_folder_mydrive_24.png 2015-04-23 16:39:59,481 -0400 INFO pid=293 -1587232344:MainThread image_resources.py:246 Loading image resources/images/ic_web_24.png 2015-04-23 16:39:59,496 -0400 INFO pid=293 -1587232344:MainThread image_resources.py:246 Loading image resources/images/menu_backups.png 2015-04-23 16:39:59,499 -0400 INFO pid=293 -1587232344:MainThread image_resources.py:246 Loading image resources/images/ic_sync_problem_24.png 2015-04-23 16:39:59,803 -0400 INFO pid=293 -1587232344:MainThread image_resources.py:246 Loading image resources/images/ic_done_24.png 2015-04-23 16:40:00,195 -0400 INFO pid=293 -1587232344:MainThread service.pyo:209 Creating paramed singleton service instance of '<class 'common.file_lock.FileLock'>' 2015-04-23 16:40:00,196 -0400 INFO pid=293 -1587232344:MainThread service.pyo:209 Creating paramed singleton service instance of '<class 'common.file_lock.FileLock'>' 2015-04-23 16:40:00,869 -0400 INFO pid=293 -1323700224:ThreadMonitor thread_manager.pyo:259 Waiting on exit condition. Wake up after 3600s. 2015-04-23 16:40:00,870 -0400 INFO pid=293 -1319497728:_LaunchSyncApp sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:40:00,919 -0400 INFO pid=293 -1319497728:_LaunchSyncApp sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:40:00,920 -0400 INFO pid=293 -1319497728:_LaunchSyncApp utils.pyo:663 ADDING persistence_sqlite:9e61e6008cd84bf7b6albf509799d0f6/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:40:00,920 -0400 INFO pid=293 -1319497728:_LaunchSyncApp utils.pyo:663 ADDING persistence_sqlite:31ebc72daebl4f89bb6c41e2da893879/Users/lgroff/Library/Application Support/Google/Drive/user default/sync_config.db 2015-04-23 16:40:01,585 -0400 INFO pid=293 -1332105216:Thread-2 finder_injector.pyo:426 Local Google Drive path not yet available, skip loading overlays 2015-04-23 16:40:01,622 -0400 INFO pid=293 -1327902720:Finderlnjector sync_client_thread.pyo:177 Finderlnjector run loop has started. EFTA00503162 2015-04-23 16:40:01,623 -0400 INFO pid=293 -1319497728:_LaunchSyncApp user.pyo:64 Initializing User instance with new credentials. None 2015-04-23 16:40:01,623 -0400 INFO pid=293 -1319497728:_LaunchSyncApp docs_client_factory.pyo:99 Creating a new Wapi DocsClient 2015-04-23 16:40:01,653 -0400 INFO pid=293 -1319497728:_LaunchSyncApp service.pyo:71 Creating user scope service instance of '<class 'common.token_bucket.CloudBucketManager'>. 2015-04-23 16:40:01,765 -0400 INFO pid=293 -1332105216:Thread-2 utils.pyo:640 Execute cleanup callback 'persistence_sqlite:e6a1f1f409f9415b94e1882432a4a636/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2015-04-23 16:40:01,765 -0400 INFO pid=293 -1332105216:Thread-2 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:40:01,766 -0400 INFO pid=293 -1332105216:Thread-2 utils.pyo:640 Execute cleanup callback 'persistence_sqlite:5c940ccd7b5643408b636eeb67a3e6ec/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-04-23 16:40:01,766 -0400 INFO pid=293 -1332105216:Thread-2 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:40:11,677 -0400 INFO pid=293 -1319497728: LaunchSyncApp user.pyo:64 Initializing User instance with new credentials. 2015-04-23 16:40:11,747 -0400 INFO pid=293 -1319497728:_LaunchSyncApp features.pyo:109 Loads feature switches. 2015-04-23 16:40:11,747 -0400 INFO pid=293 -1319497728:_LaunchSyncApp features.pyo:138 Loading feature switches with server. 2015-04-23 16:40:11,747 -0400 INFO pid=293 -1319497728:_LaunchSyncApp feature_switch_manager.pyo:551 Calling server to get feature switches. 2015-04-23 16:40:11,748 -0400 INFO pid=293 -1319497728:_LaunchSyncApp feature_switch_manager.pyo:471 Successfully received feature switches from server. 2015-04-23 16:40:11,775 -0400 INFO pid=293 -1319497728:_LaunchSyncApp sync_app.pyo:1153 Feature Switches: FeatureSwitchSettings( accept_blob_download_gzip_encoding=True, auto_backup=False, backup_polling_interval_secs=7200, cloud_graph_disk_generation=2, crash_log_size_limit=10000000, crash_throttle_percentage=99.7, disabled_cloud_graph_disk_app_versions=)'1.8.4288.4175', '1.8.4340.2022', '1.10.4711.1662', '1.10.4657.9104', '1.10.4658.6881'), docs_list_page_size=1000, download_in_place=False, download_progress_bar=False, download_strategy=turl template', download_ur1= 1 doc_id)', enable_batch_upload=True, enable_context_menu=True, enable_dapper_trace=False, enable_disk_dict=False, enable_feedback=False, enable_file_sync_status=True, enable_multiple_accounts=False, enable_native_opener=True, enable_new_menu=True, enable_push=True, enable_snapshot_reconstruct=True, feedback_type='prod', ghost_all files=False, help_ur1=' desktop_home', log_backup_count=0, log_size_mb=256, logging_level='info', max_batch_upload_files=30, new_document_ur1=1 EFTA00503163 new_presentation_ur1= 1 new_spreadsheet_ur1= 1 num_workers=3, only_rooted items in cloud graph=False, open_ur1= 1 (doc_id)', overlays_enabled_finder_versions=(.10.6.8', '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_keepalive_interval=72000.0, regular_polling_interval_secs=30, selective_sub_folder sync=False, share_template_ur1= 1 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= 1 token_bucket_read_qps=10, token_bucket_write_qps=3,) 2015-04-23 16:40:11,801 -0400 INFO pid=293 -1319497728:_LaunchSyncApp logging_config.pyo:249 OS: Darwin/10.9.5 2015-04-23 16:40:11,833 -0400 INFO pid=293 -1319497728:_LaunchSyncApp logging_config.pyo:252 Google Drive (build 1.20.8672.3137) 2015-04-23 16:40:11,833 -0400 INFO pid=293 -1319497728:_LaunchSyncApp logging_config.pyo:253 SSL: OpenSSL 0.9.8zd 8 Jan 2015 2015-04-23 16:40:11,833 -0400 INFO pid=293 -1319497728:_LaunchSyncApp sync_app.pyo:1162 Config: Email: Sync root: /Users/lgroff/Google Drive Sync collections: set([)) Upgrade number: 20 App version: 1.20.8672.3137 Selective sync: False Cloud Graph generation: 2 Auto-Backup activated: False Folder sync: C) Local app whitelist: set(fl) Local app blacklist: set(fl) 2015-04-23 16:40:12,038 -0400 INFO pid=293 -1319497728:_LaunchSyncApp service.pyo:111 Creating user scope service subclass of '<class 'common.push.notifier.Notifier'>' 2015-04-23 16:40:12,038 -0400 INFO pid=293 -1319497728:_LaunchSyncApp service.pyo:113 Actual service created: <common.push.notifier.PushXMPPNotifier object at 0x8c9a950> 2015-04-23 16:40:12,193 -0400 INFO pid=293 -1587232344:MainThread service.pyo:71 Creating user scope service instance of '<class 'common.auto_backup.AutoBackup'>' 2015-04-23 16:40:12,194 -0400 INFO pid=293 -1587232344:MainThread sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:40:12,235 -0400 INFO pid=293 -1587232344:MainThread sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:40:12,236 -0400 INFO pid=293 -1587232344:MainThread sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:40:12,236 -0400 INFO pid=293 -1587232344:MainThread sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:40:12,236 -0400 INFO pid=293 -1587232344:MainThread service.pyo:71 Creating user scope service instance of '<class 'common.telemetry.telemetry_manager.TelemetryManager'>' 2015-04-23 16:40:17,239 -0400 INFO pid=293 -1319497728:_LaunchSyncApp image_resources.py:222 Loading custom image resources/images/folder-mac.icns with function _CreateNSlmage 2015-04-23 16:40:17,476 -0400 INFO pid=293 -1319497728:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.downloads.DownloadCreate 2015-04-23 16:40:17,477 -0400 INFO pid=293 -1319497728:_LaunchSyncApp rule_factory.pyo:159 EFTA00503164 Registering aggregation rule type: common.aggregator_rules.downloads.DownloadModify 2015-04-23 16:40:17,477 -0400 INFO pid=293 -1319497728:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadCreate 2015-04-23 16:40:17,477 -0400 INFO pid=293 -1319497728:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadDelete 2015-04-23 16:40:17,477 -0400 INFO pid=293 -1319497728:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadModify 2015-04-23 16:40:17,477 -0400 INFO pid=293 -1319497728:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadMove 2015-04-23 16:40:17,477 -0400 INFO pid=293 -1319497728:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadMoveFrom 2015-04-23 16:40:17,477 -0400 INFO pid=293 -1319497728:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadMoveTo 2015-04-23 16:40:17,478 -0400 INFO pid=293 -1335775232:FilewatcherMonitor filewatcher.pyo:68 filewatcher_ext initialized 2015-04-23 16:40:17,479 -0400 INFO pid=293 -1319497728:_LaunchSyncApp docs_client_factory.pyo:99 Creating a new Wapi DocsClient 2015-04-23 16:40:17,523 -0400 INFO pid=293 -1319497728:_LaunchSyncApp docs_client_factory.pyo:99 Creating a new Wapi DocsClient 2015-04-23 16:40:17,524 -0400 INFO pid=293 -1319497728:_LaunchSyncApp docs_client_factory.pyo:99 Creating a new Wapi DocsClient 2015-04-23 16:40:17,524 -0400 INFO pid=293 -1319497728:_LaunchSyncApp docs_client_factory.pyo:99 Creating a new Wapi DocsClient 2015-04-23 16:40:17,525 -0400 INFO pid=293 -1319497728:_LaunchSyncApp docs_client_factory.pyo:99 Creating a new Wapi DocsClient 2015-04-23 16:40:17,525 -0400 INFO pid=293 -1319497728:_LaunchSyncApp docs_client_factory.pyo:99 Creating a new Wapi DocsClient 2015-04-23 16:40:17,525 -0400 INFO pid=293 -1319497728:_LaunchSyncApp docs_client_factory.pyo:99 Creating a new Wapi DocsClient 2015-04-23 16:40:17,526 -0400 INFO pid=293 -1319497728:_LaunchSyncApp service.pyo:280 Remove instance for service '<class 'common.push.notifier.Notifier'>' 2015-04-23 16:40:17,526 -0400 INFO pid=293 -1319497728:_LaunchSyncApp service.pyo:111 Creating user scope service subclass of '<class 'common.push.notifier.Notifier'>' 2015-04-23 16:40:17,526 -0400 INFO pid=293 -1319497728:_LaunchSyncApp service.pyo:113 Actual service created: <common.push.notifier.PushXMPPNotifier object at 0x8c9a950> 2015-04-23 16:40:17,526 -0400 INFO pid=293 -1319497728:_LaunchSyncApp notifier.pyo:167 Configure storage: <common.sync_config_sqlite.SyncConfigSQLite object at 0x8c9ab70> 2015-04-23 16:40:17,766 -0400 INFO pid=293 -1319497728:_LaunchSyncApp notifier.pyo:213 Creating client thread 2015-04-23 16:40:17,767 -0400 INFO pid=293 -1319497728: LaunchSyncApp push_xmpp_client.pyo:225 Using talk server: 2015-04-23 16:40:17,767 -0400 INFO pid=293 -1319497728:_LaunchSyncApp notifier.pyo:222 Creating notification bridge 2015-04-23 16:40:18,148 -0400 INFO pid=293 -1319497728:_LaunchSyncApp docs_client_factory.pyo:99 Creating a new Wapi DocsClient 2015-04-23 16:40:18,299 -0400 INFO pid=293 -1311092736:FeatureSwitchPoller sync_client_thread.pyo:177 FeatureSwitchPoller run loop has started. 2015-04-23 16:40:18,300 -0400 INFO pid=293 -1306890240:TelemetryStoreSizeMonitorThread sync_client_thread.pyo:177 TelemetryStoreSizeMonitorThread run loop has started. 2015-04-23 16:40:18,300 -0400 INFO pid=293 -1311092736:FeatureSwitchPoller features.pyo:138 Loading feature switches with server. 2015-04-23 16:40:18,300 -0400 INFO pid=293 -1302687744:Batcher sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:40:18,301 -0400 INFO pid=293 -1306890240:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo:47 Checking Telemetry store size. 2015-04-23 16:40:18,301 -0400 INFO pid=293 -1298485248:OverlayStatusCleaner sync_client_thread.pyo:177 OverlayStatusCleaner run loop has started. 2015-04-23 16:40:18,301 -0400 INFO pid=293 -1311092736:FeatureSwitchPoller feature_switch_manager.pyo:551 Calling server to get feature switches. 2015-04-23 16:40:18,301 -0400 INFO pid=293 -1294282752:PushNotificationKeepaliveThread sync_client_thread.pyo:177 PushNotificationKeepaliveThread run loop has started. 2015-04-23 16:40:18,302 -0400 INFO pid=293 -1290080256:LocalWatcher watcher.pyo:317 LocalWatcher Run invoked.Waiting for first pass of local scan from poller to start 2015-04-23 16:40:18,302 -0400 INFO pid=293 -1285877760:LocalDiskSpaceChecker EFTA00503165 sync_client_thread.pyo:177 LocalDiskSpaceChecker run loop has started. 2015-04-23 16:40:18,302 -0400 INFO pid=293 -1281675264:RawEventUpgrader sync_client_thread.pyo:177 RawEventUpgrader run loop has started. 2015-04-23 16:40:18,304 -0400 INFO pid=293 -1277472768:CloudWatcher sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:40:18,304 -0400 INFO pid=293 -1273270272:LocalFSPoller sync_client_thread.pyo:177 LocalFSPoller run loop has started. 2015-04-23 16:40:18,305 -0400 INFO pid=293 -1311092736:FeatureSwitchPoller sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:40:18,305 -0400 INFO pid=293 -1269067776:CrashReportUploaderThread crash_report_uploader_thread.pyo:58 Starting CrashReportUploaderThread. 2015-04-23 16:40:18,308 -0400 INFO pid=293 -1256460288:Worker-1 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:40:18,311 -0400 INFO pid=293 -1248055296:XmppClient connection_task.pyo:157 Recalculated LoginTask timeout: 16.000000 2015-04-23 16:40:18,312 -0400 INFO pid=293 -1252257792:Worker-2 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:40:18,314 -0400 INFO pid=293 -1239650304:Worker-0 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:40:18,314 -0400 INFO pid=293 -1235447808:TelemetryUploaderThread sync_client_thread.pyo:177 TelemetryUploaderThread run loop has started. 2015-04-23 16:40:18,315 -0400 INFO pid=293 -1319497728:_LaunchSyncApp drive_extension_installer.pyo:174 Uninstalling extension nknebiagdodnminbdpflhpkgfpeijdbf 2015-04-23 16:40:18,916 -0400 INFO pid=293 -1311092736:FeatureSwitchPoller sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:40:18,917 -0400 INFO pid=293 -1277472768:CloudWatcher sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user default/sync_config.db 2015-04-23 16:40:18,917 -0400 INFO pid=293 -1319497728:_LaunchSyncApp utils.pyo:640 Execute cleanup callback 'persistence_sqlite:9e61e6008cd84bf7b6albf509799d0f6/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-04-23 16:40:18,917 -0400 INFO pid=293 -1256460288:Worker-1 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:40:18,917 -0400 INFO pid=293 -1302687744:Batcher sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:40:18,918 -0400 INFO pid=293 -1319497728:_LaunchSyncApp sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:40:18,919 -0400 INFO pid=293 -1319497728:_LaunchSyncApp utils.pyo:640 Execute cleanup callback 'persistence_sqlite:31ebc72daebl4f89bb6c41e2da893879/Users/lgroff/Library/Application Support/Google/Drive/user default/sync_config.db' 2015-04-23 16:40:18,919 -0400 INFO pid=293 -1319497728:_LaunchSyncApp sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:40:18,943 -0400 INFO pid=293 -1239650304:Worker-0 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:40:18,944 -0400 INFO pid=293 -1252257792:Worker-2 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:40:18,987 -0400 INFO pid=293 -1311092736:FeatureSwitchPoller utils.pyo:663 ADDING persistence_sqlite:68795b57ea6740caab07c3a70abe0bd8/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:40:18,988 -0400 INFO pid=293 -1239650304:Worker-0 utils.pyo:663 ADDING persistence_sqlite:ed4d152ba35746d3bc28ecb5c8a3e7ef/Users/lgroff/Library/Application EFTA00503166 Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:40:18,988 -0400 INFO pid=293 -1256460288:Worker-1 utils.pyo:663 ADDING persistence_sglite:d5abc5e4d07349309092e553eb359384/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:40:18,988 -0400 INFO pid=293 -1277472768:CloudWatcher utils.pyo:663 ADDING persistence_sglite:4c4a86a0887d4075a8b75f56ae070b9e/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:40:18,988 -0400 INFO pid=293 -1311092736:FeatureSwitchPoller utils.pyo:663 ADDING persistence_scilite:fc29227f83dd4156b91c0396ebb87eea/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:40:18,988 -0400 INFO pid=293 -1302687744:Batcher utils.pyo:663 ADDING persistence_sglite:9139f4160c4f941fdb6520347610db919/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:40:18,988 -0400 INFO pid=293 -1239650304:Worker-0 utils.pyo:663 ADDING persistence_sglite:57e79062cfd447b39c099b4c720bele0/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:40:18,989 -0400 INFO pid=293 -1256460288:Worker-1 utils.pyo:663 ADDING persistence_sglite:35b9141d6e6a4df484cb229130a33362/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:40:18,989 -0400 INFO pid=293 -1277472768:CloudWatcher utils.pyo:663 ADDING persistence_sglite:0d808ca37b824411abebbd4199bf4022/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:40:18,989 -0400 INFO pid=293 -1311092736:FeatureSwitchPoller feature_switch_manager.pyo:471 Successfully received feature switches from server. 2015-04-23 16:40:18,989 -0400 INFO pid=293 -1302687744:Batcher utils.pyo:663 ADDING persistence_sglite:be3d733edf4a46aaafb7557847079dec/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:40:18,989 -0400 INFO pid=293 -1239650304:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.downloads.DownloadChangeACL 2015-04-23 16:40:18,990 -0400 INFO pid=293 -1256460288:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.downloads.DownloadChangeACL 2015-04-23 16:40:18,990 -0400 INFO pid=293 -1277472768:CloudWatcher cloud_graph.pyo:118 Initialize persistent graph with generation 2 2015-04-23 16:40:18,991 -0400 INFO pid=293 -1239650304:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.downloads.DownloadCreate 2015-04-23 16:40:18,991 -0400 INFO pid=293 -1256460288:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.downloads.DownloadCreate 2015-04-23 16:40:18,992 -0400 INFO pid=293 -1277472768:CloudWatcher cloud_graph.pyo:1507 Current sync config generation: 2 2015-04-23 16:40:18,992 -0400 INFO pid=293 -1239650304:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.downloads.DownloadDelete 2015-04-23 16:40:18,992 -0400 INFO pid=293 -1256460288:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.downloads.DownloadDelete 2015-04-23 16:40:18,992 -0400 INFO pid=293 -1277472768:CloudWatcher cloud_graph.pyo:1364 Cleanup cloud graph directory '/Users/lgroff/Library/Application Support/Google/Drive/user_default/cloud_graph' of files idict_*.db" except ['dict_2.db 1 , ldict_2.db-shml, 'dict_2.db-wal'] 2015-04-23 16:40:18,992 -0400 INFO pid=293 -1239650304:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.downloads.DownloadModify 2015-04-23 16:40:18,992 -0400 INFO pid=293 -1256460288:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.downloads.DownloadModify 2015-04-23 16:40:18,993 -0400 INFO pid=293 -1239650304:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.downloads.DownloadMove 2015-04-23 16:40:18,993 -0400 INFO pid=293 -1256460288:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.downloads.DownloadMove 2015-04-23 16:40:18,993 -0400 INFO pid=293 -1239650304:Worker-0 command_factory.pyo:190 Registering worker command type: EFTA00503167 common.worker.downloads.DownloadRename 2015-04-23 16:40:18,994 -0400 INFO pid=293 -1256460288:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.downloads.DownloadRename 2015-04-23 16:40:18,995 -0400 INFO pid=293 -1239650304:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupCreate 2015-04-23 16:40:18,996 -0400 INFO pid=293 -1256460288:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupCreate 2015-04-23 16:40:18,996 -0400 INFO pid=293 -1239650304:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupDelete 2015-04-23 16:40:18,996 -0400 INFO pid=293 -1256460288:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupDelete 2015-04-23 16:40:18,996 -0400 INFO pid=293 -1239650304:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupModify 2015-04-23 16:40:18,996 -0400 INFO pid=293 -1256460288:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupModify 2015-04-23 16:40:18,997 -0400 INFO pid=293 -1239650304:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupMove 2015-04-23 16:40:18,997 -0400 INFO pid=293 -1256460288:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupMove 2015-04-23 16:40:18,997 -0400 INFO pid=293 -1239650304:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupRename 2015-04-23 16:40:18,997 -0400 INFO pid=293 -1256460288:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupRename 2015-04-23 16:40:18,997 -0400 INFO pid=293 -1239650304:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BatchUploadCreate 2015-04-23 16:40:18,997 -0400 INFO pid=293 -1256460288:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BatchUploadCreate 2015-04-23 16:40:18,997 -0400 INFO pid=293 -1239650304:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadCreate 2015-04-23 16:40:18,998 -0400 INFO pid=293 -1256460288:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadCreate 2015-04-23 16:40:18,998 -0400 INFO pid=293 -1239650304:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadDelete 2015-04-23 16:40:18,998 -0400 INFO pid=293 -1256460288:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadDelete 2015-04-23 16:40:18,998 -0400 INFO pid=293 -1239650304:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadModify 2015-04-23 16:40:18,998 -0400 INFO pid=293 -1256460288:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadModify 2015-04-23 16:40:18,998 -0400 INFO pid=293 -1239650304:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadMove 2015-04-23 16:40:18,999 -0400 INFO pid=293 -1256460288:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadMove 2015-04-23 16:40:18,999 -0400 INFO pid=293 -1239650304:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadRename 2015-04-23 16:40:18,999 -0400 INFO pid=293 -1256460288:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadRename 2015-04-23 16:40:18,999 -0400 INFO pid=293 -1239650304:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.internals.InternalCreate 2015-04-23 16:40:18,999 -0400 INFO pid=293 -1256460288:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.internals.InternalCreate 2015-04-23 16:40:18,999 -0400 INFO pid=293 -1239650304:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.internals.InternalModify 2015-04-23 16:40:19,000 -0400 INFO pid=293 -1256460288:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.internals.InternalModify 2015-04-23 16:40:19,000 -0400 INFO pid=293 -1239650304:Worker-0 workers.pyo:132 Waiting for batcher to initialize 2015-04-23 16:40:19,000 -0400 INFO pid=293 -1256460288:Worker-1 workers.pyo:132 EFTA00503168 Waiting for batcher to initialize 2015-04-23 16:40:19,000 -0400 INFO pid=293 -1239650304:Worker-0 sync_client_thread.pyo:177 Worker-0 run loop has started. 2015-04-23 16:40:19,000 -0400 INFO pid=293 -1256460288:Worker-1 sync_client_thread.pyo:177 Worker-1 run loop has started. 2015-04-23 16:40:19,002 -0400 INFO pid=293 -1248055296:XmppClient xmpplib.pyo:354 Start SSL peer=173.194.204.125:5222 2015-04-23 16:40:19,009 -0400 INFO pid=293 -1277472768:CloudWatcher utils.pyo:663 ADDING DBConnectionManagerCleanupCallback 2015-04-23 16:40:19,010 -0400 INFO pid=293 -1277472768:CloudWatcher db_connection.pyo:207 Created thread connection on database /Users/lgroff/Library/Application Support/Google/Drive/user_default/cloud_graph/dict_2.db 2015-04-23 16:40:19,010 -0400 INFO pid=293 -1277472768:CloudWatcher cloud_graph.pyo:888 Reuse CloudDiskDict database: /Users/lgroff/Library/Application Support/Google/Drive/user_default/cloud_graph/dict_2.db 2015-04-23 16:40:19,113 -0400 INFO pid=293 -1231245312:IpcConnectionThread-/var/folders/n1/ypw25pmj06qfyyl_8xnt3kf40000gn/T/tmpCuL5Gp-1 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:40:19,145 -0400 INFO pid=293 -1231245312:IpcConnectionThread-/var/folders/n1/ypw25pmj06qfyyl_8xnt3kf40000gn/T/tmpCuL5Gp-1 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:40:19,146 -0400 INFO pid=293 -1231245312:IpcConnectionThread-/var/folders/n1/ypw25pmj06qfyyl_8xnt3kf40000gn/T/tmpCuL5Gp-1 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:40:19,181 -0400 INFO pid=293 -1231245312:IpcConnectionThread-/var/folders/n1/ypw25pmj06qfyyl_8xnt3kf40000gn/T/tmpCuL5Gp-1 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:40:19,232 -0400 ERROR pid=293 -1231245312:IpcConnectionThread-/var/folders/n1/ypw25pmj06qfyyl_8xnt3kf40000gn/T/tmpCuL5Gp-1 server.pyo:191 Got an Ipc client socket exception. Hanging up. Traceback (most recent call last): File "common/ipc/server.pyo", line 186, in Run File "common/ipc/router.pyo", line 398, in ProcessRequest File "common/ipc/router.pyo", line 430, in _SendResponse File "common/ipc/router.pyo", line 242, in SendBytes File "common/ipc/ipc_socket_base.pyo", line 200, in SendAll File "socket.pyo", line 224, in meth error: (Errno 32] Broken pipe 2015-04-23 16:40:19,232 -0400 INFO pid=293 -1231245312:IpcConnectionThread-/var/folders/n1/ypw25pmj06qfyyl_8xnt3kf40000gn/T/tmpCuL5Gp-1 server.pyo:198 Closing Ipc socket connection with client. 2015-04-23 16:40:19,247 -0400 INFO pid=293 -1277472768:CloudWatcher cloud_graph.pyo:161 Initialize persistent graph with existing database /Users/lgroff/Library/Application Support/Google/Drive/user_default/cloud_graph/dict_2.db 2015-04-23 16:40:19,247 -0400 INFO pid=293 -1277472768:CloudWatcher cloud_graph.pyo:256 Building gdoc docids cache. 2015-04-23 16:40:19,987 -0400 INFO pid=293 -1252257792:Worker-2 utils.pyo:663 ADDING persistence_sqlite:fce86b2a3945473e930dda3e25c31c29/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-23 16:40:19,988 -0400 INFO pid=293 -1252257792:Worker-2 utils.pyo:663 ADDING persistence_sqlite:b9c95812ed9b4d64b62cbc506b731c04/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-23 16:40:19,988 -0400 INFO pid=293 -1252257792:Worker-2 workers.pyo:132 Waiting for batcher to initialize 2015-04-23 16:40:19,989 -0400 INFO pid=293 -1252257792:Worker-2 sync_client_thread.pyo:177 Worker-2 run loop has started. 2015-04-23 16:40:20,131 -0400 INFO pid=293 -1277472768:CloudWatcher cloud_graph.pyo:171 Reuse CloudDiskDict CloudDiskDict(max_change_stamp=60312, app_version=1.20.8672.3137, only_rooted_items=False, ()) 2015-04-23 16:40:20,132 -0400 INFO pid=293 -1277472768:CloudWatcher cloud_watcher.pyo:797 Performing full snapshot diff. EFTA00503169 2015-04-23 16:40:20,132 -0400 INFO pid=293 -1277472768:CloudWatcher cloud_watcher.pyo:986 Getting cloud resources via changelog feed from 60313 2015-04-23 16:40:20,132 -0400 INFO pid=293 -1277472768:CloudWatcher docs_client.pyo:741 Requesting Doc List: iffeeds/default/private/changes?start-index=60313&showroot=true&include- shared=true&reason=startup 2015-04-23 16:40:20,262 -0400 INFO pid=293 -1248055296:XmppClient xmpplib.pyo:358 Finish SSL 2015-04-23 16:40:20,428 -0400 INFO pid=293 -1248055296:XmppClient task.pyo:257 Task <common.push.xmpp.login_task.LoginTask instance at 0x52751c0> complete. 2015-04-23 16:40:20,428 -0400 WARNING pid=293 -1248055296:XmppClient login_task.pyo:117 Clearing connection for LoginTask: <common.push.xmpp.login_task.LoginTask instance at 0x52751c0> 2015-04-23 16:40:20,429 -0400 INFO pid=293 -1248055296:XmppClient push_xmpp_client.pyo:304 Connected to 2015-04-23 16:40:20,429 -0400 WARNING pid=293 -1319497728:Thread-4 notification_bridge.pyo:121 XMPP detected connect. 2015-04-23 16:40:20,430 -0400 INFO pid=293 -1319497728:Thread-4 xmpp_network_channel.pyo:148 Sending push channel subscription request 2015-04-23 16:40:20,469 -0400 INFO pid=293 -1248055296:XmppClient xmpp_network_channel.pyo:166 Received subscription response from Push for XMPPBot 2015-04-23 16:40:20,469 -0400 INFO pid=293 -1319497728:Thread-4 notification_bridge.pyo:137 Starting TICL (client version 3.20130807)... 2015-04-23 16:40:20,469 -0400 INFO pid=293 -1319497728:Thread-4 xmpp_network_channel.pyo:64 XmppNetworkChannel.InformNetworkStatus: CONNECTED 2015-04-23 16:40:20,513 -0400 INFO pid=293 -1264865280:ListenerScheduler invalidation_listener.pyo:185 InvalidationListener.ReissueRegistrations(prefix=, prefix_len=0) 2015-04-23 16:40:22,966 -0400 INFO pid=293 -1294282752:PushNotificationKeepaliveThread push_notification_keepalive_thread.pyo:49 Sent push keepalive message at: Thu Apr 23 16:40:22 2015 2015-04-23 16:40:23,318 -0400 INFO pid=293 -1264865280:ListenerScheduler invalidation_listener.pyo:125 InvalidationListener.InformRegistrationStatus(1014:CHANGELOG, REGISTERED) 2015-04-23 16:40:23,318 -0400 WARNING pid=293 -1264865280:ListenerScheduler notification_bridge.pyo:192 Invalidation status callback called with connected=True 2015-04-23 16:40:23,318 -0400 INFO pid=293 -1264865280:ListenerScheduler pause_manager.pyo:171 Removing pause reasons (OFFLINE) from (). Paused: False 2015-04-23 16:40:24,526 -0400 INFO pid=293 -1277472768:CloudWatcher docs_client.pyo:1138 End of feed, no next URI 2015-04-23 16:40:24,527 -0400 INFO pid=293 -1277472768:CloudWatcher cloud_watcher.pyo:766 Got 0 cloud entries 2015-04-23 16:40:24,527 -0400 INFO pid=293 -1277472768:CloudWatcher cloud_watcher.pyo:783 583 nodes in the cloud graph 2015-04-23 16:40:24,640 -0400 INFO pid=293 -1277472768:CloudWatcher cloud_snapshot_diff_helper.pyo:84 Prepare for Pruning graph (total of 583 entries). sync gdocs=True, sync folders=None, excluded folders=fro