"./sync.test -test.v -test.timeout 1h0m0s -remote TestTardigrade: -verbose -test.run '^(TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveWithFilter)$'" - Starting (try 2/5)
2021/11/13 05:31:19 DEBUG : Creating backend with remote "TestTardigrade:rclone-test-taputog0qesilav7sevaten8"
2021/11/13 05:31:19 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2021/11/13 05:31:19 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: connecting...
2021/11/13 05:31:19 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: connected: <nil>
2021/11/13 05:31:19 DEBUG : Creating backend with remote "/tmp/rclone2845072398"
=== RUN   TestServerSideMoveWithFilter
    run.go:181: Remote "FS sj://rclone-test-taputog0qesilav7sevaten8", Local "Local file system at /tmp/rclone2845072398", Modify Window "1ns"
2021/11/13 05:31:19 DEBUG : Creating backend with remote "TestTardigrade:rclone-test-cogaboq0lilobuf5zidanut5"
2021/11/13 05:31:19 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: connecting...
2021/11/13 05:31:19 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: connected: <nil>
2021/11/13 05:31:19 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: mkdir -p ./
2021/11/13 05:31:19 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: cp input ./potato2 # [] 60
2021/11/13 05:31:19 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: cp input ./empty space # [] 1
2021/11/13 05:31:20 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: cp input ./potato3 # [] 68
2021/11/13 05:31:20 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: ls -R ./
2021/11/13 05:31:20 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: OBJ ls -R ./ ("rclone-test-taputog0qesilav7sevaten8", "")
    sync_test.go:1215: Server side move (if possible) FS sj://rclone-test-taputog0qesilav7sevaten8 -> FS sj://rclone-test-cogaboq0lilobuf5zidanut5
