"./operations.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestCheckDownload|TestCheckSum|TestCheckSumDownload|TestCount)$'" - Starting (try 2/5) 2025/05/08 06:36:27 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-zinirey3letu" 2025/05/08 06:36:27 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/05/08 06:36:27 DEBUG : Creating backend with remote "TestYandex:rclone-test-zinirey3letu" 2025/05/08 06:36:28 DEBUG : Creating backend with remote "/tmp/rclone1945554532" === RUN TestCheckDownload run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-zinirey3letu'", Local "Local file system at /tmp/rclone1945554532", Modify Window "1ns" 2025/05/08 06:36:33 INFO : rutabaga.rclone_chunk.001_xpat6p: Moved (server-side) to: rutabaga === RUN TestCheckDownload/1 === RUN TestCheckDownload/2 2025/05/08 06:36:39 INFO : empty space.rclone_chunk.001_xpb0sf: Moved (server-side) to: empty space === RUN TestCheckDownload/3 2025/05/08 06:36:48 INFO : potato2.rclone_chunk.001_xpb6p7: Moved (server-side) to: potato2.rclone_chunk.001 2025/05/08 06:36:49 INFO : potato2.rclone_chunk.002_xpb6p7: Moved (server-side) to: potato2.rclone_chunk.002 === RUN TestCheckDownload/4 === RUN TestCheckDownload/5 2025/05/08 06:37:06 INFO : remotepotato.rclone_chunk.001_xpbmrr: Moved (server-side) to: remotepotato.rclone_chunk.001 2025/05/08 06:37:07 INFO : remotepotato.rclone_chunk.002_xpbmrr: Moved (server-side) to: remotepotato.rclone_chunk.002 === RUN TestCheckDownload/6 === RUN TestCheckDownload/7 --- PASS: TestCheckDownload (84.40s) --- PASS: TestCheckDownload/1 (0.92s) --- PASS: TestCheckDownload/2 (0.74s) --- PASS: TestCheckDownload/3 (1.05s) --- PASS: TestCheckDownload/4 (2.17s) --- PASS: TestCheckDownload/5 (1.56s) --- PASS: TestCheckDownload/6 (1.52s) --- PASS: TestCheckDownload/7 (1.46s) === RUN TestCheckSum run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-zinirey3letu'", Local "Local file system at /tmp/rclone1945554532", Modify Window "1ns" 2025/05/08 06:37:52 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-zinirey3letu/data" 2025/05/08 06:37:52 DEBUG : Creating backend with remote "TestYandex:rclone-test-zinirey3letu/data" 2025/05/08 06:37:57 INFO : data/banana.rclone_chunk.001_xpd6rg: Moved (server-side) to: data/banana 2025/05/08 06:38:02 INFO : test.sum.rclone_chunk.001_xpdbww: Moved (server-side) to: test.sum === RUN TestCheckSum/subtest1 2025/05/08 06:38:09 INFO : data/potato.rclone_chunk.001_xpdili: Moved (server-side) to: data/potato 2025/05/08 06:38:19 INFO : test.sum: Deleted 2025/05/08 06:38:21 INFO : test.sum.rclone_chunk.001_xpdnlm: Moved (server-side) to: test.sum === RUN TestCheckSum/subtest2 2025/05/08 06:38:31 INFO : test.sum.rclone_chunk.001_xpe1xe: Moved (server-side) to: test.sum.rclone_chunk.001 2025/05/08 06:38:33 INFO : test.sum.rclone_chunk.002_xpe1xe: Moved (server-side) to: test.sum.rclone_chunk.002 === RUN TestCheckSum/subtest3 2025/05/08 06:38:57 INFO : test.sum.rclone_chunk.001_xpehqy: Moved (server-side) to: test.sum.rclone_chunk.001 2025/05/08 06:38:59 INFO : test.sum.rclone_chunk.002_xpehqy: Moved (server-side) to: test.sum.rclone_chunk.002 === RUN TestCheckSum/subtest4 2025/05/08 06:39:26 INFO : test.sum.rclone_chunk.001_xpf8eb: Moved (server-side) to: test.sum.rclone_chunk.001 2025/05/08 06:39:28 INFO : test.sum.rclone_chunk.002_xpf8eb: Moved (server-side) to: test.sum.rclone_chunk.002 2025/05/08 06:39:29 INFO : test.sum.rclone_chunk.003_xpf8eb: Moved (server-side) to: test.sum.rclone_chunk.003 === RUN TestCheckSum/subtest5 2025/05/08 06:40:03 INFO : test.sum.rclone_chunk.001_xpg2sa: Moved (server-side) to: test.sum.rclone_chunk.001 2025/05/08 06:40:04 INFO : test.sum.rclone_chunk.002_xpg2sa: Moved (server-side) to: test.sum.rclone_chunk.002 2025/05/08 06:40:10 INFO : test.sum.rclone_chunk.003_xpg2sa: Moved (server-side) to: test.sum.rclone_chunk.003 === RUN TestCheckSum/subtest6 2025/05/08 06:40:31 INFO : data/banana: Deleted 2025/05/08 06:40:32 INFO : data/banana.rclone_chunk.001_xph73g: Moved (server-side) to: data/banana 2025/05/08 06:40:43 INFO : data/potato: Deleted 2025/05/08 06:40:44 INFO : data/potato.rclone_chunk.001_xphmxh: Moved (server-side) to: data/potato 2025/05/08 06:41:07 INFO : test.sum.rclone_chunk.001_xphy8j: Moved (server-side) to: test.sum.rclone_chunk.001 2025/05/08 06:41:09 INFO : test.sum.rclone_chunk.002_xphy8j: Moved (server-side) to: test.sum.rclone_chunk.002 === RUN TestCheckSum/subtest7 --- PASS: TestCheckSum (237.67s) --- PASS: TestCheckSum/subtest1 (1.54s) --- PASS: TestCheckSum/subtest2 (1.61s) --- PASS: TestCheckSum/subtest3 (2.75s) --- PASS: TestCheckSum/subtest4 (2.29s) --- PASS: TestCheckSum/subtest5 (2.95s) --- PASS: TestCheckSum/subtest6 (3.62s) --- PASS: TestCheckSum/subtest7 (2.69s) === RUN TestCheckSumDownload run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-zinirey3letu'", Local "Local file system at /tmp/rclone1945554532", Modify Window "1ns" 2025/05/08 06:41:50 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-zinirey3letu/data" 2025/05/08 06:41:50 DEBUG : Config file has changed externally - reloading 2025/05/08 06:41:50 DEBUG : Creating backend with remote "TestYandex:rclone-test-zinirey3letu/data" 2025/05/08 06:41:55 INFO : data/banana.rclone_chunk.001_xpjr57: Moved (server-side) to: data/banana 2025/05/08 06:42:19 INFO : test.sum.rclone_chunk.001_xpjwpi: Moved (server-side) to: test.sum === RUN TestCheckSumDownload/subtest1 2025/05/08 06:42:28 INFO : data/potato.rclone_chunk.001_xpkoo7: Moved (server-side) to: data/potato 2025/05/08 06:42:37 INFO : test.sum: Deleted 2025/05/08 06:42:39 INFO : test.sum.rclone_chunk.001_xpkure: Moved (server-side) to: test.sum === RUN TestCheckSumDownload/subtest2 2025/05/08 06:42:50 INFO : test.sum.rclone_chunk.001_xpl7bf: Moved (server-side) to: test.sum.rclone_chunk.001 2025/05/08 06:42:52 INFO : test.sum.rclone_chunk.002_xpl7bf: Moved (server-side) to: test.sum.rclone_chunk.002 === RUN TestCheckSumDownload/subtest3 2025/05/08 06:43:17 INFO : test.sum.rclone_chunk.001_xplp68: Moved (server-side) to: test.sum.rclone_chunk.001 2025/05/08 06:43:18 INFO : test.sum.rclone_chunk.002_xplp68: Moved (server-side) to: test.sum.rclone_chunk.002 === RUN TestCheckSumDownload/subtest4 2025/05/08 06:43:47 INFO : test.sum.rclone_chunk.001_xpmg9b: Moved (server-side) to: test.sum.rclone_chunk.001 2025/05/08 06:43:49 INFO : test.sum.rclone_chunk.002_xpmg9b: Moved (server-side) to: test.sum.rclone_chunk.002 2025/05/08 06:43:50 INFO : test.sum.rclone_chunk.003_xpmg9b: Moved (server-side) to: test.sum.rclone_chunk.003 === RUN TestCheckSumDownload/subtest5 2025/05/08 06:44:24 INFO : test.sum.rclone_chunk.001_xpnca3: Moved (server-side) to: test.sum.rclone_chunk.001 2025/05/08 06:44:25 INFO : test.sum.rclone_chunk.002_xpnca3: Moved (server-side) to: test.sum.rclone_chunk.002 2025/05/08 06:44:29 INFO : test.sum.rclone_chunk.003_xpnca3: Moved (server-side) to: test.sum.rclone_chunk.003 === RUN TestCheckSumDownload/subtest6 2025/05/08 06:44:44 INFO : data/banana: Deleted 2025/05/08 06:44:46 INFO : data/banana.rclone_chunk.001_xpod7g: Moved (server-side) to: data/banana 2025/05/08 06:44:54 INFO : data/potato: Deleted 2025/05/08 06:44:56 INFO : data/potato.rclone_chunk.001_xpoog8: Moved (server-side) to: data/potato 2025/05/08 06:45:21 INFO : test.sum.rclone_chunk.001_xpoyk7: Moved (server-side) to: test.sum.rclone_chunk.001 2025/05/08 06:45:23 INFO : test.sum.rclone_chunk.002_xpoyk7: Moved (server-side) to: test.sum.rclone_chunk.002 === RUN TestCheckSumDownload/subtest7 --- PASS: TestCheckSumDownload (252.76s) --- PASS: TestCheckSumDownload/subtest1 (3.26s) --- PASS: TestCheckSumDownload/subtest2 (1.73s) --- PASS: TestCheckSumDownload/subtest3 (3.24s) --- PASS: TestCheckSumDownload/subtest4 (3.40s) --- PASS: TestCheckSumDownload/subtest5 (4.11s) --- PASS: TestCheckSumDownload/subtest6 (3.52s) --- PASS: TestCheckSumDownload/subtest7 (3.56s) === RUN TestCount run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-zinirey3letu'", Local "Local file system at /tmp/rclone1945554532", Modify Window "1ns" 2025/05/08 06:46:10 INFO : potato2.rclone_chunk.001_xpqs34: Moved (server-side) to: potato2.rclone_chunk.001 2025/05/08 06:46:12 INFO : potato2.rclone_chunk.002_xpqs34: Moved (server-side) to: potato2.rclone_chunk.002 2025/05/08 06:46:19 INFO : empty space.rclone_chunk.001_xpr3oz: Moved (server-side) to: empty space 2025/05/08 06:46:24 INFO : sub dir/potato3.rclone_chunk.001_xpr88e: Moved (server-side) to: sub dir/potato3 fstest.go:121: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:121 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:126 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:145 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:189 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:397 Error: Should be true Test: TestCount Messages: potato2: Modification time difference too big |-212642h41m6.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2025-05-08 06:46:13 +0000 UTC) (precision 1ns) --- FAIL: TestCount (54.12s) FAIL 2025/05/08 06:46:56 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-zinirey3letu': Purge remote "./operations.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestCheckDownload|TestCheckSum|TestCheckSumDownload|TestCount)$'" - Finished ERROR in 10m34.811836478s (try 2/5): exit status 1: Failed [TestCount]