[Module ][WARNING] Error loading the file: /home/john/gnome-bzr/src/conduit/conduit/modules/OSyncEvoModule.py Traceback (most recent call last): File "/home/john/gnome-bzr/src/conduit/conduit/Module.py", line 173, in _load_modules_in_file mod = self._import_file(filename) File "/home/john/gnome-bzr/src/conduit/conduit/Module.py", line 154, in _import_file mods = pydoc.importfile (filename) File "/usr/lib/python2.5/pydoc.py", line 259, in importfile raise ErrorDuringImport(path, sys.exc_info()) ErrorDuringImport: problem in /home/john/gnome-bzr/src/conduit/conduit/modules/OSyncEvoModule.py - : (Module.py:201) [modules.Feed ][INFO ] Module Information: feedparser v4.1 (/var/lib/python-support/python2.5/feedparser.pyc) (FeedModule.py:20) [modules.Feed ][INFO ] Patching feedparser issue #100 (FeedModule.py:26) [modules.Backpack ][INFO ] Module Information: backpack (/home/john/gnome-bzr/src/conduit/conduit/modules/BackpackModule/backpack/backpack.pyc) (BackpackModule.py:22) [dataproviders.SimpleFactory][INFO ] HAL Initialized (VolumeFactory.py:23) [modules.Evolution ][INFO ] Module Information: evolution v(2, 2, 2) (/var/lib/python-support/python2.5/gtk-2.0/evolution/__init__.pyc) (EvolutionModule.py:25) [modules.Flickr ][INFO ] Module Information: flickrapi v1.1 (/home/john/gnome-bzr/src/conduit/conduit/modules/FlickrModule/flickrapi/__init__.pyc) (FlickrModule.py:26) [modules.Network ][INFO ] Network support enabled (NetworkModule.py:30) [modules.Network ][DEBUG ] Starting AvahiAdvertiser server (Server.py:35) [modules.Network ][DEBUG ] Announcing avahi conduit service (Peers.py:159) [modules.Network ][WARNING] Error starting AvahiAdvertiser server: (98, 'Address already in use') (Server.py:52) [modules.Google ][INFO ] Module Information: gdata (/home/john/gnome-bzr/src/conduit/conduit/modules/GoogleModule/gdata/__init__.pyc) (GoogleModule.py:45) [dataproviders.SimpleFactory][INFO ] HAL Initialized (VolumeFactory.py:23) [modules.iPod ][INFO ] Module Information: gpod v(0, 6, 0) (/usr/lib/python2.5/site-packages/gpod/__init__.pyc) (iPodModule.py:35) [dataproviders.SimpleFactory][INFO ] HAL Initialized (VolumeFactory.py:23) [modules.Picasa ][INFO ] Picasa desktop directory detected (PicasaDesktopModule.py:25) [modules.Phone ][INFO ] Module Information: gammu vGammu 1.15.0, python-gammu 0.24 (/usr/lib/python2.5/site-packages/gammu/__init__.pyc) (Gammu.py:16) [modules.Facebook ][INFO ] Module Information: pyfacebook v0.1 (/home/john/gnome-bzr/src/conduit/conduit/modules/FacebookModule/pyfacebook/__init__.pyc) (FacebookModule.py:30) [modules.Phone ][INFO ] Starting Scan Threads (PhoneModule.py:88) [modules.Phone ][INFO ] Beginning Bluetooth Scan (Gammu.py:110) [modules.Phone ][WARNING] Error discovering services (Gammu.py:133) [Conduit ][DEBUG ] Adding twoway dataprovider into sink position (Conduit.py:146) [datatypes.File ][DEBUG ] New tempfile created at /tmp/conduitVVVMsN (File.py:545) [datatypes.File ][DEBUG ] Defering rename till transfer (New name: 20234) (File.py:112) [datatypes.File ][DEBUG ] Using deferred filename in transfer (File.py:293) [datatypes.File ][DEBUG ] Transfering File file:///tmp/conduitVVVMsN -> file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234 (File.py:302) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.File ][DEBUG ] Clearing pending rename (File.py:65) [datatypes.File ][DEBUG ] New tempfile created at /tmp/conduit7Zg_mM (File.py:545) [datatypes.File ][DEBUG ] Defering rename till transfer (New name: 30688) (File.py:112) [datatypes.File ][DEBUG ] Using deferred filename in transfer (File.py:293) [datatypes.File ][DEBUG ] Transfering File file:///tmp/conduit7Zg_mM -> file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688 (File.py:302) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.File ][DEBUG ] Clearing pending rename (File.py:65) [datatypes.File ][DEBUG ] New tempfile created at /tmp/conduitzBmraY (File.py:545) [datatypes.File ][DEBUG ] Defering rename till transfer (New name: 79249) (File.py:112) [datatypes.File ][DEBUG ] Using deferred filename in transfer (File.py:293) [datatypes.File ][DEBUG ] Transfering File file:///tmp/conduitzBmraY -> file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249 (File.py:302) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.File ][DEBUG ] Clearing pending rename (File.py:65) [datatypes.File ][DEBUG ] New tempfile created at /tmp/conduiteZ28Q4 (File.py:545) [datatypes.File ][DEBUG ] Defering rename till transfer (New name: 610813) (File.py:112) [datatypes.File ][DEBUG ] Using deferred filename in transfer (File.py:293) [datatypes.File ][DEBUG ] Transfering File file:///tmp/conduiteZ28Q4 -> file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813 (File.py:302) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.File ][DEBUG ] Clearing pending rename (File.py:65) [datatypes.File ][DEBUG ] New tempfile created at /tmp/conduitiqxTgF (File.py:545) [datatypes.File ][DEBUG ] Defering rename till transfer (New name: 50442) (File.py:112) [datatypes.File ][DEBUG ] Using deferred filename in transfer (File.py:293) [datatypes.File ][DEBUG ] Transfering File file:///tmp/conduitiqxTgF -> file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442 (File.py:302) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.File ][DEBUG ] Clearing pending rename (File.py:65) [datatypes.File ][DEBUG ] New tempfile created at /tmp/conduitbmsBpn (File.py:545) [datatypes.File ][DEBUG ] Defering rename till transfer (New name: 94725) (File.py:112) [datatypes.File ][DEBUG ] Using deferred filename in transfer (File.py:293) [datatypes.File ][DEBUG ] Transfering File file:///tmp/conduitbmsBpn -> file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725 (File.py:302) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.File ][DEBUG ] Clearing pending rename (File.py:65) [datatypes.File ][DEBUG ] New tempfile created at /tmp/conduitBRP8oI (File.py:545) [datatypes.File ][DEBUG ] Defering rename till transfer (New name: 16750) (File.py:112) [datatypes.File ][DEBUG ] Using deferred filename in transfer (File.py:293) [datatypes.File ][DEBUG ] Transfering File file:///tmp/conduitBRP8oI -> file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750 (File.py:302) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.File ][DEBUG ] Clearing pending rename (File.py:65) [datatypes.File ][DEBUG ] New tempfile created at /tmp/conduitA4R-WR (File.py:545) [datatypes.File ][DEBUG ] Defering rename till transfer (New name: 821101) (File.py:112) [datatypes.File ][DEBUG ] Using deferred filename in transfer (File.py:293) [datatypes.File ][DEBUG ] Transfering File file:///tmp/conduitA4R-WR -> file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101 (File.py:302) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.File ][DEBUG ] Clearing pending rename (File.py:65) [datatypes.File ][DEBUG ] New tempfile created at /tmp/conduitSgv-Gm (File.py:545) [datatypes.File ][DEBUG ] Defering rename till transfer (New name: 107295) (File.py:112) [datatypes.File ][DEBUG ] Using deferred filename in transfer (File.py:293) [datatypes.File ][DEBUG ] Transfering File file:///tmp/conduitSgv-Gm -> file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295 (File.py:302) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.File ][DEBUG ] Clearing pending rename (File.py:65) [datatypes.File ][DEBUG ] New tempfile created at /tmp/conduit0xb9Ql (File.py:545) [datatypes.File ][DEBUG ] Defering rename till transfer (New name: 710143) (File.py:112) [datatypes.File ][DEBUG ] Using deferred filename in transfer (File.py:293) [datatypes.File ][DEBUG ] Transfering File file:///tmp/conduit0xb9Ql -> file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143 (File.py:302) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.File ][DEBUG ] Clearing pending rename (File.py:65) [Vfs ][DEBUG ] Folder scan 100.0% complete (Vfs.py:508) [Vfs ][DEBUG ] 0 files loaded in 0.00214886665344 seconds (Vfs.py:516) [Conduit ][DEBUG ] Disabling Two Way Sync (Conduit.py:249) [Syncronization ][DEBUG ] Created thread (thread: -1210525504) (Synchronization.py:211) [Syncronization ][INFO ] Setting global cancel flag (Synchronization.py:90) [Syncronization ][DEBUG ] Starting worker: [], initial)> (Synchronization.py:93) [Syncronization ][INFO ] Waiting for thread to finish (Synchronization.py:124) [Syncronization ][DEBUG ] Started thread [], started)> (thread: -1272095856) (Synchronization.py:624) [Syncronization ][DEBUG ] Sync [], started)> beginning. Slow: False, Twoway: False (Synchronization.py:629) [Syncronization ][DEBUG ] Syncworker state 0 (Synchronization.py:648) [Syncronization ][DEBUG ] Syncworker state 1 (Synchronization.py:648) [Syncronization ][DEBUG ] Source Status = Synchronizing... (Synchronization.py:677) [Vfs ][DEBUG ] Folder scan 100.0% complete (Vfs.py:508) [Vfs ][DEBUG ] 0 files loaded in 0.00209903717041 seconds (Vfs.py:516) [Syncronization ][DEBUG ] Syncworker state 2 (Synchronization.py:648) [Syncronization ][INFO ] Synchronizing Wrapper: Files source (UID: FileSource-john@nzjrs-desktop) |--> Wrapper: foldersink twoway (UID: FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink) (Synchronization.py:467) [DeltaProvider ][INFO ] Delta: Source (FileSource-john@nzjrs-desktop) does not implement get_changes(). Proxying... (DeltaProvider.py:25) [DeltaProvider ][DEBUG ] Delta: Got 10 items [u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143'] (DeltaProvider.py:39) [DeltaProvider ][DEBUG ] Delta: Expecting 0 items (DeltaProvider.py:49) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: New 10 items [u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143'] (Synchronization.py:241) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: Modified 0 items [] (Synchronization.py:242) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: Deleted 0 items [] (Synchronization.py:243) [Syncronization ][DEBUG ] 1WAY PUT: Files (/home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234) -----> Folder (Synchronization.py:489) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234 (DataType.py:151) [TypeConverter ][DEBUG ] Convert file -> file using [('file', 'file', {})] (TypeConverter.py:210) [TypeConverter ][DEBUG ] Skipping file -> file (TypeConverter.py:169) [datatypes.File ][DEBUG ] Setting mtime of file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234 to 1217731495 () (File.py:141) [datatypes.File ][DEBUG ] Closing file (File.py:58) [Syncronization ][INFO ] Putting data /home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234 --> None into FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink (Synchronization.py:37) [dataproviders.File ][DEBUG ] No basepath. Going to empty dir (File.py:281) [datatypes.File ][DEBUG ] Transfering File file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234 -> file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/20234 (File.py:302) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.DataType ][DEBUG ] Getting Rid for file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/20234 (DataType.py:151) [Syncronization ][DEBUG ] 1WAY PUT: Files (/home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688) -----> Folder (Synchronization.py:489) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688 (DataType.py:151) [TypeConverter ][DEBUG ] Convert file -> file using [('file', 'file', {})] (TypeConverter.py:210) [TypeConverter ][DEBUG ] Skipping file -> file (TypeConverter.py:169) [datatypes.File ][DEBUG ] Setting mtime of file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688 to 1217731495 () (File.py:141) [datatypes.File ][DEBUG ] Closing file (File.py:58) [Syncronization ][INFO ] Putting data /home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688 --> None into FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink (Synchronization.py:37) [dataproviders.File ][DEBUG ] No basepath. Going to empty dir (File.py:281) [datatypes.File ][DEBUG ] Transfering File file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688 -> file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/30688 (File.py:302) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.DataType ][DEBUG ] Getting Rid for file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/30688 (DataType.py:151) [Syncronization ][DEBUG ] 1WAY PUT: Files (/home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249) -----> Folder (Synchronization.py:489) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249 (DataType.py:151) [TypeConverter ][DEBUG ] Convert file -> file using [('file', 'file', {})] (TypeConverter.py:210) [TypeConverter ][DEBUG ] Skipping file -> file (TypeConverter.py:169) [datatypes.File ][DEBUG ] Setting mtime of file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249 to 1217731495 () (File.py:141) [datatypes.File ][DEBUG ] Closing file (File.py:58) [Syncronization ][INFO ] Putting data /home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249 --> None into FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink (Synchronization.py:37) [dataproviders.File ][DEBUG ] No basepath. Going to empty dir (File.py:281) [datatypes.File ][DEBUG ] Transfering File file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249 -> file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/79249 (File.py:302) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.DataType ][DEBUG ] Getting Rid for file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/79249 (DataType.py:151) [Syncronization ][DEBUG ] 1WAY PUT: Files (/home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813) -----> Folder (Synchronization.py:489) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813 (DataType.py:151) [TypeConverter ][DEBUG ] Convert file -> file using [('file', 'file', {})] (TypeConverter.py:210) [TypeConverter ][DEBUG ] Skipping file -> file (TypeConverter.py:169) [datatypes.File ][DEBUG ] Setting mtime of file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813 to 1217731495 () (File.py:141) [datatypes.File ][DEBUG ] Closing file (File.py:58) [Syncronization ][INFO ] Putting data /home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813 --> None into FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink (Synchronization.py:37) [dataproviders.File ][DEBUG ] No basepath. Going to empty dir (File.py:281) [datatypes.File ][DEBUG ] Transfering File file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813 -> file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/610813 (File.py:302) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.DataType ][DEBUG ] Getting Rid for file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/610813 (DataType.py:151) [Syncronization ][DEBUG ] 1WAY PUT: Files (/home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442) -----> Folder (Synchronization.py:489) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442 (DataType.py:151) [TypeConverter ][DEBUG ] Convert file -> file using [('file', 'file', {})] (TypeConverter.py:210) [TypeConverter ][DEBUG ] Skipping file -> file (TypeConverter.py:169) [datatypes.File ][DEBUG ] Setting mtime of file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442 to 1217731495 () (File.py:141) [datatypes.File ][DEBUG ] Closing file (File.py:58) [Syncronization ][INFO ] Putting data /home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442 --> None into FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink (Synchronization.py:37) [dataproviders.File ][DEBUG ] No basepath. Going to empty dir (File.py:281) [datatypes.File ][DEBUG ] Transfering File file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442 -> file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/50442 (File.py:302) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.DataType ][DEBUG ] Getting Rid for file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/50442 (DataType.py:151) [Syncronization ][DEBUG ] 1WAY PUT: Files (/home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725) -----> Folder (Synchronization.py:489) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725 (DataType.py:151) [TypeConverter ][DEBUG ] Convert file -> file using [('file', 'file', {})] (TypeConverter.py:210) [TypeConverter ][DEBUG ] Skipping file -> file (TypeConverter.py:169) [datatypes.File ][DEBUG ] Setting mtime of file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725 to 1217731495 () (File.py:141) [datatypes.File ][DEBUG ] Closing file (File.py:58) [Syncronization ][INFO ] Putting data /home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725 --> None into FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink (Synchronization.py:37) [dataproviders.File ][DEBUG ] No basepath. Going to empty dir (File.py:281) [datatypes.File ][DEBUG ] Transfering File file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725 -> file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/94725 (File.py:302) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.DataType ][DEBUG ] Getting Rid for file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/94725 (DataType.py:151) [Syncronization ][DEBUG ] 1WAY PUT: Files (/home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750) -----> Folder (Synchronization.py:489) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750 (DataType.py:151) [TypeConverter ][DEBUG ] Convert file -> file using [('file', 'file', {})] (TypeConverter.py:210) [TypeConverter ][DEBUG ] Skipping file -> file (TypeConverter.py:169) [datatypes.File ][DEBUG ] Setting mtime of file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750 to 1217731495 () (File.py:141) [datatypes.File ][DEBUG ] Closing file (File.py:58) [Syncronization ][INFO ] Putting data /home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750 --> None into FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink (Synchronization.py:37) [dataproviders.File ][DEBUG ] No basepath. Going to empty dir (File.py:281) [datatypes.File ][DEBUG ] Transfering File file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750 -> file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/16750 (File.py:302) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.DataType ][DEBUG ] Getting Rid for file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/16750 (DataType.py:151) [Syncronization ][DEBUG ] 1WAY PUT: Files (/home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101) -----> Folder (Synchronization.py:489) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101 (DataType.py:151) [TypeConverter ][DEBUG ] Convert file -> file using [('file', 'file', {})] (TypeConverter.py:210) [TypeConverter ][DEBUG ] Skipping file -> file (TypeConverter.py:169) [datatypes.File ][DEBUG ] Setting mtime of file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101 to 1217731495 () (File.py:141) [datatypes.File ][DEBUG ] Closing file (File.py:58) [Syncronization ][INFO ] Putting data /home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101 --> None into FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink (Synchronization.py:37) [dataproviders.File ][DEBUG ] No basepath. Going to empty dir (File.py:281) [datatypes.File ][DEBUG ] Transfering File file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101 -> file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/821101 (File.py:302) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.DataType ][DEBUG ] Getting Rid for file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/821101 (DataType.py:151) [Syncronization ][DEBUG ] 1WAY PUT: Files (/home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295) -----> Folder (Synchronization.py:489) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295 (DataType.py:151) [TypeConverter ][DEBUG ] Convert file -> file using [('file', 'file', {})] (TypeConverter.py:210) [TypeConverter ][DEBUG ] Skipping file -> file (TypeConverter.py:169) [datatypes.File ][DEBUG ] Setting mtime of file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295 to 1217731495 () (File.py:141) [datatypes.File ][DEBUG ] Closing file (File.py:58) [Syncronization ][INFO ] Putting data /home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295 --> None into FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink (Synchronization.py:37) [dataproviders.File ][DEBUG ] No basepath. Going to empty dir (File.py:281) [datatypes.File ][DEBUG ] Transfering File file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295 -> file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/107295 (File.py:302) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.DataType ][DEBUG ] Getting Rid for file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/107295 (DataType.py:151) [Syncronization ][DEBUG ] 1WAY PUT: Files (/home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143) -----> Folder (Synchronization.py:489) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143 (DataType.py:151) [TypeConverter ][DEBUG ] Convert file -> file using [('file', 'file', {})] (TypeConverter.py:210) [TypeConverter ][DEBUG ] Skipping file -> file (TypeConverter.py:169) [datatypes.File ][DEBUG ] Setting mtime of file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143 to 1217731495 () (File.py:141) [datatypes.File ][DEBUG ] Closing file (File.py:58) [Syncronization ][INFO ] Putting data /home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143 --> None into FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink (Synchronization.py:37) [dataproviders.File ][DEBUG ] No basepath. Going to empty dir (File.py:281) [datatypes.File ][DEBUG ] Transfering File file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143 -> file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/710143 (File.py:302) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.DataType ][DEBUG ] Getting Rid for file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/710143 (DataType.py:151) [Syncronization ][DEBUG ] Syncworker state 3 (Synchronization.py:648) [Vfs ][DEBUG ] Folder scan 100.0% complete (Vfs.py:508) [Vfs ][DEBUG ] 10 files loaded in 0.00433015823364 seconds (Vfs.py:516) [Syncronization ][INFO ] Sync already in progress (Synchronization.py:172) [Syncronization ][INFO ] Waiting for thread to finish (Synchronization.py:124) [Syncronization ][DEBUG ] Created thread (thread: -1210525504) (Synchronization.py:211) [Syncronization ][INFO ] Setting global cancel flag (Synchronization.py:90) [Syncronization ][DEBUG ] Starting worker: [], initial)> (Synchronization.py:93) [Syncronization ][INFO ] Waiting for thread to finish (Synchronization.py:124) [Syncronization ][DEBUG ] Started thread [], started)> (thread: -1272095856) (Synchronization.py:624) [Syncronization ][DEBUG ] Sync [], started)> beginning. Slow: False, Twoway: False (Synchronization.py:629) [Syncronization ][DEBUG ] Syncworker state 0 (Synchronization.py:648) [Syncronization ][DEBUG ] Syncworker state 1 (Synchronization.py:648) [Syncronization ][DEBUG ] Source Status = Synchronizing... (Synchronization.py:677) [Vfs ][DEBUG ] Folder scan 100.0% complete (Vfs.py:508) [Vfs ][DEBUG ] 10 files loaded in 0.0036768913269 seconds (Vfs.py:516) [Syncronization ][DEBUG ] Syncworker state 2 (Synchronization.py:648) [Syncronization ][INFO ] Synchronizing Wrapper: Files source (UID: FileSource-john@nzjrs-desktop) |--> Wrapper: foldersink twoway (UID: FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink) (Synchronization.py:467) [DeltaProvider ][INFO ] Delta: Source (FileSource-john@nzjrs-desktop) does not implement get_changes(). Proxying... (DeltaProvider.py:25) [DeltaProvider ][DEBUG ] Delta: Got 10 items [u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143'] (DeltaProvider.py:39) [DeltaProvider ][DEBUG ] Delta: Expecting 10 items (DeltaProvider.py:49) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143 (DataType.py:151) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: New 0 items [] (Synchronization.py:241) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: Modified 0 items [] (Synchronization.py:242) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: Deleted 0 items [] (Synchronization.py:243) [Syncronization ][DEBUG ] Syncworker state 3 (Synchronization.py:648) [Vfs ][DEBUG ] Folder scan 100.0% complete (Vfs.py:508) [Vfs ][DEBUG ] 10 files loaded in 0.00424003601074 seconds (Vfs.py:516) [Syncronization ][INFO ] Sync already in progress (Synchronization.py:172) [Syncronization ][INFO ] Waiting for thread to finish (Synchronization.py:124) [Syncronization ][DEBUG ] Created thread (thread: -1210525504) (Synchronization.py:211) [Syncronization ][INFO ] Setting global cancel flag (Synchronization.py:90) [Syncronization ][DEBUG ] Starting worker: [], initial)> (Synchronization.py:93) [Syncronization ][DEBUG ] Started thread [], started)> (thread: -1272095856) (Synchronization.py:624) [Syncronization ][INFO ] Waiting for thread to finish (Synchronization.py:124) [Syncronization ][DEBUG ] Sync [], started)> beginning. Slow: False, Twoway: False (Synchronization.py:629) [Syncronization ][DEBUG ] Syncworker state 0 (Synchronization.py:648) [Syncronization ][DEBUG ] Syncworker state 1 (Synchronization.py:648) [Syncronization ][DEBUG ] Source Status = Synchronizing... (Synchronization.py:677) [Vfs ][DEBUG ] Folder scan 100.0% complete (Vfs.py:508) [Vfs ][DEBUG ] 10 files loaded in 0.00399589538574 seconds (Vfs.py:516) [Syncronization ][DEBUG ] Syncworker state 2 (Synchronization.py:648) [Syncronization ][INFO ] Synchronizing Wrapper: Files source (UID: FileSource-john@nzjrs-desktop) |--> Wrapper: foldersink twoway (UID: FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink) (Synchronization.py:467) [DeltaProvider ][INFO ] Delta: Source (FileSource-john@nzjrs-desktop) does not implement get_changes(). Proxying... (DeltaProvider.py:25) [DeltaProvider ][DEBUG ] Delta: Got 10 items [u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143'] (DeltaProvider.py:39) [DeltaProvider ][DEBUG ] Delta: Expecting 10 items (DeltaProvider.py:49) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143 (DataType.py:151) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: New 0 items [] (Synchronization.py:241) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: Modified 0 items [] (Synchronization.py:242) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: Deleted 0 items [] (Synchronization.py:243) [Syncronization ][DEBUG ] Syncworker state 3 (Synchronization.py:648) [Vfs ][DEBUG ] Folder scan 100.0% complete (Vfs.py:508) [Vfs ][DEBUG ] 10 files loaded in 0.00682187080383 seconds (Vfs.py:516) [Conduit ][DEBUG ] Enabling Two Way Sync (Conduit.py:244) [Syncronization ][INFO ] Sync already in progress (Synchronization.py:172) [Syncronization ][INFO ] Waiting for thread to finish (Synchronization.py:124) [Syncronization ][DEBUG ] Created thread (thread: -1210525504) (Synchronization.py:211) [Syncronization ][INFO ] Setting global cancel flag (Synchronization.py:90) [Syncronization ][DEBUG ] Starting worker: [], initial)> (Synchronization.py:93) [Syncronization ][DEBUG ] Started thread [], started)> (thread: -1272095856) (Synchronization.py:624) [Syncronization ][DEBUG ] Sync [], started)> beginning. Slow: False, Twoway: False (Synchronization.py:629) [Syncronization ][DEBUG ] Syncworker state 0 (Synchronization.py:648) [Syncronization ][DEBUG ] Syncworker state 1 (Synchronization.py:648) [Syncronization ][DEBUG ] Source Status = Synchronizing... (Synchronization.py:677) [Syncronization ][INFO ] Waiting for thread to finish (Synchronization.py:124) [Vfs ][DEBUG ] Folder scan 100.0% complete (Vfs.py:508) [Vfs ][DEBUG ] 10 files loaded in 0.00674200057983 seconds (Vfs.py:516) [Syncronization ][DEBUG ] Syncworker state 2 (Synchronization.py:648) [Syncronization ][INFO ] Synchronizing Wrapper: Files source (UID: FileSource-john@nzjrs-desktop) |--> Wrapper: foldersink twoway (UID: FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink) (Synchronization.py:467) [DeltaProvider ][INFO ] Delta: Source (FileSource-john@nzjrs-desktop) does not implement get_changes(). Proxying... (DeltaProvider.py:25) [DeltaProvider ][DEBUG ] Delta: Got 10 items [u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143'] (DeltaProvider.py:39) [DeltaProvider ][DEBUG ] Delta: Expecting 10 items (DeltaProvider.py:49) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143 (DataType.py:151) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: New 0 items [] (Synchronization.py:241) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: Modified 0 items [] (Synchronization.py:242) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: Deleted 0 items [] (Synchronization.py:243) [Syncronization ][DEBUG ] Syncworker state 3 (Synchronization.py:648) [Vfs ][DEBUG ] Folder scan 100.0% complete (Vfs.py:508) [Vfs ][DEBUG ] 10 files loaded in 0.00609993934631 seconds (Vfs.py:516) [Syncronization ][INFO ] Sync already in progress (Synchronization.py:172) [Syncronization ][INFO ] Waiting for thread to finish (Synchronization.py:124) [Syncronization ][DEBUG ] Created thread (thread: -1210525504) (Synchronization.py:211) [Syncronization ][INFO ] Setting global cancel flag (Synchronization.py:90) [Syncronization ][DEBUG ] Starting worker: [], initial)> (Synchronization.py:93) [Syncronization ][INFO ] Waiting for thread to finish (Synchronization.py:124) [Syncronization ][DEBUG ] Started thread [], started)> (thread: -1272095856) (Synchronization.py:624) [Syncronization ][DEBUG ] Sync [], started)> beginning. Slow: False, Twoway: False (Synchronization.py:629) [Syncronization ][DEBUG ] Syncworker state 0 (Synchronization.py:648) [Syncronization ][DEBUG ] Syncworker state 1 (Synchronization.py:648) [Syncronization ][DEBUG ] Source Status = Synchronizing... (Synchronization.py:677) [Vfs ][DEBUG ] Folder scan 100.0% complete (Vfs.py:508) [Vfs ][DEBUG ] 10 files loaded in 0.00479292869568 seconds (Vfs.py:516) [Syncronization ][DEBUG ] Syncworker state 2 (Synchronization.py:648) [Syncronization ][INFO ] Synchronizing Wrapper: Files source (UID: FileSource-john@nzjrs-desktop) |--> Wrapper: foldersink twoway (UID: FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink) (Synchronization.py:467) [DeltaProvider ][INFO ] Delta: Source (FileSource-john@nzjrs-desktop) does not implement get_changes(). Proxying... (DeltaProvider.py:25) [DeltaProvider ][DEBUG ] Delta: Got 10 items [u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143'] (DeltaProvider.py:39) [DeltaProvider ][DEBUG ] Delta: Expecting 10 items (DeltaProvider.py:49) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143 (DataType.py:151) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: New 0 items [] (Synchronization.py:241) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: Modified 0 items [] (Synchronization.py:242) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: Deleted 0 items [] (Synchronization.py:243) [Syncronization ][DEBUG ] Syncworker state 3 (Synchronization.py:648) [Vfs ][DEBUG ] Folder scan 100.0% complete (Vfs.py:508) [Vfs ][DEBUG ] 10 files loaded in 0.00446486473083 seconds (Vfs.py:516) [Syncronization ][INFO ] Sync already in progress (Synchronization.py:172) [Syncronization ][INFO ] Waiting for thread to finish (Synchronization.py:124) [Syncronization ][DEBUG ] Created thread (thread: -1210525504) (Synchronization.py:211) [Syncronization ][INFO ] Setting global cancel flag (Synchronization.py:90) [Syncronization ][DEBUG ] Starting worker: [], initial)> (Synchronization.py:93) [Syncronization ][INFO ] Waiting for thread to finish (Synchronization.py:124) [Syncronization ][DEBUG ] Started thread [], started)> (thread: -1272095856) (Synchronization.py:624) [Syncronization ][DEBUG ] Sync [], started)> beginning. Slow: False, Twoway: False (Synchronization.py:629) [Syncronization ][DEBUG ] Syncworker state 0 (Synchronization.py:648) [Syncronization ][DEBUG ] Syncworker state 1 (Synchronization.py:648) [Syncronization ][DEBUG ] Source Status = Synchronizing... (Synchronization.py:677) [Vfs ][DEBUG ] Folder scan 100.0% complete (Vfs.py:508) [Vfs ][DEBUG ] 10 files loaded in 0.00353407859802 seconds (Vfs.py:516) [Syncronization ][DEBUG ] Syncworker state 2 (Synchronization.py:648) [Syncronization ][INFO ] Synchronizing Wrapper: Files source (UID: FileSource-john@nzjrs-desktop) |--> Wrapper: foldersink twoway (UID: FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink) (Synchronization.py:467) [DeltaProvider ][INFO ] Delta: Source (FileSource-john@nzjrs-desktop) does not implement get_changes(). Proxying... (DeltaProvider.py:25) [DeltaProvider ][DEBUG ] Delta: Got 10 items [u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143'] (DeltaProvider.py:39) [DeltaProvider ][DEBUG ] Delta: Expecting 10 items (DeltaProvider.py:49) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143 (DataType.py:151) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: New 0 items [] (Synchronization.py:241) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: Modified 0 items [] (Synchronization.py:242) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: Deleted 0 items [] (Synchronization.py:243) [Syncronization ][DEBUG ] Syncworker state 3 (Synchronization.py:648) [Vfs ][DEBUG ] Folder scan 100.0% complete (Vfs.py:508) [Vfs ][DEBUG ] 10 files loaded in 0.00424909591675 seconds (Vfs.py:516) [datatypes.File ][DEBUG ] Comparing file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234 (MTIME: 2008-08-03 14:44:55) with file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/20234 (MTIME: 2008-08-03 14:44:55) (File.py:472) [datatypes.File ][DEBUG ] Comparing file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688 (MTIME: 2008-08-03 14:44:55) with file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/30688 (MTIME: 2008-08-03 14:44:55) (File.py:472) [datatypes.File ][DEBUG ] Comparing file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249 (MTIME: 2008-08-03 14:44:55) with file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/79249 (MTIME: 2008-08-03 14:44:55) (File.py:472) [datatypes.File ][DEBUG ] Comparing file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813 (MTIME: 2008-08-03 14:44:55) with file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/610813 (MTIME: 2008-08-03 14:44:55) (File.py:472) [datatypes.File ][DEBUG ] Comparing file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442 (MTIME: 2008-08-03 14:44:55) with file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/50442 (MTIME: 2008-08-03 14:44:55) (File.py:472) [datatypes.File ][DEBUG ] Comparing file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725 (MTIME: 2008-08-03 14:44:55) with file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/94725 (MTIME: 2008-08-03 14:44:55) (File.py:472) [datatypes.File ][DEBUG ] Comparing file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750 (MTIME: 2008-08-03 14:44:55) with file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/16750 (MTIME: 2008-08-03 14:44:55) (File.py:472) [datatypes.File ][DEBUG ] Comparing file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101 (MTIME: 2008-08-03 14:44:55) with file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/821101 (MTIME: 2008-08-03 14:44:55) (File.py:472) [datatypes.File ][DEBUG ] Comparing file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295 (MTIME: 2008-08-03 14:44:55) with file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/107295 (MTIME: 2008-08-03 14:44:55) (File.py:472) [datatypes.File ][DEBUG ] Comparing file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143 (MTIME: 2008-08-03 14:44:55) with file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/710143 (MTIME: 2008-08-03 14:44:55) (File.py:472) [Syncronization ][INFO ] Sync already in progress (Synchronization.py:172) [Syncronization ][INFO ] Waiting for thread to finish (Synchronization.py:124) [Syncronization ][DEBUG ] Created thread (thread: -1210525504) (Synchronization.py:211) [Syncronization ][INFO ] Setting global cancel flag (Synchronization.py:90) [Syncronization ][DEBUG ] Starting worker: [], initial)> (Synchronization.py:93) [Syncronization ][DEBUG ] Started thread [], started)> (thread: -1272095856) (Synchronization.py:624) [Syncronization ][DEBUG ] Sync [], started)> beginning. Slow: False, Twoway: False (Synchronization.py:629) [Syncronization ][DEBUG ] Syncworker state 0 (Synchronization.py:648) [Syncronization ][INFO ] Waiting for thread to finish (Synchronization.py:124) [Syncronization ][DEBUG ] Syncworker state 1 (Synchronization.py:648) [Syncronization ][DEBUG ] Source Status = Synchronizing... (Synchronization.py:677) [Vfs ][DEBUG ] Folder scan 100.0% complete (Vfs.py:508) [Vfs ][DEBUG ] 10 files loaded in 0.00354790687561 seconds (Vfs.py:516) [Syncronization ][DEBUG ] Syncworker state 2 (Synchronization.py:648) [Syncronization ][INFO ] Synchronizing Wrapper: Files source (UID: FileSource-john@nzjrs-desktop) |--> Wrapper: foldersink twoway (UID: FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink) (Synchronization.py:467) [DeltaProvider ][INFO ] Delta: Source (FileSource-john@nzjrs-desktop) does not implement get_changes(). Proxying... (DeltaProvider.py:25) [DeltaProvider ][DEBUG ] Delta: Got 5 items [u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143'] (DeltaProvider.py:39) [DeltaProvider ][DEBUG ] Delta: Expecting 10 items (DeltaProvider.py:49) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143 (DataType.py:151) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: New 0 items [] (Synchronization.py:241) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: Modified 0 items [] (Synchronization.py:242) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: Deleted 5 items [u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/107295', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/16750', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/79249', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/20234', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/50442'] (Synchronization.py:243) [Syncronization ][DEBUG ] Deleted Policy: Delete (Synchronization.py:408) [Syncronization ][INFO ] Deleting file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/107295 from FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink (Synchronization.py:52) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.File ][DEBUG ] Deleting file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/107295 (File.py:340) [Syncronization ][DEBUG ] Deleted Policy: Delete (Synchronization.py:408) [Syncronization ][INFO ] Deleting file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/16750 from FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink (Synchronization.py:52) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.File ][DEBUG ] Deleting file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/16750 (File.py:340) [Syncronization ][DEBUG ] Deleted Policy: Delete (Synchronization.py:408) [Syncronization ][INFO ] Deleting file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/79249 from FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink (Synchronization.py:52) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.File ][DEBUG ] Deleting file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/79249 (File.py:340) [Syncronization ][DEBUG ] Deleted Policy: Delete (Synchronization.py:408) [Syncronization ][INFO ] Deleting file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/20234 from FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink (Synchronization.py:52) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.File ][DEBUG ] Deleting file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/20234 (File.py:340) [Syncronization ][DEBUG ] Deleted Policy: Delete (Synchronization.py:408) [Syncronization ][INFO ] Deleting file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/50442 from FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink (Synchronization.py:52) [datatypes.File ][DEBUG ] Closing file (File.py:58) [datatypes.File ][DEBUG ] Deleting file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/50442 (File.py:340) [Syncronization ][DEBUG ] Syncworker state 3 (Synchronization.py:648) [Vfs ][DEBUG ] Folder scan 100.0% complete (Vfs.py:508) [Vfs ][DEBUG ] 5 files loaded in 0.00288009643555 seconds (Vfs.py:516) [Syncronization ][INFO ] Sync already in progress (Synchronization.py:172) [Syncronization ][INFO ] Waiting for thread to finish (Synchronization.py:124) [Syncronization ][DEBUG ] Created thread (thread: -1210525504) (Synchronization.py:211) [Syncronization ][INFO ] Setting global cancel flag (Synchronization.py:90) [Syncronization ][DEBUG ] Starting worker: [], initial)> (Synchronization.py:93) [Syncronization ][DEBUG ] Started thread [], started)> (thread: -1272095856) (Synchronization.py:624) [Syncronization ][INFO ] Waiting for thread to finish (Synchronization.py:124) [Syncronization ][DEBUG ] Sync [], started)> beginning. Slow: False, Twoway: False (Synchronization.py:629) [Syncronization ][DEBUG ] Syncworker state 0 (Synchronization.py:648) [Syncronization ][DEBUG ] Syncworker state 1 (Synchronization.py:648) [Syncronization ][DEBUG ] Source Status = Synchronizing... (Synchronization.py:677) [Vfs ][DEBUG ] Folder scan 100.0% complete (Vfs.py:508) [Vfs ][DEBUG ] 5 files loaded in 0.00283908843994 seconds (Vfs.py:516) [Syncronization ][DEBUG ] Syncworker state 2 (Synchronization.py:648) [Syncronization ][INFO ] Synchronizing Wrapper: Files source (UID: FileSource-john@nzjrs-desktop) |--> Wrapper: foldersink twoway (UID: FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink) (Synchronization.py:467) [DeltaProvider ][INFO ] Delta: Source (FileSource-john@nzjrs-desktop) does not implement get_changes(). Proxying... (DeltaProvider.py:25) [DeltaProvider ][DEBUG ] Delta: Got 5 items [u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143'] (DeltaProvider.py:39) [DeltaProvider ][DEBUG ] Delta: Expecting 5 items (DeltaProvider.py:49) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143 (DataType.py:151) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: New 0 items [] (Synchronization.py:241) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: Modified 0 items [] (Synchronization.py:242) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: Deleted 0 items [] (Synchronization.py:243) [Syncronization ][DEBUG ] Syncworker state 3 (Synchronization.py:648) [Vfs ][DEBUG ] Folder scan 100.0% complete (Vfs.py:508) [Vfs ][DEBUG ] 5 files loaded in 0.00339579582214 seconds (Vfs.py:516) [Syncronization ][INFO ] Sync already in progress (Synchronization.py:172) [Syncronization ][INFO ] Waiting for thread to finish (Synchronization.py:124) [Syncronization ][DEBUG ] Created thread (thread: -1210525504) (Synchronization.py:211) [Syncronization ][INFO ] Setting global cancel flag (Synchronization.py:90) [Syncronization ][DEBUG ] Starting worker: [], initial)> (Synchronization.py:93) [Syncronization ][INFO ] Waiting for thread to finish (Synchronization.py:124) [Syncronization ][DEBUG ] Started thread [], started)> (thread: -1272095856) (Synchronization.py:624) [Syncronization ][DEBUG ] Sync [], started)> beginning. Slow: False, Twoway: False (Synchronization.py:629) [Syncronization ][DEBUG ] Syncworker state 0 (Synchronization.py:648) [Syncronization ][DEBUG ] Syncworker state 1 (Synchronization.py:648) [Syncronization ][DEBUG ] Source Status = Synchronizing... (Synchronization.py:677) [Vfs ][DEBUG ] Folder scan 100.0% complete (Vfs.py:508) [Vfs ][DEBUG ] 5 files loaded in 0.00283312797546 seconds (Vfs.py:516) [Syncronization ][DEBUG ] Syncworker state 2 (Synchronization.py:648) [Syncronization ][INFO ] Synchronizing Wrapper: Files source (UID: FileSource-john@nzjrs-desktop) |--> Wrapper: foldersink twoway (UID: FolderTwoWay-file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink) (Synchronization.py:467) [DeltaProvider ][INFO ] Delta: Source (FileSource-john@nzjrs-desktop) does not implement get_changes(). Proxying... (DeltaProvider.py:25) [DeltaProvider ][DEBUG ] Delta: Got 5 items [u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101', u'/home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143'] (DeltaProvider.py:39) [DeltaProvider ][DEBUG ] Delta: Expecting 5 items (DeltaProvider.py:49) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [DeltaProvider ][DEBUG ] /home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688) -- UID:/home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688 mtime:2008-08-03 14:44:55 hash:0 (DeltaProvider.py:51) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101 (DataType.py:151) [datatypes.DataType ][DEBUG ] Getting Rid for /home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143 (DataType.py:151) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: New 0 items [] (Synchronization.py:241) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: Modified 0 items [] (Synchronization.py:242) [Syncronization ][DEBUG ] FileSource-john@nzjrs-desktop Changes: Deleted 0 items [] (Synchronization.py:243) [Syncronization ][DEBUG ] Syncworker state 3 (Synchronization.py:648) [Vfs ][DEBUG ] Folder scan 100.0% complete (Vfs.py:508) [Vfs ][DEBUG ] 5 files loaded in 0.00339818000793 seconds (Vfs.py:516) [datatypes.File ][DEBUG ] Comparing file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/30688 (MTIME: 2008-08-03 14:44:55) with file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/30688 (MTIME: 2008-08-03 14:44:55) (File.py:472) [datatypes.File ][DEBUG ] Comparing file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/610813 (MTIME: 2008-08-03 14:44:55) with file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/610813 (MTIME: 2008-08-03 14:44:55) (File.py:472) [datatypes.File ][DEBUG ] Comparing file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/94725 (MTIME: 2008-08-03 14:44:55) with file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/94725 (MTIME: 2008-08-03 14:44:55) (File.py:472) [datatypes.File ][DEBUG ] Comparing file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/821101 (MTIME: 2008-08-03 14:44:55) with file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/821101 (MTIME: 2008-08-03 14:44:55) (File.py:472) [datatypes.File ][DEBUG ] Comparing file:///home/john/gnome-bzr/src/conduit/test/test-data/filesource/710143 (MTIME: 2008-08-03 14:44:55) with file:///home/john/gnome-bzr/src/conduit/test/test-data/foldersink/710143 (MTIME: 2008-08-03 14:44:55) (File.py:472)