"./sync.test -test.v -test.timeout 1h0m0s -remote TestHiDrive: -verbose -test.run '^(TestCopyOverSelf|TestMoveNoEmptyDirectories|TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors|TestSyncEmptyDirectories|TestSyncNoEmptyDirectories|TestSyncNoTraverse)$'" - Starting (try 2/5)
2026/05/30 04:09:29 DEBUG : Creating backend with remote "TestHiDrive:rclone-test-berated1xeyu"
2026/05/30 04:09:29 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/05/30 04:09:30 DEBUG : Creating backend with remote "/tmp/rclone3249390244"
=== RUN   TestSyncNoTraverse
    run.go:198: Remote "HiDrive root 'rclone-test-berated1xeyu'", Local "Local file system at /tmp/rclone3249390244", Modify Window "1s"
2026/05/30 04:09:30 ERROR : Ignoring --no-traverse with sync
2026/05/30 04:09:30 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/05/30 04:09:30 DEBUG : HiDrive root 'rclone-test-berated1xeyu': Waiting for checks to finish
2026/05/30 04:09:30 DEBUG : HiDrive root 'rclone-test-berated1xeyu': Waiting for transfers to finish
2026/05/30 04:09:30 DEBUG : sub dir/hello world: size = 11 OK
2026/05/30 04:09:30 DEBUG : sub dir/hello world: hidrive = 456dc90e1c9b8b010bdf5c02a7cb4b435173eb4b OK
2026/05/30 04:09:30 INFO  : sub dir/hello world: Copied (new)
2026/05/30 04:09:30 DEBUG : Waiting for deletions to finish
2026/05/30 04:09:30 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name sub dir
2026/05/30 04:09:30 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name hello world
2026/05/30 04:09:30 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name sub dir
2026/05/30 04:09:30 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name hello world
--- PASS: TestSyncNoTraverse (0.64s)
=== RUN   TestMoveNoEmptyDirectories
    run.go:198: Remote "HiDrive root 'rclone-test-berated1xeyu'", Local "Local file system at /tmp/rclone3249390244", Modify Window "1s"
2026/05/30 04:09:30 INFO  : sub dir2: Making directory
2026/05/30 04:09:30 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/05/30 04:09:30 DEBUG : HiDrive root 'rclone-test-berated1xeyu': Waiting for checks to finish
2026/05/30 04:09:30 DEBUG : HiDrive root 'rclone-test-berated1xeyu': Waiting for transfers to finish
2026/05/30 04:09:30 DEBUG : sub dir/hello world: size = 11 OK
2026/05/30 04:09:30 DEBUG : sub dir/hello world: hidrive = 456dc90e1c9b8b010bdf5c02a7cb4b435173eb4b OK
2026/05/30 04:09:30 INFO  : sub dir/hello world: Copied (new)
2026/05/30 04:09:30 INFO  : sub dir/hello world: Deleted
2026/05/30 04:09:31 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name sub dir
2026/05/30 04:09:31 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name hello world
2026/05/30 04:09:31 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name sub dir
2026/05/30 04:09:31 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name hello world
--- PASS: TestMoveNoEmptyDirectories (0.57s)
=== RUN   TestSyncEmptyDirectories
    run.go:198: Remote "HiDrive root 'rclone-test-berated1xeyu'", Local "Local file system at /tmp/rclone3249390244", Modify Window "1s"
2026/05/30 04:09:31 DEBUG : sub dir2: Making directory with metadata
2026/05/30 04:09:31 INFO  : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/05/30 04:09:31 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2026/05/30 04:09:31 INFO  : sub dir2: Making directory
2026/05/30 04:09:31 INFO  : sub dir: Making directory
2026/05/30 04:09:31 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/05/30 04:09:31 DEBUG : HiDrive root 'rclone-test-berated1xeyu': Waiting for checks to finish
2026/05/30 04:09:31 DEBUG : HiDrive root 'rclone-test-berated1xeyu': Waiting for transfers to finish
2026/05/30 04:09:31 DEBUG : sub dir/hello world: size = 11 OK
2026/05/30 04:09:31 DEBUG : sub dir/hello world: hidrive = 456dc90e1c9b8b010bdf5c02a7cb4b435173eb4b OK
2026/05/30 04:09:31 INFO  : sub dir/hello world: Copied (new)
2026/05/30 04:09:31 DEBUG : Waiting for deletions to finish
2026/05/30 04:09:31 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name sub dir
2026/05/30 04:09:31 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name sub dir2
2026/05/30 04:09:31 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name hello world
2026/05/30 04:09:31 DEBUG : HiDrive root 'rclone-test-berated1xeyu': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
2026/05/30 04:09:31 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name sub dir
2026/05/30 04:09:31 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name sub dir2
2026/05/30 04:09:31 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name hello world
--- PASS: TestSyncEmptyDirectories (0.72s)
=== RUN   TestSyncNoEmptyDirectories
    run.go:198: Remote "HiDrive root 'rclone-test-berated1xeyu'", Local "Local file system at /tmp/rclone3249390244", Modify Window "1s"
