"./operations.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -fast-list -size-limit 1024" - Starting (try 2/5) 2025/06/19 05:54:55 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-jasacux0bonu" 2025/06/19 05:54:55 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/06/19 05:54:55 DEBUG : Creating backend with remote "TestYandex:rclone-test-jasacux0bonu" 2025/06/19 05:54:56 DEBUG : Creating backend with remote "/tmp/rclone537506929" === RUN TestDoMultiThreadCopy --- PASS: TestDoMultiThreadCopy (0.00s) === RUN TestMultithreadCalculateNumChunks === RUN TestMultithreadCalculateNumChunks/{size:1_chunkSize:65536_wantNumChunks:1} === RUN TestMultithreadCalculateNumChunks/{size:1048576_chunkSize:1_wantNumChunks:1048576} === RUN TestMultithreadCalculateNumChunks/{size:1048576_chunkSize:2_wantNumChunks:524288} === RUN TestMultithreadCalculateNumChunks/{size:1048577_chunkSize:2_wantNumChunks:524289} === RUN TestMultithreadCalculateNumChunks/{size:1048575_chunkSize:2_wantNumChunks:524288} --- PASS: TestMultithreadCalculateNumChunks (0.00s) --- PASS: TestMultithreadCalculateNumChunks/{size:1_chunkSize:65536_wantNumChunks:1} (0.00s) --- PASS: TestMultithreadCalculateNumChunks/{size:1048576_chunkSize:1_wantNumChunks:1048576} (0.00s) --- PASS: TestMultithreadCalculateNumChunks/{size:1048576_chunkSize:2_wantNumChunks:524288} (0.00s) --- PASS: TestMultithreadCalculateNumChunks/{size:1048577_chunkSize:2_wantNumChunks:524289} (0.00s) --- PASS: TestMultithreadCalculateNumChunks/{size:1048575_chunkSize:2_wantNumChunks:524288} (0.00s) === RUN TestMultithreadCopy run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" multithread_test.go:121: multithread writing not supported 2025/06/19 05:54:56 ERROR : error listing: directory not found --- SKIP: TestMultithreadCopy (0.31s) === RUN TestMultithreadCopyAbort run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" multithread_test.go:121: multithread writing not supported 2025/06/19 05:54:57 ERROR : error listing: directory not found --- SKIP: TestMultithreadCopyAbort (0.31s) === RUN TestSizeDiffers --- PASS: TestSizeDiffers (0.00s) === RUN TestReOpen === RUN TestReOpen/Normal === RUN TestReOpen/Normal/Basics 2025/06/19 05:54:57 DEBUG : potato: Seek from 10 to 0 === RUN TestReOpen/Normal/ErrorAtStart === RUN TestReOpen/Normal/WithErrors 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/Normal/TooManyErrors 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2025/06/19 05:54:57 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/Normal/Seek 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2025/06/19 05:54:57 DEBUG : potato: Seek from 5 to 2 === RUN TestReOpen/Normal/AccountRead === RUN TestReOpen/Normal/AccountReadDelay 2025/06/19 05:54:57 DEBUG : potato: Seek from 10 to 0 2025/06/19 05:54:57 DEBUG : potato: Seek from 10 to 0 2025/06/19 05:54:57 DEBUG : potato: Seek from 10 to 0 === RUN TestReOpen/Normal/AccountReadError === RUN TestReOpen/WithRangeOption === RUN TestReOpen/WithRangeOption/Basics 2025/06/19 05:54:57 DEBUG : potato: Seek from 7 to 0 === RUN TestReOpen/WithRangeOption/ErrorAtStart === RUN TestReOpen/WithRangeOption/WithErrors 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/WithRangeOption/TooManyErrors 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2025/06/19 05:54:57 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/WithRangeOption/Seek 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2025/06/19 05:54:57 DEBUG : potato: Seek from 5 to 2 2025/06/19 05:54:57 DEBUG : potato: Seek from 7 to 4 === RUN TestReOpen/WithRangeOption/AccountRead === RUN TestReOpen/WithRangeOption/AccountReadDelay 2025/06/19 05:54:57 DEBUG : potato: Seek from 7 to 0 2025/06/19 05:54:57 DEBUG : potato: Seek from 7 to 0 2025/06/19 05:54:57 DEBUG : potato: Seek from 7 to 0 === RUN TestReOpen/WithRangeOption/AccountReadError === RUN TestReOpen/WithSeekOption === RUN TestReOpen/WithSeekOption/Basics 2025/06/19 05:54:57 DEBUG : potato: Seek from 8 to 0 === RUN TestReOpen/WithSeekOption/ErrorAtStart === RUN TestReOpen/WithSeekOption/WithErrors 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/WithSeekOption/TooManyErrors 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2025/06/19 05:54:57 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/WithSeekOption/Seek 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2025/06/19 05:54:57 DEBUG : potato: Seek from 5 to 2 2025/06/19 05:54:57 DEBUG : potato: Seek from 7 to 5 === RUN TestReOpen/WithSeekOption/AccountRead === RUN TestReOpen/WithSeekOption/AccountReadDelay 2025/06/19 05:54:57 DEBUG : potato: Seek from 8 to 0 2025/06/19 05:54:57 DEBUG : potato: Seek from 8 to 0 2025/06/19 05:54:57 DEBUG : potato: Seek from 8 to 0 === RUN TestReOpen/WithSeekOption/AccountReadError === RUN TestReOpen/UnknownSize === RUN TestReOpen/UnknownSize/Basics 2025/06/19 05:54:57 DEBUG : potato: Seek from 9 to 0 === RUN TestReOpen/UnknownSize/ErrorAtStart === RUN TestReOpen/UnknownSize/WithErrors 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/UnknownSize/TooManyErrors 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2025/06/19 05:54:57 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/UnknownSize/Seek 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2025/06/19 05:54:57 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2025/06/19 05:54:57 DEBUG : potato: Seek from 5 to 2 2025/06/19 05:54:57 DEBUG : potato: Seek from 7 to 6 === RUN TestReOpen/UnknownSize/AccountRead === RUN TestReOpen/UnknownSize/AccountReadDelay 2025/06/19 05:54:57 DEBUG : potato: Seek from 9 to 0 2025/06/19 05:54:57 DEBUG : potato: Seek from 9 to 0 2025/06/19 05:54:57 DEBUG : potato: Seek from 9 to 0 === RUN TestReOpen/UnknownSize/AccountReadError --- PASS: TestReOpen (0.00s) --- PASS: TestReOpen/Normal (0.00s) --- PASS: TestReOpen/Normal/Basics (0.00s) --- PASS: TestReOpen/Normal/ErrorAtStart (0.00s) --- PASS: TestReOpen/Normal/WithErrors (0.00s) --- PASS: TestReOpen/Normal/TooManyErrors (0.00s) --- PASS: TestReOpen/Normal/Seek (0.00s) --- PASS: TestReOpen/Normal/AccountRead (0.00s) --- PASS: TestReOpen/Normal/AccountReadDelay (0.00s) --- PASS: TestReOpen/Normal/AccountReadError (0.00s) --- PASS: TestReOpen/WithRangeOption (0.00s) --- PASS: TestReOpen/WithRangeOption/Basics (0.00s) --- PASS: TestReOpen/WithRangeOption/ErrorAtStart (0.00s) --- PASS: TestReOpen/WithRangeOption/WithErrors (0.00s) --- PASS: TestReOpen/WithRangeOption/TooManyErrors (0.00s) --- PASS: TestReOpen/WithRangeOption/Seek (0.00s) --- PASS: TestReOpen/WithRangeOption/AccountRead (0.00s) --- PASS: TestReOpen/WithRangeOption/AccountReadDelay (0.00s) --- PASS: TestReOpen/WithRangeOption/AccountReadError (0.00s) --- PASS: TestReOpen/WithSeekOption (0.00s) --- PASS: TestReOpen/WithSeekOption/Basics (0.00s) --- PASS: TestReOpen/WithSeekOption/ErrorAtStart (0.00s) --- PASS: TestReOpen/WithSeekOption/WithErrors (0.00s) --- PASS: TestReOpen/WithSeekOption/TooManyErrors (0.00s) --- PASS: TestReOpen/WithSeekOption/Seek (0.00s) --- PASS: TestReOpen/WithSeekOption/AccountRead (0.00s) --- PASS: TestReOpen/WithSeekOption/AccountReadDelay (0.00s) --- PASS: TestReOpen/WithSeekOption/AccountReadError (0.00s) --- PASS: TestReOpen/UnknownSize (0.00s) --- PASS: TestReOpen/UnknownSize/Basics (0.00s) --- PASS: TestReOpen/UnknownSize/ErrorAtStart (0.00s) --- PASS: TestReOpen/UnknownSize/WithErrors (0.00s) --- PASS: TestReOpen/UnknownSize/TooManyErrors (0.00s) --- PASS: TestReOpen/UnknownSize/Seek (0.00s) --- PASS: TestReOpen/UnknownSize/AccountRead (0.00s) --- PASS: TestReOpen/UnknownSize/AccountReadDelay (0.00s) --- PASS: TestReOpen/UnknownSize/AccountReadError (0.00s) === RUN TestCheck run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 05:55:02 INFO : rutabaga.rclone_chunk.001_3fe8fq: Moved (server-side) to: rutabaga === RUN TestCheck/1 === RUN TestCheck/2 2025/06/19 05:55:08 INFO : empty space.rclone_chunk.001_3feeur: Moved (server-side) to: empty space === RUN TestCheck/3 2025/06/19 05:55:20 INFO : potato2.rclone_chunk.001_3fej2a: Moved (server-side) to: potato2.rclone_chunk.001 2025/06/19 05:55:21 INFO : potato2.rclone_chunk.002_3fej2a: Moved (server-side) to: potato2.rclone_chunk.002 === RUN TestCheck/4 === RUN TestCheck/5 2025/06/19 05:55:34 INFO : remotepotato.rclone_chunk.001_3ff2oj: Moved (server-side) to: remotepotato.rclone_chunk.001 2025/06/19 05:55:35 INFO : remotepotato.rclone_chunk.002_3ff2oj: Moved (server-side) to: remotepotato.rclone_chunk.002 === RUN TestCheck/6 === RUN TestCheck/7 --- PASS: TestCheck (84.61s) --- PASS: TestCheck/1 (0.50s) --- PASS: TestCheck/2 (0.42s) --- PASS: TestCheck/3 (0.30s) --- PASS: TestCheck/4 (2.47s) --- PASS: TestCheck/5 (0.87s) --- PASS: TestCheck/6 (0.91s) --- PASS: TestCheck/7 (0.79s) === RUN TestCheckFsError 2025/06/19 05:56:21 DEBUG : Creating backend with remote "nonexistent" 2025/06/19 05:56:21 DEBUG : Creating backend with remote "nonexistent" 2025/06/19 05:56:21 DEBUG : Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/nonexistent: Waiting for checks to finish 2025/06/19 05:56:21 ERROR : Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/nonexistent: error reading source root directory: directory not found 2025/06/19 05:56:21 NOTICE: Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/nonexistent: 2 differences found 2025/06/19 05:56:21 NOTICE: Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/nonexistent: 2 errors while checking --- PASS: TestCheckFsError (0.00s) === RUN TestCheckDownload run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 05:56:26 INFO : rutabaga.rclone_chunk.001_3fgjn8: Moved (server-side) to: rutabaga === RUN TestCheckDownload/1 === RUN TestCheckDownload/2 2025/06/19 05:56:35 INFO : empty space.rclone_chunk.001_3fgrpr: Moved (server-side) to: empty space === RUN TestCheckDownload/3 2025/06/19 05:56:43 INFO : potato2.rclone_chunk.001_3fgy59: Moved (server-side) to: potato2.rclone_chunk.001 2025/06/19 05:56:45 INFO : potato2.rclone_chunk.002_3fgy59: Moved (server-side) to: potato2.rclone_chunk.002 === RUN TestCheckDownload/4 === RUN TestCheckDownload/5 2025/06/19 05:56:58 INFO : remotepotato.rclone_chunk.001_3fhdw5: Moved (server-side) to: remotepotato.rclone_chunk.001 2025/06/19 05:57:00 INFO : remotepotato.rclone_chunk.002_3fhdw5: Moved (server-side) to: remotepotato.rclone_chunk.002 === RUN TestCheckDownload/6 === RUN TestCheckDownload/7 --- PASS: TestCheckDownload (92.08s) --- PASS: TestCheckDownload/1 (0.87s) --- PASS: TestCheckDownload/2 (0.71s) --- PASS: TestCheckDownload/3 (0.65s) --- PASS: TestCheckDownload/4 (1.72s) --- PASS: TestCheckDownload/5 (1.66s) --- PASS: TestCheckDownload/6 (3.34s) --- PASS: TestCheckDownload/7 (1.73s) === RUN TestCheckSizeOnly run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 05:57:58 INFO : rutabaga.rclone_chunk.001_3fj4f7: Moved (server-side) to: rutabaga === RUN TestCheckSizeOnly/1 === RUN TestCheckSizeOnly/2 2025/06/19 05:58:04 INFO : empty space.rclone_chunk.001_3fjarb: Moved (server-side) to: empty space === RUN TestCheckSizeOnly/3 2025/06/19 05:58:11 INFO : potato2.rclone_chunk.001_3fjfcg: Moved (server-side) to: potato2.rclone_chunk.001 2025/06/19 05:58:13 INFO : potato2.rclone_chunk.002_3fjfcg: Moved (server-side) to: potato2.rclone_chunk.002 === RUN TestCheckSizeOnly/4 === RUN TestCheckSizeOnly/5 2025/06/19 05:58:23 INFO : remotepotato.rclone_chunk.001_3fjr3y: Moved (server-side) to: remotepotato.rclone_chunk.001 2025/06/19 05:58:24 INFO : remotepotato.rclone_chunk.002_3fjr3y: Moved (server-side) to: remotepotato.rclone_chunk.002 === RUN TestCheckSizeOnly/6 === RUN TestCheckSizeOnly/7 --- PASS: TestCheckSizeOnly (76.59s) --- PASS: TestCheckSizeOnly/1 (0.31s) --- PASS: TestCheckSizeOnly/2 (0.27s) --- PASS: TestCheckSizeOnly/3 (0.26s) --- PASS: TestCheckSizeOnly/4 (0.31s) --- PASS: TestCheckSizeOnly/5 (0.41s) --- PASS: TestCheckSizeOnly/6 (0.33s) --- PASS: TestCheckSizeOnly/7 (0.28s) === RUN TestCheckEqualReaders --- PASS: TestCheckEqualReaders (0.00s) === RUN TestParseSumFile run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 05:59:16 INFO : test.sum.rclone_chunk.001_3fl8wx: Moved (server-side) to: test.sum.rclone_chunk.001 2025/06/19 05:59:17 INFO : test.sum.rclone_chunk.002_3fl8wx: Moved (server-side) to: test.sum.rclone_chunk.002 2025/06/19 05:59:22 NOTICE: test.sum: improperly formatted checksum line 4 2025/06/19 05:59:22 NOTICE: test.sum: improperly formatted checksum line 5 2025/06/19 05:59:22 NOTICE: test.sum: improperly formatted checksum line 6 2025/06/19 05:59:22 NOTICE: test.sum: 2 warning(s) suppressed... 2025/06/19 05:59:40 INFO : test.sum.rclone_chunk.001_3fll7e: Moved (server-side) to: test.sum.rclone_chunk.001 2025/06/19 05:59:42 INFO : test.sum.rclone_chunk.002_3fll7e: Moved (server-side) to: test.sum.rclone_chunk.002 2025/06/19 05:59:46 NOTICE: test.sum: improperly formatted checksum line 4 2025/06/19 05:59:46 NOTICE: test.sum: improperly formatted checksum line 5 2025/06/19 05:59:46 NOTICE: test.sum: improperly formatted checksum line 6 2025/06/19 05:59:46 NOTICE: test.sum: 2 warning(s) suppressed... --- PASS: TestParseSumFile (57.14s) === RUN TestCheckSum run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:00:07 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-jasacux0bonu/data" 2025/06/19 06:00:07 DEBUG : Creating backend with remote "TestYandex:rclone-test-jasacux0bonu/data" 2025/06/19 06:00:13 INFO : data/banana.rclone_chunk.001_3fmuiw: Moved (server-side) to: data/banana 2025/06/19 06:00:19 INFO : test.sum.rclone_chunk.001_3fmzc5: Moved (server-side) to: test.sum === RUN TestCheckSum/subtest1 2025/06/19 06:00:27 INFO : data/potato.rclone_chunk.001_3fn8sc: Moved (server-side) to: data/potato 2025/06/19 06:00:37 INFO : test.sum: Deleted 2025/06/19 06:00:38 INFO : test.sum.rclone_chunk.001_3fne7f: Moved (server-side) to: test.sum === RUN TestCheckSum/subtest2 2025/06/19 06:00:48 INFO : test.sum.rclone_chunk.001_3fnrdv: Moved (server-side) to: test.sum.rclone_chunk.001 2025/06/19 06:00:50 INFO : test.sum.rclone_chunk.002_3fnrdv: Moved (server-side) to: test.sum.rclone_chunk.002 === RUN TestCheckSum/subtest3 2025/06/19 06:01:15 INFO : test.sum.rclone_chunk.001_3fo885: Moved (server-side) to: test.sum.rclone_chunk.001 2025/06/19 06:01:17 INFO : test.sum.rclone_chunk.002_3fo885: Moved (server-side) to: test.sum.rclone_chunk.002 === RUN TestCheckSum/subtest4 2025/06/19 06:01:45 INFO : test.sum.rclone_chunk.001_3fp0lx: Moved (server-side) to: test.sum.rclone_chunk.001 2025/06/19 06:01:47 INFO : test.sum.rclone_chunk.002_3fp0lx: Moved (server-side) to: test.sum.rclone_chunk.002 2025/06/19 06:01:49 INFO : test.sum.rclone_chunk.003_3fp0lx: Moved (server-side) to: test.sum.rclone_chunk.003 === RUN TestCheckSum/subtest5 2025/06/19 06:02:21 INFO : test.sum.rclone_chunk.001_3fpwmo: Moved (server-side) to: test.sum.rclone_chunk.001 2025/06/19 06:02:23 INFO : test.sum.rclone_chunk.002_3fpwmo: Moved (server-side) to: test.sum.rclone_chunk.002 2025/06/19 06:02:24 INFO : test.sum.rclone_chunk.003_3fpwmo: Moved (server-side) to: test.sum.rclone_chunk.003 === RUN TestCheckSum/subtest6 2025/06/19 06:02:39 INFO : data/banana: Deleted 2025/06/19 06:02:41 INFO : data/banana.rclone_chunk.001_3fqt1r: Moved (server-side) to: data/banana 2025/06/19 06:02:49 INFO : data/potato: Deleted 2025/06/19 06:02:51 INFO : data/potato.rclone_chunk.001_3fr3e2: Moved (server-side) to: data/potato 2025/06/19 06:03:12 INFO : test.sum.rclone_chunk.001_3fre8q: Moved (server-side) to: test.sum.rclone_chunk.001 2025/06/19 06:03:13 INFO : test.sum.rclone_chunk.002_3fre8q: Moved (server-side) to: test.sum.rclone_chunk.002 === RUN TestCheckSum/subtest7 --- PASS: TestCheckSum (225.76s) --- PASS: TestCheckSum/subtest1 (1.55s) --- PASS: TestCheckSum/subtest2 (1.46s) --- PASS: TestCheckSum/subtest3 (2.64s) --- PASS: TestCheckSum/subtest4 (3.12s) --- PASS: TestCheckSum/subtest5 (3.32s) --- PASS: TestCheckSum/subtest6 (3.06s) --- PASS: TestCheckSum/subtest7 (3.08s) === RUN TestCheckSumDownload run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:03:53 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-jasacux0bonu/data" 2025/06/19 06:03:53 DEBUG : Creating backend with remote "TestYandex:rclone-test-jasacux0bonu/data" 2025/06/19 06:03:59 INFO : data/banana.rclone_chunk.001_3ft3zd: Moved (server-side) to: data/banana 2025/06/19 06:04:05 INFO : test.sum.rclone_chunk.001_3ft96f: Moved (server-side) to: test.sum === RUN TestCheckSumDownload/subtest1 2025/06/19 06:04:13 INFO : data/potato.rclone_chunk.001_3ftio9: Moved (server-side) to: data/potato 2025/06/19 06:04:23 INFO : test.sum: Deleted 2025/06/19 06:04:26 INFO : test.sum.rclone_chunk.001_3ftoed: Moved (server-side) to: test.sum === RUN TestCheckSumDownload/subtest2 2025/06/19 06:04:39 INFO : test.sum.rclone_chunk.001_3fu4al: Moved (server-side) to: test.sum.rclone_chunk.001 2025/06/19 06:04:40 INFO : test.sum.rclone_chunk.002_3fu4al: Moved (server-side) to: test.sum.rclone_chunk.002 === RUN TestCheckSumDownload/subtest3 2025/06/19 06:05:05 INFO : test.sum.rclone_chunk.001_3funkf: Moved (server-side) to: test.sum.rclone_chunk.001 2025/06/19 06:05:06 INFO : test.sum.rclone_chunk.002_3funkf: Moved (server-side) to: test.sum.rclone_chunk.002 === RUN TestCheckSumDownload/subtest4 2025/06/19 06:05:32 INFO : test.sum.rclone_chunk.001_3fvbcp: Moved (server-side) to: test.sum.rclone_chunk.001 2025/06/19 06:05:34 INFO : test.sum.rclone_chunk.002_3fvbcp: Moved (server-side) to: test.sum.rclone_chunk.002 2025/06/19 06:05:35 INFO : test.sum.rclone_chunk.003_3fvbcp: Moved (server-side) to: test.sum.rclone_chunk.003 === RUN TestCheckSumDownload/subtest5 2025/06/19 06:06:10 INFO : test.sum.rclone_chunk.001_3fw73o: Moved (server-side) to: test.sum.rclone_chunk.001 2025/06/19 06:06:12 INFO : test.sum.rclone_chunk.002_3fw73o: Moved (server-side) to: test.sum.rclone_chunk.002 2025/06/19 06:06:14 INFO : test.sum.rclone_chunk.003_3fw73o: Moved (server-side) to: test.sum.rclone_chunk.003 === RUN TestCheckSumDownload/subtest6 2025/06/19 06:06:30 INFO : data/banana: Deleted 2025/06/19 06:06:31 INFO : data/banana.rclone_chunk.001_3fx8vy: Moved (server-side) to: data/banana 2025/06/19 06:06:41 INFO : data/potato: Deleted 2025/06/19 06:06:43 INFO : data/potato.rclone_chunk.001_3fxibw: Moved (server-side) to: data/potato 2025/06/19 06:07:06 INFO : test.sum.rclone_chunk.001_3fxuxu: Moved (server-side) to: test.sum.rclone_chunk.001 2025/06/19 06:07:07 INFO : test.sum.rclone_chunk.002_3fxuxu: Moved (server-side) to: test.sum.rclone_chunk.002 === RUN TestCheckSumDownload/subtest7 --- PASS: TestCheckSumDownload (235.72s) --- PASS: TestCheckSumDownload/subtest1 (2.73s) --- PASS: TestCheckSumDownload/subtest2 (2.45s) --- PASS: TestCheckSumDownload/subtest3 (3.37s) --- PASS: TestCheckSumDownload/subtest4 (3.03s) --- PASS: TestCheckSumDownload/subtest5 (4.78s) --- PASS: TestCheckSumDownload/subtest6 (3.55s) --- PASS: TestCheckSumDownload/subtest7 (3.28s) === RUN TestApplyTransforms 2025/06/19 06:07:48 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-kosozuy7jeho" 2025/06/19 06:07:48 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/06/19 06:07:48 DEBUG : Creating backend with remote "TestYandex:rclone-test-kosozuy7jeho" 2025/06/19 06:07:49 DEBUG : Creating backend with remote "/tmp/rclone547584661" run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-kosozuy7jeho'", Local "Local file system at /tmp/rclone547584661", Modify Window "1ns" 2025/06/19 06:07:54 INFO : hello, world!.rclone_chunk.001_3fzn5n: Moved (server-side) to: hello, world! upper checkfile vs. lower remote (without normalization) 2025/06/19 06:07:54 ERROR : hello, world!: sum not found 2025/06/19 06:07:54 ERROR : HELLO, WORLD!: file not in Chunked 'TestChunkerChunk50bYandex:rclone-test-kosozuy7jeho' 2025/06/19 06:07:54 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-kosozuy7jeho': 1 files missing 2025/06/19 06:07:54 NOTICE: 1 hashes missing 2025/06/19 06:07:54 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-kosozuy7jeho': 2 differences found 2025/06/19 06:07:54 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-kosozuy7jeho': 2 errors while checking upper checkfile vs. lower remote (with normalization) 2025/06/19 06:07:55 DEBUG : hello, world!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/06/19 06:07:55 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-kosozuy7jeho': 0 differences found 2025/06/19 06:07:55 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-kosozuy7jeho': 1 matching files 2025/06/19 06:07:55 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-xenuvak4tope" 2025/06/19 06:07:55 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/06/19 06:07:55 DEBUG : Creating backend with remote "TestYandex:rclone-test-xenuvak4tope" 2025/06/19 06:07:55 DEBUG : Creating backend with remote "/tmp/rclone140760246" run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-xenuvak4tope'", Local "Local file system at /tmp/rclone140760246", Modify Window "1ns" 2025/06/19 06:08:01 INFO : HELLO, WORLD!.rclone_chunk.001_3fzuzn: Moved (server-side) to: HELLO, WORLD! lower checkfile vs. upper remote (without normalization) 2025/06/19 06:08:02 ERROR : HELLO, WORLD!: sum not found 2025/06/19 06:08:02 ERROR : hello, world!: file not in Chunked 'TestChunkerChunk50bYandex:rclone-test-xenuvak4tope' 2025/06/19 06:08:02 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-xenuvak4tope': 1 files missing 2025/06/19 06:08:02 NOTICE: 1 hashes missing 2025/06/19 06:08:02 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-xenuvak4tope': 2 differences found 2025/06/19 06:08:02 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-xenuvak4tope': 2 errors while checking lower checkfile vs. upper remote (with normalization) 2025/06/19 06:08:03 DEBUG : HELLO, WORLD!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/06/19 06:08:03 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-xenuvak4tope': 0 differences found 2025/06/19 06:08:03 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-xenuvak4tope': 1 matching files 2025/06/19 06:08:03 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-xusaked0xuva" 2025/06/19 06:08:03 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/06/19 06:08:03 DEBUG : Creating backend with remote "TestYandex:rclone-test-xusaked0xuva" 2025/06/19 06:08:03 DEBUG : Creating backend with remote "/tmp/rclone1481545362" run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-xusaked0xuva'", Local "Local file system at /tmp/rclone1481545362", Modify Window "1ns" 2025/06/19 06:08:08 INFO : HeLlO, wOrLd!.rclone_chunk.001_3g02cf: Moved (server-side) to: HeLlO, wOrLd! lower checkfile vs. upperlowermixed remote (without normalization) 2025/06/19 06:08:08 ERROR : HeLlO, wOrLd!: sum not found 2025/06/19 06:08:08 ERROR : hello, world!: file not in Chunked 'TestChunkerChunk50bYandex:rclone-test-xusaked0xuva' 2025/06/19 06:08:08 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-xusaked0xuva': 1 files missing 2025/06/19 06:08:08 NOTICE: 1 hashes missing 2025/06/19 06:08:08 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-xusaked0xuva': 2 differences found 2025/06/19 06:08:08 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-xusaked0xuva': 2 errors while checking lower checkfile vs. upperlowermixed remote (with normalization) 2025/06/19 06:08:09 DEBUG : HeLlO, wOrLd!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/06/19 06:08:09 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-xusaked0xuva': 0 differences found 2025/06/19 06:08:09 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-xusaked0xuva': 1 matching files 2025/06/19 06:08:09 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-qupifih8tagu" 2025/06/19 06:08:09 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/06/19 06:08:09 DEBUG : Creating backend with remote "TestYandex:rclone-test-qupifih8tagu" 2025/06/19 06:08:10 DEBUG : Creating backend with remote "/tmp/rclone2509080664" run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-qupifih8tagu'", Local "Local file system at /tmp/rclone2509080664", Modify Window "1ns" 2025/06/19 06:08:15 INFO : HELLO, WORLD!.rclone_chunk.001_3g08fs: Moved (server-side) to: HELLO, WORLD! upperlowermixed checkfile vs. upper remote (without normalization) 2025/06/19 06:08:15 ERROR : HELLO, WORLD!: sum not found 2025/06/19 06:08:15 ERROR : HeLlO, wOrLd!: file not in Chunked 'TestChunkerChunk50bYandex:rclone-test-qupifih8tagu' 2025/06/19 06:08:15 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-qupifih8tagu': 1 files missing 2025/06/19 06:08:15 NOTICE: 1 hashes missing 2025/06/19 06:08:15 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-qupifih8tagu': 2 differences found 2025/06/19 06:08:15 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-qupifih8tagu': 2 errors while checking upperlowermixed checkfile vs. upper remote (with normalization) 2025/06/19 06:08:17 DEBUG : HELLO, WORLD!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/06/19 06:08:17 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-qupifih8tagu': 0 differences found 2025/06/19 06:08:17 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-qupifih8tagu': 1 matching files 2025/06/19 06:08:17 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-tinirin6keso" 2025/06/19 06:08:17 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/06/19 06:08:17 DEBUG : Creating backend with remote "TestYandex:rclone-test-tinirin6keso" 2025/06/19 06:08:17 DEBUG : Creating backend with remote "/tmp/rclone568945206" run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-tinirin6keso'", Local "Local file system at /tmp/rclone568945206", Modify Window "1ns" 2025/06/19 06:08:23 INFO : 測試_Русский___ě_áñ.rclone_chunk.001_3g0guj: Moved (server-side) to: 測試_Русский___ě_áñ NFD checkfile vs. NFC remote (without normalization) 2025/06/19 06:08:23 ERROR : 測試_Русский___ě_áñ: sum not found 2025/06/19 06:08:23 ERROR : 測試_Русский___ě_áñ: file not in Chunked 'TestChunkerChunk50bYandex:rclone-test-tinirin6keso' 2025/06/19 06:08:23 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-tinirin6keso': 1 files missing 2025/06/19 06:08:23 NOTICE: 1 hashes missing 2025/06/19 06:08:23 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-tinirin6keso': 2 differences found 2025/06/19 06:08:23 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-tinirin6keso': 2 errors while checking NFD checkfile vs. NFC remote (with normalization) 2025/06/19 06:08:24 DEBUG : 測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/06/19 06:08:24 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-tinirin6keso': 0 differences found 2025/06/19 06:08:24 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-tinirin6keso': 1 matching files 2025/06/19 06:08:24 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-bezihes5qusa" 2025/06/19 06:08:24 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/06/19 06:08:24 DEBUG : Creating backend with remote "TestYandex:rclone-test-bezihes5qusa" 2025/06/19 06:08:25 DEBUG : Creating backend with remote "/tmp/rclone1278257748" run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bezihes5qusa'", Local "Local file system at /tmp/rclone1278257748", Modify Window "1ns" 2025/06/19 06:08:30 INFO : 測試_Русский___ě_áñ.rclone_chunk.001_3g0nxi: Moved (server-side) to: 測試_Русский___ě_áñ NFC checkfile vs. NFD remote (without normalization) 2025/06/19 06:08:30 ERROR : 測試_Русский___ě_áñ: sum not found 2025/06/19 06:08:30 ERROR : 測試_Русский___ě_áñ: file not in Chunked 'TestChunkerChunk50bYandex:rclone-test-bezihes5qusa' 2025/06/19 06:08:30 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-bezihes5qusa': 1 files missing 2025/06/19 06:08:30 NOTICE: 1 hashes missing 2025/06/19 06:08:30 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-bezihes5qusa': 2 differences found 2025/06/19 06:08:30 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-bezihes5qusa': 2 errors while checking NFC checkfile vs. NFD remote (with normalization) 2025/06/19 06:08:31 DEBUG : 測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/06/19 06:08:31 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-bezihes5qusa': 0 differences found 2025/06/19 06:08:31 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-bezihes5qusa': 1 matching files 2025/06/19 06:08:31 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-sakazan0fiha" 2025/06/19 06:08:31 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/06/19 06:08:31 DEBUG : Creating backend with remote "TestYandex:rclone-test-sakazan0fiha" 2025/06/19 06:08:32 DEBUG : Creating backend with remote "/tmp/rclone2564585848" run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-sakazan0fiha'", Local "Local file system at /tmp/rclone2564585848", Modify Window "1ns" 2025/06/19 06:08:37 INFO : 測試_Русский___ě_áñ測試_Русский___ě_áñ.rclone_chunk.001_3g0ua3: Moved (server-side) to: 測試_Русский___ě_áñ測試_Русский___ě_áñ NFDx2 checkfile vs. both remote (without normalization) 2025/06/19 06:08:38 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found 2025/06/19 06:08:38 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Chunked 'TestChunkerChunk50bYandex:rclone-test-sakazan0fiha' 2025/06/19 06:08:38 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-sakazan0fiha': 1 files missing 2025/06/19 06:08:38 NOTICE: 1 hashes missing 2025/06/19 06:08:38 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-sakazan0fiha': 2 differences found 2025/06/19 06:08:38 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-sakazan0fiha': 2 errors while checking NFDx2 checkfile vs. both remote (with normalization) 2025/06/19 06:08:39 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/06/19 06:08:39 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-sakazan0fiha': 0 differences found 2025/06/19 06:08:39 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-sakazan0fiha': 1 matching files 2025/06/19 06:08:39 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-koluhul7yehe" 2025/06/19 06:08:39 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/06/19 06:08:39 DEBUG : Creating backend with remote "TestYandex:rclone-test-koluhul7yehe" 2025/06/19 06:08:39 DEBUG : Creating backend with remote "/tmp/rclone1235164275" run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-koluhul7yehe'", Local "Local file system at /tmp/rclone1235164275", Modify Window "1ns" 2025/06/19 06:08:44 INFO : 測試_Русский___ě_áñ測試_Русский___ě_áñ.rclone_chunk.001_3g12tu: Moved (server-side) to: 測試_Русский___ě_áñ測試_Русский___ě_áñ NFCx2 checkfile vs. both remote (without normalization) 2025/06/19 06:08:45 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found 2025/06/19 06:08:45 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Chunked 'TestChunkerChunk50bYandex:rclone-test-koluhul7yehe' 2025/06/19 06:08:45 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-koluhul7yehe': 1 files missing 2025/06/19 06:08:45 NOTICE: 1 hashes missing 2025/06/19 06:08:45 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-koluhul7yehe': 2 differences found 2025/06/19 06:08:45 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-koluhul7yehe': 2 errors while checking NFCx2 checkfile vs. both remote (with normalization) 2025/06/19 06:08:46 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/06/19 06:08:46 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-koluhul7yehe': 0 differences found 2025/06/19 06:08:46 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-koluhul7yehe': 1 matching files 2025/06/19 06:08:46 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-bevesef5febu" 2025/06/19 06:08:46 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/06/19 06:08:46 DEBUG : Creating backend with remote "TestYandex:rclone-test-bevesef5febu" 2025/06/19 06:08:46 DEBUG : Creating backend with remote "/tmp/rclone2854356632" run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bevesef5febu'", Local "Local file system at /tmp/rclone2854356632", Modify Window "1ns" 2025/06/19 06:08:51 INFO : 測試_Русский___ě_áñ測試_Русский___ě_áñ.rclone_chunk.001_3g192j: Moved (server-side) to: 測試_Русский___ě_áñ測試_Русский___ě_áñ both checkfile vs. NFDx2 remote (without normalization) 2025/06/19 06:08:52 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found 2025/06/19 06:08:52 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Chunked 'TestChunkerChunk50bYandex:rclone-test-bevesef5febu' 2025/06/19 06:08:52 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-bevesef5febu': 1 files missing 2025/06/19 06:08:52 NOTICE: 1 hashes missing 2025/06/19 06:08:52 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-bevesef5febu': 2 differences found 2025/06/19 06:08:52 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-bevesef5febu': 2 errors while checking both checkfile vs. NFDx2 remote (with normalization) 2025/06/19 06:08:53 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/06/19 06:08:53 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-bevesef5febu': 0 differences found 2025/06/19 06:08:53 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-bevesef5febu': 1 matching files 2025/06/19 06:08:53 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-xiqumol7bata" 2025/06/19 06:08:53 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/06/19 06:08:53 DEBUG : Creating backend with remote "TestYandex:rclone-test-xiqumol7bata" 2025/06/19 06:08:53 DEBUG : Creating backend with remote "/tmp/rclone1638928884" run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-xiqumol7bata'", Local "Local file system at /tmp/rclone1638928884", Modify Window "1ns" 2025/06/19 06:08:59 INFO : 測試_Русский___ě_áñ測試_Русский___ě_áñ.rclone_chunk.001_3g1gdc: Moved (server-side) to: 測試_Русский___ě_áñ測試_Русский___ě_áñ both checkfile vs. NFCx2 remote (without normalization) 2025/06/19 06:08:59 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found 2025/06/19 06:08:59 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Chunked 'TestChunkerChunk50bYandex:rclone-test-xiqumol7bata' 2025/06/19 06:08:59 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-xiqumol7bata': 1 files missing 2025/06/19 06:08:59 NOTICE: 1 hashes missing 2025/06/19 06:08:59 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-xiqumol7bata': 2 differences found 2025/06/19 06:08:59 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-xiqumol7bata': 2 errors while checking both checkfile vs. NFCx2 remote (with normalization) 2025/06/19 06:09:00 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/06/19 06:09:00 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-xiqumol7bata': 0 differences found 2025/06/19 06:09:00 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-xiqumol7bata': 1 matching files 2025/06/19 06:09:00 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-xiqumol7bata': Purge remote 2025/06/19 06:09:08 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-bevesef5febu': Purge remote 2025/06/19 06:09:16 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-koluhul7yehe': Purge remote 2025/06/19 06:09:23 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-sakazan0fiha': Purge remote 2025/06/19 06:09:30 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-bezihes5qusa': Purge remote 2025/06/19 06:09:37 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-tinirin6keso': Purge remote 2025/06/19 06:09:45 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-qupifih8tagu': Purge remote 2025/06/19 06:09:54 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-xusaked0xuva': Purge remote 2025/06/19 06:10:01 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-xenuvak4tope': Purge remote 2025/06/19 06:10:08 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-kosozuy7jeho': Purge remote --- PASS: TestApplyTransforms (148.23s) === RUN TestTruncateString --- PASS: TestTruncateString (0.00s) === RUN TestCopyFile run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:10:17 DEBUG : file1: Need to transfer - File not found at Destination 2025/06/19 06:10:22 INFO : sub/file2.rclone_chunk.001_3g3s7s: Moved (server-side) to: sub/file2 2025/06/19 06:10:22 DEBUG : file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2025/06/19 06:10:22 INFO : file1: Copied (new) to: sub/file2 2025/06/19 06:10:23 DEBUG : file1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:10:23 DEBUG : file1: Unchanged skipping 2025/06/19 06:10:24 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu': don't need to copy/move sub/file2, it is already at target location --- PASS: TestCopyFile (20.29s) === RUN TestCopyLongFile run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" copy_test.go:153: Test only runs on local --- SKIP: TestCopyLongFile (0.50s) === RUN TestCopyFileBackupDir run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:10:42 INFO : dst/file1.rclone_chunk.001_3g4cc2: Moved (server-side) to: dst/file1 2025/06/19 06:10:44 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-jasacux0bonu/backup" 2025/06/19 06:10:44 DEBUG : Creating backend with remote "TestYandex:rclone-test-jasacux0bonu/backup" 2025/06/19 06:10:44 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18) 2025/06/19 06:10:44 DEBUG : dst/file1: move non-chunked object... 2025/06/19 06:10:47 INFO : dst/file1: Moved (server-side) 2025/06/19 06:10:47 INFO : dst/file1: Moved (server-side) 2025/06/19 06:10:47 DEBUG : dst/file1: skip slow MD5 on source file, hashing in-transit 2025/06/19 06:10:53 INFO : dst/file1.rclone_chunk.001_3g4lde: Moved (server-side) to: dst/file1 2025/06/19 06:10:53 DEBUG : dst/file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2025/06/19 06:10:53 INFO : dst/file1: Copied (new) --- PASS: TestCopyFileBackupDir (45.97s) === RUN TestCopyFileCompareDest run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:11:23 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-jasacux0bonu/dst" 2025/06/19 06:11:23 DEBUG : Creating backend with remote "TestYandex:rclone-test-jasacux0bonu/dst" 2025/06/19 06:11:24 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-jasacux0bonu/CompareDest" 2025/06/19 06:11:24 DEBUG : Creating backend with remote "TestYandex:rclone-test-jasacux0bonu/CompareDest" 2025/06/19 06:11:24 DEBUG : one: Need to transfer - File not found at Destination 2025/06/19 06:11:26 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/06/19 06:11:31 INFO : one.rclone_chunk.001_3g5oc1: Moved (server-side) to: one 2025/06/19 06:11:31 DEBUG : one: md5 = f97c5d29941bfb1b2fdab0874906ab82 OK 2025/06/19 06:11:31 INFO : one: Copied (new) 2025/06/19 06:11:33 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/19 06:11:33 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/06/19 06:11:41 INFO : one: Deleted 2025/06/19 06:11:43 INFO : one.rclone_chunk.001_3g5v5h: Moved (server-side) to: one 2025/06/19 06:11:43 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK 2025/06/19 06:11:43 INFO : one: Copied (replaced existing) 2025/06/19 06:11:52 INFO : dst/one: Deleted 2025/06/19 06:11:54 INFO : dst/one.rclone_chunk.001_3g66ps: Moved (server-side) to: dst/one 2025/06/19 06:11:58 INFO : CompareDest/one.rclone_chunk.001_3g6geb: Moved (server-side) to: CompareDest/one 2025/06/19 06:11:59 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/19 06:12:00 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:12:00 DEBUG : one: Destination found in --compare-dest, skipping 2025/06/19 06:12:09 INFO : CompareDest/two.rclone_chunk.001_3g6p2x: Moved (server-side) to: CompareDest/two 2025/06/19 06:12:11 DEBUG : two: Need to transfer - File not found at Destination 2025/06/19 06:12:11 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:12:11 DEBUG : two: Destination found in --compare-dest, skipping 2025/06/19 06:12:13 DEBUG : two: Need to transfer - File not found at Destination 2025/06/19 06:12:14 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:12:14 DEBUG : two: Destination found in --compare-dest, skipping 2025/06/19 06:12:16 DEBUG : two: Need to transfer - File not found at Destination 2025/06/19 06:12:16 DEBUG : two: Sizes differ (src 5 vs dst 3) 2025/06/19 06:12:17 DEBUG : two: skip slow MD5 on source file, hashing in-transit 2025/06/19 06:12:21 INFO : two.rclone_chunk.001_3g73m1: Moved (server-side) to: two 2025/06/19 06:12:21 DEBUG : two: md5 = 2379e4ce8c3380e996ab0509f17069ad OK 2025/06/19 06:12:21 INFO : two: Copied (new) --- PASS: TestCopyFileCompareDest (90.55s) === RUN TestCopyFileCopyDest run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:12:54 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-jasacux0bonu/dst" 2025/06/19 06:12:54 DEBUG : Creating backend with remote "TestYandex:rclone-test-jasacux0bonu/dst" 2025/06/19 06:12:55 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-jasacux0bonu/CopyDest" 2025/06/19 06:12:55 DEBUG : Creating backend with remote "TestYandex:rclone-test-jasacux0bonu/CopyDest" 2025/06/19 06:12:55 DEBUG : one: Need to transfer - File not found at Destination 2025/06/19 06:12:56 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/06/19 06:13:00 INFO : one.rclone_chunk.001_3g86m6: Moved (server-side) to: one 2025/06/19 06:13:00 DEBUG : one: md5 = f97c5d29941bfb1b2fdab0874906ab82 OK 2025/06/19 06:13:00 INFO : one: Copied (new) 2025/06/19 06:13:02 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/19 06:13:02 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/06/19 06:13:10 INFO : one: Deleted 2025/06/19 06:13:12 INFO : one.rclone_chunk.001_3g8c1y: Moved (server-side) to: one 2025/06/19 06:13:12 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK 2025/06/19 06:13:12 INFO : one: Copied (replaced existing) 2025/06/19 06:13:22 INFO : dst/one: Deleted 2025/06/19 06:13:23 INFO : dst/one.rclone_chunk.001_3g8n0w: Moved (server-side) to: dst/one 2025/06/19 06:13:28 INFO : CopyDest/one.rclone_chunk.001_3g8ywj: Moved (server-side) to: CopyDest/one 2025/06/19 06:13:30 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-jasacux0bonu/BackupDir" 2025/06/19 06:13:30 DEBUG : Creating backend with remote "TestYandex:rclone-test-jasacux0bonu/BackupDir" 2025/06/19 06:13:30 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/19 06:13:31 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:13:31 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/06/19 06:13:31 DEBUG : one: move non-chunked object... 2025/06/19 06:13:33 INFO : one: Moved (server-side) 2025/06/19 06:13:33 INFO : one: Moved (server-side) 2025/06/19 06:13:33 DEBUG : one: copy non-chunked object... 2025/06/19 06:13:35 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK 2025/06/19 06:13:35 INFO : one: Copied (server-side copy) 2025/06/19 06:13:35 DEBUG : one: Destination found in --copy-dest, using server-side copy 2025/06/19 06:13:40 INFO : CopyDest/two.rclone_chunk.001_3g9abo: Moved (server-side) to: CopyDest/two 2025/06/19 06:13:41 DEBUG : two: Need to transfer - File not found at Destination 2025/06/19 06:13:42 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:13:42 DEBUG : two: copy non-chunked object... 2025/06/19 06:13:44 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 OK 2025/06/19 06:13:44 INFO : two: Copied (server-side copy) 2025/06/19 06:13:44 DEBUG : two: Destination found in --copy-dest, using server-side copy 2025/06/19 06:13:45 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:13:45 DEBUG : two: Unchanged skipping 2025/06/19 06:13:51 INFO : CopyDest/three.rclone_chunk.001_3g9kj0: Moved (server-side) to: CopyDest/three 2025/06/19 06:13:52 DEBUG : three: Need to transfer - File not found at Destination 2025/06/19 06:13:53 DEBUG : three: Sizes differ (src 7 vs dst 5) 2025/06/19 06:13:53 DEBUG : three: Destination not found in --copy-dest 2025/06/19 06:13:53 DEBUG : three: skip slow MD5 on source file, hashing in-transit 2025/06/19 06:13:58 INFO : three.rclone_chunk.001_3g9rkc: Moved (server-side) to: three 2025/06/19 06:13:58 DEBUG : three: md5 = 1bccb9dccb3e9f6a3f9d2a8bdb54b7f5 OK 2025/06/19 06:13:58 INFO : three: Copied (new) --- PASS: TestCopyFileCopyDest (120.17s) === RUN TestCopyInplace run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" copy_test.go:370: Partial uploads not supported --- SKIP: TestCopyInplace (0.55s) === RUN TestCopyLongFileName run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" copy_test.go:403: Partial uploads not supported --- SKIP: TestCopyLongFileName (0.67s) === RUN TestCopyFileMaxTransfer run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:14:56 DEBUG : TestCopyFileMaxTransfer/file1: Need to transfer - File not found at Destination 2025/06/19 06:14:56 DEBUG : TestCopyFileMaxTransfer/file1: skip slow MD5 on source file, hashing in-transit 2025/06/19 06:15:01 INFO : TestCopyFileMaxTransfer/file1.rclone_chunk.001_3gbi6d: Moved (server-side) to: TestCopyFileMaxTransfer/file1 2025/06/19 06:15:01 DEBUG : TestCopyFileMaxTransfer/file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2025/06/19 06:15:01 INFO : TestCopyFileMaxTransfer/file1: Copied (new) 2025/06/19 06:15:02 DEBUG : TestCopyFileMaxTransfer/file2: Need to transfer - File not found at Destination 2025/06/19 06:15:02 DEBUG : TestCopyFileMaxTransfer/file2: skip slow MD5 on source file, hashing in-transit 2025/06/19 06:19:37 ERROR : TestCopyFileMaxTransfer/file2: Failed to copy: Put "https://uploader62vla.disk.yandex.net:443/upload-target/20250619T091622.260.utd.es041acg6jqjf9h81ygi1gtqs-k62vla.1467001": max transfer limit reached as set by --max-transfer 2025/06/19 06:19:38 DEBUG : TestCopyFileMaxTransfer/file3: Need to transfer - File not found at Destination copy_test.go:494: skipping remainder of test for chunker as it involves multiple transfers --- PASS: TestCopyFileMaxTransfer (294.82s) === RUN TestDeduplicateInteractive run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateInteractive (0.70s) === RUN TestDeduplicateSkip run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateSkip (0.57s) === RUN TestDeduplicateSizeOnly run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateSizeOnly (0.75s) === RUN TestDeduplicateFirst run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateFirst (0.56s) === RUN TestDeduplicateNewest run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateNewest (0.67s) === RUN TestDeduplicateNewestByHash run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:20:00 INFO : one.rclone_chunk.001_3gjsu3: Moved (server-side) to: one.rclone_chunk.001 2025/06/19 06:20:01 INFO : one.rclone_chunk.002_3gjsu3: Moved (server-side) to: one.rclone_chunk.002 2025/06/19 06:20:11 INFO : also/one.rclone_chunk.001_3gk3o1: Moved (server-side) to: also/one.rclone_chunk.001 2025/06/19 06:20:14 INFO : also/one.rclone_chunk.002_3gk3o1: Moved (server-side) to: also/one.rclone_chunk.002 2025/06/19 06:20:23 INFO : another.rclone_chunk.001_3gkeqc: Moved (server-side) to: another.rclone_chunk.001 2025/06/19 06:20:25 INFO : another.rclone_chunk.002_3gkeqc: Moved (server-side) to: another.rclone_chunk.002 2025/06/19 06:20:33 INFO : not-one.rclone_chunk.001_3gkrwf: Moved (server-side) to: not-one 2025/06/19 06:20:36 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu': Looking for duplicate md5 hashes using newest mode. 2025/06/19 06:20:38 NOTICE: 5aac3f3afe9714ced96c15cfea24b166: Found 3 files with duplicate md5 hashes 2025/06/19 06:20:52 INFO : one: Deleted 2025/06/19 06:21:08 INFO : also/one: Deleted 2025/06/19 06:21:08 NOTICE: 5aac3f3afe9714ced96c15cfea24b166: Deleted 2 extra copies --- PASS: TestDeduplicateNewestByHash (102.65s) === RUN TestDeduplicateOldest run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateOldest (0.73s) === RUN TestDeduplicateLargest run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateLargest (0.79s) === RUN TestDeduplicateSmallest run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateSmallest (0.79s) === RUN TestDeduplicateRename run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateRename (0.96s) === RUN TestMergeDirs run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" dedupe_test.go:256: Can't merge directories --- SKIP: TestMergeDirs (0.71s) === RUN TestListDirSorted run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:21:46 INFO : a.txt.rclone_chunk.001_3gmqqg: Moved (server-side) to: a.txt 2025/06/19 06:21:52 INFO : zend.txt.rclone_chunk.001_3gmwyu: Moved (server-side) to: zend.txt 2025/06/19 06:21:57 INFO : sub dir/hello world.rclone_chunk.001_3gn256: Moved (server-side) to: sub dir/hello world 2025/06/19 06:22:03 INFO : sub dir/hello world2.rclone_chunk.001_3gn8ut: Moved (server-side) to: sub dir/hello world2 2025/06/19 06:22:09 INFO : sub dir/ignore dir/.ignore.rclone_chunk.001_3gnd2q: Moved (server-side) to: sub dir/ignore dir/.ignore 2025/06/19 06:22:14 INFO : sub dir/ignore dir/should be ignored.rclone_chunk.001_3gnk46: Moved (server-side) to: sub dir/ignore dir/should be ignored 2025/06/19 06:22:19 INFO : sub dir/sub sub dir/hello world3.rclone_chunk.001_3gnppw: Moved (server-side) to: sub dir/sub sub dir/hello world3 2025/06/19 06:22:21 DEBUG : a.txt: Excluded (Size Filter) 2025/06/19 06:22:21 DEBUG : a.txt: Excluded 2025/06/19 06:22:21 DEBUG : sub dir/hello world: Excluded (Size Filter) 2025/06/19 06:22:21 DEBUG : sub dir/hello world: Excluded 2025/06/19 06:22:21 DEBUG : sub dir/hello world2: Excluded (Size Filter) 2025/06/19 06:22:21 DEBUG : sub dir/hello world2: Excluded 2025/06/19 06:22:22 DEBUG : sub dir/hello world: Excluded (Size Filter) 2025/06/19 06:22:22 DEBUG : sub dir/hello world: Excluded 2025/06/19 06:22:22 DEBUG : sub dir/hello world2: Excluded (Size Filter) 2025/06/19 06:22:22 DEBUG : sub dir/hello world2: Excluded 2025/06/19 06:22:23 DEBUG : sub dir/ignore dir: Excluded 2025/06/19 06:22:25 DEBUG : sub dir/ignore dir: Excluded --- PASS: TestListDirSorted (97.53s) === RUN TestListDirSortedFn run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:23:23 INFO : a.txt.rclone_chunk.001_3gpget: Moved (server-side) to: a.txt 2025/06/19 06:23:27 INFO : zend.txt.rclone_chunk.001_3gplpp: Moved (server-side) to: zend.txt 2025/06/19 06:23:33 INFO : sub dir/hello world.rclone_chunk.001_3gpq3v: Moved (server-side) to: sub dir/hello world 2025/06/19 06:23:38 INFO : sub dir/hello world2.rclone_chunk.001_3gpvny: Moved (server-side) to: sub dir/hello world2 2025/06/19 06:23:42 INFO : sub dir/ignore dir/.ignore.rclone_chunk.001_3gq0yy: Moved (server-side) to: sub dir/ignore dir/.ignore 2025/06/19 06:23:47 INFO : sub dir/ignore dir/should be ignored.rclone_chunk.001_3gq4d3: Moved (server-side) to: sub dir/ignore dir/should be ignored 2025/06/19 06:23:52 INFO : sub dir/sub sub dir/hello world3.rclone_chunk.001_3gqaye: Moved (server-side) to: sub dir/sub sub dir/hello world3 2025/06/19 06:23:54 DEBUG : a.txt: Excluded (Size Filter) 2025/06/19 06:23:54 DEBUG : a.txt: Excluded 2025/06/19 06:23:54 DEBUG : sub dir/hello world: Excluded (Size Filter) 2025/06/19 06:23:54 DEBUG : sub dir/hello world: Excluded 2025/06/19 06:23:54 DEBUG : sub dir/hello world2: Excluded (Size Filter) 2025/06/19 06:23:54 DEBUG : sub dir/hello world2: Excluded 2025/06/19 06:23:55 DEBUG : sub dir/hello world: Excluded (Size Filter) 2025/06/19 06:23:55 DEBUG : sub dir/hello world: Excluded 2025/06/19 06:23:55 DEBUG : sub dir/hello world2: Excluded (Size Filter) 2025/06/19 06:23:55 DEBUG : sub dir/hello world2: Excluded 2025/06/19 06:23:55 DEBUG : sub dir/ignore dir: Excluded 2025/06/19 06:23:56 DEBUG : sub dir/ignore dir: Excluded --- PASS: TestListDirSortedFn (100.24s) === RUN TestListJSON run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:25:04 INFO : file1.rclone_chunk.001_3gs8sq: Moved (server-side) to: file1 2025/06/19 06:25:09 INFO : sub/file2.rclone_chunk.001_3gsejt: Moved (server-side) to: sub/file2 === RUN TestListJSON/Default === RUN TestListJSON/FilesOnly === RUN TestListJSON/DirsOnly === RUN TestListJSON/Recurse === RUN TestListJSON/SubDir === RUN TestListJSON/NoModTime === RUN TestListJSON/NoMimeType === RUN TestListJSON/ShowHash === RUN TestListJSON/HashTypes === RUN TestListJSON/Metadata --- PASS: TestListJSON (31.21s) --- PASS: TestListJSON/Default (0.38s) --- PASS: TestListJSON/FilesOnly (0.22s) --- PASS: TestListJSON/DirsOnly (0.22s) --- PASS: TestListJSON/Recurse (0.89s) --- PASS: TestListJSON/SubDir (0.27s) --- PASS: TestListJSON/NoModTime (0.25s) --- PASS: TestListJSON/NoMimeType (0.70s) --- PASS: TestListJSON/ShowHash (0.37s) --- PASS: TestListJSON/HashTypes (0.32s) --- PASS: TestListJSON/Metadata (0.27s) === RUN TestStatJSON run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:25:34 INFO : file1.rclone_chunk.001_3gt3fd: Moved (server-side) to: file1 2025/06/19 06:25:39 INFO : sub/file2.rclone_chunk.001_3gt8w0: Moved (server-side) to: sub/file2 === RUN TestStatJSON/Root === RUN TestStatJSON/RootFilesOnly === RUN TestStatJSON/RootDirsOnly === RUN TestStatJSON/Dir === RUN TestStatJSON/DirWithTrailingSlash === RUN TestStatJSON/File === RUN TestStatJSON/NotFound === RUN TestStatJSON/DirFilesOnly === RUN TestStatJSON/FileFilesOnly === RUN TestStatJSON/NotFoundFilesOnly === RUN TestStatJSON/DirDirsOnly === RUN TestStatJSON/FileDirsOnly === RUN TestStatJSON/NotFoundDirsOnly === RUN TestStatJSON/RootNotFound 2025/06/19 06:25:46 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-jasacux0bonu/notfound" 2025/06/19 06:25:46 DEBUG : Creating backend with remote "TestYandex:rclone-test-jasacux0bonu/notfound" --- PASS: TestStatJSON (33.73s) --- PASS: TestStatJSON/Root (0.29s) --- PASS: TestStatJSON/RootFilesOnly (0.00s) --- PASS: TestStatJSON/RootDirsOnly (0.24s) --- PASS: TestStatJSON/Dir (0.55s) --- PASS: TestStatJSON/DirWithTrailingSlash (0.41s) --- PASS: TestStatJSON/File (0.51s) --- PASS: TestStatJSON/NotFound (0.77s) --- PASS: TestStatJSON/DirFilesOnly (0.68s) --- PASS: TestStatJSON/FileFilesOnly (0.58s) --- PASS: TestStatJSON/NotFoundFilesOnly (0.44s) --- PASS: TestStatJSON/DirDirsOnly (0.57s) --- PASS: TestStatJSON/FileDirsOnly (0.32s) --- PASS: TestStatJSON/NotFoundDirsOnly (0.23s) --- PASS: TestStatJSON/RootNotFound (0.72s) === RUN TestMkdir run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:26:03 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu': Making directory 2025/06/19 06:26:03 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu': Making directory --- PASS: TestMkdir (1.80s) === RUN TestLsd run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:26:10 INFO : sub dir/hello world.rclone_chunk.001_3gu382: Moved (server-side) to: sub dir/hello world --- PASS: TestLsd (17.90s) === RUN TestLs run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:26:30 INFO : potato2.rclone_chunk.001_3gul2r: Moved (server-side) to: potato2.rclone_chunk.001 2025/06/19 06:26:32 INFO : potato2.rclone_chunk.002_3gul2r: Moved (server-side) to: potato2.rclone_chunk.002 2025/06/19 06:26:41 INFO : empty space.rclone_chunk.001_3guwyn: Moved (server-side) to: empty space --- PASS: TestLs (40.10s) === RUN TestLsWithFilesFrom run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:27:10 INFO : potato2.rclone_chunk.001_3gvp7g: Moved (server-side) to: potato2.rclone_chunk.001 2025/06/19 06:27:12 INFO : potato2.rclone_chunk.002_3gvp7g: Moved (server-side) to: potato2.rclone_chunk.002 2025/06/19 06:27:19 INFO : empty space.rclone_chunk.001_3gw078: Moved (server-side) to: empty space 2025/06/19 06:27:20 DEBUG : empty space: Excluded (FilesFrom Filter) 2025/06/19 06:27:20 DEBUG : empty space: Excluded --- PASS: TestLsWithFilesFrom (38.24s) === RUN TestLsLong run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:27:48 INFO : potato2.rclone_chunk.001_3gwr3n: Moved (server-side) to: potato2.rclone_chunk.001 2025/06/19 06:27:50 INFO : potato2.rclone_chunk.002_3gwr3n: Moved (server-side) to: potato2.rclone_chunk.002 2025/06/19 06:27:57 INFO : empty space.rclone_chunk.001_3gx3kl: Moved (server-side) to: empty space --- PASS: TestLsLong (37.41s) === RUN TestHashSums run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:28:25 INFO : potato2.rclone_chunk.001_3gxtme: Moved (server-side) to: potato2.rclone_chunk.001 2025/06/19 06:28:26 INFO : potato2.rclone_chunk.002_3gxtme: Moved (server-side) to: potato2.rclone_chunk.002 2025/06/19 06:28:33 INFO : empty space.rclone_chunk.001_3gy3dz: Moved (server-side) to: empty space === RUN TestHashSums/Md5 === RUN TestHashSums/Md5Download --- PASS: TestHashSums (42.82s) --- PASS: TestHashSums/Md5 (0.71s) --- PASS: TestHashSums/Md5Download (1.85s) === RUN TestHashSumsWithErrors 2025/06/19 06:29:01 DEBUG : Creating backend with remote ":memory:" 2025/06/19 06:29:01 ERROR : file1: hash unsupported: hash type not supported --- PASS: TestHashSumsWithErrors (0.00s) === RUN TestHashStream 2025/06/19 06:29:01 DEBUG : Creating md5 hash of 0 bytes read from input stream 2025/06/19 06:29:01 DEBUG : Creating md5 hash of 0 bytes read from input stream 2025/06/19 06:29:01 DEBUG : Creating sha1 hash of 0 bytes read from input stream 2025/06/19 06:29:01 DEBUG : Creating sha1 hash of 0 bytes read from input stream 2025/06/19 06:29:01 DEBUG : Creating md5 hash of 12 bytes read from input stream 2025/06/19 06:29:01 DEBUG : Creating md5 hash of 12 bytes read from input stream 2025/06/19 06:29:01 DEBUG : Creating sha1 hash of 12 bytes read from input stream 2025/06/19 06:29:01 DEBUG : Creating sha1 hash of 12 bytes read from input stream --- PASS: TestHashStream (0.00s) === RUN TestSuffixName --- PASS: TestSuffixName (0.00s) === RUN TestCount run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:29:08 INFO : potato2.rclone_chunk.001_3gz0np: Moved (server-side) to: potato2.rclone_chunk.001 2025/06/19 06:29:09 INFO : potato2.rclone_chunk.002_3gz0np: Moved (server-side) to: potato2.rclone_chunk.002 2025/06/19 06:29:18 INFO : empty space.rclone_chunk.001_3gzbke: Moved (server-side) to: empty space 2025/06/19 06:29:23 INFO : sub dir/potato3.rclone_chunk.001_3gzg9z: Moved (server-side) to: sub dir/potato3 --- PASS: TestCount (55.72s) === RUN TestDelete run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:30:05 INFO : small.rclone_chunk.001_3h0jr4: Moved (server-side) to: small 2025/06/19 06:30:12 INFO : medium.rclone_chunk.001_3h0rjq: Moved (server-side) to: medium.rclone_chunk.001 2025/06/19 06:30:14 INFO : medium.rclone_chunk.002_3h0rjq: Moved (server-side) to: medium.rclone_chunk.002 2025/06/19 06:30:23 INFO : large.rclone_chunk.001_3h13na: Moved (server-side) to: large.rclone_chunk.001 2025/06/19 06:30:25 INFO : large.rclone_chunk.002_3h13na: Moved (server-side) to: large.rclone_chunk.002 2025/06/19 06:30:28 DEBUG : Waiting for deletions to finish 2025/06/19 06:30:28 DEBUG : large: Excluded (Size Filter) 2025/06/19 06:30:28 DEBUG : large: Excluded 2025/06/19 06:30:33 INFO : small: Deleted 2025/06/19 06:30:44 INFO : medium: Deleted --- PASS: TestDelete (63.79s) === RUN TestMaxDelete run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" operations_test.go:432: Skipping test on chunker backend --- SKIP: TestMaxDelete (1.61s) === RUN TestMaxDeleteSizeLargeFile run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" operations_test.go:432: Skipping test on chunker backend --- SKIP: TestMaxDeleteSizeLargeFile (1.64s) === RUN TestMaxDeleteSize run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" operations_test.go:432: Skipping test on chunker backend --- SKIP: TestMaxDeleteSize (1.54s) === RUN TestReadFile run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:31:11 INFO : ReadFile.rclone_chunk.001_3h2g5e: Moved (server-side) to: ReadFile fstest.go:124: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:124 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:129 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:148 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:192 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:335 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:347 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:502 Error: Should be true Test: TestReadFile Messages: ReadFile: Modification time difference too big |-213650h26m4.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2025-06-19 06:31:11 +0000 UTC) (precision 1ns) --- FAIL: TestReadFile (14.76s) === RUN TestRetry 2025/06/19 06:31:20 DEBUG : Received error: Wrapped EOF is retriable: EOF - low level retry 1/5 2025/06/19 06:31:20 DEBUG : Received error: Wrapped EOF is retriable: EOF - low level retry 2/5 2025/06/19 06:31:20 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG 2025/06/19 06:31:20 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG 2025/06/19 06:31:20 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG 2025/06/19 06:31:20 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG 2025/06/19 06:31:20 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG --- PASS: TestRetry (0.05s) === RUN TestCat run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:31:26 INFO : file1.rclone_chunk.001_3h2v6x: Moved (server-side) to: file1 2025/06/19 06:31:31 INFO : file2.rclone_chunk.001_3h31i6: Moved (server-side) to: file2 --- PASS: TestCat (28.09s) === RUN TestPurge 2025/06/19 06:31:48 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-sivexoz5wide" 2025/06/19 06:31:48 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/06/19 06:31:48 DEBUG : Creating backend with remote "TestYandex:rclone-test-sivexoz5wide" 2025/06/19 06:31:49 DEBUG : Creating backend with remote "/tmp/rclone2732845218" run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-sivexoz5wide'", Local "Local file system at /tmp/rclone2732845218", Modify Window "1ns" 2025/06/19 06:31:55 INFO : A1/B1/C1/one.rclone_chunk.001_3h3oij: Moved (server-side) to: A1/B1/C1/one 2025/06/19 06:31:55 INFO : A2: Making directory 2025/06/19 06:31:56 INFO : A1/B2: Making directory 2025/06/19 06:31:56 INFO : A1/B2/C2: Making directory 2025/06/19 06:31:56 INFO : A1/B1/C3: Making directory 2025/06/19 06:31:57 INFO : A3: Making directory 2025/06/19 06:31:57 INFO : A3/B3: Making directory 2025/06/19 06:31:58 INFO : A3/B3/C4: Making directory 2025/06/19 06:32:03 INFO : A1/two.rclone_chunk.001_3h3x9b: Moved (server-side) to: A1/two 2025/06/19 06:32:29 ERROR : error listing: directory not found 2025/06/19 06:32:29 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-sivexoz5wide': Purge remote 2025/06/19 06:32:29 NOTICE: purge failed: [404 - DiskNotFoundError] Resource not found. (Не удалось найти запрошенный ресурс.) --- PASS: TestPurge (41.10s) === RUN TestRmdirsNoLeaveRoot run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:32:36 INFO : A1/B1/C1/one.rclone_chunk.001_3h4sf6: Moved (server-side) to: A1/B1/C1/one 2025/06/19 06:32:36 INFO : A2: Making directory 2025/06/19 06:32:37 INFO : A1/B2: Making directory 2025/06/19 06:32:37 INFO : A1/B2/C2: Making directory 2025/06/19 06:32:38 INFO : A1/B1/C3: Making directory 2025/06/19 06:32:38 INFO : A3: Making directory 2025/06/19 06:32:38 INFO : A3/B3: Making directory 2025/06/19 06:32:39 INFO : A3/B3/C4: Making directory 2025/06/19 06:32:45 INFO : A1/two.rclone_chunk.001_3h51br: Moved (server-side) to: A1/two 2025/06/19 06:32:47 DEBUG : removing 1 level 3 directories 2025/06/19 06:32:47 INFO : A3/B3/C4: Removing directory 2025/06/19 06:32:56 DEBUG : removing 2 level 3 directories 2025/06/19 06:32:56 INFO : A1/B2/C2: Removing directory 2025/06/19 06:32:56 INFO : A1/B1/C3: Removing directory 2025/06/19 06:33:02 DEBUG : removing 2 level 2 directories 2025/06/19 06:33:02 INFO : A3/B3: Removing directory 2025/06/19 06:33:02 INFO : A1/B2: Removing directory 2025/06/19 06:33:07 DEBUG : removing 2 level 1 directories 2025/06/19 06:33:07 INFO : A3: Removing directory 2025/06/19 06:33:07 INFO : A2: Removing directory 2025/06/19 06:33:27 DEBUG : removing 1 level 3 directories 2025/06/19 06:33:27 INFO : A1/B1/C1: Removing directory 2025/06/19 06:33:33 DEBUG : removing 1 level 2 directories 2025/06/19 06:33:33 INFO : A1/B1: Removing directory 2025/06/19 06:33:39 DEBUG : removing 1 level 1 directories 2025/06/19 06:33:39 INFO : A1: Removing directory 2025/06/19 06:33:45 DEBUG : removing 1 level 0 directories 2025/06/19 06:33:45 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu': Removing directory 2025/06/19 06:33:51 ERROR : error listing: directory not found 2025/06/19 06:33:52 ERROR : error listing: directory not found --- PASS: TestRmdirsNoLeaveRoot (82.14s) === RUN TestRmdirsLeaveRoot run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:33:52 INFO : A1: Making directory 2025/06/19 06:33:52 INFO : A1/B1: Making directory 2025/06/19 06:33:53 INFO : A1/B1/C1: Making directory 2025/06/19 06:33:56 DEBUG : removing 1 level 3 directories 2025/06/19 06:33:56 INFO : A1/B1/C1: Removing directory 2025/06/19 06:34:02 DEBUG : removing 1 level 2 directories 2025/06/19 06:34:02 INFO : A1/B1: Removing directory --- PASS: TestRmdirsLeaveRoot (23.64s) === RUN TestRmdirsWithFilter run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:34:15 INFO : A1: Making directory 2025/06/19 06:34:16 INFO : A1/B1: Making directory 2025/06/19 06:34:16 INFO : A1/B1/C1: Making directory 2025/06/19 06:34:19 DEBUG : removing 1 level 3 directories 2025/06/19 06:34:19 INFO : A1/B1/C1: Removing directory 2025/06/19 06:34:25 DEBUG : removing 1 level 2 directories 2025/06/19 06:34:25 INFO : A1/B1: Removing directory --- PASS: TestRmdirsWithFilter (23.43s) === RUN TestCopyURL run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:34:44 INFO : file1.rclone_chunk.001_3h8dv1: Moved (server-side) to: file1 2025/06/19 06:34:45 DEBUG : filename.txt: File name found in url 2025/06/19 06:34:47 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2025/06/19 06:34:47 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/06/19 06:34:48 DEBUG : pacer: Reducing sleep to 15ms 2025/06/19 06:34:48 DEBUG : pacer: Reducing sleep to 11.25ms 2025/06/19 06:34:49 DEBUG : pacer: Reducing sleep to 10ms 2025/06/19 06:34:50 INFO : filename.txt.rclone_chunk.001_3h8jxw: Moved (server-side) to: filename.txt 2025/06/19 06:34:50 DEBUG : headerfilename.txt: filename found in Content-Disposition header. 2025/06/19 06:34:55 INFO : headerfilename.txt.rclone_chunk.001_3h8pye: Moved (server-side) to: headerfilename.txt 2025/06/19 06:35:01 INFO : file2.rclone_chunk.001_3h8u4k: Moved (server-side) to: file2 --- PASS: TestCopyURL (43.08s) === RUN TestCopyURLToWriter --- PASS: TestCopyURLToWriter (0.00s) === RUN TestMoveFile run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:35:22 DEBUG : file1: Need to transfer - File not found at Destination 2025/06/19 06:35:27 INFO : sub/file2.rclone_chunk.001_3h9keg: Moved (server-side) to: sub/file2 2025/06/19 06:35:27 DEBUG : file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2025/06/19 06:35:27 INFO : file1: Copied (new) to: sub/file2 2025/06/19 06:35:27 INFO : file1: Deleted 2025/06/19 06:35:28 DEBUG : file1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:35:28 DEBUG : file1: Unchanged skipping 2025/06/19 06:35:28 INFO : file1: Deleted 2025/06/19 06:35:29 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu': don't need to copy/move sub/file2, it is already at target location --- PASS: TestMoveFile (20.61s) === RUN TestMoveFileWithIgnoreExisting run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:35:43 DEBUG : file1: Need to transfer - File not found at Destination 2025/06/19 06:35:43 DEBUG : file1: skip slow MD5 on source file, hashing in-transit 2025/06/19 06:35:47 INFO : file1.rclone_chunk.001_3ha5s2: Moved (server-side) to: file1 2025/06/19 06:35:47 DEBUG : file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2025/06/19 06:35:47 INFO : file1: Copied (new) 2025/06/19 06:35:47 INFO : file1: Deleted 2025/06/19 06:35:48 DEBUG : file1: Destination exists, skipping 2025/06/19 06:35:48 DEBUG : file1: Not removing source file as destination file exists and --ignore-existing is set --- PASS: TestMoveFileWithIgnoreExisting (11.54s) === RUN TestCaseInsensitiveMoveFile run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" --- PASS: TestCaseInsensitiveMoveFile (0.67s) === RUN TestCaseInsensitiveMoveFileDryRun run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" --- PASS: TestCaseInsensitiveMoveFileDryRun (0.71s) === RUN TestMoveFileBackupDir run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:36:01 INFO : dst/file1.rclone_chunk.001_3haije: Moved (server-side) to: dst/file1 2025/06/19 06:36:02 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-jasacux0bonu/backup" 2025/06/19 06:36:02 DEBUG : Creating backend with remote "TestYandex:rclone-test-jasacux0bonu/backup" 2025/06/19 06:36:03 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18) 2025/06/19 06:36:03 DEBUG : dst/file1: move non-chunked object... 2025/06/19 06:36:06 INFO : dst/file1: Moved (server-side) 2025/06/19 06:36:06 INFO : dst/file1: Moved (server-side) 2025/06/19 06:36:06 DEBUG : dst/file1: skip slow MD5 on source file, hashing in-transit 2025/06/19 06:36:12 INFO : dst/file1.rclone_chunk.001_3haso2: Moved (server-side) to: dst/file1 2025/06/19 06:36:12 DEBUG : dst/file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2025/06/19 06:36:12 INFO : dst/file1: Copied (new) 2025/06/19 06:36:12 INFO : dst/file1: Deleted --- PASS: TestMoveFileBackupDir (44.91s) === RUN TestSameConfig --- PASS: TestSameConfig (0.00s) === RUN TestSame --- PASS: TestSame (0.00s) === RUN TestOverlappingFilterCheckWithoutFilter --- PASS: TestOverlappingFilterCheckWithoutFilter (0.00s) === RUN TestOverlappingFilterCheckWithFilter --- PASS: TestOverlappingFilterCheckWithFilter (0.00s) === RUN TestListFormat --- PASS: TestListFormat (0.00s) === RUN TestDirMove run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:36:45 INFO : A1/one.rclone_chunk.001_3hbr0m: Moved (server-side) to: A1/one 2025/06/19 06:36:50 INFO : A1/two.rclone_chunk.001_3hbv5e: Moved (server-side) to: A1/two 2025/06/19 06:36:55 INFO : A1/B1/three.rclone_chunk.001_3hc132: Moved (server-side) to: A1/B1/three 2025/06/19 06:37:01 INFO : A1/B1/C1/four.rclone_chunk.001_3hc5b2: Moved (server-side) to: A1/B1/C1/four 2025/06/19 06:37:07 INFO : A1/B1/C2/five.rclone_chunk.001_3hcbj4: Moved (server-side) to: A1/B1/C2/five 2025/06/19 06:37:07 INFO : A1/B2: Making directory 2025/06/19 06:37:08 INFO : A1/B1/C3: Making directory 2025/06/19 06:37:21 DEBUG : A2/one: move non-chunked object... 2025/06/19 06:37:21 DEBUG : A2/B1/C1/four: move non-chunked object... 2025/06/19 06:37:21 DEBUG : A2/B1/C2/five: move non-chunked object... 2025/06/19 06:37:21 DEBUG : A2/two: move non-chunked object... 2025/06/19 06:37:21 DEBUG : A2/B1/three: move non-chunked object... 2025/06/19 06:37:23 INFO : A2/one: Moved (server-side) to: A3/one 2025/06/19 06:37:23 INFO : A2/one: Moved (server-side) to: A3/one 2025/06/19 06:37:23 INFO : A2/B1/C2/five: Moved (server-side) to: A3/B1/C2/five 2025/06/19 06:37:23 INFO : A2/B1/C2/five: Moved (server-side) to: A3/B1/C2/five 2025/06/19 06:37:23 INFO : A2/B1/three: Moved (server-side) to: A3/B1/three 2025/06/19 06:37:23 INFO : A2/B1/three: Moved (server-side) to: A3/B1/three 2025/06/19 06:37:24 INFO : A2/two: Moved (server-side) to: A3/two 2025/06/19 06:37:24 INFO : A2/two: Moved (server-side) to: A3/two 2025/06/19 06:37:25 INFO : A2/B1/C1/four: Moved (server-side) to: A3/B1/C1/four 2025/06/19 06:37:25 INFO : A2/B1/C1/four: Moved (server-side) to: A3/B1/C1/four 2025/06/19 06:38:03 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu': Can't DirMove - falling back to file moves: can't move directory - incompatible remotes 2025/06/19 06:38:07 DEBUG : A3/B1/C1/four: move non-chunked object... 2025/06/19 06:38:07 DEBUG : A3/one: move non-chunked object... 2025/06/19 06:38:07 DEBUG : A3/B1/three: move non-chunked object... 2025/06/19 06:38:07 DEBUG : A3/B1/C2/five: move non-chunked object... 2025/06/19 06:38:07 DEBUG : A3/two: move non-chunked object... 2025/06/19 06:38:08 INFO : A3/two: Moved (server-side) to: A4/two 2025/06/19 06:38:08 INFO : A3/two: Moved (server-side) to: A4/two 2025/06/19 06:38:08 INFO : A3/B1/C2/five: Moved (server-side) to: A4/B1/C2/five 2025/06/19 06:38:08 INFO : A3/B1/C2/five: Moved (server-side) to: A4/B1/C2/five 2025/06/19 06:38:08 INFO : A3/one: Moved (server-side) to: A4/one 2025/06/19 06:38:08 INFO : A3/one: Moved (server-side) to: A4/one 2025/06/19 06:38:08 INFO : A3/B1/three: Moved (server-side) to: A4/B1/three 2025/06/19 06:38:08 INFO : A3/B1/three: Moved (server-side) to: A4/B1/three 2025/06/19 06:38:09 INFO : A3/B1/C1/four: Moved (server-side) to: A4/B1/C1/four 2025/06/19 06:38:09 INFO : A3/B1/C1/four: Moved (server-side) to: A4/B1/C1/four --- PASS: TestDirMove (186.05s) === RUN TestGetFsInfo run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" --- PASS: TestGetFsInfo (0.52s) === RUN TestRcat === RUN TestRcat/withChecksum=false,ignoreChecksum=false run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" operations_test.go:1495: Adjust StreamingUploadCutoff to size limit 1Ki (was 100Ki) 2025/06/19 06:39:47 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu': File to upload is small (34 bytes), uploading instead of streaming 2025/06/19 06:39:52 INFO : no_checksum_small_file_from_pipe.rclone_chunk.001_3hgy4k: Moved (server-side) to: no_checksum_small_file_from_pipe 2025/06/19 06:39:52 DEBUG : no_checksum_small_file_from_pipe: md5 = 4c762bc6ec18f21b23fcae426c7863b5 OK 2025/06/19 06:39:52 DEBUG : no_checksum_small_file_from_pipe: Size and md5 of src and dst objects identical 2025/06/19 06:40:47 INFO : no_checksum_big_file_from_pipe.rclone_chunk.001_3hh2nz: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.001 2025/06/19 06:40:49 INFO : no_checksum_big_file_from_pipe.rclone_chunk.002_3hh2nz: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.002 2025/06/19 06:40:50 INFO : no_checksum_big_file_from_pipe.rclone_chunk.003_3hh2nz: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.003 2025/06/19 06:40:52 INFO : no_checksum_big_file_from_pipe.rclone_chunk.004_3hh2nz: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.004 2025/06/19 06:40:53 INFO : no_checksum_big_file_from_pipe.rclone_chunk.005_3hh2nz: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.005 2025/06/19 06:40:55 INFO : no_checksum_big_file_from_pipe.rclone_chunk.006_3hh2nz: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.006 2025/06/19 06:40:57 INFO : no_checksum_big_file_from_pipe.rclone_chunk.007_3hh2nz: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.007 2025/06/19 06:41:00 INFO : no_checksum_big_file_from_pipe.rclone_chunk.008_3hh2nz: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.008 2025/06/19 06:41:02 INFO : no_checksum_big_file_from_pipe.rclone_chunk.009_3hh2nz: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.009 2025/06/19 06:41:03 INFO : no_checksum_big_file_from_pipe.rclone_chunk.010_3hh2nz: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.010 2025/06/19 06:41:05 INFO : no_checksum_big_file_from_pipe.rclone_chunk.011_3hh2nz: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.011 2025/06/19 06:41:06 INFO : no_checksum_big_file_from_pipe.rclone_chunk.012_3hh2nz: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.012 2025/06/19 06:41:08 INFO : no_checksum_big_file_from_pipe.rclone_chunk.013_3hh2nz: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.013 2025/06/19 06:41:09 INFO : no_checksum_big_file_from_pipe.rclone_chunk.014_3hh2nz: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.014 2025/06/19 06:41:11 INFO : no_checksum_big_file_from_pipe.rclone_chunk.015_3hh2nz: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.015 2025/06/19 06:41:12 INFO : no_checksum_big_file_from_pipe.rclone_chunk.016_3hh2nz: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.016 2025/06/19 06:41:13 INFO : no_checksum_big_file_from_pipe.rclone_chunk.017_3hh2nz: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.017 2025/06/19 06:41:15 INFO : no_checksum_big_file_from_pipe.rclone_chunk.018_3hh2nz: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.018 2025/06/19 06:41:17 INFO : no_checksum_big_file_from_pipe.rclone_chunk.019_3hh2nz: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.019 2025/06/19 06:41:18 INFO : no_checksum_big_file_from_pipe.rclone_chunk.020_3hh2nz: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.020 2025/06/19 06:41:20 INFO : no_checksum_big_file_from_pipe.rclone_chunk.021_3hh2nz: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.021 2025/06/19 06:41:23 DEBUG : no_checksum_big_file_from_pipe: md5 = 0ad4cf7b35f62b8ff9c73f481594fbdd OK 2025/06/19 06:41:23 DEBUG : no_checksum_big_file_from_pipe: Size and md5 of src and dst objects identical === RUN TestRcat/withChecksum=true,ignoreChecksum=false run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:43:13 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu': File to upload is small (34 bytes), uploading instead of streaming 2025/06/19 06:43:18 INFO : with_checksum_small_file_from_pipe.rclone_chunk.001_3hmnzx: Moved (server-side) to: with_checksum_small_file_from_pipe 2025/06/19 06:43:18 DEBUG : with_checksum_small_file_from_pipe: md5 = 4c762bc6ec18f21b23fcae426c7863b5 OK 2025/06/19 06:43:18 DEBUG : with_checksum_small_file_from_pipe: Size and md5 of src and dst objects identical 2025/06/19 06:44:19 INFO : with_checksum_big_file_from_pipe.rclone_chunk.001_3hmtsq: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.001 2025/06/19 06:44:21 INFO : with_checksum_big_file_from_pipe.rclone_chunk.002_3hmtsq: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.002 2025/06/19 06:44:22 INFO : with_checksum_big_file_from_pipe.rclone_chunk.003_3hmtsq: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.003 2025/06/19 06:44:24 INFO : with_checksum_big_file_from_pipe.rclone_chunk.004_3hmtsq: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.004 2025/06/19 06:44:25 INFO : with_checksum_big_file_from_pipe.rclone_chunk.005_3hmtsq: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.005 2025/06/19 06:44:27 INFO : with_checksum_big_file_from_pipe.rclone_chunk.006_3hmtsq: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.006 2025/06/19 06:44:28 INFO : with_checksum_big_file_from_pipe.rclone_chunk.007_3hmtsq: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.007 2025/06/19 06:44:30 INFO : with_checksum_big_file_from_pipe.rclone_chunk.008_3hmtsq: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.008 2025/06/19 06:44:32 INFO : with_checksum_big_file_from_pipe.rclone_chunk.009_3hmtsq: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.009 2025/06/19 06:44:34 INFO : with_checksum_big_file_from_pipe.rclone_chunk.010_3hmtsq: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.010 2025/06/19 06:44:35 INFO : with_checksum_big_file_from_pipe.rclone_chunk.011_3hmtsq: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.011 2025/06/19 06:44:36 INFO : with_checksum_big_file_from_pipe.rclone_chunk.012_3hmtsq: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.012 2025/06/19 06:44:38 INFO : with_checksum_big_file_from_pipe.rclone_chunk.013_3hmtsq: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.013 2025/06/19 06:44:39 INFO : with_checksum_big_file_from_pipe.rclone_chunk.014_3hmtsq: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.014 2025/06/19 06:44:41 INFO : with_checksum_big_file_from_pipe.rclone_chunk.015_3hmtsq: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.015 2025/06/19 06:44:42 INFO : with_checksum_big_file_from_pipe.rclone_chunk.016_3hmtsq: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.016 2025/06/19 06:44:44 INFO : with_checksum_big_file_from_pipe.rclone_chunk.017_3hmtsq: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.017 2025/06/19 06:44:45 INFO : with_checksum_big_file_from_pipe.rclone_chunk.018_3hmtsq: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.018 2025/06/19 06:44:47 INFO : with_checksum_big_file_from_pipe.rclone_chunk.019_3hmtsq: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.019 2025/06/19 06:44:48 INFO : with_checksum_big_file_from_pipe.rclone_chunk.020_3hmtsq: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.020 2025/06/19 06:44:50 INFO : with_checksum_big_file_from_pipe.rclone_chunk.021_3hmtsq: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.021 2025/06/19 06:44:52 DEBUG : with_checksum_big_file_from_pipe: md5 = 0ad4cf7b35f62b8ff9c73f481594fbdd OK 2025/06/19 06:44:52 DEBUG : with_checksum_big_file_from_pipe: Size and md5 of src and dst objects identical === RUN TestRcat/withChecksum=false,ignoreChecksum=true run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:46:45 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu': File to upload is small (34 bytes), uploading instead of streaming 2025/06/19 06:46:50 INFO : ignore_checksum_small_file_from_pipe.rclone_chunk.001_3hsj3m: Moved (server-side) to: ignore_checksum_small_file_from_pipe 2025/06/19 06:46:50 DEBUG : ignore_checksum_small_file_from_pipe: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/06/19 06:47:39 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.001_3hsp7l: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.001 2025/06/19 06:47:41 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.002_3hsp7l: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.002 2025/06/19 06:47:43 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.003_3hsp7l: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.003 2025/06/19 06:47:44 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.004_3hsp7l: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.004 2025/06/19 06:47:46 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.005_3hsp7l: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.005 2025/06/19 06:47:47 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.006_3hsp7l: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.006 2025/06/19 06:47:49 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.007_3hsp7l: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.007 2025/06/19 06:47:50 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.008_3hsp7l: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.008 2025/06/19 06:47:52 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.009_3hsp7l: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.009 2025/06/19 06:47:54 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.010_3hsp7l: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.010 2025/06/19 06:47:55 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.011_3hsp7l: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.011 2025/06/19 06:47:57 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.012_3hsp7l: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.012 2025/06/19 06:47:58 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.013_3hsp7l: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.013 2025/06/19 06:47:59 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.014_3hsp7l: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.014 2025/06/19 06:48:00 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.015_3hsp7l: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.015 2025/06/19 06:48:02 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.016_3hsp7l: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.016 2025/06/19 06:48:03 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.017_3hsp7l: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.017 2025/06/19 06:48:05 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.018_3hsp7l: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.018 2025/06/19 06:48:06 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.019_3hsp7l: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.019 2025/06/19 06:48:08 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.020_3hsp7l: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.020 2025/06/19 06:48:10 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.021_3hsp7l: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.021 2025/06/19 06:48:12 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 run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:50:04 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu': File to upload is small (34 bytes), uploading instead of streaming 2025/06/19 06:50:09 INFO : ignore_checksum_small_file_from_pipe.rclone_chunk.001_3hy2dw: Moved (server-side) to: ignore_checksum_small_file_from_pipe 2025/06/19 06:50:09 DEBUG : ignore_checksum_small_file_from_pipe: Src hash empty - aborting Dst hash check 2025/06/19 06:50:09 DEBUG : ignore_checksum_small_file_from_pipe: Size of src and dst objects identical 2025/06/19 06:50:57 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.001_3hy8mx: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.001 2025/06/19 06:50:59 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.002_3hy8mx: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.002 2025/06/19 06:51:01 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.003_3hy8mx: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.003 2025/06/19 06:51:03 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.004_3hy8mx: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.004 2025/06/19 06:51:04 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.005_3hy8mx: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.005 2025/06/19 06:51:06 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.006_3hy8mx: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.006 2025/06/19 06:51:08 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.007_3hy8mx: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.007 2025/06/19 06:51:09 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.008_3hy8mx: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.008 2025/06/19 06:51:11 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.009_3hy8mx: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.009 2025/06/19 06:51:14 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.010_3hy8mx: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.010 2025/06/19 06:51:15 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.011_3hy8mx: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.011 2025/06/19 06:51:17 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.012_3hy8mx: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.012 2025/06/19 06:51:19 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.013_3hy8mx: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.013 2025/06/19 06:51:21 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.014_3hy8mx: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.014 2025/06/19 06:51:22 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.015_3hy8mx: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.015 2025/06/19 06:51:25 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.016_3hy8mx: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.016 2025/06/19 06:51:26 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.017_3hy8mx: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.017 2025/06/19 06:51:27 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.018_3hy8mx: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.018 2025/06/19 06:51:29 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.019_3hy8mx: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.019 2025/06/19 06:51:31 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.020_3hy8mx: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.020 2025/06/19 06:51:33 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.021_3hy8mx: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.021 2025/06/19 06:51:35 DEBUG : ignore_checksum_big_file_from_pipe: Src hash empty - aborting Dst hash check 2025/06/19 06:51:35 DEBUG : ignore_checksum_big_file_from_pipe: Size of src and dst objects identical --- PASS: TestRcat (814.90s) --- PASS: TestRcat/withChecksum=false,ignoreChecksum=false (205.85s) --- PASS: TestRcat/withChecksum=true,ignoreChecksum=false (212.07s) --- PASS: TestRcat/withChecksum=false,ignoreChecksum=true (198.97s) --- PASS: TestRcat/withChecksum=true,ignoreChecksum=true (198.01s) === RUN TestRcatMetadata run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" operations_test.go:1532: Skipping as destination doesn't support user metadata --- SKIP: TestRcatMetadata (0.78s) === RUN TestRcatSize run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:53:35 INFO : potato1.rclone_chunk.001_3i3lrb: Moved (server-side) to: potato1.rclone_chunk.001 2025/06/19 06:53:37 INFO : potato1.rclone_chunk.002_3i3lrb: Moved (server-side) to: potato1.rclone_chunk.002 2025/06/19 06:53:39 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu': File to upload is small (60 bytes), uploading instead of streaming 2025/06/19 06:53:46 INFO : potato2.rclone_chunk.001_3i41pa: Moved (server-side) to: potato2.rclone_chunk.001 2025/06/19 06:53:48 INFO : potato2.rclone_chunk.002_3i41pa: Moved (server-side) to: potato2.rclone_chunk.002 2025/06/19 06:53:51 DEBUG : potato2: md5 = d6548b156ea68a4e003e786df99eee76 OK 2025/06/19 06:53:51 DEBUG : potato2: Size and md5 of src and dst objects identical --- PASS: TestRcatSize (59.75s) === RUN TestRcatSizeMetadata run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" operations_test.go:1613: Skipping as destination doesn't support user metadata --- SKIP: TestRcatSizeMetadata (0.46s) === RUN TestTouchDir run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu'", Local "Local file system at /tmp/rclone537506929", Modify Window "1ns" 2025/06/19 06:54:30 INFO : potato2.rclone_chunk.001_3i599q: Moved (server-side) to: potato2.rclone_chunk.001 2025/06/19 06:54:31 INFO : potato2.rclone_chunk.002_3i599q: Moved (server-side) to: potato2.rclone_chunk.002 2025/06/19 06:54:37 INFO : empty space.rclone_chunk.001_3i5ku6: Moved (server-side) to: empty space 2025/06/19 06:54:45 INFO : sub dir/potato3.rclone_chunk.001_3i5opd: Moved (server-side) to: sub dir/potato3 2025/06/19 06:54:47 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu': Touching "empty space" 2025/06/19 06:54:47 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu': Touching "potato2" 2025/06/19 06:54:47 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-jasacux0bonu': Touching "sub dir/potato3" panic: test timed out after 1h0m0s running tests: TestTouchDir (33s) goroutine 14975 [running]: testing.(*M).startAlarm.func1() /usr/local/go/src/testing/testing.go:2484 +0x394 created by time.goFunc /usr/local/go/src/time/sleep.go:215 +0x2d goroutine 1 [chan receive]: testing.(*T).Run(0xc0007301c0, {0x26a3940?, 0xc000591ad8?}, 0x27d35b8) /usr/local/go/src/testing/testing.go:1859 +0x431 testing.runTests.func1(0xc0007301c0) /usr/local/go/src/testing/testing.go:2279 +0x37 testing.tRunner(0xc0007301c0, 0xc000591c18) /usr/local/go/src/testing/testing.go:1792 +0xf4 testing.runTests(0xc0009ee540, {0x3e98100, 0x6d, 0x6d}, {0xedfe59d30?, 0x3eae0e0?, 0x3eae0e0?}) /usr/local/go/src/testing/testing.go:2277 +0x4b4 testing.(*M).Run(0xc000557b80) /usr/local/go/src/testing/testing.go:2142 +0x64a github.com/rclone/rclone/fstest.TestMain(0xc000557b80) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:69 +0xa5 github.com/rclone/rclone/fs/operations_test.TestMain(...) /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:61 main.main() _testmain.go:265 +0xa9 goroutine 21 [syscall, 60 minutes]: os/signal.signal_recv() /usr/local/go/src/runtime/sigqueue.go:152 +0x29 os/signal.loop() /usr/local/go/src/os/signal/signal_unix.go:23 +0x13 created by os/signal.Notify.func1.1 in goroutine 1 /usr/local/go/src/os/signal/signal.go:152 +0x1f goroutine 22 [chan receive, 60 minutes]: github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1() /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27 created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 1 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 14781 [sync.WaitGroup.Wait]: sync.runtime_SemacquireWaitGroup(0xc0006e7b68?) /usr/local/go/src/runtime/sema.go:110 +0x25 sync.(*WaitGroup).Wait(0x2b07768?) /usr/local/go/src/sync/waitgroup.go:118 +0x48 github.com/rclone/rclone/fs/walk.walk({0x2b07768, 0x3ed16a0}, {0x2b1c800, 0xc00063e000}, {0x0, 0x0}, 0x1, 0xffffffffffffffff, 0xc00037b9b0, 0x27d3830) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:453 +0x355 github.com/rclone/rclone/fs/walk.walkListDirSorted(...) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:349 github.com/rclone/rclone/fs/walk.Walk({0x2b07768, 0x3ed16a0}, {0x2b1c800, 0xc00063e000}, {0x0, 0x0}, 0x1, 0xffffffffffffffff, 0xc00037b9b0) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:76 +0x2a5 github.com/rclone/rclone/fs/walk.listRwalk({0x2b07768, 0x3ed16a0}, {0x2b1c800, 0xc00063e000}, {0x0, 0x0}, 0x1, 0xffffffffffffffff, 0x3, 0xc00037b8f0) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:170 +0x10d github.com/rclone/rclone/fs/walk.ListR({0x2b07768, 0x3ed16a0}, {0x2b1c800, 0xc00063e000}, {0x0, 0x0}, 0x1, 0xffffffffffffffff, 0x3, 0xc00037b8f0) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:160 +0x236 github.com/rclone/rclone/fstest.newRunIndividual.func1() /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:150 +0x107 github.com/rclone/rclone/fstest.(*Run).Finalise(0xc0002f0310) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:388 +0x1c testing.(*common).Cleanup.func1() /usr/local/go/src/testing/testing.go:1211 +0x106 testing.(*common).runCleanup(0xc000a0c380, 0x0?) /usr/local/go/src/testing/testing.go:1445 +0xea testing.tRunner.func2() /usr/local/go/src/testing/testing.go:1786 +0x25 testing.tRunner(0xc000a0c380, 0x27d35b8) /usr/local/go/src/testing/testing.go:1798 +0x11e created by testing.(*T).Run in goroutine 1 /usr/local/go/src/testing/testing.go:1851 +0x413 goroutine 1180 [chan receive (nil chan), 57 minutes]: github.com/rclone/rclone/fs/march.(*March).Run.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 1170 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378 goroutine 14908 [IO wait]: internal/poll.runtime_pollWait(0x75189dc25390, 0x72) /usr/local/go/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc0005a5880?, 0xc000af9800?, 0x0) /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc0005a5880, {0xc000af9800, 0x1800, 0x1800}) /usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc0005a5880, {0xc000af9800?, 0x17fb?, 0xc000a93f20?}) /usr/local/go/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc0004a6430, {0xc000af9800?, 0xc000af9800?, 0x5?}) /usr/local/go/src/net/net.go:194 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000601b90, {0xc000af9800?, 0x75189dc519d8?, 0x75189dda9108?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29 crypto/tls.(*atLeastReader).Read(0xc0007d9c20, {0xc000af9800?, 0x17fb?, 0x4100777200?}) /usr/local/go/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc00073c2b8, {0x2ae0e60, 0xc0007d9c20}) /usr/local/go/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc00073c008, {0x7518544fe498, 0xc000601b90}, 0x4426d4?) /usr/local/go/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc00073c008, 0x0) /usr/local/go/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /usr/local/go/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc00073c008, {0xc000a65000, 0x1000, 0xc00037a330?}) /usr/local/go/src/crypto/tls/conn.go:1385 +0x145 net/http.(*persistConn).Read(0xc000c785a0, {0xc000a65000?, 0x7f3b85?, 0x2adf000?}) /usr/local/go/src/net/http/transport.go:2122 +0x47 bufio.(*Reader).fill(0xc000bd8e40) /usr/local/go/src/bufio/bufio.go:113 +0x103 bufio.(*Reader).Peek(0xc000bd8e40, 0x1) /usr/local/go/src/bufio/bufio.go:152 +0x53 net/http.(*persistConn).readLoop(0xc000c785a0) /usr/local/go/src/net/http/transport.go:2275 +0x172 created by net/http.(*Transport).dialConn in goroutine 14800 /usr/local/go/src/net/http/transport.go:1944 +0x174f goroutine 388 [chan receive (nil chan), 59 minutes]: github.com/rclone/rclone/fs/march.(*March).Run.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 362 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378 goroutine 450 [chan receive (nil chan), 59 minutes]: github.com/rclone/rclone/fs/march.(*March).Run.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 440 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378 goroutine 14753 [select]: net/http.(*persistConn).writeLoop(0xc000928c60) /usr/local/go/src/net/http/transport.go:2590 +0xe7 created by net/http.(*Transport).dialConn in goroutine 14821 /usr/local/go/src/net/http/transport.go:1945 +0x17a5 goroutine 184 [chan receive (nil chan), 60 minutes]: github.com/rclone/rclone/fs/march.(*March).Run.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 142 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378 goroutine 14966 [select]: github.com/rclone/rclone/fs/walk.walk.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:398 +0x16c created by github.com/rclone/rclone/fs/walk.walk in goroutine 14781 /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:395 +0x1df goroutine 4227 [chan receive, 47 minutes]: github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1() /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27 created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 4130 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 1299 [chan receive (nil chan), 57 minutes]: github.com/rclone/rclone/fs/march.(*March).Run.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 1289 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378 goroutine 14811 [select]: net/http.(*persistConn).writeLoop(0xc000928240) /usr/local/go/src/net/http/transport.go:2590 +0xe7 created by net/http.(*Transport).dialConn in goroutine 14804 /usr/local/go/src/net/http/transport.go:1945 +0x17a5 goroutine 14968 [select]: github.com/rclone/rclone/fs/walk.walk.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:398 +0x16c created by github.com/rclone/rclone/fs/walk.walk in goroutine 14781 /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:395 +0x1df goroutine 563 [chan receive (nil chan), 59 minutes]: github.com/rclone/rclone/fs/march.(*March).Run.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 489 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378 goroutine 14892 [select]: net/http.(*persistConn).writeLoop(0xc0008e1560) /usr/local/go/src/net/http/transport.go:2590 +0xe7 created by net/http.(*Transport).dialConn in goroutine 14885 /usr/local/go/src/net/http/transport.go:1945 +0x17a5 goroutine 280 [chan receive (nil chan), 59 minutes]: github.com/rclone/rclone/fs/march.(*March).Run.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 254 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378 goroutine 230 [chan receive (nil chan), 60 minutes]: github.com/rclone/rclone/fs/march.(*March).Run.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 220 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378 goroutine 14429 [select]: net/http.(*persistConn).writeLoop(0xc000638a20) /usr/local/go/src/net/http/transport.go:2590 +0xe7 created by net/http.(*Transport).dialConn in goroutine 14398 /usr/local/go/src/net/http/transport.go:1945 +0x17a5 goroutine 14879 [select]: net/http.(*persistConn).writeLoop(0xc0008e0b40) /usr/local/go/src/net/http/transport.go:2590 +0xe7 created by net/http.(*Transport).dialConn in goroutine 14872 /usr/local/go/src/net/http/transport.go:1945 +0x17a5 goroutine 4480 [chan receive, 46 minutes]: github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1() /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27 created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 4130 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 14945 [IO wait]: internal/poll.runtime_pollWait(0x75189dc257f0, 0x72) /usr/local/go/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc0005a5a80?, 0xc000ca6000?, 0x0) /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc0005a5a80, {0xc000ca6000, 0x1800, 0x1800}) /usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc0005a5a80, {0xc000ca6000?, 0x2ce14b3271ad04ff?, 0xc00083c8c0?}) /usr/local/go/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc0004a6438, {0xc000ca6000?, 0x2c0?, 0xc0000ac480?}) /usr/local/go/src/net/net.go:194 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000601c20, {0xc000ca6000?, 0x7518546a2ab8?, 0x75189dda9f30?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29 crypto/tls.(*atLeastReader).Read(0xc000be45d0, {0xc000ca6000?, 0x75189dda9f30?, 0xc00083c9c8?}) /usr/local/go/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc00073c638, {0x2ae0e60, 0xc000be45d0}) /usr/local/go/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc00073c388, {0x7518544fe498, 0xc000601c20}, 0x4426d4?) /usr/local/go/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc00073c388, 0x0) /usr/local/go/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /usr/local/go/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc00073c388, {0xc000cac000, 0x1000, 0xc00037a330?}) /usr/local/go/src/crypto/tls/conn.go:1385 +0x145 net/http.(*persistConn).Read(0xc000c786c0, {0xc000cac000?, 0x7f3b85?, 0x2adf000?}) /usr/local/go/src/net/http/transport.go:2122 +0x47 bufio.(*Reader).fill(0xc0008fe5a0) /usr/local/go/src/bufio/bufio.go:113 +0x103 bufio.(*Reader).Peek(0xc0008fe5a0, 0x1) /usr/local/go/src/bufio/bufio.go:152 +0x53 net/http.(*persistConn).readLoop(0xc000c786c0) /usr/local/go/src/net/http/transport.go:2275 +0x172 created by net/http.(*Transport).dialConn in goroutine 14935 /usr/local/go/src/net/http/transport.go:1944 +0x174f goroutine 1549 [chan receive (nil chan), 56 minutes]: github.com/rclone/rclone/fs/march.(*March).Run.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 1539 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378 goroutine 14969 [select]: net/http.(*persistConn).roundTrip(0xc000c786c0, 0xc0005a94f0) /usr/local/go/src/net/http/transport.go:2826 +0x785 net/http.(*Transport).roundTrip(0xc000616680, 0xc000c43680) /usr/local/go/src/net/http/transport.go:696 +0xb9a net/http.(*Transport).RoundTrip(...) /usr/local/go/src/net/http/roundtrip.go:30 github.com/rclone/rclone/fs/fshttp.(*Transport).RoundTrip(0xc0002962a0, 0xc000c43680) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:349 +0x345 golang.org/x/oauth2.(*Transport).RoundTrip(0xc0004733e0, 0xc000c43540) /home/rclone/go/pkg/mod/golang.org/x/oauth2@v0.30.0/transport.go:55 +0x15e net/http.send(0xc000c43540, {0x2ae2fc0, 0xc0004733e0}, {0x6e2701?, 0xc000b20c88?, 0x0?}) /usr/local/go/src/net/http/client.go:259 +0x5e2 net/http.(*Client).send(0xc000339d10, 0xc000c43540, {0x12?, 0x1?, 0x0?}) /usr/local/go/src/net/http/client.go:180 +0x91 net/http.(*Client).do(0xc000339d10, 0xc000c43540) /usr/local/go/src/net/http/client.go:728 +0x989 net/http.(*Client).Do(...) /usr/local/go/src/net/http/client.go:587 github.com/rclone/rclone/lib/rest.(*Client).Call(0xc0001425f0, {0x2b07768, 0x3ed16a0}, 0xc000c43400) /home/rclone/go/src/github.com/rclone/rclone/lib/rest/rest.go:353 +0xd67 github.com/rclone/rclone/backend/yandex.(*Fs).delete.func1() /home/rclone/go/src/github.com/rclone/rclone/backend/yandex/yandex.go:603 +0x50 github.com/rclone/rclone/fs.pacerInvoker(0x1, 0xa, 0xc0000b2008?) /home/rclone/go/src/github.com/rclone/rclone/fs/pacer.go:86 +0x32 github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc00078e060, 0xc00094ef40, 0xa) /home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:197 +0x7c github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc00078e060, 0xc00094ef40) /home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:216 +0x93 github.com/rclone/rclone/backend/yandex.(*Fs).delete(0xc000405480, {0x2b07768, 0x3ed16a0}, {0xc000b77830, 0x26}, 0x0) /home/rclone/go/src/github.com/rclone/rclone/backend/yandex/yandex.go:602 +0x3cc github.com/rclone/rclone/backend/yandex.(*Object).Remove(0xc0008fe840, {0x2b07768, 0x3ed16a0}) /home/rclone/go/src/github.com/rclone/rclone/backend/yandex/yandex.go:1164 +0x8b github.com/rclone/rclone/backend/chunker.(*Object).Remove(0xc000404180, {0x2b07768, 0x3ed16a0}) /home/rclone/go/src/github.com/rclone/rclone/backend/chunker/chunker.go:1661 +0x125 github.com/rclone/rclone/fstest.newRunIndividual.func1.1.1() /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:154 +0x24 github.com/rclone/rclone/fstest.retry(0xc000a0c380, {0xc000615500, 0x17}, 0xc0008a7d28) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:121 +0xde github.com/rclone/rclone/fstest.newRunIndividual.func1.1({0xc000253700?, 0x18?, 0x234a160?}) /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:154 +0x29a github.com/rclone/rclone/fs/walk.listRwalk.func1({0x0?, 0x25210c0?}, {0xc000253700, 0x3, 0x4}, {0x0?, 0x0?}) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:179 +0x162 github.com/rclone/rclone/fs/walk.walk.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:415 +0x2e4 created by github.com/rclone/rclone/fs/walk.walk in goroutine 14781 /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:395 +0x1df goroutine 14962 [select]: github.com/rclone/rclone/fs/walk.walk.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:398 +0x16c created by github.com/rclone/rclone/fs/walk.walk in goroutine 14781 /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:395 +0x1df goroutine 526 [chan receive (nil chan), 59 minutes]: github.com/rclone/rclone/fs/march.(*March).Run.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 516 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378 goroutine 4131 [chan receive, 48 minutes]: github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1() /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27 created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 4130 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 14720 [select]: net/http.(*persistConn).writeLoop(0xc000c78000) /usr/local/go/src/net/http/transport.go:2590 +0xe7 created by net/http.(*Transport).dialConn in goroutine 14784 /usr/local/go/src/net/http/transport.go:1945 +0x17a5 goroutine 934 [chan receive (nil chan), 58 minutes]: github.com/rclone/rclone/fs/march.(*March).Run.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 876 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378 goroutine 1679 [chan receive (nil chan), 56 minutes]: github.com/rclone/rclone/fs/march.(*March).Run.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 1669 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378 goroutine 14428 [IO wait]: internal/poll.runtime_pollWait(0x75189dc24d00, 0x72) /usr/local/go/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc00080c680?, 0xc0006caa80?, 0x0) /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc00080c680, {0xc0006caa80, 0x2a80, 0x2a80}) /usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc00080c680, {0xc0006caa80?, 0x2000?, 0x0?}) /usr/local/go/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc000810268, {0xc0006caa80?, 0x5?, 0x3ecd9c8?}) /usr/local/go/src/net/net.go:194 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc00052fc98, {0xc0006caa80?, 0x75189dc519d8?, 0x75189dda9108?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29 crypto/tls.(*atLeastReader).Read(0xc0007d9b60, {0xc0006caa80?, 0x3ed3f20?, 0xc00087f9c8?}) /usr/local/go/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc0005af0b8, {0x2ae0e60, 0xc0007d9b60}) /usr/local/go/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc0005aee08, {0x7518544fe498, 0xc00052fc98}, 0x4426d4?) /usr/local/go/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc0005aee08, 0x0) /usr/local/go/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /usr/local/go/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc0005aee08, {0xc00097e000, 0x1000, 0xc00037a330?}) /usr/local/go/src/crypto/tls/conn.go:1385 +0x145 net/http.(*persistConn).Read(0xc000638a20, {0xc00097e000?, 0x7f3b85?, 0x2adf000?}) /usr/local/go/src/net/http/transport.go:2122 +0x47 bufio.(*Reader).fill(0xc000844d80) /usr/local/go/src/bufio/bufio.go:113 +0x103 bufio.(*Reader).Peek(0xc000844d80, 0x1) /usr/local/go/src/bufio/bufio.go:152 +0x53 net/http.(*persistConn).readLoop(0xc000638a20) /usr/local/go/src/net/http/transport.go:2275 +0x172 created by net/http.(*Transport).dialConn in goroutine 14398 /usr/local/go/src/net/http/transport.go:1944 +0x174f goroutine 4430 [chan receive, 46 minutes]: github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1() /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27 created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 4130 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 642 [chan receive (nil chan), 59 minutes]: github.com/rclone/rclone/fs/march.(*March).Run.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 633 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378 goroutine 759 [chan receive (nil chan), 58 minutes]: github.com/rclone/rclone/fs/march.(*March).Run.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 749 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378 goroutine 712 [chan receive (nil chan), 59 minutes]: github.com/rclone/rclone/fs/march.(*March).Run.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 654 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378 goroutine 835 [chan receive (nil chan), 58 minutes]: github.com/rclone/rclone/fs/march.(*March).Run.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 825 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378 goroutine 14909 [select]: net/http.(*persistConn).writeLoop(0xc000c785a0) /usr/local/go/src/net/http/transport.go:2590 +0xe7 created by net/http.(*Transport).dialConn in goroutine 14800 /usr/local/go/src/net/http/transport.go:1945 +0x17a5 goroutine 10507 [chan receive, 23 minutes]: github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1() /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27 created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 10506 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 4999 [chan receive, 46 minutes]: github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1() /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27 created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 4130 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 14731 [IO wait]: internal/poll.runtime_pollWait(0x75189dc256d8, 0x72) /usr/local/go/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc000d42480?, 0xc0008cac00?, 0x0) /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc000d42480, {0xc0008cac00, 0x1300, 0x1300}) /usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc000d42480, {0xc0008cac00?, 0x12fb?, 0xc000472ae0?}) /usr/local/go/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc00008a820, {0xc0008cac00?, 0xc0008cac00?, 0x5?}) /usr/local/go/src/net/net.go:194 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc0009eea20, {0xc0008cac00?, 0x75189dc519d8?, 0x75189dda9108?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29 crypto/tls.(*atLeastReader).Read(0xc0007d9a40, {0xc0008cac00?, 0x12fb?, 0xc000e319c8?}) /usr/local/go/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc0005afb38, {0x2ae0e60, 0xc0007d9a40}) /usr/local/go/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc0005af888, {0x7518544fe498, 0xc0009eea20}, 0x4426d4?) /usr/local/go/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc0005af888, 0x0) /usr/local/go/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /usr/local/go/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc0005af888, {0xc000920000, 0x1000, 0xc00037a330?}) /usr/local/go/src/crypto/tls/conn.go:1385 +0x145 net/http.(*persistConn).Read(0xc0008e07e0, {0xc000920000?, 0x7f3b85?, 0x2adf000?}) /usr/local/go/src/net/http/transport.go:2122 +0x47 bufio.(*Reader).fill(0xc000c68ba0) /usr/local/go/src/bufio/bufio.go:113 +0x103 bufio.(*Reader).Peek(0xc000c68ba0, 0x1) /usr/local/go/src/bufio/bufio.go:152 +0x53 net/http.(*persistConn).readLoop(0xc0008e07e0) /usr/local/go/src/net/http/transport.go:2275 +0x172 created by net/http.(*Transport).dialConn in goroutine 14725 /usr/local/go/src/net/http/transport.go:1944 +0x174f goroutine 14965 [select]: github.com/rclone/rclone/fs/walk.walk.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:398 +0x16c created by github.com/rclone/rclone/fs/walk.walk in goroutine 14781 /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:395 +0x1df goroutine 14752 [IO wait]: internal/poll.runtime_pollWait(0x751854529688, 0x72) /usr/local/go/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc000d42880?, 0xc0007f8600?, 0x0) /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc000d42880, {0xc0007f8600, 0x1300, 0x1300}) /usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc000d42880, {0xc0007f8600?, 0x12fb?, 0xc0009cece0?}) /usr/local/go/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc00032a208, {0xc0007f8600?, 0xc0007f8600?, 0x5?}) /usr/local/go/src/net/net.go:194 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc0007d87f8, {0xc0007f8600?, 0x7518546a08f8?, 0x75189dda9f30?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29 crypto/tls.(*atLeastReader).Read(0xc000a81590, {0xc0007f8600?, 0x12fb?, 0x0?}) /usr/local/go/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc00057c9b8, {0x2ae0e60, 0xc000a81590}) /usr/local/go/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc00057c708, {0x7518544fe498, 0xc0007d87f8}, 0x4426d4?) /usr/local/go/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc00057c708, 0x0) /usr/local/go/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /usr/local/go/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc00057c708, {0xc0008a1000, 0x1000, 0xc00037a330?}) /usr/local/go/src/crypto/tls/conn.go:1385 +0x145 net/http.(*persistConn).Read(0xc000928c60, {0xc0008a1000?, 0x7f3b85?, 0x2adf000?}) /usr/local/go/src/net/http/transport.go:2122 +0x47 bufio.(*Reader).fill(0xc00078f080) /usr/local/go/src/bufio/bufio.go:113 +0x103 bufio.(*Reader).Peek(0xc00078f080, 0x1) /usr/local/go/src/bufio/bufio.go:152 +0x53 net/http.(*persistConn).readLoop(0xc000928c60) /usr/local/go/src/net/http/transport.go:2275 +0x172 created by net/http.(*Transport).dialConn in goroutine 14821 /usr/local/go/src/net/http/transport.go:1944 +0x174f goroutine 1033 [chan receive (nil chan), 58 minutes]: github.com/rclone/rclone/fs/march.(*March).Run.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 1023 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378 goroutine 4755 [chan receive, 46 minutes]: github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1() /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27 created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 4130 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 14850 [IO wait]: internal/poll.runtime_pollWait(0x751854520038, 0x72) /usr/local/go/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc000b56480?, 0xc000908000?, 0x0) /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc000b56480, {0xc000908000, 0x1300, 0x1300}) /usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc000b56480, {0xc000908000?, 0x12fb?, 0xc000a930e0?}) /usr/local/go/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc000810478, {0xc000908000?, 0xc000908000?, 0x5?}) /usr/local/go/src/net/net.go:194 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000a81890, {0xc000908000?, 0x7518545a5638?, 0x75189dda95c0?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29 crypto/tls.(*atLeastReader).Read(0xc0009eee40, {0xc000908000?, 0x12fb?, 0x0?}) /usr/local/go/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc0006110b8, {0x2ae0e60, 0xc0009eee40}) /usr/local/go/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc000610e08, {0x7518544fe498, 0xc000a81890}, 0x4426d4?) /usr/local/go/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc000610e08, 0x0) /usr/local/go/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /usr/local/go/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc000610e08, {0xc000914000, 0x1000, 0xc00037a330?}) /usr/local/go/src/crypto/tls/conn.go:1385 +0x145 net/http.(*persistConn).Read(0xc000928ea0, {0xc000914000?, 0x7f3b85?, 0x2adf000?}) /usr/local/go/src/net/http/transport.go:2122 +0x47 bufio.(*Reader).fill(0xc000c93440) /usr/local/go/src/bufio/bufio.go:113 +0x103 bufio.(*Reader).Peek(0xc000c93440, 0x1) /usr/local/go/src/bufio/bufio.go:152 +0x53 net/http.(*persistConn).readLoop(0xc000928ea0) /usr/local/go/src/net/http/transport.go:2275 +0x172 created by net/http.(*Transport).dialConn in goroutine 14828 /usr/local/go/src/net/http/transport.go:1944 +0x174f goroutine 14964 [select]: github.com/rclone/rclone/fs/walk.walk.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:398 +0x16c created by github.com/rclone/rclone/fs/walk.walk in goroutine 14781 /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:395 +0x1df goroutine 1656 [chan receive (nil chan), 56 minutes]: github.com/rclone/rclone/fs/march.(*March).Run.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 1634 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378 goroutine 4949 [chan receive, 46 minutes]: github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1() /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27 created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 4130 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 1145 [chan receive (nil chan), 57 minutes]: github.com/rclone/rclone/fs/march.(*March).Run.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 1087 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378 goroutine 14898 [select]: github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0xc0002563c0, {0x2b07880, 0xc0009f7e00}) /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:339 +0x145 created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 14781 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:376 +0x117 goroutine 14963 [select]: github.com/rclone/rclone/fs/walk.walk.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:398 +0x16c created by github.com/rclone/rclone/fs/walk.walk in goroutine 14781 /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:395 +0x1df goroutine 1387 [chan receive (nil chan), 56 minutes]: github.com/rclone/rclone/fs/march.(*March).Run.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 1329 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378 goroutine 1342 [chan receive (nil chan), 57 minutes]: github.com/rclone/rclone/fs/march.(*March).Run.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 1332 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378 goroutine 14851 [select]: net/http.(*persistConn).writeLoop(0xc000928ea0) /usr/local/go/src/net/http/transport.go:2590 +0xe7 created by net/http.(*Transport).dialConn in goroutine 14828 /usr/local/go/src/net/http/transport.go:1945 +0x17a5 goroutine 14946 [select]: net/http.(*persistConn).writeLoop(0xc000c786c0) /usr/local/go/src/net/http/transport.go:2590 +0xe7 created by net/http.(*Transport).dialConn in goroutine 14935 /usr/local/go/src/net/http/transport.go:1945 +0x17a5 goroutine 14810 [IO wait]: internal/poll.runtime_pollWait(0x751854520268, 0x72) /usr/local/go/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc0005a5400?, 0xc0004f2c00?, 0x0) /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc0005a5400, {0xc0004f2c00, 0x1300, 0x1300}) /usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc0005a5400, {0xc0004f2c00?, 0x12fb?, 0xc000a92200?}) /usr/local/go/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc0008101a8, {0xc0004f2c00?, 0xc0004f2c00?, 0x5?}) /usr/local/go/src/net/net.go:194 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000a80b88, {0xc0004f2c00?, 0x7518546dd4e8?, 0x75189dda9a78?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29 crypto/tls.(*atLeastReader).Read(0xc000601020, {0xc0004f2c00?, 0x12fb?, 0xc000e2a9e8?}) /usr/local/go/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc000610d38, {0x2ae0e60, 0xc000601020}) /usr/local/go/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc000610a88, {0x7518544fe498, 0xc000a80b88}, 0x4426d4?) /usr/local/go/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc000610a88, 0x0) /usr/local/go/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /usr/local/go/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc000610a88, {0xc0006a3000, 0x1000, 0xc00037a330?}) /usr/local/go/src/crypto/tls/conn.go:1385 +0x145 net/http.(*persistConn).Read(0xc000928240, {0xc0006a3000?, 0x7f3b85?, 0x2adf000?}) /usr/local/go/src/net/http/transport.go:2122 +0x47 bufio.(*Reader).fill(0xc0009e8c60) /usr/local/go/src/bufio/bufio.go:113 +0x103 bufio.(*Reader).Peek(0xc0009e8c60, 0x1) /usr/local/go/src/bufio/bufio.go:152 +0x53 net/http.(*persistConn).readLoop(0xc000928240) /usr/local/go/src/net/http/transport.go:2275 +0x172 created by net/http.(*Transport).dialConn in goroutine 14804 /usr/local/go/src/net/http/transport.go:1944 +0x174f goroutine 4843 [chan receive, 46 minutes]: github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1() /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27 created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 4130 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 14967 [select]: github.com/rclone/rclone/fs/walk.walk.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:398 +0x16c created by github.com/rclone/rclone/fs/walk.walk in goroutine 14781 /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:395 +0x1df goroutine 1493 [chan receive (nil chan), 56 minutes]: github.com/rclone/rclone/fs/march.(*March).Run.func2() /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:256 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 1483 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:254 +0x378 goroutine 4286 [chan receive, 47 minutes]: github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1() /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27 created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 4130 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 14732 [select]: net/http.(*persistConn).writeLoop(0xc0008e07e0) /usr/local/go/src/net/http/transport.go:2590 +0xe7 created by net/http.(*Transport).dialConn in goroutine 14725 /usr/local/go/src/net/http/transport.go:1945 +0x17a5 goroutine 4643 [chan receive, 46 minutes]: github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1() /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27 created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 4130 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 14891 [IO wait]: internal/poll.runtime_pollWait(0x751854520380, 0x72) /usr/local/go/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc000d43100?, 0xc000af1300?, 0x0) /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc000d43100, {0xc000af1300, 0x1300, 0x1300}) /usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc000d43100, {0xc000af1300?, 0x12fb?, 0xc000473f60?}) /usr/local/go/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc00008ac68, {0xc000af1300?, 0xc000af1300?, 0x5?}) /usr/local/go/src/net/net.go:194 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc00052e5e8, {0xc000af1300?, 0x7518546a2ab8?, 0x75189dda9f30?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29 crypto/tls.(*atLeastReader).Read(0xc000be4660, {0xc000af1300?, 0x12fb?, 0xc0000979c8?}) /usr/local/go/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc000181b38, {0x2ae0e60, 0xc000be4660}) /usr/local/go/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc000181888, {0x7518544fe498, 0xc00052e5e8}, 0x4426d4?) /usr/local/go/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc000181888, 0x0) /usr/local/go/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /usr/local/go/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc000181888, {0xc000ba1000, 0x1000, 0xc00037a330?}) /usr/local/go/src/crypto/tls/conn.go:1385 +0x145 net/http.(*persistConn).Read(0xc0008e1560, {0xc000ba1000?, 0x7f3b85?, 0x2adf000?}) /usr/local/go/src/net/http/transport.go:2122 +0x47 bufio.(*Reader).fill(0xc000b912c0) /usr/local/go/src/bufio/bufio.go:113 +0x103 bufio.(*Reader).Peek(0xc000b912c0, 0x1) /usr/local/go/src/bufio/bufio.go:152 +0x53 net/http.(*persistConn).readLoop(0xc0008e1560) /usr/local/go/src/net/http/transport.go:2275 +0x172 created by net/http.(*Transport).dialConn in goroutine 14885 /usr/local/go/src/net/http/transport.go:1944 +0x174f goroutine 14878 [IO wait]: internal/poll.runtime_pollWait(0x75189dc254a8, 0x72) /usr/local/go/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc0005a5680?, 0xc000af0000?, 0x0) /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc0005a5680, {0xc000af0000, 0x1300, 0x1300}) /usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc0005a5680, {0xc000af0000?, 0x2000?, 0x0?}) /usr/local/go/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc00008ab30, {0xc000af0000?, 0x5?, 0x3ecd9c8?}) /usr/local/go/src/net/net.go:194 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc0009ef6b0, {0xc000af0000?, 0x75189ddb2170?, 0x75189dda9f30?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29 crypto/tls.(*atLeastReader).Read(0xc000010d38, {0xc000af0000?, 0x3ed3f20?, 0xc0009d19c8?}) /usr/local/go/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc0001802b8, {0x2ae0e60, 0xc000010d38}) /usr/local/go/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc000180008, {0x7518544fe498, 0xc0009ef6b0}, 0x4426d4?) /usr/local/go/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc000180008, 0x0) /usr/local/go/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /usr/local/go/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc000180008, {0xc0009ea000, 0x1000, 0xc00037a330?}) /usr/local/go/src/crypto/tls/conn.go:1385 +0x145 net/http.(*persistConn).Read(0xc0008e0b40, {0xc0009ea000?, 0x7f3b85?, 0x2adf000?}) /usr/local/go/src/net/http/transport.go:2122 +0x47 bufio.(*Reader).fill(0xc000a3b4a0) /usr/local/go/src/bufio/bufio.go:113 +0x103 bufio.(*Reader).Peek(0xc000a3b4a0, 0x1) /usr/local/go/src/bufio/bufio.go:152 +0x53 net/http.(*persistConn).readLoop(0xc0008e0b40) /usr/local/go/src/net/http/transport.go:2275 +0x172 created by net/http.(*Transport).dialConn in goroutine 14872 /usr/local/go/src/net/http/transport.go:1944 +0x174f goroutine 14670 [IO wait]: internal/poll.runtime_pollWait(0x751854529110, 0x72) /usr/local/go/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc0005a4a80?, 0xc000af8000?, 0x0) /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc0005a4a80, {0xc000af8000, 0x1800, 0x1800}) /usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc0005a4a80, {0xc000af8000?, 0x75189dda9108?, 0xc0009d0946?}) /usr/local/go/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc00032a3f8, {0xc000af8000?, 0xc0009d08d8?, 0x4796a5?}) /usr/local/go/src/net/net.go:194 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc0007d98d8, {0xc000af8000?, 0x75189dc519d8?, 0x75189dda9108?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29 crypto/tls.(*atLeastReader).Read(0xc0007d9e18, {0xc000af8000?, 0x7?, 0xc0003a5608?}) /usr/local/go/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc0005af7b8, {0x2ae0e60, 0xc0007d9e18}) /usr/local/go/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc0005af508, {0x7518544fe498, 0xc0007d98d8}, 0x4426d4?) /usr/local/go/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc0005af508, 0x0) /usr/local/go/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /usr/local/go/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc0005af508, {0xc000aaa000, 0x1000, 0x10?}) /usr/local/go/src/crypto/tls/conn.go:1385 +0x145 bufio.(*Reader).Read(0xc00097cde0, {0xc0004a2c80, 0x9, 0xc0002f8e00?}) /usr/local/go/src/bufio/bufio.go:245 +0x197 io.ReadAtLeast({0x2adf360, 0xc00097cde0}, {0xc0004a2c80, 0x9, 0x9}, 0x9) /usr/local/go/src/io/io.go:335 +0x91 io.ReadFull(...) /usr/local/go/src/io/io.go:354 net/http.http2readFrameHeader({0xc0004a2c80, 0x9, 0xc0003b1890?}, {0x2adf360?, 0xc00097cde0?}) /usr/local/go/src/net/http/h2_bundle.go:1805 +0x65 net/http.(*http2Framer).ReadFrame(0xc0004a2c40) /usr/local/go/src/net/http/h2_bundle.go:2072 +0x7d net/http.(*http2clientConnReadLoop).run(0xc0009d0fa8) /usr/local/go/src/net/http/h2_bundle.go:9933 +0xda net/http.(*http2ClientConn).readLoop(0xc00094ae00) /usr/local/go/src/net/http/h2_bundle.go:9812 +0x79 created by net/http.(*http2Transport).newClientConn in goroutine 14669 /usr/local/go/src/net/http/h2_bundle.go:8334 +0xde5 goroutine 14719 [IO wait]: internal/poll.runtime_pollWait(0x751854528ff8, 0x72) /usr/local/go/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc0005a5200?, 0xc0004f1900?, 0x0) /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc0005a5200, {0xc0004f1900, 0x1300, 0x1300}) /usr/local/go/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc0005a5200, {0xc0004f1900?, 0x12fb?, 0xc000263460?}) /usr/local/go/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc000810070, {0xc0004f1900?, 0xc0004f1900?, 0x5?}) /usr/local/go/src/net/net.go:194 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000a804b0, {0xc0004f1900?, 0x7518546dd4e8?, 0x75189dda9a78?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29 crypto/tls.(*atLeastReader).Read(0xc000600e88, {0xc0004f1900?, 0x12fb?, 0x0?}) /usr/local/go/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc0006109b8, {0x2ae0e60, 0xc000600e88}) /usr/local/go/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc000610708, {0x7518544fe498, 0xc000a804b0}, 0x4426d4?) /usr/local/go/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc000610708, 0x0) /usr/local/go/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /usr/local/go/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc000610708, {0xc000b1d000, 0x1000, 0xc00037a330?}) /usr/local/go/src/crypto/tls/conn.go:1385 +0x145 net/http.(*persistConn).Read(0xc000c78000, {0xc000b1d000?, 0x7f3b85?, 0x2adf000?}) /usr/local/go/src/net/http/transport.go:2122 +0x47 bufio.(*Reader).fill(0xc000844540) /usr/local/go/src/bufio/bufio.go:113 +0x103 bufio.(*Reader).Peek(0xc000844540, 0x1) /usr/local/go/src/bufio/bufio.go:152 +0x53 net/http.(*persistConn).readLoop(0xc000c78000) /usr/local/go/src/net/http/transport.go:2275 +0x172 created by net/http.(*Transport).dialConn in goroutine 14784 /usr/local/go/src/net/http/transport.go:1944 +0x174f "./operations.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -fast-list -size-limit 1024" - Finished ERROR in 1h0m0.525209994s (try 2/5): exit status 2: Failed [TestReadFile]