"go test -v -timeout 1h0m0s -remote TestChunkerS3: -verbose" - Starting (try 1/5)
=== RUN   TestIntegration
    fstests.go:357: Using remote "TestChunkerS3:"
2020/11/03 05:05:10 DEBUG : Creating backend with remote "TestChunkerS3:rclone-test-xogasuf9muribus1cazeval9"
2020/11/03 05:05:10 DEBUG : Creating backend with remote "TestS3:rclone-test-xogasuf9muribus1cazeval9"
2020/11/03 05:05:10 DEBUG : Reset feature "ListR"
=== RUN   TestIntegration/FsCheckWrap
=== RUN   TestIntegration/FsCommand
    fstests.go:422: No commands in this remote
=== RUN   TestIntegration/FsRmdirNotFound
2020/11/03 05:05:14 INFO  : S3 bucket rclone-test-xogasuf9muribus1cazeval9: Bucket "rclone-test-xogasuf9muribus1cazeval9" created with ACL "private"
=== RUN   TestIntegration/FsString
=== RUN   TestIntegration/FsName
=== RUN   TestIntegration/FsRoot
=== RUN   TestIntegration/FsRmdirEmpty
2020/11/03 05:05:14 INFO  : S3 bucket rclone-test-xogasuf9muribus1cazeval9: Bucket "rclone-test-xogasuf9muribus1cazeval9" deleted
=== RUN   TestIntegration/FsMkdir
2020/11/03 05:05:15 INFO  : S3 bucket rclone-test-xogasuf9muribus1cazeval9: Bucket "rclone-test-xogasuf9muribus1cazeval9" created with ACL "private"
=== RUN   TestIntegration/FsMkdir/FsMkdirRmdirSubdir
2020/11/03 05:05:15 DEBUG : dir/subdir: Making directory
    fstest.go:247: Filtering empty directory "dir"
    fstest.go:247: Filtering empty directory "dir/subdir"
2020/11/03 05:05:15 DEBUG : dir/subdir: Removing directory
    fstest.go:247: Filtering empty directory "dir"
2020/11/03 05:05:15 DEBUG : dir: Removing directory
=== RUN   TestIntegration/FsMkdir/FsListEmpty
=== RUN   TestIntegration/FsMkdir/FsListDirEmpty
=== RUN   TestIntegration/FsMkdir/FsListRDirEmpty
    fstests.go:317: FS has no ListR interface
=== RUN   TestIntegration/FsMkdir/FsListDirNotFound
=== RUN   TestIntegration/FsMkdir/FsListRDirNotFound
    fstests.go:317: FS has no ListR interface
=== RUN   TestIntegration/FsMkdir/FsEncoding
=== RUN   TestIntegration/FsMkdir/FsEncoding/control_chars
    fstests.go:605: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡"
2020/11/03 05:05:15 DEBUG : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_7kmgkg: MD5 = dfc4d76027567bc851e5d226fcd99594 OK
2020/11/03 05:05:15 INFO  : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_7kmgkg: Copied (server-side copy) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡
2020/11/03 05:05:15 INFO  : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_7kmgkg: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/dot
    fstests.go:605: testing "．"
2020/11/03 05:05:16 DEBUG : ．/．.rclone_chunk.001_7kmhez: MD5 = c39f1d8af49c36df85b84b627905e3e6 OK
2020/11/03 05:05:16 INFO  : ．/．.rclone_chunk.001_7kmhez: Copied (server-side copy) to: ．/．
2020/11/03 05:05:16 INFO  : ．/．.rclone_chunk.001_7kmhez: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/dot_dot
    fstests.go:605: testing "．．"
2020/11/03 05:05:16 DEBUG : ．．/．．.rclone_chunk.001_7kmhld: MD5 = 6802b88feb91923745566d0196e34635 OK
2020/11/03 05:05:16 INFO  : ．．/．．.rclone_chunk.001_7kmhld: Copied (server-side copy) to: ．．/．．
2020/11/03 05:05:16 INFO  : ．．/．．.rclone_chunk.001_7kmhld: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/punctuation
    fstests.go:605: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"
