"./sync.test -test.v -test.timeout 1h0m0s -remote TestStorj: -verbose -test.run '^(TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveWithFilter)$'" - Starting (try 3/5)
2024/11/12 04:23:46 DEBUG : Creating backend with remote "TestStorj:rclone-test-mebegay1rabe"
2024/11/12 04:23:46 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2024/11/12 04:23:46 DEBUG : FS sj://rclone-test-mebegay1rabe: connecting...
2024/11/12 04:23:46 DEBUG : FS sj://rclone-test-mebegay1rabe: connected: <nil>
2024/11/12 04:23:46 DEBUG : Creating backend with remote "/tmp/rclone534594444"
=== RUN   TestServerSideMoveWithFilter
    run.go:180: Remote "FS sj://rclone-test-mebegay1rabe", Local "Local file system at /tmp/rclone534594444", Modify Window "1ns"
2024/11/12 04:23:46 DEBUG : Creating backend with remote "TestStorj:rclone-test-vubovol0xude"
2024/11/12 04:23:46 DEBUG : FS sj://rclone-test-vubovol0xude: connecting...
2024/11/12 04:23:46 DEBUG : FS sj://rclone-test-vubovol0xude: connected: <nil>
2024/11/12 04:23:46 DEBUG : FS sj://rclone-test-mebegay1rabe: mkdir -p ./
2024/11/12 04:23:47 DEBUG : FS sj://rclone-test-mebegay1rabe: cp input ./potato2 # [] 60
2024/11/12 04:23:47 DEBUG : FS sj://rclone-test-mebegay1rabe: cp input ./empty space # [] 1
2024/11/12 04:23:47 DEBUG : FS sj://rclone-test-mebegay1rabe: cp input ./potato3 # [] 68
2024/11/12 04:23:47 DEBUG : FS sj://rclone-test-mebegay1rabe: ls -R ./
2024/11/12 04:23:47 DEBUG : FS sj://rclone-test-mebegay1rabe: OBJ ls -R ./ ("rclone-test-mebegay1rabe", "")
    sync_test.go:1705: Server side move (if possible) FS sj://rclone-test-mebegay1rabe -> FS sj://rclone-test-vubovol0xude
