"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$'" - Starting (try 3/5) === RUN TestIntegration fstests.go:418: Using remote "TestChunkerChunk50bYandex:" 2022/03/23 06:20:22 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-zopasef8mupifay5yumaxev4" 2022/03/23 06:20:22 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2022/03/23 06:20:22 DEBUG : Creating backend with remote "TestYandex:rclone-test-zopasef8mupifay5yumaxev4" 2022/03/23 06:20:22 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsMkdir === RUN TestIntegration/FsMkdir/FsPutFiles 2022/03/23 06:20:41 INFO : file name.txt.rclone_chunk.001_6uwtrz: Moved (server-side) to: file name.txt.rclone_chunk.001 2022/03/23 06:20:42 INFO : file name.txt.rclone_chunk.002_6uwtrz: Moved (server-side) to: file name.txt.rclone_chunk.002 2022/03/23 06:20:56 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001_6uxd0k: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001 2022/03/23 06:20:57 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002_6uxd0k: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002 2022/03/23 06:21:14 INFO : file name.txt.rclone_chunk.001_6uxuem: Moved (server-side) to: file name.txt.rclone_chunk.001 2022/03/23 06:21:15 INFO : file name.txt.rclone_chunk.002_6uxuem: 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/03/23 06:21:23 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:" 2022/03/23 06:21:23 DEBUG : Creating backend with remote "TestYandex:" 2022/03/23 06:21:24 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/03/23 06:21:44 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2022/03/23 06:21:44 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2022/03/23 06:21:45 DEBUG : pacer: Reducing sleep to 15ms 2022/03/23 06:21:45 DEBUG : pacer: Reducing sleep to 11.25ms 2022/03/23 06:21:46 DEBUG : pacer: Reducing sleep to 10ms 2022/03/23 06:21:50 INFO : dirToPurge/fileToPurge.txt.rclone_chunk.001_6uymuf: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.001 2022/03/23 06:21:52 INFO : dirToPurge/fileToPurge.txt.rclone_chunk.002_6uymuf: Moved (server-side) to: dirToPurge/fileToPurge.txt.rclone_chunk.002 === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy 2022/03/23 06:22:03 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: copy 2 data chunks... === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove 2022/03/23 06:22:18 DEBUG : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: move 2 data chunks... 2022/03/23 06:22:19 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001: Moved (server-side) to: other.txt.rclone_chunk.001 2022/03/23 06:22:20 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002: Moved (server-side) to: other.txt.rclone_chunk.002 2022/03/23 06:22:21 INFO : hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt: Moved (server-side) to: other.txt 2022/03/23 06:22:27 DEBUG : file name.txt: move 2 data chunks... 2022/03/23 06:22:29 INFO : file name.txt.rclone_chunk.001: Moved (server-side) to: moveTest/other.txt.rclone_chunk.001 2022/03/23 06:22:30 INFO : file name.txt.rclone_chunk.002: Moved (server-side) to: moveTest/other.txt.rclone_chunk.002 2022/03/23 06:22:32 INFO : file name.txt: Moved (server-side) to: moveTest/other.txt 2022/03/23 06:22:37 DEBUG : moveTest/other.txt: move 2 data chunks... 2022/03/23 06:22:38 INFO : moveTest/other.txt.rclone_chunk.001: Moved (server-side) to: file name.txt.rclone_chunk.001 2022/03/23 06:22:40 INFO : moveTest/other.txt.rclone_chunk.002: Moved (server-side) to: file name.txt.rclone_chunk.002 2022/03/23 06:22:41 INFO : moveTest/other.txt: Moved (server-side) to: file name.txt 2022/03/23 06:22:47 DEBUG : other.txt: move 2 data chunks... 2022/03/23 06:22:48 INFO : other.txt.rclone_chunk.001: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.001 2022/03/23 06:22:50 INFO : other.txt.rclone_chunk.002: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt.rclone_chunk.002 2022/03/23 06:22:54 INFO : other.txt: Moved (server-side) to: hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2022/03/23 06:23:00 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-giwofer2giwobeq2xikiwec3" 2022/03/23 06:23:00 DEBUG : Creating backend with remote "TestYandex:rclone-test-giwofer2giwobeq2xikiwec3" 2022/03/23 06:23:00 DEBUG : Reset feature "ListR" 2022/03/23 06:23:13 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-giwofer2giwobeq2xikiwec3': 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/03/23 06:23:45 INFO : file name.txt.rclone_chunk.001_6v1uw9: Moved (server-side) to: file name.txt.rclone_chunk.001 2022/03/23 06:23:46 INFO : file name.txt.rclone_chunk.002_6v1uw9: Moved (server-side) to: file name.txt.rclone_chunk.002 2022/03/23 06:23:47 INFO : file name.txt.rclone_chunk.003_6v1uw9: Moved (server-side) to: file name.txt.rclone_chunk.003 2022/03/23 06:23:49 INFO : file name.txt.rclone_chunk.004_6v1uw9: Moved (server-side) to: file name.txt.rclone_chunk.004 === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2022/03/23 06:23:55 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-zopasef8mupifay5yumaxev4/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2022/03/23 06:23:55 DEBUG : Creating backend with remote "TestYandex:rclone-test-zopasef8mupifay5yumaxev4/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" 2022/03/23 06:23:55 DEBUG : fs cache: adding new entry for parent of "TestYandex:rclone-test-zopasef8mupifay5yumaxev4/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt", "TestYandex:rclone-test-zopasef8mupifay5yumaxev4/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠" 2022/03/23 06:23:55 DEBUG : Reset feature "ListR" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2022/03/23 06:23:55 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-zopasef8mupifay5yumaxev4/not found.txt" 2022/03/23 06:23:55 DEBUG : Creating backend with remote "TestYandex:rclone-test-zopasef8mupifay5yumaxev4/not found.txt" 2022/03/23 06:23:56 DEBUG : Reset feature "ListR" 2022/03/23 06:23:56 ERROR : : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1503: Opening root remote "TestChunkerChunk50bYandex:" path "rclone-test-zopasef8mupifay5yumaxev4" from "TestChunkerChunk50bYandex:rclone-test-zopasef8mupifay5yumaxev4" 2022/03/23 06:23:56 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:" 2022/03/23 06:23:56 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/03/23 06:24:12 INFO : rclone-test-zopasef8mupifay5yumaxev4/created from root.txt.rclone_chunk.001_6v2r4c: Moved (server-side) to: rclone-test-zopasef8mupifay5yumaxev4/created from root.txt.rclone_chunk.001 2022/03/23 06:24:13 INFO : rclone-test-zopasef8mupifay5yumaxev4/created from root.txt.rclone_chunk.002_6v2r4c: Moved (server-side) to: rclone-test-zopasef8mupifay5yumaxev4/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/03/23 06:24:33 INFO : piped data.txt.rclone_chunk.001_6v3keg: Moved (server-side) to: piped data.txt === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 2022/03/23 06:24:37 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2022/03/23 06:24:37 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2022/03/23 06:24:38 DEBUG : pacer: Reducing sleep to 15ms 2022/03/23 06:24:38 DEBUG : pacer: Reducing sleep to 11.25ms 2022/03/23 06:24:39 DEBUG : pacer: Reducing sleep to 10ms 2022/03/23 06:24:48 INFO : piped data.txt.rclone_chunk.001_6v3qix: Moved (server-side) to: piped data.txt.rclone_chunk.001 2022/03/23 06:24:52 INFO : piped data.txt.rclone_chunk.002_6v3qix: Moved (server-side) to: piped data.txt.rclone_chunk.002 2022/03/23 06:24:54 INFO : piped data.txt.rclone_chunk.003_6v3qix: 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/03/23 06:25:01 INFO : Chunked 'TestChunkerChunk50bYandex:rclone-test-zopasef8mupifay5yumaxev4': invalid data chunk number in file "fish.chunk.001" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals 2022/03/23 06:25:06 INFO : small/emptyfile.rclone_chunk.001_6v4go4: Moved (server-side) to: small/emptyfile 2022/03/23 06:25:13 INFO : small/smallfile.rclone_chunk.001_6v4n1v: Moved (server-side) to: small/smallfile === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption 2022/03/23 06:25:27 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2022/03/23 06:25:27 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2022/03/23 06:25:27 DEBUG : pacer: Reducing sleep to 15ms 2022/03/23 06:25:28 DEBUG : pacer: Reducing sleep to 11.25ms 2022/03/23 06:25:28 DEBUG : pacer: Reducing sleep to 10ms 2022/03/23 06:25:33 INFO : corrupted/billy.rclone_chunk.001_6v4xu0: Moved (server-side) to: corrupted/billy.rclone_chunk.001 2022/03/23 06:25:34 INFO : corrupted/billy.rclone_chunk.002_6v4xu0: Moved (server-side) to: corrupted/billy.rclone_chunk.002 2022/03/23 06:25:36 INFO : corrupted/billy.rclone_chunk.003_6v4xu0: Moved (server-side) to: corrupted/billy.rclone_chunk.003 2022/03/23 06:25:37 INFO : corrupted/billy.rclone_chunk.004_6v4xu0: Moved (server-side) to: corrupted/billy.rclone_chunk.004 2022/03/23 06:25:39 INFO : corrupted/billy.rclone_chunk.005_6v4xu0: Moved (server-side) to: corrupted/billy.rclone_chunk.005 2022/03/23 06:26:09 INFO : corrupted/silly1.rclone_chunk.001_6v5oen: Moved (server-side) to: corrupted/silly1.rclone_chunk.001 2022/03/23 06:26:11 INFO : corrupted/silly1.rclone_chunk.002_6v5oen: Moved (server-side) to: corrupted/silly1.rclone_chunk.002 2022/03/23 06:26:15 INFO : corrupted/silly1.rclone_chunk.003_6v5oen: Moved (server-side) to: corrupted/silly1.rclone_chunk.003 2022/03/23 06:26:17 INFO : corrupted/silly1.rclone_chunk.004_6v5oen: Moved (server-side) to: corrupted/silly1.rclone_chunk.004 2022/03/23 06:26:19 INFO : corrupted/silly1.rclone_chunk.005_6v5oen: Moved (server-side) to: corrupted/silly1.rclone_chunk.005 2022/03/23 06:26:35 INFO : corrupted/silly2.rclone_chunk.001_6v6qda: Moved (server-side) to: corrupted/silly2.rclone_chunk.001 2022/03/23 06:26:37 INFO : corrupted/silly2.rclone_chunk.002_6v6qda: Moved (server-side) to: corrupted/silly2.rclone_chunk.002 2022/03/23 06:26:38 INFO : corrupted/silly2.rclone_chunk.003_6v6qda: Moved (server-side) to: corrupted/silly2.rclone_chunk.003 2022/03/23 06:26:40 INFO : corrupted/silly2.rclone_chunk.004_6v6qda: Moved (server-side) to: corrupted/silly2.rclone_chunk.004 2022/03/23 06:26:42 INFO : corrupted/silly2.rclone_chunk.005_6v6qda: Moved (server-side) to: corrupted/silly2.rclone_chunk.005 2022/03/23 06:27:05 INFO : corrupted/silly3.rclone_chunk.001_6v7e1l: Moved (server-side) to: corrupted/silly3.rclone_chunk.001 2022/03/23 06:27:07 INFO : corrupted/silly3.rclone_chunk.002_6v7e1l: Moved (server-side) to: corrupted/silly3.rclone_chunk.002 2022/03/23 06:27:09 INFO : corrupted/silly3.rclone_chunk.003_6v7e1l: Moved (server-side) to: corrupted/silly3.rclone_chunk.003 2022/03/23 06:27:11 INFO : corrupted/silly3.rclone_chunk.004_6v7e1l: Moved (server-side) to: corrupted/silly3.rclone_chunk.004 2022/03/23 06:27:12 INFO : corrupted/silly3.rclone_chunk.005_6v7e1l: Moved (server-side) to: corrupted/silly3.rclone_chunk.005 2022/03/23 06:27:34 INFO : corrupted/willy.rclone_chunk.001_6v87nh: Moved (server-side) to: corrupted/willy.rclone_chunk.001 2022/03/23 06:27:36 INFO : corrupted/willy.rclone_chunk.002_6v87nh: Moved (server-side) to: corrupted/willy.rclone_chunk.002 2022/03/23 06:27:38 INFO : corrupted/willy.rclone_chunk.003_6v87nh: Moved (server-side) to: corrupted/willy.rclone_chunk.003 2022/03/23 06:27:39 INFO : corrupted/willy.rclone_chunk.004_6v87nh: Moved (server-side) to: corrupted/willy.rclone_chunk.004 2022/03/23 06:27:41 INFO : corrupted/willy.rclone_chunk.005_6v87nh: Moved (server-side) to: corrupted/willy.rclone_chunk.005 2022/03/23 06:28:00 INFO : corrupted/silly4.rclone_chunk.001_6v91a0: Moved (server-side) to: corrupted/silly4.rclone_chunk.001 2022/03/23 06:28:01 INFO : corrupted/silly4.rclone_chunk.002_6v91a0: Moved (server-side) to: corrupted/silly4.rclone_chunk.002 2022/03/23 06:28:03 INFO : corrupted/silly4.rclone_chunk.003_6v91a0: Moved (server-side) to: corrupted/silly4.rclone_chunk.003 2022/03/23 06:28:06 INFO : corrupted/silly4.rclone_chunk.004_6v91a0: Moved (server-side) to: corrupted/silly4.rclone_chunk.004 2022/03/23 06:28:07 INFO : corrupted/silly4.rclone_chunk.005_6v91a0: Moved (server-side) to: corrupted/silly4.rclone_chunk.005 2022/03/23 06:28:12 ERROR : corrupted/silly4: Failed to copy: can't copy: chunk overlap with "corrupted/willy" 2022/03/23 06:28:29 INFO : corrupted/silly5.rclone_chunk.001_6v9stm: Moved (server-side) to: corrupted/silly5.rclone_chunk.001 2022/03/23 06:28:30 INFO : corrupted/silly5.rclone_chunk.002_6v9stm: Moved (server-side) to: corrupted/silly5.rclone_chunk.002 2022/03/23 06:28:32 INFO : corrupted/silly5.rclone_chunk.003_6v9stm: Moved (server-side) to: corrupted/silly5.rclone_chunk.003 2022/03/23 06:28:33 INFO : corrupted/silly5.rclone_chunk.004_6v9stm: Moved (server-side) to: corrupted/silly5.rclone_chunk.004 2022/03/23 06:28:35 INFO : corrupted/silly5.rclone_chunk.005_6v9stm: Moved (server-side) to: corrupted/silly5.rclone_chunk.005 2022/03/23 06:28:39 ERROR : corrupted/willy.rclone_chunk.002: Couldn't delete: refuse to corrupt: chunk overlap with "corrupted/willy" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow 2022/03/23 06:29:00 INFO : wreaked/wreaker.rclone_chunk.001_6vavid: Moved (server-side) to: wreaked/wreaker.rclone_chunk.001 2022/03/23 06:29:02 INFO : wreaked/wreaker.rclone_chunk.002_6vavid: Moved (server-side) to: wreaked/wreaker.rclone_chunk.002 2022/03/23 06:29:12 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-zopasef8mupifay5yumaxev4': invalid directory entry "wreaked/wreaker" === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput 2022/03/23 06:29:30 ERROR : usermeta/today.rclone_chunk.001_6vbsx4: Couldn't move: couldn't move file: [409 - DiskResourceAlreadyExistsError] Resource "disk:/rclone-test-zopasef8mupifay5yumaxev4/usermeta/today.rclone_chunk.001" already exists. (Ресурс "disk:/rclone-test-zopasef8mupifay5yumaxev4/usermeta/today.rclone_chunk.001" уже существует.) 2022/03/23 06:29:31 INFO : usermeta/today.rclone_chunk.001: Deleted 2022/03/23 06:29:32 INFO : usermeta/today.rclone_chunk.001_6vbsx4: Moved (server-side) to: usermeta/today.rclone_chunk.001 2022/03/23 06:29:46 ERROR : usermeta/past.rclone_chunk.001_6vcacy: Couldn't move: couldn't move file: [409 - DiskResourceAlreadyExistsError] Resource "disk:/rclone-test-zopasef8mupifay5yumaxev4/usermeta/past.rclone_chunk.001" already exists. (Ресурс "disk:/rclone-test-zopasef8mupifay5yumaxev4/usermeta/past.rclone_chunk.001" уже существует.) 2022/03/23 06:29:47 INFO : usermeta/past.rclone_chunk.001: Deleted 2022/03/23 06:29:48 INFO : usermeta/past.rclone_chunk.001_6vcacy: Moved (server-side) to: usermeta/past.rclone_chunk.001 2022/03/23 06:30:02 ERROR : usermeta/future.rclone_chunk.001_6vcp37: Couldn't move: couldn't move file: [409 - DiskResourceAlreadyExistsError] Resource "disk:/rclone-test-zopasef8mupifay5yumaxev4/usermeta/future.rclone_chunk.001" already exists. (Ресурс "disk:/rclone-test-zopasef8mupifay5yumaxev4/usermeta/future.rclone_chunk.001" уже существует.) 2022/03/23 06:30:02 INFO : usermeta/future.rclone_chunk.001: Deleted 2022/03/23 06:30:04 INFO : usermeta/future.rclone_chunk.001_6vcp37: Moved (server-side) to: usermeta/future.rclone_chunk.001 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof 2022/03/23 06:30:26 DEBUG : future/test: Can't move - required hash not found 2022/03/23 06:30:26 DEBUG : future/test: Can't move, switching to copy 2022/03/23 06:30:27 DEBUG : future/test: Can't copy - required hash not found 2022/03/23 06:30:27 ERROR : future/test: Failed to copy: failed to open source object: can't open: unknown metadata, please upgrade rclone 2022/03/23 06:30:27 ERROR : future/test: Not deleting source as copy failed: failed to open source object: can't open: unknown metadata, please upgrade rclone 2022/03/23 06:30:28 DEBUG : Chunked 'TestChunkerChunk50bYandex:rclone-test-zopasef8mupifay5yumaxev4': File to upload is small (3 bytes), uploading instead of streaming 2022/03/23 06:30:28 ERROR : future/test: Failed to copy: refusing to put: unknown metadata, please upgrade rclone === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility 2022/03/23 06:30:37 DEBUG : pacer: low level retry 1/10 (error [500 - InternalServerError] Internal Server Error (Ошибка сервера.)) 2022/03/23 06:30:37 DEBUG : pacer: Rate limited, increasing sleep to 20ms 2022/03/23 06:30:38 DEBUG : pacer: Reducing sleep to 15ms 2022/03/23 06:30:38 DEBUG : pacer: Reducing sleep to 11.25ms 2022/03/23 06:30:39 DEBUG : pacer: Reducing sleep to 10ms 2022/03/23 06:32:02 INFO : backcomp/renamefile.rclone_chunk.001_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.001 2022/03/23 06:32:03 INFO : backcomp/renamefile.rclone_chunk.002_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.002 2022/03/23 06:32:04 INFO : backcomp/renamefile.rclone_chunk.003_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.003 2022/03/23 06:32:05 INFO : backcomp/renamefile.rclone_chunk.004_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.004 2022/03/23 06:32:07 INFO : backcomp/renamefile.rclone_chunk.005_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.005 2022/03/23 06:32:08 INFO : backcomp/renamefile.rclone_chunk.006_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.006 2022/03/23 06:32:09 INFO : backcomp/renamefile.rclone_chunk.007_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.007 2022/03/23 06:32:10 INFO : backcomp/renamefile.rclone_chunk.008_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.008 2022/03/23 06:32:12 INFO : backcomp/renamefile.rclone_chunk.009_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.009 2022/03/23 06:32:13 INFO : backcomp/renamefile.rclone_chunk.010_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.010 2022/03/23 06:32:15 INFO : backcomp/renamefile.rclone_chunk.011_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.011 2022/03/23 06:32:17 INFO : backcomp/renamefile.rclone_chunk.012_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.012 2022/03/23 06:32:19 INFO : backcomp/renamefile.rclone_chunk.013_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.013 2022/03/23 06:32:20 INFO : backcomp/renamefile.rclone_chunk.014_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.014 2022/03/23 06:32:22 INFO : backcomp/renamefile.rclone_chunk.015_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.015 2022/03/23 06:32:24 INFO : backcomp/renamefile.rclone_chunk.016_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.016 2022/03/23 06:32:25 INFO : backcomp/renamefile.rclone_chunk.017_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.017 2022/03/23 06:32:27 INFO : backcomp/renamefile.rclone_chunk.018_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.018 2022/03/23 06:32:28 INFO : backcomp/renamefile.rclone_chunk.019_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.019 2022/03/23 06:32:29 INFO : backcomp/renamefile.rclone_chunk.020_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.020 2022/03/23 06:32:31 INFO : backcomp/renamefile.rclone_chunk.021_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.021 2022/03/23 06:32:33 INFO : backcomp/renamefile.rclone_chunk.022_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.022 2022/03/23 06:32:34 INFO : backcomp/renamefile.rclone_chunk.023_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.023 2022/03/23 06:32:36 INFO : backcomp/renamefile.rclone_chunk.024_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.024 2022/03/23 06:32:37 INFO : backcomp/renamefile.rclone_chunk.025_6vdlqb: Moved (server-side) to: backcomp/renamefile.rclone_chunk.025 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove 2022/03/23 06:33:14 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-zopasef8mupifay5yumaxev4/servermovetest/subdir1" 2022/03/23 06:33:14 DEBUG : Creating backend with remote "TestYandex:rclone-test-zopasef8mupifay5yumaxev4/servermovetest/subdir1" 2022/03/23 06:33:15 DEBUG : Reset feature "ListR" 2022/03/23 06:33:15 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex:rclone-test-zopasef8mupifay5yumaxev4/servermovetest/subdir2" 2022/03/23 06:33:15 DEBUG : Creating backend with remote "TestYandex:rclone-test-zopasef8mupifay5yumaxev4/servermovetest/subdir2" 2022/03/23 06:33:15 DEBUG : Reset feature "ListR" 2022/03/23 06:33:23 INFO : movefile.rclone_chunk.001_6vi69i: Moved (server-side) to: movefile.rclone_chunk.001 2022/03/23 06:33:25 INFO : movefile.rclone_chunk.002_6vi69i: Moved (server-side) to: movefile.rclone_chunk.002 2022/03/23 06:33:28 DEBUG : movefile: move 2 data chunks... 2022/03/23 06:33:31 INFO : movefile.rclone_chunk.001: Moved (server-side) 2022/03/23 06:33:32 INFO : movefile.rclone_chunk.002: Moved (server-side) 2022/03/23 06:33:34 INFO : movefile: Moved (server-side) 2022/03/23 06:33:36 INFO : movefile: Moved (server-side) === RUN TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow 2022/03/23 06:33:42 DEBUG : Creating backend with remote "TestChunkerChunk50bYandex,chunk_size='1P',hash_type='md5all',meta_format='simplejson',name_format='*.#',transactions='rename':rclone-test-zopasef8mupifay5yumaxev4/md5all" 2022/03/23 06:33:42 DEBUG : TestChunkerChunk50bYandex: detected overridden config - adding "{r7Izf}" suffix to name 2022/03/23 06:33:42 DEBUG : Creating backend with remote "TestYandex:rclone-test-zopasef8mupifay5yumaxev4/md5all" 2022/03/23 06:33:42 DEBUG : Reset feature "ListR" chunker_internal_test.go:878: this test needs a base fs with slow hash, e.g. local 2022/03/23 06:33:46 ERROR : : error listing: directory not found === CONT TestIntegration/FsMkdir fstests.go:1989: Warning: this should produce fs.ErrorDirNotFound --- PASS: TestIntegration (804.08s) --- PASS: TestIntegration/FsMkdir (802.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (796.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.33s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (1.32s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (0.87s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.65s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (1.91s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.37s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (1.64s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.83s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (1.62s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.60s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (30.80s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (15.68s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (42.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (14.90s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.33s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.38s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.44s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.43s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.56s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.36s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.37s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (1.76s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.44s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (2.28s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (1.14s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (1.82s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (1.19s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (28.22s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.41s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (0.59s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (0.33s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (26.85s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (3.53s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.52s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (22.80s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (4.19s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/PublicLink (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.38s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (5.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.13s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (32.48s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (5.79s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (26.69s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal (520.41s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/PutLarge (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNameFormat (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/SmallFileInternals (16.55s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/PreventCorruption (213.48s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkNumberOverflow (30.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/MetadataInput (50.04s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/FutureProof (18.45s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/BackwardsCompatibility (164.47s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/Internal/ChunkerServerSideMove (27.17s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal/MD5AllSlow (0.17s) PASS ok github.com/rclone/rclone/backend/chunker 804.102s "go test -v -timeout 1h0m0s -remote TestChunkerChunk50bYandex: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsPutFiles$'" - Finished OK in 13m25.899617235s (try 3/5)