2024-11-19 12:29:57,378 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "file_in_memory_log" initialized in 0.000015 2024-11-19 12:29:57,379 DEBUG (root) [MainThread] Release revision: 15278243 2024-11-19 12:29:57,379 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "revision" initialized in 0.000760 2024-11-19 12:29:57,379 DEBUG (yalibrary.vcs) [MainThread] detecting vcs from /home/runner/actions_runner/_work/ydb/ydb for paths: None 2024-11-19 12:29:57,379 DEBUG (yalibrary.vcs) [MainThread] common root: /home/runner/actions_runner/_work/ydb/ydb 2024-11-19 12:29:57,379 DEBUG (yalibrary.vcs) [MainThread] vcs root: /home/runner/actions_runner/_work/ydb/ydb (git) 2024-11-19 12:29:57,379 DEBUG (root) [MainThread] vcs type: git 2024-11-19 12:29:57,379 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" initialized in 0.000210 2024-11-19 12:29:57,380 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-19 12:29:57,380 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "report" initialized in 0.000411 2024-11-19 12:29:57,380 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "exit" initialized in 0.000002 2024-11-19 12:29:57,380 DEBUG (root) [MainThread] Start up timestamp 2024-11-19T12:29:57.UTC (2024-11-19T12:29:57.UTC) 2024-11-19 12:29:57,380 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "lifecycle_ts" initialized in 0.000039 2024-11-19 12:29:57,380 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "env_checker" initialized in 0.000005 2024-11-19 12:29:57,380 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" initialized in 0.000396 2024-11-19 12:29:57,381 DEBUG (library.python.tmp) [MainThread] Set TMPDIR=/home/runner/.ya/tmp/1732019397.3025.c6ogw00k instead of None 2024-11-19 12:29:57,381 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "tmp_dir" initialized in 0.000123 2024-11-19 12:29:57,381 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=modules-initialization-early, group=overall-execution, time=1732019397.3811207 2024-11-19 12:29:57,381 DEBUG (core.stages_profiler) [MainThread] Set stage modules-initialization-early_finished=1732019397.3811207 2024-11-19 12:29:57,381 DEBUG (core.profiler) [MainThread] Profile step modules-initialization-early_finished - 1732019397.3811207 2024-11-19 12:29:57,381 DEBUG (core.stage_tracer) [MainThread] Start stage tag=handler-selection, group=overall-execution, time=1732019397.3815787 2024-11-19 12:29:57,381 DEBUG (core.stages_profiler) [MainThread] Set stage handler-selection_started=1732019397.3815787 2024-11-19 12:29:57,381 DEBUG (core.profiler) [MainThread] Profile step handler-selection_started - 1732019397.3815787 2024-11-19 12:29:57,381 DEBUG (core.plugin_loader) [MainThread] Load handlers.make 2024-11-19 12:29:57,393 DEBUG (core.yarg.config_files) [MainThread] Load data from config /home/runner/actions_runner/_work/ydb/ydb/ya.conf 2024-11-19 12:29:57,394 DEBUG (core.yarg.config_files) [MainThread] Found 21 keys 2024-11-19 12:29:57,394 DEBUG (core.yarg.populate) [MainThread] Use config file `/home/runner/actions_runner/_work/ydb/ydb/ya.conf` with `21` keys 2024-11-19 12:29:57,394 DEBUG (core.yarg.populate) [MainThread] No aliases to inject 2024-11-19 12:29:57,395 DEBUG (core.yarg.config_files) [MainThread] Unknown config parameter `incremental_build_dirs_cleanup` 2024-11-19 12:29:57,395 DEBUG (core.yarg.config_files) [MainThread] Unknown config parameter `use_atd_revisions_info` 2024-11-19 12:29:57,395 DEBUG (core.yarg.config_files) [MainThread] Load data from config /home/runner/actions_runner/_work/ydb/ydb/build/internal/ya.conf 2024-11-19 12:29:57,395 DEBUG (core.yarg.config_files) [MainThread] Found 9 keys 2024-11-19 12:29:57,396 DEBUG (core.yarg.populate) [MainThread] Use config file `/home/runner/actions_runner/_work/ydb/ydb/build/internal/ya.conf` with `9` keys 2024-11-19 12:29:57,396 DEBUG (core.yarg.populate) [MainThread] No aliases to inject 2024-11-19 12:29:57,396 DEBUG (core.yarg.config_files) [MainThread] Unknown config parameter `bazel_remote_client_decompress` 2024-11-19 12:29:57,407 DEBUG (core.common_opts) [MainThread] Could not read .ya_token file at /home/runner/.ya_token: [Errno 2] No such file or directory: '/home/runner/.ya_token' 2024-11-19 12:29:57,407 DEBUG (core.common_opts) [MainThread] Could not read .ya_token file at /home/runner/.ya_token: [Errno 2] No such file or directory: '/home/runner/.ya_token' 2024-11-19 12:29:57,408 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=handler-selection, group=overall-execution, time=1732019397.4082327 2024-11-19 12:29:57,408 DEBUG (core.stages_profiler) [MainThread] Set stage handler-selection_finished=1732019397.4082327 2024-11-19 12:29:57,408 DEBUG (core.profiler) [MainThread] Profile step handler-selection_finished - 1732019397.4082327 2024-11-19 12:29:57,408 DEBUG (core.stage_tracer) [MainThread] Start stage tag=modules-initialization-full, group=overall-execution, time=1732019397.408359 2024-11-19 12:29:57,408 DEBUG (core.stages_profiler) [MainThread] Set stage modules-initialization-full_started=1732019397.408359 2024-11-19 12:29:57,408 DEBUG (core.profiler) [MainThread] Profile step modules-initialization-full_started - 1732019397.408359 2024-11-19 12:29:57,408 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Add [('params', ), ('hide_token', ), ('state', ), ('display', ), ('custom_file_log', ), ('display_log', ), ('vcs_type', ), ('self_info', ), ('fetcher_params', ), ('use_universal_fetcher_everywhere', ), ('docker_config_path', ), ('hide_token2', ), ('fetchers_storage', ), ('fetcher', ), ('showstack', ), ('profile', ), ('mlockall', ), ('event_queue', ), ('changelist_store', ), ('evlog', ), ('dump_debug', )] to ctx dict_keys(['uid', 'file_log', 'display_in_memory_log', 'file_in_memory_log', 'revision', 'vcs_type', 'report', 'exit', 'lifecycle_ts', 'env_checker', 'fetchers_storage', 'tmp_dir', 'params', 'hide_token', 'state', 'display']) 2024-11-19 12:29:57,408 DEBUG (core.respawn) [MainThread] Same as prev source root /home/runner/actions_runner/_work/ydb/ydb 2024-11-19 12:29:57,408 DEBUG (core.respawn.pyver) [MainThread] No need to respawn to other ya-bin version 2024-11-19 12:29:57,408 DEBUG (core.respawn) [MainThread] Unsetting YA_STDIN env var as respawn never happened 2024-11-19 12:29:57,409 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "params" initialized in 0.000271 2024-11-19 12:29:57,410 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-19 12:29:57,410 DEBUG (root) [MainThread] Update replacements in 2024-11-19 12:29:57,410 DEBUG (root) [MainThread] Add suppressing formatter to 2024-11-19 12:29:57,411 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-19 12:29:57,411 DEBUG (root) [MainThread] Add suppressing formatter to 2024-11-19 12:29:57,411 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-19 12:29:57,411 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token" initialized in 0.002276 2024-11-19 12:29:57,411 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "state" initialized in 0.000215 2024-11-19 12:29:57,411 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display" initialized in 0.000043 2024-11-19 12:29:57,412 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-19 12:29:57,412 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "custom_file_log" initialized in 0.000901 2024-11-19 12:29:57,412 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display_log" initialized in 0.000033 2024-11-19 12:29:57,412 DEBUG (yalibrary.vcs) [MainThread] detecting vcs from /home/runner/actions_runner/_work/ydb/ydb for paths: None 2024-11-19 12:29:57,412 DEBUG (yalibrary.vcs) [MainThread] common root: /home/runner/actions_runner/_work/ydb/ydb 2024-11-19 12:29:57,412 DEBUG (yalibrary.vcs) [MainThread] vcs root: /home/runner/actions_runner/_work/ydb/ydb (git) 2024-11-19 12:29:57,413 DEBUG (root) [MainThread] vcs type: git 2024-11-19 12:29:57,413 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" initialized in 0.000219 2024-11-19 12:29:57,413 DEBUG (devtools.ya.app) [MainThread] origin: github 2024-11-19 12:29:57,413 DEBUG (devtools.ya.app) [MainThread] python: sys.version_info(major=3, minor=12, micro=7, releaselevel='final', serial=0) 2024-11-19 12:29:57,413 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "self_info" initialized in 0.000098 2024-11-19 12:29:57,413 DEBUG (root) [MainThread] Custom fetcher: None, fetcher parameters: [{'name': 'custom'}, {'name': 'proxy'}, {'name': 'skynet'}, {'name': 'mds'}, {'name': 'sandbox'}], sb_token none 2024-11-19 12:29:57,413 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher_params" initialized in 0.000077 2024-11-19 12:29:57,413 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "use_universal_fetcher_everywhere" initialized in 0.000002 2024-11-19 12:29:57,413 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "docker_config_path" initialized in 0.000001 2024-11-19 12:29:57,414 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-19 12:29:57,414 DEBUG (root) [MainThread] Update replacements in 2024-11-19 12:29:57,414 DEBUG (root) [MainThread] Update replacements in 2024-11-19 12:29:57,414 DEBUG (root) [MainThread] Update replacements in DisplayStreamHandler 2024-11-19 12:29:57,414 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token2" initialized in 0.001117 2024-11-19 12:29:57,414 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" initialized in 0.000061 2024-11-19 12:29:57,414 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher" initialized in 0.000002 2024-11-19 12:29:57,414 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "showstack" initialized in 0.000131 2024-11-19 12:29:57,414 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "profile" initialized in 0.000002 2024-11-19 12:29:57,415 DEBUG (devtools.ya.app) [MainThread] mlockall return code: 12 2024-11-19 12:29:57,415 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "mlockall" initialized in 0.000038 2024-11-19 12:29:57,415 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "event_queue" initialized in 0.000004 2024-11-19 12:29:57,415 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "changelist_store" initialized in 0.000241 2024-11-19 12:29:57,415 DEBUG (root) [MainThread] Event log file is /home/runner/actions_runner/_work/ydb/ydb/tmp/results/try_1/ya_evlog.jsonl 2024-11-19 12:29:57,415 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "evlog" initialized in 0.000403 2024-11-19 12:29:57,454 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "dump_debug" initialized in 0.038471 2024-11-19 12:29:57,454 DEBUG (devtools.ya.app) [MainThread] Run action on with params 2024-11-19 12:29:57,455 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=modules-initialization-full, group=overall-execution, time=1732019397.4550254 2024-11-19 12:29:57,455 DEBUG (core.stages_profiler) [MainThread] Set stage modules-initialization-full_finished=1732019397.4550254 2024-11-19 12:29:57,455 DEBUG (core.profiler) [MainThread] Profile step modules-initialization-full_finished - 1732019397.4550254 2024-11-19 12:29:57,455 DEBUG (core.stage_tracer) [MainThread] Start stage tag=invoke-do_ya_make, group=overall-execution, time=1732019397.4551816 2024-11-19 12:29:57,455 DEBUG (core.stages_profiler) [MainThread] Set stage invoke-do_ya_make_started=1732019397.4551816 2024-11-19 12:29:57,455 DEBUG (core.profiler) [MainThread] Profile step invoke-do_ya_make_started - 1732019397.4551816 2024-11-19 12:29:57,580 DEBUG (core.stage_tracer) [MainThread] Start stage tag=ya_make_handler, group=build_handler, time=1732019397.5802097 2024-11-19 12:29:57,580 DEBUG (core.stages_profiler) [MainThread] Set stage ya_make_handler_started=1732019397.5802097 2024-11-19 12:29:57,580 DEBUG (core.profiler) [MainThread] Profile step ya_make_handler_started - 1732019397.5802097 2024-11-19 12:29:57,580 DEBUG (core.stage_tracer) [MainThread] Start stage tag=context_generating, group=build_handler, time=1732019397.5804257 2024-11-19 12:29:57,580 DEBUG (core.stages_profiler) [MainThread] Set stage context_generating_started=1732019397.5804257 2024-11-19 12:29:57,580 DEBUG (core.profiler) [MainThread] Profile step context_generating_started - 1732019397.5804257 2024-11-19 12:29:57,580 DEBUG (core.stage_tracer) [MainThread] Start stage tag=build_graph_cache_configuration, group=build_handler, time=1732019397.5805473 2024-11-19 12:29:57,580 DEBUG (core.stages_profiler) [MainThread] Set stage build_graph_cache_configuration_started=1732019397.5805473 2024-11-19 12:29:57,580 DEBUG (core.profiler) [MainThread] Profile step build_graph_cache_configuration_started - 1732019397.5805473 2024-11-19 12:29:57,580 DEBUG (build.ya_make) [MainThread] Build graph cache processing started 2024-11-19 12:29:57,580 DEBUG (build.ya_make) [MainThread] Build graph cache processing disabled 2024-11-19 12:29:57,580 DEBUG (build.ya_make) [MainThread] Build graph cache is not available in opensource 2024-11-19 12:29:57,580 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=build_graph_cache_configuration, group=build_handler, time=1732019397.580758 2024-11-19 12:29:57,580 DEBUG (core.stages_profiler) [MainThread] Set stage build_graph_cache_configuration_finished=1732019397.580758 2024-11-19 12:29:57,580 DEBUG (core.profiler) [MainThread] Profile step build_graph_cache_configuration_finished - 1732019397.580758 2024-11-19 12:29:57,581 DEBUG (core.stage_tracer) [MainThread] Start stage tag=context_creation, group=ya_make, time=1732019397.5809937 2024-11-19 12:29:57,581 DEBUG (core.stages_profiler) [MainThread] Set stage context_creation_started=1732019397.5809937 2024-11-19 12:29:57,581 DEBUG (core.profiler) [MainThread] Profile step context_creation_started - 1732019397.5809937 2024-11-19 12:29:57,583 DEBUG (yalibrary.toolscache) [MainThread] Tools cache uses passed opts 2024-11-19 12:29:57,583 DEBUG (yalibrary.toolscache) [MainThread] Tools cache parameters: tc enabled=True, tc master=True, ac enabled=True, ac master=True, tc_lock_file=/home/runner/.ya/tools/v4/.cache_lock, ac_lock_file=/home/runner/.ya/build/cache/7/.cache_lock, binary=None, ini=None, tc_conf={}, ac_conf={'cas_logging': 'true', 'graph_info': 'true'}, gl_conf={} 2024-11-19 12:29:57,583 DEBUG (build.ya_make) [MainThread] content UIDs enabled by request 2024-11-19 12:29:57,585 DEBUG (build.ya_make) [Misc-00] Using '/tmp/tmp.YXNkBImdtq' file to obtain bazel remote password 2024-11-19 12:29:57,585 DEBUG (core.stage_tracer) [MainThread] Start stage tag=build_graph_and_tests, group=graph, time=1732019397.5855455 2024-11-19 12:29:57,585 DEBUG (core.stages_profiler) [MainThread] Set stage build_graph_and_tests_started=1732019397.5855455 2024-11-19 12:29:57,585 DEBUG (core.profiler) [MainThread] Profile step build_graph_and_tests_started - 1732019397.5855455 2024-11-19 12:29:57,586 DEBUG (build.graph) [Misc-01] Collect vcs info 2024-11-19 12:29:57,586 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/ya.conf.json 2024-11-19 12:29:57,586 DEBUG (yalibrary.vcs) [Misc-01] detecting vcs from /home/runner/actions_runner/_work/ydb/ydb for paths: ['/home/runner/actions_runner/_work/ydb/ydb'] 2024-11-19 12:29:57,586 DEBUG (yalibrary.vcs) [Misc-01] common root: /home/runner/actions_runner/_work/ydb/ydb 2024-11-19 12:29:57,587 DEBUG (yalibrary.vcs) [Misc-01] vcs root: /home/runner/actions_runner/_work/ydb/ydb (git) 2024-11-19 12:29:57,587 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/platform/clang/clang16.json 2024-11-19 12:29:57,589 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/platform/clang/clang18.json 2024-11-19 12:29:57,591 DEBUG (build.graph) [MainThread] flags: { "APPLE_SDK_LOCAL": "yes", "CFLAGS": "-fno-omit-frame-pointer", "CONSISTENT_DEBUG": "yes", "DEBUGINFO_LINES_ONLY": "yes", "DISABLE_FLAKE8_MIGRATIONS": "yes", "OPENSOURCE": "yes", "TESTS_REQUESTED": "yes", "USE_AIO": "static", "USE_CLANG_CL": "yes", "USE_EAT_MY_DATA": "yes", "USE_ICONV": "static", "USE_IDN": "static", "USE_PREBUILT_TOOLS": "no" } 2024-11-19 12:29:57,591 DEBUG (build.graph) [MainThread] host toolchain: { "bottle_name": "clang18", "build_type": "release", "env": { "CPATH": [ "" ], "LIBRARY_PATH": [ "" ], "SDKROOT": [ "" ] }, "executable_path": "c++", "flags": { "APPLE_SDK_LOCAL": "yes", "CFLAGS": "-fno-omit-frame-pointer", "CLANG_COVERAGE": "no", "CONSISTENT_DEBUG": "yes", "NO_DEBUGINFO": "yes", "OPENSOURCE": "yes", "TIDY": "no", "TOOL_BUILD_MODE": "yes", "TRAVERSE_RECURSE": "no", "USE_AIO": "static", "USE_CLANG_CL": "yes", "USE_ICONV": "static", "USE_IDN": "static", "USE_PREBUILT_TOOLS": "no" }, "formula": { "by_platform": { "darwin-arm64": { "uri": "sbr:7451602609" }, "darwin-x86_64": { "uri": "sbr:7451585962" }, "linux-aarch64": { "uri": "sbr:7451712332" }, "linux-x86_64": { "uri": "sbr:7451466407" }, "win32-x86_64": { "uri": "sbr:7451406900" } } }, "name": "clang18", "params": { "c_compiler": "$(CLANG-1735056821)/bin/clang", "cxx_compiler": "$(CLANG-1735056821)/bin/clang++", "gcc_version": "18", "llvm-symbolizer": "$(CLANG-1735056821)/bin/llvm-symbolizer", "match_root": "CLANG-1735056821", "objcopy": "$(CLANG-1735056821)/bin/llvm-objcopy", "profiles": "$(XCODE_TOOLS_ROOT-sbr:799017771)/Xcode/Contents/Developer/Platforms/iPhoneOS.platform/Developer/Library/CoreSimulator/Profiles", "simctl": "$(XCODE_TOOLS_ROOT-sbr:799017771)/Xcode/SystemRoot/PrivateFrameworks/CoreSimulator.framework/Resources/bin/simctl", "strip": "$(CLANG-1735056821)/bin/llvm-strip", "type": "clang", "use_bundle": true, "werror_mode": "all" }, "platform": { "host": { "arch": "x86_64", "os": "LINUX", "toolchain": "default", "visible_name": "clang18" }, "target": { "arch": "x86_64", "os": "LINUX", "toolchain": "default", "visible_name": "clang18" } }, "tool_var": "CLANG-1735056821" } 2024-11-19 12:29:57,591 DEBUG (build.graph) [MainThread] target toolchain: { "bottle_name": "clang18", "env": { "CPATH": [ "" ], "LIBRARY_PATH": [ "" ], "SDKROOT": [ "" ] }, "executable_path": "c++", "flags": { "SANITIZER_TYPE": "address" }, "formula": { "by_platform": { "darwin-arm64": { "uri": "sbr:7451602609" }, "darwin-x86_64": { "uri": "sbr:7451585962" }, "linux-aarch64": { "uri": "sbr:7451712332" }, "linux-x86_64": { "uri": "sbr:7451466407" }, "win32-x86_64": { "uri": "sbr:7451406900" } } }, "name": "clang18", "params": { "c_compiler": "$(CLANG-1735056821)/bin/clang", "cxx_compiler": "$(CLANG-1735056821)/bin/clang++", "gcc_version": "18", "llvm-symbolizer": "$(CLANG-1735056821)/bin/llvm-symbolizer", "match_root": "CLANG-1735056821", "objcopy": "$(CLANG-1735056821)/bin/llvm-objcopy", "profiles": "$(XCODE_TOOLS_ROOT-sbr:799017771)/Xcode/Contents/Developer/Platforms/iPhoneOS.platform/Developer/Library/CoreSimulator/Profiles", "simctl": "$(XCODE_TOOLS_ROOT-sbr:799017771)/Xcode/SystemRoot/PrivateFrameworks/CoreSimulator.framework/Resources/bin/simctl", "strip": "$(CLANG-1735056821)/bin/llvm-strip", "type": "clang", "use_bundle": true, "werror_mode": "all" }, "platform": { "host": { "arch": "x86_64", "os": "LINUX", "toolchain": "default", "visible_name": "clang18" }, "target": { "arch": "x86_64", "os": "LINUX", "toolchain": "default", "visible_name": "clang18" } }, "platform_name": "DEFAULT-LINUX-X86_64", "tool_var": "CLANG-1735056821" } 2024-11-19 12:29:57,592 DEBUG (yalibrary.tools) [MainThread] Using old-style toolchain for: ymake 2024-11-19 12:29:57,592 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/ymake/public.resources.json 2024-11-19 12:29:57,592 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ymake: try to fetch by {'darwin': {'uri': 'sbr:7448914799'}, 'darwin-arm64': {'uri': 'sbr:7448913101'}, 'linux': {'uri': 'sbr:7448917907'}, 'linux-aarch64': {'uri': 'sbr:7448911598'}, 'win32-clang-cl': {'uri': 'sbr:7448916360'}} for 'linux' 2024-11-19 12:29:57,592 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ymake: will use 'linux' platform 2024-11-19 12:29:57,592 DEBUG (yalibrary.fetcher.resource_fetcher) [MainThread] Fetching 7448917907 from sbr:7448917907 to /home/runner/.ya/tools/v4/7448917907 dir, post_process=0) 2024-11-19 12:29:57,592 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/mapping.conf.json 2024-11-19 12:29:57,594 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/ext_mapping.conf.json 2024-11-19 12:29:57,602 DEBUG (yalibrary.toolscache) [MainThread] Tools cache attempt: (request for resource 7448917907) 2024-11-19 12:29:57,602 DEBUG (yalibrary.toolscache) [MainThread] Tools cache server resource download/parameters 2024-11-19 12:29:57,602 DEBUG (yalibrary.tools) [MainThread] Using old-style toolchain for: ya-tc 2024-11-19 12:29:57,602 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/ya-tc/public.resources.json 2024-11-19 12:29:57,602 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ya-tc: try to fetch by {'darwin': {'uri': 'sbr:6812263131'}, 'darwin-arm64': {'uri': 'sbr:6812261994'}, 'linux': {'uri': 'sbr:6812260917'}, 'linux-aarch64': {'uri': 'sbr:6812259929'}} for 'linux' 2024-11-19 12:29:57,602 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ya-tc: will use 'linux' platform 2024-11-19 12:29:57,602 DEBUG (yalibrary.fetcher.resource_fetcher) [MainThread] Fetching 6812260917 from sbr:6812260917 to /home/runner/.ya/tools/v4/6812260917 dir, post_process=0) 2024-11-19 12:29:57,602 DEBUG (yalibrary.toolscache) [MainThread] tc cache stats: None 2024-11-19 12:29:57,602 DEBUG (yalibrary.fetcher.cache_helper) [MainThread] Resource seems to be installed in /home/runner/.ya/tools/v4/6812260917 2024-11-19 12:29:57,602 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ya-tc: successfully fetched into /home/runner/.ya/tools/v4/6812260917 2024-11-19 12:29:57,603 DEBUG (yalibrary.tools) [MainThread] Using old-style toolchain for: ya-tc 2024-11-19 12:29:57,603 DEBUG (yalibrary.toolscache) [MainThread] tc cache stats: None 2024-11-19 12:29:57,603 DEBUG (yalibrary.toolscache) [MainThread] Tools cache server resource download/parameters done: id=6812260917, full_path=/home/runner/.ya/tools/v4/6812260917/ya-tc 2024-11-19 12:29:57,606 DEBUG (yalibrary.toolscache) [MainThread] Tools cache (request for resource 7448917907) address: (2448, 12055, 'unix:/home/runner/.ya/tools/v4/psingMOQUGz.tmp') 2024-11-19 12:29:57,611 DEBUG (yalibrary.toolscache) [MainThread] tc cache stats: TotalKnownSize: 62119936 TotalKnownSizeLocked: 22249472 Master: true TotalDBSize: 81920 ToolCount: 2 ProcessesCount: 2 2024-11-19 12:29:57,611 DEBUG (yalibrary.fetcher.cache_helper) [MainThread] Resource seems to be installed in /home/runner/.ya/tools/v4/7448917907 2024-11-19 12:29:57,611 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ymake: successfully fetched into /home/runner/.ya/tools/v4/7448917907 2024-11-19 12:29:57,611 DEBUG (exts.timer) [MainThread] Timer build.graph, stage fetch ymake: 0.01929497718811035 2024-11-19 12:29:57,611 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=gen-graph-default-linux-x86_64-release-asan-pic, group=graph, time=1732019397.6116943 2024-11-19 12:29:57,612 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-default-linux-x86_64-release-asan-pic_started=1732019397.6116943 2024-11-19 12:29:57,612 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-default-linux-x86_64-release-asan-pic_started - 1732019397.6116943 2024-11-19 12:29:57,612 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=gen-graph-default-linux-x86_64-release-asan-nopic, group=graph, time=1732019397.6120906 2024-11-19 12:29:57,612 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-default-linux-x86_64-release-asan-nopic_started=1732019397.6120906 2024-11-19 12:29:57,612 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-default-linux-x86_64-release-asan-nopic_started - 1732019397.6120906 2024-11-19 12:29:57,613 DEBUG (core.stage_tracer) [MainThread] Start stage tag=get-tools, group=graph, time=1732019397.612348 2024-11-19 12:29:57,613 DEBUG (core.stages_profiler) [MainThread] Set stage get-tools_started=1732019397.612348 2024-11-19 12:29:57,613 DEBUG (core.profiler) [MainThread] Profile step get-tools_started - 1732019397.612348 2024-11-19 12:29:57,613 DEBUG (core.stage_tracer) [MainThread] Start stage tag=waiting-tool-targets, group=graph, time=1732019397.6132555 2024-11-19 12:29:57,613 DEBUG (core.stages_profiler) [MainThread] Set stage waiting-tool-targets_started=1732019397.6132555 2024-11-19 12:29:57,613 DEBUG (core.profiler) [MainThread] Profile step waiting-tool-targets_started - 1732019397.6132555 2024-11-19 12:29:57,613 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=gen-graph-gen-opts-default-linux-x86_64-release-asan-pic, group=graph, time=1732019397.612634 2024-11-19 12:29:57,613 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-gen-opts-default-linux-x86_64-release-asan-pic_started=1732019397.612634 2024-11-19 12:29:57,613 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-gen-opts-default-linux-x86_64-release-asan-pic_started - 1732019397.612634 2024-11-19 12:29:57,613 DEBUG (yalibrary.guards) [Misc-02] Enter guard fetch with value None 2024-11-19 12:29:57,613 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic, group=graph, time=1732019397.6134415 2024-11-19 12:29:57,614 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic_started=1732019397.6134415 2024-11-19 12:29:57,614 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic_started - 1732019397.6134415 2024-11-19 12:29:57,614 DEBUG (yalibrary.guards) [Misc-03] Enter guard fetch with value None 2024-11-19 12:29:57,614 DEBUG (yalibrary.vcs.vcsversion) [Misc-01] b'fatal: No names found, cannot describe anything.\n' Running git describe --exact-match --tags HEAD failed with exit code 128 2024-11-19 12:29:57,616 DEBUG (yalibrary.vcs.vcsversion) [Misc-01] b'fatal: No names found, cannot describe anything.\n' Running git describe --exact-match --all HEAD failed with exit code 128 2024-11-19 12:29:57,618 DEBUG (yalibrary.vcs.vcsversion) [Misc-01] Git info commit:b'e6fde79e0d5a3f22ef6e6d28e2228ffd3cb4c7b1', author:b'Semyon ', summary:b'Merge 7c9755297b910ed6a9c1da4d208244b2caedc2b4 into 73654270aa388c26ddae0ef5e4efc4bcc8896f82', svn_id:b'' 2024-11-19 12:29:57,619 DEBUG (yalibrary.vcs.vcsversion) [Misc-01] Other data: Other info: Build by: runner Top src dir: /home/runner/actions_runner/_work/ydb/ydb Top build dir: /home/runner/.ya/build Hostname: ghrun-7yuykhajoi Host information: Linux ghrun-7yuykhajoi 5.15.0-124-generic #134-Ubuntu SMP Fri Sep 27 20:20:17 UTC 2024 x86_64 2024-11-19 12:29:57,619 DEBUG (build.graph) [Misc-01] Got version json "{\n \"ARCADIA_PATCH_NUMBER\": 1,\n \"ARCADIA_SOURCE_HG_HASH\": \"e6fde79e0d5a3f22ef6e6d28e2228ffd3cb4c7b1\",\n \"ARCADIA_SOURCE_LAST_AUTHOR\": \"Semyon \",\n \"ARCADIA_SOURCE_LAST_CHANGE\": -1,\n \"ARCADIA_SOURCE_PATH\": \"/home/runner/actions_runner/_work/ydb/ydb\",\n \"ARCADIA_SOURCE_REVISION\": -1,\n \"ARCADIA_SOURCE_URL\": \"\",\n \"ARCADIA_TAG\": \"\",\n \"BRANCH\": \"\",\n \"BUILD_DATE\": \"2024-11-19T12:29:57.000000Z\",\n \"BUILD_HOST\": \"ghrun-7yuykhajoi\",\n \"BUILD_TIMESTAMP\": 1732019397,\n \"BUILD_USER\": \"runner\",\n \"CUSTOM_VERSION\": \"\",\n \"DIRTY\": \"\",\n \"PROGRAM_VERSION\": \"Git info:\\n Commit: e6fde79e0d5a3f22ef6e6d28e2228ffd3cb4c7b1\\n Branch: \\n Author: Semyon \\n Summary: Merge 7c9755297b910ed6a9c1da4d208244b2caedc2b4 into 73654270aa388c26ddae0ef5e4efc4bcc8896f82\\n\\nOther info:\\n Build by: runner\\n Top src dir: /home/runner/actions_runner/_work/ydb/ydb\\n Top build dir: /home/runner/.ya/build\\n Hostname: ghrun-7yuykhajoi\\n Host information: \\n Linux ghrun-7yuykhajoi 5.15.0-124-generic #134-Ubuntu SMP Fri Sep 27 20:20:17 UTC 2024 x86_64\\n\\n \",\n \"SCM_DATA\": \"Git info:\\n Commit: e6fde79e0d5a3f22ef6e6d28e2228ffd3cb4c7b1\\n Branch: \\n Author: Semyon \\n Summary: Merge 7c9755297b910ed6a9c1da4d208244b2caedc2b4 into 73654270aa388c26ddae0ef5e4efc4bcc8896f82\\n\",\n \"VCS\": \"git\"\n}" 2024-11-19 12:29:57,619 DEBUG (exts.timer) [Misc-01] Timer get_version_info, stage vcs info: 0.03301668167114258 2024-11-19 12:29:57,645 DEBUG (build.genconf) [Misc-03] Generating conf into /home/runner/.ya/build/conf/dist-release-f3f3c5ea54295418c5f929aa2d708bb5/ymake.conf with cmd ['/home/runner/.ya/tools/38e015ab6e_d/ya-bin', '/home/runner/actions_runner/_work/ydb/ydb/build/ymake_conf.py', '/home/runner/actions_runner/_work/ydb/ydb', 'dist-release', 'no', '--toolchain-params', 'eyJib3R0bGVfbmFtZSI6ImNsYW5nMTgiLCJlbnYiOnsiQ1BBVEgiOlsiIl0sIkxJQlJBUllfUEFUSCI6WyIiXSwiU0RLUk9PVCI6WyIiXX0sImV4ZWN1dGFibGVfcGF0aCI6ImMrKyIsImZsYWdzIjp7IlNBTklUSVpFUl9UWVBFIjoiYWRkcmVzcyJ9LCJmb3JtdWxhIjp7ImJ5X3BsYXRmb3JtIjp7ImRhcndpbi1hcm02NCI6eyJ1cmkiOiJzYnI6NzQ1MTYwMjYwOSJ9LCJkYXJ3aW4teDg2XzY0Ijp7InVyaSI6InNicjo3NDUxNTg1OTYyIn0sImxpbnV4LWFhcmNoNjQiOnsidXJpIjoic2JyOjc0NTE3MTIzMzIifSwibGludXgteDg2XzY0Ijp7InVyaSI6InNicjo3NDUxNDY2NDA3In0sIndpbjMyLXg4Nl82NCI6eyJ1cmkiOiJzYnI6NzQ1MTQwNjkwMCJ9fX0sIm5hbWUiOiJjbGFuZzE4IiwicGFyYW1zIjp7ImNfY29tcGlsZXIiOiIkKENMQU5HLTE3MzUwNTY4MjEpL2Jpbi9jbGFuZyIsImN4eF9jb21waWxlciI6IiQoQ0xBTkctMTczNTA1NjgyMSkvYmluL2NsYW5nKysiLCJnY2NfdmVyc2lvbiI6IjE4IiwibGx2bS1zeW1ib2xpemVyIjoiJChDTEFORy0xNzM1MDU2ODIxKS9iaW4vbGx2bS1zeW1ib2xpemVyIiwibWF0Y2hfcm9vdCI6IkNMQU5HLTE3MzUwNTY4MjEiLCJvYmpjb3B5IjoiJChDTEFORy0xNzM1MDU2ODIxKS9iaW4vbGx2bS1vYmpjb3B5IiwicHJvZmlsZXMiOiIkKFhDT0RFX1RPT0xTX1JPT1Qtc2JyOjc5OTAxNzc3MSkvWGNvZGUvQ29udGVudHMvRGV2ZWxvcGVyL1BsYXRmb3Jtcy9pUGhvbmVPUy5wbGF0Zm9ybS9EZXZlbG9wZXIvTGlicmFyeS9Db3JlU2ltdWxhdG9yL1Byb2ZpbGVzIiwic2ltY3RsIjoiJChYQ09ERV9UT09MU19ST09ULXNicjo3OTkwMTc3NzEpL1hjb2RlL1N5c3RlbVJvb3QvUHJpdmF0ZUZyYW1ld29ya3MvQ29yZVNpbXVsYXRvci5mcmFtZXdvcmsvUmVzb3VyY2VzL2Jpbi9zaW1jdGwiLCJzdHJpcCI6IiQoQ0xBTkctMTczNTA1NjgyMSkvYmluL2xsdm0tc3RyaXAiLCJ0eXBlIjoiY2xhbmciLCJ1c2VfYnVuZGxlIjp0cnVlLCJ3ZXJyb3JfbW9kZSI6ImFsbCJ9LCJwbGF0Zm9ybSI6eyJob3N0Ijp7ImFyY2giOiJ4ODZfNjQiLCJvcyI6IkxJTlVYIiwidG9vbGNoYWluIjoiZGVmYXVsdCIsInZpc2libGVfbmFtZSI6ImNsYW5nMTgifSwidGFyZ2V0Ijp7ImFyY2giOiJ4ODZfNjQiLCJvcyI6IkxJTlVYIiwidG9vbGNoYWluIjoiZGVmYXVsdCIsInZpc2libGVfbmFtZSI6ImNsYW5nMTgifX0sInBsYXRmb3JtX25hbWUiOiJERUZBVUxULUxJTlVYLVg4Nl82NCIsInRvb2xfdmFyIjoiQ0xBTkctMTczNTA1NjgyMSJ9', '-l', '-D', 'APPLE_SDK_LOCAL=yes', '-D', 'CFLAGS=-fno-omit-frame-pointer', '-D', 'CLANG18=yes', '-D', 'CONSISTENT_DEBUG=yes', '-D', 'DEBUGINFO_LINES_ONLY=yes', '-D', 'DISABLE_FLAKE8_MIGRATIONS=yes', '-D', 'FORCE_NO_PIC=yes', '-D', 'IS_CROSS_SANITIZE=yes', '-D', 'OPENSOURCE=yes', '-D', 'SANITIZER_TYPE=address', '-D', 'TESTS_REQUESTED=yes', '-D', 'TRAVERSE_DEPENDS=yes', '-D', 'TRAVERSE_RECURSE_FOR_TESTS=yes', '-D', 'USE_AIO=static', '-D', 'USE_CLANG_CL=yes', '-D', 'USE_EAT_MY_DATA=yes', '-D', 'USE_ICONV=static', '-D', 'USE_IDN=static', '-D', 'USE_PREBUILT_TOOLS=no', '-D', 'YA=yes'] and env {'PATH': '/home/runner/actions_runner/_work/ydb/ydb/ydb/ci/scripts:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/snap/bin', 'Y_PYTHON_ENTRY_POINT': ':main'} 2024-11-19 12:29:57,646 DEBUG (build.genconf) [Misc-02] Generating conf into /home/runner/.ya/build/conf/dist-release-9efc4ef9baf1fc778c40c5e443395e41/ymake.conf with cmd ['/home/runner/.ya/tools/38e015ab6e_d/ya-bin', '/home/runner/actions_runner/_work/ydb/ydb/build/ymake_conf.py', '/home/runner/actions_runner/_work/ydb/ydb', 'dist-release', 'no', '--toolchain-params', 'eyJib3R0bGVfbmFtZSI6ImNsYW5nMTgiLCJlbnYiOnsiQ1BBVEgiOlsiIl0sIkxJQlJBUllfUEFUSCI6WyIiXSwiU0RLUk9PVCI6WyIiXX0sImV4ZWN1dGFibGVfcGF0aCI6ImMrKyIsImZsYWdzIjp7IlNBTklUSVpFUl9UWVBFIjoiYWRkcmVzcyJ9LCJmb3JtdWxhIjp7ImJ5X3BsYXRmb3JtIjp7ImRhcndpbi1hcm02NCI6eyJ1cmkiOiJzYnI6NzQ1MTYwMjYwOSJ9LCJkYXJ3aW4teDg2XzY0Ijp7InVyaSI6InNicjo3NDUxNTg1OTYyIn0sImxpbnV4LWFhcmNoNjQiOnsidXJpIjoic2JyOjc0NTE3MTIzMzIifSwibGludXgteDg2XzY0Ijp7InVyaSI6InNicjo3NDUxNDY2NDA3In0sIndpbjMyLXg4Nl82NCI6eyJ1cmkiOiJzYnI6NzQ1MTQwNjkwMCJ9fX0sIm5hbWUiOiJjbGFuZzE4IiwicGFyYW1zIjp7ImNfY29tcGlsZXIiOiIkKENMQU5HLTE3MzUwNTY4MjEpL2Jpbi9jbGFuZyIsImN4eF9jb21waWxlciI6IiQoQ0xBTkctMTczNTA1NjgyMSkvYmluL2NsYW5nKysiLCJnY2NfdmVyc2lvbiI6IjE4IiwibGx2bS1zeW1ib2xpemVyIjoiJChDTEFORy0xNzM1MDU2ODIxKS9iaW4vbGx2bS1zeW1ib2xpemVyIiwibWF0Y2hfcm9vdCI6IkNMQU5HLTE3MzUwNTY4MjEiLCJvYmpjb3B5IjoiJChDTEFORy0xNzM1MDU2ODIxKS9iaW4vbGx2bS1vYmpjb3B5IiwicHJvZmlsZXMiOiIkKFhDT0RFX1RPT0xTX1JPT1Qtc2JyOjc5OTAxNzc3MSkvWGNvZGUvQ29udGVudHMvRGV2ZWxvcGVyL1BsYXRmb3Jtcy9pUGhvbmVPUy5wbGF0Zm9ybS9EZXZlbG9wZXIvTGlicmFyeS9Db3JlU2ltdWxhdG9yL1Byb2ZpbGVzIiwic2ltY3RsIjoiJChYQ09ERV9UT09MU19ST09ULXNicjo3OTkwMTc3NzEpL1hjb2RlL1N5c3RlbVJvb3QvUHJpdmF0ZUZyYW1ld29ya3MvQ29yZVNpbXVsYXRvci5mcmFtZXdvcmsvUmVzb3VyY2VzL2Jpbi9zaW1jdGwiLCJzdHJpcCI6IiQoQ0xBTkctMTczNTA1NjgyMSkvYmluL2xsdm0tc3RyaXAiLCJ0eXBlIjoiY2xhbmciLCJ1c2VfYnVuZGxlIjp0cnVlLCJ3ZXJyb3JfbW9kZSI6ImFsbCJ9LCJwbGF0Zm9ybSI6eyJob3N0Ijp7ImFyY2giOiJ4ODZfNjQiLCJvcyI6IkxJTlVYIiwidG9vbGNoYWluIjoiZGVmYXVsdCIsInZpc2libGVfbmFtZSI6ImNsYW5nMTgifSwidGFyZ2V0Ijp7ImFyY2giOiJ4ODZfNjQiLCJvcyI6IkxJTlVYIiwidG9vbGNoYWluIjoiZGVmYXVsdCIsInZpc2libGVfbmFtZSI6ImNsYW5nMTgifX0sInBsYXRmb3JtX25hbWUiOiJERUZBVUxULUxJTlVYLVg4Nl82NCIsInRvb2xfdmFyIjoiQ0xBTkctMTczNTA1NjgyMSJ9', '-l', '-D', 'APPLE_SDK_LOCAL=yes', '-D', 'CFLAGS=-fno-omit-frame-pointer', '-D', 'CLANG18=yes', '-D', 'CONSISTENT_DEBUG=yes', '-D', 'DEBUGINFO_LINES_ONLY=yes', '-D', 'DISABLE_FLAKE8_MIGRATIONS=yes', '-D', 'IS_CROSS_SANITIZE=yes', '-D', 'OPENSOURCE=yes', '-D', 'SANITIZER_TYPE=address', '-D', 'TESTS_REQUESTED=yes', '-D', 'TRAVERSE_DEPENDS=yes', '-D', 'TRAVERSE_RECURSE_FOR_TESTS=yes', '-D', 'USE_AIO=static', '-D', 'USE_CLANG_CL=yes', '-D', 'USE_EAT_MY_DATA=yes', '-D', 'USE_ICONV=static', '-D', 'USE_IDN=static', '-D', 'USE_PREBUILT_TOOLS=no', '-D', 'YA=yes'] and env {'PATH': '/home/runner/actions_runner/_work/ydb/ydb/ydb/ci/scripts:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/snap/bin', 'Y_PYTHON_ENTRY_POINT': ':main'} 2024-11-19 12:29:57,770 DEBUG (build.genconf) [Misc-03] Copy conf /home/runner/.ya/build/conf/dist-release-f3f3c5ea54295418c5f929aa2d708bb5/ymake.conf to /home/runner/.ya/build/conf/dist-release-x-89b78db1db59d8d6855caed33424337f/ymake.conf 2024-11-19 12:29:57,770 DEBUG (yalibrary.guards) [Misc-03] Exit guard fetch with value None 2024-11-19 12:29:57,770 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic, group=graph, time=1732019397.7704818 2024-11-19 12:29:57,770 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic_finished=1732019397.7704818 2024-11-19 12:29:57,770 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic_finished - 1732019397.7704818 2024-11-19 12:29:57,770 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=gen-graph-json-default-linux-x86_64-release-asan-nopic, group=graph, time=1732019397.7706754 2024-11-19 12:29:57,770 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-json-default-linux-x86_64-release-asan-nopic_started=1732019397.7706754 2024-11-19 12:29:57,770 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-json-default-linux-x86_64-release-asan-nopic_started - 1732019397.7706754 2024-11-19 12:29:57,770 DEBUG (build.ymake2) [Misc-03] Run gen graph with {'grab_stderr': True, 'mode': 'dist', 'dump_graph': 'json', 'check': True, '_purpose': 'default-linux-x86_64-release-asan-nopic', 'cpp': True, 'custom_build_directory': '/home/runner/.ya/build/conf/dist-release-x-89b78db1db59d8d6855caed33424337f_d357a1f7839b099012272bcb9853ec19', 'build_type': 'release', 'abs_targets': ['/home/runner/actions_runner/_work/ydb/ydb'], 'debug_options': [], 'custom_conf': '/home/runner/.ya/build/conf/dist-release-x-89b78db1db59d8d6855caed33424337f/ymake.conf', 'continue_on_fail': False, 'ymake_bin': None, 'warn_mode': ['dirloops', 'ChkPeers'], 'build_depends': 3, 'arcadia_tests_data_path': '/home/runner/actions_runner/_work/ydb/arcadia_tests_data', 'checkout_data_by_ya': False, 'strict_inputs': False, 'dump_inputs_map': False, 'ev_listener': .event_listener_debug_id_wrapper at 0x7f742ee704a0>, 'enabled_events': 'dGT', 'no_caches_on_retry': False, 'no_ymake_retry': False, 'disable_customization': 0, 'dump_tests': '/home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.9b_g7kuw/test.dart', 'dump_make_files': '/home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.9b_g7kuw/makefiles.dart'} 2024-11-19 12:29:57,770 DEBUG (core.yarg.behaviour) [Misc-03] Found unused args ['grab_stderr'] 2024-11-19 12:29:57,771 DEBUG (build.prefetch) [Misc-03] prefetch disabled 2024-11-19 12:29:57,771 DEBUG (core.event_handling.base_subscriber) [Misc-03] Subscribing PrintProgressSubscriber to event_queue 2024-11-19 12:29:57,771 DEBUG (yalibrary.tools) [Misc-03] Using old-style toolchain for: ymake 2024-11-19 12:29:57,771 DEBUG (build.ymake2.run_ymake) [Misc-03] run: '/home/runner/.ya/tools/v4/7448917907/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732019397.3025.c6ogw00k/yatmpqh8m1y61 --config /home/runner/.ya/build/conf/dist-release-x-89b78db1db59d8d6855caed33424337f/ymake.conf --plugins-root /home/runner/actions_runner/_work/ydb/ydb/build/plugins,/home/runner/actions_runner/_work/ydb/ydb/build/internal/plugins --build-root /home/runner/.ya/build/conf/dist-release-x-89b78db1db59d8d6855caed33424337f_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.9b_g7kuw/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.9b_g7kuw/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' with env: { } 2024-11-19 12:29:57,771 DEBUG (build.genconf) [Misc-02] Copy conf /home/runner/.ya/build/conf/dist-release-9efc4ef9baf1fc778c40c5e443395e41/ymake.conf to /home/runner/.ya/build/conf/dist-release-x-9ee9d4a643e508fb4aafc1035ff3a1f6/ymake.conf 2024-11-19 12:29:57,773 DEBUG (yalibrary.guards) [Misc-02] Exit guard fetch with value None 2024-11-19 12:29:57,774 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=gen-graph-gen-opts-default-linux-x86_64-release-asan-pic, group=graph, time=1732019397.774121 2024-11-19 12:29:57,774 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-gen-opts-default-linux-x86_64-release-asan-pic_finished=1732019397.774121 2024-11-19 12:29:57,774 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-gen-opts-default-linux-x86_64-release-asan-pic_finished - 1732019397.774121 2024-11-19 12:29:57,774 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=gen-graph-json-default-linux-x86_64-release-asan-pic, group=graph, time=1732019397.7743647 2024-11-19 12:29:57,774 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-json-default-linux-x86_64-release-asan-pic_started=1732019397.7743647 2024-11-19 12:29:57,774 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-json-default-linux-x86_64-release-asan-pic_started - 1732019397.7743647 2024-11-19 12:29:57,774 DEBUG (build.ymake2) [Misc-02] Run gen graph with {'grab_stderr': True, 'mode': 'dist', 'dump_graph': 'json', 'check': True, '_purpose': 'default-linux-x86_64-release-asan-pic', 'cpp': True, 'custom_build_directory': '/home/runner/.ya/build/conf/dist-release-x-9ee9d4a643e508fb4aafc1035ff3a1f6_d357a1f7839b099012272bcb9853ec19', 'build_type': 'release', 'abs_targets': ['/home/runner/actions_runner/_work/ydb/ydb'], 'debug_options': [], 'custom_conf': '/home/runner/.ya/build/conf/dist-release-x-9ee9d4a643e508fb4aafc1035ff3a1f6/ymake.conf', 'continue_on_fail': False, 'ymake_bin': None, 'warn_mode': ['dirloops', 'ChkPeers'], 'build_depends': 3, 'arcadia_tests_data_path': '/home/runner/actions_runner/_work/ydb/arcadia_tests_data', 'checkout_data_by_ya': False, 'strict_inputs': False, 'dump_inputs_map': False, 'ev_listener': .event_listener_debug_id_wrapper at 0x7f742e17b240>, 'enabled_events': 'dGT', 'no_caches_on_retry': False, 'no_ymake_retry': False, 'disable_customization': 0, 'dump_tests': '/home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.hm96xwe6/test.dart', 'dump_make_files': '/home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.hm96xwe6/makefiles.dart'} 2024-11-19 12:29:57,774 DEBUG (core.yarg.behaviour) [Misc-02] Found unused args ['grab_stderr'] 2024-11-19 12:29:57,774 DEBUG (build.prefetch) [Misc-02] prefetch disabled 2024-11-19 12:29:57,775 DEBUG (yalibrary.tools) [Misc-02] Using old-style toolchain for: ymake 2024-11-19 12:29:57,775 DEBUG (build.ymake2.run_ymake) [Misc-02] run: '/home/runner/.ya/tools/v4/7448917907/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732019397.3025.c6ogw00k/yatmpof2lo84k --config /home/runner/.ya/build/conf/dist-release-x-9ee9d4a643e508fb4aafc1035ff3a1f6/ymake.conf --plugins-root /home/runner/actions_runner/_work/ydb/ydb/build/plugins,/home/runner/actions_runner/_work/ydb/ydb/build/internal/plugins --build-root /home/runner/.ya/build/conf/dist-release-x-9ee9d4a643e508fb4aafc1035ff3a1f6_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.hm96xwe6/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.hm96xwe6/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' with env: { } 2024-11-19 12:29:57,777 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"ymake run","_timestamp":1732019397777463,"_typename":"NEvent.TStageStarted","debug_id":"default-linux-x86_64-release-asan-nopic","ymake_run_uid":0} 2024-11-19 12:29:57,778 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Target path: /home/runner/actions_runner/_work/ydb/ydb\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019397777570,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:57,778 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load configuration from cache","_timestamp":1732019397777602,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:57,778 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Conf cache has not been loaded (reason: File does not exist)...\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019397777610,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:57,778 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load configuration from cache","_timestamp":1732019397777614,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:57,778 DEBUG (build.ya_make) [Misc-03] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedConfCache","Type":"bool","_timestamp":1732019397777854,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-19 12:29:57,778 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1732019397777858,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:57,780 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"ymake run","_timestamp":1732019397780401,"_typename":"NEvent.TStageStarted","debug_id":"default-linux-x86_64-release-asan-pic","ymake_run_uid":1} 2024-11-19 12:29:57,780 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Target path: /home/runner/actions_runner/_work/ydb/ydb\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019397780492,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:57,780 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load configuration from cache","_timestamp":1732019397780521,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:57,780 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Conf cache has not been loaded (reason: File does not exist)...\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019397780529,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:57,781 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load configuration from cache","_timestamp":1732019397780533,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:57,781 DEBUG (build.ya_make) [Misc-02] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedConfCache","Type":"bool","_timestamp":1732019397780771,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-19 12:29:57,781 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1732019397780775,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:57,930 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1732019397930539,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:57,931 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1732019397930560,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:57,932 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1732019397932071,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:57,932 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Fold global commands","_timestamp":1732019397932082,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:57,933 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Fold global commands","_timestamp":1732019397933206,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:57,933 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1732019397933140,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:57,933 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load plugins","_timestamp":1732019397933214,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:57,933 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1732019397933159,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:57,934 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1732019397934526,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:57,934 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Fold global commands","_timestamp":1732019397934537,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:57,935 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Fold global commands","_timestamp":1732019397935663,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:57,935 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load plugins","_timestamp":1732019397935671,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:58,048 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load plugins","_timestamp":1732019398047982,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:58,050 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load plugins","_timestamp":1732019398050102,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:58,079 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"MAIN_OUTPUT_AS_EXTRA enabled\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398078708,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,079 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"YMAKE_DEDICATED_MODULE_NODE disabled (by default)\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398078726,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,079 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"YMAKE_CHECK_FOR_INCORRECT_LOOPS disabled (by default)\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398078731,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,079 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"mlockall failed\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398078815,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,079 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"ymake main","_timestamp":1732019398078819,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:58,079 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"FS cache loading is enabled\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398078871,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,080 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"FS cache saving is enabled\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398078876,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,080 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Deps cache loading is enabled\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398078879,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,080 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Deps cache saving is enabled\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398078883,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,080 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"DepManagement cache loading is enabled\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398078886,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,080 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"DepManagement cache saving is enabled\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398078890,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,080 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Uids cache loading is enabled\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398078893,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,080 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Uids cache saving is enabled\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398078896,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,080 DEBUG (build.ya_make) [Misc-03] Configure message {"HasChangelist":false,"_timestamp":1732019398079735,"_typename":"NEvent.TArcChanges","ymake_run_uid":0} 2024-11-19 12:29:58,080 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Graph has structural changes because of PatchPath\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398079743,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,081 DEBUG (build.ya_make) [Misc-03] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedFSCache","Type":"bool","_timestamp":1732019398079750,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-19 12:29:58,081 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"MAIN_OUTPUT_AS_EXTRA enabled\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398080881,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,081 DEBUG (build.ya_make) [Misc-03] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedDepsCache","Type":"bool","_timestamp":1732019398079754,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-19 12:29:58,081 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"YMAKE_DEDICATED_MODULE_NODE disabled (by default)\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398080899,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,081 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Build graph","_timestamp":1732019398079758,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:58,081 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"YMAKE_CHECK_FOR_INCORRECT_LOOPS disabled (by default)\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398080903,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,081 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Graph has structural changes because start dirs are different\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398079763,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,081 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"mlockall failed\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398080977,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,081 DEBUG (build.ya_make) [Misc-03] Configure message {"PredictsStructuralChanges":true,"_timestamp":1732019398079767,"_typename":"NEvent.TGraphChangesPrediction","ymake_run_uid":0} 2024-11-19 12:29:58,081 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"ymake main","_timestamp":1732019398080982,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:58,082 DEBUG (build.ya_make) [Misc-03] Configure message {"Enabled":false,"MaybeEnabled":false,"_timestamp":1732019398079771,"_typename":"NEvent.TBypassConfigure","ymake_run_uid":0} 2024-11-19 12:29:58,082 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"FS cache loading is enabled\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398081018,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,082 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Configure graph","_timestamp":1732019398079774,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:58,082 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"FS cache saving is enabled\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398081023,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,082 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Deps cache loading is enabled\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398081027,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,082 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Deps cache saving is enabled\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398081030,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,082 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"DepManagement cache loading is enabled\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398081034,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,082 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"DepManagement cache saving is enabled\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398081037,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,082 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Uids cache loading is enabled\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398081041,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,083 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Uids cache saving is enabled\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398081044,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,083 DEBUG (build.ya_make) [Misc-02] Configure message {"HasChangelist":false,"_timestamp":1732019398081859,"_typename":"NEvent.TArcChanges","ymake_run_uid":1} 2024-11-19 12:29:58,083 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Graph has structural changes because of PatchPath\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398081867,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,083 DEBUG (build.ya_make) [Misc-02] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedFSCache","Type":"bool","_timestamp":1732019398081873,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-19 12:29:58,083 DEBUG (build.ya_make) [Misc-02] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedDepsCache","Type":"bool","_timestamp":1732019398081877,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-19 12:29:58,083 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Build graph","_timestamp":1732019398081881,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:58,083 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Graph has structural changes because start dirs are different\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398081886,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,083 DEBUG (build.ya_make) [Misc-02] Configure message {"PredictsStructuralChanges":true,"_timestamp":1732019398081890,"_typename":"NEvent.TGraphChangesPrediction","ymake_run_uid":1} 2024-11-19 12:29:58,083 DEBUG (build.ya_make) [Misc-02] Configure message {"Enabled":false,"MaybeEnabled":false,"_timestamp":1732019398081893,"_typename":"NEvent.TBypassConfigure","ymake_run_uid":1} 2024-11-19 12:29:58,083 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Configure graph","_timestamp":1732019398081897,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:58,175 DEBUG (build.ya_make) [Misc-02] Configure message {"DoubleValue":0.09315461247,"Name":"EYmakeStats::ConfigureGraphTime","Type":"double","_timestamp":1732019398175065,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-19 12:29:58,175 DEBUG (build.ya_make) [Misc-03] Configure message {"DoubleValue":0.0952756358,"Name":"EYmakeStats::ConfigureGraphTime","Type":"double","_timestamp":1732019398175065,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-19 12:29:58,175 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Configure graph","_timestamp":1732019398175087,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:58,175 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Configure graph","_timestamp":1732019398175088,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:58,176 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Searching target '.'\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398175096,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,176 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Searching target '.'\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398175097,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,176 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Selected target '$S' with id 3\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398175103,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,176 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Selected target '$S' with id 3\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398175103,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,176 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Find Lost Includes","_timestamp":1732019398175152,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:58,176 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Find Lost Includes","_timestamp":1732019398175152,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:58,176 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"TIncFixer stats: 0 resolved to nothing, 0 resolved to existing, 0 resolved to new.\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398175227,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,176 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"TIncFixer stats: 0 resolved to nothing, 0 resolved to existing, 0 resolved to new.\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398175227,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,176 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Find Lost Includes","_timestamp":1732019398175231,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:58,177 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Find Lost Includes","_timestamp":1732019398175231,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:58,177 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"loaded size = 9024203; load time = 9226; loaded MD5 time = 766; Max loaded MD5 time = 5; loaded count = 2174; max load time = 183; mapped size = 40632376; mapped MD5 time = 5792; Max mapped MD5 time = 365; mapped count = 130; map time = 683; from patch count = 0; from patch size = 0; file stat count = 3223; lstat count = 3045; lstat sum us = 3104; lstat min us = 0; lstat avr us = 1; lstat max us = 9; opendir count = 388; opendir sum us = 0; opendir min us = 0; opendir avr us = 0; opendir max us = 0; readdir count = 2837; readdir sum us = 1825; readdir min us = 0; readdir avr us = 0; readdir max us = 39; (opendir + readdir) sum us = 1825; (lstat + opendir + readdir) sum us = 4929;","Mod":"unimp","Sub":"File access stats","Type":"Debug","_timestamp":1732019398175263,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,177 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"loaded size = 9024203; load time = 9877; loaded MD5 time = 739; Max loaded MD5 time = 5; loaded count = 2174; max load time = 125; mapped size = 40632376; mapped MD5 time = 6105; Max mapped MD5 time = 367; mapped count = 130; map time = 695; from patch count = 0; from patch size = 0; file stat count = 3223; lstat count = 3045; lstat sum us = 3168; lstat min us = 1; lstat avr us = 1; lstat max us = 10; opendir count = 388; opendir sum us = 0; opendir min us = 0; opendir avr us = 0; opendir max us = 0; readdir count = 2837; readdir sum us = 2037; readdir min us = 0; readdir avr us = 0; readdir max us = 39; (opendir + readdir) sum us = 2037; (lstat + opendir + readdir) sum us = 5205;","Mod":"unimp","Sub":"File access stats","Type":"Debug","_timestamp":1732019398175261,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,177 DEBUG (build.ya_make) [Misc-02] Configure message {"FileStatCount":3223,"FromPatchCount":0,"FromPatchSize":0,"ListDirSumUs":1825,"LoadTime":9226,"LoadedCount":2174,"LoadedMD5Time":766,"LoadedSize":9024203,"LstatAvrUs":1,"LstatCount":3045,"LstatListDirSumUs":4929,"LstatMaxUs":9,"LstatMinUs":0,"LstatSumUs":3104,"MapTime":683,"MappedCount":130,"MappedMD5Time":5792,"MappedSize":40632376,"MaxLoadTime":183,"MaxLoadedMD5Time":5,"MaxMappedMD5Time":365,"OpendirAvrUs":0,"OpendirCount":388,"OpendirMaxUs":0,"OpendirMinUs":0,"OpendirSumUs":0,"ReaddirAvrUs":0,"ReaddirCount":2837,"ReaddirMaxUs":39,"ReaddirMinUs":0,"ReaddirSumUs":1825,"_timestamp":1732019398175274,"_typename":"NEvent.TFileConfStats","ymake_run_uid":1} 2024-11-19 12:29:58,177 DEBUG (build.ya_make) [Misc-03] Configure message {"FileStatCount":3223,"FromPatchCount":0,"FromPatchSize":0,"ListDirSumUs":2037,"LoadTime":9877,"LoadedCount":2174,"LoadedMD5Time":739,"LoadedSize":9024203,"LstatAvrUs":1,"LstatCount":3045,"LstatListDirSumUs":5205,"LstatMaxUs":10,"LstatMinUs":1,"LstatSumUs":3168,"MapTime":695,"MappedCount":130,"MappedMD5Time":6105,"MappedSize":40632376,"MaxLoadTime":125,"MaxLoadedMD5Time":5,"MaxMappedMD5Time":367,"OpendirAvrUs":0,"OpendirCount":388,"OpendirMaxUs":0,"OpendirMinUs":0,"OpendirSumUs":0,"ReaddirAvrUs":0,"ReaddirCount":2837,"ReaddirMaxUs":39,"ReaddirMinUs":0,"ReaddirSumUs":2037,"_timestamp":1732019398175274,"_typename":"NEvent.TFileConfStats","ymake_run_uid":0} 2024-11-19 12:29:58,177 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":9024203,"Name":"EFileConfStats::LoadedSize","Type":"int","_timestamp":1732019398175286,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-19 12:29:58,177 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":9024203,"Name":"EFileConfStats::LoadedSize","Type":"int","_timestamp":1732019398175286,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-19 12:29:58,178 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":9226,"Name":"EFileConfStats::LoadTime","Type":"int","_timestamp":1732019398175289,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-19 12:29:58,178 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":9877,"Name":"EFileConfStats::LoadTime","Type":"int","_timestamp":1732019398175290,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-19 12:29:58,178 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":2174,"Name":"EFileConfStats::LoadedCount","Type":"int","_timestamp":1732019398175292,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-19 12:29:58,178 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":2174,"Name":"EFileConfStats::LoadedCount","Type":"int","_timestamp":1732019398175293,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-19 12:29:58,178 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":40632376,"Name":"EFileConfStats::MappedSize","Type":"int","_timestamp":1732019398175295,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-19 12:29:58,178 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":40632376,"Name":"EFileConfStats::MappedSize","Type":"int","_timestamp":1732019398175295,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-19 12:29:58,178 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":683,"Name":"EFileConfStats::MapTime","Type":"int","_timestamp":1732019398175297,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-19 12:29:58,178 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":695,"Name":"EFileConfStats::MapTime","Type":"int","_timestamp":1732019398175298,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-19 12:29:58,178 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":130,"Name":"EFileConfStats::MappedCount","Type":"int","_timestamp":1732019398175300,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-19 12:29:58,178 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":130,"Name":"EFileConfStats::MappedCount","Type":"int","_timestamp":1732019398175300,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-19 12:29:58,178 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":2304,"Name":"EFileConfStats::Count","Type":"int","_timestamp":1732019398175302,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-19 12:29:58,178 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":2304,"Name":"EFileConfStats::Count","Type":"int","_timestamp":1732019398175303,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-19 12:29:58,179 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"bucket id = 0; loaded size = 9024203; load time = 9226; loaded count = 2174; max load time = 183;","Mod":"unimp","Sub":"Bucket #0","Type":"Debug","_timestamp":1732019398175310,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,179 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"bucket id = 0; loaded size = 9024203; load time = 9877; loaded count = 2174; max load time = 125;","Mod":"unimp","Sub":"Bucket #0","Type":"Debug","_timestamp":1732019398175310,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,179 DEBUG (build.ya_make) [Misc-02] Configure message {"BucketId":0,"LoadTime":9226,"LoadedCount":2174,"LoadedSize":9024203,"MaxLoadTime":183,"_timestamp":1732019398175314,"_typename":"NEvent.TFileConfSubStats","ymake_run_uid":1} 2024-11-19 12:29:58,179 DEBUG (build.ya_make) [Misc-03] Configure message {"BucketId":0,"LoadTime":9877,"LoadedCount":2174,"LoadedSize":9024203,"MaxLoadTime":125,"_timestamp":1732019398175314,"_typename":"NEvent.TFileConfSubStats","ymake_run_uid":0} 2024-11-19 12:29:58,179 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"parse time = 3; parsed files count = 6; parsed files size = 12965; parsed files recovered = 0; .in files count = 0; .in files size = 0;","Mod":"unimp","Sub":"Parsing stats","Type":"Debug","_timestamp":1732019398175324,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,179 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"parse time = 4; parsed files count = 6; parsed files size = 12965; parsed files recovered = 0; .in files count = 0; .in files size = 0;","Mod":"unimp","Sub":"Parsing stats","Type":"Debug","_timestamp":1732019398175324,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,179 DEBUG (build.ya_make) [Misc-02] Configure message {"InFilesCount":0,"InFilesSize":0,"ParseTime":3,"ParsedFilesCount":6,"ParsedFilesRecovered":0,"ParsedFilesSize":12965,"_timestamp":1732019398175329,"_typename":"NEvent.TIncParserManagerStats","ymake_run_uid":1} 2024-11-19 12:29:58,179 DEBUG (build.ya_make) [Misc-03] Configure message {"InFilesCount":0,"InFilesSize":0,"ParseTime":4,"ParsedFilesCount":6,"ParsedFilesRecovered":0,"ParsedFilesSize":12965,"_timestamp":1732019398175329,"_typename":"NEvent.TIncParserManagerStats","ymake_run_uid":0} 2024-11-19 12:29:58,179 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"count = 8; includes count = 12; unique count = 8; size = 1264; unique size = 853;","Mod":"unimp","Sub":"ya.make parsing stats","Type":"Debug","_timestamp":1732019398175340,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,180 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"count = 8; includes count = 12; unique count = 8; size = 1264; unique size = 853;","Mod":"unimp","Sub":"ya.make parsing stats","Type":"Debug","_timestamp":1732019398175340,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,180 DEBUG (build.ya_make) [Misc-02] Configure message {"Count":8,"Includes":12,"Size":1264,"UniqueCount":8,"UniqueSize":853,"_timestamp":1732019398175345,"_typename":"NEvent.TGeneralParserStats","ymake_run_uid":1} 2024-11-19 12:29:58,180 DEBUG (build.ya_make) [Misc-03] Configure message {"Count":8,"Includes":12,"Size":1264,"UniqueCount":8,"UniqueSize":853,"_timestamp":1732019398175344,"_typename":"NEvent.TGeneralParserStats","ymake_run_uid":0} 2024-11-19 12:29:58,180 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"nodes count = 2825; edges count = 12363; files count = 3263; commands count = 142;","Mod":"unimp","Sub":"DepGraph stats","Type":"Debug","_timestamp":1732019398175359,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,180 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"nodes count = 2825; edges count = 12363; files count = 3263; commands count = 142;","Mod":"unimp","Sub":"DepGraph stats","Type":"Debug","_timestamp":1732019398175359,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,180 DEBUG (build.ya_make) [Misc-02] Configure message {"CommandsCount":142,"EdgesCount":12363,"FilesCount":3263,"NodesCount":2825,"_timestamp":1732019398175362,"_typename":"NEvent.TDepGraphStats","ymake_run_uid":1} 2024-11-19 12:29:58,180 DEBUG (build.ya_make) [Misc-03] Configure message {"CommandsCount":142,"EdgesCount":12363,"FilesCount":3263,"NodesCount":2825,"_timestamp":1732019398175363,"_typename":"NEvent.TDepGraphStats","ymake_run_uid":0} 2024-11-19 12:29:58,180 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"nuke mod dir = 0;","Mod":"unimp","Sub":"UpdIter stats","Type":"Debug","_timestamp":1732019398175368,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,180 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"nuke mod dir = 0;","Mod":"unimp","Sub":"UpdIter stats","Type":"Debug","_timestamp":1732019398175368,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,180 DEBUG (build.ya_make) [Misc-02] Configure message {"NukedDir":0,"_timestamp":1732019398175371,"_typename":"NEvent.TUpdIterStats","ymake_run_uid":1} 2024-11-19 12:29:58,180 DEBUG (build.ya_make) [Misc-03] Configure message {"NukedDir":0,"_timestamp":1732019398175371,"_typename":"NEvent.TUpdIterStats","ymake_run_uid":0} 2024-11-19 12:29:58,181 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Includes attempts = 0; From cache = 0; Resolve AsKnown total = 0; Resolve AsKnown from cache = 0;","Mod":"unimp","Sub":"Resolving stats","Type":"Debug","_timestamp":1732019398175378,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,181 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Includes attempts = 0; From cache = 0; Resolve AsKnown total = 0; Resolve AsKnown from cache = 0;","Mod":"unimp","Sub":"Resolving stats","Type":"Debug","_timestamp":1732019398175378,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,181 DEBUG (build.ya_make) [Misc-02] Configure message {"IncludesAttempted":0,"IncludesFromCache":0,"ResolveAsKnownFromCache":0,"ResolveAsKnownTotal":0,"_timestamp":1732019398175381,"_typename":"NEvent.TResolveStats","ymake_run_uid":1} 2024-11-19 12:29:58,181 DEBUG (build.ya_make) [Misc-03] Configure message {"IncludesAttempted":0,"IncludesFromCache":0,"ResolveAsKnownFromCache":0,"ResolveAsKnownTotal":0,"_timestamp":1732019398175382,"_typename":"NEvent.TResolveStats","ymake_run_uid":0} 2024-11-19 12:29:58,181 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Build graph","_timestamp":1732019398175385,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:58,181 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Build graph","_timestamp":1732019398175385,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:58,181 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"accessed = 19; loaded = 0; outdated = 0; parsed = 19; total = 19;","Mod":"unimp","Sub":"TModules stats","Type":"Debug","_timestamp":1732019398175477,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,181 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"accessed = 19; loaded = 0; outdated = 0; parsed = 19; total = 19;","Mod":"unimp","Sub":"TModules stats","Type":"Debug","_timestamp":1732019398175493,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,181 DEBUG (build.ya_make) [Misc-02] Configure message {"Accessed":19,"Loaded":0,"Outdated":0,"Parsed":19,"Total":19,"_timestamp":1732019398175481,"_typename":"NEvent.TModulesStats","ymake_run_uid":1} 2024-11-19 12:29:58,181 DEBUG (build.ya_make) [Misc-03] Configure message {"Accessed":19,"Loaded":0,"Outdated":0,"Parsed":19,"Total":19,"_timestamp":1732019398175498,"_typename":"NEvent.TModulesStats","ymake_run_uid":0} 2024-11-19 12:29:58,182 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":19,"Name":"EModulesStats::Accessed","Type":"int","_timestamp":1732019398175485,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-19 12:29:58,182 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":19,"Name":"EModulesStats::Accessed","Type":"int","_timestamp":1732019398175502,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-19 12:29:58,182 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":0,"Name":"EModulesStats::Loaded","Type":"int","_timestamp":1732019398175488,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-19 12:29:58,182 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":0,"Name":"EModulesStats::Loaded","Type":"int","_timestamp":1732019398175505,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-19 12:29:58,182 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":0,"Name":"EModulesStats::Outdated","Type":"int","_timestamp":1732019398175490,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-19 12:29:58,182 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":0,"Name":"EModulesStats::Outdated","Type":"int","_timestamp":1732019398175507,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-19 12:29:58,182 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":19,"Name":"EModulesStats::Parsed","Type":"int","_timestamp":1732019398175493,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-19 12:29:58,182 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":19,"Name":"EModulesStats::Parsed","Type":"int","_timestamp":1732019398175510,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-19 12:29:58,182 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Set reachable nodes","_timestamp":1732019398175502,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:58,182 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Set reachable nodes","_timestamp":1732019398175518,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:58,182 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Set reachable nodes","_timestamp":1732019398176066,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:58,183 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Set reachable nodes","_timestamp":1732019398176074,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:58,183 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Sort edges","_timestamp":1732019398176068,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:58,183 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Sort edges","_timestamp":1732019398176076,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:58,183 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Sort edges","_timestamp":1732019398178581,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:58,183 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Sort edges","_timestamp":1732019398178558,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:58,183 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1732019398178583,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:58,183 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1732019398178561,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:58,183 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1732019398178629,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:58,183 DEBUG (_ToolTargetsQueue) [MainThread] Source_id=0 (default-linux-x86_64-release-asan-pic). Tool targets: set() 2024-11-19 12:29:58,184 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1732019398178608,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:58,184 DEBUG (_ToolTargetsQueue) [MainThread] Source_id=1 (default-linux-x86_64-release-asan-nopic). Tool targets: set() 2024-11-19 12:29:58,184 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check blacklist","_timestamp":1732019398178631,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:58,184 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=waiting-tool-targets, group=graph, time=1732019398.1843014 2024-11-19 12:29:58,184 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check blacklist","_timestamp":1732019398178633,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:58,184 DEBUG (core.stages_profiler) [MainThread] Set stage waiting-tool-targets_finished=1732019398.1843014 2024-11-19 12:29:58,184 DEBUG (core.profiler) [MainThread] Profile step waiting-tool-targets_finished - 1732019398.1843014 2024-11-19 12:29:58,184 DEBUG (build.graph) [MainThread] Empty tool targets list 2024-11-19 12:29:58,184 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=get-tools, group=graph, time=1732019398.1848114 2024-11-19 12:29:58,184 DEBUG (core.stages_profiler) [MainThread] Set stage get-tools_finished=1732019398.1848114 2024-11-19 12:29:58,184 DEBUG (core.profiler) [MainThread] Profile step get-tools_finished - 1732019398.1848114 2024-11-19 12:29:58,185 DEBUG (core.stage_tracer) [MainThread] Start stage tag=merge-target-graphs-1, group=graph, time=1732019398.185001 2024-11-19 12:29:58,185 DEBUG (core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_started=1732019398.185001 2024-11-19 12:29:58,185 DEBUG (core.profiler) [MainThread] Profile step merge-target-graphs-1_started - 1732019398.185001 2024-11-19 12:29:58,185 DEBUG (core.stage_tracer) [MainThread] Start stage tag=wait-target-graphs-1, group=graph, time=1732019398.1852 2024-11-19 12:29:58,185 DEBUG (core.stages_profiler) [MainThread] Set stage wait-target-graphs-1_started=1732019398.1852 2024-11-19 12:29:58,185 DEBUG (core.profiler) [MainThread] Profile step wait-target-graphs-1_started - 1732019398.1852 2024-11-19 12:29:58,185 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check isolated projects","_timestamp":1732019398178635,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:58,185 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check blacklist","_timestamp":1732019398178610,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:58,185 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check isolated projects","_timestamp":1732019398178638,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:58,185 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check blacklist","_timestamp":1732019398178612,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:58,185 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Report Configure Events","_timestamp":1732019398178640,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:58,185 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check isolated projects","_timestamp":1732019398178615,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:58,185 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Report Configure Events","_timestamp":1732019398178692,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:58,186 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check isolated projects","_timestamp":1732019398178617,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:58,186 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save and compact","_timestamp":1732019398178695,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:58,186 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Report Configure Events","_timestamp":1732019398178619,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:58,186 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Total cache size on save = 428512; Diagnostics cache size on save = 112; Graph cache size on save = 91616; Parsers cache size on save = 224; Modules table size on save = 3079; Times table size on save = 16; Names table size on save = 332624; Commands cache size on save = 272;","Mod":"unimp","Sub":"Internal cache stats","Type":"Debug","_timestamp":1732019398179533,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,186 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Report Configure Events","_timestamp":1732019398178672,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:58,186 DEBUG (build.ya_make) [Misc-02] Configure message {"CommandsSize":272,"DiagnosticsCacheSize":112,"GraphCacheSize":91616,"ModulesTableSize":3079,"NamesTableSize":332624,"ParsersCacheSize":224,"TimesTableSize":16,"TotalCacheSize":428512,"_timestamp":1732019398179543,"_typename":"NEvent.TInternalCacheSaverStats","ymake_run_uid":1} 2024-11-19 12:29:58,186 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save and compact","_timestamp":1732019398178674,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:58,186 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"FS cache has been saved...\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398179550,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,186 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Total cache size on save = 428512; Diagnostics cache size on save = 112; Graph cache size on save = 91616; Parsers cache size on save = 224; Modules table size on save = 3079; Times table size on save = 16; Names table size on save = 332624; Commands cache size on save = 272;","Mod":"unimp","Sub":"Internal cache stats","Type":"Debug","_timestamp":1732019398179546,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,186 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Deps cache has been saved...\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398179555,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,186 DEBUG (build.ya_make) [Misc-03] Configure message {"CommandsSize":272,"DiagnosticsCacheSize":112,"GraphCacheSize":91616,"ModulesTableSize":3079,"NamesTableSize":332624,"ParsersCacheSize":224,"TimesTableSize":16,"TotalCacheSize":428512,"_timestamp":1732019398179556,"_typename":"NEvent.TInternalCacheSaverStats","ymake_run_uid":0} 2024-11-19 12:29:58,187 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save and compact","_timestamp":1732019398180758,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:58,187 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"FS cache has been saved...\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398179563,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,187 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Detect loops","_timestamp":1732019398180763,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:58,187 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Deps cache has been saved...\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398179568,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,187 DEBUG (build.ya_make) [Misc-02] Configure message {"HasContentChanges":true,"HasStructuralChanges":true,"_timestamp":1732019398181168,"_typename":"NEvent.TGraphChanges","ymake_run_uid":1} 2024-11-19 12:29:58,187 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save and compact","_timestamp":1732019398180660,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:58,187 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Detect loops","_timestamp":1732019398181197,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:58,187 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Detect loops","_timestamp":1732019398180665,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:58,187 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Apply Dependency Management","_timestamp":1732019398181200,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:58,187 DEBUG (build.ya_make) [Misc-03] Configure message {"HasContentChanges":true,"HasStructuralChanges":true,"_timestamp":1732019398181065,"_typename":"NEvent.TGraphChanges","ymake_run_uid":0} 2024-11-19 12:29:58,187 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save Dependency management cache","_timestamp":1732019398181618,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:58,188 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Detect loops","_timestamp":1732019398181094,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:58,188 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"DM cache has been saved...\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398181728,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,188 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Apply Dependency Management","_timestamp":1732019398181097,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:58,188 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save Dependency management cache","_timestamp":1732019398181733,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:58,188 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save Dependency management cache","_timestamp":1732019398181508,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:58,188 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Apply Dependency Management","_timestamp":1732019398181735,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:58,188 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"DM cache has been saved...\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398181618,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,188 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Modules requiring dependency management: 0; BFS traversals performed: 0\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398181738,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,188 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save Dependency management cache","_timestamp":1732019398181623,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:58,188 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Fill package outputs","_timestamp":1732019398181769,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:58,188 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Apply Dependency Management","_timestamp":1732019398181625,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:58,189 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Fill package outputs","_timestamp":1732019398181771,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:58,189 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Modules requiring dependency management: 0; BFS traversals performed: 0\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398181628,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,189 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1732019398181774,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:58,189 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Fill package outputs","_timestamp":1732019398181659,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:58,189 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1732019398181906,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:58,189 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Fill package outputs","_timestamp":1732019398181661,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:58,189 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Find missing peerdirs","_timestamp":1732019398181926,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:58,189 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1732019398181665,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:58,189 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Find missing peerdirs","_timestamp":1732019398182580,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:58,189 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1732019398181800,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:58,190 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Export JSON","_timestamp":1732019398182633,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:58,190 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Find missing peerdirs","_timestamp":1732019398181820,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:58,190 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Write JSON","_timestamp":1732019398182638,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:58,190 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Find missing peerdirs","_timestamp":1732019398182478,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:58,190 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Exporting JSON\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398182643,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,190 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Export JSON","_timestamp":1732019398182531,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:58,190 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Visit JSON","_timestamp":1732019398182646,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:58,190 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Write JSON","_timestamp":1732019398182537,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:58,190 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Visit JSON","_timestamp":1732019398185501,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:58,190 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Exporting JSON\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398182541,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,190 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Render JSON","_timestamp":1732019398185506,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:58,190 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Visit JSON","_timestamp":1732019398182545,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:58,191 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Visit JSON","_timestamp":1732019398185417,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:58,191 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Store inputs in JSON cache: enabled\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398185516,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,191 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Render JSON","_timestamp":1732019398185421,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:58,191 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Store inputs in JSON cache: enabled\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398185431,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,192 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Loaded cache items = 0; Added cache items = 0; Saved old cache items = 0; Saved new cache items = 0; Saved total cache items = 0; Loaded full match items = 0; Full match requests = 0; Successful full matches = 0; Loaded partial match items = 0; Partial match requests = 0; Successful partial matches = 0; Fully rendered nodes = 0; Partially rendered nodes = 0; Nodes restored without rendering = 0;","Mod":"unimp","Sub":"JSON cache stats","Type":"Debug","_timestamp":1732019398192399,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,192 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Loaded cache items = 0; Added cache items = 0; Saved old cache items = 0; Saved new cache items = 0; Saved total cache items = 0; Loaded full match items = 0; Full match requests = 0; Successful full matches = 0; Loaded partial match items = 0; Partial match requests = 0; Successful partial matches = 0; Fully rendered nodes = 0; Partially rendered nodes = 0; Nodes restored without rendering = 0;","Mod":"unimp","Sub":"JSON cache stats","Type":"Debug","_timestamp":1732019398192526,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,192 DEBUG (build.ya_make) [Misc-03] Configure message {"AddedItems":0,"FullMatchLoadedItems":0,"FullMatchRequests":0,"FullMatchSuccess":0,"FullyRendered":0,"LoadedItems":0,"NewItemsSaved":0,"NoRendered":0,"OldItemsSaved":0,"PartialMatchLoadedItems":0,"PartialMatchRequests":0,"PartialMatchSuccess":0,"PartiallyRendered":0,"TotalItemsSaved":0,"_timestamp":1732019398192408,"_typename":"NEvent.TJsonCacheStats","ymake_run_uid":0} 2024-11-19 12:29:58,192 DEBUG (build.ya_make) [Misc-02] Configure message {"AddedItems":0,"FullMatchLoadedItems":0,"FullMatchRequests":0,"FullMatchSuccess":0,"FullyRendered":0,"LoadedItems":0,"NewItemsSaved":0,"NoRendered":0,"OldItemsSaved":0,"PartialMatchLoadedItems":0,"PartialMatchRequests":0,"PartialMatchSuccess":0,"PartiallyRendered":0,"TotalItemsSaved":0,"_timestamp":1732019398192533,"_typename":"NEvent.TJsonCacheStats","ymake_run_uid":1} 2024-11-19 12:29:58,193 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"JSON cache report: disabled\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398192415,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,193 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"JSON cache report: disabled\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398192541,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,193 DEBUG (build.ya_make) [Misc-03] Configure message {"DoubleValue":0.006999111091,"Name":"EYmakeStats::RenderJSONTime","Type":"double","_timestamp":1732019398192424,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-19 12:29:58,193 DEBUG (build.ya_make) [Misc-02] Configure message {"DoubleValue":0.007040418763,"Name":"EYmakeStats::RenderJSONTime","Type":"double","_timestamp":1732019398192550,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-19 12:29:58,193 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Render JSON","_timestamp":1732019398192428,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:58,193 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Render JSON","_timestamp":1732019398192554,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:58,193 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save Uids cache","_timestamp":1732019398192431,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-19 12:29:58,193 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save Uids cache","_timestamp":1732019398192557,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-19 12:29:58,193 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Uids cache has been saved...\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398193166,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,193 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Uids cache has been saved...\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398193289,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,194 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save Uids cache","_timestamp":1732019398193171,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:58,194 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save Uids cache","_timestamp":1732019398193295,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:58,194 DEBUG (build.ya_make) [Misc-03] Configure message {"HasRenderedNodeChanges":true,"_timestamp":1732019398193185,"_typename":"NEvent.TNodeChanges","ymake_run_uid":0} 2024-11-19 12:29:58,194 DEBUG (build.ya_make) [Misc-02] Configure message {"HasRenderedNodeChanges":true,"_timestamp":1732019398193306,"_typename":"NEvent.TNodeChanges","ymake_run_uid":1} 2024-11-19 12:29:58,194 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Loaded nodes = 0; Skipped nodes = 0; Discarded nodes = 0; Loaded loops = 0; Skipped loops = 0; Discarded loops = 0; Saved nodes = 2392; Saved loops = 0; Really all nodes no rendered = 0;","Mod":"unimp","Sub":"Uids cache stats","Type":"Debug","_timestamp":1732019398193196,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,194 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Loaded nodes = 0; Skipped nodes = 0; Discarded nodes = 0; Loaded loops = 0; Skipped loops = 0; Discarded loops = 0; Saved nodes = 2392; Saved loops = 0; Really all nodes no rendered = 0;","Mod":"unimp","Sub":"Uids cache stats","Type":"Debug","_timestamp":1732019398193318,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,194 DEBUG (build.ya_make) [Misc-03] Configure message {"DiscardedLoops":0,"DiscardedNodes":0,"LoadedLoops":0,"LoadedNodes":0,"SavedLoops":0,"SavedNodes":2392,"SkippedLoops":0,"SkippedNodes":0,"_timestamp":1732019398193201,"_typename":"NEvent.TUidsCacheStats","ymake_run_uid":0} 2024-11-19 12:29:58,194 DEBUG (build.ya_make) [Misc-02] Configure message {"DiscardedLoops":0,"DiscardedNodes":0,"LoadedLoops":0,"LoadedNodes":0,"SavedLoops":0,"SavedNodes":2392,"SkippedLoops":0,"SkippedNodes":0,"_timestamp":1732019398193324,"_typename":"NEvent.TUidsCacheStats","ymake_run_uid":1} 2024-11-19 12:29:58,194 DEBUG (build.ya_make) [Misc-03] Configure message {"DoubleValue":0.01072675006,"Name":"EYmakeStats::WriteJSONTime","Type":"double","_timestamp":1732019398193267,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-19 12:29:58,195 DEBUG (build.ya_make) [Misc-02] Configure message {"DoubleValue":0.01074629397,"Name":"EYmakeStats::WriteJSONTime","Type":"double","_timestamp":1732019398193388,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-19 12:29:58,195 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Write JSON","_timestamp":1732019398193271,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:58,195 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Write JSON","_timestamp":1732019398193392,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:58,195 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Export JSON","_timestamp":1732019398193291,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:58,196 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Export JSON","_timestamp":1732019398193412,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:58,196 DEBUG (build.ya_make) [Misc-03] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedUidsCache","Type":"bool","_timestamp":1732019398193294,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-19 12:29:58,196 DEBUG (build.ya_make) [Misc-02] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedUidsCache","Type":"bool","_timestamp":1732019398193415,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-19 12:29:58,196 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"module environment initialization calls = 13; actual module environment initializations = 13;","Mod":"unimp","Sub":"TMakeCommand stats","Type":"Debug","_timestamp":1732019398193301,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,196 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"module environment initialization calls = 13; actual module environment initializations = 13;","Mod":"unimp","Sub":"TMakeCommand stats","Type":"Debug","_timestamp":1732019398193422,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,196 DEBUG (build.ya_make) [Misc-03] Configure message {"InitModuleEnv":13,"InitModuleEnvCalls":13,"_timestamp":1732019398193305,"_typename":"NEvent.TMakeCommandStats","ymake_run_uid":0} 2024-11-19 12:29:58,196 DEBUG (build.ya_make) [Misc-02] Configure message {"InitModuleEnv":13,"InitModuleEnvCalls":13,"_timestamp":1732019398193426,"_typename":"NEvent.TMakeCommandStats","ymake_run_uid":1} 2024-11-19 12:29:58,196 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"FS cache has been committed...\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398196262,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,196 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"FS cache has been committed...\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398196266,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,196 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Deps cache has been committed...\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398196273,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,196 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Deps cache has been committed...\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398196276,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,197 DEBUG (build.ya_make) [Misc-03] Configure message {"_timestamp":1732019398196277,"_typename":"NEvent.TReadyForUpdateCacheInfo","ymake_run_uid":0} 2024-11-19 12:29:58,197 DEBUG (build.ya_make) [Misc-02] Configure message {"_timestamp":1732019398196281,"_typename":"NEvent.TReadyForUpdateCacheInfo","ymake_run_uid":1} 2024-11-19 12:29:58,197 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"DM cache has been committed...\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398196288,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,197 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"DM cache has been committed...\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398196292,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,197 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Uids cache has been committed...\n","Mod":"unimp","PID":3128,"Sub":"","Type":"Debug","_timestamp":1732019398196298,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-19 12:29:58,197 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Uids cache has been committed...\n","Mod":"unimp","PID":3130,"Sub":"","Type":"Debug","_timestamp":1732019398196303,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-19 12:29:58,197 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"ymake main","_timestamp":1732019398196873,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-19 12:29:58,197 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"ymake main","_timestamp":1732019398196867,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-19 12:29:58,197 DEBUG (build.ya_make) [Misc-03] Configure message {"DoubleValue":0.4193801164,"Name":"EYmakeStats::RunTime","Type":"double","_timestamp":1732019398196880,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-19 12:29:58,197 DEBUG (build.ya_make) [Misc-02] Configure message {"DoubleValue":0.4164346588,"Name":"EYmakeStats::RunTime","Type":"double","_timestamp":1732019398196874,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-19 12:29:58,197 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"ymake run","_timestamp":1732019398196886,"_typename":"NEvent.TStageFinished","debug_id":"default-linux-x86_64-release-asan-nopic","ymake_run_uid":0} 2024-11-19 12:29:58,198 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"ymake run","_timestamp":1732019398196880,"_typename":"NEvent.TStageFinished","debug_id":"default-linux-x86_64-release-asan-pic","ymake_run_uid":1} 2024-11-19 12:29:58,201 DEBUG (build.ymake2.run_ymake) [Misc-02] run '/home/runner/.ya/tools/v4/7448917907/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732019397.3025.c6ogw00k/yatmpof2lo84k --config /home/runner/.ya/build/conf/dist-release-x-9ee9d4a643e508fb4aafc1035ff3a1f6/ymake.conf --plugins-root /home/runner/actions_runner/_work/ydb/ydb/build/plugins,/home/runner/actions_runner/_work/ydb/ydb/build/internal/plugins --build-root /home/runner/.ya/build/conf/dist-release-x-9ee9d4a643e508fb4aafc1035ff3a1f6_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.hm96xwe6/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.hm96xwe6/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' finished 2024-11-19 12:29:58,202 DEBUG (build.ymake2.run_ymake) [Misc-03] run '/home/runner/.ya/tools/v4/7448917907/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732019397.3025.c6ogw00k/yatmpqh8m1y61 --config /home/runner/.ya/build/conf/dist-release-x-89b78db1db59d8d6855caed33424337f/ymake.conf --plugins-root /home/runner/actions_runner/_work/ydb/ydb/build/plugins,/home/runner/actions_runner/_work/ydb/ydb/build/internal/plugins --build-root /home/runner/.ya/build/conf/dist-release-x-89b78db1db59d8d6855caed33424337f_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.9b_g7kuw/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.9b_g7kuw/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' finished 2024-11-19 12:29:58,202 DEBUG (build.ymake2) [Misc-02] ymake_run_info: {"ymake_run_uid":1,"stats":{"preparing":{"start":1732019397.77477765083313,"finish":1732019397.77526044845581,"duration":0.000482797622681},"execution":{"start":1732019397.775261163711548,"finish":1732019398.201892137527466,"duration":0.426630973815918},"postprocessing":{"start":1732019398.201894044876099,"finish":1732019398.202063083648682,"duration":0.000169038772583}},"purpose":"default-linux-x86_64-release-asan-pic","caches":{"FS cache":{"loaded":false,"saved":true,"loading_enabled":true,"saving_enabled":true,"committed":true},"Deps cache":{"loaded":false,"saved":true,"loading_enabled":true,"saving_enabled":true,"committed":true},"DepManagement cache":{"loaded":false,"saved":false,"loading_enabled":true,"saving_enabled":true},"Uids cache":{"loaded":false,"saved":true,"loading_enabled":true,"saving_enabled":true,"committed":true},"DM cache":{"loaded":false,"saved":true,"loading_enabled":false,"saving_enabled":false,"committed":true}},"stages":{"ymake run":{"start":1732019397.780400991439819,"finish":1732019398.196880102157593,"duration":0.416479110717773},"Load configuration from cache":{"start":1732019397.780520915985107,"finish":1732019397.780533075332642,"duration":0.000012159347534},"Load configuration (no cache)":{"start":1732019397.78077507019043,"finish":1732019397.93314003944397,"duration":0.15236496925354},"Compile and RecalcAll conditions":{"start":1732019397.933159112930298,"finish":1732019397.934525966644287,"duration":0.001366853713989},"Fold global commands":{"start":1732019397.934536933898926,"finish":1732019397.935662984848022,"duration":0.001126050949097},"Load plugins":{"start":1732019397.935671091079712,"finish":1732019398.05010199546814,"duration":0.114430904388428},"ymake main":{"start":1732019398.080981969833374,"finish":1732019398.196866989135742,"duration":0.115885019302368},"Build graph":{"start":1732019398.081881046295166,"finish":1732019398.175384998321533,"duration":0.093503952026367},"Configure graph":{"start":1732019398.081897020339966,"finish":1732019398.175086975097656,"duration":0.09318995475769},"Find Lost Includes":{"start":1732019398.175152063369751,"finish":1732019398.175230979919434,"duration":0.000078916549683},"Set reachable nodes":{"start":1732019398.175502061843872,"finish":1732019398.176065921783447,"duration":0.000563859939575},"Sort edges":{"start":1732019398.176068067550659,"finish":1732019398.17858099937439,"duration":0.00251293182373},"Report Foreign Platform Events":{"start":1732019398.178582906723022,"finish":1732019398.178628921508789,"duration":0.000046014785767},"Check blacklist":{"start":1732019398.178631067276001,"finish":1732019398.178632974624634,"duration":0.000001907348633},"Check isolated projects":{"start":1732019398.178634881973267,"finish":1732019398.178637981414795,"duration":0.000003099441528},"Report Configure Events":{"start":1732019398.178639888763428,"finish":1732019398.178692102432251,"duration":0.000052213668823},"Save and compact":{"start":1732019398.1786949634552,"finish":1732019398.180757999420166,"duration":0.002063035964966},"Detect loops":{"start":1732019398.180763006210327,"finish":1732019398.181196928024292,"duration":0.000433921813965},"Apply Dependency Management":{"start":1732019398.18120002746582,"finish":1732019398.181735038757324,"duration":0.000535011291504},"Save Dependency management cache":{"start":1732019398.181617975234985,"finish":1732019398.181732892990112,"duration":0.000114917755127},"Fill package outputs":{"start":1732019398.181768894195557,"finish":1732019398.181771039962769,"duration":0.000002145767212},"Check Transitive Requirements":{"start":1732019398.181773900985718,"finish":1732019398.18190598487854,"duration":0.000132083892822},"Find missing peerdirs":{"start":1732019398.181926012039185,"finish":1732019398.18257999420166,"duration":0.000653982162476},"Export JSON":{"start":1732019398.182632923126221,"finish":1732019398.193412065505981,"duration":0.010779142379761},"Write JSON":{"start":1732019398.182637929916382,"finish":1732019398.193392038345337,"duration":0.010754108428955},"Visit JSON":{"start":1732019398.182646036148071,"finish":1732019398.185501098632812,"duration":0.002855062484741},"Render JSON":{"start":1732019398.185506105422974,"finish":1732019398.192553997039795,"duration":0.007047891616821},"Save Uids cache":{"start":1732019398.192557096481323,"finish":1732019398.193295001983643,"duration":0.000737905502319}},"metrics":{"File access":{"loaded size":9024203,"load time":9226,"loaded MD5 time":766,"Max loaded MD5 time":5,"loaded count":2174,"max load time":183,"mapped size":40632376,"mapped MD5 time":5792,"Max mapped MD5 time":365,"mapped count":130,"map time":683,"from patch count":0,"from patch size":0,"file stat count":3223,"lstat count":3045,"lstat sum us":3104,"lstat min us":0,"lstat avr us":1,"lstat max us":9,"opendir count":388,"opendir sum us":0,"opendir min us":0,"opendir avr us":0,"opendir max us":0,"readdir count":2837,"readdir sum us":1825,"readdir min us":0,"readdir avr us":0,"readdir max us":39,"(opendir + readdir) sum us":1825,"(lstat + opendir + readdir) sum us":4929},"Parsing":{"parse time":3,"parsed files count":6,"parsed files size":12965,"parsed files recovered":0,".in files count":0,".in files size":0},"ya.make parsing":{"count":8,"includes count":12,"unique count":8,"size":1264,"unique size":853},"DepGraph":{"nodes count":2825,"edges count":12363,"files count":3263,"commands count":142},"UpdIter":{"nuke mod dir":0},"Resolving":{"Includes attempts":0,"From cache":0,"Resolve AsKnown total":0,"Resolve AsKnown from cache":0},"TModules":{"accessed":19,"loaded":0,"outdated":0,"parsed":19,"total":19},"Internal cache":{"Total cache size on save":428512,"Diagnostics cache size on save":112,"Graph cache size on save":91616,"Parsers cache size on save":224,"Modules table size on save":3079,"Times table size on save":16,"Names table size on save":332624,"Commands cache size on save":272},"JSON cache":{"Loaded cache items":0,"Added cache items":0,"Saved old cache items":0,"Saved new cache items":0,"Saved total cache items":0,"Loaded full match items":0,"Full match requests":0,"Successful full matches":0,"Loaded partial match items":0,"Partial match requests":0,"Successful partial matches":0,"Fully rendered nodes":0,"Partially rendered nodes":0,"Nodes restored without rendering":0},"Uids cache":{"Loaded nodes":0,"Skipped nodes":0,"Discarded nodes":0,"Loaded loops":0,"Skipped loops":0,"Discarded loops":0,"Saved nodes":2392,"Saved loops":0,"Really all nodes no rendered":0},"TMakeCommand":{"module environment initialization calls":13,"actual module environment initializations":13}},"binary":"/home/runner/.ya/tools/v4/7448917907/ymake","args":["/home/runner/.ya/tools/v4/7448917907/ymake","--depends-like-recurse","--warn","dirloops,ChkPeers","--write-meta-data","/home/runner/.ya/tmp/1732019397.3025.c6ogw00k/yatmpof2lo84k","--config","/home/runner/.ya/build/conf/dist-release-x-9ee9d4a643e508fb4aafc1035ff3a1f6/ymake.conf","--plugins-root","/home/runner/actions_runner/_work/ydb/ydb/build/plugins,/home/runner/actions_runner/_work/ydb/ydb/build/internal/plugins","--build-root","/home/runner/.ya/build/conf/dist-release-x-9ee9d4a643e508fb4aafc1035ff3a1f6_d357a1f7839b099012272bcb9853ec19","--test-dart","/home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.hm96xwe6/test.dart","--tests-data-root","/home/runner/actions_runner/_work/ydb/arcadia_tests_data","--makefiles-dart","/home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.hm96xwe6/makefiles.dart","--dump-build-plan","-","--quiet","--events","dGT","/home/runner/actions_runner/_work/ydb/ydb"],"has_changelist":false,"predicts_structural_changes":true,"bypass_is_enabled":false,"bypass_is_triggered":false,"has_content_changes":true,"has_structural_changes":true,"has_rendered_node_changes":true,"exit_code":0,"duration":0.426630973815918} 2024-11-19 12:29:58,202 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=load-graph-from-json, group=graph, time=1732019398.2028759 2024-11-19 12:29:58,202 DEBUG (core.stages_profiler) [Misc-02] Set stage load-graph-from-json_started=1732019398.2028759 2024-11-19 12:29:58,203 DEBUG (core.profiler) [Misc-02] Profile step load-graph-from-json_started - 1732019398.2028759 2024-11-19 12:29:58,203 DEBUG (core.event_handling.base_subscriber) [Misc-03] Unsubscribing PrintProgressSubscriber from event_queue 2024-11-19 12:29:58,203 DEBUG (build.ymake2) [Misc-03] ymake_run_info: {"ymake_run_uid":0,"stats":{"preparing":{"start":1732019397.771103858947754,"finish":1732019397.771621465682983,"duration":0.000517606735229},"execution":{"start":1732019397.771622180938721,"finish":1732019398.20272970199585,"duration":0.431107521057129},"postprocessing":{"start":1732019398.202732086181641,"finish":1732019398.203282117843628,"duration":0.000550031661987}},"purpose":"default-linux-x86_64-release-asan-nopic","caches":{"FS cache":{"loaded":false,"saved":true,"loading_enabled":true,"saving_enabled":true,"committed":true},"Deps cache":{"loaded":false,"saved":true,"loading_enabled":true,"saving_enabled":true,"committed":true},"DepManagement cache":{"loaded":false,"saved":false,"loading_enabled":true,"saving_enabled":true},"Uids cache":{"loaded":false,"saved":true,"loading_enabled":true,"saving_enabled":true,"committed":true},"DM cache":{"loaded":false,"saved":true,"loading_enabled":false,"saving_enabled":false,"committed":true}},"stages":{"ymake run":{"start":1732019397.777462959289551,"finish":1732019398.19688606262207,"duration":0.41942310333252},"Load configuration from cache":{"start":1732019397.777601957321167,"finish":1732019397.777614116668701,"duration":0.000012159347534},"Load configuration (no cache)":{"start":1732019397.777858018875122,"finish":1732019397.930538892745972,"duration":0.15268087387085},"Compile and RecalcAll conditions":{"start":1732019397.930560111999512,"finish":1732019397.932070970535278,"duration":0.001510858535767},"Fold global commands":{"start":1732019397.932081937789917,"finish":1732019397.933206081390381,"duration":0.001124143600464},"Load plugins":{"start":1732019397.933213949203491,"finish":1732019398.047981977462769,"duration":0.114768028259277},"ymake main":{"start":1732019398.078819036483765,"finish":1732019398.19687294960022,"duration":0.118053913116455},"Build graph":{"start":1732019398.079757928848267,"finish":1732019398.175384998321533,"duration":0.095627069473267},"Configure graph":{"start":1732019398.079773902893066,"finish":1732019398.175087928771973,"duration":0.095314025878906},"Find Lost Includes":{"start":1732019398.175152063369751,"finish":1732019398.175230979919434,"duration":0.000078916549683},"Set reachable nodes":{"start":1732019398.175518035888672,"finish":1732019398.176074028015137,"duration":0.000555992126465},"Sort edges":{"start":1732019398.17607593536377,"finish":1732019398.178558111190796,"duration":0.002482175827026},"Report Foreign Platform Events":{"start":1732019398.178560972213745,"finish":1732019398.178607940673828,"duration":0.000046968460083},"Check blacklist":{"start":1732019398.17861008644104,"finish":1732019398.178611993789673,"duration":0.000001907348633},"Check isolated projects":{"start":1732019398.178615093231201,"finish":1732019398.178617000579834,"duration":0.000001907348633},"Report Configure Events":{"start":1732019398.178618907928467,"finish":1732019398.178672075271606,"duration":0.00005316734314},"Save and compact":{"start":1732019398.178673982620239,"finish":1732019398.180660009384155,"duration":0.001986026763916},"Detect loops":{"start":1732019398.180665016174316,"finish":1732019398.18109393119812,"duration":0.000428915023804},"Apply Dependency Management":{"start":1732019398.181097030639648,"finish":1732019398.181624889373779,"duration":0.000527858734131},"Save Dependency management cache":{"start":1732019398.18150806427002,"finish":1732019398.181622982025146,"duration":0.000114917755127},"Fill package outputs":{"start":1732019398.181658983230591,"finish":1732019398.181660890579224,"duration":0.000001907348633},"Check Transitive Requirements":{"start":1732019398.181664943695068,"finish":1732019398.18179988861084,"duration":0.000134944915771},"Find missing peerdirs":{"start":1732019398.181819915771484,"finish":1732019398.182477951049805,"duration":0.00065803527832},"Export JSON":{"start":1732019398.182531118392944,"finish":1732019398.193290948867798,"duration":0.010759830474854},"Write JSON":{"start":1732019398.182537078857422,"finish":1732019398.193270921707153,"duration":0.010733842849731},"Visit JSON":{"start":1732019398.182544946670532,"finish":1732019398.18541693687439,"duration":0.002871990203857},"Render JSON":{"start":1732019398.185420989990234,"finish":1732019398.192428112030029,"duration":0.007007122039795},"Save Uids cache":{"start":1732019398.192430973052978,"finish":1732019398.19317102432251,"duration":0.000740051269531}},"metrics":{"File access":{"loaded size":9024203,"load time":9877,"loaded MD5 time":739,"Max loaded MD5 time":5,"loaded count":2174,"max load time":125,"mapped size":40632376,"mapped MD5 time":6105,"Max mapped MD5 time":367,"mapped count":130,"map time":695,"from patch count":0,"from patch size":0,"file stat count":3223,"lstat count":3045,"lstat sum us":3168,"lstat min us":1,"lstat avr us":1,"lstat max us":10,"opendir count":388,"opendir sum us":0,"opendir min us":0,"opendir avr us":0,"opendir max us":0,"readdir count":2837,"readdir sum us":2037,"readdir min us":0,"readdir avr us":0,"readdir max us":39,"(opendir + readdir) sum us":2037,"(lstat + opendir + readdir) sum us":5205},"Parsing":{"parse time":4,"parsed files count":6,"parsed files size":12965,"parsed files recovered":0,".in files count":0,".in files size":0},"ya.make parsing":{"count":8,"includes count":12,"unique count":8,"size":1264,"unique size":853},"DepGraph":{"nodes count":2825,"edges count":12363,"files count":3263,"commands count":142},"UpdIter":{"nuke mod dir":0},"Resolving":{"Includes attempts":0,"From cache":0,"Resolve AsKnown total":0,"Resolve AsKnown from cache":0},"TModules":{"accessed":19,"loaded":0,"outdated":0,"parsed":19,"total":19},"Internal cache":{"Total cache size on save":428512,"Diagnostics cache size on save":112,"Graph cache size on save":91616,"Parsers cache size on save":224,"Modules table size on save":3079,"Times table size on save":16,"Names table size on save":332624,"Commands cache size on save":272},"JSON cache":{"Loaded cache items":0,"Added cache items":0,"Saved old cache items":0,"Saved new cache items":0,"Saved total cache items":0,"Loaded full match items":0,"Full match requests":0,"Successful full matches":0,"Loaded partial match items":0,"Partial match requests":0,"Successful partial matches":0,"Fully rendered nodes":0,"Partially rendered nodes":0,"Nodes restored without rendering":0},"Uids cache":{"Loaded nodes":0,"Skipped nodes":0,"Discarded nodes":0,"Loaded loops":0,"Skipped loops":0,"Discarded loops":0,"Saved nodes":2392,"Saved loops":0,"Really all nodes no rendered":0},"TMakeCommand":{"module environment initialization calls":13,"actual module environment initializations":13}},"binary":"/home/runner/.ya/tools/v4/7448917907/ymake","args":["/home/runner/.ya/tools/v4/7448917907/ymake","--depends-like-recurse","--warn","dirloops,ChkPeers","--write-meta-data","/home/runner/.ya/tmp/1732019397.3025.c6ogw00k/yatmpqh8m1y61","--config","/home/runner/.ya/build/conf/dist-release-x-89b78db1db59d8d6855caed33424337f/ymake.conf","--plugins-root","/home/runner/actions_runner/_work/ydb/ydb/build/plugins,/home/runner/actions_runner/_work/ydb/ydb/build/internal/plugins","--build-root","/home/runner/.ya/build/conf/dist-release-x-89b78db1db59d8d6855caed33424337f_d357a1f7839b099012272bcb9853ec19","--test-dart","/home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.9b_g7kuw/test.dart","--tests-data-root","/home/runner/actions_runner/_work/ydb/arcadia_tests_data","--makefiles-dart","/home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.9b_g7kuw/makefiles.dart","--dump-build-plan","-","--quiet","--events","dGT","/home/runner/actions_runner/_work/ydb/ydb"],"has_changelist":false,"predicts_structural_changes":true,"bypass_is_enabled":false,"bypass_is_triggered":false,"has_content_changes":true,"has_structural_changes":true,"has_rendered_node_changes":true,"exit_code":0,"duration":0.431107521057129} 2024-11-19 12:29:58,203 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=load-graph-from-json, group=graph, time=1732019398.2038105 2024-11-19 12:29:58,203 DEBUG (core.stages_profiler) [Misc-03] Set stage load-graph-from-json_started=1732019398.2038105 2024-11-19 12:29:58,203 DEBUG (core.profiler) [Misc-03] Profile step load-graph-from-json_started - 1732019398.2038105 2024-11-19 12:29:58,204 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=load-graph-from-json, group=graph, time=1732019398.2039778 2024-11-19 12:29:58,204 DEBUG (core.stages_profiler) [Misc-02] Set stage load-graph-from-json_finished=1732019398.2039778 2024-11-19 12:29:58,204 DEBUG (core.profiler) [Misc-02] Profile step load-graph-from-json_finished - 1732019398.2039778 2024-11-19 12:29:58,204 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=gen-graph-json-default-linux-x86_64-release-asan-pic, group=graph, time=1732019398.2042072 2024-11-19 12:29:58,204 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-json-default-linux-x86_64-release-asan-pic_finished=1732019398.2042072 2024-11-19 12:29:58,204 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-json-default-linux-x86_64-release-asan-pic_finished - 1732019398.2042072 2024-11-19 12:29:58,204 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=gen-tests-default-linux-x86_64-release-asan-pic, group=graph, time=1732019398.204468 2024-11-19 12:29:58,204 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-tests-default-linux-x86_64-release-asan-pic_started=1732019398.204468 2024-11-19 12:29:58,204 DEBUG (core.profiler) [Misc-02] Profile step gen-tests-default-linux-x86_64-release-asan-pic_started - 1732019398.204468 2024-11-19 12:29:58,204 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=load-graph-from-json, group=graph, time=1732019398.204633 2024-11-19 12:29:58,204 DEBUG (core.stages_profiler) [Misc-03] Set stage load-graph-from-json_finished=1732019398.204633 2024-11-19 12:29:58,204 DEBUG (core.profiler) [Misc-03] Profile step load-graph-from-json_finished - 1732019398.204633 2024-11-19 12:29:58,204 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=gen-graph-json-default-linux-x86_64-release-asan-nopic, group=graph, time=1732019398.2048845 2024-11-19 12:29:58,204 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-json-default-linux-x86_64-release-asan-nopic_finished=1732019398.2048845 2024-11-19 12:29:58,204 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-json-default-linux-x86_64-release-asan-nopic_finished - 1732019398.2048845 2024-11-19 12:29:58,205 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=gen-tests-default-linux-x86_64-release-asan-nopic, group=graph, time=1732019398.205135 2024-11-19 12:29:58,205 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-tests-default-linux-x86_64-release-asan-nopic_started=1732019398.205135 2024-11-19 12:29:58,205 DEBUG (core.profiler) [Misc-03] Profile step gen-tests-default-linux-x86_64-release-asan-nopic_started - 1732019398.205135 2024-11-19 12:29:58,209 DEBUG (build.graph) [Misc-02] Found 0 tests 2024-11-19 12:29:58,209 DEBUG (build.graph) [Misc-03] Found 0 tests 2024-11-19 12:29:58,209 DEBUG (exts.timer) [Misc-02] Timer gen_tests, stage generate tests: 0.00037097930908203125 2024-11-19 12:29:58,209 DEBUG (exts.timer) [Misc-03] Timer gen_tests, stage generate tests: 0.00021147727966308594 2024-11-19 12:29:58,209 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=gen-tests-default-linux-x86_64-release-asan-pic, group=graph, time=1732019398.2097118 2024-11-19 12:29:58,209 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-tests-default-linux-x86_64-release-asan-pic_finished=1732019398.2097118 2024-11-19 12:29:58,209 DEBUG (core.profiler) [Misc-02] Profile step gen-tests-default-linux-x86_64-release-asan-pic_finished - 1732019398.2097118 2024-11-19 12:29:58,209 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=gen-tests-default-linux-x86_64-release-asan-nopic, group=graph, time=1732019398.2097666 2024-11-19 12:29:58,210 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-tests-default-linux-x86_64-release-asan-nopic_finished=1732019398.2097666 2024-11-19 12:29:58,210 DEBUG (core.profiler) [Misc-03] Profile step gen-tests-default-linux-x86_64-release-asan-nopic_finished - 1732019398.2097666 2024-11-19 12:29:58,210 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=gen-graph-default-linux-x86_64-release-asan-pic, group=graph, time=1732019398.2102342 2024-11-19 12:29:58,210 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-default-linux-x86_64-release-asan-pic_finished=1732019398.2102342 2024-11-19 12:29:58,210 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-default-linux-x86_64-release-asan-pic_finished - 1732019398.2102342 2024-11-19 12:29:58,210 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=gen-graph-default-linux-x86_64-release-asan-nopic, group=graph, time=1732019398.210607 2024-11-19 12:29:58,210 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-default-linux-x86_64-release-asan-nopic_finished=1732019398.210607 2024-11-19 12:29:58,210 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-default-linux-x86_64-release-asan-nopic_finished - 1732019398.210607 2024-11-19 12:29:58,210 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage waiting_graphs for default-linux-x86_64-release-asan: 0.025756120681762695 2024-11-19 12:29:58,211 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=wait-target-graphs-1, group=graph, time=1732019398.211064 2024-11-19 12:29:58,211 DEBUG (core.stages_profiler) [MainThread] Set stage wait-target-graphs-1_finished=1732019398.211064 2024-11-19 12:29:58,211 DEBUG (core.profiler) [MainThread] Profile step wait-target-graphs-1_finished - 1732019398.211064 2024-11-19 12:29:58,211 DEBUG (core.stage_tracer) [MainThread] Start stage tag=union-make-files-1, group=graph, time=1732019398.2113092 2024-11-19 12:29:58,211 DEBUG (core.stages_profiler) [MainThread] Set stage union-make-files-1_started=1732019398.2113092 2024-11-19 12:29:58,211 DEBUG (core.profiler) [MainThread] Profile step union-make-files-1_started - 1732019398.2113092 2024-11-19 12:29:58,211 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage union make files for default-linux-x86_64-release-asan: 0.0004918575286865234 2024-11-19 12:29:58,211 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=union-make-files-1, group=graph, time=1732019398.2114844 2024-11-19 12:29:58,211 DEBUG (core.stages_profiler) [MainThread] Set stage union-make-files-1_finished=1732019398.2114844 2024-11-19 12:29:58,211 DEBUG (core.profiler) [MainThread] Profile step union-make-files-1_finished - 1732019398.2114844 2024-11-19 12:29:58,211 DEBUG (core.stage_tracer) [MainThread] Start stage tag=merge-graphs-1, group=graph, time=1732019398.211614 2024-11-19 12:29:58,211 DEBUG (core.stages_profiler) [MainThread] Set stage merge-graphs-1_started=1732019398.211614 2024-11-19 12:29:58,211 DEBUG (core.profiler) [MainThread] Profile step merge-graphs-1_started - 1732019398.211614 2024-11-19 12:29:58,211 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage merge_graphs for default-linux-x86_64-release-asan: 0.0003185272216796875 2024-11-19 12:29:58,211 DEBUG (build.graph) [MainThread] Graph size is 26 after merge_graphs 2024-11-19 12:29:58,211 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=merge-graphs-1, group=graph, time=1732019398.211858 2024-11-19 12:29:58,211 DEBUG (core.stages_profiler) [MainThread] Set stage merge-graphs-1_finished=1732019398.211858 2024-11-19 12:29:58,211 DEBUG (core.profiler) [MainThread] Profile step merge-graphs-1_finished - 1732019398.211858 2024-11-19 12:29:58,212 DEBUG (core.stage_tracer) [MainThread] Start stage tag=strip-graph-1, group=graph, time=1732019398.2120016 2024-11-19 12:29:58,212 DEBUG (core.stages_profiler) [MainThread] Set stage strip-graph-1_started=1732019398.2120016 2024-11-19 12:29:58,212 DEBUG (core.profiler) [MainThread] Profile step strip-graph-1_started - 1732019398.2120016 2024-11-19 12:29:58,212 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage strip_graph for default-linux-x86_64-release-asan: 0.0003604888916015625 2024-11-19 12:29:58,212 DEBUG (build.graph) [MainThread] Graph size is 13 after strip_graph 2024-11-19 12:29:58,212 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=strip-graph-1, group=graph, time=1732019398.2121968 2024-11-19 12:29:58,212 DEBUG (core.stages_profiler) [MainThread] Set stage strip-graph-1_finished=1732019398.2121968 2024-11-19 12:29:58,212 DEBUG (core.profiler) [MainThread] Profile step strip-graph-1_finished - 1732019398.2121968 2024-11-19 12:29:58,212 DEBUG (build.graph) [MainThread] Configuring only non-PIC for test_tool_tc1-global 2024-11-19 12:29:58,212 DEBUG (core.stage_tracer) [Misc-04] Start stage tag=gen-graph-test_tool_tc1-nopic-global, group=graph, time=1732019398.2127173 2024-11-19 12:29:58,212 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-test_tool_tc1-nopic-global_started=1732019398.2127173 2024-11-19 12:29:58,212 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-test_tool_tc1-nopic-global_started - 1732019398.2127173 2024-11-19 12:29:58,213 DEBUG (core.stage_tracer) [Misc-04] Start stage tag=gen-graph-gen-opts-test_tool_tc1-nopic-global, group=graph, time=1732019398.2131183 2024-11-19 12:29:58,213 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-gen-opts-test_tool_tc1-nopic-global_started=1732019398.2131183 2024-11-19 12:29:58,213 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-gen-opts-test_tool_tc1-nopic-global_started - 1732019398.2131183 2024-11-19 12:29:58,213 DEBUG (yalibrary.guards) [Misc-04] Enter guard fetch with value None 2024-11-19 12:29:58,226 DEBUG (build.genconf) [Misc-04] Generating conf into /home/runner/.ya/build/conf/dist-release-06d29a8eb873efd32d30df7100bcb0f9/ymake.conf with cmd ['/home/runner/.ya/tools/38e015ab6e_d/ya-bin', '/home/runner/actions_runner/_work/ydb/ydb/build/ymake_conf.py', '/home/runner/actions_runner/_work/ydb/ydb', 'dist-release', 'no', '--toolchain-params', 'eyJib3R0bGVfbmFtZSI6ImNsYW5nMTgiLCJlbnYiOnsiQ1BBVEgiOlsiIl0sIkxJQlJBUllfUEFUSCI6WyIiXSwiU0RLUk9PVCI6WyIiXX0sImV4ZWN1dGFibGVfcGF0aCI6ImMrKyIsImZsYWdzIjp7IlNBTklUSVpFUl9UWVBFIjoiYWRkcmVzcyJ9LCJmb3JtdWxhIjp7ImJ5X3BsYXRmb3JtIjp7ImRhcndpbi1hcm02NCI6eyJ1cmkiOiJzYnI6NzQ1MTYwMjYwOSJ9LCJkYXJ3aW4teDg2XzY0Ijp7InVyaSI6InNicjo3NDUxNTg1OTYyIn0sImxpbnV4LWFhcmNoNjQiOnsidXJpIjoic2JyOjc0NTE3MTIzMzIifSwibGludXgteDg2XzY0Ijp7InVyaSI6InNicjo3NDUxNDY2NDA3In0sIndpbjMyLXg4Nl82NCI6eyJ1cmkiOiJzYnI6NzQ1MTQwNjkwMCJ9fX0sIm5hbWUiOiJjbGFuZzE4IiwicGFyYW1zIjp7ImNfY29tcGlsZXIiOiIkKENMQU5HLTE3MzUwNTY4MjEpL2Jpbi9jbGFuZyIsImN4eF9jb21waWxlciI6IiQoQ0xBTkctMTczNTA1NjgyMSkvYmluL2NsYW5nKysiLCJnY2NfdmVyc2lvbiI6IjE4IiwibGx2bS1zeW1ib2xpemVyIjoiJChDTEFORy0xNzM1MDU2ODIxKS9iaW4vbGx2bS1zeW1ib2xpemVyIiwibWF0Y2hfcm9vdCI6IkNMQU5HLTE3MzUwNTY4MjEiLCJvYmpjb3B5IjoiJChDTEFORy0xNzM1MDU2ODIxKS9iaW4vbGx2bS1vYmpjb3B5IiwicHJvZmlsZXMiOiIkKFhDT0RFX1RPT0xTX1JPT1Qtc2JyOjc5OTAxNzc3MSkvWGNvZGUvQ29udGVudHMvRGV2ZWxvcGVyL1BsYXRmb3Jtcy9pUGhvbmVPUy5wbGF0Zm9ybS9EZXZlbG9wZXIvTGlicmFyeS9Db3JlU2ltdWxhdG9yL1Byb2ZpbGVzIiwic2ltY3RsIjoiJChYQ09ERV9UT09MU19ST09ULXNicjo3OTkwMTc3NzEpL1hjb2RlL1N5c3RlbVJvb3QvUHJpdmF0ZUZyYW1ld29ya3MvQ29yZVNpbXVsYXRvci5mcmFtZXdvcmsvUmVzb3VyY2VzL2Jpbi9zaW1jdGwiLCJzdHJpcCI6IiQoQ0xBTkctMTczNTA1NjgyMSkvYmluL2xsdm0tc3RyaXAiLCJ0eXBlIjoiY2xhbmciLCJ1c2VfYnVuZGxlIjp0cnVlLCJ3ZXJyb3JfbW9kZSI6ImFsbCJ9LCJwbGF0Zm9ybSI6eyJob3N0Ijp7ImFyY2giOiJ4ODZfNjQiLCJvcyI6IkxJTlVYIiwidG9vbGNoYWluIjoiZGVmYXVsdCIsInZpc2libGVfbmFtZSI6ImNsYW5nMTgifSwidGFyZ2V0Ijp7ImFyY2giOiJ4ODZfNjQiLCJvcyI6IkxJTlVYIiwidG9vbGNoYWluIjoiZGVmYXVsdCIsInZpc2libGVfbmFtZSI6ImNsYW5nMTgifX0sInBsYXRmb3JtX25hbWUiOiJERUZBVUxULUxJTlVYLVg4Nl82NCIsInRvb2xfdmFyIjoiQ0xBTkctMTczNTA1NjgyMSJ9', '-l', '-D', 'APPLE_SDK_LOCAL=yes', '-D', 'CFLAGS=-fno-omit-frame-pointer', '-D', 'CLANG18=yes', '-D', 'FORCE_NO_PIC=yes', '-D', 'IS_CROSS_SANITIZE=yes', '-D', 'IS_CROSS_TOOLS=yes', '-D', 'OPENSOURCE=yes', '-D', 'SANITIZER_TYPE=address', '-D', 'TESTS_REQUESTED=yes', '-D', 'TRAVERSE_DEPENDS=yes', '-D', 'TRAVERSE_RECURSE_FOR_TESTS=yes', '-D', 'USE_AIO=static', '-D', 'USE_CLANG_CL=yes', '-D', 'USE_ICONV=static', '-D', 'USE_IDN=static', '-D', 'USE_PREBUILT_TOOLS=no', '-D', 'YA=yes'] and env {'PATH': '/home/runner/actions_runner/_work/ydb/ydb/ydb/ci/scripts:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/snap/bin', 'Y_PYTHON_ENTRY_POINT': ':main'} 2024-11-19 12:29:58,345 DEBUG (build.genconf) [Misc-04] Copy conf /home/runner/.ya/build/conf/dist-release-06d29a8eb873efd32d30df7100bcb0f9/ymake.conf to /home/runner/.ya/build/conf/dist-release-x-50c47e5d1a77fdc41ebe2ced4dea973a/ymake.conf 2024-11-19 12:29:58,345 DEBUG (yalibrary.guards) [Misc-04] Exit guard fetch with value None 2024-11-19 12:29:58,345 DEBUG (core.stage_tracer) [Misc-04] Finish stage tag=gen-graph-gen-opts-test_tool_tc1-nopic-global, group=graph, time=1732019398.3456774 2024-11-19 12:29:58,345 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-gen-opts-test_tool_tc1-nopic-global_finished=1732019398.3456774 2024-11-19 12:29:58,345 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-gen-opts-test_tool_tc1-nopic-global_finished - 1732019398.3456774 2024-11-19 12:29:58,345 DEBUG (core.stage_tracer) [Misc-04] Start stage tag=gen-graph-json-test_tool_tc1-nopic-global, group=graph, time=1732019398.3458629 2024-11-19 12:29:58,345 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-json-test_tool_tc1-nopic-global_started=1732019398.3458629 2024-11-19 12:29:58,345 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-json-test_tool_tc1-nopic-global_started - 1732019398.3458629 2024-11-19 12:29:58,346 DEBUG (build.ymake2) [Misc-04] Run gen graph with {'grab_stderr': True, 'mode': 'dist', 'dump_graph': 'json', 'check': True, '_purpose': 'test_tool_tc1-nopic-global', 'cpp': True, 'custom_build_directory': '/home/runner/.ya/build/conf/dist-release-x-50c47e5d1a77fdc41ebe2ced4dea973a_d357a1f7839b099012272bcb9853ec19', 'build_type': 'release', 'abs_targets': ['/home/runner/actions_runner/_work/ydb/ydb/build/platform/test_tool', '/home/runner/actions_runner/_work/ydb/ydb/build/external_resources/go_tools', '/home/runner/actions_runner/_work/ydb/ydb/build/external_resources/flake8_py2', '/home/runner/actions_runner/_work/ydb/ydb/build/external_resources/flake8_py3', '/home/runner/actions_runner/_work/ydb/ydb/build/platform/java/jstyle_lib'], 'debug_options': [], 'custom_conf': '/home/runner/.ya/build/conf/dist-release-x-50c47e5d1a77fdc41ebe2ced4dea973a/ymake.conf', 'continue_on_fail': False, 'ymake_bin': None, 'warn_mode': ['dirloops', 'ChkPeers'], 'build_depends': 3, 'arcadia_tests_data_path': '/home/runner/actions_runner/_work/ydb/arcadia_tests_data', 'checkout_data_by_ya': False, 'strict_inputs': False, 'dump_inputs_map': False, 'ev_listener': .event_listener_debug_id_wrapper at 0x7f742e13b920>, 'enabled_events': 'PSLGE', 'no_caches_on_retry': False, 'no_ymake_retry': False, 'disable_customization': 0, 'dump_tests': '/home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.elwo7jp_/test.dart', 'dump_make_files': '/home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.elwo7jp_/makefiles.dart'} 2024-11-19 12:29:58,346 DEBUG (core.yarg.behaviour) [Misc-04] Found unused args ['grab_stderr'] 2024-11-19 12:29:58,346 DEBUG (build.prefetch) [Misc-04] prefetch disabled 2024-11-19 12:29:58,346 DEBUG (core.event_handling.base_subscriber) [Misc-04] Subscribing PrintProgressSubscriber to event_queue 2024-11-19 12:29:58,346 DEBUG (yalibrary.tools) [Misc-04] Using old-style toolchain for: ymake 2024-11-19 12:29:58,346 DEBUG (build.ymake2.run_ymake) [Misc-04] run: '/home/runner/.ya/tools/v4/7448917907/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732019397.3025.c6ogw00k/yatmpt3n_8k_h --config /home/runner/.ya/build/conf/dist-release-x-50c47e5d1a77fdc41ebe2ced4dea973a/ymake.conf --plugins-root /home/runner/actions_runner/_work/ydb/ydb/build/plugins,/home/runner/actions_runner/_work/ydb/ydb/build/internal/plugins --build-root /home/runner/.ya/build/conf/dist-release-x-50c47e5d1a77fdc41ebe2ced4dea973a_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.elwo7jp_/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.elwo7jp_/makefiles.dart --dump-build-plan - --quiet --events PSLGE /home/runner/actions_runner/_work/ydb/ydb/build/platform/test_tool /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/go_tools /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/flake8_py2 /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/flake8_py3 /home/runner/actions_runner/_work/ydb/ydb/build/platform/java/jstyle_lib' with env: { } 2024-11-19 12:29:58,715 DEBUG (build.ymake2.run_ymake) [Misc-04] run '/home/runner/.ya/tools/v4/7448917907/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732019397.3025.c6ogw00k/yatmpt3n_8k_h --config /home/runner/.ya/build/conf/dist-release-x-50c47e5d1a77fdc41ebe2ced4dea973a/ymake.conf --plugins-root /home/runner/actions_runner/_work/ydb/ydb/build/plugins,/home/runner/actions_runner/_work/ydb/ydb/build/internal/plugins --build-root /home/runner/.ya/build/conf/dist-release-x-50c47e5d1a77fdc41ebe2ced4dea973a_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.elwo7jp_/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.elwo7jp_/makefiles.dart --dump-build-plan - --quiet --events PSLGE /home/runner/actions_runner/_work/ydb/ydb/build/platform/test_tool /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/go_tools /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/flake8_py2 /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/flake8_py3 /home/runner/actions_runner/_work/ydb/ydb/build/platform/java/jstyle_lib' finished 2024-11-19 12:29:58,715 DEBUG (core.event_handling.base_subscriber) [Misc-04] Unsubscribing PrintProgressSubscriber from event_queue 2024-11-19 12:29:58,716 DEBUG (build.ymake2) [Misc-04] ymake_run_info: {"ymake_run_uid":2,"stats":{"preparing":{"start":1732019398.346266508102417,"finish":1732019398.34680700302124,"duration":0.000540494918823},"execution":{"start":1732019398.346807479858398,"finish":1732019398.715652704238892,"duration":0.368845224380493},"postprocessing":{"start":1732019398.715655088424683,"finish":1732019398.715988874435425,"duration":0.000333786010742}},"purpose":"test_tool_tc1-nopic-global","caches":{},"stages":{},"metrics":{},"binary":"/home/runner/.ya/tools/v4/7448917907/ymake","args":["/home/runner/.ya/tools/v4/7448917907/ymake","--depends-like-recurse","--warn","dirloops,ChkPeers","--write-meta-data","/home/runner/.ya/tmp/1732019397.3025.c6ogw00k/yatmpt3n_8k_h","--config","/home/runner/.ya/build/conf/dist-release-x-50c47e5d1a77fdc41ebe2ced4dea973a/ymake.conf","--plugins-root","/home/runner/actions_runner/_work/ydb/ydb/build/plugins,/home/runner/actions_runner/_work/ydb/ydb/build/internal/plugins","--build-root","/home/runner/.ya/build/conf/dist-release-x-50c47e5d1a77fdc41ebe2ced4dea973a_d357a1f7839b099012272bcb9853ec19","--test-dart","/home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.elwo7jp_/test.dart","--tests-data-root","/home/runner/actions_runner/_work/ydb/arcadia_tests_data","--makefiles-dart","/home/runner/.ya/tmp/1732019397.3025.c6ogw00k/gen_graph.elwo7jp_/makefiles.dart","--dump-build-plan","-","--quiet","--events","PSLGE","/home/runner/actions_runner/_work/ydb/ydb/build/platform/test_tool","/home/runner/actions_runner/_work/ydb/ydb/build/external_resources/go_tools","/home/runner/actions_runner/_work/ydb/ydb/build/external_resources/flake8_py2","/home/runner/actions_runner/_work/ydb/ydb/build/external_resources/flake8_py3","/home/runner/actions_runner/_work/ydb/ydb/build/platform/java/jstyle_lib"],"exit_code":0,"duration":0.368845224380493} 2024-11-19 12:29:58,716 DEBUG (core.stage_tracer) [Misc-04] Start stage tag=load-graph-from-json, group=graph, time=1732019398.7163622 2024-11-19 12:29:58,716 DEBUG (core.stages_profiler) [Misc-04] Set stage load-graph-from-json_started=1732019398.7163622 2024-11-19 12:29:58,716 DEBUG (core.profiler) [Misc-04] Profile step load-graph-from-json_started - 1732019398.7163622 2024-11-19 12:29:58,716 DEBUG (core.stage_tracer) [Misc-04] Finish stage tag=load-graph-from-json, group=graph, time=1732019398.7166023 2024-11-19 12:29:58,716 DEBUG (core.stages_profiler) [Misc-04] Set stage load-graph-from-json_finished=1732019398.7166023 2024-11-19 12:29:58,716 DEBUG (core.profiler) [Misc-04] Profile step load-graph-from-json_finished - 1732019398.7166023 2024-11-19 12:29:58,716 DEBUG (core.stage_tracer) [Misc-04] Finish stage tag=gen-graph-json-test_tool_tc1-nopic-global, group=graph, time=1732019398.7167885 2024-11-19 12:29:58,716 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-json-test_tool_tc1-nopic-global_finished=1732019398.7167885 2024-11-19 12:29:58,716 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-json-test_tool_tc1-nopic-global_finished - 1732019398.7167885 2024-11-19 12:29:58,717 DEBUG (core.stage_tracer) [Misc-04] Finish stage tag=gen-graph-test_tool_tc1-nopic-global, group=graph, time=1732019398.717036 2024-11-19 12:29:58,717 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-test_tool_tc1-nopic-global_finished=1732019398.717036 2024-11-19 12:29:58,717 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-test_tool_tc1-nopic-global_finished - 1732019398.717036 2024-11-19 12:29:58,717 DEBUG (core.stage_tracer) [MainThread] Start stage tag=get-graph-1, group=graph, time=1732019398.7176301 2024-11-19 12:29:58,717 DEBUG (core.stages_profiler) [MainThread] Set stage get-graph-1_started=1732019398.7176301 2024-11-19 12:29:58,717 DEBUG (core.profiler) [MainThread] Profile step get-graph-1_started - 1732019398.7176301 2024-11-19 12:29:58,719 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=get-graph-1, group=graph, time=1732019398.719376 2024-11-19 12:29:58,719 DEBUG (core.stages_profiler) [MainThread] Set stage get-graph-1_finished=1732019398.719376 2024-11-19 12:29:58,719 DEBUG (core.profiler) [MainThread] Profile step get-graph-1_finished - 1732019398.719376 2024-11-19 12:29:58,719 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=merge-target-graphs-1, group=graph, time=1732019398.719593 2024-11-19 12:29:58,719 DEBUG (core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_finished=1732019398.719593 2024-11-19 12:29:58,719 DEBUG (core.profiler) [MainThread] Profile step merge-target-graphs-1_finished - 1732019398.719593 2024-11-19 12:29:58,719 DEBUG (core.stage_tracer) [MainThread] Start stage tag=build-merged-graph, group=graph, time=1732019398.719747 2024-11-19 12:29:58,719 DEBUG (core.stages_profiler) [MainThread] Set stage build-merged-graph_started=1732019398.719747 2024-11-19 12:29:58,719 DEBUG (core.profiler) [MainThread] Profile step build-merged-graph_started - 1732019398.719747 2024-11-19 12:29:58,720 DEBUG (core.stage_tracer) [MainThread] Start stage tag=insert-tests-1, group=graph, time=1732019398.7207804 2024-11-19 12:29:58,720 DEBUG (core.stages_profiler) [MainThread] Set stage insert-tests-1_started=1732019398.7207804 2024-11-19 12:29:58,720 DEBUG (core.profiler) [MainThread] Profile step insert-tests-1_started - 1732019398.7207804 2024-11-19 12:29:58,721 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'unsupported cross-compiled tests' on 0 suites 2024-11-19 12:29:58,721 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter '. at 0x7f742e1f1f80>' on 0 suites 2024-11-19 12:29:58,721 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'size' on 0 suites 2024-11-19 12:29:58,721 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'class type' on 0 suites 2024-11-19 12:29:58,721 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'suite type' on 0 suites 2024-11-19 12:29:58,721 DEBUG (devtools.ya.test.filter) [MainThread] Tags filter include set:[] exclude set:[] 2024-11-19 12:29:58,721 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'tags' on 0 suites 2024-11-19 12:29:58,721 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'project path' on 0 suites 2024-11-19 12:29:58,721 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'filename filter' on 0 suites 2024-11-19 12:29:58,721 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'chunk filter' on 0 suites 2024-11-19 12:29:58,721 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'name' on 0 suites 2024-11-19 12:29:58,721 DEBUG (build.graph) [MainThread] Generating build plan 2024-11-19 12:29:58,721 DEBUG (build.graph) [MainThread] Preparing test suites 2024-11-19 12:29:58,721 DEBUG (build.graph) [MainThread] Stripping clang-tidy irrelevant deps 2024-11-19 12:29:58,721 DEBUG (exts.timer) [MainThread] Timer inject_tests, stage inject tests for default-linux-x86_64-release-asan: 0.0009763240814208984 2024-11-19 12:29:58,722 DEBUG (build.graph) [MainThread] injected 0 tests for default-linux-x86_64-release-asan 2024-11-19 12:29:58,722 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=insert-tests-1, group=graph, time=1732019398.7220411 2024-11-19 12:29:58,722 DEBUG (core.stages_profiler) [MainThread] Set stage insert-tests-1_finished=1732019398.7220411 2024-11-19 12:29:58,722 DEBUG (core.profiler) [MainThread] Profile step insert-tests-1_finished - 1732019398.7220411 2024-11-19 12:29:58,722 DEBUG (core.stage_tracer) [MainThread] Start stage tag=merge-target-graphs-1, group=graph, time=1732019398.7221847 2024-11-19 12:29:58,722 DEBUG (core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_started=1732019398.7221847 2024-11-19 12:29:58,722 DEBUG (core.profiler) [MainThread] Profile step merge-target-graphs-1_started - 1732019398.7221847 2024-11-19 12:29:58,722 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=merge-target-graphs-1, group=graph, time=1732019398.7223027 2024-11-19 12:29:58,722 DEBUG (core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_finished=1732019398.7223027 2024-11-19 12:29:58,722 DEBUG (core.profiler) [MainThread] Profile step merge-target-graphs-1_finished - 1732019398.7223027 2024-11-19 12:29:58,722 DEBUG (core.config) [MainThread] Read config "build/platform/python/ymake_python2/resources.json" from resource 2024-11-19 12:29:58,722 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] python: will use 'linux-x86_64' platform 2024-11-19 12:29:58,723 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/gdb/resources.json 2024-11-19 12:29:58,723 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] gdb: will use 'linux-x86_64' platform 2024-11-19 12:29:58,723 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=build-merged-graph, group=graph, time=1732019398.723178 2024-11-19 12:29:58,723 DEBUG (core.stages_profiler) [MainThread] Set stage build-merged-graph_finished=1732019398.723178 2024-11-19 12:29:58,723 DEBUG (core.profiler) [MainThread] Profile step build-merged-graph_finished - 1732019398.723178 2024-11-19 12:29:58,723 DEBUG (core.stage_tracer) [MainThread] Start stage tag=iter-extra-resources, group=graph, time=1732019398.7233295 2024-11-19 12:29:58,723 DEBUG (core.stages_profiler) [MainThread] Set stage iter-extra-resources_started=1732019398.7233295 2024-11-19 12:29:58,723 DEBUG (core.profiler) [MainThread] Profile step iter-extra-resources_started - 1732019398.7233295 2024-11-19 12:29:58,723 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=iter-extra-resources, group=graph, time=1732019398.7234647 2024-11-19 12:29:58,723 DEBUG (core.stages_profiler) [MainThread] Set stage iter-extra-resources_finished=1732019398.7234647 2024-11-19 12:29:58,723 DEBUG (core.profiler) [MainThread] Profile step iter-extra-resources_finished - 1732019398.7234647 2024-11-19 12:29:58,723 DEBUG (exts.timer) [MainThread] Timer build.graph, stage build and merge graphs: 1.1123158931732178 2024-11-19 12:29:58,723 DEBUG (core.stage_tracer) [MainThread] Start stage tag=strip-graph, group=graph, time=1732019398.723641 2024-11-19 12:29:58,723 DEBUG (core.stages_profiler) [MainThread] Set stage strip-graph_started=1732019398.723641 2024-11-19 12:29:58,723 DEBUG (core.profiler) [MainThread] Profile step strip-graph_started - 1732019398.723641 2024-11-19 12:29:58,723 DEBUG (build.graph) [MainThread] stripped 0, left 13 nodes 2024-11-19 12:29:58,723 DEBUG (exts.timer) [MainThread] Timer build.graph, stage strip graph: 0.00023293495178222656 2024-11-19 12:29:58,723 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=strip-graph, group=graph, time=1732019398.7238667 2024-11-19 12:29:58,723 DEBUG (core.stages_profiler) [MainThread] Set stage strip-graph_finished=1732019398.7238667 2024-11-19 12:29:58,723 DEBUG (core.profiler) [MainThread] Profile step strip-graph_finished - 1732019398.7238667 2024-11-19 12:29:58,724 DEBUG (exts.timer) [MainThread] Timer build.graph, stage gen rename nodes: 0.00018668174743652344 2024-11-19 12:29:58,724 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] python: will use 'linux-x86_64' platform 2024-11-19 12:29:58,724 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ymake: will use 'linux' platform 2024-11-19 12:29:58,724 DEBUG (core.stage_tracer) [MainThread] Start stage tag=inject_default_requirements, group=graph, time=1732019398.7242796 2024-11-19 12:29:58,724 DEBUG (core.stages_profiler) [MainThread] Set stage inject_default_requirements_started=1732019398.7242796 2024-11-19 12:29:58,724 DEBUG (core.profiler) [MainThread] Profile step inject_default_requirements_started - 1732019398.7242796 2024-11-19 12:29:58,724 DEBUG (build.graph) [MainThread] Updated requirements for 0 nodes 2024-11-19 12:29:58,724 DEBUG (exts.timer) [MainThread] Timer substitude_uids, stage substitude_uids: 8.106231689453125e-06 2024-11-19 12:29:58,724 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=inject_default_requirements, group=graph, time=1732019398.7244997 2024-11-19 12:29:58,724 DEBUG (core.stages_profiler) [MainThread] Set stage inject_default_requirements_finished=1732019398.7244997 2024-11-19 12:29:58,724 DEBUG (core.profiler) [MainThread] Profile step inject_default_requirements_finished - 1732019398.7244997 2024-11-19 12:29:58,724 DEBUG (exts.timer) [MainThread] Timer build.graph, stage misc graph changes: 0.0006148815155029297 2024-11-19 12:29:58,724 DEBUG (core.stage_tracer) [MainThread] Start stage tag=finalize-graph, group=graph, time=1732019398.724671 2024-11-19 12:29:58,724 DEBUG (core.stages_profiler) [MainThread] Set stage finalize-graph_started=1732019398.724671 2024-11-19 12:29:58,724 DEBUG (core.profiler) [MainThread] Profile step finalize-graph_started - 1732019398.724671 2024-11-19 12:29:58,724 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=finalize-graph, group=graph, time=1732019398.7247827 2024-11-19 12:29:58,724 DEBUG (core.stages_profiler) [MainThread] Set stage finalize-graph_finished=1732019398.7247827 2024-11-19 12:29:58,724 DEBUG (core.profiler) [MainThread] Profile step finalize-graph_finished - 1732019398.7247827 2024-11-19 12:29:58,724 DEBUG (core.stage_tracer) [MainThread] Start stage tag=imprint-store-and-stats, group=graph, time=1732019398.724907 2024-11-19 12:29:58,724 DEBUG (core.stages_profiler) [MainThread] Set stage imprint-store-and-stats_started=1732019398.724907 2024-11-19 12:29:58,724 DEBUG (core.profiler) [MainThread] Profile step imprint-store-and-stats_started - 1732019398.724907 2024-11-19 12:29:58,725 DEBUG (core.imprint.imprint:Imprint) [MainThread] 2024-11-19 12:29:58,725 DEBUG (core.imprint.imprint:Imprint) [MainThread] 2024-11-19 12:29:58,725 DEBUG (core.imprint.imprint:Imprint) [MainThread] 2024-11-19 12:29:58,725 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=imprint-store-and-stats, group=graph, time=1732019398.725169 2024-11-19 12:29:58,725 DEBUG (core.stages_profiler) [MainThread] Set stage imprint-store-and-stats_finished=1732019398.725169 2024-11-19 12:29:58,725 DEBUG (core.profiler) [MainThread] Profile step imprint-store-and-stats_finished - 1732019398.725169 2024-11-19 12:29:58,725 DEBUG (core.stage_tracer) [MainThread] Start stage tag=inject_stats_and_static_uids, group=graph, time=1732019398.725295 2024-11-19 12:29:58,725 DEBUG (core.stages_profiler) [MainThread] Set stage inject_stats_and_static_uids_started=1732019398.725295 2024-11-19 12:29:58,725 DEBUG (core.profiler) [MainThread] Profile step inject_stats_and_static_uids_started - 1732019398.725295 2024-11-19 12:29:58,725 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=inject_stats_and_static_uids, group=graph, time=1732019398.7255652 2024-11-19 12:29:58,725 DEBUG (core.stages_profiler) [MainThread] Set stage inject_stats_and_static_uids_finished=1732019398.7255652 2024-11-19 12:29:58,725 DEBUG (core.profiler) [MainThread] Profile step inject_stats_and_static_uids_finished - 1732019398.7255652 2024-11-19 12:29:58,725 DEBUG (core.stage_tracer) [MainThread] Start stage tag=strip-tags, group=graph, time=1732019398.725702 2024-11-19 12:29:58,725 DEBUG (core.stages_profiler) [MainThread] Set stage strip-tags_started=1732019398.725702 2024-11-19 12:29:58,725 DEBUG (core.profiler) [MainThread] Profile step strip-tags_started - 1732019398.725702 2024-11-19 12:29:58,725 DEBUG (exts.timer) [MainThread] Timer build.graph, stage strip tags: 0.0012128353118896484 2024-11-19 12:29:58,725 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=strip-tags, group=graph, time=1732019398.7258832 2024-11-19 12:29:58,725 DEBUG (core.stages_profiler) [MainThread] Set stage strip-tags_finished=1732019398.7258832 2024-11-19 12:29:58,725 DEBUG (core.profiler) [MainThread] Profile step strip-tags_finished - 1732019398.7258832 2024-11-19 12:29:58,726 DEBUG (core.stage_tracer) [MainThread] Start stage tag=reduce_graph_resources, group=graph, time=1732019398.7261038 2024-11-19 12:29:58,726 DEBUG (core.stages_profiler) [MainThread] Set stage reduce_graph_resources_started=1732019398.7261038 2024-11-19 12:29:58,726 DEBUG (core.profiler) [MainThread] Profile step reduce_graph_resources_started - 1732019398.7261038 2024-11-19 12:29:58,726 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=reduce_graph_resources, group=graph, time=1732019398.726377 2024-11-19 12:29:58,726 DEBUG (core.stages_profiler) [MainThread] Set stage reduce_graph_resources_finished=1732019398.726377 2024-11-19 12:29:58,726 DEBUG (core.profiler) [MainThread] Profile step reduce_graph_resources_finished - 1732019398.726377 2024-11-19 12:29:58,726 DEBUG (core.stage_tracer) [MainThread] Start stage tag=clean-intern-string-storage, group=graph, time=1732019398.7265136 2024-11-19 12:29:58,726 DEBUG (core.stages_profiler) [MainThread] Set stage clean-intern-string-storage_started=1732019398.7265136 2024-11-19 12:29:58,726 DEBUG (core.profiler) [MainThread] Profile step clean-intern-string-storage_started - 1732019398.7265136 2024-11-19 12:29:58,726 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=clean-intern-string-storage, group=graph, time=1732019398.7266905 2024-11-19 12:29:58,726 DEBUG (core.stages_profiler) [MainThread] Set stage clean-intern-string-storage_finished=1732019398.7266905 2024-11-19 12:29:58,726 DEBUG (core.profiler) [MainThread] Profile step clean-intern-string-storage_finished - 1732019398.7266905 2024-11-19 12:29:58,726 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=build_graph_and_tests, group=graph, time=1732019398.7268145 2024-11-19 12:29:58,726 DEBUG (core.stages_profiler) [MainThread] Set stage build_graph_and_tests_finished=1732019398.7268145 2024-11-19 12:29:58,726 DEBUG (core.profiler) [MainThread] Profile step build_graph_and_tests_finished - 1732019398.7268145 2024-11-19 12:29:58,727 DEBUG (exts.timer) [MainThread] Timer context_creation, stage graph_and_tests finished: 1.1461095809936523 2024-11-19 12:29:58,728 DEBUG (core.stage_tracer) [MainThread] Start stage tag=configure-dist-store-cache, group=ya_make, time=1732019398.72852 2024-11-19 12:29:58,728 DEBUG (core.stages_profiler) [MainThread] Set stage configure-dist-store-cache_started=1732019398.72852 2024-11-19 12:29:58,728 DEBUG (core.profiler) [MainThread] Profile step configure-dist-store-cache_started - 1732019398.72852 2024-11-19 12:29:58,728 DEBUG (build.ya_make) [MainThread] Waiting for dist cache setup 2024-11-19 12:29:58,728 DEBUG (build.ya_make) [MainThread] Loading meta from dist cache 2024-11-19 12:29:58,728 DEBUG (build.ya_make) [MainThread] Dist cache prepared 2024-11-19 12:29:58,728 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=configure-dist-store-cache, group=ya_make, time=1732019398.7288182 2024-11-19 12:29:58,728 DEBUG (core.stages_profiler) [MainThread] Set stage configure-dist-store-cache_finished=1732019398.7288182 2024-11-19 12:29:58,728 DEBUG (core.profiler) [MainThread] Profile step configure-dist-store-cache_finished - 1732019398.7288182 2024-11-19 12:29:58,728 DEBUG (core.stage_tracer) [MainThread] Start stage tag=configure-local-cache, group=ya_make, time=1732019398.7289615 2024-11-19 12:29:58,729 DEBUG (core.stages_profiler) [MainThread] Set stage configure-local-cache_started=1732019398.7289615 2024-11-19 12:29:58,729 DEBUG (core.profiler) [MainThread] Profile step configure-local-cache_started - 1732019398.7289615 2024-11-19 12:29:58,729 DEBUG (build.ya_make) [MainThread] content UIDs forced 2024-11-19 12:29:58,729 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=configure-local-cache, group=ya_make, time=1732019398.729164 2024-11-19 12:29:58,729 DEBUG (core.stages_profiler) [MainThread] Set stage configure-local-cache_finished=1732019398.729164 2024-11-19 12:29:58,729 DEBUG (core.profiler) [MainThread] Profile step configure-local-cache_finished - 1732019398.729164 2024-11-19 12:29:58,729 DEBUG (build.ya_make) [MainThread] sandbox_run_test_uids: set() 2024-11-19 12:29:58,731 DEBUG (urllib3.connectionpool) [Misc-05] Starting new HTTP connection (1): cachesrv.internal:8081 2024-11-19 12:29:58,731 DEBUG (urllib3.connectionpool) [Misc-06] Starting new HTTP connection (2): cachesrv.internal:8081 2024-11-19 12:29:58,732 DEBUG (urllib3.connectionpool) [Misc-07] Starting new HTTP connection (3): cachesrv.internal:8081 2024-11-19 12:29:58,733 DEBUG (urllib3.connectionpool) [Misc-08] Starting new HTTP connection (4): cachesrv.internal:8081 2024-11-19 12:29:58,735 DEBUG (urllib3.connectionpool) [Misc-09] Starting new HTTP connection (5): cachesrv.internal:8081 2024-11-19 12:29:58,736 DEBUG (urllib3.connectionpool) [Misc-05] http://cachesrv.internal:8081 "HEAD /ac/3162744e6561686b67364c626b4f763877436361375100000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:29:58,737 DEBUG (urllib3.connectionpool) [Misc-10] Starting new HTTP connection (6): cachesrv.internal:8081 2024-11-19 12:29:58,737 DEBUG (urllib3.connectionpool) [Misc-08] http://cachesrv.internal:8081 "HEAD /ac/3276756f474b7870594b6669394839354b3435374d4100000000000000000001 HTTP/1.1" 200 0 2024-11-19 12:29:58,737 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-05] Bazel-remote Probing 1btNeahkg6LbkOv8wCca7Q => False 2024-11-19 12:29:58,738 DEBUG (urllib3.connectionpool) [Misc-06] http://cachesrv.internal:8081 "HEAD /ac/50473277703254653844527676656f477a75346d4d6700000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:29:58,739 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-08] Bazel-remote Probing 2vuoGKxpYKfi9H95K457MA => True 2024-11-19 12:29:58,739 DEBUG (urllib3.connectionpool) [Misc-09] http://cachesrv.internal:8081 "HEAD /ac/4e4c6635756c58743353795a45566d776d464842416700000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:29:58,740 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-06] Bazel-remote Probing PG2wp2Te8DRvveoGzu4mMg => False 2024-11-19 12:29:58,740 DEBUG (urllib3.connectionpool) [Misc-11] http://cachesrv.internal:8081 "HEAD /ac/4242516c6c594274466c576678752d396f493154367700000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:29:58,742 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-09] Bazel-remote Probing NLf5ulXt3SyZEVmwmFHBAg => False 2024-11-19 12:29:58,742 DEBUG (urllib3.connectionpool) [Misc-07] http://cachesrv.internal:8081 "HEAD /ac/6b557878797163536c314878574c32517a36517a427700000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:29:58,742 DEBUG (urllib3.connectionpool) [Misc-12] http://cachesrv.internal:8081 "HEAD /ac/544c30434f50634f35626e48517959314431764d774100000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:29:58,744 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-11] Bazel-remote Probing BBQllYBtFlWfxu-9oI1T6w => False 2024-11-19 12:29:58,745 DEBUG (urllib3.connectionpool) [Misc-13] http://cachesrv.internal:8081 "HEAD /ac/734f36312d416949456f5552695374324239584d385100000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:29:58,745 DEBUG (urllib3.connectionpool) [Misc-10] http://cachesrv.internal:8081 "HEAD /ac/4f6c37714b485173503034737046744a54686233414100000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:29:58,745 DEBUG (urllib3.connectionpool) [Misc-14] http://cachesrv.internal:8081 "HEAD /ac/614b7a47786c7957616a79696f374a545a387a63667700000000000000000001 HTTP/1.1" 200 0 2024-11-19 12:29:58,747 DEBUG (urllib3.connectionpool) [Misc-16] Starting new HTTP connection (7): cachesrv.internal:8081 2024-11-19 12:29:58,747 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-07] Bazel-remote Probing kUxxyqcSl1HxWL2Qz6QzBw => False 2024-11-19 12:29:58,748 DEBUG (urllib3.connectionpool) [Misc-15] http://cachesrv.internal:8081 "HEAD /ac/634f6342476a35626766706c5554397330754c746e5100000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:29:58,749 DEBUG (urllib3.connectionpool) [Misc-17] http://cachesrv.internal:8081 "HEAD /ac/76635462767a6f63317935666f6e6e4852477457516700000000000000000001 HTTP/1.1" 200 0 2024-11-19 12:29:58,749 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-12] Bazel-remote Probing TL0COPcO5bnHQyY1D1vMwA => False 2024-11-19 12:29:58,749 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-13] Bazel-remote Probing sO61-AiIEoURiSt2B9XM8Q => False 2024-11-19 12:29:58,750 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-10] Bazel-remote Probing Ol7qKHQsP04spFtJThb3AA => False 2024-11-19 12:29:58,750 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-14] Bazel-remote Probing aKzGxlyWajyio7JTZ8zcfw => True 2024-11-19 12:29:58,751 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-15] Bazel-remote Probing cOcBGj5bgfplUT9s0uLtnQ => False 2024-11-19 12:29:58,751 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-17] Bazel-remote Probing vcTbvzoc1y5fonnHRGtWQg => True 2024-11-19 12:29:58,752 DEBUG (urllib3.connectionpool) [Misc-16] http://cachesrv.internal:8081 "HEAD /ac/637a52574c69497847757767574b5458373044342d7700000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:29:58,753 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-16] Bazel-remote Probing czRWLiIxGuwgWKTX70D4-w => False 2024-11-19 12:29:58,753 DEBUG (build.ya_make) [MainThread] Strip graph due bazel_remote_store mode 2024-11-19 12:29:58,753 DEBUG (build.graph) [MainThread] stripped 0, left 13 nodes 2024-11-19 12:29:58,756 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=context_creation, group=ya_make, time=1732019398.7569158 2024-11-19 12:29:58,757 DEBUG (core.stages_profiler) [MainThread] Set stage context_creation_finished=1732019398.7569158 2024-11-19 12:29:58,757 DEBUG (core.profiler) [MainThread] Profile step context_creation_finished - 1732019398.7569158 2024-11-19 12:29:58,757 DEBUG (exts.timer) [MainThread] Timer context_creation, stage context_creation finished: 0.030014514923095703 2024-11-19 12:29:58,757 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=context_generating, group=build_handler, time=1732019398.7573013 2024-11-19 12:29:58,757 DEBUG (core.stages_profiler) [MainThread] Set stage context_generating_finished=1732019398.7573013 2024-11-19 12:29:58,757 DEBUG (core.profiler) [MainThread] Profile step context_generating_finished - 1732019398.7573013 2024-11-19 12:29:58,757 DEBUG (core.stage_tracer) [MainThread] Start stage tag=build, group=build_handler, time=1732019398.757481 2024-11-19 12:29:58,757 DEBUG (core.stages_profiler) [MainThread] Set stage build_started=1732019398.757481 2024-11-19 12:29:58,757 DEBUG (core.profiler) [MainThread] Profile step build_started - 1732019398.757481 2024-11-19 12:29:58,757 DEBUG (build.reports.autocheck_report) [MainThread] Got 0 tests to report 2024-11-19 12:29:58,757 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2024-11-19 12:29:58,758 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2024-11-19 12:29:58,758 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2024-11-19 12:29:58,758 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2024-11-19 12:29:58,758 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2024-11-19 12:29:58,758 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2024-11-19 12:29:58,758 DEBUG (ReportGenerator) [MainThread] Finish style report 2024-11-19 12:29:58,758 DEBUG (StoredReport) [MainThread] Finish style report 2024-11-19 12:29:58,759 DEBUG (ReportGenerator) [MainThread] Finish tests report, tests by size defaultdict(, {'small': set(), 'medium': set(), 'large': set()}), tests by type defaultdict(, {}) 2024-11-19 12:29:58,759 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2024-11-19 12:29:58,759 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2024-11-19 12:29:58,759 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2024-11-19 12:29:58,759 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2024-11-19 12:29:58,759 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2024-11-19 12:29:58,759 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2024-11-19 12:29:58,759 DEBUG (StoredReport) [MainThread] Finish tests report 2024-11-19 12:29:58,759 DEBUG (ReportGenerator) [MainThread] Finish configure report 2024-11-19 12:29:58,759 DEBUG (StoredReport) [MainThread] Finish configure report 2024-11-19 12:29:58,759 DEBUG (core.stage_tracer) [MainThread] Start stage tag=dispatch_build, group=ya_make, time=1732019398.7593617 2024-11-19 12:29:58,759 DEBUG (core.stages_profiler) [MainThread] Set stage dispatch_build_started=1732019398.7593617 2024-11-19 12:29:58,759 DEBUG (core.profiler) [MainThread] Profile step dispatch_build_started - 1732019398.7593617 2024-11-19 12:29:58,759 DEBUG (yalibrary.runner.runner3) [MainThread] RLIMIT_NOFILE limits: (524288, 524288) 2024-11-19 12:29:58,770 DEBUG (root) [MainThread] Starting local executor with cmd: ['/home/runner/.ya/tools/38e015ab6e_d/ya-bin', 'unix:/home/runner/.ya/tmp/1732019397.3025.c6ogw00k/3025e7inw2h9', '0'] 2024-11-19 12:29:58,770 DEBUG (root) [MainThread] Not waiting for initialization, returning waiter function 2024-11-19 12:29:58,791 DEBUG (library.python.filelock) [MainThread] Acquiring FileLock (blocking=True): /home/runner/.ya/build/build_root/66bk/STAMP 2024-11-19 12:29:58,791 DEBUG (exts.timer) [MainThread] Timer yalibrary.runner.runner3, stage resolve: 3.981590270996094e-05 2024-11-19 12:29:58,791 DEBUG (exts.timer) [MainThread] Timer yalibrary.runner.runner3, stage build nodes: 0.00012564659118652344 2024-11-19 12:29:58,791 DEBUG (exts.timer) [MainThread] Timer yalibrary.runner.runner3, stage build who provides, ref count: 5.602836608886719e-05 2024-11-19 12:29:58,792 DEBUG (exts.timer) [MainThread] Timer yalibrary.runner.runner3, stage build ref count: 5.078315734863281e-05 2024-11-19 12:29:58,792 DEBUG (yalibrary.runner.runner3) [MainThread] content UIDs *enabled* in runner 2024-11-19 12:29:58,897 DEBUG (yalibrary.runner.runner3) [Worker-002] Local executor is ready 2024-11-19 12:29:58,901 DEBUG (yalibrary.toolscache) [PrepareAllNodes_0] AC cache (has uid BBQllYBtFlWfxu-9oI1T6w) address: (2607, 16865, 'unix:/home/runner/.ya/build/cache/7/psingktdsqW.tmp') 2024-11-19 12:29:58,904 DEBUG (urllib3.connectionpool) [Worker-005] http://cachesrv.internal:8081 "HEAD /ac/4242516c6c594274466c576678752d396f493154367700000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:29:58,906 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-005] Bazel-remote Probing BBQllYBtFlWfxu-9oI1T6w => False 2024-11-19 12:29:58,909 DEBUG (urllib3.connectionpool) [Worker-008] http://cachesrv.internal:8081 "HEAD /ac/4f6c37714b485173503034737046744a54686233414100000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:29:58,911 DEBUG (yalibrary.fetcher.resource_fetcher) [Worker-011] Fetching 7336031045 from sbr:7336031045 to /home/runner/.ya/tools/v4/7336031045 dir, post_process=0) 2024-11-19 12:29:58,912 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-008] Bazel-remote Probing Ol7qKHQsP04spFtJThb3AA => False 2024-11-19 12:29:58,913 DEBUG (yalibrary.toolscache) [Worker-011] Tools cache attempt: (request for resource 7336031045) 2024-11-19 12:29:58,914 DEBUG (yalibrary.fetcher.resource_fetcher) [Worker-008] Fetching 7458630270 from sbr:7458630270 to /home/runner/.ya/tools/v4/7458630270 dir, post_process=0) 2024-11-19 12:29:58,915 DEBUG (yalibrary.toolscache) [Worker-008] Tools cache attempt: (request for resource 7458630270) 2024-11-19 12:29:58,918 DEBUG (urllib3.connectionpool) [Worker-022] http://cachesrv.internal:8081 "HEAD /ac/3162744e6561686b67364c626b4f763877436361375100000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:29:58,918 DEBUG (urllib3.connectionpool) [Worker-014] http://cachesrv.internal:8081 "HEAD /ac/734f36312d416949456f5552695374324239584d385100000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:29:58,918 DEBUG (urllib3.connectionpool) [Worker-007] http://cachesrv.internal:8081 "HEAD /ac/4e4c6635756c58743353795a45566d776d464842416700000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:29:58,918 DEBUG (urllib3.connectionpool) [Worker-009] http://cachesrv.internal:8081 "HEAD /ac/6b557878797163536c314878574c32517a36517a427700000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:29:58,918 DEBUG (yalibrary.toolscache) [Worker-011] tc cache stats: TotalKnownSize: 62119936 TotalKnownSizeLocked: 22249472 NonComputedCount: 1 Master: true TotalDBSize: 81920 ToolCount: 2 ProcessesCount: 2 2024-11-19 12:29:58,918 DEBUG (urllib3.connectionpool) [Worker-013] http://cachesrv.internal:8081 "HEAD /ac/544c30434f50634f35626e48517959314431764d774100000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:29:58,920 DEBUG (urllib3.connectionpool) [Worker-025] Starting new HTTP connection (8): cachesrv.internal:8081 2024-11-19 12:29:58,921 DEBUG (yalibrary.runner.tasks.result) [Worker-002] ResultsNodeTask for 1btNeahkg6LbkOv8wCca7Q created (provider=None) 2024-11-19 12:29:58,921 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-022] Bazel-remote Probing 1btNeahkg6LbkOv8wCca7Q => False 2024-11-19 12:29:58,921 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-014] Bazel-remote Probing sO61-AiIEoURiSt2B9XM8Q => False 2024-11-19 12:29:58,921 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-007] Bazel-remote Probing NLf5ulXt3SyZEVmwmFHBAg => False 2024-11-19 12:29:58,922 DEBUG (yalibrary.toolscache) [Worker-008] tc cache stats: TotalKnownSize: 62119936 TotalKnownSizeLocked: 22249472 NonComputedCount: 2 Master: true TotalDBSize: 81920 ToolCount: 2 ProcessesCount: 2 2024-11-19 12:29:58,922 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-009] Bazel-remote Probing kUxxyqcSl1HxWL2Qz6QzBw => False 2024-11-19 12:29:58,922 DEBUG (yalibrary.fetcher.cache_helper) [Worker-011] not installed /home/runner/.ya/tools/v4/7336031045 2024-11-19 12:29:58,922 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-013] Bazel-remote Probing TL0COPcO5bnHQyY1D1vMwA => False 2024-11-19 12:29:58,923 DEBUG (yalibrary.runner.tasks.result) [Worker-002] ResultsNodeTask for PG2wp2Te8DRvveoGzu4mMg created (provider=None) 2024-11-19 12:29:58,926 DEBUG (yalibrary.fetcher.cache_helper) [Worker-008] not installed /home/runner/.ya/tools/v4/7458630270 2024-11-19 12:29:58,927 DEBUG (urllib3.connectionpool) [Worker-021] http://cachesrv.internal:8081 "HEAD /ac/50473277703254653844527676656f477a75346d4d6700000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:29:58,927 DEBUG (library.python.filelock) [Worker-011] Acquiring FileLock (blocking=True): /home/runner/.ya/tools/v4/7336031045.lock 2024-11-19 12:29:58,927 DEBUG (urllib3.connectionpool) [Worker-024] http://cachesrv.internal:8081 "HEAD /ac/637a52574c69497847757767574b5458373044342d7700000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:29:58,928 DEBUG (yalibrary.runner.tasks.result) [Worker-002] ResultsNodeTask for kUxxyqcSl1HxWL2Qz6QzBw created (provider=None) 2024-11-19 12:29:58,928 DEBUG (urllib3.connectionpool) [Worker-025] http://cachesrv.internal:8081 "HEAD /ac/634f6342476a35626766706c5554397330754c746e5100000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:29:58,929 DEBUG (library.python.filelock) [Worker-008] Acquiring FileLock (blocking=True): /home/runner/.ya/tools/v4/7458630270.lock 2024-11-19 12:29:58,929 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-021] Bazel-remote Probing PG2wp2Te8DRvveoGzu4mMg => False 2024-11-19 12:29:58,929 DEBUG (yalibrary.fetcher.cache_helper) [Worker-011] not installed /home/runner/.ya/tools/v4/7336031045 2024-11-19 12:29:58,930 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-024] Bazel-remote Probing czRWLiIxGuwgWKTX70D4-w => False 2024-11-19 12:29:58,930 DEBUG (urllib3.connectionpool) [Worker-014] http://cachesrv.internal:8081 "HEAD /ac/614b7a47786c7957616a79696f374a545a387a63667700000000000000000001 HTTP/1.1" 200 0 2024-11-19 12:29:58,930 DEBUG (yalibrary.runner.tasks.result) [Worker-002] ResultsNodeTask for BBQllYBtFlWfxu-9oI1T6w created (provider=None) 2024-11-19 12:29:58,930 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-025] Bazel-remote Probing cOcBGj5bgfplUT9s0uLtnQ => False 2024-11-19 12:29:58,931 DEBUG (yalibrary.fetcher.cache_helper) [Worker-008] not installed /home/runner/.ya/tools/v4/7458630270 2024-11-19 12:29:58,932 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-014] Bazel-remote Probing aKzGxlyWajyio7JTZ8zcfw => True 2024-11-19 12:29:58,933 DEBUG (exts.http_client) [Worker-011] Downloading https://devtools-registry.s3.yandex.net/7336031045 to /home/runner/.ya/tools/v4/7336031045/resource.ytwzh8ho.8ao625m0.part, expect md5- 2024-11-19 12:29:58,934 DEBUG (urllib3.connectionpool) [Worker-021] http://cachesrv.internal:8081 "HEAD /ac/3276756f474b7870594b6669394839354b3435374d4100000000000000000001 HTTP/1.1" 200 0 2024-11-19 12:29:58,934 DEBUG (yalibrary.runner.tasks.result) [Worker-002] ResultsNodeTask for NLf5ulXt3SyZEVmwmFHBAg created (provider=None) 2024-11-19 12:29:58,936 DEBUG (urllib3.connectionpool) [Worker-024] http://cachesrv.internal:8081 "HEAD /ac/76635462767a6f63317935666f6e6e4852477457516700000000000000000001 HTTP/1.1" 200 0 2024-11-19 12:29:58,937 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-021] Bazel-remote Probing 2vuoGKxpYKfi9H95K457MA => True 2024-11-19 12:29:58,937 DEBUG (yalibrary.runner.tasks.result) [Worker-002] ResultsNodeTask for Ol7qKHQsP04spFtJThb3AA created (provider=None) 2024-11-19 12:29:58,937 DEBUG (exts.http_client) [Worker-008] Downloading https://devtools-registry.s3.yandex.net/7458630270 to /home/runner/.ya/tools/v4/7458630270/resource.12u5glam.ks3qmntx.part, expect md5- 2024-11-19 12:29:58,937 DEBUG (urllib3.connectionpool) [Worker-014] http://cachesrv.internal:8081 "GET /ac/614b7a47786c7957616a79696f374a545a387a63667700000000000000000001 HTTP/1.1" 200 566 2024-11-19 12:29:58,943 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-024] Bazel-remote Probing vcTbvzoc1y5fonnHRGtWQg => True 2024-11-19 12:29:58,944 DEBUG (yalibrary.runner.tasks.result) [Worker-002] ResultsNodeTask for TL0COPcO5bnHQyY1D1vMwA created (provider=None) 2024-11-19 12:29:58,946 DEBUG (yalibrary.runner.tasks.result) [Worker-002] ResultsNodeTask for sO61-AiIEoURiSt2B9XM8Q created (provider=None) 2024-11-19 12:29:58,946 DEBUG (urllib3.connectionpool) [Worker-021] http://cachesrv.internal:8081 "GET /ac/3276756f474b7870594b6669394839354b3435374d4100000000000000000001 HTTP/1.1" 200 570 2024-11-19 12:29:58,946 DEBUG (yalibrary.runner.tasks.result) [Worker-002] ResultsNodeTask for cOcBGj5bgfplUT9s0uLtnQ created (provider=None) 2024-11-19 12:29:58,947 DEBUG (urllib3.connectionpool) [Worker-014] http://cachesrv.internal:8081 "GET /cas/b48b46aadc84c69d2daf2135ae401548ebae767c7650356d255db5d6e73dfdd7 HTTP/1.1" 200 45 2024-11-19 12:29:58,948 DEBUG (yalibrary.runner.tasks.result) [Worker-002] ResultsNodeTask for czRWLiIxGuwgWKTX70D4-w created (provider=None) 2024-11-19 12:29:58,948 DEBUG (urllib3.connectionpool) [Worker-024] http://cachesrv.internal:8081 "GET /ac/76635462767a6f63317935666f6e6e4852477457516700000000000000000001 HTTP/1.1" 200 576 2024-11-19 12:29:58,949 DEBUG (yalibrary.toolscache) [Worker-002] AC cache attempt: (force gc 2199023255552) 2024-11-19 12:29:58,950 DEBUG (urllib3.connectionpool) [Worker-021] http://cachesrv.internal:8081 "GET /cas/8be96c789171a7f856c4083ecaa4106e6f3f76e1694c212442063022ac08b35a HTTP/1.1" 200 45 2024-11-19 12:29:58,951 DEBUG (yalibrary.toolscache) [Worker-002] Tools cache attempt: (force gc tools cache 2199023255552) 2024-11-19 12:29:58,952 DEBUG (urllib3.connectionpool) [Worker-024] http://cachesrv.internal:8081 "GET /cas/f978e50c7ff4e2ce87baa6de18a6ddc3ebe8660cc6a8665702411d948e8a9714 HTTP/1.1" 200 45 2024-11-19 12:29:58,953 DEBUG (urllib3.connectionpool) [Worker-021] http://cachesrv.internal:8081 "GET /cas/d1c6050a7ed280771f13bd85d7b7fdacec7313803cb4dff8f118ca77f9a78ebf HTTP/1.1" 200 274 2024-11-19 12:29:58,954 DEBUG (urllib3.connectionpool) [Worker-014] http://cachesrv.internal:8081 "GET /cas/a3fa2bf341630b12bd0d3ad7b7cf2f61297a6907ebec22a3ac798cc1fe0cb080 HTTP/1.1" 200 272 2024-11-19 12:29:58,956 DEBUG (urllib3.connectionpool) [Worker-024] http://cachesrv.internal:8081 "GET /cas/33d0bd2f065e52b1bcd15eeb9f0e84cf75076a1c87ce37a33fc2c34433b99826 HTTP/1.1" 200 277 2024-11-19 12:29:58,957 DEBUG (urllib3.connectionpool) [Worker-021] http://cachesrv.internal:8081 "GET /cas/f7d1ec8734e6b999138921ac1aeecaa475c71b3c3928eb98b80bf1d760c4f9d6 HTTP/1.1" 200 313 2024-11-19 12:29:58,958 DEBUG (yalibrary.toolscache) [Worker-057] AC cache attempt: (put uid 2vuoGKxpYKfi9H95K457MA) 2024-11-19 12:29:58,965 DEBUG (urllib3.connectionpool) [Worker-014] http://cachesrv.internal:8081 "GET /cas/1401716041e1f0d70ad8a721b55e0693575271b1701d886964e4bb39e62c5840 HTTP/1.1" 200 375 2024-11-19 12:29:58,966 DEBUG (yalibrary.toolscache) [Worker-014] AC cache attempt: (put uid aKzGxlyWajyio7JTZ8zcfw) 2024-11-19 12:29:58,966 DEBUG (urllib3.connectionpool) [Worker-024] http://cachesrv.internal:8081 "GET /cas/2476989c5d8666119ef3d3a99a385863a228824c24ae377dfa11aa72f2786e98 HTTP/1.1" 200 366 2024-11-19 12:29:58,967 DEBUG (yalibrary.toolscache) [Worker-024] AC cache attempt: (put uid vcTbvzoc1y5fonnHRGtWQg) 2024-11-19 12:29:59,052 DEBUG (exts.http_client) [Worker-011] Request to https://devtools-registry.s3.yandex.net/7336031045 has headers Server: nginx Date: Tue, 19 Nov 2024 12:29:59 GMT Content-Type: application/octet-stream Content-Length: 12509507 Connection: close Accept-Ranges: bytes Etag: "2e88d3d4d49302ffa7daf9d507d47587-2" Last-Modified: Thu, 24 Oct 2024 17:39:31 GMT X-Amz-Request-Id: 82da402c29d428de NEL: {"report_to": "network-errors", "max_age": 600, "success_fraction": 0.001, "failure_fraction": 0.01} Report-To: {"group": "network-errors", "max_age": 600, "endpoints": [ { "url": "https://dr.yandex.net/s3_nel?datacenter=KLG"}]} Access-Control-Allow-Origin: * X-Robots-Tag: noindex, noarchive, nofollow 2024-11-19 12:29:59,065 DEBUG (exts.http_client) [Worker-008] Request to https://devtools-registry.s3.yandex.net/7458630270 has headers Server: nginx Date: Tue, 19 Nov 2024 12:29:59 GMT Content-Type: application/octet-stream Content-Length: 411596800 Connection: close Accept-Ranges: bytes Etag: "6725536bb72acadd7519eafb09702e00-50" Last-Modified: Thu, 14 Nov 2024 13:02:29 GMT X-Amz-Request-Id: fe5558653a64c401 NEL: {"report_to": "network-errors", "max_age": 600, "success_fraction": 0.001, "failure_fraction": 0.01} Report-To: {"group": "network-errors", "max_age": 600, "endpoints": [ { "url": "https://dr.yandex.net/s3_nel?datacenter=KLG"}]} Access-Control-Allow-Origin: * X-Robots-Tag: noindex, noarchive, nofollow 2024-11-19 12:29:59,136 DEBUG (exts.http_client) [Worker-011] Downloading finished https://devtools-registry.s3.yandex.net/7336031045 to /home/runner/.ya/tools/v4/7336031045/resource.ytwzh8ho, md5=0721a973ac7d03643308fab89504be06, size=12509507, elapsed=0.200769 2024-11-19 12:29:59,136 DEBUG (yalibrary.fetcher.common) [Worker-011] extract /home/runner/.ya/tools/v4/7336031045/resource.ytwzh8ho to /home/runner/.ya/tools/v4/7336031045 dir (strip_prefix=None) 2024-11-19 12:29:59,293 DEBUG (library.python.filelock) [Worker-011] Ensuring FileLock released: /home/runner/.ya/tools/v4/7336031045.lock 2024-11-19 12:29:59,297 DEBUG (yalibrary.toolscache) [Worker-011] AC cache attempt: (get uid 867d47ad055affc99445654d98708df7) 2024-11-19 12:29:59,298 DEBUG (yalibrary.toolscache) [Worker-070] AC cache attempt: (get uid e027b80ef83f029f4dc83a88936c3a7d) 2024-11-19 12:29:59,301 DEBUG (urllib3.connectionpool) [Worker-011] http://cachesrv.internal:8081 "HEAD /ac/5fa1e6c8a67b70c6e8634cfb6d85cae2a2089e17dd01f9f3e64c46f717af6f11 HTTP/1.1" 404 0 2024-11-19 12:29:59,302 DEBUG (urllib3.connectionpool) [Worker-070] http://cachesrv.internal:8081 "HEAD /ac/9bfb06432a55860922095bc3255326c5935cf5e9b642664871cca66370c11b11 HTTP/1.1" 404 0 2024-11-19 12:29:59,302 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-011] Bazel-remote Probing 867d47ad055affc99445654d98708df7 => False 2024-11-19 12:29:59,302 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-070] Bazel-remote Probing e027b80ef83f029f4dc83a88936c3a7d => False 2024-11-19 12:29:59,303 DEBUG (root) [Worker-011] Run node BBQllYBtFlWfxu-9oI1T6w in build root /home/runner/.ya/build/build_root/66bk/000007 2024-11-19 12:29:59,303 DEBUG (root) [Worker-070] Run node kUxxyqcSl1HxWL2Qz6QzBw in build root /home/runner/.ya/build/build_root/66bk/000012 2024-11-19 12:29:59,644 DEBUG (yalibrary.toolscache) [Worker-076] AC cache attempt: (put uid kUxxyqcSl1HxWL2Qz6QzBw) 2024-11-19 12:29:59,645 DEBUG (urllib3.connectionpool) [Worker-070] http://cachesrv.internal:8081 "HEAD /ac/6b557878797163536c314878574c32517a36517a427700000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:29:59,645 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-070] Bazel-remote Probing kUxxyqcSl1HxWL2Qz6QzBw => False 2024-11-19 12:29:59,646 DEBUG (yalibrary.toolscache) [Worker-076] AC cache attempt: (put uid e027b80ef83f029f4dc83a88936c3a7d) 2024-11-19 12:29:59,646 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-070] Put ydb/docs/ru/core/docs-ru-core.docslib(kUxxyqcSl1HxWL2Qz6QzBw) to Bazel-remote 2024-11-19 12:29:59,648 DEBUG (yalibrary.runner.tasks.result) [Worker-074] Result node kUxxyqcSl1HxWL2Qz6QzBw processed successfully: True 2024-11-19 12:29:59,650 DEBUG (urllib3.connectionpool) [Worker-070] http://cachesrv.internal:8081 "PUT /cas/5d9a17e29cd8e3c79ede518d381f6aa56863626414094de2034ea263d69746bf HTTP/1.1" 200 0 2024-11-19 12:29:59,653 DEBUG (urllib3.connectionpool) [Worker-070] http://cachesrv.internal:8081 "PUT /cas/a36c8882a5ca786ff469d0937aa7970afb440805dcead78a110113925f0270bf HTTP/1.1" 200 0 2024-11-19 12:29:59,914 DEBUG (yalibrary.runner.tasks.result) [Worker-011] Result node BBQllYBtFlWfxu-9oI1T6w processed successfully: True 2024-11-19 12:29:59,915 DEBUG (yalibrary.toolscache) [Worker-089] AC cache attempt: (put uid BBQllYBtFlWfxu-9oI1T6w) 2024-11-19 12:29:59,916 DEBUG (urllib3.connectionpool) [Worker-084] http://cachesrv.internal:8081 "HEAD /ac/4242516c6c594274466c576678752d396f493154367700000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:29:59,916 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-084] Bazel-remote Probing BBQllYBtFlWfxu-9oI1T6w => False 2024-11-19 12:29:59,917 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-084] Put ydb/docs/__docs_internal.docslib.fake(BBQllYBtFlWfxu-9oI1T6w) to Bazel-remote 2024-11-19 12:29:59,917 DEBUG (yalibrary.toolscache) [Worker-089] AC cache attempt: (put uid 867d47ad055affc99445654d98708df7) 2024-11-19 12:29:59,921 DEBUG (urllib3.connectionpool) [Worker-084] http://cachesrv.internal:8081 "PUT /cas/76a9f5579099a99bc09b9693ace23881283bd830544578be7176e109d3a4b979 HTTP/1.1" 200 0 2024-11-19 12:29:59,924 DEBUG (urllib3.connectionpool) [Worker-084] http://cachesrv.internal:8081 "PUT /cas/2ca17a8fb886f11cf88f58dc448bed0918522bed174d660d4aff130361e40045 HTTP/1.1" 200 0 2024-11-19 12:29:59,967 DEBUG (urllib3.connectionpool) [Worker-070] http://cachesrv.internal:8081 "PUT /cas/63747368bf7bd57ce560beefecdce156c2fe593502364946d4c27b0b565373b3 HTTP/1.1" 200 0 2024-11-19 12:29:59,971 DEBUG (urllib3.connectionpool) [Worker-070] http://cachesrv.internal:8081 "PUT /ac/6b557878797163536c314878574c32517a36517a427700000000000000000001 HTTP/1.1" 200 0 2024-11-19 12:29:59,971 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-070] Put ydb/docs/ru/core/docs-ru-core.docslib(kUxxyqcSl1HxWL2Qz6QzBw) size=29634833 to Bazel-remote completed 2024-11-19 12:30:00,458 DEBUG (urllib3.connectionpool) [Worker-084] http://cachesrv.internal:8081 "PUT /cas/f00eef599b80e855fe6eaa5128e1c513724da51ddace63902181dc49b375d3b9 HTTP/1.1" 200 0 2024-11-19 12:30:00,461 DEBUG (urllib3.connectionpool) [Worker-084] http://cachesrv.internal:8081 "PUT /ac/4242516c6c594274466c576678752d396f493154367700000000000000000001 HTTP/1.1" 200 0 2024-11-19 12:30:00,461 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-084] Put ydb/docs/__docs_internal.docslib.fake(BBQllYBtFlWfxu-9oI1T6w) size=51589393 to Bazel-remote completed 2024-11-19 12:30:06,015 DEBUG (exts.http_client) [Worker-008] Downloading finished https://devtools-registry.s3.yandex.net/7458630270 to /home/runner/.ya/tools/v4/7458630270/resource.12u5glam, md5=ee5835f38a9b5ba7d1d91adbaec0d95c, size=411596800, elapsed=7.070632 2024-11-19 12:30:06,015 DEBUG (yalibrary.fetcher.common) [Worker-008] extract /home/runner/.ya/tools/v4/7458630270/resource.12u5glam to /home/runner/.ya/tools/v4/7458630270 dir (strip_prefix=None) 2024-11-19 12:30:06,345 DEBUG (library.python.filelock) [Worker-008] Ensuring FileLock released: /home/runner/.ya/tools/v4/7458630270.lock 2024-11-19 12:30:06,346 DEBUG (yalibrary.toolscache) [Worker-100] AC cache attempt: (get uid 5fd831b6d3e6fe8b7f2b83198212435d) 2024-11-19 12:30:06,347 DEBUG (yalibrary.toolscache) [Worker-099] AC cache attempt: (get uid b824e975a59b0d5b6def8cee6fb85064) 2024-11-19 12:30:06,347 DEBUG (yalibrary.toolscache) [Worker-008] AC cache attempt: (get uid afcaeced81dc7a9d0c0935dabde57dc9) 2024-11-19 12:30:06,347 DEBUG (yalibrary.toolscache) [Worker-101] AC cache attempt: (get uid 7eeea1e35a18eedffd73f29407d5b58f) 2024-11-19 12:30:06,350 DEBUG (urllib3.connectionpool) [Worker-100] http://cachesrv.internal:8081 "HEAD /ac/b224d53c1787b21f96610f624cf80fa2993462696cdc6f48e0cfa1aa2b2f7311 HTTP/1.1" 404 0 2024-11-19 12:30:06,350 DEBUG (urllib3.connectionpool) [Worker-008] http://cachesrv.internal:8081 "HEAD /ac/6f3dc86ddda5d5e58daf5783957dc05c6b57b821f75129fe75871b3c6724b411 HTTP/1.1" 404 0 2024-11-19 12:30:06,351 DEBUG (urllib3.connectionpool) [Worker-099] http://cachesrv.internal:8081 "HEAD /ac/7211796d9f0750660560fc640cc709229b90c4b8d88997e01b419fdf60c9a411 HTTP/1.1" 404 0 2024-11-19 12:30:06,351 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-100] Bazel-remote Probing 5fd831b6d3e6fe8b7f2b83198212435d => False 2024-11-19 12:30:06,351 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-008] Bazel-remote Probing afcaeced81dc7a9d0c0935dabde57dc9 => False 2024-11-19 12:30:06,352 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-099] Bazel-remote Probing b824e975a59b0d5b6def8cee6fb85064 => False 2024-11-19 12:30:06,353 DEBUG (urllib3.connectionpool) [Worker-101] http://cachesrv.internal:8081 "HEAD /ac/9e4b35bdc6cad32187c23fd6a41d77c6a72fda95174bc132fe20a437fa75fd11 HTTP/1.1" 404 0 2024-11-19 12:30:06,353 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-101] Bazel-remote Probing 7eeea1e35a18eedffd73f29407d5b58f => False 2024-11-19 12:30:06,355 DEBUG (root) [Worker-100] Run node sO61-AiIEoURiSt2B9XM8Q in build root /home/runner/.ya/build/build_root/66bk/000010 2024-11-19 12:30:06,356 DEBUG (root) [Worker-099] Run node PG2wp2Te8DRvveoGzu4mMg in build root /home/runner/.ya/build/build_root/66bk/000015 2024-11-19 12:30:06,386 DEBUG (root) [Worker-101] Run node czRWLiIxGuwgWKTX70D4-w in build root /home/runner/.ya/build/build_root/66bk/000017 2024-11-19 12:30:06,404 DEBUG (root) [Worker-008] Run node Ol7qKHQsP04spFtJThb3AA in build root /home/runner/.ya/build/build_root/66bk/00000a 2024-11-19 12:30:09,754 DEBUG (yalibrary.toolscache) [Worker-107] AC cache attempt: (put uid PG2wp2Te8DRvveoGzu4mMg) 2024-11-19 12:30:09,754 DEBUG (urllib3.connectionpool) [Worker-099] http://cachesrv.internal:8081 "HEAD /ac/50473277703254653844527676656f477a75346d4d6700000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:30:09,755 DEBUG (yalibrary.toolscache) [Worker-108] AC cache attempt: (get uid 66950b7daa7fd7e70c7110ad6c84565a) 2024-11-19 12:30:09,755 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-099] Bazel-remote Probing PG2wp2Te8DRvveoGzu4mMg => False 2024-11-19 12:30:09,756 DEBUG (yalibrary.toolscache) [Worker-107] AC cache attempt: (put uid b824e975a59b0d5b6def8cee6fb85064) 2024-11-19 12:30:09,757 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-099] Put ydb/yql_docs/tests/build/rtmr/preprocessed.tar.gz(PG2wp2Te8DRvveoGzu4mMg) to Bazel-remote 2024-11-19 12:30:09,757 DEBUG (urllib3.connectionpool) [Worker-108] http://cachesrv.internal:8081 "HEAD /ac/3a3730b1ceb8b6aa6e20f4583f79e6903bca97cbe2d4377d3520752f70c3bb11 HTTP/1.1" 404 0 2024-11-19 12:30:09,758 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-108] Bazel-remote Probing 66950b7daa7fd7e70c7110ad6c84565a => False 2024-11-19 12:30:09,759 DEBUG (yalibrary.runner.tasks.result) [Worker-106] Result node PG2wp2Te8DRvveoGzu4mMg processed successfully: True 2024-11-19 12:30:09,759 DEBUG (root) [Worker-108] Run node 1btNeahkg6LbkOv8wCca7Q in build root /home/runner/.ya/build/build_root/66bk/00000f 2024-11-19 12:30:09,762 DEBUG (urllib3.connectionpool) [Worker-099] http://cachesrv.internal:8081 "PUT /cas/467a6f15971882cb9fa6d9ae80711d055842b8fbd0a29b36c341449666057ff5 HTTP/1.1" 200 0 2024-11-19 12:30:09,765 DEBUG (urllib3.connectionpool) [Worker-099] http://cachesrv.internal:8081 "PUT /cas/7bf577dc18d62f28e5fdad05dadc65d0d09fd5abd11b8a45a9f084841e1c4442 HTTP/1.1" 200 0 2024-11-19 12:30:09,780 DEBUG (urllib3.connectionpool) [Worker-099] http://cachesrv.internal:8081 "PUT /cas/62c38e06716a2ad9f352cf1edd050431f15a3860483053f0cbbc5d247f1fd6f0 HTTP/1.1" 200 0 2024-11-19 12:30:09,783 DEBUG (urllib3.connectionpool) [Worker-099] http://cachesrv.internal:8081 "PUT /ac/50473277703254653844527676656f477a75346d4d6700000000000000000001 HTTP/1.1" 200 0 2024-11-19 12:30:09,783 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-099] Put ydb/yql_docs/tests/build/rtmr/preprocessed.tar.gz(PG2wp2Te8DRvveoGzu4mMg) size=1092285 to Bazel-remote completed 2024-11-19 12:30:09,873 DEBUG (yalibrary.toolscache) [Worker-122] AC cache attempt: (get uid 9fef2f769359d33d6604d0942f512116) 2024-11-19 12:30:09,873 DEBUG (yalibrary.toolscache) [Worker-124] AC cache attempt: (put uid sO61-AiIEoURiSt2B9XM8Q) 2024-11-19 12:30:09,873 DEBUG (urllib3.connectionpool) [Worker-118] http://cachesrv.internal:8081 "HEAD /ac/734f36312d416949456f5552695374324239584d385100000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:30:09,874 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-118] Bazel-remote Probing sO61-AiIEoURiSt2B9XM8Q => False 2024-11-19 12:30:09,875 DEBUG (yalibrary.toolscache) [Worker-124] AC cache attempt: (put uid 5fd831b6d3e6fe8b7f2b83198212435d) 2024-11-19 12:30:09,875 DEBUG (urllib3.connectionpool) [Worker-122] http://cachesrv.internal:8081 "HEAD /ac/5de4ebd3e7b8b32ecdd66bddbc9df7ab75ae8a3cb8e12830326f64015c6ef111 HTTP/1.1" 404 0 2024-11-19 12:30:09,876 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-118] Put ydb/yql_docs/tests/build/yt/preprocessed.tar.gz(sO61-AiIEoURiSt2B9XM8Q) to Bazel-remote 2024-11-19 12:30:09,876 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-122] Bazel-remote Probing 9fef2f769359d33d6604d0942f512116 => False 2024-11-19 12:30:09,878 DEBUG (yalibrary.runner.tasks.result) [Worker-119] Result node sO61-AiIEoURiSt2B9XM8Q processed successfully: True 2024-11-19 12:30:09,879 DEBUG (root) [Worker-122] Run node TL0COPcO5bnHQyY1D1vMwA in build root /home/runner/.ya/build/build_root/66bk/000014 2024-11-19 12:30:09,880 DEBUG (urllib3.connectionpool) [Worker-118] http://cachesrv.internal:8081 "PUT /cas/a04fa37ff3747fa898646bbf02b8ab283825a72e867f19c940c38d67c71440fa HTTP/1.1" 200 0 2024-11-19 12:30:09,884 DEBUG (urllib3.connectionpool) [Worker-118] http://cachesrv.internal:8081 "PUT /cas/c96e66cf3700ce8dacdda90fce04d6bb9e6dd756f905666a89d0b531859fa93f HTTP/1.1" 200 0 2024-11-19 12:30:09,898 DEBUG (urllib3.connectionpool) [Worker-118] http://cachesrv.internal:8081 "PUT /cas/f388ecda348d2f69b0913477400d3b5b9df4a572b4faef4c0dd53350685faea6 HTTP/1.1" 200 0 2024-11-19 12:30:09,900 DEBUG (urllib3.connectionpool) [Worker-118] http://cachesrv.internal:8081 "PUT /ac/734f36312d416949456f5552695374324239584d385100000000000000000001 HTTP/1.1" 200 0 2024-11-19 12:30:09,900 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-118] Put ydb/yql_docs/tests/build/yt/preprocessed.tar.gz(sO61-AiIEoURiSt2B9XM8Q) size=1092281 to Bazel-remote completed 2024-11-19 12:30:10,018 DEBUG (yalibrary.toolscache) [Worker-136] AC cache attempt: (put uid czRWLiIxGuwgWKTX70D4-w) 2024-11-19 12:30:10,019 DEBUG (yalibrary.toolscache) [Worker-137] AC cache attempt: (get uid 0854d946c946c535516875cbf5d57f31) 2024-11-19 12:30:10,019 DEBUG (urllib3.connectionpool) [Worker-101] http://cachesrv.internal:8081 "HEAD /ac/637a52574c69497847757767574b5458373044342d7700000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:30:10,020 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-101] Bazel-remote Probing czRWLiIxGuwgWKTX70D4-w => False 2024-11-19 12:30:10,020 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-101] Put ydb/yql_docs/tests/build/default/preprocessed.tar.gz(czRWLiIxGuwgWKTX70D4-w) to Bazel-remote 2024-11-19 12:30:10,021 DEBUG (yalibrary.toolscache) [Worker-136] AC cache attempt: (put uid 7eeea1e35a18eedffd73f29407d5b58f) 2024-11-19 12:30:10,022 DEBUG (urllib3.connectionpool) [Worker-137] http://cachesrv.internal:8081 "HEAD /ac/41f5091f84338cfa1d4c65d7f49923e05ba2052733fcf6714dee9d76a36c0e11 HTTP/1.1" 404 0 2024-11-19 12:30:10,022 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-137] Bazel-remote Probing 0854d946c946c535516875cbf5d57f31 => False 2024-11-19 12:30:10,023 DEBUG (yalibrary.runner.tasks.result) [Worker-135] Result node czRWLiIxGuwgWKTX70D4-w processed successfully: True 2024-11-19 12:30:10,023 DEBUG (root) [Worker-137] Run node cOcBGj5bgfplUT9s0uLtnQ in build root /home/runner/.ya/build/build_root/66bk/000019 2024-11-19 12:30:10,025 DEBUG (urllib3.connectionpool) [Worker-101] http://cachesrv.internal:8081 "PUT /cas/33019164266369c30d04ee74cc1ef9c1abf8ac442528f8f1d061ebb3da132917 HTTP/1.1" 200 0 2024-11-19 12:30:10,029 DEBUG (urllib3.connectionpool) [Worker-101] http://cachesrv.internal:8081 "PUT /cas/f0215916fb22f93d195ec1037026a27e4bd610f9b2eb9d02f2a172257072ba81 HTTP/1.1" 200 0 2024-11-19 12:30:10,047 DEBUG (urllib3.connectionpool) [Worker-101] http://cachesrv.internal:8081 "PUT /cas/f056738fcf629c985f9d99ead9f6931632ef5e8481303d55d0c69cd7a18d6790 HTTP/1.1" 200 0 2024-11-19 12:30:10,050 DEBUG (urllib3.connectionpool) [Worker-101] http://cachesrv.internal:8081 "PUT /ac/637a52574c69497847757767574b5458373044342d7700000000000000000001 HTTP/1.1" 200 0 2024-11-19 12:30:10,051 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-101] Put ydb/yql_docs/tests/build/default/preprocessed.tar.gz(czRWLiIxGuwgWKTX70D4-w) size=1092256 to Bazel-remote completed 2024-11-19 12:30:14,818 DEBUG (yalibrary.toolscache) [Worker-012] AC cache attempt: (put uid 1btNeahkg6LbkOv8wCca7Q) 2024-11-19 12:30:14,818 DEBUG (yalibrary.runner.tasks.result) [Worker-017] Result node 1btNeahkg6LbkOv8wCca7Q processed successfully: True 2024-11-19 12:30:14,820 DEBUG (yalibrary.toolscache) [Worker-012] AC cache attempt: (put uid 66950b7daa7fd7e70c7110ad6c84565a) 2024-11-19 12:30:14,822 DEBUG (urllib3.connectionpool) [Worker-108] http://cachesrv.internal:8081 "HEAD /ac/3162744e6561686b67364c626b4f763877436361375100000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:30:14,822 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-108] Bazel-remote Probing 1btNeahkg6LbkOv8wCca7Q => False 2024-11-19 12:30:14,822 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-108] Put ydb/yql_docs/tests/build/rtmr/tests-build-rtmr.tar.gz(1btNeahkg6LbkOv8wCca7Q) to Bazel-remote 2024-11-19 12:30:14,826 DEBUG (urllib3.connectionpool) [Worker-108] http://cachesrv.internal:8081 "PUT /cas/0ad5bc45215b7cb8e6a45b854555698e516bb36c20ad49ae89e86016bfd60ec2 HTTP/1.1" 200 0 2024-11-19 12:30:14,830 DEBUG (urllib3.connectionpool) [Worker-108] http://cachesrv.internal:8081 "PUT /cas/6cfa7a2201d6bc7fc99d8b7ca05c13db97a0c6e3df6ed4c1f943a9ed1bf6dd5f HTTP/1.1" 200 0 2024-11-19 12:30:14,866 DEBUG (urllib3.connectionpool) [Worker-108] http://cachesrv.internal:8081 "PUT /cas/86b75034be6e112abe305b086017f0a95ec9f0a71be2bdcd6afdc5098562c773 HTTP/1.1" 200 0 2024-11-19 12:30:14,875 DEBUG (urllib3.connectionpool) [Worker-108] http://cachesrv.internal:8081 "PUT /ac/3162744e6561686b67364c626b4f763877436361375100000000000000000001 HTTP/1.1" 200 0 2024-11-19 12:30:14,875 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-108] Put ydb/yql_docs/tests/build/rtmr/tests-build-rtmr.tar.gz(1btNeahkg6LbkOv8wCca7Q) size=2779895 to Bazel-remote completed 2024-11-19 12:30:15,016 DEBUG (yalibrary.toolscache) [Worker-007] AC cache attempt: (put uid TL0COPcO5bnHQyY1D1vMwA) 2024-11-19 12:30:15,017 DEBUG (yalibrary.runner.tasks.result) [Worker-030] Result node TL0COPcO5bnHQyY1D1vMwA processed successfully: True 2024-11-19 12:30:15,017 DEBUG (yalibrary.toolscache) [Worker-007] AC cache attempt: (put uid 9fef2f769359d33d6604d0942f512116) 2024-11-19 12:30:15,018 DEBUG (urllib3.connectionpool) [Worker-122] http://cachesrv.internal:8081 "HEAD /ac/544c30434f50634f35626e48517959314431764d774100000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:30:15,018 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-122] Bazel-remote Probing TL0COPcO5bnHQyY1D1vMwA => False 2024-11-19 12:30:15,018 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-122] Put ydb/yql_docs/tests/build/yt/tests-build-yt.tar.gz(TL0COPcO5bnHQyY1D1vMwA) to Bazel-remote 2024-11-19 12:30:15,023 DEBUG (urllib3.connectionpool) [Worker-122] http://cachesrv.internal:8081 "PUT /cas/76315534a31f425a033c8af18b8bcb28f7e92030c244ce763d6980a4016078e0 HTTP/1.1" 200 0 2024-11-19 12:30:15,033 DEBUG (urllib3.connectionpool) [Worker-122] http://cachesrv.internal:8081 "PUT /cas/472cf5db79922b5b891f8facb81e709304d2d80aae7035e0fee48e64a4a11df1 HTTP/1.1" 200 0 2024-11-19 12:30:15,066 DEBUG (urllib3.connectionpool) [Worker-122] http://cachesrv.internal:8081 "PUT /cas/024391e05016a83242957a2e1c710ce741e0a63c956eaeb4ef18c4cbf5a2a19a HTTP/1.1" 200 0 2024-11-19 12:30:15,070 DEBUG (urllib3.connectionpool) [Worker-122] http://cachesrv.internal:8081 "PUT /ac/544c30434f50634f35626e48517959314431764d774100000000000000000001 HTTP/1.1" 200 0 2024-11-19 12:30:15,070 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-122] Put ydb/yql_docs/tests/build/yt/tests-build-yt.tar.gz(TL0COPcO5bnHQyY1D1vMwA) size=2779897 to Bazel-remote completed 2024-11-19 12:30:15,156 DEBUG (yalibrary.toolscache) [Worker-039] AC cache attempt: (put uid cOcBGj5bgfplUT9s0uLtnQ) 2024-11-19 12:30:15,157 DEBUG (yalibrary.runner.tasks.result) [Worker-036] Result node cOcBGj5bgfplUT9s0uLtnQ processed successfully: True 2024-11-19 12:30:15,157 DEBUG (yalibrary.toolscache) [Worker-039] AC cache attempt: (put uid 0854d946c946c535516875cbf5d57f31) 2024-11-19 12:30:15,159 DEBUG (urllib3.connectionpool) [Worker-137] http://cachesrv.internal:8081 "HEAD /ac/634f6342476a35626766706c5554397330754c746e5100000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:30:15,159 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-137] Bazel-remote Probing cOcBGj5bgfplUT9s0uLtnQ => False 2024-11-19 12:30:15,160 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-137] Put ydb/yql_docs/tests/build/default/tests-build-default.tar.gz(cOcBGj5bgfplUT9s0uLtnQ) to Bazel-remote 2024-11-19 12:30:15,164 DEBUG (urllib3.connectionpool) [Worker-137] http://cachesrv.internal:8081 "PUT /cas/e52eed581d1dd053e89d8bf22b19daddb3cd7684816e8cd1c04befe5d19e40b0 HTTP/1.1" 200 0 2024-11-19 12:30:15,168 DEBUG (urllib3.connectionpool) [Worker-137] http://cachesrv.internal:8081 "PUT /cas/9113f21786bf28d959fea8606dbfe68ab59947b5449fb9f8900890809f321a60 HTTP/1.1" 200 0 2024-11-19 12:30:15,197 DEBUG (urllib3.connectionpool) [Worker-137] http://cachesrv.internal:8081 "PUT /cas/bc9069b2ed8cdaa194779bb9bdf0e8863f7d5452f92a7e080f450f2c76bed806 HTTP/1.1" 200 0 2024-11-19 12:30:15,209 DEBUG (urllib3.connectionpool) [Worker-137] http://cachesrv.internal:8081 "PUT /ac/634f6342476a35626766706c5554397330754c746e5100000000000000000001 HTTP/1.1" 200 0 2024-11-19 12:30:15,209 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-137] Put ydb/yql_docs/tests/build/default/tests-build-default.tar.gz(cOcBGj5bgfplUT9s0uLtnQ) size=2779913 to Bazel-remote completed 2024-11-19 12:30:25,582 DEBUG (yalibrary.toolscache) [Worker-052] AC cache attempt: (put uid Ol7qKHQsP04spFtJThb3AA) 2024-11-19 12:30:25,583 DEBUG (yalibrary.toolscache) [Worker-049] AC cache attempt: (get uid 2b694bfd2563a8f6eb90ddb4c83dca62) 2024-11-19 12:30:25,584 DEBUG (yalibrary.runner.tasks.result) [Worker-008] Result node Ol7qKHQsP04spFtJThb3AA processed successfully: True 2024-11-19 12:30:25,585 DEBUG (yalibrary.toolscache) [Worker-052] AC cache attempt: (put uid afcaeced81dc7a9d0c0935dabde57dc9) 2024-11-19 12:30:25,588 DEBUG (urllib3.connectionpool) [Worker-049] http://cachesrv.internal:8081 "HEAD /ac/d00f95c37d9dc1810ea9dad5d85ddd354cbe3d1c7017a0940d61a1aa11fa1511 HTTP/1.1" 404 0 2024-11-19 12:30:25,589 DEBUG (urllib3.connectionpool) [Worker-050] http://cachesrv.internal:8081 "HEAD /ac/4f6c37714b485173503034737046744a54686233414100000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:30:25,589 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-049] Bazel-remote Probing 2b694bfd2563a8f6eb90ddb4c83dca62 => False 2024-11-19 12:30:25,589 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-050] Bazel-remote Probing Ol7qKHQsP04spFtJThb3AA => False 2024-11-19 12:30:25,590 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-050] Put ydb/docs/preprocessed.tar.gz(Ol7qKHQsP04spFtJThb3AA) to Bazel-remote 2024-11-19 12:30:25,591 DEBUG (root) [Worker-049] Run node NLf5ulXt3SyZEVmwmFHBAg in build root /home/runner/.ya/build/build_root/66bk/000011 2024-11-19 12:30:25,596 DEBUG (urllib3.connectionpool) [Worker-050] http://cachesrv.internal:8081 "PUT /cas/2083cf2614ed18ee94fd24e086cb4faf27c6015a3725192ccb567c32acfdc4c1 HTTP/1.1" 200 0 2024-11-19 12:30:25,600 DEBUG (urllib3.connectionpool) [Worker-050] http://cachesrv.internal:8081 "PUT /cas/6a2f87c72c3c3353799b4934d75bc23bc34dc2eb13109ae5949edfd82c255822 HTTP/1.1" 200 0 2024-11-19 12:30:25,900 DEBUG (urllib3.connectionpool) [Worker-050] http://cachesrv.internal:8081 "PUT /cas/912d971a91fcfb44c5a800a356a862e7adac0ec7f6ee35c783702c5a773d1b9a HTTP/1.1" 200 0 2024-11-19 12:30:25,903 DEBUG (urllib3.connectionpool) [Worker-050] http://cachesrv.internal:8081 "PUT /ac/4f6c37714b485173503034737046744a54686233414100000000000000000001 HTTP/1.1" 200 0 2024-11-19 12:30:25,903 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-050] Put ydb/docs/preprocessed.tar.gz(Ol7qKHQsP04spFtJThb3AA) size=36209199 to Bazel-remote completed 2024-11-19 12:31:09,408 DEBUG (yalibrary.toolscache) [Worker-063] AC cache attempt: (put uid NLf5ulXt3SyZEVmwmFHBAg) 2024-11-19 12:31:09,408 DEBUG (urllib3.connectionpool) [Worker-061] http://cachesrv.internal:8081 "HEAD /ac/4e4c6635756c58743353795a45566d776d464842416700000000000000000001 HTTP/1.1" 404 0 2024-11-19 12:31:09,409 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-061] Bazel-remote Probing NLf5ulXt3SyZEVmwmFHBAg => False 2024-11-19 12:31:09,409 DEBUG (yalibrary.toolscache) [Worker-063] AC cache attempt: (put uid 2b694bfd2563a8f6eb90ddb4c83dca62) 2024-11-19 12:31:09,409 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-061] Put ydb/docs/ydb-docs.tar.gz(NLf5ulXt3SyZEVmwmFHBAg) to Bazel-remote 2024-11-19 12:31:09,410 DEBUG (yalibrary.runner.tasks.result) [Worker-049] Result node NLf5ulXt3SyZEVmwmFHBAg processed successfully: True 2024-11-19 12:31:09,413 DEBUG (urllib3.connectionpool) [Worker-061] http://cachesrv.internal:8081 "PUT /cas/eccd54b88782934cf263ae06f1a91c52e61c5483d324d2afe9aba7d6b442e5c9 HTTP/1.1" 200 0 2024-11-19 12:31:09,427 DEBUG (urllib3.connectionpool) [Worker-061] http://cachesrv.internal:8081 "PUT /cas/1013c431fdf0ef84dd01c64b453fdfcc7bf480cf2b2d6b037447b4ac7a2d1235 HTTP/1.1" 200 0 2024-11-19 12:31:09,731 DEBUG (urllib3.connectionpool) [Worker-061] http://cachesrv.internal:8081 "PUT /cas/a2afcef8b2784184735e7a19ed01056f98ce9024f08ce8decc4d9ee38f7a36eb HTTP/1.1" 200 0 2024-11-19 12:31:09,734 DEBUG (urllib3.connectionpool) [Worker-061] http://cachesrv.internal:8081 "PUT /ac/4e4c6635756c58743353795a45566d776d464842416700000000000000000001 HTTP/1.1" 200 0 2024-11-19 12:31:09,735 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-061] Put ydb/docs/ydb-docs.tar.gz(NLf5ulXt3SyZEVmwmFHBAg) size=39680543 to Bazel-remote completed 2024-11-19 12:31:09,800 DEBUG (yalibrary.runner.build_root) [Worker-069] Build root /home/runner/.ya/build/build_root/66bk created=25 left=12 2024-11-19 12:31:09,800 DEBUG (library.python.filelock) [MainThread] Ensuring FileLock released: /home/runner/.ya/build/build_root/66bk/STAMP 2024-11-19 12:31:09,810 DEBUG (yalibrary.runner.runner3) [MainThread] Task Run(PG2wp2Te8DRvveoGzu4mMg$(BUILD_ROOT)/ydb/yql_docs/tests/build/rtmr/preprocessed.tar.gz) has stderr: Using v4.44.1 version COPY Copying file toc.yaml COPY Copying file ya.make COPY Copying file ydb/docs/ru/core/_assets/embedded_query.png COPY Copying file ydb/d ... md WARN Variable backend_name not found in /builtins/_includes/aggregation/max_min_by.md WARN Variable ydb-short-name not found in /udf/list/_includes/topg.md 2024-11-19 12:31:09,810 DEBUG (yalibrary.runner.runner3) [MainThread] Task Run(sO61-AiIEoURiSt2B9XM8Q$(BUILD_ROOT)/ydb/yql_docs/tests/build/yt/preprocessed.tar.gz) has stderr: Using v4.44.1 version COPY Copying file index.md COPY Copying file toc.yaml COPY Copying file ya.make COPY Copying file ydb/docs/ru/core/_assets/embedded_query. ... md WARN Variable backend_name not found in /builtins/_includes/aggregation/max_min_by.md WARN Variable ydb-short-name not found in /udf/list/_includes/topg.md 2024-11-19 12:31:09,810 DEBUG (yalibrary.runner.runner3) [MainThread] Task Run(czRWLiIxGuwgWKTX70D4-w$(BUILD_ROOT)/ydb/yql_docs/tests/build/default/preprocessed.tar.gz) has stderr: Using v4.44.1 version COPY Copying file index.md COPY Copying file toc.yaml COPY Copying file ya.make COPY Copying file ydb/docs/ru/core/_assets/embedded_query. ... md WARN Variable backend_name not found in /builtins/_includes/aggregation/max_min_by.md WARN Variable ydb-short-name not found in /udf/list/_includes/topg.md 2024-11-19 12:31:09,810 DEBUG (yalibrary.runner.runner3) [MainThread] Task Run(1btNeahkg6LbkOv8wCca7Q$(BUILD_ROOT)/ydb/yql_docs/tests/build/rtmr/tests-build-rtmr.tar.gz) has stderr: Using v4.44.1 version COPY Copying file _assets/KaTeX_AMS-Regular-CYEKBG2K.woff COPY Copying file _assets/KaTeX_AMS-Regular-JKX5W2C4.ttf COPY Copying file _asse ... : 100; Actual: 125] [Context: "Unicode::SplitToList( string:Utf8?, separator:Utf8, [ DelimeterString:Bool?, SkipEmpty:Bool?, Limit:Uint64? ]) -> List"] 2024-11-19 12:31:09,810 DEBUG (yalibrary.runner.runner3) [MainThread] Task Run(TL0COPcO5bnHQyY1D1vMwA$(BUILD_ROOT)/ydb/yql_docs/tests/build/yt/tests-build-yt.tar.gz) has stderr: Using v4.44.1 version COPY Copying file _assets/KaTeX_AMS-Regular-CYEKBG2K.woff COPY Copying file _assets/KaTeX_AMS-Regular-JKX5W2C4.ttf COPY Copying file _asse ... : 100; Actual: 125] [Context: "Unicode::SplitToList( string:Utf8?, separator:Utf8, [ DelimeterString:Bool?, SkipEmpty:Bool?, Limit:Uint64? ]) -> List"] 2024-11-19 12:31:09,810 DEBUG (yalibrary.runner.runner3) [MainThread] Task Run(cOcBGj5bgfplUT9s0uLtnQ$(BUILD_ROOT)/ydb/yql_docs/tests/build/default/tests-build-default.tar.gz) has stderr: Using v4.44.1 version COPY Copying file _assets/KaTeX_AMS-Regular-CYEKBG2K.woff COPY Copying file _assets/KaTeX_AMS-Regular-JKX5W2C4.ttf COPY Copying file _asse ... : 100; Actual: 125] [Context: "Unicode::SplitToList( string:Utf8?, separator:Utf8, [ DelimeterString:Bool?, SkipEmpty:Bool?, Limit:Uint64? ]) -> List"] 2024-11-19 12:31:09,810 DEBUG (yalibrary.runner.runner3) [MainThread] Task Run(Ol7qKHQsP04spFtJThb3AA$(BUILD_ROOT)/ydb/docs/preprocessed.tar.gz) has stderr: Using v4.44.1 version COPY Copying file _assets/gtm.js COPY Copying file _assets/logo.svg COPY Copying file _assets/tags.css COPY Copying file _assets/ydb-promo ... d: ru/changelog-server.md INFO Processing finished: ru/changelog-cli.md INFO Processing finished: ru/security-changelog.md COPY Copying file _assets/tags.css 2024-11-19 12:31:09,811 DEBUG (yalibrary.runner.runner3) [MainThread] Task Run(NLf5ulXt3SyZEVmwmFHBAg$(BUILD_ROOT)/ydb/docs/ydb-docs.tar.gz) has stderr: Using v4.44.1 version COPY Copying file _assets/KaTeX_AMS-Regular-CYEKBG2K.woff COPY Copying file _assets/KaTeX_AMS-Regular-JKX5W2C4.ttf COPY Copying file _asse ... opying file search/langs/tr.js COPY Copying file search/langs/vi.js COPY Copying file vendor.css COPY Copying file vendor.js COPY Copying file vendor.rtl.css 2024-11-19 12:31:09,811 DEBUG (yalibrary.runner.runner3) [MainThread] Merged exit code: 0 2024-11-19 12:31:09,811 DEBUG (yalibrary.runner.runner3) [MainThread] Profile of graph execution {"by_type":{"clean_symres":{"sum":0.004347562789917,"qty":1},"prepare_all_nodes":{"sum":0.051389217376709,"qty":1},"compact_cache":{"sum":0.002937316894531,"qty":1},"restore_from_dist_cache[DO]":{"sum":0.241063356399536,"qty":13},"prepare[DO]":{"sum":0.004788398742676,"qty":3},"put_in_cache[DO]":{"sum":0.039950847625732,"qty":13},"pattern[YMAKE_PYTHON3-4256832079]":{"sum":0.381491184234619,"qty":1},"DO":{"sum":89.969374656677246,"qty":10},"write_through_caches[DO]":{"sum":0.038637638092041,"qty":10},"result[DO]":{"sum":0.032687187194824,"qty":10},"put_in_dist_cache[DO]":{"sum":1.984748363494873,"qty":10},"pattern[YFM_TOOL-2315971726]":{"sum":7.431673765182495,"qty":1},"clean_build_root":{"sum":0.000228643417358,"qty":1}},"all":{"qty":75,"sum":100.183318138122559},"critical_path":[{"name":"Pattern(YFM_TOOL-2315971726)","timing":[1732019398.914118051528931,1732019406.345791816711426],"type":"pattern[YFM_TOOL-2315971726]"}],"wall_time":70.91298246383667,"build_type":"release","flags":{"OPENSOURCE":"yes","USE_PREBUILT_TOOLS":"no","APPLE_SDK_LOCAL":"yes","USE_CLANG_CL":"yes","USE_AIO":"static","USE_ICONV":"static","USE_IDN":"static","CFLAGS":"-fno-omit-frame-pointer","USE_EAT_MY_DATA":"yes","DEBUGINFO_LINES_ONLY":"yes","CONSISTENT_DEBUG":"yes","TESTS_REQUESTED":"yes","DISABLE_FLAKE8_MIGRATIONS":"yes"},"rel_targets":["."],"threads":64} 2024-11-19 12:31:09,811 DEBUG (yalibrary.runner.runner3) [MainThread] Average compression ratio: 1.00 2024-11-19 12:31:09,811 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=dispatch_build, group=ya_make, time=1732019469.8115814 2024-11-19 12:31:09,811 DEBUG (core.stages_profiler) [MainThread] Set stage dispatch_build_finished=1732019469.8115814 2024-11-19 12:31:09,811 DEBUG (core.profiler) [MainThread] Profile step dispatch_build_finished - 1732019469.8115814 2024-11-19 12:31:09,811 DEBUG (core.stage_tracer) [MainThread] Start stage tag=cache_test_statuses, group=ya_make, time=1732019469.8119419 2024-11-19 12:31:09,812 DEBUG (core.stages_profiler) [MainThread] Set stage cache_test_statuses_started=1732019469.8119419 2024-11-19 12:31:09,812 DEBUG (core.profiler) [MainThread] Profile step cache_test_statuses_started - 1732019469.8119419 2024-11-19 12:31:09,826 DEBUG (yalibrary.store.new_store) [MainThread] Initialized store in /home/runner/.ya/build/cache/trc 2024-11-19 12:31:09,826 DEBUG (yalibrary.store.new_store) [MainThread] Started filtering 2024-11-19 12:31:09,826 DEBUG (library.python.filelock) [MainThread] Acquiring FileLock (blocking=True): /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-19 12:31:09,826 DEBUG (library.python.filelock) [MainThread] Ensuring FileLock released: /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-19 12:31:09,826 DEBUG (yalibrary.store.new_store) [MainThread] Done filtering, retain 0 uids, 0 files 2024-11-19 12:31:09,826 DEBUG (yalibrary.store.new_store) [MainThread] Cleaning size store 2024-11-19 12:31:09,826 DEBUG (yalibrary.store.new_store) [MainThread] Cleaning file store 2024-11-19 12:31:09,828 DEBUG (yalibrary.store.new_store) [MainThread] Cleaning uid store 2024-11-19 12:31:09,837 DEBUG (library.python.filelock) [MainThread] Acquiring FileLock (blocking=True): /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-19 12:31:09,837 DEBUG (library.python.filelock) [MainThread] Ensuring FileLock released: /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-19 12:31:09,839 DEBUG (library.python.filelock) [MainThread] Acquiring FileLock (blocking=True): /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-19 12:31:09,839 DEBUG (library.python.filelock) [MainThread] Ensuring FileLock released: /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-19 12:31:09,839 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=cache_test_statuses, group=ya_make, time=1732019469.8392615 2024-11-19 12:31:09,839 DEBUG (core.stages_profiler) [MainThread] Set stage cache_test_statuses_finished=1732019469.8392615 2024-11-19 12:31:09,839 DEBUG (core.profiler) [MainThread] Profile step cache_test_statuses_finished - 1732019469.8392615 2024-11-19 12:31:09,839 DEBUG (yalibrary.toolscache) [MainThread] Tools cache attempt: (request for tc stats) 2024-11-19 12:31:09,840 DEBUG (yalibrary.toolscache) [MainThread] tc stats: TotalKnownSize: 39870464 NonComputedCount: 2 2024-11-19 12:31:09,840 DEBUG (yalibrary.toolscache) [MainThread] AC cache attempt: (request for ac stats) 2024-11-19 12:31:09,840 DEBUG (yalibrary.toolscache) [MainThread] ac stats: TotalFSSize: 168861696 TotalSize: 168761215 2024-11-19 12:31:09,840 DEBUG (core.stage_tracer) [MainThread] Start stage tag=statistics, group=statistics, time=1732019469.840902 2024-11-19 12:31:09,840 DEBUG (core.stages_profiler) [MainThread] Set stage statistics_started=1732019469.840902 2024-11-19 12:31:09,841 DEBUG (core.profiler) [MainThread] Profile step statistics_started - 1732019469.840902 2024-11-19 12:31:09,841 DEBUG (build.stat.graph) [MainThread] Node count in the dependency graph is 63. 2024-11-19 12:31:09,841 DEBUG (build.stat.graph) [MainThread] Dependency count in the graph is 11. 2024-11-19 12:31:09,841 DEBUG (build.stat.statistics) [MainThread] Run tasks 13: 13 cached tasks (0 cache(s) resolved by dynamic uids), 10 not cached, 0 failed 2024-11-19 12:31:09,841 DEBUG (build.stat.statistics) [MainThread] Not cached 10: 0 tests, 10 not tests 2024-11-19 12:31:09,841 DEBUG (core.profiler) [MainThread] Profile value statistics_cache_hit - 56.52173913043478 2024-11-19 12:31:09,841 DEBUG (core.profiler) [MainThread] Profile value statistics_run_tasks - 13 2024-11-19 12:31:09,842 DEBUG (core.profiler) [MainThread] Profile value statistics_executed_tasks - 23 2024-11-19 12:31:09,842 DEBUG (core.profiler) [MainThread] Profile value statistics_cached_tasks - 13 2024-11-19 12:31:09,842 DEBUG (core.profiler) [MainThread] Profile value statistics_dyn_cached_tasks - 0 2024-11-19 12:31:09,842 DEBUG (core.profiler) [MainThread] Profile value statistics_not_cached_tasks - 10 2024-11-19 12:31:09,842 DEBUG (core.profiler) [MainThread] Profile value statistics_tests_tasks - 0 2024-11-19 12:31:09,842 DEBUG (core.profiler) [MainThread] Profile value statistics_failed_tasks - 0 2024-11-19 12:31:09,842 DEBUG (core.profiler) [MainThread] Profile value statistics_ok_tasks - 10 2024-11-19 12:31:09,842 DEBUG (core.profiler) [MainThread] Profile value statistics_avoided_tasks - -10 2024-11-19 12:31:09,842 DEBUG (core.profiler) [MainThread] Profile value critical_path - [["DO | $(BUILD_ROOT)/ydb/docs/__docs_internal.docslib.fake",599,"local"],["DO | $(BUILD_ROOT)/ydb/docs/preprocessed.tar.gz",19156,"local"],["DO | $(BUILD_ROOT)/ydb/docs/ydb-docs.tar.gz",43793,"local"]] 2024-11-19 12:31:09,842 DEBUG (core.profiler) [MainThread] Profile value statistics_total_time - 70081 2024-11-19 12:31:09,842 DEBUG (core.profiler) [MainThread] Profile value statistics_graph_time - 63548 2024-11-19 12:31:09,842 DEBUG (core.profiler) [MainThread] Profile value statistics_graph_copying_time - 0 2024-11-19 12:31:09,843 DEBUG (core.profiler) [MainThread] Profile value statistics_graph_testing_time - 0 2024-11-19 12:31:09,843 DEBUG (core.profiler) [MainThread] Profile value statistics_graph_compiling_time - 63548 2024-11-19 12:31:09,843 DEBUG (core.profiler) [MainThread] Profile value statistics_graph_source_time - 0 2024-11-19 12:31:09,843 DEBUG (core.profiler) [MainThread] Profile value statistics_graph_tests_data_time - 0 2024-11-19 12:31:09,843 DEBUG (core.profiler) [MainThread] Profile value statistics_longest_task - 43793 2024-11-19 12:31:09,844 DEBUG (core.profiler) [MainThread] Profile value statistics_failed_task_time_ratio - 0.0 2024-11-19 12:31:09,844 DEBUG (core.profiler) [MainThread] Profile value statistics_failed_task_time - 0 2024-11-19 12:31:09,844 DEBUG (core.profiler) [MainThread] Profile value statistics_tests_task_time_ratio - 0.0 2024-11-19 12:31:09,844 DEBUG (core.profiler) [MainThread] Profile value statistics_tests_task_time - 0 2024-11-19 12:31:09,844 DEBUG (core.profiler) [MainThread] Profile value statistics_run_task_time - 89724 2024-11-19 12:31:09,844 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=statistics, group=statistics, time=1732019469.8449776 2024-11-19 12:31:09,845 DEBUG (core.stages_profiler) [MainThread] Set stage statistics_finished=1732019469.8449776 2024-11-19 12:31:09,845 DEBUG (core.profiler) [MainThread] Profile step statistics_finished - 1732019469.8449776 2024-11-19 12:31:09,845 DEBUG (core.stage_tracer) [MainThread] Start stage tag=finalize-reports, group=ya_make, time=1732019469.845558 2024-11-19 12:31:09,845 DEBUG (core.stages_profiler) [MainThread] Set stage finalize-reports_started=1732019469.845558 2024-11-19 12:31:09,845 DEBUG (core.profiler) [MainThread] Profile step finalize-reports_started - 1732019469.845558 2024-11-19 12:31:09,845 DEBUG (build.ya_make) [MainThread] Build is finished, process results 2024-11-19 12:31:09,845 DEBUG (ReportGenerator) [MainThread] Build result is processed, add 3 entries 2024-11-19 12:31:09,845 DEBUG (ReportGenerator) [MainThread] Finish build report 2024-11-19 12:31:09,846 DEBUG (StoredReport) [MainThread] Finish build report 2024-11-19 12:31:09,846 DEBUG (ReportGenerator) [MainThread] Finish tests report, tests by size defaultdict(, {'small': set(), 'medium': set(), 'large': set()}), tests by type defaultdict(, {}) 2024-11-19 12:31:09,846 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2024-11-19 12:31:09,846 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2024-11-19 12:31:09,846 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2024-11-19 12:31:09,846 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2024-11-19 12:31:09,846 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2024-11-19 12:31:09,846 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2024-11-19 12:31:09,846 DEBUG (StoredReport) [MainThread] Finish tests report 2024-11-19 12:31:09,846 DEBUG (ReportGenerator) [MainThread] Finish style report 2024-11-19 12:31:09,846 DEBUG (StoredReport) [MainThread] Finish style report 2024-11-19 12:31:09,846 DEBUG (ReportGenerator) [MainThread] Finish report 2024-11-19 12:31:09,846 DEBUG (StoredReport) [MainThread] Finish report 2024-11-19 12:31:09,846 DEBUG (build.ya_make) [MainThread] Build results listener statistics: {'TestNodeListener': {'duration_sec': 8.463859558105469e-05}, 'BuildResultsListener': {'duration_sec': 0.0012645721435546875}} 2024-11-19 12:31:09,846 DEBUG (build.ya_make) [MainThread] Generating results report 2024-11-19 12:31:09,846 INFO (build.reports.build_reports) [MainThread] Dump junit report to /home/runner/actions_runner/_work/ydb/ydb/tmp/results/try_1/junit.xml 2024-11-19 12:31:09,847 DEBUG (build.reports.autocheck_report) [MainThread] Got 0 tests to report 2024-11-19 12:31:09,847 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2024-11-19 12:31:09,847 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2024-11-19 12:31:09,847 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2024-11-19 12:31:09,847 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2024-11-19 12:31:09,847 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2024-11-19 12:31:09,847 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2024-11-19 12:31:09,847 DEBUG (ReportGenerator) [MainThread] Build result is processed, add 13 entries 2024-11-19 12:31:09,847 DEBUG (build.reports.autocheck_report) [MainThread] builder.opts.report_skipped_suites: False, builder.opts.report_skipped_suites False 2024-11-19 12:31:09,848 INFO (build.reports.build_reports) [MainThread] Dump results report to /home/runner/actions_runner/_work/ydb/ydb/tmp/results/try_1/report.json 2024-11-19 12:31:09,848 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=finalize-reports, group=ya_make, time=1732019469.848215 2024-11-19 12:31:09,848 DEBUG (core.stages_profiler) [MainThread] Set stage finalize-reports_finished=1732019469.848215 2024-11-19 12:31:09,848 DEBUG (core.profiler) [MainThread] Profile step finalize-reports_finished - 1732019469.848215 2024-11-19 12:31:09,848 DEBUG (yalibrary.toolscache) [MainThread] AC cache attempt: (release all data) 2024-11-19 12:31:09,849 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=build, group=build_handler, time=1732019469.849262 2024-11-19 12:31:09,849 DEBUG (core.stages_profiler) [MainThread] Set stage build_finished=1732019469.849262 2024-11-19 12:31:09,849 DEBUG (core.profiler) [MainThread] Profile step build_finished - 1732019469.849262 2024-11-19 12:31:09,849 DEBUG (core.stage_tracer) [MainThread] Start stage tag=dump_results, group=build_handler, time=1732019469.849456 2024-11-19 12:31:09,849 DEBUG (core.stages_profiler) [MainThread] Set stage dump_results_started=1732019469.849456 2024-11-19 12:31:09,849 DEBUG (core.profiler) [MainThread] Profile step dump_results_started - 1732019469.849456 2024-11-19 12:31:09,850 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=dump_results, group=build_handler, time=1732019469.8500504 2024-11-19 12:31:09,850 DEBUG (core.stages_profiler) [MainThread] Set stage dump_results_finished=1732019469.8500504 2024-11-19 12:31:09,850 DEBUG (core.profiler) [MainThread] Profile step dump_results_finished - 1732019469.8500504 2024-11-19 12:31:09,850 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=ya_make_handler, group=build_handler, time=1732019469.8502185 2024-11-19 12:31:09,850 DEBUG (core.stages_profiler) [MainThread] Set stage ya_make_handler_finished=1732019469.8502185 2024-11-19 12:31:09,850 DEBUG (core.profiler) [MainThread] Profile step ya_make_handler_finished - 1732019469.8502185 2024-11-19 12:31:09,850 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=invoke-do_ya_make, group=overall-execution, time=1732019469.8503935 2024-11-19 12:31:09,850 DEBUG (core.stages_profiler) [MainThread] Set stage invoke-do_ya_make_finished=1732019469.8503935 2024-11-19 12:31:09,850 DEBUG (core.profiler) [MainThread] Profile step invoke-do_ya_make_finished - 1732019469.8503935 2024-11-19 12:31:09,850 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "dump_debug" stopped in 0.000087 2024-11-19 12:31:09,850 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "evlog" stopped in 0.000029 2024-11-19 12:31:09,850 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "changelist_store" stopped in 0.000002 2024-11-19 12:31:09,850 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "event_queue" stopped in 0.000003 2024-11-19 12:31:09,850 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "mlockall" stopped in 0.000003 2024-11-19 12:31:09,850 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "profile" stopped in 0.000002 2024-11-19 12:31:09,851 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "showstack" stopped in 0.000017 2024-11-19 12:31:09,851 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher" stopped in 0.000002 2024-11-19 12:31:09,851 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" stopped in 0.000002 2024-11-19 12:31:09,851 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token2" stopped in 0.000002 2024-11-19 12:31:09,851 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "docker_config_path" stopped in 0.000001 2024-11-19 12:31:09,851 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "use_universal_fetcher_everywhere" stopped in 0.000001 2024-11-19 12:31:09,851 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher_params" stopped in 0.000008 2024-11-19 12:31:09,851 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "self_info" stopped in 0.000001 2024-11-19 12:31:09,851 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" stopped in 0.000002 2024-11-19 12:31:09,851 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display_log" stopped in 0.000004 2024-11-19 12:31:09,851 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "custom_file_log" stopped in 0.000008 2024-11-19 12:31:09,851 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display" stopped in 0.000013 2024-11-19 12:31:09,851 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "state" stopped in 0.000007 2024-11-19 12:31:09,851 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token" stopped in 0.000001 2024-11-19 12:31:09,851 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "params" stopped in 0.000001 2024-11-19 12:31:09,851 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Restored ctx dict_keys(['uid', 'file_log', 'display_in_memory_log', 'file_in_memory_log', 'revision', 'vcs_type', 'report', 'exit', 'lifecycle_ts', 'env_checker', 'fetchers_storage', 'tmp_dir']) 2024-11-19 12:31:09,851 DEBUG (library.python.tmp) [MainThread] Removing tmp dir /home/runner/.ya/tmp/1732019397.3025.c6ogw00k 2024-11-19 12:31:09,852 DEBUG (library.python.tmp) [MainThread] Reset back TMPDIR=None 2024-11-19 12:31:09,852 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "tmp_dir" stopped in 0.000599 2024-11-19 12:31:09,852 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" stopped in 0.000010 2024-11-19 12:31:09,852 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "env_checker" stopped in 0.000006 2024-11-19 12:31:09,852 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "lifecycle_ts" stopped in 0.000006 2024-11-19 12:31:09,852 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "exit" stopped in 0.000007 2024-11-19 12:31:09,853 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "report" stopped in 0.000998 2024-11-19 12:31:09,853 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" stopped in 0.000007 2024-11-19 12:31:09,854 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "revision" stopped in 0.000005 2024-11-19 12:31:09,854 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "file_in_memory_log" stopped in 0.000006 2024-11-19 12:31:09,854 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display_in_memory_log" stopped in 0.000005 2024-11-19 12:31:09,854 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "file_log" stopped in 0.000008 2024-11-19 12:31:09,854 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "uid" stopped in 0.000004 2024-11-19 12:31:09,854 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Restored ctx dict_keys([])