"./sync.test -test.v -test.timeout 1h0m0s -remote TestStorj: -verbose -test.run '^TestServerSideCopy$'" - Starting (try 2/5)
2026/04/30 01:38:47 DEBUG : Creating backend with remote "TestStorj:rclone-test-yalanib0haxi"
2026/04/30 01:38:47 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/04/30 01:38:47 DEBUG : FS sj://rclone-test-yalanib0haxi: connecting...
2026/04/30 01:38:47 DEBUG : FS sj://rclone-test-yalanib0haxi: connected: <nil>
2026/04/30 01:38:47 DEBUG : Creating backend with remote "/tmp/rclone1829701224"
=== RUN   TestServerSideCopy
    run.go:185: Remote "FS sj://rclone-test-yalanib0haxi", Local "Local file system at /tmp/rclone1829701224", Modify Window "1ns"
2026/04/30 01:38:47 DEBUG : FS sj://rclone-test-yalanib0haxi: mkdir -p ./
2026/04/30 01:38:47 DEBUG : FS sj://rclone-test-yalanib0haxi: cp input ./sub dir/hello world # [] 11
2026/04/30 01:38:47 DEBUG : FS sj://rclone-test-yalanib0haxi: ls -R ./
2026/04/30 01:38:47 DEBUG : FS sj://rclone-test-yalanib0haxi: OBJ ls -R ./ ("rclone-test-yalanib0haxi", "")
2026/04/30 01:38:47 DEBUG : Creating backend with remote "TestStorj:rclone-test-celojob7lape"
2026/04/30 01:38:47 DEBUG : FS sj://rclone-test-celojob7lape: connecting...
2026/04/30 01:38:47 DEBUG : FS sj://rclone-test-celojob7lape: connected: <nil>
    sync_test.go:620: Server side copy (if possible) FS sj://rclone-test-yalanib0haxi -> FS sj://rclone-test-celojob7lape
2026/04/30 01:38:47 DEBUG : FS sj://rclone-test-celojob7lape: ls ./
2026/04/30 01:38:47 DEBUG : FS sj://rclone-test-celojob7lape: OBJ ls ./ ("rclone-test-celojob7lape", "")
2026/04/30 01:38:47 DEBUG : FS sj://rclone-test-celojob7lape: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2026/04/30 01:38:47 DEBUG : FS sj://rclone-test-yalanib0haxi: ls ./
2026/04/30 01:38:47 DEBUG : FS sj://rclone-test-yalanib0haxi: OBJ ls ./ ("rclone-test-yalanib0haxi", "")
2026/04/30 01:38:47 DEBUG : FS sj://rclone-test-yalanib0haxi: opts &{Prefix: Cursor: Recursive:false System:true Custom:true}
2026/04/30 01:38:48 DEBUG : FS sj://rclone-test-yalanib0haxi: ls ./sub dir
2026/04/30 01:38:48 DEBUG : FS sj://rclone-test-yalanib0haxi: OBJ ls ./sub dir ("rclone-test-yalanib0haxi", "sub dir")
2026/04/30 01:38:48 DEBUG : FS sj://rclone-test-yalanib0haxi: opts &{Prefix:sub dir/ Cursor: Recursive:false System:true Custom:true}
2026/04/30 01:38:48 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination
2026/04/30 01:38:48 DEBUG : FS sj://rclone-test-celojob7lape: Waiting for checks to finish
2026/04/30 01:38:48 DEBUG : FS sj://rclone-test-celojob7lape: Waiting for transfers to finish
2026/04/30 01:38:48 DEBUG : sub dir/hello world: size = 11 OK
2026/04/30 01:38:48 INFO  : sub dir/hello world: Copied (server-side copy)
2026/04/30 01:38:48 DEBUG : FS sj://rclone-test-celojob7lape: ls -R ./
2026/04/30 01:38:48 DEBUG : FS sj://rclone-test-celojob7lape: OBJ ls -R ./ ("rclone-test-celojob7lape", "")
2026/04/30 01:38:48 DEBUG : FS sj://rclone-test-celojob7lape: Purge remote
2026/04/30 01:38:48 DEBUG : FS sj://rclone-test-yalanib0haxi: ls -R ./
2026/04/30 01:38:48 DEBUG : FS sj://rclone-test-yalanib0haxi: OBJ ls -R ./ ("rclone-test-yalanib0haxi", "")
2026/04/30 01:38:48 DEBUG : sub dir/hello world: rm sj://rclone-test-yalanib0haxi/sub dir/hello world
2026/04/30 01:38:48 DEBUG : FS sj://rclone-test-yalanib0haxi: rmdir ./sub dir
2026/04/30 01:38:48 DEBUG : FS sj://rclone-test-yalanib0haxi: ls -R ./
2026/04/30 01:38:48 DEBUG : FS sj://rclone-test-yalanib0haxi: OBJ ls -R ./ ("rclone-test-yalanib0haxi", "")
--- PASS: TestServerSideCopy (1.07s)
PASS
2026/04/30 01:38:48 DEBUG : FS sj://rclone-test-yalanib0haxi: Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestStorj: -verbose -test.run '^TestServerSideCopy$'" - Finished OK in 1.162281918s (try 2/5)