"./sync.test -test.v -test.timeout 1h0m0s -remote TestPixeldrain: -verbose -test.run '^(TestCopy|TestCopyEmptyDirectories|TestCopyMetadata|TestCopyMetadataNoEmptyDirs|TestMoveEmptyDirectories|TestNothingToTransferWithEmptyDirs|TestNothingToTransferWithoutEmptyDirs|TestSyncEmptyDirectories)$'" - Starting (try 3/5)
2026/07/13 03:28:10 DEBUG : Creating backend with remote "TestPixeldrain:rclone-test-witidap1goke"
2026/07/13 03:28:10 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/07/13 03:28:10 INFO  : pixeldrain root 'rclone-test-witidap1goke': Logged in as 'ncw', subscription 'Prepaid', storage limit -1
2026/07/13 03:28:10 DEBUG : Creating backend with remote "/tmp/rclone4280497776"
=== RUN   TestCopy
    run.go:198: Remote "pixeldrain root 'rclone-test-witidap1goke'", Local "Local file system at /tmp/rclone4280497776", Modify Window "1ms"
2026/07/13 03:28:10 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2026/07/13 03:28:10 DEBUG : Added delayed dir = "sub dir", newDst=<nil>
2026/07/13 03:28:10 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/07/13 03:28:10 DEBUG : pixeldrain root 'rclone-test-witidap1goke': Waiting for checks to finish
2026/07/13 03:28:10 DEBUG : pixeldrain root 'rclone-test-witidap1goke': Waiting for transfers to finish
2026/07/13 03:28:10 DEBUG : sub dir/hello world: size = 11 OK
2026/07/13 03:28:10 DEBUG : sub dir/hello world: sha256 = b94d27b9934d3e08a52e52d7da7dabfac484efe37a5380ee9088f7ace2efcde9 OK
2026/07/13 03:28:10 INFO  : sub dir/hello world: Copied (new)
2026/07/13 03:28:10 INFO  : sub dir: Set directory modification time (using DirSetModTime)
--- PASS: TestCopy (0.36s)
=== RUN   TestCopyMetadata
    run.go:198: Remote "pixeldrain root 'rclone-test-witidap1goke'", Local "Local file system at /tmp/rclone4280497776", Modify Window "1ms"
2026/07/13 03:28:11 DEBUG : metadata sub dir: Making directory with metadata
2026/07/13 03:28:11 INFO  : metadata sub dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/07/13 03:28:11 DEBUG : empty metadata sub dir: Making directory with metadata
2026/07/13 03:28:11 INFO  : empty metadata sub dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/07/13 03:28:11 DEBUG : Local file system at /tmp/rclone4280497776: File to upload is small (21 bytes), uploading instead of streaming
2026/07/13 03:28:11 DEBUG : metadata sub dir/hello metadata world: size = 21 OK
2026/07/13 03:28:11 DEBUG : metadata sub dir/hello metadata world: md5 = baa7a013449dbba2b1ed02b5cfb4e1a2 OK
2026/07/13 03:28:11 DEBUG : metadata sub dir/hello metadata world: Size and md5 of src and dst objects identical
2026/07/13 03:28:11 INFO  : metadata sub dir: Set directory modification time (using DirSetModTime)
2026/07/13 03:28:11 INFO  : empty metadata sub dir: Making directory
2026/07/13 03:28:11 INFO  : empty metadata sub dir: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC
2026/07/13 03:28:11 INFO  : metadata sub dir: Making directory
2026/07/13 03:28:11 INFO  : metadata sub dir: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC
2026/07/13 03:28:11 DEBUG : metadata sub dir/hello metadata world: Need to transfer - File not found at Destination
2026/07/13 03:28:11 DEBUG : pixeldrain root 'rclone-test-witidap1goke': Waiting for checks to finish
2026/07/13 03:28:11 DEBUG : pixeldrain root 'rclone-test-witidap1goke': Waiting for transfers to finish
2026/07/13 03:28:11 DEBUG : metadata sub dir/hello metadata world: size = 21 OK
2026/07/13 03:28:11 DEBUG : metadata sub dir/hello metadata world: sha256 = 64d5652158c99e4dd08097075e4e76b287f3b63667c0968c7867720a543c6916 OK
2026/07/13 03:28:11 INFO  : metadata sub dir/hello metadata world: Copied (new)
--- PASS: TestCopyMetadata (0.53s)
=== RUN   TestCopyMetadataNoEmptyDirs
    run.go:198: Remote "pixeldrain root 'rclone-test-witidap1goke'", Local "Local file system at /tmp/rclone4280497776", Modify Window "1ms"