2020/11/03 05:05:17 DEBUG : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001_7kmied: MD5 = 28f66398f3a76644f2b3116d90864107 OK
2020/11/03 05:05:17 INFO  : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001_7kmied: Copied (server-side copy) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~
2020/11/03 05:05:17 INFO  : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001_7kmied: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_space
    fstests.go:605: testing " leading space"
2020/11/03 05:05:17 DEBUG :  leading space/ leading space.rclone_chunk.001_7kmiwm: MD5 = 929c19050b922635619c414285f0e4d4 OK
2020/11/03 05:05:17 INFO  :  leading space/ leading space.rclone_chunk.001_7kmiwm: Copied (server-side copy) to:  leading space/ leading space
2020/11/03 05:05:17 INFO  :  leading space/ leading space.rclone_chunk.001_7kmiwm: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_tilde
    fstests.go:605: testing "~leading tilde"
2020/11/03 05:05:18 DEBUG : ~leading tilde/~leading tilde.rclone_chunk.001_7kmida: MD5 = d7bcae7ecd6b650804097efd053ecbd5 OK
2020/11/03 05:05:18 INFO  : ~leading tilde/~leading tilde.rclone_chunk.001_7kmida: Copied (server-side copy) to: ~leading tilde/~leading tilde
2020/11/03 05:05:18 INFO  : ~leading tilde/~leading tilde.rclone_chunk.001_7kmida: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_CR
    fstests.go:605: testing "␍leading CR"
2020/11/03 05:05:18 DEBUG : ␍leading CR/␍leading CR.rclone_chunk.001_7kmjmh: MD5 = e6fef73de4dd9deda48e80bc66c0d834 OK
2020/11/03 05:05:18 INFO  : ␍leading CR/␍leading CR.rclone_chunk.001_7kmjmh: Copied (server-side copy) to: ␍leading CR/␍leading CR
2020/11/03 05:05:18 INFO  : ␍leading CR/␍leading CR.rclone_chunk.001_7kmjmh: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_LF
    fstests.go:605: testing "␊leading LF"
2020/11/03 05:05:19 DEBUG : ␊leading LF/␊leading LF.rclone_chunk.001_7kmjlk: MD5 = 354be19bdc3a44b5e6f531d0c0b54618 OK
2020/11/03 05:05:19 INFO  : ␊leading LF/␊leading LF.rclone_chunk.001_7kmjlk: Copied (server-side copy) to: ␊leading LF/␊leading LF
2020/11/03 05:05:19 INFO  : ␊leading LF/␊leading LF.rclone_chunk.001_7kmjlk: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_HT
    fstests.go:605: testing "␉leading HT"
2020/11/03 05:05:19 DEBUG : ␉leading HT/␉leading HT.rclone_chunk.001_7kmkx0: MD5 = 2b19392402037a8c63aa4b8518600dee OK
2020/11/03 05:05:19 INFO  : ␉leading HT/␉leading HT.rclone_chunk.001_7kmkx0: Copied (server-side copy) to: ␉leading HT/␉leading HT
2020/11/03 05:05:19 INFO  : ␉leading HT/␉leading HT.rclone_chunk.001_7kmkx0: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_VT
    fstests.go:605: testing "␋leading VT"
2020/11/03 05:05:19 DEBUG : ␋leading VT/␋leading VT.rclone_chunk.001_7kmkt1: MD5 = 14e749d3aa32013fa4ffff47239f9047 OK
2020/11/03 05:05:19 INFO  : ␋leading VT/␋leading VT.rclone_chunk.001_7kmkt1: Copied (server-side copy) to: ␋leading VT/␋leading VT
2020/11/03 05:05:19 INFO  : ␋leading VT/␋leading VT.rclone_chunk.001_7kmkt1: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_dot
    fstests.go:605: testing ".leading dot"
