2024-11-21 10:03:36,853 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "file_in_memory_log" initialized in 0.000014 2024-11-21 10:03:36,853 DEBUG (root) [MainThread] Release revision: 15327756 2024-11-21 10:03:36,854 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "revision" initialized in 0.000871 2024-11-21 10:03:36,854 DEBUG (yalibrary.vcs) [MainThread] detecting vcs from /home/runner/actions_runner/_work/ydb/ydb for paths: None 2024-11-21 10:03:36,854 DEBUG (yalibrary.vcs) [MainThread] common root: /home/runner/actions_runner/_work/ydb/ydb 2024-11-21 10:03:36,854 DEBUG (yalibrary.vcs) [MainThread] vcs root: /home/runner/actions_runner/_work/ydb/ydb (git) 2024-11-21 10:03:36,854 DEBUG (root) [MainThread] vcs type: git 2024-11-21 10:03:36,854 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" initialized in 0.000206 2024-11-21 10:03:36,854 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-21 10:03:36,854 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "report" initialized in 0.000414 2024-11-21 10:03:36,854 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "exit" initialized in 0.000001 2024-11-21 10:03:36,854 DEBUG (root) [MainThread] Start up timestamp 2024-11-21T10:03:36.UTC (2024-11-21T10:03:36.UTC) 2024-11-21 10:03:36,854 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "lifecycle_ts" initialized in 0.000039 2024-11-21 10:03:36,854 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "env_checker" initialized in 0.000005 2024-11-21 10:03:36,855 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" initialized in 0.000415 2024-11-21 10:03:36,855 DEBUG (library.python.tmp) [MainThread] Set TMPDIR=/home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm instead of None 2024-11-21 10:03:36,855 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "tmp_dir" initialized in 0.000129 2024-11-21 10:03:36,855 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=modules-initialization-early, group=overall-execution, time=1732183416.8556151 2024-11-21 10:03:36,855 DEBUG (core.stages_profiler) [MainThread] Set stage modules-initialization-early_finished=1732183416.8556151 2024-11-21 10:03:36,855 DEBUG (core.profiler) [MainThread] Profile step modules-initialization-early_finished - 1732183416.8556151 2024-11-21 10:03:36,856 DEBUG (core.stage_tracer) [MainThread] Start stage tag=handler-selection, group=overall-execution, time=1732183416.856098 2024-11-21 10:03:36,856 DEBUG (core.stages_profiler) [MainThread] Set stage handler-selection_started=1732183416.856098 2024-11-21 10:03:36,856 DEBUG (core.profiler) [MainThread] Profile step handler-selection_started - 1732183416.856098 2024-11-21 10:03:36,856 DEBUG (core.plugin_loader) [MainThread] Load handlers.make 2024-11-21 10:03:36,868 DEBUG (core.yarg.config_files) [MainThread] Load data from config /home/runner/actions_runner/_work/ydb/ydb/ya.conf 2024-11-21 10:03:36,869 DEBUG (core.yarg.config_files) [MainThread] Found 21 keys 2024-11-21 10:03:36,869 DEBUG (core.yarg.populate) [MainThread] Use config file `/home/runner/actions_runner/_work/ydb/ydb/ya.conf` with `21` keys 2024-11-21 10:03:36,869 DEBUG (core.yarg.populate) [MainThread] No aliases to inject 2024-11-21 10:03:36,869 DEBUG (core.yarg.config_files) [MainThread] Unknown config parameter `incremental_build_dirs_cleanup` 2024-11-21 10:03:36,870 DEBUG (core.yarg.config_files) [MainThread] Unknown config parameter `use_atd_revisions_info` 2024-11-21 10:03:36,870 DEBUG (core.yarg.config_files) [MainThread] Load data from config /home/runner/actions_runner/_work/ydb/ydb/build/internal/ya.conf 2024-11-21 10:03:36,870 DEBUG (core.yarg.config_files) [MainThread] Found 9 keys 2024-11-21 10:03:36,870 DEBUG (core.yarg.populate) [MainThread] Use config file `/home/runner/actions_runner/_work/ydb/ydb/build/internal/ya.conf` with `9` keys 2024-11-21 10:03:36,870 DEBUG (core.yarg.populate) [MainThread] No aliases to inject 2024-11-21 10:03:36,870 DEBUG (core.yarg.config_files) [MainThread] Unknown config parameter `bazel_remote_client_decompress` 2024-11-21 10:03:36,880 DEBUG (core.common_opts) [MainThread] Could not read .ya_token file at /home/runner/.ya_token: [Errno 2] No such file or directory: '/home/runner/.ya_token' 2024-11-21 10:03:36,880 DEBUG (core.common_opts) [MainThread] Could not read .ya_token file at /home/runner/.ya_token: [Errno 2] No such file or directory: '/home/runner/.ya_token' 2024-11-21 10:03:36,881 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=handler-selection, group=overall-execution, time=1732183416.8816128 2024-11-21 10:03:36,881 DEBUG (core.stages_profiler) [MainThread] Set stage handler-selection_finished=1732183416.8816128 2024-11-21 10:03:36,881 DEBUG (core.profiler) [MainThread] Profile step handler-selection_finished - 1732183416.8816128 2024-11-21 10:03:36,881 DEBUG (core.stage_tracer) [MainThread] Start stage tag=modules-initialization-full, group=overall-execution, time=1732183416.8817418 2024-11-21 10:03:36,881 DEBUG (core.stages_profiler) [MainThread] Set stage modules-initialization-full_started=1732183416.8817418 2024-11-21 10:03:36,881 DEBUG (core.profiler) [MainThread] Profile step modules-initialization-full_started - 1732183416.8817418 2024-11-21 10:03:36,882 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Add [('params', ), ('hide_token', ), ('state', ), ('display', ), ('custom_file_log', ), ('display_log', ), ('vcs_type', ), ('self_info', ), ('fetcher_params', ), ('use_universal_fetcher_everywhere', ), ('docker_config_path', ), ('hide_token2', ), ('fetchers_storage', ), ('fetcher', ), ('showstack', ), ('profile', ), ('mlockall', ), ('event_queue', ), ('changelist_store', ), ('evlog', ), ('dump_debug', )] to ctx dict_keys(['uid', 'file_log', 'display_in_memory_log', 'file_in_memory_log', 'revision', 'vcs_type', 'report', 'exit', 'lifecycle_ts', 'env_checker', 'fetchers_storage', 'tmp_dir', 'params', 'hide_token', 'state', 'display']) 2024-11-21 10:03:36,882 DEBUG (core.respawn) [MainThread] Same as prev source root /home/runner/actions_runner/_work/ydb/ydb 2024-11-21 10:03:36,882 DEBUG (core.respawn.pyver) [MainThread] No need to respawn to other ya-bin version 2024-11-21 10:03:36,882 DEBUG (core.respawn) [MainThread] Unsetting YA_STDIN env var as respawn never happened 2024-11-21 10:03:36,882 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "params" initialized in 0.000283 2024-11-21 10:03:36,884 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-21 10:03:36,884 DEBUG (root) [MainThread] Update replacements in 2024-11-21 10:03:36,884 DEBUG (root) [MainThread] Add suppressing formatter to 2024-11-21 10:03:36,884 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-21 10:03:36,884 DEBUG (root) [MainThread] Add suppressing formatter to 2024-11-21 10:03:36,884 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-21 10:03:36,884 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token" initialized in 0.002194 2024-11-21 10:03:36,884 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "state" initialized in 0.000234 2024-11-21 10:03:36,885 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display" initialized in 0.000056 2024-11-21 10:03:36,885 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-21 10:03:36,886 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "custom_file_log" initialized in 0.000923 2024-11-21 10:03:36,886 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display_log" initialized in 0.000043 2024-11-21 10:03:36,886 DEBUG (yalibrary.vcs) [MainThread] detecting vcs from /home/runner/actions_runner/_work/ydb/ydb for paths: None 2024-11-21 10:03:36,886 DEBUG (yalibrary.vcs) [MainThread] common root: /home/runner/actions_runner/_work/ydb/ydb 2024-11-21 10:03:36,886 DEBUG (yalibrary.vcs) [MainThread] vcs root: /home/runner/actions_runner/_work/ydb/ydb (git) 2024-11-21 10:03:36,886 DEBUG (root) [MainThread] vcs type: git 2024-11-21 10:03:36,886 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" initialized in 0.000223 2024-11-21 10:03:36,886 DEBUG (devtools.ya.app) [MainThread] origin: github 2024-11-21 10:03:36,886 DEBUG (devtools.ya.app) [MainThread] python: sys.version_info(major=3, minor=12, micro=7, releaselevel='final', serial=0) 2024-11-21 10:03:36,886 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "self_info" initialized in 0.000104 2024-11-21 10:03:36,886 DEBUG (root) [MainThread] Custom fetcher: None, fetcher parameters: [{'name': 'custom'}, {'name': 'proxy'}, {'name': 'skynet'}, {'name': 'mds'}, {'name': 'sandbox'}], sb_token none 2024-11-21 10:03:36,886 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher_params" initialized in 0.000089 2024-11-21 10:03:36,886 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "use_universal_fetcher_everywhere" initialized in 0.000002 2024-11-21 10:03:36,886 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "docker_config_path" initialized in 0.000001 2024-11-21 10:03:36,887 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2024-11-21 10:03:36,887 DEBUG (root) [MainThread] Update replacements in 2024-11-21 10:03:36,887 DEBUG (root) [MainThread] Update replacements in 2024-11-21 10:03:36,887 DEBUG (root) [MainThread] Update replacements in DisplayStreamHandler 2024-11-21 10:03:36,887 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token2" initialized in 0.000994 2024-11-21 10:03:36,887 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" initialized in 0.000074 2024-11-21 10:03:36,888 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher" initialized in 0.000002 2024-11-21 10:03:36,888 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "showstack" initialized in 0.000154 2024-11-21 10:03:36,888 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "profile" initialized in 0.000002 2024-11-21 10:03:36,888 DEBUG (devtools.ya.app) [MainThread] mlockall return code: 12 2024-11-21 10:03:36,888 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "mlockall" initialized in 0.000035 2024-11-21 10:03:36,888 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "event_queue" initialized in 0.000005 2024-11-21 10:03:36,888 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "changelist_store" initialized in 0.000304 2024-11-21 10:03:36,888 DEBUG (root) [MainThread] Event log file is /home/runner/actions_runner/_work/ydb/ydb/tmp/results/try_1/ya_evlog.jsonl 2024-11-21 10:03:36,889 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "evlog" initialized in 0.000436 2024-11-21 10:03:36,933 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "dump_debug" initialized in 0.043825 2024-11-21 10:03:36,933 DEBUG (devtools.ya.app) [MainThread] Run action on with params 2024-11-21 10:03:36,933 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=modules-initialization-full, group=overall-execution, time=1732183416.9339757 2024-11-21 10:03:36,934 DEBUG (core.stages_profiler) [MainThread] Set stage modules-initialization-full_finished=1732183416.9339757 2024-11-21 10:03:36,934 DEBUG (core.profiler) [MainThread] Profile step modules-initialization-full_finished - 1732183416.9339757 2024-11-21 10:03:36,934 DEBUG (core.stage_tracer) [MainThread] Start stage tag=invoke-do_ya_make, group=overall-execution, time=1732183416.9341447 2024-11-21 10:03:36,934 DEBUG (core.stages_profiler) [MainThread] Set stage invoke-do_ya_make_started=1732183416.9341447 2024-11-21 10:03:36,934 DEBUG (core.profiler) [MainThread] Profile step invoke-do_ya_make_started - 1732183416.9341447 2024-11-21 10:03:37,070 DEBUG (core.stage_tracer) [MainThread] Start stage tag=ya_make_handler, group=build_handler, time=1732183417.070052 2024-11-21 10:03:37,070 DEBUG (core.stages_profiler) [MainThread] Set stage ya_make_handler_started=1732183417.070052 2024-11-21 10:03:37,070 DEBUG (core.profiler) [MainThread] Profile step ya_make_handler_started - 1732183417.070052 2024-11-21 10:03:37,070 DEBUG (core.stage_tracer) [MainThread] Start stage tag=context_generating, group=build_handler, time=1732183417.0703387 2024-11-21 10:03:37,070 DEBUG (core.stages_profiler) [MainThread] Set stage context_generating_started=1732183417.0703387 2024-11-21 10:03:37,070 DEBUG (core.profiler) [MainThread] Profile step context_generating_started - 1732183417.0703387 2024-11-21 10:03:37,070 DEBUG (core.stage_tracer) [MainThread] Start stage tag=build_graph_cache_configuration, group=build_handler, time=1732183417.0704606 2024-11-21 10:03:37,070 DEBUG (core.stages_profiler) [MainThread] Set stage build_graph_cache_configuration_started=1732183417.0704606 2024-11-21 10:03:37,070 DEBUG (core.profiler) [MainThread] Profile step build_graph_cache_configuration_started - 1732183417.0704606 2024-11-21 10:03:37,070 DEBUG (build.ya_make) [MainThread] Build graph cache processing started 2024-11-21 10:03:37,070 DEBUG (build.ya_make) [MainThread] Build graph cache processing disabled 2024-11-21 10:03:37,070 DEBUG (build.ya_make) [MainThread] Build graph cache is not available in opensource 2024-11-21 10:03:37,070 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=build_graph_cache_configuration, group=build_handler, time=1732183417.0706713 2024-11-21 10:03:37,070 DEBUG (core.stages_profiler) [MainThread] Set stage build_graph_cache_configuration_finished=1732183417.0706713 2024-11-21 10:03:37,070 DEBUG (core.profiler) [MainThread] Profile step build_graph_cache_configuration_finished - 1732183417.0706713 2024-11-21 10:03:37,070 DEBUG (core.stage_tracer) [MainThread] Start stage tag=context_creation, group=ya_make, time=1732183417.0709448 2024-11-21 10:03:37,071 DEBUG (core.stages_profiler) [MainThread] Set stage context_creation_started=1732183417.0709448 2024-11-21 10:03:37,071 DEBUG (core.profiler) [MainThread] Profile step context_creation_started - 1732183417.0709448 2024-11-21 10:03:37,073 DEBUG (yalibrary.toolscache) [MainThread] Tools cache uses passed opts 2024-11-21 10:03:37,073 DEBUG (yalibrary.toolscache) [MainThread] Tools cache parameters: tc enabled=True, tc master=True, ac enabled=True, ac master=True, tc_lock_file=/home/runner/.ya/tools/v4/.cache_lock, ac_lock_file=/home/runner/.ya/build/cache/7/.cache_lock, binary=None, ini=None, tc_conf={}, ac_conf={'cas_logging': 'true', 'graph_info': 'true'}, gl_conf={} 2024-11-21 10:03:37,073 DEBUG (build.ya_make) [MainThread] content UIDs enabled by request 2024-11-21 10:03:37,076 DEBUG (build.ya_make) [Misc-00] Using '/tmp/tmp.iVGc7qP910' file to obtain bazel remote password 2024-11-21 10:03:37,076 DEBUG (core.stage_tracer) [MainThread] Start stage tag=build_graph_and_tests, group=graph, time=1732183417.076282 2024-11-21 10:03:37,076 DEBUG (core.stages_profiler) [MainThread] Set stage build_graph_and_tests_started=1732183417.076282 2024-11-21 10:03:37,076 DEBUG (core.profiler) [MainThread] Profile step build_graph_and_tests_started - 1732183417.076282 2024-11-21 10:03:37,077 DEBUG (build.graph) [Misc-01] Collect vcs info 2024-11-21 10:03:37,077 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/ya.conf.json 2024-11-21 10:03:37,077 DEBUG (yalibrary.vcs) [Misc-01] detecting vcs from /home/runner/actions_runner/_work/ydb/ydb for paths: ['/home/runner/actions_runner/_work/ydb/ydb'] 2024-11-21 10:03:37,077 DEBUG (yalibrary.vcs) [Misc-01] common root: /home/runner/actions_runner/_work/ydb/ydb 2024-11-21 10:03:37,078 DEBUG (yalibrary.vcs) [Misc-01] vcs root: /home/runner/actions_runner/_work/ydb/ydb (git) 2024-11-21 10:03:37,078 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/platform/clang/clang16.json 2024-11-21 10:03:37,080 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/platform/clang/clang18.json 2024-11-21 10:03:37,082 DEBUG (build.graph) [MainThread] flags: { "APPLE_SDK_LOCAL": "yes", "CFLAGS": "-fno-omit-frame-pointer", "CONSISTENT_DEBUG": "yes", "DEBUGINFO_LINES_ONLY": "yes", "DISABLE_FLAKE8_MIGRATIONS": "yes", "OPENSOURCE": "yes", "TESTS_REQUESTED": "yes", "USE_AIO": "static", "USE_CLANG_CL": "yes", "USE_EAT_MY_DATA": "yes", "USE_ICONV": "static", "USE_IDN": "static", "USE_PREBUILT_TOOLS": "no" } 2024-11-21 10:03:37,082 DEBUG (build.graph) [MainThread] host toolchain: { "bottle_name": "clang18", "build_type": "release", "env": { "CPATH": [ "" ], "LIBRARY_PATH": [ "" ], "SDKROOT": [ "" ] }, "executable_path": "c++", "flags": { "APPLE_SDK_LOCAL": "yes", "CFLAGS": "-fno-omit-frame-pointer", "CLANG_COVERAGE": "no", "CONSISTENT_DEBUG": "yes", "NO_DEBUGINFO": "yes", "OPENSOURCE": "yes", "TIDY": "no", "TOOL_BUILD_MODE": "yes", "TRAVERSE_RECURSE": "no", "USE_AIO": "static", "USE_CLANG_CL": "yes", "USE_ICONV": "static", "USE_IDN": "static", "USE_PREBUILT_TOOLS": "no" }, "formula": { "by_platform": { "darwin-arm64": { "uri": "sbr:7451602609" }, "darwin-x86_64": { "uri": "sbr:7451585962" }, "linux-aarch64": { "uri": "sbr:7451712332" }, "linux-x86_64": { "uri": "sbr:7451466407" }, "win32-x86_64": { "uri": "sbr:7451406900" } } }, "name": "clang18", "params": { "c_compiler": "$(CLANG-1735056821)/bin/clang", "cxx_compiler": "$(CLANG-1735056821)/bin/clang++", "gcc_version": "18", "llvm-symbolizer": "$(CLANG-1735056821)/bin/llvm-symbolizer", "match_root": "CLANG-1735056821", "objcopy": "$(CLANG-1735056821)/bin/llvm-objcopy", "profiles": "$(XCODE_TOOLS_ROOT-sbr:799017771)/Xcode/Contents/Developer/Platforms/iPhoneOS.platform/Developer/Library/CoreSimulator/Profiles", "simctl": "$(XCODE_TOOLS_ROOT-sbr:799017771)/Xcode/SystemRoot/PrivateFrameworks/CoreSimulator.framework/Resources/bin/simctl", "strip": "$(CLANG-1735056821)/bin/llvm-strip", "type": "clang", "use_bundle": true, "werror_mode": "all" }, "platform": { "host": { "arch": "x86_64", "os": "LINUX", "toolchain": "default", "visible_name": "clang18" }, "target": { "arch": "x86_64", "os": "LINUX", "toolchain": "default", "visible_name": "clang18" } }, "tool_var": "CLANG-1735056821" } 2024-11-21 10:03:37,082 DEBUG (build.graph) [MainThread] target toolchain: { "bottle_name": "clang18", "env": { "CPATH": [ "" ], "LIBRARY_PATH": [ "" ], "SDKROOT": [ "" ] }, "executable_path": "c++", "flags": { "SANITIZER_TYPE": "address" }, "formula": { "by_platform": { "darwin-arm64": { "uri": "sbr:7451602609" }, "darwin-x86_64": { "uri": "sbr:7451585962" }, "linux-aarch64": { "uri": "sbr:7451712332" }, "linux-x86_64": { "uri": "sbr:7451466407" }, "win32-x86_64": { "uri": "sbr:7451406900" } } }, "name": "clang18", "params": { "c_compiler": "$(CLANG-1735056821)/bin/clang", "cxx_compiler": "$(CLANG-1735056821)/bin/clang++", "gcc_version": "18", "llvm-symbolizer": "$(CLANG-1735056821)/bin/llvm-symbolizer", "match_root": "CLANG-1735056821", "objcopy": "$(CLANG-1735056821)/bin/llvm-objcopy", "profiles": "$(XCODE_TOOLS_ROOT-sbr:799017771)/Xcode/Contents/Developer/Platforms/iPhoneOS.platform/Developer/Library/CoreSimulator/Profiles", "simctl": "$(XCODE_TOOLS_ROOT-sbr:799017771)/Xcode/SystemRoot/PrivateFrameworks/CoreSimulator.framework/Resources/bin/simctl", "strip": "$(CLANG-1735056821)/bin/llvm-strip", "type": "clang", "use_bundle": true, "werror_mode": "all" }, "platform": { "host": { "arch": "x86_64", "os": "LINUX", "toolchain": "default", "visible_name": "clang18" }, "target": { "arch": "x86_64", "os": "LINUX", "toolchain": "default", "visible_name": "clang18" } }, "platform_name": "DEFAULT-LINUX-X86_64", "tool_var": "CLANG-1735056821" } 2024-11-21 10:03:37,083 DEBUG (yalibrary.tools) [MainThread] Using old-style toolchain for: ymake 2024-11-21 10:03:37,083 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/ymake/public.resources.json 2024-11-21 10:03:37,083 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ymake: try to fetch by {'darwin': {'uri': 'sbr:7478218557'}, 'darwin-arm64': {'uri': 'sbr:7478218228'}, 'linux': {'uri': 'sbr:7478219259'}, 'linux-aarch64': {'uri': 'sbr:7478218007'}, 'win32-clang-cl': {'uri': 'sbr:7478218861'}} for 'linux' 2024-11-21 10:03:37,083 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ymake: will use 'linux' platform 2024-11-21 10:03:37,083 DEBUG (yalibrary.fetcher.resource_fetcher) [MainThread] Fetching 7478219259 from sbr:7478219259 to /home/runner/.ya/tools/v4/7478219259 dir, post_process=0) 2024-11-21 10:03:37,083 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/mapping.conf.json 2024-11-21 10:03:37,085 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/ext_mapping.conf.json 2024-11-21 10:03:37,094 DEBUG (yalibrary.toolscache) [MainThread] Tools cache attempt: (request for resource 7478219259) 2024-11-21 10:03:37,094 DEBUG (yalibrary.toolscache) [MainThread] Tools cache server resource download/parameters 2024-11-21 10:03:37,094 DEBUG (yalibrary.tools) [MainThread] Using old-style toolchain for: ya-tc 2024-11-21 10:03:37,095 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/ya-tc/public.resources.json 2024-11-21 10:03:37,095 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ya-tc: try to fetch by {'darwin': {'uri': 'sbr:6812263131'}, 'darwin-arm64': {'uri': 'sbr:6812261994'}, 'linux': {'uri': 'sbr:6812260917'}, 'linux-aarch64': {'uri': 'sbr:6812259929'}} for 'linux' 2024-11-21 10:03:37,095 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ya-tc: will use 'linux' platform 2024-11-21 10:03:37,095 DEBUG (yalibrary.fetcher.resource_fetcher) [MainThread] Fetching 6812260917 from sbr:6812260917 to /home/runner/.ya/tools/v4/6812260917 dir, post_process=0) 2024-11-21 10:03:37,095 DEBUG (yalibrary.toolscache) [MainThread] tc cache stats: None 2024-11-21 10:03:37,095 DEBUG (yalibrary.fetcher.cache_helper) [MainThread] Resource seems to be installed in /home/runner/.ya/tools/v4/6812260917 2024-11-21 10:03:37,095 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ya-tc: successfully fetched into /home/runner/.ya/tools/v4/6812260917 2024-11-21 10:03:37,095 DEBUG (yalibrary.tools) [MainThread] Using old-style toolchain for: ya-tc 2024-11-21 10:03:37,096 DEBUG (yalibrary.toolscache) [MainThread] tc cache stats: None 2024-11-21 10:03:37,096 DEBUG (yalibrary.toolscache) [MainThread] Tools cache server resource download/parameters done: id=6812260917, full_path=/home/runner/.ya/tools/v4/6812260917/ya-tc 2024-11-21 10:03:37,100 DEBUG (yalibrary.toolscache) [MainThread] Tools cache (request for resource 7478219259) address: (2180232, 974020, 'unix:/home/runner/.ya/tools/v4/psingZyFdWa.tmp') 2024-11-21 10:03:37,105 DEBUG (yalibrary.toolscache) [MainThread] tc cache stats: TotalKnownSize: 62115840 TotalKnownSizeLocked: 22249472 Master: true TotalDBSize: 81920 ToolCount: 2 ProcessesCount: 2 2024-11-21 10:03:37,106 DEBUG (yalibrary.fetcher.cache_helper) [MainThread] Resource seems to be installed in /home/runner/.ya/tools/v4/7478219259 2024-11-21 10:03:37,106 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ymake: successfully fetched into /home/runner/.ya/tools/v4/7478219259 2024-11-21 10:03:37,106 DEBUG (exts.timer) [MainThread] Timer build.graph, stage fetch ymake: 0.023199796676635742 2024-11-21 10:03:37,106 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=gen-graph-default-linux-x86_64-release-asan-pic, group=graph, time=1732183417.106691 2024-11-21 10:03:37,107 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-default-linux-x86_64-release-asan-pic_started=1732183417.106691 2024-11-21 10:03:37,107 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-default-linux-x86_64-release-asan-pic_started - 1732183417.106691 2024-11-21 10:03:37,107 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=gen-graph-default-linux-x86_64-release-asan-nopic, group=graph, time=1732183417.1071422 2024-11-21 10:03:37,107 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-default-linux-x86_64-release-asan-nopic_started=1732183417.1071422 2024-11-21 10:03:37,108 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-default-linux-x86_64-release-asan-nopic_started - 1732183417.1071422 2024-11-21 10:03:37,108 DEBUG (core.stage_tracer) [MainThread] Start stage tag=get-tools, group=graph, time=1732183417.1074405 2024-11-21 10:03:37,108 DEBUG (core.stages_profiler) [MainThread] Set stage get-tools_started=1732183417.1074405 2024-11-21 10:03:37,108 DEBUG (core.profiler) [MainThread] Profile step get-tools_started - 1732183417.1074405 2024-11-21 10:03:37,108 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=gen-graph-gen-opts-default-linux-x86_64-release-asan-pic, group=graph, time=1732183417.1077735 2024-11-21 10:03:37,108 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-gen-opts-default-linux-x86_64-release-asan-pic_started=1732183417.1077735 2024-11-21 10:03:37,108 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-gen-opts-default-linux-x86_64-release-asan-pic_started - 1732183417.1077735 2024-11-21 10:03:37,108 DEBUG (yalibrary.guards) [Misc-02] Enter guard fetch with value None 2024-11-21 10:03:37,108 DEBUG (core.stage_tracer) [MainThread] Start stage tag=waiting-tool-targets, group=graph, time=1732183417.1084073 2024-11-21 10:03:37,108 DEBUG (core.stages_profiler) [MainThread] Set stage waiting-tool-targets_started=1732183417.1084073 2024-11-21 10:03:37,109 DEBUG (core.profiler) [MainThread] Profile step waiting-tool-targets_started - 1732183417.1084073 2024-11-21 10:03:37,109 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic, group=graph, time=1732183417.1084435 2024-11-21 10:03:37,109 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic_started=1732183417.1084435 2024-11-21 10:03:37,109 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic_started - 1732183417.1084435 2024-11-21 10:03:37,109 DEBUG (yalibrary.guards) [Misc-03] Enter guard fetch with value None 2024-11-21 10:03:37,110 DEBUG (yalibrary.vcs.vcsversion) [Misc-01] b'fatal: No names found, cannot describe anything.\n' Running git describe --exact-match --tags HEAD failed with exit code 128 2024-11-21 10:03:37,112 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-21 10:03:37,115 DEBUG (yalibrary.vcs.vcsversion) [Misc-01] Git info commit:b'dc2140f19df95aa976f12d5f49541244b94fbd58', author:b'kruall ', summary:b'Merge ce1dd32c25a19ea33695d86442ccf3cb95a1739c into 59fa9fb62c912101473e75fc1a3d39ba0fe8dc25', svn_id:b'' 2024-11-21 10:03:37,116 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-ft54dmhj2u Host information: Linux ghrun-ft54dmhj2u 5.15.0-124-generic #134-Ubuntu SMP Fri Sep 27 20:20:17 UTC 2024 x86_64 2024-11-21 10:03:37,116 DEBUG (build.graph) [Misc-01] Got version json "{\n \"ARCADIA_PATCH_NUMBER\": 1,\n \"ARCADIA_SOURCE_HG_HASH\": \"dc2140f19df95aa976f12d5f49541244b94fbd58\",\n \"ARCADIA_SOURCE_LAST_AUTHOR\": \"kruall \",\n \"ARCADIA_SOURCE_LAST_CHANGE\": -1,\n \"ARCADIA_SOURCE_PATH\": \"/home/runner/actions_runner/_work/ydb/ydb\",\n \"ARCADIA_SOURCE_REVISION\": -1,\n \"ARCADIA_SOURCE_URL\": \"\",\n \"ARCADIA_TAG\": \"\",\n \"BRANCH\": \"\",\n \"BUILD_DATE\": \"2024-11-21T10:03:37.000000Z\",\n \"BUILD_HOST\": \"ghrun-ft54dmhj2u\",\n \"BUILD_TIMESTAMP\": 1732183417,\n \"BUILD_USER\": \"runner\",\n \"CUSTOM_VERSION\": \"\",\n \"DIRTY\": \"\",\n \"PROGRAM_VERSION\": \"Git info:\\n Commit: dc2140f19df95aa976f12d5f49541244b94fbd58\\n Branch: \\n Author: kruall \\n Summary: Merge ce1dd32c25a19ea33695d86442ccf3cb95a1739c into 59fa9fb62c912101473e75fc1a3d39ba0fe8dc25\\n\\nOther info:\\n Build by: runner\\n Top src dir: /home/runner/actions_runner/_work/ydb/ydb\\n Top build dir: /home/runner/.ya/build\\n Hostname: ghrun-ft54dmhj2u\\n Host information: \\n Linux ghrun-ft54dmhj2u 5.15.0-124-generic #134-Ubuntu SMP Fri Sep 27 20:20:17 UTC 2024 x86_64\\n\\n \",\n \"RELEASE_VERSION\": \"\",\n \"SCM_DATA\": \"Git info:\\n Commit: dc2140f19df95aa976f12d5f49541244b94fbd58\\n Branch: \\n Author: kruall \\n Summary: Merge ce1dd32c25a19ea33695d86442ccf3cb95a1739c into 59fa9fb62c912101473e75fc1a3d39ba0fe8dc25\\n\",\n \"VCS\": \"git\"\n}" 2024-11-21 10:03:37,116 DEBUG (exts.timer) [Misc-01] Timer get_version_info, stage vcs info: 0.039299964904785156 2024-11-21 10:03:37,146 DEBUG (build.genconf) [Misc-02] Generating conf into /home/runner/.ya/build/conf/dist-release-5d153bb7ddbd2c2aa1f28aab9f545412/ymake.conf with cmd ['/home/runner/.ya/tools/a6139abb9c_d/ya-bin', '/home/runner/actions_runner/_work/ydb/ydb/build/ymake_conf.py', '/home/runner/actions_runner/_work/ydb/ydb', 'dist-release', 'no', '--toolchain-params', 'eyJib3R0bGVfbmFtZSI6ImNsYW5nMTgiLCJlbnYiOnsiQ1BBVEgiOlsiIl0sIkxJQlJBUllfUEFUSCI6WyIiXSwiU0RLUk9PVCI6WyIiXX0sImV4ZWN1dGFibGVfcGF0aCI6ImMrKyIsImZsYWdzIjp7IlNBTklUSVpFUl9UWVBFIjoiYWRkcmVzcyJ9LCJmb3JtdWxhIjp7ImJ5X3BsYXRmb3JtIjp7ImRhcndpbi1hcm02NCI6eyJ1cmkiOiJzYnI6NzQ1MTYwMjYwOSJ9LCJkYXJ3aW4teDg2XzY0Ijp7InVyaSI6InNicjo3NDUxNTg1OTYyIn0sImxpbnV4LWFhcmNoNjQiOnsidXJpIjoic2JyOjc0NTE3MTIzMzIifSwibGludXgteDg2XzY0Ijp7InVyaSI6InNicjo3NDUxNDY2NDA3In0sIndpbjMyLXg4Nl82NCI6eyJ1cmkiOiJzYnI6NzQ1MTQwNjkwMCJ9fX0sIm5hbWUiOiJjbGFuZzE4IiwicGFyYW1zIjp7ImNfY29tcGlsZXIiOiIkKENMQU5HLTE3MzUwNTY4MjEpL2Jpbi9jbGFuZyIsImN4eF9jb21waWxlciI6IiQoQ0xBTkctMTczNTA1NjgyMSkvYmluL2NsYW5nKysiLCJnY2NfdmVyc2lvbiI6IjE4IiwibGx2bS1zeW1ib2xpemVyIjoiJChDTEFORy0xNzM1MDU2ODIxKS9iaW4vbGx2bS1zeW1ib2xpemVyIiwibWF0Y2hfcm9vdCI6IkNMQU5HLTE3MzUwNTY4MjEiLCJvYmpjb3B5IjoiJChDTEFORy0xNzM1MDU2ODIxKS9iaW4vbGx2bS1vYmpjb3B5IiwicHJvZmlsZXMiOiIkKFhDT0RFX1RPT0xTX1JPT1Qtc2JyOjc5OTAxNzc3MSkvWGNvZGUvQ29udGVudHMvRGV2ZWxvcGVyL1BsYXRmb3Jtcy9pUGhvbmVPUy5wbGF0Zm9ybS9EZXZlbG9wZXIvTGlicmFyeS9Db3JlU2ltdWxhdG9yL1Byb2ZpbGVzIiwic2ltY3RsIjoiJChYQ09ERV9UT09MU19ST09ULXNicjo3OTkwMTc3NzEpL1hjb2RlL1N5c3RlbVJvb3QvUHJpdmF0ZUZyYW1ld29ya3MvQ29yZVNpbXVsYXRvci5mcmFtZXdvcmsvUmVzb3VyY2VzL2Jpbi9zaW1jdGwiLCJzdHJpcCI6IiQoQ0xBTkctMTczNTA1NjgyMSkvYmluL2xsdm0tc3RyaXAiLCJ0eXBlIjoiY2xhbmciLCJ1c2VfYnVuZGxlIjp0cnVlLCJ3ZXJyb3JfbW9kZSI6ImFsbCJ9LCJwbGF0Zm9ybSI6eyJob3N0Ijp7ImFyY2giOiJ4ODZfNjQiLCJvcyI6IkxJTlVYIiwidG9vbGNoYWluIjoiZGVmYXVsdCIsInZpc2libGVfbmFtZSI6ImNsYW5nMTgifSwidGFyZ2V0Ijp7ImFyY2giOiJ4ODZfNjQiLCJvcyI6IkxJTlVYIiwidG9vbGNoYWluIjoiZGVmYXVsdCIsInZpc2libGVfbmFtZSI6ImNsYW5nMTgifX0sInBsYXRmb3JtX25hbWUiOiJERUZBVUxULUxJTlVYLVg4Nl82NCIsInRvb2xfdmFyIjoiQ0xBTkctMTczNTA1NjgyMSJ9', '-l', '-D', 'APPLE_SDK_LOCAL=yes', '-D', 'CFLAGS=-fno-omit-frame-pointer', '-D', 'CLANG18=yes', '-D', 'CONSISTENT_DEBUG=yes', '-D', 'DEBUGINFO_LINES_ONLY=yes', '-D', 'DISABLE_FLAKE8_MIGRATIONS=yes', '-D', 'IS_CROSS_SANITIZE=yes', '-D', 'OPENSOURCE=yes', '-D', 'SANITIZER_TYPE=address', '-D', 'TESTS_REQUESTED=yes', '-D', 'TRAVERSE_DEPENDS=yes', '-D', 'TRAVERSE_RECURSE_FOR_TESTS=yes', '-D', 'USE_AIO=static', '-D', 'USE_CLANG_CL=yes', '-D', 'USE_EAT_MY_DATA=yes', '-D', 'USE_ICONV=static', '-D', 'USE_IDN=static', '-D', 'USE_PREBUILT_TOOLS=no', '-D', 'YA=yes'] and env {'PATH': '/home/runner/actions_runner/_work/ydb/ydb/ydb/ci/scripts:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/snap/bin', 'Y_PYTHON_ENTRY_POINT': ':main'} 2024-11-21 10:03:37,147 DEBUG (build.genconf) [Misc-03] Generating conf into /home/runner/.ya/build/conf/dist-release-3cd4d7df7eccad8a535e21860d70efed/ymake.conf with cmd ['/home/runner/.ya/tools/a6139abb9c_d/ya-bin', '/home/runner/actions_runner/_work/ydb/ydb/build/ymake_conf.py', '/home/runner/actions_runner/_work/ydb/ydb', 'dist-release', 'no', '--toolchain-params', 'eyJib3R0bGVfbmFtZSI6ImNsYW5nMTgiLCJlbnYiOnsiQ1BBVEgiOlsiIl0sIkxJQlJBUllfUEFUSCI6WyIiXSwiU0RLUk9PVCI6WyIiXX0sImV4ZWN1dGFibGVfcGF0aCI6ImMrKyIsImZsYWdzIjp7IlNBTklUSVpFUl9UWVBFIjoiYWRkcmVzcyJ9LCJmb3JtdWxhIjp7ImJ5X3BsYXRmb3JtIjp7ImRhcndpbi1hcm02NCI6eyJ1cmkiOiJzYnI6NzQ1MTYwMjYwOSJ9LCJkYXJ3aW4teDg2XzY0Ijp7InVyaSI6InNicjo3NDUxNTg1OTYyIn0sImxpbnV4LWFhcmNoNjQiOnsidXJpIjoic2JyOjc0NTE3MTIzMzIifSwibGludXgteDg2XzY0Ijp7InVyaSI6InNicjo3NDUxNDY2NDA3In0sIndpbjMyLXg4Nl82NCI6eyJ1cmkiOiJzYnI6NzQ1MTQwNjkwMCJ9fX0sIm5hbWUiOiJjbGFuZzE4IiwicGFyYW1zIjp7ImNfY29tcGlsZXIiOiIkKENMQU5HLTE3MzUwNTY4MjEpL2Jpbi9jbGFuZyIsImN4eF9jb21waWxlciI6IiQoQ0xBTkctMTczNTA1NjgyMSkvYmluL2NsYW5nKysiLCJnY2NfdmVyc2lvbiI6IjE4IiwibGx2bS1zeW1ib2xpemVyIjoiJChDTEFORy0xNzM1MDU2ODIxKS9iaW4vbGx2bS1zeW1ib2xpemVyIiwibWF0Y2hfcm9vdCI6IkNMQU5HLTE3MzUwNTY4MjEiLCJvYmpjb3B5IjoiJChDTEFORy0xNzM1MDU2ODIxKS9iaW4vbGx2bS1vYmpjb3B5IiwicHJvZmlsZXMiOiIkKFhDT0RFX1RPT0xTX1JPT1Qtc2JyOjc5OTAxNzc3MSkvWGNvZGUvQ29udGVudHMvRGV2ZWxvcGVyL1BsYXRmb3Jtcy9pUGhvbmVPUy5wbGF0Zm9ybS9EZXZlbG9wZXIvTGlicmFyeS9Db3JlU2ltdWxhdG9yL1Byb2ZpbGVzIiwic2ltY3RsIjoiJChYQ09ERV9UT09MU19ST09ULXNicjo3OTkwMTc3NzEpL1hjb2RlL1N5c3RlbVJvb3QvUHJpdmF0ZUZyYW1ld29ya3MvQ29yZVNpbXVsYXRvci5mcmFtZXdvcmsvUmVzb3VyY2VzL2Jpbi9zaW1jdGwiLCJzdHJpcCI6IiQoQ0xBTkctMTczNTA1NjgyMSkvYmluL2xsdm0tc3RyaXAiLCJ0eXBlIjoiY2xhbmciLCJ1c2VfYnVuZGxlIjp0cnVlLCJ3ZXJyb3JfbW9kZSI6ImFsbCJ9LCJwbGF0Zm9ybSI6eyJob3N0Ijp7ImFyY2giOiJ4ODZfNjQiLCJvcyI6IkxJTlVYIiwidG9vbGNoYWluIjoiZGVmYXVsdCIsInZpc2libGVfbmFtZSI6ImNsYW5nMTgifSwidGFyZ2V0Ijp7ImFyY2giOiJ4ODZfNjQiLCJvcyI6IkxJTlVYIiwidG9vbGNoYWluIjoiZGVmYXVsdCIsInZpc2libGVfbmFtZSI6ImNsYW5nMTgifX0sInBsYXRmb3JtX25hbWUiOiJERUZBVUxULUxJTlVYLVg4Nl82NCIsInRvb2xfdmFyIjoiQ0xBTkctMTczNTA1NjgyMSJ9', '-l', '-D', 'APPLE_SDK_LOCAL=yes', '-D', 'CFLAGS=-fno-omit-frame-pointer', '-D', 'CLANG18=yes', '-D', 'CONSISTENT_DEBUG=yes', '-D', 'DEBUGINFO_LINES_ONLY=yes', '-D', 'DISABLE_FLAKE8_MIGRATIONS=yes', '-D', 'FORCE_NO_PIC=yes', '-D', 'IS_CROSS_SANITIZE=yes', '-D', 'OPENSOURCE=yes', '-D', 'SANITIZER_TYPE=address', '-D', 'TESTS_REQUESTED=yes', '-D', 'TRAVERSE_DEPENDS=yes', '-D', 'TRAVERSE_RECURSE_FOR_TESTS=yes', '-D', 'USE_AIO=static', '-D', 'USE_CLANG_CL=yes', '-D', 'USE_EAT_MY_DATA=yes', '-D', 'USE_ICONV=static', '-D', 'USE_IDN=static', '-D', 'USE_PREBUILT_TOOLS=no', '-D', 'YA=yes'] and env {'PATH': '/home/runner/actions_runner/_work/ydb/ydb/ydb/ci/scripts:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/snap/bin', 'Y_PYTHON_ENTRY_POINT': ':main'} 2024-11-21 10:03:37,294 DEBUG (build.genconf) [Misc-03] Copy conf /home/runner/.ya/build/conf/dist-release-3cd4d7df7eccad8a535e21860d70efed/ymake.conf to /home/runner/.ya/build/conf/dist-release-x-cb5eba878ca077f1101a8edae3aeca44/ymake.conf 2024-11-21 10:03:37,294 DEBUG (yalibrary.guards) [Misc-03] Exit guard fetch with value None 2024-11-21 10:03:37,294 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic, group=graph, time=1732183417.2944832 2024-11-21 10:03:37,294 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic_finished=1732183417.2944832 2024-11-21 10:03:37,294 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic_finished - 1732183417.2944832 2024-11-21 10:03:37,294 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=gen-graph-json-default-linux-x86_64-release-asan-nopic, group=graph, time=1732183417.2947135 2024-11-21 10:03:37,294 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-json-default-linux-x86_64-release-asan-nopic_started=1732183417.2947135 2024-11-21 10:03:37,294 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-json-default-linux-x86_64-release-asan-nopic_started - 1732183417.2947135 2024-11-21 10:03:37,294 DEBUG (build.ymake2) [Misc-03] Run gen graph with {'grab_stderr': True, 'mode': 'dist', 'dump_graph': 'json', 'check': True, '_purpose': 'default-linux-x86_64-release-asan-nopic', 'cpp': True, 'custom_build_directory': '/home/runner/.ya/build/conf/dist-release-x-cb5eba878ca077f1101a8edae3aeca44_d357a1f7839b099012272bcb9853ec19', 'build_type': 'release', 'abs_targets': ['/home/runner/actions_runner/_work/ydb/ydb'], 'debug_options': [], 'custom_conf': '/home/runner/.ya/build/conf/dist-release-x-cb5eba878ca077f1101a8edae3aeca44/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 0x7f0afbabcd60>, 'enabled_events': 'dGT', 'no_caches_on_retry': False, 'no_ymake_retry': False, 'disable_customization': 0, 'dump_tests': '/home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.fzi37vfr/test.dart', 'dump_make_files': '/home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.fzi37vfr/makefiles.dart'} 2024-11-21 10:03:37,295 DEBUG (core.yarg.behaviour) [Misc-03] Found unused args ['grab_stderr'] 2024-11-21 10:03:37,295 DEBUG (build.prefetch) [Misc-03] prefetch disabled 2024-11-21 10:03:37,295 DEBUG (core.event_handling.base_subscriber) [Misc-03] Subscribing PrintProgressSubscriber to event_queue 2024-11-21 10:03:37,295 DEBUG (yalibrary.tools) [Misc-03] Using old-style toolchain for: ymake 2024-11-21 10:03:37,295 DEBUG (build.ymake2.run_ymake) [Misc-03] run: '/home/runner/.ya/tools/v4/7478219259/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/yatmpt1i3jze1 --config /home/runner/.ya/build/conf/dist-release-x-cb5eba878ca077f1101a8edae3aeca44/ymake.conf --plugins-root /home/runner/actions_runner/_work/ydb/ydb/build/plugins,/home/runner/actions_runner/_work/ydb/ydb/build/internal/plugins --build-root /home/runner/.ya/build/conf/dist-release-x-cb5eba878ca077f1101a8edae3aeca44_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.fzi37vfr/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.fzi37vfr/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' with env: { } 2024-11-21 10:03:37,296 DEBUG (build.genconf) [Misc-02] Copy conf /home/runner/.ya/build/conf/dist-release-5d153bb7ddbd2c2aa1f28aab9f545412/ymake.conf to /home/runner/.ya/build/conf/dist-release-x-c0320386d16751174993c26b890d64d8/ymake.conf 2024-11-21 10:03:37,299 DEBUG (yalibrary.guards) [Misc-02] Exit guard fetch with value None 2024-11-21 10:03:37,300 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=gen-graph-gen-opts-default-linux-x86_64-release-asan-pic, group=graph, time=1732183417.3000581 2024-11-21 10:03:37,300 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-gen-opts-default-linux-x86_64-release-asan-pic_finished=1732183417.3000581 2024-11-21 10:03:37,300 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-gen-opts-default-linux-x86_64-release-asan-pic_finished - 1732183417.3000581 2024-11-21 10:03:37,300 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=gen-graph-json-default-linux-x86_64-release-asan-pic, group=graph, time=1732183417.3003616 2024-11-21 10:03:37,300 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-json-default-linux-x86_64-release-asan-pic_started=1732183417.3003616 2024-11-21 10:03:37,300 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-json-default-linux-x86_64-release-asan-pic_started - 1732183417.3003616 2024-11-21 10:03:37,300 DEBUG (build.ymake2) [Misc-02] Run gen graph with {'grab_stderr': True, 'mode': 'dist', 'dump_graph': 'json', 'check': True, '_purpose': 'default-linux-x86_64-release-asan-pic', 'cpp': True, 'custom_build_directory': '/home/runner/.ya/build/conf/dist-release-x-c0320386d16751174993c26b890d64d8_d357a1f7839b099012272bcb9853ec19', 'build_type': 'release', 'abs_targets': ['/home/runner/actions_runner/_work/ydb/ydb'], 'debug_options': [], 'custom_conf': '/home/runner/.ya/build/conf/dist-release-x-c0320386d16751174993c26b890d64d8/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 0x7f0afc379e40>, 'enabled_events': 'dGT', 'no_caches_on_retry': False, 'no_ymake_retry': False, 'disable_customization': 0, 'dump_tests': '/home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.d1sebg74/test.dart', 'dump_make_files': '/home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.d1sebg74/makefiles.dart'} 2024-11-21 10:03:37,300 DEBUG (core.yarg.behaviour) [Misc-02] Found unused args ['grab_stderr'] 2024-11-21 10:03:37,300 DEBUG (build.prefetch) [Misc-02] prefetch disabled 2024-11-21 10:03:37,301 DEBUG (yalibrary.tools) [Misc-02] Using old-style toolchain for: ymake 2024-11-21 10:03:37,301 DEBUG (build.ymake2.run_ymake) [Misc-02] run: '/home/runner/.ya/tools/v4/7478219259/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/yatmp0zcl3vdb --config /home/runner/.ya/build/conf/dist-release-x-c0320386d16751174993c26b890d64d8/ymake.conf --plugins-root /home/runner/actions_runner/_work/ydb/ydb/build/plugins,/home/runner/actions_runner/_work/ydb/ydb/build/internal/plugins --build-root /home/runner/.ya/build/conf/dist-release-x-c0320386d16751174993c26b890d64d8_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.d1sebg74/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.d1sebg74/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' with env: { } 2024-11-21 10:03:37,306 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"ymake run","_timestamp":1732183417306342,"_typename":"NEvent.TStageStarted","debug_id":"default-linux-x86_64-release-asan-nopic","ymake_run_uid":0} 2024-11-21 10:03:37,307 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Target path: /home/runner/actions_runner/_work/ydb/ydb\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417306487,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,307 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load configuration from cache","_timestamp":1732183417306540,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,307 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Conf cache has not been loaded (reason: File does not exist)...\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417306551,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,307 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load configuration from cache","_timestamp":1732183417306556,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,307 DEBUG (build.ya_make) [Misc-03] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedConfCache","Type":"bool","_timestamp":1732183417306869,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:03:37,307 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1732183417306874,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,309 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"ymake run","_timestamp":1732183417309653,"_typename":"NEvent.TStageStarted","debug_id":"default-linux-x86_64-release-asan-pic","ymake_run_uid":1} 2024-11-21 10:03:37,310 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Target path: /home/runner/actions_runner/_work/ydb/ydb\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417309769,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,310 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load configuration from cache","_timestamp":1732183417309807,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,310 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Conf cache has not been loaded (reason: File does not exist)...\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417309817,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,310 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load configuration from cache","_timestamp":1732183417309821,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,310 DEBUG (build.ya_make) [Misc-02] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedConfCache","Type":"bool","_timestamp":1732183417310109,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:03:37,310 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1732183417310114,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,488 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1732183417487879,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,488 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1732183417487912,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,489 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1732183417489612,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,489 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Fold global commands","_timestamp":1732183417489628,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,491 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Fold global commands","_timestamp":1732183417491022,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,491 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load plugins","_timestamp":1732183417491031,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,501 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1732183417501170,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,501 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1732183417501198,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,503 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1732183417503227,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,503 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Fold global commands","_timestamp":1732183417503243,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,504 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Fold global commands","_timestamp":1732183417504642,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,504 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load plugins","_timestamp":1732183417504652,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,626 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Load plugins","_timestamp":1732183417626424,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,638 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Load plugins","_timestamp":1732183417637812,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,660 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"MAIN_OUTPUT_AS_EXTRA enabled\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417659877,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,660 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"YMAKE_DEDICATED_MODULE_NODE disabled (by default)\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417659911,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,660 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"YMAKE_CHECK_FOR_INCORRECT_LOOPS disabled (by default)\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417659916,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,660 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"mlockall failed\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417660090,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,660 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"ymake main","_timestamp":1732183417660095,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,661 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"FS cache loading is enabled\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417660172,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,661 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"FS cache saving is enabled\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417660176,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,661 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Deps cache loading is enabled\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417660180,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,661 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Deps cache saving is enabled\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417660184,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,661 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"DepManagement cache loading is enabled\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417660188,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,661 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"DepManagement cache saving is enabled\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417660192,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,662 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Uids cache loading is enabled\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417660196,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,662 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Uids cache saving is enabled\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417660199,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,662 DEBUG (build.ya_make) [Misc-03] Configure message {"HasChangelist":false,"_timestamp":1732183417661227,"_typename":"NEvent.TArcChanges","ymake_run_uid":0} 2024-11-21 10:03:37,662 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Graph has structural changes because of PatchPath\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417661238,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,662 DEBUG (build.ya_make) [Misc-03] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedFSCache","Type":"bool","_timestamp":1732183417661248,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:03:37,662 DEBUG (build.ya_make) [Misc-03] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedDepsCache","Type":"bool","_timestamp":1732183417661252,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:03:37,662 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Build graph","_timestamp":1732183417661259,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,662 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Graph has structural changes because start dirs are different\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417661265,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,662 DEBUG (build.ya_make) [Misc-03] Configure message {"PredictsStructuralChanges":true,"_timestamp":1732183417661270,"_typename":"NEvent.TGraphChangesPrediction","ymake_run_uid":0} 2024-11-21 10:03:37,662 DEBUG (build.ya_make) [Misc-03] Configure message {"Enabled":false,"MaybeEnabled":false,"_timestamp":1732183417661275,"_typename":"NEvent.TBypassConfigure","ymake_run_uid":0} 2024-11-21 10:03:37,663 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Configure graph","_timestamp":1732183417661279,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,670 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"MAIN_OUTPUT_AS_EXTRA enabled\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417670501,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,671 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"YMAKE_DEDICATED_MODULE_NODE disabled (by default)\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417670525,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,671 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"YMAKE_CHECK_FOR_INCORRECT_LOOPS disabled (by default)\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417670530,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,671 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"mlockall failed\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417670655,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,671 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"ymake main","_timestamp":1732183417670668,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,671 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"FS cache loading is enabled\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417670731,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,671 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"FS cache saving is enabled\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417670736,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,671 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Deps cache loading is enabled\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417670740,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,671 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Deps cache saving is enabled\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417670744,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,671 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"DepManagement cache loading is enabled\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417670748,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,672 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"DepManagement cache saving is enabled\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417670752,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,672 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Uids cache loading is enabled\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417670756,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,672 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Uids cache saving is enabled\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417670759,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,672 DEBUG (build.ya_make) [Misc-02] Configure message {"HasChangelist":false,"_timestamp":1732183417671733,"_typename":"NEvent.TArcChanges","ymake_run_uid":1} 2024-11-21 10:03:37,672 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Graph has structural changes because of PatchPath\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417671741,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,672 DEBUG (build.ya_make) [Misc-02] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedFSCache","Type":"bool","_timestamp":1732183417671749,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:03:37,672 DEBUG (build.ya_make) [Misc-02] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedDepsCache","Type":"bool","_timestamp":1732183417671753,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:03:37,672 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Build graph","_timestamp":1732183417671758,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,672 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Graph has structural changes because start dirs are different\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417671764,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,672 DEBUG (build.ya_make) [Misc-02] Configure message {"PredictsStructuralChanges":true,"_timestamp":1732183417671768,"_typename":"NEvent.TGraphChangesPrediction","ymake_run_uid":1} 2024-11-21 10:03:37,673 DEBUG (build.ya_make) [Misc-02] Configure message {"Enabled":false,"MaybeEnabled":false,"_timestamp":1732183417671772,"_typename":"NEvent.TBypassConfigure","ymake_run_uid":1} 2024-11-21 10:03:37,673 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Configure graph","_timestamp":1732183417671776,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,770 DEBUG (build.ya_make) [Misc-03] Configure message {"DoubleValue":0.1092197259,"Name":"EYmakeStats::ConfigureGraphTime","Type":"double","_timestamp":1732183417770520,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:03:37,771 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Configure graph","_timestamp":1732183417770553,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,771 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Searching target '.'\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417770566,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,771 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Selected target '$S' with id 3\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417770575,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,771 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Find Lost Includes","_timestamp":1732183417770636,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,771 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":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417770733,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,771 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Find Lost Includes","_timestamp":1732183417770737,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,772 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"loaded size = 9023798; load time = 12723; loaded MD5 time = 827; Max loaded MD5 time = 9; loaded count = 2174; max load time = 126; mapped size = 40632376; mapped MD5 time = 12582; Max mapped MD5 time = 931; mapped count = 130; map time = 941; from patch count = 0; from patch size = 0; file stat count = 3223; lstat count = 3045; lstat sum us = 3538; lstat min us = 1; lstat avr us = 1; lstat max us = 21; 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 = 2463; readdir min us = 0; readdir avr us = 0; readdir max us = 45; (opendir + readdir) sum us = 2463; (lstat + opendir + readdir) sum us = 6001;","Mod":"unimp","Sub":"File access stats","Type":"Debug","_timestamp":1732183417770780,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,772 DEBUG (build.ya_make) [Misc-03] Configure message {"FileStatCount":3223,"FromPatchCount":0,"FromPatchSize":0,"ListDirSumUs":2463,"LoadTime":12723,"LoadedCount":2174,"LoadedMD5Time":827,"LoadedSize":9023798,"LstatAvrUs":1,"LstatCount":3045,"LstatListDirSumUs":6001,"LstatMaxUs":21,"LstatMinUs":1,"LstatSumUs":3538,"MapTime":941,"MappedCount":130,"MappedMD5Time":12582,"MappedSize":40632376,"MaxLoadTime":126,"MaxLoadedMD5Time":9,"MaxMappedMD5Time":931,"OpendirAvrUs":0,"OpendirCount":388,"OpendirMaxUs":0,"OpendirMinUs":0,"OpendirSumUs":0,"ReaddirAvrUs":0,"ReaddirCount":2837,"ReaddirMaxUs":45,"ReaddirMinUs":0,"ReaddirSumUs":2463,"_timestamp":1732183417770795,"_typename":"NEvent.TFileConfStats","ymake_run_uid":0} 2024-11-21 10:03:37,772 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":9023798,"Name":"EFileConfStats::LoadedSize","Type":"int","_timestamp":1732183417770809,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:03:37,772 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":12723,"Name":"EFileConfStats::LoadTime","Type":"int","_timestamp":1732183417770814,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:03:37,772 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":2174,"Name":"EFileConfStats::LoadedCount","Type":"int","_timestamp":1732183417770817,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:03:37,772 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":40632376,"Name":"EFileConfStats::MappedSize","Type":"int","_timestamp":1732183417770820,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:03:37,773 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":941,"Name":"EFileConfStats::MapTime","Type":"int","_timestamp":1732183417770823,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:03:37,773 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":130,"Name":"EFileConfStats::MappedCount","Type":"int","_timestamp":1732183417770826,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:03:37,773 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":2304,"Name":"EFileConfStats::Count","Type":"int","_timestamp":1732183417770829,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:03:37,773 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"bucket id = 0; loaded size = 9023798; load time = 12723; loaded count = 2174; max load time = 126;","Mod":"unimp","Sub":"Bucket #0","Type":"Debug","_timestamp":1732183417770837,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,773 DEBUG (build.ya_make) [Misc-03] Configure message {"BucketId":0,"LoadTime":12723,"LoadedCount":2174,"LoadedSize":9023798,"MaxLoadTime":126,"_timestamp":1732183417770842,"_typename":"NEvent.TFileConfSubStats","ymake_run_uid":0} 2024-11-21 10:03:37,773 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":1732183417770855,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,773 DEBUG (build.ya_make) [Misc-03] Configure message {"InFilesCount":0,"InFilesSize":0,"ParseTime":3,"ParsedFilesCount":6,"ParsedFilesRecovered":0,"ParsedFilesSize":12965,"_timestamp":1732183417770861,"_typename":"NEvent.TIncParserManagerStats","ymake_run_uid":0} 2024-11-21 10:03:37,773 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":1732183417770878,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,774 DEBUG (build.ya_make) [Misc-03] Configure message {"Count":8,"Includes":12,"Size":1264,"UniqueCount":8,"UniqueSize":853,"_timestamp":1732183417770883,"_typename":"NEvent.TGeneralParserStats","ymake_run_uid":0} 2024-11-21 10:03:37,774 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":1732183417770899,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,774 DEBUG (build.ya_make) [Misc-03] Configure message {"CommandsCount":142,"EdgesCount":12363,"FilesCount":3263,"NodesCount":2825,"_timestamp":1732183417770903,"_typename":"NEvent.TDepGraphStats","ymake_run_uid":0} 2024-11-21 10:03:37,774 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"nuke mod dir = 0;","Mod":"unimp","Sub":"UpdIter stats","Type":"Debug","_timestamp":1732183417770910,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,774 DEBUG (build.ya_make) [Misc-03] Configure message {"NukedDir":0,"_timestamp":1732183417770913,"_typename":"NEvent.TUpdIterStats","ymake_run_uid":0} 2024-11-21 10:03:37,774 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":1732183417770921,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,774 DEBUG (build.ya_make) [Misc-03] Configure message {"IncludesAttempted":0,"IncludesFromCache":0,"ResolveAsKnownFromCache":0,"ResolveAsKnownTotal":0,"_timestamp":1732183417770927,"_typename":"NEvent.TResolveStats","ymake_run_uid":0} 2024-11-21 10:03:37,774 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Build graph","_timestamp":1732183417770931,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,774 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":1732183417771052,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,775 DEBUG (build.ya_make) [Misc-03] Configure message {"Accessed":19,"Loaded":0,"Outdated":0,"Parsed":19,"Total":19,"_timestamp":1732183417771057,"_typename":"NEvent.TModulesStats","ymake_run_uid":0} 2024-11-21 10:03:37,775 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":19,"Name":"EModulesStats::Accessed","Type":"int","_timestamp":1732183417771062,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:03:37,775 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":0,"Name":"EModulesStats::Loaded","Type":"int","_timestamp":1732183417771065,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:03:37,775 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":0,"Name":"EModulesStats::Outdated","Type":"int","_timestamp":1732183417771068,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:03:37,775 DEBUG (build.ya_make) [Misc-03] Configure message {"IntValue":19,"Name":"EModulesStats::Parsed","Type":"int","_timestamp":1732183417771071,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:03:37,775 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Set reachable nodes","_timestamp":1732183417771082,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,775 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Set reachable nodes","_timestamp":1732183417771722,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,775 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Sort edges","_timestamp":1732183417771725,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,775 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Sort edges","_timestamp":1732183417774422,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,775 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1732183417774427,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,776 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1732183417774478,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,776 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check blacklist","_timestamp":1732183417774480,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,776 DEBUG (_ToolTargetsQueue) [MainThread] Source_id=1 (default-linux-x86_64-release-asan-nopic). Tool targets: set() 2024-11-21 10:03:37,776 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check blacklist","_timestamp":1732183417774483,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,776 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check isolated projects","_timestamp":1732183417774485,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,776 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check isolated projects","_timestamp":1732183417774488,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,776 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Report Configure Events","_timestamp":1732183417774490,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,776 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Report Configure Events","_timestamp":1732183417774549,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,776 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save and compact","_timestamp":1732183417774551,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,777 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":1732183417775602,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,777 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":1732183417775614,"_typename":"NEvent.TInternalCacheSaverStats","ymake_run_uid":0} 2024-11-21 10:03:37,777 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"FS cache has been saved...\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417775622,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,777 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Deps cache has been saved...\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417775627,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,777 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save and compact","_timestamp":1732183417776936,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,777 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Detect loops","_timestamp":1732183417776944,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,777 DEBUG (build.ya_make) [Misc-03] Configure message {"HasContentChanges":true,"HasStructuralChanges":true,"_timestamp":1732183417777410,"_typename":"NEvent.TGraphChanges","ymake_run_uid":0} 2024-11-21 10:03:37,777 DEBUG (build.ya_make) [Misc-02] Configure message {"DoubleValue":0.1058193117,"Name":"EYmakeStats::ConfigureGraphTime","Type":"double","_timestamp":1732183417777608,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:03:37,778 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Detect loops","_timestamp":1732183417777563,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,778 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Configure graph","_timestamp":1732183417777632,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,778 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Apply Dependency Management","_timestamp":1732183417777568,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,778 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Searching target '.'\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417777641,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,778 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save Dependency management cache","_timestamp":1732183417778060,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,778 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Selected target '$S' with id 3\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417777649,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,778 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"DM cache has been saved...\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417778210,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,778 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Find Lost Includes","_timestamp":1732183417777705,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,779 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save Dependency management cache","_timestamp":1732183417778215,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,779 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":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417777791,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,779 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Apply Dependency Management","_timestamp":1732183417778217,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,779 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Find Lost Includes","_timestamp":1732183417777795,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,779 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Modules requiring dependency management: 0; BFS traversals performed: 0\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417778221,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,779 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Fill package outputs","_timestamp":1732183417778260,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,779 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Fill package outputs","_timestamp":1732183417778263,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,779 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"loaded size = 9023798; load time = 11808; loaded MD5 time = 1009; Max loaded MD5 time = 201; loaded count = 2174; max load time = 93; mapped size = 40632376; mapped MD5 time = 11132; Max mapped MD5 time = 753; mapped count = 130; map time = 864; from patch count = 0; from patch size = 0; file stat count = 3223; lstat count = 3045; lstat sum us = 3247; lstat min us = 1; lstat avr us = 1; lstat max us = 13; opendir count = 388; opendir sum us = 0; opendir min us = 0; opendir avr us = 0; opendir max us = 0; readdir count = 2837; readdir sum us = 2392; readdir min us = 0; readdir avr us = 0; readdir max us = 41; (opendir + readdir) sum us = 2392; (lstat + opendir + readdir) sum us = 5639;","Mod":"unimp","Sub":"File access stats","Type":"Debug","_timestamp":1732183417777834,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,779 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1732183417778269,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,779 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1732183417778448,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,780 DEBUG (build.ya_make) [Misc-02] Configure message {"FileStatCount":3223,"FromPatchCount":0,"FromPatchSize":0,"ListDirSumUs":2392,"LoadTime":11808,"LoadedCount":2174,"LoadedMD5Time":1009,"LoadedSize":9023798,"LstatAvrUs":1,"LstatCount":3045,"LstatListDirSumUs":5639,"LstatMaxUs":13,"LstatMinUs":1,"LstatSumUs":3247,"MapTime":864,"MappedCount":130,"MappedMD5Time":11132,"MappedSize":40632376,"MaxLoadTime":93,"MaxLoadedMD5Time":201,"MaxMappedMD5Time":753,"OpendirAvrUs":0,"OpendirCount":388,"OpendirMaxUs":0,"OpendirMinUs":0,"OpendirSumUs":0,"ReaddirAvrUs":0,"ReaddirCount":2837,"ReaddirMaxUs":41,"ReaddirMinUs":0,"ReaddirSumUs":2392,"_timestamp":1732183417777848,"_typename":"NEvent.TFileConfStats","ymake_run_uid":1} 2024-11-21 10:03:37,780 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Find missing peerdirs","_timestamp":1732183417778479,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,780 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":9023798,"Name":"EFileConfStats::LoadedSize","Type":"int","_timestamp":1732183417777861,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:03:37,780 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Find missing peerdirs","_timestamp":1732183417779252,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,780 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":11808,"Name":"EFileConfStats::LoadTime","Type":"int","_timestamp":1732183417777865,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:03:37,780 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Export JSON","_timestamp":1732183417779324,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,780 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":2174,"Name":"EFileConfStats::LoadedCount","Type":"int","_timestamp":1732183417777868,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:03:37,780 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Write JSON","_timestamp":1732183417779331,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,780 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":40632376,"Name":"EFileConfStats::MappedSize","Type":"int","_timestamp":1732183417777871,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:03:37,780 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Exporting JSON\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417779337,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,781 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":864,"Name":"EFileConfStats::MapTime","Type":"int","_timestamp":1732183417777874,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:03:37,781 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Visit JSON","_timestamp":1732183417779342,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,781 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":130,"Name":"EFileConfStats::MappedCount","Type":"int","_timestamp":1732183417777877,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:03:37,781 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":2304,"Name":"EFileConfStats::Count","Type":"int","_timestamp":1732183417777880,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:03:37,781 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"bucket id = 0; loaded size = 9023798; load time = 11808; loaded count = 2174; max load time = 93;","Mod":"unimp","Sub":"Bucket #0","Type":"Debug","_timestamp":1732183417777888,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,781 DEBUG (build.ya_make) [Misc-02] Configure message {"BucketId":0,"LoadTime":11808,"LoadedCount":2174,"LoadedSize":9023798,"MaxLoadTime":93,"_timestamp":1732183417777893,"_typename":"NEvent.TFileConfSubStats","ymake_run_uid":1} 2024-11-21 10:03:37,781 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"parse time = 3; parsed files count = 6; parsed files size = 12965; parsed files recovered = 0; .in files count = 0; .in files size = 0;","Mod":"unimp","Sub":"Parsing stats","Type":"Debug","_timestamp":1732183417777905,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,781 DEBUG (build.ya_make) [Misc-02] Configure message {"InFilesCount":0,"InFilesSize":0,"ParseTime":3,"ParsedFilesCount":6,"ParsedFilesRecovered":0,"ParsedFilesSize":12965,"_timestamp":1732183417777910,"_typename":"NEvent.TIncParserManagerStats","ymake_run_uid":1} 2024-11-21 10:03:37,781 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":1732183417777925,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,782 DEBUG (build.ya_make) [Misc-02] Configure message {"Count":8,"Includes":12,"Size":1264,"UniqueCount":8,"UniqueSize":853,"_timestamp":1732183417777930,"_typename":"NEvent.TGeneralParserStats","ymake_run_uid":1} 2024-11-21 10:03:37,782 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":1732183417777946,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,782 DEBUG (build.ya_make) [Misc-02] Configure message {"CommandsCount":142,"EdgesCount":12363,"FilesCount":3263,"NodesCount":2825,"_timestamp":1732183417777949,"_typename":"NEvent.TDepGraphStats","ymake_run_uid":1} 2024-11-21 10:03:37,782 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"nuke mod dir = 0;","Mod":"unimp","Sub":"UpdIter stats","Type":"Debug","_timestamp":1732183417777955,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,782 DEBUG (build.ya_make) [Misc-02] Configure message {"NukedDir":0,"_timestamp":1732183417777958,"_typename":"NEvent.TUpdIterStats","ymake_run_uid":1} 2024-11-21 10:03:37,782 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":1732183417777966,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,782 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Visit JSON","_timestamp":1732183417782653,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,782 DEBUG (build.ya_make) [Misc-02] Configure message {"IncludesAttempted":0,"IncludesFromCache":0,"ResolveAsKnownFromCache":0,"ResolveAsKnownTotal":0,"_timestamp":1732183417777971,"_typename":"NEvent.TResolveStats","ymake_run_uid":1} 2024-11-21 10:03:37,782 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Render JSON","_timestamp":1732183417782675,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,783 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Build graph","_timestamp":1732183417777974,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,783 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":1732183417778088,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,783 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Store inputs in JSON cache: enabled\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417782690,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,783 DEBUG (build.ya_make) [Misc-02] Configure message {"Accessed":19,"Loaded":0,"Outdated":0,"Parsed":19,"Total":19,"_timestamp":1732183417778092,"_typename":"NEvent.TModulesStats","ymake_run_uid":1} 2024-11-21 10:03:37,783 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":19,"Name":"EModulesStats::Accessed","Type":"int","_timestamp":1732183417778097,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:03:37,783 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":0,"Name":"EModulesStats::Loaded","Type":"int","_timestamp":1732183417778100,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:03:37,783 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":0,"Name":"EModulesStats::Outdated","Type":"int","_timestamp":1732183417778103,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:03:37,783 DEBUG (build.ya_make) [Misc-02] Configure message {"IntValue":19,"Name":"EModulesStats::Parsed","Type":"int","_timestamp":1732183417778106,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:03:37,783 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Set reachable nodes","_timestamp":1732183417778116,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,784 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Set reachable nodes","_timestamp":1732183417778756,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,784 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Sort edges","_timestamp":1732183417778760,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,784 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Sort edges","_timestamp":1732183417781590,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,784 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1732183417781597,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,784 DEBUG (_ToolTargetsQueue) [MainThread] Source_id=0 (default-linux-x86_64-release-asan-pic). Tool targets: set() 2024-11-21 10:03:37,784 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=waiting-tool-targets, group=graph, time=1732183417.7845554 2024-11-21 10:03:37,784 DEBUG (core.stages_profiler) [MainThread] Set stage waiting-tool-targets_finished=1732183417.7845554 2024-11-21 10:03:37,784 DEBUG (core.profiler) [MainThread] Profile step waiting-tool-targets_finished - 1732183417.7845554 2024-11-21 10:03:37,784 DEBUG (build.graph) [MainThread] Empty tool targets list 2024-11-21 10:03:37,784 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=get-tools, group=graph, time=1732183417.784908 2024-11-21 10:03:37,784 DEBUG (core.stages_profiler) [MainThread] Set stage get-tools_finished=1732183417.784908 2024-11-21 10:03:37,785 DEBUG (core.profiler) [MainThread] Profile step get-tools_finished - 1732183417.784908 2024-11-21 10:03:37,785 DEBUG (core.stage_tracer) [MainThread] Start stage tag=merge-target-graphs-1, group=graph, time=1732183417.785111 2024-11-21 10:03:37,785 DEBUG (core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_started=1732183417.785111 2024-11-21 10:03:37,785 DEBUG (core.profiler) [MainThread] Profile step merge-target-graphs-1_started - 1732183417.785111 2024-11-21 10:03:37,785 DEBUG (core.stage_tracer) [MainThread] Start stage tag=wait-target-graphs-1, group=graph, time=1732183417.7853374 2024-11-21 10:03:37,785 DEBUG (core.stages_profiler) [MainThread] Set stage wait-target-graphs-1_started=1732183417.7853374 2024-11-21 10:03:37,785 DEBUG (core.profiler) [MainThread] Profile step wait-target-graphs-1_started - 1732183417.7853374 2024-11-21 10:03:37,785 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1732183417781652,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,785 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check blacklist","_timestamp":1732183417781655,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,785 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check blacklist","_timestamp":1732183417781657,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,785 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check isolated projects","_timestamp":1732183417781660,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,785 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check isolated projects","_timestamp":1732183417781662,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,786 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Report Configure Events","_timestamp":1732183417781665,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,786 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Report Configure Events","_timestamp":1732183417781727,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,786 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save and compact","_timestamp":1732183417781729,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,786 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":1732183417782778,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,786 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":1732183417782790,"_typename":"NEvent.TInternalCacheSaverStats","ymake_run_uid":1} 2024-11-21 10:03:37,786 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"FS cache has been saved...\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417782798,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,786 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Deps cache has been saved...\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417782804,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,786 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save and compact","_timestamp":1732183417783950,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,786 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Detect loops","_timestamp":1732183417783956,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,787 DEBUG (build.ya_make) [Misc-02] Configure message {"HasContentChanges":true,"HasStructuralChanges":true,"_timestamp":1732183417784417,"_typename":"NEvent.TGraphChanges","ymake_run_uid":1} 2024-11-21 10:03:37,787 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Detect loops","_timestamp":1732183417784452,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,787 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Apply Dependency Management","_timestamp":1732183417784455,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,787 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save Dependency management cache","_timestamp":1732183417784923,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,787 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"DM cache has been saved...\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417785050,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,787 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save Dependency management cache","_timestamp":1732183417785055,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,787 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Apply Dependency Management","_timestamp":1732183417785057,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,787 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Modules requiring dependency management: 0; BFS traversals performed: 0\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417785061,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,787 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Fill package outputs","_timestamp":1732183417785097,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,788 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Fill package outputs","_timestamp":1732183417785099,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,788 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1732183417785104,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,788 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1732183417785263,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,788 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Find missing peerdirs","_timestamp":1732183417785288,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,788 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Find missing peerdirs","_timestamp":1732183417786032,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,788 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Export JSON","_timestamp":1732183417786095,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,788 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Write JSON","_timestamp":1732183417786101,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,788 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Exporting JSON\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417786107,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,788 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Visit JSON","_timestamp":1732183417786111,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,789 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Visit JSON","_timestamp":1732183417789394,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,789 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Render JSON","_timestamp":1732183417789406,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,789 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Store inputs in JSON cache: enabled\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417789419,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,791 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":1732183417790852,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,791 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":1732183417790861,"_typename":"NEvent.TJsonCacheStats","ymake_run_uid":0} 2024-11-21 10:03:37,791 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"JSON cache report: disabled\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417790870,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,791 DEBUG (build.ya_make) [Misc-03] Configure message {"DoubleValue":0.00820196323,"Name":"EYmakeStats::RenderJSONTime","Type":"double","_timestamp":1732183417790882,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:03:37,791 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Render JSON","_timestamp":1732183417790890,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,791 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save Uids cache","_timestamp":1732183417790893,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2024-11-21 10:03:37,791 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Uids cache has been saved...\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417791786,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,791 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Save Uids cache","_timestamp":1732183417791793,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,792 DEBUG (build.ya_make) [Misc-03] Configure message {"HasRenderedNodeChanges":true,"_timestamp":1732183417791808,"_typename":"NEvent.TNodeChanges","ymake_run_uid":0} 2024-11-21 10:03:37,792 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":1732183417791824,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,792 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":1732183417791831,"_typename":"NEvent.TUidsCacheStats","ymake_run_uid":0} 2024-11-21 10:03:37,792 DEBUG (build.ya_make) [Misc-03] Configure message {"DoubleValue":0.01257558449,"Name":"EYmakeStats::WriteJSONTime","Type":"double","_timestamp":1732183417791911,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:03:37,792 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Write JSON","_timestamp":1732183417791916,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,792 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"Export JSON","_timestamp":1732183417791941,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,792 DEBUG (build.ya_make) [Misc-03] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedUidsCache","Type":"bool","_timestamp":1732183417791945,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:03:37,792 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":1732183417791955,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,792 DEBUG (build.ya_make) [Misc-03] Configure message {"InitModuleEnv":13,"InitModuleEnvCalls":13,"_timestamp":1732183417791960,"_typename":"NEvent.TMakeCommandStats","ymake_run_uid":0} 2024-11-21 10:03:37,795 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"FS cache has been committed...\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417794921,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,795 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Deps cache has been committed...\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417794941,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,795 DEBUG (build.ya_make) [Misc-03] Configure message {"_timestamp":1732183417794947,"_typename":"NEvent.TReadyForUpdateCacheInfo","ymake_run_uid":0} 2024-11-21 10:03:37,795 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"DM cache has been committed...\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417794961,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,795 DEBUG (build.ya_make) [Misc-03] Configure message {"Message":"Uids cache has been committed...\n","Mod":"unimp","PID":2180903,"Sub":"","Type":"Debug","_timestamp":1732183417794972,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2024-11-21 10:03:37,795 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"ymake main","_timestamp":1732183417795700,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2024-11-21 10:03:37,795 DEBUG (build.ya_make) [Misc-03] Configure message {"DoubleValue":0.4893402865,"Name":"EYmakeStats::RunTime","Type":"double","_timestamp":1732183417795715,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2024-11-21 10:03:37,795 DEBUG (build.ya_make) [Misc-03] Configure message {"StageName":"ymake run","_timestamp":1732183417795721,"_typename":"NEvent.TStageFinished","debug_id":"default-linux-x86_64-release-asan-nopic","ymake_run_uid":0} 2024-11-21 10:03:37,797 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":1732183417797618,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,798 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":1732183417797627,"_typename":"NEvent.TJsonCacheStats","ymake_run_uid":1} 2024-11-21 10:03:37,798 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"JSON cache report: disabled\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417797636,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,798 DEBUG (build.ya_make) [Misc-02] Configure message {"DoubleValue":0.00823465932,"Name":"EYmakeStats::RenderJSONTime","Type":"double","_timestamp":1732183417797645,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:03:37,798 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Render JSON","_timestamp":1732183417797650,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,798 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save Uids cache","_timestamp":1732183417797653,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2024-11-21 10:03:37,798 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Uids cache has been saved...\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417798529,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,798 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Save Uids cache","_timestamp":1732183417798536,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,798 DEBUG (build.ya_make) [Misc-02] Configure message {"HasRenderedNodeChanges":true,"_timestamp":1732183417798549,"_typename":"NEvent.TNodeChanges","ymake_run_uid":1} 2024-11-21 10:03:37,798 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":1732183417798563,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,799 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":1732183417798569,"_typename":"NEvent.TUidsCacheStats","ymake_run_uid":1} 2024-11-21 10:03:37,799 DEBUG (build.ya_make) [Misc-02] Configure message {"DoubleValue":0.01254548545,"Name":"EYmakeStats::WriteJSONTime","Type":"double","_timestamp":1732183417798650,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:03:37,799 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Write JSON","_timestamp":1732183417798654,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,799 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"Export JSON","_timestamp":1732183417798687,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,799 DEBUG (build.ya_make) [Misc-02] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedUidsCache","Type":"bool","_timestamp":1732183417798690,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:03:37,799 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":1732183417798699,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,799 DEBUG (build.ya_make) [Misc-02] Configure message {"InitModuleEnv":13,"InitModuleEnvCalls":13,"_timestamp":1732183417798704,"_typename":"NEvent.TMakeCommandStats","ymake_run_uid":1} 2024-11-21 10:03:37,801 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"FS cache has been committed...\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417800931,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,801 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Deps cache has been committed...\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417800949,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,801 DEBUG (build.ya_make) [Misc-02] Configure message {"_timestamp":1732183417800955,"_typename":"NEvent.TReadyForUpdateCacheInfo","ymake_run_uid":1} 2024-11-21 10:03:37,801 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"DM cache has been committed...\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417800969,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,801 DEBUG (build.ya_make) [Misc-02] Configure message {"Message":"Uids cache has been committed...\n","Mod":"unimp","PID":2180905,"Sub":"","Type":"Debug","_timestamp":1732183417800981,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2024-11-21 10:03:37,801 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"ymake main","_timestamp":1732183417801777,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2024-11-21 10:03:37,801 DEBUG (build.ya_make) [Misc-02] Configure message {"DoubleValue":0.4921182771,"Name":"EYmakeStats::RunTime","Type":"double","_timestamp":1732183417801792,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2024-11-21 10:03:37,802 DEBUG (build.ya_make) [Misc-02] Configure message {"StageName":"ymake run","_timestamp":1732183417801797,"_typename":"NEvent.TStageFinished","debug_id":"default-linux-x86_64-release-asan-pic","ymake_run_uid":1} 2024-11-21 10:03:37,804 DEBUG (build.ymake2.run_ymake) [Misc-03] run '/home/runner/.ya/tools/v4/7478219259/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/yatmpt1i3jze1 --config /home/runner/.ya/build/conf/dist-release-x-cb5eba878ca077f1101a8edae3aeca44/ymake.conf --plugins-root /home/runner/actions_runner/_work/ydb/ydb/build/plugins,/home/runner/actions_runner/_work/ydb/ydb/build/internal/plugins --build-root /home/runner/.ya/build/conf/dist-release-x-cb5eba878ca077f1101a8edae3aeca44_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.fzi37vfr/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.fzi37vfr/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' finished 2024-11-21 10:03:37,805 DEBUG (build.ymake2) [Misc-03] ymake_run_info: {"ymake_run_uid":0,"stats":{"preparing":{"start":1732183417.295193910598755,"finish":1732183417.295803308486938,"duration":0.000609397888184},"execution":{"start":1732183417.295804262161255,"finish":1732183417.804934501647949,"duration":0.509130239486694},"postprocessing":{"start":1732183417.804936408996582,"finish":1732183417.805134773254394,"duration":0.000198364257812}},"purpose":"default-linux-x86_64-release-asan-nopic","caches":{"FS cache":{"loaded":false,"saved":true,"loading_enabled":true,"saving_enabled":true,"committed":true},"Deps cache":{"loaded":false,"saved":true,"loading_enabled":true,"saving_enabled":true,"committed":true},"DepManagement cache":{"loaded":false,"saved":false,"loading_enabled":true,"saving_enabled":true},"Uids cache":{"loaded":false,"saved":true,"loading_enabled":true,"saving_enabled":true,"committed":true},"DM cache":{"loaded":false,"saved":true,"loading_enabled":false,"saving_enabled":false,"committed":true}},"stages":{"ymake run":{"start":1732183417.306341886520386,"finish":1732183417.795721054077148,"duration":0.489379167556763},"Load configuration from cache":{"start":1732183417.306540012359619,"finish":1732183417.306555986404419,"duration":0.0000159740448},"Load configuration (no cache)":{"start":1732183417.30687403678894,"finish":1732183417.487879037857056,"duration":0.181005001068115},"Compile and RecalcAll conditions":{"start":1732183417.487911939620972,"finish":1732183417.489612102508545,"duration":0.001700162887573},"Fold global commands":{"start":1732183417.489628076553345,"finish":1732183417.491022109985352,"duration":0.001394033432007},"Load plugins":{"start":1732183417.491030931472778,"finish":1732183417.626424074172974,"duration":0.135393142700195},"ymake main":{"start":1732183417.660094976425171,"finish":1732183417.795700073242188,"duration":0.135605096817017},"Build graph":{"start":1732183417.661258935928345,"finish":1732183417.770931005477905,"duration":0.109672069549561},"Configure graph":{"start":1732183417.661278963088989,"finish":1732183417.770553112030029,"duration":0.10927414894104},"Find Lost Includes":{"start":1732183417.770636081695557,"finish":1732183417.770736932754517,"duration":0.00010085105896},"Set reachable nodes":{"start":1732183417.771081924438476,"finish":1732183417.771722078323364,"duration":0.000640153884888},"Sort edges":{"start":1732183417.771724939346314,"finish":1732183417.77442193031311,"duration":0.002696990966797},"Report Foreign Platform Events":{"start":1732183417.774426937103272,"finish":1732183417.774477958679199,"duration":0.000051021575928},"Check blacklist":{"start":1732183417.774480104446411,"finish":1732183417.77448296546936,"duration":0.000002861022949},"Check isolated projects":{"start":1732183417.774485111236572,"finish":1732183417.774487972259522,"duration":0.000002861022949},"Report Configure Events":{"start":1732183417.774490118026733,"finish":1732183417.774549007415772,"duration":0.000058889389038},"Save and compact":{"start":1732183417.774550914764404,"finish":1732183417.776936054229736,"duration":0.002385139465332},"Detect loops":{"start":1732183417.776943922042847,"finish":1732183417.777563095092774,"duration":0.000619173049927},"Apply Dependency Management":{"start":1732183417.777568101882935,"finish":1732183417.778217077255249,"duration":0.000648975372314},"Save Dependency management cache":{"start":1732183417.778059959411621,"finish":1732183417.778214931488037,"duration":0.000154972076416},"Fill package outputs":{"start":1732183417.778259992599487,"finish":1732183417.778263092041016,"duration":0.000003099441528},"Check Transitive Requirements":{"start":1732183417.778269052505493,"finish":1732183417.778448104858398,"duration":0.000179052352905},"Find missing peerdirs":{"start":1732183417.778479099273682,"finish":1732183417.779252052307129,"duration":0.000772953033447},"Export JSON":{"start":1732183417.779324054718018,"finish":1732183417.791940927505493,"duration":0.012616872787476},"Write JSON":{"start":1732183417.779330968856812,"finish":1732183417.791915893554688,"duration":0.012584924697876},"Visit JSON":{"start":1732183417.77934193611145,"finish":1732183417.782653093338013,"duration":0.003311157226562},"Render JSON":{"start":1732183417.78267502784729,"finish":1732183417.790889978408814,"duration":0.008214950561523},"Save Uids cache":{"start":1732183417.790893077850342,"finish":1732183417.79179310798645,"duration":0.000900030136108}},"metrics":{"File access":{"loaded size":9023798,"load time":12723,"loaded MD5 time":827,"Max loaded MD5 time":9,"loaded count":2174,"max load time":126,"mapped size":40632376,"mapped MD5 time":12582,"Max mapped MD5 time":931,"mapped count":130,"map time":941,"from patch count":0,"from patch size":0,"file stat count":3223,"lstat count":3045,"lstat sum us":3538,"lstat min us":1,"lstat avr us":1,"lstat max us":21,"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":2463,"readdir min us":0,"readdir avr us":0,"readdir max us":45,"(opendir + readdir) sum us":2463,"(lstat + opendir + readdir) sum us":6001},"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/7478219259/ymake","args":["/home/runner/.ya/tools/v4/7478219259/ymake","--depends-like-recurse","--warn","dirloops,ChkPeers","--write-meta-data","/home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/yatmpt1i3jze1","--config","/home/runner/.ya/build/conf/dist-release-x-cb5eba878ca077f1101a8edae3aeca44/ymake.conf","--plugins-root","/home/runner/actions_runner/_work/ydb/ydb/build/plugins,/home/runner/actions_runner/_work/ydb/ydb/build/internal/plugins","--build-root","/home/runner/.ya/build/conf/dist-release-x-cb5eba878ca077f1101a8edae3aeca44_d357a1f7839b099012272bcb9853ec19","--test-dart","/home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.fzi37vfr/test.dart","--tests-data-root","/home/runner/actions_runner/_work/ydb/arcadia_tests_data","--makefiles-dart","/home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.fzi37vfr/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.509130239486694} 2024-11-21 10:03:37,805 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=load-graph-from-json, group=graph, time=1732183417.8058832 2024-11-21 10:03:37,805 DEBUG (core.stages_profiler) [Misc-03] Set stage load-graph-from-json_started=1732183417.8058832 2024-11-21 10:03:37,806 DEBUG (core.profiler) [Misc-03] Profile step load-graph-from-json_started - 1732183417.8058832 2024-11-21 10:03:37,807 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=load-graph-from-json, group=graph, time=1732183417.8070848 2024-11-21 10:03:37,807 DEBUG (core.stages_profiler) [Misc-03] Set stage load-graph-from-json_finished=1732183417.8070848 2024-11-21 10:03:37,807 DEBUG (core.profiler) [Misc-03] Profile step load-graph-from-json_finished - 1732183417.8070848 2024-11-21 10:03:37,807 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=gen-graph-json-default-linux-x86_64-release-asan-nopic, group=graph, time=1732183417.8073483 2024-11-21 10:03:37,807 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-json-default-linux-x86_64-release-asan-nopic_finished=1732183417.8073483 2024-11-21 10:03:37,807 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-json-default-linux-x86_64-release-asan-nopic_finished - 1732183417.8073483 2024-11-21 10:03:37,807 DEBUG (core.stage_tracer) [Misc-03] Start stage tag=gen-tests-default-linux-x86_64-release-asan-nopic, group=graph, time=1732183417.807671 2024-11-21 10:03:37,807 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-tests-default-linux-x86_64-release-asan-nopic_started=1732183417.807671 2024-11-21 10:03:37,807 DEBUG (core.profiler) [Misc-03] Profile step gen-tests-default-linux-x86_64-release-asan-nopic_started - 1732183417.807671 2024-11-21 10:03:37,812 DEBUG (build.graph) [Misc-03] Found 0 tests 2024-11-21 10:03:37,812 DEBUG (build.ymake2.run_ymake) [Misc-02] run '/home/runner/.ya/tools/v4/7478219259/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/yatmp0zcl3vdb --config /home/runner/.ya/build/conf/dist-release-x-c0320386d16751174993c26b890d64d8/ymake.conf --plugins-root /home/runner/actions_runner/_work/ydb/ydb/build/plugins,/home/runner/actions_runner/_work/ydb/ydb/build/internal/plugins --build-root /home/runner/.ya/build/conf/dist-release-x-c0320386d16751174993c26b890d64d8_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.d1sebg74/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.d1sebg74/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' finished 2024-11-21 10:03:37,812 DEBUG (exts.timer) [Misc-03] Timer gen_tests, stage generate tests: 0.00039315223693847656 2024-11-21 10:03:37,812 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=gen-tests-default-linux-x86_64-release-asan-nopic, group=graph, time=1732183417.8129697 2024-11-21 10:03:37,813 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-tests-default-linux-x86_64-release-asan-nopic_finished=1732183417.8129697 2024-11-21 10:03:37,813 DEBUG (core.profiler) [Misc-03] Profile step gen-tests-default-linux-x86_64-release-asan-nopic_finished - 1732183417.8129697 2024-11-21 10:03:37,813 DEBUG (core.stage_tracer) [Misc-03] Finish stage tag=gen-graph-default-linux-x86_64-release-asan-nopic, group=graph, time=1732183417.8133607 2024-11-21 10:03:37,813 DEBUG (core.event_handling.base_subscriber) [Misc-02] Unsubscribing PrintProgressSubscriber from event_queue 2024-11-21 10:03:37,813 DEBUG (core.stages_profiler) [Misc-03] Set stage gen-graph-default-linux-x86_64-release-asan-nopic_finished=1732183417.8133607 2024-11-21 10:03:37,813 DEBUG (core.profiler) [Misc-03] Profile step gen-graph-default-linux-x86_64-release-asan-nopic_finished - 1732183417.8133607 2024-11-21 10:03:37,814 DEBUG (build.ymake2) [Misc-02] ymake_run_info: {"ymake_run_uid":1,"stats":{"preparing":{"start":1732183417.300884008407593,"finish":1732183417.301513671875,"duration":0.000629663467407},"execution":{"start":1732183417.301514387130737,"finish":1732183417.812870025634766,"duration":0.511355638504028},"postprocessing":{"start":1732183417.812871932983398,"finish":1732183417.813905954360962,"duration":0.001034021377563}},"purpose":"default-linux-x86_64-release-asan-pic","caches":{"FS cache":{"loaded":false,"saved":true,"loading_enabled":true,"saving_enabled":true,"committed":true},"Deps cache":{"loaded":false,"saved":true,"loading_enabled":true,"saving_enabled":true,"committed":true},"DepManagement cache":{"loaded":false,"saved":false,"loading_enabled":true,"saving_enabled":true},"Uids cache":{"loaded":false,"saved":true,"loading_enabled":true,"saving_enabled":true,"committed":true},"DM cache":{"loaded":false,"saved":true,"loading_enabled":false,"saving_enabled":false,"committed":true}},"stages":{"ymake run":{"start":1732183417.309653043746948,"finish":1732183417.801796913146973,"duration":0.492143869400024},"Load configuration from cache":{"start":1732183417.309807062149048,"finish":1732183417.309820890426636,"duration":0.000013828277588},"Load configuration (no cache)":{"start":1732183417.310113906860352,"finish":1732183417.501169919967651,"duration":0.1910560131073},"Compile and RecalcAll conditions":{"start":1732183417.501198053359985,"finish":1732183417.50322699546814,"duration":0.002028942108154},"Fold global commands":{"start":1732183417.503242969512939,"finish":1732183417.504642009735107,"duration":0.001399040222168},"Load plugins":{"start":1732183417.50465202331543,"finish":1732183417.637811899185181,"duration":0.133159875869751},"ymake main":{"start":1732183417.670667886734009,"finish":1732183417.801776885986328,"duration":0.131108999252319},"Build graph":{"start":1732183417.671757936477661,"finish":1732183417.777973890304565,"duration":0.106215953826904},"Configure graph":{"start":1732183417.671776056289673,"finish":1732183417.777631998062134,"duration":0.105855941772461},"Find Lost Includes":{"start":1732183417.777704954147339,"finish":1732183417.777795076370239,"duration":0.0000901222229},"Set reachable nodes":{"start":1732183417.77811598777771,"finish":1732183417.778755903244018,"duration":0.000639915466309},"Sort edges":{"start":1732183417.778759956359863,"finish":1732183417.781589984893799,"duration":0.002830028533936},"Report Foreign Platform Events":{"start":1732183417.781596899032593,"finish":1732183417.781651973724365,"duration":0.000055074691772},"Check blacklist":{"start":1732183417.781655073165894,"finish":1732183417.781656980514526,"duration":0.000001907348633},"Check isolated projects":{"start":1732183417.781660079956055,"finish":1732183417.781661987304688,"duration":0.000001907348633},"Report Configure Events":{"start":1732183417.781665086746216,"finish":1732183417.781727075576782,"duration":0.000061988830566},"Save and compact":{"start":1732183417.781728982925415,"finish":1732183417.783950090408325,"duration":0.00222110748291},"Detect loops":{"start":1732183417.783956050872803,"finish":1732183417.784451961517334,"duration":0.000495910644531},"Apply Dependency Management":{"start":1732183417.784455060958862,"finish":1732183417.785057067871094,"duration":0.000602006912231},"Save Dependency management cache":{"start":1732183417.784923076629639,"finish":1732183417.785054922103882,"duration":0.000131845474243},"Fill package outputs":{"start":1732183417.785096883773804,"finish":1732183417.785099029541016,"duration":0.000002145767212},"Check Transitive Requirements":{"start":1732183417.785104036331177,"finish":1732183417.785263061523438,"duration":0.000159025192261},"Find missing peerdirs":{"start":1732183417.785288095474243,"finish":1732183417.78603196144104,"duration":0.000743865966797},"Export JSON":{"start":1732183417.786094903945923,"finish":1732183417.798686981201172,"duration":0.012592077255249},"Write JSON":{"start":1732183417.78610110282898,"finish":1732183417.798654079437256,"duration":0.012552976608276},"Visit JSON":{"start":1732183417.786111116409302,"finish":1732183417.789393901824951,"duration":0.003282785415649},"Render JSON":{"start":1732183417.789406061172485,"finish":1732183417.797650098800659,"duration":0.008244037628174},"Save Uids cache":{"start":1732183417.797652959823608,"finish":1732183417.798536062240601,"duration":0.000883102416992}},"metrics":{"File access":{"loaded size":9023798,"load time":11808,"loaded MD5 time":1009,"Max loaded MD5 time":201,"loaded count":2174,"max load time":93,"mapped size":40632376,"mapped MD5 time":11132,"Max mapped MD5 time":753,"mapped count":130,"map time":864,"from patch count":0,"from patch size":0,"file stat count":3223,"lstat count":3045,"lstat sum us":3247,"lstat min us":1,"lstat avr us":1,"lstat max us":13,"opendir count":388,"opendir sum us":0,"opendir min us":0,"opendir avr us":0,"opendir max us":0,"readdir count":2837,"readdir sum us":2392,"readdir min us":0,"readdir avr us":0,"readdir max us":41,"(opendir + readdir) sum us":2392,"(lstat + opendir + readdir) sum us":5639},"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/7478219259/ymake","args":["/home/runner/.ya/tools/v4/7478219259/ymake","--depends-like-recurse","--warn","dirloops,ChkPeers","--write-meta-data","/home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/yatmp0zcl3vdb","--config","/home/runner/.ya/build/conf/dist-release-x-c0320386d16751174993c26b890d64d8/ymake.conf","--plugins-root","/home/runner/actions_runner/_work/ydb/ydb/build/plugins,/home/runner/actions_runner/_work/ydb/ydb/build/internal/plugins","--build-root","/home/runner/.ya/build/conf/dist-release-x-c0320386d16751174993c26b890d64d8_d357a1f7839b099012272bcb9853ec19","--test-dart","/home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.d1sebg74/test.dart","--tests-data-root","/home/runner/actions_runner/_work/ydb/arcadia_tests_data","--makefiles-dart","/home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.d1sebg74/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.511355638504028} 2024-11-21 10:03:37,814 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=load-graph-from-json, group=graph, time=1732183417.814641 2024-11-21 10:03:37,814 DEBUG (core.stages_profiler) [Misc-02] Set stage load-graph-from-json_started=1732183417.814641 2024-11-21 10:03:37,814 DEBUG (core.profiler) [Misc-02] Profile step load-graph-from-json_started - 1732183417.814641 2024-11-21 10:03:37,815 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=load-graph-from-json, group=graph, time=1732183417.815441 2024-11-21 10:03:37,815 DEBUG (core.stages_profiler) [Misc-02] Set stage load-graph-from-json_finished=1732183417.815441 2024-11-21 10:03:37,815 DEBUG (core.profiler) [Misc-02] Profile step load-graph-from-json_finished - 1732183417.815441 2024-11-21 10:03:37,815 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=gen-graph-json-default-linux-x86_64-release-asan-pic, group=graph, time=1732183417.8157043 2024-11-21 10:03:37,815 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-json-default-linux-x86_64-release-asan-pic_finished=1732183417.8157043 2024-11-21 10:03:37,815 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-json-default-linux-x86_64-release-asan-pic_finished - 1732183417.8157043 2024-11-21 10:03:37,815 DEBUG (core.stage_tracer) [Misc-02] Start stage tag=gen-tests-default-linux-x86_64-release-asan-pic, group=graph, time=1732183417.8159456 2024-11-21 10:03:37,816 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-tests-default-linux-x86_64-release-asan-pic_started=1732183417.8159456 2024-11-21 10:03:37,816 DEBUG (core.profiler) [Misc-02] Profile step gen-tests-default-linux-x86_64-release-asan-pic_started - 1732183417.8159456 2024-11-21 10:03:37,816 DEBUG (build.graph) [Misc-02] Found 0 tests 2024-11-21 10:03:37,816 DEBUG (exts.timer) [Misc-02] Timer gen_tests, stage generate tests: 9.894371032714844e-05 2024-11-21 10:03:37,816 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=gen-tests-default-linux-x86_64-release-asan-pic, group=graph, time=1732183417.8162837 2024-11-21 10:03:37,816 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-tests-default-linux-x86_64-release-asan-pic_finished=1732183417.8162837 2024-11-21 10:03:37,816 DEBUG (core.profiler) [Misc-02] Profile step gen-tests-default-linux-x86_64-release-asan-pic_finished - 1732183417.8162837 2024-11-21 10:03:37,816 DEBUG (core.stage_tracer) [Misc-02] Finish stage tag=gen-graph-default-linux-x86_64-release-asan-pic, group=graph, time=1732183417.8164933 2024-11-21 10:03:37,816 DEBUG (core.stages_profiler) [Misc-02] Set stage gen-graph-default-linux-x86_64-release-asan-pic_finished=1732183417.8164933 2024-11-21 10:03:37,816 DEBUG (core.profiler) [Misc-02] Profile step gen-graph-default-linux-x86_64-release-asan-pic_finished - 1732183417.8164933 2024-11-21 10:03:37,816 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage waiting_graphs for default-linux-x86_64-release-asan: 0.031595468521118164 2024-11-21 10:03:37,817 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=wait-target-graphs-1, group=graph, time=1732183417.8170576 2024-11-21 10:03:37,817 DEBUG (core.stages_profiler) [MainThread] Set stage wait-target-graphs-1_finished=1732183417.8170576 2024-11-21 10:03:37,817 DEBUG (core.profiler) [MainThread] Profile step wait-target-graphs-1_finished - 1732183417.8170576 2024-11-21 10:03:37,817 DEBUG (core.stage_tracer) [MainThread] Start stage tag=union-make-files-1, group=graph, time=1732183417.8172534 2024-11-21 10:03:37,817 DEBUG (core.stages_profiler) [MainThread] Set stage union-make-files-1_started=1732183417.8172534 2024-11-21 10:03:37,817 DEBUG (core.profiler) [MainThread] Profile step union-make-files-1_started - 1732183417.8172534 2024-11-21 10:03:37,817 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage union make files for default-linux-x86_64-release-asan: 0.0006039142608642578 2024-11-21 10:03:37,817 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=union-make-files-1, group=graph, time=1732183417.8175764 2024-11-21 10:03:37,817 DEBUG (core.stages_profiler) [MainThread] Set stage union-make-files-1_finished=1732183417.8175764 2024-11-21 10:03:37,817 DEBUG (core.profiler) [MainThread] Profile step union-make-files-1_finished - 1732183417.8175764 2024-11-21 10:03:37,817 DEBUG (core.stage_tracer) [MainThread] Start stage tag=merge-graphs-1, group=graph, time=1732183417.8177207 2024-11-21 10:03:37,817 DEBUG (core.stages_profiler) [MainThread] Set stage merge-graphs-1_started=1732183417.8177207 2024-11-21 10:03:37,817 DEBUG (core.profiler) [MainThread] Profile step merge-graphs-1_started - 1732183417.8177207 2024-11-21 10:03:37,817 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage merge_graphs for default-linux-x86_64-release-asan: 0.0003612041473388672 2024-11-21 10:03:37,817 DEBUG (build.graph) [MainThread] Graph size is 26 after merge_graphs 2024-11-21 10:03:37,818 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=merge-graphs-1, group=graph, time=1732183417.8180606 2024-11-21 10:03:37,818 DEBUG (core.stages_profiler) [MainThread] Set stage merge-graphs-1_finished=1732183417.8180606 2024-11-21 10:03:37,818 DEBUG (core.profiler) [MainThread] Profile step merge-graphs-1_finished - 1732183417.8180606 2024-11-21 10:03:37,818 DEBUG (core.stage_tracer) [MainThread] Start stage tag=strip-graph-1, group=graph, time=1732183417.8182049 2024-11-21 10:03:37,818 DEBUG (core.stages_profiler) [MainThread] Set stage strip-graph-1_started=1732183417.8182049 2024-11-21 10:03:37,818 DEBUG (core.profiler) [MainThread] Profile step strip-graph-1_started - 1732183417.8182049 2024-11-21 10:03:37,818 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage strip_graph for default-linux-x86_64-release-asan: 0.0004527568817138672 2024-11-21 10:03:37,818 DEBUG (build.graph) [MainThread] Graph size is 13 after strip_graph 2024-11-21 10:03:37,818 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=strip-graph-1, group=graph, time=1732183417.818426 2024-11-21 10:03:37,818 DEBUG (core.stages_profiler) [MainThread] Set stage strip-graph-1_finished=1732183417.818426 2024-11-21 10:03:37,818 DEBUG (core.profiler) [MainThread] Profile step strip-graph-1_finished - 1732183417.818426 2024-11-21 10:03:37,818 DEBUG (build.graph) [MainThread] Configuring only non-PIC for test_tool_tc1-global 2024-11-21 10:03:37,819 DEBUG (core.stage_tracer) [Misc-04] Start stage tag=gen-graph-test_tool_tc1-nopic-global, group=graph, time=1732183417.8190582 2024-11-21 10:03:37,819 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-test_tool_tc1-nopic-global_started=1732183417.8190582 2024-11-21 10:03:37,819 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-test_tool_tc1-nopic-global_started - 1732183417.8190582 2024-11-21 10:03:37,819 DEBUG (core.stage_tracer) [Misc-04] Start stage tag=gen-graph-gen-opts-test_tool_tc1-nopic-global, group=graph, time=1732183417.8195357 2024-11-21 10:03:37,819 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-gen-opts-test_tool_tc1-nopic-global_started=1732183417.8195357 2024-11-21 10:03:37,819 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-gen-opts-test_tool_tc1-nopic-global_started - 1732183417.8195357 2024-11-21 10:03:37,819 DEBUG (yalibrary.guards) [Misc-04] Enter guard fetch with value None 2024-11-21 10:03:37,835 DEBUG (build.genconf) [Misc-04] Generating conf into /home/runner/.ya/build/conf/dist-release-7251796a04cd4ce6a7273413cd6c44b2/ymake.conf with cmd ['/home/runner/.ya/tools/a6139abb9c_d/ya-bin', '/home/runner/actions_runner/_work/ydb/ydb/build/ymake_conf.py', '/home/runner/actions_runner/_work/ydb/ydb', 'dist-release', 'no', '--toolchain-params', 'eyJib3R0bGVfbmFtZSI6ImNsYW5nMTgiLCJlbnYiOnsiQ1BBVEgiOlsiIl0sIkxJQlJBUllfUEFUSCI6WyIiXSwiU0RLUk9PVCI6WyIiXX0sImV4ZWN1dGFibGVfcGF0aCI6ImMrKyIsImZsYWdzIjp7IlNBTklUSVpFUl9UWVBFIjoiYWRkcmVzcyJ9LCJmb3JtdWxhIjp7ImJ5X3BsYXRmb3JtIjp7ImRhcndpbi1hcm02NCI6eyJ1cmkiOiJzYnI6NzQ1MTYwMjYwOSJ9LCJkYXJ3aW4teDg2XzY0Ijp7InVyaSI6InNicjo3NDUxNTg1OTYyIn0sImxpbnV4LWFhcmNoNjQiOnsidXJpIjoic2JyOjc0NTE3MTIzMzIifSwibGludXgteDg2XzY0Ijp7InVyaSI6InNicjo3NDUxNDY2NDA3In0sIndpbjMyLXg4Nl82NCI6eyJ1cmkiOiJzYnI6NzQ1MTQwNjkwMCJ9fX0sIm5hbWUiOiJjbGFuZzE4IiwicGFyYW1zIjp7ImNfY29tcGlsZXIiOiIkKENMQU5HLTE3MzUwNTY4MjEpL2Jpbi9jbGFuZyIsImN4eF9jb21waWxlciI6IiQoQ0xBTkctMTczNTA1NjgyMSkvYmluL2NsYW5nKysiLCJnY2NfdmVyc2lvbiI6IjE4IiwibGx2bS1zeW1ib2xpemVyIjoiJChDTEFORy0xNzM1MDU2ODIxKS9iaW4vbGx2bS1zeW1ib2xpemVyIiwibWF0Y2hfcm9vdCI6IkNMQU5HLTE3MzUwNTY4MjEiLCJvYmpjb3B5IjoiJChDTEFORy0xNzM1MDU2ODIxKS9iaW4vbGx2bS1vYmpjb3B5IiwicHJvZmlsZXMiOiIkKFhDT0RFX1RPT0xTX1JPT1Qtc2JyOjc5OTAxNzc3MSkvWGNvZGUvQ29udGVudHMvRGV2ZWxvcGVyL1BsYXRmb3Jtcy9pUGhvbmVPUy5wbGF0Zm9ybS9EZXZlbG9wZXIvTGlicmFyeS9Db3JlU2ltdWxhdG9yL1Byb2ZpbGVzIiwic2ltY3RsIjoiJChYQ09ERV9UT09MU19ST09ULXNicjo3OTkwMTc3NzEpL1hjb2RlL1N5c3RlbVJvb3QvUHJpdmF0ZUZyYW1ld29ya3MvQ29yZVNpbXVsYXRvci5mcmFtZXdvcmsvUmVzb3VyY2VzL2Jpbi9zaW1jdGwiLCJzdHJpcCI6IiQoQ0xBTkctMTczNTA1NjgyMSkvYmluL2xsdm0tc3RyaXAiLCJ0eXBlIjoiY2xhbmciLCJ1c2VfYnVuZGxlIjp0cnVlLCJ3ZXJyb3JfbW9kZSI6ImFsbCJ9LCJwbGF0Zm9ybSI6eyJob3N0Ijp7ImFyY2giOiJ4ODZfNjQiLCJvcyI6IkxJTlVYIiwidG9vbGNoYWluIjoiZGVmYXVsdCIsInZpc2libGVfbmFtZSI6ImNsYW5nMTgifSwidGFyZ2V0Ijp7ImFyY2giOiJ4ODZfNjQiLCJvcyI6IkxJTlVYIiwidG9vbGNoYWluIjoiZGVmYXVsdCIsInZpc2libGVfbmFtZSI6ImNsYW5nMTgifX0sInBsYXRmb3JtX25hbWUiOiJERUZBVUxULUxJTlVYLVg4Nl82NCIsInRvb2xfdmFyIjoiQ0xBTkctMTczNTA1NjgyMSJ9', '-l', '-D', 'APPLE_SDK_LOCAL=yes', '-D', 'CFLAGS=-fno-omit-frame-pointer', '-D', 'CLANG18=yes', '-D', 'FORCE_NO_PIC=yes', '-D', 'IS_CROSS_SANITIZE=yes', '-D', 'IS_CROSS_TOOLS=yes', '-D', 'OPENSOURCE=yes', '-D', 'SANITIZER_TYPE=address', '-D', 'TESTS_REQUESTED=yes', '-D', 'TRAVERSE_DEPENDS=yes', '-D', 'TRAVERSE_RECURSE_FOR_TESTS=yes', '-D', 'USE_AIO=static', '-D', 'USE_CLANG_CL=yes', '-D', 'USE_ICONV=static', '-D', 'USE_IDN=static', '-D', 'USE_PREBUILT_TOOLS=no', '-D', 'YA=yes'] and env {'PATH': '/home/runner/actions_runner/_work/ydb/ydb/ydb/ci/scripts:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/snap/bin', 'Y_PYTHON_ENTRY_POINT': ':main'} 2024-11-21 10:03:37,974 DEBUG (build.genconf) [Misc-04] Copy conf /home/runner/.ya/build/conf/dist-release-7251796a04cd4ce6a7273413cd6c44b2/ymake.conf to /home/runner/.ya/build/conf/dist-release-x-6b047b4e466e327e99f5399682291aa4/ymake.conf 2024-11-21 10:03:37,974 DEBUG (yalibrary.guards) [Misc-04] Exit guard fetch with value None 2024-11-21 10:03:37,974 DEBUG (core.stage_tracer) [Misc-04] Finish stage tag=gen-graph-gen-opts-test_tool_tc1-nopic-global, group=graph, time=1732183417.9748414 2024-11-21 10:03:37,974 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-gen-opts-test_tool_tc1-nopic-global_finished=1732183417.9748414 2024-11-21 10:03:37,974 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-gen-opts-test_tool_tc1-nopic-global_finished - 1732183417.9748414 2024-11-21 10:03:37,975 DEBUG (core.stage_tracer) [Misc-04] Start stage tag=gen-graph-json-test_tool_tc1-nopic-global, group=graph, time=1732183417.9750369 2024-11-21 10:03:37,975 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-json-test_tool_tc1-nopic-global_started=1732183417.9750369 2024-11-21 10:03:37,975 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-json-test_tool_tc1-nopic-global_started - 1732183417.9750369 2024-11-21 10:03:37,975 DEBUG (build.ymake2) [Misc-04] Run gen graph with {'grab_stderr': True, 'mode': 'dist', 'dump_graph': 'json', 'check': True, '_purpose': 'test_tool_tc1-nopic-global', 'cpp': True, 'custom_build_directory': '/home/runner/.ya/build/conf/dist-release-x-6b047b4e466e327e99f5399682291aa4_d357a1f7839b099012272bcb9853ec19', 'build_type': 'release', 'abs_targets': ['/home/runner/actions_runner/_work/ydb/ydb/build/platform/test_tool', '/home/runner/actions_runner/_work/ydb/ydb/build/external_resources/go_tools', '/home/runner/actions_runner/_work/ydb/ydb/build/external_resources/flake8_py2', '/home/runner/actions_runner/_work/ydb/ydb/build/external_resources/flake8_py3', '/home/runner/actions_runner/_work/ydb/ydb/build/platform/java/jstyle_lib'], 'debug_options': [], 'custom_conf': '/home/runner/.ya/build/conf/dist-release-x-6b047b4e466e327e99f5399682291aa4/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 0x7f0afdfcd8a0>, 'enabled_events': 'PSLGE', 'no_caches_on_retry': False, 'no_ymake_retry': False, 'disable_customization': 0, 'dump_tests': '/home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.pisjg7vr/test.dart', 'dump_make_files': '/home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.pisjg7vr/makefiles.dart'} 2024-11-21 10:03:37,975 DEBUG (core.yarg.behaviour) [Misc-04] Found unused args ['grab_stderr'] 2024-11-21 10:03:37,975 DEBUG (build.prefetch) [Misc-04] prefetch disabled 2024-11-21 10:03:37,975 DEBUG (core.event_handling.base_subscriber) [Misc-04] Subscribing PrintProgressSubscriber to event_queue 2024-11-21 10:03:37,975 DEBUG (yalibrary.tools) [Misc-04] Using old-style toolchain for: ymake 2024-11-21 10:03:37,976 DEBUG (build.ymake2.run_ymake) [Misc-04] run: '/home/runner/.ya/tools/v4/7478219259/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/yatmpyy7_n4tm --config /home/runner/.ya/build/conf/dist-release-x-6b047b4e466e327e99f5399682291aa4/ymake.conf --plugins-root /home/runner/actions_runner/_work/ydb/ydb/build/plugins,/home/runner/actions_runner/_work/ydb/ydb/build/internal/plugins --build-root /home/runner/.ya/build/conf/dist-release-x-6b047b4e466e327e99f5399682291aa4_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.pisjg7vr/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.pisjg7vr/makefiles.dart --dump-build-plan - --quiet --events PSLGE /home/runner/actions_runner/_work/ydb/ydb/build/platform/test_tool /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/go_tools /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/flake8_py2 /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/flake8_py3 /home/runner/actions_runner/_work/ydb/ydb/build/platform/java/jstyle_lib' with env: { } 2024-11-21 10:03:38,376 DEBUG (build.ymake2.run_ymake) [Misc-04] run '/home/runner/.ya/tools/v4/7478219259/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/yatmpyy7_n4tm --config /home/runner/.ya/build/conf/dist-release-x-6b047b4e466e327e99f5399682291aa4/ymake.conf --plugins-root /home/runner/actions_runner/_work/ydb/ydb/build/plugins,/home/runner/actions_runner/_work/ydb/ydb/build/internal/plugins --build-root /home/runner/.ya/build/conf/dist-release-x-6b047b4e466e327e99f5399682291aa4_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.pisjg7vr/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.pisjg7vr/makefiles.dart --dump-build-plan - --quiet --events PSLGE /home/runner/actions_runner/_work/ydb/ydb/build/platform/test_tool /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/go_tools /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/flake8_py2 /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/flake8_py3 /home/runner/actions_runner/_work/ydb/ydb/build/platform/java/jstyle_lib' finished 2024-11-21 10:03:38,376 DEBUG (core.event_handling.base_subscriber) [Misc-04] Unsubscribing PrintProgressSubscriber from event_queue 2024-11-21 10:03:38,376 DEBUG (build.ymake2) [Misc-04] ymake_run_info: {"ymake_run_uid":2,"stats":{"preparing":{"start":1732183417.975427389144898,"finish":1732183417.976004362106323,"duration":0.000576972961426},"execution":{"start":1732183417.976004838943482,"finish":1732183418.376340389251709,"duration":0.400335550308228},"postprocessing":{"start":1732183418.376343488693237,"finish":1732183418.376706600189209,"duration":0.000363111495972}},"purpose":"test_tool_tc1-nopic-global","caches":{},"stages":{},"metrics":{},"binary":"/home/runner/.ya/tools/v4/7478219259/ymake","args":["/home/runner/.ya/tools/v4/7478219259/ymake","--depends-like-recurse","--warn","dirloops,ChkPeers","--write-meta-data","/home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/yatmpyy7_n4tm","--config","/home/runner/.ya/build/conf/dist-release-x-6b047b4e466e327e99f5399682291aa4/ymake.conf","--plugins-root","/home/runner/actions_runner/_work/ydb/ydb/build/plugins,/home/runner/actions_runner/_work/ydb/ydb/build/internal/plugins","--build-root","/home/runner/.ya/build/conf/dist-release-x-6b047b4e466e327e99f5399682291aa4_d357a1f7839b099012272bcb9853ec19","--test-dart","/home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.pisjg7vr/test.dart","--tests-data-root","/home/runner/actions_runner/_work/ydb/arcadia_tests_data","--makefiles-dart","/home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm/gen_graph.pisjg7vr/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.400335550308228} 2024-11-21 10:03:38,377 DEBUG (core.stage_tracer) [Misc-04] Start stage tag=load-graph-from-json, group=graph, time=1732183418.3771098 2024-11-21 10:03:38,377 DEBUG (core.stages_profiler) [Misc-04] Set stage load-graph-from-json_started=1732183418.3771098 2024-11-21 10:03:38,377 DEBUG (core.profiler) [Misc-04] Profile step load-graph-from-json_started - 1732183418.3771098 2024-11-21 10:03:38,377 DEBUG (core.stage_tracer) [Misc-04] Finish stage tag=load-graph-from-json, group=graph, time=1732183418.3773766 2024-11-21 10:03:38,377 DEBUG (core.stages_profiler) [Misc-04] Set stage load-graph-from-json_finished=1732183418.3773766 2024-11-21 10:03:38,377 DEBUG (core.profiler) [Misc-04] Profile step load-graph-from-json_finished - 1732183418.3773766 2024-11-21 10:03:38,377 DEBUG (core.stage_tracer) [Misc-04] Finish stage tag=gen-graph-json-test_tool_tc1-nopic-global, group=graph, time=1732183418.3775897 2024-11-21 10:03:38,377 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-json-test_tool_tc1-nopic-global_finished=1732183418.3775897 2024-11-21 10:03:38,377 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-json-test_tool_tc1-nopic-global_finished - 1732183418.3775897 2024-11-21 10:03:38,377 DEBUG (core.stage_tracer) [Misc-04] Finish stage tag=gen-graph-test_tool_tc1-nopic-global, group=graph, time=1732183418.3778906 2024-11-21 10:03:38,377 DEBUG (core.stages_profiler) [Misc-04] Set stage gen-graph-test_tool_tc1-nopic-global_finished=1732183418.3778906 2024-11-21 10:03:38,377 DEBUG (core.profiler) [Misc-04] Profile step gen-graph-test_tool_tc1-nopic-global_finished - 1732183418.3778906 2024-11-21 10:03:38,378 DEBUG (core.stage_tracer) [MainThread] Start stage tag=get-graph-1, group=graph, time=1732183418.3785028 2024-11-21 10:03:38,378 DEBUG (core.stages_profiler) [MainThread] Set stage get-graph-1_started=1732183418.3785028 2024-11-21 10:03:38,378 DEBUG (core.profiler) [MainThread] Profile step get-graph-1_started - 1732183418.3785028 2024-11-21 10:03:38,380 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=get-graph-1, group=graph, time=1732183418.3804595 2024-11-21 10:03:38,380 DEBUG (core.stages_profiler) [MainThread] Set stage get-graph-1_finished=1732183418.3804595 2024-11-21 10:03:38,380 DEBUG (core.profiler) [MainThread] Profile step get-graph-1_finished - 1732183418.3804595 2024-11-21 10:03:38,380 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=merge-target-graphs-1, group=graph, time=1732183418.3807433 2024-11-21 10:03:38,380 DEBUG (core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_finished=1732183418.3807433 2024-11-21 10:03:38,380 DEBUG (core.profiler) [MainThread] Profile step merge-target-graphs-1_finished - 1732183418.3807433 2024-11-21 10:03:38,380 DEBUG (core.stage_tracer) [MainThread] Start stage tag=build-merged-graph, group=graph, time=1732183418.3809192 2024-11-21 10:03:38,380 DEBUG (core.stages_profiler) [MainThread] Set stage build-merged-graph_started=1732183418.3809192 2024-11-21 10:03:38,381 DEBUG (core.profiler) [MainThread] Profile step build-merged-graph_started - 1732183418.3809192 2024-11-21 10:03:38,382 DEBUG (core.stage_tracer) [MainThread] Start stage tag=insert-tests-1, group=graph, time=1732183418.381992 2024-11-21 10:03:38,382 DEBUG (core.stages_profiler) [MainThread] Set stage insert-tests-1_started=1732183418.381992 2024-11-21 10:03:38,382 DEBUG (core.profiler) [MainThread] Profile step insert-tests-1_started - 1732183418.381992 2024-11-21 10:03:38,382 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'unsupported cross-compiled tests' on 0 suites 2024-11-21 10:03:38,382 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter '. at 0x7f0ae70034c0>' on 0 suites 2024-11-21 10:03:38,382 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'size' on 0 suites 2024-11-21 10:03:38,382 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'class type' on 0 suites 2024-11-21 10:03:38,382 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'suite type' on 0 suites 2024-11-21 10:03:38,382 DEBUG (devtools.ya.test.filter) [MainThread] Tags filter include set:[] exclude set:[] 2024-11-21 10:03:38,382 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'tags' on 0 suites 2024-11-21 10:03:38,382 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'project path' on 0 suites 2024-11-21 10:03:38,382 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'filename filter' on 0 suites 2024-11-21 10:03:38,382 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'chunk filter' on 0 suites 2024-11-21 10:03:38,382 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'name' on 0 suites 2024-11-21 10:03:38,382 DEBUG (build.graph) [MainThread] Generating build plan 2024-11-21 10:03:38,383 DEBUG (build.graph) [MainThread] Preparing test suites 2024-11-21 10:03:38,383 DEBUG (build.graph) [MainThread] Stripping clang-tidy irrelevant deps 2024-11-21 10:03:38,383 DEBUG (exts.timer) [MainThread] Timer inject_tests, stage inject tests for default-linux-x86_64-release-asan: 0.0010559558868408203 2024-11-21 10:03:38,383 DEBUG (build.graph) [MainThread] injected 0 tests for default-linux-x86_64-release-asan 2024-11-21 10:03:38,383 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=insert-tests-1, group=graph, time=1732183418.3833394 2024-11-21 10:03:38,383 DEBUG (core.stages_profiler) [MainThread] Set stage insert-tests-1_finished=1732183418.3833394 2024-11-21 10:03:38,383 DEBUG (core.profiler) [MainThread] Profile step insert-tests-1_finished - 1732183418.3833394 2024-11-21 10:03:38,383 DEBUG (core.stage_tracer) [MainThread] Start stage tag=merge-target-graphs-1, group=graph, time=1732183418.3834963 2024-11-21 10:03:38,383 DEBUG (core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_started=1732183418.3834963 2024-11-21 10:03:38,383 DEBUG (core.profiler) [MainThread] Profile step merge-target-graphs-1_started - 1732183418.3834963 2024-11-21 10:03:38,383 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=merge-target-graphs-1, group=graph, time=1732183418.3836253 2024-11-21 10:03:38,383 DEBUG (core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_finished=1732183418.3836253 2024-11-21 10:03:38,383 DEBUG (core.profiler) [MainThread] Profile step merge-target-graphs-1_finished - 1732183418.3836253 2024-11-21 10:03:38,384 DEBUG (core.config) [MainThread] Read config "build/platform/python/ymake_python2/resources.json" from resource 2024-11-21 10:03:38,384 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] python: will use 'linux-x86_64' platform 2024-11-21 10:03:38,384 DEBUG (core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/gdb/resources.json 2024-11-21 10:03:38,384 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] gdb: will use 'linux-x86_64' platform 2024-11-21 10:03:38,384 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=build-merged-graph, group=graph, time=1732183418.3845816 2024-11-21 10:03:38,384 DEBUG (core.stages_profiler) [MainThread] Set stage build-merged-graph_finished=1732183418.3845816 2024-11-21 10:03:38,384 DEBUG (core.profiler) [MainThread] Profile step build-merged-graph_finished - 1732183418.3845816 2024-11-21 10:03:38,384 DEBUG (core.stage_tracer) [MainThread] Start stage tag=iter-extra-resources, group=graph, time=1732183418.3847458 2024-11-21 10:03:38,384 DEBUG (core.stages_profiler) [MainThread] Set stage iter-extra-resources_started=1732183418.3847458 2024-11-21 10:03:38,384 DEBUG (core.profiler) [MainThread] Profile step iter-extra-resources_started - 1732183418.3847458 2024-11-21 10:03:38,384 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=iter-extra-resources, group=graph, time=1732183418.3848855 2024-11-21 10:03:38,384 DEBUG (core.stages_profiler) [MainThread] Set stage iter-extra-resources_finished=1732183418.3848855 2024-11-21 10:03:38,384 DEBUG (core.profiler) [MainThread] Profile step iter-extra-resources_finished - 1732183418.3848855 2024-11-21 10:03:38,385 DEBUG (exts.timer) [MainThread] Timer build.graph, stage build and merge graphs: 1.2788825035095215 2024-11-21 10:03:38,385 DEBUG (core.stage_tracer) [MainThread] Start stage tag=strip-graph, group=graph, time=1732183418.385064 2024-11-21 10:03:38,385 DEBUG (core.stages_profiler) [MainThread] Set stage strip-graph_started=1732183418.385064 2024-11-21 10:03:38,385 DEBUG (core.profiler) [MainThread] Profile step strip-graph_started - 1732183418.385064 2024-11-21 10:03:38,385 DEBUG (build.graph) [MainThread] stripped 0, left 13 nodes 2024-11-21 10:03:38,385 DEBUG (exts.timer) [MainThread] Timer build.graph, stage strip graph: 0.00023365020751953125 2024-11-21 10:03:38,385 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=strip-graph, group=graph, time=1732183418.3852901 2024-11-21 10:03:38,385 DEBUG (core.stages_profiler) [MainThread] Set stage strip-graph_finished=1732183418.3852901 2024-11-21 10:03:38,385 DEBUG (core.profiler) [MainThread] Profile step strip-graph_finished - 1732183418.3852901 2024-11-21 10:03:38,385 DEBUG (exts.timer) [MainThread] Timer build.graph, stage gen rename nodes: 0.00022292137145996094 2024-11-21 10:03:38,385 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] python: will use 'linux-x86_64' platform 2024-11-21 10:03:38,385 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ymake: will use 'linux' platform 2024-11-21 10:03:38,385 DEBUG (core.stage_tracer) [MainThread] Start stage tag=inject_default_requirements, group=graph, time=1732183418.385775 2024-11-21 10:03:38,385 DEBUG (core.stages_profiler) [MainThread] Set stage inject_default_requirements_started=1732183418.385775 2024-11-21 10:03:38,385 DEBUG (core.profiler) [MainThread] Profile step inject_default_requirements_started - 1732183418.385775 2024-11-21 10:03:38,385 DEBUG (build.graph) [MainThread] Updated requirements for 0 nodes 2024-11-21 10:03:38,385 DEBUG (exts.timer) [MainThread] Timer substitude_uids, stage substitude_uids: 8.58306884765625e-06 2024-11-21 10:03:38,386 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=inject_default_requirements, group=graph, time=1732183418.3860147 2024-11-21 10:03:38,386 DEBUG (core.stages_profiler) [MainThread] Set stage inject_default_requirements_finished=1732183418.3860147 2024-11-21 10:03:38,386 DEBUG (core.profiler) [MainThread] Profile step inject_default_requirements_finished - 1732183418.3860147 2024-11-21 10:03:38,386 DEBUG (exts.timer) [MainThread] Timer build.graph, stage misc graph changes: 0.0006849765777587891 2024-11-21 10:03:38,386 DEBUG (core.stage_tracer) [MainThread] Start stage tag=finalize-graph, group=graph, time=1732183418.3862026 2024-11-21 10:03:38,386 DEBUG (core.stages_profiler) [MainThread] Set stage finalize-graph_started=1732183418.3862026 2024-11-21 10:03:38,386 DEBUG (core.profiler) [MainThread] Profile step finalize-graph_started - 1732183418.3862026 2024-11-21 10:03:38,386 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=finalize-graph, group=graph, time=1732183418.3863194 2024-11-21 10:03:38,386 DEBUG (core.stages_profiler) [MainThread] Set stage finalize-graph_finished=1732183418.3863194 2024-11-21 10:03:38,386 DEBUG (core.profiler) [MainThread] Profile step finalize-graph_finished - 1732183418.3863194 2024-11-21 10:03:38,386 DEBUG (core.stage_tracer) [MainThread] Start stage tag=imprint-store-and-stats, group=graph, time=1732183418.3864484 2024-11-21 10:03:38,386 DEBUG (core.stages_profiler) [MainThread] Set stage imprint-store-and-stats_started=1732183418.3864484 2024-11-21 10:03:38,386 DEBUG (core.profiler) [MainThread] Profile step imprint-store-and-stats_started - 1732183418.3864484 2024-11-21 10:03:38,386 DEBUG (core.imprint.imprint:Imprint) [MainThread] 2024-11-21 10:03:38,386 DEBUG (core.imprint.imprint:Imprint) [MainThread] 2024-11-21 10:03:38,386 DEBUG (core.imprint.imprint:Imprint) [MainThread] 2024-11-21 10:03:38,386 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=imprint-store-and-stats, group=graph, time=1732183418.386743 2024-11-21 10:03:38,386 DEBUG (core.stages_profiler) [MainThread] Set stage imprint-store-and-stats_finished=1732183418.386743 2024-11-21 10:03:38,386 DEBUG (core.profiler) [MainThread] Profile step imprint-store-and-stats_finished - 1732183418.386743 2024-11-21 10:03:38,386 DEBUG (core.stage_tracer) [MainThread] Start stage tag=inject_stats_and_static_uids, group=graph, time=1732183418.3868763 2024-11-21 10:03:38,386 DEBUG (core.stages_profiler) [MainThread] Set stage inject_stats_and_static_uids_started=1732183418.3868763 2024-11-21 10:03:38,386 DEBUG (core.profiler) [MainThread] Profile step inject_stats_and_static_uids_started - 1732183418.3868763 2024-11-21 10:03:38,387 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=inject_stats_and_static_uids, group=graph, time=1732183418.3871713 2024-11-21 10:03:38,387 DEBUG (core.stages_profiler) [MainThread] Set stage inject_stats_and_static_uids_finished=1732183418.3871713 2024-11-21 10:03:38,387 DEBUG (core.profiler) [MainThread] Profile step inject_stats_and_static_uids_finished - 1732183418.3871713 2024-11-21 10:03:38,387 DEBUG (core.stage_tracer) [MainThread] Start stage tag=strip-tags, group=graph, time=1732183418.3873196 2024-11-21 10:03:38,387 DEBUG (core.stages_profiler) [MainThread] Set stage strip-tags_started=1732183418.3873196 2024-11-21 10:03:38,387 DEBUG (core.profiler) [MainThread] Profile step strip-tags_started - 1732183418.3873196 2024-11-21 10:03:38,387 DEBUG (exts.timer) [MainThread] Timer build.graph, stage strip tags: 0.0013074874877929688 2024-11-21 10:03:38,387 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=strip-tags, group=graph, time=1732183418.3875067 2024-11-21 10:03:38,387 DEBUG (core.stages_profiler) [MainThread] Set stage strip-tags_finished=1732183418.3875067 2024-11-21 10:03:38,387 DEBUG (core.profiler) [MainThread] Profile step strip-tags_finished - 1732183418.3875067 2024-11-21 10:03:38,387 DEBUG (core.stage_tracer) [MainThread] Start stage tag=reduce_graph_resources, group=graph, time=1732183418.3877733 2024-11-21 10:03:38,387 DEBUG (core.stages_profiler) [MainThread] Set stage reduce_graph_resources_started=1732183418.3877733 2024-11-21 10:03:38,387 DEBUG (core.profiler) [MainThread] Profile step reduce_graph_resources_started - 1732183418.3877733 2024-11-21 10:03:38,388 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=reduce_graph_resources, group=graph, time=1732183418.3880904 2024-11-21 10:03:38,388 DEBUG (core.stages_profiler) [MainThread] Set stage reduce_graph_resources_finished=1732183418.3880904 2024-11-21 10:03:38,388 DEBUG (core.profiler) [MainThread] Profile step reduce_graph_resources_finished - 1732183418.3880904 2024-11-21 10:03:38,388 DEBUG (core.stage_tracer) [MainThread] Start stage tag=clean-intern-string-storage, group=graph, time=1732183418.388239 2024-11-21 10:03:38,388 DEBUG (core.stages_profiler) [MainThread] Set stage clean-intern-string-storage_started=1732183418.388239 2024-11-21 10:03:38,388 DEBUG (core.profiler) [MainThread] Profile step clean-intern-string-storage_started - 1732183418.388239 2024-11-21 10:03:38,388 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=clean-intern-string-storage, group=graph, time=1732183418.3884418 2024-11-21 10:03:38,388 DEBUG (core.stages_profiler) [MainThread] Set stage clean-intern-string-storage_finished=1732183418.3884418 2024-11-21 10:03:38,388 DEBUG (core.profiler) [MainThread] Profile step clean-intern-string-storage_finished - 1732183418.3884418 2024-11-21 10:03:38,388 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=build_graph_and_tests, group=graph, time=1732183418.3885868 2024-11-21 10:03:38,388 DEBUG (core.stages_profiler) [MainThread] Set stage build_graph_and_tests_finished=1732183418.3885868 2024-11-21 10:03:38,388 DEBUG (core.profiler) [MainThread] Profile step build_graph_and_tests_finished - 1732183418.3885868 2024-11-21 10:03:38,388 DEBUG (exts.timer) [MainThread] Timer context_creation, stage graph_and_tests finished: 1.3179569244384766 2024-11-21 10:03:38,390 DEBUG (core.stage_tracer) [MainThread] Start stage tag=configure-dist-store-cache, group=ya_make, time=1732183418.3903844 2024-11-21 10:03:38,390 DEBUG (core.stages_profiler) [MainThread] Set stage configure-dist-store-cache_started=1732183418.3903844 2024-11-21 10:03:38,390 DEBUG (core.profiler) [MainThread] Profile step configure-dist-store-cache_started - 1732183418.3903844 2024-11-21 10:03:38,390 DEBUG (build.ya_make) [MainThread] Waiting for dist cache setup 2024-11-21 10:03:38,390 DEBUG (build.ya_make) [MainThread] Loading meta from dist cache 2024-11-21 10:03:38,390 DEBUG (build.ya_make) [MainThread] Dist cache prepared 2024-11-21 10:03:38,390 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=configure-dist-store-cache, group=ya_make, time=1732183418.3907287 2024-11-21 10:03:38,390 DEBUG (core.stages_profiler) [MainThread] Set stage configure-dist-store-cache_finished=1732183418.3907287 2024-11-21 10:03:38,390 DEBUG (core.profiler) [MainThread] Profile step configure-dist-store-cache_finished - 1732183418.3907287 2024-11-21 10:03:38,390 DEBUG (core.stage_tracer) [MainThread] Start stage tag=configure-local-cache, group=ya_make, time=1732183418.3908858 2024-11-21 10:03:38,390 DEBUG (core.stages_profiler) [MainThread] Set stage configure-local-cache_started=1732183418.3908858 2024-11-21 10:03:38,390 DEBUG (core.profiler) [MainThread] Profile step configure-local-cache_started - 1732183418.3908858 2024-11-21 10:03:38,391 DEBUG (build.ya_make) [MainThread] content UIDs forced 2024-11-21 10:03:38,391 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=configure-local-cache, group=ya_make, time=1732183418.3911092 2024-11-21 10:03:38,391 DEBUG (core.stages_profiler) [MainThread] Set stage configure-local-cache_finished=1732183418.3911092 2024-11-21 10:03:38,391 DEBUG (core.profiler) [MainThread] Profile step configure-local-cache_finished - 1732183418.3911092 2024-11-21 10:03:38,391 DEBUG (build.ya_make) [MainThread] sandbox_run_test_uids: set() 2024-11-21 10:03:38,393 DEBUG (urllib3.connectionpool) [Misc-05] Starting new HTTP connection (1): cachesrv.internal:8081 2024-11-21 10:03:38,394 DEBUG (urllib3.connectionpool) [Misc-06] Starting new HTTP connection (2): cachesrv.internal:8081 2024-11-21 10:03:38,395 DEBUG (urllib3.connectionpool) [Misc-07] Starting new HTTP connection (3): cachesrv.internal:8081 2024-11-21 10:03:38,396 DEBUG (urllib3.connectionpool) [Misc-08] Starting new HTTP connection (4): cachesrv.internal:8081 2024-11-21 10:03:38,398 DEBUG (urllib3.connectionpool) [Misc-09] Starting new HTTP connection (5): cachesrv.internal:8081 2024-11-21 10:03:38,398 DEBUG (urllib3.connectionpool) [Misc-10] Starting new HTTP connection (6): cachesrv.internal:8081 2024-11-21 10:03:38,400 DEBUG (urllib3.connectionpool) [Misc-11] Starting new HTTP connection (7): cachesrv.internal:8081 2024-11-21 10:03:38,401 DEBUG (urllib3.connectionpool) [Misc-12] Starting new HTTP connection (8): cachesrv.internal:8081 2024-11-21 10:03:38,402 DEBUG (urllib3.connectionpool) [Misc-13] Starting new HTTP connection (9): cachesrv.internal:8081 2024-11-21 10:03:38,403 DEBUG (urllib3.connectionpool) [Misc-14] Starting new HTTP connection (10): cachesrv.internal:8081 2024-11-21 10:03:38,404 DEBUG (urllib3.connectionpool) [Misc-15] Starting new HTTP connection (11): cachesrv.internal:8081 2024-11-21 10:03:38,406 DEBUG (urllib3.connectionpool) [Misc-16] Starting new HTTP connection (12): cachesrv.internal:8081 2024-11-21 10:03:38,407 DEBUG (urllib3.connectionpool) [Misc-17] Starting new HTTP connection (13): cachesrv.internal:8081 2024-11-21 10:03:38,410 DEBUG (urllib3.connectionpool) [Misc-05] http://cachesrv.internal:8081 "HEAD /ac/4235573062656e74775436455739526452673441696700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:03:38,411 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-05] Bazel-remote Probing B5W0bentwT6EW9RdRg4Aig => True 2024-11-21 10:03:38,411 DEBUG (urllib3.connectionpool) [Misc-07] http://cachesrv.internal:8081 "HEAD /ac/75363872507466446133612d77416533374b5739537700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:03:38,411 DEBUG (urllib3.connectionpool) [Misc-06] http://cachesrv.internal:8081 "HEAD /ac/456a7a35634c2d366f32422d662d59634462444b767700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:03:38,412 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-07] Bazel-remote Probing u68rPtfDa3a-wAe37KW9Sw => True 2024-11-21 10:03:38,412 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-06] Bazel-remote Probing Ejz5cL-6o2B-f-YcDbDKvw => True 2024-11-21 10:03:38,413 DEBUG (urllib3.connectionpool) [Misc-09] http://cachesrv.internal:8081 "HEAD /ac/456c6f45705f536a6f6b516373654145613651426f4100000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:03:38,414 DEBUG (urllib3.connectionpool) [Misc-08] http://cachesrv.internal:8081 "HEAD /ac/614b7a47786c7957616a79696f374a545a387a63667700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:03:38,414 DEBUG (urllib3.connectionpool) [Misc-11] http://cachesrv.internal:8081 "HEAD /ac/3276756f474b7870594b6669394839354b3435374d4100000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:03:38,414 DEBUG (urllib3.connectionpool) [Misc-10] http://cachesrv.internal:8081 "HEAD /ac/774e686f57484e50644446675a364b4575764e47687700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:03:38,415 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-09] Bazel-remote Probing EloEp_SjokQcseAEa6QBoA => True 2024-11-21 10:03:38,415 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-08] Bazel-remote Probing aKzGxlyWajyio7JTZ8zcfw => True 2024-11-21 10:03:38,415 DEBUG (urllib3.connectionpool) [Misc-12] http://cachesrv.internal:8081 "HEAD /ac/474f6157312d496748745a72774d5151676631774e6700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:03:38,416 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-11] Bazel-remote Probing 2vuoGKxpYKfi9H95K457MA => True 2024-11-21 10:03:38,416 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-10] Bazel-remote Probing wNhoWHNPdDFgZ6KEuvNGhw => True 2024-11-21 10:03:38,417 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-12] Bazel-remote Probing GOaW1-IgHtZrwMQQgf1wNg => True 2024-11-21 10:03:38,418 DEBUG (urllib3.connectionpool) [Misc-13] http://cachesrv.internal:8081 "HEAD /ac/5331677649784232534a5a6a617150387a3874516b7700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:03:38,418 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-13] Bazel-remote Probing S1gvIxB2SJZjaqP8z8tQkw => True 2024-11-21 10:03:38,419 DEBUG (urllib3.connectionpool) [Misc-14] http://cachesrv.internal:8081 "HEAD /ac/76635462767a6f63317935666f6e6e4852477457516700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:03:38,419 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-14] Bazel-remote Probing vcTbvzoc1y5fonnHRGtWQg => True 2024-11-21 10:03:38,420 DEBUG (urllib3.connectionpool) [Misc-15] http://cachesrv.internal:8081 "HEAD /ac/6872735657476374305a33424345347a69764837736700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:03:38,420 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-15] Bazel-remote Probing hrsVWGct0Z3BCE4zivH7sg => True 2024-11-21 10:03:38,421 DEBUG (urllib3.connectionpool) [Misc-16] http://cachesrv.internal:8081 "HEAD /ac/6c5964543150504334654d55506c2d746c325533497700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:03:38,421 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-16] Bazel-remote Probing lYdT1PPC4eMUPl-tl2U3Iw => True 2024-11-21 10:03:38,422 DEBUG (urllib3.connectionpool) [Misc-17] http://cachesrv.internal:8081 "HEAD /ac/666759595235374b495339374a43674c716d4261666700000000000000000001 HTTP/1.1" 200 0 2024-11-21 10:03:38,422 DEBUG (yalibrary.store.bazel_store.bazel_store) [Misc-17] Bazel-remote Probing fgYYR57KIS97JCgLqmBafg => True 2024-11-21 10:03:38,422 DEBUG (build.ya_make) [MainThread] Strip graph due bazel_remote_store mode 2024-11-21 10:03:38,422 DEBUG (build.graph) [MainThread] stripped 13, left 0 nodes 2024-11-21 10:03:38,427 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=context_creation, group=ya_make, time=1732183418.4273403 2024-11-21 10:03:38,427 DEBUG (core.stages_profiler) [MainThread] Set stage context_creation_finished=1732183418.4273403 2024-11-21 10:03:38,427 DEBUG (core.profiler) [MainThread] Profile step context_creation_finished - 1732183418.4273403 2024-11-21 10:03:38,427 DEBUG (exts.timer) [MainThread] Timer context_creation, stage context_creation finished: 0.0386960506439209 2024-11-21 10:03:38,427 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=context_generating, group=build_handler, time=1732183418.427832 2024-11-21 10:03:38,427 DEBUG (core.stages_profiler) [MainThread] Set stage context_generating_finished=1732183418.427832 2024-11-21 10:03:38,427 DEBUG (core.profiler) [MainThread] Profile step context_generating_finished - 1732183418.427832 2024-11-21 10:03:38,428 DEBUG (core.stage_tracer) [MainThread] Start stage tag=build, group=build_handler, time=1732183418.428012 2024-11-21 10:03:38,428 DEBUG (core.stages_profiler) [MainThread] Set stage build_started=1732183418.428012 2024-11-21 10:03:38,428 DEBUG (core.profiler) [MainThread] Profile step build_started - 1732183418.428012 2024-11-21 10:03:38,428 DEBUG (build.reports.autocheck_report) [MainThread] Got 0 tests to report 2024-11-21 10:03:38,428 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2024-11-21 10:03:38,428 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2024-11-21 10:03:38,428 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2024-11-21 10:03:38,428 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2024-11-21 10:03:38,428 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2024-11-21 10:03:38,428 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2024-11-21 10:03:38,429 DEBUG (ReportGenerator) [MainThread] Finish style report 2024-11-21 10:03:38,429 DEBUG (StoredReport) [MainThread] Finish style report 2024-11-21 10:03:38,429 DEBUG (ReportGenerator) [MainThread] Finish tests report, tests by size defaultdict(, {'small': set(), 'medium': set(), 'large': set()}), tests by type defaultdict(, {}) 2024-11-21 10:03:38,429 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2024-11-21 10:03:38,429 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2024-11-21 10:03:38,429 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2024-11-21 10:03:38,429 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2024-11-21 10:03:38,429 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2024-11-21 10:03:38,429 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2024-11-21 10:03:38,429 DEBUG (StoredReport) [MainThread] Finish tests report 2024-11-21 10:03:38,429 DEBUG (ReportGenerator) [MainThread] Finish configure report 2024-11-21 10:03:38,429 DEBUG (StoredReport) [MainThread] Finish configure report 2024-11-21 10:03:38,430 DEBUG (core.stage_tracer) [MainThread] Start stage tag=cache_test_statuses, group=ya_make, time=1732183418.4300442 2024-11-21 10:03:38,430 DEBUG (core.stages_profiler) [MainThread] Set stage cache_test_statuses_started=1732183418.4300442 2024-11-21 10:03:38,430 DEBUG (core.profiler) [MainThread] Profile step cache_test_statuses_started - 1732183418.4300442 2024-11-21 10:03:38,446 DEBUG (yalibrary.store.new_store) [MainThread] Initialized store in /home/runner/.ya/build/cache/trc 2024-11-21 10:03:38,446 DEBUG (yalibrary.store.new_store) [MainThread] Started filtering 2024-11-21 10:03:38,447 DEBUG (library.python.filelock) [MainThread] Acquiring FileLock (blocking=True): /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-21 10:03:38,447 DEBUG (library.python.filelock) [MainThread] Ensuring FileLock released: /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-21 10:03:38,447 DEBUG (yalibrary.store.new_store) [MainThread] Done filtering, retain 0 uids, 0 files 2024-11-21 10:03:38,447 DEBUG (yalibrary.store.new_store) [MainThread] Cleaning size store 2024-11-21 10:03:38,447 DEBUG (yalibrary.store.new_store) [MainThread] Cleaning file store 2024-11-21 10:03:38,449 DEBUG (yalibrary.store.new_store) [MainThread] Cleaning uid store 2024-11-21 10:03:38,456 DEBUG (library.python.filelock) [MainThread] Acquiring FileLock (blocking=True): /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-21 10:03:38,456 DEBUG (library.python.filelock) [MainThread] Ensuring FileLock released: /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-21 10:03:38,457 DEBUG (library.python.filelock) [MainThread] Acquiring FileLock (blocking=True): /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-21 10:03:38,457 DEBUG (library.python.filelock) [MainThread] Ensuring FileLock released: /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2024-11-21 10:03:38,458 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=cache_test_statuses, group=ya_make, time=1732183418.4579773 2024-11-21 10:03:38,458 DEBUG (core.stages_profiler) [MainThread] Set stage cache_test_statuses_finished=1732183418.4579773 2024-11-21 10:03:38,458 DEBUG (core.profiler) [MainThread] Profile step cache_test_statuses_finished - 1732183418.4579773 2024-11-21 10:03:38,458 DEBUG (core.stage_tracer) [MainThread] Start stage tag=finalize-reports, group=ya_make, time=1732183418.4583373 2024-11-21 10:03:38,458 DEBUG (core.stages_profiler) [MainThread] Set stage finalize-reports_started=1732183418.4583373 2024-11-21 10:03:38,458 DEBUG (core.profiler) [MainThread] Profile step finalize-reports_started - 1732183418.4583373 2024-11-21 10:03:38,458 DEBUG (build.ya_make) [MainThread] Build is finished, process results 2024-11-21 10:03:38,458 DEBUG (ReportGenerator) [MainThread] Build result is processed, add 0 entries 2024-11-21 10:03:38,458 DEBUG (ReportGenerator) [MainThread] Finish build report 2024-11-21 10:03:38,458 DEBUG (StoredReport) [MainThread] Finish build report 2024-11-21 10:03:38,458 DEBUG (ReportGenerator) [MainThread] Finish tests report, tests by size defaultdict(, {'small': set(), 'medium': set(), 'large': set()}), tests by type defaultdict(, {}) 2024-11-21 10:03:38,458 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2024-11-21 10:03:38,458 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2024-11-21 10:03:38,458 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2024-11-21 10:03:38,458 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2024-11-21 10:03:38,458 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2024-11-21 10:03:38,458 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2024-11-21 10:03:38,458 DEBUG (StoredReport) [MainThread] Finish tests report 2024-11-21 10:03:38,458 DEBUG (ReportGenerator) [MainThread] Finish style report 2024-11-21 10:03:38,458 DEBUG (StoredReport) [MainThread] Finish style report 2024-11-21 10:03:38,459 DEBUG (ReportGenerator) [MainThread] Finish report 2024-11-21 10:03:38,459 DEBUG (StoredReport) [MainThread] Finish report 2024-11-21 10:03:38,459 DEBUG (build.ya_make) [MainThread] Build results listener statistics: {} 2024-11-21 10:03:38,459 DEBUG (build.ya_make) [MainThread] Generating results report 2024-11-21 10:03:38,459 INFO (build.reports.build_reports) [MainThread] Dump junit report to /home/runner/actions_runner/_work/ydb/ydb/tmp/results/try_1/junit.xml 2024-11-21 10:03:38,459 DEBUG (build.reports.autocheck_report) [MainThread] Got 0 tests to report 2024-11-21 10:03:38,459 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2024-11-21 10:03:38,459 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2024-11-21 10:03:38,459 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2024-11-21 10:03:38,459 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2024-11-21 10:03:38,459 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2024-11-21 10:03:38,459 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2024-11-21 10:03:38,460 DEBUG (ReportGenerator) [MainThread] Build result is processed, add 0 entries 2024-11-21 10:03:38,460 DEBUG (build.reports.autocheck_report) [MainThread] builder.opts.report_skipped_suites: False, builder.opts.report_skipped_suites False 2024-11-21 10:03:38,460 INFO (build.reports.build_reports) [MainThread] Dump results report to /home/runner/actions_runner/_work/ydb/ydb/tmp/results/try_1/report.json 2024-11-21 10:03:38,460 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=finalize-reports, group=ya_make, time=1732183418.4605134 2024-11-21 10:03:38,460 DEBUG (core.stages_profiler) [MainThread] Set stage finalize-reports_finished=1732183418.4605134 2024-11-21 10:03:38,460 DEBUG (core.profiler) [MainThread] Profile step finalize-reports_finished - 1732183418.4605134 2024-11-21 10:03:38,462 DEBUG (yalibrary.toolscache) [MainThread] AC cache attempt: (release all data) 2024-11-21 10:03:38,464 DEBUG (yalibrary.toolscache) [MainThread] AC cache (release all data) address: (2180388, 981767, 'unix:/home/runner/.ya/build/cache/7/psingfeSIr7.tmp') 2024-11-21 10:03:38,464 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=build, group=build_handler, time=1732183418.4649134 2024-11-21 10:03:38,465 DEBUG (core.stages_profiler) [MainThread] Set stage build_finished=1732183418.4649134 2024-11-21 10:03:38,465 DEBUG (core.profiler) [MainThread] Profile step build_finished - 1732183418.4649134 2024-11-21 10:03:38,465 DEBUG (core.stage_tracer) [MainThread] Start stage tag=dump_results, group=build_handler, time=1732183418.46513 2024-11-21 10:03:38,465 DEBUG (core.stages_profiler) [MainThread] Set stage dump_results_started=1732183418.46513 2024-11-21 10:03:38,465 DEBUG (core.profiler) [MainThread] Profile step dump_results_started - 1732183418.46513 2024-11-21 10:03:38,465 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=dump_results, group=build_handler, time=1732183418.4657068 2024-11-21 10:03:38,465 DEBUG (core.stages_profiler) [MainThread] Set stage dump_results_finished=1732183418.4657068 2024-11-21 10:03:38,465 DEBUG (core.profiler) [MainThread] Profile step dump_results_finished - 1732183418.4657068 2024-11-21 10:03:38,465 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=ya_make_handler, group=build_handler, time=1732183418.4658816 2024-11-21 10:03:38,465 DEBUG (core.stages_profiler) [MainThread] Set stage ya_make_handler_finished=1732183418.4658816 2024-11-21 10:03:38,465 DEBUG (core.profiler) [MainThread] Profile step ya_make_handler_finished - 1732183418.4658816 2024-11-21 10:03:38,466 DEBUG (core.stage_tracer) [MainThread] Finish stage tag=invoke-do_ya_make, group=overall-execution, time=1732183418.466546 2024-11-21 10:03:38,466 DEBUG (core.stages_profiler) [MainThread] Set stage invoke-do_ya_make_finished=1732183418.466546 2024-11-21 10:03:38,466 DEBUG (core.profiler) [MainThread] Profile step invoke-do_ya_make_finished - 1732183418.466546 2024-11-21 10:03:38,467 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "dump_debug" stopped in 0.000261 2024-11-21 10:03:38,467 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "evlog" stopped in 0.000024 2024-11-21 10:03:38,467 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "changelist_store" stopped in 0.000002 2024-11-21 10:03:38,467 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "event_queue" stopped in 0.000003 2024-11-21 10:03:38,467 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "mlockall" stopped in 0.000004 2024-11-21 10:03:38,467 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "profile" stopped in 0.000001 2024-11-21 10:03:38,467 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "showstack" stopped in 0.000023 2024-11-21 10:03:38,467 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher" stopped in 0.000003 2024-11-21 10:03:38,467 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" stopped in 0.000002 2024-11-21 10:03:38,467 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token2" stopped in 0.000003 2024-11-21 10:03:38,467 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "docker_config_path" stopped in 0.000001 2024-11-21 10:03:38,467 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "use_universal_fetcher_everywhere" stopped in 0.000001 2024-11-21 10:03:38,467 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher_params" stopped in 0.000009 2024-11-21 10:03:38,467 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "self_info" stopped in 0.000002 2024-11-21 10:03:38,467 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" stopped in 0.000003 2024-11-21 10:03:38,467 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display_log" stopped in 0.000006 2024-11-21 10:03:38,467 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "custom_file_log" stopped in 0.000013 2024-11-21 10:03:38,468 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display" stopped in 0.000019 2024-11-21 10:03:38,468 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "state" stopped in 0.000008 2024-11-21 10:03:38,468 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token" stopped in 0.000002 2024-11-21 10:03:38,468 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "params" stopped in 0.000001 2024-11-21 10:03:38,468 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Restored ctx dict_keys(['uid', 'file_log', 'display_in_memory_log', 'file_in_memory_log', 'revision', 'vcs_type', 'report', 'exit', 'lifecycle_ts', 'env_checker', 'fetchers_storage', 'tmp_dir']) 2024-11-21 10:03:38,468 DEBUG (library.python.tmp) [MainThread] Removing tmp dir /home/runner/.ya/tmp/1732183416.2180800.qg2h2tmm 2024-11-21 10:03:38,469 DEBUG (library.python.tmp) [MainThread] Reset back TMPDIR=None 2024-11-21 10:03:38,469 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "tmp_dir" stopped in 0.000726 2024-11-21 10:03:38,469 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" stopped in 0.000011 2024-11-21 10:03:38,469 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "env_checker" stopped in 0.000007 2024-11-21 10:03:38,469 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "lifecycle_ts" stopped in 0.000006 2024-11-21 10:03:38,469 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "exit" stopped in 0.000007 2024-11-21 10:03:38,470 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "report" stopped in 0.000977 2024-11-21 10:03:38,470 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" stopped in 0.000006 2024-11-21 10:03:38,470 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "revision" stopped in 0.000004 2024-11-21 10:03:38,470 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "file_in_memory_log" stopped in 0.000005 2024-11-21 10:03:38,470 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display_in_memory_log" stopped in 0.000005 2024-11-21 10:03:38,470 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "file_log" stopped in 0.000011 2024-11-21 10:03:38,470 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "uid" stopped in 0.000002 2024-11-21 10:03:38,471 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Restored ctx dict_keys([])