"./sync.test -test.v -test.timeout 1h0m0s -remote TestHiDrive: -verbose -test.run '^(TestMoveNoEmptyDirectories|TestMoveOverSelf|TestServerSideMoveOverSelf|TestSyncEmptyDirectories|TestSyncNoEmptyDirectories)$'" - Starting (try 2/5)
2026/01/23 01:30:21 DEBUG : Creating backend with remote "TestHiDrive:rclone-test-jinedab6wuhi"
2026/01/23 01:30:21 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/01/23 01:30:21 DEBUG : Creating backend with remote "/tmp/rclone575673211"
=== RUN   TestMoveNoEmptyDirectories
    run.go:185: Remote "HiDrive root 'rclone-test-jinedab6wuhi'", Local "Local file system at /tmp/rclone575673211", Modify Window "1s"
2026/01/23 01:30:21 INFO  : sub dir2: Making directory
2026/01/23 01:30:21 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/01/23 01:30:21 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': Waiting for checks to finish
2026/01/23 01:30:21 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': Waiting for transfers to finish
2026/01/23 01:30:21 DEBUG : sub dir/hello world: size = 11 OK
2026/01/23 01:30:21 DEBUG : sub dir/hello world: hidrive = 456dc90e1c9b8b010bdf5c02a7cb4b435173eb4b OK
2026/01/23 01:30:21 INFO  : sub dir/hello world: Copied (new)
2026/01/23 01:30:21 INFO  : sub dir/hello world: Deleted
2026/01/23 01:30:21 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name sub dir
2026/01/23 01:30:21 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name hello world
2026/01/23 01:30:21 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name sub dir
2026/01/23 01:30:21 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name hello world
--- PASS: TestMoveNoEmptyDirectories (0.63s)
=== RUN   TestSyncEmptyDirectories
    run.go:185: Remote "HiDrive root 'rclone-test-jinedab6wuhi'", Local "Local file system at /tmp/rclone575673211", Modify Window "1s"
2026/01/23 01:30:21 DEBUG : sub dir2: Making directory with metadata
2026/01/23 01:30:21 INFO  : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/01/23 01:30:21 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2026/01/23 01:30:22 INFO  : sub dir2: Making directory
2026/01/23 01:30:22 INFO  : sub dir: Making directory
2026/01/23 01:30:22 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/01/23 01:30:22 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': Waiting for checks to finish
2026/01/23 01:30:22 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': Waiting for transfers to finish
2026/01/23 01:30:22 DEBUG : sub dir/hello world: size = 11 OK
2026/01/23 01:30:22 DEBUG : sub dir/hello world: hidrive = 456dc90e1c9b8b010bdf5c02a7cb4b435173eb4b OK
2026/01/23 01:30:22 INFO  : sub dir/hello world: Copied (new)
2026/01/23 01:30:22 DEBUG : Waiting for deletions to finish
2026/01/23 01:30:22 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name sub dir
2026/01/23 01:30:22 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name sub dir2
2026/01/23 01:30:22 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name hello world
2026/01/23 01:30:22 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
2026/01/23 01:30:22 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name sub dir
2026/01/23 01:30:22 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name sub dir2
2026/01/23 01:30:22 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name hello world
--- PASS: TestSyncEmptyDirectories (0.72s)
=== RUN   TestSyncNoEmptyDirectories
    run.go:185: Remote "HiDrive root 'rclone-test-jinedab6wuhi'", Local "Local file system at /tmp/rclone575673211", Modify Window "1s"
