"./operations.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Starting (try 1/5) 2024/11/20 05:01:27 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-hexopiw7lilo" 2024/11/20 05:01:27 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/11/20 05:01:27 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hexopiw7lilo.bin" 2024/11/20 05:01:28 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo.bin: Auto set use_segments_container to true 2024/11/20 05:01:29 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hexopiw7lilo" 2024/11/20 05:01:29 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo: Auto set use_segments_container to true 2024/11/20 05:01:29 DEBUG : Creating backend with remote "/tmp/rclone3055548330" === 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 "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" multithread_test.go:121: multithread writing not supported --- SKIP: TestMultithreadCopy (0.15s) === RUN TestMultithreadCopyAbort run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" multithread_test.go:121: multithread writing not supported --- SKIP: TestMultithreadCopyAbort (0.20s) === RUN TestSizeDiffers --- PASS: TestSizeDiffers (0.00s) === RUN TestReOpen === RUN TestReOpen/Normal === RUN TestReOpen/Normal/Basics 2024/11/20 05:01:30 DEBUG : potato: Seek from 10 to 0 === RUN TestReOpen/Normal/ErrorAtStart === RUN TestReOpen/Normal/WithErrors 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/Normal/TooManyErrors 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2024/11/20 05:01:30 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/Normal/Seek 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2024/11/20 05:01:30 DEBUG : potato: Seek from 5 to 2 === RUN TestReOpen/Normal/AccountRead === RUN TestReOpen/Normal/AccountReadDelay 2024/11/20 05:01:30 DEBUG : potato: Seek from 10 to 0 2024/11/20 05:01:30 DEBUG : potato: Seek from 10 to 0 2024/11/20 05:01:30 DEBUG : potato: Seek from 10 to 0 === RUN TestReOpen/Normal/AccountReadError === RUN TestReOpen/WithRangeOption === RUN TestReOpen/WithRangeOption/Basics 2024/11/20 05:01:30 DEBUG : potato: Seek from 7 to 0 === RUN TestReOpen/WithRangeOption/ErrorAtStart === RUN TestReOpen/WithRangeOption/WithErrors 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/WithRangeOption/TooManyErrors 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2024/11/20 05:01:30 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/WithRangeOption/Seek 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2024/11/20 05:01:30 DEBUG : potato: Seek from 5 to 2 2024/11/20 05:01:30 DEBUG : potato: Seek from 7 to 4 === RUN TestReOpen/WithRangeOption/AccountRead === RUN TestReOpen/WithRangeOption/AccountReadDelay 2024/11/20 05:01:30 DEBUG : potato: Seek from 7 to 0 2024/11/20 05:01:30 DEBUG : potato: Seek from 7 to 0 2024/11/20 05:01:30 DEBUG : potato: Seek from 7 to 0 === RUN TestReOpen/WithRangeOption/AccountReadError === RUN TestReOpen/WithSeekOption === RUN TestReOpen/WithSeekOption/Basics 2024/11/20 05:01:30 DEBUG : potato: Seek from 8 to 0 === RUN TestReOpen/WithSeekOption/ErrorAtStart === RUN TestReOpen/WithSeekOption/WithErrors 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/WithSeekOption/TooManyErrors 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2024/11/20 05:01:30 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/WithSeekOption/Seek 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2024/11/20 05:01:30 DEBUG : potato: Seek from 5 to 2 2024/11/20 05:01:30 DEBUG : potato: Seek from 7 to 5 === RUN TestReOpen/WithSeekOption/AccountRead === RUN TestReOpen/WithSeekOption/AccountReadDelay 2024/11/20 05:01:30 DEBUG : potato: Seek from 8 to 0 2024/11/20 05:01:30 DEBUG : potato: Seek from 8 to 0 2024/11/20 05:01:30 DEBUG : potato: Seek from 8 to 0 === RUN TestReOpen/WithSeekOption/AccountReadError === RUN TestReOpen/UnknownSize === RUN TestReOpen/UnknownSize/Basics 2024/11/20 05:01:30 DEBUG : potato: Seek from 9 to 0 === RUN TestReOpen/UnknownSize/ErrorAtStart === RUN TestReOpen/UnknownSize/WithErrors 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/10: test error 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/10: test error 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/10: test error === RUN TestReOpen/UnknownSize/TooManyErrors 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 1/3: test error 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 2/3: test error 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 6 bytes: retry 3/3: test error 2024/11/20 05:01:30 DEBUG : potato: Reopen failed after offset 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/UnknownSize/Seek 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 2 bytes: retry 0/10: test error 2024/11/20 05:01:30 DEBUG : potato: Reopening on read failure after offset 3 bytes: retry 1/10: test error 2024/11/20 05:01:30 DEBUG : potato: Seek from 5 to 2 2024/11/20 05:01:30 DEBUG : potato: Seek from 7 to 6 === RUN TestReOpen/UnknownSize/AccountRead === RUN TestReOpen/UnknownSize/AccountReadDelay 2024/11/20 05:01:30 DEBUG : potato: Seek from 9 to 0 2024/11/20 05:01:30 DEBUG : potato: Seek from 9 to 0 2024/11/20 05:01:30 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 "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:01:30 DEBUG : rutabaga: md5 = 8d1fcc6d89d873133eccb23a1e38d963 OK === RUN TestCheck/1 === RUN TestCheck/2 2024/11/20 05:01:31 DEBUG : empty space: md5 = 76885594a8f96837e4ede47e43ae3016 OK === RUN TestCheck/3 2024/11/20 05:01:32 DEBUG : potato2: md5 = e10a4d887e9c66d67840bcc23c948911 OK === RUN TestCheck/4 === RUN TestCheck/5 2024/11/20 05:01:33 DEBUG : remotepotato: md5 = 1ddf2977afd2d33eb1a1ff87b55aedd7 OK === RUN TestCheck/6 === RUN TestCheck/7 --- PASS: TestCheck (4.36s) --- PASS: TestCheck/1 (0.05s) --- PASS: TestCheck/2 (0.15s) --- PASS: TestCheck/3 (0.14s) --- PASS: TestCheck/4 (0.13s) --- PASS: TestCheck/5 (0.05s) --- PASS: TestCheck/6 (0.05s) --- PASS: TestCheck/7 (0.05s) === RUN TestCheckFsError 2024/11/20 05:01:34 DEBUG : Creating backend with remote "nonexistent" 2024/11/20 05:01:34 DEBUG : Creating backend with remote "nonexistent" 2024/11/20 05:01:34 DEBUG : Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/nonexistent: Waiting for checks to finish 2024/11/20 05:01:34 ERROR : Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/nonexistent: error reading source root directory: directory not found 2024/11/20 05:01:34 NOTICE: Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/nonexistent: 2 differences found 2024/11/20 05:01:34 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 "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:01:34 DEBUG : rutabaga: md5 = bba5c057775d8dccfa5949095cfbf093 OK === RUN TestCheckDownload/1 === RUN TestCheckDownload/2 2024/11/20 05:01:35 DEBUG : empty space: md5 = 161e8cde24688ae002950e1d8423c28c OK === RUN TestCheckDownload/3 2024/11/20 05:01:35 DEBUG : potato2: md5 = f3896e5b864ac02db8271c5d352b8769 OK === RUN TestCheckDownload/4 === RUN TestCheckDownload/5 2024/11/20 05:01:36 DEBUG : remotepotato: md5 = 147ff251df9e010d7df3035cbd0ba153 OK === RUN TestCheckDownload/6 === RUN TestCheckDownload/7 --- PASS: TestCheckDownload (3.65s) --- PASS: TestCheckDownload/1 (0.20s) --- PASS: TestCheckDownload/2 (0.09s) --- PASS: TestCheckDownload/3 (0.09s) --- PASS: TestCheckDownload/4 (0.14s) --- PASS: TestCheckDownload/5 (0.16s) --- PASS: TestCheckDownload/6 (0.20s) --- PASS: TestCheckDownload/7 (0.19s) === RUN TestCheckSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:01:38 DEBUG : rutabaga: md5 = 96b88520f46080ebe534cb0bdc1c9b6e OK === RUN TestCheckSizeOnly/1 === RUN TestCheckSizeOnly/2 2024/11/20 05:01:38 DEBUG : empty space: md5 = d0f5a20796773151a34e243d79f42b06 OK === RUN TestCheckSizeOnly/3 2024/11/20 05:01:39 DEBUG : potato2: md5 = 248c8e61d8a89e8cbf96acaad03b3e87 OK === RUN TestCheckSizeOnly/4 === RUN TestCheckSizeOnly/5 2024/11/20 05:01:40 DEBUG : remotepotato: md5 = 837f40889a16b00c9441e6263e2fffd5 OK === RUN TestCheckSizeOnly/6 === RUN TestCheckSizeOnly/7 --- PASS: TestCheckSizeOnly (3.18s) --- PASS: TestCheckSizeOnly/1 (0.05s) --- PASS: TestCheckSizeOnly/2 (0.05s) --- PASS: TestCheckSizeOnly/3 (0.15s) --- PASS: TestCheckSizeOnly/4 (0.15s) --- PASS: TestCheckSizeOnly/5 (0.05s) --- PASS: TestCheckSizeOnly/6 (0.05s) --- PASS: TestCheckSizeOnly/7 (0.11s) === RUN TestCheckEqualReaders --- PASS: TestCheckEqualReaders (0.01s) === RUN TestParseSumFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:01:41 DEBUG : test.sum: md5 = 25ff48d9764b7decdf9dab984b6bb21c OK 2024/11/20 05:01:42 NOTICE: test.sum: improperly formatted checksum line 4 2024/11/20 05:01:42 NOTICE: test.sum: improperly formatted checksum line 5 2024/11/20 05:01:42 NOTICE: test.sum: improperly formatted checksum line 6 2024/11/20 05:01:42 NOTICE: test.sum: 2 warning(s) suppressed... 2024/11/20 05:01:42 DEBUG : test.sum: md5 = 2b5e274740553f736b01734dcc9c5524 OK 2024/11/20 05:01:42 NOTICE: test.sum: improperly formatted checksum line 4 2024/11/20 05:01:42 NOTICE: test.sum: improperly formatted checksum line 5 2024/11/20 05:01:42 NOTICE: test.sum: improperly formatted checksum line 6 2024/11/20 05:01:42 NOTICE: test.sum: 2 warning(s) suppressed... --- PASS: TestParseSumFile (1.30s) === RUN TestCheckSum run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:01:42 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-hexopiw7lilo/data" 2024/11/20 05:01:42 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hexopiw7lilo/data.bin" 2024/11/20 05:01:43 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo/data.bin: Auto set use_segments_container to true 2024/11/20 05:01:43 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hexopiw7lilo/data" 2024/11/20 05:01:44 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo/data: Auto set use_segments_container to true check_test.go:354: Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo/data' lacks md5, skipping --- SKIP: TestCheckSum (2.71s) === RUN TestCheckSumDownload run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:01:45 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-hexopiw7lilo/data" 2024/11/20 05:01:45 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hexopiw7lilo/data.bin" 2024/11/20 05:01:46 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo/data.bin: Auto set use_segments_container to true 2024/11/20 05:01:47 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hexopiw7lilo/data" 2024/11/20 05:01:48 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo/data: Auto set use_segments_container to true 2024/11/20 05:01:49 DEBUG : data/banana: md5 = eef8a22c6e3a70206ce5a1e0acfd3a8a OK 2024/11/20 05:01:49 DEBUG : test.sum: md5 = 2495b2f340fde8b2b292088272730c21 OK === RUN TestCheckSumDownload/subtest1 2024/11/20 05:01:50 DEBUG : data/potato: md5 = a64258b4cb8bda2a232e8cbe83e6b336 OK 2024/11/20 05:01:50 DEBUG : test.sum: md5 = f715b4700a14f518d98aba5456889eee OK === RUN TestCheckSumDownload/subtest2 2024/11/20 05:01:51 DEBUG : test.sum: md5 = 885e46b53e6bc8cdf3aebdd2c25ab2be OK === RUN TestCheckSumDownload/subtest3 2024/11/20 05:01:52 DEBUG : test.sum: md5 = 0cd5edb5662e98443177e0e0119dcd02 OK === RUN TestCheckSumDownload/subtest4 2024/11/20 05:01:53 DEBUG : test.sum: md5 = 20f071fc3b5782687f75f9c1556654de OK === RUN TestCheckSumDownload/subtest5 2024/11/20 05:01:53 DEBUG : test.sum: md5 = 94297a3826eb077b48c4629a41488106 OK === RUN TestCheckSumDownload/subtest6 2024/11/20 05:01:54 DEBUG : data/banana: md5 = b4786af9afddec2fa3b86a0b1b38d46a OK 2024/11/20 05:01:54 DEBUG : data/potato: md5 = b22870c345ee28ed078a3ca243f16485 OK 2024/11/20 05:01:55 DEBUG : test.sum: md5 = 9c510fdde45024067d161b2a09df8ae0 OK === RUN TestCheckSumDownload/subtest7 --- PASS: TestCheckSumDownload (10.71s) --- PASS: TestCheckSumDownload/subtest1 (0.28s) --- PASS: TestCheckSumDownload/subtest2 (0.18s) --- PASS: TestCheckSumDownload/subtest3 (0.46s) --- PASS: TestCheckSumDownload/subtest4 (0.29s) --- PASS: TestCheckSumDownload/subtest5 (0.30s) --- PASS: TestCheckSumDownload/subtest6 (0.30s) --- PASS: TestCheckSumDownload/subtest7 (0.27s) === RUN TestApplyTransforms 2024/11/20 05:01:56 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yipemar7hiwu" 2024/11/20 05:01:56 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/11/20 05:01:56 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yipemar7hiwu.bin" 2024/11/20 05:01:56 DEBUG : Swift container crypt path rclone-test-yipemar7hiwu.bin: Auto set use_segments_container to true 2024/11/20 05:01:57 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yipemar7hiwu" 2024/11/20 05:01:57 DEBUG : Swift container crypt path rclone-test-yipemar7hiwu: Auto set use_segments_container to true 2024/11/20 05:01:58 DEBUG : Creating backend with remote "/tmp/rclone634265709" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yipemar7hiwu'", Local "Local file system at /tmp/rclone634265709", Modify Window "1ns" 2024/11/20 05:01:58 DEBUG : hello, world!: md5 = 1460a9b0c8ef2b022f674e665acdfb9f OK upper checkfile vs. lower remote (without normalization) 2024/11/20 05:01:58 ERROR : hello, world!: sum not found 2024/11/20 05:01:58 ERROR : HELLO, WORLD!: file not in Encrypted drive 'TestCryptSwift:rclone-test-yipemar7hiwu' 2024/11/20 05:01:58 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-yipemar7hiwu': 1 files missing 2024/11/20 05:01:58 NOTICE: 1 hashes missing 2024/11/20 05:01:58 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-yipemar7hiwu': 2 differences found 2024/11/20 05:01:58 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-yipemar7hiwu': 2 errors while checking upper checkfile vs. lower remote (with normalization) 2024/11/20 05:01:59 DEBUG : hello, world!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2024/11/20 05:01:59 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-yipemar7hiwu': 0 differences found 2024/11/20 05:01:59 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-yipemar7hiwu': 1 matching files 2024/11/20 05:01:59 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-hocequr0dadu" 2024/11/20 05:01:59 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/11/20 05:01:59 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hocequr0dadu.bin" 2024/11/20 05:01:59 DEBUG : Swift container crypt path rclone-test-hocequr0dadu.bin: Auto set use_segments_container to true 2024/11/20 05:01:59 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hocequr0dadu" 2024/11/20 05:02:00 DEBUG : Swift container crypt path rclone-test-hocequr0dadu: Auto set use_segments_container to true 2024/11/20 05:02:02 DEBUG : Creating backend with remote "/tmp/rclone3846000221" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hocequr0dadu'", Local "Local file system at /tmp/rclone3846000221", Modify Window "1ns" 2024/11/20 05:02:03 DEBUG : HELLO, WORLD!: md5 = bdd8ae29b03472e72187bda3889596b2 OK lower checkfile vs. upper remote (without normalization) 2024/11/20 05:02:03 ERROR : HELLO, WORLD!: sum not found 2024/11/20 05:02:03 ERROR : hello, world!: file not in Encrypted drive 'TestCryptSwift:rclone-test-hocequr0dadu' 2024/11/20 05:02:03 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-hocequr0dadu': 1 files missing 2024/11/20 05:02:03 NOTICE: 1 hashes missing 2024/11/20 05:02:03 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-hocequr0dadu': 2 differences found 2024/11/20 05:02:03 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-hocequr0dadu': 2 errors while checking lower checkfile vs. upper remote (with normalization) 2024/11/20 05:02:03 DEBUG : HELLO, WORLD!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2024/11/20 05:02:03 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-hocequr0dadu': 0 differences found 2024/11/20 05:02:03 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-hocequr0dadu': 1 matching files 2024/11/20 05:02:03 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-bovakud8liye" 2024/11/20 05:02:03 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/11/20 05:02:03 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bovakud8liye.bin" 2024/11/20 05:02:04 DEBUG : Swift container crypt path rclone-test-bovakud8liye.bin: Auto set use_segments_container to true 2024/11/20 05:02:04 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-bovakud8liye" 2024/11/20 05:02:05 DEBUG : Swift container crypt path rclone-test-bovakud8liye: Auto set use_segments_container to true 2024/11/20 05:02:05 DEBUG : Creating backend with remote "/tmp/rclone3941768223" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-bovakud8liye'", Local "Local file system at /tmp/rclone3941768223", Modify Window "1ns" 2024/11/20 05:02:05 DEBUG : HeLlO, wOrLd!: md5 = 6bd12f6ce703cb8f65edf706cab0e9df OK lower checkfile vs. upperlowermixed remote (without normalization) 2024/11/20 05:02:06 ERROR : HeLlO, wOrLd!: sum not found 2024/11/20 05:02:06 ERROR : hello, world!: file not in Encrypted drive 'TestCryptSwift:rclone-test-bovakud8liye' 2024/11/20 05:02:06 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-bovakud8liye': 1 files missing 2024/11/20 05:02:06 NOTICE: 1 hashes missing 2024/11/20 05:02:06 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-bovakud8liye': 2 differences found 2024/11/20 05:02:06 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-bovakud8liye': 2 errors while checking lower checkfile vs. upperlowermixed remote (with normalization) 2024/11/20 05:02:06 DEBUG : HeLlO, wOrLd!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2024/11/20 05:02:06 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-bovakud8liye': 0 differences found 2024/11/20 05:02:06 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-bovakud8liye': 1 matching files 2024/11/20 05:02:06 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-beyujow8wisa" 2024/11/20 05:02:06 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/11/20 05:02:06 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-beyujow8wisa.bin" 2024/11/20 05:02:07 DEBUG : Swift container crypt path rclone-test-beyujow8wisa.bin: Auto set use_segments_container to true 2024/11/20 05:02:07 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-beyujow8wisa" 2024/11/20 05:02:07 DEBUG : Swift container crypt path rclone-test-beyujow8wisa: Auto set use_segments_container to true 2024/11/20 05:02:08 DEBUG : Creating backend with remote "/tmp/rclone3265251760" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-beyujow8wisa'", Local "Local file system at /tmp/rclone3265251760", Modify Window "1ns" 2024/11/20 05:02:08 DEBUG : HELLO, WORLD!: md5 = 0b944bdcc3eca191415cab945c02dbce OK upperlowermixed checkfile vs. upper remote (without normalization) 2024/11/20 05:02:08 ERROR : HELLO, WORLD!: sum not found 2024/11/20 05:02:08 ERROR : HeLlO, wOrLd!: file not in Encrypted drive 'TestCryptSwift:rclone-test-beyujow8wisa' 2024/11/20 05:02:08 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-beyujow8wisa': 1 files missing 2024/11/20 05:02:08 NOTICE: 1 hashes missing 2024/11/20 05:02:08 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-beyujow8wisa': 2 differences found 2024/11/20 05:02:08 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-beyujow8wisa': 2 errors while checking upperlowermixed checkfile vs. upper remote (with normalization) 2024/11/20 05:02:09 DEBUG : HELLO, WORLD!: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2024/11/20 05:02:09 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-beyujow8wisa': 0 differences found 2024/11/20 05:02:09 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-beyujow8wisa': 1 matching files 2024/11/20 05:02:09 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-dubefem1fude" 2024/11/20 05:02:09 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/11/20 05:02:09 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-dubefem1fude.bin" 2024/11/20 05:02:09 DEBUG : Swift container crypt path rclone-test-dubefem1fude.bin: Auto set use_segments_container to true 2024/11/20 05:02:09 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-dubefem1fude" 2024/11/20 05:02:10 DEBUG : Swift container crypt path rclone-test-dubefem1fude: Auto set use_segments_container to true 2024/11/20 05:02:11 DEBUG : Creating backend with remote "/tmp/rclone737190051" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-dubefem1fude'", Local "Local file system at /tmp/rclone737190051", Modify Window "1ns" 2024/11/20 05:02:11 DEBUG : 測試_Русский___ě_áñ: md5 = 44c544c650e5832f15aa23d767501df2 OK NFD checkfile vs. NFC remote (without normalization) 2024/11/20 05:02:11 ERROR : 測試_Русский___ě_áñ: sum not found 2024/11/20 05:02:11 ERROR : 測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptSwift:rclone-test-dubefem1fude' 2024/11/20 05:02:11 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-dubefem1fude': 1 files missing 2024/11/20 05:02:11 NOTICE: 1 hashes missing 2024/11/20 05:02:11 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-dubefem1fude': 2 differences found 2024/11/20 05:02:11 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-dubefem1fude': 2 errors while checking NFD checkfile vs. NFC remote (with normalization) 2024/11/20 05:02:11 DEBUG : 測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2024/11/20 05:02:11 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-dubefem1fude': 0 differences found 2024/11/20 05:02:11 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-dubefem1fude': 1 matching files 2024/11/20 05:02:11 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-juforak9magu" 2024/11/20 05:02:11 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/11/20 05:02:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-juforak9magu.bin" 2024/11/20 05:02:12 DEBUG : Swift container crypt path rclone-test-juforak9magu.bin: Auto set use_segments_container to true 2024/11/20 05:02:12 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-juforak9magu" 2024/11/20 05:02:13 DEBUG : Swift container crypt path rclone-test-juforak9magu: Auto set use_segments_container to true 2024/11/20 05:02:13 DEBUG : Creating backend with remote "/tmp/rclone3270638932" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-juforak9magu'", Local "Local file system at /tmp/rclone3270638932", Modify Window "1ns" 2024/11/20 05:02:13 DEBUG : 測試_Русский___ě_áñ: md5 = b0c048079b1cfade22e1c4c1af7d3a07 OK NFC checkfile vs. NFD remote (without normalization) 2024/11/20 05:02:14 ERROR : 測試_Русский___ě_áñ: sum not found 2024/11/20 05:02:14 ERROR : 測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptSwift:rclone-test-juforak9magu' 2024/11/20 05:02:14 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-juforak9magu': 1 files missing 2024/11/20 05:02:14 NOTICE: 1 hashes missing 2024/11/20 05:02:14 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-juforak9magu': 2 differences found 2024/11/20 05:02:14 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-juforak9magu': 2 errors while checking NFC checkfile vs. NFD remote (with normalization) 2024/11/20 05:02:14 DEBUG : 測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2024/11/20 05:02:14 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-juforak9magu': 0 differences found 2024/11/20 05:02:14 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-juforak9magu': 1 matching files 2024/11/20 05:02:14 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-yoxoqaw4tebi" 2024/11/20 05:02:14 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/11/20 05:02:14 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yoxoqaw4tebi.bin" 2024/11/20 05:02:14 DEBUG : Swift container crypt path rclone-test-yoxoqaw4tebi.bin: Auto set use_segments_container to true 2024/11/20 05:02:15 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-yoxoqaw4tebi" 2024/11/20 05:02:15 DEBUG : Swift container crypt path rclone-test-yoxoqaw4tebi: Auto set use_segments_container to true 2024/11/20 05:02:16 DEBUG : Creating backend with remote "/tmp/rclone4067123973" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-yoxoqaw4tebi'", Local "Local file system at /tmp/rclone4067123973", Modify Window "1ns" 2024/11/20 05:02:16 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 05486a96dcecec01d6c55e2d294994aa OK NFDx2 checkfile vs. both remote (without normalization) 2024/11/20 05:02:17 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found 2024/11/20 05:02:17 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptSwift:rclone-test-yoxoqaw4tebi' 2024/11/20 05:02:17 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-yoxoqaw4tebi': 1 files missing 2024/11/20 05:02:17 NOTICE: 1 hashes missing 2024/11/20 05:02:17 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-yoxoqaw4tebi': 2 differences found 2024/11/20 05:02:17 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-yoxoqaw4tebi': 2 errors while checking NFDx2 checkfile vs. both remote (with normalization) 2024/11/20 05:02:17 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2024/11/20 05:02:17 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-yoxoqaw4tebi': 0 differences found 2024/11/20 05:02:17 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-yoxoqaw4tebi': 1 matching files 2024/11/20 05:02:17 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-fuhavac9lavo" 2024/11/20 05:02:17 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/11/20 05:02:17 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-fuhavac9lavo.bin" 2024/11/20 05:02:17 DEBUG : Swift container crypt path rclone-test-fuhavac9lavo.bin: Auto set use_segments_container to true 2024/11/20 05:02:18 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-fuhavac9lavo" 2024/11/20 05:02:18 DEBUG : Swift container crypt path rclone-test-fuhavac9lavo: Auto set use_segments_container to true 2024/11/20 05:02:18 DEBUG : Creating backend with remote "/tmp/rclone3917378963" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-fuhavac9lavo'", Local "Local file system at /tmp/rclone3917378963", Modify Window "1ns" 2024/11/20 05:02:19 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 14a2b1c9146b450db52aace97dae99ac OK NFCx2 checkfile vs. both remote (without normalization) 2024/11/20 05:02:20 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found 2024/11/20 05:02:20 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptSwift:rclone-test-fuhavac9lavo' 2024/11/20 05:02:20 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-fuhavac9lavo': 1 files missing 2024/11/20 05:02:20 NOTICE: 1 hashes missing 2024/11/20 05:02:20 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-fuhavac9lavo': 2 differences found 2024/11/20 05:02:20 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-fuhavac9lavo': 2 errors while checking NFCx2 checkfile vs. both remote (with normalization) 2024/11/20 05:02:20 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2024/11/20 05:02:20 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-fuhavac9lavo': 0 differences found 2024/11/20 05:02:20 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-fuhavac9lavo': 1 matching files 2024/11/20 05:02:20 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-sogilab3lofu" 2024/11/20 05:02:20 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/11/20 05:02:20 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-sogilab3lofu.bin" 2024/11/20 05:02:20 DEBUG : Swift container crypt path rclone-test-sogilab3lofu.bin: Auto set use_segments_container to true 2024/11/20 05:02:21 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-sogilab3lofu" 2024/11/20 05:02:21 DEBUG : Swift container crypt path rclone-test-sogilab3lofu: Auto set use_segments_container to true 2024/11/20 05:02:22 DEBUG : Creating backend with remote "/tmp/rclone2970588637" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-sogilab3lofu'", Local "Local file system at /tmp/rclone2970588637", Modify Window "1ns" 2024/11/20 05:02:22 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 9cc5355ef75431a284e2c1687fbe5a8c OK both checkfile vs. NFDx2 remote (without normalization) 2024/11/20 05:02:22 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found 2024/11/20 05:02:22 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptSwift:rclone-test-sogilab3lofu' 2024/11/20 05:02:22 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-sogilab3lofu': 1 files missing 2024/11/20 05:02:22 NOTICE: 1 hashes missing 2024/11/20 05:02:22 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-sogilab3lofu': 2 differences found 2024/11/20 05:02:22 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-sogilab3lofu': 2 errors while checking both checkfile vs. NFDx2 remote (with normalization) 2024/11/20 05:02:22 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2024/11/20 05:02:22 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-sogilab3lofu': 0 differences found 2024/11/20 05:02:22 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-sogilab3lofu': 1 matching files 2024/11/20 05:02:22 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-pevaduy1dude" 2024/11/20 05:02:22 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/11/20 05:02:22 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-pevaduy1dude.bin" 2024/11/20 05:02:23 DEBUG : Swift container crypt path rclone-test-pevaduy1dude.bin: Auto set use_segments_container to true 2024/11/20 05:02:23 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-pevaduy1dude" 2024/11/20 05:02:24 DEBUG : Swift container crypt path rclone-test-pevaduy1dude: Auto set use_segments_container to true 2024/11/20 05:02:24 DEBUG : Creating backend with remote "/tmp/rclone3809590137" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-pevaduy1dude'", Local "Local file system at /tmp/rclone3809590137", Modify Window "1ns" 2024/11/20 05:02:25 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 30a798fe3eb409b79b3fd8113306fff5 OK both checkfile vs. NFCx2 remote (without normalization) 2024/11/20 05:02:25 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: sum not found 2024/11/20 05:02:25 ERROR : 測試_Русский___ě_áñ測試_Русский___ě_áñ: file not in Encrypted drive 'TestCryptSwift:rclone-test-pevaduy1dude' 2024/11/20 05:02:25 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-pevaduy1dude': 1 files missing 2024/11/20 05:02:25 NOTICE: 1 hashes missing 2024/11/20 05:02:25 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-pevaduy1dude': 2 differences found 2024/11/20 05:02:25 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-pevaduy1dude': 2 errors while checking both checkfile vs. NFCx2 remote (with normalization) 2024/11/20 05:02:25 DEBUG : 測試_Русский___ě_áñ測試_Русский___ě_áñ: md5 = 65a8e27d8879283831b664bd8b7f0ad4 OK 2024/11/20 05:02:25 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-pevaduy1dude': 0 differences found 2024/11/20 05:02:25 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-pevaduy1dude': 1 matching files 2024/11/20 05:02:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-pevaduy1dude': Purge remote 2024/11/20 05:02:25 DEBUG : Waiting for deletions to finish 2024/11/20 05:02:25 INFO : 測試_Русский___ě_áñ測試_Русский___ě_áñ.bin: Deleted 2024/11/20 05:02:25 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-sogilab3lofu': Purge remote 2024/11/20 05:02:25 DEBUG : Waiting for deletions to finish 2024/11/20 05:02:26 INFO : 測試_Русский___ě_áñ測試_Русский___ě_áñ.bin: Deleted 2024/11/20 05:02:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-fuhavac9lavo': Purge remote 2024/11/20 05:02:26 DEBUG : Waiting for deletions to finish 2024/11/20 05:02:26 INFO : 測試_Русский___ě_áñ測試_Русский___ě_áñ.bin: Deleted 2024/11/20 05:02:26 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yoxoqaw4tebi': Purge remote 2024/11/20 05:02:26 DEBUG : Waiting for deletions to finish 2024/11/20 05:02:27 INFO : 測試_Русский___ě_áñ測試_Русский___ě_áñ.bin: Deleted 2024/11/20 05:02:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-juforak9magu': Purge remote 2024/11/20 05:02:27 DEBUG : Waiting for deletions to finish 2024/11/20 05:02:27 INFO : 測試_Русский___ě_áñ.bin: Deleted 2024/11/20 05:02:27 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-dubefem1fude': Purge remote 2024/11/20 05:02:27 DEBUG : Waiting for deletions to finish 2024/11/20 05:02:28 INFO : 測試_Русский___ě_áñ.bin: Deleted 2024/11/20 05:02:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-beyujow8wisa': Purge remote 2024/11/20 05:02:28 DEBUG : Waiting for deletions to finish 2024/11/20 05:02:28 INFO : HELLO, WORLD!.bin: Deleted 2024/11/20 05:02:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-bovakud8liye': Purge remote 2024/11/20 05:02:28 DEBUG : Waiting for deletions to finish 2024/11/20 05:02:28 INFO : HeLlO, wOrLd!.bin: Deleted 2024/11/20 05:02:28 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-hocequr0dadu': Purge remote 2024/11/20 05:02:28 DEBUG : Waiting for deletions to finish 2024/11/20 05:02:29 INFO : HELLO, WORLD!.bin: Deleted 2024/11/20 05:02:29 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-yipemar7hiwu': Purge remote 2024/11/20 05:02:29 DEBUG : Waiting for deletions to finish 2024/11/20 05:02:29 INFO : hello, world!.bin: Deleted --- PASS: TestApplyTransforms (33.25s) === RUN TestTruncateString --- PASS: TestTruncateString (0.00s) === RUN TestCopyFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:02:29 DEBUG : file1: Need to transfer - File not found at Destination 2024/11/20 05:02:30 DEBUG : sub/file2: md5 = afe9a58fd9dea40ffcc20bedb21b7b49 OK 2024/11/20 05:02:30 INFO : file1: Copied (new) to: sub/file2 2024/11/20 05:02:30 DEBUG : file1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/20 05:02:30 DEBUG : file1: Unchanged skipping 2024/11/20 05:02:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo': don't need to copy/move sub/file2, it is already at target location --- PASS: TestCopyFile (1.66s) === RUN TestCopyLongFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" copy_test.go:153: Test only runs on local --- SKIP: TestCopyLongFile (0.30s) === RUN TestCopyFileBackupDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:02:31 DEBUG : dst/file1: md5 = d1e6d25d70e5768b350b051e09405d2a OK 2024/11/20 05:02:32 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-hexopiw7lilo/backup" 2024/11/20 05:02:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hexopiw7lilo/backup.bin" 2024/11/20 05:02:32 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo/backup.bin: Auto set use_segments_container to true 2024/11/20 05:02:32 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hexopiw7lilo/backup" 2024/11/20 05:02:33 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo/backup: Auto set use_segments_container to true 2024/11/20 05:02:33 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18) 2024/11/20 05:02:34 INFO : dst/file1: Copied (server-side copy) 2024/11/20 05:02:34 INFO : dst/file1: Deleted 2024/11/20 05:02:34 DEBUG : dst/file1: md5 = 379275385f24fd43ef17d2dfff11965b OK 2024/11/20 05:02:34 INFO : dst/file1: Copied (new) --- PASS: TestCopyFileBackupDir (4.19s) === RUN TestCopyFileCompareDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:02:35 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-hexopiw7lilo/dst" 2024/11/20 05:02:35 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hexopiw7lilo/dst.bin" 2024/11/20 05:02:36 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo/dst.bin: Auto set use_segments_container to true 2024/11/20 05:02:36 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hexopiw7lilo/dst" 2024/11/20 05:02:37 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo/dst: Auto set use_segments_container to true 2024/11/20 05:02:37 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-hexopiw7lilo/CompareDest" 2024/11/20 05:02:37 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hexopiw7lilo/CompareDest.bin" 2024/11/20 05:02:38 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo/CompareDest.bin: Auto set use_segments_container to true 2024/11/20 05:02:38 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hexopiw7lilo/CompareDest" 2024/11/20 05:02:38 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo/CompareDest: Auto set use_segments_container to true 2024/11/20 05:02:39 DEBUG : one: Need to transfer - File not found at Destination 2024/11/20 05:02:39 DEBUG : one: md5 = 993af11fedd5439d36b174496ac947d8 OK 2024/11/20 05:02:39 INFO : one: Copied (new) 2024/11/20 05:02:40 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/20 05:02:40 DEBUG : one: md5 = 6eebb5928ddfc1e4804ea308940ac3f0 OK 2024/11/20 05:02:40 INFO : one: Copied (replaced existing) 2024/11/20 05:02:41 DEBUG : dst/one: md5 = 2c9688291901f7ec95cd1167ff396098 OK 2024/11/20 05:02:41 DEBUG : CompareDest/one: md5 = 658109b9e33ceaa4523cd29391e49519 OK 2024/11/20 05:02:41 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/20 05:02:41 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/20 05:02:41 DEBUG : one: Destination found in --compare-dest, skipping 2024/11/20 05:02:42 DEBUG : CompareDest/two: md5 = acf88d9bbf872a76afcedb12863cb17b OK 2024/11/20 05:02:42 DEBUG : two: Need to transfer - File not found at Destination 2024/11/20 05:02:42 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/20 05:02:42 DEBUG : two: Destination found in --compare-dest, skipping 2024/11/20 05:02:43 DEBUG : two: Need to transfer - File not found at Destination 2024/11/20 05:02:43 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/20 05:02:43 DEBUG : two: Destination found in --compare-dest, skipping 2024/11/20 05:02:45 DEBUG : two: Need to transfer - File not found at Destination 2024/11/20 05:02:45 DEBUG : two: Sizes differ (src 5 vs dst 3) 2024/11/20 05:02:46 DEBUG : two: md5 = 47bbf0c81ead37af1d6097996ba4a7ae OK 2024/11/20 05:02:46 INFO : two: Copied (new) --- PASS: TestCopyFileCompareDest (11.78s) === RUN TestCopyFileCopyDest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:02:47 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-hexopiw7lilo/dst" 2024/11/20 05:02:47 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hexopiw7lilo/dst.bin" 2024/11/20 05:02:47 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo/dst.bin: Auto set use_segments_container to true 2024/11/20 05:02:48 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hexopiw7lilo/dst" 2024/11/20 05:02:48 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo/dst: Auto set use_segments_container to true 2024/11/20 05:02:48 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-hexopiw7lilo/CopyDest" 2024/11/20 05:02:48 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hexopiw7lilo/CopyDest.bin" 2024/11/20 05:02:49 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo/CopyDest.bin: Auto set use_segments_container to true 2024/11/20 05:02:49 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hexopiw7lilo/CopyDest" 2024/11/20 05:02:50 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo/CopyDest: Auto set use_segments_container to true 2024/11/20 05:02:50 DEBUG : one: Need to transfer - File not found at Destination 2024/11/20 05:02:51 DEBUG : one: md5 = fd8f60a49186b28a02651b2d10c95f77 OK 2024/11/20 05:02:51 INFO : one: Copied (new) 2024/11/20 05:02:51 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/20 05:02:52 DEBUG : one: md5 = 69a5800e423aba886d9564de6dae6a40 OK 2024/11/20 05:02:52 INFO : one: Copied (replaced existing) 2024/11/20 05:02:52 DEBUG : dst/one: md5 = 4a04983f21669ea540b373d26d37be94 OK 2024/11/20 05:02:52 DEBUG : CopyDest/one: md5 = 2f91a27ec3477105029d444af9fc1983 OK 2024/11/20 05:02:53 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-hexopiw7lilo/BackupDir" 2024/11/20 05:02:53 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hexopiw7lilo/BackupDir.bin" 2024/11/20 05:02:53 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo/BackupDir.bin: Auto set use_segments_container to true 2024/11/20 05:02:54 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hexopiw7lilo/BackupDir" 2024/11/20 05:02:54 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo/BackupDir: Auto set use_segments_container to true 2024/11/20 05:02:54 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/20 05:02:55 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/20 05:02:55 DEBUG : one: Sizes differ (src 5 vs dst 3) 2024/11/20 05:02:55 INFO : one: Copied (server-side copy) 2024/11/20 05:02:55 INFO : one: Deleted 2024/11/20 05:02:56 INFO : one: Copied (server-side copy) 2024/11/20 05:02:56 DEBUG : one: Destination found in --copy-dest, using server-side copy 2024/11/20 05:02:57 DEBUG : CopyDest/two: md5 = 371d5d65995d7da99898ebc1f86110d7 OK 2024/11/20 05:02:57 DEBUG : two: Need to transfer - File not found at Destination 2024/11/20 05:02:57 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/20 05:02:57 INFO : two: Copied (server-side copy) 2024/11/20 05:02:57 DEBUG : two: Destination found in --copy-dest, using server-side copy 2024/11/20 05:02:58 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/20 05:02:58 DEBUG : two: Unchanged skipping 2024/11/20 05:02:59 DEBUG : CopyDest/three: md5 = e783d8ccd19da6d75d95f23d7929b75d OK 2024/11/20 05:02:59 DEBUG : three: Need to transfer - File not found at Destination 2024/11/20 05:02:59 DEBUG : three: Sizes differ (src 7 vs dst 5) 2024/11/20 05:02:59 DEBUG : three: Destination not found in --copy-dest 2024/11/20 05:03:01 DEBUG : three: md5 = 97291cda48ebdd169ee49d597161fe61 OK 2024/11/20 05:03:01 INFO : three: Copied (new) --- PASS: TestCopyFileCopyDest (15.94s) === RUN TestCopyInplace run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" copy_test.go:370: Partial uploads not supported --- SKIP: TestCopyInplace (0.23s) === RUN TestCopyLongFileName run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" copy_test.go:403: Partial uploads not supported --- SKIP: TestCopyLongFileName (0.09s) === RUN TestCopyFileMaxTransfer run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:03:04 DEBUG : TestCopyFileMaxTransfer/file1: Need to transfer - File not found at Destination 2024/11/20 05:03:05 DEBUG : TestCopyFileMaxTransfer/file1: md5 = afc2a9e22af0a19b24caba0baeb1cac7 OK 2024/11/20 05:03:05 INFO : TestCopyFileMaxTransfer/file1: Copied (new) 2024/11/20 05:03:46 DEBUG : TestCopyFileMaxTransfer/file2: Need to transfer - File not found at Destination 2024/11/20 05:03:46 ERROR : TestCopyFileMaxTransfer/file2: Failed to copy: Put "https://csproxy5.memset.com/v1/AUTH_msnickcaa1_93fd688179b54bb5aa9604bf21f236be/crypt/rclone-test-hexopiw7lilo/TestCopyFileMaxTransfer/file2.bin": max transfer limit reached as set by --max-transfer 2024/11/20 05:03:47 DEBUG : TestCopyFileMaxTransfer/file3: Need to transfer - File not found at Destination 2024/11/20 05:03:48 DEBUG : TestCopyFileMaxTransfer/file4: Need to transfer - File not found at Destination 2024/11/20 05:03:49 DEBUG : TestCopyFileMaxTransfer/file4: md5 = 6e3ef97558062ba84a4fe7c67ed6d324 OK 2024/11/20 05:03:49 INFO : TestCopyFileMaxTransfer/file4: Copied (new) --- PASS: TestCopyFileMaxTransfer (47.69s) === RUN TestDeduplicateInteractive run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateInteractive (0.63s) === RUN TestDeduplicateSkip run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateSkip (0.63s) === RUN TestDeduplicateSizeOnly run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateSizeOnly (0.27s) === RUN TestDeduplicateFirst run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateFirst (0.35s) === RUN TestDeduplicateNewest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateNewest (0.32s) === RUN TestDeduplicateNewestByHash run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" dedupe_test.go:36: Can't run this test without a hash --- SKIP: TestDeduplicateNewestByHash (0.25s) === RUN TestDeduplicateOldest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateOldest (0.27s) === RUN TestDeduplicateLargest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateLargest (0.22s) === RUN TestDeduplicateSmallest run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateSmallest (0.29s) === RUN TestDeduplicateRename run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateRename (0.54s) === RUN TestMergeDirs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" dedupe_test.go:256: Can't merge directories --- SKIP: TestMergeDirs (0.26s) === RUN TestListDirSorted run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:03:56 DEBUG : a.txt: md5 = f1ffded71137acb4ab53f6f341363e0d OK 2024/11/20 05:03:57 DEBUG : zend.txt: md5 = 561aac161185dd54a9f0efcdf8a1786f OK 2024/11/20 05:03:58 DEBUG : sub dir/hello world: md5 = 1f7771f877ce638ced2f22e78ccd855d OK 2024/11/20 05:03:58 DEBUG : sub dir/hello world2: md5 = ddf3979c1b694a86d80b6c492462764d OK 2024/11/20 05:03:59 DEBUG : sub dir/ignore dir/.ignore: md5 = a5ef5d261d92da7a5bc851a274ddfdb0 OK 2024/11/20 05:03:59 DEBUG : sub dir/ignore dir/should be ignored: md5 = 1c6d7489bc92185cb6acede479ef9fac OK 2024/11/20 05:04:01 DEBUG : sub dir/sub sub dir/hello world3: md5 = 8beb50068bf1348dbfae7c15ef6d4115 OK 2024/11/20 05:04:03 DEBUG : a.txt: Excluded (Size Filter) 2024/11/20 05:04:03 DEBUG : a.txt: Excluded 2024/11/20 05:04:03 DEBUG : sub dir/hello world: Excluded (Size Filter) 2024/11/20 05:04:03 DEBUG : sub dir/hello world: Excluded 2024/11/20 05:04:03 DEBUG : sub dir/hello world2: Excluded (Size Filter) 2024/11/20 05:04:03 DEBUG : sub dir/hello world2: Excluded 2024/11/20 05:04:03 DEBUG : sub dir/hello world: Excluded (Size Filter) 2024/11/20 05:04:03 DEBUG : sub dir/hello world: Excluded 2024/11/20 05:04:03 DEBUG : sub dir/hello world2: Excluded (Size Filter) 2024/11/20 05:04:03 DEBUG : sub dir/hello world2: Excluded 2024/11/20 05:04:04 DEBUG : sub dir/ignore dir: Excluded 2024/11/20 05:04:04 DEBUG : sub dir/ignore dir: Excluded --- PASS: TestListDirSorted (10.99s) === RUN TestListJSON run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:04:07 DEBUG : file1: md5 = 613f85d4f20152861a0489c5f3bda17b OK 2024/11/20 05:04:07 DEBUG : sub/file2: md5 = 28e9bc889ba8df8d2ee5e40ca57703bc OK === 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 2024/11/20 05:04:08 ERROR : file1: Failed to read hash: hash type not supported === RUN TestListJSON/Metadata --- PASS: TestListJSON (2.59s) --- PASS: TestListJSON/Default (0.18s) --- PASS: TestListJSON/FilesOnly (0.09s) --- PASS: TestListJSON/DirsOnly (0.05s) --- PASS: TestListJSON/Recurse (0.14s) --- PASS: TestListJSON/SubDir (0.14s) --- PASS: TestListJSON/NoModTime (0.04s) --- PASS: TestListJSON/NoMimeType (0.09s) --- PASS: TestListJSON/ShowHash (0.09s) --- PASS: TestListJSON/HashTypes (0.09s) --- PASS: TestListJSON/Metadata (0.09s) === RUN TestStatJSON run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:04:09 DEBUG : file1: md5 = 785d4b15dc6d104658fe3b79036ccd4c OK 2024/11/20 05:04:09 DEBUG : sub/file2: md5 = 503c4ffcde11fd2cd407839866cd068b OK === 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 2024/11/20 05:04:11 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-hexopiw7lilo/notfound" 2024/11/20 05:04:11 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hexopiw7lilo/notfound.bin" 2024/11/20 05:04:11 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo/notfound.bin: Auto set use_segments_container to true 2024/11/20 05:04:12 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hexopiw7lilo/notfound" 2024/11/20 05:04:12 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo/notfound: Auto set use_segments_container to true --- PASS: TestStatJSON (4.30s) --- PASS: TestStatJSON/Root (0.16s) --- PASS: TestStatJSON/RootFilesOnly (0.00s) --- PASS: TestStatJSON/RootDirsOnly (0.05s) --- PASS: TestStatJSON/Dir (0.42s) --- PASS: TestStatJSON/DirWithTrailingSlash (0.04s) --- PASS: TestStatJSON/File (0.04s) --- PASS: TestStatJSON/NotFound (0.20s) --- PASS: TestStatJSON/DirFilesOnly (0.05s) --- PASS: TestStatJSON/FileFilesOnly (0.04s) --- PASS: TestStatJSON/NotFoundFilesOnly (0.05s) --- PASS: TestStatJSON/DirDirsOnly (0.05s) --- PASS: TestStatJSON/FileDirsOnly (0.05s) --- PASS: TestStatJSON/NotFoundDirsOnly (0.04s) --- PASS: TestStatJSON/RootNotFound (1.68s) === RUN TestMkdir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:04:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo': Making directory 2024/11/20 05:04:13 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo': Making directory --- PASS: TestMkdir (0.23s) === RUN TestLsd run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:04:14 DEBUG : sub dir/hello world: md5 = 45072f1e98f0228a1915c9de3be2d866 OK --- PASS: TestLsd (1.21s) === RUN TestLs run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:04:15 DEBUG : potato2: md5 = 731fa3bf6172c61bfa52d101d98cc0ea OK 2024/11/20 05:04:15 DEBUG : empty space: md5 = b54dc13bbf35361b8012b3a2f5c91e04 OK --- PASS: TestLs (1.94s) === RUN TestLsWithFilesFrom run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:04:17 DEBUG : potato2: md5 = 07c8a61b5c27821a7e0d8495a53fc18f OK 2024/11/20 05:04:17 DEBUG : empty space: md5 = 9596000e084d524de26464343d3cd682 OK 2024/11/20 05:04:17 DEBUG : empty space: Excluded (FilesFrom Filter) 2024/11/20 05:04:17 DEBUG : empty space: Excluded --- PASS: TestLsWithFilesFrom (1.31s) === RUN TestLsLong run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:04:18 DEBUG : potato2: md5 = 3e231978c9280c70d652bfdc767c4565 OK 2024/11/20 05:04:18 DEBUG : empty space: md5 = 8cb175b1ee343a7539982efc76d30849 OK --- PASS: TestLsLong (1.84s) === RUN TestHashSums run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:04:20 DEBUG : potato2: md5 = 3a37783e071b39b17b532833811af705 OK 2024/11/20 05:04:20 DEBUG : empty space: md5 = 7bd16ef8ac3b52552c7dbbf843e66354 OK --- PASS: TestHashSums (1.60s) === RUN TestHashSumsWithErrors 2024/11/20 05:04:21 DEBUG : Creating backend with remote ":memory:" 2024/11/20 05:04:21 ERROR : file1: hash unsupported: hash type not supported --- PASS: TestHashSumsWithErrors (0.01s) === RUN TestHashStream 2024/11/20 05:04:21 DEBUG : Creating md5 hash of 0 bytes read from input stream 2024/11/20 05:04:21 DEBUG : Creating md5 hash of 0 bytes read from input stream 2024/11/20 05:04:21 DEBUG : Creating sha1 hash of 0 bytes read from input stream 2024/11/20 05:04:21 DEBUG : Creating sha1 hash of 0 bytes read from input stream 2024/11/20 05:04:21 DEBUG : Creating md5 hash of 12 bytes read from input stream 2024/11/20 05:04:21 DEBUG : Creating md5 hash of 12 bytes read from input stream 2024/11/20 05:04:21 DEBUG : Creating sha1 hash of 12 bytes read from input stream 2024/11/20 05:04:21 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 "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:04:22 DEBUG : potato2: md5 = c8fbb01dfc43934724313d2087026da6 OK 2024/11/20 05:04:22 DEBUG : empty space: md5 = b60ed8cb0254a61cb1fe63dbad323ec2 OK 2024/11/20 05:04:22 DEBUG : sub dir/potato3: md5 = 7fab3692df9b77cff87e8bcdda7a703f OK --- PASS: TestCount (1.82s) === RUN TestDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:04:29 DEBUG : small: md5 = 76b73cd3f9f1fb2bad704e461b88bac4 OK 2024/11/20 05:04:29 DEBUG : medium: md5 = 9bddaf57f00480796c4276ae4c4d876e OK 2024/11/20 05:04:30 DEBUG : large: md5 = 789df66c90b0aefe302e80277ad237b3 OK 2024/11/20 05:04:30 DEBUG : Waiting for deletions to finish 2024/11/20 05:04:30 DEBUG : large: Excluded (Size Filter) 2024/11/20 05:04:31 INFO : medium: Deleted 2024/11/20 05:04:36 INFO : small: Deleted --- PASS: TestDelete (13.19s) === RUN TestMaxDelete run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:04:40 DEBUG : small: md5 = d66caf9f65445f1b7d22b5e25ae1be77 OK 2024/11/20 05:04:40 DEBUG : medium: md5 = 909a44aa570f25303ac8c762fc7ea11f OK 2024/11/20 05:04:40 DEBUG : large: md5 = ee0797fbb58dc55ccbca0fe7ad9fd18a OK 2024/11/20 05:04:40 DEBUG : Waiting for deletions to finish 2024/11/20 05:04:40 ERROR : small: Got fatal error on delete: --max-delete threshold reached 2024/11/20 05:04:40 INFO : large: Deleted 2024/11/20 05:04:41 INFO : medium: Deleted --- PASS: TestMaxDelete (5.09s) === RUN TestMaxDeleteSizeLargeFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:04:42 DEBUG : small: md5 = 04297f3bced9e5e8f873928c37d3140e OK 2024/11/20 05:04:42 DEBUG : medium: md5 = 7729645993ec4006b4bc4272e9f024c4 OK 2024/11/20 05:04:42 DEBUG : large: md5 = 7c1da32ee2882f93cc9040b8400ee132 OK 2024/11/20 05:04:42 DEBUG : Waiting for deletions to finish 2024/11/20 05:04:42 ERROR : large: Got fatal error on delete: --max-delete-size threshold reached 2024/11/20 05:04:43 INFO : small: Deleted 2024/11/20 05:04:43 INFO : medium: Deleted --- PASS: TestMaxDeleteSizeLargeFile (2.25s) === RUN TestMaxDeleteSize run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:04:44 DEBUG : small: md5 = ae177a4e854cb9d5fc4bfe23bd80d5ed OK 2024/11/20 05:04:44 DEBUG : medium: md5 = 846e3863a982cd6c94ecec6cf0f801c3 OK 2024/11/20 05:04:44 DEBUG : large: md5 = ae365ed8a4f661dd898add7f41bdb004 OK 2024/11/20 05:04:45 DEBUG : Waiting for deletions to finish 2024/11/20 05:04:45 ERROR : small: Got fatal error on delete: --max-delete-size threshold reached 2024/11/20 05:04:45 INFO : large: Deleted 2024/11/20 05:04:45 INFO : medium: Deleted --- PASS: TestMaxDeleteSize (1.94s) === RUN TestReadFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:04:46 DEBUG : ReadFile: md5 = dd30996b29e848ccf49350e50f02988c OK --- PASS: TestReadFile (1.45s) === RUN TestRetry 2024/11/20 05:04:47 DEBUG : Received error: Wrapped EOF is retriable: EOF - low level retry 1/5 2024/11/20 05:04:47 DEBUG : Received error: Wrapped EOF is retriable: EOF - low level retry 2/5 2024/11/20 05:04:47 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG 2024/11/20 05:04:47 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG 2024/11/20 05:04:47 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG 2024/11/20 05:04:47 DEBUG : Sleeping for 10ms (as indicated by the server) to obey Retry-After error: BANG 2024/11/20 05:04:47 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 "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:04:47 DEBUG : file1: md5 = e54276861e2a4eacce14a6611e693ea6 OK 2024/11/20 05:04:48 DEBUG : file2: md5 = d0e6edbdd8dea9d6823e0bcc597b8dbd OK --- PASS: TestCat (3.06s) === RUN TestPurge 2024/11/20 05:04:50 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-hogesem8nedo" 2024/11/20 05:04:50 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2024/11/20 05:04:50 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hogesem8nedo.bin" 2024/11/20 05:04:51 DEBUG : Swift container crypt path rclone-test-hogesem8nedo.bin: Auto set use_segments_container to true 2024/11/20 05:04:51 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hogesem8nedo" 2024/11/20 05:04:51 DEBUG : Config file has changed externally - reloading 2024/11/20 05:04:52 DEBUG : Swift container crypt path rclone-test-hogesem8nedo: Auto set use_segments_container to true 2024/11/20 05:04:52 DEBUG : Creating backend with remote "/tmp/rclone2789777890" run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hogesem8nedo'", Local "Local file system at /tmp/rclone2789777890", Modify Window "1ns" 2024/11/20 05:04:53 DEBUG : A1/B1/C1/one: md5 = c6eee203a4c2c5576479b20ebb7b6f96 OK 2024/11/20 05:04:53 DEBUG : A2: Making directory 2024/11/20 05:04:53 DEBUG : A1/B2: Making directory 2024/11/20 05:04:53 DEBUG : A1/B2/C2: Making directory 2024/11/20 05:04:53 DEBUG : A1/B1/C3: Making directory 2024/11/20 05:04:53 DEBUG : A3: Making directory 2024/11/20 05:04:53 DEBUG : A3/B3: Making directory 2024/11/20 05:04:53 DEBUG : A3/B3/C4: Making directory 2024/11/20 05:04:53 DEBUG : A1/two: md5 = f5c4d180226790dc32f2fcf346b3ac6c OK fstest.go:244: Filtering empty directory "A2" fstest.go:244: Filtering empty directory "A1/B2" fstest.go:244: Filtering empty directory "A1/B2/C2" fstest.go:244: Filtering empty directory "A1/B1/C3" fstest.go:244: Filtering empty directory "A3" fstest.go:244: Filtering empty directory "A3/B3" fstest.go:244: Filtering empty directory "A3/B3/C4" 2024/11/20 05:04:54 DEBUG : Waiting for deletions to finish 2024/11/20 05:04:54 INFO : A1/B1/C1/one.bin: Deleted fstest.go:244: Filtering empty directory "A2" fstest.go:244: Filtering empty directory "A1/B2" fstest.go:244: Filtering empty directory "A1/B2/C2" fstest.go:244: Filtering empty directory "A3" fstest.go:244: Filtering empty directory "A3/B3" fstest.go:244: Filtering empty directory "A3/B3/C4" 2024/11/20 05:04:54 DEBUG : Waiting for deletions to finish 2024/11/20 05:04:54 INFO : A1/two.bin: Deleted 2024/11/20 05:04:54 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-hogesem8nedo': Purge remote 2024/11/20 05:04:54 DEBUG : Waiting for deletions to finish --- PASS: TestPurge (4.35s) === RUN TestRmdirsNoLeaveRoot run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:04:55 DEBUG : A1/B1/C1/one: md5 = 9ea4f05a2f5c8b1a20741015737ca99a OK 2024/11/20 05:04:55 DEBUG : A2: Making directory 2024/11/20 05:04:55 DEBUG : A1/B2: Making directory 2024/11/20 05:04:55 DEBUG : A1/B2/C2: Making directory 2024/11/20 05:04:55 DEBUG : A1/B1/C3: Making directory 2024/11/20 05:04:55 DEBUG : A3: Making directory 2024/11/20 05:04:55 DEBUG : A3/B3: Making directory 2024/11/20 05:04:55 DEBUG : A3/B3/C4: Making directory 2024/11/20 05:04:56 DEBUG : A1/two: md5 = c918e877ba6934d27b71316cd762a5b3 OK fstest.go:244: Filtering empty directory "A2" fstest.go:244: Filtering empty directory "A1/B2" fstest.go:244: Filtering empty directory "A1/B2/C2" fstest.go:244: Filtering empty directory "A1/B1/C3" fstest.go:244: Filtering empty directory "A3" fstest.go:244: Filtering empty directory "A3/B3" fstest.go:244: Filtering empty directory "A3/B3/C4" 2024/11/20 05:04:56 DEBUG : removing 1 level 3 directories 2024/11/20 05:04:56 INFO : A3/B3/C4: Removing directory fstest.go:244: Filtering empty directory "A2" fstest.go:244: Filtering empty directory "A1/B2" fstest.go:244: Filtering empty directory "A1/B2/C2" fstest.go:244: Filtering empty directory "A1/B1/C3" fstest.go:244: Filtering empty directory "A3" fstest.go:244: Filtering empty directory "A3/B3" 2024/11/20 05:04:57 DEBUG : removing 1 level 0 directories 2024/11/20 05:04:57 INFO : Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo': Removing directory --- PASS: TestRmdirsNoLeaveRoot (3.09s) === RUN TestRmdirsLeaveRoot run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:04:58 DEBUG : A1: Making directory 2024/11/20 05:04:58 DEBUG : A1/B1: Making directory 2024/11/20 05:04:58 DEBUG : A1/B1/C1: Making directory fstest.go:244: Filtering empty directory "A1" fstest.go:244: Filtering empty directory "A1/B1" fstest.go:244: Filtering empty directory "A1/B1/C1" fstest.go:244: Filtering empty directory "A1" --- PASS: TestRmdirsLeaveRoot (0.23s) === RUN TestRmdirsWithFilter run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:04:58 DEBUG : A1: Making directory 2024/11/20 05:04:58 DEBUG : A1/B1: Making directory 2024/11/20 05:04:58 DEBUG : A1/B1/C1: Making directory fstest.go:244: Filtering empty directory "A1" fstest.go:244: Filtering empty directory "A1/B1" fstest.go:244: Filtering empty directory "A1/B1/C1" fstest.go:244: Filtering empty directory "A1" --- PASS: TestRmdirsWithFilter (0.22s) === RUN TestCopyURL run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:04:58 DEBUG : file1: md5 = 334c1638ff66e4332a05430af816905a OK 2024/11/20 05:04:59 DEBUG : filename.txt: File name found in url 2024/11/20 05:04:59 DEBUG : filename.txt: md5 = c167b85de512b53df192210684337376 OK 2024/11/20 05:04:59 DEBUG : headerfilename.txt: filename found in Content-Disposition header. 2024/11/20 05:04:59 DEBUG : headerfilename.txt: md5 = de6bd0eda348422730ec5ef669027128 OK 2024/11/20 05:05:07 DEBUG : file2: md5 = 9d36c47a8c36eee2ca2363a044a34159 OK --- PASS: TestCopyURL (15.40s) === RUN TestCopyURLToWriter --- PASS: TestCopyURLToWriter (0.00s) === RUN TestMoveFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:05:14 DEBUG : file1: Need to transfer - File not found at Destination 2024/11/20 05:05:14 DEBUG : sub/file2: md5 = 2a62669b9d2b8f40a23f469dcbc783a5 OK 2024/11/20 05:05:14 INFO : file1: Copied (new) to: sub/file2 2024/11/20 05:05:14 INFO : file1: Deleted 2024/11/20 05:05:14 DEBUG : file1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/20 05:05:14 DEBUG : file1: Unchanged skipping 2024/11/20 05:05:14 INFO : file1: Deleted 2024/11/20 05:05:14 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo': don't need to copy/move sub/file2, it is already at target location --- PASS: TestMoveFile (1.06s) === RUN TestMoveFileWithIgnoreExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:05:15 DEBUG : file1: Need to transfer - File not found at Destination 2024/11/20 05:05:15 DEBUG : file1: md5 = 4c2f78594ccab8e9267fd74678797c58 OK 2024/11/20 05:05:15 INFO : file1: Copied (new) 2024/11/20 05:05:15 INFO : file1: Deleted 2024/11/20 05:05:15 DEBUG : file1: Destination exists, skipping 2024/11/20 05:05:15 DEBUG : file1: Not removing source file as destination file exists and --ignore-existing is set --- PASS: TestMoveFileWithIgnoreExisting (0.99s) === RUN TestCaseInsensitiveMoveFile run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" --- PASS: TestCaseInsensitiveMoveFile (0.19s) === RUN TestCaseInsensitiveMoveFileDryRun run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" --- PASS: TestCaseInsensitiveMoveFileDryRun (0.09s) === RUN TestMoveFileBackupDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:05:16 DEBUG : dst/file1: md5 = e3ba7db8bc79174ea582d254ff9037d6 OK 2024/11/20 05:05:16 DEBUG : Creating backend with remote "TestCryptSwift:rclone-test-hexopiw7lilo/backup" 2024/11/20 05:05:16 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hexopiw7lilo/backup.bin" 2024/11/20 05:05:17 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo/backup.bin: Auto set use_segments_container to true 2024/11/20 05:05:17 DEBUG : Creating backend with remote "memstore:crypt/rclone-test-hexopiw7lilo/backup" 2024/11/20 05:05:18 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo/backup: Auto set use_segments_container to true 2024/11/20 05:05:18 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18) 2024/11/20 05:05:18 INFO : dst/file1: Copied (server-side copy) 2024/11/20 05:05:19 INFO : dst/file1: Deleted 2024/11/20 05:05:19 DEBUG : dst/file1: md5 = 0a8ba93c20df8fa25c894b4418547cc5 OK 2024/11/20 05:05:19 INFO : dst/file1: Copied (new) 2024/11/20 05:05:19 INFO : dst/file1: Deleted --- PASS: TestMoveFileBackupDir (4.03s) === 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 "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:05:20 DEBUG : A1/one: md5 = c6a422cb5552053180c06af672e8dc7c OK 2024/11/20 05:05:21 DEBUG : A1/two: md5 = 2a49cf115e54dca253692a3f1070fc60 OK 2024/11/20 05:05:21 DEBUG : A1/B1/three: md5 = 17719492a49c3d9751645d551265316b OK 2024/11/20 05:05:22 DEBUG : A1/B1/C1/four: md5 = 8d639512c7d13ceea96f0543156532cb OK 2024/11/20 05:05:22 DEBUG : A1/B1/C2/five: md5 = 4a4ac4e02ebbeb4efade9fe896726829 OK 2024/11/20 05:05:22 DEBUG : A1/B2: Making directory 2024/11/20 05:05:22 DEBUG : A1/B1/C3: Making directory fstest.go:244: Filtering empty directory "A1/B2" fstest.go:244: Filtering empty directory "A1/B1/C3" 2024/11/20 05:05:25 INFO : A1/B1/C1/four: Copied (server-side copy) to: A2/B1/C1/four 2024/11/20 05:05:25 INFO : A1/B1/C1/four: Deleted 2024/11/20 05:05:25 INFO : A1/one: Copied (server-side copy) to: A2/one 2024/11/20 05:05:25 INFO : A1/two: Copied (server-side copy) to: A2/two 2024/11/20 05:05:25 INFO : A1/one: Deleted 2024/11/20 05:05:25 INFO : A1/B1/three: Copied (server-side copy) to: A2/B1/three 2024/11/20 05:05:25 INFO : A1/B1/three: Deleted 2024/11/20 05:05:25 INFO : A1/B1/C2/five: Copied (server-side copy) to: A2/B1/C2/five 2024/11/20 05:05:25 INFO : A1/two: Deleted 2024/11/20 05:05:25 INFO : A1/B1/C2/five: Deleted fstest.go:244: Filtering empty directory "A2/B2" fstest.go:244: Filtering empty directory "A2/B1/C3" 2024/11/20 05:05:26 INFO : A2/one: Copied (server-side copy) to: A3/one 2024/11/20 05:05:26 INFO : A2/B1/C1/four: Copied (server-side copy) to: A3/B1/C1/four 2024/11/20 05:05:26 INFO : A2/B1/C2/five: Copied (server-side copy) to: A3/B1/C2/five 2024/11/20 05:05:26 INFO : A2/B1/C1/four: Deleted 2024/11/20 05:05:26 INFO : A2/one: Deleted 2024/11/20 05:05:27 INFO : A2/two: Copied (server-side copy) to: A3/two 2024/11/20 05:05:27 INFO : A2/B1/three: Copied (server-side copy) to: A3/B1/three 2024/11/20 05:05:27 INFO : A2/B1/C2/five: Deleted 2024/11/20 05:05:27 INFO : A2/B1/three: Deleted 2024/11/20 05:05:27 INFO : A2/two: Deleted fstest.go:244: Filtering empty directory "A3/B2" fstest.go:244: Filtering empty directory "A3/B1/C3" 2024/11/20 05:05:27 INFO : Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo': Can't DirMove - falling back to file moves: can't move directory - incompatible remotes 2024/11/20 05:05:28 INFO : A3/B1/C1/four: Copied (server-side copy) to: A4/B1/C1/four 2024/11/20 05:05:28 INFO : A3/one: Copied (server-side copy) to: A4/one 2024/11/20 05:05:28 INFO : A3/B1/C1/four: Deleted 2024/11/20 05:05:28 INFO : A3/one: Deleted 2024/11/20 05:05:28 INFO : A3/B1/C2/five: Copied (server-side copy) to: A4/B1/C2/five 2024/11/20 05:05:28 INFO : A3/B1/C2/five: Deleted 2024/11/20 05:05:28 INFO : A3/B1/three: Copied (server-side copy) to: A4/B1/three 2024/11/20 05:05:28 INFO : A3/B1/three: Deleted 2024/11/20 05:05:29 INFO : A3/two: Copied (server-side copy) to: A4/two 2024/11/20 05:05:29 INFO : A3/two: Deleted fstest.go:244: Filtering empty directory "A4/B2" fstest.go:244: Filtering empty directory "A4/B1/C3" --- PASS: TestDirMove (10.22s) === RUN TestGetFsInfo run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" --- PASS: TestGetFsInfo (0.19s) === RUN TestRcat === RUN TestRcat/withChecksum=false,ignoreChecksum=false run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:05:30 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo': File to upload is small (34 bytes), uploading instead of streaming 2024/11/20 05:05:31 DEBUG : no_checksum_small_file_from_pipe: md5 = 962461e2b546b164191b7d0609b22017 OK 2024/11/20 05:05:31 NOTICE: Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo': --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2024/11/20 05:05:31 DEBUG : no_checksum_small_file_from_pipe: Size of src and dst objects identical 2024/11/20 05:05:31 DEBUG : no_checksum_big_file_from_pipe.bin: Uploading segment file "rclone-test-hexopiw7lilo/no_checksum_big_file_from_pipe.bin/2024-11-20-050531-HAfJuNLkZejy9z1lEvIp6A/00000000" into "crypt_segments" 2024/11/20 05:05:33 DEBUG : no_checksum_big_file_from_pipe.bin: Uploading segments into "crypt_segments" seems done (EOF) 2024/11/20 05:05:33 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo: uploading manifest "rclone-test-hexopiw7lilo/no_checksum_big_file_from_pipe.bin" to "crypt" 2024/11/20 05:05:35 DEBUG : no_checksum_big_file_from_pipe.bin: Returning empty Md5sum for swift large object 2024/11/20 05:05:35 DEBUG : no_checksum_big_file_from_pipe: Size of src and dst objects identical === RUN TestRcat/withChecksum=true,ignoreChecksum=false run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:05:37 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo': File to upload is small (34 bytes), uploading instead of streaming 2024/11/20 05:05:38 DEBUG : with_checksum_small_file_from_pipe: md5 = dc0431ce454ae5491276335cf3f6eb5d OK 2024/11/20 05:05:38 DEBUG : with_checksum_small_file_from_pipe: Size of src and dst objects identical 2024/11/20 05:05:38 DEBUG : with_checksum_big_file_from_pipe.bin: Uploading segment file "rclone-test-hexopiw7lilo/with_checksum_big_file_from_pipe.bin/2024-11-20-050538-gWzWLfSpDvsI3F3-DkXEoQ/00000000" into "crypt_segments" 2024/11/20 05:05:38 DEBUG : with_checksum_big_file_from_pipe.bin: Uploading segments into "crypt_segments" seems done (EOF) 2024/11/20 05:05:38 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo: uploading manifest "rclone-test-hexopiw7lilo/with_checksum_big_file_from_pipe.bin" to "crypt" 2024/11/20 05:05:39 DEBUG : with_checksum_big_file_from_pipe.bin: Returning empty Md5sum for swift large object 2024/11/20 05:05:39 DEBUG : with_checksum_big_file_from_pipe: Size of src and dst objects identical === RUN TestRcat/withChecksum=false,ignoreChecksum=true run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:05:41 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo': File to upload is small (34 bytes), uploading instead of streaming 2024/11/20 05:05:41 DEBUG : ignore_checksum_small_file_from_pipe: Size and modification time the same (differ by 0s, within tolerance 1ns) 2024/11/20 05:05:41 DEBUG : ignore_checksum_big_file_from_pipe.bin: Uploading segment file "rclone-test-hexopiw7lilo/ignore_checksum_big_file_from_pipe.bin/2024-11-20-050541-5pnutgBNc5SjfiUXM-puJQ/00000000" into "crypt_segments" 2024/11/20 05:05:42 DEBUG : ignore_checksum_big_file_from_pipe.bin: Uploading segments into "crypt_segments" seems done (EOF) 2024/11/20 05:05:42 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo: uploading manifest "rclone-test-hexopiw7lilo/ignore_checksum_big_file_from_pipe.bin" to "crypt" 2024/11/20 05:05:42 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 "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:05:44 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo': File to upload is small (34 bytes), uploading instead of streaming 2024/11/20 05:05:44 DEBUG : ignore_checksum_small_file_from_pipe: Size of src and dst objects identical 2024/11/20 05:05:44 DEBUG : ignore_checksum_big_file_from_pipe.bin: Uploading segment file "rclone-test-hexopiw7lilo/ignore_checksum_big_file_from_pipe.bin/2024-11-20-050544-PfYYJQ13I7wxkK3Py7vbdA/00000000" into "crypt_segments" 2024/11/20 05:05:45 DEBUG : ignore_checksum_big_file_from_pipe.bin: Uploading segments into "crypt_segments" seems done (EOF) 2024/11/20 05:05:45 DEBUG : Swift container crypt path rclone-test-hexopiw7lilo: uploading manifest "rclone-test-hexopiw7lilo/ignore_checksum_big_file_from_pipe.bin" to "crypt" 2024/11/20 05:05:45 DEBUG : ignore_checksum_big_file_from_pipe: Size of src and dst objects identical --- PASS: TestRcat (16.73s) --- PASS: TestRcat/withChecksum=false,ignoreChecksum=false (6.65s) --- PASS: TestRcat/withChecksum=true,ignoreChecksum=false (3.65s) --- PASS: TestRcat/withChecksum=false,ignoreChecksum=true (3.32s) --- PASS: TestRcat/withChecksum=true,ignoreChecksum=true (3.11s) === RUN TestRcatMetadata run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" operations_test.go:1532: Skipping as destination doesn't support user metadata --- SKIP: TestRcatMetadata (0.20s) === RUN TestRcatSize run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:05:48 DEBUG : potato1: md5 = c732a311d59366f0aff6206de240a768 OK 2024/11/20 05:05:48 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo': File to upload is small (60 bytes), uploading instead of streaming 2024/11/20 05:05:48 DEBUG : potato2: md5 = b7cc5eab847824161da39c1d06d9a904 OK 2024/11/20 05:05:48 DEBUG : potato2: Size of src and dst objects identical --- PASS: TestRcatSize (1.21s) === RUN TestRcatSizeMetadata run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" operations_test.go:1613: Skipping as destination doesn't support user metadata --- SKIP: TestRcatSizeMetadata (0.21s) === RUN TestTouchDir run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" 2024/11/20 05:05:49 DEBUG : potato2: md5 = 1a716bab7492827002c5163b75964b2b OK 2024/11/20 05:05:49 DEBUG : empty space: md5 = 8230d6ab5c34450c0e6b581e7eb78570 OK 2024/11/20 05:05:49 DEBUG : sub dir/potato3: md5 = ed792be156dfb9412fba0947c1f6130f OK 2024/11/20 05:05:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo': Touching "empty space" 2024/11/20 05:05:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo': Touching "potato2" 2024/11/20 05:05:50 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo': Touching "sub dir/potato3" --- PASS: TestTouchDir (2.51s) === RUN TestMkdirMetadata run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" operations_test.go:1703: Skipping test as remote does not support MkdirMetadata --- SKIP: TestMkdirMetadata (0.19s) === RUN TestMkdirModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" operations_test.go:1722: Skipping test as remote does not support DirSetModTime or MkdirMetadata --- SKIP: TestMkdirModTime (0.10s) === RUN TestCopyDirMetadata run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" operations_test.go:1743: Skipping test as remote does not support WriteDirMetadata or MkdirMetadata --- SKIP: TestCopyDirMetadata (0.18s) === RUN TestSetDirModTime run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" operations_test.go:1779: Skipping test as remote does not support DirSetModTime or WriteDirSetModTime --- SKIP: TestSetDirModTime (0.09s) === RUN TestDirsEqual run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" operations_test.go:1823: Skipping test as remote does not support WriteDirMetadata or MkdirMetadata --- SKIP: TestDirsEqual (0.09s) === RUN TestRemoveExisting run.go:180: Remote "Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo'", Local "Local file system at /tmp/rclone3055548330", Modify Window "1ns" operations_test.go:1892: Skipping as remote can't Move --- SKIP: TestRemoveExisting (0.09s) === RUN TestRcAbout rc_test.go:30: Skipping test on non local remote --- SKIP: TestRcAbout (0.00s) === RUN TestRcCleanup rc_test.go:30: Skipping test on non local remote --- SKIP: TestRcCleanup (0.00s) === RUN TestRcCopyfile rc_test.go:30: Skipping test on non local remote --- SKIP: TestRcCopyfile (0.00s) === RUN TestRcCopyurl rc_test.go:30: Skipping test on non local remote --- SKIP: TestRcCopyurl (0.00s) === RUN TestRcDelete rc_test.go:30: Skipping test on non local remote --- SKIP: TestRcDelete (0.00s) === RUN TestRcDeletefile rc_test.go:30: Skipping test on non local remote --- SKIP: TestRcDeletefile (0.00s) === RUN TestRcList rc_test.go:30: Skipping test on non local remote --- SKIP: TestRcList (0.00s) === RUN TestRcStat rc_test.go:30: Skipping test on non local remote --- SKIP: TestRcStat (0.00s) === RUN TestRcSetTier rc_test.go:30: Skipping test on non local remote --- SKIP: TestRcSetTier (0.00s) === RUN TestRcSetTierFile rc_test.go:30: Skipping test on non local remote --- SKIP: TestRcSetTierFile (0.00s) === RUN TestRcMkdir rc_test.go:30: Skipping test on non local remote --- SKIP: TestRcMkdir (0.00s) === RUN TestRcMovefile rc_test.go:30: Skipping test on non local remote --- SKIP: TestRcMovefile (0.00s) === RUN TestRcPurge rc_test.go:30: Skipping test on non local remote --- SKIP: TestRcPurge (0.00s) === RUN TestRcRmdir rc_test.go:30: Skipping test on non local remote --- SKIP: TestRcRmdir (0.00s) === RUN TestRcRmdirs rc_test.go:30: Skipping test on non local remote --- SKIP: TestRcRmdirs (0.00s) === RUN TestRcSize rc_test.go:30: Skipping test on non local remote --- SKIP: TestRcSize (0.00s) === RUN TestRcPublicLink rc_test.go:30: Skipping test on non local remote --- SKIP: TestRcPublicLink (0.00s) === RUN TestRcFsInfo rc_test.go:30: Skipping test on non local remote --- SKIP: TestRcFsInfo (0.00s) === RUN TestUploadFile rc_test.go:30: Skipping test on non local remote --- SKIP: TestUploadFile (0.00s) === RUN TestRcCommand rc_test.go:30: Skipping test on non local remote --- SKIP: TestRcCommand (0.00s) === RUN TestRcDu rc_test.go:30: Skipping test on non local remote --- SKIP: TestRcDu (0.00s) === RUN TestRcCheck rc_test.go:30: Skipping test on non local remote --- SKIP: TestRcCheck (0.00s) === RUN TestRcHashsum rc_test.go:30: Skipping test on non local remote --- SKIP: TestRcHashsum (0.00s) === RUN TestRcHashsumFile rc_test.go:30: Skipping test on non local remote --- SKIP: TestRcHashsumFile (0.00s) PASS 2024/11/20 05:05:52 DEBUG : Encrypted drive 'TestCryptSwift:rclone-test-hexopiw7lilo': Purge remote 2024/11/20 05:05:52 DEBUG : Waiting for deletions to finish "./operations.test -test.v -test.timeout 1h0m0s -remote TestCryptSwift: -verbose" - Finished OK in 4m25.070679255s (try 1/5)