2020/11/03 05:05:20 DEBUG : .leading dot/.leading dot.rclone_chunk.001_7kmlk4: MD5 = 8454609a0757ff462c643a68f07e504a OK
2020/11/03 05:05:20 INFO  : .leading dot/.leading dot.rclone_chunk.001_7kmlk4: Copied (server-side copy) to: .leading dot/.leading dot
2020/11/03 05:05:20 INFO  : .leading dot/.leading dot.rclone_chunk.001_7kmlk4: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_space
    fstests.go:605: testing "trailing space "
2020/11/03 05:05:20 DEBUG : trailing space /trailing space .rclone_chunk.001_7kml8k: MD5 = 16642cd9d076ddfa6234f78e789ea2a2 OK
2020/11/03 05:05:20 INFO  : trailing space /trailing space .rclone_chunk.001_7kml8k: Copied (server-side copy) to: trailing space /trailing space 
2020/11/03 05:05:20 INFO  : trailing space /trailing space .rclone_chunk.001_7kml8k: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_CR
    fstests.go:605: testing "trailing CR␍"
2020/11/03 05:05:21 DEBUG : trailing CR␍/trailing CR␍.rclone_chunk.001_7kmm2k: MD5 = 3785573ee2cdb9364c90d2442e77b8d4 OK
2020/11/03 05:05:21 INFO  : trailing CR␍/trailing CR␍.rclone_chunk.001_7kmm2k: Copied (server-side copy) to: trailing CR␍/trailing CR␍
2020/11/03 05:05:21 INFO  : trailing CR␍/trailing CR␍.rclone_chunk.001_7kmm2k: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_LF
    fstests.go:605: testing "trailing LF␊"
2020/11/03 05:05:21 DEBUG : trailing LF␊/trailing LF␊.rclone_chunk.001_7kmmo3: MD5 = 4eef1f32c0d392a2fb60d5a239685772 OK
2020/11/03 05:05:21 INFO  : trailing LF␊/trailing LF␊.rclone_chunk.001_7kmmo3: Copied (server-side copy) to: trailing LF␊/trailing LF␊
2020/11/03 05:05:22 INFO  : trailing LF␊/trailing LF␊.rclone_chunk.001_7kmmo3: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_HT
    fstests.go:605: testing "trailing HT␉"
2020/11/03 05:05:22 DEBUG : trailing HT␉/trailing HT␉.rclone_chunk.001_7kmnz4: MD5 = e68ed5fc110da2da73fae11a3d475123 OK
2020/11/03 05:05:22 INFO  : trailing HT␉/trailing HT␉.rclone_chunk.001_7kmnz4: Copied (server-side copy) to: trailing HT␉/trailing HT␉
2020/11/03 05:05:22 INFO  : trailing HT␉/trailing HT␉.rclone_chunk.001_7kmnz4: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_VT
    fstests.go:605: testing "trailing VT␋"
2020/11/03 05:05:22 DEBUG : trailing VT␋/trailing VT␋.rclone_chunk.001_7kmnnu: MD5 = b00d59de39737feccf568ba0b01ff3ae OK
2020/11/03 05:05:22 INFO  : trailing VT␋/trailing VT␋.rclone_chunk.001_7kmnnu: Copied (server-side copy) to: trailing VT␋/trailing VT␋
2020/11/03 05:05:22 INFO  : trailing VT␋/trailing VT␋.rclone_chunk.001_7kmnnu: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_dot
    fstests.go:605: testing "trailing dot."
