"./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestServerSideCopyOverSelf|TestSyncConcurrentDelete)$'" - Starting (try 3/5) 2024/10/04 02:34:22 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-suremol0sica" 2024/10/04 02:34:22 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/10/04 02:34:22 DEBUG : Creating backend with remote "TestYandex:rclone-test-suremol0sica" 2024/10/04 02:34:22 DEBUG : Reset feature "ListR" 2024/10/04 02:34:22 DEBUG : Creating backend with remote "/tmp/rclone3188711590" === RUN TestServerSideCopyOverSelf run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-suremol0sica'", Local "Local file system at /tmp/rclone3188711590", Modify Window "1ns" 2024/10/04 02:34:29 INFO : sub dir/hello world.rclone_chunk.001_te17hk: Moved (server-side) to: sub dir/hello world 2024/10/04 02:34:30 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-wudilib5yosa" 2024/10/04 02:34:30 DEBUG : Creating backend with remote "TestYandex:rclone-test-wudilib5yosa" 2024/10/04 02:34:30 DEBUG : Reset feature "ListR" sync_test.go:626: Server side copy (if possible) Chunked 'TestChunkerChunk50bYandex:rclone-test-suremol0sica' -> Chunked 'TestChunkerChunk50bYandex:rclone-test-wudilib5yosa' 2024/10/04 02:34:31 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/10/04 02:34:31 DEBUG : sub dir/hello world: copy non-chunked object... 2024/10/04 02:34:31 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-wudilib5yosa': Waiting for checks to finish 2024/10/04 02:34:31 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-wudilib5yosa': Waiting for transfers to finish 2024/10/04 02:34:33 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2024/10/04 02:34:33 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-suremol0sica'", Local "Local file system at /tmp/rclone3188711590", Modify Window "1ns" 2024/10/04 02:34:39 INFO : sub dir/hello world: Deleted 2024/10/04 02:34:41 INFO : sub dir/hello world.rclone_chunk.001_te1i8p: Moved (server-side) to: sub dir/hello world 2024/10/04 02:34:42 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/10/04 02:34:42 DEBUG : sub dir/hello world: copy non-chunked object... 2024/10/04 02:34:42 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-wudilib5yosa': Waiting for checks to finish 2024/10/04 02:34:42 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-wudilib5yosa': Waiting for transfers to finish 2024/10/04 02:34:43 ERROR : sub dir/hello world: Failed to copy: couldn't copy file: [409 - DiskResourceAlreadyExistsError] Resource "disk:/rclone-test-wudilib5yosa/sub dir/hello world" already exists. (Ресурс "disk:/rclone-test-wudilib5yosa/sub dir/hello world" уже существует.) sync_test.go:639: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:639 Error: Received unexpected error: couldn't copy file: [409 - DiskResourceAlreadyExistsError] Resource "disk:/rclone-test-wudilib5yosa/sub dir/hello world" already exists. (Ресурс "disk:/rclone-test-wudilib5yosa/sub dir/hello world" уже существует.) Test: TestServerSideCopyOverSelf 2024/10/04 02:34:43 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-wudilib5yosa': Purge remote --- FAIL: TestServerSideCopyOverSelf (28.88s) === RUN TestSyncConcurrentDelete run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-suremol0sica'", Local "Local file system at /tmp/rclone3188711590", Modify Window "1ns" 2024/10/04 02:34:56 INFO : both0.rclone_chunk.001_te202b: Moved (server-side) to: both0 2024/10/04 02:35:00 INFO : only0.rclone_chunk.001_te24mt: Moved (server-side) to: only0 2024/10/04 02:35:05 INFO : both1.rclone_chunk.001_te287t: Moved (server-side) to: both1 2024/10/04 02:35:09 INFO : only1.rclone_chunk.001_te2d0t: Moved (server-side) to: only1 2024/10/04 02:35:14 INFO : both2.rclone_chunk.001_te2hf2: Moved (server-side) to: both2 2024/10/04 02:35:20 INFO : only2.rclone_chunk.001_te2m82: Moved (server-side) to: only2 2024/10/04 02:35:24 INFO : both3.rclone_chunk.001_te2s8p: Moved (server-side) to: both3 2024/10/04 02:35:31 INFO : only3.rclone_chunk.001_te2xik: Moved (server-side) to: only3 2024/10/04 02:35:35 INFO : both4.rclone_chunk.001_te33gz: Moved (server-side) to: both4 2024/10/04 02:35:39 INFO : only4.rclone_chunk.001_te37bc: Moved (server-side) to: only4 2024/10/04 02:35:45 INFO : both5.rclone_chunk.001_te3b51: Moved (server-side) to: both5 2024/10/04 02:35:49 INFO : only5.rclone_chunk.001_te3icy: Moved (server-side) to: only5 2024/10/04 02:35:55 INFO : both6.rclone_chunk.001_te3mj6: Moved (server-side) to: both6 2024/10/04 02:35:59 INFO : only6.rclone_chunk.001_te3r3b: Moved (server-side) to: only6 2024/10/04 02:36:05 INFO : both7.rclone_chunk.001_te3w9u: Moved (server-side) to: both7 2024/10/04 02:36:10 INFO : only7.rclone_chunk.001_te41um: Moved (server-side) to: only7 2024/10/04 02:36:14 INFO : both8.rclone_chunk.001_te463h: Moved (server-side) to: both8 2024/10/04 02:36:19 INFO : only8.rclone_chunk.001_te4bij: Moved (server-side) to: only8 2024/10/04 02:36:24 INFO : both9.rclone_chunk.001_te4fwa: Moved (server-side) to: both9 2024/10/04 02:36:29 INFO : only9.rclone_chunk.001_te4kkt: Moved (server-side) to: only9 2024/10/04 02:36:33 INFO : both10.rclone_chunk.001_te4pyg: Moved (server-side) to: both10 2024/10/04 02:36:38 INFO : only10.rclone_chunk.001_te4ts1: Moved (server-side) to: only10 2024/10/04 02:36:43 INFO : both11.rclone_chunk.001_te4ywo: Moved (server-side) to: both11 2024/10/04 02:36:48 INFO : only11.rclone_chunk.001_te53dd: Moved (server-side) to: only11 2024/10/04 02:36:53 INFO : both12.rclone_chunk.001_te5822: Moved (server-side) to: both12 2024/10/04 02:36:58 INFO : only12.rclone_chunk.001_te5dxu: Moved (server-side) to: only12 2024/10/04 02:37:04 INFO : both13.rclone_chunk.001_te5jx0: Moved (server-side) to: both13 2024/10/04 02:37:09 INFO : only13.rclone_chunk.001_te5pni: Moved (server-side) to: only13 2024/10/04 02:37:14 INFO : both14.rclone_chunk.001_te5tkw: Moved (server-side) to: both14 2024/10/04 02:37:19 INFO : only14.rclone_chunk.001_te5yah: Moved (server-side) to: only14 2024/10/04 02:37:24 INFO : both15.rclone_chunk.001_te63a4: Moved (server-side) to: both15 2024/10/04 02:37:29 INFO : only15.rclone_chunk.001_te68mk: Moved (server-side) to: only15 2024/10/04 02:37:35 INFO : both16.rclone_chunk.001_te6emi: Moved (server-side) to: both16 2024/10/04 02:37:39 INFO : only16.rclone_chunk.001_te6jbk: Moved (server-side) to: only16 2024/10/04 02:37:43 INFO : both17.rclone_chunk.001_te6npp: Moved (server-side) to: both17 2024/10/04 02:37:48 INFO : only17.rclone_chunk.001_te6s5e: Moved (server-side) to: only17 2024/10/04 02:37:56 INFO : both18.rclone_chunk.001_te6w3x: Moved (server-side) to: both18 2024/10/04 02:38:03 INFO : only18.rclone_chunk.001_te74zb: Moved (server-side) to: only18 2024/10/04 02:38:08 INFO : both19.rclone_chunk.001_te7bk4: Moved (server-side) to: both19 2024/10/04 02:38:12 INFO : only19.rclone_chunk.001_te7gus: Moved (server-side) to: only19 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/sync/sync_test.go:2744 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2758 Error: Should be true Test: TestSyncConcurrentDelete Messages: only8: Modification time difference too big |-207454h31m11.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2024-10-04 02:36:18 +0000 UTC) (precision 1ns) 2024/10/04 02:38:13 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/04 02:38:13 DEBUG : both0: Unchanged skipping 2024/10/04 02:38:13 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/04 02:38:13 DEBUG : both1: Unchanged skipping 2024/10/04 02:38:13 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/04 02:38:13 DEBUG : both10: Unchanged skipping 2024/10/04 02:38:13 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/04 02:38:13 DEBUG : both11: Unchanged skipping 2024/10/04 02:38:13 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/04 02:38:13 DEBUG : both12: Unchanged skipping 2024/10/04 02:38:13 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/04 02:38:13 DEBUG : both13: Unchanged skipping 2024/10/04 02:38:13 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/04 02:38:13 DEBUG : both14: Unchanged skipping 2024/10/04 02:38:13 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/04 02:38:13 DEBUG : both15: Unchanged skipping 2024/10/04 02:38:13 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/04 02:38:13 DEBUG : both16: Unchanged skipping 2024/10/04 02:38:13 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/04 02:38:13 DEBUG : both17: Unchanged skipping 2024/10/04 02:38:13 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/04 02:38:13 DEBUG : both18: Unchanged skipping 2024/10/04 02:38:13 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/04 02:38:13 DEBUG : both19: Unchanged skipping 2024/10/04 02:38:13 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/04 02:38:13 DEBUG : both2: Unchanged skipping 2024/10/04 02:38:13 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/04 02:38:13 DEBUG : both3: Unchanged skipping 2024/10/04 02:38:13 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/04 02:38:13 DEBUG : both4: Unchanged skipping 2024/10/04 02:38:13 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/04 02:38:13 DEBUG : both5: Unchanged skipping 2024/10/04 02:38:13 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/04 02:38:13 DEBUG : both6: Unchanged skipping 2024/10/04 02:38:13 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/04 02:38:13 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/04 02:38:13 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/04 02:38:13 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-suremol0sica': Waiting for checks to finish 2024/10/04 02:38:13 DEBUG : both7: Unchanged skipping 2024/10/04 02:38:13 DEBUG : both8: Unchanged skipping 2024/10/04 02:38:13 DEBUG : both9: Unchanged skipping 2024/10/04 02:38:13 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-suremol0sica': Waiting for transfers to finish 2024/10/04 02:38:13 DEBUG : Waiting for deletions to finish 2024/10/04 02:38:14 INFO : only9: Deleted 2024/10/04 02:38:14 INFO : only13: Deleted 2024/10/04 02:38:14 INFO : only11: Deleted 2024/10/04 02:38:14 INFO : only4: Deleted 2024/10/04 02:38:15 INFO : only17: Deleted 2024/10/04 02:38:15 INFO : only8: Deleted 2024/10/04 02:38:16 INFO : only16: Deleted 2024/10/04 02:38:16 INFO : only6: Deleted 2024/10/04 02:38:17 INFO : only12: Deleted 2024/10/04 02:38:17 INFO : only19: Deleted 2024/10/04 02:38:18 INFO : only18: Deleted 2024/10/04 02:38:18 INFO : only2: Deleted 2024/10/04 02:38:19 INFO : only10: Deleted 2024/10/04 02:38:19 INFO : only3: Deleted 2024/10/04 02:38:19 INFO : only0: Deleted 2024/10/04 02:38:20 INFO : only5: Deleted 2024/10/04 02:38:20 INFO : only14: Deleted 2024/10/04 02:38:20 INFO : only7: Deleted 2024/10/04 02:38:20 INFO : only1: Deleted 2024/10/04 02:38:21 INFO : only15: Deleted run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-suremol0sica'", Local "Local file system at /tmp/rclone3188711590", Modify Window "1ns" --- FAIL: TestSyncConcurrentDelete (239.23s) FAIL 2024/10/04 02:38:50 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-suremol0sica': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestServerSideCopyOverSelf|TestSyncConcurrentDelete)$'" - Finished ERROR in 4m29.840024958s (try 3/5): exit status 1: Failed [TestServerSideCopyOverSelf TestSyncConcurrentDelete]