"./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestServerSideMoveWithFilter|TestSyncAfterRemovingAFileAndAddingAFile|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffixKeepExtension|TestSyncConcurrentDelete|TestSyncConcurrentTruncate|TestSyncSuffixKeepExtension)$'" - Starting (try 2/5) 2025/02/20 03:28:38 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-rebomog5meji" 2025/02/20 03:28:38 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/02/20 03:28:38 DEBUG : Creating backend with remote "TestYandex:rclone-test-rebomog5meji" 2025/02/20 03:28:39 DEBUG : Reset feature "ListR" 2025/02/20 03:28:39 DEBUG : Creating backend with remote "/tmp/rclone4289080924" === RUN TestSyncAfterRemovingAFileAndAddingAFile run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji'", Local "Local file system at /tmp/rclone4289080924", Modify Window "1ns" 2025/02/20 03:28:45 INFO : potato.rclone_chunk.001_yv91lo: Moved (server-side) to: potato 2025/02/20 03:28:52 INFO : empty space.rclone_chunk.001_yv972a: Moved (server-side) to: empty space 2025/02/20 03:28:53 DEBUG : potato2: Need to transfer - File not found at Destination 2025/02/20 03:28:53 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:28:53 DEBUG : empty space: Unchanged skipping 2025/02/20 03:28:53 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji': Waiting for checks to finish 2025/02/20 03:28:53 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji': Waiting for transfers to finish 2025/02/20 03:28:53 DEBUG : potato2: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:29:02 INFO : potato2.rclone_chunk.001_yv9es9: Moved (server-side) to: potato2.rclone_chunk.001 2025/02/20 03:29:04 INFO : potato2.rclone_chunk.002_yv9es9: Moved (server-side) to: potato2.rclone_chunk.002 2025/02/20 03:29:07 DEBUG : potato2: md5 = d6548b156ea68a4e003e786df99eee76 OK 2025/02/20 03:29:07 INFO : potato2: Copied (new) 2025/02/20 03:29:07 DEBUG : Waiting for deletions to finish 2025/02/20 03:29:10 INFO : potato: Deleted run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji'", Local "Local file system at /tmp/rclone4289080924", Modify Window "1ns" --- PASS: TestSyncAfterRemovingAFileAndAddingAFile (48.71s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji'", Local "Local file system at /tmp/rclone4289080924", Modify Window "1ns" 2025/02/20 03:29:27 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-riviwib4godi" 2025/02/20 03:29:27 DEBUG : Creating backend with remote "TestYandex:rclone-test-riviwib4godi" 2025/02/20 03:29:28 DEBUG : Reset feature "ListR" 2025/02/20 03:29:35 INFO : potato2.rclone_chunk.001_yvadjo: Moved (server-side) to: potato2.rclone_chunk.001 2025/02/20 03:29:38 INFO : potato2.rclone_chunk.002_yvadjo: Moved (server-side) to: potato2.rclone_chunk.002 2025/02/20 03:29:46 INFO : empty space.rclone_chunk.001_yvaqel: Moved (server-side) to: empty space 2025/02/20 03:29:52 INFO : potato3.rclone_chunk.001_yvaviq: Moved (server-side) to: potato3.rclone_chunk.001 2025/02/20 03:29:54 INFO : potato3.rclone_chunk.002_yvaviq: Moved (server-side) to: potato3.rclone_chunk.002 sync_test.go:1705: Server side move (if possible) Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji' -> Chunked 'TestChunkerChunk50bYandex:rclone-test-riviwib4godi' 2025/02/20 03:30:03 INFO : empty space.rclone_chunk.001_yvb78q: Moved (server-side) to: empty space 2025/02/20 03:30:10 INFO : potato3.rclone_chunk.001_yvbcbl: Moved (server-side) to: potato3.rclone_chunk.001 2025/02/20 03:30:12 INFO : potato3.rclone_chunk.002_yvbcbl: Moved (server-side) to: potato3.rclone_chunk.002 2025/02/20 03:30:17 DEBUG : empty space: Excluded (Size Filter) 2025/02/20 03:30:17 DEBUG : empty space: Excluded 2025/02/20 03:30:21 DEBUG : empty space: Excluded (Size Filter) 2025/02/20 03:30:21 DEBUG : empty space: Excluded 2025/02/20 03:30:21 DEBUG : potato2: Need to transfer - File not found at Destination 2025/02/20 03:30:21 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/02/20 03:30:21 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-riviwib4godi': Waiting for checks to finish 2025/02/20 03:30:21 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-riviwib4godi': Waiting for transfers to finish 2025/02/20 03:30:21 DEBUG : potato2: move 2 data chunks... 2025/02/20 03:30:23 INFO : potato2.rclone_chunk.001: Moved (server-side) 2025/02/20 03:30:25 INFO : potato2.rclone_chunk.002: Moved (server-side) 2025/02/20 03:30:27 INFO : potato2: Moved (server-side) 2025/02/20 03:30:29 INFO : potato2: Moved (server-side) 2025/02/20 03:30:32 INFO : potato3: Deleted 2025/02/20 03:30:32 DEBUG : potato3: move 2 data chunks... 2025/02/20 03:30:34 INFO : potato3.rclone_chunk.001: Moved (server-side) 2025/02/20 03:30:36 INFO : potato3.rclone_chunk.002: Moved (server-side) 2025/02/20 03:30:38 INFO : potato3: Moved (server-side) 2025/02/20 03:30:40 INFO : potato3: Moved (server-side) 2025/02/20 03:30:41 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-bihitep0gora" 2025/02/20 03:30:41 DEBUG : Creating backend with remote "TestYandex:rclone-test-bihitep0gora" 2025/02/20 03:30:42 DEBUG : Reset feature "ListR" 2025/02/20 03:30:42 DEBUG : empty space: Excluded (Size Filter) 2025/02/20 03:30:42 DEBUG : empty space: Excluded 2025/02/20 03:30:42 DEBUG : potato2: Need to transfer - File not found at Destination 2025/02/20 03:30:42 DEBUG : potato3: Need to transfer - File not found at Destination 2025/02/20 03:30:42 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-bihitep0gora': Waiting for checks to finish 2025/02/20 03:30:42 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-bihitep0gora': Waiting for transfers to finish 2025/02/20 03:30:42 DEBUG : potato3: move 2 data chunks... 2025/02/20 03:30:42 DEBUG : potato2: move 2 data chunks... 2025/02/20 03:30:44 INFO : potato3.rclone_chunk.001: Moved (server-side) 2025/02/20 03:30:44 INFO : potato2.rclone_chunk.001: Moved (server-side) 2025/02/20 03:30:45 INFO : potato3.rclone_chunk.002: Moved (server-side) 2025/02/20 03:30:46 INFO : potato2.rclone_chunk.002: Moved (server-side) 2025/02/20 03:30:48 INFO : potato3: Moved (server-side) 2025/02/20 03:30:48 INFO : potato2: Moved (server-side) 2025/02/20 03:30:49 INFO : potato3: Moved (server-side) 2025/02/20 03:30:50 INFO : potato2: Moved (server-side) 2025/02/20 03:30:53 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-bihitep0gora': Purge remote 2025/02/20 03:31:01 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-riviwib4godi': Purge remote --- PASS: TestServerSideMoveWithFilter (103.51s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji'", Local "Local file system at /tmp/rclone4289080924", Modify Window "1ns" 2025/02/20 03:31:16 INFO : dst/one.rclone_chunk.001_yvd8u2: Moved (server-side) to: dst/one 2025/02/20 03:31:21 INFO : dst/two.rclone_chunk.001_yvdd79: Moved (server-side) to: dst/two 2025/02/20 03:31:25 INFO : dst/three.txt.rclone_chunk.001_yvdirj: Moved (server-side) to: dst/three.txt 2025/02/20 03:31:26 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-rebomog5meji/dst" 2025/02/20 03:31:26 DEBUG : Creating backend with remote "TestYandex:rclone-test-rebomog5meji/dst" 2025/02/20 03:31:26 DEBUG : Reset feature "ListR" 2025/02/20 03:31:26 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-rebomog5meji/backup" 2025/02/20 03:31:26 DEBUG : Creating backend with remote "TestYandex:rclone-test-rebomog5meji/backup" 2025/02/20 03:31:26 DEBUG : Reset feature "ListR" 2025/02/20 03:31:27 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/02/20 03:31:27 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:31:27 DEBUG : two: Unchanged skipping 2025/02/20 03:31:27 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji/dst': Waiting for checks to finish 2025/02/20 03:31:27 DEBUG : one: move non-chunked object... 2025/02/20 03:31:29 INFO : one: Moved (server-side) to: one-2019-01-01 2025/02/20 03:31:29 INFO : one: Moved (server-side) to: one-2019-01-01 2025/02/20 03:31:29 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji/dst': Waiting for transfers to finish 2025/02/20 03:31:29 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:31:34 INFO : one.rclone_chunk.001_yvdqnx: Moved (server-side) to: one 2025/02/20 03:31:34 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2025/02/20 03:31:34 INFO : one: Copied (new) 2025/02/20 03:31:34 DEBUG : Waiting for deletions to finish 2025/02/20 03:31:34 DEBUG : three.txt: move non-chunked object... 2025/02/20 03:31:36 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/02/20 03:31:36 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/02/20 03:31:36 INFO : three.txt: Moved into backup dir 2025/02/20 03:31:42 INFO : dst/three.txt.rclone_chunk.001_yvdyn0: Moved (server-side) to: dst/three.txt 2025/02/20 03:31:43 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/02/20 03:31:43 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:31:43 DEBUG : two: Unchanged skipping 2025/02/20 03:31:43 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji/dst': Waiting for checks to finish 2025/02/20 03:31:47 INFO : one-2019-01-01: Deleted 2025/02/20 03:31:47 DEBUG : one: move non-chunked object... 2025/02/20 03:31:49 INFO : one: Moved (server-side) to: one-2019-01-01 2025/02/20 03:31:49 INFO : one: Moved (server-side) to: one-2019-01-01 2025/02/20 03:31:49 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji/dst': Waiting for transfers to finish 2025/02/20 03:31:49 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:31:54 INFO : one.rclone_chunk.001_yveacq: Moved (server-side) to: one 2025/02/20 03:31:54 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2025/02/20 03:31:54 INFO : one: Copied (new) 2025/02/20 03:31:54 DEBUG : Waiting for deletions to finish 2025/02/20 03:31:58 INFO : three-2019-01-01.txt: Deleted 2025/02/20 03:31:58 DEBUG : three.txt: move non-chunked object... 2025/02/20 03:32:00 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/02/20 03:32:00 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/02/20 03:32:00 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (74.28s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji'", Local "Local file system at /tmp/rclone4289080924", Modify Window "1ns" 2025/02/20 03:32:33 INFO : dst/one.rclone_chunk.001_yvfbx8: Moved (server-side) to: dst/one 2025/02/20 03:32:42 INFO : dst/two.rclone_chunk.001_yvfjh0: Moved (server-side) to: dst/two 2025/02/20 03:32:47 INFO : dst/three.txt.rclone_chunk.001_yvfs4l: Moved (server-side) to: dst/three.txt 2025/02/20 03:32:48 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-rebomog5meji/dst" 2025/02/20 03:32:48 DEBUG : Creating backend with remote "TestYandex:rclone-test-rebomog5meji/dst" 2025/02/20 03:32:49 DEBUG : Reset feature "ListR" 2025/02/20 03:32:49 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/02/20 03:32:49 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:32:49 DEBUG : two: Unchanged skipping 2025/02/20 03:32:49 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji/dst': Waiting for checks to finish 2025/02/20 03:32:49 DEBUG : one: move non-chunked object... 2025/02/20 03:32:51 INFO : one: Moved (server-side) to: one.bak 2025/02/20 03:32:51 INFO : one: Moved (server-side) to: one.bak 2025/02/20 03:32:51 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji/dst': Waiting for transfers to finish 2025/02/20 03:32:51 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:32:56 INFO : one.rclone_chunk.001_yvg0op: Moved (server-side) to: one 2025/02/20 03:32:56 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2025/02/20 03:32:56 INFO : one: Copied (new) 2025/02/20 03:32:56 DEBUG : Waiting for deletions to finish 2025/02/20 03:32:56 DEBUG : three.txt: move non-chunked object... 2025/02/20 03:32:57 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/02/20 03:32:57 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/02/20 03:32:57 INFO : three.txt: Moved into backup dir 2025/02/20 03:33:07 INFO : dst/three.txt.rclone_chunk.001_yvgasa: Moved (server-side) to: dst/three.txt 2025/02/20 03:33:08 DEBUG : one.bak: Excluded (Path Filter) 2025/02/20 03:33:08 DEBUG : one.bak: Excluded 2025/02/20 03:33:08 DEBUG : three.txt.bak: Excluded (Path Filter) 2025/02/20 03:33:08 DEBUG : three.txt.bak: Excluded 2025/02/20 03:33:08 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/02/20 03:33:08 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:33:08 DEBUG : two: Unchanged skipping 2025/02/20 03:33:08 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji/dst': Waiting for checks to finish 2025/02/20 03:33:12 INFO : one.bak: Deleted 2025/02/20 03:33:12 DEBUG : one: move non-chunked object... 2025/02/20 03:33:14 INFO : one: Moved (server-side) to: one.bak 2025/02/20 03:33:14 INFO : one: Moved (server-side) to: one.bak 2025/02/20 03:33:14 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji/dst': Waiting for transfers to finish 2025/02/20 03:33:14 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:33:19 INFO : one.rclone_chunk.001_yvgnsp: Moved (server-side) to: one 2025/02/20 03:33:19 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2025/02/20 03:33:19 INFO : one: Copied (new) 2025/02/20 03:33:19 DEBUG : Waiting for deletions to finish 2025/02/20 03:33:23 INFO : three.txt.bak: Deleted 2025/02/20 03:33:23 DEBUG : three.txt: move non-chunked object... 2025/02/20 03:33:25 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/02/20 03:33:25 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/02/20 03:33:25 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (79.80s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji'", Local "Local file system at /tmp/rclone4289080924", Modify Window "1ns" 2025/02/20 03:33:50 INFO : dst/one.rclone_chunk.001_yvhic5: Moved (server-side) to: dst/one 2025/02/20 03:33:55 INFO : dst/two.rclone_chunk.001_yvhnyk: Moved (server-side) to: dst/two 2025/02/20 03:33:59 INFO : dst/three.txt.rclone_chunk.001_yvhs8n: Moved (server-side) to: dst/three.txt 2025/02/20 03:34:00 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-rebomog5meji/dst" 2025/02/20 03:34:00 DEBUG : Creating backend with remote "TestYandex:rclone-test-rebomog5meji/dst" 2025/02/20 03:34:00 DEBUG : Reset feature "ListR" 2025/02/20 03:34:01 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/02/20 03:34:04 DEBUG : one: move non-chunked object... 2025/02/20 03:34:05 INFO : one: Moved (server-side) to: one-2019-01-01 2025/02/20 03:34:05 INFO : one: Moved (server-side) to: one-2019-01-01 2025/02/20 03:34:05 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:34:10 INFO : one.rclone_chunk.001_yvi2ff: Moved (server-side) to: one 2025/02/20 03:34:10 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2025/02/20 03:34:10 INFO : one: Copied (new) 2025/02/20 03:34:10 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:34:10 DEBUG : two: Unchanged skipping 2025/02/20 03:34:11 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/02/20 03:34:11 DEBUG : three.txt: move non-chunked object... 2025/02/20 03:34:13 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/02/20 03:34:13 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/02/20 03:34:13 DEBUG : three.txt: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:34:17 INFO : three.txt.rclone_chunk.001_yviacp: Moved (server-side) to: three.txt 2025/02/20 03:34:17 DEBUG : three.txt: md5 = 91341eed84691a83caea73aa785736d5 OK 2025/02/20 03:34:17 INFO : three.txt: Copied (new) 2025/02/20 03:34:19 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/02/20 03:34:23 INFO : one-2019-01-01: Deleted 2025/02/20 03:34:23 DEBUG : one: move non-chunked object... 2025/02/20 03:34:24 INFO : one: Moved (server-side) to: one-2019-01-01 2025/02/20 03:34:24 INFO : one: Moved (server-side) to: one-2019-01-01 2025/02/20 03:34:25 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:34:30 INFO : one.rclone_chunk.001_yvimai: Moved (server-side) to: one 2025/02/20 03:34:30 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2025/02/20 03:34:30 INFO : one: Copied (new) 2025/02/20 03:34:30 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:34:30 DEBUG : two: Unchanged skipping 2025/02/20 03:34:32 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/02/20 03:34:38 INFO : three-2019-01-01.txt: Deleted 2025/02/20 03:34:38 DEBUG : three.txt: move non-chunked object... 2025/02/20 03:34:40 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/02/20 03:34:40 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/02/20 03:34:40 DEBUG : three.txt: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:34:45 INFO : three.txt.rclone_chunk.001_yvj18c: Moved (server-side) to: three.txt 2025/02/20 03:34:45 DEBUG : three.txt: md5 = 423e01c5e84a30d129b97aedb6e219a9 OK 2025/02/20 03:34:45 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (82.63s) === RUN TestSyncConcurrentDelete run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji'", Local "Local file system at /tmp/rclone4289080924", Modify Window "1ns" 2025/02/20 03:35:13 INFO : both0.rclone_chunk.001_yvjt21: Moved (server-side) to: both0 2025/02/20 03:35:18 INFO : only0.rclone_chunk.001_yvjzht: Moved (server-side) to: only0 2025/02/20 03:35:23 INFO : both1.rclone_chunk.001_yvk38s: Moved (server-side) to: both1 2025/02/20 03:35:31 INFO : only1.rclone_chunk.001_yvk8dj: Moved (server-side) to: only1 2025/02/20 03:35:37 INFO : both2.rclone_chunk.001_yvkg52: Moved (server-side) to: both2 2025/02/20 03:35:43 INFO : only2.rclone_chunk.001_yvkmlc: Moved (server-side) to: only2 2025/02/20 03:35:50 INFO : both3.rclone_chunk.001_yvksre: Moved (server-side) to: both3 2025/02/20 03:35:54 INFO : only3.rclone_chunk.001_yvkzdc: Moved (server-side) to: only3 2025/02/20 03:36:00 INFO : both4.rclone_chunk.001_yvl4pz: Moved (server-side) to: both4 2025/02/20 03:36:05 INFO : only4.rclone_chunk.001_yvl9a2: Moved (server-side) to: only4 2025/02/20 03:36:16 INFO : both5.rclone_chunk.001_yvle7a: Moved (server-side) to: both5 2025/02/20 03:36:22 INFO : only5.rclone_chunk.001_yvlqaz: Moved (server-side) to: only5 2025/02/20 03:36:26 INFO : both6.rclone_chunk.001_yvlvrg: Moved (server-side) to: both6 2025/02/20 03:36:31 INFO : only6.rclone_chunk.001_yvm0f4: Moved (server-side) to: only6 2025/02/20 03:36:39 INFO : both7.rclone_chunk.001_yvm5ku: Moved (server-side) to: both7 2025/02/20 03:36:45 INFO : only7.rclone_chunk.001_yvmd60: Moved (server-side) to: only7 2025/02/20 03:36:50 INFO : both8.rclone_chunk.001_yvmikr: Moved (server-side) to: both8 2025/02/20 03:36:55 INFO : only8.rclone_chunk.001_yvmnw6: Moved (server-side) to: only8 2025/02/20 03:37:01 INFO : both9.rclone_chunk.001_yvmsj6: Moved (server-side) to: both9 2025/02/20 03:37:06 INFO : only9.rclone_chunk.001_yvmyv4: Moved (server-side) to: only9 2025/02/20 03:37:10 INFO : both10.rclone_chunk.001_yvn31i: Moved (server-side) to: both10 2025/02/20 03:37:14 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2025/02/20 03:37:14 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/02/20 03:37:14 DEBUG : pacer: Reducing sleep to 15ms 2025/02/20 03:37:15 DEBUG : pacer: Reducing sleep to 11.25ms 2025/02/20 03:37:15 DEBUG : pacer: Reducing sleep to 10ms 2025/02/20 03:37:17 INFO : only10.rclone_chunk.001_yvn8em: Moved (server-side) to: only10 2025/02/20 03:37:21 INFO : both11.rclone_chunk.001_yvney6: Moved (server-side) to: both11 2025/02/20 03:37:27 INFO : only11.rclone_chunk.001_yvnjc0: Moved (server-side) to: only11 2025/02/20 03:37:32 INFO : both12.rclone_chunk.001_yvnobq: Moved (server-side) to: both12 2025/02/20 03:37:37 INFO : only12.rclone_chunk.001_yvntxc: Moved (server-side) to: only12 2025/02/20 03:37:43 INFO : both13.rclone_chunk.001_yvnytf: Moved (server-side) to: both13 2025/02/20 03:37:48 INFO : only13.rclone_chunk.001_yvo53l: Moved (server-side) to: only13 2025/02/20 03:37:53 INFO : both14.rclone_chunk.001_yvoan4: Moved (server-side) to: both14 2025/02/20 03:37:58 INFO : only14.rclone_chunk.001_yvof4z: Moved (server-side) to: only14 2025/02/20 03:38:04 INFO : both15.rclone_chunk.001_yvojw4: Moved (server-side) to: both15 2025/02/20 03:38:08 INFO : only15.rclone_chunk.001_yvopel: Moved (server-side) to: only15 2025/02/20 03:38:19 INFO : both16.rclone_chunk.001_yvotoe: Moved (server-side) to: both16 2025/02/20 03:38:24 INFO : only16.rclone_chunk.001_yvp4mt: Moved (server-side) to: only16 2025/02/20 03:38:29 INFO : both17.rclone_chunk.001_yvp9xn: Moved (server-side) to: both17 2025/02/20 03:38:34 INFO : only17.rclone_chunk.001_yvpeq2: Moved (server-side) to: only17 2025/02/20 03:38:38 INFO : both18.rclone_chunk.001_yvpj20: Moved (server-side) to: both18 2025/02/20 03:38:43 INFO : only18.rclone_chunk.001_yvpoa6: Moved (server-side) to: only18 2025/02/20 03:38:48 INFO : both19.rclone_chunk.001_yvpsj6: Moved (server-side) to: both19 2025/02/20 03:38:52 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2025/02/20 03:38:52 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/02/20 03:38:52 DEBUG : pacer: Reducing sleep to 15ms 2025/02/20 03:38:53 DEBUG : pacer: Reducing sleep to 11.25ms 2025/02/20 03:38:53 DEBUG : pacer: Reducing sleep to 10ms 2025/02/20 03:38:55 INFO : only19.rclone_chunk.001_yvpxc3: Moved (server-side) to: only19 2025/02/20 03:38:55 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:38:55 DEBUG : both0: Unchanged skipping 2025/02/20 03:38:55 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:38:55 DEBUG : both1: Unchanged skipping 2025/02/20 03:38:55 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:38:55 DEBUG : both10: Unchanged skipping 2025/02/20 03:38:55 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:38:55 DEBUG : both11: Unchanged skipping 2025/02/20 03:38:55 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:38:55 DEBUG : both12: Unchanged skipping 2025/02/20 03:38:55 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:38:55 DEBUG : both13: Unchanged skipping 2025/02/20 03:38:55 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:38:55 DEBUG : both14: Unchanged skipping 2025/02/20 03:38:55 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:38:55 DEBUG : both15: Unchanged skipping 2025/02/20 03:38:55 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:38:55 DEBUG : both16: Unchanged skipping 2025/02/20 03:38:55 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:38:55 DEBUG : both17: Unchanged skipping 2025/02/20 03:38:55 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:38:55 DEBUG : both18: Unchanged skipping 2025/02/20 03:38:55 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:38:55 DEBUG : both19: Unchanged skipping 2025/02/20 03:38:55 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:38:55 DEBUG : both2: Unchanged skipping 2025/02/20 03:38:55 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:38:55 DEBUG : both3: Unchanged skipping 2025/02/20 03:38:55 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:38:55 DEBUG : both4: Unchanged skipping 2025/02/20 03:38:55 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:38:55 DEBUG : both5: Unchanged skipping 2025/02/20 03:38:55 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:38:55 DEBUG : both6: Unchanged skipping 2025/02/20 03:38:55 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:38:55 DEBUG : both7: Unchanged skipping 2025/02/20 03:38:55 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:38:55 DEBUG : both8: Unchanged skipping 2025/02/20 03:38:55 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:38:55 DEBUG : both9: Unchanged skipping 2025/02/20 03:38:55 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji': Waiting for checks to finish 2025/02/20 03:38:55 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji': Waiting for transfers to finish 2025/02/20 03:38:55 DEBUG : Waiting for deletions to finish 2025/02/20 03:38:59 INFO : only3: Deleted 2025/02/20 03:38:59 INFO : only15: Deleted 2025/02/20 03:39:00 INFO : only17: Deleted 2025/02/20 03:39:02 INFO : only1: Deleted 2025/02/20 03:39:02 INFO : only7: Deleted 2025/02/20 03:39:03 INFO : only11: Deleted 2025/02/20 03:39:04 INFO : only18: Deleted 2025/02/20 03:39:05 INFO : only9: Deleted 2025/02/20 03:39:06 INFO : only13: Deleted 2025/02/20 03:39:07 INFO : only4: Deleted 2025/02/20 03:39:07 INFO : only12: Deleted 2025/02/20 03:39:09 INFO : only10: Deleted 2025/02/20 03:39:09 INFO : only8: Deleted 2025/02/20 03:39:10 INFO : only19: Deleted 2025/02/20 03:39:10 INFO : only2: Deleted 2025/02/20 03:39:12 INFO : only5: Deleted 2025/02/20 03:39:13 INFO : only6: Deleted 2025/02/20 03:39:14 INFO : only0: Deleted 2025/02/20 03:39:14 INFO : only14: Deleted 2025/02/20 03:39:16 INFO : only16: Deleted run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji'", Local "Local file system at /tmp/rclone4289080924", Modify Window "1ns" --- PASS: TestSyncConcurrentDelete (318.66s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji'", Local "Local file system at /tmp/rclone4289080924", Modify Window "1ns" 2025/02/20 03:40:32 INFO : both0.rclone_chunk.001_yvso44: Moved (server-side) to: both0 2025/02/20 03:40:37 INFO : only0.rclone_chunk.001_yvstgd: Moved (server-side) to: only0 2025/02/20 03:40:42 INFO : both1.rclone_chunk.001_yvsycz: Moved (server-side) to: both1 2025/02/20 03:40:51 INFO : only1.rclone_chunk.001_yvt3lv: Moved (server-side) to: only1 2025/02/20 03:40:57 INFO : both2.rclone_chunk.001_yvtc7x: Moved (server-side) to: both2 2025/02/20 03:41:03 INFO : only2.rclone_chunk.001_yvti66: Moved (server-side) to: only2 2025/02/20 03:41:08 INFO : both3.rclone_chunk.001_yvtowh: Moved (server-side) to: both3 2025/02/20 03:41:13 INFO : only3.rclone_chunk.001_yvtuhr: Moved (server-side) to: only3 2025/02/20 03:41:19 INFO : both4.rclone_chunk.001_yvtz79: Moved (server-side) to: both4 2025/02/20 03:41:25 INFO : only4.rclone_chunk.001_yvu4an: Moved (server-side) to: only4 2025/02/20 03:41:30 INFO : both5.rclone_chunk.001_yvuawr: Moved (server-side) to: both5 2025/02/20 03:41:35 INFO : only5.rclone_chunk.001_yvufn8: Moved (server-side) to: only5 2025/02/20 03:41:40 INFO : both6.rclone_chunk.001_yvul3f: Moved (server-side) to: both6 2025/02/20 03:41:46 INFO : only6.rclone_chunk.001_yvuq0i: Moved (server-side) to: only6 2025/02/20 03:41:51 INFO : both7.rclone_chunk.001_yvuvum: Moved (server-side) to: both7 2025/02/20 03:41:57 INFO : only7.rclone_chunk.001_yvv024: Moved (server-side) to: only7 2025/02/20 03:42:02 INFO : both8.rclone_chunk.001_yvv74l: Moved (server-side) to: both8 2025/02/20 03:42:07 INFO : only8.rclone_chunk.001_yvvclr: Moved (server-side) to: only8 2025/02/20 03:42:11 INFO : both9.rclone_chunk.001_yvvgnw: Moved (server-side) to: both9 2025/02/20 03:42:17 INFO : only9.rclone_chunk.001_yvvl1g: Moved (server-side) to: only9 2025/02/20 03:42:22 INFO : both10.rclone_chunk.001_yvvrui: Moved (server-side) to: both10 2025/02/20 03:42:28 INFO : only10.rclone_chunk.001_yvvwxz: Moved (server-side) to: only10 2025/02/20 03:42:34 INFO : both11.rclone_chunk.001_yvw278: Moved (server-side) to: both11 2025/02/20 03:42:40 INFO : only11.rclone_chunk.001_yvw8sq: Moved (server-side) to: only11 2025/02/20 03:42:45 INFO : both12.rclone_chunk.001_yvwdbg: Moved (server-side) to: both12 2025/02/20 03:42:50 INFO : only12.rclone_chunk.001_yvwij6: Moved (server-side) to: only12 2025/02/20 03:42:55 INFO : both13.rclone_chunk.001_yvwnnu: Moved (server-side) to: both13 2025/02/20 03:42:59 INFO : only13.rclone_chunk.001_yvwsrd: Moved (server-side) to: only13 2025/02/20 03:43:05 INFO : both14.rclone_chunk.001_yvwwze: Moved (server-side) to: both14 2025/02/20 03:43:10 INFO : only14.rclone_chunk.001_yvx24a: Moved (server-side) to: only14 2025/02/20 03:43:15 INFO : both15.rclone_chunk.001_yvx8nt: Moved (server-side) to: both15 2025/02/20 03:43:21 INFO : only15.rclone_chunk.001_yvxdtt: Moved (server-side) to: only15 2025/02/20 03:43:26 INFO : both16.rclone_chunk.001_yvxi6x: Moved (server-side) to: both16 2025/02/20 03:43:31 INFO : only16.rclone_chunk.001_yvxnrv: Moved (server-side) to: only16 2025/02/20 03:43:37 INFO : both17.rclone_chunk.001_yvxt3f: Moved (server-side) to: both17 2025/02/20 03:43:42 INFO : only17.rclone_chunk.001_yvxykb: Moved (server-side) to: only17 2025/02/20 03:43:47 INFO : both18.rclone_chunk.001_yvy46k: Moved (server-side) to: both18 2025/02/20 03:43:53 INFO : only18.rclone_chunk.001_yvy982: Moved (server-side) to: only18 2025/02/20 03:43:59 INFO : both19.rclone_chunk.001_yvyfs9: Moved (server-side) to: both19 2025/02/20 03:44:04 INFO : only19.rclone_chunk.001_yvykx8: 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:2762 Error: Should be true Test: TestSyncConcurrentTruncate Messages: both1: Modification time difference too big |-210791h35m34.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2025-02-20 03:40:41 +0000 UTC) (precision 1ns) 2025/02/20 03:44:05 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:44:05 DEBUG : both1: Modification times differ by 210791h35m34.500000001s: 2001-02-03 04:05:06.499999999 +0000 UTC, 2025-02-20 03:40:41 +0000 UTC 2025/02/20 03:44:05 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji': Waiting for checks to finish 2025/02/20 03:44:05 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:44:05 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:44:05 DEBUG : both0: Unchanged skipping 2025/02/20 03:44:05 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:44:05 DEBUG : both12: Unchanged skipping 2025/02/20 03:44:05 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:44:05 DEBUG : both13: Unchanged skipping 2025/02/20 03:44:05 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:44:05 DEBUG : both14: Unchanged skipping 2025/02/20 03:44:05 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:44:05 DEBUG : both15: Unchanged skipping 2025/02/20 03:44:05 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:44:05 DEBUG : both16: Unchanged skipping 2025/02/20 03:44:05 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:44:05 DEBUG : both17: Unchanged skipping 2025/02/20 03:44:05 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:44:05 DEBUG : both18: Unchanged skipping 2025/02/20 03:44:05 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:44:05 DEBUG : both19: Unchanged skipping 2025/02/20 03:44:05 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:44:05 DEBUG : both1: md5 = 8ee2027983915ec78acc45027d874316 OK 2025/02/20 03:44:05 DEBUG : both2: Unchanged skipping 2025/02/20 03:44:05 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:44:05 DEBUG : both3: Unchanged skipping 2025/02/20 03:44:05 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:44:05 DEBUG : both4: Unchanged skipping 2025/02/20 03:44:05 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:44:05 DEBUG : both10: Unchanged skipping 2025/02/20 03:44:05 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:44:05 DEBUG : both11: Unchanged skipping 2025/02/20 03:44:05 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:44:05 DEBUG : both5: Unchanged skipping 2025/02/20 03:44:05 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:44:05 DEBUG : both8: Unchanged skipping 2025/02/20 03:44:05 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/02/20 03:44:05 DEBUG : both9: Unchanged skipping 2025/02/20 03:44:05 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2025/02/20 03:44:05 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2025/02/20 03:44:05 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2025/02/20 03:44:05 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2025/02/20 03:44:05 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2025/02/20 03:44:05 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2025/02/20 03:44:05 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2025/02/20 03:44:05 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2025/02/20 03:44:05 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2025/02/20 03:44:05 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2025/02/20 03:44:05 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2025/02/20 03:44:05 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2025/02/20 03:44:05 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2025/02/20 03:44:05 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2025/02/20 03:44:05 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2025/02/20 03:44:05 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2025/02/20 03:44:05 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2025/02/20 03:44:05 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2025/02/20 03:44:05 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2025/02/20 03:44:05 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2025/02/20 03:44:05 DEBUG : only0: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:44:05 DEBUG : only1: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:44:05 DEBUG : only10: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:44:05 DEBUG : only11: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:44:05 DEBUG : both6: Unchanged skipping 2025/02/20 03:44:05 DEBUG : both7: Unchanged skipping 2025/02/20 03:44:05 INFO : both1: Updated modification time in destination 2025/02/20 03:44:05 DEBUG : both1: Unchanged skipping 2025/02/20 03:44:05 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji': Waiting for transfers to finish 2025/02/20 03:44:11 INFO : only10: Deleted 2025/02/20 03:44:12 INFO : only1: Deleted 2025/02/20 03:44:12 INFO : only0: Deleted 2025/02/20 03:44:12 INFO : only11: Deleted 2025/02/20 03:44:13 INFO : only1.rclone_chunk.001_yvyq3w: Moved (server-side) to: only1 2025/02/20 03:44:13 DEBUG : only1: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 03:44:13 INFO : only1: Copied (replaced existing) 2025/02/20 03:44:13 DEBUG : only12: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:44:14 INFO : only10.rclone_chunk.001_yvyqh4: Moved (server-side) to: only10 2025/02/20 03:44:14 DEBUG : only10: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 03:44:14 INFO : only10: Copied (replaced existing) 2025/02/20 03:44:14 DEBUG : only13: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:44:14 INFO : only0.rclone_chunk.001_yvyquk: Moved (server-side) to: only0 2025/02/20 03:44:14 DEBUG : only0: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 03:44:14 INFO : only0: Copied (replaced existing) 2025/02/20 03:44:14 DEBUG : only14: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:44:15 INFO : only11.rclone_chunk.001_yvyqyu: Moved (server-side) to: only11 2025/02/20 03:44:15 DEBUG : only11: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 03:44:15 INFO : only11: Copied (replaced existing) 2025/02/20 03:44:15 DEBUG : only15: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:44:21 INFO : only12: Deleted 2025/02/20 03:44:22 INFO : only14: Deleted 2025/02/20 03:44:22 INFO : only15: Deleted 2025/02/20 03:44:23 INFO : only12.rclone_chunk.001_yvyydl: Moved (server-side) to: only12 2025/02/20 03:44:23 DEBUG : only12: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 03:44:23 INFO : only12: Copied (replaced existing) 2025/02/20 03:44:23 DEBUG : only16: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:44:24 INFO : only14.rclone_chunk.001_yvyz3e: Moved (server-side) to: only14 2025/02/20 03:44:24 DEBUG : only14: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 03:44:24 INFO : only14: Copied (replaced existing) 2025/02/20 03:44:24 DEBUG : only17: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:44:24 INFO : only13: Deleted 2025/02/20 03:44:24 INFO : only15.rclone_chunk.001_yvz0x1: Moved (server-side) to: only15 2025/02/20 03:44:24 DEBUG : only15: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 03:44:24 INFO : only15: Copied (replaced existing) 2025/02/20 03:44:24 DEBUG : only18: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:44:26 INFO : only13.rclone_chunk.001_yvyzfk: Moved (server-side) to: only13 2025/02/20 03:44:26 DEBUG : only13: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 03:44:26 INFO : only13: Copied (replaced existing) 2025/02/20 03:44:26 DEBUG : only19: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:44:31 INFO : only16: Deleted 2025/02/20 03:44:31 INFO : only17: Deleted 2025/02/20 03:44:31 INFO : only18: Deleted 2025/02/20 03:44:33 INFO : only17.rclone_chunk.001_yvz9zj: Moved (server-side) to: only17 2025/02/20 03:44:33 DEBUG : only17: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 03:44:33 INFO : only17: Copied (replaced existing) 2025/02/20 03:44:33 DEBUG : only2: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:44:33 INFO : only16.rclone_chunk.001_yvz8ge: Moved (server-side) to: only16 2025/02/20 03:44:33 DEBUG : only16: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 03:44:33 INFO : only16: Copied (replaced existing) 2025/02/20 03:44:33 DEBUG : only3: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:44:33 INFO : only18.rclone_chunk.001_yvz9qb: Moved (server-side) to: only18 2025/02/20 03:44:33 DEBUG : only18: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 03:44:33 INFO : only18: Copied (replaced existing) 2025/02/20 03:44:33 DEBUG : only4: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:44:34 INFO : only19: Deleted 2025/02/20 03:44:36 INFO : only19.rclone_chunk.001_yvzbnm: Moved (server-side) to: only19 2025/02/20 03:44:36 DEBUG : only19: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 03:44:36 INFO : only19: Copied (replaced existing) 2025/02/20 03:44:36 DEBUG : only5: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:44:40 INFO : only2: Deleted 2025/02/20 03:44:40 INFO : only3: Deleted 2025/02/20 03:44:40 INFO : only4: Deleted 2025/02/20 03:44:41 INFO : only2.rclone_chunk.001_yvzifz: Moved (server-side) to: only2 2025/02/20 03:44:41 DEBUG : only2: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 03:44:41 INFO : only2: Copied (replaced existing) 2025/02/20 03:44:41 DEBUG : only6: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:44:41 INFO : only3.rclone_chunk.001_yvziea: Moved (server-side) to: only3 2025/02/20 03:44:41 DEBUG : only3: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 03:44:41 INFO : only3: Copied (replaced existing) 2025/02/20 03:44:41 DEBUG : only7: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:44:42 INFO : only4.rclone_chunk.001_yvzi0i: Moved (server-side) to: only4 2025/02/20 03:44:42 DEBUG : only4: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 03:44:42 INFO : only4: Copied (replaced existing) 2025/02/20 03:44:42 DEBUG : only8: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:44:45 INFO : only5: Deleted 2025/02/20 03:44:48 INFO : only5.rclone_chunk.001_yvzlxr: Moved (server-side) to: only5 2025/02/20 03:44:48 DEBUG : only5: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 03:44:48 INFO : only5: Copied (replaced existing) 2025/02/20 03:44:48 DEBUG : only9: skip slow MD5 on source file, hashing in-transit 2025/02/20 03:44:49 INFO : only7: Deleted 2025/02/20 03:44:49 INFO : only6: Deleted 2025/02/20 03:44:49 INFO : only8: Deleted 2025/02/20 03:44:51 INFO : only8.rclone_chunk.001_yvzrgg: Moved (server-side) to: only8 2025/02/20 03:44:51 DEBUG : only8: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 03:44:51 INFO : only8: Copied (replaced existing) 2025/02/20 03:44:51 INFO : only6.rclone_chunk.001_yvzqxw: Moved (server-side) to: only6 2025/02/20 03:44:51 DEBUG : only6: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 03:44:51 INFO : only6: Copied (replaced existing) 2025/02/20 03:44:51 INFO : only7.rclone_chunk.001_yvzqne: Moved (server-side) to: only7 2025/02/20 03:44:51 DEBUG : only7: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 03:44:51 INFO : only7: Copied (replaced existing) 2025/02/20 03:44:56 INFO : only9: Deleted 2025/02/20 03:44:57 INFO : only9.rclone_chunk.001_yvzxnd: Moved (server-side) to: only9 2025/02/20 03:44:57 DEBUG : only9: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 03:44:57 INFO : only9: Copied (replaced existing) 2025/02/20 03:44:57 DEBUG : Waiting for deletions to finish run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji'", Local "Local file system at /tmp/rclone4289080924", Modify Window "1ns" --- FAIL: TestSyncConcurrentTruncate (415.31s) FAIL 2025/02/20 03:47:22 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-rebomog5meji': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestServerSideMoveWithFilter|TestSyncAfterRemovingAFileAndAddingAFile|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffixKeepExtension|TestSyncConcurrentDelete|TestSyncConcurrentTruncate|TestSyncSuffixKeepExtension)$'" - Finished ERROR in 18m47.001654348s (try 2/5): exit status 1: Failed [TestSyncConcurrentTruncate]