"./operations.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024" - Starting (try 1/5) 2021/07/25 05:50:57 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9" 2021/07/25 05:50:57 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2021/07/25 05:50:57 DEBUG : Creating backend with remote "TestYandex:rclone-test-qinopic4wucesob7vihedot9" 2021/07/25 05:50:58 DEBUG : Reset feature "ListR" 2021/07/25 05:50:58 DEBUG : Creating backend with remote "/tmp/rclone782149231" === RUN TestDoMultiThreadCopy --- PASS: TestDoMultiThreadCopy (0.00s) === RUN TestMultithreadCalculateChunks === RUN TestMultithreadCalculateChunks/{size:1_streams:10_wantPartSize:65536_wantStreams:1} === RUN TestMultithreadCalculateChunks/{size:1048576_streams:1_wantPartSize:1048576_wantStreams:1} === RUN TestMultithreadCalculateChunks/{size:1048576_streams:2_wantPartSize:524288_wantStreams:2} === RUN TestMultithreadCalculateChunks/{size:1048577_streams:2_wantPartSize:589824_wantStreams:2} === RUN TestMultithreadCalculateChunks/{size:1048575_streams:2_wantPartSize:524288_wantStreams:2} --- PASS: TestMultithreadCalculateChunks (0.00s) --- PASS: TestMultithreadCalculateChunks/{size:1_streams:10_wantPartSize:65536_wantStreams:1} (0.00s) --- PASS: TestMultithreadCalculateChunks/{size:1048576_streams:1_wantPartSize:1048576_wantStreams:1} (0.00s) --- PASS: TestMultithreadCalculateChunks/{size:1048576_streams:2_wantPartSize:524288_wantStreams:2} (0.00s) --- PASS: TestMultithreadCalculateChunks/{size:1048577_streams:2_wantPartSize:589824_wantStreams:2} (0.00s) --- PASS: TestMultithreadCalculateChunks/{size:1048575_streams:2_wantPartSize:524288_wantStreams:2} (0.00s) === RUN TestMultithreadCopy run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" === RUN TestMultithreadCopy/{size:131071_streams:2} multithread_test.go:122: exceeded file size limit 131071 > 1024 === RUN TestMultithreadCopy/{size:131072_streams:2} multithread_test.go:122: exceeded file size limit 131072 > 1024 === RUN TestMultithreadCopy/{size:131073_streams:2} multithread_test.go:122: exceeded file size limit 131073 > 1024 2021/07/25 05:50:58 ERROR : : error listing: directory not found --- PASS: TestMultithreadCopy (0.18s) --- SKIP: TestMultithreadCopy/{size:131071_streams:2} (0.00s) --- SKIP: TestMultithreadCopy/{size:131072_streams:2} (0.00s) --- SKIP: TestMultithreadCopy/{size:131073_streams:2} (0.00s) === RUN TestSizeDiffers --- PASS: TestSizeDiffers (0.00s) === RUN TestReOpen === RUN TestReOpen/Seek === RUN TestReOpen/Seek/Basics === RUN TestReOpen/Seek/ErrorAtStart === RUN TestReOpen/Seek/WithErrors 2021/07/25 05:50:58 DEBUG : potato: Reopening on read failure after 2 bytes: retry 1/10: test error 2021/07/25 05:50:58 DEBUG : potato: Reopening on read failure after 3 bytes: retry 2/10: test error 2021/07/25 05:50:58 DEBUG : potato: Reopening on read failure after 6 bytes: retry 3/10: test error === RUN TestReOpen/Seek/TooManyErrors 2021/07/25 05:50:58 DEBUG : potato: Reopening on read failure after 2 bytes: retry 1/3: test error 2021/07/25 05:50:58 DEBUG : potato: Reopening on read failure after 3 bytes: retry 2/3: test error 2021/07/25 05:50:58 DEBUG : potato: Reopening on read failure after 6 bytes: retry 3/3: test error 2021/07/25 05:50:58 DEBUG : potato: Reopen failed after 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/Range === RUN TestReOpen/Range/Basics === RUN TestReOpen/Range/ErrorAtStart === RUN TestReOpen/Range/WithErrors 2021/07/25 05:50:58 DEBUG : potato: Reopening on read failure after 2 bytes: retry 1/10: test error 2021/07/25 05:50:58 DEBUG : potato: Reopening on read failure after 3 bytes: retry 2/10: test error 2021/07/25 05:50:58 DEBUG : potato: Reopening on read failure after 6 bytes: retry 3/10: test error === RUN TestReOpen/Range/TooManyErrors 2021/07/25 05:50:58 DEBUG : potato: Reopening on read failure after 2 bytes: retry 1/3: test error 2021/07/25 05:50:58 DEBUG : potato: Reopening on read failure after 3 bytes: retry 2/3: test error 2021/07/25 05:50:58 DEBUG : potato: Reopening on read failure after 6 bytes: retry 3/3: test error 2021/07/25 05:50:58 DEBUG : potato: Reopen failed after 6 bytes read: failed to reopen: too many retries --- PASS: TestReOpen (0.00s) --- PASS: TestReOpen/Seek (0.00s) --- PASS: TestReOpen/Seek/Basics (0.00s) --- PASS: TestReOpen/Seek/ErrorAtStart (0.00s) --- PASS: TestReOpen/Seek/WithErrors (0.00s) --- PASS: TestReOpen/Seek/TooManyErrors (0.00s) --- PASS: TestReOpen/Range (0.00s) --- PASS: TestReOpen/Range/Basics (0.00s) --- PASS: TestReOpen/Range/ErrorAtStart (0.00s) --- PASS: TestReOpen/Range/WithErrors (0.00s) --- PASS: TestReOpen/Range/TooManyErrors (0.00s) === RUN TestCheck run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 05:51:07 INFO : rutabaga.rclone_chunk.001_sit7cf: Moved (server-side) to: rutabaga === RUN TestCheck/1 === RUN TestCheck/2 2021/07/25 05:51:12 INFO : empty space.rclone_chunk.001_sitfho: Moved (server-side) to: empty space === RUN TestCheck/3 2021/07/25 05:51:22 INFO : potato2.rclone_chunk.001_sitkse: Moved (server-side) to: potato2.rclone_chunk.001 2021/07/25 05:51:24 INFO : potato2.rclone_chunk.002_sitkse: Moved (server-side) to: potato2.rclone_chunk.002 === RUN TestCheck/4 === RUN TestCheck/5 2021/07/25 05:51:37 INFO : remotepotato.rclone_chunk.001_siu150: Moved (server-side) to: remotepotato.rclone_chunk.001 2021/07/25 05:51:38 INFO : remotepotato.rclone_chunk.002_siu150: Moved (server-side) to: remotepotato.rclone_chunk.002 === RUN TestCheck/6 === RUN TestCheck/7 --- PASS: TestCheck (53.69s) --- PASS: TestCheck/1 (0.28s) --- PASS: TestCheck/2 (0.22s) --- PASS: TestCheck/3 (0.24s) --- PASS: TestCheck/4 (0.76s) --- PASS: TestCheck/5 (0.56s) --- PASS: TestCheck/6 (3.89s) --- PASS: TestCheck/7 (0.60s) === RUN TestCheckFsError 2021/07/25 05:51:51 DEBUG : Creating backend with remote "non-existent" 2021/07/25 05:51:51 DEBUG : Creating backend with remote "non-existent" 2021/07/25 05:51:51 DEBUG : Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/non-existent: Waiting for checks to finish 2021/07/25 05:51:51 ERROR : Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/non-existent: error reading source root directory: directory not found 2021/07/25 05:51:51 NOTICE: Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/non-existent: 2 differences found 2021/07/25 05:51:51 NOTICE: Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/non-existent: 2 errors while checking --- PASS: TestCheckFsError (0.00s) === RUN TestCheckDownload run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 05:51:55 INFO : rutabaga.rclone_chunk.001_siuofy: Moved (server-side) to: rutabaga === RUN TestCheckDownload/1 === RUN TestCheckDownload/2 2021/07/25 05:52:04 INFO : empty space.rclone_chunk.001_siutt5: Moved (server-side) to: empty space === RUN TestCheckDownload/3 2021/07/25 05:52:11 INFO : potato2.rclone_chunk.001_siv1bh: Moved (server-side) to: potato2.rclone_chunk.001 2021/07/25 05:52:12 INFO : potato2.rclone_chunk.002_siv1bh: Moved (server-side) to: potato2.rclone_chunk.002 === RUN TestCheckDownload/4 === RUN TestCheckDownload/5 2021/07/25 05:52:26 INFO : remotepotato.rclone_chunk.001_sivfko: Moved (server-side) to: remotepotato.rclone_chunk.001 2021/07/25 05:52:27 INFO : remotepotato.rclone_chunk.002_sivfko: Moved (server-side) to: remotepotato.rclone_chunk.002 === RUN TestCheckDownload/6 === RUN TestCheckDownload/7 --- PASS: TestCheckDownload (55.11s) --- PASS: TestCheckDownload/1 (0.91s) --- PASS: TestCheckDownload/2 (0.55s) --- PASS: TestCheckDownload/3 (0.67s) --- PASS: TestCheckDownload/4 (2.13s) --- PASS: TestCheckDownload/5 (1.56s) --- PASS: TestCheckDownload/6 (1.62s) --- PASS: TestCheckDownload/7 (1.52s) === RUN TestCheckSizeOnly run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 05:52:51 INFO : rutabaga.rclone_chunk.001_siw7zt: Moved (server-side) to: rutabaga === RUN TestCheckSizeOnly/1 === RUN TestCheckSizeOnly/2 2021/07/25 05:52:57 INFO : empty space.rclone_chunk.001_siwcx6: Moved (server-side) to: empty space === RUN TestCheckSizeOnly/3 2021/07/25 05:53:04 INFO : potato2.rclone_chunk.001_siwi3n: Moved (server-side) to: potato2.rclone_chunk.001 2021/07/25 05:53:06 INFO : potato2.rclone_chunk.002_siwi3n: Moved (server-side) to: potato2.rclone_chunk.002 === RUN TestCheckSizeOnly/4 === RUN TestCheckSizeOnly/5 2021/07/25 05:53:17 INFO : remotepotato.rclone_chunk.001_siwuvi: Moved (server-side) to: remotepotato.rclone_chunk.001 2021/07/25 05:53:18 INFO : remotepotato.rclone_chunk.002_siwuvi: Moved (server-side) to: remotepotato.rclone_chunk.002 === RUN TestCheckSizeOnly/6 === RUN TestCheckSizeOnly/7 --- PASS: TestCheckSizeOnly (54.67s) --- PASS: TestCheckSizeOnly/1 (0.20s) --- PASS: TestCheckSizeOnly/2 (0.20s) --- PASS: TestCheckSizeOnly/3 (0.20s) --- PASS: TestCheckSizeOnly/4 (0.22s) --- PASS: TestCheckSizeOnly/5 (0.21s) --- PASS: TestCheckSizeOnly/6 (0.23s) --- PASS: TestCheckSizeOnly/7 (0.21s) === RUN TestCheckEqualReaders --- PASS: TestCheckEqualReaders (0.00s) === RUN TestParseSumFile run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 05:53:49 INFO : test.sum.rclone_chunk.001_sixpi1: Moved (server-side) to: test.sum.rclone_chunk.001 2021/07/25 05:53:49 INFO : test.sum.rclone_chunk.002_sixpi1: Moved (server-side) to: test.sum.rclone_chunk.002 2021/07/25 05:53:54 NOTICE: test.sum: improperly formatted checksum line 4 2021/07/25 05:53:55 NOTICE: test.sum: improperly formatted checksum line 5 2021/07/25 05:53:55 NOTICE: test.sum: improperly formatted checksum line 6 2021/07/25 05:53:55 NOTICE: test.sum: more warnings suppressed... 2021/07/25 05:54:06 INFO : test.sum.rclone_chunk.001_siy4uh: Moved (server-side) to: test.sum.rclone_chunk.001 2021/07/25 05:54:06 INFO : test.sum.rclone_chunk.002_siy4uh: Moved (server-side) to: test.sum.rclone_chunk.002 2021/07/25 05:54:12 NOTICE: test.sum: improperly formatted checksum line 4 2021/07/25 05:54:12 NOTICE: test.sum: improperly formatted checksum line 5 2021/07/25 05:54:12 NOTICE: test.sum: improperly formatted checksum line 6 2021/07/25 05:54:12 NOTICE: test.sum: more warnings suppressed... --- PASS: TestParseSumFile (35.17s) === RUN TestCheckSum run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 05:54:16 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9/data" 2021/07/25 05:54:16 DEBUG : Creating backend with remote "TestYandex:rclone-test-qinopic4wucesob7vihedot9/data" 2021/07/25 05:54:17 DEBUG : Reset feature "ListR" 2021/07/25 05:54:22 INFO : data/banana.rclone_chunk.001_siypis: Moved (server-side) to: data/banana 2021/07/25 05:54:31 INFO : test.sum.rclone_chunk.001_siyuu0: Moved (server-side) to: test.sum === RUN TestCheckSum/move1 2021/07/25 05:54:39 INFO : data/potato.rclone_chunk.001_siz6vj: Moved (server-side) to: data/potato 2021/07/25 05:54:49 INFO : test.sum: Deleted 2021/07/25 05:54:51 INFO : test.sum.rclone_chunk.001_sizcvc: Moved (server-side) to: test.sum === RUN TestCheckSum/move2 2021/07/25 05:55:00 INFO : test.sum.rclone_chunk.001_sizphe: Moved (server-side) to: test.sum.rclone_chunk.001 2021/07/25 05:55:01 INFO : test.sum.rclone_chunk.002_sizphe: Moved (server-side) to: test.sum.rclone_chunk.002 === RUN TestCheckSum/move3 2021/07/25 05:55:20 INFO : test.sum.rclone_chunk.001_sj04ol: Moved (server-side) to: test.sum.rclone_chunk.001 2021/07/25 05:55:21 INFO : test.sum.rclone_chunk.002_sj04ol: Moved (server-side) to: test.sum.rclone_chunk.002 === RUN TestCheckSum/move4 2021/07/25 05:55:40 INFO : test.sum.rclone_chunk.001_sj0o7z: Moved (server-side) to: test.sum.rclone_chunk.001 2021/07/25 05:55:42 INFO : test.sum.rclone_chunk.002_sj0o7z: Moved (server-side) to: test.sum.rclone_chunk.002 2021/07/25 05:55:43 INFO : test.sum.rclone_chunk.003_sj0o7z: Moved (server-side) to: test.sum.rclone_chunk.003 === RUN TestCheckSum/move5 2021/07/25 05:56:02 INFO : test.sum.rclone_chunk.001_sj1cgh: Moved (server-side) to: test.sum.rclone_chunk.001 2021/07/25 05:56:04 INFO : test.sum.rclone_chunk.002_sj1cgh: Moved (server-side) to: test.sum.rclone_chunk.002 2021/07/25 05:56:05 INFO : test.sum.rclone_chunk.003_sj1cgh: Moved (server-side) to: test.sum.rclone_chunk.003 === RUN TestCheckSum/move6 --- PASS: TestCheckSum (124.50s) --- PASS: TestCheckSum/move1 (1.27s) --- PASS: TestCheckSum/move2 (0.98s) --- PASS: TestCheckSum/move3 (2.09s) --- PASS: TestCheckSum/move4 (2.00s) --- PASS: TestCheckSum/move5 (2.89s) --- PASS: TestCheckSum/move6 (2.92s) === RUN TestCheckSumDownload run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 05:56:21 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9/data" 2021/07/25 05:56:21 DEBUG : Creating backend with remote "TestYandex:rclone-test-qinopic4wucesob7vihedot9/data" 2021/07/25 05:56:21 DEBUG : Reset feature "ListR" 2021/07/25 05:56:27 INFO : data/banana.rclone_chunk.001_sj264c: Moved (server-side) to: data/banana 2021/07/25 05:56:31 INFO : test.sum.rclone_chunk.001_sj2bee: Moved (server-side) to: test.sum === RUN TestCheckSumDownload/move1 2021/07/25 05:56:38 INFO : data/potato.rclone_chunk.001_sj2i1u: Moved (server-side) to: data/potato 2021/07/25 05:56:43 INFO : test.sum: Deleted 2021/07/25 05:56:44 INFO : test.sum.rclone_chunk.001_sj2nmd: Moved (server-side) to: test.sum === RUN TestCheckSumDownload/move2 2021/07/25 05:56:54 INFO : test.sum.rclone_chunk.001_sj2upi: Moved (server-side) to: test.sum.rclone_chunk.001 2021/07/25 05:56:56 INFO : test.sum.rclone_chunk.002_sj2upi: Moved (server-side) to: test.sum.rclone_chunk.002 === RUN TestCheckSumDownload/move3 2021/07/25 05:57:13 INFO : test.sum.rclone_chunk.001_sj3b9g: Moved (server-side) to: test.sum.rclone_chunk.001 2021/07/25 05:57:14 INFO : test.sum.rclone_chunk.002_sj3b9g: Moved (server-side) to: test.sum.rclone_chunk.002 === RUN TestCheckSumDownload/move4 2021/07/25 05:57:34 INFO : test.sum.rclone_chunk.001_sj3u9e: Moved (server-side) to: test.sum.rclone_chunk.001 2021/07/25 05:57:35 INFO : test.sum.rclone_chunk.002_sj3u9e: Moved (server-side) to: test.sum.rclone_chunk.002 2021/07/25 05:57:37 INFO : test.sum.rclone_chunk.003_sj3u9e: Moved (server-side) to: test.sum.rclone_chunk.003 === RUN TestCheckSumDownload/move5 2021/07/25 05:58:03 INFO : test.sum.rclone_chunk.001_sj4jzh: Moved (server-side) to: test.sum.rclone_chunk.001 2021/07/25 05:58:04 INFO : test.sum.rclone_chunk.002_sj4jzh: Moved (server-side) to: test.sum.rclone_chunk.002 2021/07/25 05:58:06 INFO : test.sum.rclone_chunk.003_sj4jzh: Moved (server-side) to: test.sum.rclone_chunk.003 === RUN TestCheckSumDownload/move6 --- PASS: TestCheckSumDownload (122.51s) --- PASS: TestCheckSumDownload/move1 (2.13s) --- PASS: TestCheckSumDownload/move2 (1.26s) --- PASS: TestCheckSumDownload/move3 (2.96s) --- PASS: TestCheckSumDownload/move4 (3.11s) --- PASS: TestCheckSumDownload/move5 (5.21s) --- PASS: TestCheckSumDownload/move6 (3.65s) === RUN TestDeduplicateInteractive run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateInteractive (0.49s) === RUN TestDeduplicateSkip run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateSkip (0.77s) === RUN TestDeduplicateSizeOnly run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateSizeOnly (0.43s) === RUN TestDeduplicateFirst run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateFirst (0.53s) === RUN TestDeduplicateNewest run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateNewest (0.39s) === RUN TestDeduplicateNewestByHash run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 05:58:33 INFO : one.rclone_chunk.001_sj5mx8: Moved (server-side) to: one.rclone_chunk.001 2021/07/25 05:58:35 INFO : one.rclone_chunk.002_sj5mx8: Moved (server-side) to: one.rclone_chunk.002 2021/07/25 05:58:37 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2021/07/25 05:58:37 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2021/07/25 05:58:40 DEBUG : pacer: Reducing sleep to 15ms 2021/07/25 05:58:41 DEBUG : pacer: Reducing sleep to 11.25ms 2021/07/25 05:58:41 DEBUG : pacer: Reducing sleep to 10ms 2021/07/25 05:58:50 INFO : also/one.rclone_chunk.001_sj61x7: Moved (server-side) to: also/one.rclone_chunk.001 2021/07/25 05:58:52 INFO : also/one.rclone_chunk.002_sj61x7: Moved (server-side) to: also/one.rclone_chunk.002 2021/07/25 05:59:03 INFO : another.rclone_chunk.001_sj6gyd: Moved (server-side) to: another.rclone_chunk.001 2021/07/25 05:59:08 INFO : another.rclone_chunk.002_sj6gyd: Moved (server-side) to: another.rclone_chunk.002 2021/07/25 05:59:14 INFO : not-one.rclone_chunk.001_sj6ugd: Moved (server-side) to: not-one 2021/07/25 05:59:16 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9': Looking for duplicate md5 hashes using newest mode. 2021/07/25 05:59:18 NOTICE: 6e7ce64d2dd8b12b425ef5434d5e63c6: Found 3 files with duplicate md5 hashes 2021/07/25 05:59:22 INFO : one: Deleted 2021/07/25 05:59:24 INFO : also/one: Deleted 2021/07/25 05:59:24 NOTICE: 6e7ce64d2dd8b12b425ef5434d5e63c6: Deleted 2 extra copies --- PASS: TestDeduplicateNewestByHash (65.00s) === RUN TestDeduplicateOldest run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateOldest (0.47s) === RUN TestDeduplicateLargest run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateLargest (0.42s) === RUN TestDeduplicateSmallest run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateSmallest (0.45s) === RUN TestDeduplicateRename run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateRename (0.41s) === RUN TestMergeDirs run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" dedupe_test.go:267: Can't merge directories --- SKIP: TestMergeDirs (0.53s) === RUN TestListDirSorted run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 05:59:38 INFO : a.txt.rclone_chunk.001_sj7ie1: Moved (server-side) to: a.txt 2021/07/25 05:59:42 INFO : zend.txt.rclone_chunk.001_sj7mq7: Moved (server-side) to: zend.txt 2021/07/25 05:59:50 INFO : sub dir/hello world.rclone_chunk.001_sj7qmf: Moved (server-side) to: sub dir/hello world 2021/07/25 05:59:57 INFO : sub dir/hello world2.rclone_chunk.001_sj7zqm: Moved (server-side) to: sub dir/hello world2 2021/07/25 06:00:02 INFO : sub dir/ignore dir/.ignore.rclone_chunk.001_sj852c: Moved (server-side) to: sub dir/ignore dir/.ignore 2021/07/25 06:00:07 INFO : sub dir/ignore dir/should be ignored.rclone_chunk.001_sj8a3o: Moved (server-side) to: sub dir/ignore dir/should be ignored 2021/07/25 06:00:13 INFO : sub dir/sub sub dir/hello world3.rclone_chunk.001_sj8fvu: Moved (server-side) to: sub dir/sub sub dir/hello world3 2021/07/25 06:00:14 DEBUG : a.txt: Excluded 2021/07/25 06:00:15 DEBUG : sub dir/hello world: Excluded 2021/07/25 06:00:15 DEBUG : sub dir/hello world2: Excluded 2021/07/25 06:00:15 DEBUG : sub dir/hello world: Excluded 2021/07/25 06:00:15 DEBUG : sub dir/hello world2: Excluded 2021/07/25 06:00:16 DEBUG : sub dir/ignore dir: Excluded 2021/07/25 06:00:16 DEBUG : sub dir/ignore dir: Excluded --- PASS: TestListDirSorted (57.94s) === RUN TestMkdir run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:00:31 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9': Making directory 2021/07/25 06:00:32 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9': Making directory --- PASS: TestMkdir (1.22s) === RUN TestLsd run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:00:38 INFO : sub dir/hello world.rclone_chunk.001_sj95nj: Moved (server-side) to: sub dir/hello world --- PASS: TestLsd (9.10s) === RUN TestLs run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:00:53 INFO : potato2.rclone_chunk.001_sj9eby: Moved (server-side) to: potato2.rclone_chunk.001 2021/07/25 06:00:54 INFO : potato2.rclone_chunk.002_sj9eby: Moved (server-side) to: potato2.rclone_chunk.002 2021/07/25 06:01:00 INFO : empty space.rclone_chunk.001_sj9t1k: Moved (server-side) to: empty space --- PASS: TestLs (23.21s) === RUN TestLsWithFilesFrom run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:01:14 INFO : potato2.rclone_chunk.001_sja16d: Moved (server-side) to: potato2.rclone_chunk.001 2021/07/25 06:01:15 INFO : potato2.rclone_chunk.002_sja16d: Moved (server-side) to: potato2.rclone_chunk.002 2021/07/25 06:01:23 INFO : empty space.rclone_chunk.001_sjaekc: Moved (server-side) to: empty space 2021/07/25 06:01:24 DEBUG : empty space: Excluded --- PASS: TestLsWithFilesFrom (26.08s) === RUN TestLsLong run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:01:39 INFO : potato2.rclone_chunk.001_sjarvi: Moved (server-side) to: potato2.rclone_chunk.001 2021/07/25 06:01:41 INFO : potato2.rclone_chunk.002_sjarvi: Moved (server-side) to: potato2.rclone_chunk.002 2021/07/25 06:01:48 INFO : empty space.rclone_chunk.001_sjb3zi: Moved (server-side) to: empty space --- PASS: TestLsLong (24.37s) === RUN TestHashSums run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:02:01 INFO : potato2.rclone_chunk.001_sjbfbq: Moved (server-side) to: potato2.rclone_chunk.001 2021/07/25 06:02:03 INFO : potato2.rclone_chunk.002_sjbfbq: Moved (server-side) to: potato2.rclone_chunk.002 2021/07/25 06:02:10 INFO : empty space.rclone_chunk.001_sjbq5l: Moved (server-side) to: empty space 2021/07/25 06:02:16 ERROR : empty space: Hash unsupported: hash type not supported 2021/07/25 06:02:16 ERROR : potato2: Hash unsupported: hash type not supported 2021/07/25 06:02:18 ERROR : empty space: Hash unsupported: hash type not supported 2021/07/25 06:02:18 ERROR : potato2: Hash unsupported: hash type not supported --- PASS: TestHashSums (30.43s) === RUN TestSuffixName --- PASS: TestSuffixName (0.00s) === RUN TestCount run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:02:32 INFO : potato2.rclone_chunk.001_sjca07: Moved (server-side) to: potato2.rclone_chunk.001 2021/07/25 06:02:34 INFO : potato2.rclone_chunk.002_sjca07: Moved (server-side) to: potato2.rclone_chunk.002 2021/07/25 06:02:42 INFO : empty space.rclone_chunk.001_sjckys: Moved (server-side) to: empty space 2021/07/25 06:02:47 INFO : sub dir/potato3.rclone_chunk.001_sjcrwd: Moved (server-side) to: sub dir/potato3 --- PASS: TestCount (30.75s) === RUN TestDelete run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:03:01 INFO : small.rclone_chunk.001_sjd5hb: Moved (server-side) to: small 2021/07/25 06:03:08 INFO : medium.rclone_chunk.001_sjd930: Moved (server-side) to: medium.rclone_chunk.001 2021/07/25 06:03:10 INFO : medium.rclone_chunk.002_sjd930: Moved (server-side) to: medium.rclone_chunk.002 2021/07/25 06:03:18 INFO : large.rclone_chunk.001_sjdki5: Moved (server-side) to: large.rclone_chunk.001 2021/07/25 06:03:19 INFO : large.rclone_chunk.002_sjdki5: Moved (server-side) to: large.rclone_chunk.002 2021/07/25 06:03:22 DEBUG : Waiting for deletions to finish 2021/07/25 06:03:22 DEBUG : large: Excluded 2021/07/25 06:03:23 INFO : small: Deleted 2021/07/25 06:03:27 INFO : medium: Deleted --- PASS: TestDelete (35.83s) === RUN TestRetry 2021/07/25 06:03:32 DEBUG : Received error: EOF - low level retry 1/5 2021/07/25 06:03:32 DEBUG : Received error: EOF - low level retry 2/5 2021/07/25 06:03:32 DEBUG : Received error: EOF - low level retry 1/5 2021/07/25 06:03:32 DEBUG : Received error: EOF - low level retry 2/5 2021/07/25 06:03:32 DEBUG : Received error: EOF - low level retry 3/5 2021/07/25 06:03:32 DEBUG : Received error: EOF - low level retry 4/5 2021/07/25 06:03:32 DEBUG : Received error: EOF - low level retry 5/5 --- PASS: TestRetry (0.00s) === RUN TestCat run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:03:37 INFO : file1.rclone_chunk.001_sje5d9: Moved (server-side) to: file1 2021/07/25 06:03:41 INFO : file2.rclone_chunk.001_sje9th: Moved (server-side) to: file2 --- PASS: TestCat (17.37s) === RUN TestPurge 2021/07/25 06:03:50 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-yibusef0dojixal2zojebes2" 2021/07/25 06:03:50 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2021/07/25 06:03:50 DEBUG : Creating backend with remote "TestYandex:rclone-test-yibusef0dojixal2zojebes2" 2021/07/25 06:03:50 DEBUG : Reset feature "ListR" 2021/07/25 06:03:50 DEBUG : Creating backend with remote "/tmp/rclone034525817" run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-yibusef0dojixal2zojebes2'", Local "Local file system at /tmp/rclone034525817", Modify Window "1ns" 2021/07/25 06:03:58 INFO : A1/B1/C1/one.rclone_chunk.001_sjendy: Moved (server-side) to: A1/B1/C1/one 2021/07/25 06:03:58 DEBUG : A2: Making directory 2021/07/25 06:03:58 DEBUG : A1/B2: Making directory 2021/07/25 06:03:59 DEBUG : A1/B2/C2: Making directory 2021/07/25 06:03:59 DEBUG : A1/B1/C3: Making directory 2021/07/25 06:04:00 DEBUG : A3: Making directory 2021/07/25 06:04:00 DEBUG : A3/B3: Making directory 2021/07/25 06:04:01 DEBUG : A3/B3/C4: Making directory 2021/07/25 06:04:06 INFO : A1/two.rclone_chunk.001_sjey30: Moved (server-side) to: A1/two 2021/07/25 06:04:12 ERROR : : error listing: directory not found 2021/07/25 06:04:12 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-yibusef0dojixal2zojebes2': Purge remote 2021/07/25 06:04:12 purge failed: [404 - DiskNotFoundError] Resource not found. (Не удалось найти запрошенный ресурс.) --- PASS: TestPurge (22.36s) === RUN TestRmdirsNoLeaveRoot run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:04:17 INFO : A1/B1/C1/one.rclone_chunk.001_sjf8g1: Moved (server-side) to: A1/B1/C1/one 2021/07/25 06:04:17 DEBUG : A2: Making directory 2021/07/25 06:04:18 DEBUG : A1/B2: Making directory 2021/07/25 06:04:19 DEBUG : A1/B2/C2: Making directory 2021/07/25 06:04:19 DEBUG : A1/B1/C3: Making directory 2021/07/25 06:04:20 DEBUG : A3: Making directory 2021/07/25 06:04:20 DEBUG : A3/B3: Making directory 2021/07/25 06:04:21 DEBUG : A3/B3/C4: Making directory 2021/07/25 06:04:25 INFO : A1/two.rclone_chunk.001_sjfi8c: Moved (server-side) to: A1/two 2021/07/25 06:04:29 INFO : A3/B3/C4: Removing directory 2021/07/25 06:04:32 INFO : A3/B3: Removing directory 2021/07/25 06:04:33 INFO : A3: Removing directory 2021/07/25 06:04:33 INFO : A2: Removing directory 2021/07/25 06:04:35 INFO : A1/B2/C2: Removing directory 2021/07/25 06:04:35 INFO : A1/B2: Removing directory 2021/07/25 06:04:36 INFO : A1/B1/C3: Removing directory --- PASS: TestRmdirsNoLeaveRoot (33.25s) === RUN TestRmdirsLeaveRoot run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:04:45 DEBUG : A1: Making directory 2021/07/25 06:04:46 DEBUG : A1/B1: Making directory 2021/07/25 06:04:46 DEBUG : A1/B1/C1: Making directory 2021/07/25 06:04:48 INFO : A1/B1/C1: Removing directory 2021/07/25 06:04:49 INFO : A1/B1: Removing directory --- PASS: TestRmdirsLeaveRoot (7.47s) === RUN TestRmdirsWithFilter run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:04:53 DEBUG : A1: Making directory 2021/07/25 06:04:53 DEBUG : A1/B1: Making directory 2021/07/25 06:04:54 DEBUG : A1/B1/C1: Making directory 2021/07/25 06:04:57 INFO : A1/B1/C1: Removing directory 2021/07/25 06:04:57 INFO : A1/B1: Removing directory --- PASS: TestRmdirsWithFilter (7.40s) === RUN TestCopyURL run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:05:04 INFO : file1.rclone_chunk.001_sjgkam: Moved (server-side) to: file1 2021/07/25 06:05:05 DEBUG : filename.txt: File name found in url 2021/07/25 06:05:10 INFO : filename.txt.rclone_chunk.001_sjgp27: Moved (server-side) to: filename.txt 2021/07/25 06:05:15 INFO : file2.rclone_chunk.001_sjguwc: Moved (server-side) to: file2 --- PASS: TestCopyURL (19.83s) === RUN TestCopyURLToWriter --- PASS: TestCopyURLToWriter (0.00s) === RUN TestMoveFile run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:05:20 DEBUG : file1: Need to transfer - File not found at Destination 2021/07/25 06:05:29 INFO : sub/file2.rclone_chunk.001_sjh4ym: Moved (server-side) to: sub/file2 2021/07/25 06:05:29 DEBUG : file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2021/07/25 06:05:29 INFO : file1: Copied (new) to: sub/file2 2021/07/25 06:05:29 INFO : file1: Deleted 2021/07/25 06:05:30 DEBUG : file1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/07/25 06:05:30 DEBUG : file1: Unchanged skipping 2021/07/25 06:05:30 INFO : file1: Deleted 2021/07/25 06:05:31 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9': don't need to copy/move sub/file2, it is already at target location --- PASS: TestMoveFile (15.14s) === RUN TestCaseInsensitiveMoveFile run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" --- PASS: TestCaseInsensitiveMoveFile (0.43s) === RUN TestMoveFileBackupDir run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:05:40 INFO : dst/file1.rclone_chunk.001_sjhkwn: Moved (server-side) to: dst/file1 2021/07/25 06:05:41 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9/backup" 2021/07/25 06:05:41 DEBUG : Creating backend with remote "TestYandex:rclone-test-qinopic4wucesob7vihedot9/backup" 2021/07/25 06:05:42 DEBUG : Reset feature "ListR" 2021/07/25 06:05:42 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18) 2021/07/25 06:05:42 DEBUG : dst/file1: move non-chunked object... 2021/07/25 06:05:44 INFO : dst/file1: Moved (server-side) 2021/07/25 06:05:44 INFO : dst/file1: Moved (server-side) 2021/07/25 06:05:45 DEBUG : dst/file1: skip slow MD5 on source file, hashing in-transit 2021/07/25 06:05:48 INFO : dst/file1.rclone_chunk.001_sjhtqu: Moved (server-side) to: dst/file1 2021/07/25 06:05:48 DEBUG : dst/file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2021/07/25 06:05:48 INFO : dst/file1: Copied (new) 2021/07/25 06:05:48 INFO : dst/file1: Deleted --- PASS: TestMoveFileBackupDir (18.61s) === RUN TestCopyFile run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:05:54 DEBUG : file1: Need to transfer - File not found at Destination 2021/07/25 06:05:59 INFO : sub/file2.rclone_chunk.001_sji2oc: Moved (server-side) to: sub/file2 2021/07/25 06:05:59 DEBUG : file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2021/07/25 06:05:59 INFO : file1: Copied (new) to: sub/file2 2021/07/25 06:06:00 DEBUG : file1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/07/25 06:06:00 DEBUG : file1: Unchanged skipping 2021/07/25 06:06:01 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9': don't need to copy/move sub/file2, it is already at target location --- PASS: TestCopyFile (10.88s) === RUN TestCopyFileBackupDir run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:06:10 INFO : dst/file1.rclone_chunk.001_sjidyd: Moved (server-side) to: dst/file1 2021/07/25 06:06:11 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9/backup" 2021/07/25 06:06:11 DEBUG : Creating backend with remote "TestYandex:rclone-test-qinopic4wucesob7vihedot9/backup" 2021/07/25 06:06:11 DEBUG : Reset feature "ListR" 2021/07/25 06:06:11 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18) 2021/07/25 06:06:12 DEBUG : dst/file1: move non-chunked object... 2021/07/25 06:06:15 INFO : dst/file1: Moved (server-side) 2021/07/25 06:06:15 INFO : dst/file1: Moved (server-side) 2021/07/25 06:06:15 DEBUG : dst/file1: skip slow MD5 on source file, hashing in-transit 2021/07/25 06:06:19 INFO : dst/file1.rclone_chunk.001_sjinaq: Moved (server-side) to: dst/file1 2021/07/25 06:06:19 DEBUG : dst/file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2021/07/25 06:06:19 INFO : dst/file1: Copied (new) --- PASS: TestCopyFileBackupDir (23.24s) === RUN TestCopyFileCompareDest run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:06:28 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9/dst" 2021/07/25 06:06:28 DEBUG : Creating backend with remote "TestYandex:rclone-test-qinopic4wucesob7vihedot9/dst" 2021/07/25 06:06:28 DEBUG : Reset feature "ListR" 2021/07/25 06:06:29 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9/CompareDest" 2021/07/25 06:06:29 DEBUG : Creating backend with remote "TestYandex:rclone-test-qinopic4wucesob7vihedot9/CompareDest" 2021/07/25 06:06:29 DEBUG : Reset feature "ListR" 2021/07/25 06:06:29 DEBUG : one: Need to transfer - File not found at Destination 2021/07/25 06:06:29 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2021/07/25 06:06:34 INFO : one.rclone_chunk.001_sjj12a: Moved (server-side) to: one 2021/07/25 06:06:34 DEBUG : one: md5 = f97c5d29941bfb1b2fdab0874906ab82 OK 2021/07/25 06:06:34 INFO : one: Copied (new) 2021/07/25 06:06:37 DEBUG : one: Sizes differ (src 5 vs dst 3) 2021/07/25 06:06:37 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2021/07/25 06:06:41 INFO : one: Deleted 2021/07/25 06:06:43 INFO : one.rclone_chunk.001_sjj9z6: Moved (server-side) to: one 2021/07/25 06:06:43 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK 2021/07/25 06:06:43 INFO : one: Copied (replaced existing) 2021/07/25 06:06:48 INFO : dst/one: Deleted 2021/07/25 06:06:49 INFO : dst/one.rclone_chunk.001_sjjgt9: Moved (server-side) to: dst/one 2021/07/25 06:06:54 INFO : CompareDest/one.rclone_chunk.001_sjjlgg: Moved (server-side) to: CompareDest/one 2021/07/25 06:06:59 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/07/25 06:06:59 DEBUG : one: Destination found in --compare-dest, skipping 2021/07/25 06:07:04 INFO : CompareDest/two.rclone_chunk.001_sjjvja: Moved (server-side) to: CompareDest/two 2021/07/25 06:07:05 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/07/25 06:07:05 DEBUG : two: Destination found in --compare-dest, skipping 2021/07/25 06:07:06 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/07/25 06:07:06 DEBUG : two: Destination found in --compare-dest, skipping 2021/07/25 06:07:08 DEBUG : two: Sizes differ (src 5 vs dst 3) 2021/07/25 06:07:08 DEBUG : two: Need to transfer - File not found at Destination 2021/07/25 06:07:08 DEBUG : two: skip slow MD5 on source file, hashing in-transit 2021/07/25 06:07:12 INFO : two.rclone_chunk.001_sjk4rp: Moved (server-side) to: two 2021/07/25 06:07:12 DEBUG : two: md5 = 2379e4ce8c3380e996ab0509f17069ad OK 2021/07/25 06:07:12 INFO : two: Copied (new) --- PASS: TestCopyFileCompareDest (54.28s) === RUN TestCopyFileCopyDest run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:07:23 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9/dst" 2021/07/25 06:07:23 DEBUG : Creating backend with remote "TestYandex:rclone-test-qinopic4wucesob7vihedot9/dst" 2021/07/25 06:07:23 DEBUG : Reset feature "ListR" 2021/07/25 06:07:23 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9/CopyDest" 2021/07/25 06:07:23 DEBUG : Creating backend with remote "TestYandex:rclone-test-qinopic4wucesob7vihedot9/CopyDest" 2021/07/25 06:07:23 DEBUG : Reset feature "ListR" 2021/07/25 06:07:23 DEBUG : one: Need to transfer - File not found at Destination 2021/07/25 06:07:23 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2021/07/25 06:07:29 INFO : one.rclone_chunk.001_sjkj1f: Moved (server-side) to: one 2021/07/25 06:07:29 DEBUG : one: md5 = f97c5d29941bfb1b2fdab0874906ab82 OK 2021/07/25 06:07:29 INFO : one: Copied (new) 2021/07/25 06:07:30 DEBUG : one: Sizes differ (src 5 vs dst 3) 2021/07/25 06:07:30 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2021/07/25 06:07:34 INFO : one: Deleted 2021/07/25 06:07:35 INFO : one.rclone_chunk.001_sjkq9u: Moved (server-side) to: one 2021/07/25 06:07:35 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK 2021/07/25 06:07:35 INFO : one: Copied (replaced existing) 2021/07/25 06:07:42 INFO : dst/one: Deleted 2021/07/25 06:07:44 INFO : dst/one.rclone_chunk.001_sjkwec: Moved (server-side) to: dst/one 2021/07/25 06:07:50 INFO : CopyDest/one.rclone_chunk.001_sjl45d: Moved (server-side) to: CopyDest/one 2021/07/25 06:07:51 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9/BackupDir" 2021/07/25 06:07:51 DEBUG : Creating backend with remote "TestYandex:rclone-test-qinopic4wucesob7vihedot9/BackupDir" 2021/07/25 06:07:51 DEBUG : Reset feature "ListR" 2021/07/25 06:07:52 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/07/25 06:07:52 DEBUG : one: Sizes differ (src 5 vs dst 3) 2021/07/25 06:07:52 DEBUG : one: move non-chunked object... 2021/07/25 06:07:54 INFO : one: Moved (server-side) 2021/07/25 06:07:54 INFO : one: Moved (server-side) 2021/07/25 06:07:54 DEBUG : one: copy non-chunked object... 2021/07/25 06:07:56 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK 2021/07/25 06:07:56 INFO : one: Copied (server-side copy) 2021/07/25 06:07:56 DEBUG : one: Destination found in --copy-dest, using server-side copy 2021/07/25 06:08:03 INFO : CopyDest/two.rclone_chunk.001_sjlhz1: Moved (server-side) to: CopyDest/two 2021/07/25 06:08:04 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/07/25 06:08:04 DEBUG : two: copy non-chunked object... 2021/07/25 06:08:06 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 OK 2021/07/25 06:08:06 INFO : two: Copied (server-side copy) 2021/07/25 06:08:06 DEBUG : two: Destination found in --copy-dest, using server-side copy 2021/07/25 06:08:07 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/07/25 06:08:07 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2021/07/25 06:08:07 DEBUG : two: Unchanged skipping 2021/07/25 06:08:14 INFO : CopyDest/three.rclone_chunk.001_sjlt1q: Moved (server-side) to: CopyDest/three 2021/07/25 06:08:15 DEBUG : three: Sizes differ (src 7 vs dst 5) 2021/07/25 06:08:15 DEBUG : three: Destination not found in --copy-dest 2021/07/25 06:08:15 DEBUG : three: Need to transfer - File not found at Destination 2021/07/25 06:08:15 DEBUG : three: skip slow MD5 on source file, hashing in-transit 2021/07/25 06:08:21 INFO : three.rclone_chunk.001_sjlz56: Moved (server-side) to: three 2021/07/25 06:08:21 DEBUG : three: md5 = 1bccb9dccb3e9f6a3f9d2a8bdb54b7f5 OK 2021/07/25 06:08:21 INFO : three: Copied (new) --- PASS: TestCopyFileCopyDest (73.34s) === RUN TestSameConfig --- PASS: TestSameConfig (0.00s) === RUN TestSame --- PASS: TestSame (0.00s) === RUN TestOverlapping --- PASS: TestOverlapping (0.00s) === RUN TestListFormat --- PASS: TestListFormat (0.00s) === RUN TestDirMove run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:08:41 INFO : A1/one.rclone_chunk.001_sjmkhk: Moved (server-side) to: A1/one 2021/07/25 06:08:45 INFO : A1/two.rclone_chunk.001_sjmqux: Moved (server-side) to: A1/two 2021/07/25 06:08:51 INFO : A1/B1/three.rclone_chunk.001_sjmuas: Moved (server-side) to: A1/B1/three 2021/07/25 06:08:56 INFO : A1/B1/C1/four.rclone_chunk.001_sjmz27: Moved (server-side) to: A1/B1/C1/four 2021/07/25 06:09:01 INFO : A1/B1/C2/five.rclone_chunk.001_sjn5pu: Moved (server-side) to: A1/B1/C2/five 2021/07/25 06:09:01 DEBUG : A1/B2: Making directory 2021/07/25 06:09:02 DEBUG : A1/B1/C3: Making directory 2021/07/25 06:09:14 DEBUG : A2/two: move non-chunked object... 2021/07/25 06:09:14 DEBUG : A2/B1/C1/four: move non-chunked object... 2021/07/25 06:09:14 DEBUG : A2/B1/three: move non-chunked object... 2021/07/25 06:09:14 DEBUG : A2/one: move non-chunked object... 2021/07/25 06:09:15 INFO : A2/B1/C1/four: Moved (server-side) to: A3/B1/C1/four 2021/07/25 06:09:15 INFO : A2/B1/C1/four: Moved (server-side) to: A3/B1/C1/four 2021/07/25 06:09:15 DEBUG : A2/B1/C2/five: move non-chunked object... 2021/07/25 06:09:16 INFO : A2/two: Moved (server-side) to: A3/two 2021/07/25 06:09:16 INFO : A2/two: Moved (server-side) to: A3/two 2021/07/25 06:09:16 INFO : A2/B1/three: Moved (server-side) to: A3/B1/three 2021/07/25 06:09:16 INFO : A2/B1/three: Moved (server-side) to: A3/B1/three 2021/07/25 06:09:16 INFO : A2/B1/C2/five: Moved (server-side) to: A3/B1/C2/five 2021/07/25 06:09:16 INFO : A2/B1/C2/five: Moved (server-side) to: A3/B1/C2/five 2021/07/25 06:09:18 INFO : A2/one: Moved (server-side) to: A3/one 2021/07/25 06:09:18 INFO : A2/one: Moved (server-side) to: A3/one --- PASS: TestDirMove (72.30s) === RUN TestGetFsInfo run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" --- PASS: TestGetFsInfo (0.47s) === RUN TestRcat === RUN TestRcat/withChecksum=false,ignoreChecksum=false === CONT TestRcat run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" operations_test.go:1438: Adjust StreamingUploadCutoff to size limit 1Ki (was 100Ki) 2021/07/25 06:09:49 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9': File to upload is small (34 bytes), uploading instead of streaming 2021/07/25 06:09:53 INFO : no_checksum_small_file_from_pipe.rclone_chunk.001_sjollp: Moved (server-side) to: no_checksum_small_file_from_pipe 2021/07/25 06:09:53 DEBUG : no_checksum_small_file_from_pipe: md5 = 4c762bc6ec18f21b23fcae426c7863b5 OK 2021/07/25 06:09:53 INFO : no_checksum_small_file_from_pipe: Copied (new) 2021/07/25 06:10:56 INFO : no_checksum_big_file_from_pipe.rclone_chunk.001_sjop29: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.001 2021/07/25 06:10:57 INFO : no_checksum_big_file_from_pipe.rclone_chunk.002_sjop29: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.002 2021/07/25 06:10:58 INFO : no_checksum_big_file_from_pipe.rclone_chunk.003_sjop29: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.003 2021/07/25 06:10:59 INFO : no_checksum_big_file_from_pipe.rclone_chunk.004_sjop29: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.004 2021/07/25 06:11:00 INFO : no_checksum_big_file_from_pipe.rclone_chunk.005_sjop29: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.005 2021/07/25 06:11:00 INFO : no_checksum_big_file_from_pipe.rclone_chunk.006_sjop29: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.006 2021/07/25 06:11:01 INFO : no_checksum_big_file_from_pipe.rclone_chunk.007_sjop29: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.007 2021/07/25 06:11:03 INFO : no_checksum_big_file_from_pipe.rclone_chunk.008_sjop29: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.008 2021/07/25 06:11:04 INFO : no_checksum_big_file_from_pipe.rclone_chunk.009_sjop29: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.009 2021/07/25 06:11:05 INFO : no_checksum_big_file_from_pipe.rclone_chunk.010_sjop29: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.010 2021/07/25 06:11:06 INFO : no_checksum_big_file_from_pipe.rclone_chunk.011_sjop29: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.011 2021/07/25 06:11:07 INFO : no_checksum_big_file_from_pipe.rclone_chunk.012_sjop29: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.012 2021/07/25 06:11:08 INFO : no_checksum_big_file_from_pipe.rclone_chunk.013_sjop29: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.013 2021/07/25 06:11:09 INFO : no_checksum_big_file_from_pipe.rclone_chunk.014_sjop29: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.014 2021/07/25 06:11:10 INFO : no_checksum_big_file_from_pipe.rclone_chunk.015_sjop29: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.015 2021/07/25 06:11:10 INFO : no_checksum_big_file_from_pipe.rclone_chunk.016_sjop29: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.016 2021/07/25 06:11:11 INFO : no_checksum_big_file_from_pipe.rclone_chunk.017_sjop29: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.017 2021/07/25 06:11:12 INFO : no_checksum_big_file_from_pipe.rclone_chunk.018_sjop29: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.018 2021/07/25 06:11:13 INFO : no_checksum_big_file_from_pipe.rclone_chunk.019_sjop29: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.019 2021/07/25 06:11:14 INFO : no_checksum_big_file_from_pipe.rclone_chunk.020_sjop29: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.020 2021/07/25 06:11:15 INFO : no_checksum_big_file_from_pipe.rclone_chunk.021_sjop29: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.021 2021/07/25 06:11:17 DEBUG : no_checksum_big_file_from_pipe: Size and modification time the same (differ by 0s, within tolerance 1ns) === RUN TestRcat/withChecksum=true,ignoreChecksum=false === CONT TestRcat run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:11:55 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9': File to upload is small (34 bytes), uploading instead of streaming 2021/07/25 06:11:59 INFO : with_checksum_small_file_from_pipe.rclone_chunk.001_sjs363: Moved (server-side) to: with_checksum_small_file_from_pipe 2021/07/25 06:11:59 DEBUG : with_checksum_small_file_from_pipe: md5 = 4c762bc6ec18f21b23fcae426c7863b5 OK 2021/07/25 06:11:59 INFO : with_checksum_small_file_from_pipe: Copied (new) 2021/07/25 06:12:57 INFO : with_checksum_big_file_from_pipe.rclone_chunk.001_sjs7ht: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.001 2021/07/25 06:12:59 INFO : with_checksum_big_file_from_pipe.rclone_chunk.002_sjs7ht: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.002 2021/07/25 06:13:00 INFO : with_checksum_big_file_from_pipe.rclone_chunk.003_sjs7ht: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.003 2021/07/25 06:13:02 INFO : with_checksum_big_file_from_pipe.rclone_chunk.004_sjs7ht: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.004 2021/07/25 06:13:04 INFO : with_checksum_big_file_from_pipe.rclone_chunk.005_sjs7ht: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.005 2021/07/25 06:13:06 INFO : with_checksum_big_file_from_pipe.rclone_chunk.006_sjs7ht: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.006 2021/07/25 06:13:07 INFO : with_checksum_big_file_from_pipe.rclone_chunk.007_sjs7ht: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.007 2021/07/25 06:13:09 INFO : with_checksum_big_file_from_pipe.rclone_chunk.008_sjs7ht: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.008 2021/07/25 06:13:10 INFO : with_checksum_big_file_from_pipe.rclone_chunk.009_sjs7ht: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.009 2021/07/25 06:13:15 INFO : with_checksum_big_file_from_pipe.rclone_chunk.010_sjs7ht: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.010 2021/07/25 06:13:17 INFO : with_checksum_big_file_from_pipe.rclone_chunk.011_sjs7ht: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.011 2021/07/25 06:13:18 INFO : with_checksum_big_file_from_pipe.rclone_chunk.012_sjs7ht: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.012 2021/07/25 06:13:20 INFO : with_checksum_big_file_from_pipe.rclone_chunk.013_sjs7ht: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.013 2021/07/25 06:13:21 INFO : with_checksum_big_file_from_pipe.rclone_chunk.014_sjs7ht: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.014 2021/07/25 06:13:23 INFO : with_checksum_big_file_from_pipe.rclone_chunk.015_sjs7ht: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.015 2021/07/25 06:13:24 INFO : with_checksum_big_file_from_pipe.rclone_chunk.016_sjs7ht: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.016 2021/07/25 06:13:26 INFO : with_checksum_big_file_from_pipe.rclone_chunk.017_sjs7ht: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.017 2021/07/25 06:13:27 INFO : with_checksum_big_file_from_pipe.rclone_chunk.018_sjs7ht: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.018 2021/07/25 06:13:29 INFO : with_checksum_big_file_from_pipe.rclone_chunk.019_sjs7ht: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.019 2021/07/25 06:13:31 INFO : with_checksum_big_file_from_pipe.rclone_chunk.020_sjs7ht: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.020 2021/07/25 06:13:32 INFO : with_checksum_big_file_from_pipe.rclone_chunk.021_sjs7ht: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.021 2021/07/25 06:13:36 DEBUG : with_checksum_big_file_from_pipe: md5 = 0ad4cf7b35f62b8ff9c73f481594fbdd OK 2021/07/25 06:13:36 DEBUG : with_checksum_big_file_from_pipe: Size and md5 of src and dst objects identical === RUN TestRcat/withChecksum=false,ignoreChecksum=true === CONT TestRcat run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:14:09 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9': File to upload is small (34 bytes), uploading instead of streaming 2021/07/25 06:14:13 INFO : ignore_checksum_small_file_from_pipe.rclone_chunk.001_sjvtsv: Moved (server-side) to: ignore_checksum_small_file_from_pipe 2021/07/25 06:14:13 INFO : ignore_checksum_small_file_from_pipe: Copied (new) 2021/07/25 06:15:05 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.001_sjvxs5: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.001 2021/07/25 06:15:07 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.002_sjvxs5: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.002 2021/07/25 06:15:09 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.003_sjvxs5: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.003 2021/07/25 06:15:10 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.004_sjvxs5: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.004 2021/07/25 06:15:12 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.005_sjvxs5: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.005 2021/07/25 06:15:13 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.006_sjvxs5: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.006 2021/07/25 06:15:15 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.007_sjvxs5: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.007 2021/07/25 06:15:17 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.008_sjvxs5: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.008 2021/07/25 06:15:19 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.009_sjvxs5: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.009 2021/07/25 06:15:20 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.010_sjvxs5: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.010 2021/07/25 06:15:22 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.011_sjvxs5: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.011 2021/07/25 06:15:24 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.012_sjvxs5: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.012 2021/07/25 06:15:25 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.013_sjvxs5: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.013 2021/07/25 06:15:27 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.014_sjvxs5: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.014 2021/07/25 06:15:29 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.015_sjvxs5: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.015 2021/07/25 06:15:30 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.016_sjvxs5: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.016 2021/07/25 06:15:32 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.017_sjvxs5: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.017 2021/07/25 06:15:34 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.018_sjvxs5: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.018 2021/07/25 06:15:35 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.019_sjvxs5: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.019 2021/07/25 06:15:37 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.020_sjvxs5: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.020 2021/07/25 06:15:39 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.021_sjvxs5: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.021 2021/07/25 06:15:41 DEBUG : ignore_checksum_big_file_from_pipe: Size and modification time the same (differ by 0s, within tolerance 1ns) === RUN TestRcat/withChecksum=true,ignoreChecksum=true === CONT TestRcat run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:16:16 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9': File to upload is small (34 bytes), uploading instead of streaming 2021/07/25 06:16:21 INFO : ignore_checksum_small_file_from_pipe.rclone_chunk.001_sjzdnm: Moved (server-side) to: ignore_checksum_small_file_from_pipe 2021/07/25 06:16:21 INFO : ignore_checksum_small_file_from_pipe: Copied (new) 2021/07/25 06:17:17 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.001_sjzhu7: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.001 2021/07/25 06:17:22 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.002_sjzhu7: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.002 2021/07/25 06:17:23 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.003_sjzhu7: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.003 2021/07/25 06:17:25 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.004_sjzhu7: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.004 2021/07/25 06:17:26 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.005_sjzhu7: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.005 2021/07/25 06:17:28 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.006_sjzhu7: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.006 2021/07/25 06:17:30 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.007_sjzhu7: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.007 2021/07/25 06:17:31 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.008_sjzhu7: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.008 2021/07/25 06:17:33 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.009_sjzhu7: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.009 2021/07/25 06:17:34 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.010_sjzhu7: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.010 2021/07/25 06:17:36 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.011_sjzhu7: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.011 2021/07/25 06:17:38 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.012_sjzhu7: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.012 2021/07/25 06:17:39 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.013_sjzhu7: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.013 2021/07/25 06:17:41 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.014_sjzhu7: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.014 2021/07/25 06:17:43 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.015_sjzhu7: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.015 2021/07/25 06:17:44 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.016_sjzhu7: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.016 2021/07/25 06:17:46 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.017_sjzhu7: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.017 2021/07/25 06:17:48 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.018_sjzhu7: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.018 2021/07/25 06:17:49 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.019_sjzhu7: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.019 2021/07/25 06:17:51 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.020_sjzhu7: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.020 2021/07/25 06:17:53 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.021_sjzhu7: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.021 2021/07/25 06:17:56 DEBUG : ignore_checksum_big_file_from_pipe: Size of src and dst objects identical --- PASS: TestRcat (518.93s) --- PASS: TestRcat/withChecksum=false,ignoreChecksum=false (125.75s) --- PASS: TestRcat/withChecksum=true,ignoreChecksum=false (133.91s) --- PASS: TestRcat/withChecksum=false,ignoreChecksum=true (127.89s) --- PASS: TestRcat/withChecksum=true,ignoreChecksum=true (131.38s) === RUN TestRcatSize run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:18:36 INFO : potato1.rclone_chunk.001_sk307p: Moved (server-side) to: potato1.rclone_chunk.001 2021/07/25 06:18:37 INFO : potato1.rclone_chunk.002_sk307p: Moved (server-side) to: potato1.rclone_chunk.002 2021/07/25 06:18:39 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9': File to upload is small (60 bytes), uploading instead of streaming 2021/07/25 06:18:49 INFO : potato2.rclone_chunk.001_sk3cih: Moved (server-side) to: potato2.rclone_chunk.001 2021/07/25 06:18:50 INFO : potato2.rclone_chunk.002_sk3cih: Moved (server-side) to: potato2.rclone_chunk.002 2021/07/25 06:18:54 DEBUG : potato2: md5 = d6548b156ea68a4e003e786df99eee76 OK 2021/07/25 06:18:54 INFO : potato2: Copied (new) --- PASS: TestRcatSize (36.28s) === RUN TestCopyFileMaxTransfer run.go:176: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9'", Local "Local file system at /tmp/rclone782149231", Modify Window "1ns" 2021/07/25 06:19:04 DEBUG : TestCopyFileMaxTransfer/file1: Need to transfer - File not found at Destination 2021/07/25 06:19:04 DEBUG : TestCopyFileMaxTransfer/file1: skip slow MD5 on source file, hashing in-transit 2021/07/25 06:19:09 INFO : TestCopyFileMaxTransfer/file1.rclone_chunk.001_sk4037: Moved (server-side) to: TestCopyFileMaxTransfer/file1 2021/07/25 06:19:09 DEBUG : TestCopyFileMaxTransfer/file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2021/07/25 06:19:09 INFO : TestCopyFileMaxTransfer/file1: Copied (new) 2021/07/25 06:19:10 DEBUG : TestCopyFileMaxTransfer/file2: Need to transfer - File not found at Destination 2021/07/25 06:19:10 DEBUG : TestCopyFileMaxTransfer/file2: skip slow MD5 on source file, hashing in-transit 2021/07/25 06:22:04 ERROR : TestCopyFileMaxTransfer/file2: Failed to copy: Put "https://uploader21g.disk.yandex.net:443/upload-target/20210725T092105.533.utd.bl7emxawc7nbpy085i6m7c5x7-k21g.17824153": Max transfer limit reached as set by --max-transfer 2021/07/25 06:22:05 DEBUG : TestCopyFileMaxTransfer/file3: Need to transfer - File not found at Destination operations_test.go:1551: skipping remainder of test for chunker as it involves multiple transfers --- PASS: TestCopyFileMaxTransfer (184.59s) === RUN TestRcAbout rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcAbout (0.00s) === RUN TestRcCleanup rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcCleanup (0.00s) === RUN TestRcCopyfile rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcCopyfile (0.00s) === RUN TestRcCopyurl rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcCopyurl (0.00s) === RUN TestRcDelete rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcDelete (0.00s) === RUN TestRcDeletefile rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcDeletefile (0.00s) === RUN TestRcList rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcList (0.00s) === RUN TestRcMkdir rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcMkdir (0.00s) === RUN TestRcMovefile rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcMovefile (0.00s) === RUN TestRcPurge rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcPurge (0.00s) === RUN TestRcRmdir rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcRmdir (0.00s) === RUN TestRcRmdirs rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcRmdirs (0.00s) === RUN TestRcSize rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcSize (0.00s) === RUN TestRcPublicLink rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcPublicLink (0.00s) === RUN TestRcFsInfo rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcFsInfo (0.00s) === RUN TestUploadFile rc_test.go:25: Skipping test on non local remote --- SKIP: TestUploadFile (0.00s) === RUN TestRcCommand rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcCommand (0.00s) PASS 2021/07/25 06:22:08 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-qinopic4wucesob7vihedot9': Purge remote "./operations.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024" - Finished OK in 31m12.495486691s (try 1/5)