2020/11/03 05:05:23 DEBUG : trailing dot./trailing dot..rclone_chunk.001_7kmong: MD5 = 8ad4d0d1089bd21b561f58697adaa498 OK
2020/11/03 05:05:23 INFO  : trailing dot./trailing dot..rclone_chunk.001_7kmong: Copied (server-side copy) to: trailing dot./trailing dot.
2020/11/03 05:05:23 INFO  : trailing dot./trailing dot..rclone_chunk.001_7kmong: Deleted
=== RUN   TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8
    fstests.go:605: testing "invalid utf-8\xfe"
2020/11/03 05:05:23 DEBUG : invalid utf-8�/invalid utf-8�.rclone_chunk.001_7kmoh2: MD5 = 720665519fc87673a3f6083aaef72a60 OK
2020/11/03 05:05:23 INFO  : invalid utf-8�/invalid utf-8�.rclone_chunk.001_7kmoh2: Copied (server-side copy) to: invalid utf-8�/invalid utf-8�
2020/11/03 05:05:23 INFO  : invalid utf-8�/invalid utf-8�.rclone_chunk.001_7kmoh2: Deleted
=== RUN   TestIntegration/FsMkdir/FsNewObjectNotFound
=== RUN   TestIntegration/FsMkdir/FsPutError
=== RUN   TestIntegration/FsMkdir/FsPutZeroLength
2020/11/03 05:05:24 DEBUG : zero-length-file.rclone_chunk.001_7kmpdy: MD5 = d41d8cd98f00b204e9800998ecf8427e OK
2020/11/03 05:05:24 INFO  : zero-length-file.rclone_chunk.001_7kmpdy: Copied (server-side copy) to: zero-length-file
2020/11/03 05:05:24 INFO  : zero-length-file.rclone_chunk.001_7kmpdy: Deleted
=== RUN   TestIntegration/FsMkdir/FsOpenWriterAt
    fstests.go:678: FS has no OpenWriterAt interface
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
    fstests.go:714: FS has no ChangeNotify interface
=== RUN   TestIntegration/FsMkdir/FsPutFiles
2020/11/03 05:05:24 DEBUG : file name.txt.rclone_chunk.001_7kmpn2: MD5 = 0d0c06fe0cca9611f3871245cfe22851 OK
2020/11/03 05:05:24 INFO  : file name.txt.rclone_chunk.001_7kmpn2: Copied (server-side copy) to: file name.txt
2020/11/03 05:05:24 INFO  : file name.txt.rclone_chunk.001_7kmpn2: Deleted
2020/11/03 05:05:25 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_7kmq5q: MD5 = acd9d60f2aa5f2bd7be9902d3bc0a684 OK
2020/11/03 05:05:25 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_7kmq5q: Copied (server-side copy) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt
2020/11/03 05:05:25 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_7kmq5q: Deleted
2020/11/03 05:05:25 DEBUG : file name.txt.rclone_chunk.001_7kmqvd: MD5 = a182d05b2f40a5f207677fc82fe20443 OK
2020/11/03 05:05:25 INFO  : file name.txt.rclone_chunk.001_7kmqvd: Copied (server-side copy) to: file name.txt
2020/11/03 05:05:25 INFO  : file name.txt.rclone_chunk.001_7kmqvd: Deleted
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2
    fstests.go:317: FS has no ListR interface
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListR
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot
2020/11/03 05:05:26 DEBUG : Creating backend with remote "TestChunkerS3:"
2020/11/03 05:05:26 DEBUG : Creating backend with remote "TestS3:"
2020/11/03 05:05:26 DEBUG : Reset feature "ListR"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot
    fstests.go:317: FS has no ListR interface
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListSubdir
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01
    fstests.go:317: FS has no ListR interface
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListLevel2
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2
    fstests.go:317: FS has no ListR interface
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListFile1
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsNewObject
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPurge
    fstests.go:985: FS has no Purge interface
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsCopy
2020/11/03 05:05:26 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: copy non-chunked object...
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsMove
    fstests.go:1056: FS has no Mover interface
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsDirMove
    fstests.go:1127: 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:1258: 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