2024/11/12 04:23:47 DEBUG : FS sj://rclone-test-vubovol0xude: mkdir -p ./
2024/11/12 04:23:48 DEBUG : FS sj://rclone-test-vubovol0xude: cp input ./empty space # [] 1
2024/11/12 04:23:48 DEBUG : FS sj://rclone-test-vubovol0xude: cp input ./potato3 # [] 60
2024/11/12 04:23:48 DEBUG : FS sj://rclone-test-vubovol0xude: ls -R ./
2024/11/12 04:23:48 DEBUG : FS sj://rclone-test-vubovol0xude: OBJ ls -R ./ ("rclone-test-vubovol0xude", "")
2024/11/12 04:23:48 DEBUG : FS sj://rclone-test-vubovol0xude: ls ./
2024/11/12 04:23:48 DEBUG : FS sj://rclone-test-vubovol0xude: OBJ ls ./ ("rclone-test-vubovol0xude", "")
2024/11/12 04:23:48 DEBUG : FS sj://rclone-test-vubovol0xude: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/11/12 04:23:48 DEBUG : FS sj://rclone-test-mebegay1rabe: ls ./
2024/11/12 04:23:48 DEBUG : FS sj://rclone-test-mebegay1rabe: OBJ ls ./ ("rclone-test-mebegay1rabe", "")
2024/11/12 04:23:48 DEBUG : FS sj://rclone-test-mebegay1rabe: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/11/12 04:23:48 DEBUG : empty space: Excluded (Size Filter)
2024/11/12 04:23:48 DEBUG : empty space: Excluded
2024/11/12 04:23:48 DEBUG : empty space: Excluded (Size Filter)
2024/11/12 04:23:48 DEBUG : empty space: Excluded
2024/11/12 04:23:48 DEBUG : potato2: Need to transfer - File not found at Destination
2024/11/12 04:23:48 DEBUG : potato3: Sizes differ (src 68 vs dst 60)
2024/11/12 04:23:48 DEBUG : FS sj://rclone-test-vubovol0xude: Waiting for checks to finish
2024/11/12 04:23:48 DEBUG : potato3: rm sj://rclone-test-vubovol0xude/potato3
2024/11/12 04:23:48 DEBUG : FS sj://rclone-test-vubovol0xude: Waiting for transfers to finish
2024/11/12 04:23:49 DEBUG : FS sj://rclone-test-vubovol0xude: stat ./potato2
2024/11/12 04:23:49 INFO  : potato2: Moved (server-side)
2024/11/12 04:23:49 INFO  : potato3: Deleted
2024/11/12 04:23:49 DEBUG : FS sj://rclone-test-vubovol0xude: stat ./potato3
2024/11/12 04:23:49 INFO  : potato3: Moved (server-side)
2024/11/12 04:23:49 DEBUG : FS sj://rclone-test-mebegay1rabe: ls -R ./
2024/11/12 04:23:49 DEBUG : FS sj://rclone-test-mebegay1rabe: OBJ ls -R ./ ("rclone-test-mebegay1rabe", "")
2024/11/12 04:23:49 DEBUG : FS sj://rclone-test-vubovol0xude: ls -R ./
2024/11/12 04:23:49 DEBUG : FS sj://rclone-test-vubovol0xude: OBJ ls -R ./ ("rclone-test-vubovol0xude", "")
2024/11/12 04:23:49 DEBUG : Creating backend with remote "TestStorj:rclone-test-vijahux1nowu"
2024/11/12 04:23:49 DEBUG : FS sj://rclone-test-vijahux1nowu: connecting...
2024/11/12 04:23:49 DEBUG : FS sj://rclone-test-vijahux1nowu: connected: <nil>
2024/11/12 04:23:49 DEBUG : FS sj://rclone-test-vijahux1nowu: ls ./
2024/11/12 04:23:49 DEBUG : FS sj://rclone-test-vijahux1nowu: OBJ ls ./ ("rclone-test-vijahux1nowu", "")
2024/11/12 04:23:49 DEBUG : FS sj://rclone-test-vijahux1nowu: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/11/12 04:23:49 DEBUG : FS sj://rclone-test-vubovol0xude: ls ./
2024/11/12 04:23:49 DEBUG : FS sj://rclone-test-vubovol0xude: OBJ ls ./ ("rclone-test-vubovol0xude", "")
2024/11/12 04:23:49 DEBUG : FS sj://rclone-test-vubovol0xude: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/11/12 04:23:49 DEBUG : empty space: Excluded (Size Filter)
2024/11/12 04:23:49 DEBUG : empty space: Excluded
2024/11/12 04:23:49 DEBUG : potato2: Need to transfer - File not found at Destination
2024/11/12 04:23:49 DEBUG : potato3: Need to transfer - File not found at Destination
2024/11/12 04:23:49 DEBUG : FS sj://rclone-test-vijahux1nowu: Waiting for checks to finish
2024/11/12 04:23:49 DEBUG : FS sj://rclone-test-vijahux1nowu: Waiting for transfers to finish
2024/11/12 04:23:49 ERROR : potato3: Couldn't move: rename object failed: uplink: bucket not found ("rclone-test-vijahux1nowu")
2024/11/12 04:23:50 DEBUG : FS sj://rclone-test-vijahux1nowu: stat ./potato2
2024/11/12 04:23:50 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-vijahux1nowu")
        	Test:       	TestServerSideMoveWithFilter
2024/11/12 04:23:50 DEBUG : FS sj://rclone-test-vijahux1nowu: Purge remote
2024/11/12 04:23:50 DEBUG : FS sj://rclone-test-vubovol0xude: Purge remote
2024/11/12 04:23:51 DEBUG : FS sj://rclone-test-mebegay1rabe: ls -R ./
2024/11/12 04:23:51 DEBUG : FS sj://rclone-test-mebegay1rabe: OBJ ls -R ./ ("rclone-test-mebegay1rabe", "")
2024/11/12 04:23:51 DEBUG : empty space: rm sj://rclone-test-mebegay1rabe/empty space
2024/11/12 04:23:51 DEBUG : FS sj://rclone-test-mebegay1rabe: ls -R ./
2024/11/12 04:23:51 DEBUG : FS sj://rclone-test-mebegay1rabe: OBJ ls -R ./ ("rclone-test-mebegay1rabe", "")
--- FAIL: TestServerSideMoveWithFilter (5.15s)
=== RUN   TestServerSideMoveDeleteEmptySourceDirs
    run.go:180: Remote "FS sj://rclone-test-mebegay1rabe", Local "Local file system at /tmp/rclone534594444", Modify Window "1ns"
