"go test -v -timeout 2h0m0s -remote TestZoho: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^(FsCopy|FsDirMove|FsListDirFile2|FsListFile1|FsListFile1and2|FsListLevel2|FsListR|FsMove|FsPurge|FsPurgeRoot|ObjectOpen|ObjectOpenRange|ObjectOpenSeek|ObjectPartialRead|ObjectRemove|ObjectUpdate)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^FromRoot$/^(List|ListEntries)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^FromRoot$/^Put$/^Remove$|^TestIntegration$/^FsMkdir$/^FsPutZeroLength$'" - Starting (try 2/5)
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestZoho:"
2025/11/09 02:26:19 DEBUG : Creating backend with remote "TestZoho:rclone-test-xofejuy0figo"
2025/11/09 02:26:19 DEBUG : Using config file from "/home/rclone/.rclone.conf"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsPutZeroLength
2025/11/09 02:26:21 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 09 Nov 2025 02:26:21 UTC": parsing time "Sun, 09 Nov 2025 02:26:21 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 09 Nov 2025 02:26:21 UTC" as " "
2025/11/09 02:26:21 ERROR : zoho: missing OAuth Scope. Run rclone config reconnect to fix this issue.
    fstests.go:262: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:262
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:275
        	Error:      	Received unexpected error:
        	            	HTTP error 401 (401 INVALID_OAUTHSCOPE) returned body: "{\"ERROR_MESSAGE\":\"INVALID_OAUTHSCOPE\",\"ERROR_CODE\":401}"
        	Test:       	TestIntegration/FsMkdir/FsPutZeroLength
=== RUN   TestIntegration/FsMkdir/FsPutFiles
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2
    fstests.go:979: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:979
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:998
        	Error:      	Not equal: 
        	            	expected: []string{"file name.txt"}
        	            	actual  : []string{"file name.txt", "zero-length-file"}
        	            	
        	            	Diff:
        	            	--- Expected
        	            	+++ Actual
        	            	@@ -1,3 +1,4 @@
        	            	-([]string) (len=1) {
        	            	- (string) (len=13) "file name.txt"
        	            	+([]string) (len=2) {
        	            	+ (string) (len=13) "file name.txt",
        	            	+ (string) (len=16) "zero-length-file"
        	            	 }
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListR
    fstests.go:1021: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1021
        	Error:      	Not equal: 
        	            	expected: []string{"file name.txt", "hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"}
        	            	actual  : []string{"file name.txt", "hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt", "zero-length-file"}
        	            	
        	            	Diff:
        	            	--- Expected
        	            	+++ Actual
        	            	@@ -1,4 +1,5 @@
        	            	-([]string) (len=2) {
        	            	+([]string) (len=3) {
        	            	  (string) (len=13) "file name.txt",
        	            	- (string) (len=60) "hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"
        	            	+ (string) (len=60) "hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt",
        	            	+ (string) (len=16) "zero-length-file"
        	            	 }
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsListR
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListLevel2
    fstests.go:1093: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1093
        	Error:      	Not equal: 
        	            	expected: []string{"file name.txt"}
        	            	actual  : []string{"file name.txt", "zero-length-file"}
        	            	
        	            	Diff:
        	            	--- Expected
        	            	+++ Actual
        	            	@@ -1,3 +1,4 @@
        	            	-([]string) (len=1) {
        	            	- (string) (len=13) "file name.txt"
        	            	+([]string) (len=2) {
        	            	+ (string) (len=13) "file name.txt",
        	            	+ (string) (len=16) "zero-length-file"
        	            	 }
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsListLevel2
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListFile1
    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:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1107
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsListFile1
        	Messages:   	listing wrong, want
        	            	  file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
        	            	  file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), zero-length-file (0)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1107
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsListFile1
        	Messages:   	Unexpected file "zero-length-file"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2
    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:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1134
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2
        	Messages:   	listing wrong, want
        	            	  file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
        	            	  file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), zero-length-file (0)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1134
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2
        	Messages:   	Unexpected file "zero-length-file"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPurge
2025/11/09 02:26:39 DEBUG : Too many requests. Trying again in 60 seconds.
2025/11/09 02:26: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/11/09 02:26:39 DEBUG : pacer: Rate limited, increasing sleep to 1m0s
2025/11/09 02:26:39 DEBUG : Too many requests. Trying again in 60 seconds.
2025/11/09 02:26: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/11/09 02:27:40 DEBUG : Too many requests. Trying again in 60 seconds.
2025/11/09 02:27:40 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/11/09 02:28:40 DEBUG : Too many requests. Trying again in 60 seconds.
2025/11/09 02:28:40 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/11/09 02:29:40 DEBUG : Too many requests. Trying again in 60 seconds.
2025/11/09 02:29:40 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/11/09 02:30:40 DEBUG : Too many requests. Trying again in 60 seconds.
2025/11/09 02:30:40 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/11/09 02:31:40 DEBUG : pacer: Reducing sleep to 45s
2025/11/09 02:32:39 DEBUG : TestZoho: Token expired
2025/11/09 02:32:39 DEBUG : Config file has changed externally - reloading
2025/11/09 02:32:39 DEBUG : TestZoho: No updated token found in the config file
2025/11/09 02:32:40 DEBUG : TestZoho: Token refresh successful
2025/11/09 02:32:40 DEBUG : Saving config "token" in section "TestZoho" of the config file
2025/11/09 02:32:40 DEBUG : TestZoho: Saved new token in config file
2025/11/09 02:32:40 DEBUG : pacer: Reducing sleep to 33.75s
2025/11/09 02:33:25 DEBUG : pacer: Reducing sleep to 25.3125s
2025/11/09 02:33:58 DEBUG : pacer: Reducing sleep to 18.984375s
2025/11/09 02:34:23 DEBUG : pacer: Reducing sleep to 14.23828125s
2025/11/09 02:34:42 DEBUG : pacer: Reducing sleep to 10.678710937s
2025/11/09 02:34:57 DEBUG : pacer: Reducing sleep to 8.009033202s
2025/11/09 02:35:07 DEBUG : pacer: Reducing sleep to 6.006774901s
2025/11/09 02:35:15 DEBUG : pacer: Reducing sleep to 4.505081175s
2025/11/09 02:35:21 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/11/09 02:35:26 DEBUG : pacer: Reducing sleep to 2.53410816s
2025/11/09 02:35:29 DEBUG : pacer: Reducing sleep to 1.90058112s
2025/11/09 02:35:32 DEBUG : pacer: Reducing sleep to 1.42543584s
2025/11/09 02:35:34 DEBUG : pacer: Reducing sleep to 1.06907688s
2025/11/09 02:35:35 DEBUG : pacer: Reducing sleep to 801.80766ms
2025/11/09 02:35:36 DEBUG : pacer: Reducing sleep to 601.355745ms
2025/11/09 02:35:37 DEBUG : pacer: Reducing sleep to 451.016808ms
    fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
    fstest.go:301: Flushing the directory cache
2025/11/09 02:35:39 DEBUG : pacer: Reducing sleep to 338.262606ms
2025/11/09 02:35:40 DEBUG : pacer: Reducing sleep to 253.696954ms
2025/11/09 02:35:40 DEBUG : pacer: Reducing sleep to 190.272715ms
2025/11/09 02:35:40 DEBUG : pacer: Reducing sleep to 142.704536ms
2025/11/09 02:35:40 DEBUG : pacer: Reducing sleep to 107.028402ms
2025/11/09 02:35:40 DEBUG : pacer: Reducing sleep to 80.271301ms
2025/11/09 02:35:41 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:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1163
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsPurge
        	Messages:   	listing wrong, want
        	            	  dirToPurge/fileToPurge.txt (100), file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
        	            	  dirToPurge/fileToPurge.txt (100), file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), zero-length-file (0)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1163
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsPurge
        	Messages:   	Unexpected file "zero-length-file"