2021/11/13 05:31:20 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: mkdir -p ./
2021/11/13 05:31:21 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: cp input ./empty space # [] 1
2021/11/13 05:31:21 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: cp input ./potato3 # [] 60
2021/11/13 05:31:21 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: ls -R ./
2021/11/13 05:31:21 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: OBJ ls -R ./ ("rclone-test-cogaboq0lilobuf5zidanut5", "")
2021/11/13 05:31:21 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: ls ./
2021/11/13 05:31:21 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: OBJ ls ./ ("rclone-test-cogaboq0lilobuf5zidanut5", "")
2021/11/13 05:31:21 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2021/11/13 05:31:21 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: ls ./
2021/11/13 05:31:21 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: OBJ ls ./ ("rclone-test-taputog0qesilav7sevaten8", "")
2021/11/13 05:31:21 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2021/11/13 05:31:22 DEBUG : empty space: Excluded
2021/11/13 05:31:22 DEBUG : empty space: Excluded
2021/11/13 05:31:22 DEBUG : potato3: Sizes differ (src 68 vs dst 60)
2021/11/13 05:31:22 DEBUG : potato3: cat sj://rclone-test-taputog0qesilav7sevaten8/potato3 # [HashesOption([])]
2021/11/13 05:31:22 DEBUG : potato3: range 0 + -1
2021/11/13 05:31:22 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: Waiting for checks to finish
2021/11/13 05:31:22 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: Waiting for transfers to finish
2021/11/13 05:31:22 DEBUG : potato2: cat sj://rclone-test-taputog0qesilav7sevaten8/potato2 # [HashesOption([])]
2021/11/13 05:31:22 DEBUG : potato2: range 0 + -1
2021/11/13 05:31:22 DEBUG : potato3: cp input ./potato3 [HashesOption([])]
2021/11/13 05:31:22 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: cp input ./potato3 # [HashesOption([])] 68
2021/11/13 05:31:22 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: cp input ./potato2 # [HashesOption([])] 60
2021/11/13 05:31:22 INFO  : potato3: Copied (replaced existing)
2021/11/13 05:31:22 DEBUG : potato3: rm sj://rclone-test-taputog0qesilav7sevaten8/potato3
2021/11/13 05:31:22 INFO  : potato2: Copied (new)
2021/11/13 05:31:22 DEBUG : potato2: rm sj://rclone-test-taputog0qesilav7sevaten8/potato2
2021/11/13 05:31:22 INFO  : potato3: Deleted
2021/11/13 05:31:22 INFO  : potato2: Deleted
2021/11/13 05:31:22 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: ls -R ./
2021/11/13 05:31:22 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: OBJ ls -R ./ ("rclone-test-taputog0qesilav7sevaten8", "")
2021/11/13 05:31:22 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: ls -R ./
2021/11/13 05:31:22 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: OBJ ls -R ./ ("rclone-test-cogaboq0lilobuf5zidanut5", "")
2021/11/13 05:31:23 DEBUG : Creating backend with remote "TestTardigrade:rclone-test-yasoyiy6sicamah6gutuxuy9"
2021/11/13 05:31:23 DEBUG : FS sj://rclone-test-yasoyiy6sicamah6gutuxuy9: connecting...
2021/11/13 05:31:23 DEBUG : FS sj://rclone-test-yasoyiy6sicamah6gutuxuy9: connected: <nil>
2021/11/13 05:31:23 DEBUG : FS sj://rclone-test-yasoyiy6sicamah6gutuxuy9: ls ./
2021/11/13 05:31:23 DEBUG : FS sj://rclone-test-yasoyiy6sicamah6gutuxuy9: OBJ ls ./ ("rclone-test-yasoyiy6sicamah6gutuxuy9", "")
2021/11/13 05:31:23 DEBUG : FS sj://rclone-test-yasoyiy6sicamah6gutuxuy9: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2021/11/13 05:31:23 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: ls ./
2021/11/13 05:31:23 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: OBJ ls ./ ("rclone-test-cogaboq0lilobuf5zidanut5", "")
2021/11/13 05:31:23 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2021/11/13 05:31:23 DEBUG : empty space: Excluded
2021/11/13 05:31:23 DEBUG : FS sj://rclone-test-yasoyiy6sicamah6gutuxuy9: Waiting for checks to finish
2021/11/13 05:31:23 DEBUG : potato2: cat sj://rclone-test-cogaboq0lilobuf5zidanut5/potato2 # [HashesOption([])]
2021/11/13 05:31:23 DEBUG : potato2: range 0 + -1
2021/11/13 05:31:23 DEBUG : potato3: cat sj://rclone-test-cogaboq0lilobuf5zidanut5/potato3 # [HashesOption([])]
2021/11/13 05:31:23 DEBUG : potato3: range 0 + -1
2021/11/13 05:31:23 DEBUG : FS sj://rclone-test-yasoyiy6sicamah6gutuxuy9: Waiting for transfers to finish
2021/11/13 05:31:23 DEBUG : FS sj://rclone-test-yasoyiy6sicamah6gutuxuy9: cp input ./potato3 # [HashesOption([])] 68
2021/11/13 05:31:23 DEBUG : FS sj://rclone-test-yasoyiy6sicamah6gutuxuy9: cp input ./potato2 # [HashesOption([])] 60
2021/11/13 05:31:23 ERROR : FS sj://rclone-test-yasoyiy6sicamah6gutuxuy9: cp input ./potato2 [HashesOption([])]: uplink: upload done: already committed
	storj.io/uplink.errwrapf:82
	storj.io/uplink.(*Upload).Abort:161
	github.com/rclone/rclone/backend/tardigrade.(*Fs).Put.func1:549
	github.com/rclone/rclone/backend/tardigrade.(*Fs).Put:582
	github.com/rclone/rclone/fs/operations.Copy:472
	github.com/rclone/rclone/fs/operations.Move:620
	github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairCopyOrMove:400