2024/11/12 04:23:51 DEBUG : Creating backend with remote "TestStorj:rclone-test-leyirib9vecu"
2024/11/12 04:23:51 DEBUG : FS sj://rclone-test-leyirib9vecu: connecting...
2024/11/12 04:23:51 DEBUG : FS sj://rclone-test-leyirib9vecu: connected: <nil>
2024/11/12 04:23:51 DEBUG : FS sj://rclone-test-mebegay1rabe: cp input ./potato2 # [] 60
2024/11/12 04:23:51 DEBUG : FS sj://rclone-test-mebegay1rabe: cp input ./empty space # [] 1
2024/11/12 04:23:51 DEBUG : FS sj://rclone-test-mebegay1rabe: cp input ./potato3 # [] 68
2024/11/12 04:23:51 DEBUG : tomatoDir: Making directory
2024/11/12 04:23:51 DEBUG : FS sj://rclone-test-mebegay1rabe: mkdir -p ./tomatoDir
2024/11/12 04:23:51 DEBUG : FS sj://rclone-test-mebegay1rabe: ls -R ./
2024/11/12 04:23:51 DEBUG : FS sj://rclone-test-mebegay1rabe: OBJ ls -R ./ ("rclone-test-mebegay1rabe", "")
    sync_test.go:1705: Server side move (if possible) FS sj://rclone-test-mebegay1rabe -> FS sj://rclone-test-leyirib9vecu