2025/11/09 02:35:45 DEBUG : pacer: Reducing sleep to 45.152606ms
2025/11/09 02:35:45 DEBUG : pacer: Reducing sleep to 33.864454ms
2025/11/09 02:35:45 DEBUG : pacer: Reducing sleep to 25.39834ms
2025/11/09 02:35:45 DEBUG : pacer: Reducing sleep to 19.048755ms
2025/11/09 02:35:45 DEBUG : pacer: Reducing sleep to 14.286566ms
2025/11/09 02:35:45 DEBUG : pacer: Reducing sleep to 10.714924ms
2025/11/09 02:35:45 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:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1175
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsPurge
        	Messages:   	listing wrong, want
        	            	  file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
        	            	  file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), zero-length-file (0)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1175
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsPurge
        	Messages:   	Unexpected file "zero-length-file"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot
    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:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1200
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot
        	Messages:   	listing wrong, want
        	            	  dirToPurgeFromRoot/fileToPurgeFromRoot.txt (100), file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
        	            	  dirToPurgeFromRoot/fileToPurgeFromRoot.txt (100), file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), zero-length-file (0)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1200
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot
        	Messages:   	Unexpected file "zero-length-file"
2025/11/09 02:36:02 DEBUG : Creating backend with remote "TestZoho:rclone-test-xofejuy0figo/dirToPurgeFromRoot"
    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:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1217
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot
        	Messages:   	listing wrong, want
        	            	  file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
        	            	  file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), zero-length-file (0)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1217
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot
        	Messages:   	Unexpected file "zero-length-file"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsCopy
    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:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1270
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsCopy
        	Messages:   	listing wrong, want
        	            	  file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy (100) got
        	            	  file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt-copy (100), zero-length-file (0)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1270
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsCopy
        	Messages:   	Unexpected file "zero-length-file"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata
    fstests.go:1289: Skipping test as can't write metadata
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsMove
2025/11/09 02:36:20 DEBUG : Too many requests. Trying again in 60 seconds.
2025/11/09 02:36:20 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/11/09 02:36:20 DEBUG : pacer: Rate limited, increasing sleep to 1m0s
2025/11/09 02:36:20 DEBUG : Too many requests. Trying again in 60 seconds.
2025/11/09 02:36:20 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/11/09 02:37:21 DEBUG : pacer: low level retry 3/10 (error HTTP error 502 (502 Bad Gateway) returned body: "<!DOCTYPE html>\n<html lang=\"en\">\n<head>\n\t<meta charset=\"UTF-8\">\n\t<meta name=\"viewport\" content=\"width=device-width, initial-scale=1.0\">\n\t<link rel=\"icon\" href=\"https://www.zohowebstatic.com/sites/zweb/images/favicon.ico\" type=\"image/vnd.microsoft.icon\">\n\t<title>Zoho - Temporarily Unavailable</title>\n\t<style>\n\t\t@font-face {\n\t\t\tfont-family: 'Zoho_Puvi_Bold';\n\t\t\tsrc: url('https://static.zohocdn.com/zohofonts/zohopuvi/4.0/Zoho_Puvi_Bold.eot');\n\t\t\tsrc: url('https://static.zohocdn.com/zohofonts/zohopuvi/4.0/Zoho_Puvi_Bold.eot') format('embedded-opentype'),url('https://static.zohocdn.com/zohofonts/zohopuvi/4.0/Zoho_Puvi_Bold.woff2') format('woff2'),url('https://static.zohocdn.com/zohofonts/zohopuvi/4.0/Zoho_Puvi_Bold.otf') format('opentype');\n\t\t\tfont-weight: normal;\n\t\t\tfont-style: normal;\n\t\t\tfont-display: swap\n\t\t}\n\n\t\t@font-face {\n\t\t\tfont-family: 'Zoho_Puvi_Regular';\n\t\t\tsrc: url('https://static.zohocdn.com/zohofonts/zohopuvi/4.0/Zoho_Puvi_Regular.eot');\n\t\t\tsrc: url('https://static.zohocdn.com/zohofonts/zohopuvi/4.0/Zoho_Puvi_Regular.eot') format('embedded-opentype'),url('https://static.zohocdn.com/zohofonts/zohopuvi/4.0/Zoho_Puvi_Regular.woff2') format('woff2'),url('https://static.zohocdn.com/zohofonts/zohopuvi/4.0/Zoho_Puvi_Regular.otf') format('opentype');\n\t\t\tfont-weight: normal;\n\t\t\tfont-style: normal;\n\t\t\tfont-display: swap\n\t\t}\n\n\t\t:root {\n\t\t\t--zf-primary-regular: 'Zoho_Puvi_Regular';\n\t\t\t--zf-primary-bold: 'Zoho_Puvi_Bold';\n\t\t\t--common-elements: url(https://www.zohowebstatic.com/sites/zweb/images/commonroot/common-elements.svg);\n\t\t}\n\n\t\t* {\n\t\t\tfont-family: var(--zf-primary-regular);\n\t\t\tbox-sizing: border-box;\n\t\t\t-webkit-user-select: none;\n\t\t\t-moz-user-select: none;\n\t\t\t-ms-user-select: none;\n\t\t\tuser-select: none;\n\t\t}\n\n\t\t*, :after, :before, header *, footer * {\n\t\t\tbox-sizing: border-box;\n\t\t}\n\n\t\th1 {\n\t\t\tdisplay: block;\n\t\t\tfont-size: 2em;\n\t\t\tmargin-block-start: 0.67em;\n\t\t\tmargin-block-end: 0.67em;\n\t\t\tmargin-inline-start: 0px;\n\t\t\tmargin-inline-end: 0px;\n\t\t\tfont-weight: bold;\n\t\t}\n\n\t\tp {\n\t\t\tdisplay: block;\n\t\t\tmargin-block-start: 1em;\n\t\t\tmargin-block-end: 1em;\n\t\t\tmargin-inline-start: 0px;\n\t\t\tmargin-inline-end: 0px;\n\t\t}\n\n\t\ta, div, img, h1, p, footer {\n\t\t\tmargin: 0;\n\t\t\tpadding: 0;\n\t\t\tborder: 0;\n\t\t\tfont: inherit;\n\t\t\tvertical-align: baseline;\n\t\t\tfont-variant-ligatures: none;\n\t\t}\n\n\t\timg{\n\t\t\tmax-width: 100%;\n\t\t\theight: auto;\n\t\t}\n\n\t\ta {\n\t\t\tcolor: #03abf6;\n\t\t\ttext-decoration: none;\n\t\t\toutline: 0;\n\t\t}\n\n\t\th1, h2, h3 {\n\t\t\tmargin-top: 15px;\n\t\t\tmargin-bottom: 15px;\n\t\t}\n\t\t\n\t\th1 {\n\t\t\tfont-family: var(--zf-primary-bold);\n\t\t\tletter-spacing: -0.1px;\n\t\t\tfont-size: 44px;\n\t\t\tcolor: black;\n\t\t}\n\n\t\th2 {\n\t\t\tfont-family: var(--zf-primary-regular);\n\t\t\tfont-size:14px;\n\t\t\tfont-weight:normal;\n\t\t}\n\n\t\th3 {\n\t\t\tfont-family: var(--zf-primary-regular);\n\t\t\tfont-size:20px;\n\t\t}\n\n\t\t.template-inner {\n\t\t\tpadding: 8% 0;\n\t\t}\n\n\t\t.main {\n\t\t\tmax-width: 1280px;\n\t\t\tmargin: 10px auto 10px;\n\t\t\tpadding: 0 50px 0 50px;\n\t\t\tposition: relative;\n\t\t}\n\n\t\t.social-media-links {\n\t\t\twidth: 55%;\n\t\t\tdisplay: inline-block;\n\t\t}\n\n\t\t.zoho-logo img {\n\t\t\tmax-width: 120px;\n\t\t\tmargin-top: 60px;\n\t\t}\n\n\t\t.zoho-social {\n\t\t\ttext-align: center;\n\t\t\tdisplay: flex;\n\t\t\tjustify-content: center;\n\t\t\tmargin-top: 30px;\n\t\t\tmargin-bottom: 30px;\n\t\t}\n\n\t\t.zoho-social a.zicon {\n\t\t\twidth: 21px;\n\t\t\theight: 21px;\n\t\t\tdisplay: inline-block;\n\t\t\tmargin: 0 5px;\n\t\t\toverflow: hidden;\n\t\t\ttext-indent: -9999px;\n\t\t\tborder: 0;\n\t\t\tpadding: 0;\n\t\t\tbackground-image: var(--common-elements);\n\t\t\tbackground-size: 650px auto;\n\t\t\tbackground-repeat: no-repeat;\n\t\t}\n\n\t\t.zoho-social .zicon.twitter {\n\t\t\tbackground-position: -170px 0;\n\t\t}\n\n\t\t.zoho-social .zicon.facebook {\n\t\t\tbackground-position: -147px 0;\n\t\t\ttransform: scale(1.10);\n\t\t}\n\n\t\t.zoho-social .zicon.youtube {\n\t\t\tbackground-position: -235px 0;\n\t\t\theight: 20px;\n\t\t\twidth: 29px;\n\t\t}\n\n\t\t.zoho-social .zicon.linkedin {\n\t\t\tbackground-position: -196px 0;\n\t\t\ttransform: scale(1.10);\n\t\t\ttransform-origin: top;\n\t\t\theight: 19px;\n\t\t\twidth: 20px;\n\t\t}\n\n\t\t.zoho-social .zicon.instagram {\n\t\t\tbackground-position: -266px 0;\n\t\t\theight: 20px;\n\t\t\twidth: 20px;\n\t\t}\n\n\t\t.image-wrapper {\n\t\t\twidth: 44%;\n\t\t\tdisplay: inline-block;\n\t\t\tvertical-align: top;\n\t\t}\n\n\t\t.image-wrapper img {\n\t\t\twidth: 425px;\n\t\t\tmargin-top: 30px;\n\t\t}\n\n\t\t.inner-content {\n\t\t\tmargin: 0px auto;\n\t\t\tpadding: 25px 0px 25px 0px;\t\n\t\t\tcolor: #58595a;\n\t\t}\n\n\t\t.zoho-copyright {\n\t\t\tpadding: 20px 0;\n\t\t}\n\n\t\t.content-wrap {\n\t\t\tposition: relative;\n\t\t\twidth: 90%;\n\t\t\tmax-width: 1280px;\n\t\t\tmargin: 0 auto;\n\t\t}\n\n\t\t.content-body .zoho-copyright .content-wrap {\n\t\t\tdisplay: flex;\n\t\t\tjustify-content: center;\n\t\t\tmargin: 0 auto;\n\t\t\tmax-width: 1280px;\n\t\t}\n\n\t\t.content-body .zoho-copyright p {\n\t\t\tfont-size: 13px;\n\t\t\tpadding: 0;\n\t\t\ttext-align: center;\n\t\t}\n\n\t\t@media all and (max-width: 1024px) {\n\t\t\t.main {\n\t\t\t\tpadding:20px;\n\t\t\t\tmargin: 30px auto 0\n\t\t\t}\n\n\t\t\th1 {\n\t\t\t\tfont-size: 28px;\n\t\t\t\tmargin: 20px 0\n\t\t\t}\n\n\t\t\t.zoho-logo img {\n\t\t\t\tmargin-top: 0;\n\t\t\t\tmax-width: 100px\n\t\t\t}\n\n\t\t\t.social-media-links ,.image-wrapper {\n\t\t\t\twidth: 100%\n\t\t\t}\n\n\t\t\t.footer {\n\t\t\t\tmargin-top: 30px;\n\t\t\t\tposition: relative\n\t\t\t}\n\n\t\t\t.social-media-links ,.image-wrapper {\n\t\t\t\ttext-align: center\n\t\t\t}\n\n\t\t\t.zoho-social {\n\t\t\t\tmargin-top: 15px;\n\t\t\t\tmargin-bottom: 15px;\n\t\t\t}\n\t\t\t\n\t\t\t.image-wrapper img {\n\t\t\t\tmax-width: 500px;\n\t\t\t\tmargin-top: 0\n\t\t\t}\n\n\t\t\t.social-media-links, .social-media-links .inner-content, .social-media-links .zoho-logo, .social-media-links .image-wrapper {\n\t\t\t\ttext-align: center\n\t\t\t}\n\t\t}\n\n\t\t@media all and (max-width: 767px) {\n\t\t\t.image-wrapper img {\n\t\t\t\tmax-width:100%;\n\t\t\t\tmargin-top: 0\n\t\t\t}\n\t\t}\n\t\t\n\t\t@media all and (max-width: 480px) {\n\t\t\t.zoho-social a.zicon {\n\t\t\t    width: 18px;\n\t\t\t\theight: 17px;\n\t\t\t\tbackground-size: 550px auto;\n\t\t\t}\n\t\t\t\n\t\t\t.zoho-social .zicon.twitter {\n\t\t\t    background-position: -145px 0;\n\t\t\t}\n\t\t\t\n\t\t\t.zoho-social .zicon.facebook {\n\t\t\t\tbackground-position: -124px 0;\n\t\t\t\ttransform-origin: bottom;\n\t\t\t}\n\t\t\t\n\t\t\t.zoho-social .zicon.youtube {\n\t\t\t\tbackground-position: -199px 0;\n\t\t\t\theight: 17px;\n\t\t\t\twidth: 25px;\n\t\t\t}\n\t\t\t\n\t\t\t.zoho-social .zicon.linkedin {\n\t\t\t\tbackground-position: -165px 0;\n\t\t\t\theight: 15px;\n\t\t\t\twidth: 18px;\n\t\t\t}\n\t\t\t\n\t\t\t.zoho-social .zicon.instagram {\n\t\t\t\tbackground-position: -225px 0;\n\t\t\t\theight: 17px;\n\t\t\t\twidth: 17px;\n\t\t\t}\n\t\t}\n\n\t</style>\n</head>\n\n<body class=\"content-body\">\n\t<main>\n\t\t<div class=\"template-inner\">\n\t\t\t<div class=\"wrapper\">\n\t\t\t\t<div class=\"main\">\n\t\t\t\t\t<div class=\"content\">\n\t\t\t\t\t\t<div class=\"social-media-links\">\n\t\t\t\t\t\t\t<div class=\"zoho-logo\">\n\t\t\t\t\t\t\t\t<a href=\"https://www.zoho.com/\">\n\t\t\t\t\t\t\t\t\t<img alt=\"Zoho\" width=\"120\" height=\"42\" src=\"https://www.zohowebstatic.com/sites/zweb/images/commonroot/zoho-logo-web.svg\">\n\t\t\t\t\t\t\t\t</a>\n\t\t\t\t\t\t\t</div>\n\t\t\t\t\t\t\t<div class=\"inner-content\">\n\t\t\t\t\t\t\t\t<h1>We'll be right back!</h1>\n\t\t\t\t\t\t\t\t<h2>Our service is temporarily unavailable. We are currently working to restore it.</h2>\n\t\t\t\t\t\t\t\t<h3>Please try again later.</h3>\n\t\t\t\t\t\t\t</div>\n\t\t\t\t\t\t\t<div class=\"zoho-social\">\n\t\t\t\t\t\t\t\t<a class=\"zicon twitter\" href=\"https://twitter.com/zoho\" target=\"_blank\" rel=\"noopener\">Twitter</a>\n\t\t\t\t\t\t\t\t<a class=\"zicon facebook\" href=\"https://www.facebook.com/zoho/\" target=\"_blank\" rel=\"noopener\">Facebook</a>\n\t\t\t\t\t\t\t\t<a class=\"zicon youtube\" href=\"https://www.youtube.com/zoho\" target=\"_blank\" rel=\"noopener\">Youtube</a>\n\t\t\t\t\t\t\t\t<a class=\"zicon linkedin\" href=\"https://www.linkedin.com/company/zohocorp/\" target=\"_blank\" rel=\"noopener\">Linkedin</a>\n\t\t\t\t\t\t\t\t<a class=\"zicon instagram\" href=\"https://www.instagram.com/zoho/\" target=\"_blank\" rel=\"noopener\">Instagram</a>\n\t\t\t\t\t\t\t</div>\n\t\t\t\t\t\t</div>\n\t\t\t\t\t\t<div class=\"image-wrapper\">\n\t\t\t\t\t\t\t<img alt=\"zoho-5xx\" width=\"425\" height=\"425\" src=\"https://zohowebstatic.com/sites/zweb/images/zoho_general_pages/icon_setting.png\">\n\t\t\t\t\t\t</div>\n\t\t\t\t\t</div>\n\t\t\t\t</div>\n\t\t\t</div>\n\t\t</div>\n\t</main>\n\t<footer>\n\t\t<div class=\"zoho-copyright\">\n\t\t\t<div class=\"content-wrap bottom-animated\">\n\t\t\t\t<p>© <span id=\"50xCurrentYear\"></span>, Zoho Corporation Pvt. Ltd. All Rights Reserved.</p>\n\t\t\t</div>\n\t\t</div>\n\t\t<script>\n\t\t\tconst currentYear = new Date().getFullYear();\n\t\t\tdocument.getElementById(\"50xCurrentYear\").textContent = currentYear;\n\t\t</script>\n\t</footer>\n</body>\n</html>\n")
2025/11/09 02:38:21 DEBUG : pacer: Reducing sleep to 45s
2025/11/09 02:39:20 DEBUG : pacer: Reducing sleep to 33.75s
2025/11/09 02:40:05 DEBUG : pacer: Reducing sleep to 25.3125s
2025/11/09 02:40:39 DEBUG : pacer: Reducing sleep to 18.984375s
2025/11/09 02:41:04 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/11/09 02:41:24 DEBUG : pacer: Reducing sleep to 10.678710937s
2025/11/09 02:41:37 DEBUG : pacer: Reducing sleep to 8.009033202s
2025/11/09 02:41:48 DEBUG : pacer: Reducing sleep to 6.006774901s
2025/11/09 02:41:56 DEBUG : pacer: Reducing sleep to 4.505081175s
2025/11/09 02:42:02 DEBUG : pacer: Reducing sleep to 3.378810881s
2025/11/09 02:42:07 DEBUG : pacer: Reducing sleep to 2.53410816s
    fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
    fstest.go:301: Flushing the directory cache
2025/11/09 02:42:10 DEBUG : pacer: Reducing sleep to 1.90058112s
2025/11/09 02:42:13 DEBUG : pacer: Reducing sleep to 1.42543584s
2025/11/09 02:42:14 DEBUG : pacer: Reducing sleep to 1.06907688s
2025/11/09 02:42:16 DEBUG : pacer: Reducing sleep to 801.80766ms
2025/11/09 02:42:17 DEBUG : pacer: Reducing sleep to 601.355745ms
2025/11/09 02:42:18 DEBUG : pacer: Reducing sleep to 451.016808ms
    fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:301: Flushing the directory cache
    fstest.go:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1362
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsMove
        	Messages:   	listing wrong, want
        	            	  file name.txt (100), other.txt (100) got
        	            	  file name.txt (100), other.txt (100), zero-length-file (0)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1362
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsMove
        	Messages:   	Unexpected file "zero-length-file"
2025/11/09 02:42:22 DEBUG : pacer: Reducing sleep to 338.262606ms
2025/11/09 02:42:22 DEBUG : pacer: Reducing sleep to 253.696954ms
2025/11/09 02:42:23 DEBUG : pacer: Reducing sleep to 190.272715ms
2025/11/09 02:42:23 DEBUG : pacer: Reducing sleep to 142.704536ms
2025/11/09 02:42:23 DEBUG : pacer: Reducing sleep to 107.028402ms
2025/11/09 02:42:23 DEBUG : pacer: Reducing sleep to 80.271301ms
2025/11/09 02:42:23 DEBUG : pacer: Reducing sleep to 60.203475ms
2025/11/09 02:42:24 DEBUG : pacer: Reducing sleep to 45.152606ms
2025/11/09 02:42:24 DEBUG : pacer: Reducing sleep to 33.864454ms
2025/11/09 02:42:24 DEBUG : pacer: Reducing sleep to 25.39834ms
2025/11/09 02:42:24 DEBUG : pacer: Reducing sleep to 19.048755ms
2025/11/09 02:42:24 DEBUG : pacer: Reducing sleep to 14.286566ms
2025/11/09 02:42:24 DEBUG : pacer: Reducing sleep to 10.714924ms
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:301: Flushing the directory cache
2025/11/09 02:42:25 DEBUG : pacer: Reducing sleep to 10ms
    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:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1373
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsMove
        	Messages:   	listing wrong, want
        	            	  moveTest/other.txt (100), other.txt (100) got
        	            	  moveTest/other.txt (100), other.txt (100), zero-length-file (0)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1373
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsMove
        	Messages:   	Unexpected file "zero-length-file"
    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:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1381
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsMove
        	Messages:   	listing wrong, want
        	            	  file name.txt (100), other.txt (100) got
        	            	  file name.txt (100), other.txt (100), zero-length-file (0)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1381
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsMove
        	Messages:   	Unexpected file "zero-length-file"
    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:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1388
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsMove
        	Messages:   	listing wrong, want
        	            	  file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
        	            	  file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), zero-length-file (0)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:344
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1388
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsMove
        	Messages:   	Unexpected file "zero-length-file"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata
    fstests.go:1398: Skipping test as can't write metadata
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsDirMove
2025/11/09 02:42:52 DEBUG : Creating backend with remote "TestZoho:rclone-test-feguloj5zebe"
    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:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1485
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsDirMove
        	Messages:   	listing wrong, want
        	            	  new_name/sub_new_name/file name.txt (100), new_name/sub_new_name/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
        	            	  new_name/sub_new_name/file name.txt (100), new_name/sub_new_name/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), new_name/sub_new_name/zero-length-file (0)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1485
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsDirMove
        	Messages:   	Unexpected file "new_name/sub_new_name/zero-length-file"
    fstest.go:298: Sleeping for 1s for list eventual consistency: 1/3
    fstest.go:301: Flushing the directory cache
2025/11/09 02:43:07 DEBUG : Too many requests. Trying again in 60 seconds.
2025/11/09 02:43:07 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/11/09 02:43:07 DEBUG : pacer: Rate limited, increasing sleep to 1m0s
2025/11/09 02:43:07 DEBUG : Too many requests. Trying again in 60 seconds.
2025/11/09 02:43:07 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/11/09 02:44:07 DEBUG : Too many requests. Trying again in 60 seconds.
2025/11/09 02:44:07 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/11/09 02:45:07 DEBUG : Too many requests. Trying again in 60 seconds.
2025/11/09 02:45:07 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/11/09 02:46:07 DEBUG : Too many requests. Trying again in 60 seconds.
2025/11/09 02:46:07 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/11/09 02:47:08 DEBUG : Too many requests. Trying again in 60 seconds.
2025/11/09 02:47:08 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/11/09 02:48:07 DEBUG : pacer: Reducing sleep to 45s
2025/11/09 02:49:07 DEBUG : pacer: Reducing sleep to 33.75s
2025/11/09 02:49:52 DEBUG : pacer: Reducing sleep to 25.3125s
2025/11/09 02:50:26 DEBUG : pacer: Reducing sleep to 18.984375s
2025/11/09 02:50:51 DEBUG : pacer: Reducing sleep to 14.23828125s
2025/11/09 02:51:10 DEBUG : pacer: Reducing sleep to 10.678710937s
    fstest.go:298: Sleeping for 2s for list eventual consistency: 2/3
    fstest.go:301: Flushing the directory cache
