"go test -v -timeout 1h0m0s -remote TestChunkerS3: -verbose" - Starting (try 1/5)
=== RUN   TestIntegration
    fstests.go:418: Using remote "TestChunkerS3:"
2022/03/15 05:18:01 DEBUG : Creating backend with remote "TestChunkerS3:rclone-test-vayutuf2yasawok9xubonep3"
2022/03/15 05:18:01 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2022/03/15 05:18:01 DEBUG : Creating backend with remote "TestS3:rclone-test-vayutuf2yasawok9xubonep3"
2022/03/15 05:18:01 DEBUG : Reset feature "ListR"
=== RUN   TestIntegration/FsCheckWrap
=== RUN   TestIntegration/FsCommand
    fstests.go:487: No commands in this remote
=== RUN   TestIntegration/FsRmdirNotFound
2022/03/15 05:18:01 INFO  : S3 bucket rclone-test-vayutuf2yasawok9xubonep3: Bucket "rclone-test-vayutuf2yasawok9xubonep3" created with ACL "private"
=== RUN   TestIntegration/FsString
=== RUN   TestIntegration/FsName
=== RUN   TestIntegration/FsRoot
=== RUN   TestIntegration/FsRmdirEmpty
2022/03/15 05:18:02 INFO  : S3 bucket rclone-test-vayutuf2yasawok9xubonep3: Bucket "rclone-test-vayutuf2yasawok9xubonep3" deleted
=== RUN   TestIntegration/FsMkdir
2022/03/15 05:18:02 INFO  : S3 bucket rclone-test-vayutuf2yasawok9xubonep3: Bucket "rclone-test-vayutuf2yasawok9xubonep3" created with ACL "private"
=== RUN   TestIntegration/FsMkdir/FsMkdirRmdirSubdir
2022/03/15 05:18:02 DEBUG : dir/subdir: Making directory
    fstest.go:251: Filtering empty directory "dir"
    fstest.go:251: Filtering empty directory "dir/subdir"
2022/03/15 05:18:03 INFO  : dir/subdir: Removing directory
    fstest.go:251: Filtering empty directory "dir"
2022/03/15 05:18:03 INFO  : dir: Removing directory
=== RUN   TestIntegration/FsMkdir/FsListEmpty
=== RUN   TestIntegration/FsMkdir/FsListDirEmpty
=== RUN   TestIntegration/FsMkdir/FsListRDirEmpty
    fstests.go:378: FS has no ListR interface
=== RUN   TestIntegration/FsMkdir/FsListDirNotFound
=== RUN   TestIntegration/FsMkdir/FsListRDirNotFound
    fstests.go:378: FS has no ListR interface
=== RUN   TestIntegration/FsMkdir/FsEncoding
=== RUN   TestIntegration/FsMkdir/FsEncoding/control_chars
    fstests.go:674: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡"
2022/03/15 05:18:03 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_ryon56: md5 = 9e19a62673755a6594dd67d87d2770e5 OK
2022/03/15 05:18:03 INFO  : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_ryon56: Copied (server-side copy) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡
2022/03/15 05:18:03 INFO  : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_ryon56: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/dot
    fstests.go:674: testing "．"
2022/03/15 05:18:04 DEBUG : ．/．.rclone_chunk.001_ryoovv: md5 = ec84bdc0b3988acfd0a61864a4ac22d9 OK
2022/03/15 05:18:04 INFO  : ．/．.rclone_chunk.001_ryoovv: Copied (server-side copy) to: ．/．
2022/03/15 05:18:04 INFO  : ．/．.rclone_chunk.001_ryoovv: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/dot_dot
    fstests.go:674: testing "．．"
2022/03/15 05:18:05 DEBUG : ．．/．．.rclone_chunk.001_ryop5n: md5 = 18a10850457376945ea3ae3e7ab984c3 OK
2022/03/15 05:18:05 INFO  : ．．/．．.rclone_chunk.001_ryop5n: Copied (server-side copy) to: ．．/．．
2022/03/15 05:18:05 INFO  : ．．/．．.rclone_chunk.001_ryop5n: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/punctuation
    fstests.go:674: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"
2022/03/15 05:18:06 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001_ryopqu: md5 = fe1a6b87b6d39eccf8bfe43eed93ce45 OK
2022/03/15 05:18:06 INFO  : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001_ryopqu: Copied (server-side copy) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~
2022/03/15 05:18:06 INFO  : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001_ryopqu: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_space
    fstests.go:674: testing " leading space"
2022/03/15 05:18:07 DEBUG :  leading space/ leading space.rclone_chunk.001_ryoqn2: md5 = c9417b1362b8701368c3328341e2c8d9 OK
2022/03/15 05:18:07 INFO  :  leading space/ leading space.rclone_chunk.001_ryoqn2: Copied (server-side copy) to:  leading space/ leading space
2022/03/15 05:18:07 INFO  :  leading space/ leading space.rclone_chunk.001_ryoqn2: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_tilde
    fstests.go:674: testing "~leading tilde"
2022/03/15 05:18:08 DEBUG : ~leading tilde/~leading tilde.rclone_chunk.001_ryor3q: md5 = 6904ae7bda954b0be618eb1bfe69ee54 OK
2022/03/15 05:18:08 INFO  : ~leading tilde/~leading tilde.rclone_chunk.001_ryor3q: Copied (server-side copy) to: ~leading tilde/~leading tilde
2022/03/15 05:18:08 INFO  : ~leading tilde/~leading tilde.rclone_chunk.001_ryor3q: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_CR
    fstests.go:674: testing "␍leading CR"
