"./sync.test -test.v -test.timeout 1h0m0s -remote TestPixeldrain: -verbose -test.run '^(TestMoveEmptyDirectories|TestNothingToTransferWithEmptyDirs|TestSyncEmptyDirectories)$'" - Starting (try 3/5)
2026/03/24 03:23:44 DEBUG : Creating backend with remote "TestPixeldrain:rclone-test-cajukib8baqo"
2026/03/24 03:23:44 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/03/24 03:23:44 INFO  : pixeldrain root 'rclone-test-cajukib8baqo': Logged in as 'ncw', subscription 'Prepaid', storage limit -1
2026/03/24 03:23:44 DEBUG : Creating backend with remote "/tmp/rclone1379393259"
=== RUN   TestMoveEmptyDirectories
    run.go:185: Remote "pixeldrain root 'rclone-test-cajukib8baqo'", Local "Local file system at /tmp/rclone1379393259", Modify Window "1ms"
2026/03/24 03:23:44 DEBUG : sub dir2: Making directory with metadata
2026/03/24 03:23:44 INFO  : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/03/24 03:23:44 INFO  : sub dir2: Making directory
2026/03/24 03:23:45 INFO  : sub dir2: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC
2026/03/24 03:23:45 INFO  : sub dir: Making directory
2026/03/24 03:23:45 INFO  : sub dir: Made directory with modification time 2026-03-24 03:23:44.93303025 +0000 UTC
2026/03/24 03:23:45 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/03/24 03:23:45 DEBUG : pixeldrain root 'rclone-test-cajukib8baqo': Waiting for checks to finish
2026/03/24 03:23:45 DEBUG : pixeldrain root 'rclone-test-cajukib8baqo': Waiting for transfers to finish
2026/03/24 03:23:45 DEBUG : sub dir/hello world: size = 11 OK
2026/03/24 03:23:45 DEBUG : sub dir/hello world: sha256 = b94d27b9934d3e08a52e52d7da7dabfac484efe37a5380ee9088f7ace2efcde9 OK
2026/03/24 03:23:45 INFO  : sub dir/hello world: Copied (new)
2026/03/24 03:23:45 INFO  : sub dir/hello world: Deleted
--- PASS: TestMoveEmptyDirectories (0.54s)
=== RUN   TestSyncEmptyDirectories
    run.go:185: Remote "pixeldrain root 'rclone-test-cajukib8baqo'", Local "Local file system at /tmp/rclone1379393259", Modify Window "1ms"
2026/03/24 03:23:45 DEBUG : sub dir2: Making directory with metadata
2026/03/24 03:23:45 INFO  : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/03/24 03:23:45 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2026/03/24 03:23:45 INFO  : sub dir2: Making directory
2026/03/24 03:23:45 INFO  : sub dir2: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC
2026/03/24 03:23:45 INFO  : sub dir: Making directory
2026/03/24 03:23:45 INFO  : sub dir: Made directory with modification time 2001-02-03 04:05:06.499999999 +0000 UTC
2026/03/24 03:23:45 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/03/24 03:23:45 DEBUG : pixeldrain root 'rclone-test-cajukib8baqo': Waiting for checks to finish
2026/03/24 03:23:45 DEBUG : pixeldrain root 'rclone-test-cajukib8baqo': Waiting for transfers to finish
2026/03/24 03:23:45 DEBUG : sub dir/hello world: size = 11 OK
2026/03/24 03:23:45 DEBUG : sub dir/hello world: sha256 = b94d27b9934d3e08a52e52d7da7dabfac484efe37a5380ee9088f7ace2efcde9 OK
2026/03/24 03:23:45 INFO  : sub dir/hello world: Copied (new)
2026/03/24 03:23:45 DEBUG : Waiting for deletions to finish
    fstest.go:127: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:127
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:639
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:378
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:528
        	Error:      	Should be true
        	Test:       	TestSyncEmptyDirectories
        	Messages:   	sub dir: Modification time difference too big |-220319h18m39.040000001s| > 1ms (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2026-03-24 03:23:45.54 +0000 UTC) (precision 1ms)
    fstest.go:127: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:127
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:639
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:378
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:528
        	Error:      	Should be true
        	Test:       	TestSyncEmptyDirectories
        	Messages:   	sub dir2: Modification time difference too big |-124862h23m46.354543211s| > 1ms (want 2011-12-25 12:59:59.123456789 +0000 UTC vs got 2026-03-24 03:23:45.478 +0000 UTC) (precision 1ms)
