2025-03-19 17:30:02,275 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "file_in_memory_log" initialized in 0.000014 2025-03-19 17:30:02,276 DEBUG (root) [MainThread] Release revision: 16120592 2025-03-19 17:30:02,276 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "revision" initialized in 0.000859 2025-03-19 17:30:02,276 DEBUG (yalibrary.vcs) [MainThread] detecting vcs from /home/runner/actions_runner/_work/ydb/ydb for paths: None 2025-03-19 17:30:02,276 DEBUG (yalibrary.vcs) [MainThread] common root: /home/runner/actions_runner/_work/ydb/ydb 2025-03-19 17:30:02,277 DEBUG (yalibrary.vcs) [MainThread] vcs root: /home/runner/actions_runner/_work/ydb/ydb (git) 2025-03-19 17:30:02,277 DEBUG (root) [MainThread] vcs type: git 2025-03-19 17:30:02,277 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" initialized in 0.000206 2025-03-19 17:30:02,277 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "exit" initialized in 0.000002 2025-03-19 17:30:02,277 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "handler_info" initialized in 0.000001 2025-03-19 17:30:02,277 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "metrics_reporter" initialized in 0.000023 2025-03-19 17:30:02,277 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2025-03-19 17:30:02,277 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "report" initialized in 0.000526 2025-03-19 17:30:02,277 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "exit_code" initialized in 0.000001 2025-03-19 17:30:02,277 DEBUG (root) [MainThread] Start up timestamp 2025-03-19T17:30:02.UTC (2025-03-19T17:30:02.UTC) 2025-03-19 17:30:02,277 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "lifecycle_ts" initialized in 0.000035 2025-03-19 17:30:02,277 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "env_checker" initialized in 0.000005 2025-03-19 17:30:02,278 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" initialized in 0.000392 2025-03-19 17:30:02,278 DEBUG (library.python.tmp) [MainThread] Set TMPDIR=/home/runner/.ya/tmp/1742405402.33222.inxnaqb6 instead of None 2025-03-19 17:30:02,278 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "tmp_dir" initialized in 0.000142 2025-03-19 17:30:02,278 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=modules-initialization-early, group=overall-execution, time=1742405402.2786052 2025-03-19 17:30:02,278 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage modules-initialization-early_finished=1742405402.2786052 2025-03-19 17:30:02,278 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step modules-initialization-early_finished - 1742405402.2786052 2025-03-19 17:30:02,279 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=handler-selection, group=overall-execution, time=1742405402.279107 2025-03-19 17:30:02,279 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage handler-selection_started=1742405402.279107 2025-03-19 17:30:02,279 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step handler-selection_started - 1742405402.279107 2025-03-19 17:30:02,279 DEBUG (devtools.ya.core.plugin_loader) [MainThread] Load devtools.ya.handlers.make 2025-03-19 17:30:02,293 DEBUG (devtools.ya.core.yarg.config_files) [MainThread] Load data from config /home/runner/actions_runner/_work/ydb/ydb/ya.conf 2025-03-19 17:30:02,293 DEBUG (devtools.ya.core.yarg.config_files) [MainThread] Found 20 keys 2025-03-19 17:30:02,293 DEBUG (devtools.ya.core.yarg.populate) [MainThread] Use config file `/home/runner/actions_runner/_work/ydb/ydb/ya.conf` with `20` keys 2025-03-19 17:30:02,293 DEBUG (devtools.ya.core.yarg.populate) [MainThread] No aliases to inject 2025-03-19 17:30:02,294 DEBUG (devtools.ya.core.yarg.config_files) [MainThread] Unknown config parameter `use_atd_revisions_info` 2025-03-19 17:30:02,294 DEBUG (devtools.ya.core.yarg.config_files) [MainThread] Load data from config /home/runner/actions_runner/_work/ydb/ydb/build/internal/ya.conf 2025-03-19 17:30:02,295 DEBUG (devtools.ya.core.yarg.config_files) [MainThread] Found 9 keys 2025-03-19 17:30:02,295 DEBUG (devtools.ya.core.yarg.populate) [MainThread] Use config file `/home/runner/actions_runner/_work/ydb/ydb/build/internal/ya.conf` with `9` keys 2025-03-19 17:30:02,295 DEBUG (devtools.ya.core.yarg.populate) [MainThread] No aliases to inject 2025-03-19 17:30:02,295 DEBUG (devtools.ya.core.yarg.config_files) [MainThread] Unknown config parameter `bazel_remote_client_decompress` 2025-03-19 17:30:02,303 DEBUG (devtools.ya.build.build_opts) [MainThread] Failed to make int from size: 2TB. Will fallback to parse_size 2025-03-19 17:30:02,305 DEBUG (devtools.ya.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' 2025-03-19 17:30:02,305 DEBUG (devtools.ya.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' 2025-03-19 17:30:02,306 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=handler-selection, group=overall-execution, time=1742405402.3065455 2025-03-19 17:30:02,306 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage handler-selection_finished=1742405402.3065455 2025-03-19 17:30:02,306 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step handler-selection_finished - 1742405402.3065455 2025-03-19 17:30:02,306 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=modules-initialization-full, group=overall-execution, time=1742405402.3066847 2025-03-19 17:30:02,306 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage modules-initialization-full_started=1742405402.3066847 2025-03-19 17:30:02,306 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step modules-initialization-full_started - 1742405402.3066847 2025-03-19 17:30:02,307 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', 'username', 'file_log', 'display_in_memory_log', 'file_in_memory_log', 'revision', 'vcs_type', 'exit', 'handler_info', 'metrics_reporter', 'report', 'exit_code', 'lifecycle_ts', 'env_checker', 'fetchers_storage', 'tmp_dir', 'params', 'hide_token', 'state', 'display']) 2025-03-19 17:30:02,307 DEBUG (devtools.ya.core.respawn) [MainThread] Same as prev source root /home/runner/actions_runner/_work/ydb/ydb 2025-03-19 17:30:02,307 DEBUG (devtools.ya.core.respawn.pyver) [MainThread] No need to respawn to other ya-bin version 2025-03-19 17:30:02,307 DEBUG (devtools.ya.core.respawn) [MainThread] Unsetting YA_STDIN env var as respawn never happened 2025-03-19 17:30:02,307 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "params" initialized in 0.000309 2025-03-19 17:30:02,309 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2025-03-19 17:30:02,309 DEBUG (root) [MainThread] Update replacements in 2025-03-19 17:30:02,309 DEBUG (root) [MainThread] Add suppressing formatter to 2025-03-19 17:30:02,309 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2025-03-19 17:30:02,309 DEBUG (root) [MainThread] Add suppressing formatter to 2025-03-19 17:30:02,309 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2025-03-19 17:30:02,309 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token" initialized in 0.002238 2025-03-19 17:30:02,310 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "state" initialized in 0.000265 2025-03-19 17:30:02,310 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display" initialized in 0.000058 2025-03-19 17:30:02,310 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2025-03-19 17:30:02,311 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "custom_file_log" initialized in 0.000953 2025-03-19 17:30:02,311 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display_log" initialized in 0.000044 2025-03-19 17:30:02,311 DEBUG (yalibrary.vcs) [MainThread] detecting vcs from /home/runner/actions_runner/_work/ydb/ydb for paths: None 2025-03-19 17:30:02,311 DEBUG (yalibrary.vcs) [MainThread] common root: /home/runner/actions_runner/_work/ydb/ydb 2025-03-19 17:30:02,311 DEBUG (yalibrary.vcs) [MainThread] vcs root: /home/runner/actions_runner/_work/ydb/ydb (git) 2025-03-19 17:30:02,311 DEBUG (root) [MainThread] vcs type: git 2025-03-19 17:30:02,311 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" initialized in 0.000234 2025-03-19 17:30:02,311 DEBUG (devtools.ya.app) [MainThread] origin: github 2025-03-19 17:30:02,311 DEBUG (devtools.ya.app) [MainThread] python: sys.version_info(major=3, minor=12, micro=9, releaselevel='final', serial=0) 2025-03-19 17:30:02,311 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "self_info" initialized in 0.000100 2025-03-19 17:30:02,311 DEBUG (devtools.ya.app) [MainThread] Custom fetcher: None, fetcher parameters: [{'name': 'custom'}, {'name': 'proxy'}, {'name': 'skynet'}, {'name': 'mds'}, {'name': 'sandbox'}], sb_token none 2025-03-19 17:30:02,311 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher_params" initialized in 0.000076 2025-03-19 17:30:02,311 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "use_universal_fetcher_everywhere" initialized in 0.000002 2025-03-19 17:30:02,311 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "docker_config_path" initialized in 0.000002 2025-03-19 17:30:02,312 DEBUG (devtools.ya.core.sec) [MainThread] Found 0 secrets 2025-03-19 17:30:02,312 DEBUG (root) [MainThread] Update replacements in 2025-03-19 17:30:02,313 DEBUG (root) [MainThread] Update replacements in 2025-03-19 17:30:02,313 DEBUG (root) [MainThread] Update replacements in DisplayStreamHandler 2025-03-19 17:30:02,313 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token2" initialized in 0.001083 2025-03-19 17:30:02,313 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" initialized in 0.000081 2025-03-19 17:30:02,313 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher" initialized in 0.000002 2025-03-19 17:30:02,313 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "showstack" initialized in 0.000147 2025-03-19 17:30:02,313 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "profile" initialized in 0.000002 2025-03-19 17:30:02,313 DEBUG (devtools.ya.app) [MainThread] mlockall return code: 12 2025-03-19 17:30:02,313 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "mlockall" initialized in 0.000038 2025-03-19 17:30:02,313 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "event_queue" initialized in 0.000005 2025-03-19 17:30:02,313 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "changelist_store" initialized in 0.000278 2025-03-19 17:30:02,314 DEBUG (root) [MainThread] Event log file is /home/runner/actions_runner/_work/ydb/ydb/tmp/results/try_1/ya_evlog.jsonl 2025-03-19 17:30:02,314 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "evlog" initialized in 0.000425 2025-03-19 17:30:02,355 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "dump_debug" initialized in 0.040829 2025-03-19 17:30:02,355 DEBUG (devtools.ya.app) [MainThread] Run action on with params {'build_type': 'release', 'sanitize': 'address', 'sanitizer_flags': [], 'lto': None, 'thinlto': None, 'musl': None, 'sanitize_coverage': None, 'use_afl': False, 'hardening': False, 'race': False, 'cuda_platform': 'optional', 'flags': {'OPENSOURCE': 'yes', 'USE_PREBUILT_TOOLS': 'no', 'APPLE_SDK_LOCAL': 'yes', 'USE_CLANG_CL': 'yes', 'USE_AIO': 'static', 'USE_ICONV': 'static', 'USE_IDN': 'static', 'CFLAGS': '-fno-omit-frame-pointer -Wno-unknown-argument', 'USE_EAT_MY_DATA': 'yes', 'DEBUGINFO_LINES_ONLY': 'yes', 'CONSISTENT_DEBUG': 'yes', 'TESTS_REQUESTED': 'yes', 'DISABLE_FLAKE8_MIGRATIONS': 'yes'}, 'host_flags': {'TESTS_REQUESTED': 'yes'}, 'custom_fetcher': None, 'fetcher_params': [{'name': 'custom'}, {'name': 'proxy'}, {'name': 'skynet'}, {'name': 'mds'}, {'name': 'sandbox'}], 'fetcher_params_str': None, 'use_universal_fetcher_everywhere': False, 'use_universal_fetcher_for_dist_results': False, 'clear_build': False, 'yndexing': False, 'yt_cluster': None, 'yt_root': None, 'yt_codenav_extra_opts': None, 'java_yndexing': False, 'kythe_to_proto_tool': None, 'py3_yndexing': False, 'py_yndexing': True, 'ts_yndexing': False, 'strict_inputs': False, 'sandboxing': False, 'default_node_requirements': {'network': 'restricted'}, 'default_node_requirements_str': None, 'build_results_report_file': '/home/runner/actions_runner/_work/ydb/ydb/tmp/results/try_1/report.json', 'build_report_type': 'canonical', 'build_results_resource_id': None, 'build_results_report_tests_only': False, 'report_skipped_suites': False, 'report_skipped_suites_only': False, 'use_links_in_report': False, 'report_config_path': None, 'dump_raw_results': False, 'json_line_report_file': None, 'external_py_files': False, 'continue_on_fail': False, 'print_statistics': True, 'statistics_out_dir': None, 'be_verbose': False, 'detailed_args': False, 'do_not_output_stderrs': False, 'output_style': 'make', 'mask_roots': False, 'status_refresh_interval': 0.1, 'do_emit_status': True, 'do_not_emit_nodes': [], 'use_roman_numerals': False, 'profile_to_file': None, 'stages_profile': None, 'misc_build_info_dir': None, 'debug_options': [], 'clear_ymake_cache': False, 'vcs_file': None, 'dump_file_path': None, 'trace_context_json': None, 'conf_debug_options': [], 'extra_conf': None, 'ignore_configure_errors': False, 'ymake_bin': None, 'no_ymake_resource': False, 'no_yabin_resource': False, 'no_caches_on_retry': False, 'no_ymake_retry': False, 'ymake_tool_servermode': False, 'ymake_pic_servermode': False, 'use_local_conf': True, 'local_conf_path': None, 'random_build_root': True, 'limit_build_root_size': False, 'build_threads': 64, 'link_threads': 12, 'custom_json': None, 'custom_context': None, 'ignore_nodes_exit_code': False, 'dump_graph': None, 'dump_graph_file': None, 'use_json_cache': True, 'visible': None, 'advanced': True, 'c_compiler': None, 'cxx_compiler': None, 'host_platform': None, 'host_platform_flags': {'OPENSOURCE': 'yes', 'USE_PREBUILT_TOOLS': 'no', 'APPLE_SDK_LOCAL': 'yes', 'USE_CLANG_CL': 'yes', 'USE_AIO': 'static', 'USE_ICONV': 'static', 'USE_IDN': 'static', 'CFLAGS': '-fno-omit-frame-pointer -Wno-unknown-argument'}, 'host_build_type': 'release', 'target_platforms': [], 'platform_schema_validation': False, 'hide_arm64_host_warning': False, 'add_result': [], 'add_host_result': [], 'replace_result': False, 'all_outputs_to_result': False, 'add_modules_to_results': False, 'gen_renamed_results': True, 'strip_packages_from_results': False, 'strip_binary_from_results': False, 'do_clear': False, 'show_command': [], 'show_timings': False, 'ext_progress': False, 'local_executor': True, 'executor_address': None, 'eager_execution': False, 'use_clonefile': True, 'runner_dir_outputs': True, 'dir_outputs_test_mode': True, 'schedule_strategy': 'deeper_first__lpt', 'force_build_depends': True, 'ignore_recurses': False, 'create_symlinks': True, 'symlink_root': None, 'set_nice_value': 10, 'request_content_uids': True, 'force_content_uids': False, 'validate_build_root_content': False, 'run_tests': 3, 'run_tests_size': 1, 'peerdirs_test_type': 'none', 'fail_fast': False, 'test_threads': 52, 'testing_split_factor': 0, 'test_prepare': False, 'cpu_detect_via_ram': True, 'list_tests': False, 'list_before_test': False, 'arcadia_tests_data_path': 'arcadia_tests_data', 'canonization_transport': None, 'canonize_tests': False, 'test_diff': None, 'canonization_backend': 'ydb-canondata.storage.yandexcloud.net', 'canonization_scheme': 'https', 'custom_canondata_path': None, 'inline_diff': False, 'max_test_comment_size': None, 'omitted_test_statuses': ['good', 'xfail', 'not_launched'], 'print_test_console_report': True, 'show_deselected_tests': False, 'show_metrics': False, 'show_passed_tests': False, 'show_skipped_tests': False, 'test_console_report': True, 'show_final_ok': True, 'build_coverage_report': False, 'clang_coverage': False, 'coverage': False, 'coverage_direct_upload_yt': True, 'coverage_exclude_regexp': None, 'coverage_failed_upload_uids_file': None, 'coverage_prefix_filter': None, 'coverage_report_path': None, 'coverage_succeed_upload_uids_file': None, 'coverage_upload_snapshot_name': None, 'coverage_verbose_resolve': False, 'coverage_yt_token_path': None, 'enable_contrib_coverage': False, 'enable_java_contrib_coverage': False, 'fast_clang_coverage_merge': False, 'go_coverage': False, 'java_coverage': False, 'merge_coverage': False, 'nlg_coverage': False, 'python_coverage': False, 'sancov_coverage': False, 'ts_coverage': False, 'upload_coverage_report': False, 'debugger_requested': False, 'gdb': False, 'pdb': False, 'dlv': False, 'dlv_args': None, 'random_ports': True, 'test_allow_graceful_shutdown': True, 'test_debug': False, 'test_disable_timeout': False, 'test_stderr': False, 'test_stdout': False, 'tests_retries': 1, 'test_binary_args': [], 'dump_test_environment': False, 'show_test_cwd': False, 'drop_graph_result_before_tests': False, 'strip_skipped_test_deps': False, 'strip_idle_build_results': False, 'backup_test_results': False, 'allure_report': None, 'junit_path': '/home/runner/actions_runner/_work/ydb/ydb/tmp/results/try_1/junit.xml', 'last_failed_tests': False, 'test_files_filter': [], 'test_size_filters': ['small', 'medium'], 'test_size_timeouts': {}, 'test_tag_string': None, 'test_tags_filter': [], 'test_type_filters': [], 'test_class_filters': [], 'tests_filters': [], 'tests_chunk_filters': [], 'style': False, 'regular_tests': False, 'fuzz_case_filename': None, 'fuzz_force_minimization': False, 'fuzz_local_store': False, 'fuzz_minimization_only': False, 'fuzz_node_timeout': None, 'fuzz_opts': '', 'fuzz_runs': None, 'fuzz_proof': 0, 'fuzzing': False, 'cache_fs_read': False, 'cache_fs_write': False, 'merge_split_tests': True, 'remove_result_node': True, 'remove_tos': False, 'test_fail_exit_code': '0', 'detect_leaks_in_pytest': True, 'fail_maven_export_with_tests': True, 'use_jstyle_server': True, 'setup_pythonpath_env': True, 'use_command_file_in_testtool': True, 'use_throttling': False, 'remove_implicit_data_path': True, 'no_tests_is_error': False, 'tests_limit_in_suite': 100000, 'cache_test_statuses': None, 'skip_cross_compiled_tests': True, 'propagate_test_timeout_info': False, 'ytexec_node_timeout': None, 'store_original_tracefile': False, 'ignored_properties_files': [], 'jstyle_runner_path': None, 'jvm_args': None, 'properties': {}, 'properties_files': [], 'disable_flake8_migrations': True, 'flake8_file_processing_delay': 1.5, 'disable_jstyle_migrations': False, 'dir_outputs': False, 'keep_full_test_logs': False, 'output_only_tests': False, 'save_test_outputs': True, 'dir_outputs_in_nodes': False, 'test_keep_symlinks': False, 'test_output_compression_filter': 'zstd', 'test_output_compression_level': 1, 'test_node_output_limit': None, 'profile_pytest': False, 'test_log_level': None, 'test_traceback': 'short', 'pytest_args': [], 'collect_cores': True, 'no_src_changes': False, 'private_ram_drive': False, 'private_net_ns': False, 'autocheck_mode': False, 'test_env': [], 'test_params': {}, 'force_create_frepkage': False, 'frepkage_root': 'UNSPECIFIED', 'frepkage_target_uid': None, 'run_tagged_tests_on_sandbox': False, 'run_tagged_tests_on_yt': False, 'ytexec_bin': None, 'ytexec_wrapper_m_cpu': 250, 'vanilla_execute_yt_token_path': None, 'ytexec_title_suffix': None, 'test_tool_bin': None, 'test_tool3_bin': None, 'profile_test_tool': [], 'cache_tests': False, 'test_types_fakeid': {}, 'test_fakeid': 'r13102898', 'force_retest': True, 'hermione_config': None, 'hermione_grep': None, 'hermione_test_paths': [], 'hermione_browsers': [], 'hermione_sets': [], 'hermione_gui': False, 'hermione_gui_auto_run': False, 'hermione_gui_no_open': False, 'hermione_gui_hostname': None, 'hermione_gui_port': None, 'junit_args': None, 'ttl': 14, 'oauth_token': None, 'oauth_token_path': None, 'docker_config_path': None, 'username': 'runner', 'ssh_keys': [], 'ssh_key_option_name': '--ssh-key', 'oauth_exchange_ssh_keys': True, 'store_oauth_token': True, 'ssh_user_option_name': '--user', 'sandbox': False, 'sandbox_url': 'https://sandbox.yandex-team.ru', 'resource_owner': 'runner', 'task_kill_timeout': None, 'sandbox_owner_option_name': '--owner', 'mds': False, 'mds_host': 'storage.yandex-team.ru', 'mds_port': 443, 'mds_namespace': 'devtools', 'mds_token': None, 'sonar': False, 'sonar_project_filters': [], 'sonar_properties': {}, 'sonar_do_not_compile': False, 'sonar_default_project_filter': False, 'sonar_java_args': [], 'output_root': '/home/runner/actions_runner/_work/ydb/ydb/tmp/out', 'suppress_outputs': [], 'default_suppress_outputs': ['.o', '.obj', '.mf', '..', '.cpf', '.cpsf', '.srclst', '.fake', '.vet.out', '.vet.txt', '.self.protodesc'], 'prefetch': False, 'generate_bin_dir': None, 'generate_lib_dir': None, 'install_dir': None, 'keep_temps': False, 'html_display': None, 'teamcity': False, 'profile_to': None, 'log_file': '/home/runner/actions_runner/_work/ydb/ydb/tmp/results/ya_log.txt', 'evlog_file': '/home/runner/actions_runner/_work/ydb/ydb/tmp/results/try_1/ya_evlog.jsonl', 'no_evlogs': False, 'dump_platform_to_evlog': False, 'dump_failed_node_info_to_evlog': False, 'evlog_dump_node_stat': False, 'compress_evlog': True, 'stdout': None, 'tools_cache': True, 'tools_cache_master': True, 'build_cache': True, 'build_cache_master': True, 'tools_cache_bin': None, 'tools_cache_ini': None, 'tools_cache_conf': {}, 'tools_cache_conf_str': [], 'build_cache_conf': {'cas_logging': 'true', 'graph_info': 'true'}, 'build_cache_conf_str': ['cas_logging=true', 'graph_info=true'], 'tools_cache_gl_conf': {}, 'tools_cache_gl_conf_str': [], 'tools_cache_size': 32212254720, 'strip_cache': False, 'strip_symlinks': False, 'symlinks_ttl': 604800, 'cache_stat': False, 'cache_codec': '', 'new_store': True, 'new_runner': True, 'new_store_ttl': 259200, 'cache_size': 2199023255552, 'auto_clean_results_cache': True, 'yt_proxy': '', 'yt_dir': '', 'yt_token': None, 'yt_token_path': None, 'yt_readonly': True, 'yt_max_cache_size': None, 'yt_store_ttl': 24, 'dist_cache_evict_binaries': False, 'dist_cache_evict_bundles': False, 'dist_cache_evict_cached': False, 'dist_cache_max_file_size': 209715200, 'dist_store_threads': 76, 'dist_cache_late_fetch': True, 'yt_store': False, 'yt_create_tables': False, 'yt_self_uid': False, 'yt_cache_filter': None, 'yt_store_codec': None, 'yt_replace_result': False, 'yt_replace_result_yt_upload_only': False, 'yt_replace_result_add_objects': False, 'yt_store_exclusive': False, 'yt_store_threads': 0, 'yt_store_wt': True, 'yt_store_refresh_on_read': False, 'yt_store_cpp_client': True, 'yt_store_cpp_prepare_data': False, 'yt_store_probe_before_put': False, 'yt_store_probe_before_put_min_size': 0, 'bazel_remote_store': True, 'bazel_remote_baseuri': 'http://cachesrv.internal:8081', 'bazel_remote_username': 'cache_user', 'bazel_remote_password': None, 'bazel_remote_password_file': '/tmp/tmp.XZ7mSHjaru', 'bazel_remote_readonly': False, 'warn_mode': ['dirloops', 'ChkPeers'], 'get_deps': None, 'dump_sources': False, 'export_to_maven': False, 'version': None, 'deploy': False, 'repository_id': None, 'repository_url': None, 'maven_settings': None, 'maven_output': None, 'javac_flags': {}, 'error_prone_flags': [], 'maven_no_recursive_deps': False, 'maven_exclude_transitive_deps': False, 'disable_scriptgen': False, 'pgo_add': False, 'pgo_path': None, 'pgo_user_path': [], 'force_pic': False, 'terminal_profile': {}, 'thin_checkout': False, 'testenv_report_dir': None, 'streaming_report_id': None, 'streaming_report_url': None, 'stream_partition': 0, 'streaming_task_id': None, 'keep_alive_streams': set(), 'streaming_stage_namespace': None, 'report_only_stages': False, 'report_to_ci': False, 'ci_logbroker_token': None, 'ci_topic': None, 'ci_source_id': None, 'ci_check_id': None, 'ci_check_type': None, 'ci_iteration_number': None, 'ci_task_id_string': None, 'ci_logbroker_partition_group': None, 'ci_use_ydb_topic_client': False, 'raw_params': None, 'preset_mapsmobi': False, 'preset_with_credits': False, 'preset_disable_customization': False, 'ya_threads': 64, 'dump_debug_path': None, 'dump_debug_enabled': True, 'compress_ymake_output': False, 'compress_ymake_output_codec': 'zstd08_1', 'ya_bin3_required': None, 'use_distbuild': False, 'json_prefix': None, 'share_results': False, 'graph_stat_path': None, 'dump_graph_execution_cost': False, 'download_artifacts': False, 'upload_to_remote_store': False, 'build_graph_cache_heater': False, 'build_graph_cache_dir': None, 'build_graph_cache_archive': None, 'build_graph_cache_cl': None, 'build_graph_cache_trust_cl': False, 'build_graph_autocheck_params': None, 'build_graph_autocheck_params_str': None, 'build_graph_cache_resource': None, 'build_graph_cache_from_sb': False, 'build_graph_source_root_pattern': 'SOURCE_ROOT', 'build_graph_result_dir': None, 'build_graph_arc_server': 'arc-vcs.yandex-team.ru:5623', 'build_graph_public_arc_server': 'arc-devtools.arc-vcs.yandex-team.ru:6734', 'build_graph_use_ymake_cache_params': None, 'build_graph_use_ymake_cache_params_str': None, 'build_graph_use_public_api': False, 'abs_targets': ['/home/runner/actions_runner/_work/ydb/ydb'], 'rel_targets': ['.'], 'arc_root': '/home/runner/actions_runner/_work/ydb/ydb', 'bld_dir': '/home/runner/.ya/build', 'bld_root': '/home/runner/.ya/build/build_root', 'custom_build_directory': '/home/runner/.ya/build/build_root'} 2025-03-19 17:30:02,356 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=modules-initialization-full, group=overall-execution, time=1742405402.3565063 2025-03-19 17:30:02,356 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage modules-initialization-full_finished=1742405402.3565063 2025-03-19 17:30:02,356 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step modules-initialization-full_finished - 1742405402.3565063 2025-03-19 17:30:02,356 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=invoke-do_ya_make, group=overall-execution, time=1742405402.356698 2025-03-19 17:30:02,356 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage invoke-do_ya_make_started=1742405402.356698 2025-03-19 17:30:02,356 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step invoke-do_ya_make_started - 1742405402.356698 2025-03-19 17:30:02,501 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=ya_make_handler, group=build_handler, time=1742405402.501546 2025-03-19 17:30:02,501 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage ya_make_handler_started=1742405402.501546 2025-03-19 17:30:02,501 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step ya_make_handler_started - 1742405402.501546 2025-03-19 17:30:02,501 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=context_generating, group=build_handler, time=1742405402.501836 2025-03-19 17:30:02,501 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage context_generating_started=1742405402.501836 2025-03-19 17:30:02,501 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step context_generating_started - 1742405402.501836 2025-03-19 17:30:02,501 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=build_graph_cache_configuration, group=build_handler, time=1742405402.5019624 2025-03-19 17:30:02,502 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage build_graph_cache_configuration_started=1742405402.5019624 2025-03-19 17:30:02,502 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step build_graph_cache_configuration_started - 1742405402.5019624 2025-03-19 17:30:02,502 DEBUG (devtools.ya.build.ya_make) [MainThread] Build graph cache processing started 2025-03-19 17:30:02,502 DEBUG (devtools.ya.build.ya_make) [MainThread] Build graph cache processing disabled 2025-03-19 17:30:02,502 DEBUG (devtools.ya.build.ya_make) [MainThread] Build graph cache is not available in opensource 2025-03-19 17:30:02,502 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=build_graph_cache_configuration, group=build_handler, time=1742405402.5021644 2025-03-19 17:30:02,502 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage build_graph_cache_configuration_finished=1742405402.5021644 2025-03-19 17:30:02,502 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step build_graph_cache_configuration_finished - 1742405402.5021644 2025-03-19 17:30:02,502 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=context_creation, group=ya_make, time=1742405402.502427 2025-03-19 17:30:02,502 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage context_creation_started=1742405402.502427 2025-03-19 17:30:02,502 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step context_creation_started - 1742405402.502427 2025-03-19 17:30:02,505 DEBUG (yalibrary.toolscache) [MainThread] Tools cache uses passed opts 2025-03-19 17:30:02,505 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={} 2025-03-19 17:30:02,505 DEBUG (devtools.ya.build.ya_make) [MainThread] content UIDs enabled by request 2025-03-19 17:30:02,507 DEBUG (devtools.ya.build.ya_make) [Misc-00] Using '/tmp/tmp.XZ7mSHjaru' file to obtain bazel remote password 2025-03-19 17:30:02,507 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=build_graph_and_tests, group=graph, time=1742405402.5078287 2025-03-19 17:30:02,508 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage build_graph_and_tests_started=1742405402.5078287 2025-03-19 17:30:02,508 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step build_graph_and_tests_started - 1742405402.5078287 2025-03-19 17:30:02,508 DEBUG (devtools.ya.build.graph) [Misc-01] Collect vcs info 2025-03-19 17:30:02,509 DEBUG (devtools.ya.core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/ya.conf.json 2025-03-19 17:30:02,509 DEBUG (yalibrary.vcs) [Misc-01] detecting vcs from /home/runner/actions_runner/_work/ydb/ydb for paths: ['/home/runner/actions_runner/_work/ydb/ydb'] 2025-03-19 17:30:02,509 DEBUG (yalibrary.vcs) [Misc-01] common root: /home/runner/actions_runner/_work/ydb/ydb 2025-03-19 17:30:02,510 DEBUG (devtools.ya.core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/platform/clang/clang16.json 2025-03-19 17:30:02,510 DEBUG (yalibrary.vcs) [Misc-01] vcs root: /home/runner/actions_runner/_work/ydb/ydb (git) 2025-03-19 17:30:02,512 DEBUG (devtools.ya.core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/platform/clang/clang18.json 2025-03-19 17:30:02,514 DEBUG (devtools.ya.build.graph) [MainThread] flags: { "APPLE_SDK_LOCAL": "yes", "CFLAGS": "-fno-omit-frame-pointer -Wno-unknown-argument", "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" } 2025-03-19 17:30:02,514 DEBUG (devtools.ya.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 -Wno-unknown-argument", "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:7599484265" }, "darwin-x86_64": { "uri": "sbr:7599517506" }, "linux-aarch64": { "uri": "sbr:7599285566" }, "linux-x86_64": { "uri": "sbr:7599469156" }, "win32-x86_64": { "uri": "sbr:7599422144" } } }, "name": "clang18", "params": { "c_compiler": "$(CLANG-2518231432)/bin/clang", "cxx_compiler": "$(CLANG-2518231432)/bin/clang++", "llvm-symbolizer": "$(CLANG-2518231432)/bin/llvm-symbolizer", "match_root": "CLANG-2518231432", "nm": "$(CLANG-2518231432)/bin/llvm-nm", "objcopy": "$(CLANG-2518231432)/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-2518231432)/bin/llvm-strip", "type": "clang", "use_bundle": true, "version": "18" }, "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-2518231432" } 2025-03-19 17:30:02,514 DEBUG (devtools.ya.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:7599484265" }, "darwin-x86_64": { "uri": "sbr:7599517506" }, "linux-aarch64": { "uri": "sbr:7599285566" }, "linux-x86_64": { "uri": "sbr:7599469156" }, "win32-x86_64": { "uri": "sbr:7599422144" } } }, "name": "clang18", "params": { "c_compiler": "$(CLANG-2518231432)/bin/clang", "cxx_compiler": "$(CLANG-2518231432)/bin/clang++", "llvm-symbolizer": "$(CLANG-2518231432)/bin/llvm-symbolizer", "match_root": "CLANG-2518231432", "nm": "$(CLANG-2518231432)/bin/llvm-nm", "objcopy": "$(CLANG-2518231432)/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-2518231432)/bin/llvm-strip", "type": "clang", "use_bundle": true, "version": "18" }, "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-2518231432" } 2025-03-19 17:30:02,514 DEBUG (yalibrary.tools) [MainThread] Using old-style toolchain for: ymake 2025-03-19 17:30:02,515 DEBUG (devtools.ya.core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/ymake/public.resources.json 2025-03-19 17:30:02,515 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ymake: try to fetch by {'darwin': {'uri': 'sbr:8270821170'}, 'darwin-arm64': {'uri': 'sbr:8270820457'}, 'linux': {'uri': 'sbr:8270822128'}, 'linux-aarch64': {'uri': 'sbr:8270819892'}, 'win32': {'uri': 'sbr:8270821739'}} for 'linux' 2025-03-19 17:30:02,515 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ymake: will use 'linux' platform 2025-03-19 17:30:02,515 DEBUG (yalibrary.fetcher.resource_fetcher) [MainThread] Fetching 8270822128 from sbr:8270822128 to /home/runner/.ya/tools/v4/8270822128 dir, post_process=0) 2025-03-19 17:30:02,515 DEBUG (devtools.ya.core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/mapping.conf.json 2025-03-19 17:30:02,517 DEBUG (devtools.ya.core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/ext_mapping.conf.json 2025-03-19 17:30:02,527 DEBUG (yalibrary.toolscache) [MainThread] Tools cache attempt: (request for resource 8270822128) 2025-03-19 17:30:02,527 DEBUG (yalibrary.toolscache) [MainThread] Tools cache server resource download/parameters 2025-03-19 17:30:02,527 DEBUG (yalibrary.tools) [MainThread] Using old-style toolchain for: ya-tc 2025-03-19 17:30:02,527 DEBUG (devtools.ya.core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/ya-tc/public.resources.json 2025-03-19 17:30:02,527 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' 2025-03-19 17:30:02,527 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ya-tc: will use 'linux' platform 2025-03-19 17:30:02,528 DEBUG (yalibrary.fetcher.resource_fetcher) [MainThread] Fetching 6812260917 from sbr:6812260917 to /home/runner/.ya/tools/v4/6812260917 dir, post_process=0) 2025-03-19 17:30:02,528 DEBUG (yalibrary.toolscache) [MainThread] tc cache stats: None 2025-03-19 17:30:02,528 DEBUG (yalibrary.fetcher.cache_helper) [MainThread] Resource seems to be installed in /home/runner/.ya/tools/v4/6812260917 2025-03-19 17:30:02,528 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ya-tc: successfully fetched into /home/runner/.ya/tools/v4/6812260917 2025-03-19 17:30:02,528 DEBUG (yalibrary.tools) [MainThread] Using old-style toolchain for: ya-tc 2025-03-19 17:30:02,528 DEBUG (yalibrary.toolscache) [MainThread] tc cache stats: None 2025-03-19 17:30:02,528 DEBUG (yalibrary.toolscache) [MainThread] Tools cache server resource download/parameters done: id=6812260917, full_path=/home/runner/.ya/tools/v4/6812260917/ya-tc 2025-03-19 17:30:02,532 DEBUG (yalibrary.toolscache) [MainThread] Tools cache (request for resource 8270822128) address: (32663, 492350, 'unix:/home/runner/.ya/tools/v4/psingpZ3Olq.tmp') 2025-03-19 17:30:02,538 DEBUG (yalibrary.toolscache) [MainThread] tc cache stats: TotalKnownSize: 55046144 TotalKnownSizeLocked: 22249472 Master: true TotalDBSize: 81920 ToolCount: 2 ProcessesCount: 2 2025-03-19 17:30:02,538 DEBUG (yalibrary.fetcher.cache_helper) [MainThread] Resource seems to be installed in /home/runner/.ya/tools/v4/8270822128 2025-03-19 17:30:02,538 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ymake: successfully fetched into /home/runner/.ya/tools/v4/8270822128 2025-03-19 17:30:02,538 DEBUG (exts.timer) [MainThread] Timer devtools.ya.build.graph, stage fetch ymake: 0.023952245712280273 2025-03-19 17:30:02,539 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_0] Start stage tag=gen-graph-default-linux-x86_64-release-asan-nopic, group=graph, time=1742405402.5393999 2025-03-19 17:30:02,539 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_0] Set stage gen-graph-default-linux-x86_64-release-asan-nopic_started=1742405402.5393999 2025-03-19 17:30:02,539 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_0] Profile step gen-graph-default-linux-x86_64-release-asan-nopic_started - 1742405402.5393999 2025-03-19 17:30:02,540 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_1] Start stage tag=gen-graph-default-linux-x86_64-release-asan-pic, group=graph, time=1742405402.539844 2025-03-19 17:30:02,540 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_1] Set stage gen-graph-default-linux-x86_64-release-asan-pic_started=1742405402.539844 2025-03-19 17:30:02,540 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_1] Profile step gen-graph-default-linux-x86_64-release-asan-pic_started - 1742405402.539844 2025-03-19 17:30:02,540 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=get-tools, group=graph, time=1742405402.5402124 2025-03-19 17:30:02,541 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage get-tools_started=1742405402.5402124 2025-03-19 17:30:02,541 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step get-tools_started - 1742405402.5402124 2025-03-19 17:30:02,541 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_0] Start stage tag=gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic, group=graph, time=1742405402.5406487 2025-03-19 17:30:02,541 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_0] Set stage gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic_started=1742405402.5406487 2025-03-19 17:30:02,541 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_0] Profile step gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic_started - 1742405402.5406487 2025-03-19 17:30:02,541 DEBUG (yalibrary.guards) [ThreadPoolExecutor-0_0] Enter guard fetch with value None 2025-03-19 17:30:02,541 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_1] Start stage tag=gen-graph-gen-opts-default-linux-x86_64-release-asan-pic, group=graph, time=1742405402.5409043 2025-03-19 17:30:02,541 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_1] Set stage gen-graph-gen-opts-default-linux-x86_64-release-asan-pic_started=1742405402.5409043 2025-03-19 17:30:02,541 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_1] Profile step gen-graph-gen-opts-default-linux-x86_64-release-asan-pic_started - 1742405402.5409043 2025-03-19 17:30:02,541 DEBUG (yalibrary.guards) [ThreadPoolExecutor-0_1] Enter guard fetch with value None 2025-03-19 17:30:02,542 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=waiting-tool-targets, group=graph, time=1742405402.5412056 2025-03-19 17:30:02,542 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage waiting-tool-targets_started=1742405402.5412056 2025-03-19 17:30:02,542 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step waiting-tool-targets_started - 1742405402.5412056 2025-03-19 17:30:02,543 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 2025-03-19 17:30:02,545 DEBUG (yalibrary.vcs.vcsversion) [Misc-01] b"fatal: no tag exactly matches '36a8b525218dc7f13498a707dfbd1ab966f7c8db'\n" Running git describe --exact-match --all HEAD failed with exit code 128 2025-03-19 17:30:02,548 DEBUG (yalibrary.vcs.vcsversion) [Misc-01] Git info commit:b'36a8b525218dc7f13498a707dfbd1ab966f7c8db', author:b'Alexander Avdonkin ', summary:b'Merge ecdbec97c128c695072433de4c5e0466d1879d62 into 507487efab992689e6fbab280d61b84be95c2441', svn_id:b'' 2025-03-19 17:30:02,548 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-buunfpp5gq Host information: Linux ghrun-buunfpp5gq 5.15.0-124-generic #134-Ubuntu SMP Fri Sep 27 20:20:17 UTC 2024 x86_64 2025-03-19 17:30:02,549 DEBUG (devtools.ya.build.graph) [Misc-01] Got version json "{\n \"ARCADIA_PATCH_NUMBER\": 1,\n \"ARCADIA_SOURCE_HG_HASH\": \"36a8b525218dc7f13498a707dfbd1ab966f7c8db\",\n \"ARCADIA_SOURCE_LAST_AUTHOR\": \"Alexander Avdonkin \",\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\": \"2025-03-19T17:30:02.000000Z\",\n \"BUILD_HOST\": \"ghrun-buunfpp5gq\",\n \"BUILD_TIMESTAMP\": 1742405402,\n \"BUILD_USER\": \"runner\",\n \"CUSTOM_VERSION\": \"\",\n \"DIRTY\": \"\",\n \"PROGRAM_VERSION\": \"Git info:\\n Commit: 36a8b525218dc7f13498a707dfbd1ab966f7c8db\\n Branch: \\n Author: Alexander Avdonkin \\n Summary: Merge ecdbec97c128c695072433de4c5e0466d1879d62 into 507487efab992689e6fbab280d61b84be95c2441\\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-buunfpp5gq\\n Host information: \\n Linux ghrun-buunfpp5gq 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: 36a8b525218dc7f13498a707dfbd1ab966f7c8db\\n Branch: \\n Author: Alexander Avdonkin \\n Summary: Merge ecdbec97c128c695072433de4c5e0466d1879d62 into 507487efab992689e6fbab280d61b84be95c2441\\n\",\n \"VCS\": \"git\"\n}" 2025-03-19 17:30:02,549 DEBUG (exts.timer) [Misc-01] Timer get_version_info, stage vcs info: 0.04021620750427246 2025-03-19 17:30:02,577 DEBUG (devtools.ya.build.genconf) [ThreadPoolExecutor-0_0] Generating conf into /home/runner/.ya/build/conf/dist-release-079d6b9c9805f0640f6d7038ac168b2f/ymake.conf with cmd ['/home/runner/.ya/tools/e3e5c44a17_d/ya-bin', '-B', '/home/runner/actions_runner/_work/ydb/ydb/build/ymake_conf.py', '/home/runner/actions_runner/_work/ydb/ydb', 'dist-release', 'no', '--toolchain-params', 'eyJib3R0bGVfbmFtZSI6ImNsYW5nMTgiLCJlbnYiOnsiQ1BBVEgiOlsiIl0sIkxJQlJBUllfUEFUSCI6WyIiXSwiU0RLUk9PVCI6WyIiXX0sImV4ZWN1dGFibGVfcGF0aCI6ImMrKyIsImZsYWdzIjp7IlNBTklUSVpFUl9UWVBFIjoiYWRkcmVzcyJ9LCJmb3JtdWxhIjp7ImJ5X3BsYXRmb3JtIjp7ImRhcndpbi1hcm02NCI6eyJ1cmkiOiJzYnI6NzU5OTQ4NDI2NSJ9LCJkYXJ3aW4teDg2XzY0Ijp7InVyaSI6InNicjo3NTk5NTE3NTA2In0sImxpbnV4LWFhcmNoNjQiOnsidXJpIjoic2JyOjc1OTkyODU1NjYifSwibGludXgteDg2XzY0Ijp7InVyaSI6InNicjo3NTk5NDY5MTU2In0sIndpbjMyLXg4Nl82NCI6eyJ1cmkiOiJzYnI6NzU5OTQyMjE0NCJ9fX0sIm5hbWUiOiJjbGFuZzE4IiwicGFyYW1zIjp7ImNfY29tcGlsZXIiOiIkKENMQU5HLTI1MTgyMzE0MzIpL2Jpbi9jbGFuZyIsImN4eF9jb21waWxlciI6IiQoQ0xBTkctMjUxODIzMTQzMikvYmluL2NsYW5nKysiLCJsbHZtLXN5bWJvbGl6ZXIiOiIkKENMQU5HLTI1MTgyMzE0MzIpL2Jpbi9sbHZtLXN5bWJvbGl6ZXIiLCJtYXRjaF9yb290IjoiQ0xBTkctMjUxODIzMTQzMiIsIm5tIjoiJChDTEFORy0yNTE4MjMxNDMyKS9iaW4vbGx2bS1ubSIsIm9iamNvcHkiOiIkKENMQU5HLTI1MTgyMzE0MzIpL2Jpbi9sbHZtLW9iamNvcHkiLCJwcm9maWxlcyI6IiQoWENPREVfVE9PTFNfUk9PVC1zYnI6Nzk5MDE3NzcxKS9YY29kZS9Db250ZW50cy9EZXZlbG9wZXIvUGxhdGZvcm1zL2lQaG9uZU9TLnBsYXRmb3JtL0RldmVsb3Blci9MaWJyYXJ5L0NvcmVTaW11bGF0b3IvUHJvZmlsZXMiLCJzaW1jdGwiOiIkKFhDT0RFX1RPT0xTX1JPT1Qtc2JyOjc5OTAxNzc3MSkvWGNvZGUvU3lzdGVtUm9vdC9Qcml2YXRlRnJhbWV3b3Jrcy9Db3JlU2ltdWxhdG9yLmZyYW1ld29yay9SZXNvdXJjZXMvYmluL3NpbWN0bCIsInN0cmlwIjoiJChDTEFORy0yNTE4MjMxNDMyKS9iaW4vbGx2bS1zdHJpcCIsInR5cGUiOiJjbGFuZyIsInVzZV9idW5kbGUiOnRydWUsInZlcnNpb24iOiIxOCJ9LCJwbGF0Zm9ybSI6eyJob3N0Ijp7ImFyY2giOiJ4ODZfNjQiLCJvcyI6IkxJTlVYIiwidG9vbGNoYWluIjoiZGVmYXVsdCIsInZpc2libGVfbmFtZSI6ImNsYW5nMTgifSwidGFyZ2V0Ijp7ImFyY2giOiJ4ODZfNjQiLCJvcyI6IkxJTlVYIiwidG9vbGNoYWluIjoiZGVmYXVsdCIsInZpc2libGVfbmFtZSI6ImNsYW5nMTgifX0sInBsYXRmb3JtX25hbWUiOiJERUZBVUxULUxJTlVYLVg4Nl82NCIsInRvb2xfdmFyIjoiQ0xBTkctMjUxODIzMTQzMiJ9', '-l', '-D', 'APPLE_SDK_LOCAL=yes', '-D', 'CFLAGS=-fno-omit-frame-pointer -Wno-unknown-argument', '-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'} 2025-03-19 17:30:02,578 DEBUG (devtools.ya.build.genconf) [ThreadPoolExecutor-0_1] Generating conf into /home/runner/.ya/build/conf/dist-release-65c1fac22866a4d2a9e744d59b683f29/ymake.conf with cmd ['/home/runner/.ya/tools/e3e5c44a17_d/ya-bin', '-B', '/home/runner/actions_runner/_work/ydb/ydb/build/ymake_conf.py', '/home/runner/actions_runner/_work/ydb/ydb', 'dist-release', 'no', '--toolchain-params', 'eyJib3R0bGVfbmFtZSI6ImNsYW5nMTgiLCJlbnYiOnsiQ1BBVEgiOlsiIl0sIkxJQlJBUllfUEFUSCI6WyIiXSwiU0RLUk9PVCI6WyIiXX0sImV4ZWN1dGFibGVfcGF0aCI6ImMrKyIsImZsYWdzIjp7IlNBTklUSVpFUl9UWVBFIjoiYWRkcmVzcyJ9LCJmb3JtdWxhIjp7ImJ5X3BsYXRmb3JtIjp7ImRhcndpbi1hcm02NCI6eyJ1cmkiOiJzYnI6NzU5OTQ4NDI2NSJ9LCJkYXJ3aW4teDg2XzY0Ijp7InVyaSI6InNicjo3NTk5NTE3NTA2In0sImxpbnV4LWFhcmNoNjQiOnsidXJpIjoic2JyOjc1OTkyODU1NjYifSwibGludXgteDg2XzY0Ijp7InVyaSI6InNicjo3NTk5NDY5MTU2In0sIndpbjMyLXg4Nl82NCI6eyJ1cmkiOiJzYnI6NzU5OTQyMjE0NCJ9fX0sIm5hbWUiOiJjbGFuZzE4IiwicGFyYW1zIjp7ImNfY29tcGlsZXIiOiIkKENMQU5HLTI1MTgyMzE0MzIpL2Jpbi9jbGFuZyIsImN4eF9jb21waWxlciI6IiQoQ0xBTkctMjUxODIzMTQzMikvYmluL2NsYW5nKysiLCJsbHZtLXN5bWJvbGl6ZXIiOiIkKENMQU5HLTI1MTgyMzE0MzIpL2Jpbi9sbHZtLXN5bWJvbGl6ZXIiLCJtYXRjaF9yb290IjoiQ0xBTkctMjUxODIzMTQzMiIsIm5tIjoiJChDTEFORy0yNTE4MjMxNDMyKS9iaW4vbGx2bS1ubSIsIm9iamNvcHkiOiIkKENMQU5HLTI1MTgyMzE0MzIpL2Jpbi9sbHZtLW9iamNvcHkiLCJwcm9maWxlcyI6IiQoWENPREVfVE9PTFNfUk9PVC1zYnI6Nzk5MDE3NzcxKS9YY29kZS9Db250ZW50cy9EZXZlbG9wZXIvUGxhdGZvcm1zL2lQaG9uZU9TLnBsYXRmb3JtL0RldmVsb3Blci9MaWJyYXJ5L0NvcmVTaW11bGF0b3IvUHJvZmlsZXMiLCJzaW1jdGwiOiIkKFhDT0RFX1RPT0xTX1JPT1Qtc2JyOjc5OTAxNzc3MSkvWGNvZGUvU3lzdGVtUm9vdC9Qcml2YXRlRnJhbWV3b3Jrcy9Db3JlU2ltdWxhdG9yLmZyYW1ld29yay9SZXNvdXJjZXMvYmluL3NpbWN0bCIsInN0cmlwIjoiJChDTEFORy0yNTE4MjMxNDMyKS9iaW4vbGx2bS1zdHJpcCIsInR5cGUiOiJjbGFuZyIsInVzZV9idW5kbGUiOnRydWUsInZlcnNpb24iOiIxOCJ9LCJwbGF0Zm9ybSI6eyJob3N0Ijp7ImFyY2giOiJ4ODZfNjQiLCJvcyI6IkxJTlVYIiwidG9vbGNoYWluIjoiZGVmYXVsdCIsInZpc2libGVfbmFtZSI6ImNsYW5nMTgifSwidGFyZ2V0Ijp7ImFyY2giOiJ4ODZfNjQiLCJvcyI6IkxJTlVYIiwidG9vbGNoYWluIjoiZGVmYXVsdCIsInZpc2libGVfbmFtZSI6ImNsYW5nMTgifX0sInBsYXRmb3JtX25hbWUiOiJERUZBVUxULUxJTlVYLVg4Nl82NCIsInRvb2xfdmFyIjoiQ0xBTkctMjUxODIzMTQzMiJ9', '-l', '-D', 'APPLE_SDK_LOCAL=yes', '-D', 'CFLAGS=-fno-omit-frame-pointer -Wno-unknown-argument', '-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'} 2025-03-19 17:30:02,715 DEBUG (devtools.ya.build.genconf) [ThreadPoolExecutor-0_0] Copy conf /home/runner/.ya/build/conf/dist-release-079d6b9c9805f0640f6d7038ac168b2f/ymake.conf to /home/runner/.ya/build/conf/dist-release-x-e642421811328d8db8e31ec59182fa2b/ymake.conf 2025-03-19 17:30:02,715 DEBUG (yalibrary.guards) [ThreadPoolExecutor-0_0] Exit guard fetch with value None 2025-03-19 17:30:02,715 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_0] Finish stage tag=gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic, group=graph, time=1742405402.7155578 2025-03-19 17:30:02,715 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_0] Set stage gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic_finished=1742405402.7155578 2025-03-19 17:30:02,715 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_0] Profile step gen-graph-gen-opts-default-linux-x86_64-release-asan-nopic_finished - 1742405402.7155578 2025-03-19 17:30:02,715 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_0] Start stage tag=gen-graph-json-default-linux-x86_64-release-asan-nopic, group=graph, time=1742405402.715766 2025-03-19 17:30:02,715 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_0] Set stage gen-graph-json-default-linux-x86_64-release-asan-nopic_started=1742405402.715766 2025-03-19 17:30:02,715 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_0] Profile step gen-graph-json-default-linux-x86_64-release-asan-nopic_started - 1742405402.715766 2025-03-19 17:30:02,715 DEBUG (devtools.ya.build.ymake2) [ThreadPoolExecutor-0_0] 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-e642421811328d8db8e31ec59182fa2b_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-e642421811328d8db8e31ec59182fa2b/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 0x7fd40506eac0>, 'enabled_events': 'dGT', 'no_caches_on_retry': False, 'no_ymake_retry': False, 'disable_customization': 0, 'dump_tests': '/home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.d04_phnv/test.dart', 'dump_make_files': '/home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.d04_phnv/makefiles.dart'} 2025-03-19 17:30:02,716 DEBUG (devtools.ya.core.yarg.behaviour) [ThreadPoolExecutor-0_0] Found unused args ['grab_stderr'] 2025-03-19 17:30:02,716 DEBUG (devtools.ya.build.prefetch) [ThreadPoolExecutor-0_0] prefetch disabled 2025-03-19 17:30:02,716 DEBUG (devtools.ya.core.event_handling.base_subscriber) [ThreadPoolExecutor-0_0] Subscribing PrintProgressSubscriber to event_queue 2025-03-19 17:30:02,716 DEBUG (yalibrary.tools) [ThreadPoolExecutor-0_0] Using old-style toolchain for: ymake 2025-03-19 17:30:02,716 DEBUG (devtools.ya.build.ymake2.run_ymake) [ThreadPoolExecutor-0_0] run: '/home/runner/.ya/tools/v4/8270822128/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1742405402.33222.inxnaqb6/yatmp6_cibp6_ --config /home/runner/.ya/build/conf/dist-release-x-e642421811328d8db8e31ec59182fa2b/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-e642421811328d8db8e31ec59182fa2b_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.d04_phnv/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.d04_phnv/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' with env: { } 2025-03-19 17:30:02,717 DEBUG (devtools.ya.build.genconf) [ThreadPoolExecutor-0_1] Copy conf /home/runner/.ya/build/conf/dist-release-65c1fac22866a4d2a9e744d59b683f29/ymake.conf to /home/runner/.ya/build/conf/dist-release-x-627a72b3507f51ec375677106bb1f547/ymake.conf 2025-03-19 17:30:02,719 DEBUG (yalibrary.guards) [ThreadPoolExecutor-0_1] Exit guard fetch with value None 2025-03-19 17:30:02,720 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_1] Finish stage tag=gen-graph-gen-opts-default-linux-x86_64-release-asan-pic, group=graph, time=1742405402.7200963 2025-03-19 17:30:02,720 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_1] Set stage gen-graph-gen-opts-default-linux-x86_64-release-asan-pic_finished=1742405402.7200963 2025-03-19 17:30:02,720 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_1] Profile step gen-graph-gen-opts-default-linux-x86_64-release-asan-pic_finished - 1742405402.7200963 2025-03-19 17:30:02,720 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_1] Start stage tag=gen-graph-json-default-linux-x86_64-release-asan-pic, group=graph, time=1742405402.7203913 2025-03-19 17:30:02,720 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_1] Set stage gen-graph-json-default-linux-x86_64-release-asan-pic_started=1742405402.7203913 2025-03-19 17:30:02,720 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_1] Profile step gen-graph-json-default-linux-x86_64-release-asan-pic_started - 1742405402.7203913 2025-03-19 17:30:02,720 DEBUG (devtools.ya.build.ymake2) [ThreadPoolExecutor-0_1] 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-627a72b3507f51ec375677106bb1f547_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-627a72b3507f51ec375677106bb1f547/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 0x7fd40438ed40>, 'enabled_events': 'dGT', 'no_caches_on_retry': False, 'no_ymake_retry': False, 'disable_customization': 0, 'dump_tests': '/home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.onw9kgln/test.dart', 'dump_make_files': '/home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.onw9kgln/makefiles.dart'} 2025-03-19 17:30:02,720 DEBUG (devtools.ya.core.yarg.behaviour) [ThreadPoolExecutor-0_1] Found unused args ['grab_stderr'] 2025-03-19 17:30:02,720 DEBUG (devtools.ya.build.prefetch) [ThreadPoolExecutor-0_1] prefetch disabled 2025-03-19 17:30:02,721 DEBUG (yalibrary.tools) [ThreadPoolExecutor-0_1] Using old-style toolchain for: ymake 2025-03-19 17:30:02,721 DEBUG (devtools.ya.build.ymake2.run_ymake) [ThreadPoolExecutor-0_1] run: '/home/runner/.ya/tools/v4/8270822128/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1742405402.33222.inxnaqb6/yatmp89beu81b --config /home/runner/.ya/build/conf/dist-release-x-627a72b3507f51ec375677106bb1f547/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-627a72b3507f51ec375677106bb1f547_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.onw9kgln/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.onw9kgln/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' with env: { } 2025-03-19 17:30:02,724 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"ymake run","_timestamp":1742405402723865,"_typename":"NEvent.TStageStarted","debug_id":"default-linux-x86_64-release-asan-nopic","ymake_run_uid":0} 2025-03-19 17:30:02,724 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"Target path: /home/runner/actions_runner/_work/ydb/ydb\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405402723980,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:02,724 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Load configuration from cache","_timestamp":1742405402724002,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:02,724 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"Conf cache has not been loaded (reason: File does not exist)...\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405402724011,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:02,724 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Load configuration from cache","_timestamp":1742405402724015,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:02,725 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedConfCache","Type":"bool","_timestamp":1742405402724315,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2025-03-19 17:30:02,725 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1742405402724320,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:02,727 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"ymake run","_timestamp":1742405402727168,"_typename":"NEvent.TStageStarted","debug_id":"default-linux-x86_64-release-asan-pic","ymake_run_uid":1} 2025-03-19 17:30:02,727 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"Target path: /home/runner/actions_runner/_work/ydb/ydb\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405402727279,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:02,727 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Load configuration from cache","_timestamp":1742405402727300,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:02,727 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"Conf cache has not been loaded (reason: File does not exist)...\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405402727309,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:02,727 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Load configuration from cache","_timestamp":1742405402727313,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:02,728 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedConfCache","Type":"bool","_timestamp":1742405402727602,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2025-03-19 17:30:02,728 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1742405402727607,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:02,894 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1742405402894153,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:02,894 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1742405402894178,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:02,895 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1742405402895716,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:02,895 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Fold global commands","_timestamp":1742405402895728,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:02,897 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Fold global commands","_timestamp":1742405402897089,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:02,897 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Fill ModuleScopeOnly flag","_timestamp":1742405402897099,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:02,897 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Load configuration (no cache)","_timestamp":1742405402897155,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:02,897 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Fill ModuleScopeOnly flag","_timestamp":1742405402897102,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:02,897 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1742405402897176,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:02,897 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Load plugins","_timestamp":1742405402897163,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:02,898 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Compile and RecalcAll conditions","_timestamp":1742405402898789,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:02,899 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Fold global commands","_timestamp":1742405402898803,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:02,900 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Fold global commands","_timestamp":1742405402900229,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:02,900 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Fill ModuleScopeOnly flag","_timestamp":1742405402900239,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:02,900 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Fill ModuleScopeOnly flag","_timestamp":1742405402900242,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:02,900 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Load plugins","_timestamp":1742405402900302,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,026 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Load plugins","_timestamp":1742405403026003,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,027 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Load plugins","_timestamp":1742405403027294,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,058 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"MAIN_OUTPUT_AS_EXTRA enabled\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403058530,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,059 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"YMAKE_DEDICATED_MODULE_NODE disabled (by default)\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403058554,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,059 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"YMAKE_CHECK_FOR_INCORRECT_LOOPS disabled (by default)\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403058559,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,059 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"mlockall failed\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403058656,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,059 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"ymake main","_timestamp":1742405403058661,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,059 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"FS cache loading is enabled\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403058743,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,060 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"MAIN_OUTPUT_AS_EXTRA enabled\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403059700,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,060 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"FS cache saving is enabled\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403058748,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,060 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"YMAKE_DEDICATED_MODULE_NODE disabled (by default)\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403059717,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,060 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"Deps cache loading is enabled\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403058752,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,060 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"YMAKE_CHECK_FOR_INCORRECT_LOOPS disabled (by default)\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403059723,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,060 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"Deps cache saving is enabled\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403058756,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,060 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"mlockall failed\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403059804,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,061 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"DepManagement cache loading is enabled\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403058759,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,061 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"ymake main","_timestamp":1742405403059808,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,061 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"DepManagement cache saving is enabled\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403058763,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,061 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"FS cache loading is enabled\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403059853,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,061 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"Uids cache loading is enabled\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403058767,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,061 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"FS cache saving is enabled\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403059858,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,061 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"Uids cache saving is enabled\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403058770,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,061 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"Deps cache loading is enabled\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403059862,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,061 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"HasChangelist":false,"_timestamp":1742405403060969,"_typename":"NEvent.TArcChanges","ymake_run_uid":0} 2025-03-19 17:30:03,061 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"Deps cache saving is enabled\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403059866,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,062 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"Graph has structural changes because of PatchPath\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403060981,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,062 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"DepManagement cache loading is enabled\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403059870,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,062 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedFSCache","Type":"bool","_timestamp":1742405403060989,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2025-03-19 17:30:03,062 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"DepManagement cache saving is enabled\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403059873,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,062 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedDepsCache","Type":"bool","_timestamp":1742405403060993,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2025-03-19 17:30:03,062 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"Uids cache loading is enabled\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403059878,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,062 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Build graph","_timestamp":1742405403060998,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,062 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"Uids cache saving is enabled\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403059881,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,062 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"PredictsStructuralChanges":true,"_timestamp":1742405403061010,"_typename":"NEvent.TGraphChangesPrediction","ymake_run_uid":0} 2025-03-19 17:30:03,063 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"HasChangelist":false,"_timestamp":1742405403062045,"_typename":"NEvent.TArcChanges","ymake_run_uid":1} 2025-03-19 17:30:03,063 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Enabled":false,"MaybeEnabled":false,"_timestamp":1742405403061013,"_typename":"NEvent.TBypassConfigure","ymake_run_uid":0} 2025-03-19 17:30:03,063 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"Graph has structural changes because of PatchPath\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403062054,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,063 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Configure graph","_timestamp":1742405403061017,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,063 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedFSCache","Type":"bool","_timestamp":1742405403062062,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2025-03-19 17:30:03,063 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedDepsCache","Type":"bool","_timestamp":1742405403062066,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2025-03-19 17:30:03,063 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Build graph","_timestamp":1742405403062072,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,063 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"PredictsStructuralChanges":true,"_timestamp":1742405403062081,"_typename":"NEvent.TGraphChangesPrediction","ymake_run_uid":1} 2025-03-19 17:30:03,063 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Enabled":false,"MaybeEnabled":false,"_timestamp":1742405403062085,"_typename":"NEvent.TBypassConfigure","ymake_run_uid":1} 2025-03-19 17:30:03,063 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Configure graph","_timestamp":1742405403062089,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,107 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"DoubleValue":0.04575665722,"Name":"EYmakeStats::ConfigureGraphTime","Type":"double","_timestamp":1742405403106781,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2025-03-19 17:30:03,107 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Configure graph","_timestamp":1742405403106790,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,107 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Find Lost Includes","_timestamp":1742405403106819,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,107 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Find Lost Includes","_timestamp":1742405403106828,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,107 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"loaded size = 66; load time = 52; loaded MD5 time = 0; Max loaded MD5 time = 0; loaded count = 2; max load time = 47; mapped size = 0; mapped MD5 time = 0; Max mapped MD5 time = 0; mapped count = 0; map time = 0; from patch count = 0; from patch size = 0; file stat count = 2; lstat count = 2; lstat sum us = 26; lstat min us = 8; lstat avr us = 13; lstat max us = 18; opendir count = 0; opendir sum us = 0; opendir min us = 0; opendir avr us = 0; opendir max us = 0; readdir count = 0; readdir sum us = 0; readdir min us = 0; readdir avr us = 0; readdir max us = 0; (opendir + readdir) sum us = 0; (lstat + opendir + readdir) sum us = 26;","Mod":"unimp","Sub":"File access stats","Type":"Debug","_timestamp":1742405403106867,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,108 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"FileStatCount":2,"FromPatchCount":0,"FromPatchSize":0,"ListDirSumUs":0,"LoadTime":52,"LoadedCount":2,"LoadedMD5Time":0,"LoadedSize":66,"LstatAvrUs":13,"LstatCount":2,"LstatListDirSumUs":26,"LstatMaxUs":18,"LstatMinUs":8,"LstatSumUs":26,"MapTime":0,"MappedCount":0,"MappedMD5Time":0,"MappedSize":0,"MaxLoadTime":47,"MaxLoadedMD5Time":0,"MaxMappedMD5Time":0,"OpendirAvrUs":0,"OpendirCount":0,"OpendirMaxUs":0,"OpendirMinUs":0,"OpendirSumUs":0,"ReaddirAvrUs":0,"ReaddirCount":0,"ReaddirMaxUs":0,"ReaddirMinUs":0,"ReaddirSumUs":0,"_timestamp":1742405403106880,"_typename":"NEvent.TFileConfStats","ymake_run_uid":0} 2025-03-19 17:30:03,108 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"DoubleValue":0.04563962673,"Name":"EYmakeStats::ConfigureGraphTime","Type":"double","_timestamp":1742405403107734,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2025-03-19 17:30:03,108 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"IntValue":66,"Name":"EFileConfStats::LoadedSize","Type":"int","_timestamp":1742405403106892,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2025-03-19 17:30:03,108 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Configure graph","_timestamp":1742405403107742,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,108 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"IntValue":52,"Name":"EFileConfStats::LoadTime","Type":"int","_timestamp":1742405403106896,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2025-03-19 17:30:03,108 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Find Lost Includes","_timestamp":1742405403107767,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,109 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"IntValue":2,"Name":"EFileConfStats::LoadedCount","Type":"int","_timestamp":1742405403106898,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2025-03-19 17:30:03,109 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Find Lost Includes","_timestamp":1742405403107776,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,109 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"IntValue":0,"Name":"EFileConfStats::MappedSize","Type":"int","_timestamp":1742405403106901,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2025-03-19 17:30:03,110 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"IntValue":0,"Name":"EFileConfStats::MapTime","Type":"int","_timestamp":1742405403106904,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2025-03-19 17:30:03,110 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"loaded size = 66; load time = 23; loaded MD5 time = 0; Max loaded MD5 time = 0; loaded count = 2; max load time = 17; mapped size = 0; mapped MD5 time = 0; Max mapped MD5 time = 0; mapped count = 0; map time = 0; from patch count = 0; from patch size = 0; file stat count = 2; lstat count = 2; lstat sum us = 14; lstat min us = 5; lstat avr us = 7; lstat max us = 9; opendir count = 0; opendir sum us = 0; opendir min us = 0; opendir avr us = 0; opendir max us = 0; readdir count = 0; readdir sum us = 0; readdir min us = 0; readdir avr us = 0; readdir max us = 0; (opendir + readdir) sum us = 0; (lstat + opendir + readdir) sum us = 14;","Mod":"unimp","Sub":"File access stats","Type":"Debug","_timestamp":1742405403107811,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,110 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"IntValue":0,"Name":"EFileConfStats::MappedCount","Type":"int","_timestamp":1742405403106907,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2025-03-19 17:30:03,110 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"IntValue":2,"Name":"EFileConfStats::Count","Type":"int","_timestamp":1742405403106909,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2025-03-19 17:30:03,111 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"FileStatCount":2,"FromPatchCount":0,"FromPatchSize":0,"ListDirSumUs":0,"LoadTime":23,"LoadedCount":2,"LoadedMD5Time":0,"LoadedSize":66,"LstatAvrUs":7,"LstatCount":2,"LstatListDirSumUs":14,"LstatMaxUs":9,"LstatMinUs":5,"LstatSumUs":14,"MapTime":0,"MappedCount":0,"MappedMD5Time":0,"MappedSize":0,"MaxLoadTime":17,"MaxLoadedMD5Time":0,"MaxMappedMD5Time":0,"OpendirAvrUs":0,"OpendirCount":0,"OpendirMaxUs":0,"OpendirMinUs":0,"OpendirSumUs":0,"ReaddirAvrUs":0,"ReaddirCount":0,"ReaddirMaxUs":0,"ReaddirMinUs":0,"ReaddirSumUs":0,"_timestamp":1742405403107823,"_typename":"NEvent.TFileConfStats","ymake_run_uid":1} 2025-03-19 17:30:03,111 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"bucket id = 0; loaded size = 66; load time = 52; loaded count = 2; max load time = 47;","Mod":"unimp","Sub":"Bucket #0","Type":"Debug","_timestamp":1742405403106917,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,111 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"IntValue":66,"Name":"EFileConfStats::LoadedSize","Type":"int","_timestamp":1742405403107835,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2025-03-19 17:30:03,111 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"BucketId":0,"LoadTime":52,"LoadedCount":2,"LoadedSize":66,"MaxLoadTime":47,"_timestamp":1742405403106922,"_typename":"NEvent.TFileConfSubStats","ymake_run_uid":0} 2025-03-19 17:30:03,111 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"IntValue":23,"Name":"EFileConfStats::LoadTime","Type":"int","_timestamp":1742405403107839,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2025-03-19 17:30:03,111 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"parse time = 0; parsed files count = 0; parsed files size = 0; parsed files recovered = 0; .in files count = 0; .in files size = 0;","Mod":"unimp","Sub":"Parsing stats","Type":"Debug","_timestamp":1742405403106935,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,112 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"IntValue":2,"Name":"EFileConfStats::LoadedCount","Type":"int","_timestamp":1742405403107842,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2025-03-19 17:30:03,112 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"InFilesCount":0,"InFilesSize":0,"ParseTime":0,"ParsedFilesCount":0,"ParsedFilesRecovered":0,"ParsedFilesSize":0,"_timestamp":1742405403106939,"_typename":"NEvent.TIncParserManagerStats","ymake_run_uid":0} 2025-03-19 17:30:03,112 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"IntValue":0,"Name":"EFileConfStats::MappedSize","Type":"int","_timestamp":1742405403107845,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2025-03-19 17:30:03,112 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"count = 1; includes count = 0; unique count = 1; size = 33; unique size = 33;","Mod":"unimp","Sub":"ya.make parsing stats","Type":"Debug","_timestamp":1742405403106950,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,112 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"IntValue":0,"Name":"EFileConfStats::MapTime","Type":"int","_timestamp":1742405403107848,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2025-03-19 17:30:03,112 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Count":1,"Includes":0,"Size":33,"UniqueCount":1,"UniqueSize":33,"_timestamp":1742405403106954,"_typename":"NEvent.TGeneralParserStats","ymake_run_uid":0} 2025-03-19 17:30:03,112 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"IntValue":0,"Name":"EFileConfStats::MappedCount","Type":"int","_timestamp":1742405403107851,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2025-03-19 17:30:03,112 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"nodes count = 2; edges count = 1; files count = 6; commands count = 16;","Mod":"unimp","Sub":"DepGraph stats","Type":"Debug","_timestamp":1742405403106962,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,112 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"IntValue":2,"Name":"EFileConfStats::Count","Type":"int","_timestamp":1742405403107854,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2025-03-19 17:30:03,113 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"CommandsCount":16,"EdgesCount":1,"FilesCount":6,"NodesCount":2,"_timestamp":1742405403106970,"_typename":"NEvent.TDepGraphStats","ymake_run_uid":0} 2025-03-19 17:30:03,113 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"bucket id = 0; loaded size = 66; load time = 23; loaded count = 2; max load time = 17;","Mod":"unimp","Sub":"Bucket #0","Type":"Debug","_timestamp":1742405403107862,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,113 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"nuke mod dir = 0;","Mod":"unimp","Sub":"UpdIter stats","Type":"Debug","_timestamp":1742405403106975,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,113 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"BucketId":0,"LoadTime":23,"LoadedCount":2,"LoadedSize":66,"MaxLoadTime":17,"_timestamp":1742405403107866,"_typename":"NEvent.TFileConfSubStats","ymake_run_uid":1} 2025-03-19 17:30:03,113 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"NukedDir":0,"_timestamp":1742405403106978,"_typename":"NEvent.TUpdIterStats","ymake_run_uid":0} 2025-03-19 17:30:03,113 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"parse time = 0; parsed files count = 0; parsed files size = 0; parsed files recovered = 0; .in files count = 0; .in files size = 0;","Mod":"unimp","Sub":"Parsing stats","Type":"Debug","_timestamp":1742405403107880,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,113 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] 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":1742405403106988,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,113 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"InFilesCount":0,"InFilesSize":0,"ParseTime":0,"ParsedFilesCount":0,"ParsedFilesRecovered":0,"ParsedFilesSize":0,"_timestamp":1742405403107885,"_typename":"NEvent.TIncParserManagerStats","ymake_run_uid":1} 2025-03-19 17:30:03,114 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"IncludesAttempted":0,"IncludesFromCache":0,"ResolveAsKnownFromCache":0,"ResolveAsKnownTotal":0,"_timestamp":1742405403106993,"_typename":"NEvent.TResolveStats","ymake_run_uid":0} 2025-03-19 17:30:03,114 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"count = 1; includes count = 0; unique count = 1; size = 33; unique size = 33;","Mod":"unimp","Sub":"ya.make parsing stats","Type":"Debug","_timestamp":1742405403107895,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,114 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Build graph","_timestamp":1742405403106997,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,114 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Count":1,"Includes":0,"Size":33,"UniqueCount":1,"UniqueSize":33,"_timestamp":1742405403107899,"_typename":"NEvent.TGeneralParserStats","ymake_run_uid":1} 2025-03-19 17:30:03,114 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"accessed = 0; loaded = 0; outdated = 0; parsed = 0; total = 0;","Mod":"unimp","Sub":"TModules stats","Type":"Debug","_timestamp":1742405403107017,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,114 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"nodes count = 2; edges count = 1; files count = 6; commands count = 16;","Mod":"unimp","Sub":"DepGraph stats","Type":"Debug","_timestamp":1742405403107908,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,114 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Accessed":0,"Loaded":0,"Outdated":0,"Parsed":0,"Total":0,"_timestamp":1742405403107021,"_typename":"NEvent.TModulesStats","ymake_run_uid":0} 2025-03-19 17:30:03,114 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"CommandsCount":16,"EdgesCount":1,"FilesCount":6,"NodesCount":2,"_timestamp":1742405403107913,"_typename":"NEvent.TDepGraphStats","ymake_run_uid":1} 2025-03-19 17:30:03,114 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"IntValue":0,"Name":"EModulesStats::Accessed","Type":"int","_timestamp":1742405403107025,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2025-03-19 17:30:03,115 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"nuke mod dir = 0;","Mod":"unimp","Sub":"UpdIter stats","Type":"Debug","_timestamp":1742405403107919,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,115 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"IntValue":0,"Name":"EModulesStats::Loaded","Type":"int","_timestamp":1742405403107028,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2025-03-19 17:30:03,115 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"NukedDir":0,"_timestamp":1742405403107922,"_typename":"NEvent.TUpdIterStats","ymake_run_uid":1} 2025-03-19 17:30:03,115 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"IntValue":0,"Name":"EModulesStats::Outdated","Type":"int","_timestamp":1742405403107031,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2025-03-19 17:30:03,115 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] 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":1742405403107931,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,115 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"IntValue":0,"Name":"EModulesStats::Parsed","Type":"int","_timestamp":1742405403107033,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2025-03-19 17:30:03,115 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"IncludesAttempted":0,"IncludesFromCache":0,"ResolveAsKnownFromCache":0,"ResolveAsKnownTotal":0,"_timestamp":1742405403107937,"_typename":"NEvent.TResolveStats","ymake_run_uid":1} 2025-03-19 17:30:03,115 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Build graph","_timestamp":1742405403107940,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,115 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Set reachable nodes","_timestamp":1742405403107041,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,116 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"accessed = 0; loaded = 0; outdated = 0; parsed = 0; total = 0;","Mod":"unimp","Sub":"TModules stats","Type":"Debug","_timestamp":1742405403107958,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,116 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Set reachable nodes","_timestamp":1742405403107045,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,116 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Accessed":0,"Loaded":0,"Outdated":0,"Parsed":0,"Total":0,"_timestamp":1742405403107962,"_typename":"NEvent.TModulesStats","ymake_run_uid":1} 2025-03-19 17:30:03,116 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Sort edges","_timestamp":1742405403107047,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,116 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"IntValue":0,"Name":"EModulesStats::Accessed","Type":"int","_timestamp":1742405403107966,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2025-03-19 17:30:03,116 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Sort edges","_timestamp":1742405403107049,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,116 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"IntValue":0,"Name":"EModulesStats::Loaded","Type":"int","_timestamp":1742405403107969,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2025-03-19 17:30:03,116 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1742405403107051,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,116 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"IntValue":0,"Name":"EModulesStats::Outdated","Type":"int","_timestamp":1742405403107972,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2025-03-19 17:30:03,117 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"_timestamp":1742405403107054,"_typename":"NEvent.TAllForeignPlatformsReported","ymake_run_uid":0} 2025-03-19 17:30:03,117 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"IntValue":0,"Name":"EModulesStats::Parsed","Type":"int","_timestamp":1742405403107975,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2025-03-19 17:30:03,117 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1742405403107056,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,117 DEBUG (_ToolTargetsQueue) [MainThread] Source_id=0 (default-linux-x86_64-release-asan-nopic). Tool targets: set() 2025-03-19 17:30:03,117 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Check blacklist","_timestamp":1742405403107059,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,117 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Check blacklist","_timestamp":1742405403107061,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,117 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Set reachable nodes","_timestamp":1742405403107983,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,117 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Check isolated projects","_timestamp":1742405403107063,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,118 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Set reachable nodes","_timestamp":1742405403107987,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,118 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Check isolated projects","_timestamp":1742405403107066,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,118 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Sort edges","_timestamp":1742405403107989,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,118 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Compact internal graph and modules table","_timestamp":1742405403107069,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,118 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Sort edges","_timestamp":1742405403107991,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,118 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Compact internal graph and modules table","_timestamp":1742405403107071,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,118 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1742405403107993,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,118 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Detect loops","_timestamp":1742405403107073,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,118 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"_timestamp":1742405403107996,"_typename":"NEvent.TAllForeignPlatformsReported","ymake_run_uid":1} 2025-03-19 17:30:03,118 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"HasContentChanges":true,"HasStructuralChanges":true,"_timestamp":1742405403107080,"_typename":"NEvent.TGraphChanges","ymake_run_uid":0} 2025-03-19 17:30:03,119 DEBUG (_ToolTargetsQueue) [MainThread] Source_id=1 (default-linux-x86_64-release-asan-pic). Tool targets: set() 2025-03-19 17:30:03,119 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=waiting-tool-targets, group=graph, time=1742405403.1190972 2025-03-19 17:30:03,119 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage waiting-tool-targets_finished=1742405403.1190972 2025-03-19 17:30:03,119 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step waiting-tool-targets_finished - 1742405403.1190972 2025-03-19 17:30:03,119 DEBUG (devtools.ya.build.graph) [MainThread] Empty tool targets list 2025-03-19 17:30:03,119 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=get-tools, group=graph, time=1742405403.1194642 2025-03-19 17:30:03,119 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage get-tools_finished=1742405403.1194642 2025-03-19 17:30:03,119 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step get-tools_finished - 1742405403.1194642 2025-03-19 17:30:03,119 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=merge-target-graphs-1, group=graph, time=1742405403.119683 2025-03-19 17:30:03,119 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_started=1742405403.119683 2025-03-19 17:30:03,119 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step merge-target-graphs-1_started - 1742405403.119683 2025-03-19 17:30:03,119 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Report Foreign Platform Events","_timestamp":1742405403107998,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,120 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=wait-target-graphs-1, group=graph, time=1742405403.1200268 2025-03-19 17:30:03,120 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Detect loops","_timestamp":1742405403107083,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,120 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage wait-target-graphs-1_started=1742405403.1200268 2025-03-19 17:30:03,120 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step wait-target-graphs-1_started - 1742405403.1200268 2025-03-19 17:30:03,120 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Check blacklist","_timestamp":1742405403108000,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,120 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Apply Dependency Management","_timestamp":1742405403107086,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,120 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Check blacklist","_timestamp":1742405403108003,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,120 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Apply Dependency Management","_timestamp":1742405403107091,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,120 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Check isolated projects","_timestamp":1742405403108005,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,120 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Compute DEPENDS to modules closure","_timestamp":1742405403107093,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,121 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Check isolated projects","_timestamp":1742405403108008,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,121 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Compute DEPENDS to modules closure","_timestamp":1742405403107095,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,121 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Compact internal graph and modules table","_timestamp":1742405403108010,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,121 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Save Dependency management cache","_timestamp":1742405403107099,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,121 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Compact internal graph and modules table","_timestamp":1742405403108013,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,121 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Save Dependency management cache","_timestamp":1742405403107566,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,121 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Detect loops","_timestamp":1742405403108015,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,121 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1742405403107575,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,121 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"HasContentChanges":true,"HasStructuralChanges":true,"_timestamp":1742405403108021,"_typename":"NEvent.TGraphChanges","ymake_run_uid":1} 2025-03-19 17:30:03,121 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1742405403107579,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,121 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Detect loops","_timestamp":1742405403108024,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,122 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Find missing peerdirs","_timestamp":1742405403107583,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,122 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Apply Dependency Management","_timestamp":1742405403108026,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,122 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Find missing peerdirs","_timestamp":1742405403107585,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,122 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Apply Dependency Management","_timestamp":1742405403108031,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,122 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Report Configure Events","_timestamp":1742405403107588,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,122 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Compute DEPENDS to modules closure","_timestamp":1742405403108033,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,122 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"Searching target '.'\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403106798,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,122 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Compute DEPENDS to modules closure","_timestamp":1742405403108036,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,122 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"Selected target '$S' with id 2\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403106803,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,122 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Save Dependency management cache","_timestamp":1742405403108039,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,123 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"TIncFixer stats: 0 resolved to nothing, 0 resolved to existing, 0 resolved to new.\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403106826,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,123 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Save Dependency management cache","_timestamp":1742405403108371,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,123 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"DM cache has been saved...\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403107559,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,123 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1742405403108380,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,123 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"Modules requiring dependency management: 0; BFS traversals performed: 0\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403107570,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,123 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Check Transitive Requirements","_timestamp":1742405403108384,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,123 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Report Configure Events","_timestamp":1742405403107596,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,123 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Find missing peerdirs","_timestamp":1742405403108388,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,123 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Update Unreachable file from External changes","_timestamp":1742405403107598,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,123 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Find missing peerdirs","_timestamp":1742405403108390,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,124 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Update Unreachable file from External changes","_timestamp":1742405403107600,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,124 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Report Configure Events","_timestamp":1742405403108393,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,124 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Save Deps cache","_timestamp":1742405403107606,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,124 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"Searching target '.'\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403107749,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,124 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"Total cache size on save = 2912; Diagnostics cache size on save = 1104; Graph cache size on save = 112; Parsers cache size on save = 144; Modules table size on save = 4; Times table size on save = 16; Names table size on save = 816; Commands cache size on save = 272;","Mod":"unimp","Sub":"Internal cache stats","Type":"Debug","_timestamp":1742405403107644,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,124 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"Selected target '$S' with id 2\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403107755,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,124 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"CommandsSize":272,"DiagnosticsCacheSize":1104,"GraphCacheSize":112,"ModulesTableSize":4,"NamesTableSize":816,"ParsersCacheSize":144,"TimesTableSize":16,"TotalCacheSize":2912,"_timestamp":1742405403107651,"_typename":"NEvent.TInternalCacheSaverStats","ymake_run_uid":0} 2025-03-19 17:30:03,124 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"TIncFixer stats: 0 resolved to nothing, 0 resolved to existing, 0 resolved to new.\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403107773,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,124 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"FS cache has been saved...\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403107656,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,124 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"DM cache has been saved...\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403108367,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,125 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"Deps cache has been saved...\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403107660,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,125 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"Modules requiring dependency management: 0; BFS traversals performed: 0\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403108376,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,125 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Save Deps cache","_timestamp":1742405403108294,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,125 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Report Configure Events","_timestamp":1742405403108400,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,125 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Export JSON","_timestamp":1742405403108301,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,125 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Update Unreachable file from External changes","_timestamp":1742405403108402,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,125 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Write JSON","_timestamp":1742405403108305,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,125 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Update Unreachable file from External changes","_timestamp":1742405403108404,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,125 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"Exporting JSON\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403108309,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,125 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Save Deps cache","_timestamp":1742405403108410,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,126 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Visit JSON","_timestamp":1742405403108312,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,126 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"Total cache size on save = 2912; Diagnostics cache size on save = 1104; Graph cache size on save = 112; Parsers cache size on save = 144; Modules table size on save = 4; Times table size on save = 16; Names table size on save = 816; Commands cache size on save = 272;","Mod":"unimp","Sub":"Internal cache stats","Type":"Debug","_timestamp":1742405403108443,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,126 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Visit JSON","_timestamp":1742405403108324,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,126 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"CommandsSize":272,"DiagnosticsCacheSize":1104,"GraphCacheSize":112,"ModulesTableSize":4,"NamesTableSize":816,"ParsersCacheSize":144,"TimesTableSize":16,"TotalCacheSize":2912,"_timestamp":1742405403108449,"_typename":"NEvent.TInternalCacheSaverStats","ymake_run_uid":1} 2025-03-19 17:30:03,126 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Render JSON","_timestamp":1742405403108326,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,126 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"FS cache has been saved...\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403108456,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,126 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"Deps cache has been saved...\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403108460,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,126 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"Store inputs in JSON cache: enabled\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403108335,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,127 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Save Deps cache","_timestamp":1742405403109086,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,127 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Export JSON","_timestamp":1742405403109095,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,127 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Write JSON","_timestamp":1742405403109101,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,127 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] 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":1742405403108367,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,127 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"Exporting JSON\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403109107,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,127 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] 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":1742405403108374,"_typename":"NEvent.TJsonCacheStats","ymake_run_uid":0} 2025-03-19 17:30:03,127 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Visit JSON","_timestamp":1742405403109112,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,127 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"JSON cache report: disabled\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403108381,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,127 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Visit JSON","_timestamp":1742405403109124,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,128 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"DoubleValue":0.00005770383616,"Name":"EYmakeStats::RenderJSONTime","Type":"double","_timestamp":1742405403108387,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2025-03-19 17:30:03,128 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Render JSON","_timestamp":1742405403109127,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,128 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Render JSON","_timestamp":1742405403108390,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,128 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Save Uids cache","_timestamp":1742405403108393,"_typename":"NEvent.TStageStarted","ymake_run_uid":0} 2025-03-19 17:30:03,128 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"Store inputs in JSON cache: enabled\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403109138,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,128 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"Uids cache has been saved...\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403108411,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,128 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Save Uids cache","_timestamp":1742405403108414,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,128 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"HasRenderedNodeChanges":true,"_timestamp":1742405403108424,"_typename":"NEvent.TNodeChanges","ymake_run_uid":0} 2025-03-19 17:30:03,128 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] 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":1742405403109173,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,129 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"Loaded nodes = 0; Skipped nodes = 0; Discarded nodes = 0; Loaded loops = 0; Skipped loops = 0; Discarded loops = 0; Saved nodes = 2; Saved loops = 0; Really all nodes no rendered = 0;","Mod":"unimp","Sub":"Uids cache stats","Type":"Debug","_timestamp":1742405403108436,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,129 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] 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":1742405403109181,"_typename":"NEvent.TJsonCacheStats","ymake_run_uid":1} 2025-03-19 17:30:03,129 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"DiscardedLoops":0,"DiscardedNodes":0,"LoadedLoops":0,"LoadedNodes":0,"SavedLoops":0,"SavedNodes":2,"SkippedLoops":0,"SkippedNodes":0,"_timestamp":1742405403108441,"_typename":"NEvent.TUidsCacheStats","ymake_run_uid":0} 2025-03-19 17:30:03,129 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"JSON cache report: disabled\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403109189,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,129 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"DoubleValue":0.0001499399621,"Name":"EYmakeStats::WriteJSONTime","Type":"double","_timestamp":1742405403108457,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2025-03-19 17:30:03,129 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"DoubleValue":0.00006335944901,"Name":"EYmakeStats::RenderJSONTime","Type":"double","_timestamp":1742405403109194,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2025-03-19 17:30:03,129 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Write JSON","_timestamp":1742405403108460,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,129 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Render JSON","_timestamp":1742405403109198,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,129 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"Export JSON","_timestamp":1742405403108463,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,130 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Save Uids cache","_timestamp":1742405403109200,"_typename":"NEvent.TStageStarted","ymake_run_uid":1} 2025-03-19 17:30:03,130 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedUidsCache","Type":"bool","_timestamp":1742405403108465,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2025-03-19 17:30:03,130 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"Uids cache has been saved...\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403109236,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,130 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"module environment initialization calls = 0; actual module environment initializations = 0;","Mod":"unimp","Sub":"TMakeCommand stats","Type":"Debug","_timestamp":1742405403108473,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,130 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Save Uids cache","_timestamp":1742405403109240,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,130 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"InitModuleEnv":0,"InitModuleEnvCalls":0,"_timestamp":1742405403108477,"_typename":"NEvent.TMakeCommandStats","ymake_run_uid":0} 2025-03-19 17:30:03,130 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"HasRenderedNodeChanges":true,"_timestamp":1742405403109256,"_typename":"NEvent.TNodeChanges","ymake_run_uid":1} 2025-03-19 17:30:03,130 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"FS cache has been committed...\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403111321,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,130 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"Loaded nodes = 0; Skipped nodes = 0; Discarded nodes = 0; Loaded loops = 0; Skipped loops = 0; Discarded loops = 0; Saved nodes = 2; Saved loops = 0; Really all nodes no rendered = 0;","Mod":"unimp","Sub":"Uids cache stats","Type":"Debug","_timestamp":1742405403109270,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,130 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"Deps cache has been committed...\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403111330,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,131 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"DiscardedLoops":0,"DiscardedNodes":0,"LoadedLoops":0,"LoadedNodes":0,"SavedLoops":0,"SavedNodes":2,"SkippedLoops":0,"SkippedNodes":0,"_timestamp":1742405403109276,"_typename":"NEvent.TUidsCacheStats","ymake_run_uid":1} 2025-03-19 17:30:03,131 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"_timestamp":1742405403111333,"_typename":"NEvent.TReadyForUpdateCacheInfo","ymake_run_uid":0} 2025-03-19 17:30:03,131 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"DoubleValue":0.0001886188815,"Name":"EYmakeStats::WriteJSONTime","Type":"double","_timestamp":1742405403109293,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2025-03-19 17:30:03,131 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"DM cache has been committed...\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403111346,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,131 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Write JSON","_timestamp":1742405403109298,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,131 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"Uids cache has been committed...\n","Mod":"unimp","PID":33325,"Sub":"","Type":"Debug","_timestamp":1742405403111357,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,131 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"Export JSON","_timestamp":1742405403109301,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,131 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"Message":"Maximum stack size in TUpdIter = 2; Maximum stack size in TUpdReiter = 0; Maximum stack size in TJSONVisitor = 2;","Mod":"unimp","Sub":"StackDepthStats","Type":"Debug","_timestamp":1742405403111366,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":0} 2025-03-19 17:30:03,131 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"BoolValue":false,"Name":"EYmakeStats::UsedUidsCache","Type":"bool","_timestamp":1742405403109304,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2025-03-19 17:30:03,131 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"ymake main","_timestamp":1742405403112775,"_typename":"NEvent.TStageFinished","ymake_run_uid":0} 2025-03-19 17:30:03,132 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"module environment initialization calls = 0; actual module environment initializations = 0;","Mod":"unimp","Sub":"TMakeCommand stats","Type":"Debug","_timestamp":1742405403109314,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,132 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"DoubleValue":0.3889104792,"Name":"EYmakeStats::RunTime","Type":"double","_timestamp":1742405403112806,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":0} 2025-03-19 17:30:03,132 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"InitModuleEnv":0,"InitModuleEnvCalls":0,"_timestamp":1742405403109319,"_typename":"NEvent.TMakeCommandStats","ymake_run_uid":1} 2025-03-19 17:30:03,132 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_0] Configure message {"StageName":"ymake run","_timestamp":1742405403112810,"_typename":"NEvent.TStageFinished","debug_id":"default-linux-x86_64-release-asan-nopic","ymake_run_uid":0} 2025-03-19 17:30:03,132 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"FS cache has been committed...\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403111616,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,132 DEBUG (devtools.ya.build.ymake2.run_ymake) [ThreadPoolExecutor-0_0] run '/home/runner/.ya/tools/v4/8270822128/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1742405402.33222.inxnaqb6/yatmp6_cibp6_ --config /home/runner/.ya/build/conf/dist-release-x-e642421811328d8db8e31ec59182fa2b/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-e642421811328d8db8e31ec59182fa2b_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.d04_phnv/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.d04_phnv/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' finished 2025-03-19 17:30:03,132 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"Deps cache has been committed...\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403111625,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,133 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"_timestamp":1742405403111629,"_typename":"NEvent.TReadyForUpdateCacheInfo","ymake_run_uid":1} 2025-03-19 17:30:03,133 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"DM cache has been committed...\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403111641,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,133 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"Uids cache has been committed...\n","Mod":"unimp","PID":33327,"Sub":"","Type":"Debug","_timestamp":1742405403111653,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,133 DEBUG (devtools.ya.build.ymake2) [ThreadPoolExecutor-0_0] ymake_run_info: {"ymake_run_uid":0,"stats":{"preparing":{"start":1742405402.716283321380615,"finish":1742405402.716842651367188,"duration":0.000559329986572},"execution":{"start":1742405402.716843605041504,"finish":1742405403.132843971252441,"duration":0.416000366210938},"postprocessing":{"start":1742405403.132847309112549,"finish":1742405403.133309364318848,"duration":0.000462055206299}},"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":1742405402.723865032196045,"finish":1742405403.112809896469116,"duration":0.388944864273071},"Load configuration from cache":{"start":1742405402.724001884460449,"finish":1742405402.7240149974823,"duration":0.000013113021851},"Load configuration (no cache)":{"start":1742405402.724319934844971,"finish":1742405402.894153118133545,"duration":0.169833183288574},"Compile and RecalcAll conditions":{"start":1742405402.894177913665772,"finish":1742405402.895715951919556,"duration":0.001538038253784},"Fold global commands":{"start":1742405402.89572811126709,"finish":1742405402.897089004516602,"duration":0.001360893249512},"Fill ModuleScopeOnly flag":{"start":1742405402.897099018096924,"finish":1742405402.897102117538452,"duration":0.000003099441528},"Load plugins":{"start":1742405402.897162914276123,"finish":1742405403.026002883911133,"duration":0.12883996963501},"ymake main":{"start":1742405403.058660984039307,"finish":1742405403.112775087356567,"duration":0.054114103317261},"Build graph":{"start":1742405403.06099796295166,"finish":1742405403.106997013092041,"duration":0.045999050140381},"Configure graph":{"start":1742405403.061017036437988,"finish":1742405403.106790065765381,"duration":0.045773029327393},"Find Lost Includes":{"start":1742405403.106818914413452,"finish":1742405403.106827974319458,"duration":0.000009059906006},"Set reachable nodes":{"start":1742405403.107040882110596,"finish":1742405403.10704493522644,"duration":0.000004053115845},"Sort edges":{"start":1742405403.107047080993652,"finish":1742405403.107048988342285,"duration":0.000001907348633},"Report Foreign Platform Events":{"start":1742405403.107050895690918,"finish":1742405403.107055902481079,"duration":0.000005006790161},"Check blacklist":{"start":1742405403.107059001922607,"finish":1742405403.10706090927124,"duration":0.000001907348633},"Check isolated projects":{"start":1742405403.107063055038452,"finish":1742405403.107065916061401,"duration":0.000002861022949},"Compact internal graph and modules table":{"start":1742405403.10706901550293,"finish":1742405403.107070922851562,"duration":0.000001907348633},"Detect loops":{"start":1742405403.107073068618774,"finish":1742405403.107083082199097,"duration":0.000010013580322},"Apply Dependency Management":{"start":1742405403.107085943222046,"finish":1742405403.107090950012207,"duration":0.000005006790161},"Compute DEPENDS to modules closure":{"start":1742405403.107093095779419,"finish":1742405403.107095003128052,"duration":0.000001907348633},"Save Dependency management cache":{"start":1742405403.107099056243896,"finish":1742405403.107566118240356,"duration":0.00046706199646},"Check Transitive Requirements":{"start":1742405403.107574939727783,"finish":1742405403.107578992843628,"duration":0.000004053115845},"Find missing peerdirs":{"start":1742405403.107583045959473,"finish":1742405403.107584953308105,"duration":0.000001907348633},"Report Configure Events":{"start":1742405403.107588052749634,"finish":1742405403.107595920562744,"duration":0.00000786781311},"Update Unreachable file from External changes":{"start":1742405403.107598066329956,"finish":1742405403.107599973678589,"duration":0.000001907348633},"Save Deps cache":{"start":1742405403.107605934143066,"finish":1742405403.108294010162354,"duration":0.000688076019287},"Export JSON":{"start":1742405403.108300924301147,"finish":1742405403.108463048934937,"duration":0.000162124633789},"Write JSON":{"start":1742405403.108304977416992,"finish":1742405403.108459949493408,"duration":0.000154972076416},"Visit JSON":{"start":1742405403.108311891555786,"finish":1742405403.10832405090332,"duration":0.000012159347534},"Render JSON":{"start":1742405403.108325958251953,"finish":1742405403.108390092849731,"duration":0.000064134597778},"Save Uids cache":{"start":1742405403.108392953872681,"finish":1742405403.108413934707642,"duration":0.000020980834961}},"metrics":{"File access":{"loaded size":66,"load time":52,"loaded MD5 time":0,"Max loaded MD5 time":0,"loaded count":2,"max load time":47,"mapped size":0,"mapped MD5 time":0,"Max mapped MD5 time":0,"mapped count":0,"map time":0,"from patch count":0,"from patch size":0,"file stat count":2,"lstat count":2,"lstat sum us":26,"lstat min us":8,"lstat avr us":13,"lstat max us":18,"opendir count":0,"opendir sum us":0,"opendir min us":0,"opendir avr us":0,"opendir max us":0,"readdir count":0,"readdir sum us":0,"readdir min us":0,"readdir avr us":0,"readdir max us":0,"(opendir + readdir) sum us":0,"(lstat + opendir + readdir) sum us":26},"Parsing":{"parse time":0,"parsed files count":0,"parsed files size":0,"parsed files recovered":0,".in files count":0,".in files size":0},"ya.make parsing":{"count":1,"includes count":0,"unique count":1,"size":33,"unique size":33},"DepGraph":{"nodes count":2,"edges count":1,"files count":6,"commands count":16},"UpdIter":{"nuke mod dir":0},"Resolving":{"Includes attempts":0,"From cache":0,"Resolve AsKnown total":0,"Resolve AsKnown from cache":0},"TModules":{"accessed":0,"loaded":0,"outdated":0,"parsed":0,"total":0},"Internal cache":{"Total cache size on save":2912,"Diagnostics cache size on save":1104,"Graph cache size on save":112,"Parsers cache size on save":144,"Modules table size on save":4,"Times table size on save":16,"Names table size on save":816,"Commands cache size on save":272},"JSON cache":{"Loaded cache items":0,"Added cache items":0,"Saved old cache items":0,"Saved new cache items":0,"Saved total cache items":0,"Loaded full match items":0,"Full match requests":0,"Successful full matches":0,"Loaded partial match items":0,"Partial match requests":0,"Successful partial matches":0,"Fully rendered nodes":0,"Partially rendered nodes":0,"Nodes restored without rendering":0},"Uids cache":{"Loaded nodes":0,"Skipped nodes":0,"Discarded nodes":0,"Loaded loops":0,"Skipped loops":0,"Discarded loops":0,"Saved nodes":2,"Saved loops":0,"Really all nodes no rendered":0},"TMakeCommand":{"module environment initialization calls":0,"actual module environment initializations":0}},"binary":"/home/runner/.ya/tools/v4/8270822128/ymake","args":["/home/runner/.ya/tools/v4/8270822128/ymake","--depends-like-recurse","--warn","dirloops,ChkPeers","--write-meta-data","/home/runner/.ya/tmp/1742405402.33222.inxnaqb6/yatmp6_cibp6_","--config","/home/runner/.ya/build/conf/dist-release-x-e642421811328d8db8e31ec59182fa2b/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-e642421811328d8db8e31ec59182fa2b_d357a1f7839b099012272bcb9853ec19","--test-dart","/home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.d04_phnv/test.dart","--tests-data-root","/home/runner/actions_runner/_work/ydb/arcadia_tests_data","--makefiles-dart","/home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.d04_phnv/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.416000366210938} 2025-03-19 17:30:03,134 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_0] Start stage tag=load-graph-from-json, group=graph, time=1742405403.1342075 2025-03-19 17:30:03,134 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_0] Set stage load-graph-from-json_started=1742405403.1342075 2025-03-19 17:30:03,134 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_0] Profile step load-graph-from-json_started - 1742405403.1342075 2025-03-19 17:30:03,134 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"Message":"Maximum stack size in TUpdIter = 2; Maximum stack size in TUpdReiter = 0; Maximum stack size in TJSONVisitor = 2;","Mod":"unimp","Sub":"StackDepthStats","Type":"Debug","_timestamp":1742405403111662,"_typename":"NEvent.TDisplayMessage","ymake_run_uid":1} 2025-03-19 17:30:03,134 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_0] Finish stage tag=load-graph-from-json, group=graph, time=1742405403.1345215 2025-03-19 17:30:03,134 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_0] Set stage load-graph-from-json_finished=1742405403.1345215 2025-03-19 17:30:03,134 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_0] Profile step load-graph-from-json_finished - 1742405403.1345215 2025-03-19 17:30:03,134 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_0] Finish stage tag=gen-graph-json-default-linux-x86_64-release-asan-nopic, group=graph, time=1742405403.1348214 2025-03-19 17:30:03,134 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_0] Set stage gen-graph-json-default-linux-x86_64-release-asan-nopic_finished=1742405403.1348214 2025-03-19 17:30:03,134 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_0] Profile step gen-graph-json-default-linux-x86_64-release-asan-nopic_finished - 1742405403.1348214 2025-03-19 17:30:03,135 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_0] Finish stage tag=gen-graph-default-linux-x86_64-release-asan-nopic, group=graph, time=1742405403.1352909 2025-03-19 17:30:03,135 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_0] Set stage gen-graph-default-linux-x86_64-release-asan-nopic_finished=1742405403.1352909 2025-03-19 17:30:03,135 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_0] Profile step gen-graph-default-linux-x86_64-release-asan-nopic_finished - 1742405403.1352909 2025-03-19 17:30:03,135 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"ymake main","_timestamp":1742405403113036,"_typename":"NEvent.TStageFinished","ymake_run_uid":1} 2025-03-19 17:30:03,135 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"DoubleValue":0.3858787272,"Name":"EYmakeStats::RunTime","Type":"double","_timestamp":1742405403113066,"_typename":"NEvent.TMonitoringStat","ymake_run_uid":1} 2025-03-19 17:30:03,135 DEBUG (devtools.ya.build.ya_make) [ThreadPoolExecutor-0_1] Configure message {"StageName":"ymake run","_timestamp":1742405403113070,"_typename":"NEvent.TStageFinished","debug_id":"default-linux-x86_64-release-asan-pic","ymake_run_uid":1} 2025-03-19 17:30:03,136 DEBUG (devtools.ya.build.ymake2.run_ymake) [ThreadPoolExecutor-0_1] run '/home/runner/.ya/tools/v4/8270822128/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1742405402.33222.inxnaqb6/yatmp89beu81b --config /home/runner/.ya/build/conf/dist-release-x-627a72b3507f51ec375677106bb1f547/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-627a72b3507f51ec375677106bb1f547_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.onw9kgln/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.onw9kgln/makefiles.dart --dump-build-plan - --quiet --events dGT /home/runner/actions_runner/_work/ydb/ydb' finished 2025-03-19 17:30:03,136 DEBUG (devtools.ya.core.event_handling.base_subscriber) [ThreadPoolExecutor-0_1] Unsubscribing PrintProgressSubscriber from event_queue 2025-03-19 17:30:03,137 DEBUG (devtools.ya.build.ymake2) [ThreadPoolExecutor-0_1] ymake_run_info: {"ymake_run_uid":1,"stats":{"preparing":{"start":1742405402.720870494842529,"finish":1742405402.72142481803894,"duration":0.000554323196411},"execution":{"start":1742405402.721425771713257,"finish":1742405403.136298418045044,"duration":0.414872646331787},"postprocessing":{"start":1742405403.136300086975098,"finish":1742405403.136592626571655,"duration":0.000292539596558}},"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":1742405402.727168083190918,"finish":1742405403.113070011138916,"duration":0.385901927947998},"Load configuration from cache":{"start":1742405402.727299928665161,"finish":1742405402.727313041687012,"duration":0.000013113021851},"Load configuration (no cache)":{"start":1742405402.727607011795044,"finish":1742405402.897155046463013,"duration":0.169548034667969},"Compile and RecalcAll conditions":{"start":1742405402.897176027297974,"finish":1742405402.898788928985596,"duration":0.001612901687622},"Fold global commands":{"start":1742405402.898802995681763,"finish":1742405402.900228977203369,"duration":0.001425981521606},"Fill ModuleScopeOnly flag":{"start":1742405402.900238990783691,"finish":1742405402.90024209022522,"duration":0.000003099441528},"Load plugins":{"start":1742405402.900301933288574,"finish":1742405403.027293920516968,"duration":0.126991987228394},"ymake main":{"start":1742405403.059808015823364,"finish":1742405403.113035917282104,"duration":0.05322790145874},"Build graph":{"start":1742405403.062072038650513,"finish":1742405403.107939958572388,"duration":0.045867919921875},"Configure graph":{"start":1742405403.062088966369629,"finish":1742405403.107742071151733,"duration":0.045653104782104},"Find Lost Includes":{"start":1742405403.107767105102539,"finish":1742405403.107775926589966,"duration":0.000008821487427},"Set reachable nodes":{"start":1742405403.107983112335205,"finish":1742405403.107986927032471,"duration":0.000003814697266},"Sort edges":{"start":1742405403.107989072799683,"finish":1742405403.107990980148315,"duration":0.000001907348633},"Report Foreign Platform Events":{"start":1742405403.107992887496948,"finish":1742405403.107997894287109,"duration":0.000005006790161},"Check blacklist":{"start":1742405403.108000040054321,"finish":1742405403.10800290107727,"duration":0.000002861022949},"Check isolated projects":{"start":1742405403.108005046844482,"finish":1742405403.108007907867432,"duration":0.000002861022949},"Compact internal graph and modules table":{"start":1742405403.108010053634644,"finish":1742405403.108012914657593,"duration":0.000002861022949},"Detect loops":{"start":1742405403.108015060424805,"finish":1742405403.108023881912231,"duration":0.000008821487427},"Apply Dependency Management":{"start":1742405403.108026027679443,"finish":1742405403.108031034469604,"duration":0.000005006790161},"Compute DEPENDS to modules closure":{"start":1742405403.108032941818237,"finish":1742405403.108036041259766,"duration":0.000003099441528},"Save Dependency management cache":{"start":1742405403.108038902282715,"finish":1742405403.108371019363403,"duration":0.000332117080688},"Check Transitive Requirements":{"start":1742405403.108380079269409,"finish":1742405403.108383893966675,"duration":0.000003814697266},"Find missing peerdirs":{"start":1742405403.10838794708252,"finish":1742405403.108390092849731,"duration":0.000002145767212},"Report Configure Events":{"start":1742405403.108392953872681,"finish":1742405403.108400106430054,"duration":0.000007152557373},"Update Unreachable file from External changes":{"start":1742405403.108402013778687,"finish":1742405403.108403921127319,"duration":0.000001907348633},"Save Deps cache":{"start":1742405403.108409881591797,"finish":1742405403.109086036682129,"duration":0.000676155090332},"Export JSON":{"start":1742405403.109095096588135,"finish":1742405403.109301090240479,"duration":0.000205993652344},"Write JSON":{"start":1742405403.109101057052612,"finish":1742405403.10929799079895,"duration":0.000196933746338},"Visit JSON":{"start":1742405403.109112024307251,"finish":1742405403.109123945236206,"duration":0.000011920928955},"Render JSON":{"start":1742405403.109127044677734,"finish":1742405403.109198093414307,"duration":0.000071048736572},"Save Uids cache":{"start":1742405403.109200000762939,"finish":1742405403.109240055084229,"duration":0.000040054321289}},"metrics":{"File access":{"loaded size":66,"load time":23,"loaded MD5 time":0,"Max loaded MD5 time":0,"loaded count":2,"max load time":17,"mapped size":0,"mapped MD5 time":0,"Max mapped MD5 time":0,"mapped count":0,"map time":0,"from patch count":0,"from patch size":0,"file stat count":2,"lstat count":2,"lstat sum us":14,"lstat min us":5,"lstat avr us":7,"lstat max us":9,"opendir count":0,"opendir sum us":0,"opendir min us":0,"opendir avr us":0,"opendir max us":0,"readdir count":0,"readdir sum us":0,"readdir min us":0,"readdir avr us":0,"readdir max us":0,"(opendir + readdir) sum us":0,"(lstat + opendir + readdir) sum us":14},"Parsing":{"parse time":0,"parsed files count":0,"parsed files size":0,"parsed files recovered":0,".in files count":0,".in files size":0},"ya.make parsing":{"count":1,"includes count":0,"unique count":1,"size":33,"unique size":33},"DepGraph":{"nodes count":2,"edges count":1,"files count":6,"commands count":16},"UpdIter":{"nuke mod dir":0},"Resolving":{"Includes attempts":0,"From cache":0,"Resolve AsKnown total":0,"Resolve AsKnown from cache":0},"TModules":{"accessed":0,"loaded":0,"outdated":0,"parsed":0,"total":0},"Internal cache":{"Total cache size on save":2912,"Diagnostics cache size on save":1104,"Graph cache size on save":112,"Parsers cache size on save":144,"Modules table size on save":4,"Times table size on save":16,"Names table size on save":816,"Commands cache size on save":272},"JSON cache":{"Loaded cache items":0,"Added cache items":0,"Saved old cache items":0,"Saved new cache items":0,"Saved total cache items":0,"Loaded full match items":0,"Full match requests":0,"Successful full matches":0,"Loaded partial match items":0,"Partial match requests":0,"Successful partial matches":0,"Fully rendered nodes":0,"Partially rendered nodes":0,"Nodes restored without rendering":0},"Uids cache":{"Loaded nodes":0,"Skipped nodes":0,"Discarded nodes":0,"Loaded loops":0,"Skipped loops":0,"Discarded loops":0,"Saved nodes":2,"Saved loops":0,"Really all nodes no rendered":0},"TMakeCommand":{"module environment initialization calls":0,"actual module environment initializations":0}},"binary":"/home/runner/.ya/tools/v4/8270822128/ymake","args":["/home/runner/.ya/tools/v4/8270822128/ymake","--depends-like-recurse","--warn","dirloops,ChkPeers","--write-meta-data","/home/runner/.ya/tmp/1742405402.33222.inxnaqb6/yatmp89beu81b","--config","/home/runner/.ya/build/conf/dist-release-x-627a72b3507f51ec375677106bb1f547/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-627a72b3507f51ec375677106bb1f547_d357a1f7839b099012272bcb9853ec19","--test-dart","/home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.onw9kgln/test.dart","--tests-data-root","/home/runner/actions_runner/_work/ydb/arcadia_tests_data","--makefiles-dart","/home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.onw9kgln/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.414872646331787} 2025-03-19 17:30:03,137 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_1] Start stage tag=load-graph-from-json, group=graph, time=1742405403.1371465 2025-03-19 17:30:03,137 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_1] Set stage load-graph-from-json_started=1742405403.1371465 2025-03-19 17:30:03,137 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_1] Profile step load-graph-from-json_started - 1742405403.1371465 2025-03-19 17:30:03,137 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_1] Finish stage tag=load-graph-from-json, group=graph, time=1742405403.1373072 2025-03-19 17:30:03,137 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_1] Set stage load-graph-from-json_finished=1742405403.1373072 2025-03-19 17:30:03,137 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_1] Profile step load-graph-from-json_finished - 1742405403.1373072 2025-03-19 17:30:03,137 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_1] Finish stage tag=gen-graph-json-default-linux-x86_64-release-asan-pic, group=graph, time=1742405403.1375344 2025-03-19 17:30:03,137 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_1] Set stage gen-graph-json-default-linux-x86_64-release-asan-pic_finished=1742405403.1375344 2025-03-19 17:30:03,137 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_1] Profile step gen-graph-json-default-linux-x86_64-release-asan-pic_finished - 1742405403.1375344 2025-03-19 17:30:03,137 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_1] Finish stage tag=gen-graph-default-linux-x86_64-release-asan-pic, group=graph, time=1742405403.1378026 2025-03-19 17:30:03,137 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_1] Set stage gen-graph-default-linux-x86_64-release-asan-pic_finished=1742405403.1378026 2025-03-19 17:30:03,137 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_1] Profile step gen-graph-default-linux-x86_64-release-asan-pic_finished - 1742405403.1378026 2025-03-19 17:30:03,138 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage waiting_graphs for default-linux-x86_64-release-asan: 0.018052101135253906 2025-03-19 17:30:03,138 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=wait-target-graphs-1, group=graph, time=1742405403.1382184 2025-03-19 17:30:03,138 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage wait-target-graphs-1_finished=1742405403.1382184 2025-03-19 17:30:03,138 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step wait-target-graphs-1_finished - 1742405403.1382184 2025-03-19 17:30:03,138 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=union-make-files-1, group=graph, time=1742405403.138407 2025-03-19 17:30:03,138 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage union-make-files-1_started=1742405403.138407 2025-03-19 17:30:03,138 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step union-make-files-1_started - 1742405403.138407 2025-03-19 17:30:03,138 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage union make files for default-linux-x86_64-release-asan: 0.0004673004150390625 2025-03-19 17:30:03,138 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=union-make-files-1, group=graph, time=1742405403.138583 2025-03-19 17:30:03,138 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage union-make-files-1_finished=1742405403.138583 2025-03-19 17:30:03,138 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step union-make-files-1_finished - 1742405403.138583 2025-03-19 17:30:03,138 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=merge-graphs-1, group=graph, time=1742405403.1387217 2025-03-19 17:30:03,138 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage merge-graphs-1_started=1742405403.1387217 2025-03-19 17:30:03,138 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step merge-graphs-1_started - 1742405403.1387217 2025-03-19 17:30:03,138 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage merge_graphs for default-linux-x86_64-release-asan: 0.0003249645233154297 2025-03-19 17:30:03,138 DEBUG (devtools.ya.build.graph) [MainThread] Graph size is 0 after merge_graphs 2025-03-19 17:30:03,139 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=merge-graphs-1, group=graph, time=1742405403.139061 2025-03-19 17:30:03,139 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage merge-graphs-1_finished=1742405403.139061 2025-03-19 17:30:03,139 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step merge-graphs-1_finished - 1742405403.139061 2025-03-19 17:30:03,139 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=strip-graph-1, group=graph, time=1742405403.139197 2025-03-19 17:30:03,139 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage strip-graph-1_started=1742405403.139197 2025-03-19 17:30:03,139 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step strip-graph-1_started - 1742405403.139197 2025-03-19 17:30:03,139 DEBUG (exts.timer) [MainThread] Timer merge_target_graphs, stage strip_graph for default-linux-x86_64-release-asan: 0.0004515647888183594 2025-03-19 17:30:03,139 DEBUG (devtools.ya.build.graph) [MainThread] Graph size is 0 after strip_graph 2025-03-19 17:30:03,139 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=strip-graph-1, group=graph, time=1742405403.1393936 2025-03-19 17:30:03,139 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage strip-graph-1_finished=1742405403.1393936 2025-03-19 17:30:03,139 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step strip-graph-1_finished - 1742405403.1393936 2025-03-19 17:30:03,139 DEBUG (devtools.ya.build.graph) [MainThread] Configuring only non-PIC for test_tool_tc1-global 2025-03-19 17:30:03,139 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_0] Start stage tag=gen-graph-test_tool_tc1-nopic-global, group=graph, time=1742405403.1398616 2025-03-19 17:30:03,139 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_0] Set stage gen-graph-test_tool_tc1-nopic-global_started=1742405403.1398616 2025-03-19 17:30:03,139 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_0] Profile step gen-graph-test_tool_tc1-nopic-global_started - 1742405403.1398616 2025-03-19 17:30:03,140 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_0] Start stage tag=gen-graph-gen-opts-test_tool_tc1-nopic-global, group=graph, time=1742405403.1402059 2025-03-19 17:30:03,140 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_0] Set stage gen-graph-gen-opts-test_tool_tc1-nopic-global_started=1742405403.1402059 2025-03-19 17:30:03,140 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_0] Profile step gen-graph-gen-opts-test_tool_tc1-nopic-global_started - 1742405403.1402059 2025-03-19 17:30:03,140 DEBUG (yalibrary.guards) [ThreadPoolExecutor-0_0] Enter guard fetch with value None 2025-03-19 17:30:03,155 DEBUG (devtools.ya.build.genconf) [ThreadPoolExecutor-0_0] Generating conf into /home/runner/.ya/build/conf/dist-release-57b3257a3e9641f5722e561f14c2a640/ymake.conf with cmd ['/home/runner/.ya/tools/e3e5c44a17_d/ya-bin', '-B', '/home/runner/actions_runner/_work/ydb/ydb/build/ymake_conf.py', '/home/runner/actions_runner/_work/ydb/ydb', 'dist-release', 'no', '--toolchain-params', 'eyJib3R0bGVfbmFtZSI6ImNsYW5nMTgiLCJlbnYiOnsiQ1BBVEgiOlsiIl0sIkxJQlJBUllfUEFUSCI6WyIiXSwiU0RLUk9PVCI6WyIiXX0sImV4ZWN1dGFibGVfcGF0aCI6ImMrKyIsImZsYWdzIjp7IlNBTklUSVpFUl9UWVBFIjoiYWRkcmVzcyJ9LCJmb3JtdWxhIjp7ImJ5X3BsYXRmb3JtIjp7ImRhcndpbi1hcm02NCI6eyJ1cmkiOiJzYnI6NzU5OTQ4NDI2NSJ9LCJkYXJ3aW4teDg2XzY0Ijp7InVyaSI6InNicjo3NTk5NTE3NTA2In0sImxpbnV4LWFhcmNoNjQiOnsidXJpIjoic2JyOjc1OTkyODU1NjYifSwibGludXgteDg2XzY0Ijp7InVyaSI6InNicjo3NTk5NDY5MTU2In0sIndpbjMyLXg4Nl82NCI6eyJ1cmkiOiJzYnI6NzU5OTQyMjE0NCJ9fX0sIm5hbWUiOiJjbGFuZzE4IiwicGFyYW1zIjp7ImNfY29tcGlsZXIiOiIkKENMQU5HLTI1MTgyMzE0MzIpL2Jpbi9jbGFuZyIsImN4eF9jb21waWxlciI6IiQoQ0xBTkctMjUxODIzMTQzMikvYmluL2NsYW5nKysiLCJsbHZtLXN5bWJvbGl6ZXIiOiIkKENMQU5HLTI1MTgyMzE0MzIpL2Jpbi9sbHZtLXN5bWJvbGl6ZXIiLCJtYXRjaF9yb290IjoiQ0xBTkctMjUxODIzMTQzMiIsIm5tIjoiJChDTEFORy0yNTE4MjMxNDMyKS9iaW4vbGx2bS1ubSIsIm9iamNvcHkiOiIkKENMQU5HLTI1MTgyMzE0MzIpL2Jpbi9sbHZtLW9iamNvcHkiLCJwcm9maWxlcyI6IiQoWENPREVfVE9PTFNfUk9PVC1zYnI6Nzk5MDE3NzcxKS9YY29kZS9Db250ZW50cy9EZXZlbG9wZXIvUGxhdGZvcm1zL2lQaG9uZU9TLnBsYXRmb3JtL0RldmVsb3Blci9MaWJyYXJ5L0NvcmVTaW11bGF0b3IvUHJvZmlsZXMiLCJzaW1jdGwiOiIkKFhDT0RFX1RPT0xTX1JPT1Qtc2JyOjc5OTAxNzc3MSkvWGNvZGUvU3lzdGVtUm9vdC9Qcml2YXRlRnJhbWV3b3Jrcy9Db3JlU2ltdWxhdG9yLmZyYW1ld29yay9SZXNvdXJjZXMvYmluL3NpbWN0bCIsInN0cmlwIjoiJChDTEFORy0yNTE4MjMxNDMyKS9iaW4vbGx2bS1zdHJpcCIsInR5cGUiOiJjbGFuZyIsInVzZV9idW5kbGUiOnRydWUsInZlcnNpb24iOiIxOCJ9LCJwbGF0Zm9ybSI6eyJob3N0Ijp7ImFyY2giOiJ4ODZfNjQiLCJvcyI6IkxJTlVYIiwidG9vbGNoYWluIjoiZGVmYXVsdCIsInZpc2libGVfbmFtZSI6ImNsYW5nMTgifSwidGFyZ2V0Ijp7ImFyY2giOiJ4ODZfNjQiLCJvcyI6IkxJTlVYIiwidG9vbGNoYWluIjoiZGVmYXVsdCIsInZpc2libGVfbmFtZSI6ImNsYW5nMTgifX0sInBsYXRmb3JtX25hbWUiOiJERUZBVUxULUxJTlVYLVg4Nl82NCIsInRvb2xfdmFyIjoiQ0xBTkctMjUxODIzMTQzMiJ9', '-l', '-D', 'APPLE_SDK_LOCAL=yes', '-D', 'CFLAGS=-fno-omit-frame-pointer -Wno-unknown-argument', '-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'} 2025-03-19 17:30:03,284 DEBUG (devtools.ya.build.genconf) [ThreadPoolExecutor-0_0] Copy conf /home/runner/.ya/build/conf/dist-release-57b3257a3e9641f5722e561f14c2a640/ymake.conf to /home/runner/.ya/build/conf/dist-release-x-e24becc7f7544da04f654431cab30bda/ymake.conf 2025-03-19 17:30:03,284 DEBUG (yalibrary.guards) [ThreadPoolExecutor-0_0] Exit guard fetch with value None 2025-03-19 17:30:03,284 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_0] Finish stage tag=gen-graph-gen-opts-test_tool_tc1-nopic-global, group=graph, time=1742405403.2847576 2025-03-19 17:30:03,284 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_0] Set stage gen-graph-gen-opts-test_tool_tc1-nopic-global_finished=1742405403.2847576 2025-03-19 17:30:03,284 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_0] Profile step gen-graph-gen-opts-test_tool_tc1-nopic-global_finished - 1742405403.2847576 2025-03-19 17:30:03,284 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_0] Start stage tag=gen-graph-json-test_tool_tc1-nopic-global, group=graph, time=1742405403.2849593 2025-03-19 17:30:03,285 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_0] Set stage gen-graph-json-test_tool_tc1-nopic-global_started=1742405403.2849593 2025-03-19 17:30:03,285 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_0] Profile step gen-graph-json-test_tool_tc1-nopic-global_started - 1742405403.2849593 2025-03-19 17:30:03,285 DEBUG (devtools.ya.build.ymake2) [ThreadPoolExecutor-0_0] 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-e24becc7f7544da04f654431cab30bda_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-e24becc7f7544da04f654431cab30bda/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 0x7fd4050f07c0>, 'enabled_events': 'PSLGE', 'no_caches_on_retry': False, 'no_ymake_retry': False, 'disable_customization': 0, 'dump_tests': '/home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.0m6i3p_m/test.dart', 'dump_make_files': '/home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.0m6i3p_m/makefiles.dart'} 2025-03-19 17:30:03,285 DEBUG (devtools.ya.core.yarg.behaviour) [ThreadPoolExecutor-0_0] Found unused args ['grab_stderr'] 2025-03-19 17:30:03,285 DEBUG (devtools.ya.build.prefetch) [ThreadPoolExecutor-0_0] prefetch disabled 2025-03-19 17:30:03,285 DEBUG (devtools.ya.core.event_handling.base_subscriber) [ThreadPoolExecutor-0_0] Subscribing PrintProgressSubscriber to event_queue 2025-03-19 17:30:03,285 DEBUG (yalibrary.tools) [ThreadPoolExecutor-0_0] Using old-style toolchain for: ymake 2025-03-19 17:30:03,285 DEBUG (devtools.ya.build.ymake2.run_ymake) [ThreadPoolExecutor-0_0] run: '/home/runner/.ya/tools/v4/8270822128/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1742405402.33222.inxnaqb6/yatmpbc3qgnzk --config /home/runner/.ya/build/conf/dist-release-x-e24becc7f7544da04f654431cab30bda/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-e24becc7f7544da04f654431cab30bda_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.0m6i3p_m/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.0m6i3p_m/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: { } 2025-03-19 17:30:03,678 DEBUG (devtools.ya.build.ymake2.run_ymake) [ThreadPoolExecutor-0_0] run '/home/runner/.ya/tools/v4/8270822128/ymake --depends-like-recurse --warn dirloops,ChkPeers --write-meta-data /home/runner/.ya/tmp/1742405402.33222.inxnaqb6/yatmpbc3qgnzk --config /home/runner/.ya/build/conf/dist-release-x-e24becc7f7544da04f654431cab30bda/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-e24becc7f7544da04f654431cab30bda_d357a1f7839b099012272bcb9853ec19 --test-dart /home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.0m6i3p_m/test.dart --tests-data-root /home/runner/actions_runner/_work/ydb/arcadia_tests_data --makefiles-dart /home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.0m6i3p_m/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 2025-03-19 17:30:03,678 DEBUG (devtools.ya.core.event_handling.base_subscriber) [ThreadPoolExecutor-0_0] Unsubscribing PrintProgressSubscriber from event_queue 2025-03-19 17:30:03,679 DEBUG (devtools.ya.build.ymake2) [ThreadPoolExecutor-0_0] ymake_run_info: {"ymake_run_uid":2,"stats":{"preparing":{"start":1742405403.285361766815186,"finish":1742405403.285931348800659,"duration":0.000569581985474},"execution":{"start":1742405403.285932064056396,"finish":1742405403.678687810897827,"duration":0.392755746841431},"postprocessing":{"start":1742405403.678690671920776,"finish":1742405403.6790611743927,"duration":0.000370502471924}},"purpose":"test_tool_tc1-nopic-global","caches":{},"stages":{},"metrics":{},"binary":"/home/runner/.ya/tools/v4/8270822128/ymake","args":["/home/runner/.ya/tools/v4/8270822128/ymake","--depends-like-recurse","--warn","dirloops,ChkPeers","--write-meta-data","/home/runner/.ya/tmp/1742405402.33222.inxnaqb6/yatmpbc3qgnzk","--config","/home/runner/.ya/build/conf/dist-release-x-e24becc7f7544da04f654431cab30bda/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-e24becc7f7544da04f654431cab30bda_d357a1f7839b099012272bcb9853ec19","--test-dart","/home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.0m6i3p_m/test.dart","--tests-data-root","/home/runner/actions_runner/_work/ydb/arcadia_tests_data","--makefiles-dart","/home/runner/.ya/tmp/1742405402.33222.inxnaqb6/gen_graph.0m6i3p_m/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.392755746841431} 2025-03-19 17:30:03,679 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_0] Start stage tag=load-graph-from-json, group=graph, time=1742405403.67954 2025-03-19 17:30:03,679 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_0] Set stage load-graph-from-json_started=1742405403.67954 2025-03-19 17:30:03,679 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_0] Profile step load-graph-from-json_started - 1742405403.67954 2025-03-19 17:30:03,679 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_0] Finish stage tag=load-graph-from-json, group=graph, time=1742405403.679903 2025-03-19 17:30:03,679 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_0] Set stage load-graph-from-json_finished=1742405403.679903 2025-03-19 17:30:03,680 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_0] Profile step load-graph-from-json_finished - 1742405403.679903 2025-03-19 17:30:03,680 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_0] Finish stage tag=gen-graph-json-test_tool_tc1-nopic-global, group=graph, time=1742405403.6800942 2025-03-19 17:30:03,680 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_0] Set stage gen-graph-json-test_tool_tc1-nopic-global_finished=1742405403.6800942 2025-03-19 17:30:03,680 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_0] Profile step gen-graph-json-test_tool_tc1-nopic-global_finished - 1742405403.6800942 2025-03-19 17:30:03,680 DEBUG (devtools.ya.core.stage_tracer) [ThreadPoolExecutor-0_0] Finish stage tag=gen-graph-test_tool_tc1-nopic-global, group=graph, time=1742405403.6804316 2025-03-19 17:30:03,680 DEBUG (devtools.ya.core.stages_profiler) [ThreadPoolExecutor-0_0] Set stage gen-graph-test_tool_tc1-nopic-global_finished=1742405403.6804316 2025-03-19 17:30:03,680 DEBUG (devtools.ya.core.profiler) [ThreadPoolExecutor-0_0] Profile step gen-graph-test_tool_tc1-nopic-global_finished - 1742405403.6804316 2025-03-19 17:30:03,681 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=get-graph-1, group=graph, time=1742405403.6810977 2025-03-19 17:30:03,681 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage get-graph-1_started=1742405403.6810977 2025-03-19 17:30:03,681 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step get-graph-1_started - 1742405403.6810977 2025-03-19 17:30:03,681 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=get-graph-1, group=graph, time=1742405403.6813772 2025-03-19 17:30:03,681 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage get-graph-1_finished=1742405403.6813772 2025-03-19 17:30:03,681 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step get-graph-1_finished - 1742405403.6813772 2025-03-19 17:30:03,681 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=merge-target-graphs-1, group=graph, time=1742405403.6815438 2025-03-19 17:30:03,681 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_finished=1742405403.6815438 2025-03-19 17:30:03,681 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step merge-target-graphs-1_finished - 1742405403.6815438 2025-03-19 17:30:03,681 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=build-merged-graph, group=graph, time=1742405403.6817334 2025-03-19 17:30:03,681 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage build-merged-graph_started=1742405403.6817334 2025-03-19 17:30:03,681 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step build-merged-graph_started - 1742405403.6817334 2025-03-19 17:30:03,682 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=insert-tests-1, group=graph, time=1742405403.6827734 2025-03-19 17:30:03,682 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage insert-tests-1_started=1742405403.6827734 2025-03-19 17:30:03,682 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step insert-tests-1_started - 1742405403.6827734 2025-03-19 17:30:03,683 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'unsupported cross-compiled tests' on 0 suites 2025-03-19 17:30:03,683 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter '. at 0x7fd40506e840>' on 0 suites 2025-03-19 17:30:03,683 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'size' on 0 suites 2025-03-19 17:30:03,683 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'class type' on 0 suites 2025-03-19 17:30:03,683 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'suite type' on 0 suites 2025-03-19 17:30:03,683 DEBUG (devtools.ya.test.filter) [MainThread] Tags filter include set:[] exclude set:[] 2025-03-19 17:30:03,683 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'tags' on 0 suites 2025-03-19 17:30:03,683 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'project path' on 0 suites 2025-03-19 17:30:03,683 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'filename filter' on 0 suites 2025-03-19 17:30:03,683 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'chunk filter' on 0 suites 2025-03-19 17:30:03,683 DEBUG (devtools.ya.test.filter) [MainThread] Going to apply filter 'name' on 0 suites 2025-03-19 17:30:03,683 DEBUG (devtools.ya.build.graph) [MainThread] Generating build plan 2025-03-19 17:30:03,683 DEBUG (devtools.ya.build.graph) [MainThread] Preparing test suites 2025-03-19 17:30:03,683 DEBUG (devtools.ya.build.graph) [MainThread] Stripping clang-tidy irrelevant deps 2025-03-19 17:30:03,683 DEBUG (exts.timer) [MainThread] Timer inject_tests, stage inject tests for default-linux-x86_64-release-asan: 0.0009899139404296875 2025-03-19 17:30:03,683 DEBUG (devtools.ya.build.graph) [MainThread] injected 0 tests for default-linux-x86_64-release-asan 2025-03-19 17:30:03,684 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=insert-tests-1, group=graph, time=1742405403.6840396 2025-03-19 17:30:03,684 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage insert-tests-1_finished=1742405403.6840396 2025-03-19 17:30:03,684 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step insert-tests-1_finished - 1742405403.6840396 2025-03-19 17:30:03,684 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=merge-target-graphs-1, group=graph, time=1742405403.6842232 2025-03-19 17:30:03,684 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_started=1742405403.6842232 2025-03-19 17:30:03,684 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step merge-target-graphs-1_started - 1742405403.6842232 2025-03-19 17:30:03,684 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=merge-target-graphs-1, group=graph, time=1742405403.684361 2025-03-19 17:30:03,684 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage merge-target-graphs-1_finished=1742405403.684361 2025-03-19 17:30:03,684 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step merge-target-graphs-1_finished - 1742405403.684361 2025-03-19 17:30:03,684 DEBUG (devtools.ya.core.config) [MainThread] Read config "build/platform/python/ymake_python2/resources.json" from resource 2025-03-19 17:30:03,684 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] python: will use 'linux-x86_64' platform 2025-03-19 17:30:03,685 DEBUG (devtools.ya.core.config) [MainThread] Reading contents of /home/runner/actions_runner/_work/ydb/ydb/build/external_resources/gdb/resources.json 2025-03-19 17:30:03,685 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] gdb: will use 'linux-x86_64' platform 2025-03-19 17:30:03,685 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=build-merged-graph, group=graph, time=1742405403.6852975 2025-03-19 17:30:03,685 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage build-merged-graph_finished=1742405403.6852975 2025-03-19 17:30:03,685 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step build-merged-graph_finished - 1742405403.6852975 2025-03-19 17:30:03,685 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=iter-extra-resources, group=graph, time=1742405403.6854548 2025-03-19 17:30:03,685 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage iter-extra-resources_started=1742405403.6854548 2025-03-19 17:30:03,685 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step iter-extra-resources_started - 1742405403.6854548 2025-03-19 17:30:03,685 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=iter-extra-resources, group=graph, time=1742405403.6855776 2025-03-19 17:30:03,685 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage iter-extra-resources_finished=1742405403.6855776 2025-03-19 17:30:03,685 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step iter-extra-resources_finished - 1742405403.6855776 2025-03-19 17:30:03,685 DEBUG (exts.timer) [MainThread] Timer devtools.ya.build.graph, stage build and merge graphs: 1.1469016075134277 2025-03-19 17:30:03,685 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=strip-graph, group=graph, time=1742405403.6857626 2025-03-19 17:30:03,685 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage strip-graph_started=1742405403.6857626 2025-03-19 17:30:03,685 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step strip-graph_started - 1742405403.6857626 2025-03-19 17:30:03,685 DEBUG (devtools.ya.build.graph) [MainThread] stripped 0, left 0 nodes 2025-03-19 17:30:03,685 DEBUG (exts.timer) [MainThread] Timer devtools.ya.build.graph, stage strip graph: 0.00021457672119140625 2025-03-19 17:30:03,685 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=strip-graph, group=graph, time=1742405403.6859665 2025-03-19 17:30:03,686 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage strip-graph_finished=1742405403.6859665 2025-03-19 17:30:03,686 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step strip-graph_finished - 1742405403.6859665 2025-03-19 17:30:03,686 DEBUG (exts.timer) [MainThread] Timer devtools.ya.build.graph, stage gen rename nodes: 0.00017571449279785156 2025-03-19 17:30:03,686 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] python: will use 'linux-x86_64' platform 2025-03-19 17:30:03,686 DEBUG (yalibrary.fetcher.tool_chain_fetcher) [MainThread] ymake: will use 'linux' platform 2025-03-19 17:30:03,686 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=inject_default_requirements, group=graph, time=1742405403.6863978 2025-03-19 17:30:03,686 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage inject_default_requirements_started=1742405403.6863978 2025-03-19 17:30:03,686 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step inject_default_requirements_started - 1742405403.6863978 2025-03-19 17:30:03,686 DEBUG (devtools.ya.build.graph) [MainThread] Updated requirements for 0 nodes 2025-03-19 17:30:03,686 DEBUG (exts.timer) [MainThread] Timer substitude_uids, stage substitude_uids: 1.9073486328125e-06 2025-03-19 17:30:03,686 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=inject_default_requirements, group=graph, time=1742405403.686606 2025-03-19 17:30:03,686 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage inject_default_requirements_finished=1742405403.686606 2025-03-19 17:30:03,686 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step inject_default_requirements_finished - 1742405403.686606 2025-03-19 17:30:03,686 DEBUG (exts.timer) [MainThread] Timer devtools.ya.build.graph, stage misc graph changes: 0.0006308555603027344 2025-03-19 17:30:03,686 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=finalize-graph, group=graph, time=1742405403.6867774 2025-03-19 17:30:03,686 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage finalize-graph_started=1742405403.6867774 2025-03-19 17:30:03,686 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step finalize-graph_started - 1742405403.6867774 2025-03-19 17:30:03,686 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=finalize-graph, group=graph, time=1742405403.6868887 2025-03-19 17:30:03,686 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage finalize-graph_finished=1742405403.6868887 2025-03-19 17:30:03,686 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step finalize-graph_finished - 1742405403.6868887 2025-03-19 17:30:03,687 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=imprint-store-and-stats, group=graph, time=1742405403.6870115 2025-03-19 17:30:03,687 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage imprint-store-and-stats_started=1742405403.6870115 2025-03-19 17:30:03,687 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step imprint-store-and-stats_started - 1742405403.6870115 2025-03-19 17:30:03,687 DEBUG (devtools.ya.core.imprint.imprint:Imprint) [MainThread] 2025-03-19 17:30:03,687 DEBUG (devtools.ya.core.imprint.imprint:Imprint) [MainThread] 2025-03-19 17:30:03,687 DEBUG (devtools.ya.core.imprint.imprint:Imprint) [MainThread] 2025-03-19 17:30:03,687 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=imprint-store-and-stats, group=graph, time=1742405403.687274 2025-03-19 17:30:03,687 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage imprint-store-and-stats_finished=1742405403.687274 2025-03-19 17:30:03,687 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step imprint-store-and-stats_finished - 1742405403.687274 2025-03-19 17:30:03,687 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=inject_stats_and_static_uids, group=graph, time=1742405403.687397 2025-03-19 17:30:03,687 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage inject_stats_and_static_uids_started=1742405403.687397 2025-03-19 17:30:03,687 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step inject_stats_and_static_uids_started - 1742405403.687397 2025-03-19 17:30:03,687 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=inject_stats_and_static_uids, group=graph, time=1742405403.68751 2025-03-19 17:30:03,687 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage inject_stats_and_static_uids_finished=1742405403.68751 2025-03-19 17:30:03,687 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step inject_stats_and_static_uids_finished - 1742405403.68751 2025-03-19 17:30:03,687 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=strip-tags, group=graph, time=1742405403.6876454 2025-03-19 17:30:03,687 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage strip-tags_started=1742405403.6876454 2025-03-19 17:30:03,687 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step strip-tags_started - 1742405403.6876454 2025-03-19 17:30:03,687 DEBUG (exts.timer) [MainThread] Timer devtools.ya.build.graph, stage strip tags: 0.0010273456573486328 2025-03-19 17:30:03,687 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=strip-tags, group=graph, time=1742405403.687801 2025-03-19 17:30:03,687 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage strip-tags_finished=1742405403.687801 2025-03-19 17:30:03,687 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step strip-tags_finished - 1742405403.687801 2025-03-19 17:30:03,688 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=reduce_graph_resources, group=graph, time=1742405403.688017 2025-03-19 17:30:03,688 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage reduce_graph_resources_started=1742405403.688017 2025-03-19 17:30:03,688 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step reduce_graph_resources_started - 1742405403.688017 2025-03-19 17:30:03,688 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=reduce_graph_resources, group=graph, time=1742405403.6881468 2025-03-19 17:30:03,688 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage reduce_graph_resources_finished=1742405403.6881468 2025-03-19 17:30:03,688 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step reduce_graph_resources_finished - 1742405403.6881468 2025-03-19 17:30:03,688 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=clean-intern-string-storage, group=graph, time=1742405403.6882994 2025-03-19 17:30:03,688 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage clean-intern-string-storage_started=1742405403.6882994 2025-03-19 17:30:03,688 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step clean-intern-string-storage_started - 1742405403.6882994 2025-03-19 17:30:03,688 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=clean-intern-string-storage, group=graph, time=1742405403.6884704 2025-03-19 17:30:03,688 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage clean-intern-string-storage_finished=1742405403.6884704 2025-03-19 17:30:03,688 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step clean-intern-string-storage_finished - 1742405403.6884704 2025-03-19 17:30:03,688 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=build_graph_and_tests, group=graph, time=1742405403.6885967 2025-03-19 17:30:03,688 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage build_graph_and_tests_finished=1742405403.6885967 2025-03-19 17:30:03,688 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step build_graph_and_tests_finished - 1742405403.6885967 2025-03-19 17:30:03,688 DEBUG (exts.timer) [MainThread] Timer context_creation, stage graph_and_tests finished: 1.186471939086914 2025-03-19 17:30:03,691 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=configure-dist-store-cache, group=ya_make, time=1742405403.6917796 2025-03-19 17:30:03,691 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage configure-dist-store-cache_started=1742405403.6917796 2025-03-19 17:30:03,691 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step configure-dist-store-cache_started - 1742405403.6917796 2025-03-19 17:30:03,692 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=configure-dist-store-cache, group=ya_make, time=1742405403.691994 2025-03-19 17:30:03,692 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage configure-dist-store-cache_finished=1742405403.691994 2025-03-19 17:30:03,692 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step configure-dist-store-cache_finished - 1742405403.691994 2025-03-19 17:30:03,692 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=configure-local-cache, group=ya_make, time=1742405403.6921492 2025-03-19 17:30:03,692 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage configure-local-cache_started=1742405403.6921492 2025-03-19 17:30:03,692 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step configure-local-cache_started - 1742405403.6921492 2025-03-19 17:30:03,692 DEBUG (devtools.ya.build.ya_make) [MainThread] content UIDs forced 2025-03-19 17:30:03,692 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=configure-local-cache, group=ya_make, time=1742405403.6924076 2025-03-19 17:30:03,692 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage configure-local-cache_finished=1742405403.6924076 2025-03-19 17:30:03,692 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step configure-local-cache_finished - 1742405403.6924076 2025-03-19 17:30:03,692 DEBUG (devtools.ya.build.ya_make) [MainThread] sandbox_run_test_uids: set() 2025-03-19 17:30:03,692 DEBUG (devtools.ya.build.ya_make) [MainThread] Strip graph due bazel_remote_store mode 2025-03-19 17:30:03,692 DEBUG (devtools.ya.build.graph) [MainThread] stripped 0, left 0 nodes 2025-03-19 17:30:03,697 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=context_creation, group=ya_make, time=1742405403.6972134 2025-03-19 17:30:03,697 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage context_creation_finished=1742405403.6972134 2025-03-19 17:30:03,697 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step context_creation_finished - 1742405403.6972134 2025-03-19 17:30:03,697 DEBUG (exts.timer) [MainThread] Timer context_creation, stage context_creation finished: 0.008553504943847656 2025-03-19 17:30:03,697 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=context_generating, group=build_handler, time=1742405403.6977065 2025-03-19 17:30:03,697 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage context_generating_finished=1742405403.6977065 2025-03-19 17:30:03,697 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step context_generating_finished - 1742405403.6977065 2025-03-19 17:30:03,697 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=build, group=build_handler, time=1742405403.6978924 2025-03-19 17:30:03,697 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage build_started=1742405403.6978924 2025-03-19 17:30:03,697 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step build_started - 1742405403.6978924 2025-03-19 17:30:03,698 DEBUG (devtools.ya.build.reports.autocheck_report) [MainThread] Got 0 tests to report 2025-03-19 17:30:03,698 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2025-03-19 17:30:03,698 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2025-03-19 17:30:03,698 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2025-03-19 17:30:03,698 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2025-03-19 17:30:03,698 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2025-03-19 17:30:03,698 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2025-03-19 17:30:03,698 DEBUG (ReportGenerator) [MainThread] Finish style report 2025-03-19 17:30:03,698 DEBUG (StoredReport) [MainThread] Finish style report 2025-03-19 17:30:03,698 DEBUG (ReportGenerator) [MainThread] Finish tests report, tests by size defaultdict(, {'small': set(), 'medium': set(), 'large': set()}), tests by type defaultdict(, {}) 2025-03-19 17:30:03,698 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2025-03-19 17:30:03,698 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2025-03-19 17:30:03,698 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2025-03-19 17:30:03,698 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2025-03-19 17:30:03,698 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2025-03-19 17:30:03,698 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2025-03-19 17:30:03,698 DEBUG (StoredReport) [MainThread] Finish tests report 2025-03-19 17:30:03,698 DEBUG (ReportGenerator) [MainThread] Finish configure report 2025-03-19 17:30:03,698 DEBUG (StoredReport) [MainThread] Finish configure report 2025-03-19 17:30:03,699 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=cache_test_statuses, group=ya_make, time=1742405403.699045 2025-03-19 17:30:03,699 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage cache_test_statuses_started=1742405403.699045 2025-03-19 17:30:03,699 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step cache_test_statuses_started - 1742405403.699045 2025-03-19 17:30:03,714 DEBUG (yalibrary.store.new_store) [MainThread] Initialized store in /home/runner/.ya/build/cache/trc 2025-03-19 17:30:03,714 DEBUG (yalibrary.store.new_store) [MainThread] Started filtering 2025-03-19 17:30:03,714 DEBUG (library.python.filelock) [MainThread] Acquiring FileLock (blocking=True): /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2025-03-19 17:30:03,715 DEBUG (library.python.filelock) [MainThread] Ensuring FileLock released: /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2025-03-19 17:30:03,715 DEBUG (yalibrary.store.new_store) [MainThread] Done filtering, retain 0 uids, 0 files 2025-03-19 17:30:03,715 DEBUG (yalibrary.store.new_store) [MainThread] Cleaning size store 2025-03-19 17:30:03,715 DEBUG (yalibrary.store.new_store) [MainThread] Cleaning file store 2025-03-19 17:30:03,717 DEBUG (yalibrary.store.new_store) [MainThread] Cleaning uid store 2025-03-19 17:30:03,724 DEBUG (library.python.filelock) [MainThread] Acquiring FileLock (blocking=True): /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2025-03-19 17:30:03,724 DEBUG (library.python.filelock) [MainThread] Ensuring FileLock released: /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2025-03-19 17:30:03,725 DEBUG (library.python.filelock) [MainThread] Acquiring FileLock (blocking=True): /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2025-03-19 17:30:03,725 DEBUG (library.python.filelock) [MainThread] Ensuring FileLock released: /home/runner/.ya/build/cache/trc/lru/queue/consume.lock 2025-03-19 17:30:03,725 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=cache_test_statuses, group=ya_make, time=1742405403.725658 2025-03-19 17:30:03,725 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage cache_test_statuses_finished=1742405403.725658 2025-03-19 17:30:03,725 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step cache_test_statuses_finished - 1742405403.725658 2025-03-19 17:30:03,726 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=finalize-reports, group=ya_make, time=1742405403.7260172 2025-03-19 17:30:03,726 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage finalize-reports_started=1742405403.7260172 2025-03-19 17:30:03,726 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step finalize-reports_started - 1742405403.7260172 2025-03-19 17:30:03,726 DEBUG (devtools.ya.build.ya_make) [MainThread] Build is finished, process results 2025-03-19 17:30:03,726 DEBUG (ReportGenerator) [MainThread] Build result is processed, add 0 entries 2025-03-19 17:30:03,726 DEBUG (ReportGenerator) [MainThread] Finish build report 2025-03-19 17:30:03,726 DEBUG (StoredReport) [MainThread] Finish build report 2025-03-19 17:30:03,726 DEBUG (ReportGenerator) [MainThread] Finish tests report, tests by size defaultdict(, {'small': set(), 'medium': set(), 'large': set()}), tests by type defaultdict(, {}) 2025-03-19 17:30:03,726 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2025-03-19 17:30:03,726 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2025-03-19 17:30:03,726 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2025-03-19 17:30:03,726 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2025-03-19 17:30:03,726 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2025-03-19 17:30:03,726 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2025-03-19 17:30:03,726 DEBUG (StoredReport) [MainThread] Finish tests report 2025-03-19 17:30:03,726 DEBUG (ReportGenerator) [MainThread] Finish style report 2025-03-19 17:30:03,726 DEBUG (StoredReport) [MainThread] Finish style report 2025-03-19 17:30:03,726 DEBUG (ReportGenerator) [MainThread] Finish report 2025-03-19 17:30:03,726 DEBUG (StoredReport) [MainThread] Finish report 2025-03-19 17:30:03,726 DEBUG (devtools.ya.build.ya_make) [MainThread] Build results listener statistics: {} 2025-03-19 17:30:03,726 DEBUG (devtools.ya.build.ya_make) [MainThread] Generating results report 2025-03-19 17:30:03,727 INFO (devtools.ya.build.reports.build_reports) [MainThread] Dump junit report to /home/runner/actions_runner/_work/ydb/ydb/tmp/results/try_1/junit.xml 2025-03-19 17:30:03,727 DEBUG (devtools.ya.build.reports.autocheck_report) [MainThread] Got 0 tests to report 2025-03-19 17:30:03,727 DEBUG (ReportGenerator) [MainThread] Finish tests report by size small 2025-03-19 17:30:03,727 DEBUG (StoredReport) [MainThread] Finish tests report by size small 2025-03-19 17:30:03,727 DEBUG (ReportGenerator) [MainThread] Finish tests report by size medium 2025-03-19 17:30:03,727 DEBUG (StoredReport) [MainThread] Finish tests report by size medium 2025-03-19 17:30:03,727 DEBUG (ReportGenerator) [MainThread] Finish tests report by size large 2025-03-19 17:30:03,727 DEBUG (StoredReport) [MainThread] Finish tests report by size large 2025-03-19 17:30:03,727 DEBUG (ReportGenerator) [MainThread] Build result is processed, add 0 entries 2025-03-19 17:30:03,727 DEBUG (devtools.ya.build.reports.autocheck_report) [MainThread] builder.opts.report_skipped_suites: False, builder.opts.report_skipped_suites False 2025-03-19 17:30:03,727 INFO (devtools.ya.build.reports.build_reports) [MainThread] Dump results report to /home/runner/actions_runner/_work/ydb/ydb/tmp/results/try_1/report.json 2025-03-19 17:30:03,727 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=finalize-reports, group=ya_make, time=1742405403.7279432 2025-03-19 17:30:03,728 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage finalize-reports_finished=1742405403.7279432 2025-03-19 17:30:03,728 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step finalize-reports_finished - 1742405403.7279432 2025-03-19 17:30:03,730 DEBUG (yalibrary.toolscache) [MainThread] AC cache attempt: (release all data) 2025-03-19 17:30:03,731 DEBUG (yalibrary.toolscache) [MainThread] AC cache (release all data) address: (32813, 496779, 'unix:/home/runner/.ya/build/cache/7/psingAwm8ps.tmp') 2025-03-19 17:30:03,732 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=build, group=build_handler, time=1742405403.7320063 2025-03-19 17:30:03,732 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage build_finished=1742405403.7320063 2025-03-19 17:30:03,732 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step build_finished - 1742405403.7320063 2025-03-19 17:30:03,732 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Start stage tag=dump_results, group=build_handler, time=1742405403.7322598 2025-03-19 17:30:03,732 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage dump_results_started=1742405403.7322598 2025-03-19 17:30:03,732 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step dump_results_started - 1742405403.7322598 2025-03-19 17:30:03,732 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=dump_results, group=build_handler, time=1742405403.73275 2025-03-19 17:30:03,732 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage dump_results_finished=1742405403.73275 2025-03-19 17:30:03,732 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step dump_results_finished - 1742405403.73275 2025-03-19 17:30:03,732 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=ya_make_handler, group=build_handler, time=1742405403.732928 2025-03-19 17:30:03,732 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage ya_make_handler_finished=1742405403.732928 2025-03-19 17:30:03,733 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step ya_make_handler_finished - 1742405403.732928 2025-03-19 17:30:03,733 DEBUG (devtools.ya.core.stage_tracer) [MainThread] Finish stage tag=invoke-do_ya_make, group=overall-execution, time=1742405403.7331562 2025-03-19 17:30:03,733 DEBUG (devtools.ya.core.stages_profiler) [MainThread] Set stage invoke-do_ya_make_finished=1742405403.7331562 2025-03-19 17:30:03,733 DEBUG (devtools.ya.core.profiler) [MainThread] Profile step invoke-do_ya_make_finished - 1742405403.7331562 2025-03-19 17:30:03,733 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "dump_debug" stopped in 0.000566 2025-03-19 17:30:03,734 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "evlog" stopped in 0.000024 2025-03-19 17:30:03,734 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "changelist_store" stopped in 0.000002 2025-03-19 17:30:03,734 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "event_queue" stopped in 0.000003 2025-03-19 17:30:03,734 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "mlockall" stopped in 0.000004 2025-03-19 17:30:03,734 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "profile" stopped in 0.000001 2025-03-19 17:30:03,734 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "showstack" stopped in 0.000019 2025-03-19 17:30:03,734 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher" stopped in 0.000001 2025-03-19 17:30:03,734 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" stopped in 0.000004 2025-03-19 17:30:03,734 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token2" stopped in 0.000001 2025-03-19 17:30:03,734 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "docker_config_path" stopped in 0.000001 2025-03-19 17:30:03,734 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "use_universal_fetcher_everywhere" stopped in 0.000001 2025-03-19 17:30:03,734 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetcher_params" stopped in 0.000005 2025-03-19 17:30:03,734 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "self_info" stopped in 0.000002 2025-03-19 17:30:03,734 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" stopped in 0.000001 2025-03-19 17:30:03,734 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display_log" stopped in 0.000005 2025-03-19 17:30:03,734 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "custom_file_log" stopped in 0.000012 2025-03-19 17:30:03,734 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display" stopped in 0.000018 2025-03-19 17:30:03,734 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "state" stopped in 0.000007 2025-03-19 17:30:03,735 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "hide_token" stopped in 0.000001 2025-03-19 17:30:03,735 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "params" stopped in 0.000001 2025-03-19 17:30:03,735 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Restored ctx dict_keys(['uid', 'username', 'file_log', 'display_in_memory_log', 'file_in_memory_log', 'revision', 'vcs_type', 'exit', 'handler_info', 'metrics_reporter', 'report', 'exit_code', 'lifecycle_ts', 'env_checker', 'fetchers_storage', 'tmp_dir']) 2025-03-19 17:30:03,735 DEBUG (library.python.tmp) [MainThread] Removing tmp dir /home/runner/.ya/tmp/1742405402.33222.inxnaqb6 2025-03-19 17:30:03,736 DEBUG (library.python.tmp) [MainThread] Reset back TMPDIR=None 2025-03-19 17:30:03,736 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "tmp_dir" stopped in 0.000710 2025-03-19 17:30:03,736 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "fetchers_storage" stopped in 0.000010 2025-03-19 17:30:03,736 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "env_checker" stopped in 0.000006 2025-03-19 17:30:03,736 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "lifecycle_ts" stopped in 0.000003 2025-03-19 17:30:03,736 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "exit_code" stopped in 0.000004 2025-03-19 17:30:03,737 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "report" stopped in 0.001160 2025-03-19 17:30:03,737 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "metrics_reporter" stopped in 0.000005 2025-03-19 17:30:03,737 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "handler_info" stopped in 0.000006 2025-03-19 17:30:03,737 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "exit" stopped in 0.000006 2025-03-19 17:30:03,737 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "vcs_type" stopped in 0.000006 2025-03-19 17:30:03,737 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "revision" stopped in 0.000004 2025-03-19 17:30:03,737 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "file_in_memory_log" stopped in 0.000007 2025-03-19 17:30:03,738 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "display_in_memory_log" stopped in 0.000003 2025-03-19 17:30:03,738 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "file_log" stopped in 0.000011 2025-03-19 17:30:03,738 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "username" stopped in 0.000002 2025-03-19 17:30:03,738 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Module "uid" stopped in 0.000002 2025-03-19 17:30:03,738 DEBUG (devtools.ya.yalibrary.app_ctx) [MainThread] Restored ctx dict_keys([])