2024-11-21 10:00:44,588 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "file_in_memory_log" initialized in 0.000014 2024-11-21 10:00:44,589 DEBUG (root) [MainThread] Release revision: 15327756 2024-11-21 10:00:44,589 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "revision" initialized in 0.000751 2024-11-21 10:00:44,589 DEBUG (yalibrary.vcs) [MainThread] detecting vcs from /home/runner/actions_runner/_work/ydb/ydb for paths: None 2024-11-21 10:00:44,589 DEBUG (yalibrary.vcs) [MainThread] common root: /home/runner/actions_runner/_work/ydb/ydb 2024-11-21 10:00:44,589 DEBUG (yalibrary.vcs) [MainThread] vcs root: /home/runner/actions_runner/_work/ydb/ydb (git) 2024-11-21 10:00:44,589 DEBUG (root) [MainThread] vcs type: git 2024-11-21 10:00:44,590 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" initialized in 0.000219 2024-11-21 10:00:44,590 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-21 10:00:44,590 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "report" initialized in 0.000380 2024-11-21 10:00:44,590 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "exit" initialized in 0.000002 2024-11-21 10:00:44,590 DEBUG (root) [MainThread] Start up timestamp 2024-11-21T10:00:44.UTC (2024-11-21T10:00:44.UTC) 2024-11-21 10:00:44,590 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "lifecycle_ts" initialized in 0.000038 2024-11-21 10:00:44,590 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "env_checker" initialized in 0.000005 2024-11-21 10:00:44,591 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" initialized in 0.000392 2024-11-21 10:00:44,591 DEBUG (library.python.tmp) [MainThread] Set TMPDIR=/home/runner/.ya/tmp/1732183244.20575.esmjm5jo instead of None 2024-11-21 10:00:44,591 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "tmp_dir" initialized in 0.000129 2024-11-21 10:00:44,591 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=modules-initialization-early, group=overall-execution, time=1732183244.5912519 2024-11-21 10:00:44,591 DEBUG (core.stages_profiler) [MainThread] Set stage modules-initialization-early_finished=1732183244.5912519 2024-11-21 10:00:44,591 DEBUG (core.profiler) [MainThread] Profile step modules-initialization-early_finished - 1732183244.5912519 2024-11-21 10:00:44,591 DEBUG (core.stage_tracer) [MainThread] Start stage tag=handler-selection, group=overall-execution, time=1732183244.5916605 2024-11-21 10:00:44,591 DEBUG (core.stages_profiler) [MainThread] Set stage handler-selection_started=1732183244.5916605 2024-11-21 10:00:44,591 DEBUG (core.profiler) [MainThread] Profile step handler-selection_started - 1732183244.5916605 2024-11-21 10:00:44,591 DEBUG (core.plugin_loader) [MainThread] Load handlers.make 2024-11-21 10:00:44,603 DEBUG (core.yarg.config_files) [MainThread] Load data from config /home/runner/actions_runner/_work/ydb/ydb/ya.conf 2024-11-21 10:00:44,604 DEBUG (core.yarg.config_files) [MainThread] Found 21 keys 2024-11-21 10:00:44,604 DEBUG (core.yarg.populate) [MainThread] Use config file `/home/runner/actions_runner/_work/ydb/ydb/ya.conf` with `21` keys 2024-11-21 10:00:44,604 DEBUG (core.yarg.populate) [MainThread] No aliases to inject 2024-11-21 10:00:44,604 DEBUG (core.yarg.config_files) [MainThread] Unknown config parameter `incremental_build_dirs_cleanup` 2024-11-21 10:00:44,604 DEBUG (core.yarg.config_files) [MainThread] Unknown config parameter `use_atd_revisions_info` 2024-11-21 10:00:44,605 DEBUG (core.yarg.config_files) [MainThread] Load data from config /home/runner/actions_runner/_work/ydb/ydb/build/internal/ya.conf 2024-11-21 10:00:44,605 DEBUG (core.yarg.config_files) [MainThread] Found 9 keys 2024-11-21 10:00:44,605 DEBUG (core.yarg.populate) [MainThread] Use config file `/home/runner/actions_runner/_work/ydb/ydb/build/internal/ya.conf` with `9` keys 2024-11-21 10:00:44,605 DEBUG (core.yarg.populate) [MainThread] No aliases to inject 2024-11-21 10:00:44,605 DEBUG (core.yarg.config_files) [MainThread] Unknown config parameter `bazel_remote_client_decompress` 2024-11-21 10:00:44,614 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-21 10:00:44,615 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-21 10:00:44,615 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=handler-selection, group=overall-execution, time=1732183244.6159017 2024-11-21 10:00:44,615 DEBUG (core.stages_profiler) [MainThread] Set stage handler-selection_finished=1732183244.6159017 2024-11-21 10:00:44,615 DEBUG (core.profiler) [MainThread] Profile step handler-selection_finished - 1732183244.6159017 2024-11-21 10:00:44,616 DEBUG (core.stage_tracer) [MainThread] Start stage tag=modules-initialization-full, group=overall-execution, time=1732183244.616022 2024-11-21 10:00:44,616 DEBUG (core.stages_profiler) [MainThread] Set stage modules-initialization-full_started=1732183244.616022 2024-11-21 10:00:44,616 DEBUG (core.profiler) [MainThread] Profile step modules-initialization-full_started - 1732183244.616022 2024-11-21 10:00:44,616 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-21 10:00:44,616 DEBUG (core.respawn) [MainThread] Same as prev source root /home/runner/actions_runner/_work/ydb/ydb 2024-11-21 10:00:44,616 DEBUG (core.respawn.pyver) [MainThread] No need to respawn to other ya-bin version 2024-11-21 10:00:44,616 DEBUG (core.respawn) [MainThread] Unsetting YA_STDIN env var as respawn never happened 2024-11-21 10:00:44,616 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "params" initialized in 0.000256 2024-11-21 10:00:44,618 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-21 10:00:44,618 DEBUG (root) [MainThread] Update replacements in 2024-11-21 10:00:44,618 DEBUG (root) [MainThread] Add suppressing formatter to 2024-11-21 10:00:44,618 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-21 10:00:44,618 DEBUG (root) [MainThread] Add suppressing formatter to 2024-11-21 10:00:44,618 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-21 10:00:44,618 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token" initialized in 0.002066 2024-11-21 10:00:44,619 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "state" initialized in 0.000213 2024-11-21 10:00:44,619 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display" initialized in 0.000043 2024-11-21 10:00:44,619 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-21 10:00:44,620 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "custom_file_log" initialized in 0.000840 2024-11-21 10:00:44,620 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display_log" initialized in 0.000032 2024-11-21 10:00:44,620 DEBUG (yalibrary.vcs) [MainThread] detecting vcs from /home/runner/actions_runner/_work/ydb/ydb for paths: None 2024-11-21 10:00:44,620 DEBUG (yalibrary.vcs) [MainThread] common root: /home/runner/actions_runner/_work/ydb/ydb 2024-11-21 10:00:44,620 DEBUG (yalibrary.vcs) [MainThread] vcs root: /home/runner/actions_runner/_work/ydb/ydb (git) 2024-11-21 10:00:44,620 DEBUG (root) [MainThread] vcs type: git 2024-11-21 10:00:44,620 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" initialized in 0.000206 2024-11-21 10:00:44,620 DEBUG (devtools.ya.app) [MainThread] origin: github 2024-11-21 10:00:44,620 DEBUG (devtools.ya.app) [MainThread] python: sys.version_info(major=3, minor=12, micro=7, releaselevel='final', serial=0) 2024-11-21 10:00:44,620 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "self_info" initialized in 0.000096 2024-11-21 10:00:44,620 DEBUG (root) [MainThread] Custom fetcher: None, fetcher parameters: [{'name': 'custom'}, {'name': 'proxy'}, {'name': 'skynet'}, {'name': 'mds'}, {'name': 'sandbox'}], sb_token none 2024-11-21 10:00:44,620 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher_params" initialized in 0.000071 2024-11-21 10:00:44,620 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "use_universal_fetcher_everywhere" initialized in 0.000002 2024-11-21 10:00:44,620 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "docker_config_path" initialized in 0.000001 2024-11-21 10:00:44,621 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-21 10:00:44,621 DEBUG (root) [MainThread] Update replacements in 2024-11-21 10:00:44,621 DEBUG (root) [MainThread] Update replacements in 2024-11-21 10:00:44,621 DEBUG (root) [MainThread] Update replacements in DisplayStreamHandler 2024-11-21 10:00:44,621 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token2" initialized in 0.000968 2024-11-21 10:00:44,621 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" initialized in 0.000075 2024-11-21 10:00:44,621 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher" initialized in 0.000002 2024-11-21 10:00:44,622 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "showstack" initialized in 0.000132 2024-11-21 10:00:44,622 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "profile" initialized in 0.000002 2024-11-21 10:00:44,622 DEBUG (devtools.ya.app) [MainThread] mlockall return code: 12 2024-11-21 10:00:44,622 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "mlockall" initialized in 0.000034 2024-11-21 10:00:44,622 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "event_queue" initialized in 0.000005 2024-11-21 10:00:44,622 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "changelist_store" initialized in 0.000259 2024-11-21 10:00:44,622 DEBUG (root) [MainThread] Event log file is /home/runner/actions_runner/_work/ydb/ydb/tmp/results/try_1/ya_evlog.jsonl 2024-11-21 10:00:44,623 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "evlog" initialized in 0.000378 2024-11-21 10:00:44,661 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "dump_debug" initialized in 0.038909 2024-11-21 10:00:44,662 DEBUG (devtools.ya.app) [MainThread] Run action on with params 2024-11-21 10:00:44,662 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=modules-initialization-full, group=overall-execution, time=1732183244.6625886 2024-11-21 10:00:44,662 DEBUG (core.stages_profiler) [MainThread] Set stage modules-initialization-full_finished=1732183244.6625886 2024-11-21 10:00:44,662 DEBUG (core.profiler) [MainThread] Profile step modules-initialization-full_finished - 1732183244.6625886 2024-11-21 10:00:44,662 DEBUG (core.stage_tracer) [MainThread] Start stage tag=invoke-do_ya_make, group=overall-execution, time=1732183244.6627457 2024-11-21 10:00:44,662 DEBUG (core.stages_profiler) [MainThread] Set stage invoke-do_ya_make_started=1732183244.6627457 2024-11-21 10:00:44,662 DEBUG (core.profiler) [MainThread] Profile step invoke-do_ya_make_started - 1732183244.6627457 2024-11-21 10:00:44,783 DEBUG (core.stage_tracer) [MainThread] Start stage tag=ya_make_handler, group=build_handler, time=1732183244.7835796 2024-11-21 10:00:44,783 DEBUG (core.stages_profiler) [MainThread] Set stage ya_make_handler_started=1732183244.7835796 2024-11-21 10:00:44,783 DEBUG (core.profiler) [MainThread] Profile step ya_make_handler_started - 1732183244.7835796 2024-11-21 10:00:44,783 DEBUG (core.stage_tracer) [MainThread] Start stage tag=context_generating, group=build_handler, time=1732183244.7837887 2024-11-21 10:00:44,783 DEBUG (core.stages_profiler) [MainThread] Set stage context_generating_started=1732183244.7837887 2024-11-21 10:00:44,783 DEBUG (core.profiler) [MainThread] Profile step context_generating_started - 1732183244.7837887 2024-11-21 10:00:44,783 DEBUG (core.stage_tracer) [MainThread] Start stage tag=build_graph_cache_configuration, group=build_handler, time=1732183244.7839048 2024-11-21 10:00:44,783 DEBUG (core.stages_profiler) [MainThread] Set stage build_graph_cache_configuration_started=1732183244.7839048 2024-11-21 10:00:44,783 DEBUG (core.profiler) [MainThread] Profile step build_graph_cache_configuration_started - 1732183244.7839048 2024-11-21 10:00:44,784 DEBUG (build.ya_make) [MainThread] Build graph cache processing started 2024-11-21 10:00:44,784 DEBUG (build.ya_make) [MainThread] Build graph cache processing disabled 2024-11-21 10:00:44,784 DEBUG (build.ya_make) [MainThread] Build graph cache is not available in opensource 2024-11-21 10:00:44,784 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=build_graph_cache_configuration, group=build_handler, time=1732183244.784094 2024-11-21 10:00:44,784 DEBUG (core.stages_profiler) [MainThread] Set stage build_graph_cache_configuration_finished=1732183244.784094 2024-11-21 10:00:44,784 DEBUG (core.profiler) [MainThread] Profile step build_graph_cache_configuration_finished - 1732183244.784094 2024-11-21 10:00:44,784 DEBUG (core.stage_tracer) [MainThread] Start stage tag=context_creation, group=ya_make, time=1732183244.7843087 2024-11-21 10:00:44,784 DEBUG (core.stages_profiler) [MainThread] Set stage context_creation_started=1732183244.7843087 2024-11-21 10:00:44,784 DEBUG (core.profiler) [MainThread] Profile step context_creation_started - 1732183244.7843087 2024-11-21 10:00:44,786 DEBUG (yalibrary.toolscache) [MainThread] Tools cache uses passed opts 2024-11-21 10:00:44,786 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-21 10:00:44,786 DEBUG (build.ya_make) [MainThread] content UIDs enabled by request 2024-11-21 10:00:44,788 DEBUG (build.ya_make) [Misc-00] Using '/tmp/tmp.lDMMv7JmML' file to obtain bazel remote password 2024-11-21 10:00:44,788 DEBUG (core.stage_tracer) [MainThread] Start stage tag=build_graph_and_tests, group=graph, time=1732183244.788886 2024-11-21 10:00:44,789 DEBUG (core.stages_profiler) [MainThread] Set stage build_graph_and_tests_started=1732183244.788886 2024-11-21 10:00:44,789 DEBUG (core.profiler) [MainThread] Profile step build_graph_and_tests_started - 1732183244.788886 2024-11-21 10:00:44,789 DEBUG (build.graph) [Misc-01] Collect vcs info 2024-11-21 10:00:44,789 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/ya.conf.json 2024-11-21 10:00:44,790 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-21 10:00:44,790 DEBUG (yalibrary.vcs) [Misc-01] common root: /home/runner/actions_runner/_work/ydb/ydb 2024-11-21 10:00:44,791 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/platform/clang/clang16.json 2024-11-21 10:00:44,792 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/platform/clang/clang18.json 2024-11-21 10:00:44,794 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-21 10:00:44,794 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-21 10:00:44,794 DEBUG (build.graph) [MainThread] target toolchain: { "bottle_name": "clang18", "env": { "CPATH": [ "" ], "LIBRARY_PATH": [ "" ], "SDKROOT": [ "" ] }, "executable_path": "c++", "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-21 10:00:44,794 DEBUG (yalibrary.vcs) [Misc-01] vcs root: /home/runner/actions_runner/_work/ydb/ydb (git) 2024-11-21 10:00:44,794 DEBUG (yalibrary.tools) [MainThread] Using old-style toolchain for: ymake 2024-11-21 10:00:44,795 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/ymake/public.resources.json 2024-11-21 10:00:44,795 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ymake: try to fetch by {'darwin': {'uri': 'sbr:7478218557'}, 'darwin-arm64': {'uri': 'sbr:7478218228'}, 'linux': {'uri': 'sbr:7478219259'}, 'linux-aarch64': {'uri': 'sbr:7478218007'}, 'win32-clang-cl': {'uri': 'sbr:7478218861'}} for 'linux' 2024-11-21 10:00:44,795 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ymake: will use 'linux' platform 2024-11-21 10:00:44,795 DEBUG (yalibrary.fetcher.resource_fetcher) [MainThread] Fetching 7478219259 from sbr:7478219259 to /home/runner/.ya/tools/v4/7478219259 dir, post_process=0) 2024-11-21 10:00:44,795 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/mapping.conf.json 2024-11-21 10:00:44,797 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/ext_mapping.conf.json 2024-11-21 10:00:44,805 DEBUG (yalibrary.toolscache) [MainThread] Tools cache attempt: (request for resource 7478219259) 2024-11-21 10:00:44,805 DEBUG (yalibrary.toolscache) [MainThread] Tools cache server resource download/parameters 2024-11-21 10:00:44,805 DEBUG (yalibrary.tools) [MainThread] Using old-style toolchain for: ya-tc 2024-11-21 10:00:44,805 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/ya-tc/public.resources.json 2024-11-21 10:00:44,805 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-21 10:00:44,805 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ya-tc: will use 'linux' platform 2024-11-21 10:00:44,805 DEBUG (yalibrary.fetcher.resource_fetcher) [MainThread] Fetching 6812260917 from sbr:6812260917 to /home/runner/.ya/tools/v4/6812260917 dir, post_process=0) 2024-11-21 10:00:44,805 DEBUG (yalibrary.toolscache) [MainThread] tc cache stats: None 2024-11-21 10:00:44,805 DEBUG (yalibrary.fetcher.cache_helper) [MainThread] Resource seems to be installed in /home/runner/.ya/tools/v4/6812260917 2024-11-21 10:00:44,805 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ya-tc: successfully fetched into /home/runner/.ya/tools/v4/6812260917 2024-11-21 10:00:44,805 DEBUG (yalibrary.tools) [MainThread] Using old-style toolchain for: ya-tc 2024-11-21 10:00:44,806 DEBUG (yalibrary.toolscache) [MainThread] tc cache stats: None 2024-11-21 10:00:44,806 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-21 10:00:44,809 DEBUG (yalibrary.toolscache) [MainThread] Tools cache (request for resource 7478219259) address: (20008, 328262, 'unix:/home/runner/.ya/tools/v4/psingIfYrbM.tmp') 2024-11-21 10:00:44,813 DEBUG (yalibrary.toolscache) [MainThread] tc cache stats: TotalKnownSize: 62115840 TotalKnownSizeLocked: 22249472 Master: true TotalDBSize: 81920 ToolCount: 2 ProcessesCount: 2 2024-11-21 10:00:44,814 DEBUG (yalibrary.fetcher.cache_helper) [MainThread] Resource seems to be installed in /home/runner/.ya/tools/v4/7478219259 2024-11-21 10:00:44,814 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ymake: successfully fetched into /home/runner/.ya/tools/v4/7478219259 2024-11-21 10:00:44,814 DEBUG (exts.timer) [MainThread] Timer build.graph, stage fetch ymake: 0.019322872161865234 2024-11-21 10:00:44,814 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=gen-graph-default-linux-x86_64-relwithdebinfo-pic, group=graph, time=1732183244.8146503 2024-11-21 10:00:44,815 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-default-linux-x86_64-relwithdebinfo-pic_started=1732183244.8146503 2024-11-21 10:00:44,815 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-default-linux-x86_64-relwithdebinfo-pic_started - 1732183244.8146503 2024-11-21 10:00:44,815 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=gen-graph-default-linux-x86_64-relwithdebinfo-nopic, group=graph, time=1732183244.8150506 2024-11-21 10:00:44,815 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-default-linux-x86_64-relwithdebinfo-nopic_started=1732183244.8150506 2024-11-21 10:00:44,815 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-default-linux-x86_64-relwithdebinfo-nopic_started - 1732183244.8150506 2024-11-21 10:00:44,815 DEBUG (core.stage_tracer) [MainThread] Start stage tag=get-tools, group=graph, time=1732183244.8153136 2024-11-21 10:00:44,815 DEBUG (core.stages_profiler) [MainThread] Set stage get-tools_started=1732183244.8153136 2024-11-21 10:00:44,816 DEBUG (core.profiler) [MainThread] Profile step get-tools_started - 1732183244.8153136 2024-11-21 10:00:44,816 DEBUG (core.stage_tracer) [MainThread] Start stage tag=waiting-tool-targets, group=graph, time=1732183244.8160822 2024-11-21 10:00:44,816 DEBUG (core.stages_profiler) [MainThread] Set stage waiting-tool-targets_started=1732183244.8160822 2024-11-21 10:00:44,816 DEBUG (core.profiler) [MainThread] Profile step waiting-tool-targets_started - 1732183244.8160822 2024-11-21 10:00:44,816 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-nopic, group=graph, time=1732183244.815818 2024-11-21 10:00:44,816 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-nopic_started=1732183244.815818 2024-11-21 10:00:44,816 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-nopic_started - 1732183244.815818 2024-11-21 10:00:44,816 DEBUG (yalibrary.guards) [Misc-03] Enter guard fetch with value None 2024-11-21 10:00:44,816 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-pic, group=graph, time=1732183244.816277 2024-11-21 10:00:44,816 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-pic_started=1732183244.816277 2024-11-21 10:00:44,816 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-pic_started - 1732183244.816277 2024-11-21 10:00:44,817 DEBUG (yalibrary.guards) [Misc-02] Enter guard fetch with value None 2024-11-21 10:00:44,820 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-21 10:00:44,823 DEBUG (yalibrary.vcs.vcsversion) [Misc-01] b"fatal: no tag exactly matches 'dc2140f19df95aa976f12d5f49541244b94fbd58'\n" Running git describe --exact-match --all HEAD failed with exit code 128 2024-11-21 10:00:44,825 DEBUG (yalibrary.vcs.vcsversion) [Misc-01] Git info commit:b'dc2140f19df95aa976f12d5f49541244b94fbd58', author:b'kruall ', summary:b'Merge ce1dd32c25a19ea33695d86442ccf3cb95a1739c into 59fa9fb62c912101473e75fc1a3d39ba0fe8dc25', svn_id:b'' 2024-11-21 10:00:44,826 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-rcldssy4de Host information: Linux ghrun-rcldssy4de 5.15.0-124-generic #134-Ubuntu SMP Fri Sep 27 20:20:17 UTC 2024 x86_64 2024-11-21 10:00:44,826 DEBUG (build.graph) [Misc-01] Got version json "{\n \"ARCADIA_PATCH_NUMBER\": 1,\n \"ARCADIA_SOURCE_HG_HASH\": \"dc2140f19df95aa976f12d5f49541244b94fbd58\",\n \"ARCADIA_SOURCE_LAST_AUTHOR\": \"kruall \",\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-21T10:00:44.000000Z\",\n \"BUILD_HOST\": \"ghrun-rcldssy4de\",\n \"BUILD_TIMESTAMP\": 1732183244,\n \"BUILD_USER\": \"runner\",\n \"CUSTOM_VERSION\": \"\",\n \"DIRTY\": \"\",\n \"PROGRAM_VERSION\": \"Git info:\\n Commit: dc2140f19df95aa976f12d5f49541244b94fbd58\\n Branch: \\n Author: kruall \\n Summary: Merge ce1dd32c25a19ea33695d86442ccf3cb95a1739c into 59fa9fb62c912101473e75fc1a3d39ba0fe8dc25\\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-rcldssy4de\\n Host information: \\n Linux ghrun-rcldssy4de 5.15.0-124-generic #134-Ubuntu SMP Fri Sep 27 20:20:17 UTC 2024 x86_64\\n\\n \",\n \"RELEASE_VERSION\": \"\",\n \"SCM_DATA\": \"Git info:\\n Commit: dc2140f19df95aa976f12d5f49541244b94fbd58\\n Branch: \\n Author: kruall \\n Summary: Merge ce1dd32c25a19ea33695d86442ccf3cb95a1739c into 59fa9fb62c912101473e75fc1a3d39ba0fe8dc25\\n\",\n \"VCS\": \"git\"\n}" 2024-11-21 10:00:44,826 DEBUG (exts.timer) [Misc-01] Timer get_version_info, stage vcs info: 0.03660082817077637 2024-11-21 10:00:44,848 DEBUG (build.genconf) [Misc-03] Generating conf into /home/runner/.ya/build/conf/dist-relwithdebinfo-a623bf9bc21ce83a2dc96dee3a6452e4/ymake.conf with cmd ['/home/runner/.ya/tools/a6139abb9c_d/ya-bin', '/home/runner/actions_runner/_work/ydb/ydb/build/ymake_conf.py', '/home/runner/actions_runner/_work/ydb/ydb', 'dist-relwithdebinfo', 'no', '--toolchain-params', 'eyJib3R0bGVfbmFtZSI6ImNsYW5nMTgiLCJlbnYiOnsiQ1BBVEgiOlsiIl0sIkxJQlJBUllfUEFUSCI6WyIiXSwiU0RLUk9PVCI6WyIiXX0sImV4ZWN1dGFibGVfcGF0aCI6ImMrKyIsImZvcm11bGEiOnsiYnlfcGxhdGZvcm0iOnsiZGFyd2luLWFybTY0Ijp7InVyaSI6InNicjo3NDUxNjAyNjA5In0sImRhcndpbi14ODZfNjQiOnsidXJpIjoic2JyOjc0NTE1ODU5NjIifSwibGludXgtYWFyY2g2NCI6eyJ1cmkiOiJzYnI6NzQ1MTcxMjMzMiJ9LCJsaW51eC14ODZfNjQiOnsidXJpIjoic2JyOjc0NTE0NjY0MDcifSwid2luMzIteDg2XzY0Ijp7InVyaSI6InNicjo3NDUxNDA2OTAwIn19fSwibmFtZSI6ImNsYW5nMTgiLCJwYXJhbXMiOnsiY19jb21waWxlciI6IiQoQ0xBTkctMTczNTA1NjgyMSkvYmluL2NsYW5nIiwiY3h4X2NvbXBpbGVyIjoiJChDTEFORy0xNzM1MDU2ODIxKS9iaW4vY2xhbmcrKyIsImdjY192ZXJzaW9uIjoiMTgiLCJsbHZtLXN5bWJvbGl6ZXIiOiIkKENMQU5HLTE3MzUwNTY4MjEpL2Jpbi9sbHZtLXN5bWJvbGl6ZXIiLCJtYXRjaF9yb290IjoiQ0xBTkctMTczNTA1NjgyMSIsIm9iamNvcHkiOiIkKENMQU5HLTE3MzUwNTY4MjEpL2Jpbi9sbHZtLW9iamNvcHkiLCJwcm9maWxlcyI6IiQoWENPREVfVE9PTFNfUk9PVC1zYnI6Nzk5MDE3NzcxKS9YY29kZS9Db250ZW50cy9EZXZlbG9wZXIvUGxhdGZvcm1zL2lQaG9uZU9TLnBsYXRmb3JtL0RldmVsb3Blci9MaWJyYXJ5L0NvcmVTaW11bGF0b3IvUHJvZmlsZXMiLCJzaW1jdGwiOiIkKFhDT0RFX1RPT0xTX1JPT1Qtc2JyOjc5OTAxNzc3MSkvWGNvZGUvU3lzdGVtUm9vdC9Qcml2YXRlRnJhbWV3b3Jrcy9Db3JlU2ltdWxhdG9yLmZyYW1ld29yay9SZXNvdXJjZXMvYmluL3NpbWN0bCIsInN0cmlwIjoiJChDTEFORy0xNzM1MDU2ODIxKS9iaW4vbGx2bS1zdHJpcCIsInR5cGUiOiJjbGFuZyIsInVzZV9idW5kbGUiOnRydWUsIndlcnJvcl9tb2RlIjoiYWxsIn0sInBsYXRmb3JtIjp7Imhvc3QiOnsiYXJjaCI6Ing4Nl82NCIsIm9zIjoiTElOVVgiLCJ0b29sY2hhaW4iOiJkZWZhdWx0IiwidmlzaWJsZV9uYW1lIjoiY2xhbmcxOCJ9LCJ0YXJnZXQiOnsiYXJjaCI6Ing4Nl82NCIsIm9zIjoiTElOVVgiLCJ0b29sY2hhaW4iOiJkZWZhdWx0IiwidmlzaWJsZV9uYW1lIjoiY2xhbmcxOCJ9fSwicGxhdGZvcm1fbmFtZSI6IkRFRkFVTFQtTElOVVgtWDg2XzY0IiwidG9vbF92YXIiOiJDTEFORy0xNzM1MDU2ODIxIn0=', '-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', '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-21 10:00:44,849 DEBUG (build.genconf) [Misc-02] Generating conf into /home/runner/.ya/build/conf/dist-relwithdebinfo-f6c361f7cdc7c22d9fbbcaaacb59ed34/ymake.conf with cmd ['/home/runner/.ya/tools/a6139abb9c_d/ya-bin', '/home/runner/actions_runner/_work/ydb/ydb/build/ymake_conf.py', '/home/runner/actions_runner/_work/ydb/ydb', 'dist-relwithdebinfo', 'no', '--toolchain-params', 'eyJib3R0bGVfbmFtZSI6ImNsYW5nMTgiLCJlbnYiOnsiQ1BBVEgiOlsiIl0sIkxJQlJBUllfUEFUSCI6WyIiXSwiU0RLUk9PVCI6WyIiXX0sImV4ZWN1dGFibGVfcGF0aCI6ImMrKyIsImZvcm11bGEiOnsiYnlfcGxhdGZvcm0iOnsiZGFyd2luLWFybTY0Ijp7InVyaSI6InNicjo3NDUxNjAyNjA5In0sImRhcndpbi14ODZfNjQiOnsidXJpIjoic2JyOjc0NTE1ODU5NjIifSwibGludXgtYWFyY2g2NCI6eyJ1cmkiOiJzYnI6NzQ1MTcxMjMzMiJ9LCJsaW51eC14ODZfNjQiOnsidXJpIjoic2JyOjc0NTE0NjY0MDcifSwid2luMzIteDg2XzY0Ijp7InVyaSI6InNicjo3NDUxNDA2OTAwIn19fSwibmFtZSI6ImNsYW5nMTgiLCJwYXJhbXMiOnsiY19jb21waWxlciI6IiQoQ0xBTkctMTczNTA1NjgyMSkvYmluL2NsYW5nIiwiY3h4X2NvbXBpbGVyIjoiJChDTEFORy0xNzM1MDU2ODIxKS9iaW4vY2xhbmcrKyIsImdjY192ZXJzaW9uIjoiMTgiLCJsbHZtLXN5bWJvbGl6ZXIiOiIkKENMQU5HLTE3MzUwNTY4MjEpL2Jpbi9sbHZtLXN5bWJvbGl6ZXIiLCJtYXRjaF9yb290IjoiQ0xBTkctMTczNTA1NjgyMSIsIm9iamNvcHkiOiIkKENMQU5HLTE3MzUwNTY4MjEpL2Jpbi9sbHZtLW9iamNvcHkiLCJwcm9maWxlcyI6IiQoWENPREVfVE9PTFNfUk9PVC1zYnI6Nzk5MDE3NzcxKS9YY29kZS9Db250ZW50cy9EZXZlbG9wZXIvUGxhdGZvcm1zL2lQaG9uZU9TLnBsYXRmb3JtL0RldmVsb3Blci9MaWJyYXJ5L0NvcmVTaW11bGF0b3IvUHJvZmlsZXMiLCJzaW1jdGwiOiIkKFhDT0RFX1RPT0xTX1JPT1Qtc2JyOjc5OTAxNzc3MSkvWGNvZGUvU3lzdGVtUm9vdC9Qcml2YXRlRnJhbWV3b3Jrcy9Db3JlU2ltdWxhdG9yLmZyYW1ld29yay9SZXNvdXJjZXMvYmluL3NpbWN0bCIsInN0cmlwIjoiJChDTEFORy0xNzM1MDU2ODIxKS9iaW4vbGx2bS1zdHJpcCIsInR5cGUiOiJjbGFuZyIsInVzZV9idW5kbGUiOnRydWUsIndlcnJvcl9tb2RlIjoiYWxsIn0sInBsYXRmb3JtIjp7Imhvc3QiOnsiYXJjaCI6Ing4Nl82NCIsIm9zIjoiTElOVVgiLCJ0b29sY2hhaW4iOiJkZWZhdWx0IiwidmlzaWJsZV9uYW1lIjoiY2xhbmcxOCJ9LCJ0YXJnZXQiOnsiYXJjaCI6Ing4Nl82NCIsIm9zIjoiTElOVVgiLCJ0b29sY2hhaW4iOiJkZWZhdWx0IiwidmlzaWJsZV9uYW1lIjoiY2xhbmcxOCJ9fSwicGxhdGZvcm1fbmFtZSI6IkRFRkFVTFQtTElOVVgtWDg2XzY0IiwidG9vbF92YXIiOiJDTEFORy0xNzM1MDU2ODIxIn0=', '-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', '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-21 10:00:44,977 DEBUG (build.genconf) [Misc-02] Copy conf /home/runner/.ya/build/conf/dist-relwithdebinfo-f6c361f7cdc7c22d9fbbcaaacb59ed34/ymake.conf to /home/runner/.ya/build/conf/dist-relwithdebinfo-x-73fab6ec2ddd71b498968faffd57f411/ymake.conf 2024-11-21 10:00:44,977 DEBUG (yalibrary.guards) [Misc-02] Exit guard fetch with value None 2024-11-21 10:00:44,977 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-pic, group=graph, time=1732183244.9777803 2024-11-21 10:00:44,977 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-pic_finished=1732183244.9777803 2024-11-21 10:00:44,977 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-pic_finished - 1732183244.9777803 2024-11-21 10:00:44,978 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=gen-graph-json-default-linux-x86_64-relwithdebinfo-pic, group=graph, time=1732183244.9780242 2024-11-21 10:00:44,978 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-json-default-linux-x86_64-relwithdebinfo-pic_started=1732183244.9780242 2024-11-21 10:00:44,978 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-json-default-linux-x86_64-relwithdebinfo-pic_started - 1732183244.9780242 2024-11-21 10:00:44,978 DEBUG (build.ymake2) [Misc-02] Run gen graph with {'grab_stderr': True, 'mode': 'dist', 'dump_graph': 'json', 'check': True, '_purpose': 'default-linux-x86_64-relwithdebinfo-pic', 'cpp': True, 'custom_build_directory': '/home/runner/.ya/build/conf/dist-relwithdebinfo-x-73fab6ec2ddd71b498968faffd57f411_d357a1f7839b099012272bcb9853ec19', 'build_type': 'relwithdebinfo', 'abs_targets': ['/home/runner/actions_runner/_work/ydb/ydb'], 'debug_options': [], 'custom_conf': '/home/runner/.ya/build/conf/dist-relwithdebinfo-x-73fab6ec2ddd71b498968faffd57f411/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 0x7fb83ed94b80>, 'enabled_events': 'dGT', 'no_caches_on_retry': False, 'no_ymake_retry': False, 'disable_customization': 0, 'dump_tests': '/home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.lku1ngll/test.dart', 'dump_make_files': '/home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.lku1ngll/makefiles.dart'} 2024-11-21 10:00:44,978 DEBUG (core.yarg.behaviour) [Misc-02] Found unused args ['grab_stderr'] 2024-11-21 10:00:44,978 DEBUG (build.prefetch) [Misc-02] prefetch disabled 2024-11-21 10:00:44,978 DEBUG (core.event_handling.base_subscriber) [Misc-02] Subscribing PrintProgressSubscriber to event_queue 2024-11-21 10:00:44,978 DEBUG (build.genconf) [Misc-03] Copy conf /home/runner/.ya/build/conf/dist-relwithdebinfo-a623bf9bc21ce83a2dc96dee3a6452e4/ymake.conf to /home/runner/.ya/build/conf/dist-relwithdebinfo-x-7115d855fe2bcec2cf122cfc3e2a8ccd/ymake.conf 2024-11-21 10:00:44,979 DEBUG (yalibrary.tools) [Misc-02] Using old-style toolchain for: ymake 2024-11-21 10:00:44,979 DEBUG (build.ymake2.run_ymake) [Misc-02] run: '/home/runner/.ya/tools/v4/7478219259/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732183244.20575.esmjm5jo/yatmpiixitrup --config /home/runner/.ya/build/conf/dist-relwithdebinfo-x-73fab6ec2ddd71b498968faffd57f411/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-relwithdebinfo-x-73fab6ec2ddd71b498968faffd57f411_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.lku1ngll/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.lku1ngll/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' with env: { } 2024-11-21 10:00:44,981 DEBUG (yalibrary.guards) [Misc-03] Exit guard fetch with value None 2024-11-21 10:00:44,982 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-nopic, group=graph, time=1732183244.9824057 2024-11-21 10:00:44,982 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-nopic_finished=1732183244.9824057 2024-11-21 10:00:44,982 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-nopic_finished - 1732183244.9824057 2024-11-21 10:00:44,982 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=gen-graph-json-default-linux-x86_64-relwithdebinfo-nopic, group=graph, time=1732183244.982695 2024-11-21 10:00:44,982 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-json-default-linux-x86_64-relwithdebinfo-nopic_started=1732183244.982695 2024-11-21 10:00:44,982 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-json-default-linux-x86_64-relwithdebinfo-nopic_started - 1732183244.982695 2024-11-21 10:00:44,982 DEBUG (build.ymake2) [Misc-03] Run gen graph with {'grab_stderr': True, 'mode': 'dist', 'dump_graph': 'json', 'check': True, '_purpose': 'default-linux-x86_64-relwithdebinfo-nopic', 'cpp': True, 'custom_build_directory': '/home/runner/.ya/build/conf/dist-relwithdebinfo-x-7115d855fe2bcec2cf122cfc3e2a8ccd_d357a1f7839b099012272bcb9853ec19', 'build_type': 'relwithdebinfo', 'abs_targets': ['/home/runner/actions_runner/_work/ydb/ydb'], 'debug_options': [], 'custom_conf': '/home/runner/.ya/build/conf/dist-relwithdebinfo-x-7115d855fe2bcec2cf122cfc3e2a8ccd/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 0x7fb8400ea480>, 'enabled_events': 'dGT', 'no_caches_on_retry': False, 'no_ymake_retry': False, 'disable_customization': 0, 'dump_tests': '/home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.ujf94yj7/test.dart', 'dump_make_files': '/home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.ujf94yj7/makefiles.dart'} 2024-11-21 10:00:44,983 DEBUG (core.yarg.behaviour) [Misc-03] Found unused args ['grab_stderr'] 2024-11-21 10:00:44,983 DEBUG (build.prefetch) [Misc-03] prefetch disabled 2024-11-21 10:00:44,983 DEBUG (yalibrary.tools) [Misc-03] Using old-style toolchain for: ymake 2024-11-21 10:00:44,983 DEBUG (build.ymake2.run_ymake) [Misc-03] run: '/home/runner/.ya/tools/v4/7478219259/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732183244.20575.esmjm5jo/yatmprrwpxcud --config /home/runner/.ya/build/conf/dist-relwithdebinfo-x-7115d855fe2bcec2cf122cfc3e2a8ccd/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-relwithdebinfo-x-7115d855fe2bcec2cf122cfc3e2a8ccd_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.ujf94yj7/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.ujf94yj7/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' with env: { } 2024-11-21 10:00:44,987 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"ymake run","_timestamp":1732183244987092,"_typename":"NEvent.TStageStarted","debug_id":"default-linux-x86_64-relwithdebinfo-pic","ymake_run_uid":0} 2024-11-21 10:00:44,987 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Target path: /home/runner/actions_runner/_work/ydb/ydb\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183244987216,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:44,987 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load configuration from cache","_timestamp":1732183244987257,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:44,987 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Conf cache has not been loaded (reason: File does not exist)...\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183244987266,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:44,988 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load configuration from cache","_timestamp":1732183244987270,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:44,988 DEBUG (build.ya_make) [Misc-02] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedConfCache","Type":"bool","_timestamp":1732183244987518,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:00:44,988 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1732183244987523,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:44,989 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"ymake run","_timestamp":1732183244989760,"_typename":"NEvent.TStageStarted","debug_id":"default-linux-x86_64-relwithdebinfo-nopic","ymake_run_uid":1} 2024-11-21 10:00:44,990 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Target path: /home/runner/actions_runner/_work/ydb/ydb\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183244989871,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:44,990 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load configuration from cache","_timestamp":1732183244989903,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:44,990 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Conf cache has not been loaded (reason: File does not exist)...\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183244989911,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:44,990 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load configuration from cache","_timestamp":1732183244989915,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:44,990 DEBUG (build.ya_make) [Misc-03] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedConfCache","Type":"bool","_timestamp":1732183244990167,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:00:44,990 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1732183244990171,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,146 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1732183245145753,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,146 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1732183245145779,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,147 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1732183245147228,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,147 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Fold global commands","_timestamp":1732183245147240,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,147 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1732183245147320,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,147 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1732183245147339,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,148 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Fold global commands","_timestamp":1732183245148397,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,148 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load plugins","_timestamp":1732183245148405,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,148 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1732183245148654,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,148 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Fold global commands","_timestamp":1732183245148664,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,149 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Fold global commands","_timestamp":1732183245149805,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,149 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load plugins","_timestamp":1732183245149812,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,265 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load plugins","_timestamp":1732183245264910,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,265 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load plugins","_timestamp":1732183245265208,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,294 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"MAIN_OUTPUT_AS_EXTRA enabled\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245294509,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,295 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"MAIN_OUTPUT_AS_EXTRA enabled\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245294877,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,295 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"YMAKE_DEDICATED_MODULE_NODE disabled (by default)\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245294527,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,295 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"YMAKE_DEDICATED_MODULE_NODE disabled (by default)\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245294895,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,295 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"YMAKE_CHECK_FOR_INCORRECT_LOOPS disabled (by default)\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245294532,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,295 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"YMAKE_CHECK_FOR_INCORRECT_LOOPS disabled (by default)\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245294900,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,295 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"mlockall failed\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245294651,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,295 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"mlockall failed\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245294989,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,295 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"ymake main","_timestamp":1732183245294655,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,295 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"ymake main","_timestamp":1732183245294993,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,296 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"FS cache loading is enabled\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245294719,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,296 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"FS cache loading is enabled\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245295038,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,296 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"FS cache saving is enabled\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245294724,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,296 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"FS cache saving is enabled\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245295042,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,296 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Deps cache loading is enabled\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245294727,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,296 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Deps cache loading is enabled\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245295046,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,296 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Deps cache saving is enabled\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245294731,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,296 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Deps cache saving is enabled\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245295050,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,297 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"DepManagement cache loading is enabled\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245294734,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,297 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"DepManagement cache loading is enabled\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245295053,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,297 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"DepManagement cache saving is enabled\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245294737,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,297 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"DepManagement cache saving is enabled\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245295056,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,297 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Uids cache loading is enabled\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245294741,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,297 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Uids cache loading is enabled\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245295060,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,297 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Uids cache saving is enabled\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245294744,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,297 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Uids cache saving is enabled\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245295063,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,297 DEBUG (build.ya_make) [Misc-03] Configure message {"HasChangelist":false,"_timestamp":1732183245295590,"_typename":"NEvent.TArcChanges","ymake_run_uid":1} 2024-11-21 10:00:45,297 DEBUG (build.ya_make) [Misc-02] Configure message {"HasChangelist":false,"_timestamp":1732183245295882,"_typename":"NEvent.TArcChanges","ymake_run_uid":0} 2024-11-21 10:00:45,298 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Graph has structural changes because of PatchPath\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245295597,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,298 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Graph has structural changes because of PatchPath\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245295891,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,298 DEBUG (build.ya_make) [Misc-03] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedFSCache","Type":"bool","_timestamp":1732183245295605,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:00:45,298 DEBUG (build.ya_make) [Misc-02] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedFSCache","Type":"bool","_timestamp":1732183245295898,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:00:45,298 DEBUG (build.ya_make) [Misc-03] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedDepsCache","Type":"bool","_timestamp":1732183245295609,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:00:45,298 DEBUG (build.ya_make) [Misc-02] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedDepsCache","Type":"bool","_timestamp":1732183245295902,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:00:45,298 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Build graph","_timestamp":1732183245295615,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,298 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Build graph","_timestamp":1732183245295906,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,298 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Graph has structural changes because start dirs are different\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245295619,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,298 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Graph has structural changes because start dirs are different\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245295911,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,298 DEBUG (build.ya_make) [Misc-03] Configure message {"PredictsStructuralChanges":true,"_timestamp":1732183245295623,"_typename":"NEvent.TGraphChangesPrediction","ymake_run_uid":1} 2024-11-21 10:00:45,298 DEBUG (build.ya_make) [Misc-02] Configure message {"PredictsStructuralChanges":true,"_timestamp":1732183245295915,"_typename":"NEvent.TGraphChangesPrediction","ymake_run_uid":0} 2024-11-21 10:00:45,299 DEBUG (build.ya_make) [Misc-03] Configure message {"Enabled":false,"MaybeEnabled":false,"_timestamp":1732183245295627,"_typename":"NEvent.TBypassConfigure","ymake_run_uid":1} 2024-11-21 10:00:45,299 DEBUG (build.ya_make) [Misc-02] Configure message {"Enabled":false,"MaybeEnabled":false,"_timestamp":1732183245295918,"_typename":"NEvent.TBypassConfigure","ymake_run_uid":0} 2024-11-21 10:00:45,299 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Configure graph","_timestamp":1732183245295630,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,299 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Configure graph","_timestamp":1732183245295921,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,395 DEBUG (build.ya_make) [Misc-02] Configure message {"DoubleValue":0.09878184205,"Name":"EYmakeStats::ConfigureGraphTime","Type":"double","_timestamp":1732183245394719,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:00:45,395 DEBUG (build.ya_make) [Misc-03] Configure message {"DoubleValue":0.09910474533,"Name":"EYmakeStats::ConfigureGraphTime","Type":"double","_timestamp":1732183245394748,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:00:45,395 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Configure graph","_timestamp":1732183245394745,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,395 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Configure graph","_timestamp":1732183245394769,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,395 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Searching target '.'\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245394755,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,395 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Searching target '.'\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245394778,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,396 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Selected target '$S' with id 3\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245394763,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,396 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Selected target '$S' with id 3\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245394784,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,396 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Find Lost Includes","_timestamp":1732183245394815,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,396 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Find Lost Includes","_timestamp":1732183245394831,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,396 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":20678,"Sub":"","Type":"Debug","_timestamp":1732183245394891,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,396 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":20680,"Sub":"","Type":"Debug","_timestamp":1732183245394905,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,396 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Find Lost Includes","_timestamp":1732183245394895,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,396 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Find Lost Includes","_timestamp":1732183245394908,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,396 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"loaded size = 9023798; load time = 11201; loaded MD5 time = 751; Max loaded MD5 time = 10; loaded count = 2174; max load time = 241; mapped size = 40632376; mapped MD5 time = 8246; Max mapped MD5 time = 529; mapped count = 130; map time = 760; from patch count = 0; from patch size = 0; file stat count = 3223; lstat count = 3045; lstat sum us = 3220; lstat min us = 0; lstat avr us = 1; lstat max us = 13; opendir count = 388; opendir sum us = 0; opendir min us = 0; opendir avr us = 0; opendir max us = 0; readdir count = 2837; readdir sum us = 2172; readdir min us = 0; readdir avr us = 0; readdir max us = 39; (opendir + readdir) sum us = 2172; (lstat + opendir + readdir) sum us = 5392;","Mod":"unimp","Sub":"File access stats","Type":"Debug","_timestamp":1732183245394930,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,397 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"loaded size = 9023798; load time = 11217; loaded MD5 time = 752; Max loaded MD5 time = 5; loaded count = 2174; max load time = 211; mapped size = 40632376; mapped MD5 time = 8385; Max mapped MD5 time = 529; mapped count = 130; map time = 753; from patch count = 0; from patch size = 0; file stat count = 3223; lstat count = 3045; lstat sum us = 3246; lstat min us = 0; lstat avr us = 1; lstat max us = 15; opendir count = 388; opendir sum us = 0; opendir min us = 0; opendir avr us = 0; opendir max us = 0; readdir count = 2837; readdir sum us = 2215; readdir min us = 0; readdir avr us = 0; readdir max us = 39; (opendir + readdir) sum us = 2215; (lstat + opendir + readdir) sum us = 5461;","Mod":"unimp","Sub":"File access stats","Type":"Debug","_timestamp":1732183245394941,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,397 DEBUG (build.ya_make) [Misc-02] Configure message {"FileStatCount":3223,"FromPatchCount":0,"FromPatchSize":0,"ListDirSumUs":2172,"LoadTime":11201,"LoadedCount":2174,"LoadedMD5Time":751,"LoadedSize":9023798,"LstatAvrUs":1,"LstatCount":3045,"LstatListDirSumUs":5392,"LstatMaxUs":13,"LstatMinUs":0,"LstatSumUs":3220,"MapTime":760,"MappedCount":130,"MappedMD5Time":8246,"MappedSize":40632376,"MaxLoadTime":241,"MaxLoadedMD5Time":10,"MaxMappedMD5Time":529,"OpendirAvrUs":0,"OpendirCount":388,"OpendirMaxUs":0,"OpendirMinUs":0,"OpendirSumUs":0,"ReaddirAvrUs":0,"ReaddirCount":2837,"ReaddirMaxUs":39,"ReaddirMinUs":0,"ReaddirSumUs":2172,"_timestamp":1732183245394942,"_typename":"NEvent.TFileConfStats","ymake_run_uid":0} 2024-11-21 10:00:45,397 DEBUG (build.ya_make) [Misc-03] Configure message {"FileStatCount":3223,"FromPatchCount":0,"FromPatchSize":0,"ListDirSumUs":2215,"LoadTime":11217,"LoadedCount":2174,"LoadedMD5Time":752,"LoadedSize":9023798,"LstatAvrUs":1,"LstatCount":3045,"LstatListDirSumUs":5461,"LstatMaxUs":15,"LstatMinUs":0,"LstatSumUs":3246,"MapTime":753,"MappedCount":130,"MappedMD5Time":8385,"MappedSize":40632376,"MaxLoadTime":211,"MaxLoadedMD5Time":5,"MaxMappedMD5Time":529,"OpendirAvrUs":0,"OpendirCount":388,"OpendirMaxUs":0,"OpendirMinUs":0,"OpendirSumUs":0,"ReaddirAvrUs":0,"ReaddirCount":2837,"ReaddirMaxUs":39,"ReaddirMinUs":0,"ReaddirSumUs":2215,"_timestamp":1732183245394953,"_typename":"NEvent.TFileConfStats","ymake_run_uid":1} 2024-11-21 10:00:45,397 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":9023798,"Name":"EFileConfStats::LoadedSize","Type":"int","_timestamp":1732183245394954,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:00:45,397 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":9023798,"Name":"EFileConfStats::LoadedSize","Type":"int","_timestamp":1732183245394964,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:00:45,397 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":11201,"Name":"EFileConfStats::LoadTime","Type":"int","_timestamp":1732183245394958,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:00:45,397 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":11217,"Name":"EFileConfStats::LoadTime","Type":"int","_timestamp":1732183245394968,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:00:45,397 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":2174,"Name":"EFileConfStats::LoadedCount","Type":"int","_timestamp":1732183245394961,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:00:45,397 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":2174,"Name":"EFileConfStats::LoadedCount","Type":"int","_timestamp":1732183245394970,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:00:45,397 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":40632376,"Name":"EFileConfStats::MappedSize","Type":"int","_timestamp":1732183245394963,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:00:45,398 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":40632376,"Name":"EFileConfStats::MappedSize","Type":"int","_timestamp":1732183245394973,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:00:45,398 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":760,"Name":"EFileConfStats::MapTime","Type":"int","_timestamp":1732183245394966,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:00:45,398 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":753,"Name":"EFileConfStats::MapTime","Type":"int","_timestamp":1732183245394976,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:00:45,398 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":130,"Name":"EFileConfStats::MappedCount","Type":"int","_timestamp":1732183245394969,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:00:45,398 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":130,"Name":"EFileConfStats::MappedCount","Type":"int","_timestamp":1732183245394978,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:00:45,398 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":2304,"Name":"EFileConfStats::Count","Type":"int","_timestamp":1732183245394971,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:00:45,398 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":2304,"Name":"EFileConfStats::Count","Type":"int","_timestamp":1732183245394981,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:00:45,398 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"bucket id = 0; loaded size = 9023798; load time = 11201; loaded count = 2174; max load time = 241;","Mod":"unimp","Sub":"Bucket #0","Type":"Debug","_timestamp":1732183245394978,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,398 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"bucket id = 0; loaded size = 9023798; load time = 11217; loaded count = 2174; max load time = 211;","Mod":"unimp","Sub":"Bucket #0","Type":"Debug","_timestamp":1732183245394988,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,398 DEBUG (build.ya_make) [Misc-02] Configure message {"BucketId":0,"LoadTime":11201,"LoadedCount":2174,"LoadedSize":9023798,"MaxLoadTime":241,"_timestamp":1732183245394982,"_typename":"NEvent.TFileConfSubStats","ymake_run_uid":0} 2024-11-21 10:00:45,398 DEBUG (build.ya_make) [Misc-03] Configure message {"BucketId":0,"LoadTime":11217,"LoadedCount":2174,"LoadedSize":9023798,"MaxLoadTime":211,"_timestamp":1732183245394992,"_typename":"NEvent.TFileConfSubStats","ymake_run_uid":1} 2024-11-21 10:00:45,398 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"parse time = 2; parsed files count = 6; parsed files size = 12965; parsed files recovered = 0; .in files count = 0; .in files size = 0;","Mod":"unimp","Sub":"Parsing stats","Type":"Debug","_timestamp":1732183245394993,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,399 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"parse time = 1; parsed files count = 6; parsed files size = 12965; parsed files recovered = 0; .in files count = 0; .in files size = 0;","Mod":"unimp","Sub":"Parsing stats","Type":"Debug","_timestamp":1732183245395002,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,399 DEBUG (build.ya_make) [Misc-02] Configure message {"InFilesCount":0,"InFilesSize":0,"ParseTime":2,"ParsedFilesCount":6,"ParsedFilesRecovered":0,"ParsedFilesSize":12965,"_timestamp":1732183245394997,"_typename":"NEvent.TIncParserManagerStats","ymake_run_uid":0} 2024-11-21 10:00:45,399 DEBUG (build.ya_make) [Misc-03] Configure message {"InFilesCount":0,"InFilesSize":0,"ParseTime":1,"ParsedFilesCount":6,"ParsedFilesRecovered":0,"ParsedFilesSize":12965,"_timestamp":1732183245395007,"_typename":"NEvent.TIncParserManagerStats","ymake_run_uid":1} 2024-11-21 10:00:45,399 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"count = 8; includes count = 12; unique count = 8; size = 1264; unique size = 853;","Mod":"unimp","Sub":"ya.make parsing stats","Type":"Debug","_timestamp":1732183245395010,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,399 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"count = 8; includes count = 12; unique count = 8; size = 1264; unique size = 853;","Mod":"unimp","Sub":"ya.make parsing stats","Type":"Debug","_timestamp":1732183245395018,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,399 DEBUG (build.ya_make) [Misc-02] Configure message {"Count":8,"Includes":12,"Size":1264,"UniqueCount":8,"UniqueSize":853,"_timestamp":1732183245395014,"_typename":"NEvent.TGeneralParserStats","ymake_run_uid":0} 2024-11-21 10:00:45,399 DEBUG (build.ya_make) [Misc-03] Configure message {"Count":8,"Includes":12,"Size":1264,"UniqueCount":8,"UniqueSize":853,"_timestamp":1732183245395022,"_typename":"NEvent.TGeneralParserStats","ymake_run_uid":1} 2024-11-21 10:00:45,399 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"nodes count = 2825; edges count = 12363; files count = 3263; commands count = 142;","Mod":"unimp","Sub":"DepGraph stats","Type":"Debug","_timestamp":1732183245395029,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,399 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"nodes count = 2825; edges count = 12363; files count = 3263; commands count = 142;","Mod":"unimp","Sub":"DepGraph stats","Type":"Debug","_timestamp":1732183245395036,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,399 DEBUG (build.ya_make) [Misc-02] Configure message {"CommandsCount":142,"EdgesCount":12363,"FilesCount":3263,"NodesCount":2825,"_timestamp":1732183245395032,"_typename":"NEvent.TDepGraphStats","ymake_run_uid":0} 2024-11-21 10:00:45,400 DEBUG (build.ya_make) [Misc-03] Configure message {"CommandsCount":142,"EdgesCount":12363,"FilesCount":3263,"NodesCount":2825,"_timestamp":1732183245395040,"_typename":"NEvent.TDepGraphStats","ymake_run_uid":1} 2024-11-21 10:00:45,400 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"nuke mod dir = 0;","Mod":"unimp","Sub":"UpdIter stats","Type":"Debug","_timestamp":1732183245395037,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,400 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"nuke mod dir = 0;","Mod":"unimp","Sub":"UpdIter stats","Type":"Debug","_timestamp":1732183245395045,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,400 DEBUG (build.ya_make) [Misc-02] Configure message {"NukedDir":0,"_timestamp":1732183245395041,"_typename":"NEvent.TUpdIterStats","ymake_run_uid":0} 2024-11-21 10:00:45,400 DEBUG (build.ya_make) [Misc-03] Configure message {"NukedDir":0,"_timestamp":1732183245395048,"_typename":"NEvent.TUpdIterStats","ymake_run_uid":1} 2024-11-21 10:00:45,400 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":1732183245395048,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,400 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":1732183245395055,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,400 DEBUG (build.ya_make) [Misc-02] Configure message {"IncludesAttempted":0,"IncludesFromCache":0,"ResolveAsKnownFromCache":0,"ResolveAsKnownTotal":0,"_timestamp":1732183245395052,"_typename":"NEvent.TResolveStats","ymake_run_uid":0} 2024-11-21 10:00:45,400 DEBUG (build.ya_make) [Misc-03] Configure message {"IncludesAttempted":0,"IncludesFromCache":0,"ResolveAsKnownFromCache":0,"ResolveAsKnownTotal":0,"_timestamp":1732183245395059,"_typename":"NEvent.TResolveStats","ymake_run_uid":1} 2024-11-21 10:00:45,400 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Build graph","_timestamp":1732183245395055,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,400 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Build graph","_timestamp":1732183245395062,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,401 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"accessed = 19; loaded = 0; outdated = 0; parsed = 19; total = 19;","Mod":"unimp","Sub":"TModules stats","Type":"Debug","_timestamp":1732183245395156,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,401 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"accessed = 19; loaded = 0; outdated = 0; parsed = 19; total = 19;","Mod":"unimp","Sub":"TModules stats","Type":"Debug","_timestamp":1732183245395152,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,401 DEBUG (build.ya_make) [Misc-02] Configure message {"Accessed":19,"Loaded":0,"Outdated":0,"Parsed":19,"Total":19,"_timestamp":1732183245395160,"_typename":"NEvent.TModulesStats","ymake_run_uid":0} 2024-11-21 10:00:45,401 DEBUG (build.ya_make) [Misc-03] Configure message {"Accessed":19,"Loaded":0,"Outdated":0,"Parsed":19,"Total":19,"_timestamp":1732183245395157,"_typename":"NEvent.TModulesStats","ymake_run_uid":1} 2024-11-21 10:00:45,401 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":19,"Name":"EModulesStats::Accessed","Type":"int","_timestamp":1732183245395164,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:00:45,401 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":19,"Name":"EModulesStats::Accessed","Type":"int","_timestamp":1732183245395161,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:00:45,401 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":0,"Name":"EModulesStats::Loaded","Type":"int","_timestamp":1732183245395167,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:00:45,401 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":0,"Name":"EModulesStats::Loaded","Type":"int","_timestamp":1732183245395164,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:00:45,401 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":0,"Name":"EModulesStats::Outdated","Type":"int","_timestamp":1732183245395170,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:00:45,401 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":0,"Name":"EModulesStats::Outdated","Type":"int","_timestamp":1732183245395166,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:00:45,401 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":19,"Name":"EModulesStats::Parsed","Type":"int","_timestamp":1732183245395172,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:00:45,401 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":19,"Name":"EModulesStats::Parsed","Type":"int","_timestamp":1732183245395169,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:00:45,402 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Set reachable nodes","_timestamp":1732183245395181,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,402 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Set reachable nodes","_timestamp":1732183245395178,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,402 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Set reachable nodes","_timestamp":1732183245395743,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,402 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Set reachable nodes","_timestamp":1732183245395731,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,402 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Sort edges","_timestamp":1732183245395745,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,402 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Sort edges","_timestamp":1732183245395734,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,402 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Sort edges","_timestamp":1732183245398241,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,402 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Sort edges","_timestamp":1732183245398237,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,402 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1732183245398245,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,402 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1732183245398240,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,403 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1732183245398292,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,403 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1732183245398287,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,403 DEBUG (_ToolTargetsQueue) [MainThread] Source_id=0 (default-linux-x86_64-relwithdebinfo-pic). Tool targets: set() 2024-11-21 10:00:45,403 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check blacklist","_timestamp":1732183245398293,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,403 DEBUG (_ToolTargetsQueue) [MainThread] Source_id=1 (default-linux-x86_64-relwithdebinfo-nopic). Tool targets: set() 2024-11-21 10:00:45,403 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check blacklist","_timestamp":1732183245398289,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,403 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=waiting-tool-targets, group=graph, time=1732183245.4036117 2024-11-21 10:00:45,403 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check blacklist","_timestamp":1732183245398291,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,403 DEBUG (core.stages_profiler) [MainThread] Set stage waiting-tool-targets_finished=1732183245.4036117 2024-11-21 10:00:45,403 DEBUG (core.profiler) [MainThread] Profile step waiting-tool-targets_finished - 1732183245.4036117 2024-11-21 10:00:45,404 DEBUG (build.graph) [MainThread] Empty tool targets list 2024-11-21 10:00:45,404 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=get-tools, group=graph, time=1732183245.4041004 2024-11-21 10:00:45,404 DEBUG (core.stages_profiler) [MainThread] Set stage get-tools_finished=1732183245.4041004 2024-11-21 10:00:45,404 DEBUG (core.profiler) [MainThread] Profile step get-tools_finished - 1732183245.4041004 2024-11-21 10:00:45,404 DEBUG (core.stage_tracer) [MainThread] Start stage tag=merge-target-graphs-1, group=graph, time=1732183245.4042807 2024-11-21 10:00:45,404 DEBUG (core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_started=1732183245.4042807 2024-11-21 10:00:45,404 DEBUG (core.profiler) [MainThread] Profile step merge-target-graphs-1_started - 1732183245.4042807 2024-11-21 10:00:45,404 DEBUG (core.stage_tracer) [MainThread] Start stage tag=wait-target-graphs-1, group=graph, time=1732183245.4044683 2024-11-21 10:00:45,404 DEBUG (core.stages_profiler) [MainThread] Set stage wait-target-graphs-1_started=1732183245.4044683 2024-11-21 10:00:45,404 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check isolated projects","_timestamp":1732183245398293,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,404 DEBUG (core.profiler) [MainThread] Profile step wait-target-graphs-1_started - 1732183245.4044683 2024-11-21 10:00:45,404 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check blacklist","_timestamp":1732183245398296,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,404 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check isolated projects","_timestamp":1732183245398295,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,404 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check isolated projects","_timestamp":1732183245398298,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,405 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Report Configure Events","_timestamp":1732183245398297,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,405 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check isolated projects","_timestamp":1732183245398300,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,405 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Report Configure Events","_timestamp":1732183245398350,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,405 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Report Configure Events","_timestamp":1732183245398302,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,405 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save and compact","_timestamp":1732183245398352,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,405 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Report Configure Events","_timestamp":1732183245398355,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,405 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save and compact","_timestamp":1732183245398357,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,405 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Total cache size on save = 428512; Diagnostics cache size on save = 112; Graph cache size on save = 91616; Parsers cache size on save = 224; Modules table size on save = 3079; Times table size on save = 16; Names table size on save = 332624; Commands cache size on save = 272;","Mod":"unimp","Sub":"Internal cache stats","Type":"Debug","_timestamp":1732183245399247,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,405 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Total cache size on save = 428512; Diagnostics cache size on save = 112; Graph cache size on save = 91616; Parsers cache size on save = 224; Modules table size on save = 3079; Times table size on save = 16; Names table size on save = 332624; Commands cache size on save = 272;","Mod":"unimp","Sub":"Internal cache stats","Type":"Debug","_timestamp":1732183245399243,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,405 DEBUG (build.ya_make) [Misc-03] Configure message {"CommandsSize":272,"DiagnosticsCacheSize":112,"GraphCacheSize":91616,"ModulesTableSize":3079,"NamesTableSize":332624,"ParsersCacheSize":224,"TimesTableSize":16,"TotalCacheSize":428512,"_timestamp":1732183245399258,"_typename":"NEvent.TInternalCacheSaverStats","ymake_run_uid":1} 2024-11-21 10:00:45,405 DEBUG (build.ya_make) [Misc-02] Configure message {"CommandsSize":272,"DiagnosticsCacheSize":112,"GraphCacheSize":91616,"ModulesTableSize":3079,"NamesTableSize":332624,"ParsersCacheSize":224,"TimesTableSize":16,"TotalCacheSize":428512,"_timestamp":1732183245399254,"_typename":"NEvent.TInternalCacheSaverStats","ymake_run_uid":0} 2024-11-21 10:00:45,406 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"FS cache has been saved...\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245399265,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,406 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"FS cache has been saved...\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245399261,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,406 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Deps cache has been saved...\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245399270,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,406 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Deps cache has been saved...\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245399266,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,406 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save and compact","_timestamp":1732183245400489,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,406 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save and compact","_timestamp":1732183245400334,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,406 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Detect loops","_timestamp":1732183245400494,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,406 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Detect loops","_timestamp":1732183245400338,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,406 DEBUG (build.ya_make) [Misc-03] Configure message {"HasContentChanges":true,"HasStructuralChanges":true,"_timestamp":1732183245400919,"_typename":"NEvent.TGraphChanges","ymake_run_uid":1} 2024-11-21 10:00:45,406 DEBUG (build.ya_make) [Misc-02] Configure message {"HasContentChanges":true,"HasStructuralChanges":true,"_timestamp":1732183245400735,"_typename":"NEvent.TGraphChanges","ymake_run_uid":0} 2024-11-21 10:00:45,406 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Detect loops","_timestamp":1732183245400949,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,407 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Detect loops","_timestamp":1732183245400765,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,407 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Apply Dependency Management","_timestamp":1732183245400952,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,407 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Apply Dependency Management","_timestamp":1732183245400768,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,407 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save Dependency management cache","_timestamp":1732183245401368,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,407 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save Dependency management cache","_timestamp":1732183245401186,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,407 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"DM cache has been saved...\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245401486,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,407 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"DM cache has been saved...\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245401305,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,407 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save Dependency management cache","_timestamp":1732183245401490,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,407 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save Dependency management cache","_timestamp":1732183245401310,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,407 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Apply Dependency Management","_timestamp":1732183245401492,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,407 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Apply Dependency Management","_timestamp":1732183245401312,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,407 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Modules requiring dependency management: 0; BFS traversals performed: 0\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245401495,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,408 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Modules requiring dependency management: 0; BFS traversals performed: 0\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245401315,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,408 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Fill package outputs","_timestamp":1732183245401527,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,408 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Fill package outputs","_timestamp":1732183245401346,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,408 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Fill package outputs","_timestamp":1732183245401529,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,408 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Fill package outputs","_timestamp":1732183245401348,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,408 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1732183245401533,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,408 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1732183245401352,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,408 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1732183245401673,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,408 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1732183245401491,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,408 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Find missing peerdirs","_timestamp":1732183245401694,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,408 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Find missing peerdirs","_timestamp":1732183245401515,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,408 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Find missing peerdirs","_timestamp":1732183245402336,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,408 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Find missing peerdirs","_timestamp":1732183245402172,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,409 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Export JSON","_timestamp":1732183245402392,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,409 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Export JSON","_timestamp":1732183245402234,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,409 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Write JSON","_timestamp":1732183245402396,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,409 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Write JSON","_timestamp":1732183245402240,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,409 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Exporting JSON\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245402401,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,409 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Exporting JSON\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245402245,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,409 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Visit JSON","_timestamp":1732183245402404,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,409 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Visit JSON","_timestamp":1732183245402249,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,409 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Visit JSON","_timestamp":1732183245405299,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,409 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Visit JSON","_timestamp":1732183245405106,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,410 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Render JSON","_timestamp":1732183245405304,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,410 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Render JSON","_timestamp":1732183245405110,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,410 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Store inputs in JSON cache: enabled\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245405314,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,410 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Store inputs in JSON cache: enabled\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245405122,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,412 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":1732183245412163,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,412 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":1732183245412171,"_typename":"NEvent.TJsonCacheStats","ymake_run_uid":0} 2024-11-21 10:00:45,412 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":1732183245412358,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,412 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"JSON cache report: disabled\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245412179,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,412 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":1732183245412366,"_typename":"NEvent.TJsonCacheStats","ymake_run_uid":1} 2024-11-21 10:00:45,412 DEBUG (build.ya_make) [Misc-02] Configure message {"DoubleValue":0.007073372334,"Name":"EYmakeStats::RenderJSONTime","Type":"double","_timestamp":1732183245412188,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:00:45,413 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"JSON cache report: disabled\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245412374,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,413 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Render JSON","_timestamp":1732183245412193,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,413 DEBUG (build.ya_make) [Misc-03] Configure message {"DoubleValue":0.007074129064,"Name":"EYmakeStats::RenderJSONTime","Type":"double","_timestamp":1732183245412382,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:00:45,413 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save Uids cache","_timestamp":1732183245412196,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:00:45,413 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Render JSON","_timestamp":1732183245412387,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,413 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Uids cache has been saved...\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245412953,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,413 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save Uids cache","_timestamp":1732183245412389,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:00:45,413 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save Uids cache","_timestamp":1732183245412959,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,413 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Uids cache has been saved...\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245413146,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,413 DEBUG (build.ya_make) [Misc-02] Configure message {"HasRenderedNodeChanges":true,"_timestamp":1732183245412970,"_typename":"NEvent.TNodeChanges","ymake_run_uid":0} 2024-11-21 10:00:45,413 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save Uids cache","_timestamp":1732183245413152,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,413 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Loaded nodes = 0; Skipped nodes = 0; Discarded nodes = 0; Loaded loops = 0; Skipped loops = 0; Discarded loops = 0; Saved nodes = 2392; Saved loops = 0; Really all nodes no rendered = 0;","Mod":"unimp","Sub":"Uids cache stats","Type":"Debug","_timestamp":1732183245412982,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,414 DEBUG (build.ya_make) [Misc-03] Configure message {"HasRenderedNodeChanges":true,"_timestamp":1732183245413162,"_typename":"NEvent.TNodeChanges","ymake_run_uid":1} 2024-11-21 10:00:45,414 DEBUG (build.ya_make) [Misc-02] Configure message {"DiscardedLoops":0,"DiscardedNodes":0,"LoadedLoops":0,"LoadedNodes":0,"SavedLoops":0,"SavedNodes":2392,"SkippedLoops":0,"SkippedNodes":0,"_timestamp":1732183245412988,"_typename":"NEvent.TUidsCacheStats","ymake_run_uid":0} 2024-11-21 10:00:45,414 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Loaded nodes = 0; Skipped nodes = 0; Discarded nodes = 0; Loaded loops = 0; Skipped loops = 0; Discarded loops = 0; Saved nodes = 2392; Saved loops = 0; Really all nodes no rendered = 0;","Mod":"unimp","Sub":"Uids cache stats","Type":"Debug","_timestamp":1732183245413174,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,414 DEBUG (build.ya_make) [Misc-02] Configure message {"DoubleValue":0.01081308882,"Name":"EYmakeStats::WriteJSONTime","Type":"double","_timestamp":1732183245413056,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:00:45,414 DEBUG (build.ya_make) [Misc-03] Configure message {"DiscardedLoops":0,"DiscardedNodes":0,"LoadedLoops":0,"LoadedNodes":0,"SavedLoops":0,"SavedNodes":2392,"SkippedLoops":0,"SkippedNodes":0,"_timestamp":1732183245413180,"_typename":"NEvent.TUidsCacheStats","ymake_run_uid":1} 2024-11-21 10:00:45,414 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Write JSON","_timestamp":1732183245413060,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,415 DEBUG (build.ya_make) [Misc-03] Configure message {"DoubleValue":0.01085648867,"Name":"EYmakeStats::WriteJSONTime","Type":"double","_timestamp":1732183245413256,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:00:45,415 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Export JSON","_timestamp":1732183245413081,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,415 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Write JSON","_timestamp":1732183245413261,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,415 DEBUG (build.ya_make) [Misc-02] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedUidsCache","Type":"bool","_timestamp":1732183245413084,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:00:45,415 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Export JSON","_timestamp":1732183245413281,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,415 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"module environment initialization calls = 13; actual module environment initializations = 13;","Mod":"unimp","Sub":"TMakeCommand stats","Type":"Debug","_timestamp":1732183245413091,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,415 DEBUG (build.ya_make) [Misc-03] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedUidsCache","Type":"bool","_timestamp":1732183245413284,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:00:45,415 DEBUG (build.ya_make) [Misc-02] Configure message {"InitModuleEnv":13,"InitModuleEnvCalls":13,"_timestamp":1732183245413095,"_typename":"NEvent.TMakeCommandStats","ymake_run_uid":0} 2024-11-21 10:00:45,415 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"module environment initialization calls = 13; actual module environment initializations = 13;","Mod":"unimp","Sub":"TMakeCommand stats","Type":"Debug","_timestamp":1732183245413292,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,416 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"FS cache has been committed...\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245415781,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,416 DEBUG (build.ya_make) [Misc-03] Configure message {"InitModuleEnv":13,"InitModuleEnvCalls":13,"_timestamp":1732183245413296,"_typename":"NEvent.TMakeCommandStats","ymake_run_uid":1} 2024-11-21 10:00:45,416 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Deps cache has been committed...\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245415791,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,416 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"FS cache has been committed...\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245415793,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,416 DEBUG (build.ya_make) [Misc-02] Configure message {"_timestamp":1732183245415796,"_typename":"NEvent.TReadyForUpdateCacheInfo","ymake_run_uid":0} 2024-11-21 10:00:45,416 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Deps cache has been committed...\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245415804,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,416 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"DM cache has been committed...\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245415808,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,416 DEBUG (build.ya_make) [Misc-03] Configure message {"_timestamp":1732183245415808,"_typename":"NEvent.TReadyForUpdateCacheInfo","ymake_run_uid":1} 2024-11-21 10:00:45,416 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Uids cache has been committed...\n","Mod":"unimp","PID":20678,"Sub":"","Type":"Debug","_timestamp":1732183245415819,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:00:45,416 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"DM cache has been committed...\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245415820,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,416 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"ymake main","_timestamp":1732183245416418,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:00:45,416 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Uids cache has been committed...\n","Mod":"unimp","PID":20680,"Sub":"","Type":"Debug","_timestamp":1732183245415832,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:00:45,417 DEBUG (build.ya_make) [Misc-02] Configure message {"DoubleValue":0.4293018782,"Name":"EYmakeStats::RunTime","Type":"double","_timestamp":1732183245416425,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:00:45,417 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"ymake main","_timestamp":1732183245416408,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:00:45,417 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"ymake run","_timestamp":1732183245416430,"_typename":"NEvent.TStageFinished","debug_id":"default-linux-x86_64-relwithdebinfo-pic","ymake_run_uid":0} 2024-11-21 10:00:45,417 DEBUG (build.ya_make) [Misc-03] Configure message {"DoubleValue":0.4266217699,"Name":"EYmakeStats::RunTime","Type":"double","_timestamp":1732183245416415,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:00:45,417 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"ymake run","_timestamp":1732183245416422,"_typename":"NEvent.TStageFinished","debug_id":"default-linux-x86_64-relwithdebinfo-nopic","ymake_run_uid":1} 2024-11-21 10:00:45,422 DEBUG (build.ymake2.run_ymake) [Misc-03] run '/home/runner/.ya/tools/v4/7478219259/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732183244.20575.esmjm5jo/yatmprrwpxcud --config /home/runner/.ya/build/conf/dist-relwithdebinfo-x-7115d855fe2bcec2cf122cfc3e2a8ccd/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-relwithdebinfo-x-7115d855fe2bcec2cf122cfc3e2a8ccd_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.ujf94yj7/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.ujf94yj7/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' finished 2024-11-21 10:00:45,423 DEBUG (build.ymake2.run_ymake) [Misc-02] run '/home/runner/.ya/tools/v4/7478219259/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732183244.20575.esmjm5jo/yatmpiixitrup --config /home/runner/.ya/build/conf/dist-relwithdebinfo-x-73fab6ec2ddd71b498968faffd57f411/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-relwithdebinfo-x-73fab6ec2ddd71b498968faffd57f411_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.lku1ngll/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.lku1ngll/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' finished 2024-11-21 10:00:45,423 DEBUG (build.ymake2) [Misc-03] ymake_run_info: {"ymake_run_uid":1,"stats":{"preparing":{"start":1732183244.983117580413818,"finish":1732183244.983624458312988,"duration":0.00050687789917},"execution":{"start":1732183244.983625173568726,"finish":1732183245.422852039337158,"duration":0.439226865768433},"postprocessing":{"start":1732183245.422853946685791,"finish":1732183245.42303729057312,"duration":0.000183343887329}},"purpose":"default-linux-x86_64-relwithdebinfo-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":1732183244.989759922027588,"finish":1732183245.416421890258789,"duration":0.426661968231201},"Load configuration from cache":{"start":1732183244.989902973175049,"finish":1732183244.989914894104004,"duration":0.000011920928955},"Load configuration (no cache)":{"start":1732183244.990170955657959,"finish":1732183245.147320032119751,"duration":0.157149076461792},"Compile and RecalcAll conditions":{"start":1732183245.147339105606079,"finish":1732183245.148653984069824,"duration":0.001314878463745},"Fold global commands":{"start":1732183245.148663997650146,"finish":1732183245.149805068969727,"duration":0.00114107131958},"Load plugins":{"start":1732183245.14981198310852,"finish":1732183245.264909982681274,"duration":0.115097999572754},"ymake main":{"start":1732183245.294655084609985,"finish":1732183245.416408061981201,"duration":0.121752977371216},"Build graph":{"start":1732183245.295614957809448,"finish":1732183245.39506196975708,"duration":0.099447011947632},"Configure graph":{"start":1732183245.295629978179932,"finish":1732183245.394768953323364,"duration":0.099138975143433},"Find Lost Includes":{"start":1732183245.394830942153931,"finish":1732183245.39490795135498,"duration":0.00007700920105},"Set reachable nodes":{"start":1732183245.395178079605103,"finish":1732183245.395730972290039,"duration":0.000552892684937},"Sort edges":{"start":1732183245.395734071731567,"finish":1732183245.398236989974976,"duration":0.002502918243408},"Report Foreign Platform Events":{"start":1732183245.398240089416504,"finish":1732183245.398287057876587,"duration":0.000046968460083},"Check blacklist":{"start":1732183245.39828896522522,"finish":1732183245.398291110992432,"duration":0.000002145767212},"Check isolated projects":{"start":1732183245.398293018341064,"finish":1732183245.398294925689697,"duration":0.000001907348633},"Report Configure Events":{"start":1732183245.398297071456909,"finish":1732183245.39835000038147,"duration":0.000052928924561},"Save and compact":{"start":1732183245.398351907730103,"finish":1732183245.400489091873169,"duration":0.002137184143066},"Detect loops":{"start":1732183245.40049409866333,"finish":1732183245.400949001312256,"duration":0.000454902648926},"Apply Dependency Management":{"start":1732183245.400952100753784,"finish":1732183245.401492118835449,"duration":0.000540018081665},"Save Dependency management cache":{"start":1732183245.401367902755737,"finish":1732183245.401489973068237,"duration":0.0001220703125},"Fill package outputs":{"start":1732183245.401526927947998,"finish":1732183245.40152907371521,"duration":0.000002145767212},"Check Transitive Requirements":{"start":1732183245.401532888412476,"finish":1732183245.401673078536987,"duration":0.000140190124512},"Find missing peerdirs":{"start":1732183245.401694059371948,"finish":1732183245.40233588218689,"duration":0.000641822814941},"Export JSON":{"start":1732183245.402391910552978,"finish":1732183245.413280963897705,"duration":0.010889053344727},"Write JSON":{"start":1732183245.402395963668823,"finish":1732183245.413260936737061,"duration":0.010864973068237},"Visit JSON":{"start":1732183245.402404069900513,"finish":1732183245.405298948287964,"duration":0.002894878387451},"Render JSON":{"start":1732183245.405303955078125,"finish":1732183245.412386894226074,"duration":0.007082939147949},"Save Uids cache":{"start":1732183245.412389039993286,"finish":1732183245.413151979446411,"duration":0.000762939453125}},"metrics":{"File access":{"loaded size":9023798,"load time":11217,"loaded MD5 time":752,"Max loaded MD5 time":5,"loaded count":2174,"max load time":211,"mapped size":40632376,"mapped MD5 time":8385,"Max mapped MD5 time":529,"mapped count":130,"map time":753,"from patch count":0,"from patch size":0,"file stat count":3223,"lstat count":3045,"lstat sum us":3246,"lstat min us":0,"lstat avr us":1,"lstat max us":15,"opendir count":388,"opendir sum us":0,"opendir min us":0,"opendir avr us":0,"opendir max us":0,"readdir count":2837,"readdir sum us":2215,"readdir min us":0,"readdir avr us":0,"readdir max us":39,"(opendir + readdir) sum us":2215,"(lstat + opendir + readdir) sum us":5461},"Parsing":{"parse time":1,"parsed files count":6,"parsed files size":12965,"parsed files recovered":0,".in files count":0,".in files size":0},"ya.make parsing":{"count":8,"includes count":12,"unique count":8,"size":1264,"unique size":853},"DepGraph":{"nodes count":2825,"edges count":12363,"files count":3263,"commands count":142},"UpdIter":{"nuke mod dir":0},"Resolving":{"Includes attempts":0,"From cache":0,"Resolve AsKnown total":0,"Resolve AsKnown from cache":0},"TModules":{"accessed":19,"loaded":0,"outdated":0,"parsed":19,"total":19},"Internal cache":{"Total cache size on save":428512,"Diagnostics cache size on save":112,"Graph cache size on save":91616,"Parsers cache size on save":224,"Modules table size on save":3079,"Times table size on save":16,"Names table size on save":332624,"Commands cache size on save":272},"JSON cache":{"Loaded cache items":0,"Added cache items":0,"Saved old cache items":0,"Saved new cache items":0,"Saved total cache items":0,"Loaded full match items":0,"Full match requests":0,"Successful full matches":0,"Loaded partial match items":0,"Partial match requests":0,"Successful partial matches":0,"Fully rendered nodes":0,"Partially rendered nodes":0,"Nodes restored without rendering":0},"Uids cache":{"Loaded nodes":0,"Skipped nodes":0,"Discarded nodes":0,"Loaded loops":0,"Skipped loops":0,"Discarded loops":0,"Saved nodes":2392,"Saved loops":0,"Really all nodes no rendered":0},"TMakeCommand":{"module environment initialization calls":13,"actual module environment initializations":13}},"binary":"/home/runner/.ya/tools/v4/7478219259/ymake","args":["/home/runner/.ya/tools/v4/7478219259/ymake","--depends-like-recurse","--warn","dirloops,ChkPeers","--write-meta-data","/home/runner/.ya/tmp/1732183244.20575.esmjm5jo/yatmprrwpxcud","--config","/home/runner/.ya/build/conf/dist-relwithdebinfo-x-7115d855fe2bcec2cf122cfc3e2a8ccd/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-relwithdebinfo-x-7115d855fe2bcec2cf122cfc3e2a8ccd_d357a1f7839b099012272bcb9853ec19","--test-dart","/home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.ujf94yj7/test.dart","--tests-data-root","/home/runner/actions_runner/_work/ydb/arcadia_tests_data","--makefiles-dart","/home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.ujf94yj7/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.439226865768433} 2024-11-21 10:00:45,423 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=load-graph-from-json, group=graph, time=1732183245.4238782 2024-11-21 10:00:45,423 DEBUG (core.stages_profiler) [Misc-03] Set stage load-graph-from-json_started=1732183245.4238782 2024-11-21 10:00:45,424 DEBUG (core.profiler) [Misc-03] Profile step load-graph-from-json_started - 1732183245.4238782 2024-11-21 10:00:45,424 DEBUG (core.event_handling.base_subscriber) [Misc-02] Unsubscribing PrintProgressSubscriber from event_queue 2024-11-21 10:00:45,424 DEBUG (build.ymake2) [Misc-02] ymake_run_info: {"ymake_run_uid":0,"stats":{"preparing":{"start":1732183244.978590965270996,"finish":1732183244.97936749458313,"duration":0.000776529312134},"execution":{"start":1732183244.979368448257446,"finish":1732183245.423527002334595,"duration":0.444158554077148},"postprocessing":{"start":1732183245.423530101776123,"finish":1732183245.424289703369141,"duration":0.000759601593018}},"purpose":"default-linux-x86_64-relwithdebinfo-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":1732183244.987092018127441,"finish":1732183245.416429996490478,"duration":0.429337978363037},"Load configuration from cache":{"start":1732183244.98725700378418,"finish":1732183244.98727011680603,"duration":0.000013113021851},"Load configuration (no cache)":{"start":1732183244.987523078918457,"finish":1732183245.145752906799316,"duration":0.158229827880859},"Compile and RecalcAll conditions":{"start":1732183245.145778894424438,"finish":1732183245.147228002548218,"duration":0.001449108123779},"Fold global commands":{"start":1732183245.147239923477173,"finish":1732183245.148396968841553,"duration":0.00115704536438},"Load plugins":{"start":1732183245.148405075073242,"finish":1732183245.265208005905151,"duration":0.116802930831909},"ymake main":{"start":1732183245.294992923736572,"finish":1732183245.416418075561523,"duration":0.121425151824951},"Build graph":{"start":1732183245.295906066894531,"finish":1732183245.395055055618286,"duration":0.099148988723755},"Configure graph":{"start":1732183245.295921087265015,"finish":1732183245.394745111465454,"duration":0.098824024200439},"Find Lost Includes":{"start":1732183245.394814968109131,"finish":1732183245.394895076751709,"duration":0.000080108642578},"Set reachable nodes":{"start":1732183245.395180940628052,"finish":1732183245.395742893218994,"duration":0.000561952590942},"Sort edges":{"start":1732183245.395745038986206,"finish":1732183245.39824104309082,"duration":0.002496004104614},"Report Foreign Platform Events":{"start":1732183245.398245096206665,"finish":1732183245.398292064666748,"duration":0.000046968460083},"Check blacklist":{"start":1732183245.398293018341064,"finish":1732183245.398296117782593,"duration":0.000003099441528},"Check isolated projects":{"start":1732183245.398298025131226,"finish":1732183245.398299932479858,"duration":0.000001907348633},"Report Configure Events":{"start":1732183245.39830207824707,"finish":1732183245.398355007171631,"duration":0.000052928924561},"Save and compact":{"start":1732183245.398356914520264,"finish":1732183245.400333881378174,"duration":0.00197696685791},"Detect loops":{"start":1732183245.400337934494019,"finish":1732183245.400764942169189,"duration":0.000427007675171},"Apply Dependency Management":{"start":1732183245.400768041610718,"finish":1732183245.401312112808228,"duration":0.00054407119751},"Save Dependency management cache":{"start":1732183245.401185989379883,"finish":1732183245.401309967041016,"duration":0.000123977661133},"Fill package outputs":{"start":1732183245.40134596824646,"finish":1732183245.401348114013672,"duration":0.000002145767212},"Check Transitive Requirements":{"start":1732183245.401351928710938,"finish":1732183245.401490926742554,"duration":0.000138998031616},"Find missing peerdirs":{"start":1732183245.401515007019043,"finish":1732183245.402172088623047,"duration":0.000657081604004},"Export JSON":{"start":1732183245.402234077453613,"finish":1732183245.413080930709839,"duration":0.010846853256226},"Write JSON":{"start":1732183245.402240037918091,"finish":1732183245.413059949874878,"duration":0.010819911956787},"Visit JSON":{"start":1732183245.402249097824097,"finish":1732183245.405106067657471,"duration":0.002856969833374},"Render JSON":{"start":1732183245.405109882354736,"finish":1732183245.412193059921265,"duration":0.007083177566528},"Save Uids cache":{"start":1732183245.412195920944214,"finish":1732183245.412959098815918,"duration":0.000763177871704}},"metrics":{"File access":{"loaded size":9023798,"load time":11201,"loaded MD5 time":751,"Max loaded MD5 time":10,"loaded count":2174,"max load time":241,"mapped size":40632376,"mapped MD5 time":8246,"Max mapped MD5 time":529,"mapped count":130,"map time":760,"from patch count":0,"from patch size":0,"file stat count":3223,"lstat count":3045,"lstat sum us":3220,"lstat min us":0,"lstat avr us":1,"lstat max us":13,"opendir count":388,"opendir sum us":0,"opendir min us":0,"opendir avr us":0,"opendir max us":0,"readdir count":2837,"readdir sum us":2172,"readdir min us":0,"readdir avr us":0,"readdir max us":39,"(opendir + readdir) sum us":2172,"(lstat + opendir + readdir) sum us":5392},"Parsing":{"parse time":2,"parsed files count":6,"parsed files size":12965,"parsed files recovered":0,".in files count":0,".in files size":0},"ya.make parsing":{"count":8,"includes count":12,"unique count":8,"size":1264,"unique size":853},"DepGraph":{"nodes count":2825,"edges count":12363,"files count":3263,"commands count":142},"UpdIter":{"nuke mod dir":0},"Resolving":{"Includes attempts":0,"From cache":0,"Resolve AsKnown total":0,"Resolve AsKnown from cache":0},"TModules":{"accessed":19,"loaded":0,"outdated":0,"parsed":19,"total":19},"Internal cache":{"Total cache size on save":428512,"Diagnostics cache size on save":112,"Graph cache size on save":91616,"Parsers cache size on save":224,"Modules table size on save":3079,"Times table size on save":16,"Names table size on save":332624,"Commands cache size on save":272},"JSON cache":{"Loaded cache items":0,"Added cache items":0,"Saved old cache items":0,"Saved new cache items":0,"Saved total cache items":0,"Loaded full match items":0,"Full match requests":0,"Successful full matches":0,"Loaded partial match items":0,"Partial match requests":0,"Successful partial matches":0,"Fully rendered nodes":0,"Partially rendered nodes":0,"Nodes restored without rendering":0},"Uids cache":{"Loaded nodes":0,"Skipped nodes":0,"Discarded nodes":0,"Loaded loops":0,"Skipped loops":0,"Discarded loops":0,"Saved nodes":2392,"Saved loops":0,"Really all nodes no rendered":0},"TMakeCommand":{"module environment initialization calls":13,"actual module environment initializations":13}},"binary":"/home/runner/.ya/tools/v4/7478219259/ymake","args":["/home/runner/.ya/tools/v4/7478219259/ymake","--depends-like-recurse","--warn","dirloops,ChkPeers","--write-meta-data","/home/runner/.ya/tmp/1732183244.20575.esmjm5jo/yatmpiixitrup","--config","/home/runner/.ya/build/conf/dist-relwithdebinfo-x-73fab6ec2ddd71b498968faffd57f411/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-relwithdebinfo-x-73fab6ec2ddd71b498968faffd57f411_d357a1f7839b099012272bcb9853ec19","--test-dart","/home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.lku1ngll/test.dart","--tests-data-root","/home/runner/actions_runner/_work/ydb/arcadia_tests_data","--makefiles-dart","/home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.lku1ngll/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.444158554077148} 2024-11-21 10:00:45,424 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=load-graph-from-json, group=graph, time=1732183245.4248114 2024-11-21 10:00:45,424 DEBUG (core.stages_profiler) [Misc-02] Set stage load-graph-from-json_started=1732183245.4248114 2024-11-21 10:00:45,424 DEBUG (core.profiler) [Misc-02] Profile step load-graph-from-json_started - 1732183245.4248114 2024-11-21 10:00:45,425 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=load-graph-from-json, group=graph, time=1732183245.4249744 2024-11-21 10:00:45,425 DEBUG (core.stages_profiler) [Misc-03] Set stage load-graph-from-json_finished=1732183245.4249744 2024-11-21 10:00:45,425 DEBUG (core.profiler) [Misc-03] Profile step load-graph-from-json_finished - 1732183245.4249744 2024-11-21 10:00:45,425 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=gen-graph-json-default-linux-x86_64-relwithdebinfo-nopic, group=graph, time=1732183245.4252007 2024-11-21 10:00:45,425 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-json-default-linux-x86_64-relwithdebinfo-nopic_finished=1732183245.4252007 2024-11-21 10:00:45,425 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-json-default-linux-x86_64-relwithdebinfo-nopic_finished - 1732183245.4252007 2024-11-21 10:00:45,425 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=gen-tests-default-linux-x86_64-relwithdebinfo-nopic, group=graph, time=1732183245.4254653 2024-11-21 10:00:45,425 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-tests-default-linux-x86_64-relwithdebinfo-nopic_started=1732183245.4254653 2024-11-21 10:00:45,425 DEBUG (core.profiler) [Misc-03] Profile step gen-tests-default-linux-x86_64-relwithdebinfo-nopic_started - 1732183245.4254653 2024-11-21 10:00:45,425 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=load-graph-from-json, group=graph, time=1732183245.4256184 2024-11-21 10:00:45,425 DEBUG (core.stages_profiler) [Misc-02] Set stage load-graph-from-json_finished=1732183245.4256184 2024-11-21 10:00:45,425 DEBUG (core.profiler) [Misc-02] Profile step load-graph-from-json_finished - 1732183245.4256184 2024-11-21 10:00:45,425 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=gen-graph-json-default-linux-x86_64-relwithdebinfo-pic, group=graph, time=1732183245.4258852 2024-11-21 10:00:45,425 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-json-default-linux-x86_64-relwithdebinfo-pic_finished=1732183245.4258852 2024-11-21 10:00:45,425 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-json-default-linux-x86_64-relwithdebinfo-pic_finished - 1732183245.4258852 2024-11-21 10:00:45,426 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=gen-tests-default-linux-x86_64-relwithdebinfo-pic, group=graph, time=1732183245.4261315 2024-11-21 10:00:45,426 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-tests-default-linux-x86_64-relwithdebinfo-pic_started=1732183245.4261315 2024-11-21 10:00:45,426 DEBUG (core.profiler) [Misc-02] Profile step gen-tests-default-linux-x86_64-relwithdebinfo-pic_started - 1732183245.4261315 2024-11-21 10:00:45,430 DEBUG (build.graph) [Misc-03] Found 0 tests 2024-11-21 10:00:45,430 DEBUG (build.graph) [Misc-02] Found 0 tests 2024-11-21 10:00:45,430 DEBUG (exts.timer) [Misc-03] Timer gen_tests, stage generate tests: 0.00041556358337402344 2024-11-21 10:00:45,430 DEBUG (exts.timer) [Misc-02] Timer gen_tests, stage generate tests: 0.00022220611572265625 2024-11-21 10:00:45,430 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=gen-tests-default-linux-x86_64-relwithdebinfo-nopic, group=graph, time=1732183245.4307582 2024-11-21 10:00:45,430 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-tests-default-linux-x86_64-relwithdebinfo-nopic_finished=1732183245.4307582 2024-11-21 10:00:45,430 DEBUG (core.profiler) [Misc-03] Profile step gen-tests-default-linux-x86_64-relwithdebinfo-nopic_finished - 1732183245.4307582 2024-11-21 10:00:45,430 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=gen-tests-default-linux-x86_64-relwithdebinfo-pic, group=graph, time=1732183245.4308205 2024-11-21 10:00:45,431 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-tests-default-linux-x86_64-relwithdebinfo-pic_finished=1732183245.4308205 2024-11-21 10:00:45,431 DEBUG (core.profiler) [Misc-02] Profile step gen-tests-default-linux-x86_64-relwithdebinfo-pic_finished - 1732183245.4308205 2024-11-21 10:00:45,431 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=gen-graph-default-linux-x86_64-relwithdebinfo-nopic, group=graph, time=1732183245.4312558 2024-11-21 10:00:45,431 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-default-linux-x86_64-relwithdebinfo-nopic_finished=1732183245.4312558 2024-11-21 10:00:45,431 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-default-linux-x86_64-relwithdebinfo-nopic_finished - 1732183245.4312558 2024-11-21 10:00:45,431 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=gen-graph-default-linux-x86_64-relwithdebinfo-pic, group=graph, time=1732183245.4316218 2024-11-21 10:00:45,431 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-default-linux-x86_64-relwithdebinfo-pic_finished=1732183245.4316218 2024-11-21 10:00:45,431 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-default-linux-x86_64-relwithdebinfo-pic_finished - 1732183245.4316218 2024-11-21 10:00:45,432 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage waiting_graphs for default-linux-x86_64-relwithdebinfo: 0.027530670166015625 2024-11-21 10:00:45,432 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=wait-target-graphs-1, group=graph, time=1732183245.4321144 2024-11-21 10:00:45,432 DEBUG (core.stages_profiler) [MainThread] Set stage wait-target-graphs-1_finished=1732183245.4321144 2024-11-21 10:00:45,432 DEBUG (core.profiler) [MainThread] Profile step wait-target-graphs-1_finished - 1732183245.4321144 2024-11-21 10:00:45,432 DEBUG (core.stage_tracer) [MainThread] Start stage tag=union-make-files-1, group=graph, time=1732183245.432344 2024-11-21 10:00:45,432 DEBUG (core.stages_profiler) [MainThread] Set stage union-make-files-1_started=1732183245.432344 2024-11-21 10:00:45,432 DEBUG (core.profiler) [MainThread] Profile step union-make-files-1_started - 1732183245.432344 2024-11-21 10:00:45,432 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage union make files for default-linux-x86_64-relwithdebinfo: 0.0005137920379638672 2024-11-21 10:00:45,432 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=union-make-files-1, group=graph, time=1732183245.432547 2024-11-21 10:00:45,432 DEBUG (core.stages_profiler) [MainThread] Set stage union-make-files-1_finished=1732183245.432547 2024-11-21 10:00:45,432 DEBUG (core.profiler) [MainThread] Profile step union-make-files-1_finished - 1732183245.432547 2024-11-21 10:00:45,432 DEBUG (core.stage_tracer) [MainThread] Start stage tag=merge-graphs-1, group=graph, time=1732183245.4326682 2024-11-21 10:00:45,432 DEBUG (core.stages_profiler) [MainThread] Set stage merge-graphs-1_started=1732183245.4326682 2024-11-21 10:00:45,432 DEBUG (core.profiler) [MainThread] Profile step merge-graphs-1_started - 1732183245.4326682 2024-11-21 10:00:45,432 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage merge_graphs for default-linux-x86_64-relwithdebinfo: 0.00030684471130371094 2024-11-21 10:00:45,432 DEBUG (build.graph) [MainThread] Graph size is 26 after merge_graphs 2024-11-21 10:00:45,432 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=merge-graphs-1, group=graph, time=1732183245.4329026 2024-11-21 10:00:45,432 DEBUG (core.stages_profiler) [MainThread] Set stage merge-graphs-1_finished=1732183245.4329026 2024-11-21 10:00:45,432 DEBUG (core.profiler) [MainThread] Profile step merge-graphs-1_finished - 1732183245.4329026 2024-11-21 10:00:45,433 DEBUG (core.stage_tracer) [MainThread] Start stage tag=strip-graph-1, group=graph, time=1732183245.4330332 2024-11-21 10:00:45,433 DEBUG (core.stages_profiler) [MainThread] Set stage strip-graph-1_started=1732183245.4330332 2024-11-21 10:00:45,433 DEBUG (core.profiler) [MainThread] Profile step strip-graph-1_started - 1732183245.4330332 2024-11-21 10:00:45,433 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage strip_graph for default-linux-x86_64-relwithdebinfo: 0.00033736228942871094 2024-11-21 10:00:45,433 DEBUG (build.graph) [MainThread] Graph size is 13 after strip_graph 2024-11-21 10:00:45,433 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=strip-graph-1, group=graph, time=1732183245.433224 2024-11-21 10:00:45,433 DEBUG (core.stages_profiler) [MainThread] Set stage strip-graph-1_finished=1732183245.433224 2024-11-21 10:00:45,433 DEBUG (core.profiler) [MainThread] Profile step strip-graph-1_finished - 1732183245.433224 2024-11-21 10:00:45,433 DEBUG (build.graph) [MainThread] Configuring only non-PIC for test_tool_tc1-global 2024-11-21 10:00:45,433 DEBUG (core.stage_tracer) [Misc-04] Start stage tag=gen-graph-test_tool_tc1-nopic-global, group=graph, time=1732183245.4337556 2024-11-21 10:00:45,433 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-test_tool_tc1-nopic-global_started=1732183245.4337556 2024-11-21 10:00:45,434 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-test_tool_tc1-nopic-global_started - 1732183245.4337556 2024-11-21 10:00:45,434 DEBUG (core.stage_tracer) [Misc-04] Start stage tag=gen-graph-gen-opts-test_tool_tc1-nopic-global, group=graph, time=1732183245.434187 2024-11-21 10:00:45,434 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-gen-opts-test_tool_tc1-nopic-global_started=1732183245.434187 2024-11-21 10:00:45,434 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-gen-opts-test_tool_tc1-nopic-global_started - 1732183245.434187 2024-11-21 10:00:45,434 DEBUG (yalibrary.guards) [Misc-04] Enter guard fetch with value None 2024-11-21 10:00:45,447 DEBUG (build.genconf) [Misc-04] Generating conf into /home/runner/.ya/build/conf/dist-relwithdebinfo-8d2c6403cf81ceccc8344ced565a6f37/ymake.conf with cmd ['/home/runner/.ya/tools/a6139abb9c_d/ya-bin', '/home/runner/actions_runner/_work/ydb/ydb/build/ymake_conf.py', '/home/runner/actions_runner/_work/ydb/ydb', 'dist-relwithdebinfo', 'no', '--toolchain-params', 'eyJib3R0bGVfbmFtZSI6ImNsYW5nMTgiLCJlbnYiOnsiQ1BBVEgiOlsiIl0sIkxJQlJBUllfUEFUSCI6WyIiXSwiU0RLUk9PVCI6WyIiXX0sImV4ZWN1dGFibGVfcGF0aCI6ImMrKyIsImZvcm11bGEiOnsiYnlfcGxhdGZvcm0iOnsiZGFyd2luLWFybTY0Ijp7InVyaSI6InNicjo3NDUxNjAyNjA5In0sImRhcndpbi14ODZfNjQiOnsidXJpIjoic2JyOjc0NTE1ODU5NjIifSwibGludXgtYWFyY2g2NCI6eyJ1cmkiOiJzYnI6NzQ1MTcxMjMzMiJ9LCJsaW51eC14ODZfNjQiOnsidXJpIjoic2JyOjc0NTE0NjY0MDcifSwid2luMzIteDg2XzY0Ijp7InVyaSI6InNicjo3NDUxNDA2OTAwIn19fSwibmFtZSI6ImNsYW5nMTgiLCJwYXJhbXMiOnsiY19jb21waWxlciI6IiQoQ0xBTkctMTczNTA1NjgyMSkvYmluL2NsYW5nIiwiY3h4X2NvbXBpbGVyIjoiJChDTEFORy0xNzM1MDU2ODIxKS9iaW4vY2xhbmcrKyIsImdjY192ZXJzaW9uIjoiMTgiLCJsbHZtLXN5bWJvbGl6ZXIiOiIkKENMQU5HLTE3MzUwNTY4MjEpL2Jpbi9sbHZtLXN5bWJvbGl6ZXIiLCJtYXRjaF9yb290IjoiQ0xBTkctMTczNTA1NjgyMSIsIm9iamNvcHkiOiIkKENMQU5HLTE3MzUwNTY4MjEpL2Jpbi9sbHZtLW9iamNvcHkiLCJwcm9maWxlcyI6IiQoWENPREVfVE9PTFNfUk9PVC1zYnI6Nzk5MDE3NzcxKS9YY29kZS9Db250ZW50cy9EZXZlbG9wZXIvUGxhdGZvcm1zL2lQaG9uZU9TLnBsYXRmb3JtL0RldmVsb3Blci9MaWJyYXJ5L0NvcmVTaW11bGF0b3IvUHJvZmlsZXMiLCJzaW1jdGwiOiIkKFhDT0RFX1RPT0xTX1JPT1Qtc2JyOjc5OTAxNzc3MSkvWGNvZGUvU3lzdGVtUm9vdC9Qcml2YXRlRnJhbWV3b3Jrcy9Db3JlU2ltdWxhdG9yLmZyYW1ld29yay9SZXNvdXJjZXMvYmluL3NpbWN0bCIsInN0cmlwIjoiJChDTEFORy0xNzM1MDU2ODIxKS9iaW4vbGx2bS1zdHJpcCIsInR5cGUiOiJjbGFuZyIsInVzZV9idW5kbGUiOnRydWUsIndlcnJvcl9tb2RlIjoiYWxsIn0sInBsYXRmb3JtIjp7Imhvc3QiOnsiYXJjaCI6Ing4Nl82NCIsIm9zIjoiTElOVVgiLCJ0b29sY2hhaW4iOiJkZWZhdWx0IiwidmlzaWJsZV9uYW1lIjoiY2xhbmcxOCJ9LCJ0YXJnZXQiOnsiYXJjaCI6Ing4Nl82NCIsIm9zIjoiTElOVVgiLCJ0b29sY2hhaW4iOiJkZWZhdWx0IiwidmlzaWJsZV9uYW1lIjoiY2xhbmcxOCJ9fSwicGxhdGZvcm1fbmFtZSI6IkRFRkFVTFQtTElOVVgtWDg2XzY0IiwidG9vbF92YXIiOiJDTEFORy0xNzM1MDU2ODIxIn0=', '-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', '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-21 10:00:45,567 DEBUG (build.genconf) [Misc-04] Copy conf /home/runner/.ya/build/conf/dist-relwithdebinfo-8d2c6403cf81ceccc8344ced565a6f37/ymake.conf to /home/runner/.ya/build/conf/dist-relwithdebinfo-x-a57f9583d616e5680d7626994c7b7271/ymake.conf 2024-11-21 10:00:45,568 DEBUG (yalibrary.guards) [Misc-04] Exit guard fetch with value None 2024-11-21 10:00:45,568 DEBUG (core.stage_tracer) [Misc-04] Finish stage tag=gen-graph-gen-opts-test_tool_tc1-nopic-global, group=graph, time=1732183245.5682907 2024-11-21 10:00:45,568 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-gen-opts-test_tool_tc1-nopic-global_finished=1732183245.5682907 2024-11-21 10:00:45,568 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-gen-opts-test_tool_tc1-nopic-global_finished - 1732183245.5682907 2024-11-21 10:00:45,568 DEBUG (core.stage_tracer) [Misc-04] Start stage tag=gen-graph-json-test_tool_tc1-nopic-global, group=graph, time=1732183245.568462 2024-11-21 10:00:45,568 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-json-test_tool_tc1-nopic-global_started=1732183245.568462 2024-11-21 10:00:45,568 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-json-test_tool_tc1-nopic-global_started - 1732183245.568462 2024-11-21 10:00:45,568 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-relwithdebinfo-x-a57f9583d616e5680d7626994c7b7271_d357a1f7839b099012272bcb9853ec19', 'build_type': 'relwithdebinfo', '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-relwithdebinfo-x-a57f9583d616e5680d7626994c7b7271/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 0x7fb83ed94cc0>, 'enabled_events': 'PSLGE', 'no_caches_on_retry': False, 'no_ymake_retry': False, 'disable_customization': 0, 'dump_tests': '/home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.7shr02n_/test.dart', 'dump_make_files': '/home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.7shr02n_/makefiles.dart'} 2024-11-21 10:00:45,568 DEBUG (core.yarg.behaviour) [Misc-04] Found unused args ['grab_stderr'] 2024-11-21 10:00:45,568 DEBUG (build.prefetch) [Misc-04] prefetch disabled 2024-11-21 10:00:45,568 DEBUG (core.event_handling.base_subscriber) [Misc-04] Subscribing PrintProgressSubscriber to event_queue 2024-11-21 10:00:45,569 DEBUG (yalibrary.tools) [Misc-04] Using old-style toolchain for: ymake 2024-11-21 10:00:45,569 DEBUG (build.ymake2.run_ymake) [Misc-04] run: '/home/runner/.ya/tools/v4/7478219259/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732183244.20575.esmjm5jo/yatmpw35qkijk --config /home/runner/.ya/build/conf/dist-relwithdebinfo-x-a57f9583d616e5680d7626994c7b7271/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-relwithdebinfo-x-a57f9583d616e5680d7626994c7b7271_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.7shr02n_/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.7shr02n_/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-21 10:00:45,936 DEBUG (build.ymake2.run_ymake) [Misc-04] run '/home/runner/.ya/tools/v4/7478219259/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732183244.20575.esmjm5jo/yatmpw35qkijk --config /home/runner/.ya/build/conf/dist-relwithdebinfo-x-a57f9583d616e5680d7626994c7b7271/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-relwithdebinfo-x-a57f9583d616e5680d7626994c7b7271_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.7shr02n_/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.7shr02n_/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-21 10:00:45,936 DEBUG (core.event_handling.base_subscriber) [Misc-04] Unsubscribing PrintProgressSubscriber from event_queue 2024-11-21 10:00:45,937 DEBUG (build.ymake2) [Misc-04] ymake_run_info: {"ymake_run_uid":2,"stats":{"preparing":{"start":1732183245.568830728530884,"finish":1732183245.569366216659546,"duration":0.000535488128662},"execution":{"start":1732183245.569366693496704,"finish":1732183245.936788320541382,"duration":0.367421627044678},"postprocessing":{"start":1732183245.936790704727173,"finish":1732183245.937127113342285,"duration":0.000336408615112}},"purpose":"test_tool_tc1-nopic-global","caches":{},"stages":{},"metrics":{},"binary":"/home/runner/.ya/tools/v4/7478219259/ymake","args":["/home/runner/.ya/tools/v4/7478219259/ymake","--depends-like-recurse","--warn","dirloops,ChkPeers","--write-meta-data","/home/runner/.ya/tmp/1732183244.20575.esmjm5jo/yatmpw35qkijk","--config","/home/runner/.ya/build/conf/dist-relwithdebinfo-x-a57f9583d616e5680d7626994c7b7271/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-relwithdebinfo-x-a57f9583d616e5680d7626994c7b7271_d357a1f7839b099012272bcb9853ec19","--test-dart","/home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.7shr02n_/test.dart","--tests-data-root","/home/runner/actions_runner/_work/ydb/arcadia_tests_data","--makefiles-dart","/home/runner/.ya/tmp/1732183244.20575.esmjm5jo/gen_graph.7shr02n_/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.367421627044678} 2024-11-21 10:00:45,937 DEBUG (core.stage_tracer) [Misc-04] Start stage tag=load-graph-from-json, group=graph, time=1732183245.937524 2024-11-21 10:00:45,937 DEBUG (core.stages_profiler) [Misc-04] Set stage load-graph-from-json_started=1732183245.937524 2024-11-21 10:00:45,937 DEBUG (core.profiler) [Misc-04] Profile step load-graph-from-json_started - 1732183245.937524 2024-11-21 10:00:45,937 DEBUG (core.stage_tracer) [Misc-04] Finish stage tag=load-graph-from-json, group=graph, time=1732183245.9377623 2024-11-21 10:00:45,937 DEBUG (core.stages_profiler) [Misc-04] Set stage load-graph-from-json_finished=1732183245.9377623 2024-11-21 10:00:45,937 DEBUG (core.profiler) [Misc-04] Profile step load-graph-from-json_finished - 1732183245.9377623 2024-11-21 10:00:45,937 DEBUG (core.stage_tracer) [Misc-04] Finish stage tag=gen-graph-json-test_tool_tc1-nopic-global, group=graph, time=1732183245.9379766 2024-11-21 10:00:45,938 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-json-test_tool_tc1-nopic-global_finished=1732183245.9379766 2024-11-21 10:00:45,938 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-json-test_tool_tc1-nopic-global_finished - 1732183245.9379766 2024-11-21 10:00:45,938 DEBUG (core.stage_tracer) [Misc-04] Finish stage tag=gen-graph-test_tool_tc1-nopic-global, group=graph, time=1732183245.9382327 2024-11-21 10:00:45,938 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-test_tool_tc1-nopic-global_finished=1732183245.9382327 2024-11-21 10:00:45,938 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-test_tool_tc1-nopic-global_finished - 1732183245.9382327 2024-11-21 10:00:45,938 DEBUG (core.stage_tracer) [MainThread] Start stage tag=get-graph-1, group=graph, time=1732183245.9388003 2024-11-21 10:00:45,938 DEBUG (core.stages_profiler) [MainThread] Set stage get-graph-1_started=1732183245.9388003 2024-11-21 10:00:45,939 DEBUG (core.profiler) [MainThread] Profile step get-graph-1_started - 1732183245.9388003 2024-11-21 10:00:45,940 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=get-graph-1, group=graph, time=1732183245.9405134 2024-11-21 10:00:45,940 DEBUG (core.stages_profiler) [MainThread] Set stage get-graph-1_finished=1732183245.9405134 2024-11-21 10:00:45,940 DEBUG (core.profiler) [MainThread] Profile step get-graph-1_finished - 1732183245.9405134 2024-11-21 10:00:45,940 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=merge-target-graphs-1, group=graph, time=1732183245.94071 2024-11-21 10:00:45,940 DEBUG (core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_finished=1732183245.94071 2024-11-21 10:00:45,940 DEBUG (core.profiler) [MainThread] Profile step merge-target-graphs-1_finished - 1732183245.94071 2024-11-21 10:00:45,940 DEBUG (core.stage_tracer) [MainThread] Start stage tag=build-merged-graph, group=graph, time=1732183245.9408662 2024-11-21 10:00:45,940 DEBUG (core.stages_profiler) [MainThread] Set stage build-merged-graph_started=1732183245.9408662 2024-11-21 10:00:45,940 DEBUG (core.profiler) [MainThread] Profile step build-merged-graph_started - 1732183245.9408662 2024-11-21 10:00:45,941 DEBUG (core.stage_tracer) [MainThread] Start stage tag=insert-tests-1, group=graph, time=1732183245.9414806 2024-11-21 10:00:45,941 DEBUG (core.stages_profiler) [MainThread] Set stage insert-tests-1_started=1732183245.9414806 2024-11-21 10:00:45,941 DEBUG (core.profiler) [MainThread] Profile step insert-tests-1_started - 1732183245.9414806 2024-11-21 10:00:45,941 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'unsupported cross-compiled tests' on 0 suites 2024-11-21 10:00:45,941 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter '. at 0x7fb83edff420>' on 0 suites 2024-11-21 10:00:45,941 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'size' on 0 suites 2024-11-21 10:00:45,941 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'class type' on 0 suites 2024-11-21 10:00:45,941 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'suite type' on 0 suites 2024-11-21 10:00:45,942 DEBUG (devtools.ya.test.filter) [MainThread] Tags filter include set:[] exclude set:[] 2024-11-21 10:00:45,942 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'tags' on 0 suites 2024-11-21 10:00:45,942 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'project path' on 0 suites 2024-11-21 10:00:45,942 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'filename filter' on 0 suites 2024-11-21 10:00:45,942 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'chunk filter' on 0 suites 2024-11-21 10:00:45,942 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'name' on 0 suites 2024-11-21 10:00:45,942 DEBUG (build.graph) [MainThread] Generating build plan 2024-11-21 10:00:45,942 DEBUG (build.graph) [MainThread] Preparing test suites 2024-11-21 10:00:45,942 DEBUG (build.graph) [MainThread] Stripping clang-tidy irrelevant deps 2024-11-21 10:00:45,942 DEBUG (exts.timer) [MainThread] Timer inject_tests, stage inject tests for default-linux-x86_64-relwithdebinfo: 0.0009655952453613281 2024-11-21 10:00:45,942 DEBUG (build.graph) [MainThread] injected 0 tests for default-linux-x86_64-relwithdebinfo 2024-11-21 10:00:45,942 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=insert-tests-1, group=graph, time=1732183245.9427307 2024-11-21 10:00:45,942 DEBUG (core.stages_profiler) [MainThread] Set stage insert-tests-1_finished=1732183245.9427307 2024-11-21 10:00:45,942 DEBUG (core.profiler) [MainThread] Profile step insert-tests-1_finished - 1732183245.9427307 2024-11-21 10:00:45,942 DEBUG (core.stage_tracer) [MainThread] Start stage tag=merge-target-graphs-1, group=graph, time=1732183245.9428687 2024-11-21 10:00:45,942 DEBUG (core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_started=1732183245.9428687 2024-11-21 10:00:45,942 DEBUG (core.profiler) [MainThread] Profile step merge-target-graphs-1_started - 1732183245.9428687 2024-11-21 10:00:45,942 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=merge-target-graphs-1, group=graph, time=1732183245.9429786 2024-11-21 10:00:45,943 DEBUG (core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_finished=1732183245.9429786 2024-11-21 10:00:45,943 DEBUG (core.profiler) [MainThread] Profile step merge-target-graphs-1_finished - 1732183245.9429786 2024-11-21 10:00:45,943 DEBUG (core.config) [MainThread] Read config "build/platform/python/ymake_python2/resources.json" from resource 2024-11-21 10:00:45,943 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] python: will use 'linux-x86_64' platform 2024-11-21 10:00:45,943 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/gdb/resources.json 2024-11-21 10:00:45,943 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] gdb: will use 'linux-x86_64' platform 2024-11-21 10:00:45,943 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=build-merged-graph, group=graph, time=1732183245.9437916 2024-11-21 10:00:45,943 DEBUG (core.stages_profiler) [MainThread] Set stage build-merged-graph_finished=1732183245.9437916 2024-11-21 10:00:45,943 DEBUG (core.profiler) [MainThread] Profile step build-merged-graph_finished - 1732183245.9437916 2024-11-21 10:00:45,943 DEBUG (core.stage_tracer) [MainThread] Start stage tag=iter-extra-resources, group=graph, time=1732183245.943935 2024-11-21 10:00:45,943 DEBUG (core.stages_profiler) [MainThread] Set stage iter-extra-resources_started=1732183245.943935 2024-11-21 10:00:45,944 DEBUG (core.profiler) [MainThread] Profile step iter-extra-resources_started - 1732183245.943935 2024-11-21 10:00:45,944 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=iter-extra-resources, group=graph, time=1732183245.9440658 2024-11-21 10:00:45,944 DEBUG (core.stages_profiler) [MainThread] Set stage iter-extra-resources_finished=1732183245.9440658 2024-11-21 10:00:45,944 DEBUG (core.profiler) [MainThread] Profile step iter-extra-resources_finished - 1732183245.9440658 2024-11-21 10:00:45,944 DEBUG (exts.timer) [MainThread] Timer build.graph, stage build and merge graphs: 1.129988431930542 2024-11-21 10:00:45,944 DEBUG (core.stage_tracer) [MainThread] Start stage tag=strip-graph, group=graph, time=1732183245.9442253 2024-11-21 10:00:45,944 DEBUG (core.stages_profiler) [MainThread] Set stage strip-graph_started=1732183245.9442253 2024-11-21 10:00:45,944 DEBUG (core.profiler) [MainThread] Profile step strip-graph_started - 1732183245.9442253 2024-11-21 10:00:45,944 DEBUG (build.graph) [MainThread] stripped 0, left 13 nodes 2024-11-21 10:00:45,944 DEBUG (exts.timer) [MainThread] Timer build.graph, stage strip graph: 0.00020575523376464844 2024-11-21 10:00:45,944 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=strip-graph, group=graph, time=1732183245.944423 2024-11-21 10:00:45,944 DEBUG (core.stages_profiler) [MainThread] Set stage strip-graph_finished=1732183245.944423 2024-11-21 10:00:45,944 DEBUG (core.profiler) [MainThread] Profile step strip-graph_finished - 1732183245.944423 2024-11-21 10:00:45,944 DEBUG (exts.timer) [MainThread] Timer build.graph, stage gen rename nodes: 0.000171661376953125 2024-11-21 10:00:45,944 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] python: will use 'linux-x86_64' platform 2024-11-21 10:00:45,944 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ymake: will use 'linux' platform 2024-11-21 10:00:45,944 DEBUG (core.stage_tracer) [MainThread] Start stage tag=inject_default_requirements, group=graph, time=1732183245.9448204 2024-11-21 10:00:45,944 DEBUG (core.stages_profiler) [MainThread] Set stage inject_default_requirements_started=1732183245.9448204 2024-11-21 10:00:45,944 DEBUG (core.profiler) [MainThread] Profile step inject_default_requirements_started - 1732183245.9448204 2024-11-21 10:00:45,944 DEBUG (build.graph) [MainThread] Updated requirements for 0 nodes 2024-11-21 10:00:45,944 DEBUG (exts.timer) [MainThread] Timer substitude_uids, stage substitude_uids: 7.152557373046875e-06 2024-11-21 10:00:45,945 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=inject_default_requirements, group=graph, time=1732183245.9450185 2024-11-21 10:00:45,945 DEBUG (core.stages_profiler) [MainThread] Set stage inject_default_requirements_finished=1732183245.9450185 2024-11-21 10:00:45,945 DEBUG (core.profiler) [MainThread] Profile step inject_default_requirements_finished - 1732183245.9450185 2024-11-21 10:00:45,945 DEBUG (exts.timer) [MainThread] Timer build.graph, stage misc graph changes: 0.000583648681640625 2024-11-21 10:00:45,945 DEBUG (core.stage_tracer) [MainThread] Start stage tag=finalize-graph, group=graph, time=1732183245.9451823 2024-11-21 10:00:45,945 DEBUG (core.stages_profiler) [MainThread] Set stage finalize-graph_started=1732183245.9451823 2024-11-21 10:00:45,945 DEBUG (core.profiler) [MainThread] Profile step finalize-graph_started - 1732183245.9451823 2024-11-21 10:00:45,945 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=finalize-graph, group=graph, time=1732183245.9452813 2024-11-21 10:00:45,945 DEBUG (core.stages_profiler) [MainThread] Set stage finalize-graph_finished=1732183245.9452813 2024-11-21 10:00:45,945 DEBUG (core.profiler) [MainThread] Profile step finalize-graph_finished - 1732183245.9452813 2024-11-21 10:00:45,945 DEBUG (core.stage_tracer) [MainThread] Start stage tag=imprint-store-and-stats, group=graph, time=1732183245.945392 2024-11-21 10:00:45,945 DEBUG (core.stages_profiler) [MainThread] Set stage imprint-store-and-stats_started=1732183245.945392 2024-11-21 10:00:45,945 DEBUG (core.profiler) [MainThread] Profile step imprint-store-and-stats_started - 1732183245.945392 2024-11-21 10:00:45,945 DEBUG (core.imprint.imprint:Imprint) [MainThread] 2024-11-21 10:00:45,945 DEBUG (core.imprint.imprint:Imprint) [MainThread] 2024-11-21 10:00:45,945 DEBUG (core.imprint.imprint:Imprint) [MainThread] 2024-11-21 10:00:45,945 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=imprint-store-and-stats, group=graph, time=1732183245.9456348 2024-11-21 10:00:45,945 DEBUG (core.stages_profiler) [MainThread] Set stage imprint-store-and-stats_finished=1732183245.9456348 2024-11-21 10:00:45,945 DEBUG (core.profiler) [MainThread] Profile step imprint-store-and-stats_finished - 1732183245.9456348 2024-11-21 10:00:45,945 DEBUG (core.stage_tracer) [MainThread] Start stage tag=inject_stats_and_static_uids, group=graph, time=1732183245.9457498 2024-11-21 10:00:45,945 DEBUG (core.stages_profiler) [MainThread] Set stage inject_stats_and_static_uids_started=1732183245.9457498 2024-11-21 10:00:45,945 DEBUG (core.profiler) [MainThread] Profile step inject_stats_and_static_uids_started - 1732183245.9457498 2024-11-21 10:00:45,946 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=inject_stats_and_static_uids, group=graph, time=1732183245.9460251 2024-11-21 10:00:45,946 DEBUG (core.stages_profiler) [MainThread] Set stage inject_stats_and_static_uids_finished=1732183245.9460251 2024-11-21 10:00:45,946 DEBUG (core.profiler) [MainThread] Profile step inject_stats_and_static_uids_finished - 1732183245.9460251 2024-11-21 10:00:45,946 DEBUG (core.stage_tracer) [MainThread] Start stage tag=strip-tags, group=graph, time=1732183245.9461584 2024-11-21 10:00:45,946 DEBUG (core.stages_profiler) [MainThread] Set stage strip-tags_started=1732183245.9461584 2024-11-21 10:00:45,946 DEBUG (core.profiler) [MainThread] Profile step strip-tags_started - 1732183245.9461584 2024-11-21 10:00:45,946 DEBUG (exts.timer) [MainThread] Timer build.graph, stage strip tags: 0.0011420249938964844 2024-11-21 10:00:45,946 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=strip-tags, group=graph, time=1732183245.9463236 2024-11-21 10:00:45,946 DEBUG (core.stages_profiler) [MainThread] Set stage strip-tags_finished=1732183245.9463236 2024-11-21 10:00:45,946 DEBUG (core.profiler) [MainThread] Profile step strip-tags_finished - 1732183245.9463236 2024-11-21 10:00:45,946 DEBUG (core.stage_tracer) [MainThread] Start stage tag=reduce_graph_resources, group=graph, time=1732183245.9465516 2024-11-21 10:00:45,946 DEBUG (core.stages_profiler) [MainThread] Set stage reduce_graph_resources_started=1732183245.9465516 2024-11-21 10:00:45,946 DEBUG (core.profiler) [MainThread] Profile step reduce_graph_resources_started - 1732183245.9465516 2024-11-21 10:00:45,946 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=reduce_graph_resources, group=graph, time=1732183245.9468334 2024-11-21 10:00:45,946 DEBUG (core.stages_profiler) [MainThread] Set stage reduce_graph_resources_finished=1732183245.9468334 2024-11-21 10:00:45,946 DEBUG (core.profiler) [MainThread] Profile step reduce_graph_resources_finished - 1732183245.9468334 2024-11-21 10:00:45,946 DEBUG (core.stage_tracer) [MainThread] Start stage tag=clean-intern-string-storage, group=graph, time=1732183245.9469671 2024-11-21 10:00:45,947 DEBUG (core.stages_profiler) [MainThread] Set stage clean-intern-string-storage_started=1732183245.9469671 2024-11-21 10:00:45,947 DEBUG (core.profiler) [MainThread] Profile step clean-intern-string-storage_started - 1732183245.9469671 2024-11-21 10:00:45,947 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=clean-intern-string-storage, group=graph, time=1732183245.9471498 2024-11-21 10:00:45,947 DEBUG (core.stages_profiler) [MainThread] Set stage clean-intern-string-storage_finished=1732183245.9471498 2024-11-21 10:00:45,947 DEBUG (core.profiler) [MainThread] Profile step clean-intern-string-storage_finished - 1732183245.9471498 2024-11-21 10:00:45,947 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=build_graph_and_tests, group=graph, time=1732183245.9472842 2024-11-21 10:00:45,947 DEBUG (core.stages_profiler) [MainThread] Set stage build_graph_and_tests_finished=1732183245.9472842 2024-11-21 10:00:45,947 DEBUG (core.profiler) [MainThread] Profile step build_graph_and_tests_finished - 1732183245.9472842 2024-11-21 10:00:45,947 DEBUG (exts.timer) [MainThread] Timer context_creation, stage graph_and_tests finished: 1.163259744644165 2024-11-21 10:00:45,948 DEBUG (core.stage_tracer) [MainThread] Start stage tag=configure-dist-store-cache, group=ya_make, time=1732183245.9488819 2024-11-21 10:00:45,948 DEBUG (core.stages_profiler) [MainThread] Set stage configure-dist-store-cache_started=1732183245.9488819 2024-11-21 10:00:45,949 DEBUG (core.profiler) [MainThread] Profile step configure-dist-store-cache_started - 1732183245.9488819 2024-11-21 10:00:45,949 DEBUG (build.ya_make) [MainThread] Waiting for dist cache setup 2024-11-21 10:00:45,949 DEBUG (build.ya_make) [MainThread] Loading meta from dist cache 2024-11-21 10:00:45,949 DEBUG (build.ya_make) [MainThread] Dist cache prepared 2024-11-21 10:00:45,949 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=configure-dist-store-cache, group=ya_make, time=1732183245.9491754 2024-11-21 10:00:45,949 DEBUG (core.stages_profiler) [MainThread] Set stage configure-dist-store-cache_finished=1732183245.9491754 2024-11-21 10:00:45,949 DEBUG (core.profiler) [MainThread] Profile step configure-dist-store-cache_finished - 1732183245.9491754 2024-11-21 10:00:45,949 DEBUG (core.stage_tracer) [MainThread] Start stage tag=configure-local-cache, group=ya_make, time=1732183245.9493117 2024-11-21 10:00:45,949 DEBUG (core.stages_profiler) [MainThread] Set stage configure-local-cache_started=1732183245.9493117 2024-11-21 10:00:45,949 DEBUG (core.profiler) [MainThread] Profile step configure-local-cache_started - 1732183245.9493117 2024-11-21 10:00:45,949 DEBUG (build.ya_make) [MainThread] content UIDs forced 2024-11-21 10:00:45,949 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=configure-local-cache, group=ya_make, time=1732183245.9495125 2024-11-21 10:00:45,949 DEBUG (core.stages_profiler) [MainThread] Set stage configure-local-cache_finished=1732183245.9495125 2024-11-21 10:00:45,949 DEBUG (core.profiler) [MainThread] Profile step configure-local-cache_finished - 1732183245.9495125 2024-11-21 10:00:45,949 DEBUG (build.ya_make) [MainThread] sandbox_run_test_uids: set() 2024-11-21 10:00:45,951 DEBUG (urllib3.connectionpool) [Misc-05] Starting new HTTP connection (1): cachesrv.internal:8081 2024-11-21 10:00:45,952 DEBUG (urllib3.connectionpool) [Misc-06] Starting new HTTP connection (2): cachesrv.internal:8081 2024-11-21 10:00:45,953 DEBUG (urllib3.connectionpool) [Misc-07] Starting new HTTP connection (3): cachesrv.internal:8081 2024-11-21 10:00:45,954 DEBUG (urllib3.connectionpool) [Misc-08] Starting new HTTP connection (4): cachesrv.internal:8081 2024-11-21 10:00:45,955 DEBUG (urllib3.connectionpool) [Misc-09] Starting new HTTP connection (5): cachesrv.internal:8081 2024-11-21 10:00:45,956 DEBUG (urllib3.connectionpool) [Misc-07] http://cachesrv.internal:8081 "HEAD /ac/75363872507466446133612d77416533374b5739537700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:45,956 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-07] Bazel-remote Probing u68rPtfDa3a-wAe37KW9Sw => False 2024-11-21 10:00:45,958 DEBUG (urllib3.connectionpool) [Misc-11] Starting new HTTP connection (6): cachesrv.internal:8081 2024-11-21 10:00:45,958 DEBUG (urllib3.connectionpool) [Misc-10] http://cachesrv.internal:8081 "HEAD /ac/774e686f57484e50644446675a364b4575764e47687700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:45,959 DEBUG (urllib3.connectionpool) [Misc-06] http://cachesrv.internal:8081 "HEAD /ac/456a7a35634c2d366f32422d662d59634462444b767700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:45,960 DEBUG (urllib3.connectionpool) [Misc-12] Starting new HTTP connection (7): cachesrv.internal:8081 2024-11-21 10:00:45,960 DEBUG (urllib3.connectionpool) [Misc-05] http://cachesrv.internal:8081 "HEAD /ac/4235573062656e74775436455739526452673441696700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:45,961 DEBUG (urllib3.connectionpool) [Misc-13] Starting new HTTP connection (8): cachesrv.internal:8081 2024-11-21 10:00:45,961 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-10] Bazel-remote Probing wNhoWHNPdDFgZ6KEuvNGhw => False 2024-11-21 10:00:45,961 DEBUG (urllib3.connectionpool) [Misc-08] http://cachesrv.internal:8081 "HEAD /ac/614b7a47786c7957616a79696f374a545a387a63667700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:00:45,962 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-06] Bazel-remote Probing Ejz5cL-6o2B-f-YcDbDKvw => False 2024-11-21 10:00:45,963 DEBUG (urllib3.connectionpool) [Misc-11] http://cachesrv.internal:8081 "HEAD /ac/3276756f474b7870594b6669394839354b3435374d4100000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:00:45,963 DEBUG (urllib3.connectionpool) [Misc-09] http://cachesrv.internal:8081 "HEAD /ac/456c6f45705f536a6f6b516373654145613651426f4100000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:45,964 DEBUG (urllib3.connectionpool) [Misc-14] http://cachesrv.internal:8081 "HEAD /ac/76635462767a6f63317935666f6e6e4852477457516700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:00:45,965 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-05] Bazel-remote Probing B5W0bentwT6EW9RdRg4Aig => False 2024-11-21 10:00:45,966 DEBUG (urllib3.connectionpool) [Misc-15] http://cachesrv.internal:8081 "HEAD /ac/6872735657476374305a33424345347a69764837736700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:45,966 DEBUG (urllib3.connectionpool) [Misc-16] http://cachesrv.internal:8081 "HEAD /ac/6c5964543150504334654d55506c2d746c325533497700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:45,967 DEBUG (urllib3.connectionpool) [Misc-17] Starting new HTTP connection (9): cachesrv.internal:8081 2024-11-21 10:00:45,968 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-08] Bazel-remote Probing aKzGxlyWajyio7JTZ8zcfw => True 2024-11-21 10:00:45,968 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-11] Bazel-remote Probing 2vuoGKxpYKfi9H95K457MA => True 2024-11-21 10:00:45,968 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-09] Bazel-remote Probing EloEp_SjokQcseAEa6QBoA => False 2024-11-21 10:00:45,969 DEBUG (urllib3.connectionpool) [Misc-12] http://cachesrv.internal:8081 "HEAD /ac/474f6157312d496748745a72774d5151676631774e6700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:45,969 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-14] Bazel-remote Probing vcTbvzoc1y5fonnHRGtWQg => True 2024-11-21 10:00:45,969 DEBUG (urllib3.connectionpool) [Misc-13] http://cachesrv.internal:8081 "HEAD /ac/5331677649784232534a5a6a617150387a3874516b7700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:45,970 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-15] Bazel-remote Probing hrsVWGct0Z3BCE4zivH7sg => False 2024-11-21 10:00:45,970 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-16] Bazel-remote Probing lYdT1PPC4eMUPl-tl2U3Iw => False 2024-11-21 10:00:45,971 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-12] Bazel-remote Probing GOaW1-IgHtZrwMQQgf1wNg => False 2024-11-21 10:00:45,971 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-13] Bazel-remote Probing S1gvIxB2SJZjaqP8z8tQkw => False 2024-11-21 10:00:45,972 DEBUG (urllib3.connectionpool) [Misc-17] http://cachesrv.internal:8081 "HEAD /ac/666759595235374b495339374a43674c716d4261666700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:45,972 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-17] Bazel-remote Probing fgYYR57KIS97JCgLqmBafg => False 2024-11-21 10:00:45,973 DEBUG (build.ya_make) [MainThread] Strip graph due bazel_remote_store mode 2024-11-21 10:00:45,973 DEBUG (build.graph) [MainThread] stripped 0, left 13 nodes 2024-11-21 10:00:45,977 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=context_creation, group=ya_make, time=1732183245.9769874 2024-11-21 10:00:45,977 DEBUG (core.stages_profiler) [MainThread] Set stage context_creation_finished=1732183245.9769874 2024-11-21 10:00:45,977 DEBUG (core.profiler) [MainThread] Profile step context_creation_finished - 1732183245.9769874 2024-11-21 10:00:45,977 DEBUG (exts.timer) [MainThread] Timer context_creation, stage context_creation finished: 0.029627084732055664 2024-11-21 10:00:45,977 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=context_generating, group=build_handler, time=1732183245.9773889 2024-11-21 10:00:45,977 DEBUG (core.stages_profiler) [MainThread] Set stage context_generating_finished=1732183245.9773889 2024-11-21 10:00:45,977 DEBUG (core.profiler) [MainThread] Profile step context_generating_finished - 1732183245.9773889 2024-11-21 10:00:45,977 DEBUG (core.stage_tracer) [MainThread] Start stage tag=build, group=build_handler, time=1732183245.9775565 2024-11-21 10:00:45,977 DEBUG (core.stages_profiler) [MainThread] Set stage build_started=1732183245.9775565 2024-11-21 10:00:45,977 DEBUG (core.profiler) [MainThread] Profile step build_started - 1732183245.9775565 2024-11-21 10:00:45,977 DEBUG (build.reports.autocheck_report) [MainThread] Got 0 tests to report 2024-11-21 10:00:45,978 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2024-11-21 10:00:45,978 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2024-11-21 10:00:45,978 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2024-11-21 10:00:45,978 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2024-11-21 10:00:45,978 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2024-11-21 10:00:45,978 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2024-11-21 10:00:45,979 DEBUG (ReportGenerator) [MainThread] Finish style report 2024-11-21 10:00:45,979 DEBUG (StoredReport) [MainThread] Finish style report 2024-11-21 10:00:45,979 DEBUG (ReportGenerator) [MainThread] Finish tests report, tests by size defaultdict(, {'small': set(), 'medium': set(), 'large': set()}), tests by type defaultdict(, {}) 2024-11-21 10:00:45,979 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2024-11-21 10:00:45,979 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2024-11-21 10:00:45,979 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2024-11-21 10:00:45,979 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2024-11-21 10:00:45,979 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2024-11-21 10:00:45,979 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2024-11-21 10:00:45,979 DEBUG (StoredReport) [MainThread] Finish tests report 2024-11-21 10:00:45,979 DEBUG (ReportGenerator) [MainThread] Finish configure report 2024-11-21 10:00:45,979 DEBUG (StoredReport) [MainThread] Finish configure report 2024-11-21 10:00:45,979 DEBUG (core.stage_tracer) [MainThread] Start stage tag=dispatch_build, group=ya_make, time=1732183245.979518 2024-11-21 10:00:45,979 DEBUG (core.stages_profiler) [MainThread] Set stage dispatch_build_started=1732183245.979518 2024-11-21 10:00:45,979 DEBUG (core.profiler) [MainThread] Profile step dispatch_build_started - 1732183245.979518 2024-11-21 10:00:45,979 DEBUG (yalibrary.runner.runner3) [MainThread] RLIMIT_NOFILE limits: (524288, 524288) 2024-11-21 10:00:45,990 DEBUG (root) [MainThread] Starting local executor with cmd: ['/home/runner/.ya/tools/a6139abb9c_d/ya-bin', 'unix:/home/runner/.ya/tmp/1732183244.20575.esmjm5jo/20575vlzr6y5u', '0'] 2024-11-21 10:00:45,990 DEBUG (root) [MainThread] Not waiting for initialization, returning waiter function 2024-11-21 10:00:46,012 DEBUG (library.python.filelock) [MainThread] Acquiring FileLock (blocking=True): /home/runner/.ya/build/build_root/c2tn/STAMP 2024-11-21 10:00:46,013 DEBUG (exts.timer) [MainThread] Timer yalibrary.runner.runner3, stage resolve: 3.337860107421875e-05 2024-11-21 10:00:46,013 DEBUG (exts.timer) [MainThread] Timer yalibrary.runner.runner3, stage build nodes: 0.00012731552124023438 2024-11-21 10:00:46,013 DEBUG (exts.timer) [MainThread] Timer yalibrary.runner.runner3, stage build who provides, ref count: 5.8650970458984375e-05 2024-11-21 10:00:46,013 DEBUG (exts.timer) [MainThread] Timer yalibrary.runner.runner3, stage build ref count: 5.555152893066406e-05 2024-11-21 10:00:46,013 DEBUG (yalibrary.runner.runner3) [MainThread] content UIDs *enabled* in runner 2024-11-21 10:00:46,118 DEBUG (yalibrary.runner.runner3) [Worker-002] Local executor is ready 2024-11-21 10:00:46,122 DEBUG (yalibrary.toolscache) [PrepareAllNodes_0] AC cache (has uid hrsVWGct0Z3BCE4zivH7sg) address: (20162, 335500, 'unix:/home/runner/.ya/build/cache/7/psingdvpvPV.tmp') 2024-11-21 10:00:46,126 DEBUG (urllib3.connectionpool) [Worker-005] http://cachesrv.internal:8081 "HEAD /ac/6872735657476374305a33424345347a69764837736700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:46,128 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-005] Bazel-remote Probing hrsVWGct0Z3BCE4zivH7sg => False 2024-11-21 10:00:46,129 DEBUG (urllib3.connectionpool) [Worker-006] http://cachesrv.internal:8081 "HEAD /ac/456c6f45705f536a6f6b516373654145613651426f4100000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:46,129 DEBUG (urllib3.connectionpool) [Worker-009] http://cachesrv.internal:8081 "HEAD /ac/6c5964543150504334654d55506c2d746c325533497700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:46,130 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-006] Bazel-remote Probing EloEp_SjokQcseAEa6QBoA => False 2024-11-21 10:00:46,130 DEBUG (yalibrary.fetcher.resource_fetcher) [Worker-011] Fetching 7336031045 from sbr:7336031045 to /home/runner/.ya/tools/v4/7336031045 dir, post_process=0) 2024-11-21 10:00:46,131 DEBUG (yalibrary.fetcher.resource_fetcher) [Worker-013] Fetching 7487632536 from sbr:7487632536 to /home/runner/.ya/tools/v4/7487632536 dir, post_process=0) 2024-11-21 10:00:46,131 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-009] Bazel-remote Probing lYdT1PPC4eMUPl-tl2U3Iw => False 2024-11-21 10:00:46,133 DEBUG (urllib3.connectionpool) [Worker-010] http://cachesrv.internal:8081 "HEAD /ac/474f6157312d496748745a72774d5151676631774e6700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:46,133 DEBUG (urllib3.connectionpool) [Worker-005] http://cachesrv.internal:8081 "HEAD /ac/5331677649784232534a5a6a617150387a3874516b7700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:46,135 DEBUG (urllib3.connectionpool) [Worker-016] http://cachesrv.internal:8081 "HEAD /ac/4235573062656e74775436455739526452673441696700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:46,136 DEBUG (urllib3.connectionpool) [Worker-021] http://cachesrv.internal:8081 "HEAD /ac/666759595235374b495339374a43674c716d4261666700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:46,137 DEBUG (urllib3.connectionpool) [Worker-022] http://cachesrv.internal:8081 "HEAD /ac/774e686f57484e50644446675a364b4575764e47687700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:46,137 DEBUG (urllib3.connectionpool) [Worker-012] http://cachesrv.internal:8081 "HEAD /ac/75363872507466446133612d77416533374b5739537700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:46,138 DEBUG (yalibrary.runner.tasks.result) [Worker-002] ResultsNodeTask for B5W0bentwT6EW9RdRg4Aig created (provider=None) 2024-11-21 10:00:46,139 DEBUG (yalibrary.toolscache) [Worker-011] Tools cache attempt: (request for resource 7336031045) 2024-11-21 10:00:46,139 DEBUG (urllib3.connectionpool) [Worker-024] http://cachesrv.internal:8081 "HEAD /ac/456a7a35634c2d366f32422d662d59634462444b767700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:46,139 DEBUG (yalibrary.toolscache) [Worker-013] Tools cache attempt: (request for resource 7487632536) 2024-11-21 10:00:46,140 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-010] Bazel-remote Probing GOaW1-IgHtZrwMQQgf1wNg => False 2024-11-21 10:00:46,140 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-005] Bazel-remote Probing S1gvIxB2SJZjaqP8z8tQkw => False 2024-11-21 10:00:46,141 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-016] Bazel-remote Probing B5W0bentwT6EW9RdRg4Aig => False 2024-11-21 10:00:46,141 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-021] Bazel-remote Probing fgYYR57KIS97JCgLqmBafg => False 2024-11-21 10:00:46,141 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-022] Bazel-remote Probing wNhoWHNPdDFgZ6KEuvNGhw => False 2024-11-21 10:00:46,142 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-012] Bazel-remote Probing u68rPtfDa3a-wAe37KW9Sw => False 2024-11-21 10:00:46,142 DEBUG (yalibrary.runner.tasks.result) [Worker-002] ResultsNodeTask for Ejz5cL-6o2B-f-YcDbDKvw created (provider=None) 2024-11-21 10:00:46,142 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-024] Bazel-remote Probing Ejz5cL-6o2B-f-YcDbDKvw => False 2024-11-21 10:00:46,144 DEBUG (yalibrary.toolscache) [Worker-011] tc cache stats: TotalKnownSize: 62115840 TotalKnownSizeLocked: 22249472 NonComputedCount: 1 Master: true TotalDBSize: 81920 ToolCount: 2 ProcessesCount: 2 2024-11-21 10:00:46,151 DEBUG (urllib3.connectionpool) [Worker-005] http://cachesrv.internal:8081 "HEAD /ac/76635462767a6f63317935666f6e6e4852477457516700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:00:46,151 DEBUG (yalibrary.toolscache) [Worker-013] tc cache stats: TotalKnownSize: 62115840 TotalKnownSizeLocked: 22249472 NonComputedCount: 2 Master: true TotalDBSize: 81920 ToolCount: 2 ProcessesCount: 2 2024-11-21 10:00:46,152 DEBUG (yalibrary.runner.tasks.result) [Worker-002] ResultsNodeTask for u68rPtfDa3a-wAe37KW9Sw created (provider=None) 2024-11-21 10:00:46,153 DEBUG (urllib3.connectionpool) [Worker-022] http://cachesrv.internal:8081 "HEAD /ac/3276756f474b7870594b6669394839354b3435374d4100000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:00:46,154 DEBUG (yalibrary.fetcher.cache_helper) [Worker-011] not installed /home/runner/.ya/tools/v4/7336031045 2024-11-21 10:00:46,154 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-005] Bazel-remote Probing vcTbvzoc1y5fonnHRGtWQg => True 2024-11-21 10:00:46,154 DEBUG (urllib3.connectionpool) [Worker-024] http://cachesrv.internal:8081 "HEAD /ac/614b7a47786c7957616a79696f374a545a387a63667700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:00:46,155 DEBUG (yalibrary.fetcher.cache_helper) [Worker-013] not installed /home/runner/.ya/tools/v4/7487632536 2024-11-21 10:00:46,155 DEBUG (yalibrary.runner.tasks.result) [Worker-002] ResultsNodeTask for EloEp_SjokQcseAEa6QBoA created (provider=None) 2024-11-21 10:00:46,155 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-022] Bazel-remote Probing 2vuoGKxpYKfi9H95K457MA => True 2024-11-21 10:00:46,156 DEBUG (library.python.filelock) [Worker-011] Acquiring FileLock (blocking=True): /home/runner/.ya/tools/v4/7336031045.lock 2024-11-21 10:00:46,156 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-024] Bazel-remote Probing aKzGxlyWajyio7JTZ8zcfw => True 2024-11-21 10:00:46,156 DEBUG (yalibrary.runner.tasks.result) [Worker-002] ResultsNodeTask for wNhoWHNPdDFgZ6KEuvNGhw created (provider=None) 2024-11-21 10:00:46,157 DEBUG (yalibrary.runner.tasks.result) [Worker-002] ResultsNodeTask for GOaW1-IgHtZrwMQQgf1wNg created (provider=None) 2024-11-21 10:00:46,157 DEBUG (yalibrary.fetcher.cache_helper) [Worker-011] not installed /home/runner/.ya/tools/v4/7336031045 2024-11-21 10:00:46,156 DEBUG (library.python.filelock) [Worker-013] Acquiring FileLock (blocking=True): /home/runner/.ya/tools/v4/7487632536.lock 2024-11-21 10:00:46,157 DEBUG (yalibrary.runner.tasks.result) [Worker-002] ResultsNodeTask for S1gvIxB2SJZjaqP8z8tQkw created (provider=None) 2024-11-21 10:00:46,158 DEBUG (urllib3.connectionpool) [Worker-005] http://cachesrv.internal:8081 "GET /ac/76635462767a6f63317935666f6e6e4852477457516700000000000000000001 HTTP/1.1" 200 576 2024-11-21 10:00:46,158 DEBUG (yalibrary.fetcher.cache_helper) [Worker-013] not installed /home/runner/.ya/tools/v4/7487632536 2024-11-21 10:00:46,158 DEBUG (exts.http_client) [Worker-011] Downloading https://devtools-registry.s3.yandex.net/7336031045 to /home/runner/.ya/tools/v4/7336031045/resource.dbzh5iy7.nn6z4u18.part, expect md5- 2024-11-21 10:00:46,158 DEBUG (yalibrary.runner.tasks.result) [Worker-002] ResultsNodeTask for fgYYR57KIS97JCgLqmBafg created (provider=None) 2024-11-21 10:00:46,159 DEBUG (urllib3.connectionpool) [Worker-024] http://cachesrv.internal:8081 "GET /ac/614b7a47786c7957616a79696f374a545a387a63667700000000000000000001 HTTP/1.1" 200 566 2024-11-21 10:00:46,160 DEBUG (yalibrary.runner.tasks.result) [Worker-002] ResultsNodeTask for hrsVWGct0Z3BCE4zivH7sg created (provider=None) 2024-11-21 10:00:46,161 DEBUG (exts.http_client) [Worker-013] Downloading https://devtools-registry.s3.yandex.net/7487632536 to /home/runner/.ya/tools/v4/7487632536/resource.cjh42d2u.2pf5u9zm.part, expect md5- 2024-11-21 10:00:46,167 DEBUG (urllib3.connectionpool) [Worker-005] http://cachesrv.internal:8081 "GET /cas/f978e50c7ff4e2ce87baa6de18a6ddc3ebe8660cc6a8665702411d948e8a9714 HTTP/1.1" 200 45 2024-11-21 10:00:46,167 DEBUG (yalibrary.runner.tasks.result) [Worker-002] ResultsNodeTask for lYdT1PPC4eMUPl-tl2U3Iw created (provider=None) 2024-11-21 10:00:46,167 DEBUG (urllib3.connectionpool) [Worker-024] http://cachesrv.internal:8081 "GET /cas/b48b46aadc84c69d2daf2135ae401548ebae767c7650356d255db5d6e73dfdd7 HTTP/1.1" 200 45 2024-11-21 10:00:46,168 DEBUG (yalibrary.toolscache) [Worker-002] AC cache attempt: (force gc 2199023255552) 2024-11-21 10:00:46,168 DEBUG (urllib3.connectionpool) [Worker-022] http://cachesrv.internal:8081 "GET /ac/3276756f474b7870594b6669394839354b3435374d4100000000000000000001 HTTP/1.1" 200 570 2024-11-21 10:00:46,171 DEBUG (yalibrary.toolscache) [Worker-002] Tools cache attempt: (force gc tools cache 2199023255552) 2024-11-21 10:00:46,171 DEBUG (urllib3.connectionpool) [Worker-005] http://cachesrv.internal:8081 "GET /cas/33d0bd2f065e52b1bcd15eeb9f0e84cf75076a1c87ce37a33fc2c34433b99826 HTTP/1.1" 200 277 2024-11-21 10:00:46,172 DEBUG (urllib3.connectionpool) [Worker-022] http://cachesrv.internal:8081 "GET /cas/8be96c789171a7f856c4083ecaa4106e6f3f76e1694c212442063022ac08b35a HTTP/1.1" 200 45 2024-11-21 10:00:46,174 DEBUG (urllib3.connectionpool) [Worker-024] http://cachesrv.internal:8081 "GET /cas/a3fa2bf341630b12bd0d3ad7b7cf2f61297a6907ebec22a3ac798cc1fe0cb080 HTTP/1.1" 200 272 2024-11-21 10:00:46,175 DEBUG (urllib3.connectionpool) [Worker-022] http://cachesrv.internal:8081 "GET /cas/d1c6050a7ed280771f13bd85d7b7fdacec7313803cb4dff8f118ca77f9a78ebf HTTP/1.1" 200 274 2024-11-21 10:00:46,177 DEBUG (urllib3.connectionpool) [Worker-005] http://cachesrv.internal:8081 "GET /cas/2476989c5d8666119ef3d3a99a385863a228824c24ae377dfa11aa72f2786e98 HTTP/1.1" 200 366 2024-11-21 10:00:46,178 DEBUG (yalibrary.toolscache) [Worker-054] AC cache attempt: (put uid vcTbvzoc1y5fonnHRGtWQg) 2024-11-21 10:00:46,178 DEBUG (urllib3.connectionpool) [Worker-024] http://cachesrv.internal:8081 "GET /cas/1401716041e1f0d70ad8a721b55e0693575271b1701d886964e4bb39e62c5840 HTTP/1.1" 200 375 2024-11-21 10:00:46,179 DEBUG (yalibrary.toolscache) [Worker-024] AC cache attempt: (put uid aKzGxlyWajyio7JTZ8zcfw) 2024-11-21 10:00:46,179 DEBUG (urllib3.connectionpool) [Worker-022] http://cachesrv.internal:8081 "GET /cas/f7d1ec8734e6b999138921ac1aeecaa475c71b3c3928eb98b80bf1d760c4f9d6 HTTP/1.1" 200 313 2024-11-21 10:00:46,180 DEBUG (yalibrary.toolscache) [Worker-022] AC cache attempt: (put uid 2vuoGKxpYKfi9H95K457MA) 2024-11-21 10:00:46,324 DEBUG (exts.http_client) [Worker-011] Request to https://devtools-registry.s3.yandex.net/7336031045 has headers Server: nginx Date: Thu, 21 Nov 2024 10:00:46 GMT Content-Type: application/octet-stream Content-Length: 12509507 Connection: close Accept-Ranges: bytes Etag: "2e88d3d4d49302ffa7daf9d507d47587-2" Last-Modified: Thu, 24 Oct 2024 17:39:31 GMT X-Amz-Request-Id: 397bb842de49e316 NEL: {"report_to": "network-errors", "max_age": 600, "success_fraction": 0.001, "failure_fraction": 0.01} Report-To: {"group": "network-errors", "max_age": 600, "endpoints": [ { "url": "https://dr.yandex.net/s3_nel?datacenter=KLG"}]} Access-Control-Allow-Origin: * X-Robots-Tag: noindex, noarchive, nofollow 2024-11-21 10:00:46,342 DEBUG (exts.http_client) [Worker-013] Request to https://devtools-registry.s3.yandex.net/7487632536 has headers Server: nginx Date: Thu, 21 Nov 2024 10:00:46 GMT Content-Type: application/octet-stream Content-Length: 413644800 Connection: close Accept-Ranges: bytes Etag: "11f90adcd2edf3313773f4f42ec84864-50" Last-Modified: Mon, 18 Nov 2024 15:12:51 GMT X-Amz-Request-Id: c10e0bbd99407f39 NEL: {"report_to": "network-errors", "max_age": 600, "success_fraction": 0.001, "failure_fraction": 0.01} Report-To: {"group": "network-errors", "max_age": 600, "endpoints": [ { "url": "https://dr.yandex.net/s3_nel?datacenter=KLG"}]} Access-Control-Allow-Origin: * X-Robots-Tag: noindex, noarchive, nofollow 2024-11-21 10:00:46,479 DEBUG (exts.http_client) [Worker-011] Downloading finished https://devtools-registry.s3.yandex.net/7336031045 to /home/runner/.ya/tools/v4/7336031045/resource.dbzh5iy7, md5=0721a973ac7d03643308fab89504be06, size=12509507, elapsed=0.320054 2024-11-21 10:00:46,480 DEBUG (yalibrary.fetcher.common) [Worker-011] extract /home/runner/.ya/tools/v4/7336031045/resource.dbzh5iy7 to /home/runner/.ya/tools/v4/7336031045 dir (strip_prefix=None) 2024-11-21 10:00:46,636 DEBUG (library.python.filelock) [Worker-011] Ensuring FileLock released: /home/runner/.ya/tools/v4/7336031045.lock 2024-11-21 10:00:46,640 DEBUG (yalibrary.toolscache) [Worker-011] AC cache attempt: (get uid e9d0bc808e09a5d290dc6562967cd35c) 2024-11-21 10:00:46,642 DEBUG (yalibrary.toolscache) [Worker-067] AC cache attempt: (get uid 474175aa26ab1b9eaf6629d79d8a31aa) 2024-11-21 10:00:46,644 DEBUG (urllib3.connectionpool) [Worker-011] http://cachesrv.internal:8081 "HEAD /ac/ef0de73f57518e1f2c2d7daa9e76318c7839351ddc63ce7c150359cec19ea011 HTTP/1.1" 404 0 2024-11-21 10:00:46,645 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-011] Bazel-remote Probing e9d0bc808e09a5d290dc6562967cd35c => False 2024-11-21 10:00:46,645 DEBUG (urllib3.connectionpool) [Worker-067] http://cachesrv.internal:8081 "HEAD /ac/fc18ec33bb48c6669174b93c25c718b281bf831657342344000361f798c86d11 HTTP/1.1" 404 0 2024-11-21 10:00:46,645 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-067] Bazel-remote Probing 474175aa26ab1b9eaf6629d79d8a31aa => False 2024-11-21 10:00:46,645 DEBUG (root) [Worker-011] Run node fgYYR57KIS97JCgLqmBafg in build root /home/runner/.ya/build/build_root/c2tn/000014 2024-11-21 10:00:46,646 DEBUG (root) [Worker-067] Run node u68rPtfDa3a-wAe37KW9Sw in build root /home/runner/.ya/build/build_root/c2tn/000016 2024-11-21 10:00:46,990 DEBUG (yalibrary.toolscache) [Worker-070] AC cache attempt: (put uid u68rPtfDa3a-wAe37KW9Sw) 2024-11-21 10:00:46,991 DEBUG (urllib3.connectionpool) [Worker-067] http://cachesrv.internal:8081 "HEAD /ac/75363872507466446133612d77416533374b5739537700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:46,991 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-067] Bazel-remote Probing u68rPtfDa3a-wAe37KW9Sw => False 2024-11-21 10:00:46,992 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-067] Put ydb/docs/ru/core/docs-ru-core.docslib(u68rPtfDa3a-wAe37KW9Sw) to Bazel-remote 2024-11-21 10:00:46,992 DEBUG (yalibrary.toolscache) [Worker-070] AC cache attempt: (put uid 474175aa26ab1b9eaf6629d79d8a31aa) 2024-11-21 10:00:46,994 DEBUG (yalibrary.runner.tasks.result) [Worker-072] Result node u68rPtfDa3a-wAe37KW9Sw processed successfully: True 2024-11-21 10:00:46,997 DEBUG (urllib3.connectionpool) [Worker-067] http://cachesrv.internal:8081 "PUT /cas/68666f2660a382c14c1294b1ac58d68a2831a0e68e143def75172005c61518db HTTP/1.1" 200 0 2024-11-21 10:00:47,000 DEBUG (urllib3.connectionpool) [Worker-067] http://cachesrv.internal:8081 "PUT /cas/7e8189ca5fe01f411c31aa800781dc3c3ceb70721dc90cc76ea28ce4c08177d1 HTTP/1.1" 200 0 2024-11-21 10:00:47,220 DEBUG (yalibrary.runner.tasks.result) [Worker-011] Result node fgYYR57KIS97JCgLqmBafg processed successfully: True 2024-11-21 10:00:47,220 DEBUG (yalibrary.toolscache) [Worker-086] AC cache attempt: (put uid fgYYR57KIS97JCgLqmBafg) 2024-11-21 10:00:47,222 DEBUG (yalibrary.toolscache) [Worker-086] AC cache attempt: (put uid e9d0bc808e09a5d290dc6562967cd35c) 2024-11-21 10:00:47,225 DEBUG (urllib3.connectionpool) [Worker-081] http://cachesrv.internal:8081 "HEAD /ac/666759595235374b495339374a43674c716d4261666700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:47,226 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-081] Bazel-remote Probing fgYYR57KIS97JCgLqmBafg => False 2024-11-21 10:00:47,226 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-081] Put ydb/docs/__docs_internal.docslib.fake(fgYYR57KIS97JCgLqmBafg) to Bazel-remote 2024-11-21 10:00:47,230 DEBUG (urllib3.connectionpool) [Worker-081] http://cachesrv.internal:8081 "PUT /cas/c0825668d1fa617c86d7176912cd3d4c0e082fdd1140c8ca2dcf36f0968ecfa2 HTTP/1.1" 200 0 2024-11-21 10:00:47,234 DEBUG (urllib3.connectionpool) [Worker-081] http://cachesrv.internal:8081 "PUT /cas/b0204194ceb80814e0b6cb9e402ab315ada27c7828d59cba43b8cd955e379a5a HTTP/1.1" 200 0 2024-11-21 10:00:47,318 DEBUG (urllib3.connectionpool) [Worker-067] http://cachesrv.internal:8081 "PUT /cas/ed169b0e302f4f3c78eebded4732636ec4b2502ee083d28d2fab661c0b1d8faf HTTP/1.1" 200 0 2024-11-21 10:00:47,321 DEBUG (urllib3.connectionpool) [Worker-067] http://cachesrv.internal:8081 "PUT /ac/75363872507466446133612d77416533374b5739537700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:00:47,321 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-067] Put ydb/docs/ru/core/docs-ru-core.docslib(u68rPtfDa3a-wAe37KW9Sw) size=29634833 to Bazel-remote completed 2024-11-21 10:00:47,767 DEBUG (urllib3.connectionpool) [Worker-081] http://cachesrv.internal:8081 "PUT /cas/f09598cea90b4ad37fee3ae5f64a573673329c58f912a9a192e3f1b972d2481d HTTP/1.1" 200 0 2024-11-21 10:00:47,771 DEBUG (urllib3.connectionpool) [Worker-081] http://cachesrv.internal:8081 "PUT /ac/666759595235374b495339374a43674c716d4261666700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:00:47,772 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-081] Put ydb/docs/__docs_internal.docslib.fake(fgYYR57KIS97JCgLqmBafg) size=51589393 to Bazel-remote completed 2024-11-21 10:00:55,501 DEBUG (exts.http_client) [Worker-013] Downloading finished https://devtools-registry.s3.yandex.net/7487632536 to /home/runner/.ya/tools/v4/7487632536/resource.cjh42d2u, md5=40a01d355c1aa1b53a37fbe251e7fa2d, size=413644800, elapsed=9.333577 2024-11-21 10:00:55,501 DEBUG (yalibrary.fetcher.common) [Worker-013] extract /home/runner/.ya/tools/v4/7487632536/resource.cjh42d2u to /home/runner/.ya/tools/v4/7487632536 dir (strip_prefix=None) 2024-11-21 10:00:55,863 DEBUG (library.python.filelock) [Worker-013] Ensuring FileLock released: /home/runner/.ya/tools/v4/7487632536.lock 2024-11-21 10:00:55,864 DEBUG (yalibrary.toolscache) [Worker-096] AC cache attempt: (get uid 63d12eff6bcf6b929e2560d198327d11) 2024-11-21 10:00:55,865 DEBUG (yalibrary.toolscache) [Worker-013] AC cache attempt: (get uid c7abe54794cc9b74f95dedd0b861ce7e) 2024-11-21 10:00:55,865 DEBUG (yalibrary.toolscache) [Worker-097] AC cache attempt: (get uid de9a259ad6bd385447d86ff944da1634) 2024-11-21 10:00:55,866 DEBUG (yalibrary.toolscache) [Worker-095] AC cache attempt: (get uid 9292d046b63be4c92935853678bbafb0) 2024-11-21 10:00:55,869 DEBUG (urllib3.connectionpool) [Worker-013] http://cachesrv.internal:8081 "HEAD /ac/7173216773f6a9ff2858fa51d3b8888b67f6fd04539ad71a21116a2a9c109c11 HTTP/1.1" 404 0 2024-11-21 10:00:55,869 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-013] Bazel-remote Probing c7abe54794cc9b74f95dedd0b861ce7e => False 2024-11-21 10:00:55,870 DEBUG (urllib3.connectionpool) [Worker-097] http://cachesrv.internal:8081 "HEAD /ac/4a05487e8b65fbf5d2a63d3ec5843d288f1133c62f94158390650c25e32a2711 HTTP/1.1" 404 0 2024-11-21 10:00:55,870 DEBUG (urllib3.connectionpool) [Worker-096] http://cachesrv.internal:8081 "HEAD /ac/a52729f638c04b815b50e6591aa79e6ef67f8047cdd2ac28cb390b2d6740be11 HTTP/1.1" 404 0 2024-11-21 10:00:55,870 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-097] Bazel-remote Probing de9a259ad6bd385447d86ff944da1634 => False 2024-11-21 10:00:55,870 DEBUG (urllib3.connectionpool) [Worker-095] http://cachesrv.internal:8081 "HEAD /ac/0006b8c80e94865f6d6495caa8baf9e8fe3f672ccb43dd812243d26b62a76e11 HTTP/1.1" 404 0 2024-11-21 10:00:55,871 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-096] Bazel-remote Probing 63d12eff6bcf6b929e2560d198327d11 => False 2024-11-21 10:00:55,871 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-095] Bazel-remote Probing 9292d046b63be4c92935853678bbafb0 => False 2024-11-21 10:00:55,874 DEBUG (root) [Worker-097] Run node S1gvIxB2SJZjaqP8z8tQkw in build root /home/runner/.ya/build/build_root/c2tn/000011 2024-11-21 10:00:55,875 DEBUG (root) [Worker-096] Run node Ejz5cL-6o2B-f-YcDbDKvw in build root /home/runner/.ya/build/build_root/c2tn/000018 2024-11-21 10:00:55,916 DEBUG (root) [Worker-095] Run node wNhoWHNPdDFgZ6KEuvNGhw in build root /home/runner/.ya/build/build_root/c2tn/000015 2024-11-21 10:00:55,936 DEBUG (root) [Worker-013] Run node lYdT1PPC4eMUPl-tl2U3Iw in build root /home/runner/.ya/build/build_root/c2tn/00000f 2024-11-21 10:00:59,437 DEBUG (yalibrary.toolscache) [Worker-105] AC cache attempt: (put uid Ejz5cL-6o2B-f-YcDbDKvw) 2024-11-21 10:00:59,438 DEBUG (urllib3.connectionpool) [Worker-096] http://cachesrv.internal:8081 "HEAD /ac/456a7a35634c2d366f32422d662d59634462444b767700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:59,438 DEBUG (yalibrary.toolscache) [Worker-104] AC cache attempt: (get uid e522b82a681ab72f0463d8cc2c127fa2) 2024-11-21 10:00:59,439 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-096] Bazel-remote Probing Ejz5cL-6o2B-f-YcDbDKvw => False 2024-11-21 10:00:59,439 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-096] Put ydb/yql_docs/tests/build/yt/preprocessed.tar.gz(Ejz5cL-6o2B-f-YcDbDKvw) to Bazel-remote 2024-11-21 10:00:59,440 DEBUG (yalibrary.toolscache) [Worker-105] AC cache attempt: (put uid 63d12eff6bcf6b929e2560d198327d11) 2024-11-21 10:00:59,442 DEBUG (urllib3.connectionpool) [Worker-104] http://cachesrv.internal:8081 "HEAD /ac/392a4cc2477b766b7f3717d4fc9d92dff99bc6e5b6eb48a7f2596c82b9aa5711 HTTP/1.1" 404 0 2024-11-21 10:00:59,442 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-104] Bazel-remote Probing e522b82a681ab72f0463d8cc2c127fa2 => False 2024-11-21 10:00:59,442 DEBUG (yalibrary.runner.tasks.result) [Worker-103] Result node Ejz5cL-6o2B-f-YcDbDKvw processed successfully: True 2024-11-21 10:00:59,443 DEBUG (root) [Worker-104] Run node B5W0bentwT6EW9RdRg4Aig in build root /home/runner/.ya/build/build_root/c2tn/000012 2024-11-21 10:00:59,445 DEBUG (urllib3.connectionpool) [Worker-096] http://cachesrv.internal:8081 "PUT /cas/529d53b340ed9cbc9314cf9329f53aaeb43fa5947ba8080566aa91fe8e71ce49 HTTP/1.1" 200 0 2024-11-21 10:00:59,450 DEBUG (urllib3.connectionpool) [Worker-096] http://cachesrv.internal:8081 "PUT /cas/420dd1e11c0298589a1044179be4ff709f730b2f3a8bd947dd3a3889fed56d42 HTTP/1.1" 200 0 2024-11-21 10:00:59,459 DEBUG (yalibrary.toolscache) [Worker-118] AC cache attempt: (put uid wNhoWHNPdDFgZ6KEuvNGhw) 2024-11-21 10:00:59,460 DEBUG (yalibrary.toolscache) [Worker-115] AC cache attempt: (get uid 2133e9ce391435847e857f7a3a7241a3) 2024-11-21 10:00:59,461 DEBUG (yalibrary.toolscache) [Worker-118] AC cache attempt: (put uid 9292d046b63be4c92935853678bbafb0) 2024-11-21 10:00:59,462 DEBUG (yalibrary.runner.tasks.result) [Worker-114] Result node wNhoWHNPdDFgZ6KEuvNGhw processed successfully: True 2024-11-21 10:00:59,464 DEBUG (urllib3.connectionpool) [Worker-095] http://cachesrv.internal:8081 "HEAD /ac/774e686f57484e50644446675a364b4575764e47687700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:59,464 DEBUG (urllib3.connectionpool) [Worker-115] http://cachesrv.internal:8081 "HEAD /ac/154e214596925e5a4d147c0a0a14b180f97f9fefb736d7592736cff7423a6311 HTTP/1.1" 404 0 2024-11-21 10:00:59,465 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-095] Bazel-remote Probing wNhoWHNPdDFgZ6KEuvNGhw => False 2024-11-21 10:00:59,465 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-115] Bazel-remote Probing 2133e9ce391435847e857f7a3a7241a3 => False 2024-11-21 10:00:59,466 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-095] Put ydb/yql_docs/tests/build/rtmr/preprocessed.tar.gz(wNhoWHNPdDFgZ6KEuvNGhw) to Bazel-remote 2024-11-21 10:00:59,467 DEBUG (root) [Worker-115] Run node EloEp_SjokQcseAEa6QBoA in build root /home/runner/.ya/build/build_root/c2tn/00000e 2024-11-21 10:00:59,468 DEBUG (urllib3.connectionpool) [Worker-096] http://cachesrv.internal:8081 "PUT /cas/9ce55ba7db3226a16ea8b084e645076b1b4ec684c6a716c6aeef2a9c80f3d7d2 HTTP/1.1" 200 0 2024-11-21 10:00:59,469 DEBUG (urllib3.connectionpool) [Worker-095] http://cachesrv.internal:8081 "PUT /cas/13e414c7020b73be8db35a3f47b3d5c4f24b08ffce54a207ba22bf6f3481e9e4 HTTP/1.1" 200 0 2024-11-21 10:00:59,471 DEBUG (urllib3.connectionpool) [Worker-096] http://cachesrv.internal:8081 "PUT /ac/456a7a35634c2d366f32422d662d59634462444b767700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:00:59,471 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-096] Put ydb/yql_docs/tests/build/yt/preprocessed.tar.gz(Ejz5cL-6o2B-f-YcDbDKvw) size=1092281 to Bazel-remote completed 2024-11-21 10:00:59,472 DEBUG (urllib3.connectionpool) [Worker-095] http://cachesrv.internal:8081 "PUT /cas/9d0910ef930c60cb0518fd7ba348bebf702c7b58fdca741c72c1061581745058 HTTP/1.1" 200 0 2024-11-21 10:00:59,488 DEBUG (urllib3.connectionpool) [Worker-095] http://cachesrv.internal:8081 "PUT /cas/7e4aa2ae4092ba62a2e987694ec721e8a7e2f6f1cea5df6682d83b435b841ed7 HTTP/1.1" 200 0 2024-11-21 10:00:59,491 DEBUG (urllib3.connectionpool) [Worker-095] http://cachesrv.internal:8081 "PUT /ac/774e686f57484e50644446675a364b4575764e47687700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:00:59,491 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-095] Put ydb/yql_docs/tests/build/rtmr/preprocessed.tar.gz(wNhoWHNPdDFgZ6KEuvNGhw) size=1092285 to Bazel-remote completed 2024-11-21 10:00:59,591 DEBUG (yalibrary.toolscache) [Worker-132] AC cache attempt: (put uid S1gvIxB2SJZjaqP8z8tQkw) 2024-11-21 10:00:59,591 DEBUG (urllib3.connectionpool) [Worker-097] http://cachesrv.internal:8081 "HEAD /ac/5331677649784232534a5a6a617150387a3874516b7700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:00:59,592 DEBUG (yalibrary.toolscache) [Worker-133] AC cache attempt: (get uid 4b55dce7d05b19615cd81cdc15f05a3f) 2024-11-21 10:00:59,592 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-097] Bazel-remote Probing S1gvIxB2SJZjaqP8z8tQkw => False 2024-11-21 10:00:59,593 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-097] Put ydb/yql_docs/tests/build/default/preprocessed.tar.gz(S1gvIxB2SJZjaqP8z8tQkw) to Bazel-remote 2024-11-21 10:00:59,594 DEBUG (yalibrary.toolscache) [Worker-132] AC cache attempt: (put uid de9a259ad6bd385447d86ff944da1634) 2024-11-21 10:00:59,595 DEBUG (urllib3.connectionpool) [Worker-133] http://cachesrv.internal:8081 "HEAD /ac/abd265ada938f39f858b6d9bc172600743dc08db7b23519bf38fb9a72f6ba311 HTTP/1.1" 404 0 2024-11-21 10:00:59,596 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-133] Bazel-remote Probing 4b55dce7d05b19615cd81cdc15f05a3f => False 2024-11-21 10:00:59,596 DEBUG (yalibrary.runner.tasks.result) [Worker-131] Result node S1gvIxB2SJZjaqP8z8tQkw processed successfully: True 2024-11-21 10:00:59,597 DEBUG (root) [Worker-133] Run node GOaW1-IgHtZrwMQQgf1wNg in build root /home/runner/.ya/build/build_root/c2tn/000010 2024-11-21 10:00:59,598 DEBUG (urllib3.connectionpool) [Worker-097] http://cachesrv.internal:8081 "PUT /cas/33d41e8943f250609289481b0960bc79fe83e331e29d033d89a143207425c5cb HTTP/1.1" 200 0 2024-11-21 10:00:59,602 DEBUG (urllib3.connectionpool) [Worker-097] http://cachesrv.internal:8081 "PUT /cas/d928caa357ce639190782a8e919dacd65b76dc97be017d437a933bf6b9fe7b57 HTTP/1.1" 200 0 2024-11-21 10:00:59,617 DEBUG (urllib3.connectionpool) [Worker-097] http://cachesrv.internal:8081 "PUT /cas/1728683f1da0d0f713c78664c030374b33ed3d6643483df673aa33828cb2c132 HTTP/1.1" 200 0 2024-11-21 10:00:59,620 DEBUG (urllib3.connectionpool) [Worker-097] http://cachesrv.internal:8081 "PUT /ac/5331677649784232534a5a6a617150387a3874516b7700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:00:59,621 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-097] Put ydb/yql_docs/tests/build/default/preprocessed.tar.gz(S1gvIxB2SJZjaqP8z8tQkw) size=1092256 to Bazel-remote completed 2024-11-21 10:01:04,602 DEBUG (yalibrary.toolscache) [Worker-001] AC cache attempt: (put uid B5W0bentwT6EW9RdRg4Aig) 2024-11-21 10:01:04,602 DEBUG (urllib3.connectionpool) [Worker-104] http://cachesrv.internal:8081 "HEAD /ac/4235573062656e74775436455739526452673441696700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:01:04,603 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-104] Bazel-remote Probing B5W0bentwT6EW9RdRg4Aig => False 2024-11-21 10:01:04,603 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-104] Put ydb/yql_docs/tests/build/yt/tests-build-yt.tar.gz(B5W0bentwT6EW9RdRg4Aig) to Bazel-remote 2024-11-21 10:01:04,604 DEBUG (yalibrary.toolscache) [Worker-001] AC cache attempt: (put uid e522b82a681ab72f0463d8cc2c127fa2) 2024-11-21 10:01:04,604 DEBUG (yalibrary.runner.tasks.result) [Worker-007] Result node B5W0bentwT6EW9RdRg4Aig processed successfully: True 2024-11-21 10:01:04,607 DEBUG (urllib3.connectionpool) [Worker-104] http://cachesrv.internal:8081 "PUT /cas/2934fb317a075c3efcf58b44f3fa50c6014974d0b475721167523e8e2864eab1 HTTP/1.1" 200 0 2024-11-21 10:01:04,611 DEBUG (urllib3.connectionpool) [Worker-104] http://cachesrv.internal:8081 "PUT /cas/b7118a8310fe80d4e544ba8b5a4a938b46cdd77ea9ee3bb41147c066f2e8daf2 HTTP/1.1" 200 0 2024-11-21 10:01:04,641 DEBUG (urllib3.connectionpool) [Worker-104] http://cachesrv.internal:8081 "PUT /cas/75db81b3f9c0d898bc801c15d2db79fb787229401bfa0a619f6d84cddf98ed66 HTTP/1.1" 200 0 2024-11-21 10:01:04,645 DEBUG (urllib3.connectionpool) [Worker-104] http://cachesrv.internal:8081 "PUT /ac/4235573062656e74775436455739526452673441696700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:01:04,645 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-104] Put ydb/yql_docs/tests/build/yt/tests-build-yt.tar.gz(B5W0bentwT6EW9RdRg4Aig) size=2779884 to Bazel-remote completed 2024-11-21 10:01:04,701 DEBUG (yalibrary.toolscache) [Worker-006] AC cache attempt: (put uid EloEp_SjokQcseAEa6QBoA) 2024-11-21 10:01:04,702 DEBUG (urllib3.connectionpool) [Worker-115] http://cachesrv.internal:8081 "HEAD /ac/456c6f45705f536a6f6b516373654145613651426f4100000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:01:04,702 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-115] Bazel-remote Probing EloEp_SjokQcseAEa6QBoA => False 2024-11-21 10:01:04,703 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-115] Put ydb/yql_docs/tests/build/rtmr/tests-build-rtmr.tar.gz(EloEp_SjokQcseAEa6QBoA) to Bazel-remote 2024-11-21 10:01:04,703 DEBUG (yalibrary.toolscache) [Worker-006] AC cache attempt: (put uid 2133e9ce391435847e857f7a3a7241a3) 2024-11-21 10:01:04,705 DEBUG (yalibrary.runner.tasks.result) [Worker-027] Result node EloEp_SjokQcseAEa6QBoA processed successfully: True 2024-11-21 10:01:04,708 DEBUG (urllib3.connectionpool) [Worker-115] http://cachesrv.internal:8081 "PUT /cas/e8302959c1ec0e295b781fb5fd38666dca89a36322f516e842a5badc3cb7a185 HTTP/1.1" 200 0 2024-11-21 10:01:04,712 DEBUG (urllib3.connectionpool) [Worker-115] http://cachesrv.internal:8081 "PUT /cas/f04f167a747194a7042a00bee4b6e25aee5485bb1cf3b6c176599205cfb7a2e2 HTTP/1.1" 200 0 2024-11-21 10:01:04,714 DEBUG (yalibrary.toolscache) [Worker-036] AC cache attempt: (put uid GOaW1-IgHtZrwMQQgf1wNg) 2024-11-21 10:01:04,714 DEBUG (urllib3.connectionpool) [Worker-133] http://cachesrv.internal:8081 "HEAD /ac/474f6157312d496748745a72774d5151676631774e6700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:01:04,715 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-133] Bazel-remote Probing GOaW1-IgHtZrwMQQgf1wNg => False 2024-11-21 10:01:04,716 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-133] Put ydb/yql_docs/tests/build/default/tests-build-default.tar.gz(GOaW1-IgHtZrwMQQgf1wNg) to Bazel-remote 2024-11-21 10:01:04,716 DEBUG (yalibrary.toolscache) [Worker-036] AC cache attempt: (put uid 4b55dce7d05b19615cd81cdc15f05a3f) 2024-11-21 10:01:04,717 DEBUG (yalibrary.runner.tasks.result) [Worker-021] Result node GOaW1-IgHtZrwMQQgf1wNg processed successfully: True 2024-11-21 10:01:04,720 DEBUG (urllib3.connectionpool) [Worker-133] http://cachesrv.internal:8081 "PUT /cas/2bbe5e4d7ffda850d95d5385d1b54ce5e9e0aa82a1644585d60abfd0d941ffb6 HTTP/1.1" 200 0 2024-11-21 10:01:04,725 DEBUG (urllib3.connectionpool) [Worker-133] http://cachesrv.internal:8081 "PUT /cas/bf7f472f39231c8f0030838445b45e53c1ad09d8e9c8dfd36223b5d86a3b30b6 HTTP/1.1" 200 0 2024-11-21 10:01:04,747 DEBUG (urllib3.connectionpool) [Worker-115] http://cachesrv.internal:8081 "PUT /cas/d7ffa974fe45a13a371c2955389914b32de6d5bcf6ed5a80489d784f55e17aad HTTP/1.1" 200 0 2024-11-21 10:01:04,763 DEBUG (urllib3.connectionpool) [Worker-133] http://cachesrv.internal:8081 "PUT /cas/31b5e338b78f28a716fe0a88f84dbb3c461787d74d83d9d8dfc1eb29f4d7bf40 HTTP/1.1" 200 0 2024-11-21 10:01:04,765 DEBUG (urllib3.connectionpool) [Worker-115] http://cachesrv.internal:8081 "PUT /ac/456c6f45705f536a6f6b516373654145613651426f4100000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:01:04,765 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-115] Put ydb/yql_docs/tests/build/rtmr/tests-build-rtmr.tar.gz(EloEp_SjokQcseAEa6QBoA) size=2779909 to Bazel-remote completed 2024-11-21 10:01:04,766 DEBUG (urllib3.connectionpool) [Worker-133] http://cachesrv.internal:8081 "PUT /ac/474f6157312d496748745a72774d5151676631774e6700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:01:04,766 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-133] Put ydb/yql_docs/tests/build/default/tests-build-default.tar.gz(GOaW1-IgHtZrwMQQgf1wNg) size=2779901 to Bazel-remote completed 2024-11-21 10:01:15,637 DEBUG (yalibrary.toolscache) [Worker-049] AC cache attempt: (put uid lYdT1PPC4eMUPl-tl2U3Iw) 2024-11-21 10:01:15,638 DEBUG (yalibrary.toolscache) [Worker-044] AC cache attempt: (get uid 2d98a19d7ad789c392e396ff4144422a) 2024-11-21 10:01:15,638 DEBUG (yalibrary.runner.tasks.result) [Worker-013] Result node lYdT1PPC4eMUPl-tl2U3Iw processed successfully: True 2024-11-21 10:01:15,639 DEBUG (urllib3.connectionpool) [Worker-046] http://cachesrv.internal:8081 "HEAD /ac/6c5964543150504334654d55506c2d746c325533497700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:01:15,639 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-046] Bazel-remote Probing lYdT1PPC4eMUPl-tl2U3Iw => False 2024-11-21 10:01:15,640 DEBUG (yalibrary.toolscache) [Worker-049] AC cache attempt: (put uid c7abe54794cc9b74f95dedd0b861ce7e) 2024-11-21 10:01:15,641 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-053] Put ydb/docs/preprocessed.tar.gz(lYdT1PPC4eMUPl-tl2U3Iw) to Bazel-remote 2024-11-21 10:01:15,641 DEBUG (urllib3.connectionpool) [Worker-044] http://cachesrv.internal:8081 "HEAD /ac/ac1f44b1ce85b07f535614e3c1e0fcf6fa61b140f89a2d24b965084984b8a611 HTTP/1.1" 404 0 2024-11-21 10:01:15,642 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-044] Bazel-remote Probing 2d98a19d7ad789c392e396ff4144422a => False 2024-11-21 10:01:15,643 DEBUG (root) [Worker-044] Run node hrsVWGct0Z3BCE4zivH7sg in build root /home/runner/.ya/build/build_root/c2tn/000008 2024-11-21 10:01:15,646 DEBUG (urllib3.connectionpool) [Worker-053] http://cachesrv.internal:8081 "PUT /cas/cafb60a1de130ab56c2502cfed9fe5c59051aa6f6076c5554f2e2caa418cb6aa HTTP/1.1" 200 0 2024-11-21 10:01:15,649 DEBUG (urllib3.connectionpool) [Worker-053] http://cachesrv.internal:8081 "PUT /cas/4f81129463eb547b3b84200868cffea1918fdb28150e1fe5106d57dbde00a39f HTTP/1.1" 200 0 2024-11-21 10:01:15,969 DEBUG (urllib3.connectionpool) [Worker-053] http://cachesrv.internal:8081 "PUT /cas/058490b44011bd03fa61702f635b3e09e72ca75ae1a333af05beb8ba0246c000 HTTP/1.1" 200 0 2024-11-21 10:01:15,973 DEBUG (urllib3.connectionpool) [Worker-053] http://cachesrv.internal:8081 "PUT /ac/6c5964543150504334654d55506c2d746c325533497700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:01:15,973 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-053] Put ydb/docs/preprocessed.tar.gz(lYdT1PPC4eMUPl-tl2U3Iw) size=36209700 to Bazel-remote completed 2024-11-21 10:02:01,146 DEBUG (yalibrary.toolscache) [Worker-059] AC cache attempt: (put uid hrsVWGct0Z3BCE4zivH7sg) 2024-11-21 10:02:01,147 DEBUG (urllib3.connectionpool) [Worker-061] http://cachesrv.internal:8081 "HEAD /ac/6872735657476374305a33424345347a69764837736700000000000000000001 HTTP/1.1" 404 0 2024-11-21 10:02:01,148 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-061] Bazel-remote Probing hrsVWGct0Z3BCE4zivH7sg => False 2024-11-21 10:02:01,148 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-061] Put ydb/docs/ydb-docs.tar.gz(hrsVWGct0Z3BCE4zivH7sg) to Bazel-remote 2024-11-21 10:02:01,149 DEBUG (yalibrary.runner.tasks.result) [Worker-044] Result node hrsVWGct0Z3BCE4zivH7sg processed successfully: True 2024-11-21 10:02:01,150 DEBUG (yalibrary.toolscache) [Worker-059] AC cache attempt: (put uid 2d98a19d7ad789c392e396ff4144422a) 2024-11-21 10:02:01,152 DEBUG (urllib3.connectionpool) [Worker-061] http://cachesrv.internal:8081 "PUT /cas/28166d3d57ad3fc424b9858e3e6098905369aea64391c66d4e6ab582af2dfc6b HTTP/1.1" 200 0 2024-11-21 10:02:01,156 DEBUG (urllib3.connectionpool) [Worker-061] http://cachesrv.internal:8081 "PUT /cas/8354682091eb5c969b678e38ec7c7a0f796406e62116150a9d536bee69774b3e HTTP/1.1" 200 0 2024-11-21 10:02:01,504 DEBUG (urllib3.connectionpool) [Worker-061] http://cachesrv.internal:8081 "PUT /cas/ec842c92d7bb39ecfed7f72338f18537f1a07bf9178169cb35654642df446863 HTTP/1.1" 200 0 2024-11-21 10:02:01,508 DEBUG (urllib3.connectionpool) [Worker-061] http://cachesrv.internal:8081 "PUT /ac/6872735657476374305a33424345347a69764837736700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:02:01,508 DEBUG (yalibrary.store.bazel_store.bazel_store) [Worker-061] Put ydb/docs/ydb-docs.tar.gz(hrsVWGct0Z3BCE4zivH7sg) size=39674631 to Bazel-remote completed 2024-11-21 10:02:01,572 DEBUG (yalibrary.runner.build_root) [Worker-068] Build root /home/runner/.ya/build/build_root/c2tn created=25 left=12 2024-11-21 10:02:01,572 DEBUG (library.python.filelock) [MainThread] Ensuring FileLock released: /home/runner/.ya/build/build_root/c2tn/STAMP 2024-11-21 10:02:01,583 DEBUG (yalibrary.runner.runner3) [MainThread] Task Run(Ejz5cL-6o2B-f-YcDbDKvw$(BUILD_ROOT)/ydb/yql_docs/tests/build/yt/preprocessed.tar.gz) has stderr: Using v4.45.1 version COPY Copying file index.md COPY Copying file toc.yaml COPY Copying file ya.make COPY Copying file ydb/docs/ru/core/_assets/embedded_query. ... md WARN Variable backend_name not found in /builtins/_includes/aggregation/max_min_by.md WARN Variable ydb-short-name not found in /udf/list/_includes/topg.md 2024-11-21 10:02:01,583 DEBUG (yalibrary.runner.runner3) [MainThread] Task Run(wNhoWHNPdDFgZ6KEuvNGhw$(BUILD_ROOT)/ydb/yql_docs/tests/build/rtmr/preprocessed.tar.gz) has stderr: Using v4.45.1 version COPY Copying file toc.yaml COPY Copying file ya.make COPY Copying file ydb/docs/ru/core/_assets/embedded_query.png COPY Copying file ydb/d ... md WARN Variable backend_name not found in /builtins/_includes/aggregation/max_min_by.md WARN Variable ydb-short-name not found in /udf/list/_includes/topg.md 2024-11-21 10:02:01,583 DEBUG (yalibrary.runner.runner3) [MainThread] Task Run(S1gvIxB2SJZjaqP8z8tQkw$(BUILD_ROOT)/ydb/yql_docs/tests/build/default/preprocessed.tar.gz) has stderr: Using v4.45.1 version COPY Copying file index.md COPY Copying file toc.yaml COPY Copying file ya.make COPY Copying file ydb/docs/ru/core/_assets/embedded_query. ... md WARN Variable backend_name not found in /builtins/_includes/aggregation/max_min_by.md WARN Variable ydb-short-name not found in /udf/list/_includes/topg.md 2024-11-21 10:02:01,583 DEBUG (yalibrary.runner.runner3) [MainThread] Task Run(B5W0bentwT6EW9RdRg4Aig$(BUILD_ROOT)/ydb/yql_docs/tests/build/yt/tests-build-yt.tar.gz) has stderr: Using v4.45.1 version COPY Copying file _assets/KaTeX_AMS-Regular-CYEKBG2K.woff COPY Copying file _assets/KaTeX_AMS-Regular-JKX5W2C4.ttf COPY Copying file _asse ... : 100; Actual: 125] [Context: "Unicode::SplitToList( string:Utf8?, separator:Utf8, [ DelimeterString:Bool?, SkipEmpty:Bool?, Limit:Uint64? ]) -> List"] 2024-11-21 10:02:01,583 DEBUG (yalibrary.runner.runner3) [MainThread] Task Run(EloEp_SjokQcseAEa6QBoA$(BUILD_ROOT)/ydb/yql_docs/tests/build/rtmr/tests-build-rtmr.tar.gz) has stderr: Using v4.45.1 version COPY Copying file _assets/KaTeX_AMS-Regular-CYEKBG2K.woff COPY Copying file _assets/KaTeX_AMS-Regular-JKX5W2C4.ttf COPY Copying file _asse ... : 100; Actual: 125] [Context: "Unicode::SplitToList( string:Utf8?, separator:Utf8, [ DelimeterString:Bool?, SkipEmpty:Bool?, Limit:Uint64? ]) -> List"] 2024-11-21 10:02:01,583 DEBUG (yalibrary.runner.runner3) [MainThread] Task Run(GOaW1-IgHtZrwMQQgf1wNg$(BUILD_ROOT)/ydb/yql_docs/tests/build/default/tests-build-default.tar.gz) has stderr: Using v4.45.1 version COPY Copying file _assets/KaTeX_AMS-Regular-CYEKBG2K.woff COPY Copying file _assets/KaTeX_AMS-Regular-JKX5W2C4.ttf COPY Copying file _asse ... : 100; Actual: 125] [Context: "Unicode::SplitToList( string:Utf8?, separator:Utf8, [ DelimeterString:Bool?, SkipEmpty:Bool?, Limit:Uint64? ]) -> List"] 2024-11-21 10:02:01,583 DEBUG (yalibrary.runner.runner3) [MainThread] Task Run(lYdT1PPC4eMUPl-tl2U3Iw$(BUILD_ROOT)/ydb/docs/preprocessed.tar.gz) has stderr: Using v4.45.1 version COPY Copying file _assets/gtm.js COPY Copying file _assets/logo.svg COPY Copying file _assets/tags.css COPY Copying file _assets/ydb-promo ... d: ru/changelog-server.md INFO Processing finished: ru/changelog-cli.md INFO Processing finished: ru/security-changelog.md COPY Copying file _assets/tags.css 2024-11-21 10:02:01,583 DEBUG (yalibrary.runner.runner3) [MainThread] Task Run(hrsVWGct0Z3BCE4zivH7sg$(BUILD_ROOT)/ydb/docs/ydb-docs.tar.gz) has stderr: Using v4.45.1 version COPY Copying file _assets/KaTeX_AMS-Regular-CYEKBG2K.woff COPY Copying file _assets/KaTeX_AMS-Regular-JKX5W2C4.ttf COPY Copying file _asse ... opying file search/langs/tr.js COPY Copying file search/langs/vi.js COPY Copying file vendor.css COPY Copying file vendor.js COPY Copying file vendor.rtl.css 2024-11-21 10:02:01,583 DEBUG (yalibrary.runner.runner3) [MainThread] Merged exit code: 0 2024-11-21 10:02:01,583 DEBUG (yalibrary.runner.runner3) [MainThread] Profile of graph execution {"by_type":{"clean_symres":{"sum":0.004457712173462,"qty":1},"prepare_all_nodes":{"sum":0.049491882324219,"qty":1},"compact_cache":{"sum":0.003993034362793,"qty":1},"restore_from_dist_cache[DO]":{"sum":0.218702077865601,"qty":13},"prepare[DO]":{"sum":0.003933429718018,"qty":3},"put_in_cache[DO]":{"sum":0.04451584815979,"qty":13},"pattern[YMAKE_PYTHON3-4256832079]":{"sum":0.506506204605103,"qty":1},"DO":{"sum":92.629372596740723,"qty":10},"write_through_caches[DO]":{"sum":0.035169363021851,"qty":10},"result[DO]":{"sum":0.037472248077393,"qty":10},"put_in_dist_cache[DO]":{"sum":2.083560943603516,"qty":10},"pattern[YFM_TOOL-2222417654]":{"sum":9.732670068740845,"qty":1},"clean_build_root":{"sum":0.000319242477417,"qty":1}},"all":{"qty":75,"sum":105.350164651870728},"critical_path":[{"name":"Pattern(YFM_TOOL-2222417654)","timing":[1732183246.131017446517944,1732183255.863687515258789],"type":"pattern[YFM_TOOL-2222417654]"}],"wall_time":75.464421987533569,"build_type":"relwithdebinfo","flags":{"OPENSOURCE":"yes","USE_PREBUILT_TOOLS":"no","APPLE_SDK_LOCAL":"yes","USE_CLANG_CL":"yes","USE_AIO":"static","USE_ICONV":"static","USE_IDN":"static","CFLAGS":"-fno-omit-frame-pointer","USE_EAT_MY_DATA":"yes","DEBUGINFO_LINES_ONLY":"yes","CONSISTENT_DEBUG":"yes","TESTS_REQUESTED":"yes","DISABLE_FLAKE8_MIGRATIONS":"yes"},"rel_targets":["."],"threads":64} 2024-11-21 10:02:01,584 DEBUG (yalibrary.runner.runner3) [MainThread] Average compression ratio: 1.00 2024-11-21 10:02:01,584 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=dispatch_build, group=ya_make, time=1732183321.5842037 2024-11-21 10:02:01,584 DEBUG (core.stages_profiler) [MainThread] Set stage dispatch_build_finished=1732183321.5842037 2024-11-21 10:02:01,584 DEBUG (core.profiler) [MainThread] Profile step dispatch_build_finished - 1732183321.5842037 2024-11-21 10:02:01,584 DEBUG (core.stage_tracer) [MainThread] Start stage tag=cache_test_statuses, group=ya_make, time=1732183321.5845468 2024-11-21 10:02:01,584 DEBUG (core.stages_profiler) [MainThread] Set stage cache_test_statuses_started=1732183321.5845468 2024-11-21 10:02:01,584 DEBUG (core.profiler) [MainThread] Profile step cache_test_statuses_started - 1732183321.5845468 2024-11-21 10:02:01,599 DEBUG (yalibrary.store.new_store) [MainThread] Initialized store in /home/runner/.ya/build/cache/trc 2024-11-21 10:02:01,599 DEBUG (yalibrary.store.new_store) [MainThread] Started filtering 2024-11-21 10:02:01,599 DEBUG (library.python.filelock) [MainThread] Acquiring FileLock (blocking=True): /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-21 10:02:01,599 DEBUG (library.python.filelock) [MainThread] Ensuring FileLock released: /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-21 10:02:01,599 DEBUG (yalibrary.store.new_store) [MainThread] Done filtering, retain 0 uids, 0 files 2024-11-21 10:02:01,599 DEBUG (yalibrary.store.new_store) [MainThread] Cleaning size store 2024-11-21 10:02:01,599 DEBUG (yalibrary.store.new_store) [MainThread] Cleaning file store 2024-11-21 10:02:01,601 DEBUG (yalibrary.store.new_store) [MainThread] Cleaning uid store 2024-11-21 10:02:01,618 DEBUG (library.python.filelock) [MainThread] Acquiring FileLock (blocking=True): /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-21 10:02:01,619 DEBUG (library.python.filelock) [MainThread] Ensuring FileLock released: /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-21 10:02:01,623 DEBUG (library.python.filelock) [MainThread] Acquiring FileLock (blocking=True): /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-21 10:02:01,623 DEBUG (library.python.filelock) [MainThread] Ensuring FileLock released: /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-21 10:02:01,623 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=cache_test_statuses, group=ya_make, time=1732183321.6232255 2024-11-21 10:02:01,623 DEBUG (core.stages_profiler) [MainThread] Set stage cache_test_statuses_finished=1732183321.6232255 2024-11-21 10:02:01,623 DEBUG (core.profiler) [MainThread] Profile step cache_test_statuses_finished - 1732183321.6232255 2024-11-21 10:02:01,623 DEBUG (yalibrary.toolscache) [MainThread] Tools cache attempt: (request for tc stats) 2024-11-21 10:02:01,624 DEBUG (yalibrary.toolscache) [MainThread] tc stats: TotalKnownSize: 39866368 NonComputedCount: 2 2024-11-21 10:02:01,624 DEBUG (yalibrary.toolscache) [MainThread] AC cache attempt: (request for ac stats) 2024-11-21 10:02:01,625 DEBUG (yalibrary.toolscache) [MainThread] ac stats: TotalFSSize: 168857600 TotalSize: 168755793 2024-11-21 10:02:01,625 DEBUG (core.stage_tracer) [MainThread] Start stage tag=statistics, group=statistics, time=1732183321.6251316 2024-11-21 10:02:01,625 DEBUG (core.stages_profiler) [MainThread] Set stage statistics_started=1732183321.6251316 2024-11-21 10:02:01,625 DEBUG (core.profiler) [MainThread] Profile step statistics_started - 1732183321.6251316 2024-11-21 10:02:01,625 DEBUG (build.stat.graph) [MainThread] Node count in the dependency graph is 63. 2024-11-21 10:02:01,625 DEBUG (build.stat.graph) [MainThread] Dependency count in the graph is 11. 2024-11-21 10:02:01,626 DEBUG (build.stat.statistics) [MainThread] Run tasks 13: 13 cached tasks (0 cache(s) resolved by dynamic uids), 10 not cached, 0 failed 2024-11-21 10:02:01,626 DEBUG (build.stat.statistics) [MainThread] Not cached 10: 0 tests, 10 not tests 2024-11-21 10:02:01,626 DEBUG (core.profiler) [MainThread] Profile value statistics_cache_hit - 56.52173913043478 2024-11-21 10:02:01,626 DEBUG (core.profiler) [MainThread] Profile value statistics_run_tasks - 13 2024-11-21 10:02:01,626 DEBUG (core.profiler) [MainThread] Profile value statistics_executed_tasks - 23 2024-11-21 10:02:01,626 DEBUG (core.profiler) [MainThread] Profile value statistics_cached_tasks - 13 2024-11-21 10:02:01,626 DEBUG (core.profiler) [MainThread] Profile value statistics_dyn_cached_tasks - 0 2024-11-21 10:02:01,626 DEBUG (core.profiler) [MainThread] Profile value statistics_not_cached_tasks - 10 2024-11-21 10:02:01,626 DEBUG (core.profiler) [MainThread] Profile value statistics_tests_tasks - 0 2024-11-21 10:02:01,626 DEBUG (core.profiler) [MainThread] Profile value statistics_failed_tasks - 0 2024-11-21 10:02:01,626 DEBUG (core.profiler) [MainThread] Profile value statistics_ok_tasks - 10 2024-11-21 10:02:01,626 DEBUG (core.profiler) [MainThread] Profile value statistics_avoided_tasks - -10 2024-11-21 10:02:01,626 DEBUG (core.profiler) [MainThread] Profile value critical_path - [["DO | $(BUILD_ROOT)/ydb/docs/__docs_internal.docslib.fake",563,"local"],["DO | $(BUILD_ROOT)/ydb/docs/preprocessed.tar.gz",19679,"local"],["DO | $(BUILD_ROOT)/ydb/docs/ydb-docs.tar.gz",45482,"local"]] 2024-11-21 10:02:01,627 DEBUG (core.profiler) [MainThread] Profile value statistics_total_time - 74480 2024-11-21 10:02:01,627 DEBUG (core.profiler) [MainThread] Profile value statistics_graph_time - 65724 2024-11-21 10:02:01,627 DEBUG (core.profiler) [MainThread] Profile value statistics_graph_copying_time - 0 2024-11-21 10:02:01,627 DEBUG (core.profiler) [MainThread] Profile value statistics_graph_testing_time - 0 2024-11-21 10:02:01,627 DEBUG (core.profiler) [MainThread] Profile value statistics_graph_compiling_time - 65724 2024-11-21 10:02:01,627 DEBUG (core.profiler) [MainThread] Profile value statistics_graph_source_time - 0 2024-11-21 10:02:01,627 DEBUG (core.profiler) [MainThread] Profile value statistics_graph_tests_data_time - 0 2024-11-21 10:02:01,627 DEBUG (core.profiler) [MainThread] Profile value statistics_longest_task - 45482 2024-11-21 10:02:01,628 DEBUG (core.profiler) [MainThread] Profile value statistics_failed_task_time_ratio - 0.0 2024-11-21 10:02:01,628 DEBUG (core.profiler) [MainThread] Profile value statistics_failed_task_time - 0 2024-11-21 10:02:01,628 DEBUG (core.profiler) [MainThread] Profile value statistics_tests_task_time_ratio - 0.0 2024-11-21 10:02:01,628 DEBUG (core.profiler) [MainThread] Profile value statistics_tests_task_time - 0 2024-11-21 10:02:01,628 DEBUG (core.profiler) [MainThread] Profile value statistics_run_task_time - 92362 2024-11-21 10:02:01,629 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=statistics, group=statistics, time=1732183321.628991 2024-11-21 10:02:01,629 DEBUG (core.stages_profiler) [MainThread] Set stage statistics_finished=1732183321.628991 2024-11-21 10:02:01,629 DEBUG (core.profiler) [MainThread] Profile step statistics_finished - 1732183321.628991 2024-11-21 10:02:01,629 DEBUG (core.stage_tracer) [MainThread] Start stage tag=finalize-reports, group=ya_make, time=1732183321.629557 2024-11-21 10:02:01,629 DEBUG (core.stages_profiler) [MainThread] Set stage finalize-reports_started=1732183321.629557 2024-11-21 10:02:01,629 DEBUG (core.profiler) [MainThread] Profile step finalize-reports_started - 1732183321.629557 2024-11-21 10:02:01,629 DEBUG (build.ya_make) [MainThread] Build is finished, process results 2024-11-21 10:02:01,629 DEBUG (ReportGenerator) [MainThread] Build result is processed, add 3 entries 2024-11-21 10:02:01,629 DEBUG (ReportGenerator) [MainThread] Finish build report 2024-11-21 10:02:01,630 DEBUG (StoredReport) [MainThread] Finish build report 2024-11-21 10:02:01,630 DEBUG (ReportGenerator) [MainThread] Finish tests report, tests by size defaultdict(, {'small': set(), 'medium': set(), 'large': set()}), tests by type defaultdict(, {}) 2024-11-21 10:02:01,630 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2024-11-21 10:02:01,630 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2024-11-21 10:02:01,630 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2024-11-21 10:02:01,630 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2024-11-21 10:02:01,630 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2024-11-21 10:02:01,630 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2024-11-21 10:02:01,630 DEBUG (StoredReport) [MainThread] Finish tests report 2024-11-21 10:02:01,630 DEBUG (ReportGenerator) [MainThread] Finish style report 2024-11-21 10:02:01,630 DEBUG (StoredReport) [MainThread] Finish style report 2024-11-21 10:02:01,630 DEBUG (ReportGenerator) [MainThread] Finish report 2024-11-21 10:02:01,630 DEBUG (StoredReport) [MainThread] Finish report 2024-11-21 10:02:01,630 DEBUG (build.ya_make) [MainThread] Build results listener statistics: {'TestNodeListener': {'duration_sec': 8.440017700195312e-05}, 'BuildResultsListener': {'duration_sec': 0.0012524127960205078}} 2024-11-21 10:02:01,630 DEBUG (build.ya_make) [MainThread] Generating results report 2024-11-21 10:02:01,630 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-21 10:02:01,630 DEBUG (build.reports.autocheck_report) [MainThread] Got 0 tests to report 2024-11-21 10:02:01,630 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2024-11-21 10:02:01,631 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2024-11-21 10:02:01,631 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2024-11-21 10:02:01,631 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2024-11-21 10:02:01,631 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2024-11-21 10:02:01,631 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2024-11-21 10:02:01,631 DEBUG (ReportGenerator) [MainThread] Build result is processed, add 13 entries 2024-11-21 10:02:01,631 DEBUG (build.reports.autocheck_report) [MainThread] builder.opts.report_skipped_suites: False, builder.opts.report_skipped_suites False 2024-11-21 10:02:01,631 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-21 10:02:01,632 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=finalize-reports, group=ya_make, time=1732183321.631999 2024-11-21 10:02:01,632 DEBUG (core.stages_profiler) [MainThread] Set stage finalize-reports_finished=1732183321.631999 2024-11-21 10:02:01,632 DEBUG (core.profiler) [MainThread] Profile step finalize-reports_finished - 1732183321.631999 2024-11-21 10:02:01,632 DEBUG (yalibrary.toolscache) [MainThread] AC cache attempt: (release all data) 2024-11-21 10:02:01,633 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=build, group=build_handler, time=1732183321.633012 2024-11-21 10:02:01,633 DEBUG (core.stages_profiler) [MainThread] Set stage build_finished=1732183321.633012 2024-11-21 10:02:01,633 DEBUG (core.profiler) [MainThread] Profile step build_finished - 1732183321.633012 2024-11-21 10:02:01,633 DEBUG (core.stage_tracer) [MainThread] Start stage tag=dump_results, group=build_handler, time=1732183321.633187 2024-11-21 10:02:01,633 DEBUG (core.stages_profiler) [MainThread] Set stage dump_results_started=1732183321.633187 2024-11-21 10:02:01,633 DEBUG (core.profiler) [MainThread] Profile step dump_results_started - 1732183321.633187 2024-11-21 10:02:01,633 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=dump_results, group=build_handler, time=1732183321.6337318 2024-11-21 10:02:01,633 DEBUG (core.stages_profiler) [MainThread] Set stage dump_results_finished=1732183321.6337318 2024-11-21 10:02:01,633 DEBUG (core.profiler) [MainThread] Profile step dump_results_finished - 1732183321.6337318 2024-11-21 10:02:01,633 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=ya_make_handler, group=build_handler, time=1732183321.6339006 2024-11-21 10:02:01,633 DEBUG (core.stages_profiler) [MainThread] Set stage ya_make_handler_finished=1732183321.6339006 2024-11-21 10:02:01,633 DEBUG (core.profiler) [MainThread] Profile step ya_make_handler_finished - 1732183321.6339006 2024-11-21 10:02:01,634 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=invoke-do_ya_make, group=overall-execution, time=1732183321.6340613 2024-11-21 10:02:01,634 DEBUG (core.stages_profiler) [MainThread] Set stage invoke-do_ya_make_finished=1732183321.6340613 2024-11-21 10:02:01,634 DEBUG (core.profiler) [MainThread] Profile step invoke-do_ya_make_finished - 1732183321.6340613 2024-11-21 10:02:01,634 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "dump_debug" stopped in 0.000080 2024-11-21 10:02:01,634 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "evlog" stopped in 0.000027 2024-11-21 10:02:01,634 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "changelist_store" stopped in 0.000001 2024-11-21 10:02:01,634 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "event_queue" stopped in 0.000003 2024-11-21 10:02:01,634 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "mlockall" stopped in 0.000004 2024-11-21 10:02:01,634 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "profile" stopped in 0.000001 2024-11-21 10:02:01,634 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "showstack" stopped in 0.000016 2024-11-21 10:02:01,634 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher" stopped in 0.000002 2024-11-21 10:02:01,634 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" stopped in 0.000001 2024-11-21 10:02:01,634 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token2" stopped in 0.000003 2024-11-21 10:02:01,634 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "docker_config_path" stopped in 0.000001 2024-11-21 10:02:01,634 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "use_universal_fetcher_everywhere" stopped in 0.000001 2024-11-21 10:02:01,634 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher_params" stopped in 0.000007 2024-11-21 10:02:01,634 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "self_info" stopped in 0.000001 2024-11-21 10:02:01,635 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" stopped in 0.000003 2024-11-21 10:02:01,635 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display_log" stopped in 0.000004 2024-11-21 10:02:01,635 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "custom_file_log" stopped in 0.000008 2024-11-21 10:02:01,635 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display" stopped in 0.000014 2024-11-21 10:02:01,635 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "state" stopped in 0.000007 2024-11-21 10:02:01,635 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token" stopped in 0.000002 2024-11-21 10:02:01,635 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "params" stopped in 0.000001 2024-11-21 10:02:01,635 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-21 10:02:01,635 DEBUG (library.python.tmp) [MainThread] Removing tmp dir /home/runner/.ya/tmp/1732183244.20575.esmjm5jo 2024-11-21 10:02:01,635 DEBUG (library.python.tmp) [MainThread] Reset back TMPDIR=None 2024-11-21 10:02:01,636 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "tmp_dir" stopped in 0.000570 2024-11-21 10:02:01,636 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" stopped in 0.000009 2024-11-21 10:02:01,636 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "env_checker" stopped in 0.000005 2024-11-21 10:02:01,636 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "lifecycle_ts" stopped in 0.000006 2024-11-21 10:02:01,636 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "exit" stopped in 0.000007 2024-11-21 10:02:01,637 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "report" stopped in 0.000861 2024-11-21 10:02:01,637 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" stopped in 0.000006 2024-11-21 10:02:01,637 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "revision" stopped in 0.000004 2024-11-21 10:02:01,637 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "file_in_memory_log" stopped in 0.000006 2024-11-21 10:02:01,637 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display_in_memory_log" stopped in 0.000004 2024-11-21 10:02:01,637 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "file_log" stopped in 0.000007 2024-11-21 10:02:01,637 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "uid" stopped in 0.000004 2024-11-21 10:02:01,637 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Restored ctx dict_keys([])