"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/09/02 03:27:22 DEBUG : Creating backend with remote "TestIA:rclone-integration-test-2/rclone-test-tesazaf4guca" 2026/09/02 03:27:22 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/09/02 03:27:23 INFO : dir/subdir: Making directory fstest.go:251: Filtering empty directory "dir" fstest.go:251: Filtering empty directory "dir/subdir" 2026/09/02 03:27:23 INFO : dir/subdir: Removing directory fstest.go:251: Filtering empty directory "dir" 2026/09/02 03:27:24 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/09/02 03:27:25 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Setting IA item derive: false === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/09/02 03:27:26 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/09/02 03:29:55 DEBUG : file name.txt: Setting IA item derive: false 2026/09/02 03:31:01 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Setting IA item derive: false 2026/09/02 03:33:41 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/09/02 03:36:11 DEBUG : Creating backend with remote "TestIA:rclone-integration-test-2" 2026/09/02 03:36:11 DEBUG : Config file has changed externally - reloading === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot 2026/09/02 03:36:13 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/09/02 03:36:26 DEBUG : Creating backend with remote "TestIA:rclone-integration-test-2/rclone-test-tesazaf4guca/hello? sausage/êé" 2026/09/02 03:36:27 DEBUG : a/b/c/d/e.txt: Setting IA item derive: false 2026/09/02 03:38:25 DEBUG : Waiting for deletions to finish 2026/09/02 03:44:05 INFO : a/b/c/d/e.txt: Deleted 2026/09/02 03:44:05 DEBUG : removing 1 level 1 directories 2026/09/02 03:44:05 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata 2026/09/02 03:46:17 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: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: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: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/09/02 03:50:58 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/09/02 03:57:54 DEBUG : file name.txt: Setting IA item derive: false === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/09/02 03:59:22 DEBUG : Creating backend with remote "TestIA:rclone-integration-test-2/rclone-test-tesazaf4guca/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/09/02 03:59:22 DEBUG : Config file has changed externally - reloading === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/09/02 03:59:23 DEBUG : Creating backend with remote "TestIA:rclone-integration-test-2/rclone-test-tesazaf4guca/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 === 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/09/02 04:05:09 DEBUG : retry-Status500.bin: Setting IA item derive: false 2026/09/02 04:05:09 DEBUG : pacer: low level retry 1/10 (error HTTP error 500 (500 Internal Server Error) returned body: "") 2026/09/02 04:05:09 DEBUG : pacer: Rate limited, increasing sleep to 10ms 2026/09/02 04:05:09 DEBUG : pacer: low level retry 2/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/02 04:05:09 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/09/02 04:05:10 DEBUG : pacer: low level retry 3/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/02 04:05:10 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2026/09/02 04:05:10 DEBUG : pacer: low level retry 4/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/02 04:05:10 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2026/09/02 04:05:10 DEBUG : pacer: low level retry 5/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/02 04:05:10 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2026/09/02 04:05:11 DEBUG : pacer: low level retry 6/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/02 04:05:11 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2026/09/02 04:05:11 DEBUG : pacer: low level retry 7/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/02 04:05:11 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2026/09/02 04:05:11 DEBUG : pacer: low level retry 8/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/02 04:05:11 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2026/09/02 04:05:12 DEBUG : pacer: low level retry 9/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/02 04:05:12 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/02 04:05:13 DEBUG : pacer: low level retry 10/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%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-tesazaf4guca%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0 2026/09/02 04:05:15 DEBUG : pacer: Reducing sleep to 1.5s 2026/09/02 04:05:17 DEBUG : pacer: Reducing sleep to 1.125s === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/NetError 2026/09/02 04:05:17 DEBUG : retry-NetError.bin: Setting IA item derive: false 2026/09/02 04:05:18 DEBUG : pacer: low level retry 1/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fretry-NetError.bin": write tcp: unexpected EOF) 2026/09/02 04:05:18 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/02 04:05:20 DEBUG : pacer: low level retry 2/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/02 04:05:22 DEBUG : pacer: low level retry 3/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/02 04:05:24 DEBUG : pacer: low level retry 4/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/02 04:05:26 DEBUG : pacer: low level retry 5/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/02 04:05:28 DEBUG : pacer: low level retry 6/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/02 04:05:30 DEBUG : pacer: low level retry 7/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/02 04:05:32 DEBUG : pacer: low level retry 8/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/02 04:05:34 DEBUG : pacer: low level retry 9/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/02 04:05:36 DEBUG : pacer: low level retry 10/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%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-tesazaf4guca%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0 2026/09/02 04:05:38 DEBUG : pacer: Reducing sleep to 1.5s 2026/09/02 04:05:40 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/09/02 04:05:40 DEBUG : short-eof.bin: Setting IA item derive: false 2026/09/02 04:05:41 DEBUG : pacer: low level retry 1/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 5120) 2026/09/02 04:05:41 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/02 04:05:43 DEBUG : pacer: low level retry 2/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/09/02 04:05:45 DEBUG : pacer: low level retry 3/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/09/02 04:05:47 DEBUG : pacer: low level retry 4/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/09/02 04:05:49 DEBUG : pacer: low level retry 5/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/09/02 04:05:51 DEBUG : pacer: low level retry 6/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/09/02 04:05:53 DEBUG : pacer: low level retry 7/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/09/02 04:05:55 DEBUG : pacer: low level retry 8/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/09/02 04:05:57 DEBUG : pacer: low level retry 9/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/09/02 04:05:59 DEBUG : pacer: low level retry 10/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-tesazaf4guca%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-tesazaf4guca%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0 2026/09/02 04:06:00 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/09/02 04:06:00 DEBUG : unknown-size-put.txt: Setting IA item derive: false 2026/09/02 04:06:03 DEBUG : pacer: Reducing sleep to 1.125s === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/09/02 04:06:03 DEBUG : unknown-size-update.txt: Setting IA item derive: false 2026/09/02 04:06:06 DEBUG : pacer: Reducing sleep to 843.75ms 2026/09/02 04:06:06 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/09/02 04:06:16 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/09/02 04:06:27 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/09/02 04:06:37 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/09/02 04:06:47 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/09/02 04:06:57 DEBUG : pacer: Reducing sleep to 150.169371ms 2026/09/02 04:07:08 DEBUG : pacer: Reducing sleep to 112.627028ms 2026/09/02 04:07:18 DEBUG : pacer: Reducing sleep to 84.470271ms 2026/09/02 04:07:28 DEBUG : pacer: Reducing sleep to 63.352703ms 2026/09/02 04:07:28 DEBUG : pacer: Reducing sleep to 47.514527ms 2026/09/02 04:07:29 DEBUG : pacer: Reducing sleep to 35.635895ms 2026/09/02 04:07:29 DEBUG : unknown-size-update.txt: Setting IA item derive: false 2026/09/02 04:07:29 DEBUG : pacer: Reducing sleep to 26.726921ms === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/09/02 04:07:29 DEBUG : Creating backend with remote "TestIA:rclone-integration-test-2/rclone-test-tesazaf4guca/deeper/nonexisting/directory" 2026/09/02 04:07:29 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/09/02 04:07:31 DEBUG : Waiting for deletions to finish 2026/09/02 04:07:32 DEBUG : pacer: Reducing sleep to 20.04519ms 2026/09/02 04:07:33 DEBUG : pacer: Reducing sleep to 15.033892ms 2026/09/02 04:07:34 DEBUG : pacer: Reducing sleep to 11.275419ms 2026/09/02 04:07:34 DEBUG : pacer: Reducing sleep to 0s 2026/09/02 04:13:14 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/09/02 04:13:34 INFO : unknown-size-update.txt: Deleted 2026/09/02 04:13:34 DEBUG : removing 1 level 0 directories 2026/09/02 04:13:34 INFO : Internet Archive item rclone-integration-test-2 path rclone-test-tesazaf4guca: Removing directory === RUN TestIntegration/FsShutdown fstests.go:3225: Shutdown method not supported --- FAIL: TestIntegration (2772.74s) --- 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 (2771.66s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.67s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.20s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.21s) --- PASS: TestIntegration/FsMkdir/FsListRDirEmpty (0.19s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.21s) --- PASS: TestIntegration/FsMkdir/FsListRDirNotFound (0.19s) --- SKIP: TestIntegration/FsMkdir/FsEncoding (0.00s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.41s) --- PASS: TestIntegration/FsMkdir/FsPutError (0.54s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (149.49s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles (2113.43s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.67s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (1.23s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.22s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (1.34s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (2.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (1.96s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (1.99s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (3.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.23s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (1.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.99s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.98s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (459.54s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsCopy (411.90s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (280.01s) --- 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.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.23s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.23s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.22s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (406.08s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata/mtime (405.88s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.25s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (1.33s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.23s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.99s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.66s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (1.71s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.60s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint (3.49s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read (0.58s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh (0.62s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (87.66s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.44s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.78s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.77s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (1.14s) --- 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 (344.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.23s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutRetry (31.12s) --- PASS: TestIntegration/FsMkdir/FsPutRetry/Simple (31.12s) --- PASS: TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 (8.48s) --- PASS: TestIntegration/FsMkdir/FsPutRetry/Simple/NetError (22.64s) --- SKIP: TestIntegration/FsMkdir/FsPutRetry/Chunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF (20.62s) --- PASS: TestIntegration/FsMkdir/FsPutShortEOF/Simple (20.62s) --- SKIP: TestIntegration/FsMkdir/FsPutShortEOF/Chunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (88.84s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (2.30s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (86.54s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (1.61s) --- 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 2772.753s "go test -v -timeout 2h0m0s -remote TestIA:rclone-integration-test-2 -verbose -short" - Finished OK in 46m13.954180421s (try 1/5)