"./sync.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestMoveWithIgnoreExisting|TestNothingToTransferWithEmptyDirs|TestNothingToTransferWithoutEmptyDirs|TestServerSideMoveDeleteEmptySourceDirs|TestSyncCompareDest|TestSyncReplaceDirModTime|TestSyncReplaceDirModTimeWithEmptyDirs|TestSyncSuffixKeepExtension)$'" - Starting (try 2/5) 2026/08/17 05:26:17 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-kugebar0pifa" 2026/08/17 05:26:17 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/08/17 05:26:17 DEBUG : Linkbox root 'rclone-test-kugebar0pifa': Using cached web token 2026/08/17 05:26:18 DEBUG : Creating backend with remote "/tmp/rclone1395882267" === RUN TestMoveWithIgnoreExisting run.go:198: Remote "Linkbox root 'rclone-test-kugebar0pifa'", Local "Local file system at /tmp/rclone1395882267", Modify Window "876000h0m0s" 2026/08/17 05:26:19 DEBUG : existing-b: Need to transfer - File not found at Destination 2026/08/17 05:26:19 DEBUG : existing: Need to transfer - File not found at Destination 2026/08/17 05:26:19 DEBUG : Linkbox root 'rclone-test-kugebar0pifa': Waiting for checks to finish 2026/08/17 05:26:19 DEBUG : Linkbox root 'rclone-test-kugebar0pifa': Waiting for transfers to finish 2026/08/17 05:26:23 DEBUG : existing-b: size = 6 OK 2026/08/17 05:26:23 INFO : existing-b: Copied (new) 2026/08/17 05:26:23 INFO : existing-b: Deleted 2026/08/17 05:26:23 DEBUG : existing: Trying to read object after upload: try again in 100ms (1/10) 2026/08/17 05:26:23 DEBUG : existing: Trying to read object after upload: try again in 200ms (2/10) 2026/08/17 05:26:24 DEBUG : existing: Trying to read object after upload: try again in 400ms (3/10) 2026/08/17 05:26:24 DEBUG : existing: Trying to read object after upload: try again in 800ms (4/10) 2026/08/17 05:26:25 DEBUG : existing: Trying to read object after upload: try again in 1.6s (5/10) 2026/08/17 05:26:27 DEBUG : existing: Trying to read object after upload: try again in 3.2s (6/10) 2026/08/17 05:26:31 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:26:31 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/17 05:26:31 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:26:31 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/17 05:26:31 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:26:31 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/17 05:26:32 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:26:32 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/17 05:26:34 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:26:36 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:26:38 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:26:40 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:26:42 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:26:44 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:26:44 DEBUG : existing: Received error: Update failed to read object: getting files failed: invalid character '<' looking for beginning of value - low level retry 0/10 2026/08/17 05:26:46 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:26:48 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:26:50 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:26:52 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:26:54 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:26:56 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:26:58 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:27:00 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:27:02 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:27:04 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/17 05:27:06 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/17 05:27:08 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/17 05:27:09 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/17 05:27:09 DEBUG : existing: Trying to read object after upload: try again in 100ms (1/10) 2026/08/17 05:27:09 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/17 05:27:09 DEBUG : existing: Trying to read object after upload: try again in 200ms (2/10) 2026/08/17 05:27:10 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/17 05:27:10 DEBUG : existing: Trying to read object after upload: try again in 400ms (3/10) 2026/08/17 05:27:11 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/17 05:27:11 DEBUG : existing: Trying to read object after upload: try again in 800ms (4/10) 2026/08/17 05:27:12 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/17 05:27:12 DEBUG : existing: Trying to read object after upload: try again in 1.6s (5/10) 2026/08/17 05:27:13 DEBUG : pacer: Reducing sleep to 200ms 2026/08/17 05:27:13 DEBUG : existing: Trying to read object after upload: try again in 3.2s (6/10) 2026/08/17 05:27:17 DEBUG : existing: Trying to read object after upload: try again in 6.4s (7/10) 2026/08/17 05:27:23 DEBUG : existing: Trying to read object after upload: try again in 12.8s (8/10) 2026/08/17 05:27:37 DEBUG : existing: Trying to read object after upload: try again in 25.6s (9/10) 2026/08/17 05:28:02 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:28:02 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/17 05:28:02 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:28:02 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/17 05:28:03 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:28:03 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/17 05:28:04 DEBUG : pacer: Reducing sleep to 1.2s 2026/08/17 05:28:04 DEBUG : existing: Trying to read object after upload: try again in 51.2s (10/10) 2026/08/17 05:28:55 ERROR : existing: Failed to copy: object not found 2026/08/17 05:28:55 ERROR : existing: Not deleting source as copy failed: object not found sync_test.go:1866: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1866 Error: Received unexpected error: object not found Test: TestMoveWithIgnoreExisting 2026/08/17 05:28:55 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:28:55 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/17 05:28:56 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:28:58 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:29:00 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:29:02 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:29:04 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/17 05:29:08 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/17 05:29:09 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/17 05:29:10 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/17 05:29:11 DEBUG : pacer: Reducing sleep to 474.609375ms --- FAIL: TestMoveWithIgnoreExisting (172.24s) === RUN TestServerSideMoveDeleteEmptySourceDirs run.go:198: Remote "Linkbox root 'rclone-test-kugebar0pifa'", Local "Local file system at /tmp/rclone1395882267", Modify Window "876000h0m0s" 2026/08/17 05:29:11 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-lohipef2naga" 2026/08/17 05:29:11 DEBUG : Config file has changed externally - reloading 2026/08/17 05:29:11 DEBUG : Linkbox root 'rclone-test-lohipef2naga': Using cached web token 2026/08/17 05:29:12 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/17 05:29:12 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/17 05:29:14 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/17 05:29:14 DEBUG : pacer: Reducing sleep to 200ms 2026/08/17 05:29:18 INFO : tomatoDir: Making directory sync_test.go:1736: Server side move (if possible) Linkbox root 'rclone-test-kugebar0pifa' -> Linkbox root 'rclone-test-lohipef2naga' 2026/08/17 05:29:26 DEBUG : potato2: Need to transfer - File not found at Destination 2026/08/17 05:29:26 DEBUG : empty space: size = 1 OK 2026/08/17 05:29:26 DEBUG : empty space: Sizes identical 2026/08/17 05:29:26 DEBUG : empty space: Unchanged skipping 2026/08/17 05:29:26 DEBUG : potato3: size = 68 (Linkbox root 'rclone-test-kugebar0pifa') 2026/08/17 05:29:26 DEBUG : potato3: size = 60 (Linkbox root 'rclone-test-lohipef2naga') 2026/08/17 05:29:26 DEBUG : potato3: Sizes differ 2026/08/17 05:29:26 DEBUG : Linkbox root 'rclone-test-lohipef2naga': Waiting for checks to finish 2026/08/17 05:29:26 NOTICE: Time may be set wrong - time from "aht.nuplink3.net" is 1586h19m49.832987713s different from this computer 2026/08/17 05:29:27 DEBUG : potato3: Update: removing old file 2026/08/17 05:29:28 INFO : empty space: Deleted 2026/08/17 05:29:28 DEBUG : Linkbox root 'rclone-test-lohipef2naga': Waiting for transfers to finish 2026/08/17 05:29:29 DEBUG : potato2: size = 60 OK 2026/08/17 05:29:29 INFO : potato2: Copied (new) 2026/08/17 05:29:30 INFO : potato2: Deleted 2026/08/17 05:29:30 DEBUG : potato3: size = 68 OK 2026/08/17 05:29:30 INFO : potato3: Copied (replaced existing) 2026/08/17 05:29:31 INFO : potato3: Deleted 2026/08/17 05:29:31 INFO : tomatoDir: Removing directory 2026/08/17 05:29:33 DEBUG : Linkbox root 'rclone-test-kugebar0pifa': deleted 1 directories 2026/08/17 05:29:34 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-jotuhit5gozi" 2026/08/17 05:29:34 DEBUG : Linkbox root 'rclone-test-jotuhit5gozi': Using cached web token 2026/08/17 05:29:34 INFO : tomatoDir: Making directory 2026/08/17 05:29:36 DEBUG : empty space: Need to transfer - File not found at Destination 2026/08/17 05:29:36 DEBUG : potato2: Need to transfer - File not found at Destination 2026/08/17 05:29:36 DEBUG : potato3: Need to transfer - File not found at Destination 2026/08/17 05:29:37 DEBUG : Linkbox root 'rclone-test-jotuhit5gozi': Waiting for checks to finish 2026/08/17 05:29:37 DEBUG : Linkbox root 'rclone-test-jotuhit5gozi': Waiting for transfers to finish 2026/08/17 05:29:41 DEBUG : empty space: size = 1 OK 2026/08/17 05:29:41 INFO : empty space: Copied (new) 2026/08/17 05:29:41 DEBUG : potato2: size = 60 OK 2026/08/17 05:29:41 INFO : potato2: Copied (new) 2026/08/17 05:29:42 DEBUG : potato3: size = 68 OK 2026/08/17 05:29:42 INFO : potato3: Copied (new) 2026/08/17 05:29:42 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:29:42 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/17 05:29:42 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:29:42 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/17 05:29:42 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:29:42 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/17 05:29:42 DEBUG : pacer: Reducing sleep to 1.2s 2026/08/17 05:29:42 INFO : empty space: Deleted 2026/08/17 05:29:43 DEBUG : pacer: Reducing sleep to 900ms 2026/08/17 05:29:43 INFO : potato2: Deleted 2026/08/17 05:29:43 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:29:43 DEBUG : pacer: Rate limited, increasing sleep to 1.8s 2026/08/17 05:29:44 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:29:44 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/17 05:29:46 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:29:48 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:29:50 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:29:52 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:29:54 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:29:54 ERROR : potato3: Couldn't delete: could not Remove: invalid character '<' looking for beginning of value 2026/08/17 05:29:54 ERROR : Linkbox root 'rclone-test-lohipef2naga': not deleting directories as there were IO errors sync_test.go:1776: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync_test.go:1776 /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/17 05:29:54 DEBUG : Linkbox root 'rclone-test-jotuhit5gozi': Purge remote 2026/08/17 05:29:54 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:29:54 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/17 05:29:54 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:29:54 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/17 05:29:54 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:29:54 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/17 05:29:55 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:29:55 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/17 05:29:57 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:29:59 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:30:01 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:30:03 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:30:06 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/17 05:30:06 DEBUG : Linkbox root 'rclone-test-lohipef2naga': Purge remote 2026/08/17 05:30:07 DEBUG : pacer: Reducing sleep to 1.5s --- FAIL: TestServerSideMoveDeleteEmptySourceDirs (57.17s) === RUN TestSyncCompareDest run.go:198: Remote "Linkbox root 'rclone-test-kugebar0pifa'", Local "Local file system at /tmp/rclone1395882267", Modify Window "876000h0m0s" 2026/08/17 05:30:08 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-kugebar0pifa/dst" 2026/08/17 05:30:08 DEBUG : Linkbox root 'rclone-test-kugebar0pifa/dst': Using cached web token 2026/08/17 05:30:09 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-kugebar0pifa/CompareDest" 2026/08/17 05:30:09 DEBUG : Linkbox root 'rclone-test-kugebar0pifa/CompareDest': Using cached web token 2026/08/17 05:30:11 DEBUG : one: Need to transfer - File not found at Destination 2026/08/17 05:30:11 DEBUG : Linkbox root 'rclone-test-kugebar0pifa/dst': Waiting for checks to finish 2026/08/17 05:30:11 DEBUG : Linkbox root 'rclone-test-kugebar0pifa/dst': Waiting for transfers to finish 2026/08/17 05:30:14 DEBUG : one: size = 3 OK 2026/08/17 05:30:14 INFO : one: Copied (new) 2026/08/17 05:30:14 DEBUG : Waiting for deletions to finish 2026/08/17 05:30:15 DEBUG : Linkbox root 'rclone-test-kugebar0pifa/dst': Waiting for checks to finish 2026/08/17 05:30:15 DEBUG : one: size = 5 (Local file system at /tmp/rclone1395882267) 2026/08/17 05:30:15 DEBUG : one: size = 3 (Linkbox root 'rclone-test-kugebar0pifa/dst') 2026/08/17 05:30:15 DEBUG : one: Sizes differ 2026/08/17 05:30:16 DEBUG : Linkbox root 'rclone-test-kugebar0pifa/dst': Waiting for transfers to finish 2026/08/17 05:30:16 DEBUG : one: Update: removing old file 2026/08/17 05:30:19 DEBUG : one: size = 5 OK 2026/08/17 05:30:19 INFO : one: Copied (replaced existing) 2026/08/17 05:30:19 DEBUG : Waiting for deletions to finish 2026/08/17 05:30:19 DEBUG : dst/one: Update: removing old file 2026/08/17 05:30:27 DEBUG : Linkbox root 'rclone-test-kugebar0pifa/dst': Waiting for checks to finish 2026/08/17 05:30:27 DEBUG : one: size = 5 (Local file system at /tmp/rclone1395882267) 2026/08/17 05:30:27 DEBUG : one: size = 3 (Linkbox root 'rclone-test-kugebar0pifa/dst') 2026/08/17 05:30:27 DEBUG : one: Sizes differ 2026/08/17 05:30:27 DEBUG : one: size = 5 OK 2026/08/17 05:30:27 DEBUG : one: Sizes identical 2026/08/17 05:30:27 DEBUG : one: Destination found in --compare-dest, skipping 2026/08/17 05:30:27 DEBUG : Linkbox root 'rclone-test-kugebar0pifa/dst': Waiting for transfers to finish 2026/08/17 05:30:27 DEBUG : Waiting for deletions to finish 2026/08/17 05:30:27 INFO : There was nothing to transfer 2026/08/17 05:30:31 DEBUG : one: size = 5 (Local file system at /tmp/rclone1395882267) 2026/08/17 05:30:31 DEBUG : one: size = 3 (Linkbox root 'rclone-test-kugebar0pifa/dst') 2026/08/17 05:30:31 DEBUG : one: Sizes differ 2026/08/17 05:30:31 DEBUG : two: size = 3 OK 2026/08/17 05:30:31 DEBUG : two: Sizes identical 2026/08/17 05:30:31 DEBUG : two: Destination found in --compare-dest, skipping 2026/08/17 05:30:31 DEBUG : Linkbox root 'rclone-test-kugebar0pifa/dst': Waiting for checks to finish 2026/08/17 05:30:31 DEBUG : one: size = 5 OK 2026/08/17 05:30:31 DEBUG : one: Sizes identical 2026/08/17 05:30:31 DEBUG : one: Destination found in --compare-dest, skipping 2026/08/17 05:30:31 DEBUG : Linkbox root 'rclone-test-kugebar0pifa/dst': Waiting for transfers to finish 2026/08/17 05:30:31 DEBUG : Waiting for deletions to finish 2026/08/17 05:30:31 INFO : There was nothing to transfer 2026/08/17 05:30:32 DEBUG : one: size = 5 (Local file system at /tmp/rclone1395882267) 2026/08/17 05:30:32 DEBUG : one: size = 3 (Linkbox root 'rclone-test-kugebar0pifa/dst') 2026/08/17 05:30:32 DEBUG : one: Sizes differ 2026/08/17 05:30:32 DEBUG : two: size = 3 OK 2026/08/17 05:30:32 DEBUG : two: Sizes identical 2026/08/17 05:30:32 DEBUG : two: Destination found in --compare-dest, skipping 2026/08/17 05:30:32 DEBUG : Linkbox root 'rclone-test-kugebar0pifa/dst': Waiting for checks to finish 2026/08/17 05:30:32 DEBUG : one: size = 5 OK 2026/08/17 05:30:32 DEBUG : one: Sizes identical 2026/08/17 05:30:32 DEBUG : one: Destination found in --compare-dest, skipping 2026/08/17 05:30:32 DEBUG : Linkbox root 'rclone-test-kugebar0pifa/dst': Waiting for transfers to finish 2026/08/17 05:30:32 DEBUG : Waiting for deletions to finish 2026/08/17 05:30:32 INFO : There was nothing to transfer 2026/08/17 05:30:32 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:30:32 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/17 05:30:32 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:30:32 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/17 05:30:33 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:30:33 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/17 05:30:34 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:30:34 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/17 05:30:35 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:30:37 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:30:39 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:30:41 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:30:43 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:30:45 DEBUG : pacer: low level retry 10/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:30:45 ERROR : error listing: getting files failed: invalid character '<' looking for beginning of value fstest.go:282: Error listing: getting files failed: invalid character '<' looking for beginning of value 2026/08/17 05:30:47 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:30:49 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:30:51 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:30:53 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:30:55 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:30:59 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:30:59 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:31:02 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:31:03 DEBUG : pacer: low level retry 9/10 (error invalid character '<' looking for beginning of value) 2026/08/17 05:31:05 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/17 05:31:07 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/17 05:31:09 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/17 05:31:11 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/17 05:31:13 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/17 05:31:14 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/17 05:31:14 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/17 05:31:16 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/17 05:31:16 DEBUG : pacer: Reducing sleep to 200ms --- FAIL: TestSyncCompareDest (69.37s) === RUN TestSyncSuffixKeepExtension run.go:198: Remote "Linkbox root 'rclone-test-kugebar0pifa'", Local "Local file system at /tmp/rclone1395882267", Modify Window "876000h0m0s" sync_test.go:2480: Skipping test as remote does not support server-side move --- SKIP: TestSyncSuffixKeepExtension (0.40s) === RUN TestSyncReplaceDirModTime run.go:198: Remote "Linkbox root 'rclone-test-kugebar0pifa'", Local "Local file system at /tmp/rclone1395882267", Modify Window "876000h0m0s" 2026/08/17 05:31:18 DEBUG : empty_dir: Making directory with metadata 2026/08/17 05:31:18 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/08/17 05:31:18 DEBUG : empty_on_remote: Making directory with metadata 2026/08/17 05:31:18 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/08/17 05:31:18 INFO : empty_on_remote: Making directory 2026/08/17 05:31:19 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC 2026/08/17 05:31:27 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2026/08/17 05:31:27 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2026/08/17 05:31:27 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2026/08/17 05:31:27 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) --- PASS: TestSyncReplaceDirModTime (23.07s) === RUN TestSyncReplaceDirModTimeWithEmptyDirs run.go:198: Remote "Linkbox root 'rclone-test-kugebar0pifa'", Local "Local file system at /tmp/rclone1395882267", Modify Window "876000h0m0s" 2026/08/17 05:31:41 DEBUG : empty_dir: Making directory with metadata 2026/08/17 05:31:41 INFO : empty_dir: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/08/17 05:31:41 DEBUG : empty_on_remote: Making directory with metadata 2026/08/17 05:31:41 INFO : empty_on_remote: Made directory with metadata (mtime=2011-12-25T12:59:59.123456789Z) 2026/08/17 05:31:41 INFO : empty_on_remote: Making directory 2026/08/17 05:31:42 INFO : empty_on_remote: Made directory with modification time 2011-12-25 12:59:59.123456789 +0000 UTC 2026/08/17 05:31:52 INFO : test_dir1: Set directory modification time (using DirSetModTime) 2026/08/17 05:31:52 INFO : test_dir2: Set directory modification time (using DirSetModTime) 2026/08/17 05:31:52 INFO : test_dir2/sub_dir: Set directory modification time (using DirSetModTime) 2026/08/17 05:31:52 INFO : empty_on_remote: Set directory modification time (using DirSetModTime) 2026/08/17 05:31:52 INFO : empty_dir: Set directory modification time (using DirSetModTime) 2026/08/17 05:32:11 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/17 05:32:13 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/17 05:32:13 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/17 05:32:14 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/17 05:32:14 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/17 05:32:15 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/17 05:32:15 DEBUG : pacer: Reducing sleep to 200ms --- PASS: TestSyncReplaceDirModTimeWithEmptyDirs (44.53s) === RUN TestNothingToTransferWithEmptyDirs run.go:198: Remote "Linkbox root 'rclone-test-kugebar0pifa'", Local "Local file system at /tmp/rclone1395882267", Modify Window "876000h0m0s" 2026/08/17 05:32:25 INFO : sub dir: Set directory modification time (using DirSetModTime) 2026/08/17 05:32:25 INFO : sub dir: Making directory 2026/08/17 05:32:27 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC --- PASS: TestNothingToTransferWithEmptyDirs (41.62s) === RUN TestNothingToTransferWithoutEmptyDirs run.go:198: Remote "Linkbox root 'rclone-test-kugebar0pifa'", Local "Local file system at /tmp/rclone1395882267", Modify Window "876000h0m0s" 2026/08/17 05:33:07 INFO : sub dir: Set directory modification time (using DirSetModTime) 2026/08/17 05:33:07 INFO : sub dir: Making directory 2026/08/17 05:33:08 INFO : sub dir: Made directory with modification time 2011-12-30 12:59:59 +0000 UTC --- PASS: TestNothingToTransferWithoutEmptyDirs (41.57s) FAIL 2026/08/17 05:33:48 DEBUG : Linkbox root 'rclone-test-kugebar0pifa': Purge remote "./sync.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestMoveWithIgnoreExisting|TestNothingToTransferWithEmptyDirs|TestNothingToTransferWithoutEmptyDirs|TestServerSideMoveDeleteEmptySourceDirs|TestSyncCompareDest|TestSyncReplaceDirModTime|TestSyncReplaceDirModTimeWithEmptyDirs|TestSyncSuffixKeepExtension)$'" - Finished ERROR in 7m32.458286343s (try 2/5): exit status 1: Failed [TestMoveWithIgnoreExisting TestServerSideMoveDeleteEmptySourceDirs TestSyncCompareDest]