"./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestDirMove|TestListDirSortedFn)$'" - Starting (try 2/5)
2026/07/21 01:31:08 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-wuhelad3coqe"
2026/07/21 01:31:08 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/07/21 01:31:08 DEBUG : Linkbox root 'rclone-test-wuhelad3coqe': Using cached web token
2026/07/21 01:31:09 DEBUG : Creating backend with remote "/tmp/rclone2309458811"
=== RUN   TestListDirSortedFn
    run.go:198: Remote "Linkbox root 'rclone-test-wuhelad3coqe'", Local "Local file system at /tmp/rclone2309458811", Modify Window "876000h0m0s"
    run.go:303: Failed to put "sub dir/ignore dir/.ignore" to "Linkbox root 'rclone-test-wuhelad3coqe'": Update second step failed: Linkbox error 500: The file name needs to include a suffix, such as xxx.mp4
--- FAIL: TestListDirSortedFn (22.76s)
=== RUN   TestDirMove
    run.go:198: Remote "Linkbox root 'rclone-test-wuhelad3coqe'", Local "Local file system at /tmp/rclone2309458811", Modify Window "876000h0m0s"
2026/07/21 01:31:48 INFO  : A1/B2: Making directory
2026/07/21 01:31:49 INFO  : A1/B1/C3: Making directory
2026/07/21 01:32:04 NOTICE: Time may be set wrong - time from "aht.nuplink3.net" is 932h0m32.124580965s different from this computer
2026/07/21 01:32:08 DEBUG : A2/B1/C1/four: size = 4 OK
2026/07/21 01:32:08 INFO  : A1/B1/C1/four: Copied (new) to: A2/B1/C1/four
2026/07/21 01:32:08 DEBUG : A2/B1/C2/five: size = 4 OK
2026/07/21 01:32:08 INFO  : A1/B1/C2/five: Copied (new) to: A2/B1/C2/five
2026/07/21 01:32:09 DEBUG : A2/one: size = 3 OK
2026/07/21 01:32:09 INFO  : A1/one: Copied (new) to: A2/one
2026/07/21 01:32:09 DEBUG : A2/B1/three: size = 5 OK
2026/07/21 01:32:09 INFO  : A1/B1/three: Copied (new) to: A2/B1/three
2026/07/21 01:32:09 DEBUG : A2/two: size = 3 OK
2026/07/21 01:32:09 INFO  : A1/two: Copied (new) to: A2/two
2026/07/21 01:32:10 INFO  : A1/B1/C1/four: Deleted
2026/07/21 01:32:10 INFO  : A1/B1/C2/five: Deleted
2026/07/21 01:32:11 INFO  : A1/one: Deleted
2026/07/21 01:32:11 INFO  : A1/B1/three: Deleted
2026/07/21 01:32:11 INFO  : A1/two: Deleted
2026/07/21 01:32:28 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value)
2026/07/21 01:32:28 DEBUG : pacer: Rate limited, increasing sleep to 400ms
2026/07/21 01:32:28 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value)
2026/07/21 01:32:28 DEBUG : pacer: Rate limited, increasing sleep to 800ms
2026/07/21 01:32:28 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value)
2026/07/21 01:32:28 DEBUG : pacer: Rate limited, increasing sleep to 1.6s
2026/07/21 01:32:29 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value)
2026/07/21 01:32:29 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/07/21 01:32:31 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value)
2026/07/21 01:32:34 DEBUG : pacer: Reducing sleep to 1.5s
2026/07/21 01:32:35 DEBUG : pacer: Reducing sleep to 1.125s
2026/07/21 01:32:37 DEBUG : pacer: Reducing sleep to 843.75ms
2026/07/21 01:32:38 DEBUG : pacer: Reducing sleep to 632.8125ms
2026/07/21 01:32:40 DEBUG : pacer: Reducing sleep to 474.609375ms
2026/07/21 01:32:40 DEBUG : pacer: Reducing sleep to 355.957031ms
2026/07/21 01:32:40 DEBUG : pacer: Reducing sleep to 266.967773ms
2026/07/21 01:32:41 DEBUG : pacer: Reducing sleep to 200.225829ms
2026/07/21 01:32:41 DEBUG : pacer: Reducing sleep to 200ms
2026/07/21 01:32:46 DEBUG : A3/one: size = 3 OK
2026/07/21 01:32:46 INFO  : A2/one: Copied (new) to: A3/one
2026/07/21 01:32:46 DEBUG : A3/two: size = 3 OK
2026/07/21 01:32:46 INFO  : A2/two: Copied (new) to: A3/two
2026/07/21 01:32:46 DEBUG : A3/B1/three: size = 5 OK
2026/07/21 01:32:46 INFO  : A2/B1/three: Copied (new) to: A3/B1/three
2026/07/21 01:32:47 DEBUG : A3/B1/C1/four: size = 4 OK
2026/07/21 01:32:47 INFO  : A2/B1/C1/four: Copied (new) to: A3/B1/C1/four
2026/07/21 01:32:47 DEBUG : A3/B1/C2/five: size = 4 OK
2026/07/21 01:32:47 INFO  : A2/B1/C2/five: Copied (new) to: A3/B1/C2/five
2026/07/21 01:32:47 INFO  : A2/one: Deleted
2026/07/21 01:32:48 INFO  : A2/two: Deleted
2026/07/21 01:32:48 INFO  : A2/B1/three: Deleted
2026/07/21 01:32:49 INFO  : A2/B1/C1/four: Deleted
2026/07/21 01:32:49 INFO  : A2/B1/C2/five: Deleted
2026/07/21 01:32:59 INFO  : Linkbox root 'rclone-test-wuhelad3coqe': Can't DirMove - falling back to file moves: can't move directory - incompatible remotes
2026/07/21 01:33:15 DEBUG : A4/B1/C1/four: size = 4 OK
2026/07/21 01:33:15 INFO  : A3/B1/C1/four: Copied (new) to: A4/B1/C1/four
2026/07/21 01:33:15 DEBUG : A4/one: size = 3 OK
2026/07/21 01:33:15 INFO  : A3/one: Copied (new) to: A4/one
2026/07/21 01:33:16 DEBUG : A4/B1/C2/five: size = 4 OK
2026/07/21 01:33:16 INFO  : A3/B1/C2/five: Copied (new) to: A4/B1/C2/five
2026/07/21 01:33:16 DEBUG : A4/two: size = 3 OK
2026/07/21 01:33:16 INFO  : A3/two: Copied (new) to: A4/two
2026/07/21 01:33:16 INFO  : A3/B1/C1/four: Deleted
2026/07/21 01:33:16 DEBUG : A4/B1/three: size = 5 OK
2026/07/21 01:33:16 INFO  : A3/B1/three: Copied (new) to: A4/B1/three
2026/07/21 01:33:17 INFO  : A3/one: Deleted
2026/07/21 01:33:17 INFO  : A3/B1/C2/five: Deleted
2026/07/21 01:33:18 INFO  : A3/two: Deleted
2026/07/21 01:33:18 INFO  : A3/B1/three: Deleted
2026/07/21 01:33:28 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value)
2026/07/21 01:33:28 DEBUG : pacer: Rate limited, increasing sleep to 400ms
2026/07/21 01:33:28 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value)
2026/07/21 01:33:28 DEBUG : pacer: Rate limited, increasing sleep to 800ms
2026/07/21 01:33:29 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value)
2026/07/21 01:33:29 DEBUG : pacer: Rate limited, increasing sleep to 1.6s
2026/07/21 01:33:30 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value)
2026/07/21 01:33:30 DEBUG : pacer: Rate limited, increasing sleep to 2s
2026/07/21 01:33:31 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value)
2026/07/21 01:33:33 DEBUG : pacer: Reducing sleep to 1.5s
2026/07/21 01:33:35 DEBUG : pacer: Reducing sleep to 1.125s
2026/07/21 01:33:37 DEBUG : pacer: Reducing sleep to 843.75ms
2026/07/21 01:33:39 DEBUG : pacer: Reducing sleep to 632.8125ms
2026/07/21 01:33:41 DEBUG : pacer: Reducing sleep to 474.609375ms
2026/07/21 01:33:41 DEBUG : pacer: Reducing sleep to 355.957031ms
2026/07/21 01:33:41 DEBUG : pacer: Reducing sleep to 266.967773ms
2026/07/21 01:33:43 DEBUG : pacer: Reducing sleep to 200.225829ms
2026/07/21 01:33:43 DEBUG : pacer: Reducing sleep to 200ms
--- PASS: TestDirMove (143.72s)
FAIL
2026/07/21 01:33:55 DEBUG : Linkbox root 'rclone-test-wuhelad3coqe': Purge remote
"./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^(TestDirMove|TestListDirSortedFn)$'" - Finished ERROR in 2m49.002705718s (try 2/5): exit status 1: Failed [TestListDirSortedFn]