"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/18 03:13:02 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/18 03:13:02 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/18 03:13:02 NOTICE: zoho root '': Failed to parse Retry-After: "soon": strconv.Atoi: parsing "soon": invalid syntax 2026/08/18 03:13:02 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/18 03:13:02 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/18 03:13:02 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/18 03:13:02 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/18 03:13:02 DEBUG : Creating backend with remote "TestZoho:rclone-test-fudobok1rola" 2026/08/18 03:13:02 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2026/08/18 03:13:02 DEBUG : zoho root 'rclone-test-fudobok1rola': folder listing limiter sweep: evicted 0 of 0 idle limiters 2026/08/18 03:13:02 DEBUG : TestZoho: Token expired 2026/08/18 03:13:02 DEBUG : TestZoho: No updated token found in the config file 2026/08/18 03:13:02 DEBUG : TestZoho: Token refresh successful 2026/08/18 03:13:02 DEBUG : Saving config "token" in section "TestZoho" of the config file 2026/08/18 03:13:02 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/18 03:13:03 DEBUG : pacer: Reducing sleep to 4.062034ms 2026/08/18 03:13:03 DEBUG : pacer: Reducing sleep to 9.85095ms 2026/08/18 03:13:03 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:13:03 DEBUG : pacer: Reducing sleep to 96.191531ms === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty 2026/08/18 03:13:03 DEBUG : pacer: Reducing sleep to 188.809144ms 2026/08/18 03:13:03 DEBUG : pacer: Reducing sleep to 245.171052ms === RUN TestIntegration/FsMkdir 2026/08/18 03:13:04 DEBUG : pacer: Reducing sleep to 152.137622ms 2026/08/18 03:13:04 DEBUG : pacer: Reducing sleep to 62.507309ms 2026/08/18 03:13:04 DEBUG : pacer: Reducing sleep to 158.399576ms === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/08/18 03:13:04 INFO : dir/subdir: Making directory 2026/08/18 03:13:04 DEBUG : pacer: Reducing sleep to 254.195531ms 2026/08/18 03:13:04 DEBUG : pacer: Reducing sleep to 236.972642ms 2026/08/18 03:13:04 DEBUG : pacer: Reducing sleep to 173.371191ms 2026/08/18 03:13:05 DEBUG : pacer: Reducing sleep to 73.870972ms 2026/08/18 03:13:05 DEBUG : pacer: Reducing sleep to 84.544882ms 2026/08/18 03:13:05 DEBUG : pacer: Reducing sleep to 174.593854ms 2026/08/18 03:13:05 DEBUG : pacer: Reducing sleep to 260.847819ms 2026/08/18 03:13:05 INFO : dir/subdir: Removing directory 2026/08/18 03:13:05 DEBUG : pacer: Reducing sleep to 248.800393ms 2026/08/18 03:13:06 DEBUG : pacer: Reducing sleep to 141.246654ms 2026/08/18 03:13:06 DEBUG : pacer: Reducing sleep to 66.052031ms 2026/08/18 03:13:06 DEBUG : pacer: Reducing sleep to 96.526113ms 2026/08/18 03:13:06 INFO : dir: Removing directory 2026/08/18 03:13:06 DEBUG : pacer: Reducing sleep to 189.267599ms 2026/08/18 03:13:06 DEBUG : pacer: Reducing sleep to 247.336018ms 2026/08/18 03:13:06 DEBUG : pacer: Reducing sleep to 239.907564ms === RUN TestIntegration/FsMkdir/FsListEmpty 2026/08/18 03:13:06 DEBUG : pacer: Reducing sleep to 155.943863ms === RUN TestIntegration/FsMkdir/FsListDirEmpty 2026/08/18 03:13:11 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2026/08/18 03:13:16 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/18 03:13:25 DEBUG : pacer: Reducing sleep to 69.621134ms 2026/08/18 03:13:25 DEBUG : pacer: Reducing sleep to 167.461128ms 2026/08/18 03:13:25 DEBUG : pacer: Reducing sleep to 64.464673ms 2026/08/18 03:13:25 DEBUG : pacer: Reducing sleep to 154.725054ms 2026/08/18 03:13:29 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:13:29 DEBUG : pacer: Reducing sleep to 87.27412ms 2026/08/18 03:13:30 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:13:30 DEBUG : pacer: Reducing sleep to 34.950764ms 2026/08/18 03:13:30 DEBUG : pacer: Reducing sleep to 101.503233ms 2026/08/18 03:13:34 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:727: testing "." 2026/08/18 03:13:39 DEBUG : pacer: Reducing sleep to 68.420005ms 2026/08/18 03:13:39 DEBUG : pacer: Reducing sleep to 165.215096ms 2026/08/18 03:13:39 DEBUG : pacer: Reducing sleep to 138.119602ms 2026/08/18 03:13:39 DEBUG : pacer: Reducing sleep to 225.65714ms 2026/08/18 03:13:43 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:13:43 DEBUG : pacer: Reducing sleep to 84.831067ms 2026/08/18 03:13:43 DEBUG : pacer: Reducing sleep to 92.881943ms 2026/08/18 03:13:44 DEBUG : pacer: Reducing sleep to 174.610732ms 2026/08/18 03:13:44 DEBUG : pacer: Reducing sleep to 247.923458ms 2026/08/18 03:13:48 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:727: testing ".." 2026/08/18 03:13:53 DEBUG : pacer: Reducing sleep to 69.825221ms 2026/08/18 03:13:53 DEBUG : pacer: Reducing sleep to 166.549798ms 2026/08/18 03:13:53 DEBUG : pacer: Reducing sleep to 93.189074ms 2026/08/18 03:13:53 DEBUG : pacer: Reducing sleep to 183.270386ms 2026/08/18 03:13:57 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:13:57 DEBUG : pacer: Reducing sleep to 86.539824ms 2026/08/18 03:13:57 DEBUG : pacer: Reducing sleep to 139.087096ms 2026/08/18 03:13:57 DEBUG : pacer: Reducing sleep to 229.530783ms 2026/08/18 03:13:58 DEBUG : pacer: Reducing sleep to 246.63301ms 2026/08/18 03:14:02 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:727: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~" 2026/08/18 03:14:02 DEBUG : zoho root 'rclone-test-fudobok1rola': folder listing limiter sweep: evicted 0 of 8 idle limiters 2026/08/18 03:14:06 DEBUG : pacer: Reducing sleep to 71.370437ms 2026/08/18 03:14:06 DEBUG : pacer: Reducing sleep to 168.465354ms 2026/08/18 03:14:07 DEBUG : pacer: Reducing sleep to 178.243399ms 2026/08/18 03:14:07 DEBUG : pacer: Reducing sleep to 249.406456ms 2026/08/18 03:14:07 DEBUG : pacer: Reducing sleep to 245.121294ms 2026/08/18 03:14:07 DEBUG : pacer: Reducing sleep to 158.757013ms 2026/08/18 03:14:07 DEBUG : pacer: Reducing sleep to 68.770252ms 2026/08/18 03:14:08 DEBUG : pacer: Reducing sleep to 85.600235ms 2026/08/18 03:14:08 DEBUG : pacer: Reducing sleep to 161.301149ms 2026/08/18 03:14:08 DEBUG : pacer: Reducing sleep to 257.770755ms === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:727: testing " leading space" 2026/08/18 03:14:08 DEBUG : pacer: Reducing sleep to 259.436511ms 2026/08/18 03:14:08 DEBUG : pacer: Reducing sleep to 146.804466ms 2026/08/18 03:14:08 DEBUG : pacer: Reducing sleep to 77.147667ms 2026/08/18 03:14:09 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:14:09 DEBUG : pacer: Reducing sleep to 89.186823ms 2026/08/18 03:14:09 DEBUG : pacer: Reducing sleep to 179.92331ms 2026/08/18 03:14:09 DEBUG : pacer: Reducing sleep to 257.409437ms 2026/08/18 03:14:09 DEBUG : pacer: Reducing sleep to 227.273428ms 2026/08/18 03:14:09 DEBUG : pacer: Reducing sleep to 148.197281ms 2026/08/18 03:14:10 DEBUG : pacer: Reducing sleep to 65.798749ms 2026/08/18 03:14:10 DEBUG : pacer: Reducing sleep to 110.73565ms === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:727: testing "~leading tilde" 2026/08/18 03:14:14 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:14:14 DEBUG : pacer: Reducing sleep to 69.976044ms 2026/08/18 03:14:14 DEBUG : pacer: Reducing sleep to 167.561326ms 2026/08/18 03:14:15 DEBUG : pacer: Reducing sleep to 132.424442ms 2026/08/18 03:14:15 DEBUG : pacer: Reducing sleep to 198.837699ms 2026/08/18 03:14:19 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:14:19 DEBUG : pacer: Reducing sleep to 84.94015ms 2026/08/18 03:14:19 DEBUG : pacer: Reducing sleep to 122.198781ms 2026/08/18 03:14:19 DEBUG : pacer: Reducing sleep to 214.140857ms 2026/08/18 03:14:19 DEBUG : pacer: Reducing sleep to 252.307061ms 2026/08/18 03:14:24 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:727: testing "␍leading CR" 2026/08/18 03:14:28 DEBUG : pacer: Reducing sleep to 69.569355ms 2026/08/18 03:14:28 DEBUG : pacer: Reducing sleep to 164.761548ms 2026/08/18 03:14:29 DEBUG : pacer: Reducing sleep to 122.145299ms 2026/08/18 03:14:29 DEBUG : pacer: Reducing sleep to 213.265582ms 2026/08/18 03:14:33 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:14:33 DEBUG : pacer: Reducing sleep to 87.159544ms 2026/08/18 03:14:33 DEBUG : pacer: Reducing sleep to 110.985626ms 2026/08/18 03:14:33 DEBUG : pacer: Reducing sleep to 200.005583ms 2026/08/18 03:14:33 DEBUG : pacer: Reducing sleep to 242.578579ms 2026/08/18 03:14:37 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:727: testing "␊leading LF" 2026/08/18 03:14:42 DEBUG : pacer: Reducing sleep to 68.559258ms 2026/08/18 03:14:42 DEBUG : pacer: Reducing sleep to 165.266431ms 2026/08/18 03:14:42 DEBUG : pacer: Reducing sleep to 178.697202ms 2026/08/18 03:14:42 DEBUG : pacer: Reducing sleep to 257.050254ms 2026/08/18 03:14:47 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:14:47 DEBUG : pacer: Reducing sleep to 84.032196ms 2026/08/18 03:14:47 DEBUG : pacer: Reducing sleep to 66.18357ms 2026/08/18 03:14:47 DEBUG : pacer: Reducing sleep to 158.28142ms 2026/08/18 03:14:47 DEBUG : pacer: Reducing sleep to 239.808775ms 2026/08/18 03:14:51 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:727: testing "␉leading HT" 2026/08/18 03:14:56 DEBUG : pacer: Reducing sleep to 70.056054ms 2026/08/18 03:14:56 DEBUG : pacer: Reducing sleep to 167.46428ms 2026/08/18 03:14:56 DEBUG : pacer: Reducing sleep to 151.703635ms 2026/08/18 03:14:56 DEBUG : pacer: Reducing sleep to 241.100032ms 2026/08/18 03:15:00 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:15:01 DEBUG : pacer: Reducing sleep to 85.271909ms 2026/08/18 03:15:01 DEBUG : pacer: Reducing sleep to 81.208814ms 2026/08/18 03:15:01 DEBUG : pacer: Reducing sleep to 174.971566ms 2026/08/18 03:15:01 DEBUG : pacer: Reducing sleep to 248.259192ms 2026/08/18 03:15:05 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:727: testing "␋leading VT" 2026/08/18 03:15:05 DEBUG : zoho root 'rclone-test-fudobok1rola': folder listing limiter sweep: evicted 7 of 14 idle limiters 2026/08/18 03:15:05 DEBUG : pacer: Reducing sleep to 94.54545ms 2026/08/18 03:15:05 DEBUG : pacer: Reducing sleep to 57.638521ms 2026/08/18 03:15:05 DEBUG : pacer: Reducing sleep to 153.617087ms 2026/08/18 03:15:06 DEBUG : pacer: Reducing sleep to 145.573867ms 2026/08/18 03:15:06 DEBUG : pacer: Reducing sleep to 237.897091ms 2026/08/18 03:15:07 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:15:07 DEBUG : pacer: Reducing sleep to 93.76632ms 2026/08/18 03:15:07 DEBUG : pacer: Reducing sleep to 85.962521ms 2026/08/18 03:15:07 DEBUG : pacer: Reducing sleep to 169.641269ms 2026/08/18 03:15:07 DEBUG : pacer: Reducing sleep to 241.181686ms 2026/08/18 03:15:07 DEBUG : pacer: Reducing sleep to 250.157915ms === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:727: testing ".leading dot" 2026/08/18 03:15:08 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:15:08 DEBUG : pacer: Reducing sleep to 70.482447ms 2026/08/18 03:15:08 DEBUG : pacer: Reducing sleep to 83.584758ms 2026/08/18 03:15:09 DEBUG : pacer: Reducing sleep to 44.472546ms 2026/08/18 03:15:09 DEBUG : pacer: Reducing sleep to 134.911932ms 2026/08/18 03:15:09 DEBUG : pacer: Reducing sleep to 225.685188ms 2026/08/18 03:15:09 DEBUG : pacer: Reducing sleep to 257.677371ms 2026/08/18 03:15:09 DEBUG : pacer: Reducing sleep to 184.291414ms 2026/08/18 03:15:09 DEBUG : pacer: Reducing sleep to 106.668568ms 2026/08/18 03:15:10 DEBUG : pacer: Reducing sleep to 72.004745ms 2026/08/18 03:15:13 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:727: testing "trailing space " 2026/08/18 03:15:18 DEBUG : pacer: Reducing sleep to 69.950234ms 2026/08/18 03:15:18 DEBUG : pacer: Reducing sleep to 166.347041ms 2026/08/18 03:15:18 DEBUG : pacer: Reducing sleep to 160.948964ms 2026/08/18 03:15:18 DEBUG : pacer: Reducing sleep to 252.131072ms 2026/08/18 03:15:23 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:15:23 DEBUG : pacer: Reducing sleep to 86.247149ms 2026/08/18 03:15:23 DEBUG : pacer: Reducing sleep to 73.941698ms 2026/08/18 03:15:23 DEBUG : pacer: Reducing sleep to 162.881432ms 2026/08/18 03:15:23 DEBUG : pacer: Reducing sleep to 246.085756ms 2026/08/18 03:15:27 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:727: testing "trailing CR␍" 2026/08/18 03:15:32 DEBUG : pacer: Reducing sleep to 66.195904ms 2026/08/18 03:15:32 DEBUG : pacer: Reducing sleep to 163.48312ms 2026/08/18 03:15:32 DEBUG : pacer: Reducing sleep to 98.619517ms 2026/08/18 03:15:32 DEBUG : pacer: Reducing sleep to 189.350254ms 2026/08/18 03:15:37 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:15:37 DEBUG : pacer: Reducing sleep to 86.071487ms 2026/08/18 03:15:37 DEBUG : pacer: Reducing sleep to 132.64329ms 2026/08/18 03:15:37 DEBUG : pacer: Reducing sleep to 224.648764ms 2026/08/18 03:15:37 DEBUG : pacer: Reducing sleep to 249.577086ms 2026/08/18 03:15:41 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:727: testing "trailing LF␊" 2026/08/18 03:15:46 DEBUG : pacer: Reducing sleep to 67.535253ms 2026/08/18 03:15:46 DEBUG : pacer: Reducing sleep to 164.045583ms 2026/08/18 03:15:46 DEBUG : pacer: Reducing sleep to 176.392185ms 2026/08/18 03:15:46 DEBUG : pacer: Reducing sleep to 256.765701ms 2026/08/18 03:15:50 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:15:50 DEBUG : pacer: Reducing sleep to 86.141118ms 2026/08/18 03:15:51 DEBUG : pacer: Reducing sleep to 63.594635ms 2026/08/18 03:15:51 DEBUG : pacer: Reducing sleep to 156.574258ms 2026/08/18 03:15:51 DEBUG : pacer: Reducing sleep to 236.330851ms 2026/08/18 03:15:55 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:727: testing "trailing HT␉" 2026/08/18 03:16:00 DEBUG : pacer: Reducing sleep to 92.098678ms 2026/08/18 03:16:00 DEBUG : pacer: Reducing sleep to 37.954076ms 2026/08/18 03:16:00 DEBUG : pacer: Reducing sleep to 128.376159ms 2026/08/18 03:16:04 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:16:04 DEBUG : pacer: Reducing sleep to 85.307293ms 2026/08/18 03:16:04 DEBUG : pacer: Reducing sleep to 166.22155ms 2026/08/18 03:16:04 DEBUG : pacer: Reducing sleep to 257.386586ms 2026/08/18 03:16:05 DEBUG : pacer: Reducing sleep to 249.145307ms 2026/08/18 03:16:05 DEBUG : pacer: Reducing sleep to 170.476392ms === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:727: testing "trailing VT␋" 2026/08/18 03:16:06 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:16:06 DEBUG : pacer: Reducing sleep to 67.30705ms 2026/08/18 03:16:06 DEBUG : zoho root 'rclone-test-fudobok1rola': folder listing limiter sweep: evicted 6 of 13 idle limiters 2026/08/18 03:16:06 DEBUG : pacer: Reducing sleep to 164.334136ms 2026/08/18 03:16:06 DEBUG : pacer: Reducing sleep to 184.017942ms 2026/08/18 03:16:06 DEBUG : pacer: Reducing sleep to 256.619963ms 2026/08/18 03:16:06 DEBUG : pacer: Reducing sleep to 239.20904ms 2026/08/18 03:16:06 DEBUG : pacer: Reducing sleep to 148.727585ms 2026/08/18 03:16:07 DEBUG : pacer: Reducing sleep to 64.139241ms 2026/08/18 03:16:07 DEBUG : pacer: Reducing sleep to 95.150177ms 2026/08/18 03:16:07 DEBUG : pacer: Reducing sleep to 180.177544ms 2026/08/18 03:16:07 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:727: testing "trailing dot." 2026/08/18 03:16:08 DEBUG : pacer: Reducing sleep to 69.638083ms 2026/08/18 03:16:08 DEBUG : pacer: Reducing sleep to 166.617498ms 2026/08/18 03:16:08 DEBUG : pacer: Reducing sleep to 140.837981ms 2026/08/18 03:16:08 DEBUG : pacer: Reducing sleep to 230.418814ms 2026/08/18 03:16:12 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:16:13 DEBUG : pacer: Reducing sleep to 85.578985ms 2026/08/18 03:16:13 DEBUG : pacer: Reducing sleep to 90.904667ms 2026/08/18 03:16:13 DEBUG : pacer: Reducing sleep to 183.939134ms 2026/08/18 03:16:13 DEBUG : pacer: Reducing sleep to 247.60084ms 2026/08/18 03:16:17 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/18 03:16:22 DEBUG : pacer: Reducing sleep to 72.177279ms 2026/08/18 03:16:22 DEBUG : pacer: Reducing sleep to 168.478493ms 2026/08/18 03:16:22 DEBUG : pacer: Reducing sleep to 186.349657ms 2026/08/18 03:16:22 DEBUG : pacer: Reducing sleep to 254.338523ms 2026/08/18 03:16:26 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:16:26 DEBUG : pacer: Reducing sleep to 88.002503ms 2026/08/18 03:16:27 DEBUG : pacer: Reducing sleep to 51.858923ms 2026/08/18 03:16:27 DEBUG : pacer: Reducing sleep to 145.611284ms 2026/08/18 03:16:27 DEBUG : pacer: Reducing sleep to 231.342347ms 2026/08/18 03:16:31 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/08/18 03:16:49 DEBUG : pacer: Reducing sleep to 71.067122ms 2026/08/18 03:16:50 DEBUG : pacer: Reducing sleep to 166.900281ms 2026/08/18 03:16:50 DEBUG : pacer: Reducing sleep to 216.74247ms 2026/08/18 03:16:50 DEBUG : pacer: Reducing sleep to 259.662837ms 2026/08/18 03:16:50 DEBUG : pacer: Reducing sleep to 182.265579ms 2026/08/18 03:16:50 DEBUG : pacer: Reducing sleep to 118.717284ms 2026/08/18 03:16:50 DEBUG : pacer: Reducing sleep to 65.58495ms 2026/08/18 03:16:50 DEBUG : pacer: Reducing sleep to 218.294138ms 2026/08/18 03:16:51 DEBUG : pacer: Reducing sleep to 245.800236ms === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/08/18 03:16:54 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:16:59 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Tue, 18 Aug 2026 03:16:59 UTC": parsing time "Tue, 18 Aug 2026 03:16:59 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 18 Aug 2026 03:16:59 UTC" as " " 2026/08/18 03:16:59 DEBUG : pacer: Reducing sleep to 79.528376ms === 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/18 03:17:03 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:17:08 DEBUG : zoho root 'rclone-test-fudobok1rola': folder listing limiter sweep: evicted 7 of 14 idle limiters 2026/08/18 03:17:08 DEBUG : pacer: Reducing sleep to 95.229821ms 2026/08/18 03:17:08 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:17:08 DEBUG : pacer: Reducing sleep to 90.727177ms 2026/08/18 03:17:08 DEBUG : pacer: Reducing sleep to 181.873617ms 2026/08/18 03:17:09 DEBUG : pacer: Reducing sleep to 167.39159ms 2026/08/18 03:17:09 DEBUG : pacer: Reducing sleep to 238.41606ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 2026/08/18 03:17:09 DEBUG : pacer: Reducing sleep to 239.104262ms 2026/08/18 03:17:09 DEBUG : pacer: Reducing sleep to 160.681478ms 2026/08/18 03:17:09 DEBUG : pacer: Reducing sleep to 85.197612ms 2026/08/18 03:17:09 DEBUG : pacer: Reducing sleep to 96.749781ms 2026/08/18 03:17:10 DEBUG : pacer: Reducing sleep to 168.565575ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR 2026/08/18 03:17:10 DEBUG : pacer: Reducing sleep to 242.056803ms 2026/08/18 03:17:10 DEBUG : pacer: Reducing sleep to 241.982506ms 2026/08/18 03:17:10 DEBUG : pacer: Reducing sleep to 168.227164ms 2026/08/18 03:17:10 DEBUG : pacer: Reducing sleep to 92.076581ms 2026/08/18 03:17:10 DEBUG : pacer: Reducing sleep to 84.32249ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir 2026/08/18 03:17:11 DEBUG : pacer: Reducing sleep to 162.735843ms 2026/08/18 03:17:11 DEBUG : pacer: Reducing sleep to 244.716373ms 2026/08/18 03:17:11 DEBUG : pacer: Reducing sleep to 247.014676ms 2026/08/18 03:17:11 DEBUG : pacer: Reducing sleep to 168.310369ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/08/18 03:17:11 DEBUG : Creating backend with remote "TestZoho:" 2026/08/18 03:17:11 DEBUG : Config file has changed externally - reloading === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir 2026/08/18 03:17:15 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/18 03:17:20 DEBUG : pacer: Reducing sleep to 88.317526ms 2026/08/18 03:17:20 DEBUG : pacer: Reducing sleep to 180.182323ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:418: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 2026/08/18 03:17:25 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:17:25 DEBUG : pacer: Reducing sleep to 90.014421ms 2026/08/18 03:17:25 DEBUG : pacer: Reducing sleep to 152.970473ms 2026/08/18 03:17:25 DEBUG : pacer: Reducing sleep to 224.553136ms 2026/08/18 03:17:25 DEBUG : pacer: Reducing sleep to 240.221127ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject 2026/08/18 03:17:29 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1145: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 2026/08/18 03:17:34 DEBUG : pacer: Reducing sleep to 89.133556ms 2026/08/18 03:17:34 DEBUG : pacer: Reducing sleep to 182.95145ms 2026/08/18 03:17:34 DEBUG : pacer: Reducing sleep to 257.561661ms 2026/08/18 03:17:34 DEBUG : pacer: Reducing sleep to 236.221664ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir 2026/08/18 03:17:39 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge 2026/08/18 03:17:39 DEBUG : pacer: Reducing sleep to 90.982841ms 2026/08/18 03:17:44 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:17:44 DEBUG : pacer: Reducing sleep to 56.820814ms 2026/08/18 03:17:44 DEBUG : pacer: Reducing sleep to 30.530026ms 2026/08/18 03:17:44 DEBUG : pacer: Reducing sleep to 122.995716ms 2026/08/18 03:17:48 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:17:48 DEBUG : pacer: Reducing sleep to 87.941907ms 2026/08/18 03:17:48 DEBUG : pacer: Reducing sleep to 254.006416ms 2026/08/18 03:17:48 DEBUG : pacer: Reducing sleep to 346.103931ms 2026/08/18 03:17:48 DEBUG : pacer: Reducing sleep to 423.628675ms 2026/08/18 03:17:49 DEBUG : pacer: Reducing sleep to 240.187595ms 2026/08/18 03:17:49 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:17:49 DEBUG : pacer: Reducing sleep to 81.845745ms 2026/08/18 03:17:53 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:17:53 DEBUG : pacer: Reducing sleep to 92.537815ms 2026/08/18 03:17:53 DEBUG : pacer: Reducing sleep to 182.068003ms 2026/08/18 03:17:53 DEBUG : pacer: Reducing sleep to 257.543918ms 2026/08/18 03:17:53 DEBUG : pacer: Reducing sleep to 240.042519ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2026/08/18 03:17:57 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:18:02 DEBUG : pacer: Reducing sleep to 70.133195ms 2026/08/18 03:18:02 DEBUG : pacer: Reducing sleep to 87.784229ms 2026/08/18 03:18:02 DEBUG : pacer: Reducing sleep to 179.26549ms 2026/08/18 03:18:07 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:18:07 DEBUG : pacer: Reducing sleep to 88.751305ms 2026/08/18 03:18:07 DEBUG : pacer: Reducing sleep to 252.068224ms 2026/08/18 03:18:07 DEBUG : pacer: Reducing sleep to 319.587525ms 2026/08/18 03:18:07 DEBUG : pacer: Reducing sleep to 236.027856ms 2026/08/18 03:18:07 DEBUG : pacer: Reducing sleep to 78.419798ms 2026/08/18 03:18:07 DEBUG : Creating backend with remote "TestZoho:rclone-test-fudobok1rola/dirToPurgeFromRoot" 2026/08/18 03:18:08 DEBUG : pacer: Reducing sleep to 121.519847ms 2026/08/18 03:18:08 DEBUG : pacer: Reducing sleep to 244.411294ms 2026/08/18 03:18:08 DEBUG : pacer: Reducing sleep to 277.595323ms 2026/08/18 03:18:08 DEBUG : zoho root 'rclone-test-fudobok1rola': folder listing limiter sweep: evicted 2 of 10 idle limiters 2026/08/18 03:18:08 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:18:08 DEBUG : pacer: Reducing sleep to 89.973653ms 2026/08/18 03:18:08 DEBUG : pacer: Reducing sleep to 181.046042ms 2026/08/18 03:18:08 DEBUG : pacer: Reducing sleep to 254.803521ms 2026/08/18 03:18:08 DEBUG : pacer: Reducing sleep to 239.601954ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/08/18 03:18:08 DEBUG : Creating backend with remote "TestZoho:rclone-test-fudobok1rola/hello? sausage/êé" 2026/08/18 03:18:09 DEBUG : pacer: Reducing sleep to 117.155095ms 2026/08/18 03:18:09 DEBUG : pacer: Reducing sleep to 238.226345ms 2026/08/18 03:18:09 DEBUG : pacer: Reducing sleep to 283.342757ms 2026/08/18 03:18:09 DEBUG : pacer: Reducing sleep to 212.727724ms 2026/08/18 03:18:09 DEBUG : pacer: Reducing sleep to 71.487085ms 2026/08/18 03:18:10 DEBUG : pacer: Reducing sleep to 50.738753ms 2026/08/18 03:18:10 DEBUG : pacer: Reducing sleep to 104.901288ms 2026/08/18 03:18:10 DEBUG : pacer: Reducing sleep to 229.903262ms 2026/08/18 03:18:10 DEBUG : pacer: Reducing sleep to 260.729408ms 2026/08/18 03:18:10 DEBUG : pacer: Reducing sleep to 226.117916ms 2026/08/18 03:18:10 DEBUG : pacer: Reducing sleep to 94.742357ms 2026/08/18 03:18:11 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:18:11 DEBUG : pacer: Reducing sleep to 118.78912ms 2026/08/18 03:18:11 DEBUG : pacer: Reducing sleep to 236.931279ms 2026/08/18 03:18:11 DEBUG : pacer: Reducing sleep to 275.240516ms 2026/08/18 03:18:11 DEBUG : pacer: Reducing sleep to 212.668621ms 2026/08/18 03:18:11 DEBUG : pacer: Reducing sleep to 96.453824ms 2026/08/18 03:18:12 DEBUG : pacer: Reducing sleep to 50.235944ms 2026/08/18 03:18:12 DEBUG : pacer: Reducing sleep to 124.131945ms 2026/08/18 03:18:12 DEBUG : pacer: Reducing sleep to 241.77986ms 2026/08/18 03:18:12 DEBUG : pacer: Reducing sleep to 282.790118ms 2026/08/18 03:18:12 DEBUG : pacer: Reducing sleep to 199.241799ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy 2026/08/18 03:18:12 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:18:12 DEBUG : pacer: Reducing sleep to 76.067532ms 2026/08/18 03:18:13 DEBUG : pacer: Reducing sleep to 168.482596ms 2026/08/18 03:18:13 DEBUG : pacer: Reducing sleep to 257.141336ms 2026/08/18 03:18:15 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:18:15 DEBUG : pacer: Reducing sleep to 89.347059ms 2026/08/18 03:18:16 DEBUG : pacer: Reducing sleep to 68.141124ms 2026/08/18 03:18:20 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:18:20 DEBUG : pacer: Reducing sleep to 63.287465ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata fstests.go:1318: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2026/08/18 03:18:25 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:18:25 DEBUG : pacer: Reducing sleep to 75.924081ms 2026/08/18 03:18:25 DEBUG : pacer: Reducing sleep to 132.970261ms 2026/08/18 03:18:25 DEBUG : pacer: Reducing sleep to 213.786972ms 2026/08/18 03:18:25 DEBUG : pacer: Reducing sleep to 256.390179ms 2026/08/18 03:18:25 DEBUG : pacer: Reducing sleep to 205.749313ms 2026/08/18 03:18:26 DEBUG : pacer: Reducing sleep to 112.568324ms 2026/08/18 03:18:26 DEBUG : pacer: Reducing sleep to 76.889656ms 2026/08/18 03:18:29 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:18:39 DEBUG : pacer: Reducing sleep to 73.137097ms 2026/08/18 03:18:39 DEBUG : pacer: Reducing sleep to 155.079915ms 2026/08/18 03:18:39 DEBUG : pacer: Reducing sleep to 202.863082ms 2026/08/18 03:18:39 DEBUG : pacer: Reducing sleep to 249.289798ms 2026/08/18 03:18:44 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:18:44 DEBUG : pacer: Reducing sleep to 78.914036ms 2026/08/18 03:18:44 DEBUG : pacer: Reducing sleep to 240.415388ms 2026/08/18 03:18:44 DEBUG : pacer: Reducing sleep to 269.212861ms 2026/08/18 03:18:44 DEBUG : pacer: Reducing sleep to 191.862487ms 2026/08/18 03:18:44 DEBUG : pacer: Reducing sleep to 95.657626ms 2026/08/18 03:18:45 DEBUG : pacer: Reducing sleep to 60.406103ms 2026/08/18 03:18:45 DEBUG : pacer: Reducing sleep to 72.208711ms 2026/08/18 03:18:45 DEBUG : pacer: Reducing sleep to 114.142132ms 2026/08/18 03:18:45 DEBUG : pacer: Reducing sleep to 184.506454ms 2026/08/18 03:18:48 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:18:48 DEBUG : pacer: Reducing sleep to 95.137494ms 2026/08/18 03:18:48 DEBUG : pacer: Reducing sleep to 240.544192ms 2026/08/18 03:18:48 DEBUG : pacer: Reducing sleep to 316.0004ms 2026/08/18 03:18:49 DEBUG : pacer: Reducing sleep to 241.090813ms 2026/08/18 03:18:49 DEBUG : pacer: Reducing sleep to 96.765917ms 2026/08/18 03:18:53 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:18:53 DEBUG : pacer: Reducing sleep to 81.862114ms 2026/08/18 03:18:53 DEBUG : pacer: Reducing sleep to 140.650865ms 2026/08/18 03:18:53 DEBUG : pacer: Reducing sleep to 217.742601ms 2026/08/18 03:18:57 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:18:57 DEBUG : pacer: Reducing sleep to 94.842116ms 2026/08/18 03:18:57 DEBUG : pacer: Reducing sleep to 255.633798ms 2026/08/18 03:18:58 DEBUG : pacer: Reducing sleep to 271.734181ms 2026/08/18 03:18:58 DEBUG : pacer: Reducing sleep to 193.335908ms 2026/08/18 03:18:58 DEBUG : pacer: Reducing sleep to 86.949427ms 2026/08/18 03:18:58 DEBUG : pacer: Reducing sleep to 62.178036ms 2026/08/18 03:18:58 DEBUG : pacer: Reducing sleep to 133.383447ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1430: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2026/08/18 03:18:58 DEBUG : Creating backend with remote "TestZoho:rclone-test-fekunod9faxi" 2026/08/18 03:18:58 DEBUG : Config file has changed externally - reloading 2026/08/18 03:18:59 DEBUG : pacer: Reducing sleep to 12.038973ms 2026/08/18 03:18:59 DEBUG : pacer: Reducing sleep to 27.149969ms 2026/08/18 03:18:59 DEBUG : pacer: Reducing sleep to 28.673817ms 2026/08/18 03:18:59 DEBUG : pacer: Reducing sleep to 126.518253ms 2026/08/18 03:18:59 DEBUG : pacer: Reducing sleep to 198.125461ms 2026/08/18 03:18:59 DEBUG : pacer: Reducing sleep to 263.305673ms 2026/08/18 03:19:00 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:19:00 DEBUG : pacer: Reducing sleep to 60.01232ms 2026/08/18 03:19:00 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:19:00 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:19:00 DEBUG : pacer: Reducing sleep to 91.26456ms 2026/08/18 03:19:02 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:19:02 DEBUG : pacer: Reducing sleep to 91.240063ms 2026/08/18 03:19:02 DEBUG : pacer: Reducing sleep to 184.147877ms 2026/08/18 03:19:02 DEBUG : pacer: Reducing sleep to 254.908616ms 2026/08/18 03:19:02 DEBUG : pacer: Reducing sleep to 237.036093ms 2026/08/18 03:19:04 DEBUG : pacer: Reducing sleep to 10.456825ms 2026/08/18 03:19:04 DEBUG : pacer: Reducing sleep to 98.843341ms 2026/08/18 03:19:05 DEBUG : pacer: Reducing sleep to 190.102592ms 2026/08/18 03:19:05 DEBUG : pacer: Reducing sleep to 257.486975ms 2026/08/18 03:19:05 DEBUG : pacer: Reducing sleep to 232.197536ms 2026/08/18 03:19:05 DEBUG : pacer: Reducing sleep to 134.798689ms 2026/08/18 03:19:05 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:19:05 DEBUG : pacer: Reducing sleep to 98.096431ms 2026/08/18 03:19:05 DEBUG : zoho root 'rclone-test-fekunod9faxi': Purge remote 2026/08/18 03:19:05 DEBUG : pacer: Reducing sleep to 92.273324ms 2026/08/18 03:19:06 DEBUG : pacer: Reducing sleep to 148.693532ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull 2026/08/18 03:19:06 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString 2026/08/18 03:19:06 DEBUG : pacer: Reducing sleep to 88.768245ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs 2026/08/18 03:19:06 DEBUG : pacer: Reducing sleep to 176.804309ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote 2026/08/18 03:19:06 DEBUG : pacer: Reducing sleep to 250.63244ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes 2026/08/18 03:19:06 DEBUG : pacer: Reducing sleep to 242.093023ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime 2026/08/18 03:19:07 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/18 03:19:12 DEBUG : zoho root 'rclone-test-fudobok1rola': folder listing limiter sweep: evicted 6 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/18 03:19:35 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Tue, 18 Aug 2026 03:19:35 UTC": parsing time "Tue, 18 Aug 2026 03:19:35 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 18 Aug 2026 03:19:35 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek 2026/08/18 03:19:40 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Tue, 18 Aug 2026 03:19:40 UTC": parsing time "Tue, 18 Aug 2026 03:19:40 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 18 Aug 2026 03:19:40 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange 2026/08/18 03:19:44 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Tue, 18 Aug 2026 03:19:44 UTC": parsing time "Tue, 18 Aug 2026 03:19:44 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 18 Aug 2026 03:19:44 UTC" as " " 2026/08/18 03:19:45 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Tue, 18 Aug 2026 03:19:45 UTC": parsing time "Tue, 18 Aug 2026 03:19:45 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 18 Aug 2026 03:19:45 UTC" as " " 2026/08/18 03:19:45 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Tue, 18 Aug 2026 03:19:45 UTC": parsing time "Tue, 18 Aug 2026 03:19:45 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 18 Aug 2026 03:19:45 UTC" as " " 2026/08/18 03:19:45 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Tue, 18 Aug 2026 03:19:45 UTC": parsing time "Tue, 18 Aug 2026 03:19:45 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 18 Aug 2026 03:19:45 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead 2026/08/18 03:19:49 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Tue, 18 Aug 2026 03:19:49 UTC": parsing time "Tue, 18 Aug 2026 03:19:49 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 18 Aug 2026 03:19:49 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint 2026/08/18 03:19:54 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Tue, 18 Aug 2026 03:19:54 UTC": parsing time "Tue, 18 Aug 2026 03:19:54 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 18 Aug 2026 03:19:54 UTC" as " " 2026/08/18 03:19:58 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Tue, 18 Aug 2026 03:19:58 UTC": parsing time "Tue, 18 Aug 2026 03:19:58 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 18 Aug 2026 03:19:58 UTC" as " " 2026/08/18 03:19:58 DEBUG : pacer: Reducing sleep to 803.485µs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read 2026/08/18 03:19:58 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Tue, 18 Aug 2026 03:19:58 UTC": parsing time "Tue, 18 Aug 2026 03:19:58 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 18 Aug 2026 03:19:58 UTC" as " " 2026/08/18 03:19:58 DEBUG : pacer: Reducing sleep to 584.55µs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read 2026/08/18 03:19:58 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Tue, 18 Aug 2026 03:19:58 UTC": parsing time "Tue, 18 Aug 2026 03:19:58 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 18 Aug 2026 03:19:58 UTC" as " " 2026/08/18 03:19:58 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read 2026/08/18 03:19:59 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Tue, 18 Aug 2026 03:19:59 UTC": parsing time "Tue, 18 Aug 2026 03:19:59 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 18 Aug 2026 03:19:59 UTC" as " " 2026/08/18 03:19:59 DEBUG : pacer: Reducing sleep to 19.808635ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end 2026/08/18 03:19:59 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Tue, 18 Aug 2026 03:19:59 UTC": parsing time "Tue, 18 Aug 2026 03:19:59 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 18 Aug 2026 03:19:59 UTC" as " " 2026/08/18 03:19:59 DEBUG : pacer: Reducing sleep to 36.948871ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh 2026/08/18 03:20:03 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:20:03 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Tue, 18 Aug 2026 03:20:03 UTC": parsing time "Tue, 18 Aug 2026 03:20:03 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 18 Aug 2026 03:20:03 UTC" as " " === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/08/18 03:20:07 DEBUG : pacer: Reducing sleep to 31.534989ms 2026/08/18 03:20:07 DEBUG : pacer: Reducing sleep to 121.066427ms 2026/08/18 03:20:08 DEBUG : Couldn't parse Date: from server download.zoho.eu: "Tue, 18 Aug 2026 03:20:07 UTC": parsing time "Tue, 18 Aug 2026 03:20:07 UTC" as "Mon Jan _2 15:04:05 2006": cannot parse ", 18 Aug 2026 03:20:07 UTC" as " " 2026/08/18 03:20:08 DEBUG : pacer: Reducing sleep to 121.818336ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable 2026/08/18 03:20:08 DEBUG : pacer: Reducing sleep to 208.034841ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/08/18 03:20:08 DEBUG : Creating backend with remote "TestZoho:rclone-test-fudobok1rola/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/08/18 03:20:08 DEBUG : pacer: Reducing sleep to 123.737355ms 2026/08/18 03:20:08 DEBUG : pacer: Reducing sleep to 243.119425ms 2026/08/18 03:20:08 DEBUG : pacer: Reducing sleep to 289.686844ms 2026/08/18 03:20:09 DEBUG : pacer: Reducing sleep to 211.070264ms 2026/08/18 03:20:09 DEBUG : pacer: Reducing sleep to 86.490562ms 2026/08/18 03:20:09 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:20:09 DEBUG : pacer: Reducing sleep to 123.516967ms 2026/08/18 03:20:09 DEBUG : pacer: Reducing sleep to 247.191854ms 2026/08/18 03:20:09 DEBUG : pacer: Reducing sleep to 290.60266ms 2026/08/18 03:20:10 DEBUG : pacer: Reducing sleep to 197.733206ms 2026/08/18 03:20:10 DEBUG : pacer: Reducing sleep to 81.018698ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot 2026/08/18 03:20:10 DEBUG : pacer: Reducing sleep to 48.513601ms === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/08/18 03:20:10 DEBUG : Creating backend with remote "TestZoho:rclone-test-fudobok1rola/not found.txt" 2026/08/18 03:20:10 DEBUG : pacer: Reducing sleep to 119.029964ms 2026/08/18 03:20:10 DEBUG : pacer: Reducing sleep to 154.860417ms 2026/08/18 03:20:15 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:20:15 DEBUG : zoho root 'rclone-test-fudobok1rola/not found.txt': folder listing limiter sweep: evicted 3 of 9 idle limiters 2026/08/18 03:20:20 ERROR : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1987: Opening root remote "TestZoho:" path "rclone-test-fudobok1rola" from "TestZoho:rclone-test-fudobok1rola" 2026/08/18 03:20:20 DEBUG : Creating backend with remote "TestZoho:" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List 2026/08/18 03:20:24 DEBUG : pacer: Reducing sleep to 123.140968ms 2026/08/18 03:20:24 DEBUG : pacer: Reducing sleep to 245.546948ms 2026/08/18 03:20:24 DEBUG : pacer: Reducing sleep to 287.780502ms 2026/08/18 03:20:25 DEBUG : pacer: Reducing sleep to 207.132596ms === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries 2026/08/18 03:20:29 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/18 03:20:34 DEBUG : pacer: Reducing sleep to 32.20163ms 2026/08/18 03:20:38 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:20:43 DEBUG : pacer: Reducing sleep to 121.337644ms 2026/08/18 03:20:43 DEBUG : pacer: Reducing sleep to 242.602107ms 2026/08/18 03:20:43 DEBUG : pacer: Reducing sleep to 287.58293ms 2026/08/18 03:20:43 DEBUG : pacer: Reducing sleep to 207.404468ms === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove 2026/08/18 03:20:44 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:20:47 DEBUG : pacer: Reducing sleep to 123.603302ms 2026/08/18 03:20:47 DEBUG : pacer: Reducing sleep to 244.702854ms 2026/08/18 03:20:47 DEBUG : pacer: Reducing sleep to 287.805319ms 2026/08/18 03:20:48 DEBUG : pacer: Reducing sleep to 204.803137ms === 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/18 03:20:52 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:20:57 DEBUG : pacer: Reducing sleep to 120.766564ms 2026/08/18 03:20:57 DEBUG : pacer: Reducing sleep to 239.668537ms 2026/08/18 03:20:57 DEBUG : pacer: Reducing sleep to 285.145356ms 2026/08/18 03:20:57 DEBUG : pacer: Reducing sleep to 208.464069ms === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout 2026/08/18 03:20:57 DEBUG : pacer: Reducing sleep to 91.968615ms === 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/18 03:21:01 DEBUG : pacer: Reducing sleep to 0s 2026/08/18 03:21:01 DEBUG : pacer: Reducing sleep to 138.112593ms fstests.go:2596: Put returned an error (acceptable): upload error: HTTP error 400 (400 Bad Request) returned body: "\r\n