"go test -v -timeout 2h0m0s -remote TestZoho: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestZoho:" 2025/10/09 02:02:10 NOTICE: TestZoho: Stopped server 2025/10/09 02:02:10 NOTICE: TestZoho: Starting server 2025/10/09 02:02:10 DEBUG : Creating backend with remote "TestZoho:rclone-test-devexum4nuzo" 2025/10/09 02:02:10 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/10/09 02:02:10 DEBUG : TestZoho: Loaded invalid token from config file - ignoring 2025/10/09 02:02:10 DEBUG : Saving config "token" in section "TestZoho" of the config file 2025/10/09 02:02:10 DEBUG : TestZoho: Saved new token in config file 2025/10/09 02:02:11 DEBUG : Config file has changed externally - reloading === RUN TestIntegration/FsCheckWrap fstests.go:479: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:507: No commands in this remote === RUN TestIntegration/FsRmdirNotFound === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/10/09 02:02:12 INFO : dir/subdir: Making directory 2025/10/09 02:02:12 INFO : dir/subdir: Removing directory 2025/10/09 02:02:13 INFO : dir: Removing directory === RUN TestIntegration/FsMkdir/FsListEmpty === RUN TestIntegration/FsMkdir/FsListDirEmpty === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/10/09 02:02:13 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" fstests.go:716: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:716 Error: Received unexpected error: directory not empty Test: TestIntegration/FsMkdir/FsEncoding/punctuation 2025/10/09 02:02:16 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:02:16 DEBUG : pacer: low level retry 1/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:02:16 DEBUG : pacer: Rate limited, increasing sleep to 1m0s 2025/10/09 02:02:16 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:02:16 DEBUG : pacer: low level retry 2/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:03:16 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:03:16 DEBUG : pacer: low level retry 3/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:04:16 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:04:16 DEBUG : pacer: low level retry 4/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:05:16 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:05:16 DEBUG : pacer: low level retry 5/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:06:16 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:06:16 DEBUG : pacer: low level retry 6/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:07:16 DEBUG : pacer: Reducing sleep to 45s 2025/10/09 02:08:16 DEBUG : pacer: Reducing sleep to 33.75s fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache 2025/10/09 02:09:01 DEBUG : pacer: Reducing sleep to 25.3125s 2025/10/09 02:09:35 DEBUG : pacer: Reducing sleep to 18.984375s 2025/10/09 02:10:00 DEBUG : pacer: Reducing sleep to 14.23828125s fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache 2025/10/09 02:10:19 DEBUG : pacer: Reducing sleep to 10.678710937s 2025/10/09 02:10:33 DEBUG : pacer: Reducing sleep to 8.009033202s 2025/10/09 02:10:44 DEBUG : pacer: Reducing sleep to 6.006774901s fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:717 Error: Not equal: expected: []string{} actual : []string{"!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=34) "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" } Test: TestIntegration/FsMkdir/FsEncoding/punctuation Messages: directories === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" 2025/10/09 02:10:52 DEBUG : pacer: Reducing sleep to 4.505081175s 2025/10/09 02:10:58 DEBUG : pacer: Reducing sleep to 3.378810881s 2025/10/09 02:11:02 DEBUG : pacer: Reducing sleep to 2.53410816s 2025/10/09 02:11:06 DEBUG : pacer: Reducing sleep to 1.90058112s 2025/10/09 02:11:08 DEBUG : pacer: Reducing sleep to 1.42543584s 2025/10/09 02:11:10 DEBUG : pacer: Reducing sleep to 1.06907688s 2025/10/09 02:11:11 DEBUG : pacer: Reducing sleep to 801.80766ms 2025/10/09 02:11:13 DEBUG : pacer: Reducing sleep to 601.355745ms 2025/10/09 02:11:13 DEBUG : pacer: Reducing sleep to 451.016808ms fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache 2025/10/09 02:11:14 DEBUG : pacer: Reducing sleep to 338.262606ms 2025/10/09 02:11:15 DEBUG : pacer: Reducing sleep to 253.696954ms 2025/10/09 02:11:15 DEBUG : pacer: Reducing sleep to 190.272715ms 2025/10/09 02:11:15 DEBUG : pacer: Reducing sleep to 142.704536ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache 2025/10/09 02:11:18 DEBUG : pacer: Reducing sleep to 107.028402ms 2025/10/09 02:11:18 DEBUG : pacer: Reducing sleep to 80.271301ms 2025/10/09 02:11:18 DEBUG : pacer: Reducing sleep to 60.203475ms 2025/10/09 02:11:18 DEBUG : pacer: Reducing sleep to 45.152606ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 Error: Not equal: expected: []string{" leading space"} actual : []string{" leading space", "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"} Diff: --- Expected +++ Actual @@ -1,3 +1,4 @@ -([]string) (len=1) { - (string) (len=14) " leading space" +([]string) (len=2) { + (string) (len=14) " leading space", + (string) (len=34) "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" } Test: TestIntegration/FsMkdir/FsEncoding/leading_space Messages: directories 2025/10/09 02:11:22 DEBUG : pacer: Reducing sleep to 33.864454ms 2025/10/09 02:11:22 DEBUG : pacer: Reducing sleep to 25.39834ms 2025/10/09 02:11:22 DEBUG : pacer: Reducing sleep to 19.048755ms 2025/10/09 02:11:22 DEBUG : pacer: Reducing sleep to 14.286566ms 2025/10/09 02:11:22 DEBUG : pacer: Reducing sleep to 10.714924ms 2025/10/09 02:11:22 DEBUG : pacer: Reducing sleep to 10ms 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:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:717 Error: Not equal: expected: []string{} actual : []string{"!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=34) "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" } Test: TestIntegration/FsMkdir/FsEncoding/leading_space Messages: directories === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" 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:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 Error: Not equal: expected: []string{"~leading tilde"} actual : []string{"!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~", "~leading tilde"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) (len=1) { +([]string) (len=2) { + (string) (len=34) "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~", (string) (len=14) "~leading tilde" Test: TestIntegration/FsMkdir/FsEncoding/leading_tilde Messages: directories 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:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:717 Error: Not equal: expected: []string{} actual : []string{"!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=34) "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" } Test: TestIntegration/FsMkdir/FsEncoding/leading_tilde Messages: directories === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" 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:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 Error: Not equal: expected: []string{"␍leading CR"} actual : []string{"!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~", "␍leading CR"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) (len=1) { +([]string) (len=2) { + (string) (len=34) "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~", (string) (len=13) "␍leading CR" Test: TestIntegration/FsMkdir/FsEncoding/leading_CR Messages: directories 2025/10/09 02:11:54 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:11:54 DEBUG : pacer: low level retry 1/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:11:54 DEBUG : pacer: Rate limited, increasing sleep to 1m0s 2025/10/09 02:11:54 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:11:54 DEBUG : pacer: low level retry 2/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:12:54 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:12:54 DEBUG : pacer: low level retry 3/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:13:54 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:13:54 DEBUG : pacer: low level retry 4/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:14:54 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:14:54 DEBUG : pacer: low level retry 5/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:15:54 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:15:54 DEBUG : pacer: low level retry 6/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:16:54 DEBUG : pacer: Reducing sleep to 45s 2025/10/09 02:17:54 DEBUG : pacer: Reducing sleep to 33.75s 2025/10/09 02:18:39 DEBUG : pacer: Reducing sleep to 25.3125s 2025/10/09 02:19:13 DEBUG : pacer: Reducing sleep to 18.984375s 2025/10/09 02:19:38 DEBUG : pacer: Reducing sleep to 14.23828125s fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache 2025/10/09 02:19:57 DEBUG : pacer: Reducing sleep to 10.678710937s 2025/10/09 02:20:11 DEBUG : pacer: Reducing sleep to 8.009033202s 2025/10/09 02:20:22 DEBUG : pacer: Reducing sleep to 6.006774901s fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache 2025/10/09 02:20:30 DEBUG : pacer: Reducing sleep to 4.505081175s 2025/10/09 02:20:36 DEBUG : pacer: Reducing sleep to 3.378810881s 2025/10/09 02:20:41 DEBUG : pacer: Reducing sleep to 2.53410816s fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:717 Error: Not equal: expected: []string{} actual : []string{"!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=34) "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" } Test: TestIntegration/FsMkdir/FsEncoding/leading_CR Messages: directories === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" 2025/10/09 02:20:45 DEBUG : pacer: Reducing sleep to 1.90058112s 2025/10/09 02:20:47 DEBUG : pacer: Reducing sleep to 1.42543584s 2025/10/09 02:20:49 DEBUG : pacer: Reducing sleep to 1.06907688s 2025/10/09 02:20:50 DEBUG : pacer: Reducing sleep to 801.80766ms 2025/10/09 02:20:52 DEBUG : pacer: Reducing sleep to 601.355745ms 2025/10/09 02:20:52 DEBUG : pacer: Reducing sleep to 451.016808ms 2025/10/09 02:20:53 DEBUG : pacer: Reducing sleep to 338.262606ms 2025/10/09 02:20:53 DEBUG : pacer: Reducing sleep to 253.696954ms 2025/10/09 02:20:54 DEBUG : pacer: Reducing sleep to 190.272715ms fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache 2025/10/09 02:20:55 DEBUG : pacer: Reducing sleep to 142.704536ms 2025/10/09 02:20:55 DEBUG : pacer: Reducing sleep to 107.028402ms 2025/10/09 02:20:55 DEBUG : pacer: Reducing sleep to 80.271301ms 2025/10/09 02:20:55 DEBUG : pacer: Reducing sleep to 60.203475ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache 2025/10/09 02:20:57 DEBUG : pacer: Reducing sleep to 45.152606ms 2025/10/09 02:20:57 DEBUG : pacer: Reducing sleep to 33.864454ms 2025/10/09 02:20:57 DEBUG : pacer: Reducing sleep to 25.39834ms 2025/10/09 02:20:57 DEBUG : pacer: Reducing sleep to 19.048755ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 Error: Not equal: expected: []string{"␊leading LF"} actual : []string{"!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~", "␊leading LF"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) (len=1) { +([]string) (len=2) { + (string) (len=34) "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~", (string) (len=13) "␊leading LF" Test: TestIntegration/FsMkdir/FsEncoding/leading_LF Messages: directories 2025/10/09 02:21:02 DEBUG : pacer: Reducing sleep to 14.286566ms 2025/10/09 02:21:02 DEBUG : pacer: Reducing sleep to 10.714924ms 2025/10/09 02:21:02 DEBUG : pacer: Reducing sleep to 10ms 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:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:717 Error: Not equal: expected: []string{} actual : []string{"!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=34) "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" } Test: TestIntegration/FsMkdir/FsEncoding/leading_LF Messages: directories === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" 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:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 Error: Not equal: expected: []string{"␉leading HT"} actual : []string{"!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~", "␉leading HT"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) (len=1) { +([]string) (len=2) { + (string) (len=34) "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~", (string) (len=13) "␉leading HT" Test: TestIntegration/FsMkdir/FsEncoding/leading_HT Messages: directories 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:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:717 Error: Not equal: expected: []string{} actual : []string{"!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=34) "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" } Test: TestIntegration/FsMkdir/FsEncoding/leading_HT Messages: directories === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" 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 2025/10/09 02:21:29 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:21:29 DEBUG : pacer: low level retry 1/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:21:29 DEBUG : pacer: Rate limited, increasing sleep to 1m0s 2025/10/09 02:21:29 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:21:29 DEBUG : pacer: low level retry 2/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:22:29 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:22:29 DEBUG : pacer: low level retry 3/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:23:29 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:23:29 DEBUG : pacer: low level retry 4/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:24:29 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:24:29 DEBUG : pacer: low level retry 5/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:25:29 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:25:29 DEBUG : pacer: low level retry 6/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:26:29 DEBUG : pacer: Reducing sleep to 45s 2025/10/09 02:27:29 DEBUG : pacer: Reducing sleep to 33.75s 2025/10/09 02:28:14 DEBUG : pacer: Reducing sleep to 25.3125s fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 Error: Not equal: expected: []string{"␋leading VT"} actual : []string{"!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~", "␋leading VT"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) (len=1) { +([]string) (len=2) { + (string) (len=34) "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~", (string) (len=13) "␋leading VT" Test: TestIntegration/FsMkdir/FsEncoding/leading_VT Messages: directories 2025/10/09 02:28:48 DEBUG : pacer: Reducing sleep to 18.984375s 2025/10/09 02:29:13 DEBUG : pacer: Reducing sleep to 14.23828125s 2025/10/09 02:29:32 DEBUG : pacer: Reducing sleep to 10.678710937s 2025/10/09 02:29:47 DEBUG : pacer: Reducing sleep to 8.009033202s 2025/10/09 02:29:57 DEBUG : pacer: Reducing sleep to 6.006774901s 2025/10/09 02:30:05 DEBUG : pacer: Reducing sleep to 4.505081175s 2025/10/09 02:30:11 DEBUG : pacer: Reducing sleep to 3.378810881s fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache 2025/10/09 02:30:16 DEBUG : pacer: Reducing sleep to 2.53410816s 2025/10/09 02:30:19 DEBUG : pacer: Reducing sleep to 1.90058112s 2025/10/09 02:30:22 DEBUG : pacer: Reducing sleep to 1.42543584s fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache 2025/10/09 02:30:24 DEBUG : pacer: Reducing sleep to 1.06907688s 2025/10/09 02:30:25 DEBUG : pacer: Reducing sleep to 801.80766ms 2025/10/09 02:30:26 DEBUG : pacer: Reducing sleep to 601.355745ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:717 Error: Not equal: expected: []string{} actual : []string{"!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=34) "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" } Test: TestIntegration/FsMkdir/FsEncoding/leading_VT Messages: directories === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" 2025/10/09 02:30:30 DEBUG : pacer: Reducing sleep to 451.016808ms 2025/10/09 02:30:31 DEBUG : pacer: Reducing sleep to 338.262606ms 2025/10/09 02:30:31 DEBUG : pacer: Reducing sleep to 253.696954ms 2025/10/09 02:30:32 DEBUG : pacer: Reducing sleep to 190.272715ms 2025/10/09 02:30:32 DEBUG : pacer: Reducing sleep to 142.704536ms 2025/10/09 02:30:32 DEBUG : pacer: Reducing sleep to 107.028402ms 2025/10/09 02:30:32 DEBUG : pacer: Reducing sleep to 80.271301ms 2025/10/09 02:30:32 DEBUG : pacer: Reducing sleep to 60.203475ms 2025/10/09 02:30:32 DEBUG : pacer: Reducing sleep to 45.152606ms fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache 2025/10/09 02:30:34 DEBUG : pacer: Reducing sleep to 33.864454ms 2025/10/09 02:30:34 DEBUG : pacer: Reducing sleep to 25.39834ms 2025/10/09 02:30:34 DEBUG : pacer: Reducing sleep to 19.048755ms 2025/10/09 02:30:34 DEBUG : pacer: Reducing sleep to 14.286566ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache 2025/10/09 02:30:36 DEBUG : pacer: Reducing sleep to 10.714924ms 2025/10/09 02:30:36 DEBUG : pacer: Reducing sleep to 10ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 Error: Not equal: expected: []string{".leading dot"} actual : []string{"!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~", ".leading dot"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) (len=1) { +([]string) (len=2) { + (string) (len=34) "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~", (string) (len=12) ".leading dot" Test: TestIntegration/FsMkdir/FsEncoding/leading_dot Messages: directories 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:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:717 Error: Not equal: expected: []string{} actual : []string{"!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=34) "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" } Test: TestIntegration/FsMkdir/FsEncoding/leading_dot Messages: directories === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " 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:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 Error: Not equal: expected: []string{"trailing space "} actual : []string{"!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~", "trailing space "} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) (len=1) { +([]string) (len=2) { + (string) (len=34) "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~", (string) (len=15) "trailing space " Test: TestIntegration/FsMkdir/FsEncoding/trailing_space Messages: directories 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:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:717 Error: Not equal: expected: []string{} actual : []string{"!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=34) "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" } Test: TestIntegration/FsMkdir/FsEncoding/trailing_space Messages: directories === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" 2025/10/09 02:31:04 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:31:04 DEBUG : pacer: low level retry 1/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:31:04 DEBUG : pacer: Rate limited, increasing sleep to 1m0s 2025/10/09 02:31:04 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:31:04 DEBUG : pacer: low level retry 2/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:32:04 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:32:04 DEBUG : pacer: low level retry 3/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:33:04 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:33:04 DEBUG : pacer: low level retry 4/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:34:04 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:34:04 DEBUG : pacer: low level retry 5/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:35:04 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:35:04 DEBUG : pacer: low level retry 6/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:36:04 DEBUG : pacer: Reducing sleep to 45s 2025/10/09 02:37:04 DEBUG : pacer: Reducing sleep to 33.75s 2025/10/09 02:37:49 DEBUG : pacer: Reducing sleep to 25.3125s fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache 2025/10/09 02:38:23 DEBUG : pacer: Reducing sleep to 18.984375s 2025/10/09 02:38:48 DEBUG : pacer: Reducing sleep to 14.23828125s 2025/10/09 02:39:07 DEBUG : pacer: Reducing sleep to 10.678710937s 2025/10/09 02:39:22 DEBUG : pacer: Reducing sleep to 8.009033202s fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache 2025/10/09 02:39:32 DEBUG : pacer: Reducing sleep to 6.006774901s 2025/10/09 02:39:40 DEBUG : pacer: Reducing sleep to 4.505081175s 2025/10/09 02:39:46 DEBUG : pacer: Reducing sleep to 3.378810881s 2025/10/09 02:39:51 DEBUG : pacer: Reducing sleep to 2.53410816s fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 Error: Not equal: expected: []string{"trailing CR␍"} actual : []string{"!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~", "trailing CR␍"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) (len=1) { +([]string) (len=2) { + (string) (len=34) "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~", (string) (len=14) "trailing CR␍" Test: TestIntegration/FsMkdir/FsEncoding/trailing_CR Messages: directories 2025/10/09 02:39:55 DEBUG : pacer: Reducing sleep to 1.90058112s 2025/10/09 02:39:57 DEBUG : pacer: Reducing sleep to 1.42543584s 2025/10/09 02:39:59 DEBUG : pacer: Reducing sleep to 1.06907688s 2025/10/09 02:40:01 DEBUG : pacer: Reducing sleep to 801.80766ms 2025/10/09 02:40:02 DEBUG : pacer: Reducing sleep to 601.355745ms 2025/10/09 02:40:02 DEBUG : pacer: Reducing sleep to 451.016808ms 2025/10/09 02:40:03 DEBUG : pacer: Reducing sleep to 338.262606ms fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3 fstest.go:301: Flushing the directory cache 2025/10/09 02:40:04 DEBUG : pacer: Reducing sleep to 253.696954ms 2025/10/09 02:40:04 DEBUG : pacer: Reducing sleep to 190.272715ms 2025/10/09 02:40:05 DEBUG : pacer: Reducing sleep to 142.704536ms fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3 fstest.go:301: Flushing the directory cache 2025/10/09 02:40:07 DEBUG : pacer: Reducing sleep to 107.028402ms 2025/10/09 02:40:07 DEBUG : pacer: Reducing sleep to 80.271301ms 2025/10/09 02:40:07 DEBUG : pacer: Reducing sleep to 60.203475ms fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:717 Error: Not equal: expected: []string{} actual : []string{"!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=34) "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" } Test: TestIntegration/FsMkdir/FsEncoding/trailing_CR Messages: directories === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" 2025/10/09 02:40:11 DEBUG : pacer: Reducing sleep to 45.152606ms 2025/10/09 02:40:11 DEBUG : pacer: Reducing sleep to 33.864454ms 2025/10/09 02:40:11 DEBUG : pacer: Reducing sleep to 25.39834ms 2025/10/09 02:40:11 DEBUG : pacer: Reducing sleep to 19.048755ms 2025/10/09 02:40:12 DEBUG : pacer: Reducing sleep to 14.286566ms 2025/10/09 02:40:12 DEBUG : pacer: Reducing sleep to 10.714924ms 2025/10/09 02:40:12 DEBUG : pacer: Reducing sleep to 10ms 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:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 Error: Not equal: expected: []string{"trailing LF␊"} actual : []string{"!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~", "trailing LF␊"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) (len=1) { +([]string) (len=2) { + (string) (len=34) "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~", (string) (len=14) "trailing LF␊" Test: TestIntegration/FsMkdir/FsEncoding/trailing_LF Messages: directories 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:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:717 Error: Not equal: expected: []string{} actual : []string{"!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=34) "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" } Test: TestIntegration/FsMkdir/FsEncoding/trailing_LF Messages: directories === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" 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:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:714 Error: Not equal: expected: []string{"trailing HT␉"} actual : []string{"!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~", "trailing HT␉"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) (len=1) { +([]string) (len=2) { + (string) (len=34) "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~", (string) (len=14) "trailing HT␉" Test: TestIntegration/FsMkdir/FsEncoding/trailing_HT Messages: directories 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 2025/10/09 02:40:39 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:40:39 DEBUG : pacer: low level retry 1/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:40:39 DEBUG : pacer: Rate limited, increasing sleep to 1m0s 2025/10/09 02:40:39 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:40:39 DEBUG : pacer: low level retry 2/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:41:39 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:41:39 DEBUG : pacer: low level retry 3/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:42:39 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:42:39 DEBUG : pacer: low level retry 4/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:43:39 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:43:39 DEBUG : pacer: low level retry 5/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:44:39 DEBUG : Too many requests. Trying again in 60 seconds. 2025/10/09 02:44:39 DEBUG : pacer: low level retry 6/10 (error HTTP error 429 (429 Too Many Requests) returned body: "{\"errors\":[{\"id\":\"F7008\",\"title\":\"Request rate limit exceeded. Please retry again later.\"}]}\n": trying again in 1m0s) 2025/10/09 02:45:39 DEBUG : pacer: Reducing sleep to 45s 2025/10/09 02:46:39 DEBUG : pacer: Reducing sleep to 33.75s fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3 fstest.go:301: Flushing the directory cache fstest.go:327: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:327 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:717 Error: Not equal: expected: []string{} actual : []string{"!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"} Diff: --- Expected +++ Actual @@ -1,2 +1,3 @@ -([]string) { +([]string) (len=1) { + (string) (len=34) "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" } Test: TestIntegration/FsMkdir/FsEncoding/trailing_HT Messages: directories === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" 2025/10/09 02:47:24 DEBUG : pacer: Reducing sleep to 25.3125s 2025/10/09 02:47:58 DEBUG : pacer: Reducing sleep to 18.984375s fstests.go:708: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:708 Error: Received unexpected error: couldn't list files: HTTP error 401 (401 Unauthorized) returned body: "{\"errors\":[{\"id\":\"R008\",\"title\":\"Unauthorized access\"}]}" Test: TestIntegration/FsMkdir/FsEncoding/trailing_VT 2025/10/09 02:48:23 DEBUG : pacer: Reducing sleep to 14.23828125s fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:162 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:224 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:214 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:713 /usr/local/go/src/runtime/asm_amd64.s:1700 Error: Received unexpected error: couldn't list files: HTTP error 401 (401 Unauthorized) returned body: "{\"errors\":[{\"id\":\"R008\",\"title\":\"Unauthorized access\"}]}" Test: TestIntegration/FsMkdir/FsEncoding/trailing_VT Messages: Put === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." 2025/10/09 02:48:42 DEBUG : pacer: Reducing sleep to 10.678710937s fstests.go:708: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:708 Error: Received unexpected error: couldn't list files: HTTP error 401 (401 Unauthorized) returned body: "{\"errors\":[{\"id\":\"R008\",\"title\":\"Unauthorized access\"}]}" Test: TestIntegration/FsMkdir/FsEncoding/trailing_dot 2025/10/09 02:48:56 DEBUG : pacer: Reducing sleep to 8.009033202s fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:162 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:224 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:214 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:713 /usr/local/go/src/runtime/asm_amd64.s:1700 Error: Received unexpected error: couldn't list files: HTTP error 401 (401 Unauthorized) returned body: "{\"errors\":[{\"id\":\"R008\",\"title\":\"Unauthorized access\"}]}" Test: TestIntegration/FsMkdir/FsEncoding/trailing_dot Messages: Put === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:699: Skipping invalid UTF-8 === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" 2025/10/09 02:49:07 DEBUG : pacer: Reducing sleep to 6.006774901s fstests.go:708: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:708 Error: Received unexpected error: couldn't list files: HTTP error 401 (401 Unauthorized) returned body: "{\"errors\":[{\"id\":\"R008\",\"title\":\"Unauthorized access\"}]}" Test: TestIntegration/FsMkdir/FsEncoding/URL_encoding 2025/10/09 02:49:15 DEBUG : pacer: Reducing sleep to 4.505081175s fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:162 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:224 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:214 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:713 /usr/local/go/src/runtime/asm_amd64.s:1700 Error: Received unexpected error: couldn't list files: HTTP error 401 (401 Unauthorized) returned body: "{\"errors\":[{\"id\":\"R008\",\"title\":\"Unauthorized access\"}]}" Test: TestIntegration/FsMkdir/FsEncoding/URL_encoding Messages: Put === RUN TestIntegration/FsMkdir/FsNewObjectNotFound 2025/10/09 02:49:21 DEBUG : pacer: Reducing sleep to 3.378810881s fstests.go:728: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:728 Error: Not equal: expected: *errors.errorString(&errors.errorString{s:"object not found"}) actual : *fmt.wrapError(&fmt.wrapError{msg:"couldn't list files: HTTP error 401 (401 Unauthorized) returned body: \"{\\\"errors\\\":[{\\\"id\\\":\\\"R008\\\",\\\"title\\\":\\\"Unauthorized access\\\"}]}\"", err:(*errors.errorString)(0xc0000b2910)}) Test: TestIntegration/FsMkdir/FsNewObjectNotFound 2025/10/09 02:49:25 DEBUG : pacer: Reducing sleep to 2.53410816s fstests.go:732: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:732 Error: Not equal: expected: *errors.errorString(&errors.errorString{s:"object not found"}) actual : *fmt.wrapError(&fmt.wrapError{msg:"couldn't list files: HTTP error 401 (401 Unauthorized) returned body: \"{\\\"errors\\\":[{\\\"id\\\":\\\"R008\\\",\\\"title\\\":\\\"Unauthorized access\\\"}]}\"", err:(*errors.errorString)(0xc0000b2b10)}) Test: TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2025/10/09 02:49:29 DEBUG : pacer: Reducing sleep to 1.90058112s 2025/10/09 02:49:31 DEBUG : pacer: Reducing sleep to 1.42543584s fstests.go:767: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:767 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:138 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:761 Error: Not equal: expected: *errors.errorString(&errors.errorString{s:"object not found"}) actual : *fmt.wrapError(&fmt.wrapError{msg:"couldn't list files: HTTP error 401 (401 Unauthorized) returned body: \"{\\\"errors\\\":[{\\\"id\\\":\\\"R008\\\",\\\"title\\\":\\\"Unauthorized access\\\"}]}\"", err:(*errors.errorString)(0xc0000b3080)}) Test: TestIntegration/FsMkdir/FsPutError === RUN TestIntegration/FsMkdir/FsPutZeroLength 2025/10/09 02:49:33 DEBUG : pacer: Reducing sleep to 1.06907688s fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:236 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:275 Error: Received unexpected error: couldn't list files: HTTP error 401 (401 Unauthorized) returned body: "{\"errors\":[{\"id\":\"R008\",\"title\":\"Unauthorized access\"}]}" Test: TestIntegration/FsMkdir/FsPutZeroLength Messages: PutLarge === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:786: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:819: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:868: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2025/10/09 02:49:35 DEBUG : pacer: Reducing sleep to 801.80766ms fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:162 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:224 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:214 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:953 /usr/local/go/src/runtime/asm_amd64.s:1700 Error: Received unexpected error: couldn't list files: HTTP error 401 (401 Unauthorized) returned body: "{\"errors\":[{\"id\":\"R008\",\"title\":\"Unauthorized access\"}]}" Test: TestIntegration/FsMkdir/FsPutFiles Messages: Put === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2364: *zoho.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2485: *zoho.Fs does not implement SetCopyCutoff === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2025/10/09 02:49:36 DEBUG : pacer: Reducing sleep to 601.355745ms === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2025/10/09 02:49:36 DEBUG : pacer: Reducing sleep to 451.016808ms fstests.go:146: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:146 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:162 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:224 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:214 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:2579 /usr/local/go/src/runtime/asm_amd64.s:1700 Error: Received unexpected error: couldn't list files: HTTP error 401 (401 Unauthorized) returned body: "{\"errors\":[{\"id\":\"R008\",\"title\":\"Unauthorized access\"}]}" Test: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize Messages: Put === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/10/09 02:49:36 DEBUG : Creating backend with remote "TestZoho:rclone-test-devexum4nuzo/deeper/nonexisting/directory" 2025/10/09 02:49:36 DEBUG : Config file has changed externally - reloading === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2625: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2668: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2725: FS has no Directory methods and doesn't Wrap 2025/10/09 02:49:37 DEBUG : pacer: Reducing sleep to 338.262606ms === NAME TestIntegration/FsMkdir fstests.go:2807: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:2807 Error: Received unexpected error: HTTP error 401 (401 Unauthorized) returned body: "{\"errors\":[{\"id\":\"R008\",\"title\":\"Unauthorized access\"}]}" Test: TestIntegration/FsMkdir 2025/10/09 02:49:38 DEBUG : pacer: Reducing sleep to 253.696954ms === RUN TestIntegration/FsShutdown fstests.go:2831: Shutdown method not supported --- FAIL: TestIntegration (2847.56s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.16s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.11s) --- FAIL: TestIntegration/FsMkdir (2845.44s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.71s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.04s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.04s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.04s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- FAIL: TestIntegration/FsMkdir/FsEncoding (2822.07s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.65s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.76s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.82s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/punctuation (512.66s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/leading_space (41.96s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/leading_tilde (16.04s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/leading_CR (538.82s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/leading_LF (24.78s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/leading_HT (15.95s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/leading_VT (544.93s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/leading_dot (17.54s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/trailing_space (15.91s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/trailing_CR (547.37s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/trailing_LF (15.95s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/trailing_HT (376.09s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/trailing_VT (99.89s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/trailing_dot (33.22s) --- SKIP: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.00s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/URL_encoding (18.69s) --- FAIL: TestIntegration/FsMkdir/FsNewObjectNotFound (10.51s) --- FAIL: TestIntegration/FsMkdir/FsPutError (5.92s) --- FAIL: TestIntegration/FsMkdir/FsPutZeroLength (1.90s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles (1.43s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- FAIL: TestIntegration/FsMkdir/FsUploadUnknownSize (1.87s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (1.07s) --- FAIL: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.80s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.47s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- SKIP: TestIntegration/FsShutdown (0.00s) FAIL exit status 1 FAIL github.com/rclone/rclone/backend/zoho 2847.584s "go test -v -timeout 2h0m0s -remote TestZoho: -verbose" - Finished ERROR in 47m28.559043557s (try 1/5): exit status 1: Failed [TestIntegration/FsMkdir/FsEncoding/punctuation TestIntegration/FsMkdir/FsEncoding/leading_space TestIntegration/FsMkdir/FsEncoding/leading_tilde TestIntegration/FsMkdir/FsEncoding/leading_CR TestIntegration/FsMkdir/FsEncoding/leading_LF TestIntegration/FsMkdir/FsEncoding/leading_HT TestIntegration/FsMkdir/FsEncoding/leading_VT TestIntegration/FsMkdir/FsEncoding/leading_dot TestIntegration/FsMkdir/FsEncoding/trailing_space TestIntegration/FsMkdir/FsEncoding/trailing_CR TestIntegration/FsMkdir/FsEncoding/trailing_LF TestIntegration/FsMkdir/FsEncoding/trailing_HT TestIntegration/FsMkdir/FsEncoding/trailing_VT TestIntegration/FsMkdir/FsEncoding/trailing_dot TestIntegration/FsMkdir/FsEncoding/URL_encoding TestIntegration/FsMkdir/FsNewObjectNotFound TestIntegration/FsMkdir/FsPutError TestIntegration/FsMkdir/FsPutZeroLength TestIntegration/FsMkdir/FsPutFiles TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize]