"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024" - Starting (try 1/5)
=== RUN   TestIntegration
    fstests.go:418: Using remote "TestChunkerChunk50bYandex:"
2022/02/10 06:40:39 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-lazihiz9cebuwih6wawuxak6"
2022/02/10 06:40:39 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2022/02/10 06:40:39 DEBUG : Creating backend with remote "TestYandex:rclone-test-lazihiz9cebuwih6wawuxak6"
2022/02/10 06:40:41 DEBUG : Reset feature "ListR"
=== RUN   TestIntegration/FsCheckWrap
=== RUN   TestIntegration/FsCommand
    fstests.go:487: 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
2022/02/10 06:40:44 DEBUG : dir/subdir: Making directory
2022/02/10 06:40:47 INFO  : dir/subdir: Removing directory
2022/02/10 06:40:49 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
2022/02/10 06:40:52 ERROR : does not exist: error listing: directory not found
=== 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/02/10 06:40:57 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.))
2022/02/10 06:40:57 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2022/02/10 06:40:57 DEBUG : pacer: Reducing sleep to 15ms
2022/02/10 06:40:58 DEBUG : pacer: Reducing sleep to 11.25ms
2022/02/10 06:40:58 DEBUG : pacer: Reducing sleep to 10ms
2022/02/10 06:41:02 INFO  : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_2yijpn: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001
2022/02/10 06:41:03 INFO  : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002_2yijpn: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/dot
    fstests.go:674: testing "．"
2022/02/10 06:41:27 INFO  : ．/．.rclone_chunk.001_2yj8ff: Moved (server-side) to: ．/．.rclone_chunk.001
2022/02/10 06:41:28 INFO  : ．/．.rclone_chunk.002_2yj8ff: Moved (server-side) to: ．/．.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/dot_dot
    fstests.go:674: testing "．．"
2022/02/10 06:41:48 INFO  : ．．/．．.rclone_chunk.001_2yjvqz: Moved (server-side) to: ．．/．．.rclone_chunk.001
2022/02/10 06:41:49 INFO  : ．．/．．.rclone_chunk.002_2yjvqz: Moved (server-side) to: ．．/．．.rclone_chunk.002
    fstest.go:128: 
        	Error Trace:	fstest.go:128
        	            				fstest.go:133
        	            				fstest.go:152
        	            				fstests.go:202
        	            				fstests.go:212
        	            				fstests.go:217
        	            				fstests.go:680
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsEncoding/dot_dot
        	Messages:   	．．/．．: Modification time difference too big |-8.826543041s| > 1ns (want 2022-02-10 06:41:42.173456959 +0000 UTC m=+62.332465683 vs got 2022-02-10 06:41:51 +0000 UTC) (precision 1ns)
    fstest.go:128: 
        	Error Trace:	fstest.go:128
        	            				fstest.go:133
        	            				fstest.go:152
        	            				fstests.go:205
        	            				fstests.go:212
        	            				fstests.go:217
        	            				fstests.go:680
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsEncoding/dot_dot
        	Messages:   	．．/．．: Modification time difference too big |-8.826543041s| > 1ns (want 2022-02-10 06:41:42.173456959 +0000 UTC m=+62.332465683 vs got 2022-02-10 06:41:51 +0000 UTC) (precision 1ns)
    fstest.go:128: 
        	Error Trace:	fstest.go:128
        	            				fstest.go:133
        	            				fstest.go:152
        	            				fstest.go:196
        	            				fstest.go:309
        	            				fstest.go:339
        	            				fstests.go:681
        	Error:      	Should be true
        	Test:       	TestIntegration/FsMkdir/FsEncoding/dot_dot
        	Messages:   	．．/．．: Modification time difference too big |-8.826543041s| > 1ns (want 2022-02-10 06:41:42.173456959 +0000 UTC m=+62.332465683 vs got 2022-02-10 06:41:51 +0000 UTC) (precision 1ns)
=== RUN   TestIntegration/FsMkdir/FsEncoding/punctuation
    fstests.go:674: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~"
2022/02/10 06:42:12 INFO  : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001_2ykc8p: Moved (server-side) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001
2022/02/10 06:42:13 INFO  : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.002_2ykc8p: Moved (server-side) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_space
    fstests.go:674: testing " leading space"
2022/02/10 06:42:29 INFO  :  leading space/ leading space.rclone_chunk.001_2yl06j: Moved (server-side) to:  leading space/ leading space.rclone_chunk.001
2022/02/10 06:42:30 INFO  :  leading space/ leading space.rclone_chunk.002_2yl06j: Moved (server-side) to:  leading space/ leading space.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_tilde
    fstests.go:674: testing "~leading tilde"
2022/02/10 06:42:52 INFO  : ~leading tilde/~leading tilde.rclone_chunk.001_2ylkuh: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.001
2022/02/10 06:42:54 INFO  : ~leading tilde/~leading tilde.rclone_chunk.002_2ylkuh: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_CR
    fstests.go:674: testing "␍leading CR"
2022/02/10 06:43:12 INFO  : ␍leading CR/␍leading CR.rclone_chunk.001_2ym4c7: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.001
2022/02/10 06:43:13 INFO  : ␍leading CR/␍leading CR.rclone_chunk.002_2ym4c7: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_LF
    fstests.go:674: testing "␊leading LF"
2022/02/10 06:43:33 INFO  : ␊leading LF/␊leading LF.rclone_chunk.001_2ymrf8: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.001
2022/02/10 06:43:35 INFO  : ␊leading LF/␊leading LF.rclone_chunk.002_2ymrf8: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_HT
    fstests.go:674: testing "␉leading HT"
2022/02/10 06:43:54 INFO  : ␉leading HT/␉leading HT.rclone_chunk.001_2ynbfu: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.001
2022/02/10 06:43:56 INFO  : ␉leading HT/␉leading HT.rclone_chunk.002_2ynbfu: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_VT
    fstests.go:674: testing "␋leading VT"
2022/02/10 06:44:14 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.))
2022/02/10 06:44:14 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2022/02/10 06:44:14 DEBUG : pacer: Reducing sleep to 15ms
2022/02/10 06:44:15 DEBUG : pacer: Reducing sleep to 11.25ms
2022/02/10 06:44:15 DEBUG : pacer: Reducing sleep to 10ms
2022/02/10 06:44:17 INFO  : ␋leading VT/␋leading VT.rclone_chunk.001_2ynxw4: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.001
2022/02/10 06:44:18 INFO  : ␋leading VT/␋leading VT.rclone_chunk.002_2ynxw4: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/leading_dot
    fstests.go:674: testing ".leading dot"
2022/02/10 06:44:37 INFO  : .leading dot/.leading dot.rclone_chunk.001_2yojdt: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.001
2022/02/10 06:44:38 INFO  : .leading dot/.leading dot.rclone_chunk.002_2yojdt: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_space
    fstests.go:674: testing "trailing space "
2022/02/10 06:45:05 INFO  : trailing space /trailing space .rclone_chunk.001_2yp791: Moved (server-side) to: trailing space /trailing space .rclone_chunk.001
2022/02/10 06:45:07 INFO  : trailing space /trailing space .rclone_chunk.002_2yp791: Moved (server-side) to: trailing space /trailing space .rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_CR
    fstests.go:674: testing "trailing CR␍"
2022/02/10 06:45:33 INFO  : trailing CR␍/trailing CR␍.rclone_chunk.001_2ypyu7: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.001
2022/02/10 06:45:34 INFO  : trailing CR␍/trailing CR␍.rclone_chunk.002_2ypyu7: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.002
2022/02/10 06:45:37 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.))
2022/02/10 06:45:37 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2022/02/10 06:45:38 DEBUG : pacer: Reducing sleep to 15ms
2022/02/10 06:45:38 DEBUG : pacer: Reducing sleep to 11.25ms
2022/02/10 06:45:38 DEBUG : pacer: Reducing sleep to 10ms
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_LF
    fstests.go:674: testing "trailing LF␊"
2022/02/10 06:45:54 INFO  : trailing LF␊/trailing LF␊.rclone_chunk.001_2yqmjk: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.001
2022/02/10 06:45:55 INFO  : trailing LF␊/trailing LF␊.rclone_chunk.002_2yqmjk: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_HT
    fstests.go:674: testing "trailing HT␉"
2022/02/10 06:46:16 INFO  : trailing HT␉/trailing HT␉.rclone_chunk.001_2yr9pw: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.001
2022/02/10 06:46:18 INFO  : trailing HT␉/trailing HT␉.rclone_chunk.002_2yr9pw: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_VT
    fstests.go:674: testing "trailing VT␋"
2022/02/10 06:46:30 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.))
2022/02/10 06:46:30 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2022/02/10 06:46:31 DEBUG : pacer: Reducing sleep to 15ms
2022/02/10 06:46:31 DEBUG : pacer: Reducing sleep to 11.25ms
2022/02/10 06:46:32 DEBUG : pacer: Reducing sleep to 10ms
2022/02/10 06:46:36 INFO  : trailing VT␋/trailing VT␋.rclone_chunk.001_2yrt6m: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.001
2022/02/10 06:46:37 INFO  : trailing VT␋/trailing VT␋.rclone_chunk.002_2yrt6m: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/trailing_dot
    fstests.go:674: testing "trailing dot."
2022/02/10 06:46:57 INFO  : trailing dot./trailing dot..rclone_chunk.001_2ysdl7: Moved (server-side) to: trailing dot./trailing dot..rclone_chunk.001
2022/02/10 06:46:59 INFO  : trailing dot./trailing dot..rclone_chunk.002_2ysdl7: Moved (server-side) to: trailing dot./trailing dot..rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8
    fstests.go:674: testing "invalid utf-8\xfe"
2022/02/10 06:47:18 INFO  : invalid utf-8�/invalid utf-8�.rclone_chunk.001_2ysyzx: Moved (server-side) to: invalid utf-8�/invalid utf-8�.rclone_chunk.001
2022/02/10 06:47:19 INFO  : invalid utf-8�/invalid utf-8�.rclone_chunk.002_2ysyzx: Moved (server-side) to: invalid utf-8�/invalid utf-8�.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsEncoding/URL_encoding
    fstests.go:674: testing "test%46.txt"
