2024-11-18 13:50:46,501 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "file_in_memory_log" initialized in 0.000015 2024-11-18 13:50:46,502 DEBUG (root) [MainThread] Release revision: 15278243 2024-11-18 13:50:46,502 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "revision" initialized in 0.000743 2024-11-18 13:50:46,502 DEBUG (yalibrary.vcs) [MainThread] detecting vcs from /home/runner/actions_runner/_work/ydb/ydb for paths: None 2024-11-18 13:50:46,502 DEBUG (yalibrary.vcs) [MainThread] common root: /home/runner/actions_runner/_work/ydb/ydb 2024-11-18 13:50:46,502 DEBUG (yalibrary.vcs) [MainThread] vcs root: /home/runner/actions_runner/_work/ydb/ydb (git) 2024-11-18 13:50:46,503 DEBUG (root) [MainThread] vcs type: git 2024-11-18 13:50:46,503 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" initialized in 0.000195 2024-11-18 13:50:46,503 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-18 13:50:46,503 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "report" initialized in 0.000406 2024-11-18 13:50:46,503 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "exit" initialized in 0.000003 2024-11-18 13:50:46,503 DEBUG (root) [MainThread] Start up timestamp 2024-11-18T13:50:46.UTC (2024-11-18T13:50:46.UTC) 2024-11-18 13:50:46,503 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "lifecycle_ts" initialized in 0.000036 2024-11-18 13:50:46,503 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "env_checker" initialized in 0.000005 2024-11-18 13:50:46,504 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" initialized in 0.000387 2024-11-18 13:50:46,504 DEBUG (library.python.tmp) [MainThread] Set TMPDIR=/home/runner/.ya/tmp/1731937846.2955.vieqmrwm instead of None 2024-11-18 13:50:46,504 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "tmp_dir" initialized in 0.000128 2024-11-18 13:50:46,504 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=modules-initialization-early, group=overall-execution, time=1731937846.504325 2024-11-18 13:50:46,504 DEBUG (core.stages_profiler) [MainThread] Set stage modules-initialization-early_finished=1731937846.504325 2024-11-18 13:50:46,504 DEBUG (core.profiler) [MainThread] Profile step modules-initialization-early_finished - 1731937846.504325 2024-11-18 13:50:46,504 DEBUG (core.stage_tracer) [MainThread] Start stage tag=handler-selection, group=overall-execution, time=1731937846.5047693 2024-11-18 13:50:46,504 DEBUG (core.stages_profiler) [MainThread] Set stage handler-selection_started=1731937846.5047693 2024-11-18 13:50:46,504 DEBUG (core.profiler) [MainThread] Profile step handler-selection_started - 1731937846.5047693 2024-11-18 13:50:46,504 DEBUG (core.plugin_loader) [MainThread] Load handlers.make 2024-11-18 13:50:46,516 DEBUG (core.yarg.config_files) [MainThread] Load data from config /home/runner/actions_runner/_work/ydb/ydb/ya.conf 2024-11-18 13:50:46,517 DEBUG (core.yarg.config_files) [MainThread] Found 21 keys 2024-11-18 13:50:46,517 DEBUG (core.yarg.populate) [MainThread] Use config file `/home/runner/actions_runner/_work/ydb/ydb/ya.conf` with `21` keys 2024-11-18 13:50:46,517 DEBUG (core.yarg.populate) [MainThread] No aliases to inject 2024-11-18 13:50:46,518 DEBUG (core.yarg.config_files) [MainThread] Unknown config parameter `incremental_build_dirs_cleanup` 2024-11-18 13:50:46,518 DEBUG (core.yarg.config_files) [MainThread] Unknown config parameter `use_atd_revisions_info` 2024-11-18 13:50:46,518 DEBUG (core.yarg.config_files) [MainThread] Load data from config /home/runner/actions_runner/_work/ydb/ydb/build/internal/ya.conf 2024-11-18 13:50:46,518 DEBUG (core.yarg.config_files) [MainThread] Found 9 keys 2024-11-18 13:50:46,518 DEBUG (core.yarg.populate) [MainThread] Use config file `/home/runner/actions_runner/_work/ydb/ydb/build/internal/ya.conf` with `9` keys 2024-11-18 13:50:46,519 DEBUG (core.yarg.populate) [MainThread] No aliases to inject 2024-11-18 13:50:46,519 DEBUG (core.yarg.config_files) [MainThread] Unknown config parameter `bazel_remote_client_decompress` 2024-11-18 13:50:46,530 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-18 13:50:46,530 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-18 13:50:46,531 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=handler-selection, group=overall-execution, time=1731937846.531122 2024-11-18 13:50:46,531 DEBUG (core.stages_profiler) [MainThread] Set stage handler-selection_finished=1731937846.531122 2024-11-18 13:50:46,531 DEBUG (core.profiler) [MainThread] Profile step handler-selection_finished - 1731937846.531122 2024-11-18 13:50:46,531 DEBUG (core.stage_tracer) [MainThread] Start stage tag=modules-initialization-full, group=overall-execution, time=1731937846.5312448 2024-11-18 13:50:46,531 DEBUG (core.stages_profiler) [MainThread] Set stage modules-initialization-full_started=1731937846.5312448 2024-11-18 13:50:46,531 DEBUG (core.profiler) [MainThread] Profile step modules-initialization-full_started - 1731937846.5312448 2024-11-18 13:50:46,531 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-18 13:50:46,531 DEBUG (core.respawn) [MainThread] Same as prev source root /home/runner/actions_runner/_work/ydb/ydb 2024-11-18 13:50:46,531 DEBUG (core.respawn.pyver) [MainThread] No need to respawn to other ya-bin version 2024-11-18 13:50:46,531 DEBUG (core.respawn) [MainThread] Unsetting YA_STDIN env var as respawn never happened 2024-11-18 13:50:46,531 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "params" initialized in 0.000267 2024-11-18 13:50:46,533 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-18 13:50:46,533 DEBUG (root) [MainThread] Update replacements in 2024-11-18 13:50:46,533 DEBUG (root) [MainThread] Add suppressing formatter to 2024-11-18 13:50:46,534 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-18 13:50:46,534 DEBUG (root) [MainThread] Add suppressing formatter to 2024-11-18 13:50:46,534 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-18 13:50:46,534 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token" initialized in 0.002312 2024-11-18 13:50:46,534 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "state" initialized in 0.000211 2024-11-18 13:50:46,534 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display" initialized in 0.000042 2024-11-18 13:50:46,534 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-18 13:50:46,535 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "custom_file_log" initialized in 0.000878 2024-11-18 13:50:46,535 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display_log" initialized in 0.000032 2024-11-18 13:50:46,535 DEBUG (yalibrary.vcs) [MainThread] detecting vcs from /home/runner/actions_runner/_work/ydb/ydb for paths: None 2024-11-18 13:50:46,535 DEBUG (yalibrary.vcs) [MainThread] common root: /home/runner/actions_runner/_work/ydb/ydb 2024-11-18 13:50:46,535 DEBUG (yalibrary.vcs) [MainThread] vcs root: /home/runner/actions_runner/_work/ydb/ydb (git) 2024-11-18 13:50:46,535 DEBUG (root) [MainThread] vcs type: git 2024-11-18 13:50:46,535 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" initialized in 0.000220 2024-11-18 13:50:46,535 DEBUG (devtools.ya.app) [MainThread] origin: github 2024-11-18 13:50:46,536 DEBUG (devtools.ya.app) [MainThread] python: sys.version_info(major=3, minor=12, micro=7, releaselevel='final', serial=0) 2024-11-18 13:50:46,536 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "self_info" initialized in 0.000098 2024-11-18 13:50:46,536 DEBUG (root) [MainThread] Custom fetcher: None, fetcher parameters: [{'name': 'custom'}, {'name': 'proxy'}, {'name': 'skynet'}, {'name': 'mds'}, {'name': 'sandbox'}], sb_token none 2024-11-18 13:50:46,536 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher_params" initialized in 0.000075 2024-11-18 13:50:46,536 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "use_universal_fetcher_everywhere" initialized in 0.000002 2024-11-18 13:50:46,536 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "docker_config_path" initialized in 0.000001 2024-11-18 13:50:46,537 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-18 13:50:46,537 DEBUG (root) [MainThread] Update replacements in 2024-11-18 13:50:46,537 DEBUG (root) [MainThread] Update replacements in 2024-11-18 13:50:46,537 DEBUG (root) [MainThread] Update replacements in DisplayStreamHandler 2024-11-18 13:50:46,537 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token2" initialized in 0.001122 2024-11-18 13:50:46,537 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" initialized in 0.000061 2024-11-18 13:50:46,537 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher" initialized in 0.000002 2024-11-18 13:50:46,537 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "showstack" initialized in 0.000131 2024-11-18 13:50:46,537 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "profile" initialized in 0.000002 2024-11-18 13:50:46,537 DEBUG (devtools.ya.app) [MainThread] mlockall return code: 12 2024-11-18 13:50:46,537 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "mlockall" initialized in 0.000037 2024-11-18 13:50:46,537 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "event_queue" initialized in 0.000003 2024-11-18 13:50:46,538 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "changelist_store" initialized in 0.000241 2024-11-18 13:50:46,538 DEBUG (root) [MainThread] Event log file is /home/runner/actions_runner/_work/ydb/ydb/tmp/results/try_1/ya_evlog.jsonl 2024-11-18 13:50:46,538 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "evlog" initialized in 0.000381 2024-11-18 13:50:46,576 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "dump_debug" initialized in 0.037863 2024-11-18 13:50:46,577 DEBUG (devtools.ya.app) [MainThread] Run action on with params 2024-11-18 13:50:46,577 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=modules-initialization-full, group=overall-execution, time=1731937846.5772872 2024-11-18 13:50:46,577 DEBUG (core.stages_profiler) [MainThread] Set stage modules-initialization-full_finished=1731937846.5772872 2024-11-18 13:50:46,577 DEBUG (core.profiler) [MainThread] Profile step modules-initialization-full_finished - 1731937846.5772872 2024-11-18 13:50:46,577 DEBUG (core.stage_tracer) [MainThread] Start stage tag=invoke-do_ya_make, group=overall-execution, time=1731937846.577445 2024-11-18 13:50:46,577 DEBUG (core.stages_profiler) [MainThread] Set stage invoke-do_ya_make_started=1731937846.577445 2024-11-18 13:50:46,577 DEBUG (core.profiler) [MainThread] Profile step invoke-do_ya_make_started - 1731937846.577445 2024-11-18 13:50:46,701 DEBUG (core.stage_tracer) [MainThread] Start stage tag=ya_make_handler, group=build_handler, time=1731937846.701198 2024-11-18 13:50:46,701 DEBUG (core.stages_profiler) [MainThread] Set stage ya_make_handler_started=1731937846.701198 2024-11-18 13:50:46,701 DEBUG (core.profiler) [MainThread] Profile step ya_make_handler_started - 1731937846.701198 2024-11-18 13:50:46,701 DEBUG (core.stage_tracer) [MainThread] Start stage tag=context_generating, group=build_handler, time=1731937846.7014248 2024-11-18 13:50:46,701 DEBUG (core.stages_profiler) [MainThread] Set stage context_generating_started=1731937846.7014248 2024-11-18 13:50:46,701 DEBUG (core.profiler) [MainThread] Profile step context_generating_started - 1731937846.7014248 2024-11-18 13:50:46,701 DEBUG (core.stage_tracer) [MainThread] Start stage tag=build_graph_cache_configuration, group=build_handler, time=1731937846.7015467 2024-11-18 13:50:46,701 DEBUG (core.stages_profiler) [MainThread] Set stage build_graph_cache_configuration_started=1731937846.7015467 2024-11-18 13:50:46,701 DEBUG (core.profiler) [MainThread] Profile step build_graph_cache_configuration_started - 1731937846.7015467 2024-11-18 13:50:46,701 DEBUG (build.ya_make) [MainThread] Build graph cache processing started 2024-11-18 13:50:46,701 DEBUG (build.ya_make) [MainThread] Build graph cache processing disabled 2024-11-18 13:50:46,701 DEBUG (build.ya_make) [MainThread] Build graph cache is not available in opensource 2024-11-18 13:50:46,701 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=build_graph_cache_configuration, group=build_handler, time=1731937846.7017791 2024-11-18 13:50:46,701 DEBUG (core.stages_profiler) [MainThread] Set stage build_graph_cache_configuration_finished=1731937846.7017791 2024-11-18 13:50:46,701 DEBUG (core.profiler) [MainThread] Profile step build_graph_cache_configuration_finished - 1731937846.7017791 2024-11-18 13:50:46,702 DEBUG (core.stage_tracer) [MainThread] Start stage tag=context_creation, group=ya_make, time=1731937846.7020211 2024-11-18 13:50:46,702 DEBUG (core.stages_profiler) [MainThread] Set stage context_creation_started=1731937846.7020211 2024-11-18 13:50:46,702 DEBUG (core.profiler) [MainThread] Profile step context_creation_started - 1731937846.7020211 2024-11-18 13:50:46,704 DEBUG (yalibrary.toolscache) [MainThread] Tools cache uses passed opts 2024-11-18 13:50:46,704 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-18 13:50:46,704 DEBUG (build.ya_make) [MainThread] content UIDs enabled by request 2024-11-18 13:50:46,706 DEBUG (build.ya_make) [Misc-00] Using '/tmp/tmp.e0zs6l4Rja' file to obtain bazel remote password 2024-11-18 13:50:46,706 DEBUG (core.stage_tracer) [MainThread] Start stage tag=build_graph_and_tests, group=graph, time=1731937846.7065735 2024-11-18 13:50:46,706 DEBUG (core.stages_profiler) [MainThread] Set stage build_graph_and_tests_started=1731937846.7065735 2024-11-18 13:50:46,706 DEBUG (core.profiler) [MainThread] Profile step build_graph_and_tests_started - 1731937846.7065735 2024-11-18 13:50:46,707 DEBUG (build.graph) [Misc-01] Collect vcs info 2024-11-18 13:50:46,707 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/ya.conf.json 2024-11-18 13:50:46,707 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-18 13:50:46,707 DEBUG (yalibrary.vcs) [Misc-01] common root: /home/runner/actions_runner/_work/ydb/ydb 2024-11-18 13:50:46,708 DEBUG (yalibrary.vcs) [Misc-01] vcs root: /home/runner/actions_runner/_work/ydb/ydb (git) 2024-11-18 13:50:46,708 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/platform/clang/clang16.json 2024-11-18 13:50:46,710 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/platform/clang/clang18.json 2024-11-18 13:50:46,712 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-18 13:50:46,712 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-18 13:50:46,712 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-18 13:50:46,713 DEBUG (yalibrary.tools) [MainThread] Using old-style toolchain for: ymake 2024-11-18 13:50:46,713 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/ymake/public.resources.json 2024-11-18 13:50:46,713 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-18 13:50:46,713 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ymake: will use 'linux' platform 2024-11-18 13:50:46,713 DEBUG (yalibrary.fetcher.resource_fetcher) [MainThread] Fetching 7448917907 from sbr:7448917907 to /home/runner/.ya/tools/v4/7448917907 dir, post_process=0) 2024-11-18 13:50:46,713 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/mapping.conf.json 2024-11-18 13:50:46,715 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/ext_mapping.conf.json 2024-11-18 13:50:46,723 DEBUG (yalibrary.toolscache) [MainThread] Tools cache attempt: (request for resource 7448917907) 2024-11-18 13:50:46,723 DEBUG (yalibrary.toolscache) [MainThread] Tools cache server resource download/parameters 2024-11-18 13:50:46,723 DEBUG (yalibrary.tools) [MainThread] Using old-style toolchain for: ya-tc 2024-11-18 13:50:46,724 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/ya-tc/public.resources.json 2024-11-18 13:50:46,724 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-18 13:50:46,724 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ya-tc: will use 'linux' platform 2024-11-18 13:50:46,724 DEBUG (yalibrary.fetcher.resource_fetcher) [MainThread] Fetching 6812260917 from sbr:6812260917 to /home/runner/.ya/tools/v4/6812260917 dir, post_process=0) 2024-11-18 13:50:46,724 DEBUG (yalibrary.toolscache) [MainThread] tc cache stats: None 2024-11-18 13:50:46,724 DEBUG (yalibrary.fetcher.cache_helper) [MainThread] Resource seems to be installed in /home/runner/.ya/tools/v4/6812260917 2024-11-18 13:50:46,724 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ya-tc: successfully fetched into /home/runner/.ya/tools/v4/6812260917 2024-11-18 13:50:46,724 DEBUG (yalibrary.tools) [MainThread] Using old-style toolchain for: ya-tc 2024-11-18 13:50:46,724 DEBUG (yalibrary.toolscache) [MainThread] tc cache stats: None 2024-11-18 13:50:46,724 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-18 13:50:46,727 DEBUG (yalibrary.toolscache) [MainThread] Tools cache (request for resource 7448917907) address: (2372, 14342, 'unix:/home/runner/.ya/tools/v4/psingX8l29Y.tmp') 2024-11-18 13:50:46,732 DEBUG (yalibrary.toolscache) [MainThread] tc cache stats: TotalKnownSize: 62119936 TotalKnownSizeLocked: 22249472 Master: true TotalDBSize: 81920 ToolCount: 2 ProcessesCount: 2 2024-11-18 13:50:46,732 DEBUG (yalibrary.fetcher.cache_helper) [MainThread] Resource seems to be installed in /home/runner/.ya/tools/v4/7448917907 2024-11-18 13:50:46,732 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ymake: successfully fetched into /home/runner/.ya/tools/v4/7448917907 2024-11-18 13:50:46,732 DEBUG (exts.timer) [MainThread] Timer build.graph, stage fetch ymake: 0.019814729690551758 2024-11-18 13:50:46,733 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=gen-graph-default-linux-x86_64-release-asan-pic, group=graph, time=1731937846.7333424 2024-11-18 13:50:46,733 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-default-linux-x86_64-release-asan-pic_started=1731937846.7333424 2024-11-18 13:50:46,733 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-default-linux-x86_64-release-asan-pic_started - 1731937846.7333424 2024-11-18 13:50:46,734 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=gen-graph-default-linux-x86_64-release-asan-nopic, group=graph, time=1731937846.7337205 2024-11-18 13:50:46,734 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-default-linux-x86_64-release-asan-nopic_started=1731937846.7337205 2024-11-18 13:50:46,734 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-default-linux-x86_64-release-asan-nopic_started - 1731937846.7337205 2024-11-18 13:50:46,734 DEBUG (core.stage_tracer) [MainThread] Start stage tag=get-tools, group=graph, time=1731937846.7339842 2024-11-18 13:50:46,734 DEBUG (core.stages_profiler) [MainThread] Set stage get-tools_started=1731937846.7339842 2024-11-18 13:50:46,734 DEBUG (core.profiler) [MainThread] Profile step get-tools_started - 1731937846.7339842 2024-11-18 13:50:46,734 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=gen-graph-gen-opts-default-linux-x86_64-release-asan-pic, group=graph, time=1731937846.7342582 2024-11-18 13:50:46,734 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-gen-opts-default-linux-x86_64-release-asan-pic_started=1731937846.7342582 2024-11-18 13:50:46,735 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-gen-opts-default-linux-x86_64-release-asan-pic_started - 1731937846.7342582 2024-11-18 13:50:46,735 DEBUG (yalibrary.guards) [Misc-02] Enter guard fetch with value None 2024-11-18 13:50:46,735 DEBUG (core.stage_tracer) [MainThread] Start stage tag=waiting-tool-targets, group=graph, time=1731937846.7348442 2024-11-18 13:50:46,735 DEBUG (core.stages_profiler) [MainThread] Set stage waiting-tool-targets_started=1731937846.7348442 2024-11-18 13:50:46,735 DEBUG (core.profiler) [MainThread] Profile step waiting-tool-targets_started - 1731937846.7348442 2024-11-18 13:50:46,735 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic, group=graph, time=1731937846.7348738 2024-11-18 13:50:46,735 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic_started=1731937846.7348738 2024-11-18 13:50:46,735 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic_started - 1731937846.7348738 2024-11-18 13:50:46,735 DEBUG (yalibrary.guards) [Misc-03] Enter guard fetch with value None 2024-11-18 13:50:46,736 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-18 13:50:46,738 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-18 13:50:46,740 DEBUG (yalibrary.vcs.vcsversion) [Misc-01] Git info commit:b'c7006248a54756eb73a8a7d5c92dd7f67c4561d1', author:b'Kirill Rysin <35688753+naspirato@users.noreply.github.com>', summary:b'Merge 36d3d8951388785c4b62da398988d3e3b75b2904 into 0cdb00dde7707ae777a9aa397682ec00041b47ed', svn_id:b'' 2024-11-18 13:50:46,741 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-2elicmfr6a Host information: Linux ghrun-2elicmfr6a 5.15.0-124-generic #134-Ubuntu SMP Fri Sep 27 20:20:17 UTC 2024 x86_64 2024-11-18 13:50:46,741 DEBUG (build.graph) [Misc-01] Got version json "{\n \"ARCADIA_PATCH_NUMBER\": 1,\n \"ARCADIA_SOURCE_HG_HASH\": \"c7006248a54756eb73a8a7d5c92dd7f67c4561d1\",\n \"ARCADIA_SOURCE_LAST_AUTHOR\": \"Kirill Rysin <35688753+naspirato@users.noreply.github.com>\",\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-18T13:50:46.000000Z\",\n \"BUILD_HOST\": \"ghrun-2elicmfr6a\",\n \"BUILD_TIMESTAMP\": 1731937846,\n \"BUILD_USER\": \"runner\",\n \"CUSTOM_VERSION\": \"\",\n \"DIRTY\": \"\",\n \"PROGRAM_VERSION\": \"Git info:\\n Commit: c7006248a54756eb73a8a7d5c92dd7f67c4561d1\\n Branch: \\n Author: Kirill Rysin <35688753+naspirato@users.noreply.github.com>\\n Summary: Merge 36d3d8951388785c4b62da398988d3e3b75b2904 into 0cdb00dde7707ae777a9aa397682ec00041b47ed\\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-2elicmfr6a\\n Host information: \\n Linux ghrun-2elicmfr6a 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: c7006248a54756eb73a8a7d5c92dd7f67c4561d1\\n Branch: \\n Author: Kirill Rysin <35688753+naspirato@users.noreply.github.com>\\n Summary: Merge 36d3d8951388785c4b62da398988d3e3b75b2904 into 0cdb00dde7707ae777a9aa397682ec00041b47ed\\n\",\n \"VCS\": \"git\"\n}" 2024-11-18 13:50:46,741 DEBUG (exts.timer) [Misc-01] Timer get_version_info, stage vcs info: 0.0338747501373291 2024-11-18 13:50:46,767 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-18 13:50:46,769 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-18 13:50:46,892 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-18 13:50:46,892 DEBUG (yalibrary.guards) [Misc-02] Exit guard fetch with value None 2024-11-18 13:50:46,892 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=gen-graph-gen-opts-default-linux-x86_64-release-asan-pic, group=graph, time=1731937846.892889 2024-11-18 13:50:46,892 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-gen-opts-default-linux-x86_64-release-asan-pic_finished=1731937846.892889 2024-11-18 13:50:46,893 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-gen-opts-default-linux-x86_64-release-asan-pic_finished - 1731937846.892889 2024-11-18 13:50:46,893 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=gen-graph-json-default-linux-x86_64-release-asan-pic, group=graph, time=1731937846.8930855 2024-11-18 13:50:46,893 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-json-default-linux-x86_64-release-asan-pic_started=1731937846.8930855 2024-11-18 13:50:46,893 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-json-default-linux-x86_64-release-asan-pic_started - 1731937846.8930855 2024-11-18 13:50:46,893 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 0x7f52774a31a0>, 'enabled_events': 'dGT', 'no_caches_on_retry': False, 'no_ymake_retry': False, 'disable_customization': 0, 'dump_tests': '/home/runner/.ya/tmp/1731937846.2955.vieqmrwm/gen_graph.eratwyt3/test.dart', 'dump_make_files': '/home/runner/.ya/tmp/1731937846.2955.vieqmrwm/gen_graph.eratwyt3/makefiles.dart'} 2024-11-18 13:50:46,893 DEBUG (core.yarg.behaviour) [Misc-02] Found unused args ['grab_stderr'] 2024-11-18 13:50:46,893 DEBUG (build.prefetch) [Misc-02] prefetch disabled 2024-11-18 13:50:46,893 DEBUG (core.event_handling.base_subscriber) [Misc-02] Subscribing PrintProgressSubscriber to event_queue 2024-11-18 13:50:46,893 DEBUG (yalibrary.tools) [Misc-02] Using old-style toolchain for: ymake 2024-11-18 13:50:46,894 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/1731937846.2955.vieqmrwm/yatmpjrnoj22w --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/1731937846.2955.vieqmrwm/gen_graph.eratwyt3/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1731937846.2955.vieqmrwm/gen_graph.eratwyt3/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' with env: { } 2024-11-18 13:50:46,894 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-18 13:50:46,896 DEBUG (yalibrary.guards) [Misc-03] Exit guard fetch with value None 2024-11-18 13:50:46,896 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic, group=graph, time=1731937846.8968043 2024-11-18 13:50:46,896 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic_finished=1731937846.8968043 2024-11-18 13:50:46,896 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic_finished - 1731937846.8968043 2024-11-18 13:50:46,897 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=gen-graph-json-default-linux-x86_64-release-asan-nopic, group=graph, time=1731937846.8970585 2024-11-18 13:50:46,897 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-json-default-linux-x86_64-release-asan-nopic_started=1731937846.8970585 2024-11-18 13:50:46,897 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-json-default-linux-x86_64-release-asan-nopic_started - 1731937846.8970585 2024-11-18 13:50:46,897 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 0x7f5277d6c900>, 'enabled_events': 'dGT', 'no_caches_on_retry': False, 'no_ymake_retry': False, 'disable_customization': 0, 'dump_tests': '/home/runner/.ya/tmp/1731937846.2955.vieqmrwm/gen_graph.irez0doj/test.dart', 'dump_make_files': '/home/runner/.ya/tmp/1731937846.2955.vieqmrwm/gen_graph.irez0doj/makefiles.dart'} 2024-11-18 13:50:46,897 DEBUG (core.yarg.behaviour) [Misc-03] Found unused args ['grab_stderr'] 2024-11-18 13:50:46,897 DEBUG (build.prefetch) [Misc-03] prefetch disabled 2024-11-18 13:50:46,897 DEBUG (yalibrary.tools) [Misc-03] Using old-style toolchain for: ymake 2024-11-18 13:50:46,898 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/1731937846.2955.vieqmrwm/yatmpvup717lz --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/1731937846.2955.vieqmrwm/gen_graph.irez0doj/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1731937846.2955.vieqmrwm/gen_graph.irez0doj/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' with env: { } 2024-11-18 13:50:46,900 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"ymake run","_timestamp":1731937846900230,"_typename":"NEvent.TStageStarted","debug_id":"default-linux-x86_64-release-asan-pic","ymake_run_uid":0} 2024-11-18 13:50:46,900 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Target path: /home/runner/actions_runner/_work/ydb/ydb\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937846900335,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:46,900 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load configuration from cache","_timestamp":1731937846900368,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:46,901 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Conf cache has not been loaded (reason: File does not exist)...\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937846900376,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:46,901 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load configuration from cache","_timestamp":1731937846900380,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:46,901 DEBUG (build.ya_make) [Misc-02] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedConfCache","Type":"bool","_timestamp":1731937846900634,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-18 13:50:46,901 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1731937846900639,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:46,903 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"ymake run","_timestamp":1731937846903161,"_typename":"NEvent.TStageStarted","debug_id":"default-linux-x86_64-release-asan-nopic","ymake_run_uid":1} 2024-11-18 13:50:46,903 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Target path: /home/runner/actions_runner/_work/ydb/ydb\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937846903260,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:46,903 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load configuration from cache","_timestamp":1731937846903288,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:46,903 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Conf cache has not been loaded (reason: File does not exist)...\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937846903297,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:46,903 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load configuration from cache","_timestamp":1731937846903301,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:46,903 DEBUG (build.ya_make) [Misc-03] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedConfCache","Type":"bool","_timestamp":1731937846903548,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-18 13:50:46,904 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1731937846903555,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,055 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1731937847055197,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,055 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1731937847055218,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,056 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1731937847056566,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,056 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Fold global commands","_timestamp":1731937847056578,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,056 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1731937847056785,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,057 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1731937847056804,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,057 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Fold global commands","_timestamp":1731937847057762,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,057 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load plugins","_timestamp":1731937847057772,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,058 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1731937847058347,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,058 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Fold global commands","_timestamp":1731937847058359,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,059 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Fold global commands","_timestamp":1731937847059490,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,059 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load plugins","_timestamp":1731937847059497,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,172 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load plugins","_timestamp":1731937847172540,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,173 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load plugins","_timestamp":1731937847173353,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,203 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"MAIN_OUTPUT_AS_EXTRA enabled\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847202997,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,203 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"YMAKE_DEDICATED_MODULE_NODE disabled (by default)\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847203015,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,203 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"YMAKE_CHECK_FOR_INCORRECT_LOOPS disabled (by default)\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847203020,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,203 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"mlockall failed\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847203101,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,203 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"MAIN_OUTPUT_AS_EXTRA enabled\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847203572,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,203 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"ymake main","_timestamp":1731937847203106,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,203 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"YMAKE_DEDICATED_MODULE_NODE disabled (by default)\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847203589,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,204 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"FS cache loading is enabled\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847203155,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,204 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"YMAKE_CHECK_FOR_INCORRECT_LOOPS disabled (by default)\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847203593,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,204 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"FS cache saving is enabled\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847203159,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,204 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"mlockall failed\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847203664,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,204 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Deps cache loading is enabled\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847203163,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,204 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"ymake main","_timestamp":1731937847203668,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,204 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Deps cache saving is enabled\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847203166,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,205 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"FS cache loading is enabled\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847203707,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,205 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"DepManagement cache loading is enabled\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847203170,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,205 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"FS cache saving is enabled\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847203712,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,205 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"DepManagement cache saving is enabled\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847203173,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,205 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Deps cache loading is enabled\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847203715,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,205 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Uids cache loading is enabled\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847203176,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,205 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Deps cache saving is enabled\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847203719,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,205 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Uids cache saving is enabled\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847203180,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,205 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"DepManagement cache loading is enabled\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847203722,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,205 DEBUG (build.ya_make) [Misc-02] Configure message {"HasChangelist":false,"_timestamp":1731937847203982,"_typename":"NEvent.TArcChanges","ymake_run_uid":0} 2024-11-18 13:50:47,206 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"DepManagement cache saving is enabled\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847203725,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,206 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Graph has structural changes because of PatchPath\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847203989,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,206 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Uids cache loading is enabled\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847203728,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,206 DEBUG (build.ya_make) [Misc-02] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedFSCache","Type":"bool","_timestamp":1731937847203996,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-18 13:50:47,206 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Uids cache saving is enabled\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847203732,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,206 DEBUG (build.ya_make) [Misc-02] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedDepsCache","Type":"bool","_timestamp":1731937847204000,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-18 13:50:47,206 DEBUG (build.ya_make) [Misc-03] Configure message {"HasChangelist":false,"_timestamp":1731937847204516,"_typename":"NEvent.TArcChanges","ymake_run_uid":1} 2024-11-18 13:50:47,206 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Build graph","_timestamp":1731937847204004,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,206 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Graph has structural changes because of PatchPath\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847204525,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,206 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Graph has structural changes because start dirs are different\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847204009,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,207 DEBUG (build.ya_make) [Misc-03] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedFSCache","Type":"bool","_timestamp":1731937847204532,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-18 13:50:47,207 DEBUG (build.ya_make) [Misc-02] Configure message {"PredictsStructuralChanges":true,"_timestamp":1731937847204013,"_typename":"NEvent.TGraphChangesPrediction","ymake_run_uid":0} 2024-11-18 13:50:47,207 DEBUG (build.ya_make) [Misc-03] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedDepsCache","Type":"bool","_timestamp":1731937847204536,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-18 13:50:47,207 DEBUG (build.ya_make) [Misc-02] Configure message {"Enabled":false,"MaybeEnabled":false,"_timestamp":1731937847204016,"_typename":"NEvent.TBypassConfigure","ymake_run_uid":0} 2024-11-18 13:50:47,207 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Build graph","_timestamp":1731937847204540,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,207 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Configure graph","_timestamp":1731937847204020,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,207 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Graph has structural changes because start dirs are different\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847204544,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,207 DEBUG (build.ya_make) [Misc-03] Configure message {"PredictsStructuralChanges":true,"_timestamp":1731937847204549,"_typename":"NEvent.TGraphChangesPrediction","ymake_run_uid":1} 2024-11-18 13:50:47,207 DEBUG (build.ya_make) [Misc-03] Configure message {"Enabled":false,"MaybeEnabled":false,"_timestamp":1731937847204553,"_typename":"NEvent.TBypassConfigure","ymake_run_uid":1} 2024-11-18 13:50:47,207 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Configure graph","_timestamp":1731937847204556,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,249 DEBUG (build.ya_make) [Misc-02] Configure message {"DoubleValue":0.04567624597,"Name":"EYmakeStats::ConfigureGraphTime","Type":"double","_timestamp":1731937847249704,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-18 13:50:47,250 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Configure graph","_timestamp":1731937847249711,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,250 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Searching target '.'\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847249718,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,250 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Selected target '$S' with id 2\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847249724,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,250 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Find Lost Includes","_timestamp":1731937847249738,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,250 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":3058,"Sub":"","Type":"Debug","_timestamp":1731937847249744,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,250 DEBUG (build.ya_make) [Misc-03] Configure message {"DoubleValue":0.04561129819,"Name":"EYmakeStats::ConfigureGraphTime","Type":"double","_timestamp":1731937847250175,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-18 13:50:47,250 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Find Lost Includes","_timestamp":1731937847249747,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,250 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Configure graph","_timestamp":1731937847250182,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,251 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Searching target '.'\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847250187,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,251 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"loaded size = 66; load time = 25; loaded MD5 time = 2; Max loaded MD5 time = 1; loaded count = 2; max load time = 21; mapped size = 0; mapped MD5 time = 0; Max mapped MD5 time = 0; mapped count = 0; map time = 0; from patch count = 0; from patch size = 0; file stat count = 2; lstat count = 2; lstat sum us = 11; lstat min us = 4; lstat avr us = 5; lstat max us = 7; opendir count = 0; opendir sum us = 0; opendir min us = 0; opendir avr us = 0; opendir max us = 0; readdir count = 0; readdir sum us = 0; readdir min us = 0; readdir avr us = 0; readdir max us = 0; (opendir + readdir) sum us = 0; (lstat + opendir + readdir) sum us = 11;","Mod":"unimp","Sub":"File access stats","Type":"Debug","_timestamp":1731937847249777,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,251 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Selected target '$S' with id 2\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847250193,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,251 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Find Lost Includes","_timestamp":1731937847250204,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,251 DEBUG (build.ya_make) [Misc-02] Configure message {"FileStatCount":2,"FromPatchCount":0,"FromPatchSize":0,"ListDirSumUs":0,"LoadTime":25,"LoadedCount":2,"LoadedMD5Time":2,"LoadedSize":66,"LstatAvrUs":5,"LstatCount":2,"LstatListDirSumUs":11,"LstatMaxUs":7,"LstatMinUs":4,"LstatSumUs":11,"MapTime":0,"MappedCount":0,"MappedMD5Time":0,"MappedSize":0,"MaxLoadTime":21,"MaxLoadedMD5Time":1,"MaxMappedMD5Time":0,"OpendirAvrUs":0,"OpendirCount":0,"OpendirMaxUs":0,"OpendirMinUs":0,"OpendirSumUs":0,"ReaddirAvrUs":0,"ReaddirCount":0,"ReaddirMaxUs":0,"ReaddirMinUs":0,"ReaddirSumUs":0,"_timestamp":1731937847249788,"_typename":"NEvent.TFileConfStats","ymake_run_uid":0} 2024-11-18 13:50:47,251 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":3060,"Sub":"","Type":"Debug","_timestamp":1731937847250209,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,251 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":66,"Name":"EFileConfStats::LoadedSize","Type":"int","_timestamp":1731937847249800,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-18 13:50:47,251 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Find Lost Includes","_timestamp":1731937847250212,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,252 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":25,"Name":"EFileConfStats::LoadTime","Type":"int","_timestamp":1731937847249803,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-18 13:50:47,252 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":2,"Name":"EFileConfStats::LoadedCount","Type":"int","_timestamp":1731937847249806,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-18 13:50:47,252 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"loaded size = 66; load time = 17; loaded MD5 time = 0; Max loaded MD5 time = 0; loaded count = 2; max load time = 13; mapped size = 0; mapped MD5 time = 0; Max mapped MD5 time = 0; mapped count = 0; map time = 0; from patch count = 0; from patch size = 0; file stat count = 2; lstat count = 2; lstat sum us = 10; lstat min us = 4; lstat avr us = 5; lstat max us = 6; opendir count = 0; opendir sum us = 0; opendir min us = 0; opendir avr us = 0; opendir max us = 0; readdir count = 0; readdir sum us = 0; readdir min us = 0; readdir avr us = 0; readdir max us = 0; (opendir + readdir) sum us = 0; (lstat + opendir + readdir) sum us = 10;","Mod":"unimp","Sub":"File access stats","Type":"Debug","_timestamp":1731937847250241,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,252 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":0,"Name":"EFileConfStats::MappedSize","Type":"int","_timestamp":1731937847249809,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-18 13:50:47,252 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":0,"Name":"EFileConfStats::MapTime","Type":"int","_timestamp":1731937847249812,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-18 13:50:47,253 DEBUG (build.ya_make) [Misc-03] Configure message {"FileStatCount":2,"FromPatchCount":0,"FromPatchSize":0,"ListDirSumUs":0,"LoadTime":17,"LoadedCount":2,"LoadedMD5Time":0,"LoadedSize":66,"LstatAvrUs":5,"LstatCount":2,"LstatListDirSumUs":10,"LstatMaxUs":6,"LstatMinUs":4,"LstatSumUs":10,"MapTime":0,"MappedCount":0,"MappedMD5Time":0,"MappedSize":0,"MaxLoadTime":13,"MaxLoadedMD5Time":0,"MaxMappedMD5Time":0,"OpendirAvrUs":0,"OpendirCount":0,"OpendirMaxUs":0,"OpendirMinUs":0,"OpendirSumUs":0,"ReaddirAvrUs":0,"ReaddirCount":0,"ReaddirMaxUs":0,"ReaddirMinUs":0,"ReaddirSumUs":0,"_timestamp":1731937847250253,"_typename":"NEvent.TFileConfStats","ymake_run_uid":1} 2024-11-18 13:50:47,253 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":0,"Name":"EFileConfStats::MappedCount","Type":"int","_timestamp":1731937847249815,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-18 13:50:47,253 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":66,"Name":"EFileConfStats::LoadedSize","Type":"int","_timestamp":1731937847250264,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-18 13:50:47,253 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":2,"Name":"EFileConfStats::Count","Type":"int","_timestamp":1731937847249817,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-18 13:50:47,253 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":17,"Name":"EFileConfStats::LoadTime","Type":"int","_timestamp":1731937847250268,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-18 13:50:47,253 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"bucket id = 0; loaded size = 66; load time = 25; loaded count = 2; max load time = 21;","Mod":"unimp","Sub":"Bucket #0","Type":"Debug","_timestamp":1731937847249825,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,253 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":2,"Name":"EFileConfStats::LoadedCount","Type":"int","_timestamp":1731937847250270,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-18 13:50:47,254 DEBUG (build.ya_make) [Misc-02] Configure message {"BucketId":0,"LoadTime":25,"LoadedCount":2,"LoadedSize":66,"MaxLoadTime":21,"_timestamp":1731937847249829,"_typename":"NEvent.TFileConfSubStats","ymake_run_uid":0} 2024-11-18 13:50:47,254 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":0,"Name":"EFileConfStats::MappedSize","Type":"int","_timestamp":1731937847250273,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-18 13:50:47,254 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"parse time = 0; parsed files count = 0; parsed files size = 0; parsed files recovered = 0; .in files count = 0; .in files size = 0;","Mod":"unimp","Sub":"Parsing stats","Type":"Debug","_timestamp":1731937847249840,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,254 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":0,"Name":"EFileConfStats::MapTime","Type":"int","_timestamp":1731937847250275,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-18 13:50:47,254 DEBUG (build.ya_make) [Misc-02] Configure message {"InFilesCount":0,"InFilesSize":0,"ParseTime":0,"ParsedFilesCount":0,"ParsedFilesRecovered":0,"ParsedFilesSize":0,"_timestamp":1731937847249845,"_typename":"NEvent.TIncParserManagerStats","ymake_run_uid":0} 2024-11-18 13:50:47,254 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":0,"Name":"EFileConfStats::MappedCount","Type":"int","_timestamp":1731937847250278,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-18 13:50:47,254 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"count = 1; includes count = 0; unique count = 1; size = 33; unique size = 33;","Mod":"unimp","Sub":"ya.make parsing stats","Type":"Debug","_timestamp":1731937847249856,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,254 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":2,"Name":"EFileConfStats::Count","Type":"int","_timestamp":1731937847250280,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-18 13:50:47,254 DEBUG (build.ya_make) [Misc-02] Configure message {"Count":1,"Includes":0,"Size":33,"UniqueCount":1,"UniqueSize":33,"_timestamp":1731937847249860,"_typename":"NEvent.TGeneralParserStats","ymake_run_uid":0} 2024-11-18 13:50:47,254 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"bucket id = 0; loaded size = 66; load time = 17; loaded count = 2; max load time = 13;","Mod":"unimp","Sub":"Bucket #0","Type":"Debug","_timestamp":1731937847250287,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,255 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"nodes count = 2; edges count = 1; files count = 6; commands count = 16;","Mod":"unimp","Sub":"DepGraph stats","Type":"Debug","_timestamp":1731937847249867,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,255 DEBUG (build.ya_make) [Misc-03] Configure message {"BucketId":0,"LoadTime":17,"LoadedCount":2,"LoadedSize":66,"MaxLoadTime":13,"_timestamp":1731937847250291,"_typename":"NEvent.TFileConfSubStats","ymake_run_uid":1} 2024-11-18 13:50:47,255 DEBUG (build.ya_make) [Misc-02] Configure message {"CommandsCount":16,"EdgesCount":1,"FilesCount":6,"NodesCount":2,"_timestamp":1731937847249871,"_typename":"NEvent.TDepGraphStats","ymake_run_uid":0} 2024-11-18 13:50:47,255 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"parse time = 0; parsed files count = 0; parsed files size = 0; parsed files recovered = 0; .in files count = 0; .in files size = 0;","Mod":"unimp","Sub":"Parsing stats","Type":"Debug","_timestamp":1731937847250300,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,255 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"nuke mod dir = 0;","Mod":"unimp","Sub":"UpdIter stats","Type":"Debug","_timestamp":1731937847249876,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,255 DEBUG (build.ya_make) [Misc-03] Configure message {"InFilesCount":0,"InFilesSize":0,"ParseTime":0,"ParsedFilesCount":0,"ParsedFilesRecovered":0,"ParsedFilesSize":0,"_timestamp":1731937847250305,"_typename":"NEvent.TIncParserManagerStats","ymake_run_uid":1} 2024-11-18 13:50:47,255 DEBUG (build.ya_make) [Misc-02] Configure message {"NukedDir":0,"_timestamp":1731937847249880,"_typename":"NEvent.TUpdIterStats","ymake_run_uid":0} 2024-11-18 13:50:47,255 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"count = 1; includes count = 0; unique count = 1; size = 33; unique size = 33;","Mod":"unimp","Sub":"ya.make parsing stats","Type":"Debug","_timestamp":1731937847250315,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,255 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":1731937847249887,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,255 DEBUG (build.ya_make) [Misc-03] Configure message {"Count":1,"Includes":0,"Size":33,"UniqueCount":1,"UniqueSize":33,"_timestamp":1731937847250320,"_typename":"NEvent.TGeneralParserStats","ymake_run_uid":1} 2024-11-18 13:50:47,256 DEBUG (build.ya_make) [Misc-02] Configure message {"IncludesAttempted":0,"IncludesFromCache":0,"ResolveAsKnownFromCache":0,"ResolveAsKnownTotal":0,"_timestamp":1731937847249891,"_typename":"NEvent.TResolveStats","ymake_run_uid":0} 2024-11-18 13:50:47,256 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"nodes count = 2; edges count = 1; files count = 6; commands count = 16;","Mod":"unimp","Sub":"DepGraph stats","Type":"Debug","_timestamp":1731937847250328,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,256 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Build graph","_timestamp":1731937847249894,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,256 DEBUG (build.ya_make) [Misc-03] Configure message {"CommandsCount":16,"EdgesCount":1,"FilesCount":6,"NodesCount":2,"_timestamp":1731937847250331,"_typename":"NEvent.TDepGraphStats","ymake_run_uid":1} 2024-11-18 13:50:47,256 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"accessed = 0; loaded = 0; outdated = 0; parsed = 0; total = 0;","Mod":"unimp","Sub":"TModules stats","Type":"Debug","_timestamp":1731937847249902,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,256 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"nuke mod dir = 0;","Mod":"unimp","Sub":"UpdIter stats","Type":"Debug","_timestamp":1731937847250336,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,256 DEBUG (build.ya_make) [Misc-02] Configure message {"Accessed":0,"Loaded":0,"Outdated":0,"Parsed":0,"Total":0,"_timestamp":1731937847249907,"_typename":"NEvent.TModulesStats","ymake_run_uid":0} 2024-11-18 13:50:47,256 DEBUG (build.ya_make) [Misc-03] Configure message {"NukedDir":0,"_timestamp":1731937847250339,"_typename":"NEvent.TUpdIterStats","ymake_run_uid":1} 2024-11-18 13:50:47,256 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":0,"Name":"EModulesStats::Accessed","Type":"int","_timestamp":1731937847249910,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-18 13:50:47,256 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":1731937847250345,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,257 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":0,"Name":"EModulesStats::Loaded","Type":"int","_timestamp":1731937847249913,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-18 13:50:47,257 DEBUG (build.ya_make) [Misc-03] Configure message {"IncludesAttempted":0,"IncludesFromCache":0,"ResolveAsKnownFromCache":0,"ResolveAsKnownTotal":0,"_timestamp":1731937847250349,"_typename":"NEvent.TResolveStats","ymake_run_uid":1} 2024-11-18 13:50:47,257 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":0,"Name":"EModulesStats::Outdated","Type":"int","_timestamp":1731937847249916,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-18 13:50:47,257 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Build graph","_timestamp":1731937847250352,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,257 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":0,"Name":"EModulesStats::Parsed","Type":"int","_timestamp":1731937847249918,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-18 13:50:47,257 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"accessed = 0; loaded = 0; outdated = 0; parsed = 0; total = 0;","Mod":"unimp","Sub":"TModules stats","Type":"Debug","_timestamp":1731937847250360,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,257 DEBUG (build.ya_make) [Misc-03] Configure message {"Accessed":0,"Loaded":0,"Outdated":0,"Parsed":0,"Total":0,"_timestamp":1731937847250365,"_typename":"NEvent.TModulesStats","ymake_run_uid":1} 2024-11-18 13:50:47,257 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":0,"Name":"EModulesStats::Accessed","Type":"int","_timestamp":1731937847250368,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-18 13:50:47,257 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Set reachable nodes","_timestamp":1731937847249925,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,257 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":0,"Name":"EModulesStats::Loaded","Type":"int","_timestamp":1731937847250371,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-18 13:50:47,258 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Set reachable nodes","_timestamp":1731937847249928,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,258 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":0,"Name":"EModulesStats::Outdated","Type":"int","_timestamp":1731937847250373,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-18 13:50:47,258 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Sort edges","_timestamp":1731937847249930,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,258 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":0,"Name":"EModulesStats::Parsed","Type":"int","_timestamp":1731937847250376,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-18 13:50:47,258 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Sort edges","_timestamp":1731937847249932,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,258 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1731937847249934,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,258 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Set reachable nodes","_timestamp":1731937847250383,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,258 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1731937847249939,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,258 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Set reachable nodes","_timestamp":1731937847250386,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,258 DEBUG (_ToolTargetsQueue) [MainThread] Source_id=0 (default-linux-x86_64-release-asan-pic). Tool targets: set() 2024-11-18 13:50:47,259 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check blacklist","_timestamp":1731937847249940,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,259 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Sort edges","_timestamp":1731937847250388,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,259 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check blacklist","_timestamp":1731937847249943,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,259 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Sort edges","_timestamp":1731937847250390,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,259 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check isolated projects","_timestamp":1731937847249945,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,259 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1731937847250392,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,259 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check isolated projects","_timestamp":1731937847249947,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,259 DEBUG (_ToolTargetsQueue) [MainThread] Source_id=1 (default-linux-x86_64-release-asan-nopic). Tool targets: set() 2024-11-18 13:50:47,259 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=waiting-tool-targets, group=graph, time=1731937847.2599537 2024-11-18 13:50:47,260 DEBUG (core.stages_profiler) [MainThread] Set stage waiting-tool-targets_finished=1731937847.2599537 2024-11-18 13:50:47,260 DEBUG (core.profiler) [MainThread] Profile step waiting-tool-targets_finished - 1731937847.2599537 2024-11-18 13:50:47,260 DEBUG (build.graph) [MainThread] Empty tool targets list 2024-11-18 13:50:47,260 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=get-tools, group=graph, time=1731937847.2602742 2024-11-18 13:50:47,260 DEBUG (core.stages_profiler) [MainThread] Set stage get-tools_finished=1731937847.2602742 2024-11-18 13:50:47,260 DEBUG (core.profiler) [MainThread] Profile step get-tools_finished - 1731937847.2602742 2024-11-18 13:50:47,260 DEBUG (core.stage_tracer) [MainThread] Start stage tag=merge-target-graphs-1, group=graph, time=1731937847.2604687 2024-11-18 13:50:47,260 DEBUG (core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_started=1731937847.2604687 2024-11-18 13:50:47,260 DEBUG (core.profiler) [MainThread] Profile step merge-target-graphs-1_started - 1731937847.2604687 2024-11-18 13:50:47,260 DEBUG (core.stage_tracer) [MainThread] Start stage tag=wait-target-graphs-1, group=graph, time=1731937847.2606814 2024-11-18 13:50:47,260 DEBUG (core.stages_profiler) [MainThread] Set stage wait-target-graphs-1_started=1731937847.2606814 2024-11-18 13:50:47,260 DEBUG (core.profiler) [MainThread] Profile step wait-target-graphs-1_started - 1731937847.2606814 2024-11-18 13:50:47,260 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Report Configure Events","_timestamp":1731937847249949,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,260 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1731937847250397,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,261 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Report Configure Events","_timestamp":1731937847249953,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,261 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check blacklist","_timestamp":1731937847250399,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,261 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save and compact","_timestamp":1731937847249954,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,261 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check blacklist","_timestamp":1731937847250401,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,261 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Total cache size on save = 1936; Diagnostics cache size on save = 112; Graph cache size on save = 112; Parsers cache size on save = 144; Modules table size on save = 4; Times table size on save = 16; Names table size on save = 816; Commands cache size on save = 272;","Mod":"unimp","Sub":"Internal cache stats","Type":"Debug","_timestamp":1731937847250133,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,261 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check isolated projects","_timestamp":1731937847250403,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,261 DEBUG (build.ya_make) [Misc-02] Configure message {"CommandsSize":272,"DiagnosticsCacheSize":112,"GraphCacheSize":112,"ModulesTableSize":4,"NamesTableSize":816,"ParsersCacheSize":144,"TimesTableSize":16,"TotalCacheSize":1936,"_timestamp":1731937847250140,"_typename":"NEvent.TInternalCacheSaverStats","ymake_run_uid":0} 2024-11-18 13:50:47,261 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check isolated projects","_timestamp":1731937847250405,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,261 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"FS cache has been saved...\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847250146,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,261 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Report Configure Events","_timestamp":1731937847250407,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,262 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Deps cache has been saved...\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847250150,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,262 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Report Configure Events","_timestamp":1731937847250411,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,262 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save and compact","_timestamp":1731937847250754,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,262 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save and compact","_timestamp":1731937847250413,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,262 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Detect loops","_timestamp":1731937847250757,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,262 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Total cache size on save = 1936; Diagnostics cache size on save = 112; Graph cache size on save = 112; Parsers cache size on save = 144; Modules table size on save = 4; Times table size on save = 16; Names table size on save = 816; Commands cache size on save = 272;","Mod":"unimp","Sub":"Internal cache stats","Type":"Debug","_timestamp":1731937847250578,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,262 DEBUG (build.ya_make) [Misc-02] Configure message {"HasContentChanges":true,"HasStructuralChanges":true,"_timestamp":1731937847250764,"_typename":"NEvent.TGraphChanges","ymake_run_uid":0} 2024-11-18 13:50:47,262 DEBUG (build.ya_make) [Misc-03] Configure message {"CommandsSize":272,"DiagnosticsCacheSize":112,"GraphCacheSize":112,"ModulesTableSize":4,"NamesTableSize":816,"ParsersCacheSize":144,"TimesTableSize":16,"TotalCacheSize":1936,"_timestamp":1731937847250585,"_typename":"NEvent.TInternalCacheSaverStats","ymake_run_uid":1} 2024-11-18 13:50:47,262 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Detect loops","_timestamp":1731937847250767,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,262 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"FS cache has been saved...\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847250591,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,263 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Apply Dependency Management","_timestamp":1731937847250769,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,263 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Deps cache has been saved...\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847250595,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,263 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save Dependency management cache","_timestamp":1731937847250773,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,263 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save and compact","_timestamp":1731937847251214,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,263 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"DM cache has been saved...\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847250883,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,263 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Detect loops","_timestamp":1731937847251217,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,263 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save Dependency management cache","_timestamp":1731937847250887,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,263 DEBUG (build.ya_make) [Misc-03] Configure message {"HasContentChanges":true,"HasStructuralChanges":true,"_timestamp":1731937847251223,"_typename":"NEvent.TGraphChanges","ymake_run_uid":1} 2024-11-18 13:50:47,263 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Apply Dependency Management","_timestamp":1731937847250889,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,263 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Detect loops","_timestamp":1731937847251225,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,263 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Modules requiring dependency management: 0; BFS traversals performed: 0\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847250891,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,263 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Apply Dependency Management","_timestamp":1731937847251227,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,264 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Fill package outputs","_timestamp":1731937847250895,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,264 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save Dependency management cache","_timestamp":1731937847251232,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,264 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Fill package outputs","_timestamp":1731937847250897,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,264 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"DM cache has been saved...\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847251322,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,264 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1731937847250900,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,264 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save Dependency management cache","_timestamp":1731937847251325,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,264 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1731937847250904,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,264 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Apply Dependency Management","_timestamp":1731937847251327,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,264 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Find missing peerdirs","_timestamp":1731937847250911,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,264 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Modules requiring dependency management: 0; BFS traversals performed: 0\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847251330,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,264 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Find missing peerdirs","_timestamp":1731937847250914,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,265 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Fill package outputs","_timestamp":1731937847251333,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,265 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Export JSON","_timestamp":1731937847250916,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,265 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Fill package outputs","_timestamp":1731937847251335,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,265 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Write JSON","_timestamp":1731937847250920,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,265 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1731937847251338,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,265 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Exporting JSON\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847250924,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,265 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1731937847251342,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,265 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Visit JSON","_timestamp":1731937847250927,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,265 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Find missing peerdirs","_timestamp":1731937847251348,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,265 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Visit JSON","_timestamp":1731937847250936,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,265 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Find missing peerdirs","_timestamp":1731937847251350,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,265 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Render JSON","_timestamp":1731937847250938,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,266 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Export JSON","_timestamp":1731937847251352,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,266 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Write JSON","_timestamp":1731937847251356,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,266 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Store inputs in JSON cache: enabled\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847250946,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,266 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Exporting JSON\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847251359,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,266 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Visit JSON","_timestamp":1731937847251361,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,266 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Visit JSON","_timestamp":1731937847251369,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,266 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":1731937847250965,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,266 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Render JSON","_timestamp":1731937847251371,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,266 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":1731937847250972,"_typename":"NEvent.TJsonCacheStats","ymake_run_uid":0} 2024-11-18 13:50:47,267 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"JSON cache report: disabled\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847250978,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,267 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Store inputs in JSON cache: enabled\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847251377,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,267 DEBUG (build.ya_make) [Misc-02] Configure message {"DoubleValue":0.00004238333531,"Name":"EYmakeStats::RenderJSONTime","Type":"double","_timestamp":1731937847250983,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-18 13:50:47,267 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Render JSON","_timestamp":1731937847250987,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,267 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save Uids cache","_timestamp":1731937847250989,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-18 13:50:47,267 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":1731937847251396,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,267 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Uids cache has been saved...\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847251005,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,267 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":1731937847251403,"_typename":"NEvent.TJsonCacheStats","ymake_run_uid":1} 2024-11-18 13:50:47,267 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save Uids cache","_timestamp":1731937847251008,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,267 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"JSON cache report: disabled\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847251410,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,268 DEBUG (build.ya_make) [Misc-02] Configure message {"HasRenderedNodeChanges":true,"_timestamp":1731937847251017,"_typename":"NEvent.TNodeChanges","ymake_run_uid":0} 2024-11-18 13:50:47,268 DEBUG (build.ya_make) [Misc-03] Configure message {"DoubleValue":0.00004126476374,"Name":"EYmakeStats::RenderJSONTime","Type":"double","_timestamp":1731937847251414,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-18 13:50:47,268 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 = 2; Saved loops = 0; Really all nodes no rendered = 0;","Mod":"unimp","Sub":"Uids cache stats","Type":"Debug","_timestamp":1731937847251026,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,268 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Render JSON","_timestamp":1731937847251418,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,268 DEBUG (build.ya_make) [Misc-02] Configure message {"DiscardedLoops":0,"DiscardedNodes":0,"LoadedLoops":0,"LoadedNodes":0,"SavedLoops":0,"SavedNodes":2,"SkippedLoops":0,"SkippedNodes":0,"_timestamp":1731937847251031,"_typename":"NEvent.TUidsCacheStats","ymake_run_uid":0} 2024-11-18 13:50:47,268 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save Uids cache","_timestamp":1731937847251420,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-18 13:50:47,268 DEBUG (build.ya_make) [Misc-02] Configure message {"DoubleValue":0.0001221182036,"Name":"EYmakeStats::WriteJSONTime","Type":"double","_timestamp":1731937847251045,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-18 13:50:47,268 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Uids cache has been saved...\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847251435,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,268 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Write JSON","_timestamp":1731937847251048,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,268 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save Uids cache","_timestamp":1731937847251438,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,268 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Export JSON","_timestamp":1731937847251050,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,269 DEBUG (build.ya_make) [Misc-03] Configure message {"HasRenderedNodeChanges":true,"_timestamp":1731937847251448,"_typename":"NEvent.TNodeChanges","ymake_run_uid":1} 2024-11-18 13:50:47,269 DEBUG (build.ya_make) [Misc-02] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedUidsCache","Type":"bool","_timestamp":1731937847251053,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-18 13:50:47,269 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 = 2; Saved loops = 0; Really all nodes no rendered = 0;","Mod":"unimp","Sub":"Uids cache stats","Type":"Debug","_timestamp":1731937847251458,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,269 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"module environment initialization calls = 0; actual module environment initializations = 0;","Mod":"unimp","Sub":"TMakeCommand stats","Type":"Debug","_timestamp":1731937847251060,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,269 DEBUG (build.ya_make) [Misc-03] Configure message {"DiscardedLoops":0,"DiscardedNodes":0,"LoadedLoops":0,"LoadedNodes":0,"SavedLoops":0,"SavedNodes":2,"SkippedLoops":0,"SkippedNodes":0,"_timestamp":1731937847251463,"_typename":"NEvent.TUidsCacheStats","ymake_run_uid":1} 2024-11-18 13:50:47,269 DEBUG (build.ya_make) [Misc-02] Configure message {"InitModuleEnv":0,"InitModuleEnvCalls":0,"_timestamp":1731937847251064,"_typename":"NEvent.TMakeCommandStats","ymake_run_uid":0} 2024-11-18 13:50:47,269 DEBUG (build.ya_make) [Misc-03] Configure message {"DoubleValue":0.0001188255605,"Name":"EYmakeStats::WriteJSONTime","Type":"double","_timestamp":1731937847251477,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-18 13:50:47,269 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"FS cache has been committed...\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847253758,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,269 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Write JSON","_timestamp":1731937847251480,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,269 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Deps cache has been committed...\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847253765,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,270 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Export JSON","_timestamp":1731937847251482,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,270 DEBUG (build.ya_make) [Misc-02] Configure message {"_timestamp":1731937847253768,"_typename":"NEvent.TReadyForUpdateCacheInfo","ymake_run_uid":0} 2024-11-18 13:50:47,270 DEBUG (build.ya_make) [Misc-03] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedUidsCache","Type":"bool","_timestamp":1731937847251485,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-18 13:50:47,270 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"DM cache has been committed...\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847253780,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,270 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"module environment initialization calls = 0; actual module environment initializations = 0;","Mod":"unimp","Sub":"TMakeCommand stats","Type":"Debug","_timestamp":1731937847251491,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,270 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Uids cache has been committed...\n","Mod":"unimp","PID":3058,"Sub":"","Type":"Debug","_timestamp":1731937847253790,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-18 13:50:47,270 DEBUG (build.ya_make) [Misc-03] Configure message {"InitModuleEnv":0,"InitModuleEnvCalls":0,"_timestamp":1731937847251495,"_typename":"NEvent.TMakeCommandStats","ymake_run_uid":1} 2024-11-18 13:50:47,270 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"ymake main","_timestamp":1731937847254158,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-18 13:50:47,270 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"FS cache has been committed...\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847254002,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,270 DEBUG (build.ya_make) [Misc-02] Configure message {"DoubleValue":0.353896011,"Name":"EYmakeStats::RunTime","Type":"double","_timestamp":1731937847254163,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-18 13:50:47,270 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Deps cache has been committed...\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847254008,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,271 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"ymake run","_timestamp":1731937847254167,"_typename":"NEvent.TStageFinished","debug_id":"default-linux-x86_64-release-asan-pic","ymake_run_uid":0} 2024-11-18 13:50:47,271 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/1731937846.2955.vieqmrwm/yatmpjrnoj22w --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/1731937846.2955.vieqmrwm/gen_graph.eratwyt3/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1731937846.2955.vieqmrwm/gen_graph.eratwyt3/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' finished 2024-11-18 13:50:47,271 DEBUG (build.ya_make) [Misc-03] Configure message {"_timestamp":1731937847254011,"_typename":"NEvent.TReadyForUpdateCacheInfo","ymake_run_uid":1} 2024-11-18 13:50:47,271 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"DM cache has been committed...\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847254022,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,271 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Uids cache has been committed...\n","Mod":"unimp","PID":3060,"Sub":"","Type":"Debug","_timestamp":1731937847254031,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-18 13:50:47,272 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"ymake main","_timestamp":1731937847254395,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-18 13:50:47,272 DEBUG (build.ymake2) [Misc-02] ymake_run_info: {"ymake_run_uid":0,"stats":{"preparing":{"start":1731937846.89353346824646,"finish":1731937846.894060134887695,"duration":0.000526666641235},"execution":{"start":1731937846.894060850143433,"finish":1731937847.271342277526855,"duration":0.377281427383423},"postprocessing":{"start":1731937847.271345138549805,"finish":1731937847.271682977676392,"duration":0.000337839126587}},"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":1731937846.900229930877686,"finish":1731937847.254167079925537,"duration":0.353937149047852},"Load configuration from cache":{"start":1731937846.900367975234985,"finish":1731937846.90037989616394,"duration":0.000011920928955},"Load configuration (no cache)":{"start":1731937846.900639057159424,"finish":1731937847.05519700050354,"duration":0.154557943344116},"Compile and RecalcAll conditions":{"start":1731937847.055217981338501,"finish":1731937847.056565999984741,"duration":0.00134801864624},"Fold global commands":{"start":1731937847.056577920913696,"finish":1731937847.057761907577515,"duration":0.001183986663818},"Load plugins":{"start":1731937847.057771921157837,"finish":1731937847.172539949417114,"duration":0.114768028259277},"ymake main":{"start":1731937847.203105926513672,"finish":1731937847.254158020019531,"duration":0.051052093505859},"Build graph":{"start":1731937847.204004049301147,"finish":1731937847.2498939037323,"duration":0.045889854431152},"Configure graph":{"start":1731937847.204020023345947,"finish":1731937847.249711036682129,"duration":0.045691013336182},"Find Lost Includes":{"start":1731937847.249737977981567,"finish":1731937847.249747037887573,"duration":0.000009059906006},"Set reachable nodes":{"start":1731937847.249924898147583,"finish":1731937847.249927997589111,"duration":0.000003099441528},"Sort edges":{"start":1731937847.249929904937744,"finish":1731937847.249932050704956,"duration":0.000002145767212},"Report Foreign Platform Events":{"start":1731937847.249933958053589,"finish":1731937847.24993896484375,"duration":0.000005006790161},"Check blacklist":{"start":1731937847.249939918518066,"finish":1731937847.249943017959595,"duration":0.000003099441528},"Check isolated projects":{"start":1731937847.249944925308228,"finish":1731937847.249947071075439,"duration":0.000002145767212},"Report Configure Events":{"start":1731937847.249948978424072,"finish":1731937847.249953031539917,"duration":0.000004053115845},"Save and compact":{"start":1731937847.249953985214233,"finish":1731937847.250754117965698,"duration":0.000800132751465},"Detect loops":{"start":1731937847.250756978988647,"finish":1731937847.25076699256897,"duration":0.000010013580322},"Apply Dependency Management":{"start":1731937847.250768899917603,"finish":1731937847.25088906288147,"duration":0.000120162963867},"Save Dependency management cache":{"start":1731937847.250772953033447,"finish":1731937847.250886917114258,"duration":0.000113964080811},"Fill package outputs":{"start":1731937847.250895023345947,"finish":1731937847.25089693069458,"duration":0.000001907348633},"Check Transitive Requirements":{"start":1731937847.250900030136108,"finish":1731937847.250904083251953,"duration":0.000004053115845},"Find missing peerdirs":{"start":1731937847.250910997390747,"finish":1731937847.250914096832275,"duration":0.000003099441528},"Export JSON":{"start":1731937847.250916004180908,"finish":1731937847.251049995422363,"duration":0.000133991241455},"Write JSON":{"start":1731937847.250920057296753,"finish":1731937847.25104808807373,"duration":0.000128030776978},"Visit JSON":{"start":1731937847.250926971435547,"finish":1731937847.250936031341553,"duration":0.000009059906006},"Render JSON":{"start":1731937847.250937938690186,"finish":1731937847.25098705291748,"duration":0.000049114227295},"Save Uids cache":{"start":1731937847.250988960266113,"finish":1731937847.251008033752441,"duration":0.000019073486328}},"metrics":{"File access":{"loaded size":66,"load time":25,"loaded MD5 time":2,"Max loaded MD5 time":1,"loaded count":2,"max load time":21,"mapped size":0,"mapped MD5 time":0,"Max mapped MD5 time":0,"mapped count":0,"map time":0,"from patch count":0,"from patch size":0,"file stat count":2,"lstat count":2,"lstat sum us":11,"lstat min us":4,"lstat avr us":5,"lstat max us":7,"opendir count":0,"opendir sum us":0,"opendir min us":0,"opendir avr us":0,"opendir max us":0,"readdir count":0,"readdir sum us":0,"readdir min us":0,"readdir avr us":0,"readdir max us":0,"(opendir + readdir) sum us":0,"(lstat + opendir + readdir) sum us":11},"Parsing":{"parse time":0,"parsed files count":0,"parsed files size":0,"parsed files recovered":0,".in files count":0,".in files size":0},"ya.make parsing":{"count":1,"includes count":0,"unique count":1,"size":33,"unique size":33},"DepGraph":{"nodes count":2,"edges count":1,"files count":6,"commands count":16},"UpdIter":{"nuke mod dir":0},"Resolving":{"Includes attempts":0,"From cache":0,"Resolve AsKnown total":0,"Resolve AsKnown from cache":0},"TModules":{"accessed":0,"loaded":0,"outdated":0,"parsed":0,"total":0},"Internal cache":{"Total cache size on save":1936,"Diagnostics cache size on save":112,"Graph cache size on save":112,"Parsers cache size on save":144,"Modules table size on save":4,"Times table size on save":16,"Names table size on save":816,"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":2,"Saved loops":0,"Really all nodes no rendered":0},"TMakeCommand":{"module environment initialization calls":0,"actual module environment initializations":0}},"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/1731937846.2955.vieqmrwm/yatmpjrnoj22w","--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/1731937846.2955.vieqmrwm/gen_graph.eratwyt3/test.dart","--tests-data-root","/home/runner/actions_runner/_work/ydb/arcadia_tests_data","--makefiles-dart","/home/runner/.ya/tmp/1731937846.2955.vieqmrwm/gen_graph.eratwyt3/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.377281427383423} 2024-11-18 13:50:47,272 DEBUG (build.ya_make) [Misc-03] Configure message {"DoubleValue":0.3512024713,"Name":"EYmakeStats::RunTime","Type":"double","_timestamp":1731937847254401,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-18 13:50:47,272 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=load-graph-from-json, group=graph, time=1731937847.272486 2024-11-18 13:50:47,272 DEBUG (core.stages_profiler) [Misc-02] Set stage load-graph-from-json_started=1731937847.272486 2024-11-18 13:50:47,272 DEBUG (core.profiler) [Misc-02] Profile step load-graph-from-json_started - 1731937847.272486 2024-11-18 13:50:47,272 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"ymake run","_timestamp":1731937847254404,"_typename":"NEvent.TStageFinished","debug_id":"default-linux-x86_64-release-asan-nopic","ymake_run_uid":1} 2024-11-18 13:50:47,272 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=load-graph-from-json, group=graph, time=1731937847.2728252 2024-11-18 13:50:47,272 DEBUG (core.stages_profiler) [Misc-02] Set stage load-graph-from-json_finished=1731937847.2728252 2024-11-18 13:50:47,272 DEBUG (core.profiler) [Misc-02] Profile step load-graph-from-json_finished - 1731937847.2728252 2024-11-18 13:50:47,273 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=gen-graph-json-default-linux-x86_64-release-asan-pic, group=graph, time=1731937847.2730153 2024-11-18 13:50:47,273 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/1731937846.2955.vieqmrwm/yatmpvup717lz --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/1731937846.2955.vieqmrwm/gen_graph.irez0doj/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1731937846.2955.vieqmrwm/gen_graph.irez0doj/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' finished 2024-11-18 13:50:47,273 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-json-default-linux-x86_64-release-asan-pic_finished=1731937847.2730153 2024-11-18 13:50:47,273 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-json-default-linux-x86_64-release-asan-pic_finished - 1731937847.2730153 2024-11-18 13:50:47,273 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=gen-graph-default-linux-x86_64-release-asan-pic, group=graph, time=1731937847.27363 2024-11-18 13:50:47,273 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-default-linux-x86_64-release-asan-pic_finished=1731937847.27363 2024-11-18 13:50:47,273 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-default-linux-x86_64-release-asan-pic_finished - 1731937847.27363 2024-11-18 13:50:47,274 DEBUG (core.event_handling.base_subscriber) [Misc-03] Unsubscribing PrintProgressSubscriber from event_queue 2024-11-18 13:50:47,274 DEBUG (build.ymake2) [Misc-03] ymake_run_info: {"ymake_run_uid":1,"stats":{"preparing":{"start":1731937846.897536516189575,"finish":1731937846.898048162460327,"duration":0.000511646270752},"execution":{"start":1731937846.898049116134644,"finish":1731937847.273258209228516,"duration":0.375209093093872},"postprocessing":{"start":1731937847.273259878158569,"finish":1731937847.274303436279297,"duration":0.001043558120728}},"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":1731937846.90316104888916,"finish":1731937847.254404067993164,"duration":0.351243019104004},"Load configuration from cache":{"start":1731937846.903287887573242,"finish":1731937846.903301000595093,"duration":0.000013113021851},"Load configuration (no cache)":{"start":1731937846.903554916381836,"finish":1731937847.056785106658936,"duration":0.1532301902771},"Compile and RecalcAll conditions":{"start":1731937847.056803941726685,"finish":1731937847.05834698677063,"duration":0.001543045043945},"Fold global commands":{"start":1731937847.058358907699585,"finish":1731937847.059489965438843,"duration":0.001131057739258},"Load plugins":{"start":1731937847.059497117996216,"finish":1731937847.173352956771851,"duration":0.113855838775635},"ymake main":{"start":1731937847.203668117523193,"finish":1731937847.254395008087158,"duration":0.050726890563965},"Build graph":{"start":1731937847.204540014266968,"finish":1731937847.250351905822754,"duration":0.045811891555786},"Configure graph":{"start":1731937847.204555988311768,"finish":1731937847.250181913375854,"duration":0.045625925064087},"Find Lost Includes":{"start":1731937847.250204086303711,"finish":1731937847.250211954116821,"duration":0.00000786781311},"Set reachable nodes":{"start":1731937847.250382900238037,"finish":1731937847.250385999679565,"duration":0.000003099441528},"Sort edges":{"start":1731937847.250387907028198,"finish":1731937847.25039005279541,"duration":0.000002145767212},"Report Foreign Platform Events":{"start":1731937847.250391960144043,"finish":1731937847.250396966934204,"duration":0.000005006790161},"Check blacklist":{"start":1731937847.250399112701416,"finish":1731937847.250401020050049,"duration":0.000001907348633},"Check isolated projects":{"start":1731937847.250402927398682,"finish":1731937847.250405073165894,"duration":0.000002145767212},"Report Configure Events":{"start":1731937847.250406980514526,"finish":1731937847.250411033630371,"duration":0.000004053115845},"Save and compact":{"start":1731937847.250412940979004,"finish":1731937847.251214027404785,"duration":0.000801086425781},"Detect loops":{"start":1731937847.251216888427734,"finish":1731937847.251224994659424,"duration":0.000008106231689},"Apply Dependency Management":{"start":1731937847.251226902008057,"finish":1731937847.251327037811279,"duration":0.000100135803223},"Save Dependency management cache":{"start":1731937847.251231908798218,"finish":1731937847.251324892044067,"duration":0.00009298324585},"Fill package outputs":{"start":1731937847.251332998275757,"finish":1731937847.25133490562439,"duration":0.000001907348633},"Check Transitive Requirements":{"start":1731937847.251338005065918,"finish":1731937847.251342058181763,"duration":0.000004053115845},"Find missing peerdirs":{"start":1731937847.25134801864624,"finish":1731937847.251349925994873,"duration":0.000001907348633},"Export JSON":{"start":1731937847.251352071762085,"finish":1731937847.251482009887695,"duration":0.00012993812561},"Write JSON":{"start":1731937847.251355886459351,"finish":1731937847.251480102539062,"duration":0.000124216079712},"Visit JSON":{"start":1731937847.251360893249512,"finish":1731937847.251368999481201,"duration":0.000008106231689},"Render JSON":{"start":1731937847.251370906829834,"finish":1731937847.251418113708496,"duration":0.000047206878662},"Save Uids cache":{"start":1731937847.251420021057129,"finish":1731937847.251437902450562,"duration":0.000017881393433}},"metrics":{"File access":{"loaded size":66,"load time":17,"loaded MD5 time":0,"Max loaded MD5 time":0,"loaded count":2,"max load time":13,"mapped size":0,"mapped MD5 time":0,"Max mapped MD5 time":0,"mapped count":0,"map time":0,"from patch count":0,"from patch size":0,"file stat count":2,"lstat count":2,"lstat sum us":10,"lstat min us":4,"lstat avr us":5,"lstat max us":6,"opendir count":0,"opendir sum us":0,"opendir min us":0,"opendir avr us":0,"opendir max us":0,"readdir count":0,"readdir sum us":0,"readdir min us":0,"readdir avr us":0,"readdir max us":0,"(opendir + readdir) sum us":0,"(lstat + opendir + readdir) sum us":10},"Parsing":{"parse time":0,"parsed files count":0,"parsed files size":0,"parsed files recovered":0,".in files count":0,".in files size":0},"ya.make parsing":{"count":1,"includes count":0,"unique count":1,"size":33,"unique size":33},"DepGraph":{"nodes count":2,"edges count":1,"files count":6,"commands count":16},"UpdIter":{"nuke mod dir":0},"Resolving":{"Includes attempts":0,"From cache":0,"Resolve AsKnown total":0,"Resolve AsKnown from cache":0},"TModules":{"accessed":0,"loaded":0,"outdated":0,"parsed":0,"total":0},"Internal cache":{"Total cache size on save":1936,"Diagnostics cache size on save":112,"Graph cache size on save":112,"Parsers cache size on save":144,"Modules table size on save":4,"Times table size on save":16,"Names table size on save":816,"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":2,"Saved loops":0,"Really all nodes no rendered":0},"TMakeCommand":{"module environment initialization calls":0,"actual module environment initializations":0}},"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/1731937846.2955.vieqmrwm/yatmpvup717lz","--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/1731937846.2955.vieqmrwm/gen_graph.irez0doj/test.dart","--tests-data-root","/home/runner/actions_runner/_work/ydb/arcadia_tests_data","--makefiles-dart","/home/runner/.ya/tmp/1731937846.2955.vieqmrwm/gen_graph.irez0doj/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.375209093093872} 2024-11-18 13:50:47,274 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=load-graph-from-json, group=graph, time=1731937847.2748215 2024-11-18 13:50:47,274 DEBUG (core.stages_profiler) [Misc-03] Set stage load-graph-from-json_started=1731937847.2748215 2024-11-18 13:50:47,274 DEBUG (core.profiler) [Misc-03] Profile step load-graph-from-json_started - 1731937847.2748215 2024-11-18 13:50:47,274 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=load-graph-from-json, group=graph, time=1731937847.2749758 2024-11-18 13:50:47,275 DEBUG (core.stages_profiler) [Misc-03] Set stage load-graph-from-json_finished=1731937847.2749758 2024-11-18 13:50:47,275 DEBUG (core.profiler) [Misc-03] Profile step load-graph-from-json_finished - 1731937847.2749758 2024-11-18 13:50:47,275 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=gen-graph-json-default-linux-x86_64-release-asan-nopic, group=graph, time=1731937847.2751565 2024-11-18 13:50:47,275 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-json-default-linux-x86_64-release-asan-nopic_finished=1731937847.2751565 2024-11-18 13:50:47,275 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-json-default-linux-x86_64-release-asan-nopic_finished - 1731937847.2751565 2024-11-18 13:50:47,275 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=gen-graph-default-linux-x86_64-release-asan-nopic, group=graph, time=1731937847.2753637 2024-11-18 13:50:47,275 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-default-linux-x86_64-release-asan-nopic_finished=1731937847.2753637 2024-11-18 13:50:47,275 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-default-linux-x86_64-release-asan-nopic_finished - 1731937847.2753637 2024-11-18 13:50:47,275 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage waiting_graphs for default-linux-x86_64-release-asan: 0.014912605285644531 2024-11-18 13:50:47,275 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=wait-target-graphs-1, group=graph, time=1731937847.2757068 2024-11-18 13:50:47,275 DEBUG (core.stages_profiler) [MainThread] Set stage wait-target-graphs-1_finished=1731937847.2757068 2024-11-18 13:50:47,275 DEBUG (core.profiler) [MainThread] Profile step wait-target-graphs-1_finished - 1731937847.2757068 2024-11-18 13:50:47,275 DEBUG (core.stage_tracer) [MainThread] Start stage tag=union-make-files-1, group=graph, time=1731937847.2758958 2024-11-18 13:50:47,275 DEBUG (core.stages_profiler) [MainThread] Set stage union-make-files-1_started=1731937847.2758958 2024-11-18 13:50:47,276 DEBUG (core.profiler) [MainThread] Profile step union-make-files-1_started - 1731937847.2758958 2024-11-18 13:50:47,276 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage union make files for default-linux-x86_64-release-asan: 0.00047135353088378906 2024-11-18 13:50:47,276 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=union-make-files-1, group=graph, time=1731937847.2761059 2024-11-18 13:50:47,276 DEBUG (core.stages_profiler) [MainThread] Set stage union-make-files-1_finished=1731937847.2761059 2024-11-18 13:50:47,276 DEBUG (core.profiler) [MainThread] Profile step union-make-files-1_finished - 1731937847.2761059 2024-11-18 13:50:47,276 DEBUG (core.stage_tracer) [MainThread] Start stage tag=merge-graphs-1, group=graph, time=1731937847.2762425 2024-11-18 13:50:47,276 DEBUG (core.stages_profiler) [MainThread] Set stage merge-graphs-1_started=1731937847.2762425 2024-11-18 13:50:47,276 DEBUG (core.profiler) [MainThread] Profile step merge-graphs-1_started - 1731937847.2762425 2024-11-18 13:50:47,276 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage merge_graphs for default-linux-x86_64-release-asan: 0.000316619873046875 2024-11-18 13:50:47,276 DEBUG (build.graph) [MainThread] Graph size is 0 after merge_graphs 2024-11-18 13:50:47,276 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=merge-graphs-1, group=graph, time=1731937847.2765663 2024-11-18 13:50:47,276 DEBUG (core.stages_profiler) [MainThread] Set stage merge-graphs-1_finished=1731937847.2765663 2024-11-18 13:50:47,276 DEBUG (core.profiler) [MainThread] Profile step merge-graphs-1_finished - 1731937847.2765663 2024-11-18 13:50:47,276 DEBUG (core.stage_tracer) [MainThread] Start stage tag=strip-graph-1, group=graph, time=1731937847.2766962 2024-11-18 13:50:47,276 DEBUG (core.stages_profiler) [MainThread] Set stage strip-graph-1_started=1731937847.2766962 2024-11-18 13:50:47,276 DEBUG (core.profiler) [MainThread] Profile step strip-graph-1_started - 1731937847.2766962 2024-11-18 13:50:47,276 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage strip_graph for default-linux-x86_64-release-asan: 0.0004374980926513672 2024-11-18 13:50:47,276 DEBUG (build.graph) [MainThread] Graph size is 0 after strip_graph 2024-11-18 13:50:47,276 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=strip-graph-1, group=graph, time=1731937847.2768905 2024-11-18 13:50:47,276 DEBUG (core.stages_profiler) [MainThread] Set stage strip-graph-1_finished=1731937847.2768905 2024-11-18 13:50:47,276 DEBUG (core.profiler) [MainThread] Profile step strip-graph-1_finished - 1731937847.2768905 2024-11-18 13:50:47,277 DEBUG (build.graph) [MainThread] Configuring only non-PIC for test_tool_tc1-global 2024-11-18 13:50:47,277 DEBUG (core.stage_tracer) [Misc-04] Start stage tag=gen-graph-test_tool_tc1-nopic-global, group=graph, time=1731937847.2774296 2024-11-18 13:50:47,277 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-test_tool_tc1-nopic-global_started=1731937847.2774296 2024-11-18 13:50:47,277 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-test_tool_tc1-nopic-global_started - 1731937847.2774296 2024-11-18 13:50:47,277 DEBUG (core.stage_tracer) [Misc-04] Start stage tag=gen-graph-gen-opts-test_tool_tc1-nopic-global, group=graph, time=1731937847.277843 2024-11-18 13:50:47,277 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-gen-opts-test_tool_tc1-nopic-global_started=1731937847.277843 2024-11-18 13:50:47,277 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-gen-opts-test_tool_tc1-nopic-global_started - 1731937847.277843 2024-11-18 13:50:47,278 DEBUG (yalibrary.guards) [Misc-04] Enter guard fetch with value None 2024-11-18 13:50:47,292 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-18 13:50:47,409 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-18 13:50:47,409 DEBUG (yalibrary.guards) [Misc-04] Exit guard fetch with value None 2024-11-18 13:50:47,409 DEBUG (core.stage_tracer) [Misc-04] Finish stage tag=gen-graph-gen-opts-test_tool_tc1-nopic-global, group=graph, time=1731937847.4096072 2024-11-18 13:50:47,409 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-gen-opts-test_tool_tc1-nopic-global_finished=1731937847.4096072 2024-11-18 13:50:47,409 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-gen-opts-test_tool_tc1-nopic-global_finished - 1731937847.4096072 2024-11-18 13:50:47,409 DEBUG (core.stage_tracer) [Misc-04] Start stage tag=gen-graph-json-test_tool_tc1-nopic-global, group=graph, time=1731937847.409799 2024-11-18 13:50:47,409 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-json-test_tool_tc1-nopic-global_started=1731937847.409799 2024-11-18 13:50:47,409 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-json-test_tool_tc1-nopic-global_started - 1731937847.409799 2024-11-18 13:50:47,409 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 0x7f5277d37060>, 'enabled_events': 'PSLGE', 'no_caches_on_retry': False, 'no_ymake_retry': False, 'disable_customization': 0, 'dump_tests': '/home/runner/.ya/tmp/1731937846.2955.vieqmrwm/gen_graph.rj_uasuk/test.dart', 'dump_make_files': '/home/runner/.ya/tmp/1731937846.2955.vieqmrwm/gen_graph.rj_uasuk/makefiles.dart'} 2024-11-18 13:50:47,410 DEBUG (core.yarg.behaviour) [Misc-04] Found unused args ['grab_stderr'] 2024-11-18 13:50:47,410 DEBUG (build.prefetch) [Misc-04] prefetch disabled 2024-11-18 13:50:47,410 DEBUG (core.event_handling.base_subscriber) [Misc-04] Subscribing PrintProgressSubscriber to event_queue 2024-11-18 13:50:47,410 DEBUG (yalibrary.tools) [Misc-04] Using old-style toolchain for: ymake 2024-11-18 13:50:47,410 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/1731937846.2955.vieqmrwm/yatmpd5qz0nre --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/1731937846.2955.vieqmrwm/gen_graph.rj_uasuk/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1731937846.2955.vieqmrwm/gen_graph.rj_uasuk/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-18 13:50:47,772 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/1731937846.2955.vieqmrwm/yatmpd5qz0nre --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/1731937846.2955.vieqmrwm/gen_graph.rj_uasuk/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1731937846.2955.vieqmrwm/gen_graph.rj_uasuk/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-18 13:50:47,773 DEBUG (core.event_handling.base_subscriber) [Misc-04] Unsubscribing PrintProgressSubscriber from event_queue 2024-11-18 13:50:47,773 DEBUG (build.ymake2) [Misc-04] ymake_run_info: {"ymake_run_uid":2,"stats":{"preparing":{"start":1731937847.410182952880859,"finish":1731937847.410724878311157,"duration":0.000541925430298},"execution":{"start":1731937847.410725355148315,"finish":1731937847.773073673248291,"duration":0.362348318099976},"postprocessing":{"start":1731937847.773076057434082,"finish":1731937847.773428678512573,"duration":0.000352621078491}},"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/1731937846.2955.vieqmrwm/yatmpd5qz0nre","--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/1731937846.2955.vieqmrwm/gen_graph.rj_uasuk/test.dart","--tests-data-root","/home/runner/actions_runner/_work/ydb/arcadia_tests_data","--makefiles-dart","/home/runner/.ya/tmp/1731937846.2955.vieqmrwm/gen_graph.rj_uasuk/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.362348318099976} 2024-11-18 13:50:47,773 DEBUG (core.stage_tracer) [Misc-04] Start stage tag=load-graph-from-json, group=graph, time=1731937847.773847 2024-11-18 13:50:47,773 DEBUG (core.stages_profiler) [Misc-04] Set stage load-graph-from-json_started=1731937847.773847 2024-11-18 13:50:47,773 DEBUG (core.profiler) [Misc-04] Profile step load-graph-from-json_started - 1731937847.773847 2024-11-18 13:50:47,774 DEBUG (core.stage_tracer) [Misc-04] Finish stage tag=load-graph-from-json, group=graph, time=1731937847.774102 2024-11-18 13:50:47,774 DEBUG (core.stages_profiler) [Misc-04] Set stage load-graph-from-json_finished=1731937847.774102 2024-11-18 13:50:47,774 DEBUG (core.profiler) [Misc-04] Profile step load-graph-from-json_finished - 1731937847.774102 2024-11-18 13:50:47,774 DEBUG (core.stage_tracer) [Misc-04] Finish stage tag=gen-graph-json-test_tool_tc1-nopic-global, group=graph, time=1731937847.7742665 2024-11-18 13:50:47,774 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-json-test_tool_tc1-nopic-global_finished=1731937847.7742665 2024-11-18 13:50:47,774 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-json-test_tool_tc1-nopic-global_finished - 1731937847.7742665 2024-11-18 13:50:47,774 DEBUG (core.stage_tracer) [Misc-04] Finish stage tag=gen-graph-test_tool_tc1-nopic-global, group=graph, time=1731937847.7745159 2024-11-18 13:50:47,774 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-test_tool_tc1-nopic-global_finished=1731937847.7745159 2024-11-18 13:50:47,774 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-test_tool_tc1-nopic-global_finished - 1731937847.7745159 2024-11-18 13:50:47,775 DEBUG (core.stage_tracer) [MainThread] Start stage tag=get-graph-1, group=graph, time=1731937847.7751124 2024-11-18 13:50:47,775 DEBUG (core.stages_profiler) [MainThread] Set stage get-graph-1_started=1731937847.7751124 2024-11-18 13:50:47,775 DEBUG (core.profiler) [MainThread] Profile step get-graph-1_started - 1731937847.7751124 2024-11-18 13:50:47,775 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=get-graph-1, group=graph, time=1731937847.7753625 2024-11-18 13:50:47,775 DEBUG (core.stages_profiler) [MainThread] Set stage get-graph-1_finished=1731937847.7753625 2024-11-18 13:50:47,775 DEBUG (core.profiler) [MainThread] Profile step get-graph-1_finished - 1731937847.7753625 2024-11-18 13:50:47,775 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=merge-target-graphs-1, group=graph, time=1731937847.7755318 2024-11-18 13:50:47,775 DEBUG (core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_finished=1731937847.7755318 2024-11-18 13:50:47,775 DEBUG (core.profiler) [MainThread] Profile step merge-target-graphs-1_finished - 1731937847.7755318 2024-11-18 13:50:47,775 DEBUG (core.stage_tracer) [MainThread] Start stage tag=build-merged-graph, group=graph, time=1731937847.7756808 2024-11-18 13:50:47,775 DEBUG (core.stages_profiler) [MainThread] Set stage build-merged-graph_started=1731937847.7756808 2024-11-18 13:50:47,775 DEBUG (core.profiler) [MainThread] Profile step build-merged-graph_started - 1731937847.7756808 2024-11-18 13:50:47,776 DEBUG (core.stage_tracer) [MainThread] Start stage tag=insert-tests-1, group=graph, time=1731937847.7766824 2024-11-18 13:50:47,776 DEBUG (core.stages_profiler) [MainThread] Set stage insert-tests-1_started=1731937847.7766824 2024-11-18 13:50:47,776 DEBUG (core.profiler) [MainThread] Profile step insert-tests-1_started - 1731937847.7766824 2024-11-18 13:50:47,776 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'unsupported cross-compiled tests' on 0 suites 2024-11-18 13:50:47,776 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter '. at 0x7f5277d37060>' on 0 suites 2024-11-18 13:50:47,776 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'size' on 0 suites 2024-11-18 13:50:47,777 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'class type' on 0 suites 2024-11-18 13:50:47,777 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'suite type' on 0 suites 2024-11-18 13:50:47,777 DEBUG (devtools.ya.test.filter) [MainThread] Tags filter include set:[] exclude set:[] 2024-11-18 13:50:47,777 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'tags' on 0 suites 2024-11-18 13:50:47,777 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'project path' on 0 suites 2024-11-18 13:50:47,777 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'filename filter' on 0 suites 2024-11-18 13:50:47,777 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'chunk filter' on 0 suites 2024-11-18 13:50:47,777 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'name' on 0 suites 2024-11-18 13:50:47,777 DEBUG (build.graph) [MainThread] Generating build plan 2024-11-18 13:50:47,777 DEBUG (build.graph) [MainThread] Preparing test suites 2024-11-18 13:50:47,777 DEBUG (build.graph) [MainThread] Stripping clang-tidy irrelevant deps 2024-11-18 13:50:47,777 DEBUG (exts.timer) [MainThread] Timer inject_tests, stage inject tests for default-linux-x86_64-release-asan: 0.0009927749633789062 2024-11-18 13:50:47,777 DEBUG (build.graph) [MainThread] injected 0 tests for default-linux-x86_64-release-asan 2024-11-18 13:50:47,777 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=insert-tests-1, group=graph, time=1731937847.7779186 2024-11-18 13:50:47,777 DEBUG (core.stages_profiler) [MainThread] Set stage insert-tests-1_finished=1731937847.7779186 2024-11-18 13:50:47,778 DEBUG (core.profiler) [MainThread] Profile step insert-tests-1_finished - 1731937847.7779186 2024-11-18 13:50:47,778 DEBUG (core.stage_tracer) [MainThread] Start stage tag=merge-target-graphs-1, group=graph, time=1731937847.7780836 2024-11-18 13:50:47,778 DEBUG (core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_started=1731937847.7780836 2024-11-18 13:50:47,778 DEBUG (core.profiler) [MainThread] Profile step merge-target-graphs-1_started - 1731937847.7780836 2024-11-18 13:50:47,778 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=merge-target-graphs-1, group=graph, time=1731937847.7782063 2024-11-18 13:50:47,778 DEBUG (core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_finished=1731937847.7782063 2024-11-18 13:50:47,778 DEBUG (core.profiler) [MainThread] Profile step merge-target-graphs-1_finished - 1731937847.7782063 2024-11-18 13:50:47,778 DEBUG (core.config) [MainThread] Read config "build/platform/python/ymake_python2/resources.json" from resource 2024-11-18 13:50:47,778 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] python: will use 'linux-x86_64' platform 2024-11-18 13:50:47,778 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/gdb/resources.json 2024-11-18 13:50:47,778 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] gdb: will use 'linux-x86_64' platform 2024-11-18 13:50:47,779 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=build-merged-graph, group=graph, time=1731937847.7790334 2024-11-18 13:50:47,779 DEBUG (core.stages_profiler) [MainThread] Set stage build-merged-graph_finished=1731937847.7790334 2024-11-18 13:50:47,779 DEBUG (core.profiler) [MainThread] Profile step build-merged-graph_finished - 1731937847.7790334 2024-11-18 13:50:47,779 DEBUG (core.stage_tracer) [MainThread] Start stage tag=iter-extra-resources, group=graph, time=1731937847.7791812 2024-11-18 13:50:47,779 DEBUG (core.stages_profiler) [MainThread] Set stage iter-extra-resources_started=1731937847.7791812 2024-11-18 13:50:47,779 DEBUG (core.profiler) [MainThread] Profile step iter-extra-resources_started - 1731937847.7791812 2024-11-18 13:50:47,779 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=iter-extra-resources, group=graph, time=1731937847.7793045 2024-11-18 13:50:47,779 DEBUG (core.stages_profiler) [MainThread] Set stage iter-extra-resources_finished=1731937847.7793045 2024-11-18 13:50:47,779 DEBUG (core.profiler) [MainThread] Profile step iter-extra-resources_finished - 1731937847.7793045 2024-11-18 13:50:47,779 DEBUG (exts.timer) [MainThread] Timer build.graph, stage build and merge graphs: 1.0465595722198486 2024-11-18 13:50:47,779 DEBUG (core.stage_tracer) [MainThread] Start stage tag=strip-graph, group=graph, time=1731937847.7794728 2024-11-18 13:50:47,779 DEBUG (core.stages_profiler) [MainThread] Set stage strip-graph_started=1731937847.7794728 2024-11-18 13:50:47,779 DEBUG (core.profiler) [MainThread] Profile step strip-graph_started - 1731937847.7794728 2024-11-18 13:50:47,779 DEBUG (build.graph) [MainThread] stripped 0, left 0 nodes 2024-11-18 13:50:47,779 DEBUG (exts.timer) [MainThread] Timer build.graph, stage strip graph: 0.00020384788513183594 2024-11-18 13:50:47,779 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=strip-graph, group=graph, time=1731937847.7796705 2024-11-18 13:50:47,779 DEBUG (core.stages_profiler) [MainThread] Set stage strip-graph_finished=1731937847.7796705 2024-11-18 13:50:47,779 DEBUG (core.profiler) [MainThread] Profile step strip-graph_finished - 1731937847.7796705 2024-11-18 13:50:47,779 DEBUG (exts.timer) [MainThread] Timer build.graph, stage gen rename nodes: 0.00017762184143066406 2024-11-18 13:50:47,779 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] python: will use 'linux-x86_64' platform 2024-11-18 13:50:47,780 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ymake: will use 'linux' platform 2024-11-18 13:50:47,780 DEBUG (core.stage_tracer) [MainThread] Start stage tag=inject_default_requirements, group=graph, time=1731937847.7800703 2024-11-18 13:50:47,780 DEBUG (core.stages_profiler) [MainThread] Set stage inject_default_requirements_started=1731937847.7800703 2024-11-18 13:50:47,780 DEBUG (core.profiler) [MainThread] Profile step inject_default_requirements_started - 1731937847.7800703 2024-11-18 13:50:47,780 DEBUG (build.graph) [MainThread] Updated requirements for 0 nodes 2024-11-18 13:50:47,780 DEBUG (exts.timer) [MainThread] Timer substitude_uids, stage substitude_uids: 2.384185791015625e-06 2024-11-18 13:50:47,780 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=inject_default_requirements, group=graph, time=1731937847.780271 2024-11-18 13:50:47,780 DEBUG (core.stages_profiler) [MainThread] Set stage inject_default_requirements_finished=1731937847.780271 2024-11-18 13:50:47,780 DEBUG (core.profiler) [MainThread] Profile step inject_default_requirements_finished - 1731937847.780271 2024-11-18 13:50:47,780 DEBUG (exts.timer) [MainThread] Timer build.graph, stage misc graph changes: 0.000598907470703125 2024-11-18 13:50:47,780 DEBUG (core.stage_tracer) [MainThread] Start stage tag=finalize-graph, group=graph, time=1731937847.7804508 2024-11-18 13:50:47,780 DEBUG (core.stages_profiler) [MainThread] Set stage finalize-graph_started=1731937847.7804508 2024-11-18 13:50:47,780 DEBUG (core.profiler) [MainThread] Profile step finalize-graph_started - 1731937847.7804508 2024-11-18 13:50:47,780 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=finalize-graph, group=graph, time=1731937847.780563 2024-11-18 13:50:47,780 DEBUG (core.stages_profiler) [MainThread] Set stage finalize-graph_finished=1731937847.780563 2024-11-18 13:50:47,780 DEBUG (core.profiler) [MainThread] Profile step finalize-graph_finished - 1731937847.780563 2024-11-18 13:50:47,780 DEBUG (core.stage_tracer) [MainThread] Start stage tag=imprint-store-and-stats, group=graph, time=1731937847.7806869 2024-11-18 13:50:47,780 DEBUG (core.stages_profiler) [MainThread] Set stage imprint-store-and-stats_started=1731937847.7806869 2024-11-18 13:50:47,780 DEBUG (core.profiler) [MainThread] Profile step imprint-store-and-stats_started - 1731937847.7806869 2024-11-18 13:50:47,780 DEBUG (core.imprint.imprint:Imprint) [MainThread] 2024-11-18 13:50:47,780 DEBUG (core.imprint.imprint:Imprint) [MainThread] 2024-11-18 13:50:47,780 DEBUG (core.imprint.imprint:Imprint) [MainThread] 2024-11-18 13:50:47,780 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=imprint-store-and-stats, group=graph, time=1731937847.7809405 2024-11-18 13:50:47,780 DEBUG (core.stages_profiler) [MainThread] Set stage imprint-store-and-stats_finished=1731937847.7809405 2024-11-18 13:50:47,781 DEBUG (core.profiler) [MainThread] Profile step imprint-store-and-stats_finished - 1731937847.7809405 2024-11-18 13:50:47,781 DEBUG (core.stage_tracer) [MainThread] Start stage tag=inject_stats_and_static_uids, group=graph, time=1731937847.7810652 2024-11-18 13:50:47,781 DEBUG (core.stages_profiler) [MainThread] Set stage inject_stats_and_static_uids_started=1731937847.7810652 2024-11-18 13:50:47,781 DEBUG (core.profiler) [MainThread] Profile step inject_stats_and_static_uids_started - 1731937847.7810652 2024-11-18 13:50:47,781 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=inject_stats_and_static_uids, group=graph, time=1731937847.781216 2024-11-18 13:50:47,781 DEBUG (core.stages_profiler) [MainThread] Set stage inject_stats_and_static_uids_finished=1731937847.781216 2024-11-18 13:50:47,781 DEBUG (core.profiler) [MainThread] Profile step inject_stats_and_static_uids_finished - 1731937847.781216 2024-11-18 13:50:47,781 DEBUG (core.stage_tracer) [MainThread] Start stage tag=strip-tags, group=graph, time=1731937847.781342 2024-11-18 13:50:47,781 DEBUG (core.stages_profiler) [MainThread] Set stage strip-tags_started=1731937847.781342 2024-11-18 13:50:47,781 DEBUG (core.profiler) [MainThread] Profile step strip-tags_started - 1731937847.781342 2024-11-18 13:50:47,781 DEBUG (exts.timer) [MainThread] Timer build.graph, stage strip tags: 0.0010526180267333984 2024-11-18 13:50:47,781 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=strip-tags, group=graph, time=1731937847.7814991 2024-11-18 13:50:47,781 DEBUG (core.stages_profiler) [MainThread] Set stage strip-tags_finished=1731937847.7814991 2024-11-18 13:50:47,781 DEBUG (core.profiler) [MainThread] Profile step strip-tags_finished - 1731937847.7814991 2024-11-18 13:50:47,781 DEBUG (core.stage_tracer) [MainThread] Start stage tag=reduce_graph_resources, group=graph, time=1731937847.7817054 2024-11-18 13:50:47,781 DEBUG (core.stages_profiler) [MainThread] Set stage reduce_graph_resources_started=1731937847.7817054 2024-11-18 13:50:47,781 DEBUG (core.profiler) [MainThread] Profile step reduce_graph_resources_started - 1731937847.7817054 2024-11-18 13:50:47,781 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=reduce_graph_resources, group=graph, time=1731937847.7818415 2024-11-18 13:50:47,781 DEBUG (core.stages_profiler) [MainThread] Set stage reduce_graph_resources_finished=1731937847.7818415 2024-11-18 13:50:47,781 DEBUG (core.profiler) [MainThread] Profile step reduce_graph_resources_finished - 1731937847.7818415 2024-11-18 13:50:47,781 DEBUG (core.stage_tracer) [MainThread] Start stage tag=clean-intern-string-storage, group=graph, time=1731937847.7819672 2024-11-18 13:50:47,782 DEBUG (core.stages_profiler) [MainThread] Set stage clean-intern-string-storage_started=1731937847.7819672 2024-11-18 13:50:47,782 DEBUG (core.profiler) [MainThread] Profile step clean-intern-string-storage_started - 1731937847.7819672 2024-11-18 13:50:47,782 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=clean-intern-string-storage, group=graph, time=1731937847.782118 2024-11-18 13:50:47,782 DEBUG (core.stages_profiler) [MainThread] Set stage clean-intern-string-storage_finished=1731937847.782118 2024-11-18 13:50:47,782 DEBUG (core.profiler) [MainThread] Profile step clean-intern-string-storage_finished - 1731937847.782118 2024-11-18 13:50:47,782 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=build_graph_and_tests, group=graph, time=1731937847.782238 2024-11-18 13:50:47,782 DEBUG (core.stages_profiler) [MainThread] Set stage build_graph_and_tests_finished=1731937847.782238 2024-11-18 13:50:47,782 DEBUG (core.profiler) [MainThread] Profile step build_graph_and_tests_finished - 1731937847.782238 2024-11-18 13:50:47,782 DEBUG (exts.timer) [MainThread] Timer context_creation, stage graph_and_tests finished: 1.0804686546325684 2024-11-18 13:50:47,783 DEBUG (core.stage_tracer) [MainThread] Start stage tag=configure-dist-store-cache, group=ya_make, time=1731937847.78386 2024-11-18 13:50:47,783 DEBUG (core.stages_profiler) [MainThread] Set stage configure-dist-store-cache_started=1731937847.78386 2024-11-18 13:50:47,783 DEBUG (core.profiler) [MainThread] Profile step configure-dist-store-cache_started - 1731937847.78386 2024-11-18 13:50:47,784 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=configure-dist-store-cache, group=ya_make, time=1731937847.784034 2024-11-18 13:50:47,784 DEBUG (core.stages_profiler) [MainThread] Set stage configure-dist-store-cache_finished=1731937847.784034 2024-11-18 13:50:47,784 DEBUG (core.profiler) [MainThread] Profile step configure-dist-store-cache_finished - 1731937847.784034 2024-11-18 13:50:47,784 DEBUG (core.stage_tracer) [MainThread] Start stage tag=configure-local-cache, group=ya_make, time=1731937847.784175 2024-11-18 13:50:47,784 DEBUG (core.stages_profiler) [MainThread] Set stage configure-local-cache_started=1731937847.784175 2024-11-18 13:50:47,784 DEBUG (core.profiler) [MainThread] Profile step configure-local-cache_started - 1731937847.784175 2024-11-18 13:50:47,784 DEBUG (build.ya_make) [MainThread] content UIDs forced 2024-11-18 13:50:47,784 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=configure-local-cache, group=ya_make, time=1731937847.7843883 2024-11-18 13:50:47,784 DEBUG (core.stages_profiler) [MainThread] Set stage configure-local-cache_finished=1731937847.7843883 2024-11-18 13:50:47,784 DEBUG (core.profiler) [MainThread] Profile step configure-local-cache_finished - 1731937847.7843883 2024-11-18 13:50:47,784 DEBUG (build.ya_make) [MainThread] sandbox_run_test_uids: set() 2024-11-18 13:50:47,784 DEBUG (build.ya_make) [MainThread] Strip graph due bazel_remote_store mode 2024-11-18 13:50:47,784 DEBUG (build.graph) [MainThread] stripped 0, left 0 nodes 2024-11-18 13:50:47,788 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=context_creation, group=ya_make, time=1731937847.788266 2024-11-18 13:50:47,788 DEBUG (core.stages_profiler) [MainThread] Set stage context_creation_finished=1731937847.788266 2024-11-18 13:50:47,788 DEBUG (core.profiler) [MainThread] Profile step context_creation_finished - 1731937847.788266 2024-11-18 13:50:47,788 DEBUG (exts.timer) [MainThread] Timer context_creation, stage context_creation finished: 0.005973100662231445 2024-11-18 13:50:47,788 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=context_generating, group=build_handler, time=1731937847.7886744 2024-11-18 13:50:47,788 DEBUG (core.stages_profiler) [MainThread] Set stage context_generating_finished=1731937847.7886744 2024-11-18 13:50:47,788 DEBUG (core.profiler) [MainThread] Profile step context_generating_finished - 1731937847.7886744 2024-11-18 13:50:47,788 DEBUG (core.stage_tracer) [MainThread] Start stage tag=build, group=build_handler, time=1731937847.7888353 2024-11-18 13:50:47,788 DEBUG (core.stages_profiler) [MainThread] Set stage build_started=1731937847.7888353 2024-11-18 13:50:47,788 DEBUG (core.profiler) [MainThread] Profile step build_started - 1731937847.7888353 2024-11-18 13:50:47,789 DEBUG (build.reports.autocheck_report) [MainThread] Got 0 tests to report 2024-11-18 13:50:47,789 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2024-11-18 13:50:47,789 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2024-11-18 13:50:47,789 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2024-11-18 13:50:47,789 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2024-11-18 13:50:47,789 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2024-11-18 13:50:47,789 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2024-11-18 13:50:47,789 DEBUG (ReportGenerator) [MainThread] Finish style report 2024-11-18 13:50:47,789 DEBUG (StoredReport) [MainThread] Finish style report 2024-11-18 13:50:47,789 DEBUG (ReportGenerator) [MainThread] Finish tests report, tests by size defaultdict(, {'small': set(), 'medium': set(), 'large': set()}), tests by type defaultdict(, {}) 2024-11-18 13:50:47,789 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2024-11-18 13:50:47,789 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2024-11-18 13:50:47,789 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2024-11-18 13:50:47,789 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2024-11-18 13:50:47,789 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2024-11-18 13:50:47,789 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2024-11-18 13:50:47,789 DEBUG (StoredReport) [MainThread] Finish tests report 2024-11-18 13:50:47,789 DEBUG (ReportGenerator) [MainThread] Finish configure report 2024-11-18 13:50:47,789 DEBUG (StoredReport) [MainThread] Finish configure report 2024-11-18 13:50:47,789 DEBUG (core.stage_tracer) [MainThread] Start stage tag=cache_test_statuses, group=ya_make, time=1731937847.7899375 2024-11-18 13:50:47,789 DEBUG (core.stages_profiler) [MainThread] Set stage cache_test_statuses_started=1731937847.7899375 2024-11-18 13:50:47,790 DEBUG (core.profiler) [MainThread] Profile step cache_test_statuses_started - 1731937847.7899375 2024-11-18 13:50:47,803 DEBUG (yalibrary.store.new_store) [MainThread] Initialized store in /home/runner/.ya/build/cache/trc 2024-11-18 13:50:47,803 DEBUG (yalibrary.store.new_store) [MainThread] Started filtering 2024-11-18 13:50:47,803 DEBUG (library.python.filelock) [MainThread] Acquiring FileLock (blocking=True): /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-18 13:50:47,803 DEBUG (library.python.filelock) [MainThread] Ensuring FileLock released: /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-18 13:50:47,803 DEBUG (yalibrary.store.new_store) [MainThread] Done filtering, retain 0 uids, 0 files 2024-11-18 13:50:47,803 DEBUG (yalibrary.store.new_store) [MainThread] Cleaning size store 2024-11-18 13:50:47,803 DEBUG (yalibrary.store.new_store) [MainThread] Cleaning file store 2024-11-18 13:50:47,805 DEBUG (yalibrary.store.new_store) [MainThread] Cleaning uid store 2024-11-18 13:50:47,812 DEBUG (library.python.filelock) [MainThread] Acquiring FileLock (blocking=True): /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-18 13:50:47,812 DEBUG (library.python.filelock) [MainThread] Ensuring FileLock released: /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-18 13:50:47,813 DEBUG (library.python.filelock) [MainThread] Acquiring FileLock (blocking=True): /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-18 13:50:47,813 DEBUG (library.python.filelock) [MainThread] Ensuring FileLock released: /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-18 13:50:47,813 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=cache_test_statuses, group=ya_make, time=1731937847.8134685 2024-11-18 13:50:47,813 DEBUG (core.stages_profiler) [MainThread] Set stage cache_test_statuses_finished=1731937847.8134685 2024-11-18 13:50:47,813 DEBUG (core.profiler) [MainThread] Profile step cache_test_statuses_finished - 1731937847.8134685 2024-11-18 13:50:47,813 DEBUG (core.stage_tracer) [MainThread] Start stage tag=finalize-reports, group=ya_make, time=1731937847.813727 2024-11-18 13:50:47,813 DEBUG (core.stages_profiler) [MainThread] Set stage finalize-reports_started=1731937847.813727 2024-11-18 13:50:47,813 DEBUG (core.profiler) [MainThread] Profile step finalize-reports_started - 1731937847.813727 2024-11-18 13:50:47,813 DEBUG (build.ya_make) [MainThread] Build is finished, process results 2024-11-18 13:50:47,813 DEBUG (ReportGenerator) [MainThread] Build result is processed, add 0 entries 2024-11-18 13:50:47,813 DEBUG (ReportGenerator) [MainThread] Finish build report 2024-11-18 13:50:47,813 DEBUG (StoredReport) [MainThread] Finish build report 2024-11-18 13:50:47,814 DEBUG (ReportGenerator) [MainThread] Finish tests report, tests by size defaultdict(, {'small': set(), 'medium': set(), 'large': set()}), tests by type defaultdict(, {}) 2024-11-18 13:50:47,814 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2024-11-18 13:50:47,814 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2024-11-18 13:50:47,814 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2024-11-18 13:50:47,814 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2024-11-18 13:50:47,814 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2024-11-18 13:50:47,814 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2024-11-18 13:50:47,814 DEBUG (StoredReport) [MainThread] Finish tests report 2024-11-18 13:50:47,814 DEBUG (ReportGenerator) [MainThread] Finish style report 2024-11-18 13:50:47,814 DEBUG (StoredReport) [MainThread] Finish style report 2024-11-18 13:50:47,814 DEBUG (ReportGenerator) [MainThread] Finish report 2024-11-18 13:50:47,814 DEBUG (StoredReport) [MainThread] Finish report 2024-11-18 13:50:47,814 DEBUG (build.ya_make) [MainThread] Build results listener statistics: {} 2024-11-18 13:50:47,814 DEBUG (build.ya_make) [MainThread] Generating results report 2024-11-18 13:50:47,814 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-18 13:50:47,814 DEBUG (build.reports.autocheck_report) [MainThread] Got 0 tests to report 2024-11-18 13:50:47,814 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2024-11-18 13:50:47,814 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2024-11-18 13:50:47,814 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2024-11-18 13:50:47,815 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2024-11-18 13:50:47,815 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2024-11-18 13:50:47,815 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2024-11-18 13:50:47,815 DEBUG (ReportGenerator) [MainThread] Build result is processed, add 0 entries 2024-11-18 13:50:47,815 DEBUG (build.reports.autocheck_report) [MainThread] builder.opts.report_skipped_suites: False, builder.opts.report_skipped_suites False 2024-11-18 13:50:47,815 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-18 13:50:47,815 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=finalize-reports, group=ya_make, time=1731937847.8153844 2024-11-18 13:50:47,815 DEBUG (core.stages_profiler) [MainThread] Set stage finalize-reports_finished=1731937847.8153844 2024-11-18 13:50:47,815 DEBUG (core.profiler) [MainThread] Profile step finalize-reports_finished - 1731937847.8153844 2024-11-18 13:50:47,817 DEBUG (yalibrary.toolscache) [MainThread] AC cache attempt: (release all data) 2024-11-18 13:50:47,818 DEBUG (yalibrary.toolscache) [MainThread] AC cache (release all data) address: (2537, 19124, 'unix:/home/runner/.ya/build/cache/7/psingtQKTfM.tmp') 2024-11-18 13:50:47,818 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=build, group=build_handler, time=1731937847.8186443 2024-11-18 13:50:47,818 DEBUG (core.stages_profiler) [MainThread] Set stage build_finished=1731937847.8186443 2024-11-18 13:50:47,818 DEBUG (core.profiler) [MainThread] Profile step build_finished - 1731937847.8186443 2024-11-18 13:50:47,818 DEBUG (core.stage_tracer) [MainThread] Start stage tag=dump_results, group=build_handler, time=1731937847.8188467 2024-11-18 13:50:47,818 DEBUG (core.stages_profiler) [MainThread] Set stage dump_results_started=1731937847.8188467 2024-11-18 13:50:47,818 DEBUG (core.profiler) [MainThread] Profile step dump_results_started - 1731937847.8188467 2024-11-18 13:50:47,819 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=dump_results, group=build_handler, time=1731937847.8193116 2024-11-18 13:50:47,819 DEBUG (core.stages_profiler) [MainThread] Set stage dump_results_finished=1731937847.8193116 2024-11-18 13:50:47,819 DEBUG (core.profiler) [MainThread] Profile step dump_results_finished - 1731937847.8193116 2024-11-18 13:50:47,819 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=ya_make_handler, group=build_handler, time=1731937847.8194757 2024-11-18 13:50:47,819 DEBUG (core.stages_profiler) [MainThread] Set stage ya_make_handler_finished=1731937847.8194757 2024-11-18 13:50:47,819 DEBUG (core.profiler) [MainThread] Profile step ya_make_handler_finished - 1731937847.8194757 2024-11-18 13:50:47,819 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=invoke-do_ya_make, group=overall-execution, time=1731937847.8196738 2024-11-18 13:50:47,819 DEBUG (core.stages_profiler) [MainThread] Set stage invoke-do_ya_make_finished=1731937847.8196738 2024-11-18 13:50:47,819 DEBUG (core.profiler) [MainThread] Profile step invoke-do_ya_make_finished - 1731937847.8196738 2024-11-18 13:50:47,820 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "dump_debug" stopped in 0.000185 2024-11-18 13:50:47,820 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "evlog" stopped in 0.000037 2024-11-18 13:50:47,820 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "changelist_store" stopped in 0.000001 2024-11-18 13:50:47,820 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "event_queue" stopped in 0.000003 2024-11-18 13:50:47,820 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "mlockall" stopped in 0.000003 2024-11-18 13:50:47,820 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "profile" stopped in 0.000002 2024-11-18 13:50:47,820 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "showstack" stopped in 0.000017 2024-11-18 13:50:47,820 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher" stopped in 0.000003 2024-11-18 13:50:47,820 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" stopped in 0.000002 2024-11-18 13:50:47,820 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token2" stopped in 0.000002 2024-11-18 13:50:47,820 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "docker_config_path" stopped in 0.000002 2024-11-18 13:50:47,820 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "use_universal_fetcher_everywhere" stopped in 0.000002 2024-11-18 13:50:47,820 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher_params" stopped in 0.000006 2024-11-18 13:50:47,820 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "self_info" stopped in 0.000001 2024-11-18 13:50:47,820 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" stopped in 0.000002 2024-11-18 13:50:47,820 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display_log" stopped in 0.000005 2024-11-18 13:50:47,820 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "custom_file_log" stopped in 0.000008 2024-11-18 13:50:47,820 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display" stopped in 0.000015 2024-11-18 13:50:47,821 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "state" stopped in 0.000006 2024-11-18 13:50:47,821 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token" stopped in 0.000002 2024-11-18 13:50:47,821 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "params" stopped in 0.000001 2024-11-18 13:50:47,821 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-18 13:50:47,821 DEBUG (library.python.tmp) [MainThread] Removing tmp dir /home/runner/.ya/tmp/1731937846.2955.vieqmrwm 2024-11-18 13:50:47,822 DEBUG (library.python.tmp) [MainThread] Reset back TMPDIR=None 2024-11-18 13:50:47,822 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "tmp_dir" stopped in 0.000599 2024-11-18 13:50:47,822 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" stopped in 0.000009 2024-11-18 13:50:47,822 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "env_checker" stopped in 0.000006 2024-11-18 13:50:47,822 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "lifecycle_ts" stopped in 0.000005 2024-11-18 13:50:47,822 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "exit" stopped in 0.000006 2024-11-18 13:50:47,823 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "report" stopped in 0.000976 2024-11-18 13:50:47,823 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" stopped in 0.000006 2024-11-18 13:50:47,823 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "revision" stopped in 0.000004 2024-11-18 13:50:47,823 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "file_in_memory_log" stopped in 0.000005 2024-11-18 13:50:47,823 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display_in_memory_log" stopped in 0.000004 2024-11-18 13:50:47,823 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "file_log" stopped in 0.000007 2024-11-18 13:50:47,823 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "uid" stopped in 0.000003 2024-11-18 13:50:47,823 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Restored ctx dict_keys([])