"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024" - Starting (try 1/5) === RUN TestIntegration fstests.go:407: Using remote "TestChunkerChunk50bYandex:" 2021/02/08 05:02:21 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-zivemen3kaneyiw0vutoquj4" 2021/02/08 05:02:21 DEBUG : Creating backend with remote "TestYandex:rclone-test-zivemen3kaneyiw0vutoquj4" 2021/02/08 05:02:22 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsCheckWrap === RUN TestIntegration/FsCommand fstests.go:472: 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 2021/02/08 05:02:25 DEBUG : dir/subdir: Making directory 2021/02/08 05:02:28 DEBUG : dir/subdir: Removing directory 2021/02/08 05:02:29 DEBUG : dir: Removing directory === RUN TestIntegration/FsMkdir/FsListEmpty === RUN TestIntegration/FsMkdir/FsListDirEmpty === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:367: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2021/02/08 05:02:31 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:367: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:658: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" 2021/02/08 05:02:38 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2021/02/08 05:02:38 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2021/02/08 05:02:38 DEBUG : pacer: Reducing sleep to 15ms 2021/02/08 05:02:38 DEBUG : pacer: Reducing sleep to 11.25ms 2021/02/08 05:02:39 DEBUG : pacer: Reducing sleep to 10ms 2021/02/08 05:02:40 INFO : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001_776wcm: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.001 2021/02/08 05:02:41 INFO : ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002_776wcm: Moved (server-side) to: ␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡/␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:658: testing "．" 2021/02/08 05:02:57 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2021/02/08 05:02:57 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2021/02/08 05:02:57 DEBUG : pacer: Reducing sleep to 15ms 2021/02/08 05:02:57 DEBUG : pacer: Reducing sleep to 11.25ms 2021/02/08 05:02:58 DEBUG : pacer: Reducing sleep to 10ms 2021/02/08 05:02:59 INFO : ．/．.rclone_chunk.001_777gsv: Moved (server-side) to: ．/．.rclone_chunk.001 2021/02/08 05:03:02 INFO : ．/．.rclone_chunk.002_777gsv: Moved (server-side) to: ．/．.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:658: testing "．．" 2021/02/08 05:03:19 INFO : ．．/．．.rclone_chunk.001_77805m: Moved (server-side) to: ．．/．．.rclone_chunk.001 2021/02/08 05:03:21 INFO : ．．/．．.rclone_chunk.002_77805m: Moved (server-side) to: ．．/．．.rclone_chunk.002 2021/02/08 05:03:23 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2021/02/08 05:03:23 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2021/02/08 05:03:24 DEBUG : pacer: Reducing sleep to 15ms 2021/02/08 05:03:24 DEBUG : pacer: Reducing sleep to 11.25ms 2021/02/08 05:03:25 DEBUG : pacer: Reducing sleep to 10ms === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:658: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" 2021/02/08 05:03:35 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2021/02/08 05:03:35 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2021/02/08 05:03:35 DEBUG : pacer: Reducing sleep to 15ms 2021/02/08 05:03:36 DEBUG : pacer: Reducing sleep to 11.25ms 2021/02/08 05:03:36 DEBUG : pacer: Reducing sleep to 10ms 2021/02/08 05:03:44 INFO : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001_778kc1: Moved (server-side) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.001 2021/02/08 05:03:45 INFO : !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.002_778kc1: Moved (server-side) to: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~.rclone_chunk.002 fstest.go:126: Error Trace: fstest.go:126 fstest.go:131 fstest.go:150 fstests.go:202 fstests.go:212 fstests.go:217 fstests.go:664 Error: Should be true Test: TestIntegration/FsMkdir/FsEncoding/punctuation Messages: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Modification time difference too big |-14.947606807s| > 1ns (want 2021-02-08 05:03:32.052393193 +0000 UTC m=+70.264756955 vs got 2021-02-08 05:03:47 +0000 UTC) (precision 1ns) fstest.go:126: Error Trace: fstest.go:126 fstest.go:131 fstest.go:150 fstests.go:205 fstests.go:212 fstests.go:217 fstests.go:664 Error: Should be true Test: TestIntegration/FsMkdir/FsEncoding/punctuation Messages: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Modification time difference too big |-14.947606807s| > 1ns (want 2021-02-08 05:03:32.052393193 +0000 UTC m=+70.264756955 vs got 2021-02-08 05:03:47 +0000 UTC) (precision 1ns) fstest.go:126: Error Trace: fstest.go:126 fstest.go:131 fstest.go:150 fstest.go:194 fstest.go:307 fstest.go:337 fstests.go:665 Error: Should be true Test: TestIntegration/FsMkdir/FsEncoding/punctuation Messages: !"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~/!"#$%&'()*+,-.／:;<=>?@[\]^_`{|}~: Modification time difference too big |-14.947606807s| > 1ns (want 2021-02-08 05:03:32.052393193 +0000 UTC m=+70.264756955 vs got 2021-02-08 05:03:47 +0000 UTC) (precision 1ns) === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:658: testing " leading space" 2021/02/08 05:04:02 INFO : leading space/ leading space.rclone_chunk.001_77978b: Moved (server-side) to: leading space/ leading space.rclone_chunk.001 2021/02/08 05:04:03 INFO : leading space/ leading space.rclone_chunk.002_77978b: Moved (server-side) to: leading space/ leading space.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:658: testing "~leading tilde" 2021/02/08 05:04:24 INFO : ~leading tilde/~leading tilde.rclone_chunk.001_779scc: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.001 2021/02/08 05:04:26 INFO : ~leading tilde/~leading tilde.rclone_chunk.002_779scc: Moved (server-side) to: ~leading tilde/~leading tilde.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:658: testing "␍leading CR" 2021/02/08 05:04:43 INFO : ␍leading CR/␍leading CR.rclone_chunk.001_77ac3a: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.001 2021/02/08 05:04:44 INFO : ␍leading CR/␍leading CR.rclone_chunk.002_77ac3a: Moved (server-side) to: ␍leading CR/␍leading CR.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:658: testing "␊leading LF" 2021/02/08 05:05:04 INFO : ␊leading LF/␊leading LF.rclone_chunk.001_77awrk: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.001 2021/02/08 05:05:05 INFO : ␊leading LF/␊leading LF.rclone_chunk.002_77awrk: Moved (server-side) to: ␊leading LF/␊leading LF.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:658: testing "␉leading HT" 2021/02/08 05:05:21 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2021/02/08 05:05:21 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2021/02/08 05:05:21 DEBUG : pacer: Reducing sleep to 15ms 2021/02/08 05:05:21 DEBUG : pacer: Reducing sleep to 11.25ms 2021/02/08 05:05:22 DEBUG : pacer: Reducing sleep to 10ms 2021/02/08 05:05:23 INFO : ␉leading HT/␉leading HT.rclone_chunk.001_77bff7: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.001 2021/02/08 05:05:25 INFO : ␉leading HT/␉leading HT.rclone_chunk.002_77bff7: Moved (server-side) to: ␉leading HT/␉leading HT.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:658: testing "␋leading VT" 2021/02/08 05:05:39 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2021/02/08 05:05:39 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2021/02/08 05:05:40 DEBUG : pacer: Reducing sleep to 15ms 2021/02/08 05:05:40 DEBUG : pacer: Reducing sleep to 11.25ms 2021/02/08 05:05:40 DEBUG : pacer: Reducing sleep to 10ms 2021/02/08 05:05:42 INFO : ␋leading VT/␋leading VT.rclone_chunk.001_77bzxy: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.001 2021/02/08 05:05:43 INFO : ␋leading VT/␋leading VT.rclone_chunk.002_77bzxy: Moved (server-side) to: ␋leading VT/␋leading VT.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:658: testing ".leading dot" 2021/02/08 05:06:01 INFO : .leading dot/.leading dot.rclone_chunk.001_77ciu7: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.001 2021/02/08 05:06:02 INFO : .leading dot/.leading dot.rclone_chunk.002_77ciu7: Moved (server-side) to: .leading dot/.leading dot.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:658: testing "trailing space " 2021/02/08 05:06:26 INFO : trailing space /trailing space .rclone_chunk.001_77d4ji: Moved (server-side) to: trailing space /trailing space .rclone_chunk.001 2021/02/08 05:06:28 INFO : trailing space /trailing space .rclone_chunk.002_77d4ji: Moved (server-side) to: trailing space /trailing space .rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:658: testing "trailing CR␍" 2021/02/08 05:06:44 INFO : trailing CR␍/trailing CR␍.rclone_chunk.001_77dpot: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.001 2021/02/08 05:06:45 INFO : trailing CR␍/trailing CR␍.rclone_chunk.002_77dpot: Moved (server-side) to: trailing CR␍/trailing CR␍.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:658: testing "trailing LF␊" 2021/02/08 05:07:03 INFO : trailing LF␊/trailing LF␊.rclone_chunk.001_77e867: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.001 2021/02/08 05:07:04 INFO : trailing LF␊/trailing LF␊.rclone_chunk.002_77e867: Moved (server-side) to: trailing LF␊/trailing LF␊.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:658: testing "trailing HT␉" 2021/02/08 05:07:26 INFO : trailing HT␉/trailing HT␉.rclone_chunk.001_77erni: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.001 2021/02/08 05:07:27 INFO : trailing HT␉/trailing HT␉.rclone_chunk.002_77erni: Moved (server-side) to: trailing HT␉/trailing HT␉.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:658: testing "trailing VT␋" 2021/02/08 05:07:45 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2021/02/08 05:07:45 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2021/02/08 05:07:46 DEBUG : pacer: Reducing sleep to 15ms 2021/02/08 05:07:46 DEBUG : pacer: Reducing sleep to 11.25ms 2021/02/08 05:07:46 DEBUG : pacer: Reducing sleep to 10ms 2021/02/08 05:07:48 INFO : trailing VT␋/trailing VT␋.rclone_chunk.001_77ff4k: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.001 2021/02/08 05:07:49 INFO : trailing VT␋/trailing VT␋.rclone_chunk.002_77ff4k: Moved (server-side) to: trailing VT␋/trailing VT␋.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:658: testing "trailing dot." 2021/02/08 05:08:06 INFO : trailing dot./trailing dot..rclone_chunk.001_77fz3c: Moved (server-side) to: trailing dot./trailing dot..rclone_chunk.001 2021/02/08 05:08:07 INFO : trailing dot./trailing dot..rclone_chunk.002_77fz3c: Moved (server-side) to: trailing dot./trailing dot..rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:658: testing "invalid utf-8\xfe" 2021/02/08 05:08:24 INFO : invalid utf-8/invalid utf-8.rclone_chunk.001_77ghvw: Moved (server-side) to: invalid utf-8/invalid utf-8.rclone_chunk.001 2021/02/08 05:08:25 INFO : invalid utf-8/invalid utf-8.rclone_chunk.002_77ghvw: Moved (server-side) to: invalid utf-8/invalid utf-8.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError fstests.go:698: Reduce file size due to limit 1024 === RUN TestIntegration/FsMkdir/FsPutZeroLength 2021/02/08 05:10:08 INFO : zero-length-file.rclone_chunk.001_77jgpb: Moved (server-side) to: zero-length-file === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:731: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsChangeNotify fstests.go:767: FS has no ChangeNotify interface === RUN TestIntegration/FsMkdir/FsPutFiles 2021/02/08 05:10:17 INFO : file name.txt.rclone_chunk.001_77jmkf: Moved (server-side) to: file name.txt.rclone_chunk.001 2021/02/08 05:10:18 INFO : file name.txt.rclone_chunk.002_77jmkf: Moved (server-side) to: file name.txt.rclone_chunk.002 2021/02/08 05:10:20 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2021/02/08 05:10:20 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2021/02/08 05:10:20 DEBUG : pacer: Reducing sleep to 15ms 2021/02/08 05:10:21 DEBUG : pacer: Reducing sleep to 11.25ms 2021/02/08 05:10:21 DEBUG : pacer: Reducing sleep to 10ms 2021/02/08 05:10:29 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_77jyo7: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001 2021/02/08 05:10:31 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002_77jyo7: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002 2021/02/08 05:10:45 INFO : file name.txt.rclone_chunk.001_77kbc4: Moved (server-side) to: file name.txt.rclone_chunk.001 2021/02/08 05:10:47 INFO : file name.txt.rclone_chunk.002_77kbc4: Moved (server-side) to: file name.txt.rclone_chunk.002 fstest.go:126: Error Trace: fstest.go:126 fstest.go:131 fstest.go:150 fstests.go:202 fstests.go:222 fstests.go:854 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles Messages: file name.txt: Modification time difference too big |-175441h5m42.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2021-02-08 05:10:49 +0000 UTC) (precision 1ns) fstest.go:126: Error Trace: fstest.go:126 fstest.go:131 fstest.go:150 fstests.go:205 fstests.go:222 fstests.go:854 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles Messages: file name.txt: Modification time difference too big |-175441h5m42.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2021-02-08 05:10:49 +0000 UTC) (precision 1ns) === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:367: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2021/02/08 05:10:54 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:" 2021/02/08 05:10:54 DEBUG : Creating backend with remote "TestYandex:" 2021/02/08 05:10:55 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:367: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:367: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:367: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 fstest.go:126: Error Trace: fstest.go:126 fstest.go:131 fstest.go:150 fstest.go:194 fstest.go:307 fstest.go:337 fstest.go:343 fstests.go:1006 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 Messages: file name.txt: Modification time difference too big |-175441h5m42.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2021-02-08 05:10:49 +0000 UTC) (precision 1ns) === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject fstest.go:126: Error Trace: fstest.go:126 fstest.go:131 fstest.go:150 fstests.go:1013 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/FsNewObject Messages: file name.txt: Modification time difference too big |-175441h5m42.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2021-02-08 05:10:49 +0000 UTC) (precision 1ns) === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive fstests.go:1020: Not Case Insensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 fstest.go:126: Error Trace: fstest.go:126 fstest.go:131 fstest.go:150 fstest.go:194 fstest.go:307 fstest.go:337 fstest.go:343 fstests.go:1033 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 Messages: file name.txt: Modification time difference too big |-175441h5m42.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2021-02-08 05:10:49 +0000 UTC) (precision 1ns) === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge 2021/02/08 05:11:12 INFO : dirToPurge/fileToPurge.txt.rclone_chunk.001_77l1jd: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.001 2021/02/08 05:11:13 INFO : dirToPurge/fileToPurge.txt.rclone_chunk.002_77l1jd: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.002 fstest.go:126: Error Trace: fstest.go:126 fstest.go:131 fstest.go:150 fstest.go:194 fstest.go:307 fstest.go:337 fstests.go:1062 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/FsPurge Messages: file name.txt: Modification time difference too big |-175441h5m42.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2021-02-08 05:10:49 +0000 UTC) (precision 1ns) fstest.go:126: Error Trace: fstest.go:126 fstest.go:131 fstest.go:150 fstest.go:194 fstest.go:307 fstest.go:337 fstests.go:1074 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/FsPurge Messages: file name.txt: Modification time difference too big |-175441h5m42.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2021-02-08 05:10:49 +0000 UTC) (precision 1ns) === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy 2021/02/08 05:11:28 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: copy 2 data chunks... fstest.go:126: Error Trace: fstest.go:126 fstest.go:131 fstest.go:150 fstest.go:194 fstest.go:307 fstest.go:337 fstest.go:343 fstests.go:1105 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/FsCopy Messages: file name.txt: Modification time difference too big |-175441h5m42.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2021-02-08 05:10:49 +0000 UTC) (precision 1ns) === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2021/02/08 05:11:41 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: move 2 data chunks... 2021/02/08 05:11:42 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001: Moved (server-side) to: other.txt.rclone_chunk.001 2021/02/08 05:11:43 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002: Moved (server-side) to: other.txt.rclone_chunk.002 2021/02/08 05:11:46 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Moved (server-side) to: other.txt fstest.go:126: Error Trace: fstest.go:126 fstest.go:131 fstest.go:150 fstest.go:194 fstest.go:307 fstest.go:337 fstest.go:343 fstests.go:1143 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/FsMove Messages: file name.txt: Modification time difference too big |-175441h5m42.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2021-02-08 05:10:49 +0000 UTC) (precision 1ns) 2021/02/08 05:11:51 DEBUG : file name.txt: move 2 data chunks... 2021/02/08 05:11:52 INFO : file name.txt.rclone_chunk.001: Moved (server-side) to: moveTest/other.txt.rclone_chunk.001 2021/02/08 05:11:53 INFO : file name.txt.rclone_chunk.002: Moved (server-side) to: moveTest/other.txt.rclone_chunk.002 2021/02/08 05:11:54 INFO : file name.txt: Moved (server-side) to: moveTest/other.txt fstest.go:126: Error Trace: fstest.go:126 fstest.go:131 fstest.go:150 fstest.go:194 fstest.go:307 fstest.go:337 fstest.go:343 fstests.go:1154 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/FsMove Messages: moveTest/other.txt: Modification time difference too big |-175441h6m47.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2021-02-08 05:11:54 +0000 UTC) (precision 1ns) 2021/02/08 05:11:59 DEBUG : moveTest/other.txt: move 2 data chunks... 2021/02/08 05:12:00 INFO : moveTest/other.txt.rclone_chunk.001: Moved (server-side) to: file name.txt.rclone_chunk.001 2021/02/08 05:12:02 INFO : moveTest/other.txt.rclone_chunk.002: Moved (server-side) to: file name.txt.rclone_chunk.002 2021/02/08 05:12:03 INFO : moveTest/other.txt: Moved (server-side) to: file name.txt fstest.go:126: Error Trace: fstest.go:126 fstest.go:131 fstest.go:150 fstest.go:194 fstest.go:307 fstest.go:337 fstest.go:343 fstests.go:1162 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/FsMove Messages: file name.txt: Modification time difference too big |-175441h6m47.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2021-02-08 05:11:54 +0000 UTC) (precision 1ns) 2021/02/08 05:12:08 DEBUG : other.txt: move 2 data chunks... 2021/02/08 05:12:09 INFO : other.txt.rclone_chunk.001: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001 2021/02/08 05:12:10 INFO : other.txt.rclone_chunk.002: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002 2021/02/08 05:12:12 INFO : other.txt: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt fstest.go:126: Error Trace: fstest.go:126 fstest.go:131 fstest.go:150 fstest.go:194 fstest.go:307 fstest.go:337 fstest.go:343 fstests.go:1169 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/FsMove Messages: file name.txt: Modification time difference too big |-175441h6m47.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2021-02-08 05:11:54 +0000 UTC) (precision 1ns) === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2021/02/08 05:12:17 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-tawigib3weqacar8xemahov9" 2021/02/08 05:12:17 DEBUG : Creating backend with remote "TestYandex:rclone-test-tawigib3weqacar8xemahov9" 2021/02/08 05:12:17 DEBUG : Reset feature "ListR" fstest.go:126: Error Trace: fstest.go:126 fstest.go:131 fstest.go:150 fstest.go:194 fstest.go:307 fstest.go:337 fstests.go:1220 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/FsDirMove Messages: new_name/sub_new_name/file name.txt: Modification time difference too big |-175441h6m47.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2021-02-08 05:11:54 +0000 UTC) (precision 1ns) fstest.go:126: Error Trace: fstest.go:126 fstest.go:131 fstest.go:150 fstest.go:194 fstest.go:307 fstest.go:337 fstests.go:1234 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/FsDirMove Messages: file name.txt: Modification time difference too big |-175441h6m47.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2021-02-08 05:11:54 +0000 UTC) (precision 1ns) 2021/02/08 05:12:32 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-tawigib3weqacar8xemahov9': 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 fstest.go:126: Error Trace: fstest.go:126 fstest.go:131 fstests.go:1315 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime Messages: file name.txt: Modification time difference too big |-175441h6m47.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2021-02-08 05:11:54 +0000 UTC) (precision 1ns) === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType fstests.go:1327: 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 2021/02/08 05:12:48 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2021/02/08 05:12:48 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2021/02/08 05:12:49 DEBUG : pacer: Reducing sleep to 15ms 2021/02/08 05:12:49 DEBUG : pacer: Reducing sleep to 11.25ms 2021/02/08 05:12:49 DEBUG : pacer: Reducing sleep to 10ms 2021/02/08 05:12:59 INFO : file name.txt.rclone_chunk.001_77nygh: Moved (server-side) to: file name.txt.rclone_chunk.001 2021/02/08 05:13:04 INFO : file name.txt.rclone_chunk.002_77nygh: Moved (server-side) to: file name.txt.rclone_chunk.002 2021/02/08 05:13:05 INFO : file name.txt.rclone_chunk.003_77nygh: Moved (server-side) to: file name.txt.rclone_chunk.003 2021/02/08 05:13:06 INFO : file name.txt.rclone_chunk.004_77nygh: Moved (server-side) to: file name.txt.rclone_chunk.004 === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2021/02/08 05:13:13 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-zivemen3kaneyiw0vutoquj4/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2021/02/08 05:13:13 DEBUG : Creating backend with remote "TestYandex:rclone-test-zivemen3kaneyiw0vutoquj4/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2021/02/08 05:13:13 DEBUG : fs cache: adding new entry for parent of "TestYandex:rclone-test-zivemen3kaneyiw0vutoquj4/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt", "TestYandex:rclone-test-zivemen3kaneyiw0vutoquj4/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠" 2021/02/08 05:13:13 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2021/02/08 05:13:13 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-zivemen3kaneyiw0vutoquj4/not found.txt" 2021/02/08 05:13:13 DEBUG : Creating backend with remote "TestYandex:rclone-test-zivemen3kaneyiw0vutoquj4/not found.txt" 2021/02/08 05:13:14 DEBUG : Reset feature "ListR" 2021/02/08 05:13:14 ERROR : : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1484: Opening root remote "TestChunkerChunk50bYandex:" path "rclone-test-zivemen3kaneyiw0vutoquj4" from "TestChunkerChunk50bYandex:rclone-test-zivemen3kaneyiw0vutoquj4" 2021/02/08 05:13:14 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:" 2021/02/08 05:13:14 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1518: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put 2021/02/08 05:13:22 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2021/02/08 05:13:22 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2021/02/08 05:13:22 DEBUG : pacer: Reducing sleep to 15ms 2021/02/08 05:13:22 DEBUG : pacer: Reducing sleep to 11.25ms 2021/02/08 05:13:22 DEBUG : pacer: Reducing sleep to 10ms 2021/02/08 05:13:26 INFO : rclone-test-zivemen3kaneyiw0vutoquj4/created from root.txt.rclone_chunk.001_77os7z: Moved (server-side) to: rclone-test-zivemen3kaneyiw0vutoquj4/created from root.txt.rclone_chunk.001 2021/02/08 05:13:27 INFO : rclone-test-zivemen3kaneyiw0vutoquj4/created from root.txt.rclone_chunk.002_77os7z: Moved (server-side) to: rclone-test-zivemen3kaneyiw0vutoquj4/created from root.txt.rclone_chunk.002 fstest.go:126: Error Trace: fstest.go:126 fstest.go:131 fstest.go:150 fstests.go:202 fstests.go:212 fstests.go:217 fstests.go:1559 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put Messages: rclone-test-zivemen3kaneyiw0vutoquj4/created from root.txt: Modification time difference too big |-11.196566638s| > 1ns (want 2021-02-08 05:13:16.803433362 +0000 UTC m=+655.015797017 vs got 2021-02-08 05:13:28 +0000 UTC) (precision 1ns) fstest.go:126: Error Trace: fstest.go:126 fstest.go:131 fstest.go:150 fstests.go:205 fstests.go:212 fstests.go:217 fstests.go:1559 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put Messages: rclone-test-zivemen3kaneyiw0vutoquj4/created from root.txt: Modification time difference too big |-11.196566638s| > 1ns (want 2021-02-08 05:13:16.803433362 +0000 UTC m=+655.015797017 vs got 2021-02-08 05:13:28 +0000 UTC) (precision 1ns) fstest.go:126: Error Trace: fstest.go:126 fstest.go:131 fstest.go:150 fstest.go:194 fstest.go:307 fstests.go:1560 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put Messages: rclone-test-zivemen3kaneyiw0vutoquj4/created from root.txt: Modification time difference too big |-11.196566638s| > 1ns (want 2021-02-08 05:13:16.803433362 +0000 UTC m=+655.015797017 vs got 2021-02-08 05:13:28 +0000 UTC) (precision 1ns) === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink fstests.go:1577: FS has no PublicLinker interface === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:381: 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 2021/02/08 05:13:52 INFO : piped data.txt.rclone_chunk.001_77po3t: Moved (server-side) to: piped data.txt === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2021/02/08 05:14:01 INFO : piped data.txt.rclone_chunk.001_77ptnq: Moved (server-side) to: piped data.txt.rclone_chunk.001 2021/02/08 05:14:03 INFO : piped data.txt.rclone_chunk.002_77ptnq: Moved (server-side) to: piped data.txt.rclone_chunk.002 2021/02/08 05:14:04 INFO : piped data.txt.rclone_chunk.003_77ptnq: Moved (server-side) to: piped data.txt.rclone_chunk.003 fstest.go:126: Error Trace: fstest.go:126 fstest.go:131 fstest.go:150 fstests.go:1738 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 Messages: piped data.txt: Modification time difference too big |-175441h8m59.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2021-02-08 05:14:06 +0000 UTC) (precision 1ns) fstest.go:126: Error Trace: fstest.go:126 fstest.go:131 fstest.go:150 fstests.go:1741 Error: Should be true Test: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 Messages: piped data.txt: Modification time difference too big |-175441h8m59.500000001s| > 1ns (want 2001-02-03 04:05:06.499999999 +0000 UTC vs got 2021-02-08 05:14:06 +0000 UTC) (precision 1ns) === RUN TestIntegration/FsMkdir/FsPutFiles/Internal === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge chunker_internal_test.go:745: -upload-kilobytes is not set === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat 2021/02/08 05:14:14 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-zivemen3kaneyiw0vutoquj4': invalid data chunk number in file "fish.chunk.001" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals 2021/02/08 05:14:17 INFO : small/emptyfile.rclone_chunk.001_77qehx: Moved (server-side) to: small/emptyfile 2021/02/08 05:14:23 INFO : small/smallfile.rclone_chunk.001_77qk66: Moved (server-side) to: small/smallfile === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption 2021/02/08 05:14:41 INFO : corrupted/billy.rclone_chunk.001_77qro8: Moved (server-side) to: corrupted/billy.rclone_chunk.001 2021/02/08 05:14:42 INFO : corrupted/billy.rclone_chunk.002_77qro8: Moved (server-side) to: corrupted/billy.rclone_chunk.002 2021/02/08 05:14:43 INFO : corrupted/billy.rclone_chunk.003_77qro8: Moved (server-side) to: corrupted/billy.rclone_chunk.003 2021/02/08 05:14:44 INFO : corrupted/billy.rclone_chunk.004_77qro8: Moved (server-side) to: corrupted/billy.rclone_chunk.004 2021/02/08 05:14:46 INFO : corrupted/billy.rclone_chunk.005_77qro8: Moved (server-side) to: corrupted/billy.rclone_chunk.005 2021/02/08 05:15:02 INFO : corrupted/silly1.rclone_chunk.001_77re79: Moved (server-side) to: corrupted/silly1.rclone_chunk.001 2021/02/08 05:15:03 INFO : corrupted/silly1.rclone_chunk.002_77re79: Moved (server-side) to: corrupted/silly1.rclone_chunk.002 2021/02/08 05:15:04 INFO : corrupted/silly1.rclone_chunk.003_77re79: Moved (server-side) to: corrupted/silly1.rclone_chunk.003 2021/02/08 05:15:06 INFO : corrupted/silly1.rclone_chunk.004_77re79: Moved (server-side) to: corrupted/silly1.rclone_chunk.004 2021/02/08 05:15:07 INFO : corrupted/silly1.rclone_chunk.005_77re79: Moved (server-side) to: corrupted/silly1.rclone_chunk.005 2021/02/08 05:15:25 INFO : corrupted/silly2.rclone_chunk.001_77ryie: Moved (server-side) to: corrupted/silly2.rclone_chunk.001 2021/02/08 05:15:26 INFO : corrupted/silly2.rclone_chunk.002_77ryie: Moved (server-side) to: corrupted/silly2.rclone_chunk.002 2021/02/08 05:15:27 INFO : corrupted/silly2.rclone_chunk.003_77ryie: Moved (server-side) to: corrupted/silly2.rclone_chunk.003 2021/02/08 05:15:29 INFO : corrupted/silly2.rclone_chunk.004_77ryie: Moved (server-side) to: corrupted/silly2.rclone_chunk.004 2021/02/08 05:15:30 INFO : corrupted/silly2.rclone_chunk.005_77ryie: Moved (server-side) to: corrupted/silly2.rclone_chunk.005 2021/02/08 05:15:46 INFO : corrupted/silly3.rclone_chunk.001_77sm1v: Moved (server-side) to: corrupted/silly3.rclone_chunk.001 2021/02/08 05:15:47 INFO : corrupted/silly3.rclone_chunk.002_77sm1v: Moved (server-side) to: corrupted/silly3.rclone_chunk.002 2021/02/08 05:15:48 INFO : corrupted/silly3.rclone_chunk.003_77sm1v: Moved (server-side) to: corrupted/silly3.rclone_chunk.003 2021/02/08 05:15:50 INFO : corrupted/silly3.rclone_chunk.004_77sm1v: Moved (server-side) to: corrupted/silly3.rclone_chunk.004 2021/02/08 05:15:51 INFO : corrupted/silly3.rclone_chunk.005_77sm1v: Moved (server-side) to: corrupted/silly3.rclone_chunk.005 2021/02/08 05:16:06 INFO : corrupted/willy.rclone_chunk.001_77t6om: Moved (server-side) to: corrupted/willy.rclone_chunk.001 2021/02/08 05:16:08 INFO : corrupted/willy.rclone_chunk.002_77t6om: Moved (server-side) to: corrupted/willy.rclone_chunk.002 2021/02/08 05:16:09 INFO : corrupted/willy.rclone_chunk.003_77t6om: Moved (server-side) to: corrupted/willy.rclone_chunk.003 2021/02/08 05:16:10 INFO : corrupted/willy.rclone_chunk.004_77t6om: Moved (server-side) to: corrupted/willy.rclone_chunk.004 2021/02/08 05:16:12 INFO : corrupted/willy.rclone_chunk.005_77t6om: Moved (server-side) to: corrupted/willy.rclone_chunk.005 2021/02/08 05:16:30 INFO : corrupted/silly4.rclone_chunk.001_77trjh: Moved (server-side) to: corrupted/silly4.rclone_chunk.001 2021/02/08 05:16:32 INFO : corrupted/silly4.rclone_chunk.002_77trjh: Moved (server-side) to: corrupted/silly4.rclone_chunk.002 2021/02/08 05:16:33 INFO : corrupted/silly4.rclone_chunk.003_77trjh: Moved (server-side) to: corrupted/silly4.rclone_chunk.003 2021/02/08 05:16:34 INFO : corrupted/silly4.rclone_chunk.004_77trjh: Moved (server-side) to: corrupted/silly4.rclone_chunk.004 2021/02/08 05:16:36 INFO : corrupted/silly4.rclone_chunk.005_77trjh: Moved (server-side) to: corrupted/silly4.rclone_chunk.005 2021/02/08 05:16:39 ERROR : corrupted/silly4: Failed to copy: can't copy: chunk overlap with "corrupted/willy" 2021/02/08 05:16:51 INFO : corrupted/silly5.rclone_chunk.001_77ufne: Moved (server-side) to: corrupted/silly5.rclone_chunk.001 2021/02/08 05:16:52 INFO : corrupted/silly5.rclone_chunk.002_77ufne: Moved (server-side) to: corrupted/silly5.rclone_chunk.002 2021/02/08 05:16:54 INFO : corrupted/silly5.rclone_chunk.003_77ufne: Moved (server-side) to: corrupted/silly5.rclone_chunk.003 2021/02/08 05:16:55 INFO : corrupted/silly5.rclone_chunk.004_77ufne: Moved (server-side) to: corrupted/silly5.rclone_chunk.004 2021/02/08 05:16:56 INFO : corrupted/silly5.rclone_chunk.005_77ufne: Moved (server-side) to: corrupted/silly5.rclone_chunk.005 2021/02/08 05:16:59 ERROR : corrupted/willy.rclone_chunk.002: Couldn't delete: refuse to corrupt: chunk overlap with "corrupted/willy" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow 2021/02/08 05:17:17 INFO : wreaked/wreaker.rclone_chunk.001_77v9ut: Moved (server-side) to: wreaked/wreaker.rclone_chunk.001 2021/02/08 05:17:18 INFO : wreaked/wreaker.rclone_chunk.002_77v9ut: Moved (server-side) to: wreaked/wreaker.rclone_chunk.002 2021/02/08 05:17:25 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-zivemen3kaneyiw0vutoquj4': invalid directory entry "wreaked/wreaker" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput 2021/02/08 05:17:37 ERROR : usermeta/today.rclone_chunk.001_77vy6u: Couldn't move: couldn't move file: [409 - DiskResourceAlreadyExistsError] Resource "disk:/rclone-test-zivemen3kaneyiw0vutoquj4/usermeta/today.rclone_chunk.001" already exists. (Ресурс "disk:/rclone-test-zivemen3kaneyiw0vutoquj4/usermeta/today.rclone_chunk.001" уже существует.) 2021/02/08 05:17:39 INFO : usermeta/today.rclone_chunk.001: Deleted 2021/02/08 05:17:40 INFO : usermeta/today.rclone_chunk.001_77vy6u: Moved (server-side) to: usermeta/today.rclone_chunk.001 2021/02/08 05:17:53 ERROR : usermeta/past.rclone_chunk.001_77wcsg: Couldn't move: couldn't move file: [409 - DiskResourceAlreadyExistsError] Resource "disk:/rclone-test-zivemen3kaneyiw0vutoquj4/usermeta/past.rclone_chunk.001" already exists. (Ресурс "disk:/rclone-test-zivemen3kaneyiw0vutoquj4/usermeta/past.rclone_chunk.001" уже существует.) 2021/02/08 05:17:54 INFO : usermeta/past.rclone_chunk.001: Deleted 2021/02/08 05:17:55 INFO : usermeta/past.rclone_chunk.001_77wcsg: Moved (server-side) to: usermeta/past.rclone_chunk.001 2021/02/08 05:18:06 ERROR : usermeta/future.rclone_chunk.001_77wrvq: Couldn't move: couldn't move file: [409 - DiskResourceAlreadyExistsError] Resource "disk:/rclone-test-zivemen3kaneyiw0vutoquj4/usermeta/future.rclone_chunk.001" already exists. (Ресурс "disk:/rclone-test-zivemen3kaneyiw0vutoquj4/usermeta/future.rclone_chunk.001" уже существует.) 2021/02/08 05:18:07 INFO : usermeta/future.rclone_chunk.001: Deleted 2021/02/08 05:18:09 INFO : usermeta/future.rclone_chunk.001_77wrvq: Moved (server-side) to: usermeta/future.rclone_chunk.001 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof 2021/02/08 05:18:26 DEBUG : future/test: Can't move - required hash not found 2021/02/08 05:18:26 DEBUG : future/test: Can't move, switching to copy 2021/02/08 05:18:26 DEBUG : future/test: Can't copy - required hash not found 2021/02/08 05:18:27 ERROR : future/test: Failed to copy: failed to open source object: can't open: unknown metadata, please upgrade rclone 2021/02/08 05:18:27 ERROR : future/test: Not deleting source as copy failed: failed to open source object: can't open: unknown metadata, please upgrade rclone 2021/02/08 05:18:27 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-zivemen3kaneyiw0vutoquj4': File to upload is small (3 bytes), uploading instead of streaming 2021/02/08 05:18:28 ERROR : future/test: Failed to copy: refusing to put: unknown metadata, please upgrade rclone === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:1770: *chunker.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize 2021/02/08 05:18:40 INFO : unknown-size-put.txt.rclone_chunk.001_77xky3: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.001 2021/02/08 05:18:42 INFO : unknown-size-put.txt.rclone_chunk.002_77xky3: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.002 2021/02/08 05:18:43 INFO : unknown-size-put.txt.rclone_chunk.003_77xky3: Moved (server-side) to: unknown-size-put.txt.rclone_chunk.003 === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize 2021/02/08 05:18:58 INFO : unknown-size-update.txt.rclone_chunk.001_77y1zd: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001 2021/02/08 05:18:59 INFO : unknown-size-update.txt.rclone_chunk.002_77y1zd: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002 2021/02/08 05:19:25 INFO : unknown-size-update.txt.rclone_chunk.001_77ygqa: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.001 2021/02/08 05:19:26 INFO : unknown-size-update.txt.rclone_chunk.002_77ygqa: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.002 2021/02/08 05:19:27 INFO : unknown-size-update.txt.rclone_chunk.003_77ygqa: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.003 2021/02/08 05:19:29 INFO : unknown-size-update.txt.rclone_chunk.004_77ygqa: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.004 2021/02/08 05:19:30 INFO : unknown-size-update.txt.rclone_chunk.005_77ygqa: Moved (server-side) to: unknown-size-update.txt.rclone_chunk.005 === RUN TestIntegration/FsMkdir/FsRootCollapse 2021/02/08 05:19:40 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-zivemen3kaneyiw0vutoquj4/deeper/nonexisting/directory" 2021/02/08 05:19:40 DEBUG : Creating backend with remote "TestYandex:rclone-test-zivemen3kaneyiw0vutoquj4/deeper/nonexisting/directory" 2021/02/08 05:19:40 DEBUG : Reset feature "ListR" 2021/02/08 05:19:44 ERROR : : error listing: directory not found === CONT TestIntegration/FsMkdir fstests.go:1952: Warning: this should produce fs.ErrorDirNotFound === RUN TestIntegration/FsShutdown fstests.go:1966: Shutdown method not supported --- FAIL: TestIntegration (1043.18s) --- PASS: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.20s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (1.15s) --- FAIL: TestIntegration/FsMkdir (1040.42s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (5.47s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.24s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.20s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.16s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- FAIL: TestIntegration/FsMkdir/FsEncoding (363.55s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (19.38s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (20.41s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (19.82s) --- FAIL: TestIntegration/FsMkdir/FsEncoding/punctuation (23.09s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (20.64s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (20.20s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (20.49s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (19.19s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (18.75s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (19.29s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (22.52s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (21.19s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (18.53s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (18.87s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (23.22s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (21.15s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (17.87s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (18.74s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutError (88.91s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (5.76s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsChangeNotify (0.00s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles (502.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.11s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (1.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.76s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.57s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.43s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.45s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (1.64s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.71s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (2.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.23s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsPurge (26.48s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsCopy (12.50s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsMove (37.31s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (16.62s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.18s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.46s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.35s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.41s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.70s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.38s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.45s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (1.53s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.60s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (1.77s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (1.69s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (2.22s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (1.14s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (26.68s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.58s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.77s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.60s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FromRoot (26.95s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (1.73s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.49s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (24.73s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (4.94s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.34s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (6.50s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.18s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (25.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (5.19s) --- FAIL: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (20.55s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (258.23s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat (0.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals (12.85s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption (162.22s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow (22.77s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput (44.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof (16.10s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (67.71s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (16.95s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (50.76s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (0.45s) --- SKIP: TestIntegration/FsShutdown (0.00s) FAIL exit status 1 FAIL github.com/rclone/rclone/backend/chunker 1043.252s "go test -v -timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024" - Finished ERROR in 17m31.063456306s (try 1/5): exit status 1: Failed [TestIntegration/FsMkdir/FsEncoding/punctuation TestIntegration/FsMkdir/FsPutFiles/FsListFile1 TestIntegration/FsMkdir/FsPutFiles/FsNewObject TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 TestIntegration/FsMkdir/FsPutFiles/FsPurge TestIntegration/FsMkdir/FsPutFiles/FsCopy TestIntegration/FsMkdir/FsPutFiles/FsMove TestIntegration/FsMkdir/FsPutFiles/FsDirMove TestIntegration/FsMkdir/FsPutFiles/ObjectModTime TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100]