2025/11/09 02:51:24 DEBUG : pacer: Reducing sleep to 8.009033202s
2025/11/09 02:51:35 DEBUG : pacer: Reducing sleep to 6.006774901s
2025/11/09 02:51:43 DEBUG : pacer: Reducing sleep to 4.505081175s
2025/11/09 02:51:49 DEBUG : pacer: Reducing sleep to 3.378810881s
2025/11/09 02:51:54 DEBUG : pacer: Reducing sleep to 2.53410816s
2025/11/09 02:51:57 DEBUG : pacer: Reducing sleep to 1.90058112s
    fstest.go:298: Sleeping for 4s for list eventual consistency: 3/3
    fstest.go:301: Flushing the directory cache
    fstest.go:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1499
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsDirMove
        	Messages:   	listing wrong, want
        	            	  file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
        	            	  file name.txt (100), hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), zero-length-file (0)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1499
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FsDirMove
        	Messages:   	Unexpected file "zero-length-file"
2025/11/09 02:52:01 DEBUG : zoho root 'rclone-test-feguloj5zebe': Purge remote
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectOpen
2025/11/09 02:52:02 DEBUG : pacer: Reducing sleep to 1.42543584s
2025/11/09 02:52:04 DEBUG : pacer: Reducing sleep to 1.06907688s
2025/11/09 02:52:05 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 09 Nov 2025 02:52:05 UTC": parsing time "Sun, 09 Nov 2025 02:52:05 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 09 Nov 2025 02:52:05 UTC" as " "
2025/11/09 02:52:05 ERROR : zoho: missing OAuth Scope. Run rclone config reconnect to fix this issue.
2025/11/09 02:52:05 DEBUG : pacer: Reducing sleep to 801.80766ms
    fstests.go:287: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:287
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1772
        	Error:      	Received unexpected error:
        	            	HTTP error 401 (401 INVALID_OAUTHSCOPE) returned body: "{\"ERROR_MESSAGE\":\"INVALID_OAUTHSCOPE\",\"ERROR_CODE\":401}"
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/ObjectOpen
        	Messages:   	readObject("file name.txt") limit=-1, options=[]
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek
2025/11/09 02:52:06 DEBUG : pacer: Reducing sleep to 601.355745ms
2025/11/09 02:52:07 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 09 Nov 2025 02:52:07 UTC": parsing time "Sun, 09 Nov 2025 02:52:07 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 09 Nov 2025 02:52:07 UTC" as " "
2025/11/09 02:52:07 ERROR : zoho: missing OAuth Scope. Run rclone config reconnect to fix this issue.
2025/11/09 02:52:07 DEBUG : pacer: Reducing sleep to 451.016808ms
    fstests.go:287: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:287
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1779
        	Error:      	Received unexpected error:
        	            	HTTP error 401 (401 INVALID_OAUTHSCOPE) returned body: "{\"ERROR_MESSAGE\":\"INVALID_OAUTHSCOPE\",\"ERROR_CODE\":401}"
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek
        	Messages:   	readObject("file name.txt") limit=-1, options=[SeekOption(50)]
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange
2025/11/09 02:52:08 DEBUG : pacer: Reducing sleep to 338.262606ms
2025/11/09 02:52:08 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 09 Nov 2025 02:52:08 UTC": parsing time "Sun, 09 Nov 2025 02:52:08 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 09 Nov 2025 02:52:08 UTC" as " "
2025/11/09 02:52:08 ERROR : zoho: missing OAuth Scope. Run rclone config reconnect to fix this issue.
2025/11/09 02:52:08 DEBUG : pacer: Reducing sleep to 253.696954ms
    fstests.go:287: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:287
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1798
        	Error:      	Received unexpected error:
        	            	HTTP error 401 (401 INVALID_OAUTHSCOPE) returned body: "{\"ERROR_MESSAGE\":\"INVALID_OAUTHSCOPE\",\"ERROR_CODE\":401}"
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange
        	Messages:   	readObject("file name.txt") limit=-1, options=[RangeOption(5,15)]
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead
2025/11/09 02:52:08 DEBUG : pacer: Reducing sleep to 190.272715ms
2025/11/09 02:52:09 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 09 Nov 2025 02:52:09 UTC": parsing time "Sun, 09 Nov 2025 02:52:09 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 09 Nov 2025 02:52:09 UTC" as " "
2025/11/09 02:52:09 ERROR : zoho: missing OAuth Scope. Run rclone config reconnect to fix this issue.
2025/11/09 02:52:09 DEBUG : pacer: Reducing sleep to 142.704536ms
    fstests.go:287: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:287
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1809
        	Error:      	Received unexpected error:
        	            	HTTP error 401 (401 INVALID_OAUTHSCOPE) returned body: "{\"ERROR_MESSAGE\":\"INVALID_OAUTHSCOPE\",\"ERROR_CODE\":401}"
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead
        	Messages:   	readObject("file name.txt") limit=50, options=[]
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate
2025/11/09 02:52:09 DEBUG : pacer: Reducing sleep to 107.028402ms
2025/11/09 02:52:09 DEBUG : pacer: Reducing sleep to 80.271301ms
2025/11/09 02:52:09 DEBUG : pacer: Reducing sleep to 60.203475ms
2025/11/09 02:52:10 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Sun, 09 Nov 2025 02:52:10 UTC": parsing time "Sun, 09 Nov 2025 02:52:10 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 09 Nov 2025 02:52:10 UTC" as " "
2025/11/09 02:52:10 ERROR : zoho: missing OAuth Scope. Run rclone config reconnect to fix this issue.
2025/11/09 02:52:10 DEBUG : pacer: Reducing sleep to 45.152606ms
    fstests.go:287: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:287
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1840
        	Error:      	Received unexpected error:
        	            	HTTP error 401 (401 INVALID_OAUTHSCOPE) returned body: "{\"ERROR_MESSAGE\":\"INVALID_OAUTHSCOPE\",\"ERROR_CODE\":401}"
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate
        	Messages:   	readObject("file name.txt") limit=-1, options=[]
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot
    fstests.go:1911: Opening root remote "TestZoho:" path "rclone-test-xofejuy0figo" from "TestZoho:rclone-test-xofejuy0figo"
