"./sync.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveWithFilter|TestSyncUTFNorm)$'" - Starting (try 5/5)
2026/08/02 05:28:26 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-nefufez7sigu"
2026/08/02 05:28:26 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/08/02 05:28:26 DEBUG : Linkbox root 'rclone-test-nefufez7sigu': Using cached web token
2026/08/02 05:28:27 DEBUG : Creating backend with remote "/tmp/rclone1976722706"
=== RUN   TestServerSideMove
    run.go:198: Remote "Linkbox root 'rclone-test-nefufez7sigu'", Local "Local file system at /tmp/rclone1976722706", Modify Window "876000h0m0s"
2026/08/02 05:28:27 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-yugeyot4vesi"
2026/08/02 05:28:27 DEBUG : Linkbox root 'rclone-test-yugeyot4vesi': Using cached web token
2026/08/02 05:28:31 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10)
2026/08/02 05:28:36 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10)
2026/08/02 05:28:36 DEBUG : potato3: Trying to read object after upload: try again in 200ms (2/10)
2026/08/02 05:28:37 DEBUG : potato3: Trying to read object after upload: try again in 400ms (3/10)
    sync_test.go:1736: Server side move (if possible) Linkbox root 'rclone-test-nefufez7sigu' -> Linkbox root 'rclone-test-yugeyot4vesi'
2026/08/02 05:28:41 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10)
2026/08/02 05:28:42 DEBUG : empty space: Trying to read object after upload: try again in 200ms (2/10)
2026/08/02 05:28:44 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10)
2026/08/02 05:28:45 DEBUG : potato3: 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/08/02 05:28:53 DEBUG : potato2: Need to transfer - File not found at Destination
2026/08/02 05:28:53 DEBUG : empty space: size = 1 OK
2026/08/02 05:28:53 DEBUG : empty space: Sizes identical
2026/08/02 05:28:53 DEBUG : empty space: Unchanged skipping
2026/08/02 05:28:53 DEBUG : potato3: size = 68 (Linkbox root 'rclone-test-nefufez7sigu')
2026/08/02 05:28:53 DEBUG : potato3: size = 60 (Linkbox root 'rclone-test-yugeyot4vesi')
2026/08/02 05:28:53 DEBUG : potato3: Sizes differ
2026/08/02 05:28:53 DEBUG : Linkbox root 'rclone-test-yugeyot4vesi': Waiting for checks to finish
2026/08/02 05:28:53 NOTICE: Time may be set wrong - time from "aht.nuplink3.net" is 1226h19m16.992934761s different from this computer
2026/08/02 05:28:54 DEBUG : potato3: Update: removing old file
2026/08/02 05:28:54 INFO  : empty space: Deleted
2026/08/02 05:28:54 DEBUG : Linkbox root 'rclone-test-yugeyot4vesi': Waiting for transfers to finish
2026/08/02 05:28:56 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10)
2026/08/02 05:28:56 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10)
2026/08/02 05:28:56 DEBUG : potato2: Trying to read object after upload: try again in 400ms (3/10)
2026/08/02 05:28:57 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10)
2026/08/02 05:28:57 DEBUG : potato2: Trying to read object after upload: try again in 800ms (4/10)
2026/08/02 05:28:57 DEBUG : potato3: Trying to read object after upload: try again in 200ms (2/10)
2026/08/02 05:28:58 DEBUG : potato3: Trying to read object after upload: try again in 400ms (3/10)
2026/08/02 05:28:58 DEBUG : potato2: size = 60 OK
2026/08/02 05:28:58 INFO  : potato2: Copied (new)
2026/08/02 05:28:58 DEBUG : potato3: size = 68 OK
2026/08/02 05:28:58 INFO  : potato3: Copied (replaced existing)
2026/08/02 05:28:59 INFO  : potato2: Deleted
2026/08/02 05:29:00 INFO  : potato3: 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:292: Sleeping for 7s just to make sure
2026/08/02 05:29:11 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-zepofic3cifu"
2026/08/02 05:29:11 DEBUG : Linkbox root 'rclone-test-zepofic3cifu': Using cached web token
2026/08/02 05:29:13 DEBUG : empty space: Need to transfer - File not found at Destination
2026/08/02 05:29:13 DEBUG : potato2: Need to transfer - File not found at Destination
2026/08/02 05:29:13 DEBUG : potato3: Need to transfer - File not found at Destination
2026/08/02 05:29:13 DEBUG : Linkbox root 'rclone-test-zepofic3cifu': Waiting for checks to finish
2026/08/02 05:29:13 DEBUG : Linkbox root 'rclone-test-zepofic3cifu': Waiting for transfers to finish
2026/08/02 05:29:17 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10)
2026/08/02 05:29:17 DEBUG : potato2: size = 60 OK
2026/08/02 05:29:17 INFO  : potato2: Copied (new)
2026/08/02 05:29:18 DEBUG : empty space: size = 1 OK
2026/08/02 05:29:18 INFO  : empty space: Copied (new)
2026/08/02 05:29:18 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10)
2026/08/02 05:29:18 DEBUG : potato3: Trying to read object after upload: try again in 200ms (2/10)
2026/08/02 05:29:19 DEBUG : potato3: Trying to read object after upload: try again in 400ms (3/10)
2026/08/02 05:29:19 INFO  : potato2: Deleted
2026/08/02 05:29:19 INFO  : empty space: Deleted
2026/08/02 05:29:19 DEBUG : potato3: size = 68 OK
2026/08/02 05:29:19 INFO  : potato3: Copied (new)
2026/08/02 05:29:21 INFO  : potato3: Deleted
2026/08/02 05:29:21 DEBUG : Linkbox root 'rclone-test-zepofic3cifu': Purge remote
2026/08/02 05:29:22 DEBUG : Linkbox root 'rclone-test-yugeyot4vesi': Purge remote
--- PASS: TestServerSideMove (57.46s)
=== RUN   TestServerSideMoveWithFilter
    run.go:198: Remote "Linkbox root 'rclone-test-nefufez7sigu'", Local "Local file system at /tmp/rclone1976722706", Modify Window "876000h0m0s"