2021/11/13 05:31:23 DEBUG : potato2: Received error: bucket was not available, now created, the upload must be retried - low level retry 1/10
2021/11/13 05:31:23 DEBUG : potato2: cat sj://rclone-test-cogaboq0lilobuf5zidanut5/potato2 # [HashesOption([])]
2021/11/13 05:31:23 DEBUG : potato2: range 0 + -1
2021/11/13 05:31:23 DEBUG : FS sj://rclone-test-yasoyiy6sicamah6gutuxuy9: cp input ./potato2 # [HashesOption([])] 60
2021/11/13 05:31:23 INFO  : potato3: Copied (new)
2021/11/13 05:31:23 DEBUG : potato3: rm sj://rclone-test-cogaboq0lilobuf5zidanut5/potato3
2021/11/13 05:31:24 INFO  : potato2: Copied (new)
2021/11/13 05:31:24 DEBUG : potato2: rm sj://rclone-test-cogaboq0lilobuf5zidanut5/potato2
2021/11/13 05:31:24 INFO  : potato3: Deleted
2021/11/13 05:31:24 INFO  : potato2: Deleted
2021/11/13 05:31:24 DEBUG : FS sj://rclone-test-yasoyiy6sicamah6gutuxuy9: ls -R ./
2021/11/13 05:31:24 DEBUG : FS sj://rclone-test-yasoyiy6sicamah6gutuxuy9: OBJ ls -R ./ ("rclone-test-yasoyiy6sicamah6gutuxuy9", "")
2021/11/13 05:31:24 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: ls -R ./
2021/11/13 05:31:24 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: OBJ ls -R ./ ("rclone-test-cogaboq0lilobuf5zidanut5", "")
2021/11/13 05:31:24 DEBUG : FS sj://rclone-test-yasoyiy6sicamah6gutuxuy9: ls -R ./
2021/11/13 05:31:24 DEBUG : FS sj://rclone-test-yasoyiy6sicamah6gutuxuy9: OBJ ls -R ./ ("rclone-test-yasoyiy6sicamah6gutuxuy9", "")
2021/11/13 05:31:24 DEBUG : FS sj://rclone-test-yasoyiy6sicamah6gutuxuy9: Purge object "potato3"
2021/11/13 05:31:24 DEBUG : potato3: rm sj://rclone-test-yasoyiy6sicamah6gutuxuy9/potato3
2021/11/13 05:31:24 DEBUG : FS sj://rclone-test-yasoyiy6sicamah6gutuxuy9: Purge object "potato2"
2021/11/13 05:31:24 DEBUG : potato2: rm sj://rclone-test-yasoyiy6sicamah6gutuxuy9/potato2
2021/11/13 05:31:24 DEBUG : FS sj://rclone-test-yasoyiy6sicamah6gutuxuy9: Purge dir ""
2021/11/13 05:31:24 DEBUG : FS sj://rclone-test-yasoyiy6sicamah6gutuxuy9: rmdir ./
2021/11/13 05:31:24 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: ls -R ./
2021/11/13 05:31:24 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: OBJ ls -R ./ ("rclone-test-cogaboq0lilobuf5zidanut5", "")
2021/11/13 05:31:24 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: Purge object "empty space"
2021/11/13 05:31:24 DEBUG : empty space: rm sj://rclone-test-cogaboq0lilobuf5zidanut5/empty space
2021/11/13 05:31:24 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: Purge dir ""
2021/11/13 05:31:24 DEBUG : FS sj://rclone-test-cogaboq0lilobuf5zidanut5: rmdir ./
2021/11/13 05:31:24 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: ls -R ./
2021/11/13 05:31:24 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: OBJ ls -R ./ ("rclone-test-taputog0qesilav7sevaten8", "")
2021/11/13 05:31:25 DEBUG : empty space: rm sj://rclone-test-taputog0qesilav7sevaten8/empty space
2021/11/13 05:31:25 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: ls -R ./
2021/11/13 05:31:25 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: OBJ ls -R ./ ("rclone-test-taputog0qesilav7sevaten8", "")
--- PASS: TestServerSideMoveWithFilter (6.28s)
=== RUN   TestServerSideMoveDeleteEmptySourceDirs
    run.go:181: Remote "FS sj://rclone-test-taputog0qesilav7sevaten8", Local "Local file system at /tmp/rclone2845072398", Modify Window "1ns"