2025/11/09 02:52:10 DEBUG : Creating backend with remote "TestZoho:"
2025/11/09 02:52:10 DEBUG : Config file has changed externally - reloading
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot/List
    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:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1931
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FromRoot/List
        	Messages:   	listing wrong, want
        	            	  rclone-test-xofejuy0figo/file name.txt (200), rclone-test-xofejuy0figo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
        	            	  rclone-test-xofejuy0figo/file name.txt (200), rclone-test-xofejuy0figo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), rclone-test-xofejuy0figo/zero-length-file (0)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1931
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FromRoot/List
        	Messages:   	Unexpected file "rclone-test-xofejuy0figo/zero-length-file"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries
    fstest.go:380: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:380
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1938
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries
        	Messages:   	ListEntries not equal, want
        	            	  rclone-test-xofejuy0figo/file name.txt (200) got
        	            	  rclone-test-xofejuy0figo/file name.txt (200), rclone-test-xofejuy0figo/zero-length-file (0)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:383
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1938
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries
        	Messages:   	Unexpected file "rclone-test-xofejuy0figo/zero-length-file"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put
    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:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1987
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put
        	Messages:   	listing wrong, want
        	            	  rclone-test-xofejuy0figo/created from root.txt (100), rclone-test-xofejuy0figo/file name.txt (200), rclone-test-xofejuy0figo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
        	            	  rclone-test-xofejuy0figo/created from root.txt (100), rclone-test-xofejuy0figo/file name.txt (200), rclone-test-xofejuy0figo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), rclone-test-xofejuy0figo/zero-length-file (0)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1987
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put
        	Messages:   	Unexpected file "rclone-test-xofejuy0figo/zero-length-file"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove
    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:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1992
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove
        	Messages:   	listing wrong, want
        	            	  rclone-test-xofejuy0figo/file name.txt (200), rclone-test-xofejuy0figo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
        	            	  rclone-test-xofejuy0figo/file name.txt (200), rclone-test-xofejuy0figo/hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), rclone-test-xofejuy0figo/zero-length-file (0)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1992
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove
        	Messages:   	Unexpected file "rclone-test-xofejuy0figo/zero-length-file"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectRemove
2025/11/09 02:52:37 DEBUG : pacer: Reducing sleep to 33.864454ms
2025/11/09 02:52:38 DEBUG : pacer: Reducing sleep to 25.39834ms
2025/11/09 02:52:38 DEBUG : pacer: Reducing sleep to 19.048755ms
2025/11/09 02:52:38 DEBUG : pacer: Reducing sleep to 14.286566ms
2025/11/09 02:52:38 DEBUG : pacer: Reducing sleep to 10.714924ms
2025/11/09 02:52:38 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
2025/11/09 02:52:39 DEBUG : Too many requests. Trying again in 60 seconds.
2025/11/09 02:52: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/11/09 02:52:39 DEBUG : pacer: Rate limited, increasing sleep to 1m0s
2025/11/09 02:52:39 DEBUG : Too many requests. Trying again in 60 seconds.
2025/11/09 02:52: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/11/09 02:53:40 DEBUG : Too many requests. Trying again in 60 seconds.
2025/11/09 02:53:40 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/11/09 02:54:40 DEBUG : Too many requests. Trying again in 60 seconds.
2025/11/09 02:54:40 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/11/09 02:55:40 DEBUG : Too many requests. Trying again in 60 seconds.
2025/11/09 02:55:40 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/11/09 02:56:40 DEBUG : Too many requests. Trying again in 60 seconds.
2025/11/09 02:56:40 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/11/09 02:57:40 DEBUG : pacer: Reducing sleep to 45s
2025/11/09 02:58:40 DEBUG : pacer: Reducing sleep to 33.75s
2025/11/09 02:59:25 DEBUG : pacer: Reducing sleep to 25.3125s
2025/11/09 02:59:58 DEBUG : pacer: Reducing sleep to 18.984375s
2025/11/09 03:00:24 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/11/09 03:00:43 DEBUG : pacer: Reducing sleep to 10.678710937s
2025/11/09 03:00:57 DEBUG : pacer: Reducing sleep to 8.009033202s
2025/11/09 03:01:07 DEBUG : pacer: Reducing sleep to 6.006774901s
2025/11/09 03:01:15 DEBUG : pacer: Reducing sleep to 4.505081175s
2025/11/09 03:01:21 DEBUG : pacer: Reducing sleep to 3.378810881s
2025/11/09 03:01:26 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:305: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:305
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:2269
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/ObjectRemove
        	Messages:   	listing wrong, want
        	            	  hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100) got
        	            	  hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt (100), zero-length-file (0)
    fstest.go:191: 
        	Error Trace:	/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:191
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:308
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:338
        	            				/home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:2269
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/ObjectRemove
        	Messages:   	Unexpected file "zero-length-file"