2026/08/02 05:29:24 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-qusinil6fuce"
2026/08/02 05:29:24 DEBUG : Linkbox root 'rclone-test-qusinil6fuce': Using cached web token
2026/08/02 05:29:29 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10)
2026/08/02 05:29:29 DEBUG : empty space: Trying to read object after upload: try again in 200ms (2/10)
2026/08/02 05:29:32 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10)
2026/08/02 05:29:32 DEBUG : potato3: Trying to read object after upload: try again in 200ms (2/10)
2026/08/02 05:29:33 DEBUG : potato3: Trying to read object after upload: try again in 400ms (3/10)
    sync_test.go:1736: Server side move (if possible) Linkbox root 'rclone-test-nefufez7sigu' -> Linkbox root 'rclone-test-qusinil6fuce'
2026/08/02 05:29:37 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10)
2026/08/02 05:29:38 DEBUG : empty space: Trying to read object after upload: try again in 200ms (2/10)
2026/08/02 05:29:38 DEBUG : empty space: Trying to read object after upload: try again in 400ms (3/10)
2026/08/02 05:29:39 DEBUG : empty space: Trying to read object after upload: try again in 800ms (4/10)
2026/08/02 05:29:42 DEBUG : empty space: Excluded (Size Filter)
2026/08/02 05:29:42 DEBUG : empty space: Excluded
2026/08/02 05:29:42 DEBUG : empty space: Excluded (Size Filter)
2026/08/02 05:29:42 DEBUG : empty space: Excluded
2026/08/02 05:29:42 DEBUG : potato2: Need to transfer - File not found at Destination
2026/08/02 05:29:42 DEBUG : potato3: size = 68 (Linkbox root 'rclone-test-nefufez7sigu')
2026/08/02 05:29:42 DEBUG : potato3: size = 60 (Linkbox root 'rclone-test-qusinil6fuce')
2026/08/02 05:29:42 DEBUG : potato3: Sizes differ
2026/08/02 05:29:42 DEBUG : Linkbox root 'rclone-test-qusinil6fuce': Waiting for checks to finish
2026/08/02 05:29:42 DEBUG : Linkbox root 'rclone-test-qusinil6fuce': Waiting for transfers to finish
2026/08/02 05:29:43 DEBUG : potato3: Update: removing old file
2026/08/02 05:29:45 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10)
2026/08/02 05:29:45 DEBUG : potato2: size = 60 OK
2026/08/02 05:29:45 INFO  : potato2: Copied (new)
2026/08/02 05:29:47 INFO  : potato2: Deleted
2026/08/02 05:29:47 DEBUG : potato3: size = 68 (Linkbox root 'rclone-test-nefufez7sigu')
2026/08/02 05:29:47 DEBUG : potato3: size = 60 (Linkbox root 'rclone-test-qusinil6fuce')
2026/08/02 05:29:47 ERROR : potato3: corrupted on transfer: sizes differ src(Linkbox root 'rclone-test-nefufez7sigu') 68 vs dst(Linkbox root 'rclone-test-qusinil6fuce') 60
2026/08/02 05:29:47 INFO  : potato3: Removing failed copy
2026/08/02 05:29:47 INFO  : potato3: Failed to remove failed copy: could not Remove: Linkbox error 403: not permit 
2026/08/02 05:29:47 ERROR : potato3: Not deleting source as copy failed: corrupted on transfer: sizes differ src(Linkbox root 'rclone-test-nefufez7sigu') 68 vs dst(Linkbox root 'rclone-test-qusinil6fuce') 60
    sync_test.go:1747: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1747
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1925
        	Error:      	Received unexpected error:
        	            	corrupted on transfer: sizes differ src(Linkbox root 'rclone-test-nefufez7sigu') 68 vs dst(Linkbox root 'rclone-test-qusinil6fuce') 60
        	Test:       	TestServerSideMoveWithFilter
2026/08/02 05:29:47 DEBUG : Linkbox root 'rclone-test-qusinil6fuce': Purge remote
    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
--- FAIL: TestServerSideMoveWithFilter (34.75s)
=== RUN   TestServerSideMoveDeleteEmptySourceDirs
    run.go:198: Remote "Linkbox root 'rclone-test-nefufez7sigu'", Local "Local file system at /tmp/rclone1976722706", Modify Window "876000h0m0s"
2026/08/02 05:29:59 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-yujeroy4gudi"
2026/08/02 05:29:59 DEBUG : Linkbox root 'rclone-test-yujeroy4gudi': Using cached web token
2026/08/02 05:30:04 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10)
2026/08/02 05:30:04 DEBUG : empty space: Trying to read object after upload: try again in 200ms (2/10)
2026/08/02 05:30:05 DEBUG : empty space: Trying to read object after upload: try again in 400ms (3/10)
2026/08/02 05:30:05 DEBUG : empty space: Trying to read object after upload: try again in 800ms (4/10)
2026/08/02 05:30:08 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10)
2026/08/02 05:30:09 DEBUG : potato3: Trying to read object after upload: try again in 200ms (2/10)
2026/08/02 05:30:09 DEBUG : potato3: Trying to read object after upload: try again in 400ms (3/10)
2026/08/02 05:30:10 DEBUG : potato3: Trying to read object after upload: try again in 800ms (4/10)
2026/08/02 05:30:11 DEBUG : potato3: Trying to read object after upload: try again in 1.6s (5/10)
2026/08/02 05:30:13 INFO  : tomatoDir: Making directory
    sync_test.go:1736: Server side move (if possible) Linkbox root 'rclone-test-nefufez7sigu' -> Linkbox root 'rclone-test-yujeroy4gudi'
