EFTA00503210.pdf

From: File "Nolumes/BuildData/pulse- datathgents/wpyt3.hot/recipes/641932625/base/b/drb/googleclient/apps/webdrive_sync/osx/dist/Googl e Drive.app/Contents/Resources/_boot_.py", line 43, in <module> File "Nolumes/BuildData/pulse- datathgents/wpyt3.hot/recipes/641932625/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 371, in applicationWillTerminate_ File "osx/mac_sync_app_controller.pyo", line 310, in Exit File "common/ui_action_handler.pyo", line 457, in Quit File "common/sync_app.pyo", line 1445, in Quit 2015-02-27 16:58:27,779 -0500 INFO pid=9326 -1603214936:MainThread thread_manager.pyo:79 Stop was called 2015-02-27 16:58:27,780 -0500 INFO pid=9326 -1315295232:Finderlnjector sync_client_thread.pyo:199 Finderlnjector run loop has terminated. 2015-02-27 16:58:27,781 -0500 WARNING pid=9326 -1298485248:CloudWatcher cloud_watcher.pyo:677 Exiting CloudWatcher.PushRunLoop() 2015-02-27 16:58:27,781 -0500 INFO pid=9326 -1603214936:MainThread watcher.pyo:291 Unschedule: _MyDriveRoot(u'/Users/lgroff/Google Drive') 2015-02-27 16:58:27,781 -0500 INFO pid=9326 -1302687744:RawEventUpgrader sync_client_thread.pyo:199 RawEventUpgrader run loop has terminated. 2015-02-27 16:58:27,781 -0500 INFO pid=9326 -1298485248:CloudWatcher sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-02-27 16:58:27,782 -0500 INFO pid=9326 -1603214936:MainThread filewatcher.pyo:57 Ignoring unschedule for root [_MyDriveRoot(u./Users/lgroff/Google Drive')] 2015-02-27 16:58:27,783 -0500 INFO pid=9326 -1290080256:LocalFSPoller sync_client_thread.pyo:199 LocalFSPoller run loop has terminated. 2015-02-27 16:58:27,783 -0500 INFO pid=9326 -1281675264:Worker-1 sync_client_thread.pyo: 199 Worker-1 run loop has terminated. 2015-02-27 16:58:27,783 -0500 INFO pid=9326 -1285877760:Worker-0 sync_client_thread.pyo:199 Worker-0 run loop has terminated. 2015-02-27 16:58:27,784 -0500 INFO pid=9326 -1273270272:Batcher sync_client_thread.pyo:251 Batcher run loop has terminated. 2015-02-27 16:58:27,784 -0500 INFO pid=9326 -1281675264:Worker-1 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-02-27 16:58:27,784 -0500 INFO pid=9326 -1269067776:CrashReportUploaderThread crash_report_uploader_thread.pyo:73 Thread suspended. Skipping crash reporting 2015-02-27 16:58:27,784 -0500 INFO pid=9326 -1285877760:Worker-0 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-02-27 16:58:27,784 -0500 INFO pid=9326 -1264865280:OverlayStatusCleaner sync_client_thread.pyo:199 OverlayStatusCleaner run loop has terminated. 2015-02-27 16:58:27,785 -0500 INFO pid=9326 -1260662784:FeatureSwitchPoller features.pyo:138 Loading feature switches with server. 2015-02-27 16:58:27,785 -0500 INFO pid=9326 -1277472768:Worker-2 sync_client_thread.pyo:199 Worker-2 run loop has terminated. 2015-02-27 16:58:27,785 -0500 INFO pid=9326 -1273270272:Batcher sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-02-27 16:58:27,785 -0500 WARNING pid=9326 -1603214936:MainThread task.pyo:245 DriveXmppTask-0xb7434e0 aborting: abort 2015-02-27 16:58:27,785 -0500 INFO pid=9326 -1256460288:PushNotificationKeepaliveThread sync_client_thread.pyo:199 PushNotificationKeepaliveThread run loop has terminated. 2015-02-27 16:58:27,787 -0500 INFO pid=9326 -1260662784:FeatureSwitchPoller feature_switch_manager.pyo:515 Calling server to get feature switches. 2015-02-27 16:58:27,787 -0500 INFO pid=9326 -1298485248:CloudWatcher sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db EFTA00503210 2015-02-27 16:58:27,787 -0500 INFO pid=9326 -1277472768:Worker-2 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.clb 2015-02-27 16:58:27,787 -0500 INFO pid=9326 -1603214936:MainThread task.pyo:257 Task <common.push.push_xmpp_client.DrivekmppTask instance at 0xb7434e0> complete. 2015-02-27 16:58:27,788 -0500 INFO pid=9326 -1281675264:Worker-1 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-02-27 16:58:27,790 -0500 INFO pid=9326 -1603214936:MainThread xmpplib.pyo:112 Close called with 'why' reason = Client initiated close 2015-02-27 16:58:27,790 -0500 INFO pid=9326 -1298485248:CloudWatcher utils.pyo:625 Execute cleanup callback 'persistence_sqlite: 72120789a98c45eda6544492a1b0a09e/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-02-27 16:58:27,791 -0500 INFO pid=9326 -1298485248:CloudWatcher utils.pyo:625 Execute cleanup callback 'DBConnectionManagerCleanupCallback' 2015-02-27 16:58:27,791 -0500 INFO pid=9326 -1298485248:CloudWatcher db_connection.pyo:441 Closing ManagedConnection(id=B3FAE30, thread=CloudWatcher--4D655000, path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/cloud_graph/dict_2.db, closed=False) 2015-02-27 16:58:27,792 -0500 INFO pid=9326 -1281675264:Worker-1 utils.pyo:625 Execute cleanup callback 'persistence_sqlite:1785dbcdba2943e1813d78eaeee2cle4/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2015-02-27 16:58:27,792 -0500 INFO pid=9326 -1281675264:Worker-1 utils.pyo:625 Execute cleanup callback 'persistence_sqlite:c0aef7d2c23947be8954d5a9dbcaf625/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-02-27 16:58:27,793 -0500 INFO pid=9326 -1285877760:Worker-0 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-02-27 16:58:27,793 -0500 INFO pid=9326 -1273270272:Batcher utils.pyo:625 Execute cleanup callback 'persistence_sqlite:e4ad70aa177d4eef9e3edca40972aed6/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-02-27 16:58:27,793 -0500 INFO pid=9326 -1277472768:Worker-2 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-02-27 16:58:27,794 -0500 INFO pid=9326 -1273270272:Batcher utils.pyo:625 Execute cleanup callback 'persistence_sqlite: a1724e3454b94a08aa5b101e137657ec/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2015-02-27 16:58:27,794 -0500 INFO pid=9326 -1285877760:Worker-0 utils.pyo:625 Execute cleanup callback 'persistence_sqlite: f12ad3b3dcf94b789a6bb7453c09b9d8/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-02-27 16:58:27,794 -0500 INFO pid=9326 -1273270272:Batcher sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-02-27 16:58:27,794 -0500 INFO pid=9326 -1277472768:Worker-2 utils.pyo:625 Execute cleanup callback 'persistence_sqlite:aac0ad83b5cb4cefbc7038a23bd92175/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-02-27 16:58:27,794 -0500 INFO pid=9326 -1285877760:Worker-0 utils.pyo:625 Execute cleanup callback 'persistence_sqlite:2989a4027edd4e10a6c3935050bd1386/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2015-02-27 16:58:27,795 -0500 INFO pid=9326 -1277472768:Worker-2 utils.pyo:625 Execute cleanup callback 'persistence_sqlite:b3129312dd5e43f9aa824552472fedab/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2015-02-27 16:58:27,995 -0500 INFO pid=9326 -1260662784:FeatureSwitchPoller feature_switch_manager.pyo:443 Successfully received feature switches from server. 2015-02-27 16:58:27,996 -0500 INFO pid=9326 -1260662784:FeatureSwitchPoller sync_client_thread.pyo:199 FeatureSwitchPoller run loop has terminated. EFTA00503211 2015-02-27 16:58:27,996 -0500 INFO pid=9326 -1260662784:FeatureSwitchPoller utils.pyo:625 Execute cleanup callback 'persistence_sqlite:d1b80a22a7684c3c8e337f2243269462/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2015-02-27 16:58:27,996 -0500 INFO pid=9326 -1260662784:FeatureSwitchPoller sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-02-27 16:58:28,300 -0500 INFO pid=9326 -1260662784:FeatureSwitchPoller utils.pyo:625 Execute cleanup callback 'persistence_sqlite:4e5309cc663140cdb39d70249ae8f316/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-02-27 16:58:28,300 -0500 INFO pid=9326 -1260662784:FeatureSwitchPoller sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-02-27 16:58:28,509 -0500 INFO pid=9326 -1603214936:MainThread task.pyo:257 Task <common.push.push_xmpp_client.DriveXmppTask instance at 0xb7434e0> complete. 2015-02-27 16:58:28,509 -0500 INFO pid=9326 -1603214936:MainThread xmpplib.pyo:112 Close called with 'why' reason = Client initiated close 2015-02-27 16:58:28,509 -0500 INFO pid=9326 -1252257792:XmppClient push_xmpp_client.pyo:137 Exiting run loop 2015-02-27 16:58:28,510 -0500 INFO pid=9326 -1248055296:LocalDiskSpaceChecker sync_client_thread.pyo:199 LocalDiskSpaceChecker run loop has terminated. 2015-02-27 16:58:28,581 -0500 INFO pid=9326 -1235447808:TelemetryStoreSizeMonitorThread sync_client_thread.pyo:199 TelemetryStoreSizeMonitorThread run loop has terminated. 2015-02-27 16:58:28,581 -0500 INFO pid=9326 -1239650304:TelemetryUploaderThread sync_client_thread.pyo:199 TelemetryUploaderThread run loop has terminated. 2015-02-27 16:58:28,645 -0500 INFO pid=9326 -1298485248:CloudWatcher utils.pyo:625 Execute cleanup callback 'persistence_sqlite:2df956cac8564d9fbf8a3c001ce52673/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2015-02-27 16:58:29,107 -0500 INFO pid=9326 -1603214936:MainThread sync_app.pyo:1470 Repr caching stats: <class 'common.delivery.ImmutableChange'>: max hits: 7 mean hits: 6.63636363636 max miss: 0 mean miss: 0.0 <class 'common.worker.worker_event.WorkerModifyCloudEvent'>: max hits: 1 mean hits: 1.0 max miss: 0 mean miss: 0.0 <class 'common. raw_event. ImmutableRawEvent'>: max hits: 15 mean hits: 15.0 max miss: 0 mean miss: 0.0 2015-03-24 09:02:53,495 -0400 INFO pid=3143 -1603214936:MainThread logging_config.pyo:249 OS: Darwin/10.9.5 2015-03-24 09:02:53,548 -0400 INFO pid=3143 -1603214936:MainThread logging_config.pyo:252 Google Drive (build 1.19.8406.6504) 2015-03-24 09:02:53,548 -0400 INFO pid=3143 -1603214936:MainThread logging_config.pyo:253 SSL: OpenSSL 0.9.8zc 15 Oct 2014 2015-03-24 09:02:53,716 -0400 INFO pid=3143 -1603214936:MainThread GSyncAppDelegate.pyo:248 Application did finish launching. 2015-03-24 09:02:56,776 -0400 INFO pid=3143 -1336840192:Thread-1 service.pyo:67 Creating user scope service instance of '<class 'common.service.user.User'>' 2015-03-24 09:02:56,777 -0400 INFO pid=3143 -1336840192:Thread-1 service.pyo:67 Creating user scope service instance of '<class 'common.local.roots.RootManager'>' 2015-03-24 09:02:56,777 -0400 INFO pid=3143 -1336840192:Thread-1 service.pyo:67 Creating user scope service instance of '<class 'common.pause_manager.Service'>' 2015-03-24 09:02:56,777 -0400 INFO pid=3143 -1336840192:Thread-1 sync_app.pyo:297 Getting TokenStorage... 2015-03-24 09:02:56,777 -0400 INFO pid=3143 -1336840192:Thread-1 sync_app.pyo:299 Got token storage: <token_storage.TokenStorage object at 0x819f350> 2015-03-24 09:02:56,778 -0400 INFO pid=3143 -1336840192:Thread-1 service.pyo:67 EFTA00503212 Creating user scope service instance of '<class 'common.features.AppFeatures'>' 2015-03-24 09:02:56,778 -0400 INFO pid=3143 -1336840192:Thread-1 service.pyo:67 Creating user scope service instance of '<class 'common.cert.Manager'>' 2015-03-24 09:02:57,123 -0400 INFO pid=3143 -1336840192:Thread-1 service.pyo:109 Creating singleton service instance of '<class 'common.sync_http_client.BandwidthThrottler'> 1 2015-03-24 09:02:57,160 -0400 INFO pid=3143 -1336840192:Thread-1 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-03-24 09:02:57,222 -0400 INFO pid=3143 -1336840192:Thread-1 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-03-24 09:02:57,234 -0400 INFO pid=3143 -1336840192:Thread-1 utils.pyo:648 ADDING persistence_sqlite:6fblcf96dfa347d0964690d9fe423a98/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-03-24 09:02:57,234 -0400 INFO pid=3143 -1336840192:Thread-1 utils.pyo:648 ADDING persistence_sqlite: 987ba64139f948e38be5c658fa5977ba/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-03-24 09:02:58,575 -0400 INFO pid=3143 -1336840192:Thread-1 sync_app.pyo:472 BandwidthThrottler configured via sync_config 2015-03-24 09:02:58,575 -0400 INFO pid=3143 -1336840192:Thread-1 sync_http_client.pyo:92 BandwidthThrottler.SetRxBytesPerSecond 0 2015-03-24 09:02:58,575 -0400 INFO pid=3143 -1336840192:Thread-1 sync_http_client.pyo:101 BandwidthThrottler.SetTxBytesPerSecond 0 2015-03-24 09:02:58,634 -0400 INFO pid=3143 -1336840192:Thread-1 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-03-24 09:02:58,695 -0400 INFO pid=3143 -1336840192:Thread-1 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-03-24 09:02:58,740 -0400 INFO pid=3143 -1336840192:Thread-1 utils.pyo:625 Execute cleanup callback 'persistence_sqlite:987ba64139f948e38be5c658fa5977ba/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2015-03-24 09:02:58,741 -0400 INFO pid=3143 -1336840192:Thread-1 utils.pyo:625 Execute cleanup callback 'persistence_sqlite:6fblcf96dfa347d0964690d9fe423a98/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-03-24 09:02:58,957 -0400 INFO pid=3143 -1332637696:Thread-2 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-03-24 09:02:59,014 -0400 INFO pid=3143 -1332637696:Thread-2 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-03-24 09:02:59,086 -0400 INFO pid=3143 -1332637696:Thread-2 utils.pyo:648 ADDING persistence_sqlite:741ff8claaa741c7b216d63263277bf4/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-03-24 09:02:59,086 -0400 INFO pid=3143 -1332637696:Thread-2 utils.pyo:648 ADDING persistence_sqlite:82db4f6d9df74983b06ad3b285183d16/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-03-24 09:02:59,086 -0400 INFO pid=3143 -1332637696:Thread-2 feature_switch_manager.pyo:451 Successfully read persisted feature switches. 2015-03-24 09:02:59,674 -0400 INFO pid=3143 -1603214936:MainThread image_resources.py:240 Loading image resources/images/ic_drawer_24.png 2015-03-24 09:02:59,818 -0400 INFO pid=3143 -1603214936:MainThread image_resources.py:240 Loading image resources/images/menu_drive-logo.png 2015-03-24 09:02:59,827 -0400 INFO pid=3143 -1603214936:MainThread image_resources.py:240 Loading image resources/images/menu_google-logo-gray.png 2015-03-24 09:02:59,872 -0400 INFO pid=3143 -1603214936:MainThread image_resources.py:240 Loading image resources/images/ic_folder_mydrive_24.png 2015-03-24 09:02:59,876 -0400 INFO pid=3143 -1603214936:MainThread image_resources.py:240 Loading image resources/images/ic_web_24.png 2015-03-24 09:02:59,889 -0400 INFO pid=3143 -1603214936:MainThread image_resources.py:240 Loading image resources/images/menu_backups.png 2015-03-24 09:02:59,939 -0400 INFO pid=3143 -1603214936:MainThread image_resources.py:240 Loading image resources/images/ic_sync_problem_24.png EFTA00503213 2015-03-24 09:03:00,005 -0400 INFO pid=3143 -1603214936:MainThread image_resources.py:240 Loading image resources/images/ic_done_24.png 2015-03-24 09:03:01,098 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp sqlite.pyo:277 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-03-24 09:03:01,119 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp sqlite.pyo:277 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-03-24 09:03:01,154 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp utils.pyo:648 ADDING persistence_sqlite:df83f426dfcb48a6aa0cedc880256cc6/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-03-24 09:03:01,154 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp utils.pyo:648 ADDING persistence_sqlite:9d0eea3535d3451685247fd9094da85b/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-03-24 09:03:01,713 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp service.pyo:67 Creating user scope service instance of '<class 'common.token_bucket.CloudBucketManager'>. 2015-03-24 09:03:03,816 -0400 INFO pid=3143 -1320030208: LaunchSyncApp user.pyo:61 Initializing User instance with new credentials. 2015-03-24 09:03:03,823 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp features.pyo:109 Loads feature switches. 2015-03-24 09:03:03,823 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp features.pyo:138 Loading feature switches with server. 2015-03-24 09:03:03,823 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp feature_switch_manager.pyo:515 Calling server to get feature switches. 2015-03-24 09:03:03,824 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp feature_switch_manager.pyo:443 Successfully received feature switches from server. 2015-03-24 09:03:03,825 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp sync_app.pyo:1137 Feature Switches: FeatureSwitchSettingsf 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_bandwidth_throttle=True, enable_batch_upload=True, enable_context_menu=True, enable_dapper_trace=False, enable_disk_dict=False, enable_f ile_sync_status=True, enable_multiple_accounts=False, enable_native_opener=True, enable_new_menu=True, enable_push=True, enable_snapshot_reconstruct=True, 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 new_presentation_ur1=' new_spreadsheet_ur1= 1 only_rooted items in cloud graph=False, open_ur1=1 (doc_id)', overlays_enabled_finder_versions=p10.6.8 1, '10.7', '10.7.1', '10.7.2', '10.7.3', '10.7.5', EFTA00503214 '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, share_template_ur1=' subapp=10&shareProtocolVersion=2&theme=2&command=settings&shareUiType=default&authuser=0&clie nt=desktop', show_confirmation_dialog_on_delete=True, telemetry_enabled=True, telemetry_upload interval secs=1800, telemetry_ur1=' token_bucket_read_qps=10, token bucket write_qps=3,) 2015-03-24 09:03:03,841 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp logging_config.pyo:249 OS: Darwin/10.9.5 2015-03-24 09:03:03,882 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp logging_config.pyo:252 Google Drive (build 1.19.8406.6504) 2015-03-24 09:03:03,882 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp logging_config.pyo:253 SSL: OpenSSL 0.9.8zc 15 Oct 2014 2015-03-24 09:03:03,882 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp sync_app.pyo:1146 Config: Email: Sync root: /Users/lgroff/Google Drive Sync collections: set([]) Upgrade number: 19 App version: 1.19.8406.6504 Selective sync: False Cloud Graph generation: 2 Auto-Backup activated: False Folder sync: [] Local app whitelist: set([]) Local app blacklist: set([]) 2015-03-24 09:03:07,539 -0400 INFO pid=3143 -1332637696:Thread-2 finder_injector.pyo:425 Local Google Drive path not yet available, skip loading overlays 2015-03-24 09:03:07,656 -0400 INFO pid=3143 -1315827712:Finderlnjector sync_client_thread.pyo:173 Finderlnjector run loop has started. 2015-03-24 09:03:07,656 -0400 INFO pid=3143 -1332637696:Thread-2 utils.pyo:625 Execute cleanup callback 'persistence_sqlite:741ff8claaa741c7b216d63263277bf4/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-03-24 09:03:07,657 -0400 INFO pid=3143 -1332637696:Thread-2 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-03-24 09:03:07,658 -0400 INFO pid=3143 -1332637696:Thread-2 utils.pyo:625 Execute cleanup callback 'persistence_sqlite:82db4f6d9df74983b06ad3b285183d16/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2015-03-24 09:03:07,658 -0400 INFO pid=3143 -1332637696:Thread-2 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-03-24 09:03:07,712 -0400 INFO pid=3143 -1603214936:MainThread service.pyo:67 Creating user scope service instance of '<class 'common.auto_backup.AutoBackup'>' 2015-03-24 09:03:07,713 -0400 INFO pid=3143 -1603214936:MainThread sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-03-24 09:03:07,728 -0400 INFO pid=3143 -1603214936:MainThread sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-03-24 09:03:07,729 -0400 INFO pid=3143 -1603214936:MainThread sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-03-24 09:03:07,730 -0400 INFO pid=3143 -1603214936:MainThread sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-03-24 09:03:07,730 -0400 INFO pid=3143 -1603214936:MainThread service.pyo:67 EFTA00503215 Creating user scope service instance of '<class 'common.telemetry.telemetry_manager.TelemetryManager'> 1 2015-03-24 09:03:08,599 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp image_resources.py:216 Loading custom image resources/images/folder-mac.icns with function _CreateNSImage 2015-03-24 09:03:09,781 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.downloads.DownloadCreate 2015-03-24 09:03:09,781 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.downloads.DownloadModify 2015-03-24 09:03:09,781 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadCreate 2015-03-24 09:03:09,781 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadDelete 2015-03-24 09:03:09,781 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp rulefactory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadModify 2015-03-24 09:03:09,781 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadMove 2015-03-24 09:03:09,782 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadMoveFrom 2015-03-24 09:03:09,782 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadMoveTo 2015-03-24 09:03:09,783 -0400 INFO pid=3143 -1335775232:FilewatcherMonitor filewatcher.pyo:68 filewatcher_ext initialized 2015-03-24 09:03:09,786 -0400 INFO pid=3143 -1320030208: LaunchSyncApp push_xmpp_client.pyo:220 Using talk server: 2015-03-24 09:03:09,972 -0400 INFO pid=3143 -1303220224:RawEventUpgrader sync_client_thread.pyo:173 RawEventUpgrader run loop has started. 2015-03-24 09:03:09,973 -0400 INFO pid=3143 -1294815232:LocalWatcher watcher.pyo:314 LocalWatcher Run invoked.Waiting for first pass of local scan from poller to start 2015-03-24 09:03:09,973 -0400 INFO pid=3143 -1299017728:CloudWatcher sqlite.pyo:277 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-03-24 09:03:09,973 -0400 INFO pid=3143 -1290612736:LocalFSPoller sync_client_thread.pyo:173 LocalFSPoller run loop has started. 2015-03-24 09:03:09,974 -0400 INFO pid=3143 -1286410240:Worker-0 master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-03-24 09:03:09,974 -0400 INFO pid=3143 -1282207744:Worker-1 master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-03-24 09:03:09,975 -0400 INFO pid=3143 -1278005248:Worker-2 master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-03-24 09:03:09,975 -0400 INFO pid=3143 -1273802752:Batcher master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-03-24 09:03:09,975 -0400 INFO pid=3143 -1269600256:CrashReportUploaderThread crash report uploader thread.pyo:58 Starting CrashReportUploaderThread. 2015-03-24 09:03:09,975 -0400 INFO pid=3143 -1265397760:OverlayStatusCleaner sync_client_thread.pyo:173 OverlayStatusCleaner run loop has started. 2015-03-24 09:03:09,976 -0400 INFO pid=3143 -1261195264:FeatureSwitchPoller sync_client_thread.pyo:173 FeatureSwitchPoller run loop has started. 2015-03-24 09:03:09,976 -0400 INFO pid=3143 -1256992768:PushNotificationKeepaliveThread sync_client_thread.pyo:173 PushNotificationKeepaliveThread run loop has started. 2015-03-24 09:03:09,977 -0400 INFO pid=3143 -1252790272:KmppClient connection_task.pyo:157 Recalculated LoginTask timeout: 16.000000 2015-03-24 09:03:09,977 -0400 INFO pid=3143 -1248587776:LocalDiskSpaceChecker sync_client_thread.pyo:173 LocalDiskSpaceChecker run loop has started. 2015-03-24 09:03:09,977 -0400 INFO pid=3143 -1240182784:TelemetryUploaderThread sync_client_thread.pyo:173 TelemetryUploaderThread run loop has started. 2015-03-24 09:03:09,978 -0400 INFO pid=3143 -1235980288:TelemetryStoreSizeMonitorThread sync_client_thread.pyo:173 TelemetryStoreSizeMonitorThread run loop has started. 2015-03-24 09:03:09,978 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp drive_extension_installer.pyo:174 Uninstalling extension nknebiagdodnminbdpflhpkgfpeijdbf 2015-03-24 09:03:09,998 -0400 INFO pid=3143 -1261195264:FeatureSwitchPoller features.pyo:138 sqlite.pyo:277 Open sqlite.pyo:277 Open sqlite.pyo:277 Open sqlite.pyo:277 Open EFTA00503216 Loading feature switches with server. 2015-03-24 09:03:10,001 -0400 INFO pid=3143 -1235980288:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 47 Checking Telemetry store size. 2015-03-24 09:03:10 /Volumes/BuildData/pulse- data/agents/wpyt3.hot/recipes/641932625/base/b/drb/googleclient/apps/webdrive_sync/osx/ext/sh ared/ :93 - Pipe path is a symbolic link, connecting to target. 2015-03-24 09:03:10 /Volumes/BuildData/pulse- data/agents/wpyt3.hot/recipes/641932625/base/b/drb/googleclient/apps/webdrive_sync/osx/ext/sh ared/ :93 - /Users/lgroff/Library/Application Support/Google/Drive/GoogleDrivelpcPipe is a symbolic link to /var/folders/n1/ypw25pmj06qfyyl_8xnt3kf40000gn/T/tmp97gnIl, connecting to link target. 2015-03-24 09:03:10,001 -0400 INFO pid=3143 -1261195264:FeatureSwitchPoller feature_switch_manager.pyo:515 Calling server to get feature switches. 2015-03-24 09:03:10,295 -0400 INFO pid=3143 -1261195264:FeatureSwitchPoller sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-03-24 09:03:10,295 -0400 INFO pid=3143 -1282207744:Worker-1 sqlite.pyo:277 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-03-24 09:03:10,297 -0400 INFO pid=3143 -1299017728:CloudWatcher master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-03-24 09:03:10,295 -0400 INFO pid=3143 -1278005248:Worker-2 master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-03-24 09:03:10,296 -0400 INFO pid=3143 -1286410240:Worker-0 master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-03-24 09:03:10,296 -0400 ERROR pid=3143 -1231777792:IpcConnectionThread-/var/folders/n1/ypw25pmj06qfyyl_8xnt3kf40000gn/T/tmp97gnI1-1 server.pyo:185 Got an Ipc client socket exception. Hanging up. Traceback (most recent call last): File "common/ipc/server.pyo", line 180, in Run File "common/ipc/router.pyo", line 380, in ProcessRequest File "common/ipc/router.pyo", line 415, in _SendResponse File "common/ipc/router.pyo", line 238, in SendBytes File "common/ipc/ipc_socket_base.pyo", line 169, in SendAll File "socket.pyo", line 224, in meth error: (Errno 32] Broken pipe 2015-03-24 09:03:10,296 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp utils.pyo:625 Execute cleanup callback 'persistence_sqlite:df83f426dfcb48a6aa0cedc880256cc6/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-03-24 09:03:10,296 -0400 INFO pid=3143 -1273802752:Batcher sqlite.pyo:277 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-03-24 09:03:10,373 -0400 INFO pid=3143 -1252790272:XmppClient xmpplib.pyo:352 Start SSL peer=64.233.171.125:5222 2015-03-24 09:03:10,440 -0400 INFO pid=3143 -1256992768:PushNotificationKeepaliveThread push_notification_keepalive_thread.pyo:49 Sent push keepalive message at: Tue Mar 24 09:03:10 2015 2015-03-24 09:03:10,563 -0400 INFO pid=3143 -1231777792:IpcConnectionThread-/var/folders/n1/ypw25pmj06qfyyl_8xnt3kf40000gn/T/tmp97gnI1-1 server.pyo:192 Closing Ipc socket connection with client. 2015-03-24 09:03:10,564 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-03-24 09:03:10,566 -0400 INFO pid=3143 -1282207744:Worker-1 utils.pyo:648 ADDING persistence_sqlite: f58e1c39c37747f39de02752e58be3ac/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-03-24 09:03:10,567 -0400 INFO pid=3143 -1282207744:Worker-1 utils.pyo:648 ADDING persistence_sqlite:0f8bccffl7a545728f6518a4665e6alf/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-03-24 09:03:10,567 -0400 INFO pid=3143 -1282207744:Worker-1 command_factory.pyo:190 Registering worker command type: sqlite.pyo:277 Open sqlite.pyo:277 Open sqlite.pyo:277 Open EFTA00503217 common.worker.downloads.DownloadChangeACL 2015-03-24 09:03:10,567 -0400 INFO pid=3143 -1282207744:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.downloads.DownloadCreate 2015-03-24 09:03:10,567 -0400 INFO pid=3143 -1282207744:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.downloads.DownloadDelete 2015-03-24 09:03:10,567 -0400 INFO pid=3143 -1282207744:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.downloads.DownloadModify 2015-03-24 09:03:10,568 -0400 INFO pid=3143 -1278005248:Worker-2 utils.pyo:648 ADDING persistence_sqlite:7d0cad0b94ca40a198a9f6lab7153b3f/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-03-24 09:03:10,568 -0400 INFO pid=3143 -1282207744:Worker-1 command_factory.pyo: 190 Registering worker command type: common.worker.downloads.DownloadMove 2015-03-24 09:03:10,568 -0400 INFO pid=3143 -1299017728:CloudWatcher utils.pyo:648 ADDING persistence_sqlite: 6ecd68b95a0746cba92b571c2aff7756/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-03-24 09:03:10,568 -0400 INFO pid=3143 -1286410240:Worker-0 utils.pyo:648 ADDING persistence_sqlite:09d418ff848d4edb8567ea5cd8614ffa/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-03-24 09:03:10,568 -0400 INFO pid=3143 -1273802752:Batcher utils.pyo:648 ADDING persistence_sqlite:caeba7420a464459bcfb932c9775cfe8/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-03-24 09:03:10,568 -0400 INFO pid=3143 -1278005248:Worker-2 utils.pyo:648 ADDING persistence_sqlite:9abld8de412d4433818a6a53d69699d0/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-03-24 09:03:10,568 -0400 INFO pid=3143 -1282207744:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.downloads.DownloadRename 2015-03-24 09:03:10,569 -0400 INFO pid=3143 -1299017728:CloudWatcher utils.pyo:648 ADDING persistence_sqlite: f5d1d8d8b2924042b41f6fca287cd086/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-03-24 09:03:10,569 -0400 INFO pid=3143 -1286410240:Worker-0 utils.pyo:648 ADDING persistence_sqlite:56f98470376b4b0eb2fc7eab0ac6e972/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-03-24 09:03:10,569 -0400 INFO pid=3143 -1273802752:Batcher utils.pyo:648 ADDING persistence_sqlite:cafebd2e7d204efb89c6a12e2411d562/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-03-24 09:03:10,570 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp utils.pyo:625 Execute cleanup callback 'persistence_sqlite:9d0eea3535d3451685247fd9094da85b/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2015-03-24 09:03:10,570 -0400 INFO pid=3143 -1261195264:FeatureSwitchPoller sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-03-24 09:03:10,590 -0400 INFO pid=3143 -1278005248:Worker-2 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupCreate 2015-03-24 09:03:10,590 -0400 INFO pid=3143 -1282207744:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupCreate 2015-03-24 09:03:10,590 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_graph.pyo:118 Initialize persistent graph with generation 2 2015-03-24 09:03:10,591 -0400 INFO pid=3143 -1286410240:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupCreate 2015-03-24 09:03:10,591 -0400 INFO pid=3143 -1320030208:_LaunchSyncApp sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-03-24 09:03:10,591 -0400 INFO pid=3143 -1278005248:Worker-2 command_factory.pyo: 190 Registering worker command type: common.worker.uploads.BackupDelete 2015-03-24 09:03:10,592 -0400 INFO pid=3143 -1282207744:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupDelete 2015-03-24 09:03:10,592 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_graph.pyo:1507 Current sync config generation: 2 2015-03-24 09:03:10,592 -0400 INFO pid=3143 -1286410240:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupDelete EFTA00503218 2015-03-24 09:03:10,592 command_factory.pyo:190 2015-03-24 09:03:10,593 command_factory.pyo:190 2015-03-24 09:03:10,593 command_factory.pyo:190 2015-03-24 09:03:10,593 command_factory.pyo:190 2015-03-24 09:03:10,593 command_factory.pyo:190 2015-03-24 09:03:10,593 command_factory.pyo:190 2015-03-24 09:03:10,594 -0400 INFO pid=3143 -1278005248 Registering worker command type -0400 INFO pid=3143 -1282207744 Registering worker command type -0400 INFO pid=3143 -1282207744 Registering worker command type -0400 INFO pid=3143 -1278005248 Registering worker command type -0400 INFO pid=3143 -1286410240 Registering worker command type -0400 INFO pid=3143 -1282207744 Registering worker command type -0400 INFO pid=3143 -1278005248 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupRename 2015-03-24 09:03:10,594 -0400 INFO pid=3143 -1286410240:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupMove 2015-03-24 09:03:10,594 -0400 INFO pid=3143 -1282207744:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BatchUploadCreate 2015-03-24 09:03:10,594 -0400 INFO pid=3143 -1278005248:Worker-2 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BatchUploadCreate 2015-03-24 09:03:10,684 -0400 INFO pid=3143 -1286410240:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupRename 2015-03-24 09:03:10,684 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_graph.pyo:1364 Cleanup cloud graph directory '/Users/lgrof f/Library/Application Support/Google/Drive/user_default/cloud_graph' of files 'dict_*.db" except ['dict_2.db 1, 'dict 2.db-shm., 'dict 2.db-wal'] 2015-03-24 09:03:10,684 -0400 INFO pid=3143 -1282207744:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadCreate 2015-03-24 09:03:10,684 -0400 INFO pid=3143 -1278005248:Worker-2 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadCreate 2015-03-24 09:03:10,684 -0400 INFO pid=3143 -1286410240:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BatchUploadCreate 2015-03-24 09:03:10,685 -0400 INFO pid=3143 -1282207744:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadDelete 2015-03-24 09:03:10,686 -0400 INFO pid=3143 -1261195264:FeatureSwitchPoller utils.pyo:648 ADDING persistence_scilite:db893cc2a38c4dalbbd0b866fc6d5e12/Users/lgroff/Library/Application Support/Google/Drive/user default/snapshot.db 2015-03-24 09:03:10,686 -0400 INFO pid=3143 -1278005248:Worker-2 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadDelete 2015-03-24 09:03:10,686 -0400 INFO pid=3143 -1286410240:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadCreate 2015-03-24 09:03:10,686 -0400 INFO pid=3143 -1282207744:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadModify 2015-03-24 09:03:10,686 -0400 INFO pid=3143 -1261195264:FeatureSwitchPoller utils.pyo:648 ADDING persistence_scilite:c60bddle37f441feb2e83a36cac88244/Users/lgroff/Library/Application Support/Google/Drive/user default/sync_config.db 2015-03-24 09:03:10,686 -0400 INFO pid=3143 -1278005248:Worker-2 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadModify 2015-03-24 09:03:10,687 -0400 INFO pid=3143 -1286410240:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadDelete 2015-03-24 09:03:10,687 -0400 INFO pid=3143 -1282207744:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadMove 2015-03-24 09:03:10,687 -0400 INFO pid=3143 -1261195264:FeatureSwitchPoller feature_switch_manager.pyo:443 Successfully received feature switches from server. 2015-03-24 09:03:10,687 -0400 INFO pid=3143 -1278005248:Worker-2 command_factory.pyo:190 2015-03-24 09:03:10,687 command_factory.pyo:190 2015-03-24 09:03:10,687 command_factory.pyo:190 2015-03-24 09:03:10,688 command_factory.pyo:190 :Worker-2 : common.worker :Worker-1 : common.worker :Worker-1 : common.worker :Worker-2 : common.worker :Worker-0 : common.worker :Worker-1 : common.worker :Worker-2 .uploads.BackupModify .uploads.BackupModify .uploads.BackupMove .uploads.BackupMove .uploads.BackupModify .uploads.BackupRename Registering worker command type: common.worker.uploads -0400 INFO pid=3143 -1286410240:Worker-0 Registering worker command type: common.worker.uploads -0400 INFO pid=3143 -1282207744:Worker-1 Registering worker command type: common.worker.uploads -0400 INFO pid=3143 -1278005248:Worker-2 Registering worker command type: common.worker.uploads .UploaciMove .UploadModify .UploadRename .UploadRename EFTA00503219 2015-03-24 09:03:10,689 command_factory.pyo:190 2015-03-24 09:03:10,689 command_factory.pyo:190 common.worker.internals. 2015-03-24 09:03:10,689 command_factory.pyo:190 common.worker.internals. 2015-03-24 09:03:10,689 command_factory.pyo:190 2015-03-24 09:03:10,720 command_factory.pyo:190 common.worker.internals. 2015-03-24 09:03:10,720 command_factory.pyo:190 common.worker.internals. 2015-03-24 09:03:10,720 -0400 INFO pid=3143 Registering worker -0400 INFO pid=3143 Registering worker InternalCreate -0400 INFO pid=3143 Registering worker InternalCreate -0400 INFO pid=3143 Registering worker -0400 INFO pid=3143 Registering worker InternalModify -0400 INFO pid=3143 Registering worker InternalModify -0400 INFO pid=3143 Waiting for batcher to initialize 2015-03-24 09:03:10,720 -0400 INFO pid=3143 -1282207744:Worker-1 Waiting for batcher to initialize 2015-03-24 09:03:10,720 -0400 INFO pid=3143 -1278005248:Worker-2 Waiting for batcher to initialize 2015-03-24 09:03:10,721 -0400 INFO pid=3143 -1286410240:Worker-0 sync_client_thread.pyo:173 Worker-0 run loop has started. 2015-03-24 09:03:10,721 -0400 INFO pid=3143 -1282207744:Worker-1 sync_client_thread.pyo:173 Worker-1 run loop has started. 2015-03-24 09:03:10,721 -0400 INFO pid=3143 -1278005248:Worker-2 sync_client_thread.pyo:173 Worker-2 run loop has started. 2015-03-24 09:03:10,776 -0400 INFO pid=3143 -1299017728:CloudWatcher DBConnectionManagerCleanupCallback 2015-03-24 09:03:10,777 -0400 INFO pid=3143 -1299017728:CloudWatcher Created thread connection on database /Users/lgroff/Library/Application Support/Google/Drive/user_default/cloud_graph/dict_2.db 2015-03-24 09:03:10,778 -0400 INFO pid=3143 -1299017728:CloudWatcher Reuse CloudDiskDict database: /Users/lgroff/Library/Application Support/Google/Drive/user_default/cloud_graph/dict_2.db 2015-03-24 09:03:10,892 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_graph.pyo:161 Initialize persistent graph with existing database /Users/lgrof f/Library/Application Support/Google/Drive/user_default/cloud_graph/dict_2.db 2015-03-24 09:03:10,892 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_graph.pyo:256 Building gdoc docids cache. 2015-03-24 09:03:11,834 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_graph.pyo:171 Reuse CloudDiskDict CloudDiskDict(max_change_stamp=57421, app_version=1.19.8406.6504, only_rooted_items=False, (}) 2015-03-24 09:03:11,835 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_watcher.pyo:798 Performing full snapshot diff. 2015-03-24 09:03:11,835 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_watcher.pyo:987 Getting cloud resources via changelog feed from 57422 2015-03-24 09:03:11,835 -0400 INFO pid=3143 -1299017728:CloudWatcher docs_client.pyo:801 Requesting Doc List: /feeds/default/private/changes?start-index=57422&showroot=true&include- shared=true&reason=startup 2015-03-24 09:03:12,399 -0400 INFO pid=3143 -1252790272:XmppClient xmpplib.pyo:356 Finish SSL 2015-03-24 09:03:12,550 -0400 INFO pid=3143 -1252790272:XmppClient task.pyo:257 Task <common.push.xmpp.login_task.LoginTask instance at 0xb854738> complete. 2015-03-24 09:03:12,550 -0400 WARNING pid=3143 -1252790272:XmppClient login_task.pyo:117 Clearing connection for LoginTask: <common.push.xmpp.login_task.LoginTask instance at 0xb854738> 2015-03-24 09:03:12,550 -0400 INFO pid=3143 -1252790272:XmppClient push_xmpp_client.pyo:295 Connected to 2015-03-24 09:03:12,551 -0400 WARNING pid=3143 -1320030208:Thread-4 notification_bridge.pyo:125 XMPP detected connect. 2015-03-24 09:03:12,551 -0400 INFO pid=3143 -1320030208:Thread-4 xmpp_network_channel.pyo:148 Sending push channel subscription request 2015-03-24 09:03:12,578 -0400 INFO pid=3143 -1252790272:XmppClient -1286410240 command type -1282207744 command type :Worker-0 : common .worker . uploads .UploaciMove :Worker-1 -1278005248:Worker-2 command type: -1286410240 command type -1282207744 command type :Worker-0 : common.worker.uploads.UploadRename :Worker-1 -1278005248:Worker-2 command type: -1286410240: Worker-0 workers.pyo:132 workers.pyo:132 workers.pyo:132 utils.pyo:648 ADDING db_connection.pyo:207 cloud_graph.pyo: 888 EFTA00503220 xmpp_network_channel.pyo:166 Received subscription response from Push for XMPPBot 2015-03-24 09:03:12,578 -0400 INFO pid=3143 -1320030208:Thread-4 notification_bridge.pyo:141 Starting TICL (client version 3.20130807)... 2015-03-24 09:03:12,643 -0400 INFO pid=3143 -1299017728:CloudWatcher docs_client.pyo:1211 Feed has 12 entries 2015-03-24 09:03:12,733 -0400 INFO pid=3143 -1320030208:Thread-4 xmpp_network_channel.pyo: 64 XmppNetworkChannel.InformNetworkStatus: CONNECTED 2015-03-24 09:03:12,798 -0400 INFO pid=3143 -1299017728:CloudWatcher docs_client.pyo:1218 End of feed, no next URI 2015-03-24 09:03:12,799 -0400 INFO pid=3143 -1307422720:ListenerScheduler invalidation_listener.pyo:184 InvalidationListener.ReissueRegistrations(prefix=, prefix_len=0) 2015-03-24 09:03:12,810 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_watcher.pyo:767 Got 12 cloud entries 2015-03-24 09:03:13,031 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_watcher.pyo:784 573 nodes in the cloud graph 2015-03-24 09:03:13,062 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_snapshot_diff_helper.pyo:84 Prepare for Pruning graph (total of 573 entries). sync gdocs=True, sync folders=None, excluded folders=frozenset([]) 2015-03-24 09:03:13,062 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_snapshot_diff_helper.pyo:85 Start Prune Graph (total of 573 entries) 2015-03-24 09:03:13,068 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_snapshot_diff_helper.pyo:168 Pruning detected 568 items to keep 2015-03-24 09:03:13,069 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_snapshot_diff_helper.pyo:175 568 entries in graph after pruning 2015-03-24 09:03:13,069 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_snapshot_diff_helper.pyo:93 Compare to snaphost 2015-03-24 09:03:13,069 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_snapshot_diff_helper.pyo:746 Starting cloud graph vs snapshot diff with selective sync set: None 2015-03-24 09:03:13,069 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_snapshot_diff_helper.pyo:748 Prepopulating DOC_ID-to-inodes cache 2015-03-24 09:03:13,548 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_snapshot_diff_helper.pyo:752 First pass detecting moved entries 2015-03-24 09:03:13,773 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_snapshot_diff_helper.pyo:767 Second pass detecting creations and modification entries 2015-03-24 09:03:14,007 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_snapshot_diff_helper.pyo:794 Processed 567 entries in total. Number of events detected: (_FSChangeActionType(Action.MODIFY): 2, _FSChangeActionType(Action.CREATE): 2} 2015-03-24 09:03:14,057 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_watcher.pyo:841 Done with full snapshot diff. 2015-03-24 09:03:14,057 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_watcher.pyo:897 CloudWatcher generated 4 events 2015-03-24 09:03:14,058 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_watcher.pyo:903 CloudWatcher generated FSChange(Direction.DOWNLOAD, Action.MODIFY, ino=13355997, name=2015 March.docx, rid=0BxNN8iEiWGvga2Q5dEtmMXRvQjg, parent_ino=529993, modified=1427145287, checksum=8939b22f46584628758c7879942d72a6, size=100353, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False) 2015-03-24 09:03:14,058 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_watcher.pyo:903 CloudWatcher generated FSChange(Direction.DOWNLOAD, Action.CREATE, name=2015 April.docx, route=[CloudEntry(doc_id=0BxNN8iEiWGvgaXhaVzNUdGt6ckU,filename=2015 April.docx,modified=1426849114,created=1426524655,acl_role=owner,doc_type=DocType.BLOB,remove d=False,parent_doc_ids=set( 1011xNN8iEiWGvgblENdGVHdkRvSOU' ,child_doc_ids=set( [1 ) ,size=46178 ,checksum=815488ee4ab4020fbd32dad72eea3012,change_stamp=58268,server_mod_time=1426849729,is_z ombie=False,shared=Falser resource_type=file)1, rid=0BxNN8iEiWGvgaXhaVzNUdGt6ckU, parent_ino=529993, is_folder=False, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False) 2015-03-24 09:03:14,059 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_watcher.pyo:903 CloudWatcher generated FSChange(Direction.DOWNLOAD, Action.MODIFY, ino=13356002, name=2015 Employee Vacation and Sick Days.docx, rid=0BxNN8iEiWGvg0TlanV19MZVJ4M2c, parent_ino=529993, modified=1425399279, checksum=57c809766380b53ee0a9b6a9ce36b3c9, size=30058, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False) 2015-03-24 09:03:14,082 -0400 INFO pid=3143 -1299017728:CloudWatcher cloud_watcher.pyo:903 CloudWatcher generated FSChange(Direction.DOWNLOAD, Action.CREATE, name=RussianVisaAppMarch2015.pdf, route= EFTA00503221 (CloudEntry(doc_id=0BxNN8iEiWGvgbWlnaTJcidWF1bEU,filename=RussianVisaAppMarch2015.pdf,modified =1426797204,created=1426797209,acl_role=owner,doc_type=DocType.BLOB,removed=False,parent_doc_ ids=setWOBxNN8iEiWGvgb1FNdGVHdkRvSOU'D,child_doc_ids=set([1),size=249075,checksum=lf6634e2 48bbfdd53f90a35b51523f29,change_stamp=58250,server_mod_time=1426809930,is_zombie=False,shared =False,resource_type=pdf)], rid=0B5(NN8iEiWGvgbWlnaTJOWF1bEU, parent_ino=529993, is_folder=False, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False) 2015-03-24 09:03:14,083 -0400 INFO pid=3143 -1299017728:CloudWatcher aggregator.pyo:114 > Received event None FSChange(Direction.DOWNLOAD, Action.MODIFY, ino=13355997, name=2015 March.docx, rid=0BxNN8iEiWGvga2Q5dEtmMXRvQjg, parent_ino=529993, modified=1427145287, checksum=8939b22f46584628758c7879942d72a6, size=100353, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False) 2015-03-24 09:03:14,083 -0400 INFO pid=3143 -1299017728:CloudWatcher downloads.pyo:127 ProcessDownloadModify (FSChange(Direction.DOWNLOAD, Action.MODIFY, ino=13355997, name=2015 March.docx, rid=0BxNN8iEiWGvga2Q5dEtmMXRvQjg, parent_ino=529993, modified=1427145287, checksum=8939b22f46584628758c7879942d72a6, size=100353, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False)) 2015-03-24 09:03:14,083 -0400 INFO pid=3143 -1299017728:CloudWatcher change_buffer.pyo:1027 Adding change to change buffer: FSChange(Direction.DOWNLOAD, Action.MODIFY, ino=13355997, name=2015 March.docx, rid=0BxNN8iEiWGvga2Q5dEtmMXRvQjg, parent_ino=529993, modified=1427145287, checksum=8939b22f46584628758c7879942d72a6, size=100353, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, ispriority=False, hash=-1954924861) 2015-03-24 09:03:14,083 -0400 INFO pid=3143 -1299017728:CloudWatcher aggregator.pyo:114 > Received event None FSChange(Direction.DOWNLOAD, Action.MODIFY, ino=13356002, name=2015 Employee Vacation and Sick Days.docx, rid=0124(NN8iEiWGvg0TlanV19MZVJ4M2c, parent_ino=529993, modified=1425399279, checksum=57c809766380b53ee0a9b6a9ce36b3c9, size=30058, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False) 2015-03-24 09:03:14,084 -0400 INFO pid=3143 -1299017728:CloudWatcher downloads.pyo:127 ProcessDownloadModify (FSChange(Direction.DOWNLOAD, Action.MODIFY, ino=13356002, name=2015 Employee Vacation and Sick Days.docx, rid=0BxNN8iEiWGvg0TlanV19M2VJ4M2c, parent_ino=529993, modified=1425399279, checksum=57c809766380b53ee0a9b6a9ce36b3c9, size=30058, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False)) 2015-03-24 09:03:14,084 -0400 INFO pid=3143 -1299017728:CloudWatcher change_buffer.pyo:1027 Adding change to change buffer: FSChange(Direction.DOWNLOAD, Action.MODIFY, ino=13356002, name=2015 Employee Vacation and Sick Days.docx, rid=0B5(NN8iEiWGvg0TIMV19MZVJ4M2c, parent_ino=529993, modified=1425399279, checksum=57c809766380b53ee0a9b6a9ce36b3c9, size=30058, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False, hash=-1516976679) 2015-03-24 09:03:14,084 -0400 INFO pid=3143 -1299017728:CloudWatcher aggregator.pyo:114 > Received event None FSChange(Direction.DOWNLOAD, Action.CREATE, name=2015 April.docx, route=[CloudEntry(doc_id=0BxNN8iEiWGvgaXhaVzNUdGt6ckU,filename=2015 April.docx,modified=1426849114,created=1426524655,acl_role=owner,doc_type=DocType.BLOB,remove d=False,parent_doc_ids=set([ 1011xNN8iEiWGvgb1FNdGVHdkRvSOU']),child_doc_ids=set(u),size=46178 ,checksum=815488ee4ab4020fbd32dad72eea3012,change_stamp=58268,server_mod_time=1426849729,is_z ombie=False,shared=False,resource_type=file)], rid=0B3ENN8iEiWGvgaXhaVzNUdGt6ckU, parent_ino=529993, is_folder=False, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False) 2015-03-24 09:03:14,124 -0400 INFO pid=3143 -1299017728:CloudWatcher change_buffer.pyo:1027 Adding change to change buffer: FSChange(Direction.DOWNLOAD, Action.CREATE, name=2015 April.docx, route= (CloudEntry(doc_id=0BxNN8iEiWGvgaXhaVzNUdGt6ckU,filename=2015 April.docx,modified=1426849114,created=1426524655,acl_role=owner,doc_type=DocType.BLOB,remove d=False,parent_doc_ids=set([ 10BxNN8iEiWGvgb1FNdGVHdkRvSOU']),child_doc_ids=set(u),size=46178 ,checksum=815488ee4ab4020fbd32dad72eea3012,change_stamp=58268,server_mod_time=1426849729,is_z ombie=False,shared=False,resource_type=file)], rid=0BxNN8iEiWGvgaXhaVzNUdGt6ckU, parent_ino=529993, is_folder=False, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False, hash=-1677849506) 2015-03-24 09:03:14,125 -0400 INFO pid=3143 -1299017728:CloudWatcher aggregator.pyo:114 -- > Received event None FSChange(Direction.DOWNLOAD, Action.CREATE, name=RussianVisaAppMarch2015.pdf, route= (CloudEntry(doc_id=08xNN8iEiWGvgbWlnaTJqdWF1bEU,filename=RussianVisaAppMarch2015.pdf,modified =1426797204,created=1426797209,acl_role=owner,doc_type=DocType.BLOB,removed=False,parent_doc_ ids=set(p0BxNN8iEiWGvgb1FNdGVHdkRvSOU'D,child_doc_ids=set(()),size=249075,checksum=lf6634e2 48bbfdd53f90a35b51523f29,change_stamp=58250,server_mod_time=1426809930,is_zombie=False,shared =False, resource_type=pdf)], rid=0BxNN8iEiWGvgbWlnaTJOWF1bEU, parent_ino=529993, EFTA00503222 is_folder=False, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False) 2015-03-24 09:03:14,125 -0400 INFO pid=3143 -1299017728:CloudWatcher change_buffer.pyo:1027 Adding change to change buffer: FSChange(Direction.DOWNLOAD, Action.CREATE, name=RussianVisaAppMarch2015.pdf, route= (CloudEntry(doc_id=OBxNN8iEiWGvgbWlnaTJgdWF1bEU,filename=RussianVisaAppMarch2015.pdf,modified =1426797204,created=1426797209,acl_role=owner,doc_type=DocType.BLOB,removed=False,parent_doc_ ids=set(p0BxNN8iEiWGvgblElidGVHdkRvSOU'D,child_doc_ids=set([1),size=249075,checksum=lf6634e2 48bbfdd53f90a35b51523f29,change_stamp=58250,server_mod_time=1426809930,is_zombie=False,shared =False,resource_type=pdf)], rid=0B5(NN8iEiWGvgbWlnaT.ROWF1bEU, parent_ino=529993, is_folder=False, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False, hash=149103828) 2015-03-24 09:03:14,487 -0400 INFO pid=3143 -1273802752:Batcher batcher.pyo:241 Ready changes are pending. 2015-03-24 09:03:14,490 -0400 INFO pid=3143 -1286410240:Worker-0 workers.pyo:188 Worker starting on [ImmutableChange(Direction.DOWNLOAD, Action.MODIFY, ino=13355997, name=2015 March.docx, rid=0BxNN8iEiWGvga2Q5dEtmMXRvQjg, parent_ino=529993, modified=1427145287, checksum=8939b22f46584628758c7879942d72a6, size=100353, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False, hash=-1954924861, _constructor_called=True)] 2015-03-24 09:03:14,494 -0400 INFO pid=3143 -1282207744:Worker-1 workers.pyo:188 Worker starting on [ImmutableChange(Direction.DOWNLOAD, Action.MODIFY, ino=13356002, name=2015 Employee Vacation and Sick Days.docx, rid=0BxNN8iEiWGvg0TBnV19M2VJ4M2c, parent_ino=529993, modified=1425399279, checksum=57c809766380b53ee0a9b6a9ce36b3c9, size=30058, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False, hash=-1516976679, _constructor_called=True)] 2015-03-24 09:03:14,497 -0400 INFO pid=3143 -1278005248:Worker-2 workers.pyo:188 Worker starting on [ImmutableChange(Direction.DOWNLOAD, Action.CREATE, name=2015 April.docx, route=[CloudEntry(doc_id=0BxNN8iEiWGvgaXhaVzNUdGt6ckU,filename=2015 April.docx,modified=1426849114,created=1426524655,acl_role=owner,doc_type=DocType.BLOB,remove d=False,parent_doc_ids=set([ 1011xNN8iEiWGvgb1FNdGVHdkRvSOU']),child_doc_ids=set([]),size=46178 ,checksum=815488ee4ab4020fbd32dad72eea3012,change_stamp=58268,server_mod_time=1426849729,is_z ombie=False,shared=False,resource_type=file)), rid=0BxNN8iEiWGvgaXhaVzNUdGt6ckU, parent_ino=529993, is_folder=False, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False, hash=-1677849506, _constructor_called=True)] 2015-03-24 09:03:14,500 -0400 INFO pid=3143 -1282207744:Worker-1 docs_client.pyo:2248 Downloading to /var/folders/n1/ypw25pmj06qfyyl_8xnt3kf40000gn/T/tmpL5mPA2 2015-03-24 09:03:14,500 -0400 INFO pid=3143 -1286410240:Worker-0 docs_client.pyo:2248 Downloading to /var/folders/n1/ypw25pmj06qfyyl_8xntakf40000gn/T/tmp2N6G2H 2015-03-24 09:03:14,525 -0400 INFO pid=3143 -1278005248:Worker-2 docs_client.pyo:2248 Downloading to /var/folders/n1/ypw25pmj06qfyyl_8xnt3kf40000gn/T/tmpRmEKIY 2015-03-24 09:03:14,952 -0400 INFO pid=3143 -1278005248:Worker-2 fileutils.pyo:208 Opening /var/folders/n1/ypw25pmj06qfyyl_fixntakf40000gn/T/tmpRmEKIY 2015-03-24 09:03:14,959 -0400 INFO pid=3143 -1286410240:Worker-0 fileutils.pyo:208 Opening /var/folders/n1/ypw25pmj06qfyyl_8xntakf40000gn/T/tmp2N6G2H 2015-03-24 09:03:14,977 -0400 INFO pid=3143 -1278005248:Worker-2 snapshot_scilite.pyo:143 Adding local entry inode=13412546, filename=None 2015-03-24 09:03:14,977 -0400 INFO pid=3143 -1278005248:Worker-2 snapshot_scilite.pyo:171 Adding cloud entry resource_id=file:OBxNN8iEiWGvgaXhaVzNUdGt6ckU, filename=None 2015-03-24 09:03:14,977 -0400 INFO pid=3143 -1278005248:Worker-2 snapshot_scilite.pyo:248 Updating cloud entry doc_id=0BxNN8iEiWGvgaXhaVzNUdGt6ckU, filename=2015 April.docx 2015-03-24 09:03:14,978 -0400 INFO pid=3143 -1278005248:Worker-2 snapshot_scilite.pyo:225 Updating local entry inode=13412546, filename=2015 April.docx, modified=1426849114, checksum=815488ee4ab4020fbd32dad72eea3012, size=46178 2015-03-24 09:03:14,978 -0400 INFO pid=3143 -1278005248:Worker-2 snapshot_scilite.pyo:498 Adding local relation child_inode=13412546, parent_inode=529993 2015-03-24 09:03:14,982 -0400 INFO pid=3143 -1282207744:Worker-1 fileutils.pyo:208 Opening /var/folders/n1/ypw25pmj06qfyyl_8xntakf40000gn/T/tmpL5mPA2 2015-03-24 09:03:14,982 -0400 INFO pid=3143 -1286410240:Worker-0 commands.pyo:56 Updating inode in snapshot. old=13355997, new=13412544 2015-03-24 09:03:14,983 -0400 INFO pid=3143 -1286410240:Worker-0 commands.pyo:59 Entry EFTA00503223 associated with new inode prior to update None: 2015-03-24 09:03:14,983 -0400 INFO pid=3143 -1286410240:Worker-0 snapshot_sqlite.pyo:508 Removing local relation child_inode=13355997, parent_inode=529993 2015-03-24 09:03:15,000 -0400 INFO pid=3143 -1290612736:LocalFSPoller poller.pyo:156 Cloud scan complete. Preparing to start LocalFSPoller 2015-03-24 09:03:15,020 -0400 INFO pid=3143 -1278005248:Worker-2 snapshot_sqlite.pyo:475 Adding cloud relation child_doc_id=0BxNN8iEiWGvgaXhaVzNUdGt6ckU, parent_doc_id=0BxNN8iEiWGvgb1FNdGVHdkRvSOU 2015-03-24 09:03:15,020 -0400 INFO pid=3143 -1278005248:Worker-2 snapshot_sqlite.pyo:518 Adding Mapping inode=13412546, doc_id=0BxNN8iEiWGvgaXhaVzNUdGt6ckU 2015-03-24 09:03:15,057 -0400 INFO pid=3143 -1282207744:Worker-1 commands.pyo:56 Updating inode in snapshot. old=13356002, new=13412545 2015-03-24 09:03:15,057 -0400 INFO pid=3143 -1278005248:Worker-2 workers.pyo:199 Worker successfully completed (ImmutableChange(Direction.DOWNLOAD, Action.CREATE, name=2015 April.docx, route=[CloudEntry(doc_id=0BxNN8iEiWGvgaXhaVzNUdGt6ckUffilename=2015 April.docx,modified=1426849114,created=1426524655,acl_role=owner,doc_type=DocType.BLOB,remove d=False,parent_doc_ids=set([ 10BxNN8iEiWGvgb1FNdGVHdkRvSOUrn,child_doc_ids=set([]),size=46178 ,checksum=815488ee4ab4020fbd32dad72eea3012,change_stamp=58268,server_mod_time=1426849729,is_z ombie=False,shared=False,resource_type=file)), rid=0BxNN8iEiWGvgaXhaVzNUdGt6ckU, parent_ino=529993, is_folder=False, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False, hash=-1677849506, _constructor_called=True)] 2015-03-24 09:03:15,058 -0400 INFO pid=3143 -1278005248:Worker-2 change_buffer.pyo:275 Removing entry from change buffer: ChangeBufferEntry(state=IN_PROGRESS, fschange=ImmutableChange(Direction.DOWNLOAD, Action.CREATE, name=2015 April.docx, route= (CloudEntry(doc_id=0BxNN8iEiWGvgaXhaVzNUdGt6ckU,filename=2015 April.docx,modified=1426849114,created=1426524655,acl_role=owner,doc_type=DocType.BLOB,remove d=False,parent_doc_ids=set([ 10BxNN8iEiWGvgb1FNdGVHdkRvSOU 1)),child_doc_ids=set([1),size=46178 ,checksum=815488ee4ab4020fbd32dad72eea3012,change_stamp=58268,server_mod_time=1426849729,is_z ombie=False,shared=False,resource_type=file)), rid=0B501N8iEiWGvgaXhaVzNUdGt6ckU, parent_ino=529993, is_folder=False, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False, hash=-1677849506, _constructor_called=True), sequence_number=2) 2015-03-24 09:03:15,058 -0400 INFO pid=3143 -1282207744:Worker-1 commands.pyo:59 Entry associated with new inode prior to update None: 2015-03-24 09:03:15,084 -0400 INFO pid=3143 -1282207744:Worker-1 snapshot_sqlite.pyo:508 Removing local relation child_inode=13356002, parent_inode=529993 2015-03-24 09:03:15,085 -0400 INFO pid=3143 -1282207744:Worker-1 snapshot_sqlite.pyo:528 Removing Mapping inode=13356002, doc_id=0BxNN8iEiWGvg0TIMV19M2V34M2c 2015-03-24 09:03:15,085 -0400 INFO pid=3143 -1282207744:Worker-1 snapshot_sqlite.pyo:154 Removing local entry inode=13356002 2015-03-24 09:03:15,086 -0400 INFO pid=3143 -1278005248:Worker-2 workers.pyo:188 Worker starting on [ImmutableChange(Direction.DOWNLOAD, Action.CREATE, name=RussianVisaAppMarch2015.pdf, route= (CloudEntry(doc_id=0BxNN8iEiWGvgbWlnaTJqdWF1bEU,filename=RussianVisaAppMarch2015.pdf,modified =1426797204,created=1426797209,acl_role=owner,doc_type=DocType.BLOB,removed=False,parent_doc_ ids=set([ 10BxNN8iEiWGvgb1FNdGVHdkRvSOU 1)),child_doc_ids=set(()),size=249075,checksum=lf6634e2 48bbfdd53f90a35b51523f29,change_stamp=58250,server_mod_time=1426809930,is_zombie=False,shared =False,resource_type=pdf)], rid=0BxNN8iEiWGvgbWlnaT.ROWF1bEU, parent_ino=529993, is_folder=False, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False, hash=149103828, _constructor_called=True)) 2015-03-24 09:03:15,147 -0400 INFO pid=3143 -1278005248:Worker-2 docs_client.pyo:2248 Downloading to /var/folders/n1/ypw25pmj06qfyyl_8xnt3kf40000gn/T/tmpSKbbfE 2015-03-24 09:03:15,148 -0400 INFO pid=3143 -1282207744:Worker-1 snapshot_sqlite.pyo:143 Adding local entry inode=13412545, filename=None 2015-03-24 09:03:15,148 -0400 INFO pid=3143 -1282207744:Worker-1 snapshot_sqlite.pyo:498 Adding local relation child_inode=13412545, parent_inode=529993 2015-03-24 09:03:15,148 -0400 INFO pid=3143 -1282207744:Worker-1 snapshot_sqlite.pyo:225 Updating local entry inode=13412545, filename=2015 Employee Vacation and Sick Days.docx, modified=1424875359, checksum=5a038efb469002536be5172612b37243, size=29616 2015-03-24 09:03:15,148 -0400 INFO pid=3143 -1282207744:Worker-1 snapshot_sqlite.pyo: 518 Adding Mapping inode=13412545, doc_id=0BxNN8iEiWGvg0TlanV19M2VJ4M2c 2015-03-24 09:03:15,149 -0400 INFO pid=3143 -1282207744:Worker-1 snapshot_sqlite.pyo:225 Updating local entry inode=13412545, modified=1425399279, checksum=57c809766380b53ee0a9b6a9ce36b3c9, size=30058 EFTA00503224 2015-03-24 09:03:15,183 -0400 INFO pid=3143 -1282207744:Worker-1 workers.pyo:199 Worker successfully completed (ImmutableChange(Direction.DOWNLOAD, Action.MODIFY, ino=13356002, name=2015 Employee Vacation and Sick Days.docx, rid=0BxNN8iEiWGvg0TBnV19MZVJ4M2c, parent_ino=529993, modified=1425399279, checksum=57c809766380b53ee0a9b6a9ce36b3c9, size=30058, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False, hash=-1516976679, _constructor_called=True)] 2015-03-24 09:03:15,183 -0400 INFO pid=3143 -1282207744:Worker-1 change_buffer.pyo:275 Removing entry from change buffer: ChangeBufferEntry(state=IN_PROGRESS, fschange=ImmutableChange(Direction.DOWNLOAD, Action.MODIFY, ino=13356002, name=2015 Employee Vacation and Sick Days.docx, rid=0BxNN8iEiWGvg0TBnV19M2VJAM2c, parent_ino=529993, modified=1425399279, checksum=57c809766380b53ee0a9b6a9ce36b3c9, size=30058, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False, hash=-1516976679, _constructor_called=True), sequence_number=1) 2015-03-24 09:03:15,488 -0400 INFO pid=3143 -1273802752:Batcher batcher.pyo:258 There are no blacklisted requests. 2015-03-24 09:03:15 /Volumes/BuildData/pulse- data/agents/wpyt3.hot/recipes/641932625/base/b/drb/googleclient/apps/webdrive_sync/osx/ext/sh ared/ :93 - Pipe path is a symbolic link, connecting to target. 2015-03-24 09:03:15 /Volumes/BuildData/pulse- data/agents/wpyt3.hot/recipes/641932625/base/b/drb/googleclient/apps/webdrive_sync/osx/ext/sh ared/ :93 - /Users/lgroff/Library/Application Support/Google/Drive/GoogleDrivelpcPipe is a symbolic link to /var/folders/nl/ypw25pmj06gfyyl_8xnt3kf40000gn/T/tmp97gnIl, connecting to link target. 2015-03-24 09:03:15,579 -0400 INFO pid=3143 -1278005248:Worker-2 fileutils.pyo:208 Opening /var/folders/n1/ypw25pmj06qfyyl_8xntakf40000gn/T/tmpSKbbfE 2015-03-24 09:03:15,652 -0400 INFO pid=3143 -1278005248:Worker-2 snapshot_sqlite.pyo:143 Adding local entry inode=13412549, filename=None 2015-03-24 09:03:15,789 -0400 INFO pid=3143 -1603214936:MainThread sync_app.pyo:1445 Quit called from: File "/Volumes/BuildData/pulse- data/agents/wpyt3.hot/recipes/641932625/base/b/drb/googleclient/apps/webdrive_sync/osx/dist/G oogle Drive.app/Contents/Resources/ boot .py", line 43, in <module> File "/Volumes/BuildData/pulse- data/agents/wpyt3.hot/recipes/641932625/base/b/drb/googleclient/apps/webdrive_sync/osx/dist/G oogle 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/Appllelper.pyo", line 235, in runEventLoop File "osx/GSyncAppDelegate.pyo", line 371, in applicationWillTerminate_ File "osx/mac_sync_app_controller.pyo", line 310, in Exit File "common/ui_action_handler.pyo", line 457, in Quit File "common/sync_app.pyo", line 1445, in Quit EFTA00503225