"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/24 03:25:12 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/24 03:25:12 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/24 03:25:12 NOTICE: zoho root '': Failed to parse Retry-After: "soon": strconv.Atoi: parsing "soon": invalid syntax 2026/08/24 03:25:12 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/24 03:25:12 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/24 03:25:12 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/24 03:25:12 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/24 03:25:12 DEBUG : Creating backend with remote "TestZoho:rclone-test-codetad7qelo" 2026/08/24 03:25:12 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/08/24 03:25:12 DEBUG : zoho root 'rclone-test-codetad7qelo': folder listing limiter sweep: evicted 0 of 0 idle limiters 2026/08/24 03:25:12 DEBUG : TestZoho: Token expired 2026/08/24 03:25:12 DEBUG : TestZoho: No updated token found in the config file 2026/08/24 03:25:13 DEBUG : TestZoho: Token refresh successful 2026/08/24 03:25:13 DEBUG : Saving config "token" in section "TestZoho" of the config file 2026/08/24 03:25:13 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/24 03:25:14 DEBUG : pacer: Reducing sleep to 28.779857ms 2026/08/24 03:25:14 DEBUG : pacer: Reducing sleep to 37.429201ms 2026/08/24 03:25:14 DEBUG : pacer: Reducing sleep to 161.654264ms === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty 2026/08/24 03:25:14 DEBUG : pacer: Reducing sleep to 276.908471ms 2026/08/24 03:25:14 DEBUG : pacer: Reducing sleep to 273.644274ms === RUN TestIntegration/FsMkdir 2026/08/24 03:25:15 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:25:15 DEBUG : pacer: Reducing sleep to 23.046914ms 2026/08/24 03:25:15 DEBUG : pacer: Reducing sleep to 131.375998ms === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/08/24 03:25:15 INFO : dir/subdir: Making directory 2026/08/24 03:25:15 DEBUG : pacer: Reducing sleep to 255.012539ms 2026/08/24 03:25:15 DEBUG : pacer: Reducing sleep to 243.649984ms 2026/08/24 03:25:15 DEBUG : pacer: Reducing sleep to 200.489038ms 2026/08/24 03:25:16 DEBUG : pacer: Reducing sleep to 75.287903ms 2026/08/24 03:25:16 DEBUG : pacer: Reducing sleep to 74.44179ms 2026/08/24 03:25:16 DEBUG : pacer: Reducing sleep to 167.404575ms 2026/08/24 03:25:16 DEBUG : pacer: Reducing sleep to 269.793985ms 2026/08/24 03:25:16 INFO : dir/subdir: Removing directory 2026/08/24 03:25:16 DEBUG : pacer: Reducing sleep to 257.078555ms 2026/08/24 03:25:16 DEBUG : pacer: Reducing sleep to 150.658997ms 2026/08/24 03:25:17 DEBUG : pacer: Reducing sleep to 58.947174ms 2026/08/24 03:25:17 DEBUG : pacer: Reducing sleep to 87.193283ms 2026/08/24 03:25:17 INFO : dir: Removing directory 2026/08/24 03:25:17 DEBUG : pacer: Reducing sleep to 182.736569ms 2026/08/24 03:25:17 DEBUG : pacer: Reducing sleep to 259.064077ms 2026/08/24 03:25:17 DEBUG : pacer: Reducing sleep to 250.918293ms === RUN TestIntegration/FsMkdir/FsListEmpty 2026/08/24 03:25:17 DEBUG : pacer: Reducing sleep to 162.762534ms === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/08/24 03:25:22 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/08/24 03:25:26 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/24 03:25:36 DEBUG : pacer: Reducing sleep to 96.649292ms 2026/08/24 03:25:36 DEBUG : pacer: Reducing sleep to 215.276087ms 2026/08/24 03:25:36 DEBUG : pacer: Reducing sleep to 102.333898ms 2026/08/24 03:25:36 DEBUG : pacer: Reducing sleep to 214.594783ms 2026/08/24 03:25:40 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:25:40 DEBUG : pacer: Reducing sleep to 105.256332ms 2026/08/24 03:25:41 DEBUG : pacer: Reducing sleep to 105.905688ms 2026/08/24 03:25:41 DEBUG : pacer: Reducing sleep to 174.329454ms 2026/08/24 03:25:41 DEBUG : pacer: Reducing sleep to 229.105025ms 2026/08/24 03:25:45 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:727: testing "." 2026/08/24 03:25:50 DEBUG : pacer: Reducing sleep to 46.165965ms 2026/08/24 03:25:50 DEBUG : pacer: Reducing sleep to 168.898669ms 2026/08/24 03:25:50 DEBUG : pacer: Reducing sleep to 143.586372ms 2026/08/24 03:25:50 DEBUG : pacer: Reducing sleep to 257.366024ms 2026/08/24 03:25:54 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:25:54 DEBUG : pacer: Reducing sleep to 112.286613ms 2026/08/24 03:25:54 DEBUG : pacer: Reducing sleep to 60.937239ms 2026/08/24 03:25:55 DEBUG : pacer: Reducing sleep to 133.275403ms 2026/08/24 03:25:55 DEBUG : pacer: Reducing sleep to 227.119099ms 2026/08/24 03:25:59 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:727: testing ".." 2026/08/24 03:26:03 DEBUG : pacer: Reducing sleep to 98.355132ms 2026/08/24 03:26:03 DEBUG : pacer: Reducing sleep to 220.778471ms 2026/08/24 03:26:04 DEBUG : pacer: Reducing sleep to 142.40663ms 2026/08/24 03:26:04 DEBUG : pacer: Reducing sleep to 228.992962ms 2026/08/24 03:26:08 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:26:08 DEBUG : pacer: Reducing sleep to 114.279744ms 2026/08/24 03:26:08 DEBUG : pacer: Reducing sleep to 87.021821ms 2026/08/24 03:26:08 DEBUG : pacer: Reducing sleep to 156.73561ms 2026/08/24 03:26:08 DEBUG : pacer: Reducing sleep to 222.32907ms 2026/08/24 03:26:13 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:727: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2026/08/24 03:26:13 DEBUG : zoho root 'rclone-test-codetad7qelo': folder listing limiter sweep: evicted 0 of 8 idle limiters 2026/08/24 03:26:17 DEBUG : pacer: Reducing sleep to 101.283167ms 2026/08/24 03:26:17 DEBUG : pacer: Reducing sleep to 223.242832ms 2026/08/24 03:26:18 DEBUG : pacer: Reducing sleep to 206.610487ms 2026/08/24 03:26:18 DEBUG : pacer: Reducing sleep to 226.660966ms 2026/08/24 03:26:18 DEBUG : pacer: Reducing sleep to 181.520169ms 2026/08/24 03:26:18 DEBUG : pacer: Reducing sleep to 125.057247ms 2026/08/24 03:26:18 DEBUG : pacer: Reducing sleep to 94.697688ms 2026/08/24 03:26:18 DEBUG : pacer: Reducing sleep to 152.821996ms 2026/08/24 03:26:19 DEBUG : pacer: Reducing sleep to 210.776764ms 2026/08/24 03:26:19 DEBUG : pacer: Reducing sleep to 240.136267ms === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:727: testing " leading space" 2026/08/24 03:26:19 DEBUG : pacer: Reducing sleep to 192.403867ms 2026/08/24 03:26:19 DEBUG : pacer: Reducing sleep to 98.28738ms 2026/08/24 03:26:19 DEBUG : pacer: Reducing sleep to 92.086748ms 2026/08/24 03:26:20 DEBUG : pacer: Reducing sleep to 8.721188ms 2026/08/24 03:26:20 DEBUG : pacer: Reducing sleep to 121.235478ms 2026/08/24 03:26:20 DEBUG : pacer: Reducing sleep to 232.168345ms 2026/08/24 03:26:20 DEBUG : pacer: Reducing sleep to 283.963294ms 2026/08/24 03:26:20 DEBUG : pacer: Reducing sleep to 202.257245ms 2026/08/24 03:26:20 DEBUG : pacer: Reducing sleep to 100.321304ms 2026/08/24 03:26:20 DEBUG : pacer: Reducing sleep to 53.606637ms 2026/08/24 03:26:21 DEBUG : pacer: Reducing sleep to 133.003105ms === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:727: testing "~leading tilde" 2026/08/24 03:26:25 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:26:25 DEBUG : pacer: Reducing sleep to 98.317329ms 2026/08/24 03:26:25 DEBUG : pacer: Reducing sleep to 199.262538ms 2026/08/24 03:26:26 DEBUG : pacer: Reducing sleep to 116.781184ms 2026/08/24 03:26:26 DEBUG : pacer: Reducing sleep to 224.501415ms 2026/08/24 03:26:30 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:26:30 DEBUG : pacer: Reducing sleep to 105.173551ms 2026/08/24 03:26:30 DEBUG : pacer: Reducing sleep to 147.429901ms 2026/08/24 03:26:30 DEBUG : pacer: Reducing sleep to 236.015938ms 2026/08/24 03:26:30 DEBUG : pacer: Reducing sleep to 239.573658ms 2026/08/24 03:26:34 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:727: testing "␍leading CR" 2026/08/24 03:26:39 DEBUG : pacer: Reducing sleep to 98.273205ms 2026/08/24 03:26:39 DEBUG : pacer: Reducing sleep to 221.366827ms 2026/08/24 03:26:39 DEBUG : pacer: Reducing sleep to 205.676618ms 2026/08/24 03:26:39 DEBUG : pacer: Reducing sleep to 229.183119ms 2026/08/24 03:26:44 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:26:44 DEBUG : pacer: Reducing sleep to 107.825418ms 2026/08/24 03:26:44 DEBUG : pacer: Reducing sleep to 94.22387ms 2026/08/24 03:26:44 DEBUG : pacer: Reducing sleep to 160.663484ms 2026/08/24 03:26:44 DEBUG : pacer: Reducing sleep to 228.149995ms 2026/08/24 03:26:48 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:727: testing "␊leading LF" 2026/08/24 03:26:53 DEBUG : pacer: Reducing sleep to 98.606613ms 2026/08/24 03:26:53 DEBUG : pacer: Reducing sleep to 220.516692ms 2026/08/24 03:26:53 DEBUG : pacer: Reducing sleep to 144.705054ms 2026/08/24 03:26:53 DEBUG : pacer: Reducing sleep to 227.881005ms 2026/08/24 03:26:57 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:26:58 DEBUG : pacer: Reducing sleep to 111.844194ms 2026/08/24 03:26:58 DEBUG : pacer: Reducing sleep to 90.588763ms 2026/08/24 03:26:58 DEBUG : pacer: Reducing sleep to 163.40702ms 2026/08/24 03:26:58 DEBUG : pacer: Reducing sleep to 222.639497ms 2026/08/24 03:27:02 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:727: testing "␉leading HT" 2026/08/24 03:27:07 DEBUG : pacer: Reducing sleep to 98.903033ms 2026/08/24 03:27:07 DEBUG : pacer: Reducing sleep to 218.028292ms 2026/08/24 03:27:07 DEBUG : pacer: Reducing sleep to 165.011508ms 2026/08/24 03:27:07 DEBUG : pacer: Reducing sleep to 231.531492ms 2026/08/24 03:27:11 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:27:11 DEBUG : pacer: Reducing sleep to 113.70686ms 2026/08/24 03:27:12 DEBUG : pacer: Reducing sleep to 88.020494ms 2026/08/24 03:27:12 DEBUG : pacer: Reducing sleep to 154.8863ms 2026/08/24 03:27:12 DEBUG : pacer: Reducing sleep to 227.163684ms 2026/08/24 03:27:16 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:727: testing "␋leading VT" 2026/08/24 03:27:16 DEBUG : zoho root 'rclone-test-codetad7qelo': folder listing limiter sweep: evicted 7 of 14 idle limiters 2026/08/24 03:27:16 DEBUG : pacer: Reducing sleep to 123.795488ms 2026/08/24 03:27:16 DEBUG : pacer: Reducing sleep to 77.267092ms 2026/08/24 03:27:16 DEBUG : pacer: Reducing sleep to 148.53605ms 2026/08/24 03:27:16 DEBUG : pacer: Reducing sleep to 130.368247ms 2026/08/24 03:27:17 DEBUG : pacer: Reducing sleep to 247.438368ms 2026/08/24 03:27:18 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:27:18 DEBUG : pacer: Reducing sleep to 113.257823ms 2026/08/24 03:27:18 DEBUG : pacer: Reducing sleep to 75.693841ms 2026/08/24 03:27:18 DEBUG : pacer: Reducing sleep to 136.423563ms 2026/08/24 03:27:18 DEBUG : pacer: Reducing sleep to 221.398428ms 2026/08/24 03:27:18 DEBUG : pacer: Reducing sleep to 261.755667ms === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:727: testing ".leading dot" 2026/08/24 03:27:19 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:27:19 DEBUG : pacer: Reducing sleep to 89.64911ms 2026/08/24 03:27:19 DEBUG : pacer: Reducing sleep to 70.0682ms 2026/08/24 03:27:20 DEBUG : pacer: Reducing sleep to 29.909568ms 2026/08/24 03:27:20 DEBUG : pacer: Reducing sleep to 136.500704ms 2026/08/24 03:27:20 DEBUG : pacer: Reducing sleep to 254.053074ms 2026/08/24 03:27:20 DEBUG : pacer: Reducing sleep to 277.758797ms 2026/08/24 03:27:20 DEBUG : pacer: Reducing sleep to 172.519137ms 2026/08/24 03:27:20 DEBUG : pacer: Reducing sleep to 82.111256ms 2026/08/24 03:27:20 DEBUG : pacer: Reducing sleep to 69.946355ms 2026/08/24 03:27:24 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:727: testing "trailing space " 2026/08/24 03:27:29 DEBUG : pacer: Reducing sleep to 88.388959ms 2026/08/24 03:27:29 DEBUG : pacer: Reducing sleep to 212.476327ms 2026/08/24 03:27:29 DEBUG : pacer: Reducing sleep to 150.868169ms 2026/08/24 03:27:29 DEBUG : pacer: Reducing sleep to 232.093464ms 2026/08/24 03:27:33 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:27:34 DEBUG : pacer: Reducing sleep to 99.362138ms 2026/08/24 03:27:34 DEBUG : pacer: Reducing sleep to 89.701081ms 2026/08/24 03:27:34 DEBUG : pacer: Reducing sleep to 168.309586ms 2026/08/24 03:27:34 DEBUG : pacer: Reducing sleep to 236.380568ms 2026/08/24 03:27:38 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:727: testing "trailing CR␍" 2026/08/24 03:27:43 DEBUG : pacer: Reducing sleep to 94.214049ms 2026/08/24 03:27:43 DEBUG : pacer: Reducing sleep to 217.71534ms 2026/08/24 03:27:43 DEBUG : pacer: Reducing sleep to 184.944893ms 2026/08/24 03:27:43 DEBUG : pacer: Reducing sleep to 228.587773ms 2026/08/24 03:27:47 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:27:47 DEBUG : pacer: Reducing sleep to 109.568635ms 2026/08/24 03:27:48 DEBUG : pacer: Reducing sleep to 86.451123ms 2026/08/24 03:27:48 DEBUG : pacer: Reducing sleep to 156.797038ms 2026/08/24 03:27:48 DEBUG : pacer: Reducing sleep to 232.696858ms 2026/08/24 03:27:52 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:727: testing "trailing LF␊" 2026/08/24 03:27:57 DEBUG : pacer: Reducing sleep to 99.560771ms 2026/08/24 03:27:57 DEBUG : pacer: Reducing sleep to 219.993157ms 2026/08/24 03:27:57 DEBUG : pacer: Reducing sleep to 141.362084ms 2026/08/24 03:27:57 DEBUG : pacer: Reducing sleep to 229.319889ms 2026/08/24 03:28:01 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:28:01 DEBUG : pacer: Reducing sleep to 107.624064ms 2026/08/24 03:28:01 DEBUG : pacer: Reducing sleep to 93.974977ms 2026/08/24 03:28:02 DEBUG : pacer: Reducing sleep to 160.43268ms 2026/08/24 03:28:02 DEBUG : pacer: Reducing sleep to 208.164557ms 2026/08/24 03:28:06 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:727: testing "trailing HT␉" 2026/08/24 03:28:10 DEBUG : pacer: Reducing sleep to 94.524923ms 2026/08/24 03:28:11 DEBUG : pacer: Reducing sleep to 218.502452ms 2026/08/24 03:28:11 DEBUG : pacer: Reducing sleep to 214.358128ms 2026/08/24 03:28:11 DEBUG : pacer: Reducing sleep to 227.142495ms 2026/08/24 03:28:15 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:28:15 DEBUG : pacer: Reducing sleep to 108.783283ms 2026/08/24 03:28:15 DEBUG : pacer: Reducing sleep to 97.248244ms 2026/08/24 03:28:15 DEBUG : pacer: Reducing sleep to 162.758357ms 2026/08/24 03:28:15 DEBUG : pacer: Reducing sleep to 224.815018ms 2026/08/24 03:28:16 DEBUG : pacer: Reducing sleep to 230.558813ms === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:727: testing "trailing VT␋" 2026/08/24 03:28:16 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:28:16 DEBUG : pacer: Reducing sleep to 93.018869ms 2026/08/24 03:28:16 DEBUG : zoho root 'rclone-test-codetad7qelo': folder listing limiter sweep: evicted 6 of 13 idle limiters 2026/08/24 03:28:17 DEBUG : pacer: Reducing sleep to 102.297647ms 2026/08/24 03:28:17 DEBUG : pacer: Reducing sleep to 62.085666ms 2026/08/24 03:28:17 DEBUG : pacer: Reducing sleep to 177.149878ms 2026/08/24 03:28:17 DEBUG : pacer: Reducing sleep to 284.324423ms 2026/08/24 03:28:17 DEBUG : pacer: Reducing sleep to 269.319162ms 2026/08/24 03:28:17 DEBUG : pacer: Reducing sleep to 142.925982ms 2026/08/24 03:28:18 DEBUG : pacer: Reducing sleep to 49.699809ms 2026/08/24 03:28:18 DEBUG : pacer: Reducing sleep to 63.743654ms 2026/08/24 03:28:18 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:727: testing "trailing dot." 2026/08/24 03:28:19 DEBUG : pacer: Reducing sleep to 99.40791ms 2026/08/24 03:28:19 DEBUG : pacer: Reducing sleep to 220.587176ms 2026/08/24 03:28:19 DEBUG : pacer: Reducing sleep to 210.721158ms 2026/08/24 03:28:19 DEBUG : pacer: Reducing sleep to 224.694499ms 2026/08/24 03:28:23 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:28:23 DEBUG : pacer: Reducing sleep to 108.124908ms 2026/08/24 03:28:24 DEBUG : pacer: Reducing sleep to 87.256718ms 2026/08/24 03:28:24 DEBUG : pacer: Reducing sleep to 155.280547ms 2026/08/24 03:28:24 DEBUG : pacer: Reducing sleep to 237.39106ms 2026/08/24 03:28:28 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/24 03:28:33 DEBUG : pacer: Reducing sleep to 89.91124ms 2026/08/24 03:28:33 DEBUG : pacer: Reducing sleep to 213.082676ms 2026/08/24 03:28:33 DEBUG : pacer: Reducing sleep to 129.650013ms 2026/08/24 03:28:33 DEBUG : pacer: Reducing sleep to 235.366505ms 2026/08/24 03:28:37 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:28:37 DEBUG : pacer: Reducing sleep to 110.582356ms 2026/08/24 03:28:37 DEBUG : pacer: Reducing sleep to 71.801004ms 2026/08/24 03:28:38 DEBUG : pacer: Reducing sleep to 153.936524ms 2026/08/24 03:28:38 DEBUG : pacer: Reducing sleep to 230.659055ms 2026/08/24 03:28:42 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/08/24 03:29:00 DEBUG : pacer: Reducing sleep to 97.308255ms 2026/08/24 03:29:00 DEBUG : pacer: Reducing sleep to 218.294575ms 2026/08/24 03:29:00 DEBUG : pacer: Reducing sleep to 260.378155ms 2026/08/24 03:29:01 DEBUG : pacer: Reducing sleep to 232.977517ms 2026/08/24 03:29:01 DEBUG : pacer: Reducing sleep to 114.212989ms 2026/08/24 03:29:01 DEBUG : pacer: Reducing sleep to 70.914005ms 2026/08/24 03:29:01 DEBUG : pacer: Reducing sleep to 95.514455ms 2026/08/24 03:29:01 DEBUG : pacer: Reducing sleep to 261.625824ms 2026/08/24 03:29:01 DEBUG : pacer: Reducing sleep to 287.236171ms === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/08/24 03:29:05 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:29:05 DEBUG : pacer: Reducing sleep to 56.07242ms 2026/08/24 03:29:09 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:29:10 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Mon, 24 Aug 2026 03:29:10 UTC": parsing time "Mon, 24 Aug 2026 03:29:10 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 24 Aug 2026 03:29:10 UTC" as " " 2026/08/24 03:29:10 DEBUG : pacer: Reducing sleep to 108.26348ms === 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/24 03:29:14 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:29:19 DEBUG : zoho root 'rclone-test-codetad7qelo': folder listing limiter sweep: evicted 7 of 14 idle limiters 2026/08/24 03:29:19 DEBUG : pacer: Reducing sleep to 121.245228ms 2026/08/24 03:29:19 DEBUG : pacer: Reducing sleep to 162.513476ms 2026/08/24 03:29:19 DEBUG : pacer: Reducing sleep to 279.847711ms 2026/08/24 03:29:19 DEBUG : pacer: Reducing sleep to 282.185198ms 2026/08/24 03:29:20 DEBUG : pacer: Reducing sleep to 35.641385ms 2026/08/24 03:29:20 DEBUG : pacer: Reducing sleep to 52.318695ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/08/24 03:29:20 DEBUG : pacer: Reducing sleep to 166.851161ms 2026/08/24 03:29:20 DEBUG : pacer: Reducing sleep to 283.833941ms 2026/08/24 03:29:20 DEBUG : pacer: Reducing sleep to 273.854633ms 2026/08/24 03:29:20 DEBUG : pacer: Reducing sleep to 163.11764ms 2026/08/24 03:29:20 DEBUG : pacer: Reducing sleep to 54.000064ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/08/24 03:29:21 DEBUG : pacer: Reducing sleep to 56.043424ms 2026/08/24 03:29:21 DEBUG : pacer: Reducing sleep to 172.090288ms 2026/08/24 03:29:21 DEBUG : pacer: Reducing sleep to 278.348961ms 2026/08/24 03:29:21 DEBUG : pacer: Reducing sleep to 274.055087ms 2026/08/24 03:29:21 DEBUG : pacer: Reducing sleep to 154.949995ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/08/24 03:29:21 DEBUG : pacer: Reducing sleep to 53.638256ms 2026/08/24 03:29:22 DEBUG : pacer: Reducing sleep to 53.288217ms 2026/08/24 03:29:22 DEBUG : pacer: Reducing sleep to 166.609806ms 2026/08/24 03:29:22 DEBUG : pacer: Reducing sleep to 279.55882ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/08/24 03:29:22 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/24 03:29:26 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/24 03:29:31 DEBUG : pacer: Reducing sleep to 109.427796ms 2026/08/24 03:29:31 DEBUG : pacer: Reducing sleep to 228.060021ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/08/24 03:29:36 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:29:36 DEBUG : pacer: Reducing sleep to 117.29018ms 2026/08/24 03:29:36 DEBUG : pacer: Reducing sleep to 104.489694ms 2026/08/24 03:29:36 DEBUG : pacer: Reducing sleep to 156.342204ms 2026/08/24 03:29:36 DEBUG : pacer: Reducing sleep to 213.916159ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject 2026/08/24 03:29:40 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1145: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/08/24 03:29:45 DEBUG : pacer: Reducing sleep to 108.839366ms 2026/08/24 03:29:45 DEBUG : pacer: Reducing sleep to 226.168579ms 2026/08/24 03:29:45 DEBUG : pacer: Reducing sleep to 280.73757ms 2026/08/24 03:29:45 DEBUG : pacer: Reducing sleep to 223.16626ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir 2026/08/24 03:29:50 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge 2026/08/24 03:29:50 DEBUG : pacer: Reducing sleep to 112.541285ms 2026/08/24 03:29:54 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:29:54 DEBUG : pacer: Reducing sleep to 94.306396ms 2026/08/24 03:29:55 DEBUG : pacer: Reducing sleep to 140.348446ms 2026/08/24 03:29:55 DEBUG : pacer: Reducing sleep to 258.580361ms 2026/08/24 03:29:59 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:29:59 DEBUG : pacer: Reducing sleep to 112.55537ms 2026/08/24 03:29:59 DEBUG : pacer: Reducing sleep to 279.158346ms 2026/08/24 03:29:59 DEBUG : pacer: Reducing sleep to 245.949604ms 2026/08/24 03:29:59 DEBUG : pacer: Reducing sleep to 128.462279ms 2026/08/24 03:30:00 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:30:00 DEBUG : pacer: Reducing sleep to 87.109996ms 2026/08/24 03:30:00 DEBUG : pacer: Reducing sleep to 178.396912ms 2026/08/24 03:30:04 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:30:04 DEBUG : pacer: Reducing sleep to 100.697672ms 2026/08/24 03:30:04 DEBUG : pacer: Reducing sleep to 156.210242ms 2026/08/24 03:30:04 DEBUG : pacer: Reducing sleep to 226.961384ms 2026/08/24 03:30:04 DEBUG : pacer: Reducing sleep to 231.217228ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2026/08/24 03:30:08 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:30:13 DEBUG : pacer: Reducing sleep to 103.291428ms 2026/08/24 03:30:13 DEBUG : pacer: Reducing sleep to 84.166177ms 2026/08/24 03:30:13 DEBUG : pacer: Reducing sleep to 198.437275ms 2026/08/24 03:30:17 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:30:17 DEBUG : pacer: Reducing sleep to 118.470036ms 2026/08/24 03:30:17 DEBUG : pacer: Reducing sleep to 275.097799ms 2026/08/24 03:30:18 DEBUG : pacer: Reducing sleep to 302.991371ms 2026/08/24 03:30:18 DEBUG : pacer: Reducing sleep to 192.866934ms 2026/08/24 03:30:18 DEBUG : pacer: Reducing sleep to 58.668495ms 2026/08/24 03:30:18 DEBUG : Creating backend with remote "TestZoho:rclone-test-codetad7qelo/dirToPurgeFromRoot" 2026/08/24 03:30:19 DEBUG : pacer: Reducing sleep to 113.783459ms 2026/08/24 03:30:19 DEBUG : pacer: Reducing sleep to 235.34303ms 2026/08/24 03:30:19 DEBUG : pacer: Reducing sleep to 274.938205ms 2026/08/24 03:30:19 DEBUG : zoho root 'rclone-test-codetad7qelo': folder listing limiter sweep: evicted 2 of 10 idle limiters 2026/08/24 03:30:19 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:30:19 DEBUG : pacer: Reducing sleep to 115.283088ms 2026/08/24 03:30:19 DEBUG : pacer: Reducing sleep to 233.287588ms 2026/08/24 03:30:19 DEBUG : pacer: Reducing sleep to 279.812217ms 2026/08/24 03:30:19 DEBUG : pacer: Reducing sleep to 216.732705ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/08/24 03:30:19 DEBUG : Creating backend with remote "TestZoho:rclone-test-codetad7qelo/hello? sausage/êé" 2026/08/24 03:30:20 DEBUG : pacer: Reducing sleep to 115.398558ms 2026/08/24 03:30:20 DEBUG : pacer: Reducing sleep to 234.240226ms 2026/08/24 03:30:20 DEBUG : pacer: Reducing sleep to 281.912793ms 2026/08/24 03:30:20 DEBUG : pacer: Reducing sleep to 218.849591ms 2026/08/24 03:30:20 DEBUG : pacer: Reducing sleep to 71.782666ms 2026/08/24 03:30:21 DEBUG : pacer: Reducing sleep to 53.096981ms 2026/08/24 03:30:21 DEBUG : pacer: Reducing sleep to 111.35255ms 2026/08/24 03:30:21 DEBUG : pacer: Reducing sleep to 236.228402ms 2026/08/24 03:30:21 DEBUG : pacer: Reducing sleep to 258.20976ms 2026/08/24 03:30:21 DEBUG : pacer: Reducing sleep to 220.248662ms 2026/08/24 03:30:21 DEBUG : pacer: Reducing sleep to 92.429629ms 2026/08/24 03:30:22 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:30:22 DEBUG : pacer: Reducing sleep to 113.212189ms 2026/08/24 03:30:22 DEBUG : pacer: Reducing sleep to 232.391225ms 2026/08/24 03:30:22 DEBUG : pacer: Reducing sleep to 268.560503ms 2026/08/24 03:30:22 DEBUG : pacer: Reducing sleep to 218.49423ms 2026/08/24 03:30:22 DEBUG : pacer: Reducing sleep to 106.626982ms 2026/08/24 03:30:23 DEBUG : pacer: Reducing sleep to 64.607553ms 2026/08/24 03:30:23 DEBUG : pacer: Reducing sleep to 118.610722ms 2026/08/24 03:30:23 DEBUG : pacer: Reducing sleep to 223.560622ms 2026/08/24 03:30:23 DEBUG : pacer: Reducing sleep to 267.777352ms 2026/08/24 03:30:23 DEBUG : pacer: Reducing sleep to 208.477256ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy 2026/08/24 03:30:23 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:30:23 DEBUG : pacer: Reducing sleep to 97.75677ms 2026/08/24 03:30:23 DEBUG : pacer: Reducing sleep to 212.61144ms 2026/08/24 03:30:24 DEBUG : pacer: Reducing sleep to 249.358588ms 2026/08/24 03:30:26 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:30:26 DEBUG : pacer: Reducing sleep to 116.040859ms 2026/08/24 03:30:27 DEBUG : pacer: Reducing sleep to 88.547084ms 2026/08/24 03:30:31 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:30:31 DEBUG : pacer: Reducing sleep to 90.849816ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata fstests.go:1318: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/08/24 03:30:36 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:30:36 DEBUG : pacer: Reducing sleep to 100.498305ms 2026/08/24 03:30:36 DEBUG : pacer: Reducing sleep to 192.150358ms 2026/08/24 03:30:36 DEBUG : pacer: Reducing sleep to 271.680682ms 2026/08/24 03:30:36 DEBUG : pacer: Reducing sleep to 256.975132ms 2026/08/24 03:30:36 DEBUG : pacer: Reducing sleep to 147.414068ms 2026/08/24 03:30:37 DEBUG : pacer: Reducing sleep to 60.559725ms 2026/08/24 03:30:37 DEBUG : pacer: Reducing sleep to 70.726034ms 2026/08/24 03:30:40 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:30:50 DEBUG : pacer: Reducing sleep to 101.385789ms 2026/08/24 03:30:50 DEBUG : pacer: Reducing sleep to 205.532151ms 2026/08/24 03:30:50 DEBUG : pacer: Reducing sleep to 263.213072ms 2026/08/24 03:30:50 DEBUG : pacer: Reducing sleep to 232.526067ms 2026/08/24 03:30:54 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:30:54 DEBUG : pacer: Reducing sleep to 121.064534ms 2026/08/24 03:30:54 DEBUG : pacer: Reducing sleep to 280.348772ms 2026/08/24 03:30:55 DEBUG : pacer: Reducing sleep to 261.997566ms 2026/08/24 03:30:55 DEBUG : pacer: Reducing sleep to 152.344304ms 2026/08/24 03:30:55 DEBUG : pacer: Reducing sleep to 61.06274ms 2026/08/24 03:30:55 DEBUG : pacer: Reducing sleep to 67.549561ms 2026/08/24 03:30:55 DEBUG : pacer: Reducing sleep to 160.058871ms 2026/08/24 03:30:56 DEBUG : pacer: Reducing sleep to 234.738539ms 2026/08/24 03:30:56 DEBUG : pacer: Reducing sleep to 256.209782ms 2026/08/24 03:30:59 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:30:59 DEBUG : pacer: Reducing sleep to 121.739649ms 2026/08/24 03:30:59 DEBUG : pacer: Reducing sleep to 286.645772ms 2026/08/24 03:30:59 DEBUG : pacer: Reducing sleep to 243.272371ms 2026/08/24 03:31:00 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:31:00 DEBUG : pacer: Reducing sleep to 70.59309ms 2026/08/24 03:31:04 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:31:04 DEBUG : pacer: Reducing sleep to 109.333604ms 2026/08/24 03:31:04 DEBUG : pacer: Reducing sleep to 188.309532ms 2026/08/24 03:31:04 DEBUG : pacer: Reducing sleep to 270.464101ms 2026/08/24 03:31:08 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:31:08 DEBUG : pacer: Reducing sleep to 123.623535ms 2026/08/24 03:31:08 DEBUG : pacer: Reducing sleep to 281.081245ms 2026/08/24 03:31:09 DEBUG : pacer: Reducing sleep to 236.112723ms 2026/08/24 03:31:09 DEBUG : pacer: Reducing sleep to 115.907596ms 2026/08/24 03:31:09 DEBUG : pacer: Reducing sleep to 50.292271ms 2026/08/24 03:31:09 DEBUG : pacer: Reducing sleep to 96.099782ms 2026/08/24 03:31:09 DEBUG : pacer: Reducing sleep to 205.026109ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1430: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/08/24 03:31:09 DEBUG : Creating backend with remote "TestZoho:rclone-test-maxajuh0mivo" 2026/08/24 03:31:09 DEBUG : Config file has changed externally - reloading 2026/08/24 03:31:10 DEBUG : pacer: Reducing sleep to 41.894073ms 2026/08/24 03:31:10 DEBUG : pacer: Reducing sleep to 86.541074ms 2026/08/24 03:31:10 DEBUG : pacer: Reducing sleep to 124.406418ms 2026/08/24 03:31:10 DEBUG : pacer: Reducing sleep to 247.618347ms 2026/08/24 03:31:10 DEBUG : pacer: Reducing sleep to 264.960293ms 2026/08/24 03:31:10 DEBUG : pacer: Reducing sleep to 210.588516ms 2026/08/24 03:31:11 DEBUG : pacer: Reducing sleep to 73.57365ms 2026/08/24 03:31:11 DEBUG : pacer: Reducing sleep to 48.413969ms 2026/08/24 03:31:11 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:31:11 DEBUG : pacer: Reducing sleep to 42.173008ms 2026/08/24 03:31:11 DEBUG : pacer: Reducing sleep to 161.571156ms 2026/08/24 03:31:13 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:31:13 DEBUG : pacer: Reducing sleep to 119.969177ms 2026/08/24 03:31:13 DEBUG : pacer: Reducing sleep to 171.256003ms 2026/08/24 03:31:13 DEBUG : pacer: Reducing sleep to 221.501183ms 2026/08/24 03:31:13 DEBUG : pacer: Reducing sleep to 203.876278ms 2026/08/24 03:31:15 DEBUG : pacer: Reducing sleep to 36.530375ms 2026/08/24 03:31:15 DEBUG : pacer: Reducing sleep to 147.701168ms 2026/08/24 03:31:15 DEBUG : pacer: Reducing sleep to 265.704394ms 2026/08/24 03:31:15 DEBUG : pacer: Reducing sleep to 281.206684ms 2026/08/24 03:31:16 DEBUG : pacer: Reducing sleep to 183.139276ms 2026/08/24 03:31:16 DEBUG : pacer: Reducing sleep to 61.144479ms 2026/08/24 03:31:16 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:31:16 DEBUG : pacer: Reducing sleep to 123.561868ms 2026/08/24 03:31:16 DEBUG : zoho root 'rclone-test-maxajuh0mivo': Purge remote 2026/08/24 03:31:16 DEBUG : pacer: Reducing sleep to 126.830634ms 2026/08/24 03:31:16 DEBUG : pacer: Reducing sleep to 155.771028ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull 2026/08/24 03:31:16 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString 2026/08/24 03:31:16 DEBUG : pacer: Reducing sleep to 113.802142ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs 2026/08/24 03:31:17 DEBUG : pacer: Reducing sleep to 230.034843ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote 2026/08/24 03:31:17 DEBUG : pacer: Reducing sleep to 278.893827ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes 2026/08/24 03:31:17 DEBUG : pacer: Reducing sleep to 217.887802ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime 2026/08/24 03:31:18 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/24 03:31:23 DEBUG : zoho root 'rclone-test-codetad7qelo': 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/24 03:31:46 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Mon, 24 Aug 2026 03:31:46 UTC": parsing time "Mon, 24 Aug 2026 03:31:46 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 24 Aug 2026 03:31:46 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/08/24 03:31:50 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Mon, 24 Aug 2026 03:31:50 UTC": parsing time "Mon, 24 Aug 2026 03:31:50 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 24 Aug 2026 03:31:50 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/08/24 03:31:55 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Mon, 24 Aug 2026 03:31:55 UTC": parsing time "Mon, 24 Aug 2026 03:31:55 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 24 Aug 2026 03:31:55 UTC" as " " 2026/08/24 03:31:56 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Mon, 24 Aug 2026 03:31:56 UTC": parsing time "Mon, 24 Aug 2026 03:31:56 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 24 Aug 2026 03:31:56 UTC" as " " 2026/08/24 03:31:56 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Mon, 24 Aug 2026 03:31:56 UTC": parsing time "Mon, 24 Aug 2026 03:31:56 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 24 Aug 2026 03:31:56 UTC" as " " 2026/08/24 03:31:56 DEBUG : pacer: Reducing sleep to 575.925µs 2026/08/24 03:31:56 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Mon, 24 Aug 2026 03:31:56 UTC": parsing time "Mon, 24 Aug 2026 03:31:56 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 24 Aug 2026 03:31:56 UTC" as " " 2026/08/24 03:31:56 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/08/24 03:32:00 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Mon, 24 Aug 2026 03:32:00 UTC": parsing time "Mon, 24 Aug 2026 03:32:00 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 24 Aug 2026 03:32:00 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint 2026/08/24 03:32:04 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Mon, 24 Aug 2026 03:32:04 UTC": parsing time "Mon, 24 Aug 2026 03:32:04 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 24 Aug 2026 03:32:04 UTC" as " " 2026/08/24 03:32:09 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Mon, 24 Aug 2026 03:32:09 UTC": parsing time "Mon, 24 Aug 2026 03:32:09 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 24 Aug 2026 03:32:09 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read 2026/08/24 03:32:09 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Mon, 24 Aug 2026 03:32:09 UTC": parsing time "Mon, 24 Aug 2026 03:32:09 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 24 Aug 2026 03:32:09 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read 2026/08/24 03:32:10 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Mon, 24 Aug 2026 03:32:10 UTC": parsing time "Mon, 24 Aug 2026 03:32:10 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 24 Aug 2026 03:32:10 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read 2026/08/24 03:32:10 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Mon, 24 Aug 2026 03:32:10 UTC": parsing time "Mon, 24 Aug 2026 03:32:10 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 24 Aug 2026 03:32:10 UTC" as " " 2026/08/24 03:32:10 DEBUG : pacer: Reducing sleep to 16.724053ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end 2026/08/24 03:32:10 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Mon, 24 Aug 2026 03:32:10 UTC": parsing time "Mon, 24 Aug 2026 03:32:10 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 24 Aug 2026 03:32:10 UTC" as " " 2026/08/24 03:32:10 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh 2026/08/24 03:32:13 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Mon, 24 Aug 2026 03:32:13 UTC": parsing time "Mon, 24 Aug 2026 03:32:13 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 24 Aug 2026 03:32:13 UTC" as " " 2026/08/24 03:32:13 DEBUG : pacer: Reducing sleep to 1.899304ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/08/24 03:32:18 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:32:18 DEBUG : pacer: Reducing sleep to 114.495098ms 2026/08/24 03:32:19 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Mon, 24 Aug 2026 03:32:18 UTC": parsing time "Mon, 24 Aug 2026 03:32:18 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 24 Aug 2026 03:32:18 UTC" as " " 2026/08/24 03:32:19 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable 2026/08/24 03:32:19 DEBUG : pacer: Reducing sleep to 109.825732ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/08/24 03:32:19 DEBUG : Creating backend with remote "TestZoho:rclone-test-codetad7qelo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/08/24 03:32:19 DEBUG : pacer: Reducing sleep to 118.513026ms 2026/08/24 03:32:19 DEBUG : pacer: Reducing sleep to 235.336572ms 2026/08/24 03:32:19 DEBUG : pacer: Reducing sleep to 284.963269ms 2026/08/24 03:32:19 DEBUG : pacer: Reducing sleep to 211.755913ms 2026/08/24 03:32:20 DEBUG : pacer: Reducing sleep to 88.657853ms 2026/08/24 03:32:20 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:32:20 DEBUG : pacer: Reducing sleep to 118.410982ms 2026/08/24 03:32:20 DEBUG : pacer: Reducing sleep to 234.897291ms 2026/08/24 03:32:20 DEBUG : pacer: Reducing sleep to 283.503985ms 2026/08/24 03:32:20 DEBUG : pacer: Reducing sleep to 212.060475ms 2026/08/24 03:32:21 DEBUG : pacer: Reducing sleep to 96.748899ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/08/24 03:32:21 DEBUG : pacer: Reducing sleep to 44.520401ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/08/24 03:32:21 DEBUG : Creating backend with remote "TestZoho:rclone-test-codetad7qelo/not found.txt" 2026/08/24 03:32:21 DEBUG : pacer: Reducing sleep to 119.766462ms 2026/08/24 03:32:21 DEBUG : pacer: Reducing sleep to 163.320655ms 2026/08/24 03:32:26 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:32:26 DEBUG : zoho root 'rclone-test-codetad7qelo/not found.txt': folder listing limiter sweep: evicted 4 of 10 idle limiters 2026/08/24 03:32:30 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1987: Opening root remote "TestZoho:" path "rclone-test-codetad7qelo" from "TestZoho:rclone-test-codetad7qelo" 2026/08/24 03:32:30 DEBUG : Creating backend with remote "TestZoho:" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/08/24 03:32:35 DEBUG : pacer: Reducing sleep to 119.031343ms 2026/08/24 03:32:35 DEBUG : pacer: Reducing sleep to 226.493924ms 2026/08/24 03:32:35 DEBUG : pacer: Reducing sleep to 281.896948ms 2026/08/24 03:32:35 DEBUG : pacer: Reducing sleep to 218.633645ms === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/08/24 03:32:40 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/24 03:32:53 DEBUG : pacer: Reducing sleep to 119.401561ms 2026/08/24 03:32:53 DEBUG : pacer: Reducing sleep to 232.293332ms 2026/08/24 03:32:54 DEBUG : pacer: Reducing sleep to 275.089483ms 2026/08/24 03:32:54 DEBUG : pacer: Reducing sleep to 209.756839ms === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/08/24 03:32:54 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:32:58 DEBUG : pacer: Reducing sleep to 118.503778ms 2026/08/24 03:32:58 DEBUG : pacer: Reducing sleep to 228.958617ms 2026/08/24 03:32:58 DEBUG : pacer: Reducing sleep to 280.809594ms 2026/08/24 03:32:58 DEBUG : pacer: Reducing sleep to 217.165127ms === 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/24 03:33:03 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:33:07 DEBUG : pacer: Reducing sleep to 119.040119ms 2026/08/24 03:33:07 DEBUG : pacer: Reducing sleep to 241.383656ms 2026/08/24 03:33:07 DEBUG : pacer: Reducing sleep to 281.493213ms 2026/08/24 03:33:08 DEBUG : pacer: Reducing sleep to 209.933141ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout 2026/08/24 03:33:08 DEBUG : pacer: Reducing sleep to 87.045934ms === 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/24 03:33:12 DEBUG : pacer: Reducing sleep to 0s 2026/08/24 03:33:12 DEBUG : pacer: Reducing sleep to 139.126425ms fstests.go:2596: Put returned an error (acceptable): upload error: HTTP error 400 (400 Bad Request) returned body: "\r\n