"./sync.test -test.v -test.timeout 1h0m0s -remote TestStorj: -verbose -test.run '^(TestServerSideMove|TestServerSideMoveWithFilter)$'" - Starting (try 4/5)
2024/10/29 02:35:31 DEBUG : Creating backend with remote "TestStorj:rclone-test-qetetay9hire"
2024/10/29 02:35:31 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/10/29 02:35:31 DEBUG : FS sj://rclone-test-qetetay9hire: connecting...
2024/10/29 02:35:31 DEBUG : FS sj://rclone-test-qetetay9hire: connected: <nil>
2024/10/29 02:35:31 DEBUG : Creating backend with remote "/tmp/rclone1707610558"
=== RUN   TestServerSideMove
    run.go:180: Remote "FS sj://rclone-test-qetetay9hire", Local "Local file system at /tmp/rclone1707610558", Modify Window "1ns"
2024/10/29 02:35:31 DEBUG : Creating backend with remote "TestStorj:rclone-test-qaqecuz4buqe"
2024/10/29 02:35:31 DEBUG : FS sj://rclone-test-qaqecuz4buqe: connecting...
2024/10/29 02:35:31 DEBUG : FS sj://rclone-test-qaqecuz4buqe: connected: <nil>
2024/10/29 02:35:31 DEBUG : FS sj://rclone-test-qetetay9hire: mkdir -p ./
2024/10/29 02:35:32 DEBUG : FS sj://rclone-test-qetetay9hire: cp input ./potato2 # [] 60
2024/10/29 02:35:32 DEBUG : FS sj://rclone-test-qetetay9hire: cp input ./empty space # [] 1
2024/10/29 02:35:32 DEBUG : FS sj://rclone-test-qetetay9hire: cp input ./potato3 # [] 68
2024/10/29 02:35:32 DEBUG : FS sj://rclone-test-qetetay9hire: ls -R ./
2024/10/29 02:35:32 DEBUG : FS sj://rclone-test-qetetay9hire: OBJ ls -R ./ ("rclone-test-qetetay9hire", "")
    sync_test.go:1705: Server side move (if possible) FS sj://rclone-test-qetetay9hire -> FS sj://rclone-test-qaqecuz4buqe