2026/08/02 05:30:18 DEBUG : empty space: Trying to read object after upload: try again in 100ms (1/10)
2026/08/02 05:30:19 DEBUG : empty space: Trying to read object after upload: try again in 200ms (2/10)
2026/08/02 05:30:19 DEBUG : empty space: Trying to read object after upload: try again in 400ms (3/10)
2026/08/02 05:30:20 DEBUG : empty space: Trying to read object after upload: try again in 800ms (4/10)
2026/08/02 05:30:23 DEBUG : potato3: Trying to read object after upload: try again in 100ms (1/10)
2026/08/02 05:30:23 DEBUG : potato3: Trying to read object after upload: try again in 200ms (2/10)
2026/08/02 05:30:23 DEBUG : potato3: Trying to read object after upload: try again in 400ms (3/10)
2026/08/02 05:30:25 DEBUG : potato2: Need to transfer - File not found at Destination
2026/08/02 05:30:25 DEBUG : potato3: size = 68 (Linkbox root 'rclone-test-nefufez7sigu')
2026/08/02 05:30:25 DEBUG : empty space: size = 1 OK
2026/08/02 05:30:25 DEBUG : empty space: Sizes identical
2026/08/02 05:30:25 DEBUG : empty space: Unchanged skipping
2026/08/02 05:30:25 DEBUG : potato3: size = 60 (Linkbox root 'rclone-test-yujeroy4gudi')
2026/08/02 05:30:25 DEBUG : potato3: Sizes differ
2026/08/02 05:30:25 DEBUG : Linkbox root 'rclone-test-yujeroy4gudi': Waiting for checks to finish
2026/08/02 05:30:25 DEBUG : potato3: Update: removing old file
2026/08/02 05:30:26 INFO  : empty space: Deleted
2026/08/02 05:30:26 DEBUG : Linkbox root 'rclone-test-yujeroy4gudi': Waiting for transfers to finish
2026/08/02 05:30:28 DEBUG : potato2: Trying to read object after upload: try again in 100ms (1/10)
2026/08/02 05:30:28 DEBUG : potato2: Trying to read object after upload: try again in 200ms (2/10)
2026/08/02 05:30:28 DEBUG : potato2: Trying to read object after upload: try again in 400ms (3/10)
2026/08/02 05:30:29 DEBUG : potato3: size = 68 (Linkbox root 'rclone-test-nefufez7sigu')
2026/08/02 05:30:29 DEBUG : potato3: size = 60 (Linkbox root 'rclone-test-yujeroy4gudi')
2026/08/02 05:30:29 ERROR : potato3: corrupted on transfer: sizes differ src(Linkbox root 'rclone-test-nefufez7sigu') 68 vs dst(Linkbox root 'rclone-test-yujeroy4gudi') 60
2026/08/02 05:30:29 INFO  : potato3: Removing failed copy
2026/08/02 05:30:29 DEBUG : potato2: size = 60 OK
2026/08/02 05:30:29 INFO  : potato2: Copied (new)
2026/08/02 05:30:29 INFO  : potato3: Failed to remove failed copy: could not Remove: Linkbox error 403: not permit 
2026/08/02 05:30:29 ERROR : potato3: Not deleting source as copy failed: corrupted on transfer: sizes differ src(Linkbox root 'rclone-test-nefufez7sigu') 68 vs dst(Linkbox root 'rclone-test-yujeroy4gudi') 60
2026/08/02 05:30:30 INFO  : potato2: Deleted
2026/08/02 05:30:30 ERROR : Linkbox root 'rclone-test-nefufez7sigu': not deleting directories as there were IO errors
    sync_test.go:1747: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1747
        	            				/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1932
        	Error:      	Received unexpected error:
        	            	not deleting directories as there were IO errors
        	Test:       	TestServerSideMoveDeleteEmptySourceDirs
