[modules.iPod ][INFO ] Module Information: gpod v(0, 6, 0) (/usr/lib/python2.5/site-packages/gpod/__init__.pyc) (iPodModule.py:45) [modules.AVConverter ][INFO ] Module Information: gst v(0, 10, 13) (/usr/lib/python2.5/site-packages/gst-0.10/gst/__init__.pyc) (AudioVideoConverterModule.py:23) [modules.Google ][INFO ] Module Information: gdata (/home/john/testing/conduit/conduit/modules/GoogleModule/gdata/__init__.pyc) (GoogleModule.py:45) [modules.Feed ][INFO ] Module Information: feedparser v4.1 (/var/lib/python-support/python2.5/feedparser.pyc) (FeedModule.py:21) [modules.Feed ][INFO ] Patching feedparser issue #100 (FeedModule.py:27) [modules.Flickr ][INFO ] Module Information: flickrapi v1.1 (/home/john/testing/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.Backpack ][INFO ] Module Information: backpack (/home/john/testing/conduit/conduit/modules/BackpackModule/backpack/backpack.pyc) (BackpackModule.py:22) [modules.iPod ][INFO ] Module Information: gpod v(0, 6, 0) (/usr/lib/python2.5/site-packages/gpod/__init__.pyc) (iPodModule.py:45) [modules.Facebook ][INFO ] Module Information: pyfacebook v0.1 (/home/john/testing/conduit/conduit/modules/FacebookModule/pyfacebook/__init__.pyc) (FacebookModule.py:30) [modules.Facebook ][INFO ] Facebook parsing using: JSON (simplejson) (FacebookModule.py:31) [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) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [Conduit ][DEBUG ] Adding twoway dataprovider into source position (Conduit.py:140) [Conduit ][DEBUG ] Adding twoway dataprovider into sink position (Conduit.py:146) [Syncronization ][DEBUG ] Created thread (thread: -1209640768) (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: -1262724208) (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 = Ready (Synchronization.py:677) [platform.FileGio ][DEBUG ] Folder scan 100.0% complete (FileGio.py:372) [platform.FileGio ][DEBUG ] 1 files loaded (FileGio.py:379) [platform.FileGio ][DEBUG ] 0 files loaded (FileGio.py:379) [Syncronization ][DEBUG ] Syncworker state 2 (Synchronization.py:648) [Syncronization ][INFO ] Synchronizing Wrapper: tmptC3HhW twoway (UID: FolderTwoWay-file:///tmp/tmptC3HhW) |--> Wrapper: tmpL6Y7WI twoway (UID: FolderTwoWay-file:///tmp/tmpL6Y7WI) (Synchronization.py:467) [DeltaProvider ][INFO ] Delta: Source (FolderTwoWay-file:///tmp/tmptC3HhW) does not implement get_changes(). Proxying... (DeltaProvider.py:25) [DeltaProvider ][DEBUG ] Delta: Got 1 items [u'file:///tmp/tmptC3HhW/testfile'] (DeltaProvider.py:39) [DeltaProvider ][DEBUG ] Delta: Expecting 0 items (DeltaProvider.py:49) [Syncronization ][DEBUG ] FolderTwoWay-file:///tmp/tmptC3HhW Changes: New 1 items [u'file:///tmp/tmptC3HhW/testfile'] (Synchronization.py:241) [Syncronization ][DEBUG ] FolderTwoWay-file:///tmp/tmptC3HhW Changes: Modified 0 items [] (Synchronization.py:242) [Syncronization ][DEBUG ] FolderTwoWay-file:///tmp/tmptC3HhW Changes: Deleted 0 items [] (Synchronization.py:243) [Syncronization ][DEBUG ] 1WAY PUT: Folder (file:///tmp/tmptC3HhW/testfile) -----> Folder (Synchronization.py:489) [datatypes.DataType ][DEBUG ] Getting Rid for file:///tmp/tmptC3HhW/testfile (DataType.py:158) [TypeConverter ][DEBUG ] Convert file -> file using [('file', 'file', {})] (TypeConverter.py:209) [TypeConverter ][DEBUG ] Skipping file -> file (TypeConverter.py:168) [datatypes.File ][DEBUG ] Defering new mtime till transfer (New mtime: 2009-02-13 18:36:42) (File.py:93) [Syncronization ][INFO ] Putting data file:///tmp/tmptC3HhW/testfile --> None into FolderTwoWay-file:///tmp/tmpL6Y7WI (Synchronization.py:37) [dataproviders.File ][DEBUG ] Relative path: testfile (File.py:290) [dataproviders.File ][DEBUG ] Found corresponding group (File.py:292) [platform.FileGio ][DEBUG ] Transfering File file:///tmp/tmptC3HhW/testfile -> file:///tmp/tmpL6Y7WI/testfile (overwrite: False) (FileGio.py:246) [datatypes.File ][DEBUG ] Clearing pending mtime (File.py:68) [datatypes.DataType ][DEBUG ] Getting Rid for file:///tmp/tmpL6Y7WI/testfile (DataType.py:158) [Syncronization ][DEBUG ] Syncworker state 3 (Synchronization.py:648) [platform.FileGio ][DEBUG ] Folder scan 100.0% complete (FileGio.py:372) [platform.FileGio ][DEBUG ] 1 files loaded (FileGio.py:379) [platform.FileGio ][DEBUG ] Folder scan 100.0% complete (FileGio.py:372) [platform.FileGio ][DEBUG ] 1 files loaded (FileGio.py:379) [Syncronization ][INFO ] Sync already in progress (Synchronization.py:172) [Syncronization ][INFO ] Waiting for thread to finish (Synchronization.py:124) [Syncronization ][DEBUG ] Created thread (thread: -1209640768) (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: -1262724208) (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) [platform.FileGio ][DEBUG ] Folder scan 100.0% complete (FileGio.py:372) [platform.FileGio ][DEBUG ] 1 files loaded (FileGio.py:379) [platform.FileGio ][DEBUG ] Folder scan 100.0% complete (FileGio.py:372) [platform.FileGio ][DEBUG ] 1 files loaded (FileGio.py:379) [Syncronization ][DEBUG ] Syncworker state 2 (Synchronization.py:648) [Syncronization ][INFO ] Synchronizing Wrapper: tmptC3HhW twoway (UID: FolderTwoWay-file:///tmp/tmptC3HhW) |--> Wrapper: tmpL6Y7WI twoway (UID: FolderTwoWay-file:///tmp/tmpL6Y7WI) (Synchronization.py:467) [DeltaProvider ][INFO ] Delta: Source (FolderTwoWay-file:///tmp/tmptC3HhW) does not implement get_changes(). Proxying... (DeltaProvider.py:25) [DeltaProvider ][DEBUG ] Delta: Got 1 items [u'file:///tmp/tmptC3HhW/testfile'] (DeltaProvider.py:39) [DeltaProvider ][DEBUG ] Delta: Expecting 1 items (DeltaProvider.py:49) [DeltaProvider ][DEBUG ] file:///tmp/tmptC3HhW/testfile) -- UID:file:///tmp/tmptC3HhW/testfile mtime:2009-02-13 18:36:42 hash:-2123892116 (DeltaProvider.py:51) [datatypes.DataType ][DEBUG ] Getting Rid for file:///tmp/tmptC3HhW/testfile (DataType.py:158) [datatypes.DataType ][DEBUG ] Getting Rid for file:///tmp/tmptC3HhW/testfile (DataType.py:158) [DeltaProvider ][DEBUG ] Modified: Actual:UID:file:///tmp/tmptC3HhW/testfile mtime:2009-02-13 18:36:44 hash:-2117892098 v DB:UID:file:///tmp/tmptC3HhW/testfile mtime:2009-02-13 18:36:42 hash:-2123892116 (DeltaProvider.py:61) [Syncronization ][DEBUG ] FolderTwoWay-file:///tmp/tmptC3HhW Changes: New 0 items [] (Synchronization.py:241) [Syncronization ][DEBUG ] FolderTwoWay-file:///tmp/tmptC3HhW Changes: Modified 1 items [u'file:///tmp/tmptC3HhW/testfile'] (Synchronization.py:242) [Syncronization ][DEBUG ] FolderTwoWay-file:///tmp/tmptC3HhW Changes: Deleted 0 items [] (Synchronization.py:243) [Syncronization ][DEBUG ] 1WAY PUT: Folder (file:///tmp/tmptC3HhW/testfile) -----> Folder (Synchronization.py:489) [datatypes.DataType ][DEBUG ] Getting Rid for file:///tmp/tmptC3HhW/testfile (DataType.py:158) [TypeConverter ][DEBUG ] Convert file -> file using [('file', 'file', {})] (TypeConverter.py:209) [TypeConverter ][DEBUG ] Skipping file -> file (TypeConverter.py:168) [datatypes.File ][DEBUG ] Defering new mtime till transfer (New mtime: 2009-02-13 18:36:44) (File.py:93) [Syncronization ][INFO ] Putting data file:///tmp/tmptC3HhW/testfile --> file:///tmp/tmpL6Y7WI/testfile into FolderTwoWay-file:///tmp/tmpL6Y7WI (Synchronization.py:37) [datatypes.File ][DEBUG ] Comparing file:///tmp/tmptC3HhW/testfile (MTIME: 2009-02-13 18:36:44) with file:///tmp/tmpL6Y7WI/testfile (MTIME: 2009-02-13 18:36:42) (File.py:398) [platform.FileGio ][DEBUG ] Transfering File file:///tmp/tmptC3HhW/testfile -> file:///tmp/tmpL6Y7WI/testfile (overwrite: True) (FileGio.py:246) [datatypes.File ][DEBUG ] Clearing pending mtime (File.py:68) [datatypes.DataType ][DEBUG ] Getting Rid for file:///tmp/tmpL6Y7WI/testfile (DataType.py:158) [Syncronization ][DEBUG ] Syncworker state 3 (Synchronization.py:648) [platform.FileGio ][DEBUG ] Folder scan 100.0% complete (FileGio.py:372) [platform.FileGio ][DEBUG ] 1 files loaded (FileGio.py:379) [platform.FileGio ][DEBUG ] Folder scan 100.0% complete (FileGio.py:372) [platform.FileGio ][DEBUG ] 1 files loaded (FileGio.py:379) [modules.AVConverter ][INFO ] Module Information: gst v(0, 10, 13) (/usr/lib/python2.5/site-packages/gst-0.10/gst/__init__.pyc) (AudioVideoConverterModule.py:23) [modules.Google ][INFO ] Module Information: gdata (/home/john/testing/conduit/conduit/modules/GoogleModule/gdata/__init__.pyc) (GoogleModule.py:45) [modules.Feed ][INFO ] Module Information: feedparser v4.1 (/var/lib/python-support/python2.5/feedparser.pyc) (FeedModule.py:21) [modules.Feed ][INFO ] Patching feedparser issue #100 (FeedModule.py:27) [modules.Flickr ][INFO ] Module Information: flickrapi v1.1 (/home/john/testing/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.Backpack ][INFO ] Module Information: backpack (/home/john/testing/conduit/conduit/modules/BackpackModule/backpack/backpack.pyc) (BackpackModule.py:22) [modules.iPod ][INFO ] Module Information: gpod v(0, 6, 0) (/usr/lib/python2.5/site-packages/gpod/__init__.pyc) (iPodModule.py:45) [modules.Facebook ][INFO ] Module Information: pyfacebook v0.1 (/home/john/testing/conduit/conduit/modules/FacebookModule/pyfacebook/__init__.pyc) (FacebookModule.py:30) [modules.Facebook ][INFO ] Facebook parsing using: JSON (simplejson) (FacebookModule.py:31) [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) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [Conduit ][DEBUG ] Adding twoway dataprovider into source position (Conduit.py:140) [Conduit ][DEBUG ] Adding twoway dataprovider into sink position (Conduit.py:146) [Syncronization ][DEBUG ] Created thread (thread: -1209640768) (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: -1271116912) (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 = Ready (Synchronization.py:677) [platform.FileGio ][DEBUG ] Folder scan 100.0% complete (FileGio.py:372) [platform.FileGio ][DEBUG ] 1 files loaded (FileGio.py:379) [platform.FileGio ][DEBUG ] Folder scan 100.0% complete (FileGio.py:372) [platform.FileGio ][DEBUG ] 1 files loaded (FileGio.py:379) [Syncronization ][DEBUG ] Syncworker state 2 (Synchronization.py:648) [Syncronization ][INFO ] Synchronizing Wrapper: tmpmm_hc8 twoway (UID: FolderTwoWay-file:///tmp/tmpmm_hc8) |--> Wrapper: tmpkdKiLs twoway (UID: FolderTwoWay-file:///tmp/tmpkdKiLs) (Synchronization.py:467) [DeltaProvider ][INFO ] Delta: Source (FolderTwoWay-file:///tmp/tmpmm_hc8) does not implement get_changes(). Proxying... (DeltaProvider.py:25) [DeltaProvider ][DEBUG ] Delta: Got 1 items [u'file:///tmp/tmpmm_hc8/testfile'] (DeltaProvider.py:39) [DeltaProvider ][DEBUG ] Delta: Expecting 0 items (DeltaProvider.py:49) [Syncronization ][DEBUG ] FolderTwoWay-file:///tmp/tmpmm_hc8 Changes: New 1 items [u'file:///tmp/tmpmm_hc8/testfile'] (Synchronization.py:241) [Syncronization ][DEBUG ] FolderTwoWay-file:///tmp/tmpmm_hc8 Changes: Modified 0 items [] (Synchronization.py:242) [Syncronization ][DEBUG ] FolderTwoWay-file:///tmp/tmpmm_hc8 Changes: Deleted 0 items [] (Synchronization.py:243) [Syncronization ][DEBUG ] 1WAY PUT: Folder (file:///tmp/tmpmm_hc8/testfile) -----> Folder (Synchronization.py:489) [datatypes.DataType ][DEBUG ] Getting Rid for file:///tmp/tmpmm_hc8/testfile (DataType.py:158) [TypeConverter ][DEBUG ] Convert file -> file using [('file', 'file', {})] (TypeConverter.py:209) [TypeConverter ][DEBUG ] Skipping file -> file (TypeConverter.py:168) [datatypes.File ][DEBUG ] Defering new mtime till transfer (New mtime: 2009-02-13 18:36:46) (File.py:93) [Syncronization ][INFO ] Putting data file:///tmp/tmpmm_hc8/testfile --> None into FolderTwoWay-file:///tmp/tmpkdKiLs (Synchronization.py:37) [dataproviders.File ][DEBUG ] Relative path: testfile (File.py:290) [dataproviders.File ][DEBUG ] Found corresponding group (File.py:292) [datatypes.File ][DEBUG ] Comparing file:///tmp/tmpmm_hc8/testfile (MTIME: 2009-02-13 18:36:46) with file:///tmp/tmpkdKiLs/testfile (MTIME: 2009-02-13 18:36:48) (File.py:398) [datatypes.DataType ][DEBUG ] Getting Rid for None (DataType.py:158) [Syncronization ][DEBUG ] Conflict Policy: Ask (Synchronization.py:421) [Syncronization ][DEBUG ] Syncworker state 3 (Synchronization.py:648) [platform.FileGio ][DEBUG ] Folder scan 100.0% complete (FileGio.py:372) [platform.FileGio ][DEBUG ] 1 files loaded (FileGio.py:379) [platform.FileGio ][DEBUG ] Folder scan 100.0% complete (FileGio.py:372) [platform.FileGio ][DEBUG ] 1 files loaded (FileGio.py:379) [modules.AVConverter ][INFO ] Module Information: gst v(0, 10, 13) (/usr/lib/python2.5/site-packages/gst-0.10/gst/__init__.pyc) (AudioVideoConverterModule.py:23) [modules.Google ][INFO ] Module Information: gdata (/home/john/testing/conduit/conduit/modules/GoogleModule/gdata/__init__.pyc) (GoogleModule.py:45) [modules.Feed ][INFO ] Module Information: feedparser v4.1 (/var/lib/python-support/python2.5/feedparser.pyc) (FeedModule.py:21) [modules.Feed ][INFO ] Patching feedparser issue #100 (FeedModule.py:27) [modules.Flickr ][INFO ] Module Information: flickrapi v1.1 (/home/john/testing/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.Backpack ][INFO ] Module Information: backpack (/home/john/testing/conduit/conduit/modules/BackpackModule/backpack/backpack.pyc) (BackpackModule.py:22) [modules.iPod ][INFO ] Module Information: gpod v(0, 6, 0) (/usr/lib/python2.5/site-packages/gpod/__init__.pyc) (iPodModule.py:45) [modules.Facebook ][INFO ] Module Information: pyfacebook v0.1 (/home/john/testing/conduit/conduit/modules/FacebookModule/pyfacebook/__init__.pyc) (FacebookModule.py:30) [modules.Facebook ][INFO ] Facebook parsing using: JSON (simplejson) (FacebookModule.py:31) [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) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [Conduit ][DEBUG ] Adding twoway dataprovider into source position (Conduit.py:140) [Conduit ][DEBUG ] Adding twoway dataprovider into sink position (Conduit.py:146) [datatypes.File ][DEBUG ] Comparing file:///tmp/tmpc7ycw8/testfile (SIZE: 3) with file:///tmp/tmpAyDFP3/testfile (SIZE: 7) (File.py:387) [datatypes.File ][DEBUG ] Comparing file:///tmp/tmpc7ycw8/testfile (MTIME: 2009-02-13 18:36:50) with file:///tmp/tmpAyDFP3/testfile (MTIME: 2009-02-13 18:36:50) (File.py:398) [datatypes.File ][WARNING ] Error comparing file sizes (File.py:423) [Syncronization ][DEBUG ] Created thread (thread: -1209640768) (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: -1271116912) (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 = Ready (Synchronization.py:677) [platform.FileGio ][DEBUG ] Folder scan 100.0% complete (FileGio.py:372) [platform.FileGio ][DEBUG ] 1 files loaded (FileGio.py:379) [platform.FileGio ][DEBUG ] Folder scan 100.0% complete (FileGio.py:372) [platform.FileGio ][DEBUG ] 1 files loaded (FileGio.py:379) [Syncronization ][DEBUG ] Syncworker state 2 (Synchronization.py:648) [Syncronization ][INFO ] Synchronizing Wrapper: tmpc7ycw8 twoway (UID: FolderTwoWay-file:///tmp/tmpc7ycw8) |--> Wrapper: tmpAyDFP3 twoway (UID: FolderTwoWay-file:///tmp/tmpAyDFP3) (Synchronization.py:467) [DeltaProvider ][INFO ] Delta: Source (FolderTwoWay-file:///tmp/tmpc7ycw8) does not implement get_changes(). Proxying... (DeltaProvider.py:25) [DeltaProvider ][DEBUG ] Delta: Got 1 items [u'file:///tmp/tmpc7ycw8/testfile'] (DeltaProvider.py:39) [DeltaProvider ][DEBUG ] Delta: Expecting 0 items (DeltaProvider.py:49) [Syncronization ][DEBUG ] FolderTwoWay-file:///tmp/tmpc7ycw8 Changes: New 1 items [u'file:///tmp/tmpc7ycw8/testfile'] (Synchronization.py:241) [Syncronization ][DEBUG ] FolderTwoWay-file:///tmp/tmpc7ycw8 Changes: Modified 0 items [] (Synchronization.py:242) [Syncronization ][DEBUG ] FolderTwoWay-file:///tmp/tmpc7ycw8 Changes: Deleted 0 items [] (Synchronization.py:243) [Syncronization ][DEBUG ] 1WAY PUT: Folder (file:///tmp/tmpc7ycw8/testfile) -----> Folder (Synchronization.py:489) [datatypes.DataType ][DEBUG ] Getting Rid for file:///tmp/tmpc7ycw8/testfile (DataType.py:158) [TypeConverter ][DEBUG ] Convert file -> file using [('file', 'file', {})] (TypeConverter.py:209) [TypeConverter ][DEBUG ] Skipping file -> file (TypeConverter.py:168) [datatypes.File ][DEBUG ] Defering new mtime till transfer (New mtime: 2009-02-13 18:36:50) (File.py:93) [Syncronization ][INFO ] Putting data file:///tmp/tmpc7ycw8/testfile --> None into FolderTwoWay-file:///tmp/tmpAyDFP3 (Synchronization.py:37) [dataproviders.File ][DEBUG ] Relative path: testfile (File.py:290) [dataproviders.File ][DEBUG ] Found corresponding group (File.py:292) [datatypes.File ][DEBUG ] Comparing file:///tmp/tmpc7ycw8/testfile (MTIME: 2009-02-13 18:36:50) with file:///tmp/tmpAyDFP3/testfile (MTIME: 2009-02-13 18:36:50) (File.py:398) [datatypes.File ][WARNING ] Error comparing file sizes (File.py:423) [datatypes.DataType ][DEBUG ] Getting Rid for None (DataType.py:158) [Syncronization ][DEBUG ] Conflict Policy: Ask (Synchronization.py:421) [Syncronization ][DEBUG ] Syncworker state 3 (Synchronization.py:648) [platform.FileGio ][DEBUG ] Folder scan 100.0% complete (FileGio.py:372) [platform.FileGio ][DEBUG ] 1 files loaded (FileGio.py:379) [platform.FileGio ][DEBUG ] Folder scan 100.0% complete (FileGio.py:372) [platform.FileGio ][DEBUG ] 1 files loaded (FileGio.py:379) [modules.AVConverter ][INFO ] Module Information: gst v(0, 10, 13) (/usr/lib/python2.5/site-packages/gst-0.10/gst/__init__.pyc) (AudioVideoConverterModule.py:23) [modules.Google ][INFO ] Module Information: gdata (/home/john/testing/conduit/conduit/modules/GoogleModule/gdata/__init__.pyc) (GoogleModule.py:45) [modules.Feed ][INFO ] Module Information: feedparser v4.1 (/var/lib/python-support/python2.5/feedparser.pyc) (FeedModule.py:21) [modules.Feed ][INFO ] Patching feedparser issue #100 (FeedModule.py:27) [modules.Flickr ][INFO ] Module Information: flickrapi v1.1 (/home/john/testing/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.Backpack ][INFO ] Module Information: backpack (/home/john/testing/conduit/conduit/modules/BackpackModule/backpack/backpack.pyc) (BackpackModule.py:22) [modules.iPod ][INFO ] Module Information: gpod v(0, 6, 0) (/usr/lib/python2.5/site-packages/gpod/__init__.pyc) (iPodModule.py:45) [modules.Facebook ][INFO ] Module Information: pyfacebook v0.1 (/home/john/testing/conduit/conduit/modules/FacebookModule/pyfacebook/__init__.pyc) (FacebookModule.py:30) [modules.Facebook ][INFO ] Facebook parsing using: JSON (simplejson) (FacebookModule.py:31) [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) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [dataproviders.VolumeFactory][INFO ] Waiting for HAL to attempt mount (VolumeFactory.py:38) [Conduit ][DEBUG ] Adding twoway dataprovider into source position (Conduit.py:140) [Conduit ][DEBUG ] Adding twoway dataprovider into sink position (Conduit.py:146) [datatypes.File ][DEBUG ] Comparing file:///tmp/tmpBZujw-/testfile (SIZE: 3) with file:///tmp/tmpj3FR2I/testfile (SIZE: 3) (File.py:387) [datatypes.File ][DEBUG ] Comparing file:///tmp/tmpBZujw-/testfile (MTIME: 2009-02-13 18:36:51) with file:///tmp/tmpj3FR2I/testfile (MTIME: 2009-02-13 18:36:51) (File.py:398) [Syncronization ][DEBUG ] Created thread (thread: -1209640768) (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: -1287902320) (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 = Ready (Synchronization.py:677) [platform.FileGio ][DEBUG ] Folder scan 100.0% complete (FileGio.py:372) [platform.FileGio ][DEBUG ] 1 files loaded (FileGio.py:379) [platform.FileGio ][DEBUG ] Folder scan 100.0% complete (FileGio.py:372) [platform.FileGio ][DEBUG ] 1 files loaded (FileGio.py:379) [Syncronization ][DEBUG ] Syncworker state 2 (Synchronization.py:648) [Syncronization ][INFO ] Synchronizing Wrapper: tmpBZujw- twoway (UID: FolderTwoWay-file:///tmp/tmpBZujw-) |--> Wrapper: tmpj3FR2I twoway (UID: FolderTwoWay-file:///tmp/tmpj3FR2I) (Synchronization.py:467) [DeltaProvider ][INFO ] Delta: Source (FolderTwoWay-file:///tmp/tmpBZujw-) does not implement get_changes(). Proxying... (DeltaProvider.py:25) [DeltaProvider ][DEBUG ] Delta: Got 1 items [u'file:///tmp/tmpBZujw-/testfile'] (DeltaProvider.py:39) [DeltaProvider ][DEBUG ] Delta: Expecting 0 items (DeltaProvider.py:49) [Syncronization ][DEBUG ] FolderTwoWay-file:///tmp/tmpBZujw- Changes: New 1 items [u'file:///tmp/tmpBZujw-/testfile'] (Synchronization.py:241) [Syncronization ][DEBUG ] FolderTwoWay-file:///tmp/tmpBZujw- Changes: Modified 0 items [] (Synchronization.py:242) [Syncronization ][DEBUG ] FolderTwoWay-file:///tmp/tmpBZujw- Changes: Deleted 0 items [] (Synchronization.py:243) [Syncronization ][DEBUG ] 1WAY PUT: Folder (file:///tmp/tmpBZujw-/testfile) -----> Folder (Synchronization.py:489) [datatypes.DataType ][DEBUG ] Getting Rid for file:///tmp/tmpBZujw-/testfile (DataType.py:158) [TypeConverter ][DEBUG ] Convert file -> file using [('file', 'file', {})] (TypeConverter.py:209) [TypeConverter ][DEBUG ] Skipping file -> file (TypeConverter.py:168) [datatypes.File ][DEBUG ] Defering new mtime till transfer (New mtime: 2009-02-13 18:36:51) (File.py:93) [Syncronization ][INFO ] Putting data file:///tmp/tmpBZujw-/testfile --> None into FolderTwoWay-file:///tmp/tmpj3FR2I (Synchronization.py:37) [dataproviders.File ][DEBUG ] Relative path: testfile (File.py:290) [dataproviders.File ][DEBUG ] Found corresponding group (File.py:292) [datatypes.File ][DEBUG ] Comparing file:///tmp/tmpBZujw-/testfile (MTIME: 2009-02-13 18:36:51) with file:///tmp/tmpj3FR2I/testfile (MTIME: 2009-02-13 18:36:51) (File.py:398) [datatypes.DataType ][DEBUG ] Getting Rid for file:///tmp/tmpj3FR2I/testfile (DataType.py:158) [Syncronization ][DEBUG ] Syncworker state 3 (Synchronization.py:648) [platform.FileGio ][DEBUG ] Folder scan 100.0% complete (FileGio.py:372) [platform.FileGio ][DEBUG ] 1 files loaded (FileGio.py:379) [platform.FileGio ][DEBUG ] Folder scan 100.0% complete (FileGio.py:372) [platform.FileGio ][DEBUG ] 1 files loaded (FileGio.py:379)