2026/07/13 03:28:11 DEBUG : metadata sub dir: Making directory with metadata
2026/07/13 03:28:11 INFO  : metadata sub dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/07/13 03:28:11 DEBUG : empty metadata sub dir: Making directory with metadata
2026/07/13 03:28:11 INFO  : empty metadata sub dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/07/13 03:28:11 DEBUG : Local file system at /tmp/rclone4280497776: File to upload is small (21 bytes), uploading instead of streaming
2026/07/13 03:28:11 DEBUG : metadata sub dir/hello metadata world: size = 21 OK
2026/07/13 03:28:11 DEBUG : metadata sub dir/hello metadata world: md5 = baa7a013449dbba2b1ed02b5cfb4e1a2 OK
2026/07/13 03:28:11 DEBUG : metadata sub dir/hello metadata world: Size and md5 of src and dst objects identical
2026/07/13 03:28:11 INFO  : metadata sub dir: Set directory modification time (using DirSetModTime)
2026/07/13 03:28:11 DEBUG : Added delayed dir = "empty metadata sub dir", newDst=<nil>
2026/07/13 03:28:11 DEBUG : Added delayed dir = "metadata sub dir", newDst=<nil>
2026/07/13 03:28:11 DEBUG : metadata sub dir/hello metadata world: Need to transfer - File not found at Destination
2026/07/13 03:28:11 DEBUG : pixeldrain root 'rclone-test-witidap1goke': Waiting for checks to finish
2026/07/13 03:28:11 DEBUG : pixeldrain root 'rclone-test-witidap1goke': Waiting for transfers to finish
2026/07/13 03:28:11 DEBUG : metadata sub dir/hello metadata world: size = 21 OK
2026/07/13 03:28:11 DEBUG : metadata sub dir/hello metadata world: sha256 = 64d5652158c99e4dd08097075e4e76b287f3b63667c0968c7867720a543c6916 OK
2026/07/13 03:28:11 INFO  : metadata sub dir/hello metadata world: Copied (new)
2026/07/13 03:28:11 INFO  : metadata sub dir: Set directory modification time (using DirSetModTime)
--- PASS: TestCopyMetadataNoEmptyDirs (0.38s)
=== RUN   TestCopyEmptyDirectories
    run.go:198: Remote "pixeldrain root 'rclone-test-witidap1goke'", Local "Local file system at /tmp/rclone4280497776", Modify Window "1ms"
2026/07/13 03:28:11 DEBUG : sub dir2/sub sub dir2: Making directory with metadata
2026/07/13 03:28:11 INFO  : sub dir2/sub sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/07/13 03:28:11 INFO  : sub dir2: Set directory modification time (using DirSetModTime)
2026/07/13 03:28:11 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2026/07/13 03:28:11 INFO  : sub dir2: Making directory
2026/07/13 03:28:11 INFO  : sub dir2: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC
2026/07/13 03:28:11 INFO  : sub dir: Making directory
2026/07/13 03:28:12 INFO  : sub dir: Made directory with modification time 2001-02-03 04:05:06.499999999 +0000 UTC
2026/07/13 03:28:12 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/07/13 03:28:12 INFO  : sub dir2/sub sub dir2: Making directory
2026/07/13 03:28:12 DEBUG : sub dir/hello world: size = 11 OK
2026/07/13 03:28:12 DEBUG : sub dir/hello world: sha256 = b94d27b9934d3e08a52e52d7da7dabfac484efe37a5380ee9088f7ace2efcde9 OK
2026/07/13 03:28:12 INFO  : sub dir/hello world: Copied (new)
2026/07/13 03:28:12 INFO  : sub dir2/sub sub dir2: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC
2026/07/13 03:28:12 DEBUG : pixeldrain root 'rclone-test-witidap1goke': Waiting for checks to finish
2026/07/13 03:28:12 DEBUG : pixeldrain root 'rclone-test-witidap1goke': Waiting for transfers to finish
--- PASS: TestCopyEmptyDirectories (0.60s)
=== RUN   TestMoveEmptyDirectories
    run.go:198: Remote "pixeldrain root 'rclone-test-witidap1goke'", Local "Local file system at /tmp/rclone4280497776", Modify Window "1ms"
