+ sudo -E -H -u github ./ya make --test-size=small --test-size=medium --test-type=unittest --test-type=clang_tidy --test-type=gtest --test-type=py3test --test-type=py2test --test-type=pytest --test-type=flake8 --test-type=black --test-type=py2_flake8 --test-type=go_test --test-type=gofmt --run-all-tests --keep-going --retest --test-threads 20 --link-threads 40 --cache-size 512G --do-not-output-stderrs -T --nice 0 --stat --output /home/github/tmp/out -DGITHUB_CI=yes --build relwithdebinfo --target=cloud/filestore/ --bazel-remote-store --bazel-remote-base-uri http://195.242.10.243:9090 --bazel-remote-username bazel-remote-user --bazel-remote-password-file /tmp/tmp.jhf7jxwBf4 --junit /home/github/tmp/junit.xml.3 --log-file /home/github/tmp/logs/3/ya_log.txt --evlog-file /home/github/tmp/logs/3/ya_evlog.jsonl -X Configuring dependencies for platform default-linux-x86_64-relwithdebinfo Warn[-WPluginErr]: in $B/cloud/filestore/tests/async_close_test/cloud-filestore-tests-async_close_test: Requirement cpu is redefined 8 -> 4 Warn[-WPluginErr]: in $B/cloud/filestore/tests/async_close_test/cloud-filestore-tests-async_close_test: Requirement ram is redefined 30 -> 16 Configuring dependencies for platform tools Configuring dependencies for platform test_tool_tc1-global Configuring tests execution Configuring local and dist store caches Configuration done. Preparing for execution |24.5%| PREPARE $(OS_SDK_ROOT-sbr:1966560555) |26.5%| PREPARE $(YMAKE_PYTHON3-1415908779) |30.6%| PREPARE $(GDB) |32.7%| PREPARE $(PYTHON) |34.7%| PREPARE $(CLANG-2185927622) |36.7%| PREPARE $(LLD_ROOT-3334042713) |38.8%| PREPARE $(FLAKE8_PY3-3680676150) |40.8%| PREPARE $(TEST_TOOL_HOST-sbr:8580453620) |42.9%| COMPACTING CACHE 151.4GiB |53.1%| CLEANING SYMRES |55.1%| [LD] {RESULT} $(B)/cloud/filestore/tests/recipes/vhost-endpoint/vhost-endpoint-recipe |57.1%| [LD] {RESULT} $(B)/cloud/filestore/tests/recipes/service-kikimr/service-kikimr-recipe |59.2%| [LD] {RESULT} $(B)/cloud/storage/core/tests/recipes/qemu/qemu-recipe |61.2%| [LD] {RESULT} $(B)/cloud/filestore/tests/recipes/vhost/vhost-recipe |63.3%| [LD] {RESULT} $(B)/cloud/storage/core/tests/recipes/virtiofs-server/virtiofs-server-recipe |65.3%| [LD] {RESULT} $(B)/cloud/filestore/tests/fio/qemu-kikimr-test/cloud-filestore-tests-fio-qemu-kikimr-test |67.3%| [LD] {RESULT} $(B)/cloud/filestore/apps/server/{filestore-server ... liblibaio-dynamic.so} |69.4%| [LD] {RESULT} $(B)/cloud/filestore/apps/client/{filestore-client ... libfuse.so} |71.4%| [LD] {RESULT} $(B)/cloud/filestore/apps/vhost/{filestore-vhost ... libvirtiofsd.so} |73.5%| [PK] {RESULT} $(B)/cloud/storage/core/tools/testing/ydb/bin/{testing-ydb-bin.final.pkg.fake ... cloud/storage/core/tools/testing/ydb/bin/ydbd} |75.5%| [PK] {RESULT} $(B)/cloud/storage/core/tools/testing/qemu/bin/{testing-qemu-bin.final.pkg.fake ... cloud/storage/core/tools/testing/qemu/bin/qemu-bin.tar.gz} |77.6%| [PK] {RESULT} $(B)/cloud/storage/core/tools/testing/qemu/image/{testing-qemu-image.final.pkg.fake ... cloud/storage/core/tools/testing/qemu/image/rootfs.img} |79.6%| [PK] {RESULT} $(B)/cloud/storage/core/tools/testing/fio/bin/{testing-fio-bin.final.pkg.fake ... cloud/storage/core/tools/testing/fio/bin/fio} |81.6%| [PK] {RESULT} $(B)/cloud/storage/core/tools/testing/virtiofs_server/bin/{testing-virtiofs_server-bin.final.pkg.fake ... cloud/storage/core/tools/testing/virtiofs_server/bin/virtiofs-server} >> test.py::test_unaligned_fio[randrw_16K_1] |83.7%| [TM] {default-linux-x86_64, relwithdebinfo} cloud/filestore/tests/fio/qemu-kikimr-test/py3test |85.7%| [TM] {default-linux-x86_64, relwithdebinfo} cloud/filestore/tests/fio/qemu-kikimr-test/py3test |87.8%| [TM] {default-linux-x86_64, relwithdebinfo} cloud/filestore/tests/fio/qemu-kikimr-test/py3test |89.8%| [TM] {default-linux-x86_64, relwithdebinfo} cloud/filestore/tests/fio/qemu-kikimr-test/py3test |91.8%| [TM] {default-linux-x86_64, relwithdebinfo} cloud/filestore/tests/fio/qemu-kikimr-test/py3test |93.9%| [TM] {default-linux-x86_64, relwithdebinfo} cloud/filestore/tests/fio/qemu-kikimr-test/py3test >> test.py::test_unaligned_fio[randrw_16K_1] [FAIL] |95.9%| [TM] {default-linux-x86_64, relwithdebinfo} cloud/filestore/tests/fio/qemu-kikimr-test/py3test >> test.py::test_unaligned_fio[randrw_16K_1] [FAIL] |98.0%| [TA] $(B)/cloud/filestore/tests/fio/qemu-kikimr-test/test-results/py3test/{meta.json ... results_accumulator.log} |99.9%| [TA] {RESULT} $(B)/cloud/filestore/tests/fio/qemu-kikimr-test/test-results/py3test/{meta.json ... results_accumulator.log} |99.9%| CLEANING BUILD ROOT cloud/filestore/tests/fio/qemu-kikimr-test [size:medium] nchunks:7 [tags: sb:MULTISLOT, sb:cores=8, sb:logs_ttl=3, sb:ssd, sb:ttl=3, ya:dirty] ------ [0/7] chunk ran 1 test (total:72.52s - recipes:38.10s test:28.85s recipes:5.56s) [fail] test.py::test_unaligned_fio[randrw_16K_1] [default-linux-x86_64-relwithdebinfo] (26.93s) cloud/filestore/tests/fio/qemu-kikimr-test/test.py:37: in test_unaligned_fio fio.run_test(file_name, UNALIGNED_TESTS[name], fail_on_errors=True) cloud/storage/core/tools/testing/fio/lib/__init__.py:339: in run_test return _execute_command(cmd, fail_on_errors) cloud/storage/core/tools/testing/fio/lib/__init__.py:314: in _execute_command raise e cloud/storage/core/tools/testing/fio/lib/__init__.py:309: in _execute_command ex = common.execute( library/python/testing/yatest_common/yatest/common/process.py:656: in execute res.wait(check_exit_code, timeout, on_timeout) library/python/testing/yatest_common/yatest/common/process.py:411: in wait self._finalise(check_exit_code) library/python/testing/yatest_common/yatest/common/process.py:422: in _finalise raise ExecutionError(self) E yatest.common.process.ExecutionError: Command '/home/github/tmp/out/cloud/storage/core/tools/testing/fio/bin/fio --name randrw_16K_1 --rw randrw --size 104857600 --bs 16384 --buffer_compress_percentage 90 --runtime 60 --time_based --output-format json --offset 262143 --verify md5 --verify_backlog 8192 --serialize_overlap 1 --verify_dump 1 --direct 1 --ioengine libaio --iodepth 1 --randseed 899967931647259149 --filename /mnt/fs0/randrw_16K_1.dat' has failed with code 1. E Errors: E None Log: /home/github/tmp/out/cloud/filestore/tests/fio/qemu-kikimr-test/test-results/py3test/chunk0/testing_out_stuff/test.py.test_unaligned_fio.randrw_16K_1.log Logsdir: /home/github/tmp/out/cloud/filestore/tests/fio/qemu-kikimr-test/test-results/py3test/chunk0/testing_out_stuff ------ FAIL: 1 - FAIL cloud/filestore/tests/fio/qemu-kikimr-test Total 1 suite: 1 - FAIL Total 1 test: 1 - FAIL Cache efficiency ratio is 99.97% (24284 of 24292). Local: 15 (0.06%), dist: 0 (0.00%), by dynamic uids: 0 (0.00%), avoided: 24269 (99.91%) Dist cache download: count=0, size=0 bytes, speed=0.0 bytes/s Disk usage for tools/sdk 1.25 GiB Additional disk space consumed for build cache 0 bytes Critical path: [72762 ms] [TM] [rnd-3651102011584071678 default-linux-x86_64 relwithdebinfo]: cloud/filestore/tests/fio/qemu-kikimr-test/py3test [started: 0 (1762523812129), finished: 72762 (1762523884891)] [ 180 ms] [TA] [rnd-68zffqmwlgfiis43]: $(BUILD_ROOT)/cloud/filestore/tests/fio/qemu-kikimr-test/test-results/py3test/{meta.json ... results_accumulator.log} [started: 73176 (1762523885305), finished: 73356 (1762523885485)] Time from start: 79752.97705078125 ms, time elapsed by graph 72942 ms, time diff 6810.97705078125 ms. The longest 10 tasks: [72762 ms] [TM] [rnd-3651102011584071678 default-linux-x86_64 relwithdebinfo]: cloud/filestore/tests/fio/qemu-kikimr-test/py3test [started: 1762523812129, finished: 1762523884891] [47165 ms] [TM] [rnd-1736076247322101723 default-linux-x86_64 relwithdebinfo]: cloud/filestore/tests/fio/qemu-kikimr-test/py3test [started: 1762523812131, finished: 1762523859296] [46956 ms] [TM] [rnd-9497641687058882376 default-linux-x86_64 relwithdebinfo]: cloud/filestore/tests/fio/qemu-kikimr-test/py3test [started: 1762523812129, finished: 1762523859085] [46951 ms] [TM] [rnd-8518609348249814333 default-linux-x86_64 relwithdebinfo]: cloud/filestore/tests/fio/qemu-kikimr-test/py3test [started: 1762523812136, finished: 1762523859087] [46664 ms] [TM] [rnd-12791395589788621854 default-linux-x86_64 relwithdebinfo]: cloud/filestore/tests/fio/qemu-kikimr-test/py3test [started: 1762523812137, finished: 1762523858801] [46603 ms] [TM] [rnd-1209415793316714116 default-linux-x86_64 relwithdebinfo]: cloud/filestore/tests/fio/qemu-kikimr-test/py3test [started: 1762523812135, finished: 1762523858738] [46466 ms] [TM] [rnd-15281318055628461079 default-linux-x86_64 relwithdebinfo]: cloud/filestore/tests/fio/qemu-kikimr-test/py3test [started: 1762523812142, finished: 1762523858608] [ 6392 ms] [ymake ThreadPoolExecutor-0_1 default-linux-x86_64-relwithdebinfo-pic] [started: 1762523802789841, finished: 1762523809182375] [ 6349 ms] [ymake ThreadPoolExecutor-0_0 default-linux-x86_64-relwithdebinfo-nopic] [started: 1762523802785398, finished: 1762523809134409] [ 911 ms] [ymake ThreadPoolExecutor-0_2 tools-pic] [started: 1762523804029778, finished: 1762523804941097] Total time by type: [353567 ms] [TM] [count: 7, ave time 50509.57 msec] [ 292 ms] [prepare:clean] [count: 3, ave time 97.33 msec] [ 260 ms] [prepare:get from local cache] [count: 15, ave time 17.33 msec] [ 180 ms] [TA] [count: 1, ave time 180.00 msec] [ 81 ms] [prepare:tools] [count: 8, ave time 10.12 msec] [ 60 ms] [prepare:AC] [count: 2, ave time 30.00 msec] Total tasks times: Total failed tasks time - 0 ms (0.00%) Total tests tasks time - 353747 ms (100.00%) Total run tasks time - 353747 ms Configure time - 9.1 s Statistics overhead 570 ms Info: Dump junit report to /home/github/tmp/junit.xml.3 Failed + echo 10