"./sync.test -test.v -test.timeout 1h0m0s -remote TestPixeldrain: -verbose -test.run '^(TestNothingToTransferWithEmptyDirs|TestSyncEmptyDirectories)$'" - Starting (try 4/5) 2026/03/24 03:23:49 DEBUG : Creating backend with remote "TestPixeldrain:rclone-test-qapuveq6xitu" 2026/03/24 03:23:49 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/03/24 03:23:49 INFO : pixeldrain root 'rclone-test-qapuveq6xitu': Logged in as 'ncw', subscription 'Prepaid', storage limit -1 2026/03/24 03:23:49 DEBUG : Creating backend with remote "/tmp/rclone358204403" === RUN TestSyncEmptyDirectories run.go:185: Remote "pixeldrain root 'rclone-test-qapuveq6xitu'", Local "Local file system at /tmp/rclone358204403", Modify Window "1ms" 2026/03/24 03:23:49 DEBUG : sub dir2: Making directory with metadata 2026/03/24 03:23:49 INFO : sub dir2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/03/24 03:23:49 INFO : sub dir: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:49 INFO : sub dir2: Making directory 2026/03/24 03:23:49 INFO : sub dir2: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC 2026/03/24 03:23:49 INFO : sub dir: Making directory 2026/03/24 03:23:49 INFO : sub dir: Made directory with modification time 2001-02-03 04:05:06.499999999 +0000 UTC 2026/03/24 03:23:49 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/03/24 03:23:49 DEBUG : pixeldrain root 'rclone-test-qapuveq6xitu': Waiting for checks to finish 2026/03/24 03:23:49 DEBUG : pixeldrain root 'rclone-test-qapuveq6xitu': Waiting for transfers to finish 2026/03/24 03:23:49 DEBUG : sub dir/hello world: size = 11 OK 2026/03/24 03:23:49 DEBUG : sub dir/hello world: sha256 = b94d27b9934d3e08a52e52d7da7dabfac484efe37a5380ee9088f7ace2efcde9 OK 2026/03/24 03:23:49 INFO : sub dir/hello world: Copied (new) 2026/03/24 03:23:49 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 |-220319h18m43.372000001s| > 1ms (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2026-03-24 03:23:49.872 +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 |-124862h23m50.689543211s| > 1ms (want 2011-12-25 12:59:59.123456789 +0000 UTC vs got 2026-03-24 03:23:49.813 +0000 UTC) (precision 1ms) --- FAIL: TestSyncEmptyDirectories (0.54s) === RUN TestNothingToTransferWithEmptyDirs run.go:185: Remote "pixeldrain root 'rclone-test-qapuveq6xitu'", Local "Local file system at /tmp/rclone358204403", Modify Window "1ms" 2026/03/24 03:23:50 INFO : sub dir: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:50 INFO : sub dir: Making directory 2026/03/24 03:23:50 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 |-170.920284ms| > 1ms (want 2026-03-24 03:23:50.320079716 +0000 UTC vs got 2026-03-24 03:23:50.491 +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 |-241.920284ms| > 1ms (want 2026-03-24 03:23:50.320079716 +0000 UTC vs got 2026-03-24 03:23:50.562 +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 |-566.920284ms| > 1ms (want 2026-03-24 03:23:50.320079716 +0000 UTC vs got 2026-03-24 03:23:50.887 +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:51 INFO : sub dir2/very: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:51 INFO : sub dir2/very/very: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:51 INFO : sub dir2/very/very/very: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:51 INFO : sub dir2/very/very/very/very: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:51 INFO : sub dir2/very/very/very/very/very: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:51 INFO : sub dir2/very/very/very/very/very/nested: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:51 INFO : sub dir2/very/very/very/very/very/nested/subdir: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:51 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:51 INFO : sub dir2/very: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:51 INFO : sub dir2/very/very: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:51 INFO : sub dir2/very/very/very: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:51 INFO : sub dir2/very/very/very/very: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:51 INFO : sub dir2/very/very/very/very/very: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:51 INFO : sub dir2/very/very/very/very/very/nested: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:51 INFO : sub dir2/very/very/very/very/very/nested/subdir: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:51 INFO : There was nothing to transfer 2026/03/24 03:23:52 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:52 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2026/03/24 03:23:52 INFO : sub dirEmpty/sub dirEmpty2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/03/24 03:23:52 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 |-133.901505ms| > 1ms (want 2026-03-24 03:23:52.365098495 +0000 UTC vs got 2026-03-24 03:23:52.499 +0000 UTC) (precision 1ms) --- FAIL: TestNothingToTransferWithEmptyDirs (3.78s) FAIL 2026/03/24 03:23:54 DEBUG : pixeldrain root 'rclone-test-qapuveq6xitu': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestPixeldrain: -verbose -test.run '^(TestNothingToTransferWithEmptyDirs|TestSyncEmptyDirectories)$'" - Finished ERROR in 4.528014438s (try 4/5): exit status 1: Failed [TestSyncEmptyDirectories TestNothingToTransferWithEmptyDirs]