"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024" - Starting (try 1/5) === RUN TestIntegration fstests.go:418: Using remote "TestChunkerChunk50bYandex:" 2022/01/09 06:08:22 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-warereb9mulupij4bemaduk4" 2022/01/09 06:08:22 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2022/01/09 06:08:22 DEBUG : Creating backend with remote "TestYandex:rclone-test-warereb9mulupij4bemaduk4" 2022/01/09 06:08:22 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/01/09 06:08:25 DEBUG : dir/subdir: Making directory 2022/01/09 06:08:27 INFO : dir/subdir: Removing directory 2022/01/09 06:08:29 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/01/09 06:08:31 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/01/09 06:08:38 INFO : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_fno7v2: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001 2022/01/09 06:08:40 INFO : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002_fno7v2: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002 2022/01/09 06:08:42 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2022/01/09 06:08:42 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2022/01/09 06:08:42 DEBUG : pacer: Reducing sleep to 15ms 2022/01/09 06:08:42 DEBUG : pacer: Reducing sleep to 11.25ms 2022/01/09 06:08:43 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:674: testing "．" 2022/01/09 06:08:55 INFO : ．/．.rclone_chunk.001_fnoo9a: Moved (server-side) to: ．/．.rclone_chunk.001 2022/01/09 06:08:56 INFO : ．/．.rclone_chunk.002_fnoo9a: Moved (server-side) to: ．/．.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:674: testing "．．" 2022/01/09 06:09:11 INFO : ．．/．．.rclone_chunk.001_fnp39d: Moved (server-side) to: ．．/．．.rclone_chunk.001 2022/01/09 06:09:12 INFO : ．．/．．.rclone_chunk.002_fnp39d: Moved (server-side) to: ．．/．．.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:674: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2022/01/09 06:09:25 INFO : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001_fnphkg: Moved (server-side) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001 2022/01/09 06:09:26 INFO : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.002_fnphkg: Moved (server-side) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:674: testing " leading space" 2022/01/09 06:09:41 INFO : leading space/ leading space.rclone_chunk.001_fnpy74: Moved (server-side) to: leading space/ leading space.rclone_chunk.001 2022/01/09 06:09:42 INFO : leading space/ leading space.rclone_chunk.002_fnpy74: Moved (server-side) to: leading space/ leading space.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:674: testing "~leading tilde" 2022/01/09 06:09:57 INFO : ~leading tilde/~leading tilde.rclone_chunk.001_fnqe39: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.001 2022/01/09 06:09:58 INFO : ~leading tilde/~leading tilde.rclone_chunk.002_fnqe39: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:674: testing "␍leading CR" 2022/01/09 06:10:13 INFO : ␍leading CR/␍leading CR.rclone_chunk.001_fnquc6: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.001 2022/01/09 06:10:14 INFO : ␍leading CR/␍leading CR.rclone_chunk.002_fnquc6: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:674: testing "␊leading LF" 2022/01/09 06:10:24 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2022/01/09 06:10:24 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2022/01/09 06:10:25 DEBUG : pacer: Reducing sleep to 15ms 2022/01/09 06:10:25 DEBUG : pacer: Reducing sleep to 11.25ms 2022/01/09 06:10:26 DEBUG : pacer: Reducing sleep to 10ms 2022/01/09 06:10:29 INFO : ␊leading LF/␊leading LF.rclone_chunk.001_fnr9ce: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.001 2022/01/09 06:10:30 INFO : ␊leading LF/␊leading LF.rclone_chunk.002_fnr9ce: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:674: testing "␉leading HT" 2022/01/09 06:10:46 INFO : ␉leading HT/␉leading HT.rclone_chunk.001_fnrruv: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.001 2022/01/09 06:10:47 INFO : ␉leading HT/␉leading HT.rclone_chunk.002_fnrruv: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:674: testing "␋leading VT" 2022/01/09 06:10:58 INFO : ␋leading VT/␋leading VT.rclone_chunk.001_fns4cc: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.001 2022/01/09 06:10:59 INFO : ␋leading VT/␋leading VT.rclone_chunk.002_fns4cc: Moved (server-side) to: ␋leading VT/␋leading VT.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/leading_VT Messages: ␋leading VT/␋leading VT: Modification time difference too big |-8.086335683s| > 1ns (want 2022-01-09 06:10:52.913664317 +0000 UTC m=+150.915847644 vs got 2022-01-09 06:11:01 +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/leading_VT Messages: ␋leading VT/␋leading VT: Modification time difference too big |-8.086335683s| > 1ns (want 2022-01-09 06:10:52.913664317 +0000 UTC m=+150.915847644 vs got 2022-01-09 06:11:01 +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/leading_VT Messages: ␋leading VT/␋leading VT: Modification time difference too big |-8.086335683s| > 1ns (want 2022-01-09 06:10:52.913664317 +0000 UTC m=+150.915847644 vs got 2022-01-09 06:11:01 +0000 UTC) (precision 1ns) === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:674: testing ".leading dot" 2022/01/09 06:11:13 INFO : .leading dot/.leading dot.rclone_chunk.001_fnsja6: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.001 2022/01/09 06:11:14 INFO : .leading dot/.leading dot.rclone_chunk.002_fnsja6: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:674: testing "trailing space " 2022/01/09 06:11:28 INFO : trailing space /trailing space .rclone_chunk.001_fnsyw3: Moved (server-side) to: trailing space /trailing space .rclone_chunk.001 2022/01/09 06:11:29 INFO : trailing space /trailing space .rclone_chunk.002_fnsyw3: Moved (server-side) to: trailing space /trailing space .rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:674: testing "trailing CR␍" 2022/01/09 06:11:47 INFO : trailing CR␍/trailing CR␍.rclone_chunk.001_fntg83: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.001 2022/01/09 06:11:48 INFO : trailing CR␍/trailing CR␍.rclone_chunk.002_fntg83: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:674: testing "trailing LF␊" 2022/01/09 06:12:03 INFO : trailing LF␊/trailing LF␊.rclone_chunk.001_fntwks: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.001 2022/01/09 06:12:04 INFO : trailing LF␊/trailing LF␊.rclone_chunk.002_fntwks: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:674: testing "trailing HT␉" 2022/01/09 06:12:19 INFO : trailing HT␉/trailing HT␉.rclone_chunk.001_fnubrj: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.001 2022/01/09 06:12:20 INFO : trailing HT␉/trailing HT␉.rclone_chunk.002_fnubrj: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:674: testing "trailing VT␋" 2022/01/09 06:12:34 INFO : trailing VT␋/trailing VT␋.rclone_chunk.001_fnurjd: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.001 2022/01/09 06:12:35 INFO : trailing VT␋/trailing VT␋.rclone_chunk.002_fnurjd: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.002 2022/01/09 06:12:37 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2022/01/09 06:12:37 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2022/01/09 06:12:37 DEBUG : pacer: Reducing sleep to 15ms 2022/01/09 06:12:38 DEBUG : pacer: Reducing sleep to 11.25ms 2022/01/09 06:12:38 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:674: testing "trailing dot." 2022/01/09 06:12:50 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2022/01/09 06:12:50 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2022/01/09 06:12:51 DEBUG : pacer: Reducing sleep to 15ms 2022/01/09 06:12:51 DEBUG : pacer: Reducing sleep to 11.25ms 2022/01/09 06:12:51 DEBUG : pacer: Reducing sleep to 10ms 2022/01/09 06:12:53 INFO : trailing dot./trailing dot..rclone_chunk.001_fnv9j6: Moved (server-side) to: trailing dot./trailing dot..rclone_chunk.001 2022/01/09 06:12:54 INFO : trailing dot./trailing dot..rclone_chunk.002_fnv9j6: 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/01/09 06:13:04 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2022/01/09 06:13:04 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2022/01/09 06:13:05 DEBUG : pacer: Reducing sleep to 15ms 2022/01/09 06:13:05 DEBUG : pacer: Reducing sleep to 11.25ms 2022/01/09 06:13:05 DEBUG : pacer: Reducing sleep to 10ms 2022/01/09 06:13:09 INFO : invalid utf-8/invalid utf-8.rclone_chunk.001_fnvpi0: Moved (server-side) to: invalid utf-8/invalid utf-8.rclone_chunk.001 2022/01/09 06:13:10 INFO : invalid utf-8/invalid utf-8.rclone_chunk.002_fnvpi0: 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/01/09 06:13:24 INFO : test%46.txt/test%46.txt.rclone_chunk.001_fnw5j8: Moved (server-side) to: test%46.txt/test%46.txt.rclone_chunk.001 2022/01/09 06:13:25 INFO : test%46.txt/test%46.txt.rclone_chunk.002_fnw5j8: 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/01/09 06:13:40 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2022/01/09 06:13:40 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2022/01/09 06:13:40 DEBUG : pacer: Reducing sleep to 15ms 2022/01/09 06:13:40 DEBUG : pacer: Reducing sleep to 11.25ms 2022/01/09 06:13:40 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsPutZeroLength 2022/01/09 06:14:50 INFO : zero-length-file.rclone_chunk.001_fnyizg: 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/01/09 06:14:58 INFO : file name.txt.rclone_chunk.001_fnyq7s: Moved (server-side) to: file name.txt.rclone_chunk.001 2022/01/09 06:14:59 INFO : file name.txt.rclone_chunk.002_fnyq7s: Moved (server-side) to: file name.txt.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:868 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles Messages: file name.txt: Modification time difference too big |-183482h9m53.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2022-01-09 06:15:00 +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:868 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles Messages: file name.txt: Modification time difference too big |-183482h9m53.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2022-01-09 06:15:00 +0000 UTC) (precision 1ns) 2022/01/09 06:15:06 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2022/01/09 06:15:06 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2022/01/09 06:15:07 DEBUG : pacer: Reducing sleep to 15ms 2022/01/09 06:15:07 DEBUG : pacer: Reducing sleep to 11.25ms 2022/01/09 06:15:07 DEBUG : pacer: Reducing sleep to 10ms 2022/01/09 06:15:09 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_fnz2de: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001 2022/01/09 06:15:10 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002_fnz2de: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002 2022/01/09 06:15:16 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2022/01/09 06:15:16 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2022/01/09 06:15:16 DEBUG : pacer: Reducing sleep to 15ms 2022/01/09 06:15:17 DEBUG : pacer: Reducing sleep to 11.25ms 2022/01/09 06:15:17 DEBUG : pacer: Reducing sleep to 10ms 2022/01/09 06:15:23 INFO : file name.txt.rclone_chunk.001_fnzddu: Moved (server-side) to: file name.txt.rclone_chunk.001 2022/01/09 06:15:24 INFO : file name.txt.rclone_chunk.002_fnzddu: 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/01/09 06:15:31 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:" 2022/01/09 06:15:31 DEBUG : Config file has changed externaly - reloading 2022/01/09 06:15:31 DEBUG : Creating backend with remote "TestYandex:" 2022/01/09 06:15:31 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/01/09 06:15:42 INFO : dirToPurge/fileToPurge.txt.rclone_chunk.001_fnzzk0: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.001 2022/01/09 06:15:43 INFO : dirToPurge/fileToPurge.txt.rclone_chunk.002_fnzzk0: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy 2022/01/09 06:15:54 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: copy 2 data chunks... === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2022/01/09 06:16:04 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: move 2 data chunks... 2022/01/09 06:16:06 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001: Moved (server-side) to: other.txt.rclone_chunk.001 2022/01/09 06:16:07 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002: Moved (server-side) to: other.txt.rclone_chunk.002 2022/01/09 06:16:08 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Moved (server-side) to: other.txt 2022/01/09 06:16:12 DEBUG : file name.txt: move 2 data chunks... 2022/01/09 06:16:13 INFO : file name.txt.rclone_chunk.001: Moved (server-side) to: moveTest/other.txt.rclone_chunk.001 2022/01/09 06:16:14 INFO : file name.txt.rclone_chunk.002: Moved (server-side) to: moveTest/other.txt.rclone_chunk.002 2022/01/09 06:16:15 INFO : file name.txt: Moved (server-side) to: moveTest/other.txt 2022/01/09 06:16:20 DEBUG : moveTest/other.txt: move 2 data chunks... 2022/01/09 06:16:21 INFO : moveTest/other.txt.rclone_chunk.001: Moved (server-side) to: file name.txt.rclone_chunk.001 2022/01/09 06:16:23 INFO : moveTest/other.txt.rclone_chunk.002: Moved (server-side) to: file name.txt.rclone_chunk.002 2022/01/09 06:16:24 INFO : moveTest/other.txt: Moved (server-side) to: file name.txt 2022/01/09 06:16:28 DEBUG : other.txt: move 2 data chunks... 2022/01/09 06:16:29 INFO : other.txt.rclone_chunk.001: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001 2022/01/09 06:16:31 INFO : other.txt.rclone_chunk.002: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002 2022/01/09 06:16:32 INFO : other.txt: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2022/01/09 06:16:38 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-guyihom3heyamup5vebazas8" 2022/01/09 06:16:38 DEBUG : Creating backend with remote "TestYandex:rclone-test-guyihom3heyamup5vebazas8" 2022/01/09 06:16:38 DEBUG : Reset feature "ListR" 2022/01/09 06:16:55 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-guyihom3heyamup5vebazas8': 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/01/09 06:17:18 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2022/01/09 06:17:18 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2022/01/09 06:17:18 DEBUG : pacer: Reducing sleep to 15ms 2022/01/09 06:17:19 DEBUG : pacer: Reducing sleep to 11.25ms 2022/01/09 06:17:19 DEBUG : pacer: Reducing sleep to 10ms 2022/01/09 06:17:23 INFO : file name.txt.rclone_chunk.001_fo2mpc: Moved (server-side) to: file name.txt.rclone_chunk.001 2022/01/09 06:17:24 INFO : file name.txt.rclone_chunk.002_fo2mpc: Moved (server-side) to: file name.txt.rclone_chunk.002 2022/01/09 06:17:25 INFO : file name.txt.rclone_chunk.003_fo2mpc: Moved (server-side) to: file name.txt.rclone_chunk.003 2022/01/09 06:17:26 INFO : file name.txt.rclone_chunk.004_fo2mpc: Moved (server-side) to: file name.txt.rclone_chunk.004 === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2022/01/09 06:17:31 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-warereb9mulupij4bemaduk4/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2022/01/09 06:17:31 DEBUG : Creating backend with remote "TestYandex:rclone-test-warereb9mulupij4bemaduk4/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2022/01/09 06:17:31 DEBUG : fs cache: adding new entry for parent of "TestYandex:rclone-test-warereb9mulupij4bemaduk4/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt", "TestYandex:rclone-test-warereb9mulupij4bemaduk4/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠" 2022/01/09 06:17:31 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2022/01/09 06:17:31 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-warereb9mulupij4bemaduk4/not found.txt" 2022/01/09 06:17:31 DEBUG : Creating backend with remote "TestYandex:rclone-test-warereb9mulupij4bemaduk4/not found.txt" 2022/01/09 06:17:32 DEBUG : Reset feature "ListR" 2022/01/09 06:17:32 ERROR : : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1503: Opening root remote "TestChunkerChunk50bYandex:" path "rclone-test-warereb9mulupij4bemaduk4" from "TestChunkerChunk50bYandex:rclone-test-warereb9mulupij4bemaduk4" 2022/01/09 06:17:32 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:" 2022/01/09 06:17:32 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/01/09 06:17:36 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2022/01/09 06:17:36 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2022/01/09 06:17:36 DEBUG : pacer: Reducing sleep to 15ms 2022/01/09 06:17:37 DEBUG : pacer: Reducing sleep to 11.25ms 2022/01/09 06:17:37 DEBUG : pacer: Reducing sleep to 10ms 2022/01/09 06:17:40 INFO : rclone-test-warereb9mulupij4bemaduk4/created from root.txt.rclone_chunk.001_fo39ep: Moved (server-side) to: rclone-test-warereb9mulupij4bemaduk4/created from root.txt.rclone_chunk.001 2022/01/09 06:17:41 INFO : rclone-test-warereb9mulupij4bemaduk4/created from root.txt.rclone_chunk.002_fo39ep: Moved (server-side) to: rclone-test-warereb9mulupij4bemaduk4/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/01/09 06:18:01 INFO : piped data.txt.rclone_chunk.001_fo3x0h: Moved (server-side) to: piped data.txt === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2022/01/09 06:18:12 INFO : piped data.txt.rclone_chunk.001_fo42g4: Moved (server-side) to: piped data.txt.rclone_chunk.001 2022/01/09 06:18:13 INFO : piped data.txt.rclone_chunk.002_fo42g4: Moved (server-side) to: piped data.txt.rclone_chunk.002 2022/01/09 06:18:14 INFO : piped data.txt.rclone_chunk.003_fo42g4: 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/01/09 06:18:21 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-warereb9mulupij4bemaduk4': invalid data chunk number in file "fish.chunk.001" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals 2022/01/09 06:18:26 INFO : small/emptyfile.rclone_chunk.001_fo4kgd: Moved (server-side) to: small/emptyfile 2022/01/09 06:18:35 INFO : small/smallfile.rclone_chunk.001_fo4r8u: Moved (server-side) to: small/smallfile === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption 2022/01/09 06:18:47 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2022/01/09 06:18:47 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2022/01/09 06:18:48 DEBUG : pacer: Reducing sleep to 15ms 2022/01/09 06:18:48 DEBUG : pacer: Reducing sleep to 11.25ms 2022/01/09 06:18:48 DEBUG : pacer: Reducing sleep to 10ms 2022/01/09 06:18:50 INFO : corrupted/billy.rclone_chunk.001_fo517v: Moved (server-side) to: corrupted/billy.rclone_chunk.001 2022/01/09 06:18:54 INFO : corrupted/billy.rclone_chunk.002_fo517v: Moved (server-side) to: corrupted/billy.rclone_chunk.002 2022/01/09 06:18:56 INFO : corrupted/billy.rclone_chunk.003_fo517v: Moved (server-side) to: corrupted/billy.rclone_chunk.003 2022/01/09 06:18:58 INFO : corrupted/billy.rclone_chunk.004_fo517v: Moved (server-side) to: corrupted/billy.rclone_chunk.004 2022/01/09 06:19:02 INFO : corrupted/billy.rclone_chunk.005_fo517v: Moved (server-side) to: corrupted/billy.rclone_chunk.005 fstest.go:128: Error Trace: fstest.go:128 fstest.go:133 fstest.go:152 fstests.go:202 fstests.go:212 chunker_internal_test.go:492 chunker_internal_test.go:496 chunker_internal_test.go:917 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption Messages: corrupted/billy: Modification time difference too big |-183482h13m56.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2022-01-09 06:19:03 +0000 UTC) (precision 1ns) fstest.go:128: Error Trace: fstest.go:128 fstest.go:133 fstest.go:152 fstests.go:205 fstests.go:212 chunker_internal_test.go:492 chunker_internal_test.go:496 chunker_internal_test.go:917 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption Messages: corrupted/billy: Modification time difference too big |-183482h13m56.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2022-01-09 06:19:03 +0000 UTC) (precision 1ns) 2022/01/09 06:19:17 INFO : corrupted/silly1.rclone_chunk.001_fo5svv: Moved (server-side) to: corrupted/silly1.rclone_chunk.001 2022/01/09 06:19:18 INFO : corrupted/silly1.rclone_chunk.002_fo5svv: Moved (server-side) to: corrupted/silly1.rclone_chunk.002 2022/01/09 06:19:20 INFO : corrupted/silly1.rclone_chunk.003_fo5svv: Moved (server-side) to: corrupted/silly1.rclone_chunk.003 2022/01/09 06:19:21 INFO : corrupted/silly1.rclone_chunk.004_fo5svv: Moved (server-side) to: corrupted/silly1.rclone_chunk.004 2022/01/09 06:19:23 INFO : corrupted/silly1.rclone_chunk.005_fo5svv: Moved (server-side) to: corrupted/silly1.rclone_chunk.005 2022/01/09 06:19:38 INFO : corrupted/silly2.rclone_chunk.001_fo6d4p: Moved (server-side) to: corrupted/silly2.rclone_chunk.001 2022/01/09 06:19:39 INFO : corrupted/silly2.rclone_chunk.002_fo6d4p: Moved (server-side) to: corrupted/silly2.rclone_chunk.002 2022/01/09 06:19:40 INFO : corrupted/silly2.rclone_chunk.003_fo6d4p: Moved (server-side) to: corrupted/silly2.rclone_chunk.003 2022/01/09 06:19:41 INFO : corrupted/silly2.rclone_chunk.004_fo6d4p: Moved (server-side) to: corrupted/silly2.rclone_chunk.004 2022/01/09 06:19:42 INFO : corrupted/silly2.rclone_chunk.005_fo6d4p: Moved (server-side) to: corrupted/silly2.rclone_chunk.005 2022/01/09 06:19:59 INFO : corrupted/silly3.rclone_chunk.001_fo6zyc: Moved (server-side) to: corrupted/silly3.rclone_chunk.001 2022/01/09 06:20:00 INFO : corrupted/silly3.rclone_chunk.002_fo6zyc: Moved (server-side) to: corrupted/silly3.rclone_chunk.002 2022/01/09 06:20:02 INFO : corrupted/silly3.rclone_chunk.003_fo6zyc: Moved (server-side) to: corrupted/silly3.rclone_chunk.003 2022/01/09 06:20:03 INFO : corrupted/silly3.rclone_chunk.004_fo6zyc: Moved (server-side) to: corrupted/silly3.rclone_chunk.004 2022/01/09 06:20:04 INFO : corrupted/silly3.rclone_chunk.005_fo6zyc: Moved (server-side) to: corrupted/silly3.rclone_chunk.005 2022/01/09 06:20:22 INFO : corrupted/willy.rclone_chunk.001_fo7ier: Moved (server-side) to: corrupted/willy.rclone_chunk.001 2022/01/09 06:20:23 INFO : corrupted/willy.rclone_chunk.002_fo7ier: Moved (server-side) to: corrupted/willy.rclone_chunk.002 2022/01/09 06:20:28 INFO : corrupted/willy.rclone_chunk.003_fo7ier: Moved (server-side) to: corrupted/willy.rclone_chunk.003 2022/01/09 06:20:29 INFO : corrupted/willy.rclone_chunk.004_fo7ier: Moved (server-side) to: corrupted/willy.rclone_chunk.004 2022/01/09 06:20:31 INFO : corrupted/willy.rclone_chunk.005_fo7ier: Moved (server-side) to: corrupted/willy.rclone_chunk.005 2022/01/09 06:20:53 INFO : corrupted/silly4.rclone_chunk.001_fo8aec: Moved (server-side) to: corrupted/silly4.rclone_chunk.001 2022/01/09 06:20:54 INFO : corrupted/silly4.rclone_chunk.002_fo8aec: Moved (server-side) to: corrupted/silly4.rclone_chunk.002 2022/01/09 06:20:55 INFO : corrupted/silly4.rclone_chunk.003_fo8aec: Moved (server-side) to: corrupted/silly4.rclone_chunk.003 2022/01/09 06:20:56 INFO : corrupted/silly4.rclone_chunk.004_fo8aec: Moved (server-side) to: corrupted/silly4.rclone_chunk.004 2022/01/09 06:20:57 INFO : corrupted/silly4.rclone_chunk.005_fo8aec: Moved (server-side) to: corrupted/silly4.rclone_chunk.005 2022/01/09 06:21:00 ERROR : corrupted/silly4: Failed to copy: can't copy: chunk overlap with "corrupted/willy" 2022/01/09 06:21:11 INFO : corrupted/silly5.rclone_chunk.001_fo8zqd: Moved (server-side) to: corrupted/silly5.rclone_chunk.001 2022/01/09 06:21:12 INFO : corrupted/silly5.rclone_chunk.002_fo8zqd: Moved (server-side) to: corrupted/silly5.rclone_chunk.002 2022/01/09 06:21:13 INFO : corrupted/silly5.rclone_chunk.003_fo8zqd: Moved (server-side) to: corrupted/silly5.rclone_chunk.003 2022/01/09 06:21:15 INFO : corrupted/silly5.rclone_chunk.004_fo8zqd: Moved (server-side) to: corrupted/silly5.rclone_chunk.004 2022/01/09 06:21:16 INFO : corrupted/silly5.rclone_chunk.005_fo8zqd: Moved (server-side) to: corrupted/silly5.rclone_chunk.005 2022/01/09 06:21:20 ERROR : corrupted/willy.rclone_chunk.002: Couldn't delete: refuse to corrupt: chunk overlap with "corrupted/willy" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow 2022/01/09 06:21:36 INFO : wreaked/wreaker.rclone_chunk.001_fo9tqo: Moved (server-side) to: wreaked/wreaker.rclone_chunk.001 2022/01/09 06:21:37 INFO : wreaked/wreaker.rclone_chunk.002_fo9tqo: Moved (server-side) to: wreaked/wreaker.rclone_chunk.002 2022/01/09 06:21:43 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-warereb9mulupij4bemaduk4': invalid directory entry "wreaked/wreaker" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput 2022/01/09 06:21:55 ERROR : usermeta/today.rclone_chunk.001_foae0c: Couldn't move: couldn't move file: [409 - DiskResourceAlreadyExistsError] Resource "disk:/rclone-test-warereb9mulupij4bemaduk4/usermeta/today.rclone_chunk.001" already exists. (Ресурс "disk:/rclone-test-warereb9mulupij4bemaduk4/usermeta/today.rclone_chunk.001" уже существует.) 2022/01/09 06:21:56 INFO : usermeta/today.rclone_chunk.001: Deleted 2022/01/09 06:21:57 INFO : usermeta/today.rclone_chunk.001_foae0c: Moved (server-side) to: usermeta/today.rclone_chunk.001 2022/01/09 06:22:10 ERROR : usermeta/past.rclone_chunk.001_foaufy: Couldn't move: couldn't move file: [409 - DiskResourceAlreadyExistsError] Resource "disk:/rclone-test-warereb9mulupij4bemaduk4/usermeta/past.rclone_chunk.001" already exists. (Ресурс "disk:/rclone-test-warereb9mulupij4bemaduk4/usermeta/past.rclone_chunk.001" уже существует.) 2022/01/09 06:22:11 INFO : usermeta/past.rclone_chunk.001: Deleted 2022/01/09 06:22:12 INFO : usermeta/past.rclone_chunk.001_foaufy: Moved (server-side) to: usermeta/past.rclone_chunk.001 2022/01/09 06:22:23 ERROR : usermeta/future.rclone_chunk.001_fob7pl: Couldn't move: couldn't move file: [409 - DiskResourceAlreadyExistsError] Resource "disk:/rclone-test-warereb9mulupij4bemaduk4/usermeta/future.rclone_chunk.001" already exists. (Ресурс "disk:/rclone-test-warereb9mulupij4bemaduk4/usermeta/future.rclone_chunk.001" уже существует.) 2022/01/09 06:22:24 INFO : usermeta/future.rclone_chunk.001: Deleted 2022/01/09 06:22:24 INFO : usermeta/future.rclone_chunk.001_fob7pl: Moved (server-side) to: usermeta/future.rclone_chunk.001 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof 2022/01/09 06:22:40 DEBUG : future/test: Can't move - required hash not found 2022/01/09 06:22:40 DEBUG : future/test: Can't move, switching to copy 2022/01/09 06:22:41 DEBUG : future/test: Can't copy - required hash not found 2022/01/09 06:22:41 ERROR : future/test: Failed to copy: failed to open source object: can't open: unknown metadata, please upgrade rclone 2022/01/09 06:22:41 ERROR : future/test: Not deleting source as copy failed: failed to open source object: can't open: unknown metadata, please upgrade rclone 2022/01/09 06:22:41 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-warereb9mulupij4bemaduk4': File to upload is small (3 bytes), uploading instead of streaming 2022/01/09 06:22:42 ERROR : future/test: Failed to copy: refusing to put: unknown metadata, please upgrade rclone === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility 2022/01/09 06:23:27 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2022/01/09 06:23:27 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2022/01/09 06:23:28 DEBUG : pacer: Reducing sleep to 15ms 2022/01/09 06:23:28 DEBUG : pacer: Reducing sleep to 11.25ms 2022/01/09 06:23:28 DEBUG : pacer: Reducing sleep to 10ms 2022/01/09 06:23:45 INFO : backcomp/renamefile.rclone_chunk.001_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.001 2022/01/09 06:23:47 INFO : backcomp/renamefile.rclone_chunk.002_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.002 2022/01/09 06:23:48 INFO : backcomp/renamefile.rclone_chunk.003_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.003 2022/01/09 06:23:49 INFO : backcomp/renamefile.rclone_chunk.004_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.004 2022/01/09 06:23:50 INFO : backcomp/renamefile.rclone_chunk.005_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.005 2022/01/09 06:23:51 INFO : backcomp/renamefile.rclone_chunk.006_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.006 2022/01/09 06:23:53 INFO : backcomp/renamefile.rclone_chunk.007_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.007 2022/01/09 06:23:54 INFO : backcomp/renamefile.rclone_chunk.008_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.008 2022/01/09 06:23:55 INFO : backcomp/renamefile.rclone_chunk.009_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.009 2022/01/09 06:23:56 INFO : backcomp/renamefile.rclone_chunk.010_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.010 2022/01/09 06:23:57 INFO : backcomp/renamefile.rclone_chunk.011_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.011 2022/01/09 06:23:58 INFO : backcomp/renamefile.rclone_chunk.012_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.012 2022/01/09 06:24:00 INFO : backcomp/renamefile.rclone_chunk.013_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.013 2022/01/09 06:24:01 INFO : backcomp/renamefile.rclone_chunk.014_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.014 2022/01/09 06:24:02 INFO : backcomp/renamefile.rclone_chunk.015_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.015 2022/01/09 06:24:03 INFO : backcomp/renamefile.rclone_chunk.016_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.016 2022/01/09 06:24:04 INFO : backcomp/renamefile.rclone_chunk.017_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.017 2022/01/09 06:24:05 INFO : backcomp/renamefile.rclone_chunk.018_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.018 2022/01/09 06:24:08 INFO : backcomp/renamefile.rclone_chunk.019_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.019 2022/01/09 06:24:10 INFO : backcomp/renamefile.rclone_chunk.020_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.020 2022/01/09 06:24:11 INFO : backcomp/renamefile.rclone_chunk.021_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.021 2022/01/09 06:24:12 INFO : backcomp/renamefile.rclone_chunk.022_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.022 2022/01/09 06:24:14 INFO : backcomp/renamefile.rclone_chunk.023_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.023 2022/01/09 06:24:16 INFO : backcomp/renamefile.rclone_chunk.024_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.024 2022/01/09 06:24:17 INFO : backcomp/renamefile.rclone_chunk.025_fobw69: Moved (server-side) to: backcomp/renamefile.rclone_chunk.025 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove 2022/01/09 06:24:51 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-warereb9mulupij4bemaduk4/servermovetest/subdir1" 2022/01/09 06:24:51 DEBUG : Creating backend with remote "TestYandex:rclone-test-warereb9mulupij4bemaduk4/servermovetest/subdir1" 2022/01/09 06:24:51 DEBUG : Reset feature "ListR" 2022/01/09 06:24:51 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-warereb9mulupij4bemaduk4/servermovetest/subdir2" 2022/01/09 06:24:51 DEBUG : Creating backend with remote "TestYandex:rclone-test-warereb9mulupij4bemaduk4/servermovetest/subdir2" 2022/01/09 06:24:51 DEBUG : Reset feature "ListR" 2022/01/09 06:24:58 INFO : movefile.rclone_chunk.001_foff4o: Moved (server-side) to: movefile.rclone_chunk.001 2022/01/09 06:24:59 INFO : movefile.rclone_chunk.002_foff4o: Moved (server-side) to: movefile.rclone_chunk.002 2022/01/09 06:25:02 DEBUG : movefile: move 2 data chunks... 2022/01/09 06:25:03 INFO : movefile.rclone_chunk.001: Moved (server-side) 2022/01/09 06:25:04 INFO : movefile.rclone_chunk.002: Moved (server-side) 2022/01/09 06:25:06 INFO : movefile: Moved (server-side) 2022/01/09 06:25:08 INFO : movefile: Moved (server-side) === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow 2022/01/09 06:25:11 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex,chunk_size='1P',hash_type='md5all',meta_format='simplejson',name_format='*.#',transactions='rename':rclone-test-warereb9mulupij4bemaduk4/md5all" 2022/01/09 06:25:11 DEBUG : TestChunkerChunk50bYandex: detected overridden config - adding "{r7Izf}" suffix to name 2022/01/09 06:25:11 DEBUG : Creating backend with remote "TestYandex:rclone-test-warereb9mulupij4bemaduk4/md5all" 2022/01/09 06:25:11 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/01/09 06:25:19 INFO : unknown-size-put.txt.rclone_chunk.001_fofzqa: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.001 2022/01/09 06:25:24 INFO : unknown-size-put.txt.rclone_chunk.002_fofzqa: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.002 2022/01/09 06:25:25 INFO : unknown-size-put.txt.rclone_chunk.003_fofzqa: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.003 === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2022/01/09 06:25:34 INFO : unknown-size-update.txt.rclone_chunk.001_foggcm: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001 2022/01/09 06:25:35 INFO : unknown-size-update.txt.rclone_chunk.002_foggcm: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002 2022/01/09 06:25:51 INFO : unknown-size-update.txt.rclone_chunk.001_fogqd5: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001 2022/01/09 06:25:52 INFO : unknown-size-update.txt.rclone_chunk.002_fogqd5: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002 2022/01/09 06:25:53 INFO : unknown-size-update.txt.rclone_chunk.003_fogqd5: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.003 2022/01/09 06:25:53 INFO : unknown-size-update.txt.rclone_chunk.004_fogqd5: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.004 2022/01/09 06:25:54 INFO : unknown-size-update.txt.rclone_chunk.005_fogqd5: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.005 === RUN TestIntegration/FsMkdir/FsRootCollapse 2022/01/09 06:26:01 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-warereb9mulupij4bemaduk4/deeper/nonexisting/directory" 2022/01/09 06:26:01 DEBUG : Creating backend with remote "TestYandex:rclone-test-warereb9mulupij4bemaduk4/deeper/nonexisting/directory" 2022/01/09 06:26:01 DEBUG : Reset feature "ListR" 2022/01/09 06:26:04 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 (1062.85s) --- PASS: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.38s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (1.12s) --- FAIL: TestIntegration/FsMkdir (1060.44s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (4.43s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.34s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.30s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.23s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- FAIL: TestIntegration/FsMkdir/FsEncoding (302.52s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (17.49s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (15.57s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (13.77s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (16.38s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (16.16s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (16.23s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (14.98s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (17.47s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (13.24s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/leading_VT (14.88s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (14.99s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (18.36s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (15.63s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (15.26s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (16.35s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (18.10s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (15.64s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (16.56s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (15.19s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.43s) --- PASS: TestIntegration/FsMkdir/FsPutError (69.36s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (8.26s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles (620.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.04s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (0.94s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.94s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.45s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.47s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.35s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (1.46s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.69s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (1.64s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.23s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (16.71s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (10.85s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (33.66s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (20.52s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.40s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.38s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.39s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.65s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.42s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (1.62s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.31s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (3.34s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (1.49s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (1.59s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (0.84s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (20.73s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.31s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.57s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.33s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (18.97s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (1.75s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.42s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (16.80s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (4.18s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (6.65s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (23.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (4.65s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (18.53s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/Internal (410.45s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals (16.75s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption (172.07s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow (18.98s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput (41.02s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof (15.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility (126.23s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove (20.24s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow (0.15s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (49.55s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (17.73s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (31.82s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.40s) --- SKIP: TestIntegration/FsShutdown (0.00s) FAIL exit status 1 FAIL github.com/rclone/rclone/backend/chunker 1062.878s "go test -v -timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024" - Finished ERROR in 17m44.55557788s (try 1/5): exit status 1: Failed [TestIntegration/FsMkdir/FsEncoding/leading_VT TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption]