"./sync.test -test.v -test.timeout 1h0m0s -remote TestHiDrive: -verbose -test.run '^(TestMoveEmptyDirectories|TestServerSideCopy|TestSyncEmptyDirectories|TestSyncNoEmptyDirectories)$'" - Starting (try 2/5)
2025/10/02 05:38:16 DEBUG : Creating backend with remote "TestHiDrive:rclone-test-tegimad9xife"
2025/10/02 05:38:16 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/10/02 05:38:16 DEBUG : Creating backend with remote "/tmp/rclone3894959305"
=== RUN   TestMoveEmptyDirectories
    run.go:180: Remote "HiDrive root 'rclone-test-tegimad9xife'", Local "Local file system at /tmp/rclone3894959305", Modify Window "1s"
2025/10/02 05:38:16 DEBUG : sub dir2: Making directory with metadata
2025/10/02 05:38:16 INFO  : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2025/10/02 05:38:16 INFO  : sub dir2: Making directory
2025/10/02 05:38:16 INFO  : sub dir: Making directory
2025/10/02 05:38:16 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/10/02 05:38:16 DEBUG : HiDrive root 'rclone-test-tegimad9xife': Waiting for checks to finish
2025/10/02 05:38:16 DEBUG : HiDrive root 'rclone-test-tegimad9xife': Waiting for transfers to finish
2025/10/02 05:38:16 DEBUG : sub dir/hello world: hidrive = 456dc90e1c9b8b010bdf5c02a7cb4b435173eb4b OK
2025/10/02 05:38:16 INFO  : sub dir/hello world: Copied (new)
2025/10/02 05:38:16 INFO  : sub dir/hello world: Deleted
2025/10/02 05:38:16 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name sub dir
2025/10/02 05:38:16 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name sub dir2
2025/10/02 05:38:16 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name hello world
2025/10/02 05:38:16 DEBUG : HiDrive root 'rclone-test-tegimad9xife': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
2025/10/02 05:38:16 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name sub dir
2025/10/02 05:38:16 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name sub dir2
2025/10/02 05:38:16 DEBUG : HiDrive root 'rclone-test-tegimad9xife': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
2025/10/02 05:38:16 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name sub dir
2025/10/02 05:38:16 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name sub dir2
2025/10/02 05:38:16 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name hello world
--- PASS: TestMoveEmptyDirectories (0.86s)
=== RUN   TestSyncEmptyDirectories
    run.go:180: Remote "HiDrive root 'rclone-test-tegimad9xife'", Local "Local file system at /tmp/rclone3894959305", Modify Window "1s"
2025/10/02 05:38:17 DEBUG : sub dir2: Making directory with metadata
2025/10/02 05:38:17 INFO  : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2025/10/02 05:38:17 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2025/10/02 05:38:17 INFO  : sub dir2: Making directory
2025/10/02 05:38:17 INFO  : sub dir: Making directory
2025/10/02 05:38:17 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/10/02 05:38:17 DEBUG : HiDrive root 'rclone-test-tegimad9xife': Waiting for checks to finish
2025/10/02 05:38:17 DEBUG : HiDrive root 'rclone-test-tegimad9xife': Waiting for transfers to finish
2025/10/02 05:38:17 DEBUG : sub dir/hello world: hidrive = 456dc90e1c9b8b010bdf5c02a7cb4b435173eb4b OK
2025/10/02 05:38:17 INFO  : sub dir/hello world: Copied (new)
2025/10/02 05:38:17 DEBUG : Waiting for deletions to finish
2025/10/02 05:38:17 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name sub dir
2025/10/02 05:38:17 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name sub dir2
2025/10/02 05:38:17 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name hello world
2025/10/02 05:38:17 DEBUG : HiDrive root 'rclone-test-tegimad9xife': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata
2025/10/02 05:38:17 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name sub dir
2025/10/02 05:38:17 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name sub dir2
2025/10/02 05:38:17 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name hello world
--- PASS: TestSyncEmptyDirectories (0.63s)
=== RUN   TestSyncNoEmptyDirectories
    run.go:180: Remote "HiDrive root 'rclone-test-tegimad9xife'", Local "Local file system at /tmp/rclone3894959305", Modify Window "1s"
2025/10/02 05:38:17 INFO  : sub dir2: Making directory
2025/10/02 05:38:17 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/10/02 05:38:17 DEBUG : HiDrive root 'rclone-test-tegimad9xife': Waiting for checks to finish
2025/10/02 05:38:17 DEBUG : HiDrive root 'rclone-test-tegimad9xife': Waiting for transfers to finish
2025/10/02 05:38:17 DEBUG : sub dir/hello world: hidrive = 456dc90e1c9b8b010bdf5c02a7cb4b435173eb4b OK
2025/10/02 05:38:17 INFO  : sub dir/hello world: Copied (new)
2025/10/02 05:38:17 DEBUG : Waiting for deletions to finish
2025/10/02 05:38:17 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name sub dir
2025/10/02 05:38:17 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name hello world
2025/10/02 05:38:18 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name sub dir
2025/10/02 05:38:18 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name hello world
--- PASS: TestSyncNoEmptyDirectories (0.52s)
=== RUN   TestServerSideCopy
    run.go:180: Remote "HiDrive root 'rclone-test-tegimad9xife'", Local "Local file system at /tmp/rclone3894959305", Modify Window "1s"
2025/10/02 05:38:18 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name sub dir
2025/10/02 05:38:18 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name hello world
2025/10/02 05:38:18 DEBUG : Creating backend with remote "TestHiDrive:rclone-test-ripehem3kaxu"
    sync_test.go:620: Server side copy (if possible) HiDrive root 'rclone-test-tegimad9xife' -> HiDrive root 'rclone-test-ripehem3kaxu'
2025/10/02 05:38:18 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name sub dir
2025/10/02 05:38:18 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name hello world
2025/10/02 05:38:18 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2025/10/02 05:38:18 DEBUG : HiDrive root 'rclone-test-ripehem3kaxu': Waiting for checks to finish
2025/10/02 05:38:18 DEBUG : HiDrive root 'rclone-test-ripehem3kaxu': Waiting for transfers to finish
2025/10/02 05:38:19 DEBUG : sub dir/hello world: hidrive = 456dc90e1c9b8b010bdf5c02a7cb4b435173eb4b OK
2025/10/02 05:38:19 INFO  : sub dir/hello world: Copied (server-side copy)
2025/10/02 05:38:19 DEBUG : HiDrive root 'rclone-test-ripehem3kaxu': found directory-element with name sub dir
2025/10/02 05:38:19 DEBUG : HiDrive root 'rclone-test-ripehem3kaxu': found directory-element with name hello world
2025/10/02 05:38:19 DEBUG : HiDrive root 'rclone-test-ripehem3kaxu': Purge remote
2025/10/02 05:38:19 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name sub dir
2025/10/02 05:38:19 DEBUG : HiDrive root 'rclone-test-tegimad9xife': found directory-element with name hello world
--- PASS: TestServerSideCopy (1.30s)
PASS
2025/10/02 05:38:19 DEBUG : HiDrive root 'rclone-test-tegimad9xife': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestHiDrive: -verbose -test.run '^(TestMoveEmptyDirectories|TestServerSideCopy|TestSyncEmptyDirectories|TestSyncNoEmptyDirectories)$'" - Finished OK in 3.609222786s (try 2/5)