2024-11-20 16:38:49,419 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "file_in_memory_log" initialized in 0.000015 2024-11-20 16:38:49,420 DEBUG (root) [MainThread] Release revision: 15278243 2024-11-20 16:38:49,420 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "revision" initialized in 0.000751 2024-11-20 16:38:49,420 DEBUG (yalibrary.vcs) [MainThread] detecting vcs from /home/runner/actions_runner/_work/ydb/ydb for paths: None 2024-11-20 16:38:49,420 DEBUG (yalibrary.vcs) [MainThread] common root: /home/runner/actions_runner/_work/ydb/ydb 2024-11-20 16:38:49,420 DEBUG (yalibrary.vcs) [MainThread] vcs root: /home/runner/actions_runner/_work/ydb/ydb (git) 2024-11-20 16:38:49,420 DEBUG (root) [MainThread] vcs type: git 2024-11-20 16:38:49,420 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" initialized in 0.000196 2024-11-20 16:38:49,420 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-20 16:38:49,421 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "report" initialized in 0.000409 2024-11-20 16:38:49,421 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "exit" initialized in 0.000002 2024-11-20 16:38:49,421 DEBUG (root) [MainThread] Start up timestamp 2024-11-20T16:38:49.UTC (2024-11-20T16:38:49.UTC) 2024-11-20 16:38:49,421 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "lifecycle_ts" initialized in 0.000036 2024-11-20 16:38:49,421 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "env_checker" initialized in 0.000005 2024-11-20 16:38:49,421 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" initialized in 0.000386 2024-11-20 16:38:49,421 DEBUG (library.python.tmp) [MainThread] Set TMPDIR=/home/runner/.ya/tmp/1732120729.2956.vtimd2l6 instead of None 2024-11-20 16:38:49,421 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "tmp_dir" initialized in 0.000132 2024-11-20 16:38:49,421 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=modules-initialization-early, group=overall-execution, time=1732120729.42189 2024-11-20 16:38:49,421 DEBUG (core.stages_profiler) [MainThread] Set stage modules-initialization-early_finished=1732120729.42189 2024-11-20 16:38:49,421 DEBUG (core.profiler) [MainThread] Profile step modules-initialization-early_finished - 1732120729.42189 2024-11-20 16:38:49,422 DEBUG (core.stage_tracer) [MainThread] Start stage tag=handler-selection, group=overall-execution, time=1732120729.4223459 2024-11-20 16:38:49,422 DEBUG (core.stages_profiler) [MainThread] Set stage handler-selection_started=1732120729.4223459 2024-11-20 16:38:49,422 DEBUG (core.profiler) [MainThread] Profile step handler-selection_started - 1732120729.4223459 2024-11-20 16:38:49,422 DEBUG (core.plugin_loader) [MainThread] Load handlers.make 2024-11-20 16:38:49,434 DEBUG (core.yarg.config_files) [MainThread] Load data from config /home/runner/actions_runner/_work/ydb/ydb/ya.conf 2024-11-20 16:38:49,434 DEBUG (core.yarg.config_files) [MainThread] Found 21 keys 2024-11-20 16:38:49,435 DEBUG (core.yarg.populate) [MainThread] Use config file `/home/runner/actions_runner/_work/ydb/ydb/ya.conf` with `21` keys 2024-11-20 16:38:49,435 DEBUG (core.yarg.populate) [MainThread] No aliases to inject 2024-11-20 16:38:49,435 DEBUG (core.yarg.config_files) [MainThread] Unknown config parameter `incremental_build_dirs_cleanup` 2024-11-20 16:38:49,435 DEBUG (core.yarg.config_files) [MainThread] Unknown config parameter `use_atd_revisions_info` 2024-11-20 16:38:49,436 DEBUG (core.yarg.config_files) [MainThread] Load data from config /home/runner/actions_runner/_work/ydb/ydb/build/internal/ya.conf 2024-11-20 16:38:49,436 DEBUG (core.yarg.config_files) [MainThread] Found 9 keys 2024-11-20 16:38:49,436 DEBUG (core.yarg.populate) [MainThread] Use config file `/home/runner/actions_runner/_work/ydb/ydb/build/internal/ya.conf` with `9` keys 2024-11-20 16:38:49,436 DEBUG (core.yarg.populate) [MainThread] No aliases to inject 2024-11-20 16:38:49,436 DEBUG (core.yarg.config_files) [MainThread] Unknown config parameter `bazel_remote_client_decompress` 2024-11-20 16:38:49,447 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-20 16:38:49,447 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-20 16:38:49,448 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=handler-selection, group=overall-execution, time=1732120729.4483962 2024-11-20 16:38:49,448 DEBUG (core.stages_profiler) [MainThread] Set stage handler-selection_finished=1732120729.4483962 2024-11-20 16:38:49,448 DEBUG (core.profiler) [MainThread] Profile step handler-selection_finished - 1732120729.4483962 2024-11-20 16:38:49,448 DEBUG (core.stage_tracer) [MainThread] Start stage tag=modules-initialization-full, group=overall-execution, time=1732120729.4485211 2024-11-20 16:38:49,448 DEBUG (core.stages_profiler) [MainThread] Set stage modules-initialization-full_started=1732120729.4485211 2024-11-20 16:38:49,448 DEBUG (core.profiler) [MainThread] Profile step modules-initialization-full_started - 1732120729.4485211 2024-11-20 16:38:49,448 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-20 16:38:49,448 DEBUG (core.respawn) [MainThread] Same as prev source root /home/runner/actions_runner/_work/ydb/ydb 2024-11-20 16:38:49,449 DEBUG (core.respawn.pyver) [MainThread] No need to respawn to other ya-bin version 2024-11-20 16:38:49,449 DEBUG (core.respawn) [MainThread] Unsetting YA_STDIN env var as respawn never happened 2024-11-20 16:38:49,449 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "params" initialized in 0.000265 2024-11-20 16:38:49,450 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-20 16:38:49,451 DEBUG (root) [MainThread] Update replacements in 2024-11-20 16:38:49,451 DEBUG (root) [MainThread] Add suppressing formatter to 2024-11-20 16:38:49,451 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-20 16:38:49,451 DEBUG (root) [MainThread] Add suppressing formatter to 2024-11-20 16:38:49,451 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-20 16:38:49,451 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token" initialized in 0.002290 2024-11-20 16:38:49,451 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "state" initialized in 0.000212 2024-11-20 16:38:49,451 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display" initialized in 0.000041 2024-11-20 16:38:49,452 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-20 16:38:49,452 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "custom_file_log" initialized in 0.000890 2024-11-20 16:38:49,452 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display_log" initialized in 0.000032 2024-11-20 16:38:49,452 DEBUG (yalibrary.vcs) [MainThread] detecting vcs from /home/runner/actions_runner/_work/ydb/ydb for paths: None 2024-11-20 16:38:49,453 DEBUG (yalibrary.vcs) [MainThread] common root: /home/runner/actions_runner/_work/ydb/ydb 2024-11-20 16:38:49,453 DEBUG (yalibrary.vcs) [MainThread] vcs root: /home/runner/actions_runner/_work/ydb/ydb (git) 2024-11-20 16:38:49,453 DEBUG (root) [MainThread] vcs type: git 2024-11-20 16:38:49,453 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" initialized in 0.000218 2024-11-20 16:38:49,453 DEBUG (devtools.ya.app) [MainThread] origin: github 2024-11-20 16:38:49,453 DEBUG (devtools.ya.app) [MainThread] python: sys.version_info(major=3, minor=12, micro=7, releaselevel='final', serial=0) 2024-11-20 16:38:49,453 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "self_info" initialized in 0.000101 2024-11-20 16:38:49,453 DEBUG (root) [MainThread] Custom fetcher: None, fetcher parameters: [{'name': 'custom'}, {'name': 'proxy'}, {'name': 'skynet'}, {'name': 'mds'}, {'name': 'sandbox'}], sb_token none 2024-11-20 16:38:49,453 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher_params" initialized in 0.000077 2024-11-20 16:38:49,453 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "use_universal_fetcher_everywhere" initialized in 0.000002 2024-11-20 16:38:49,453 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "docker_config_path" initialized in 0.000001 2024-11-20 16:38:49,454 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-20 16:38:49,454 DEBUG (root) [MainThread] Update replacements in 2024-11-20 16:38:49,454 DEBUG (root) [MainThread] Update replacements in 2024-11-20 16:38:49,454 DEBUG (root) [MainThread] Update replacements in DisplayStreamHandler 2024-11-20 16:38:49,454 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token2" initialized in 0.001112 2024-11-20 16:38:49,454 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" initialized in 0.000061 2024-11-20 16:38:49,454 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher" initialized in 0.000002 2024-11-20 16:38:49,455 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "showstack" initialized in 0.000148 2024-11-20 16:38:49,455 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "profile" initialized in 0.000002 2024-11-20 16:38:49,455 DEBUG (devtools.ya.app) [MainThread] mlockall return code: 12 2024-11-20 16:38:49,455 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "mlockall" initialized in 0.000037 2024-11-20 16:38:49,455 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "event_queue" initialized in 0.000004 2024-11-20 16:38:49,455 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "changelist_store" initialized in 0.000239 2024-11-20 16:38:49,455 DEBUG (root) [MainThread] Event log file is /home/runner/actions_runner/_work/ydb/ydb/tmp/results/try_1/ya_evlog.jsonl 2024-11-20 16:38:49,455 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "evlog" initialized in 0.000384 2024-11-20 16:38:49,494 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "dump_debug" initialized in 0.038000 2024-11-20 16:38:49,494 DEBUG (devtools.ya.app) [MainThread] Run action on with params 2024-11-20 16:38:49,494 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=modules-initialization-full, group=overall-execution, time=1732120729.4946613 2024-11-20 16:38:49,494 DEBUG (core.stages_profiler) [MainThread] Set stage modules-initialization-full_finished=1732120729.4946613 2024-11-20 16:38:49,494 DEBUG (core.profiler) [MainThread] Profile step modules-initialization-full_finished - 1732120729.4946613 2024-11-20 16:38:49,494 DEBUG (core.stage_tracer) [MainThread] Start stage tag=invoke-do_ya_make, group=overall-execution, time=1732120729.4948137 2024-11-20 16:38:49,494 DEBUG (core.stages_profiler) [MainThread] Set stage invoke-do_ya_make_started=1732120729.4948137 2024-11-20 16:38:49,494 DEBUG (core.profiler) [MainThread] Profile step invoke-do_ya_make_started - 1732120729.4948137 2024-11-20 16:38:49,617 DEBUG (core.stage_tracer) [MainThread] Start stage tag=ya_make_handler, group=build_handler, time=1732120729.6173017 2024-11-20 16:38:49,617 DEBUG (core.stages_profiler) [MainThread] Set stage ya_make_handler_started=1732120729.6173017 2024-11-20 16:38:49,617 DEBUG (core.profiler) [MainThread] Profile step ya_make_handler_started - 1732120729.6173017 2024-11-20 16:38:49,617 DEBUG (core.stage_tracer) [MainThread] Start stage tag=context_generating, group=build_handler, time=1732120729.6175086 2024-11-20 16:38:49,617 DEBUG (core.stages_profiler) [MainThread] Set stage context_generating_started=1732120729.6175086 2024-11-20 16:38:49,617 DEBUG (core.profiler) [MainThread] Profile step context_generating_started - 1732120729.6175086 2024-11-20 16:38:49,617 DEBUG (core.stage_tracer) [MainThread] Start stage tag=build_graph_cache_configuration, group=build_handler, time=1732120729.6176307 2024-11-20 16:38:49,617 DEBUG (core.stages_profiler) [MainThread] Set stage build_graph_cache_configuration_started=1732120729.6176307 2024-11-20 16:38:49,617 DEBUG (core.profiler) [MainThread] Profile step build_graph_cache_configuration_started - 1732120729.6176307 2024-11-20 16:38:49,617 DEBUG (build.ya_make) [MainThread] Build graph cache processing started 2024-11-20 16:38:49,617 DEBUG (build.ya_make) [MainThread] Build graph cache processing disabled 2024-11-20 16:38:49,617 DEBUG (build.ya_make) [MainThread] Build graph cache is not available in opensource 2024-11-20 16:38:49,617 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=build_graph_cache_configuration, group=build_handler, time=1732120729.6178403 2024-11-20 16:38:49,617 DEBUG (core.stages_profiler) [MainThread] Set stage build_graph_cache_configuration_finished=1732120729.6178403 2024-11-20 16:38:49,617 DEBUG (core.profiler) [MainThread] Profile step build_graph_cache_configuration_finished - 1732120729.6178403 2024-11-20 16:38:49,618 DEBUG (core.stage_tracer) [MainThread] Start stage tag=context_creation, group=ya_make, time=1732120729.6180868 2024-11-20 16:38:49,618 DEBUG (core.stages_profiler) [MainThread] Set stage context_creation_started=1732120729.6180868 2024-11-20 16:38:49,618 DEBUG (core.profiler) [MainThread] Profile step context_creation_started - 1732120729.6180868 2024-11-20 16:38:49,620 DEBUG (yalibrary.toolscache) [MainThread] Tools cache uses passed opts 2024-11-20 16:38:49,620 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-20 16:38:49,620 DEBUG (build.ya_make) [MainThread] content UIDs enabled by request 2024-11-20 16:38:49,622 DEBUG (build.ya_make) [Misc-00] Using '/tmp/tmp.9fNRL4WDo8' file to obtain bazel remote password 2024-11-20 16:38:49,622 DEBUG (core.stage_tracer) [MainThread] Start stage tag=build_graph_and_tests, group=graph, time=1732120729.6224847 2024-11-20 16:38:49,622 DEBUG (core.stages_profiler) [MainThread] Set stage build_graph_and_tests_started=1732120729.6224847 2024-11-20 16:38:49,622 DEBUG (core.profiler) [MainThread] Profile step build_graph_and_tests_started - 1732120729.6224847 2024-11-20 16:38:49,622 DEBUG (build.graph) [Misc-01] Collect vcs info 2024-11-20 16:38:49,623 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-20 16:38:49,623 DEBUG (yalibrary.vcs) [Misc-01] common root: /home/runner/actions_runner/_work/ydb/ydb 2024-11-20 16:38:49,623 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/ya.conf.json 2024-11-20 16:38:49,623 DEBUG (yalibrary.vcs) [Misc-01] vcs root: /home/runner/actions_runner/_work/ydb/ydb (git) 2024-11-20 16:38:49,624 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/platform/clang/clang16.json 2024-11-20 16:38:49,626 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/platform/clang/clang18.json 2024-11-20 16:38:49,628 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-20 16:38:49,628 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-20 16:38:49,628 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-20 16:38:49,629 DEBUG (yalibrary.tools) [MainThread] Using old-style toolchain for: ymake 2024-11-20 16:38:49,629 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/ymake/public.resources.json 2024-11-20 16:38:49,629 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ymake: try to fetch by {'darwin': {'uri': 'sbr:7448914799'}, 'darwin-arm64': {'uri': 'sbr:7448913101'}, 'linux': {'uri': 'sbr:7448917907'}, 'linux-aarch64': {'uri': 'sbr:7448911598'}, 'win32-clang-cl': {'uri': 'sbr:7448916360'}} for 'linux' 2024-11-20 16:38:49,629 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ymake: will use 'linux' platform 2024-11-20 16:38:49,629 DEBUG (yalibrary.fetcher.resource_fetcher) [MainThread] Fetching 7448917907 from sbr:7448917907 to /home/runner/.ya/tools/v4/7448917907 dir, post_process=0) 2024-11-20 16:38:49,629 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/mapping.conf.json 2024-11-20 16:38:49,631 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/ext_mapping.conf.json 2024-11-20 16:38:49,639 DEBUG (yalibrary.toolscache) [MainThread] Tools cache attempt: (request for resource 7448917907) 2024-11-20 16:38:49,639 DEBUG (yalibrary.toolscache) [MainThread] Tools cache server resource download/parameters 2024-11-20 16:38:49,639 DEBUG (yalibrary.tools) [MainThread] Using old-style toolchain for: ya-tc 2024-11-20 16:38:49,639 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/ya-tc/public.resources.json 2024-11-20 16:38:49,639 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-20 16:38:49,639 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ya-tc: will use 'linux' platform 2024-11-20 16:38:49,639 DEBUG (yalibrary.fetcher.resource_fetcher) [MainThread] Fetching 6812260917 from sbr:6812260917 to /home/runner/.ya/tools/v4/6812260917 dir, post_process=0) 2024-11-20 16:38:49,639 DEBUG (yalibrary.toolscache) [MainThread] tc cache stats: None 2024-11-20 16:38:49,640 DEBUG (yalibrary.fetcher.cache_helper) [MainThread] Resource seems to be installed in /home/runner/.ya/tools/v4/6812260917 2024-11-20 16:38:49,640 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ya-tc: successfully fetched into /home/runner/.ya/tools/v4/6812260917 2024-11-20 16:38:49,640 DEBUG (yalibrary.tools) [MainThread] Using old-style toolchain for: ya-tc 2024-11-20 16:38:49,640 DEBUG (yalibrary.toolscache) [MainThread] tc cache stats: None 2024-11-20 16:38:49,640 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-20 16:38:49,643 DEBUG (yalibrary.toolscache) [MainThread] Tools cache (request for resource 7448917907) address: (2383, 13274, 'unix:/home/runner/.ya/tools/v4/psingL04zAe.tmp') 2024-11-20 16:38:49,648 DEBUG (yalibrary.toolscache) [MainThread] tc cache stats: TotalKnownSize: 62119936 TotalKnownSizeLocked: 22249472 Master: true TotalDBSize: 81920 ToolCount: 2 ProcessesCount: 2 2024-11-20 16:38:49,648 DEBUG (yalibrary.fetcher.cache_helper) [MainThread] Resource seems to be installed in /home/runner/.ya/tools/v4/7448917907 2024-11-20 16:38:49,648 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ymake: successfully fetched into /home/runner/.ya/tools/v4/7448917907 2024-11-20 16:38:49,648 DEBUG (exts.timer) [MainThread] Timer build.graph, stage fetch ymake: 0.01968073844909668 2024-11-20 16:38:49,649 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=gen-graph-default-linux-x86_64-relwithdebinfo-pic, group=graph, time=1732120729.6490393 2024-11-20 16:38:49,649 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-default-linux-x86_64-relwithdebinfo-pic_started=1732120729.6490393 2024-11-20 16:38:49,649 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-default-linux-x86_64-relwithdebinfo-pic_started - 1732120729.6490393 2024-11-20 16:38:49,649 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=gen-graph-default-linux-x86_64-relwithdebinfo-nopic, group=graph, time=1732120729.6496212 2024-11-20 16:38:49,649 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-default-linux-x86_64-relwithdebinfo-nopic_started=1732120729.6496212 2024-11-20 16:38:49,650 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-default-linux-x86_64-relwithdebinfo-nopic_started - 1732120729.6496212 2024-11-20 16:38:49,650 DEBUG (core.stage_tracer) [MainThread] Start stage tag=get-tools, group=graph, time=1732120729.6497867 2024-11-20 16:38:49,650 DEBUG (core.stages_profiler) [MainThread] Set stage get-tools_started=1732120729.6497867 2024-11-20 16:38:49,650 DEBUG (core.profiler) [MainThread] Profile step get-tools_started - 1732120729.6497867 2024-11-20 16:38:49,650 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-pic, group=graph, time=1732120729.6498463 2024-11-20 16:38:49,650 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-pic_started=1732120729.6498463 2024-11-20 16:38:49,650 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-pic_started - 1732120729.6498463 2024-11-20 16:38:49,650 DEBUG (yalibrary.guards) [Misc-02] Enter guard fetch with value None 2024-11-20 16:38:49,650 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-nopic, group=graph, time=1732120729.6503193 2024-11-20 16:38:49,651 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-nopic_started=1732120729.6503193 2024-11-20 16:38:49,651 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-nopic_started - 1732120729.6503193 2024-11-20 16:38:49,651 DEBUG (yalibrary.guards) [Misc-03] Enter guard fetch with value None 2024-11-20 16:38:49,651 DEBUG (core.stage_tracer) [MainThread] Start stage tag=waiting-tool-targets, group=graph, time=1732120729.6506307 2024-11-20 16:38:49,651 DEBUG (core.stages_profiler) [MainThread] Set stage waiting-tool-targets_started=1732120729.6506307 2024-11-20 16:38:49,651 DEBUG (core.profiler) [MainThread] Profile step waiting-tool-targets_started - 1732120729.6506307 2024-11-20 16:38:49,651 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-20 16:38:49,654 DEBUG (yalibrary.vcs.vcsversion) [Misc-01] b'fatal: No names found, cannot describe anything.\n' Running git describe --exact-match --all HEAD failed with exit code 128 2024-11-20 16:38:49,656 DEBUG (yalibrary.vcs.vcsversion) [Misc-01] Git info commit:b'79055f4e470d2f0aec69d9b78399027011586dab', author:b'Natasha ', summary:b'Merge 03315766a95b346d6d19b68da634fc5d470287ff into 4644e090d713dd56dd5734b49ad80400f1a21414', svn_id:b'' 2024-11-20 16:38:49,656 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-5jq2vz2xk4 Host information: Linux ghrun-5jq2vz2xk4 5.15.0-124-generic #134-Ubuntu SMP Fri Sep 27 20:20:17 UTC 2024 x86_64 2024-11-20 16:38:49,657 DEBUG (build.graph) [Misc-01] Got version json "{\n \"ARCADIA_PATCH_NUMBER\": 1,\n \"ARCADIA_SOURCE_HG_HASH\": \"79055f4e470d2f0aec69d9b78399027011586dab\",\n \"ARCADIA_SOURCE_LAST_AUTHOR\": \"Natasha \",\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-20T16:38:49.000000Z\",\n \"BUILD_HOST\": \"ghrun-5jq2vz2xk4\",\n \"BUILD_TIMESTAMP\": 1732120729,\n \"BUILD_USER\": \"runner\",\n \"CUSTOM_VERSION\": \"\",\n \"DIRTY\": \"\",\n \"PROGRAM_VERSION\": \"Git info:\\n Commit: 79055f4e470d2f0aec69d9b78399027011586dab\\n Branch: \\n Author: Natasha \\n Summary: Merge 03315766a95b346d6d19b68da634fc5d470287ff into 4644e090d713dd56dd5734b49ad80400f1a21414\\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-5jq2vz2xk4\\n Host information: \\n Linux ghrun-5jq2vz2xk4 5.15.0-124-generic #134-Ubuntu SMP Fri Sep 27 20:20:17 UTC 2024 x86_64\\n\\n \",\n \"SCM_DATA\": \"Git info:\\n Commit: 79055f4e470d2f0aec69d9b78399027011586dab\\n Branch: \\n Author: Natasha \\n Summary: Merge 03315766a95b346d6d19b68da634fc5d470287ff into 4644e090d713dd56dd5734b49ad80400f1a21414\\n\",\n \"VCS\": \"git\"\n}" 2024-11-20 16:38:49,657 DEBUG (exts.timer) [Misc-01] Timer get_version_info, stage vcs info: 0.03382420539855957 2024-11-20 16:38:49,683 DEBUG (build.genconf) [Misc-03] Generating conf into /home/runner/.ya/build/conf/dist-relwithdebinfo-3798d7c5263eb68d1e51bedf06eb099e/ymake.conf with cmd ['/home/runner/.ya/tools/38e015ab6e_d/ya-bin', '/home/runner/actions_runner/_work/ydb/ydb/build/ymake_conf.py', '/home/runner/actions_runner/_work/ydb/ydb', 'dist-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-20 16:38:49,683 DEBUG (build.genconf) [Misc-02] Generating conf into /home/runner/.ya/build/conf/dist-relwithdebinfo-98d764e15a8af720dfdf42d2b66ea646/ymake.conf with cmd ['/home/runner/.ya/tools/38e015ab6e_d/ya-bin', '/home/runner/actions_runner/_work/ydb/ydb/build/ymake_conf.py', '/home/runner/actions_runner/_work/ydb/ydb', 'dist-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-20 16:38:49,809 DEBUG (build.genconf) [Misc-02] Copy conf /home/runner/.ya/build/conf/dist-relwithdebinfo-98d764e15a8af720dfdf42d2b66ea646/ymake.conf to /home/runner/.ya/build/conf/dist-relwithdebinfo-x-9ab01bb8ea623bac3a59e142d32bd0cf/ymake.conf 2024-11-20 16:38:49,809 DEBUG (yalibrary.guards) [Misc-02] Exit guard fetch with value None 2024-11-20 16:38:49,809 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-pic, group=graph, time=1732120729.8098173 2024-11-20 16:38:49,809 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-pic_finished=1732120729.8098173 2024-11-20 16:38:49,809 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-pic_finished - 1732120729.8098173 2024-11-20 16:38:49,810 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=gen-graph-json-default-linux-x86_64-relwithdebinfo-pic, group=graph, time=1732120729.81003 2024-11-20 16:38:49,810 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-json-default-linux-x86_64-relwithdebinfo-pic_started=1732120729.81003 2024-11-20 16:38:49,810 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-json-default-linux-x86_64-relwithdebinfo-pic_started - 1732120729.81003 2024-11-20 16:38:49,810 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-9ab01bb8ea623bac3a59e142d32bd0cf_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-9ab01bb8ea623bac3a59e142d32bd0cf/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 0x7fb88e05e7a0>, 'enabled_events': 'dGT', 'no_caches_on_retry': False, 'no_ymake_retry': False, 'disable_customization': 0, 'dump_tests': '/home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.38cdtv6r/test.dart', 'dump_make_files': '/home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.38cdtv6r/makefiles.dart'} 2024-11-20 16:38:49,810 DEBUG (core.yarg.behaviour) [Misc-02] Found unused args ['grab_stderr'] 2024-11-20 16:38:49,810 DEBUG (build.prefetch) [Misc-02] prefetch disabled 2024-11-20 16:38:49,810 DEBUG (core.event_handling.base_subscriber) [Misc-02] Subscribing PrintProgressSubscriber to event_queue 2024-11-20 16:38:49,810 DEBUG (yalibrary.tools) [Misc-02] Using old-style toolchain for: ymake 2024-11-20 16:38:49,811 DEBUG (build.ymake2.run_ymake) [Misc-02] run: '/home/runner/.ya/tools/v4/7448917907/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732120729.2956.vtimd2l6/yatmpkc68l0rk --config /home/runner/.ya/build/conf/dist-relwithdebinfo-x-9ab01bb8ea623bac3a59e142d32bd0cf/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-9ab01bb8ea623bac3a59e142d32bd0cf_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.38cdtv6r/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.38cdtv6r/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' with env: { } 2024-11-20 16:38:49,811 DEBUG (build.genconf) [Misc-03] Copy conf /home/runner/.ya/build/conf/dist-relwithdebinfo-3798d7c5263eb68d1e51bedf06eb099e/ymake.conf to /home/runner/.ya/build/conf/dist-relwithdebinfo-x-80332a3dd2fbf236732d73bb012dec23/ymake.conf 2024-11-20 16:38:49,813 DEBUG (yalibrary.guards) [Misc-03] Exit guard fetch with value None 2024-11-20 16:38:49,813 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-nopic, group=graph, time=1732120729.813633 2024-11-20 16:38:49,813 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-nopic_finished=1732120729.813633 2024-11-20 16:38:49,813 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-gen-opts-default-linux-x86_64-relwithdebinfo-nopic_finished - 1732120729.813633 2024-11-20 16:38:49,813 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=gen-graph-json-default-linux-x86_64-relwithdebinfo-nopic, group=graph, time=1732120729.8138795 2024-11-20 16:38:49,813 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-json-default-linux-x86_64-relwithdebinfo-nopic_started=1732120729.8138795 2024-11-20 16:38:49,814 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-json-default-linux-x86_64-relwithdebinfo-nopic_started - 1732120729.8138795 2024-11-20 16:38:49,814 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-80332a3dd2fbf236732d73bb012dec23_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-80332a3dd2fbf236732d73bb012dec23/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 0x7fb88e05f420>, 'enabled_events': 'dGT', 'no_caches_on_retry': False, 'no_ymake_retry': False, 'disable_customization': 0, 'dump_tests': '/home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.7zt5bz5y/test.dart', 'dump_make_files': '/home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.7zt5bz5y/makefiles.dart'} 2024-11-20 16:38:49,814 DEBUG (core.yarg.behaviour) [Misc-03] Found unused args ['grab_stderr'] 2024-11-20 16:38:49,814 DEBUG (build.prefetch) [Misc-03] prefetch disabled 2024-11-20 16:38:49,814 DEBUG (yalibrary.tools) [Misc-03] Using old-style toolchain for: ymake 2024-11-20 16:38:49,814 DEBUG (build.ymake2.run_ymake) [Misc-03] run: '/home/runner/.ya/tools/v4/7448917907/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732120729.2956.vtimd2l6/yatmppxbx1rhu --config /home/runner/.ya/build/conf/dist-relwithdebinfo-x-80332a3dd2fbf236732d73bb012dec23/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-80332a3dd2fbf236732d73bb012dec23_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.7zt5bz5y/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.7zt5bz5y/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' with env: { } 2024-11-20 16:38:49,817 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"ymake run","_timestamp":1732120729816981,"_typename":"NEvent.TStageStarted","debug_id":"default-linux-x86_64-relwithdebinfo-pic","ymake_run_uid":0} 2024-11-20 16:38:49,817 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Target path: /home/runner/actions_runner/_work/ydb/ydb\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120729817099,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:49,817 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load configuration from cache","_timestamp":1732120729817131,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:49,817 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Conf cache has not been loaded (reason: File does not exist)...\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120729817139,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:49,817 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load configuration from cache","_timestamp":1732120729817143,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:49,818 DEBUG (build.ya_make) [Misc-02] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedConfCache","Type":"bool","_timestamp":1732120729817397,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-20 16:38:49,818 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1732120729817402,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:49,820 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"ymake run","_timestamp":1732120729819885,"_typename":"NEvent.TStageStarted","debug_id":"default-linux-x86_64-relwithdebinfo-nopic","ymake_run_uid":1} 2024-11-20 16:38:49,820 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Target path: /home/runner/actions_runner/_work/ydb/ydb\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120729819987,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:49,820 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load configuration from cache","_timestamp":1732120729820016,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:49,820 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Conf cache has not been loaded (reason: File does not exist)...\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120729820025,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:49,820 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load configuration from cache","_timestamp":1732120729820028,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:49,820 DEBUG (build.ya_make) [Misc-03] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedConfCache","Type":"bool","_timestamp":1732120729820274,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-20 16:38:49,820 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1732120729820278,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:49,970 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1732120729969922,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:49,970 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1732120729969954,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:49,971 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1732120729971345,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:49,971 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Fold global commands","_timestamp":1732120729971356,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:49,972 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Fold global commands","_timestamp":1732120729972488,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:49,972 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load plugins","_timestamp":1732120729972495,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:49,973 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1732120729973631,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:49,974 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1732120729973648,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:49,975 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1732120729975007,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:49,975 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Fold global commands","_timestamp":1732120729975017,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:49,976 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Fold global commands","_timestamp":1732120729976180,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:49,976 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load plugins","_timestamp":1732120729976187,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:50,087 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load plugins","_timestamp":1732120730086807,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:50,089 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load plugins","_timestamp":1732120730089057,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:50,117 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"MAIN_OUTPUT_AS_EXTRA enabled\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730117390,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,117 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"YMAKE_DEDICATED_MODULE_NODE disabled (by default)\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730117410,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,117 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"YMAKE_CHECK_FOR_INCORRECT_LOOPS disabled (by default)\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730117414,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,118 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"mlockall failed\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730117495,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,118 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"ymake main","_timestamp":1732120730117499,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:50,118 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"FS cache loading is enabled\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730117551,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,118 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"FS cache saving is enabled\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730117556,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,118 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Deps cache loading is enabled\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730117560,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,118 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Deps cache saving is enabled\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730117563,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,118 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"DepManagement cache loading is enabled\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730117567,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,119 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"DepManagement cache saving is enabled\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730117570,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,119 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Uids cache loading is enabled\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730117573,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,119 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Uids cache saving is enabled\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730117577,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,119 DEBUG (build.ya_make) [Misc-02] Configure message {"HasChangelist":false,"_timestamp":1732120730118406,"_typename":"NEvent.TArcChanges","ymake_run_uid":0} 2024-11-20 16:38:50,119 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"MAIN_OUTPUT_AS_EXTRA enabled\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730119263,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,119 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Graph has structural changes because of PatchPath\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730118415,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,119 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"YMAKE_DEDICATED_MODULE_NODE disabled (by default)\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730119280,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,119 DEBUG (build.ya_make) [Misc-02] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedFSCache","Type":"bool","_timestamp":1732120730118422,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-20 16:38:50,120 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"YMAKE_CHECK_FOR_INCORRECT_LOOPS disabled (by default)\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730119284,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,120 DEBUG (build.ya_make) [Misc-02] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedDepsCache","Type":"bool","_timestamp":1732120730118426,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-20 16:38:50,120 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"mlockall failed\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730119354,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,120 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Build graph","_timestamp":1732120730118429,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:50,120 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"ymake main","_timestamp":1732120730119358,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:50,120 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Graph has structural changes because start dirs are different\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730118434,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,120 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"FS cache loading is enabled\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730119395,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,120 DEBUG (build.ya_make) [Misc-02] Configure message {"PredictsStructuralChanges":true,"_timestamp":1732120730118438,"_typename":"NEvent.TGraphChangesPrediction","ymake_run_uid":0} 2024-11-20 16:38:50,120 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"FS cache saving is enabled\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730119400,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,120 DEBUG (build.ya_make) [Misc-02] Configure message {"Enabled":false,"MaybeEnabled":false,"_timestamp":1732120730118442,"_typename":"NEvent.TBypassConfigure","ymake_run_uid":0} 2024-11-20 16:38:50,120 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Deps cache loading is enabled\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730119403,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,121 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Configure graph","_timestamp":1732120730118446,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:50,121 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Deps cache saving is enabled\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730119407,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,121 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"DepManagement cache loading is enabled\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730119411,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,121 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"DepManagement cache saving is enabled\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730119414,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,121 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Uids cache loading is enabled\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730119418,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,121 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Uids cache saving is enabled\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730119421,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,121 DEBUG (build.ya_make) [Misc-03] Configure message {"HasChangelist":false,"_timestamp":1732120730120217,"_typename":"NEvent.TArcChanges","ymake_run_uid":1} 2024-11-20 16:38:50,121 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Graph has structural changes because of PatchPath\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730120224,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,121 DEBUG (build.ya_make) [Misc-03] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedFSCache","Type":"bool","_timestamp":1732120730120230,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-20 16:38:50,121 DEBUG (build.ya_make) [Misc-03] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedDepsCache","Type":"bool","_timestamp":1732120730120234,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-20 16:38:50,122 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Build graph","_timestamp":1732120730120237,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:50,122 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Graph has structural changes because start dirs are different\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730120242,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,122 DEBUG (build.ya_make) [Misc-03] Configure message {"PredictsStructuralChanges":true,"_timestamp":1732120730120246,"_typename":"NEvent.TGraphChangesPrediction","ymake_run_uid":1} 2024-11-20 16:38:50,122 DEBUG (build.ya_make) [Misc-03] Configure message {"Enabled":false,"MaybeEnabled":false,"_timestamp":1732120730120249,"_typename":"NEvent.TBypassConfigure","ymake_run_uid":1} 2024-11-20 16:38:50,122 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Configure graph","_timestamp":1732120730120252,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:50,218 DEBUG (build.ya_make) [Misc-03] Configure message {"DoubleValue":0.09842257548,"Name":"EYmakeStats::ConfigureGraphTime","Type":"double","_timestamp":1732120730218691,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-20 16:38:50,219 DEBUG (build.ya_make) [Misc-02] Configure message {"DoubleValue":0.1003699272,"Name":"EYmakeStats::ConfigureGraphTime","Type":"double","_timestamp":1732120730218823,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-20 16:38:50,219 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Configure graph","_timestamp":1732120730218711,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:50,219 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Configure graph","_timestamp":1732120730218842,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:50,219 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Searching target '.'\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730218719,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,219 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Searching target '.'\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730218850,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,219 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Selected target '$S' with id 3\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730218725,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,219 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Selected target '$S' with id 3\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730218856,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,220 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Find Lost Includes","_timestamp":1732120730218773,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:50,220 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Find Lost Includes","_timestamp":1732120730218902,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:50,220 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":3061,"Sub":"","Type":"Debug","_timestamp":1732120730218849,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,220 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":3059,"Sub":"","Type":"Debug","_timestamp":1732120730218976,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,220 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Find Lost Includes","_timestamp":1732120730218853,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:50,220 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Find Lost Includes","_timestamp":1732120730218985,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:50,220 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"loaded size = 9020005; load time = 10500; loaded MD5 time = 740; Max loaded MD5 time = 5; loaded count = 2174; max load time = 28; mapped size = 40632376; mapped MD5 time = 9183; Max mapped MD5 time = 568; mapped count = 130; map time = 736; from patch count = 0; from patch size = 0; file stat count = 3223; lstat count = 3045; lstat sum us = 3085; lstat min us = 0; lstat avr us = 1; lstat max us = 16; 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 = 1909; readdir min us = 0; readdir avr us = 0; readdir max us = 42; (opendir + readdir) sum us = 1909; (lstat + opendir + readdir) sum us = 4994;","Mod":"unimp","Sub":"File access stats","Type":"Debug","_timestamp":1732120730218885,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,220 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"loaded size = 9020005; load time = 10300; loaded MD5 time = 726; Max loaded MD5 time = 5; loaded count = 2174; max load time = 23; mapped size = 40632376; mapped MD5 time = 9140; Max mapped MD5 time = 569; mapped count = 130; map time = 745; from patch count = 0; from patch size = 0; file stat count = 3223; lstat count = 3045; lstat sum us = 3576; lstat min us = 0; lstat avr us = 1; lstat max us = 18; 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 = 2322; readdir min us = 0; readdir avr us = 0; readdir max us = 39; (opendir + readdir) sum us = 2322; (lstat + opendir + readdir) sum us = 5898;","Mod":"unimp","Sub":"File access stats","Type":"Debug","_timestamp":1732120730219016,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,221 DEBUG (build.ya_make) [Misc-03] Configure message {"FileStatCount":3223,"FromPatchCount":0,"FromPatchSize":0,"ListDirSumUs":1909,"LoadTime":10500,"LoadedCount":2174,"LoadedMD5Time":740,"LoadedSize":9020005,"LstatAvrUs":1,"LstatCount":3045,"LstatListDirSumUs":4994,"LstatMaxUs":16,"LstatMinUs":0,"LstatSumUs":3085,"MapTime":736,"MappedCount":130,"MappedMD5Time":9183,"MappedSize":40632376,"MaxLoadTime":28,"MaxLoadedMD5Time":5,"MaxMappedMD5Time":568,"OpendirAvrUs":0,"OpendirCount":388,"OpendirMaxUs":0,"OpendirMinUs":0,"OpendirSumUs":0,"ReaddirAvrUs":0,"ReaddirCount":2837,"ReaddirMaxUs":42,"ReaddirMinUs":0,"ReaddirSumUs":1909,"_timestamp":1732120730218896,"_typename":"NEvent.TFileConfStats","ymake_run_uid":1} 2024-11-20 16:38:50,221 DEBUG (build.ya_make) [Misc-02] Configure message {"FileStatCount":3223,"FromPatchCount":0,"FromPatchSize":0,"ListDirSumUs":2322,"LoadTime":10300,"LoadedCount":2174,"LoadedMD5Time":726,"LoadedSize":9020005,"LstatAvrUs":1,"LstatCount":3045,"LstatListDirSumUs":5898,"LstatMaxUs":18,"LstatMinUs":0,"LstatSumUs":3576,"MapTime":745,"MappedCount":130,"MappedMD5Time":9140,"MappedSize":40632376,"MaxLoadTime":23,"MaxLoadedMD5Time":5,"MaxMappedMD5Time":569,"OpendirAvrUs":0,"OpendirCount":388,"OpendirMaxUs":0,"OpendirMinUs":0,"OpendirSumUs":0,"ReaddirAvrUs":0,"ReaddirCount":2837,"ReaddirMaxUs":39,"ReaddirMinUs":0,"ReaddirSumUs":2322,"_timestamp":1732120730219027,"_typename":"NEvent.TFileConfStats","ymake_run_uid":0} 2024-11-20 16:38:50,221 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":9020005,"Name":"EFileConfStats::LoadedSize","Type":"int","_timestamp":1732120730218908,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-20 16:38:50,221 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":9020005,"Name":"EFileConfStats::LoadedSize","Type":"int","_timestamp":1732120730219038,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-20 16:38:50,221 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":10500,"Name":"EFileConfStats::LoadTime","Type":"int","_timestamp":1732120730218912,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-20 16:38:50,221 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":10300,"Name":"EFileConfStats::LoadTime","Type":"int","_timestamp":1732120730219043,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-20 16:38:50,221 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":2174,"Name":"EFileConfStats::LoadedCount","Type":"int","_timestamp":1732120730218915,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-20 16:38:50,221 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":2174,"Name":"EFileConfStats::LoadedCount","Type":"int","_timestamp":1732120730219045,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-20 16:38:50,221 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":40632376,"Name":"EFileConfStats::MappedSize","Type":"int","_timestamp":1732120730218917,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-20 16:38:50,222 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":40632376,"Name":"EFileConfStats::MappedSize","Type":"int","_timestamp":1732120730219048,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-20 16:38:50,222 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":736,"Name":"EFileConfStats::MapTime","Type":"int","_timestamp":1732120730218920,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-20 16:38:50,222 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":745,"Name":"EFileConfStats::MapTime","Type":"int","_timestamp":1732120730219051,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-20 16:38:50,222 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":130,"Name":"EFileConfStats::MappedCount","Type":"int","_timestamp":1732120730218923,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-20 16:38:50,222 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":130,"Name":"EFileConfStats::MappedCount","Type":"int","_timestamp":1732120730219054,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-20 16:38:50,222 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":2304,"Name":"EFileConfStats::Count","Type":"int","_timestamp":1732120730218925,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-20 16:38:50,222 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":2304,"Name":"EFileConfStats::Count","Type":"int","_timestamp":1732120730219056,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-20 16:38:50,222 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"bucket id = 0; loaded size = 9020005; load time = 10500; loaded count = 2174; max load time = 28;","Mod":"unimp","Sub":"Bucket #0","Type":"Debug","_timestamp":1732120730218932,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,222 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"bucket id = 0; loaded size = 9020005; load time = 10300; loaded count = 2174; max load time = 23;","Mod":"unimp","Sub":"Bucket #0","Type":"Debug","_timestamp":1732120730219064,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,222 DEBUG (build.ya_make) [Misc-03] Configure message {"BucketId":0,"LoadTime":10500,"LoadedCount":2174,"LoadedSize":9020005,"MaxLoadTime":28,"_timestamp":1732120730218937,"_typename":"NEvent.TFileConfSubStats","ymake_run_uid":1} 2024-11-20 16:38:50,222 DEBUG (build.ya_make) [Misc-02] Configure message {"BucketId":0,"LoadTime":10300,"LoadedCount":2174,"LoadedSize":9020005,"MaxLoadTime":23,"_timestamp":1732120730219068,"_typename":"NEvent.TFileConfSubStats","ymake_run_uid":0} 2024-11-20 16:38:50,223 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"parse time = 3; parsed files count = 6; parsed files size = 12965; parsed files recovered = 0; .in files count = 0; .in files size = 0;","Mod":"unimp","Sub":"Parsing stats","Type":"Debug","_timestamp":1732120730218947,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,223 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":1732120730219078,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,223 DEBUG (build.ya_make) [Misc-03] Configure message {"InFilesCount":0,"InFilesSize":0,"ParseTime":3,"ParsedFilesCount":6,"ParsedFilesRecovered":0,"ParsedFilesSize":12965,"_timestamp":1732120730218951,"_typename":"NEvent.TIncParserManagerStats","ymake_run_uid":1} 2024-11-20 16:38:50,223 DEBUG (build.ya_make) [Misc-02] Configure message {"InFilesCount":0,"InFilesSize":0,"ParseTime":2,"ParsedFilesCount":6,"ParsedFilesRecovered":0,"ParsedFilesSize":12965,"_timestamp":1732120730219083,"_typename":"NEvent.TIncParserManagerStats","ymake_run_uid":0} 2024-11-20 16:38:50,223 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":1732120730218963,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,223 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":1732120730219094,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,223 DEBUG (build.ya_make) [Misc-03] Configure message {"Count":8,"Includes":12,"Size":1264,"UniqueCount":8,"UniqueSize":853,"_timestamp":1732120730218967,"_typename":"NEvent.TGeneralParserStats","ymake_run_uid":1} 2024-11-20 16:38:50,223 DEBUG (build.ya_make) [Misc-02] Configure message {"Count":8,"Includes":12,"Size":1264,"UniqueCount":8,"UniqueSize":853,"_timestamp":1732120730219099,"_typename":"NEvent.TGeneralParserStats","ymake_run_uid":0} 2024-11-20 16:38:50,223 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":1732120730218986,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,223 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":1732120730219112,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,224 DEBUG (build.ya_make) [Misc-03] Configure message {"CommandsCount":142,"EdgesCount":12363,"FilesCount":3263,"NodesCount":2825,"_timestamp":1732120730218990,"_typename":"NEvent.TDepGraphStats","ymake_run_uid":1} 2024-11-20 16:38:50,224 DEBUG (build.ya_make) [Misc-02] Configure message {"CommandsCount":142,"EdgesCount":12363,"FilesCount":3263,"NodesCount":2825,"_timestamp":1732120730219116,"_typename":"NEvent.TDepGraphStats","ymake_run_uid":0} 2024-11-20 16:38:50,224 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"nuke mod dir = 0;","Mod":"unimp","Sub":"UpdIter stats","Type":"Debug","_timestamp":1732120730218995,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,224 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"nuke mod dir = 0;","Mod":"unimp","Sub":"UpdIter stats","Type":"Debug","_timestamp":1732120730219121,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,224 DEBUG (build.ya_make) [Misc-03] Configure message {"NukedDir":0,"_timestamp":1732120730218998,"_typename":"NEvent.TUpdIterStats","ymake_run_uid":1} 2024-11-20 16:38:50,224 DEBUG (build.ya_make) [Misc-02] Configure message {"NukedDir":0,"_timestamp":1732120730219124,"_typename":"NEvent.TUpdIterStats","ymake_run_uid":0} 2024-11-20 16:38:50,224 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":1732120730219004,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,224 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":1732120730219130,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,224 DEBUG (build.ya_make) [Misc-03] Configure message {"IncludesAttempted":0,"IncludesFromCache":0,"ResolveAsKnownFromCache":0,"ResolveAsKnownTotal":0,"_timestamp":1732120730219008,"_typename":"NEvent.TResolveStats","ymake_run_uid":1} 2024-11-20 16:38:50,224 DEBUG (build.ya_make) [Misc-02] Configure message {"IncludesAttempted":0,"IncludesFromCache":0,"ResolveAsKnownFromCache":0,"ResolveAsKnownTotal":0,"_timestamp":1732120730219134,"_typename":"NEvent.TResolveStats","ymake_run_uid":0} 2024-11-20 16:38:50,225 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Build graph","_timestamp":1732120730219011,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:50,225 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Build graph","_timestamp":1732120730219138,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:50,225 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":1732120730219099,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,225 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":1732120730219237,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,225 DEBUG (build.ya_make) [Misc-03] Configure message {"Accessed":19,"Loaded":0,"Outdated":0,"Parsed":19,"Total":19,"_timestamp":1732120730219103,"_typename":"NEvent.TModulesStats","ymake_run_uid":1} 2024-11-20 16:38:50,225 DEBUG (build.ya_make) [Misc-02] Configure message {"Accessed":19,"Loaded":0,"Outdated":0,"Parsed":19,"Total":19,"_timestamp":1732120730219242,"_typename":"NEvent.TModulesStats","ymake_run_uid":0} 2024-11-20 16:38:50,225 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":19,"Name":"EModulesStats::Accessed","Type":"int","_timestamp":1732120730219107,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-20 16:38:50,225 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":19,"Name":"EModulesStats::Accessed","Type":"int","_timestamp":1732120730219246,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-20 16:38:50,225 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":0,"Name":"EModulesStats::Loaded","Type":"int","_timestamp":1732120730219110,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-20 16:38:50,225 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":0,"Name":"EModulesStats::Loaded","Type":"int","_timestamp":1732120730219249,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-20 16:38:50,225 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":0,"Name":"EModulesStats::Outdated","Type":"int","_timestamp":1732120730219112,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-20 16:38:50,226 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":0,"Name":"EModulesStats::Outdated","Type":"int","_timestamp":1732120730219251,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-20 16:38:50,226 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":19,"Name":"EModulesStats::Parsed","Type":"int","_timestamp":1732120730219115,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-20 16:38:50,226 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":19,"Name":"EModulesStats::Parsed","Type":"int","_timestamp":1732120730219254,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-20 16:38:50,226 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Set reachable nodes","_timestamp":1732120730219123,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:50,226 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Set reachable nodes","_timestamp":1732120730219263,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:50,226 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Set reachable nodes","_timestamp":1732120730219669,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:50,226 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Set reachable nodes","_timestamp":1732120730219815,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:50,226 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Sort edges","_timestamp":1732120730219672,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:50,226 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Sort edges","_timestamp":1732120730219818,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:50,226 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Sort edges","_timestamp":1732120730222144,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:50,226 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Sort edges","_timestamp":1732120730222281,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:50,227 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1732120730222147,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:50,227 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1732120730222284,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:50,227 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1732120730222194,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:50,227 DEBUG (_ToolTargetsQueue) [MainThread] Source_id=1 (default-linux-x86_64-relwithdebinfo-nopic). Tool targets: set() 2024-11-20 16:38:50,227 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1732120730222330,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:50,227 DEBUG (_ToolTargetsQueue) [MainThread] Source_id=0 (default-linux-x86_64-relwithdebinfo-pic). Tool targets: set() 2024-11-20 16:38:50,227 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check blacklist","_timestamp":1732120730222332,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:50,227 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=waiting-tool-targets, group=graph, time=1732120730.2278314 2024-11-20 16:38:50,227 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check blacklist","_timestamp":1732120730222334,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:50,228 DEBUG (core.stages_profiler) [MainThread] Set stage waiting-tool-targets_finished=1732120730.2278314 2024-11-20 16:38:50,228 DEBUG (core.profiler) [MainThread] Profile step waiting-tool-targets_finished - 1732120730.2278314 2024-11-20 16:38:50,228 DEBUG (build.graph) [MainThread] Empty tool targets list 2024-11-20 16:38:50,228 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=get-tools, group=graph, time=1732120730.2283309 2024-11-20 16:38:50,228 DEBUG (core.stages_profiler) [MainThread] Set stage get-tools_finished=1732120730.2283309 2024-11-20 16:38:50,228 DEBUG (core.profiler) [MainThread] Profile step get-tools_finished - 1732120730.2283309 2024-11-20 16:38:50,228 DEBUG (core.stage_tracer) [MainThread] Start stage tag=merge-target-graphs-1, group=graph, time=1732120730.2285175 2024-11-20 16:38:50,228 DEBUG (core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_started=1732120730.2285175 2024-11-20 16:38:50,228 DEBUG (core.profiler) [MainThread] Profile step merge-target-graphs-1_started - 1732120730.2285175 2024-11-20 16:38:50,228 DEBUG (core.stage_tracer) [MainThread] Start stage tag=wait-target-graphs-1, group=graph, time=1732120730.228705 2024-11-20 16:38:50,228 DEBUG (core.stages_profiler) [MainThread] Set stage wait-target-graphs-1_started=1732120730.228705 2024-11-20 16:38:50,228 DEBUG (core.profiler) [MainThread] Profile step wait-target-graphs-1_started - 1732120730.228705 2024-11-20 16:38:50,228 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check isolated projects","_timestamp":1732120730222336,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:50,228 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check blacklist","_timestamp":1732120730222196,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:50,229 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check isolated projects","_timestamp":1732120730222338,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:50,229 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check blacklist","_timestamp":1732120730222198,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:50,229 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Report Configure Events","_timestamp":1732120730222340,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:50,229 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check isolated projects","_timestamp":1732120730222200,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:50,229 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Report Configure Events","_timestamp":1732120730222392,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:50,229 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check isolated projects","_timestamp":1732120730222202,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:50,229 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save and compact","_timestamp":1732120730222395,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:50,229 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Report Configure Events","_timestamp":1732120730222204,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:50,229 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":1732120730223245,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,229 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Report Configure Events","_timestamp":1732120730222257,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:50,229 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":1732120730223255,"_typename":"NEvent.TInternalCacheSaverStats","ymake_run_uid":0} 2024-11-20 16:38:50,230 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save and compact","_timestamp":1732120730222259,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:50,230 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"FS cache has been saved...\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730223262,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,230 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":1732120730223140,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,230 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Deps cache has been saved...\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730223267,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,230 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":1732120730223150,"_typename":"NEvent.TInternalCacheSaverStats","ymake_run_uid":1} 2024-11-20 16:38:50,230 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save and compact","_timestamp":1732120730224327,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:50,230 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"FS cache has been saved...\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730223157,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,230 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Detect loops","_timestamp":1732120730224333,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:50,230 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Deps cache has been saved...\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730223162,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,230 DEBUG (build.ya_make) [Misc-02] Configure message {"HasContentChanges":true,"HasStructuralChanges":true,"_timestamp":1732120730224735,"_typename":"NEvent.TGraphChanges","ymake_run_uid":0} 2024-11-20 16:38:50,231 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save and compact","_timestamp":1732120730224228,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:50,231 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Detect loops","_timestamp":1732120730224765,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:50,231 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Detect loops","_timestamp":1732120730224234,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:50,231 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Apply Dependency Management","_timestamp":1732120730224767,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:50,231 DEBUG (build.ya_make) [Misc-03] Configure message {"HasContentChanges":true,"HasStructuralChanges":true,"_timestamp":1732120730224640,"_typename":"NEvent.TGraphChanges","ymake_run_uid":1} 2024-11-20 16:38:50,231 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save Dependency management cache","_timestamp":1732120730225195,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:50,231 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Detect loops","_timestamp":1732120730224670,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:50,231 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"DM cache has been saved...\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730225310,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,231 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Apply Dependency Management","_timestamp":1732120730224673,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:50,231 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save Dependency management cache","_timestamp":1732120730225314,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:50,231 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save Dependency management cache","_timestamp":1732120730225099,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:50,231 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Apply Dependency Management","_timestamp":1732120730225316,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:50,232 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"DM cache has been saved...\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730225210,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,232 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Modules requiring dependency management: 0; BFS traversals performed: 0\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730225319,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,232 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save Dependency management cache","_timestamp":1732120730225214,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:50,232 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Fill package outputs","_timestamp":1732120730225351,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:50,232 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Apply Dependency Management","_timestamp":1732120730225216,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:50,232 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Fill package outputs","_timestamp":1732120730225353,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:50,232 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Modules requiring dependency management: 0; BFS traversals performed: 0\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730225219,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,232 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1732120730225357,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:50,232 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Fill package outputs","_timestamp":1732120730225249,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:50,232 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1732120730225494,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:50,232 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Fill package outputs","_timestamp":1732120730225251,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:50,233 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Find missing peerdirs","_timestamp":1732120730225513,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:50,233 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1732120730225255,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:50,233 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Find missing peerdirs","_timestamp":1732120730226166,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:50,233 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1732120730225391,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:50,233 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Export JSON","_timestamp":1732120730226221,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:50,233 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Find missing peerdirs","_timestamp":1732120730225411,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:50,233 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Write JSON","_timestamp":1732120730226225,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:50,233 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Find missing peerdirs","_timestamp":1732120730226058,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:50,233 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Exporting JSON\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730226229,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,233 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Export JSON","_timestamp":1732120730226120,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:50,233 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Visit JSON","_timestamp":1732120730226232,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:50,234 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Write JSON","_timestamp":1732120730226127,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:50,234 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Visit JSON","_timestamp":1732120730229105,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:50,234 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Exporting JSON\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730226131,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,234 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Render JSON","_timestamp":1732120730229110,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:50,234 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Visit JSON","_timestamp":1732120730226135,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:50,234 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Visit JSON","_timestamp":1732120730229029,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:50,234 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Store inputs in JSON cache: enabled\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730229121,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,234 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Render JSON","_timestamp":1732120730229034,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:50,234 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Store inputs in JSON cache: enabled\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730229045,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,236 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":1732120730236014,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,236 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":1732120730236022,"_typename":"NEvent.TJsonCacheStats","ymake_run_uid":0} 2024-11-20 16:38:50,236 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":1732120730236455,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,236 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"JSON cache report: disabled\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730236030,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,236 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":1732120730236462,"_typename":"NEvent.TJsonCacheStats","ymake_run_uid":1} 2024-11-20 16:38:50,237 DEBUG (build.ya_make) [Misc-02] Configure message {"DoubleValue":0.006924474332,"Name":"EYmakeStats::RenderJSONTime","Type":"double","_timestamp":1732120730236038,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-20 16:38:50,237 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"JSON cache report: disabled\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730236470,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,237 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Render JSON","_timestamp":1732120730236042,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:50,237 DEBUG (build.ya_make) [Misc-03] Configure message {"DoubleValue":0.007440761168,"Name":"EYmakeStats::RenderJSONTime","Type":"double","_timestamp":1732120730236479,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-20 16:38:50,237 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save Uids cache","_timestamp":1732120730236045,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-20 16:38:50,237 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Render JSON","_timestamp":1732120730236483,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:50,237 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Uids cache has been saved...\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730236771,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,237 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save Uids cache","_timestamp":1732120730236486,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-20 16:38:50,237 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save Uids cache","_timestamp":1732120730236778,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:50,237 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Uids cache has been saved...\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730237231,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,238 DEBUG (build.ya_make) [Misc-02] Configure message {"HasRenderedNodeChanges":true,"_timestamp":1732120730236789,"_typename":"NEvent.TNodeChanges","ymake_run_uid":0} 2024-11-20 16:38:50,238 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save Uids cache","_timestamp":1732120730237236,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:50,238 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":1732120730236800,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,238 DEBUG (build.ya_make) [Misc-03] Configure message {"HasRenderedNodeChanges":true,"_timestamp":1732120730237248,"_typename":"NEvent.TNodeChanges","ymake_run_uid":1} 2024-11-20 16:38:50,239 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":1732120730236805,"_typename":"NEvent.TUidsCacheStats","ymake_run_uid":0} 2024-11-20 16:38:50,239 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":1732120730237260,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,239 DEBUG (build.ya_make) [Misc-02] Configure message {"DoubleValue":0.0106439879,"Name":"EYmakeStats::WriteJSONTime","Type":"double","_timestamp":1732120730236872,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-20 16:38:50,239 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":1732120730237265,"_typename":"NEvent.TUidsCacheStats","ymake_run_uid":1} 2024-11-20 16:38:50,240 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Write JSON","_timestamp":1732120730236876,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:50,240 DEBUG (build.ya_make) [Misc-03] Configure message {"DoubleValue":0.01119978925,"Name":"EYmakeStats::WriteJSONTime","Type":"double","_timestamp":1732120730237330,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-20 16:38:50,240 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Export JSON","_timestamp":1732120730236897,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:50,240 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Write JSON","_timestamp":1732120730237334,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:50,240 DEBUG (build.ya_make) [Misc-02] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedUidsCache","Type":"bool","_timestamp":1732120730236900,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-20 16:38:50,240 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Export JSON","_timestamp":1732120730237355,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:50,240 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":1732120730236907,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,240 DEBUG (build.ya_make) [Misc-03] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedUidsCache","Type":"bool","_timestamp":1732120730237357,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-20 16:38:50,240 DEBUG (build.ya_make) [Misc-02] Configure message {"InitModuleEnv":13,"InitModuleEnvCalls":13,"_timestamp":1732120730236911,"_typename":"NEvent.TMakeCommandStats","ymake_run_uid":0} 2024-11-20 16:38:50,240 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":1732120730237364,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,241 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"FS cache has been committed...\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730239879,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,241 DEBUG (build.ya_make) [Misc-03] Configure message {"InitModuleEnv":13,"InitModuleEnvCalls":13,"_timestamp":1732120730237368,"_typename":"NEvent.TMakeCommandStats","ymake_run_uid":1} 2024-11-20 16:38:50,241 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Deps cache has been committed...\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730239890,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,241 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"FS cache has been committed...\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730240486,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,241 DEBUG (build.ya_make) [Misc-02] Configure message {"_timestamp":1732120730239895,"_typename":"NEvent.TReadyForUpdateCacheInfo","ymake_run_uid":0} 2024-11-20 16:38:50,241 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Deps cache has been committed...\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730240496,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,241 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"DM cache has been committed...\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730239907,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,241 DEBUG (build.ya_make) [Misc-03] Configure message {"_timestamp":1732120730240501,"_typename":"NEvent.TReadyForUpdateCacheInfo","ymake_run_uid":1} 2024-11-20 16:38:50,241 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Uids cache has been committed...\n","Mod":"unimp","PID":3059,"Sub":"","Type":"Debug","_timestamp":1732120730239917,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-20 16:38:50,241 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"DM cache has been committed...\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730240513,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,241 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"ymake main","_timestamp":1732120730240476,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-20 16:38:50,242 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Uids cache has been committed...\n","Mod":"unimp","PID":3061,"Sub":"","Type":"Debug","_timestamp":1732120730240524,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-20 16:38:50,242 DEBUG (build.ya_make) [Misc-02] Configure message {"DoubleValue":0.4234821229,"Name":"EYmakeStats::RunTime","Type":"double","_timestamp":1732120730240482,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-20 16:38:50,242 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"ymake main","_timestamp":1732120730241072,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-20 16:38:50,242 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"ymake run","_timestamp":1732120730240488,"_typename":"NEvent.TStageFinished","debug_id":"default-linux-x86_64-relwithdebinfo-pic","ymake_run_uid":0} 2024-11-20 16:38:50,242 DEBUG (build.ya_make) [Misc-03] Configure message {"DoubleValue":0.4211542428,"Name":"EYmakeStats::RunTime","Type":"double","_timestamp":1732120730241079,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-20 16:38:50,242 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"ymake run","_timestamp":1732120730241085,"_typename":"NEvent.TStageFinished","debug_id":"default-linux-x86_64-relwithdebinfo-nopic","ymake_run_uid":1} 2024-11-20 16:38:50,245 DEBUG (build.ymake2.run_ymake) [Misc-02] run '/home/runner/.ya/tools/v4/7448917907/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732120729.2956.vtimd2l6/yatmpkc68l0rk --config /home/runner/.ya/build/conf/dist-relwithdebinfo-x-9ab01bb8ea623bac3a59e142d32bd0cf/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-9ab01bb8ea623bac3a59e142d32bd0cf_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.38cdtv6r/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.38cdtv6r/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' finished 2024-11-20 16:38:50,246 DEBUG (build.ymake2.run_ymake) [Misc-03] run '/home/runner/.ya/tools/v4/7448917907/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732120729.2956.vtimd2l6/yatmppxbx1rhu --config /home/runner/.ya/build/conf/dist-relwithdebinfo-x-80332a3dd2fbf236732d73bb012dec23/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-80332a3dd2fbf236732d73bb012dec23_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.7zt5bz5y/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.7zt5bz5y/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' finished 2024-11-20 16:38:50,246 DEBUG (build.ymake2) [Misc-02] ymake_run_info: {"ymake_run_uid":0,"stats":{"preparing":{"start":1732120729.810468912124634,"finish":1732120729.810971975326538,"duration":0.000503063201904},"execution":{"start":1732120729.810972690582275,"finish":1732120730.245489358901978,"duration":0.434516668319702},"postprocessing":{"start":1732120730.24549126625061,"finish":1732120730.2456374168396,"duration":0.000146150588989}},"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":1732120729.816981077194214,"finish":1732120730.240488052368164,"duration":0.42350697517395},"Load configuration from cache":{"start":1732120729.817131042480469,"finish":1732120729.817142963409424,"duration":0.000011920928955},"Load configuration (no cache)":{"start":1732120729.817401885986328,"finish":1732120729.969922065734863,"duration":0.152520179748535},"Compile and RecalcAll conditions":{"start":1732120729.969954013824463,"finish":1732120729.971344947814941,"duration":0.001390933990479},"Fold global commands":{"start":1732120729.97135591506958,"finish":1732120729.972487926483154,"duration":0.001132011413574},"Load plugins":{"start":1732120729.972495079040527,"finish":1732120730.086807012557983,"duration":0.114311933517456},"ymake main":{"start":1732120730.117499113082886,"finish":1732120730.24047589302063,"duration":0.122976779937744},"Build graph":{"start":1732120730.118428945541382,"finish":1732120730.219137907028198,"duration":0.100708961486816},"Configure graph":{"start":1732120730.118446111679077,"finish":1732120730.218842029571533,"duration":0.100395917892456},"Find Lost Includes":{"start":1732120730.218902111053467,"finish":1732120730.218985080718994,"duration":0.000082969665527},"Set reachable nodes":{"start":1732120730.219263076782227,"finish":1732120730.219815015792847,"duration":0.00055193901062},"Sort edges":{"start":1732120730.219818115234375,"finish":1732120730.222280979156494,"duration":0.002462863922119},"Report Foreign Platform Events":{"start":1732120730.222284078598022,"finish":1732120730.222330093383789,"duration":0.000046014785767},"Check blacklist":{"start":1732120730.222332000732422,"finish":1732120730.222333908081055,"duration":0.000001907348633},"Check isolated projects":{"start":1732120730.222336053848267,"finish":1732120730.222337961196899,"duration":0.000001907348633},"Report Configure Events":{"start":1732120730.222340106964111,"finish":1732120730.222392082214355,"duration":0.000051975250244},"Save and compact":{"start":1732120730.222394943237305,"finish":1732120730.224327087402344,"duration":0.001932144165039},"Detect loops":{"start":1732120730.224333047866821,"finish":1732120730.224765062332153,"duration":0.000432014465332},"Apply Dependency Management":{"start":1732120730.224766969680786,"finish":1732120730.225316047668457,"duration":0.000549077987671},"Save Dependency management cache":{"start":1732120730.225194931030273,"finish":1732120730.225313901901245,"duration":0.000118970870972},"Fill package outputs":{"start":1732120730.225351095199585,"finish":1732120730.225353002548218,"duration":0.000001907348633},"Check Transitive Requirements":{"start":1732120730.225357055664062,"finish":1732120730.225493907928467,"duration":0.000136852264404},"Find missing peerdirs":{"start":1732120730.225512981414795,"finish":1732120730.226166009902954,"duration":0.000653028488159},"Export JSON":{"start":1732120730.226221084594727,"finish":1732120730.236896991729736,"duration":0.01067590713501},"Write JSON":{"start":1732120730.226224899291992,"finish":1732120730.236876010894775,"duration":0.010651111602783},"Visit JSON":{"start":1732120730.226232051849365,"finish":1732120730.229104995727539,"duration":0.002872943878174},"Render JSON":{"start":1732120730.2291100025177,"finish":1732120730.236042022705078,"duration":0.006932020187378},"Save Uids cache":{"start":1732120730.236044883728027,"finish":1732120730.236778020858765,"duration":0.000733137130737}},"metrics":{"File access":{"loaded size":9020005,"load time":10300,"loaded MD5 time":726,"Max loaded MD5 time":5,"loaded count":2174,"max load time":23,"mapped size":40632376,"mapped MD5 time":9140,"Max mapped MD5 time":569,"mapped count":130,"map time":745,"from patch count":0,"from patch size":0,"file stat count":3223,"lstat count":3045,"lstat sum us":3576,"lstat min us":0,"lstat avr us":1,"lstat max us":18,"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":2322,"readdir min us":0,"readdir avr us":0,"readdir max us":39,"(opendir + readdir) sum us":2322,"(lstat + opendir + readdir) sum us":5898},"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/7448917907/ymake","args":["/home/runner/.ya/tools/v4/7448917907/ymake","--depends-like-recurse","--warn","dirloops,ChkPeers","--write-meta-data","/home/runner/.ya/tmp/1732120729.2956.vtimd2l6/yatmpkc68l0rk","--config","/home/runner/.ya/build/conf/dist-relwithdebinfo-x-9ab01bb8ea623bac3a59e142d32bd0cf/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-9ab01bb8ea623bac3a59e142d32bd0cf_d357a1f7839b099012272bcb9853ec19","--test-dart","/home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.38cdtv6r/test.dart","--tests-data-root","/home/runner/actions_runner/_work/ydb/arcadia_tests_data","--makefiles-dart","/home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.38cdtv6r/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.434516668319702} 2024-11-20 16:38:50,246 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=load-graph-from-json, group=graph, time=1732120730.2464588 2024-11-20 16:38:50,246 DEBUG (core.stages_profiler) [Misc-02] Set stage load-graph-from-json_started=1732120730.2464588 2024-11-20 16:38:50,246 DEBUG (core.profiler) [Misc-02] Profile step load-graph-from-json_started - 1732120730.2464588 2024-11-20 16:38:50,246 DEBUG (core.event_handling.base_subscriber) [Misc-03] Unsubscribing PrintProgressSubscriber from event_queue 2024-11-20 16:38:50,247 DEBUG (build.ymake2) [Misc-03] ymake_run_info: {"ymake_run_uid":1,"stats":{"preparing":{"start":1732120729.81433892250061,"finish":1732120729.814852237701416,"duration":0.000513315200806},"execution":{"start":1732120729.814853191375732,"finish":1732120730.246317148208618,"duration":0.431463956832886},"postprocessing":{"start":1732120730.246318578720093,"finish":1732120730.246865510940552,"duration":0.000546932220459}},"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":1732120729.819885015487671,"finish":1732120730.241085052490234,"duration":0.421200037002564},"Load configuration from cache":{"start":1732120729.820015907287598,"finish":1732120729.820028066635132,"duration":0.000012159347534},"Load configuration (no cache)":{"start":1732120729.82027792930603,"finish":1732120729.973630905151367,"duration":0.153352975845337},"Compile and RecalcAll conditions":{"start":1732120729.973648071289062,"finish":1732120729.975007057189941,"duration":0.001358985900879},"Fold global commands":{"start":1732120729.975017070770264,"finish":1732120729.976180076599121,"duration":0.001163005828857},"Load plugins":{"start":1732120729.976186990737915,"finish":1732120730.089056968688965,"duration":0.11286997795105},"ymake main":{"start":1732120730.119358062744141,"finish":1732120730.241071939468384,"duration":0.121713876724243},"Build graph":{"start":1732120730.120237112045288,"finish":1732120730.219011068344116,"duration":0.098773956298828},"Configure graph":{"start":1732120730.120251893997192,"finish":1732120730.218710899353027,"duration":0.098459005355835},"Find Lost Includes":{"start":1732120730.218772888183594,"finish":1732120730.218852996826172,"duration":0.000080108642578},"Set reachable nodes":{"start":1732120730.219122886657715,"finish":1732120730.219669103622437,"duration":0.000546216964722},"Sort edges":{"start":1732120730.219671964645386,"finish":1732120730.222143888473511,"duration":0.002471923828125},"Report Foreign Platform Events":{"start":1732120730.222146987915039,"finish":1732120730.222193956375122,"duration":0.000046968460083},"Check blacklist":{"start":1732120730.222196102142334,"finish":1732120730.222198009490967,"duration":0.000001907348633},"Check isolated projects":{"start":1732120730.2221999168396,"finish":1732120730.222202062606812,"duration":0.000002145767212},"Report Configure Events":{"start":1732120730.222203969955444,"finish":1732120730.222256898880005,"duration":0.000052928924561},"Save and compact":{"start":1732120730.222259044647217,"finish":1732120730.224227905273438,"duration":0.001968860626221},"Detect loops":{"start":1732120730.224234104156494,"finish":1732120730.224669933319092,"duration":0.000435829162598},"Apply Dependency Management":{"start":1732120730.22467303276062,"finish":1732120730.225215911865234,"duration":0.000542879104614},"Save Dependency management cache":{"start":1732120730.225099086761475,"finish":1732120730.225214004516602,"duration":0.000114917755127},"Fill package outputs":{"start":1732120730.22524905204773,"finish":1732120730.225250959396362,"duration":0.000001907348633},"Check Transitive Requirements":{"start":1732120730.225255012512207,"finish":1732120730.225390911102295,"duration":0.000135898590088},"Find missing peerdirs":{"start":1732120730.225410938262939,"finish":1732120730.226058006286621,"duration":0.000647068023682},"Export JSON":{"start":1732120730.226119995117188,"finish":1732120730.23735499382019,"duration":0.011234998703003},"Write JSON":{"start":1732120730.226126909255981,"finish":1732120730.23733401298523,"duration":0.011207103729248},"Visit JSON":{"start":1732120730.226135015487671,"finish":1732120730.229028940200806,"duration":0.002893924713135},"Render JSON":{"start":1732120730.229033946990967,"finish":1732120730.236483097076416,"duration":0.007449150085449},"Save Uids cache":{"start":1732120730.236485958099365,"finish":1732120730.237236022949219,"duration":0.000750064849854}},"metrics":{"File access":{"loaded size":9020005,"load time":10500,"loaded MD5 time":740,"Max loaded MD5 time":5,"loaded count":2174,"max load time":28,"mapped size":40632376,"mapped MD5 time":9183,"Max mapped MD5 time":568,"mapped count":130,"map time":736,"from patch count":0,"from patch size":0,"file stat count":3223,"lstat count":3045,"lstat sum us":3085,"lstat min us":0,"lstat avr us":1,"lstat max us":16,"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":1909,"readdir min us":0,"readdir avr us":0,"readdir max us":42,"(opendir + readdir) sum us":1909,"(lstat + opendir + readdir) sum us":4994},"Parsing":{"parse time":3,"parsed files count":6,"parsed files size":12965,"parsed files recovered":0,".in files count":0,".in files size":0},"ya.make parsing":{"count":8,"includes count":12,"unique count":8,"size":1264,"unique size":853},"DepGraph":{"nodes count":2825,"edges count":12363,"files count":3263,"commands count":142},"UpdIter":{"nuke mod dir":0},"Resolving":{"Includes attempts":0,"From cache":0,"Resolve AsKnown total":0,"Resolve AsKnown from cache":0},"TModules":{"accessed":19,"loaded":0,"outdated":0,"parsed":19,"total":19},"Internal cache":{"Total cache size on save":428512,"Diagnostics cache size on save":112,"Graph cache size on save":91616,"Parsers cache size on save":224,"Modules table size on save":3079,"Times table size on save":16,"Names table size on save":332624,"Commands cache size on save":272},"JSON cache":{"Loaded cache items":0,"Added cache items":0,"Saved old cache items":0,"Saved new cache items":0,"Saved total cache items":0,"Loaded full match items":0,"Full match requests":0,"Successful full matches":0,"Loaded partial match items":0,"Partial match requests":0,"Successful partial matches":0,"Fully rendered nodes":0,"Partially rendered nodes":0,"Nodes restored without rendering":0},"Uids cache":{"Loaded nodes":0,"Skipped nodes":0,"Discarded nodes":0,"Loaded loops":0,"Skipped loops":0,"Discarded loops":0,"Saved nodes":2392,"Saved loops":0,"Really all nodes no rendered":0},"TMakeCommand":{"module environment initialization calls":13,"actual module environment initializations":13}},"binary":"/home/runner/.ya/tools/v4/7448917907/ymake","args":["/home/runner/.ya/tools/v4/7448917907/ymake","--depends-like-recurse","--warn","dirloops,ChkPeers","--write-meta-data","/home/runner/.ya/tmp/1732120729.2956.vtimd2l6/yatmppxbx1rhu","--config","/home/runner/.ya/build/conf/dist-relwithdebinfo-x-80332a3dd2fbf236732d73bb012dec23/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-80332a3dd2fbf236732d73bb012dec23_d357a1f7839b099012272bcb9853ec19","--test-dart","/home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.7zt5bz5y/test.dart","--tests-data-root","/home/runner/actions_runner/_work/ydb/arcadia_tests_data","--makefiles-dart","/home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.7zt5bz5y/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.431463956832886} 2024-11-20 16:38:50,247 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=load-graph-from-json, group=graph, time=1732120730.2473836 2024-11-20 16:38:50,247 DEBUG (core.stages_profiler) [Misc-03] Set stage load-graph-from-json_started=1732120730.2473836 2024-11-20 16:38:50,247 DEBUG (core.profiler) [Misc-03] Profile step load-graph-from-json_started - 1732120730.2473836 2024-11-20 16:38:50,247 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=load-graph-from-json, group=graph, time=1732120730.2475471 2024-11-20 16:38:50,247 DEBUG (core.stages_profiler) [Misc-02] Set stage load-graph-from-json_finished=1732120730.2475471 2024-11-20 16:38:50,247 DEBUG (core.profiler) [Misc-02] Profile step load-graph-from-json_finished - 1732120730.2475471 2024-11-20 16:38:50,247 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=gen-graph-json-default-linux-x86_64-relwithdebinfo-pic, group=graph, time=1732120730.24778 2024-11-20 16:38:50,247 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-json-default-linux-x86_64-relwithdebinfo-pic_finished=1732120730.24778 2024-11-20 16:38:50,247 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-json-default-linux-x86_64-relwithdebinfo-pic_finished - 1732120730.24778 2024-11-20 16:38:50,248 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=gen-tests-default-linux-x86_64-relwithdebinfo-pic, group=graph, time=1732120730.2480474 2024-11-20 16:38:50,248 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-tests-default-linux-x86_64-relwithdebinfo-pic_started=1732120730.2480474 2024-11-20 16:38:50,248 DEBUG (core.profiler) [Misc-02] Profile step gen-tests-default-linux-x86_64-relwithdebinfo-pic_started - 1732120730.2480474 2024-11-20 16:38:50,248 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=load-graph-from-json, group=graph, time=1732120730.2482107 2024-11-20 16:38:50,248 DEBUG (core.stages_profiler) [Misc-03] Set stage load-graph-from-json_finished=1732120730.2482107 2024-11-20 16:38:50,248 DEBUG (core.profiler) [Misc-03] Profile step load-graph-from-json_finished - 1732120730.2482107 2024-11-20 16:38:50,248 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=gen-graph-json-default-linux-x86_64-relwithdebinfo-nopic, group=graph, time=1732120730.24845 2024-11-20 16:38:50,248 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-json-default-linux-x86_64-relwithdebinfo-nopic_finished=1732120730.24845 2024-11-20 16:38:50,248 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-json-default-linux-x86_64-relwithdebinfo-nopic_finished - 1732120730.24845 2024-11-20 16:38:50,248 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=gen-tests-default-linux-x86_64-relwithdebinfo-nopic, group=graph, time=1732120730.2486887 2024-11-20 16:38:50,248 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-tests-default-linux-x86_64-relwithdebinfo-nopic_started=1732120730.2486887 2024-11-20 16:38:50,248 DEBUG (core.profiler) [Misc-03] Profile step gen-tests-default-linux-x86_64-relwithdebinfo-nopic_started - 1732120730.2486887 2024-11-20 16:38:50,252 DEBUG (build.graph) [Misc-02] Found 0 tests 2024-11-20 16:38:50,252 DEBUG (exts.timer) [Misc-02] Timer gen_tests, stage generate tests: 0.00025582313537597656 2024-11-20 16:38:50,253 DEBUG (build.graph) [Misc-03] Found 0 tests 2024-11-20 16:38:50,253 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=gen-tests-default-linux-x86_64-relwithdebinfo-pic, group=graph, time=1732120730.25307 2024-11-20 16:38:50,253 DEBUG (exts.timer) [Misc-03] Timer gen_tests, stage generate tests: 0.00018072128295898438 2024-11-20 16:38:50,253 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-tests-default-linux-x86_64-relwithdebinfo-pic_finished=1732120730.25307 2024-11-20 16:38:50,253 DEBUG (core.profiler) [Misc-02] Profile step gen-tests-default-linux-x86_64-relwithdebinfo-pic_finished - 1732120730.25307 2024-11-20 16:38:50,253 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=gen-tests-default-linux-x86_64-relwithdebinfo-nopic, group=graph, time=1732120730.2533183 2024-11-20 16:38:50,253 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-tests-default-linux-x86_64-relwithdebinfo-nopic_finished=1732120730.2533183 2024-11-20 16:38:50,253 DEBUG (core.profiler) [Misc-03] Profile step gen-tests-default-linux-x86_64-relwithdebinfo-nopic_finished - 1732120730.2533183 2024-11-20 16:38:50,253 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=gen-graph-default-linux-x86_64-relwithdebinfo-pic, group=graph, time=1732120730.2537222 2024-11-20 16:38:50,253 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-default-linux-x86_64-relwithdebinfo-pic_finished=1732120730.2537222 2024-11-20 16:38:50,253 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-default-linux-x86_64-relwithdebinfo-pic_finished - 1732120730.2537222 2024-11-20 16:38:50,254 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=gen-graph-default-linux-x86_64-relwithdebinfo-nopic, group=graph, time=1732120730.2541256 2024-11-20 16:38:50,254 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-default-linux-x86_64-relwithdebinfo-nopic_finished=1732120730.2541256 2024-11-20 16:38:50,254 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-default-linux-x86_64-relwithdebinfo-nopic_finished - 1732120730.2541256 2024-11-20 16:38:50,254 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage waiting_graphs for default-linux-x86_64-relwithdebinfo: 0.0257720947265625 2024-11-20 16:38:50,254 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=wait-target-graphs-1, group=graph, time=1732120730.2545817 2024-11-20 16:38:50,254 DEBUG (core.stages_profiler) [MainThread] Set stage wait-target-graphs-1_finished=1732120730.2545817 2024-11-20 16:38:50,254 DEBUG (core.profiler) [MainThread] Profile step wait-target-graphs-1_finished - 1732120730.2545817 2024-11-20 16:38:50,254 DEBUG (core.stage_tracer) [MainThread] Start stage tag=union-make-files-1, group=graph, time=1732120730.2548258 2024-11-20 16:38:50,254 DEBUG (core.stages_profiler) [MainThread] Set stage union-make-files-1_started=1732120730.2548258 2024-11-20 16:38:50,254 DEBUG (core.profiler) [MainThread] Profile step union-make-files-1_started - 1732120730.2548258 2024-11-20 16:38:50,254 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage union make files for default-linux-x86_64-relwithdebinfo: 0.0004901885986328125 2024-11-20 16:38:50,255 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=union-make-files-1, group=graph, time=1732120730.255017 2024-11-20 16:38:50,255 DEBUG (core.stages_profiler) [MainThread] Set stage union-make-files-1_finished=1732120730.255017 2024-11-20 16:38:50,255 DEBUG (core.profiler) [MainThread] Profile step union-make-files-1_finished - 1732120730.255017 2024-11-20 16:38:50,255 DEBUG (core.stage_tracer) [MainThread] Start stage tag=merge-graphs-1, group=graph, time=1732120730.2551486 2024-11-20 16:38:50,255 DEBUG (core.stages_profiler) [MainThread] Set stage merge-graphs-1_started=1732120730.2551486 2024-11-20 16:38:50,255 DEBUG (core.profiler) [MainThread] Profile step merge-graphs-1_started - 1732120730.2551486 2024-11-20 16:38:50,255 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage merge_graphs for default-linux-x86_64-relwithdebinfo: 0.00033545494079589844 2024-11-20 16:38:50,255 DEBUG (build.graph) [MainThread] Graph size is 26 after merge_graphs 2024-11-20 16:38:50,255 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=merge-graphs-1, group=graph, time=1732120730.255381 2024-11-20 16:38:50,255 DEBUG (core.stages_profiler) [MainThread] Set stage merge-graphs-1_finished=1732120730.255381 2024-11-20 16:38:50,255 DEBUG (core.profiler) [MainThread] Profile step merge-graphs-1_finished - 1732120730.255381 2024-11-20 16:38:50,255 DEBUG (core.stage_tracer) [MainThread] Start stage tag=strip-graph-1, group=graph, time=1732120730.2555215 2024-11-20 16:38:50,255 DEBUG (core.stages_profiler) [MainThread] Set stage strip-graph-1_started=1732120730.2555215 2024-11-20 16:38:50,255 DEBUG (core.profiler) [MainThread] Profile step strip-graph-1_started - 1732120730.2555215 2024-11-20 16:38:50,255 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage strip_graph for default-linux-x86_64-relwithdebinfo: 0.00034546852111816406 2024-11-20 16:38:50,255 DEBUG (build.graph) [MainThread] Graph size is 13 after strip_graph 2024-11-20 16:38:50,255 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=strip-graph-1, group=graph, time=1732120730.255718 2024-11-20 16:38:50,255 DEBUG (core.stages_profiler) [MainThread] Set stage strip-graph-1_finished=1732120730.255718 2024-11-20 16:38:50,255 DEBUG (core.profiler) [MainThread] Profile step strip-graph-1_finished - 1732120730.255718 2024-11-20 16:38:50,255 DEBUG (build.graph) [MainThread] Configuring only non-PIC for test_tool_tc1-global 2024-11-20 16:38:50,256 DEBUG (core.stage_tracer) [Misc-04] Start stage tag=gen-graph-test_tool_tc1-nopic-global, group=graph, time=1732120730.2562306 2024-11-20 16:38:50,256 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-test_tool_tc1-nopic-global_started=1732120730.2562306 2024-11-20 16:38:50,256 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-test_tool_tc1-nopic-global_started - 1732120730.2562306 2024-11-20 16:38:50,256 DEBUG (core.stage_tracer) [Misc-04] Start stage tag=gen-graph-gen-opts-test_tool_tc1-nopic-global, group=graph, time=1732120730.2566404 2024-11-20 16:38:50,256 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-gen-opts-test_tool_tc1-nopic-global_started=1732120730.2566404 2024-11-20 16:38:50,256 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-gen-opts-test_tool_tc1-nopic-global_started - 1732120730.2566404 2024-11-20 16:38:50,256 DEBUG (yalibrary.guards) [Misc-04] Enter guard fetch with value None 2024-11-20 16:38:50,271 DEBUG (build.genconf) [Misc-04] Generating conf into /home/runner/.ya/build/conf/dist-relwithdebinfo-c0348968119373774c0780f660d06e8f/ymake.conf with cmd ['/home/runner/.ya/tools/38e015ab6e_d/ya-bin', '/home/runner/actions_runner/_work/ydb/ydb/build/ymake_conf.py', '/home/runner/actions_runner/_work/ydb/ydb', 'dist-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-20 16:38:50,388 DEBUG (build.genconf) [Misc-04] Copy conf /home/runner/.ya/build/conf/dist-relwithdebinfo-c0348968119373774c0780f660d06e8f/ymake.conf to /home/runner/.ya/build/conf/dist-relwithdebinfo-x-6e95ef52940bd0954316c8e7cca867ae/ymake.conf 2024-11-20 16:38:50,388 DEBUG (yalibrary.guards) [Misc-04] Exit guard fetch with value None 2024-11-20 16:38:50,388 DEBUG (core.stage_tracer) [Misc-04] Finish stage tag=gen-graph-gen-opts-test_tool_tc1-nopic-global, group=graph, time=1732120730.3887985 2024-11-20 16:38:50,388 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-gen-opts-test_tool_tc1-nopic-global_finished=1732120730.3887985 2024-11-20 16:38:50,388 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-gen-opts-test_tool_tc1-nopic-global_finished - 1732120730.3887985 2024-11-20 16:38:50,388 DEBUG (core.stage_tracer) [Misc-04] Start stage tag=gen-graph-json-test_tool_tc1-nopic-global, group=graph, time=1732120730.388982 2024-11-20 16:38:50,389 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-json-test_tool_tc1-nopic-global_started=1732120730.388982 2024-11-20 16:38:50,389 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-json-test_tool_tc1-nopic-global_started - 1732120730.388982 2024-11-20 16:38:50,389 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-6e95ef52940bd0954316c8e7cca867ae_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-6e95ef52940bd0954316c8e7cca867ae/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 0x7fb88e05f420>, 'enabled_events': 'PSLGE', 'no_caches_on_retry': False, 'no_ymake_retry': False, 'disable_customization': 0, 'dump_tests': '/home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.q_ku38bn/test.dart', 'dump_make_files': '/home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.q_ku38bn/makefiles.dart'} 2024-11-20 16:38:50,389 DEBUG (core.yarg.behaviour) [Misc-04] Found unused args ['grab_stderr'] 2024-11-20 16:38:50,389 DEBUG (build.prefetch) [Misc-04] prefetch disabled 2024-11-20 16:38:50,389 DEBUG (core.event_handling.base_subscriber) [Misc-04] Subscribing PrintProgressSubscriber to event_queue 2024-11-20 16:38:50,389 DEBUG (yalibrary.tools) [Misc-04] Using old-style toolchain for: ymake 2024-11-20 16:38:50,389 DEBUG (build.ymake2.run_ymake) [Misc-04] run: '/home/runner/.ya/tools/v4/7448917907/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732120729.2956.vtimd2l6/yatmp37cb31wr --config /home/runner/.ya/build/conf/dist-relwithdebinfo-x-6e95ef52940bd0954316c8e7cca867ae/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-6e95ef52940bd0954316c8e7cca867ae_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.q_ku38bn/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.q_ku38bn/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-20 16:38:50,752 DEBUG (build.ymake2.run_ymake) [Misc-04] run '/home/runner/.ya/tools/v4/7448917907/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732120729.2956.vtimd2l6/yatmp37cb31wr --config /home/runner/.ya/build/conf/dist-relwithdebinfo-x-6e95ef52940bd0954316c8e7cca867ae/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-6e95ef52940bd0954316c8e7cca867ae_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.q_ku38bn/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.q_ku38bn/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-20 16:38:50,753 DEBUG (core.event_handling.base_subscriber) [Misc-04] Unsubscribing PrintProgressSubscriber from event_queue 2024-11-20 16:38:50,753 DEBUG (build.ymake2) [Misc-04] ymake_run_info: {"ymake_run_uid":2,"stats":{"preparing":{"start":1732120730.389354228973389,"finish":1732120730.389906883239746,"duration":0.000552654266357},"execution":{"start":1732120730.389907360076904,"finish":1732120730.752953290939331,"duration":0.363045930862427},"postprocessing":{"start":1732120730.752956390380859,"finish":1732120730.753281354904175,"duration":0.000324964523315}},"purpose":"test_tool_tc1-nopic-global","caches":{},"stages":{},"metrics":{},"binary":"/home/runner/.ya/tools/v4/7448917907/ymake","args":["/home/runner/.ya/tools/v4/7448917907/ymake","--depends-like-recurse","--warn","dirloops,ChkPeers","--write-meta-data","/home/runner/.ya/tmp/1732120729.2956.vtimd2l6/yatmp37cb31wr","--config","/home/runner/.ya/build/conf/dist-relwithdebinfo-x-6e95ef52940bd0954316c8e7cca867ae/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-6e95ef52940bd0954316c8e7cca867ae_d357a1f7839b099012272bcb9853ec19","--test-dart","/home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.q_ku38bn/test.dart","--tests-data-root","/home/runner/actions_runner/_work/ydb/arcadia_tests_data","--makefiles-dart","/home/runner/.ya/tmp/1732120729.2956.vtimd2l6/gen_graph.q_ku38bn/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.363045930862427} 2024-11-20 16:38:50,753 DEBUG (core.stage_tracer) [Misc-04] Start stage tag=load-graph-from-json, group=graph, time=1732120730.7536552 2024-11-20 16:38:50,753 DEBUG (core.stages_profiler) [Misc-04] Set stage load-graph-from-json_started=1732120730.7536552 2024-11-20 16:38:50,753 DEBUG (core.profiler) [Misc-04] Profile step load-graph-from-json_started - 1732120730.7536552 2024-11-20 16:38:50,753 DEBUG (core.stage_tracer) [Misc-04] Finish stage tag=load-graph-from-json, group=graph, time=1732120730.7538948 2024-11-20 16:38:50,753 DEBUG (core.stages_profiler) [Misc-04] Set stage load-graph-from-json_finished=1732120730.7538948 2024-11-20 16:38:50,754 DEBUG (core.profiler) [Misc-04] Profile step load-graph-from-json_finished - 1732120730.7538948 2024-11-20 16:38:50,754 DEBUG (core.stage_tracer) [Misc-04] Finish stage tag=gen-graph-json-test_tool_tc1-nopic-global, group=graph, time=1732120730.7541132 2024-11-20 16:38:50,754 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-json-test_tool_tc1-nopic-global_finished=1732120730.7541132 2024-11-20 16:38:50,754 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-json-test_tool_tc1-nopic-global_finished - 1732120730.7541132 2024-11-20 16:38:50,754 DEBUG (core.stage_tracer) [Misc-04] Finish stage tag=gen-graph-test_tool_tc1-nopic-global, group=graph, time=1732120730.754373 2024-11-20 16:38:50,754 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-test_tool_tc1-nopic-global_finished=1732120730.754373 2024-11-20 16:38:50,754 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-test_tool_tc1-nopic-global_finished - 1732120730.754373 2024-11-20 16:38:50,754 DEBUG (core.stage_tracer) [MainThread] Start stage tag=get-graph-1, group=graph, time=1732120730.7549355 2024-11-20 16:38:50,755 DEBUG (core.stages_profiler) [MainThread] Set stage get-graph-1_started=1732120730.7549355 2024-11-20 16:38:50,755 DEBUG (core.profiler) [MainThread] Profile step get-graph-1_started - 1732120730.7549355 2024-11-20 16:38:50,756 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=get-graph-1, group=graph, time=1732120730.7566645 2024-11-20 16:38:50,756 DEBUG (core.stages_profiler) [MainThread] Set stage get-graph-1_finished=1732120730.7566645 2024-11-20 16:38:50,756 DEBUG (core.profiler) [MainThread] Profile step get-graph-1_finished - 1732120730.7566645 2024-11-20 16:38:50,756 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=merge-target-graphs-1, group=graph, time=1732120730.7568722 2024-11-20 16:38:50,756 DEBUG (core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_finished=1732120730.7568722 2024-11-20 16:38:50,756 DEBUG (core.profiler) [MainThread] Profile step merge-target-graphs-1_finished - 1732120730.7568722 2024-11-20 16:38:50,757 DEBUG (core.stage_tracer) [MainThread] Start stage tag=build-merged-graph, group=graph, time=1732120730.7570276 2024-11-20 16:38:50,757 DEBUG (core.stages_profiler) [MainThread] Set stage build-merged-graph_started=1732120730.7570276 2024-11-20 16:38:50,757 DEBUG (core.profiler) [MainThread] Profile step build-merged-graph_started - 1732120730.7570276 2024-11-20 16:38:50,757 DEBUG (core.stage_tracer) [MainThread] Start stage tag=insert-tests-1, group=graph, time=1732120730.7577305 2024-11-20 16:38:50,757 DEBUG (core.stages_profiler) [MainThread] Set stage insert-tests-1_started=1732120730.7577305 2024-11-20 16:38:50,757 DEBUG (core.profiler) [MainThread] Profile step insert-tests-1_started - 1732120730.7577305 2024-11-20 16:38:50,757 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'unsupported cross-compiled tests' on 0 suites 2024-11-20 16:38:50,758 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter '. at 0x7fb88e11a020>' on 0 suites 2024-11-20 16:38:50,758 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'size' on 0 suites 2024-11-20 16:38:50,758 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'class type' on 0 suites 2024-11-20 16:38:50,758 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'suite type' on 0 suites 2024-11-20 16:38:50,758 DEBUG (devtools.ya.test.filter) [MainThread] Tags filter include set:[] exclude set:[] 2024-11-20 16:38:50,758 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'tags' on 0 suites 2024-11-20 16:38:50,758 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'project path' on 0 suites 2024-11-20 16:38:50,758 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'filename filter' on 0 suites 2024-11-20 16:38:50,758 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'chunk filter' on 0 suites 2024-11-20 16:38:50,758 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'name' on 0 suites 2024-11-20 16:38:50,758 DEBUG (build.graph) [MainThread] Generating build plan 2024-11-20 16:38:50,758 DEBUG (build.graph) [MainThread] Preparing test suites 2024-11-20 16:38:50,758 DEBUG (build.graph) [MainThread] Stripping clang-tidy irrelevant deps 2024-11-20 16:38:50,758 DEBUG (exts.timer) [MainThread] Timer inject_tests, stage inject tests for default-linux-x86_64-relwithdebinfo: 0.0009827613830566406 2024-11-20 16:38:50,758 DEBUG (build.graph) [MainThread] injected 0 tests for default-linux-x86_64-relwithdebinfo 2024-11-20 16:38:50,758 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=insert-tests-1, group=graph, time=1732120730.75897 2024-11-20 16:38:50,759 DEBUG (core.stages_profiler) [MainThread] Set stage insert-tests-1_finished=1732120730.75897 2024-11-20 16:38:50,759 DEBUG (core.profiler) [MainThread] Profile step insert-tests-1_finished - 1732120730.75897 2024-11-20 16:38:50,759 DEBUG (core.stage_tracer) [MainThread] Start stage tag=merge-target-graphs-1, group=graph, time=1732120730.7591283 2024-11-20 16:38:50,759 DEBUG (core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_started=1732120730.7591283 2024-11-20 16:38:50,759 DEBUG (core.profiler) [MainThread] Profile step merge-target-graphs-1_started - 1732120730.7591283 2024-11-20 16:38:50,759 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=merge-target-graphs-1, group=graph, time=1732120730.75925 2024-11-20 16:38:50,759 DEBUG (core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_finished=1732120730.75925 2024-11-20 16:38:50,759 DEBUG (core.profiler) [MainThread] Profile step merge-target-graphs-1_finished - 1732120730.75925 2024-11-20 16:38:50,759 DEBUG (core.config) [MainThread] Read config "build/platform/python/ymake_python2/resources.json" from resource 2024-11-20 16:38:50,759 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] python: will use 'linux-x86_64' platform 2024-11-20 16:38:50,759 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/gdb/resources.json 2024-11-20 16:38:50,760 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] gdb: will use 'linux-x86_64' platform 2024-11-20 16:38:50,760 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=build-merged-graph, group=graph, time=1732120730.7600942 2024-11-20 16:38:50,760 DEBUG (core.stages_profiler) [MainThread] Set stage build-merged-graph_finished=1732120730.7600942 2024-11-20 16:38:50,760 DEBUG (core.profiler) [MainThread] Profile step build-merged-graph_finished - 1732120730.7600942 2024-11-20 16:38:50,760 DEBUG (core.stage_tracer) [MainThread] Start stage tag=iter-extra-resources, group=graph, time=1732120730.760238 2024-11-20 16:38:50,760 DEBUG (core.stages_profiler) [MainThread] Set stage iter-extra-resources_started=1732120730.760238 2024-11-20 16:38:50,760 DEBUG (core.profiler) [MainThread] Profile step iter-extra-resources_started - 1732120730.760238 2024-11-20 16:38:50,760 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=iter-extra-resources, group=graph, time=1732120730.7604237 2024-11-20 16:38:50,760 DEBUG (core.stages_profiler) [MainThread] Set stage iter-extra-resources_finished=1732120730.7604237 2024-11-20 16:38:50,760 DEBUG (core.profiler) [MainThread] Profile step iter-extra-resources_finished - 1732120730.7604237 2024-11-20 16:38:50,760 DEBUG (exts.timer) [MainThread] Timer build.graph, stage build and merge graphs: 1.1119153499603271 2024-11-20 16:38:50,760 DEBUG (core.stage_tracer) [MainThread] Start stage tag=strip-graph, group=graph, time=1732120730.7606025 2024-11-20 16:38:50,760 DEBUG (core.stages_profiler) [MainThread] Set stage strip-graph_started=1732120730.7606025 2024-11-20 16:38:50,760 DEBUG (core.profiler) [MainThread] Profile step strip-graph_started - 1732120730.7606025 2024-11-20 16:38:50,760 DEBUG (build.graph) [MainThread] stripped 0, left 13 nodes 2024-11-20 16:38:50,760 DEBUG (exts.timer) [MainThread] Timer build.graph, stage strip graph: 0.00022482872009277344 2024-11-20 16:38:50,760 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=strip-graph, group=graph, time=1732120730.76082 2024-11-20 16:38:50,760 DEBUG (core.stages_profiler) [MainThread] Set stage strip-graph_finished=1732120730.76082 2024-11-20 16:38:50,760 DEBUG (core.profiler) [MainThread] Profile step strip-graph_finished - 1732120730.76082 2024-11-20 16:38:50,760 DEBUG (exts.timer) [MainThread] Timer build.graph, stage gen rename nodes: 0.0001888275146484375 2024-11-20 16:38:50,761 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] python: will use 'linux-x86_64' platform 2024-11-20 16:38:50,761 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ymake: will use 'linux' platform 2024-11-20 16:38:50,761 DEBUG (core.stage_tracer) [MainThread] Start stage tag=inject_default_requirements, group=graph, time=1732120730.7612453 2024-11-20 16:38:50,761 DEBUG (core.stages_profiler) [MainThread] Set stage inject_default_requirements_started=1732120730.7612453 2024-11-20 16:38:50,761 DEBUG (core.profiler) [MainThread] Profile step inject_default_requirements_started - 1732120730.7612453 2024-11-20 16:38:50,761 DEBUG (build.graph) [MainThread] Updated requirements for 0 nodes 2024-11-20 16:38:50,761 DEBUG (exts.timer) [MainThread] Timer substitude_uids, stage substitude_uids: 1.2636184692382812e-05 2024-11-20 16:38:50,761 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=inject_default_requirements, group=graph, time=1732120730.7614985 2024-11-20 16:38:50,761 DEBUG (core.stages_profiler) [MainThread] Set stage inject_default_requirements_finished=1732120730.7614985 2024-11-20 16:38:50,761 DEBUG (core.profiler) [MainThread] Profile step inject_default_requirements_finished - 1732120730.7614985 2024-11-20 16:38:50,761 DEBUG (exts.timer) [MainThread] Timer build.graph, stage misc graph changes: 0.0006842613220214844 2024-11-20 16:38:50,761 DEBUG (core.stage_tracer) [MainThread] Start stage tag=finalize-graph, group=graph, time=1732120730.7616973 2024-11-20 16:38:50,761 DEBUG (core.stages_profiler) [MainThread] Set stage finalize-graph_started=1732120730.7616973 2024-11-20 16:38:50,761 DEBUG (core.profiler) [MainThread] Profile step finalize-graph_started - 1732120730.7616973 2024-11-20 16:38:50,761 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=finalize-graph, group=graph, time=1732120730.7618055 2024-11-20 16:38:50,761 DEBUG (core.stages_profiler) [MainThread] Set stage finalize-graph_finished=1732120730.7618055 2024-11-20 16:38:50,761 DEBUG (core.profiler) [MainThread] Profile step finalize-graph_finished - 1732120730.7618055 2024-11-20 16:38:50,761 DEBUG (core.stage_tracer) [MainThread] Start stage tag=imprint-store-and-stats, group=graph, time=1732120730.761925 2024-11-20 16:38:50,761 DEBUG (core.stages_profiler) [MainThread] Set stage imprint-store-and-stats_started=1732120730.761925 2024-11-20 16:38:50,762 DEBUG (core.profiler) [MainThread] Profile step imprint-store-and-stats_started - 1732120730.761925 2024-11-20 16:38:50,762 DEBUG (core.imprint.imprint:Imprint) [MainThread] 2024-11-20 16:38:50,762 DEBUG (core.imprint.imprint:Imprint) [MainThread] 2024-11-20 16:38:50,762 DEBUG (core.imprint.imprint:Imprint) [MainThread] 2024-11-20 16:38:50,762 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=imprint-store-and-stats, group=graph, time=1732120730.7622054 2024-11-20 16:38:50,762 DEBUG (core.stages_profiler) [MainThread] Set stage imprint-store-and-stats_finished=1732120730.7622054 2024-11-20 16:38:50,762 DEBUG (core.profiler) [MainThread] Profile step imprint-store-and-stats_finished - 1732120730.7622054 2024-11-20 16:38:50,762 DEBUG (core.stage_tracer) [MainThread] Start stage tag=inject_stats_and_static_uids, group=graph, time=1732120730.7623315 2024-11-20 16:38:50,762 DEBUG (core.stages_profiler) [MainThread] Set stage inject_stats_and_static_uids_started=1732120730.7623315 2024-11-20 16:38:50,762 DEBUG (core.profiler) [MainThread] Profile step inject_stats_and_static_uids_started - 1732120730.7623315 2024-11-20 16:38:50,762 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=inject_stats_and_static_uids, group=graph, time=1732120730.7626054 2024-11-20 16:38:50,762 DEBUG (core.stages_profiler) [MainThread] Set stage inject_stats_and_static_uids_finished=1732120730.7626054 2024-11-20 16:38:50,762 DEBUG (core.profiler) [MainThread] Profile step inject_stats_and_static_uids_finished - 1732120730.7626054 2024-11-20 16:38:50,762 DEBUG (core.stage_tracer) [MainThread] Start stage tag=strip-tags, group=graph, time=1732120730.7627404 2024-11-20 16:38:50,762 DEBUG (core.stages_profiler) [MainThread] Set stage strip-tags_started=1732120730.7627404 2024-11-20 16:38:50,762 DEBUG (core.profiler) [MainThread] Profile step strip-tags_started - 1732120730.7627404 2024-11-20 16:38:50,762 DEBUG (exts.timer) [MainThread] Timer build.graph, stage strip tags: 0.0012230873107910156 2024-11-20 16:38:50,762 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=strip-tags, group=graph, time=1732120730.7629185 2024-11-20 16:38:50,762 DEBUG (core.stages_profiler) [MainThread] Set stage strip-tags_finished=1732120730.7629185 2024-11-20 16:38:50,763 DEBUG (core.profiler) [MainThread] Profile step strip-tags_finished - 1732120730.7629185 2024-11-20 16:38:50,763 DEBUG (core.stage_tracer) [MainThread] Start stage tag=reduce_graph_resources, group=graph, time=1732120730.7631245 2024-11-20 16:38:50,763 DEBUG (core.stages_profiler) [MainThread] Set stage reduce_graph_resources_started=1732120730.7631245 2024-11-20 16:38:50,763 DEBUG (core.profiler) [MainThread] Profile step reduce_graph_resources_started - 1732120730.7631245 2024-11-20 16:38:50,763 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=reduce_graph_resources, group=graph, time=1732120730.7634008 2024-11-20 16:38:50,763 DEBUG (core.stages_profiler) [MainThread] Set stage reduce_graph_resources_finished=1732120730.7634008 2024-11-20 16:38:50,763 DEBUG (core.profiler) [MainThread] Profile step reduce_graph_resources_finished - 1732120730.7634008 2024-11-20 16:38:50,763 DEBUG (core.stage_tracer) [MainThread] Start stage tag=clean-intern-string-storage, group=graph, time=1732120730.763538 2024-11-20 16:38:50,763 DEBUG (core.stages_profiler) [MainThread] Set stage clean-intern-string-storage_started=1732120730.763538 2024-11-20 16:38:50,763 DEBUG (core.profiler) [MainThread] Profile step clean-intern-string-storage_started - 1732120730.763538 2024-11-20 16:38:50,763 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=clean-intern-string-storage, group=graph, time=1732120730.7637064 2024-11-20 16:38:50,763 DEBUG (core.stages_profiler) [MainThread] Set stage clean-intern-string-storage_finished=1732120730.7637064 2024-11-20 16:38:50,763 DEBUG (core.profiler) [MainThread] Profile step clean-intern-string-storage_finished - 1732120730.7637064 2024-11-20 16:38:50,763 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=build_graph_and_tests, group=graph, time=1732120730.7638333 2024-11-20 16:38:50,763 DEBUG (core.stages_profiler) [MainThread] Set stage build_graph_and_tests_finished=1732120730.7638333 2024-11-20 16:38:50,763 DEBUG (core.profiler) [MainThread] Profile step build_graph_and_tests_finished - 1732120730.7638333 2024-11-20 16:38:50,764 DEBUG (exts.timer) [MainThread] Timer context_creation, stage graph_and_tests finished: 1.1460325717926025 2024-11-20 16:38:50,765 DEBUG (core.stage_tracer) [MainThread] Start stage tag=configure-dist-store-cache, group=ya_make, time=1732120730.7654662 2024-11-20 16:38:50,765 DEBUG (core.stages_profiler) [MainThread] Set stage configure-dist-store-cache_started=1732120730.7654662 2024-11-20 16:38:50,765 DEBUG (core.profiler) [MainThread] Profile step configure-dist-store-cache_started - 1732120730.7654662 2024-11-20 16:38:50,765 DEBUG (build.ya_make) [MainThread] Waiting for dist cache setup 2024-11-20 16:38:50,765 DEBUG (build.ya_make) [MainThread] Loading meta from dist cache 2024-11-20 16:38:50,765 DEBUG (build.ya_make) [MainThread] Dist cache prepared 2024-11-20 16:38:50,765 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=configure-dist-store-cache, group=ya_make, time=1732120730.7657316 2024-11-20 16:38:50,765 DEBUG (core.stages_profiler) [MainThread] Set stage configure-dist-store-cache_finished=1732120730.7657316 2024-11-20 16:38:50,765 DEBUG (core.profiler) [MainThread] Profile step configure-dist-store-cache_finished - 1732120730.7657316 2024-11-20 16:38:50,765 DEBUG (core.stage_tracer) [MainThread] Start stage tag=configure-local-cache, group=ya_make, time=1732120730.7658656 2024-11-20 16:38:50,765 DEBUG (core.stages_profiler) [MainThread] Set stage configure-local-cache_started=1732120730.7658656 2024-11-20 16:38:50,765 DEBUG (core.profiler) [MainThread] Profile step configure-local-cache_started - 1732120730.7658656 2024-11-20 16:38:50,766 DEBUG (build.ya_make) [MainThread] content UIDs forced 2024-11-20 16:38:50,766 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=configure-local-cache, group=ya_make, time=1732120730.7660894 2024-11-20 16:38:50,766 DEBUG (core.stages_profiler) [MainThread] Set stage configure-local-cache_finished=1732120730.7660894 2024-11-20 16:38:50,766 DEBUG (core.profiler) [MainThread] Profile step configure-local-cache_finished - 1732120730.7660894 2024-11-20 16:38:50,766 DEBUG (build.ya_make) [MainThread] sandbox_run_test_uids: set() 2024-11-20 16:38:50,767 DEBUG (urllib3.connectionpool) [Misc-05] Starting new HTTP connection (1): cachesrv.internal:8081 2024-11-20 16:38:50,769 DEBUG (urllib3.connectionpool) [Misc-06] Starting new HTTP connection (2): cachesrv.internal:8081 2024-11-20 16:38:50,769 DEBUG (urllib3.connectionpool) [Misc-07] Starting new HTTP connection (3): cachesrv.internal:8081 2024-11-20 16:38:50,770 DEBUG (urllib3.connectionpool) [Misc-08] Starting new HTTP connection (4): cachesrv.internal:8081 2024-11-20 16:38:50,772 DEBUG (urllib3.connectionpool) [Misc-09] Starting new HTTP connection (5): cachesrv.internal:8081 2024-11-20 16:38:50,773 DEBUG (urllib3.connectionpool) [Misc-10] Starting new HTTP connection (6): cachesrv.internal:8081 2024-11-20 16:38:50,774 DEBUG (urllib3.connectionpool) [Misc-06] http://cachesrv.internal:8081 "HEAD /ac/68384d6d49524269427070785357365475666235595100000000000000000001 HTTP/1.1" 200 0 2024-11-20 16:38:50,774 DEBUG (urllib3.connectionpool) [Misc-07] http://cachesrv.internal:8081 "HEAD /ac/614b7a47786c7957616a79696f374a545a387a63667700000000000000000001 HTTP/1.1" 200 0 2024-11-20 16:38:50,774 DEBUG (urllib3.connectionpool) [Misc-05] http://cachesrv.internal:8081 "HEAD /ac/2d7054776e4e484c37653736515a4c697071546a367700000000000000000001 HTTP/1.1" 200 0 2024-11-20 16:38:50,775 DEBUG (urllib3.connectionpool) [Misc-11] Starting new HTTP connection (7): cachesrv.internal:8081 2024-11-20 16:38:50,775 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-06] Bazel-remote Probing h8MmIRBiBppxSW6Tufb5YQ => True 2024-11-20 16:38:50,776 DEBUG (urllib3.connectionpool) [Misc-08] http://cachesrv.internal:8081 "HEAD /ac/48445f4470507531367a33734778683249317966696700000000000000000001 HTTP/1.1" 200 0 2024-11-20 16:38:50,777 DEBUG (urllib3.connectionpool) [Misc-09] http://cachesrv.internal:8081 "HEAD /ac/63323767355f484e662d736a48375539504f2d68564100000000000000000001 HTTP/1.1" 200 0 2024-11-20 16:38:50,777 DEBUG (urllib3.connectionpool) [Misc-10] http://cachesrv.internal:8081 "HEAD /ac/76635462767a6f63317935666f6e6e4852477457516700000000000000000001 HTTP/1.1" 200 0 2024-11-20 16:38:50,778 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-07] Bazel-remote Probing aKzGxlyWajyio7JTZ8zcfw => True 2024-11-20 16:38:50,778 DEBUG (urllib3.connectionpool) [Misc-12] http://cachesrv.internal:8081 "HEAD /ac/3276756f474b7870594b6669394839354b3435374d4100000000000000000001 HTTP/1.1" 200 0 2024-11-20 16:38:50,779 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-05] Bazel-remote Probing -pTwnNHL7e76QZLipqTj6w => True 2024-11-20 16:38:50,781 DEBUG (urllib3.connectionpool) [Misc-15] Starting new HTTP connection (8): cachesrv.internal:8081 2024-11-20 16:38:50,781 DEBUG (urllib3.connectionpool) [Misc-13] http://cachesrv.internal:8081 "HEAD /ac/546d653532436235454d345f77724b70736e38464c5100000000000000000001 HTTP/1.1" 200 0 2024-11-20 16:38:50,782 DEBUG (urllib3.connectionpool) [Misc-16] Starting new HTTP connection (9): cachesrv.internal:8081 2024-11-20 16:38:50,782 DEBUG (urllib3.connectionpool) [Misc-14] http://cachesrv.internal:8081 "HEAD /ac/5f635a54705579642d544f797841536a69383439437700000000000000000001 HTTP/1.1" 200 0 2024-11-20 16:38:50,783 DEBUG (urllib3.connectionpool) [Misc-17] Starting new HTTP connection (10): cachesrv.internal:8081 2024-11-20 16:38:50,783 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-08] Bazel-remote Probing HD_DpPu16z3sGxh2I1yfig => True 2024-11-20 16:38:50,784 DEBUG (urllib3.connectionpool) [Misc-11] http://cachesrv.internal:8081 "HEAD /ac/4e54347458416470685f63324c5f4145576f49476c5100000000000000000001 HTTP/1.1" 200 0 2024-11-20 16:38:50,784 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-09] Bazel-remote Probing c27g5_HNf-sjH7U9PO-hVA => True 2024-11-20 16:38:50,784 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-10] Bazel-remote Probing vcTbvzoc1y5fonnHRGtWQg => True 2024-11-20 16:38:50,785 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-12] Bazel-remote Probing 2vuoGKxpYKfi9H95K457MA => True 2024-11-20 16:38:50,785 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-13] Bazel-remote Probing Tme52Cb5EM4_wrKpsn8FLQ => True 2024-11-20 16:38:50,786 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-14] Bazel-remote Probing _cZTpUyd-TOyxASji849Cw => True 2024-11-20 16:38:50,787 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-11] Bazel-remote Probing NT4tXAdph_c2L_AEWoIGlQ => True 2024-11-20 16:38:50,787 DEBUG (urllib3.connectionpool) [Misc-15] http://cachesrv.internal:8081 "HEAD /ac/753939734c6869385266476b79365858586a776d4d5100000000000000000001 HTTP/1.1" 200 0 2024-11-20 16:38:50,787 DEBUG (urllib3.connectionpool) [Misc-16] http://cachesrv.internal:8081 "HEAD /ac/7530774b3034394f794755317a74676d487638566a5100000000000000000001 HTTP/1.1" 200 0 2024-11-20 16:38:50,788 DEBUG (urllib3.connectionpool) [Misc-17] http://cachesrv.internal:8081 "HEAD /ac/7345326e416c376c5f5a57583738653571324b545a7700000000000000000001 HTTP/1.1" 200 0 2024-11-20 16:38:50,788 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-15] Bazel-remote Probing u99sLhi8RfGky6XXXjwmMQ => True 2024-11-20 16:38:50,789 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-16] Bazel-remote Probing u0wK049OyGU1ztgmHv8VjQ => True 2024-11-20 16:38:50,789 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-17] Bazel-remote Probing sE2nAl7l_ZWX78e5q2KTZw => True 2024-11-20 16:38:50,790 DEBUG (build.ya_make) [MainThread] Strip graph due bazel_remote_store mode 2024-11-20 16:38:50,790 DEBUG (build.graph) [MainThread] stripped 13, left 0 nodes 2024-11-20 16:38:50,793 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=context_creation, group=ya_make, time=1732120730.7937584 2024-11-20 16:38:50,793 DEBUG (core.stages_profiler) [MainThread] Set stage context_creation_finished=1732120730.7937584 2024-11-20 16:38:50,793 DEBUG (core.profiler) [MainThread] Profile step context_creation_finished - 1732120730.7937584 2024-11-20 16:38:50,794 DEBUG (exts.timer) [MainThread] Timer context_creation, stage context_creation finished: 0.029881715774536133 2024-11-20 16:38:50,794 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=context_generating, group=build_handler, time=1732120730.794196 2024-11-20 16:38:50,794 DEBUG (core.stages_profiler) [MainThread] Set stage context_generating_finished=1732120730.794196 2024-11-20 16:38:50,794 DEBUG (core.profiler) [MainThread] Profile step context_generating_finished - 1732120730.794196 2024-11-20 16:38:50,794 DEBUG (core.stage_tracer) [MainThread] Start stage tag=build, group=build_handler, time=1732120730.7943625 2024-11-20 16:38:50,794 DEBUG (core.stages_profiler) [MainThread] Set stage build_started=1732120730.7943625 2024-11-20 16:38:50,794 DEBUG (core.profiler) [MainThread] Profile step build_started - 1732120730.7943625 2024-11-20 16:38:50,794 DEBUG (build.reports.autocheck_report) [MainThread] Got 0 tests to report 2024-11-20 16:38:50,794 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2024-11-20 16:38:50,794 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2024-11-20 16:38:50,794 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2024-11-20 16:38:50,794 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2024-11-20 16:38:50,794 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2024-11-20 16:38:50,794 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2024-11-20 16:38:50,795 DEBUG (ReportGenerator) [MainThread] Finish style report 2024-11-20 16:38:50,795 DEBUG (StoredReport) [MainThread] Finish style report 2024-11-20 16:38:50,795 DEBUG (ReportGenerator) [MainThread] Finish tests report, tests by size defaultdict(, {'small': set(), 'medium': set(), 'large': set()}), tests by type defaultdict(, {}) 2024-11-20 16:38:50,795 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2024-11-20 16:38:50,795 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2024-11-20 16:38:50,795 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2024-11-20 16:38:50,795 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2024-11-20 16:38:50,795 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2024-11-20 16:38:50,796 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2024-11-20 16:38:50,796 DEBUG (StoredReport) [MainThread] Finish tests report 2024-11-20 16:38:50,796 DEBUG (ReportGenerator) [MainThread] Finish configure report 2024-11-20 16:38:50,796 DEBUG (StoredReport) [MainThread] Finish configure report 2024-11-20 16:38:50,796 DEBUG (core.stage_tracer) [MainThread] Start stage tag=cache_test_statuses, group=ya_make, time=1732120730.7961655 2024-11-20 16:38:50,796 DEBUG (core.stages_profiler) [MainThread] Set stage cache_test_statuses_started=1732120730.7961655 2024-11-20 16:38:50,796 DEBUG (core.profiler) [MainThread] Profile step cache_test_statuses_started - 1732120730.7961655 2024-11-20 16:38:50,811 DEBUG (yalibrary.store.new_store) [MainThread] Initialized store in /home/runner/.ya/build/cache/trc 2024-11-20 16:38:50,811 DEBUG (yalibrary.store.new_store) [MainThread] Started filtering 2024-11-20 16:38:50,811 DEBUG (library.python.filelock) [MainThread] Acquiring FileLock (blocking=True): /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-20 16:38:50,811 DEBUG (library.python.filelock) [MainThread] Ensuring FileLock released: /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-20 16:38:50,811 DEBUG (yalibrary.store.new_store) [MainThread] Done filtering, retain 0 uids, 0 files 2024-11-20 16:38:50,811 DEBUG (yalibrary.store.new_store) [MainThread] Cleaning size store 2024-11-20 16:38:50,811 DEBUG (yalibrary.store.new_store) [MainThread] Cleaning file store 2024-11-20 16:38:50,813 DEBUG (yalibrary.store.new_store) [MainThread] Cleaning uid store 2024-11-20 16:38:50,822 DEBUG (library.python.filelock) [MainThread] Acquiring FileLock (blocking=True): /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-20 16:38:50,822 DEBUG (library.python.filelock) [MainThread] Ensuring FileLock released: /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-20 16:38:50,823 DEBUG (library.python.filelock) [MainThread] Acquiring FileLock (blocking=True): /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-20 16:38:50,823 DEBUG (library.python.filelock) [MainThread] Ensuring FileLock released: /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-20 16:38:50,823 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=cache_test_statuses, group=ya_make, time=1732120730.82345 2024-11-20 16:38:50,823 DEBUG (core.stages_profiler) [MainThread] Set stage cache_test_statuses_finished=1732120730.82345 2024-11-20 16:38:50,823 DEBUG (core.profiler) [MainThread] Profile step cache_test_statuses_finished - 1732120730.82345 2024-11-20 16:38:50,823 DEBUG (core.stage_tracer) [MainThread] Start stage tag=finalize-reports, group=ya_make, time=1732120730.8237047 2024-11-20 16:38:50,823 DEBUG (core.stages_profiler) [MainThread] Set stage finalize-reports_started=1732120730.8237047 2024-11-20 16:38:50,823 DEBUG (core.profiler) [MainThread] Profile step finalize-reports_started - 1732120730.8237047 2024-11-20 16:38:50,823 DEBUG (build.ya_make) [MainThread] Build is finished, process results 2024-11-20 16:38:50,823 DEBUG (ReportGenerator) [MainThread] Build result is processed, add 0 entries 2024-11-20 16:38:50,823 DEBUG (ReportGenerator) [MainThread] Finish build report 2024-11-20 16:38:50,823 DEBUG (StoredReport) [MainThread] Finish build report 2024-11-20 16:38:50,824 DEBUG (ReportGenerator) [MainThread] Finish tests report, tests by size defaultdict(, {'small': set(), 'medium': set(), 'large': set()}), tests by type defaultdict(, {}) 2024-11-20 16:38:50,824 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2024-11-20 16:38:50,824 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2024-11-20 16:38:50,824 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2024-11-20 16:38:50,824 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2024-11-20 16:38:50,824 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2024-11-20 16:38:50,824 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2024-11-20 16:38:50,824 DEBUG (StoredReport) [MainThread] Finish tests report 2024-11-20 16:38:50,824 DEBUG (ReportGenerator) [MainThread] Finish style report 2024-11-20 16:38:50,824 DEBUG (StoredReport) [MainThread] Finish style report 2024-11-20 16:38:50,824 DEBUG (ReportGenerator) [MainThread] Finish report 2024-11-20 16:38:50,824 DEBUG (StoredReport) [MainThread] Finish report 2024-11-20 16:38:50,824 DEBUG (build.ya_make) [MainThread] Build results listener statistics: {} 2024-11-20 16:38:50,824 DEBUG (build.ya_make) [MainThread] Generating results report 2024-11-20 16:38:50,824 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-20 16:38:50,824 DEBUG (build.reports.autocheck_report) [MainThread] Got 0 tests to report 2024-11-20 16:38:50,824 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2024-11-20 16:38:50,824 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2024-11-20 16:38:50,824 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2024-11-20 16:38:50,824 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2024-11-20 16:38:50,825 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2024-11-20 16:38:50,825 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2024-11-20 16:38:50,825 DEBUG (ReportGenerator) [MainThread] Build result is processed, add 0 entries 2024-11-20 16:38:50,825 DEBUG (build.reports.autocheck_report) [MainThread] builder.opts.report_skipped_suites: False, builder.opts.report_skipped_suites False 2024-11-20 16:38:50,825 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-20 16:38:50,825 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=finalize-reports, group=ya_make, time=1732120730.8256452 2024-11-20 16:38:50,825 DEBUG (core.stages_profiler) [MainThread] Set stage finalize-reports_finished=1732120730.8256452 2024-11-20 16:38:50,825 DEBUG (core.profiler) [MainThread] Profile step finalize-reports_finished - 1732120730.8256452 2024-11-20 16:38:50,827 DEBUG (yalibrary.toolscache) [MainThread] AC cache attempt: (release all data) 2024-11-20 16:38:50,828 DEBUG (yalibrary.toolscache) [MainThread] AC cache (release all data) address: (2542, 18067, 'unix:/home/runner/.ya/build/cache/7/psingmKc4iN.tmp') 2024-11-20 16:38:50,829 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=build, group=build_handler, time=1732120730.8292558 2024-11-20 16:38:50,829 DEBUG (core.stages_profiler) [MainThread] Set stage build_finished=1732120730.8292558 2024-11-20 16:38:50,829 DEBUG (core.profiler) [MainThread] Profile step build_finished - 1732120730.8292558 2024-11-20 16:38:50,829 DEBUG (core.stage_tracer) [MainThread] Start stage tag=dump_results, group=build_handler, time=1732120730.8294568 2024-11-20 16:38:50,829 DEBUG (core.stages_profiler) [MainThread] Set stage dump_results_started=1732120730.8294568 2024-11-20 16:38:50,829 DEBUG (core.profiler) [MainThread] Profile step dump_results_started - 1732120730.8294568 2024-11-20 16:38:50,830 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=dump_results, group=build_handler, time=1732120730.8299823 2024-11-20 16:38:50,830 DEBUG (core.stages_profiler) [MainThread] Set stage dump_results_finished=1732120730.8299823 2024-11-20 16:38:50,830 DEBUG (core.profiler) [MainThread] Profile step dump_results_finished - 1732120730.8299823 2024-11-20 16:38:50,830 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=ya_make_handler, group=build_handler, time=1732120730.8301566 2024-11-20 16:38:50,830 DEBUG (core.stages_profiler) [MainThread] Set stage ya_make_handler_finished=1732120730.8301566 2024-11-20 16:38:50,830 DEBUG (core.profiler) [MainThread] Profile step ya_make_handler_finished - 1732120730.8301566 2024-11-20 16:38:50,830 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=invoke-do_ya_make, group=overall-execution, time=1732120730.830672 2024-11-20 16:38:50,830 DEBUG (core.stages_profiler) [MainThread] Set stage invoke-do_ya_make_finished=1732120730.830672 2024-11-20 16:38:50,830 DEBUG (core.profiler) [MainThread] Profile step invoke-do_ya_make_finished - 1732120730.830672 2024-11-20 16:38:50,831 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "dump_debug" stopped in 0.000191 2024-11-20 16:38:50,831 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "evlog" stopped in 0.000021 2024-11-20 16:38:50,831 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "changelist_store" stopped in 0.000002 2024-11-20 16:38:50,831 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "event_queue" stopped in 0.000002 2024-11-20 16:38:50,831 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "mlockall" stopped in 0.000003 2024-11-20 16:38:50,831 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "profile" stopped in 0.000003 2024-11-20 16:38:50,831 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "showstack" stopped in 0.000016 2024-11-20 16:38:50,831 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher" stopped in 0.000003 2024-11-20 16:38:50,831 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" stopped in 0.000002 2024-11-20 16:38:50,831 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token2" stopped in 0.000003 2024-11-20 16:38:50,831 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "docker_config_path" stopped in 0.000001 2024-11-20 16:38:50,831 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "use_universal_fetcher_everywhere" stopped in 0.000001 2024-11-20 16:38:50,831 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher_params" stopped in 0.000007 2024-11-20 16:38:50,831 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "self_info" stopped in 0.000001 2024-11-20 16:38:50,831 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" stopped in 0.000002 2024-11-20 16:38:50,831 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display_log" stopped in 0.000005 2024-11-20 16:38:50,831 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "custom_file_log" stopped in 0.000009 2024-11-20 16:38:50,831 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display" stopped in 0.000014 2024-11-20 16:38:50,832 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "state" stopped in 0.000005 2024-11-20 16:38:50,832 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token" stopped in 0.000002 2024-11-20 16:38:50,832 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "params" stopped in 0.000001 2024-11-20 16:38:50,832 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-20 16:38:50,832 DEBUG (library.python.tmp) [MainThread] Removing tmp dir /home/runner/.ya/tmp/1732120729.2956.vtimd2l6 2024-11-20 16:38:50,832 DEBUG (library.python.tmp) [MainThread] Reset back TMPDIR=None 2024-11-20 16:38:50,833 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "tmp_dir" stopped in 0.000584 2024-11-20 16:38:50,833 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" stopped in 0.000009 2024-11-20 16:38:50,833 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "env_checker" stopped in 0.000005 2024-11-20 16:38:50,833 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "lifecycle_ts" stopped in 0.000006 2024-11-20 16:38:50,833 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "exit" stopped in 0.000007 2024-11-20 16:38:50,834 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "report" stopped in 0.001069 2024-11-20 16:38:50,834 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" stopped in 0.000006 2024-11-20 16:38:50,834 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "revision" stopped in 0.000004 2024-11-20 16:38:50,834 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "file_in_memory_log" stopped in 0.000005 2024-11-20 16:38:50,834 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display_in_memory_log" stopped in 0.000004 2024-11-20 16:38:50,834 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "file_log" stopped in 0.000007 2024-11-20 16:38:50,834 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "uid" stopped in 0.000003 2024-11-20 16:38:50,834 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Restored ctx dict_keys([])