2022/02/10 06:47:32 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.))
2022/02/10 06:47:32 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2022/02/10 06:47:32 DEBUG : pacer: Reducing sleep to 15ms
2022/02/10 06:47:32 DEBUG : pacer: Reducing sleep to 11.25ms
2022/02/10 06:47:33 DEBUG : pacer: Reducing sleep to 10ms
2022/02/10 06:47:36 INFO  : test%46.txt/test%46.txt.rclone_chunk.001_2ytihi: Moved (server-side) to: test%46.txt/test%46.txt.rclone_chunk.001
2022/02/10 06:47:38 INFO  : test%46.txt/test%46.txt.rclone_chunk.002_2ytihi: Moved (server-side) to: test%46.txt/test%46.txt.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsNewObjectNotFound
=== RUN   TestIntegration/FsMkdir/FsPutError
    fstests.go:714: Reduce file size due to limit 1024
2022/02/10 06:47:56 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.))
2022/02/10 06:47:56 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2022/02/10 06:47:57 DEBUG : pacer: Reducing sleep to 15ms
2022/02/10 06:47:58 DEBUG : pacer: Reducing sleep to 11.25ms
2022/02/10 06:47:58 DEBUG : pacer: Reducing sleep to 10ms
2022/02/10 06:48:46 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.))
2022/02/10 06:48:46 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2022/02/10 06:48:47 DEBUG : pacer: Reducing sleep to 15ms
2022/02/10 06:48:47 DEBUG : pacer: Reducing sleep to 11.25ms
2022/02/10 06:48:47 DEBUG : pacer: Reducing sleep to 10ms
=== RUN   TestIntegration/FsMkdir/FsPutZeroLength
2022/02/10 06:49:25 INFO  : zero-length-file.rclone_chunk.001_2ywhw5: Moved (server-side) to: zero-length-file
=== 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/02/10 06:49:37 INFO  : file name.txt.rclone_chunk.001_2ywshl: Moved (server-side) to: file name.txt.rclone_chunk.001
2022/02/10 06:49:39 INFO  : file name.txt.rclone_chunk.002_2ywshl: Moved (server-side) to: file name.txt.rclone_chunk.002
2022/02/10 06:49:49 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.))
2022/02/10 06:49:49 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2022/02/10 06:49:49 DEBUG : pacer: Reducing sleep to 15ms
2022/02/10 06:49:49 DEBUG : pacer: Reducing sleep to 11.25ms
2022/02/10 06:49:50 DEBUG : pacer: Reducing sleep to 10ms
2022/02/10 06:49:54 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_2yxb0f: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001
2022/02/10 06:49:55 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002_2yxb0f: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002
2022/02/10 06:50:11 INFO  : file name.txt.rclone_chunk.001_2yxq7d: Moved (server-side) to: file name.txt.rclone_chunk.001
2022/02/10 06:50:13 INFO  : file name.txt.rclone_chunk.002_2yxq7d: Moved (server-side) to: file name.txt.rclone_chunk.002
=== 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/02/10 06:50:20 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:"
2022/02/10 06:50:20 DEBUG : Config file has changed externaly - reloading
2022/02/10 06:50:20 DEBUG : Creating backend with remote "TestYandex:"
2022/02/10 06:50:21 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
2022/02/10 06:50:37 INFO  : dirToPurge/fileToPurge.txt.rclone_chunk.001_2yyfru: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.001
2022/02/10 06:50:39 INFO  : dirToPurge/fileToPurge.txt.rclone_chunk.002_2yyfru: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsCopy
2022/02/10 06:50:50 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: copy 2 data chunks...
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsMove
2022/02/10 06:51:05 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: move 2 data chunks...
2022/02/10 06:51:07 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001: Moved (server-side) to: other.txt.rclone_chunk.001
2022/02/10 06:51:08 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002: Moved (server-side) to: other.txt.rclone_chunk.002
2022/02/10 06:51:10 INFO  : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Moved (server-side) to: other.txt
2022/02/10 06:51:15 DEBUG : file name.txt: move 2 data chunks...
2022/02/10 06:51:16 INFO  : file name.txt.rclone_chunk.001: Moved (server-side) to: moveTest/other.txt.rclone_chunk.001
2022/02/10 06:51:16 INFO  : file name.txt.rclone_chunk.002: Moved (server-side) to: moveTest/other.txt.rclone_chunk.002
2022/02/10 06:51:18 INFO  : file name.txt: Moved (server-side) to: moveTest/other.txt
2022/02/10 06:51:22 DEBUG : moveTest/other.txt: move 2 data chunks...
2022/02/10 06:51:24 INFO  : moveTest/other.txt.rclone_chunk.001: Moved (server-side) to: file name.txt.rclone_chunk.001
2022/02/10 06:51:25 INFO  : moveTest/other.txt.rclone_chunk.002: Moved (server-side) to: file name.txt.rclone_chunk.002
2022/02/10 06:51:26 INFO  : moveTest/other.txt: Moved (server-side) to: file name.txt
2022/02/10 06:51:33 DEBUG : other.txt: move 2 data chunks...
2022/02/10 06:51:35 INFO  : other.txt.rclone_chunk.001: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001
2022/02/10 06:51:36 INFO  : other.txt.rclone_chunk.002: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002
2022/02/10 06:51:38 INFO  : other.txt: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsDirMove
2022/02/10 06:51:47 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-kobogic0hosulew9tuxozed1"
2022/02/10 06:51:47 DEBUG : Creating backend with remote "TestYandex:rclone-test-kobogic0hosulew9tuxozed1"
2022/02/10 06:51:47 DEBUG : Reset feature "ListR"
2022/02/10 06:52:02 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-kobogic0hosulew9tuxozed1': 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
    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/02/10 06:52:29 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.))
