"go test -v -timeout 1h0m0s -remote TestGoFile: -verbose" - Starting (try 1/5)
=== RUN TestIntegration
fstests.go:438: Using remote "TestGoFile:"
2026/05/22 04:07:09 DEBUG : Creating backend with remote "TestGoFile:rclone-test-nexaxup9nuzu"
2026/05/22 04:07:09 DEBUG : Using config file from "/home/rclone/.rclone.conf"
=== RUN TestIntegration/FsCheckWrap
fstests.go:479: Not a wrapping Fs
=== RUN TestIntegration/FsCommand
fstests.go:507: No commands in this remote
=== RUN TestIntegration/FsRmdirNotFound
=== RUN TestIntegration/FsString
=== RUN TestIntegration/FsName
=== RUN TestIntegration/FsRoot
=== RUN TestIntegration/FsRmdirEmpty
=== RUN TestIntegration/FsMkdir
=== RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir
2026/05/22 04:07:10 INFO : dir/subdir: Making directory
2026/05/22 04:07:11 INFO : dir/subdir: Removing directory
2026/05/22 04:07:11 INFO : dir: Removing directory
=== RUN TestIntegration/FsMkdir/FsListEmpty
=== RUN TestIntegration/FsMkdir/FsListDirEmpty
=== RUN TestIntegration/FsMkdir/FsListRDirEmpty
=== RUN TestIntegration/FsMkdir/FsListDirNotFound
2026/05/22 04:07:13 ERROR : does not exist: error listing: directory not found
=== RUN TestIntegration/FsMkdir/FsListRDirNotFound
2026/05/22 04:07:13 ERROR : does not exist: error listing: directory not found
=== RUN TestIntegration/FsMkdir/FsEncoding
=== RUN TestIntegration/FsMkdir/FsEncoding/control_chars
fstests.go:708: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡"
=== RUN TestIntegration/FsMkdir/FsEncoding/dot
fstests.go:708: testing "."
=== RUN TestIntegration/FsMkdir/FsEncoding/dot_dot
fstests.go:708: testing ".."
=== RUN TestIntegration/FsMkdir/FsEncoding/punctuation
fstests.go:708: testing "!\"#$%&'()*+,-./:;<=>?@[\\]^_`{|}~"
=== RUN TestIntegration/FsMkdir/FsEncoding/leading_space
fstests.go:708: testing " leading space"
=== RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde
fstests.go:708: testing "~leading tilde"
=== RUN TestIntegration/FsMkdir/FsEncoding/leading_CR
fstests.go:708: testing "␍leading CR"
=== RUN TestIntegration/FsMkdir/FsEncoding/leading_LF
fstests.go:708: testing "␊leading LF"
=== RUN TestIntegration/FsMkdir/FsEncoding/leading_HT
fstests.go:708: testing "␉leading HT"
=== RUN TestIntegration/FsMkdir/FsEncoding/leading_VT
fstests.go:708: testing "␋leading VT"
=== RUN TestIntegration/FsMkdir/FsEncoding/leading_dot
fstests.go:708: testing ".leading dot"
=== RUN TestIntegration/FsMkdir/FsEncoding/trailing_space
fstests.go:708: testing "trailing space "
=== RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR
fstests.go:708: testing "trailing CR␍"
=== RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF
fstests.go:708: testing "trailing LF␊"
=== RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT
fstests.go:708: testing "trailing HT␉"
=== RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT
fstests.go:708: testing "trailing VT␋"
=== RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot
fstests.go:708: testing "trailing dot."
=== RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8
fstests.go:708: testing "invalid utf-8\xfe"
=== RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding
fstests.go:708: testing "test%46.txt"
=== RUN TestIntegration/FsMkdir/FsNewObjectNotFound
=== RUN TestIntegration/FsMkdir/FsPutError
=== RUN TestIntegration/FsMkdir/FsPutZeroLength
=== RUN TestIntegration/FsMkdir/FsOpenWriterAt
fstests.go:787: FS has no OpenWriterAt interface
=== RUN TestIntegration/FsMkdir/FsOpenChunkWriter
fstests.go:820: FS has no OpenChunkWriter interface
=== RUN TestIntegration/FsMkdir/FsChangeNotify
fstests.go:873: FS has no ChangeNotify interface
=== RUN TestIntegration/FsMkdir/FsPutFiles
2026/05/22 04:07:57 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/05/22 04:08:00 DEBUG : Creating backend with remote "TestGoFile:"
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot
2026/05/22 04:08: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:1126: Not Case Insensitive
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot
2026/05/22 04:08:08 DEBUG : Creating backend with remote "TestGoFile:rclone-test-nexaxup9nuzu/dirToPurgeFromRoot"
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir
2026/05/22 04:08:09 DEBUG : Creating backend with remote "TestGoFile:rclone-test-nexaxup9nuzu/hello? sausage/êé"
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata
fstests.go:1298: Skipping test as can't write metadata
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsMove
2026/05/22 04:08:18 DEBUG : Rate limited, sleep for 5s
2026/05/22 04:08:23 DEBUG : pacer: low level retry 1/10 (error Error "error-rateLimit")
2026/05/22 04:08:23 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/05/22 04:08:23 DEBUG : Rate limited, sleep for 5s
2026/05/22 04:08:28 DEBUG : pacer: low level retry 2/10 (error Error "error-rateLimit")
2026/05/22 04:08:28 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/05/22 04:08:28 DEBUG : pacer: Reducing sleep to 20ms
2026/05/22 04:08:28 DEBUG : pacer: Reducing sleep to 10ms
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata
fstests.go:1407: Skipping test as can't write metadata
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove
2026/05/22 04:08:29 DEBUG : Creating backend with remote "TestGoFile:rclone-test-zilunif9qaqa"
2026/05/22 04:08:36 DEBUG : gofile root 'rclone-test-zilunif9qaqa': 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:1632: Metadata method not supported
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata
fstests.go:1703: 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/05/22 04:08:40 DEBUG : file name.txt: Removing old object on successful upload
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile
2026/05/22 04:08:41 DEBUG : Creating backend with remote "TestGoFile:rclone-test-nexaxup9nuzu/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"
2026/05/22 04:08:49 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:08:49 DEBUG : pacer: low level retry 1/10 (error Error "502 Bad Gateway (502): \r\n
502 Bad Gateway\r\n\r\n502 Bad Gateway
\r\n
nginx\r\n\r\n\r\n")
2026/05/22 04:08:49 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/05/22 04:08:50 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:08:50 DEBUG : pacer: low level retry 2/10 (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/05/22 04:08:50 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/05/22 04:08:50 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:08:50 DEBUG : pacer: low level retry 3/10 (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/05/22 04:08:50 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/05/22 04:08:50 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:08:50 DEBUG : pacer: low level retry 4/10 (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/05/22 04:08:50 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/05/22 04:08:50 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:08:50 DEBUG : pacer: low level retry 5/10 (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/05/22 04:08:50 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/05/22 04:08:50 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:08:50 DEBUG : pacer: low level retry 6/10 (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/05/22 04:08:50 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/05/22 04:08:51 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:08:51 DEBUG : pacer: low level retry 7/10 (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/05/22 04:08:51 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/05/22 04:08:52 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:08:52 DEBUG : pacer: low level retry 8/10 (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/05/22 04:08:52 DEBUG : pacer: Rate limited, increasing sleep to 2.56s
2026/05/22 04:08:53 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:08:53 DEBUG : pacer: low level retry 9/10 (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/05/22 04:08:53 DEBUG : pacer: Rate limited, increasing sleep to 5.12s
2026/05/22 04:08:55 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:08:55 DEBUG : pacer: low level retry 10/10 (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/05/22 04:08:55 DEBUG : pacer: Rate limited, increasing sleep to 10.24s
fstests.go:1868:
Error Trace: /home/rclone/go/src/github.com/rclone/rclone/fstest/fstests/fstests.go:1868
Error: Expected value not to be nil.
Test: TestIntegration/FsMkdir/FsPutFiles/FsIsFile
=== RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound
2026/05/22 04:08:55 DEBUG : Creating backend with remote "TestGoFile:rclone-test-nexaxup9nuzu/not found.txt"
=== RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot
fstests.go:1920: Opening root remote "TestGoFile:" path "rclone-test-nexaxup9nuzu" from "TestGoFile:rclone-test-nexaxup9nuzu"
2026/05/22 04:08:56 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
=== RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove
=== RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink
2026/05/22 04:09:00 DEBUG : gofile root 'rclone-test-nexaxup9nuzu': attempting to share single file 'file name.txt_does_not_exist'
2026/05/22 04:09:00 DEBUG : gofile root 'rclone-test-nexaxup9nuzu': attempting to share single file 'file name.txt'
2026/05/22 04:09:00 DEBUG : gofile root 'rclone-test-nexaxup9nuzu': Link expires at 2026-05-22 04:11:00.528209579 +0000 UTC m=+231.292547509 (duration 2m0s)
2026/05/22 04:09:00 DEBUG : gofile root 'rclone-test-nexaxup9nuzu': attempting to share single file 'hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt'
2026/05/22 04:09:00 DEBUG : gofile root 'rclone-test-nexaxup9nuzu': Link expires at 2026-05-22 04:11:00.701549343 +0000 UTC m=+231.465887273 (duration 2m0s)
2026/05/22 04:09:00 DEBUG : gofile root 'rclone-test-nexaxup9nuzu': attempting to share single file 'file name.txt'
2026/05/22 04:09:00 DEBUG : gofile root 'rclone-test-nexaxup9nuzu': Link expires at 2026-05-22 04:11:00.878071591 +0000 UTC m=+231.642409521 (duration 2m0s)
2026/05/22 04:09:00 DEBUG : gofile root 'rclone-test-nexaxup9nuzu': attempting to share directory 'hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠'
2026/05/22 04:09:00 DEBUG : gofile root 'rclone-test-nexaxup9nuzu': Link expires at 2026-05-22 04:11:00.931927088 +0000 UTC m=+231.696265018 (duration 2m0s)
2026/05/22 04:09:00 DEBUG : gofile root 'rclone-test-nexaxup9nuzu': attempting to share directory 'hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠'
2026/05/22 04:09:00 DEBUG : gofile root 'rclone-test-nexaxup9nuzu': Link expires at 2026-05-22 04:11:00.986036818 +0000 UTC m=+231.750374748 (duration 2m0s)
2026/05/22 04:09:01 DEBUG : Creating backend with remote "TestGoFile:rclone-test-texemag9neme"
2026/05/22 04:09:01 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:09:01 DEBUG : pacer: low level retry 1/10 (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/05/22 04:09:01 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/05/22 04:09:01 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:09:01 DEBUG : pacer: low level retry 2/10 (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/05/22 04:09:01 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/05/22 04:09:02 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:09:02 DEBUG : pacer: low level retry 3/10 (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/05/22 04:09:02 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/05/22 04:09:02 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:09:02 DEBUG : pacer: low level retry 4/10 (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/05/22 04:09:02 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/05/22 04:09:02 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:09:02 DEBUG : pacer: low level retry 5/10 (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/05/22 04:09:02 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/05/22 04:09:02 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:09:02 DEBUG : pacer: low level retry 6/10 (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/05/22 04:09:02 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/05/22 04:09:03 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:09:03 DEBUG : pacer: low level retry 7/10 (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/05/22 04:09:03 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/05/22 04:09:03 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:09:03 DEBUG : pacer: low level retry 8/10 (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/05/22 04:09:03 DEBUG : pacer: Rate limited, increasing sleep to 2.56s
2026/05/22 04:09:04 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:09:04 DEBUG : pacer: low level retry 9/10 (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/05/22 04:09:04 DEBUG : pacer: Rate limited, increasing sleep to 5.12s
2026/05/22 04:09:07 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:09:07 DEBUG : pacer: low level retry 10/10 (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/05/22 04:09:07 DEBUG : pacer: Rate limited, increasing sleep to 10.24s
2026/05/22 04:09:12 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:09:12 DEBUG : pacer: low level retry 1/10 (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/05/22 04:09:12 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/05/22 04:09:22 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:09:22 DEBUG : pacer: low level retry 2/10 (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/05/22 04:09:45 DEBUG : pacer: Reducing sleep to 10s
2026/05/22 04:10:02 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:10:02 DEBUG : pacer: low level retry 1/10 (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/05/22 04:10:02 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/05/22 04:10:12 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:10:12 DEBUG : pacer: low level retry 2/10 (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/05/22 04:10:32 DEBUG : pacer: Reducing sleep to 10s
2026/05/22 04:10:52 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:10:52 DEBUG : pacer: low level retry 1/10 (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/05/22 04:10:52 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/05/22 04:11:03 DEBUG : pacer: Reducing sleep to 10s
2026/05/22 04:11:36 DEBUG : pacer: Reducing sleep to 5s
2026/05/22 04:11:37 DEBUG : pacer: Reducing sleep to 2.5s
2026/05/22 04:11:37 DEBUG : gofile root 'rclone-test-nexaxup9nuzu': attempting to share directory ''
2026/05/22 04:11:37 DEBUG : gofile root 'rclone-test-nexaxup9nuzu': Link expires at 2026-05-22 04:13:37.560977921 +0000 UTC m=+388.325315842 (duration 2m0s)
2026/05/22 04:11:37 DEBUG : gofile root 'rclone-test-texemag9neme': Purge remote
2026/05/22 04:11:42 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:11:42 DEBUG : pacer: low level retry 1/10 (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/05/22 04:11:42 DEBUG : pacer: Rate limited, increasing sleep to 5s
2026/05/22 04:11:44 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:11:44 DEBUG : pacer: low level retry 2/10 (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/05/22 04:11:44 DEBUG : pacer: Rate limited, increasing sleep to 10s
2026/05/22 04:11:49 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:11:49 DEBUG : pacer: low level retry 3/10 (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/05/22 04:11:49 DEBUG : pacer: Rate limited, increasing sleep to 20s
2026/05/22 04:11:59 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:11:59 DEBUG : pacer: low level retry 4/10 (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/05/22 04:12:19 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:12:19 DEBUG : pacer: low level retry 5/10 (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/05/22 04:13:01 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:13:01 DEBUG : pacer: low level retry 6/10 (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/05/22 04:13:01 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:13:01 DEBUG : pacer: low level retry 7/10 (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/05/22 04:13:21 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:13:21 DEBUG : pacer: low level retry 8/10 (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/05/22 04:13:41 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:13:41 DEBUG : pacer: low level retry 9/10 (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/05/22 04:14:01 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:14:01 DEBUG : pacer: low level retry 10/10 (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/05/22 04:14:01 NOTICE: purge failed: failed to delete item: Error "502 Bad Gateway (502): \r\n502 Bad Gateway\r\n\r\n502 Bad Gateway
\r\n
nginx\r\n\r\n\r\n"
=== RUN TestIntegration/FsMkdir/FsPutFiles/SetTier
fstests.go:412: FS has no SetTier & GetTier interfaces
=== RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap
fstests.go:2121: Not a wrapping Fs
=== RUN TestIntegration/FsMkdir/FsPutFiles/Bucket
fstests.go:2137: 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:2355: *gofile.Fs does not implement InternalTester
=== RUN TestIntegration/FsMkdir/FsPutChunked
fstests.go:2376: *gofile.Fs does not implement SetUploadChunkSizer
=== RUN TestIntegration/FsMkdir/FsCopyChunked
fstests.go:2497: *gofile.Fs does not implement SetCopyCutoff
=== RUN TestIntegration/FsMkdir/FsUploadUnknownSize
=== RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize
=== RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize
2026/05/22 04:14:05 DEBUG : unknown-size-update.txt: Removing old object on successful upload
=== RUN TestIntegration/FsMkdir/FsRootCollapse
2026/05/22 04:14:06 DEBUG : Creating backend with remote "TestGoFile:rclone-test-nexaxup9nuzu/deeper/nonexisting/directory"
2026/05/22 04:14:06 DEBUG : Config file has changed externally - reloading
2026/05/22 04:14:06 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:14:06 DEBUG : pacer: low level retry 1/10 (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/05/22 04:14:06 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/05/22 04:14:06 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:14:06 DEBUG : pacer: low level retry 2/10 (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/05/22 04:14:06 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/05/22 04:14:06 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:14:06 DEBUG : pacer: low level retry 3/10 (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/05/22 04:14:06 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/05/22 04:14:06 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:14:06 DEBUG : pacer: low level retry 4/10 (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/05/22 04:14:06 DEBUG : pacer: Rate limited, increasing sleep to 160ms
2026/05/22 04:14:06 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:14:06 DEBUG : pacer: low level retry 5/10 (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/05/22 04:14:06 DEBUG : pacer: Rate limited, increasing sleep to 320ms
2026/05/22 04:14:06 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:14:06 DEBUG : pacer: low level retry 6/10 (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/05/22 04:14:06 DEBUG : pacer: Rate limited, increasing sleep to 640ms
2026/05/22 04:14:07 DEBUG : Couldn't decode error response: invalid character '<' looking for beginning of value
2026/05/22 04:14:07 DEBUG : pacer: low level retry 7/10 (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/05/22 04:14:07 DEBUG : pacer: Rate limited, increasing sleep to 1.28s
2026/05/22 04:14:08 DEBUG : pacer: Reducing sleep to 640ms
2026/05/22 04:14:10 DEBUG : pacer: Reducing sleep to 320ms
2026/05/22 04:14:12 DEBUG : pacer: Reducing sleep to 160ms
2026/05/22 04:14:12 DEBUG : pacer: Reducing sleep to 80ms
2026/05/22 04:14:12 DEBUG : pacer: Reducing sleep to 40ms
=== RUN TestIntegration/FsMkdir/FsDirSetModTime
=== RUN TestIntegration/FsMkdir/FsMkdirMetadata
fstests.go:2680: FS has no MkdirMetadata interface
=== RUN TestIntegration/FsMkdir/FsDirectory
=== RUN TestIntegration/FsMkdir/FsDirectory/ReadDirMetadata
fstests.go:2754: Directories don't support ReadDirMetadata
=== RUN TestIntegration/FsMkdir/FsDirectory/WriteDirMetadata
fstests.go:2766: Directories don't support WriteDirMetadata
=== RUN TestIntegration/FsMkdir/FsDirectory/WriteDirSetModTime
=== RUN TestIntegration/FsMkdir/FsDirectory/DirectoryCheckWrap
fstests.go:2801: Not a wrapping Fs
=== RUN TestIntegration/FsShutdown
fstests.go:2843: Shutdown method not supported
--- FAIL: TestIntegration (426.91s)
--- SKIP: TestIntegration/FsCheckWrap (0.00s)
--- SKIP: TestIntegration/FsCommand (0.00s)
--- PASS: TestIntegration/FsRmdirNotFound (0.06s)
--- PASS: TestIntegration/FsString (0.00s)
--- PASS: TestIntegration/FsName (0.00s)
--- PASS: TestIntegration/FsRoot (0.00s)
--- PASS: TestIntegration/FsRmdirEmpty (0.26s)
--- FAIL: TestIntegration/FsMkdir (425.78s)
--- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (1.35s)
--- PASS: TestIntegration/FsMkdir/FsListEmpty (0.23s)
--- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.62s)
--- PASS: TestIntegration/FsMkdir/FsListRDirEmpty (0.52s)
--- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.06s)
--- PASS: TestIntegration/FsMkdir/FsListRDirNotFound (0.06s)
--- PASS: TestIntegration/FsMkdir/FsEncoding (36.42s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (1.87s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/dot (2.53s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (2.02s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (2.09s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (2.54s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (1.67s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (1.78s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (2.36s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (1.45s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (2.10s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (1.07s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (1.47s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (2.61s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (1.66s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (1.14s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (1.90s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (1.47s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (2.76s)
--- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (1.88s)
--- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.11s)
--- PASS: TestIntegration/FsMkdir/FsPutError (0.69s)
--- PASS: TestIntegration/FsMkdir/FsPutZeroLength (3.65s)
--- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s)
--- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s)
--- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles (369.13s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.47s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (1.04s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.31s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.08s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.17s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.15s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.11s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.66s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.54s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.27s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.62s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.06s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (1.03s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.06s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (2.32s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (2.11s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (3.82s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.85s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (0.00s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (15.78s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (6.90s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.06s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.06s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.40s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.06s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.06s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.23s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.06s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.06s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.06s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.16s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.06s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.73s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.57s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.94s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.55s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (1.17s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.25s)
--- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (13.79s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.52s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (4.12s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (0.28s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.07s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (2.45s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (1.32s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (0.47s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (301.18s)
--- 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.77s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.07s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (1.22s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.73s)
--- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.50s)
--- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal (0.00s)
--- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s)
--- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s)
--- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (2.52s)
--- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.99s)
--- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (1.53s)
--- PASS: TestIntegration/FsMkdir/FsRootCollapse (6.54s)
--- PASS: TestIntegration/FsMkdir/FsDirSetModTime (1.33s)
--- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s)
--- PASS: TestIntegration/FsMkdir/FsDirectory (1.10s)
--- SKIP: TestIntegration/FsMkdir/FsDirectory/ReadDirMetadata (0.00s)
--- SKIP: TestIntegration/FsMkdir/FsDirectory/WriteDirMetadata (0.00s)
--- PASS: TestIntegration/FsMkdir/FsDirectory/WriteDirSetModTime (0.34s)
--- SKIP: TestIntegration/FsMkdir/FsDirectory/DirectoryCheckWrap (0.00s)
--- SKIP: TestIntegration/FsShutdown (0.00s)
FAIL
exit status 1
FAIL github.com/rclone/rclone/backend/gofile 426.922s
"go test -v -timeout 1h0m0s -remote TestGoFile: -verbose" - Finished ERROR in 7m7.907574162s (try 1/5): exit status 1: Failed [TestIntegration/FsMkdir/FsPutFiles/FsIsFile]