"./sync.test -test.v -test.timeout 1h0m0s -remote TestStorj: -verbose -test.run '^(TestServerSideMove|TestServerSideMoveWithFilter)$'" - Starting (try 2/5)
2024/11/20 03:01:58 DEBUG : Creating backend with remote "TestStorj:rclone-test-xazuzag6diqu"
2024/11/20 03:01:58 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/11/20 03:01:58 DEBUG : FS sj://rclone-test-xazuzag6diqu: connecting...
2024/11/20 03:01:58 DEBUG : FS sj://rclone-test-xazuzag6diqu: connected: <nil>
2024/11/20 03:01:58 DEBUG : Creating backend with remote "/tmp/rclone1401032492"
=== RUN   TestServerSideMove
    run.go:180: Remote "FS sj://rclone-test-xazuzag6diqu", Local "Local file system at /tmp/rclone1401032492", Modify Window "1ns"
2024/11/20 03:01:58 DEBUG : Creating backend with remote "TestStorj:rclone-test-mohotuz0pika"
2024/11/20 03:01:58 DEBUG : FS sj://rclone-test-mohotuz0pika: connecting...
2024/11/20 03:01:58 DEBUG : FS sj://rclone-test-mohotuz0pika: connected: <nil>
2024/11/20 03:01:58 DEBUG : FS sj://rclone-test-xazuzag6diqu: mkdir -p ./
2024/11/20 03:01:59 DEBUG : FS sj://rclone-test-xazuzag6diqu: cp input ./potato2 # [] 60
2024/11/20 03:01:59 DEBUG : FS sj://rclone-test-xazuzag6diqu: cp input ./empty space # [] 1
2024/11/20 03:01:59 DEBUG : FS sj://rclone-test-xazuzag6diqu: cp input ./potato3 # [] 68
2024/11/20 03:02:00 DEBUG : FS sj://rclone-test-xazuzag6diqu: ls -R ./
2024/11/20 03:02:00 DEBUG : FS sj://rclone-test-xazuzag6diqu: OBJ ls -R ./ ("rclone-test-xazuzag6diqu", "")
    sync_test.go:1705: Server side move (if possible) FS sj://rclone-test-xazuzag6diqu -> FS sj://rclone-test-mohotuz0pika
2024/11/20 03:02:00 DEBUG : FS sj://rclone-test-mohotuz0pika: mkdir -p ./
2024/11/20 03:02:00 DEBUG : FS sj://rclone-test-mohotuz0pika: cp input ./empty space # [] 1
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-mohotuz0pika: cp input ./potato3 # [] 60
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-mohotuz0pika: ls -R ./
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-mohotuz0pika: OBJ ls -R ./ ("rclone-test-mohotuz0pika", "")
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-mohotuz0pika: ls ./
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-mohotuz0pika: OBJ ls ./ ("rclone-test-mohotuz0pika", "")
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-mohotuz0pika: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-xazuzag6diqu: ls ./
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-xazuzag6diqu: OBJ ls ./ ("rclone-test-xazuzag6diqu", "")
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-xazuzag6diqu: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/11/20 03:02:01 DEBUG : potato2: Need to transfer - File not found at Destination
2024/11/20 03:02:01 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2024/11/20 03:02:01 DEBUG : empty space: Unchanged skipping
2024/11/20 03:02:01 DEBUG : empty space: rm sj://rclone-test-xazuzag6diqu/empty space
2024/11/20 03:02:01 DEBUG : potato3: Sizes differ (src 68 vs dst 60)
2024/11/20 03:02:01 DEBUG : potato3: rm sj://rclone-test-mohotuz0pika/potato3
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-mohotuz0pika: Waiting for checks to finish
2024/11/20 03:02:01 INFO  : empty space: Deleted
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-mohotuz0pika: Waiting for transfers to finish
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-mohotuz0pika: stat ./potato2
2024/11/20 03:02:01 INFO  : potato3: Deleted
2024/11/20 03:02:01 INFO  : potato2: Moved (server-side)
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-mohotuz0pika: stat ./potato3
2024/11/20 03:02:01 INFO  : potato3: Moved (server-side)
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-xazuzag6diqu: ls -R ./
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-xazuzag6diqu: OBJ ls -R ./ ("rclone-test-xazuzag6diqu", "")
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-mohotuz0pika: ls -R ./
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-mohotuz0pika: OBJ ls -R ./ ("rclone-test-mohotuz0pika", "")
2024/11/20 03:02:01 DEBUG : Creating backend with remote "TestStorj:rclone-test-zopehap7bope"
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-zopehap7bope: connecting...
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-zopehap7bope: connected: <nil>
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-zopehap7bope: ls ./
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-zopehap7bope: OBJ ls ./ ("rclone-test-zopehap7bope", "")
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-zopehap7bope: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-mohotuz0pika: ls ./
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-mohotuz0pika: OBJ ls ./ ("rclone-test-mohotuz0pika", "")
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-mohotuz0pika: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/11/20 03:02:01 DEBUG : empty space: Need to transfer - File not found at Destination
2024/11/20 03:02:01 DEBUG : potato2: Need to transfer - File not found at Destination
2024/11/20 03:02:01 DEBUG : potato3: Need to transfer - File not found at Destination
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-zopehap7bope: Waiting for checks to finish
2024/11/20 03:02:01 DEBUG : FS sj://rclone-test-zopehap7bope: Waiting for transfers to finish
2024/11/20 03:02:01 ERROR : empty space: Couldn't move: rename object failed: uplink: bucket not found ("rclone-test-zopehap7bope")
2024/11/20 03:02:01 ERROR : potato2: Couldn't move: rename object failed: uplink: bucket not found ("rclone-test-zopehap7bope")
2024/11/20 03:02:02 DEBUG : FS sj://rclone-test-zopehap7bope: stat ./potato3
2024/11/20 03:02:02 INFO  : potato3: 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:1881
        	Error:      	Received unexpected error:
        	            	rename object failed: uplink: bucket not found ("rclone-test-zopehap7bope")
        	Test:       	TestServerSideMove