2022/02/10 06:52:29 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2022/02/10 06:52:29 DEBUG : pacer: Reducing sleep to 15ms
2022/02/10 06:52:29 DEBUG : pacer: Reducing sleep to 11.25ms
2022/02/10 06:52:29 DEBUG : pacer: Reducing sleep to 10ms
2022/02/10 06:52:35 INFO  : file name.txt.rclone_chunk.001_2z1ifs: Moved (server-side) to: file name.txt.rclone_chunk.001
2022/02/10 06:52:37 INFO  : file name.txt.rclone_chunk.002_2z1ifs: Moved (server-side) to: file name.txt.rclone_chunk.002
2022/02/10 06:52:38 INFO  : file name.txt.rclone_chunk.003_2z1ifs: Moved (server-side) to: file name.txt.rclone_chunk.003
2022/02/10 06:52:39 INFO  : file name.txt.rclone_chunk.004_2z1ifs: Moved (server-side) to: file name.txt.rclone_chunk.004
=== RUN   TestIntegration/FsMkdir/FsPutFiles/ObjectStorable
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFile
2022/02/10 06:52:50 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-lazihiz9cebuwih6wawuxak6/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"
2022/02/10 06:52:50 DEBUG : Creating backend with remote "TestYandex:rclone-test-lazihiz9cebuwih6wawuxak6/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt"
2022/02/10 06:52:50 DEBUG : fs cache: adding new entry for parent of "TestYandex:rclone-test-lazihiz9cebuwih6wawuxak6/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt", "TestYandex:rclone-test-lazihiz9cebuwih6wawuxak6/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠"
2022/02/10 06:52:50 DEBUG : Reset feature "ListR"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound
2022/02/10 06:52:51 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-lazihiz9cebuwih6wawuxak6/not found.txt"
2022/02/10 06:52:51 DEBUG : Creating backend with remote "TestYandex:rclone-test-lazihiz9cebuwih6wawuxak6/not found.txt"
2022/02/10 06:52:52 DEBUG : Reset feature "ListR"
2022/02/10 06:52:52 ERROR : : error listing: directory not found
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot
    fstests.go:1503: Opening root remote "TestChunkerChunk50bYandex:" path "rclone-test-lazihiz9cebuwih6wawuxak6" from "TestChunkerChunk50bYandex:rclone-test-lazihiz9cebuwih6wawuxak6"