2020/11/03 05:05:28 DEBUG : file name.txt.rclone_chunk.001_7kmskb: MD5 = 8850c54ade7b237f68437f77908dab6f OK
2020/11/03 05:05:28 INFO  : file name.txt.rclone_chunk.001_7kmskb: Copied (server-side copy) to: file name.txt
2020/11/03 05:05:28 INFO  : file name.txt.rclone_chunk.001_7kmskb: Deleted
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectStorable
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFile
2020/11/03 05:05:28 DEBUG : Creating backend with remote "TestChunkerS3:rclone-test-xogasuf9muribus1cazeval9/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"
2020/11/03 05:05:28 DEBUG : Creating backend with remote "TestS3:rclone-test-xogasuf9muribus1cazeval9/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"
2020/11/03 05:05:28 DEBUG : fs cache: adding new entry for parent of "TestS3:rclone-test-xogasuf9muribus1cazeval9/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt", "TestS3:rclone-test-xogasuf9muribus1cazeval9/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠"
2020/11/03 05:05:28 DEBUG : Reset feature "ListR"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound
2020/11/03 05:05:28 DEBUG : Creating backend with remote "TestChunkerS3:rclone-test-xogasuf9muribus1cazeval9/not found.txt"
2020/11/03 05:05:28 DEBUG : Creating backend with remote "TestS3:rclone-test-xogasuf9muribus1cazeval9/not found.txt"
2020/11/03 05:05:28 DEBUG : Reset feature "ListR"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot
    fstests.go:1401: Can't list from root on this remote
=== RUN   TestIntegration/FsMkdir/FsPutFiles/PublicLink
    fstests.go:1504: FS has no PublicLinker interface
