+ sudo -E -H -u github ./ya make --test-size=small --test-size=medium --test-size=large --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 14 --link-threads 28 --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.F6eECMCVq8 --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 Warn[-WPluginErr]: in $B/cloud/filestore/tests/directory_handles/cloud-filestore-tests-directory_handles: Requirement cpu is redefined 8 -> 4 Warn[-WPluginErr]: in $B/cloud/filestore/tests/directory_handles/cloud-filestore-tests-directory_handles: 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 |22.9%| PREPARE $(LLD_ROOT-3334042713) |24.3%| PREPARE $(GDB) |25.7%| PREPARE $(OS_SDK_ROOT-sbr:1966560555) |27.1%| PREPARE $(JDK11-2842640623) |28.6%| PREPARE $(JDK_DEFAULT-1779948129) |30.0%| PREPARE $(WITH_JDK11-sbr:3064614561) |31.4%| PREPARE $(WITH_JDK17-sbr:4561486916) |32.9%| PREPARE $(WITH_JDK-sbr:4561486916) |35.7%| PREPARE $(JDK17-1779948129) |37.1%| PREPARE $(CLANG-2185927622) |38.6%| PREPARE $(PYTHON) |40.0%| PREPARE $(FLAKE8_PY3-3680676150) |41.4%| PREPARE $(YMAKE_PYTHON3-1415908779) |45.7%| PREPARE $(TEST_TOOL_HOST-sbr:8580453620) |47.1%| COMPACTING CACHE 152.3GiB |50.0%| CLEANING SYMRES |51.4%| [LD] {RESULT} $(B)/cloud/storage/core/tests/recipes/virtiofs-server/virtiofs-server-recipe |52.9%| [LD] {RESULT} $(B)/cloud/storage/core/tests/recipes/qemu/qemu-recipe |54.3%| [LD] {RESULT} $(B)/cloud/filestore/tests/recipes/vhost/vhost-recipe |55.7%| [LD] {RESULT} $(B)/cloud/filestore/tests/recipes/vhost-endpoint/vhost-endpoint-recipe |57.1%| [LD] {RESULT} $(B)/cloud/filestore/tests/profile_log/qemu-kikimr-test/filestore-tests-profile_log-qemu-kikimr-test |58.6%| [LD] {RESULT} $(B)/cloud/filestore/tools/testing/fs_posix_compliance/suite/fstest |60.0%| [LD] {RESULT} $(B)/cloud/filestore/tests/recipes/service-kikimr/service-kikimr-recipe |61.4%| [LD] {RESULT} $(B)/cloud/filestore/libs/storage/service/ut/{cloud-filestore-libs-storage-service-ut ... liblibaio-dynamic.so} |62.9%| [PK] {RESULT} $(B)/cloud/storage/core/tools/testing/ydb/bin/{testing-ydb-bin.final.pkg.fake ... cloud/storage/core/tools/testing/ydb/bin/ydbd} |64.3%| [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} |65.7%| [LD] {RESULT} $(B)/cloud/filestore/tools/analytics/profile_tool/{filestore-profile-tool ... liblibaio-dynamic.so} |67.1%| [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} |68.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} |70.0%| [LD] {RESULT} $(B)/cloud/filestore/apps/server/{filestore-server ... liblibaio-dynamic.so} |71.4%| [PK] {RESULT} $(B)/cloud/filestore/tools/testing/fs_posix_compliance/suite/bin/{fs_posix_compliance-suite-bin.final.pkg.fake ... cloud/filestore/tools/testing/fs_posix_compliance/suite/bin/flock} |72.9%| [LD] {RESULT} $(B)/cloud/filestore/apps/client/{filestore-client ... libfuse.so} |74.3%| [LD] {RESULT} $(B)/cloud/filestore/apps/vhost/{filestore-vhost ... libvirtiofsd.so} >> TStorageServiceTest::ShouldFallbackToWriteIfNoAlignedForAtLeastOneBlock |75.7%| [TM] {default-linux-x86_64, relwithdebinfo} cloud/filestore/libs/storage/service/ut/unittest |77.1%| [TM] {default-linux-x86_64, relwithdebinfo} cloud/filestore/libs/storage/service/ut/unittest |78.6%| [TM] {default-linux-x86_64, relwithdebinfo} cloud/filestore/libs/storage/service/ut/unittest |80.0%| [TM] {default-linux-x86_64, relwithdebinfo} cloud/filestore/libs/storage/service/ut/unittest |81.4%| [TM] {default-linux-x86_64, relwithdebinfo} cloud/filestore/libs/storage/service/ut/unittest |82.9%| [TM] {default-linux-x86_64, relwithdebinfo} cloud/filestore/libs/storage/service/ut/unittest >> TStorageServiceTest::ShouldFallbackToWriteIfNoAlignedForAtLeastOneBlock [FAIL] |84.3%| [TM] {default-linux-x86_64, relwithdebinfo} cloud/filestore/libs/storage/service/ut/unittest >> TStorageServiceTest::ShouldFallbackToWriteIfNoAlignedForAtLeastOneBlock [FAIL] |85.7%| [TA] $(B)/cloud/filestore/libs/storage/service/ut/test-results/unittest/{meta.json ... results_accumulator.log} |87.1%| [TA] {RESULT} $(B)/cloud/filestore/libs/storage/service/ut/test-results/unittest/{meta.json ... results_accumulator.log} >> test.py::test_profile_log |88.6%| [TM] {default-linux-x86_64, relwithdebinfo} cloud/filestore/tests/profile_log/qemu-kikimr-test/py3test |90.0%| [TM] {default-linux-x86_64, relwithdebinfo} cloud/filestore/tests/profile_log/qemu-kikimr-test/py3test |91.4%| [TM] {default-linux-x86_64, relwithdebinfo} cloud/filestore/tests/profile_log/qemu-kikimr-test/py3test |92.9%| [TM] {default-linux-x86_64, relwithdebinfo} cloud/filestore/tests/profile_log/qemu-kikimr-test/py3test |94.3%| [TM] {default-linux-x86_64, relwithdebinfo} cloud/filestore/tests/profile_log/qemu-kikimr-test/py3test |95.7%| [TM] {default-linux-x86_64, relwithdebinfo} cloud/filestore/tests/profile_log/qemu-kikimr-test/py3test >> test.py::test_profile_log [GOOD] |97.1%| [TM] {default-linux-x86_64, relwithdebinfo} cloud/filestore/tests/profile_log/qemu-kikimr-test/py3test >> test.py::test_profile_log [GOOD] |97.2%| [TA] $(B)/cloud/filestore/tests/profile_log/qemu-kikimr-test/test-results/py3test/{meta.json ... results_accumulator.log} |98.6%| [TA] {RESULT} $(B)/cloud/filestore/tests/profile_log/qemu-kikimr-test/test-results/py3test/{meta.json ... results_accumulator.log} |99.9%| CLEANING BUILD ROOT cloud/filestore/tests/profile_log/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:186.84s - recipes:39.67s test:141.38s recipes:5.53s canon:0.16s) [fail] test.py::test_profile_log [default-linux-x86_64-relwithdebinfo] (139.08s) Test results differ from canonical: files content differs: --- cloud/filestore/tests/profile_log/qemu-kikimr-test/canondata/test.test_profile_log/results.txt 2025-12-05 21:39:45.586111293 +0000 +++ /home/github/.ya/build/build_root/mm60/000018/canon_tmp4but7agt/results.txt 2025-12-05 22:59:34.605402443 +0000 @@ -2,2 +2,4 @@ CreateFileStore +ReadData +WriteData VHOST profile: Log: /home/github/tmp/out/cloud/filestore/tests/profile_log/qemu-kikimr-test/test-results/py3test/chunk0/testing_out_stuff/test.py.test_profile_log.log Logsdir: /home/github/tmp/out/cloud/filestore/tests/profile_log/qemu-kikimr-test/test-results/py3test/chunk0/testing_out_stuff ------ FAIL: 1 - FAIL cloud/filestore/tests/profile_log/qemu-kikimr-test cloud/filestore/libs/storage/service/ut [size:medium] nchunks:7 [tags: sb:MULTISLOT, sb:cores=8, sb:logs_ttl=3, sb:ssd, sb:ttl=3] ------ [0/7] chunk ran 1 test (total:19.87s - test:19.85s) [fail] TStorageServiceTest::ShouldFallbackToWriteIfNoAlignedForAtLeastOneBlock [default-linux-x86_64-relwithdebinfo] (0.66s) assertion failed at cloud/filestore/libs/storage/service/service_ut.cpp:2820, virtual void NCloud::NFileStore::NStorage::NTestSuiteTStorageServiceTest::TTestCaseShouldFallbackToWriteIfNoAlignedForAtLeastOneBlock::Execute_(NUnitTest::TTestContext &): (1 == profileLog ->Requests[static_cast(EFileStoreRequest::WriteData)] .size()) failed: (1 != 2) TIntrusivePtr, std::__y1::allocator>>, TStringPtrOps, std::__y1::allocator>>>>::Get() const at /actions-runner/_work/nbs/nbs/util/generic/ptr.h:560:16 NPrivateStringBuilder::TStringBuilder::~TStringBuilder() at /actions-runner/_work/nbs/nbs/util/string/builder.h:8:11 NCloud::NFileStore::NStorage::NTestSuiteTStorageServiceTest::TCurrentTest::Execute()::'lambda'()::operator()() const at /actions-runner/_work/nbs/nbs/cloud/filestore/libs/storage/service/service_ut.cpp:0:1 std::__y1::__function::__value_func::~__value_func[abi:v15000]() at /actions-runner/_work/nbs/nbs/contrib/libs/cxxsupp/libcxx/include/__functional/function.h:470:20 TIntrusivePtr, std::__y1::allocator>>, TStringPtrOps, std::__y1::allocator>>>>::UnRef() at /actions-runner/_work/nbs/nbs/util/generic/ptr.h:598:13 NUnitTest::TTestFactory::Execute() at /actions-runner/_work/nbs/nbs/library/cpp/testing/unittest/registar.cpp:0:19 NUnitTest::RunMain(int, char**) at /actions-runner/_work/nbs/nbs/library/cpp/testing/unittest/utmain.cpp:0:0 ?? at ??:0:0 ?? at ??:0:0 _start at ??:0:0 Logsdir: /home/github/tmp/out/cloud/filestore/libs/storage/service/ut/test-results/unittest/chunk0/testing_out_stuff Stderr: /home/github/tmp/out/cloud/filestore/libs/storage/service/ut/test-results/unittest/chunk0/testing_out_stuff/TStorageServiceTest.ShouldFallbackToWriteIfNoAlignedForAtLeastOneBlock.err Stdout: /home/github/tmp/out/cloud/filestore/libs/storage/service/ut/test-results/unittest/chunk0/testing_out_stuff/TStorageServiceTest.ShouldFallbackToWriteIfNoAlignedForAtLeastOneBlock.out ------ FAIL: 1 - FAIL cloud/filestore/libs/storage/service/ut Total 2 suites: 2 - FAIL Total 2 tests: 2 - FAIL Cache efficiency ratio is 99.93% (24444 of 24460). Local: 18 (0.07%), dist: 0 (0.00%), by dynamic uids: 0 (0.00%), avoided: 24426 (99.86%) Dist cache download: count=0, size=0 bytes, speed=0.0 bytes/s Disk usage for tools/sdk 2.11 GiB Additional disk space consumed for build cache 0 bytes Critical path: [187091 ms] [TM] [rnd-2402190064787321827 default-linux-x86_64 relwithdebinfo]: cloud/filestore/tests/profile_log/qemu-kikimr-test/py3test [started: 0 (1764975393478), finished: 187091 (1764975580569)] [ 179 ms] [TA] [rnd-lt6ug57kmmb5qm2k]: $(BUILD_ROOT)/cloud/filestore/tests/profile_log/qemu-kikimr-test/test-results/py3test/{meta.json ... results_accumulator.log} [started: 187514 (1764975580992), finished: 187693 (1764975581171)] Time from start: 194211.53100585938 ms, time elapsed by graph 187270 ms, time diff 6941.531005859375 ms. The longest 10 tasks: [187091 ms] [TM] [rnd-2402190064787321827 default-linux-x86_64 relwithdebinfo]: cloud/filestore/tests/profile_log/qemu-kikimr-test/py3test [started: 1764975393478, finished: 1764975580569] [ 48223 ms] [TM] [rnd-2988818672337386416 default-linux-x86_64 relwithdebinfo]: cloud/filestore/tests/profile_log/qemu-kikimr-test/py3test [started: 1764975393484, finished: 1764975441707] [ 47973 ms] [TM] [rnd-2521537219706799625 default-linux-x86_64 relwithdebinfo]: cloud/filestore/tests/profile_log/qemu-kikimr-test/py3test [started: 1764975393481, finished: 1764975441454] [ 47972 ms] [TM] [rnd-14226275264530244657 default-linux-x86_64 relwithdebinfo]: cloud/filestore/tests/profile_log/qemu-kikimr-test/py3test [started: 1764975393486, finished: 1764975441458] [ 47904 ms] [TM] [rnd-13339717489597022420 default-linux-x86_64 relwithdebinfo]: cloud/filestore/tests/profile_log/qemu-kikimr-test/py3test [started: 1764975393489, finished: 1764975441393] [ 47818 ms] [TM] [rnd-371371964559171796 default-linux-x86_64 relwithdebinfo]: cloud/filestore/tests/profile_log/qemu-kikimr-test/py3test [started: 1764975393487, finished: 1764975441305] [ 47162 ms] [TM] [rnd-3353465809277479305 default-linux-x86_64 relwithdebinfo]: cloud/filestore/tests/profile_log/qemu-kikimr-test/py3test [started: 1764975393493, finished: 1764975440655] [ 20117 ms] [TM] [rnd-16131574003889153286 default-linux-x86_64 relwithdebinfo]: cloud/filestore/libs/storage/service/ut/unittest [started: 1764975393395, finished: 1764975413512] [ 6426 ms] [ymake ThreadPoolExecutor-0_0 default-linux-x86_64-relwithdebinfo-nopic] [started: 1764975384066554, finished: 1764975390492809] [ 6422 ms] [ymake ThreadPoolExecutor-0_1 default-linux-x86_64-relwithdebinfo-pic] [started: 1764975384071240, finished: 1764975390494085] Total time by type: [498318 ms] [TM] [count: 14, ave time 35594.14 msec] [ 382 ms] [TA] [count: 2, ave time 191.00 msec] [ 357 ms] [prepare:clean] [count: 3, ave time 119.00 msec] [ 314 ms] [prepare:get from local cache] [count: 18, ave time 17.44 msec] [ 236 ms] [prepare:tools] [count: 14, ave time 16.86 msec] [ 69 ms] [prepare:AC] [count: 2, ave time 34.50 msec] Total tasks times: Total failed tasks time - 0 ms (0.00%) Total tests tasks time - 498700 ms (100.00%) Total run tasks time - 498700 ms Configure time - 9.2 s Statistics overhead 575 ms Info: Dump junit report to /home/github/tmp/junit.xml.3 Failed + echo 10