"./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestServerSideCopyOverSelf|TestServerSideMoveOverSelf|TestSyncCopyDest)$'" - Starting (try 2/5) 2024/10/30 06:25:00 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-maticuz2wizi" 2024/10/30 06:25:00 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/10/30 06:25:00 DEBUG : Creating backend with remote "TestYandex:rclone-test-maticuz2wizi" 2024/10/30 06:25:01 DEBUG : Reset feature "ListR" 2024/10/30 06:25:01 DEBUG : Creating backend with remote "/tmp/rclone52258840" === RUN TestServerSideCopyOverSelf run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-maticuz2wizi'", Local "Local file system at /tmp/rclone52258840", Modify Window "1ns" 2024/10/30 06:25:07 INFO : sub dir/hello world.rclone_chunk.001_5u20at: Moved (server-side) to: sub dir/hello world 2024/10/30 06:25:07 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-nusejux9qoyo" 2024/10/30 06:25:07 DEBUG : Creating backend with remote "TestYandex:rclone-test-nusejux9qoyo" 2024/10/30 06:25:08 DEBUG : Reset feature "ListR" sync_test.go:626: Server side copy (if possible) Chunked 'TestChunkerChunk50bYandex:rclone-test-maticuz2wizi' -> Chunked 'TestChunkerChunk50bYandex:rclone-test-nusejux9qoyo' 2024/10/30 06:25:08 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/10/30 06:25:08 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-nusejux9qoyo': Waiting for checks to finish 2024/10/30 06:25:08 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-nusejux9qoyo': Waiting for transfers to finish 2024/10/30 06:25:08 DEBUG : sub dir/hello world: copy non-chunked object... 2024/10/30 06:25:11 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2024/10/30 06:25:11 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-maticuz2wizi'", Local "Local file system at /tmp/rclone52258840", Modify Window "1ns" 2024/10/30 06:25:18 INFO : sub dir/hello world: Deleted 2024/10/30 06:25:19 INFO : sub dir/hello world.rclone_chunk.001_5u2bt8: Moved (server-side) to: sub dir/hello world 2024/10/30 06:25:21 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/10/30 06:25:21 DEBUG : sub dir/hello world: copy non-chunked object... 2024/10/30 06:25:21 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-nusejux9qoyo': Waiting for checks to finish 2024/10/30 06:25:21 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-nusejux9qoyo': Waiting for transfers to finish 2024/10/30 06:25:22 ERROR : sub dir/hello world: Failed to copy: couldn't copy file: [409 - DiskResourceAlreadyExistsError] Resource "disk:/rclone-test-nusejux9qoyo/sub dir/hello world" already exists. (Ресурс "disk:/rclone-test-nusejux9qoyo/sub dir/hello world" уже существует.) sync_test.go:639: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:639 Error: Received unexpected error: couldn't copy file: [409 - DiskResourceAlreadyExistsError] Resource "disk:/rclone-test-nusejux9qoyo/sub dir/hello world" already exists. (Ресурс "disk:/rclone-test-nusejux9qoyo/sub dir/hello world" уже существует.) Test: TestServerSideCopyOverSelf 2024/10/30 06:25:22 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-nusejux9qoyo': Purge remote --- FAIL: TestServerSideCopyOverSelf (27.22s) === RUN TestServerSideMoveOverSelf run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-maticuz2wizi'", Local "Local file system at /tmp/rclone52258840", Modify Window "1ns" 2024/10/30 06:25:34 INFO : sub dir/hello world.rclone_chunk.001_5u2ri4: Moved (server-side) to: sub dir/hello world 2024/10/30 06:25:35 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-bucijag7vite" 2024/10/30 06:25:35 DEBUG : Creating backend with remote "TestYandex:rclone-test-bucijag7vite" 2024/10/30 06:25:35 DEBUG : Reset feature "ListR" sync_test.go:671: Server side copy (if possible) Chunked 'TestChunkerChunk50bYandex:rclone-test-maticuz2wizi' -> Chunked 'TestChunkerChunk50bYandex:rclone-test-bucijag7vite' 2024/10/30 06:25:36 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2024/10/30 06:25:36 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-bucijag7vite': Waiting for checks to finish 2024/10/30 06:25:36 DEBUG : sub dir/hello world: copy non-chunked object... 2024/10/30 06:25:36 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-bucijag7vite': Waiting for transfers to finish 2024/10/30 06:25:38 DEBUG : sub dir/hello world: md5 = 5eb63bbbe01eeed093cb22bb8f5acdc3 OK 2024/10/30 06:25:38 INFO : sub dir/hello world: Copied (server-side copy) run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-maticuz2wizi'", Local "Local file system at /tmp/rclone52258840", Modify Window "1ns" 2024/10/30 06:25:45 INFO : sub dir/hello world: Deleted 2024/10/30 06:25:51 INFO : sub dir/hello world.rclone_chunk.001_5u3252: Moved (server-side) to: sub dir/hello world 2024/10/30 06:25:52 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-bucijag7vite': Using server-side directory move 2024/10/30 06:25:52 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-bucijag7vite': Server side directory move failed - fallback to file moves: can't copy directory - destination already exists 2024/10/30 06:25:53 DEBUG : sub dir/hello world: Sizes differ (src 17 vs dst 11) 2024/10/30 06:25:53 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-bucijag7vite': Waiting for checks to finish 2024/10/30 06:25:53 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-bucijag7vite': Waiting for transfers to finish 2024/10/30 06:25:54 INFO : sub dir/hello world: Deleted 2024/10/30 06:25:54 DEBUG : sub dir/hello world: move non-chunked object... 2024/10/30 06:25:56 INFO : sub dir/hello world: Moved (server-side) 2024/10/30 06:25:56 INFO : sub dir/hello world: Moved (server-side) 2024/10/30 06:26:03 INFO : sub dir/hello world.rclone_chunk.001_5u3kc4: Moved (server-side) to: sub dir/hello world 2024/10/30 06:26:03 DEBUG : testing file moves 2024/10/30 06:26:04 DEBUG : sub dir/hello world: Sizes differ (src 24 vs dst 17) 2024/10/30 06:26:04 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-bucijag7vite': Waiting for checks to finish 2024/10/30 06:26:04 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-bucijag7vite': Waiting for transfers to finish 2024/10/30 06:26:05 INFO : sub dir/hello world: Deleted 2024/10/30 06:26:05 DEBUG : sub dir/hello world: move non-chunked object... 2024/10/30 06:26:07 INFO : sub dir/hello world: Moved (server-side) 2024/10/30 06:26:07 INFO : sub dir/hello world: Moved (server-side) run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-maticuz2wizi'", Local "Local file system at /tmp/rclone52258840", Modify Window "1ns" 2024/10/30 06:26:09 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-bucijag7vite': Purge remote --- PASS: TestServerSideMoveOverSelf (51.04s) === RUN TestSyncCopyDest run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-maticuz2wizi'", Local "Local file system at /tmp/rclone52258840", Modify Window "1ns" 2024/10/30 06:26:19 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-maticuz2wizi/dst" 2024/10/30 06:26:19 DEBUG : Creating backend with remote "TestYandex:rclone-test-maticuz2wizi/dst" 2024/10/30 06:26:20 DEBUG : Reset feature "ListR" 2024/10/30 06:26:20 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-maticuz2wizi/CopyDest" 2024/10/30 06:26:20 DEBUG : Creating backend with remote "TestYandex:rclone-test-maticuz2wizi/CopyDest" 2024/10/30 06:26:20 DEBUG : Reset feature "ListR" 2024/10/30 06:26:22 DEBUG : one: Need to transfer - File not found at Destination 2024/10/30 06:26:22 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-maticuz2wizi/dst': Waiting for checks to finish 2024/10/30 06:26:22 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-maticuz2wizi/dst': Waiting for transfers to finish 2024/10/30 06:26:22 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2024/10/30 06:26:28 INFO : one.rclone_chunk.001_5u48s1: Moved (server-side) to: one 2024/10/30 06:26:28 DEBUG : one: md5 = f97c5d29941bfb1b2fdab0874906ab82 OK 2024/10/30 06:26:28 INFO : one: Copied (new) 2024/10/30 06:26:28 DEBUG : Waiting for deletions to finish 2024/10/30 06:26:29 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/10/30 06:26:29 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-maticuz2wizi/dst': Waiting for checks to finish 2024/10/30 06:26:30 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-maticuz2wizi/dst': Waiting for transfers to finish 2024/10/30 06:26:30 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2024/10/30 06:26:38 INFO : one: Deleted 2024/10/30 06:26:40 INFO : one.rclone_chunk.001_5u4gj6: Moved (server-side) to: one 2024/10/30 06:26:40 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK 2024/10/30 06:26:40 INFO : one: Copied (replaced existing) 2024/10/30 06:26:40 DEBUG : Waiting for deletions to finish 2024/10/30 06:26:46 INFO : dst/one: Deleted 2024/10/30 06:26:48 INFO : dst/one.rclone_chunk.001_5u4ryk: Moved (server-side) to: dst/one 2024/10/30 06:26:58 INFO : CopyDest/one.rclone_chunk.001_5u4ywh: Moved (server-side) to: CopyDest/one 2024/10/30 06:26:59 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-maticuz2wizi/BackupDir" 2024/10/30 06:26:59 DEBUG : Creating backend with remote "TestYandex:rclone-test-maticuz2wizi/BackupDir" 2024/10/30 06:26:59 DEBUG : Reset feature "ListR" 2024/10/30 06:27:00 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/10/30 06:27:00 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-maticuz2wizi/dst': Waiting for checks to finish 2024/10/30 06:27:00 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 06:27:00 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/10/30 06:27:01 DEBUG : one: move non-chunked object... 2024/10/30 06:27:02 INFO : one: Moved (server-side) 2024/10/30 06:27:02 INFO : one: Moved (server-side) 2024/10/30 06:27:02 DEBUG : one: copy non-chunked object... 2024/10/30 06:27:04 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK 2024/10/30 06:27:04 INFO : one: Copied (server-side copy) 2024/10/30 06:27:04 DEBUG : one: Destination found in --copy-dest, using server-side copy 2024/10/30 06:27:04 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-maticuz2wizi/dst': Waiting for transfers to finish 2024/10/30 06:27:04 DEBUG : Waiting for deletions to finish 2024/10/30 06:27:10 INFO : CopyDest/two.rclone_chunk.001_5u5gvb: Moved (server-side) to: CopyDest/two 2024/10/30 06:27:12 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 06:27:12 DEBUG : two: copy non-chunked object... 2024/10/30 06:27:13 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 OK 2024/10/30 06:27:13 INFO : two: Copied (server-side copy) 2024/10/30 06:27:13 DEBUG : two: Destination found in --copy-dest, using server-side copy 2024/10/30 06:27:13 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 06:27:13 DEBUG : one: Unchanged skipping 2024/10/30 06:27:13 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-maticuz2wizi/dst': Waiting for checks to finish 2024/10/30 06:27:13 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-maticuz2wizi/dst': Waiting for transfers to finish 2024/10/30 06:27:13 DEBUG : Waiting for deletions to finish 2024/10/30 06:27:14 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 06:27:14 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-maticuz2wizi/dst': Waiting for checks to finish 2024/10/30 06:27:14 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 06:27:14 DEBUG : two: Unchanged skipping 2024/10/30 06:27:14 DEBUG : one: Unchanged skipping 2024/10/30 06:27:14 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-maticuz2wizi/dst': Waiting for transfers to finish 2024/10/30 06:27:14 DEBUG : Waiting for deletions to finish 2024/10/30 06:27:14 INFO : There was nothing to transfer 2024/10/30 06:27:19 INFO : CopyDest/three.rclone_chunk.001_5u5o5l: Moved (server-side) to: CopyDest/three 2024/10/30 06:27:22 DEBUG : three: Sizes differ (src 7 vs dst 5) 2024/10/30 06:27:22 DEBUG : three: Destination not found in --copy-dest 2024/10/30 06:27:22 DEBUG : three: Need to transfer - File not found at Destination 2024/10/30 06:27:22 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 06:27:22 DEBUG : one: Unchanged skipping 2024/10/30 06:27:22 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/10/30 06:27:22 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-maticuz2wizi/dst': Waiting for checks to finish 2024/10/30 06:27:22 DEBUG : two: Unchanged skipping 2024/10/30 06:27:22 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-maticuz2wizi/dst': Waiting for transfers to finish 2024/10/30 06:27:22 DEBUG : three: skip slow MD5 on source file, hashing in-transit 2024/10/30 06:27:29 INFO : three.rclone_chunk.001_5u5wfw: Moved (server-side) to: three 2024/10/30 06:27:29 DEBUG : three: md5 = 1bccb9dccb3e9f6a3f9d2a8bdb54b7f5 OK 2024/10/30 06:27:29 INFO : three: Copied (new) 2024/10/30 06:27:29 DEBUG : Waiting for deletions to finish --- PASS: TestSyncCopyDest (91.04s) FAIL 2024/10/30 06:27:50 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-maticuz2wizi': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^(TestServerSideCopyOverSelf|TestServerSideMoveOverSelf|TestSyncCopyDest)$'" - Finished ERROR in 2m52.176563s (try 2/5): exit status 1: Failed [TestServerSideCopyOverSelf]