"./operations.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Starting (try 1/5) 2021/03/04 05:05:47 DEBUG : Creating backend with remote "TestB2:rclone-test-pobenip8cafolot0dezonif6" 2021/03/04 05:05:48 DEBUG : Creating backend with remote "/tmp/rclone098986532" === RUN TestDoMultiThreadCopy --- PASS: TestDoMultiThreadCopy (0.00s) === RUN TestMultithreadCalculateChunks === RUN TestMultithreadCalculateChunks/{size:1_streams:10_wantPartSize:65536_wantStreams:1} === RUN TestMultithreadCalculateChunks/{size:1048576_streams:1_wantPartSize:1048576_wantStreams:1} === RUN TestMultithreadCalculateChunks/{size:1048576_streams:2_wantPartSize:524288_wantStreams:2} === RUN TestMultithreadCalculateChunks/{size:1048577_streams:2_wantPartSize:589824_wantStreams:2} === RUN TestMultithreadCalculateChunks/{size:1048575_streams:2_wantPartSize:524288_wantStreams:2} --- PASS: TestMultithreadCalculateChunks (0.00s) --- PASS: TestMultithreadCalculateChunks/{size:1_streams:10_wantPartSize:65536_wantStreams:1} (0.00s) --- PASS: TestMultithreadCalculateChunks/{size:1048576_streams:1_wantPartSize:1048576_wantStreams:1} (0.00s) --- PASS: TestMultithreadCalculateChunks/{size:1048576_streams:2_wantPartSize:524288_wantStreams:2} (0.00s) --- PASS: TestMultithreadCalculateChunks/{size:1048577_streams:2_wantPartSize:589824_wantStreams:2} (0.00s) --- PASS: TestMultithreadCalculateChunks/{size:1048575_streams:2_wantPartSize:524288_wantStreams:2} (0.00s) === RUN TestMultithreadCopy run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" === RUN TestMultithreadCopy/{size:131071_streams:2} 2021/03/04 05:05:52 DEBUG : file1: Starting multi-thread copy with 2 parts of size 64k 2021/03/04 05:05:52 DEBUG : file1: multi-thread copy: stream 1/2 (0-65536) size 64k starting 2021/03/04 05:05:52 DEBUG : file1: multi-thread copy: stream 2/2 (65536-131071) size 63.999k starting 2021/03/04 05:05:52 DEBUG : file1: multi-thread copy: stream 1/2 (0-65536) size 64k finished 2021/03/04 05:05:52 DEBUG : file1: multi-thread copy: stream 2/2 (65536-131071) size 63.999k finished 2021/03/04 05:05:52 DEBUG : file1: Finished multi-thread copy with 2 parts of size 64k === RUN TestMultithreadCopy/{size:131072_streams:2} 2021/03/04 05:05:54 DEBUG : file1: Starting multi-thread copy with 2 parts of size 64k 2021/03/04 05:05:54 DEBUG : file1: multi-thread copy: stream 2/2 (65536-131072) size 64k starting 2021/03/04 05:05:54 DEBUG : file1: multi-thread copy: stream 1/2 (0-65536) size 64k starting 2021/03/04 05:05:54 DEBUG : file1: multi-thread copy: stream 2/2 (65536-131072) size 64k finished 2021/03/04 05:05:54 DEBUG : file1: multi-thread copy: stream 1/2 (0-65536) size 64k finished 2021/03/04 05:05:54 DEBUG : file1: Finished multi-thread copy with 2 parts of size 64k === RUN TestMultithreadCopy/{size:131073_streams:2} 2021/03/04 05:05:55 DEBUG : file1: Starting multi-thread copy with 2 parts of size 128k 2021/03/04 05:05:55 DEBUG : file1: multi-thread copy: stream 2/2 (131072-131073) size 1 starting 2021/03/04 05:05:55 DEBUG : file1: multi-thread copy: stream 1/2 (0-131072) size 128k starting 2021/03/04 05:05:56 DEBUG : file1: multi-thread copy: stream 2/2 (131072-131073) size 1 finished 2021/03/04 05:05:56 DEBUG : file1: multi-thread copy: stream 1/2 (0-131072) size 128k finished 2021/03/04 05:05:56 DEBUG : file1: Finished multi-thread copy with 2 parts of size 128k --- PASS: TestMultithreadCopy (8.35s) --- PASS: TestMultithreadCopy/{size:131071_streams:2} (4.44s) --- PASS: TestMultithreadCopy/{size:131072_streams:2} (1.53s) --- PASS: TestMultithreadCopy/{size:131073_streams:2} (1.50s) === RUN TestSizeDiffers --- PASS: TestSizeDiffers (0.00s) === RUN TestReOpen === RUN TestReOpen/Seek === RUN TestReOpen/Seek/Basics === RUN TestReOpen/Seek/ErrorAtStart === RUN TestReOpen/Seek/WithErrors 2021/03/04 05:05:56 DEBUG : potato: Reopening on read failure after 2 bytes: retry 1/10: test error 2021/03/04 05:05:56 DEBUG : potato: Reopening on read failure after 3 bytes: retry 2/10: test error 2021/03/04 05:05:56 DEBUG : potato: Reopening on read failure after 6 bytes: retry 3/10: test error === RUN TestReOpen/Seek/TooManyErrors 2021/03/04 05:05:56 DEBUG : potato: Reopening on read failure after 2 bytes: retry 1/3: test error 2021/03/04 05:05:56 DEBUG : potato: Reopening on read failure after 3 bytes: retry 2/3: test error 2021/03/04 05:05:56 DEBUG : potato: Reopening on read failure after 6 bytes: retry 3/3: test error 2021/03/04 05:05:56 DEBUG : potato: Reopen failed after 6 bytes read: failed to reopen: too many retries === RUN TestReOpen/Range === RUN TestReOpen/Range/Basics === RUN TestReOpen/Range/ErrorAtStart === RUN TestReOpen/Range/WithErrors 2021/03/04 05:05:56 DEBUG : potato: Reopening on read failure after 2 bytes: retry 1/10: test error 2021/03/04 05:05:56 DEBUG : potato: Reopening on read failure after 3 bytes: retry 2/10: test error 2021/03/04 05:05:56 DEBUG : potato: Reopening on read failure after 6 bytes: retry 3/10: test error === RUN TestReOpen/Range/TooManyErrors 2021/03/04 05:05:56 DEBUG : potato: Reopening on read failure after 2 bytes: retry 1/3: test error 2021/03/04 05:05:56 DEBUG : potato: Reopening on read failure after 3 bytes: retry 2/3: test error 2021/03/04 05:05:56 DEBUG : potato: Reopening on read failure after 6 bytes: retry 3/3: test error 2021/03/04 05:05:56 DEBUG : potato: Reopen failed after 6 bytes read: failed to reopen: too many retries --- PASS: TestReOpen (0.00s) --- PASS: TestReOpen/Seek (0.00s) --- PASS: TestReOpen/Seek/Basics (0.00s) --- PASS: TestReOpen/Seek/ErrorAtStart (0.00s) --- PASS: TestReOpen/Seek/WithErrors (0.00s) --- PASS: TestReOpen/Seek/TooManyErrors (0.00s) --- PASS: TestReOpen/Range (0.00s) --- PASS: TestReOpen/Range/Basics (0.00s) --- PASS: TestReOpen/Range/ErrorAtStart (0.00s) --- PASS: TestReOpen/Range/WithErrors (0.00s) --- PASS: TestReOpen/Range/TooManyErrors (0.00s) === RUN TestCheck run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" === RUN TestCheck/1 === RUN TestCheck/2 === RUN TestCheck/3 === RUN TestCheck/4 === RUN TestCheck/5 === RUN TestCheck/6 === RUN TestCheck/7 --- PASS: TestCheck (6.26s) --- PASS: TestCheck/1 (0.14s) --- PASS: TestCheck/2 (0.14s) --- PASS: TestCheck/3 (0.15s) --- PASS: TestCheck/4 (0.15s) --- PASS: TestCheck/5 (0.15s) --- PASS: TestCheck/6 (0.14s) --- PASS: TestCheck/7 (0.14s) === RUN TestCheckFsError 2021/03/04 05:06:03 DEBUG : Creating backend with remote "non-existent" 2021/03/04 05:06:03 DEBUG : Creating backend with remote "non-existent" 2021/03/04 05:06:03 DEBUG : Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/non-existent: Waiting for checks to finish 2021/03/04 05:06:03 ERROR : : error reading source directory: directory not found 2021/03/04 05:06:03 NOTICE: Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/non-existent: 2 differences found 2021/03/04 05:06:03 NOTICE: Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/non-existent: 2 errors while checking --- PASS: TestCheckFsError (0.01s) === RUN TestCheckDownload run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" === RUN TestCheckDownload/1 === RUN TestCheckDownload/2 === RUN TestCheckDownload/3 === RUN TestCheckDownload/4 === RUN TestCheckDownload/5 === RUN TestCheckDownload/6 === RUN TestCheckDownload/7 --- PASS: TestCheckDownload (9.08s) --- PASS: TestCheckDownload/1 (0.74s) --- PASS: TestCheckDownload/2 (0.29s) --- PASS: TestCheckDownload/3 (0.29s) --- PASS: TestCheckDownload/4 (0.44s) --- PASS: TestCheckDownload/5 (0.31s) --- PASS: TestCheckDownload/6 (0.33s) --- PASS: TestCheckDownload/7 (0.30s) === RUN TestCheckSizeOnly run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" === RUN TestCheckSizeOnly/1 === RUN TestCheckSizeOnly/2 === RUN TestCheckSizeOnly/3 === RUN TestCheckSizeOnly/4 === RUN TestCheckSizeOnly/5 === RUN TestCheckSizeOnly/6 === RUN TestCheckSizeOnly/7 --- PASS: TestCheckSizeOnly (6.10s) --- PASS: TestCheckSizeOnly/1 (0.14s) --- PASS: TestCheckSizeOnly/2 (0.14s) --- PASS: TestCheckSizeOnly/3 (0.14s) --- PASS: TestCheckSizeOnly/4 (0.14s) --- PASS: TestCheckSizeOnly/5 (0.14s) --- PASS: TestCheckSizeOnly/6 (0.14s) --- PASS: TestCheckSizeOnly/7 (0.14s) === RUN TestCheckEqualReaders --- PASS: TestCheckEqualReaders (0.00s) === RUN TestDeduplicateInteractive run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateInteractive (0.29s) === RUN TestDeduplicateSkip run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateSkip (0.29s) === RUN TestDeduplicateSizeOnly run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateSizeOnly (0.29s) === RUN TestDeduplicateFirst run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateFirst (0.29s) === RUN TestDeduplicateNewest run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateNewest (0.29s) === RUN TestDeduplicateNewestByHash run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" 2021/03/04 05:06:22 INFO : B2 bucket rclone-test-pobenip8cafolot0dezonif6: Looking for duplicate SHA-1 hashes using newest mode. 2021/03/04 05:06:22 NOTICE: fa881af33b78e904b5d39c75ee6a1cbb55632e10: Found 3 files with duplicate SHA-1 hashes 2021/03/04 05:06:22 INFO : one: Deleted 2021/03/04 05:06:22 INFO : also/one: Deleted 2021/03/04 05:06:22 NOTICE: fa881af33b78e904b5d39c75ee6a1cbb55632e10: Deleted 2 extra copies --- PASS: TestDeduplicateNewestByHash (4.26s) === RUN TestDeduplicateOldest run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateOldest (0.29s) === RUN TestDeduplicateLargest run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateLargest (0.29s) === RUN TestDeduplicateSmallest run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateSmallest (0.29s) === RUN TestDeduplicateRename run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" dedupe_test.go:24: Can't test deduplicate - no duplicate files possible --- SKIP: TestDeduplicateRename (0.29s) === RUN TestMergeDirs run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" dedupe_test.go:267: Can't merge directories --- SKIP: TestMergeDirs (0.29s) === RUN TestListDirSorted run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" 2021/03/04 05:06:30 DEBUG : a.txt: Excluded 2021/03/04 05:06:30 DEBUG : sub dir/hello world: Excluded 2021/03/04 05:06:30 DEBUG : sub dir/hello world2: Excluded 2021/03/04 05:06:30 DEBUG : sub dir/hello world: Excluded 2021/03/04 05:06:30 DEBUG : sub dir/hello world2: Excluded 2021/03/04 05:06:31 DEBUG : sub dir/ignore dir: Excluded 2021/03/04 05:06:31 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:06:31 DEBUG : sub dir/ignore dir: Excluded --- PASS: TestListDirSorted (9.93s) === RUN TestMkdir run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" 2021/03/04 05:06:35 DEBUG : B2 bucket rclone-test-pobenip8cafolot0dezonif6: Making directory 2021/03/04 05:06:35 DEBUG : B2 bucket rclone-test-pobenip8cafolot0dezonif6: Making directory --- PASS: TestMkdir (0.43s) === RUN TestLsd run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" --- PASS: TestLsd (1.65s) === RUN TestLs run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" --- PASS: TestLs (2.59s) === RUN TestLsWithFilesFrom run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" 2021/03/04 05:06:41 DEBUG : empty space: Excluded 2021/03/04 05:06:41 DEBUG : Couldn't decode error response: EOF --- PASS: TestLsWithFilesFrom (2.82s) === RUN TestLsLong run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" --- PASS: TestLsLong (2.09s) === RUN TestHashSums run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" 2021/03/04 05:06:47 ERROR : potato2: Hash unsupported: hash type not supported 2021/03/04 05:06:47 ERROR : empty space: Hash unsupported: hash type not supported 2021/03/04 05:06:47 ERROR : potato2: Hash unsupported: hash type not supported 2021/03/04 05:06:47 ERROR : empty space: Hash unsupported: hash type not supported --- PASS: TestHashSums (4.19s) === RUN TestSuffixName --- PASS: TestSuffixName (0.00s) === RUN TestCount run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" --- PASS: TestCount (2.17s) === RUN TestDelete run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" 2021/03/04 05:06:52 DEBUG : Waiting for deletions to finish 2021/03/04 05:06:53 DEBUG : large: Excluded from sync (and deletion) 2021/03/04 05:06:53 INFO : medium: Deleted 2021/03/04 05:06:53 INFO : small: Deleted --- PASS: TestDelete (3.18s) === RUN TestRetry 2021/03/04 05:06:54 DEBUG : Received error: EOF - low level retry 1/5 2021/03/04 05:06:54 DEBUG : Received error: EOF - low level retry 2/5 2021/03/04 05:06:54 DEBUG : Received error: EOF - low level retry 1/5 2021/03/04 05:06:54 DEBUG : Received error: EOF - low level retry 2/5 2021/03/04 05:06:54 DEBUG : Received error: EOF - low level retry 3/5 2021/03/04 05:06:54 DEBUG : Received error: EOF - low level retry 4/5 2021/03/04 05:06:54 DEBUG : Received error: EOF - low level retry 5/5 --- PASS: TestRetry (0.00s) === RUN TestCat run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" --- PASS: TestCat (3.70s) === RUN TestPurge 2021/03/04 05:06:58 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2021/03/04 05:06:58 DEBUG : Creating backend with remote "TestB2:rclone-test-jofucec3voyawad3vivuquj6" 2021/03/04 05:06:58 DEBUG : Creating backend with remote "/tmp/rclone361665270" run.go:176: Remote "B2 bucket rclone-test-jofucec3voyawad3vivuquj6", Local "Local file system at /tmp/rclone361665270", Modify Window "1ms" 2021/03/04 05:07:00 DEBUG : A2: Making directory 2021/03/04 05:07:00 DEBUG : A1/B2: Making directory 2021/03/04 05:07:00 DEBUG : A1/B2/C2: Making directory 2021/03/04 05:07:00 DEBUG : A1/B1/C3: Making directory 2021/03/04 05:07:00 DEBUG : A3: Making directory 2021/03/04 05:07:00 DEBUG : A3/B3: Making directory 2021/03/04 05:07:00 DEBUG : A3/B3/C4: Making directory fstest.go:249: Filtering empty directory "A2" fstest.go:249: Filtering empty directory "A1/B2" fstest.go:249: Filtering empty directory "A1/B2/C2" fstest.go:249: Filtering empty directory "A1/B1/C3" fstest.go:249: Filtering empty directory "A3" fstest.go:249: Filtering empty directory "A3/B3" fstest.go:249: Filtering empty directory "A3/B3/C4" 2021/03/04 05:07:01 DEBUG : A1/B1/C1/one: Deleting (id "4_z8f02cd53a01dfbbb7f780e1b_f10697840339d79d2_d20210304_m050659_c001_v0001136_t0038") fstest.go:249: Filtering empty directory "A2" fstest.go:249: Filtering empty directory "A1/B2" fstest.go:249: Filtering empty directory "A1/B2/C2" fstest.go:249: Filtering empty directory "A3" fstest.go:249: Filtering empty directory "A3/B3" fstest.go:249: Filtering empty directory "A3/B3/C4" 2021/03/04 05:07:01 DEBUG : A1/two: Deleting (id "4_z8f02cd53a01dfbbb7f780e1b_f10697840339d79d5_d20210304_m050700_c001_v0001136_t0038") 2021/03/04 05:07:02 DEBUG : B2 bucket rclone-test-jofucec3voyawad3vivuquj6: Purge remote 2021/03/04 05:07:02 purge failed: directory not found --- PASS: TestPurge (4.05s) === RUN TestRmdirsNoLeaveRoot run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" 2021/03/04 05:07:03 DEBUG : A2: Making directory 2021/03/04 05:07:03 DEBUG : A1/B2: Making directory 2021/03/04 05:07:03 DEBUG : A1/B2/C2: Making directory 2021/03/04 05:07:03 DEBUG : A1/B1/C3: Making directory 2021/03/04 05:07:03 DEBUG : A3: Making directory 2021/03/04 05:07:03 DEBUG : A3/B3: Making directory 2021/03/04 05:07:03 DEBUG : A3/B3/C4: Making directory fstest.go:249: Filtering empty directory "A2" fstest.go:249: Filtering empty directory "A1/B2" fstest.go:249: Filtering empty directory "A1/B2/C2" fstest.go:249: Filtering empty directory "A1/B1/C3" fstest.go:249: Filtering empty directory "A3" fstest.go:249: Filtering empty directory "A3/B3" fstest.go:249: Filtering empty directory "A3/B3/C4" 2021/03/04 05:07:04 DEBUG : A3/B3/C4: Removing directory fstest.go:249: Filtering empty directory "A2" fstest.go:249: Filtering empty directory "A1/B2" fstest.go:249: Filtering empty directory "A1/B2/C2" fstest.go:249: Filtering empty directory "A1/B1/C3" fstest.go:249: Filtering empty directory "A3" fstest.go:249: Filtering empty directory "A3/B3" --- PASS: TestRmdirsNoLeaveRoot (4.75s) === RUN TestRmdirsLeaveRoot run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" 2021/03/04 05:07:07 DEBUG : A1: Making directory 2021/03/04 05:07:07 DEBUG : A1/B1: Making directory 2021/03/04 05:07:07 DEBUG : A1/B1/C1: Making directory fstest.go:249: Filtering empty directory "A1" fstest.go:249: Filtering empty directory "A1/B1" fstest.go:249: Filtering empty directory "A1/B1/C1" fstest.go:249: Filtering empty directory "A1" --- PASS: TestRmdirsLeaveRoot (0.72s) === RUN TestRmdirsWithFilter run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" 2021/03/04 05:07:07 DEBUG : A1: Making directory 2021/03/04 05:07:07 DEBUG : A1/B1: Making directory 2021/03/04 05:07:07 DEBUG : A1/B1/C1: Making directory fstest.go:249: Filtering empty directory "A1" fstest.go:249: Filtering empty directory "A1/B1" fstest.go:249: Filtering empty directory "A1/B1/C1" fstest.go:249: Filtering empty directory "A1" --- PASS: TestRmdirsWithFilter (0.72s) === RUN TestCopyURL run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" --- PASS: TestCopyURL (4.57s) === RUN TestCopyURLToWriter --- PASS: TestCopyURLToWriter (0.00s) === RUN TestMoveFile run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" 2021/03/04 05:07:13 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:07:13 DEBUG : file1: Need to transfer - File not found at Destination 2021/03/04 05:07:13 DEBUG : file1: SHA-1 = a379624177abc4679cafafa8eae1d73e1478aaa6 OK 2021/03/04 05:07:13 INFO : file1: Copied (new) to: sub/file2 2021/03/04 05:07:13 INFO : file1: Deleted 2021/03/04 05:07:14 DEBUG : file1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/03/04 05:07:14 DEBUG : file1: Unchanged skipping 2021/03/04 05:07:14 INFO : file1: Deleted 2021/03/04 05:07:14 DEBUG : B2 bucket rclone-test-pobenip8cafolot0dezonif6: don't need to copy/move sub/file2, it is already at target location --- PASS: TestMoveFile (2.46s) === RUN TestCaseInsensitiveMoveFile run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" --- PASS: TestCaseInsensitiveMoveFile (0.30s) === RUN TestMoveFileBackupDir run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" 2021/03/04 05:07:16 DEBUG : Creating backend with remote "TestB2:rclone-test-pobenip8cafolot0dezonif6/backup" 2021/03/04 05:07:17 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:07:17 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18) 2021/03/04 05:07:18 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:07:20 DEBUG : dst/file1: SHA-1 = 9d125cddbdc7323ccf9db2d2b67af177f781b5c6 OK 2021/03/04 05:07:20 INFO : dst/file1: Copied (server-side copy) 2021/03/04 05:07:20 INFO : dst/file1: Deleted 2021/03/04 05:07:20 DEBUG : dst/file1: SHA-1 = a379624177abc4679cafafa8eae1d73e1478aaa6 OK 2021/03/04 05:07:20 INFO : dst/file1: Copied (new) 2021/03/04 05:07:20 INFO : dst/file1: Deleted --- PASS: TestMoveFileBackupDir (6.60s) === RUN TestCopyFile run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" 2021/03/04 05:07:23 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:07:23 DEBUG : file1: Need to transfer - File not found at Destination 2021/03/04 05:07:23 DEBUG : file1: SHA-1 = a379624177abc4679cafafa8eae1d73e1478aaa6 OK 2021/03/04 05:07:23 INFO : file1: Copied (new) to: sub/file2 2021/03/04 05:07:23 DEBUG : file1: Size and modification time the same (differ by -999.999µs, within tolerance 1ms) 2021/03/04 05:07:23 DEBUG : file1: Unchanged skipping 2021/03/04 05:07:23 DEBUG : B2 bucket rclone-test-pobenip8cafolot0dezonif6: don't need to copy/move sub/file2, it is already at target location --- PASS: TestCopyFile (1.98s) === RUN TestCopyFileBackupDir run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" 2021/03/04 05:07:25 DEBUG : Creating backend with remote "TestB2:rclone-test-pobenip8cafolot0dezonif6/backup" 2021/03/04 05:07:26 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:07:26 DEBUG : dst/file1: Sizes differ (src 14 vs dst 18) 2021/03/04 05:07:26 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:07:28 DEBUG : dst/file1: SHA-1 = 9d125cddbdc7323ccf9db2d2b67af177f781b5c6 OK 2021/03/04 05:07:28 INFO : dst/file1: Copied (server-side copy) 2021/03/04 05:07:28 INFO : dst/file1: Deleted 2021/03/04 05:07:28 DEBUG : dst/file1: SHA-1 = a379624177abc4679cafafa8eae1d73e1478aaa6 OK 2021/03/04 05:07:28 INFO : dst/file1: Copied (new) --- PASS: TestCopyFileBackupDir (6.47s) === RUN TestCopyFileCompareDest run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" 2021/03/04 05:07:30 DEBUG : Creating backend with remote "TestB2:rclone-test-pobenip8cafolot0dezonif6/dst" 2021/03/04 05:07:32 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:07:32 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:07:32 DEBUG : Creating backend with remote "TestB2:rclone-test-pobenip8cafolot0dezonif6/CompareDest" 2021/03/04 05:07:32 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:07:32 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:07:32 DEBUG : one: Need to transfer - File not found at Destination 2021/03/04 05:07:34 DEBUG : one: SHA-1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/03/04 05:07:34 INFO : one: Copied (new) 2021/03/04 05:07:35 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:07:35 DEBUG : one: Sizes differ (src 5 vs dst 3) 2021/03/04 05:07:35 DEBUG : one: SHA-1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2021/03/04 05:07:35 INFO : one: Copied (replaced existing) 2021/03/04 05:07:37 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/03/04 05:07:37 DEBUG : one: Destination found in --compare-dest, skipping 2021/03/04 05:07:38 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:07:38 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/03/04 05:07:38 DEBUG : two: Destination found in --compare-dest, skipping 2021/03/04 05:07:38 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:07:38 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/03/04 05:07:38 DEBUG : two: Destination found in --compare-dest, skipping 2021/03/04 05:07:39 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:07:39 DEBUG : two: Sizes differ (src 5 vs dst 3) 2021/03/04 05:07:39 DEBUG : two: Need to transfer - File not found at Destination 2021/03/04 05:07:39 DEBUG : two: SHA-1 = a4be8877ad88f3109a6411985a1f359e10e2d930 OK 2021/03/04 05:07:39 INFO : two: Copied (new) --- PASS: TestCopyFileCompareDest (10.44s) === RUN TestCopyFileCopyDest run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" 2021/03/04 05:07:41 DEBUG : Creating backend with remote "TestB2:rclone-test-pobenip8cafolot0dezonif6/dst" 2021/03/04 05:07:42 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:07:42 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:07:42 DEBUG : Creating backend with remote "TestB2:rclone-test-pobenip8cafolot0dezonif6/CopyDest" 2021/03/04 05:07:42 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:07:42 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:07:42 DEBUG : one: Need to transfer - File not found at Destination 2021/03/04 05:07:47 DEBUG : one: SHA-1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/03/04 05:07:47 INFO : one: Copied (new) 2021/03/04 05:07:48 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:07:48 DEBUG : one: Sizes differ (src 5 vs dst 3) 2021/03/04 05:07:49 DEBUG : one: SHA-1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2021/03/04 05:07:49 INFO : one: Copied (replaced existing) 2021/03/04 05:07:51 DEBUG : Creating backend with remote "TestB2:rclone-test-pobenip8cafolot0dezonif6/BackupDir" 2021/03/04 05:07:52 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:07:52 DEBUG : one: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/03/04 05:07:52 DEBUG : one: Sizes differ (src 5 vs dst 3) 2021/03/04 05:07:52 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:07:53 DEBUG : one: SHA-1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/03/04 05:07:53 INFO : one: Copied (server-side copy) 2021/03/04 05:07:54 INFO : one: Deleted 2021/03/04 05:07:54 DEBUG : one: SHA-1 = 7f376fd65843a1267de8f986d40e164e5a321c13 OK 2021/03/04 05:07:54 INFO : one: Copied (server-side copy) 2021/03/04 05:07:54 DEBUG : one: Destination found in --copy-dest, using server-side copy 2021/03/04 05:07:55 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:07:55 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/03/04 05:07:57 DEBUG : two: SHA-1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2021/03/04 05:07:57 INFO : two: Copied (server-side copy) 2021/03/04 05:07:57 DEBUG : two: Destination found in --copy-dest, using server-side copy 2021/03/04 05:07:58 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/03/04 05:07:58 DEBUG : two: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) 2021/03/04 05:07:58 DEBUG : two: Unchanged skipping 2021/03/04 05:07:59 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:07:59 DEBUG : three: Sizes differ (src 7 vs dst 5) 2021/03/04 05:07:59 DEBUG : three: Destination not found in --copy-dest 2021/03/04 05:07:59 DEBUG : three: Need to transfer - File not found at Destination 2021/03/04 05:08:02 DEBUG : three: SHA-1 = 370e613335f3cf2f19b2a2d35a86402f55c659f8 OK 2021/03/04 05:08:02 INFO : three: Copied (new) --- PASS: TestCopyFileCopyDest (27.51s) === RUN TestSameConfig --- PASS: TestSameConfig (0.00s) === RUN TestSame --- PASS: TestSame (0.00s) === RUN TestOverlapping --- PASS: TestOverlapping (0.00s) === RUN TestListFormat --- PASS: TestListFormat (0.00s) === RUN TestDirMove run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" 2021/03/04 05:08:11 DEBUG : A1/B2: Making directory 2021/03/04 05:08:11 DEBUG : A1/B1/C3: Making directory fstest.go:249: Filtering empty directory "A1/B2" fstest.go:249: Filtering empty directory "A1/B1/C3" 2021/03/04 05:08:12 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:08:12 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:08:12 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:08:12 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:08:13 DEBUG : A1/B1/C1/four: SHA-1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2021/03/04 05:08:13 INFO : A1/B1/C1/four: Copied (server-side copy) to: A2/B1/C1/four 2021/03/04 05:08:13 DEBUG : A1/B1/three: SHA-1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/03/04 05:08:13 INFO : A1/B1/three: Copied (server-side copy) to: A2/B1/three 2021/03/04 05:08:13 INFO : A1/B1/C1/four: Deleted 2021/03/04 05:08:13 DEBUG : A1/one: SHA-1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/03/04 05:08:13 INFO : A1/one: Copied (server-side copy) to: A2/one 2021/03/04 05:08:13 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:08:13 INFO : A1/B1/three: Deleted 2021/03/04 05:08:13 DEBUG : A1/B1/C2/five: SHA-1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2021/03/04 05:08:13 INFO : A1/B1/C2/five: Copied (server-side copy) to: A2/B1/C2/five 2021/03/04 05:08:14 DEBUG : A1/two: SHA-1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2021/03/04 05:08:14 INFO : A1/two: Copied (server-side copy) to: A2/two 2021/03/04 05:08:14 INFO : A1/B1/C2/five: Deleted 2021/03/04 05:08:14 INFO : A1/two: Deleted 2021/03/04 05:08:15 INFO : A1/one: Deleted fstest.go:249: Filtering empty directory "A2/B2" fstest.go:249: Filtering empty directory "A2/B1/C3" 2021/03/04 05:08:15 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:08:15 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:08:15 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:08:15 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:08:16 DEBUG : A2/B1/C2/five: SHA-1 = 4db2c1df4610cd6c0da6b9197b066bfb4e9b9d00 OK 2021/03/04 05:08:16 INFO : A2/B1/C2/five: Copied (server-side copy) to: A3/B1/C2/five 2021/03/04 05:08:16 DEBUG : A2/one: SHA-1 = fe05bcdcdc4928012781a5f1a2a77cbb5398e106 OK 2021/03/04 05:08:16 INFO : A2/one: Copied (server-side copy) to: A3/one 2021/03/04 05:08:16 DEBUG : A2/B1/C1/four: SHA-1 = 9f8f7eec5dea5ac43738721939c120318cbff1df OK 2021/03/04 05:08:16 INFO : A2/B1/C1/four: Copied (server-side copy) to: A3/B1/C1/four 2021/03/04 05:08:16 INFO : A2/one: Deleted 2021/03/04 05:08:16 INFO : A2/B1/C2/five: Deleted 2021/03/04 05:08:16 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:08:16 INFO : A2/B1/C1/four: Deleted 2021/03/04 05:08:16 DEBUG : A2/two: SHA-1 = ad782ecdac770fc6eb9a62e44f90873fb97fb26b OK 2021/03/04 05:08:16 INFO : A2/two: Copied (server-side copy) to: A3/two 2021/03/04 05:08:17 INFO : A2/two: Deleted 2021/03/04 05:08:55 DEBUG : A2/B1/three: SHA-1 = b802f384302cb24fbab0a44997e820bf2e8507bb OK 2021/03/04 05:08:55 INFO : A2/B1/three: Copied (server-side copy) to: A3/B1/three 2021/03/04 05:08:56 INFO : A2/B1/three: Deleted fstest.go:249: Filtering empty directory "A3/B2" fstest.go:249: Filtering empty directory "A3/B1/C3" --- PASS: TestDirMove (49.76s) === RUN TestGetFsInfo run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" --- PASS: TestGetFsInfo (0.29s) === RUN TestRcat === RUN TestRcat/withChecksum=false,ignoreChecksum=false === CONT TestRcat run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" 2021/03/04 05:08:59 DEBUG : B2 bucket rclone-test-pobenip8cafolot0dezonif6: File to upload is small (34 bytes), uploading instead of streaming 2021/03/04 05:08:59 DEBUG : no_checksum_small_file_from_pipe: SHA-1 = 4c3452689ee5e2b950454c46181b8b5e7bcfeca9 OK 2021/03/04 05:08:59 INFO : no_checksum_small_file_from_pipe: Copied (new) 2021/03/04 05:08:59 DEBUG : no_checksum_big_file_from_pipe: File has 102401 bytes, which makes only one chunk. Using direct upload. 2021/03/04 05:09:01 DEBUG : no_checksum_big_file_from_pipe: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) === RUN TestRcat/withChecksum=true,ignoreChecksum=false === CONT TestRcat run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" 2021/03/04 05:09:06 DEBUG : B2 bucket rclone-test-pobenip8cafolot0dezonif6: File to upload is small (34 bytes), uploading instead of streaming 2021/03/04 05:09:07 DEBUG : with_checksum_small_file_from_pipe: SHA-1 = 4c3452689ee5e2b950454c46181b8b5e7bcfeca9 OK 2021/03/04 05:09:07 INFO : with_checksum_small_file_from_pipe: Copied (new) 2021/03/04 05:09:07 DEBUG : with_checksum_big_file_from_pipe: File has 102401 bytes, which makes only one chunk. Using direct upload. 2021/03/04 05:09:08 DEBUG : with_checksum_big_file_from_pipe: SHA-1 = d0080f73aa8b494570ad63df1beb25c01ea9eea2 OK 2021/03/04 05:09:08 DEBUG : with_checksum_big_file_from_pipe: Size and SHA-1 of src and dst objects identical === RUN TestRcat/withChecksum=false,ignoreChecksum=true === CONT TestRcat run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" 2021/03/04 05:09:09 DEBUG : B2 bucket rclone-test-pobenip8cafolot0dezonif6: File to upload is small (34 bytes), uploading instead of streaming 2021/03/04 05:09:09 INFO : ignore_checksum_small_file_from_pipe: Copied (new) 2021/03/04 05:09:09 DEBUG : ignore_checksum_big_file_from_pipe: File has 102401 bytes, which makes only one chunk. Using direct upload. 2021/03/04 05:09:10 DEBUG : ignore_checksum_big_file_from_pipe: Size and modification time the same (differ by -456.789µs, within tolerance 1ms) === RUN TestRcat/withChecksum=true,ignoreChecksum=true === CONT TestRcat run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" 2021/03/04 05:09:12 DEBUG : B2 bucket rclone-test-pobenip8cafolot0dezonif6: File to upload is small (34 bytes), uploading instead of streaming 2021/03/04 05:09:12 INFO : ignore_checksum_small_file_from_pipe: Copied (new) 2021/03/04 05:09:12 DEBUG : ignore_checksum_big_file_from_pipe: File has 102401 bytes, which makes only one chunk. Using direct upload. 2021/03/04 05:09:13 DEBUG : ignore_checksum_big_file_from_pipe: Size of src and dst objects identical --- PASS: TestRcat (15.73s) --- PASS: TestRcat/withChecksum=false,ignoreChecksum=false (7.32s) --- PASS: TestRcat/withChecksum=true,ignoreChecksum=false (2.91s) --- PASS: TestRcat/withChecksum=false,ignoreChecksum=true (2.93s) --- PASS: TestRcat/withChecksum=true,ignoreChecksum=true (2.57s) === RUN TestRcatSize run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" 2021/03/04 05:09:14 DEBUG : B2 bucket rclone-test-pobenip8cafolot0dezonif6: File to upload is small (60 bytes), uploading instead of streaming 2021/03/04 05:09:15 DEBUG : potato2: SHA-1 = 9dc7f7d3279715991a22853f5981df582b7f9f6d OK 2021/03/04 05:09:15 INFO : potato2: Copied (new) --- PASS: TestRcatSize (1.63s) === RUN TestCopyFileMaxTransfer run.go:176: Remote "B2 bucket rclone-test-pobenip8cafolot0dezonif6", Local "Local file system at /tmp/rclone098986532", Modify Window "1ms" 2021/03/04 05:09:16 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:09:16 DEBUG : TestCopyFileMaxTransfer/file1: Need to transfer - File not found at Destination 2021/03/04 05:09:17 DEBUG : TestCopyFileMaxTransfer/file1: SHA-1 = a379624177abc4679cafafa8eae1d73e1478aaa6 OK 2021/03/04 05:09:17 INFO : TestCopyFileMaxTransfer/file1: Copied (new) 2021/03/04 05:09:17 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:09:17 DEBUG : TestCopyFileMaxTransfer/file2: Need to transfer - File not found at Destination 2021/03/04 05:09:17 ERROR : TestCopyFileMaxTransfer/file2: Failed to copy: Post "https://pod-000-1113-10.backblaze.com/b2api/v1/b2_upload_file/9f92bd43a00dfbbb7f780e1b/c001_v0001113_t0020": Max transfer limit reached as set by --max-transfer 2021/03/04 05:09:17 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:09:17 DEBUG : TestCopyFileMaxTransfer/file3: Need to transfer - File not found at Destination 2021/03/04 05:09:18 DEBUG : Couldn't decode error response: EOF 2021/03/04 05:09:18 DEBUG : TestCopyFileMaxTransfer/file4: Need to transfer - File not found at Destination 2021/03/04 05:09:19 DEBUG : TestCopyFileMaxTransfer/file4: SHA-1 = 2cb4e13eb14307dcad934d548c991c1f1032a561 OK 2021/03/04 05:09:19 INFO : TestCopyFileMaxTransfer/file4: Copied (new) --- PASS: TestCopyFileMaxTransfer (4.94s) === RUN TestRcAbout rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcAbout (0.00s) === RUN TestRcCleanup rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcCleanup (0.00s) === RUN TestRcCopyfile rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcCopyfile (0.00s) === RUN TestRcCopyurl rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcCopyurl (0.00s) === RUN TestRcDelete rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcDelete (0.00s) === RUN TestRcDeletefile rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcDeletefile (0.00s) === RUN TestRcList rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcList (0.00s) === RUN TestRcMkdir rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcMkdir (0.00s) === RUN TestRcMovefile rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcMovefile (0.00s) === RUN TestRcPurge rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcPurge (0.00s) === RUN TestRcRmdir rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcRmdir (0.00s) === RUN TestRcRmdirs rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcRmdirs (0.00s) === RUN TestRcSize rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcSize (0.00s) === RUN TestRcPublicLink rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcPublicLink (0.00s) === RUN TestRcFsInfo rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcFsInfo (0.00s) === RUN TestUploadFile rc_test.go:25: Skipping test on non local remote --- SKIP: TestUploadFile (0.00s) === RUN TestRcCommand rc_test.go:25: Skipping test on non local remote --- SKIP: TestRcCommand (0.00s) PASS 2021/03/04 05:09:21 DEBUG : B2 bucket rclone-test-pobenip8cafolot0dezonif6: Purge remote 2021/03/04 05:09:21 DEBUG : A1/B1/C1/four: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f108ecd5b65c06ee7_d20210304_m050813_c001_v0001038_t0004") 2021/03/04 05:09:21 DEBUG : A1/B1/C1/four: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35da7a_d20210304_m050811_c001_v0001113_t0020") 2021/03/04 05:09:21 DEBUG : A1/B1/C1/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1084eb393e4ca2b7_d20210304_m050705_c001_v0001131_t0041") 2021/03/04 05:09:21 DEBUG : A1/B1/C1/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d997_d20210304_m050702_c001_v0001113_t0020") 2021/03/04 05:09:21 DEBUG : A1/B1/C2/five: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f102a53fb5e8ce4e0_d20210304_m050813_c001_v0001154_t0016") 2021/03/04 05:09:21 DEBUG : A1/B1/C2/five: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35da7c_d20210304_m050811_c001_v0001113_t0020") 2021/03/04 05:09:21 DEBUG : A1/B1/three: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f116c3e3f32cba374_d20210304_m050813_c001_v0001145_t0031") 2021/03/04 05:09:21 DEBUG : A1/B1/three: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35da77_d20210304_m050810_c001_v0001113_t0020") 2021/03/04 05:09:21 DEBUG : A1/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f102a5f338a86fd04_d20210304_m050813_c001_v0001015_t0004") 2021/03/04 05:09:21 DEBUG : A1/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35da6a_d20210304_m050809_c001_v0001113_t0020") 2021/03/04 05:09:21 DEBUG : A1/two: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1098ee902ba3b760_d20210304_m050814_c001_v0001131_t0001") 2021/03/04 05:09:22 DEBUG : A1/two: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35da71_d20210304_m050810_c001_v0001113_t0020") 2021/03/04 05:09:22 DEBUG : A1/two: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f100dd205275e873c_d20210304_m050706_c001_v0001154_t0025") 2021/03/04 05:09:22 DEBUG : A1/two: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d99e_d20210304_m050703_c001_v0001113_t0020") 2021/03/04 05:09:22 DEBUG : A2/B1/C1/four: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f11733b90fd547378_d20210304_m050816_c001_v0001146_t0047") 2021/03/04 05:09:22 DEBUG : A2/B1/C1/four: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f11418003a0a5e80a_d20210304_m050812_c001_v0001146_t0058") 2021/03/04 05:09:22 DEBUG : A2/B1/C2/five: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f11802f57fb91330f_d20210304_m050816_c001_v0001018_t0034") 2021/03/04 05:09:22 DEBUG : A2/B1/C2/five: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f117f5f3949001ac6_d20210304_m050813_c001_v0001120_t0040") 2021/03/04 05:09:22 DEBUG : A2/B1/three: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f105dbcfc0ca546bd_d20210304_m050855_c001_v0001120_t0020") 2021/03/04 05:09:22 DEBUG : A2/B1/three: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f10029922b2e8d87f_d20210304_m050813_c001_v0001150_t0017") 2021/03/04 05:09:22 DEBUG : A2/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f102a53fb5e8ce4f1_d20210304_m050816_c001_v0001154_t0014") 2021/03/04 05:09:22 DEBUG : A2/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1137a9a690109441_d20210304_m050813_c001_v0001134_t0045") 2021/03/04 05:09:22 DEBUG : A2/two: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1001616ced20d075_d20210304_m050816_c001_v0001131_t0055") 2021/03/04 05:09:22 DEBUG : A2/two: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f11749a17e64b5602_d20210304_m050813_c001_v0001042_t0023") 2021/03/04 05:09:22 DEBUG : A3/B1/C1/four: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f106ea8da2a92400d_d20210304_m050856_c001_v0001153_t0005") 2021/03/04 05:09:22 DEBUG : A3/B1/C1/four: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f113ea391166a6fe0_d20210304_m050815_c001_v0001025_t0025") 2021/03/04 05:09:22 DEBUG : A3/B1/C2/five: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f118cf2475a37f3a1_d20210304_m050856_c001_v0001154_t0022") 2021/03/04 05:09:22 DEBUG : A3/B1/C2/five: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f10603f47a51eb789_d20210304_m050815_c001_v0001033_t0046") 2021/03/04 05:09:22 DEBUG : A3/B1/three: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f116c3e3f32cba534_d20210304_m050857_c001_v0001145_t0018") 2021/03/04 05:09:22 DEBUG : A3/B1/three: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f117c12783a53b531_d20210304_m050815_c001_v0001009_t0016") 2021/03/04 05:09:22 DEBUG : A3/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f11474d28aab55a79_d20210304_m050857_c001_v0001043_t0031") 2021/03/04 05:09:22 DEBUG : A3/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f101c34467bce495a_d20210304_m050815_c001_v0001093_t0011") 2021/03/04 05:09:23 DEBUG : A3/two: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f119d5321ece23528_d20210304_m050858_c001_v0001154_t0023") 2021/03/04 05:09:23 DEBUG : A3/two: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f10676ed4220312de_d20210304_m050816_c001_v0001036_t0013") 2021/03/04 05:09:23 DEBUG : BackupDir/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1017a203d27dba66_d20210304_m050802_c001_v0001153_t0015") 2021/03/04 05:09:23 DEBUG : BackupDir/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f112746ad897e075e_d20210304_m050753_c001_v0001033_t0048") 2021/03/04 05:09:23 DEBUG : CompareDest/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f102905c8e9d97401_d20210304_m050740_c001_v0001150_t0016") 2021/03/04 05:09:23 DEBUG : CompareDest/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35da0c_d20210304_m050736_c001_v0001113_t0020") 2021/03/04 05:09:23 DEBUG : CompareDest/two: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f103f5608e9627168_d20210304_m050740_c001_v0001033_t0015") 2021/03/04 05:09:23 DEBUG : CompareDest/two: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35da10_d20210304_m050737_c001_v0001113_t0020") 2021/03/04 05:09:23 DEBUG : CopyDest/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f11408fbd38bf413c_d20210304_m050802_c001_v0001029_t0009") 2021/03/04 05:09:23 DEBUG : CopyDest/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35da3a_d20210304_m050750_c001_v0001113_t0020") 2021/03/04 05:09:23 DEBUG : CopyDest/three: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1020a87e2f0c54c3_d20210304_m050806_c001_v0001131_t0051") 2021/03/04 05:09:23 DEBUG : CopyDest/three: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35da4e_d20210304_m050758_c001_v0001113_t0020") 2021/03/04 05:09:23 DEBUG : CopyDest/two: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f106ac98896e7dc8a_d20210304_m050807_c001_v0001137_t0021") 2021/03/04 05:09:23 DEBUG : CopyDest/two: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35da48_d20210304_m050754_c001_v0001113_t0020") 2021/03/04 05:09:23 DEBUG : TestCopyFileMaxTransfer/file1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f10043951e3c71a63_d20210304_m050919_c001_v0001145_t0057") 2021/03/04 05:09:23 DEBUG : TestCopyFileMaxTransfer/file1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35db23_d20210304_m050916_c001_v0001113_t0020") 2021/03/04 05:09:23 DEBUG : TestCopyFileMaxTransfer/file4: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1187077a92814112_d20210304_m050920_c001_v0001153_t0024") 2021/03/04 05:09:23 DEBUG : TestCopyFileMaxTransfer/file4: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35db27_d20210304_m050918_c001_v0001113_t0020") 2021/03/04 05:09:23 DEBUG : a.txt: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f118b4eb9e95a34c7_d20210304_m050632_c001_v0001150_t0022") 2021/03/04 05:09:23 DEBUG : a.txt: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d862_d20210304_m050627_c001_v0001113_t0020") 2021/03/04 05:09:23 DEBUG : also/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f11720b594b515273_d20210304_m050622_c001_v0001153_t0012") 2021/03/04 05:09:23 DEBUG : also/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d845_d20210304_m050620_c001_v0001113_t0020") 2021/03/04 05:09:24 DEBUG : another: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f11516c0fe36339f7_d20210304_m050623_c001_v0001131_t0031") 2021/03/04 05:09:24 DEBUG : another: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d849_d20210304_m050621_c001_v0001113_t0020") 2021/03/04 05:09:24 DEBUG : backup/dst/file1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f114d7082a3e63307_d20210304_m050729_c001_v0001018_t0026") 2021/03/04 05:09:24 DEBUG : backup/dst/file1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f102764dcefde65d0_d20210304_m050727_c001_v0001146_t0039") 2021/03/04 05:09:24 DEBUG : backup/dst/file1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f10781c3542ee593c_d20210304_m050721_c001_v0001093_t0042") 2021/03/04 05:09:24 DEBUG : backup/dst/file1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1046d2da2f48b396_d20210304_m050719_c001_v0001012_t0039") 2021/03/04 05:09:24 DEBUG : dst/file1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1187077a92813d65_d20210304_m050730_c001_v0001153_t0002") 2021/03/04 05:09:24 DEBUG : dst/file1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d9f3_d20210304_m050729_c001_v0001113_t0020") 2021/03/04 05:09:24 DEBUG : dst/file1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f11699ad03988f92e_d20210304_m050728_c001_v0001013_t0021") 2021/03/04 05:09:24 DEBUG : dst/file1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d9e9_d20210304_m050724_c001_v0001113_t0020") 2021/03/04 05:09:24 DEBUG : dst/file1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f116893aac7fe5df0_d20210304_m050722_c001_v0001130_t0025") 2021/03/04 05:09:24 DEBUG : dst/file1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d9e0_d20210304_m050721_c001_v0001113_t0020") 2021/03/04 05:09:24 DEBUG : dst/file1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f102da25d2d3bc66d_d20210304_m050720_c001_v0001090_t0000") 2021/03/04 05:09:24 DEBUG : dst/file1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d9d3_d20210304_m050715_c001_v0001113_t0020") 2021/03/04 05:09:24 DEBUG : dst/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f108f46465f394481_d20210304_m050807_c001_v0001039_t0000") 2021/03/04 05:09:24 DEBUG : dst/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f10626b937b06ccb4_d20210304_m050754_c001_v0001154_t0006") 2021/03/04 05:09:24 DEBUG : dst/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f10571adaa02643c5_d20210304_m050753_c001_v0001145_t0002") 2021/03/04 05:09:24 DEBUG : dst/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35da38_d20210304_m050750_c001_v0001113_t0020") 2021/03/04 05:09:24 DEBUG : dst/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1084e0e4e98f9585_d20210304_m050749_c001_v0001144_t0013") 2021/03/04 05:09:25 DEBUG : dst/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1084e0e4e98f9553_d20210304_m050744_c001_v0001144_t0013") 2021/03/04 05:09:25 DEBUG : dst/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1038739b43217a2e_d20210304_m050740_c001_v0001153_t0005") 2021/03/04 05:09:25 DEBUG : dst/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35da08_d20210304_m050736_c001_v0001113_t0020") 2021/03/04 05:09:25 DEBUG : dst/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f107341b7c0b6683c_d20210304_m050735_c001_v0001146_t0038") 2021/03/04 05:09:25 DEBUG : dst/one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f107341b7c0b66832_d20210304_m050734_c001_v0001146_t0038") 2021/03/04 05:09:25 DEBUG : dst/three: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1180110d4a6bcbb7_d20210304_m050808_c001_v0001091_t0057") 2021/03/04 05:09:25 DEBUG : dst/three: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1084e0e4e98f9639_d20210304_m050800_c001_v0001144_t0013") 2021/03/04 05:09:25 DEBUG : dst/two: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1083e272a04a0cdf_d20210304_m050808_c001_v0001022_t0053") 2021/03/04 05:09:25 DEBUG : dst/two: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1093963474cb6b36_d20210304_m050757_c001_v0001145_t0011") 2021/03/04 05:09:25 DEBUG : dst/two: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f100dd205275e883d_d20210304_m050741_c001_v0001154_t0007") 2021/03/04 05:09:25 DEBUG : dst/two: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f107341b7c0b66862_d20210304_m050739_c001_v0001146_t0038") 2021/03/04 05:09:25 DEBUG : empty space: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1190aff2492308d8_d20210304_m050650_c001_v0001153_t0008") 2021/03/04 05:09:25 DEBUG : empty space: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d92c_d20210304_m050649_c001_v0001113_t0020") 2021/03/04 05:09:25 DEBUG : empty space: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1046bd18a489f5b5_d20210304_m050648_c001_v0001093_t0029") 2021/03/04 05:09:25 DEBUG : empty space: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d90d_d20210304_m050645_c001_v0001113_t0020") 2021/03/04 05:09:25 DEBUG : empty space: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f11066c66b2464665_d20210304_m050644_c001_v0001154_t0008") 2021/03/04 05:09:25 DEBUG : empty space: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d8f7_d20210304_m050643_c001_v0001113_t0020") 2021/03/04 05:09:25 DEBUG : empty space: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1104a464067ccb63_d20210304_m050642_c001_v0001023_t0009") 2021/03/04 05:09:25 DEBUG : empty space: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d8e0_d20210304_m050640_c001_v0001113_t0020") 2021/03/04 05:09:25 DEBUG : empty space: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f102764dcefde6441_d20210304_m050639_c001_v0001146_t0049") 2021/03/04 05:09:25 DEBUG : empty space: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d8c6_d20210304_m050638_c001_v0001113_t0020") 2021/03/04 05:09:25 DEBUG : empty space: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f119c635d34f454f3_d20210304_m050616_c001_v0001090_t0006") 2021/03/04 05:09:26 DEBUG : empty space: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d812_d20210304_m050613_c001_v0001113_t0020") 2021/03/04 05:09:26 DEBUG : empty space: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f11398826589613db_d20210304_m050610_c001_v0001136_t0011") 2021/03/04 05:09:26 DEBUG : empty space: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d7e2_d20210304_m050604_c001_v0001113_t0020") 2021/03/04 05:09:26 DEBUG : empty space: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f118cf2475a37ee9e_d20210304_m050600_c001_v0001154_t0012") 2021/03/04 05:09:26 DEBUG : empty space: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d7a9_d20210304_m050558_c001_v0001113_t0020") 2021/03/04 05:09:26 DEBUG : file1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1073b843cb4df199_d20210304_m050711_c001_v0001013_t0027") 2021/03/04 05:09:26 DEBUG : file1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d9b1_d20210304_m050708_c001_v0001113_t0020") 2021/03/04 05:09:26 DEBUG : file1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1166264b251148c6_d20210304_m050657_c001_v0001137_t0036") 2021/03/04 05:09:26 DEBUG : file1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d958_d20210304_m050654_c001_v0001113_t0020") 2021/03/04 05:09:26 DEBUG : file1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f105b76267e21ca7b_d20210304_m050556_c001_v0001146_t0020") 2021/03/04 05:09:26 DEBUG : file1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d78b_d20210304_m050554_c001_v0001113_t0020") 2021/03/04 05:09:26 DEBUG : file1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d77b_d20210304_m050553_c001_v0001113_t0020") 2021/03/04 05:09:26 DEBUG : file1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d76e_d20210304_m050550_c001_v0001113_t0020") 2021/03/04 05:09:26 DEBUG : file2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f10391ee2833e1cf1_d20210304_m050712_c001_v0001150_t0049") 2021/03/04 05:09:26 DEBUG : file2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d9bc_d20210304_m050710_c001_v0001113_t0020") 2021/03/04 05:09:26 DEBUG : file2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1072d3eb3bbf87bb_d20210304_m050657_c001_v0001042_t0024") 2021/03/04 05:09:26 DEBUG : file2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d95a_d20210304_m050654_c001_v0001113_t0020") 2021/03/04 05:09:26 DEBUG : filename.txt: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f107341b7c0b6676d_d20210304_m050712_c001_v0001146_t0029") 2021/03/04 05:09:26 DEBUG : filename.txt: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d9ba_d20210304_m050710_c001_v0001113_t0020") 2021/03/04 05:09:26 DEBUG : ignore_checksum_big_file_from_pipe: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1186a57d440cc3a2_d20210304_m050914_c001_v0001128_t0041") 2021/03/04 05:09:26 DEBUG : ignore_checksum_big_file_from_pipe: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35db15_d20210304_m050912_c001_v0001113_t0020") 2021/03/04 05:09:26 DEBUG : ignore_checksum_big_file_from_pipe: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1103463aa0a08c8f_d20210304_m050910_c001_v0001146_t0026") 2021/03/04 05:09:26 DEBUG : ignore_checksum_big_file_from_pipe: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35db0c_d20210304_m050909_c001_v0001113_t0020") 2021/03/04 05:09:26 DEBUG : ignore_checksum_small_file_from_pipe: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1033ec8807ee7d0c_d20210304_m050914_c001_v0001030_t0033") 2021/03/04 05:09:27 DEBUG : ignore_checksum_small_file_from_pipe: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35db11_d20210304_m050912_c001_v0001113_t0020") 2021/03/04 05:09:27 DEBUG : ignore_checksum_small_file_from_pipe: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1158966e1b8765d9_d20210304_m050911_c001_v0001093_t0010") 2021/03/04 05:09:27 DEBUG : ignore_checksum_small_file_from_pipe: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35db07_d20210304_m050909_c001_v0001113_t0020") 2021/03/04 05:09:27 DEBUG : large: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f102dee882c7e5023_d20210304_m050653_c001_v0001145_t0043") 2021/03/04 05:09:27 DEBUG : large: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d946_d20210304_m050652_c001_v0001113_t0020") 2021/03/04 05:09:27 DEBUG : medium: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1041e17f8031373a_d20210304_m050653_c001_v0001134_t0046") 2021/03/04 05:09:27 DEBUG : medium: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d942_d20210304_m050652_c001_v0001113_t0020") 2021/03/04 05:09:27 DEBUG : no_checksum_big_file_from_pipe: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1075318f68d8bda6_d20210304_m050901_c001_v0001090_t0005") 2021/03/04 05:09:27 DEBUG : no_checksum_big_file_from_pipe: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35daed_d20210304_m050900_c001_v0001113_t0020") 2021/03/04 05:09:27 DEBUG : no_checksum_small_file_from_pipe: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1185ef195c10cd2d_d20210304_m050902_c001_v0001092_t0049") 2021/03/04 05:09:27 DEBUG : no_checksum_small_file_from_pipe: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35daeb_d20210304_m050859_c001_v0001113_t0020") 2021/03/04 05:09:27 DEBUG : not-one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110a4e7b87e566a6_d20210304_m050623_c001_v0001120_t0006") 2021/03/04 05:09:27 DEBUG : not-one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d84d_d20210304_m050621_c001_v0001113_t0020") 2021/03/04 05:09:27 DEBUG : one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f103f50b228ba2a55_d20210304_m050622_c001_v0001039_t0016") 2021/03/04 05:09:27 DEBUG : one: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d83c_d20210304_m050619_c001_v0001113_t0020") 2021/03/04 05:09:27 DEBUG : potato1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f117473cc4d072180_d20210304_m050915_c001_v0001044_t0018") 2021/03/04 05:09:27 DEBUG : potato1: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35db1e_d20210304_m050914_c001_v0001113_t0020") 2021/03/04 05:09:27 DEBUG : potato2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f11066c66b2464d01_d20210304_m050916_c001_v0001154_t0002") 2021/03/04 05:09:27 DEBUG : potato2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35db20_d20210304_m050915_c001_v0001113_t0020") 2021/03/04 05:09:27 DEBUG : potato2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f116267f54d9c00c0_d20210304_m050650_c001_v0001131_t0018") 2021/03/04 05:09:27 DEBUG : potato2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d928_d20210304_m050649_c001_v0001113_t0020") 2021/03/04 05:09:27 DEBUG : potato2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f104361eb67f551d0_d20210304_m050648_c001_v0001015_t0003") 2021/03/04 05:09:27 DEBUG : potato2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d905_d20210304_m050645_c001_v0001113_t0020") 2021/03/04 05:09:27 DEBUG : potato2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1076089686957d4f_d20210304_m050644_c001_v0001131_t0027") 2021/03/04 05:09:27 DEBUG : potato2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d8ef_d20210304_m050643_c001_v0001113_t0020") 2021/03/04 05:09:27 DEBUG : potato2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1019675624e7ed74_d20210304_m050642_c001_v0001033_t0034") 2021/03/04 05:09:28 DEBUG : potato2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d8da_d20210304_m050640_c001_v0001113_t0020") 2021/03/04 05:09:28 DEBUG : potato2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1124400154414b0a_d20210304_m050639_c001_v0001042_t0002") 2021/03/04 05:09:28 DEBUG : potato2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d8c2_d20210304_m050637_c001_v0001113_t0020") 2021/03/04 05:09:28 DEBUG : potato2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f102831002fa82f9e_d20210304_m050616_c001_v0001144_t0017") 2021/03/04 05:09:28 DEBUG : potato2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d81a_d20210304_m050614_c001_v0001113_t0020") 2021/03/04 05:09:28 DEBUG : potato2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f106f61eac113f927_d20210304_m050610_c001_v0001145_t0016") 2021/03/04 05:09:28 DEBUG : potato2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d7e8_d20210304_m050607_c001_v0001113_t0020") 2021/03/04 05:09:28 DEBUG : potato2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f111078a4d7a368f0_d20210304_m050600_c001_v0001145_t0001") 2021/03/04 05:09:28 DEBUG : potato2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d7ad_d20210304_m050558_c001_v0001113_t0020") 2021/03/04 05:09:28 DEBUG : remotepotato: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f1f59004f2df8_d20210304_m050617_c001_v0001003_t0005") 2021/03/04 05:09:28 DEBUG : remotepotato: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d824_d20210304_m050615_c001_v0001113_t0020") 2021/03/04 05:09:28 DEBUG : remotepotato: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f105f144208a0080d_d20210304_m050611_c001_v0001136_t0030") 2021/03/04 05:09:28 DEBUG : remotepotato: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d7f4_d20210304_m050608_c001_v0001113_t0020") 2021/03/04 05:09:28 DEBUG : remotepotato: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1151f17df8d1a82a_d20210304_m050601_c001_v0001145_t0003") 2021/03/04 05:09:28 DEBUG : remotepotato: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d7b5_d20210304_m050559_c001_v0001113_t0020") 2021/03/04 05:09:28 DEBUG : rutabaga: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f10778f681d54ce2c_d20210304_m050617_c001_v0001136_t0000") 2021/03/04 05:09:28 DEBUG : rutabaga: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d80a_d20210304_m050612_c001_v0001113_t0020") 2021/03/04 05:09:28 DEBUG : rutabaga: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f10581c5be4accdd3_d20210304_m050611_c001_v0001130_t0007") 2021/03/04 05:09:28 DEBUG : rutabaga: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d7ce_d20210304_m050603_c001_v0001113_t0020") 2021/03/04 05:09:28 DEBUG : rutabaga: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1124400154414aaf_d20210304_m050602_c001_v0001042_t0024") 2021/03/04 05:09:28 DEBUG : rutabaga: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d7a3_d20210304_m050557_c001_v0001113_t0020") 2021/03/04 05:09:28 DEBUG : small: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f114cbaa1b7dc6257_d20210304_m050653_c001_v0001093_t0027") 2021/03/04 05:09:28 DEBUG : small: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d93c_d20210304_m050651_c001_v0001113_t0020") 2021/03/04 05:09:28 DEBUG : sub dir/hello world: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f119c22957c61a344_d20210304_m050637_c001_v0001030_t0040") 2021/03/04 05:09:28 DEBUG : sub dir/hello world: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d8b9_d20210304_m050636_c001_v0001113_t0020") 2021/03/04 05:09:28 DEBUG : sub dir/hello world: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f118d8dff26fb89f4_d20210304_m050632_c001_v0001146_t0005") 2021/03/04 05:09:29 DEBUG : sub dir/hello world: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d870_d20210304_m050627_c001_v0001113_t0020") 2021/03/04 05:09:29 DEBUG : sub dir/hello world2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1137a9a6901091e6_d20210304_m050633_c001_v0001134_t0038") 2021/03/04 05:09:29 DEBUG : sub dir/hello world2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d876_d20210304_m050628_c001_v0001113_t0020") 2021/03/04 05:09:29 DEBUG : sub dir/ignore dir/.ignore: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1069b985af02a469_d20210304_m050633_c001_v0001146_t0009") 2021/03/04 05:09:29 DEBUG : sub dir/ignore dir/.ignore: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d87e_d20210304_m050628_c001_v0001113_t0020") 2021/03/04 05:09:29 DEBUG : sub dir/ignore dir/should be ignored: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f104361eb67f551c9_d20210304_m050633_c001_v0001015_t0025") 2021/03/04 05:09:29 DEBUG : sub dir/ignore dir/should be ignored: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d884_d20210304_m050629_c001_v0001113_t0020") 2021/03/04 05:09:29 DEBUG : sub dir/potato3: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f105be383497349cb_d20210304_m050651_c001_v0001001_t0042") 2021/03/04 05:09:29 DEBUG : sub dir/potato3: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d930_d20210304_m050649_c001_v0001113_t0020") 2021/03/04 05:09:29 DEBUG : sub dir/sub sub dir/hello world3: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f113aa13ae3f8e00e_d20210304_m050634_c001_v0001145_t0018") 2021/03/04 05:09:29 DEBUG : sub dir/sub sub dir/hello world3: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d889_d20210304_m050629_c001_v0001113_t0020") 2021/03/04 05:09:29 DEBUG : sub/file2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1099631ba9707504_d20210304_m050724_c001_v0001136_t0053") 2021/03/04 05:09:29 DEBUG : sub/file2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d9e6_d20210304_m050723_c001_v0001113_t0020") 2021/03/04 05:09:29 DEBUG : sub/file2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1014f69049614c5e_d20210304_m050714_c001_v0001145_t0025") 2021/03/04 05:09:29 DEBUG : sub/file2: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d9c7_d20210304_m050713_c001_v0001113_t0020") 2021/03/04 05:09:29 DEBUG : with_checksum_big_file_from_pipe: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f116304dfe77aa554_d20210304_m050908_c001_v0001153_t0014") 2021/03/04 05:09:29 DEBUG : with_checksum_big_file_from_pipe: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35dafc_d20210304_m050907_c001_v0001113_t0020") 2021/03/04 05:09:29 DEBUG : with_checksum_small_file_from_pipe: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f1027eb7b03463c39_d20210304_m050908_c001_v0001134_t0013") 2021/03/04 05:09:29 DEBUG : with_checksum_small_file_from_pipe: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35dafa_d20210304_m050906_c001_v0001113_t0020") 2021/03/04 05:09:29 DEBUG : zend.txt: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f100e0a06f4377e79_d20210304_m050634_c001_v0001144_t0050") 2021/03/04 05:09:29 DEBUG : zend.txt: Deleting (id "4_z9f92bd43a00dfbbb7f780e1b_f110f543cee35d86d_d20210304_m050627_c001_v0001113_t0020") "./operations.test -test.v -test.timeout 1h0m0s -remote TestB2: -list-retries 5 -verbose" - Finished OK in 3m43.1507835s (try 1/5)