2026/05/30 04:09:31 INFO  : sub dir2: Making directory
2026/05/30 04:09:31 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/05/30 04:09:31 DEBUG : HiDrive root 'rclone-test-berated1xeyu': Waiting for checks to finish
2026/05/30 04:09:31 DEBUG : HiDrive root 'rclone-test-berated1xeyu': Waiting for transfers to finish
2026/05/30 04:09:32 DEBUG : sub dir/hello world: size = 11 OK
2026/05/30 04:09:32 DEBUG : sub dir/hello world: hidrive = 456dc90e1c9b8b010bdf5c02a7cb4b435173eb4b OK
2026/05/30 04:09:32 INFO  : sub dir/hello world: Copied (new)
2026/05/30 04:09:32 DEBUG : Waiting for deletions to finish
2026/05/30 04:09:32 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name sub dir
2026/05/30 04:09:32 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name hello world
2026/05/30 04:09:32 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name sub dir
2026/05/30 04:09:32 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name hello world
--- PASS: TestSyncNoEmptyDirectories (0.53s)
=== RUN   TestCopyOverSelf
    run.go:198: Remote "HiDrive root 'rclone-test-berated1xeyu'", Local "Local file system at /tmp/rclone3249390244", Modify Window "1s"
2026/05/30 04:09:32 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name sub dir
2026/05/30 04:09:32 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name hello world
2026/05/30 04:09:32 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name sub dir
2026/05/30 04:09:32 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name hello world
2026/05/30 04:09:32 DEBUG : HiDrive root 'rclone-test-berated1xeyu': Waiting for checks to finish
2026/05/30 04:09:32 DEBUG : sub dir/hello world: size = 17 (Local file system at /tmp/rclone3249390244)
2026/05/30 04:09:32 DEBUG : sub dir/hello world: size = 11 (HiDrive root 'rclone-test-berated1xeyu')
2026/05/30 04:09:32 DEBUG : sub dir/hello world: Sizes differ
2026/05/30 04:09:32 DEBUG : HiDrive root 'rclone-test-berated1xeyu': Waiting for transfers to finish
2026/05/30 04:09:32 DEBUG : sub dir/hello world: size = 17 OK
2026/05/30 04:09:32 DEBUG : sub dir/hello world: hidrive = ea39137182fa1c8271a3d15ba3d183d09dbff0ad OK
2026/05/30 04:09:32 INFO  : sub dir/hello world: Copied (replaced existing)
2026/05/30 04:09:33 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name sub dir
2026/05/30 04:09:33 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name hello world
2026/05/30 04:09:33 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name sub dir
2026/05/30 04:09:33 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name hello world
--- PASS: TestCopyOverSelf (0.86s)
=== RUN   TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors
    run.go:198: Remote "HiDrive root 'rclone-test-berated1xeyu'", Local "Local file system at /tmp/rclone3249390244", Modify Window "1s"
2026/05/30 04:09:33 INFO  : d: Making directory
2026/05/30 04:09:33 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name b
2026/05/30 04:09:33 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name c
2026/05/30 04:09:33 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name d
2026/05/30 04:09:33 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name non empty space
2026/05/30 04:09:33 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name potato
2026/05/30 04:09:34 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name b
2026/05/30 04:09:34 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name c
2026/05/30 04:09:34 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name d
2026/05/30 04:09:34 DEBUG : a/potato2: Need to transfer - File not found at Destination
2026/05/30 04:09:34 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name potato
2026/05/30 04:09:34 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name non empty space
2026/05/30 04:09:34 DEBUG : HiDrive root 'rclone-test-berated1xeyu': Waiting for checks to finish
2026/05/30 04:09:34 DEBUG : c/non empty space: size = 5 OK
2026/05/30 04:09:34 DEBUG : c/non empty space: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2026/05/30 04:09:34 DEBUG : c/non empty space: Unchanged skipping
2026/05/30 04:09:34 DEBUG : HiDrive root 'rclone-test-berated1xeyu': Waiting for transfers to finish
2026/05/30 04:09:34 DEBUG : a/potato2: size = 60 OK
2026/05/30 04:09:34 DEBUG : a/potato2: hidrive = bce3cb268703fff742fa2271e8c7fad9c26b0104 OK
2026/05/30 04:09:34 INFO  : a/potato2: Copied (new)
2026/05/30 04:09:34 ERROR : HiDrive root 'rclone-test-berated1xeyu': not deleting files as there were IO errors
2026/05/30 04:09:34 ERROR : HiDrive root 'rclone-test-berated1xeyu': not deleting directories as there were IO errors
2026/05/30 04:09:34 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name a
2026/05/30 04:09:34 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name b
2026/05/30 04:09:34 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name c
2026/05/30 04:09:34 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name d
2026/05/30 04:09:34 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name potato2
2026/05/30 04:09:34 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name potato
2026/05/30 04:09:34 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name non empty space
2026/05/30 04:09:34 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name a
2026/05/30 04:09:34 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name b
2026/05/30 04:09:34 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name c
2026/05/30 04:09:34 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name d
2026/05/30 04:09:34 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name potato2
2026/05/30 04:09:34 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name potato
2026/05/30 04:09:34 DEBUG : HiDrive root 'rclone-test-berated1xeyu': found directory-element with name non empty space
--- PASS: TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors (1.51s)
PASS
2026/05/30 04:09:34 DEBUG : HiDrive root 'rclone-test-berated1xeyu': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestHiDrive: -verbose -test.run '^(TestCopyOverSelf|TestMoveNoEmptyDirectories|TestSyncAfterRemovingAFileAndAddingAFileSubDirWithErrors|TestSyncEmptyDirectories|TestSyncNoEmptyDirectories|TestSyncNoTraverse)$'" - Finished OK in 5.137102973s (try 2/5)