"./operations.test -test.v -test.timeout 1h0m0s -remote TestHiDrive: -verbose -test.run '^TestCopyFileCopyDest$'" - Starting (try 2/5)
2026/04/20 05:01:07 DEBUG : Creating backend with remote "TestHiDrive:rclone-test-porokiv9dove"
2026/04/20 05:01:07 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/04/20 05:01:07 DEBUG : Creating backend with remote "/tmp/rclone1520308758"
=== RUN   TestCopyFileCopyDest
    run.go:185: Remote "HiDrive root 'rclone-test-porokiv9dove'", Local "Local file system at /tmp/rclone1520308758", Modify Window "1s"
2026/04/20 05:01:07 DEBUG : Creating backend with remote "TestHiDrive:rclone-test-porokiv9dove/dst"
2026/04/20 05:01:07 DEBUG : Creating backend with remote "TestHiDrive:rclone-test-porokiv9dove/CopyDest"
2026/04/20 05:01:07 DEBUG : one: Need to transfer - File not found at Destination
2026/04/20 05:01:07 DEBUG : one: size = 3 OK
2026/04/20 05:01:07 DEBUG : one: hidrive = 4ae17179700e403a003b67e8771a3746b8fb7038 OK
2026/04/20 05:01:07 INFO  : one: Copied (new)
2026/04/20 05:01:07 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name dst
2026/04/20 05:01:07 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:07 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name dst
2026/04/20 05:01:08 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:08 DEBUG : one: size = 5 (Local file system at /tmp/rclone1520308758)
2026/04/20 05:01:08 DEBUG : one: size = 3 (HiDrive root 'rclone-test-porokiv9dove/dst')
2026/04/20 05:01:08 DEBUG : one: Sizes differ
2026/04/20 05:01:08 DEBUG : one: size = 5 OK
2026/04/20 05:01:08 DEBUG : one: hidrive = e5931477da5d36ab3f7d23b04caa81cb9e263847 OK
2026/04/20 05:01:08 INFO  : one: Copied (replaced existing)
2026/04/20 05:01:08 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name dst
2026/04/20 05:01:08 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:09 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name CopyDest
2026/04/20 05:01:09 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name dst
2026/04/20 05:01:09 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:09 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:09 DEBUG : Creating backend with remote "TestHiDrive:rclone-test-porokiv9dove/BackupDir"
2026/04/20 05:01:09 DEBUG : one: size = 5 (Local file system at /tmp/rclone1520308758)
2026/04/20 05:01:09 DEBUG : one: size = 3 (HiDrive root 'rclone-test-porokiv9dove/dst')
2026/04/20 05:01:09 DEBUG : one: Sizes differ
2026/04/20 05:01:09 DEBUG : one: size = 5 OK
2026/04/20 05:01:09 DEBUG : one: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2026/04/20 05:01:09 DEBUG : one: size = 5 (Local file system at /tmp/rclone1520308758)
2026/04/20 05:01:09 DEBUG : one: size = 3 (HiDrive root 'rclone-test-porokiv9dove/dst')
2026/04/20 05:01:09 DEBUG : one: Sizes differ
2026/04/20 05:01:10 INFO  : one: Moved (server-side)
2026/04/20 05:01:10 DEBUG : one: size = 5 OK
2026/04/20 05:01:10 DEBUG : one: hidrive = e5931477da5d36ab3f7d23b04caa81cb9e263847 OK
2026/04/20 05:01:10 INFO  : one: Copied (server-side copy)
2026/04/20 05:01:10 DEBUG : one: Destination found in --copy-dest, using server-side copy
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name BackupDir
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name CopyDest
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name dst
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name BackupDir
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name CopyDest
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name dst
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name two
2026/04/20 05:01:10 DEBUG : two: Need to transfer - File not found at Destination
2026/04/20 05:01:10 DEBUG : two: size = 3 OK
2026/04/20 05:01:10 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2026/04/20 05:01:10 DEBUG : two: size = 3 OK
2026/04/20 05:01:10 DEBUG : two: hidrive = e582e2c9b94ae07f4109b7127ba3df5fe0209586 OK
2026/04/20 05:01:10 INFO  : two: Copied (server-side copy)
2026/04/20 05:01:10 DEBUG : two: Destination found in --copy-dest, using server-side copy
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name BackupDir
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name CopyDest
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name dst
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name two
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name two
2026/04/20 05:01:10 DEBUG : two: size = 3 OK
2026/04/20 05:01:10 DEBUG : two: Size and modification time the same (differ by -123.456789ms, within tolerance 1s)
2026/04/20 05:01:10 DEBUG : two: Unchanged skipping
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name BackupDir
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name CopyDest
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name dst
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name two
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name two
2026/04/20 05:01:10 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name BackupDir
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name CopyDest
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name dst
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name two
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name three
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name two
2026/04/20 05:01:11 DEBUG : three: Need to transfer - File not found at Destination
2026/04/20 05:01:11 DEBUG : three: size = 7 (Local file system at /tmp/rclone1520308758)
2026/04/20 05:01:11 DEBUG : three: size = 5 (HiDrive root 'rclone-test-porokiv9dove/CopyDest')
2026/04/20 05:01:11 DEBUG : three: Sizes differ
2026/04/20 05:01:11 DEBUG : three: Destination not found in --copy-dest
2026/04/20 05:01:11 DEBUG : three: size = 7 OK
2026/04/20 05:01:11 DEBUG : three: hidrive = 54e22cfa786a1f46d23d20dc072e928b07900050 OK
2026/04/20 05:01:11 INFO  : three: Copied (new)
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name BackupDir
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name CopyDest
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name dst
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name three
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name two
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name three
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name two
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name BackupDir
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name CopyDest
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name dst
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name three
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name two
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name three
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name two
2026/04/20 05:01:11 DEBUG : HiDrive root 'rclone-test-porokiv9dove': found directory-element with name one
--- PASS: TestCopyFileCopyDest (5.29s)
PASS
2026/04/20 05:01:12 DEBUG : HiDrive root 'rclone-test-porokiv9dove': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestHiDrive: -verbose -test.run '^TestCopyFileCopyDest$'" - Finished OK in 5.597154925s (try 2/5)