"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/05 02:49:27 DEBUG : Creating backend with remote "TestIA:rclone-integration-test-2/rclone-test-nuhovec5jaxo" 2026/09/05 02:49: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/09/05 02:49:28 INFO : dir/subdir: Making directory fstest.go:251: Filtering empty directory "dir" fstest.go:251: Filtering empty directory "dir/subdir" 2026/09/05 02:49:28 INFO : dir/subdir: Removing directory fstest.go:251: Filtering empty directory "dir" 2026/09/05 02:49: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/09/05 02:49:30 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Setting IA item derive: false === RUN TestIntegration/FsMkdir/FsPutZeroLength 2026/09/05 02:49: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/09/05 02:51:20 DEBUG : file name.txt: Setting IA item derive: false 2026/09/05 02:52:25 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Setting IA item derive: false 2026/09/05 02:55:15 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/05 02:57:23 DEBUG : Creating backend with remote "TestIA:rclone-integration-test-2" 2026/09/05 02:57:23 DEBUG : Config file has changed externally - reloading === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot 2026/09/05 02:57:25 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/05 02:57:38 DEBUG : Creating backend with remote "TestIA:rclone-integration-test-2/rclone-test-nuhovec5jaxo/hello? sausage/êé" 2026/09/05 02:57:38 DEBUG : Config file has changed externally - reloading 2026/09/05 02:57:39 DEBUG : a/b/c/d/e.txt: Setting IA item derive: false 2026/09/05 02:59:37 DEBUG : Waiting for deletions to finish 2026/09/05 03:05:27 INFO : a/b/c/d/e.txt: Deleted 2026/09/05 03:05:28 DEBUG : removing 1 level 1 directories 2026/09/05 03:05:28 INFO : a: Removing directory === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata 2026/09/05 03:07:49 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/05 03:12:55 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/05 03:19:59 DEBUG : file name.txt: Setting IA item derive: false === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2026/09/05 03:21:23 DEBUG : Creating backend with remote "TestIA:rclone-integration-test-2/rclone-test-nuhovec5jaxo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2026/09/05 03:21:23 DEBUG : Config file has changed externally - reloading === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2026/09/05 03:21:24 DEBUG : Creating backend with remote "TestIA:rclone-integration-test-2/rclone-test-nuhovec5jaxo/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/05 03:26:58 DEBUG : retry-Status500.bin: Setting IA item derive: false 2026/09/05 03:26:58 DEBUG : pacer: low level retry 1/10 (error HTTP error 500 (500 Internal Server Error) returned body: "") 2026/09/05 03:26:58 DEBUG : pacer: Rate limited, increasing sleep to 10ms 2026/09/05 03:26:58 DEBUG : pacer: low level retry 2/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/05 03:26:58 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2026/09/05 03:26:58 DEBUG : pacer: low level retry 3/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/05 03:26:58 DEBUG : pacer: Rate limited, increasing sleep to 40ms 2026/09/05 03:26:59 DEBUG : pacer: low level retry 4/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/05 03:26:59 DEBUG : pacer: Rate limited, increasing sleep to 80ms 2026/09/05 03:26:59 DEBUG : pacer: low level retry 5/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/05 03:26:59 DEBUG : pacer: Rate limited, increasing sleep to 160ms 2026/09/05 03:27:00 DEBUG : pacer: low level retry 6/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/05 03:27:00 DEBUG : pacer: Rate limited, increasing sleep to 320ms 2026/09/05 03:27:00 DEBUG : pacer: low level retry 7/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/05 03:27:00 DEBUG : pacer: Rate limited, increasing sleep to 640ms 2026/09/05 03:27:00 DEBUG : pacer: low level retry 8/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/05 03:27:00 DEBUG : pacer: Rate limited, increasing sleep to 1.28s 2026/09/05 03:27:01 DEBUG : pacer: low level retry 9/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/05 03:27:01 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/05 03:27:02 DEBUG : pacer: low level retry 10/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%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-nuhovec5jaxo%2Fretry-Status500.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0 2026/09/05 03:27:04 DEBUG : pacer: Reducing sleep to 1.5s 2026/09/05 03:27:06 DEBUG : pacer: Reducing sleep to 1.125s === RUN TestIntegration/FsMkdir/FsPutRetry/Simple/NetError 2026/09/05 03:27:06 DEBUG : retry-NetError.bin: Setting IA item derive: false 2026/09/05 03:27:07 DEBUG : pacer: low level retry 1/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fretry-NetError.bin": write tcp: unexpected EOF) 2026/09/05 03:27:07 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/05 03:27:09 DEBUG : pacer: low level retry 2/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/05 03:27:11 DEBUG : pacer: low level retry 3/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/05 03:27:13 DEBUG : pacer: low level retry 4/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/05 03:27:15 DEBUG : pacer: low level retry 5/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/05 03:27:17 DEBUG : pacer: low level retry 6/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/05 03:27:19 DEBUG : pacer: low level retry 7/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/05 03:27:21 DEBUG : pacer: low level retry 8/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/05 03:27:23 DEBUG : pacer: low level retry 9/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0) 2026/09/05 03:27:25 DEBUG : pacer: low level retry 10/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%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-nuhovec5jaxo%2Fretry-NetError.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=65536 with Body length 0 2026/09/05 03:27:27 DEBUG : pacer: Reducing sleep to 1.5s 2026/09/05 03:27:29 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/05 03:27:29 DEBUG : short-eof.bin: Setting IA item derive: false 2026/09/05 03:27:30 DEBUG : pacer: low level retry 1/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 5120) 2026/09/05 03:27:30 DEBUG : pacer: Rate limited, increasing sleep to 2s 2026/09/05 03:27:31 DEBUG : pacer: low level retry 2/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/09/05 03:27:33 DEBUG : pacer: low level retry 3/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/09/05 03:27:35 DEBUG : pacer: low level retry 4/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/09/05 03:27:37 DEBUG : pacer: low level retry 5/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/09/05 03:27:39 DEBUG : pacer: low level retry 6/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/09/05 03:27:41 DEBUG : pacer: low level retry 7/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/09/05 03:27:43 DEBUG : pacer: low level retry 8/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/09/05 03:27:45 DEBUG : pacer: low level retry 9/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0) 2026/09/05 03:27:47 DEBUG : pacer: low level retry 10/10 (error Put "https://s3.us.archive.org/rclone-integration-test-2%2Frclone-test-nuhovec5jaxo%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-nuhovec5jaxo%2Fshort-eof.bin": net/http: HTTP/1.x transport connection broken: http: ContentLength=10240 with Body length 0 2026/09/05 03:27:49 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/05 03:27:49 DEBUG : unknown-size-put.txt: Setting IA item derive: false 2026/09/05 03:27:52 DEBUG : pacer: Reducing sleep to 1.125s === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2026/09/05 03:27:52 DEBUG : unknown-size-update.txt: Setting IA item derive: false 2026/09/05 03:27:55 DEBUG : pacer: Reducing sleep to 843.75ms 2026/09/05 03:27:55 DEBUG : pacer: Reducing sleep to 632.8125ms 2026/09/05 03:28:05 DEBUG : pacer: Reducing sleep to 474.609375ms 2026/09/05 03:28:16 DEBUG : pacer: Reducing sleep to 355.957031ms 2026/09/05 03:28:26 DEBUG : pacer: Reducing sleep to 266.967773ms 2026/09/05 03:28:36 DEBUG : pacer: Reducing sleep to 200.225829ms 2026/09/05 03:28:46 DEBUG : pacer: Reducing sleep to 150.169371ms 2026/09/05 03:28:56 DEBUG : pacer: Reducing sleep to 112.627028ms 2026/09/05 03:29:07 DEBUG : pacer: Reducing sleep to 84.470271ms 2026/09/05 03:29:07 DEBUG : pacer: Reducing sleep to 63.352703ms 2026/09/05 03:29:07 DEBUG : pacer: Reducing sleep to 47.514527ms 2026/09/05 03:29:07 DEBUG : unknown-size-update.txt: Setting IA item derive: false 2026/09/05 03:29:08 DEBUG : pacer: Reducing sleep to 35.635895ms === RUN TestIntegration/FsMkdir/FsRootCollapse 2026/09/05 03:29:08 DEBUG : Creating backend with remote "TestIA:rclone-integration-test-2/rclone-test-nuhovec5jaxo/deeper/nonexisting/directory" 2026/09/05 03:29:08 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/05 03:29:08 DEBUG : Waiting for deletions to finish 2026/09/05 03:29:09 DEBUG : pacer: Reducing sleep to 26.726921ms 2026/09/05 03:29:10 DEBUG : pacer: Reducing sleep to 20.04519ms 2026/09/05 03:29:10 DEBUG : pacer: Reducing sleep to 15.033892ms 2026/09/05 03:29:17 DEBUG : pacer: Reducing sleep to 11.275419ms 2026/09/05 03:29:17 DEBUG : pacer: Reducing sleep to 0s 2026/09/05 03:34:58 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted 2026/09/05 03:35:37 INFO : unknown-size-update.txt: Deleted 2026/09/05 03:35:37 DEBUG : removing 1 level 0 directories 2026/09/05 03:35:37 INFO : Internet Archive item rclone-integration-test-2 path rclone-test-nuhovec5jaxo: Removing directory === RUN TestIntegration/FsShutdown fstests.go:3225: Shutdown method not supported --- FAIL: TestIntegration (2770.22s) --- 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 (2769.39s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.60s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.22s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.19s) --- PASS: TestIntegration/FsMkdir/FsListRDirEmpty (0.20s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.19s) --- PASS: TestIntegration/FsMkdir/FsListRDirNotFound (0.22s) --- SKIP: TestIntegration/FsMkdir/FsEncoding (0.00s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.43s) --- PASS: TestIntegration/FsMkdir/FsPutError (0.61s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (109.62s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles (2137.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (1.13s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.24s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.26s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (1.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (1.96s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (1.98s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (2.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (2.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.98s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.99s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (1.01s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (1.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.99s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (469.99s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsCopy (445.76s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (304.81s) --- 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.20s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.20s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.23s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (414.48s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata/mtime (414.26s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.25s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (1.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.23s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (1.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.63s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (1.67s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.58s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint (3.45s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/full_read (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/seek_read (0.38s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read (0.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/range_read_to_end (0.35s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenFingerprint/refresh (0.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (84.50s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.23s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.79s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.95s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (1.08s) --- 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 (331.54s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.22s) --- 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.04s) --- PASS: TestIntegration/FsMkdir/FsPutRetry/Simple (31.04s) --- PASS: TestIntegration/FsMkdir/FsPutRetry/Simple/Status500 (8.56s) --- PASS: TestIntegration/FsMkdir/FsPutRetry/Simple/NetError (22.48s) --- 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 (78.33s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (2.29s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (76.04s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.74s) --- 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 2770.242s "go test -v -timeout 2h0m0s -remote TestIA:rclone-integration-test-2 -verbose -short" - Finished OK in 46m11.61246158s (try 1/5)