peter3@diros:~/.cache/ubuntuone/log$ cat syncdaemon-exceptions.log.2009-10-13_10-35-50
2009-10-13 10:35:49,442 - ubuntuone.SyncDaemon.ActionQueue - ERROR - OAuth failed: Authentication Error:id: 7
type: ERROR
error {
type: INTERNAL_ERROR
}
peter3@diros:~/.cache/ubuntuone/log$ less syncdaemon.log.2009-10-13_10-35-50
peter3@diros:~/.cache/ubuntuone/log$ cat syncdaemon.log.2009-10-13_10-35-50
2009-10-13 10:35:39,992 - ubuntuone.SyncDaemon.fsm - INFO - loading updated metadata
2009-10-13 10:35:40,141 - ubuntuone.SyncDaemon.fsm - INFO - initialized: idx_path: 7, idx_node_id: 0, shares: 1
2009-10-13 10:35:40,145 - ubuntuone.SyncDaemon.VM - DEBUG - init_root
2009-10-13 10:35:40,175 - ubuntuone.SyncDaemon.HQ - INFO - HashQueue: _hasher started
2009-10-13 10:35:47,675 - ubuntuone.SyncDaemon.DBus - DEBUG - using the real system bus
2009-10-13 10:35:47,692 - ubuntuone.SyncDaemon.DBus - WARNING - Unable to connect to NetworkManager. Assuming we have network.
2009-10-13 10:35:47,692 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_NET_CONNECTED, args:(), kw:{}
2009-10-13 10:35:47,693 - ubuntuone.SyncDaemon.State - DEBUG - INIT --[SYS_NET_CONNECTED]--> INIT_WITH_NETWORK
2009-10-13 10:35:47,694 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_STATE_CHANGED, args:(), kw:{'state': <SyncDaemonState INIT_WITH_NETWORK>}
2009-10-13 10:35:47,715 - ubuntuone.SyncDaemon.DBus - INFO - DBusInterface initialized.
2009-10-13 10:35:47,716 - ubuntuone.SyncDaemon.Main - INFO - Using /home/peter3/Ubuntu One as root dir
2009-10-13 10:35:47,716 - ubuntuone.SyncDaemon.Main - INFO - Using /home/peter3/.local/share/ubuntuone/syncdaemon as data dir
2009-10-13 10:35:47,717 - ubuntuone.SyncDaemon.Main - INFO - Using /home/peter3/.local/share/ubuntuone/shares as shares root dir
2009-10-13 10:35:47,718 - ubuntuone.SyncDaemon.Main - NOTE - ---- MARK (state: INIT_WITH_NETWORK; queues: metadata: 0; content: 0; hash: 0, fsm-cache: hit=1 miss=7) ----
2009-10-13 10:35:47,720 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_WAIT_FOR_LOCAL_RESCAN, args:(), kw:{}
2009-10-13 10:35:47,721 - ubuntuone.SyncDaemon.State - DEBUG - INIT_WITH_NETWORK --[SYS_WAIT_FOR_LOCAL_RESCAN]--> READING_WITH_NETWORK
2009-10-13 10:35:47,722 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_STATE_CHANGED, args:(), kw:{'state': <SyncDaemonState READING_WITH_NETWORK>}
2009-10-13 10:35:47,742 - ubuntuone.SyncDaemon.EQ - DEBUG - Adding inotify watch to '/home/peter3/Ubuntu One'
2009-10-13 10:35:47,744 - ubuntuone.SyncDaemon.Main - NOTE - Local rescan starting...
2009-10-13 10:35:47,745 - ubuntuone.SyncDaemon.local_rescan - INFO - start scan all shares
2009-10-13 10:35:47,762 - ubuntuone.SyncDaemon.local_rescan - DEBUG - process next in queue (len 1)
2009-10-13 10:35:47,765 - ubuntuone.SyncDaemon.local_rescan - DEBUG - _scan_tree: share_path: '/home/peter3/Ubuntu One' path: '/home/peter3/Ubuntu One'
2009-10-13 10:35:47,766 - ubuntuone.SyncDaemon.local_rescan - DEBUG - Path already has watch: '/home/peter3/Ubuntu One'
2009-10-13 10:35:47,767 - ubuntuone.SyncDaemon.INotifyProcessor - DEBUG - Freeze begin: '/home/peter3/Ubuntu One'
2009-10-13 10:35:47,767 - ubuntuone.SyncDaemon.local_rescan - DEBUG - scanning the dir '/home/peter3/Ubuntu One'
2009-10-13 10:35:47,769 - ubuntuone.SyncDaemon.local_rescan - DEBUG - comparing directory '/home/peter3/Ubuntu One'
2009-10-13 10:35:47,770 - ubuntuone.SyncDaemon.local_rescan - DEBUG - Deleting metadata, because of node_id=None, of '/home/peter3/Ubuntu One/backey'
2009-10-13 10:35:47,771 - ubuntuone.SyncDaemon.fsm - DEBUG - delete metadata: path='/home/peter3/Ubuntu One/backey' mdid='9ea2f31b-94f6-4fea-a715-fa0a4b71bc98'
2009-10-13 10:35:47,773 - ubuntuone.SyncDaemon.local_rescan - DEBUG - Deleting metadata, because of node_id=None, of '/home/peter3/Ubuntu One/BlackBoxSaga.txt'
2009-10-13 10:35:47,774 - ubuntuone.SyncDaemon.fsm - DEBUG - delete metadata: path='/home/peter3/Ubuntu One/BlackBoxSaga.txt' mdid='1b3baa00-babb-4013-9a91-c9fc676891c9'
2009-10-13 10:35:47,788 - ubuntuone.SyncDaemon.local_rescan - DEBUG - Deleting metadata, because of node_id=None, of '/home/peter3/Ubuntu One/11-23-08 Sermon.doc'
2009-10-13 10:35:47,789 - ubuntuone.SyncDaemon.fsm - DEBUG - delete metadata: path='/home/peter3/Ubuntu One/11-23-08 Sermon.doc' mdid='fb81c1bb-81ce-4a81-98b3-d26c63d5d2ae'
2009-10-13 10:35:47,790 - ubuntuone.SyncDaemon.local_rescan - DEBUG - Deleting metadata, because of node_id=None, of '/home/peter3/Ubuntu One/doug11_23_08_Sermon.html'
2009-10-13 10:35:47,791 - ubuntuone.SyncDaemon.fsm - DEBUG - delete metadata: path='/home/peter3/Ubuntu One/doug11_23_08_Sermon.html' mdid='775e6aa6-723d-463c-944a-7f9e8b77d81a'
2009-10-13 10:35:47,793 - ubuntuone.SyncDaemon.local_rescan - DEBUG - Deleting metadata, because of node_id=None, of '/home/peter3/Ubuntu One/fan2.pl'
2009-10-13 10:35:47,794 - ubuntuone.SyncDaemon.fsm - DEBUG - delete metadata: path='/home/peter3/Ubuntu One/fan2.pl' mdid='61ee03dc-c72c-4f35-89d2-2fb5d722760f'
2009-10-13 10:35:47,795 - ubuntuone.SyncDaemon.local_rescan - DEBUG - Deleting metadata, because of node_id=None, of '/home/peter3/Ubuntu One/TBirdPersonal.ldif'
2009-10-13 10:35:47,796 - ubuntuone.SyncDaemon.fsm - DEBUG - delete metadata: path='/home/peter3/Ubuntu One/TBirdPersonal.ldif' mdid='af9c60db-9359-41e0-b8a0-f504c8fc6bb4'
2009-10-13 10:35:47,798 - ubuntuone.SyncDaemon.local_rescan - DEBUG - comp yield: file '/home/peter3/Ubuntu One/doug11_23_08_Sermon.html' is new!
2009-10-13 10:35:47,799 - ubuntuone.SyncDaemon.local_rescan - DEBUG - comp yield: file '/home/peter3/Ubuntu One/backey' is new!
2009-10-13 10:35:47,800 - ubuntuone.SyncDaemon.local_rescan - DEBUG - comp yield: file '/home/peter3/Ubuntu One/BlackBoxSaga.txt' is new!
2009-10-13 10:35:47,800 - ubuntuone.SyncDaemon.local_rescan - DEBUG - comp yield: file '/home/peter3/Ubuntu One/TBirdPersonal.ldif' is new!
2009-10-13 10:35:47,801 - ubuntuone.SyncDaemon.local_rescan - DEBUG - comp yield: file '/home/peter3/Ubuntu One/11-23-08 Sermon.doc' is new!
2009-10-13 10:35:47,802 - ubuntuone.SyncDaemon.local_rescan - DEBUG - comp yield: file '/home/peter3/Ubuntu One/fan2.pl' is new!
2009-10-13 10:35:47,803 - ubuntuone.SyncDaemon.INotifyProcessor - DEBUG - Freeze commit: '/home/peter3/Ubuntu One' (12 events)
2009-10-13 10:35:47,805 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_CREATE, args:('/home/peter3/Ubuntu One/doug11_23_08_Sermon.html',), kw:{}
2009-10-13 10:35:47,807 - ubuntuone.SyncDaemon.sync - DEBUG - -:-:- - [-:-] ''/home/peter3/Ubuntu One/doug11_23_08_Sermon.html'' | EVENT: FS_FILE_CREATE:{} with ARGS:('/home/peter3/Ubuntu One/doug11_23_08_Sermon.html',)
2009-10-13 10:35:47,809 - ubuntuone.SyncDaemon.sync - DEBUG - -:-:- - [-:-] ''/home/peter3/Ubuntu One/doug11_23_08_Sermon.html'' | Calling new_local_file
2009-10-13 10:35:47,835 - ubuntuone.SyncDaemon.fsm - DEBUG - create: path='/home/peter3/Ubuntu One/doug11_23_08_Sermon.html' mdid='7301271f-4aea-4257-acc3-93c343fa1559' share_id='' node_id=None is_dir=False
2009-10-13 10:35:47,838 - ubuntuone.SyncDaemon.fsm - DEBUG - set mdid='7301271f-4aea-4257-acc3-93c343fa1559': {'local_hash': '', 'server_hash': ''}
2009-10-13 10:35:47,845 - ubuntuone.SyncDaemon.ActionQueue - DEBUG - MakeFile share:'' node:'7301271f-4aea-4257-acc3-93c343fa1559' MakeFile(marker="'7301271f-4aea-4257-acc3-93c343fa1559'", parent_id="'2e7a4a20-d52f-49fe-a741-2dd0fe62598a'", share_id="''", name="u'doug11_23_08_Sermon.html'") queueing in the META_QUEUE
2009-10-13 10:35:47,846 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_META_QUEUE_WAITING, args:(), kw:{}
2009-10-13 10:35:47,848 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F 7301271f-4aea-4257-acc3-93c343fa1559 [root:7301271f-4aea-4257-acc3-93c343fa1559] ''Ubuntu One/doug11_23_08_Sermon.html'' | Called new_local_file
2009-10-13 10:35:47,850 - ubuntuone.SyncDaemon.State - DEBUG - READING_WITH_NETWORK --[SYS_META_QUEUE_WAITING]--> READING_WITH_NETWORK_WITH_METAQ
2009-10-13 10:35:47,851 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_STATE_CHANGED, args:(), kw:{'state': <SyncDaemonState READING_WITH_NETWORK_WITH_METAQ>}
2009-10-13 10:35:47,871 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_CLOSE_WRITE, args:('/home/peter3/Ubuntu One/doug11_23_08_Sermon.html',), kw:{}
2009-10-13 10:35:47,873 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F 7301271f-4aea-4257-acc3-93c343fa1559 [root:7301271f-4aea-4257-acc3-93c343fa1559] ''Ubuntu One/doug11_23_08_Sermon.html'' | EVENT: FS_FILE_CLOSE_WRITE:{} with ARGS:()
2009-10-13 10:35:47,875 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F 7301271f-4aea-4257-acc3-93c343fa1559 [root:7301271f-4aea-4257-acc3-93c343fa1559] ''Ubuntu One/doug11_23_08_Sermon.html'' | Calling calculate_hash
2009-10-13 10:35:47,877 - ubuntuone.SyncDaemon.HQ - INFO - HashQueue: inserting path '/home/peter3/Ubuntu One/doug11_23_08_Sermon.html' mdid 7301271f-4aea-4257-acc3-93c343fa1559
2009-10-13 10:35:47,878 - ubuntuone.SyncDaemon.HQ.hasher - DEBUG - Hasher: got file to hash: path '/home/peter3/Ubuntu One/doug11_23_08_Sermon.html' mdid 7301271f-4aea-4257-acc3-93c343fa1559
2009-10-13 10:35:47,880 - ubuntuone.SyncDaemon.HQ.hasher - DEBUG - Hasher: path hash pushed: path '/home/peter3/Ubuntu One/doug11_23_08_Sermon.html' hash ('sha1:110a17f6eb421c392fc28d18e7b411509c56b165', 1393436872L, 33107, posix.stat_result(st_mode=33188, st_ino=1052830L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=33107L, st_atime=1255452313, st_mtime=1227577341, st_ctime=1255451922))
2009-10-13 10:35:47,883 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F 7301271f-4aea-4257-acc3-93c343fa1559 [root:7301271f-4aea-4257-acc3-93c343fa1559] ''Ubuntu One/doug11_23_08_Sermon.html'' | Called calculate_hash
2009-10-13 10:35:47,884 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_CREATE, args:('/home/peter3/Ubuntu One/backey',), kw:{}
2009-10-13 10:35:47,886 - ubuntuone.SyncDaemon.sync - DEBUG - -:-:- - [-:-] ''/home/peter3/Ubuntu One/backey'' | EVENT: FS_FILE_CREATE:{} with ARGS:('/home/peter3/Ubuntu One/backey',)
2009-10-13 10:35:47,887 - ubuntuone.SyncDaemon.sync - DEBUG - -:-:- - [-:-] ''/home/peter3/Ubuntu One/backey'' | Calling new_local_file
2009-10-13 10:35:47,889 - ubuntuone.SyncDaemon.fsm - DEBUG - create: path='/home/peter3/Ubuntu One/backey' mdid='9501079a-364d-453c-9305-20724fb31a22' share_id='' node_id=None is_dir=False
2009-10-13 10:35:47,892 - ubuntuone.SyncDaemon.fsm - DEBUG - set mdid='9501079a-364d-453c-9305-20724fb31a22': {'local_hash': '', 'server_hash': ''}
2009-10-13 10:35:47,908 - ubuntuone.SyncDaemon.ActionQueue - DEBUG - MakeFile share:'' node:'9501079a-364d-453c-9305-20724fb31a22' MakeFile(marker="'9501079a-364d-453c-9305-20724fb31a22'", parent_id="'2e7a4a20-d52f-49fe-a741-2dd0fe62598a'", share_id="''", name="u'backey'") queueing in the META_QUEUE
2009-10-13 10:35:47,910 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F 9501079a-364d-453c-9305-20724fb31a22 [root:9501079a-364d-453c-9305-20724fb31a22] ''Ubuntu One/backey'' | Called new_local_file
2009-10-13 10:35:47,911 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_CLOSE_WRITE, args:('/home/peter3/Ubuntu One/backey',), kw:{}
2009-10-13 10:35:47,914 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F 9501079a-364d-453c-9305-20724fb31a22 [root:9501079a-364d-453c-9305-20724fb31a22] ''Ubuntu One/backey'' | EVENT: FS_FILE_CLOSE_WRITE:{} with ARGS:()
2009-10-13 10:35:47,916 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F 9501079a-364d-453c-9305-20724fb31a22 [root:9501079a-364d-453c-9305-20724fb31a22] ''Ubuntu One/backey'' | Calling calculate_hash
2009-10-13 10:35:47,917 - ubuntuone.SyncDaemon.HQ - INFO - HashQueue: inserting path '/home/peter3/Ubuntu One/backey' mdid 9501079a-364d-453c-9305-20724fb31a22
2009-10-13 10:35:47,939 - ubuntuone.SyncDaemon.HQ.hasher - DEBUG - Hasher: got file to hash: path '/home/peter3/Ubuntu One/backey' mdid 9501079a-364d-453c-9305-20724fb31a22
2009-10-13 10:35:47,941 - ubuntuone.SyncDaemon.HQ.hasher - DEBUG - Hasher: path hash pushed: path '/home/peter3/Ubuntu One/backey' hash ('sha1:858b94ba45f38902d6364a3cec1d8b7c5c22c959', 708638606L, 1117, posix.stat_result(st_mode=33188, st_ino=1052828L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=1117L, st_atime=1255451923, st_mtime=1211230048, st_ctime=1255451922))
2009-10-13 10:35:47,943 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F 9501079a-364d-453c-9305-20724fb31a22 [root:9501079a-364d-453c-9305-20724fb31a22] ''Ubuntu One/backey'' | Called calculate_hash
2009-10-13 10:35:47,944 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_CREATE, args:('/home/peter3/Ubuntu One/BlackBoxSaga.txt',), kw:{}
2009-10-13 10:35:47,946 - ubuntuone.SyncDaemon.sync - DEBUG - -:-:- - [-:-] ''/home/peter3/Ubuntu One/BlackBoxSaga.txt'' | EVENT: FS_FILE_CREATE:{} with ARGS:('/home/peter3/Ubuntu One/BlackBoxSaga.txt',)
2009-10-13 10:35:47,948 - ubuntuone.SyncDaemon.sync - DEBUG - -:-:- - [-:-] ''/home/peter3/Ubuntu One/BlackBoxSaga.txt'' | Calling new_local_file
2009-10-13 10:35:47,949 - ubuntuone.SyncDaemon.fsm - DEBUG - create: path='/home/peter3/Ubuntu One/BlackBoxSaga.txt' mdid='fe040790-8714-4f11-a4f9-bb38185b72d1' share_id='' node_id=None is_dir=False
2009-10-13 10:35:47,952 - ubuntuone.SyncDaemon.fsm - DEBUG - set mdid='fe040790-8714-4f11-a4f9-bb38185b72d1': {'local_hash': '', 'server_hash': ''}
2009-10-13 10:35:47,968 - ubuntuone.SyncDaemon.ActionQueue - DEBUG - MakeFile share:'' node:'fe040790-8714-4f11-a4f9-bb38185b72d1' MakeFile(marker="'fe040790-8714-4f11-a4f9-bb38185b72d1'", parent_id="'2e7a4a20-d52f-49fe-a741-2dd0fe62598a'", share_id="''", name="u'BlackBoxSaga.txt'") queueing in the META_QUEUE
2009-10-13 10:35:47,970 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F fe040790-8714-4f11-a4f9-bb38185b72d1 [root:fe040790-8714-4f11-a4f9-bb38185b72d1] ''Ubuntu One/BlackBoxSaga.txt'' | Called new_local_file
2009-10-13 10:35:47,972 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_CLOSE_WRITE, args:('/home/peter3/Ubuntu One/BlackBoxSaga.txt',), kw:{}
2009-10-13 10:35:47,974 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F fe040790-8714-4f11-a4f9-bb38185b72d1 [root:fe040790-8714-4f11-a4f9-bb38185b72d1] ''Ubuntu One/BlackBoxSaga.txt'' | EVENT: FS_FILE_CLOSE_WRITE:{} with ARGS:()
2009-10-13 10:35:47,976 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F fe040790-8714-4f11-a4f9-bb38185b72d1 [root:fe040790-8714-4f11-a4f9-bb38185b72d1] ''Ubuntu One/BlackBoxSaga.txt'' | Calling calculate_hash
2009-10-13 10:35:47,978 - ubuntuone.SyncDaemon.HQ - INFO - HashQueue: inserting path '/home/peter3/Ubuntu One/BlackBoxSaga.txt' mdid fe040790-8714-4f11-a4f9-bb38185b72d1
2009-10-13 10:35:48,013 - ubuntuone.SyncDaemon.HQ.hasher - DEBUG - Hasher: got file to hash: path '/home/peter3/Ubuntu One/BlackBoxSaga.txt' mdid fe040790-8714-4f11-a4f9-bb38185b72d1
2009-10-13 10:35:48,015 - ubuntuone.SyncDaemon.HQ.hasher - DEBUG - Hasher: path hash pushed: path '/home/peter3/Ubuntu One/BlackBoxSaga.txt' hash ('sha1:112bb8e0feeffa4fb34c425eb07019bd902ffe45', 150246573L, 9684, posix.stat_result(st_mode=33188, st_ino=1052829L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=9684L, st_atime=1255452313, st_mtime=1255450349, st_ctime=1255451922))
2009-10-13 10:35:48,017 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F fe040790-8714-4f11-a4f9-bb38185b72d1 [root:fe040790-8714-4f11-a4f9-bb38185b72d1] ''Ubuntu One/BlackBoxSaga.txt'' | Called calculate_hash
2009-10-13 10:35:48,019 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_CREATE, args:('/home/peter3/Ubuntu One/TBirdPersonal.ldif',), kw:{}
2009-10-13 10:35:48,021 - ubuntuone.SyncDaemon.sync - DEBUG - -:-:- - [-:-] ''/home/peter3/Ubuntu One/TBirdPersonal.ldif'' | EVENT: FS_FILE_CREATE:{} with ARGS:('/home/peter3/Ubuntu One/TBirdPersonal.ldif',)
2009-10-13 10:35:48,022 - ubuntuone.SyncDaemon.sync - DEBUG - -:-:- - [-:-] ''/home/peter3/Ubuntu One/TBirdPersonal.ldif'' | Calling new_local_file
2009-10-13 10:35:48,026 - ubuntuone.SyncDaemon.fsm - DEBUG - create: path='/home/peter3/Ubuntu One/TBirdPersonal.ldif' mdid='addbd02f-4b97-4e76-9d33-565e47fd6e06' share_id='' node_id=None is_dir=False
2009-10-13 10:35:48,030 - ubuntuone.SyncDaemon.fsm - DEBUG - set mdid='addbd02f-4b97-4e76-9d33-565e47fd6e06': {'local_hash': '', 'server_hash': ''}
2009-10-13 10:35:48,071 - ubuntuone.SyncDaemon.ActionQueue - DEBUG - MakeFile share:'' node:'addbd02f-4b97-4e76-9d33-565e47fd6e06' MakeFile(marker="'addbd02f-4b97-4e76-9d33-565e47fd6e06'", parent_id="'2e7a4a20-d52f-49fe-a741-2dd0fe62598a'", share_id="''", name="u'TBirdPersonal.ldif'") queueing in the META_QUEUE
2009-10-13 10:35:48,074 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F addbd02f-4b97-4e76-9d33-565e47fd6e06 [root:addbd02f-4b97-4e76-9d33-565e47fd6e06] ''Ubuntu One/TBirdPersonal.ldif'' | Called new_local_file
2009-10-13 10:35:48,075 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_CLOSE_WRITE, args:('/home/peter3/Ubuntu One/TBirdPersonal.ldif',), kw:{}
2009-10-13 10:35:48,078 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F addbd02f-4b97-4e76-9d33-565e47fd6e06 [root:addbd02f-4b97-4e76-9d33-565e47fd6e06] ''Ubuntu One/TBirdPersonal.ldif'' | EVENT: FS_FILE_CLOSE_WRITE:{} with ARGS:()
2009-10-13 10:35:48,080 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F addbd02f-4b97-4e76-9d33-565e47fd6e06 [root:addbd02f-4b97-4e76-9d33-565e47fd6e06] ''Ubuntu One/TBirdPersonal.ldif'' | Calling calculate_hash
2009-10-13 10:35:48,081 - ubuntuone.SyncDaemon.HQ - INFO - HashQueue: inserting path '/home/peter3/Ubuntu One/TBirdPersonal.ldif' mdid addbd02f-4b97-4e76-9d33-565e47fd6e06
2009-10-13 10:35:48,097 - ubuntuone.SyncDaemon.HQ.hasher - DEBUG - Hasher: got file to hash: path '/home/peter3/Ubuntu One/TBirdPersonal.ldif' mdid addbd02f-4b97-4e76-9d33-565e47fd6e06
2009-10-13 10:35:48,100 - ubuntuone.SyncDaemon.HQ.hasher - DEBUG - Hasher: path hash pushed: path '/home/peter3/Ubuntu One/TBirdPersonal.ldif' hash ('sha1:b1a5445a768c90299591b31751618b77b41811b5', 3523774813L, 163374, posix.stat_result(st_mode=33188, st_ino=1052835L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=163374L, st_atime=1255451923, st_mtime=1248902509, st_ctime=1255451922))
2009-10-13 10:35:48,102 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F addbd02f-4b97-4e76-9d33-565e47fd6e06 [root:addbd02f-4b97-4e76-9d33-565e47fd6e06] ''Ubuntu One/TBirdPersonal.ldif'' | Called calculate_hash
2009-10-13 10:35:48,104 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_CREATE, args:('/home/peter3/Ubuntu One/11-23-08 Sermon.doc',), kw:{}
2009-10-13 10:35:48,105 - ubuntuone.SyncDaemon.sync - DEBUG - -:-:- - [-:-] ''/home/peter3/Ubuntu One/11-23-08 Sermon.doc'' | EVENT: FS_FILE_CREATE:{} with ARGS:('/home/peter3/Ubuntu One/11-23-08 Sermon.doc',)
2009-10-13 10:35:48,107 - ubuntuone.SyncDaemon.sync - DEBUG - -:-:- - [-:-] ''/home/peter3/Ubuntu One/11-23-08 Sermon.doc'' | Calling new_local_file
2009-10-13 10:35:48,108 - ubuntuone.SyncDaemon.fsm - DEBUG - create: path='/home/peter3/Ubuntu One/11-23-08 Sermon.doc' mdid='e671c7c8-4bcd-4350-9982-a57ca86cadb9' share_id='' node_id=None is_dir=False
2009-10-13 10:35:48,112 - ubuntuone.SyncDaemon.fsm - DEBUG - set mdid='e671c7c8-4bcd-4350-9982-a57ca86cadb9': {'local_hash': '', 'server_hash': ''}
2009-10-13 10:35:48,140 - ubuntuone.SyncDaemon.ActionQueue - DEBUG - MakeFile share:'' node:'e671c7c8-4bcd-4350-9982-a57ca86cadb9' MakeFile(marker="'e671c7c8-4bcd-4350-9982-a57ca86cadb9'", parent_id="'2e7a4a20-d52f-49fe-a741-2dd0fe62598a'", share_id="''", name="u'11-23-08 Sermon.doc'") queueing in the META_QUEUE
2009-10-13 10:35:48,143 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F e671c7c8-4bcd-4350-9982-a57ca86cadb9 [root:e671c7c8-4bcd-4350-9982-a57ca86cadb9] ''Ubuntu One/11-23-08 Sermon.doc'' | Called new_local_file
2009-10-13 10:35:48,144 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_CLOSE_WRITE, args:('/home/peter3/Ubuntu One/11-23-08 Sermon.doc',), kw:{}
2009-10-13 10:35:48,147 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F e671c7c8-4bcd-4350-9982-a57ca86cadb9 [root:e671c7c8-4bcd-4350-9982-a57ca86cadb9] ''Ubuntu One/11-23-08 Sermon.doc'' | EVENT: FS_FILE_CLOSE_WRITE:{} with ARGS:()
2009-10-13 10:35:48,149 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F e671c7c8-4bcd-4350-9982-a57ca86cadb9 [root:e671c7c8-4bcd-4350-9982-a57ca86cadb9] ''Ubuntu One/11-23-08 Sermon.doc'' | Calling calculate_hash
2009-10-13 10:35:48,150 - ubuntuone.SyncDaemon.HQ - INFO - HashQueue: inserting path '/home/peter3/Ubuntu One/11-23-08 Sermon.doc' mdid e671c7c8-4bcd-4350-9982-a57ca86cadb9
2009-10-13 10:35:48,165 - ubuntuone.SyncDaemon.HQ.hasher - DEBUG - Hasher: got file to hash: path '/home/peter3/Ubuntu One/11-23-08 Sermon.doc' mdid e671c7c8-4bcd-4350-9982-a57ca86cadb9
2009-10-13 10:35:48,168 - ubuntuone.SyncDaemon.HQ.hasher - DEBUG - Hasher: path hash pushed: path '/home/peter3/Ubuntu One/11-23-08 Sermon.doc' hash ('sha1:c92878912387d86121951135b6182f56a7612b24', 1179678891L, 77824, posix.stat_result(st_mode=33188, st_ino=1052814L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=77824L, st_atime=1255452313, st_mtime=1227576613, st_ctime=1255451922))
2009-10-13 10:35:48,170 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F e671c7c8-4bcd-4350-9982-a57ca86cadb9 [root:e671c7c8-4bcd-4350-9982-a57ca86cadb9] ''Ubuntu One/11-23-08 Sermon.doc'' | Called calculate_hash
2009-10-13 10:35:48,171 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_CREATE, args:('/home/peter3/Ubuntu One/fan2.pl',), kw:{}
2009-10-13 10:35:48,173 - ubuntuone.SyncDaemon.sync - DEBUG - -:-:- - [-:-] ''/home/peter3/Ubuntu One/fan2.pl'' | EVENT: FS_FILE_CREATE:{} with ARGS:('/home/peter3/Ubuntu One/fan2.pl',)
2009-10-13 10:35:48,175 - ubuntuone.SyncDaemon.sync - DEBUG - -:-:- - [-:-] ''/home/peter3/Ubuntu One/fan2.pl'' | Calling new_local_file
2009-10-13 10:35:48,177 - ubuntuone.SyncDaemon.fsm - DEBUG - create: path='/home/peter3/Ubuntu One/fan2.pl' mdid='634f29b7-0c16-48b3-a145-462d75f3f638' share_id='' node_id=None is_dir=False
2009-10-13 10:35:48,179 - ubuntuone.SyncDaemon.fsm - DEBUG - set mdid='634f29b7-0c16-48b3-a145-462d75f3f638': {'local_hash': '', 'server_hash': ''}
2009-10-13 10:35:48,194 - ubuntuone.SyncDaemon.ActionQueue - DEBUG - MakeFile share:'' node:'634f29b7-0c16-48b3-a145-462d75f3f638' MakeFile(marker="'634f29b7-0c16-48b3-a145-462d75f3f638'", parent_id="'2e7a4a20-d52f-49fe-a741-2dd0fe62598a'", share_id="''", name="u'fan2.pl'") queueing in the META_QUEUE
2009-10-13 10:35:48,198 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F 634f29b7-0c16-48b3-a145-462d75f3f638 [root:634f29b7-0c16-48b3-a145-462d75f3f638] ''Ubuntu One/fan2.pl'' | Called new_local_file
2009-10-13 10:35:48,199 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_CLOSE_WRITE, args:('/home/peter3/Ubuntu One/fan2.pl',), kw:{}
2009-10-13 10:35:48,202 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F 634f29b7-0c16-48b3-a145-462d75f3f638 [root:634f29b7-0c16-48b3-a145-462d75f3f638] ''Ubuntu One/fan2.pl'' | EVENT: FS_FILE_CLOSE_WRITE:{} with ARGS:()
2009-10-13 10:35:48,205 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F 634f29b7-0c16-48b3-a145-462d75f3f638 [root:634f29b7-0c16-48b3-a145-462d75f3f638] ''Ubuntu One/fan2.pl'' | Calling calculate_hash
2009-10-13 10:35:48,207 - ubuntuone.SyncDaemon.HQ - INFO - HashQueue: inserting path '/home/peter3/Ubuntu One/fan2.pl' mdid 634f29b7-0c16-48b3-a145-462d75f3f638
2009-10-13 10:35:48,208 - ubuntuone.SyncDaemon.HQ.hasher - DEBUG - Hasher: got file to hash: path '/home/peter3/Ubuntu One/fan2.pl' mdid 634f29b7-0c16-48b3-a145-462d75f3f638
2009-10-13 10:35:48,209 - ubuntuone.SyncDaemon.HQ.hasher - DEBUG - Hasher: path hash pushed: path '/home/peter3/Ubuntu One/fan2.pl' hash ('sha1:5a9f41775c153333f28e94b28403bd0a7ce0ca15', 3825638088L, 1927, posix.stat_result(st_mode=33216, st_ino=1052832L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=1927L, st_atime=1255451923, st_mtime=1242422291, st_ctime=1255451922))
2009-10-13 10:35:48,212 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F 634f29b7-0c16-48b3-a145-462d75f3f638 [root:634f29b7-0c16-48b3-a145-462d75f3f638] ''Ubuntu One/fan2.pl'' | Called calculate_hash
2009-10-13 10:35:48,213 - ubuntuone.SyncDaemon.local_rescan - DEBUG - process next in queue (len 0)
2009-10-13 10:35:48,214 - ubuntuone.SyncDaemon.local_rescan - INFO - processing trash
2009-10-13 10:35:48,216 - ubuntuone.SyncDaemon.Main - NOTE - Local rescan finished!
2009-10-13 10:35:48,216 - ubuntuone.SyncDaemon.Main - INFO - hash queue empty. We are ready!
2009-10-13 10:35:48,217 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_LOCAL_RESCAN_DONE, args:(), kw:{}
2009-10-13 10:35:48,221 - ubuntuone.SyncDaemon.State - DEBUG - READING_WITH_NETWORK_WITH_METAQ --[SYS_LOCAL_RESCAN_DONE]--> READY_WITH_NETWORK_WITH_METAQ
2009-10-13 10:35:48,222 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_STATE_CHANGED, args:(), kw:{'state': <SyncDaemonState READY_WITH_NETWORK_WITH_METAQ>}
2009-10-13 10:35:48,246 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: HQ_HASH_NEW, args:('/home/peter3/Ubuntu One/doug11_23_08_Sermon.html', 'sha1:110a17f6eb421c392fc28d18e7b411509c56b165', 1393436872L, 33107, posix.stat_result(st_mode=33188, st_ino=1052830L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=33107L, st_atime=1255452313, st_mtime=1227577341, st_ctime=1255451922)), kw:{}
2009-10-13 10:35:48,252 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F 7301271f-4aea-4257-acc3-93c343fa1559 [root:7301271f-4aea-4257-acc3-93c343fa1559] ''Ubuntu One/doug11_23_08_Sermon.html'' | EVENT: HQ_HASH_NEW:{'hash_eq_local_hash': 'F', 'hash_eq_server_hash': 'F'} with ARGS:('sha1:110a17f6eb421c392fc28d18e7b411509c56b165', 1393436872L, 33107, posix.stat_result(st_mode=33188, st_ino=1052830L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=33107L, st_atime=1255452313, st_mtime=1227577341, st_ctime=1255451922))
2009-10-13 10:35:48,254 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F 7301271f-4aea-4257-acc3-93c343fa1559 [root:7301271f-4aea-4257-acc3-93c343fa1559] ''Ubuntu One/doug11_23_08_Sermon.html'' | Calling put_file
2009-10-13 10:35:48,256 - ubuntuone.SyncDaemon.fsm - DEBUG - set mdid='7301271f-4aea-4257-acc3-93c343fa1559': {'stat': posix.stat_result(st_mode=33188, st_ino=1052830L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=33107L, st_atime=1255452313, st_mtime=1227577341, st_ctime=1255451922), 'local_hash': 'sha1:110a17f6eb421c392fc28d18e7b411509c56b165'}
2009-10-13 10:35:48,262 - ubuntuone.SyncDaemon.ActionQueue - DEBUG - Upload share:'' node:'7301271f-4aea-4257-acc3-93c343fa1559' Upload(share_id="''", hash="'sha1:110a17f6eb421c392fc28d18e7b411509c56b165'", fileobj_factory='<bound method FSKey.open_file of <ubuntuone.syncdaemon.sync.FSKey object at 0xb737616c>>', node_id="'7301271f-4aea-4257-acc3-93c343fa1559'", crc32='1393436872L', previous_hash="''", size='33107') queueing in the CONTENT_QUEUE
2009-10-13 10:35:48,263 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_CONTENT_QUEUE_WAITING, args:(), kw:{}
2009-10-13 10:35:48,273 - ubuntuone.SyncDaemon.sync - DEBUG - T:LOCAL:F 7301271f-4aea-4257-acc3-93c343fa1559 [root:7301271f-4aea-4257-acc3-93c343fa1559] ''Ubuntu One/doug11_23_08_Sermon.html'' | Called put_file
2009-10-13 10:35:48,275 - ubuntuone.SyncDaemon.State - DEBUG - READY_WITH_NETWORK_WITH_METAQ --[SYS_CONTENT_QUEUE_WAITING]--> READY_WITH_NETWORK_WITH_BOTHQ
2009-10-13 10:35:48,276 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_STATE_CHANGED, args:(), kw:{'state': <SyncDaemonState READY_WITH_NETWORK_WITH_BOTHQ>}
2009-10-13 10:35:48,300 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: HQ_HASH_NEW, args:('/home/peter3/Ubuntu One/backey', 'sha1:858b94ba45f38902d6364a3cec1d8b7c5c22c959', 708638606L, 1117, posix.stat_result(st_mode=33188, st_ino=1052828L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=1117L, st_atime=1255451923, st_mtime=1211230048, st_ctime=1255451922)), kw:{}
2009-10-13 10:35:48,304 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F 9501079a-364d-453c-9305-20724fb31a22 [root:9501079a-364d-453c-9305-20724fb31a22] ''Ubuntu One/backey'' | EVENT: HQ_HASH_NEW:{'hash_eq_local_hash': 'F', 'hash_eq_server_hash': 'F'} with ARGS:('sha1:858b94ba45f38902d6364a3cec1d8b7c5c22c959', 708638606L, 1117, posix.stat_result(st_mode=33188, st_ino=1052828L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=1117L, st_atime=1255451923, st_mtime=1211230048, st_ctime=1255451922))
2009-10-13 10:35:48,306 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F 9501079a-364d-453c-9305-20724fb31a22 [root:9501079a-364d-453c-9305-20724fb31a22] ''Ubuntu One/backey'' | Calling put_file
2009-10-13 10:35:48,307 - ubuntuone.SyncDaemon.fsm - DEBUG - set mdid='9501079a-364d-453c-9305-20724fb31a22': {'stat': posix.stat_result(st_mode=33188, st_ino=1052828L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=1117L, st_atime=1255451923, st_mtime=1211230048, st_ctime=1255451922), 'local_hash': 'sha1:858b94ba45f38902d6364a3cec1d8b7c5c22c959'}
2009-10-13 10:35:48,311 - ubuntuone.SyncDaemon.ActionQueue - DEBUG - Upload share:'' node:'9501079a-364d-453c-9305-20724fb31a22' Upload(share_id="''", hash="'sha1:858b94ba45f38902d6364a3cec1d8b7c5c22c959'", fileobj_factory='<bound method FSKey.open_file of <ubuntuone.syncdaemon.sync.FSKey object at 0xb73762d4>>', node_id="'9501079a-364d-453c-9305-20724fb31a22'", crc32='708638606L', previous_hash="''", size='1117') queueing in the CONTENT_QUEUE
2009-10-13 10:35:48,327 - ubuntuone.SyncDaemon.sync - DEBUG - T:LOCAL:F 9501079a-364d-453c-9305-20724fb31a22 [root:9501079a-364d-453c-9305-20724fb31a22] ''Ubuntu One/backey'' | Called put_file
2009-10-13 10:35:48,328 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: HQ_HASH_NEW, args:('/home/peter3/Ubuntu One/BlackBoxSaga.txt', 'sha1:112bb8e0feeffa4fb34c425eb07019bd902ffe45', 150246573L, 9684, posix.stat_result(st_mode=33188, st_ino=1052829L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=9684L, st_atime=1255452313, st_mtime=1255450349, st_ctime=1255451922)), kw:{}
2009-10-13 10:35:48,331 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F fe040790-8714-4f11-a4f9-bb38185b72d1 [root:fe040790-8714-4f11-a4f9-bb38185b72d1] ''Ubuntu One/BlackBoxSaga.txt'' | EVENT: HQ_HASH_NEW:{'hash_eq_local_hash': 'F', 'hash_eq_server_hash': 'F'} with ARGS:('sha1:112bb8e0feeffa4fb34c425eb07019bd902ffe45', 150246573L, 9684, posix.stat_result(st_mode=33188, st_ino=1052829L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=9684L, st_atime=1255452313, st_mtime=1255450349, st_ctime=1255451922))
2009-10-13 10:35:48,334 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F fe040790-8714-4f11-a4f9-bb38185b72d1 [root:fe040790-8714-4f11-a4f9-bb38185b72d1] ''Ubuntu One/BlackBoxSaga.txt'' | Calling put_file
2009-10-13 10:35:48,335 - ubuntuone.SyncDaemon.fsm - DEBUG - set mdid='fe040790-8714-4f11-a4f9-bb38185b72d1': {'stat': posix.stat_result(st_mode=33188, st_ino=1052829L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=9684L, st_atime=1255452313, st_mtime=1255450349, st_ctime=1255451922), 'local_hash': 'sha1:112bb8e0feeffa4fb34c425eb07019bd902ffe45'}
2009-10-13 10:35:48,339 - ubuntuone.SyncDaemon.ActionQueue - DEBUG - Upload share:'' node:'fe040790-8714-4f11-a4f9-bb38185b72d1' Upload(share_id="''", hash="'sha1:112bb8e0feeffa4fb34c425eb07019bd902ffe45'", fileobj_factory='<bound method FSKey.open_file of <ubuntuone.syncdaemon.sync.FSKey object at 0xb69a5414>>', node_id="'fe040790-8714-4f11-a4f9-bb38185b72d1'", crc32='150246573L', previous_hash="''", size='9684') queueing in the CONTENT_QUEUE
2009-10-13 10:35:48,352 - ubuntuone.SyncDaemon.sync - DEBUG - T:LOCAL:F fe040790-8714-4f11-a4f9-bb38185b72d1 [root:fe040790-8714-4f11-a4f9-bb38185b72d1] ''Ubuntu One/BlackBoxSaga.txt'' | Called put_file
2009-10-13 10:35:48,357 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: HQ_HASH_NEW, args:('/home/peter3/Ubuntu One/TBirdPersonal.ldif', 'sha1:b1a5445a768c90299591b31751618b77b41811b5', 3523774813L, 163374, posix.stat_result(st_mode=33188, st_ino=1052835L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=163374L, st_atime=1255451923, st_mtime=1248902509, st_ctime=1255451922)), kw:{}
2009-10-13 10:35:48,360 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F addbd02f-4b97-4e76-9d33-565e47fd6e06 [root:addbd02f-4b97-4e76-9d33-565e47fd6e06] ''Ubuntu One/TBirdPersonal.ldif'' | EVENT: HQ_HASH_NEW:{'hash_eq_local_hash': 'F', 'hash_eq_server_hash': 'F'} with ARGS:('sha1:b1a5445a768c90299591b31751618b77b41811b5', 3523774813L, 163374, posix.stat_result(st_mode=33188, st_ino=1052835L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=163374L, st_atime=1255451923, st_mtime=1248902509, st_ctime=1255451922))
2009-10-13 10:35:48,362 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F addbd02f-4b97-4e76-9d33-565e47fd6e06 [root:addbd02f-4b97-4e76-9d33-565e47fd6e06] ''Ubuntu One/TBirdPersonal.ldif'' | Calling put_file
2009-10-13 10:35:48,363 - ubuntuone.SyncDaemon.fsm - DEBUG - set mdid='addbd02f-4b97-4e76-9d33-565e47fd6e06': {'stat': posix.stat_result(st_mode=33188, st_ino=1052835L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=163374L, st_atime=1255451923, st_mtime=1248902509, st_ctime=1255451922), 'local_hash': 'sha1:b1a5445a768c90299591b31751618b77b41811b5'}
2009-10-13 10:35:48,368 - ubuntuone.SyncDaemon.ActionQueue - DEBUG - Upload share:'' node:'addbd02f-4b97-4e76-9d33-565e47fd6e06' Upload(share_id="''", hash="'sha1:b1a5445a768c90299591b31751618b77b41811b5'", fileobj_factory='<bound method FSKey.open_file of <ubuntuone.syncdaemon.sync.FSKey object at 0xb69a5cac>>', node_id="'addbd02f-4b97-4e76-9d33-565e47fd6e06'", crc32='3523774813L', previous_hash="''", size='163374') queueing in the CONTENT_QUEUE
2009-10-13 10:35:48,378 - ubuntuone.SyncDaemon.sync - DEBUG - T:LOCAL:F addbd02f-4b97-4e76-9d33-565e47fd6e06 [root:addbd02f-4b97-4e76-9d33-565e47fd6e06] ''Ubuntu One/TBirdPersonal.ldif'' | Called put_file
2009-10-13 10:35:48,379 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: HQ_HASH_NEW, args:('/home/peter3/Ubuntu One/11-23-08 Sermon.doc', 'sha1:c92878912387d86121951135b6182f56a7612b24', 1179678891L, 77824, posix.stat_result(st_mode=33188, st_ino=1052814L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=77824L, st_atime=1255452313, st_mtime=1227576613, st_ctime=1255451922)), kw:{}
2009-10-13 10:35:48,388 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F e671c7c8-4bcd-4350-9982-a57ca86cadb9 [root:e671c7c8-4bcd-4350-9982-a57ca86cadb9] ''Ubuntu One/11-23-08 Sermon.doc'' | EVENT: HQ_HASH_NEW:{'hash_eq_local_hash': 'F', 'hash_eq_server_hash': 'F'} with ARGS:('sha1:c92878912387d86121951135b6182f56a7612b24', 1179678891L, 77824, posix.stat_result(st_mode=33188, st_ino=1052814L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=77824L, st_atime=1255452313, st_mtime=1227576613, st_ctime=1255451922))
2009-10-13 10:35:48,390 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F e671c7c8-4bcd-4350-9982-a57ca86cadb9 [root:e671c7c8-4bcd-4350-9982-a57ca86cadb9] ''Ubuntu One/11-23-08 Sermon.doc'' | Calling put_file
2009-10-13 10:35:48,391 - ubuntuone.SyncDaemon.fsm - DEBUG - set mdid='e671c7c8-4bcd-4350-9982-a57ca86cadb9': {'stat': posix.stat_result(st_mode=33188, st_ino=1052814L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=77824L, st_atime=1255452313, st_mtime=1227576613, st_ctime=1255451922), 'local_hash': 'sha1:c92878912387d86121951135b6182f56a7612b24'}
2009-10-13 10:35:48,395 - ubuntuone.SyncDaemon.ActionQueue - DEBUG - Upload share:'' node:'e671c7c8-4bcd-4350-9982-a57ca86cadb9' Upload(share_id="''", hash="'sha1:c92878912387d86121951135b6182f56a7612b24'", fileobj_factory='<bound method FSKey.open_file of <ubuntuone.syncdaemon.sync.FSKey object at 0xb69a5cfc>>', node_id="'e671c7c8-4bcd-4350-9982-a57ca86cadb9'", crc32='1179678891L', previous_hash="''", size='77824') queueing in the CONTENT_QUEUE
2009-10-13 10:35:48,405 - ubuntuone.SyncDaemon.sync - DEBUG - T:LOCAL:F e671c7c8-4bcd-4350-9982-a57ca86cadb9 [root:e671c7c8-4bcd-4350-9982-a57ca86cadb9] ''Ubuntu One/11-23-08 Sermon.doc'' | Called put_file
2009-10-13 10:35:48,406 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: HQ_HASH_NEW, args:('/home/peter3/Ubuntu One/fan2.pl', 'sha1:5a9f41775c153333f28e94b28403bd0a7ce0ca15', 3825638088L, 1927, posix.stat_result(st_mode=33216, st_ino=1052832L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=1927L, st_atime=1255451923, st_mtime=1242422291, st_ctime=1255451922)), kw:{}
2009-10-13 10:35:48,416 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F 634f29b7-0c16-48b3-a145-462d75f3f638 [root:634f29b7-0c16-48b3-a145-462d75f3f638] ''Ubuntu One/fan2.pl'' | EVENT: HQ_HASH_NEW:{'hash_eq_local_hash': 'F', 'hash_eq_server_hash': 'F'} with ARGS:('sha1:5a9f41775c153333f28e94b28403bd0a7ce0ca15', 3825638088L, 1927, posix.stat_result(st_mode=33216, st_ino=1052832L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=1927L, st_atime=1255451923, st_mtime=1242422291, st_ctime=1255451922))
2009-10-13 10:35:48,420 - ubuntuone.SyncDaemon.sync - DEBUG - T:NONE:F 634f29b7-0c16-48b3-a145-462d75f3f638 [root:634f29b7-0c16-48b3-a145-462d75f3f638] ''Ubuntu One/fan2.pl'' | Calling put_file
2009-10-13 10:35:48,421 - ubuntuone.SyncDaemon.fsm - DEBUG - set mdid='634f29b7-0c16-48b3-a145-462d75f3f638': {'stat': posix.stat_result(st_mode=33216, st_ino=1052832L, st_dev=2051L, st_nlink=1, st_uid=1000, st_gid=1000, st_size=1927L, st_atime=1255451923, st_mtime=1242422291, st_ctime=1255451922), 'local_hash': 'sha1:5a9f41775c153333f28e94b28403bd0a7ce0ca15'}
2009-10-13 10:35:48,424 - ubuntuone.SyncDaemon.ActionQueue - DEBUG - Upload share:'' node:'634f29b7-0c16-48b3-a145-462d75f3f638' Upload(share_id="''", hash="'sha1:5a9f41775c153333f28e94b28403bd0a7ce0ca15'", fileobj_factory='<bound method FSKey.open_file of <ubuntuone.syncdaemon.sync.FSKey object at 0xb69a5c0c>>', node_id="'634f29b7-0c16-48b3-a145-462d75f3f638'", crc32='3825638088L', previous_hash="''", size='1927') queueing in the CONTENT_QUEUE
2009-10-13 10:35:48,435 - ubuntuone.SyncDaemon.sync - DEBUG - T:LOCAL:F 634f29b7-0c16-48b3-a145-462d75f3f638 [root:634f29b7-0c16-48b3-a145-462d75f3f638] ''Ubuntu One/fan2.pl'' | Called put_file
2009-10-13 10:35:48,446 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_OPEN, args:('/home/peter3/Ubuntu One/doug11_23_08_Sermon.html',), kw:{}
2009-10-13 10:35:48,448 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_CLOSE_NOWRITE, args:('/home/peter3/Ubuntu One/doug11_23_08_Sermon.html',), kw:{}
2009-10-13 10:35:48,449 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_OPEN, args:('/home/peter3/Ubuntu One/backey',), kw:{}
2009-10-13 10:35:48,451 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_CLOSE_NOWRITE, args:('/home/peter3/Ubuntu One/backey',), kw:{}
2009-10-13 10:35:48,453 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_OPEN, args:('/home/peter3/Ubuntu One/BlackBoxSaga.txt',), kw:{}
2009-10-13 10:35:48,456 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_CLOSE_NOWRITE, args:('/home/peter3/Ubuntu One/BlackBoxSaga.txt',), kw:{}
2009-10-13 10:35:48,458 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_OPEN, args:('/home/peter3/Ubuntu One/TBirdPersonal.ldif',), kw:{}
2009-10-13 10:35:48,465 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_CLOSE_NOWRITE, args:('/home/peter3/Ubuntu One/TBirdPersonal.ldif',), kw:{}
2009-10-13 10:35:48,467 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_OPEN, args:('/home/peter3/Ubuntu One/11-23-08 Sermon.doc',), kw:{}
2009-10-13 10:35:48,468 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_CLOSE_NOWRITE, args:('/home/peter3/Ubuntu One/11-23-08 Sermon.doc',), kw:{}
2009-10-13 10:35:48,470 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_OPEN, args:('/home/peter3/Ubuntu One/fan2.pl',), kw:{}
2009-10-13 10:35:48,472 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: FS_FILE_CLOSE_NOWRITE, args:('/home/peter3/Ubuntu One/fan2.pl',), kw:{}
2009-10-13 10:35:48,487 - ubuntuone.SyncDaemon.DBus - DEBUG - connect requetsed
2009-10-13 10:35:48,510 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_CONNECT, args:(<oauth.oauth.OAuthToken object at 0xb6a1aeec>,), kw:{}
2009-10-13 10:35:48,511 - ubuntuone.SyncDaemon.State - DEBUG - Setting up timeout watchdog
2009-10-13 10:35:48,526 - ubuntuone.SyncDaemon.State - DEBUG - READY_WITH_NETWORK_WITH_BOTHQ --[SYS_CONNECT]--> START_CONNECTING_WITH_BOTHQ
2009-10-13 10:35:48,527 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_STATE_CHANGED, args:(), kw:{'state': <SyncDaemonState START_CONNECTING_WITH_BOTHQ>}
2009-10-13 10:35:48,560 - ubuntuone.SyncDaemon.DBus - DEBUG - called get_rootdir
2009-10-13 10:35:48,564 - ubuntuone.SyncDaemon.ActionQueue - DEBUG - SRV lookup done, choosing a server
2009-10-13 10:35:48,588 - ubuntuone.SyncDaemon.ActionQueue - INFO - SRV lookup error, fallback to 'fs-1.one.ubuntu.com':443
Traceback (most recent call last):
File "/usr/lib/python2.6/dist-packages/twisted/internet/defer.py", line 312, in _startRunCallbacks
self._runCallbacks()
File "/usr/lib/python2.6/dist-packages/twisted/internet/defer.py", line 328, in _runCallbacks
self.result = callback(self.result, *args, **kw)
File "/usr/lib/python2.6/dist-packages/twisted/internet/defer.py", line 289, in _continue
self.unpause()
File "/usr/lib/python2.6/dist-packages/twisted/internet/defer.py", line 285, in unpause
self._runCallbacks()
--- <exception caught here> ---
File "/usr/lib/python2.6/dist-packages/twisted/internet/defer.py", line 328, in _runCallbacks
self.result = callback(self.result, *args, **kw)
File "/usr/lib/python2.6/dist-packages/ubuntuone/syncdaemon/action_queue.py", line 825, in on_lookup_ok
raise ValueError("No available records.")
exceptions.ValueError: No available records.
2009-10-13 10:35:48,698 - ubuntuone.SyncDaemon.ActionQueue - DEBUG - connection made
2009-10-13 10:35:48,699 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_CONNECTION_MADE, args:(), kw:{}
2009-10-13 10:35:48,700 - ubuntuone.SyncDaemon.State - DEBUG - Event arrived: cancelling timeout watchdog
2009-10-13 10:35:48,708 - ubuntuone.SyncDaemon.State - DEBUG - Setting up timeout watchdog
2009-10-13 10:35:48,714 - ubuntuone.SyncDaemon.State - DEBUG - START_CONNECTING_WITH_BOTHQ --[SYS_CONNECTION_MADE]--> START_CONNECTED_WITH_BOTHQ
2009-10-13 10:35:48,715 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_STATE_CHANGED, args:(), kw:{'state': <NonActiveConnectedSDState START_CONNECTED_WITH_BOTHQ>}
2009-10-13 10:35:48,717 - ubuntuone.SyncDaemon.ActionQueue - DEBUG - get_root share:'' node:'2e7a4a20-d52f-49fe-a741-2dd0fe62598a' get_root(marker="'2e7a4a20-d52f-49fe-a741-2dd0fe62598a'") starting
2009-10-13 10:35:49,030 - ubuntuone.SyncDaemon.ActionQueue - INFO - Protocol version OK
2009-10-13 10:35:49,031 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_PROTOCOL_VERSION_OK, args:(), kw:{}
2009-10-13 10:35:49,032 - ubuntuone.SyncDaemon.State - DEBUG - Event arrived: cancelling timeout watchdog
2009-10-13 10:35:49,033 - ubuntuone.SyncDaemon.State - DEBUG - Setting up timeout watchdog
2009-10-13 10:35:49,035 - ubuntuone.SyncDaemon.Main - DEBUG - capabilities query: frozenset(['resumable-uploads', 'account-info', 'no-content'])
2009-10-13 10:35:49,045 - ubuntuone.SyncDaemon.State - DEBUG - START_CONNECTED_WITH_BOTHQ --[SYS_PROTOCOL_VERSION_OK]--> START_SET_CAPABILITIES_WITH_BOTHQ
2009-10-13 10:35:49,046 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_STATE_CHANGED, args:(), kw:{'state': <NonActiveConnectedSDState START_SET_CAPABILITIES_WITH_BOTHQ>}
2009-10-13 10:35:49,272 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_SET_CAPABILITIES_OK, args:(), kw:{}
2009-10-13 10:35:49,273 - ubuntuone.SyncDaemon.State - DEBUG - Event arrived: cancelling timeout watchdog
2009-10-13 10:35:49,274 - ubuntuone.SyncDaemon.State - DEBUG - Setting up timeout watchdog
2009-10-13 10:35:49,287 - ubuntuone.SyncDaemon.State - DEBUG - START_SET_CAPABILITIES_WITH_BOTHQ --[SYS_SET_CAPABILITIES_OK]--> START_AUTHENTICATING_WITH_BOTHQ
2009-10-13 10:35:49,288 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_STATE_CHANGED, args:(), kw:{'state': <NonActiveConnectedSDState START_AUTHENTICATING_WITH_BOTHQ>}
2009-10-13 10:35:49,442 - ubuntuone.SyncDaemon.ActionQueue - ERROR - OAuth failed: Authentication Error:id: 7
type: ERROR
error {
type: INTERNAL_ERROR
}
2009-10-13 10:35:49,443 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_OAUTH_ERROR, args:(), kw:{'error': 'Authentication Error:id: 7\ntype: ERROR\nerror {\n type: INTERNAL_ERROR\n}\n'}
2009-10-13 10:35:49,444 - ubuntuone.SyncDaemon.State - DEBUG - Event arrived: cancelling timeout watchdog
2009-10-13 10:35:49,445 - ubuntuone.SyncDaemon.ActionQueue - DEBUG - disconnected
2009-10-13 10:35:49,447 - ubuntuone.SyncDaemon.State - DEBUG - START_AUTHENTICATING_WITH_BOTHQ --[SYS_OAUTH_ERROR]--> AUTH_FAILED
2009-10-13 10:35:49,448 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_STATE_CHANGED, args:(), kw:{'state': <AQErrorState AUTH_FAILED>}
2009-10-13 10:35:49,486 - ubuntuone.SyncDaemon.ActionQueue - WARNING - connection lost: Connection was closed cleanly.
2009-10-13 10:35:49,487 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_CONNECTION_LOST, args:(), kw:{}
2009-10-13 10:35:49,488 - ubuntuone.SyncDaemon.State - DEBUG - AUTH_FAILED --[SYS_CONNECTION_LOST]--> AUTH_FAILED
2009-10-13 10:35:49,489 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_STATE_CHANGED, args:(), kw:{'state': <AQErrorState AUTH_FAILED>}
2009-10-13 10:35:49,536 - ubuntuone.SyncDaemon.DBus - DEBUG - Quit requested
2009-10-13 10:35:49,538 - ubuntuone.SyncDaemon.DBus - DEBUG - Calling Main.quit
2009-10-13 10:35:49,539 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_DISCONNECT, args:(), kw:{}
2009-10-13 10:35:49,540 - ubuntuone.SyncDaemon.State - DEBUG - AUTH_FAILED --[SYS_DISCONNECT]--> AUTH_FAILED
2009-10-13 10:35:49,540 - ubuntuone.SyncDaemon.EQ - DEBUG - push_event: SYS_STATE_CHANGED, args:(), kw:{'state': <AQErrorState AUTH_FAILED>}
2009-10-13 10:35:49,545 - ubuntuone.SyncDaemon.HQ - INFO - HashQueue: _hasher stopped
2009-10-13 10:35:49,547 - ubuntuone.SyncDaemon.DBus - INFO - Shuttingdown DBusInterface!
It just doesn't work......
Authorization has failed each time (of about 3 tries).