2026/01/23 01:30:22 INFO  : sub dir2: Making directory
2026/01/23 01:30:22 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/01/23 01:30:22 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': Waiting for checks to finish
2026/01/23 01:30:22 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': Waiting for transfers to finish
2026/01/23 01:30:23 DEBUG : sub dir/hello world: size = 11 OK
2026/01/23 01:30:23 DEBUG : sub dir/hello world: hidrive = 456dc90e1c9b8b010bdf5c02a7cb4b435173eb4b OK
2026/01/23 01:30:23 INFO  : sub dir/hello world: Copied (new)
2026/01/23 01:30:23 DEBUG : Waiting for deletions to finish
2026/01/23 01:30:23 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name sub dir
2026/01/23 01:30:23 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name hello world
2026/01/23 01:30:23 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name sub dir
2026/01/23 01:30:23 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name hello world
--- PASS: TestSyncNoEmptyDirectories (0.64s)
=== RUN   TestMoveOverSelf
    run.go:185: Remote "HiDrive root 'rclone-test-jinedab6wuhi'", Local "Local file system at /tmp/rclone575673211", Modify Window "1s"
2026/01/23 01:30:23 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name sub dir
2026/01/23 01:30:23 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name hello world
2026/01/23 01:30:23 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name sub dir
2026/01/23 01:30:23 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name hello world
2026/01/23 01:30:23 DEBUG : sub dir/hello world: size = 17 (Local file system at /tmp/rclone575673211)
2026/01/23 01:30:23 DEBUG : sub dir/hello world: size = 11 (HiDrive root 'rclone-test-jinedab6wuhi')
2026/01/23 01:30:23 DEBUG : sub dir/hello world: Sizes differ
2026/01/23 01:30:23 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': Waiting for checks to finish
2026/01/23 01:30:23 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': Waiting for transfers to finish
2026/01/23 01:30:23 DEBUG : sub dir/hello world: size = 17 OK
2026/01/23 01:30:23 DEBUG : sub dir/hello world: hidrive = ea39137182fa1c8271a3d15ba3d183d09dbff0ad OK
2026/01/23 01:30:23 INFO  : sub dir/hello world: Copied (replaced existing)
2026/01/23 01:30:23 INFO  : sub dir/hello world: Deleted
2026/01/23 01:30:23 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name sub dir
2026/01/23 01:30:23 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name hello world
2026/01/23 01:30:23 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name sub dir
2026/01/23 01:30:23 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name hello world
--- PASS: TestMoveOverSelf (0.92s)
=== RUN   TestServerSideMoveOverSelf
    run.go:185: Remote "HiDrive root 'rclone-test-jinedab6wuhi'", Local "Local file system at /tmp/rclone575673211", Modify Window "1s"
2026/01/23 01:30:24 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name sub dir
2026/01/23 01:30:24 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name hello world
2026/01/23 01:30:24 DEBUG : Creating backend with remote "TestHiDrive:rclone-test-yozugec6sigi"
    sync_test.go:701: Server side copy (if possible) HiDrive root 'rclone-test-jinedab6wuhi' -> HiDrive root 'rclone-test-yozugec6sigi'
