"./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^TestDirMove$'" - Starting (try 5/5) 2026/08/01 04:40:46 DEBUG : Creating backend with remote "TestLinkbox:rclone-test-nicucor9jeda" 2026/08/01 04:40:46 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/08/01 04:40:46 DEBUG : Linkbox root 'rclone-test-nicucor9jeda': Using cached web token 2026/08/01 04:40:47 DEBUG : Creating backend with remote "/tmp/rclone3867730869" === RUN TestDirMove run.go:198: Remote "Linkbox root 'rclone-test-nicucor9jeda'", Local "Local file system at /tmp/rclone3867730869", Modify Window "876000h0m0s" 2026/08/01 04:40:53 DEBUG : A1/one: Trying to read object after upload: try again in 100ms (1/10) 2026/08/01 04:40:53 DEBUG : A1/one: Trying to read object after upload: try again in 200ms (2/10) 2026/08/01 04:41:06 INFO : A1/B2: Making directory 2026/08/01 04:41:08 INFO : A1/B1/C3: Making directory 2026/08/01 04:41:22 NOTICE: Time may be set wrong - time from "aht.nuplink3.net" is 1176h50m58.608959247s different from this computer 2026/08/01 04:41:27 DEBUG : A2/B1/three: size = 5 OK 2026/08/01 04:41:27 INFO : A1/B1/three: Copied (new) to: A2/B1/three 2026/08/01 04:41:27 DEBUG : A2/B1/C2/five: size = 4 OK 2026/08/01 04:41:27 INFO : A1/B1/C2/five: Copied (new) to: A2/B1/C2/five 2026/08/01 04:41:27 DEBUG : A2/B1/C1/four: Trying to read object after upload: try again in 100ms (1/10) 2026/08/01 04:41:28 DEBUG : A2/one: size = 3 OK 2026/08/01 04:41:28 INFO : A1/one: Copied (new) to: A2/one 2026/08/01 04:41:28 DEBUG : A2/two: Trying to read object after upload: try again in 100ms (1/10) 2026/08/01 04:41:28 DEBUG : A2/B1/C1/four: size = 4 OK 2026/08/01 04:41:28 INFO : A1/B1/C1/four: Copied (new) to: A2/B1/C1/four 2026/08/01 04:41:28 INFO : A1/B1/three: Deleted 2026/08/01 04:41:29 DEBUG : A2/two: size = 3 OK 2026/08/01 04:41:29 INFO : A1/two: Copied (new) to: A2/two 2026/08/01 04:41:29 INFO : A1/B1/C2/five: Deleted 2026/08/01 04:41:29 INFO : A1/one: Deleted 2026/08/01 04:41:30 INFO : A1/B1/C1/four: Deleted 2026/08/01 04:41:30 INFO : A1/two: Deleted 2026/08/01 04:41:57 DEBUG : A3/B1/C2/five: Trying to read object after upload: try again in 100ms (1/10) 2026/08/01 04:41:57 DEBUG : A3/one: Trying to read object after upload: try again in 100ms (1/10) 2026/08/01 04:41:57 DEBUG : A3/B1/C2/five: Trying to read object after upload: try again in 200ms (2/10) 2026/08/01 04:41:57 DEBUG : A3/two: Trying to read object after upload: try again in 100ms (1/10) 2026/08/01 04:41:58 DEBUG : A3/one: size = 3 OK 2026/08/01 04:41:58 INFO : A2/one: Copied (new) to: A3/one 2026/08/01 04:41:58 DEBUG : A3/B1/three: size = 5 OK 2026/08/01 04:41:58 INFO : A2/B1/three: Copied (new) to: A3/B1/three 2026/08/01 04:41:58 DEBUG : A3/B1/C2/five: size = 4 OK 2026/08/01 04:41:58 INFO : A2/B1/C2/five: Copied (new) to: A3/B1/C2/five 2026/08/01 04:41:58 DEBUG : A3/two: size = 3 OK 2026/08/01 04:41:58 INFO : A2/two: Copied (new) to: A3/two 2026/08/01 04:41:58 DEBUG : A3/B1/C1/four: size = 4 OK 2026/08/01 04:41:58 INFO : A2/B1/C1/four: Copied (new) to: A3/B1/C1/four 2026/08/01 04:42:00 INFO : A2/one: Deleted 2026/08/01 04:42:00 INFO : A2/B1/three: Deleted 2026/08/01 04:42:00 INFO : A2/B1/C2/five: Deleted 2026/08/01 04:42:00 INFO : A2/two: Deleted 2026/08/01 04:42:00 INFO : A2/B1/C1/four: Deleted 2026/08/01 04:42:10 DEBUG : pacer: low level retry 1/10 (error invalid character '<' looking for beginning of value) 2026/08/01 04:42:10 DEBUG : pacer: Rate limited, increasing sleep to 400ms 2026/08/01 04:42:10 DEBUG : pacer: low level retry 2/10 (error invalid character '<' looking for beginning of value) 2026/08/01 04:42:10 DEBUG : pacer: Rate limited, increasing sleep to 800ms 2026/08/01 04:42:11 DEBUG : pacer: low level retry 3/10 (error invalid character '<' looking for beginning of value) 2026/08/01 04:42:11 DEBUG : pacer: Rate limited, increasing sleep to 1.6s 2026/08/01 04:42:12 DEBUG : pacer: low level retry 4/10 (error invalid character '<' looking for beginning of value) 2026/08/01 04:42:12 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/08/01 04:42:13 DEBUG : pacer: low level retry 5/10 (error invalid character '<' looking for beginning of value) 2026/08/01 04:42:15 DEBUG : pacer: low level retry 6/10 (error invalid character '<' looking for beginning of value) 2026/08/01 04:42:17 DEBUG : pacer: low level retry 7/10 (error invalid character '<' looking for beginning of value) 2026/08/01 04:42:19 DEBUG : pacer: low level retry 8/10 (error invalid character '<' looking for beginning of value) 2026/08/01 04:42:21 DEBUG : pacer: Reducing sleep to 1.5s 2026/08/01 04:42:23 DEBUG : pacer: Reducing sleep to 1.125s 2026/08/01 04:42:25 DEBUG : pacer: Reducing sleep to 843.75ms 2026/08/01 04:42:26 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/08/01 04:42:27 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/08/01 04:42:27 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/08/01 04:42:28 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/08/01 04:42:28 INFO : Linkbox root 'rclone-test-nicucor9jeda': Can't DirMove - falling back to file moves: can't move directory - incompatible remotes 2026/08/01 04:42:28 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/08/01 04:42:29 DEBUG : pacer: Reducing sleep to 200ms 2026/08/01 04:42:44 DEBUG : A4/B1/C2/five: Trying to read object after upload: try again in 100ms (1/10) 2026/08/01 04:42:44 DEBUG : A4/B1/C1/four: Trying to read object after upload: try again in 100ms (1/10) 2026/08/01 04:42:44 DEBUG : A4/B1/C2/five: Trying to read object after upload: try again in 200ms (2/10) 2026/08/01 04:42:45 DEBUG : A4/B1/three: size = 5 OK 2026/08/01 04:42:45 INFO : A3/B1/three: Copied (new) to: A4/B1/three 2026/08/01 04:42:45 DEBUG : A4/B1/C1/four: Trying to read object after upload: try again in 200ms (2/10) 2026/08/01 04:42:45 DEBUG : A4/one: Trying to read object after upload: try again in 100ms (1/10) 2026/08/01 04:42:45 DEBUG : A4/two: Trying to read object after upload: try again in 100ms (1/10) 2026/08/01 04:42:45 DEBUG : A4/B1/C2/five: size = 4 OK 2026/08/01 04:42:45 INFO : A3/B1/C2/five: Copied (new) to: A4/B1/C2/five 2026/08/01 04:42:46 DEBUG : A4/B1/C1/four: size = 4 OK 2026/08/01 04:42:46 INFO : A3/B1/C1/four: Copied (new) to: A4/B1/C1/four 2026/08/01 04:42:46 DEBUG : A4/one: Trying to read object after upload: try again in 200ms (2/10) 2026/08/01 04:42:46 DEBUG : A4/two: Trying to read object after upload: try again in 200ms (2/10) 2026/08/01 04:42:47 INFO : A3/B1/three: Deleted 2026/08/01 04:42:47 DEBUG : A4/one: Trying to read object after upload: try again in 400ms (3/10) 2026/08/01 04:42:47 DEBUG : A4/two: Trying to read object after upload: try again in 400ms (3/10) 2026/08/01 04:42:48 INFO : A3/B1/C2/five: Deleted 2026/08/01 04:42:48 DEBUG : A4/one: size = 3 OK 2026/08/01 04:42:48 INFO : A3/one: Copied (new) to: A4/one 2026/08/01 04:42:48 DEBUG : A4/two: size = 3 OK 2026/08/01 04:42:48 INFO : A3/two: Copied (new) to: A4/two 2026/08/01 04:42:48 INFO : A3/B1/C1/four: Deleted 2026/08/01 04:42:49 INFO : A3/one: Deleted 2026/08/01 04:42:49 INFO : A3/two: Deleted --- PASS: TestDirMove (149.87s) PASS 2026/08/01 04:43:17 DEBUG : Linkbox root 'rclone-test-nicucor9jeda': Purge remote "./operations.test -test.v -test.timeout 1h0m0s -remote TestLinkbox: -verbose -test.run '^TestDirMove$'" - Finished OK in 2m32.149505071s (try 5/5)