2022/02/10 06:52:52 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:"
2022/02/10 06:52:52 DEBUG : Reset feature "ListR"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot/List
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR
    fstests.go:1537: FS has no ListR interface
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put
2022/02/10 06:53:04 INFO  : rclone-test-lazihiz9cebuwih6wawuxak6/created from root.txt.rclone_chunk.001_2z2mgl: Moved (server-side) to: rclone-test-lazihiz9cebuwih6wawuxak6/created from root.txt.rclone_chunk.001
2022/02/10 06:53:06 INFO  : rclone-test-lazihiz9cebuwih6wawuxak6/created from root.txt.rclone_chunk.002_2z2mgl: Moved (server-side) to: rclone-test-lazihiz9cebuwih6wawuxak6/created from root.txt.rclone_chunk.002
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove
=== 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
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPutStream
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0
2022/02/10 06:53:30 INFO  : piped data.txt.rclone_chunk.001_2z3gf6: Moved (server-side) to: piped data.txt
=== RUN   TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100
2022/02/10 06:53:41 INFO  : piped data.txt.rclone_chunk.001_2z3k7n: Moved (server-side) to: piped data.txt.rclone_chunk.001
2022/02/10 06:53:43 INFO  : piped data.txt.rclone_chunk.002_2z3k7n: Moved (server-side) to: piped data.txt.rclone_chunk.002
2022/02/10 06:53:45 INFO  : piped data.txt.rclone_chunk.003_2z3k7n: Moved (server-side) to: piped data.txt.rclone_chunk.003
=== 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/02/10 06:53:54 INFO  : Chunked 'TestChunkerChunk50bYandex:rclone-test-lazihiz9cebuwih6wawuxak6': invalid data chunk number in file "fish.chunk.001"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals
2022/02/10 06:54:21 ERROR : small/emptyfile.rclone_chunk.001_2z47sx: Couldn't move: couldn't move file: [500 - InternalServerError] Internal Server Error (Ошибка сервера.)
2022/02/10 06:54:22 ERROR : small/emptyfile.rclone_chunk.001_2z47sx: Failed to remove temporary chunk: [404 - DiskNotFoundError] Resource not found. (Не удалось найти запрошенный ресурс.)
    fstests.go:153: 
        	Error Trace:	fstests.go:153
        	            				fstests.go:187
        	            				fstests.go:212
        	            				chunker_internal_test.go:443
        	            				chunker_internal_test.go:461
        	            				chunker_internal_test.go:914
        	Error:      	Received unexpected error:
        	            	couldn't move file: [500 - InternalServerError] Internal Server Error (Ошибка сервера.)
        	Test:       	TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals
        	Messages:   	Put
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption
2022/02/10 06:54:41 INFO  : corrupted/billy.rclone_chunk.001_2z514s: Moved (server-side) to: corrupted/billy.rclone_chunk.001
2022/02/10 06:54:42 INFO  : corrupted/billy.rclone_chunk.002_2z514s: Moved (server-side) to: corrupted/billy.rclone_chunk.002
2022/02/10 06:54:46 INFO  : corrupted/billy.rclone_chunk.003_2z514s: Moved (server-side) to: corrupted/billy.rclone_chunk.003
2022/02/10 06:54:47 INFO  : corrupted/billy.rclone_chunk.004_2z514s: Moved (server-side) to: corrupted/billy.rclone_chunk.004
2022/02/10 06:54:48 INFO  : corrupted/billy.rclone_chunk.005_2z514s: Moved (server-side) to: corrupted/billy.rclone_chunk.005
2022/02/10 06:55:06 INFO  : corrupted/silly1.rclone_chunk.001_2z5s3l: Moved (server-side) to: corrupted/silly1.rclone_chunk.001
2022/02/10 06:55:14 INFO  : corrupted/silly1.rclone_chunk.002_2z5s3l: Moved (server-side) to: corrupted/silly1.rclone_chunk.002
2022/02/10 06:55:15 INFO  : corrupted/silly1.rclone_chunk.003_2z5s3l: Moved (server-side) to: corrupted/silly1.rclone_chunk.003
2022/02/10 06:55:17 INFO  : corrupted/silly1.rclone_chunk.004_2z5s3l: Moved (server-side) to: corrupted/silly1.rclone_chunk.004
2022/02/10 06:55:18 INFO  : corrupted/silly1.rclone_chunk.005_2z5s3l: Moved (server-side) to: corrupted/silly1.rclone_chunk.005
2022/02/10 06:55:36 INFO  : corrupted/silly2.rclone_chunk.001_2z6ndw: Moved (server-side) to: corrupted/silly2.rclone_chunk.001
2022/02/10 06:55:37 INFO  : corrupted/silly2.rclone_chunk.002_2z6ndw: Moved (server-side) to: corrupted/silly2.rclone_chunk.002
2022/02/10 06:55:41 INFO  : corrupted/silly2.rclone_chunk.003_2z6ndw: Moved (server-side) to: corrupted/silly2.rclone_chunk.003
2022/02/10 06:55:43 INFO  : corrupted/silly2.rclone_chunk.004_2z6ndw: Moved (server-side) to: corrupted/silly2.rclone_chunk.004
2022/02/10 06:55:44 INFO  : corrupted/silly2.rclone_chunk.005_2z6ndw: Moved (server-side) to: corrupted/silly2.rclone_chunk.005
2022/02/10 06:56:12 INFO  : corrupted/silly3.rclone_chunk.001_2z7k3w: Moved (server-side) to: corrupted/silly3.rclone_chunk.001
2022/02/10 06:56:13 INFO  : corrupted/silly3.rclone_chunk.002_2z7k3w: Moved (server-side) to: corrupted/silly3.rclone_chunk.002
2022/02/10 06:56:15 INFO  : corrupted/silly3.rclone_chunk.003_2z7k3w: Moved (server-side) to: corrupted/silly3.rclone_chunk.003
2022/02/10 06:56:16 INFO  : corrupted/silly3.rclone_chunk.004_2z7k3w: Moved (server-side) to: corrupted/silly3.rclone_chunk.004
2022/02/10 06:56:18 INFO  : corrupted/silly3.rclone_chunk.005_2z7k3w: Moved (server-side) to: corrupted/silly3.rclone_chunk.005
2022/02/10 06:56:51 INFO  : corrupted/willy.rclone_chunk.001_2z8n67: Moved (server-side) to: corrupted/willy.rclone_chunk.001
2022/02/10 06:56:52 INFO  : corrupted/willy.rclone_chunk.002_2z8n67: Moved (server-side) to: corrupted/willy.rclone_chunk.002
2022/02/10 06:56:53 INFO  : corrupted/willy.rclone_chunk.003_2z8n67: Moved (server-side) to: corrupted/willy.rclone_chunk.003
2022/02/10 06:56:54 INFO  : corrupted/willy.rclone_chunk.004_2z8n67: Moved (server-side) to: corrupted/willy.rclone_chunk.004
2022/02/10 06:56:56 INFO  : corrupted/willy.rclone_chunk.005_2z8n67: Moved (server-side) to: corrupted/willy.rclone_chunk.005
2022/02/10 06:57:13 INFO  : corrupted/silly4.rclone_chunk.001_2z9d8l: Moved (server-side) to: corrupted/silly4.rclone_chunk.001
2022/02/10 06:57:14 INFO  : corrupted/silly4.rclone_chunk.002_2z9d8l: Moved (server-side) to: corrupted/silly4.rclone_chunk.002
2022/02/10 06:57:16 INFO  : corrupted/silly4.rclone_chunk.003_2z9d8l: Moved (server-side) to: corrupted/silly4.rclone_chunk.003
2022/02/10 06:57:17 INFO  : corrupted/silly4.rclone_chunk.004_2z9d8l: Moved (server-side) to: corrupted/silly4.rclone_chunk.004
2022/02/10 06:57:18 INFO  : corrupted/silly4.rclone_chunk.005_2z9d8l: Moved (server-side) to: corrupted/silly4.rclone_chunk.005
2022/02/10 06:57:22 ERROR : corrupted/silly4: Failed to copy: can't copy: chunk overlap with "corrupted/willy"
2022/02/10 06:57:35 INFO  : corrupted/silly5.rclone_chunk.001_2z9znf: Moved (server-side) to: corrupted/silly5.rclone_chunk.001
2022/02/10 06:57:37 INFO  : corrupted/silly5.rclone_chunk.002_2z9znf: Moved (server-side) to: corrupted/silly5.rclone_chunk.002
2022/02/10 06:57:38 INFO  : corrupted/silly5.rclone_chunk.003_2z9znf: Moved (server-side) to: corrupted/silly5.rclone_chunk.003
2022/02/10 06:57:39 INFO  : corrupted/silly5.rclone_chunk.004_2z9znf: Moved (server-side) to: corrupted/silly5.rclone_chunk.004
2022/02/10 06:57:41 INFO  : corrupted/silly5.rclone_chunk.005_2z9znf: Moved (server-side) to: corrupted/silly5.rclone_chunk.005
2022/02/10 06:57:44 ERROR : corrupted/willy.rclone_chunk.002: Couldn't delete: refuse to corrupt: chunk overlap with "corrupted/willy"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow
2022/02/10 06:58:01 INFO  : wreaked/wreaker.rclone_chunk.001_2zawuk: Moved (server-side) to: wreaked/wreaker.rclone_chunk.001
2022/02/10 06:58:03 INFO  : wreaked/wreaker.rclone_chunk.002_2zawuk: Moved (server-side) to: wreaked/wreaker.rclone_chunk.002
2022/02/10 06:58:18 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lazihiz9cebuwih6wawuxak6': invalid directory entry "wreaked/wreaker"
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput
2022/02/10 06:58:30 ERROR : usermeta/today.rclone_chunk.001_2zbr9p: Couldn't move: couldn't move file: [409 - DiskResourceAlreadyExistsError] Resource "disk:/rclone-test-lazihiz9cebuwih6wawuxak6/usermeta/today.rclone_chunk.001" already exists. (Ресурс "disk:/rclone-test-lazihiz9cebuwih6wawuxak6/usermeta/today.rclone_chunk.001" уже существует.)
2022/02/10 06:58:31 INFO  : usermeta/today.rclone_chunk.001: Deleted
2022/02/10 06:58:33 INFO  : usermeta/today.rclone_chunk.001_2zbr9p: Moved (server-side) to: usermeta/today.rclone_chunk.001
2022/02/10 06:58:45 ERROR : usermeta/past.rclone_chunk.001_2zc608: Couldn't move: couldn't move file: [409 - DiskResourceAlreadyExistsError] Resource "disk:/rclone-test-lazihiz9cebuwih6wawuxak6/usermeta/past.rclone_chunk.001" already exists. (Ресурс "disk:/rclone-test-lazihiz9cebuwih6wawuxak6/usermeta/past.rclone_chunk.001" уже существует.)
2022/02/10 06:58:46 INFO  : usermeta/past.rclone_chunk.001: Deleted
2022/02/10 06:58:48 INFO  : usermeta/past.rclone_chunk.001_2zc608: Moved (server-side) to: usermeta/past.rclone_chunk.001
2022/02/10 06:58:59 ERROR : usermeta/future.rclone_chunk.001_2zckv2: Couldn't move: couldn't move file: [409 - DiskResourceAlreadyExistsError] Resource "disk:/rclone-test-lazihiz9cebuwih6wawuxak6/usermeta/future.rclone_chunk.001" already exists. (Ресурс "disk:/rclone-test-lazihiz9cebuwih6wawuxak6/usermeta/future.rclone_chunk.001" уже существует.)
2022/02/10 06:59:01 INFO  : usermeta/future.rclone_chunk.001: Deleted
2022/02/10 06:59:02 INFO  : usermeta/future.rclone_chunk.001_2zckv2: Moved (server-side) to: usermeta/future.rclone_chunk.001
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof
2022/02/10 06:59:29 DEBUG : future/test: Can't move - required hash not found
2022/02/10 06:59:29 DEBUG : future/test: Can't move, switching to copy
2022/02/10 06:59:29 DEBUG : future/test: Can't copy - required hash not found
2022/02/10 06:59:30 ERROR : future/test: Failed to copy: failed to open source object: can't open: unknown metadata, please upgrade rclone
2022/02/10 06:59:30 ERROR : future/test: Not deleting source as copy failed: failed to open source object: can't open: unknown metadata, please upgrade rclone
2022/02/10 06:59:31 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-lazihiz9cebuwih6wawuxak6': File to upload is small (3 bytes), uploading instead of streaming
2022/02/10 06:59:35 ERROR : future/test: Failed to copy: refusing to put: unknown metadata, please upgrade rclone
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility
2022/02/10 06:59:48 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.))
2022/02/10 06:59:48 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2022/02/10 06:59:49 DEBUG : pacer: Reducing sleep to 15ms
2022/02/10 06:59:49 DEBUG : pacer: Reducing sleep to 11.25ms
2022/02/10 06:59:49 DEBUG : pacer: Reducing sleep to 10ms
2022/02/10 07:00:22 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.))
2022/02/10 07:00:22 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2022/02/10 07:00:22 DEBUG : pacer: Reducing sleep to 15ms
2022/02/10 07:00:23 DEBUG : pacer: Reducing sleep to 11.25ms
2022/02/10 07:00:23 DEBUG : pacer: Reducing sleep to 10ms
2022/02/10 07:00:42 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.))
2022/02/10 07:00:42 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2022/02/10 07:00:42 DEBUG : pacer: Reducing sleep to 15ms
2022/02/10 07:00:42 DEBUG : pacer: Reducing sleep to 11.25ms
2022/02/10 07:00:43 DEBUG : pacer: Reducing sleep to 10ms
2022/02/10 07:00:58 INFO  : backcomp/renamefile.rclone_chunk.001_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.001
2022/02/10 07:01:00 INFO  : backcomp/renamefile.rclone_chunk.002_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.002
2022/02/10 07:01:01 INFO  : backcomp/renamefile.rclone_chunk.003_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.003
2022/02/10 07:01:02 INFO  : backcomp/renamefile.rclone_chunk.004_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.004
2022/02/10 07:01:04 INFO  : backcomp/renamefile.rclone_chunk.005_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.005
2022/02/10 07:01:06 INFO  : backcomp/renamefile.rclone_chunk.006_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.006
2022/02/10 07:01:07 INFO  : backcomp/renamefile.rclone_chunk.007_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.007
2022/02/10 07:01:09 INFO  : backcomp/renamefile.rclone_chunk.008_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.008
2022/02/10 07:01:10 INFO  : backcomp/renamefile.rclone_chunk.009_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.009
2022/02/10 07:01:11 INFO  : backcomp/renamefile.rclone_chunk.010_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.010
2022/02/10 07:01:13 INFO  : backcomp/renamefile.rclone_chunk.011_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.011
2022/02/10 07:01:18 INFO  : backcomp/renamefile.rclone_chunk.012_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.012
2022/02/10 07:01:19 INFO  : backcomp/renamefile.rclone_chunk.013_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.013
2022/02/10 07:01:21 INFO  : backcomp/renamefile.rclone_chunk.014_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.014
2022/02/10 07:01:22 INFO  : backcomp/renamefile.rclone_chunk.015_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.015
2022/02/10 07:01:24 INFO  : backcomp/renamefile.rclone_chunk.016_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.016
2022/02/10 07:01:26 INFO  : backcomp/renamefile.rclone_chunk.017_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.017
2022/02/10 07:01:27 INFO  : backcomp/renamefile.rclone_chunk.018_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.018
2022/02/10 07:01:29 INFO  : backcomp/renamefile.rclone_chunk.019_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.019
2022/02/10 07:01:30 INFO  : backcomp/renamefile.rclone_chunk.020_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.020
2022/02/10 07:01:31 INFO  : backcomp/renamefile.rclone_chunk.021_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.021
2022/02/10 07:01:34 INFO  : backcomp/renamefile.rclone_chunk.022_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.022
2022/02/10 07:01:35 INFO  : backcomp/renamefile.rclone_chunk.023_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.023
2022/02/10 07:01:36 INFO  : backcomp/renamefile.rclone_chunk.024_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.024
2022/02/10 07:01:38 INFO  : backcomp/renamefile.rclone_chunk.025_2zdt73: Moved (server-side) to: backcomp/renamefile.rclone_chunk.025
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove
2022/02/10 07:02:12 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-lazihiz9cebuwih6wawuxak6/servermovetest/subdir1"
2022/02/10 07:02:12 DEBUG : Creating backend with remote "TestYandex:rclone-test-lazihiz9cebuwih6wawuxak6/servermovetest/subdir1"
2022/02/10 07:02:13 DEBUG : Reset feature "ListR"
2022/02/10 07:02:13 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-lazihiz9cebuwih6wawuxak6/servermovetest/subdir2"
2022/02/10 07:02:13 DEBUG : Creating backend with remote "TestYandex:rclone-test-lazihiz9cebuwih6wawuxak6/servermovetest/subdir2"
2022/02/10 07:02:13 DEBUG : Reset feature "ListR"
2022/02/10 07:02:21 INFO  : movefile.rclone_chunk.001_2zi2p7: Moved (server-side) to: movefile.rclone_chunk.001
2022/02/10 07:02:22 INFO  : movefile.rclone_chunk.002_2zi2p7: Moved (server-side) to: movefile.rclone_chunk.002
2022/02/10 07:02:26 DEBUG : movefile: move 2 data chunks...
2022/02/10 07:02:27 INFO  : movefile.rclone_chunk.001: Moved (server-side)
2022/02/10 07:02:29 INFO  : movefile.rclone_chunk.002: Moved (server-side)
2022/02/10 07:02:32 INFO  : movefile: Moved (server-side)
2022/02/10 07:02:37 INFO  : movefile: Moved (server-side)
=== RUN   TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow
2022/02/10 07:02:42 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex,chunk_size='1P',hash_type='md5all',meta_format='simplejson',name_format='*.#',transactions='rename':rclone-test-lazihiz9cebuwih6wawuxak6/md5all"
2022/02/10 07:02:42 DEBUG : TestChunkerChunk50bYandex: detected overridden config - adding "{r7Izf}" suffix to name
2022/02/10 07:02:42 DEBUG : Creating backend with remote "TestYandex:rclone-test-lazihiz9cebuwih6wawuxak6/md5all"
2022/02/10 07:02:42 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/02/10 07:02:51 INFO  : unknown-size-put.txt.rclone_chunk.001_2zivx9: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.001
2022/02/10 07:02:52 INFO  : unknown-size-put.txt.rclone_chunk.002_2zivx9: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.002
2022/02/10 07:02:53 INFO  : unknown-size-put.txt.rclone_chunk.003_2zivx9: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.003
=== RUN   TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize
2022/02/10 07:03:08 INFO  : unknown-size-update.txt.rclone_chunk.001_2zjemu: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001
2022/02/10 07:03:09 INFO  : unknown-size-update.txt.rclone_chunk.002_2zjemu: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002
2022/02/10 07:03:28 INFO  : unknown-size-update.txt.rclone_chunk.001_2zjrln: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001
2022/02/10 07:03:30 INFO  : unknown-size-update.txt.rclone_chunk.002_2zjrln: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002
2022/02/10 07:03:31 INFO  : unknown-size-update.txt.rclone_chunk.003_2zjrln: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.003
2022/02/10 07:03:33 INFO  : unknown-size-update.txt.rclone_chunk.004_2zjrln: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.004
2022/02/10 07:03:38 INFO  : unknown-size-update.txt.rclone_chunk.005_2zjrln: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.005
=== RUN   TestIntegration/FsMkdir/FsRootCollapse
2022/02/10 07:03:47 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-lazihiz9cebuwih6wawuxak6/deeper/nonexisting/directory"
2022/02/10 07:03:47 DEBUG : Creating backend with remote "TestYandex:rclone-test-lazihiz9cebuwih6wawuxak6/deeper/nonexisting/directory"
2022/02/10 07:03:47 DEBUG : Reset feature "ListR"
2022/02/10 07:03:51 ERROR : : error listing: directory not found
=== CONT  TestIntegration/FsMkdir
    fstests.go:1989: Warning: this should produce fs.ErrorDirNotFound
