"./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCopyFileCompareDest|TestRemoveExisting)$'" - Starting (try 2/5)
2025/10/09 04:44:47 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-qubuyuc2dixi"
2025/10/09 04:44:47 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/10/09 04:44:48 DEBUG : Starting OpenDrive session with ID: 473ccbe08fc95492967dc5face1566cb20f104e8f144ed50b59e0476804a11d0
2025/10/09 04:44:48 DEBUG : Creating backend with remote "/tmp/rclone154906158"
=== RUN   TestCopyFileCompareDest
    run.go:180: Remote "OpenDrive root 'rclone-test-qubuyuc2dixi'", Local "Local file system at /tmp/rclone154906158", Modify Window "1s"
2025/10/09 04:44:48 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-qubuyuc2dixi/dst"
2025/10/09 04:44:48 DEBUG : Starting OpenDrive session with ID: 894ea611bb61ec57892c107c860eb549551912abc461d8967f38c160694a3e3d
2025/10/09 04:44:49 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-qubuyuc2dixi/CompareDest"
2025/10/09 04:44:49 DEBUG : Starting OpenDrive session with ID: a49b3cdbc09c96691c1fa8c929c45f72b613ace28786949b40fb6c411561494b
2025/10/09 04:44:50 DEBUG : one: Need to transfer - File not found at Destination
2025/10/09 04:44:52 DEBUG : one: Uploading chunk 0, size=3, remain=0
2025/10/09 04:44:52 DEBUG : one: md5 = f97c5d29941bfb1b2fdab0874906ab82 OK
2025/10/09 04:44:52 INFO  : one: Copied (new)
2025/10/09 04:44:54 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/10/09 04:44:54 DEBUG : one: Uploading chunk 0, size=5, remain=0
2025/10/09 04:44:55 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK
2025/10/09 04:44:55 INFO  : one: Copied (replaced existing)
2025/10/09 04:44:56 DEBUG : dst/one: Uploading chunk 0, size=3, remain=0
2025/10/09 04:44:58 DEBUG : CompareDest/one: Uploading chunk 0, size=5, remain=0
2025/10/09 04:45:00 DEBUG : one: Sizes differ (src 5 vs dst 3)
2025/10/09 04:45:00 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/10/09 04:45:00 DEBUG : one: Destination found in --compare-dest, skipping
2025/10/09 04:45:01 DEBUG : CompareDest/two: Uploading chunk 0, size=3, remain=0
2025/10/09 04:45:03 DEBUG : two: Need to transfer - File not found at Destination
2025/10/09 04:45:03 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/10/09 04:45:03 DEBUG : two: Destination found in --compare-dest, skipping
2025/10/09 04:45:03 DEBUG : two: Need to transfer - File not found at Destination
2025/10/09 04:45:03 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2025/10/09 04:45:03 DEBUG : two: Destination found in --compare-dest, skipping
2025/10/09 04:45:04 DEBUG : two: Need to transfer - File not found at Destination
2025/10/09 04:45:05 DEBUG : two: Sizes differ (src 5 vs dst 3)
2025/10/09 04:45:05 DEBUG : two: Uploading chunk 0, size=5, remain=0
2025/10/09 04:45:06 DEBUG : two: md5 = 2379e4ce8c3380e996ab0509f17069ad OK
2025/10/09 04:45:06 INFO  : two: Copied (new)
--- PASS: TestCopyFileCompareDest (20.59s)
=== RUN   TestRemoveExisting
    run.go:180: Remote "OpenDrive root 'rclone-test-qubuyuc2dixi'", Local "Local file system at /tmp/rclone154906158", Modify Window "1s"
2025/10/09 04:45:10 DEBUG : sub dir/test remove existing: Uploading chunk 0, size=11, remain=0
2025/10/09 04:45:12 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: Uploading chunk 0, size=21, remain=0
2025/10/09 04:45:14 DEBUG : sub dir/test remove existing: TEST: renaming existing object to "sub dir/test remove existing.kabuvey0" before starting
2025/10/09 04:45:14 DEBUG : sub dir/test remove existing: same parent dir (ODFfOTQ3MjcxN185enBmeQ) - using file/rename instead of move_copy for sub dir/test remove existing.kabuvey0
2025/10/09 04:45:15 DEBUG : sub dir/test remove existing.kabuvey0: TEST: removing renamed existing file after operation
2025/10/09 04:45:15 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: TEST: renaming existing object to "sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.jozahuv6" before starting
2025/10/09 04:45:15 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: same parent dir (ODFfOTQ3MjcxN185enBmeQ) - using file/rename instead of move_copy for sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.jozahuv6
2025/10/09 04:45:16 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.jozahuv6: TEST: renaming existing back after failed operation
2025/10/09 04:45:16 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.jozahuv6: same parent dir (ODFfOTQ3MjcxN185enBmeQ) - using file/rename instead of move_copy for sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789
2025/10/09 04:45:17 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: TEST: renaming existing object to "sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.nobeqot0" before starting
2025/10/09 04:45:17 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890123456789: same parent dir (ODFfOTQ3MjcxN185enBmeQ) - using file/rename instead of move_copy for sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.nobeqot0
2025/10/09 04:45:18 DEBUG : sub dir/test remove existing with long name 123456789012345678901234567890123456789012345678901234567890.nobeqot0: TEST: removing renamed existing file after operation
--- PASS: TestRemoveExisting (10.43s)
PASS
2025/10/09 04:45:19 DEBUG : OpenDrive root 'rclone-test-qubuyuc2dixi': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCopyFileCompareDest|TestRemoveExisting)$'" - Finished OK in 32.313796281s (try 2/5)