2024/11/12 04:23:52 DEBUG : FS sj://rclone-test-leyirib9vecu: mkdir -p ./
2024/11/12 04:23:52 DEBUG : FS sj://rclone-test-leyirib9vecu: cp input ./empty space # [] 1
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-leyirib9vecu: cp input ./potato3 # [] 60
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-leyirib9vecu: ls -R ./
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-leyirib9vecu: OBJ ls -R ./ ("rclone-test-leyirib9vecu", "")
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-leyirib9vecu: ls ./
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-leyirib9vecu: OBJ ls ./ ("rclone-test-leyirib9vecu", "")
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-leyirib9vecu: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-mebegay1rabe: ls ./
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-mebegay1rabe: OBJ ls ./ ("rclone-test-mebegay1rabe", "")
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-mebegay1rabe: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/11/12 04:23:53 DEBUG : potato2: Need to transfer - File not found at Destination
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-leyirib9vecu: Waiting for checks to finish
2024/11/12 04:23:53 DEBUG : empty space: Size and modification time the same (differ by 0s, within tolerance 1ns)
2024/11/12 04:23:53 DEBUG : empty space: Unchanged skipping
2024/11/12 04:23:53 DEBUG : empty space: rm sj://rclone-test-mebegay1rabe/empty space
2024/11/12 04:23:53 DEBUG : potato3: Sizes differ (src 68 vs dst 60)
2024/11/12 04:23:53 DEBUG : potato3: rm sj://rclone-test-leyirib9vecu/potato3
2024/11/12 04:23:53 INFO  : empty space: Deleted
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-leyirib9vecu: Waiting for transfers to finish
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-leyirib9vecu: stat ./potato2
2024/11/12 04:23:53 INFO  : potato3: Deleted
2024/11/12 04:23:53 INFO  : potato2: Moved (server-side)
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-leyirib9vecu: stat ./potato3
2024/11/12 04:23:53 INFO  : potato3: Moved (server-side)
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-mebegay1rabe: ls -R ./
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-mebegay1rabe: OBJ ls -R ./ ("rclone-test-mebegay1rabe", "")
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-mebegay1rabe: ls -R ./
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-mebegay1rabe: OBJ ls -R ./ ("rclone-test-mebegay1rabe", "")
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-leyirib9vecu: ls -R ./
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-leyirib9vecu: OBJ ls -R ./ ("rclone-test-leyirib9vecu", "")
2024/11/12 04:23:53 DEBUG : Creating backend with remote "TestStorj:rclone-test-qotelal3zaxi"
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-qotelal3zaxi: connecting...
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-qotelal3zaxi: connected: <nil>
2024/11/12 04:23:53 DEBUG : tomatoDir: Making directory
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-leyirib9vecu: mkdir -p ./tomatoDir
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-qotelal3zaxi: ls ./
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-qotelal3zaxi: OBJ ls ./ ("rclone-test-qotelal3zaxi", "")
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-qotelal3zaxi: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-leyirib9vecu: ls ./
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-leyirib9vecu: OBJ ls ./ ("rclone-test-leyirib9vecu", "")
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-leyirib9vecu: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2024/11/12 04:23:53 DEBUG : empty space: Need to transfer - File not found at Destination
2024/11/12 04:23:53 DEBUG : potato2: Need to transfer - File not found at Destination
2024/11/12 04:23:53 DEBUG : potato3: Need to transfer - File not found at Destination
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-qotelal3zaxi: Waiting for checks to finish
2024/11/12 04:23:53 DEBUG : FS sj://rclone-test-qotelal3zaxi: Waiting for transfers to finish
2024/11/12 04:23:54 DEBUG : FS sj://rclone-test-qotelal3zaxi: stat ./potato2
2024/11/12 04:23:54 INFO  : potato2: Moved (server-side)
2024/11/12 04:23:54 DEBUG : FS sj://rclone-test-qotelal3zaxi: stat ./potato3
2024/11/12 04:23:54 INFO  : potato3: Moved (server-side)
2024/11/12 04:23:54 DEBUG : FS sj://rclone-test-qotelal3zaxi: stat ./empty space
2024/11/12 04:23:54 INFO  : empty space: Moved (server-side)
2024/11/12 04:23:54 DEBUG : FS sj://rclone-test-qotelal3zaxi: ls -R ./
2024/11/12 04:23:54 DEBUG : FS sj://rclone-test-qotelal3zaxi: OBJ ls -R ./ ("rclone-test-qotelal3zaxi", "")
2024/11/12 04:23:54 DEBUG : FS sj://rclone-test-leyirib9vecu: ls -R ./
2024/11/12 04:23:54 DEBUG : FS sj://rclone-test-leyirib9vecu: OBJ ls -R ./ ("rclone-test-leyirib9vecu", "")
2024/11/12 04:23:54 DEBUG : FS sj://rclone-test-leyirib9vecu: ls -R ./
2024/11/12 04:23:54 DEBUG : FS sj://rclone-test-leyirib9vecu: OBJ ls -R ./ ("rclone-test-leyirib9vecu", "")
2024/11/12 04:23:54 DEBUG : FS sj://rclone-test-qotelal3zaxi: Purge remote
2024/11/12 04:23:55 DEBUG : FS sj://rclone-test-leyirib9vecu: Purge remote
2024/11/12 04:23:55 DEBUG : FS sj://rclone-test-mebegay1rabe: ls -R ./
2024/11/12 04:23:55 DEBUG : FS sj://rclone-test-mebegay1rabe: OBJ ls -R ./ ("rclone-test-mebegay1rabe", "")
2024/11/12 04:23:55 DEBUG : FS sj://rclone-test-mebegay1rabe: ls -R ./
2024/11/12 04:23:55 DEBUG : FS sj://rclone-test-mebegay1rabe: OBJ ls -R ./ ("rclone-test-mebegay1rabe", "")
--- PASS: TestServerSideMoveDeleteEmptySourceDirs (4.19s)
FAIL
2024/11/12 04:23:55 DEBUG : FS sj://rclone-test-mebegay1rabe: Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestStorj: -verbose -test.run '^(TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveWithFilter)$'" - Finished ERROR in 9.932035359s (try 3/5): exit status 1: Failed [TestServerSideMoveWithFilter]