"./operations.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -fast-list -size-limit 1024 -test.run '^(TestCat|TestCheckSizeOnly|TestCopyFileBackupDir|TestCopyFileCompareDest)$|^TestRcat$/^withChecksum=false,ignoreChecksum=false$'" - Starting (try 2/5) 2025/01/16 02:05:05 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-cadawag1padu" 2025/01/16 02:05:05 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/01/16 02:05:05 DEBUG : Creating backend with remote "TestYandex:rclone-test-cadawag1padu" 2025/01/16 02:05:05 DEBUG : Reset feature "ListR" 2025/01/16 02:05:05 DEBUG : Creating backend with remote "/tmp/rclone411005969" === RUN TestCheckSizeOnly run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-cadawag1padu'", Local "Local file system at /tmp/rclone411005969", Modify Window "1ns" 2025/01/16 02:05:12 INFO : rutabaga.rclone_chunk.001_5y1k24: Moved (server-side) to: rutabaga === RUN TestCheckSizeOnly/1 === RUN TestCheckSizeOnly/2 2025/01/16 02:05:19 INFO : empty space.rclone_chunk.001_5y1ry6: Moved (server-side) to: empty space === RUN TestCheckSizeOnly/3 2025/01/16 02:05:27 INFO : potato2.rclone_chunk.001_5y1yos: Moved (server-side) to: potato2.rclone_chunk.001 2025/01/16 02:05:28 INFO : potato2.rclone_chunk.002_5y1yos: Moved (server-side) to: potato2.rclone_chunk.002 === RUN TestCheckSizeOnly/4 === RUN TestCheckSizeOnly/5 2025/01/16 02:05:40 INFO : remotepotato.rclone_chunk.001_5y2bkf: Moved (server-side) to: remotepotato.rclone_chunk.001 2025/01/16 02:05:42 INFO : remotepotato.rclone_chunk.002_5y2bkf: Moved (server-side) to: remotepotato.rclone_chunk.002 === RUN TestCheckSizeOnly/6 === RUN TestCheckSizeOnly/7 --- PASS: TestCheckSizeOnly (75.57s) --- PASS: TestCheckSizeOnly/1 (0.24s) --- PASS: TestCheckSizeOnly/2 (0.32s) --- PASS: TestCheckSizeOnly/3 (0.42s) --- PASS: TestCheckSizeOnly/4 (0.32s) --- PASS: TestCheckSizeOnly/5 (0.74s) --- PASS: TestCheckSizeOnly/6 (0.65s) --- PASS: TestCheckSizeOnly/7 (0.48s) === RUN TestCopyFileBackupDir run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-cadawag1padu'", Local "Local file system at /tmp/rclone411005969", Modify Window "1ns" 2025/01/16 02:06:27 INFO : dst/file1.rclone_chunk.001_5y3njl: Moved (server-side) to: dst/file1 2025/01/16 02:06:29 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-cadawag1padu/backup" 2025/01/16 02:06:29 DEBUG : Creating backend with remote "TestYandex:rclone-test-cadawag1padu/backup" 2025/01/16 02:06:29 DEBUG : Reset feature "ListR" 2025/01/16 02:06:29 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18) 2025/01/16 02:06:29 DEBUG : dst/file1: move non-chunked object... 2025/01/16 02:06:31 INFO : dst/file1: Moved (server-side) 2025/01/16 02:06:31 INFO : dst/file1: Moved (server-side) 2025/01/16 02:06:32 DEBUG : dst/file1: skip slow MD5 on source file, hashing in-transit 2025/01/16 02:06:38 INFO : dst/file1.rclone_chunk.001_5y3yqm: Moved (server-side) to: dst/file1 2025/01/16 02:06:38 DEBUG : dst/file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2025/01/16 02:06:38 INFO : dst/file1: Copied (new) --- PASS: TestCopyFileBackupDir (42.23s) === RUN TestCopyFileCompareDest run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-cadawag1padu'", Local "Local file system at /tmp/rclone411005969", Modify Window "1ns" 2025/01/16 02:07:03 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-cadawag1padu/dst" 2025/01/16 02:07:03 DEBUG : Creating backend with remote "TestYandex:rclone-test-cadawag1padu/dst" 2025/01/16 02:07:04 DEBUG : Reset feature "ListR" 2025/01/16 02:07:04 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-cadawag1padu/CompareDest" 2025/01/16 02:07:04 DEBUG : Creating backend with remote "TestYandex:rclone-test-cadawag1padu/CompareDest" 2025/01/16 02:07:05 DEBUG : Reset feature "ListR" 2025/01/16 02:07:05 DEBUG : one: Need to transfer - File not found at Destination 2025/01/16 02:07:06 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/01/16 02:07:11 INFO : one.rclone_chunk.001_5y4w2d: Moved (server-side) to: one 2025/01/16 02:07:11 DEBUG : one: md5 = f97c5d29941bfb1b2fdab0874906ab82 OK 2025/01/16 02:07:11 INFO : one: Copied (new) 2025/01/16 02:07:13 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/01/16 02:07:13 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/01/16 02:07:21 INFO : one: Deleted 2025/01/16 02:07:25 INFO : one.rclone_chunk.001_5y53u2: Moved (server-side) to: one 2025/01/16 02:07:25 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK 2025/01/16 02:07:25 INFO : one: Copied (replaced existing) 2025/01/16 02:07:35 INFO : dst/one: Deleted 2025/01/16 02:07:39 INFO : dst/one.rclone_chunk.001_5y5gmn: Moved (server-side) to: dst/one 2025/01/16 02:07:45 INFO : CompareDest/one.rclone_chunk.001_5y5ua4: Moved (server-side) to: CompareDest/one 2025/01/16 02:07:48 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/01/16 02:07:49 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/16 02:07:49 DEBUG : one: Destination found in --compare-dest, skipping 2025/01/16 02:07:56 INFO : CompareDest/two.rclone_chunk.001_5y64m6: Moved (server-side) to: CompareDest/two 2025/01/16 02:07:58 DEBUG : two: Need to transfer - File not found at Destination 2025/01/16 02:07:58 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/16 02:07:58 DEBUG : two: Destination found in --compare-dest, skipping 2025/01/16 02:08:00 DEBUG : two: Need to transfer - File not found at Destination 2025/01/16 02:08:00 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/01/16 02:08:00 DEBUG : two: Destination found in --compare-dest, skipping 2025/01/16 02:08:02 DEBUG : two: Need to transfer - File not found at Destination 2025/01/16 02:08:03 DEBUG : two: Sizes differ (src 5 vs dst 3) 2025/01/16 02:08:04 DEBUG : two: skip slow MD5 on source file, hashing in-transit 2025/01/16 02:08:08 INFO : two.rclone_chunk.001_5y6ix1: Moved (server-side) to: two 2025/01/16 02:08:08 DEBUG : two: md5 = 2379e4ce8c3380e996ab0509f17069ad OK 2025/01/16 02:08:08 INFO : two: Copied (new) --- PASS: TestCopyFileCompareDest (95.69s) === RUN TestCat run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-cadawag1padu'", Local "Local file system at /tmp/rclone411005969", Modify Window "1ns" 2025/01/16 02:08:45 INFO : file1.rclone_chunk.001_5y7hky: Moved (server-side) to: file1 2025/01/16 02:08:52 INFO : file2.rclone_chunk.001_5y7ory: Moved (server-side) to: file2 2025/01/16 02:08:57 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2025/01/16 02:08:57 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/01/16 02:08:57 DEBUG : pacer: Reducing sleep to 15ms 2025/01/16 02:08:58 DEBUG : pacer: Reducing sleep to 11.25ms 2025/01/16 02:08:58 DEBUG : pacer: Reducing sleep to 10ms --- PASS: TestCat (29.29s) === RUN TestRcat === RUN TestRcat/withChecksum=false,ignoreChecksum=false run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-cadawag1padu'", Local "Local file system at /tmp/rclone411005969", Modify Window "1ns" operations_test.go:1495: Adjust StreamingUploadCutoff to size limit 1Ki (was 100Ki) 2025/01/16 02:09:09 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-cadawag1padu': File to upload is small (34 bytes), uploading instead of streaming 2025/01/16 02:09:16 INFO : no_checksum_small_file_from_pipe.rclone_chunk.001_5y8bwz: Moved (server-side) to: no_checksum_small_file_from_pipe 2025/01/16 02:09:16 DEBUG : no_checksum_small_file_from_pipe: md5 = 4c762bc6ec18f21b23fcae426c7863b5 OK 2025/01/16 02:09:16 DEBUG : no_checksum_small_file_from_pipe: Size and md5 of src and dst objects identical 2025/01/16 02:10:16 INFO : no_checksum_big_file_from_pipe.rclone_chunk.001_5y8i1y: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.001 2025/01/16 02:10:18 INFO : no_checksum_big_file_from_pipe.rclone_chunk.002_5y8i1y: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.002 2025/01/16 02:10:20 INFO : no_checksum_big_file_from_pipe.rclone_chunk.003_5y8i1y: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.003 2025/01/16 02:10:22 INFO : no_checksum_big_file_from_pipe.rclone_chunk.004_5y8i1y: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.004 2025/01/16 02:10:24 INFO : no_checksum_big_file_from_pipe.rclone_chunk.005_5y8i1y: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.005 2025/01/16 02:10:26 INFO : no_checksum_big_file_from_pipe.rclone_chunk.006_5y8i1y: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.006 2025/01/16 02:10:27 INFO : no_checksum_big_file_from_pipe.rclone_chunk.007_5y8i1y: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.007 2025/01/16 02:10:29 INFO : no_checksum_big_file_from_pipe.rclone_chunk.008_5y8i1y: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.008 2025/01/16 02:10:31 INFO : no_checksum_big_file_from_pipe.rclone_chunk.009_5y8i1y: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.009 2025/01/16 02:10:32 INFO : no_checksum_big_file_from_pipe.rclone_chunk.010_5y8i1y: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.010 2025/01/16 02:10:35 INFO : no_checksum_big_file_from_pipe.rclone_chunk.011_5y8i1y: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.011 2025/01/16 02:10:37 INFO : no_checksum_big_file_from_pipe.rclone_chunk.012_5y8i1y: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.012 2025/01/16 02:10:38 INFO : no_checksum_big_file_from_pipe.rclone_chunk.013_5y8i1y: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.013 2025/01/16 02:10:39 INFO : no_checksum_big_file_from_pipe.rclone_chunk.014_5y8i1y: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.014 2025/01/16 02:10:41 INFO : no_checksum_big_file_from_pipe.rclone_chunk.015_5y8i1y: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.015 2025/01/16 02:10:43 INFO : no_checksum_big_file_from_pipe.rclone_chunk.016_5y8i1y: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.016 2025/01/16 02:10:45 INFO : no_checksum_big_file_from_pipe.rclone_chunk.017_5y8i1y: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.017 2025/01/16 02:10:47 INFO : no_checksum_big_file_from_pipe.rclone_chunk.018_5y8i1y: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.018 2025/01/16 02:10:48 INFO : no_checksum_big_file_from_pipe.rclone_chunk.019_5y8i1y: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.019 2025/01/16 02:10:50 INFO : no_checksum_big_file_from_pipe.rclone_chunk.020_5y8i1y: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.020 2025/01/16 02:10:52 INFO : no_checksum_big_file_from_pipe.rclone_chunk.021_5y8i1y: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.021 2025/01/16 02:10:55 DEBUG : no_checksum_big_file_from_pipe: md5 = 0ad4cf7b35f62b8ff9c73f481594fbdd OK 2025/01/16 02:10:55 DEBUG : no_checksum_big_file_from_pipe: Size and md5 of src and dst objects identical --- PASS: TestRcat (199.01s) --- PASS: TestRcat/withChecksum=false,ignoreChecksum=false (199.01s) PASS 2025/01/16 02:12:27 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-cadawag1padu': Purge remote "./operations.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -fast-list -size-limit 1024 -test.run '^(TestCat|TestCheckSizeOnly|TestCopyFileBackupDir|TestCopyFileCompareDest)$|^TestRcat$/^withChecksum=false,ignoreChecksum=false$'" - Finished OK in 7m25.803921338s (try 2/5)