[INFO] cloning repository https://github.com/lvmiller/project_symphony [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/lvmiller/project_symphony" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Flvmiller%2Fproject_symphony", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Flvmiller%2Fproject_symphony'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 3d8b70be1fc0473f40cf0f2b15f5d6c20fdd9dcd [INFO] testing lvmiller/project_symphony against try#28f95933dc0727396c07b48d0a8cb5211b7fb472 for pr-154065-2 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Flvmiller%2Fproject_symphony" "/workspace/builds/worker-5-tc2/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-5-tc2/source'... [INFO] [stderr] done. [INFO] started tweaking git repo https://github.com/lvmiller/project_symphony [INFO] finished tweaking git repo https://github.com/lvmiller/project_symphony [INFO] tweaked toml for git repo https://github.com/lvmiller/project_symphony written to /workspace/builds/worker-5-tc2/source/Cargo.toml [INFO] validating manifest of git repo https://github.com/lvmiller/project_symphony on toolchain 28f95933dc0727396c07b48d0a8cb5211b7fb472 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate git repo https://github.com/lvmiller/project_symphony 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" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 2a422a753f3cc6be760ff9bb3a61d9c572e65996d6dc366c9a76d04a93ec7e4b [INFO] running `Command { std: "docker" "start" "-a" "2a422a753f3cc6be760ff9bb3a61d9c572e65996d6dc366c9a76d04a93ec7e4b", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "2a422a753f3cc6be760ff9bb3a61d9c572e65996d6dc366c9a76d04a93ec7e4b", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "2a422a753f3cc6be760ff9bb3a61d9c572e65996d6dc366c9a76d04a93ec7e4b", kill_on_drop: false }` [INFO] [stdout] 2a422a753f3cc6be760ff9bb3a61d9c572e65996d6dc366c9a76d04a93ec7e4b [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 7006076c847bb96cdd3a272cc5c358b3fc94aa11f3da0d71ac9fa040bb72f588 [INFO] running `Command { std: "docker" "start" "-a" "7006076c847bb96cdd3a272cc5c358b3fc94aa11f3da0d71ac9fa040bb72f588", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.106 [INFO] [stderr] Compiling quote v1.0.45 [INFO] [stderr] Compiling unicode-ident v1.0.24 [INFO] [stderr] Compiling libc v0.2.186 [INFO] [stderr] Compiling smallvec v1.15.1 [INFO] [stderr] Compiling itoa v1.0.18 [INFO] [stderr] Compiling memchr v2.8.0 [INFO] [stderr] Compiling log v0.4.29 [INFO] [stderr] Compiling pin-project-lite v0.2.17 [INFO] [stderr] Compiling bytes v1.11.1 [INFO] [stderr] Compiling futures-core v0.3.32 [INFO] [stderr] Compiling find-msvc-tools v0.1.9 [INFO] [stderr] Compiling once_cell v1.21.4 [INFO] [stderr] Compiling writeable v0.6.3 [INFO] [stderr] Compiling litemap v0.8.2 [INFO] [stderr] Compiling icu_properties_data v2.2.0 [INFO] [stderr] Compiling icu_normalizer_data v2.2.0 [INFO] [stderr] Compiling regex-syntax v0.8.10 [INFO] [stderr] Compiling cc v1.2.62 [INFO] [stderr] Compiling zeroize v1.8.2 [INFO] [stderr] Compiling ucd-trie v0.1.7 [INFO] [stderr] Compiling untrusted v0.9.0 [INFO] [stderr] Compiling futures-task v0.3.32 [INFO] [stderr] Compiling slab v0.4.12 [INFO] [stderr] Compiling num-conv v0.2.1 [INFO] [stderr] Compiling bitflags v2.11.1 [INFO] [stderr] Compiling rustls v0.23.40 [INFO] [stderr] Compiling rustls-pki-types v1.14.1 [INFO] [stderr] Compiling tracing-core v0.1.36 [INFO] [stderr] Compiling time-core v0.1.8 [INFO] [stderr] Compiling powerfmt v0.2.0 [INFO] [stderr] Compiling aho-corasick v1.1.4 [INFO] [stderr] Compiling pest v2.8.6 [INFO] [stderr] Compiling futures-util v0.3.32 [INFO] [stderr] Compiling deranged v0.5.8 [INFO] [stderr] Compiling futures-channel v0.3.32 [INFO] [stderr] Compiling time-macros v0.2.27 [INFO] [stderr] Compiling autocfg v1.5.0 [INFO] [stderr] Compiling subtle v2.6.1 [INFO] [stderr] Compiling zmij v1.0.21 [INFO] [stderr] Compiling either v1.15.0 [INFO] [stderr] Compiling http v1.4.0 [INFO] [stderr] Compiling static_assertions v1.1.0 [INFO] [stderr] Compiling atomic-waker v1.1.2 [INFO] [stderr] Compiling itertools v0.14.0 [INFO] [stderr] Compiling num-traits v0.2.19 [INFO] [stderr] Compiling anstyle-parse v1.0.0 [INFO] [stderr] Compiling syn v2.0.117 [INFO] [stderr] Compiling sync_wrapper v1.0.2 [INFO] [stderr] Compiling serde_json v1.0.149 [INFO] [stderr] Compiling anstyle v1.0.14 [INFO] [stderr] Compiling ryu v1.0.23 [INFO] [stderr] Compiling anstyle-query v1.1.5 [INFO] [stderr] Compiling colorchoice v1.0.5 [INFO] [stderr] Compiling base64 v0.22.1 [INFO] [stderr] Compiling anymap2 v0.13.0 [INFO] [stderr] Compiling ipnet v2.12.0 [INFO] [stderr] Compiling tower-layer v0.3.3 [INFO] [stderr] Compiling anstream v1.0.0 [INFO] [stderr] Compiling webpki-roots v1.0.7 [INFO] [stderr] Compiling thiserror v2.0.18 [INFO] [stderr] Compiling errno v0.3.14 [INFO] [stderr] Compiling parking_lot_core v0.9.12 [INFO] [stderr] Compiling mio v1.2.0 [INFO] [stderr] Compiling ring v0.17.14 [INFO] [stderr] Compiling signal-hook-registry v1.4.8 [INFO] [stderr] Compiling socket2 v0.6.3 [INFO] [stderr] Compiling getrandom v0.2.17 [INFO] [stderr] Compiling inotify-sys v0.1.5 [INFO] [stderr] Compiling parking_lot v0.12.5 [INFO] [stderr] Compiling hashbrown v0.17.1 [INFO] [stderr] Compiling clap_lex v1.1.0 [INFO] [stderr] Compiling unicode-segmentation v1.13.2 [INFO] [stderr] Compiling lazy_static v1.5.0 [INFO] [stderr] Compiling http-body v1.0.1 [INFO] [stderr] Compiling same-file v1.0.6 [INFO] [stderr] Compiling clap_builder v4.6.0 [INFO] [stderr] Compiling http-body-util v0.1.3 [INFO] [stderr] Compiling pest_meta v2.8.6 [INFO] [stderr] Compiling walkdir v2.5.0 [INFO] [stderr] Compiling sharded-slab v0.1.7 [INFO] [stderr] Compiling inotify v0.11.1 [INFO] [stderr] Compiling time v0.3.47 [INFO] [stderr] Compiling indexmap v2.14.0 [INFO] [stderr] Compiling tracing-log v0.2.0 [INFO] [stderr] Compiling notify-types v2.1.0 [INFO] [stderr] Compiling thread_local v1.1.9 [INFO] [stderr] Compiling nu-ansi-term v0.50.3 [INFO] [stderr] Compiling unsafe-libyaml v0.2.11 [INFO] [stderr] Compiling iana-time-zone v0.1.65 [INFO] [stderr] Compiling notify v8.2.0 [INFO] [stderr] Compiling regex-automata v0.4.14 [INFO] [stderr] Compiling regex v1.12.3 [INFO] [stderr] Compiling matchers v0.2.0 [INFO] [stderr] Compiling rustls-webpki v0.103.13 [INFO] [stderr] Compiling synstructure v0.13.2 [INFO] [stderr] Compiling pest_generator v2.8.6 [INFO] [stderr] Compiling zerofrom-derive v0.1.7 [INFO] [stderr] Compiling yoke-derive v0.8.2 [INFO] [stderr] Compiling zerovec-derive v0.11.3 [INFO] [stderr] Compiling displaydoc v0.2.5 [INFO] [stderr] Compiling serde_derive v1.0.228 [INFO] [stderr] Compiling tokio-macros v2.7.0 [INFO] [stderr] Compiling tracing-attributes v0.1.31 [INFO] [stderr] Compiling liquid-derive v0.26.10 [INFO] [stderr] Compiling clap_derive v4.6.1 [INFO] [stderr] Compiling thiserror-impl v2.0.18 [INFO] [stderr] Compiling async-trait v0.1.89 [INFO] [stderr] Compiling pest_derive v2.8.6 [INFO] [stderr] Compiling tokio v1.52.3 [INFO] [stderr] Compiling zerofrom v0.1.8 [INFO] [stderr] Compiling yoke v0.8.2 [INFO] [stderr] Compiling tracing v0.1.44 [INFO] [stderr] Compiling zerovec v0.11.6 [INFO] [stderr] Compiling zerotrie v0.2.4 [INFO] [stderr] Compiling tracing-subscriber v0.3.23 [INFO] [stderr] Compiling clap v4.6.1 [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 serde v1.0.228 [INFO] [stderr] Compiling icu_provider v2.2.0 [INFO] [stderr] Compiling kstring v2.0.2 [INFO] [stderr] Compiling serde_urlencoded v0.7.1 [INFO] [stderr] Compiling chrono v0.4.44 [INFO] [stderr] Compiling serde_yaml v0.9.34+deprecated [INFO] [stderr] Compiling liquid-core v0.26.11 [INFO] [stderr] Compiling icu_properties v2.2.0 [INFO] [stderr] Compiling icu_normalizer v2.2.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 liquid-lib v0.26.11 [INFO] [stderr] Compiling hyper v1.9.0 [INFO] [stderr] Compiling tokio-rustls v0.26.4 [INFO] [stderr] Compiling tower v0.5.3 [INFO] [stderr] Compiling tower-http v0.6.10 [INFO] [stderr] Compiling liquid v0.26.11 [INFO] [stderr] Compiling hyper-util v0.1.20 [INFO] [stderr] Compiling hyper-rustls v0.27.9 [INFO] [stderr] Compiling reqwest v0.12.28 [INFO] [stderr] Compiling symphony v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 18s [INFO] running `Command { std: "docker" "inspect" "7006076c847bb96cdd3a272cc5c358b3fc94aa11f3da0d71ac9fa040bb72f588", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "7006076c847bb96cdd3a272cc5c358b3fc94aa11f3da0d71ac9fa040bb72f588", kill_on_drop: false }` [INFO] [stdout] 7006076c847bb96cdd3a272cc5c358b3fc94aa11f3da0d71ac9fa040bb72f588 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 98c139d308818bd1010eb90d95afa9aa32b16c158b1b70f2fd863865f99dc5f4 [INFO] running `Command { std: "docker" "start" "-a" "98c139d308818bd1010eb90d95afa9aa32b16c158b1b70f2fd863865f99dc5f4", kill_on_drop: false }` [INFO] [stderr] Compiling bitflags v2.11.1 [INFO] [stderr] Compiling rustix v1.1.4 [INFO] [stderr] Compiling getrandom v0.4.2 [INFO] [stderr] Compiling predicates-core v1.0.10 [INFO] [stderr] Compiling float-cmp v0.10.0 [INFO] [stderr] Compiling linux-raw-sys v0.12.1 [INFO] [stderr] Compiling termtree v0.5.1 [INFO] [stderr] Compiling assert_cmd v2.2.2 [INFO] [stderr] Compiling normalize-line-endings v0.3.0 [INFO] [stderr] Compiling difflib v0.4.0 [INFO] [stderr] Compiling bstr v1.12.1 [INFO] [stderr] Compiling wait-timeout v0.2.1 [INFO] [stderr] Compiling fastrand v2.4.1 [INFO] [stderr] Compiling tower-http v0.6.10 [INFO] [stderr] Compiling inotify v0.11.1 [INFO] [stderr] Compiling notify-types v2.1.0 [INFO] [stderr] Compiling predicates-tree v1.0.13 [INFO] [stderr] Compiling predicates v3.1.4 [INFO] [stderr] Compiling notify v8.2.0 [INFO] [stderr] Compiling reqwest v0.12.28 [INFO] [stderr] Compiling symphony v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Compiling tempfile v3.27.0 [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 18.73s [INFO] running `Command { std: "docker" "inspect" "98c139d308818bd1010eb90d95afa9aa32b16c158b1b70f2fd863865f99dc5f4", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "98c139d308818bd1010eb90d95afa9aa32b16c158b1b70f2fd863865f99dc5f4", kill_on_drop: false }` [INFO] [stdout] 98c139d308818bd1010eb90d95afa9aa32b16c158b1b70f2fd863865f99dc5f4 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/source:/opt/rustwide/workdir:ro,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" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 37fa24a5f2fb2ce90320caffd16eb66d8aaedda5566a1be9aaa4b778515c43d6 [INFO] running `Command { std: "docker" "start" "-a" "37fa24a5f2fb2ce90320caffd16eb66d8aaedda5566a1be9aaa4b778515c43d6", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.38s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/symphony-6ecac00a337ac169) [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test orchestrator::state::tests::releases_claimed_workspace_key_after_retry_entry_was_removed ... ok [INFO] [stdout] test completion::tests::github_git_authorization_header_uses_x_access_token_basic_auth ... ok [INFO] [stdout] test shutdown::tests::shutdown_event_returns_when_terminate_branch_completes ... ok [INFO] [stdout] test shutdown::tests::shutdown_event_returns_when_interrupt_branch_completes ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stderr] Running unittests src/main.rs (/opt/rustwide/target/debug/deps/symphony-b82e8a00bf38bb0c) [INFO] [stderr] Running tests/agent_runner.rs (/opt/rustwide/target/debug/deps/agent_runner-a5cbb3a59bfecf56) [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 6 tests [INFO] [stdout] test runner_uses_initial_prompt_then_continuation_and_refreshes_after_successful_turns ... ok [INFO] [stdout] test runner_converts_codex_failure_to_worker_outcome_and_runs_after_run ... ok [INFO] [stdout] test runner_treats_direct_completion_without_changes_as_normal_skip ... ok [INFO] [stdout] test runner_runs_lifecycle_hooks_and_stops_on_terminal_state ... ok [INFO] [stdout] test runner_removes_workspace_after_successful_direct_commit_completion ... ok [INFO] [stderr] Running tests/cli.rs (/opt/rustwide/target/debug/deps/cli-d149ceafa2224b5a) [INFO] [stdout] test runner_keeps_workspace_after_committed_completion_when_cleanup_policy_is_never ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.78s [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 5 tests [INFO] [stdout] test cli_fails_cleanly_when_default_workflow_is_missing ... ok [INFO] [stdout] test cli_uses_default_workflow_path_for_check_success ... ok [INFO] [stdout] test cli_uses_explicit_workflow_path_for_check_success ... ok [INFO] [stdout] test cli_fails_cleanly_when_explicit_workflow_is_missing ... ok [INFO] [stdout] test cli_accepts_multiple_workflow_paths_for_check_success ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s [INFO] [stdout] [INFO] [stderr] Running tests/codex_protocol.rs (/opt/rustwide/target/debug/deps/codex_protocol-a91cc132c98ff81b) [INFO] [stdout] [INFO] [stdout] running 7 tests [INFO] [stdout] test times_out_when_turn_does_not_complete ... ok [INFO] [stdout] test extracts_token_totals_and_rate_limits ... FAILED [INFO] [stdout] test auto_approves_command_and_file_requests_for_session ... FAILED [INFO] [stdout] test sends_schema_shaped_startup_messages_and_streams_completion ... FAILED [INFO] [stdout] test user_input_required_fails_without_stalling ... FAILED [INFO] [stdout] test unsupported_dynamic_tool_calls_return_unsuccessful_response ... FAILED [INFO] [stdout] test malformed_messages_are_reported_and_fail_the_run ... FAILED [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- extracts_token_totals_and_rate_limits stdout ---- [INFO] [stdout] [INFO] [stdout] thread 'extracts_token_totals_and_rate_limits' (241) panicked at tests/codex_protocol.rs:192:25: [INFO] [stdout] run completes: Codex { kind: "timeout", message: "timed out waiting for codex response" } [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5d0468c59d48 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::libunwind::trace [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x5d0468c59d48 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::trace_unsynchronized:: [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x5d0468c59d48 - std[d054f6f42beb1baa]::sys::backtrace::_print_fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:74:9 [INFO] [stdout] 3: 0x5d0468c59d48 - <::print::DisplayBacktrace as core[5a1c3e9896636f3a]::fmt::Display>::fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:44:26 [INFO] [stdout] 4: 0x5d0468c6ea7a - ::fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/fmt/rt.rs:152:76 [INFO] [stdout] 5: 0x5d0468c6ea7a - core[5a1c3e9896636f3a]::fmt::write [INFO] [stdout] 6: 0x5d0468c5e782 - std[d054f6f42beb1baa]::io::default_write_fmt::> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:622:11 [INFO] [stdout] 7: 0x5d0468c5e782 - as std[d054f6f42beb1baa]::io::Write>::write_fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:1977:13 [INFO] [stdout] 8: 0x5d0468c36dd6 - ::print [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:47:9 [INFO] [stdout] 9: 0x5d0468c36dd6 - std[d054f6f42beb1baa]::panicking::default_hook::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:292:27 [INFO] [stdout] 10: 0x5d0468c51639 - std[d054f6f42beb1baa]::panicking::default_hook [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:316:9 [INFO] [stdout] 11: 0x5d0468ae17bc - core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9 [INFO] [stdout] 12: 0x5d0468ae17bc - test[fad20673b750c10e]::test_main_inner::::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:155:21 [INFO] [stdout] 13: 0x5d0468c518b2 - core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9 [INFO] [stdout] 14: 0x5d0468c518b2 - std[d054f6f42beb1baa]::panicking::panic_with_hook [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:833:13 [INFO] [stdout] 15: 0x5d0468c36e92 - std[d054f6f42beb1baa]::panicking::panic_handler::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:698:13 [INFO] [stdout] 16: 0x5d0468c2e5f9 - std[d054f6f42beb1baa]::sys::backtrace::__rust_end_short_backtrace:: [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:182:18 [INFO] [stdout] 17: 0x5d0468c37bad - __rustc[7ab284efd7f33ea8]::rust_begin_unwind [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:689:5 [INFO] [stdout] 18: 0x5d0468c6f26c - core[5a1c3e9896636f3a]::panicking::panic_fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panicking.rs:80:14 [INFO] [stdout] 19: 0x5d0468c6efb2 - core[5a1c3e9896636f3a]::result::unwrap_failed [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/result.rs:1872:5 [INFO] [stdout] 20: 0x5d0468accbd7 - , symphony[9e94a00ed0030622]::error::SymphonyError>>::expect [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/result.rs:1185:23 [INFO] [stdout] 21: 0x5d0468ac361a - codex_protocol[967957b8baebdca0]::extracts_token_totals_and_rate_limits::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/codex_protocol.rs:192:25 [INFO] [stdout] 22: 0x5d0468acf272 - > as core[5a1c3e9896636f3a]::future::future::Future>::poll [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/future/future.rs:133:9 [INFO] [stdout] 23: 0x5d0468acf2ed - >> as core[5a1c3e9896636f3a]::future::future::Future>::poll [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/future/future.rs:133:9 [INFO] [stdout] 24: 0x5d0468ac24ad - ::block_on::>>>::{closure#0}::{closure#0}::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:778:70 [INFO] [stdout] 25: 0x5d0468ac23ab - tokio[efdb887346cc66e5]::task::coop::with_budget::, ::block_on>>>::{closure#0}::{closure#0}::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/task/coop/mod.rs:167:5 [INFO] [stdout] 26: 0x5d0468ac23ab - tokio[efdb887346cc66e5]::task::coop::budget::, ::block_on>>>::{closure#0}::{closure#0}::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/task/coop/mod.rs:133:5 [INFO] [stdout] 27: 0x5d0468ac23ab - ::block_on::>>>::{closure#0}::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:778:25 [INFO] [stdout] 28: 0x5d0468abec80 - ::enter::, ::block_on>>>::{closure#0}::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:451:19 [INFO] [stdout] 29: 0x5d0468ac172d - ::block_on::>>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:777:44 [INFO] [stdout] 30: 0x5d0468ac09d4 - ::enter::<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:865:68 [INFO] [stdout] 31: 0x5d0468ad026b - >::set::<::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}, (alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>)> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context/scoped.rs:40:9 [INFO] [stdout] 32: 0x5d0468ad27c9 - tokio[efdb887346cc66e5]::runtime::context::set_scheduler::<(alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context.rs:181:38 [INFO] [stdout] 33: 0x5d0468ad0a12 - >::try_with::, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>)> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/local.rs:462:12 [INFO] [stdout] 34: 0x5d0468ad059e - >::with::, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>)> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/local.rs:426:20 [INFO] [stdout] 35: 0x5d0468ad197d - tokio[efdb887346cc66e5]::runtime::context::set_scheduler::<(alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context.rs:181:17 [INFO] [stdout] 36: 0x5d0468abfd20 - ::enter::<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:865:27 [INFO] [stdout] 37: 0x5d0468ac0016 - ::block_on::>>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:765:24 [INFO] [stdout] 38: 0x5d0468ac05e0 - ::block_on::>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:205:33 [INFO] [stdout] 39: 0x5d0468acb5f3 - tokio[efdb887346cc66e5]::runtime::context::runtime::enter_runtime::<::block_on>>::{closure#0}, ()> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context/runtime.rs:65:16 [INFO] [stdout] 40: 0x5d0468abe7b1 - ::block_on::>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:193:9 [INFO] [stdout] 41: 0x5d0468acfdf4 - ::block_on_inner::>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/runtime.rs:371:52 [INFO] [stdout] 42: 0x5d0468acffbf - ::block_on::>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/runtime.rs:345:18 [INFO] [stdout] 43: 0x5d0468ac8441 - codex_protocol[967957b8baebdca0]::extracts_token_totals_and_rate_limits [INFO] [stdout] at /opt/rustwide/workdir/tests/codex_protocol.rs:205:58 [INFO] [stdout] 44: 0x5d0468ac3207 - codex_protocol[967957b8baebdca0]::extracts_token_totals_and_rate_limits::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/codex_protocol.rs:190:49 [INFO] [stdout] 45: 0x5d0468acf966 - >::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 46: 0x5d0468ad489b - core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 47: 0x5d0468ad489b - test[fad20673b750c10e]::__rust_begin_short_backtrace::, fn() -> core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:724:18 [INFO] [stdout] 48: 0x5d0468ae2115 - test[fad20673b750c10e]::run_test_in_process::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:74 [INFO] [stdout] 49: 0x5d0468ae2115 - as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 50: 0x5d0468ae2115 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40 [INFO] [stdout] 51: 0x5d0468ae2115 - std[d054f6f42beb1baa]::panicking::catch_unwind::, core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19 [INFO] [stdout] 52: 0x5d0468ae2115 - std[d054f6f42beb1baa]::panic::catch_unwind::, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14 [INFO] [stdout] 53: 0x5d0468ae2115 - test[fad20673b750c10e]::run_test_in_process [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:27 [INFO] [stdout] 54: 0x5d0468ae2115 - test[fad20673b750c10e]::run_test::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:668:43 [INFO] [stdout] 55: 0x5d0468adcc74 - test[fad20673b750c10e]::run_test::{closure#1} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:698:41 [INFO] [stdout] 56: 0x5d0468adcc74 - std[d054f6f42beb1baa]::sys::backtrace::__rust_begin_short_backtrace:: [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:166:18 [INFO] [stdout] 57: 0x5d0468ae5192 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::::{closure#1}::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:70:13 [INFO] [stdout] 58: 0x5d0468ae5192 - ::{closure#1}::{closure#0}> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 59: 0x5d0468ae5192 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40 [INFO] [stdout] 60: 0x5d0468ae5192 - std[d054f6f42beb1baa]::panicking::catch_unwind::<(), core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe::{closure#1}::{closure#0}>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19 [INFO] [stdout] 61: 0x5d0468ae5192 - std[d054f6f42beb1baa]::panic::catch_unwind::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14 [INFO] [stdout] 62: 0x5d0468ae5192 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::::{closure#1} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:68:26 [INFO] [stdout] 63: 0x5d0468ae5192 - ::{closure#1} as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 64: 0x5d0468c5918f - + core[5a1c3e9896636f3a]::marker::Send> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2277:9 [INFO] [stdout] 65: 0x5d0468c5918f - ::new::thread_start [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/thread/unix.rs:118:17 [INFO] [stdout] 66: 0x79c2be534aa4 - [INFO] [stdout] 67: 0x79c2be5c1a64 - clone [INFO] [stdout] 68: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- auto_approves_command_and_file_requests_for_session stdout ---- [INFO] [stdout] [INFO] [stdout] thread 'auto_approves_command_and_file_requests_for_session' (240) panicked at tests/codex_protocol.rs:218:12: [INFO] [stdout] run completes: Codex { kind: "timeout", message: "timed out waiting for codex response" } [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5d0468c59d48 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::libunwind::trace [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x5d0468c59d48 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::trace_unsynchronized:: [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x5d0468c59d48 - std[d054f6f42beb1baa]::sys::backtrace::_print_fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:74:9 [INFO] [stdout] 3: 0x5d0468c59d48 - <::print::DisplayBacktrace as core[5a1c3e9896636f3a]::fmt::Display>::fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:44:26 [INFO] [stdout] 4: 0x5d0468c6ea7a - ::fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/fmt/rt.rs:152:76 [INFO] [stdout] 5: 0x5d0468c6ea7a - core[5a1c3e9896636f3a]::fmt::write [INFO] [stdout] 6: 0x5d0468c5e782 - std[d054f6f42beb1baa]::io::default_write_fmt::> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:622:11 [INFO] [stdout] 7: 0x5d0468c5e782 - as std[d054f6f42beb1baa]::io::Write>::write_fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:1977:13 [INFO] [stdout] 8: 0x5d0468c36dd6 - ::print [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:47:9 [INFO] [stdout] 9: 0x5d0468c36dd6 - std[d054f6f42beb1baa]::panicking::default_hook::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:292:27 [INFO] [stdout] 10: 0x5d0468c51639 - std[d054f6f42beb1baa]::panicking::default_hook [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:316:9 [INFO] [stdout] 11: 0x5d0468ae17bc - core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9 [INFO] [stdout] 12: 0x5d0468ae17bc - test[fad20673b750c10e]::test_main_inner::::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:155:21 [INFO] [stdout] 13: 0x5d0468c518b2 - core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9 [INFO] [stdout] 14: 0x5d0468c518b2 - std[d054f6f42beb1baa]::panicking::panic_with_hook [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:833:13 [INFO] [stdout] 15: 0x5d0468c36e92 - std[d054f6f42beb1baa]::panicking::panic_handler::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:698:13 [INFO] [stdout] 16: 0x5d0468c2e5f9 - std[d054f6f42beb1baa]::sys::backtrace::__rust_end_short_backtrace:: [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:182:18 [INFO] [stdout] 17: 0x5d0468c37bad - __rustc[7ab284efd7f33ea8]::rust_begin_unwind [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:689:5 [INFO] [stdout] 18: 0x5d0468c6f26c - core[5a1c3e9896636f3a]::panicking::panic_fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panicking.rs:80:14 [INFO] [stdout] 19: 0x5d0468c6efb2 - core[5a1c3e9896636f3a]::result::unwrap_failed [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/result.rs:1872:5 [INFO] [stdout] 20: 0x5d0468accbd7 - , symphony[9e94a00ed0030622]::error::SymphonyError>>::expect [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/result.rs:1185:23 [INFO] [stdout] 21: 0x5d0468ac4bca - codex_protocol[967957b8baebdca0]::auto_approves_command_and_file_requests_for_session::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/codex_protocol.rs:218:12 [INFO] [stdout] 22: 0x5d0468acf272 - > as core[5a1c3e9896636f3a]::future::future::Future>::poll [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/future/future.rs:133:9 [INFO] [stdout] 23: 0x5d0468acf2ed - >> as core[5a1c3e9896636f3a]::future::future::Future>::poll [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/future/future.rs:133:9 [INFO] [stdout] 24: 0x5d0468ac24ad - ::block_on::>>>::{closure#0}::{closure#0}::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:778:70 [INFO] [stdout] 25: 0x5d0468ac23ab - tokio[efdb887346cc66e5]::task::coop::with_budget::, ::block_on>>>::{closure#0}::{closure#0}::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/task/coop/mod.rs:167:5 [INFO] [stdout] 26: 0x5d0468ac23ab - tokio[efdb887346cc66e5]::task::coop::budget::, ::block_on>>>::{closure#0}::{closure#0}::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/task/coop/mod.rs:133:5 [INFO] [stdout] 27: 0x5d0468ac23ab - ::block_on::>>>::{closure#0}::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:778:25 [INFO] [stdout] 28: 0x5d0468abec80 - ::enter::, ::block_on>>>::{closure#0}::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:451:19 [INFO] [stdout] 29: 0x5d0468ac172d - ::block_on::>>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:777:44 [INFO] [stdout] 30: 0x5d0468ac09d4 - ::enter::<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:865:68 [INFO] [stdout] 31: 0x5d0468ad026b - >::set::<::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}, (alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>)> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context/scoped.rs:40:9 [INFO] [stdout] 32: 0x5d0468ad27c9 - tokio[efdb887346cc66e5]::runtime::context::set_scheduler::<(alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context.rs:181:38 [INFO] [stdout] 33: 0x5d0468ad0a12 - >::try_with::, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>)> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/local.rs:462:12 [INFO] [stdout] 34: 0x5d0468ad059e - >::with::, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>)> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/local.rs:426:20 [INFO] [stdout] 35: 0x5d0468ad197d - tokio[efdb887346cc66e5]::runtime::context::set_scheduler::<(alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context.rs:181:17 [INFO] [stdout] 36: 0x5d0468abfd20 - ::enter::<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:865:27 [INFO] [stdout] 37: 0x5d0468ac0016 - ::block_on::>>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:765:24 [INFO] [stdout] 38: 0x5d0468ac05e0 - ::block_on::>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:205:33 [INFO] [stdout] 39: 0x5d0468acb5f3 - tokio[efdb887346cc66e5]::runtime::context::runtime::enter_runtime::<::block_on>>::{closure#0}, ()> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context/runtime.rs:65:16 [INFO] [stdout] 40: 0x5d0468abe7b1 - ::block_on::>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:193:9 [INFO] [stdout] 41: 0x5d0468acfdf4 - ::block_on_inner::>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/runtime.rs:371:52 [INFO] [stdout] 42: 0x5d0468acffbf - ::block_on::>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/runtime.rs:345:18 [INFO] [stdout] 43: 0x5d0468ac8b41 - codex_protocol[967957b8baebdca0]::auto_approves_command_and_file_requests_for_session [INFO] [stdout] at /opt/rustwide/workdir/tests/codex_protocol.rs:229:63 [INFO] [stdout] 44: 0x5d0468ac32c7 - codex_protocol[967957b8baebdca0]::auto_approves_command_and_file_requests_for_session::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/codex_protocol.rs:216:63 [INFO] [stdout] 45: 0x5d0468acfa66 - >::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 46: 0x5d0468ad489b - core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 47: 0x5d0468ad489b - test[fad20673b750c10e]::__rust_begin_short_backtrace::, fn() -> core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:724:18 [INFO] [stdout] 48: 0x5d0468ae2115 - test[fad20673b750c10e]::run_test_in_process::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:74 [INFO] [stdout] 49: 0x5d0468ae2115 - as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 50: 0x5d0468ae2115 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40 [INFO] [stdout] 51: 0x5d0468ae2115 - std[d054f6f42beb1baa]::panicking::catch_unwind::, core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19 [INFO] [stdout] 52: 0x5d0468ae2115 - std[d054f6f42beb1baa]::panic::catch_unwind::, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14 [INFO] [stdout] 53: 0x5d0468ae2115 - test[fad20673b750c10e]::run_test_in_process [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:27 [INFO] [stdout] 54: 0x5d0468ae2115 - test[fad20673b750c10e]::run_test::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:668:43 [INFO] [stdout] 55: 0x5d0468adcc74 - test[fad20673b750c10e]::run_test::{closure#1} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:698:41 [INFO] [stdout] 56: 0x5d0468adcc74 - std[d054f6f42beb1baa]::sys::backtrace::__rust_begin_short_backtrace:: [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:166:18 [INFO] [stdout] 57: 0x5d0468ae5192 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::::{closure#1}::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:70:13 [INFO] [stdout] 58: 0x5d0468ae5192 - ::{closure#1}::{closure#0}> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 59: 0x5d0468ae5192 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40 [INFO] [stdout] 60: 0x5d0468ae5192 - std[d054f6f42beb1baa]::panicking::catch_unwind::<(), core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe::{closure#1}::{closure#0}>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19 [INFO] [stdout] 61: 0x5d0468ae5192 - std[d054f6f42beb1baa]::panic::catch_unwind::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14 [INFO] [stdout] 62: 0x5d0468ae5192 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::::{closure#1} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:68:26 [INFO] [stdout] 63: 0x5d0468ae5192 - ::{closure#1} as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 64: 0x5d0468c5918f - + core[5a1c3e9896636f3a]::marker::Send> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2277:9 [INFO] [stdout] 65: 0x5d0468c5918f - ::new::thread_start [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/thread/unix.rs:118:17 [INFO] [stdout] 66: 0x79c2be534aa4 - [INFO] [stdout] 67: 0x79c2be5c1a64 - clone [INFO] [stdout] 68: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- sends_schema_shaped_startup_messages_and_streams_completion stdout ---- [INFO] [stdout] [INFO] [stdout] thread 'sends_schema_shaped_startup_messages_and_streams_completion' (243) panicked at tests/codex_protocol.rs:146:25: [INFO] [stdout] run completes: Codex { kind: "timeout", message: "timed out waiting for codex response" } [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5d0468c59d48 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::libunwind::trace [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x5d0468c59d48 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::trace_unsynchronized:: [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x5d0468c59d48 - std[d054f6f42beb1baa]::sys::backtrace::_print_fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:74:9 [INFO] [stdout] 3: 0x5d0468c59d48 - <::print::DisplayBacktrace as core[5a1c3e9896636f3a]::fmt::Display>::fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:44:26 [INFO] [stdout] 4: 0x5d0468c6ea7a - ::fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/fmt/rt.rs:152:76 [INFO] [stdout] 5: 0x5d0468c6ea7a - core[5a1c3e9896636f3a]::fmt::write [INFO] [stdout] 6: 0x5d0468c5e782 - std[d054f6f42beb1baa]::io::default_write_fmt::> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:622:11 [INFO] [stdout] 7: 0x5d0468c5e782 - as std[d054f6f42beb1baa]::io::Write>::write_fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:1977:13 [INFO] [stdout] 8: 0x5d0468c36dd6 - ::print [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:47:9 [INFO] [stdout] 9: 0x5d0468c36dd6 - std[d054f6f42beb1baa]::panicking::default_hook::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:292:27 [INFO] [stdout] 10: 0x5d0468c51639 - std[d054f6f42beb1baa]::panicking::default_hook [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:316:9 [INFO] [stdout] 11: 0x5d0468ae17bc - core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9 [INFO] [stdout] 12: 0x5d0468ae17bc - test[fad20673b750c10e]::test_main_inner::::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:155:21 [INFO] [stdout] 13: 0x5d0468c518b2 - core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9 [INFO] [stdout] 14: 0x5d0468c518b2 - std[d054f6f42beb1baa]::panicking::panic_with_hook [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:833:13 [INFO] [stdout] 15: 0x5d0468c36e92 - std[d054f6f42beb1baa]::panicking::panic_handler::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:698:13 [INFO] [stdout] 16: 0x5d0468c2e5f9 - std[d054f6f42beb1baa]::sys::backtrace::__rust_end_short_backtrace:: [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:182:18 [INFO] [stdout] 17: 0x5d0468c37bad - __rustc[7ab284efd7f33ea8]::rust_begin_unwind [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:689:5 [INFO] [stdout] 18: 0x5d0468c6f26c - core[5a1c3e9896636f3a]::panicking::panic_fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panicking.rs:80:14 [INFO] [stdout] 19: 0x5d0468c6efb2 - core[5a1c3e9896636f3a]::result::unwrap_failed [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/result.rs:1872:5 [INFO] [stdout] 20: 0x5d0468accbd7 - , symphony[9e94a00ed0030622]::error::SymphonyError>>::expect [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/result.rs:1185:23 [INFO] [stdout] 21: 0x5d0468ac5272 - codex_protocol[967957b8baebdca0]::sends_schema_shaped_startup_messages_and_streams_completion::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/codex_protocol.rs:146:25 [INFO] [stdout] 22: 0x5d0468acf272 - > as core[5a1c3e9896636f3a]::future::future::Future>::poll [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/future/future.rs:133:9 [INFO] [stdout] 23: 0x5d0468acf2ed - >> as core[5a1c3e9896636f3a]::future::future::Future>::poll [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/future/future.rs:133:9 [INFO] [stdout] 24: 0x5d0468ac24ad - ::block_on::>>>::{closure#0}::{closure#0}::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:778:70 [INFO] [stdout] 25: 0x5d0468ac23ab - tokio[efdb887346cc66e5]::task::coop::with_budget::, ::block_on>>>::{closure#0}::{closure#0}::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/task/coop/mod.rs:167:5 [INFO] [stdout] 26: 0x5d0468ac23ab - tokio[efdb887346cc66e5]::task::coop::budget::, ::block_on>>>::{closure#0}::{closure#0}::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/task/coop/mod.rs:133:5 [INFO] [stdout] 27: 0x5d0468ac23ab - ::block_on::>>>::{closure#0}::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:778:25 [INFO] [stdout] 28: 0x5d0468abec80 - ::enter::, ::block_on>>>::{closure#0}::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:451:19 [INFO] [stdout] 29: 0x5d0468ac172d - ::block_on::>>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:777:44 [INFO] [stdout] 30: 0x5d0468ac09d4 - ::enter::<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:865:68 [INFO] [stdout] 31: 0x5d0468ad026b - >::set::<::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}, (alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>)> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context/scoped.rs:40:9 [INFO] [stdout] 32: 0x5d0468ad27c9 - tokio[efdb887346cc66e5]::runtime::context::set_scheduler::<(alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context.rs:181:38 [INFO] [stdout] 33: 0x5d0468ad0a12 - >::try_with::, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>)> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/local.rs:462:12 [INFO] [stdout] 34: 0x5d0468ad059e - >::with::, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>)> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/local.rs:426:20 [INFO] [stdout] 35: 0x5d0468ad197d - tokio[efdb887346cc66e5]::runtime::context::set_scheduler::<(alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context.rs:181:17 [INFO] [stdout] 36: 0x5d0468abfd20 - ::enter::<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:865:27 [INFO] [stdout] 37: 0x5d0468ac0016 - ::block_on::>>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:765:24 [INFO] [stdout] 38: 0x5d0468ac05e0 - ::block_on::>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:205:33 [INFO] [stdout] 39: 0x5d0468acb5f3 - tokio[efdb887346cc66e5]::runtime::context::runtime::enter_runtime::<::block_on>>::{closure#0}, ()> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context/runtime.rs:65:16 [INFO] [stdout] 40: 0x5d0468abe7b1 - ::block_on::>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:193:9 [INFO] [stdout] 41: 0x5d0468acfdf4 - ::block_on_inner::>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/runtime.rs:371:52 [INFO] [stdout] 42: 0x5d0468acffbf - ::block_on::>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/runtime.rs:345:18 [INFO] [stdout] 43: 0x5d0468ac8d01 - codex_protocol[967957b8baebdca0]::sends_schema_shaped_startup_messages_and_streams_completion [INFO] [stdout] at /opt/rustwide/workdir/tests/codex_protocol.rs:186:6 [INFO] [stdout] 44: 0x5d0468ac32f7 - codex_protocol[967957b8baebdca0]::sends_schema_shaped_startup_messages_and_streams_completion::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/codex_protocol.rs:144:71 [INFO] [stdout] 45: 0x5d0468acfaa6 - >::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 46: 0x5d0468ad489b - core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 47: 0x5d0468ad489b - test[fad20673b750c10e]::__rust_begin_short_backtrace::, fn() -> core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:724:18 [INFO] [stdout] 48: 0x5d0468ae2115 - test[fad20673b750c10e]::run_test_in_process::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:74 [INFO] [stdout] 49: 0x5d0468ae2115 - as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 50: 0x5d0468ae2115 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40 [INFO] [stdout] 51: 0x5d0468ae2115 - std[d054f6f42beb1baa]::panicking::catch_unwind::, core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19 [INFO] [stdout] 52: 0x5d0468ae2115 - std[d054f6f42beb1baa]::panic::catch_unwind::, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14 [INFO] [stdout] 53: 0x5d0468ae2115 - test[fad20673b750c10e]::run_test_in_process [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:27 [INFO] [stdout] 54: 0x5d0468ae2115 - test[fad20673b750c10e]::run_test::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:668:43 [INFO] [stdout] 55: 0x5d0468adcc74 - test[fad20673b750c10e]::run_test::{closure#1} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:698:41 [INFO] [stdout] 56: 0x5d0468adcc74 - std[d054f6f42beb1baa]::sys::backtrace::__rust_begin_short_backtrace:: [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:166:18 [INFO] [stdout] 57: 0x5d0468ae5192 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::::{closure#1}::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:70:13 [INFO] [stdout] 58: 0x5d0468ae5192 - ::{closure#1}::{closure#0}> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 59: 0x5d0468ae5192 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40 [INFO] [stdout] 60: 0x5d0468ae5192 - std[d054f6f42beb1baa]::panicking::catch_unwind::<(), core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe::{closure#1}::{closure#0}>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19 [INFO] [stdout] 61: 0x5d0468ae5192 - std[d054f6f42beb1baa]::panic::catch_unwind::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14 [INFO] [stdout] 62: 0x5d0468ae5192 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::::{closure#1} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:68:26 [INFO] [stdout] 63: 0x5d0468ae5192 - ::{closure#1} as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 64: 0x5d0468c5918f - + core[5a1c3e9896636f3a]::marker::Send> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2277:9 [INFO] [stdout] 65: 0x5d0468c5918f - ::new::thread_start [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/thread/unix.rs:118:17 [INFO] [stdout] 66: 0x79c2be534aa4 - [INFO] [stdout] 67: 0x79c2be5c1a64 - clone [INFO] [stdout] 68: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- user_input_required_fails_without_stalling stdout ---- [INFO] [stdout] [INFO] [stdout] thread 'user_input_required_fails_without_stalling' (246) panicked at tests/codex_protocol.rs:251:5: [INFO] [stdout] codex_error kind=timeout message=timed out waiting for codex response [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5d0468c59d48 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::libunwind::trace [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x5d0468c59d48 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::trace_unsynchronized:: [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x5d0468c59d48 - std[d054f6f42beb1baa]::sys::backtrace::_print_fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:74:9 [INFO] [stdout] 3: 0x5d0468c59d48 - <::print::DisplayBacktrace as core[5a1c3e9896636f3a]::fmt::Display>::fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:44:26 [INFO] [stdout] 4: 0x5d0468c6ea7a - ::fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/fmt/rt.rs:152:76 [INFO] [stdout] 5: 0x5d0468c6ea7a - core[5a1c3e9896636f3a]::fmt::write [INFO] [stdout] 6: 0x5d0468c5e782 - std[d054f6f42beb1baa]::io::default_write_fmt::> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:622:11 [INFO] [stdout] 7: 0x5d0468c5e782 - as std[d054f6f42beb1baa]::io::Write>::write_fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:1977:13 [INFO] [stdout] 8: 0x5d0468c36dd6 - ::print [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:47:9 [INFO] [stdout] 9: 0x5d0468c36dd6 - std[d054f6f42beb1baa]::panicking::default_hook::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:292:27 [INFO] [stdout] 10: 0x5d0468c51639 - std[d054f6f42beb1baa]::panicking::default_hook [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:316:9 [INFO] [stdout] 11: 0x5d0468ae17bc - core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9 [INFO] [stdout] 12: 0x5d0468ae17bc - test[fad20673b750c10e]::test_main_inner::::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:155:21 [INFO] [stdout] 13: 0x5d0468c518b2 - core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9 [INFO] [stdout] 14: 0x5d0468c518b2 - std[d054f6f42beb1baa]::panicking::panic_with_hook [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:833:13 [INFO] [stdout] 15: 0x5d0468c36e92 - std[d054f6f42beb1baa]::panicking::panic_handler::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:698:13 [INFO] [stdout] 16: 0x5d0468c2e5f9 - std[d054f6f42beb1baa]::sys::backtrace::__rust_end_short_backtrace:: [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:182:18 [INFO] [stdout] 17: 0x5d0468c37bad - __rustc[7ab284efd7f33ea8]::rust_begin_unwind [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:689:5 [INFO] [stdout] 18: 0x5d0468c6f26c - core[5a1c3e9896636f3a]::panicking::panic_fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panicking.rs:80:14 [INFO] [stdout] 19: 0x5d0468ac42fa - codex_protocol[967957b8baebdca0]::user_input_required_fails_without_stalling::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/codex_protocol.rs:251:5 [INFO] [stdout] 20: 0x5d0468acf272 - > as core[5a1c3e9896636f3a]::future::future::Future>::poll [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/future/future.rs:133:9 [INFO] [stdout] 21: 0x5d0468acf2ed - >> as core[5a1c3e9896636f3a]::future::future::Future>::poll [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/future/future.rs:133:9 [INFO] [stdout] 22: 0x5d0468ac24ad - ::block_on::>>>::{closure#0}::{closure#0}::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:778:70 [INFO] [stdout] 23: 0x5d0468ac23ab - tokio[efdb887346cc66e5]::task::coop::with_budget::, ::block_on>>>::{closure#0}::{closure#0}::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/task/coop/mod.rs:167:5 [INFO] [stdout] 24: 0x5d0468ac23ab - tokio[efdb887346cc66e5]::task::coop::budget::, ::block_on>>>::{closure#0}::{closure#0}::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/task/coop/mod.rs:133:5 [INFO] [stdout] 25: 0x5d0468ac23ab - ::block_on::>>>::{closure#0}::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:778:25 [INFO] [stdout] 26: 0x5d0468abec80 - ::enter::, ::block_on>>>::{closure#0}::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:451:19 [INFO] [stdout] 27: 0x5d0468ac172d - ::block_on::>>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:777:44 [INFO] [stdout] 28: 0x5d0468ac09d4 - ::enter::<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:865:68 [INFO] [stdout] 29: 0x5d0468ad026b - >::set::<::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}, (alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>)> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context/scoped.rs:40:9 [INFO] [stdout] 30: 0x5d0468ad27c9 - tokio[efdb887346cc66e5]::runtime::context::set_scheduler::<(alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context.rs:181:38 [INFO] [stdout] 31: 0x5d0468ad0a12 - >::try_with::, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>)> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/local.rs:462:12 [INFO] [stdout] 32: 0x5d0468ad059e - >::with::, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>)> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/local.rs:426:20 [INFO] [stdout] 33: 0x5d0468ad197d - tokio[efdb887346cc66e5]::runtime::context::set_scheduler::<(alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context.rs:181:17 [INFO] [stdout] 34: 0x5d0468abfd20 - ::enter::<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:865:27 [INFO] [stdout] 35: 0x5d0468ac0016 - ::block_on::>>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:765:24 [INFO] [stdout] 36: 0x5d0468ac05e0 - ::block_on::>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:205:33 [INFO] [stdout] 37: 0x5d0468acb5f3 - tokio[efdb887346cc66e5]::runtime::context::runtime::enter_runtime::<::block_on>>::{closure#0}, ()> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context/runtime.rs:65:16 [INFO] [stdout] 38: 0x5d0468abe7b1 - ::block_on::>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:193:9 [INFO] [stdout] 39: 0x5d0468acfdf4 - ::block_on_inner::>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/runtime.rs:371:52 [INFO] [stdout] 40: 0x5d0468acffbf - ::block_on::>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/runtime.rs:345:18 [INFO] [stdout] 41: 0x5d0468ac87c1 - codex_protocol[967957b8baebdca0]::user_input_required_fails_without_stalling [INFO] [stdout] at /opt/rustwide/workdir/tests/codex_protocol.rs:256:6 [INFO] [stdout] 42: 0x5d0468ac3267 - codex_protocol[967957b8baebdca0]::user_input_required_fails_without_stalling::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/codex_protocol.rs:248:54 [INFO] [stdout] 43: 0x5d0468acf9e6 - >::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 44: 0x5d0468ad489b - core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 45: 0x5d0468ad489b - test[fad20673b750c10e]::__rust_begin_short_backtrace::, fn() -> core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:724:18 [INFO] [stdout] 46: 0x5d0468ae2115 - test[fad20673b750c10e]::run_test_in_process::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:74 [INFO] [stdout] 47: 0x5d0468ae2115 - as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 48: 0x5d0468ae2115 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40 [INFO] [stdout] 49: 0x5d0468ae2115 - std[d054f6f42beb1baa]::panicking::catch_unwind::, core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19 [INFO] [stdout] 50: 0x5d0468ae2115 - std[d054f6f42beb1baa]::panic::catch_unwind::, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14 [INFO] [stdout] 51: 0x5d0468ae2115 - test[fad20673b750c10e]::run_test_in_process [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:27 [INFO] [stdout] 52: 0x5d0468ae2115 - test[fad20673b750c10e]::run_test::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:668:43 [INFO] [stdout] 53: 0x5d0468adcc74 - test[fad20673b750c10e]::run_test::{closure#1} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:698:41 [INFO] [stdout] 54: 0x5d0468adcc74 - std[d054f6f42beb1baa]::sys::backtrace::__rust_begin_short_backtrace:: [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:166:18 [INFO] [stdout] 55: 0x5d0468ae5192 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::::{closure#1}::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:70:13 [INFO] [stdout] 56: 0x5d0468ae5192 - ::{closure#1}::{closure#0}> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 57: 0x5d0468ae5192 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40 [INFO] [stdout] 58: 0x5d0468ae5192 - std[d054f6f42beb1baa]::panicking::catch_unwind::<(), core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe::{closure#1}::{closure#0}>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19 [INFO] [stdout] 59: 0x5d0468ae5192 - std[d054f6f42beb1baa]::panic::catch_unwind::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14 [INFO] [stdout] 60: 0x5d0468ae5192 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::::{closure#1} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:68:26 [INFO] [stdout] 61: 0x5d0468ae5192 - ::{closure#1} as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 62: 0x5d0468c5918f - + core[5a1c3e9896636f3a]::marker::Send> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2277:9 [INFO] [stdout] 63: 0x5d0468c5918f - ::new::thread_start [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/thread/unix.rs:118:17 [INFO] [stdout] 64: 0x79c2be534aa4 - [INFO] [stdout] 65: 0x79c2be5c1a64 - clone [INFO] [stdout] 66: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- unsupported_dynamic_tool_calls_return_unsuccessful_response stdout ---- [INFO] [stdout] [INFO] [stdout] thread 'unsupported_dynamic_tool_calls_return_unsuccessful_response' (245) panicked at tests/codex_protocol.rs:235:12: [INFO] [stdout] run completes: Codex { kind: "timeout", message: "timed out waiting for codex response" } [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5d0468c59d48 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::libunwind::trace [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x5d0468c59d48 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::trace_unsynchronized:: [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x5d0468c59d48 - std[d054f6f42beb1baa]::sys::backtrace::_print_fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:74:9 [INFO] [stdout] 3: 0x5d0468c59d48 - <::print::DisplayBacktrace as core[5a1c3e9896636f3a]::fmt::Display>::fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:44:26 [INFO] [stdout] 4: 0x5d0468c6ea7a - ::fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/fmt/rt.rs:152:76 [INFO] [stdout] 5: 0x5d0468c6ea7a - core[5a1c3e9896636f3a]::fmt::write [INFO] [stdout] 6: 0x5d0468c5e782 - std[d054f6f42beb1baa]::io::default_write_fmt::> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:622:11 [INFO] [stdout] 7: 0x5d0468c5e782 - as std[d054f6f42beb1baa]::io::Write>::write_fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:1977:13 [INFO] [stdout] 8: 0x5d0468c36dd6 - ::print [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:47:9 [INFO] [stdout] 9: 0x5d0468c36dd6 - std[d054f6f42beb1baa]::panicking::default_hook::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:292:27 [INFO] [stdout] 10: 0x5d0468c51639 - std[d054f6f42beb1baa]::panicking::default_hook [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:316:9 [INFO] [stdout] 11: 0x5d0468ae17bc - core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9 [INFO] [stdout] 12: 0x5d0468ae17bc - test[fad20673b750c10e]::test_main_inner::::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:155:21 [INFO] [stdout] 13: 0x5d0468c518b2 - core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9 [INFO] [stdout] 14: 0x5d0468c518b2 - std[d054f6f42beb1baa]::panicking::panic_with_hook [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:833:13 [INFO] [stdout] 15: 0x5d0468c36e92 - std[d054f6f42beb1baa]::panicking::panic_handler::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:698:13 [INFO] [stdout] 16: 0x5d0468c2e5f9 - std[d054f6f42beb1baa]::sys::backtrace::__rust_end_short_backtrace:: [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:182:18 [INFO] [stdout] 17: 0x5d0468c37bad - __rustc[7ab284efd7f33ea8]::rust_begin_unwind [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:689:5 [INFO] [stdout] 18: 0x5d0468c6f26c - core[5a1c3e9896636f3a]::panicking::panic_fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panicking.rs:80:14 [INFO] [stdout] 19: 0x5d0468c6efb2 - core[5a1c3e9896636f3a]::result::unwrap_failed [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/result.rs:1872:5 [INFO] [stdout] 20: 0x5d0468accbd7 - , symphony[9e94a00ed0030622]::error::SymphonyError>>::expect [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/result.rs:1185:23 [INFO] [stdout] 21: 0x5d0468ac6f0f - codex_protocol[967957b8baebdca0]::unsupported_dynamic_tool_calls_return_unsuccessful_response::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/codex_protocol.rs:235:12 [INFO] [stdout] 22: 0x5d0468acf272 - > as core[5a1c3e9896636f3a]::future::future::Future>::poll [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/future/future.rs:133:9 [INFO] [stdout] 23: 0x5d0468acf2ed - >> as core[5a1c3e9896636f3a]::future::future::Future>::poll [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/future/future.rs:133:9 [INFO] [stdout] 24: 0x5d0468ac24ad - ::block_on::>>>::{closure#0}::{closure#0}::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:778:70 [INFO] [stdout] 25: 0x5d0468ac23ab - tokio[efdb887346cc66e5]::task::coop::with_budget::, ::block_on>>>::{closure#0}::{closure#0}::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/task/coop/mod.rs:167:5 [INFO] [stdout] 26: 0x5d0468ac23ab - tokio[efdb887346cc66e5]::task::coop::budget::, ::block_on>>>::{closure#0}::{closure#0}::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/task/coop/mod.rs:133:5 [INFO] [stdout] 27: 0x5d0468ac23ab - ::block_on::>>>::{closure#0}::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:778:25 [INFO] [stdout] 28: 0x5d0468abec80 - ::enter::, ::block_on>>>::{closure#0}::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:451:19 [INFO] [stdout] 29: 0x5d0468ac172d - ::block_on::>>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:777:44 [INFO] [stdout] 30: 0x5d0468ac09d4 - ::enter::<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:865:68 [INFO] [stdout] 31: 0x5d0468ad026b - >::set::<::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}, (alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>)> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context/scoped.rs:40:9 [INFO] [stdout] 32: 0x5d0468ad27c9 - tokio[efdb887346cc66e5]::runtime::context::set_scheduler::<(alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context.rs:181:38 [INFO] [stdout] 33: 0x5d0468ad0a12 - >::try_with::, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>)> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/local.rs:462:12 [INFO] [stdout] 34: 0x5d0468ad059e - >::with::, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>)> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/local.rs:426:20 [INFO] [stdout] 35: 0x5d0468ad197d - tokio[efdb887346cc66e5]::runtime::context::set_scheduler::<(alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context.rs:181:17 [INFO] [stdout] 36: 0x5d0468abfd20 - ::enter::<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:865:27 [INFO] [stdout] 37: 0x5d0468ac0016 - ::block_on::>>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:765:24 [INFO] [stdout] 38: 0x5d0468ac05e0 - ::block_on::>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:205:33 [INFO] [stdout] 39: 0x5d0468acb5f3 - tokio[efdb887346cc66e5]::runtime::context::runtime::enter_runtime::<::block_on>>::{closure#0}, ()> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context/runtime.rs:65:16 [INFO] [stdout] 40: 0x5d0468abe7b1 - ::block_on::>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:193:9 [INFO] [stdout] 41: 0x5d0468acfdf4 - ::block_on_inner::>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/runtime.rs:371:52 [INFO] [stdout] 42: 0x5d0468acffbf - ::block_on::>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/runtime.rs:345:18 [INFO] [stdout] 43: 0x5d0468ac8ec1 - codex_protocol[967957b8baebdca0]::unsupported_dynamic_tool_calls_return_unsuccessful_response [INFO] [stdout] at /opt/rustwide/workdir/tests/codex_protocol.rs:244:6 [INFO] [stdout] 44: 0x5d0468ac3327 - codex_protocol[967957b8baebdca0]::unsupported_dynamic_tool_calls_return_unsuccessful_response::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/codex_protocol.rs:233:71 [INFO] [stdout] 45: 0x5d0468acfae6 - >::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 46: 0x5d0468ad489b - core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 47: 0x5d0468ad489b - test[fad20673b750c10e]::__rust_begin_short_backtrace::, fn() -> core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:724:18 [INFO] [stdout] 48: 0x5d0468ae2115 - test[fad20673b750c10e]::run_test_in_process::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:74 [INFO] [stdout] 49: 0x5d0468ae2115 - as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 50: 0x5d0468ae2115 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40 [INFO] [stdout] 51: 0x5d0468ae2115 - std[d054f6f42beb1baa]::panicking::catch_unwind::, core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19 [INFO] [stdout] 52: 0x5d0468ae2115 - std[d054f6f42beb1baa]::panic::catch_unwind::, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14 [INFO] [stdout] 53: 0x5d0468ae2115 - test[fad20673b750c10e]::run_test_in_process [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:27 [INFO] [stdout] 54: 0x5d0468ae2115 - test[fad20673b750c10e]::run_test::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:668:43 [INFO] [stdout] 55: 0x5d0468adcc74 - test[fad20673b750c10e]::run_test::{closure#1} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:698:41 [INFO] [stdout] 56: 0x5d0468adcc74 - std[d054f6f42beb1baa]::sys::backtrace::__rust_begin_short_backtrace:: [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:166:18 [INFO] [stdout] 57: 0x5d0468ae5192 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::::{closure#1}::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:70:13 [INFO] [stdout] 58: 0x5d0468ae5192 - ::{closure#1}::{closure#0}> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 59: 0x5d0468ae5192 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40 [INFO] [stdout] 60: 0x5d0468ae5192 - std[d054f6f42beb1baa]::panicking::catch_unwind::<(), core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe::{closure#1}::{closure#0}>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19 [INFO] [stdout] 61: 0x5d0468ae5192 - std[d054f6f42beb1baa]::panic::catch_unwind::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14 [INFO] [stdout] 62: 0x5d0468ae5192 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::::{closure#1} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:68:26 [INFO] [stdout] 63: 0x5d0468ae5192 - ::{closure#1} as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 64: 0x5d0468c5918f - + core[5a1c3e9896636f3a]::marker::Send> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2277:9 [INFO] [stdout] 65: 0x5d0468c5918f - ::new::thread_start [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/thread/unix.rs:118:17 [INFO] [stdout] 66: 0x79c2be534aa4 - [INFO] [stdout] 67: 0x79c2be5c1a64 - clone [INFO] [stdout] 68: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- malformed_messages_are_reported_and_fail_the_run stdout ---- [INFO] [stdout] [INFO] [stdout] thread 'malformed_messages_are_reported_and_fail_the_run' (242) panicked at tests/codex_protocol.rs:265:5: [INFO] [stdout] codex_error kind=timeout message=timed out waiting for codex response [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5d0468c59d48 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::libunwind::trace [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x5d0468c59d48 - std[d054f6f42beb1baa]::backtrace_rs::backtrace::trace_unsynchronized:: [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x5d0468c59d48 - std[d054f6f42beb1baa]::sys::backtrace::_print_fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:74:9 [INFO] [stdout] 3: 0x5d0468c59d48 - <::print::DisplayBacktrace as core[5a1c3e9896636f3a]::fmt::Display>::fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:44:26 [INFO] [stdout] 4: 0x5d0468c6ea7a - ::fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/fmt/rt.rs:152:76 [INFO] [stdout] 5: 0x5d0468c6ea7a - core[5a1c3e9896636f3a]::fmt::write [INFO] [stdout] 6: 0x5d0468c5e782 - std[d054f6f42beb1baa]::io::default_write_fmt::> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:622:11 [INFO] [stdout] 7: 0x5d0468c5e782 - as std[d054f6f42beb1baa]::io::Write>::write_fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/io/mod.rs:1977:13 [INFO] [stdout] 8: 0x5d0468c36dd6 - ::print [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:47:9 [INFO] [stdout] 9: 0x5d0468c36dd6 - std[d054f6f42beb1baa]::panicking::default_hook::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:292:27 [INFO] [stdout] 10: 0x5d0468c51639 - std[d054f6f42beb1baa]::panicking::default_hook [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:316:9 [INFO] [stdout] 11: 0x5d0468ae17bc - core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9 [INFO] [stdout] 12: 0x5d0468ae17bc - test[fad20673b750c10e]::test_main_inner::::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:155:21 [INFO] [stdout] 13: 0x5d0468c518b2 - core[5a1c3e9896636f3a]::ops::function::Fn<(&'a std[d054f6f42beb1baa]::panic::PanicHookInfo<'b>,), Output = ()> + core[5a1c3e9896636f3a]::marker::Send + core[5a1c3e9896636f3a]::marker::Sync> as core[5a1c3e9896636f3a]::ops::function::Fn<(&std[d054f6f42beb1baa]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2291:9 [INFO] [stdout] 14: 0x5d0468c518b2 - std[d054f6f42beb1baa]::panicking::panic_with_hook [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:833:13 [INFO] [stdout] 15: 0x5d0468c36e92 - std[d054f6f42beb1baa]::panicking::panic_handler::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:698:13 [INFO] [stdout] 16: 0x5d0468c2e5f9 - std[d054f6f42beb1baa]::sys::backtrace::__rust_end_short_backtrace:: [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:182:18 [INFO] [stdout] 17: 0x5d0468c37bad - __rustc[7ab284efd7f33ea8]::rust_begin_unwind [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:689:5 [INFO] [stdout] 18: 0x5d0468c6f26c - core[5a1c3e9896636f3a]::panicking::panic_fmt [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panicking.rs:80:14 [INFO] [stdout] 19: 0x5d0468ac488b - codex_protocol[967957b8baebdca0]::malformed_messages_are_reported_and_fail_the_run::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/codex_protocol.rs:265:5 [INFO] [stdout] 20: 0x5d0468acf272 - > as core[5a1c3e9896636f3a]::future::future::Future>::poll [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/future/future.rs:133:9 [INFO] [stdout] 21: 0x5d0468acf2ed - >> as core[5a1c3e9896636f3a]::future::future::Future>::poll [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/future/future.rs:133:9 [INFO] [stdout] 22: 0x5d0468ac24ad - ::block_on::>>>::{closure#0}::{closure#0}::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:778:70 [INFO] [stdout] 23: 0x5d0468ac23ab - tokio[efdb887346cc66e5]::task::coop::with_budget::, ::block_on>>>::{closure#0}::{closure#0}::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/task/coop/mod.rs:167:5 [INFO] [stdout] 24: 0x5d0468ac23ab - tokio[efdb887346cc66e5]::task::coop::budget::, ::block_on>>>::{closure#0}::{closure#0}::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/task/coop/mod.rs:133:5 [INFO] [stdout] 25: 0x5d0468ac23ab - ::block_on::>>>::{closure#0}::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:778:25 [INFO] [stdout] 26: 0x5d0468abec80 - ::enter::, ::block_on>>>::{closure#0}::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:451:19 [INFO] [stdout] 27: 0x5d0468ac172d - ::block_on::>>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:777:44 [INFO] [stdout] 28: 0x5d0468ac09d4 - ::enter::<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:865:68 [INFO] [stdout] 29: 0x5d0468ad026b - >::set::<::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}, (alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>)> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context/scoped.rs:40:9 [INFO] [stdout] 30: 0x5d0468ad27c9 - tokio[efdb887346cc66e5]::runtime::context::set_scheduler::<(alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context.rs:181:38 [INFO] [stdout] 31: 0x5d0468ad0a12 - >::try_with::, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>)> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/local.rs:462:12 [INFO] [stdout] 32: 0x5d0468ad059e - >::with::, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>)> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/local.rs:426:20 [INFO] [stdout] 33: 0x5d0468ad197d - tokio[efdb887346cc66e5]::runtime::context::set_scheduler::<(alloc[154f689e5dd3bae5]::boxed::Box, core[5a1c3e9896636f3a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>>::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context.rs:181:17 [INFO] [stdout] 34: 0x5d0468abfd20 - ::enter::<::block_on>>>::{closure#0}, core[5a1c3e9896636f3a]::option::Option<()>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:865:27 [INFO] [stdout] 35: 0x5d0468ac0016 - ::block_on::>>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:765:24 [INFO] [stdout] 36: 0x5d0468ac05e0 - ::block_on::>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:205:33 [INFO] [stdout] 37: 0x5d0468acb5f3 - tokio[efdb887346cc66e5]::runtime::context::runtime::enter_runtime::<::block_on>>::{closure#0}, ()> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/context/runtime.rs:65:16 [INFO] [stdout] 38: 0x5d0468abe7b1 - ::block_on::>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/scheduler/current_thread/mod.rs:193:9 [INFO] [stdout] 39: 0x5d0468acfdf4 - ::block_on_inner::>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/runtime.rs:371:52 [INFO] [stdout] 40: 0x5d0468acffbf - ::block_on::>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.3/src/runtime/runtime.rs:345:18 [INFO] [stdout] 41: 0x5d0468ac8981 - codex_protocol[967957b8baebdca0]::malformed_messages_are_reported_and_fail_the_run [INFO] [stdout] at /opt/rustwide/workdir/tests/codex_protocol.rs:265:57 [INFO] [stdout] 42: 0x5d0468ac3297 - codex_protocol[967957b8baebdca0]::malformed_messages_are_reported_and_fail_the_run::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/codex_protocol.rs:260:60 [INFO] [stdout] 43: 0x5d0468acfa26 - >::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 44: 0x5d0468ad489b - core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 45: 0x5d0468ad489b - test[fad20673b750c10e]::__rust_begin_short_backtrace::, fn() -> core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:724:18 [INFO] [stdout] 46: 0x5d0468ae2115 - test[fad20673b750c10e]::run_test_in_process::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:74 [INFO] [stdout] 47: 0x5d0468ae2115 - as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 48: 0x5d0468ae2115 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40 [INFO] [stdout] 49: 0x5d0468ae2115 - std[d054f6f42beb1baa]::panicking::catch_unwind::, core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19 [INFO] [stdout] 50: 0x5d0468ae2115 - std[d054f6f42beb1baa]::panic::catch_unwind::, core[5a1c3e9896636f3a]::result::Result<(), alloc[154f689e5dd3bae5]::string::String>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14 [INFO] [stdout] 51: 0x5d0468ae2115 - test[fad20673b750c10e]::run_test_in_process [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:747:27 [INFO] [stdout] 52: 0x5d0468ae2115 - test[fad20673b750c10e]::run_test::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:668:43 [INFO] [stdout] 53: 0x5d0468adcc74 - test[fad20673b750c10e]::run_test::{closure#1} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/test/src/lib.rs:698:41 [INFO] [stdout] 54: 0x5d0468adcc74 - std[d054f6f42beb1baa]::sys::backtrace::__rust_begin_short_backtrace:: [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/backtrace.rs:166:18 [INFO] [stdout] 55: 0x5d0468ae5192 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::::{closure#1}::{closure#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:70:13 [INFO] [stdout] 56: 0x5d0468ae5192 - ::{closure#1}::{closure#0}> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 57: 0x5d0468ae5192 - std[d054f6f42beb1baa]::panicking::catch_unwind::do_call::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:581:40 [INFO] [stdout] 58: 0x5d0468ae5192 - std[d054f6f42beb1baa]::panicking::catch_unwind::<(), core[5a1c3e9896636f3a]::panic::unwind_safe::AssertUnwindSafe::{closure#1}::{closure#0}>> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panicking.rs:544:19 [INFO] [stdout] 59: 0x5d0468ae5192 - std[d054f6f42beb1baa]::panic::catch_unwind::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/panic.rs:359:14 [INFO] [stdout] 60: 0x5d0468ae5192 - std[d054f6f42beb1baa]::thread::lifecycle::spawn_unchecked::::{closure#1} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/thread/lifecycle.rs:68:26 [INFO] [stdout] 61: 0x5d0468ae5192 - ::{closure#1} as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0} [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 62: 0x5d0468c5918f - + core[5a1c3e9896636f3a]::marker::Send> as core[5a1c3e9896636f3a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/alloc/src/boxed.rs:2277:9 [INFO] [stdout] 63: 0x5d0468c5918f - ::new::thread_start [INFO] [stdout] at /rustc/28f95933dc0727396c07b48d0a8cb5211b7fb472/library/std/src/sys/thread/unix.rs:118:17 [INFO] [stdout] 64: 0x79c2be534aa4 - [INFO] [stdout] 65: 0x79c2be5c1a64 - clone [INFO] [stdout] 66: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] auto_approves_command_and_file_requests_for_session [INFO] [stdout] extracts_token_totals_and_rate_limits [INFO] [stdout] malformed_messages_are_reported_and_fail_the_run [INFO] [stdout] sends_schema_shaped_startup_messages_and_streams_completion [INFO] [stdout] unsupported_dynamic_tool_calls_return_unsuccessful_response [INFO] [stdout] user_input_required_fails_without_stalling [INFO] [stdout] [INFO] [stdout] test result: FAILED. 1 passed; 6 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.42s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--test codex_protocol` [INFO] running `Command { std: "docker" "inspect" "37fa24a5f2fb2ce90320caffd16eb66d8aaedda5566a1be9aaa4b778515c43d6", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "37fa24a5f2fb2ce90320caffd16eb66d8aaedda5566a1be9aaa4b778515c43d6", kill_on_drop: false }` [INFO] [stdout] 37fa24a5f2fb2ce90320caffd16eb66d8aaedda5566a1be9aaa4b778515c43d6