2022/03/15 05:18:08 DEBUG : ␍leading CR/␍leading CR.rclone_chunk.001_ryoscr: md5 = fb4649cff7bfd88eedbf65e4f25b8d18 OK
2022/03/15 05:18:08 INFO  : ␍leading CR/␍leading CR.rclone_chunk.001_ryoscr: Copied (server-side copy) to: ␍leading CR/␍leading CR
2022/03/15 05:18:08 INFO  : ␍leading CR/␍leading CR.rclone_chunk.001_ryoscr: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_LF
    fstests.go:674: testing "␊leading LF"
2022/03/15 05:18:09 DEBUG : ␊leading LF/␊leading LF.rclone_chunk.001_ryotbz: md5 = b6b3f4c09cc20ede9f2bc7b8abac0684 OK
2022/03/15 05:18:09 INFO  : ␊leading LF/␊leading LF.rclone_chunk.001_ryotbz: Copied (server-side copy) to: ␊leading LF/␊leading LF
2022/03/15 05:18:09 INFO  : ␊leading LF/␊leading LF.rclone_chunk.001_ryotbz: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_HT
    fstests.go:674: testing "␉leading HT"
2022/03/15 05:18:10 DEBUG : ␉leading HT/␉leading HT.rclone_chunk.001_ryouge: md5 = 81798fc0d57a6835bc361c07dda0d642 OK
2022/03/15 05:18:10 INFO  : ␉leading HT/␉leading HT.rclone_chunk.001_ryouge: Copied (server-side copy) to: ␉leading HT/␉leading HT
2022/03/15 05:18:10 INFO  : ␉leading HT/␉leading HT.rclone_chunk.001_ryouge: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_VT
    fstests.go:674: testing "␋leading VT"
2022/03/15 05:18:11 DEBUG : ␋leading VT/␋leading VT.rclone_chunk.001_ryovrn: md5 = bc8be7b161bbe32a255bab6d3bcf72c0 OK
2022/03/15 05:18:11 INFO  : ␋leading VT/␋leading VT.rclone_chunk.001_ryovrn: Copied (server-side copy) to: ␋leading VT/␋leading VT
2022/03/15 05:18:11 INFO  : ␋leading VT/␋leading VT.rclone_chunk.001_ryovrn: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_dot
    fstests.go:674: testing ".leading dot"
2022/03/15 05:18:12 DEBUG : .leading dot/.leading dot.rclone_chunk.001_ryovfa: md5 = 4d7cb8777a076d6f837e38d60c15678f OK
2022/03/15 05:18:12 INFO  : .leading dot/.leading dot.rclone_chunk.001_ryovfa: Copied (server-side copy) to: .leading dot/.leading dot
2022/03/15 05:18:12 INFO  : .leading dot/.leading dot.rclone_chunk.001_ryovfa: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_space
    fstests.go:674: testing "trailing space "
2022/03/15 05:18:13 DEBUG : trailing space /trailing space .rclone_chunk.001_ryow6t: md5 = 77519bc99a3e46d23444b8af17b01926 OK
2022/03/15 05:18:13 INFO  : trailing space /trailing space .rclone_chunk.001_ryow6t: Copied (server-side copy) to: trailing space /trailing space 
2022/03/15 05:18:13 INFO  : trailing space /trailing space .rclone_chunk.001_ryow6t: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_CR
    fstests.go:674: testing "trailing CR␍"
2022/03/15 05:18:14 DEBUG : trailing CR␍/trailing CR␍.rclone_chunk.001_ryoxow: md5 = 07296b64576c023a1144a66271807dfb OK
2022/03/15 05:18:14 INFO  : trailing CR␍/trailing CR␍.rclone_chunk.001_ryoxow: Copied (server-side copy) to: trailing CR␍/trailing CR␍
2022/03/15 05:18:14 INFO  : trailing CR␍/trailing CR␍.rclone_chunk.001_ryoxow: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_LF
    fstests.go:674: testing "trailing LF␊"
2022/03/15 05:18:14 DEBUG : trailing LF␊/trailing LF␊.rclone_chunk.001_ryoyi7: md5 = 236cd636c741ad6c8f6c23b28e5c7333 OK
2022/03/15 05:18:14 INFO  : trailing LF␊/trailing LF␊.rclone_chunk.001_ryoyi7: Copied (server-side copy) to: trailing LF␊/trailing LF␊
2022/03/15 05:18:15 INFO  : trailing LF␊/trailing LF␊.rclone_chunk.001_ryoyi7: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_HT
    fstests.go:674: testing "trailing HT␉"
2022/03/15 05:18:15 DEBUG : trailing HT␉/trailing HT␉.rclone_chunk.001_ryozuo: md5 = 34b54d0985cece58516ad68c52f548e7 OK
2022/03/15 05:18:15 INFO  : trailing HT␉/trailing HT␉.rclone_chunk.001_ryozuo: Copied (server-side copy) to: trailing HT␉/trailing HT␉
2022/03/15 05:18:15 INFO  : trailing HT␉/trailing HT␉.rclone_chunk.001_ryozuo: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_VT
    fstests.go:674: testing "trailing VT␋"
