"./sync.test -test.v -test.timeout 1h0m0s -remote TestPixeldrain: -verbose -test.run '^(TestNothingToTransferWithEmptyDirs|TestSyncEmptyDirectories)$'" - Starting (try 5/5) 2026/03/24 03:23:54 DEBUG : Creating backend with remote "TestPixeldrain:rclone-test-xubohap1yabu" 2026/03/24 03:23:54 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/03/24 03:23:54 INFO : pixeldrain root 'rclone-test-xubohap1yabu': Logged in as 'ncw', subscription 'Prepaid', storage limit -1 2026/03/24 03:23:54 DEBUG : Creating backend with remote "/tmp/rclone923360836" === RUN TestSyncEmptyDirectories run.go:185: Remote "pixeldrain root 'rclone-test-xubohap1yabu'", Local "Local file system at /tmp/rclone923360836", Modify Window "1ms" 2026/03/24 03:23:54 DEBUG : sub dir2: Making directory with metadata 2026/03/24 03:23:54 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/03/24 03:23:54 INFO : sub dir: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:54 INFO : sub dir2: Making directory 2026/03/24 03:23:54 INFO : sub dir2: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC 2026/03/24 03:23:54 INFO : sub dir: Making directory 2026/03/24 03:23:54 INFO : sub dir: Made directory with modification time 2001-02-03 04:05:06.499999999 +0000 UTC 2026/03/24 03:23:54 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/03/24 03:23:54 DEBUG : pixeldrain root 'rclone-test-xubohap1yabu': Waiting for checks to finish 2026/03/24 03:23:54 DEBUG : pixeldrain root 'rclone-test-xubohap1yabu': Waiting for transfers to finish 2026/03/24 03:23:54 DEBUG : sub dir/hello world: size = 11 OK 2026/03/24 03:23:54 DEBUG : sub dir/hello world: sha256 = b94d27b9934d3e08a52e52d7da7dabfac484efe37a5380ee9088f7ace2efcde9 OK 2026/03/24 03:23:54 INFO : sub dir/hello world: Copied (new) 2026/03/24 03:23:54 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 |-220319h18m47.941000001s| > 1ms (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2026-03-24 03:23:54.441 +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 |-124862h23m55.258543211s| > 1ms (want 2011-12-25 12:59:59.123456789 +0000 UTC vs got 2026-03-24 03:23:54.382 +0000 UTC) (precision 1ms) --- FAIL: TestSyncEmptyDirectories (0.55s) === RUN TestNothingToTransferWithEmptyDirs run.go:185: Remote "pixeldrain root 'rclone-test-xubohap1yabu'", Local "Local file system at /tmp/rclone923360836", Modify Window "1ms" 2026/03/24 03:23:54 INFO : sub dir: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:54 INFO : sub dir: Making directory 2026/03/24 03:23:54 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/very: Modification time difference too big |-172.878227ms| > 1ms (want 2026-03-24 03:23:54.900121773 +0000 UTC vs got 2026-03-24 03:23:55.073 +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:2906 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2977 Error: Should be true Test: TestNothingToTransferWithEmptyDirs Messages: sub dir2/very/very: Modification time difference too big |-236.878227ms| > 1ms (want 2026-03-24 03:23:54.900121773 +0000 UTC vs got 2026-03-24 03:23:55.137 +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:2906 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2977 Error: Should be true Test: TestNothingToTransferWithEmptyDirs Messages: sub dir2/very/very/very/very/very/nested/subdir: Modification time difference too big |-561.878227ms| > 1ms (want 2026-03-24 03:23:54.900121773 +0000 UTC vs got 2026-03-24 03:23:55.462 +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:56 INFO : sub dir2/very: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:56 INFO : sub dir2/very/very: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:56 INFO : sub dir2/very/very/very: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:56 INFO : sub dir2/very/very/very/very: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:56 INFO : sub dir2/very/very/very/very/very: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:56 INFO : sub dir2/very/very/very/very/very/nested: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:56 INFO : sub dir2/very/very/very/very/very/nested/subdir: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:56 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:56 INFO : sub dir2/very: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:56 INFO : sub dir2/very/very: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:56 INFO : sub dir2/very/very/very: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:56 INFO : sub dir2/very/very/very/very: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:56 INFO : sub dir2/very/very/very/very/very: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:56 INFO : sub dir2/very/very/very/very/very/nested: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:56 INFO : sub dir2/very/very/very/very/very/nested/subdir: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:56 INFO : There was nothing to transfer 2026/03/24 03:23:56 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:56 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:56 INFO : sub dirEmpty/sub dirEmpty2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/03/24 03:23:56 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:2965 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2977 Error: Should be true Test: TestNothingToTransferWithEmptyDirs Messages: sub dir2/sub dir3: Modification time difference too big |-140.859476ms| > 1ms (want 2026-03-24 03:23:56.942140524 +0000 UTC vs got 2026-03-24 03:23:57.083 +0000 UTC) (precision 1ms) --- FAIL: TestNothingToTransferWithEmptyDirs (3.76s) FAIL 2026/03/24 03:23:58 DEBUG : pixeldrain root 'rclone-test-xubohap1yabu': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestPixeldrain: -verbose -test.run '^(TestNothingToTransferWithEmptyDirs|TestSyncEmptyDirectories)$'" - Finished ERROR in 4.559084756s (try 5/5): exit status 1: Failed [TestSyncEmptyDirectories TestNothingToTransferWithEmptyDirs]