2021/11/13 05:31:25 DEBUG : Creating backend with remote "TestTardigrade:rclone-test-mawuquz4leremaz4baletac8"
2021/11/13 05:31:25 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: connecting...
2021/11/13 05:31:25 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: connected: <nil>
2021/11/13 05:31:25 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: cp input ./potato2 # [] 60
2021/11/13 05:31:25 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: cp input ./empty space # [] 1
2021/11/13 05:31:26 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: cp input ./potato3 # [] 68
2021/11/13 05:31:26 DEBUG : tomatoDir: Making directory
2021/11/13 05:31:26 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: mkdir -p ./tomatoDir
2021/11/13 05:31:26 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: ls -R ./
2021/11/13 05:31:26 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: OBJ ls -R ./ ("rclone-test-taputog0qesilav7sevaten8", "")
    sync_test.go:1215: Server side move (if possible) FS sj://rclone-test-taputog0qesilav7sevaten8 -> FS sj://rclone-test-mawuquz4leremaz4baletac8
2021/11/13 05:31:26 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: mkdir -p ./
2021/11/13 05:31:27 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: cp input ./empty space # [] 1
2021/11/13 05:31:27 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: cp input ./potato3 # [] 60
2021/11/13 05:31:27 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: ls -R ./
2021/11/13 05:31:27 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: OBJ ls -R ./ ("rclone-test-mawuquz4leremaz4baletac8", "")
2021/11/13 05:31:27 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: ls ./
2021/11/13 05:31:27 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: OBJ ls ./ ("rclone-test-mawuquz4leremaz4baletac8", "")
2021/11/13 05:31:27 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2021/11/13 05:31:27 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: ls ./
2021/11/13 05:31:27 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: OBJ ls ./ ("rclone-test-taputog0qesilav7sevaten8", "")
2021/11/13 05:31:27 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2021/11/13 05:31:28 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2021/11/13 05:31:28 DEBUG : empty space: Unchanged skipping
2021/11/13 05:31:28 DEBUG : potato3: Sizes differ (src 68 vs dst 60)
2021/11/13 05:31:28 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: Waiting for checks to finish
2021/11/13 05:31:28 DEBUG : empty space: rm sj://rclone-test-taputog0qesilav7sevaten8/empty space
2021/11/13 05:31:28 DEBUG : potato2: cat sj://rclone-test-taputog0qesilav7sevaten8/potato2 # [HashesOption([])]
2021/11/13 05:31:28 DEBUG : potato2: range 0 + -1
2021/11/13 05:31:28 DEBUG : potato3: cat sj://rclone-test-taputog0qesilav7sevaten8/potato3 # [HashesOption([])]
2021/11/13 05:31:28 DEBUG : potato3: range 0 + -1
2021/11/13 05:31:28 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: cp input ./potato2 # [HashesOption([])] 60
2021/11/13 05:31:28 DEBUG : potato3: cp input ./potato3 [HashesOption([])]
2021/11/13 05:31:28 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: cp input ./potato3 # [HashesOption([])] 68
2021/11/13 05:31:28 INFO  : empty space: Deleted
2021/11/13 05:31:28 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: Waiting for transfers to finish
2021/11/13 05:31:28 INFO  : potato2: Copied (new)
2021/11/13 05:31:28 DEBUG : potato2: rm sj://rclone-test-taputog0qesilav7sevaten8/potato2
2021/11/13 05:31:28 INFO  : potato2: Deleted
2021/11/13 05:31:28 INFO  : potato3: Copied (replaced existing)
2021/11/13 05:31:28 DEBUG : potato3: rm sj://rclone-test-taputog0qesilav7sevaten8/potato3
2021/11/13 05:31:28 INFO  : potato3: Deleted
2021/11/13 05:31:28 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: ls -R ./
2021/11/13 05:31:28 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: OBJ ls -R ./ ("rclone-test-taputog0qesilav7sevaten8", "")
2021/11/13 05:31:28 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: ls -R ./
2021/11/13 05:31:28 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: OBJ ls -R ./ ("rclone-test-taputog0qesilav7sevaten8", "")
2021/11/13 05:31:28 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: ls -R ./
2021/11/13 05:31:28 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: OBJ ls -R ./ ("rclone-test-mawuquz4leremaz4baletac8", "")
2021/11/13 05:31:29 DEBUG : Creating backend with remote "TestTardigrade:rclone-test-wogohor7hofecon2lagorow7"
2021/11/13 05:31:29 DEBUG : FS sj://rclone-test-wogohor7hofecon2lagorow7: connecting...
2021/11/13 05:31:29 DEBUG : FS sj://rclone-test-wogohor7hofecon2lagorow7: connected: <nil>
2021/11/13 05:31:29 DEBUG : tomatoDir: Making directory
2021/11/13 05:31:29 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: mkdir -p ./tomatoDir
2021/11/13 05:31:29 DEBUG : FS sj://rclone-test-wogohor7hofecon2lagorow7: ls ./
2021/11/13 05:31:29 DEBUG : FS sj://rclone-test-wogohor7hofecon2lagorow7: OBJ ls ./ ("rclone-test-wogohor7hofecon2lagorow7", "")
2021/11/13 05:31:29 DEBUG : FS sj://rclone-test-wogohor7hofecon2lagorow7: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2021/11/13 05:31:29 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: ls ./
2021/11/13 05:31:29 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: OBJ ls ./ ("rclone-test-mawuquz4leremaz4baletac8", "")
2021/11/13 05:31:29 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2021/11/13 05:31:29 DEBUG : FS sj://rclone-test-wogohor7hofecon2lagorow7: Waiting for checks to finish
2021/11/13 05:31:29 DEBUG : FS sj://rclone-test-wogohor7hofecon2lagorow7: Waiting for transfers to finish
2021/11/13 05:31:29 DEBUG : empty space: cat sj://rclone-test-mawuquz4leremaz4baletac8/empty space # [HashesOption([])]
2021/11/13 05:31:29 DEBUG : empty space: range 0 + -1
2021/11/13 05:31:29 DEBUG : potato2: cat sj://rclone-test-mawuquz4leremaz4baletac8/potato2 # [HashesOption([])]
2021/11/13 05:31:29 DEBUG : potato3: cat sj://rclone-test-mawuquz4leremaz4baletac8/potato3 # [HashesOption([])]
2021/11/13 05:31:29 DEBUG : potato2: range 0 + -1
2021/11/13 05:31:29 DEBUG : potato3: range 0 + -1
2021/11/13 05:31:29 DEBUG : FS sj://rclone-test-wogohor7hofecon2lagorow7: cp input ./potato2 # [HashesOption([])] 60
2021/11/13 05:31:29 DEBUG : FS sj://rclone-test-wogohor7hofecon2lagorow7: cp input ./potato3 # [HashesOption([])] 68
2021/11/13 05:31:29 DEBUG : FS sj://rclone-test-wogohor7hofecon2lagorow7: cp input ./empty space # [HashesOption([])] 1
2021/11/13 05:31:29 ERROR : FS sj://rclone-test-wogohor7hofecon2lagorow7: cp input ./potato2 [HashesOption([])]: uplink: upload done: already committed
	storj.io/uplink.errwrapf:82
	storj.io/uplink.(*Upload).Abort:161
	github.com/rclone/rclone/backend/tardigrade.(*Fs).Put.func1:549
	github.com/rclone/rclone/backend/tardigrade.(*Fs).Put:582
	github.com/rclone/rclone/fs/operations.Copy:472
	github.com/rclone/rclone/fs/operations.Move:620
	github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairCopyOrMove:400