=== RUN   TestIntegration/FsMkdir/FsPutFiles/SetTier
    fstests.go:331: FS has no SetTier & GetTier interfaces
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectRemove
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectAbout
    fstests.go:1618: FS does not support About
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPutStream
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0
2020/11/03 05:05:33 NOTICE: S3 bucket rclone-test-xogasuf9muribus1cazeval9: Streaming uploads using chunk size 5M will have maximum file size of 48.828G
2020/11/03 05:05:33 DEBUG : piped data.txt.rclone_chunk.001_7kmy3n: multipart upload starting chunk 1 size 0 offset 0/off
2020/11/03 05:05:34 INFO  : piped data.txt.rclone_chunk.001_7kmy3n: Copied (server-side copy) to: piped data.txt
2020/11/03 05:05:34 INFO  : piped data.txt.rclone_chunk.001_7kmy3n: Deleted
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100
2020/11/03 05:05:34 DEBUG : piped data.txt.rclone_chunk.001_7kmzxi: multipart upload starting chunk 1 size 100 offset 0/off
2020/11/03 05:05:34 INFO  : piped data.txt.rclone_chunk.001_7kmzxi: Copied (server-side copy) to: piped data.txt
2020/11/03 05:05:34 INFO  : piped data.txt.rclone_chunk.001_7kmzxi: Deleted
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge
    chunker_internal_test.go:670: -upload-kilobytes is not set
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat
2020/11/03 05:05:34 INFO  : Chunked 'TestChunkerS3:rclone-test-xogasuf9muribus1cazeval9': invalid data chunk number in file "fish.chunk.001"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals
2020/11/03 05:05:35 DEBUG : small/emptyfile.rclone_chunk.001_7kmzdc: MD5 = d41d8cd98f00b204e9800998ecf8427e OK
2020/11/03 05:05:35 INFO  : small/emptyfile.rclone_chunk.001_7kmzdc: Copied (server-side copy) to: small/emptyfile
2020/11/03 05:05:35 INFO  : small/emptyfile.rclone_chunk.001_7kmzdc: Deleted
2020/11/03 05:05:35 DEBUG : small/smallfile.rclone_chunk.001_7kn04o: MD5 = a60852f204ed8028c1c58808b746d115 OK
2020/11/03 05:05:35 INFO  : small/smallfile.rclone_chunk.001_7kn04o: Copied (server-side copy) to: small/smallfile
2020/11/03 05:05:35 INFO  : small/smallfile.rclone_chunk.001_7kn04o: Deleted
2020/11/03 05:05:35 DEBUG : Waiting for deletions to finish
2020/11/03 05:05:35 DEBUG : small: Removing directory
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption
    chunker_internal_test.go:440: this test requires small chunks
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow
    chunker_internal_test.go:548: this test requires small chunks
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput
2020/11/03 05:05:35 DEBUG : usermeta/today.rclone_chunk.001_7kn0qh: MD5 = f9af2f31f4e4284fb7081584cbaa97e1 OK
2020/11/03 05:05:35 INFO  : usermeta/today.rclone_chunk.001_7kn0qh: Copied (server-side copy) to: usermeta/today.rclone_chunk.001
2020/11/03 05:05:35 INFO  : usermeta/today.rclone_chunk.001_7kn0qh: Deleted
2020/11/03 05:05:36 DEBUG : usermeta/past.rclone_chunk.001_7kn1wb: MD5 = 078b72de2a9230309abb5a7db80a13c4 OK
2020/11/03 05:05:36 INFO  : usermeta/past.rclone_chunk.001_7kn1wb: Copied (server-side copy) to: usermeta/past.rclone_chunk.001
2020/11/03 05:05:36 INFO  : usermeta/past.rclone_chunk.001_7kn1wb: Deleted
2020/11/03 05:05:36 DEBUG : usermeta/future.rclone_chunk.001_7kn10p: MD5 = 82e240013837bf80c807dba600b4594d OK
2020/11/03 05:05:36 INFO  : usermeta/future.rclone_chunk.001_7kn10p: Copied (server-side copy) to: usermeta/future.rclone_chunk.001
2020/11/03 05:05:36 INFO  : usermeta/future.rclone_chunk.001_7kn10p: Deleted
2020/11/03 05:05:37 DEBUG : Waiting for deletions to finish
2020/11/03 05:05:37 DEBUG : usermeta: Removing directory
=== RUN   TestIntegration/FsMkdir/FsPutChunked
    fstests.go:1697: *chunker.Fs does not implement SetUploadChunkSizer
