"go test -v -timeout 2h0m0s -remote TestIA:rclone-integration-test-2 -verbose -short" - Starting (try 1/5) === RUN TestIntegration fstests.go:464: Using remote "TestIA:rclone-integration-test-2" 2026/10/06 01:10:27 DEBUG : Creating backend with remote "TestIA:rclone-integration-test-2/rclone-test-mewuvem2gayu" 2026/10/06 01:10:27 DEBUG : Using config file from "/home/rclone/.rclone.conf" === RUN TestIntegration/FsCheckWrap fstests.go:505: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:533: No commands in this remote === RUN TestIntegration/FsRmdirNotFound fstests.go:548: Skipping test as non root bucket-based remote === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2026/10/06 01:10:28 INFO : dir/subdir: Making directory fstest.go:251: Filtering empty directory "dir" fstest.go:251: Filtering empty directory "dir/subdir" 2026/10/06 01:10:28 INFO : dir/subdir: Removing directory fstest.go:251: Filtering empty directory "dir" 2026/10/06 01:10:28 INFO : dir: Removing directory === RUN TestIntegration/FsMkdir/FsListEmpty === RUN TestIntegration/FsMkdir/FsListDirEmpty === RUN TestIntegration/FsMkdir/FsListRDirEmpty === RUN TestIntegration/FsMkdir/FsListDirNotFound === RUN TestIntegration/FsMkdir/FsListRDirNotFound === RUN TestIntegration/FsMkdir/FsEncoding fstests.go:692: not running with -short === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError 2026/10/06 01:10:30 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Setting IA item derive: false === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/10/06 01:10:31 DEBUG : zero-length-file: Setting IA item derive: false === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:813: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:846: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:899: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2026/10/06 01:14:15 DEBUG : file name.txt: Setting IA item derive: false 2026/10/06 01:16:12 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Setting IA item derive: false 2026/10/06 01:19:20 DEBUG : file name.txt: Setting IA item derive: false === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2026/10/06 01:23:08 DEBUG : Creating backend with remote "TestIA:rclone-integration-test-2" 2026/10/06 01:23:08 DEBUG : Config file has changed externally - reloading === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot 2026/10/06 01:23:08 DEBUG : Creating backend with remote "TestIA:rclone-integration-test-2" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1152: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge fstests.go:1184: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot fstests.go:1221: FS has no Purge interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2026/10/06 01:23:12 DEBUG : Creating backend with remote "TestIA:rclone-integration-test-2/rclone-test-mewuvem2gayu/hello? sausage/êé" 2026/10/06 01:23:13 DEBUG : a/b/c/d/e.txt: Setting IA item derive: false 2026/10/06 01:26:12 DEBUG : Waiting for deletions to finish 2026/10/06 01:32:26 INFO : a/b/c/d/e.txt: Deleted 2026/10/06 01:32:26 DEBUG : removing 1 level 1 directories 2026/10/06 01:32:26 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata 2026/10/06 01:37:27 DEBUG : test metadata copy.txt: Setting IA item derive: false fstest.go:128: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:128 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:133 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:152 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:196 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:309 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:339 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:345 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1358 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata Messages: test metadata copied.txt: Modification time difference too big |9456h0m0s| > 1ns (want 2004-03-03 04:05:06.499999999 +0000 UTC vs got 2003-02-03 04:05:06.499999999 +0000 UTC) (precision 1ns) fstest.go:128: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:128 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:613 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1361 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata Messages: test metadata copied.txt: Modification time difference too big |9456h0m0s| > 1ns (want 2004-03-03 04:05:06.499999999 +0000 UTC vs got 2003-02-03 04:05:06.499999999 +0000 UTC) (precision 1ns) fstest.go:618: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:618 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1361 Error: Not equal: expected: "royal" actual : "jersey" Diff: --- Expected +++ Actual @@ -1 +1 @@ -royal +jersey Test: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata fstest.go:618: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:618 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1364 Error: Not equal: expected: "royal" actual : "jersey" Diff: --- Expected +++ Actual @@ -1 +1 @@ -royal +jersey Test: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata fstest.go:128: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:128 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:613 /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1364 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata Messages: test metadata copied.txt: Modification time difference too big |9456h0m0s| > 1ns (want 2004-03-03 04:05:06.499999999 +0000 UTC vs got 2003-02-03 04:05:06.499999999 +0000 UTC) (precision 1ns) === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove fstests.go:1380: FS has no Mover interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove fstests.go:1500: FS has no DirMover interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull fstests.go:1555: Skipping test as non root bucket-based remote === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType fstests.go:1633: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata/mtime 2026/10/06 01:47:48 DEBUG : metadatatest: Setting IA item derive: false === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1735: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate 2026/10/06 02:00:37 DEBUG : file name.txt: Setting IA item derive: false === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/10/06 02:05:12 DEBUG : Creating backend with remote "TestIA:rclone-integration-test-2/rclone-test-mewuvem2gayu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/10/06 02:05:12 DEBUG : Config file has changed externally - reloading === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/10/06 02:05:13 DEBUG : Creating backend with remote "TestIA:rclone-integration-test-2/rclone-test-mewuvem2gayu/not found.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1983: Can't list from root on this remote === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:2138: skipping directory tests as not supported on this backend === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:438: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2195: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2217: Can't have // in paths === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove 2026/10/06 02:05:19 DEBUG : pacer: low level retry 1/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit471b8225-0296-4bdd-9b98-fa18d682b5bb") 2026/10/06 02:05:19 DEBUG : pacer: Rate limited, increasing sleep to 10ms 2026/10/06 02:05:22 DEBUG : pacer: low level retry 2/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit947ddf13-d1e8-41b1-8c2b-eda45c83ebfe") 2026/10/06 02:05:22 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/06 02:05:25 DEBUG : pacer: low level retry 3/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit62069ff9-ec66-4eb5-9470-b28a79a92a2e") 2026/10/06 02:05:25 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2026/10/06 02:05:28 DEBUG : pacer: low level retry 4/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit103f67c1-cf90-462b-bf1b-6d7b6b8ab468") 2026/10/06 02:05:28 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2026/10/06 02:05:31 DEBUG : pacer: low level retry 5/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit9e120a0f-0680-4768-9de0-0c2b8fad7514") 2026/10/06 02:05:31 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2026/10/06 02:05:34 DEBUG : pacer: low level retry 6/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit30481cd2-2c24-4f85-8abf-b8d008510311") 2026/10/06 02:05:34 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2026/10/06 02:05:38 DEBUG : pacer: low level retry 7/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit12f4741a-9f93-474c-afbd-6bca6071723e") 2026/10/06 02:05:38 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2026/10/06 02:05:41 DEBUG : pacer: low level retry 8/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit67e5c106-c100-48ff-a679-f55d2bb9e58f") 2026/10/06 02:05:41 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2026/10/06 02:05:42 DEBUG : pacer: Reducing sleep to 960ms 2026/10/06 02:05:42 DEBUG : pacer: Reducing sleep to 720ms 2026/10/06 02:05:53 DEBUG : pacer: Reducing sleep to 540ms 2026/10/06 02:06:03 DEBUG : pacer: Reducing sleep to 405ms 2026/10/06 02:06:13 DEBUG : pacer: Reducing sleep to 303.75ms 2026/10/06 02:06:24 DEBUG : pacer: Reducing sleep to 227.8125ms 2026/10/06 02:06:34 DEBUG : pacer: Reducing sleep to 170.859375ms 2026/10/06 02:06:44 DEBUG : pacer: Reducing sleep to 128.144531ms 2026/10/06 02:06:54 DEBUG : pacer: Reducing sleep to 96.108398ms 2026/10/06 02:07:05 DEBUG : pacer: Reducing sleep to 72.081298ms 2026/10/06 02:07:15 DEBUG : pacer: Reducing sleep to 54.060973ms 2026/10/06 02:07:25 DEBUG : pacer: Reducing sleep to 40.545729ms 2026/10/06 02:07:35 DEBUG : pacer: Reducing sleep to 30.409296ms 2026/10/06 02:07:46 DEBUG : pacer: Reducing sleep to 22.806972ms 2026/10/06 02:07:56 DEBUG : pacer: Reducing sleep to 17.105229ms 2026/10/06 02:08:06 DEBUG : pacer: Reducing sleep to 12.828921ms 2026/10/06 02:08:16 DEBUG : pacer: Reducing sleep to 0s === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream fstests.go:2385: FS has no PutStream interface === RUN TestIntegration/FsMkdir/FsPutFiles/Internal fstests.go:2431: *internetarchive.Fs does not implement InternalTester === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2443: not running with -short === RUN TestIntegration/FsMkdir/FsPutRetry === RUN TestIntegration/FsMkdir/FsPutRetry/Simple === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 2026/10/06 02:12:04 DEBUG : retry-Status500.bin: Setting IA item derive: false 2026/10/06 02:12:04 DEBUG : pacer: low level retry 1/10 (error HTTP error 500 (500 Internal Server Error) returned body: "") 2026/10/06 02:12:04 DEBUG : pacer: Rate limited, increasing sleep to 10ms 2026/10/06 02:12:04 DEBUG : pacer: low level retry 2/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/10/06 02:12:04 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/10/06 02:12:05 DEBUG : pacer: low level retry 3/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/10/06 02:12:05 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2026/10/06 02:12:05 DEBUG : pacer: low level retry 4/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/10/06 02:12:05 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2026/10/06 02:12:05 DEBUG : pacer: low level retry 5/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/10/06 02:12:05 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2026/10/06 02:12:06 DEBUG : pacer: low level retry 6/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/10/06 02:12:06 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2026/10/06 02:12:06 DEBUG : pacer: low level retry 7/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/10/06 02:12:06 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2026/10/06 02:12:06 DEBUG : pacer: low level retry 8/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/10/06 02:12:06 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2026/10/06 02:12:07 DEBUG : pacer: low level retry 9/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/10/06 02:12:07 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/10/06 02:12:08 DEBUG : pacer: low level retry 10/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) fstests.go:2660: Put returned an error after the injected failure (acceptable): Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0 2026/10/06 02:12:10 DEBUG : pacer: Reducing sleep to 1.5s 2026/10/06 02:12:12 DEBUG : pacer: Reducing sleep to 1.125s === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/NetError 2026/10/06 02:12:12 DEBUG : retry-NetError.bin: Setting IA item derive: false 2026/10/06 02:12:13 DEBUG : pacer: low level retry 1/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fretry-NetError.bin": write tcp: unexpected EOF) 2026/10/06 02:12:13 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/10/06 02:12:15 DEBUG : pacer: low level retry 2/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/10/06 02:12:17 DEBUG : pacer: low level retry 3/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/10/06 02:12:19 DEBUG : pacer: low level retry 4/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/10/06 02:12:21 DEBUG : pacer: low level retry 5/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/10/06 02:12:23 DEBUG : pacer: low level retry 6/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/10/06 02:12:25 DEBUG : pacer: low level retry 7/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/10/06 02:12:27 DEBUG : pacer: low level retry 8/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/10/06 02:12:29 DEBUG : pacer: low level retry 9/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/10/06 02:12:31 DEBUG : pacer: low level retry 10/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) fstests.go:2660: Put returned an error after the injected failure (acceptable): Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0 2026/10/06 02:12:33 DEBUG : pacer: Reducing sleep to 1.5s 2026/10/06 02:12:35 DEBUG : pacer: Reducing sleep to 1.125s === RUN TestIntegration/FsMkdir/FsPutRetry/Chunked fstests.go:2690: not running with -short === RUN TestIntegration/FsMkdir/FsPutShortEOF === RUN TestIntegration/FsMkdir/FsPutShortEOF/Simple 2026/10/06 02:12:35 DEBUG : short-eof.bin: Setting IA item derive: false 2026/10/06 02:12:36 DEBUG : pacer: low level retry 1/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 5120) 2026/10/06 02:12:36 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/10/06 02:12:37 DEBUG : pacer: low level retry 2/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/10/06 02:12:39 DEBUG : pacer: low level retry 3/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/10/06 02:12:41 DEBUG : pacer: low level retry 4/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/10/06 02:12:43 DEBUG : pacer: low level retry 5/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/10/06 02:12:45 DEBUG : pacer: low level retry 6/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/10/06 02:12:47 DEBUG : pacer: low level retry 7/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/10/06 02:12:49 DEBUG : pacer: low level retry 8/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/10/06 02:12:51 DEBUG : pacer: low level retry 9/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/10/06 02:12:53 DEBUG : pacer: low level retry 10/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) fstests.go:2784: Put returned an error (acceptable): Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0 2026/10/06 02:12:55 DEBUG : pacer: Reducing sleep to 1.5s === RUN TestIntegration/FsMkdir/FsPutShortEOF/Chunked fstests.go:2821: not running with -short === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2864: not running with -short === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2026/10/06 02:12:55 DEBUG : unknown-size-put.txt: Setting IA item derive: false 2026/10/06 02:12:58 DEBUG : pacer: Reducing sleep to 1.125s === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/10/06 02:12:58 DEBUG : unknown-size-update.txt: Setting IA item derive: false 2026/10/06 02:13:03 DEBUG : pacer: low level retry 1/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limite961f72e-b265-4ba8-81ae-9c14e0930b5d") 2026/10/06 02:13:03 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/10/06 02:13:03 DEBUG : pacer: low level retry 2/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:13:05 DEBUG : pacer: low level retry 3/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:13:07 DEBUG : pacer: low level retry 4/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:13:09 DEBUG : pacer: low level retry 5/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:13:11 DEBUG : pacer: low level retry 6/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:13:13 DEBUG : pacer: low level retry 7/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:13:15 DEBUG : pacer: low level retry 8/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:13:17 DEBUG : pacer: low level retry 9/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:13:19 DEBUG : pacer: low level retry 10/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) fstests.go:148: Put error: Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0 - low level retry 1/10 2026/10/06 02:13:21 DEBUG : unknown-size-update.txt: Setting IA item derive: false 2026/10/06 02:13:24 DEBUG : pacer: low level retry 1/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limited936abb-2492-49e7-a7f9-e5aac308b8ef") 2026/10/06 02:13:24 DEBUG : pacer: low level retry 2/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:13:26 DEBUG : pacer: low level retry 3/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:13:28 DEBUG : pacer: low level retry 4/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:13:30 DEBUG : pacer: low level retry 5/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:13:32 DEBUG : pacer: low level retry 6/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:13:34 DEBUG : pacer: low level retry 7/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:13:36 DEBUG : pacer: low level retry 8/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:13:38 DEBUG : pacer: low level retry 9/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:13:40 DEBUG : pacer: low level retry 10/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) fstests.go:148: Put error: Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0 - low level retry 2/10 2026/10/06 02:13:42 DEBUG : unknown-size-update.txt: Setting IA item derive: false 2026/10/06 02:13:45 DEBUG : pacer: low level retry 1/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit5009a01b-45bd-4d29-806b-100c10eb7ea5") 2026/10/06 02:13:46 DEBUG : pacer: low level retry 2/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:13:48 DEBUG : pacer: low level retry 3/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:13:50 DEBUG : pacer: low level retry 4/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:13:52 DEBUG : pacer: low level retry 5/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:13:54 DEBUG : pacer: low level retry 6/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:13:56 DEBUG : pacer: low level retry 7/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:13:58 DEBUG : pacer: low level retry 8/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:14:00 DEBUG : pacer: low level retry 9/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) 2026/10/06 02:14:02 DEBUG : pacer: low level retry 10/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0) fstests.go:148: Put error: Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-mewuvem2gayu%2Funknown-size-update.txt": net/http: HTTP/1.x transport connection broken: http: ContentLength=100 with Body length 0 - low level retry 3/10 2026/10/06 02:14:04 DEBUG : unknown-size-update.txt: Setting IA item derive: false 2026/10/06 02:14:06 DEBUG : pacer: Reducing sleep to 1.5s 2026/10/06 02:14:07 DEBUG : pacer: Reducing sleep to 1.125s 2026/10/06 02:14:17 DEBUG : pacer: Reducing sleep to 843.75ms 2026/10/06 02:14:27 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/10/06 02:14:37 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/10/06 02:14:48 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/10/06 02:14:58 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/10/06 02:15:08 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/10/06 02:15:18 DEBUG : pacer: Reducing sleep to 150.169371ms 2026/10/06 02:15:29 DEBUG : pacer: Reducing sleep to 112.627028ms 2026/10/06 02:15:29 DEBUG : pacer: Reducing sleep to 84.470271ms 2026/10/06 02:15:29 DEBUG : pacer: Reducing sleep to 63.352703ms 2026/10/06 02:15:29 DEBUG : unknown-size-update.txt: Setting IA item derive: false 2026/10/06 02:15:30 DEBUG : pacer: Reducing sleep to 47.514527ms === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/10/06 02:15:30 DEBUG : Creating backend with remote "TestIA:rclone-integration-test-2/rclone-test-mewuvem2gayu/deeper/nonexisting/directory" 2026/10/06 02:15:30 DEBUG : Config file has changed externally - reloading === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:3019: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:3062: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:3111: Can't test if can't have empty directories 2026/10/06 02:15:30 DEBUG : Waiting for deletions to finish 2026/10/06 02:15:31 DEBUG : pacer: Reducing sleep to 35.635895ms 2026/10/06 02:15:34 DEBUG : pacer: low level retry 1/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit8000a725-3071-4117-9b4c-70c0f07dda93") 2026/10/06 02:15:34 DEBUG : pacer: Rate limited, increasing sleep to 71.27179ms 2026/10/06 02:15:34 DEBUG : pacer: low level retry 1/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit07ed2b0a-ca4a-42f4-839f-c3b72f0b80d0") 2026/10/06 02:15:34 DEBUG : pacer: Rate limited, increasing sleep to 142.54358ms 2026/10/06 02:15:38 DEBUG : pacer: low level retry 2/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit84ee9dcb-7be5-49db-b7d0-a2a7543053fa") 2026/10/06 02:15:38 DEBUG : pacer: Rate limited, increasing sleep to 285.08716ms 2026/10/06 02:15:38 DEBUG : pacer: low level retry 2/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limitcec47f5f-e826-4ce0-ab29-091410491552") 2026/10/06 02:15:38 DEBUG : pacer: Rate limited, increasing sleep to 570.17432ms 2026/10/06 02:15:41 DEBUG : pacer: low level retry 3/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit2126f931-25a2-4595-aa6a-b0481b7972c1") 2026/10/06 02:15:41 DEBUG : pacer: Rate limited, increasing sleep to 1.14034864s 2026/10/06 02:15:41 DEBUG : pacer: low level retry 3/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit0c6f76dc-4cb1-4a02-8d0f-2f6c6fbad865") 2026/10/06 02:15:41 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/10/06 02:15:44 DEBUG : pacer: low level retry 4/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit62e822b3-7507-4336-9913-fa145f7c2bec") 2026/10/06 02:15:45 DEBUG : pacer: low level retry 4/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limitadc4d26b-b161-4b20-a7e5-3d5f9f0d5c58") 2026/10/06 02:15:47 DEBUG : pacer: low level retry 5/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limitb67c45bc-7bef-4aa8-ab40-b9da96e5f808") 2026/10/06 02:15:49 DEBUG : pacer: low level retry 5/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit201458be-4281-4fd9-b91a-27e00a1b7f3b") 2026/10/06 02:15:54 DEBUG : pacer: low level retry 6/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit8aec8f57-b9f4-4c2e-9bb0-9e17fec93635") 2026/10/06 02:15:54 DEBUG : pacer: low level retry 6/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit91e93703-b78b-4810-9e08-0a15e05dbba1") 2026/10/06 02:15:58 DEBUG : pacer: low level retry 7/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limitc1bc5a9b-8daf-4fc1-a0f3-a84b7a9125cb") 2026/10/06 02:15:59 DEBUG : pacer: low level retry 7/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limitc9ea598f-5c8b-4fee-876b-f7e82cbdbeae") 2026/10/06 02:16:01 DEBUG : pacer: low level retry 8/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit0c0282eb-234b-43fe-b479-b904a87d9bd2") 2026/10/06 02:16:03 DEBUG : pacer: low level retry 8/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit4a51ac7c-7620-4739-9b2b-b67c50f3ec1b") 2026/10/06 02:16:05 DEBUG : pacer: low level retry 9/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit7036afa6-c41e-4650-b76a-5791bb03cf9c") 2026/10/06 02:16:07 DEBUG : pacer: low level retry 9/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit6d688f3e-e632-4895-96e9-f0505ced3427") 2026/10/06 02:16:09 DEBUG : pacer: low level retry 10/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limitfb26f4aa-3771-46ba-a3d1-8b864b6617eb") 2026/10/06 02:16:09 ERROR : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Couldn't delete: HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limitfb26f4aa-3771-46ba-a3d1-8b864b6617eb" 2026/10/06 02:16:11 DEBUG : pacer: low level retry 10/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit619021d1-25a6-46cc-b710-9a7939920fd5") 2026/10/06 02:16:11 ERROR : unknown-size-update.txt: Couldn't delete: HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit619021d1-25a6-46cc-b710-9a7939920fd5" === NAME TestIntegration/FsMkdir fstests.go:3201: Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:3201 Error: Received unexpected error: failed to delete 2 files Test: TestIntegration/FsMkdir 2026/10/06 02:16:11 DEBUG : Waiting for deletions to finish 2026/10/06 02:16:11 DEBUG : pacer: Reducing sleep to 1.5s 2026/10/06 02:16:16 DEBUG : pacer: low level retry 1/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limitb3b44ac3-62c8-493e-b30c-99a8e476d802") 2026/10/06 02:16:16 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/10/06 02:16:18 DEBUG : pacer: low level retry 1/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit0c715e53-c84e-4808-96fc-b5f368bfde1f") 2026/10/06 02:16:19 DEBUG : pacer: low level retry 2/10 (error HTTP error 503 (503 Slow Down) returned body: "\nSlowDownPlease reduce your request rate.total_tasks_queued exceeds global_limit8620fe38-2a77-4229-b52d-0cc4d8fb3d53") 2026/10/06 02:16:21 DEBUG : pacer: Reducing sleep to 1.5s 2026/10/06 02:16:22 DEBUG : pacer: Reducing sleep to 1.125s 2026/10/06 02:16:22 DEBUG : pacer: Reducing sleep to 843.75ms 2026/10/06 02:16:23 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/10/06 02:16:33 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/10/06 02:16:34 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/10/06 02:16:43 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/10/06 02:16:44 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/10/06 02:16:53 DEBUG : pacer: Reducing sleep to 150.169371ms 2026/10/06 02:16:54 DEBUG : pacer: Reducing sleep to 112.627028ms 2026/10/06 02:17:03 DEBUG : pacer: Reducing sleep to 84.470271ms 2026/10/06 02:17:04 DEBUG : pacer: Reducing sleep to 63.352703ms 2026/10/06 02:17:14 DEBUG : pacer: Reducing sleep to 47.514527ms 2026/10/06 02:17:15 DEBUG : pacer: Reducing sleep to 35.635895ms 2026/10/06 02:17:24 DEBUG : pacer: Reducing sleep to 26.726921ms 2026/10/06 02:17:25 DEBUG : pacer: Reducing sleep to 20.04519ms 2026/10/06 02:17:34 DEBUG : pacer: Reducing sleep to 15.033892ms 2026/10/06 02:17:35 DEBUG : pacer: Reducing sleep to 11.275419ms 2026/10/06 02:17:44 DEBUG : pacer: Reducing sleep to 0s 2026/10/06 02:21:40 INFO : unknown-size-update.txt: Deleted 2026/10/06 02:23:13 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/10/06 02:23:13 DEBUG : removing 1 level 0 directories 2026/10/06 02:23:13 INFO : Internet Archive item rclone-integration-test-2 path rclone-test-mewuvem2gayu: Removing directory === RUN TestIntegration/FsShutdown fstests.go:3225: Shutdown method not supported --- FAIL: TestIntegration (4366.54s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- SKIP: TestIntegration/FsRmdirNotFound (0.00s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.00s) --- FAIL: TestIntegration/FsMkdir (3943.16s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.60s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.19s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.20s) --- PASS: TestIntegration/FsMkdir/FsListRDirEmpty (0.20s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.19s) --- PASS: TestIntegration/FsMkdir/FsListRDirNotFound (0.21s) --- SKIP: TestIntegration/FsMkdir/FsEncoding (0.00s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.40s) --- PASS: TestIntegration/FsMkdir/FsPutError (0.76s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (224.41s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles (3468.61s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (1.60s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.22s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.22s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.78s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.49s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.50s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.46s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.24s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.21s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.23s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.23s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (554.09s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsCopy (920.32s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (618.95s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.31s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.23s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.22s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.25s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (759.42s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata/mtime (759.21s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.28s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (1.12s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.23s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (1.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.66s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (1.80s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.63s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint (4.10s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read (0.39s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read (0.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read (0.39s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end (0.48s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh (0.62s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (274.66s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.85s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (1.48s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (408.41s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.24s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutRetry (30.85s) --- PASS: TestIntegration/FsMkdir/FsPutRetry/Simple (30.85s) --- PASS: TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 (8.24s) --- PASS: TestIntegration/FsMkdir/FsPutRetry/Simple/NetError (22.62s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Chunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF (20.63s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF/Simple (20.63s) --- SKIP: TestIntegration/FsMkdir/FsPutShortEOF/Chunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (154.23s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (2.28s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (151.95s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.90s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- SKIP: TestIntegration/FsShutdown (0.00s) FAIL exit status 1 FAIL github.com/rclone/rclone/backend/internetarchive 4366.565s "go test -v -timeout 2h0m0s -remote TestIA:rclone-integration-test-2 -verbose -short" - Finished OK in 1h12m48.367491035s (try 1/5)