"./operations.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024" - Starting (try 1/5) 2025/03/03 09:57:11 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo" 2025/03/03 09:57:11 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/03 09:57:11 DEBUG : Creating backend with remote "TestYandex:rclone-test-bosuxuy5yafo" 2025/03/03 09:57:11 DEBUG : Reset feature "ListR" 2025/03/03 09:57:11 DEBUG : Creating backend with remote "/tmp/rclone2325820316" === 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-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" multithread_test.go:121: multithread writing not supported 2025/03/03 09:57:11 ERROR : : error listing: directory not found --- SKIP: TestMultithreadCopy (0.21s) === RUN TestMultithreadCopyAbort run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" multithread_test.go:121: multithread writing not supported 2025/03/03 09:57:12 ERROR : : error listing: directory not found --- SKIP: TestMultithreadCopyAbort (0.48s) === RUN TestSizeDiffers --- PASS: TestSizeDiffers (0.00s) === RUN TestReOpen === RUN TestReOpen/Normal === RUN TestReOpen/Normal/Basics 2025/03/03 09:57:12 DEBUG : potato: Seek from 10 to 0 === RUN TestReOpen/Normal/ErrorAtStart === RUN TestReOpen/Normal/WithErrors 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/Normal/TooManyErrors 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2025/03/03 09:57:12 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/Normal/Seek 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2025/03/03 09:57:12 DEBUG : potato: Seek from 5 to 2 === RUN TestReOpen/Normal/AccountRead === RUN TestReOpen/Normal/AccountReadDelay 2025/03/03 09:57:12 DEBUG : potato: Seek from 10 to 0 2025/03/03 09:57:12 DEBUG : potato: Seek from 10 to 0 2025/03/03 09:57:12 DEBUG : potato: Seek from 10 to 0 === RUN TestReOpen/Normal/AccountReadError === RUN TestReOpen/WithRangeOption === RUN TestReOpen/WithRangeOption/Basics 2025/03/03 09:57:12 DEBUG : potato: Seek from 7 to 0 === RUN TestReOpen/WithRangeOption/ErrorAtStart === RUN TestReOpen/WithRangeOption/WithErrors 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/WithRangeOption/TooManyErrors 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2025/03/03 09:57:12 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/WithRangeOption/Seek 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2025/03/03 09:57:12 DEBUG : potato: Seek from 5 to 2 2025/03/03 09:57:12 DEBUG : potato: Seek from 7 to 4 === RUN TestReOpen/WithRangeOption/AccountRead === RUN TestReOpen/WithRangeOption/AccountReadDelay 2025/03/03 09:57:12 DEBUG : potato: Seek from 7 to 0 2025/03/03 09:57:12 DEBUG : potato: Seek from 7 to 0 2025/03/03 09:57:12 DEBUG : potato: Seek from 7 to 0 === RUN TestReOpen/WithRangeOption/AccountReadError === RUN TestReOpen/WithSeekOption === RUN TestReOpen/WithSeekOption/Basics 2025/03/03 09:57:12 DEBUG : potato: Seek from 8 to 0 === RUN TestReOpen/WithSeekOption/ErrorAtStart === RUN TestReOpen/WithSeekOption/WithErrors 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/WithSeekOption/TooManyErrors 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2025/03/03 09:57:12 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/WithSeekOption/Seek 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2025/03/03 09:57:12 DEBUG : potato: Seek from 5 to 2 2025/03/03 09:57:12 DEBUG : potato: Seek from 7 to 5 === RUN TestReOpen/WithSeekOption/AccountRead === RUN TestReOpen/WithSeekOption/AccountReadDelay 2025/03/03 09:57:12 DEBUG : potato: Seek from 8 to 0 2025/03/03 09:57:12 DEBUG : potato: Seek from 8 to 0 2025/03/03 09:57:12 DEBUG : potato: Seek from 8 to 0 === RUN TestReOpen/WithSeekOption/AccountReadError === RUN TestReOpen/UnknownSize === RUN TestReOpen/UnknownSize/Basics 2025/03/03 09:57:12 DEBUG : potato: Seek from 9 to 0 === RUN TestReOpen/UnknownSize/ErrorAtStart === RUN TestReOpen/UnknownSize/WithErrors 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/UnknownSize/TooManyErrors 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2025/03/03 09:57:12 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/UnknownSize/Seek 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2025/03/03 09:57:12 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2025/03/03 09:57:12 DEBUG : potato: Seek from 5 to 2 2025/03/03 09:57:12 DEBUG : potato: Seek from 7 to 6 === RUN TestReOpen/UnknownSize/AccountRead === RUN TestReOpen/UnknownSize/AccountReadDelay 2025/03/03 09:57:12 DEBUG : potato: Seek from 9 to 0 2025/03/03 09:57:12 DEBUG : potato: Seek from 9 to 0 2025/03/03 09:57:12 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-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 09:57:19 INFO : rutabaga.rclone_chunk.001_jqktim: Moved (server-side) to: rutabaga === RUN TestCheck/1 === RUN TestCheck/2 2025/03/03 09:57:26 INFO : empty space.rclone_chunk.001_jql10y: Moved (server-side) to: empty space === RUN TestCheck/3 2025/03/03 09:57:39 INFO : potato2.rclone_chunk.001_jql6o5: Moved (server-side) to: potato2.rclone_chunk.001 2025/03/03 09:57:41 INFO : potato2.rclone_chunk.002_jql6o5: Moved (server-side) to: potato2.rclone_chunk.002 === RUN TestCheck/4 === RUN TestCheck/5 2025/03/03 09:58:02 INFO : remotepotato.rclone_chunk.001_jqlx37: Moved (server-side) to: remotepotato.rclone_chunk.001 2025/03/03 09:58:03 INFO : remotepotato.rclone_chunk.002_jqlx37: Moved (server-side) to: remotepotato.rclone_chunk.002 === NAME TestCheck fstest.go:121: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:121 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:126 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:145 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:189 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:164 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/check_test.go:184 Error: Should be true Test: TestCheck Messages: remotepotato: Modification time difference too big |-211061h52m57.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2025-03-03 09:58:04 +0000 UTC) (precision 1ns) === RUN TestCheck/6 === RUN TestCheck/7 --- FAIL: TestCheck (88.24s) --- PASS: TestCheck/1 (0.41s) --- PASS: TestCheck/2 (0.22s) --- PASS: TestCheck/3 (0.24s) --- PASS: TestCheck/4 (2.18s) --- PASS: TestCheck/5 (0.67s) --- PASS: TestCheck/6 (1.05s) --- PASS: TestCheck/7 (0.79s) === RUN TestCheckFsError 2025/03/03 09:58:40 DEBUG : Creating backend with remote "nonexistent" 2025/03/03 09:58:40 DEBUG : Config file has changed externally - reloading 2025/03/03 09:58:40 DEBUG : Creating backend with remote "nonexistent" 2025/03/03 09:58:40 DEBUG : Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/nonexistent: Waiting for checks to finish 2025/03/03 09:58:40 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/03/03 09:58:40 NOTICE: Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/nonexistent: 2 differences found 2025/03/03 09:58:40 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-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 09:58:45 INFO : rutabaga.rclone_chunk.001_jqn8kn: Moved (server-side) to: rutabaga === RUN TestCheckDownload/1 === RUN TestCheckDownload/2 2025/03/03 09:58:53 INFO : empty space.rclone_chunk.001_jqngae: Moved (server-side) to: empty space === RUN TestCheckDownload/3 2025/03/03 09:59:07 INFO : potato2.rclone_chunk.001_jqnnf7: Moved (server-side) to: potato2.rclone_chunk.001 2025/03/03 09:59:09 INFO : potato2.rclone_chunk.002_jqnnf7: Moved (server-side) to: potato2.rclone_chunk.002 === RUN TestCheckDownload/4 === RUN TestCheckDownload/5 2025/03/03 09:59:29 INFO : remotepotato.rclone_chunk.001_jqod0f: Moved (server-side) to: remotepotato.rclone_chunk.001 2025/03/03 09:59:31 INFO : remotepotato.rclone_chunk.002_jqod0f: Moved (server-side) to: remotepotato.rclone_chunk.002 === RUN TestCheckDownload/6 === RUN TestCheckDownload/7 --- PASS: TestCheckDownload (96.10s) --- PASS: TestCheckDownload/1 (0.67s) --- PASS: TestCheckDownload/2 (1.39s) --- PASS: TestCheckDownload/3 (0.89s) --- PASS: TestCheckDownload/4 (2.64s) --- PASS: TestCheckDownload/5 (1.72s) --- PASS: TestCheckDownload/6 (1.56s) --- PASS: TestCheckDownload/7 (2.59s) === RUN TestCheckSizeOnly run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:00:23 INFO : rutabaga.rclone_chunk.001_jqpwdt: Moved (server-side) to: rutabaga === RUN TestCheckSizeOnly/1 === RUN TestCheckSizeOnly/2 2025/03/03 10:00:31 INFO : empty space.rclone_chunk.001_jqq5o3: Moved (server-side) to: empty space === RUN TestCheckSizeOnly/3 2025/03/03 10:00:44 INFO : potato2.rclone_chunk.001_jqqdfu: Moved (server-side) to: potato2.rclone_chunk.001 2025/03/03 10:00:46 INFO : potato2.rclone_chunk.002_jqqdfu: Moved (server-side) to: potato2.rclone_chunk.002 === RUN TestCheckSizeOnly/4 === RUN TestCheckSizeOnly/5 2025/03/03 10:01:08 INFO : remotepotato.rclone_chunk.001_jqr0qa: Moved (server-side) to: remotepotato.rclone_chunk.001 2025/03/03 10:01:10 INFO : remotepotato.rclone_chunk.002_jqr0qa: Moved (server-side) to: remotepotato.rclone_chunk.002 === RUN TestCheckSizeOnly/6 === RUN TestCheckSizeOnly/7 --- PASS: TestCheckSizeOnly (91.75s) --- PASS: TestCheckSizeOnly/1 (0.71s) --- PASS: TestCheckSizeOnly/2 (0.23s) --- PASS: TestCheckSizeOnly/3 (0.29s) --- PASS: TestCheckSizeOnly/4 (0.23s) --- PASS: TestCheckSizeOnly/5 (0.34s) --- PASS: TestCheckSizeOnly/6 (0.37s) --- PASS: TestCheckSizeOnly/7 (0.39s) === RUN TestCheckEqualReaders --- PASS: TestCheckEqualReaders (0.00s) === RUN TestParseSumFile run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:01:59 INFO : test.sum.rclone_chunk.001_jqsgyc: Moved (server-side) to: test.sum.rclone_chunk.001 2025/03/03 10:02:01 INFO : test.sum.rclone_chunk.002_jqsgyc: Moved (server-side) to: test.sum.rclone_chunk.002 2025/03/03 10:02:06 NOTICE: test.sum: improperly formatted checksum line 4 2025/03/03 10:02:06 NOTICE: test.sum: improperly formatted checksum line 5 2025/03/03 10:02:06 NOTICE: test.sum: improperly formatted checksum line 6 2025/03/03 10:02:06 NOTICE: test.sum: 2 warning(s) suppressed... 2025/03/03 10:02:27 INFO : test.sum.rclone_chunk.001_jqsz6e: Moved (server-side) to: test.sum.rclone_chunk.001 2025/03/03 10:02:30 INFO : test.sum.rclone_chunk.002_jqsz6e: Moved (server-side) to: test.sum.rclone_chunk.002 2025/03/03 10:02:36 NOTICE: test.sum: improperly formatted checksum line 4 2025/03/03 10:02:36 NOTICE: test.sum: improperly formatted checksum line 5 2025/03/03 10:02:36 NOTICE: test.sum: improperly formatted checksum line 6 2025/03/03 10:02:36 NOTICE: test.sum: 2 warning(s) suppressed... 2025/03/03 10:02:37 DEBUG : Couldn't decode error response: invalid character 'N' looking for beginning of value 2025/03/03 10:02:37 DEBUG : pacer: low level retry 1/10 (error [500 - ] (500 Internal Server Error)) 2025/03/03 10:02:37 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/03/03 10:02:37 DEBUG : pacer: Reducing sleep to 15ms 2025/03/03 10:02:41 DEBUG : pacer: Reducing sleep to 11.25ms 2025/03/03 10:02:45 DEBUG : pacer: Reducing sleep to 10ms --- PASS: TestParseSumFile (60.82s) === RUN TestCheckSum run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:02:49 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo/data" 2025/03/03 10:02:49 DEBUG : Creating backend with remote "TestYandex:rclone-test-bosuxuy5yafo/data" 2025/03/03 10:02:49 DEBUG : Reset feature "ListR" 2025/03/03 10:02:55 INFO : data/banana.rclone_chunk.001_jqu6mg: Moved (server-side) to: data/banana 2025/03/03 10:03:01 INFO : test.sum.rclone_chunk.001_jqubhn: Moved (server-side) to: test.sum === RUN TestCheckSum/subtest1 2025/03/03 10:03:12 INFO : data/potato.rclone_chunk.001_jqukqc: Moved (server-side) to: data/potato 2025/03/03 10:03:24 INFO : test.sum: Deleted 2025/03/03 10:03:26 INFO : test.sum.rclone_chunk.001_jqutqr: Moved (server-side) to: test.sum === RUN TestCheckSum/subtest2 2025/03/03 10:03:40 INFO : test.sum.rclone_chunk.001_jqv99b: Moved (server-side) to: test.sum.rclone_chunk.001 2025/03/03 10:03:41 INFO : test.sum.rclone_chunk.002_jqv99b: Moved (server-side) to: test.sum.rclone_chunk.002 === RUN TestCheckSum/subtest3 2025/03/03 10:04:16 INFO : test.sum.rclone_chunk.001_jqvxm4: Moved (server-side) to: test.sum.rclone_chunk.001 2025/03/03 10:04:17 INFO : test.sum.rclone_chunk.002_jqvxm4: Moved (server-side) to: test.sum.rclone_chunk.002 === RUN TestCheckSum/subtest4 2025/03/03 10:04:47 INFO : test.sum.rclone_chunk.001_jqwven: Moved (server-side) to: test.sum.rclone_chunk.001 2025/03/03 10:04:49 INFO : test.sum.rclone_chunk.002_jqwven: Moved (server-side) to: test.sum.rclone_chunk.002 2025/03/03 10:04:50 INFO : test.sum.rclone_chunk.003_jqwven: Moved (server-side) to: test.sum.rclone_chunk.003 === RUN TestCheckSum/subtest5 2025/03/03 10:05:28 INFO : test.sum.rclone_chunk.001_jqxs3f: Moved (server-side) to: test.sum.rclone_chunk.001 2025/03/03 10:05:29 INFO : test.sum.rclone_chunk.002_jqxs3f: Moved (server-side) to: test.sum.rclone_chunk.002 2025/03/03 10:05:31 INFO : test.sum.rclone_chunk.003_jqxs3f: Moved (server-side) to: test.sum.rclone_chunk.003 === RUN TestCheckSum/subtest6 2025/03/03 10:05:50 INFO : data/banana: Deleted 2025/03/03 10:05:52 INFO : data/banana.rclone_chunk.001_jqyxtq: Moved (server-side) to: data/banana 2025/03/03 10:06:00 INFO : data/potato: Deleted 2025/03/03 10:06:02 INFO : data/potato.rclone_chunk.001_jqz994: Moved (server-side) to: data/potato 2025/03/03 10:06:30 INFO : test.sum.rclone_chunk.001_jqznk9: Moved (server-side) to: test.sum.rclone_chunk.001 2025/03/03 10:06:32 INFO : test.sum.rclone_chunk.002_jqznk9: Moved (server-side) to: test.sum.rclone_chunk.002 === RUN TestCheckSum/subtest7 --- PASS: TestCheckSum (257.39s) --- PASS: TestCheckSum/subtest1 (1.64s) --- PASS: TestCheckSum/subtest2 (1.53s) --- PASS: TestCheckSum/subtest3 (2.87s) --- PASS: TestCheckSum/subtest4 (2.63s) --- PASS: TestCheckSum/subtest5 (3.32s) --- PASS: TestCheckSum/subtest6 (2.92s) --- PASS: TestCheckSum/subtest7 (2.42s) === RUN TestCheckSumDownload run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:07:06 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo/data" 2025/03/03 10:07:06 DEBUG : Config file has changed externally - reloading 2025/03/03 10:07:06 DEBUG : Creating backend with remote "TestYandex:rclone-test-bosuxuy5yafo/data" 2025/03/03 10:07:06 DEBUG : Reset feature "ListR" 2025/03/03 10:07:20 INFO : data/banana.rclone_chunk.001_jr1bif: Moved (server-side) to: data/banana 2025/03/03 10:07:28 INFO : test.sum.rclone_chunk.001_jr1o48: Moved (server-side) to: test.sum === RUN TestCheckSumDownload/subtest1 2025/03/03 10:07:39 INFO : data/potato.rclone_chunk.001_jr2176: Moved (server-side) to: data/potato 2025/03/03 10:07:49 INFO : test.sum: Deleted 2025/03/03 10:07:51 INFO : test.sum.rclone_chunk.001_jr285e: Moved (server-side) to: test.sum === RUN TestCheckSumDownload/subtest2 2025/03/03 10:08:05 INFO : test.sum.rclone_chunk.001_jr2nvw: Moved (server-side) to: test.sum.rclone_chunk.001 2025/03/03 10:08:07 INFO : test.sum.rclone_chunk.002_jr2nvw: Moved (server-side) to: test.sum.rclone_chunk.002 === RUN TestCheckSumDownload/subtest3 2025/03/03 10:08:42 INFO : test.sum.rclone_chunk.001_jr3934: Moved (server-side) to: test.sum.rclone_chunk.001 2025/03/03 10:08:43 INFO : test.sum.rclone_chunk.002_jr3934: Moved (server-side) to: test.sum.rclone_chunk.002 === RUN TestCheckSumDownload/subtest4 2025/03/03 10:09:16 INFO : test.sum.rclone_chunk.001_jr4da8: Moved (server-side) to: test.sum.rclone_chunk.001 2025/03/03 10:09:18 INFO : test.sum.rclone_chunk.002_jr4da8: Moved (server-side) to: test.sum.rclone_chunk.002 2025/03/03 10:09:20 INFO : test.sum.rclone_chunk.003_jr4da8: Moved (server-side) to: test.sum.rclone_chunk.003 === RUN TestCheckSumDownload/subtest5 2025/03/03 10:09:55 INFO : test.sum.rclone_chunk.001_jr5ad7: Moved (server-side) to: test.sum.rclone_chunk.001 2025/03/03 10:09:57 INFO : test.sum.rclone_chunk.002_jr5ad7: Moved (server-side) to: test.sum.rclone_chunk.002 2025/03/03 10:09:58 INFO : test.sum.rclone_chunk.003_jr5ad7: Moved (server-side) to: test.sum.rclone_chunk.003 === RUN TestCheckSumDownload/subtest6 2025/03/03 10:10:22 INFO : data/banana: Deleted 2025/03/03 10:10:24 INFO : data/banana.rclone_chunk.001_jr6b8d: Moved (server-side) to: data/banana 2025/03/03 10:10:32 INFO : data/potato: Deleted 2025/03/03 10:10:34 INFO : data/potato.rclone_chunk.001_jr6s1j: Moved (server-side) to: data/potato 2025/03/03 10:10:56 INFO : test.sum.rclone_chunk.001_jr73fq: Moved (server-side) to: test.sum.rclone_chunk.001 2025/03/03 10:10:57 INFO : test.sum.rclone_chunk.002_jr73fq: Moved (server-side) to: test.sum.rclone_chunk.002 === RUN TestCheckSumDownload/subtest7 --- PASS: TestCheckSumDownload (268.17s) --- PASS: TestCheckSumDownload/subtest1 (3.58s) --- PASS: TestCheckSumDownload/subtest2 (2.54s) --- PASS: TestCheckSumDownload/subtest3 (4.26s) --- PASS: TestCheckSumDownload/subtest4 (3.66s) --- PASS: TestCheckSumDownload/subtest5 (4.83s) --- PASS: TestCheckSumDownload/subtest6 (3.79s) --- PASS: TestCheckSumDownload/subtest7 (3.82s) === RUN TestApplyTransforms 2025/03/03 10:11:34 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-rosunow9lufe" 2025/03/03 10:11:34 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/03 10:11:34 DEBUG : Creating backend with remote "TestYandex:rclone-test-rosunow9lufe" 2025/03/03 10:11:35 DEBUG : Reset feature "ListR" 2025/03/03 10:11:35 DEBUG : Creating backend with remote "/tmp/rclone3813739761" run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-rosunow9lufe'", Local "Local file system at /tmp/rclone3813739761", Modify Window "1ns" 2025/03/03 10:11:42 INFO : hello, world!.rclone_chunk.001_jr8sus: Moved (server-side) to: hello, world! upper checkfile vs. lower remote (without normalization) 2025/03/03 10:11:42 ERROR : hello, world!: sum not found 2025/03/03 10:11:42 ERROR : HELLO, WORLD!: file not in Chunked 'TestChunkerChunk50bYandex:rclone-test-rosunow9lufe' 2025/03/03 10:11:42 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-rosunow9lufe': 1 files missing 2025/03/03 10:11:42 NOTICE: 1 hashes missing 2025/03/03 10:11:42 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-rosunow9lufe': 2 differences found 2025/03/03 10:11:42 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-rosunow9lufe': 2 errors while checking upper checkfile vs. lower remote (with normalization) 2025/03/03 10:11:47 DEBUG : hello, world!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/03/03 10:11:47 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-rosunow9lufe': 0 differences found 2025/03/03 10:11:47 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-rosunow9lufe': 1 matching files 2025/03/03 10:11:47 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-sipeqam8huci" 2025/03/03 10:11:47 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/03 10:11:47 DEBUG : Creating backend with remote "TestYandex:rclone-test-sipeqam8huci" 2025/03/03 10:11:47 DEBUG : Reset feature "ListR" 2025/03/03 10:11:47 DEBUG : Creating backend with remote "/tmp/rclone1160186971" run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-sipeqam8huci'", Local "Local file system at /tmp/rclone1160186971", Modify Window "1ns" 2025/03/03 10:11:54 INFO : HELLO, WORLD!.rclone_chunk.001_jr94lk: Moved (server-side) to: HELLO, WORLD! lower checkfile vs. upper remote (without normalization) 2025/03/03 10:11:55 ERROR : HELLO, WORLD!: sum not found 2025/03/03 10:11:55 ERROR : hello, world!: file not in Chunked 'TestChunkerChunk50bYandex:rclone-test-sipeqam8huci' 2025/03/03 10:11:55 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-sipeqam8huci': 1 files missing 2025/03/03 10:11:55 NOTICE: 1 hashes missing 2025/03/03 10:11:55 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-sipeqam8huci': 2 differences found 2025/03/03 10:11:55 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-sipeqam8huci': 2 errors while checking lower checkfile vs. upper remote (with normalization) 2025/03/03 10:11:56 DEBUG : HELLO, WORLD!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/03/03 10:11:56 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-sipeqam8huci': 0 differences found 2025/03/03 10:11:56 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-sipeqam8huci': 1 matching files 2025/03/03 10:11:56 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-dosozit2papi" 2025/03/03 10:11:56 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/03 10:11:56 DEBUG : Creating backend with remote "TestYandex:rclone-test-dosozit2papi" 2025/03/03 10:11:57 DEBUG : Reset feature "ListR" 2025/03/03 10:11:57 DEBUG : Creating backend with remote "/tmp/rclone1588698311" run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-dosozit2papi'", Local "Local file system at /tmp/rclone1588698311", Modify Window "1ns" 2025/03/03 10:12:04 INFO : HeLlO, wOrLd!.rclone_chunk.001_jr9djo: Moved (server-side) to: HeLlO, wOrLd! lower checkfile vs. upperlowermixed remote (without normalization) 2025/03/03 10:12:05 ERROR : HeLlO, wOrLd!: sum not found 2025/03/03 10:12:05 ERROR : hello, world!: file not in Chunked 'TestChunkerChunk50bYandex:rclone-test-dosozit2papi' 2025/03/03 10:12:05 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-dosozit2papi': 1 files missing 2025/03/03 10:12:05 NOTICE: 1 hashes missing 2025/03/03 10:12:05 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-dosozit2papi': 2 differences found 2025/03/03 10:12:05 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-dosozit2papi': 2 errors while checking lower checkfile vs. upperlowermixed remote (with normalization) 2025/03/03 10:12:06 DEBUG : HeLlO, wOrLd!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/03/03 10:12:06 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-dosozit2papi': 0 differences found 2025/03/03 10:12:06 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-dosozit2papi': 1 matching files 2025/03/03 10:12:06 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-xolosot3kina" 2025/03/03 10:12:06 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/03 10:12:06 DEBUG : Creating backend with remote "TestYandex:rclone-test-xolosot3kina" 2025/03/03 10:12:06 DEBUG : Reset feature "ListR" 2025/03/03 10:12:06 DEBUG : Creating backend with remote "/tmp/rclone523124912" run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-xolosot3kina'", Local "Local file system at /tmp/rclone523124912", Modify Window "1ns" 2025/03/03 10:12:13 INFO : HELLO, WORLD!.rclone_chunk.001_jr9onc: Moved (server-side) to: HELLO, WORLD! upperlowermixed checkfile vs. upper remote (without normalization) 2025/03/03 10:12:14 ERROR : HELLO, WORLD!: sum not found 2025/03/03 10:12:14 ERROR : HeLlO, wOrLd!: file not in Chunked 'TestChunkerChunk50bYandex:rclone-test-xolosot3kina' 2025/03/03 10:12:14 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-xolosot3kina': 1 files missing 2025/03/03 10:12:14 NOTICE: 1 hashes missing 2025/03/03 10:12:14 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-xolosot3kina': 2 differences found 2025/03/03 10:12:14 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-xolosot3kina': 2 errors while checking upperlowermixed checkfile vs. upper remote (with normalization) 2025/03/03 10:12:15 DEBUG : HELLO, WORLD!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/03/03 10:12:15 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-xolosot3kina': 0 differences found 2025/03/03 10:12:15 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-xolosot3kina': 1 matching files 2025/03/03 10:12:15 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-pibirak0hiru" 2025/03/03 10:12:15 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/03 10:12:15 DEBUG : Creating backend with remote "TestYandex:rclone-test-pibirak0hiru" 2025/03/03 10:12:15 DEBUG : Reset feature "ListR" 2025/03/03 10:12:15 DEBUG : Creating backend with remote "/tmp/rclone2006936089" run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-pibirak0hiru'", Local "Local file system at /tmp/rclone2006936089", Modify Window "1ns" 2025/03/03 10:12:23 INFO : 測試_Русский___ě_áñ.rclone_chunk.001_jr9wjb: Moved (server-side) to: 測試_Русский___ě_áñ NFD checkfile vs. NFC remote (without normalization) 2025/03/03 10:12:24 ERROR : 測試_Русский___ě_áñ: sum not found 2025/03/03 10:12:24 ERROR : 測試_Русский___ě_áñ: file not in Chunked 'TestChunkerChunk50bYandex:rclone-test-pibirak0hiru' 2025/03/03 10:12:24 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-pibirak0hiru': 1 files missing 2025/03/03 10:12:24 NOTICE: 1 hashes missing 2025/03/03 10:12:24 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-pibirak0hiru': 2 differences found 2025/03/03 10:12:24 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-pibirak0hiru': 2 errors while checking NFD checkfile vs. NFC remote (with normalization) 2025/03/03 10:12:25 DEBUG : 測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/03/03 10:12:25 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-pibirak0hiru': 0 differences found 2025/03/03 10:12:25 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-pibirak0hiru': 1 matching files 2025/03/03 10:12:25 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-tokopit4losu" 2025/03/03 10:12:25 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/03 10:12:25 DEBUG : Creating backend with remote "TestYandex:rclone-test-tokopit4losu" 2025/03/03 10:12:25 DEBUG : Reset feature "ListR" 2025/03/03 10:12:25 DEBUG : Creating backend with remote "/tmp/rclone1555831225" run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-tokopit4losu'", Local "Local file system at /tmp/rclone1555831225", Modify Window "1ns" 2025/03/03 10:12:31 INFO : 測試_Русский___ě_áñ.rclone_chunk.001_jra6rb: Moved (server-side) to: 測試_Русский___ě_áñ NFC checkfile vs. NFD remote (without normalization) 2025/03/03 10:12:32 ERROR : 測試_Русский___ě_áñ: sum not found 2025/03/03 10:12:32 ERROR : 測試_Русский___ě_áñ: file not in Chunked 'TestChunkerChunk50bYandex:rclone-test-tokopit4losu' 2025/03/03 10:12:32 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-tokopit4losu': 1 files missing 2025/03/03 10:12:32 NOTICE: 1 hashes missing 2025/03/03 10:12:32 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-tokopit4losu': 2 differences found 2025/03/03 10:12:32 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-tokopit4losu': 2 errors while checking NFC checkfile vs. NFD remote (with normalization) 2025/03/03 10:12:33 DEBUG : 測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/03/03 10:12:33 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-tokopit4losu': 0 differences found 2025/03/03 10:12:33 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-tokopit4losu': 1 matching files 2025/03/03 10:12:33 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-coxaxuz5kipi" 2025/03/03 10:12:33 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/03 10:12:33 DEBUG : Creating backend with remote "TestYandex:rclone-test-coxaxuz5kipi" 2025/03/03 10:12:33 DEBUG : Reset feature "ListR" 2025/03/03 10:12:33 DEBUG : Creating backend with remote "/tmp/rclone2774756324" run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-coxaxuz5kipi'", Local "Local file system at /tmp/rclone2774756324", Modify Window "1ns" 2025/03/03 10:12:41 INFO : 測試_Русский___ě_áñ測試_Русский___ě_áñ.rclone_chunk.001_jraeib: Moved (server-side) to: 測試_Русский___ě_áñ測試_Русский___ě_áñ NFDx2 checkfile vs. both remote (without normalization) 2025/03/03 10:12:41 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found 2025/03/03 10:12:41 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Chunked 'TestChunkerChunk50bYandex:rclone-test-coxaxuz5kipi' 2025/03/03 10:12:41 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-coxaxuz5kipi': 1 files missing 2025/03/03 10:12:41 NOTICE: 1 hashes missing 2025/03/03 10:12:41 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-coxaxuz5kipi': 2 differences found 2025/03/03 10:12:41 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-coxaxuz5kipi': 2 errors while checking NFDx2 checkfile vs. both remote (with normalization) 2025/03/03 10:12:43 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/03/03 10:12:43 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-coxaxuz5kipi': 0 differences found 2025/03/03 10:12:43 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-coxaxuz5kipi': 1 matching files 2025/03/03 10:12:43 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-bacidec7baza" 2025/03/03 10:12:43 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/03 10:12:43 DEBUG : Creating backend with remote "TestYandex:rclone-test-bacidec7baza" 2025/03/03 10:12:44 DEBUG : Reset feature "ListR" 2025/03/03 10:12:44 DEBUG : Creating backend with remote "/tmp/rclone1534723784" run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bacidec7baza'", Local "Local file system at /tmp/rclone1534723784", Modify Window "1ns" 2025/03/03 10:12:52 INFO : 測試_Русский___ě_áñ測試_Русский___ě_áñ.rclone_chunk.001_jraqt6: Moved (server-side) to: 測試_Русский___ě_áñ測試_Русский___ě_áñ NFCx2 checkfile vs. both remote (without normalization) 2025/03/03 10:12:52 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found 2025/03/03 10:12:52 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Chunked 'TestChunkerChunk50bYandex:rclone-test-bacidec7baza' 2025/03/03 10:12:52 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-bacidec7baza': 1 files missing 2025/03/03 10:12:52 NOTICE: 1 hashes missing 2025/03/03 10:12:52 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-bacidec7baza': 2 differences found 2025/03/03 10:12:52 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-bacidec7baza': 2 errors while checking NFCx2 checkfile vs. both remote (with normalization) 2025/03/03 10:12:53 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/03/03 10:12:53 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-bacidec7baza': 0 differences found 2025/03/03 10:12:53 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-bacidec7baza': 1 matching files 2025/03/03 10:12:53 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-datuyov5moda" 2025/03/03 10:12:53 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/03 10:12:53 DEBUG : Creating backend with remote "TestYandex:rclone-test-datuyov5moda" 2025/03/03 10:12:53 DEBUG : Reset feature "ListR" 2025/03/03 10:12:53 DEBUG : Creating backend with remote "/tmp/rclone2280201318" run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-datuyov5moda'", Local "Local file system at /tmp/rclone2280201318", Modify Window "1ns" 2025/03/03 10:12:59 INFO : 測試_Русский___ě_áñ測試_Русский___ě_áñ.rclone_chunk.001_jraya3: Moved (server-side) to: 測試_Русский___ě_áñ測試_Русский___ě_áñ both checkfile vs. NFDx2 remote (without normalization) 2025/03/03 10:13:00 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found 2025/03/03 10:13:00 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Chunked 'TestChunkerChunk50bYandex:rclone-test-datuyov5moda' 2025/03/03 10:13:00 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-datuyov5moda': 1 files missing 2025/03/03 10:13:00 NOTICE: 1 hashes missing 2025/03/03 10:13:00 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-datuyov5moda': 2 differences found 2025/03/03 10:13:00 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-datuyov5moda': 2 errors while checking both checkfile vs. NFDx2 remote (with normalization) 2025/03/03 10:13:01 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/03/03 10:13:01 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-datuyov5moda': 0 differences found 2025/03/03 10:13:01 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-datuyov5moda': 1 matching files 2025/03/03 10:13:01 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-huwidem3yabo" 2025/03/03 10:13:01 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/03 10:13:01 DEBUG : Creating backend with remote "TestYandex:rclone-test-huwidem3yabo" 2025/03/03 10:13:02 DEBUG : Reset feature "ListR" 2025/03/03 10:13:02 DEBUG : Creating backend with remote "/tmp/rclone3006985675" run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-huwidem3yabo'", Local "Local file system at /tmp/rclone3006985675", Modify Window "1ns" 2025/03/03 10:13:09 INFO : 測試_Русский___ě_áñ測試_Русский___ě_áñ.rclone_chunk.001_jrb7c4: Moved (server-side) to: 測試_Русский___ě_áñ測試_Русский___ě_áñ both checkfile vs. NFCx2 remote (without normalization) 2025/03/03 10:13:10 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found 2025/03/03 10:13:10 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Chunked 'TestChunkerChunk50bYandex:rclone-test-huwidem3yabo' 2025/03/03 10:13:10 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-huwidem3yabo': 1 files missing 2025/03/03 10:13:10 NOTICE: 1 hashes missing 2025/03/03 10:13:10 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-huwidem3yabo': 2 differences found 2025/03/03 10:13:10 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-huwidem3yabo': 2 errors while checking both checkfile vs. NFCx2 remote (with normalization) 2025/03/03 10:13:11 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2025/03/03 10:13:11 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-huwidem3yabo': 0 differences found 2025/03/03 10:13:11 NOTICE: Chunked 'TestChunkerChunk50bYandex:rclone-test-huwidem3yabo': 1 matching files 2025/03/03 10:13:11 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-huwidem3yabo': Purge remote 2025/03/03 10:13:17 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-datuyov5moda': Purge remote 2025/03/03 10:13:24 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-bacidec7baza': Purge remote 2025/03/03 10:13:30 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-coxaxuz5kipi': Purge remote 2025/03/03 10:13:37 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-tokopit4losu': Purge remote 2025/03/03 10:13:43 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-pibirak0hiru': Purge remote 2025/03/03 10:13:51 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-xolosot3kina': Purge remote 2025/03/03 10:13:56 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-dosozit2papi': Purge remote 2025/03/03 10:14:02 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-sipeqam8huci': Purge remote 2025/03/03 10:14:08 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-rosunow9lufe': Purge remote --- PASS: TestApplyTransforms (160.54s) === RUN TestTruncateString --- PASS: TestTruncateString (0.00s) === RUN TestCopyFile run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:14:15 DEBUG : file1: Need to transfer - File not found at Destination 2025/03/03 10:14:20 INFO : sub/file2.rclone_chunk.001_jrd8ys: Moved (server-side) to: sub/file2 2025/03/03 10:14:20 DEBUG : file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2025/03/03 10:14:20 INFO : file1: Copied (new) to: sub/file2 2025/03/03 10:14:22 DEBUG : file1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/03 10:14:22 DEBUG : file1: Unchanged skipping 2025/03/03 10:14:23 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo': don't need to copy/move sub/file2, it is already at target location --- PASS: TestCopyFile (19.07s) === RUN TestCopyLongFile run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" copy_test.go:153: Test only runs on local --- SKIP: TestCopyLongFile (0.93s) === RUN TestCopyFileBackupDir run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:14:40 INFO : dst/file1.rclone_chunk.001_jrdrn9: Moved (server-side) to: dst/file1 2025/03/03 10:14:41 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo/backup" 2025/03/03 10:14:41 DEBUG : Creating backend with remote "TestYandex:rclone-test-bosuxuy5yafo/backup" 2025/03/03 10:14:42 DEBUG : Reset feature "ListR" 2025/03/03 10:14:42 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18) 2025/03/03 10:14:42 DEBUG : dst/file1: move non-chunked object... 2025/03/03 10:14:45 INFO : dst/file1: Moved (server-side) 2025/03/03 10:14:45 INFO : dst/file1: Moved (server-side) 2025/03/03 10:14:45 DEBUG : dst/file1: skip slow MD5 on source file, hashing in-transit 2025/03/03 10:14:54 INFO : dst/file1.rclone_chunk.001_jre17n: Moved (server-side) to: dst/file1 2025/03/03 10:14:54 DEBUG : dst/file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2025/03/03 10:14:54 INFO : dst/file1: Copied (new) --- PASS: TestCopyFileBackupDir (46.34s) === RUN TestCopyFileCompareDest run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:15:21 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo/dst" 2025/03/03 10:15:21 DEBUG : Creating backend with remote "TestYandex:rclone-test-bosuxuy5yafo/dst" 2025/03/03 10:15:22 DEBUG : Reset feature "ListR" 2025/03/03 10:15:22 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo/CompareDest" 2025/03/03 10:15:22 DEBUG : Creating backend with remote "TestYandex:rclone-test-bosuxuy5yafo/CompareDest" 2025/03/03 10:15:22 DEBUG : Reset feature "ListR" 2025/03/03 10:15:22 DEBUG : one: Need to transfer - File not found at Destination 2025/03/03 10:15:23 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/03/03 10:15:32 INFO : one.rclone_chunk.001_jrf3sb: Moved (server-side) to: one 2025/03/03 10:15:32 DEBUG : one: md5 = f97c5d29941bfb1b2fdab0874906ab82 OK 2025/03/03 10:15:32 INFO : one: Copied (new) 2025/03/03 10:15:34 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/03/03 10:15:35 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/03/03 10:15:46 INFO : one: Deleted 2025/03/03 10:15:47 INFO : one.rclone_chunk.001_jrffjp: Moved (server-side) to: one 2025/03/03 10:15:47 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK 2025/03/03 10:15:47 INFO : one: Copied (replaced existing) 2025/03/03 10:15:58 INFO : dst/one: Deleted 2025/03/03 10:16:01 INFO : dst/one.rclone_chunk.001_jrftfa: Moved (server-side) to: dst/one 2025/03/03 10:16:11 INFO : CompareDest/one.rclone_chunk.001_jrg57n: Moved (server-side) to: CompareDest/one 2025/03/03 10:16:12 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/03/03 10:16:13 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/03 10:16:13 DEBUG : one: Destination found in --compare-dest, skipping 2025/03/03 10:16:23 INFO : CompareDest/two.rclone_chunk.001_jrgjiy: Moved (server-side) to: CompareDest/two 2025/03/03 10:16:24 DEBUG : two: Need to transfer - File not found at Destination 2025/03/03 10:16:24 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/03 10:16:24 DEBUG : two: Destination found in --compare-dest, skipping 2025/03/03 10:16:26 DEBUG : two: Need to transfer - File not found at Destination 2025/03/03 10:16:27 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/03 10:16:27 DEBUG : two: Destination found in --compare-dest, skipping 2025/03/03 10:16:28 DEBUG : two: Need to transfer - File not found at Destination 2025/03/03 10:16:29 DEBUG : two: Sizes differ (src 5 vs dst 3) 2025/03/03 10:16:29 DEBUG : two: skip slow MD5 on source file, hashing in-transit 2025/03/03 10:16:35 INFO : two.rclone_chunk.001_jrgxeo: Moved (server-side) to: two 2025/03/03 10:16:35 DEBUG : two: md5 = 2379e4ce8c3380e996ab0509f17069ad OK 2025/03/03 10:16:35 INFO : two: Copied (new) --- PASS: TestCopyFileCompareDest (102.63s) === RUN TestCopyFileCopyDest run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:17:04 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo/dst" 2025/03/03 10:17:04 DEBUG : Creating backend with remote "TestYandex:rclone-test-bosuxuy5yafo/dst" 2025/03/03 10:17:04 DEBUG : Reset feature "ListR" 2025/03/03 10:17:04 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo/CopyDest" 2025/03/03 10:17:04 DEBUG : Creating backend with remote "TestYandex:rclone-test-bosuxuy5yafo/CopyDest" 2025/03/03 10:17:05 DEBUG : Reset feature "ListR" 2025/03/03 10:17:05 DEBUG : one: Need to transfer - File not found at Destination 2025/03/03 10:17:05 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/03/03 10:17:13 INFO : one.rclone_chunk.001_jrhx9p: Moved (server-side) to: one 2025/03/03 10:17:13 DEBUG : one: md5 = f97c5d29941bfb1b2fdab0874906ab82 OK 2025/03/03 10:17:13 INFO : one: Copied (new) 2025/03/03 10:17:14 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/03/03 10:17:15 DEBUG : one: skip slow MD5 on source file, hashing in-transit 2025/03/03 10:17:22 INFO : one: Deleted 2025/03/03 10:17:24 INFO : one.rclone_chunk.001_jri7ai: Moved (server-side) to: one 2025/03/03 10:17:24 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK 2025/03/03 10:17:24 INFO : one: Copied (replaced existing) 2025/03/03 10:17:33 INFO : dst/one: Deleted 2025/03/03 10:17:35 INFO : dst/one.rclone_chunk.001_jrihxj: Moved (server-side) to: dst/one 2025/03/03 10:17:40 INFO : CopyDest/one.rclone_chunk.001_jrirti: Moved (server-side) to: CopyDest/one 2025/03/03 10:17:42 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo/BackupDir" 2025/03/03 10:17:42 DEBUG : Creating backend with remote "TestYandex:rclone-test-bosuxuy5yafo/BackupDir" 2025/03/03 10:17:43 DEBUG : Reset feature "ListR" 2025/03/03 10:17:43 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/03/03 10:17:43 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/03 10:17:43 DEBUG : one: Sizes differ (src 5 vs dst 3) 2025/03/03 10:17:44 DEBUG : one: move non-chunked object... 2025/03/03 10:17:46 INFO : one: Moved (server-side) 2025/03/03 10:17:46 INFO : one: Moved (server-side) 2025/03/03 10:17:46 DEBUG : one: copy non-chunked object... 2025/03/03 10:17:51 DEBUG : one: md5 = 07912d142f5d63ee918b34796b5a2432 OK 2025/03/03 10:17:51 INFO : one: Copied (server-side copy) 2025/03/03 10:17:51 DEBUG : one: Destination found in --copy-dest, using server-side copy 2025/03/03 10:18:01 INFO : CopyDest/two.rclone_chunk.001_jrjbuz: Moved (server-side) to: CopyDest/two 2025/03/03 10:18:02 DEBUG : two: Need to transfer - File not found at Destination 2025/03/03 10:18:03 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/03 10:18:03 DEBUG : two: copy non-chunked object... 2025/03/03 10:18:05 DEBUG : two: md5 = b8a9f715dbb64fd5c56e7783c6820a61 OK 2025/03/03 10:18:05 INFO : two: Copied (server-side copy) 2025/03/03 10:18:05 DEBUG : two: Destination found in --copy-dest, using server-side copy 2025/03/03 10:18:07 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/03 10:18:07 DEBUG : two: Unchanged skipping 2025/03/03 10:18:21 INFO : CopyDest/three.rclone_chunk.001_jrjpe6: Moved (server-side) to: CopyDest/three 2025/03/03 10:18:23 DEBUG : three: Need to transfer - File not found at Destination 2025/03/03 10:18:23 DEBUG : three: Sizes differ (src 7 vs dst 5) 2025/03/03 10:18:23 DEBUG : three: Destination not found in --copy-dest 2025/03/03 10:18:23 DEBUG : three: skip slow MD5 on source file, hashing in-transit 2025/03/03 10:18:29 INFO : three.rclone_chunk.001_jrk3ij: Moved (server-side) to: three 2025/03/03 10:18:29 DEBUG : three: md5 = 1bccb9dccb3e9f6a3f9d2a8bdb54b7f5 OK 2025/03/03 10:18:29 INFO : three: Copied (new) --- PASS: TestCopyFileCopyDest (131.54s) === RUN TestCopyInplace run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" copy_test.go:370: Partial uploads not supported --- SKIP: TestCopyInplace (0.87s) === RUN TestCopyLongFileName run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" copy_test.go:403: Partial uploads not supported --- SKIP: TestCopyLongFileName (0.65s) === RUN TestCopyFileMaxTransfer run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:19:17 DEBUG : TestCopyFileMaxTransfer/file1: Need to transfer - File not found at Destination 2025/03/03 10:19:17 DEBUG : TestCopyFileMaxTransfer/file1: skip slow MD5 on source file, hashing in-transit 2025/03/03 10:19:24 INFO : TestCopyFileMaxTransfer/file1.rclone_chunk.001_jrllmv: Moved (server-side) to: TestCopyFileMaxTransfer/file1 2025/03/03 10:19:24 DEBUG : TestCopyFileMaxTransfer/file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2025/03/03 10:19:24 INFO : TestCopyFileMaxTransfer/file1: Copied (new) 2025/03/03 10:19:25 DEBUG : TestCopyFileMaxTransfer/file2: Need to transfer - File not found at Destination 2025/03/03 10:19:26 DEBUG : TestCopyFileMaxTransfer/file2: skip slow MD5 on source file, hashing in-transit 2025/03/03 10:24:06 ERROR : TestCopyFileMaxTransfer/file2: Failed to copy: Put "https://uploader60j.disk.yandex.net:443/upload-target/20250303T132127.089.utd.9iks3b4jvlv17ypyog7bpktof-k60j.9376024": max transfer limit reached as set by --max-transfer 2025/03/03 10:24:09 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 (303.49s) === RUN TestDeduplicateInteractive run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateInteractive (0.69s) === RUN TestDeduplicateSkip run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateSkip (0.66s) === RUN TestDeduplicateSizeOnly run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateSizeOnly (1.07s) === RUN TestDeduplicateFirst run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateFirst (0.60s) === RUN TestDeduplicateNewest run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateNewest (0.79s) === RUN TestDeduplicateNewestByHash run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:24:33 INFO : one.rclone_chunk.001_jru404: Moved (server-side) to: one.rclone_chunk.001 2025/03/03 10:24:35 INFO : one.rclone_chunk.002_jru404: Moved (server-side) to: one.rclone_chunk.002 2025/03/03 10:24:49 INFO : also/one.rclone_chunk.001_jruip7: Moved (server-side) to: also/one.rclone_chunk.001 2025/03/03 10:24:50 INFO : also/one.rclone_chunk.002_jruip7: Moved (server-side) to: also/one.rclone_chunk.002 2025/03/03 10:24:59 INFO : another.rclone_chunk.001_jruxxo: Moved (server-side) to: another.rclone_chunk.001 2025/03/03 10:25:02 INFO : another.rclone_chunk.002_jruxxo: Moved (server-side) to: another.rclone_chunk.002 2025/03/03 10:25:10 INFO : not-one.rclone_chunk.001_jrv90a: Moved (server-side) to: not-one fstest.go:121: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:121 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:126 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:145 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:189 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/dedupe_test.go:159 Error: Should be true Test: TestDeduplicateNewestByHash Messages: also/one: Modification time difference too big |-115605h24m52.876543211s| > 1ns (want 2011-12-25 12:59:59.123456789 +0000 UTC vs got 2025-03-03 10:24:52 +0000 UTC) (precision 1ns) 2025/03/03 10:25:12 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo': Looking for duplicate md5 hashes using newest mode. 2025/03/03 10:25:13 NOTICE: 57efa01fc0cb40fb8b90ee53e94b51e1: Found 3 files with duplicate md5 hashes 2025/03/03 10:25:25 INFO : one: Deleted 2025/03/03 10:25:37 INFO : another: Deleted 2025/03/03 10:25:37 NOTICE: 57efa01fc0cb40fb8b90ee53e94b51e1: Deleted 2 extra copies fstest.go:292: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:292: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:292: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:299: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:299 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/dedupe_test.go:164 Error: Should be true Test: TestDeduplicateNewestByHash Messages: listing wrong, want another (100), not-one (5) got also/one (100), not-one (5) fstest.go:185: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:185 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:302 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/dedupe_test.go:164 Error: Should be true Test: TestDeduplicateNewestByHash Messages: Unexpected file "also/one" fstest.go:197: Not found "another" fstest.go:200: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:200 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:304 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:340 /home/rclone/go/src/github.com/rclone/rclone/fs/operations/dedupe_test.go:164 Error: Not equal: expected: 0 actual : 1 Test: TestDeduplicateNewestByHash Messages: 1 objects not found --- FAIL: TestDeduplicateNewestByHash (110.35s) === RUN TestDeduplicateOldest run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateOldest (1.03s) === RUN TestDeduplicateLargest run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateLargest (1.11s) === RUN TestDeduplicateSmallest run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateSmallest (0.69s) === RUN TestDeduplicateRename run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateRename (1.64s) === RUN TestMergeDirs run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" dedupe_test.go:256: Can't merge directories --- SKIP: TestMergeDirs (0.52s) === RUN TestListDirSorted run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:26:27 INFO : a.txt.rclone_chunk.001_jrxcso: Moved (server-side) to: a.txt 2025/03/03 10:26:33 INFO : zend.txt.rclone_chunk.001_jrxkf8: Moved (server-side) to: zend.txt 2025/03/03 10:26:40 INFO : sub dir/hello world.rclone_chunk.001_jrxp9k: Moved (server-side) to: sub dir/hello world 2025/03/03 10:26:44 INFO : sub dir/hello world2.rclone_chunk.001_jrxw49: Moved (server-side) to: sub dir/hello world2 2025/03/03 10:27:00 INFO : sub dir/ignore dir/.ignore.rclone_chunk.001_jry1fr: Moved (server-side) to: sub dir/ignore dir/.ignore 2025/03/03 10:27:07 INFO : sub dir/ignore dir/should be ignored.rclone_chunk.001_jrygrx: Moved (server-side) to: sub dir/ignore dir/should be ignored 2025/03/03 10:27:15 INFO : sub dir/sub sub dir/hello world3.rclone_chunk.001_jryol8: Moved (server-side) to: sub dir/sub sub dir/hello world3 2025/03/03 10:27:17 DEBUG : a.txt: Excluded (Size Filter) 2025/03/03 10:27:17 DEBUG : a.txt: Excluded 2025/03/03 10:27:18 DEBUG : sub dir/hello world: Excluded (Size Filter) 2025/03/03 10:27:18 DEBUG : sub dir/hello world: Excluded 2025/03/03 10:27:18 DEBUG : sub dir/hello world2: Excluded (Size Filter) 2025/03/03 10:27:18 DEBUG : sub dir/hello world2: Excluded 2025/03/03 10:27:18 DEBUG : sub dir/hello world: Excluded (Size Filter) 2025/03/03 10:27:18 DEBUG : sub dir/hello world: Excluded 2025/03/03 10:27:18 DEBUG : sub dir/hello world2: Excluded (Size Filter) 2025/03/03 10:27:18 DEBUG : sub dir/hello world2: Excluded 2025/03/03 10:27:19 DEBUG : sub dir/ignore dir: Excluded 2025/03/03 10:27:20 DEBUG : sub dir/ignore dir: Excluded --- PASS: TestListDirSorted (105.12s) === RUN TestListJSON run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:28:10 INFO : file1.rclone_chunk.001_js09jn: Moved (server-side) to: file1 2025/03/03 10:28:16 INFO : sub/file2.rclone_chunk.001_js0fj5: 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 (30.06s) --- PASS: TestListJSON/Default (0.44s) --- PASS: TestListJSON/FilesOnly (0.56s) --- PASS: TestListJSON/DirsOnly (0.54s) --- PASS: TestListJSON/Recurse (0.67s) --- PASS: TestListJSON/SubDir (0.43s) --- PASS: TestListJSON/NoModTime (0.38s) --- PASS: TestListJSON/NoMimeType (0.43s) --- PASS: TestListJSON/ShowHash (0.47s) --- PASS: TestListJSON/HashTypes (0.37s) --- PASS: TestListJSON/Metadata (0.26s) === RUN TestStatJSON run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:28:44 INFO : file1.rclone_chunk.001_js141y: Moved (server-side) to: file1 2025/03/03 10:28:52 INFO : sub/file2.rclone_chunk.001_js1cpd: 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/03/03 10:28:59 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo/notfound" 2025/03/03 10:28:59 DEBUG : Config file has changed externally - reloading 2025/03/03 10:28:59 DEBUG : Creating backend with remote "TestYandex:rclone-test-bosuxuy5yafo/notfound" 2025/03/03 10:28:59 DEBUG : Reset feature "ListR" --- PASS: TestStatJSON (38.37s) --- PASS: TestStatJSON/Root (0.49s) --- PASS: TestStatJSON/RootFilesOnly (0.00s) --- PASS: TestStatJSON/RootDirsOnly (0.35s) --- PASS: TestStatJSON/Dir (0.69s) --- PASS: TestStatJSON/DirWithTrailingSlash (0.30s) --- PASS: TestStatJSON/File (0.61s) --- PASS: TestStatJSON/NotFound (0.81s) --- PASS: TestStatJSON/DirFilesOnly (0.27s) --- PASS: TestStatJSON/FileFilesOnly (0.97s) --- PASS: TestStatJSON/NotFoundFilesOnly (0.33s) --- PASS: TestStatJSON/DirDirsOnly (0.37s) --- PASS: TestStatJSON/FileDirsOnly (0.44s) --- PASS: TestStatJSON/NotFoundDirsOnly (0.31s) --- PASS: TestStatJSON/RootNotFound (0.46s) === RUN TestMkdir run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:29:13 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo': Making directory 2025/03/03 10:29:13 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo': Making directory --- PASS: TestMkdir (1.34s) === RUN TestLsd run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:29:20 INFO : sub dir/hello world.rclone_chunk.001_js272k: Moved (server-side) to: sub dir/hello world --- PASS: TestLsd (15.93s) === RUN TestLs run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:29:50 INFO : potato2.rclone_chunk.001_js2nhn: Moved (server-side) to: potato2.rclone_chunk.001 2025/03/03 10:29:52 INFO : potato2.rclone_chunk.002_js2nhn: Moved (server-side) to: potato2.rclone_chunk.002 2025/03/03 10:30:00 INFO : empty space.rclone_chunk.001_js3bq0: Moved (server-side) to: empty space --- PASS: TestLs (47.75s) === RUN TestLsWithFilesFrom run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:30:29 INFO : potato2.rclone_chunk.001_js3yuf: Moved (server-side) to: potato2.rclone_chunk.001 2025/03/03 10:30:30 INFO : potato2.rclone_chunk.002_js3yuf: Moved (server-side) to: potato2.rclone_chunk.002 2025/03/03 10:30:40 INFO : empty space.rclone_chunk.001_js4fp2: Moved (server-side) to: empty space 2025/03/03 10:30:42 DEBUG : empty space: Excluded (FilesFrom Filter) 2025/03/03 10:30:42 DEBUG : empty space: Excluded --- PASS: TestLsWithFilesFrom (42.15s) === RUN TestLsLong run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:31:12 INFO : potato2.rclone_chunk.001_js54hu: Moved (server-side) to: potato2.rclone_chunk.001 2025/03/03 10:31:14 INFO : potato2.rclone_chunk.002_js54hu: Moved (server-side) to: potato2.rclone_chunk.002 2025/03/03 10:31:24 INFO : empty space.rclone_chunk.001_js5l7f: Moved (server-side) to: empty space --- PASS: TestLsLong (46.42s) === RUN TestHashSums run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:31:55 INFO : potato2.rclone_chunk.001_js6f2y: Moved (server-side) to: potato2.rclone_chunk.001 2025/03/03 10:31:57 INFO : potato2.rclone_chunk.002_js6f2y: Moved (server-side) to: potato2.rclone_chunk.002 2025/03/03 10:32:10 INFO : empty space.rclone_chunk.001_js6s6k: Moved (server-side) to: empty space === RUN TestHashSums/Md5 === RUN TestHashSums/Md5Download --- PASS: TestHashSums (46.58s) --- PASS: TestHashSums/Md5 (0.92s) --- PASS: TestHashSums/Md5Download (4.75s) === RUN TestHashSumsWithErrors 2025/03/03 10:32:33 DEBUG : Creating backend with remote ":memory:" 2025/03/03 10:32:33 ERROR : file1: hash unsupported: hash type not supported --- PASS: TestHashSumsWithErrors (0.00s) === RUN TestHashStream 2025/03/03 10:32:33 DEBUG : Creating md5 hash of 0 bytes read from input stream 2025/03/03 10:32:33 DEBUG : Creating md5 hash of 0 bytes read from input stream 2025/03/03 10:32:33 DEBUG : Creating sha1 hash of 0 bytes read from input stream 2025/03/03 10:32:33 DEBUG : Creating sha1 hash of 0 bytes read from input stream 2025/03/03 10:32:33 DEBUG : Creating md5 hash of 12 bytes read from input stream 2025/03/03 10:32:33 DEBUG : Creating md5 hash of 12 bytes read from input stream 2025/03/03 10:32:33 DEBUG : Creating sha1 hash of 12 bytes read from input stream 2025/03/03 10:32:33 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-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:32:48 INFO : potato2.rclone_chunk.001_js7p6i: Moved (server-side) to: potato2.rclone_chunk.001 2025/03/03 10:32:50 INFO : potato2.rclone_chunk.002_js7p6i: Moved (server-side) to: potato2.rclone_chunk.002 2025/03/03 10:33:03 INFO : empty space.rclone_chunk.001_js8bts: Moved (server-side) to: empty space 2025/03/03 10:33:09 INFO : sub dir/potato3.rclone_chunk.001_js8jot: Moved (server-side) to: sub dir/potato3 --- PASS: TestCount (62.05s) === RUN TestDelete run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:33:42 INFO : small.rclone_chunk.001_js9guk: Moved (server-side) to: small 2025/03/03 10:33:50 INFO : medium.rclone_chunk.001_js9mpl: Moved (server-side) to: medium.rclone_chunk.001 2025/03/03 10:33:52 INFO : medium.rclone_chunk.002_js9mpl: Moved (server-side) to: medium.rclone_chunk.002 2025/03/03 10:34:09 INFO : large.rclone_chunk.001_jsa5li: Moved (server-side) to: large.rclone_chunk.001 2025/03/03 10:34:11 INFO : large.rclone_chunk.002_jsa5li: Moved (server-side) to: large.rclone_chunk.002 2025/03/03 10:34:16 DEBUG : Waiting for deletions to finish 2025/03/03 10:34:16 DEBUG : large: Excluded (Size Filter) 2025/03/03 10:34:16 DEBUG : large: Excluded 2025/03/03 10:34:20 INFO : small: Deleted 2025/03/03 10:34:28 INFO : medium: Deleted --- PASS: TestDelete (68.64s) === RUN TestMaxDelete run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", 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-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" operations_test.go:432: Skipping test on chunker backend --- SKIP: TestMaxDeleteSizeLargeFile (1.58s) === RUN TestMaxDeleteSize run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" operations_test.go:432: Skipping test on chunker backend --- SKIP: TestMaxDeleteSize (2.80s) === RUN TestReadFile run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:34:55 INFO : ReadFile.rclone_chunk.001_jsbimy: Moved (server-side) to: ReadFile --- PASS: TestReadFile (12.66s) === RUN TestRetry 2025/03/03 10:35:02 DEBUG : Received error: Wrapped EOF is retriable: EOF - low level retry 1/5 2025/03/03 10:35:02 DEBUG : Received error: Wrapped EOF is retriable: EOF - low level retry 2/5 2025/03/03 10:35:02 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG 2025/03/03 10:35:02 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG 2025/03/03 10:35:03 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG 2025/03/03 10:35:03 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG 2025/03/03 10:35:03 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-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:35:09 INFO : file1.rclone_chunk.001_jsbvgd: Moved (server-side) to: file1 2025/03/03 10:35:15 INFO : file2.rclone_chunk.001_jsc16w: Moved (server-side) to: file2 --- PASS: TestCat (31.01s) === RUN TestPurge 2025/03/03 10:35:34 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-dayajoy0kaze" 2025/03/03 10:35:34 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/03 10:35:34 DEBUG : Creating backend with remote "TestYandex:rclone-test-dayajoy0kaze" 2025/03/03 10:35:34 DEBUG : Reset feature "ListR" 2025/03/03 10:35:34 DEBUG : Creating backend with remote "/tmp/rclone3420964424" run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-dayajoy0kaze'", Local "Local file system at /tmp/rclone3420964424", Modify Window "1ns" 2025/03/03 10:35:42 INFO : A1/B1/C1/one.rclone_chunk.001_jscr0s: Moved (server-side) to: A1/B1/C1/one 2025/03/03 10:35:42 INFO : A2: Making directory 2025/03/03 10:35:43 INFO : A1/B2: Making directory 2025/03/03 10:35:43 INFO : A1/B2/C2: Making directory 2025/03/03 10:35:44 INFO : A1/B1/C3: Making directory 2025/03/03 10:35:44 INFO : A3: Making directory 2025/03/03 10:35:45 INFO : A3/B3: Making directory 2025/03/03 10:35:45 INFO : A3/B3/C4: Making directory 2025/03/03 10:35:54 INFO : A1/two.rclone_chunk.001_jsd2ot: Moved (server-side) to: A1/two 2025/03/03 10:36:12 ERROR : : error listing: directory not found 2025/03/03 10:36:12 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-dayajoy0kaze': Purge remote 2025/03/03 10:36:14 NOTICE: purge failed: [404 - DiskNotFoundError] Resource not found. (Не удалось найти запрошенный ресурс.) --- PASS: TestPurge (40.33s) === RUN TestRmdirsNoLeaveRoot run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:36:29 INFO : A1/B1/C1/one.rclone_chunk.001_jsdvkd: Moved (server-side) to: A1/B1/C1/one 2025/03/03 10:36:29 INFO : A2: Making directory 2025/03/03 10:36:29 INFO : A1/B2: Making directory 2025/03/03 10:36:29 INFO : A1/B2/C2: Making directory 2025/03/03 10:36:30 INFO : A1/B1/C3: Making directory 2025/03/03 10:36:31 INFO : A3: Making directory 2025/03/03 10:36:31 INFO : A3/B3: Making directory 2025/03/03 10:36:32 INFO : A3/B3/C4: Making directory 2025/03/03 10:36:42 INFO : A1/two.rclone_chunk.001_jsedvx: Moved (server-side) to: A1/two 2025/03/03 10:36:45 DEBUG : removing 1 level 3 directories 2025/03/03 10:36:45 INFO : A3/B3/C4: Removing directory 2025/03/03 10:36:53 DEBUG : removing 2 level 3 directories 2025/03/03 10:36:53 INFO : A1/B2/C2: Removing directory 2025/03/03 10:36:53 INFO : A1/B1/C3: Removing directory 2025/03/03 10:36:57 DEBUG : removing 2 level 2 directories 2025/03/03 10:36:57 INFO : A3/B3: Removing directory 2025/03/03 10:36:57 INFO : A1/B2: Removing directory 2025/03/03 10:37:02 DEBUG : removing 2 level 1 directories 2025/03/03 10:37:02 INFO : A3: Removing directory 2025/03/03 10:37:02 INFO : A2: Removing directory 2025/03/03 10:37:22 DEBUG : removing 1 level 3 directories 2025/03/03 10:37:22 INFO : A1/B1/C1: Removing directory 2025/03/03 10:37:26 DEBUG : removing 1 level 2 directories 2025/03/03 10:37:26 INFO : A1/B1: Removing directory 2025/03/03 10:37:30 DEBUG : removing 1 level 1 directories 2025/03/03 10:37:30 INFO : A1: Removing directory 2025/03/03 10:37:34 DEBUG : removing 1 level 0 directories 2025/03/03 10:37:34 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo': Removing directory 2025/03/03 10:37:38 ERROR : : error listing: directory not found 2025/03/03 10:37:39 ERROR : : error listing: directory not found --- PASS: TestRmdirsNoLeaveRoot (84.79s) === RUN TestRmdirsLeaveRoot run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:37:39 INFO : A1: Making directory 2025/03/03 10:37:40 INFO : A1/B1: Making directory 2025/03/03 10:37:40 INFO : A1/B1/C1: Making directory 2025/03/03 10:37:44 DEBUG : removing 1 level 3 directories 2025/03/03 10:37:44 INFO : A1/B1/C1: Removing directory 2025/03/03 10:37:48 DEBUG : removing 1 level 2 directories 2025/03/03 10:37:48 INFO : A1/B1: Removing directory --- PASS: TestRmdirsLeaveRoot (20.51s) === RUN TestRmdirsWithFilter run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:37:59 INFO : A1: Making directory 2025/03/03 10:38:00 INFO : A1/B1: Making directory 2025/03/03 10:38:00 INFO : A1/B1/C1: Making directory 2025/03/03 10:38:08 DEBUG : removing 1 level 3 directories 2025/03/03 10:38:08 INFO : A1/B1/C1: Removing directory 2025/03/03 10:38:13 DEBUG : removing 1 level 2 directories 2025/03/03 10:38:13 INFO : A1/B1: Removing directory --- PASS: TestRmdirsWithFilter (25.24s) === RUN TestCopyURL run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:38:31 INFO : file1.rclone_chunk.001_jshh25: Moved (server-side) to: file1 2025/03/03 10:38:32 DEBUG : filename.txt: File name found in url 2025/03/03 10:38:38 INFO : filename.txt.rclone_chunk.001_jshphi: Moved (server-side) to: filename.txt 2025/03/03 10:38:38 DEBUG : headerfilename.txt: filename found in Content-Disposition header. 2025/03/03 10:38:46 INFO : headerfilename.txt.rclone_chunk.001_jshugw: Moved (server-side) to: headerfilename.txt 2025/03/03 10:38:51 INFO : file2.rclone_chunk.001_jsi2o9: Moved (server-side) to: file2 --- PASS: TestCopyURL (43.32s) === RUN TestCopyURLToWriter --- PASS: TestCopyURLToWriter (0.00s) === RUN TestMoveFile run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:39:08 DEBUG : file1: Need to transfer - File not found at Destination 2025/03/03 10:39:18 INFO : sub/file2.rclone_chunk.001_jsio5s: Moved (server-side) to: sub/file2 2025/03/03 10:39:18 DEBUG : file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2025/03/03 10:39:18 INFO : file1: Copied (new) to: sub/file2 2025/03/03 10:39:18 INFO : file1: Deleted 2025/03/03 10:39:19 DEBUG : file1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/03 10:39:19 DEBUG : file1: Unchanged skipping 2025/03/03 10:39:19 INFO : file1: Deleted 2025/03/03 10:39:20 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo': don't need to copy/move sub/file2, it is already at target location --- PASS: TestMoveFile (22.68s) === RUN TestMoveFileWithIgnoreExisting run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:39:31 DEBUG : file1: Need to transfer - File not found at Destination 2025/03/03 10:39:31 DEBUG : file1: skip slow MD5 on source file, hashing in-transit 2025/03/03 10:39:37 INFO : file1.rclone_chunk.001_jsjb5n: Moved (server-side) to: file1 2025/03/03 10:39:37 DEBUG : file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2025/03/03 10:39:37 INFO : file1: Copied (new) 2025/03/03 10:39:37 INFO : file1: Deleted 2025/03/03 10:39:38 DEBUG : file1: Destination exists, skipping 2025/03/03 10:39:38 DEBUG : file1: Not removing source file as destination file exists and --ignore-existing is set --- PASS: TestMoveFileWithIgnoreExisting (12.95s) === RUN TestCaseInsensitiveMoveFile run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" --- PASS: TestCaseInsensitiveMoveFile (0.86s) === RUN TestCaseInsensitiveMoveFileDryRun run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" --- PASS: TestCaseInsensitiveMoveFileDryRun (0.58s) === RUN TestMoveFileBackupDir run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:39:51 INFO : dst/file1.rclone_chunk.001_jsjpo5: Moved (server-side) to: dst/file1 2025/03/03 10:39:53 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo/backup" 2025/03/03 10:39:53 DEBUG : Creating backend with remote "TestYandex:rclone-test-bosuxuy5yafo/backup" 2025/03/03 10:39:53 DEBUG : Reset feature "ListR" 2025/03/03 10:39:53 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18) 2025/03/03 10:39:54 DEBUG : dst/file1: move non-chunked object... 2025/03/03 10:39:58 INFO : dst/file1: Moved (server-side) 2025/03/03 10:39:58 INFO : dst/file1: Moved (server-side) 2025/03/03 10:39:58 DEBUG : dst/file1: skip slow MD5 on source file, hashing in-transit 2025/03/03 10:40:05 INFO : dst/file1.rclone_chunk.001_jsk2cn: Moved (server-side) to: dst/file1 2025/03/03 10:40:05 DEBUG : dst/file1: md5 = 0ef726ce9b1a7692357ff70dd321d595 OK 2025/03/03 10:40:05 INFO : dst/file1: Copied (new) 2025/03/03 10:40:05 INFO : dst/file1: Deleted --- PASS: TestMoveFileBackupDir (46.35s) === 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-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:40:44 INFO : A1/one.rclone_chunk.001_jsl0u8: Moved (server-side) to: A1/one 2025/03/03 10:40:49 INFO : A1/two.rclone_chunk.001_jslcg6: Moved (server-side) to: A1/two 2025/03/03 10:41:04 INFO : A1/B1/three.rclone_chunk.001_jsliym: Moved (server-side) to: A1/B1/three 2025/03/03 10:41:12 INFO : A1/B1/C1/four.rclone_chunk.001_jslwiq: Moved (server-side) to: A1/B1/C1/four 2025/03/03 10:41:20 INFO : A1/B1/C2/five.rclone_chunk.001_jsm47t: Moved (server-side) to: A1/B1/C2/five 2025/03/03 10:41:20 INFO : A1/B2: Making directory 2025/03/03 10:41:21 INFO : A1/B1/C3: Making directory 2025/03/03 10:41:33 DEBUG : A2/B1/three: move non-chunked object... 2025/03/03 10:41:33 DEBUG : A2/two: move non-chunked object... 2025/03/03 10:41:33 DEBUG : A2/B1/C2/five: move non-chunked object... 2025/03/03 10:41:33 DEBUG : A2/B1/C1/four: move non-chunked object... 2025/03/03 10:41:33 DEBUG : A2/one: move non-chunked object... 2025/03/03 10:41:35 INFO : A2/B1/C1/four: Moved (server-side) to: A3/B1/C1/four 2025/03/03 10:41:35 INFO : A2/B1/C1/four: Moved (server-side) to: A3/B1/C1/four 2025/03/03 10:41:35 INFO : A2/B1/three: Moved (server-side) to: A3/B1/three 2025/03/03 10:41:35 INFO : A2/B1/three: Moved (server-side) to: A3/B1/three 2025/03/03 10:41:35 INFO : A2/B1/C2/five: Moved (server-side) to: A3/B1/C2/five 2025/03/03 10:41:35 INFO : A2/B1/C2/five: Moved (server-side) to: A3/B1/C2/five 2025/03/03 10:41:35 INFO : A2/two: Moved (server-side) to: A3/two 2025/03/03 10:41:35 INFO : A2/two: Moved (server-side) to: A3/two 2025/03/03 10:41:35 INFO : A2/one: Moved (server-side) to: A3/one 2025/03/03 10:41:35 INFO : A2/one: Moved (server-side) to: A3/one 2025/03/03 10:42:03 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo': Can't DirMove - falling back to file moves: can't move directory - incompatible remotes 2025/03/03 10:42:08 DEBUG : A3/two: move non-chunked object... 2025/03/03 10:42:08 DEBUG : A3/B1/three: move non-chunked object... 2025/03/03 10:42:08 DEBUG : A3/B1/C1/four: move non-chunked object... 2025/03/03 10:42:08 DEBUG : A3/one: move non-chunked object... 2025/03/03 10:42:08 DEBUG : A3/B1/C2/five: move non-chunked object... 2025/03/03 10:42:09 INFO : A3/two: Moved (server-side) to: A4/two 2025/03/03 10:42:09 INFO : A3/two: Moved (server-side) to: A4/two 2025/03/03 10:42:10 INFO : A3/B1/three: Moved (server-side) to: A4/B1/three 2025/03/03 10:42:10 INFO : A3/B1/three: Moved (server-side) to: A4/B1/three 2025/03/03 10:42:10 INFO : A3/B1/C2/five: Moved (server-side) to: A4/B1/C2/five 2025/03/03 10:42:10 INFO : A3/B1/C2/five: Moved (server-side) to: A4/B1/C2/five 2025/03/03 10:42:10 INFO : A3/one: Moved (server-side) to: A4/one 2025/03/03 10:42:10 INFO : A3/one: Moved (server-side) to: A4/one 2025/03/03 10:42:11 INFO : A3/B1/C1/four: Moved (server-side) to: A4/B1/C1/four 2025/03/03 10:42:11 INFO : A3/B1/C1/four: Moved (server-side) to: A4/B1/C1/four --- PASS: TestDirMove (275.08s) === RUN TestGetFsInfo run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" --- PASS: TestGetFsInfo (0.77s) === RUN TestRcat === RUN TestRcat/withChecksum=false,ignoreChecksum=false run.go:180: Remote "Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" operations_test.go:1495: Adjust StreamingUploadCutoff to size limit 1Ki (was 100Ki) 2025/03/03 10:45:07 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo': File to upload is small (34 bytes), uploading instead of streaming 2025/03/03 10:45:13 INFO : no_checksum_small_file_from_pipe.rclone_chunk.001_jsso7u: Moved (server-side) to: no_checksum_small_file_from_pipe 2025/03/03 10:45:13 DEBUG : no_checksum_small_file_from_pipe: md5 = 4c762bc6ec18f21b23fcae426c7863b5 OK 2025/03/03 10:45:13 DEBUG : no_checksum_small_file_from_pipe: Size and md5 of src and dst objects identical 2025/03/03 10:46:17 INFO : no_checksum_big_file_from_pipe.rclone_chunk.001_jssur0: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.001 2025/03/03 10:46:19 INFO : no_checksum_big_file_from_pipe.rclone_chunk.002_jssur0: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.002 2025/03/03 10:46:21 INFO : no_checksum_big_file_from_pipe.rclone_chunk.003_jssur0: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.003 2025/03/03 10:46:23 INFO : no_checksum_big_file_from_pipe.rclone_chunk.004_jssur0: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.004 2025/03/03 10:46:25 INFO : no_checksum_big_file_from_pipe.rclone_chunk.005_jssur0: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.005 2025/03/03 10:46:27 INFO : no_checksum_big_file_from_pipe.rclone_chunk.006_jssur0: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.006 2025/03/03 10:46:31 INFO : no_checksum_big_file_from_pipe.rclone_chunk.007_jssur0: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.007 2025/03/03 10:46:33 INFO : no_checksum_big_file_from_pipe.rclone_chunk.008_jssur0: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.008 2025/03/03 10:46:35 INFO : no_checksum_big_file_from_pipe.rclone_chunk.009_jssur0: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.009 2025/03/03 10:46:38 INFO : no_checksum_big_file_from_pipe.rclone_chunk.010_jssur0: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.010 2025/03/03 10:46:39 INFO : no_checksum_big_file_from_pipe.rclone_chunk.011_jssur0: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.011 2025/03/03 10:46:41 INFO : no_checksum_big_file_from_pipe.rclone_chunk.012_jssur0: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.012 2025/03/03 10:46:43 INFO : no_checksum_big_file_from_pipe.rclone_chunk.013_jssur0: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.013 2025/03/03 10:46:45 INFO : no_checksum_big_file_from_pipe.rclone_chunk.014_jssur0: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.014 2025/03/03 10:46:46 INFO : no_checksum_big_file_from_pipe.rclone_chunk.015_jssur0: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.015 2025/03/03 10:46:48 INFO : no_checksum_big_file_from_pipe.rclone_chunk.016_jssur0: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.016 2025/03/03 10:46:51 INFO : no_checksum_big_file_from_pipe.rclone_chunk.017_jssur0: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.017 2025/03/03 10:46:53 INFO : no_checksum_big_file_from_pipe.rclone_chunk.018_jssur0: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.018 2025/03/03 10:46:55 INFO : no_checksum_big_file_from_pipe.rclone_chunk.019_jssur0: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.019 2025/03/03 10:46:57 INFO : no_checksum_big_file_from_pipe.rclone_chunk.020_jssur0: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.020 2025/03/03 10:46:59 INFO : no_checksum_big_file_from_pipe.rclone_chunk.021_jssur0: Moved (server-side) to: no_checksum_big_file_from_pipe.rclone_chunk.021 2025/03/03 10:47:06 DEBUG : no_checksum_big_file_from_pipe: md5 = 0ad4cf7b35f62b8ff9c73f481594fbdd OK 2025/03/03 10:47:06 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-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:48:37 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo': File to upload is small (34 bytes), uploading instead of streaming 2025/03/03 10:48:43 INFO : with_checksum_small_file_from_pipe.rclone_chunk.001_jsyhx4: Moved (server-side) to: with_checksum_small_file_from_pipe 2025/03/03 10:48:43 DEBUG : with_checksum_small_file_from_pipe: md5 = 4c762bc6ec18f21b23fcae426c7863b5 OK 2025/03/03 10:48:43 DEBUG : with_checksum_small_file_from_pipe: Size and md5 of src and dst objects identical 2025/03/03 10:49:50 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2025/03/03 10:49:50 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2025/03/03 10:49:50 DEBUG : pacer: Reducing sleep to 15ms 2025/03/03 10:49:50 DEBUG : pacer: Reducing sleep to 11.25ms 2025/03/03 10:49:52 DEBUG : pacer: Reducing sleep to 10ms 2025/03/03 10:50:07 INFO : with_checksum_big_file_from_pipe.rclone_chunk.001_jsynsn: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.001 2025/03/03 10:50:09 INFO : with_checksum_big_file_from_pipe.rclone_chunk.002_jsynsn: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.002 2025/03/03 10:50:11 INFO : with_checksum_big_file_from_pipe.rclone_chunk.003_jsynsn: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.003 2025/03/03 10:50:13 INFO : with_checksum_big_file_from_pipe.rclone_chunk.004_jsynsn: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.004 2025/03/03 10:50:15 INFO : with_checksum_big_file_from_pipe.rclone_chunk.005_jsynsn: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.005 2025/03/03 10:50:17 INFO : with_checksum_big_file_from_pipe.rclone_chunk.006_jsynsn: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.006 2025/03/03 10:50:20 INFO : with_checksum_big_file_from_pipe.rclone_chunk.007_jsynsn: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.007 2025/03/03 10:50:22 INFO : with_checksum_big_file_from_pipe.rclone_chunk.008_jsynsn: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.008 2025/03/03 10:50:23 INFO : with_checksum_big_file_from_pipe.rclone_chunk.009_jsynsn: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.009 2025/03/03 10:50:25 INFO : with_checksum_big_file_from_pipe.rclone_chunk.010_jsynsn: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.010 2025/03/03 10:50:26 INFO : with_checksum_big_file_from_pipe.rclone_chunk.011_jsynsn: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.011 2025/03/03 10:50:29 INFO : with_checksum_big_file_from_pipe.rclone_chunk.012_jsynsn: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.012 2025/03/03 10:50:31 INFO : with_checksum_big_file_from_pipe.rclone_chunk.013_jsynsn: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.013 2025/03/03 10:50:32 INFO : with_checksum_big_file_from_pipe.rclone_chunk.014_jsynsn: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.014 2025/03/03 10:50:35 INFO : with_checksum_big_file_from_pipe.rclone_chunk.015_jsynsn: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.015 2025/03/03 10:50:39 INFO : with_checksum_big_file_from_pipe.rclone_chunk.016_jsynsn: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.016 2025/03/03 10:50:41 INFO : with_checksum_big_file_from_pipe.rclone_chunk.017_jsynsn: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.017 2025/03/03 10:50:43 INFO : with_checksum_big_file_from_pipe.rclone_chunk.018_jsynsn: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.018 2025/03/03 10:50:45 INFO : with_checksum_big_file_from_pipe.rclone_chunk.019_jsynsn: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.019 2025/03/03 10:50:47 INFO : with_checksum_big_file_from_pipe.rclone_chunk.020_jsynsn: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.020 2025/03/03 10:50:49 INFO : with_checksum_big_file_from_pipe.rclone_chunk.021_jsynsn: Moved (server-side) to: with_checksum_big_file_from_pipe.rclone_chunk.021 2025/03/03 10:50:52 DEBUG : with_checksum_big_file_from_pipe: md5 = 0ad4cf7b35f62b8ff9c73f481594fbdd OK 2025/03/03 10:50: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-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:52:33 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo': File to upload is small (34 bytes), uploading instead of streaming 2025/03/03 10:52:41 INFO : ignore_checksum_small_file_from_pipe.rclone_chunk.001_jt51uh: Moved (server-side) to: ignore_checksum_small_file_from_pipe 2025/03/03 10:52:41 DEBUG : ignore_checksum_small_file_from_pipe: Size and modification time the same (differ by 0s, within tolerance 1ns) 2025/03/03 10:53:51 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.001_jt59gd: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.001 2025/03/03 10:53:52 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.002_jt59gd: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.002 2025/03/03 10:53:54 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.003_jt59gd: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.003 2025/03/03 10:53:56 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.004_jt59gd: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.004 2025/03/03 10:53:58 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.005_jt59gd: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.005 2025/03/03 10:54:03 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.006_jt59gd: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.006 2025/03/03 10:54:09 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.007_jt59gd: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.007 2025/03/03 10:54:11 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.008_jt59gd: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.008 2025/03/03 10:54:13 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.009_jt59gd: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.009 2025/03/03 10:54:15 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.010_jt59gd: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.010 2025/03/03 10:54:20 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.011_jt59gd: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.011 2025/03/03 10:54:21 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.012_jt59gd: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.012 2025/03/03 10:54:25 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.013_jt59gd: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.013 2025/03/03 10:54:27 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.014_jt59gd: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.014 2025/03/03 10:54:29 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.015_jt59gd: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.015 2025/03/03 10:54:31 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.016_jt59gd: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.016 2025/03/03 10:54:33 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.017_jt59gd: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.017 2025/03/03 10:54:35 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.018_jt59gd: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.018 2025/03/03 10:54:37 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.019_jt59gd: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.019 2025/03/03 10:54:39 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.020_jt59gd: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.020 2025/03/03 10:54:41 INFO : ignore_checksum_big_file_from_pipe.rclone_chunk.021_jt59gd: Moved (server-side) to: ignore_checksum_big_file_from_pipe.rclone_chunk.021 2025/03/03 10:54:43 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-bosuxuy5yafo'", Local "Local file system at /tmp/rclone2325820316", Modify Window "1ns" 2025/03/03 10:56:12 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-bosuxuy5yafo': File to upload is small (34 bytes), uploading instead of streaming 2025/03/03 10:56:24 INFO : ignore_checksum_small_file_from_pipe.rclone_chunk.001_jtb448: Moved (server-side) to: ignore_checksum_small_file_from_pipe 2025/03/03 10:56:24 DEBUG : ignore_checksum_small_file_from_pipe: Src hash empty - aborting Dst hash check 2025/03/03 10:56:24 DEBUG : ignore_checksum_small_file_from_pipe: Size of src and dst objects identical panic: test timed out after 1h0m0s running tests: TestRcat (12m4s) TestRcat/withChecksum=true,ignoreChecksum=true (59s) goroutine 13962 [running]: testing.(*M).startAlarm.func1() /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:2373 +0x385 created by time.goFunc /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/time/sleep.go:215 +0x2d goroutine 1 [chan receive, 12 minutes]: testing.(*T).Run(0xc0007a2340, {0x25dd5f3?, 0x0?}, 0x2725f00) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1751 +0x3ab testing.runTests.func1(0xc0007a2340) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:2168 +0x37 testing.tRunner(0xc0007a2340, 0xc00080fc18) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1690 +0xf4 testing.runTests(0xc000996570, {0x3d066a0, 0x6c, 0x6c}, {0x3d1ae20?, 0x1?, 0x3d1ae20?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:2166 +0x43d testing.(*M).Run(0xc0006e7b80) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:2034 +0x64a github.com/rclone/rclone/fstest.TestMain(0xc0006e7b80) /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:263 +0xa9 goroutine 10 [syscall, 60 minutes]: os/signal.signal_recv() /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/sigqueue.go:152 +0x29 os/signal.loop() /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/os/signal/signal_unix.go:23 +0x13 created by os/signal.Notify.func1.1 in goroutine 1 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/os/signal/signal.go:151 +0x1f goroutine 10021 [select]: github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0xc0008d4000) /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:339 +0x13d created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 10020 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:404 +0xb6 goroutine 11 [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 13845 [IO wait]: internal/poll.runtime_pollWait(0x7fe3d84272c8, 0x72) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc000ddbb80?, 0xc000a0a600?, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc000ddbb80, {0xc000a0a600, 0x1300, 0x1300}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc000ddbb80, {0xc000a0a600?, 0xc000a0a600?, 0x2?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc00095c350, {0xc000a0a600?, 0x3d1ae20?, 0xc0008e99d0?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/net.go:189 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000789d88, {0xc000a0a600?, 0x18?, 0x7fe3d84068f0?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x2c crypto/tls.(*atLeastReader).Read(0xc000848bb8, {0xc000a0a600?, 0x0?, 0xc000848bb8?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc000a062b8, {0x29dc780, 0xc000848bb8}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc000a06008, {0x7fe3d8295018, 0xc000789d88}, 0xc0008e9a40?) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc000a06008, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc000a06008, {0xc0008c0000, 0x1000, 0xc000909308?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:1385 +0x150 net/http.(*persistConn).Read(0xc0004f4120, {0xc0008c0000?, 0x81d405?, 0x214b620?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2052 +0x4a bufio.(*Reader).fill(0xc000a33ec0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:110 +0x103 bufio.(*Reader).Peek(0xc000a33ec0, 0x1) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:148 +0x53 net/http.(*persistConn).readLoop(0xc0004f4120) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2205 +0x185 created by net/http.(*Transport).dialConn in goroutine 13823 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1874 +0x154f goroutine 1402 [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:211 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 1376 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:209 +0x378 goroutine 13923 [select]: net/http.(*persistConn).writeLoop(0xc0004f45a0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2519 +0xe7 created by net/http.(*Transport).dialConn in goroutine 13852 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1875 +0x15a5 goroutine 13896 [IO wait]: internal/poll.runtime_pollWait(0x7fe3d8426da0, 0x72) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc000ca3400?, 0xc000d1f300?, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc000ca3400, {0xc000d1f300, 0x1300, 0x1300}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc000ca3400, {0xc000d1f300?, 0xc000d1f300?, 0x2?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc00008aa28, {0xc000d1f300?, 0x3d1ae20?, 0xc0006399d0?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/net.go:189 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000849bf0, {0xc000d1f300?, 0x18?, 0x0?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x2c crypto/tls.(*atLeastReader).Read(0xc000115020, {0xc000d1f300?, 0x0?, 0xc000115020?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc000c509b8, {0x29dc780, 0xc000115020}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc000c50708, {0x7fe3d8295018, 0xc000849bf0}, 0xc000639a40?) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc000c50708, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc000c50708, {0xc0009a2000, 0x1000, 0xc000909308?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:1385 +0x150 net/http.(*persistConn).Read(0xc000cb8900, {0xc0009a2000?, 0x81d405?, 0x214b620?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2052 +0x4a bufio.(*Reader).fill(0xc000af3bc0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:110 +0x103 bufio.(*Reader).Peek(0xc000af3bc0, 0x1) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:148 +0x53 net/http.(*persistConn).readLoop(0xc000cb8900) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2205 +0x185 created by net/http.(*Transport).dialConn in goroutine 13890 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1874 +0x154f goroutine 187 [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:211 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 177 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:209 +0x378 goroutine 13939 [select]: net/http.(*persistConn).writeLoop(0xc000a4ea20) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2519 +0xe7 created by net/http.(*Transport).dialConn in goroutine 13916 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1875 +0x15a5 goroutine 4512 [chan receive, 45 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 4198 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 13897 [select]: net/http.(*persistConn).writeLoop(0xc000cb8900) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2519 +0xe7 created by net/http.(*Transport).dialConn in goroutine 13890 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1875 +0x15a5 goroutine 467 [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:211 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 457 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:209 +0x378 goroutine 220 [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:211 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 210 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:209 +0x378 goroutine 1361 [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:211 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 1351 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:209 +0x378 goroutine 1562 [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:211 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 1552 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:209 +0x378 goroutine 13820 [IO wait]: internal/poll.runtime_pollWait(0x7fe3d8e1c270, 0x72) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc000ca2a00?, 0xc000a09300?, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc000ca2a00, {0xc000a09300, 0x1300, 0x1300}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc000ca2a00, {0xc000a09300?, 0xc000a09300?, 0x2?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc00095c2f0, {0xc000a09300?, 0x3d1ae20?, 0xc0008e49d0?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/net.go:189 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000789848, {0xc000a09300?, 0x18?, 0x7fe3d844b198?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x2c crypto/tls.(*atLeastReader).Read(0xc000996a08, {0xc000a09300?, 0x0?, 0xc000996a08?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc0004a7eb8, {0x29dc780, 0xc000996a08}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc0004a7c08, {0x7fe3d8295018, 0xc000789848}, 0xc0008e4a40?) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc0004a7c08, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc0004a7c08, {0xc000709000, 0x1000, 0xc000100508?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:1385 +0x150 net/http.(*persistConn).Read(0xc0004f4000, {0xc000709000?, 0x81d405?, 0x214b620?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2052 +0x4a bufio.(*Reader).fill(0xc000e50660) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:110 +0x103 bufio.(*Reader).Peek(0xc000e50660, 0x1) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:148 +0x53 net/http.(*persistConn).readLoop(0xc0004f4000) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2205 +0x185 created by net/http.(*Transport).dialConn in goroutine 13814 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1874 +0x154f goroutine 13821 [select]: net/http.(*persistConn).writeLoop(0xc0004f4000) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2519 +0xe7 created by net/http.(*Transport).dialConn in goroutine 13814 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1875 +0x15a5 goroutine 719 [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:211 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 709 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:209 +0x378 goroutine 286 [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:211 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 276 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:209 +0x378 goroutine 1651 [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:211 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 1625 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:209 +0x378 goroutine 13861 [IO wait]: internal/poll.runtime_pollWait(0x7fe3d84277f0, 0x72) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc000ddbd80?, 0xc000d1e000?, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc000ddbd80, {0xc000d1e000, 0x1300, 0x1300}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc000ddbd80, {0xc000d1e000?, 0xc000d1e000?, 0x2?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc00008a688, {0xc000d1e000?, 0x3d1ae20?, 0xc0008e39d0?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/net.go:189 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000848ff0, {0xc000d1e000?, 0x18?, 0x3a00000000?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x2c crypto/tls.(*atLeastReader).Read(0xc0008494e8, {0xc000d1e000?, 0x0?, 0xc0008494e8?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc000c50638, {0x29dc780, 0xc0008494e8}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc000c50388, {0x7fe3d8295018, 0xc000848ff0}, 0xc0008e3a40?) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc000c50388, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc000c50388, {0xc00083b000, 0x1000, 0xc000909308?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:1385 +0x150 net/http.(*persistConn).Read(0xc000cb8480, {0xc00083b000?, 0x81d405?, 0x214b620?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2052 +0x4a bufio.(*Reader).fill(0xc000c9fec0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:110 +0x103 bufio.(*Reader).Peek(0xc000c9fec0, 0x1) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:148 +0x53 net/http.(*persistConn).readLoop(0xc000cb8480) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2205 +0x185 created by net/http.(*Transport).dialConn in goroutine 13837 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1874 +0x154f goroutine 12103 [chan receive]: testing.(*T).Run(0xc000180340, {0xc000b340c0?, 0xc00009ef40?}, 0xc000996360) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1751 +0x3ab github.com/rclone/rclone/fs/operations_test.TestRcat(0xc000180340) /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1522 +0xcd testing.tRunner(0xc000180340, 0x2725f00) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1690 +0xf4 created by testing.(*T).Run in goroutine 1 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1743 +0x390 goroutine 11611 [select]: net/http.(*persistConn).writeLoop(0xc000a4e6c0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2519 +0xe7 created by net/http.(*Transport).dialConn in goroutine 11602 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1875 +0x15a5 goroutine 4199 [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 4198 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 370 [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:211 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 360 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:209 +0x378 goroutine 4488 [chan receive, 45 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 4198 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 559 [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:211 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 549 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:209 +0x378 goroutine 4842 [chan receive, 44 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 4198 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 13647 [IO wait]: internal/poll.runtime_pollWait(0x7fe3d8e1c168, 0x72) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc000ca2800?, 0xc000a08000?, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc000ca2800, {0xc000a08000, 0x1300, 0x1300}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc000ca2800, {0xc000a08000?, 0xc000a08000?, 0x2?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc00095c170, {0xc000a08000?, 0x3d1ae20?, 0xc000d019d0?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/net.go:189 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000788b40, {0xc000a08000?, 0x18?, 0x7fe3d8196238?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x2c crypto/tls.(*atLeastReader).Read(0xc000789398, {0xc000a08000?, 0x0?, 0xc000789398?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc0004a7b38, {0x29dc780, 0xc000789398}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc0004a7888, {0x7fe3d8295018, 0xc000788b40}, 0xc000d01a40?) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc0004a7888, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc0004a7888, {0xc000e4d000, 0x1000, 0xc000392508?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:1385 +0x150 net/http.(*persistConn).Read(0xc000a4e000, {0xc000e4d000?, 0x81d405?, 0x214b620?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2052 +0x4a bufio.(*Reader).fill(0xc0009fbe60) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:110 +0x103 bufio.(*Reader).Peek(0xc0009fbe60, 0x1) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:148 +0x53 net/http.(*persistConn).readLoop(0xc000a4e000) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2205 +0x185 created by net/http.(*Transport).dialConn in goroutine 13777 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1874 +0x154f goroutine 4805 [chan receive, 44 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 4198 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 5114 [chan receive, 44 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 4198 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 596 [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:211 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 538 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:209 +0x378 goroutine 1307 [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:211 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 1297 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:209 +0x378 goroutine 13889 [select]: net/http.(*persistConn).writeLoop(0xc000a4e360) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2519 +0xe7 created by net/http.(*Transport).dialConn in goroutine 13880 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1875 +0x15a5 goroutine 1020 [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:211 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 1010 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:209 +0x378 goroutine 775 [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:211 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 765 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:209 +0x378 goroutine 646 [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:211 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 637 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:209 +0x378 goroutine 13960 [IO wait]: internal/poll.runtime_pollWait(0x7fe3d8426fb0, 0x72) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc000ca3900?, 0xc000d22c00?, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc000ca3900, {0xc000d22c00, 0x1300, 0x1300}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc000ca3900, {0xc000d22c00?, 0xc000d22d2f?, 0x2?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc00008ab50, {0xc000d22c00?, 0x3d1ae20?, 0xc00063a9d0?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/net.go:189 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000936648, {0xc000d22c00?, 0x18?, 0x4190a5?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x2c crypto/tls.(*atLeastReader).Read(0xc000382570, {0xc000d22c00?, 0x0?, 0xc000382570?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc000c510b8, {0x29dc780, 0xc000382570}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc000c50e08, {0x7fe3d8295018, 0xc000936648}, 0x100000011d1?) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc000c50e08, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc000c50e08, {0xc000b20000, 0x1000, 0x30?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:1385 +0x150 net/http.(*persistConn).Read(0xc000cb8c60, {0xc000b20000?, 0x40a8a5?, 0x68?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2052 +0x4a bufio.(*Reader).fill(0xc000ea1da0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:110 +0x103 bufio.(*Reader).Peek(0xc000ea1da0, 0x1) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:148 +0x53 net/http.(*persistConn).readLoop(0xc000cb8c60) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2205 +0x185 created by net/http.(*Transport).dialConn in goroutine 13954 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1874 +0x154f goroutine 13938 [IO wait]: internal/poll.runtime_pollWait(0x7fe3d8e1c798, 0x72) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc0006f4880?, 0xc000af8600?, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc0006f4880, {0xc000af8600, 0x1300, 0x1300}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc0006f4880, {0xc000af8600?, 0xc00063d868?, 0x2?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc0004e6538, {0xc000af8600?, 0x3d1ae20?, 0xc00063d9d0?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/net.go:189 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000997c50, {0xc000af8600?, 0x18?, 0x7fe3d81973b8?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x2c crypto/tls.(*atLeastReader).Read(0xc000382330, {0xc000af8600?, 0x0?, 0xc000382330?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc00088db38, {0x29dc780, 0xc000382330}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc00088d888, {0x7fe3d8295018, 0xc000997c50}, 0xc00063da40?) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc00088d888, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc00088d888, {0xc000aa1000, 0x1000, 0xc000100508?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:1385 +0x150 net/http.(*persistConn).Read(0xc000a4ea20, {0xc000aa1000?, 0x81d405?, 0x214b620?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2052 +0x4a bufio.(*Reader).fill(0xc000385ce0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:110 +0x103 bufio.(*Reader).Peek(0xc000385ce0, 0x1) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:148 +0x53 net/http.(*persistConn).readLoop(0xc000a4ea20) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2205 +0x185 created by net/http.(*Transport).dialConn in goroutine 13916 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1874 +0x154f goroutine 13876 [IO wait]: internal/poll.runtime_pollWait(0x7fe3d84274d8, 0x72) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc000ca2c80?, 0xc000af6000?, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc000ca2c80, {0xc000af6000, 0x1300, 0x1300}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc000ca2c80, {0xc000af6000?, 0xc000af6000?, 0x2?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc0004e6320, {0xc000af6000?, 0x3d1ae20?, 0xc0008e69d0?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/net.go:189 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000996c48, {0xc000af6000?, 0x18?, 0xc00096ac00?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x2c crypto/tls.(*atLeastReader).Read(0xc000114438, {0xc000af6000?, 0x0?, 0xc000114438?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc00088cd38, {0x29dc780, 0xc000114438}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc00088ca88, {0x7fe3d8295018, 0xc000996c48}, 0xc0008e6a40?) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc00088ca88, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc00088ca88, {0xc001151000, 0x1000, 0xc000392508?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:1385 +0x150 net/http.(*persistConn).Read(0xc000cb87e0, {0xc001151000?, 0x81d405?, 0x214b620?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2052 +0x4a bufio.(*Reader).fill(0xc000e1dec0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:110 +0x103 bufio.(*Reader).Peek(0xc000e1dec0, 0x1) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:148 +0x53 net/http.(*persistConn).readLoop(0xc000cb87e0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2205 +0x185 created by net/http.(*Transport).dialConn in goroutine 13867 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1874 +0x154f goroutine 839 [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:211 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 685 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:209 +0x378 goroutine 13648 [select]: net/http.(*persistConn).writeLoop(0xc000a4e000) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2519 +0xe7 created by net/http.(*Transport).dialConn in goroutine 13777 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1875 +0x15a5 goroutine 4707 [chan receive, 45 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 4198 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 4988 [chan receive, 44 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 4198 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 13827 [select]: github.com/rclone/rclone/fs/accounting.(*Account).averageLoop(0xc000c90900) /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:221 +0xed created by github.com/rclone/rclone/fs/accounting.newAccountSizeName in goroutine 13765 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:119 +0x438 goroutine 895 [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:211 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 885 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:209 +0x378 goroutine 1675 [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:211 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 1569 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:209 +0x378 goroutine 4387 [chan receive, 45 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 4198 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 1138 [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:211 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 1128 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:209 +0x378 goroutine 1194 [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:211 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 1152 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:209 +0x378 goroutine 4278 [chan receive, 45 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 4198 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 1516 [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:211 +0x3c created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 1506 /home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:209 +0x378 goroutine 13888 [IO wait]: internal/poll.runtime_pollWait(0x7fe3d8e1ced0, 0x72) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc000ca2f80?, 0xc000af7300?, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc000ca2f80, {0xc000af7300, 0x1300, 0x1300}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc000ca2f80, {0xc000af7300?, 0xc000af7300?, 0x2?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc0004e63b8, {0xc000af7300?, 0x3d1ae20?, 0xc000ab29d0?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/net.go:189 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc0009970c8, {0xc000af7300?, 0x18?, 0xc00096afc0?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x2c crypto/tls.(*atLeastReader).Read(0xc000114b70, {0xc000af7300?, 0x0?, 0xc000114b70?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc00088d7b8, {0x29dc780, 0xc000114b70}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc00088d508, {0x7fe3d8295018, 0xc0009970c8}, 0xc000ab2a40?) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc00088d508, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc00088d508, {0xc001166000, 0x1000, 0xc00008da08?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:1385 +0x150 net/http.(*persistConn).Read(0xc000a4e360, {0xc001166000?, 0x81d405?, 0x214b620?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2052 +0x4a bufio.(*Reader).fill(0xc000b05500) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:110 +0x103 bufio.(*Reader).Peek(0xc000b05500, 0x1) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:148 +0x53 net/http.(*persistConn).readLoop(0xc000a4e360) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2205 +0x185 created by net/http.(*Transport).dialConn in goroutine 13880 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1874 +0x154f goroutine 13902 [IO wait]: internal/poll.runtime_pollWait(0x7fe3d8e1ccc0, 0x72) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc000ca3600?, 0xc000d20600?, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc000ca3600, {0xc000d20600, 0x1300, 0x1300}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc000ca3600, {0xc000d20600?, 0xc000d20600?, 0x2?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc00095c538, {0xc000d20600?, 0x3d1ae20?, 0xc0009999d0?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/net.go:189 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000382180, {0xc000d20600?, 0x18?, 0xc00092ce40?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x2c crypto/tls.(*atLeastReader).Read(0xc0009363d8, {0xc000d20600?, 0x0?, 0xc0009363d8?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc000a070b8, {0x29dc780, 0xc0009363d8}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc000a06e08, {0x7fe3d8295018, 0xc000382180}, 0xc000999a40?) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc000a06e08, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc000a06e08, {0xc0009f5000, 0x1000, 0xc000392508?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:1385 +0x150 net/http.(*persistConn).Read(0xc0004f47e0, {0xc0009f5000?, 0x81d405?, 0x214b620?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2052 +0x4a bufio.(*Reader).fill(0xc000cc47e0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:110 +0x103 bufio.(*Reader).Peek(0xc000cc47e0, 0x1) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:148 +0x53 net/http.(*persistConn).readLoop(0xc0004f47e0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2205 +0x185 created by net/http.(*Transport).dialConn in goroutine 13925 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1874 +0x154f goroutine 13903 [select]: net/http.(*persistConn).writeLoop(0xc0004f47e0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2519 +0xe7 created by net/http.(*Transport).dialConn in goroutine 13925 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1875 +0x15a5 goroutine 13961 [select]: net/http.(*persistConn).writeLoop(0xc000cb8c60) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2519 +0xe7 created by net/http.(*Transport).dialConn in goroutine 13954 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1875 +0x15a5 goroutine 13862 [select]: net/http.(*persistConn).writeLoop(0xc000cb8480) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2519 +0xe7 created by net/http.(*Transport).dialConn in goroutine 13837 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1875 +0x15a5 goroutine 13846 [select]: net/http.(*persistConn).writeLoop(0xc0004f4120) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2519 +0xe7 created by net/http.(*Transport).dialConn in goroutine 13823 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1875 +0x15a5 goroutine 13922 [IO wait]: internal/poll.runtime_pollWait(0x7fe3d84271c0, 0x72) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc000412300?, 0xc000a0b900?, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc000412300, {0xc000a0b900, 0x1300, 0x1300}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc000412300, {0xc000a0b900?, 0xc000a0b900?, 0x2?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc00095c4b8, {0xc000a0b900?, 0x3d1ae20?, 0xc00099b9d0?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/net.go:189 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000115680, {0xc000a0b900?, 0x18?, 0xc00092cc80?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x2c crypto/tls.(*atLeastReader).Read(0xc000997470, {0xc000a0b900?, 0x0?, 0xc000997470?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc000a06d38, {0x29dc780, 0xc000997470}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc000a06a88, {0x7fe3d8295018, 0xc000115680}, 0xc00099ba40?) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc000a06a88, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc000a06a88, {0xc0008f7000, 0x1000, 0xc000100508?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:1385 +0x150 net/http.(*persistConn).Read(0xc0004f45a0, {0xc0008f7000?, 0x81d405?, 0x214b620?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2052 +0x4a bufio.(*Reader).fill(0xc000d412c0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:110 +0x103 bufio.(*Reader).Peek(0xc000d412c0, 0x1) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:148 +0x53 net/http.(*persistConn).readLoop(0xc0004f45a0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2205 +0x185 created by net/http.(*Transport).dialConn in goroutine 13852 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1874 +0x154f goroutine 10338 [chan receive, 22 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 10273 /home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7 goroutine 13765 [select]: net/http.(*persistConn).roundTrip(0xc000cb8c60, 0xc00098e410) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2755 +0x7b0 net/http.(*Transport).roundTrip(0xc0003e0f00, 0xc000e21e00) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:644 +0xb91 net/http.(*Transport).RoundTrip(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/roundtrip.go:30 github.com/rclone/rclone/fs/fshttp.(*Transport).RoundTrip(0xc0005a0cb0, 0xc000e21e00) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:349 +0x345 golang.org/x/oauth2.(*Transport).RoundTrip(0xc0008b39e0, 0xc000e21cc0) /home/rclone/go/pkg/mod/golang.org/x/oauth2@v0.27.0/transport.go:55 +0x3de net/http.send(0xc000e21cc0, {0x29de6c0, 0xc0008b39e0}, {0xc00006ad01?, 0x41790b?, 0x0?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/client.go:259 +0x5e4 net/http.(*Client).send(0xc00060a810, 0xc000e21cc0, {0xc000e46327?, 0xc00006adf0?, 0x0?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/client.go:180 +0x98 net/http.(*Client).do(0xc00060a810, 0xc000e21cc0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/client.go:725 +0x8bc net/http.(*Client).Do(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/client.go:590 github.com/rclone/rclone/lib/rest.(*Client).Call(0xc0003d3a40, {0x2a02540, 0xc000cdee70}, 0xc000a04640) /home/rclone/go/src/github.com/rclone/rclone/lib/rest/rest.go:353 +0xd67 github.com/rclone/rclone/backend/yandex.(*Object).upload.func2() /home/rclone/go/src/github.com/rclone/rclone/backend/yandex/yandex.go:1123 +0x4a github.com/rclone/rclone/fs.pacerInvoker(0x1, 0x1, 0xc0007231c0?) /home/rclone/go/src/github.com/rclone/rclone/fs/pacer.go:88 +0x32 github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc00011f7a0, 0xc0007231c0, 0x1) /home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:197 +0x7c github.com/rclone/rclone/lib/pacer.(*Pacer).CallNoRetry(...) /home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:225 github.com/rclone/rclone/backend/yandex.(*Object).upload(0xc000ce02a0, {0x2a02540, 0xc000cdee70}, {0x29dad00, 0xc0003823f0}, 0x1, {0x260ddfe, 0x18}, {0x0, 0x0, ...}) /home/rclone/go/src/github.com/rclone/rclone/backend/yandex/yandex.go:1122 +0x685 github.com/rclone/rclone/backend/yandex.(*Object).Update(0xc000ce02a0, {0x2a02540, 0xc000cdee70}, {0x29dcde0, 0xc00011b1e0}, {0x2a0cfa0, 0xc0006a7960}, {0x0, 0x0, 0x0}) /home/rclone/go/src/github.com/rclone/rclone/backend/yandex/yandex.go:1147 +0x20c github.com/rclone/rclone/backend/yandex.(*Fs).Put(0xc0004e4080, {0x2a02540, 0xc000cdee70}, {0x29dcde0, 0xc00011b1e0}, {0x2a0cfa0, 0xc0006a7960}, {0x0, 0x0, 0x0}) /home/rclone/go/src/github.com/rclone/rclone/backend/yandex/yandex.go:461 +0x1ab github.com/rclone/rclone/backend/yandex.(*Fs).PutStream(0x0?, {0x2a02540?, 0xc000cdee70?}, {0x29dcde0?, 0xc00011b1e0?}, {0x2a0cfa0?, 0xc0006a7960?}, {0x0, 0x0, 0x0}) /home/rclone/go/src/github.com/rclone/rclone/backend/yandex/yandex.go:466 +0x65 github.com/rclone/rclone/backend/chunker.(*Fs).put(0xc000780100, {0x2a02540, 0xc000cdee70}, {0x29daf40, 0xc000848780}, {0x2a0caf0, 0xc0005f4e70}, {0xc000e18210, 0x22}, {0x0, ...}, ...) /home/rclone/go/src/github.com/rclone/rclone/backend/chunker/chunker.go:1205 +0x6f0 github.com/rclone/rclone/backend/chunker.(*Fs).PutStream(0xc000780100, {0x2a02540, 0xc000cdee70}, {0x29daf40, 0xc000848780}, {0x2a0caf0, 0xc0005f4e70}, {0x0, 0x0, 0x0}) /home/rclone/go/src/github.com/rclone/rclone/backend/chunker/chunker.go:1521 +0x11e github.com/rclone/rclone/fs/operations.rcatSrc({0x2a02540, 0xc000cdee70}, {0x2a16660, 0xc000780100}, {0xc000e18210, 0x22}, {0x29edeb8, 0xc0004796d0}, {0x75bcd15, 0xec689154f, ...}, ...) /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations.go:1461 +0x133b github.com/rclone/rclone/fs/operations.Rcat(...) /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations.go:1351 github.com/rclone/rclone/fs/operations_test.TestRcat.func1(0xc000180000, 0x2f?, 0x1a?) /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1511 +0x59b github.com/rclone/rclone/fs/operations_test.TestRcat.func2(0xc000180000?) /home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations_test.go:1523 +0x1f testing.tRunner(0xc000180000, 0xc000996360) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1690 +0xf4 created by testing.(*T).Run in goroutine 12103 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1743 +0x390 goroutine 11610 [IO wait]: internal/poll.runtime_pollWait(0x7fe3d8e1c480, 0x72) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/netpoll.go:351 +0x85 internal/poll.(*pollDesc).wait(0xc000ddba80?, 0xc000fa4000?, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:84 +0x27 internal/poll.(*pollDesc).waitRead(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_poll_runtime.go:89 internal/poll.(*FD).Read(0xc000ddba80, {0xc000fa4000, 0x2a80, 0x2a80}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/internal/poll/fd_unix.go:165 +0x27a net.(*netFD).Read(0xc000ddba80, {0xc000fa4000?, 0xc000fa4000?, 0x2?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/fd_posix.go:55 +0x25 net.(*conn).Read(0xc000591a70, {0xc000fa4000?, 0x3d1ae20?, 0xc00009d9d0?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/net.go:189 +0x45 github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc000e9f248, {0xc000fa4000?, 0x18?, 0xc00009d998?}) /home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x2c crypto/tls.(*atLeastReader).Read(0xc000936588, {0xc000fa4000?, 0x0?, 0xc000936588?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:809 +0x3b bytes.(*Buffer).ReadFrom(0xc000d6b0b8, {0x29dc780, 0xc000936588}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bytes/buffer.go:211 +0x98 crypto/tls.(*Conn).readFromUntil(0xc000d6ae08, {0x7fe3d8295018, 0xc000e9f248}, 0xc00009da40?) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:831 +0xde crypto/tls.(*Conn).readRecordOrCCS(0xc000d6ae08, 0x0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:629 +0x3cf crypto/tls.(*Conn).readRecord(...) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:591 crypto/tls.(*Conn).Read(0xc000d6ae08, {0xc000836000, 0x1000, 0xc000392508?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/crypto/tls/conn.go:1385 +0x150 net/http.(*persistConn).Read(0xc000a4e6c0, {0xc000836000?, 0x81d405?, 0x214b620?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2052 +0x4a bufio.(*Reader).fill(0xc000e802a0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:110 +0x103 bufio.(*Reader).Peek(0xc000e802a0, 0x1) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/bufio/bufio.go:148 +0x53 net/http.(*persistConn).readLoop(0xc000a4e6c0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2205 +0x185 created by net/http.(*Transport).dialConn in goroutine 11602 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1874 +0x154f goroutine 13877 [select]: net/http.(*persistConn).writeLoop(0xc000cb87e0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:2519 +0xe7 created by net/http.(*Transport).dialConn in goroutine 13867 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/net/http/transport.go:1875 +0x15a5 "./operations.test -test.v -test.timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024" - Finished ERROR in 1h0m0.470084282s (try 1/5): exit status 2: Failed [TestCheck TestDeduplicateNewestByHash]