EFTA00502434.pdf

From: File "Nolumes/BuildData/pulse- datathgents/599758/recipes/859788647/base/b/drb/googleclient/apps/webdrive_sync/osxklist/Google Drive.app/Contents/ftesources/_boot_.py", line 77, in <module> File "Nolumes/BuildData/pulse- datathgents/599758/recipes/859788647/base/b/drb/googleclient/apps/webdrive_sync/osxklist/Google Drive.app/Contents/ftesources/_boot_.py", line 62, in _run File "/Applications/Google Drive.app/Contents/Resourceslmain.py", line 12, in <module> File "osx/run_googledrive.pyo", line 31, in Main File "PyObjCTools/AppHelper.pyo", line 235, in runEventLoop File "osx/GSyncAppDelegate.pyo", line 297, in applicationWillTerminate_ File "osx/mac_sync_app_controller.pyo", line 252, in Exit File "common/ui_action_handler.pyo", line 450, in Quit File "common/sync_app.pyo", line 1643, in Quit 2015-12-14 16:58:01,207 -0500 INFO pid=4958 140735235863312:MainThread thread_manager.pyo:114 Stop was called 2015-12-14 16:58:01,207 -0500 INFO pid=4958 140735235863312:MainThread thread_manager.pyo:250 Asking <FeatureSwitchPoller(FeatureSwitchPoller, started 4625682432)> to stop. 2015-12-14 16:58:01,364 -0500 INFO pid=4958 140735235863312:MainThread thread_manager.pyo:250 Asking <LocalFSPoller(LocalFSPoller, started 4604649472)> to stop. 2015-12-14 16:58:01,364 -0500 INFO pid=4958 4625682432:FeatureSwitchPoller sync_client_thread.pyo:209 FeatureSwitchPoller run loop has terminated. 2015-12-14 16:58:01,365 -0500 INFO pid=4958 140735235863312:MainThread thread_manager.pyo:250 Asking <PushXmppClient(XmppClient, started 4583616512)> to stop. 2015-12-14 16:58:01,365 -0500 INFO pid=4958 4604649472:LocalFSPoller sync_client_thread.pyo:209 LocalFSPoller run loop has terminated. 2015-12-14 16:58:01,365 -0500 WARNING pid=4958 140735235863312:MainThread task.pyo:242 DriveXmppTask-0x11004ac90 aborting: abort 2015-12-14 16:58:01,366 -0500 INFO pid=4958 140735235863312:MainThread task.pyo:254 Task <common.push.push_xmpp_client.DriveXmppTask object at 0x11004ac90> complete. 2015-12-14 16:58:01,366 -0500 INFO pid=4958 140735235863312:MainThread xmpplib.pyo:143 Close called with 'why' reason = Client initiated close 2015-12-15 09:12:25,768 -0500 INFO pid=9827 140735235863312:MainThread logging_config.pyo:249 OS: Darwin/10.9.5 2015-12-15 09:12:25,903 -0500 INFO pid=9827 140735235863312:MainThread logging_config.pyo:252 Google Drive (build 1.26.0707.2863) 2015-12-15 09:12:25,904 -0500 INFO pid=9827 140735235863312:MainThread logging_config.pyo:253 SSL: OpenSSL 0.9.8zg 14 July 2015 2015-12-15 09:12:25,981 -0500 INFO pid=9827 140735235863312:MainThread GSyncAppDelegate.pyo:198 Application did finish launching. 2015-12-15 09:12:28,584 -0500 INFO pid=9827 140735235863312:MainThread service.pyo:132 Creating singleton service instance of '<class 'common.file_lock.FileLocki> 1 2015-12-15 09:12:28,585 -0500 INFO pid=9827 140735235863312:MainThread service.pyo:132 Creating singleton service instance of '<class 'common.file_lock.FileLock'>' 2015-12-15 09:12:28,586 -0500 INFO pid=9827 4523966464:RunAsync-_InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.service.user.User'>' 2015-12-15 09:12:28,586 -0500 INFO pid=9827 4523966464:RunAsync-_InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common. roots. roots. RootManager'>' 2015-12-15 09:12:28,586 -0500 INFO pid=9827 4523966464:RunAsync-_InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.thread_manager.ThreadManager'> 1 2015-12-15 09:12:28,587 -0500 INFO pid=9827 4523966464:RunAsync-_InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.pause_manager.Service'>' 2015-12-15 09:12:28,587 -0500 INFO pid=9827 4523966464:RunAsync-_InitializeSyncAppAsync-1 sync_app.pyo:330 Getting TokenStorage... 2015-12-15 09:12:28,587 -0500 INFO pid=9827 4523966464:RunAsync-_InitializeSyncAppAsync-1 sync_app.pyo:332 Got token storage: <token_storage.TokenStorage object at 0x10911bed0> 2015-12-15 09:12:28,587 -0500 INFO pid=9827 4523966464:RunAsync-_InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.features.AppFeatures'>' EFTA00502434 2015-12-15 09:12:28,588 -0500 INFO pid=9827 4523966464:RunAsync-_InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.cert.Manager'>' 2015-12-15 09:12:28,762 -0500 INFO pid=9827 4523966464:RunAsync-_InitializeSyncAppAsync-1 service.pyo:132 Creating singleton service instance of '<class 'common.net.bandwidth.BandwidthThrottler'> 1 2015-12-15 09:12:28,862 -0500 INFO pid=9827 4523966464:RunAsync-_InitializeSyncAppAsync-1 sqlite.pyo:276 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-12-15 09:12:28,863 -0500 INFO pid=9827 4523966464:RunAsync-_InitializeSyncAppAsync-1 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-12-15 09:12:28,864 -0500 INFO pid=9827 4523966464:RunAsync-_InitializeSyncAppAsync-1 utils.pyo:737 AddCleanupCallback persistence_sqlite:d20c60df9e7d4353ba31d8c33cf2e7d1/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-12-15 09:12:28,864 -0500 INFO pid=9827 4523966464:RunAsync-_InitializeSyncAppAsync-1 utils.pyo:737 AddCleanupCallback persistence_sqlite:71a15bb5a17343ca81f292ed5c2909cc/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-12-15 09:12:29,096 -0500 INFO pid=9827 4523966464:RunAsync-_InitializeSyncAppAsync-1 sync_app.pyo:506 BandwidthThrottler configured via sync_config 2015-12-15 09:12:29,096 -0500 INFO pid=9827 4523966464:RunAsync-_InitializeSyncAppAsync-1 bandwidth.pyo: 59 BandwidthThrottler.SetRxBytesPerSecond 0 2015-12-15 09:12:29,096 -0500 INFO pid=9827 4523966464:RunAsync-_InitializeSyncAppAsync-1 bandwidth.pyo: 68 BandwidthThrottler.SetTxBytesPerSecond 0 2015-12-15 09:12:29,097 -0500 INFO pid=9827 4523966464:RunAsync-_InitializeSyncAppAsync-1 sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-12-15 09:12:29,097 -0500 INFO pid=9827 4523966464:RunAsync-_InitializeSyncAppAsync-1 sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-12-15 09:12:29,111 -0500 INFO pid=9827 4523966464:RunAsync-_InitializeSyncAppAsync-1 utils.pyo:714 Execute cleanup callback 'persistence_sqlite:71a15bb5a17343ca81f292ed5c2909cc/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2015-12-15 09:12:29,147 -0500 INFO pid=9827 4523966464:RunAsync-_InitializeSyncAppAsync-1 utils.pyo:714 Execute cleanup callback 'persistence_sqlite:d20c60df9e7d4353ba31d8c33cf2e7d1/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-12-15 09:12:29,149 -0500 INFO pid=9827 4532641792:Finderlnjector sync_client_thread.pyo:175 Finderlnjector run loop has started. 2015-12-15 09:12:29,571 -0500 INFO pid=9827 140735235863312:MainThread image_resources.py:292 Loading image resources/images/ic_drawer_24.png 2015-12-15 09:12:29,665 -0500 INFO pid=9827 140735235863312:MainThread image_resources.py:292 Loading image resources/images/menu_drive-logo.png 2015-12-15 09:12:29,768 -0500 INFO pid=9827 140735235863312:MainThread image_resources.py:292 Loading image resources/images/menu_google-logo-gray.png 2015-12-15 09:12:30,028 -0500 INFO pid=9827 140735235863312:MainThread image_resources.py:292 Loading image resources/images/ic_folder_mydrive_24.png 2015-12-15 09:12:30,101 -0500 INFO pid=9827 140735235863312:MainThread image_resources.py:292 Loading image resources/images/ic_web_24.png 2015-12-15 09:12:30,103 -0500 INFO pid=9827 140735235863312:MainThread image_resources.py:292 Loading image resources/images/ic_sync_problem_24.png 2015-12-15 09:12:30,197 -0500 INFO pid=9827 140735235863312:MainThread image_resources.py:292 Loading image resources/images/ic_done.png 2015-12-15 09:12:32,259 -0500 INFO pid=9827 4546482176:ThreadMonitor thread_manager.pyo:336 Waiting on exit condition. Wake up after 3600s. 2015-12-15 09:12:32,260 -0500 INFO pid=9827 4550688768:_LaunchSyncApp sqlite.pyo:276 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-12-15 09:12:32,261 -0500 INFO pid=9827 4550688768:_LaunchSyncApp sqlite.pyo:276 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-12-15 09:12:32,262 -0500 INFO pid=9827 4550688768:_LaunchSyncApp utils.pyo:737 AddCleanupCallback EFTA00502435 persistence_sqlite:b353daa25a35408da88778fde433699a/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-12-15 09:12:32,262 -0500 INFO pid=9827 4550688768:_LaunchSyncApp utils.pyo:737 AddCleanupCallback persistence_sqlite:c1032e50de6c460f9e59d26flbdd6934/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-12-15 09:12:32,285 -0500 INFO pid=9827 4550688768:_LaunchSyncApp user.pyo:66 Initializing User instance with new credentials. None 2015-12-15 09:12:32,286 -0500 INFO pid=9827 4550688768:_LaunchSyncApp docs_client_factory.pyo:89 Creating a new DriveClient 2015-12-15 09:12:32,286 -0500 INFO pid=9827 4550688768: LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.quota.Quotalnfo'>' 2015-12-15 09:12:32,287 -0500 INFO pid=9827 4550688768:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class tcommon.token_bucket.CloudlaucketManagerJ> 1 2015-12-15 09:12:32,288 -0500 INFO pid=9827 140735235863312:MainThread sqlite.pyo:276 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-12-15 09:12:32,288 -0500 INFO pid=9827 4550688768:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive_api.drive_resource.Manager'>' 2015-12-15 09:12:32,288 -0500 INFO pid=9827 4550688768:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive_api.http.Manager'>' 2015-12-15 09:12:32,289 -0500 INFO pid=9827 4550688768:_LaunchSyncApp drive_resource.pyo:130 Initialize apiclient Drive resource for current user token 2015-12-15 09:12:32,289 -0500 INFO pid=9827 140735235863312:MainThread sqlite.pyo:276 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-12-15 09:12:32,290 -0500 INFO pid=9827 140735235863312:MainThread sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-12-15 09:12:32,290 -0500 INFO pid=9827 140735235863312:MainThread sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-12-15 09:12:32,325 -0500 ERROR pid=9827 4542275584:IpcServerThread ipc_socket_base.pyo:249 Failed to bind to socket /private/var/folders/n1/ypw25pmj06qfyyl_8xntakf40000gn/T/tmpcnVAnj (attempt 1 of 3) Traceback (most recent call last): File "common/ipc/ipc_socket_base.pyo", line 242, in Bind File "common/ipc/ipc_socket_base.pyo", line 176, in Bind File "socket.pyo", line 228, in meth error: [Erma 48] Address already in use 2015-12-15 09:12:32,326 -0500 ERROR pid=9827 4542275584:IpcServerThread ipc_socket_base.pyo:249 Failed to bind to socket /private/var/folders/n1/ypw25pmj06qfyyl_8xntakf40000gn/T/tmpcnVAnj (attempt 2 of 3) Traceback (most recent call last): File "common/ipc/ipc_socket_base.pyo", line 242, in Bind File "common/ipc/ipc_socket_base.pyo", line 176, in Bind File "socket.pyo", line 228, in meth error: [Erma 48] Address already in use 2015-12-15 09:12:32,326 -0500 WARNING pid=9827 4542275584:IpcServerThread server.pyo:145 Socket (/Users/lgroff/Library/Application Support/Google/Drive/GoogleDrivelpcPipe) already in use, deleting it. 2015-12-15 09:12:32,398 -0500 INFO pid=9827 4550688768: LaunchSyncApp drive_resource.pyo:178 Drive SDK baseUrl = https://www.googleapis.com/drive/v2internal/ 2015-12-15 09:12:32,400 -0500 INFO pid=9827 4550688768:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive_api.http.AccessTokenInMemoryCache'>. 2015-12-15 09:12:32,400 -0500 INFO pid=9827 4550688768:_LaunchSyncApp drive_request.pyo:285 Drive request: About(tags=Reason.SYNC_OTHER) - Read request - None 2015-12-15 09:12:32,402 -0500 INFO pid=9827 4550688768:_LaunchSyncApp discovery.pyo:762 URL being requested: GET https://www.googleapis.com/drive/v2internal/about? fields=rootFolderld%2CquotaBytesTotal%2CquotaBytesUsedAggregate%2CquotaBytesUsedInTrash%2Cquo taType%2Cuser%2FemailAddress&reason=304Salt=json 2015-12-15 09:12:32,467 -0500 INFO pid=9827 4550688768:_LaunchSyncApp client.pyo:515 Attempting refresh to obtain initial access_token 2015-12-15 09:12:32,467 -0500 INFO pid=9827 4550688768:_LaunchSyncApp client.pyo:755 EFTA00502436 Refreshing access_token 2015-12-15 09:12:32,470 -0500 INFO pid=9827 4550688768:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.net.dapper.DapperService'>' 2015-12-15 09:12:32,470 -0500 INFO pid=9827 4550688768:_LaunchSyncApp http.pyo:248 Request user-agent: Python-httplib2/0.9 (gzip) 2015-12-15 09:12:32,859 -0500 INFO pid=9827 4550688768:_LaunchSyncApp sync_http_client.pyo:236 Opening direct connecton to accounts.google.com:443. 2015-12-15 09:12:33,011 -0500 INFO pid=9827 4550688768:_LaunchSyncApp http.pyo:267 Response: 151 bytes - application/json; charset=utf-8 (encoding:gzip) 2015-12-15 09:12:33,012 -0500 INFO pid=9827 4550688768:_LaunchSyncApp http.pyo:248 Request user-agent: googledrivesync-1.26.0707.2863 google-api-python-client/1.3.1 (gzip) (Darwin/10.9.5) 2015-12-15 09:12:33,012 -0500 INFO pid=9827 4550688768:_LaunchSyncApp sync_http_client.pyo:236 Opening direct connecton to www.googleapis.com:443. 2015-12-15 09:12:33,796 -0500 INFO pid=9827 4550688768:_LaunchSyncApp http.pyo:267 Response: 241 bytes - application/json; charset=UTF-8 (encoding:gzip) 2015-12-15 09:12:33,835 -0500 INFO pid=9827 4550688768:_LaunchSyncApp drive_request.pyo:292 Drive response: Request (None): About(tags=Reason.SYNC_OTHER) Response: About(root_id=OABNN8iEiWGvgUk9PVA, email_address=lesley.jee@gmail.com, quota_bytes_total=16106127360, quota_bytes_used_aggregate=15230097005, quota_bytes_used_in_trash=405074503, quota_type=LIMITED) 2015-12-15 09:12:33,836 -0500 INFO pid=9827 4550688768:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.drive_api.doc_id_provider.Store'>' 2015-12-15 09:12:33,836 -0500 INFO pid=9827 4550688768:_LaunchSyncApp user.pyo:66 Initializing User instance with new credentials. lesley.jee@gmail.com 2015-12-15 09:12:33,836 -0500 INFO pid=9827 4550688768:_LaunchSyncApp sync_app.pyo:1235 Configuring sync app from feature switches. 2015-12-15 09:12:33,836 -0500 INFO pid=9827 4550688768:_LaunchSyncApp features.pyo:112 Loads feature switches. 2015-12-15 09:12:33,837 -0500 INFO pid=9827 4550688768:_LaunchSyncApp feature_switch_manager.pyo:644 Calling server to get feature switches. 2015-12-15 09:12:33,837 -0500 INFO pid=9827 4550688768:_LaunchSyncApp drive_request.pyo:285 Drive request: ListFeatureSwitches(tags=Reason.SYNC_OTHER) - Read request - lesley.jee@gmail.com 2015-12-15 09:12:33,839 -0500 INFO pid=9827 4550688768:_LaunchSyncApp discovery.pyo:762 URL being requested: GET https://www.googleapis.com/drive/v2internal/settings? fields=items%2Fkey%2Citems%2Fvalue&reason=304&namespace=FEATURE_SWITCH&alt=json 2015-12-15 09:12:33,839 -0500 INFO pid=9827 4550688768:_LaunchSyncApp http.pyo:248 Request user-agent: googledrivesync-1.26.0707.2863 google-api-python-client/1.3.1 (gzip) (Darwin/10.9.5) 2015-12-15 09:12:33,893 -0500 INFO pid=9827 4550688768:_LaunchSyncApp http.pyo:267 Response: 1434 bytes - application/json; charset=UTF-8 (encoding:gzip) 2015-12-15 09:12:33,966 -0500 INFO pid=9827 4550688768:_LaunchSyncApp drive_request.pyo:292 Drive response: Request (lesley.jee@gmail.com): ListFeatureSwitches(tags=Reason.SYNC_OTHER) Response: (u'enable_impressions_library': u'false', u'selective_sub_folder_sync.: u'false., u'crash_throttle_percentage': u'99.7', u'enable_feedback': u'true', u'enable_usb_detection': u'false', u'max_page_size_selective_sync': u'1000 1, u'enable_shared_move_confirmation': u'false', u'enable_disk_check_on_preferences': u'false., u'enable_recursive_size': u'false', u'enable_push': u'true', u'enable_sync_options_in_setup_flow': u'false', u'enable_multipause': u'true', u'log_backup_count': u'0', u'enable_arbitrary_sync': u'false', u'enable_disk_check_on_setup': u'false', u'maxbatch_upload_files': u'30', u'cloud_graph_disk_generation': u'2', u'use_drive_api': u'false', u'query_strategy': u'all', u'enable_multipleaccounts': u'false', u'perf_throttle_percentage': u'100', u'test.feature_switch.name': u") 2015-12-15 09:12:33,968 -0500 INFO pid=9827 4550688768:_LaunchSyncApp sync_app.pyo:1260 Feature Switches: FeatureSwitchSettings( accept_blob_download_gzip_encoding=True, backup_polling_interval_secs=7200, EFTA00502437 change_filters=[ 1 DRIVE_SYNC 1], cloud_graph_disk_generation=2, crash_log_size_limit=10000000, crash_throttle_percentage=99.7, disabled_cloud_graph_disk_app_versions=[], docs_list_page_size=1000, download_in_place=False, download_progress_bar=False, download_strategy=turl_template', download_url=thttps://googledrive.com/p/host/(doc_id)', enable_arbitrary_sync=False, enable_batch_upload=True, enable_change_filters=False, enable_context_menu=True, enable_dapper_trace=False, enable_disk_dict=False, enable_feedback=True, enable_file_sync_status=True, enable_impressions_library=False, enable_local_v2=False, enable_multipause=True, enable_multiple_accounts=False, enable_native_opener=True, enable_push=True, enable_recursivesize=False, enable_shared_move_confirmation=False, enable_usb_detection=False, feedback_type='prod', ghost_all_files=False, help_ur1=1 https://support.google.com/drive/?h1=%ssp=desktop_homel, impressions_heartbeat_interval_secs=10800, impressions_upload_interval_secs=1800, log_backup_count=0, log_size_mb=256, logging_level='info', max_batch_upload_files=30, new document url='https://docs.google.com/document?usp=drive_sync', new_presentation_ur1='https://docs.google.com/presentation?usp=drive_sync'„ new_spreadsheet_ur1='https://docs.google.com/spreadsheets?usp=drive_synci, numworkers=3, open_ur1='https://docs.google.com/open?id=fdoc_id)', overlays_enabled_finder_versions=[.10.7 1, '10.7.1', '10.7.2', '10.7.3', '10.7.5', '10.8', '10.8.1', '10.8.2', '10.8.3', '10.9', '10.9.1', '10.9.2', '10.9.3', '10.9.4'], perf_throttle_percentage=100.0, push_clientversion=1, push_keepalive_interval=72000.0, query_strategy=u'all', regular_polling_interval_secs=30, selective_sub_folder_sync=False, share_template_url=lhttps://drive.google.com/sharing/share? subapp=10&shareProtocolVersion=2&theme=2&command=settings&shareUiType=default&authuser=0&clie nt=desktop', show_confirmation_dialog_on_delete=True, telemetry_enabled=True, telemetry_upload_interval_secs=1800, telemetry_ur1='https://drive.google.com/syncclient_impressions', token_bucket_read_qps=10, token_bucketwrite_gps=3, use_drive_api=False,) 2015-12-15 09:12:34,067 -0500 INFO pid=9827 4550688768:_LaunchSyncApp logging_config.pyo:249 OS: Darwin/10.9.5 2015-12-15 09:12:34,193 -0500 INFO pid=9827 4550688768:_LaunchSyncApp logging_config.pyo:252 Google Drive (build 1.26.0707.2863) 2015-12-15 09:12:34,193 -0500 INFO pid=9827 4550688768:_LaunchSyncApp logging_config.pyo:253 SSL: OpenSSL 0.9.8zg 14 July 2015 EFTA00502438 2015-12-15 09:12:34,193 -0500 INFO pid=9827 4550688768:_LaunchSyncApp Config: Email: lesley.jee@gmail.com Sync root: /Users/lgroff/Google Drive Sync collections: set([]) Upgrade number: 22 App version: 1.26.0707.2863 Selective sync: False Cloud Graph generation: 2 Folder sync: [] Local app whitelist: set([]) Local app blacklist: set([]) Bandwidth RX Rate kpBs: 0 Bandwidth TX Rate kpBs: 0 Yosemite icons upgraded: False Win10 icons upgraded: False USB sync enabled: True Do sync default folder: True 2015-12-15 09:12:34,195 -0500 INFO pid=9827 4550688768:_LaunchSyncApp Switching cloud client based on new feature switches 2015-12-15 09:12:34,196 -0500 INFO pid=9827 4550688768:_LaunchSyncApp docs_client_factory.pyo:97 Creating a new Wapi DocsClient 2015-12-15 09:12:34,196 -0500 INFO pid=9827 4550688768:_LaunchSyncApp SetPushClientVersion: 1 (3, 20130807) 2015-12-15 09:12:34,197 -0500 INFO pid=9827 4550688768:_LaunchSyncApp Creating singleton service instance of '<class 'common.push.telemetry. 2015-12-15 09:12:34,197 -0500 INFO pid=9827 4550688768:_LaunchSyncApp Creating singleton service instance of '<class 'common.telemetry.telemetry_manager.TelemetryManager'>' 2015-12-15 09:12:34,835 -0500 INFO pid=9827 4550688768:_LaunchSyncApp image_resources.py:268 Loading custom image resources/images/folder-mac.icns with function _CreateNSlmage 2015-12-15 09:12:34,837 -0500 INFO pid=9827 4550688768:_LaunchSyncApp service.pyo:132 Creating singleton service instance of '<class 'common.roots.root_wrangler.RootWrangler'>. 2015-12-15 09:12:34,837 -0500 INFO pid=9827 4550688768:_LaunchSyncApp root_wrangler.pyo:65 RootWrangler.RootObserverRegistered with roots [_MyDriveRoot(u'/Users/lgroff/Google Drive', 'root', <RootState.INITED: 2>)] 2015-12-15 09:12:35,742 -0500 INFO pid=9827 4550688768:_LaunchSyncApp root_wrangler.pyo:73 RootWrangler.RootsAdded with roots (_MyDriveRoot(u'/Users/lgroff/Google Drive', 'root', <RootState.INITED: 2>)] 2015-12-15 09:12:35,742 RootWrangler got inited <RootState. 2015-12-15 Registering 2015-12-15 Registering 2015-12-15 Registering 2015-12-15 Registering 2015-12-15 Registering 2015-12-15 Registering 2015-12-15 Registering 2015-12-15 Registering 2015-12-15 filewatcher_ext initialized 2015-12-15 09:12:36,449 -0500 INFO pid=9827 4550688768:_LaunchSyncApp docs_client_factory.pyo:97 Creating a new Wapi DocsClient 2015-12-15 09:12:36,451 -0500 INFO pid=9827 4550688768:_LaunchSyncApp docs_client_factory.pyo:97 Creating a new Wapi DocsClient 2015-12-15 09:12:36,452 -0500 INFO pid=9827 4550688768:_LaunchSyncApp INITED: 2>) 09:12:35,743 aggregation 09:12:35,743 aggregation 09:12:35,743 aggregation 09:12:35,743 aggregation 09:12:35,743 aggregation 09:12:35,743 aggregation 09:12:35,744 aggregation 09:12:35,744 aggregation 09:12:36,448 sync_app.pyo:1269 sync_app.pyo:1274 telemetry.pyo: 228 service.pyo: 132 PushTelemetry'>' service.pyo:132 -0500 INFO pid=9827 4550688768:_LaunchSyncApp root_wrangler.pyo:79 root _MyDriveRoot(u'/Users/lgroff/Google Drive', 'root', -0500 INFO rule type: -0500 INFO rule type: -0500 INFO rule type: -0500 INFO rule type: -0500 INFO rule type: -0500 INFO rule type: -0500 INFO rule type: -0500 INFO rule type: -0500 INFO pid=9827 4550688768:_LaunchSyncApp rule_factory.pyo:159 common.aggregator_rules.downloads.DownloadCreate pid=9827 4550688768:_LaunchSyncApp rule_factory.pyo:159 common.aggregator_rules.downloads.DownloadModify pid=9827 4550688768:_LaunchSyncApp rule_factory.pyo:159 common.aggregator_rules.uploads.UploadCreate pid=9827 4550688768:_LaunchSyncApp rule_factory.pyo:159 common.aggregator_rules.uploads.UploadDelete pid=9827 4550688768:_LaunchSyncApp rule_factory.pyo:159 common.aggregator_rules.uploads.UploadModify pid=9827 4550688768:_LaunchSyncApp rule_factory.pyo:159 common.aggregator_rules.uploads.UploadMove pid=9827 4550688768:_LaunchSyncApp rule_factory.pyo:159 common.aggregator_rules.uploads.UploadMoveFrom pid=9827 4550688768:_LaunchSyncApp rule_factory.pyo:159 common.aggregator_rules.uploads.UploadMoveTo pid=9827 4563025920: FilewatcherMonitor filewatcher.pyo:71 EFTA00502439 docs_client_factory.pyo:97 Creating a new Wapi DocsClient 2015-12-15 09:12:36,453 -0500 INFO pid=9827 4550688768:_LaunchSyncApp docs_client_factory.pyo:97 Creating a new Wapi DocsClient 2015-12-15 09:12:36,454 -0500 INFO pid=9827 4550688768:_LaunchSyncApp docs_client_factory.pyo:97 Creating a new Wapi DocsClient 2015-12-15 09:12:36,454 -0500 INFO pid=9827 4550688768:_LaunchSyncApp docs_client_factory.pyo:97 Creating a new Wapi DocsClient 2015-12-15 09:12:36,455 -0500 INFO pid=9827 4550688768:_LaunchSyncApp docs_client_factory.pyo:97 Creating a new Wapi DocsClient 2015-12-15 09:12:36,474 -0500 INFO pid=9827 4550688768:_LaunchSyncApp xmpplib_notifier.pyo:34 Configure storage: <common.push.tango.storage.SyncConfigStorage; proxy of <Swig Object of type 'invalidation::Storage *' at 0xl0f83ca50> > 2015-12-15 09:12:36,475 -0500 INFO pid=9827 4550688768:_LaunchSyncApp xmpplib_notifier.pyo:59 Creating client thread 2015-12-15 09:12:36,475 -0500 INFO pid=9827 4550688768:_LaunchSyncApp push_xmpp_client.pyo:223 Using talk server: talk.google.com:5222 2015-12-15 09:12:36,475 -0500 INFO pid=9827 4550688768:_LaunchSyncApp xmpplib_notifier.pyo:68 Creating notification bridge 2015-12-15 09:12:36,554 -0500 INFO pid=9827 4550688768:_LaunchSyncApp docs_client_factory.pyo:97 Creating a new Wapi DocsClient 2015-12-15 09:12:36,560 -0500 INFO pid=9827 4571439104:TelemetryUploaderThread sync_client_thread.pyo:175 TelemetryUploaderThread run loop has started. 2015-12-15 09:12:36,561 -0500 INFO pid=9827 4567232512:XmppClient telemetry.pyo:153 Push state None => PushStates.CONNECTING 2015-12-15 09:12:36,561 -0500 INFO pid=9827 4575645696:LocalDiskSpaceChecker sync_client_thread.pyo:175 LocalDiskSpaceChecker run loop has started. 2015-12-15 09:12:36,563 -0500 INFO pid=9827 4567232512:XmppClient connection_task.pyo:151 Recalculated LoginTask timeout: 16.000000 2015-12-15 09:12:36,565 -0500 INFO pid=9827 4588265472:Worker-0 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-12-15 09:12:36,565 -0500 INFO pid=9827 4567232512:XmppClient telemetry.pyo:167 PushStates.CONNECTING: +0.00445637 => 0.00445637 2015-12-15 09:12:36,566 -0500 INFO pid=9827 4567232512:XmppClient xmpplib.pyo:80 Connecting to talk.google.com:5222 2015-12-15 09:12:36,566 -0500 INFO pid=9827 4596678656:CloudWatcher sqlite.pyo:276 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-12-15 09:12:36,567 -0500 INFO pid=9827 4600885248:CrashReportUploaderThread crash_report_uploader_thread.pyo: 60 Starting CrashReportUploaderThread. 2015-12-15 09:12:36,568 -0500 INFO pid=9827 4605091840:LocalFSPoller sync_client_thread.pyo:175 LocalFSPoller run loop has started. 2015-12-15 09:12:36,568 -0500 INFO pid=9827 4588265472:Worker-0 sqlite.pyo:276 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-12-15 09:12:36,568 -0500 INFO pid=9827 4609298432:PushTelemetryThread sync_client_thread.pyo:175 PushTelemetryThread run loop has started. 2015-12-15 09:12:36,569 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread sync_client_thread.pyo:175 TelemetryStoreSizeMonitorThread run loop has started. 2015-12-15 09:12:36,570 -0500 INFO pid=9827 4596678656:CloudWatcher sqlite.pyo:276 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-12-15 09:12:36,570 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 09:12:36,570 -0500 INFO pid=9827 4617711616:RawEventUpgrader sync_client_thread.pyo:175 RawEventUpgrader run loop has started. 2015-12-15 09:12:36,571 -0500 INFO pid=9827 4621918208:Batcher sqlite.pyo:276 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-12-15 09:12:36,571 -0500 INFO pid=9827 4588265472:Worker-0 utils.pyo:737 AddCleanupCallback persistence_sqlite:e5f5e48166b44adab8ce1006e88095d8/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-12-15 09:12:36,571 -0500 INFO pid=9827 4626124800:PauseTelemetryThread sync_client_thread.pyo:175 PauseTelemetryThread run loop has started. EFTA00502440 2015-12-15 09:12:36,572 -0500 INFO pid=9827 4630331392:Worker-2 sqlite.pyo:276 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-12-15 09:12:36,573 -0500 INFO pid=9827 4596678656:CloudWatcher utils.pyo:737 AddCleanupCallback persistence_sqlite:5c0638d14ee145c986f2504b4eeba709/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-12-15 09:12:36,573 -0500 INFO pid=9827 4634537984:PushNotificationKeepaliveThread sync_client_thread.pyo:175 PushNotificationKeepaliveThread run loop has started. 2015-12-15 09:12:36,573 -0500 INFO pid=9827 4588265472:Worker-0 utils.pyo:737 AddCleanupCallback persistence_sqlite:f8d0175b343149919d86eeb7a146543c/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-12-15 09:12:36,574 -0500 INFO pid=9827 4638744576:OverlayStatusCleaner sync_client_thread.pyo:175 OverlayStatusCleaner run loop has started. 2015-12-15 09:12:36,574 -0500 INFO pid=9827 4642951168:LocalWatcher watcher.pyo:347 LocalWatcher Run invoked.Waiting for first pass of local scan from poller to start 2015-12-15 09:12:36,575 -0500 INFO pid=9827 4596678656:CloudWatcher utils.pyo:737 AddCleanupCallback persistence_sqlite:56504c0cf5fd4lfbbce757af5270dd3e/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-12-15 09:12:36,575 -0500 INFO pid=9827 4647157760:FeatureSwitchPoller sync_client_thread.pyo:175 FeatureSwitchPoller run loop has started. 2015-12-15 09:12:36,576 -0500 INFO pid=9827 4651364352:Worker-1 sqlite.pyo:276 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-12-15 09:12:36,576 -0500 INFO pid=9827 4621918208:Batcher sqlite.pyo:276 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-12-15 09:12:36,577 -0500 INFO pid=9827 4550688768:_LaunchSyncApp drive_extension_installer.pyo:174 Uninstalling extension nknebiagdodnminbdpflhpkgfpeijdbf 2015-12-15 09:12:36,578 -0500 INFO pid=9827 4588265472:Worker-0 command_factory.pyo:186 Registering worker command type: common.worker.downloads.DownloadChangeACL 2015-12-15 09:12:36,580 -0500 INFO pid=9827 4634537984:PushNotificationKeepaliveThread sync_http_client.pyo:236 Opening direct connecton to accounts.google.com:443. 2015-12-15 09:12:36,580 -0500 INFO pid=9827 4630331392:Worker-2 sqlite.pyo:276 Open master connection to /Users/lgrof f/Library/Application Support/Google/Drive/user_default/sync_configS 2015-12-15 09:12:36,580 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_graph.pyo:115 Initialize persistent graph with generation 2 2015-12-15 09:12:36,597 -0500 INFO pid=9827 4567232512:XmppClient telemetry.pyo:167 PushStates.CONNECTING: +0.0322121 => 0.0366685 2015-12-15 09:12:36,752 -0500 INFO pid=9827 4647157760:FeatureSwitchPoller feature_switch_manager.pyo:644 Calling server to get feature switches. 2015-12-15 09:12:36,753 -0500 INFO pid=9827 4588265472:Worker-0 command_factory.pyo:186 Registering worker command type: common.worker.downloads.DownloadCreate 2015-12-15 09:12:36,755 -0500 INFO pid=9827 4621918208:Batcher utils.pyo:737 AddCleanupCallback persistence_sqlite:85fldllaaf574098bfbad06ca2e5le20/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-12-15 09:12:36,756 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_graph.pyo:1563 Current sync config generation: 2 2015-12-15 09:12:36,756 -0500 INFO pid=9827 4567232512:XmppClient telemetry.pyo:153 Push state PushStates.CONNECTING => PushStates.NEGOTIATING 2015-12-15 09:12:36,757 -0500 INFO pid=9827 4550688768:_LaunchSyncApp utils.pyo:714 Execute cleanup callback 'persistence_sqlite:b353daa25a35408da88778fde433699a/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db' 2015-12-15 09:12:36,757 -0500 INFO pid=9827 4588265472:Worker-0 command_factory.pyo:186 Registering worker command type: common.worker.downloads.DownloadDelete 2015-12-15 09:12:36,758 -0500 INFO pid=9827 4651364352:Worker-1 sqlite.pyo:276 Open master connection to /Users/lgroff/Library/Application EFTA00502441 Support/Google/Drive/user_default/sync_config.db 2015-12-15 09:12:36,758 -0500 INFO pid=9827 4630331392:Worker-2 utils.pyo:737 AddCleanupCallback persistence_sqlite:f20d495b19df4e639c3bc3224a3fe967/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-12-15 09:12:36,758 -0500 INFO pid=9827 4647157760:FeatureSwitchPoller drive_resource.pyo:130 Initialize apiclient Drive resource for lesley.jee@gmail.com 2015-12-15 09:12:36,758 -0500 INFO pid=9827 4621918208:Batcher utils.pyo:737 AddCleanupCallback persistence_sqlite:e057a384eefa4c218db54781fc6ae21c/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-12-15 09:12:36,759 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_graph.pyo:1415 Cleanup cloud graph directory '/Users/lgroff/Library/Application Support/Google/Drive/user_default/cloud_graph' of files 'dict_*.db" except ['dict_2.db 1, Idict_2.db-shml, 'dict_2.db-wal'] 2015-12-15 09:12:36,759 -0500 INFO pid=9827 4550688768:_LaunchSyncApp sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-12-15 09:12:36,760 -0500 INFO pid=9827 4588265472:Worker-0 command_factory.pyo:186 Registering worker command type: common.worker.downloads.DownloadModify 2015-12-15 09:12:36,760 -0500 INFO pid=9827 4630331392:Worker-2 utils.pyo:737 AddCleanupCallback persistence_sqlite:5974bf5a84d8444ab35895642ead24ea/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-12-15 09:12:36,760 -0500 INFO pid=9827 4647157760:FeatureSwitchPoller drive_resource.pyo:178 Drive SDK baseUrl = https://www.googleapis.com/drive/v2internal/ 2015-12-15 09:12:36,761 -0500 INFO pid=9827 4651364352:Worker-1 utils.pyo:737 AddCleanupCallback persistence_sqlite:64ab89f4ef344b60bd9fd091f7453a48/Users/lgroff/Library/Application Support/Google/Drive/user_default/snapshot.db 2015-12-15 09:12:36,762 -0500 INFO pid=9827 4550688768:_LaunchSyncApp utils.pyo:714 Execute cleanup callback 'persistence_sqlite:c1032e50de6c460f9e59d26flbdd6934/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db' 2015-12-15 09:12:36,767 -0500 INFO pid=9827 4588265472:Worker-0 command_factory.pyo:186 Registering worker command type: common.worker.downloads.DownloadMove 2015-12-15 09:12:36,770 -0500 INFO pid=9827 4630331392:Worker-2 command_factory.pyo:186 Registering worker command type: common.worker.uploads.BatchUploadCreate 2015-12-15 09:12:36,771 -0500 INFO pid=9827 4651364352:Worker-1 utils.pyo:737 AddCleanupCallback persistence_sqlite:d6364d3ad67d45f0a574cf341a8431d4/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-12-15 09:12:36,771 -0500 INFO pid=9827 4550688768:_LaunchSyncApp sqlite.pyo:362 Close connection. path=/Users/lgroff/Library/Application Support/Google/Drive/user_default/sync_config.db 2015-12-15 09:12:36,772 -0500 INFO pid=9827 4588265472:Worker-0 command_factory.pyo:186 Registering worker command type: common.worker.downloads.DownloadRename 2015-12-15 09:12:36,772 -0500 INFO pid=9827 4630331392:Worker-2 command_factory.pyo: 186 Registering worker command type: common.worker.uploads.UploadCreate 2015-12-15 09:12:36,773 -0500 INFO pid=9827 4651364352:Worker-1 command_factory.pyo:186 Registering worker command type: common.worker.internals.InternalCreate 2015-12-15 09:12:36,773 -0500 INFO pid=9827 4647157760:FeatureSwitchPoller drive_request.pyo:285 Drive request: ListFeatureSwitches(tags=Reason.SYNC_OTHER) - Read request - lesley.jee@gmail.com 2015-12-15 09:12:36,774 -0500 INFO pid=9827 4588265472:Worker-0 command_factory.pyo:186 Registering worker command type: common.worker.internals.InternalCreate 2015-12-15 09:12:36,774 -0500 INFO pid=9827 4630331392:Worker-2 command_factory.pyo: 186 Registering worker command type: common.worker.uploads.UploadDelete 2015-12-15 09:12:36,774 -0500 INFO pid=9827 4651364352:Worker-1 command_factory.pyo:186 Registering worker command type: EFTA00502442 common.worker.internals.InternalModify 2015-12-15 09:12:36,778 -0500 INFO pid=9827 4647157760:FeatureSwitchPoller discovery.pyo:762 URL being requested: GET https://www.googleapis.com/drive/v2internal/settings? fields=items%2Fkey%2Citems%2Fvalue&reason=304&namespace=FEATURE_SWITCH&alt=json 2015-12-15 09:12:36,779 -0500 INFO pid=9827 4588265472:Worker-0 command_factory.pyo:186 Registering worker command type: common.worker.internals.InternalModify 2015-12-15 09:12:36,779 -0500 INFO pid=9827 4630331392:Worker-2 command_factory.pyo:186 Registering worker command type: common.worker.uploads.UploadModify 2015-12-15 09:12:36,779 -0500 INFO pid=9827 4651364352:Worker-1 workers.pyo:127 Waiting for batcher to initialize 2015-12-15 09:12:36,780 -0500 INFO pid=9827 4588265472:Worker-0 workers.pyo:127 Waiting for batcher to initialize 2015-12-15 09:12:36,781 -0500 INFO pid=9827 4647157760:FeatureSwitchPoller client.pyo:515 Attempting refresh to obtain initial access_token 2015-12-15 09:12:36,781 -0500 INFO pid=9827 4630331392:Worker-2 command_factory.pyo:186 Registering worker command type: common.worker.uploads.UploadMove 2015-12-15 09:12:36,781 -0500 INFO pid=9827 4651364352:Worker-1 sync_client_thread.pyo:175 Worker-1 run loop has started. 2015-12-15 09:12:36,781 -0500 INFO pid=9827 4588265472:Worker-0 sync_client_thread.pyo:175 Worker-0 run loop has started. 2015-12-15 09:12:36,782 -0500 INFO pid=9827 4647157760:FeatureSwitchPoller client.pyo:735 Updated access_token read from Storage 2015-12-15 09:12:36,782 -0500 INFO pid=9827 4630331392:Worker-2 command_factory.pyo:186 Registering worker command type: common.worker.uploads.UploadRename 2015-12-15 09:12:36,783 -0500 INFO pid=9827 4647157760:FeatureSwitchPoller http.pyo:248 Request user-agent: googledrivesync-1.26.0707.2863 google-api-python-client/1.3.1 (gzip) (Darwin/10.9.5) 2015-12-15 09:12:36,783 -0500 INFO pid=9827 4630331392:Worker-2 workers.pyo:127 Waiting for batcher to initialize 2015-12-15 09:12:36,783 -0500 INFO pid=9827 4647157760:FeatureSwitchPoller sync_http_client.pyo:236 Opening direct connecton to www.googleapis.com:443. 2015-12-15 09:12:36,783 -0500 INFO pid=9827 4630331392:Worker-2 sync_client_thread.pyo:175 Worker-2 run loop has started. 2015-12-15 09:12:36,799 -0500 INFO pid=9827 4567232512:XmppClient xmpplib.pyo:420 Start SSL peer=gmail.com 2015-12-15 09:12:36,914 -0500 INFO pid=9827 4567232512:XmppClient telemetry.pyo:167 PushStates.NEGOTIATING: 40.316607 => 0.316607 2015-12-15 09:12:36,942 -0500 INFO pid=9827 4596678656:CloudWatcher utils.pyo:737 AddCleanupCallback DBConnectionManagerCleanupCallback 2015-12-15 09:12:36,942 -0500 INFO pid=9827 4596678656:CloudWatcher db_connection.pyo:200 Created thread connection on database /Users/lgroff/Library/Application Support/Google/Drive/user_default/cloud_graph/dict_2.db 2015-12-15 09:12:36,953 -0500 INFO pid=9827 4634537984:PushNotificationKeepaliveThread sync_http_client.pyo:236 Opening direct connecton to clients3.google.com:443. 2015-12-15 09:12:36,977 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_graph.pyo:956 Reuse CloudDiskDict database: /Users/lgroff/Library/Application Support/Google/Drive/user_default/cloud_graph/dict_2.db 2015-12-15 09:12:36,990 -0500 INFO pid=9827 4647157760:FeatureSwitchPoller http.pyo:267 Response: 1434 bytes - application/json; charset=UTF-8 (encoding:gzip) 2015-12-15 09:12:37,022 -0500 INFO pid=9827 4567232512:XmppClient telemetry.pyo:167 PushStates.NEGOTIATING: 40.108121 => 0.424729 2015-12-15 09:12:37,055 -0500 INFO pid=9827 4647157760:FeatureSwitchPoller drive_request.pyo:292 Drive response: Request (lesley.jee@gmail.com): ListFeatureSwitches(tags=Reason.SYNC_OTHER) Response: (u'enable_impressions_library': u'false', u'selective_sub_folder_syncl: u'false., u'crash_throttle_percentage': u'99.7', u'enable_feedback': u'true', u'enable_usb_detection': u'false', u'max_page_size_selective_syncl: u'1000', u'enable_shared_move_confirmation': u'false', u'enable_disk_check_on_preferences': u'false', u'enable_recursive_size': u'false', u'enable_push': u'true', u'enable_sync_options_in_setup_flow': u'false', u'enable_multipause': u'true', u'log_backup_count': u'0', u'enable_arbitrary_sync': u'false', u'enable_disk_check_on_setup': u'false', u'maxbatch_upload_files': u'30', u'cloud_graph_disk_generation': u'2', u'use_drive_api': u'false', u'query_strategy': u'all', EFTA00502443 u'enable_multipleaccounts': u'false', u'perf_throttle_percentage': u'100', u'test.feature_switch.name': u") 2015-12-15 09:12:37,126 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_graph.pyo:155 Initialize persistent graph with existing database /Users/lgrof f/Library/Application Support/Google/Drive/user_default/cloud_graph/dict_2.db 2015-12-15 09:12:37,127 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_graph.pyo:216 Building gdoc docids cache. 2015-12-15 09:12:37,158 -0500 INFO pid=9827 4567232512:XmppClient task.pyo:254 Task <common.push.xmpp.login_task.LoginTask object at Oxl0f7ffd10> complete. 2015-12-15 09:12:37,158 -0500 WARNING pid=9827 4567232512:XmppClient login_task.pyo:90 Clearing connection for LoginTask: <common.push.xmpp.login_task.LoginTask object at Oxl0f7ffd10> 2015-12-15 09:12:37,158 -0500 INFO pid=9827 4567232512:XmppClient push_xmpp_client.pyo:313 Connected to talk.google.com:5222 2015-12-15 09:12:37,159 -0500 WARNING pid=9827 4550688768:RunAsync-_OnXmppConnect-4 notification_bridge.pyo:126 XMPP detected connect. 2015-12-15 09:12:37,159 -0500 INFO pid=9827 4550688768:RunAsync-_OnXmppConnect-4 xmpp_network_channel.pyo:169 Sending push channel subscription request 2015-12-15 09:12:37,201 -0500 INFO pid=9827 4567232512:XmppClient xmpp_network_channel.pyo:187 Received subscription response from Push for XMPPBot 2015-12-15 09:12:37,201 -0500 INFO pid=9827 4550688768:RunAsync-_OnXmppConnect-4 notification_bridge.pyo:142 Starting TICL (client version 3.20130807)... 2015-12-15 09:12:37,201 -0500 INFO pid=9827 4550688768:RunAsync-_OnXmppConnect-4 xmpp_network_channel.pyo: 65 XmppNetworkChannel.InformNetworkStatus: CONNECTED 2015-12-15 09:12:37,222 -0500 INFO pid=9827 4584058880:ListenerScheduler invalidation_listener.pyo:185 InvalidationListener.ReissueRegistrations(prefix=, prefix_len=0) 2015-12-15 09:12:37,666 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_graph.pyo:161 Reuse CloudDiskDict CloudDiskDict(max_change_stamp=76027, app_version=1.26.0707.2863, (1) 2015-12-15 09:12:37,667 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:831 Performing full snapshot diff. 2015-12-15 09:12:37,667 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:1026 Getting cloud resources via changelog feed from 76028 2015-12-15 09:12:37,667 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:743 Requesting Doc List: /feeds/default/private/changes?start-index=76028&showroot=true&include- shared=true&reason=startup 2015-12-15 09:12:37,668 -0500 INFO pid=9827 4596678656:CloudWatcher sync_http_client.pyo:236 Opening direct connecton to clients3.google.com:443. 2015-12-15 09:12:37,682 -0500 INFO pid=9827 4634537984:PushNotificationKeepaliveThread push_notification_keepalive_thread.pyo:49 Sent push keepalive message at: Tue Dec 15 09:12:37 2015 2015-12-15 09:12:38,286 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:1174 Feed has 1 entries 2015-12-15 09:12:38,286 -0500 End of feed, no next URI 2015-12-15 09:12:38,291 -0500 Got 1 cloud entries 2015-12-15 09:12:38,292 -0500 712 nodes in the cloud graph 2015-12-15 09:12:38,329 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_snapshot_diff_helper.pyo:84 Prepare for Pruning graph (total of gdocs=True, sync folders=None, excluded folders=frozenset(()) 2015-12-15 09:12:38,329 -0500 INFO pid=9827 4596678656:CloudWatcher cloud snapshot diff_helper.pyo:85 Start Prune Graph (total of 712 entries) 2015-12-15 09:12:38,341 -0500 INFO pid=9827 4596678656:CloudWatcher cloud snapshot diff_helper.pyo:175 Pruning detected 695 items to keep 2015-12-15 09:12:38,341 -0500 INFO pid=9827 4596678656:CloudWatcher cloud snapshot diff_helper.pyo:182 695 entries in graph after pruning 2015-12-15 09:12:38,341 -0500 INFO pid=9827 4596678656:CloudWatcher cloud snapshot diff_helper.pyo:93 Compare to snaphost 2015-12-15 09:12:38,341 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_snapshot_diff_helper.pyo:762 Starting cloud graph vs snapshot set: None 2015-12-15 09:12:38,341 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_snapshot_diff_helper.pyo:764 Prepopulating DOC_ID-to-inodes cache INFO pid=9827 4596678656:CloudWatcher INFO pid=9827 4596678656:CloudWatcher INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:1181 cloud_watcher.pyo: 807 cloud_watcher.pyo:815 712 entries). sync diff with selective sync EFTA00502444 2015-12-15 09:12:38, cloud snapshot cliff_ 2015-12-15 09:12:38, cloud snapshot cliff_ 2015-12-15 09:12:38, cloud_snapshot_diff_ (} 2015-12-15 09:12:39, 344 -0500 INFO helper.pyo:768 596 -0500 INFO helper.pyo:783 940 -0500 INFO helper.pyo:810 pid=9827 4596678656:CloudWatcher First pass detecting moved entries pid=9827 4596678656:CloudWatcher Second pass detecting creations and modification entries pid=9827 4596678656:CloudWatcher Processed 694 entries in total. Number of events detected: 011 -0500 INFO pid=9827 4596678656:CloudWatcher Done with full snapshot diff. 2015-12-15 09:12:39,572 -0500 INFO pid=9827 4605091840:LocalFSPoller poller.pyo:126 Cloud scan complete. Preparing to start LocalFSPoller 2015-12-15 09:12:39,572 -0500 INFO pid=9827 4605091840:LocalFSPoller poller.pyo:137 LocalFSPoller first pass started. Waiting for localWatcher to start watching. 2015-12-15 09:12:39,572 -0500 INFO pid=9827 4642951168:LocalWatcher watcher.pyo:266 RootsAdded with roots [_MyDriveRootfu'/Users/lgroff/Google Drive', 'root', <RootState.INITED: 2>)] 2015-12-15 09:12:39,573 -0500 INFO pid=9827 4642951168:LocalWatcher watcher.pyo:271 watcher adding new root to graph: _MyDriveRoot(u'/Users/lgroff/Google Drive', 'root', INITED: 2>) 09:12:39,573 -0500 INFO pid=9827 4642951168:LocalWatcher watcher.pyo:252 roots: [_MyDriveRoot(u'/Users/lgroff/Google Drive', 'root', <RootState.INITED: <RootState. 2015-12-15 Scheduling 2>)] 2015-12-15 Scheduling cloud_watcher.pyo: 875 09:12:39,573 -0500 INFO pid=9827 4642951168:LocalWatcher watcher.pyo:305 root: _MyDriveRoot(u'/Users/lgroff/Google Drive', 'root', <RootState.INITED: 2>) 2015-12-15 09:12:39,574 -0500 INFO pid=9827 4642951168:LocalWatcher LocalWatcher is up. 2015-12-15 09:12:39,574 -0500 INFO pid=9827 4605091840:LocalFSPoller Finished waiting for LocalWatcher. 2015-12-15 09:12:39,574 -0500 INFO pid=9827 4605091840:LocalFSPoller Starting a local disk scan. 2015-12-15 09:12:39,574 -0500 INFO pid=9827 4605091840:LocalFSPoller Walking: [u'/Users/lgroff/Google Drive') 2015-12-15 09:12:40,109 -0500 INFO pid=9827 4584058880:ListenerScheduler invalidation_listener.pyo:125 Invalidationlistener.InformRegistrationStatus(1014:CHANGELOG, REGISTERED) 2015-12-15 09:12:40,109 -0500 WARNING pid=9827 4584058880:ListenerScheduler notification_bridge.pyo:202 Invalidation status callback called with connected=True 2015-12-15 09:12:40,109 -0500 INFO pid=9827 4584058880:ListenerScheduler telemetry.pyo:167 PushStates.NEGOTIATING: 43.08728 => 3.51201 2015-12-15 09:12:40,110 -0500 INFO pid=9827 4584058880:ListenerScheduler telemetry.pyo:153 Push state PushStates.NEGOTIATING => PushStates.ONLINE 2015-12-15 09:12:40,110 -0500 INFO pid=9827 4584058880:ListenerScheduler pause_manager.pyo:130 Removing pause reason OFFLINE. Paused: False 2015-12-15 09:12:40,110 -0500 ERROR pid=9827 4584058880:ListenerScheduler pause_manager.pyo:438 Tried to get last event time for PauseReason.OFFLINE, but no last event time recorded. 2015-12-15 09:12:40,111 -0500 INFO pid=9827 4584058880:ListenerScheduler invalidation_listener.pyo:82 Invalidationlistener.Invalidation(1014:CHANGELOG, wapi_version=76069) 2015-12-15 09:12:40,111 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:716 Change ignored. observed: 76069, retrieved: 76070 2015-12-15 09:12:40,709 -0500 INFO pid=9827 4605091840:LocalFSPoller poller.pyo:166 Number of found changes: 0 2015-12-15 09:12:40,709 -0500 INFO pid=9827 4605091840:LocalFSPoller poller.pyo:177 Finished local disk scan. 2015-12-15 09:14:56,748 -0500 INFO pid=9827 4563025920:FilewatcherMonitor watcher.pyo:550 PathsCallback called with: [u'/Users/lgroff/Google Drivel'] 2015-12-15 09:14:56,767 -0500 INFO pid=9827 4563025920:FilewatcherMonitor diff_helper.pyo:86 Scanning: (u'/Users/lgroff/Google Drive') 2015-12-15 09:15:00,728 -0500 INFO pid=9827 4563025920:FilewatcherMonitor watcher.pyo:550 PathsCallback called with: [u'/Users/lgroff/Google Drivel'] 2015-12-15 09:15:00,728 -0500 INFO pid=9827 4563025920:FilewatcherMonitor diff_helper.pyo:86 Scanning: (u'/Users/lgroff/Google Drive') 2015-12-15 09:20:25,651 -0500 INFO pid=9827 4563025920:FilewatcherMonitor watcher.pyo:550 PathsCallback called with: [u'/Users/lgroff/Google Drive/'] watcher.pyo:368 poller.pyo:146 poller.pyo:149 diff_helper.pyo: 86 EFTA00502445 2015-12-15 09:20:25,667 -0500 INFO pid=9827 4563025920:FilewatcherMonitor diff_helper.pyo:86 Scanning: [u'/Users/lgroff/Google Drive') 2015-12-15 09:20:29,587 -0500 INFO pid=9827 4563025920:FilewatcherMonitor watcher.pyo:550 PathsCallback called with: (u'/Users/lgroff/Google Drive/'] 2015-12-15 09:20:29,587 -0500 INFO pid=9827 4563025920:FilewatcherMonitor diff_helper.pyo:86 Scanning: [u'/Users/lgroff/Google Drive') 2015-12-15 09:27:36,554 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 09:42:36,562 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 10:00:10,892 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 10:15:06,504 -0500 INFO pid=9827 4546482176:ThreadMonitor thread_manager.pyo:339 Waking up. 2015-12-15 10:15:06,526 -0500 INFO pid=9827 4546482176:ThreadMonitor thread_manager.pyo:336 Waiting on exit condition. Wake up after 3600s. 2015-12-15 10:15:10,814 -0500 INFO pid=9827 4609298432:PushTelemetryThread telemetry.pyo:167 PushStates.ONLINE: +3596.46 => 3596.46 2015-12-15 10:15:10,814 -0500 INFO pid=9827 4609298432:PushTelemetryThread telemetry.pyo:112 Push telemetry harvest triggered, but only 3600.01017458s elapsed. Skipping. 2015-12-15 10:15:10,818 -0500 INFO pid=9827 4626124800:PauseTelemetryThread pause_telemetry.pyo:185 Collected 1.04284636027h of telemetry at t=1450192510.82, skipping. 2015-12-15 10:15:11,054 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 10:30:11,036 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 10:34:02,552 -0500 INFO pid=9827 4563025920:FilewatcherMonitor watcher.pyo:550 PathsCallback called with: [u'/Users/lgroff/Google Drive/', u'/Users/lgroff/Google Drive/My Documents (1)/1 ] 2015-12-15 10:34:02,592 -0500 INFO pid=9827 4563025920:FilewatcherMonitor diff_helper.pyo:86 Scanning: (u'/Users/lgroff/Google Drive', u'/Users/lgroff/Google Drive/My Documents Cl)'] 2015-12-15 10:34:02,775 -0500 INFO pid=9827 4563025920:FilewatcherMonitor diff_helper.pyo:133 Found 1 changes: [(FSChange(Direction.UPLOAD, Action.MODIFY, ino=15425403, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'2015 December.docx', parent_ino=14390475, new_ino=15425403, is_folder=False, unparents_shared=False, modified=1450193641, checksum=bd5fe16f186dd6642574c6c1957d4f8e, size=88937, generator_module=l, is_cancelled=False, is_priority=False)]] 2015-12-15 10:34:02,776 -0500 INFO pid=9827 4563025920:FilewatcherMonitor aggregator.pyo:108 > Received event ImmutableRawEvent(op=MODIFY, path=/Users/lgroff/Google Drive/My Documents (1)/2015 December.docx, time=1450193642.78, is_dir=False, ino=15425403, size=88937, old_path=None, new_ino=15425403, mtime=1450193641, parent_ino=14390475, affects_gdoc=None, is_cancelled=RawEventIsCancelledFlag.FALSE, old_parent_ino=None, _hash_ code=-4083614791868432007) FSChange(Direction.UPL0AD, Action.MODIFY, ino=15425403, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'2015 December.docx', parent_ino=14390475, new_ino=15425403, is_folder=False, unparents_shared=False, modified=1450193641, checksum=bd5fe16f186dd6642574c6c1957d4f8e, size=88937, generator_module=l, is_cancelled=False, is_priority=False) 2015-12-15 10:34:02,778 -0500 INFO pid=9827 4563025920:FilewatcherMonitor change_buffer.pyo:1042 Adding change and event to change buffer: FSChange(Direction.UPLOAD, Action.MODIFY, ino=15425403, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'2015 December.docx', parent_ino=14390475, new_ino=15425403, is_folder=False, unparents_shared=False, modified=1450193641, checksum=bd5fe16f186dd6642574c6c1957d4 f8e, size=88937, generator_module=1, is_cancelled=False, ispriority=False) ImmutableRawEvent(op=MODIFY, path=/Users/lgroff/Google Drive/My Documents (1)/2015 December.docx, time=1450193642.78, is_dir=False, ino=15425403, size=88937, old_path=None, new_ino=15425403, mtime=1450193641, parent_ino=14390475, affects_gdoc=None, is_cancelled=RawEventIsCancelledFlag.FALSE, old_parent_ino=None, _hash_code=-4083614791868432007) 2015-12-15 10:34:04,916 -0500 INFO pid=9827 4651364352:Worker-1 workers.pyo:183 Worker starting on (ImmutableChange(Direction.UPLOAD, Action.MODIFY, ino=15425403, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'2015 December.docx', parent_ino=14390475, new_ino=15425403, is_folder=False, unparents_shared=False, modified=1450193641, checksum=bd5fe16f186dd6642574c6c1957d4f8e, size=88937, generator_module=l, is_cancelled=False, is_priority=False, hash=6231917129284666895, constructor called=True)) EFTA00502446 2015-12-15 10:34:04,964 -0500 INFO pid=9827 4651364352:Worker-1 proxy_manager.pyo:354 Removing stale proxy entry from cache 2015-12-15 10:34:04,966 -0500 INFO pid=9827 4651364352:Worker-1 sync_http_client.pyo:236 Opening direct connecton to accounts.google.com:443. 2015-12-15 10:34:05,269 -0500 INFO pid=9827 4651364352:Worker-1 proxy_manager.pyo:354 Removing stale proxy entry from cache 2015-12-15 10:34:05,270 -0500 INFO pid=9827 4651364352:Worker-1 sync_http_client.pyo:236 Opening direct connecton to clients3.google.com:443. 2015-12-15 10:34:06,027 -0500 INFO pid=9827 4651364352:Worker-1 docs_client.pyo:2167 Updating: 2015 December.docx (88937 bytes). DocsEntry: <ns0:entry xmlns:ns0="http://www.w3.org/2005/Atom" xmlns:nsl="http://schemas.google.com/g/2005" xmlns:ns2="http://schemas.google.com/docs/2007" xmlns:ns3="http://www.w3.org/2007/app" nsl:etag="&quot;ABEEVQVdACt7ImBl&quot;"><nsl:quotaBytesUsed>56433</nsl:quotaBytesUsed> <ns0:category label="hidden" scheme="http://schemas.google.com/g/2005/labels" term="http://schemas.google.com/g/2005/labels#hidden" /><ns0:category label="has-path-to- root" scheme="http://schemas.google.com/docs/2007" term="http://schemas.google.com/docs/2007#has-path-to-root" /><ns0:category label="application/vnd.openxmlformats-officedocument.wordprocessingml.document" scheme="http://schemas.google.com/g/2005#kind" term="http://schemas.google.com/docs/2007#file" /><ns0:category label="modified-by-me" scheme="http://schemas.google.com/g/2005/1abels" term="http://schemas.google.com/g/2005/labels#modified-by-me" /><ns0:category label="viewed" scheme="http://schemas.google.com/g/2005/1abels" term="http://schemas.google.com/g/2005/labels#viewed" /><ns0:category label="purgeable" scheme="http://schemas.google.com/g/2005/1abels" term="http://schemas.google.com/g/2005/1abels#purgeable" I> <ns0:id>https://clients3.google.com/feeds/id/file%3A0BxNN8iEiWGvgRF1wTG9EcDJ12Fk</ns0:id> <ns2:writersCanlnvite value="true" /><ns0:author><ns0:name>lesley.jee</ns0:name> <ns0:email>lesley.jee@gmail.com</ns0:email></ns0:author><ns0:content src="https://doc-0k-bc- docs.googleusercontent.com/docs/securesc/rsu4vkf416fjahebskrbestgo213ea4g/8u0illkc29evf9mgfeg tgjpuf78kddqf/1450188000000/07946446228801835265/07946446228801835265/0BxNN8iEiWGvgRF1wTG9EcD J1ZFk?e=download&amp;gd=true" type="application/vnd.openxmlformats- officedocument.wordprocessingml.document" /><ns0:updated>2015-12-15T15:34:01</ns0:updated> <ns0:published>2015-11-17T15:43:03.8902</ns0:published><nsl:lastViewed>2015-12- 15T12:50:26.5302.</nsl:lastViewed><nsl:lastModifiedBy><ns0:name>lesley.jee</ns0:name> <ns0:email>lesley.jee@gmail.com</ns0:email></nsl:lastModifiedBy><ns0:title>2015 December.docx</ns0:title><nsl:resourceld>file:0BxNN8iEiWGvgRF1wTG9EcDJ12Fk</nsl:resourceld> <ns0:link href="https://clients3.google.com/feeds/default/private/full/folder%3A0BxNN8iEiWGvgRjcxNnEhRm 5nVlk" rel="http://schemas.google.com/docs/2007#parent" type="application/atom+xml" I> <ns0:link href="https://drive.google.com/file/d/0BxNN8iEiWGvgRF1wTG9EclillEFk/view? usp=docslist_api" rel="alternate" type="text/html" /><ns0:link href="https://ssl.gstatic.com/docs/doclist/images/icon_10_word_list.png" rel="http://schemas.google.com/docs/2007#icon" type="image/png" /><ns0:link href="https://clients3.google.com/feeds/upload/create- session/default/private/full/file%3A0MNN8iEiWGvgRF1wTG9EcDJIZFk?new- revision=true&amp;override-modified-timestamp=truefiamp;force-modified-timestamp=true" rel="http://schemas.google.com/g/2005#resumable-edit-media" type="application/atom+xml" I> <ns0:link href="https://clients3.google.com/feeds/upload/file/default/private/full/file%3A0BxNN8iEiWGvg RF1wTG9EcDJ12Fk" rel="http://schemas.google.com/docs/2007#alt-edit-media" type="application/atom+xml" /><ns0:link href="https://lh5.googleusercontent.com/N- Scv5YQ2T9o3Rpk8wBpQDUGbg3AlwAdCN-K_mXw48VauU50F6Wrzv0DArVAlyB50Pv3J_U=s220" rel="http://schemas.google.com/docs/2007/thumbnail" type="image/png" /><ns0:link href="https://drive.google.com/sharing/share? subapp=10Samp;id=0BxNN8iEiWGvgRF1wTG9EcDJ12Fkfiamp;shareProtocolVersion=2&amp;foreignService=g oogledrivesyncSamp;command=settingsfiamp;shareUiType=default&amp;authuser=0&amp;client=desktop &amp;hl=en" rel="http://schemas.google.com/docs/2007#share" type="text/html" /><ns0:link href="https://clients3.google.com/feeds/default/private/full/file%3A0BxNN8iEiWGvgRF1wTG9EcDJ1 2.Fk" rel="self" type="application/atom+xml" /><ns0:link href="https://clients3.google.com/feeds/default/private/full/file%3A0BxNN8iEiWGvgRF1wTG9Eclill EFk?new-revision=true&amp;override-modified-timestamp=true&amp;force-modified-timestamp=true" rel="edit" type="application/atom+xml" /><ns0:link href="https://clients3.google.com/feeds/default/media/file%3A0BxNN8iEiWGvgRF1wTG9EcDJIZFk" rel="edit-media" type="application/vnd.openxmlformats- EFTA00502447 off icedocument.wordprocessingml.document" /><nsl:feedlink href="https://clients3.google.com/feeds/default/private/full/file%3A0BxNN8iEiWGvgRF1wTG9EcDJ1 2.Fk/acl" rel="http://schemas.google.com/ac1/200711accessControllist" /><nsl:feedLink href="https://clients3.google.com/feeds/default/private/full/file%3A0BxNN8iEiWGvgRF1wTG9EcDJ1 Erik/revisions" rel="http://schemas.google.com/docs/2007/revisions" /><ns3:edited>2015-12- 15T14:10:15.9202.</ns3:edited><ns2:isShareable value="true" /><ns2:isShareableByMe value="true" /><ns2:modifiedlayMeDate>2015-12-14T21:49:45.0002.</ns2:modifiedByMeDate> <ns2:md5Checksum>d42025933fe29a0c766b5a76257ece73</ns2:md5Checksum><ns2:filename>2015 December.docx</ns2:filename><ns2:suggestedFilename>2015 December.docx</ns2:suggestedFilename> <ns2:size>56433</ns2:size></ns0:entry> 2015-12-15 10:34:06,033 -0500 INFO pid=9827 4651364352:Worker-1 sync_http_client.pyo:236 Opening direct connecton to upload.drive.google.com:443. 2015-12-15 10:34:07,904 -0500 INFO pid=9827 4651364352:Worker-1 snapshot_sqlite.pyo:253 Updating cloud entry doc_id=0BxNN8iEiWGvgRF1wTG9EcDJ1EFk, filename=None 2015-12-15 10:34:07,905 -0500 INFO pid=9827 4651364352:Worker-1 snapshot_sqlite.pyo:230 Updating local entry inode=15425403, modified=1450193641, checksum=bd5fe16f186dd6642574c6c1957d4f8e, size=88937 2015-12-15 10:34:07,906 -0500 INFO pid=9827 4651364352:Worker-1 workers.pyo:194 Worker successfully completed (ImmutableChange(Direction.UPLOAD, Action.MODIFY, ino=15425403, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'2015 December.docx', parent_ino=14390475, new_ino=15425403, is folder=False, unparents_shared=False, modified=1450193641, checksum=bd5fe16f186dd6642574c6c1957d4f8e, size=88937, generator module=1, is_cancelled=False, is_priority=False, hash=6231917129284666895, constructor called=True)) 2015-12-15 0:34:07,915 -0500 INFO pid=9827 4621918208:Batcher batcher.pyo:239 Current batch is completed. Batcher snooze. 2015-12-15 10:34:07,915 -0500 INFO pid=9827 4621918208:Batcher sync_status.pyo:133 Reset sync status 2015-12-15 10:34:07,916 -0500 INFO pid=9827 4621918208:Batcher batcher.pyo:855 Batcher Stats = file count = Counter(( COUNT KEY(airection=_UploadDirectionType(Direction.UPLOAD), action= FiChangactionType(Action.MODIFY), batch=False, successful=True): 1)), byte_count = Counter1( COUNT KEY(direction=_UploadDirectionType(Direction.UPLOAD), action=_FSChangeActionType(Action.MODIFY), batch=False, successful=True): 88937)), batch_operation_count = Counter(), process seconds = Counter(( COUNT KEY(direction=_UploadDireciionType(Direction.UPLOAD), action= FChangactionType(Action.MODIFY), batch=False, successful=True): 2.9799519579620361), duration seconds = 3 (start time = 1450193644, end_time = 1450193647) 2015-12-15 10:34:10,309 -0500 INFO pid=9827 4584058880:ListenerScheduler invalidation_listener.pyo:82 Invalidationlistener.Invalidation(1014:CHANGELOG, wapi_version=76076) 2015-12-15 10:34:10,310 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:711 Getting changes; observed: 76076, retrieved: 76070 2015-12-15 10:34:10,311 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:1026 Getting cloud resources via changelog feed from 76071 2015-12-15 10:34:10,323 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:743 Requesting Doc List: /feeds/default/private/changes?start-index=76071&showroot=true&include- shared=true&reason=change 2015-12-15 10:34:10,324 -0500 INFO pid=9827 4584058880:ListenerScheduler invalidation_listener.pyo:82 Invalidationlistener.Invalidation(1014:CHANGELOG, wapi_version=76077) 2015-12-15 10:34:10,325 -0500 INFO pid=9827 4596678656:CloudWatcher sync_http_client.pyo:236 Opening direct connecton to clients3.google.com:443. 2015-12-15 10:34:10,570 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:1174 Feed has 1 entries 2015-12-15 10:34:10,570 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:1181 End of feed, no next URI 2015-12-15 10:34:10,571 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:1645 Built recent change dict: ( 1 0BxNN8iEiWGvgRF1wTG9EcD.J1EFk': (WorkerModifyCloudEvent(modify_time=1450193641, size=88937, checksum=bd5fe16f186dd6642574c6c1957d4f8e, doc id=0BxNN8iEiWGvgRF1wTG9EcDJ12,Fk, server mod_time=1450193647, version=None, hasii code=-4166993537875656735))) 2015-12-15 10:34:10,593 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:1368 GenerateCreateForDescendents() entry EFTA00502448 CloudEntry(doc_id=0BxNN8iEiWGvgRF1wTG9EcD.J1ZFk,filename=2015 December.docx,modified=1450193641,created=1447774983,acl_role=owner,doc_type=DocType.BLOB,rem oved=False,parent_doc_ids=set(('0laxNN8iEiWGvgRjcxNnlahRm5nV11O)),child_doc_ids=set(()),size=88 937,checksum=bd5fel6f186dd6642574c6c1957d4f8e,change_stamp=76077,server_mod_time=1450193647,i s_zombie=False,shared=False,recursive_size=None,resource_type=file,version=None) parents_added set([)) 2015-12-15 10:34:10,601 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:198 HandleSyncConfigSettingsChange generated events=set([]) 2015-12-15 10:34:15,602 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:716 Change ignored. observed: 76077, retrieved: 76077 2015-12-15 10:45:11,060 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 11:00:11,061 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 11:15:06,448 -0500 INFO pid=9827 4546482176:ThreadMonitor thread_manager.pyo:339 Waking up. 2015-12-15 11:15:06,503 -0500 INFO pid=9827 4546482176:ThreadMonitor thread_manager.pyo:336 Waiting on exit condition. Wake up after 3600s. 2015-12-15 11:15:10,737 -0500 INFO pid=9827 4609298432:PushTelemetryThread telemetry.pyo:167 PushStates.ONLINE: +3600 => 7196.46 2015-12-15 11:15:10,737 -0500 INFO pid=9827 4609298432:PushTelemetryThread telemetry.pyo:112 Push telemetry harvest triggered, but only 7200.01228199s elapsed. Skipping. 2015-12-15 11:15:10,740 -0500 INFO pid=9827 4626124800:PauseTelemetryThread pause_telemetry.pyo:185 Collected 2.04282467279h of telemetry at t=1450196110.74, skipping. 2015-12-15 11:15:11,095 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 11:30:11,091 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 11:31:06,690 -0500 INFO pid=9827 4563025920:FilewatcherMonitor watcher.pyo:550 PathsCallback called with: [u'/Users/lgroff/Google Drive/', u'/Users/lgroff/Google Drive/My Documents (1)/1 ] 2015-12-15 11:31:06,789 -0500 INFO pid=9827 4563025920:FilewatcherMonitor diff_helper.pyo:86 Scanning: (u'/Users/Igroff/Google Drive', u'/Users/lgroff/Google Drive/My Documents Cl)'] 2015-12-15 11:31:07,180 -0500 INFO pid=9827 4563025920:FilewatcherMonitor diff_helper.pyo:133 Found 1 changes: [(FSChange(Direction.UPLOAD, Action.MODIFY, ino=15425403, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'2015 December.docx', parent_ino=14390475, new_ino=15425403, is_folder=False, unparents_shared=False, modified=1450197065, checksum=4aa87cdc7bb301bad7befb5e28da14df, size=57255, generator_module=l, is_cancelled=False, is_priority=False)]] 2015-12-15 11:31:07,181 -0500 INFO pid=9827 4563025920:FilewatcherMonitor aggregator.pyo:108 > Received event ImmutableRawEvent(op=MODIFY, path=/Users/lgroff/Google Drive/My Documents (1)/2015 December.docx, time=1450197067.18, is_dir=False, ino=15425403, size=57255, old_path=None, new_ino=15425403, mtime=1450197065, parent_ino=14390475, affects_gdoc=None, is_cancelled=RawEventIsCancelledFlag.FALSE, old_parent_ino=None, _hash_ code=1200731584340727166) FSChange(Direction.UPLOAD, Action.MODIFY, ino=15425403, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'2015 December.docx', parent_ino=14390475, new_ino=15425403, is_folder=False, unparents_shared=False, modified=1450197065, checksum=4aa87cdc7bb301bad7befb5e28da14df, size=57255, generator_module=l, is_cancelled=False, is_priority=False) 2015-12-15 11:31:07,183 -0500 INFO pid=9827 4563025920:FilewatcherMonitor change_buffer.pyo:1042 Adding change and event to change buffer: FSChange(Direction.UPLOAD, Action.MODIFY, ino=15425403, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'2015 December.docx', parent_ino=14390475, new_ino=15425403, is_folder=False, unparents_shared=False, modified=1450197065, checksum=4aa87cdc7bb301bad7befb5e28da14df, size=57255, generator_module=1, is_cancelled=False, is_priority=False) ImmutableRawEvent(op=MODIFY, path=/Users/lgroff/Google Drive/My Documents (1)/2015 December.docx, time=1450197067.18, is_dir=False, ino=15425403, size=57255, old_path=None, new_ino=15425403, mtime=1450197065, parent_ino=14390475, affects_gdoc=None, is_cancelled=RawEventIsCancelledFlag.FALSE, old_parent_ino=None, _hash_code=1200731584340727166) 2015-12-15 11:31:09,316 -0500 INFO pid=9827 4630331392:Worker-2 workers.pyo:183 Worker starting on (ImmutableChange(Direction.UPLOAD, Action.MODIFY, ino=15425403, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'2015 December.docx', parent_ino=14390475, new_ino=15425403, is_folder=False, unparents_shared=False, modified=1450197065, checksum=4aa87cdc7bb301bad7befb5e28da14df, size=57255, EFTA00502449 generator_module=l, is_cancelled=False, is_priority=False, hash=-1231584862755501753, _constructorcalled=True)) 2015-12-15 11:31:09,346 -0500 INFO pid=9827 4630331392:Worker-2 proxy_manager.pyo:354 Removing stale proxy entry from cache 2015-12-15 11:31:09,353 -0500 INFO pid=9827 4630331392:Worker-2 sync_http_client.pyo:236 Opening direct connecton to clients3.google.com:443. 2015-12-15 11:31:09,840 -0500 INFO pid=9827 4630331392:Worker-2 docs_client.pyo:2167 Updating: 2015 December.docx (57255 bytes). DocsEntry: <ns0:entry xmlns:ns0="http://www.w3.org/2005/Atom" xmlns:nsl="http://schemas.google.com/g/2005" xmlns:ns2="http://schemas.google.com/docs/2007" xmlns:ns3="http://www.w3.org/2007/app" nsl:etag="&quot;ABEJVQ4NAyt7ImBl&quot;"><nsl:quotaBytesUsed>88937</nsl:quotaBytesUsed> <ns0:category label="hidden" scheme="http://schemas.google.com/g/2005/labels" term="http://schemas.google.com/g/2005/labels#hidden" /><ns0:category label="has-path-to- root" scheme="http://schemas.google.com/docs/2007" term="http://schemas.google.com/docs/2007#has-path-to-root" /><ns0:category label="application/vnd.openxmlformats-officedocument.wordprocessingml.document" scheme="http://schemas.google.com/g/2005#kind" term="http://schemas.google.com/docs/2007#file" /><ns0:category label="modified-by-me" scheme="http://schemas.google.com/g/2005/1abels" term="http://schemas.google.com/g/2005/labels#modified-by-me" /><ns0:category label="viewed" scheme="http://schemas.google.com/g/2005/1abels" term="http://schemas.google.com/g/2005/labels#viewed" /><ns0:category label="purgeable" scheme="http://schemas.google.com/g/2005/1abels" term="http://schemas.google.com/g/2005/1abels#purgeable" I> <ns0:id>https://clients3.google.com/feeds/id/file%3A0BxNN8iEiWGvgRF1wTG9EcDJ12Fk</ns0:id> <ns2:writersCanlnvite value="true" /><ns0:author><ns0:name>lesley.jee</ns0:name> <ns0:email>lesley.jee@gmail.com</ns0:email></ns0:author><ns0:content src="https://doc-Ok-bc- docs.googleusercontent.com/docs/securesc/rsu4vkf416fjahebskrbestclo213ea4g/cfgs351ktvsraggnn6j j6houv4mf2b4g/1450195200000/07946446228801835265/07946446228801835265/0BxNN8iEiWGvgRF1wTG9EcD J1ZFk?e=download&amp;gd=true" type="application/vnd.openxmlformats- officedocument.wordprocessingml.document" /><ns0:updated>2015-12-15T16:31:05</ns0:updated> <ns0:published>2015-11-17T15:43:03.8902</ns0:published><nsl:lastViewed>2015-12- 15T12:50:26.5302.</nsl:lastViewed><nsl:lastModifiedBy><ns0:name>lesley.jee</ns0:name> <ns0:email>lesley.jee@gmail.com</ns0:email></nsl:lastModifiedBy><ns0:title>2015 December.docx</ns0:title><nsl:resourceld>file:OBxNN8iEiWGvgRF1wTG9EcDJ12Fk</nsl:resourceld> <ns0:link href="https://clients3.google.com/feeds/default/private/full/folder%3A0BxNN8iEiWGvgRjcxNnEhRm 5nVlk" rel="http://schemas.google.com/docs/2007#parent" type="application/atom+xml" I> <ns0:link href="https://drive.google.com/file/d/OWENN8iEiWGvgRF1wTG9EcD.112Fk/view? usp=docslist_api" rel="alternate" type="text/html" /><ns0:link href="https://ssl.gstatic.com/docs/doclist/images/icon_10_word_list.png" rel="http://schemas.google.com/docs/2007#icon" type="image/png" /><ns0:link href="https://clients3.google.com/feeds/upload/create- session/default/private/full/file%3A0B5ENN8iEiWGvgRF1wTG9EcDJIZFk?new- revision=true&amp;override-modified-timestamp=truefiamp;force-modified-timestamp=true" rel="http://schemas.google.com/g/2005#resumable-edit-media" type="application/atom+xml" I> <ns0:link href="https://clients3.google.com/feeds/upload/file/default/private/full/file%3A0BxNN8iEiWGvg RF1wTG9EcDJ12Fk" rel="http://schemas.google.com/docs/2007#alt-edit-media" type="application/atom+xml" /><ns0:link href="https://1h4.googleusercontent.com/C1FUMI- AxACRNDfX_WNELL3U3nCbR2bblbTmoi4TxrUo6gayg8E001rzNKFWeWTdmDENnd4=s220" rel="http://schemas.google.com/docs/2007/thumbnail" type="image/png" /><ns0:link href="https://drive.google.com/sharing/share? subapp=10Samp;id=0BxNN8iEiWGvgRF1wTG9EcDJ12Fkfiamp;shareProtocolVersion=2&amp;foreignService=g oogledrivesyncsamp;command=settingsfiamp;shareUiType=default&amp;authuser=0&amp;client=desktop &amp;hl=en" rel="http://schemas.google.com/docs/2007#share" type="text/html" /><ns0:link href="https://clients3.google.com/feeds/default/private/full/file%3A0BxNN8iEiWGvgRF1wTG9EcDJ1 2.Fk" rel="self" type="application/atom+xml" /><ns0:link href="https://clients3.google.com/feeds/default/private/full/file%3A0BxNN8iEiWGvgRF1wTG9EcDJ1 EFk?new-revision=true&amp;override-modified-timestamp=true&amp;force-modified-timestamp=true" rel="edit" type="application/atom+xml" /><ns0:link href="https://clients3.google.com/feeds/default/media/file%3A0BxNN8iEiWGvgRF1wTG9EcDJIZFk" rel="edit-media" type="application/vnd.openxmlformats- officedocument.wordprocessingml.document" /><nsl:feedLink href="https://clients3.google.com/feeds/default/private/full/file%3A0BxNN8iEiWGvgRF1wTG9EcDJ1 EFTA00502450 Erik/ad" rel="http://schemas.google.com/ac1/200711accessControllist" /><nsl:feedLink href="https://clients3.google.com/feeds/default/private/full/file%3A0BxNN8iEiWGvgRF1wTG9EcDJ1 Erik/revisions" rel="http://schemas.google.com/docs/2007/revisions" /><ns3:edited>2015-12- 15T15:34:07.9612.</ns3:edited><ns2:isShareable value="true" /><ns2:isShareableByMe value="true" /><ns2:modifiedByMeDate>2015-12-15T15:34:01.0002.</ns2:modifiedByMeDate> <ns2:md5Checksum>bd5fel6f186dd6642574c6c1957d4f8e</ns2:md5Checksum><ns2:filename>2015 December.docx</ns2:filename><ns2:suggestedFilename>2015 December.docx</ns2:suggestedFilename> <ns2:size>88937</ns2:size></ns0:entry> 2015-12-15 11:31:09,845 -0500 INFO pid=9827 4630331392:Worker-2 proxy_manager.pyo:354 Removing stale proxy entry from cache 2015-12-15 11:31:09,846 -0500 INFO pid=9827 4630331392:Worker-2 sync_http_client.pyo:236 Opening direct connecton to upload.drive.google.com:443. 2015-12-15 11:31:11,334 -0500 INFO pid=9827 4630331392:Worker-2 snapshot_sqlite.pyo:253 Updating cloud entry doc_id=0BxNN8iEiWGvgRF1wTG9EcDJ12Fk, filename=None 2015-12-15 11:31:11,334 -0500 INFO pid=9827 4630331392:Worker-2 snapshot_sqlite.pyo:230 Updating local entry inode=15425403, modified=1450197065, checksum=4aa87cdc7bb301bad7befb5e28da14df, size=57255 2015-12-15 11:31:11,335 -0500 INFO pid=9827 4630331392:Worker-2 workers.pyo:194 Worker successfully completed (ImmutableChange(Direction.UPLOAD, Action.MODIFY, ino=15425403, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=1O2015 December.docx', parent_ino=14390475, new_ino=15425403, is_folder=False, unparents_shared=False, modified=1450197065, checksum=4aa87cdc7bb301bad7befb5e28da14df, size=57255, generator_module=l, is_cancelled=False, is_priority=False, hash=-1231584862755501753, _constructor_called=True)) 2015-12-15 11:31:11,459 -0500 INFO pid=9827 4584058880:ListenerScheduler invalidation_listener.pyo:82 Invalidationlistener.Invalidation(1014:CHANGELOG, wapi_version=76080) 2015-12-15 11:31:11,459 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:711 Getting changes; observed: 76080, retrieved: 76077 2015-12-15 11:31:11,676 -0500 INFO pid=9827 4584058880:ListenerScheduler invalidation_listener.pyo:82 Invalidationlistener.Invalidation(1014:CHANGELOG, wapi_version=76081) 2015-12-15 11:31:12,293 -0500 INFO pid=9827 4584058880:ListenerScheduler invalidation_listener.pyo:82 Invalidationlistener.Invalidation(1014:CHANGELOG, wapi_version=76082) 2015-12-15 11:31:12,315 -0500 INFO pid=9827 4621918208:Batcher batcher.pyo:239 Current batch is completed. Batcher snooze. 2015-12-15 11:31:12,315 -0500 INFO pid=9827 4621918208:Batcher sync_status.pyo:133 Reset sync status 2015-12-15 11:31:12,315 -0500 INFO pid=9827 4621918208:Batcher batcher.pyo:855 Batcher Stats = file_count = Counter (f_COUNT_KEY Cdirection=_UploadDirectionType (Direction. UPLOAD), action=_FSChangeActionType(Action.M0DIFY), batch=False, successful=True): 1)), byte_count = Counter (f_COUNT_KEY (direction=_UploadDirectionType (Direction. UPLOAD), action=_FSChangeActionType(Action.M0DIFY), batch=False, successful=True): 57255)), batch_operation_count = Counter(), process_seconds = Counter (f_COUNT_KEY (direction=_UploadDirectionType (Direction. UPLOAD), action=_FSChangeActionType(Action.MODIFY), batch=False, successful=True): 2.0183048248291016)), duration seconds = 3 (start time = 1450197069, end time = 1450197072) 2015-12-15 11:31:12,333 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:1026 Getting cloud resources via changelog feed from 76078 2015-12-15 11:31:12,334 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:743 Requesting Doc List: /feeds/default/private/changes?start-index=76078&showroot=true&include- shared=true&reason=change 2015-12-15 11:31:12,336 -0500 INFO pid=9827 4596678656:CloudWatcher sync_http_client.pyo:236 Opening direct connecton to clients3.google.com:443. 2015-12-15 11:31:12,558 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:1174 Feed has 1 entries 2015-12-15 11:31:12,558 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:1181 End of feed, no next URI 2015-12-15 11:31:12,559 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:1645 Built recent change dict: ( 1 0BxNN8iEiWGvgRF1wTG9EcDJ1ZFIC: (WorkerModifyCloudEvent(modify_time=1450197065, size=57255, checksum=4aa87cdc7bb301bad7befb5e28dal4df, doc_id=OBxNN8iEiWGvgRF1wTG9ECDJ12Fk, EFTA00502451 server_mod_time=1450197070, version=None, _hash_code=-7091998612614146762)]) 2015-12-15 11:31:12,584 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:1368 GenerateCreateForDescendents() entry CloudEntry(doc_id=0BxNN8iEiWGvgRF1wTG9EcD.112Fk,filename=2015 December.docx,modified=1450197065,created=1447774983,acl_role=owner,doc_type=DocType.BLOB,rem oved=False,parent_doc_ids=set(i'0laxNN8iEiWGvgRjcxNnlahRm5nV1k 1 1),child_doc_ids=set([]),size=57 255,checksum=4aa87cdc7bb301bad7befb5e28dal4df,change_stamp=76082,server_mod_time=1450197071,i s_zombie=False,shared=False,recursive_size=None,resource_type=file,version=None) parents_added set([)) 2015-12-15 11:31:12,592 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:198 HandleSyncConfigSettingsChange generated events=set([]) 2015-12-15 11:31:17,593 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:716 Change ignored. observed: 76082, retrieved: 76082 2015-12-15 11:45:11,184 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 12:00:11,196 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 12:15:06,425 -0500 INFO pid=9827 4546482176:ThreadMonitor thread_manager.pyo:339 Waking up. 2015-12-15 12:15:06,455 -0500 INFO pid=9827 4546482176:ThreadMonitor thread_manager.pyo:336 Waiting on exit condition. Wake up after 3600s. 2015-12-15 12:15:10,659 -0500 INFO pid=9827 4609298432:PushTelemetryThread telemetry.pyo:167 PushStates.ONLINE: +3600 => 10796.5 2015-12-15 12:15:10,659 -0500 INFO pid=9827 4609298432:PushTelemetryThread telemetry.pyo:112 Push telemetry harvest triggered, but only 10800.0140468s elapsed. Skipping. 2015-12-15 12:15:10,662 -0500 INFO pid=9827 4626124800:PauseTelemetryThread pause_telemetry.pyo:185 Collected 3.04280306333h of telemetry at t=1450199710.66, skipping. 2015-12-15 12:15:11,188 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 12:30:11,230 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 12:45:11,252 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 12:52:16,088 -0500 INFO pid=9827 4584058880:ListenerScheduler invalidation_listener.pyo:82 InvalidationListener.Invalidation(1014:CHANGELOG, wapi_version=76083) 2015-12-15 12:52:16,106 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:711 Getting changes; observed: 76083, retrieved: 76082 2015-12-15 12:52:16,126 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:1026 Getting cloud resources via changelog feed from 76083 2015-12-15 12:52:16,127 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:743 Requesting Doc List: /feeds/default/private/changes?start-index=76083&showroot=true&include- shared=true&reason=change 2015-12-15 12:52:16,141 -0500 INFO pid=9827 4596678656:CloudWatcher proxy_manager.pyo:354 Removing stale proxy entry from cache 2015-12-15 12:52:16,143 -0500 INFO pid=9827 4596678656:CloudWatcher sync_http_client.pyo:236 Opening direct connecton to accounts.google. 2015-12-15 12:52:16,444 -0500 INFO pid=9827 4596678656:CloudWatcher Removing stale proxy entry from cache 2015-12-15 12:52:16,445 -0500 INFO pid=9827 4596678656:CloudWatcher sync_http_client.pyo:236 Opening direct connecton to clients3.google. 2015-12-15 12:52:17,734 -0500 INFO pid=9827 4596678656:CloudWatcher Feed has 1 entries 2015-12-15 12:52:17,734 -0500 INFO pid=9827 4596678656:CloudWatcher End of feed, no next URI 2015-12-15 12:52:17,755 -0500 INFO pid=9827 4596678656:CloudWatcher GenerateCreateForDescendents() entry CloudEntry(doc_id=0HxNN8iEiWGvgb2c3V1htMG11YU0,filename=2015 November2.docx,modified=1448833494,created=1446753675,acl_role=owner,doc_type=DocType.BLOH,re moved=False,parent_doc_ids=set([ 1 0BxNN8iEiWGvgRjcxNnEhRm5nVlk']),child_doc_ids=set(()),size=1 02116,checksum=16e26165aca86d1424dff6a8f6529d32,change_stamp=76083,servermod_time=1450201925 f is_zombie=False,shared=Falser recursive_size=None,resource_type=file,version=None) parents_added set([)) 2015-12-15 12:52:17,765 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:198 HandleSyncConfigSettingsChange generated events=set([]) com:443. proxy_manager.pyo:354 com:443. docs_client.pyo: 1174 docs_client.pyo: 1181 cloud_watcher.pyo: 1368 EFTA00502452 2015-12-15 13:00:11,247 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 13:00:36,052 -0500 INFO pid=9827 4584058880:ListenerScheduler invalidation_listener.pyo:82 InvalidationListener.Invalidation(1014:CHANGELOG, wapi_version=76087) 2015-12-15 13:00:36,053 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:711 Getting changes; observed: 76087, retrieved: 76083 2015-12-15 13:00:36,053 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:1026 Getting cloud resources via changelog feed from 76084 2015-12-15 13:00:36,054 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:743 Requesting Doc List: /feeds/default/private/changes?start-index=76084&showroot=true&include- shared=true&reason=change 2015-12-15 13:00:36,054 -0500 INFO pid=9827 4596678656:CloudWatcher proxy_manager.pyo:354 Removing stale proxy entry from cache 2015-12-15 13:00:36,055 -0500 INFO pid=9827 4596678656:CloudWatcher sync_http_client.pyo:236 Opening direct connecton to clients3.google.com:443. 2015-12-15 13:00:36,432 -0500 INFO pid=9827 4584058880:ListenerScheduler invalidation_listener.pyo:82 InvalidationListener.Invalidation(1014:CHANGELOG, wapi_version=76088) 2015-12-15 13:00:37,433 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:1174 Feed has 2 entries 2015-12-15 13:00:37,433 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:1181 End of feed, no next URI 2015-12-15 13:00:37,435 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:1368 GenerateCreateForDescendents() entry CloudEntry(doc_id=0BxNN8iEiWGvgRF1wTG9EctOlZFk,filename=2015 December.docx,modified=1450197065,created=1447774983,acl_role=owner,doc_type=DocType.BLOB,rem oved=False,parent_doc_ids=set([ 10BxNN8iEiWGvgRjcxNnlahRm5nVlk']),child_doc_ids=set([]),size=57 255,checksum=4aa87cdc7bb301bad7befb5e28dal4df,change_stamp=76084,server_mod_time=1450201995,i s_zombie=False,shared=False,recursive_size=None,resource_type=file,version=None) parents_added set([)) 2015-12-15 13:00:37,449 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:198 HandleSyncConfigSettingsChange generated events=set([]) 2015-12-15 13:00:42,086 -0500 INFO pid=9827 4584058880:ListenerScheduler invalidation_listener.pyo:82 InvalidationListener.Invalidation(1014:CHANGELOG, wapi_version=76089) 2015-12-15 13:00:42,449 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:711 Getting changes; observed: 76089, retrieved: 76088 2015-12-15 13:00:42,449 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:1026 Getting cloud resources via changelog feed from 76089 2015-12-15 13:00:42,450 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:743 Requesting Doc List: /feeds/default/private/changes?start-index=76089&showroot=true&include- shared=true&reason=change 2015-12-15 13:00:42,450 -0500 INFO pid=9827 4596678656:CloudWatcher sync_http_client.pyo:236 Opening direct connecton to clients3.google.com:443. 2015-12-15 13:00:42,674 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:1174 Feed has 1 entries 2015-12-15 13:00:42,675 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:1181 End of feed, no next URI 2015-12-15 13:00:42,675 -0500 INFO pid=9827 4596678656:CloudWatcher HandleSyncConfigSettingsChange generated events=set([]) 2015-12-15 13:15:06,377 -0500 INFO pid=9827 4546482176:ThreadMonitor Waking up. 2015-12-15 13:15:06,389 -0500 INFO pid=9827 4546482176:ThreadMonitor Waiting on exit condition. Wake up after 3600s. 2015-12-15 13:15:10,582 -0500 INFO pid=9827 4609298432:PushTelemetryThread telemetry.pyo:167 PushStates.ONLINE: 43600 => 14396.5 2015-12-15 13:15:10,582 -0500 INFO pid=9827 4609298432:PushTelemetryThread telemetry.pyo:112 Push telemetry harvest triggered, but only 14400.015856s elapsed. Skipping. 2015-12-15 13:15:10,584 -0500 INFO pid=9827 4626124800:PauseTelemetryThread pause_telemetry.pyo:185 Collected 4.04278128359h of telemetry at t=1450203310.58, skipping. 2015-12-15 13:15:11,260 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 13:30:11,261 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo:44 Checking Telemetry store size. cloud_watcher.pyo: 198 thread_manager.pyo:339 thread_manager.pyo:336 EFTA00502453 2015-12-15 13:45:11,287 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 14:00:11,312 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 14:15:06,311 -0500 INFO pid=9827 4546482176:ThreadMonitor Waking up. 2015-12-15 14:15:06,324 -0500 INFO pid=9827 4546482176:ThreadMonitor Waiting on exit condition. Wake up after 3600s. 2015-12-15 14:15:10,536 -0500 INFO pid=9827 4609298432:PushTelemetryThread telemetry.pyo:167 PushStates.ONLINE: 43600.03 => 17996.5 2015-12-15 14:15:10,537 -0500 INFO pid=9827 4626124800:PauseTelemetryThread pause_telemetry.pyo:185 Collected 5.04276819136h of telemetry at t=1450206910.54, skipping. 2015-12-15 14:15:10,537 -0500 INFO pid=9827 4609298432:PushTelemetryThread telemetry.pyo:112 Push telemetry harvest triggered, but only 18000.0498142s elapsed. Skipping. 2015-12-15 14:15:11,307 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 14:30:11,329 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 14:38:37,261 -0500 INFO pid=9827 4563025920:FilewatcherMonitor watcher.pyo:550 PathsCallback called with: [u'/Users/lgroff/Google Drive/'] 2015-12-15 14:38:37,289 -0500 INFO pid=9827 4563025920:FilewatcherMonitor diff_helper.pyo:86 Scanning: [u'/Users/lgroff/Google Drive.] 2015-12-15 14:38:41,160 -0500 INFO pid=9827 4563025920:FilewatcherMonitor watcher.pyo:550 PathsCallback called with: [u'/Users/lgroff/Google Drive/'] 2015-12-15 14:38:41,160 -0500 INFO pid=9827 4563025920:FilewatcherMonitor diff_helper.pyo:86 Scanning: [u'/Users/lgroff/Google Drive.] 2015-12-15 14:38:48,297 -0500 INFO pid=9827 4563025920:FilewatcherMonitor watcher.pyo:550 PathsCallback called with: [u'/Users/lgroff/Google Drive/'] 2015-12-15 14:38:48,297 -0500 INFO pid=9827 4563025920:FilewatcherMonitor diff_helper.pyo:86 Scanning: [u'/Users/lgroff/Google Drive.] 2015-12-15 14:38:53,299 -0500 INFO pid=9827 4563025920:FilewatcherMonitor watcher.pyo:550 PathsCallback called with: [u'/Users/lgroff/Google Drive/'] 2015-12-15 14:38:53,299 -0500 INFO pid=9827 4563025920:FilewatcherMonitor diff_helper.pyo:86 Scanning: (u'/Users/lgroff/Google Drive.] 2015-12-15 14:45:11,354 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 15:00:11,367 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 15:00:42,519 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:698 Getting changes: elapsed_time: 7200.00143789 2015-12-15 15:00:42,573 -0500 INFO pid=9827 4596678656:CloudWatcher Getting cloud resources via changelog feed from 76090 2015-12-15 15:00:42,577 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:743 Requesting Doc List: /feeds/default/private/changes?start-index=76090&showroot=true&include- shared=true&reason=backup_poll 2015-12-15 15:00:42,596 -0500 INFO pid=9827 4596678656:CloudWatcher proxy_manager.pyo:354 Removing stale proxy entry from cache 2015-12-15 15:00:42,611 -0500 INFO pid=9827 4596678656:CloudWatcher sync_http_client.pyo:236 Opening direct connecton to accounts.google.com:443. 2015-12-15 15:00:42,891 -0500 INFO pid=9827 4596678656:CloudWatcher proxy_manager.pyo:354 Removing stale proxy entry from cache 2015-12-15 15:00:42,892 -0500 INFO pid=9827 4596678656:CloudWatcher sync_http_client.pyo:236 Opening direct connecton to clients3.google.com:443. 2015-12-15 15:00:43,537 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:1181 End of feed, no next URI 2015-12-15 15:00:43,539 -0500 INFO pid=9827 4596678656:CloudWatcher HandleSyncConfigSettingsChange generated events=set([]) 2015-12-15 15:15:06,247 -0500 INFO pid=9827 4546482176:ThreadMonitor Waking up. 2015-12-15 15:15:06,259 -0500 INFO pid=9827 4546482176:ThreadMonitor Waiting on exit condition. Wake up after 3600s. 2015-12-15 15:15:10,459 -0500 INFO pid=9827 4626124800:PauseTelemetryThread pause_telemetry.pyo:185 Collected 6.04274653971h of telemetry at t=1450210510.46, skipping. 2015-12-15 15:15:10,459 -0500 INFO pid=9827 4609298432:PushTelemetryThread telemetry.pyo:167 PushStates.ONLINE: +3600 => 21596.5 thread_manager.pyo:339 thread_manager.pyo:336 cloud_watcher.pyo: 1026 cloud_watcher.pyo: 198 thread_manager.pyo:339 thread_manager.pyo:336 EFTA00502454 2015-12-15 15:15:10,460 -0500 INFO pid=9827 4609298432:PushTelemetryThread telemetry.pyo:112 Push telemetry harvest triggered, but only 21600.0521657s elapsed. Skipping. 2015-12-15 15:15:11,388 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 15:15:14,617 -0500 INFO pid=9827 4605091840:LocalFSPoller poller.pyo:149 Starting a local disk scan. 2015-12-15 15:15:14,618 -0500 INFO pid=9827 4605091840:LocalFSPoller diff_helper.pyo:86 Walking: (u'/Users/lgroff/Google Drive') 2015-12-15 15:15:14,926 -0500 of found changes: 0 INFO pid=9827 4605091840:LocalFSPoller poller.pyo:166 Number 2015-12-15 15:15:14,926 -0500 INFO pid=9827 4605091840:LocalFSPoller poller.pyo:177 Finished local disk scan. 2015-12-15 15:24:46,034 -0500 INFO pid=9827 4563025920:FilewatcherMonitor watcher.pyo:550 PathsCallback called with: (u'/Users/lgroff/Google Drive/My Documents (1)/', u'/Users/lgroff/Google Drive/1) 2015-12-15 15:24:46,050 -0500 INFO pid=9827 4563025920:FilewatcherMonitor diff_helper.pyo:86 Scanning: (u'/Users/lgroff/Google Drive/My Documents (1)', u'/Users/lgroff/Google Drive'] 2015-12-15 15:24:46,441 -0500 INFO pid=9827 4563025920:FilewatcherMonitor diff_helper.pyo:133 Found 1 changes: ((FSChange(Direction.UPLOAD, Action.MODIFY, ino=14455808, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'Christmas Address List.docx', parent_ino=14390475, new_ino=14455808, is_folder=False, unparents_shared=False, modified=1450211084, checksum=7f5ad4aabbbc422beb52fc553459adee, size=64264, generator_module=l, is_cancelled=False, is_priority=False)]] 2015-12-15 15:24:46,442 -0500 INFO pid=9827 4563025920:FilewatcherMonitor aggregator.pyo:108 > Received event ImmutableRawEvent(op=MODIFY, path=/Users/lgroff/Google Drive/My Documents (1)/Christmas Address List.docx, time=1450211086.44, is_dir=False, ino=14455808, size=64264, old_path=None, new_ino=14455808, mtime=1450211084, parent_ino=14390475, affects_gdoc=None, is_cancelled=RawEventIsCancelledFlag. FALSE, old_parent_ino=None, _hash_ code=-3427481499000789719) FSChange(Direction.UPL0AD, Action.MODIFY, ino=14455808, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'Christmas Address List.docx', parent_ino=14390475, new_ino=14455808, is_folder=False, unparents_shared=False, modified=1450211084, checksum=7f5ad4aabbbc422beb52fc553459adee, size=64264, generator_module=1, is_cancelled=False, is_priority=False) 2015-12-15 15:24:46,451 -0500 INFO pid=9827 4563025920:FilewatcherMonitor change_buffer.pyo:1042 Adding change and event to change buffer: FSChange(Direction.UPLOAD, Action.MODIFY, ino=14455808, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'Christmas Address List.docx', parent_ino=14390475, new_ino=14455808, is_folder=False, unparents_shared=False, modified=1450211084, checksum=7f5ad4aabbbc422beb52fc553459adee, size=64264, generator_module=1, is_cancelled=False, ispriority=False) ImmutableRawEvent(op=MODIFY, path=/Users/lgroff/Google Drive/My Documents (1)/Christmas Address List.docx, time=1450211086.44, is_dir=False, ino=14455808, size=64264, old_path=None, new_ino=14455808, mtime=1450211084, parent_ino=14390475, affects_gdoc=None, is_cancelled=RawEventIsCancelledFlag.FALSE, old_parent_ino=None, _hash_code=-3427481499000789719) 2015-12-15 15:24:47,077 -0500 INFO pid=9827 4563025920:FilewatcherMonitor watcher.pyo:550 PathsCallback called with: (u'/Users/lgroff/Google Drive/', u'/Users/lgroff/Google Drive/My Documents (1)/') 2015-12-15 15:24:47,077 -0500 INFO pid=9827 4563025920:FilewatcherMonitor diff_helper.pyo:86 Scanning: (u'/Users/lgroff/Google Drive', u'/Users/lgroff/Google Drive/My Documents (1)'] 2015-12-15 15:24:48,609 -0500 INFO pid=9827 4651364352:Worker-1 workers.pyo:183 Worker starting on (ImmutableChange(Direction.UPLOAD, Action.MODIFY, ino=14455808, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'Christmas Address List.docx', parent_ino=14390475, new_ino=14455808, is_folder=False, unparents_shared=False, modified=1450211084, checksum=7f5ad4aabbbc422beb52fc553459adee, size=64264, generator_module=l, is_cancelled=False, is_priority=False, hash=-5632738472455613515, _constructor_called=True)) 2015-12-15 15:24:48,639 -0500 INFO pid=9827 4651364352:Worker-1 proxy_manager.pyo:354 Removing stale proxy entry from cache 2015-12-15 15:24:48,654 -0500 INFO pid=9827 4651364352:Worker-1 sync_http_client.pyo:236 Opening direct connecton to clients3.google.com:443. 2015-12-15 15:24:49,456 -0500 INFO pid=9827 4651364352:Worker-1 docs_client.pyo:2167 Updating: Christmas Address List.docx (64264 bytes). DocsEntry: <ns0:entry xmlns:ns0="http://www.w3.org/2005/Atom" xmlns:nsl="http://schemas.google.com/g/2005" xmlns:ns2="http://schemas.google.com/docs/2007" xmlns:ns3="http://www.w3.org/2007/app" nsl:etag="&quat;DVQUEhFWDit7ImBl&quot;"><nsl:quataBytesUsed>64192</nsl:quotaBytesUsed> EFTA00502455 <ns0:category label="hidden" scheme="http://schemas.google.com/g/2005/1abels" term="http://schemas.google.com/g/2005/1abels#hidden" /><ns0:category label="has-path-to- root" scheme="http://schemas.google.com/docs/2007" term="http://schemas.google.com/docs/2007#has-path-to-root" /><ns0:category label="application/vnd.openxmlformats-officedocument.wordprocessingml.document" scheme="http://schemas.google.com/g/2005#kind" term="http://schemas.google.com/docs/2007#file" /><ns0:category label="modified-by-me" scheme="http://schemas.google.com/g/2005/1abels" term="http://schemas.google.com/g/2005/1abels#modified-by-me" /><ns0:category label="purgeable" scheme="http://schemas.google.com/g/2005/1abels" term="http://schemas.google.com/g/2005/1abels#purgeable" I> <ns0:id>https://clients3.google.com/feeds/id/file%3AOBxNN8iEiWGvgNE9ONVB6cFhTeG8</ns0:id> <ns2:writersCanlnvite value="true" /><ns0:author><ns0:name>lesley.jee</ns0:name> <ns0:email>lesley.jee@gmail.com</ns0:email></ns0:author><ns0:content src="https://doc-14-bc- docs.googleusercontent.com/docs/securesc/rsu4vkf416fjahebskrbestclo213ea4g/4g6ifrkqqjtkk3grlid 77i8enemhgag5/1450209600000/07946446228801835265/07946446228801835265/OBxNN8iEiWGvgNE9ONVB6cF hTeG8?e=download&amp;gd=true" type="application/vnd.openxmlformats- officedocument.wordprocessingml.document" /><ns0:updated>2015-12-15T20:24:44</ns0:updated> <ns0:published>2015-08-25T21:52:59.471E</ns0:published><nsl:lastModifiedBy> <ns0:name>lesley.jee</ns0:name><ns0:email>lesley.jee@gmail.com</ns0:email> </nsl:lastModifiedBy><ns0:title>Christmas Address List.docx</ns0:title> <nsl:resourceId>file:0B501N8iEiNGvgNE9ONVB6cFhTeG8</nsl:resourceId><ns0:link href="https://clients3.google.com/feeds/default/private/full/folder%3A0BxNN8iEiNGvgRjcxNnBhRm 5nVlk" rel="http://schemas.google.com/docs/2007#parent" type="application/atom+xml" <ns0:link href="https://drive.google.com/file/d/0WENN8iEiWGvgNE90NVB6cFhTeG8/view? usp=docslist_api" rel="alternate" type="text/html" /><ns0:link href="https://ssl.gstatic.com/docs/doclist/images/icon_10_word_list.png" rel="http://schemas.google.com/docs/2007#icon" type="image/png" /><ns0:link href="https://clients3.google.com/feeds/upload/create- session/default/private/full/file%3A0BxNN8iEiNGvgNE9ONVB6cFhTeG8?new- revision=true&amp;override-modified-timestamp=true&amp;force-modified-timestamp=true" rel="http://schemas.google.com/g/2005#resumable-edit-media" type="application/atom+xml" I> <ns0:link href="https://clients3.google.com/feeds/upload/file/default/private/full/file%3A0BxNN8iEiWGvg NE9ONVB6cFhTeG8" rel="http://schemas.google.com/docs/2007#alt-edit-media" type="application/atom+xml" /><ns0:link href="https://1h3.googleusercontent.com/hvWwz42_3W7OGAeYpEWgsUviN7GMxJ9So6PF1RbfluonG4uLwH5E b-wwlRp_OYx3WYQQA=s220" rel="http://schemas.google.com/docs/2007/thumbnail" type="image/png" /><ns0:link href="https://drive.google.com/sharing/share? subapp=10&amp;id=011xNN8iEiWGvgNE9ONVB6cFhTeG8fiamp;shareProtocolVersion=2&amp;foreignService=g oogledrivesync&amp;command=settings&amp;shareUiType=default&amp;authuser=0&amp;client=desktop &amp;hl=en" rel="http://schemas.google.com/docs/2007#share" type="text/html" /><ns0:link href="https://clients3.google.com/feeds/default/private/full/file%3A0BxNN8iEiWGvgNE90NVB6cFhT eG8" rel="self" type="application/atom+xml" /><ns0:link href="https://clients3.google.com/feeds/default/private/full/file%3A0BxNN8iEiWGvgNE90NVB6cFhT eG8?new-revision=true&amp;override-modified-timestamp=true&amp;force-modified-timestamp=true" rel="edit" type="application/atom+xml" /><ns0:link href="https://clients3.google.com/feeds/default/media/file%3A0BxNN8iEiNGvgNE9ONVB6cFhTeG8" rel="edit-media" type="application/vnd.openxmlformats- officedocument.wordprocessingml.document" /><nsl:feedLink href="https://clients3.google.com/feeds/default/private/full/file%3A0BxNN8iEiWGvgNE90NVB6cFhT eG8/acl" rel="http://schemas.google.com/ac1/2007#accessControlList" /><nsl:feedLink href="https://clients3.google.com/feeds/default/private/full/file%3A0BxNN8iEiWGvgNE90NVB6cFhT eG8/revisions" rel="http://schemas.google.com/docs/2007/revisions" /><ns3:edited>2015-08- 25T21:52:59.8782.</ns3:edited><ns2:isShareable value="true" /><ns2:isShareableByMe value="true" /><ns2:modifiedByMeDate>2015-01-27T21:32:40.0002.</ns2:modifiedByMeDate> <ns2:md5Checksum>8987331b8014893a19eab0c6c63afeba</ns2:md5Checksum><ns2:filename>Christmas Address List.docx</ns2:filename><ns2:suggestedFilename>Christmas Address List.docx</ns2:suggestedFilename><ns2:size>64192</ns2:size></ns0:entry> 2015-12-15 15:24:49,460 -0500 INFO pid=9827 4651364352:Worker-1 proxy_manager.pyo:354 Removing stale proxy entry from cache 2015-12-15 15:24:49,460 -0500 INFO pid=9827 4651364352:Worker-1 sync_http_client.pyo:236 Opening direct connecton to upload.drive.google.com:443. 2015-12-15 15:24:50,967 -0500 INFO pid=9827 4584058880:ListenerScheduler invalidation_listener.pyo:82 InvalidationListener.Invalidation(1014:CHANGELOG, EFTA00502456 wapi_version=76096) 2015-12-15 15:24:50,969 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:711 Getting changes; observed: 76096, retrieved: 76089 2015-12-15 15:24:50,986 -0500 INFO pid=9827 4651364352:Worker-1 snapshot_sqlite.pyo:253 Updating cloud entry doc_id=0BxNN8iEiWGvgNE9ONVB6cFhTeG8, filename=None 2015-12-15 15:24:50,987 -0500 INFO pid=9827 4651364352:Worker-1 snapshot_sqlite.pyo:230 Updating local entry inode=14455808, modified=1450211084, checksum=7f5ad4aabbbc422beb52fc553459adee, size=64264 2015-12-15 15:24:50,993 -0500 INFO pid=9827 4651364352:Worker-1 workers.pyo:194 Worker successfully completed [ImmutableChange(Direction.UPLOAD, Action.MODIFY, ino=14455808, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'Christmas Address List.docx', parent_ino=14390475, new_ino=14455808, is_folder=False, unparents_shared=False, modified=1450211084, checksum=7f5ad4aabbbc422beb52fc553459adee, size=64264, generator_module=l, is_cancelled=False, is_priority=False, hash=-5632738472455613515, _constructor_called=True)) 2015-12-15 15:24:51,496 -0500 INFO pid=9827 4584058880:ListenerScheduler invalidation_listener.pyo:82 Invalidationlistener.Invalidation(1014:CHANGELOG, wapi_version=76098) 2015-12-15 15:24:51,609 -0500 INFO pid=9827 4621918208:Batcher batcher.pyo:239 Current batch is completed. Batcher snooze. 2015-12-15 15:24:51,609 -0500 INFO pid=9827 4621918208:Batcher sync_status.pyo:133 Reset sync status 2015-12-15 15:24:51,631 -0500 INFO pid=9827 4621918208:Batcher batcher.pyo:855 Batcher Stats = file_count = Counter (f_COUNT_KEY Cdirection=_UploadDirectionType (Direction. UPLOAD), action=_FSChangeActionType(Action.MODIFY), batch=False, successful=True): 1)), byte_count = Counter (f_COUNT_KEY Cdirection=_UploadDirectionType (Direction. UPLOAD), action=_FSChangeActionType(Action.MODIFY), batch=False, successful=True): 64264)), batch_operation_count = Counter(), process_seconds = Counter (f_COUNT_KEY Cdirection=_UploadDirectionType (Direction. UPLOAD), action=_FSChangeActionType(Action.MODIFY), batch=False, successful=True): 2.3840839862823486)), duration seconds = 3 (start_time = 1450211088, end_time = 1450211091) 2015-12-15 15:24:51,644 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:1026 Getting cloud resources via changelog feed from 76090 2015-12-15 15:24:51,644 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:743 Requesting Doc List: /feeds/default/private/changes?start-index=76090&showroot=true&include- shared=true&reason=change 2015-12-15 15:24:51,645 -0500 INFO pid=9827 4596678656:CloudWatcher sync_http_client.pyo:236 Opening direct connecton to clients3.google.com:443. 2015-12-15 15:24:51,843 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:1174 Feed has 1 entries 2015-12-15 15:24:51,843 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:1181 End of feed, no next URI 2015-12-15 15:24:51,844 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:1645 Built recent change dict: f'OBxNN8iEiWGvgNE9ONVB6cFhTeG8': (WorkerModifyCloudEvent(modify_time=1450211084, size=64264, checksum=7f5ad4aabbbc422beb52fc553459adee, doc_id=0BxNN8iEiWGvgNE9ONVB6cFhTeG8, server_mod_time=1450211090, version=None, _hash_code=8071967001658603640)]) 2015-12-15 15:24:51,878 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:1368 GenerateCreateForDescendents() entry CloudEntry(doc_id=0BxNN8iEiWGvgNE9ONVB6cFhTeG8,filename=Christmas Address List.docx,modified=1450211084,created=1440539579,acl_role=owner,doc_type=DocType.BLOB,removed =False,parent_doc_ids=set([ 1 0BxNN8iEiWGvgRjcxNnBhRm5nVlk']),child_doc_ids=set([]),size=64264, checksum=7f5ad4aabbbc422beb52fc553459adee,change_stamp=76098,server_mod_time=1450211090,is_zo mbie=False,shared=False,recursive_size=None,resource_type=file,version=None) parents_added set([)) 2015-12-15 15:24:51,887 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:198 HandleSyncConfigSettingsChange generated events=set([]) 2015-12-15 15:24:56,888 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:716 Change ignored. observed: 76098, retrieved: 76098 2015-12-15 15:30:11,404 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 15:31:25,884 -0500 INFO pid=9827 4563025920:FilewatcherMonitor watcher.pyo:550 PathsCallback called with: [u'/Users/lgroff/Google Drive/', u'/Users/lgroff/Google Drive/My EFTA00502457 Documents (1)/.] 2015-12-15 15:31:25,898 -0500 INFO pid=9827 4563025920:FilewatcherMonitor diff_helper.pyo:86 Scanning: (u'/Users/lgroff/Google Drive', u'/Users/lgroff/Google Drive/My Documents Cl)'] 2015-12-15 15:31:25,974 -0500 INFO pid=9827 4563025920:FilewatcherMonitor diff_helper.pyo:133 Found 1 changes: ][FSChange(Direction.UPLOAD, Action.MODIFY, ino=14455808, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'Christmas Address List.docx', parent_ino=14390475, new_ino=14455808, is_folder=False, unparents_shared=False, modified=1450211484, checksum=4b2ffcf3a6716d3fc3d7862b9e0de6ee, size=64531, generator_module=1, is_cancelled=False, is_priority=False)]] 2015-12-15 15:31:25,975 -0500 INFO pid=9827 4563025920:FilewatcherMonitor aggregator.pyo:108 > Received event ImmutableRawEvent(op=MODIFY, path=/Users/lgroff/Google Drive/My Documents (1)/Christmas Address List.docx, time=1450211485.98, is_dir=False, ino=14455808, size=64531, oldpath=None, new_ino=14455808, mtime=1450211484, parent_ino=14390475, affects_gdoc=None, is_cancelled=RawEventIsCancelledFlag. FALSE, old_parent_ino=None, _hash_ code=1954305182698566771) FSChange(Direction.UPLOAD, Action.MODIFY, ino=14455808, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'Christmas Address List.docx', parent_ino=14390475, new_ino=14455808, is_folder=False, unparents_shared=False, modified=1450211484, checksum=4b2ffcf3a6716d3fc3d7862b9e0de6ee, size=64531, generator_module=1, is_cancelled=False, is_priority=False) 2015-12-15 15:31:25,975 -0500 INFO pid=9827 4563025920:FilewatcherMonitor change_buffer.pyo:1042 Adding change and event to change buffer: FSChange(Direction.UPLOAD, Action.MODIFY, ino=14455808, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'Christmas Address List.docx', parent_ino=14390475, new_ino=14455808, is_folder=False, unparents_shared=False, modified=1450211484, checksum=4b2ffcf3a6716d3fc3d7862b9e0de6ee, size=64531, generator_module=l, is_cancelled=False, is_priority=False) ImmutableRawEvent(op=MODIFY, path=/Users/lgroff/Google Drive/My Documents (1)/Christmas Address List.docx, time=1450211485.98, is_dir=False, ino=14455808, size=64531, old_path=None, new_ino=14455808, mtime=1450211484, parent_ino=14390475, affects_gdoc=None, is_cancelled=RawEventIsCancelledFlag.FALSE, old_parent_ino=None, _hash_code=1954305182698566771) 2015-12-15 15:31:26,959 -0500 INFO pid=9827 4563025920:FilewatcherMonitor watcher.pyo:550 PathsCallback called with: [u'/Users/lgroff/Google Drive/My Documents (1),O] 2015-12-15 15:31:26,959 -0500 INFO pid=9827 4563025920:FilewatcherMonitor diff_helper.pyo:86 Scanning: (u'/Users/lgroff/Google Drive/My Documents (1)'] 2015-12-15 15:31:28,434 -0500 INFO pid=9827 4588265472:Worker-0 workers.pyo:183 Worker starting on (ImmutableChange(Direction.UPLOAD, Action.MODIFY, ino=14455808, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'Christmas Address List.docx', parent_ino=14390475, new_ino=14455808, is_folder=False, unparents_shared=False, modified=1450211484, checksum=4b2ffcf3a6716d3fc3d7862b9e0de6ee, size=64531, generator_module=l, is_cancelled=False, is_priority=False, hash=-877068704417056567, _constructor_called=True)] 2015-12-15 15:31:28,437 -0500 INFO pid=9827 4588265472:Worker-0 proxy_manager.pyo:354 Removing stale proxy entry from cache 2015-12-15 15:31:28,437 -0500 INFO pid=9827 4588265472:Worker-0 sync_http_client.pyo:236 Opening direct connecton to clients3.google.com:443. 2015-12-15 15:31:28,620 -0500 INFO pid=9827 4588265472:Worker-0 docs_client.pyo:2167 Updating: Christmas Address List.docx (64531 bytes). DocsEntry: <ns0:entry xmlns:ns0="http://www.w3.org/2005/Atom" xmlns:nsl="http://schemas.google.com/g/2005" xmlns:ns2="http://schemas.google.com/docs/2007" xmlns:ns3="http://www.w3.org/2007/app" nsl:etag="&quot;ABEWGBMIAyt7ImBl&quot;"><nsl:quotaBytesUsed>64264</nsl:quotaBytesUsed> <ns0:category label="hidden" scheme="http://schemas.google.com/g/2005/labels" term="http://schemas.google.com/g/2005/labels#hidden" /><ns0:category label="has-path-to- root" scheme="http://schemas.google.com/docs/2007" term="http://schemas.google.com/docs/2007#has-path-to-root" /><ns0:category label="application/vnd.openxmlformats-officedocument.wordprocessingml.document" scheme="http://schemas.google.com/g/2005#kind" term="http://schemas.google.com/docs/2007#file" /><ns0:category label="modified-by-me" scheme="http://schemas.google.com/g/2005/1abels" term="http://schemas.google.com/g/2005/labels#modified-by-me" /><ns0:category label="purgeable" scheme="http://schemas.google.com/g/2005/1abels" term="http://schemas.google.com/g/2005/1abels#purgeable" /> <ns0:id>https://clients3.google.com/feeds/id/file%3A0BxNN8iEiWGvgNE9ONVB6cFhTeG8</ns0:id> <ns2:writersCanlnvite value="true" /><ns0:author><ns0:name>lesley.jee</ns0:name> <ns0:email>lesley.jee@gmail.com</ns0:email></ns0:author><ns0:content src="https://doc-14-bc- docs.googleusercontent.com/docs/securesc/rsu4vkf416fjahebskrbestclo213ea4g/4g6ifrkqqjtkk3grlid EFTA00502458 77i8enemhgag5/14502O9600OO0/079464462288O1835265/O7946446228801835265/OBxNN8iEiWGvgNE9ONVB6cF hTeG8?e=download&amp;gd=true" type="application/vnd.openxmlformats- officedocument.wordprocessingml.document" /><ns0:updated>2015-12-1572O:31:24</ns0:updated> <ns0:published>2015-O8-25T21:52:59.4712</ns0:published><nsl:lastModifiedBy> <ns0:name>lesley.jee</nsO:name><nsO:email>lesley.jee@gmail.com</ns0:email> </nsl:lastModifiedlay><nsO:title>Christmas Address List.docx</ns0:title> <nsl:resourceId>file:012401N8iEiWGvgNE9ONVB6cFhTeG8</nsl:resourceId><ns0:link href="https://clients3.google.com/feeds/default/private/full/folder%3AOBxNN8iEiWGvgRjcxNnBhRm 5nVlk" rel="http://schemas.google.com/docs/2OO7#parent" type="application/atom+xml" <ns0:link href="https://drive.google.com/file/d/0WENN8iEiWGvgNE9ONVB6cFhTeG8/view? usp=docslist_api" rel="alternate" type="text/html" /><ns0:link href="https://ssl.gstatic.com/docs/doclist/images/icon_10_word_list.png" rel="http://schemas.google.com/docs/2007#icon" type="image/png" /><nsO:link href="https://clients3.google.com/feeds/upload/create- session/default/private/full/file%3A0BxNN8iEiWGvgNE9ONVB6cFhTeG8?new- revision=true&amp;override-modified-timestamp=true&amp;force-modified-timestamp=true" rel="http://schemas.google.com/g/2OO5#resumable-edit-media" type="application/atom+xml" I> <ns0:link href="https://clients3.google.com/feeds/upload/file/default/private/full/file%3AOBxNN8iEiWGvg NE9ONVB6cFhTeG8" rel="http://schemas.google.com/docs/2OO7#alt-edit-media" type="application/atom+xml" /><ns0:link href="https://1h4.googleusercontent.com/u4- p0BCi9rR_bpJserrAA3Vbqi03gif48ciDgwscNRSXG_gXcpmjwIRu8fzI-zWvsFDT-1g=s220" rel="http://schemas.google.com/docs/2007/thumbnail" type="image/png" /><nsO:link href="https://drive.google.com/sharing/share? subapp=10&amp;id=011xNN8iEiWGvgNE9ONVB6cFhTeG8fiamp;shareBrotocolVersion=2&amp;foreignService=g oogledrivesync&amp;command=settings&amp;shareUiType=default&amp;authuser=0&amp;client=desktop &amp;hl=en" rel="http://schemas.google.com/docs/2OO7#share" type="text/html" /><ns0:link href="https://clients3.google.com/feeds/default/private/full/file%3A0BxNN8iEiWGvgNE9ONVB6cFhT eG8" rel="self" type="application/atom+xml" /><nsO:link href="https://clients3.google.com/feeds/default/private/full/file%3A0BxNN8iEiWGvgNE9ONVB6cFhT eG8?new-revision=true&amp;override-modified-timestamp=true&amp;force-modified-timestamp=true" rel="edit" type="application/atom+xml" /><nsO:link href="https://clients3.google.com/feeds/default/media/file%3A0BxNN8iEiWGvgNE9ONVB6cFhTeG8" rel="edit-media" type="application/vnd.openxmlformats- officedocument.wordprocessingml.document" /><nsl:feedLink href="https://clients3.google.com/feeds/default/private/full/file%3A0BxNN8iEiWGvgNE9ONVB6cFhT eG8/acl" rel="http://schemas.google.com/ac1/2O07#accessControlList" /><nsl:feedLink href="https://clients3.google.com/feeds/default/private/full/file%3A0BxNN8iEiWGvgNE9ONVB6cFhT eG8/revisions" rel="http://schemas.google.com/docs/2007/revisions" /><ns3:edited>2015-12- 15T2O:24:5O.6452.</ns3:edited><ns2:isShareable value="true" /><ns2:isShareableByMe value="true" /><ns2:modifiedlayMeDate>2015-12-15T2O:24:44.00O2.</ns2:modifiedByMeDate> <ns2:md5Checksum>7f5ad4aabbbc422beb52fc553459adee</ns2:md5Checksum><ns2:filename>Christmas Address List.docx</ns2:filename><ns2:suggestedFilename>Christmas Address List.docx</ns2:suggestedFilename><ns2:size>64264</ns2:size></ns0:entry> 2015-12-15 15:31:28,625 -O500 INFO pid=9827 4588265472:Worker-0 proxy_manager.pyo:354 Removing stale proxy entry from cache 2015-12-15 15:31:28,626 -O500 INFO pid=9827 4588265472:Worker-0 sync_http_client.pyo:236 Opening direct connecton to upload.drive.google.com:443. 2015-12-15 15:31:30,O81 -O500 INFO pid=9827 4584058880:ListenerScheduler invalidation_listener.pyo:82 InvalidationListener.Invalidation(1O14:CHANGELOG, wapi_version=76102) 2015-12-15 15:31:30,O81 -O500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:711 Getting changes; observed: 761O2, retrieved: 76098 2015-12-15 15:31:30,O84 -O500 INFO pid=9827 4584058880:ListenerScheduler invalidation_listener.pyo:82 InvalidationListener.Invalidation(1O14:CHANGELOG, wapi_version=76101) 2015-12-15 15:31:30,O86 -O500 INFO pid=9827 4588265472:Worker-0 snapshot_sglite.pyo:253 Updating cloud entry doc_id=0RxNN8iEiWGvgNE9ONVB6cFhTeG8, filename=None 2015-12-15 15:31:30,O92 -O500 INFO pid=9827 4588265472:Worker-0 snapshot_sglite.pyo:230 Updating local entry inode=14455808, modified=1450211484, checksum=4b2ffcf3a6716d3fc3d7862b9e0de6ee, size=64531 2015-12-15 15:31:30,129 -O500 INFO pid=9827 4588265472:Worker-0 workers.pyo:194 Worker successfully completed (ImmutableChange(Direction.URLOAD, Action.MODIFY, ino=14455808, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'Christmas Address List.docx', EFTA00502459 parent_ino=14390475, new_ino=14455808, is_folder=False, unparents_shared=False, modified=1450211484, checksum=4b2ffcf3a6716d3fc3d7862b9e0de6ee, size=64531, generator_module=l, is_cancelled=False, is_priority=False, hash=-877068704417056567, _constructor_called=True)) 2015-12-15 15:31:30,414 -0500 INFO pid=9827 4621918208:Batcher batcher.pyo:239 Current batch is completed. Batcher snooze. 2015-12-15 15:31:30,414 -0500 INFO pid=9827 4621918208:Batcher sync_status.pyo:133 Reset sync status 2015-12-15 15:31:30,415 -0500 INFO pid=9827 4621918208:Batcher batcher.pyo:855 Batcher Stats = file_count = Counter (f_COUNT_KEY Cdirection=_UploadDirectionType (Direction. UPLOAD), action=_FSChangeActionType(Action.MODIFY), batch=False, successful=True): 1)), byte_count = Counter (f_COUNT_KEY (direction=_UploadDirectionType (Direction. UPLOAD), action=_FSChangeActionType(Action.MODIFY), batch=False, successful=True): 64531)), batch_operation_count = Counter(), process_seconds = Counter (f_COUNT_KEY (direction=_UploadDirectionType (Direction. UPLOAD), action=_FSChangeActionType(Action.MODIFY), batch=False, successful=True): 1.694854974746704)), duration seconds = 2 (start_time = 1450211488, end_time = 1450211490) 2015-12-15 15:31:30,415 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:1026 Getting cloud resources via changelog feed from 76099 2015-12-15 15:31:30,415 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:743 Requesting Doc List: /feeds/default/private/changes?start-index=76099&showroot=true&include- shared=true&reason=change 2015-12-15 15:31:30,416 -0500 INFO pid=9827 4596678656:CloudWatcher sync_http_client.pyo:236 Opening direct connecton to clients3.google.com:443. 2015-12-15 15:31:30,467 -0500 INFO pid=9827 4584058880:ListenerScheduler invalidation_listener.pyo:82 wapi_version=76103) InvalidationListener.Invalidation(1014:CHANGELOG, 2015-12-15 15:31:30,604 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:1174 Feed has 1 entries 2015-12-15 15:31:30,605 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:1181 End of feed, no next URI 2015-12-15 15:31:30,605 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:1645 Built recent change dict: ('0BxNN8iEiWGvgNE9ONVB6cFhTeG8': (WorkerModifyCloudEvent(modify_time=1450211484, size=64531, checksum=4b2ffcf3a6716d3fc3d7862b9e0defiee, doc_id=0BxNN8iEiWGvgNE90NVB6cFhTeG8, server_mod_time=1450211489, version=None, _hash_code=1688743456284125647)]) 2015-12-15 15:31:30,607 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:1368 GenerateCreateForDescendents() entry CloudEntry(doc_id=0BxNN8iEiWGvgNE9ONVB6cFhTeG8,filename=Christmas Address List.docx,modified=1450211484,created=1440539579,acl_role=owner,doc_type=DocType.BLOB,removed =False,parent_doc_ids=set([ 1 0BxNN8iEiWGvgRjcxNnBhRm5nUlk']),child_doc_ids=set(()),size=64531, checksum=4b2ffcf3a6716d3fc3d7862b9e0de6ee,change_stamp=76103,server_mod_time=1450211489,is_zo mbie=False,shared=False,recursive_size=None,resource_type=file,version=None) parents_added set([)) 2015-12-15 15:31:30,621 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:198 HandleSyncConfigSettingsChange generated events=set(()) 2015-12-15 15:31:35,621 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:716 Change ignored. observed: 76103, retrieved: 76103 2015-12-15 15:45:11,401 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 16:00:11,417 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 16:15:06,182 -0500 INFO pid=9827 4546482176:ThreadMonitor thread_manager.pyo:339 Waking up. 2015-12-15 16:15:06,352 -0500 INFO pid=9827 4546482176:ThreadMonitor thread_manager.pyo:336 Waiting on exit condition. Wake up after 3600s. 2015-12-15 16:15:10,382 -0500 INFO pid=9827 4626124800:PauseTelemetryThread pause_telemetry.pyo:185 Collected 7.04272533721h of telemetry at t=1450214110.38, skipping. 2015-12-15 16:15:10,383 -0500 INFO pid=9827 4609298432:PushTelemetryThread telemetry.pyo:167 PushStates.ONLINE: +3600 => 25196.5 2015-12-15 16:15:10,383 -0500 INFO pid=9827 4609298432:PushTelemetryThread telemetry.pyo:112 Push telemetry harvest triggered, but only 25200.0549556s elapsed. Skipping. 2015-12-15 16:15:11,431 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo:44 Checking Telemetry store size. EFTA00502460 2015-12-15 16:30:11,545 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 16:45:11,568 -0500 INFO pid=9827 4613505024:TelemetryStoreSizeMonitorThread telemetry_store_monitor_thread.pyo: 44 Checking Telemetry store size. 2015-12-15 16:50:34,112 -0500 INFO pid=9827 4563025920:FilewatcherMonitor watcher.pyo:550 PathsCallback called with: (u'/Users/lgroff/Google Drive/My Documents (1)1', u'/Users/lgroff/Google Drive/1) 2015-12-15 16:50:34,128 -0500 INFO pid=9827 4563025920:FilewatcherMonitor diff_helper.pyo:86 Scanning: (u'/Users/lgroff/Google Drive/My Documents (1)', u'/Users/lgroff/Google Drive'] 2015-12-15 16:50:35,210 -0500 INFO pid=9827 4563025920:FilewatcherMonitor diff_helper.pyo:133 Found 1 changes: ((FSChange(Direction.UPLOAD, Action.MODIFY, ino=15425403, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'2015 December.docx', parent_ino=14390475, new_ino=15425403, is_folder=False, unparents_shared=False, modified=1450216232, checksum=a34e38b656f4e351bb917909bbc4aa5c, size=57397, generator_module=1, is_cancelled=False, is_priority=False))) 2015-12-15 16:50:35,211 -0500 INFO pid=9827 4563025920:FilewatcherMonitor aggregator.pyo:108 > Received event ImmutableRawEvent(op=MODIFY, path=/Users/lgroff/Google Drive/My Documents (1)/2015 December.docx, time=1450216235.21, is_dir=False, ino=15425403, size=57397, old_path=None, new_ino=15425403, mtime=1450216232, parent_ino=14390475, affects_gdoc=None, is_cancelled=RawEventIsCancelledFlag.FALSE, old_parent_ino=None, _hash_ code=-5157172622572156727) FSChange(Direction.UPL0AD, Action.MODIFY, ino=15425403, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'2015 December.docx', parent_ino=14390475, new_ino=15425403, is_folder=False, unparents_shared=False, modified=1450216232, checksum=a34e38b656f4e351bb917909bbc4aa5c, size=57397, generator_module=1, is_cancelled=False, is_priority=False) 2015-12-15 16:50:35,215 -0500 INFO pid=9827 4563025920:FilewatcherMonitor change_buffer.pyo:1042 Adding change and event to change buffer: FSChange(Direction.UPLOAD, Action.MODIFY, ino=15425403, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'2015 December.docx', parent_ino=14390475, new_ino=15425403, is_folder=False, unparents_shared=False, modified=1450216232, checksum=a34e38b656f4e351bb917909bbc4aa5c, size=57397, generator_module=1, is_cancelled=False, is_priority=False) ImmutableRawEvent(op=MODIFY, path=/Users/lgroff/Google Drive/My Documents (1)/2015 December.docx, time=1450216235.21, is_dir=False, ino=15425403, size=57397, old_path=None, new_ino=15425403, mtime=1450216232, parent_ino=14390475, affects_gdoc=None, is_cancelled=RawEventIsCancelledFlag.FALSE, old_parent_ino=None, _hash_code=-5157172622572156727) 2015-12-15 16:50:35,219 -0500 INFO pid=9827 4563025920:FilewatcherMonitor watcher.pyo:550 PathsCallback called with: (u'/Users/lgroff/Google Drive/My Documents (1)1', u'/Users/lgroff/Google Drive/1) 2015-12-15 16:50:35,257 -0500 INFO pid=9827 4563025920:FilewatcherMonitor diff_helper.pyo:86 Scanning: (u'/Users/lgroff/Google Drive/My Documents (1)', u'/Users/lgroff/Google Drive'] 2015-12-15 16:50:36,117 -0500 INFO pid=9827 4563025920:FilewatcherMonitor watcher.pyo:550 PathsCallback called with: (u'/Users/lgroff/Google Drive/', u'/Users/lgroff/Google Drive/My Documents (1)/') 2015-12-15 16:50:36,118 -0500 INFO pid=9827 4563025920:FilewatcherMonitor diff_helper.pyo:86 Scanning: (u'/Users/lgroff/Google Drive', u'/Users/lgroff/Google Drive/My Documents Cl)'] 2015-12-15 16:50:37,619 -0500 INFO pid=9827 4630331392:Worker-2 workers.pyo:183 Worker starting on (ImmutableChange(Direction.UPLOAD, Action.MODIFY, ino=15425403, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'2015 December.docx', parent_ino=14390475, new_ino=15425403, is_folder=False, unparents_shared=False, modified=1450216232, checksum=a34e38b656f4e351bb917909bbc4aa5c, size=57397, generator_module=1, is_cancelled=False, is_priority=False, hash=2223939148152275148, _constructorcalled=True)) 2015-12-15 16:50:37,715 -0500 INFO pid=9827 4630331392:Worker-2 proxy_manager.pyo:354 Removing stale proxy entry from cache 2015-12-15 16:50:37,717 -0500 INFO pid=9827 4630331392:Worker-2 sync_http_client.pyo:236 Opening direct connecton to accounts.google.com:443. 2015-12-15 16:50:38,295 -0500 INFO pid=9827 4630331392:Worker-2 proxy_manager.pyo:354 Removing stale proxy entry from cache 2015-12-15 16:50:38,296 -0500 INFO pid=9827 4630331392:Worker-2 sync_http_client.pyo:236 Opening direct connecton to clients3.google.com:443. 2015-12-15 16:50:39,118 -0500 INFO pid=9827 4630331392:Worker-2 docs client.pyo:2167 Updating: 2015 December.docx (57397 bytes). DocsEntry: <ns0:entry xmlns:ns0="http://www.w3.org/2005/Atom" xmlns:nsl="http://schemas.google.com/g/2005" xmlns:ns2="http://schemas.google.com/docs/2007" xmlns:ns3="http://www.w3.org/2007/app" EFTA00502461 nsl:etag="&quot;ABEMVAldHSt7ImBl&quot;"><nsl:quotaBytesUsed>57255</nsl:quotaBytesUsed> <ns0:category label="hidden" scheme="http://schemas.google.com/g/2005/labels" term="http://schemas.google.com/g/2005/labels#hidden" /><ns0:category label="has-path-to- root" scheme="http://schemas.google.com/docs/2007" term="http://schemas.google.com/docs/2007#has-path-to-root" /><ns0:category label="application/vnd.openxmlformats-officedocument.wordprocessingml.document" scheme="http://schemas.google.com/g/2005#kind" term="http://schemas.google.com/docs/2007#file" /><ns0:category label="modified-by-me" scheme="http://schemas.google.com/g/2005/1abels" term="http://schemas.google.com/g/2005/labels#modified-by-me" /><ns0:category label="viewed" scheme="http://schemas.google.com/g/2005/1abels" term="http://schemas.google.com/g/2005/1abels#viewed" /><ns0:category label="purgeable" scheme="http://schemas.google.com/g/2005/1abels" term="http://schemas.google.com/g/2005/1abels#purgeable" I> <ns0:id>https://clients3.google.com/feeds/id/file%3A0BxNN8iEiWGvgRF1wTG9EcDJ1ZFk</ns0:id> <ns2:writersCanlnvite value="true" /><ns0:author><ns0:name>lesley.jee</ns0:name> <ns0:email>lesley.jee@gmail.com</ns0:email></ns0:author><ns0:content src="https://doc-0k-bc- docs.googleusercontent.com/docs/securesc/rsu4vkf416fjahebskrbestclo213ea4g/60psfclb3fc3larl6bo djmm7olnvm92c/1450209600000/07946446228801835265/07946446228801835265/OBxNN8iEiWGvgRFlwTG9EcD J1ZFIOe=download&amp;gd=true" type="application/vnd.openxmlformats- officedocument.wordprocessingml.document" /><ns0:updated>2015-12-15T21:50:32</ns0:updated> <ns0:published>2015-11-17T15:43:03.8902</ns0:published><nsl:lastViewed>2015-12- 15T12:50:26.5302.</nsl:lastViewed><nsl:lastModifiedBy><ns0:name>lesley.jee</ns0:name> <ns0:email>lesley.jee@gmail.com</ns0:email></nsl:lastModifiedBy><ns0:title>2015 December.docx</ns0:title><nsl:resourceld>file:OBxNN8iEiWGvgRF1wTG9EcDJl2Fk</nsl:resourceld> <ns0:link href="https://clients3.google.com/feeds/default/private/full/folder%3A0BxNN8iEiWGvgRjcxNnEhRm 5nVlk" rel="http://schemas.google.com/docs/2007#parent" type="application/atom+xml" I> <ns0:link href="https://drive.google.com/file/d/0WENN8iEiWGvgRF1wTG9EcDJ1ZFk/view? usp=docslist_api" rel="alternate" type="text/html" /><ns0:link href="https://ssl.gstatic.com/docs/doclist/images/icon_10_word_list.png" rel="http://schemas.google.com/docs/2007#icon" type="image/png" /><ns0:link href="https://clients3.google.com/feeds/upload/create- session/default/private/full/file%3A0BxNN8iEiWGvgRF1wTG9EcDJIZFk?new- revision=true&amp;override-modified-timestamp=true&amp;force-modified-timestamp=true" rel="http://schemas.google.com/g/2005#resumable-edit-media" type="application/atom+xml" I> <ns0:link href="https://clients3.google.com/feeds/upload/file/default/private/full/file%3A0BxNN8iEiWGvg RF1wTG9EcDJ1ZFk" rel="http://schemas.google.com/docs/2007#alt-edit-media" type="application/atom+xml" /><ns0:link href="https://1h4.googleusercontent.com/jqJyLZ1K3BqkgIuWgYc5P7SiMc31xe9ezHr9YfApIjR6CgmkiceZd 35dSK_2HQuolIv6nE8=s220" rel="http://schemas.google.com/docs/2007/thumbnail" type="image/png" /><ns0:link href="https://drive.google.com/sharing/share? subapp=10&amp;id=011xNN8iEiWGvgRF1wTG9EcDJ1ZFk&amp;shareProtocolVersion=2&amp;foreignService=g oogledrivesync&amp;command=settings&amp;shareUiType=default&amp;authuser=0&amp;client=desktop &amp;hl=en" rel="http://schemas.google.com/docs/2007lshare" type="text/html" /><ns0:link href="https://clients3.google.com/feeds/default/private/full/file%3A0BxNN8iEiWGvgRF1wTG9EcEO1 ZFk" rel="self" type="application/atom+xml" /><ns0:link href="https://clients3.google.com/feeds/default/private/full/file%3A0BxNN8iEiWGvgRF1wTG9EcEO1 ZFk?new-revision=true&amp;override-modified-timestamp=true&amp;force-modified-timestamp=true" rel="edit" type="application/atom+xml" /><ns0:link href="https://clients3.google.com/feeds/default/media/file%3A0BxNN8iEiWGvgRF1wTG9EcDJIZFk" rel="edit-media" type="application/vnd.openxmlformats- officedocument.wordprocessingml.document" /><nsl:feedLink href="https://clients3.google.com/feeds/default/private/full/file%3A0BxNN8iEiWGvgRF1wTG9EcDJ1 ZFk/acl" rel="http://schemas.google.com/ac1/2007#accessControlList" /><nsl:feedLink href="https://clients3.google.com/feeds/default/private/full/file%3A0BxNN8iEiWGvgRF1wTG9EcDJ1 ZFk/revisions" rel="http://schemas.google.com/docs/2007/revisions" /><ns3:edited>2015-12- 15T17:53:15.8112.</ns3:edited><ns2:isShareable value="true" /><ns2:isShareableByMe value="true" /><ns2:modifiedByMeDate>2015-12-15T16:31:05.0002.</ns2:modifiedByMeDate> <ns2:md5Checksum>4aa87cdc7bb301bad7befb5e28dal4df</ns2:md5Checksum><ns2:filename>2015 December.docx</ns2:filename><ns2:suggestedFilename>2015 December.docx</ns2:suggestedFilename> <ns2:size>57255</ns2:size></ns0:entry> 2015-12-15 16:50:39,324 -0500 INFO pid=9827 4630331392:Worker-2 proxy_manager.pyo:354 Removing stale proxy entry from cache EFTA00502462 2015-12-15 16:50:39,325 -0500 INFO pid=9827 4630331392:Worker-2 sync_http_client.pyo:236 Opening direct connecton to upload.drive.google.com:443. 2015-12-15 16:50:40,844 -0500 INFO pid=9827 4584058880:ListenerScheduler invalidation_listener.pyo:82 InvalidationListener.Invalidation(1014:CHANGELOG, wapi_version=76107) 2015-12-15 16:50:40,845 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:711 Getting changes; observed: 76107, retrieved: 76103 2015-12-15 16:50:40,863 -0500 INFO pid=9827 4630331392:Worker-2 snapshot_sqlite.pyo:253 Updating cloud entry doc_id=0BxNN8iEiWGvgRF1wTG9EcDJ1KFk, filename=None 2015-12-15 16:50:40,864 -0500 INFO pid=9827 4630331392:Worker-2 snapshot_sqlite.pyo:230 Updating local entry inode=15425403, modified=1450216232, checksum=a34e38b656f4e351bb917909bbc4aa5c, size=57397 2015-12-15 16:50:40,924 -0500 INFO pid=9827 4630331392:Worker-2 workers.pyo:194 Worker successfully completed (ImmutableChange(Direction.UPLOAD, Action.MODIFY, ino=15425403, path=u'/Users/lgroff/Google Drive/My Documents (1)', name=u'2015 December.docx', parent_ino=14390475, new_ino=15425403, is_folder=False, unparents_shared=False, modified=1450216232, checksum=a34e38b656f4e351bb917909bbc4aa5c, size=57397, generator_module=l, is_cancelled=False, is_priority=False, hash=2223939148152275148, _constructor_called=True)) 2015-12-15 16:50:40,957 -0500 INFO pid=9827 4584058880:ListenerScheduler invalidation_listener.pyo:82 InvalidationListener.Invalidation(1014:CHANGELOG, wapi_version=76108) 2015-12-15 16:50:41,593 -0500 INFO pid=9827 4621918208:Batcher batcher.pyo:239 Current batch is completed. Batcher snooze. 2015-12-15 16:50:41,593 -0500 INFO pid=9827 4621918208:Batcher sync_status.pyo:133 Reset sync status 2015-12-15 16:50:41,685 -0500 INFO pid=9827 4621918208:Batcher batcher.pyo:855 Batcher Stats = file_count = Counter (f_COUNT_KEY Cdirection=_UploadDirectionType (Direction. UPLOAD), action=_FSChangeActionType(Action.MODIFY), batch=False, successful=True): 1)), byte_count = Counter (f_COUNT_KEY Cdirection=_UploadDirectionType (Direction. UPLOAD), action=_FSChangeActionType(Action.MODIFY), batch=False, successful=True): 57397)), batch_operation_count = Counter(), process_seconds = Counter (f_COUNT_KEY Cdirection=_UploadDirectionType (Direction. UPLOAD), action=_FSChangeActionType(Action.M0DIFY), batch=False, successful=True): 3.335387945175171)), duration seconds = 4 (start_time = 1450216237, end_time = 1450216241) 2015-12-15 16:50:41,688 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:1026 Getting cloud resources via changelog feed from 76104 2015-12-15 16:50:41,688 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:743 Requesting Doc List: /feeds/default/private/changes?start-index=76104&showroot=true&include- shared=true&reason=change 2015-12-15 16:50:41,689 -0500 INFO pid=9827 4596678656:CloudWatcher sync_http_client.pyo:236 Opening direct connecton to clients3.google.com:443. 2015-12-15 16:50:41,764 -0500 INFO pid=9827 4584058880:ListenerScheduler invalidation_listener.pyo:82 wapi_version=76109) InvalidationListener.Invalidation(1014:CHANGELOG, 2015-12-15 16:50:41,971 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:1174 Feed has 1 entries 2015-12-15 16:50:41,971 -0500 INFO pid=9827 4596678656:CloudWatcher docs_client.pyo:1181 End of feed, no next URI 2015-12-15 16:50:41,971 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:1645 Built recent change dict: ( 1 0BxNN8iEiWGvgRF1wTG9EcD.J1KFki: fWorkerModifyCloudEvent(modify_time=1450216232, size=57397, checksum=a34e38b656f4e351bb917909bbc4aa5c, doc_id=OBxNN8iEiWGvgRF1wTG9ECDJ12Fk, server_mod_time=1450216240, version=None, _hash_code=-7208000590541249145)]) 2015-12-15 16:50:42,087 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:1368 GenerateCreateForDescendents() entry CloudEntry(doc_id=0BxNN8iEiWGvgRF1wTG9EcDJ1ZFk,filename=2015 December.docx,modified=1450216232,created=1447774983,acl_role=owner,doc_type=DocType.BLOB,rem oved=False,parent_doc_ids=set(f 10BxNN8iEiWGvgRjcxNnBhRm5nVlk'D,child_doc_ids=set([]),size=57 397,checksum=a34e38b656f4e351bb917909bbc4aa5c,change_stamp=76109,server_mod_time=1450216240,1 s_zombie=False,shared=False,recursive_size=None,resource_type=file,version=None) parents_added set([)) 2015-12-15 16:50:43,401 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:198 EFTA00502463 HandleSyncConfigSettingsChange generated events=set([]) 2015-12-15 16:50:48,402 -0500 INFO pid=9827 4596678656:CloudWatcher cloud_watcher.pyo:716 Change ignored. observed: 76109, retrieved: 76109 2015-12-15 16:56:00,972 -0500 INFO pid=9827 140735235863312:MainThread sync_app.pyo:1643 Quit called from: File "/Volumes/BuildData/pulse- data/agents/599758/recipes/859788647/base/b/drb/googleclient/apps/vebdrive_sync/osx/dist/Goog le Drive.app/Contents/Resources/ boot .py", line 77, in <module> File "/Volumes/BuildData/pulse- data/agents/599758/recipes/859788647/base/b/drb/googleclient/apps/vebdrive_sync/osx/dist/Goog le Drive.app/Contents/Resources/ boot .py", line 62, 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 "PyObjeTools/AppHelper.pyo", line 235, in runEventLoop File "osx/GSyncAppDelegate.pyo", line 297, in applicationWillTerminate_ File "osx/mac_sync_app_controller.pyo", line 252, in Exit File "common/ui_action_handler.pyo", line 450, in Quit File "common/sync_app.pyo", line 1643, in Quit EFTA00502464