"./sync.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestCopyOverSelf|TestServerSideMove|TestSyncAfterChangingContentsOnly|TestSyncAfterChangingFilesSizeOnly|TestSyncIgnoreErrors)$'" - Starting (try 5/5) 2026/05/09 03:19:56 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-bedutuc2qogo" 2026/05/09 03:19:56 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/05/09 03:19:56 DEBUG : Linkbox root 'rclone-test-bedutuc2qogo': Using cached web token 2026/05/09 03:19:56 DEBUG : Creating backend with remote "/tmp/rclone1115863088" === RUN TestCopyOverSelf run.go:198: Remote "Linkbox root 'rclone-test-bedutuc2qogo'", Local "Local file system at /tmp/rclone1115863088", Modify Window "876000h0m0s" 2026/05/09 03:20:01 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/05/09 03:20:01 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 200ms (2/10) 2026/05/09 03:20:03 DEBUG : sub dir/hello world: size = 17 (Local file system at /tmp/rclone1115863088) 2026/05/09 03:20:03 DEBUG : Linkbox root 'rclone-test-bedutuc2qogo': Waiting for checks to finish 2026/05/09 03:20:03 DEBUG : sub dir/hello world: size = 11 (Linkbox root 'rclone-test-bedutuc2qogo') 2026/05/09 03:20:03 DEBUG : sub dir/hello world: Sizes differ 2026/05/09 03:20:03 DEBUG : Linkbox root 'rclone-test-bedutuc2qogo': Waiting for transfers to finish 2026/05/09 03:20:03 DEBUG : sub dir/hello world: Update: removing old file 2026/05/09 03:20:06 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/05/09 03:20:06 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 200ms (2/10) 2026/05/09 03:20:07 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 400ms (3/10) 2026/05/09 03:20:07 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 800ms (4/10) 2026/05/09 03:20:08 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 1.6s (5/10) 2026/05/09 03:20:10 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 3.2s (6/10) 2026/05/09 03:20:13 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 6.4s (7/10) 2026/05/09 03:20:20 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 12.8s (8/10) 2026/05/09 03:20:33 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 25.6s (9/10) 2026/05/09 03:20:59 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 51.2s (10/10) 2026/05/09 03:21:50 ERROR : sub dir/hello world: Failed to copy: object not found sync_test.go:641: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:641 Error: Received unexpected error: object not found Test: TestCopyOverSelf run.go:186: removing dir "sub dir" failed - try 1/3: sleeping 1s: directory not empty --- FAIL: TestCopyOverSelf (118.50s) === RUN TestSyncIgnoreErrors run.go:198: Remote "Linkbox root 'rclone-test-bedutuc2qogo'", Local "Local file system at /tmp/rclone1115863088", Modify Window "876000h0m0s" 2026/05/09 03:21:58 DEBUG : b/potato: Trying to read object after upload: try again in 100ms (1/10) 2026/05/09 03:21:58 DEBUG : b/potato: Trying to read object after upload: try again in 200ms (2/10) 2026/05/09 03:22:02 DEBUG : c/non empty space: Trying to read object after upload: try again in 100ms (1/10) 2026/05/09 03:22:03 DEBUG : c/non empty space: Trying to read object after upload: try again in 200ms (2/10) 2026/05/09 03:22:03 DEBUG : c/non empty space: Trying to read object after upload: try again in 400ms (3/10) 2026/05/09 03:22:04 INFO : d: Making directory 2026/05/09 03:22:06 DEBUG : a/potato2: Need to transfer - File not found at Destination 2026/05/09 03:22:08 DEBUG : c/non empty space: size = 5 OK 2026/05/09 03:22:08 DEBUG : c/non empty space: Sizes identical 2026/05/09 03:22:08 DEBUG : Linkbox root 'rclone-test-bedutuc2qogo': Waiting for checks to finish 2026/05/09 03:22:08 DEBUG : c/non empty space: Unchanged skipping 2026/05/09 03:22:08 DEBUG : Linkbox root 'rclone-test-bedutuc2qogo': Waiting for transfers to finish 2026/05/09 03:22:10 DEBUG : a/potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/05/09 03:22:11 DEBUG : a/potato2: size = 60 OK 2026/05/09 03:22:11 INFO : a/potato2: Copied (new) 2026/05/09 03:22:11 DEBUG : Waiting for deletions to finish 2026/05/09 03:22:12 INFO : b/potato: Deleted 2026/05/09 03:22:12 INFO : d: Removing directory 2026/05/09 03:22:13 INFO : b: Removing directory 2026/05/09 03:22:15 DEBUG : Linkbox root 'rclone-test-bedutuc2qogo': deleted 2 directories --- PASS: TestSyncIgnoreErrors (27.26s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:198: Remote "Linkbox root 'rclone-test-bedutuc2qogo'", Local "Local file system at /tmp/rclone1115863088", Modify Window "876000h0m0s" 2026/05/09 03:22:24 DEBUG : potato: size = 21 (Local file system at /tmp/rclone1115863088) 2026/05/09 03:22:24 DEBUG : potato: size = 60 (Linkbox root 'rclone-test-bedutuc2qogo') 2026/05/09 03:22:24 DEBUG : potato: Sizes differ 2026/05/09 03:22:24 DEBUG : Linkbox root 'rclone-test-bedutuc2qogo': Waiting for checks to finish 2026/05/09 03:22:24 DEBUG : potato: Update: removing old file 2026/05/09 03:22:24 DEBUG : Linkbox root 'rclone-test-bedutuc2qogo': Waiting for transfers to finish 2026/05/09 03:22:27 DEBUG : potato: Trying to read object after upload: try again in 100ms (1/10) 2026/05/09 03:22:28 DEBUG : potato: Trying to read object after upload: try again in 200ms (2/10) 2026/05/09 03:22:28 DEBUG : potato: size = 21 OK 2026/05/09 03:22:28 INFO : potato: Copied (replaced existing) 2026/05/09 03:22:28 DEBUG : Waiting for deletions to finish fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure --- PASS: TestSyncAfterChangingFilesSizeOnly (15.37s) === RUN TestSyncAfterChangingContentsOnly run.go:198: Remote "Linkbox root 'rclone-test-bedutuc2qogo'", Local "Local file system at /tmp/rclone1115863088", Modify Window "876000h0m0s" sync_test.go:1136: ModTimeNotSupported so forcing file to be a different size 2026/05/09 03:22:39 DEBUG : potato: Trying to read object after upload: try again in 100ms (1/10) 2026/05/09 03:22:39 DEBUG : potato: Trying to read object after upload: try again in 200ms (2/10) fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:292: Sleeping for 6s just to make sure 2026/05/09 03:22:48 DEBUG : Linkbox root 'rclone-test-bedutuc2qogo': Waiting for checks to finish 2026/05/09 03:22:48 DEBUG : potato: size = 21 (Local file system at /tmp/rclone1115863088) 2026/05/09 03:22:48 DEBUG : potato: size = 36 (Linkbox root 'rclone-test-bedutuc2qogo') 2026/05/09 03:22:48 DEBUG : potato: Sizes differ 2026/05/09 03:22:48 DEBUG : Linkbox root 'rclone-test-bedutuc2qogo': Waiting for transfers to finish 2026/05/09 03:22:48 DEBUG : potato: Update: removing old file 2026/05/09 03:22:51 DEBUG : potato: Trying to read object after upload: try again in 100ms (1/10) 2026/05/09 03:22:51 DEBUG : potato: Trying to read object after upload: try again in 200ms (2/10) 2026/05/09 03:22:51 DEBUG : potato: Trying to read object after upload: try again in 400ms (3/10) 2026/05/09 03:22:52 DEBUG : potato: Trying to read object after upload: try again in 800ms (4/10) 2026/05/09 03:22:53 DEBUG : potato: Trying to read object after upload: try again in 1.6s (5/10) 2026/05/09 03:22:55 DEBUG : potato: Trying to read object after upload: try again in 3.2s (6/10) 2026/05/09 03:22:58 DEBUG : potato: Trying to read object after upload: try again in 6.4s (7/10) 2026/05/09 03:23:05 DEBUG : potato: Trying to read object after upload: try again in 12.8s (8/10) 2026/05/09 03:23:18 DEBUG : potato: Trying to read object after upload: try again in 25.6s (9/10) 2026/05/09 03:23:44 DEBUG : potato: Trying to read object after upload: try again in 51.2s (10/10) 2026/05/09 03:24:35 ERROR : potato: Failed to copy: object not found 2026/05/09 03:24:35 ERROR : Linkbox root 'rclone-test-bedutuc2qogo': not deleting files as there were IO errors 2026/05/09 03:24:35 ERROR : Linkbox root 'rclone-test-bedutuc2qogo': not deleting directories as there were IO errors sync_test.go:1148: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1148 Error: Received unexpected error: object not found Test: TestSyncAfterChangingContentsOnly --- FAIL: TestSyncAfterChangingContentsOnly (119.22s) === RUN TestServerSideMove run.go:198: Remote "Linkbox root 'rclone-test-bedutuc2qogo'", Local "Local file system at /tmp/rclone1115863088", Modify Window "876000h0m0s" 2026/05/09 03:24:36 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-nucevuq1qilu" 2026/05/09 03:24:36 DEBUG : Config file has changed externally - reloading 2026/05/09 03:24:36 DEBUG : Linkbox root 'rclone-test-nucevuq1qilu': Using cached web token sync_test.go:1736: Server side move (if possible) Linkbox root 'rclone-test-bedutuc2qogo' -> Linkbox root 'rclone-test-nucevuq1qilu' 2026/05/09 03:24:49 DEBUG : potato2: Need to transfer - File not found at Destination 2026/05/09 03:24:49 DEBUG : empty space: size = 1 OK 2026/05/09 03:24:49 DEBUG : empty space: Sizes identical 2026/05/09 03:24:49 DEBUG : empty space: Unchanged skipping 2026/05/09 03:24:49 DEBUG : potato3: size = 68 (Linkbox root 'rclone-test-bedutuc2qogo') 2026/05/09 03:24:49 DEBUG : potato3: size = 60 (Linkbox root 'rclone-test-nucevuq1qilu') 2026/05/09 03:24:49 DEBUG : potato3: Sizes differ 2026/05/09 03:24:49 DEBUG : Linkbox root 'rclone-test-nucevuq1qilu': Waiting for checks to finish 2026/05/09 03:24:49 NOTICE: Time may be set wrong - time from "aht.nuplink3.net" is 239h50m5.663969066s different from this computer 2026/05/09 03:24:49 DEBUG : potato3: Update: removing old file 2026/05/09 03:24:50 INFO : empty space: Deleted 2026/05/09 03:24:50 DEBUG : Linkbox root 'rclone-test-nucevuq1qilu': Waiting for transfers to finish 2026/05/09 03:24:51 DEBUG : potato2: size = 60 OK 2026/05/09 03:24:51 INFO : potato2: Copied (new) 2026/05/09 03:24:53 DEBUG : potato3: size = 68 OK 2026/05/09 03:24:53 INFO : potato3: Copied (replaced existing) 2026/05/09 03:24:53 INFO : potato2: Deleted 2026/05/09 03:24:54 INFO : potato3: Deleted 2026/05/09 03:24:54 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-vepixok8pefo" 2026/05/09 03:24:54 DEBUG : Linkbox root 'rclone-test-vepixok8pefo': Using cached web token 2026/05/09 03:24:55 DEBUG : empty space: Need to transfer - File not found at Destination 2026/05/09 03:24:55 DEBUG : potato2: Need to transfer - File not found at Destination 2026/05/09 03:24:55 DEBUG : potato3: Need to transfer - File not found at Destination 2026/05/09 03:24:55 DEBUG : Linkbox root 'rclone-test-vepixok8pefo': Waiting for checks to finish 2026/05/09 03:24:55 DEBUG : Linkbox root 'rclone-test-vepixok8pefo': Waiting for transfers to finish 2026/05/09 03:24:59 DEBUG : empty space: size = 1 OK 2026/05/09 03:24:59 INFO : empty space: Copied (new) 2026/05/09 03:25:00 DEBUG : potato2: size = 60 OK 2026/05/09 03:25:00 INFO : potato2: Copied (new) 2026/05/09 03:25:00 DEBUG : potato3: size = 68 OK 2026/05/09 03:25:00 INFO : potato3: Copied (new) 2026/05/09 03:25:01 INFO : empty space: Deleted 2026/05/09 03:25:01 INFO : potato2: Deleted 2026/05/09 03:25:01 INFO : potato3: Deleted 2026/05/09 03:25:01 DEBUG : Linkbox root 'rclone-test-vepixok8pefo': Purge remote 2026/05/09 03:25:03 DEBUG : Linkbox root 'rclone-test-nucevuq1qilu': Purge remote --- PASS: TestServerSideMove (28.07s) FAIL 2026/05/09 03:25:05 DEBUG : Linkbox root 'rclone-test-bedutuc2qogo': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestCopyOverSelf|TestServerSideMove|TestSyncAfterChangingContentsOnly|TestSyncAfterChangingFilesSizeOnly|TestSyncIgnoreErrors)$'" - Finished ERROR in 5m10.289959394s (try 5/5): exit status 1: Failed [TestCopyOverSelf TestSyncAfterChangingContentsOnly]