2022/03/15 05:18:16 DEBUG : trailing VT␋/trailing VT␋.rclone_chunk.001_ryp0g2: md5 = f33947514db31a574af5fc522dc82faf OK
2022/03/15 05:18:16 INFO  : trailing VT␋/trailing VT␋.rclone_chunk.001_ryp0g2: Copied (server-side copy) to: trailing VT␋/trailing VT␋
2022/03/15 05:18:16 INFO  : trailing VT␋/trailing VT␋.rclone_chunk.001_ryp0g2: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_dot
    fstests.go:674: testing "trailing dot."
2022/03/15 05:18:17 DEBUG : trailing dot./trailing dot..rclone_chunk.001_ryp1w5: md5 = ff09bea98ee81e15d5b7a480b66436ee OK
2022/03/15 05:18:17 INFO  : trailing dot./trailing dot..rclone_chunk.001_ryp1w5: Copied (server-side copy) to: trailing dot./trailing dot.
2022/03/15 05:18:17 INFO  : trailing dot./trailing dot..rclone_chunk.001_ryp1w5: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8
    fstests.go:674: testing "invalid utf-8\xfe"
2022/03/15 05:18:18 DEBUG : invalid utf-8�/invalid utf-8�.rclone_chunk.001_ryp183: md5 = 6154a89d60420cf5e87c1dd3d46c5d01 OK
2022/03/15 05:18:18 INFO  : invalid utf-8�/invalid utf-8�.rclone_chunk.001_ryp183: Copied (server-side copy) to: invalid utf-8�/invalid utf-8�
2022/03/15 05:18:18 INFO  : invalid utf-8�/invalid utf-8�.rclone_chunk.001_ryp183: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/URL_encoding
    fstests.go:674: testing "test%46.txt"
2022/03/15 05:18:19 DEBUG : test%46.txt/test%46.txt.rclone_chunk.001_ryp2gt: md5 = 873de83178fbc8b01c5767649a10e326 OK
2022/03/15 05:18:19 INFO  : test%46.txt/test%46.txt.rclone_chunk.001_ryp2gt: Copied (server-side copy) to: test%46.txt/test%46.txt
2022/03/15 05:18:19 INFO  : test%46.txt/test%46.txt.rclone_chunk.001_ryp2gt: Deleted
=== RUN   TestIntegration/FsMkdir/FsNewObjectNotFound
=== RUN   TestIntegration/FsMkdir/FsPutError
=== RUN   TestIntegration/FsMkdir/FsPutZeroLength
2022/03/15 05:18:20 DEBUG : zero-length-file.rclone_chunk.001_ryp327: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2022/03/15 05:18:20 INFO  : zero-length-file.rclone_chunk.001_ryp327: Copied (server-side copy) to: zero-length-file
2022/03/15 05:18:20 INFO  : zero-length-file.rclone_chunk.001_ryp327: Deleted
=== RUN   TestIntegration/FsMkdir/FsOpenWriterAt
    fstests.go:747: FS has no OpenWriterAt interface
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
    fstests.go:783: FS has no ChangeNotify interface
=== RUN   TestIntegration/FsMkdir/FsPutFiles
2022/03/15 05:18:20 DEBUG : file name.txt.rclone_chunk.001_ryp4ta: md5 = 12384f3ab54219bd0a363372ad7cc8f3 OK
2022/03/15 05:18:20 INFO  : file name.txt.rclone_chunk.001_ryp4ta: Copied (server-side copy) to: file name.txt
2022/03/15 05:18:20 INFO  : file name.txt.rclone_chunk.001_ryp4ta: Deleted
2022/03/15 05:18:21 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_ryp5rt: md5 = f8afb6788b1fdbb404ead8f8434ed068 OK
2022/03/15 05:18:21 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_ryp5rt: Copied (server-side copy) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt
2022/03/15 05:18:21 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_ryp5rt: Deleted
2022/03/15 05:18:22 DEBUG : file name.txt.rclone_chunk.001_ryp5pa: md5 = f68f6ac8ac07999bf2e98c79215862f2 OK
2022/03/15 05:18:22 INFO  : file name.txt.rclone_chunk.001_ryp5pa: Copied (server-side copy) to: file name.txt
2022/03/15 05:18:22 INFO  : file name.txt.rclone_chunk.001_ryp5pa: Deleted
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2
    fstests.go:378: FS has no ListR interface
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListR
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot
2022/03/15 05:18:22 DEBUG : Creating backend with remote "TestChunkerS3:"
2022/03/15 05:18:22 DEBUG : Creating backend with remote "TestS3:"
2022/03/15 05:18:22 DEBUG : Reset feature "ListR"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot
    fstests.go:378: FS has no ListR interface
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListSubdir
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01
    fstests.go:378: FS has no ListR interface
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListLevel2
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2
    fstests.go:378: FS has no ListR interface
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListFile1
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsNewObject
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive
    fstests.go:1036: Not Case Insensitive
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPurge
    fstests.go:1068: FS has no Purge interface
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsCopy
2022/03/15 05:18:24 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: copy non-chunked object...
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsMove
    fstests.go:1139: FS has no Mover interface
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsDirMove
    fstests.go:1210: FS has no DirMover interface
=== 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
    fstests.go:1343: MimeType 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