2024/11/20 03:02:02 DEBUG : FS sj://rclone-test-zopehap7bope: Purge remote
2024/11/20 03:02:03 DEBUG : FS sj://rclone-test-mohotuz0pika: Purge remote
2024/11/20 03:02:03 DEBUG : FS sj://rclone-test-xazuzag6diqu: ls -R ./
2024/11/20 03:02:03 DEBUG : FS sj://rclone-test-xazuzag6diqu: OBJ ls -R ./ ("rclone-test-xazuzag6diqu", "")
2024/11/20 03:02:03 DEBUG : FS sj://rclone-test-xazuzag6diqu: ls -R ./
2024/11/20 03:02:03 DEBUG : FS sj://rclone-test-xazuzag6diqu: OBJ ls -R ./ ("rclone-test-xazuzag6diqu", "")
--- FAIL: TestServerSideMove (5.08s)
=== RUN   TestServerSideMoveWithFilter
    run.go:180: Remote "FS sj://rclone-test-xazuzag6diqu", Local "Local file system at /tmp/rclone1401032492", Modify Window "1ns"
2024/11/20 03:02:03 DEBUG : Creating backend with remote "TestStorj:rclone-test-vafahav1kedo"
2024/11/20 03:02:03 DEBUG : FS sj://rclone-test-vafahav1kedo: connecting...
2024/11/20 03:02:03 DEBUG : FS sj://rclone-test-vafahav1kedo: connected: <nil>
2024/11/20 03:02:03 DEBUG : FS sj://rclone-test-xazuzag6diqu: cp input ./potato2 # [] 60
2024/11/20 03:02:03 DEBUG : FS sj://rclone-test-xazuzag6diqu: cp input ./empty space # [] 1
2024/11/20 03:02:04 DEBUG : FS sj://rclone-test-xazuzag6diqu: cp input ./potato3 # [] 68
2024/11/20 03:02:04 DEBUG : FS sj://rclone-test-xazuzag6diqu: ls -R ./
2024/11/20 03:02:04 DEBUG : FS sj://rclone-test-xazuzag6diqu: OBJ ls -R ./ ("rclone-test-xazuzag6diqu", "")
    sync_test.go:1705: Server side move (if possible) FS sj://rclone-test-xazuzag6diqu -> FS sj://rclone-test-vafahav1kedo
