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