2026/08/02 05:30:30 DEBUG : Linkbox root 'rclone-test-yujeroy4gudi': Purge remote
--- FAIL: TestServerSideMoveDeleteEmptySourceDirs (36.67s)
=== RUN   TestSyncUTFNorm
    run.go:198: Remote "Linkbox root 'rclone-test-nefufez7sigu'", Local "Local file system at /tmp/rclone1976722706", Modify Window "876000h0m0s"
2026/08/02 05:30:38 DEBUG : Testêé: Trying to read object after upload: try again in 100ms (1/10)
2026/08/02 05:30:38 DEBUG : Testêé: Trying to read object after upload: try again in 200ms (2/10)
2026/08/02 05:30:39 DEBUG : Testêé: size = 14 (Local file system at /tmp/rclone1976722706)
2026/08/02 05:30:39 DEBUG : Testêé: size = 18 (Linkbox root 'rclone-test-nefufez7sigu')
2026/08/02 05:30:39 DEBUG : Testêé: Sizes differ
2026/08/02 05:30:39 DEBUG : Linkbox root 'rclone-test-nefufez7sigu': Waiting for checks to finish
2026/08/02 05:30:39 DEBUG : Testêé: Update: removing old file
2026/08/02 05:30:39 DEBUG : Linkbox root 'rclone-test-nefufez7sigu': Waiting for transfers to finish
2026/08/02 05:30:42 DEBUG : Testêé: Trying to read object after upload: try again in 100ms (1/10)
2026/08/02 05:30:42 DEBUG : Testêé: Trying to read object after upload: try again in 200ms (2/10)
2026/08/02 05:30:43 DEBUG : Testêé: Trying to read object after upload: try again in 400ms (3/10)
2026/08/02 05:30:43 DEBUG : Testêé: Trying to read object after upload: try again in 800ms (4/10)
2026/08/02 05:30:44 DEBUG : Testêé: Trying to read object after upload: try again in 1.6s (5/10)
2026/08/02 05:30:46 DEBUG : Testêé: Trying to read object after upload: try again in 3.2s (6/10)
2026/08/02 05:30:50 DEBUG : Testêé: Trying to read object after upload: try again in 6.4s (7/10)
2026/08/02 05:30:56 DEBUG : Testêé: Trying to read object after upload: try again in 12.8s (8/10)
2026/08/02 05:31:09 DEBUG : Testêé: Trying to read object after upload: try again in 25.6s (9/10)
2026/08/02 05:31:35 DEBUG : Testêé: Trying to read object after upload: try again in 51.2s (10/10)
2026/08/02 05:32:26 ERROR : Testêé: Failed to copy: object not found
2026/08/02 05:32:26 ERROR : Linkbox root 'rclone-test-nefufez7sigu': not deleting files as there were IO errors
2026/08/02 05:32:26 ERROR : Linkbox root 'rclone-test-nefufez7sigu': not deleting directories as there were IO errors
    sync_test.go:2582: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:2582
        	Error:      	Received unexpected error:
        	            	object not found
        	Test:       	TestSyncUTFNorm
    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:292: Sleeping for 7s just to make sure
--- FAIL: TestSyncUTFNorm (123.91s)
FAIL
2026/08/02 05:32:39 DEBUG : Linkbox root 'rclone-test-nefufez7sigu': Purge remote
"./sync.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestServerSideMove|TestServerSideMoveDeleteEmptySourceDirs|TestServerSideMoveWithFilter|TestSyncUTFNorm)$'" - Finished ERROR in 4m15.23057178s (try 5/5): exit status 1: Failed [TestServerSideMoveWithFilter TestServerSideMoveDeleteEmptySourceDirs TestSyncUTFNorm]