"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestMoveWithoutDeleteEmptySrcDirs|TestSyncWithUpdateOlder)$'" - Starting (try 2/5)
2025/04/25 02:22:07 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-xurepay9bexa"
2025/04/25 02:22:07 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/04/25 02:22:08 DEBUG : Starting OpenDrive session with ID: 8261d2f49c7d3cdc080e735634be846108e06f1d6c655175ca1d55614bc7736b
2025/04/25 02:22:08 DEBUG : Creating backend with remote "/tmp/rclone1449821996"
=== RUN   TestSyncWithUpdateOlder
    run.go:180: Remote "OpenDrive root 'rclone-test-xurepay9bexa'", Local "Local file system at /tmp/rclone1449821996", Modify Window "1s"
2025/04/25 02:22:09 DEBUG : one: Uploading chunk 0, size=3, remain=0
2025/04/25 02:22:11 DEBUG : two: Uploading chunk 0, size=3, remain=0
2025/04/25 02:22:13 DEBUG : three: Uploading chunk 0, size=5, remain=0
2025/04/25 02:22:15 DEBUG : four: Uploading chunk 0, size=8, remain=0
2025/04/25 02:22:16 DEBUG : five: Need to transfer - File not found at Destination
2025/04/25 02:22:16 DEBUG : four: Sizes differ (src 4 vs dst 8)
2025/04/25 02:22:16 DEBUG : one: Destination is newer than source, skipping
2025/04/25 02:22:16 DEBUG : three: Sizes identical
2025/04/25 02:22:16 DEBUG : OpenDrive root 'rclone-test-xurepay9bexa': Waiting for checks to finish
2025/04/25 02:22:16 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring
2025/04/25 02:22:16 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping
2025/04/25 02:22:16 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 (Local file system at /tmp/rclone1449821996)
2025/04/25 02:22:16 DEBUG : two: md5 = 0f82d86afa0f5dc965c5c15aca58dcfb (OpenDrive root 'rclone-test-xurepay9bexa')
2025/04/25 02:22:16 DEBUG : two: md5 differ
2025/04/25 02:22:16 DEBUG : OpenDrive root 'rclone-test-xurepay9bexa': Waiting for transfers to finish
2025/04/25 02:22:17 DEBUG : four: Uploading chunk 0, size=4, remain=0
2025/04/25 02:22:17 DEBUG : two: Uploading chunk 0, size=3, remain=0
2025/04/25 02:22:17 DEBUG : five: Uploading chunk 0, size=4, remain=0
2025/04/25 02:22:18 DEBUG : four: md5 = 8cbad96aced40b3838dd9f07f6ef5772 OK
2025/04/25 02:22:18 INFO  : four: Copied (replaced existing)
2025/04/25 02:22:18 DEBUG : five: md5 = 30056e1cab7a61d256fc8edd970d14f5 OK
2025/04/25 02:22:18 INFO  : five: Copied (new)
2025/04/25 02:22:18 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 OK
2025/04/25 02:22:18 INFO  : two: Copied (replaced existing)
2025/04/25 02:22:18 DEBUG : Waiting for deletions to finish
2025/04/25 02:22:19 DEBUG : one: Destination is newer than source, skipping
2025/04/25 02:22:19 DEBUG : OpenDrive root 'rclone-test-xurepay9bexa': Waiting for checks to finish
2025/04/25 02:22:19 DEBUG : five: md5 = 30056e1cab7a61d256fc8edd970d14f5 OK
2025/04/25 02:22:19 DEBUG : five: Size and md5 of src and dst objects identical
2025/04/25 02:22:19 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping
2025/04/25 02:22:19 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 OK
2025/04/25 02:22:19 DEBUG : two: Size and md5 of src and dst objects identical
2025/04/25 02:22:19 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping
2025/04/25 02:22:19 DEBUG : three: md5 = 35d6d33467aae9a2e3dccb4b6b027878 (Local file system at /tmp/rclone1449821996)
2025/04/25 02:22:19 DEBUG : three: md5 = 413af0de1f97a2155acf2b8b26ab36e2 (OpenDrive root 'rclone-test-xurepay9bexa')
2025/04/25 02:22:19 DEBUG : three: md5 differ
2025/04/25 02:22:19 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring
2025/04/25 02:22:19 DEBUG : four: md5 = 8cbad96aced40b3838dd9f07f6ef5772 OK
2025/04/25 02:22:19 DEBUG : four: Size and md5 of src and dst objects identical
2025/04/25 02:22:19 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping
2025/04/25 02:22:19 DEBUG : OpenDrive root 'rclone-test-xurepay9bexa': Waiting for transfers to finish
2025/04/25 02:22:19 DEBUG : three: Uploading chunk 0, size=5, remain=0
2025/04/25 02:22:20 DEBUG : three: md5 = 35d6d33467aae9a2e3dccb4b6b027878 OK
2025/04/25 02:22:20 INFO  : three: Copied (replaced existing)
2025/04/25 02:22:20 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncWithUpdateOlder (13.30s)
=== RUN   TestMoveWithoutDeleteEmptySrcDirs
    run.go:180: Remote "OpenDrive root 'rclone-test-xurepay9bexa'", Local "Local file system at /tmp/rclone1449821996", Modify Window "1s"
2025/04/25 02:22:22 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/04/25 02:22:22 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination
2025/04/25 02:22:22 DEBUG : OpenDrive root 'rclone-test-xurepay9bexa': Waiting for checks to finish
2025/04/25 02:22:22 DEBUG : OpenDrive root 'rclone-test-xurepay9bexa': Waiting for transfers to finish
2025/04/25 02:22:23 DEBUG : sub dir/hello world: Uploading chunk 0, size=11, remain=0
2025/04/25 02:22:23 DEBUG : nested/sub dir/file: Uploading chunk 0, size=6, remain=0
2025/04/25 02:22:24 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2025/04/25 02:22:24 INFO  : sub dir/hello world: Copied (new)
2025/04/25 02:22:24 INFO  : sub dir/hello world: Deleted
2025/04/25 02:22:25 DEBUG : nested/sub dir/file: md5 = 83d3784ea62518eafc60e98d84f877ad OK
2025/04/25 02:22:25 INFO  : nested/sub dir/file: Copied (new)
2025/04/25 02:22:25 INFO  : nested/sub dir/file: Deleted
    run.go:180: Remote "OpenDrive root 'rclone-test-xurepay9bexa'", Local "Local file system at /tmp/rclone1449821996", Modify Window "1s"
--- PASS: TestMoveWithoutDeleteEmptySrcDirs (6.21s)
PASS
2025/04/25 02:22:28 DEBUG : OpenDrive root 'rclone-test-xurepay9bexa': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestMoveWithoutDeleteEmptySrcDirs|TestSyncWithUpdateOlder)$'" - Finished OK in 21.009642547s (try 2/5)