2024/10/29 02:35:32 DEBUG : FS sj://rclone-test-qaqecuz4buqe: mkdir -p ./
2024/10/29 02:35:33 DEBUG : FS sj://rclone-test-qaqecuz4buqe: cp input ./empty space # [] 1
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-qaqecuz4buqe: cp input ./potato3 # [] 60
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-qaqecuz4buqe: ls -R ./
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-qaqecuz4buqe: OBJ ls -R ./ ("rclone-test-qaqecuz4buqe", "")
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-qaqecuz4buqe: ls ./
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-qetetay9hire: ls ./
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-qaqecuz4buqe: OBJ ls ./ ("rclone-test-qaqecuz4buqe", "")
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-qetetay9hire: OBJ ls ./ ("rclone-test-qetetay9hire", "")
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-qaqecuz4buqe: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-qetetay9hire: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/10/29 02:35:34 DEBUG : potato2: Need to transfer - File not found at Destination
2024/10/29 02:35:34 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2024/10/29 02:35:34 DEBUG : empty space: Unchanged skipping
2024/10/29 02:35:34 DEBUG : empty space: rm sj://rclone-test-qetetay9hire/empty space
2024/10/29 02:35:34 DEBUG : potato3: Sizes differ (src 68 vs dst 60)
2024/10/29 02:35:34 DEBUG : potato3: rm sj://rclone-test-qaqecuz4buqe/potato3
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-qaqecuz4buqe: Waiting for checks to finish
2024/10/29 02:35:34 INFO  : potato3: Deleted
2024/10/29 02:35:34 INFO  : empty space: Deleted
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-qaqecuz4buqe: Waiting for transfers to finish
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-qaqecuz4buqe: stat ./potato3
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-qaqecuz4buqe: stat ./potato2
2024/10/29 02:35:34 INFO  : potato3: Moved (server-side)
2024/10/29 02:35:34 INFO  : potato2: Moved (server-side)
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-qetetay9hire: ls -R ./
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-qetetay9hire: OBJ ls -R ./ ("rclone-test-qetetay9hire", "")
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-qaqecuz4buqe: ls -R ./
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-qaqecuz4buqe: OBJ ls -R ./ ("rclone-test-qaqecuz4buqe", "")
2024/10/29 02:35:34 DEBUG : Creating backend with remote "TestStorj:rclone-test-lebejuf5kabi"
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-lebejuf5kabi: connecting...
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-lebejuf5kabi: connected: <nil>
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-lebejuf5kabi: ls ./
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-lebejuf5kabi: OBJ ls ./ ("rclone-test-lebejuf5kabi", "")
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-lebejuf5kabi: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-qaqecuz4buqe: ls ./
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-qaqecuz4buqe: OBJ ls ./ ("rclone-test-qaqecuz4buqe", "")
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-qaqecuz4buqe: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/10/29 02:35:34 DEBUG : empty space: Need to transfer - File not found at Destination
2024/10/29 02:35:34 DEBUG : potato2: Need to transfer - File not found at Destination
2024/10/29 02:35:34 DEBUG : potato3: Need to transfer - File not found at Destination
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-lebejuf5kabi: Waiting for checks to finish
2024/10/29 02:35:34 DEBUG : FS sj://rclone-test-lebejuf5kabi: Waiting for transfers to finish
2024/10/29 02:35:35 DEBUG : FS sj://rclone-test-lebejuf5kabi: stat ./potato2
2024/10/29 02:35:35 DEBUG : FS sj://rclone-test-lebejuf5kabi: stat ./potato3
2024/10/29 02:35:35 INFO  : potato2: Moved (server-side)
2024/10/29 02:35:35 INFO  : potato3: Moved (server-side)
2024/10/29 02:35:35 DEBUG : FS sj://rclone-test-lebejuf5kabi: stat ./empty space
2024/10/29 02:35:35 INFO  : empty space: Moved (server-side)
2024/10/29 02:35:35 DEBUG : FS sj://rclone-test-lebejuf5kabi: ls -R ./
2024/10/29 02:35:35 DEBUG : FS sj://rclone-test-lebejuf5kabi: OBJ ls -R ./ ("rclone-test-lebejuf5kabi", "")
2024/10/29 02:35:35 DEBUG : FS sj://rclone-test-qaqecuz4buqe: ls -R ./
2024/10/29 02:35:35 DEBUG : FS sj://rclone-test-qaqecuz4buqe: OBJ ls -R ./ ("rclone-test-qaqecuz4buqe", "")
2024/10/29 02:35:35 DEBUG : FS sj://rclone-test-lebejuf5kabi: Purge remote
2024/10/29 02:35:35 DEBUG : FS sj://rclone-test-qaqecuz4buqe: Purge remote
2024/10/29 02:35:36 DEBUG : FS sj://rclone-test-qetetay9hire: ls -R ./
2024/10/29 02:35:36 DEBUG : FS sj://rclone-test-qetetay9hire: OBJ ls -R ./ ("rclone-test-qetetay9hire", "")
2024/10/29 02:35:36 DEBUG : FS sj://rclone-test-qetetay9hire: ls -R ./
2024/10/29 02:35:36 DEBUG : FS sj://rclone-test-qetetay9hire: OBJ ls -R ./ ("rclone-test-qetetay9hire", "")
--- PASS: TestServerSideMove (4.67s)
=== RUN   TestServerSideMoveWithFilter
    run.go:180: Remote "FS sj://rclone-test-qetetay9hire", Local "Local file system at /tmp/rclone1707610558", Modify Window "1ns"
