"./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -fast-list -size-limit 1024 -test.run '^(TestCopy|TestServerSideMoveWithFilter|TestSyncBackupDir)$'" - Starting (try 2/5) 2025/01/31 03:44:16 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-fagimap2tuve" 2025/01/31 03:44:16 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/01/31 03:44:16 DEBUG : Creating backend with remote "TestYandex:rclone-test-fagimap2tuve" 2025/01/31 03:44:16 DEBUG : Reset feature "ListR" 2025/01/31 03:44:16 DEBUG : Creating backend with remote "/tmp/rclone1535868011" === RUN TestCopy run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-fagimap2tuve'", Local "Local file system at /tmp/rclone1535868011", Modify Window "1ns" 2025/01/31 03:44:16 INFO : sub dir: Set directory modification time (using DirSetModTime) 2025/01/31 03:44:17 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2025/01/31 03:44:17 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-fagimap2tuve': Waiting for checks to finish 2025/01/31 03:44:17 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-fagimap2tuve': Waiting for transfers to finish 2025/01/31 03:44:17 DEBUG : sub dir/hello world: skip slow MD5 on source file, hashing in-transit 2025/01/31 03:44:22 INFO : sub dir/hello world.rclone_chunk.001_xumv5z: Moved (server-side) to: sub dir/hello world 2025/01/31 03:44:22 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2025/01/31 03:44:22 INFO : sub dir/hello world: Copied (new) run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-fagimap2tuve'", Local "Local file system at /tmp/rclone1535868011", Modify Window "1ns" 2025/01/31 03:44:23 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-fagimap2tuve': Skipping modtime test as remote does not support DirSetModTime or MkdirMetadata --- PASS: TestCopy (15.10s) === RUN TestServerSideMoveWithFilter run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-fagimap2tuve'", Local "Local file system at /tmp/rclone1535868011", Modify Window "1ns" 2025/01/31 03:44:31 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-layuqis7xuca" 2025/01/31 03:44:31 DEBUG : Creating backend with remote "TestYandex:rclone-test-layuqis7xuca" 2025/01/31 03:44:32 DEBUG : Reset feature "ListR" 2025/01/31 03:44:38 INFO : potato2.rclone_chunk.001_xunarw: Moved (server-side) to: potato2.rclone_chunk.001 2025/01/31 03:44:40 INFO : potato2.rclone_chunk.002_xunarw: Moved (server-side) to: potato2.rclone_chunk.002 2025/01/31 03:44:46 INFO : empty space.rclone_chunk.001_xunk9a: Moved (server-side) to: empty space 2025/01/31 03:44:53 INFO : potato3.rclone_chunk.001_xunp54: Moved (server-side) to: potato3.rclone_chunk.001 2025/01/31 03:44:54 INFO : potato3.rclone_chunk.002_xunp54: Moved (server-side) to: potato3.rclone_chunk.002 sync_test.go:1705: Server side move (if possible) Chunked 'TestChunkerChunk50bYandex:rclone-test-fagimap2tuve' -> Chunked 'TestChunkerChunk50bYandex:rclone-test-layuqis7xuca' 2025/01/31 03:45:04 INFO : empty space.rclone_chunk.001_xuo0oi: Moved (server-side) to: empty space 2025/01/31 03:45:16 INFO : potato3.rclone_chunk.001_xuo7ln: Moved (server-side) to: potato3.rclone_chunk.001 2025/01/31 03:45:17 INFO : potato3.rclone_chunk.002_xuo7ln: Moved (server-side) to: potato3.rclone_chunk.002 2025/01/31 03:45:21 DEBUG : empty space: Excluded (Size Filter) 2025/01/31 03:45:21 DEBUG : empty space: Excluded 2025/01/31 03:45:21 DEBUG : empty space: Excluded (Size Filter) 2025/01/31 03:45:21 DEBUG : empty space: Excluded 2025/01/31 03:45:21 DEBUG : potato2: Need to transfer - File not found at Destination 2025/01/31 03:45:21 DEBUG : potato3: Sizes differ (src 68 vs dst 60) 2025/01/31 03:45:21 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-layuqis7xuca': Waiting for checks to finish 2025/01/31 03:45:21 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-layuqis7xuca': Waiting for transfers to finish 2025/01/31 03:45:21 DEBUG : potato2: move 2 data chunks... 2025/01/31 03:45:24 INFO : potato2.rclone_chunk.001: Moved (server-side) 2025/01/31 03:45:25 INFO : potato2.rclone_chunk.002: Moved (server-side) 2025/01/31 03:45:27 INFO : potato2: Moved (server-side) 2025/01/31 03:45:29 INFO : potato2: Moved (server-side) 2025/01/31 03:45:31 INFO : potato3: Deleted 2025/01/31 03:45:31 DEBUG : potato3: move 2 data chunks... 2025/01/31 03:45:33 INFO : potato3.rclone_chunk.001: Moved (server-side) 2025/01/31 03:45:35 INFO : potato3.rclone_chunk.002: Moved (server-side) 2025/01/31 03:45:36 INFO : potato3: Moved (server-side) 2025/01/31 03:45:38 INFO : potato3: Moved (server-side) 2025/01/31 03:45:40 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-pavihis7wibi" 2025/01/31 03:45:40 DEBUG : Creating backend with remote "TestYandex:rclone-test-pavihis7wibi" 2025/01/31 03:45:40 DEBUG : Reset feature "ListR" 2025/01/31 03:45:40 DEBUG : empty space: Excluded (Size Filter) 2025/01/31 03:45:40 DEBUG : empty space: Excluded 2025/01/31 03:45:40 DEBUG : potato2: Need to transfer - File not found at Destination 2025/01/31 03:45:40 DEBUG : potato3: Need to transfer - File not found at Destination 2025/01/31 03:45:40 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-pavihis7wibi': Waiting for checks to finish 2025/01/31 03:45:40 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-pavihis7wibi': Waiting for transfers to finish 2025/01/31 03:45:41 DEBUG : potato3: move 2 data chunks... 2025/01/31 03:45:41 DEBUG : potato2: move 2 data chunks... 2025/01/31 03:45:43 INFO : potato2.rclone_chunk.001: Moved (server-side) 2025/01/31 03:45:43 INFO : potato3.rclone_chunk.001: Moved (server-side) 2025/01/31 03:45:44 INFO : potato2.rclone_chunk.002: Moved (server-side) 2025/01/31 03:45:44 INFO : potato3.rclone_chunk.002: Moved (server-side) 2025/01/31 03:45:46 INFO : potato2: Moved (server-side) 2025/01/31 03:45:46 INFO : potato3: Moved (server-side) 2025/01/31 03:45:48 INFO : potato2: Moved (server-side) 2025/01/31 03:45:48 INFO : potato3: Moved (server-side) 2025/01/31 03:45:54 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-pavihis7wibi': Purge remote 2025/01/31 03:46:03 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-layuqis7xuca': Purge remote --- PASS: TestServerSideMoveWithFilter (104.23s) === RUN TestSyncBackupDir run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-fagimap2tuve'", Local "Local file system at /tmp/rclone1535868011", Modify Window "1ns" 2025/01/31 03:46:22 INFO : dst/one.rclone_chunk.001_xuq62f: Moved (server-side) to: dst/one 2025/01/31 03:46:27 INFO : dst/two.rclone_chunk.001_xuqc9g: Moved (server-side) to: dst/two 2025/01/31 03:46:33 INFO : dst/three.txt.rclone_chunk.001_xuqhd4: Moved (server-side) to: dst/three.txt 2025/01/31 03:46:34 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-fagimap2tuve/dst" 2025/01/31 03:46:34 DEBUG : Creating backend with remote "TestYandex:rclone-test-fagimap2tuve/dst" 2025/01/31 03:46:35 DEBUG : Reset feature "ListR" 2025/01/31 03:46:35 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-fagimap2tuve/backup" 2025/01/31 03:46:35 DEBUG : Creating backend with remote "TestYandex:rclone-test-fagimap2tuve/backup" 2025/01/31 03:46:35 DEBUG : Reset feature "ListR" 2025/01/31 03:46:35 DEBUG : one: Sizes differ (src 4 vs dst 3) 2025/01/31 03:46:35 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/31 03:46:35 DEBUG : two: Unchanged skipping 2025/01/31 03:46:35 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-fagimap2tuve/dst': Waiting for checks to finish 2025/01/31 03:46:36 DEBUG : one: move non-chunked object... 2025/01/31 03:46:38 INFO : one: Moved (server-side) 2025/01/31 03:46:38 INFO : one: Moved (server-side) 2025/01/31 03:46:38 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-fagimap2tuve/dst': Waiting for transfers to finish 2025/01/31 03:46:38 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/01/31 03:46:43 INFO : one.rclone_chunk.001_xuqsb7: Moved (server-side) to: one 2025/01/31 03:46:43 DEBUG : one: md5 = c7957179c41f69d44f217a108c7915d8 OK 2025/01/31 03:46:43 INFO : one: Copied (new) 2025/01/31 03:46:43 DEBUG : Waiting for deletions to finish 2025/01/31 03:46:43 DEBUG : three.txt: move non-chunked object... 2025/01/31 03:46:44 INFO : three.txt: Moved (server-side) 2025/01/31 03:46:44 INFO : three.txt: Moved (server-side) 2025/01/31 03:46:44 INFO : three.txt: Moved into backup dir 2025/01/31 03:46:49 INFO : dst/three.txt.rclone_chunk.001_xuqz7j: Moved (server-side) to: dst/three.txt 2025/01/31 03:46:50 DEBUG : one: Sizes differ (src 5 vs dst 4) 2025/01/31 03:46:50 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/31 03:46:50 DEBUG : two: Unchanged skipping 2025/01/31 03:46:50 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-fagimap2tuve/dst': Waiting for checks to finish 2025/01/31 03:46:53 INFO : one: Deleted 2025/01/31 03:46:53 DEBUG : one: move non-chunked object... 2025/01/31 03:46:56 INFO : one: Moved (server-side) 2025/01/31 03:46:56 INFO : one: Moved (server-side) 2025/01/31 03:46:56 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-fagimap2tuve/dst': Waiting for transfers to finish 2025/01/31 03:46:56 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/01/31 03:47:00 INFO : one.rclone_chunk.001_xurac1: Moved (server-side) to: one 2025/01/31 03:47:00 DEBUG : one: md5 = 0f93e81041f0cab37c37a05ae998b219 OK 2025/01/31 03:47:00 INFO : one: Copied (new) 2025/01/31 03:47:00 DEBUG : Waiting for deletions to finish 2025/01/31 03:47:04 INFO : three.txt: Deleted 2025/01/31 03:47:04 DEBUG : three.txt: move non-chunked object... 2025/01/31 03:47:06 INFO : three.txt: Moved (server-side) 2025/01/31 03:47:06 INFO : three.txt: Moved (server-side) 2025/01/31 03:47:06 INFO : three.txt: Moved into backup dir --- PASS: TestSyncBackupDir (73.46s) PASS 2025/01/31 03:47:29 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-fagimap2tuve': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -fast-list -size-limit 1024 -test.run '^(TestCopy|TestServerSideMoveWithFilter|TestSyncBackupDir)$'" - Finished OK in 3m16.212644843s (try 2/5)