"./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^TestDirMove$'" - Starting (try 2/5) 2026/08/12 02:48:01 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-xovoliw9sadu" 2026/08/12 02:48:01 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/08/12 02:48:01 DEBUG : Linkbox root 'rclone-test-xovoliw9sadu': Using cached web token 2026/08/12 02:48:03 DEBUG : Creating backend with remote "/tmp/rclone2521343510" === RUN TestDirMove run.go:198: Remote "Linkbox root 'rclone-test-xovoliw9sadu'", Local "Local file system at /tmp/rclone2521343510", Modify Window "876000h0m0s" 2026/08/12 02:48:22 INFO : A1/B2: Making directory 2026/08/12 02:48:23 INFO : A1/B1/C3: Making directory 2026/08/12 02:48:38 NOTICE: Time may be set wrong - time from "aht.nuplink3.net" is 1343h46m52.018659584s different from this computer 2026/08/12 02:48:42 DEBUG : A2/B1/three: size = 5 OK 2026/08/12 02:48:42 INFO : A1/B1/three: Copied (new) to: A2/B1/three 2026/08/12 02:48:43 DEBUG : A2/B1/C1/four: size = 4 OK 2026/08/12 02:48:43 INFO : A1/B1/C1/four: Copied (new) to: A2/B1/C1/four 2026/08/12 02:48:43 DEBUG : A2/one: size = 3 OK 2026/08/12 02:48:43 INFO : A1/one: Copied (new) to: A2/one 2026/08/12 02:48:43 DEBUG : A2/two: size = 3 OK 2026/08/12 02:48:43 INFO : A1/two: Copied (new) to: A2/two 2026/08/12 02:48:43 DEBUG : A2/B1/C2/five: size = 4 OK 2026/08/12 02:48:43 INFO : A1/B1/C2/five: Copied (new) to: A2/B1/C2/five 2026/08/12 02:48:44 INFO : A1/B1/three: Deleted 2026/08/12 02:48:45 INFO : A1/B1/C1/four: Deleted 2026/08/12 02:48:45 INFO : A1/one: Deleted 2026/08/12 02:48:45 INFO : A1/two: Deleted 2026/08/12 02:48:45 INFO : A1/B1/C2/five: Deleted 2026/08/12 02:49:12 DEBUG : A3/B1/C1/four: size = 4 OK 2026/08/12 02:49:12 INFO : A2/B1/C1/four: Copied (new) to: A3/B1/C1/four 2026/08/12 02:49:12 DEBUG : A3/B1/C2/five: size = 4 OK 2026/08/12 02:49:12 INFO : A2/B1/C2/five: Copied (new) to: A3/B1/C2/five 2026/08/12 02:49:12 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/12 02:49:12 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/12 02:49:12 DEBUG : pacer: Reducing sleep to 300ms 2026/08/12 02:49:12 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/12 02:49:12 DEBUG : pacer: Rate limited, increasing sleep to 600ms 2026/08/12 02:49:12 DEBUG : pacer: Reducing sleep to 450ms 2026/08/12 02:49:13 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/12 02:49:13 DEBUG : pacer: Rate limited, increasing sleep to 900ms 2026/08/12 02:49:13 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/12 02:49:13 DEBUG : pacer: Rate limited, increasing sleep to 1.8s 2026/08/12 02:49:13 DEBUG : pacer: Reducing sleep to 1.35s 2026/08/12 02:49:13 INFO : A2/B1/C1/four: Deleted 2026/08/12 02:49:14 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/12 02:49:14 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/12 02:49:15 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/12 02:49:17 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/12 02:49:19 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/12 02:49:21 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/12 02:49:24 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/12 02:49:24 DEBUG : A3/two: size = 3 OK 2026/08/12 02:49:24 INFO : A2/two: Copied (new) to: A3/two 2026/08/12 02:49:26 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/12 02:49:26 DEBUG : A3/one: size = 3 OK 2026/08/12 02:49:26 INFO : A2/one: Copied (new) to: A3/one 2026/08/12 02:49:27 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/12 02:49:27 DEBUG : A3/B1/three: size = 5 OK 2026/08/12 02:49:27 INFO : A2/B1/three: Copied (new) to: A3/B1/three 2026/08/12 02:49:29 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/12 02:49:29 INFO : A2/B1/C2/five: Deleted 2026/08/12 02:49:30 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/12 02:49:30 INFO : A2/two: Deleted 2026/08/12 02:49:31 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/12 02:49:31 INFO : A2/one: Deleted 2026/08/12 02:49:32 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/12 02:49:32 INFO : A2/B1/three: Deleted 2026/08/12 02:49:32 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/12 02:49:33 DEBUG : pacer: Reducing sleep to 200ms 2026/08/12 02:49:42 INFO : Linkbox root 'rclone-test-xovoliw9sadu': Can't DirMove - falling back to file moves: can't move directory - incompatible remotes 2026/08/12 02:49:58 DEBUG : A4/one: size = 3 OK 2026/08/12 02:49:58 INFO : A3/one: Copied (new) to: A4/one 2026/08/12 02:49:58 DEBUG : A4/B1/three: size = 5 OK 2026/08/12 02:49:58 INFO : A3/B1/three: Copied (new) to: A4/B1/three 2026/08/12 02:49:59 DEBUG : A4/two: size = 3 OK 2026/08/12 02:49:59 INFO : A3/two: Copied (new) to: A4/two 2026/08/12 02:49:59 DEBUG : A4/B1/C1/four: size = 4 OK 2026/08/12 02:49:59 INFO : A3/B1/C1/four: Copied (new) to: A4/B1/C1/four 2026/08/12 02:49:59 DEBUG : A4/B1/C2/five: size = 4 OK 2026/08/12 02:49:59 INFO : A3/B1/C2/five: Copied (new) to: A4/B1/C2/five 2026/08/12 02:50:00 INFO : A3/one: Deleted 2026/08/12 02:50:00 INFO : A3/B1/three: Deleted 2026/08/12 02:50:01 INFO : A3/two: Deleted 2026/08/12 02:50:01 INFO : A3/B1/C1/four: Deleted 2026/08/12 02:50:01 INFO : A3/B1/C2/five: Deleted --- PASS: TestDirMove (146.47s) PASS 2026/08/12 02:50:29 DEBUG : Linkbox root 'rclone-test-xovoliw9sadu': Purge remote "./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^TestDirMove$'" - Finished OK in 2m28.934860944s (try 2/5)