2021/11/13 05:31:29 DEBUG : potato2: Received error: bucket was not available, now created, the upload must be retried - low level retry 1/10
2021/11/13 05:31:29 DEBUG : potato2: cat sj://rclone-test-mawuquz4leremaz4baletac8/potato2 # [HashesOption([])]
2021/11/13 05:31:29 DEBUG : potato2: range 0 + -1
2021/11/13 05:31:30 DEBUG : FS sj://rclone-test-wogohor7hofecon2lagorow7: cp input ./potato2 # [HashesOption([])] 60
2021/11/13 05:31:30 INFO  : potato3: Copied (new)
2021/11/13 05:31:30 DEBUG : potato3: rm sj://rclone-test-mawuquz4leremaz4baletac8/potato3
2021/11/13 05:31:30 INFO  : empty space: Copied (new)
2021/11/13 05:31:30 DEBUG : empty space: rm sj://rclone-test-mawuquz4leremaz4baletac8/empty space
2021/11/13 05:31:30 INFO  : potato3: Deleted
2021/11/13 05:31:30 INFO  : empty space: Deleted
2021/11/13 05:31:30 INFO  : potato2: Copied (new)
2021/11/13 05:31:30 DEBUG : potato2: rm sj://rclone-test-mawuquz4leremaz4baletac8/potato2
2021/11/13 05:31:30 INFO  : potato2: Deleted
2021/11/13 05:31:30 DEBUG : FS sj://rclone-test-wogohor7hofecon2lagorow7: ls -R ./
2021/11/13 05:31:30 DEBUG : FS sj://rclone-test-wogohor7hofecon2lagorow7: OBJ ls -R ./ ("rclone-test-wogohor7hofecon2lagorow7", "")
2021/11/13 05:31:30 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: ls -R ./
2021/11/13 05:31:30 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: OBJ ls -R ./ ("rclone-test-mawuquz4leremaz4baletac8", "")
2021/11/13 05:31:30 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: ls -R ./
2021/11/13 05:31:30 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: OBJ ls -R ./ ("rclone-test-mawuquz4leremaz4baletac8", "")
2021/11/13 05:31:30 DEBUG : FS sj://rclone-test-wogohor7hofecon2lagorow7: ls -R ./
2021/11/13 05:31:30 DEBUG : FS sj://rclone-test-wogohor7hofecon2lagorow7: OBJ ls -R ./ ("rclone-test-wogohor7hofecon2lagorow7", "")
2021/11/13 05:31:30 DEBUG : FS sj://rclone-test-wogohor7hofecon2lagorow7: Purge object "potato3"
2021/11/13 05:31:30 DEBUG : potato3: rm sj://rclone-test-wogohor7hofecon2lagorow7/potato3
2021/11/13 05:31:30 DEBUG : FS sj://rclone-test-wogohor7hofecon2lagorow7: Purge object "potato2"
2021/11/13 05:31:30 DEBUG : potato2: rm sj://rclone-test-wogohor7hofecon2lagorow7/potato2
2021/11/13 05:31:31 DEBUG : FS sj://rclone-test-wogohor7hofecon2lagorow7: Purge object "empty space"
2021/11/13 05:31:31 DEBUG : empty space: rm sj://rclone-test-wogohor7hofecon2lagorow7/empty space
2021/11/13 05:31:31 DEBUG : FS sj://rclone-test-wogohor7hofecon2lagorow7: Purge dir ""
2021/11/13 05:31:31 DEBUG : FS sj://rclone-test-wogohor7hofecon2lagorow7: rmdir ./
2021/11/13 05:31:31 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: ls -R ./
2021/11/13 05:31:31 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: OBJ ls -R ./ ("rclone-test-mawuquz4leremaz4baletac8", "")
2021/11/13 05:31:31 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: Purge dir ""
2021/11/13 05:31:31 DEBUG : FS sj://rclone-test-mawuquz4leremaz4baletac8: rmdir ./
2021/11/13 05:31:31 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: ls -R ./
2021/11/13 05:31:31 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: OBJ ls -R ./ ("rclone-test-taputog0qesilav7sevaten8", "")
2021/11/13 05:31:31 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: ls -R ./
2021/11/13 05:31:31 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: OBJ ls -R ./ ("rclone-test-taputog0qesilav7sevaten8", "")
--- PASS: TestServerSideMoveDeleteEmptySourceDirs (6.30s)
PASS
2021/11/13 05:31:31 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: ls -R ./
2021/11/13 05:31:31 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: OBJ ls -R ./ ("rclone-test-taputog0qesilav7sevaten8", "")
2021/11/13 05:31:31 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: Purge dir ""
2021/11/13 05:31:31 DEBUG : FS sj://rclone-test-taputog0qesilav7sevaten8: rmdir ./
"./sync.test -test.v -test.timeout 1h0m0s -remote TestTardigrade: -verbose -test.run '^(TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveWithFilter)$'" - Finished OK in 12.837032126s (try 2/5)