2024/10/29 02:35:36 DEBUG : Creating backend with remote "TestStorj:rclone-test-poqigad6qeyo"
2024/10/29 02:35:36 DEBUG : FS sj://rclone-test-poqigad6qeyo: connecting...
2024/10/29 02:35:36 DEBUG : FS sj://rclone-test-poqigad6qeyo: connected: <nil>
2024/10/29 02:35:36 DEBUG : FS sj://rclone-test-qetetay9hire: cp input ./potato2 # [] 60
2024/10/29 02:35:36 DEBUG : FS sj://rclone-test-qetetay9hire: cp input ./empty space # [] 1
2024/10/29 02:35:36 DEBUG : FS sj://rclone-test-qetetay9hire: cp input ./potato3 # [] 68
2024/10/29 02:35:36 DEBUG : FS sj://rclone-test-qetetay9hire: ls -R ./
2024/10/29 02:35:36 DEBUG : FS sj://rclone-test-qetetay9hire: OBJ ls -R ./ ("rclone-test-qetetay9hire", "")
    sync_test.go:1705: Server side move (if possible) FS sj://rclone-test-qetetay9hire -> FS sj://rclone-test-poqigad6qeyo
2024/10/29 02:35:36 DEBUG : FS sj://rclone-test-poqigad6qeyo: mkdir -p ./
2024/10/29 02:35:37 DEBUG : FS sj://rclone-test-poqigad6qeyo: cp input ./empty space # [] 1
2024/10/29 02:35:37 DEBUG : FS sj://rclone-test-poqigad6qeyo: cp input ./potato3 # [] 60
2024/10/29 02:35:37 DEBUG : FS sj://rclone-test-poqigad6qeyo: ls -R ./
2024/10/29 02:35:37 DEBUG : FS sj://rclone-test-poqigad6qeyo: OBJ ls -R ./ ("rclone-test-poqigad6qeyo", "")
2024/10/29 02:35:37 DEBUG : FS sj://rclone-test-poqigad6qeyo: ls ./
2024/10/29 02:35:37 DEBUG : FS sj://rclone-test-poqigad6qeyo: OBJ ls ./ ("rclone-test-poqigad6qeyo", "")
2024/10/29 02:35:37 DEBUG : FS sj://rclone-test-qetetay9hire: ls ./
2024/10/29 02:35:37 DEBUG : FS sj://rclone-test-poqigad6qeyo: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/10/29 02:35:37 DEBUG : FS sj://rclone-test-qetetay9hire: OBJ ls ./ ("rclone-test-qetetay9hire", "")
2024/10/29 02:35:37 DEBUG : FS sj://rclone-test-qetetay9hire: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/10/29 02:35:37 DEBUG : empty space: Excluded (Size Filter)
2024/10/29 02:35:37 DEBUG : empty space: Excluded
2024/10/29 02:35:37 DEBUG : empty space: Excluded (Size Filter)
2024/10/29 02:35:37 DEBUG : empty space: Excluded
2024/10/29 02:35:37 DEBUG : potato2: Need to transfer - File not found at Destination
2024/10/29 02:35:37 DEBUG : potato3: Sizes differ (src 68 vs dst 60)
2024/10/29 02:35:37 DEBUG : FS sj://rclone-test-poqigad6qeyo: Waiting for checks to finish
2024/10/29 02:35:37 DEBUG : FS sj://rclone-test-poqigad6qeyo: Waiting for transfers to finish
2024/10/29 02:35:37 DEBUG : potato3: rm sj://rclone-test-poqigad6qeyo/potato3
2024/10/29 02:35:37 DEBUG : FS sj://rclone-test-poqigad6qeyo: stat ./potato2
2024/10/29 02:35:37 INFO  : potato2: Moved (server-side)
2024/10/29 02:35:37 INFO  : potato3: Deleted
2024/10/29 02:35:37 DEBUG : FS sj://rclone-test-poqigad6qeyo: stat ./potato3
2024/10/29 02:35:38 INFO  : potato3: Moved (server-side)
2024/10/29 02:35:38 DEBUG : FS sj://rclone-test-qetetay9hire: ls -R ./
2024/10/29 02:35:38 DEBUG : FS sj://rclone-test-qetetay9hire: OBJ ls -R ./ ("rclone-test-qetetay9hire", "")
2024/10/29 02:35:38 DEBUG : FS sj://rclone-test-poqigad6qeyo: ls -R ./
2024/10/29 02:35:38 DEBUG : FS sj://rclone-test-poqigad6qeyo: OBJ ls -R ./ ("rclone-test-poqigad6qeyo", "")
2024/10/29 02:35:38 DEBUG : Creating backend with remote "TestStorj:rclone-test-lasepoc8zapa"
2024/10/29 02:35:38 DEBUG : FS sj://rclone-test-lasepoc8zapa: connecting...
2024/10/29 02:35:38 DEBUG : FS sj://rclone-test-lasepoc8zapa: connected: <nil>
2024/10/29 02:35:38 DEBUG : FS sj://rclone-test-lasepoc8zapa: ls ./
2024/10/29 02:35:38 DEBUG : FS sj://rclone-test-lasepoc8zapa: OBJ ls ./ ("rclone-test-lasepoc8zapa", "")
2024/10/29 02:35:38 DEBUG : FS sj://rclone-test-poqigad6qeyo: ls ./
2024/10/29 02:35:38 DEBUG : FS sj://rclone-test-poqigad6qeyo: OBJ ls ./ ("rclone-test-poqigad6qeyo", "")
2024/10/29 02:35:38 DEBUG : FS sj://rclone-test-lasepoc8zapa: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/10/29 02:35:38 DEBUG : FS sj://rclone-test-poqigad6qeyo: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/10/29 02:35:38 DEBUG : empty space: Excluded (Size Filter)
2024/10/29 02:35:38 DEBUG : empty space: Excluded
2024/10/29 02:35:38 DEBUG : potato2: Need to transfer - File not found at Destination
2024/10/29 02:35:38 DEBUG : potato3: Need to transfer - File not found at Destination
2024/10/29 02:35:38 DEBUG : FS sj://rclone-test-lasepoc8zapa: Waiting for checks to finish
2024/10/29 02:35:38 DEBUG : FS sj://rclone-test-lasepoc8zapa: Waiting for transfers to finish
2024/10/29 02:35:38 ERROR : potato3: Couldn't move: rename object failed: uplink: bucket not found ("rclone-test-lasepoc8zapa")
2024/10/29 02:35:39 DEBUG : FS sj://rclone-test-lasepoc8zapa: stat ./potato2
2024/10/29 02:35:39 INFO  : potato2: Moved (server-side)
    sync_test.go:1745: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1745
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1894
        	Error:      	Received unexpected error:
        	            	rename object failed: uplink: bucket not found ("rclone-test-lasepoc8zapa")
        	Test:       	TestServerSideMoveWithFilter
