"./sync.test -test.v -test.timeout 1h0m0s -remote TestPixeldrain: -verbose -test.run '^(TestNothingToTransferWithEmptyDirs|TestNothingToTransferWithoutEmptyDirs)$'" - Starting (try 2/5) 2025/09/13 02:54:29 DEBUG : Creating backend with remote "TestPixeldrain:rclone-test-pabiqac8puke" 2025/09/13 02:54:29 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/13 02:54:29 INFO : pixeldrain root 'rclone-test-pabiqac8puke': Logged in as 'ncw', subscription 'Prepaid', storage limit -1 2025/09/13 02:54:30 DEBUG : Creating backend with remote "/tmp/rclone303618146" === RUN TestNothingToTransferWithEmptyDirs run.go:180: Remote "pixeldrain root 'rclone-test-pabiqac8puke'", Local "Local file system at /tmp/rclone303618146", Modify Window "1ms" 2025/09/13 02:54:30 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/09/13 02:54:30 INFO : sub dir: Making directory 2025/09/13 02:54:30 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:373 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2905 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2976 Error: Should be true Test: TestNothingToTransferWithEmptyDirs Messages: sub dir2: Modification time difference too big |-740.739997ms| > 1ms (want 2025-09-13 02:54:30.137260003 +0000 UTC vs got 2025-09-13 02:54:30.878 +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:373 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2905 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2976 Error: Should be true Test: TestNothingToTransferWithEmptyDirs Messages: sub dir2/very/very/very/very/very/nested/subdir: Modification time difference too big |-2.684739997s| > 1ms (want 2025-09-13 02:54:30.137260003 +0000 UTC vs got 2025-09-13 02:54:32.822 +0000 UTC) (precision 1ms) sync_test.go:2932: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2932 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2976 Error: Should be false Test: TestNothingToTransferWithEmptyDirs Messages: expected to find no "Set directory modification time" logs, but found one: 2025/09/13 02:54:33 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2025/09/13 02:54:33 INFO : sub dir2/very/very/very/very/very/nested/subdir: Set directory modification time (using DirSetModTime) 2025/09/13 02:54:33 INFO : There was nothing to transfer sync_test.go:2934: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2934 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2976 Error: Should be false Test: TestNothingToTransferWithEmptyDirs Messages: expected to find no "directory"-related logs, but found one: 2025/09/13 02:54:33 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2025/09/13 02:54:33 INFO : sub dir2/very/very/very/very/very/nested/subdir: Set directory modification time (using DirSetModTime) 2025/09/13 02:54:33 INFO : There was nothing to transfer 2025/09/13 02:54:34 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2025/09/13 02:54:34 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2025/09/13 02:54:34 INFO : sub dirEmpty/sub dirEmpty2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/09/13 02:54:34 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:373 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2966 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2976 Error: Should be true Test: TestNothingToTransferWithEmptyDirs Messages: sub dirEmpty: Modification time difference too big |-120253h54m35.396543211s| > 1ms (want 2011-12-25 12:59:59.123456789 +0000 UTC vs got 2025-09-13 02:54:34.52 +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:373 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2966 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2976 Error: Should be true Test: TestNothingToTransferWithEmptyDirs Messages: sub dirEmpty/sub dirEmpty2: Modification time difference too big |-120253h54m35.759543211s| > 1ms (want 2011-12-25 12:59:59.123456789 +0000 UTC vs got 2025-09-13 02:54:34.883 +0000 UTC) (precision 1ms) --- FAIL: TestNothingToTransferWithEmptyDirs (6.20s) === RUN TestNothingToTransferWithoutEmptyDirs run.go:180: Remote "pixeldrain root 'rclone-test-pabiqac8puke'", Local "Local file system at /tmp/rclone303618146", Modify Window "1ms" 2025/09/13 02:54:36 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/09/13 02:54:36 INFO : sub dir: Making directory 2025/09/13 02:54:36 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC 2025/09/13 02:54:39 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2025/09/13 02:54:39 INFO : sub dir2: Set directory modification time (using DirSetModTime) 2025/09/13 02:54:39 INFO : sub dirEmpty/sub dirEmpty2: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/09/13 02:54:39 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:373 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2964 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2980 Error: Should be true Test: TestNothingToTransferWithoutEmptyDirs Messages: sub dir2/sub dir3: Modification time difference too big |-531.717445ms| > 1ms (want 2025-09-13 02:54:39.656282555 +0000 UTC vs got 2025-09-13 02:54:40.188 +0000 UTC) (precision 1ms) --- FAIL: TestNothingToTransferWithoutEmptyDirs (5.50s) FAIL 2025/09/13 02:54:41 DEBUG : pixeldrain root 'rclone-test-pabiqac8puke': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestPixeldrain: -verbose -test.run '^(TestNothingToTransferWithEmptyDirs|TestNothingToTransferWithoutEmptyDirs)$'" - Finished ERROR in 12.091167501s (try 2/5): exit status 1: Failed [TestNothingToTransferWithEmptyDirs TestNothingToTransferWithoutEmptyDirs]