=== RUN   TestIntegration/FsShutdown
    fstests.go:2003: Shutdown method not supported
--- FAIL: TestIntegration (1392.19s)
    --- PASS: TestIntegration/FsCheckWrap (0.00s)
    --- SKIP: TestIntegration/FsCommand (0.00s)
    --- PASS: TestIntegration/FsRmdirNotFound (0.47s)
    --- PASS: TestIntegration/FsString (0.00s)
    --- PASS: TestIntegration/FsName (0.00s)
    --- PASS: TestIntegration/FsRoot (0.00s)
    --- PASS: TestIntegration/FsRmdirEmpty (0.93s)
    --- FAIL: TestIntegration/FsMkdir (1388.17s)
        --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (6.81s)
        --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.54s)
        --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.47s)
        --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.43s)
        --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s)
        --- FAIL: TestIntegration/FsMkdir/FsEncoding (414.81s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (25.45s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (22.92s)
            --- FAIL: TestIntegration/FsMkdir/FsEncoding/dot_dot (16.78s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (24.15s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (19.70s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (20.86s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (22.72s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (17.72s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (23.44s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (22.67s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (23.48s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (27.67s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (23.88s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (22.78s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (20.00s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (19.48s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (21.45s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (19.71s)
            --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (19.47s)
        --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.38s)
        --- PASS: TestIntegration/FsMkdir/FsPutError (88.55s)
        --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (10.45s)
        --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s)
        --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s)
        --- FAIL: TestIntegration/FsMkdir/FsPutFiles (795.13s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.23s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (1.15s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.78s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.51s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.50s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.50s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (1.53s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.85s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (1.77s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.21s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (22.90s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (15.11s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (42.50s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (17.20s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.27s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.44s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.49s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.49s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.69s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.43s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.54s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (2.01s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.43s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (1.54s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (1.65s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (2.04s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (1.11s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (32.92s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.51s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (1.50s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.94s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (24.43s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (3.04s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.96s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (20.43s)
                    --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (5.23s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s)
            --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.58s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (9.48s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.10s)
            --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (27.73s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (4.60s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (23.13s)
            --- FAIL: TestIntegration/FsMkdir/FsPutFiles/Internal (527.48s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge (0.00s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat (0.00s)
                --- FAIL: TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals (29.15s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption (211.31s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow (29.37s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput (47.19s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof (28.07s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility (153.07s)
                --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove (29.12s)
                --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow (0.19s)
        --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s)
        --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (65.13s)
            --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (18.55s)
            --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (46.59s)
        --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.35s)
    --- SKIP: TestIntegration/FsShutdown (0.00s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	1392.221s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024" - Finished ERROR in 23m14.563290282s (try 1/5): exit status 1: Failed [TestIntegration/FsMkdir/FsEncoding/dot_dot TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals]