"./operations.test -test.v -test.timeout 1h0m0s -remote TestTardigrade: -verbose -fast-list" - Starting (try 1/5) 2020/05/15 05:06:56 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: connecting... 2020/05/15 05:06:56 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: connected: === 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 TestMultithreadCopy/{size:131071_streams:2} 2020/05/15 05:06:57 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./ 2020/05/15 05:06:57 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./file1 # [] 131071 2020/05/15 05:06:57 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:06:57 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:06:57 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./file1 2020/05/15 05:06:57 DEBUG : file1: Starting multi-thread copy with 2 parts of size 64k 2020/05/15 05:06:57 DEBUG : file1: multi-thread copy: stream 2/2 (65536-131071) size 63.999k starting 2020/05/15 05:06:57 DEBUG : file1: cat sj://rclone-test-wicujag9puqakac3wocobep3/file1 # [RangeOption(65536,131070)] 2020/05/15 05:06:57 DEBUG : file1: range 65536 + 65535 2020/05/15 05:06:57 DEBUG : file1: multi-thread copy: stream 1/2 (0-65536) size 64k starting 2020/05/15 05:06:57 DEBUG : file1: cat sj://rclone-test-wicujag9puqakac3wocobep3/file1 # [RangeOption(0,65535)] 2020/05/15 05:06:57 DEBUG : file1: range 0 + 65536 2020/05/15 05:06:58 DEBUG : file1: multi-thread copy: stream 1/2 (0-65536) size 64k finished 2020/05/15 05:06:58 DEBUG : file1: multi-thread copy: stream 2/2 (65536-131071) size 63.999k finished 2020/05/15 05:06:58 DEBUG : file1: Finished multi-thread copy with 2 parts of size 64k === RUN TestMultithreadCopy/{size:131072_streams:2} 2020/05/15 05:06:58 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./file1 # [] 131072 2020/05/15 05:06:58 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:06:58 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:06:58 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./file1 2020/05/15 05:06:58 DEBUG : file1: Starting multi-thread copy with 2 parts of size 64k 2020/05/15 05:06:58 DEBUG : file1: multi-thread copy: stream 1/2 (0-65536) size 64k starting 2020/05/15 05:06:58 DEBUG : file1: cat sj://rclone-test-wicujag9puqakac3wocobep3/file1 # [RangeOption(0,65535)] 2020/05/15 05:06:58 DEBUG : file1: range 0 + 65536 2020/05/15 05:06:58 DEBUG : file1: multi-thread copy: stream 2/2 (65536-131072) size 64k starting 2020/05/15 05:06:58 DEBUG : file1: cat sj://rclone-test-wicujag9puqakac3wocobep3/file1 # [RangeOption(65536,131071)] 2020/05/15 05:06:58 DEBUG : file1: range 65536 + 65536 2020/05/15 05:06:59 DEBUG : file1: multi-thread copy: stream 1/2 (0-65536) size 64k finished 2020/05/15 05:06:59 DEBUG : file1: multi-thread copy: stream 2/2 (65536-131072) size 64k finished 2020/05/15 05:06:59 DEBUG : file1: Finished multi-thread copy with 2 parts of size 64k === RUN TestMultithreadCopy/{size:131073_streams:2} 2020/05/15 05:06:59 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./file1 # [] 131073 2020/05/15 05:06:59 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:06:59 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:06:59 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./file1 2020/05/15 05:06:59 DEBUG : file1: Starting multi-thread copy with 2 parts of size 128k 2020/05/15 05:06:59 DEBUG : file1: multi-thread copy: stream 2/2 (131072-131073) size 1 starting 2020/05/15 05:06:59 DEBUG : file1: cat sj://rclone-test-wicujag9puqakac3wocobep3/file1 # [RangeOption(131072,131072)] 2020/05/15 05:06:59 DEBUG : file1: range 131072 + 1 2020/05/15 05:06:59 DEBUG : file1: multi-thread copy: stream 1/2 (0-131072) size 128k starting 2020/05/15 05:06:59 DEBUG : file1: cat sj://rclone-test-wicujag9puqakac3wocobep3/file1 # [RangeOption(0,131071)] 2020/05/15 05:06:59 DEBUG : file1: range 0 + 131072 2020/05/15 05:07:00 DEBUG : file1: multi-thread copy: stream 1/2 (0-131072) size 128k finished 2020/05/15 05:07:00 DEBUG : file1: multi-thread copy: stream 2/2 (131072-131073) size 1 finished 2020/05/15 05:07:00 DEBUG : file1: Finished multi-thread copy with 2 parts of size 128k 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:00 DEBUG : file1: rm sj://rclone-test-wicujag9puqakac3wocobep3/file1 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestMultithreadCopy (3.64s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" --- PASS: TestMultithreadCopy/{size:131071_streams:2} (1.17s) --- PASS: TestMultithreadCopy/{size:131072_streams:2} (0.92s) --- PASS: TestMultithreadCopy/{size:131073_streams:2} (1.18s) === RUN TestSizeDiffers --- PASS: TestSizeDiffers (0.00s) === RUN TestReOpen === RUN TestReOpen/Seek === RUN TestReOpen/Seek/Basics === RUN TestReOpen/Seek/ErrorAtStart === RUN TestReOpen/Seek/WithErrors 2020/05/15 05:07:00 DEBUG : potato: Reopening on read failure after 2 bytes: retry 1/10: test error 2020/05/15 05:07:00 DEBUG : potato: Reopening on read failure after 3 bytes: retry 2/10: test error 2020/05/15 05:07:00 DEBUG : potato: Reopening on read failure after 6 bytes: retry 3/10: test error === RUN TestReOpen/Seek/TooManyErrors 2020/05/15 05:07:00 DEBUG : potato: Reopening on read failure after 2 bytes: retry 1/3: test error 2020/05/15 05:07:00 DEBUG : potato: Reopening on read failure after 3 bytes: retry 2/3: test error 2020/05/15 05:07:00 DEBUG : potato: Reopening on read failure after 6 bytes: retry 3/3: test error 2020/05/15 05:07:00 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 2020/05/15 05:07:00 DEBUG : potato: Reopening on read failure after 2 bytes: retry 1/10: test error 2020/05/15 05:07:00 DEBUG : potato: Reopening on read failure after 3 bytes: retry 2/10: test error 2020/05/15 05:07:00 DEBUG : potato: Reopening on read failure after 6 bytes: retry 3/10: test error === RUN TestReOpen/Range/TooManyErrors 2020/05/15 05:07:00 DEBUG : potato: Reopening on read failure after 2 bytes: retry 1/3: test error 2020/05/15 05:07:00 DEBUG : potato: Reopening on read failure after 3 bytes: retry 2/3: test error 2020/05/15 05:07:00 DEBUG : potato: Reopening on read failure after 6 bytes: retry 3/3: test error 2020/05/15 05:07:00 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 TestDeduplicateInteractive 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- SKIP: TestDeduplicateInteractive (0.03s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" dedupe_test.go:23: Can't test deduplicate - no duplicate files possible === RUN TestDeduplicateSkip 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- SKIP: TestDeduplicateSkip (0.03s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" dedupe_test.go:23: Can't test deduplicate - no duplicate files possible === RUN TestDeduplicateFirst 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- SKIP: TestDeduplicateFirst (0.03s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" dedupe_test.go:23: Can't test deduplicate - no duplicate files possible === RUN TestDeduplicateNewest 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- SKIP: TestDeduplicateNewest (0.03s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" dedupe_test.go:23: Can't test deduplicate - no duplicate files possible === RUN TestDeduplicateOldest 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- SKIP: TestDeduplicateOldest (0.02s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" dedupe_test.go:23: Can't test deduplicate - no duplicate files possible === RUN TestDeduplicateLargest 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- SKIP: TestDeduplicateLargest (0.02s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" dedupe_test.go:23: Can't test deduplicate - no duplicate files possible === RUN TestDeduplicateSmallest 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- SKIP: TestDeduplicateSmallest (0.02s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" dedupe_test.go:23: Can't test deduplicate - no duplicate files possible === RUN TestDeduplicateRename 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- SKIP: TestDeduplicateRename (0.03s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" dedupe_test.go:23: Can't test deduplicate - no duplicate files possible === RUN TestMergeDirs 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- SKIP: TestMergeDirs (0.02s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" dedupe_test.go:217: Can't merge directories === RUN TestListDirSorted 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./a.txt # [] 11 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./zend.txt # [] 5 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./sub dir/hello world # [] 11 2020/05/15 05:07:00 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./sub dir/hello world2 # [] 11 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./sub dir/ignore dir/.ignore # [] 1 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./sub dir/ignore dir/should be ignored # [] 9 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./sub dir/sub sub dir/hello world3 # [] 11 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls ./ 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: opts &{Prefix: Cursor: Recursive:false System:true Custom:true} 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls ./ 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: opts &{Prefix: Cursor: Recursive:false System:true Custom:true} 2020/05/15 05:07:01 DEBUG : a.txt: Excluded 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls ./sub dir 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls ./sub dir ("rclone-test-wicujag9puqakac3wocobep3", "sub dir") 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: opts &{Prefix:sub dir/ Cursor: Recursive:false System:true Custom:true} 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls ./sub dir 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls ./sub dir ("rclone-test-wicujag9puqakac3wocobep3", "sub dir") 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: opts &{Prefix:sub dir/ Cursor: Recursive:false System:true Custom:true} 2020/05/15 05:07:01 DEBUG : sub dir/hello world: Excluded 2020/05/15 05:07:01 DEBUG : sub dir/hello world2: Excluded 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls ./sub dir 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls ./sub dir ("rclone-test-wicujag9puqakac3wocobep3", "sub dir") 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: opts &{Prefix:sub dir/ Cursor: Recursive:false System:true Custom:true} 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./sub dir/ignore dir/.ignore 2020/05/15 05:07:01 DEBUG : sub dir/ignore dir: Excluded 2020/05/15 05:07:01 DEBUG : sub dir/hello world: Excluded 2020/05/15 05:07:01 DEBUG : sub dir/hello world2: Excluded 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./sub dir/sub sub dir/.ignore 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: err: uplink: object not found ("sub dir/sub sub dir/.ignore") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs.FileExists:1372 github.com/rclone/rclone/fs/filter.(*Filter).DirContainsExcludeFile:433 github.com/rclone/rclone/fs/filter.(*Filter).IncludeDirectory.func1:404 github.com/rclone/rclone/fs/list.filterAndSortDir:59 github.com/rclone/rclone/fs/list.DirSorted:35 github.com/rclone/rclone/fs/operations_test.TestListDirSorted:84 testing.tRunner:909 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls ./sub dir/ignore dir 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls ./sub dir/ignore dir ("rclone-test-wicujag9puqakac3wocobep3", "sub dir/ignore dir") 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: opts &{Prefix:sub dir/ignore dir/ Cursor: Recursive:false System:true Custom:true} 2020/05/15 05:07:01 DEBUG : sub dir/ignore dir: Excluded 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls ./sub dir/ignore dir 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls ./sub dir/ignore dir ("rclone-test-wicujag9puqakac3wocobep3", "sub dir/ignore dir") 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: opts &{Prefix:sub dir/ignore dir/ Cursor: Recursive:false System:true Custom:true} 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls ./sub dir/ignore dir 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls ./sub dir/ignore dir ("rclone-test-wicujag9puqakac3wocobep3", "sub dir/ignore dir") 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: opts &{Prefix:sub dir/ignore dir/ Cursor: Recursive:false System:true Custom:true} 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:01 DEBUG : sub dir/ignore dir/should be ignored: rm sj://rclone-test-wicujag9puqakac3wocobep3/sub dir/ignore dir/should be ignored 2020/05/15 05:07:01 DEBUG : sub dir/ignore dir/.ignore: rm sj://rclone-test-wicujag9puqakac3wocobep3/sub dir/ignore dir/.ignore 2020/05/15 05:07:01 DEBUG : sub dir/hello world: rm sj://rclone-test-wicujag9puqakac3wocobep3/sub dir/hello world 2020/05/15 05:07:01 DEBUG : sub dir/hello world2: rm sj://rclone-test-wicujag9puqakac3wocobep3/sub dir/hello world2 2020/05/15 05:07:01 DEBUG : sub dir/sub sub dir/hello world3: rm sj://rclone-test-wicujag9puqakac3wocobep3/sub dir/sub sub dir/hello world3 2020/05/15 05:07:01 DEBUG : a.txt: rm sj://rclone-test-wicujag9puqakac3wocobep3/a.txt 2020/05/15 05:07:01 DEBUG : zend.txt: rm sj://rclone-test-wicujag9puqakac3wocobep3/zend.txt 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./sub dir/sub sub dir 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./sub dir/ignore dir 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./sub dir 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestListDirSorted (0.58s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" === RUN TestMkdir 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: Making directory 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./ 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: Making directory 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./ 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestMkdir (0.08s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" === RUN TestLsd 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./sub dir/hello world # [] 11 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls ./ 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: opts &{Prefix: Cursor: Recursive:false System:true Custom:true} 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:01 DEBUG : sub dir/hello world: rm sj://rclone-test-wicujag9puqakac3wocobep3/sub dir/hello world 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./sub dir 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestLsd (0.12s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" === RUN TestLs 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./potato2 # [] 60 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./empty space # [] 1 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:01 DEBUG : empty space: rm sj://rclone-test-wicujag9puqakac3wocobep3/empty space 2020/05/15 05:07:01 DEBUG : potato2: rm sj://rclone-test-wicujag9puqakac3wocobep3/potato2 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestLs (0.15s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" === RUN TestLsWithFilesFrom 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./potato2 # [] 60 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./empty space # [] 1 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:01 DEBUG : empty space: Excluded from sync (and deletion) 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./potato2 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./notfound 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: err: uplink: object not found ("notfound") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs/filter.(*Filter).MakeListR.func1.1:554 github.com/rclone/rclone/vendor/golang.org/x/sync/errgroup.(*Group).Go.func1:57 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:01 DEBUG : empty space: rm sj://rclone-test-wicujag9puqakac3wocobep3/empty space 2020/05/15 05:07:01 DEBUG : potato2: rm sj://rclone-test-wicujag9puqakac3wocobep3/potato2 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestLsWithFilesFrom (0.16s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" === RUN TestLsLong 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./potato2 # [] 60 2020/05/15 05:07:01 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./empty space # [] 1 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:02 DEBUG : empty space: rm sj://rclone-test-wicujag9puqakac3wocobep3/empty space 2020/05/15 05:07:02 DEBUG : potato2: rm sj://rclone-test-wicujag9puqakac3wocobep3/potato2 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestLsLong (0.15s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" === RUN TestHashSums 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./potato2 # [] 60 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./empty space # [] 1 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:02 DEBUG : empty space: MD5 2020/05/15 05:07:02 DEBUG : potato2: MD5 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:02 DEBUG : empty space: SHA-1 2020/05/15 05:07:02 DEBUG : potato2: SHA-1 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:02 DEBUG : empty space: QuickXorHash 2020/05/15 05:07:02 DEBUG : potato2: QuickXorHash 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:02 DEBUG : empty space: QuickXorHash 2020/05/15 05:07:02 DEBUG : potato2: QuickXorHash 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:02 DEBUG : empty space: rm sj://rclone-test-wicujag9puqakac3wocobep3/empty space 2020/05/15 05:07:02 DEBUG : potato2: rm sj://rclone-test-wicujag9puqakac3wocobep3/potato2 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestHashSums (0.19s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" === RUN TestSuffixName --- PASS: TestSuffixName (0.00s) === RUN TestCount 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./potato2 # [] 60 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./empty space # [] 1 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./sub dir/potato3 # [] 5 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: opts &{Prefix: Cursor: Recursive:false System:true Custom:true} 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:02 DEBUG : empty space: rm sj://rclone-test-wicujag9puqakac3wocobep3/empty space 2020/05/15 05:07:02 DEBUG : sub dir/potato3: rm sj://rclone-test-wicujag9puqakac3wocobep3/sub dir/potato3 2020/05/15 05:07:02 DEBUG : potato2: rm sj://rclone-test-wicujag9puqakac3wocobep3/potato2 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./sub dir 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestCount (0.22s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" === RUN TestDelete 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./small # [] 10 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./medium # [] 60 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./large # [] 100 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:02 DEBUG : Waiting for deletions to finish 2020/05/15 05:07:02 DEBUG : large: Excluded from sync (and deletion) 2020/05/15 05:07:02 DEBUG : medium: rm sj://rclone-test-wicujag9puqakac3wocobep3/medium 2020/05/15 05:07:02 DEBUG : small: rm sj://rclone-test-wicujag9puqakac3wocobep3/small 2020/05/15 05:07:02 INFO : medium: Deleted 2020/05/15 05:07:02 INFO : small: Deleted 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:02 DEBUG : large: rm sj://rclone-test-wicujag9puqakac3wocobep3/large 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestDelete (0.21s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" === RUN TestCheck 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./rutabaga # [] 8 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: 1: Starting check test 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: 2: Starting check test 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./empty space # [] 1 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: 3: Starting check test 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./potato2 # [] 60 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: 4: Starting check test 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: 5: Starting check test 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./remotepotato # [] 60 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: 6: Starting check test 2020/05/15 05:07:02 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: 7: Starting check test 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:03 DEBUG : remotepotato: rm sj://rclone-test-wicujag9puqakac3wocobep3/remotepotato 2020/05/15 05:07:03 DEBUG : empty space: rm sj://rclone-test-wicujag9puqakac3wocobep3/empty space 2020/05/15 05:07:03 DEBUG : rutabaga: rm sj://rclone-test-wicujag9puqakac3wocobep3/rutabaga 2020/05/15 05:07:03 DEBUG : potato2: rm sj://rclone-test-wicujag9puqakac3wocobep3/potato2 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestCheck (0.38s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" === RUN TestCheckFsError 2020/05/15 05:07:03 DEBUG : Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/non-existent: Waiting for checks to finish 2020/05/15 05:07:03 ERROR : : error reading source directory: directory not found 2020/05/15 05:07:03 NOTICE: Local file system at /home/rclone/go/src/github.com/rclone/rclone/fs/operations/non-existent: 1 differences found --- PASS: TestCheckFsError (0.00s) === RUN TestCheckDownload 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./rutabaga # [] 8 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: 1: Starting check test 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: 2: Starting check test 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./empty space # [] 1 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: 3: Starting check test 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./potato2 # [] 60 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: 4: Starting check test 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: 5: Starting check test 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./remotepotato # [] 60 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: 6: Starting check test 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: 7: Starting check test 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:03 DEBUG : remotepotato: rm sj://rclone-test-wicujag9puqakac3wocobep3/remotepotato 2020/05/15 05:07:03 DEBUG : empty space: rm sj://rclone-test-wicujag9puqakac3wocobep3/empty space 2020/05/15 05:07:03 DEBUG : rutabaga: rm sj://rclone-test-wicujag9puqakac3wocobep3/rutabaga 2020/05/15 05:07:03 DEBUG : potato2: rm sj://rclone-test-wicujag9puqakac3wocobep3/potato2 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestCheckDownload (0.74s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" === RUN TestCheckSizeOnly 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./rutabaga # [] 8 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: 1: Starting check test 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: 2: Starting check test 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./empty space # [] 1 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: 3: Starting check test 2020/05/15 05:07:03 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./potato2 # [] 60 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: 4: Starting check test 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: 5: Starting check test 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./remotepotato # [] 60 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: 6: Starting check test 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: 7: Starting check test 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:04 DEBUG : remotepotato: rm sj://rclone-test-wicujag9puqakac3wocobep3/remotepotato 2020/05/15 05:07:04 DEBUG : empty space: rm sj://rclone-test-wicujag9puqakac3wocobep3/empty space 2020/05/15 05:07:04 DEBUG : rutabaga: rm sj://rclone-test-wicujag9puqakac3wocobep3/rutabaga 2020/05/15 05:07:04 DEBUG : potato2: rm sj://rclone-test-wicujag9puqakac3wocobep3/potato2 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestCheckSizeOnly (0.38s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" === RUN TestCat 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./file1 # [] 10 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./file2 # [] 9 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:04 DEBUG : file2: cat sj://rclone-test-wicujag9puqakac3wocobep3/file2 # [] 2020/05/15 05:07:04 DEBUG : file2: range 0 + -1 2020/05/15 05:07:04 DEBUG : file1: cat sj://rclone-test-wicujag9puqakac3wocobep3/file1 # [] 2020/05/15 05:07:04 DEBUG : file1: range 0 + -1 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:04 DEBUG : file2: cat sj://rclone-test-wicujag9puqakac3wocobep3/file2 # [RangeOption(0,4)] 2020/05/15 05:07:04 DEBUG : file2: range 0 + 5 2020/05/15 05:07:04 DEBUG : file1: cat sj://rclone-test-wicujag9puqakac3wocobep3/file1 # [RangeOption(0,4)] 2020/05/15 05:07:04 DEBUG : file1: range 0 + 5 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:04 DEBUG : file2: cat sj://rclone-test-wicujag9puqakac3wocobep3/file2 # [RangeOption(6,-1)] 2020/05/15 05:07:04 DEBUG : file2: range 6 + -1 2020/05/15 05:07:04 DEBUG : file1: cat sj://rclone-test-wicujag9puqakac3wocobep3/file1 # [RangeOption(7,-1)] 2020/05/15 05:07:04 DEBUG : file1: range 7 + -1 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:04 DEBUG : file2: cat sj://rclone-test-wicujag9puqakac3wocobep3/file2 # [RangeOption(1,3)] 2020/05/15 05:07:04 DEBUG : file2: range 1 + 3 2020/05/15 05:07:04 DEBUG : file1: cat sj://rclone-test-wicujag9puqakac3wocobep3/file1 # [RangeOption(1,3)] 2020/05/15 05:07:04 DEBUG : file1: range 1 + 3 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:04 DEBUG : file2: rm sj://rclone-test-wicujag9puqakac3wocobep3/file2 2020/05/15 05:07:04 DEBUG : file1: rm sj://rclone-test-wicujag9puqakac3wocobep3/file1 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestCat (0.39s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" === RUN TestPurge 2020/05/15 05:07:04 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: connecting... 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: connected: 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: mkdir -p ./ 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: mkdir -p ./ 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: cp input ./A1/B1/C1/one # [] 3 2020/05/15 05:07:04 DEBUG : A2: Making directory 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: mkdir -p ./A2 2020/05/15 05:07:04 DEBUG : A1/B2: Making directory 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: mkdir -p ./A1/B2 2020/05/15 05:07:04 DEBUG : A1/B2/C2: Making directory 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: mkdir -p ./A1/B2/C2 2020/05/15 05:07:04 DEBUG : A1/B1/C3: Making directory 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: mkdir -p ./A1/B1/C3 2020/05/15 05:07:04 DEBUG : A3: Making directory 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: mkdir -p ./A3 2020/05/15 05:07:04 DEBUG : A3/B3: Making directory 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: mkdir -p ./A3/B3 2020/05/15 05:07:04 DEBUG : A3/B3/C4: Making directory 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: mkdir -p ./A3/B3/C4 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: cp input ./A1/two # [] 3 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: ls -R ./ 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: OBJ ls -R ./ ("rclone-test-tejulip2sarawow0ralayar2", "") 2020/05/15 05:07:04 DEBUG : Waiting for deletions to finish 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: ls -R ./A1/B1 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: OBJ ls -R ./A1/B1 ("rclone-test-tejulip2sarawow0ralayar2", "A1/B1") 2020/05/15 05:07:04 DEBUG : A1/B1/C1/one: rm sj://rclone-test-tejulip2sarawow0ralayar2/A1/B1/C1/one 2020/05/15 05:07:04 INFO : A1/B1/C1/one: Deleted 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: ls -R ./A1/B1 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: OBJ ls -R ./A1/B1 ("rclone-test-tejulip2sarawow0ralayar2", "A1/B1") 2020/05/15 05:07:04 DEBUG : A1/B1: Removing directory 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: rmdir ./A1/B1 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: ls -R ./ 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: OBJ ls -R ./ ("rclone-test-tejulip2sarawow0ralayar2", "") 2020/05/15 05:07:04 DEBUG : Waiting for deletions to finish 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: ls -R ./ 2020/05/15 05:07:04 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: OBJ ls -R ./ ("rclone-test-tejulip2sarawow0ralayar2", "") 2020/05/15 05:07:05 DEBUG : A1/two: rm sj://rclone-test-tejulip2sarawow0ralayar2/A1/two 2020/05/15 05:07:05 INFO : A1/two: Deleted 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: ls -R ./ 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: OBJ ls -R ./ ("rclone-test-tejulip2sarawow0ralayar2", "") 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: Removing directory 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: rmdir ./ 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: ls -R ./ 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: OBJ ls -R ./ ("rclone-test-tejulip2sarawow0ralayar2", "") 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: ls -R ./ 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: OBJ ls -R ./ ("rclone-test-tejulip2sarawow0ralayar2", "") 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: Purge dir "" 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-tejulip2sarawow0ralayar2: rmdir ./ 2020/05/15 05:07:05 purge failed to rmdir "": directory not found 2020/05/15 05:07:05 purge failed: directory not found --- PASS: TestPurge (0.47s) run.go:176: Remote "FS sj://rclone-test-tejulip2sarawow0ralayar2", Local "Local file system at /tmp/rclone587060811", Modify Window "1ns" fstest.go:247: Filtering empty directory "A2" fstest.go:247: Filtering empty directory "A1/B2" fstest.go:247: Filtering empty directory "A1/B2/C2" fstest.go:247: Filtering empty directory "A1/B1/C3" fstest.go:247: Filtering empty directory "A3" fstest.go:247: Filtering empty directory "A3/B3" fstest.go:247: Filtering empty directory "A3/B3/C4" fstest.go:247: Filtering empty directory "A2" fstest.go:247: Filtering empty directory "A1/B2" fstest.go:247: Filtering empty directory "A1/B2/C2" fstest.go:247: Filtering empty directory "A3" fstest.go:247: Filtering empty directory "A3/B3" fstest.go:247: Filtering empty directory "A3/B3/C4" === RUN TestRmdirsNoLeaveRoot 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./ 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./A1/B1/C1/one # [] 3 2020/05/15 05:07:05 DEBUG : A2: Making directory 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./A2 2020/05/15 05:07:05 DEBUG : A1/B2: Making directory 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./A1/B2 2020/05/15 05:07:05 DEBUG : A1/B2/C2: Making directory 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./A1/B2/C2 2020/05/15 05:07:05 DEBUG : A1/B1/C3: Making directory 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./A1/B1/C3 2020/05/15 05:07:05 DEBUG : A3: Making directory 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./A3 2020/05/15 05:07:05 DEBUG : A3/B3: Making directory 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./A3/B3 2020/05/15 05:07:05 DEBUG : A3/B3/C4: Making directory 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./A3/B3/C4 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./A1/two # [] 3 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./A3/B3/C4 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./A3/B3/C4 ("rclone-test-wicujag9puqakac3wocobep3", "A3/B3/C4") 2020/05/15 05:07:05 DEBUG : A3/B3/C4: Removing directory 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./A3/B3/C4 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:05 DEBUG : A1/B1/C1/one: rm sj://rclone-test-wicujag9puqakac3wocobep3/A1/B1/C1/one 2020/05/15 05:07:05 DEBUG : A1/two: rm sj://rclone-test-wicujag9puqakac3wocobep3/A1/two 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./A1/B1/C1 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./A1/B1 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./A1 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestRmdirsNoLeaveRoot (0.48s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" fstest.go:247: Filtering empty directory "A2" fstest.go:247: Filtering empty directory "A1/B2" fstest.go:247: Filtering empty directory "A1/B2/C2" fstest.go:247: Filtering empty directory "A1/B1/C3" fstest.go:247: Filtering empty directory "A3" fstest.go:247: Filtering empty directory "A3/B3" fstest.go:247: Filtering empty directory "A3/B3/C4" fstest.go:247: Filtering empty directory "A2" fstest.go:247: Filtering empty directory "A1/B2" fstest.go:247: Filtering empty directory "A1/B2/C2" fstest.go:247: Filtering empty directory "A1/B1/C3" fstest.go:247: Filtering empty directory "A3" fstest.go:247: Filtering empty directory "A3/B3" === RUN TestRmdirsLeaveRoot 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./ 2020/05/15 05:07:05 DEBUG : A1: Making directory 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./A1 2020/05/15 05:07:05 DEBUG : A1/B1: Making directory 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./A1/B1 2020/05/15 05:07:05 DEBUG : A1/B1/C1: Making directory 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./A1/B1/C1 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./A1 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./A1 ("rclone-test-wicujag9puqakac3wocobep3", "A1") 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestRmdirsLeaveRoot (0.16s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" fstest.go:247: Filtering empty directory "A1" fstest.go:247: Filtering empty directory "A1/B1" fstest.go:247: Filtering empty directory "A1/B1/C1" fstest.go:247: Filtering empty directory "A1" === RUN TestCopyURL 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./file1 # [] 14 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./file1 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./filename.txt # [] 14 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./file2 # [] 14 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:05 DEBUG : file2: rm sj://rclone-test-wicujag9puqakac3wocobep3/file2 2020/05/15 05:07:05 DEBUG : filename.txt: rm sj://rclone-test-wicujag9puqakac3wocobep3/filename.txt 2020/05/15 05:07:05 DEBUG : file1: rm sj://rclone-test-wicujag9puqakac3wocobep3/file1 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestCopyURL (0.23s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" === RUN TestCopyURLToWriter --- PASS: TestCopyURLToWriter (0.00s) === RUN TestMoveFile 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./sub/file2 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: err: uplink: object not found ("sub/file2") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs/operations.moveOrCopyFile:1830 github.com/rclone/rclone/fs/operations.MoveFile:1910 github.com/rclone/rclone/fs/operations_test.TestMoveFile:751 testing.tRunner:909 2020/05/15 05:07:05 DEBUG : file1: Need to transfer - File not found at Destination 2020/05/15 05:07:05 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./sub/file2 # [HashesOption([])] 14 2020/05/15 05:07:06 INFO : file1: Copied (new) 2020/05/15 05:07:06 INFO : file1: Deleted 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./sub/file2 2020/05/15 05:07:06 DEBUG : file1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2020/05/15 05:07:06 DEBUG : file1: Unchanged skipping 2020/05/15 05:07:06 INFO : file1: Deleted 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: don't need to copy/move sub/file2, it is already at target location 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:06 DEBUG : sub/file2: rm sj://rclone-test-wicujag9puqakac3wocobep3/sub/file2 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./sub 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestMoveFile (0.17s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" === RUN TestCaseInsensitiveMoveFile 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestCaseInsensitiveMoveFile (0.03s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" === RUN TestMoveFileBackupDir 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- SKIP: TestMoveFileBackupDir (0.03s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" operations_test.go:809: Skipping test as remote does not support server side move or copy === RUN TestCopyFile 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./sub/file2 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: err: uplink: object not found ("sub/file2") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs/operations.moveOrCopyFile:1830 github.com/rclone/rclone/fs/operations.CopyFile:1915 github.com/rclone/rclone/fs/operations_test.TestCopyFile:841 testing.tRunner:909 2020/05/15 05:07:06 DEBUG : file1: Need to transfer - File not found at Destination 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./sub/file2 # [HashesOption([])] 14 2020/05/15 05:07:06 INFO : file1: Copied (new) 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./sub/file2 2020/05/15 05:07:06 DEBUG : file1: Size and modification time the same (differ by 0s, within tolerance 1ns) 2020/05/15 05:07:06 DEBUG : file1: Unchanged skipping 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: don't need to copy/move sub/file2, it is already at target location 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:06 DEBUG : sub/file2: rm sj://rclone-test-wicujag9puqakac3wocobep3/sub/file2 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./sub 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestCopyFile (0.18s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" === RUN TestCopyFileBackupDir 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- SKIP: TestCopyFileBackupDir (0.03s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" operations_test.go:861: Skipping test as remote does not support server side move or copy === RUN TestCopyFileCompareDest 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/dst: connecting... 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/dst: connected: 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/dst: stat ./one 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/dst: err: uplink: object not found ("dst/one") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs/operations.moveOrCopyFile:1830 github.com/rclone/rclone/fs/operations.CopyFile:1915 github.com/rclone/rclone/fs/operations_test.TestCopyFileCompareDest:899 testing.tRunner:909 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/CompareDest: connecting... 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/CompareDest: connected: 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/CompareDest: stat ./one 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/CompareDest: err: uplink: object not found ("CompareDest/one") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs/operations.compareDest:1509 github.com/rclone/rclone/fs/operations.CompareOrCopyDest:1593 github.com/rclone/rclone/fs/operations.moveOrCopyFile:1882 github.com/rclone/rclone/fs/operations.CopyFile:1915 github.com/rclone/rclone/fs/operations_test.TestCopyFileCompareDest:899 testing.tRunner:909 2020/05/15 05:07:06 DEBUG : one: Need to transfer - File not found at Destination 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/dst: cp input ./one # [HashesOption([])] 3 2020/05/15 05:07:06 INFO : one: Copied (new) 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/dst: stat ./one 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/CompareDest: stat ./one 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/CompareDest: err: uplink: object not found ("CompareDest/one") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs/operations.compareDest:1509 github.com/rclone/rclone/fs/operations.CompareOrCopyDest:1593 github.com/rclone/rclone/fs/operations.moveOrCopyFile:1882 github.com/rclone/rclone/fs/operations.CopyFile:1915 github.com/rclone/rclone/fs/operations_test.TestCopyFileCompareDest:912 testing.tRunner:909 2020/05/15 05:07:06 DEBUG : one: Sizes differ (src 5 vs dst 3) 2020/05/15 05:07:06 DEBUG : one: cp input ./one [HashesOption([])] 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/dst: cp input ./one # [HashesOption([])] 5 2020/05/15 05:07:06 INFO : one: Copied (replaced existing) 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./dst/one # [] 3 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./CompareDest/one # [] 5 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/dst: stat ./one 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/CompareDest: stat ./one 2020/05/15 05:07:06 DEBUG : one: Size and modification time the same (differ by 0s, within tolerance 1ns) 2020/05/15 05:07:06 DEBUG : one: Destination found in --compare-dest, skipping 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./CompareDest/two # [] 3 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/dst: stat ./two 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/dst: err: uplink: object not found ("dst/two") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs/operations.moveOrCopyFile:1830 github.com/rclone/rclone/fs/operations.CopyFile:1915 github.com/rclone/rclone/fs/operations_test.TestCopyFileCompareDest:938 testing.tRunner:909 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/CompareDest: stat ./two 2020/05/15 05:07:06 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2020/05/15 05:07:06 DEBUG : two: Destination found in --compare-dest, skipping 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/dst: stat ./two 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/dst: err: uplink: object not found ("dst/two") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs/operations.moveOrCopyFile:1830 github.com/rclone/rclone/fs/operations.CopyFile:1915 github.com/rclone/rclone/fs/operations_test.TestCopyFileCompareDest:944 testing.tRunner:909 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/CompareDest: stat ./two 2020/05/15 05:07:06 DEBUG : two: Size and modification time the same (differ by 0s, within tolerance 1ns) 2020/05/15 05:07:06 DEBUG : two: Destination found in --compare-dest, skipping 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/dst: stat ./two 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/dst: err: uplink: object not found ("dst/two") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs/operations.moveOrCopyFile:1830 github.com/rclone/rclone/fs/operations.CopyFile:1915 github.com/rclone/rclone/fs/operations_test.TestCopyFileCompareDest:954 testing.tRunner:909 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/CompareDest: stat ./two 2020/05/15 05:07:06 DEBUG : two: Sizes differ (src 5 vs dst 3) 2020/05/15 05:07:06 DEBUG : two: Need to transfer - File not found at Destination 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3/dst: cp input ./two # [HashesOption([])] 5 2020/05/15 05:07:06 INFO : two: Copied (new) 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:06 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:07 DEBUG : dst/two: rm sj://rclone-test-wicujag9puqakac3wocobep3/dst/two 2020/05/15 05:07:07 DEBUG : dst/one: rm sj://rclone-test-wicujag9puqakac3wocobep3/dst/one 2020/05/15 05:07:07 DEBUG : CompareDest/two: rm sj://rclone-test-wicujag9puqakac3wocobep3/CompareDest/two 2020/05/15 05:07:07 DEBUG : CompareDest/one: rm sj://rclone-test-wicujag9puqakac3wocobep3/CompareDest/one 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./dst 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./CompareDest 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestCopyFileCompareDest (0.76s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" === RUN TestCopyFileCopyDest 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- SKIP: TestCopyFileCopyDest (0.03s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" operations_test.go:969: Skipping test as remote does not support server side copy === RUN TestSameConfig --- PASS: TestSameConfig (0.00s) === RUN TestSame --- PASS: TestSame (0.00s) === RUN TestOverlapping --- PASS: TestOverlapping (0.00s) === RUN TestCheckEqualReaders --- PASS: TestCheckEqualReaders (0.00s) === RUN TestListFormat --- PASS: TestListFormat (0.00s) === RUN TestDirMove 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./ 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./A1/one # [] 3 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./A1/two # [] 3 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./A1/B1/three # [] 5 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./A1/B1/C1/four # [] 4 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./A1/B1/C2/five # [] 4 2020/05/15 05:07:07 DEBUG : A1/B2: Making directory 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./A1/B2 2020/05/15 05:07:07 DEBUG : A1/B1/C3: Making directory 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./A1/B1/C3 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./A1 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./A1 ("rclone-test-wicujag9puqakac3wocobep3", "A1") 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./A2 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./A2/B1 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./A2/B1/C1 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./A2/B1/C2 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./A2/B1/three 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./A2/B1/C1/four 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./A2/B1/C2/five 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./A2/one 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: err: uplink: object not found ("A2/B1/C1/four") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs/operations.DirMove.func1:2120 github.com/rclone/rclone/vendor/golang.org/x/sync/errgroup.(*Group).Go.func1:57 2020/05/15 05:07:07 DEBUG : A1/B1/C1/four: cat sj://rclone-test-wicujag9puqakac3wocobep3/A1/B1/C1/four # [HashesOption([])] 2020/05/15 05:07:07 DEBUG : A1/B1/C1/four: range 0 + -1 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: err: uplink: object not found ("A2/B1/three") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs/operations.DirMove.func1:2120 github.com/rclone/rclone/vendor/golang.org/x/sync/errgroup.(*Group).Go.func1:57 2020/05/15 05:07:07 DEBUG : A1/B1/three: cat sj://rclone-test-wicujag9puqakac3wocobep3/A1/B1/three # [HashesOption([])] 2020/05/15 05:07:07 DEBUG : A1/B1/three: range 0 + -1 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./A2/B1/C1/four # [HashesOption([])] 4 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./A2/B1/three # [HashesOption([])] 5 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: err: uplink: object not found ("A2/B1/C2/five") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs/operations.DirMove.func1:2120 github.com/rclone/rclone/vendor/golang.org/x/sync/errgroup.(*Group).Go.func1:57 2020/05/15 05:07:07 DEBUG : A1/B1/C2/five: cat sj://rclone-test-wicujag9puqakac3wocobep3/A1/B1/C2/five # [HashesOption([])] 2020/05/15 05:07:07 DEBUG : A1/B1/C2/five: range 0 + -1 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: err: uplink: object not found ("A2/one") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs/operations.DirMove.func1:2120 github.com/rclone/rclone/vendor/golang.org/x/sync/errgroup.(*Group).Go.func1:57 2020/05/15 05:07:07 DEBUG : A1/one: cat sj://rclone-test-wicujag9puqakac3wocobep3/A1/one # [HashesOption([])] 2020/05/15 05:07:07 DEBUG : A1/one: range 0 + -1 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./A2/B1/C2/five # [HashesOption([])] 4 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./A2/one # [HashesOption([])] 3 2020/05/15 05:07:07 INFO : A1/B1/C1/four: Copied (new) 2020/05/15 05:07:07 DEBUG : A1/B1/C1/four: rm sj://rclone-test-wicujag9puqakac3wocobep3/A1/B1/C1/four 2020/05/15 05:07:07 INFO : A1/B1/three: Copied (new) 2020/05/15 05:07:07 DEBUG : A1/B1/three: rm sj://rclone-test-wicujag9puqakac3wocobep3/A1/B1/three 2020/05/15 05:07:07 INFO : A1/B1/C1/four: Deleted 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./A2/two 2020/05/15 05:07:07 INFO : A1/B1/C2/five: Copied (new) 2020/05/15 05:07:07 DEBUG : A1/B1/C2/five: rm sj://rclone-test-wicujag9puqakac3wocobep3/A1/B1/C2/five 2020/05/15 05:07:07 INFO : A1/B1/three: Deleted 2020/05/15 05:07:07 INFO : A1/one: Copied (new) 2020/05/15 05:07:07 DEBUG : A1/one: rm sj://rclone-test-wicujag9puqakac3wocobep3/A1/one 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: err: uplink: object not found ("A2/two") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs/operations.DirMove.func1:2120 github.com/rclone/rclone/vendor/golang.org/x/sync/errgroup.(*Group).Go.func1:57 2020/05/15 05:07:07 DEBUG : A1/two: cat sj://rclone-test-wicujag9puqakac3wocobep3/A1/two # [HashesOption([])] 2020/05/15 05:07:07 DEBUG : A1/two: range 0 + -1 2020/05/15 05:07:07 INFO : A1/B1/C2/five: Deleted 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./A2/two # [HashesOption([])] 3 2020/05/15 05:07:07 INFO : A1/one: Deleted 2020/05/15 05:07:07 INFO : A1/two: Copied (new) 2020/05/15 05:07:07 DEBUG : A1/two: rm sj://rclone-test-wicujag9puqakac3wocobep3/A1/two 2020/05/15 05:07:07 INFO : A1/two: Deleted 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./A1/B1/C2 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./A1/B1/C1 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./A1/B1 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./A1 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./A2 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./A2 ("rclone-test-wicujag9puqakac3wocobep3", "A2") 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./A3 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./A3/B1 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./A3/B1/C1 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: mkdir -p ./A3/B1/C2 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./A3/B1/C1/four 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./A3/B1/C2/five 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./A3/one 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./A3/B1/three 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: err: uplink: object not found ("A3/B1/three") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs/operations.DirMove.func1:2120 github.com/rclone/rclone/vendor/golang.org/x/sync/errgroup.(*Group).Go.func1:57 2020/05/15 05:07:07 DEBUG : A2/B1/three: cat sj://rclone-test-wicujag9puqakac3wocobep3/A2/B1/three # [HashesOption([])] 2020/05/15 05:07:07 DEBUG : A2/B1/three: range 0 + -1 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: err: uplink: object not found ("A3/B1/C2/five") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs/operations.DirMove.func1:2120 github.com/rclone/rclone/vendor/golang.org/x/sync/errgroup.(*Group).Go.func1:57 2020/05/15 05:07:07 DEBUG : A2/B1/C2/five: cat sj://rclone-test-wicujag9puqakac3wocobep3/A2/B1/C2/five # [HashesOption([])] 2020/05/15 05:07:07 DEBUG : A2/B1/C2/five: range 0 + -1 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: err: uplink: object not found ("A3/one") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs/operations.DirMove.func1:2120 github.com/rclone/rclone/vendor/golang.org/x/sync/errgroup.(*Group).Go.func1:57 2020/05/15 05:07:07 DEBUG : A2/one: cat sj://rclone-test-wicujag9puqakac3wocobep3/A2/one # [HashesOption([])] 2020/05/15 05:07:07 DEBUG : A2/one: range 0 + -1 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: err: uplink: object not found ("A3/B1/C1/four") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs/operations.DirMove.func1:2120 github.com/rclone/rclone/vendor/golang.org/x/sync/errgroup.(*Group).Go.func1:57 2020/05/15 05:07:07 DEBUG : A2/B1/C1/four: cat sj://rclone-test-wicujag9puqakac3wocobep3/A2/B1/C1/four # [HashesOption([])] 2020/05/15 05:07:07 DEBUG : A2/B1/C1/four: range 0 + -1 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./A3/B1/three # [HashesOption([])] 5 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./A3/B1/C2/five # [HashesOption([])] 4 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./A3/one # [HashesOption([])] 3 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./A3/B1/C1/four # [HashesOption([])] 4 2020/05/15 05:07:07 INFO : A2/B1/three: Copied (new) 2020/05/15 05:07:07 DEBUG : A2/B1/three: rm sj://rclone-test-wicujag9puqakac3wocobep3/A2/B1/three 2020/05/15 05:07:07 INFO : A2/one: Copied (new) 2020/05/15 05:07:07 DEBUG : A2/one: rm sj://rclone-test-wicujag9puqakac3wocobep3/A2/one 2020/05/15 05:07:07 INFO : A2/B1/C2/five: Copied (new) 2020/05/15 05:07:07 DEBUG : A2/B1/C2/five: rm sj://rclone-test-wicujag9puqakac3wocobep3/A2/B1/C2/five 2020/05/15 05:07:07 INFO : A2/B1/C1/four: Copied (new) 2020/05/15 05:07:07 DEBUG : A2/B1/C1/four: rm sj://rclone-test-wicujag9puqakac3wocobep3/A2/B1/C1/four 2020/05/15 05:07:07 INFO : A2/B1/three: Deleted 2020/05/15 05:07:07 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./A3/two 2020/05/15 05:07:07 INFO : A2/one: Deleted 2020/05/15 05:07:07 INFO : A2/B1/C2/five: Deleted 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: err: uplink: object not found ("A3/two") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs/operations.DirMove.func1:2120 github.com/rclone/rclone/vendor/golang.org/x/sync/errgroup.(*Group).Go.func1:57 2020/05/15 05:07:08 DEBUG : A2/two: cat sj://rclone-test-wicujag9puqakac3wocobep3/A2/two # [HashesOption([])] 2020/05/15 05:07:08 DEBUG : A2/two: range 0 + -1 2020/05/15 05:07:08 INFO : A2/B1/C1/four: Deleted 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./A3/two # [HashesOption([])] 3 2020/05/15 05:07:08 INFO : A2/two: Copied (new) 2020/05/15 05:07:08 DEBUG : A2/two: rm sj://rclone-test-wicujag9puqakac3wocobep3/A2/two 2020/05/15 05:07:08 INFO : A2/two: Deleted 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./A2/B1/C2 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./A2/B1/C1 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./A2/B1 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./A2 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:08 DEBUG : A3/two: rm sj://rclone-test-wicujag9puqakac3wocobep3/A3/two 2020/05/15 05:07:08 DEBUG : A3/one: rm sj://rclone-test-wicujag9puqakac3wocobep3/A3/one 2020/05/15 05:07:08 DEBUG : A3/B1/C2/five: rm sj://rclone-test-wicujag9puqakac3wocobep3/A3/B1/C2/five 2020/05/15 05:07:08 DEBUG : A3/B1/C1/four: rm sj://rclone-test-wicujag9puqakac3wocobep3/A3/B1/C1/four 2020/05/15 05:07:08 DEBUG : A3/B1/three: rm sj://rclone-test-wicujag9puqakac3wocobep3/A3/B1/three 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./A3/B1/C2 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./A3/B1/C1 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./A3/B1 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./A3 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestDirMove (1.20s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" fstest.go:247: Filtering empty directory "A1/B2" fstest.go:247: Filtering empty directory "A1/B1/C3" fstest.go:247: Filtering empty directory "A2/B2" fstest.go:247: Filtering empty directory "A2/B1/C3" fstest.go:247: Filtering empty directory "A3/B2" fstest.go:247: Filtering empty directory "A3/B1/C3" === RUN TestGetFsInfo 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestGetFsInfo (0.02s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" === RUN TestRcat === RUN TestRcat/withChecksum=false,ignoreChecksum=false 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: File to upload is small (34 bytes), uploading instead of streaming 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./no_checksum_small_file_from_pipe # [HashesOption([])] 34 2020/05/15 05:07:08 INFO : no_checksum_small_file_from_pipe: Copied (new) 2020/05/15 05:07:08 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./no_checksum_big_file_from_pipe # [HashesOption([])] -1 2020/05/15 05:07:09 DEBUG : no_checksum_big_file_from_pipe: Size and modification time the same (differ by 0s, within tolerance 1ns) 2020/05/15 05:07:09 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:09 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:09 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:09 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:09 DEBUG : no_checksum_big_file_from_pipe: rm sj://rclone-test-wicujag9puqakac3wocobep3/no_checksum_big_file_from_pipe 2020/05/15 05:07:09 DEBUG : no_checksum_small_file_from_pipe: rm sj://rclone-test-wicujag9puqakac3wocobep3/no_checksum_small_file_from_pipe 2020/05/15 05:07:09 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:09 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") === RUN TestRcat/withChecksum=true,ignoreChecksum=false 2020/05/15 05:07:09 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:09 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:09 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: File to upload is small (34 bytes), uploading instead of streaming 2020/05/15 05:07:09 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./with_checksum_small_file_from_pipe # [HashesOption([])] 34 2020/05/15 05:07:09 INFO : with_checksum_small_file_from_pipe: Copied (new) 2020/05/15 05:07:09 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./with_checksum_big_file_from_pipe # [HashesOption([])] -1 2020/05/15 05:07:10 NOTICE: FS sj://rclone-test-wicujag9puqakac3wocobep3: --checksum is in use but the source and destination have no hashes in common; falling back to --size-only 2020/05/15 05:07:10 DEBUG : with_checksum_big_file_from_pipe: Size of src and dst objects identical 2020/05/15 05:07:10 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:10 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:10 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:10 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:10 DEBUG : with_checksum_big_file_from_pipe: rm sj://rclone-test-wicujag9puqakac3wocobep3/with_checksum_big_file_from_pipe 2020/05/15 05:07:10 DEBUG : with_checksum_small_file_from_pipe: rm sj://rclone-test-wicujag9puqakac3wocobep3/with_checksum_small_file_from_pipe 2020/05/15 05:07:10 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:10 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") === RUN TestRcat/withChecksum=false,ignoreChecksum=true 2020/05/15 05:07:10 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:10 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:10 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: File to upload is small (34 bytes), uploading instead of streaming 2020/05/15 05:07:10 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./ignore_checksum_small_file_from_pipe # [HashesOption([])] 34 2020/05/15 05:07:10 INFO : ignore_checksum_small_file_from_pipe: Copied (new) 2020/05/15 05:07:10 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./ignore_checksum_big_file_from_pipe # [] -1 2020/05/15 05:07:11 DEBUG : ignore_checksum_big_file_from_pipe: Size and modification time the same (differ by 0s, within tolerance 1ns) 2020/05/15 05:07:11 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:11 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:11 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:11 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:11 DEBUG : ignore_checksum_small_file_from_pipe: rm sj://rclone-test-wicujag9puqakac3wocobep3/ignore_checksum_small_file_from_pipe 2020/05/15 05:07:11 DEBUG : ignore_checksum_big_file_from_pipe: rm sj://rclone-test-wicujag9puqakac3wocobep3/ignore_checksum_big_file_from_pipe 2020/05/15 05:07:11 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:11 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") === RUN TestRcat/withChecksum=true,ignoreChecksum=true 2020/05/15 05:07:11 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:11 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:11 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: File to upload is small (34 bytes), uploading instead of streaming 2020/05/15 05:07:11 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./ignore_checksum_small_file_from_pipe # [HashesOption([])] 34 2020/05/15 05:07:11 INFO : ignore_checksum_small_file_from_pipe: Copied (new) 2020/05/15 05:07:11 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./ignore_checksum_big_file_from_pipe # [] -1 2020/05/15 05:07:12 DEBUG : ignore_checksum_big_file_from_pipe: Size of src and dst objects identical 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:12 DEBUG : ignore_checksum_small_file_from_pipe: rm sj://rclone-test-wicujag9puqakac3wocobep3/ignore_checksum_small_file_from_pipe 2020/05/15 05:07:12 DEBUG : ignore_checksum_big_file_from_pipe: rm sj://rclone-test-wicujag9puqakac3wocobep3/ignore_checksum_big_file_from_pipe 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestRcat (4.28s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" --- PASS: TestRcat/withChecksum=false,ignoreChecksum=false (1.11s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" --- PASS: TestRcat/withChecksum=true,ignoreChecksum=false (0.92s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" --- PASS: TestRcat/withChecksum=false,ignoreChecksum=true (1.16s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" --- PASS: TestRcat/withChecksum=true,ignoreChecksum=true (1.09s) === RUN TestRcatSize 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./potato1 # [] 60 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: File to upload is small (60 bytes), uploading instead of streaming 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./potato2 # [HashesOption([])] 60 2020/05/15 05:07:12 INFO : potato2: Copied (new) 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:12 DEBUG : potato1: rm sj://rclone-test-wicujag9puqakac3wocobep3/potato1 2020/05/15 05:07:12 DEBUG : potato2: rm sj://rclone-test-wicujag9puqakac3wocobep3/potato2 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestRcatSize (0.13s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" === RUN TestCopyFileMaxTransfer 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./TestCopyFileMaxTransfer/file1 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: err: uplink: object not found ("TestCopyFileMaxTransfer/file1") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs/operations.moveOrCopyFile:1830 github.com/rclone/rclone/fs/operations.CopyFile:1915 github.com/rclone/rclone/fs/operations_test.TestCopyFileMaxTransfer:1553 testing.tRunner:909 2020/05/15 05:07:12 DEBUG : TestCopyFileMaxTransfer/file1: Need to transfer - File not found at Destination 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./TestCopyFileMaxTransfer/file1 # [HashesOption([])] 14 2020/05/15 05:07:12 INFO : TestCopyFileMaxTransfer/file1: Copied (new) 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./TestCopyFileMaxTransfer/file2 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: err: uplink: object not found ("TestCopyFileMaxTransfer/file2") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs/operations.moveOrCopyFile:1830 github.com/rclone/rclone/fs/operations.CopyFile:1915 github.com/rclone/rclone/fs/operations_test.TestCopyFileMaxTransfer:1560 testing.tRunner:909 2020/05/15 05:07:12 DEBUG : TestCopyFileMaxTransfer/file2: Need to transfer - File not found at Destination 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./TestCopyFileMaxTransfer/file2 # [HashesOption([])] 2062 2020/05/15 05:07:12 ERROR : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./TestCopyFileMaxTransfer/file2 [HashesOption([])]: Max transfer limit reached as set by --max-transfer 2020/05/15 05:07:12 DEBUG : TestCopyFileMaxTransfer/file2: Received error: Max transfer limit reached as set by --max-transfer - low level retry 1/10 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./TestCopyFileMaxTransfer/file3 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: err: uplink: object not found ("TestCopyFileMaxTransfer/file3") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs/operations.moveOrCopyFile:1830 github.com/rclone/rclone/fs/operations.CopyFile:1915 github.com/rclone/rclone/fs/operations_test.TestCopyFileMaxTransfer:1572 testing.tRunner:909 2020/05/15 05:07:12 DEBUG : TestCopyFileMaxTransfer/file3: Need to transfer - File not found at Destination 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: stat ./TestCopyFileMaxTransfer/file4 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: err: uplink: object not found ("TestCopyFileMaxTransfer/file4") github.com/rclone/rclone/vendor/storj.io/uplink.errwrapf:55 github.com/rclone/rclone/vendor/storj.io/uplink.(*Project).StatObject:91 github.com/rclone/rclone/backend/tardigrade.(*Fs).NewObject:506 github.com/rclone/rclone/fs/operations.moveOrCopyFile:1830 github.com/rclone/rclone/fs/operations.CopyFile:1915 github.com/rclone/rclone/fs/operations_test.TestCopyFileMaxTransfer:1589 testing.tRunner:909 2020/05/15 05:07:12 DEBUG : TestCopyFileMaxTransfer/file4: Need to transfer - File not found at Destination 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: cp input ./TestCopyFileMaxTransfer/file4 # [HashesOption([])] 2062 2020/05/15 05:07:12 INFO : TestCopyFileMaxTransfer/file4: Copied (new) 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:12 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:13 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:13 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:13 DEBUG : TestCopyFileMaxTransfer/file1: rm sj://rclone-test-wicujag9puqakac3wocobep3/TestCopyFileMaxTransfer/file1 2020/05/15 05:07:13 DEBUG : TestCopyFileMaxTransfer/file4: rm sj://rclone-test-wicujag9puqakac3wocobep3/TestCopyFileMaxTransfer/file4 2020/05/15 05:07:13 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./TestCopyFileMaxTransfer 2020/05/15 05:07:13 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:13 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") --- PASS: TestCopyFileMaxTransfer (0.27s) run.go:176: Remote "FS sj://rclone-test-wicujag9puqakac3wocobep3", Local "Local file system at /tmp/rclone589400552", Modify Window "1ns" === RUN TestRcAbout --- SKIP: TestRcAbout (0.00s) rc_test.go:21: Skipping test on non local remote === RUN TestRcCleanup --- SKIP: TestRcCleanup (0.00s) rc_test.go:21: Skipping test on non local remote === RUN TestRcCopyfile --- SKIP: TestRcCopyfile (0.00s) rc_test.go:21: Skipping test on non local remote === RUN TestRcCopyurl --- SKIP: TestRcCopyurl (0.00s) rc_test.go:21: Skipping test on non local remote === RUN TestRcDelete --- SKIP: TestRcDelete (0.00s) rc_test.go:21: Skipping test on non local remote === RUN TestRcDeletefile --- SKIP: TestRcDeletefile (0.00s) rc_test.go:21: Skipping test on non local remote === RUN TestRcList --- SKIP: TestRcList (0.00s) rc_test.go:21: Skipping test on non local remote === RUN TestRcMkdir --- SKIP: TestRcMkdir (0.00s) rc_test.go:21: Skipping test on non local remote === RUN TestRcMovefile --- SKIP: TestRcMovefile (0.00s) rc_test.go:21: Skipping test on non local remote === RUN TestRcPurge --- SKIP: TestRcPurge (0.00s) rc_test.go:21: Skipping test on non local remote === RUN TestRcRmdir --- SKIP: TestRcRmdir (0.00s) rc_test.go:21: Skipping test on non local remote === RUN TestRcRmdirs --- SKIP: TestRcRmdirs (0.00s) rc_test.go:21: Skipping test on non local remote === RUN TestRcSize --- SKIP: TestRcSize (0.00s) rc_test.go:21: Skipping test on non local remote === RUN TestRcPublicLink --- SKIP: TestRcPublicLink (0.00s) rc_test.go:21: Skipping test on non local remote === RUN TestRcFsInfo --- SKIP: TestRcFsInfo (0.00s) rc_test.go:21: Skipping test on non local remote === RUN TestRcCommand --- SKIP: TestRcCommand (0.00s) rc_test.go:21: Skipping test on non local remote PASS 2020/05/15 05:07:13 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: ls -R ./ 2020/05/15 05:07:13 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: OBJ ls -R ./ ("rclone-test-wicujag9puqakac3wocobep3", "") 2020/05/15 05:07:13 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: Purge dir "" 2020/05/15 05:07:13 DEBUG : FS sj://rclone-test-wicujag9puqakac3wocobep3: rmdir ./ "./operations.test -test.v -test.timeout 1h0m0s -remote TestTardigrade: -verbose -fast-list" - Finished OK in 16.211173263s (try 1/5)