"go test -v -timeout 1h0m0s -remote TestGoFile: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$'" - Starting (try 2/5)
=== RUN TestIntegration
fstests.go:438: Using remote "TestGoFile:"
2026/02/08 02:02:56 DEBUG : Creating backend with remote "TestGoFile:rclone-test-cemuful8bizo"
2026/02/08 02:02:56 DEBUG : Using config file from "/home/rclone/.rclone.conf"
=== RUN TestIntegration/FsMkdir
=== RUN TestIntegration/FsMkdir/FsPutFiles
2026/02/08 02:02:58 DEBUG : file name.txt: Removing old object on successful upload
=== 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/02/08 02:03:00 DEBUG : Creating backend with remote "TestGoFile:"
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot
2026/02/08 02:03:01 DEBUG : Creating backend with remote "TestGoFile:"
=== 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:1122: Not Case Insensitive
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot
2026/02/08 02:03:05 DEBUG : Creating backend with remote "TestGoFile:rclone-test-cemuful8bizo/dirToPurgeFromRoot"
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir
2026/02/08 02:03:06 DEBUG : Creating backend with remote "TestGoFile:rclone-test-cemuful8bizo/hello? sausage/êé"
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy
2026/02/08 02:03:09 DEBUG : Rate limited, sleep for 5s
2026/02/08 02:03:14 DEBUG : pacer: low level retry 1/10 (error Error "error-rateLimit")
2026/02/08 02:03:14 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/02/08 02:03:14 DEBUG : Rate limited, sleep for 5s
2026/02/08 02:03:19 DEBUG : pacer: low level retry 2/10 (error Error "error-rateLimit")
2026/02/08 02:03:19 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/02/08 02:04:40 DEBUG : Rate limited, sleep for 5s
2026/02/08 02:04:45 DEBUG : pacer: low level retry 3/10 (error Error "error-rateLimit")
2026/02/08 02:04:45 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/02/08 02:04:45 DEBUG : Rate limited, sleep for 5s
2026/02/08 02:04:50 DEBUG : pacer: low level retry 4/10 (error Error "error-rateLimit")
2026/02/08 02:04:50 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/02/08 02:04:50 DEBUG : Rate limited, sleep for 5s
2026/02/08 02:04:55 DEBUG : pacer: low level retry 5/10 (error Error "error-rateLimit")
2026/02/08 02:04:55 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/02/08 02:04:55 DEBUG : Rate limited, sleep for 5s
2026/02/08 02:05:00 DEBUG : pacer: low level retry 6/10 (error Error "error-rateLimit")
2026/02/08 02:05:00 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/02/08 02:05:00 DEBUG : Rate limited, sleep for 5s
2026/02/08 02:05:05 DEBUG : pacer: low level retry 7/10 (error Error "error-rateLimit")
2026/02/08 02:05:05 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/02/08 02:05:05 DEBUG : Rate limited, sleep for 5s
2026/02/08 02:05:10 DEBUG : pacer: low level retry 8/10 (error Error "error-rateLimit")
2026/02/08 02:05:10 DEBUG : pacer: Rate limited, increasing sleep to 2.56s
2026/02/08 02:05:10 DEBUG : Rate limited, sleep for 5s
2026/02/08 02:05:15 DEBUG : pacer: low level retry 9/10 (error Error "error-rateLimit")
2026/02/08 02:05:15 DEBUG : pacer: Rate limited, increasing sleep to 5.12s
2026/02/08 02:05:15 DEBUG : Rate limited, sleep for 5s
2026/02/08 02:05:20 DEBUG : pacer: low level retry 10/10 (error Error "error-rateLimit")
2026/02/08 02:05:20 DEBUG : pacer: Rate limited, increasing sleep to 10.24s
fstests.go:1268:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1268
Error: Received unexpected error:
failed to copy item: Error "error-rateLimit"
Test: TestIntegration/FsMkdir/FsPutFiles/FsCopy
Messages: Error: &fmt.wrapError{msg:"failed to copy item: Error \"error-rateLimit\"", err:fserrors.wrappedRetryError{error:api.Error{Status:"error-rateLimit"}}}
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsMove
2026/02/08 02:05:20 DEBUG : pacer: Reducing sleep to 5.12s
2026/02/08 02:05:30 DEBUG : pacer: Reducing sleep to 2.56s
2026/02/08 02:05:35 DEBUG : pacer: Reducing sleep to 1.28s
2026/02/08 02:05:38 DEBUG : pacer: Reducing sleep to 640ms
2026/02/08 02:05:39 DEBUG : pacer: Reducing sleep to 320ms
2026/02/08 02:05:40 DEBUG : pacer: Reducing sleep to 160ms
2026/02/08 02:05:40 DEBUG : pacer: Reducing sleep to 80ms
2026/02/08 02:05:40 DEBUG : pacer: Reducing sleep to 40ms
2026/02/08 02:05:40 DEBUG : pacer: Reducing sleep to 20ms
2026/02/08 02:05:41 DEBUG : pacer: Reducing sleep to 10ms
2026/02/08 02:05:41 DEBUG : Rate limited, sleep for 5s
2026/02/08 02:05:46 DEBUG : pacer: low level retry 1/10 (error Error "error-rateLimit")
2026/02/08 02:05:46 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/02/08 02:05:46 DEBUG : Rate limited, sleep for 5s
2026/02/08 02:05:51 DEBUG : pacer: low level retry 2/10 (error Error "error-rateLimit")
2026/02/08 02:05:51 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/02/08 02:05:51 DEBUG : pacer: Reducing sleep to 20ms
2026/02/08 02:05:52 DEBUG : pacer: Reducing sleep to 10ms
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata
fstests.go:1403: Skipping test as can't write metadata
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove
2026/02/08 02:05:52 DEBUG : Creating backend with remote "TestGoFile:rclone-test-hilefer0woda"
2026/02/08 02:06:15 DEBUG : gofile root 'rclone-test-hilefer0woda': Purge remote
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull
=== 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
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata
fstests.go:1628: Metadata method not supported
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata
fstests.go:1699: 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/ObjectUpdate
2026/02/08 02:06:18 DEBUG : file name.txt: Removing old object on successful upload
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile
2026/02/08 02:06:18 DEBUG : Creating backend with remote "TestGoFile:rclone-test-cemuful8bizo/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound
2026/02/08 02:06:20 DEBUG : Creating backend with remote "TestGoFile:rclone-test-cemuful8bizo/not found.txt"
=== RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot
fstests.go:1916: Opening root remote "TestGoFile:" path "rclone-test-cemuful8bizo" from "TestGoFile:rclone-test-cemuful8bizo"
2026/02/08 02:06:21 DEBUG : Creating backend with remote "TestGoFile:"
=== RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List
=== RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries
=== RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR
=== RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put
2026/02/08 02:06:43 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/02/08 02:06:43 DEBUG : pacer: low level retry 1/1 (error Error "502 Bad Gateway (502): \r\n502 Bad Gateway\r\n\r\n502 Bad Gateway
\r\n
nginx\r\n\r\n\r\n")
2026/02/08 02:06:43 DEBUG : pacer: Rate limited, increasing sleep to 20ms
fstests.go:143: Put error: failed to upload file: Error "502 Bad Gateway (502): \r\n502 Bad Gateway\r\n\r\n502 Bad Gateway
\r\n
nginx\r\n\r\n\r\n" - low level retry 1/10
2026/02/08 02:06:45 DEBUG : pacer: Reducing sleep to 10ms
=== RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove
=== RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink
2026/02/08 02:06:46 DEBUG : gofile root 'rclone-test-cemuful8bizo': attempting to share single file 'file name.txt_does_not_exist'
2026/02/08 02:06:46 DEBUG : gofile root 'rclone-test-cemuful8bizo': attempting to share single file 'file name.txt'
2026/02/08 02:06:46 DEBUG : gofile root 'rclone-test-cemuful8bizo': Link expires at 2026-02-08 02:08:46.438737457 +0000 UTC m=+350.442950630 (duration 2m0s)
2026/02/08 02:06:46 DEBUG : gofile root 'rclone-test-cemuful8bizo': attempting to share single file 'hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt'
2026/02/08 02:06:46 DEBUG : gofile root 'rclone-test-cemuful8bizo': Link expires at 2026-02-08 02:08:46.780744584 +0000 UTC m=+350.784957768 (duration 2m0s)
2026/02/08 02:06:46 DEBUG : gofile root 'rclone-test-cemuful8bizo': attempting to share single file 'file name.txt'
2026/02/08 02:06:47 DEBUG : gofile root 'rclone-test-cemuful8bizo': Link expires at 2026-02-08 02:08:47.060614403 +0000 UTC m=+351.064827577 (duration 2m0s)
2026/02/08 02:06:47 DEBUG : gofile root 'rclone-test-cemuful8bizo': attempting to share directory 'hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠'
2026/02/08 02:06:47 DEBUG : gofile root 'rclone-test-cemuful8bizo': Link expires at 2026-02-08 02:08:47.206181842 +0000 UTC m=+351.210395015 (duration 2m0s)
2026/02/08 02:06:47 DEBUG : gofile root 'rclone-test-cemuful8bizo': attempting to share directory 'hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠'
2026/02/08 02:06:47 DEBUG : gofile root 'rclone-test-cemuful8bizo': Link expires at 2026-02-08 02:08:47.274011195 +0000 UTC m=+351.278224379 (duration 2m0s)
2026/02/08 02:06:47 DEBUG : Creating backend with remote "TestGoFile:rclone-test-howikeq3vavu"
2026/02/08 02:06:48 DEBUG : gofile root 'rclone-test-cemuful8bizo': attempting to share directory ''
2026/02/08 02:06:48 DEBUG : gofile root 'rclone-test-cemuful8bizo': Link expires at 2026-02-08 02:08:48.401377455 +0000 UTC m=+352.405590638 (duration 2m0s)
2026/02/08 02:06:48 DEBUG : gofile root 'rclone-test-howikeq3vavu': Purge remote
=== RUN TestIntegration/FsMkdir/FsPutFiles/SetTier
fstests.go:412: FS has no SetTier & GetTier interfaces
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap
fstests.go:2117: Not a wrapping Fs
=== RUN TestIntegration/FsMkdir/FsPutFiles/Bucket
fstests.go:2133: Not a bucket based backend
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100
=== RUN TestIntegration/FsMkdir/FsPutFiles/Internal
fstests.go:2351: *gofile.Fs does not implement InternalTester
--- FAIL: TestIntegration (234.80s)
--- FAIL: TestIntegration/FsMkdir (234.10s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles (233.45s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.65s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.54s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.40s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.32s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.18s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.20s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.25s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.27s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.22s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.33s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.38s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.14s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.40s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.10s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (1.50s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (1.96s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (2.76s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsCopy (130.74s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (32.17s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (23.24s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.09s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.07s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.06s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.10s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.10s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.10s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.14s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.07s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.12s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.20s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.12s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.28s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.19s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.42s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.19s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.68s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.08s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (1.75s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.88s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (24.65s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (20.48s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.16s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.75s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (3.27s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.38s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (2.85s)
--- 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 (0.54s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.09s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (0.77s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.39s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.38s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal (0.00s)
FAIL
exit status 1
FAIL github.com/rclone/rclone/backend/gofile 234.820s
"go test -v -timeout 1h0m0s -remote TestGoFile: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$'" - Finished ERROR in 3m55.693593377s (try 2/5): exit status 1: Failed [TestIntegration/FsMkdir/FsPutFiles/FsCopy]