"./sync.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -test.run '^(TestNothingToTransferWithEmptyDirs|TestSyncAfterChangingModtimeOnly|TestSyncReplaceDirModTimeWithEmptyDirs|TestSyncWithUpdateOlder)$'" - Starting (try 2/5) 2025/09/15 03:11:31 DEBUG : Creating backend with remote "TestPcloud:rclone-test-xuvideh4mena" 2025/09/15 03:11:31 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/09/15 03:11:31 DEBUG : Creating backend with remote "/tmp/rclone142409232" === RUN TestSyncAfterChangingModtimeOnly run.go:180: Remote "pcloud root 'rclone-test-xuvideh4mena'", Local "Local file system at /tmp/rclone142409232", Modify Window "1s" fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure 2025/09/15 03:11:40 DEBUG : empty space: Modification times differ by -95456h54m53.123456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06 +0000 UTC 2025/09/15 03:11:40 DEBUG : pcloud root 'rclone-test-xuvideh4mena': Waiting for checks to finish 2025/09/15 03:11:40 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2025/09/15 03:11:40 NOTICE: empty space: Skipped update modification time as --dry-run is set (size 1) 2025/09/15 03:11:40 DEBUG : empty space: Unchanged skipping 2025/09/15 03:11:40 DEBUG : pcloud root 'rclone-test-xuvideh4mena': Waiting for transfers to finish 2025/09/15 03:11:40 DEBUG : Waiting for deletions to finish 2025/09/15 03:11:40 INFO : There was nothing to transfer 2025/09/15 03:11:40 DEBUG : pcloud root 'rclone-test-xuvideh4mena': Waiting for checks to finish 2025/09/15 03:11:40 DEBUG : empty space: Modification times differ by -95456h54m53.123456789s: 2011-12-25 12:59:59.123456789 +0000 UTC, 2001-02-03 04:05:06 +0000 UTC 2025/09/15 03:11:40 DEBUG : empty space: sha1 = 3bc15c8aae3e4124dd409035f32ea2fd6835efc9 OK 2025/09/15 03:11:40 INFO : empty space: Updated modification time in destination 2025/09/15 03:11:40 DEBUG : empty space: Unchanged skipping 2025/09/15 03:11:40 DEBUG : pcloud root 'rclone-test-xuvideh4mena': Waiting for transfers to finish 2025/09/15 03:11:40 DEBUG : Waiting for deletions to finish 2025/09/15 03:11:40 INFO : There was nothing to transfer 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:132 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:151 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:195 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1037 Error: Should be true Test: TestSyncAfterChangingModtimeOnly Messages: empty space: Modification time difference too big |95456h54m53.123456789s| > 1s (want 2011-12-25 12:59:59.123456789 +0000 UTC vs got 2001-02-03 04:05:06 +0000 UTC) (precision 1s) fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- FAIL: TestSyncAfterChangingModtimeOnly (16.33s) === RUN TestSyncWithUpdateOlder run.go:180: Remote "pcloud root 'rclone-test-xuvideh4mena'", Local "Local file system at /tmp/rclone142409232", Modify Window "1s" fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure 2025/09/15 03:11:56 DEBUG : five: Need to transfer - File not found at Destination 2025/09/15 03:11:56 DEBUG : four: Sizes differ (src 4 vs dst 8) 2025/09/15 03:11:56 DEBUG : one: Destination is newer than source, skipping 2025/09/15 03:11:56 DEBUG : three: Sizes identical 2025/09/15 03:11:56 DEBUG : pcloud root 'rclone-test-xuvideh4mena': Waiting for checks to finish 2025/09/15 03:11:56 DEBUG : four: Destination mod time is within 1s of source but files differ, transferring 2025/09/15 03:11:56 DEBUG : three: Destination mod time is within 1s of source and files identical, skipping 2025/09/15 03:11:56 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2025/09/15 03:11:56 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b (Local file system at /tmp/rclone142409232) 2025/09/15 03:11:56 DEBUG : two: sha1 = b10e0da85e90399abfec36c7376b20aa4596461b (pcloud root 'rclone-test-xuvideh4mena') 2025/09/15 03:11:56 DEBUG : two: sha1 differ 2025/09/15 03:11:56 DEBUG : pcloud root 'rclone-test-xuvideh4mena': Waiting for transfers to finish 2025/09/15 03:11:56 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2025/09/15 03:11:56 DEBUG : five.0fee171d.partial: renamed to: five 2025/09/15 03:11:56 INFO : five: Copied (new) 2025/09/15 03:11:56 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2025/09/15 03:11:56 DEBUG : four.f852663a.partial: renamed to: four 2025/09/15 03:11:56 INFO : four: Copied (replaced existing) 2025/09/15 03:11:56 DEBUG : two.8549bf6d.partial: renamed to: two 2025/09/15 03:11:56 INFO : two: Copied (replaced existing) 2025/09/15 03:11:56 DEBUG : Waiting for deletions to finish 2025/09/15 03:11:57 DEBUG : one: Destination is newer than source, skipping 2025/09/15 03:11:57 DEBUG : pcloud root 'rclone-test-xuvideh4mena': Waiting for checks to finish 2025/09/15 03:11:57 DEBUG : five: sha1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2025/09/15 03:11:57 DEBUG : five: Size and sha1 of src and dst objects identical 2025/09/15 03:11:57 DEBUG : five: Destination mod time is within 1s of source and files identical, skipping 2025/09/15 03:11:57 DEBUG : four: sha1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2025/09/15 03:11:57 DEBUG : four: Size and sha1 of src and dst objects identical 2025/09/15 03:11:57 DEBUG : four: Destination mod time is within 1s of source and files identical, skipping 2025/09/15 03:11:57 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb (Local file system at /tmp/rclone142409232) 2025/09/15 03:11:57 DEBUG : three: sha1 = 03731cad13f4cf7b59703c77529381cdec1632e5 (pcloud root 'rclone-test-xuvideh4mena') 2025/09/15 03:11:57 DEBUG : three: sha1 differ 2025/09/15 03:11:57 DEBUG : three: Destination mod time is within 1s of source but files differ, transferring 2025/09/15 03:11:57 DEBUG : two: sha1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2025/09/15 03:11:57 DEBUG : two: Size and sha1 of src and dst objects identical 2025/09/15 03:11:57 DEBUG : two: Destination mod time is within 1s of source and files identical, skipping 2025/09/15 03:11:57 DEBUG : pcloud root 'rclone-test-xuvideh4mena': Waiting for transfers to finish 2025/09/15 03:11:57 DEBUG : three: sha1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2025/09/15 03:11:57 DEBUG : three.7d26d052.partial: renamed to: three 2025/09/15 03:11:57 INFO : three: Copied (replaced existing) 2025/09/15 03:11:57 DEBUG : Waiting for deletions to finish --- PASS: TestSyncWithUpdateOlder (10.54s) === RUN TestSyncReplaceDirModTimeWithEmptyDirs run.go:180: Remote "pcloud root 'rclone-test-xuvideh4mena'", Local "Local file system at /tmp/rclone142409232", Modify Window "1s" 2025/09/15 03:11:58 DEBUG : empty_dir: Making directory with metadata 2025/09/15 03:11:58 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/09/15 03:11:58 DEBUG : empty_on_remote: Making directory with metadata 2025/09/15 03:11:58 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/09/15 03:11:58 INFO : empty_on_remote: Making directory 2025/09/15 03:11:59 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC 2025/09/15 03:12:00 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/09/15 03:12:00 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/09/15 03:12:00 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/09/15 03:12:00 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) 2025/09/15 03:12:00 INFO : empty_dir: Set directory modification time (using DirSetModTime) fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestSyncReplaceDirModTimeWithEmptyDirs (10.43s) === RUN TestNothingToTransferWithEmptyDirs run.go:180: Remote "pcloud root 'rclone-test-xuvideh4mena'", Local "Local file system at /tmp/rclone142409232", Modify Window "1s" 2025/09/15 03:12:09 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/09/15 03:12:09 INFO : sub dir: Making directory 2025/09/15 03:12:09 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC --- PASS: TestNothingToTransferWithEmptyDirs (4.33s) FAIL 2025/09/15 03:12:13 DEBUG : pcloud root 'rclone-test-xuvideh4mena': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose -test.run '^(TestNothingToTransferWithEmptyDirs|TestSyncAfterChangingModtimeOnly|TestSyncReplaceDirModTimeWithEmptyDirs|TestSyncWithUpdateOlder)$'" - Finished ERROR in 42.690015047s (try 2/5): exit status 1: Failed [TestSyncAfterChangingModtimeOnly]