2026/01/23 01:30:24 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name sub dir
2026/01/23 01:30:24 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name hello world
2026/01/23 01:30:24 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/01/23 01:30:24 DEBUG : HiDrive root 'rclone-test-yozugec6sigi': Waiting for checks to finish
2026/01/23 01:30:24 DEBUG : HiDrive root 'rclone-test-yozugec6sigi': Waiting for transfers to finish
2026/01/23 01:30:25 DEBUG : sub dir/hello world: size = 11 OK
2026/01/23 01:30:25 DEBUG : sub dir/hello world: hidrive = 456dc90e1c9b8b010bdf5c02a7cb4b435173eb4b OK
2026/01/23 01:30:25 INFO  : sub dir/hello world: Copied (server-side copy)
2026/01/23 01:30:25 DEBUG : HiDrive root 'rclone-test-yozugec6sigi': found directory-element with name sub dir
2026/01/23 01:30:25 DEBUG : HiDrive root 'rclone-test-yozugec6sigi': found directory-element with name hello world
2026/01/23 01:30:26 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name sub dir
2026/01/23 01:30:26 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name hello world
2026/01/23 01:30:26 DEBUG : HiDrive root 'rclone-test-yozugec6sigi': Using server-side directory move
2026/01/23 01:30:26 INFO  : HiDrive root 'rclone-test-yozugec6sigi': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists
2026/01/23 01:30:26 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name sub dir
2026/01/23 01:30:26 DEBUG : HiDrive root 'rclone-test-yozugec6sigi': found directory-element with name sub dir
2026/01/23 01:30:26 DEBUG : HiDrive root 'rclone-test-yozugec6sigi': found directory-element with name hello world
2026/01/23 01:30:26 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name hello world
2026/01/23 01:30:26 DEBUG : sub dir/hello world: size = 17 (HiDrive root 'rclone-test-jinedab6wuhi')
2026/01/23 01:30:26 DEBUG : sub dir/hello world: size = 11 (HiDrive root 'rclone-test-yozugec6sigi')
2026/01/23 01:30:26 DEBUG : sub dir/hello world: Sizes differ
2026/01/23 01:30:26 DEBUG : HiDrive root 'rclone-test-yozugec6sigi': Waiting for checks to finish
2026/01/23 01:30:26 DEBUG : HiDrive root 'rclone-test-yozugec6sigi': Waiting for transfers to finish
2026/01/23 01:30:26 INFO  : sub dir/hello world: Deleted
2026/01/23 01:30:26 INFO  : sub dir/hello world: Moved (server-side)
2026/01/23 01:30:26 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name sub dir
2026/01/23 01:30:26 DEBUG : HiDrive root 'rclone-test-yozugec6sigi': found directory-element with name sub dir
2026/01/23 01:30:26 DEBUG : HiDrive root 'rclone-test-yozugec6sigi': found directory-element with name hello world
2026/01/23 01:30:26 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name sub dir
2026/01/23 01:30:26 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name hello world
2026/01/23 01:30:26 DEBUG : testing file moves
2026/01/23 01:30:27 DEBUG : HiDrive root 'rclone-test-yozugec6sigi': found directory-element with name sub dir
2026/01/23 01:30:27 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name sub dir
2026/01/23 01:30:27 DEBUG : HiDrive root 'rclone-test-yozugec6sigi': found directory-element with name hello world
2026/01/23 01:30:27 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name hello world
2026/01/23 01:30:27 DEBUG : sub dir/hello world: size = 24 (HiDrive root 'rclone-test-jinedab6wuhi')
2026/01/23 01:30:27 DEBUG : sub dir/hello world: size = 17 (HiDrive root 'rclone-test-yozugec6sigi')
2026/01/23 01:30:27 DEBUG : sub dir/hello world: Sizes differ
2026/01/23 01:30:27 DEBUG : HiDrive root 'rclone-test-yozugec6sigi': Waiting for checks to finish
2026/01/23 01:30:27 DEBUG : HiDrive root 'rclone-test-yozugec6sigi': Waiting for transfers to finish
2026/01/23 01:30:27 INFO  : sub dir/hello world: Deleted
2026/01/23 01:30:27 INFO  : sub dir/hello world: Moved (server-side)
2026/01/23 01:30:27 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name sub dir
2026/01/23 01:30:27 DEBUG : HiDrive root 'rclone-test-yozugec6sigi': found directory-element with name sub dir
2026/01/23 01:30:27 DEBUG : HiDrive root 'rclone-test-yozugec6sigi': found directory-element with name hello world
2026/01/23 01:30:27 DEBUG : HiDrive root 'rclone-test-yozugec6sigi': Purge remote
2026/01/23 01:30:27 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': found directory-element with name sub dir
--- PASS: TestServerSideMoveOverSelf (3.29s)
PASS
2026/01/23 01:30:27 DEBUG : HiDrive root 'rclone-test-jinedab6wuhi': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestHiDrive: -verbose -test.run '^(TestMoveNoEmptyDirectories|TestMoveOverSelf|TestServerSideMoveOverSelf|TestSyncEmptyDirectories|TestSyncNoEmptyDirectories)$'" - Finished OK in 6.487367488s (try 2/5)