"./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^TestCopyFileCopyDest$'" - Starting (try 2/5)
2025/09/10 03:16:30 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-womizic1nohi"
2025/09/10 03:16:30 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/09/10 03:16:31 DEBUG : Starting OpenDrive session with ID: ea5e1b99692ba111220dc8ddf5d55621f2a01acafb04d50284bda16421c22b65
2025/09/10 03:16:31 DEBUG : Creating backend with remote "/tmp/rclone3300962798"
=== RUN   TestCopyFileCopyDest
    run.go:180: Remote "OpenDrive root 'rclone-test-womizic1nohi'", Local "Local file system at /tmp/rclone3300962798", Modify Window "1s"
2025/09/10 03:16:31 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-womizic1nohi/dst"
2025/09/10 03:16:32 DEBUG : Starting OpenDrive session with ID: 767ad758c9378fdffb84a15684da632e651243ee19dcb5a1b104e32699771150
2025/09/10 03:16:32 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-womizic1nohi/CopyDest"
2025/09/10 03:16:33 DEBUG : Starting OpenDrive session with ID: 8a321da9ae9b7ec6c105cbd909b7adea0def21abe03d8cc7378d6d28b7941612
2025/09/10 03:16:33 DEBUG : one: Need to transfer - File not found at Destination
2025/09/10 03:16:35 DEBUG : one: Uploading chunk 0, size=3, remain=0
2025/09/10 03:16:36 DEBUG : one: md5 = f97c5d29941bfb1b2fdab0874906ab82 OK
2025/09/10 03:16:36 INFO  : one: Copied (new)
2025/09/10 03:16:37 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/09/10 03:16:38 DEBUG : one: Uploading chunk 0, size=5, remain=0
2025/09/10 03:16:39 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK
2025/09/10 03:16:39 INFO  : one: Copied (replaced existing)
2025/09/10 03:16:40 DEBUG : dst/one: Uploading chunk 0, size=3, remain=0
2025/09/10 03:16:42 DEBUG : CopyDest/one: Uploading chunk 0, size=5, remain=0
2025/09/10 03:16:44 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-womizic1nohi/BackupDir"
2025/09/10 03:16:44 DEBUG : Starting OpenDrive session with ID: 3de753f1e3c27867f81cc26691cef9c3c226ea12bac2fbde6e6758b159d9d3ad
2025/09/10 03:16:45 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/09/10 03:16:45 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/09/10 03:16:45 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/09/10 03:16:46 INFO  : one: Moved (server-side)
2025/09/10 03:16:47 DEBUG : one: Dst hash empty - aborting Src hash check
2025/09/10 03:16:47 INFO  : one: Copied (server-side copy)
2025/09/10 03:16:47 DEBUG : one: Destination found in --copy-dest, using server-side copy
2025/09/10 03:16:48 DEBUG : CopyDest/two: Uploading chunk 0, size=3, remain=0
2025/09/10 03:16:50 DEBUG : two: Need to transfer - File not found at Destination
2025/09/10 03:16:50 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/09/10 03:16:50 DEBUG : two: Dst hash empty - aborting Src hash check
2025/09/10 03:16:50 INFO  : two: Copied (server-side copy)
2025/09/10 03:16:50 DEBUG : two: Destination found in --copy-dest, using server-side copy
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:301: Flushing the directory cache
    fstest.go:292: Sleeping for 6s just to make sure
2025/09/10 03:16:58 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/09/10 03:16:58 DEBUG : two: Unchanged skipping
2025/09/10 03:17:00 DEBUG : CopyDest/three: Uploading chunk 0, size=5, remain=0
2025/09/10 03:17:01 DEBUG : three: Need to transfer - File not found at Destination
2025/09/10 03:17:01 DEBUG : three: Sizes differ (src 7 vs dst 5)
2025/09/10 03:17:01 DEBUG : three: Destination not found in --copy-dest
2025/09/10 03:17:02 DEBUG : three: Uploading chunk 0, size=7, remain=0
2025/09/10 03:17:03 DEBUG : three: md5 = 1bccb9dccb3e9f6a3f9d2a8bdb54b7f5 OK
2025/09/10 03:17:03 INFO  : three: Copied (new)
--- PASS: TestCopyFileCopyDest (35.50s)
PASS
2025/09/10 03:17:07 DEBUG : OpenDrive root 'rclone-test-womizic1nohi': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^TestCopyFileCopyDest$'" - Finished OK in 36.965893838s (try 2/5)