"go test -v -timeout 2h0m0s -remote TestZoho: -verbose" - Starting (try 1/5) === RUN TestFolderListLimiter --- PASS: TestFolderListLimiter (0.00s) === RUN TestFolderWindowLimiterShape --- PASS: TestFolderWindowLimiterShape (0.00s) === RUN TestFolderWindowLimiterIdleResume --- PASS: TestFolderWindowLimiterIdleResume (0.00s) === RUN TestFolderWindowLimiterClamps --- PASS: TestFolderWindowLimiterClamps (0.00s) === RUN TestFolderListLimiterConcurrent --- PASS: TestFolderListLimiterConcurrent (0.00s) === RUN TestTPSMinSleep --- PASS: TestTPSMinSleep (0.00s) === RUN TestShouldRetry === RUN TestShouldRetry/429_honours_Retry-After 2026/08/07 04:33:39 NOTICE: zoho root '': Too many requests: Trying again in 6 seconds. assert.AnError general error for testing === RUN TestShouldRetry/429_without_Retry-After_falls_back_to_60s 2026/08/07 04:33:39 NOTICE: zoho root '': Too many requests: Trying again in 61 seconds. assert.AnError general error for testing === RUN TestShouldRetry/429_with_unparseable_Retry-After_falls_back 2026/08/07 04:33:39 NOTICE: zoho root '': Failed to parse Retry-After: "soon": strconv.Atoi: parsing "soon": invalid syntax 2026/08/07 04:33:39 NOTICE: zoho root '': Too many requests: Trying again in 61 seconds. assert.AnError general error for testing === RUN TestShouldRetry/401_missing_scope_aborts 2026/08/07 04:33:39 ERROR : zoho: missing OAuth Scope. Run rclone config reconnect to fix this issue. === RUN TestShouldRetry/401_expired_token_retries === RUN TestShouldRetry/401_R008_deleted_folder_is_not_retried === RUN TestShouldRetry/cancelled_context_aborts --- PASS: TestShouldRetry (0.00s) --- PASS: TestShouldRetry/429_honours_Retry-After (0.00s) --- PASS: TestShouldRetry/429_without_Retry-After_falls_back_to_60s (0.00s) --- PASS: TestShouldRetry/429_with_unparseable_Retry-After_falls_back (0.00s) --- PASS: TestShouldRetry/401_missing_scope_aborts (0.00s) --- PASS: TestShouldRetry/401_expired_token_retries (0.00s) --- PASS: TestShouldRetry/401_R008_deleted_folder_is_not_retried (0.00s) --- PASS: TestShouldRetry/cancelled_context_aborts (0.00s) === RUN TestIsMissingResourceErr --- PASS: TestIsMissingResourceErr (0.00s) === RUN TestThrottleEpisode 2026/08/07 04:33:39 NOTICE: zoho root '': Too many requests: Trying again in 2 seconds. assert.AnError general error for testing --- PASS: TestThrottleEpisode (0.00s) === RUN TestThrottleStateConcurrent 2026/08/07 04:33:39 NOTICE: zoho root '': Too many requests: Trying again in 2 seconds. assert.AnError general error for testing --- PASS: TestThrottleStateConcurrent (0.00s) === RUN TestConfigRootFolderID === RUN TestConfigRootFolderID/SetRootAsksBeforeChanging === RUN TestConfigRootFolderID/EmptyRootGoesToEdition === RUN TestConfigRootFolderID/KeepRootOnNo === RUN TestConfigRootFolderID/ChangeRootOnYes --- PASS: TestConfigRootFolderID (0.00s) --- PASS: TestConfigRootFolderID/SetRootAsksBeforeChanging (0.00s) --- PASS: TestConfigRootFolderID/EmptyRootGoesToEdition (0.00s) --- PASS: TestConfigRootFolderID/KeepRootOnNo (0.00s) --- PASS: TestConfigRootFolderID/ChangeRootOnYes (0.00s) === RUN TestIntegration fstests.go:457: Using remote "TestZoho:" 2026/08/07 04:33:39 DEBUG : Creating backend with remote "TestZoho:rclone-test-pufifey7nihe" 2026/08/07 04:33:39 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/08/07 04:33:39 DEBUG : zoho root 'rclone-test-pufifey7nihe': folder listing limiter sweep: evicted 0 of 0 idle limiters 2026/08/07 04:33:39 DEBUG : TestZoho: Token expired 2026/08/07 04:33:39 DEBUG : TestZoho: No updated token found in the config file 2026/08/07 04:33:39 DEBUG : TestZoho: Token refresh successful 2026/08/07 04:33:39 DEBUG : Saving config "token" in section "TestZoho" of the config file 2026/08/07 04:33:39 DEBUG : TestZoho: Saved new token in config file === RUN TestIntegration/FsCheckWrap fstests.go:498: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:526: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2026/08/07 04:33:40 DEBUG : pacer: Reducing sleep to 7.248308ms 2026/08/07 04:33:40 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:33:40 DEBUG : pacer: Reducing sleep to 95.17699ms === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty 2026/08/07 04:33:40 DEBUG : pacer: Reducing sleep to 188.777872ms 2026/08/07 04:33:40 DEBUG : pacer: Reducing sleep to 244.088967ms === RUN TestIntegration/FsMkdir 2026/08/07 04:33:41 DEBUG : pacer: Reducing sleep to 157.190638ms 2026/08/07 04:33:41 DEBUG : pacer: Reducing sleep to 61.332011ms 2026/08/07 04:33:41 DEBUG : pacer: Reducing sleep to 158.603288ms === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/08/07 04:33:41 INFO : dir/subdir: Making directory 2026/08/07 04:33:41 DEBUG : pacer: Reducing sleep to 253.819752ms 2026/08/07 04:33:41 DEBUG : pacer: Reducing sleep to 232.270287ms 2026/08/07 04:33:41 DEBUG : pacer: Reducing sleep to 173.3804ms 2026/08/07 04:33:42 DEBUG : pacer: Reducing sleep to 69.497554ms 2026/08/07 04:33:42 DEBUG : pacer: Reducing sleep to 88.477816ms 2026/08/07 04:33:42 DEBUG : pacer: Reducing sleep to 179.603043ms 2026/08/07 04:33:42 DEBUG : pacer: Reducing sleep to 260.718769ms 2026/08/07 04:33:42 INFO : dir/subdir: Removing directory 2026/08/07 04:33:42 DEBUG : pacer: Reducing sleep to 242.859856ms 2026/08/07 04:33:42 DEBUG : pacer: Reducing sleep to 112.16073ms 2026/08/07 04:33:43 DEBUG : pacer: Reducing sleep to 73.322273ms 2026/08/07 04:33:43 DEBUG : pacer: Reducing sleep to 128.929931ms 2026/08/07 04:33:43 INFO : dir: Removing directory 2026/08/07 04:33:43 DEBUG : pacer: Reducing sleep to 219.807848ms 2026/08/07 04:33:43 DEBUG : pacer: Reducing sleep to 243.045755ms 2026/08/07 04:33:43 DEBUG : pacer: Reducing sleep to 207.466887ms === RUN TestIntegration/FsMkdir/FsListEmpty 2026/08/07 04:33:43 DEBUG : pacer: Reducing sleep to 127.284605ms === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/08/07 04:33:48 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/08/07 04:33:52 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:727: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2026/08/07 04:34:02 DEBUG : pacer: Reducing sleep to 71.827424ms 2026/08/07 04:34:02 DEBUG : pacer: Reducing sleep to 166.007463ms 2026/08/07 04:34:02 DEBUG : pacer: Reducing sleep to 69.960509ms 2026/08/07 04:34:02 DEBUG : pacer: Reducing sleep to 160.136544ms 2026/08/07 04:34:06 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:34:06 DEBUG : pacer: Reducing sleep to 84.056175ms 2026/08/07 04:34:07 DEBUG : pacer: Reducing sleep to 158.871812ms 2026/08/07 04:34:07 DEBUG : pacer: Reducing sleep to 249.901812ms 2026/08/07 04:34:07 DEBUG : pacer: Reducing sleep to 248.493033ms 2026/08/07 04:34:11 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:727: testing "." 2026/08/07 04:34:16 DEBUG : pacer: Reducing sleep to 63.135355ms 2026/08/07 04:34:16 DEBUG : pacer: Reducing sleep to 158.923494ms 2026/08/07 04:34:16 DEBUG : pacer: Reducing sleep to 166.299972ms 2026/08/07 04:34:16 DEBUG : pacer: Reducing sleep to 256.520565ms 2026/08/07 04:34:20 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:34:20 DEBUG : pacer: Reducing sleep to 85.928925ms 2026/08/07 04:34:20 DEBUG : pacer: Reducing sleep to 63.765522ms 2026/08/07 04:34:21 DEBUG : pacer: Reducing sleep to 156.242847ms 2026/08/07 04:34:21 DEBUG : pacer: Reducing sleep to 235.088211ms 2026/08/07 04:34:25 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:727: testing ".." 2026/08/07 04:34:30 DEBUG : pacer: Reducing sleep to 71.960027ms 2026/08/07 04:34:30 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:34:30 DEBUG : pacer: Reducing sleep to 85.810531ms 2026/08/07 04:34:34 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:34:34 DEBUG : pacer: Reducing sleep to 84.775718ms 2026/08/07 04:34:34 DEBUG : pacer: Reducing sleep to 163.599532ms 2026/08/07 04:34:34 DEBUG : pacer: Reducing sleep to 257.788711ms 2026/08/07 04:34:34 DEBUG : pacer: Reducing sleep to 248.574426ms 2026/08/07 04:34:39 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:727: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2026/08/07 04:34:43 DEBUG : pacer: Reducing sleep to 63.311862ms 2026/08/07 04:34:43 DEBUG : zoho root 'rclone-test-pufifey7nihe': folder listing limiter sweep: evicted 4 of 8 idle limiters 2026/08/07 04:34:43 DEBUG : pacer: Reducing sleep to 159.614277ms 2026/08/07 04:34:44 DEBUG : pacer: Reducing sleep to 122.661403ms 2026/08/07 04:34:44 DEBUG : pacer: Reducing sleep to 208.534215ms 2026/08/07 04:34:44 DEBUG : pacer: Reducing sleep to 257.681921ms 2026/08/07 04:34:44 DEBUG : pacer: Reducing sleep to 212.945936ms 2026/08/07 04:34:44 DEBUG : pacer: Reducing sleep to 109.7582ms 2026/08/07 04:34:45 DEBUG : pacer: Reducing sleep to 77.936801ms 2026/08/07 04:34:45 DEBUG : pacer: Reducing sleep to 83.066885ms 2026/08/07 04:34:45 DEBUG : pacer: Reducing sleep to 157.840671ms === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:727: testing " leading space" 2026/08/07 04:34:45 DEBUG : pacer: Reducing sleep to 248.976715ms 2026/08/07 04:34:45 DEBUG : pacer: Reducing sleep to 233.455157ms 2026/08/07 04:34:45 DEBUG : pacer: Reducing sleep to 178.166407ms 2026/08/07 04:34:46 DEBUG : pacer: Reducing sleep to 27.078909ms 2026/08/07 04:34:46 DEBUG : pacer: Reducing sleep to 70.492172ms 2026/08/07 04:34:46 DEBUG : pacer: Reducing sleep to 159.007345ms 2026/08/07 04:34:46 DEBUG : pacer: Reducing sleep to 247.940189ms 2026/08/07 04:34:46 DEBUG : pacer: Reducing sleep to 247.317446ms 2026/08/07 04:34:46 DEBUG : pacer: Reducing sleep to 174.368905ms 2026/08/07 04:34:46 DEBUG : pacer: Reducing sleep to 85.513686ms 2026/08/07 04:34:47 DEBUG : pacer: Reducing sleep to 88.722381ms === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:727: testing "~leading tilde" 2026/08/07 04:34:51 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:34:51 DEBUG : pacer: Reducing sleep to 67.178028ms 2026/08/07 04:34:51 DEBUG : pacer: Reducing sleep to 163.386205ms 2026/08/07 04:34:52 DEBUG : pacer: Reducing sleep to 98.842192ms 2026/08/07 04:34:52 DEBUG : pacer: Reducing sleep to 180.338217ms 2026/08/07 04:34:56 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:34:56 DEBUG : pacer: Reducing sleep to 87.196604ms 2026/08/07 04:34:56 DEBUG : pacer: Reducing sleep to 145.231572ms 2026/08/07 04:34:56 DEBUG : pacer: Reducing sleep to 234.928508ms 2026/08/07 04:34:56 DEBUG : pacer: Reducing sleep to 245.583982ms 2026/08/07 04:35:00 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:727: testing "␍leading CR" 2026/08/07 04:35:05 DEBUG : pacer: Reducing sleep to 69.745569ms 2026/08/07 04:35:05 DEBUG : pacer: Reducing sleep to 165.541718ms 2026/08/07 04:35:05 DEBUG : pacer: Reducing sleep to 129.985451ms 2026/08/07 04:35:05 DEBUG : pacer: Reducing sleep to 220.575517ms 2026/08/07 04:35:10 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:35:10 DEBUG : pacer: Reducing sleep to 85.480414ms 2026/08/07 04:35:10 DEBUG : pacer: Reducing sleep to 115.035534ms 2026/08/07 04:35:10 DEBUG : pacer: Reducing sleep to 208.572558ms 2026/08/07 04:35:10 DEBUG : pacer: Reducing sleep to 246.613457ms 2026/08/07 04:35:14 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:727: testing "␊leading LF" 2026/08/07 04:35:19 DEBUG : pacer: Reducing sleep to 72.166104ms 2026/08/07 04:35:19 DEBUG : pacer: Reducing sleep to 167.690411ms 2026/08/07 04:35:19 DEBUG : pacer: Reducing sleep to 179.582927ms 2026/08/07 04:35:19 DEBUG : pacer: Reducing sleep to 252.477989ms 2026/08/07 04:35:24 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:35:24 DEBUG : pacer: Reducing sleep to 76.238336ms 2026/08/07 04:35:24 DEBUG : pacer: Reducing sleep to 69.727521ms 2026/08/07 04:35:24 DEBUG : pacer: Reducing sleep to 163.071149ms 2026/08/07 04:35:24 DEBUG : pacer: Reducing sleep to 242.404313ms 2026/08/07 04:35:28 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:727: testing "␉leading HT" 2026/08/07 04:35:33 DEBUG : pacer: Reducing sleep to 63.57621ms 2026/08/07 04:35:33 DEBUG : pacer: Reducing sleep to 160.5566ms 2026/08/07 04:35:33 DEBUG : pacer: Reducing sleep to 113.694613ms 2026/08/07 04:35:33 DEBUG : pacer: Reducing sleep to 199.414342ms 2026/08/07 04:35:37 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:35:37 DEBUG : pacer: Reducing sleep to 86.167354ms 2026/08/07 04:35:38 DEBUG : pacer: Reducing sleep to 113.154179ms 2026/08/07 04:35:38 DEBUG : pacer: Reducing sleep to 198.134491ms 2026/08/07 04:35:38 DEBUG : pacer: Reducing sleep to 248.009279ms 2026/08/07 04:35:42 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:727: testing "␋leading VT" 2026/08/07 04:35:42 DEBUG : pacer: Reducing sleep to 91.887632ms 2026/08/07 04:35:42 DEBUG : pacer: Reducing sleep to 58.527492ms 2026/08/07 04:35:42 DEBUG : pacer: Reducing sleep to 152.162674ms 2026/08/07 04:35:42 DEBUG : pacer: Reducing sleep to 157.101672ms 2026/08/07 04:35:43 DEBUG : pacer: Reducing sleep to 247.402706ms 2026/08/07 04:35:44 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:35:44 DEBUG : zoho root 'rclone-test-pufifey7nihe': folder listing limiter sweep: evicted 3 of 11 idle limiters 2026/08/07 04:35:44 DEBUG : pacer: Reducing sleep to 90.10323ms 2026/08/07 04:35:44 DEBUG : pacer: Reducing sleep to 75.052579ms 2026/08/07 04:35:44 DEBUG : pacer: Reducing sleep to 164.443503ms 2026/08/07 04:35:44 DEBUG : pacer: Reducing sleep to 244.681538ms 2026/08/07 04:35:44 DEBUG : pacer: Reducing sleep to 261.255032ms === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:727: testing ".leading dot" 2026/08/07 04:35:45 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:35:45 DEBUG : pacer: Reducing sleep to 68.321223ms 2026/08/07 04:35:46 DEBUG : pacer: Reducing sleep to 71.408924ms 2026/08/07 04:35:46 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:35:46 DEBUG : pacer: Reducing sleep to 87.354408ms 2026/08/07 04:35:46 DEBUG : pacer: Reducing sleep to 169.948834ms 2026/08/07 04:35:46 DEBUG : pacer: Reducing sleep to 255.923466ms 2026/08/07 04:35:46 DEBUG : pacer: Reducing sleep to 239.745314ms 2026/08/07 04:35:46 DEBUG : pacer: Reducing sleep to 166.085683ms 2026/08/07 04:35:47 DEBUG : pacer: Reducing sleep to 78.366892ms 2026/08/07 04:35:51 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:727: testing "trailing space " 2026/08/07 04:35:55 DEBUG : pacer: Reducing sleep to 66.479358ms 2026/08/07 04:35:55 DEBUG : pacer: Reducing sleep to 162.707238ms 2026/08/07 04:35:55 DEBUG : pacer: Reducing sleep to 181.986446ms 2026/08/07 04:35:56 DEBUG : pacer: Reducing sleep to 252.066966ms 2026/08/07 04:36:00 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:36:00 DEBUG : pacer: Reducing sleep to 42.286839ms 2026/08/07 04:36:00 DEBUG : pacer: Reducing sleep to 111.311966ms 2026/08/07 04:36:00 DEBUG : pacer: Reducing sleep to 194.376363ms 2026/08/07 04:36:00 DEBUG : pacer: Reducing sleep to 247.835064ms 2026/08/07 04:36:04 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:727: testing "trailing CR␍" 2026/08/07 04:36:09 DEBUG : pacer: Reducing sleep to 72.547902ms 2026/08/07 04:36:09 DEBUG : pacer: Reducing sleep to 169.079178ms 2026/08/07 04:36:09 DEBUG : pacer: Reducing sleep to 118.27715ms 2026/08/07 04:36:09 DEBUG : pacer: Reducing sleep to 207.220962ms 2026/08/07 04:36:14 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:36:14 DEBUG : pacer: Reducing sleep to 79.045915ms 2026/08/07 04:36:14 DEBUG : pacer: Reducing sleep to 123.189304ms 2026/08/07 04:36:14 DEBUG : pacer: Reducing sleep to 216.182298ms 2026/08/07 04:36:14 DEBUG : pacer: Reducing sleep to 249.762713ms 2026/08/07 04:36:18 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:727: testing "trailing LF␊" 2026/08/07 04:36:23 DEBUG : pacer: Reducing sleep to 71.901062ms 2026/08/07 04:36:23 DEBUG : pacer: Reducing sleep to 168.026009ms 2026/08/07 04:36:23 DEBUG : pacer: Reducing sleep to 187.571256ms 2026/08/07 04:36:23 DEBUG : pacer: Reducing sleep to 253.44906ms 2026/08/07 04:36:27 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:36:28 DEBUG : pacer: Reducing sleep to 84.609809ms 2026/08/07 04:36:28 DEBUG : pacer: Reducing sleep to 69.592519ms 2026/08/07 04:36:28 DEBUG : pacer: Reducing sleep to 160.818055ms 2026/08/07 04:36:28 DEBUG : pacer: Reducing sleep to 243.95455ms 2026/08/07 04:36:32 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:727: testing "trailing HT␉" 2026/08/07 04:36:37 DEBUG : pacer: Reducing sleep to 67.206726ms 2026/08/07 04:36:37 DEBUG : pacer: Reducing sleep to 164.826691ms 2026/08/07 04:36:37 DEBUG : pacer: Reducing sleep to 129.975459ms 2026/08/07 04:36:37 DEBUG : pacer: Reducing sleep to 217.485317ms 2026/08/07 04:36:41 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:36:41 DEBUG : pacer: Reducing sleep to 85.299412ms 2026/08/07 04:36:42 DEBUG : pacer: Reducing sleep to 107.39027ms 2026/08/07 04:36:42 DEBUG : pacer: Reducing sleep to 194.701503ms 2026/08/07 04:36:42 DEBUG : pacer: Reducing sleep to 242.38364ms 2026/08/07 04:36:42 DEBUG : pacer: Reducing sleep to 232.494131ms === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:727: testing "trailing VT␋" 2026/08/07 04:36:42 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:36:43 DEBUG : pacer: Reducing sleep to 70.211423ms 2026/08/07 04:36:43 DEBUG : pacer: Reducing sleep to 100.847952ms 2026/08/07 04:36:43 DEBUG : pacer: Reducing sleep to 122.308559ms 2026/08/07 04:36:43 DEBUG : pacer: Reducing sleep to 212.653964ms 2026/08/07 04:36:43 DEBUG : pacer: Reducing sleep to 253.316262ms 2026/08/07 04:36:43 DEBUG : pacer: Reducing sleep to 207.340399ms 2026/08/07 04:36:44 DEBUG : pacer: Reducing sleep to 109.861945ms 2026/08/07 04:36:44 DEBUG : pacer: Reducing sleep to 83.988604ms 2026/08/07 04:36:44 DEBUG : pacer: Reducing sleep to 128.640758ms 2026/08/07 04:36:44 DEBUG : zoho root 'rclone-test-pufifey7nihe': folder listing limiter sweep: evicted 7 of 14 idle limiters 2026/08/07 04:36:44 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:727: testing "trailing dot." 2026/08/07 04:36:45 DEBUG : pacer: Reducing sleep to 55.681287ms 2026/08/07 04:36:45 DEBUG : pacer: Reducing sleep to 147.918464ms 2026/08/07 04:36:45 DEBUG : pacer: Reducing sleep to 90.540626ms 2026/08/07 04:36:45 DEBUG : pacer: Reducing sleep to 182.344094ms 2026/08/07 04:36:49 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:36:49 DEBUG : pacer: Reducing sleep to 85.794706ms 2026/08/07 04:36:50 DEBUG : pacer: Reducing sleep to 131.240882ms 2026/08/07 04:36:50 DEBUG : pacer: Reducing sleep to 225.201545ms 2026/08/07 04:36:50 DEBUG : pacer: Reducing sleep to 245.410209ms 2026/08/07 04:36:54 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:718: Skipping invalid UTF-8 === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:727: testing "test%46.txt" 2026/08/07 04:36:59 DEBUG : pacer: Reducing sleep to 69.701992ms 2026/08/07 04:36:59 DEBUG : pacer: Reducing sleep to 162.980016ms 2026/08/07 04:36:59 DEBUG : pacer: Reducing sleep to 183.772015ms 2026/08/07 04:36:59 DEBUG : pacer: Reducing sleep to 253.236479ms 2026/08/07 04:37:03 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:37:03 DEBUG : pacer: Reducing sleep to 86.215674ms 2026/08/07 04:37:04 DEBUG : pacer: Reducing sleep to 51.253461ms 2026/08/07 04:37:04 DEBUG : pacer: Reducing sleep to 143.414726ms 2026/08/07 04:37:04 DEBUG : pacer: Reducing sleep to 225.227484ms 2026/08/07 04:37:08 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/08/07 04:37:26 DEBUG : pacer: Reducing sleep to 67.468887ms 2026/08/07 04:37:26 DEBUG : pacer: Reducing sleep to 163.957188ms 2026/08/07 04:37:27 DEBUG : pacer: Reducing sleep to 224.689673ms 2026/08/07 04:37:27 DEBUG : pacer: Reducing sleep to 262.472107ms 2026/08/07 04:37:27 DEBUG : pacer: Reducing sleep to 168.344185ms 2026/08/07 04:37:27 DEBUG : pacer: Reducing sleep to 106.874599ms 2026/08/07 04:37:27 DEBUG : pacer: Reducing sleep to 67.596679ms 2026/08/07 04:37:27 DEBUG : pacer: Reducing sleep to 233.275099ms 2026/08/07 04:37:28 DEBUG : pacer: Reducing sleep to 256.350875ms === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/08/07 04:37:31 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:37:36 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 07 Aug 2026 04:37:36 UTC": parsing time "Fri, 07 Aug 2026 04:37:36 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 07 Aug 2026 04:37:36 UTC" as " " 2026/08/07 04:37:36 DEBUG : pacer: Reducing sleep to 73.257ms === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:806: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:839: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:892: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2026/08/07 04:37:40 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:37:45 DEBUG : zoho root 'rclone-test-pufifey7nihe': folder listing limiter sweep: evicted 6 of 13 idle limiters 2026/08/07 04:37:45 DEBUG : pacer: Reducing sleep to 93.926914ms 2026/08/07 04:37:45 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:37:45 DEBUG : pacer: Reducing sleep to 85.786027ms 2026/08/07 04:37:45 DEBUG : pacer: Reducing sleep to 176.628736ms 2026/08/07 04:37:45 DEBUG : pacer: Reducing sleep to 191.413395ms 2026/08/07 04:37:46 DEBUG : pacer: Reducing sleep to 236.189903ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/08/07 04:37:46 DEBUG : pacer: Reducing sleep to 219.566207ms 2026/08/07 04:37:46 DEBUG : pacer: Reducing sleep to 143.942934ms 2026/08/07 04:37:46 DEBUG : pacer: Reducing sleep to 95.905744ms 2026/08/07 04:37:46 DEBUG : pacer: Reducing sleep to 115.372416ms 2026/08/07 04:37:46 DEBUG : pacer: Reducing sleep to 186.778873ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/08/07 04:37:47 DEBUG : pacer: Reducing sleep to 235.300084ms 2026/08/07 04:37:47 DEBUG : pacer: Reducing sleep to 216.35743ms 2026/08/07 04:37:47 DEBUG : pacer: Reducing sleep to 144.106574ms 2026/08/07 04:37:47 DEBUG : pacer: Reducing sleep to 95.245178ms 2026/08/07 04:37:47 DEBUG : pacer: Reducing sleep to 111.879081ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/08/07 04:37:47 DEBUG : pacer: Reducing sleep to 187.803421ms 2026/08/07 04:37:48 DEBUG : pacer: Reducing sleep to 225.788351ms 2026/08/07 04:37:48 DEBUG : pacer: Reducing sleep to 217.71139ms 2026/08/07 04:37:48 DEBUG : pacer: Reducing sleep to 161.058548ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/08/07 04:37:48 DEBUG : Creating backend with remote "TestZoho:" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/08/07 04:37:52 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 2026/08/07 04:37:57 DEBUG : pacer: Reducing sleep to 89.333048ms 2026/08/07 04:37:57 DEBUG : pacer: Reducing sleep to 177.247497ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/08/07 04:38:02 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:38:02 DEBUG : pacer: Reducing sleep to 88.608861ms 2026/08/07 04:38:02 DEBUG : pacer: Reducing sleep to 155.488669ms 2026/08/07 04:38:02 DEBUG : pacer: Reducing sleep to 230.154785ms 2026/08/07 04:38:02 DEBUG : pacer: Reducing sleep to 242.737648ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject 2026/08/07 04:38:06 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1145: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/08/07 04:38:11 DEBUG : pacer: Reducing sleep to 90.044984ms 2026/08/07 04:38:11 DEBUG : pacer: Reducing sleep to 179.227038ms 2026/08/07 04:38:11 DEBUG : pacer: Reducing sleep to 252.792716ms 2026/08/07 04:38:11 DEBUG : pacer: Reducing sleep to 240.406308ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir 2026/08/07 04:38:16 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge 2026/08/07 04:38:16 DEBUG : pacer: Reducing sleep to 87.281113ms 2026/08/07 04:38:21 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:38:21 DEBUG : pacer: Reducing sleep to 67.735076ms 2026/08/07 04:38:21 DEBUG : pacer: Reducing sleep to 9.772967ms 2026/08/07 04:38:21 DEBUG : pacer: Reducing sleep to 98.532114ms 2026/08/07 04:38:25 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:38:25 DEBUG : pacer: Reducing sleep to 90.772039ms 2026/08/07 04:38:25 DEBUG : pacer: Reducing sleep to 255.111229ms 2026/08/07 04:38:25 DEBUG : pacer: Reducing sleep to 350.139475ms 2026/08/07 04:38:25 DEBUG : pacer: Reducing sleep to 419.973126ms 2026/08/07 04:38:26 DEBUG : pacer: Reducing sleep to 238.233391ms 2026/08/07 04:38:26 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:38:26 DEBUG : pacer: Reducing sleep to 83.40333ms 2026/08/07 04:38:30 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:38:30 DEBUG : pacer: Reducing sleep to 38.435788ms 2026/08/07 04:38:30 DEBUG : pacer: Reducing sleep to 121.680579ms 2026/08/07 04:38:30 DEBUG : pacer: Reducing sleep to 202.900546ms 2026/08/07 04:38:30 DEBUG : pacer: Reducing sleep to 255.96261ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2026/08/07 04:38:34 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:38:39 DEBUG : pacer: Reducing sleep to 76.192753ms 2026/08/07 04:38:39 DEBUG : pacer: Reducing sleep to 26.006235ms 2026/08/07 04:38:39 DEBUG : pacer: Reducing sleep to 116.097498ms 2026/08/07 04:38:44 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:38:44 DEBUG : pacer: Reducing sleep to 90.602199ms 2026/08/07 04:38:44 DEBUG : pacer: Reducing sleep to 254.477673ms 2026/08/07 04:38:44 DEBUG : pacer: Reducing sleep to 346.496487ms 2026/08/07 04:38:44 DEBUG : pacer: Reducing sleep to 423.932709ms 2026/08/07 04:38:44 DEBUG : pacer: Reducing sleep to 240.475588ms 2026/08/07 04:38:44 DEBUG : Creating backend with remote "TestZoho:rclone-test-pufifey7nihe/dirToPurgeFromRoot" 2026/08/07 04:38:45 DEBUG : pacer: Reducing sleep to 87.205394ms 2026/08/07 04:38:45 DEBUG : pacer: Reducing sleep to 204.088191ms 2026/08/07 04:38:45 DEBUG : pacer: Reducing sleep to 264.674065ms 2026/08/07 04:38:45 DEBUG : zoho root 'rclone-test-pufifey7nihe': folder listing limiter sweep: evicted 2 of 10 idle limiters 2026/08/07 04:38:45 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:38:45 DEBUG : pacer: Reducing sleep to 78.913621ms 2026/08/07 04:38:45 DEBUG : pacer: Reducing sleep to 92.765157ms 2026/08/07 04:38:45 DEBUG : pacer: Reducing sleep to 181.148986ms 2026/08/07 04:38:45 DEBUG : pacer: Reducing sleep to 255.692846ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/08/07 04:38:45 DEBUG : Creating backend with remote "TestZoho:rclone-test-pufifey7nihe/hello? sausage/êé" 2026/08/07 04:38:46 DEBUG : pacer: Reducing sleep to 117.100055ms 2026/08/07 04:38:46 DEBUG : pacer: Reducing sleep to 234.573348ms 2026/08/07 04:38:46 DEBUG : pacer: Reducing sleep to 285.317404ms 2026/08/07 04:38:46 DEBUG : pacer: Reducing sleep to 215.734043ms 2026/08/07 04:38:47 DEBUG : pacer: Reducing sleep to 70.173541ms 2026/08/07 04:38:47 DEBUG : pacer: Reducing sleep to 52.543055ms 2026/08/07 04:38:47 DEBUG : pacer: Reducing sleep to 116.852745ms 2026/08/07 04:38:47 DEBUG : pacer: Reducing sleep to 241.455371ms 2026/08/07 04:38:47 DEBUG : pacer: Reducing sleep to 253.625663ms 2026/08/07 04:38:47 DEBUG : pacer: Reducing sleep to 214.579988ms 2026/08/07 04:38:47 DEBUG : pacer: Reducing sleep to 92.640279ms 2026/08/07 04:38:48 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:38:48 DEBUG : pacer: Reducing sleep to 118.135003ms 2026/08/07 04:38:48 DEBUG : pacer: Reducing sleep to 234.372169ms 2026/08/07 04:38:48 DEBUG : pacer: Reducing sleep to 276.065311ms 2026/08/07 04:38:48 DEBUG : pacer: Reducing sleep to 212.580851ms 2026/08/07 04:38:49 DEBUG : pacer: Reducing sleep to 101.734214ms 2026/08/07 04:38:49 DEBUG : pacer: Reducing sleep to 58.02915ms 2026/08/07 04:38:49 DEBUG : pacer: Reducing sleep to 124.278053ms 2026/08/07 04:38:49 DEBUG : pacer: Reducing sleep to 229.058591ms 2026/08/07 04:38:49 DEBUG : pacer: Reducing sleep to 276.784689ms 2026/08/07 04:38:49 DEBUG : pacer: Reducing sleep to 197.331135ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy 2026/08/07 04:38:49 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:38:50 DEBUG : pacer: Reducing sleep to 35.676459ms 2026/08/07 04:38:50 DEBUG : pacer: Reducing sleep to 127.22705ms 2026/08/07 04:38:50 DEBUG : pacer: Reducing sleep to 215.752707ms 2026/08/07 04:38:53 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:38:53 DEBUG : pacer: Reducing sleep to 91.952929ms 2026/08/07 04:38:53 DEBUG : pacer: Reducing sleep to 113.705531ms 2026/08/07 04:38:57 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata fstests.go:1318: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/08/07 04:39:02 DEBUG : pacer: Reducing sleep to 79.233236ms 2026/08/07 04:39:02 DEBUG : pacer: Reducing sleep to 138.166012ms 2026/08/07 04:39:02 DEBUG : pacer: Reducing sleep to 220.120699ms 2026/08/07 04:39:02 DEBUG : pacer: Reducing sleep to 254.429865ms 2026/08/07 04:39:03 DEBUG : pacer: Reducing sleep to 203.634403ms 2026/08/07 04:39:03 DEBUG : pacer: Reducing sleep to 113.411753ms 2026/08/07 04:39:03 DEBUG : pacer: Reducing sleep to 77.716902ms 2026/08/07 04:39:07 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:39:16 DEBUG : pacer: Reducing sleep to 67.367909ms 2026/08/07 04:39:16 DEBUG : pacer: Reducing sleep to 148.312248ms 2026/08/07 04:39:16 DEBUG : pacer: Reducing sleep to 205.284102ms 2026/08/07 04:39:17 DEBUG : pacer: Reducing sleep to 246.18496ms 2026/08/07 04:39:21 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:39:21 DEBUG : pacer: Reducing sleep to 88.627863ms 2026/08/07 04:39:21 DEBUG : pacer: Reducing sleep to 254.890887ms 2026/08/07 04:39:21 DEBUG : pacer: Reducing sleep to 260.07121ms 2026/08/07 04:39:21 DEBUG : pacer: Reducing sleep to 168.614935ms 2026/08/07 04:39:21 DEBUG : pacer: Reducing sleep to 83.541254ms 2026/08/07 04:39:22 DEBUG : pacer: Reducing sleep to 57.256801ms 2026/08/07 04:39:22 DEBUG : pacer: Reducing sleep to 138.505907ms 2026/08/07 04:39:22 DEBUG : pacer: Reducing sleep to 195.551721ms 2026/08/07 04:39:22 DEBUG : pacer: Reducing sleep to 246.425046ms 2026/08/07 04:39:25 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:39:25 DEBUG : pacer: Reducing sleep to 95.875272ms 2026/08/07 04:39:25 DEBUG : pacer: Reducing sleep to 255.296222ms 2026/08/07 04:39:26 DEBUG : pacer: Reducing sleep to 255.4381ms 2026/08/07 04:39:26 DEBUG : pacer: Reducing sleep to 167.594279ms 2026/08/07 04:39:26 DEBUG : pacer: Reducing sleep to 86.540412ms 2026/08/07 04:39:30 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:39:30 DEBUG : pacer: Reducing sleep to 55.185008ms 2026/08/07 04:39:30 DEBUG : pacer: Reducing sleep to 112.075619ms 2026/08/07 04:39:30 DEBUG : pacer: Reducing sleep to 192.568319ms 2026/08/07 04:39:35 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:39:35 DEBUG : pacer: Reducing sleep to 95.518619ms 2026/08/07 04:39:35 DEBUG : pacer: Reducing sleep to 258.023775ms 2026/08/07 04:39:35 DEBUG : pacer: Reducing sleep to 304.761701ms 2026/08/07 04:39:35 DEBUG : pacer: Reducing sleep to 213.50153ms 2026/08/07 04:39:35 DEBUG : pacer: Reducing sleep to 73.231271ms 2026/08/07 04:39:36 DEBUG : pacer: Reducing sleep to 26.972004ms 2026/08/07 04:39:36 DEBUG : pacer: Reducing sleep to 88.006571ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1430: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/08/07 04:39:36 DEBUG : Creating backend with remote "TestZoho:rclone-test-dosehuf2zide" 2026/08/07 04:39:36 DEBUG : pacer: Reducing sleep to 42.727993ms 2026/08/07 04:39:36 DEBUG : pacer: Reducing sleep to 88.12738ms 2026/08/07 04:39:36 DEBUG : pacer: Reducing sleep to 116.375856ms 2026/08/07 04:39:36 DEBUG : pacer: Reducing sleep to 244.483435ms 2026/08/07 04:39:36 DEBUG : pacer: Reducing sleep to 265.832879ms 2026/08/07 04:39:37 DEBUG : pacer: Reducing sleep to 214.187178ms 2026/08/07 04:39:37 DEBUG : pacer: Reducing sleep to 70.203367ms 2026/08/07 04:39:37 DEBUG : pacer: Reducing sleep to 49.606167ms 2026/08/07 04:39:37 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:39:37 DEBUG : pacer: Reducing sleep to 17.391826ms 2026/08/07 04:39:37 DEBUG : pacer: Reducing sleep to 137.137483ms 2026/08/07 04:39:39 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:39:39 DEBUG : pacer: Reducing sleep to 119.503229ms 2026/08/07 04:39:39 DEBUG : pacer: Reducing sleep to 196.676587ms 2026/08/07 04:39:39 DEBUG : pacer: Reducing sleep to 245.078276ms 2026/08/07 04:39:40 DEBUG : pacer: Reducing sleep to 182.771311ms 2026/08/07 04:39:41 DEBUG : pacer: Reducing sleep to 15.101073ms 2026/08/07 04:39:42 DEBUG : pacer: Reducing sleep to 99.46771ms 2026/08/07 04:39:42 DEBUG : pacer: Reducing sleep to 184.393401ms 2026/08/07 04:39:42 DEBUG : pacer: Reducing sleep to 254.525432ms 2026/08/07 04:39:42 DEBUG : pacer: Reducing sleep to 237.662095ms 2026/08/07 04:39:42 DEBUG : pacer: Reducing sleep to 141.672693ms 2026/08/07 04:39:42 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:39:42 DEBUG : pacer: Reducing sleep to 125.346793ms 2026/08/07 04:39:42 DEBUG : zoho root 'rclone-test-dosehuf2zide': Purge remote 2026/08/07 04:39:42 DEBUG : pacer: Reducing sleep to 149.819228ms 2026/08/07 04:39:43 DEBUG : pacer: Reducing sleep to 175.58294ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull 2026/08/07 04:39:43 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString 2026/08/07 04:39:43 DEBUG : pacer: Reducing sleep to 87.441494ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs 2026/08/07 04:39:43 DEBUG : pacer: Reducing sleep to 177.819434ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote 2026/08/07 04:39:43 DEBUG : pacer: Reducing sleep to 255.577639ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes 2026/08/07 04:39:43 DEBUG : pacer: Reducing sleep to 244.218879ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime 2026/08/07 04:39:44 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType fstests.go:1626: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata 2026/08/07 04:39:49 DEBUG : zoho root 'rclone-test-pufifey7nihe': folder listing limiter sweep: evicted 5 of 15 idle limiters fstests.go:1657: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1728: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime fstests.go:1785: can't set modified time === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen 2026/08/07 04:40:12 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 07 Aug 2026 04:40:12 UTC": parsing time "Fri, 07 Aug 2026 04:40:12 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 07 Aug 2026 04:40:12 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/08/07 04:40:17 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 07 Aug 2026 04:40:17 UTC": parsing time "Fri, 07 Aug 2026 04:40:17 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 07 Aug 2026 04:40:17 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/08/07 04:40:21 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 07 Aug 2026 04:40:21 UTC": parsing time "Fri, 07 Aug 2026 04:40:21 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 07 Aug 2026 04:40:21 UTC" as " " 2026/08/07 04:40:22 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 07 Aug 2026 04:40:22 UTC": parsing time "Fri, 07 Aug 2026 04:40:22 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 07 Aug 2026 04:40:22 UTC" as " " 2026/08/07 04:40:22 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 07 Aug 2026 04:40:22 UTC": parsing time "Fri, 07 Aug 2026 04:40:22 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 07 Aug 2026 04:40:22 UTC" as " " 2026/08/07 04:40:22 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 07 Aug 2026 04:40:22 UTC": parsing time "Fri, 07 Aug 2026 04:40:22 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 07 Aug 2026 04:40:22 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/08/07 04:40:26 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 07 Aug 2026 04:40:26 UTC": parsing time "Fri, 07 Aug 2026 04:40:26 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 07 Aug 2026 04:40:26 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint 2026/08/07 04:40:31 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 07 Aug 2026 04:40:31 UTC": parsing time "Fri, 07 Aug 2026 04:40:31 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 07 Aug 2026 04:40:31 UTC" as " " 2026/08/07 04:40:35 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 07 Aug 2026 04:40:35 UTC": parsing time "Fri, 07 Aug 2026 04:40:35 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 07 Aug 2026 04:40:35 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read 2026/08/07 04:40:36 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 07 Aug 2026 04:40:35 UTC": parsing time "Fri, 07 Aug 2026 04:40:35 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 07 Aug 2026 04:40:35 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read 2026/08/07 04:40:36 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 07 Aug 2026 04:40:36 UTC": parsing time "Fri, 07 Aug 2026 04:40:36 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 07 Aug 2026 04:40:36 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read 2026/08/07 04:40:36 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 07 Aug 2026 04:40:36 UTC": parsing time "Fri, 07 Aug 2026 04:40:36 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 07 Aug 2026 04:40:36 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end 2026/08/07 04:40:36 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 07 Aug 2026 04:40:36 UTC": parsing time "Fri, 07 Aug 2026 04:40:36 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 07 Aug 2026 04:40:36 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh 2026/08/07 04:40:40 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 07 Aug 2026 04:40:40 UTC": parsing time "Fri, 07 Aug 2026 04:40:40 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 07 Aug 2026 04:40:40 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/08/07 04:40:44 DEBUG : pacer: Reducing sleep to 88.324725ms 2026/08/07 04:40:45 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Fri, 07 Aug 2026 04:40:45 UTC": parsing time "Fri, 07 Aug 2026 04:40:45 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 07 Aug 2026 04:40:45 UTC" as " " 2026/08/07 04:40:45 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable 2026/08/07 04:40:45 DEBUG : pacer: Reducing sleep to 83.491978ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/08/07 04:40:45 DEBUG : Creating backend with remote "TestZoho:rclone-test-pufifey7nihe/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/08/07 04:40:45 DEBUG : pacer: Reducing sleep to 118.256526ms 2026/08/07 04:40:45 DEBUG : pacer: Reducing sleep to 237.070084ms 2026/08/07 04:40:45 DEBUG : pacer: Reducing sleep to 286.248056ms 2026/08/07 04:40:45 DEBUG : pacer: Reducing sleep to 211.935947ms 2026/08/07 04:40:46 DEBUG : pacer: Reducing sleep to 93.633298ms 2026/08/07 04:40:46 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:40:46 DEBUG : pacer: Reducing sleep to 121.134511ms 2026/08/07 04:40:46 DEBUG : pacer: Reducing sleep to 240.134812ms 2026/08/07 04:40:46 DEBUG : pacer: Reducing sleep to 285.073828ms 2026/08/07 04:40:47 DEBUG : pacer: Reducing sleep to 211.449649ms 2026/08/07 04:40:47 DEBUG : pacer: Reducing sleep to 93.530002ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/08/07 04:40:47 DEBUG : pacer: Reducing sleep to 44.398742ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/08/07 04:40:47 DEBUG : Creating backend with remote "TestZoho:rclone-test-pufifey7nihe/not found.txt" 2026/08/07 04:40:47 DEBUG : pacer: Reducing sleep to 91.407208ms 2026/08/07 04:40:48 DEBUG : pacer: Reducing sleep to 102.836675ms 2026/08/07 04:40:52 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:40:52 DEBUG : zoho root 'rclone-test-pufifey7nihe/not found.txt': folder listing limiter sweep: evicted 4 of 10 idle limiters 2026/08/07 04:40:57 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1987: Opening root remote "TestZoho:" path "rclone-test-pufifey7nihe" from "TestZoho:rclone-test-pufifey7nihe" 2026/08/07 04:40:57 DEBUG : Creating backend with remote "TestZoho:" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/08/07 04:41:01 DEBUG : pacer: Reducing sleep to 117.878844ms 2026/08/07 04:41:01 DEBUG : pacer: Reducing sleep to 233.904227ms 2026/08/07 04:41:01 DEBUG : pacer: Reducing sleep to 284.819321ms 2026/08/07 04:41:02 DEBUG : pacer: Reducing sleep to 211.885038ms === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/08/07 04:41:06 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:2024: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2026/08/07 04:41:11 DEBUG : pacer: Reducing sleep to 40.669914ms 2026/08/07 04:41:15 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:41:20 DEBUG : pacer: Reducing sleep to 115.390163ms 2026/08/07 04:41:20 DEBUG : pacer: Reducing sleep to 234.35541ms 2026/08/07 04:41:20 DEBUG : pacer: Reducing sleep to 282.277082ms 2026/08/07 04:41:20 DEBUG : pacer: Reducing sleep to 212.436967ms === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/08/07 04:41:20 DEBUG : pacer: Reducing sleep to 71.891436ms 2026/08/07 04:41:24 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:41:24 DEBUG : pacer: Reducing sleep to 118.0354ms 2026/08/07 04:41:24 DEBUG : pacer: Reducing sleep to 236.725476ms 2026/08/07 04:41:25 DEBUG : pacer: Reducing sleep to 281.935967ms 2026/08/07 04:41:25 DEBUG : pacer: Reducing sleep to 212.373819ms === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2083: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:431: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2188: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2204: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2026/08/07 04:41:29 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:41:34 DEBUG : pacer: Reducing sleep to 91.536133ms 2026/08/07 04:41:34 DEBUG : pacer: Reducing sleep to 212.271943ms 2026/08/07 04:41:34 DEBUG : pacer: Reducing sleep to 282.848121ms 2026/08/07 04:41:34 DEBUG : pacer: Reducing sleep to 236.844957ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout 2026/08/07 04:41:34 DEBUG : pacer: Reducing sleep to 115.307477ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream fstests.go:2378: FS has no PutStream interface === RUN TestIntegration/FsMkdir/FsPutFiles/Internal fstests.go:2424: *zoho.Fs does not implement InternalTester === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2445: *zoho.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsPutShortEOF === RUN TestIntegration/FsMkdir/FsPutShortEOF/Simple 2026/08/07 04:41:38 DEBUG : pacer: Reducing sleep to 0s 2026/08/07 04:41:38 DEBUG : pacer: Reducing sleep to 137.431071ms fstests.go:2596: Put returned an error (acceptable): upload error: HTTP error 400 (400 Bad Request) returned body: "\r\n