2024/11/20 03:02:04 DEBUG : FS sj://rclone-test-vafahav1kedo: mkdir -p ./
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-vafahav1kedo: cp input ./empty space # [] 1
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-vafahav1kedo: cp input ./potato3 # [] 60
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-vafahav1kedo: ls -R ./
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-vafahav1kedo: OBJ ls -R ./ ("rclone-test-vafahav1kedo", "")
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-vafahav1kedo: ls ./
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-xazuzag6diqu: ls ./
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-vafahav1kedo: OBJ ls ./ ("rclone-test-vafahav1kedo", "")
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-xazuzag6diqu: OBJ ls ./ ("rclone-test-xazuzag6diqu", "")
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-vafahav1kedo: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-xazuzag6diqu: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/11/20 03:02:05 DEBUG : empty space: Excluded (Size Filter)
2024/11/20 03:02:05 DEBUG : empty space: Excluded
2024/11/20 03:02:05 DEBUG : empty space: Excluded (Size Filter)
2024/11/20 03:02:05 DEBUG : empty space: Excluded
2024/11/20 03:02:05 DEBUG : potato2: Need to transfer - File not found at Destination
2024/11/20 03:02:05 DEBUG : potato3: Sizes differ (src 68 vs dst 60)
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-vafahav1kedo: Waiting for checks to finish
2024/11/20 03:02:05 DEBUG : potato3: rm sj://rclone-test-vafahav1kedo/potato3
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-vafahav1kedo: Waiting for transfers to finish
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-vafahav1kedo: stat ./potato2
2024/11/20 03:02:05 INFO  : potato3: Deleted
2024/11/20 03:02:05 INFO  : potato2: Moved (server-side)
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-vafahav1kedo: stat ./potato3
2024/11/20 03:02:05 INFO  : potato3: Moved (server-side)
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-xazuzag6diqu: ls -R ./
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-xazuzag6diqu: OBJ ls -R ./ ("rclone-test-xazuzag6diqu", "")
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-vafahav1kedo: ls -R ./
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-vafahav1kedo: OBJ ls -R ./ ("rclone-test-vafahav1kedo", "")
2024/11/20 03:02:05 DEBUG : Creating backend with remote "TestStorj:rclone-test-kunoled2kamo"
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-kunoled2kamo: connecting...
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-kunoled2kamo: connected: <nil>
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-kunoled2kamo: ls ./
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-kunoled2kamo: OBJ ls ./ ("rclone-test-kunoled2kamo", "")
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-kunoled2kamo: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-vafahav1kedo: ls ./
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-vafahav1kedo: OBJ ls ./ ("rclone-test-vafahav1kedo", "")
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-vafahav1kedo: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/11/20 03:02:05 DEBUG : empty space: Excluded (Size Filter)
2024/11/20 03:02:05 DEBUG : empty space: Excluded
2024/11/20 03:02:05 DEBUG : potato2: Need to transfer - File not found at Destination
2024/11/20 03:02:05 DEBUG : potato3: Need to transfer - File not found at Destination
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-kunoled2kamo: Waiting for checks to finish
2024/11/20 03:02:05 DEBUG : FS sj://rclone-test-kunoled2kamo: Waiting for transfers to finish
2024/11/20 03:02:06 DEBUG : FS sj://rclone-test-kunoled2kamo: stat ./potato3
2024/11/20 03:02:06 INFO  : potato3: Moved (server-side)
2024/11/20 03:02:06 DEBUG : FS sj://rclone-test-kunoled2kamo: stat ./potato2
2024/11/20 03:02:06 INFO  : potato2: Moved (server-side)
2024/11/20 03:02:06 DEBUG : FS sj://rclone-test-kunoled2kamo: ls -R ./
2024/11/20 03:02:06 DEBUG : FS sj://rclone-test-kunoled2kamo: OBJ ls -R ./ ("rclone-test-kunoled2kamo", "")
2024/11/20 03:02:06 DEBUG : FS sj://rclone-test-vafahav1kedo: ls -R ./
2024/11/20 03:02:06 DEBUG : FS sj://rclone-test-vafahav1kedo: OBJ ls -R ./ ("rclone-test-vafahav1kedo", "")
2024/11/20 03:02:07 DEBUG : FS sj://rclone-test-kunoled2kamo: Purge remote
2024/11/20 03:02:07 DEBUG : FS sj://rclone-test-vafahav1kedo: Purge remote
2024/11/20 03:02:08 DEBUG : FS sj://rclone-test-xazuzag6diqu: ls -R ./
2024/11/20 03:02:08 DEBUG : FS sj://rclone-test-xazuzag6diqu: OBJ ls -R ./ ("rclone-test-xazuzag6diqu", "")
2024/11/20 03:02:08 DEBUG : empty space: rm sj://rclone-test-xazuzag6diqu/empty space
2024/11/20 03:02:08 DEBUG : FS sj://rclone-test-xazuzag6diqu: ls -R ./
2024/11/20 03:02:08 DEBUG : FS sj://rclone-test-xazuzag6diqu: OBJ ls -R ./ ("rclone-test-xazuzag6diqu", "")
--- PASS: TestServerSideMoveWithFilter (4.48s)
FAIL
2024/11/20 03:02:08 DEBUG : FS sj://rclone-test-xazuzag6diqu: Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestStorj: -verbose -test.run '^(TestServerSideMove|TestServerSideMoveWithFilter)$'" - Finished ERROR in 10.064671239s (try 2/5): exit status 1: Failed [TestServerSideMove]