[INFO] fetching crate wcode-cli 0.3.4...
[INFO] testing wcode-cli-0.3.4 against 1.100.0-beta.1 for beta-1.100-2
[INFO] extracting crate wcode-cli 0.3.4 into /workspace/builds/worker-4-tc2/source
[INFO] started tweaking crates.io crate wcode-cli 0.3.4
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate wcode-cli 0.3.4
[INFO] tweaked toml for crates.io crate wcode-cli 0.3.4 written to /workspace/builds/worker-4-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate wcode-cli 0.3.4 on toolchain 1.100.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate wcode-cli 0.3.4 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.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/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:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] d647d13e7a155a9c30b6600892f17d4438f5cf8bad835fedba452db32d0baa77
[INFO] running `Command { std: "docker" "start" "d647d13e7a155a9c30b6600892f17d4438f5cf8bad835fedba452db32d0baa77", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d647d13e7a155a9c30b6600892f17d4438f5cf8bad835fedba452db32d0baa77", 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" "d647d13e7a155a9c30b6600892f17d4438f5cf8bad835fedba452db32d0baa77" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d647d13e7a155a9c30b6600892f17d4438f5cf8bad835fedba452db32d0baa77", 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" "d647d13e7a155a9c30b6600892f17d4438f5cf8bad835fedba452db32d0baa77" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v3.0.5
[INFO] [stderr]    Compiling smallvec v1.16.0
[INFO] [stderr]    Compiling find-msvc-tools v0.1.12
[INFO] [stderr]    Compiling serde_core v1.0.229
[INFO] [stderr]    Compiling mio v1.2.3
[INFO] [stderr]    Compiling futures-channel v0.3.34
[INFO] [stderr]    Compiling futures-task v0.3.34
[INFO] [stderr]    Compiling aws-lc-rs v1.18.1
[INFO] [stderr]    Compiling indexmap v2.14.2
[INFO] [stderr]    Compiling unicase v2.9.0
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling ref-cast v1.0.27
[INFO] [stderr]    Compiling strum_macros v0.28.0
[INFO] [stderr]    Compiling aho-corasick v1.1.5
[INFO] [stderr]    Compiling powerfmt v0.2.0
[INFO] [stderr]    Compiling time-core v0.1.9
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling cc v1.4.5
[INFO] [stderr]    Compiling deranged v0.5.8
[INFO] [stderr]    Compiling num-conv v0.2.2
[INFO] [stderr]    Compiling minimal-lexical v0.2.1
[INFO] [stderr]    Compiling mime_guess v2.0.5
[INFO] [stderr]    Compiling num_threads v0.1.7
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling lru v0.18.4
[INFO] [stderr]    Compiling critical-section v1.2.0
[INFO] [stderr]    Compiling dyn-clone v1.0.20
[INFO] [stderr]    Compiling derive_more-impl v2.1.1
[INFO] [stderr]    Compiling as-any v0.3.2
[INFO] [stderr]    Compiling futures-timer v3.0.4
[INFO] [stderr]    Compiling nom v7.1.3
[INFO] [stderr]    Compiling glob v0.3.4
[INFO] [stderr]    Compiling crc32fast v1.5.1
[INFO] [stderr]    Compiling fastrand v2.5.0
[INFO] [stderr]    Compiling crossbeam-utils v0.8.22
[INFO] [stderr]    Compiling signal-hook-mio v0.2.5
[INFO] [stderr]    Compiling uuid v1.26.0
[INFO] [stderr]    Compiling ordered-float v5.5.0
[INFO] [stderr]    Compiling quick-xml v0.42.0
[INFO] [stderr]    Compiling pulldown-cmark v0.13.4
[INFO] [stderr]    Compiling base64 v0.23.1
[INFO] [stderr]    Compiling linked-hash-map v0.5.6
[INFO] [stderr]    Compiling flate2 v1.1.10
[INFO] [stderr]    Compiling derive_more v2.1.1
[INFO] [stderr]    Compiling bstr v1.13.1
[INFO] [stderr]    Compiling crossterm v0.29.0
[INFO] [stderr]    Compiling yaml-rust v0.4.5
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.20
[INFO] [stderr]    Compiling option-ext v0.2.0
[INFO] [stderr]    Compiling cmake v0.1.58
[INFO] [stderr]    Compiling regex-automata v0.4.18
[INFO] [stderr]    Compiling winnow v1.0.4
[INFO] [stderr]    Compiling crossbeam-deque v0.8.7
[INFO] [stderr]    Compiling dirs-sys v0.5.0
[INFO] [stderr]    Compiling toml_writer v1.1.2+spec-1.1.0
[INFO] [stderr]    Compiling toml_parser v1.1.3+spec-1.1.0
[INFO] [stderr]    Compiling winnow v0.7.15
[INFO] [stderr]    Compiling time v0.3.55
[INFO] [stderr]    Compiling unsafe-libyaml v0.2.11
[INFO] [stderr]    Compiling dirs v6.0.0
[INFO] [stderr]    Compiling strum v0.28.0
[INFO] [stderr]    Compiling aws-lc-sys v0.45.0
[INFO] [stderr]    Compiling eventsource-stream v0.2.3
[INFO] [stderr]    Compiling serde_spanned v1.1.1
[INFO] [stderr]    Compiling toml_datetime v0.7.5+spec-1.1.0
[INFO] [stderr]    Compiling toml v0.9.12+spec-1.1.0
[INFO] [stderr]    Compiling fancy-regex v0.16.2
[INFO] [stderr]    Compiling globset v0.4.20
[INFO] [stderr]    Compiling regex v1.13.1
[INFO] [stderr]    Compiling darling_core v0.24.1
[INFO] [stderr]    Compiling serde_derive_internals v0.30.0
[INFO] [stderr]    Compiling ignore v0.4.33
[INFO] [stderr]    Compiling zerovec-derive v0.11.6
[INFO] [stderr]    Compiling displaydoc v0.2.7
[INFO] [stderr]    Compiling tokio-macros v2.7.2
[INFO] [stderr]    Compiling futures-macro v0.3.34
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling thiserror-impl v2.0.20
[INFO] [stderr]    Compiling ref-cast-impl v1.0.27
[INFO] [stderr]    Compiling schemars_derive v1.2.2
[INFO] [stderr]    Compiling async-trait v0.1.92
[INFO] [stderr]    Compiling tokio v1.53.1
[INFO] [stderr]    Compiling zerotrie v0.2.5
[INFO] [stderr]    Compiling futures-util v0.3.34
[INFO] [stderr]    Compiling zerovec v0.11.8
[INFO] [stderr]    Compiling thiserror v2.0.20
[INFO] [stderr]    Compiling kasuari v0.4.12
[INFO] [stderr]    Compiling ratatui-core v0.1.2
[INFO] [stderr]    Compiling tinystr v0.8.4
[INFO] [stderr]    Compiling potential_utf v0.1.6
[INFO] [stderr]    Compiling icu_locale_core v2.3.0
[INFO] [stderr]    Compiling icu_collections v2.3.0
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling darling_macro v0.24.1
[INFO] [stderr]    Compiling darling v0.24.1
[INFO] [stderr]    Compiling instability v0.3.13
[INFO] [stderr]    Compiling schemars v1.2.2
[INFO] [stderr]    Compiling icu_provider v2.3.1
[INFO] [stderr]    Compiling chrono v0.4.45
[INFO] [stderr]    Compiling plist v1.10.1
[INFO] [stderr]    Compiling bincode v1.3.3
[INFO] [stderr]    Compiling serde_yaml_ng v0.10.0
[INFO] [stderr]    Compiling icu_normalizer v2.3.0
[INFO] [stderr]    Compiling icu_properties v2.3.0
[INFO] [stderr]    Compiling ratatui-widgets v0.3.2
[INFO] [stderr]    Compiling ratatui-crossterm v0.1.2
[INFO] [stderr]    Compiling futures-executor v0.3.34
[INFO] [stderr]    Compiling futures v0.3.34
[INFO] [stderr]    Compiling tracing-futures v0.2.5
[INFO] [stderr]    Compiling syntect v5.3.0
[INFO] [stderr]    Compiling idna_adapter v1.2.2
[INFO] [stderr]    Compiling idna v1.1.0
[INFO] [stderr]    Compiling url v2.5.8
[INFO] [stderr]    Compiling ratatui-macros v0.7.2
[INFO] [stderr]    Compiling ratatui v0.30.2
[INFO] [stderr]    Compiling tokio-util v0.7.19
[INFO] [stderr]    Compiling tower v0.5.3
[INFO] [stderr]    Compiling tower-http v0.6.11
[INFO] [stderr]    Compiling h2 v0.4.19
[INFO] [stderr]    Compiling hyper v1.11.1
[INFO] [stderr]    Compiling rustls v0.23.43
[INFO] [stderr]    Compiling hyper-util v0.1.20
[INFO] [stderr]    Compiling rustls-webpki v0.103.15
[INFO] [stderr]    Compiling tokio-rustls v0.26.5
[INFO] [stderr]    Compiling rustls-platform-verifier v0.7.0
[INFO] [stderr]    Compiling hyper-rustls v0.27.9
[INFO] [stderr]    Compiling reqwest v0.13.4
[INFO] [stderr]    Compiling rig-core v0.42.0
[INFO] [stderr]    Compiling rig v0.42.0
[INFO] [stderr]    Compiling wcode-harness v0.3.4
[INFO] [stderr]    Compiling wcode-protocol v0.3.4
[INFO] [stderr]    Compiling wcode-tui v0.3.4
[INFO] [stderr]    Compiling wcode-cli v0.3.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 2m 22s
[INFO] running `Command { std: "docker" "inspect" "d647d13e7a155a9c30b6600892f17d4438f5cf8bad835fedba452db32d0baa77", 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" "d647d13e7a155a9c30b6600892f17d4438f5cf8bad835fedba452db32d0baa77" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling tokio v1.53.1
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling crossterm v0.29.0
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling ratatui-crossterm v0.1.2
[INFO] [stderr]    Compiling ratatui v0.30.2
[INFO] [stderr]    Compiling tokio-util v0.7.19
[INFO] [stderr]    Compiling tower v0.5.3
[INFO] [stderr]    Compiling tokio-rustls v0.26.5
[INFO] [stderr]    Compiling tower-http v0.6.11
[INFO] [stderr]    Compiling h2 v0.4.19
[INFO] [stderr]    Compiling hyper v1.11.1
[INFO] [stderr]    Compiling hyper-util v0.1.20
[INFO] [stderr]    Compiling hyper-rustls v0.27.9
[INFO] [stderr]    Compiling reqwest v0.13.4
[INFO] [stderr]    Compiling rig-core v0.42.0
[INFO] [stderr]    Compiling rig v0.42.0
[INFO] [stderr]    Compiling wcode-harness v0.3.4
[INFO] [stderr]    Compiling wcode-protocol v0.3.4
[INFO] [stderr]    Compiling wcode-tui v0.3.4
[INFO] [stderr]    Compiling wcode-cli v0.3.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1m 26s
[INFO] running `Command { std: "docker" "inspect" "d647d13e7a155a9c30b6600892f17d4438f5cf8bad835fedba452db32d0baa77", 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" "d647d13e7a155a9c30b6600892f17d4438f5cf8bad835fedba452db32d0baa77" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.87s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/build/wcode-cli/861d33fbab24b0b7/out/wcode-861d33fbab24b0b7)
[INFO] [stdout] 
[INFO] [stdout] running 485 tests
[INFO] [stdout] test agent_files::tests::absent_tools_is_none_and_empty_is_some_empty ... ok
[INFO] [stdout] test agent_files::tests::empty_body_falls_back_to_description ... ok
[INFO] [stdout] test agent_files::tests::missing_name_is_skipped_with_none ... ok
[INFO] [stdout] test agent_files::tests::parses_model_effort_and_read_only ... ok
[INFO] [stdout] test agent_files::tests::parses_name_tools_string_and_list ... ok
[INFO] [stdout] test agent_files::tests::unknown_keys_are_ignored ... ok
[INFO] [stdout] test agent_files::tests::same_name_within_one_dir_keeps_the_first ... ok
[INFO] [stdout] test agent_files::tests::unparseable_yaml_is_skipped_with_none ... ok
[INFO] [stdout] test agent_files::tests::global_scan_is_skipped_when_home_is_none ... ok
[INFO] [stdout] test agents::tests::a_served_worker_reports_to_its_owner ... ok
[INFO] [stdout] test agent_files::tests::body_becomes_role ... ok
[INFO] [stdout] test agent_files::tests::project_md_beats_global_md_with_the_same_name ... ok
[INFO] [stdout] test agents::tests::a_worker_reports_to_its_orchestrator ... ok
[INFO] [stdout] test agents::tests::a_mapped_model_adapts_the_worker_provider ... ok
[INFO] [stdout] test agents::tests::a_worker_auto_reports_when_its_run_ends ... ok
[INFO] [stdout] test agents::tests::a_spawned_worker_is_a_live_session ... ok
[INFO] [stdout] test agents::tests::phonebook_resolves_names_and_lists_them_sorted ... ok
[INFO] [stdout] test agents::tests::a_worker_reports_a_failed_run_to_its_orchestrator ... ok
[INFO] [stdout] test agents::tests::a_tool_allow_list_keeps_only_those_tools_plus_message ... ok
[INFO] [stdout] test agents::tests::a_role_is_appended_after_the_identity_blurb ... ok
[INFO] [stdout] test agents::tests::a_worker_gets_its_own_session_id_not_the_roots ... ok
[INFO] [stdout] test agents::tests::an_explicit_spec_provider_wins_over_the_model_profile ... ok
[INFO] [stdout] test agents::tests::a_worker_reports_a_session_error_to_its_orchestrator ... ok
[INFO] [stdout] test agents::tests::a_model_override_changes_only_the_model ... ok
[INFO] [stdout] test agents::tests::message_in_the_allow_list_is_accepted_and_not_duplicated ... ok
[INFO] [stdout] test config::compaction_cfg_tests::absent_table_keeps_harness_defaults ... ok
[INFO] [stdout] test config::compaction_cfg_tests::an_absent_theme_table_is_the_default_overlay ... ok
[INFO] [stdout] test config::compaction_cfg_tests::an_unknown_theme_color_is_a_config_error ... ok
[INFO] [stdout] test config::compaction_cfg_tests::an_unknown_theme_role_is_a_config_error ... ok
[INFO] [stdout] test agents::tests::an_empty_tool_list_keeps_only_message ... ok
[INFO] [stdout] test agents::tests::a_default_name_skips_an_explicitly_taken_id ... ok
[INFO] [stdout] test config::compaction_cfg_tests::env_beats_toml_for_compaction ... ok
[INFO] [stdout] test config::compaction_cfg_tests::invalid_compaction_env_is_config_error_naming_the_field ... ok
[INFO] [stdout] test config::compaction_cfg_tests::retry_stall_env_beats_toml_and_zero_disables ... ok
[INFO] [stdout] test config::compaction_cfg_tests::invalid_retry_stall_env_is_config_error_naming_the_field ... ok
[INFO] [stdout] test config::compaction_cfg_tests::theme_table_with_named_and_hex_colors_parses ... ok
[INFO] [stdout] test agents::tests::a_duplicate_explicit_name_is_rejected ... ok
[INFO] [stdout] test config::compaction_cfg_tests::toml_sets_individual_fields ... ok
[INFO] [stdout] test config::endpoint_detect_tests::a_pinned_model_base_is_never_reported_implicit ... ok
[INFO] [stdout] test config::endpoint_detect_tests::candidates_are_ordered_and_deduped ... ok
[INFO] [stdout] test agents::tests::the_task_tool_is_root_only ... ok
[INFO] [stdout] test config::endpoint_detect_tests::detect_timeout_is_half_a_second ... ok
[INFO] [stdout] test config::endpoint_detect_tests::ollama_host_is_normalized_to_v1 ... ok
[INFO] [stdout] test config::endpoint_detect_tests::provenance_flags_win_over_env ... ok
[INFO] [stdout] test config::compaction_cfg_tests::toml_retry_stall_timeouts_parse_into_the_policy ... ok
[INFO] [stdout] test config::endpoint_detect_tests::provenance_records_env_over_toml ... ok
[INFO] [stdout] test config::endpoint_detect_tests::summary_names_the_implicit_openai_default ... ok
[INFO] [stdout] test config::endpoint_detect_tests::provenance_records_toml_and_default ... ok
[INFO] [stdout] test config::instructions_cfg_tests::env_instructions_overrides_file ... ok
[INFO] [stdout] test config::tests::a_models_profile_absent_or_empty_endpoint_inherits ... ok
[INFO] [stdout] test config::tests::a_missing_overlay_is_a_hard_error ... ok
[INFO] [stdout] test config::tests::a_missing_auto_overlay_is_skipped_silently ... ok
[INFO] [stdout] test config::tests::a_models_profile_parses_and_resolves ... ok
[INFO] [stdout] test config::tests::a_models_profile_beats_the_flag_folded_into_the_config ... ok
[INFO] [stdout] test config::tests::a_models_profile_bad_endpoint_fails_at_load_naming_the_value ... ok
[INFO] [stdout] test config::tests::auto_overlays_fold_in_order_with_the_last_writer_winning ... ok
[INFO] [stdout] test config::instructions_cfg_tests::mode_defaults_to_discovery_and_honors_off_and_override ... ok
[INFO] [stdout] test agents::tests::spawn_emits_a_surface_spec_on_success_only ... ok
[INFO] [stdout] test config::tests::a_missing_explicit_overlay_beside_auto_is_still_a_hard_error ... ok
[INFO] [stdout] test config::tests::endpoint_env_beats_toml ... ok
[INFO] [stdout] test config::tests::endpoint_rejects_unknown_value ... ok
[INFO] [stdout] test config::tests::effort_defaults_to_none ... ok
[INFO] [stdout] test config::tests::effort_env_beats_toml_and_flows_to_llm_opts ... ok
[INFO] [stdout] test config::tests::hooks_default_to_auto_rtk ... ok
[INFO] [stdout] test config::tests::load_merges_an_overlay_over_the_global_file ... ok
[INFO] [stdout] test config::tests::invalid_rtk_env_is_config_error ... ok
[INFO] [stdout] test config::tests::invalid_tools_env_is_config_error ... ok
[INFO] [stdout] test agents::tests::spawn_registers_the_worker_in_the_phonebook ... ok
[INFO] [stdout] test config::tests::merge_env_overrides_file ... ok
[INFO] [stdout] test config::tests::missing_model_rescue_carries_the_post_fold_file ... ok
[INFO] [stdout] test config::tests::missing_model_rescue_carries_the_overlaid_file ... ok
[INFO] [stdout] test config::tests::nameless_team_member_fails_to_parse ... ok
[INFO] [stdout] test config::tests::node_title_resolves_and_falls_back_to_id ... ok
[INFO] [stdout] test config::tests::overlay_deep_merge_scalars_tables_and_arrays ... ok
[INFO] [stdout] test config::tests::orchestrator_guidelines_parse_and_pass_through ... ok
[INFO] [stdout] test config::tests::overlay_replaces_arrays_wholesale ... ok
[INFO] [stdout] test config::tests::a_valid_workflow_is_carried_through ... ok
[INFO] [stdout] test config::tests::duplicate_team_names_are_a_config_error ... ok
[INFO] [stdout] test config::tests::endpoint_parses_chat_and_responses ... ok
[INFO] [stdout] test config::tests::merge_passes_team_through_and_absent_is_empty ... ok
[INFO] [stdout] test config::tests::overlay_replaces_the_team_array_wholesale ... ok
[INFO] [stdout] test config::tests::rtk_env_beats_toml ... ok
[INFO] [stdout] test config::tests::merge_missing_model_is_typed_error ... ok
[INFO] [stdout] test config::tests::toml_hooks_accept_bool_and_string_rtk ... ok
[INFO] [stdout] test config::tests::substitute_task_replaces_every_placeholder ... ok
[INFO] [stdout] test config::tests::toml_round_trips_a_title_with_the_placeholder ... ok
[INFO] [stdout] test config::tests::toml_team_parses_members ... ok
[INFO] [stdout] test config::tests::team_toml_overrides_config_toml_in_one_fold ... ok
[INFO] [stdout] test config::tests::toml_tools_enable_grep_and_find ... ok
[INFO] [stdout] test config::tests::uses_task_detects_a_title_only ... ok
[INFO] [stdout] test agents::tests::a_default_spec_is_the_full_inherited_worker ... ok
[INFO] [stdout] test config::tests::tools_env_beats_toml ... ok
[INFO] [stdout] test config::tests::toml_workflow_parses_nodes ... ok
[INFO] [stdout] test config::tests::tools_default_to_off ... ok
[INFO] [stdout] test frontmatter::tests::frontmatter_returns_only_the_yaml ... ok
[INFO] [stdout] test config::workspace_cfg_tests::toml_turns_digest_cas_off_and_on ... ok
[INFO] [stdout] test frontmatter::tests::split_errors_when_unterminated ... ok
[INFO] [stdout] test config::tests::toml_invalid_rtk_fails_parse ... ok
[INFO] [stdout] test config::tests::workflow_rejects_a_bad_node ... ok
[INFO] [stdout] test config::tests::workflow_rejects_an_empty_workflow ... ok
[INFO] [stdout] test config::workspace_cfg_tests::digest_cas_defaults_on ... ok
[INFO] [stdout] test config::tests::workflow_rejects_a_bad_graph ... ok
[INFO] [stdout] test frontmatter::tests::split_accepts_crlf_opening_and_terminator ... ok
[INFO] [stdout] test frontmatter::tests::split_errors_without_a_leading_delimiter ... ok
[INFO] [stdout] test agents::tests::a_provider_override_changes_only_the_provider ... ok
[INFO] [stdout] test frontmatter::tests::split_strips_a_leading_bom ... ok
[INFO] [stdout] test frontmatter::tests::split_returns_yaml_and_body ... ok
[INFO] [stdout] test frontmatter::tests::split_matches_the_old_substring_terminator_rule ... ok
[INFO] [stdout] test instructions::tests::render_marks_scope_and_path ... ok
[INFO] [stdout] test instructions::tests::candidate_priority_first_hit_wins ... ok
[INFO] [stdout] test instructions::tests::dedups_a_file_seen_twice ... ok
[INFO] [stdout] test instructions_flag_tests::parse_no_instructions_flag ... ok
[INFO] [stdout] test instructions::tests::truncates_large_files ... ok
[INFO] [stdout] test instructions::tests::explicit_override_loads_only_that_file ... ok
[INFO] [stdout] test instructions::tests::off_loads_nothing ... ok
[INFO] [stdout] test instructions::tests::discovers_ancestors_root_first_nearest_last ... ok
[INFO] [stdout] test repl::tests::list_sessions_newest_first ... ok
[INFO] [stdout] test repl::tests::new_session_args_has_no_session_flags_but_keeps_launch_opts ... ok
[INFO] [stdout] test instructions::tests::stops_at_the_repo_root ... ok
[INFO] [stdout] test repl::tests::parse_command_table ... ok
[INFO] [stdout] test repl::tests::print_events_caches_the_latest_todo_event ... ok
[INFO] [stdout] test repl::tests::printer_handles_interleaved_blocks ... ok
[INFO] [stdout] test repl::tests::printer_ignores_non_assistant_and_tool_calls ... ok
[INFO] [stdout] test repl::tests::printer_mid_line_tracks_text_only ... ok
[INFO] [stdout] test repl::tests::printer_reset_clears_thinking_replacement_state ... ok
[INFO] [stdout] test repl::system_prompt_tests::appends_project_instructions_and_omits_when_empty ... ok
[INFO] [stdout] test repl::tests::printer_diffs_text_deltas ... ok
[INFO] [stdout] test repl::tests::printer_reset_restarts_diff ... ok
[INFO] [stdout] test repl::tests::printer_splits_thinking_from_text ... ok
[INFO] [stdout] test config::tests::unknown_braces_are_left_literal ... ok
[INFO] [stdout] test repl::tests::printer_superset_restate_is_plain_append ... ok
[INFO] [stdout] test repl::tests::printer_thinking_delta_resumes_from_replaced_text ... ok
[INFO] [stdout] test repl::tests::relaunch_line_prefixes_the_program_and_quotes_unsafe_args ... ok
[INFO] [stdout] test repl::tests::reload_args_forwards_agents_only_when_set ... ok
[INFO] [stdout] test repl::tests::reload_args_forwards_no_project_config_only_when_set ... ok
[INFO] [stdout] test repl::tests::reload_args_forwards_owner_and_name_when_set ... ok
[INFO] [stdout] test repl::tests::reload_args_forwards_config_overlay_when_set ... ok
[INFO] [stdout] test repl::tests::reload_args_resume_and_forward_opts ... ok
[INFO] [stdout] test repl::tests::reload_args_no_session_and_defaults ... ok
[INFO] [stdout] test repl::tests::shell_quote_escapes_only_when_needed ... ok
[INFO] [stdout] test repl::tests::skill_turn_frames_the_body_and_appends_args ... ok
[INFO] [stdout] test repl::tests::system_prompt_names_only_registered_inspect_tools ... ok
[INFO] [stdout] test repl::tests::system_prompt_renders_the_team_block_only_with_a_team ... ok
[INFO] [stdout] test repl::tests::tool_note_first_line_truncated ... ok
[INFO] [stdout] test rtk::tests::preference_defaults_to_auto ... ok
[INFO] [stdout] test rtk::tests::preference_deserialization_rejects_garbage ... ok
[INFO] [stdout] test repl::tests::system_prompt_renders_guidelines_only_when_non_empty ... ok
[INFO] [stdout] test rtk::tests::preference_deserializes_string_forms ... ok
[INFO] [stdout] test rtk::tests::preference_deserializes_boolean ... ok
[INFO] [stdout] test repl::tests::reload_args_forwards_the_launch_base_not_the_settled_provider ... ok
[INFO] [stdout] test rtk::tests::transform_off_leaves_command_untouched ... ok
[INFO] [stdout] test rtk::tests::preference_rejects_unknown_value ... ok
[INFO] [stdout] test rtk::tests::preference_parses_on_off_with_synonyms ... ok
[INFO] [stdout] test repl::tests::a_ready_read_is_returned_without_a_signal ... ok
[INFO] [stdout] test rtk::tests::preference_round_trips_through_serde ... ok
[INFO] [stdout] test rtk::tests::transform_rewrites_when_rtk_present ... ok
[INFO] [stdout] test rtk::tests::transform_skips_non_bash_tools ... ok
[INFO] [stdout] test scheduler::tests::a_blocked_script_fails_without_running ... ok
[INFO] [stdout] test agents::tests::a_read_only_worker_installs_a_hook_that_refuses_edit ... ok
[INFO] [stdout] test scheduler::tests::bash_risk_hooks_refuse_a_catastrophic_script ... ok
[INFO] [stdout] test rtk::tests::transform_passes_unknown_commands_through ... ok
[INFO] [stdout] test repl::tests::printer_reports_thinking_replace_and_rerenders_full ... ok
[INFO] [stdout] test scheduler::tests::content_hydrates_title_artifacts_and_feedback ... ok
[INFO] [stdout] test scheduler::tests::cap_then_reset_resumes_and_the_plan_completes ... ok
[INFO] [stdout] test scheduler::tests::dispatch_wakes_owned_ready_nodes_only ... ok
[INFO] [stdout] test repl::tests::an_idle_ctrl_c_signal_ends_the_prompt_wait ... ok
[INFO] [stdout] test scheduler::tests::a_script_gate_rejects_then_passes ... ok
[INFO] [stdout] test scheduler::tests::escalation_content_names_the_cap ... ok
[INFO] [stdout] test scheduler::tests::a_script_work_node_completes_on_zero ... ok
[INFO] [stdout] test scheduler::tests::a_script_work_node_fails_on_nonzero ... ok
[INFO] [stdout] test session_groups::tests::create_group_lays_out_dir_and_members ... ok
[INFO] [stdout] test scheduler::tests::frontier_includes_a_script_node_but_not_an_ownerless_session ... ok
[INFO] [stdout] test session_groups::tests::group_dir_of_maps_a_group_dir_and_root_jsonl_only ... ok
[INFO] [stdout] test session_groups::tests::is_group_dir_name_accepts_millis_hex_and_rejects_the_rest ... ok
[INFO] [stdout] test session_groups::tests::create_root_and_member_sessions_roundtrip_through_open ... ok
[INFO] [stdout] test session_groups::tests::list_groups_hides_a_legacy_file_colliding_with_a_group_dir ... ok
[INFO] [stdout] test session_groups::tests::list_groups_mixes_groups_and_legacy_newest_first ... ok
[INFO] [stdout] test session_groups::tests::list_groups_survives_a_missing_session_dir ... ok
[INFO] [stdout] test session_groups::tests::load_root_extracts_model_and_effort_from_the_transcript ... ok
[INFO] [stdout] test session_groups::tests::member_id_derives_session_id_from_file_stem ... ok
[INFO] [stdout] test session_groups::tests::manifest_roundtrips_member_specs ... ok
[INFO] [stdout] test session_groups::tests::member_spec_falls_back_to_default_when_manifest_entry_missing ... ok
[INFO] [stdout] test session_groups::tests::record_member_upserts_instead_of_duplicating ... ok
[INFO] [stdout] test session_groups::tests::open_group_requires_root_jsonl_and_tolerates_missing_members ... ok
[INFO] [stdout] test session_groups::tests::scan_members_lists_only_jsonl_sorted ... ok
[INFO] [stdout] test agents::tests::spawn_worker_registers_the_name_and_rejects_bad_tools ... ok
[INFO] [stdout] test session_groups::tests::validate_member_name_rejects_slash_dotdot_and_jsonl_suffix ... ok
[INFO] [stdout] test skills::tests::explicit_roots_scan_first_and_disabled_names_are_skipped ... ok
[INFO] [stdout] test skills::tests::find_returns_the_discovered_skill ... ok
[INFO] [stdout] test skills::tests::parses_and_validates_frontmatter ... ok
[INFO] [stdout] test skills::tests::project_skills_win_over_global_and_nearest_wins ... ok
[INFO] [stdout] test agents::tests::worker_system_documents_the_report_shape ... ok
[INFO] [stdout] test skills::tests::render_uses_relative_paths_clips_and_degrades ... ok
[INFO] [stdout] test agents::tests::spawn_registers_and_owns_the_worker ... ok
[INFO] [stdout] test skills::tests::rejects_invalid_skills ... ok
[INFO] [stdout] test skills::tests::scan_stops_at_the_depth_bound ... ok
[INFO] [stdout] test skills::tests::shared_pair_prefers_agents_then_falls_back_to_claude ... ok
[INFO] [stdout] test tasks::terminal_code_tests::none_while_any_node_is_open ... ok
[INFO] [stdout] test tasks::terminal_code_tests::one_as_soon_as_a_node_fails ... ok
[INFO] [stdout] test tasks::terminal_code_tests::zero_when_all_done ... ok
[INFO] [stdout] test tasks::terminal_code_tests::rework_reopens_a_dep_and_clears_the_verdict ... ok
[INFO] [stdout] test tasks::tests::a_configured_cap_reaches_reopen ... ok
[INFO] [stdout] test tasks::tests::a_torn_tail_is_dropped ... ok
[INFO] [stdout] test tasks::tests::complete_flips_state ... ok
[INFO] [stdout] test tasks::tests::a_create_after_a_snapshot_gets_a_fresh_id ... ok
[INFO] [stdout] test tasks::tests::create_rejects_an_unknown_dep ... ok
[INFO] [stdout] test tasks::tests::create_returns_increasing_ids ... ok
[INFO] [stdout] test tasks::tests::depends_rejects_a_cycle ... ok
[INFO] [stdout] test tasks::tests::fail_sets_terminal_state_without_a_rework ... ok
[INFO] [stdout] test tasks::tests::complete_stores_the_artifact_and_respects_blocking ... ok
[INFO] [stdout] test tasks::tests::journal_round_trips ... ok
[INFO] [stdout] test tasks::tests::plan_op_and_task_serde_round_trip ... ok
[INFO] [stdout] test tasks::tests::ready_ids_tracks_the_frontier ... ok
[INFO] [stdout] test tasks::tests::reject_journals_one_line ... ok
[INFO] [stdout] test tasks::tests::reject_refuses_a_dep_less_gate ... ok
[INFO] [stdout] test scheduler::tests::a_undeliverable_node_stays_todo ... ok
[INFO] [stdout] test tasks::tests::reject_reopens_the_gated_dep_and_the_cone ... ok
[INFO] [stdout] test scheduler::tests::cap_escalates_exactly_once ... ok
[INFO] [stdout] test tasks::tests::reopen_resets_the_transitive_cone ... ok
[INFO] [stdout] test tasks::tests::reset_clears_a_failed_node ... ok
[INFO] [stdout] test tasks::tests::reopen_hits_the_cap_and_fails_terminal ... ok
[INFO] [stdout] test tasks::tests::snapshot_replaces_the_set_then_later_ops_apply ... ok
[INFO] [stdout] test tasks::tests::subscribe_sees_an_update ... ok
[INFO] [stdout] test tests::choose_tui_prefers_flags_then_terminal ... ok
[INFO] [stdout] test tasks::tests::reject_unsticks_the_gate_on_a_cap ... ok
[INFO] [stdout] test tasks::tests::reload_reconciles_a_doing_node ... ok
[INFO] [stdout] test scheduler::tests::reject_reopens_and_redispatches_the_work_node ... ok
[INFO] [stdout] test tests::detection_lands_before_to_llm_opts_and_settle_keeps_it ... ok
[INFO] [stdout] test tests::env_detect_flag_matches_truthy_values ... ok
[INFO] [stdout] test tests::instantiate_workflow_handles_a_later_authored_dependency ... ok
[INFO] [stdout] test tests::instantiate_workflow_resolves_node_titles ... ok
[INFO] [stdout] test tests::overlay_precedence_flag_beats_env ... ok
[INFO] [stdout] test tests::parse_all_flags ... ok
[INFO] [stdout] test tests::parse_config_flag ... ok
[INFO] [stdout] test tests::parse_defaults ... ok
[INFO] [stdout] test tests::parse_detect_and_dump_config_flags ... ok
[INFO] [stdout] test tests::parse_effort_flag ... ok
[INFO] [stdout] test tests::parse_endpoint_flag ... ok
[INFO] [stdout] test tests::parse_errors ... ok
[INFO] [stdout] test tests::parse_help ... ok
[INFO] [stdout] test tests::parse_list_models_flag ... ok
[INFO] [stdout] test tests::parse_no_project_config_flag ... ok
[INFO] [stdout] test agents::tests::validate_tools_rejects_spawn_and_unknown_names ... ok
[INFO] [stdout] test tests::parse_prompt ... ok
[INFO] [stdout] test tests::config_dump_never_prints_a_key_value ... ok
[INFO] [stdout] test tests::parse_resume_ignores_next_flag ... ok
[INFO] [stdout] test tests::parse_task_and_timeout ... ok
[INFO] [stdout] test agents::tests::two_default_spawns_get_distinct_ids ... ok
[INFO] [stdout] test tests::project_config_opt_out_matrix ... ok
[INFO] [stdout] test tests::parse_theme_flag ... ok
[INFO] [stdout] test tests::parse_resume_with_and_without_path ... ok
[INFO] [stdout] test tests::parse_version ... ok
[INFO] [stdout] test tests::rescue_carries_env_base_url_and_flag_model ... ok
[INFO] [stdout] test tests::rescue_carries_toml_base_url_and_api_key ... ok
[INFO] [stdout] test tests::rescue_invalid_env_override_is_error_not_panic ... ok
[INFO] [stdout] test tests::selected_model_pins_base_skips_probing ... ok
[INFO] [stdout] test tests::session_age_is_humanized ... ok
[INFO] [stdout] test tests::resolve_prefers_existing_path ... ok
[INFO] [stdout] test tests::session_label_reads_the_first_user_line_and_age ... ok
[INFO] [stdout] test tests::timeout_rejects_junk ... ok
[INFO] [stdout] test tests::truncate_chars_keeps_short_text_and_elides_long ... ok
[INFO] [stdout] test tools::anchor::digest_tests::digest_differs_on_a_single_byte_change ... ok
[INFO] [stdout] test repl::tests::build_agent_leaves_the_shared_hook_set_untouched ... ok
[INFO] [stdout] test tests::workflow_is_not_instantiated_on_resume ... ok
[INFO] [stdout] test tools::anchor::digest_tests::digest_is_deterministic_and_len_bounded ... ok
[INFO] [stdout] test tools::anchor::tests::anchors_are_raw_byte_addresses ... ok
[INFO] [stdout] test tools::anchor::digest_tests::digest_hashes_exact_bytes_no_cr_strip ... ok
[INFO] [stdout] test tools::anchor::tests::anchor_is_deterministic_and_position_independent ... ok
[INFO] [stdout] test tools::anchor::tests::anchors_do_not_move_under_insert_above ... ok
[INFO] [stdout] test tools::anchor::tests::apply_replace_mid_file_and_preserve_final_newline ... ok
[INFO] [stdout] test tools::anchor::tests::crlf_and_lf_address_identically ... ok
[INFO] [stdout] test tools::anchor::tests::degenerate_empty_is_only_byte_empty_or_lone_separator ... ok
[INFO] [stdout] test tools::anchor::tests::duplicate_lines_share_anchor_and_ranges_are_discoverable ... ok
[INFO] [stdout] test tools::anchor::tests::old_string_must_be_local_to_the_candidate ... ok
[INFO] [stdout] test tools::anchor::tests::split_lines_preserves_trailing_separator_semantics ... ok
[INFO] [stdout] test tools::ast::tests::version_probe_accepts_ast_grep_and_its_alias ... ok
[INFO] [stdout] test tools::ast::tests::version_probe_rejects_the_linux_switch_group_sg ... ok
[INFO] [stdout] test tools::anchor::tests::changed_range_reports_new_side_lines ... ok
[INFO] [stdout] test tools::ast_edit::tests::dry_run_differs_from_commit ... ok
[INFO] [stdout] test tools::ast_search::tests::available_detects_binary_on_path ... ok
[INFO] [stdout] test tools::anchor::tests::apply_replace_delete_range ... ok
[INFO] [stdout] test tools::ast_edit::tests::available_detects_binary_on_path ... ok
[INFO] [stdout] test tools::background::tests::a_finished_task_wakes_an_idle_actor ... ok
[INFO] [stdout] test scheduler::tests::empty_and_ownerless_plans_do_not_stall ... ok
[INFO] [stdout] test tools::background::tests::kill_leaves_no_orphaned_group ... ok
[INFO] [stdout] test tools::background::tests::kill_transitions_to_killed_and_is_a_noop_after_exit ... ok
[INFO] [stdout] test session_groups::tests::corrupt_mid_file_member_is_skipped_not_fatal ... ok
[INFO] [stdout] test tasks::tests::assign_sets_the_owner ... ok
[INFO] [stdout] test tests::config_dump_names_a_pinned_model_base_not_openai ... ok
[INFO] [stdout] test tests::detect_opt_in_reads_the_flag ... ok
[INFO] [stdout] test tests::task_guards_accept_a_well_formed_run ... ok
[INFO] [stdout] test tools::background::tests::shutdown_kills_a_running_group ... ok
[INFO] [stdout] test tests::task_guards_reject_misconfiguration ... ok
[INFO] [stdout] test tools::background::tests::start_then_list_shows_a_running_task ... ok
[INFO] [stdout] test tools::background::tests::shutdown_never_signals_an_exited_task ... ok
[INFO] [stdout] test tools::background::tests::two_concurrent_tasks_get_distinct_ids ... ok
[INFO] [stdout] test tools::background::tests::wait_on_a_short_task_returns_the_exit_code ... ok
[INFO] [stdout] test tools::bash::tests::echo_reports_exit_code_zero ... ok
[INFO] [stdout] test tools::bash::tests::run_command_returns_exit_code_and_output ... ok
[INFO] [stdout] test tools::background::tests::a_finished_task_mid_run_lands_as_a_follow_up ... ok
[INFO] [stdout] test tools::bash::tests::non_zero_exit_is_error ... ok
[INFO] [stdout] test tools::bash::tests::small_output_stays_inline_without_spilling ... ok
[INFO] [stdout] test tools::bash::tests::stdin_is_null_so_a_reading_child_gets_eof ... ok
[INFO] [stdout] test tools::bash::tests::streams_stderr_lines_with_live_prefix ... ok
[INFO] [stdout] test tools::bash::tests::live_updates_are_capped ... ok
[INFO] [stdout] test tools::bash::tests::sweep_stale_spills_handles_a_missing_directory_and_entries ... ok
[INFO] [stdout] test tools::bash::tests::a_no_newline_stream_is_chunked_and_never_grows_unboundedly ... ok
[INFO] [stdout] test tools::bash::tests::large_output_spills_and_points_at_the_full_file ... ok
[INFO] [stdout] test tools::diff::tests::a_changed_line_shows_context_minus_and_plus ... ok
[INFO] [stdout] test tools::diff::tests::a_new_file_is_all_additions ... ok
[INFO] [stdout] test tools::diff::tests::an_insertion_is_add_only ... ok
[INFO] [stdout] test tools::diff::tests::identical_text_has_no_diff ... ok
[INFO] [stdout] test tools::diff::tests::the_body_is_capped ... ok
[INFO] [stdout] test tools::bash::tests::stderr_spills_independently_of_stdout ... ok
[INFO] [stdout] test tools::edit::tests::ambiguous_duplicate_is_rejected_with_candidates ... ok
[INFO] [stdout] test tools::edit::tests::anchors_are_stable_across_edits_above ... ok
[INFO] [stdout] test tools::edit::tests::bad_anchor_format_is_rejected ... ok
[INFO] [stdout] test tasks::tests::the_journal_compacts_to_a_snapshot ... ok
[INFO] [stdout] test tools::edit::tests::deleting_the_last_line_echoes_a_real_region ... ok
[INFO] [stdout] test tools::background::tests::wait_aborts_on_cancel ... ok
[INFO] [stdout] test tools::edit::tests::disjoint_replace_all_ranges_still_apply ... ok
[INFO] [stdout] test session_groups::tests::torn_tail_member_transcript_is_tolerated_on_resume ... ok
[INFO] [stdout] test tools::edit::tests::overlapping_replace_all_ranges_are_rejected ... ok
[INFO] [stdout] test tools::edit::tests::matching_digest_allows_the_edit ... ok
[INFO] [stdout] test tools::edit::tests::range_whose_half_is_deleted_returns_stale ... ok
[INFO] [stdout] test tools::edit::tests::range_edit_across_adjacent_lines ... ok
[INFO] [stdout] test tools::edit::tests::replace_all_applies_to_every_match ... ok
[INFO] [stdout] test tools::edit::tests::populates_empty_file ... ok
[INFO] [stdout] test tools::edit::tests::replacement_keeps_indentation ... ok
[INFO] [stdout] test tools::edit::tests::stale_anchor_is_rejected_with_reread_hint ... ok
[INFO] [stdout] test tools::bash::tests::sweep_stale_spills_removes_old_spills_and_keeps_fresh_and_foreign_files ... ok
[INFO] [stdout] test tools::edit::tests::single_line_edit_by_anchor ... ok
[INFO] [stdout] test tools::edit::tests::stale_digest_refuses_the_edit ... ok
[INFO] [stdout] test tools::edit::tests::old_string_disambiguates_duplicate ... ok
[INFO] [stdout] test tools::bash::tests::streams_partial_output_updates ... ok
[INFO] [stdout] test tools::edits::tests::empty_batch_is_rejected ... ok
[INFO] [stdout] test tools::edit::tests::stale_from_present_shows_the_line_and_reason ... ok
[INFO] [stdout] test tools::edits::tests::disjoint_batch_applies_atomically ... ok
[INFO] [stdout] test tools::edits::tests::equivalent_paths_are_not_mixed_files ... ok
[INFO] [stdout] test tools::edits::tests::matching_digest_applies_the_batch ... ok
[INFO] [stdout] test tools::edits::tests::ambiguous_op_names_the_offending_op ... ok
[INFO] [stdout] test tools::edits::tests::stale_digest_refuses_the_batch ... ok
[INFO] [stdout] test tools::edit::tests::old_string_matches_only_nearby_context ... ok
[INFO] [stdout] test tools::edits::tests::applied_count_excludes_noop_ops ... ok
[INFO] [stdout] test tools::grep::tests::builtin_skip_dirs_apply_without_gitignore ... ok
[INFO] [stdout] test tools::edits::tests::one_stale_op_aborts_the_whole_batch ... ok
[INFO] [stdout] test tools::edits::tests::mixed_files_are_rejected ... ok
[INFO] [stdout] test tools::edits::tests::replace_all_combines_with_other_ops ... ok
[INFO] [stdout] test tools::edits::tests::overlapping_ops_are_rejected ... ok
[INFO] [stdout] test tools::find::tests::respects_gitignore ... ok
[INFO] [stdout] test tools::bash::tests::cancel_token_kills_command ... ok
[INFO] [stdout] test tools::find::tests::finds_by_glob_and_kind ... ok
[INFO] [stdout] test tools::member::tests::ask_without_text_is_an_error ... ok
[INFO] [stdout] test tools::grep::tests::greps_with_anchors_and_context ... ok
[INFO] [stdout] test tools::grep::tests::gitignore_from_a_parent_directory_applies ... ok
[INFO] [stdout] test tools::grep::tests::respects_gitignore_without_a_git_repo ... ok
[INFO] [stdout] test tools::grep::tests::gitignore_negation_re_includes_a_file ... ok
[INFO] [stdout] test tools::member::tests::live_ask_against_a_real_model ... ignored, live test; run with WCODE_BASE_URL=... (and WCODE_MODEL=...)
[INFO] [stdout] test tools::read::indentation_regression::anchored_read_keeps_indentation ... ok
[INFO] [stdout] test tools::member::tests::status_reports_state_and_last_work ... ok
[INFO] [stdout] test tools::peers::tests::listing_names_each_members_state ... ok
[INFO] [stdout] test tools::grep::tests::respoects_glob_excludes ... ok
[INFO] [stdout] test tools::member::tests::unknown_op_is_an_error ... ok
[INFO] [stdout] test tools::read::tests::empty_file_shows_insertion_anchor ... ok
[INFO] [stdout] test tools::read::tests::from_anchor_context_clamps_at_first_line ... ok
[INFO] [stdout] test tools::read::tests::from_anchor_not_found_is_stale_error ... ok
[INFO] [stdout] test tools::read::tests::anchored_read_truncates_long_lines_and_keeps_full_line_anchor ... ok
[INFO] [stdout] test tools::read::tests::from_anchor_reads_to_end_of_file ... ok
[INFO] [stdout] test tools::read::tests::from_anchor_notes_ambiguity_for_duplicates ... ok
[INFO] [stdout] test tools::read::tests::from_and_offset_conflict_is_rejected ... ok
[INFO] [stdout] test tools::read::tests::from_anchor_with_context_shows_lines_above ... ok
[INFO] [stdout] test tools::read::tests::plain_mode_keeps_old_cat_n_shape ... ok
[INFO] [stdout] test tools::read::tests::missing_file_is_error ... ok
[INFO] [stdout] test tools::read::tests::reads_with_anchors_and_paging ... ok
[INFO] [stdout] test tools::replace::tests::matching_digest_allows_the_replace ... ok
[INFO] [stdout] test tools::replace::tests::multiple_matches_fail_without_replace_all ... ok
[INFO] [stdout] test tools::replace::tests::stale_digest_refuses_the_replace ... ok
[INFO] [stdout] test tools::read::tests::truncate_line_caps_long_lines_and_passes_short ... ok
[INFO] [stdout] test tools::replace::tests::zero_matches_is_not_found_error ... ok
[INFO] [stdout] test tools::replace::tests::replace_all_replaces_every_occurrence ... ok
[INFO] [stdout] test tools::session_search::tests::an_empty_query_is_rejected ... ok
[INFO] [stdout] test tools::session_search::tests::a_malformed_non_final_line_skips_the_session_only ... ok
[INFO] [stdout] test tools::session_search::tests::a_term_with_a_quote_is_found_by_skipping_the_pre_filter ... ok
[INFO] [stdout] test tools::session_search::tests::current_scope_without_a_session_is_an_error ... ok
[INFO] [stdout] test tools::session_search::tests::current_recovers_pre_compaction_messages ... ok
[INFO] [stdout] test tools::session_search::tests::current_turns_returns_a_verbatim_ordinal_range ... ok
[INFO] [stdout] test tools::replace::tests::unique_match_replaces_once ... ok
[INFO] [stdout] test tools::session_search::tests::current_on_a_group_root_reports_the_group_id ... ok
[INFO] [stdout] test tools::session_search::tests::current_stats_reports_turn_count_and_tokens ... ok
[INFO] [stdout] test tools::session_search::tests::matches_all_requires_every_term ... ok
[INFO] [stdout] test tools::session_search::tests::limit_caps_the_sessions_reported ... ok
[INFO] [stdout] test tools::session_search::tests::more_than_one_selector_is_rejected ... ok
[INFO] [stdout] test tools::read::tests::no_limit_caps_page_and_notes_continuation ... ok
[INFO] [stdout] test tools::session_search::tests::groups_flat_and_group_and_members ... ok
[INFO] [stdout] test tools::session_search::tests::mixed_case_line_is_found_by_the_lowercased_pre_filter ... ok
[INFO] [stdout] test tools::session_search::tests::no_selector_is_an_error ... ok
[INFO] [stdout] test tools::session_search::tests::scope_all_excludes_current_unless_include_current ... ok
[INFO] [stdout] test tools::session_search::tests::terms_split_and_lowercase ... ok
[INFO] [stdout] test tools::session_search::tests::turns_and_stats_require_current_scope ... ok
[INFO] [stdout] test tools::grep::tests::max_caps_result_lines_including_context ... ok
[INFO] [stdout] test tools::session_search::tests::scope_all_excludes_a_group_whose_root_is_current ... ok
[INFO] [stdout] test tools::session_search::tests::scope_all_excludes_a_whole_group_holding_current ... ok
[INFO] [stdout] test tools::spawn::tests::a_spawn_to_an_unknown_peer_is_an_error ... ok
[INFO] [stdout] test agents::tests::a_worker_effort_override_sets_clears_or_inherits ... ok
[INFO] [stdout] test tools::member::tests::ask_returns_the_members_side_answer ... ok
[INFO] [stdout] test tools::spawn::tests::a_spawn_to_a_remote_peer_defines_and_starts_the_worker ... ok
[INFO] [stdout] test tools::spawn::tests::spawn_args_map_onto_a_worker_spec ... ok
[INFO] [stdout] test tools::task::tests::assign_accepts_a_prefixed_assignee ... ok
[INFO] [stdout] test tools::task::tests::assign_and_complete ... ok
[INFO] [stdout] test tools::task::tests::create_then_list ... ok
[INFO] [stdout] test tools::task::tests::dag_ops ... ok
[INFO] [stdout] test tools::task::tests::reject_cap_renders_failed_and_the_note ... ok
[INFO] [stdout] test tools::task::tests::render_appends_suffixes_only_when_set ... ok
[INFO] [stdout] test tools::session_search::tests::member_cap_limits_members_scanned ... ok
[INFO] [stdout] test tools::task::tests::reject_and_complete_carry_payloads ... ok
[INFO] [stdout] test tools::task::tests::unknown_op_is_an_error ... ok
[INFO] [stdout] test tools::task::tests::reset_op_clears_a_failed_node ... ok
[INFO] [stdout] test tools::tests::print_tool_definition_sizes ... ignored, diagnostic: print tool definition sizes
[INFO] [stdout] test tools::todo::tests::a_bare_call_reads_without_changing_the_list ... ok
[INFO] [stdout] test tools::todo::tests::a_write_emits_a_todo_event_on_the_sink ... ok
[INFO] [stdout] test tools::tests::normalize_collapses_dot_and_dotdot ... ok
[INFO] [stdout] test tools::todo::tests::a_bare_read_seeds_from_the_persisted_list ... ok
[INFO] [stdout] test session_groups::tests::resume_roundtrip_members_report_to_the_root ... ok
[INFO] [stdout] test tools::todo::tests::a_write_persists_a_session_entry ... ok
[INFO] [stdout] test tools::todo::tests::render_shows_each_status ... ok
[INFO] [stdout] test tools::todo::tests::blank_content_is_rejected ... ok
[INFO] [stdout] test tools::todo::tests::a_write_replaces_the_list_and_renders_it ... ok
[INFO] [stdout] test tools::todo::tests::the_seed_flag_keeps_a_cleared_list_cleared ... ok
[INFO] [stdout] test tools::webfetch::tests::caps_output_length ... ok
[INFO] [stdout] test repl::tests::lock_slot_tolerates_poisoning ... ok
[INFO] [stdout] test tools::member::tests::cancel_stops_a_running_member ... ok
[INFO] [stdout] test tools::webfetch::tests::drops_empty_links_and_overlong_targets ... ok
[INFO] [stdout] test tools::todo::tests::an_empty_list_clears_the_checklist ... ok
[INFO] [stdout] test tools::spawn::tests::an_unknown_tool_name_fails_loudly ... ok
[INFO] [stdout] test tools::webfetch::tests::keeps_short_output_intact ... ok
[INFO] [stdout] test session_groups::tests::rebuild_team_closes_registry_owners_and_names ... ok
[INFO] [stdout] test tools::tests::default_tools_omit_grep_and_find ... ok
[INFO] [stdout] test tools::tests::every_mutating_tool_is_in_the_plan_mode_denylist ... ok
[INFO] [stdout] test tools::webfetch::tests::bad_scheme_is_an_error ... ok
[INFO] [stdout] test tools::tests::default_tools_include_grep_and_find_when_enabled ... ok
[INFO] [stdout] test tools::webfetch::tests::does_not_leak_attributes_containing_angle_brackets ... ok
[INFO] [stdout] test tools::webfetch::tests::content_length_over_cap_is_rejected ... ok
[INFO] [stdout] test tools::webfetch::tests::truncation_prefers_the_last_newline ... ok
[INFO] [stdout] test tools::webfetch::tests::truncation_respects_char_boundaries ... ok
[INFO] [stdout] test tools::write::tests::a_missing_file_hashes_as_empty ... ok
[INFO] [stdout] test tools::write::tests::stale_digest_refuses_the_write ... ok
[INFO] [stdout] test tools::write::tests::creates_parent_directories ... ok
[INFO] [stdout] test verify_gate::tests::blocks_a_work_node_whose_gate_depends_elsewhere ... ok
[INFO] [stdout] test verify_gate::tests::dep_less_gate_flag_is_not_exempt ... ok
[INFO] [stdout] test verify_gate::tests::exempts_script_work_nodes ... ok
[INFO] [stdout] test tools::write::tests::matching_digest_allows_the_write ... ok
[INFO] [stdout] test verify_gate::tests::allows_after_a_gate_depends_on_the_work_node ... ok
[INFO] [stdout] test verify_gate::tests::exempts_the_gate_itself ... ok
[INFO] [stdout] test verify_gate::tests::ignores_task_ops_other_than_complete ... ok
[INFO] [stdout] test verify_gate::tests::ignores_non_task_tools ... ok
[INFO] [stdout] test verify_gate::tests::r_prime_blocks_completing_an_ungated_work_node ... ok
[INFO] [stdout] test workflow_seed_tests::seed_names_the_task_and_forbids_new_nodes ... ok
[INFO] [stdout] test workspace::chain::a_disabled_hook_injects_nothing_into_the_real_call ... ok
[INFO] [stdout] test workspace::chain::a_plain_read_arms_nothing ... ok
[INFO] [stdout] test verify_gate::tests::noop_on_unknown_id_and_empty_plan ... ok
[INFO] [stdout] test workspace::chain::read_arms_the_hook_and_the_real_write_is_cas_guarded ... ok
[INFO] [stdout] test workspace::chain::the_real_hook_set_composes_in_order ... ok
[INFO] [stdout] test workspace::tests::cache_key_is_lexically_normalized ... ok
[INFO] [stdout] test workspace::chain::read_arms_the_hook_and_the_real_edit_is_cas_guarded ... ok
[INFO] [stdout] test workspace::tests::disabled_hook_is_inert ... ok
[INFO] [stdout] test workspace::tests::failed_read_does_not_arm_the_cache ... ok
[INFO] [stdout] test workspace::tests::explicit_expected_digest_wins_over_cache ... ok
[INFO] [stdout] test workspace::tests::header_roundtrips_and_is_not_an_anchor_line ... ok
[INFO] [stdout] test workspace::tests::note_read_parses_the_header_digest ... ok
[INFO] [stdout] test workspace::tests::edits_digest_is_top_level_not_per_op ... ok
[INFO] [stdout] test workspace::tests::transform_tool_input_attaches_last_read_digest ... ok
[INFO] [stdout] test workspace::tests::stale_digest_message_names_both_digests_and_the_reread_hint ... ok
[INFO] [stdout] test tools::webfetch::tests::non_2xx_is_http_error ... ok
[INFO] [stdout] test tools::webfetch::tests::cancel_aborts_the_fetch ... ok
[INFO] [stdout] test tools::session_search::tests::session_scan_cap_limits_sessions_scanned ... ok
[INFO] [stdout] test tools::background::tests::output_is_capped_and_names_the_spill_file ... ok
[INFO] [stdout] test tools::webfetch::tests::format_matrix_routes_by_content_type ... ok
[INFO] [stdout] test tools::webfetch::tests::keeps_article_header_and_footer_content ... ok
[INFO] [stdout] test tools::webfetch::tests::success_is_framed_with_the_converted_length ... ok
[INFO] [stdout] test tools::webfetch::tests::strips_html_comments ... ok
[INFO] [stdout] test tools::webfetch::tests::strips_non_prose_elements ... ok
[INFO] [stdout] test tools::bash::tests::timeout_kills_command ... ok
[INFO] [stdout] test tools::background::tests::a_held_pipe_does_not_stall_the_push ... ok
[INFO] [stdout] test tools::bash::tests::timeout_kills_the_whole_process_group ... FAILED
[INFO] [stdout] test tools::webfetch::tests::streaming_body_over_cap_is_truncated ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- tools::bash::tests::timeout_kills_the_whole_process_group stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'tools::bash::tests::timeout_kills_the_whole_process_group' (4124) panicked at src/tools/bash.rs:697:9:
[INFO] [stdout] background grandchild (pid 4126) survived the timeout
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x624933cf7111 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x624933cf7111 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::trace_unsynchronized::<std[617be2ca0a6fd877]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x624933cf7111 - std[617be2ca0a6fd877]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x624933cf7111 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x624933d0f39a - <core[a373ad73a504971]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x624933d0f39a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    6:     0x624933cfc56c - core[a373ad73a504971]::io::write::default_write_fmt::<alloc[2e1b2a31b91974c5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:402:11
[INFO] [stdout]    7:     0x624933cfc56c - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:335:13
[INFO] [stdout]    8:     0x624933ccdff6 - <std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x624933ccdff6 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:289:27
[INFO] [stdout]   10:     0x624933cecf59 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:313:9
[INFO] [stdout]   11:     0x624932cc0f30 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   12:     0x624932cc0f30 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:137:21
[INFO] [stdout]   13:     0x624933ced282 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   14:     0x624933ced282 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:819:13
[INFO] [stdout]   15:     0x624933cce0a2 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:685:13
[INFO] [stdout]   16:     0x624933cc6929 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x624933ccf04d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:676:5
[INFO] [stdout]   18:     0x624933d0fc3c - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x624932782553 - wcode[9c48ae11f7de053c]::tools::bash::tests::timeout_kills_the_whole_process_group::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tools/bash.rs:697:9
[INFO] [stdout]   20:     0x624932b065b2 - <core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>> as core[a373ad73a504971]::future::future::Future>::poll
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/future/future.rs:133:9
[INFO] [stdout]   21:     0x624932b0662d - <core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>> as core[a373ad73a504971]::future::future::Future>::poll
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/future/future.rs:133:9
[INFO] [stdout]   22:     0x624932a01efd - <tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/scheduler/current_thread/mod.rs:830:70
[INFO] [stdout]   23:     0x624932a01e35 - tokio[7c629e9ef101a854]::task::coop::with_budget::<core[a373ad73a504971]::task::poll::Poll<()>, <tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/task/coop/mod.rs:167:5
[INFO] [stdout]   24:     0x624932a01e35 - tokio[7c629e9ef101a854]::task::coop::budget::<core[a373ad73a504971]::task::poll::Poll<()>, <tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/task/coop/mod.rs:133:5
[INFO] [stdout]   25:     0x624932a01e35 - <tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/scheduler/current_thread/mod.rs:830:25
[INFO] [stdout]   26:     0x6249329bc532 - <tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::Context>::enter::<core[a373ad73a504971]::task::poll::Poll<()>, <tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/scheduler/current_thread/mod.rs:488:19
[INFO] [stdout]   27:     0x6249329ffecd - <tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/scheduler/current_thread/mod.rs:829:44
[INFO] [stdout]   28:     0x6249329ff164 - <tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CoreGuard>::enter::<<tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}, core[a373ad73a504971]::option::Option<()>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/scheduler/current_thread/mod.rs:906:68
[INFO] [stdout]   29:     0x62493281057b - <tokio[7c629e9ef101a854]::runtime::context::scoped::Scoped<tokio[7c629e9ef101a854]::runtime::scheduler::Context>>::set::<<tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}, core[a373ad73a504971]::option::Option<()>>::{closure#0}, (alloc[2e1b2a31b91974c5]::boxed::Box<tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::Core>, core[a373ad73a504971]::option::Option<()>)>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/context/scoped.rs:40:9
[INFO] [stdout]   30:     0x624932a16269 - tokio[7c629e9ef101a854]::runtime::context::set_scheduler::<(alloc[2e1b2a31b91974c5]::boxed::Box<tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::Core>, core[a373ad73a504971]::option::Option<()>), <tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}, core[a373ad73a504971]::option::Option<()>>::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/context.rs:187:38
[INFO] [stdout]   31:     0x624932969a1f - <std[617be2ca0a6fd877]::thread::local::LocalKey<tokio[7c629e9ef101a854]::runtime::context::Context>>::try_with::<tokio[7c629e9ef101a854]::runtime::context::set_scheduler<(alloc[2e1b2a31b91974c5]::boxed::Box<tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::Core>, core[a373ad73a504971]::option::Option<()>), <tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}, core[a373ad73a504971]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[2e1b2a31b91974c5]::boxed::Box<tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::Core>, core[a373ad73a504971]::option::Option<()>)>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/local.rs:463:12
[INFO] [stdout]   32:     0x6249329695ce - <std[617be2ca0a6fd877]::thread::local::LocalKey<tokio[7c629e9ef101a854]::runtime::context::Context>>::with::<tokio[7c629e9ef101a854]::runtime::context::set_scheduler<(alloc[2e1b2a31b91974c5]::boxed::Box<tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::Core>, core[a373ad73a504971]::option::Option<()>), <tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}, core[a373ad73a504971]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[2e1b2a31b91974c5]::boxed::Box<tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::Core>, core[a373ad73a504971]::option::Option<()>)>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/local.rs:427:20
[INFO] [stdout]   33:     0x624932a1072d - tokio[7c629e9ef101a854]::runtime::context::set_scheduler::<(alloc[2e1b2a31b91974c5]::boxed::Box<tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::Core>, core[a373ad73a504971]::option::Option<()>), <tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}, core[a373ad73a504971]::option::Option<()>>::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/context.rs:187:17
[INFO] [stdout]   34:     0x6249329c61e0 - <tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CoreGuard>::enter::<<tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}, core[a373ad73a504971]::option::Option<()>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/scheduler/current_thread/mod.rs:906:27
[INFO] [stdout]   35:     0x6249329c64d6 - <tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/scheduler/current_thread/mod.rs:817:24
[INFO] [stdout]   36:     0x6249329fe480 - <tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CurrentThread>::block_on::<core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/scheduler/current_thread/mod.rs:218:33
[INFO] [stdout]   37:     0x624932b4e4e8 - tokio[7c629e9ef101a854]::runtime::context::runtime::enter_runtime::<<tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/context/runtime.rs:65:16
[INFO] [stdout]   38:     0x6249329bba34 - <tokio[7c629e9ef101a854]::runtime::scheduler::current_thread::CurrentThread>::block_on::<core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/scheduler/current_thread/mod.rs:206:9
[INFO] [stdout]   39:     0x624932a736af - <tokio[7c629e9ef101a854]::runtime::runtime::Runtime>::block_on_inner::<core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/runtime.rs:374:52
[INFO] [stdout]   40:     0x624932a737fb - <tokio[7c629e9ef101a854]::runtime::runtime::Runtime>::block_on::<core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/runtime.rs:343:18
[INFO] [stdout]   41:     0x6249327bae51 - wcode[9c48ae11f7de053c]::tools::bash::tests::timeout_kills_the_whole_process_group
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tools/bash.rs:700:10
[INFO] [stdout]   42:     0x62493277cc27 - wcode[9c48ae11f7de053c]::tools::bash::tests::timeout_kills_the_whole_process_group::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tools/bash.rs:663:53
[INFO] [stdout]   43:     0x624932845da6 - <wcode[9c48ae11f7de053c]::tools::bash::tests::timeout_kills_the_whole_process_group::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   44:     0x624932cb437b - <fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   45:     0x624932cb437b - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:701:18
[INFO] [stdout]   46:     0x624932cc1555 - test[aada8e7e76ba119b]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:74
[INFO] [stdout]   47:     0x624932cc1555 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   48:     0x624932cc1555 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   49:     0x624932cc1555 - std[617be2ca0a6fd877]::panicking::catch_unwind::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   50:     0x624932cc1555 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   51:     0x624932cc1555 - test[aada8e7e76ba119b]::run_test_in_process
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:27
[INFO] [stdout]   52:     0x624932cc1555 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:645:43
[INFO] [stdout]   53:     0x624932cbae44 - test[aada8e7e76ba119b]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:675:41
[INFO] [stdout]   54:     0x624932cbae44 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   55:     0x624932cc45e2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   56:     0x624932cc45e2 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   57:     0x624932cc45e2 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   58:     0x624932cc45e2 - std[617be2ca0a6fd877]::panicking::catch_unwind::<(), core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   59:     0x624932cc45e2 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   60:     0x624932cc45e2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   61:     0x624932cc45e2 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   62:     0x624933cf5b1f - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn core[a373ad73a504971]::ops::function::FnOnce<(), Output = ()> + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2314:9
[INFO] [stdout]   63:     0x624933cf5b1f - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   64:     0x746a45746dfa - <unknown>
[INFO] [stdout]   65:     0x746a457da3d4 - clone
[INFO] [stdout]   66:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     tools::bash::tests::timeout_kills_the_whole_process_group
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 482 passed; 1 failed; 2 ignored; 0 measured; 0 filtered out; finished in 12.33s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--bin wcode`
[INFO] running `Command { std: "docker" "inspect" "d647d13e7a155a9c30b6600892f17d4438f5cf8bad835fedba452db32d0baa77", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d647d13e7a155a9c30b6600892f17d4438f5cf8bad835fedba452db32d0baa77", kill_on_drop: false }`
[INFO] [stdout] d647d13e7a155a9c30b6600892f17d4438f5cf8bad835fedba452db32d0baa77