=== RUN   TestIntegration/FsMkdir/FsUploadUnknownSize
=== RUN   TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize
2020/11/03 05:05:37 DEBUG : unknown-size-put.txt.rclone_chunk.001_7kn2tf: multipart upload starting chunk 1 size 100 offset 0/off
2020/11/03 05:05:37 INFO  : unknown-size-put.txt.rclone_chunk.001_7kn2tf: Copied (server-side copy) to: unknown-size-put.txt
2020/11/03 05:05:37 INFO  : unknown-size-put.txt.rclone_chunk.001_7kn2tf: Deleted
=== RUN   TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize
2020/11/03 05:05:37 DEBUG : unknown-size-update.txt.rclone_chunk.001_7kn2k3: MD5 = 5ef9ed43b91b0327753c513368b41ce0 OK
2020/11/03 05:05:37 INFO  : unknown-size-update.txt.rclone_chunk.001_7kn2k3: Copied (server-side copy) to: unknown-size-update.txt
2020/11/03 05:05:38 INFO  : unknown-size-update.txt.rclone_chunk.001_7kn2k3: Deleted
2020/11/03 05:05:38 DEBUG : unknown-size-update.txt.rclone_chunk.001_7kn3eg: multipart upload starting chunk 1 size 200 offset 0/off
2020/11/03 05:05:38 INFO  : unknown-size-update.txt.rclone_chunk.001_7kn3eg: Copied (server-side copy) to: unknown-size-update.txt
2020/11/03 05:05:38 INFO  : unknown-size-update.txt.rclone_chunk.001_7kn3eg: Deleted
=== RUN   TestIntegration/FsMkdir/FsRootCollapse
2020/11/03 05:05:38 DEBUG : Creating backend with remote "TestChunkerS3:rclone-test-xogasuf9muribus1cazeval9/deeper/nonexisting/directory"
2020/11/03 05:05:38 DEBUG : Creating backend with remote "TestS3:rclone-test-xogasuf9muribus1cazeval9/deeper/nonexisting/directory"
2020/11/03 05:05:38 DEBUG : Reset feature "ListR"
2020/11/03 05:05:38 DEBUG : Waiting for deletions to finish
2020/11/03 05:05:38 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Deleted
2020/11/03 05:05:38 DEBUG : Chunked 'TestChunkerS3:rclone-test-xogasuf9muribus1cazeval9': Removing directory
2020/11/03 05:05:39 INFO  : S3 bucket rclone-test-xogasuf9muribus1cazeval9: Bucket "rclone-test-xogasuf9muribus1cazeval9" deleted
2020/11/03 05:05:39 ERROR : : error listing: directory not found
2020/11/03 05:05:39 DEBUG : Waiting for deletions to finish
2020/11/03 05:05:39 ERROR : : error listing: directory not found
2020/11/03 05:05:39 ERROR : Chunked 'TestChunkerS3:rclone-test-xogasuf9muribus1cazeval9': Failed to list "": directory not found
2020/11/03 05:05:39 DEBUG : Chunked 'TestChunkerS3:rclone-test-xogasuf9muribus1cazeval9': Removing directory
2020/11/03 05:05:39 ERROR : : Failed to rmdir: bucket already deleted
=== CONT  TestIntegration/FsMkdir
    fstests.go:1879: Warning: this should produce fs.ErrorDirNotFound
--- PASS: TestIntegration (29.02s)
    --- PASS: TestIntegration/FsCheckWrap (0.00s)
    --- SKIP: TestIntegration/FsCommand (0.00s)
    --- PASS: TestIntegration/FsRmdirNotFound (2.15s)
    --- PASS: TestIntegration/FsString (0.00s)
    --- PASS: TestIntegration/FsName (0.00s)
    --- PASS: TestIntegration/FsRoot (0.00s)
    --- PASS: TestIntegration/FsRmdirEmpty (0.23s)
    --- PASS: TestIntegration/FsMkdir (25.63s)
        --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (0.07s)
        --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.02s)
        --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.02s)
        --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.02s)
        --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsEncoding (8.61s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (0.60s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (0.42s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (0.48s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (0.49s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (0.42s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (0.45s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (0.42s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (0.43s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (0.42s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (0.49s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (0.48s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (0.52s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (0.57s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (0.43s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (0.58s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (0.41s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (0.54s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (0.44s)
        --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.07s)
        --- PASS: TestIntegration/FsMkdir/FsPutError (0.10s)
        --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (0.43s)
        --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s)
        --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsPutFiles (12.52s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (0.12s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.12s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.10s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.07s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.04s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.04s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (0.14s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.04s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (0.15s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.02s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsPurge (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (0.32s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove (0.00s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.03s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.04s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.04s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.03s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.04s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.04s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.04s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (0.13s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.04s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (0.08s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (0.06s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (0.13s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.06s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (0.51s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.05s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.08s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (5.25s)
            --- 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.04s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (0.23s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (1.07s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (0.51s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (0.56s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (2.38s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge (0.00s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat (0.01s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals (0.82s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption (0.00s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow (0.00s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput (1.54s)
        --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (1.28s)
            --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (0.46s)
            --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (0.82s)
        --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.10s)
PASS
ok  	github.com/rclone/rclone/backend/chunker	29.063s
"go test -v -timeout 1h0m0s -remote TestChunkerS3: -verbose" - Finished OK in 39.656952615s (try 1/5)