2024/10/29 02:35:39 DEBUG : FS sj://rclone-test-lasepoc8zapa: Purge remote
2024/10/29 02:35:39 DEBUG : FS sj://rclone-test-poqigad6qeyo: Purge remote
2024/10/29 02:35:40 DEBUG : FS sj://rclone-test-qetetay9hire: ls -R ./
2024/10/29 02:35:40 DEBUG : FS sj://rclone-test-qetetay9hire: OBJ ls -R ./ ("rclone-test-qetetay9hire", "")
2024/10/29 02:35:40 DEBUG : empty space: rm sj://rclone-test-qetetay9hire/empty space
2024/10/29 02:35:40 DEBUG : FS sj://rclone-test-qetetay9hire: ls -R ./
2024/10/29 02:35:40 DEBUG : FS sj://rclone-test-qetetay9hire: OBJ ls -R ./ ("rclone-test-qetetay9hire", "")
--- FAIL: TestServerSideMoveWithFilter (4.07s)
FAIL
2024/10/29 02:35:40 DEBUG : FS sj://rclone-test-qetetay9hire: Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestStorj: -verbose -test.run '^(TestServerSideMove|TestServerSideMoveWithFilter)$'" - Finished ERROR in 9.263760021s (try 4/5): exit status 1: Failed [TestServerSideMoveWithFilter]