[INFO] fetching crate vik 0.1.3...
[INFO] testing vik-0.1.3 against 1.99.0-beta.8+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate vik 0.1.3 into /workspace/builds/worker-3-tc1/source
[INFO] started tweaking crates.io crate vik 0.1.3
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate vik 0.1.3
[INFO] tweaked toml for crates.io crate vik 0.1.3 written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate vik 0.1.3 on toolchain 1.99.0-beta.8
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate vik 0.1.3 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded memo-map v0.3.3
[INFO] [stderr]   Downloaded minijinja v2.19.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 9e928f00a45d3a8744a0b84066cce39a752cbbd89b5c48d63bd2287407525c3a
[INFO] running `Command { std: "docker" "start" "9e928f00a45d3a8744a0b84066cce39a752cbbd89b5c48d63bd2287407525c3a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9e928f00a45d3a8744a0b84066cce39a752cbbd89b5c48d63bd2287407525c3a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "9e928f00a45d3a8744a0b84066cce39a752cbbd89b5c48d63bd2287407525c3a" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9e928f00a45d3a8744a0b84066cce39a752cbbd89b5c48d63bd2287407525c3a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "9e928f00a45d3a8744a0b84066cce39a752cbbd89b5c48d63bd2287407525c3a" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling displaydoc v0.2.5
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling yoke v0.8.2
[INFO] [stderr]    Compiling futures-macro v0.3.32
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling socket2 v0.6.3
[INFO] [stderr]    Compiling mio v1.2.0
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling http-body-util v0.1.3
[INFO] [stderr]    Compiling bitflags v2.11.1
[INFO] [stderr]    Compiling nix v0.31.3
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling clap_lex v1.1.0
[INFO] [stderr]    Compiling time v0.3.47
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling zerovec v0.11.6
[INFO] [stderr]    Compiling clap_builder v4.6.0
[INFO] [stderr]    Compiling axum-core v0.5.6
[INFO] [stderr]    Compiling clap_derive v4.6.1
[INFO] [stderr]    Compiling dirs-sys v0.5.0
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]    Compiling symlink v0.1.0
[INFO] [stderr]    Compiling memo-map v0.3.3
[INFO] [stderr]    Compiling unsafe-libyaml v0.2.11
[INFO] [stderr]    Compiling zerotrie v0.2.4
[INFO] [stderr]    Compiling tokio v1.52.3
[INFO] [stderr]    Compiling uuid v1.23.1
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling dirs v6.0.0
[INFO] [stderr]    Compiling tinystr v0.8.3
[INFO] [stderr]    Compiling potential_utf v0.1.5
[INFO] [stderr]    Compiling icu_collections v2.2.0
[INFO] [stderr]    Compiling icu_locale_core v2.2.0
[INFO] [stderr]    Compiling icu_provider v2.2.0
[INFO] [stderr]    Compiling icu_normalizer v2.2.0
[INFO] [stderr]    Compiling icu_properties v2.2.0
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling serde_path_to_error v0.1.20
[INFO] [stderr]    Compiling indexmap v2.14.0
[INFO] [stderr]    Compiling clap v4.6.1
[INFO] [stderr]    Compiling tracing-serde v0.2.0
[INFO] [stderr]    Compiling serde_urlencoded v0.7.1
[INFO] [stderr]    Compiling minijinja v2.19.0
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling idna_adapter v1.2.2
[INFO] [stderr]    Compiling idna v1.1.0
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling futures-executor v0.3.32
[INFO] [stderr]    Compiling tracing-subscriber v0.3.23
[INFO] [stderr]    Compiling futures v0.3.32
[INFO] [stderr]    Compiling serde_yaml v0.9.34+deprecated
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling url v2.5.8
[INFO] [stderr]    Compiling tracing-appender v0.2.5
[INFO] [stderr]    Compiling hyper v1.9.0
[INFO] [stderr]    Compiling tower v0.5.3
[INFO] [stderr]    Compiling tokio-util v0.7.18
[INFO] [stderr]    Compiling tower-http v0.6.11
[INFO] [stderr]    Compiling hyper-util v0.1.20
[INFO] [stderr]    Compiling reqwest v0.13.3
[INFO] [stderr]    Compiling axum v0.8.9
[INFO] [stderr]    Compiling vik v0.1.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 2m 42s
[INFO] running `Command { std: "docker" "inspect" "9e928f00a45d3a8744a0b84066cce39a752cbbd89b5c48d63bd2287407525c3a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "9e928f00a45d3a8744a0b84066cce39a752cbbd89b5c48d63bd2287407525c3a" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling bitflags v2.11.1
[INFO] [stderr]    Compiling num_cpus v1.17.0
[INFO] [stderr]    Compiling deadpool-runtime v0.1.4
[INFO] [stderr]    Compiling assert-json-diff v2.0.2
[INFO] [stderr]    Compiling nix v0.31.3
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling deadpool v0.12.3
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling tokio-util v0.7.18
[INFO] [stderr]    Compiling tower v0.5.3
[INFO] [stderr]    Compiling futures-executor v0.3.32
[INFO] [stderr]    Compiling futures v0.3.32
[INFO] [stderr]    Compiling tower-http v0.6.11
[INFO] [stderr]    Compiling h2 v0.4.14
[INFO] [stderr]    Compiling hyper v1.9.0
[INFO] [stderr]    Compiling hyper-util v0.1.20
[INFO] [stderr]    Compiling reqwest v0.13.3
[INFO] [stderr]    Compiling axum v0.8.9
[INFO] [stderr]    Compiling wiremock v0.6.5
[INFO] [stderr]    Compiling vik v0.1.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 1m 42s
[INFO] running `Command { std: "docker" "inspect" "9e928f00a45d3a8744a0b84066cce39a752cbbd89b5c48d63bd2287407525c3a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "9e928f00a45d3a8744a0b84066cce39a752cbbd89b5c48d63bd2287407525c3a" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.35s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/release/deps/vik-5b939126611e30a7)
[INFO] [stdout] 
[INFO] [stdout] running 170 tests
[INFO] [stdout] test agent::adapters::claude_code::tests::multi_text_blocks_fixture_joins_text ... ok
[INFO] [stdout] test agent::adapters::claude_code::tests::assistant_text_blocks_concatenate ... ok
[INFO] [stdout] test agent::adapters::claude_code::tests::system_init_maps_to_session_started ... ok
[INFO] [stdout] test agent::adapters::claude_code::tests::command_contains_expected_flags_and_closed_stdin ... ok
[INFO] [stdout] test agent::adapters::claude_code::tests::non_init_system_event_maps_to_unknown ... ok
[INFO] [stdout] test agent::adapters::codex::tests::command_contains_expected_flags_and_stdin_pipe ... ok
[INFO] [stdout] test agent::adapters::codex::tests::collab_agent_tool_call_retains_unknown_raw_event ... ok
[INFO] [stdout] test agent::adapters::claude_code::tests::future_event_maps_to_unknown_event_with_raw_payload ... ok
[INFO] [stdout] test agent::adapters::claude_code::tests::assistant_tool_only_maps_to_tool_call ... ok
[INFO] [stdout] test agent::adapters::claude_code::tests::task_tool_use_maps_to_subagent_event ... ok
[INFO] [stdout] test agent::adapters::claude_code::tests::agent_tool_use_maps_to_subagent_event ... ok
[INFO] [stdout] test agent::adapters::claude_code::tests::happy_path_fixture_yields_full_session ... ok
[INFO] [stdout] test agent::adapters::codex::tests::current_collab_tool_call_maps_to_subagent_event ... ok
[INFO] [stdout] test agent::adapters::claude_code::tests::result_without_usage_still_completes ... ok
[INFO] [stdout] test agent::adapters::claude_code::tests::user_tool_result_maps_to_tool_call_result ... ok
[INFO] [stdout] test agent::adapters::codex::tests::current_command_execution_completed_maps_to_tool_call_result ... ok
[INFO] [stdout] test agent::adapters::codex::tests::current_item_completed_agent_message_maps_to_message ... ok
[INFO] [stdout] test agent::adapters::codex::tests::current_turn_completed_maps_usage_and_completed ... ok
[INFO] [stdout] test agent::adapters::codex::tests::current_turn_failed_maps_to_provider_error ... ok
[INFO] [stdout] test cli::doctor::tests::errors_fail_even_when_strict_mode_is_disabled ... ok
[INFO] [stdout] test agent::adapters::codex::tests::happy_path_fixture_maps_to_expected_sequence ... ok
[INFO] [stdout] test agent::response::tests::deserializes_provider_neutral_events_and_roundtrips ... ok
[INFO] [stdout] test agent::response::tests::serializes_provider_neutral_event_vocabulary ... ok
[INFO] [stdout] test agent::adapters::codex::tests::current_mcp_tool_call_completed_maps_to_tool_call_result ... ok
[INFO] [stdout] test agent::adapters::codex::tests::current_thread_started_maps_to_session_started ... ok
[INFO] [stdout] test agent::adapters::codex::tests::current_thread_started_without_thread_id_maps_to_unknown ... ok
[INFO] [stdout] test agent::adapters::codex::tests::current_turn_completed_without_usage_still_completes ... ok
[INFO] [stdout] test cli::doctor::tests::strict_mode_fails_when_diagnostics_only_have_warnings ... ok
[INFO] [stdout] test cli::run::tests::format_command_records_detached_http_args_and_workflow_path ... ok
[INFO] [stdout] test cli::run::tests::resolve_bind_address_skips_bind_parsing_without_port ... ok
[INFO] [stdout] test config::agent::tests::agent_profile_defaults_args_and_warns_unknown_fields ... ok
[INFO] [stdout] test cli::run::tests::http_status_logs_inside_server_span ... ok
[INFO] [stdout] test cli::run::tests::resolve_bind_address_builds_socket_when_port_is_set ... ok
[INFO] [stdout] test agent::adapters::codex::tests::current_agent_message_started_maps_to_unknown_event ... ok
[INFO] [stdout] test config::diagnose::tests::diagnostics_warn_unknown_fields_for_string_keys_only ... ok
[INFO] [stdout] test agent::adapters::codex::tests::unsupported_msg_envelope_maps_to_unknown_event_with_raw_payload ... ok
[INFO] [stdout] test config::issue::tests::issue_pull_defaults_idle_sec_when_omitted ... ok
[INFO] [stdout] test agent::adapters::codex::tests::current_command_execution_started_maps_to_tool_call_request ... ok
[INFO] [stdout] test agent::adapters::codex::tests::current_error_event_maps_to_provider_error ... ok
[INFO] [stdout] test cli::shutdown::tests::graceful_returns_ready_future_even_if_shutdown_already_cancelled ... ok
[INFO] [stdout] test agent::adapters::codex::tests::current_turn_started_maps_to_unknown_event_with_raw_payload ... ok
[INFO] [stdout] test config::issue::tests::issue_stages_reject_array_shape ... ok
[INFO] [stdout] test config::issue::tests::issue_stages_deserialize_map_into_named_indexmap_entries ... ok
[INFO] [stdout] test config::agent::tests::agent_runtime_uses_snake_case_yaml_values ... ok
[INFO] [stdout] test config::issue::tests::issue_stages_report_empty_stage_name ... ok
[INFO] [stdout] test config::diagnose::tests::diagnostics_extend_root_child_pointer_to_parent ... ok
[INFO] [stdout] test config::issue::tests::issue_stage_accepts_known_agent_and_reports_empty_prompt_file ... ok
[INFO] [stdout] test config::issue::tests::issue_stage_prompt_source_preserves_unknown_field_warning ... ok
[INFO] [stdout] test config::issue::tests::issue_stage_prompt_source_rejects_both_sources ... ok
[INFO] [stdout] test config::issue::tests::issue_stages_report_empty_map ... ok
[INFO] [stdout] test config::tests::workflow_schema_parses_core_sections_and_preserves_stage_order ... ok
[INFO] [stdout] test config::workspace::tests::workspace_schema_accepts_null_root ... ok
[INFO] [stdout] test config::workspace::tests::workspace_schema_diagnoses_empty_root ... ok
[INFO] [stdout] test config::issue::tests::issue_stage_prompt_source_accepts_inline_prompt ... ok
[INFO] [stdout] test config::issue::tests::issue_stage_prompt_source_rejects_missing_source ... ok
[INFO] [stdout] test config::issue::tests::issue_stages_derive_name_from_map_key_not_authored_field ... ok
[INFO] [stdout] test context::intake::tests::issue_deserializes_tracker_aliases ... ok
[INFO] [stdout] test context::intake::tests::issue_keeps_extra_payload_flattened ... ok
[INFO] [stdout] test context::intake::tests::issues_deserializes_array_and_mutates_like_vec ... ok
[INFO] [stdout] test config::loop_::tests::loop_schema_defaults_to_continuous_polling_limits ... ok
[INFO] [stdout] test context::intake::tests::issue_defaults_description_to_empty_string ... ok
[INFO] [stdout] test config::tests::unknown_fields_surface_as_warnings ... ok
[INFO] [stdout] test config::loop_::tests::loop_schema_diagnoses_zero_limits_and_unknown_fields ... ok
[INFO] [stdout] test config::tests::documented_flat_runtime_shape_parses ... ok
[INFO] [stdout] test config::tests::agents_schema_reports_empty_map_at_agents_pointer ... ok
[INFO] [stdout] test context::run::tests::matching_stages_preserve_workflow_author_order ... ok
[INFO] [stdout] test config::tests::diagnostics_include_nested_pointers_for_invalid_schema ... ok
[INFO] [stdout] test context::tests::context_serializes_values ... ok
[INFO] [stdout] test config::workspace::tests::workspace_schema_defaults_to_repo_local_root ... ok
[INFO] [stdout] test context::tests::context_with_values_allows_chaining ... ok
[INFO] [stdout] test daemon::lifecycle::tests::status_reports_not_installed_when_file_missing ... ok
[INFO] [stdout] test daemon::lifecycle::tests::restart_stop_phase_reports_not_running_when_missing ... ok
[INFO] [stdout] test cli::run::tests::write_state_file_logs_inside_daemon_span ... ok
[INFO] [stdout] test config::issue::tests::issue_stage_prompt_source_accepts_prompt_file ... ok
[INFO] [stdout] test context::run::tests::issue_run_serialized_context_renders_jinja_template ... ok
[INFO] [stdout] test context::run::tests::issue_stage_serializes_stage_context_under_issue ... ok
[INFO] [stdout] test context::run::tests::issue_run_serializes_template_context_shape ... ok
[INFO] [stdout] test context::run::tests::issue_stage_serialization_keeps_stage_metadata_reserved ... ok
[INFO] [stdout] test daemon::lifecycle::tests::restart_stop_phase_reports_not_running_when_stale ... ok
[INFO] [stdout] test agent::adapters::claude_code::tests::result_emits_usage_then_completed ... ok
[INFO] [stdout] test context::run::tests::prepare_skips_after_create_when_issue_workdir_exists ... ok
[INFO] [stdout] test daemon::state::tests::remove_missing_is_ok ... ok
[INFO] [stdout] test daemon::state::tests::try_read_errors_on_malformed_json ... ok
[INFO] [stdout] test daemon::signals::tests::unix_tests::sigterm_trips_shutdown_token ... ok
[INFO] [stdout] test daemon::lifecycle::tests::stop_returns_not_installed_on_missing_file ... ok
[INFO] [stdout] test daemon::state::tests::try_read_missing_returns_none ... ok
[INFO] [stdout] test daemon::lifecycle::tests::uninstall_is_noop_when_missing ... ok
[INFO] [stdout] test hooks::tests::hook_kind_names_match_workflow_keys ... ok
[INFO] [stdout] test logging::value_tests::logging_module_values_match_operational_contract ... ok
[INFO] [stdout] test daemon::state::tests::roundtrip_preserves_fields ... ok
[INFO] [stdout] test orchestrator::event::tests::producer_delivers_intake_events_in_order ... ok
[INFO] [stdout] test logging::retention::tests::deletes_old_files_keeps_fresh_ones ... ok
[INFO] [stdout] test daemon::state::tests::remove_existing_deletes_file ... ok
[INFO] [stdout] test orchestrator::intake::tests::stderr_tail_is_limited ... ok
[INFO] [stdout] test logging::retention::tests::missing_directory_is_ok ... ok
[INFO] [stdout] test orchestrator::session_manager::tests::should_dispatch_preserves_author_order_and_respects_running_policy ... ok
[INFO] [stdout] test orchestrator::intake::tests::run_once_emits_issues_from_command_json ... ok
[INFO] [stdout] test orchestrator::session_manager::tests::dispatch_skip_reason_tracing_separates_no_match_concurrency_and_active_stage ... ok
[INFO] [stdout] test orchestrator::intake::tests::parses_pull_stdout_as_issue_json ... ok
[INFO] [stdout] test orchestrator::intake::tests::nonzero_pull_command_keeps_stderr_tail ... ok
[INFO] [stdout] test orchestrator::session_manager::tests::prepared_dispatch_logs_inside_issue_span ... ok
[INFO] [stdout] test orchestrator::tests::intake_failure_logs_inside_intake_span ... ok
[INFO] [stdout] test hooks::tests::nonzero_hook_reports_bounded_stderr_tail ... ok
[INFO] [stdout] test hooks::tests::unconfigured_hook_skips_without_requiring_cwd ... ok
[INFO] [stdout] test daemon::lifecycle::tests::stop_removes_stale_file_without_signal ... ok
[INFO] [stdout] test daemon::lifecycle::tests::status_reports_stale_when_pid_dead ... ok
[INFO] [stdout] test session::snapshot::tests::session_state_reports_only_terminal_states_as_terminated ... ok
[INFO] [stdout] test session::tests::rate_limit_observation_keeps_latest_event_per_scope ... ok
[INFO] [stdout] test session::tests::session_command_sender_hides_command_construction ... ok
[INFO] [stdout] test session::tests::apply_event_emits_agent_session_id_log ... ok
[INFO] [stdout] test orchestrator::intake::tests::runs_pull_command_from_workflow_directory ... ok
[INFO] [stdout] test daemon::state::tests::write_creates_parent_directory ... ok
[INFO] [stdout] test session::tests::token_usage_events_accumulate_without_overflow ... ok
[INFO] [stdout] test session::tests::session_state_receiver_receives_only_sent_state_changes ... ok
[INFO] [stdout] test shell::command_ext::tests::sleep_beyond_timeout_returns_timeout ... ok
[INFO] [stdout] test shell::command_ext::tests::nonzero_exit_is_captured ... ok
[INFO] [stdout] test shell::command_ext::tests::stderr_is_captured ... ok
[INFO] [stdout] test session::tests::set_state_emits_terminal_log_on_terminal_transition ... ok
[INFO] [stdout] test hooks::tests::unconfigured_hook_log_omits_phase_field ... FAILED
[INFO] [stdout] test template::jinja::tests::render_with_added_env ... ok
[INFO] [stdout] test template::jinja::tests::render_with_added_envs ... ok
[INFO] [stdout] test template::jinja::tests::render_with_added_value ... ok
[INFO] [stdout] test template::jinja::tests::render_with_added_values ... ok
[INFO] [stdout] test shell::command_ext::tests::echo_stdout_success ... ok
[INFO] [stdout] test daemon::lifecycle::tests::status_reports_running_for_own_pid ... ok
[INFO] [stdout] test hooks::tests::configured_hook_renders_template_and_executes_in_cwd ... ok
[INFO] [stdout] test session::jsonl_writer::tests::appends_events_as_json_lines_without_truncating_existing_file ... ok
[INFO] [stdout] test daemon::lifecycle::tests::uninstall_removes_stale_file ... ok
[INFO] [stdout] test session::tests::prompt_file_renders_from_workflow_relative_path ... ok
[INFO] [stdout] test template::jinja::tests::render_with_default_envs ... ok
[INFO] [stdout] test template::jinja::tests::render_with_non_serializable_value ... ok
[INFO] [stdout] test template::jinja::tests::render_with_passed_context ... ok
[INFO] [stdout] test template::jinja::tests::render_with_unknown_variable_errors ... ok
[INFO] [stdout] test shell::command_ext::tests::missing_program_is_spawn_error ... ok
[INFO] [stdout] test utils::paths::tests::absolute_is_untouched ... ok
[INFO] [stdout] test utils::paths::tests::test_canonicalize ... ok
[INFO] [stdout] test utils::paths::tests::no_var_expansion ... ok
[INFO] [stdout] test utils::paths::tests::tilde_inside_the_path_is_literal ... ok
[INFO] [stdout] test utils::paths::tests::tilde_alone_expands_to_home ... ok
[INFO] [stdout] test utils::paths::tests::relative_joins_onto_workflow_dir ... ok
[INFO] [stdout] test shell::command_ext::tests::run_stream_cancel_returns_cancelled ... ok
[INFO] [stdout] test workflow::builder::tests::workflow_builder_applies_fluent_overrides ... ok
[INFO] [stdout] test session::tests::malformed_jsonl_writes_error_event_and_fails_session ... ok
[INFO] [stdout] test shell::command_ext::tests::stdin_is_forwarded ... ok
[INFO] [stdout] test workflow::builder::tests::workflow_builder_starts_without_test_fixture_data ... ok
[INFO] [stdout] test session::tests::inline_prompt_renders_issue_variables_and_prompt_commands ... ok
[INFO] [stdout] test workflow::loader::tests::load_rejects_directory_path_after_canonicalization ... FAILED
[INFO] [stdout] test session::tests::observation_events_write_jsonl_without_snapshot_updates ... ok
[INFO] [stdout] test workflow::builder::tests::workflow_root_resolution ... ok
[INFO] [stdout] test workflow::builder::tests::workflow_without_workspace_root_defaults_to_home_vik_and_workflow_namespace ... ok
[INFO] [stdout] test workflow::builder::tests::workflow_builder_inline_stage_uses_map_key_as_stage_name ... ok
[INFO] [stdout] test workspace::tests::issue_workdir_nests_under_issues_dir ... ok
[INFO] [stdout] test workflow::loader::tests::load_from_str_preserves_virtual_path_and_parses_schema ... ok
[INFO] [stdout] test workspace::tests::ensure_root_creates_only_workspace_root ... ok
[INFO] [stdout] test workspace::tests::creates_when_parent_exists ... ok
[INFO] [stdout] test workflow::loader::tests::load_from_str_uses_virtual_path_for_yaml_errors_without_path ... ok
[INFO] [stdout] test utils::paths::tests::tilde_slash_expands_to_home_subpath ... ok
[INFO] [stdout] test template::prompt::tests::nonzero_prompt_command_returns_template_error ... ok
[INFO] [stdout] test workspace::tests::fails_when_target_is_a_file ... ok
[INFO] [stdout] test workspace::tests::noop_when_already_a_directory ... ok
[INFO] [stdout] test workspace::tests::root_accessor_returns_input ... ok
[INFO] [stdout] test workspace::tests::service_dir_and_state_file_live_under_root ... ok
[INFO] [stdout] test workflow::loader::tests::load_canonicalizes_relative_disk_path_before_reading ... FAILED
[INFO] [stdout] test workspace::tests::issue_sessions_dir_nests_issue_id_under_sessions ... ok
[INFO] [stdout] test workspace::tests::issues_dir_lives_under_root_without_workflow_namespace_by_default ... ok
[INFO] [stdout] test workspace::tests::logs_and_sessions_dirs_live_under_root ... ok
[INFO] [stdout] test workspace::tests::memoized_accessors_return_stable_address_across_calls ... ok
[INFO] [stdout] test template::prompt::tests::renders_jinja_before_executing_prompt_command ... ok
[INFO] [stdout] test template::prompt::tests::executes_all_prompt_commands_and_keeps_output_order ... ok
[INFO] [stdout] test shell::command_ext::tests::wait_after_exit_uses_background_status ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- hooks::tests::unconfigured_hook_log_omits_phase_field stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'hooks::tests::unconfigured_hook_log_omits_phase_field' (1962) panicked at src/hooks/mod.rs:350:5:
[INFO] [stdout] assertion `left == right` failed
[INFO] [stdout]   left: Null
[INFO] [stdout]  right: "before_issue_stage_run"
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e5fb0ca7bc1 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5e5fb0cc174a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5e5fb0cacf0c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5e5fb0c80226 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5e5fb0c9e259 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5e5fb0a1ecd0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5e5fb0c9e582 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5e5fb0c802d2 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5e5fb0c78589 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5e5fb0c8116d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5e5fb0cc1f2c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5e5fb0cc1e43 - core[df12db4294e9bfd3]::panicking::assert_failed_inner
[INFO] [stdout]   12:     0x5e5fb0999ef3 - core[df12db4294e9bfd3]::panicking::assert_failed::<serde_json[25bbe53c2e0bb17d]::value::Value, &str>
[INFO] [stdout]   13:     0x5e5fb09d5a8e - vik[ab4495c7a8552823]::hooks::tests::unconfigured_hook_log_omits_phase_field
[INFO] [stdout]   14:     0x5e5fb08f5db9 - <vik[ab4495c7a8552823]::hooks::tests::unconfigured_hook_log_omits_phase_field::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   15:     0x5e5fb0a11fbb - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   16:     0x5e5fb0a1f625 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   17:     0x5e5fb0a18ee4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   18:     0x5e5fb0a22782 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   19:     0x5e5fb0ca6bd9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   20:     0x77507361cdfa - <unknown>
[INFO] [stdout]   21:     0x7750736b03d4 - clone
[INFO] [stdout]   22:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- workflow::loader::tests::load_rejects_directory_path_after_canonicalization stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'workflow::loader::tests::load_rejects_directory_path_after_canonicalization' (2065) panicked at src/workflow/loader.rs:234:8:
[INFO] [stdout] tempdir: Custom { kind: ReadOnlyFilesystem, error: PathError { path: "/opt/rustwide/workdir/.workflow-loader-SB8Fhx", err: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" } } }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e5fb0ca7bc1 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5e5fb0cc174a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5e5fb0cacf0c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5e5fb0c80226 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5e5fb0c9e259 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5e5fb0a1ecd0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5e5fb0c9e582 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5e5fb0c802d2 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5e5fb0c78589 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5e5fb0c8116d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5e5fb0cc1f2c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5e5fb0cc1d02 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5e5fb09dbdf7 - vik[ab4495c7a8552823]::workflow::loader::tests::load_rejects_directory_path_after_canonicalization
[INFO] [stdout]   13:     0x5e5fb08fa0e9 - <vik[ab4495c7a8552823]::workflow::loader::tests::load_rejects_directory_path_after_canonicalization::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5e5fb0a11fbb - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   15:     0x5e5fb0a1f625 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5e5fb0a18ee4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5e5fb0a22782 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   18:     0x5e5fb0ca6bd9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x77507361cdfa - <unknown>
[INFO] [stdout]   20:     0x7750736b03d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- workflow::loader::tests::load_canonicalizes_relative_disk_path_before_reading stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'workflow::loader::tests::load_canonicalizes_relative_disk_path_before_reading' (2062) panicked at src/workflow/loader.rs:209:8:
[INFO] [stdout] tempdir: Custom { kind: ReadOnlyFilesystem, error: PathError { path: "/opt/rustwide/workdir/.workflow-loader-DAzP7U", err: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" } } }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e5fb0ca7bc1 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5e5fb0cc174a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5e5fb0cacf0c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5e5fb0c80226 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5e5fb0c9e259 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5e5fb0a1ecd0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5e5fb0c9e582 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5e5fb0c802d2 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5e5fb0c78589 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5e5fb0c8116d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5e5fb0cc1f2c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5e5fb0cc1d02 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5e5fb09dc512 - vik[ab4495c7a8552823]::workflow::loader::tests::load_canonicalizes_relative_disk_path_before_reading
[INFO] [stdout]   13:     0x5e5fb08fa109 - <vik[ab4495c7a8552823]::workflow::loader::tests::load_canonicalizes_relative_disk_path_before_reading::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x5e5fb0a11fbb - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   15:     0x5e5fb0a1f625 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   16:     0x5e5fb0a18ee4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x5e5fb0a22782 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   18:     0x5e5fb0ca6bd9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x77507361cdfa - <unknown>
[INFO] [stdout]   20:     0x7750736b03d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     hooks::tests::unconfigured_hook_log_omits_phase_field
[INFO] [stdout]     workflow::loader::tests::load_canonicalizes_relative_disk_path_before_reading
[INFO] [stdout]     workflow::loader::tests::load_rejects_directory_path_after_canonicalization
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 167 passed; 3 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.13s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--bin vik`
[INFO] running `Command { std: "docker" "inspect" "9e928f00a45d3a8744a0b84066cce39a752cbbd89b5c48d63bd2287407525c3a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9e928f00a45d3a8744a0b84066cce39a752cbbd89b5c48d63bd2287407525c3a", kill_on_drop: false }`
[INFO] [stdout] 9e928f00a45d3a8744a0b84066cce39a752cbbd89b5c48d63bd2287407525c3a
