"./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bMD5QuickS3: -verbose -size-limit 1024 -test.run '^TestServerSideMoveDeleteEmptySourceDirs$'" - Starting (try 2/5) 2025/12/22 04:32:17 DEBUG : Creating backend with remote "TestChunkerChunk50bMD5QuickS3:rclone-test-qosazik3qejo" 2025/12/22 04:32:17 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/12/22 04:32:17 DEBUG : Creating backend with remote "TestS3:rclone-test-qosazik3qejo" 2025/12/22 04:32:17 DEBUG : Creating backend with remote "/tmp/rclone2839769815" === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:185: Remote "Chunked 'TestChunkerChunk50bMD5QuickS3:rclone-test-qosazik3qejo'", Local "Local file system at /tmp/rclone2839769815", Modify Window "1ns" 2025/12/22 04:32:17 DEBUG : Creating backend with remote "TestChunkerChunk50bMD5QuickS3:rclone-test-coromex4nama" 2025/12/22 04:32:17 DEBUG : Creating backend with remote "TestS3:rclone-test-coromex4nama" 2025/12/22 04:32:18 INFO : S3 bucket rclone-test-qosazik3qejo: Bucket "rclone-test-qosazik3qejo" created with ACL "" 2025/12/22 04:32:19 DEBUG : potato2.rclone_chunk.001: size = 50 OK 2025/12/22 04:32:19 DEBUG : potato2.rclone_chunk.001_nrm7i0: md5 = dbbc040ac83a6f6c6816767a36d34c7b OK 2025/12/22 04:32:19 INFO : potato2.rclone_chunk.001_nrm7i0: Copied (server-side copy) to: potato2.rclone_chunk.001 2025/12/22 04:32:19 INFO : potato2.rclone_chunk.001_nrm7i0: Deleted 2025/12/22 04:32:19 DEBUG : potato2.rclone_chunk.002: size = 10 OK 2025/12/22 04:32:19 DEBUG : potato2.rclone_chunk.002_nrm7i0: md5 = 01a6651a94ab602dbfc47587d234b52c OK 2025/12/22 04:32:19 INFO : potato2.rclone_chunk.002_nrm7i0: Copied (server-side copy) to: potato2.rclone_chunk.002 2025/12/22 04:32:19 INFO : potato2.rclone_chunk.002_nrm7i0: Deleted 2025/12/22 04:32:19 DEBUG : empty space: size = 1 OK 2025/12/22 04:32:19 DEBUG : empty space.rclone_chunk.001_nrm8l6: md5 = 336d5ebc5436534e61d16e63ddfca327 OK 2025/12/22 04:32:19 INFO : empty space.rclone_chunk.001_nrm8l6: Copied (server-side copy) to: empty space 2025/12/22 04:32:19 INFO : empty space.rclone_chunk.001_nrm8l6: Deleted 2025/12/22 04:32:20 DEBUG : potato3.rclone_chunk.001: size = 50 OK 2025/12/22 04:32:20 DEBUG : potato3.rclone_chunk.001_nrm809: md5 = dbbc040ac83a6f6c6816767a36d34c7b OK 2025/12/22 04:32:20 INFO : potato3.rclone_chunk.001_nrm809: Copied (server-side copy) to: potato3.rclone_chunk.001 2025/12/22 04:32:20 INFO : potato3.rclone_chunk.001_nrm809: Deleted 2025/12/22 04:32:20 DEBUG : potato3.rclone_chunk.002: size = 18 OK 2025/12/22 04:32:20 DEBUG : potato3.rclone_chunk.002_nrm809: md5 = 111c387f2584838efb7e0ec6f2fa2e10 OK 2025/12/22 04:32:20 INFO : potato3.rclone_chunk.002_nrm809: Copied (server-side copy) to: potato3.rclone_chunk.002 2025/12/22 04:32:20 INFO : potato3.rclone_chunk.002_nrm809: Deleted 2025/12/22 04:32:20 INFO : tomatoDir: Making directory sync_test.go:1736: Server side move (if possible) Chunked 'TestChunkerChunk50bMD5QuickS3:rclone-test-qosazik3qejo' -> Chunked 'TestChunkerChunk50bMD5QuickS3:rclone-test-coromex4nama' 2025/12/22 04:32:21 INFO : S3 bucket rclone-test-coromex4nama: Bucket "rclone-test-coromex4nama" created with ACL "" 2025/12/22 04:32:21 DEBUG : empty space: size = 1 OK 2025/12/22 04:32:21 DEBUG : empty space.rclone_chunk.001_nrmac0: md5 = 336d5ebc5436534e61d16e63ddfca327 OK 2025/12/22 04:32:21 INFO : empty space.rclone_chunk.001_nrmac0: Copied (server-side copy) to: empty space 2025/12/22 04:32:21 INFO : empty space.rclone_chunk.001_nrmac0: Deleted 2025/12/22 04:32:22 DEBUG : potato3.rclone_chunk.001: size = 50 OK 2025/12/22 04:32:22 DEBUG : potato3.rclone_chunk.001_nrmady: md5 = dbbc040ac83a6f6c6816767a36d34c7b OK 2025/12/22 04:32:22 INFO : potato3.rclone_chunk.001_nrmady: Copied (server-side copy) to: potato3.rclone_chunk.001 2025/12/22 04:32:22 INFO : potato3.rclone_chunk.001_nrmady: Deleted 2025/12/22 04:32:22 DEBUG : potato3.rclone_chunk.002: size = 10 OK 2025/12/22 04:32:22 DEBUG : potato3.rclone_chunk.002_nrmady: md5 = 01a6651a94ab602dbfc47587d234b52c OK 2025/12/22 04:32:22 INFO : potato3.rclone_chunk.002_nrmady: Copied (server-side copy) to: potato3.rclone_chunk.002 2025/12/22 04:32:22 INFO : potato3.rclone_chunk.002_nrmady: Deleted 2025/12/22 04:32:22 DEBUG : potato2: Need to transfer - File not found at Destination 2025/12/22 04:32:22 DEBUG : empty space: size = 1 OK 2025/12/22 04:32:22 DEBUG : potato3: size = 68 (Chunked 'TestChunkerChunk50bMD5QuickS3:rclone-test-qosazik3qejo') 2025/12/22 04:32:22 DEBUG : potato3: size = 60 (Chunked 'TestChunkerChunk50bMD5QuickS3:rclone-test-coromex4nama') 2025/12/22 04:32:22 DEBUG : potato3: Sizes differ 2025/12/22 04:32:22 DEBUG : Chunked 'TestChunkerChunk50bMD5QuickS3:rclone-test-coromex4nama': Waiting for checks to finish 2025/12/22 04:32:22 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/12/22 04:32:22 DEBUG : empty space: Unchanged skipping 2025/12/22 04:32:22 DEBUG : potato2: Can't copy - required hash not found 2025/12/22 04:32:22 DEBUG : potato3: Can't copy - required hash not found 2025/12/22 04:32:22 INFO : empty space: Deleted 2025/12/22 04:32:22 DEBUG : Chunked 'TestChunkerChunk50bMD5QuickS3:rclone-test-coromex4nama': Waiting for transfers to finish 2025/12/22 04:32:23 DEBUG : potato2.rclone_chunk.001: size = 50 OK 2025/12/22 04:32:23 DEBUG : potato2.rclone_chunk.001_nrmbx7: md5 = dbbc040ac83a6f6c6816767a36d34c7b OK 2025/12/22 04:32:23 INFO : potato2.rclone_chunk.001_nrmbx7: Copied (server-side copy) to: potato2.rclone_chunk.001 2025/12/22 04:32:23 INFO : potato2.rclone_chunk.001_nrmbx7: Deleted 2025/12/22 04:32:23 DEBUG : potato2.rclone_chunk.002: size = 10 OK 2025/12/22 04:32:23 DEBUG : potato2.rclone_chunk.002_nrmbx7: md5 = 01a6651a94ab602dbfc47587d234b52c OK 2025/12/22 04:32:23 INFO : potato2.rclone_chunk.002_nrmbx7: Copied (server-side copy) to: potato2.rclone_chunk.002 2025/12/22 04:32:23 INFO : potato2.rclone_chunk.002_nrmbx7: Deleted 2025/12/22 04:32:23 DEBUG : potato3.rclone_chunk.001: size = 50 OK 2025/12/22 04:32:23 DEBUG : potato3.rclone_chunk.001_nrmbyw: md5 = dbbc040ac83a6f6c6816767a36d34c7b OK 2025/12/22 04:32:23 INFO : potato3.rclone_chunk.001_nrmbyw: Copied (server-side copy) to: potato3.rclone_chunk.001 2025/12/22 04:32:23 INFO : potato3.rclone_chunk.001_nrmbyw: Deleted 2025/12/22 04:32:23 DEBUG : potato2: size = 60 OK 2025/12/22 04:32:23 INFO : potato2: Copied (new) 2025/12/22 04:32:23 DEBUG : potato3.rclone_chunk.002: size = 18 OK 2025/12/22 04:32:23 DEBUG : potato3.rclone_chunk.002_nrmbyw: md5 = 111c387f2584838efb7e0ec6f2fa2e10 OK 2025/12/22 04:32:23 INFO : potato3.rclone_chunk.002_nrmbyw: Copied (server-side copy) to: potato3.rclone_chunk.002 2025/12/22 04:32:23 INFO : potato3.rclone_chunk.002_nrmbyw: Deleted 2025/12/22 04:32:23 INFO : potato2: Deleted 2025/12/22 04:32:23 DEBUG : potato3: size = 68 OK 2025/12/22 04:32:23 INFO : potato3: Copied (replaced existing) 2025/12/22 04:32:24 INFO : potato3: Deleted 2025/12/22 04:32:24 DEBUG : Creating backend with remote "TestChunkerChunk50bMD5QuickS3:rclone-test-zuzupay6pira" 2025/12/22 04:32:24 DEBUG : Creating backend with remote "TestS3:rclone-test-zuzupay6pira" 2025/12/22 04:32:24 INFO : tomatoDir: Making directory 2025/12/22 04:32:24 DEBUG : empty space: Need to transfer - File not found at Destination 2025/12/22 04:32:24 DEBUG : potato2: Need to transfer - File not found at Destination 2025/12/22 04:32:24 DEBUG : potato3: Need to transfer - File not found at Destination 2025/12/22 04:32:24 DEBUG : Chunked 'TestChunkerChunk50bMD5QuickS3:rclone-test-zuzupay6pira': Waiting for checks to finish 2025/12/22 04:32:24 DEBUG : Chunked 'TestChunkerChunk50bMD5QuickS3:rclone-test-zuzupay6pira': Waiting for transfers to finish 2025/12/22 04:32:24 DEBUG : empty space: copy non-chunked object... 2025/12/22 04:32:24 DEBUG : potato2: Can't copy - required hash not found 2025/12/22 04:32:24 DEBUG : potato3: Can't copy - required hash not found 2025/12/22 04:32:25 INFO : S3 bucket rclone-test-zuzupay6pira: Bucket "rclone-test-zuzupay6pira" created with ACL "" 2025/12/22 04:32:25 DEBUG : empty space: size = 1 OK 2025/12/22 04:32:25 INFO : empty space: Copied (server-side copy) 2025/12/22 04:32:25 INFO : empty space: Deleted 2025/12/22 04:32:25 DEBUG : potato3.rclone_chunk.001: size = 50 OK 2025/12/22 04:32:25 DEBUG : potato3.rclone_chunk.001_nrmdph: md5 = dbbc040ac83a6f6c6816767a36d34c7b OK 2025/12/22 04:32:25 INFO : potato3.rclone_chunk.001_nrmdph: Copied (server-side copy) to: potato3.rclone_chunk.001 2025/12/22 04:32:25 DEBUG : potato2.rclone_chunk.001: size = 50 OK 2025/12/22 04:32:25 DEBUG : potato2.rclone_chunk.001_nrmdij: md5 = dbbc040ac83a6f6c6816767a36d34c7b OK 2025/12/22 04:32:25 INFO : potato2.rclone_chunk.001_nrmdij: Copied (server-side copy) to: potato2.rclone_chunk.001 2025/12/22 04:32:25 INFO : potato3.rclone_chunk.001_nrmdph: Deleted 2025/12/22 04:32:25 INFO : potato2.rclone_chunk.001_nrmdij: Deleted 2025/12/22 04:32:25 DEBUG : potato3.rclone_chunk.002: size = 18 OK 2025/12/22 04:32:25 DEBUG : potato3.rclone_chunk.002_nrmdph: md5 = 111c387f2584838efb7e0ec6f2fa2e10 OK 2025/12/22 04:32:25 INFO : potato3.rclone_chunk.002_nrmdph: Copied (server-side copy) to: potato3.rclone_chunk.002 2025/12/22 04:32:25 DEBUG : potato2.rclone_chunk.002: size = 10 OK 2025/12/22 04:32:25 DEBUG : potato2.rclone_chunk.002_nrmdij: md5 = 01a6651a94ab602dbfc47587d234b52c OK 2025/12/22 04:32:25 INFO : potato2.rclone_chunk.002_nrmdij: Copied (server-side copy) to: potato2.rclone_chunk.002 2025/12/22 04:32:25 INFO : potato3.rclone_chunk.002_nrmdph: Deleted 2025/12/22 04:32:25 INFO : potato2.rclone_chunk.002_nrmdij: Deleted 2025/12/22 04:32:25 DEBUG : potato3: size = 68 OK 2025/12/22 04:32:25 INFO : potato3: Copied (new) 2025/12/22 04:32:25 DEBUG : potato2: size = 60 OK 2025/12/22 04:32:25 INFO : potato2: Copied (new) 2025/12/22 04:32:25 INFO : potato3: Deleted 2025/12/22 04:32:25 INFO : potato2: Deleted 2025/12/22 04:32:26 DEBUG : Chunked 'TestChunkerChunk50bMD5QuickS3:rclone-test-zuzupay6pira': Purge remote 2025/12/22 04:32:26 DEBUG : S3 bucket rclone-test-zuzupay6pira: bucket is versioned: false 2025/12/22 04:32:26 DEBUG : Waiting for deletions to finish 2025/12/22 04:32:26 DEBUG : "empty space" version false 2025/12/22 04:32:26 DEBUG : empty space: Deleting (id "") 2025/12/22 04:32:26 DEBUG : "potato2" version false 2025/12/22 04:32:26 DEBUG : potato2: Deleting (id "") 2025/12/22 04:32:26 DEBUG : "potato2.rclone_chunk.001" version false 2025/12/22 04:32:26 DEBUG : potato2.rclone_chunk.001: Deleting (id "") 2025/12/22 04:32:26 DEBUG : "potato2.rclone_chunk.002" version false 2025/12/22 04:32:26 DEBUG : potato2.rclone_chunk.002: Deleting (id "") 2025/12/22 04:32:26 DEBUG : "potato3" version false 2025/12/22 04:32:26 DEBUG : potato3: Deleting (id "") 2025/12/22 04:32:26 DEBUG : "potato3.rclone_chunk.001" version false 2025/12/22 04:32:26 DEBUG : potato3.rclone_chunk.001: Deleting (id "") 2025/12/22 04:32:26 DEBUG : "potato3.rclone_chunk.002" version false 2025/12/22 04:32:26 DEBUG : potato3.rclone_chunk.002: Deleting (id "") 2025/12/22 04:32:26 INFO : potato2: Deleted 2025/12/22 04:32:26 INFO : potato2.rclone_chunk.001: Deleted 2025/12/22 04:32:26 INFO : empty space: Deleted 2025/12/22 04:32:26 INFO : potato2.rclone_chunk.002: Deleted 2025/12/22 04:32:26 INFO : potato3: Deleted 2025/12/22 04:32:26 INFO : potato3.rclone_chunk.001: Deleted 2025/12/22 04:32:26 INFO : potato3.rclone_chunk.002: Deleted 2025/12/22 04:32:26 INFO : S3 bucket rclone-test-zuzupay6pira: Bucket "rclone-test-zuzupay6pira" deleted 2025/12/22 04:32:26 DEBUG : Chunked 'TestChunkerChunk50bMD5QuickS3:rclone-test-coromex4nama': Purge remote 2025/12/22 04:32:26 DEBUG : S3 bucket rclone-test-coromex4nama: bucket is versioned: false 2025/12/22 04:32:26 DEBUG : Waiting for deletions to finish 2025/12/22 04:32:27 INFO : S3 bucket rclone-test-coromex4nama: Bucket "rclone-test-coromex4nama" deleted --- PASS: TestServerSideMoveDeleteEmptySourceDirs (9.25s) PASS 2025/12/22 04:32:27 DEBUG : Chunked 'TestChunkerChunk50bMD5QuickS3:rclone-test-qosazik3qejo': Purge remote 2025/12/22 04:32:27 DEBUG : S3 bucket rclone-test-qosazik3qejo: bucket is versioned: false 2025/12/22 04:32:27 DEBUG : Waiting for deletions to finish 2025/12/22 04:32:27 INFO : S3 bucket rclone-test-qosazik3qejo: Bucket "rclone-test-qosazik3qejo" deleted "./sync.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bMD5QuickS3: -verbose -size-limit 1024 -test.run '^TestServerSideMoveDeleteEmptySourceDirs$'" - Finished OK in 9.667802678s (try 2/5)