"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCopyEmptyDirectories|TestMoveNoEmptyDirectories|TestNothingToTransferWithEmptyDirs|TestServerSideCopy|TestServerSideMove)$'" - Starting (try 2/5)
2025/05/09 03:27:49 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-kariqab2wisa"
2025/05/09 03:27:49 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/05/09 03:27:50 DEBUG : Starting OpenDrive session with ID: 21436a31150a79042e08a8b19f5b2b234469db098b80ca01956acd4c970b3bf4
2025/05/09 03:27:50 DEBUG : Creating backend with remote "/tmp/rclone2417754084"
=== RUN   TestCopyEmptyDirectories
    run.go:180: Remote "OpenDrive root 'rclone-test-kariqab2wisa'", Local "Local file system at /tmp/rclone2417754084", Modify Window "1s"
2025/05/09 03:27:50 DEBUG : sub dir2/sub sub dir2: Making directory with metadata
2025/05/09 03:27:50 INFO  : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2025/05/09 03:27:50 INFO  : sub dir2: Set directory modification time (using DirSetModTime)
2025/05/09 03:27:50 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2025/05/09 03:27:51 INFO  : sub dir: Making directory
2025/05/09 03:27:51 INFO  : sub dir2: Making directory
2025/05/09 03:27:51 INFO  : sub dir2/sub sub dir2: Making directory
2025/05/09 03:27:51 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/05/09 03:27:52 DEBUG : OpenDrive root 'rclone-test-kariqab2wisa': Waiting for checks to finish
2025/05/09 03:27:52 DEBUG : OpenDrive root 'rclone-test-kariqab2wisa': Waiting for transfers to finish
2025/05/09 03:27:52 DEBUG : sub dir/hello world: Uploading chunk 0, size=11, remain=0
2025/05/09 03:27:53 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2025/05/09 03:27:53 INFO  : sub dir/hello world: Copied (new)
    run.go:180: Remote "OpenDrive root 'rclone-test-kariqab2wisa'", Local "Local file system at /tmp/rclone2417754084", Modify Window "1s"
2025/05/09 03:27:54 DEBUG : OpenDrive root 'rclone-test-kariqab2wisa': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
--- PASS: TestCopyEmptyDirectories (5.88s)
=== RUN   TestMoveNoEmptyDirectories
    run.go:180: Remote "OpenDrive root 'rclone-test-kariqab2wisa'", Local "Local file system at /tmp/rclone2417754084", Modify Window "1s"
2025/05/09 03:27:56 INFO  : sub dir2: Making directory
2025/05/09 03:27:56 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/05/09 03:27:56 DEBUG : OpenDrive root 'rclone-test-kariqab2wisa': Waiting for checks to finish
2025/05/09 03:27:56 DEBUG : OpenDrive root 'rclone-test-kariqab2wisa': Waiting for transfers to finish
2025/05/09 03:27:57 DEBUG : sub dir/hello world: Uploading chunk 0, size=11, remain=0
2025/05/09 03:27:58 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK
2025/05/09 03:27:58 INFO  : sub dir/hello world: Copied (new)
2025/05/09 03:27:58 INFO  : sub dir/hello world: Deleted
--- PASS: TestMoveNoEmptyDirectories (3.53s)
=== RUN   TestServerSideCopy
    run.go:180: Remote "OpenDrive root 'rclone-test-kariqab2wisa'", Local "Local file system at /tmp/rclone2417754084", Modify Window "1s"
2025/05/09 03:28:01 DEBUG : sub dir/hello world: Uploading chunk 0, size=11, remain=0
2025/05/09 03:28:02 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-novijaq0xaru"
2025/05/09 03:28:02 DEBUG : Starting OpenDrive session with ID: 99dc82dd9a3f9f50fefd8625759cfb55e853bc5983678db49a236ac6f582bb76
    sync_test.go:590: Server side copy (if possible) OpenDrive root 'rclone-test-kariqab2wisa' -> OpenDrive root 'rclone-test-novijaq0xaru'
2025/05/09 03:28:03 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/05/09 03:28:03 DEBUG : OpenDrive root 'rclone-test-novijaq0xaru': Waiting for checks to finish
2025/05/09 03:28:03 DEBUG : OpenDrive root 'rclone-test-novijaq0xaru': Waiting for transfers to finish
2025/05/09 03:28:04 DEBUG : sub dir/hello world: Dst hash empty - aborting Src hash check
2025/05/09 03:28:04 INFO  : sub dir/hello world: Copied (server-side copy)
    run.go:180: Remote "OpenDrive root 'rclone-test-kariqab2wisa'", Local "Local file system at /tmp/rclone2417754084", Modify Window "1s"