2022/03/15 05:18:27 DEBUG : file name.txt.rclone_chunk.001_rypaym: md5 = c7169dcc71958edc3f9b58c4ed2b94c8 OK
2022/03/15 05:18:27 INFO  : file name.txt.rclone_chunk.001_rypaym: Copied (server-side copy) to: file name.txt
2022/03/15 05:18:27 INFO  : file name.txt.rclone_chunk.001_rypaym: Deleted
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectStorable
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFile
2022/03/15 05:18:27 DEBUG : Creating backend with remote "TestChunkerS3:rclone-test-vayutuf2yasawok9xubonep3/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"
2022/03/15 05:18:27 DEBUG : Creating backend with remote "TestS3:rclone-test-vayutuf2yasawok9xubonep3/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"
2022/03/15 05:18:27 DEBUG : fs cache: adding new entry for parent of "TestS3:rclone-test-vayutuf2yasawok9xubonep3/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt", "TestS3:rclone-test-vayutuf2yasawok9xubonep3/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠"
2022/03/15 05:18:27 DEBUG : Reset feature "ListR"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound
2022/03/15 05:18:27 DEBUG : Creating backend with remote "TestChunkerS3:rclone-test-vayutuf2yasawok9xubonep3/not found.txt"
2022/03/15 05:18:27 DEBUG : Creating backend with remote "TestS3:rclone-test-vayutuf2yasawok9xubonep3/not found.txt"
2022/03/15 05:18:27 DEBUG : Reset feature "ListR"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot
    fstests.go:1492: Can't list from root on this remote
=== RUN   TestIntegration/FsMkdir/FsPutFiles/PublicLink
    fstests.go:1596: FS has no PublicLinker interface
=== RUN   TestIntegration/FsMkdir/FsPutFiles/SetTier
    fstests.go:392: FS has no SetTier & GetTier interfaces
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectRemove
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectAbout
    fstests.go:1728: FS does not support About
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPutStream
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0
2022/03/15 05:18:28 NOTICE: S3 bucket rclone-test-vayutuf2yasawok9xubonep3: Streaming uploads using chunk size 5Mi will have maximum file size of 48.828Gi
2022/03/15 05:18:28 DEBUG : piped data.txt.rclone_chunk.001_rypc60: multipart upload starting chunk 1 size 0 offset 0/off
2022/03/15 05:18:28 DEBUG : piped data.txt.rclone_chunk.001_rypc60: Multipart upload Etag: 59adb24ef3cdbe0297f05b395827453f-1 OK
2022/03/15 05:18:28 INFO  : piped data.txt.rclone_chunk.001_rypc60: Copied (server-side copy) to: piped data.txt
2022/03/15 05:18:29 INFO  : piped data.txt.rclone_chunk.001_rypc60: Deleted
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100
2022/03/15 05:18:29 DEBUG : piped data.txt.rclone_chunk.001_rypdin: multipart upload starting chunk 1 size 100 offset 0/off
2022/03/15 05:18:29 DEBUG : piped data.txt.rclone_chunk.001_rypdin: Multipart upload Etag: 4100e4bf25a6423008675c099c3e7ed4-1 OK
2022/03/15 05:18:29 INFO  : piped data.txt.rclone_chunk.001_rypdin: Copied (server-side copy) to: piped data.txt
2022/03/15 05:18:29 INFO  : piped data.txt.rclone_chunk.001_rypdin: Deleted
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge
    chunker_internal_test.go:906: -upload-kilobytes is not set
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat
2022/03/15 05:18:30 INFO  : Chunked 'TestChunkerS3:rclone-test-vayutuf2yasawok9xubonep3': invalid data chunk number in file "fish.chunk.001"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals
2022/03/15 05:18:30 DEBUG : small/emptyfile.rclone_chunk.001_rypeh8: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2022/03/15 05:18:30 INFO  : small/emptyfile.rclone_chunk.001_rypeh8: Copied (server-side copy) to: small/emptyfile
2022/03/15 05:18:30 INFO  : small/emptyfile.rclone_chunk.001_rypeh8: Deleted
2022/03/15 05:18:31 DEBUG : small/smallfile.rclone_chunk.001_rypeis: md5 = a60852f204ed8028c1c58808b746d115 OK
2022/03/15 05:18:31 INFO  : small/smallfile.rclone_chunk.001_rypeis: Copied (server-side copy) to: small/smallfile
2022/03/15 05:18:31 INFO  : small/smallfile.rclone_chunk.001_rypeis: Deleted
2022/03/15 05:18:31 DEBUG : Waiting for deletions to finish
2022/03/15 05:18:31 INFO  : small: Removing directory
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption
    chunker_internal_test.go:467: this test requires small chunks
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow
    chunker_internal_test.go:584: this test requires small chunks
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput
2022/03/15 05:18:32 DEBUG : usermeta/today.rclone_chunk.001_rypfyg: md5 = f9af2f31f4e4284fb7081584cbaa97e1 OK
2022/03/15 05:18:32 INFO  : usermeta/today.rclone_chunk.001_rypfyg: Copied (server-side copy) to: usermeta/today.rclone_chunk.001
2022/03/15 05:18:32 INFO  : usermeta/today.rclone_chunk.001_rypfyg: Deleted
2022/03/15 05:18:33 DEBUG : usermeta/past.rclone_chunk.001_rypgip: md5 = 078b72de2a9230309abb5a7db80a13c4 OK
2022/03/15 05:18:33 INFO  : usermeta/past.rclone_chunk.001_rypgip: Copied (server-side copy) to: usermeta/past.rclone_chunk.001
2022/03/15 05:18:33 INFO  : usermeta/past.rclone_chunk.001_rypgip: Deleted
2022/03/15 05:18:34 DEBUG : usermeta/future.rclone_chunk.001_ryphjs: md5 = 82e240013837bf80c807dba600b4594d OK
2022/03/15 05:18:34 INFO  : usermeta/future.rclone_chunk.001_ryphjs: Copied (server-side copy) to: usermeta/future.rclone_chunk.001
2022/03/15 05:18:34 INFO  : usermeta/future.rclone_chunk.001_ryphjs: Deleted
2022/03/15 05:18:34 DEBUG : Waiting for deletions to finish
2022/03/15 05:18:34 INFO  : usermeta: Removing directory
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof
2022/03/15 05:18:35 DEBUG : future/test: Can't copy - required hash not found
2022/03/15 05:18:35 ERROR : future/test: Failed to copy: failed to open source object: can't open: unknown metadata, please upgrade rclone
2022/03/15 05:18:35 ERROR : future/test: Not deleting source as copy failed: failed to open source object: can't open: unknown metadata, please upgrade rclone
2022/03/15 05:18:35 DEBUG : Chunked 'TestChunkerS3:rclone-test-vayutuf2yasawok9xubonep3': File to upload is small (3 bytes), uploading instead of streaming
2022/03/15 05:18:35 ERROR : future/test: Failed to copy: refusing to put: unknown metadata, please upgrade rclone
2022/03/15 05:18:35 DEBUG : Waiting for deletions to finish
2022/03/15 05:18:35 INFO  : future/test.rclone_chunk.003: Deleted
2022/03/15 05:18:36 INFO  : future/test: Deleted
2022/03/15 05:18:36 INFO  : future/test.rclone_chunk.001: Deleted
2022/03/15 05:18:36 INFO  : future/test.rclone_chunk.002: Deleted
2022/03/15 05:18:36 INFO  : future: Removing directory
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility
2022/03/15 05:18:38 DEBUG : backcomp/renamefile.rclone_chunk.001_rypkow: md5 = 85d917dd777543858f23955c8708fe4d OK
2022/03/15 05:18:38 INFO  : backcomp/renamefile.rclone_chunk.001_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.001
2022/03/15 05:18:38 INFO  : backcomp/renamefile.rclone_chunk.001_rypkow: Deleted
2022/03/15 05:18:38 DEBUG : backcomp/renamefile.rclone_chunk.002_rypkow: md5 = 69e04cc0335a88801986d32ea210ad1c OK
2022/03/15 05:18:38 INFO  : backcomp/renamefile.rclone_chunk.002_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.002
2022/03/15 05:18:38 INFO  : backcomp/renamefile.rclone_chunk.002_rypkow: Deleted
2022/03/15 05:18:39 DEBUG : backcomp/renamefile.rclone_chunk.003_rypkow: md5 = 33f555f73d3896542b4fcbb6e1a2f4d6 OK
2022/03/15 05:18:39 INFO  : backcomp/renamefile.rclone_chunk.003_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.003
2022/03/15 05:18:39 INFO  : backcomp/renamefile.rclone_chunk.003_rypkow: Deleted
2022/03/15 05:18:39 DEBUG : backcomp/renamefile.rclone_chunk.004_rypkow: md5 = 897f23c8cf9c80ffd5e4f99079e7c93c OK
2022/03/15 05:18:39 INFO  : backcomp/renamefile.rclone_chunk.004_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.004
2022/03/15 05:18:39 INFO  : backcomp/renamefile.rclone_chunk.004_rypkow: Deleted
2022/03/15 05:18:39 DEBUG : backcomp/renamefile.rclone_chunk.005_rypkow: md5 = 632532dfc476f82e09e5baaa402eb7a6 OK
2022/03/15 05:18:39 INFO  : backcomp/renamefile.rclone_chunk.005_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.005
2022/03/15 05:18:39 INFO  : backcomp/renamefile.rclone_chunk.005_rypkow: Deleted
2022/03/15 05:18:39 DEBUG : backcomp/renamefile.rclone_chunk.006_rypkow: md5 = 3a30fa1d288f60defbba3b4d7eed3a8f OK
2022/03/15 05:18:39 INFO  : backcomp/renamefile.rclone_chunk.006_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.006
2022/03/15 05:18:39 INFO  : backcomp/renamefile.rclone_chunk.006_rypkow: Deleted
2022/03/15 05:18:39 DEBUG : backcomp/renamefile.rclone_chunk.007_rypkow: md5 = 8506e791246d5be621b30a3782c383f0 OK
2022/03/15 05:18:39 INFO  : backcomp/renamefile.rclone_chunk.007_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.007
2022/03/15 05:18:39 INFO  : backcomp/renamefile.rclone_chunk.007_rypkow: Deleted
2022/03/15 05:18:39 DEBUG : backcomp/renamefile.rclone_chunk.008_rypkow: md5 = dcfbbd648b14fd67b3105cf39010bfad OK
2022/03/15 05:18:39 INFO  : backcomp/renamefile.rclone_chunk.008_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.008
2022/03/15 05:18:39 INFO  : backcomp/renamefile.rclone_chunk.008_rypkow: Deleted
2022/03/15 05:18:40 DEBUG : backcomp/renamefile.rclone_chunk.009_rypkow: md5 = 5c85a87843147354ac19cc3213f4a74b OK
2022/03/15 05:18:40 INFO  : backcomp/renamefile.rclone_chunk.009_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.009
2022/03/15 05:18:40 INFO  : backcomp/renamefile.rclone_chunk.009_rypkow: Deleted
2022/03/15 05:18:40 DEBUG : backcomp/renamefile.rclone_chunk.010_rypkow: md5 = 2934630b1e89795451117bab43ba7144 OK
2022/03/15 05:18:40 INFO  : backcomp/renamefile.rclone_chunk.010_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.010
2022/03/15 05:18:40 INFO  : backcomp/renamefile.rclone_chunk.010_rypkow: Deleted
2022/03/15 05:18:40 DEBUG : backcomp/renamefile.rclone_chunk.011_rypkow: md5 = 08675a519fe061356b7164b41fca1190 OK
2022/03/15 05:18:40 INFO  : backcomp/renamefile.rclone_chunk.011_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.011
2022/03/15 05:18:40 INFO  : backcomp/renamefile.rclone_chunk.011_rypkow: Deleted
2022/03/15 05:18:40 DEBUG : backcomp/renamefile.rclone_chunk.012_rypkow: md5 = ab87e737e6b5b79d04c6ecf473890673 OK
2022/03/15 05:18:40 INFO  : backcomp/renamefile.rclone_chunk.012_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.012
2022/03/15 05:18:40 INFO  : backcomp/renamefile.rclone_chunk.012_rypkow: Deleted
2022/03/15 05:18:40 DEBUG : backcomp/renamefile.rclone_chunk.013_rypkow: md5 = 5d7498474adc8caea29ad5d350f1965c OK
2022/03/15 05:18:40 INFO  : backcomp/renamefile.rclone_chunk.013_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.013
2022/03/15 05:18:40 INFO  : backcomp/renamefile.rclone_chunk.013_rypkow: Deleted
2022/03/15 05:18:40 DEBUG : backcomp/renamefile.rclone_chunk.014_rypkow: md5 = dd81092d948b086f33fc89a6abb91608 OK
2022/03/15 05:18:40 INFO  : backcomp/renamefile.rclone_chunk.014_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.014
2022/03/15 05:18:40 INFO  : backcomp/renamefile.rclone_chunk.014_rypkow: Deleted
2022/03/15 05:18:40 DEBUG : backcomp/renamefile.rclone_chunk.015_rypkow: md5 = 7d6cc73239d7f458e9b8b23d092b35d9 OK
2022/03/15 05:18:40 INFO  : backcomp/renamefile.rclone_chunk.015_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.015
2022/03/15 05:18:41 INFO  : backcomp/renamefile.rclone_chunk.015_rypkow: Deleted
2022/03/15 05:18:41 DEBUG : backcomp/renamefile.rclone_chunk.016_rypkow: md5 = e36136a5b5caebbe7da51c7c3332fa38 OK
2022/03/15 05:18:41 INFO  : backcomp/renamefile.rclone_chunk.016_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.016
2022/03/15 05:18:41 INFO  : backcomp/renamefile.rclone_chunk.016_rypkow: Deleted
2022/03/15 05:18:41 DEBUG : backcomp/renamefile.rclone_chunk.017_rypkow: md5 = 66ba0da06db3d11993d9eb04de31fc5b OK
2022/03/15 05:18:41 INFO  : backcomp/renamefile.rclone_chunk.017_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.017
2022/03/15 05:18:41 INFO  : backcomp/renamefile.rclone_chunk.017_rypkow: Deleted
2022/03/15 05:18:41 DEBUG : backcomp/renamefile.rclone_chunk.018_rypkow: md5 = 807ef7ef440152943ec32a367a6a41ef OK
2022/03/15 05:18:41 INFO  : backcomp/renamefile.rclone_chunk.018_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.018
2022/03/15 05:18:41 INFO  : backcomp/renamefile.rclone_chunk.018_rypkow: Deleted
2022/03/15 05:18:41 DEBUG : backcomp/renamefile.rclone_chunk.019_rypkow: md5 = 5998c0e69d07c8ac2603d600231b01ce OK
2022/03/15 05:18:41 INFO  : backcomp/renamefile.rclone_chunk.019_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.019
2022/03/15 05:18:41 INFO  : backcomp/renamefile.rclone_chunk.019_rypkow: Deleted
2022/03/15 05:18:41 DEBUG : backcomp/renamefile.rclone_chunk.020_rypkow: md5 = 7e59454a870fab808e9e63bba37347c7 OK
2022/03/15 05:18:41 INFO  : backcomp/renamefile.rclone_chunk.020_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.020
2022/03/15 05:18:41 INFO  : backcomp/renamefile.rclone_chunk.020_rypkow: Deleted
2022/03/15 05:18:41 DEBUG : backcomp/renamefile.rclone_chunk.021_rypkow: md5 = 216215b0c15d66c6e6e240f2a2bcf979 OK
2022/03/15 05:18:41 INFO  : backcomp/renamefile.rclone_chunk.021_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.021
2022/03/15 05:18:41 INFO  : backcomp/renamefile.rclone_chunk.021_rypkow: Deleted
2022/03/15 05:18:42 DEBUG : backcomp/renamefile.rclone_chunk.022_rypkow: md5 = 3e5b76260e2fe81f2d915db6bd3db87b OK
2022/03/15 05:18:42 INFO  : backcomp/renamefile.rclone_chunk.022_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.022
2022/03/15 05:18:42 INFO  : backcomp/renamefile.rclone_chunk.022_rypkow: Deleted
2022/03/15 05:18:42 DEBUG : backcomp/renamefile.rclone_chunk.023_rypkow: md5 = 9d870e7a315b0942a59f6be5ad8a4360 OK
2022/03/15 05:18:42 INFO  : backcomp/renamefile.rclone_chunk.023_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.023
2022/03/15 05:18:42 INFO  : backcomp/renamefile.rclone_chunk.023_rypkow: Deleted
2022/03/15 05:18:42 DEBUG : backcomp/renamefile.rclone_chunk.024_rypkow: md5 = 9a8393265706c2ac9f13cdb92fe466f3 OK
2022/03/15 05:18:42 INFO  : backcomp/renamefile.rclone_chunk.024_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.024
2022/03/15 05:18:42 INFO  : backcomp/renamefile.rclone_chunk.024_rypkow: Deleted
2022/03/15 05:18:42 DEBUG : backcomp/renamefile.rclone_chunk.025_rypkow: md5 = 88efcf63e04c6332ceec55c97eccf3d9 OK
2022/03/15 05:18:42 INFO  : backcomp/renamefile.rclone_chunk.025_rypkow: Copied (server-side copy) to: backcomp/renamefile.rclone_chunk.025
2022/03/15 05:18:42 INFO  : backcomp/renamefile.rclone_chunk.025_rypkow: Deleted
2022/03/15 05:18:44 DEBUG : Waiting for deletions to finish
2022/03/15 05:18:44 INFO  : backcomp: Removing directory
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove
2022/03/15 05:18:44 DEBUG : Creating backend with remote "TestChunkerS3:rclone-test-vayutuf2yasawok9xubonep3/servermovetest/subdir1"
2022/03/15 05:18:44 DEBUG : Creating backend with remote "TestS3:rclone-test-vayutuf2yasawok9xubonep3/servermovetest/subdir1"
2022/03/15 05:18:44 DEBUG : Reset feature "ListR"
2022/03/15 05:18:44 DEBUG : Creating backend with remote "TestChunkerS3:rclone-test-vayutuf2yasawok9xubonep3/servermovetest/subdir2"
2022/03/15 05:18:44 DEBUG : Creating backend with remote "TestS3:rclone-test-vayutuf2yasawok9xubonep3/servermovetest/subdir2"
2022/03/15 05:18:45 DEBUG : Reset feature "ListR"
2022/03/15 05:18:45 DEBUG : movefile.rclone_chunk.001_ryptbp: md5 = 900150983cd24fb0d6963f7d28e17f72 OK
2022/03/15 05:18:45 INFO  : movefile.rclone_chunk.001_ryptbp: Copied (server-side copy) to: movefile.rclone_chunk.001
2022/03/15 05:18:45 INFO  : movefile.rclone_chunk.001_ryptbp: Deleted
2022/03/15 05:18:45 DEBUG : movefile.rclone_chunk.002_ryptbp: md5 = 4ed9407630eb1000c0f6b63842defa7d OK
2022/03/15 05:18:45 INFO  : movefile.rclone_chunk.002_ryptbp: Copied (server-side copy) to: movefile.rclone_chunk.002
2022/03/15 05:18:46 INFO  : movefile.rclone_chunk.002_ryptbp: Deleted
2022/03/15 05:18:46 DEBUG : movefile: copy 2 data chunks...
2022/03/15 05:18:47 DEBUG : movefile: md5 = e80b5017098950fc58aad83c8c14978e OK
2022/03/15 05:18:47 INFO  : movefile: Copied (server-side copy)
2022/03/15 05:18:47 INFO  : movefile: Deleted
2022/03/15 05:18:47 DEBUG : Waiting for deletions to finish
2022/03/15 05:18:47 INFO  : servermovetest/subdir2/movefile.rclone_chunk.002: Deleted
2022/03/15 05:18:47 INFO  : servermovetest/subdir2/movefile.rclone_chunk.001: Deleted
2022/03/15 05:18:47 INFO  : servermovetest/subdir2/movefile: Deleted
2022/03/15 05:18:47 INFO  : servermovetest: Removing directory
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow
2022/03/15 05:18:47 DEBUG : Creating backend with remote "TestChunkerS3,chunk_size='1P',hash_type='md5all',meta_format='simplejson',name_format='*.#',transactions='rename':rclone-test-vayutuf2yasawok9xubonep3/md5all"
2022/03/15 05:18:47 DEBUG : TestChunkerS3: detected overridden config - adding "{r7Izf}" suffix to name
2022/03/15 05:18:47 DEBUG : Creating backend with remote "TestS3:rclone-test-vayutuf2yasawok9xubonep3/md5all"
2022/03/15 05:18:47 DEBUG : Reset feature "ListR"
    chunker_internal_test.go:878: this test needs a base fs with slow hash, e.g. local
=== RUN   TestIntegration/FsMkdir/FsPutChunked
    fstests.go:1807: *chunker.Fs does not implement SetUploadChunkSizer
=== RUN   TestIntegration/FsMkdir/FsUploadUnknownSize
=== RUN   TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize
2022/03/15 05:18:47 DEBUG : unknown-size-put.txt.rclone_chunk.001_rypvhv: multipart upload starting chunk 1 size 100 offset 0/off
2022/03/15 05:18:48 DEBUG : unknown-size-put.txt.rclone_chunk.001_rypvhv: Multipart upload Etag: 80285ffb380904c6ff4594d07c02977a-1 OK
2022/03/15 05:18:48 INFO  : unknown-size-put.txt.rclone_chunk.001_rypvhv: Copied (server-side copy) to: unknown-size-put.txt
2022/03/15 05:18:48 INFO  : unknown-size-put.txt.rclone_chunk.001_rypvhv: Deleted
=== RUN   TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize
2022/03/15 05:18:48 DEBUG : unknown-size-update.txt.rclone_chunk.001_rypwj4: md5 = baaa8c7951e7b9c7400f0856fc8d44f6 OK
2022/03/15 05:18:48 INFO  : unknown-size-update.txt.rclone_chunk.001_rypwj4: Copied (server-side copy) to: unknown-size-update.txt
2022/03/15 05:18:48 INFO  : unknown-size-update.txt.rclone_chunk.001_rypwj4: Deleted
2022/03/15 05:18:49 DEBUG : unknown-size-update.txt.rclone_chunk.001_rypwvb: multipart upload starting chunk 1 size 200 offset 0/off
2022/03/15 05:18:49 DEBUG : unknown-size-update.txt.rclone_chunk.001_rypwvb: Multipart upload Etag: da1fa99c9b4f97cb2dae088798377739-1 OK
2022/03/15 05:18:49 INFO  : unknown-size-update.txt.rclone_chunk.001_rypwvb: Copied (server-side copy) to: unknown-size-update.txt
2022/03/15 05:18:49 INFO  : unknown-size-update.txt.rclone_chunk.001_rypwvb: Deleted
=== RUN   TestIntegration/FsMkdir/FsRootCollapse
2022/03/15 05:18:49 DEBUG : Creating backend with remote "TestChunkerS3:rclone-test-vayutuf2yasawok9xubonep3/deeper/nonexisting/directory"
2022/03/15 05:18:49 DEBUG : Creating backend with remote "TestS3:rclone-test-vayutuf2yasawok9xubonep3/deeper/nonexisting/directory"
2022/03/15 05:18:49 DEBUG : Reset feature "ListR"
2022/03/15 05:18:49 DEBUG : Waiting for deletions to finish
2022/03/15 05:18:50 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted
2022/03/15 05:18:50 INFO  : Chunked 'TestChunkerS3:rclone-test-vayutuf2yasawok9xubonep3': Removing directory
2022/03/15 05:18:50 INFO  : S3 bucket rclone-test-vayutuf2yasawok9xubonep3: Bucket "rclone-test-vayutuf2yasawok9xubonep3" deleted
2022/03/15 05:18:50 ERROR : : error listing: directory not found
2022/03/15 05:18:50 DEBUG : Waiting for deletions to finish
2022/03/15 05:18:50 ERROR : : error listing: directory not found
2022/03/15 05:18:50 ERROR : Chunked 'TestChunkerS3:rclone-test-vayutuf2yasawok9xubonep3': Failed to list "": directory not found
2022/03/15 05:18:50 INFO  : Chunked 'TestChunkerS3:rclone-test-vayutuf2yasawok9xubonep3': Removing directory
2022/03/15 05:18:50 ERROR : : Failed to rmdir: bucket already deleted
=== CONT  TestIntegration/FsMkdir
    fstests.go:1989: Warning: this should produce fs.ErrorDirNotFound
