"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestMoveWithoutDeleteEmptySrcDirs|TestSyncBackupDirWithSuffix)$'" - Starting (try 2/5) 2025/01/27 04:54:53 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-wicunuf5peku" 2025/01/27 04:54:53 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/01/27 04:54:54 DEBUG : Starting OpenDrive session with ID: 87a6c01fcb1b97f17e0f73bb6687444847468ece0efa26d1caa5706199eb306a 2025/01/27 04:54:54 DEBUG : Creating backend with remote "/tmp/rclone857649546" === RUN TestMoveWithDeleteEmptySrcDirs run.go:180: Remote "OpenDrive root 'rclone-test-wicunuf5peku'", Local "Local file system at /tmp/rclone857649546", Modify Window "1s" 2025/01/27 04:54:55 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/01/27 04:54:55 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/01/27 04:54:55 DEBUG : OpenDrive root 'rclone-test-wicunuf5peku': Waiting for checks to finish 2025/01/27 04:54:55 DEBUG : OpenDrive root 'rclone-test-wicunuf5peku': Waiting for transfers to finish 2025/01/27 04:54:56 DEBUG : nested/sub dir/file: Uploading chunk 0, size=6, remain=0 2025/01/27 04:54:57 DEBUG : sub dir/hello world: Uploading chunk 0, size=11, remain=0 2025/01/27 04:54:57 DEBUG : nested/sub dir/file: md5 = 83d3784ea62518eafc60e98d84f877ad OK 2025/01/27 04:54:57 INFO : nested/sub dir/file: Copied (new) 2025/01/27 04:54:57 INFO : nested/sub dir/file: Deleted 2025/01/27 04:54:58 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/01/27 04:54:58 INFO : sub dir/hello world: Copied (new) 2025/01/27 04:54:58 INFO : sub dir/hello world: Deleted 2025/01/27 04:54:58 INFO : sub dir: Removing directory 2025/01/27 04:54:58 INFO : nested/sub dir: Removing directory 2025/01/27 04:54:58 INFO : nested: Removing directory 2025/01/27 04:54:58 DEBUG : Local file system at /tmp/rclone857649546: deleted 3 directories run.go:180: Remote "OpenDrive root 'rclone-test-wicunuf5peku'", Local "Local file system at /tmp/rclone857649546", Modify Window "1s" --- PASS: TestMoveWithDeleteEmptySrcDirs (6.36s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:180: Remote "OpenDrive root 'rclone-test-wicunuf5peku'", Local "Local file system at /tmp/rclone857649546", Modify Window "1s" 2025/01/27 04:55:01 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/01/27 04:55:01 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2025/01/27 04:55:01 DEBUG : OpenDrive root 'rclone-test-wicunuf5peku': Waiting for checks to finish 2025/01/27 04:55:01 DEBUG : OpenDrive root 'rclone-test-wicunuf5peku': Waiting for transfers to finish 2025/01/27 04:55:02 DEBUG : sub dir/hello world: Uploading chunk 0, size=11, remain=0 2025/01/27 04:55:02 DEBUG : nested/sub dir/file: Uploading chunk 0, size=6, remain=0 2025/01/27 04:55:03 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/01/27 04:55:03 INFO : sub dir/hello world: Copied (new) 2025/01/27 04:55:03 INFO : sub dir/hello world: Deleted 2025/01/27 04:55:04 DEBUG : nested/sub dir/file: md5 = 83d3784ea62518eafc60e98d84f877ad OK 2025/01/27 04:55:04 INFO : nested/sub dir/file: Copied (new) 2025/01/27 04:55:04 INFO : nested/sub dir/file: Deleted run.go:180: Remote "OpenDrive root 'rclone-test-wicunuf5peku'", Local "Local file system at /tmp/rclone857649546", Modify Window "1s" --- PASS: TestMoveWithoutDeleteEmptySrcDirs (5.99s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "OpenDrive root 'rclone-test-wicunuf5peku'", Local "Local file system at /tmp/rclone857649546", Modify Window "1s" 2025/01/27 04:55:08 DEBUG : dst/one: Uploading chunk 0, size=3, remain=0 2025/01/27 04:55:10 DEBUG : dst/two: Uploading chunk 0, size=3, remain=0 2025/01/27 04:55:11 DEBUG : dst/three.txt: Uploading chunk 0, size=5, remain=0 2025/01/27 04:55:13 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-wicunuf5peku/dst" 2025/01/27 04:55:13 DEBUG : Starting OpenDrive session with ID: eeaac20f745872096c4c7f3a6cec359bba050fba77bef1c37eb909cf974074c9 2025/01/27 04:55:13 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-wicunuf5peku/backup" 2025/01/27 04:55:14 DEBUG : Starting OpenDrive session with ID: 822819a199398b2772b9bd79b041571d12256761c6ed3e965a0b96746a183ca4 2025/01/27 04:55:15 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/01/27 04:55:15 DEBUG : OpenDrive root 'rclone-test-wicunuf5peku/dst': Waiting for checks to finish 2025/01/27 04:55:15 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/01/27 04:55:15 DEBUG : two: Unchanged skipping 2025/01/27 04:55:16 INFO : one: Moved (server-side) to: one.bak 2025/01/27 04:55:16 DEBUG : OpenDrive root 'rclone-test-wicunuf5peku/dst': Waiting for transfers to finish 2025/01/27 04:55:17 DEBUG : one: Uploading chunk 0, size=4, remain=0 2025/01/27 04:55:17 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2025/01/27 04:55:17 INFO : one: Copied (new) 2025/01/27 04:55:17 DEBUG : Waiting for deletions to finish 2025/01/27 04:55:18 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/01/27 04:55:18 INFO : three.txt: Moved into backup dir 2025/01/27 04:55:19 DEBUG : dst/three.txt: Uploading chunk 0, size=6, remain=0 2025/01/27 04:55:21 DEBUG : OpenDrive root 'rclone-test-wicunuf5peku/dst': Waiting for checks to finish 2025/01/27 04:55:21 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/01/27 04:55:21 DEBUG : two: Size and modification time the same (differ by -499.999999ms, within tolerance 1s) 2025/01/27 04:55:21 DEBUG : two: Unchanged skipping 2025/01/27 04:55:21 INFO : one.bak: Deleted 2025/01/27 04:55:21 INFO : one: Moved (server-side) to: one.bak 2025/01/27 04:55:21 DEBUG : OpenDrive root 'rclone-test-wicunuf5peku/dst': Waiting for transfers to finish 2025/01/27 04:55:22 DEBUG : one: Uploading chunk 0, size=5, remain=0 2025/01/27 04:55:23 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2025/01/27 04:55:23 INFO : one: Copied (new) 2025/01/27 04:55:23 DEBUG : Waiting for deletions to finish 2025/01/27 04:55:23 INFO : three.txt.bak: Deleted 2025/01/27 04:55:24 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/01/27 04:55:24 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (19.72s) PASS 2025/01/27 04:55:26 DEBUG : OpenDrive root 'rclone-test-wicunuf5peku': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestMoveWithDeleteEmptySrcDirs|TestMoveWithoutDeleteEmptySrcDirs|TestSyncBackupDirWithSuffix)$'" - Finished OK in 33.333668023s (try 2/5)