2025/05/09 03:28:04 DEBUG : OpenDrive root 'rclone-test-novijaq0xaru': Purge remote
--- PASS: TestServerSideCopy (6.54s)
=== RUN   TestServerSideMove
    run.go:180: Remote "OpenDrive root 'rclone-test-kariqab2wisa'", Local "Local file system at /tmp/rclone2417754084", Modify Window "1s"
2025/05/09 03:28:06 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-vitiqid6pece"
2025/05/09 03:28:06 DEBUG : Starting OpenDrive session with ID: e71acdcf7bb3f24032ae170e9448f55afc13cce4ec73c909b3536d986901c5f0
2025/05/09 03:28:08 DEBUG : potato2: Uploading chunk 0, size=60, remain=0
2025/05/09 03:28:09 DEBUG : empty space: Uploading chunk 0, size=1, remain=0
2025/05/09 03:28:11 DEBUG : potato3: Uploading chunk 0, size=68, remain=0
    sync_test.go:1705: Server side move (if possible) OpenDrive root 'rclone-test-kariqab2wisa' -> OpenDrive root 'rclone-test-vitiqid6pece'
2025/05/09 03:28:13 DEBUG : empty space: Uploading chunk 0, size=1, remain=0
2025/05/09 03:28:15 DEBUG : potato3: Uploading chunk 0, size=60, remain=0
2025/05/09 03:28:16 DEBUG : OpenDrive root 'rclone-test-vitiqid6pece': Using server-side directory move
2025/05/09 03:28:16 INFO  : OpenDrive root 'rclone-test-vitiqid6pece': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists
2025/05/09 03:28:16 DEBUG : potato2: Need to transfer - File not found at Destination
2025/05/09 03:28:16 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1s)
2025/05/09 03:28:16 DEBUG : empty space: Unchanged skipping
2025/05/09 03:28:16 DEBUG : potato3: Sizes differ (src 68 vs dst 60)
2025/05/09 03:28:16 DEBUG : OpenDrive root 'rclone-test-vitiqid6pece': Waiting for checks to finish
2025/05/09 03:28:16 INFO  : potato3: Deleted
2025/05/09 03:28:16 INFO  : empty space: Deleted
2025/05/09 03:28:16 DEBUG : OpenDrive root 'rclone-test-vitiqid6pece': Waiting for transfers to finish
2025/05/09 03:28:16 INFO  : potato2: Moved (server-side)
2025/05/09 03:28:16 INFO  : potato3: Moved (server-side)
2025/05/09 03:28:17 DEBUG : Creating backend with remote "TestOpenDrive:rclone-test-riwoyay0suhu"
2025/05/09 03:28:17 DEBUG : Starting OpenDrive session with ID: 812cc948c8ea44c0aa67a18a57ac2f8ec277fdfad0bd7e6029d426928012a0df
2025/05/09 03:28:17 DEBUG : OpenDrive root 'rclone-test-riwoyay0suhu': Using server-side directory move
2025/05/09 03:28:18 DEBUG : : same parent dir (0) - using folder/rename instead of move_copy
2025/05/09 03:28:18 INFO  : OpenDrive root 'rclone-test-riwoyay0suhu': Server side directory move succeeded
2025/05/09 03:28:18 ERROR : : error listing: directory not found
2025/05/09 03:28:18 DEBUG : OpenDrive root 'rclone-test-riwoyay0suhu': Purge remote
2025/05/09 03:28:19 DEBUG : OpenDrive root 'rclone-test-vitiqid6pece': Purge remote
2025/05/09 03:28:19 NOTICE: purge failed: directory not found
--- PASS: TestServerSideMove (13.21s)
=== RUN   TestNothingToTransferWithEmptyDirs
    run.go:180: Remote "OpenDrive root 'rclone-test-kariqab2wisa'", Local "Local file system at /tmp/rclone2417754084", Modify Window "1s"
2025/05/09 03:28:19 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2025/05/09 03:28:19 INFO  : sub dir: Making directory
2025/05/09 03:28:20 INFO  : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC
    run.go:180: Remote "OpenDrive root 'rclone-test-kariqab2wisa'", Local "Local file system at /tmp/rclone2417754084", Modify Window "1s"
    run.go:180: Remote "OpenDrive root 'rclone-test-kariqab2wisa'", Local "Local file system at /tmp/rclone2417754084", Modify Window "1s"
--- PASS: TestNothingToTransferWithEmptyDirs (15.59s)
PASS
2025/05/09 03:28:35 DEBUG : OpenDrive root 'rclone-test-kariqab2wisa': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestOpenDrive: -verbose -test.run '^(TestCopyEmptyDirectories|TestMoveNoEmptyDirectories|TestNothingToTransferWithEmptyDirs|TestServerSideCopy|TestServerSideMove)$'" - Finished OK in 46.082137568s (try 2/5)