Skip to content

Instantly share code, notes, and snippets.

@merickson

merickson/failure log, 2015-11-02 Secret

Created November 2, 2015 14:50
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save merickson/27bbaf793c2eff7bae49 to your computer and use it in GitHub Desktop.
Save merickson/27bbaf793c2eff7bae49 to your computer and use it in GitHub Desktop.
Download ZIP
Raw
failure log, 2015-11-02
Magic Folder 'client-0' uploader: inotify event None, FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_alice_delete_and_restore\\ncgsek\\temp\\Alice-magic\\blam'), 'delete'
Magic Folder 'client-0' uploader: _get_relpath(FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_alice_delete_and_restore\\ncgsek\\temp\\Alice-magic\\blam'))
Magic Folder 'client-0' uploader: segments = [u'blam']
Magic Folder 'client-0' uploader: _append_to_deque(u'blam')
Magic Folder 'client-0' uploader: objects_queued += 1
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: popped u'blam'
Magic Folder 'client-0' uploader: objects_queued += -1
Magic Folder 'client-0' uploader: _process(u'blam')
Magic Folder 'client-0' uploader: pending = set([u'blam']), about to remove u'blam'
Magic Folder 'client-0' uploader: notified object 'C:\Users\peawe\git\magic-folder\_trial_temp\allmydata.test.test_magic_folder\MockTest\test_alice_delete_and_restore\ncgsek\temp\Alice-magic\blam' disappeared (this is normal)
Magic Folder 'client-0' uploader: objects_disappeared += 1
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\xf8'
<allmydata.magicfolderdb.MagicFolderDB object at 0x0784CED0>.did_upload_version(u'blam', 1, 'URI:LIT:', None, 1446237332.374, PathInfo(isdir=False, isfile=False, islink=False, exists=False, size=None, mtime=1446237332.374, ctime=1446237332.374))
insert
err... update
committed
Magic Folder 'client-0' uploader: files_uploaded += 1
Magic Folder 'client-0' uploader: objects_succeeded += 1
Magic Folder 'client-0' uploader: call_hook 'processed', ignore_count=0
Magic Folder 'client-1' downloader: _turn_deque
Magic Folder 'client-1' downloader: deque is now empty
Magic Folder 'client-1' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: found u'blam'
Magic Folder 'client-0' downloader: u'blam' has local version None, remote version 0
Magic Folder 'client-0' downloader: u'blam' added to download queue
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-1' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: _should_download(u'blam', 0)
Magic Folder 'client-0' downloader: yep
Magic Folder 'client-0' downloader: v = 1
Magic Folder 'client-0' downloader: Excluding u'blam'
Magic Folder 'client-0' downloader: objects_excluded += 1
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-1' downloader: found u'blam'
Magic Folder 'client-1' downloader: u'blam' has local version 0, remote version 1
Magic Folder 'client-1' downloader: u'blam' added to download queue
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _filter_scan_batch
Magic Folder 'client-1' downloader: _should_download(u'blam', 1)
Magic Folder 'client-1' downloader: yep
Magic Folder 'client-1' downloader: v = 0
Magic Folder 'client-1' downloader: result = [(u'blam', <allmydata.immutable.literal.LiteralFileNode object at 0x0486DE10>, {u'deleted': True, u'last_downloaded_timestamp': 1446237332.374, u'version': 1, u'tahoe': {u'linkmotime': 1446237332.419, u'linkcrtime': 1446237332.036}})]
Magic Folder 'client-1' downloader: deque = deque([])
Magic Folder 'client-1' downloader: deque after = deque([(u'blam', <allmydata.immutable.literal.LiteralFileNode object at 0x0486DE10>, {u'deleted': True, u'last_downloaded_timestamp': 1446237332.374, u'version': 1, u'tahoe': {u'linkmotime': 1446237332.419, u'linkcrtime': 1446237332.036}})])
Magic Folder 'client-1' downloader: objects_queued += 1
Magic Folder 'client-1' downloader: pending = set([])
Magic Folder 'client-1' downloader: pending after = set([u'blam'])
Magic Folder 'client-1' downloader: after _scan_remote_collective: None
Magic Folder 'client-1' downloader: _turn_deque
Magic Folder 'client-1' downloader: popped (u'blam', <allmydata.immutable.literal.LiteralFileNode object at 0x0486DE10>, {u'deleted': True, u'last_downloaded_timestamp': 1446237332.374, u'version': 1, u'tahoe': {u'linkmotime': 1446237332.419, u'linkcrtime': 1446237332.036}})
Magic Folder 'client-1' downloader: objects_queued += -1
Magic Folder 'client-1' downloader: _process((u'blam', <allmydata.immutable.literal.LiteralFileNode object at 0x0486DE10>, {u'deleted': True, u'last_downloaded_timestamp': 1446237332.374, u'version': 1, u'tahoe': {u'linkmotime': 1446237332.419, u'linkcrtime': 1446237332.036}}))
metadata {u'deleted': True, u'last_downloaded_timestamp': 1446237332.374, u'version': 1, u'tahoe': {u'linkmotime': 1446237332.419, u'linkcrtime': 1446237332.036}}
<<<<--- if None != u'URI:LIT:mnxw45dfnz2hgmak'
Magic Folder 'client-1' downloader: renaming deleted file to backup: \\?\C:\Users\peawe\git\magic-folder\_trial_temp\allmydata.test.test_magic_folder\MockTest\test_alice_delete_and_restore\ncgsek\temp\Bob-magic\blam
<allmydata.magicfolderdb.MagicFolderDB object at 0x05CAB410>.did_upload_version(u'blam', 1, None, 'URI:LIT:', 1446237332.586, PathInfo(isdir=False, isfile=False, islink=False, exists=False, size=None, mtime=1446237332.588, ctime=1446237332.588))
insert
err... update
committed
Magic Folder 'client-1' downloader: objects_downloaded += 1
Magic Folder 'client-1' downloader: call_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
Magic Folder 'client-1' downloader: set_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: inotify event None, FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_alice_delete_and_restore\\ncgsek\\temp\\Alice-magic\\blam'), 'close_write'
Magic Folder 'client-0' uploader: _get_relpath(FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_alice_delete_and_restore\\ncgsek\\temp\\Alice-magic\\blam'))
Magic Folder 'client-0' uploader: segments = [u'blam']
Magic Folder 'client-0' uploader: _append_to_deque(u'blam')
Magic Folder 'client-0' uploader: objects_queued += 1
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: popped u'blam'
Magic Folder 'client-0' uploader: objects_queued += -1
Magic Folder 'client-0' uploader: _process(u'blam')
Magic Folder 'client-0' uploader: pending = set([u'blam']), about to remove u'blam'
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\xf8'
<allmydata.magicfolderdb.MagicFolderDB object at 0x0784CED0>.did_upload_version(u'blam', 2, 'URI:LIT:mfwgsy3feb3xk6ranbsxezik', None, 1446237332.712, PathInfo(isdir=False, isfile=True, islink=False, exists=True, size=15L, mtime=1446237332.709799, ctime=1446237331.9814932))
insert
err... update
committed
Magic Folder 'client-0' uploader: files_uploaded += 1
Magic Folder 'client-0' uploader: objects_succeeded += 1
Magic Folder 'client-0' uploader: call_hook 'processed', ignore_count=0
Magic Folder 'client-1' downloader: _turn_deque
Magic Folder 'client-1' downloader: deque is now empty
Magic Folder 'client-1' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: found u'blam'
Magic Folder 'client-0' downloader: u'blam' has local version 2, remote version 1
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-1' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-1' downloader: found u'blam'
Magic Folder 'client-1' downloader: u'blam' has local version None, remote version 2
Magic Folder 'client-1' downloader: u'blam' added to download queue
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _filter_scan_batch
Magic Folder 'client-1' downloader: _should_download(u'blam', 2)
Magic Folder 'client-1' downloader: yep
Magic Folder 'client-1' downloader: v = 1
Magic Folder 'client-1' downloader: result = [(u'blam', <allmydata.immutable.literal.LiteralFileNode object at 0x045F7C90>, {u'last_downloaded_timestamp': 1446237332.712, u'version': 2, u'tahoe': {u'linkmotime': 1446237332.758, u'linkcrtime': 1446237332.036}})]
Magic Folder 'client-1' downloader: deque = deque([])
Magic Folder 'client-1' downloader: deque after = deque([(u'blam', <allmydata.immutable.literal.LiteralFileNode object at 0x045F7C90>, {u'last_downloaded_timestamp': 1446237332.712, u'version': 2, u'tahoe': {u'linkmotime': 1446237332.758, u'linkcrtime': 1446237332.036}})])
Magic Folder 'client-1' downloader: objects_queued += 1
Magic Folder 'client-1' downloader: pending = set([])
Magic Folder 'client-1' downloader: pending after = set([u'blam'])
Magic Folder 'client-1' downloader: after _scan_remote_collective: None
Magic Folder 'client-1' downloader: _turn_deque
Magic Folder 'client-1' downloader: popped (u'blam', <allmydata.immutable.literal.LiteralFileNode object at 0x045F7C90>, {u'last_downloaded_timestamp': 1446237332.712, u'version': 2, u'tahoe': {u'linkmotime': 1446237332.758, u'linkcrtime': 1446237332.036}})
Magic Folder 'client-1' downloader: objects_queued += -1
Magic Folder 'client-1' downloader: _process((u'blam', <allmydata.immutable.literal.LiteralFileNode object at 0x045F7C90>, {u'last_downloaded_timestamp': 1446237332.712, u'version': 2, u'tahoe': {u'linkmotime': 1446237332.758, u'linkcrtime': 1446237332.036}}))
metadata {u'last_downloaded_timestamp': 1446237332.712, u'version': 2, u'tahoe': {u'linkmotime': 1446237332.758, u'linkcrtime': 1446237332.036}}
<<<<--- if None != u'URI:LIT:'
Magic Folder 'client-1' downloader: _write_downloaded_file(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_alice_delete_and_restore\\ncgsek\\temp\\Bob-magic\\blam', <15 bytes>, is_conflict=False, now=None)
<allmydata.magicfolderdb.MagicFolderDB object at 0x05CAB410>.did_upload_version(u'blam', 2, None, 'URI:LIT:mfwgsy3feb3xk6ranbsxezik', 1446237332.922, PathInfo(isdir=False, isfile=True, islink=False, exists=True, size=15L, mtime=1446237322.923, ctime=1446237332.2514932))
insert
err... update
committed
Magic Folder 'client-1' downloader: objects_downloaded += 1
Magic Folder 'client-1' downloader: call_hook 'processed', ignore_count=0
finish
Magic Folder 'client-0' uploader: stop
Magic Folder 'client-0' uploader: dirs_monitored += -1
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-0' downloader: found u'blam'
Magic Folder 'client-0' downloader: u'blam' has local version 2, remote version 2
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: stopped
finish
Magic Folder 'client-1' uploader: stop
Magic Folder 'client-1' uploader: dirs_monitored += -1
Magic Folder 'client-1' downloader: _turn_deque
Magic Folder 'client-1' downloader: stopped
[OK]
test_alice_delete_bob_restore ... Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: set_hook 'started', ignore_count=0
<allmydata.frontends.magic_folder.MagicFolder object at 0x05693FD0>.startService
Magic Folder 'client-0' uploader: start_monitoring
Magic Folder 'client-0' uploader: dirs_monitored += 1
Magic Folder 'client-0' uploader: call_hook 'started', ignore_count=0
Magic Folder 'client-0' uploader: start_scanning
Magic Folder 'client-0' uploader: all_files set([])
Magic Folder 'client-0' uploader: scan u''
Magic Folder 'client-0' uploader: adding set([])
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: start_scanning
Magic Folder 'client-0' downloader: all files set([])
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-1' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-1' downloader: set_hook 'started', ignore_count=0
<allmydata.frontends.magic_folder.MagicFolder object at 0x0486DE10>.startService
Magic Folder 'client-1' uploader: start_monitoring
Magic Folder 'client-1' uploader: dirs_monitored += 1
Magic Folder 'client-1' uploader: call_hook 'started', ignore_count=0
Magic Folder 'client-1' uploader: start_scanning
Magic Folder 'client-1' uploader: all_files set([])
Magic Folder 'client-1' uploader: scan u''
Magic Folder 'client-1' uploader: adding set([])
Magic Folder 'client-1' uploader: _turn_deque
Magic Folder 'client-1' uploader: deque is now empty
Magic Folder 'client-1' downloader: start_scanning
Magic Folder 'client-1' downloader: all files set([])
Magic Folder 'client-1' downloader: _scan_remote_collective
Magic Folder 'client-1' downloader: _turn_deque
Magic Folder 'client-1' downloader: deque is now empty
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
Magic Folder 'client-1' downloader: set_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: inotify event None, FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_alice_delete_bob_restore\\kqhd_k\\temp\\Alice-magic\\blam'), 'close_write'
Magic Folder 'client-0' uploader: _get_relpath(FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_alice_delete_bob_restore\\kqhd_k\\temp\\Alice-magic\\blam'))
Magic Folder 'client-0' uploader: segments = [u'blam']
Magic Folder 'client-0' uploader: _append_to_deque(u'blam')
Magic Folder 'client-0' uploader: objects_queued += 1
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: popped u'blam'
Magic Folder 'client-0' uploader: objects_queued += -1
Magic Folder 'client-0' uploader: _process(u'blam')
Magic Folder 'client-0' uploader: pending = set([u'blam']), about to remove u'blam'
Magic Folder 'client-1' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\xf8'
<allmydata.magicfolderdb.MagicFolderDB object at 0x0784C1D0>.did_upload_version(u'blam', 0, 'URI:LIT:mnxw45dfnz2hgmak', None, 1446237334.561, PathInfo(isdir=False, isfile=True, islink=False, exists=True, size=10L, mtime=1446237334.5580306, ctime=1446237334.5570292))
insert
committed
Magic Folder 'client-0' uploader: files_uploaded += 1
Magic Folder 'client-0' uploader: objects_succeeded += 1
Magic Folder 'client-0' uploader: call_hook 'processed', ignore_count=0
Magic Folder 'client-1' downloader: _scan_remote_collective
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _filter_scan_batch
Magic Folder 'client-1' downloader: result = []
Magic Folder 'client-1' downloader: deque = deque([])
Magic Folder 'client-1' downloader: deque after = deque([])
Magic Folder 'client-1' downloader: objects_queued += 0
Magic Folder 'client-1' downloader: pending = set([])
Magic Folder 'client-1' downloader: pending after = set([])
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-1' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-1' downloader: found u'blam'
Magic Folder 'client-1' downloader: u'blam' has local version None, remote version 0
Magic Folder 'client-1' downloader: u'blam' added to download queue
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _filter_scan_batch
Magic Folder 'client-1' downloader: _should_download(u'blam', 0)
Magic Folder 'client-1' downloader: yep
Magic Folder 'client-1' downloader: v = None
Magic Folder 'client-1' downloader: result = [(u'blam', <allmydata.immutable.literal.LiteralFileNode object at 0x04884BF0>, {u'last_downloaded_timestamp': 1446237334.561, u'version': 0, u'tahoe': {u'linkmotime': 1446237334.616, u'linkcrtime': 1446237334.616}})]
Magic Folder 'client-1' downloader: deque = deque([])
Magic Folder 'client-1' downloader: deque after = deque([(u'blam', <allmydata.immutable.literal.LiteralFileNode object at 0x04884BF0>, {u'last_downloaded_timestamp': 1446237334.561, u'version': 0, u'tahoe': {u'linkmotime': 1446237334.616, u'linkcrtime': 1446237334.616}})])
Magic Folder 'client-1' downloader: objects_queued += 1
Magic Folder 'client-1' downloader: pending = set([])
Magic Folder 'client-1' downloader: pending after = set([u'blam'])
Magic Folder 'client-1' downloader: after _scan_remote_collective: None
Magic Folder 'client-1' downloader: _turn_deque
Magic Folder 'client-1' downloader: popped (u'blam', <allmydata.immutable.literal.LiteralFileNode object at 0x04884BF0>, {u'last_downloaded_timestamp': 1446237334.561, u'version': 0, u'tahoe': {u'linkmotime': 1446237334.616, u'linkcrtime': 1446237334.616}})
Magic Folder 'client-1' downloader: objects_queued += -1
Magic Folder 'client-1' downloader: _process((u'blam', <allmydata.immutable.literal.LiteralFileNode object at 0x04884BF0>, {u'last_downloaded_timestamp': 1446237334.561, u'version': 0, u'tahoe': {u'linkmotime': 1446237334.616, u'linkcrtime': 1446237334.616}}))
Magic Folder 'client-1' downloader: _write_downloaded_file(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_alice_delete_bob_restore\\kqhd_k\\temp\\Bob-magic\\blam', <10 bytes>, is_conflict=False, now=None)
<allmydata.magicfolderdb.MagicFolderDB object at 0x05999BB0>.did_upload_version(u'blam', 0, None, 'URI:LIT:mnxw45dfnz2hgmak', 1446237334.828, PathInfo(isdir=False, isfile=True, islink=False, exists=True, size=10L, mtime=1446237324.828999, ctime=1446237334.829332))
insert
committed
Magic Folder 'client-1' downloader: objects_downloaded += 1
Magic Folder 'client-1' downloader: call_hook 'processed', ignore_count=0
BOB DELETE
Magic Folder 'client-1' uploader: set_hook 'processed', ignore_count=0
Magic Folder 'client-0' downloader: set_hook 'processed', ignore_count=0
Magic Folder 'client-1' uploader: inotify event None, FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_alice_delete_bob_restore\\kqhd_k\\temp\\Bob-magic\\blam'), 'delete'
Magic Folder 'client-1' uploader: _get_relpath(FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_alice_delete_bob_restore\\kqhd_k\\temp\\Bob-magic\\blam'))
Magic Folder 'client-1' uploader: segments = [u'blam']
Magic Folder 'client-1' uploader: _append_to_deque(u'blam')
Magic Folder 'client-1' uploader: objects_queued += 1
Magic Folder 'client-1' downloader: _turn_deque
Magic Folder 'client-1' downloader: deque is now empty
Magic Folder 'client-1' uploader: _turn_deque
Magic Folder 'client-1' uploader: popped u'blam'
Magic Folder 'client-1' uploader: objects_queued += -1
Magic Folder 'client-1' uploader: _process(u'blam')
Magic Folder 'client-1' uploader: pending = set([u'blam']), about to remove u'blam'
Magic Folder 'client-1' uploader: notified object 'C:\Users\peawe\git\magic-folder\_trial_temp\allmydata.test.test_magic_folder\MockTest\test_alice_delete_bob_restore\kqhd_k\temp\Bob-magic\blam' disappeared (this is normal)
Magic Folder 'client-1' uploader: objects_disappeared += 1
Magic Folder 'client-1' downloader: _scan_remote_collective
Magic Folder 'client-1' downloader: _scan_remote nickname u'Alice\xf8'
<allmydata.magicfolderdb.MagicFolderDB object at 0x05999BB0>.did_upload_version(u'blam', 1, 'URI:LIT:', u'URI:LIT:mnxw45dfnz2hgmak', 1446237334.96, PathInfo(isdir=False, isfile=False, islink=False, exists=False, size=None, mtime=1446237334.96, ctime=1446237334.96))
insert
err... update
committed
Magic Folder 'client-1' uploader: files_uploaded += 1
Magic Folder 'client-1' uploader: objects_succeeded += 1
Magic Folder 'client-1' uploader: call_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-1' downloader: found u'blam'
Magic Folder 'client-1' downloader: u'blam' has local version None, remote version 0
Magic Folder 'client-1' downloader: u'blam' added to download queue
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-1' downloader: found u'blam'
Magic Folder 'client-1' downloader: u'blam' has local version None, remote version 1
Magic Folder 'client-1' downloader: u'blam' added to download queue
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _filter_scan_batch
Magic Folder 'client-1' downloader: _should_download(u'blam', 1)
Magic Folder 'client-1' downloader: yep
Magic Folder 'client-1' downloader: v = 1
Magic Folder 'client-1' downloader: Excluding u'blam'
Magic Folder 'client-1' downloader: objects_excluded += 1
Magic Folder 'client-1' downloader: result = []
Magic Folder 'client-1' downloader: deque = deque([])
Magic Folder 'client-1' downloader: deque after = deque([])
Magic Folder 'client-1' downloader: objects_queued += 0
Magic Folder 'client-1' downloader: pending = set([])
Magic Folder 'client-1' downloader: pending after = set([])
Magic Folder 'client-1' downloader: after _scan_remote_collective: None
Magic Folder 'client-1' downloader: _turn_deque
Magic Folder 'client-1' downloader: deque is now empty
Magic Folder 'client-0' downloader: found u'blam'
Magic Folder 'client-0' downloader: u'blam' has local version 0, remote version 0
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-0' downloader: found u'blam'
Magic Folder 'client-0' downloader: u'blam' has local version 0, remote version 1
Magic Folder 'client-0' downloader: u'blam' added to download queue
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: _should_download(u'blam', 1)
Magic Folder 'client-0' downloader: yep
Magic Folder 'client-0' downloader: v = 0
Magic Folder 'client-0' downloader: result = [(u'blam', <allmydata.immutable.literal.LiteralFileNode object at 0x04FD4C50>, {u'deleted': True, u'last_downloaded_timestamp': 1446237334.96, u'version': 1, u'last_downloaded_uri': u'URI:LIT:mnxw45dfnz2hgmak', u'tahoe': {u'linkmotime': 1446237335.002, u'linkcrtime': 1446237335.002}})]
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([(u'blam', <allmydata.immutable.literal.LiteralFileNode object at 0x04FD4C50>, {u'deleted': True, u'last_downloaded_timestamp': 1446237334.96, u'version': 1, u'last_downloaded_uri': u'URI:LIT:mnxw45dfnz2hgmak', u'tahoe': {u'linkmotime': 1446237335.002, u'linkcrtime': 1446237335.002}})])
Magic Folder 'client-0' downloader: objects_queued += 1
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([u'blam'])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: popped (u'blam', <allmydata.immutable.literal.LiteralFileNode object at 0x04FD4C50>, {u'deleted': True, u'last_downloaded_timestamp': 1446237334.96, u'version': 1, u'last_downloaded_uri': u'URI:LIT:mnxw45dfnz2hgmak', u'tahoe': {u'linkmotime': 1446237335.002, u'linkcrtime': 1446237335.002}})
Magic Folder 'client-0' downloader: objects_queued += -1
Magic Folder 'client-0' downloader: _process((u'blam', <allmydata.immutable.literal.LiteralFileNode object at 0x04FD4C50>, {u'deleted': True, u'last_downloaded_timestamp': 1446237334.96, u'version': 1, u'last_downloaded_uri': u'URI:LIT:mnxw45dfnz2hgmak', u'tahoe': {u'linkmotime': 1446237335.002, u'linkcrtime': 1446237335.002}}))
metadata {u'deleted': True, u'last_downloaded_timestamp': 1446237334.96, u'version': 1, u'last_downloaded_uri': u'URI:LIT:mnxw45dfnz2hgmak', u'tahoe': {u'linkmotime': 1446237335.002, u'linkcrtime': 1446237335.002}}
<<<<--- if u'URI:LIT:mnxw45dfnz2hgmak' != None
Magic Folder 'client-0' downloader: renaming deleted file to backup: \\?\C:\Users\peawe\git\magic-folder\_trial_temp\allmydata.test.test_magic_folder\MockTest\test_alice_delete_bob_restore\kqhd_k\temp\Alice-magic\blam
<allmydata.magicfolderdb.MagicFolderDB object at 0x0784C1D0>.did_upload_version(u'blam', 1, None, 'URI:LIT:', 1446237335.206, PathInfo(isdir=False, isfile=False, islink=False, exists=False, size=None, mtime=1446237335.207, ctime=1446237335.207))
insert
err... update
committed
Magic Folder 'client-0' downloader: objects_downloaded += 1
Magic Folder 'client-0' downloader: call_hook 'processed', ignore_count=0
ALICE RESTORE
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
Magic Folder 'client-1' downloader: set_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: inotify event None, FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_alice_delete_bob_restore\\kqhd_k\\temp\\Alice-magic\\blam'), 'close_write'
Magic Folder 'client-0' uploader: _get_relpath(FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_alice_delete_bob_restore\\kqhd_k\\temp\\Alice-magic\\blam'))
Magic Folder 'client-0' uploader: segments = [u'blam']
Magic Folder 'client-0' uploader: _append_to_deque(u'blam')
Magic Folder 'client-0' uploader: objects_queued += 1
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: popped u'blam'
Magic Folder 'client-0' uploader: objects_queued += -1
Magic Folder 'client-0' uploader: _process(u'blam')
Magic Folder 'client-0' uploader: pending = set([u'blam']), about to remove u'blam'
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\xf8'
<allmydata.magicfolderdb.MagicFolderDB object at 0x0784C1D0>.did_upload_version(u'blam', 2, 'URI:LIT:nzsxoiddn5xhizloorzqu', u'URI:LIT:', 1446237335.383, PathInfo(isdir=False, isfile=True, islink=False, exists=True, size=13L, mtime=1446237335.380444, ctime=1446237334.5570292))
insert
err... update
committed
Magic Folder 'client-0' uploader: files_uploaded += 1
Magic Folder 'client-0' uploader: objects_succeeded += 1
Magic Folder 'client-0' uploader: call_hook 'processed', ignore_count=0
Magic Folder 'client-1' uploader: _turn_deque
Magic Folder 'client-1' uploader: deque is now empty
Magic Folder 'client-1' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: found u'blam'
Magic Folder 'client-0' downloader: u'blam' has local version 2, remote version 0
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-1' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-0' downloader: found u'blam'
Magic Folder 'client-0' downloader: u'blam' has local version 2, remote version 1
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-1' downloader: found u'blam'
Magic Folder 'client-1' downloader: u'blam' has local version None, remote version 2
Magic Folder 'client-1' downloader: u'blam' added to download queue
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-1' downloader: found u'blam'
Magic Folder 'client-1' downloader: u'blam' has local version None, remote version 1
Magic Folder 'client-1' downloader: u'blam' added to download queue
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _filter_scan_batch
Magic Folder 'client-1' downloader: _should_download(u'blam', 2)
Magic Folder 'client-1' downloader: yep
Magic Folder 'client-1' downloader: v = 1
Magic Folder 'client-1' downloader: result = [(u'blam', <allmydata.immutable.literal.LiteralFileNode object at 0x04FE9450>, {u'last_downloaded_timestamp': 1446237335.383, u'version': 2, u'last_downloaded_uri': u'URI:LIT:', u'tahoe': {u'linkmotime': 1446237335.428, u'linkcrtime': 1446237334.616}})]
Magic Folder 'client-1' downloader: deque = deque([])
Magic Folder 'client-1' downloader: deque after = deque([(u'blam', <allmydata.immutable.literal.LiteralFileNode object at 0x04FE9450>, {u'last_downloaded_timestamp': 1446237335.383, u'version': 2, u'last_downloaded_uri': u'URI:LIT:', u'tahoe': {u'linkmotime': 1446237335.428, u'linkcrtime': 1446237334.616}})])
Magic Folder 'client-1' downloader: objects_queued += 1
Magic Folder 'client-1' downloader: pending = set([])
Magic Folder 'client-1' downloader: pending after = set([u'blam'])
Magic Folder 'client-1' downloader: after _scan_remote_collective: None
Magic Folder 'client-1' downloader: _turn_deque
Magic Folder 'client-1' downloader: popped (u'blam', <allmydata.immutable.literal.LiteralFileNode object at 0x04FE9450>, {u'last_downloaded_timestamp': 1446237335.383, u'version': 2, u'last_downloaded_uri': u'URI:LIT:', u'tahoe': {u'linkmotime': 1446237335.428, u'linkcrtime': 1446237334.616}})
Magic Folder 'client-1' downloader: objects_queued += -1
Magic Folder 'client-1' downloader: _process((u'blam', <allmydata.immutable.literal.LiteralFileNode object at 0x04FE9450>, {u'last_downloaded_timestamp': 1446237335.383, u'version': 2, u'last_downloaded_uri': u'URI:LIT:', u'tahoe': {u'linkmotime': 1446237335.428, u'linkcrtime': 1446237334.616}}))
metadata {u'last_downloaded_timestamp': 1446237335.383, u'version': 2, u'last_downloaded_uri': u'URI:LIT:', u'tahoe': {u'linkmotime': 1446237335.428, u'linkcrtime': 1446237334.616}}
<<<<--- if u'URI:LIT:' != u'URI:LIT:mnxw45dfnz2hgmak'
Magic Folder 'client-1' downloader: objects_conflicted += 1
Magic Folder 'client-1' downloader: _write_downloaded_file(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_alice_delete_bob_restore\\kqhd_k\\temp\\Bob-magic\\blam', <13 bytes>, is_conflict=True, now=None)
0x00 ------------ <><> is conflict; calling _rename_conflicted_file... u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_alice_delete_bob_restore\\kqhd_k\\temp\\Bob-magic\\blam' u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_alice_delete_bob_restore\\kqhd_k\\temp\\Bob-magic\\blam.tmp'
Magic Folder 'client-1' downloader: _rename_conflicted_file(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_alice_delete_bob_restore\\kqhd_k\\temp\\Bob-magic\\blam', u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_alice_delete_bob_restore\\kqhd_k\\temp\\Bob-magic\\blam.tmp')
XXX rename u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_alice_delete_bob_restore\\kqhd_k\\temp\\Bob-magic\\blam.tmp' u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_alice_delete_bob_restore\\kqhd_k\\temp\\Bob-magic\\blam.conflict'
u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_alice_delete_bob_restore\\kqhd_k\\temp\\Bob-magic\\blam.tmp' exists
<allmydata.magicfolderdb.MagicFolderDB object at 0x05999BB0>.did_upload_version(u'blam', 2, None, 'URI:LIT:nzsxoiddn5xhizloorzqu', 1446237335.623, PathInfo(isdir=False, isfile=True, islink=False, exists=True, size=13L, mtime=1446237325.625, ctime=1446237334.829332))
insert
err... update
committed
Magic Folder 'client-1' downloader: objects_downloaded += 1
Magic Folder 'client-1' downloader: call_hook 'processed', ignore_count=0
finish
Magic Folder 'client-0' uploader: stop
Magic Folder 'client-0' uploader: dirs_monitored += -1
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-0' downloader: found u'blam'
Magic Folder 'client-0' downloader: u'blam' has local version 2, remote version 2
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-0' downloader: found u'blam'
Magic Folder 'client-0' downloader: u'blam' has local version 2, remote version 1
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: stopped
finish
Magic Folder 'client-1' uploader: stop
Magic Folder 'client-1' uploader: dirs_monitored += -1
Magic Folder 'client-1' downloader: _turn_deque
Magic Folder 'client-1' downloader: stopped
[OK]
test_db_basic ... [OK]
test_db_persistence ... <allmydata.magicfolderdb.MagicFolderDB object at 0x0749E830>.did_upload_version(u'myFile1', 0, 'URI:LIT:1', 'URI:LIT:0', 0, PathInfo(isdir=False, isfile=True, islink=False, exists=True, size=1, mtime=123, ctime=456))
insert
committed
<allmydata.magicfolderdb.MagicFolderDB object at 0x0749E830>.did_upload_version(u'myFile2', 0, 'URI:LIT:2', 'URI:LIT:1', 0, PathInfo(isdir=False, isfile=True, islink=False, exists=True, size=5L, mtime=1446237336.2510176, ctime=1446237336.2440164))
insert
committed
[OK]
test_delete ... Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: set_hook 'started', ignore_count=0
<allmydata.frontends.magic_folder.MagicFolder object at 0x0698E8F0>.startService
Magic Folder 'client-0' uploader: start_monitoring
Magic Folder 'client-0' uploader: dirs_monitored += 1
Magic Folder 'client-0' uploader: call_hook 'started', ignore_count=0
Magic Folder 'client-0' uploader: start_scanning
Magic Folder 'client-0' uploader: all_files set([])
Magic Folder 'client-0' uploader: scan u''
Magic Folder 'client-0' uploader: adding set([])
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: start_scanning
Magic Folder 'client-0' downloader: all files set([])
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: inotify event None, FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_delete\\pva6ma\\temp\\local_dir\\foo'), 'close_write'
Magic Folder 'client-0' uploader: _get_relpath(FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_delete\\pva6ma\\temp\\local_dir\\foo'))
Magic Folder 'client-0' uploader: segments = [u'foo']
Magic Folder 'client-0' uploader: _append_to_deque(u'foo')
Magic Folder 'client-0' uploader: objects_queued += 1
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: popped u'foo'
Magic Folder 'client-0' uploader: objects_queued += -1
Magic Folder 'client-0' uploader: _process(u'foo')
Magic Folder 'client-0' uploader: pending = set([u'foo']), about to remove u'foo'
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
<allmydata.magicfolderdb.MagicFolderDB object at 0x0698ECB0>.did_upload_version(u'foo', 0, 'URI:LIT:mzxw6cq', None, 1446237337.196, PathInfo(isdir=False, isfile=True, islink=False, exists=True, size=4L, mtime=1446237337.193993, ctime=1446237337.1934931))
insert
committed
Magic Folder 'client-0' uploader: files_uploaded += 1
Magic Folder 'client-0' uploader: objects_succeeded += 1
Magic Folder 'client-0' uploader: call_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: inotify event None, FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_delete\\pva6ma\\temp\\local_dir\\foo'), 'delete'
Magic Folder 'client-0' uploader: _get_relpath(FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_delete\\pva6ma\\temp\\local_dir\\foo'))
Magic Folder 'client-0' uploader: segments = [u'foo']
Magic Folder 'client-0' uploader: _append_to_deque(u'foo')
Magic Folder 'client-0' uploader: objects_queued += 1
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: popped u'foo'
Magic Folder 'client-0' uploader: objects_queued += -1
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' uploader: _process(u'foo')
Magic Folder 'client-0' uploader: pending = set([u'foo']), about to remove u'foo'
Magic Folder 'client-0' uploader: notified object 'C:\Users\peawe\git\magic-folder\_trial_temp\allmydata.test.test_magic_folder\MockTest\test_delete\pva6ma\temp\local_dir\foo' disappeared (this is normal)
Magic Folder 'client-0' uploader: objects_disappeared += 1
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
Magic Folder 'client-0' downloader: found u'foo'
Magic Folder 'client-0' downloader: u'foo' has local version None, remote version 0
Magic Folder 'client-0' downloader: u'foo' added to download queue
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: _should_download(u'foo', 0)
Magic Folder 'client-0' downloader: yep
Magic Folder 'client-0' downloader: v = 0
Magic Folder 'client-0' downloader: Excluding u'foo'
Magic Folder 'client-0' downloader: objects_excluded += 1
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
<allmydata.magicfolderdb.MagicFolderDB object at 0x0698ECB0>.did_upload_version(u'foo', 1, 'URI:LIT:', None, 1446237337.369, PathInfo(isdir=False, isfile=False, islink=False, exists=False, size=None, mtime=1446237337.369, ctime=1446237337.369))
insert
err... update
committed
Magic Folder 'client-0' uploader: files_uploaded += 1
Magic Folder 'client-0' uploader: objects_succeeded += 1
Magic Folder 'client-0' uploader: call_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
Magic Folder 'client-0' downloader: found u'foo'
Magic Folder 'client-0' downloader: u'foo' has local version None, remote version 1
Magic Folder 'client-0' downloader: u'foo' added to download queue
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: _should_download(u'foo', 1)
Magic Folder 'client-0' downloader: yep
Magic Folder 'client-0' downloader: v = 1
Magic Folder 'client-0' downloader: Excluding u'foo'
Magic Folder 'client-0' downloader: objects_excluded += 1
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
finish
Magic Folder 'client-0' uploader: stop
Magic Folder 'client-0' uploader: dirs_monitored += -1
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
Magic Folder 'client-0' downloader: found u'foo'
Magic Folder 'client-0' downloader: u'foo' has local version None, remote version 1
Magic Folder 'client-0' downloader: u'foo' added to download queue
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: _should_download(u'foo', 1)
Magic Folder 'client-0' downloader: yep
Magic Folder 'client-0' downloader: v = 1
Magic Folder 'client-0' downloader: Excluding u'foo'
Magic Folder 'client-0' downloader: objects_excluded += 1
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: stopped
[OK]
test_delete_and_restore ... Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: set_hook 'started', ignore_count=0
<allmydata.frontends.magic_folder.MagicFolder object at 0x07259A90>.startService
Magic Folder 'client-0' uploader: start_monitoring
Magic Folder 'client-0' uploader: dirs_monitored += 1
Magic Folder 'client-0' uploader: call_hook 'started', ignore_count=0
Magic Folder 'client-0' uploader: start_scanning
Magic Folder 'client-0' uploader: all_files set([])
Magic Folder 'client-0' uploader: scan u''
Magic Folder 'client-0' uploader: adding set([])
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: start_scanning
Magic Folder 'client-0' downloader: all files set([])
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: inotify event None, FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_delete_and_restore\\mnlqca\\temp\\local_dir\\foo'), 'close_write'
Magic Folder 'client-0' uploader: _get_relpath(FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_delete_and_restore\\mnlqca\\temp\\local_dir\\foo'))
Magic Folder 'client-0' uploader: segments = [u'foo']
Magic Folder 'client-0' uploader: _append_to_deque(u'foo')
Magic Folder 'client-0' uploader: objects_queued += 1
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: popped u'foo'
Magic Folder 'client-0' uploader: objects_queued += -1
Magic Folder 'client-0' uploader: _process(u'foo')
Magic Folder 'client-0' uploader: pending = set([u'foo']), about to remove u'foo'
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
<allmydata.magicfolderdb.MagicFolderDB object at 0x07259BD0>.did_upload_version(u'foo', 0, 'URI:LIT:mzxw6cq', None, 1446237338.565, PathInfo(isdir=False, isfile=True, islink=False, exists=True, size=4L, mtime=1446237338.5628664, ctime=1446237338.562367))
insert
committed
Magic Folder 'client-0' uploader: files_uploaded += 1
Magic Folder 'client-0' uploader: objects_succeeded += 1
Magic Folder 'client-0' uploader: call_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: inotify event None, FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_delete_and_restore\\mnlqca\\temp\\local_dir\\foo'), 'delete'
Magic Folder 'client-0' uploader: _get_relpath(FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_delete_and_restore\\mnlqca\\temp\\local_dir\\foo'))
Magic Folder 'client-0' uploader: segments = [u'foo']
Magic Folder 'client-0' uploader: _append_to_deque(u'foo')
Magic Folder 'client-0' uploader: objects_queued += 1
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: popped u'foo'
Magic Folder 'client-0' uploader: objects_queued += -1
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' uploader: _process(u'foo')
Magic Folder 'client-0' uploader: pending = set([u'foo']), about to remove u'foo'
Magic Folder 'client-0' uploader: notified object 'C:\Users\peawe\git\magic-folder\_trial_temp\allmydata.test.test_magic_folder\MockTest\test_delete_and_restore\mnlqca\temp\local_dir\foo' disappeared (this is normal)
Magic Folder 'client-0' uploader: objects_disappeared += 1
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
Magic Folder 'client-0' downloader: found u'foo'
Magic Folder 'client-0' downloader: u'foo' has local version None, remote version 0
Magic Folder 'client-0' downloader: u'foo' added to download queue
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: _should_download(u'foo', 0)
Magic Folder 'client-0' downloader: yep
Magic Folder 'client-0' downloader: v = 0
Magic Folder 'client-0' downloader: Excluding u'foo'
Magic Folder 'client-0' downloader: objects_excluded += 1
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
<allmydata.magicfolderdb.MagicFolderDB object at 0x07259BD0>.did_upload_version(u'foo', 1, 'URI:LIT:', None, 1446237338.713, PathInfo(isdir=False, isfile=False, islink=False, exists=False, size=None, mtime=1446237338.713, ctime=1446237338.713))
insert
err... update
committed
Magic Folder 'client-0' uploader: files_uploaded += 1
Magic Folder 'client-0' uploader: objects_succeeded += 1
Magic Folder 'client-0' uploader: call_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
Magic Folder 'client-0' downloader: found u'foo'
Magic Folder 'client-0' downloader: u'foo' has local version None, remote version 1
Magic Folder 'client-0' downloader: u'foo' added to download queue
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: _should_download(u'foo', 1)
Magic Folder 'client-0' downloader: yep
Magic Folder 'client-0' downloader: v = 1
Magic Folder 'client-0' downloader: Excluding u'foo'
Magic Folder 'client-0' downloader: objects_excluded += 1
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: inotify event None, FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_delete_and_restore\\mnlqca\\temp\\local_dir\\foo'), 'close_write'
Magic Folder 'client-0' uploader: _get_relpath(FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_delete_and_restore\\mnlqca\\temp\\local_dir\\foo'))
Magic Folder 'client-0' uploader: segments = [u'foo']
Magic Folder 'client-0' uploader: _append_to_deque(u'foo')
Magic Folder 'client-0' uploader: objects_queued += 1
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: popped u'foo'
Magic Folder 'client-0' uploader: objects_queued += -1
Magic Folder 'client-0' uploader: _process(u'foo')
Magic Folder 'client-0' uploader: pending = set([u'foo']), about to remove u'foo'
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
Magic Folder 'client-0' downloader: found u'foo'
Magic Folder 'client-0' downloader: u'foo' has local version 1, remote version 1
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
<allmydata.magicfolderdb.MagicFolderDB object at 0x07259BD0>.did_upload_version(u'foo', 2, 'URI:LIT:mjqxecq', None, 1446237338.929, PathInfo(isdir=False, isfile=True, islink=False, exists=True, size=4L, mtime=1446237338.9264183, ctime=1446237338.562367))
insert
err... update
committed
Magic Folder 'client-0' uploader: files_uploaded += 1
Magic Folder 'client-0' uploader: objects_succeeded += 1
Magic Folder 'client-0' uploader: call_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
Magic Folder 'client-0' downloader: found u'foo'
Magic Folder 'client-0' downloader: u'foo' has local version 2, remote version 2
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
finish
Magic Folder 'client-0' uploader: stop
Magic Folder 'client-0' uploader: dirs_monitored += -1
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
Magic Folder 'client-0' downloader: found u'foo'
Magic Folder 'client-0' downloader: u'foo' has local version 2, remote version 2
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: stopped
[OK]
test_errors ... Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Traceback (most recent call last):
File "c:\users\peawe\git\magic-folder\src\allmydata\test\common.py", line 1061, in done
% (which, substring, message))
File "C:\Users\peawe\git\magic-folder\support\Lib\site-packages\twisted-15.4.0-py2.7-win32.egg\twisted\trial\_synctest.py", line 400, in assertTrue
super(_Assertions, self).assertTrue(condition, msg)
File "C:\Python27\lib\unittest\case.py", line 422, in assertTrue
raise self.failureException(msg)
twisted.trial.unittest.FailTest: collective dircap: substring 'The URI in 'private\collective_dircap' is not a readonly cap to a directory.' not in '"The URI in 'private\\collective_dircap' is not a readonly cap to a directory."'
[ERROR]
test_magic_folder ... Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: set_hook 'started', ignore_count=0
<allmydata.frontends.magic_folder.MagicFolder object at 0x06933630>.startService
Magic Folder 'client-0' uploader: start_monitoring
Magic Folder 'client-0' uploader: dirs_monitored += 1
Magic Folder 'client-0' uploader: call_hook 'started', ignore_count=0
Magic Folder 'client-0' uploader: start_scanning
Magic Folder 'client-0' uploader: all_files set([])
Magic Folder 'client-0' uploader: scan u''
Magic Folder 'client-0' uploader: adding set([])
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: start_scanning
Magic Folder 'client-0' downloader: all files set([])
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: inotify event None, FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_magic_folder\\u1hnwl\\temp\\loc\u0101l_dir\\short'), 'close_write'
Magic Folder 'client-0' uploader: _get_relpath(FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_magic_folder\\u1hnwl\\temp\\loc\u0101l_dir\\short'))
Magic Folder 'client-0' uploader: segments = [u'short']
Magic Folder 'client-0' uploader: _append_to_deque(u'short')
Magic Folder 'client-0' uploader: objects_queued += 1
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: popped u'short'
Magic Folder 'client-0' uploader: objects_queued += -1
Magic Folder 'client-0' uploader: _process(u'short')
Magic Folder 'client-0' uploader: pending = set([u'short']), about to remove u'short'
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
<allmydata.magicfolderdb.MagicFolderDB object at 0x06ED5790>.did_upload_version(u'short', 0, 'URI:LIT:orsxg5a', None, 1446237340.898, PathInfo(isdir=False, isfile=True, islink=False, exists=True, size=4L, mtime=1446237340.8946116, ctime=1446237340.8941114))
insert
committed
Magic Folder 'client-0' uploader: files_uploaded += 1
Magic Folder 'client-0' uploader: objects_succeeded += 1
Magic Folder 'client-0' uploader: call_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: inotify event None, FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_magic_folder\\u1hnwl\\temp\\loc\u0101l_dir\\short'), 'close_write'
Magic Folder 'client-0' uploader: _get_relpath(FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_magic_folder\\u1hnwl\\temp\\loc\u0101l_dir\\short'))
Magic Folder 'client-0' uploader: segments = [u'short']
Magic Folder 'client-0' uploader: _append_to_deque(u'short')
Magic Folder 'client-0' uploader: objects_queued += 1
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: popped u'short'
Magic Folder 'client-0' uploader: objects_queued += -1
Magic Folder 'client-0' uploader: _process(u'short')
Magic Folder 'client-0' uploader: pending = set([u'short']), about to remove u'short'
Magic Folder 'client-0' downloader: found u'short'
Magic Folder 'client-0' downloader: u'short' has local version 0, remote version 0
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
<allmydata.magicfolderdb.MagicFolderDB object at 0x06ED5790>.did_upload_version(u'short', 1, 'URI:LIT:mruwmztfojsw45a', None, 1446237341.101, PathInfo(isdir=False, isfile=True, islink=False, exists=True, size=9L, mtime=1446237341.0981119, ctime=1446237340.8941114))
insert
err... update
committed
Magic Folder 'client-0' uploader: files_uploaded += 1
Magic Folder 'client-0' uploader: objects_succeeded += 1
Magic Folder 'client-0' uploader: call_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: found u'short'
Magic Folder 'client-0' downloader: u'short' has local version 1, remote version 1
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: inotify event None, FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_magic_folder\\u1hnwl\\temp\\loc\u0101l_dir\\tempfile'), 'delete'
Magic Folder 'client-0' uploader: _get_relpath(FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_magic_folder\\u1hnwl\\temp\\loc\u0101l_dir\\tempfile'))
Magic Folder 'client-0' uploader: segments = [u'tempfile']
Magic Folder 'client-0' uploader: _append_to_deque(u'tempfile')
Magic Folder 'client-0' uploader: objects_queued += 1
Magic Folder 'client-0' uploader: inotify event None, FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_magic_folder\\u1hnwl\\temp\\loc\u0101l_dir\\tempfile'), 'close_write'
Magic Folder 'client-0' uploader: _get_relpath(FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_magic_folder\\u1hnwl\\temp\\loc\u0101l_dir\\tempfile'))
Magic Folder 'client-0' uploader: segments = [u'tempfile']
Magic Folder 'client-0' uploader: _append_to_deque(u'tempfile')
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: popped u'tempfile'
Magic Folder 'client-0' uploader: objects_queued += -1
Magic Folder 'client-0' uploader: _process(u'tempfile')
Magic Folder 'client-0' uploader: pending = set([u'tempfile']), about to remove u'tempfile'
Magic Folder 'client-0' uploader: notified object 'C:\Users\peawe\git\magic-folder\_trial_temp\allmydata.test.test_magic_folder\MockTest\test_magic_folder\u1hnwl\temp\locāl_dir\tempfile' disappeared (this is normal)
Magic Folder 'client-0' uploader: objects_disappeared += 1
Magic Folder 'client-0' uploader: objects_succeeded += 1
Magic Folder 'client-0' uploader: call_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: inotify event None, FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_magic_folder\\u1hnwl\\temp\\loc\u0101l_dir\\directory\\'), 'create, is_dir'
Magic Folder 'client-0' uploader: _get_relpath(FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_magic_folder\\u1hnwl\\temp\\loc\u0101l_dir\\directory\\'))
Magic Folder 'client-0' uploader: segments = [u'directory', u'']
Magic Folder 'client-0' uploader: _append_to_deque(u'directory/')
Magic Folder 'client-0' uploader: objects_queued += 1
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: popped u'directory/'
Magic Folder 'client-0' uploader: objects_queued += -1
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' uploader: _process(u'directory/')
Magic Folder 'client-0' uploader: pending = set([u'directory/']), about to remove u'directory/'
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
Magic Folder 'client-0' downloader: found u'short'
Magic Folder 'client-0' downloader: u'short' has local version 1, remote version 1
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' uploader: created subdirectory u'directory/'
Magic Folder 'client-0' uploader: directories_created += 1
Magic Folder 'client-0' uploader: scan u'directory/'
Magic Folder 'client-0' uploader: objects_succeeded += 1
Magic Folder 'client-0' uploader: call_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
finish
Magic Folder 'client-0' uploader: stop
Magic Folder 'client-0' uploader: dirs_monitored += -1
Magic Folder 'client-0' downloader: found u'short'
Magic Folder 'client-0' downloader: u'short' has local version 1, remote version 1
Magic Folder 'client-0' downloader: found u'directory//'
Magic Folder 'client-0' downloader: u'directory//' has local version None, remote version 0
Magic Folder 'client-0' downloader: u'directory//' added to download queue
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: _should_download(u'directory//', 0)
Magic Folder 'client-0' downloader: yep
Magic Folder 'client-0' downloader: v = None
Magic Folder 'client-0' downloader: result = [(u'directory//', <allmydata.immutable.literal.LiteralFileNode object at 0x06715F50>, {u'version': 0, u'tahoe': {u'linkmotime': 1446237341.441, u'linkcrtime': 1446237341.441}})]
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([(u'directory//', <allmydata.immutable.literal.LiteralFileNode object at 0x06715F50>, {u'version': 0, u'tahoe': {u'linkmotime': 1446237341.441, u'linkcrtime': 1446237341.441}})])
Magic Folder 'client-0' downloader: objects_queued += 1
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([u'directory//'])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: stopped
Traceback (most recent call last):
File "c:\users\peawe\git\magic-folder\src\allmydata\dirnode.py", line 445, in _get
raise NoSuchChildError(name)
allmydata.interfaces.NoSuchChildError: NoSuchChildError(u'directory@_',)
[ERROR]
test_magicfolder_start_service ... Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: set_hook 'started', ignore_count=0
<allmydata.frontends.magic_folder.MagicFolder object at 0x05EB11F0>.startService
Magic Folder 'client-0' uploader: start_monitoring
Magic Folder 'client-0' uploader: dirs_monitored += 1
Magic Folder 'client-0' uploader: call_hook 'started', ignore_count=0
Magic Folder 'client-0' uploader: start_scanning
Magic Folder 'client-0' uploader: all_files set([])
Magic Folder 'client-0' uploader: scan u''
Magic Folder 'client-0' uploader: adding set([])
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: start_scanning
Magic Folder 'client-0' downloader: all files set([])
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
finish
Magic Folder 'client-0' uploader: stop
Magic Folder 'client-0' uploader: dirs_monitored += -1
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: stopped
[OK]
test_move_tree ... Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: set_hook 'started', ignore_count=0
<allmydata.frontends.magic_folder.MagicFolder object at 0x056A17B0>.startService
Magic Folder 'client-0' uploader: start_monitoring
Magic Folder 'client-0' uploader: dirs_monitored += 1
Magic Folder 'client-0' uploader: call_hook 'started', ignore_count=0
Magic Folder 'client-0' uploader: start_scanning
Magic Folder 'client-0' uploader: all_files set([])
Magic Folder 'client-0' uploader: scan u''
Magic Folder 'client-0' uploader: adding set([])
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: start_scanning
Magic Folder 'client-0' downloader: all files set([])
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
_check_move_empty_tree
Magic Folder 'client-0' downloader: set_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: inotify event None, FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_move_tree\\v2xign\\temp\\l\xf8cal_dir\\empty_tr\xeae'), 'moved_to'
Magic Folder 'client-0' uploader: _get_relpath(FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_move_tree\\v2xign\\temp\\l\xf8cal_dir\\empty_tr\xeae'))
Magic Folder 'client-0' uploader: segments = [u'empty_tr\xeae']
Magic Folder 'client-0' uploader: _append_to_deque(u'empty_tr\xeae')
Magic Folder 'client-0' uploader: objects_queued += 1
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: popped u'empty_tr\xeae'
Magic Folder 'client-0' uploader: objects_queued += -1
Magic Folder 'client-0' uploader: _process(u'empty_tr\xeae')
Magic Folder 'client-0' uploader: pending = set([u'empty_tr\xeae']), about to remove u'empty_tr\xeae'
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' uploader: created subdirectory u'empty_tr\xeae'
Magic Folder 'client-0' uploader: directories_created += 1
Magic Folder 'client-0' uploader: scan u'empty_tr\xeae'
Magic Folder 'client-0' uploader: objects_succeeded += 1
Magic Folder 'client-0' uploader: call_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice'
Magic Folder 'client-0' downloader: found u'empty_tr\xeae/'
Magic Folder 'client-0' downloader: u'empty_tr\xeae/' has local version None, remote version 0
Magic Folder 'client-0' downloader: u'empty_tr\xeae/' added to download queue
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: _should_download(u'empty_tr\xeae/', 0)
Magic Folder 'client-0' downloader: yep
Magic Folder 'client-0' downloader: v = None
Magic Folder 'client-0' downloader: result = [(u'empty_tr\xeae/', <allmydata.immutable.literal.LiteralFileNode object at 0x0507AE70>, {u'version': 0, u'tahoe': {u'linkmotime': 1446237343.865, u'linkcrtime': 1446237343.865}})]
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([(u'empty_tr\xeae/', <allmydata.immutable.literal.LiteralFileNode object at 0x0507AE70>, {u'version': 0, u'tahoe': {u'linkmotime': 1446237343.865, u'linkcrtime': 1446237343.865}})])
Magic Folder 'client-0' downloader: objects_queued += 1
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([u'empty_tr\xeae/'])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: popped (u'empty_tr\xeae/', <allmydata.immutable.literal.LiteralFileNode object at 0x0507AE70>, {u'version': 0, u'tahoe': {u'linkmotime': 1446237343.865, u'linkcrtime': 1446237343.865}})
Magic Folder 'client-0' downloader: objects_queued += -1
Magic Folder 'client-0' downloader: _process((u'empty_tr\xeae/', <allmydata.immutable.literal.LiteralFileNode object at 0x0507AE70>, {u'version': 0, u'tahoe': {u'linkmotime': 1446237343.865, u'linkcrtime': 1446237343.865}}))
Magic Folder 'client-0' downloader: mkdir(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_move_tree\\v2xign\\temp\\l\xf8cal_dir\\empty_tr\xeae')
<allmydata.magicfolderdb.MagicFolderDB object at 0x06ED5FF0>.did_upload_version(u'empty_tr\xeae/', 0, None, 'URI:LIT:', 1446237343.967, PathInfo(isdir=True, isfile=False, islink=False, exists=True, size=0L, mtime=1446237343.8179722, ctime=1446237343.8179722))
insert
committed
Magic Folder 'client-0' downloader: objects_downloaded += 1
Magic Folder 'client-0' downloader: call_hook 'processed', ignore_count=0
_check_move_small_tree
Magic Folder 'client-0' downloader: set_hook 'processed', ignore_count=1
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=1
Magic Folder 'client-0' uploader: inotify event None, FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_move_tree\\v2xign\\temp\\l\xf8cal_dir\\small_tr\xeae'), 'moved_to'
Magic Folder 'client-0' uploader: _get_relpath(FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_move_tree\\v2xign\\temp\\l\xf8cal_dir\\small_tr\xeae'))
Magic Folder 'client-0' uploader: segments = [u'small_tr\xeae']
Magic Folder 'client-0' uploader: _append_to_deque(u'small_tr\xeae')
Magic Folder 'client-0' uploader: objects_queued += 1
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: popped u'small_tr\xeae'
Magic Folder 'client-0' uploader: objects_queued += -1
Magic Folder 'client-0' uploader: _process(u'small_tr\xeae')
Magic Folder 'client-0' uploader: pending = set([u'small_tr\xeae']), about to remove u'small_tr\xeae'
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice'
Magic Folder 'client-0' uploader: created subdirectory u'small_tr\xeae'
Magic Folder 'client-0' uploader: directories_created += 1
Magic Folder 'client-0' uploader: scan u'small_tr\xeae'
Magic Folder 'client-0' uploader: _process(u'small_tr\xeae/what')
Magic Folder 'client-0' uploader: pending = set([u'small_tr\xeae/what']), about to remove u'small_tr\xeae/what'
Magic Folder 'client-0' downloader: found u'empty_tr\xeae/'
Magic Folder 'client-0' downloader: u'empty_tr\xeae/' has local version 0, remote version 0
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice'
<allmydata.magicfolderdb.MagicFolderDB object at 0x06ED5FF0>.did_upload_version(u'small_tr\xeae/what', 0, 'URI:LIT:onqxsidxnbsw4', None, 1446237344.151, PathInfo(isdir=False, isfile=True, islink=False, exists=True, size=8L, mtime=1446237344.0104716, ctime=1446237344.007971))
insert
committed
Magic Folder 'client-0' uploader: files_uploaded += 1
Magic Folder 'client-0' uploader: objects_succeeded += 1
Magic Folder 'client-0' uploader: call_hook 'processed', ignore_count=1
Magic Folder 'client-0' uploader: objects_succeeded += 1
Magic Folder 'client-0' uploader: call_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: found u'empty_tr\xeae/'
Magic Folder 'client-0' downloader: u'empty_tr\xeae/' has local version 0, remote version 0
Magic Folder 'client-0' downloader: found u'small_tr\xeae/what'
Magic Folder 'client-0' downloader: u'small_tr\xeae/what' has local version 0, remote version 0
Magic Folder 'client-0' downloader: found u'small_tr\xeae/'
Magic Folder 'client-0' downloader: u'small_tr\xeae/' has local version None, remote version 0
Magic Folder 'client-0' downloader: u'small_tr\xeae/' added to download queue
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: _should_download(u'small_tr\xeae/', 0)
Magic Folder 'client-0' downloader: yep
Magic Folder 'client-0' downloader: v = None
Magic Folder 'client-0' downloader: result = [(u'small_tr\xeae/', <allmydata.immutable.literal.LiteralFileNode object at 0x06ED5950>, {u'version': 0, u'tahoe': {u'linkmotime': 1446237344.065, u'linkcrtime': 1446237344.065}})]
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([(u'small_tr\xeae/', <allmydata.immutable.literal.LiteralFileNode object at 0x06ED5950>, {u'version': 0, u'tahoe': {u'linkmotime': 1446237344.065, u'linkcrtime': 1446237344.065}})])
Magic Folder 'client-0' downloader: objects_queued += 1
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([u'small_tr\xeae/'])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: popped (u'small_tr\xeae/', <allmydata.immutable.literal.LiteralFileNode object at 0x06ED5950>, {u'version': 0, u'tahoe': {u'linkmotime': 1446237344.065, u'linkcrtime': 1446237344.065}})
Magic Folder 'client-0' downloader: objects_queued += -1
Magic Folder 'client-0' downloader: _process((u'small_tr\xeae/', <allmydata.immutable.literal.LiteralFileNode object at 0x06ED5950>, {u'version': 0, u'tahoe': {u'linkmotime': 1446237344.065, u'linkcrtime': 1446237344.065}}))
Magic Folder 'client-0' downloader: mkdir(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_move_tree\\v2xign\\temp\\l\xf8cal_dir\\small_tr\xeae')
<allmydata.magicfolderdb.MagicFolderDB object at 0x06ED5FF0>.did_upload_version(u'small_tr\xeae/', 0, None, 'URI:LIT:', 1446237344.316, PathInfo(isdir=True, isfile=False, islink=False, exists=True, size=0L, mtime=1446237344.0084715, ctime=1446237344.007971))
insert
err... update
committed
Magic Folder 'client-0' downloader: objects_downloaded += 1
Magic Folder 'client-0' downloader: call_hook 'processed', ignore_count=1
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice'
Magic Folder 'client-0' downloader: found u'empty_tr\xeae/'
Magic Folder 'client-0' downloader: u'empty_tr\xeae/' has local version 0, remote version 0
Magic Folder 'client-0' downloader: found u'small_tr\xeae/what'
Magic Folder 'client-0' downloader: u'small_tr\xeae/what' has local version 0, remote version 0
Magic Folder 'client-0' downloader: found u'small_tr\xeae/'
Magic Folder 'client-0' downloader: u'small_tr\xeae/' has local version None, remote version 0
Magic Folder 'client-0' downloader: u'small_tr\xeae/' added to download queue
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: _should_download(u'small_tr\xeae/', 0)
Magic Folder 'client-0' downloader: yep
Magic Folder 'client-0' downloader: v = None
Magic Folder 'client-0' downloader: result = [(u'small_tr\xeae/', <allmydata.immutable.literal.LiteralFileNode object at 0x0507A0D0>, {u'version': 0, u'tahoe': {u'linkmotime': 1446237344.065, u'linkcrtime': 1446237344.065}})]
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([(u'small_tr\xeae/', <allmydata.immutable.literal.LiteralFileNode object at 0x0507A0D0>, {u'version': 0, u'tahoe': {u'linkmotime': 1446237344.065, u'linkcrtime': 1446237344.065}})])
Magic Folder 'client-0' downloader: objects_queued += 1
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([u'small_tr\xeae/'])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: popped (u'small_tr\xeae/', <allmydata.immutable.literal.LiteralFileNode object at 0x0507A0D0>, {u'version': 0, u'tahoe': {u'linkmotime': 1446237344.065, u'linkcrtime': 1446237344.065}})
Magic Folder 'client-0' downloader: objects_queued += -1
Magic Folder 'client-0' downloader: _process((u'small_tr\xeae/', <allmydata.immutable.literal.LiteralFileNode object at 0x0507A0D0>, {u'version': 0, u'tahoe': {u'linkmotime': 1446237344.065, u'linkcrtime': 1446237344.065}}))
Magic Folder 'client-0' downloader: mkdir(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_move_tree\\v2xign\\temp\\l\xf8cal_dir\\small_tr\xeae')
<allmydata.magicfolderdb.MagicFolderDB object at 0x06ED5FF0>.did_upload_version(u'small_tr\xeae/', 0, None, 'URI:LIT:', 1446237344.36, PathInfo(isdir=True, isfile=False, islink=False, exists=True, size=0L, mtime=1446237344.0084715, ctime=1446237344.007971))
insert
err... update
committed
Magic Folder 'client-0' downloader: objects_downloaded += 1
Magic Folder 'client-0' downloader: call_hook 'processed', ignore_count=0
_check_moved_tree_is_watched
Magic Folder 'client-0' downloader: set_hook 'processed', ignore_count=1
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: inotify event None, FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_move_tree\\v2xign\\temp\\l\xf8cal_dir\\small_tr\xeae\\another'), 'close_write'
Magic Folder 'client-0' uploader: _get_relpath(FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_move_tree\\v2xign\\temp\\l\xf8cal_dir\\small_tr\xeae\\another'))
Magic Folder 'client-0' uploader: segments = [u'small_tr\xeae', u'another']
Magic Folder 'client-0' uploader: _append_to_deque(u'small_tr\xeae/another')
Magic Folder 'client-0' uploader: objects_queued += 1
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: popped u'small_tr\xeae/another'
Magic Folder 'client-0' uploader: objects_queued += -1
Magic Folder 'client-0' uploader: _process(u'small_tr\xeae/another')
Magic Folder 'client-0' uploader: pending = set([u'small_tr\xeae/another']), about to remove u'small_tr\xeae/another'
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice'
<allmydata.magicfolderdb.MagicFolderDB object at 0x06ED5FF0>.did_upload_version(u'small_tr\xeae/another', 0, 'URI:LIT:mzuwyzi', None, 1446237344.371, PathInfo(isdir=False, isfile=True, islink=False, exists=True, size=4L, mtime=1446237344.3689694, ctime=1446237344.3689694))
insert
committed
Magic Folder 'client-0' uploader: files_uploaded += 1
Magic Folder 'client-0' uploader: objects_succeeded += 1
Magic Folder 'client-0' uploader: call_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: found u'empty_tr\xeae/'
Magic Folder 'client-0' downloader: u'empty_tr\xeae/' has local version 0, remote version 0
Magic Folder 'client-0' downloader: found u'small_tr\xeae/what'
Magic Folder 'client-0' downloader: u'small_tr\xeae/what' has local version 0, remote version 0
Magic Folder 'client-0' downloader: found u'small_tr\xeae/'
Magic Folder 'client-0' downloader: u'small_tr\xeae/' has local version None, remote version 0
Magic Folder 'client-0' downloader: u'small_tr\xeae/' added to download queue
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: _should_download(u'small_tr\xeae/', 0)
Magic Folder 'client-0' downloader: yep
Magic Folder 'client-0' downloader: v = None
Magic Folder 'client-0' downloader: result = [(u'small_tr\xeae/', <allmydata.immutable.literal.LiteralFileNode object at 0x0577FB50>, {u'version': 0, u'tahoe': {u'linkmotime': 1446237344.065, u'linkcrtime': 1446237344.065}})]
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([(u'small_tr\xeae/', <allmydata.immutable.literal.LiteralFileNode object at 0x0577FB50>, {u'version': 0, u'tahoe': {u'linkmotime': 1446237344.065, u'linkcrtime': 1446237344.065}})])
Magic Folder 'client-0' downloader: objects_queued += 1
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([u'small_tr\xeae/'])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: popped (u'small_tr\xeae/', <allmydata.immutable.literal.LiteralFileNode object at 0x0577FB50>, {u'version': 0, u'tahoe': {u'linkmotime': 1446237344.065, u'linkcrtime': 1446237344.065}})
Magic Folder 'client-0' downloader: objects_queued += -1
Magic Folder 'client-0' downloader: _process((u'small_tr\xeae/', <allmydata.immutable.literal.LiteralFileNode object at 0x0577FB50>, {u'version': 0, u'tahoe': {u'linkmotime': 1446237344.065, u'linkcrtime': 1446237344.065}}))
Magic Folder 'client-0' downloader: mkdir(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_move_tree\\v2xign\\temp\\l\xf8cal_dir\\small_tr\xeae')
<allmydata.magicfolderdb.MagicFolderDB object at 0x06ED5FF0>.did_upload_version(u'small_tr\xeae/', 0, None, 'URI:LIT:', 1446237344.535, PathInfo(isdir=True, isfile=False, islink=False, exists=True, size=0L, mtime=1446237344.3689694, ctime=1446237344.007971))
insert
err... update
committed
Magic Folder 'client-0' downloader: objects_downloaded += 1
Magic Folder 'client-0' downloader: call_hook 'processed', ignore_count=1
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice'
Magic Folder 'client-0' downloader: found u'empty_tr\xeae/'
Magic Folder 'client-0' downloader: u'empty_tr\xeae/' has local version 0, remote version 0
Magic Folder 'client-0' downloader: found u'small_tr\xeae/another'
Magic Folder 'client-0' downloader: u'small_tr\xeae/another' has local version 0, remote version 0
Magic Folder 'client-0' downloader: found u'small_tr\xeae/what'
Magic Folder 'client-0' downloader: u'small_tr\xeae/what' has local version 0, remote version 0
Magic Folder 'client-0' downloader: found u'small_tr\xeae/'
Magic Folder 'client-0' downloader: u'small_tr\xeae/' has local version None, remote version 0
Magic Folder 'client-0' downloader: u'small_tr\xeae/' added to download queue
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: _should_download(u'small_tr\xeae/', 0)
Magic Folder 'client-0' downloader: yep
Magic Folder 'client-0' downloader: v = None
Magic Folder 'client-0' downloader: result = [(u'small_tr\xeae/', <allmydata.immutable.literal.LiteralFileNode object at 0x050DF5B0>, {u'version': 0, u'tahoe': {u'linkmotime': 1446237344.065, u'linkcrtime': 1446237344.065}})]
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([(u'small_tr\xeae/', <allmydata.immutable.literal.LiteralFileNode object at 0x050DF5B0>, {u'version': 0, u'tahoe': {u'linkmotime': 1446237344.065, u'linkcrtime': 1446237344.065}})])
Magic Folder 'client-0' downloader: objects_queued += 1
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([u'small_tr\xeae/'])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: popped (u'small_tr\xeae/', <allmydata.immutable.literal.LiteralFileNode object at 0x050DF5B0>, {u'version': 0, u'tahoe': {u'linkmotime': 1446237344.065, u'linkcrtime': 1446237344.065}})
Magic Folder 'client-0' downloader: objects_queued += -1
Magic Folder 'client-0' downloader: _process((u'small_tr\xeae/', <allmydata.immutable.literal.LiteralFileNode object at 0x050DF5B0>, {u'version': 0, u'tahoe': {u'linkmotime': 1446237344.065, u'linkcrtime': 1446237344.065}}))
Magic Folder 'client-0' downloader: mkdir(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_move_tree\\v2xign\\temp\\l\xf8cal_dir\\small_tr\xeae')
<allmydata.magicfolderdb.MagicFolderDB object at 0x06ED5FF0>.did_upload_version(u'small_tr\xeae/', 0, None, 'URI:LIT:', 1446237344.581, PathInfo(isdir=True, isfile=False, islink=False, exists=True, size=0L, mtime=1446237344.3689694, ctime=1446237344.007971))
insert
err... update
committed
Magic Folder 'client-0' downloader: objects_downloaded += 1
Magic Folder 'client-0' downloader: call_hook 'processed', ignore_count=0
finish
Magic Folder 'client-0' uploader: stop
Magic Folder 'client-0' uploader: dirs_monitored += -1
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: stopped
[OK]
test_persistence ... Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: set_hook 'started', ignore_count=0
<allmydata.frontends.magic_folder.MagicFolder object at 0x0699F250>.startService
Magic Folder 'client-0' uploader: start_monitoring
Magic Folder 'client-0' uploader: dirs_monitored += 1
Magic Folder 'client-0' uploader: call_hook 'started', ignore_count=0
Magic Folder 'client-0' uploader: start_scanning
Magic Folder 'client-0' uploader: all_files set([])
Magic Folder 'client-0' uploader: scan u''
Magic Folder 'client-0' uploader: adding set([])
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: start_scanning
Magic Folder 'client-0' downloader: all files set([])
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: inotify event None, FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_persistence\\gjyrcm\\temp\\test_persistence\\what1'), 'close_write'
Magic Folder 'client-0' uploader: _get_relpath(FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_persistence\\gjyrcm\\temp\\test_persistence\\what1'))
Magic Folder 'client-0' uploader: segments = [u'what1']
Magic Folder 'client-0' uploader: _append_to_deque(u'what1')
Magic Folder 'client-0' uploader: objects_queued += 1
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: popped u'what1'
Magic Folder 'client-0' uploader: objects_queued += -1
Magic Folder 'client-0' uploader: _process(u'what1')
Magic Folder 'client-0' uploader: pending = set([u'what1']), about to remove u'what1'
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
<allmydata.magicfolderdb.MagicFolderDB object at 0x0699F1B0>.did_upload_version(u'what1', 0, 'URI:LIT:nvsw65zao5ugc5br', None, 1446237345.656, PathInfo(isdir=False, isfile=True, islink=False, exists=True, size=10L, mtime=1446237345.6496785, ctime=1446237345.6471784))
insert
committed
Magic Folder 'client-0' uploader: files_uploaded += 1
Magic Folder 'client-0' uploader: objects_succeeded += 1
Magic Folder 'client-0' uploader: call_hook 'processed', ignore_count=0
finish
Magic Folder 'client-0' uploader: stop
Magic Folder 'client-0' uploader: dirs_monitored += -1
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice'
Magic Folder 'client-0' downloader: found u'what1'
Magic Folder 'client-0' downloader: u'what1' has local version 0, remote version 0
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: stopped
Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: set_hook 'started', ignore_count=0
<allmydata.frontends.magic_folder.MagicFolder object at 0x057F9390>.startService
Magic Folder 'client-0' uploader: start_monitoring
Magic Folder 'client-0' uploader: dirs_monitored += 1
Magic Folder 'client-0' uploader: call_hook 'started', ignore_count=0
Magic Folder 'client-0' uploader: start_scanning
Magic Folder 'client-0' uploader: all_files set([u'what1'])
Magic Folder 'client-0' uploader: scan u''
Magic Folder 'client-0' uploader: _process(u'what1')
Magic Folder 'client-0' uploader: pending = set([u'what1']), about to remove u'what1'
Magic Folder 'client-0' uploader: Not uploading u'what1'
Magic Folder 'client-0' uploader: objects_not_uploaded += 1
Magic Folder 'client-0' uploader: objects_succeeded += 1
Magic Folder 'client-0' uploader: adding set([])
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: start_scanning
Magic Folder 'client-0' downloader: all files set([u'what1'])
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice'
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice'
Magic Folder 'client-0' downloader: found u'what1'
Magic Folder 'client-0' downloader: u'what1' has local version 0, remote version 0
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: inotify event None, FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_persistence\\gjyrcm\\temp\\test_persistence\\what2'), 'close_write'
Magic Folder 'client-0' uploader: _get_relpath(FilePath(u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\allmydata.test.test_magic_folder\\MockTest\\test_persistence\\gjyrcm\\temp\\test_persistence\\what2'))
Magic Folder 'client-0' uploader: segments = [u'what2']
Magic Folder 'client-0' uploader: _append_to_deque(u'what2')
Magic Folder 'client-0' uploader: objects_queued += 1
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: popped u'what2'
Magic Folder 'client-0' uploader: objects_queued += -1
Magic Folder 'client-0' uploader: _process(u'what2')
Magic Folder 'client-0' uploader: pending = set([u'what2']), about to remove u'what2'
Magic Folder 'client-0' downloader: found u'what1'
Magic Folder 'client-0' downloader: u'what1' has local version 0, remote version 0
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
<allmydata.magicfolderdb.MagicFolderDB object at 0x057F9EB0>.did_upload_version(u'what2', 0, 'URI:LIT:nvsw65zao5ugc5bs', None, 1446237345.923, PathInfo(isdir=False, isfile=True, islink=False, exists=True, size=10L, mtime=1446237345.9155781, ctime=1446237345.9135778))
insert
committed
Magic Folder 'client-0' uploader: files_uploaded += 1
Magic Folder 'client-0' uploader: objects_succeeded += 1
Magic Folder 'client-0' uploader: call_hook 'processed', ignore_count=0
finish
Magic Folder 'client-0' uploader: stop
Magic Folder 'client-0' uploader: dirs_monitored += -1
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice'
Magic Folder 'client-0' downloader: found u'what2'
Magic Folder 'client-0' downloader: u'what2' has local version 0, remote version 0
Magic Folder 'client-0' downloader: found u'what1'
Magic Folder 'client-0' downloader: u'what1' has local version 0, remote version 0
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: stopped
[OK]
test_write_downloaded_file ... 0x00 ------------ <><> is conflict; calling _rename_conflicted_file... u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\cli\\MagicFolder\\write-downloaded-file\\foobar' u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\cli\\MagicFolder\\write-downloaded-file\\foobar.tmp'
XXX rename u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\cli\\MagicFolder\\write-downloaded-file\\foobar.tmp' u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\cli\\MagicFolder\\write-downloaded-file\\foobar.conflict'
u'\\\\?\\C:\\Users\\peawe\\git\\magic-folder\\_trial_temp\\cli\\MagicFolder\\write-downloaded-file\\foobar.tmp' exists
[OK]
RealTest
test_alice_bob ... Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: set_hook 'started', ignore_count=0
<allmydata.frontends.magic_folder.MagicFolder object at 0x0698E590>.startService
Magic Folder 'client-0' uploader: start_monitoring
Magic Folder 'client-0' uploader: start_scanning
Magic Folder 'client-0' uploader: all_files set([])
Magic Folder 'client-0' uploader: scan u''
Magic Folder 'client-0' uploader: adding set([])
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: start_scanning
Magic Folder 'client-0' downloader: all files set([])
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' uploader: dirs_monitored += 1
Magic Folder 'client-0' uploader: call_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-1' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-1' downloader: set_hook 'started', ignore_count=0
<allmydata.frontends.magic_folder.MagicFolder object at 0x04B18230>.startService
Magic Folder 'client-1' uploader: start_monitoring
Magic Folder 'client-1' uploader: start_scanning
Magic Folder 'client-1' uploader: all_files set([])
Magic Folder 'client-1' uploader: scan u''
Magic Folder 'client-1' uploader: adding set([])
Magic Folder 'client-1' uploader: _turn_deque
Magic Folder 'client-1' uploader: deque is now empty
Magic Folder 'client-1' downloader: start_scanning
Magic Folder 'client-1' downloader: all files set([])
Magic Folder 'client-1' downloader: _scan_remote_collective
Magic Folder 'client-1' downloader: _turn_deque
Magic Folder 'client-1' downloader: deque is now empty
Magic Folder 'client-1' downloader: set_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
Alice writes a file
flushing u'C:'
cleanup alice bob test
finish
Magic Folder 'client-0' uploader: stop
Magic Folder 'client-0' uploader: dirs_monitored += -1
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-1' uploader: dirs_monitored += 1
Magic Folder 'client-1' uploader: call_hook 'started', ignore_count=0
Magic Folder 'client-1' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _filter_scan_batch
Magic Folder 'client-1' downloader: result = []
Magic Folder 'client-1' downloader: deque = deque([])
Magic Folder 'client-1' downloader: deque after = deque([])
Magic Folder 'client-1' downloader: objects_queued += 0
Magic Folder 'client-1' downloader: pending = set([])
Magic Folder 'client-1' downloader: pending after = set([])
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: stopped
finish
Magic Folder 'client-1' uploader: stop
Magic Folder 'client-1' uploader: dirs_monitored += -1
Magic Folder 'client-1' downloader: _scan_remote_collective
Magic Folder 'client-1' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _filter_scan_batch
Magic Folder 'client-1' downloader: result = []
Magic Folder 'client-1' downloader: deque = deque([])
Magic Folder 'client-1' downloader: deque after = deque([])
Magic Folder 'client-1' downloader: objects_queued += 0
Magic Folder 'client-1' downloader: pending = set([])
Magic Folder 'client-1' downloader: pending after = set([])
Magic Folder 'client-1' downloader: after _scan_remote_collective: None
Magic Folder 'client-1' downloader: _turn_deque
Magic Folder 'client-1' downloader: stopped
Traceback (most recent call last):
File "c:\users\peawe\git\magic-folder\src\allmydata\test\test_magic_folder.py", line 693, in _wait_for
something_to_do()
File "c:\users\peawe\git\magic-folder\src\allmydata\test\test_magic_folder.py", line 708, in Alice_to_write_a_file
self.notify(to_filepath(self.file_path), self.inotify.IN_CLOSE_WRITE, magic=self.alice_magicfolder)
File "c:\users\peawe\git\magic-folder\src\allmydata\test\test_magic_folder.py", line 966, in notify
fileutil.flush_volume(path.path)
File "c:\users\peawe\git\magic-folder\src\allmydata\util\fileutil.py", line 564, in flush_volume
raise WinError(get_last_error())
exceptions.WindowsError: [Error 5] Access is denied.
[ERROR]
Traceback (most recent call last):
Failure: twisted.trial.util.DirtyReactorAggregateError: Reactor was unclean.
DelayedCalls: (set twisted.internet.base.DelayedCall.debug = True to debug)
<DelayedCall 0x628c4b8 [0.0100002288818s] called=0 cancelled=0 _do_callbacks()>
[ERROR]
test_alice_create_bob_update ... Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: set_hook 'started', ignore_count=0
<allmydata.frontends.magic_folder.MagicFolder object at 0x05EA7030>.startService
Magic Folder 'client-0' uploader: start_monitoring
Magic Folder 'client-0' uploader: start_scanning
Magic Folder 'client-0' uploader: all_files set([])
Magic Folder 'client-0' uploader: scan u''
Magic Folder 'client-0' uploader: adding set([])
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: start_scanning
Magic Folder 'client-0' downloader: all files set([])
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' uploader: dirs_monitored += 1
Magic Folder 'client-0' uploader: call_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-1' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-1' downloader: set_hook 'started', ignore_count=0
<allmydata.frontends.magic_folder.MagicFolder object at 0x04808B10>.startService
Magic Folder 'client-1' uploader: start_monitoring
Magic Folder 'client-1' uploader: start_scanning
Magic Folder 'client-1' uploader: all_files set([])
Magic Folder 'client-1' uploader: scan u''
Magic Folder 'client-1' uploader: adding set([])
Magic Folder 'client-1' uploader: _turn_deque
Magic Folder 'client-1' uploader: deque is now empty
Magic Folder 'client-1' downloader: start_scanning
Magic Folder 'client-1' downloader: all files set([])
Magic Folder 'client-1' downloader: _scan_remote_collective
Magic Folder 'client-1' downloader: _turn_deque
Magic Folder 'client-1' downloader: deque is now empty
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
Magic Folder 'client-1' downloader: set_hook 'processed', ignore_count=0
flushing u'C:'
finish
Magic Folder 'client-0' uploader: stop
Magic Folder 'client-0' uploader: dirs_monitored += -1
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-1' uploader: dirs_monitored += 1
Magic Folder 'client-1' uploader: call_hook 'started', ignore_count=0
Magic Folder 'client-1' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _filter_scan_batch
Magic Folder 'client-1' downloader: result = []
Magic Folder 'client-1' downloader: deque = deque([])
Magic Folder 'client-1' downloader: deque after = deque([])
Magic Folder 'client-1' downloader: objects_queued += 0
Magic Folder 'client-1' downloader: pending = set([])
Magic Folder 'client-1' downloader: pending after = set([])
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: stopped
finish
Magic Folder 'client-1' uploader: stop
Magic Folder 'client-1' uploader: dirs_monitored += -1
Magic Folder 'client-1' downloader: _scan_remote_collective
Magic Folder 'client-1' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _filter_scan_batch
Magic Folder 'client-1' downloader: result = []
Magic Folder 'client-1' downloader: deque = deque([])
Magic Folder 'client-1' downloader: deque after = deque([])
Magic Folder 'client-1' downloader: objects_queued += 0
Magic Folder 'client-1' downloader: pending = set([])
Magic Folder 'client-1' downloader: pending after = set([])
Magic Folder 'client-1' downloader: after _scan_remote_collective: None
Magic Folder 'client-1' downloader: _turn_deque
Magic Folder 'client-1' downloader: stopped
Traceback (most recent call last):
File "C:\Users\peawe\git\magic-folder\support\Lib\site-packages\twisted-15.4.0-py2.7-win32.egg\twisted\internet\defer.py", line 1128, in _inlineCallbacks
result = g.send(result)
File "c:\users\peawe\git\magic-folder\src\allmydata\test\test_magic_folder.py", line 431, in test_alice_create_bob_update
self.notify(to_filepath(alice_fname), self.inotify.IN_CLOSE_WRITE, magic=self.alice_magicfolder)
File "c:\users\peawe\git\magic-folder\src\allmydata\test\test_magic_folder.py", line 966, in notify
fileutil.flush_volume(path.path)
File "c:\users\peawe\git\magic-folder\src\allmydata\util\fileutil.py", line 564, in flush_volume
raise WinError(get_last_error())
exceptions.WindowsError: [Error 5] Access is denied.
[ERROR]
Traceback (most recent call last):
File "C:\Users\peawe\git\magic-folder\support\Lib\site-packages\twisted-15.4.0-py2.7-win32.egg\twisted\internet\base.py", line 825, in runUntilCurrent
call.func(*call.args, **call.kw)
File "c:\users\peawe\git\magic-folder\src\allmydata\windows\inotify.py", line 275, in _do_callbacks
for cb in self._callbacks:
exceptions.TypeError: 'NoneType' object is not iterable
[ERROR]
test_alice_delete_and_restore ... Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: set_hook 'started', ignore_count=0
<allmydata.frontends.magic_folder.MagicFolder object at 0x061D8D90>.startService
Magic Folder 'client-0' uploader: start_monitoring
Magic Folder 'client-0' uploader: start_scanning
Magic Folder 'client-0' uploader: all_files set([])
Magic Folder 'client-0' uploader: scan u''
Magic Folder 'client-0' uploader: adding set([])
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: start_scanning
Magic Folder 'client-0' downloader: all files set([])
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' uploader: dirs_monitored += 1
Magic Folder 'client-0' uploader: call_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-1' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-1' downloader: set_hook 'started', ignore_count=0
<allmydata.frontends.magic_folder.MagicFolder object at 0x054CAF10>.startService
Magic Folder 'client-1' uploader: start_monitoring
Magic Folder 'client-1' uploader: start_scanning
Magic Folder 'client-1' uploader: all_files set([])
Magic Folder 'client-1' uploader: scan u''
Magic Folder 'client-1' uploader: adding set([])
Magic Folder 'client-1' uploader: _turn_deque
Magic Folder 'client-1' uploader: deque is now empty
Magic Folder 'client-1' downloader: start_scanning
Magic Folder 'client-1' downloader: all files set([])
Magic Folder 'client-1' downloader: _scan_remote_collective
Magic Folder 'client-1' downloader: _turn_deque
Magic Folder 'client-1' downloader: deque is now empty
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
Magic Folder 'client-1' downloader: set_hook 'processed', ignore_count=0
flushing u'C:'
finish
Magic Folder 'client-0' uploader: stop
Magic Folder 'client-0' uploader: dirs_monitored += -1
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-1' uploader: dirs_monitored += 1
Magic Folder 'client-1' uploader: call_hook 'started', ignore_count=0
Magic Folder 'client-1' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _filter_scan_batch
Magic Folder 'client-1' downloader: result = []
Magic Folder 'client-1' downloader: deque = deque([])
Magic Folder 'client-1' downloader: deque after = deque([])
Magic Folder 'client-1' downloader: objects_queued += 0
Magic Folder 'client-1' downloader: pending = set([])
Magic Folder 'client-1' downloader: pending after = set([])
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: stopped
finish
Magic Folder 'client-1' uploader: stop
Magic Folder 'client-1' uploader: dirs_monitored += -1
Magic Folder 'client-1' downloader: _scan_remote_collective
Magic Folder 'client-1' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _filter_scan_batch
Magic Folder 'client-1' downloader: result = []
Magic Folder 'client-1' downloader: deque = deque([])
Magic Folder 'client-1' downloader: deque after = deque([])
Magic Folder 'client-1' downloader: objects_queued += 0
Magic Folder 'client-1' downloader: pending = set([])
Magic Folder 'client-1' downloader: pending after = set([])
Magic Folder 'client-1' downloader: after _scan_remote_collective: None
Magic Folder 'client-1' downloader: _turn_deque
Magic Folder 'client-1' downloader: stopped
Traceback (most recent call last):
File "C:\Users\peawe\git\magic-folder\support\Lib\site-packages\twisted-15.4.0-py2.7-win32.egg\twisted\internet\defer.py", line 1128, in _inlineCallbacks
result = g.send(result)
File "c:\users\peawe\git\magic-folder\src\allmydata\test\test_magic_folder.py", line 496, in test_alice_delete_and_restore
self.notify(to_filepath(alice_fname), self.inotify.IN_CLOSE_WRITE, magic=self.alice_magicfolder)
File "c:\users\peawe\git\magic-folder\src\allmydata\test\test_magic_folder.py", line 966, in notify
fileutil.flush_volume(path.path)
File "c:\users\peawe\git\magic-folder\src\allmydata\util\fileutil.py", line 564, in flush_volume
raise WinError(get_last_error())
exceptions.WindowsError: [Error 5] Access is denied.
[ERROR]
Traceback (most recent call last):
Failure: twisted.trial.util.DirtyReactorAggregateError: Reactor was unclean.
DelayedCalls: (set twisted.internet.base.DelayedCall.debug = True to debug)
<DelayedCall 0x58e4d78 [0.00300002098083s] called=0 cancelled=0 _do_callbacks()>
[ERROR]
test_alice_delete_bob_restore ... Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: set_hook 'started', ignore_count=0
<allmydata.frontends.magic_folder.MagicFolder object at 0x04849530>.startService
Magic Folder 'client-0' uploader: start_monitoring
Magic Folder 'client-0' uploader: start_scanning
Magic Folder 'client-0' uploader: all_files set([])
Magic Folder 'client-0' uploader: scan u''
Magic Folder 'client-0' uploader: adding set([])
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: start_scanning
Magic Folder 'client-0' downloader: all files set([])
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' uploader: dirs_monitored += 1
Magic Folder 'client-0' uploader: call_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-1' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-1' downloader: set_hook 'started', ignore_count=0
<allmydata.frontends.magic_folder.MagicFolder object at 0x074797F0>.startService
Magic Folder 'client-1' uploader: start_monitoring
Magic Folder 'client-1' uploader: start_scanning
Magic Folder 'client-1' uploader: all_files set([])
Magic Folder 'client-1' uploader: scan u''
Magic Folder 'client-1' uploader: adding set([])
Magic Folder 'client-1' uploader: _turn_deque
Magic Folder 'client-1' uploader: deque is now empty
Magic Folder 'client-1' downloader: start_scanning
Magic Folder 'client-1' downloader: all files set([])
Magic Folder 'client-1' downloader: _scan_remote_collective
Magic Folder 'client-1' downloader: _turn_deque
Magic Folder 'client-1' downloader: deque is now empty
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
Magic Folder 'client-1' downloader: set_hook 'processed', ignore_count=0
flushing u'C:'
finish
Magic Folder 'client-0' uploader: stop
Magic Folder 'client-0' uploader: dirs_monitored += -1
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-1' uploader: dirs_monitored += 1
Magic Folder 'client-1' uploader: call_hook 'started', ignore_count=0
Magic Folder 'client-1' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _filter_scan_batch
Magic Folder 'client-1' downloader: result = []
Magic Folder 'client-1' downloader: deque = deque([])
Magic Folder 'client-1' downloader: deque after = deque([])
Magic Folder 'client-1' downloader: objects_queued += 0
Magic Folder 'client-1' downloader: pending = set([])
Magic Folder 'client-1' downloader: pending after = set([])
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: stopped
finish
Magic Folder 'client-1' uploader: stop
Magic Folder 'client-1' uploader: dirs_monitored += -1
Magic Folder 'client-1' downloader: _scan_remote_collective
Magic Folder 'client-1' downloader: _scan_remote nickname u'Alice\xf8'
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _scan_remote nickname u'Bob\xf8'
Magic Folder 'client-1' downloader: end of _scan_remote: None
Magic Folder 'client-1' downloader: _filter_scan_batch
Magic Folder 'client-1' downloader: result = []
Magic Folder 'client-1' downloader: deque = deque([])
Magic Folder 'client-1' downloader: deque after = deque([])
Magic Folder 'client-1' downloader: objects_queued += 0
Magic Folder 'client-1' downloader: pending = set([])
Magic Folder 'client-1' downloader: pending after = set([])
Magic Folder 'client-1' downloader: after _scan_remote_collective: None
Magic Folder 'client-1' downloader: _turn_deque
Magic Folder 'client-1' downloader: stopped
Traceback (most recent call last):
File "C:\Users\peawe\git\magic-folder\support\Lib\site-packages\twisted-15.4.0-py2.7-win32.egg\twisted\internet\defer.py", line 1128, in _inlineCallbacks
result = g.send(result)
File "c:\users\peawe\git\magic-folder\src\allmydata\test\test_magic_folder.py", line 343, in test_alice_delete_bob_restore
self.notify(to_filepath(alice_fname), self.inotify.IN_CLOSE_WRITE, magic=self.alice_magicfolder)
File "c:\users\peawe\git\magic-folder\src\allmydata\test\test_magic_folder.py", line 966, in notify
fileutil.flush_volume(path.path)
File "c:\users\peawe\git\magic-folder\src\allmydata\util\fileutil.py", line 564, in flush_volume
raise WinError(get_last_error())
exceptions.WindowsError: [Error 5] Access is denied.
[ERROR]
Traceback (most recent call last):
File "C:\Users\peawe\git\magic-folder\support\Lib\site-packages\twisted-15.4.0-py2.7-win32.egg\twisted\internet\base.py", line 825, in runUntilCurrent
call.func(*call.args, **call.kw)
File "c:\users\peawe\git\magic-folder\src\allmydata\windows\inotify.py", line 275, in _do_callbacks
for cb in self._callbacks:
exceptions.TypeError: 'NoneType' object is not iterable
[ERROR]
test_db_basic ... [OK]
test_db_persistence ... <allmydata.magicfolderdb.MagicFolderDB object at 0x049307D0>.did_upload_version(u'myFile1', 0, 'URI:LIT:1', 'URI:LIT:0', 0, PathInfo(isdir=False, isfile=True, islink=False, exists=True, size=1, mtime=123, ctime=456))
insert
committed
<allmydata.magicfolderdb.MagicFolderDB object at 0x049307D0>.did_upload_version(u'myFile2', 0, 'URI:LIT:2', 'URI:LIT:1', 0, PathInfo(isdir=False, isfile=True, islink=False, exists=True, size=5L, mtime=1446237353.2188232, ctime=1446237353.216825))
insert
committed
[OK]
test_delete ... Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: set_hook 'started', ignore_count=0
<allmydata.frontends.magic_folder.MagicFolder object at 0x07A5D3B0>.startService
Magic Folder 'client-0' uploader: start_monitoring
Magic Folder 'client-0' uploader: start_scanning
Magic Folder 'client-0' uploader: all_files set([])
Magic Folder 'client-0' uploader: scan u''
Magic Folder 'client-0' uploader: adding set([])
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: start_scanning
Magic Folder 'client-0' downloader: all files set([])
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' uploader: dirs_monitored += 1
Magic Folder 'client-0' uploader: call_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
flushing u'C:'
finish
Magic Folder 'client-0' uploader: stop
Magic Folder 'client-0' uploader: dirs_monitored += -1
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: stopped
Traceback (most recent call last):
File "C:\Users\peawe\git\magic-folder\support\Lib\site-packages\twisted-15.4.0-py2.7-win32.egg\twisted\internet\defer.py", line 1128, in _inlineCallbacks
result = g.send(result)
File "c:\users\peawe\git\magic-folder\src\allmydata\test\test_magic_folder.py", line 261, in test_delete
self.notify(to_filepath(path), self.inotify.IN_CLOSE_WRITE)
File "c:\users\peawe\git\magic-folder\src\allmydata\test\test_magic_folder.py", line 966, in notify
fileutil.flush_volume(path.path)
File "c:\users\peawe\git\magic-folder\src\allmydata\util\fileutil.py", line 564, in flush_volume
raise WinError(get_last_error())
exceptions.WindowsError: [Error 5] Access is denied.
[ERROR]
Traceback (most recent call last):
Failure: twisted.trial.util.DirtyReactorAggregateError: Reactor was unclean.
DelayedCalls: (set twisted.internet.base.DelayedCall.debug = True to debug)
<DelayedCall 0x45f2580 [0.848000049591s] called=0 cancelled=0 _do_callbacks()>
[ERROR]
test_delete_and_restore ... Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: set_hook 'started', ignore_count=0
<allmydata.frontends.magic_folder.MagicFolder object at 0x077D1170>.startService
Magic Folder 'client-0' uploader: start_monitoring
Magic Folder 'client-0' uploader: start_scanning
Magic Folder 'client-0' uploader: all_files set([])
Magic Folder 'client-0' uploader: scan u''
Magic Folder 'client-0' uploader: adding set([])
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: start_scanning
Magic Folder 'client-0' downloader: all files set([])
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' uploader: dirs_monitored += 1
Magic Folder 'client-0' uploader: call_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
flushing u'C:'
finish
Magic Folder 'client-0' uploader: stop
Magic Folder 'client-0' uploader: dirs_monitored += -1
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: stopped
Traceback (most recent call last):
File "C:\Users\peawe\git\magic-folder\support\Lib\site-packages\twisted-15.4.0-py2.7-win32.egg\twisted\internet\defer.py", line 1128, in _inlineCallbacks
result = g.send(result)
File "c:\users\peawe\git\magic-folder\src\allmydata\test\test_magic_folder.py", line 295, in test_delete_and_restore
self.notify(to_filepath(path), self.inotify.IN_CLOSE_WRITE)
File "c:\users\peawe\git\magic-folder\src\allmydata\test\test_magic_folder.py", line 966, in notify
fileutil.flush_volume(path.path)
File "c:\users\peawe\git\magic-folder\src\allmydata\util\fileutil.py", line 564, in flush_volume
raise WinError(get_last_error())
exceptions.WindowsError: [Error 5] Access is denied.
[ERROR]
Traceback (most recent call last):
Failure: twisted.trial.util.DirtyReactorAggregateError: Reactor was unclean.
DelayedCalls: (set twisted.internet.base.DelayedCall.debug = True to debug)
<DelayedCall 0x6717170 [0.861999988556s] called=0 cancelled=0 _do_callbacks()>
[ERROR]
test_magic_folder ... Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: set_hook 'started', ignore_count=0
<allmydata.frontends.magic_folder.MagicFolder object at 0x0749E810>.startService
Magic Folder 'client-0' uploader: start_monitoring
Magic Folder 'client-0' uploader: start_scanning
Magic Folder 'client-0' uploader: all_files set([])
Magic Folder 'client-0' uploader: scan u''
Magic Folder 'client-0' uploader: adding set([])
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: start_scanning
Magic Folder 'client-0' downloader: all files set([])
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' uploader: dirs_monitored += 1
Magic Folder 'client-0' uploader: call_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
flushing u'C:'
finish
Magic Folder 'client-0' uploader: stop
Magic Folder 'client-0' uploader: dirs_monitored += -1
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice\u0101'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: stopped
Traceback (most recent call last):
File "c:\users\peawe\git\magic-folder\src\allmydata\test\test_magic_folder.py", line 574, in <lambda>
d.addCallback(lambda ign: self._check_file(u"short", "test"))
File "c:\users\peawe\git\magic-folder\src\allmydata\test\test_magic_folder.py", line 627, in _check_file
self.notify(path, event_mask)
File "c:\users\peawe\git\magic-folder\src\allmydata\test\test_magic_folder.py", line 966, in notify
fileutil.flush_volume(path.path)
File "c:\users\peawe\git\magic-folder\src\allmydata\util\fileutil.py", line 564, in flush_volume
raise WinError(get_last_error())
exceptions.WindowsError: [Error 5] Access is denied.
[ERROR]
Traceback (most recent call last):
Failure: twisted.trial.util.DirtyReactorAggregateError: Reactor was unclean.
DelayedCalls: (set twisted.internet.base.DelayedCall.debug = True to debug)
<DelayedCall 0x58ef698 [0.851999998093s] called=0 cancelled=0 _do_callbacks()>
[ERROR]
test_magicfolder_start_service ... Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: set_hook 'started', ignore_count=0
<allmydata.frontends.magic_folder.MagicFolder object at 0x0699FF70>.startService
Magic Folder 'client-0' uploader: start_monitoring
Magic Folder 'client-0' uploader: start_scanning
Magic Folder 'client-0' uploader: all_files set([])
Magic Folder 'client-0' uploader: scan u''
Magic Folder 'client-0' uploader: adding set([])
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: start_scanning
Magic Folder 'client-0' downloader: all files set([])
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' uploader: dirs_monitored += 1
Magic Folder 'client-0' uploader: call_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
finish
Magic Folder 'client-0' uploader: stop
Magic Folder 'client-0' uploader: dirs_monitored += -1
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: stopped
[OK]
test_move_tree ... Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: set_hook 'started', ignore_count=0
<allmydata.frontends.magic_folder.MagicFolder object at 0x0747FEB0>.startService
Magic Folder 'client-0' uploader: start_monitoring
Magic Folder 'client-0' uploader: start_scanning
Magic Folder 'client-0' uploader: all_files set([])
Magic Folder 'client-0' uploader: scan u''
Magic Folder 'client-0' uploader: adding set([])
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: start_scanning
Magic Folder 'client-0' downloader: all files set([])
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' uploader: dirs_monitored += 1
Magic Folder 'client-0' uploader: call_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
_check_move_empty_tree
Magic Folder 'client-0' downloader: set_hook 'processed', ignore_count=0
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
flushing u'C:'
finish
Magic Folder 'client-0' uploader: stop
Magic Folder 'client-0' uploader: dirs_monitored += -1
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: stopped
Traceback (most recent call last):
File "c:\users\peawe\git\magic-folder\src\allmydata\test\test_magic_folder.py", line 139, in _check_move_empty_tree
self.notify(to_filepath(new_empty_tree_dir), self.inotify.IN_MOVED_TO)
File "c:\users\peawe\git\magic-folder\src\allmydata\test\test_magic_folder.py", line 966, in notify
fileutil.flush_volume(path.path)
File "c:\users\peawe\git\magic-folder\src\allmydata\util\fileutil.py", line 564, in flush_volume
raise WinError(get_last_error())
exceptions.WindowsError: [Error 5] Access is denied.
[ERROR]
Traceback (most recent call last):
Failure: twisted.trial.util.DirtyReactorAggregateError: Reactor was unclean.
DelayedCalls: (set twisted.internet.base.DelayedCall.debug = True to debug)
<DelayedCall 0x6f784b8 [0.854000091553s] called=0 cancelled=0 _do_callbacks()>
[ERROR]
test_persistence ... Magic Folder 'client-0' uploader: set_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: set_hook 'started', ignore_count=0
<allmydata.frontends.magic_folder.MagicFolder object at 0x056EF630>.startService
Magic Folder 'client-0' uploader: start_monitoring
Magic Folder 'client-0' uploader: start_scanning
Magic Folder 'client-0' uploader: all_files set([])
Magic Folder 'client-0' uploader: scan u''
Magic Folder 'client-0' uploader: adding set([])
Magic Folder 'client-0' uploader: _turn_deque
Magic Folder 'client-0' uploader: deque is now empty
Magic Folder 'client-0' downloader: start_scanning
Magic Folder 'client-0' downloader: all files set([])
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: deque is now empty
Magic Folder 'client-0' uploader: dirs_monitored += 1
Magic Folder 'client-0' uploader: call_hook 'started', ignore_count=0
Magic Folder 'client-0' downloader: _scan_remote_collective
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' uploader: set_hook 'processed', ignore_count=0
flushing u'C:'
finish
Magic Folder 'client-0' uploader: stop
Magic Folder 'client-0' uploader: dirs_monitored += -1
Magic Folder 'client-0' downloader: _scan_remote nickname u'Alice'
Magic Folder 'client-0' downloader: end of _scan_remote: None
Magic Folder 'client-0' downloader: _filter_scan_batch
Magic Folder 'client-0' downloader: result = []
Magic Folder 'client-0' downloader: deque = deque([])
Magic Folder 'client-0' downloader: deque after = deque([])
Magic Folder 'client-0' downloader: objects_queued += 0
Magic Folder 'client-0' downloader: pending = set([])
Magic Folder 'client-0' downloader: pending after = set([])
Magic Folder 'client-0' downloader: after _scan_remote_collective: None
Magic Folder 'client-0' downloader: _turn_deque
Magic Folder 'client-0' downloader: stopped
Traceback (most recent call last):
File "c:\users\peawe\git\magic-folder\src\allmydata\test\test_magic_folder.py", line 229, in <lambda>
d.addCallback(lambda ign: create_test_file(u"what1"))
File "c:\users\peawe\git\magic-folder\src\allmydata\test\test_magic_folder.py", line 227, in create_test_file
self.notify(to_filepath(test_file), self.inotify.IN_CLOSE_WRITE)
File "c:\users\peawe\git\magic-folder\src\allmydata\test\test_magic_folder.py", line 966, in notify
fileutil.flush_volume(path.path)
File "c:\users\peawe\git\magic-folder\src\allmydata\util\fileutil.py", line 564, in flush_volume
raise WinError(get_last_error())
exceptions.WindowsError: [Error 5] Access is denied.
[ERROR]
Traceback (most recent call last):
Failure: twisted.trial.util.DirtyReactorAggregateError: Reactor was unclean.
DelayedCalls: (set twisted.internet.base.DelayedCall.debug = True to debug)
<DelayedCall 0x56f8850 [0.695999860764s] called=0 cancelled=0 _do_callbacks()>
[ERROR]
allmydata.test.test_magicpath
MagicPath
test_magic2path ... [OK]
test_path2magic ... [OK]
test_should_ignore ... [OK]
allmydata.test.test_mutable
Checker
test_check_all_bad_blocks ... [OK]
test_check_all_bad_sig ... [OK]
test_check_good ... [OK]
test_check_mdmf_all_bad_blocks ... [OK]
test_check_mdmf_all_bad_sig ... [OK]
test_check_mdmf_good ... [OK]
test_check_mdmf_no_shares ... [OK]
test_check_mdmf_not_enough_shares ... [OK]
test_check_no_shares ... [OK]
test_check_not_enough_shares ... [OK]
test_verify_all_bad_sig ... [OK]
test_verify_good ... [OK]
test_verify_mdmf_all_bad_sharedata ... [OK]
test_verify_mdmf_bad_encprivkey ... [OK]
test_verify_mdmf_bad_encprivkey_uncheckable ... [OK]
test_verify_mdmf_bad_sig ... [OK]
test_verify_mdmf_empty ... [OK]
test_verify_mdmf_good ... [OK]
test_verify_mdmf_one_bad_block ... [OK]
test_verify_one_bad_block ... [OK]
test_verify_one_bad_encprivkey ... [OK]
test_verify_one_bad_encprivkey_uncheckable ... [OK]
test_verify_one_bad_sharehash ... [OK]
test_verify_one_bad_sig ... [OK]
test_verify_sdmf_empty ... [OK]
DataHandle
test_datahandle_get_size ... [OK]
test_datahandle_get_size_out_of_order ... [OK]
test_datahandle_read ... [OK]
DifferentEncoding
test_filenode ... [OK]
Exceptions
test_repr ... [OK]
FileHandle
test_close ... [OK]
test_filehandle_file ... [OK]
test_filehandle_get_size ... [OK]
test_filehandle_get_size_out_of_order ... [OK]
test_filehandle_read ... [OK]
Filenode
test_create ... [OK]
test_create_from_mdmf_readcap ... [OK]
test_create_from_mdmf_writecap ... [OK]
test_create_mdmf ... [OK]
test_create_mdmf_with_initial_contents ... [OK]
test_create_mdmf_with_initial_contents_function ... [OK]
test_create_with_initial_contents ... [OK]
test_create_with_initial_contents_function ... [OK]
test_create_with_too_large_contents ... [OK]
test_download_from_mdmf_cap ... [OK]
test_internal_version_from_cap ... [OK]
test_max_shares ... [OK]
test_max_shares_mdmf ... [OK]
test_mdmf_filenode_cap ... [OK]
test_mdmf_write_count ... [OK]
test_modify ... [OK]
test_modify_backoffer ... [OK]
test_retrieve_producer_mdmf ... [OK]
test_serialize ... [OK]
test_single_share ... [OK]
test_size_after_servermap_update ... [OK]
test_upload_and_download ... [OK]
test_upload_and_download_full_size_keys ... [OK]
test_upload_and_download_mdmf ... [OK]
Interoperability
test_new_downloader_can_read_old_shares ... [OK]
MultipleEncodings
test_multiple_encodings ... [OK]
MultipleVersions
test_multiple_versions ... [OK]
test_replace ... [OK]
Problems
test_1654 ... [OK]
test_bad_server ... [OK]
test_bad_server_overlap ... [OK]
test_block_and_hash_query_error ... [OK]
test_multiply_placed_shares ... [OK]
test_privkey_query_error ... [OK]
test_privkey_query_missing ... [OK]
test_publish_all_servers_bad ... [OK]
test_publish_no_servers ... [OK]
test_publish_surprise_mdmf ... [OK]
test_publish_surprise_sdmf ... [OK]
test_retrieve_surprise ... [OK]
test_unexpected_shares ... [OK]
Repair
test_check_and_repair_readcap ... [OK]
test_mdmf_repairable_5shares ... [OK]
test_mdmf_repairable_5shares_checkandrepair ... [OK]
test_mdmf_unrepairable_0shares ... [OK]
test_mdmf_unrepairable_0shares_checkandrepair ... [OK]
test_mdmf_unrepairable_1share ... [OK]
test_mdmf_unrepairable_1share_checkandrepair ... [OK]
test_merge ... [OK]
test_non_merge ... [OK]
test_repair_empty ... [OK]
test_repair_nop ... [OK]
test_repairable_5shares ... [OK]
test_repairable_5shares_checkandrepair ... [OK]
test_unrepairable_0shares ... [OK]
test_unrepairable_0shares_checkandrepair ... [OK]
test_unrepairable_1share ... [OK]
test_unrepairable_1share_checkandrepair ... [OK]
Roundtrip
test_all_but_two_shares_vanished_updated_servermap ... [OK]
test_all_shares_vanished ... [OK]
test_basic ... [OK]
test_basic_pubkey_at_end ... [OK]
test_corrupt_all_IV ... [OK]
test_corrupt_all_N ... [OK]
test_corrupt_all_R ... [OK]
test_corrupt_all_block ... [OK]
test_corrupt_all_block_hash_tree ... [OK]
test_corrupt_all_block_late ... [OK]
test_corrupt_all_datalen ... [OK]
test_corrupt_all_encprivkey ... [OK]
test_corrupt_all_encprivkey_late ... [OK]
test_corrupt_all_k ... [OK]
test_corrupt_all_pubkey ... [OK]
test_corrupt_all_segsize ... [OK]
test_corrupt_all_seqnum ... [OK]
test_corrupt_all_share_hash_chain_hash ... [OK]
test_corrupt_all_share_hash_chain_number ... [OK]
test_corrupt_all_sig ... [OK]
test_corrupt_all_verbyte ... [OK]
test_corrupt_mdmf_block_hash_tree ... [OK]
test_corrupt_mdmf_block_hash_tree_late ... [OK]
test_corrupt_mdmf_share_data ... [OK]
test_corrupt_some ... [OK]
test_corrupt_some_mdmf ... [OK]
test_download_fails ... [OK]
test_no_servers ... [OK]
test_no_servers_download ... [OK]
Servermap
test_basic ... [OK]
test_fetch_privkey ... [OK]
test_fetch_update ... [OK]
test_mark_bad ... [OK]
test_no_shares ... [OK]
test_not_quite_enough_shares ... [OK]
test_servermapupdater_finds_mdmf_files ... [OK]
test_servermapupdater_finds_sdmf_files ... [OK]
Update
test_append ... [OK]
test_append_power_of_two ... [OK]
test_multiple_segment_replace ... [OK]
test_replace_and_extend ... [OK]
test_replace_beginning ... [OK]
test_replace_in_last_segment ... [OK]
test_replace_locations ... [OK]
test_replace_locations_max_shares ... [OK]
test_replace_middle ... [OK]
test_replace_segstart1 ... [OK]
test_replace_zero_length_beginning ... [OK]
test_replace_zero_length_middle ... [OK]
test_replace_zero_length_segstart1 ... [OK]
test_update_sdmf ... [OK]
Version
test_cap_after_upload ... [OK]
test_debug ... [OK]
test_download_nonexistent_version ... [OK]
test_download_version ... [OK]
test_get_readonly_version ... [OK]
test_get_sequence_number ... [OK]
test_mutable_version ... [OK]
test_partial_read_mdmf_0 ... [OK]
test_partial_read_mdmf_large ... [OK]
test_partial_read_sdmf_0 ... [OK]
test_partial_read_sdmf_100 ... [OK]
test_partial_read_sdmf_2 ... [OK]
test_partial_read_sdmf_90 ... [OK]
test_read_and_download_mdmf ... [OK]
test_read_and_download_sdmf ... [OK]
test_read_and_download_sdmf_zero_length ... [OK]
test_toplevel_modify ... [OK]
test_toplevel_overwrite ... [OK]
test_version_modify ... [OK]
allmydata.test.test_netstring
Netstring
test_extra ... [OK]
test_nested ... [OK]
test_split ... [OK]
allmydata.test.test_no_network
Harness
test_create ... [OK]
test_upload ... [OK]
allmydata.test.test_node
TestCase
test_location1 ... [OK]
test_location2 ... [OK]
test_location_auto_and_explicit ... [OK]
test_location_not_set ... [OK]
test_logdir_is_str ... [OK]
test_private_config ... [OK]
test_secrets_dir ... [OK]
test_secrets_dir_protected ... [SKIPPED]
test_tahoe_cfg_hash_in_name ... [OK]
test_tahoe_cfg_utf8 ... [OK]
test_timestamp ... [OK]
allmydata.test.test_observer
Observer
test_lazy_oneshot ... [OK]
test_observerlist ... [OK]
test_oneshot ... [OK]
test_oneshot_fireagain ... [OK]
allmydata.test.test_repairer
Repairer
test_harness ... [OK]
test_repair_from_deletion_of_1 ... [OK]
test_repair_from_deletion_of_7 ... [OK]
test_repairer_servers_of_happiness ... [OK]
test_servers_responding ... [OK]
test_tiny_reads ... [OK]
Verifier
test_check_without_verify ... [OK]
test_corrupt_block_hashtree ... [OK]
test_corrupt_block_hashtree_offset ... [OK]
test_corrupt_crypttext_hashtree ... [OK]
test_corrupt_crypttext_hashtree_byte_x221 ... [OK]
test_corrupt_crypttext_hashtree_offset ... [OK]
test_corrupt_file_verno ... [OK]
test_corrupt_share_hashtree ... [OK]
test_corrupt_share_hashtree_offset ... [OK]
test_corrupt_share_verno ... [OK]
test_corrupt_sharedata ... [OK]
test_corrupt_sharedata_last_byte ... [OK]
test_corrupt_sharedata_offset ... [OK]
test_corrupt_ueb ... [OK]
test_corrupt_ueb_length ... [OK]
test_corrupt_ueb_offset ... [OK]
test_corrupt_ueb_offset_shortread ... [OK]
test_ok_filedata_size ... [OK]
test_ok_no_corruption ... [OK]
test_ok_segment_size ... [OK]
test_ok_sharedata_size ... [OK]
test_truncate_crypttext_hashtree ... [OK]
test_wrong_share_verno ... [OK]
allmydata.test.test_runner
BinTahoe
test_import_in_repl ... [OK]
test_path ... [OK]
test_run_with_python_options ... [OK]
test_the_right_code ... [OK]
test_unicode_arguments_and_output ... [OK]
test_version_no_noise ... [OK]
CreateNode
test_client ... [OK]
test_introducer ... [OK]
test_key_generator ... [OK]
test_node ... [OK]
test_stats_gatherer ... [OK]
test_subcommands ... [OK]
RunNode
test_baddir ... [SKIPPED]
test_client ... [SKIPPED]
test_client_no_noise ... [SKIPPED]
test_introducer ... [SKIPPED]
test_keygen ... [SKIPPED]
allmydata.test.test_sftp
Handler
test_basic ... [OK]
test_convert_error ... [OK]
test_execCommand_and_openShell ... [OK]
test_extendedRequest ... [OK]
test_makeDirectory ... [OK]
test_not_implemented ... [OK]
test_openDirectory_and_attrs ... [OK]
test_openFile_read ... [OK]
test_openFile_read_error ... [OK]
test_openFile_write ... [OK]
test_removeDirectory ... [OK]
test_removeFile ... [OK]
test_renameFile ... [OK]
test_renameFile_posix ... [OK]
allmydata.test.test_stats
CPUUsage
test_monitor ... [OK]
allmydata.test.test_storage
Bucket
test_create ... [OK]
test_read_past_end_of_share_data ... [OK]
test_readwrite ... [OK]
BucketCounter
test_bucket_counter ... [OK]
test_bucket_counter_cleanup ... [OK]
test_bucket_counter_eta ... [OK]
BucketProxy
test_create ... [OK]
test_readwrite_v1 ... [OK]
test_readwrite_v2 ... [OK]
LeaseCrawler
test_bad_mode ... [OK]
test_basic ... [OK]
test_expire_age ... [OK]
test_expire_cutoff_date ... [OK]
test_limited_history ... [OK]
test_no_st_blocks ... [OK]
test_only_immutable ... [OK]
test_only_mutable ... [OK]
test_parse_date ... [OK]
test_parse_duration ... [OK]
test_share_corruption ... [OK]
test_unpredictable_future ... [OK]
MDMFProxies
test_end_to_end ... [OK]
test_get_block_with_invalid_segnum ... [OK]
test_get_checkstring_first ... [OK]
test_get_encoding_parameters_first ... [OK]
test_get_root_hash_first ... [OK]
test_get_seqnum_first ... [OK]
test_invalid_salt_size ... [OK]
test_is_sdmf ... [OK]
test_only_reads_one_segment_sdmf ... [OK]
test_private_key_after_share_hash_chain ... [OK]
test_read ... [OK]
test_read_with_different_tail_segment_size ... [OK]
test_read_with_empty_mdmf_file ... [OK]
test_read_with_empty_sdmf_file ... [OK]
test_read_with_prefetched_mdmf_data ... [OK]
test_read_with_prefetched_sdmf_data ... [OK]
test_reads_sdmf ... [OK]
test_sdmf_writer ... [OK]
test_sdmf_writer_preexisting_share ... [OK]
test_signature_after_verification_key ... [OK]
test_uncoordinated_write ... [OK]
test_verinfo_with_mdmf_file ... [OK]
test_verinfo_with_sdmf_file ... [OK]
test_write ... [OK]
test_write_enforces_order_constraints ... [OK]
test_write_read_vectors ... [OK]
test_write_rejected_with_invalid_blocksize ... [OK]
test_write_rejected_with_invalid_root_hash ... [OK]
test_write_rejected_with_invalid_salt ... [OK]
test_write_rejected_with_too_many_blocks ... [OK]
test_write_test_vectors ... [OK]
MutableServer
test_allocate ... [OK]
test_bad_magic ... [OK]
test_container_size ... [OK]
test_create ... [OK]
test_leases ... [OK]
test_operators ... [OK]
test_readv ... [OK]
test_remove ... [OK]
Server
test_abort ... [OK]
test_advise_corruption ... [OK]
test_allocate ... [OK]
test_bad_container_version ... [OK]
test_create ... [OK]
test_declares_available_space ... [OK]
test_declares_fixed_1528 ... [OK]
test_declares_maximum_share_sizes ... [OK]
test_discard ... [OK]
test_disconnect ... [OK]
test_dont_overfill_dirs ... [OK]
test_large_share ... [SKIPPED]
test_leases ... [OK]
test_readonly ... [OK]
test_remove_incoming ... [OK]
test_reserved_space ... [OK]
test_seek ... [OK]
Stats
test_latencies ... [OK]
WebStatus
test_huge_reserved ... [OK]
test_no_server ... [OK]
test_readonly ... [OK]
test_reserved ... [OK]
test_status ... [OK]
test_status_bad_disk_stats ... [OK]
test_status_no_disk_stats ... [OK]
test_status_right_disk_stats ... [OK]
test_util ... [OK]
allmydata.test.test_storage_client
TestNativeStorageServer
test_get_available_space_new ... [OK]
test_get_available_space_old ... [OK]
allmydata.test.test_system
Connections
test_rref ... [OK]
SystemTest
test_debug_trial ... [OK]
test_filesystem ... [<twisted.python.failure.Failure foolscap.ipb.DeadReferenceError: replaced by a new connection>]
Traceback (most recent call last):
File "C:\Users\peawe\git\magic-folder\support\Lib\site-packages\twisted-15.4.0-py2.7-win32.egg\twisted\internet\defer.py", line 150, in maybeDeferred
result = f(*args, **kw)
File "c:\users\peawe\git\magic-folder\src\allmydata\util\pollmixin.py", line 49, in _poll
self.fail("Errors snooped, terminating early")
twisted.trial.unittest.FailTest: Errors snooped, terminating early
[FAIL]
Traceback (most recent call last):
Failure: twisted.trial.util.DirtyReactorAggregateError: Reactor was unclean.
DelayedCalls: (set twisted.internet.base.DelayedCall.debug = True to debug)
<DelayedCall 0x6994f08 [0.0s] called=0 cancelled=0 _SimpleCallQueue._turn()>
[ERROR]
Traceback (most recent call last):
Failure: foolscap.ipb.DeadReferenceError: replaced by a new connection
[ERROR]
Traceback (most recent call last):
Failure: foolscap.ipb.DeadReferenceError: Connection was lost (to tubid=ncie) (during method=RIStorageServer.tahoe.allmydata.com:get_version)
[ERROR]
test_filesystem_with_cli_in_subprocess ... Traceback (most recent call last):
Failure: twisted.internet.defer.TimeoutError: <allmydata.test.test_system.SystemTest testMethod=test_filesystem_with_cli_in_subprocess> (test_filesystem_with_cli_in_subprocess) still running at 3600.0 secs
[ERROR]
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment