"./sync.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestMoveWithoutDeleteEmptySrcDirs|TestServerSideCopyOverSelf|TestSyncAfterChangingFilesSizeOnly|TestSyncIgnoreTimes|TestSyncWithExcludeAndDeleteExcluded)$'" - Starting (try 5/5) 2026/05/04 04:13:41 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-qananek3cuqu" 2026/05/04 04:13:41 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/05/04 04:13:41 DEBUG : Linkbox root 'rclone-test-qananek3cuqu': Using cached web token 2026/05/04 04:13:42 DEBUG : Creating backend with remote "/tmp/rclone2159961775" === RUN TestServerSideCopyOverSelf run.go:185: Remote "Linkbox root 'rclone-test-qananek3cuqu'", Local "Local file system at /tmp/rclone2159961775", Modify Window "876000h0m0s" 2026/05/04 04:13:46 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/05/04 04:13:47 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 200ms (2/10) 2026/05/04 04:13:48 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-meyuwak2daba" 2026/05/04 04:13:48 DEBUG : Linkbox root 'rclone-test-meyuwak2daba': Using cached web token sync_test.go:656: Server side copy (if possible) Linkbox root 'rclone-test-qananek3cuqu' -> Linkbox root 'rclone-test-meyuwak2daba' 2026/05/04 04:13:49 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/05/04 04:13:49 DEBUG : Linkbox root 'rclone-test-meyuwak2daba': Waiting for checks to finish 2026/05/04 04:13:49 DEBUG : Linkbox root 'rclone-test-meyuwak2daba': Waiting for transfers to finish 2026/05/04 04:13:49 NOTICE: Time may be set wrong - time from "aht.nuplink3.net" is 97h29m56.145676577s different from this computer 2026/05/04 04:13:54 DEBUG : sub dir/hello world: size = 11 OK 2026/05/04 04:13:54 INFO : sub dir/hello world: Copied (new) 2026/05/04 04:13:54 DEBUG : sub dir/hello world: Update: removing old file 2026/05/04 04:13:57 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/05/04 04:13:58 DEBUG : Linkbox root 'rclone-test-meyuwak2daba': Waiting for checks to finish 2026/05/04 04:13:58 DEBUG : sub dir/hello world: size = 17 (Linkbox root 'rclone-test-qananek3cuqu') 2026/05/04 04:13:58 DEBUG : sub dir/hello world: size = 11 (Linkbox root 'rclone-test-meyuwak2daba') 2026/05/04 04:13:58 DEBUG : sub dir/hello world: Sizes differ 2026/05/04 04:13:58 DEBUG : Linkbox root 'rclone-test-meyuwak2daba': Waiting for transfers to finish 2026/05/04 04:13:58 DEBUG : sub dir/hello world: Update: removing old file 2026/05/04 04:14:02 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/05/04 04:14:02 DEBUG : sub dir/hello world: size = 17 OK 2026/05/04 04:14:02 INFO : sub dir/hello world: Copied (replaced existing) 2026/05/04 04:14:03 DEBUG : Linkbox root 'rclone-test-meyuwak2daba': Purge remote run.go:130: removing dir "sub dir" failed - try 1/3: directory not empty run.go:130: removing dir "sub dir" failed - try 2/3: directory not empty --- PASS: TestServerSideCopyOverSelf (28.13s) === RUN TestSyncIgnoreTimes run.go:185: Remote "Linkbox root 'rclone-test-qananek3cuqu'", Local "Local file system at /tmp/rclone2159961775", Modify Window "876000h0m0s" 2026/05/04 04:14:12 DEBUG : existing: Trying to read object after upload: try again in 100ms (1/10) 2026/05/04 04:14:12 DEBUG : existing: Trying to read object after upload: try again in 200ms (2/10) 2026/05/04 04:14:13 DEBUG : existing: size = 6 OK 2026/05/04 04:14:13 DEBUG : existing: Sizes identical 2026/05/04 04:14:13 DEBUG : Linkbox root 'rclone-test-qananek3cuqu': Waiting for checks to finish 2026/05/04 04:14:13 DEBUG : existing: Unchanged skipping 2026/05/04 04:14:13 DEBUG : Linkbox root 'rclone-test-qananek3cuqu': Waiting for transfers to finish 2026/05/04 04:14:13 DEBUG : Waiting for deletions to finish 2026/05/04 04:14:13 INFO : There was nothing to transfer 2026/05/04 04:14:13 DEBUG : existing: Transferring unconditionally as --ignore-times is in use 2026/05/04 04:14:13 DEBUG : Linkbox root 'rclone-test-qananek3cuqu': Waiting for checks to finish 2026/05/04 04:14:13 DEBUG : existing: Update: removing old file 2026/05/04 04:14:13 DEBUG : Linkbox root 'rclone-test-qananek3cuqu': Waiting for transfers to finish 2026/05/04 04:14:16 DEBUG : existing: Trying to read object after upload: try again in 100ms (1/10) 2026/05/04 04:14:16 DEBUG : existing: Trying to read object after upload: try again in 200ms (2/10) 2026/05/04 04:14:17 DEBUG : existing: Trying to read object after upload: try again in 400ms (3/10) 2026/05/04 04:14:17 DEBUG : existing: Trying to read object after upload: try again in 800ms (4/10) 2026/05/04 04:14:18 DEBUG : existing: Trying to read object after upload: try again in 1.6s (5/10) 2026/05/04 04:14:20 DEBUG : existing: Trying to read object after upload: try again in 3.2s (6/10) 2026/05/04 04:14:23 DEBUG : existing: Trying to read object after upload: try again in 6.4s (7/10) 2026/05/04 04:14:30 DEBUG : existing: Trying to read object after upload: try again in 12.8s (8/10) 2026/05/04 04:14:43 DEBUG : existing: Trying to read object after upload: try again in 25.6s (9/10) 2026/05/04 04:15:09 DEBUG : existing: Trying to read object after upload: try again in 51.2s (10/10) 2026/05/04 04:16:00 ERROR : existing: Failed to copy: object not found 2026/05/04 04:16:00 ERROR : Linkbox root 'rclone-test-qananek3cuqu': not deleting files as there were IO errors 2026/05/04 04:16:00 ERROR : Linkbox root 'rclone-test-qananek3cuqu': not deleting directories as there were IO errors sync_test.go:905: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:905 Error: Received unexpected error: object not found Test: TestSyncIgnoreTimes --- FAIL: TestSyncIgnoreTimes (112.10s) === RUN TestSyncAfterChangingFilesSizeOnly run.go:185: Remote "Linkbox root 'rclone-test-qananek3cuqu'", Local "Local file system at /tmp/rclone2159961775", Modify Window "876000h0m0s" 2026/05/04 04:16:04 DEBUG : potato: size = 21 (Local file system at /tmp/rclone2159961775) 2026/05/04 04:16:04 DEBUG : potato: size = 60 (Linkbox root 'rclone-test-qananek3cuqu') 2026/05/04 04:16:04 DEBUG : potato: Sizes differ 2026/05/04 04:16:04 DEBUG : potato: Update: removing old file 2026/05/04 04:16:04 DEBUG : Linkbox root 'rclone-test-qananek3cuqu': Waiting for checks to finish 2026/05/04 04:16:04 DEBUG : Linkbox root 'rclone-test-qananek3cuqu': Waiting for transfers to finish 2026/05/04 04:16:07 DEBUG : potato: size = 21 (Local file system at /tmp/rclone2159961775) 2026/05/04 04:16:07 DEBUG : potato: size = 60 (Linkbox root 'rclone-test-qananek3cuqu') 2026/05/04 04:16:07 ERROR : potato: corrupted on transfer: sizes differ src(Local file system at /tmp/rclone2159961775) 21 vs dst(Linkbox root 'rclone-test-qananek3cuqu') 60 2026/05/04 04:16:07 INFO : potato: Removing failed copy 2026/05/04 04:16:08 INFO : potato: Failed to remove failed copy: could not Remove: Linkbox error 403: not permit 2026/05/04 04:16:08 ERROR : Linkbox root 'rclone-test-qananek3cuqu': not deleting files as there were IO errors 2026/05/04 04:16:08 ERROR : Linkbox root 'rclone-test-qananek3cuqu': not deleting directories as there were IO errors sync_test.go:1123: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1123 Error: Received unexpected error: corrupted on transfer: sizes differ src(Local file system at /tmp/rclone2159961775) 21 vs dst(Linkbox root 'rclone-test-qananek3cuqu') 60 Test: TestSyncAfterChangingFilesSizeOnly run.go:130: removing file "potato" failed - try 1/3: could not Remove: Linkbox error 403: not permit run.go:130: removing file "potato" failed - try 2/3: could not Remove: Linkbox error 403: not permit run.go:130: removing file "potato" failed - try 3/3: could not Remove: Linkbox error 403: not permit run.go:133: removing file "potato" failed: could not Remove: Linkbox error 403: not permit fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1123 Error: Should be true Test: TestSyncAfterChangingFilesSizeOnly Messages: listing wrong, want got potato (60) fstest.go:191: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1123 Error: Should be true Test: TestSyncAfterChangingFilesSizeOnly Messages: Unexpected file "potato" --- FAIL: TestSyncAfterChangingFilesSizeOnly (18.98s) === RUN TestSyncWithExcludeAndDeleteExcluded run.go:185: Remote "Linkbox root 'rclone-test-qananek3cuqu'", Local "Local file system at /tmp/rclone2159961775", Modify Window "876000h0m0s" 2026/05/04 04:16:23 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10) 2026/05/04 04:16:23 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10) 2026/05/04 04:16:24 DEBUG : potato2: Trying to read object after upload: try again in 400ms (3/10) 2026/05/04 04:16:28 DEBUG : enormous: Trying to read object after upload: try again in 100ms (1/10) 2026/05/04 04:16:28 DEBUG : enormous: 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:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1422 Error: Should be true Test: TestSyncWithExcludeAndDeleteExcluded Messages: listing wrong, want empty space (1), enormous (100), potato2 (60) got empty space (1), enormous (100), potato (60), potato2 (60) fstest.go:191: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1422 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestSyncWithExcludeAndDeleteExcluded Messages: Unexpected file "potato" 2026/05/04 04:16:37 DEBUG : enormous: Excluded (Size Filter) 2026/05/04 04:16:37 DEBUG : enormous: Excluded 2026/05/04 04:16:37 DEBUG : potato2: Excluded (Size Filter) 2026/05/04 04:16:37 DEBUG : potato2: Excluded 2026/05/04 04:16:37 DEBUG : empty space: size = 1 OK 2026/05/04 04:16:37 DEBUG : empty space: Sizes identical 2026/05/04 04:16:37 DEBUG : Linkbox root 'rclone-test-qananek3cuqu': Waiting for checks to finish 2026/05/04 04:16:37 DEBUG : empty space: Unchanged skipping 2026/05/04 04:16:37 DEBUG : Linkbox root 'rclone-test-qananek3cuqu': Waiting for transfers to finish 2026/05/04 04:16:37 DEBUG : Waiting for deletions to finish 2026/05/04 04:16:38 ERROR : potato: Couldn't delete: could not Remove: Linkbox error 403: not permit 2026/05/04 04:16:39 INFO : enormous: Deleted 2026/05/04 04:16:39 INFO : potato2: Deleted 2026/05/04 04:16:39 ERROR : Linkbox root 'rclone-test-qananek3cuqu': not deleting directories as there were IO errors sync_test.go:1434: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1434 Error: Received unexpected error: failed to delete 1 files Test: TestSyncWithExcludeAndDeleteExcluded run.go:130: removing file "potato" failed - try 1/3: could not Remove: Linkbox error 403: not permit run.go:130: removing file "potato" failed - try 2/3: could not Remove: Linkbox error 403: not permit run.go:130: removing file "potato" failed - try 3/3: could not Remove: Linkbox error 403: not permit run.go:133: removing file "potato" failed: could not Remove: Linkbox error 403: not permit fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1434 Error: Should be true Test: TestSyncWithExcludeAndDeleteExcluded Messages: listing wrong, want got potato (60) fstest.go:191: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 /usr/local/go/src/runtime/panic.go:694 /usr/local/go/src/testing/testing.go:1022 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1434 Error: Should be true Test: TestSyncWithExcludeAndDeleteExcluded Messages: Unexpected file "potato" --- FAIL: TestSyncWithExcludeAndDeleteExcluded (31.28s) === RUN TestMoveWithoutDeleteEmptySrcDirs run.go:185: Remote "Linkbox root 'rclone-test-qananek3cuqu'", Local "Local file system at /tmp/rclone2159961775", Modify Window "876000h0m0s" 2026/05/04 04:16:53 DEBUG : sub dir/hello world: Need to transfer - File not found at Destination 2026/05/04 04:16:53 DEBUG : nested/sub dir/file: Need to transfer - File not found at Destination 2026/05/04 04:16:53 DEBUG : Linkbox root 'rclone-test-qananek3cuqu': Waiting for checks to finish 2026/05/04 04:16:53 DEBUG : Linkbox root 'rclone-test-qananek3cuqu': Waiting for transfers to finish 2026/05/04 04:16:59 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 100ms (1/10) 2026/05/04 04:16:59 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 200ms (2/10) 2026/05/04 04:17:00 DEBUG : nested/sub dir/file: Trying to read object after upload: try again in 100ms (1/10) 2026/05/04 04:17:00 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 400ms (3/10) 2026/05/04 04:17:00 DEBUG : nested/sub dir/file: size = 6 OK 2026/05/04 04:17:00 INFO : nested/sub dir/file: Copied (new) 2026/05/04 04:17:00 INFO : nested/sub dir/file: Deleted 2026/05/04 04:17:00 DEBUG : sub dir/hello world: Trying to read object after upload: try again in 800ms (4/10) 2026/05/04 04:17:01 DEBUG : sub dir/hello world: size = 11 OK 2026/05/04 04:17:01 INFO : sub dir/hello world: Copied (new) 2026/05/04 04:17:01 INFO : sub dir/hello world: Deleted fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1851 Error: Should be true Test: TestMoveWithoutDeleteEmptySrcDirs Messages: listing wrong, want nested/sub dir/file (6), sub dir/hello world (11) got nested/sub dir/file (6), potato (60), sub dir/hello world (11) fstest.go:191: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:350 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:345 /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1851 /usr/local/go/src/runtime/asm_amd64.s:1771 Error: Should be true Test: TestMoveWithoutDeleteEmptySrcDirs Messages: Unexpected file "potato" run.go:130: removing file "potato" failed - try 1/3: could not Remove: Linkbox error 403: not permit run.go:130: removing file "potato" failed - try 2/3: could not Remove: Linkbox error 403: not permit run.go:130: removing file "potato" failed - try 3/3: could not Remove: Linkbox error 403: not permit run.go:133: removing file "potato" failed: could not Remove: Linkbox error 403: not permit fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:305: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 Error: Should be true Test: TestMoveWithoutDeleteEmptySrcDirs Messages: listing wrong, want got potato (60) fstest.go:191: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:178 /home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:393 /usr/local/go/src/testing/testing.go:1317 /usr/local/go/src/testing/testing.go:1667 /usr/local/go/src/testing/testing.go:2030 Error: Should be true Test: TestMoveWithoutDeleteEmptySrcDirs Messages: Unexpected file "potato" --- FAIL: TestMoveWithoutDeleteEmptySrcDirs (39.28s) FAIL 2026/05/04 04:17:31 DEBUG : Linkbox root 'rclone-test-qananek3cuqu': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestMoveWithoutDeleteEmptySrcDirs|TestServerSideCopyOverSelf|TestSyncAfterChangingFilesSizeOnly|TestSyncIgnoreTimes|TestSyncWithExcludeAndDeleteExcluded)$'" - Finished ERROR in 3m51.941415498s (try 5/5): exit status 1: Failed [TestSyncIgnoreTimes TestSyncAfterChangingFilesSizeOnly TestSyncWithExcludeAndDeleteExcluded TestMoveWithoutDeleteEmptySrcDirs]