2026/07/13 03:28:12 DEBUG : sub dir2: Making directory with metadata
2026/07/13 03:28:12 INFO  : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/07/13 03:28:12 INFO  : sub dir2: Making directory
2026/07/13 03:28:12 INFO  : sub dir2: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC
2026/07/13 03:28:12 INFO  : sub dir: Making directory
2026/07/13 03:28:12 INFO  : sub dir: Made directory with modification time 2026-07-13 03:28:12.499443538 +0000 UTC
2026/07/13 03:28:12 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/07/13 03:28:12 DEBUG : pixeldrain root 'rclone-test-witidap1goke': Waiting for checks to finish
2026/07/13 03:28:12 DEBUG : pixeldrain root 'rclone-test-witidap1goke': Waiting for transfers to finish
2026/07/13 03:28:12 DEBUG : sub dir/hello world: size = 11 OK
2026/07/13 03:28:12 DEBUG : sub dir/hello world: sha256 = b94d27b9934d3e08a52e52d7da7dabfac484efe37a5380ee9088f7ace2efcde9 OK
2026/07/13 03:28:12 INFO  : sub dir/hello world: Copied (new)
2026/07/13 03:28:12 INFO  : sub dir/hello world: Deleted
--- PASS: TestMoveEmptyDirectories (0.49s)
=== RUN   TestSyncEmptyDirectories
    run.go:198: Remote "pixeldrain root 'rclone-test-witidap1goke'", Local "Local file system at /tmp/rclone4280497776", Modify Window "1ms"
2026/07/13 03:28:12 DEBUG : sub dir2: Making directory with metadata
2026/07/13 03:28:12 INFO  : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/07/13 03:28:12 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2026/07/13 03:28:13 INFO  : sub dir2: Making directory
2026/07/13 03:28:13 INFO  : sub dir2: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC
2026/07/13 03:28:13 INFO  : sub dir: Making directory
2026/07/13 03:28:13 INFO  : sub dir: Made directory with modification time 2001-02-03 04:05:06.499999999 +0000 UTC
2026/07/13 03:28:13 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/07/13 03:28:13 DEBUG : pixeldrain root 'rclone-test-witidap1goke': Waiting for checks to finish
2026/07/13 03:28:13 DEBUG : pixeldrain root 'rclone-test-witidap1goke': Waiting for transfers to finish
2026/07/13 03:28:13 DEBUG : sub dir/hello world: size = 11 OK
2026/07/13 03:28:13 DEBUG : sub dir/hello world: sha256 = b94d27b9934d3e08a52e52d7da7dabfac484efe37a5380ee9088f7ace2efcde9 OK
2026/07/13 03:28:13 INFO  : sub dir/hello world: Copied (new)
2026/07/13 03:28:13 DEBUG : Waiting for deletions to finish
--- PASS: TestSyncEmptyDirectories (0.49s)
=== RUN   TestNothingToTransferWithEmptyDirs
    run.go:198: Remote "pixeldrain root 'rclone-test-witidap1goke'", Local "Local file system at /tmp/rclone4280497776", Modify Window "1ms"
2026/07/13 03:28:13 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2026/07/13 03:28:13 INFO  : sub dir: Making directory
2026/07/13 03:28:13 INFO  : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC
2026/07/13 03:28:15 INFO  : sub dir2: Set directory modification time (using DirSetModTime)
2026/07/13 03:28:15 INFO  : sub dir2: Set directory modification time (using DirSetModTime)
2026/07/13 03:28:15 INFO  : sub dirEmpty/sub dirEmpty2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/07/13 03:28:15 INFO  : sub dirEmpty: Set directory modification time (using DirSetModTime)
--- PASS: TestNothingToTransferWithEmptyDirs (3.48s)
=== RUN   TestNothingToTransferWithoutEmptyDirs
    run.go:198: Remote "pixeldrain root 'rclone-test-witidap1goke'", Local "Local file system at /tmp/rclone4280497776", Modify Window "1ms"
2026/07/13 03:28:16 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2026/07/13 03:28:16 INFO  : sub dir: Making directory
2026/07/13 03:28:17 INFO  : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC
2026/07/13 03:28:18 INFO  : sub dir2: Set directory modification time (using DirSetModTime)
2026/07/13 03:28:18 INFO  : sub dir2: Set directory modification time (using DirSetModTime)
2026/07/13 03:28:18 INFO  : sub dirEmpty/sub dirEmpty2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/07/13 03:28:18 INFO  : sub dirEmpty: Set directory modification time (using DirSetModTime)
--- PASS: TestNothingToTransferWithoutEmptyDirs (3.00s)
PASS
2026/07/13 03:28:19 DEBUG : pixeldrain root 'rclone-test-witidap1goke': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestPixeldrain: -verbose -test.run '^(TestCopy|TestCopyEmptyDirectories|TestCopyMetadata|TestCopyMetadataNoEmptyDirs|TestMoveEmptyDirectories|TestNothingToTransferWithEmptyDirs|TestNothingToTransferWithoutEmptyDirs|TestSyncEmptyDirectories)$'" - Finished OK in 9.526450642s (try 3/5)