EFTA00503788.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-24 15:12:38,721 -0400 INFO pid=612 -1587232344:MainThread thread manager.pyo:77 Stop was called 2015-04-24 15:12:38,721 -0400 WARNING pid=612 -1587232344:MainThread task.pyo:245 DriveXmppTask-0xc211a30 aborting: abort 2015-04-24 15:12:38,721 -0400 INFO pid=612 -1310027776:FeatureSwitchPoller sync_client_thread.pyo:203 FeatureSwitchPoller run loop has terminated. 2015-04-24 15:12:38,722 -0400 INFO pid=612 -1587232344:MainThread task.pyo:257 Task <common.push.push_xmpp_client.DriveXmppTask instance at 0xc211a30> complete. 2015-04-24 15:12:38,722 -0400 INFO pid=612 -1305825280:TelemetryStoreSizeMonitorThread sync_client_thread.pyo:203 TelemetryStoreSizeMonitorThread run loop has terminated. 2015-04-24 15:12:38,722 -0400 INFO pid=612 -1310027776:FeatureSwitchPoller utils.pyo:640 Execute cleanup callback 'persistence_sqlite:ad071bc3fd624be9bfa904224721b0lf/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-04-24 15:12:38,722 -0400 INFO pid=612 -1587232344:MainThread xmpplib.pyo:114 Close called with 'why' reason = Client initiated close 2015-04-24 15:12:38,723 -0400 INFO pid=612 -1310027776:FeatureSwitchPoller sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-04-24 15:12:38,723 -0400 INFO pid=612 -1310027776:FeatureSwitchPoller utils.pyo:640 Execute cleanup callback 'persistence_sqlite:36c74340f0la4e18808d100287872e7d/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2015-04-24 15:12:38,723 -0400 INFO pid=612 -1310027776:FeatureSwitchPoller sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-04-24 15:12:39,447 -0400 INFO pid=612 -1587232344:MainThread task.pyo:257 Task <common.push.push_xmpp_client.DriveXmppTask instance at 0xc211a30> complete. 2015-04-24 15:12:39,447 -0400 INFO pid=612 -1587232344:MainThread xmpplib.pyo:114 Close called with 'why' reason = Client initiated close 2015-04-24 15:12:39,448 -0400 INFO pid=612 -1301622784:XmppClient push_xmpp_client.pyo:137 Exiting run loop 2015-05-05 09:35:18,328 -0400 INFO pid=2679 -1587232344:MainThread logging_config.pyo:249 OS: Darwin/10.9.5 2015-05-05 09:35:18,399 -0400 INFO pid=2679 -1587232344:MainThread logging_config.pyo:252 Google Drive (build 1.20.8672.3137) 2015-05-05 09:35:18,399 -0400 INFO pid=2679 -1587232344:MainThread logging_config.pyo:253 SSL: OpenSSL 0.9.8zd 8 Jan 2015 2015-05-05 09:35:18,422 -0400 INFO pid=2679 -1587232344:MainThread GSyncAppDelegate.pyo:216 Application did finish launching. 2015-05-05 09:35:21,562 -0400 INFO pid=2679 -1336307712:Thread-1 service.pyo:71 Creating user scope service instance of '<class 'common.service.user.User'>' 2015-05-05 09:35:21,562 -0400 INFO pid=2679 -1336307712:Thread-1 service.pyo:71 Creating user scope service instance of '<class 'common.local.roots.RootManager'>' 2015-05-05 09:35:21,562 -0400 INFO pid=2679 -1336307712:Thread-1 service.pyo:71 Creating user scope service instance of '<class 'common.pause_manager.Service'>' 2015-05-05 09:35:21,563 -0400 INFO pid=2679 -1336307712:Thread-1 sync_app.pyo:301 Getting TokenStorage... 2015-05-05 09:35:21,563 -0400 INFO pid=2679 -1336307712:Thread-1 sync_app.pyo:303 Got EFTA00503788 token storage: <token_storage.TokenStorage object at 0x7ee4360> 2015-05-05 09:35:21,563 -0400 INFO pid=2679 -1336307712:Thread-1 service.pyo:71 Creating user scope service instance of '<class 'common.features.AppFeatures'>' 2015-05-05 09:35:21,564 -0400 INFO pid=2679 -1336307712:Thread-1 service.pyo:71 Creating user scope service instance of '<class 'common.cert.Manager'>' 2015-05-05 09:35:21,565 -0400 INFO pid=2679 -1336307712:Thread-1 service.pyo:156 Creating singleton service instance of '<class 'common.sync_http_client.BandwidthThrottler'> 1 2015-05-05 09:35:21,566 -0400 INFO pid=2679 -1336307712:Thread-1 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-05-05 09:35:21,567 -0400 INFO pid=2679 -1336307712:Thread-1 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:21,568 -0400 INFO pid=2679 -1336307712:Thread-1 utils.pyo:663 ADDING persistence_sqlite:c49457a1410a40eb9cccl3ea9edfa216/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-05-05 09:35:21,568 -0400 INFO pid=2679 -1336307712:Thread-1 utils.pyo:663 ADDING persistence_sqlite:578c42c9f8584104bfl0c6c0fbae8cf0/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:22,237 -0400 INFO pid=2679 -1336307712:Thread-1 sync_app.pyo:477 BandwidthThrottler configured via sync_config 2015-05-05 09:35:22,237 -0400 INFO pid=2679 -1336307712:Thread-1 sync_http_client.pyo:91 BandwidthThrottler.SetRxBytesPerSecond 0 2015-05-05 09:35:22,237 -0400 INFO pid=2679 -1336307712:Thread-1 sync_http_client.pyo:100 BandwidthThrottler.SetTxBytesPerSecond 0 2015-05-05 09:35:22,238 -0400 INFO pid=2679 -1336307712:Thread-1 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:22,238 -0400 INFO pid=2679 -1336307712:Thread-1 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-05-05 09:35:22,261 -0400 INFO pid=2679 -1336307712:Thread-1 utils.pyo:640 Execute cleanup callback 'persistence_sqlite:578c42c9f8584104bfl0c6c0fbae8cf0/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2015-05-05 09:35:22,262 -0400 INFO pid=2679 -1336307712:Thread-1 utils.pyo:640 Execute cleanup callback 'persistence_sqlite:c49457a1410a40eb9ccc13ea9edfa216/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-05-05 09:35:22,267 -0400 INFO pid=2679 -1332105216:Thread-2 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-05-05 09:35:22,267 -0400 INFO pid=2679 -1332105216:Thread-2 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:22,268 -0400 INFO pid=2679 -1332105216:Thread-2 utils.pyo:663 ADDING persistence_sqlite:04f6c35117eb440cb2f81f437f82b1d0/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-05-05 09:35:22,268 -0400 INFO pid=2679 -1332105216:Thread-2 utils.pyo:663 ADDING persistence_sqlite:02ea736a929f4lbd86d14cf5138d001c/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:22,268 -0400 INFO pid=2679 -1332105216:Thread-2 feature_switch_manager.pyo:479 Successfully read persisted feature switches. 2015-05-05 09:35:23,476 -0400 INFO pid=2679 -1587232344:MainThread image_resources.py:246 Loading image resources/images/ic_drawer_24.png 2015-05-05 09:35:23,679 -0400 INFO pid=2679 -1587232344:MainThread image_resources.py:246 Loading image resources/images/menu_drive-logo.png 2015-05-05 09:35:23,802 -0400 INFO pid=2679 -1587232344:MainThread image_resources.py:246 Loading image resources/images/menu_google-logo-gray.png 2015-05-05 09:35:23,850 -0400 INFO pid=2679 -1587232344:MainThread image_resources.py:246 Loading image resources/images/ic_folder_mydrive_24.png 2015-05-05 09:35:24,126 -0400 INFO pid=2679 -1587232344:MainThread image_resources.py:246 Loading image resources/images/ic_web_24.png 2015-05-05 09:35:24,169 -0400 INFO pid=2679 -1587232344:MainThread image_resources.py:246 Loading image resources/images/menu_backups.png EFTA00503789 2015-05-05 09:35:24,171 -0400 INFO pid=2679 -1587232344:MainThread image_resources.py:246 Loading image resources/images/ic_sync_problem_24.png 2015-05-05 09:35:24,667 -0400 INFO pid=2679 -1587232344:MainThread image_resources.py:246 Loading image resources/images/ic_done_24.png 2015-05-05 09:35:25,562 -0400 INFO pid=2679 -1587232344:MainThread service.pyo:209 Creating paramed singleton service instance of '<class 'common.file_lock.FileLock'>' 2015-05-05 09:35:25,562 -0400 INFO pid=2679 -1587232344:MainThread service.pyo:209 Creating paramed singleton service instance of '<class 'common.file_lock.FileLock'>' 2015-05-05 09:35:26,544 -0400 INFO pid=2679 -1327902720:ThreadMonitor thread_manager.pyo:259 Waiting on exit condition. Wake up after 3600s. 2015-05-05 09:35:26,544 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-05-05 09:35:26,545 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:26,546 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp utils.pyo:663 ADDING persistence_sqlite:547f945aa69c490f80c5lba2cb409013/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-05-05 09:35:26,546 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp utils.pyo:663 ADDING persistence_sqlite:6af5337e821e43538414a56e631db35d/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:27,043 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp user.pyo:64 Initializing User instance with new credentials. None 2015-05-05 09:35:27,044 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp docs_client_factory.pyo:99 Creating a new Wapi DocsClient 2015-05-05 09:35:27,148 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp service.pyo:71 Creating user scope service instance of '<class 'common.token_bucket.CloudBucketManager'>. 2015-05-05 09:35:30,443 -0400 INFO pid=2679 -1332105216:Thread-2 finder_injector.pyo:426 Local Google Drive path not yet available, skip loading overlays 2015-05-05 09:35:30,445 -0400 INFO pid=2679 -1318965248:Finderlnjector sync_client_thread.pyo:177 Finderlnjector run loop has started. 2015-05-05 09:35:30,445 -0400 INFO pid=2679 -1332105216:Thread-2 utils.pyo:640 Execute cleanup callback 'persistence_sqlite:04f6c35117eb440cb2f81f437f82b1d0/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-05-05 09:35:30,446 -0400 INFO pid=2679 -1332105216:Thread-2 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-05-05 09:35:30,446 -0400 INFO pid=2679 -1332105216:Thread-2 utils.pyo:640 Execute cleanup callback 'persistence_sqlite:02ea736a929f4lbd86d14cf5138d001c/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2015-05-05 09:35:30,446 -0400 INFO pid=2679 -1332105216:Thread-2 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:36,773 -0400 INFO pid=2679 -1323700224: LaunchSyncApp user.pyo:64 Initializing User instance with new credentials. 2015-05-05 09:35:36,773 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp features.pyo:109 Loads feature switches. 2015-05-05 09:35:36,773 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp features.pyo:138 Loading feature switches with server. 2015-05-05 09:35:36,773 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp feature_switch_manager.pyo:551 Calling server to get feature switches. 2015-05-05 09:35:36,774 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp feature_switch_manager.pyo:471 Successfully received feature switches from server. 2015-05-05 09:35:36,775 -0400 INFO pid=2679 -1323700224:_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, EFTA00503790 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=lurl 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 new_presentation_ur1=' new_spreadsheet_ur1=' numworkers=3, only_rooted items in cloud graph=False, open_ur1= 1 (doc_id)', overlays_enabled_finder_versions=['10.6.8 1, '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=' 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_gps=3,) 2015-05-05 09:35:36,775 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp logging_config.pyo:249 OS: Darwin/10.9.5 2015-05-05 09:35:36,826 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp logging_config.pyo:252 Google Drive (build 1.20.8672.3137) 2015-05-05 09:35:36,826 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp logging_config.pyo:253 SSL: OpenSSL 0.9.8zd 8 Jan 2015 2015-05-05 09:35:36,826 -0400 INFO pid=2679 -1323700224:_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([]) Local app blacklist: set([]) EFTA00503791 2015-05-05 09:35:36,829 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp service.pyo:111 Creating user scope service subclass of '<class 'common.push.notifier.Notifier'>' 2015-05-05 09:35:36,829 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp service.pyo:113 Actual service created: <common.push.notifier.PushXMPPNotifier object at 0x8b9c950> 2015-05-05 09:35:37,560 -0400 INFO pid=2679 -1587232344:MainThread service.pyo:71 Creating user scope service instance of '<class 'common.auto_backup.AutoBackup'>' 2015-05-05 09:35:37,560 -0400 INFO pid=2679 -1587232344:MainThread sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-05-05 09:35:37,561 -0400 INFO pid=2679 -1587232344:MainThread sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:37,561 -0400 INFO pid=2679 -1587232344:MainThread sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-05-05 09:35:37,561 -0400 INFO pid=2679 -1587232344:MainThread sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:37,561 -0400 INFO pid=2679 -1587232344:MainThread service.pyo:71 Creating user scope service instance of '<class 'common.telemetry.telemetry_manager.TelemetryManager'> 1 2015-05-05 09:35:41,537 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp image_resources.py:222 Loading custom image resources/images/folder-mac.icns with function _CreateNSImage 2015-05-05 09:35:41,698 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.downloads.DownloadCreate 2015-05-05 09:35:41,698 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.downloads.DownloadModify 2015-05-05 09:35:41,698 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadCreate 2015-05-05 09:35:41,698 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadDelete 2015-05-05 09:35:41,698 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp rulefactory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadModify 2015-05-05 09:35:41,698 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadMove 2015-05-05 09:35:41,698 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadMoveFrom 2015-05-05 09:35:41,698 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp rule_factory.pyo:159 Registering aggregation rule type: common.aggregator_rules.uploads.UploadMoveTo 2015-05-05 09:35:41,700 -0400 INFO pid=2679 -1332105216:FilewatcherMonitor filewatcher.pyo:68 filewatcher ext initialized 2015-05-05 09:35:41,701 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp docs_client_factory.pyo:99 Creating a new Wapi DocsClient 2015-05-05 09:35:41,701 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp docs_client_factory.pyo:99 Creating a new Wapi DocsClient 2015-05-05 09:35:41,702 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp docs_client_factory.pyo:99 Creating a new Wapi DocsClient 2015-05-05 09:35:41,702 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp docs_client_factory.pyo:99 Creating a new Wapi DocsClient 2015-05-05 09:35:41,703 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp docs_client_factory.pyo:99 Creating a new Wapi DocsClient 2015-05-05 09:35:41,703 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp docs_client_factory.pyo:99 Creating a new Wapi DocsClient 2015-05-05 09:35:41,704 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp docs_client_factory.pyo:99 Creating a new Wapi DocsClient 2015-05-05 09:35:41,704 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp service.pyo:280 Remove instance for service '<class 'common.push.notifier.Notifier'>' 2015-05-05 09:35:41,705 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp service.pyo:111 Creating user scope service subclass of '<class 'common.push.notifier.Notifier'>' 2015-05-05 09:35:41,705 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp service.pyo:113 Actual service created: <common.push.notifier.PushXMPPNotifier object at 0x8b9c950> 2015-05-05 09:35:41,705 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp notifier.pyo:167 Configure storage: <common.sync_config_sqlite.SyncConfigSQLite object at 0x8b9cb70> 2015-05-05 09:35:41,725 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp notifier.pyo:213 EFTA00503792 Creating client thread 2015-05-05 09:35:41,725 -0400 INFO pid=2679 -1323700224: LaunchSyncApp push_xmpp_client.pyo:225 Using talk server: 2015-05-05 09:35:41,725 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp notifier.pyo:222 Creating notification bridge 2015-05-05 09:35:41,837 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp docs_client_factory.pyo:99 Creating a new Wapi DocsClient 2015-05-05 09:35:41,839 -0400 INFO pid=2679 -1314762752:TelemetryStoreSizeMonitorThread sync_client_thread.pyo:177 TelemetryStoreSizeMonitorThread run loop has started. 2015-05-05 09:35:41,839 -0400 INFO pid=2679 -1314762752:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo:47 Checking Telemetry store size. 2015-05-05 09:35:41,840 -0400 INFO pid=2679 -1310560256:OverlayStatusCleaner sync_client_thread.pyo:177 OverlayStatusCleaner run loop has started. 2015-05-05 09:35:41,840 -0400 INFO pid=2679 -1306357760:CloudWatcher sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-05-05 09:35:41,841 -0400 INFO pid=2679 -1297952768:PushNotificationKeepaliveThread sync_client_thread.pyo:177 PushNotificationKeepaliveThread run loop has started. 2015-05-05 09:35:41,842 -0400 INFO pid=2679 -1302155264:XmppClient connection_task.pyo:157 Recalculated LoginTask timeout: 16.000000 2015-05-05 09:35:41,842 -0400 INFO pid=2679 -1293750272:Worker-1 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-05-05 09:35:41,843 -0400 INFO pid=2679 -1289547776:LocalWatcher watcher.pyo:317 LocalWatcher Run invoked.Waiting for first pass of local scan from poller to start 2015-05-05 09:35:41,844 -0400 INFO pid=2679 -1285345280:LocalDiskSpaceChecker sync_client_thread.pyo:177 LocalDiskSpaceChecker run loop has started. 2015-05-05 09:35:41,845 -0400 INFO pid=2679 -1306357760:CloudWatcher sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:41,845 -0400 INFO pid=2679 -1276940288:LocalFSPoller sync_client_thread.pyo:177 LocalFSPoller run loop has started. 2015-05-05 09:35:41,850 -0400 INFO pid=2679 -1306357760:CloudWatcher utils.pyo:663 ADDING persistence_sqlite:17f8160a893341e69f97cb6daffbele4/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-05-05 09:35:41,847 -0400 INFO pid=2679 -1293750272:Worker-1 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:41,849 -0400 INFO pid=2679 -1260130304:Batcher sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-05-05 09:35:41,846 -0400 INFO pid=2679 -1272737792:CrashReportUploaderThread crash_report_uploader_thread.pyo:58 Starting CrashReportUploaderThread. 2015-05-05 09:35:41,850 -0400 INFO pid=2679 -1306357760:CloudWatcher utils.pyo:663 ADDING persistence_sqlite:0c303c8447884c58bcac650c0f2cc2d6/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:41,851 -0400 INFO pid=2679 -1255927808:Worker-2 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-05-05 09:35:41,852 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_graph.pyo:118 Initialize persistent graph with generation 2 2015-05-05 09:35:41,852 -0400 INFO pid=2679 -1293750272:Worker-1 utils.pyo:663 ADDING persistence_sqlite:0e738041843a44c980ad6a1b2348a536/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-05-05 09:35:41,852 -0400 INFO pid=2679 -1251725312:Worker-0 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-05-05 09:35:41,853 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_graph.pyo:1507 Current sync config generation: 2 2015-05-05 09:35:41,853 -0400 INFO pid=2679 -1293750272:Worker-1 utils.pyo:663 ADDING persistence_sqlite:7cc358789d174a55b59e796ecad20d80/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:41,853 -0400 INFO pid=2679 -1247522816:RawEventUpgrader sync_client_thread.pyo:177 RawEventUpgrader run loop has started. 2015-05-05 09:35:41,853 -0400 INFO pid=2679 -1243320320:TelemetryUploaderThread EFTA00503793 sync_client_thread.pyo:177 TelemetryUploaderThread run loop has started. 2015-05-05 09:35:41,854 -0400 INFO pid=2679 -1239117824:FeatureSwitchPoller sync_client_thread.pyo:177 FeatureSwitchPoller run loop has started. 2015-05-05 09:35:41,854 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp drive_extension_installer.pyo:174 Uninstalling extension nknebiagdodnminbdpflhpkgfpeijdbf 2015-05-05 09:35:41,854 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_graph.pyo:1364 Cleanup cloud graph directory '/Users/lgroff/Library/Application Support/Google/Drive/user_default/cloud_graph' of files 'dict_*.db" except ['dict_2.db 1 , Idict2.db-shre, 'dict2.db-wal'] 2015-05-05 09:35:41,855 -0400 INFO pid=2679 -1293750272:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.downloads.DownloadChangeACL 2015-05-05 09:35:41,855 -0400 INFO pid=2679 -1239117824:FeatureSwitchPoller features.pyo:138 Loading feature switches with server. 2015-05-05 09:35:41,856 -0400 INFO pid=2679 -1293750272:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.downloads.DownloadCreate 2015-05-05 09:35:42,066 -0400 INFO pid=2679 -1239117824:FeatureSwitchPoller feature_switch_manager.pyo:551 Calling server to get feature switches. 2015-05-05 09:35:42,067 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp utils.pyo:640 Execute cleanup callback 'persistence_sqlite:6af5337e821e43538414a56e631db35d/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2015-05-05 09:35:42,067 -0400 INFO pid=2679 -1260130304:Batcher sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:42,068 -0400 INFO pid=2679 -1251725312:Worker-0 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:42,068 -0400 INFO pid=2679 -1293750272:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.downloads.DownloadDelete 2015-05-05 09:35:42,068 -0400 INFO pid=2679 -1255927808:Worker-2 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:42,070 -0400 INFO pid=2679 -1239117824:FeatureSwitchPoller sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-05-05 09:35:42,070 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:42,071 -0400 INFO pid=2679 -1293750272:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.downloads.DownloadModify 2015-05-05 09:35:42,071 -0400 INFO pid=2679 -1293750272:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.downloads.DownloadMove 2015-05-05 09:35:42,072 -0400 INFO pid=2679 -1260130304:Batcher utils.pyo:663 ADDING persistence_sqlite:lal4b8e8d1034024a2e58cd4d2abe86b/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-05-05 09:35:42,097 -0400 INFO pid=2679 -1260130304:Batcher utils.pyo:663 ADDING persistence_sqlite:969b6abf4c0547c38cdd92653071242c/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:42,072 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp utils.pyo:640 Execute cleanup callback 'persistence_sqlite:547f945aa69c490f80c5lba2cb409013/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-05-05 09:35:42,097 -0400 INFO pid=2679 -1255927808:Worker-2 utils.pyo:663 ADDING persistence_sqlite:0d8f1a8ffflf499297a824cc291a63c2/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-05-05 09:35:42,097 -0400 INFO pid=2679 -1251725312:Worker-0 utils.pyo:663 ADDING persistence_sqlite:98b7f88f840243758a9f7589a5f76ec2/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-05-05 09:35:42,096 -0400 INFO pid=2679 -1293750272:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.downloads.DownloadRename EFTA00503794 2015-05-05 09:35:42,097 -0400 INFO pid=2679 -1323700224:_LaunchSyncApp sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-05-05 09:35:42,098 -0400 INFO pid=2679 -1239117824:FeatureSwitchPoller sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:42,098 -0400 INFO pid=2679 -1255927808:Worker-2 utils.pyo:663 ADDING persistence_sqlite:de480f1a202d49f79a432c42505e81f4/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:42,098 -0400 INFO pid=2679 -1251725312:Worker-0 utils.pyo:663 ADDING persistence_sqlite:lea3ba7f533e441094e2edd3ecdbf082/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:42,100 -0400 INFO pid=2679 -1293750272:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupCreate 2015-05-05 09:35:42,102 -0400 INFO pid=2679 -1255927808:Worker-2 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupCreate 2015-05-05 09:35:42,102 -0400 INFO pid=2679 -1251725312:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupCreate 2015-05-05 09:35:42,102 -0400 INFO pid=2679 -1239117824:FeatureSwitchPoller utils.pyo:663 ADDING persistence_sqlite:50a913c6c84a44a698d0ae8270610e60/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-05-05 09:35:42,103 -0400 INFO pid=2679 -1293750272:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupDelete 2015-05-05 09:35:42,103 -0400 INFO pid=2679 -1255927808:Worker-2 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupDelete 2015-05-05 09:35:42,103 -0400 INFO pid=2679 -1251725312:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupDelete 2015-05-05 09:35:42,103 -0400 INFO pid=2679 -1239117824:FeatureSwitchPoller utils.pyo:663 ADDING persistence_sqlite:d351a254c152414fal0a6b549f832b13/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:42,103 -0400 INFO pid=2679 -1293750272:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupModify 2015-05-05 09:35:42,103 -0400 INFO pid=2679 -1255927808:Worker-2 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupModify 2015-05-05 09:35:42,103 -0400 INFO pid=2679 -1251725312:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupModify 2015-05-05 09:35:42,104 -0400 INFO pid=2679 -1239117824:FeatureSwitchPoller feature_switch_manager.pyo:471 Successfully received feature switches from server. 2015-05-05 09:35:42,104 -0400 INFO pid=2679 -1293750272:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupMove 2015-05-05 09:35:42,118 -0400 INFO pid=2679 -1293750272:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupRename 2015-05-05 09:35:42,117 -0400 INFO pid=2679 -1251725312:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupMove 2015-05-05 09:35:42,104 -0400 INFO pid=2679 -1255927808:Worker-2 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupMove 2015-05-05 09:35:42,118 -0400 INFO pid=2679 -1293750272:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BatchUploadCreate 2015-05-05 09:35:42,119 -0400 INFO pid=2679 -1251725312:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupRename 2015-05-05 09:35:42,119 -0400 INFO pid=2679 -1255927808:Worker-2 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BackupRename 2015-05-05 09:35:42,119 -0400 INFO pid=2679 -1293750272:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadCreate 2015-05-05 09:35:42,119 -0400 INFO pid=2679 -1251725312:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BatchUploadCreate 2015-05-05 09:35:42,119 -0400 INFO pid=2679 -1255927808:Worker-2 command_factory.pyo:190 Registering worker command type: common.worker.uploads.BatchUploadCreate 2015-05-05 09:35:42,119 -0400 INFO pid=2679 -1293750272:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadDelete 2015-05-05 09:35:42,119 -0400 INFO pid=2679 -1251725312:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadCreate EFTA00503795 2015-05-05 09:35:42,120 -0400 INFO pid=2679 -1255927808:Worker-2 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadCreate 2015-05-05 09:35:42,120 -0400 INFO pid=2679 -1293750272:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadModify 2015-05-05 09:35:42,120 -0400 INFO pid=2679 -1251725312:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadDelete 2015-05-05 09:35:42,120 -0400 INFO pid=2679 -1255927808:Worker-2 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadDelete 2015-05-05 09:35:42,120 -0400 INFO pid=2679 -1293750272:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploaciMove 2015-05-05 09:35:42,120 -0400 INFO pid=2679 -1251725312:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadModify 2015-05-05 09:35:42,120 -0400 INFO pid=2679 -1255927808:Worker-2 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadModify 2015-05-05 09:35:42,121 -0400 INFO pid=2679 -1293750272:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadRename 2015-05-05 09:35:42,121 -0400 INFO pid=2679 -1251725312:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploaciMove 2015-05-05 09:35:42,121 -0400 INFO pid=2679 -1255927808:Worker-2 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploaciMove 2015-05-05 09:35:42,121 -0400 INFO pid=2679 -1293750272:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.anternals.InternalCreate 2015-05-05 09:35:42,121 -0400 INFO pid=2679 -1251725312:Worker-0 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadRename 2015-05-05 09:35:42,121 -0400 INFO pid=2679 -1255927808:Worker-2 command_factory.pyo:190 Registering worker command type: common.worker.uploads.UploadRename 2015-05-05 09:35:42,122 -0400 INFO pid=2679 -1293750272:Worker-1 command_factory.pyo:190 Registering worker command type: common.worker.internals.InternalModify 2015-05-05 09:35:42,122 -0400 INFO pid=2679 -1302155264:XmppClient xmpplib.pyo:354 Start SSL peer=64.233.171.125:5222 2015-05-05 09:35:42,172 -0400 INFO pid=2679 -1251725312:Worker-0 workers.pyo:132 Waiting for batcher to initialize 2015-05-05 09:35:42,172 -0400 INFO pid=2679 -1234915328:IpcConnectionThread-/var/folders/n1/ypw25pmj06qfyyl_8xnt3kf40000gn/T/tmpWnYRsB-1 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:42,172 -0400 INFO pid=2679 -1255927808:Worker-2 workers.pyo:132 Waiting for batcher to initialize 2015-05-05 09:35:42,172 -0400 INFO pid=2679 -1293750272:Worker-1 workers.pyo:132 Waiting for batcher to initialize 2015-05-05 09:35:42,173 -0400 INFO pid=2679 -1251725312:Worker-0 sync_client_thread.pyo:177 Worker-0 run loop has started. 2015-05-05 09:35:42,173 -0400 INFO pid=2679 -1255927808:Worker-2 sync_client_thread.pyo:177 Worker-2 run loop has started. 2015-05-05 09:35:42,173 -0400 INFO pid=2679 -1293750272:Worker-1 sync_client_thread.pyo:177 Worker-1 run loop has started. 2015-05-05 09:35:42,174 -0400 INFO pid=2679 -1234915328:IpcConnectionThread-/var/folders/n1/ypw25pmj06qfyyl_8xnt3kf40000gn/T/tmpWnYRsB-1 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:42,228 -0400 INFO pid=2679 -1234915328:IpcConnectionThread-/var/folders/n1/ypw25pmj06qfyyl_8xnt3kf40000gn/T/tmpWnYRsB-1 sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:42,229 -0400 INFO pid=2679 -1234915328:IpcConnectionThread-/var/folders/n1/ypw25pmj06qfyyl_8xnt3kf40000gn/T/tmpWnYRsB-1 sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:42,230 -0400 ERROR pid=2679 -1234915328:IpcConnectionThread-/var/folders/n1/ypw25pmj06qfyyl_8xnt3kf40000gn/T/tmpWnYRsB-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 EFTA00503796  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-05-05 09:35:42,230 -0400 INFO pid=2679 -1234915328:IpcConnectionThread-/var/folders/n1/ypw25pmj06qfyyl_8xnt3kf40000gn/T/tmpWnYRsB-1 server.pyo:198 Closing Ipc socket connection with client. 2015-05-05 09:35:42,282 -0400 INFO pid=2679 -1306357760:CloudWatcher utils.pyo:663 ADDING DBConnectionManagerCleanupCallback 2015-05-05 09:35:42,282 -0400 INFO pid=2679 -1306357760: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-05-05 09:35:42,321 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_graph.pyo:888 Reuse CloudDiskDict database: /Users/lgroff/Library/Application Support/Google/Drive/user_default/cloud_graph/dict_2.db 2015-05-05 09:35:42,406 -0400 INFO pid=2679 -1306357760: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-05-05 09:35:42,406 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_graph.pyo:256 Building gdoc docids cache. 2015-05-05 09:35:42,663 -0400 INFO pid=2679 -1302155264:XmppClient xmpplib.pyo:358 Finish SSL 2015-05-05 09:35:42,822 -0400 INFO pid=2679 -1302155264:XmppClient task.pyo:257 Task <common.push.xmpp.login_task.LoginTask instance at 0xb66b918> complete. 2015-05-05 09:35:42,822 -0400 WARNING pid=2679 -1302155264:XmppClient login_task.pyo:117 Clearing connection for LoginTask: <common.push.xmpp.login_task.LoginTask instance at 0xb66b918> 2015-05-05 09:35:42,823 -0400 INFO pid=2679 -1302155264:XmppClient push_xmpp_client.pyo:304 Connected to 2015-05-05 09:35:42,823 -0400 WARNING pid=2679 -1323700224:Thread-4 notification_bridge.pyo:121 XMPP detected connect. 2015-05-05 09:35:42,823 -0400 INFO pid=2679 -1323700224:Thread-4 xmpp_network_channel.pyo:148 Sending push channel subscription request 2015-05-05 09:35:42,848 -0400 INFO pid=2679 -1302155264:XmppClient xmpp_network_channel.pyo:166 Received subscription response from Push for XMPPBot 2015-05-05 09:35:42,848 -0400 INFO pid=2679 -1323700224:Thread-4 notification_bridge.pyo:137 Starting TICL (client version 3.20130807)... 2015-05-05 09:35:42,849 -0400 INFO pid=2679 -1323700224:Thread-4 xmpp_network_channel.pyo:64 XmppNetworkChannel.InformNetworkStatus: CONNECTED 2015-05-05 09:35:42,887 -0400 INFO pid=2679 -1268535296:ListenerScheduler invalidation_listener.pyo:185 InvalidationListener.ReissueRegistrations(prefix=, prefix_len=0) 2015-05-05 09:35:43,800 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_graph.pyo:171 Reuse CloudDiskDict CloudDiskDict(max_change_stamp=60403, app_version=1.20.8672.3137, only_rooted_items=False, ()) 2015-05-05 09:35:43,800 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_watcher.pyo:797 Performing full snapshot diff. 2015-05-05 09:35:43,801 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_watcher.pyo:986 Getting cloud resources via changelog feed from 60404 2015-05-05 09:35:43,801 -0400 INFO pid=2679 -1306357760:CloudWatcher docs_client.pyo:741 Requesting Doc List: /feeds/default/private/changes?start-index=60404&showroot=true&include- shared=true&reason=startup 2015-05-05 09:35:46,213 -0400 INFO pid=2679 -1281142784:InternalScheduler sqlite.pyo:277 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user default/sync_config.db 2015-05-05 09:35:46,256 -0400 INFO pid=2679 -1281142784:InternalScheduler sqlite.pyo:379 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-05-05 09:35:46,329 -0400 INFO pid=2679 -1297952768:PushNotificationKeepaliveThread push_notification_keepalive_thread.pyo:49 Sent push keepalive message at: Tue May 5 09:35:46 2015 2015-05-05 09:35:46,995 -0400 INFO pid=2679 -1268535296:ListenerScheduler invalidation_listener.pyo:125 InvalidationListener.InformRegistrationStatus(1014:CHANGELOG, EFTA00503797 REGISTERED) 2015-05-05 09:35:46,995 -0400 WARNING pid=2679 -1268535296:ListenerScheduler notification_bridge.pyo:192 Invalidation status callback called with connected=True 2015-05-05 09:35:46,995 -0400 INFO pid=2679 -1268535296:ListenerScheduler pause_manager.pyo:171 Removing pause reasons (OFFLINE) from (). Paused: False 2015-05-05 09:35:47,276 -0400 INFO pid=2679 -1268535296:ListenerScheduler invalidation_listener.pyo:82 InvalidationListener.Invalidation(1014:CHANGELOG, wapi_version=61160) 2015-05-05 09:35:48,431 -0400 INFO pid=2679 -1306357760:CloudWatcher docs_client.pyo:1131 Feed has 12 entries 2015-05-05 09:35:48,432 -0400 INFO pid=2679 -1306357760:CloudWatcher docs_client.pyo:1138 End of feed, no next URI 2015-05-05 09:35:48,441 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_watcher.pyo:766 Got 12 cloud entries 2015-05-05 09:35:48,443 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_watcher.pyo:783 588 nodes in the cloud graph 2015-05-05 09:35:48,479 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud snapshot_diff_helper.pyo:84 Prepare for Pruning graph (total of 588 entries). sync gdocs=True, sync folders=None, excluded folders=frozenset(()) 2015-05-05 09:35:48,479 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_snapshot_diff_helper.pyo:85 Start Prune Graph (total of 588 entries) 2015-05-05 09:35:48,487 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_snapshot_diff_helper.pyo:168 Pruning detected 582 items to keep 2015-05-05 09:35:48,487 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_snapshot_diff_helper.pyo:175 582 entries in graph after pruning 2015-05-05 09:35:48,487 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_snapshot_diff_helper.pyo:93 Compare to snaphost 2015-05-05 09:35:48,488 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_snapshot_diff_helper.pyo:751 Starting cloud graph vs snapshot diff with selective sync set: None 2015-05-05 09:35:48,488 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_snapshot_diff_helper.pyo:753 Prepopulating DOC_ID-to-inodes cache 2015-05-05 09:35:48,612 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_snapshot_diff_helper.pyo:757 First pass detecting moved entries 2015-05-05 09:35:48,690 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_snapshot_diff_helper.pyo:772 Second pass detecting creations and modification entries 2015-05-05 09:35:48,978 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_snapshot_diff_helper.pyo:799 Processed 581 entries in total. Number of events detected: (_FSChangeActionType(Action.MODIFY): 6, _FSChangeActionType(Action.CREATE): 3} 2015-05-05 09:35:49,027 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_watcher.pyo:840 Done with full snapshot diff. 2015-05-05 09:35:49,027 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_watcher.pyo:896 CloudWatcher generated 9 events 2015-05-05 09:35:49,027 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_watcher.pyo:902 CloudWatcher generated FSChange(Direction.DOWNLOAD, Action.CREATE, name=The Notebook of Doom Book Report.docx, route=(CloudEntry(doc_id=0BxNN8iEiWGvgMU9oVFdXdUl3W1E,filename=The Notebook of Doom Book Report.docx,modified=1430487533,created=1430267565,acl_role=owner,doc_type=DocType.BLOB,remov ed=False,parent_doc_ids=setWOBxNN8iEiWGvgb1FNdGVHdkRvSOU'D,child_doc_ids=set([]),size=8426 9,checksum=1c30a311bca9dfae3d45276abb1636a0,change_stamp=60881,server_mod_time=None,is_zombie =False,shared=False r resource_type=file,version=None)), rid=011xNN8iEiWGvgMU9oVFdXdUl3W1E, parent_ino=529993, is_folder=False, size=84269, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False, doc_type=DocType.BLOB) 2015-05-05 09:35:49,028 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_watcher.pyo:902 CloudWatcher generated FSChange(Direction.DOWNLOAD, Action.MODIFY, ino=13540346, name=2015 Girls May Calendar.docx, rid=0BxNN8iEiWGvgRjFSLWozSkx4bzQ, parent_ino=529993, is_folder=False, modified=1430593763, checksum=6de973bldee8bf49be5497b86d6ed625, size=40276, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False, doc_type=DocType.BLOB) 2015-05-05 09:35:49,028 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_watcher.pyo:902 CloudWatcher generated FSChange(Direction.DOWNLOAD, Action.CREATE, name=JuliaStepPassport.JPG, route= (CloudEntry(doc_id=011xNN8iEiWGvgLTdfRF9xVzBydHM,filename=JuliaStepPassport.JPG,modified=14304 20715,created=1430420720,acl_role=owner,doc_type=DocType.BLOB,removed=False,parent_doc_ids=se t(( 1011xNN8iEiWGvgb1FNdGVHdkRvSOU'll,child_doc_ids=set([)),size=388528,checksum=2ad256a10711d7 EFTA00503798 llbdb57f0ba3fbecf8,change_stamp=60847,server_mod_time=None,is_zombie=False r shared=False,resou rce_type=file,version=None)], rid=OBxNN8iEiWGvgLTdfRF9xVzBydHM, parent_ino=529993, is_folder=False, size=388528, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False, doc_type=DocType.BLOB) 2015-05-05 09:35:49,029 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_watcher.pyo:902 CloudWatcher generated FSChange(Direction.DOWNLOAD, Action.MODIFY, ino=13509397, name=2015 Day Count for Jeffrey.docx, rid=0BxNN8iEiWGvgMX1UcUF2a32.jR2s, parent_ino=529993, is_folder=False, modified=1430402871, checksum=fce91f163elbelbfeeea58aaeac8bd7f, size=37136, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False, doc_type=DocType.BLOB) 2015-05-05 09:35:49,029 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_watcher.pyo:902 CloudWatcher generated FSChange(Direction.DOWNLOAD, Action.MODIFY, ino=13540354, name=2015 Girls April.docx, rid=0BxNN8iEiWGvg0WE3bE8zdTJiR00, parent_ino=529993, is_folder=False, modified=1430236633, checksum=270c9b02d0802ea37c1ed0fa70587746, size=84384, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False, doc_type=DocType.BLOB) 2015-05-05 09:35:49,029 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_watcher.pyo:902 CloudWatcher generated FSChange(Direction.DOWNLOAD, Action.MODIFY, ino=13635503, name=2015 April.docx, rid=0BxNN8iEiWGvgaXhaVzNUdGt6ckU, parent_ino=529993, is_folder=False, modified=1430411115, checksum=15a575a2604f3b1a3b3e6b581ef4fle4, size=112701, backup=Backup.NO_BACKUP_CONTENT, is_cancelled=False, is_priority=False, doc_type=DocType.BLOB) 2015-05-05 09:35:49,029 -0400 INFO pid=2679 -1306357760:CloudWatcher cloud_watcher.pyo:902 CloudWatcher generated FSChange(Direction.DOWNLOAD, Action.MODIFY, ino=13540348, name=2015 May.docx, rid=011xNN8iEiWGvgWEFSZylucFMOLUk, parent_ino=529993, is_folder=False, modified=1430817766, checksum=510f994e3ab7bf7ccc36a60e398e4b7a, size=87643, backup=Backup.NO_BACKU