=== RUN   TestIntegration/FsShutdown
    fstests.go:2003: Shutdown method not supported
--- PASS: TestIntegration (49.52s)
    --- PASS: TestIntegration/FsCheckWrap (0.00s)
    --- SKIP: TestIntegration/FsCommand (0.00s)
    --- PASS: TestIntegration/FsRmdirNotFound (0.24s)
    --- PASS: TestIntegration/FsString (0.00s)
    --- PASS: TestIntegration/FsName (0.00s)
    --- PASS: TestIntegration/FsRoot (0.00s)
    --- PASS: TestIntegration/FsRmdirEmpty (0.25s)
    --- PASS: TestIntegration/FsMkdir (48.41s)
        --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.15s)
        --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.06s)
        --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.05s)
        --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.05s)
        --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsEncoding (16.22s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.81s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.86s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.80s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.83s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.80s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.98s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.86s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.95s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.85s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.85s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.83s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.96s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.82s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.82s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.81s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.79s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.81s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.90s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (0.81s)
        --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.09s)
        --- PASS: TestIntegration/FsMkdir/FsPutError (0.24s)
        --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.61s)
        --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s)
        --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsPutFiles (27.20s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.24s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.24s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.19s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.19s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.09s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.09s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.32s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.09s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.32s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.04s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.66s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.00s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.05s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.09s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.20s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.09s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.09s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.09s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.09s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.25s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.09s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.14s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.14s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.27s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.14s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.85s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.10s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.25s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.23s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot (0.00s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.10s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.45s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (1.64s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.81s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.83s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (17.64s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge (0.00s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat (0.00s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals (1.60s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption (0.00s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow (0.00s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput (3.15s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof (1.39s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility (8.64s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove (2.69s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow (0.16s)
        --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (2.03s)
            --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.67s)
            --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (1.36s)
        --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.21s)
    --- SKIP: TestIntegration/FsShutdown (0.00s)
PASS
ok  	github.com/rclone/rclone/backend/chunker	49.550s
"go test -v -timeout 1h0m0s -remote TestChunkerS3: -verbose" - Finished OK in 51.65648008s (try 1/5)