2025/11/09 03:01:30 DEBUG : pacer: Reducing sleep to 1.90058112s
2025/11/09 03:01:33 DEBUG : pacer: Reducing sleep to 1.42543584s
2025/11/09 03:01:35 DEBUG : pacer: Reducing sleep to 1.06907688s
2025/11/09 03:01:36 DEBUG : pacer: Reducing sleep to 801.80766ms
2025/11/09 03:01:36 ERROR : error listing: directory not found
2025/11/09 03:01:37 DEBUG : pacer: Reducing sleep to 601.355745ms
--- FAIL: TestIntegration (2117.93s)
    --- FAIL: TestIntegration/FsMkdir (2117.19s)
        --- FAIL: TestIntegration/FsMkdir/FsPutZeroLength (0.61s)
        --- FAIL: TestIntegration/FsMkdir/FsPutFiles (2109.42s)
            --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.28s)
            --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.29s)
            --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.11s)
            --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (8.10s)
            --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (8.30s)
            --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsPurge (553.86s)
            --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (17.51s)
            --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsCopy (8.84s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (0.00s)
            --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsMove (392.81s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s)
            --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (549.49s)
            --- FAIL: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (3.74s)
            --- FAIL: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (1.73s)
            --- FAIL: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (1.03s)
            --- FAIL: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.64s)
            --- FAIL: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.90s)
            --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FromRoot (27.58s)
                --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (8.98s)
                --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.27s)
                --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (18.33s)
                    --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (9.14s)
            --- FAIL: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (532.70s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/zoho	2117.957s
"go test -v -timeout 2h0m0s -remote TestZoho: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$/^(FsCopy|FsDirMove|FsListDirFile2|FsListFile1|FsListFile1and2|FsListLevel2|FsListR|FsMove|FsPurge|FsPurgeRoot|ObjectOpen|ObjectOpenRange|ObjectOpenSeek|ObjectPartialRead|ObjectRemove|ObjectUpdate)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^FromRoot$/^(List|ListEntries)$|^TestIntegration$/^FsMkdir$/^FsPutFiles$/^FromRoot$/^Put$/^Remove$|^TestIntegration$/^FsMkdir$/^FsPutZeroLength$'" - Finished ERROR in 35m19.569873808s (try 2/5): exit status 1: Failed [TestIntegration/FsMkdir/FsPutZeroLength TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 TestIntegration/FsMkdir/FsPutFiles/FsListR TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 TestIntegration/FsMkdir/FsPutFiles/FsListFile1 TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 TestIntegration/FsMkdir/FsPutFiles/FsPurge TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot TestIntegration/FsMkdir/FsPutFiles/FsCopy TestIntegration/FsMkdir/FsPutFiles/FsMove TestIntegration/FsMkdir/FsPutFiles/FsDirMove TestIntegration/FsMkdir/FsPutFiles/ObjectOpen TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate TestIntegration/FsMkdir/FsPutFiles/FromRoot/List TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove TestIntegration/FsMkdir/FsPutFiles/ObjectRemove]