--- FAIL: TestSyncEmptyDirectories (0.50s)
=== RUN   TestNothingToTransferWithEmptyDirs
    run.go:185: Remote "pixeldrain root 'rclone-test-cajukib8baqo'", Local "Local file system at /tmp/rclone1379393259", Modify Window "1ms"
2026/03/24 03:23:45 INFO  : sub dir: Set directory modification time (using DirSetModTime)
2026/03/24 03:23:45 INFO  : sub dir: Making directory
2026/03/24 03:23:46 INFO  : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC
    fstest.go:127: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:127
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:639
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:378
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2906
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2977
        	Error:      	Should be true
        	Test:       	TestNothingToTransferWithEmptyDirs
        	Messages:   	sub dir2: Modification time difference too big |-78.960154ms| > 1ms (want 2026-03-24 03:23:45.978039846 +0000 UTC vs got 2026-03-24 03:23:46.057 +0000 UTC) (precision 1ms)
    sync_test.go:2933: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2933
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2977
        	Error:      	Should be false
        	Test:       	TestNothingToTransferWithEmptyDirs
        	Messages:   	expected to find no "Set directory modification time" logs, but found one: 2026/03/24 03:23:47 INFO  : sub dir2: Set directory modification time (using DirSetModTime)
        	            	2026/03/24 03:23:47 INFO  : There was nothing to transfer
    sync_test.go:2935: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2935
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2977
        	Error:      	Should be false
        	Test:       	TestNothingToTransferWithEmptyDirs
        	Messages:   	expected to find no "directory"-related logs, but found one: 2026/03/24 03:23:47 INFO  : sub dir2: Set directory modification time (using DirSetModTime)
        	            	2026/03/24 03:23:47 INFO  : There was nothing to transfer
2026/03/24 03:23:47 INFO  : sub dir2: Set directory modification time (using DirSetModTime)
2026/03/24 03:23:47 INFO  : sub dir2: Set directory modification time (using DirSetModTime)
2026/03/24 03:23:47 INFO  : sub dirEmpty/sub dirEmpty2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z)
2026/03/24 03:23:47 INFO  : sub dirEmpty: Set directory modification time (using DirSetModTime)
    fstest.go:127: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:127
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:639
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:378
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2967
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2977
        	Error:      	Should be true
        	Test:       	TestNothingToTransferWithEmptyDirs
        	Messages:   	sub dirEmpty: Modification time difference too big |-124862h23m48.753543211s| > 1ms (want 2011-12-25 12:59:59.123456789 +0000 UTC vs got 2026-03-24 03:23:47.877 +0000 UTC) (precision 1ms)
    fstest.go:127: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:127
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:639
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:378
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2967
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2977
        	Error:      	Should be true
        	Test:       	TestNothingToTransferWithEmptyDirs
        	Messages:   	sub dirEmpty/sub dirEmpty2: Modification time difference too big |-124862h23m48.842543211s| > 1ms (want 2011-12-25 12:59:59.123456789 +0000 UTC vs got 2026-03-24 03:23:47.966 +0000 UTC) (precision 1ms)
--- FAIL: TestNothingToTransferWithEmptyDirs (3.60s)
FAIL
2026/03/24 03:23:49 DEBUG : pixeldrain root 'rclone-test-cajukib8baqo': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestPixeldrain: -verbose -test.run '^(TestMoveEmptyDirectories|TestNothingToTransferWithEmptyDirs|TestSyncEmptyDirectories)$'" - Finished ERROR in 4.851908252s (try 3/5): exit status 1: Failed [TestSyncEmptyDirectories TestNothingToTransferWithEmptyDirs]