"./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestFixCase|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncConcurrentDelete|TestSyncConcurrentTruncate|TestSyncIgnoreCase|TestSyncImmutable|TestSyncReplaceDirModTime|TestSyncReplaceDirModTimeWithEmptyDirs|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncUTFNorm)$|^TestMaxTransfer$/^(Cautious|Hard|Soft)$'" - Starting (try 2/5) 2025/03/22 02:50:21 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-ruxadij3beso" 2025/03/22 02:50:21 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/22 02:50:21 DEBUG : Creating backend with remote "TestYandex:rclone-test-ruxadij3beso" 2025/03/22 02:50:22 DEBUG : Reset feature "ListR" 2025/03/22 02:50:22 DEBUG : Creating backend with remote "/tmp/rclone3310103616" === RUN TestSyncBackupDir run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" 2025/03/22 02:50:26 INFO : dst/one.rclone_chunk.001_idhlfl: Moved (server-side) to: dst/one 2025/03/22 02:50:31 INFO : dst/two.rclone_chunk.001_idhqnv: Moved (server-side) to: dst/two 2025/03/22 02:50:36 INFO : dst/three.txt.rclone_chunk.001_idhu9l: Moved (server-side) to: dst/three.txt 2025/03/22 02:50:36 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/dst" 2025/03/22 02:50:36 DEBUG : Creating backend with remote "TestYandex:rclone-test-ruxadij3beso/dst" 2025/03/22 02:50:37 DEBUG : Reset feature "ListR" 2025/03/22 02:50:37 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/backup" 2025/03/22 02:50:37 DEBUG : Creating backend with remote "TestYandex:rclone-test-ruxadij3beso/backup" 2025/03/22 02:50:37 DEBUG : Reset feature "ListR" 2025/03/22 02:50:38 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/22 02:50:38 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 02:50:38 DEBUG : two: Unchanged skipping 2025/03/22 02:50:38 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/dst': Waiting for checks to finish 2025/03/22 02:50:38 DEBUG : one: move non-chunked object... 2025/03/22 02:50:39 INFO : one: Moved (server-side) 2025/03/22 02:50:39 INFO : one: Moved (server-side) 2025/03/22 02:50:39 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/dst': Waiting for transfers to finish 2025/03/22 02:50:40 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/03/22 02:50:45 INFO : one.rclone_chunk.001_idi3fg: Moved (server-side) to: one 2025/03/22 02:50:45 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2025/03/22 02:50:45 INFO : one: Copied (new) 2025/03/22 02:50:45 DEBUG : Waiting for deletions to finish 2025/03/22 02:50:45 DEBUG : three.txt: move non-chunked object... 2025/03/22 02:50:46 INFO : three.txt: Moved (server-side) 2025/03/22 02:50:46 INFO : three.txt: Moved (server-side) 2025/03/22 02:50:46 INFO : three.txt: Moved into backup dir 2025/03/22 02:50:52 INFO : dst/three.txt.rclone_chunk.001_idiaku: Moved (server-side) to: dst/three.txt 2025/03/22 02:50:52 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/03/22 02:50:52 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/dst': Waiting for checks to finish 2025/03/22 02:50:52 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 02:50:52 DEBUG : two: Unchanged skipping 2025/03/22 02:50:57 INFO : one: Deleted 2025/03/22 02:50:57 DEBUG : one: move non-chunked object... 2025/03/22 02:50:58 INFO : one: Moved (server-side) 2025/03/22 02:50:58 INFO : one: Moved (server-side) 2025/03/22 02:50:58 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/dst': Waiting for transfers to finish 2025/03/22 02:50:58 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/03/22 02:51:04 INFO : one.rclone_chunk.001_idil8t: Moved (server-side) to: one 2025/03/22 02:51:04 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2025/03/22 02:51:04 INFO : one: Copied (new) 2025/03/22 02:51:04 DEBUG : Waiting for deletions to finish 2025/03/22 02:51:09 INFO : three.txt: Deleted 2025/03/22 02:51:09 DEBUG : three.txt: move non-chunked object... 2025/03/22 02:51:11 INFO : three.txt: Moved (server-side) 2025/03/22 02:51:11 INFO : three.txt: Moved (server-side) 2025/03/22 02:51:11 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (73.53s) === RUN TestSyncBackupDirWithSuffix run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" 2025/03/22 02:51:41 INFO : dst/one.rclone_chunk.001_idjms3: Moved (server-side) to: dst/one 2025/03/22 02:51:45 INFO : dst/two.rclone_chunk.001_idjses: Moved (server-side) to: dst/two 2025/03/22 02:51:50 INFO : dst/three.txt.rclone_chunk.001_idjwa7: Moved (server-side) to: dst/three.txt 2025/03/22 02:51:51 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/dst" 2025/03/22 02:51:51 DEBUG : Creating backend with remote "TestYandex:rclone-test-ruxadij3beso/dst" 2025/03/22 02:51:51 DEBUG : Reset feature "ListR" 2025/03/22 02:51:51 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/backup" 2025/03/22 02:51:51 DEBUG : Creating backend with remote "TestYandex:rclone-test-ruxadij3beso/backup" 2025/03/22 02:51:51 DEBUG : Reset feature "ListR" 2025/03/22 02:51:52 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/22 02:51:52 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 02:51:52 DEBUG : two: Unchanged skipping 2025/03/22 02:51:52 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/dst': Waiting for checks to finish 2025/03/22 02:51:52 DEBUG : one: move non-chunked object... 2025/03/22 02:51:53 INFO : one: Moved (server-side) to: one.bak 2025/03/22 02:51:53 INFO : one: Moved (server-side) to: one.bak 2025/03/22 02:51:53 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/dst': Waiting for transfers to finish 2025/03/22 02:51:54 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/03/22 02:51:59 INFO : one.rclone_chunk.001_idk58c: Moved (server-side) to: one 2025/03/22 02:51:59 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2025/03/22 02:51:59 INFO : one: Copied (new) 2025/03/22 02:51:59 DEBUG : Waiting for deletions to finish 2025/03/22 02:52:00 DEBUG : three.txt: move non-chunked object... 2025/03/22 02:52:01 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/03/22 02:52:01 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/03/22 02:52:01 INFO : three.txt: Moved into backup dir 2025/03/22 02:52:07 INFO : dst/three.txt.rclone_chunk.001_idkdr1: Moved (server-side) to: dst/three.txt 2025/03/22 02:52:08 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/03/22 02:52:08 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 02:52:08 DEBUG : two: Unchanged skipping 2025/03/22 02:52:08 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/dst': Waiting for checks to finish 2025/03/22 02:52:12 INFO : one.bak: Deleted 2025/03/22 02:52:12 DEBUG : one: move non-chunked object... 2025/03/22 02:52:13 INFO : one: Moved (server-side) to: one.bak 2025/03/22 02:52:13 INFO : one: Moved (server-side) to: one.bak 2025/03/22 02:52:13 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/dst': Waiting for transfers to finish 2025/03/22 02:52:13 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/03/22 02:52:18 INFO : one.rclone_chunk.001_idko69: Moved (server-side) to: one 2025/03/22 02:52:18 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2025/03/22 02:52:18 INFO : one: Copied (new) 2025/03/22 02:52:18 DEBUG : Waiting for deletions to finish 2025/03/22 02:52:22 INFO : three.txt.bak: Deleted 2025/03/22 02:52:22 DEBUG : three.txt: move non-chunked object... 2025/03/22 02:52:23 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/03/22 02:52:23 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/03/22 02:52:23 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffix (70.75s) === RUN TestSyncBackupDirWithSuffixKeepExtension run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" 2025/03/22 02:52:51 INFO : dst/one.rclone_chunk.001_idlly3: Moved (server-side) to: dst/one 2025/03/22 02:52:57 INFO : dst/two.rclone_chunk.001_idlrn0: Moved (server-side) to: dst/two 2025/03/22 02:53:02 INFO : dst/three.txt.rclone_chunk.001_idlw3b: Moved (server-side) to: dst/three.txt 2025/03/22 02:53:03 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/dst" 2025/03/22 02:53:03 DEBUG : Creating backend with remote "TestYandex:rclone-test-ruxadij3beso/dst" 2025/03/22 02:53:03 DEBUG : Reset feature "ListR" 2025/03/22 02:53:03 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/backup" 2025/03/22 02:53:03 DEBUG : Creating backend with remote "TestYandex:rclone-test-ruxadij3beso/backup" 2025/03/22 02:53:03 DEBUG : Reset feature "ListR" 2025/03/22 02:53:04 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/22 02:53:04 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/dst': Waiting for checks to finish 2025/03/22 02:53:04 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 02:53:04 DEBUG : two: Unchanged skipping 2025/03/22 02:53:04 DEBUG : one: move non-chunked object... 2025/03/22 02:53:06 INFO : one: Moved (server-side) to: one-2019-01-01 2025/03/22 02:53:06 INFO : one: Moved (server-side) to: one-2019-01-01 2025/03/22 02:53:06 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/dst': Waiting for transfers to finish 2025/03/22 02:53:06 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/03/22 02:53:12 INFO : one.rclone_chunk.001_idm51h: Moved (server-side) to: one 2025/03/22 02:53:12 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2025/03/22 02:53:12 INFO : one: Copied (new) 2025/03/22 02:53:12 DEBUG : Waiting for deletions to finish 2025/03/22 02:53:13 DEBUG : three.txt: move non-chunked object... 2025/03/22 02:53:14 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/03/22 02:53:14 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/03/22 02:53:14 INFO : three.txt: Moved into backup dir 2025/03/22 02:53:20 INFO : dst/three.txt.rclone_chunk.001_idmehq: Moved (server-side) to: dst/three.txt 2025/03/22 02:53:21 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/03/22 02:53:21 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 02:53:21 DEBUG : two: Unchanged skipping 2025/03/22 02:53:21 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/dst': Waiting for checks to finish 2025/03/22 02:53:26 INFO : one-2019-01-01: Deleted 2025/03/22 02:53:26 DEBUG : one: move non-chunked object... 2025/03/22 02:53:27 INFO : one: Moved (server-side) to: one-2019-01-01 2025/03/22 02:53:27 INFO : one: Moved (server-side) to: one-2019-01-01 2025/03/22 02:53:27 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/dst': Waiting for transfers to finish 2025/03/22 02:53:28 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/03/22 02:53:33 INFO : one.rclone_chunk.001_idmrbp: Moved (server-side) to: one 2025/03/22 02:53:33 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2025/03/22 02:53:33 INFO : one: Copied (new) 2025/03/22 02:53:33 DEBUG : Waiting for deletions to finish 2025/03/22 02:53:37 INFO : three-2019-01-01.txt: Deleted 2025/03/22 02:53:37 DEBUG : three.txt: move non-chunked object... 2025/03/22 02:53:39 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/03/22 02:53:39 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/03/22 02:53:39 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirWithSuffixKeepExtension (78.08s) === RUN TestSyncBackupDirSuffixOnly run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" 2025/03/22 02:54:09 INFO : dst/one.rclone_chunk.001_idnrya: Moved (server-side) to: dst/one 2025/03/22 02:54:14 INFO : dst/two.rclone_chunk.001_idnw98: Moved (server-side) to: dst/two 2025/03/22 02:54:19 INFO : dst/three.txt.rclone_chunk.001_ido1w8: Moved (server-side) to: dst/three.txt 2025/03/22 02:54:20 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/dst" 2025/03/22 02:54:20 DEBUG : Config file has changed externally - reloading 2025/03/22 02:54:20 DEBUG : Creating backend with remote "TestYandex:rclone-test-ruxadij3beso/dst" 2025/03/22 02:54:20 DEBUG : Reset feature "ListR" 2025/03/22 02:54:21 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/22 02:54:21 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 02:54:21 DEBUG : two: Unchanged skipping 2025/03/22 02:54:21 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/dst': Waiting for checks to finish 2025/03/22 02:54:21 DEBUG : one: move non-chunked object... 2025/03/22 02:54:22 INFO : one: Moved (server-side) to: one.bak 2025/03/22 02:54:22 INFO : one: Moved (server-side) to: one.bak 2025/03/22 02:54:22 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/dst': Waiting for transfers to finish 2025/03/22 02:54:23 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/03/22 02:54:28 INFO : one.rclone_chunk.001_idoau9: Moved (server-side) to: one 2025/03/22 02:54:28 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2025/03/22 02:54:28 INFO : one: Copied (new) 2025/03/22 02:54:28 DEBUG : Waiting for deletions to finish 2025/03/22 02:54:28 DEBUG : three.txt: move non-chunked object... 2025/03/22 02:54:30 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/03/22 02:54:30 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/03/22 02:54:30 INFO : three.txt: Moved into backup dir 2025/03/22 02:54:35 INFO : dst/three.txt.rclone_chunk.001_idoh56: Moved (server-side) to: dst/three.txt 2025/03/22 02:54:36 DEBUG : one.bak: Excluded (Path Filter) 2025/03/22 02:54:36 DEBUG : one.bak: Excluded 2025/03/22 02:54:36 DEBUG : three.txt.bak: Excluded (Path Filter) 2025/03/22 02:54:36 DEBUG : three.txt.bak: Excluded 2025/03/22 02:54:36 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/03/22 02:54:36 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 02:54:36 DEBUG : two: Unchanged skipping 2025/03/22 02:54:36 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/dst': Waiting for checks to finish 2025/03/22 02:54:40 INFO : one.bak: Deleted 2025/03/22 02:54:40 DEBUG : one: move non-chunked object... 2025/03/22 02:54:41 INFO : one: Moved (server-side) to: one.bak 2025/03/22 02:54:41 INFO : one: Moved (server-side) to: one.bak 2025/03/22 02:54:41 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/dst': Waiting for transfers to finish 2025/03/22 02:54:43 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/03/22 02:54:49 INFO : one.rclone_chunk.001_idouck: Moved (server-side) to: one 2025/03/22 02:54:49 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2025/03/22 02:54:49 INFO : one: Copied (new) 2025/03/22 02:54:49 DEBUG : Waiting for deletions to finish 2025/03/22 02:54:55 INFO : three.txt.bak: Deleted 2025/03/22 02:54:55 DEBUG : three.txt: move non-chunked object... 2025/03/22 02:54:56 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/03/22 02:54:56 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/03/22 02:54:56 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDirSuffixOnly (73.22s) === RUN TestSyncSuffix run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" 2025/03/22 02:55:22 INFO : dst/one.rclone_chunk.001_idpsoh: Moved (server-side) to: dst/one 2025/03/22 02:55:27 INFO : dst/two.rclone_chunk.001_idpyew: Moved (server-side) to: dst/two 2025/03/22 02:55:32 INFO : dst/three.txt.rclone_chunk.001_idq277: Moved (server-side) to: dst/three.txt 2025/03/22 02:55:33 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/dst" 2025/03/22 02:55:33 DEBUG : Config file has changed externally - reloading 2025/03/22 02:55:33 DEBUG : Creating backend with remote "TestYandex:rclone-test-ruxadij3beso/dst" 2025/03/22 02:55:33 DEBUG : Reset feature "ListR" 2025/03/22 02:55:34 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/22 02:55:34 DEBUG : one: move non-chunked object... 2025/03/22 02:55:35 INFO : one: Moved (server-side) to: one.bak 2025/03/22 02:55:35 INFO : one: Moved (server-side) to: one.bak 2025/03/22 02:55:36 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/03/22 02:55:40 INFO : one.rclone_chunk.001_idqbm3: Moved (server-side) to: one 2025/03/22 02:55:40 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2025/03/22 02:55:40 INFO : one: Copied (new) 2025/03/22 02:55:41 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 02:55:41 DEBUG : two: Unchanged skipping 2025/03/22 02:55:42 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/03/22 02:55:42 DEBUG : three.txt: move non-chunked object... 2025/03/22 02:55:43 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/03/22 02:55:43 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/03/22 02:55:44 DEBUG : three.txt: skip slow MD5 on source file, hashing in-transit 2025/03/22 02:55:49 INFO : three.txt.rclone_chunk.001_idqjuf: Moved (server-side) to: three.txt 2025/03/22 02:55:49 DEBUG : three.txt: md5 = 91341eed84691a83caea73aa785736d5 OK 2025/03/22 02:55:49 INFO : three.txt: Copied (new) 2025/03/22 02:55:51 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/03/22 02:55:55 INFO : one.bak: Deleted 2025/03/22 02:55:55 DEBUG : one: move non-chunked object... 2025/03/22 02:55:56 INFO : one: Moved (server-side) to: one.bak 2025/03/22 02:55:56 INFO : one: Moved (server-side) to: one.bak 2025/03/22 02:55:56 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/03/22 02:56:01 INFO : one.rclone_chunk.001_idqvw4: Moved (server-side) to: one 2025/03/22 02:56:01 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2025/03/22 02:56:01 INFO : one: Copied (new) 2025/03/22 02:56:02 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 02:56:02 DEBUG : two: Unchanged skipping 2025/03/22 02:56:02 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/03/22 02:56:07 INFO : three.txt.bak: Deleted 2025/03/22 02:56:07 DEBUG : three.txt: move non-chunked object... 2025/03/22 02:56:08 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/03/22 02:56:08 INFO : three.txt: Moved (server-side) to: three.txt.bak 2025/03/22 02:56:08 DEBUG : three.txt: skip slow MD5 on source file, hashing in-transit 2025/03/22 02:56:12 INFO : three.txt.rclone_chunk.001_idr733: Moved (server-side) to: three.txt 2025/03/22 02:56:12 DEBUG : three.txt: md5 = 423e01c5e84a30d129b97aedb6e219a9 OK 2025/03/22 02:56:12 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffix (78.14s) === RUN TestSyncSuffixKeepExtension run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" 2025/03/22 02:56:40 INFO : dst/one.rclone_chunk.001_idrzum: Moved (server-side) to: dst/one 2025/03/22 02:56:45 INFO : dst/two.rclone_chunk.001_ids3es: Moved (server-side) to: dst/two 2025/03/22 02:56:50 INFO : dst/three.txt.rclone_chunk.001_ids8jw: Moved (server-side) to: dst/three.txt 2025/03/22 02:56:51 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-ruxadij3beso/dst" 2025/03/22 02:56:51 DEBUG : Creating backend with remote "TestYandex:rclone-test-ruxadij3beso/dst" 2025/03/22 02:56:52 DEBUG : Reset feature "ListR" 2025/03/22 02:56:52 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/03/22 02:56:53 DEBUG : one: move non-chunked object... 2025/03/22 02:56:54 INFO : one: Moved (server-side) to: one-2019-01-01 2025/03/22 02:56:54 INFO : one: Moved (server-side) to: one-2019-01-01 2025/03/22 02:56:55 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/03/22 02:56:59 INFO : one.rclone_chunk.001_idsi24: Moved (server-side) to: one 2025/03/22 02:56:59 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2025/03/22 02:56:59 INFO : one: Copied (new) 2025/03/22 02:57:00 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 02:57:00 DEBUG : two: Unchanged skipping 2025/03/22 02:57:00 DEBUG : three.txt: Sizes differ (src 6 vs dst 5) 2025/03/22 02:57:01 DEBUG : three.txt: move non-chunked object... 2025/03/22 02:57:03 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/03/22 02:57:03 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/03/22 02:57:03 DEBUG : three.txt: skip slow MD5 on source file, hashing in-transit 2025/03/22 02:57:08 INFO : three.txt.rclone_chunk.001_idsq0o: Moved (server-side) to: three.txt 2025/03/22 02:57:08 DEBUG : three.txt: md5 = 91341eed84691a83caea73aa785736d5 OK 2025/03/22 02:57:08 INFO : three.txt: Copied (new) 2025/03/22 02:57:09 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/03/22 02:57:14 INFO : one-2019-01-01: Deleted 2025/03/22 02:57:14 DEBUG : one: move non-chunked object... 2025/03/22 02:57:16 INFO : one: Moved (server-side) to: one-2019-01-01 2025/03/22 02:57:16 INFO : one: Moved (server-side) to: one-2019-01-01 2025/03/22 02:57:16 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/03/22 02:57:24 INFO : one.rclone_chunk.001_idt3ln: Moved (server-side) to: one 2025/03/22 02:57:24 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2025/03/22 02:57:24 INFO : one: Copied (new) 2025/03/22 02:57:25 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 02:57:25 DEBUG : two: Unchanged skipping 2025/03/22 02:57:25 DEBUG : three.txt: Sizes differ (src 19 vs dst 6) 2025/03/22 02:57:30 INFO : three-2019-01-01.txt: Deleted 2025/03/22 02:57:30 DEBUG : three.txt: move non-chunked object... 2025/03/22 02:57:32 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/03/22 02:57:32 INFO : three.txt: Moved (server-side) to: three-2019-01-01.txt 2025/03/22 02:57:32 DEBUG : three.txt: skip slow MD5 on source file, hashing in-transit 2025/03/22 02:57:37 INFO : three.txt.rclone_chunk.001_idtjq8: Moved (server-side) to: three.txt 2025/03/22 02:57:37 DEBUG : three.txt: md5 = 423e01c5e84a30d129b97aedb6e219a9 OK 2025/03/22 02:57:37 INFO : three.txt: Copied (new) --- PASS: TestSyncSuffixKeepExtension (85.63s) === RUN TestSyncUTFNorm run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" 2025/03/22 02:58:06 INFO : Testêé.rclone_chunk.001_iduc52: Moved (server-side) to: Testêé 2025/03/22 02:58:06 DEBUG : Testêé: Sizes differ (src 14 vs dst 18) 2025/03/22 02:58:06 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso': Waiting for checks to finish 2025/03/22 02:58:06 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso': Waiting for transfers to finish 2025/03/22 02:58:13 INFO : Testêé: Deleted 2025/03/22 02:58:15 INFO : Testêé.rclone_chunk.001_iduhcc: Moved (server-side) to: Testêé 2025/03/22 02:58:15 DEBUG : Testêé: md5 = ce114e4501d2f4e2dcea3e17b546f339 OK 2025/03/22 02:58:15 INFO : Testêé: Copied (replaced existing) to: Testêé 2025/03/22 02:58:15 DEBUG : Waiting for deletions to finish --- PASS: TestSyncUTFNorm (18.64s) === RUN TestSyncImmutable run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" 2025/03/22 02:58:20 DEBUG : existing: Need to transfer - File not found at Destination 2025/03/22 02:58:20 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso': Waiting for checks to finish 2025/03/22 02:58:20 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso': Waiting for transfers to finish 2025/03/22 02:58:21 DEBUG : existing: skip slow MD5 on source file, hashing in-transit 2025/03/22 02:58:25 INFO : existing.rclone_chunk.001_iduwtu: Moved (server-side) to: existing 2025/03/22 02:58:25 DEBUG : existing: md5 = 8ee2027983915ec78acc45027d874316 OK 2025/03/22 02:58:25 INFO : existing: Copied (new) 2025/03/22 02:58:25 DEBUG : Waiting for deletions to finish run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" 2025/03/22 02:58:26 DEBUG : existing: Sizes differ (src 8 vs dst 6) 2025/03/22 02:58:26 ERROR : existing: Source and destination exist but do not match: immutable file modified 2025/03/22 02:58:26 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso': Waiting for checks to finish 2025/03/22 02:58:26 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso': Waiting for transfers to finish 2025/03/22 02:58:26 ERROR : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso': not deleting files as there were IO errors 2025/03/22 02:58:26 ERROR : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso': not deleting directories as there were IO errors run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" --- PASS: TestSyncImmutable (13.61s) === RUN TestSyncIgnoreCase run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" 2025/03/22 02:58:37 INFO : EXISTING.rclone_chunk.001_idv80n: Moved (server-side) to: EXISTING 2025/03/22 02:58:38 DEBUG : existing: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 02:58:38 DEBUG : existing: Unchanged skipping 2025/03/22 02:58:38 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso': Waiting for checks to finish 2025/03/22 02:58:38 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso': Waiting for transfers to finish 2025/03/22 02:58:38 DEBUG : Waiting for deletions to finish 2025/03/22 02:58:38 INFO : There was nothing to transfer --- PASS: TestSyncIgnoreCase (9.29s) === RUN TestFixCase run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" sync_test.go:2635: Skipping test as local or remote are case-sensitive --- SKIP: TestFixCase (0.57s) === RUN TestMaxTransfer === RUN TestMaxTransfer/Hard run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" sync_test.go:2674: This test only runs on local === RUN TestMaxTransfer/Soft run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" sync_test.go:2674: This test only runs on local === RUN TestMaxTransfer/Cautious run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" sync_test.go:2674: This test only runs on local --- PASS: TestMaxTransfer (2.00s) --- SKIP: TestMaxTransfer/Hard (0.59s) --- SKIP: TestMaxTransfer/Soft (0.67s) --- SKIP: TestMaxTransfer/Cautious (0.75s) === RUN TestSyncConcurrentDelete run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" 2025/03/22 02:58:49 INFO : both0.rclone_chunk.001_idvk8f: Moved (server-side) to: both0 2025/03/22 02:58:54 INFO : only0.rclone_chunk.001_idvpxw: Moved (server-side) to: only0 2025/03/22 02:58:58 INFO : both1.rclone_chunk.001_idvtqe: Moved (server-side) to: both1 2025/03/22 02:59:16 INFO : only1.rclone_chunk.001_idvyjh: Moved (server-side) to: only1 2025/03/22 02:59:21 INFO : both2.rclone_chunk.001_idwfox: Moved (server-side) to: both2 2025/03/22 02:59:26 INFO : only2.rclone_chunk.001_idwkx7: Moved (server-side) to: only2 2025/03/22 02:59:30 INFO : both3.rclone_chunk.001_idwps4: Moved (server-side) to: both3 2025/03/22 02:59:35 INFO : only3.rclone_chunk.001_idwug7: Moved (server-side) to: only3 2025/03/22 02:59:40 INFO : both4.rclone_chunk.001_idwybg: Moved (server-side) to: both4 2025/03/22 02:59:45 INFO : only4.rclone_chunk.001_idx3bu: Moved (server-side) to: only4 2025/03/22 02:59:50 INFO : both5.rclone_chunk.001_idx8lb: Moved (server-side) to: both5 2025/03/22 02:59:58 INFO : only5.rclone_chunk.001_idxgeo: Moved (server-side) to: only5 2025/03/22 03:00:03 INFO : both6.rclone_chunk.001_idxl3u: Moved (server-side) to: both6 2025/03/22 03:00:08 INFO : only6.rclone_chunk.001_idxr61: Moved (server-side) to: only6 2025/03/22 03:00:13 INFO : both7.rclone_chunk.001_idxv9f: Moved (server-side) to: both7 2025/03/22 03:00:18 INFO : only7.rclone_chunk.001_idy06a: Moved (server-side) to: only7 2025/03/22 03:00:23 INFO : both8.rclone_chunk.001_idy5t9: Moved (server-side) to: both8 2025/03/22 03:00:27 INFO : only8.rclone_chunk.001_idyaz7: Moved (server-side) to: only8 2025/03/22 03:00:33 INFO : both9.rclone_chunk.001_idyeej: Moved (server-side) to: both9 2025/03/22 03:00:38 INFO : only9.rclone_chunk.001_idylih: Moved (server-side) to: only9 2025/03/22 03:00:44 INFO : both10.rclone_chunk.001_idyq7r: Moved (server-side) to: both10 2025/03/22 03:00:49 INFO : only10.rclone_chunk.001_idyve9: Moved (server-side) to: only10 2025/03/22 03:00:54 INFO : both11.rclone_chunk.001_idz09u: Moved (server-side) to: both11 2025/03/22 03:00:59 INFO : only11.rclone_chunk.001_idz5gt: Moved (server-side) to: only11 2025/03/22 03:01:04 INFO : both12.rclone_chunk.001_idzaqz: Moved (server-side) to: both12 2025/03/22 03:01:08 INFO : only12.rclone_chunk.001_idzfxh: Moved (server-side) to: only12 2025/03/22 03:01:13 INFO : both13.rclone_chunk.001_idzkcs: Moved (server-side) to: both13 2025/03/22 03:01:18 INFO : only13.rclone_chunk.001_idzprx: Moved (server-side) to: only13 2025/03/22 03:01:23 INFO : both14.rclone_chunk.001_idzuzg: Moved (server-side) to: both14 2025/03/22 03:01:29 INFO : only14.rclone_chunk.001_idzyn7: Moved (server-side) to: only14 2025/03/22 03:01:39 INFO : both15.rclone_chunk.001_ie04ax: Moved (server-side) to: both15 2025/03/22 03:01:45 INFO : only15.rclone_chunk.001_ie0et8: Moved (server-side) to: only15 2025/03/22 03:01:51 INFO : both16.rclone_chunk.001_ie0ldm: Moved (server-side) to: both16 2025/03/22 03:01:57 INFO : only16.rclone_chunk.001_ie0rob: Moved (server-side) to: only16 2025/03/22 03:02:02 INFO : both17.rclone_chunk.001_ie0wbm: Moved (server-side) to: both17 2025/03/22 03:02:08 INFO : only17.rclone_chunk.001_ie11v2: Moved (server-side) to: only17 2025/03/22 03:02:12 INFO : both18.rclone_chunk.001_ie18ou: Moved (server-side) to: both18 2025/03/22 03:02:17 INFO : only18.rclone_chunk.001_ie1ckq: Moved (server-side) to: only18 2025/03/22 03:02:26 INFO : both19.rclone_chunk.001_ie1gwm: Moved (server-side) to: both19 2025/03/22 03:02:50 INFO : only19.rclone_chunk.001_ie1phr: Moved (server-side) to: only19 2025/03/22 03:02:51 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:02:51 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:02:51 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso': Waiting for checks to finish 2025/03/22 03:02:51 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:02:51 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:02:51 DEBUG : both1: Unchanged skipping 2025/03/22 03:02:51 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:02:51 DEBUG : both12: Unchanged skipping 2025/03/22 03:02:51 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:02:51 DEBUG : both13: Unchanged skipping 2025/03/22 03:02:51 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:02:51 DEBUG : both14: Unchanged skipping 2025/03/22 03:02:51 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:02:51 DEBUG : both15: Unchanged skipping 2025/03/22 03:02:51 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:02:51 DEBUG : both16: Unchanged skipping 2025/03/22 03:02:51 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:02:51 DEBUG : both17: Unchanged skipping 2025/03/22 03:02:51 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:02:51 DEBUG : both18: Unchanged skipping 2025/03/22 03:02:51 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:02:51 DEBUG : both19: Unchanged skipping 2025/03/22 03:02:51 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:02:51 DEBUG : both2: Unchanged skipping 2025/03/22 03:02:51 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:02:51 DEBUG : both3: Unchanged skipping 2025/03/22 03:02:51 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:02:51 DEBUG : both4: Unchanged skipping 2025/03/22 03:02:51 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:02:51 DEBUG : both5: Unchanged skipping 2025/03/22 03:02:51 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:02:51 DEBUG : both6: Unchanged skipping 2025/03/22 03:02:51 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:02:51 DEBUG : both7: Unchanged skipping 2025/03/22 03:02:51 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:02:51 DEBUG : both8: Unchanged skipping 2025/03/22 03:02:51 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:02:51 DEBUG : both9: Unchanged skipping 2025/03/22 03:02:51 DEBUG : both10: Unchanged skipping 2025/03/22 03:02:51 DEBUG : both11: Unchanged skipping 2025/03/22 03:02:51 DEBUG : both0: Unchanged skipping 2025/03/22 03:02:51 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso': Waiting for transfers to finish 2025/03/22 03:02:51 DEBUG : Waiting for deletions to finish 2025/03/22 03:02:55 INFO : only7: Deleted 2025/03/22 03:02:55 INFO : only3: Deleted 2025/03/22 03:02:55 INFO : only13: Deleted 2025/03/22 03:02:55 INFO : only0: Deleted 2025/03/22 03:02:58 INFO : only1: Deleted 2025/03/22 03:02:58 INFO : only18: Deleted 2025/03/22 03:02:58 INFO : only19: Deleted 2025/03/22 03:02:58 INFO : only10: Deleted 2025/03/22 03:03:01 INFO : only16: Deleted 2025/03/22 03:03:01 INFO : only9: Deleted 2025/03/22 03:03:01 INFO : only15: Deleted 2025/03/22 03:03:01 INFO : only17: Deleted 2025/03/22 03:03:05 INFO : only5: Deleted 2025/03/22 03:03:05 INFO : only4: Deleted 2025/03/22 03:03:05 INFO : only11: Deleted 2025/03/22 03:03:05 INFO : only6: Deleted 2025/03/22 03:03:08 INFO : only14: Deleted 2025/03/22 03:03:08 INFO : only12: Deleted 2025/03/22 03:03:08 INFO : only2: Deleted 2025/03/22 03:03:08 INFO : only8: Deleted 2025/03/22 03:03:08 INFO : There was nothing to transfer run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" --- PASS: TestSyncConcurrentDelete (336.33s) === RUN TestSyncConcurrentTruncate run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" 2025/03/22 03:04:26 INFO : both0.rclone_chunk.001_ie4xjb: Moved (server-side) to: both0 2025/03/22 03:04:31 INFO : only0.rclone_chunk.001_ie521r: Moved (server-side) to: only0 2025/03/22 03:04:35 INFO : both1.rclone_chunk.001_ie566x: Moved (server-side) to: both1 2025/03/22 03:04:40 INFO : only1.rclone_chunk.001_ie5azx: Moved (server-side) to: only1 2025/03/22 03:04:44 INFO : both2.rclone_chunk.001_ie5fo9: Moved (server-side) to: both2 2025/03/22 03:04:49 INFO : only2.rclone_chunk.001_ie5kfy: Moved (server-side) to: only2 2025/03/22 03:04:53 INFO : both3.rclone_chunk.001_ie5o1g: Moved (server-side) to: both3 2025/03/22 03:04:59 INFO : only3.rclone_chunk.001_ie5s7i: Moved (server-side) to: only3 2025/03/22 03:05:04 INFO : both4.rclone_chunk.001_ie5zrm: Moved (server-side) to: both4 2025/03/22 03:05:09 INFO : only4.rclone_chunk.001_ie63h8: Moved (server-side) to: only4 2025/03/22 03:05:14 INFO : both5.rclone_chunk.001_ie69yq: Moved (server-side) to: both5 2025/03/22 03:05:19 INFO : only5.rclone_chunk.001_ie6dzm: Moved (server-side) to: only5 2025/03/22 03:05:24 INFO : both6.rclone_chunk.001_ie6ia6: Moved (server-side) to: both6 2025/03/22 03:05:28 INFO : only6.rclone_chunk.001_ie6n9j: Moved (server-side) to: only6 2025/03/22 03:05:32 INFO : both7.rclone_chunk.001_ie6rjz: Moved (server-side) to: both7 2025/03/22 03:05:36 INFO : only7.rclone_chunk.001_ie6v2j: Moved (server-side) to: only7 2025/03/22 03:05:40 INFO : both8.rclone_chunk.001_ie6z9n: Moved (server-side) to: both8 2025/03/22 03:05:46 INFO : only8.rclone_chunk.001_ie73kf: Moved (server-side) to: only8 2025/03/22 03:05:50 INFO : both9.rclone_chunk.001_ie79qc: Moved (server-side) to: both9 2025/03/22 03:05:54 INFO : only9.rclone_chunk.001_ie7dw4: Moved (server-side) to: only9 2025/03/22 03:05:59 INFO : both10.rclone_chunk.001_ie7ipz: Moved (server-side) to: both10 2025/03/22 03:06:12 INFO : only10.rclone_chunk.001_ie7m4o: Moved (server-side) to: only10 2025/03/22 03:06:17 INFO : both11.rclone_chunk.001_ie80bj: Moved (server-side) to: both11 2025/03/22 03:06:22 INFO : only11.rclone_chunk.001_ie85i1: Moved (server-side) to: only11 2025/03/22 03:06:27 INFO : both12.rclone_chunk.001_ie899y: Moved (server-side) to: both12 2025/03/22 03:06:32 INFO : only12.rclone_chunk.001_ie8ftt: Moved (server-side) to: only12 2025/03/22 03:06:38 INFO : both13.rclone_chunk.001_ie8jy3: Moved (server-side) to: both13 2025/03/22 03:06:43 INFO : only13.rclone_chunk.001_ie8qxm: Moved (server-side) to: only13 2025/03/22 03:06:48 INFO : both14.rclone_chunk.001_ie8u65: Moved (server-side) to: both14 2025/03/22 03:06:52 INFO : only14.rclone_chunk.001_ie8z3s: Moved (server-side) to: only14 2025/03/22 03:06:56 INFO : both15.rclone_chunk.001_ie93jq: Moved (server-side) to: both15 2025/03/22 03:07:02 INFO : only15.rclone_chunk.001_ie98ye: Moved (server-side) to: only15 2025/03/22 03:07:12 INFO : both16.rclone_chunk.001_ie9dhq: Moved (server-side) to: both16 2025/03/22 03:07:16 INFO : only16.rclone_chunk.001_ie9nws: Moved (server-side) to: only16 2025/03/22 03:07:21 INFO : both17.rclone_chunk.001_ie9s8v: Moved (server-side) to: both17 2025/03/22 03:07:26 INFO : only17.rclone_chunk.001_ie9wv0: Moved (server-side) to: only17 2025/03/22 03:07:30 INFO : both18.rclone_chunk.001_iea1d6: Moved (server-side) to: both18 2025/03/22 03:07:34 INFO : only18.rclone_chunk.001_iea521: Moved (server-side) to: only18 2025/03/22 03:07:39 INFO : both19.rclone_chunk.001_iea9ld: Moved (server-side) to: both19 2025/03/22 03:07:45 INFO : only19.rclone_chunk.001_ieae4p: Moved (server-side) to: only19 2025/03/22 03:07:45 DEBUG : both1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:07:45 DEBUG : both11: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:07:45 DEBUG : both10: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:07:45 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso': Waiting for checks to finish 2025/03/22 03:07:45 DEBUG : both0: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:07:45 DEBUG : both1: Unchanged skipping 2025/03/22 03:07:45 DEBUG : both12: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:07:45 DEBUG : both11: Unchanged skipping 2025/03/22 03:07:45 DEBUG : both13: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:07:45 DEBUG : both13: Unchanged skipping 2025/03/22 03:07:45 DEBUG : both14: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:07:45 DEBUG : both14: Unchanged skipping 2025/03/22 03:07:45 DEBUG : both15: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:07:45 DEBUG : both15: Unchanged skipping 2025/03/22 03:07:45 DEBUG : both16: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:07:45 DEBUG : both16: Unchanged skipping 2025/03/22 03:07:45 DEBUG : both17: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:07:45 DEBUG : both17: Unchanged skipping 2025/03/22 03:07:45 DEBUG : both18: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:07:45 DEBUG : both10: Unchanged skipping 2025/03/22 03:07:45 DEBUG : both19: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:07:45 DEBUG : both19: Unchanged skipping 2025/03/22 03:07:45 DEBUG : both2: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:07:45 DEBUG : both0: Unchanged skipping 2025/03/22 03:07:45 DEBUG : both3: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:07:45 DEBUG : both12: Unchanged skipping 2025/03/22 03:07:45 DEBUG : both4: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:07:45 DEBUG : both18: Unchanged skipping 2025/03/22 03:07:45 DEBUG : both5: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:07:45 DEBUG : both2: Unchanged skipping 2025/03/22 03:07:45 DEBUG : both6: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:07:45 DEBUG : both6: Unchanged skipping 2025/03/22 03:07:45 DEBUG : both7: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:07:45 DEBUG : both7: Unchanged skipping 2025/03/22 03:07:45 DEBUG : both8: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:07:45 DEBUG : both8: Unchanged skipping 2025/03/22 03:07:45 DEBUG : both9: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/22 03:07:45 DEBUG : both9: Unchanged skipping 2025/03/22 03:07:45 DEBUG : only0: Sizes differ (src 0 vs dst 6) 2025/03/22 03:07:45 DEBUG : only1: Sizes differ (src 0 vs dst 6) 2025/03/22 03:07:45 DEBUG : only10: Sizes differ (src 0 vs dst 6) 2025/03/22 03:07:45 DEBUG : only11: Sizes differ (src 0 vs dst 6) 2025/03/22 03:07:45 DEBUG : only12: Sizes differ (src 0 vs dst 6) 2025/03/22 03:07:45 DEBUG : only13: Sizes differ (src 0 vs dst 6) 2025/03/22 03:07:45 DEBUG : only14: Sizes differ (src 0 vs dst 6) 2025/03/22 03:07:45 DEBUG : only15: Sizes differ (src 0 vs dst 6) 2025/03/22 03:07:45 DEBUG : only16: Sizes differ (src 0 vs dst 6) 2025/03/22 03:07:45 DEBUG : only17: Sizes differ (src 0 vs dst 6) 2025/03/22 03:07:45 DEBUG : only18: Sizes differ (src 0 vs dst 6) 2025/03/22 03:07:45 DEBUG : only19: Sizes differ (src 0 vs dst 6) 2025/03/22 03:07:45 DEBUG : only2: Sizes differ (src 0 vs dst 6) 2025/03/22 03:07:45 DEBUG : only3: Sizes differ (src 0 vs dst 6) 2025/03/22 03:07:45 DEBUG : only4: Sizes differ (src 0 vs dst 6) 2025/03/22 03:07:45 DEBUG : only5: Sizes differ (src 0 vs dst 6) 2025/03/22 03:07:45 DEBUG : only6: Sizes differ (src 0 vs dst 6) 2025/03/22 03:07:45 DEBUG : only7: Sizes differ (src 0 vs dst 6) 2025/03/22 03:07:45 DEBUG : only8: Sizes differ (src 0 vs dst 6) 2025/03/22 03:07:45 DEBUG : only9: Sizes differ (src 0 vs dst 6) 2025/03/22 03:07:45 DEBUG : both3: Unchanged skipping 2025/03/22 03:07:45 DEBUG : both4: Unchanged skipping 2025/03/22 03:07:45 DEBUG : both5: Unchanged skipping 2025/03/22 03:07:45 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso': Waiting for transfers to finish 2025/03/22 03:07:45 DEBUG : only0: skip slow MD5 on source file, hashing in-transit 2025/03/22 03:07:45 DEBUG : only1: skip slow MD5 on source file, hashing in-transit 2025/03/22 03:07:45 DEBUG : only10: skip slow MD5 on source file, hashing in-transit 2025/03/22 03:07:45 DEBUG : only11: skip slow MD5 on source file, hashing in-transit 2025/03/22 03:07:51 INFO : only10: Deleted 2025/03/22 03:07:52 INFO : only0: Deleted 2025/03/22 03:07:53 INFO : only10.rclone_chunk.001_ieakuf: Moved (server-side) to: only10 2025/03/22 03:07:53 DEBUG : only10: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/03/22 03:07:53 INFO : only10: Copied (replaced existing) 2025/03/22 03:07:53 DEBUG : only12: skip slow MD5 on source file, hashing in-transit 2025/03/22 03:07:54 INFO : only11: Deleted 2025/03/22 03:07:54 INFO : only1: Deleted 2025/03/22 03:07:55 INFO : only0.rclone_chunk.001_ieakn4: Moved (server-side) to: only0 2025/03/22 03:07:55 DEBUG : only0: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/03/22 03:07:55 INFO : only0: Copied (replaced existing) 2025/03/22 03:07:55 DEBUG : only13: skip slow MD5 on source file, hashing in-transit 2025/03/22 03:07:55 INFO : only11.rclone_chunk.001_ieakxo: Moved (server-side) to: only11 2025/03/22 03:07:55 DEBUG : only11: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/03/22 03:07:55 INFO : only11: Copied (replaced existing) 2025/03/22 03:07:55 DEBUG : only14: skip slow MD5 on source file, hashing in-transit 2025/03/22 03:07:56 INFO : only1.rclone_chunk.001_ieaksh: Moved (server-side) to: only1 2025/03/22 03:07:56 DEBUG : only1: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/03/22 03:07:56 INFO : only1: Copied (replaced existing) 2025/03/22 03:07:56 DEBUG : only15: skip slow MD5 on source file, hashing in-transit 2025/03/22 03:08:00 INFO : only12: Deleted 2025/03/22 03:08:01 INFO : only13: Deleted 2025/03/22 03:08:02 INFO : only12.rclone_chunk.001_ieas3a: Moved (server-side) to: only12 2025/03/22 03:08:02 DEBUG : only12: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/03/22 03:08:02 INFO : only12: Copied (replaced existing) 2025/03/22 03:08:02 DEBUG : only16: skip slow MD5 on source file, hashing in-transit 2025/03/22 03:08:02 INFO : only14: Deleted 2025/03/22 03:08:03 INFO : only13.rclone_chunk.001_ieauyz: Moved (server-side) to: only13 2025/03/22 03:08:03 DEBUG : only13: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/03/22 03:08:03 INFO : only13: Copied (replaced existing) 2025/03/22 03:08:03 DEBUG : only17: skip slow MD5 on source file, hashing in-transit 2025/03/22 03:08:04 INFO : only15: Deleted 2025/03/22 03:08:04 INFO : only14.rclone_chunk.001_ieau4u: Moved (server-side) to: only14 2025/03/22 03:08:04 DEBUG : only14: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/03/22 03:08:04 INFO : only14: Copied (replaced existing) 2025/03/22 03:08:04 DEBUG : only18: skip slow MD5 on source file, hashing in-transit 2025/03/22 03:08:06 INFO : only15.rclone_chunk.001_ieav8o: Moved (server-side) to: only15 2025/03/22 03:08:06 DEBUG : only15: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/03/22 03:08:06 INFO : only15: Copied (replaced existing) 2025/03/22 03:08:06 DEBUG : only19: skip slow MD5 on source file, hashing in-transit 2025/03/22 03:08:10 INFO : only17: Deleted 2025/03/22 03:08:11 INFO : only16: Deleted 2025/03/22 03:08:11 INFO : only17.rclone_chunk.001_ieb23n: Moved (server-side) to: only17 2025/03/22 03:08:11 DEBUG : only17: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/03/22 03:08:11 INFO : only17: Copied (replaced existing) 2025/03/22 03:08:11 DEBUG : only2: skip slow MD5 on source file, hashing in-transit 2025/03/22 03:08:11 INFO : only18: Deleted 2025/03/22 03:08:12 INFO : only18.rclone_chunk.001_ieb3o8: Moved (server-side) to: only18 2025/03/22 03:08:12 DEBUG : only18: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/03/22 03:08:12 INFO : only18: Copied (replaced existing) 2025/03/22 03:08:12 DEBUG : only3: skip slow MD5 on source file, hashing in-transit 2025/03/22 03:08:13 INFO : only16.rclone_chunk.001_ieb1zi: Moved (server-side) to: only16 2025/03/22 03:08:13 DEBUG : only16: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/03/22 03:08:13 INFO : only16: Copied (replaced existing) 2025/03/22 03:08:13 DEBUG : only4: skip slow MD5 on source file, hashing in-transit 2025/03/22 03:08:13 INFO : only19: Deleted 2025/03/22 03:08:15 INFO : only19.rclone_chunk.001_ieb5if: Moved (server-side) to: only19 2025/03/22 03:08:15 DEBUG : only19: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/03/22 03:08:15 INFO : only19: Copied (replaced existing) 2025/03/22 03:08:15 DEBUG : only5: skip slow MD5 on source file, hashing in-transit 2025/03/22 03:08:18 INFO : only2: Deleted 2025/03/22 03:08:20 INFO : only3: Deleted 2025/03/22 03:08:20 INFO : only4: Deleted 2025/03/22 03:08:20 INFO : only2.rclone_chunk.001_iebaay: Moved (server-side) to: only2 2025/03/22 03:08:20 DEBUG : only2: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/03/22 03:08:20 INFO : only2: Copied (replaced existing) 2025/03/22 03:08:20 DEBUG : only6: skip slow MD5 on source file, hashing in-transit 2025/03/22 03:08:21 INFO : only4.rclone_chunk.001_iebc6s: Moved (server-side) to: only4 2025/03/22 03:08:21 DEBUG : only4: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/03/22 03:08:21 INFO : only4: Copied (replaced existing) 2025/03/22 03:08:21 DEBUG : only7: skip slow MD5 on source file, hashing in-transit 2025/03/22 03:08:22 INFO : only3.rclone_chunk.001_iebbhi: Moved (server-side) to: only3 2025/03/22 03:08:22 DEBUG : only3: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/03/22 03:08:22 INFO : only3: Copied (replaced existing) 2025/03/22 03:08:22 DEBUG : only8: skip slow MD5 on source file, hashing in-transit 2025/03/22 03:08:23 INFO : only5: Deleted 2025/03/22 03:08:24 INFO : only5.rclone_chunk.001_iebeyb: Moved (server-side) to: only5 2025/03/22 03:08:24 DEBUG : only5: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/03/22 03:08:24 INFO : only5: Copied (replaced existing) 2025/03/22 03:08:24 DEBUG : only9: skip slow MD5 on source file, hashing in-transit 2025/03/22 03:08:27 INFO : only6: Deleted 2025/03/22 03:08:28 INFO : only7: Deleted 2025/03/22 03:08:28 INFO : only6.rclone_chunk.001_iebjct: Moved (server-side) to: only6 2025/03/22 03:08:28 DEBUG : only6: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/03/22 03:08:28 INFO : only6: Copied (replaced existing) 2025/03/22 03:08:29 INFO : only8: Deleted 2025/03/22 03:08:29 INFO : only7.rclone_chunk.001_iebkvj: Moved (server-side) to: only7 2025/03/22 03:08:29 DEBUG : only7: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/03/22 03:08:29 INFO : only7: Copied (replaced existing) 2025/03/22 03:08:31 INFO : only8.rclone_chunk.001_ieblld: Moved (server-side) to: only8 2025/03/22 03:08:31 DEBUG : only8: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/03/22 03:08:31 INFO : only8: Copied (replaced existing) 2025/03/22 03:08:37 INFO : only9: Deleted 2025/03/22 03:08:38 INFO : only9.rclone_chunk.001_iebnco: Moved (server-side) to: only9 2025/03/22 03:08:38 DEBUG : only9: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/03/22 03:08:38 INFO : only9: Copied (replaced existing) 2025/03/22 03:08:38 DEBUG : Waiting for deletions to finish run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" --- PASS: TestSyncConcurrentTruncate (400.51s) === RUN TestSyncReplaceDirModTime run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" 2025/03/22 03:11:02 DEBUG : empty_dir: Making directory with metadata 2025/03/22 03:11:02 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/03/22 03:11:02 DEBUG : empty_on_remote: Making directory with metadata 2025/03/22 03:11:02 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/03/22 03:11:02 INFO : empty_on_remote: Making directory 2025/03/22 03:11:02 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" 2025/03/22 03:11:12 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/03/22 03:11:12 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/03/22 03:11:12 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/03/22 03:11:12 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" --- PASS: TestSyncReplaceDirModTime (45.16s) === RUN TestSyncReplaceDirModTimeWithEmptyDirs run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" 2025/03/22 03:11:47 DEBUG : empty_dir: Making directory with metadata 2025/03/22 03:11:47 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/03/22 03:11:47 DEBUG : empty_on_remote: Making directory with metadata 2025/03/22 03:11:47 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2025/03/22 03:11:47 INFO : empty_on_remote: Making directory 2025/03/22 03:11:47 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" 2025/03/22 03:11:59 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2025/03/22 03:11:59 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2025/03/22 03:11:59 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2025/03/22 03:11:59 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) 2025/03/22 03:11:59 INFO : empty_dir: Set directory modification time (using DirSetModTime) run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso'", Local "Local file system at /tmp/rclone3310103616", Modify Window "1ns" --- PASS: TestSyncReplaceDirModTimeWithEmptyDirs (51.46s) PASS 2025/03/22 03:12:38 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-ruxadij3beso': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestFixCase|TestSyncBackupDir|TestSyncBackupDirSuffixOnly|TestSyncBackupDirWithSuffix|TestSyncBackupDirWithSuffixKeepExtension|TestSyncConcurrentDelete|TestSyncConcurrentTruncate|TestSyncIgnoreCase|TestSyncImmutable|TestSyncReplaceDirModTime|TestSyncReplaceDirModTimeWithEmptyDirs|TestSyncSuffix|TestSyncSuffixKeepExtension|TestSyncUTFNorm)$|^TestMaxTransfer$/^(Cautious|Hard|Soft)$'" - Finished OK in 22m21.071448559s (try 2/5)