[INFO] cloning repository https://github.com/CVPaul/xcode-rs
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/CVPaul/xcode-rs" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FCVPaul%2Fxcode-rs", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FCVPaul%2Fxcode-rs'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 0e6eeca55798ced4e01eed5e4ca1266341774fe8
[INFO] testing CVPaul/xcode-rs against try#33835004928d3bf65db4d4712e1330766263b0bd for pr-155739
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FCVPaul%2Fxcode-rs" "/workspace/builds/worker-7-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-7-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/CVPaul/xcode-rs
[INFO] finished tweaking git repo https://github.com/CVPaul/xcode-rs
[INFO] tweaked toml for git repo https://github.com/CVPaul/xcode-rs written to /workspace/builds/worker-7-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/CVPaul/xcode-rs on toolchain 33835004928d3bf65db4d4712e1330766263b0bd
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+33835004928d3bf65db4d4712e1330766263b0bd" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/CVPaul/xcode-rs 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" "+33835004928d3bf65db4d4712e1330766263b0bd" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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" "+33835004928d3bf65db4d4712e1330766263b0bd" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 8762a7cf063fd63756fa5a83c3e9d27f0d72df633a44edee86ae31c8e6435042
[INFO] running `Command { std: "docker" "start" "-a" "8762a7cf063fd63756fa5a83c3e9d27f0d72df633a44edee86ae31c8e6435042", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "8762a7cf063fd63756fa5a83c3e9d27f0d72df633a44edee86ae31c8e6435042", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8762a7cf063fd63756fa5a83c3e9d27f0d72df633a44edee86ae31c8e6435042", kill_on_drop: false }`
[INFO] [stdout] 8762a7cf063fd63756fa5a83c3e9d27f0d72df633a44edee86ae31c8e6435042
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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" "+33835004928d3bf65db4d4712e1330766263b0bd" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 3f0d801b3cc88b8bfcb3a4fb9b489ba68303fbff52bc625a74d1683efe112524
[INFO] running `Command { std: "docker" "start" "-a" "3f0d801b3cc88b8bfcb3a4fb9b489ba68303fbff52bc625a74d1683efe112524", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling unicode-ident v1.0.24
[INFO] [stderr]    Compiling quote v1.0.44
[INFO] [stderr]    Compiling cfg-if v1.0.4
[INFO] [stderr]    Compiling libc v0.2.182
[INFO] [stderr]    Compiling log v0.4.29
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling scopeguard v1.2.0
[INFO] [stderr]    Compiling lock_api v0.4.14
[INFO] [stderr]    Compiling memchr v2.8.0
[INFO] [stderr]    Compiling bitflags v2.11.0
[INFO] [stderr]    Compiling stable_deref_trait v1.2.1
[INFO] [stderr]    Compiling pin-project-lite v0.2.17
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling futures-core v0.3.32
[INFO] [stderr]    Compiling bytes v1.11.1
[INFO] [stderr]    Compiling crossbeam-utils v0.8.21
[INFO] [stderr]    Compiling find-msvc-tools v0.1.9
[INFO] [stderr]    Compiling itoa v1.0.17
[INFO] [stderr]    Compiling shlex v1.3.0
[INFO] [stderr]    Compiling autocfg v1.5.0
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling vcpkg v0.2.15
[INFO] [stderr]    Compiling cc v1.2.56
[INFO] [stderr]    Compiling pkg-config v0.3.32
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling siphasher v1.0.2
[INFO] [stderr]    Compiling zerocopy v0.8.40
[INFO] [stderr]    Compiling phf_shared v0.11.3
[INFO] [stderr]    Compiling tracing-core v0.1.36
[INFO] [stderr]    Compiling new_debug_unreachable v1.0.6
[INFO] [stderr]    Compiling signal-hook v0.3.18
[INFO] [stderr]    Compiling http v1.4.0
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling linux-raw-sys v0.12.1
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling mio v1.1.1
[INFO] [stderr]    Compiling socket2 v0.6.2
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.18
[INFO] [stderr]    Compiling regex-syntax v0.8.10
[INFO] [stderr]    Compiling slab v0.4.12
[INFO] [stderr]    Compiling crossbeam-deque v0.8.6
[INFO] [stderr]    Compiling phf_generator v0.11.3
[INFO] [stderr]    Compiling http-body v1.0.1
[INFO] [stderr]    Compiling openssl-sys v0.9.111
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling convert_case v0.10.0
[INFO] [stderr]    Compiling writeable v0.6.2
[INFO] [stderr]    Compiling futures-task v0.3.32
[INFO] [stderr]    Compiling simd-adler32 v0.3.8
[INFO] [stderr]    Compiling litemap v0.8.1
[INFO] [stderr]    Compiling tower-service v0.3.3
[INFO] [stderr]    Compiling string_cache_codegen v0.5.4
[INFO] [stderr]    Compiling phf_codegen v0.11.3
[INFO] [stderr]    Compiling num-integer v0.1.46
[INFO] [stderr]    Compiling aho-corasick v1.1.4
[INFO] [stderr]    Compiling equivalent v1.0.2
[INFO] [stderr]    Compiling rayon-core v1.13.0
[INFO] [stderr]    Compiling httparse v1.10.1
[INFO] [stderr]    Compiling percent-encoding v2.3.2
[INFO] [stderr]    Compiling icu_properties_data v2.1.2
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling litrs v1.0.0
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling anyhow v1.0.102
[INFO] [stderr]    Compiling futures-sink v0.3.32
[INFO] [stderr]    Compiling icu_normalizer_data v2.1.1
[INFO] [stderr]    Compiling web_atoms v0.1.3
[INFO] [stderr]    Compiling synstructure v0.13.2
[INFO] [stderr]    Compiling document-features v0.2.12
[INFO] [stderr]    Compiling indexmap v2.13.0
[INFO] [stderr]    Compiling num-bigint v0.4.6
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling mio v0.8.11
[INFO] [stderr]    Compiling tower-layer v0.3.3
[INFO] [stderr]    Compiling try-lock v0.2.5
[INFO] [stderr]    Compiling arrayvec v0.7.6
[INFO] [stderr]    Compiling atomic-waker v1.1.2
[INFO] [stderr]    Compiling adler2 v2.0.1
[INFO] [stderr]    Compiling foreign-types-shared v0.1.1
[INFO] [stderr]    Compiling openssl v0.10.75
[INFO] [stderr]    Compiling crc32fast v1.5.0
[INFO] [stderr]    Compiling precomputed-hash v0.1.1
[INFO] [stderr]    Compiling mac v0.1.1
[INFO] [stderr]    Compiling futf v0.1.5
[INFO] [stderr]    Compiling foreign-types v0.3.2
[INFO] [stderr]    Compiling miniz_oxide v0.8.9
[INFO] [stderr]    Compiling signal-hook-mio v0.2.5
[INFO] [stderr]    Compiling want v0.3.1
[INFO] [stderr]    Compiling num-rational v0.4.2
[INFO] [stderr]    Compiling zerofrom-derive v0.1.6
[INFO] [stderr]    Compiling yoke-derive v0.8.1
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling zerocopy-derive v0.8.40
[INFO] [stderr]    Compiling zerovec-derive v0.11.2
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling tokio-macros v2.6.0
[INFO] [stderr]    Compiling displaydoc v0.2.5
[INFO] [stderr]    Compiling tokio v1.49.0
[INFO] [stderr]    Compiling zerofrom v0.1.6
[INFO] [stderr]    Compiling futures-macro v0.3.32
[INFO] [stderr]    Compiling yoke v0.8.1
[INFO] [stderr]    Compiling equator-macro v0.4.2
[INFO] [stderr]    Compiling zerovec v0.11.5
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling zerotrie v0.2.3
[INFO] [stderr]    Compiling equator v0.4.2
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling tinystr v0.8.2
[INFO] [stderr]    Compiling potential_utf v0.1.4
[INFO] [stderr]    Compiling derive_more-impl v2.1.1
[INFO] [stderr]    Compiling icu_locale_core v2.1.1
[INFO] [stderr]    Compiling icu_collections v2.1.1
[INFO] [stderr]    Compiling aligned-vec v0.6.4
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling derive_more v2.1.1
[INFO] [stderr]    Compiling v_frame v0.3.9
[INFO] [stderr]    Compiling icu_provider v2.1.1
[INFO] [stderr]    Compiling openssl-macros v0.1.1
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling http-body-util v0.1.3
[INFO] [stderr]    Compiling phf v0.11.3
[INFO] [stderr]    Compiling string_cache v0.8.9
[INFO] [stderr]    Compiling futures-channel v0.3.32
[INFO] [stderr]    Compiling sync_wrapper v1.0.2
[INFO] [stderr]    Compiling as-slice v0.2.1
[INFO] [stderr]    Compiling version_check v0.9.5
[INFO] [stderr]    Compiling native-tls v0.2.18
[INFO] [stderr]    Compiling paste v1.0.15
[INFO] [stderr]    Compiling built v0.8.0
[INFO] [stderr]    Compiling av-scenechange v0.14.1
[INFO] [stderr]    Compiling httpdate v1.0.3
[INFO] [stderr]    Compiling utf-8 v0.7.6
[INFO] [stderr]    Compiling base64 v0.22.1
[INFO] [stderr]    Compiling bytemuck v1.25.0
[INFO] [stderr]    Compiling zmij v1.0.21
[INFO] [stderr]    Compiling rav1e v0.8.1
[INFO] [stderr]    Compiling tendril v0.4.3
[INFO] [stderr]    Compiling ahash v0.8.12
[INFO] [stderr]    Compiling aligned v0.4.3
[INFO] [stderr]    Compiling icu_normalizer v2.1.1
[INFO] [stderr]    Compiling icu_properties v2.1.2
[INFO] [stderr]    Compiling rayon v1.11.0
[INFO] [stderr]    Compiling profiling-procmacros v1.0.17
[INFO] [stderr]    Compiling arg_enum_proc_macro v0.3.4
[INFO] [stderr]    Compiling form_urlencoded v1.2.2
[INFO] [stderr]    Compiling core2 v0.4.0
[INFO] [stderr]    Compiling nom v8.0.0
[INFO] [stderr]    Compiling tokio-util v0.7.18
[INFO] [stderr]    Compiling openssl-probe v0.2.1
[INFO] [stderr]    Compiling quick-error v2.0.1
[INFO] [stderr]    Compiling y4m v0.8.0
[INFO] [stderr]    Compiling pastey v0.1.1
[INFO] [stderr]    Compiling ipnet v2.11.0
[INFO] [stderr]    Compiling h2 v0.4.13
[INFO] [stderr]    Compiling utf8parse v0.2.2
[INFO] [stderr]    Compiling getrandom v0.4.1
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling idna_adapter v1.2.1
[INFO] [stderr]    Compiling tower v0.5.3
[INFO] [stderr]    Compiling bitstream-io v4.9.0
[INFO] [stderr]    Compiling flate2 v1.1.9
[INFO] [stderr]    Compiling profiling v1.0.17
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling markup5ever v0.16.2
[INFO] [stderr]    Compiling rgb v0.8.53
[INFO] [stderr]    Compiling av1-grain v0.2.5
[INFO] [stderr]    Compiling crossterm v0.29.0
[INFO] [stderr]    Compiling num-derive v0.4.2
[INFO] [stderr]    Compiling fax_derive v0.2.0
[INFO] [stderr]    Compiling simd_helpers v0.1.0
[INFO] [stderr]    Compiling maybe-rayon v0.1.1
[INFO] [stderr]    Compiling cfg_aliases v0.1.1
[INFO] [stderr]    Compiling noop_proc_macro v0.3.0
[INFO] [stderr]    Compiling ryu v1.0.23
[INFO] [stderr]    Compiling utf8_iter v1.0.4
[INFO] [stderr]    Compiling mime v0.3.17
[INFO] [stderr]    Compiling rustversion v1.0.22
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling zune-core v0.4.12
[INFO] [stderr]    Compiling weezl v0.1.12
[INFO] [stderr]    Compiling imgref v1.12.0
[INFO] [stderr]    Compiling loop9 v0.1.5
[INFO] [stderr]    Compiling zune-jpeg v0.4.21
[INFO] [stderr]    Compiling idna v1.1.0
[INFO] [stderr]    Compiling fax v0.2.6
[INFO] [stderr]    Compiling serde_urlencoded v0.7.1
[INFO] [stderr]    Compiling nix v0.28.0
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling hyper v1.8.1
[INFO] [stderr]    Compiling tokio-native-tls v0.3.1
[INFO] [stderr]    Compiling anstyle-parse v0.2.7
[INFO] [stderr]    Compiling match_token v0.1.0
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling avif-serialize v0.8.8
[INFO] [stderr]    Compiling zune-inflate v0.2.54
[INFO] [stderr]    Compiling fdeflate v0.3.7
[INFO] [stderr]    Compiling libsqlite3-sys v0.28.0
[INFO] [stderr]    Compiling getrandom v0.2.17
[INFO] [stderr]    Compiling zeroize v1.8.2
[INFO] [stderr]    Compiling anstyle v1.0.13
[INFO] [stderr]    Compiling zune-core v0.5.1
[INFO] [stderr]    Compiling anstyle-query v1.1.5
[INFO] [stderr]    Compiling strict v0.2.0
[INFO] [stderr]    Compiling color_quant v1.1.0
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.2
[INFO] [stderr]    Compiling lebe v0.5.3
[INFO] [stderr]    Compiling pxfm v0.1.28
[INFO] [stderr]    Compiling minimal-lexical v0.2.1
[INFO] [stderr]    Compiling colorchoice v1.0.4
[INFO] [stderr]    Compiling bit_field v0.10.3
[INFO] [stderr]    Compiling hyper-util v0.1.20
[INFO] [stderr]    Compiling iri-string v0.7.10
[INFO] [stderr]    Compiling byteorder-lite v0.1.0
[INFO] [stderr]    Compiling exr v1.74.0
[INFO] [stderr]    Compiling nom v7.1.3
[INFO] [stderr]    Compiling image-webp v0.2.4
[INFO] [stderr]    Compiling anstream v0.6.21
[INFO] [stderr]    Compiling zune-jpeg v0.5.12
[INFO] [stderr]    Compiling tower-http v0.6.8
[INFO] [stderr]    Compiling hyper-tls v0.6.0
[INFO] [stderr]    Compiling gif v0.14.1
[INFO] [stderr]    Compiling crokey-proc_macros v1.4.0
[INFO] [stderr]    Compiling rustls-pki-types v1.14.0
[INFO] [stderr]    Compiling png v0.18.1
[INFO] [stderr]    Compiling html5ever v0.31.0
[INFO] [stderr]    Compiling hashbrown v0.14.5
[INFO] [stderr]    Compiling moxcms v0.7.11
[INFO] [stderr]    Compiling lazy-regex-proc_macros v3.6.0
[INFO] [stderr]    Compiling ravif v0.12.0
[INFO] [stderr]    Compiling tiff v0.10.3
[INFO] [stderr]    Compiling url v2.5.8
[INFO] [stderr]    Compiling xml5ever v0.22.1
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling qoi v0.4.1
[INFO] [stderr]    Compiling async-trait v0.1.89
[INFO] [stderr]    Compiling crossbeam-channel v0.5.15
[INFO] [stderr]    Compiling crossbeam-queue v0.3.12
[INFO] [stderr]    Compiling bstr v1.12.1
[INFO] [stderr]    Compiling nibble_vec v0.1.0
[INFO] [stderr]    Compiling encoding_rs v0.8.35
[INFO] [stderr]    Compiling unicode-width v0.2.2
[INFO] [stderr]    Compiling heck v0.5.0
[INFO] [stderr]    Compiling strsim v0.11.1
[INFO] [stderr]    Compiling endian-type v0.1.2
[INFO] [stderr]    Compiling utf8-width v0.1.8
[INFO] [stderr]    Compiling option-ext v0.2.0
[INFO] [stderr]    Compiling same-file v1.0.6
[INFO] [stderr]    Compiling clap_lex v1.0.0
[INFO] [stderr]    Compiling unicode-width v0.1.14
[INFO] [stderr]    Compiling lazy_static v1.5.0
[INFO] [stderr]    Compiling sharded-slab v0.1.7
[INFO] [stderr]    Compiling clap_builder v4.5.60
[INFO] [stderr]    Compiling walkdir v2.5.0
[INFO] [stderr]    Compiling tempfile v3.26.0
[INFO] [stderr]    Compiling dirs-sys v0.4.1
[INFO] [stderr]    Compiling html-escape v0.2.13
[INFO] [stderr]    Compiling radix_trie v0.2.1
[INFO] [stderr]    Compiling reqwest v0.12.28
[INFO] [stderr]    Compiling clap_derive v4.5.55
[INFO] [stderr]    Compiling globset v0.4.18
[INFO] [stderr]    Compiling axum-core v0.4.5
[INFO] [stderr]    Compiling console v0.15.11
[INFO] [stderr]    Compiling image v0.25.9
[INFO] [stderr]    Compiling crossbeam v0.8.4
[INFO] [stderr]    Compiling lazy-regex v3.6.0
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling markup5ever_rcdom v0.5.3-unofficial
[INFO] [stderr]    Compiling hashlink v0.9.1
[INFO] [stderr]    Compiling crokey v1.4.0
[INFO] [stderr]    Compiling eventsource-stream v0.2.3
[INFO] [stderr]    Compiling coolor v1.1.0
[INFO] [stderr]    Compiling ansi_colours v1.2.3
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling axum-macros v0.4.2
[INFO] [stderr]    Compiling rustyline-derive v0.10.0
[INFO] [stderr]    Compiling fd-lock v4.0.4
[INFO] [stderr]    Compiling serde_path_to_error v0.1.20
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling console v0.16.2
[INFO] [stderr]    Compiling minimad v0.14.0
[INFO] [stderr]    Compiling thread_local v1.1.9
[INFO] [stderr]    Compiling termcolor v1.4.1
[INFO] [stderr]    Compiling matchit v0.7.3
[INFO] [stderr]    Compiling futures-timer v3.0.3
[INFO] [stderr]    Compiling shell-words v1.1.1
[INFO] [stderr]    Compiling nu-ansi-term v0.50.3
[INFO] [stderr]    Compiling iana-time-zone v0.1.65
[INFO] [stderr]    Compiling fallible-streaming-iterator v0.1.9
[INFO] [stderr]    Compiling home v0.5.12
[INFO] [stderr]    Compiling fallible-iterator v0.3.0
[INFO] [stderr]    Compiling tracing-subscriber v0.3.22
[INFO] [stderr]    Compiling axum v0.7.9
[INFO] [stderr]    Compiling rustyline v14.0.0
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling reqwest-eventsource v0.6.0
[INFO] [stderr]    Compiling rusqlite v0.31.0
[INFO] [stderr]    Compiling dialoguer v0.11.0
[INFO] [stderr]    Compiling viuer v0.11.0
[INFO] [stderr]    Compiling termimad v0.34.1
[INFO] [stderr]    Compiling htmd v0.2.2
[INFO] [stderr]    Compiling clap v4.5.60
[INFO] [stderr]    Compiling ignore v0.4.25
[INFO] [stderr]    Compiling dirs v5.0.1
[INFO] [stderr]    Compiling uuid v1.21.0
[INFO] [stderr]    Compiling tower-http v0.5.2
[INFO] [stderr]    Compiling crossterm v0.27.0
[INFO] [stderr]    Compiling base64 v0.21.7
[INFO] [stderr]    Compiling xcodeai v2.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 5m 47s
[INFO] running `Command { std: "docker" "inspect" "3f0d801b3cc88b8bfcb3a4fb9b489ba68303fbff52bc625a74d1683efe112524", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3f0d801b3cc88b8bfcb3a4fb9b489ba68303fbff52bc625a74d1683efe112524", kill_on_drop: false }`
[INFO] [stdout] 3f0d801b3cc88b8bfcb3a4fb9b489ba68303fbff52bc625a74d1683efe112524
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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" "+33835004928d3bf65db4d4712e1330766263b0bd" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 196756ff52d0dcc2fbd5735a20592281b7067934194c361b67265ddcc9b8b986
[INFO] running `Command { std: "docker" "start" "-a" "196756ff52d0dcc2fbd5735a20592281b7067934194c361b67265ddcc9b8b986", kill_on_drop: false }`
[INFO] [stderr]    Compiling tokio v1.49.0
[INFO] [stderr]    Compiling pin-project-internal v1.1.11
[INFO] [stderr]    Compiling futures-executor v0.3.32
[INFO] [stderr]    Compiling pin-project v1.1.11
[INFO] [stderr]    Compiling tower v0.4.13
[INFO] [stderr]    Compiling tokio-util v0.7.18
[INFO] [stderr]    Compiling tower v0.5.3
[INFO] [stderr]    Compiling tokio-native-tls v0.3.1
[INFO] [stderr]    Compiling tokio-stream v0.1.18
[INFO] [stderr]    Compiling tokio-test v0.4.5
[INFO] [stderr]    Compiling h2 v0.4.13
[INFO] [stderr]    Compiling tower-http v0.6.8
[INFO] [stderr]    Compiling hyper v1.8.1
[INFO] [stderr]    Compiling hyper-util v0.1.20
[INFO] [stderr]    Compiling hyper-tls v0.6.0
[INFO] [stderr]    Compiling axum v0.7.9
[INFO] [stderr]    Compiling reqwest v0.12.28
[INFO] [stderr]    Compiling reqwest-eventsource v0.6.0
[INFO] [stderr]    Compiling xcodeai v2.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: function `dummy_result` is never used
[INFO] [stdout]    --> src/orchestrator/executor.rs:527:8
[INFO] [stdout]     |
[INFO] [stdout] 527 |     fn dummy_result() -> AgentResult {
[INFO] [stdout]     |        ^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: variants `ToolCallResponse` and `ErrorResponse` are never constructed
[INFO] [stdout]   --> tests/mock_llm_server.rs:23:5
[INFO] [stdout]    |
[INFO] [stdout] 18 | pub enum MockScenario {
[INFO] [stdout]    |          ------------ variants in this enum
[INFO] [stdout] ...
[INFO] [stdout] 23 |     ToolCallResponse {
[INFO] [stdout]    |     ^^^^^^^^^^^^^^^^
[INFO] [stdout] ...
[INFO] [stdout] 29 |     ErrorResponse(u16),
[INFO] [stdout]    |     ^^^^^^^^^^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `MockScenario` has a derived impl for the trait `Clone`, but this is intentionally ignored during dead code analysis
[INFO] [stdout]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: function `dummy_result` is never used
[INFO] [stdout]    --> src/orchestrator/executor.rs:527:8
[INFO] [stdout]     |
[INFO] [stdout] 527 |     fn dummy_result() -> AgentResult {
[INFO] [stdout]     |        ^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2m 18s
[INFO] running `Command { std: "docker" "inspect" "196756ff52d0dcc2fbd5735a20592281b7067934194c361b67265ddcc9b8b986", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "196756ff52d0dcc2fbd5735a20592281b7067934194c361b67265ddcc9b8b986", kill_on_drop: false }`
[INFO] [stdout] 196756ff52d0dcc2fbd5735a20592281b7067934194c361b67265ddcc9b8b986
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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" "+33835004928d3bf65db4d4712e1330766263b0bd" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 5b9b6cfe046b28c031e92b8ef76934222e2617d5b9a25df9f5b97f693d82b3e5
[INFO] running `Command { std: "docker" "start" "-a" "5b9b6cfe046b28c031e92b8ef76934222e2617d5b9a25df9f5b97f693d82b3e5", kill_on_drop: false }`
[INFO] [stderr] warning: function `dummy_result` is never used
[INFO] [stderr]    --> src/orchestrator/executor.rs:527:8
[INFO] [stderr]     |
[INFO] [stderr] 527 |     fn dummy_result() -> AgentResult {
[INFO] [stderr]     |        ^^^^^^^^^^^^
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: variants `ToolCallResponse` and `ErrorResponse` are never constructed
[INFO] [stderr]   --> tests/mock_llm_server.rs:23:5
[INFO] [stderr]    |
[INFO] [stderr] 18 | pub enum MockScenario {
[INFO] [stderr]    |          ------------ variants in this enum
[INFO] [stderr] ...
[INFO] [stderr] 23 |     ToolCallResponse {
[INFO] [stderr]    |     ^^^^^^^^^^^^^^^^
[INFO] [stderr] ...
[INFO] [stderr] 29 |     ErrorResponse(u16),
[INFO] [stderr]    |     ^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `MockScenario` has a derived impl for the trait `Clone`, but this is intentionally ignored during dead code analysis
[INFO] [stderr]    = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `xcodeai` (lib test) generated 1 warning
[INFO] [stderr] warning: `xcodeai` (test "http_integration") generated 1 warning
[INFO] [stderr] warning: `xcodeai` (bin "xcodeai" test) generated 1 warning (1 duplicate)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.67s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/xcodeai-0cb975263dbb1646)
[INFO] [stdout] 
[INFO] [stdout] running 347 tests
[INFO] [stdout] test agent::agents_md::tests::test_no_agents_md_returns_none ... ok
[INFO] [stdout] test agent::agents_md::tests::test_lowercase_agents_md_last_resort ... ok
[INFO] [stdout] test agent::agents_md::tests::test_agents_md_is_loaded ... ok
[INFO] [stdout] test agent::agents_md::tests::test_dot_agents_md_fallback ... ok
[INFO] [stdout] test agent::agents_md::tests::test_xcodeai_agents_md_takes_priority ... ok
[INFO] [stdout] test agent::agents_md::tests::test_empty_agents_md_is_skipped ... ok
[INFO] [stdout] test agent::coder::tests::test_context_truncation ... ok
[INFO] [stdout] test agent::coder::tests::test_plan_turn_max_question_rounds ... ok
[INFO] [stdout] test agent::coder::tests::test_plan_turn_tool_call_loop ... ok
[INFO] [stdout] test agent::coder::tests::test_coder_simple_task ... ok
[INFO] [stdout] test agent::coder::tests::test_coder_tool_error_recovery ... ok
[INFO] [stdout] test agent::context_manager::tests::test_context_config_defaults ... ok
[INFO] [stdout] test agent::coder::tests::test_coder_max_tool_calls_per_response ... ok
[INFO] [stdout] test agent::context_manager::tests::test_context_manager_truncate_noop_under_threshold ... ok
[INFO] [stdout] test agent::coder::tests::test_coder_checkpoint_continues ... ok
[INFO] [stdout] test agent::context_manager::tests::test_context_manager_truncate_strategy ... ok
[INFO] [stdout] test agent::context_manager::tests::test_truncate_noop_when_under_budget ... ok
[INFO] [stdout] test config::tests::test_default_config ... ok
[INFO] [stdout] test agent::context_manager::tests::test_truncate_keeps_system_and_recent ... ok
[INFO] [stdout] test config::tests::test_backwards_compatible_config ... ok
[INFO] [stdout] test agent::context_manager::tests::test_truncate_inserts_marker ... ok
[INFO] [stdout] test config::tests::test_cli_override_takes_precedence ... ok
[INFO] [stdout] test config::tests::test_env_override ... ok
[INFO] [stdout] test config::tests::test_load_from_file ... ok
[INFO] [stdout] test config::tests::test_mcp_servers_defaults_to_empty ... ok
[INFO] [stdout] test config::tests::test_mcp_config_parsing ... ok
[INFO] [stdout] test config::tests::test_sandbox_disable_override ... ok
[INFO] [stdout] test agent::agents_md::tests::test_agents_md_beats_dot_agents_md ... ok
[INFO] [stdout] test http::tests::test_get_session_not_found ... ok
[INFO] [stdout] test http::tests::test_cors_header_present ... ok
[INFO] [stdout] test http::tests::test_delete_session ... ok
[INFO] [stdout] test http::tests::test_create_session_returns_id ... ok
[INFO] [stdout] test io::http::tests::test_channel_closes_when_io_dropped ... ok
[INFO] [stdout] test http::tests::test_create_then_get_session ... ok
[INFO] [stdout] test io::http::tests::test_show_status_sends_event ... ok
[INFO] [stdout] test io::http::tests::test_confirm_destructive_auto_approves ... ok
[INFO] [stdout] test io::http::tests::test_show_tool_call_sends_event ... ok
[INFO] [stdout] test io::http::tests::test_sse_event_data_json_complete ... ok
[INFO] [stdout] test http::tests::test_post_message_session_not_found ... ok
[INFO] [stdout] test http::tests::test_list_sessions_empty ... ok
[INFO] [stdout] test io::http::tests::test_sse_event_data_json_tool_result ... ok
[INFO] [stdout] test io::http::tests::test_sse_event_names ... ok
[INFO] [stdout] test io::terminal::tests::test_render_markdown_empty_string ... ok
[INFO] [stdout] test io::terminal::tests::test_render_markdown_no_markdown_flag ... ok
[INFO] [stdout] test io::http::tests::test_write_error_sends_event ... ok
[INFO] [stdout] test io::terminal::tests::test_terminal_io_default_no_markdown_false ... ok
[INFO] [stdout] test io::terminal::tests::test_terminal_io_new_no_markdown_true ... ok
[INFO] [stdout] test llm::anthropic::tests::test_build_anthropic_content_image_base64 ... ok
[INFO] [stdout] test llm::anthropic::tests::test_build_anthropic_content_image_url ... ok
[INFO] [stdout] test llm::anthropic::tests::test_build_anthropic_content_text ... ok
[INFO] [stdout] test llm::anthropic::tests::test_build_anthropic_content_tool_result ... ok
[INFO] [stdout] test llm::anthropic::tests::test_build_anthropic_content_tool_use ... ok
[INFO] [stdout] test llm::anthropic::tests::test_build_anthropic_tool_format ... ok
[INFO] [stdout] test io::terminal::tests::test_render_markdown_non_tty_returns_plain ... ok
[INFO] [stdout] test llm::anthropic::tests::test_empty_content_produces_empty_text_block ... ok
[INFO] [stdout] test io::http::tests::test_show_tool_result_sends_event ... ok
[INFO] [stdout] test io::http::tests::test_sse_event_data_json_status ... ok
[INFO] [stdout] test io::http::tests::test_sse_event_data_json_tool_call ... ok
[INFO] [stdout] test http::tests::test_post_message_conflict_when_active ... ok
[INFO] [stdout] test llm::anthropic::tests::test_tool_use_builder ... ok
[INFO] [stdout] test llm::anthropic::tests::test_tool_use_builder_empty_input ... ok
[INFO] [stdout] test agent::coder::tests::test_plan_turn_plain_text ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_gemini_content_image_base64 ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_gemini_content_image_url ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_gemini_content_parts_empty_gets_placeholder ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_gemini_content_parts_text ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_gemini_content_parts_tool_calls ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_gemini_tool ... ok
[INFO] [stdout] test context::tests::test_new_with_no_mcp_servers ... ok
[INFO] [stdout] test llm::anthropic::tests::test_tool_result_message_conversion ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_request_body_assistant_role_is_model ... ok
[INFO] [stdout] test llm::anthropic::tests::test_no_system_message_omitted_from_body ... ok
[INFO] [stdout] test llm::anthropic::tests::test_tool_definition_anthropic_format ... ok
[INFO] [stdout] test llm::anthropic::tests::test_no_tools_omitted_from_body ... ok
[INFO] [stdout] test llm::anthropic::tests::test_user_message_content_block ... ok
[INFO] [stdout] test llm::gemini::tests::test_gemini_api_base_sentinel ... ok
[INFO] [stdout] test llm::gemini::tests::test_gemini_response_deserializes_function_call ... ok
[INFO] [stdout] test llm::gemini::tests::test_gemini_response_empty_candidates ... ok
[INFO] [stdout] test llm::gemini::tests::test_gemini_response_deserializes_text_chunk ... ok
[INFO] [stdout] test llm::gemini::tests::test_infer_mime_from_url ... ok
[INFO] [stdout] test llm::gemini::tests::test_gemini_usage_metadata_partial ... ok
[INFO] [stdout] test llm::anthropic::tests::test_system_message_extracted ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_request_body_no_tools_when_empty ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_request_body_tool_result ... ok
[INFO] [stdout] test llm::openai::tests::test_message_serialization ... ok
[INFO] [stdout] test llm::openai::tests::test_partial_tool_call_assembly ... ok
[INFO] [stdout] test llm::openai::tests::test_sse_parsing_text_only ... ok
[INFO] [stdout] test llm::openai::tests::test_sse_parsing_tool_call ... ok
[INFO] [stdout] test llm::openai::tests::test_tool_definition_format ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_request_body_simple_message ... ok
[INFO] [stdout] test llm::registry::tests::test_builtin_providers_fields_non_empty ... ok
[INFO] [stdout] test llm::registry::tests::test_builtin_providers_contains_all ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_request_body_with_tools ... ok
[INFO] [stdout] test llm::gemini::tests::test_set_stream_print ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_request_body_system_prompt ... ok
[INFO] [stdout] test llm::gemini::tests::test_is_not_copilot ... ok
[INFO] [stdout] test llm::gemini::tests::test_new_stores_fields ... ok
[INFO] [stdout] test llm::registry::tests::test_create_provider_anthropic_sentinel ... ok
[INFO] [stdout] test llm::registry::tests::test_is_anthropic_false_for_others ... ok
[INFO] [stdout] test llm::registry::tests::test_is_anthropic_full_url ... ok
[INFO] [stdout] test llm::registry::tests::test_is_anthropic_sentinel ... ok
[INFO] [stdout] test llm::registry::tests::test_is_gemini_false_for_others ... ok
[INFO] [stdout] test llm::registry::tests::test_is_gemini_full_url ... ok
[INFO] [stdout] test llm::registry::tests::test_is_gemini_sentinel ... ok
[INFO] [stdout] test llm::retry::tests::test_classify_permanent_codes ... ok
[INFO] [stdout] test llm::retry::tests::test_classify_retryable_codes ... ok
[INFO] [stdout] test llm::openai::tests::test_is_copilot ... ok
[INFO] [stdout] test llm::retry::tests::test_next_delay_caps_at_max ... ok
[INFO] [stdout] test llm::retry::tests::test_next_delay_doubles_by_default ... ok
[INFO] [stdout] test llm::registry::tests::test_create_provider_anthropic_url ... ok
[INFO] [stdout] test llm::registry::tests::test_create_provider_copilot ... ok
[INFO] [stdout] test llm::registry::tests::test_create_provider_openai_fallback ... ok
[INFO] [stdout] test llm::retry::tests::test_parse_retry_after_integer ... ok
[INFO] [stdout] test llm::retry::tests::test_parse_retry_after_invalid_falls_back_to_default ... ok
[INFO] [stdout] test llm::retry::tests::test_parse_retry_after_none_returns_default ... ok
[INFO] [stdout] test llm::registry::tests::test_create_provider_gemini_sentinel ... ok
[INFO] [stdout] test llm::retry::tests::test_parse_retry_after_with_whitespace ... ok
[INFO] [stdout] test llm::retry::tests::test_retry_after_header_respected ... ok
[INFO] [stdout] test llm::registry::tests::test_create_provider_ollama ... ok
[INFO] [stdout] test llm::tests::test_assistant_message_roundtrip ... ok
[INFO] [stdout] test llm::tests::test_backwards_compat_string_content ... ok
[INFO] [stdout] test llm::tests::test_content_part_image_url_serde ... ok
[INFO] [stdout] test llm::tests::test_content_part_text_serde ... ok
[INFO] [stdout] test llm::registry::tests::test_create_provider_gemini_url ... ok
[INFO] [stdout] test llm::tests::test_image_to_content_part_from_disk ... ok
[INFO] [stdout] test llm::retry::tests::test_no_retry_on_400 ... ok
[INFO] [stdout] test llm::retry::tests::test_no_retry_on_success ... ok
[INFO] [stdout] test llm::retry::tests::test_non_retryable_error_propagates_immediately ... ok
[INFO] [stdout] test llm::tests::test_image_to_content_part_unsupported_ext ... ok
[INFO] [stdout] test llm::tests::test_llm_response_usage_can_be_some ... ok
[INFO] [stdout] test llm::tests::test_message_multipart_serializes_as_array ... ok
[INFO] [stdout] test llm::tests::test_message_single_text_serializes_as_string ... ok
[INFO] [stdout] test llm::tests::test_null_content_deserializes_to_empty_vec ... ok
[INFO] [stdout] test llm::tests::test_text_content_multiple_parts ... ok
[INFO] [stdout] test llm::tests::test_text_content_no_text_parts ... ok
[INFO] [stdout] test llm::tests::test_usage_default_is_zero ... ok
[INFO] [stdout] test llm::tests::test_usage_equality ... ok
[INFO] [stdout] test llm::tests::test_image_to_content_part_missing_file ... ok
[INFO] [stdout] test lsp::tests::test_detect_no_project ... ok
[INFO] [stdout] test llm::retry::tests::test_retry_on_network_error ... ok
[INFO] [stdout] test llm::tests::test_image_to_content_part_no_ext ... ok
[INFO] [stdout] test llm::tests::test_tool_message_roundtrip ... ok
[INFO] [stdout] test lsp::tests::test_detect_prefers_rust_over_python_if_both ... ok
[INFO] [stdout] test lsp::tests::test_detect_python_project_pyproject ... ok
[INFO] [stdout] test lsp::tests::test_detect_rust_project ... ok
[INFO] [stdout] test lsp::transport::tests::test_encode_message_format ... ok
[INFO] [stdout] test lsp::tests::test_detect_python_project_setup_py ... ok
[INFO] [stdout] test lsp::tests::test_detect_typescript_project ... ok
[INFO] [stdout] test llm::retry::tests::test_exhausts_retries ... ok
[INFO] [stdout] test lsp::transport::tests::test_encode_content_length_matches_body ... ok
[INFO] [stdout] test lsp::transport::tests::test_roundtrip_notification ... ok
[INFO] [stdout] test lsp::transport::tests::test_roundtrip_simple ... ok
[INFO] [stdout] test lsp::transport::tests::test_missing_content_length_returns_error ... ok
[INFO] [stdout] test lsp::transport::tests::test_roundtrip_large_body ... ok
[INFO] [stdout] test llm::tests::test_llm_response_usage_is_none_by_default ... ok
[INFO] [stdout] test lsp::transport::tests::test_read_multiple_messages_sequentially ... ok
[INFO] [stdout] test mcp::bridge::tests::test_format_empty_error ... ok
[INFO] [stdout] test mcp::bridge::tests::test_bridge_description_fallback ... ok
[INFO] [stdout] test mcp::bridge::tests::test_bridge_description_present ... ok
[INFO] [stdout] test mcp::bridge::tests::test_bridge_schema_forwarded ... ok
[INFO] [stdout] test llm::retry::tests::test_retry_on_429_then_success ... ok
[INFO] [stdout] test mcp::bridge::tests::test_format_image_placeholder ... ok
[INFO] [stdout] test mcp::bridge::tests::test_bridge_name_prefixing ... ok
[INFO] [stdout] test mcp::bridge::tests::test_format_empty_success ... ok
[INFO] [stdout] test mcp::bridge::tests::test_format_mixed_content ... ok
[INFO] [stdout] test mcp::bridge::tests::test_format_multiple_text ... ok
[INFO] [stdout] test mcp::bridge::tests::test_format_single_text ... ok
[INFO] [stdout] test mcp::bridge::tests::test_prefix_contract ... ok
[INFO] [stdout] test mcp::tests::test_initialize_request_structure ... ok
[INFO] [stdout] test mcp::bridge::tests::test_format_resource_annotation ... ok
[INFO] [stdout] test mcp::tests::test_message_framing_for_mcp ... ok
[INFO] [stdout] test mcp::tests::test_error_response_detection ... ok
[INFO] [stdout] test mcp::tests::test_resources_read_request_structure ... ok
[INFO] [stdout] test mcp::tests::test_initialized_notification_no_id ... ok
[INFO] [stdout] test mcp::tests::test_response_id_matching ... ok
[INFO] [stdout] test mcp::transport::tests::test_mcp_encode_decode_roundtrip ... ok
[INFO] [stdout] test mcp::tests::test_tools_call_request_structure ... ok
[INFO] [stdout] test mcp::transport::tests::test_mcp_notification_framing ... ok
[INFO] [stdout] test mcp::transport::tests::test_mcp_tools_list_framing ... ok
[INFO] [stdout] test mcp::types::tests::test_content_text_deserialize ... ok
[INFO] [stdout] test mcp::types::tests::test_resource_minimal ... ok
[INFO] [stdout] test mcp::types::tests::test_resource_read_result ... ok
[INFO] [stdout] test mcp::types::tests::test_resources_list_result ... ok
[INFO] [stdout] test mcp::types::tests::test_content_image_deserialize ... ok
[INFO] [stdout] test mcp::types::tests::test_tool_call_result_default_not_error ... ok
[INFO] [stdout] test mcp::types::tests::test_resource_roundtrip ... ok
[INFO] [stdout] test mcp::types::tests::test_tool_call_result_success ... ok
[INFO] [stdout] test mcp::types::tests::test_tool_call_result_error ... ok
[INFO] [stdout] test mcp::types::tests::test_tool_definition_no_description ... ok
[INFO] [stdout] test mcp::types::tests::test_tool_definition_roundtrip ... ok
[INFO] [stdout] test orchestrator::executor::tests::test_collect_dependents_transitive ... ok
[INFO] [stdout] test orchestrator::executor::tests::test_executor_empty_graph ... ok
[INFO] [stdout] test mcp::types::tests::test_tools_list_result ... ok
[INFO] [stdout] test orchestrator::executor::tests::test_collect_dependents_leaf ... ok
[INFO] [stdout] test orchestrator::executor::tests::test_collect_dependents_direct_only ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_add_single_task ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_cannot_start_from_non_pending ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_compute_waves_empty ... ok
[INFO] [stdout] test orchestrator::executor::tests::test_executor_parallel_tasks ... ok
[INFO] [stdout] test orchestrator::executor::tests::test_executor_single_task ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_empty_graph ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_compute_waves_linear_chain ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_compute_waves_diamond ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_compute_waves_no_deps ... ok
[INFO] [stdout] test orchestrator::executor::tests::test_executor_linear_chain ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_duplicate_id_rejected ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_is_finished ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_mark_cancelled ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_mark_running_and_completed ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_next_ready_after_completion ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_next_ready_initial_state ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_status_counts ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_topological_sort_empty ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_mark_failed_increments_retries ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_topological_sort_linear_chain ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_serialisation_roundtrip ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_topological_sort_diamond ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_unknown_dependency_rejected ... ok
[INFO] [stdout] test orchestrator::executor::tests::test_executor_cancels_dependents ... ok
[INFO] [stdout] test sandbox::tests::test_nosandbox_exec_simple ... ok
[INFO] [stdout] test sandbox::tests::test_nosandbox_exec_exit_code ... ok
[INFO] [stdout] test session::store::tests::test_session_create_no_title ... ok
[INFO] [stdout] test session::store::tests::test_session_create_and_get ... ok
[INFO] [stdout] test session::store::tests::test_session_not_found ... ok
[INFO] [stdout] test session::store::tests::test_list_undo_does_not_remove ... ok
[INFO] [stdout] test session::store::tests::test_message_all_roles ... ok
[INFO] [stdout] test session::tests::test_auto_title_cjk ... ok
[INFO] [stdout] test session::tests::test_auto_title_cjk_short ... ok
[INFO] [stdout] test session::tests::test_auto_title_no_spaces ... ok
[INFO] [stdout] test session::tests::test_auto_title_short ... ok
[INFO] [stdout] test session::tests::test_auto_title_truncates_at_word ... ok
[INFO] [stdout] test session::store::tests::test_push_and_pop_undo ... ok
[INFO] [stdout] test session::store::tests::test_session_list_ordering ... ok
[INFO] [stdout] test tools::bash::tests::test_bash_execute ... ok
[INFO] [stdout] test tools::bash::tests::test_bash_exit_code ... ok
[INFO] [stdout] test tools::bash::tests::test_bash_missing_command ... ok
[INFO] [stdout] test session::store::tests::test_tool_calls_roundtrip ... ok
[INFO] [stdout] test tools::bash::tests::test_truncate_output_long ... ok
[INFO] [stdout] test tools::bash::tests::test_truncate_output_short ... ok
[INFO] [stdout] test tools::display_image::tests::test_display_image_file_not_found ... ok
[INFO] [stdout] test tools::display_image::tests::test_display_image_missing_path ... ok
[INFO] [stdout] test tools::display_image::tests::test_display_image_non_image_ext ... ok
[INFO] [stdout] test spinner::tests::test_spinner_drop_safety ... ok
[INFO] [stdout] test session::store::tests::test_update_session_title ... ok
[INFO] [stdout] test tools::fetch::tests::test_fetch_missing_url ... ok
[INFO] [stdout] test tools::file_edit::tests::test_file_edit_multiple_matches ... ok
[INFO] [stdout] test session::store::tests::test_update_session_tokens ... ok
[INFO] [stdout] test tools::file_edit::tests::test_file_edit_not_found ... ok
[INFO] [stdout] test tools::file_edit::tests::test_file_edit_success ... ok
[INFO] [stdout] test tools::file_read::tests::test_file_read_existing_file ... ok
[INFO] [stdout] test tools::file_read::tests::test_file_read_missing_file ... ok
[INFO] [stdout] test tools::file_read::tests::test_file_read_with_offset_limit ... ok
[INFO] [stdout] test tools::file_write::tests::test_file_write_creates_file ... ok
[INFO] [stdout] test tools::file_write::tests::test_file_write_creates_parent_dirs ... ok
[INFO] [stdout] test tools::git_blame::tests::test_git_blame_missing_path ... ok
[INFO] [stdout] test tools::git_commit::tests::test_git_commit_empty_message ... ok
[INFO] [stdout] test tools::git_commit::tests::test_git_commit_missing_message ... ok
[INFO] [stdout] test spinner::tests::test_spinner_non_tty_noop ... ok
[INFO] [stdout] test tools::git_diff::tests::test_find_char_boundary_ascii ... ok
[INFO] [stdout] test tools::fetch::tests::test_fetch_success ... ok
[INFO] [stdout] test tools::git_commit::tests::test_git_commit_no_git_repo ... ok
[INFO] [stdout] test tools::git_blame::tests::test_git_blame_nonexistent_file ... ok
[INFO] [stdout] test tools::git_log::tests::test_git_log_default_count ... ok
[INFO] [stdout] test tools::git_diff::tests::test_git_diff_staged_flag_builds_correctly ... ok
[INFO] [stdout] test tools::git_log::tests::test_git_log_not_a_repo ... ok
[INFO] [stdout] test tools::git_diff::tests::test_git_diff_missing_git_repo ... ok
[INFO] [stdout] test tools::glob_search::tests::test_glob_search_invalid_pattern ... ok
[INFO] [stdout] test tools::glob_search::tests::test_glob_search_missing_pattern ... ok
[INFO] [stdout] test tools::glob_search::tests::test_glob_search_finds_files ... ok
[INFO] [stdout] test tools::grep_search::tests::test_grep_finds_matches ... ok
[INFO] [stdout] test tools::glob_search::tests::test_glob_search_no_matches ... ok
[INFO] [stdout] test tools::grep_search::tests::test_grep_invalid_regex ... ok
[INFO] [stdout] test tools::glob_search::tests::test_glob_search_custom_path ... ok
[INFO] [stdout] test tools::grep_search::tests::test_grep_missing_pattern ... ok
[INFO] [stdout] test tools::grep_search::tests::test_grep_include_filter ... ok
[INFO] [stdout] test session::store::tests::test_trim_undo_history ... ok
[INFO] [stdout] test tools::ls::tests::test_ls_nonexistent ... ok
[INFO] [stdout] test tools::grep_search::tests::test_grep_no_matches ... ok
[INFO] [stdout] test tools::lsp_diagnostics::tests::test_lsp_diagnostics_metadata ... ok
[INFO] [stdout] test tools::lsp_diagnostics::tests::test_detect_language_id ... ok
[INFO] [stdout] test tools::lsp_diagnostics::tests::test_lsp_diagnostics_missing_path ... ok
[INFO] [stdout] test tools::lsp_diagnostics::tests::test_lsp_diagnostics_nonexistent_file ... ok
[INFO] [stdout] test tools::ls::tests::test_ls_respects_gitignore ... ok
[INFO] [stdout] test tools::lsp_diagnostics::tests::test_path_to_uri ... ok
[INFO] [stdout] test tools::ls::tests::test_ls_current_dir ... ok
[INFO] [stdout] test tools::ls::tests::test_ls_recursive ... ok
[INFO] [stdout] test tools::lsp_goto_def::tests::test_lsp_goto_def_missing_params ... ok
[INFO] [stdout] test tools::lsp_goto_def::tests::test_parse_locations_array ... ok
[INFO] [stdout] test tools::lsp_goto_def::tests::test_lsp_goto_def_metadata ... ok
[INFO] [stdout] test tools::lsp_goto_def::tests::test_parse_locations_location_link ... ok
[INFO] [stdout] test tools::lsp_goto_def::tests::test_lsp_goto_def_nonexistent_file ... ok
[INFO] [stdout] test tools::lsp_goto_def::tests::test_parse_locations_null ... ok
[INFO] [stdout] test tools::lsp_goto_def::tests::test_parse_locations_single_location ... ok
[INFO] [stdout] test tools::lsp_references::tests::test_lsp_references_metadata ... ok
[INFO] [stdout] test tools::lsp_references::tests::test_lsp_references_include_declaration_default ... ok
[INFO] [stdout] test tools::lsp_references::tests::test_lsp_references_missing_params ... ok
[INFO] [stdout] test tools::mcp_resource::tests::test_execute_no_mcp_client ... ok
[INFO] [stdout] test tools::mcp_resource::tests::test_execute_empty_uri ... ok
[INFO] [stdout] test tools::lsp_references::tests::test_lsp_references_nonexistent_file ... ok
[INFO] [stdout] test tools::mcp_resource::tests::test_format_binary_only ... ok
[INFO] [stdout] test tools::mcp_resource::tests::test_format_empty ... ok
[INFO] [stdout] test tools::mcp_resource::tests::test_format_multiple_text_blocks ... ok
[INFO] [stdout] test tools::mcp_resource::tests::test_format_single_text ... ok
[INFO] [stdout] test tools::mcp_resource::tests::test_tool_description_mentions_uri ... ok
[INFO] [stdout] test tools::mcp_resource::tests::test_tool_name ... ok
[INFO] [stdout] test tools::mcp_resource::tests::test_tool_schema ... ok
[INFO] [stdout] test tools::patch::tests::test_patch_context_mismatch ... ok
[INFO] [stdout] test tools::patch::tests::test_patch_add_lines ... ok
[INFO] [stdout] test tools::patch::tests::test_patch_missing_file ... ok
[INFO] [stdout] test tools::patch::tests::test_patch_multiple_hunks ... ok
[INFO] [stdout] test tools::patch::tests::test_patch_simple_change ... ok
[INFO] [stdout] test tools::question::tests::test_question_empty_options ... ok
[INFO] [stdout] test tools::patch::tests::test_patch_missing_params ... ok
[INFO] [stdout] test tools::patch::tests::test_patch_remove_lines ... ok
[INFO] [stdout] test tools::question::tests::test_question_missing_options_arg ... ok
[INFO] [stdout] test tools::question::tests::test_question_missing_question_arg ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_empty_tasks_array_succeeds ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_max_concurrent_respected ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_nesting_depth_below_limit_is_allowed_to_attempt ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_nesting_depth_at_limit_is_refused ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_no_args_returns_usage_error ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_parallel_false_accepted_as_serial ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_spawn_task_description_non_empty ... ok
[INFO] [stdout] test tools::question::tests::test_question_schema_multiple_field ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_spawn_task_name ... ok
[INFO] [stdout] test tools::question::tests::test_question_tool_metadata ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_spawn_task_schema_has_required_properties ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_task_missing_description_returns_error ... ok
[INFO] [stdout] test tools::question::tests::test_question_multiple_defaults_false ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_task_missing_id_returns_error ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_tasks_not_array_returns_error ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_unknown_dependency_returns_error ... ok
[INFO] [stdout] test tools::tests::test_registry_register_and_get ... ok
[INFO] [stdout] test tools::tests::test_registry_definitions ... ok
[INFO] [stdout] test tracking::tests::test_cost_estimation_gpt4o ... ok
[INFO] [stdout] test tracking::tests::test_cost_estimation_unknown_model ... ok
[INFO] [stdout] test tracking::tests::test_detailed_report_empty ... ok
[INFO] [stdout] test tracking::tests::test_empty_tracker ... ok
[INFO] [stdout] test tracking::tests::test_format_number ... ok
[INFO] [stdout] test tracking::tests::test_detailed_report_with_turns ... ok
[INFO] [stdout] test tracking::tests::test_record_some_usage ... ok
[INFO] [stdout] test tracking::tests::test_record_none_is_silently_skipped ... ok
[INFO] [stdout] test tracking::tests::test_summary_line_with_known_model ... ok
[INFO] [stdout] test tracking::tests::test_summary_line_with_unknown_model ... ok
[INFO] [stdout] test tools::fetch::tests::test_fetch_invalid_url ... ok
[INFO] [stdout] test sandbox::tests::test_nosandbox_timeout ... ok
[INFO] [stdout] test tools::bash::tests::test_bash_timeout ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 347 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.57s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/xcodeai-82574541ea808927)
[INFO] [stdout] 
[INFO] [stdout] running 356 tests
[INFO] [stdout] test agent::agents_md::tests::test_agents_md_beats_dot_agents_md ... ok
[INFO] [stdout] test agent::agents_md::tests::test_agents_md_is_loaded ... ok
[INFO] [stdout] test agent::agents_md::tests::test_dot_agents_md_fallback ... ok
[INFO] [stdout] test agent::agents_md::tests::test_no_agents_md_returns_none ... ok
[INFO] [stdout] test agent::agents_md::tests::test_empty_agents_md_is_skipped ... ok
[INFO] [stdout] test agent::agents_md::tests::test_xcodeai_agents_md_takes_priority ... ok
[INFO] [stdout] test agent::agents_md::tests::test_lowercase_agents_md_last_resort ... ok
[INFO] [stdout] test agent::coder::tests::test_coder_checkpoint_continues ... ok
[INFO] [stdout] test agent::coder::tests::test_coder_max_tool_calls_per_response ... ok
[INFO] [stdout] test agent::coder::tests::test_coder_simple_task ... ok
[INFO] [stdout] test agent::coder::tests::test_coder_tool_error_recovery ... ok
[INFO] [stdout] test agent::coder::tests::test_plan_turn_tool_call_loop ... ok
[INFO] [stdout] test agent::coder::tests::test_plan_turn_max_question_rounds ... ok
[INFO] [stdout] test agent::coder::tests::test_plan_turn_plain_text ... ok
[INFO] [stdout] test agent::context_manager::tests::test_context_config_defaults ... ok
[INFO] [stdout] test agent::context_manager::tests::test_truncate_noop_when_under_budget ... ok
[INFO] [stdout] test agent::context_manager::tests::test_context_manager_truncate_noop_under_threshold ... ok
[INFO] [stdout] test agent::context_manager::tests::test_context_manager_truncate_strategy ... ok
[INFO] [stdout] test config::tests::test_cli_override_takes_precedence ... ok
[INFO] [stdout] test config::tests::test_backwards_compatible_config ... ok
[INFO] [stdout] test agent::context_manager::tests::test_truncate_keeps_system_and_recent ... ok
[INFO] [stdout] test agent::context_manager::tests::test_truncate_inserts_marker ... ok
[INFO] [stdout] test config::tests::test_env_override ... ok
[INFO] [stdout] test config::tests::test_default_config ... ok
[INFO] [stdout] test config::tests::test_load_from_file ... ok
[INFO] [stdout] test config::tests::test_mcp_config_parsing ... ok
[INFO] [stdout] test agent::coder::tests::test_context_truncation ... ok
[INFO] [stdout] test config::tests::test_sandbox_disable_override ... ok
[INFO] [stdout] test config::tests::test_mcp_servers_defaults_to_empty ... ok
[INFO] [stdout] test http::tests::test_get_session_not_found ... ok
[INFO] [stdout] test http::tests::test_create_then_get_session ... ok
[INFO] [stdout] test http::tests::test_list_sessions_empty ... ok
[INFO] [stdout] test io::http::tests::test_confirm_destructive_auto_approves ... ok
[INFO] [stdout] test io::http::tests::test_channel_closes_when_io_dropped ... ok
[INFO] [stdout] test io::http::tests::test_show_status_sends_event ... ok
[INFO] [stdout] test http::tests::test_cors_header_present ... ok
[INFO] [stdout] test http::tests::test_create_session_returns_id ... ok
[INFO] [stdout] test http::tests::test_delete_session ... ok
[INFO] [stdout] test http::tests::test_post_message_conflict_when_active ... ok
[INFO] [stdout] test io::http::tests::test_show_tool_call_sends_event ... ok
[INFO] [stdout] test io::http::tests::test_sse_event_data_json_tool_call ... ok
[INFO] [stdout] test io::http::tests::test_show_tool_result_sends_event ... ok
[INFO] [stdout] test io::http::tests::test_sse_event_data_json_status ... ok
[INFO] [stdout] test io::http::tests::test_sse_event_data_json_complete ... ok
[INFO] [stdout] test http::tests::test_post_message_session_not_found ... ok
[INFO] [stdout] test io::http::tests::test_sse_event_data_json_tool_result ... ok
[INFO] [stdout] test io::terminal::tests::test_render_markdown_empty_string ... ok
[INFO] [stdout] test io::terminal::tests::test_render_markdown_no_markdown_flag ... ok
[INFO] [stdout] test io::http::tests::test_write_error_sends_event ... ok
[INFO] [stdout] test io::terminal::tests::test_render_markdown_non_tty_returns_plain ... ok
[INFO] [stdout] test io::http::tests::test_sse_event_names ... ok
[INFO] [stdout] test llm::anthropic::tests::test_build_anthropic_content_image_base64 ... ok
[INFO] [stdout] test llm::anthropic::tests::test_build_anthropic_content_image_url ... ok
[INFO] [stdout] test io::terminal::tests::test_terminal_io_default_no_markdown_false ... ok
[INFO] [stdout] test llm::anthropic::tests::test_build_anthropic_tool_format ... ok
[INFO] [stdout] test io::terminal::tests::test_terminal_io_new_no_markdown_true ... ok
[INFO] [stdout] test llm::anthropic::tests::test_build_anthropic_content_text ... ok
[INFO] [stdout] test llm::anthropic::tests::test_build_anthropic_content_tool_result ... ok
[INFO] [stdout] test llm::anthropic::tests::test_build_anthropic_content_tool_use ... ok
[INFO] [stdout] test llm::anthropic::tests::test_tool_use_builder ... ok
[INFO] [stdout] test llm::anthropic::tests::test_tool_use_builder_empty_input ... ok
[INFO] [stdout] test llm::anthropic::tests::test_empty_content_produces_empty_text_block ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_gemini_content_image_base64 ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_gemini_content_image_url ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_gemini_content_parts_empty_gets_placeholder ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_gemini_content_parts_text ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_gemini_content_parts_tool_calls ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_gemini_tool ... ok
[INFO] [stdout] test llm::anthropic::tests::test_no_system_message_omitted_from_body ... ok
[INFO] [stdout] test llm::anthropic::tests::test_tool_definition_anthropic_format ... ok
[INFO] [stdout] test llm::anthropic::tests::test_no_tools_omitted_from_body ... ok
[INFO] [stdout] test context::tests::test_new_with_no_mcp_servers ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_request_body_assistant_role_is_model ... ok
[INFO] [stdout] test llm::anthropic::tests::test_tool_result_message_conversion ... ok
[INFO] [stdout] test llm::gemini::tests::test_gemini_api_base_sentinel ... ok
[INFO] [stdout] test llm::gemini::tests::test_gemini_response_deserializes_function_call ... ok
[INFO] [stdout] test llm::gemini::tests::test_gemini_response_deserializes_text_chunk ... ok
[INFO] [stdout] test llm::anthropic::tests::test_system_message_extracted ... ok
[INFO] [stdout] test llm::gemini::tests::test_gemini_response_empty_candidates ... ok
[INFO] [stdout] test llm::gemini::tests::test_infer_mime_from_url ... ok
[INFO] [stdout] test llm::gemini::tests::test_gemini_usage_metadata_partial ... ok
[INFO] [stdout] test llm::anthropic::tests::test_user_message_content_block ... ok
[INFO] [stdout] test llm::gemini::tests::test_is_not_copilot ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_request_body_system_prompt ... ok
[INFO] [stdout] test llm::openai::tests::test_message_serialization ... ok
[INFO] [stdout] test llm::openai::tests::test_partial_tool_call_assembly ... ok
[INFO] [stdout] test llm::openai::tests::test_sse_parsing_text_only ... ok
[INFO] [stdout] test llm::openai::tests::test_sse_parsing_tool_call ... ok
[INFO] [stdout] test llm::openai::tests::test_tool_definition_format ... ok
[INFO] [stdout] test llm::registry::tests::test_builtin_providers_contains_all ... ok
[INFO] [stdout] test llm::registry::tests::test_builtin_providers_fields_non_empty ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_request_body_tool_result ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_request_body_with_tools ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_request_body_no_tools_when_empty ... ok
[INFO] [stdout] test llm::gemini::tests::test_set_stream_print ... ok
[INFO] [stdout] test llm::gemini::tests::test_build_request_body_simple_message ... ok
[INFO] [stdout] test llm::gemini::tests::test_new_stores_fields ... ok
[INFO] [stdout] test llm::registry::tests::test_create_provider_anthropic_sentinel ... ok
[INFO] [stdout] test llm::registry::tests::test_is_anthropic_false_for_others ... ok
[INFO] [stdout] test llm::registry::tests::test_is_anthropic_full_url ... ok
[INFO] [stdout] test llm::registry::tests::test_is_anthropic_sentinel ... ok
[INFO] [stdout] test llm::registry::tests::test_is_gemini_false_for_others ... ok
[INFO] [stdout] test llm::registry::tests::test_is_gemini_full_url ... ok
[INFO] [stdout] test llm::registry::tests::test_is_gemini_sentinel ... ok
[INFO] [stdout] test llm::retry::tests::test_classify_permanent_codes ... ok
[INFO] [stdout] test llm::retry::tests::test_classify_retryable_codes ... ok
[INFO] [stdout] test llm::retry::tests::test_exhausts_retries ... ok
[INFO] [stdout] test llm::retry::tests::test_next_delay_caps_at_max ... ok
[INFO] [stdout] test llm::retry::tests::test_next_delay_doubles_by_default ... ok
[INFO] [stdout] test llm::retry::tests::test_no_retry_on_400 ... ok
[INFO] [stdout] test llm::retry::tests::test_no_retry_on_success ... ok
[INFO] [stdout] test llm::retry::tests::test_non_retryable_error_propagates_immediately ... ok
[INFO] [stdout] test llm::retry::tests::test_parse_retry_after_integer ... ok
[INFO] [stdout] test llm::retry::tests::test_parse_retry_after_invalid_falls_back_to_default ... ok
[INFO] [stdout] test llm::retry::tests::test_parse_retry_after_none_returns_default ... ok
[INFO] [stdout] test llm::retry::tests::test_parse_retry_after_with_whitespace ... ok
[INFO] [stdout] test llm::retry::tests::test_retry_after_header_respected ... ok
[INFO] [stdout] test llm::retry::tests::test_retry_on_429_then_success ... ok
[INFO] [stdout] test llm::retry::tests::test_retry_on_network_error ... ok
[INFO] [stdout] test llm::tests::test_assistant_message_roundtrip ... ok
[INFO] [stdout] test llm::tests::test_backwards_compat_string_content ... ok
[INFO] [stdout] test llm::tests::test_content_part_image_url_serde ... ok
[INFO] [stdout] test llm::tests::test_content_part_text_serde ... ok
[INFO] [stdout] test llm::tests::test_image_to_content_part_from_disk ... ok
[INFO] [stdout] test llm::tests::test_image_to_content_part_missing_file ... ok
[INFO] [stdout] test llm::tests::test_image_to_content_part_no_ext ... ok
[INFO] [stdout] test llm::tests::test_image_to_content_part_unsupported_ext ... ok
[INFO] [stdout] test llm::tests::test_llm_response_usage_can_be_some ... ok
[INFO] [stdout] test llm::tests::test_llm_response_usage_is_none_by_default ... ok
[INFO] [stdout] test llm::tests::test_message_multipart_serializes_as_array ... ok
[INFO] [stdout] test llm::tests::test_message_single_text_serializes_as_string ... ok
[INFO] [stdout] test llm::tests::test_null_content_deserializes_to_empty_vec ... ok
[INFO] [stdout] test llm::tests::test_text_content_multiple_parts ... ok
[INFO] [stdout] test llm::tests::test_text_content_no_text_parts ... ok
[INFO] [stdout] test llm::tests::test_tool_message_roundtrip ... ok
[INFO] [stdout] test llm::tests::test_usage_default_is_zero ... ok
[INFO] [stdout] test llm::tests::test_usage_equality ... ok
[INFO] [stdout] test lsp::tests::test_detect_no_project ... ok
[INFO] [stdout] test lsp::tests::test_detect_prefers_rust_over_python_if_both ... ok
[INFO] [stdout] test lsp::tests::test_detect_python_project_pyproject ... ok
[INFO] [stdout] test lsp::tests::test_detect_python_project_setup_py ... ok
[INFO] [stdout] test lsp::tests::test_detect_rust_project ... ok
[INFO] [stdout] test lsp::tests::test_detect_typescript_project ... ok
[INFO] [stdout] test lsp::transport::tests::test_encode_content_length_matches_body ... ok
[INFO] [stdout] test lsp::transport::tests::test_encode_message_format ... ok
[INFO] [stdout] test lsp::transport::tests::test_missing_content_length_returns_error ... ok
[INFO] [stdout] test lsp::transport::tests::test_read_multiple_messages_sequentially ... ok
[INFO] [stdout] test lsp::transport::tests::test_roundtrip_large_body ... ok
[INFO] [stdout] test lsp::transport::tests::test_roundtrip_notification ... ok
[INFO] [stdout] test lsp::transport::tests::test_roundtrip_simple ... ok
[INFO] [stdout] test mcp::bridge::tests::test_bridge_description_fallback ... ok
[INFO] [stdout] test mcp::bridge::tests::test_bridge_description_present ... ok
[INFO] [stdout] test mcp::bridge::tests::test_bridge_name_prefixing ... ok
[INFO] [stdout] test mcp::bridge::tests::test_bridge_schema_forwarded ... ok
[INFO] [stdout] test mcp::bridge::tests::test_format_empty_error ... ok
[INFO] [stdout] test mcp::bridge::tests::test_format_empty_success ... ok
[INFO] [stdout] test mcp::bridge::tests::test_format_image_placeholder ... ok
[INFO] [stdout] test mcp::bridge::tests::test_format_mixed_content ... ok
[INFO] [stdout] test mcp::bridge::tests::test_format_multiple_text ... ok
[INFO] [stdout] test mcp::bridge::tests::test_format_resource_annotation ... ok
[INFO] [stdout] test mcp::bridge::tests::test_format_single_text ... ok
[INFO] [stdout] test mcp::bridge::tests::test_prefix_contract ... ok
[INFO] [stdout] test mcp::tests::test_error_response_detection ... ok
[INFO] [stdout] test mcp::tests::test_initialize_request_structure ... ok
[INFO] [stdout] test mcp::tests::test_initialized_notification_no_id ... ok
[INFO] [stdout] test mcp::tests::test_message_framing_for_mcp ... ok
[INFO] [stdout] test mcp::tests::test_resources_read_request_structure ... ok
[INFO] [stdout] test mcp::tests::test_response_id_matching ... ok
[INFO] [stdout] test mcp::tests::test_tools_call_request_structure ... ok
[INFO] [stdout] test mcp::transport::tests::test_mcp_encode_decode_roundtrip ... ok
[INFO] [stdout] test mcp::transport::tests::test_mcp_notification_framing ... ok
[INFO] [stdout] test mcp::transport::tests::test_mcp_tools_list_framing ... ok
[INFO] [stdout] test mcp::types::tests::test_content_image_deserialize ... ok
[INFO] [stdout] test mcp::types::tests::test_content_text_deserialize ... ok
[INFO] [stdout] test mcp::types::tests::test_resource_minimal ... ok
[INFO] [stdout] test mcp::types::tests::test_resource_read_result ... ok
[INFO] [stdout] test mcp::types::tests::test_resource_roundtrip ... ok
[INFO] [stdout] test mcp::types::tests::test_resources_list_result ... ok
[INFO] [stdout] test mcp::types::tests::test_tool_call_result_default_not_error ... ok
[INFO] [stdout] test mcp::types::tests::test_tool_call_result_error ... ok
[INFO] [stdout] test mcp::types::tests::test_tool_call_result_success ... ok
[INFO] [stdout] test mcp::types::tests::test_tool_definition_no_description ... ok
[INFO] [stdout] test mcp::types::tests::test_tool_definition_roundtrip ... ok
[INFO] [stdout] test mcp::types::tests::test_tools_list_result ... ok
[INFO] [stdout] test orchestrator::executor::tests::test_collect_dependents_direct_only ... ok
[INFO] [stdout] test llm::registry::tests::test_create_provider_copilot ... ok
[INFO] [stdout] test orchestrator::executor::tests::test_collect_dependents_transitive ... ok
[INFO] [stdout] test orchestrator::executor::tests::test_executor_cancels_dependents ... ok
[INFO] [stdout] test orchestrator::executor::tests::test_collect_dependents_leaf ... ok
[INFO] [stdout] test orchestrator::executor::tests::test_executor_empty_graph ... ok
[INFO] [stdout] test orchestrator::executor::tests::test_executor_linear_chain ... ok
[INFO] [stdout] test orchestrator::executor::tests::test_executor_parallel_tasks ... ok
[INFO] [stdout] test orchestrator::executor::tests::test_executor_single_task ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_add_single_task ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_cannot_start_from_non_pending ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_compute_waves_diamond ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_compute_waves_empty ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_compute_waves_no_deps ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_compute_waves_linear_chain ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_duplicate_id_rejected ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_empty_graph ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_mark_cancelled ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_is_finished ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_mark_failed_increments_retries ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_mark_running_and_completed ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_next_ready_after_completion ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_next_ready_initial_state ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_status_counts ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_serialisation_roundtrip ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_topological_sort_empty ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_topological_sort_linear_chain ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_topological_sort_diamond ... ok
[INFO] [stdout] test orchestrator::graph::tests::test_unknown_dependency_rejected ... ok
[INFO] [stdout] test sandbox::tests::test_nosandbox_exec_exit_code ... ok
[INFO] [stdout] test llm::registry::tests::test_create_provider_gemini_sentinel ... ok
[INFO] [stdout] test sandbox::tests::test_nosandbox_exec_simple ... ok
[INFO] [stdout] test llm::registry::tests::test_create_provider_anthropic_url ... ok
[INFO] [stdout] test session::store::tests::test_list_undo_does_not_remove ... ok
[INFO] [stdout] test llm::registry::tests::test_create_provider_ollama ... ok
[INFO] [stdout] test session::store::tests::test_message_all_roles ... ok
[INFO] [stdout] test session::store::tests::test_session_create_no_title ... ok
[INFO] [stdout] test session::store::tests::test_session_create_and_get ... ok
[INFO] [stdout] test session::store::tests::test_push_and_pop_undo ... ok
[INFO] [stdout] test llm::registry::tests::test_create_provider_gemini_url ... ok
[INFO] [stdout] test llm::registry::tests::test_create_provider_openai_fallback ... ok
[INFO] [stdout] test llm::openai::tests::test_is_copilot ... ok
[INFO] [stdout] test session::tests::test_auto_title_cjk ... ok
[INFO] [stdout] test session::tests::test_auto_title_cjk_short ... ok
[INFO] [stdout] test session::tests::test_auto_title_no_spaces ... ok
[INFO] [stdout] test session::tests::test_auto_title_short ... ok
[INFO] [stdout] test session::tests::test_auto_title_truncates_at_word ... ok
[INFO] [stdout] test session::store::tests::test_session_not_found ... ok
[INFO] [stdout] test session::store::tests::test_tool_calls_roundtrip ... ok
[INFO] [stdout] test tests::test_cli_copilot_provider_url ... ok
[INFO] [stdout] test tests::test_cli_debug_assert ... ok
[INFO] [stdout] test tests::test_cli_no_subcommand_is_repl ... ok
[INFO] [stdout] test tests::test_cli_no_subcommand_with_flags ... ok
[INFO] [stdout] test tests::test_cli_prompt_flag ... ok
[INFO] [stdout] test tests::test_cli_prompt_long_flag ... ok
[INFO] [stdout] test tests::test_cli_run_subcommand ... ok
[INFO] [stdout] test tests::test_cli_session_list ... ok
[INFO] [stdout] test tests::test_cli_session_show ... ok
[INFO] [stdout] test tools::bash::tests::test_bash_execute ... ok
[INFO] [stdout] test tools::bash::tests::test_bash_exit_code ... ok
[INFO] [stdout] test session::store::tests::test_session_list_ordering ... ok
[INFO] [stdout] test tools::bash::tests::test_bash_missing_command ... ok
[INFO] [stdout] test tools::bash::tests::test_truncate_output_long ... ok
[INFO] [stdout] test tools::bash::tests::test_truncate_output_short ... ok
[INFO] [stdout] test tools::display_image::tests::test_display_image_file_not_found ... ok
[INFO] [stdout] test tools::display_image::tests::test_display_image_missing_path ... ok
[INFO] [stdout] test session::store::tests::test_update_session_title ... ok
[INFO] [stdout] test spinner::tests::test_spinner_drop_safety ... ok
[INFO] [stdout] test tools::fetch::tests::test_fetch_missing_url ... ok
[INFO] [stdout] test tools::display_image::tests::test_display_image_non_image_ext ... ok
[INFO] [stdout] test tools::file_edit::tests::test_file_edit_multiple_matches ... ok
[INFO] [stdout] test tools::file_edit::tests::test_file_edit_not_found ... ok
[INFO] [stdout] test tools::file_edit::tests::test_file_edit_success ... ok
[INFO] [stdout] test tools::fetch::tests::test_fetch_success ... ok
[INFO] [stdout] test tools::file_read::tests::test_file_read_existing_file ... ok
[INFO] [stdout] test tools::file_read::tests::test_file_read_missing_file ... ok
[INFO] [stdout] test tools::file_read::tests::test_file_read_with_offset_limit ... ok
[INFO] [stdout] test tools::file_write::tests::test_file_write_creates_parent_dirs ... ok
[INFO] [stdout] test tools::git_blame::tests::test_git_blame_missing_path ... ok
[INFO] [stdout] test session::store::tests::test_update_session_tokens ... ok
[INFO] [stdout] test tools::git_commit::tests::test_git_commit_empty_message ... ok
[INFO] [stdout] test spinner::tests::test_spinner_non_tty_noop ... ok
[INFO] [stdout] test tools::git_commit::tests::test_git_commit_missing_message ... ok
[INFO] [stdout] test tools::git_diff::tests::test_find_char_boundary_ascii ... ok
[INFO] [stdout] test tools::git_blame::tests::test_git_blame_nonexistent_file ... ok
[INFO] [stdout] test tools::git_commit::tests::test_git_commit_no_git_repo ... ok
[INFO] [stdout] test tools::git_log::tests::test_git_log_default_count ... ok
[INFO] [stdout] test tools::git_log::tests::test_git_log_not_a_repo ... ok
[INFO] [stdout] test tools::file_write::tests::test_file_write_creates_file ... ok
[INFO] [stdout] test tools::git_diff::tests::test_git_diff_missing_git_repo ... ok
[INFO] [stdout] test tools::git_diff::tests::test_git_diff_staged_flag_builds_correctly ... ok
[INFO] [stdout] test session::store::tests::test_trim_undo_history ... ok
[INFO] [stdout] test tools::glob_search::tests::test_glob_search_invalid_pattern ... ok
[INFO] [stdout] test tools::glob_search::tests::test_glob_search_missing_pattern ... ok
[INFO] [stdout] test tools::glob_search::tests::test_glob_search_custom_path ... ok
[INFO] [stdout] test tools::glob_search::tests::test_glob_search_finds_files ... ok
[INFO] [stdout] test tools::glob_search::tests::test_glob_search_no_matches ... ok
[INFO] [stdout] test tools::grep_search::tests::test_grep_finds_matches ... ok
[INFO] [stdout] test tools::grep_search::tests::test_grep_include_filter ... ok
[INFO] [stdout] test tools::grep_search::tests::test_grep_invalid_regex ... ok
[INFO] [stdout] test tools::grep_search::tests::test_grep_missing_pattern ... ok
[INFO] [stdout] test tools::grep_search::tests::test_grep_no_matches ... ok
[INFO] [stdout] test tools::ls::tests::test_ls_nonexistent ... ok
[INFO] [stdout] test tools::lsp_diagnostics::tests::test_detect_language_id ... ok
[INFO] [stdout] test tools::ls::tests::test_ls_respects_gitignore ... ok
[INFO] [stdout] test tools::ls::tests::test_ls_recursive ... ok
[INFO] [stdout] test tools::lsp_diagnostics::tests::test_lsp_diagnostics_missing_path ... ok
[INFO] [stdout] test tools::lsp_diagnostics::tests::test_path_to_uri ... ok
[INFO] [stdout] test tools::lsp_diagnostics::tests::test_lsp_diagnostics_nonexistent_file ... ok
[INFO] [stdout] test tools::lsp_goto_def::tests::test_lsp_goto_def_metadata ... ok
[INFO] [stdout] test tools::lsp_goto_def::tests::test_lsp_goto_def_missing_params ... ok
[INFO] [stdout] test tools::ls::tests::test_ls_current_dir ... ok
[INFO] [stdout] test tools::lsp_goto_def::tests::test_parse_locations_array ... ok
[INFO] [stdout] test tools::lsp_goto_def::tests::test_lsp_goto_def_nonexistent_file ... ok
[INFO] [stdout] test tools::lsp_goto_def::tests::test_parse_locations_location_link ... ok
[INFO] [stdout] test tools::lsp_goto_def::tests::test_parse_locations_null ... ok
[INFO] [stdout] test tools::lsp_references::tests::test_lsp_references_include_declaration_default ... ok
[INFO] [stdout] test tools::lsp_references::tests::test_lsp_references_metadata ... ok
[INFO] [stdout] test tools::lsp_references::tests::test_lsp_references_missing_params ... ok
[INFO] [stdout] test tools::mcp_resource::tests::test_execute_empty_uri ... ok
[INFO] [stdout] test tools::lsp_references::tests::test_lsp_references_nonexistent_file ... ok
[INFO] [stdout] test tools::mcp_resource::tests::test_execute_no_mcp_client ... ok
[INFO] [stdout] test tools::mcp_resource::tests::test_format_binary_only ... ok
[INFO] [stdout] test tools::mcp_resource::tests::test_format_empty ... ok
[INFO] [stdout] test tools::mcp_resource::tests::test_format_multiple_text_blocks ... ok
[INFO] [stdout] test tools::mcp_resource::tests::test_tool_description_mentions_uri ... ok
[INFO] [stdout] test tools::mcp_resource::tests::test_format_single_text ... ok
[INFO] [stdout] test tools::mcp_resource::tests::test_tool_name ... ok
[INFO] [stdout] test tools::mcp_resource::tests::test_tool_schema ... ok
[INFO] [stdout] test tools::patch::tests::test_patch_context_mismatch ... ok
[INFO] [stdout] test tools::patch::tests::test_patch_missing_file ... ok
[INFO] [stdout] test tools::lsp_diagnostics::tests::test_lsp_diagnostics_metadata ... ok
[INFO] [stdout] test tools::lsp_goto_def::tests::test_parse_locations_single_location ... ok
[INFO] [stdout] test tools::patch::tests::test_patch_add_lines ... ok
[INFO] [stdout] test tools::patch::tests::test_patch_simple_change ... ok
[INFO] [stdout] test tools::patch::tests::test_patch_remove_lines ... ok
[INFO] [stdout] test tools::patch::tests::test_patch_multiple_hunks ... ok
[INFO] [stdout] test tools::question::tests::test_question_empty_options ... ok
[INFO] [stdout] test tools::question::tests::test_question_missing_options_arg ... ok
[INFO] [stdout] test tools::question::tests::test_question_missing_question_arg ... ok
[INFO] [stdout] test tools::question::tests::test_question_tool_metadata ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_empty_tasks_array_succeeds ... ok
[INFO] [stdout] test tools::question::tests::test_question_multiple_defaults_false ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_nesting_depth_at_limit_is_refused ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_nesting_depth_below_limit_is_allowed_to_attempt ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_parallel_false_accepted_as_serial ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_spawn_task_description_non_empty ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_spawn_task_name ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_spawn_task_schema_has_required_properties ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_task_missing_description_returns_error ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_task_missing_id_returns_error ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_tasks_not_array_returns_error ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_no_args_returns_usage_error ... ok
[INFO] [stdout] test tools::tests::test_registry_definitions ... ok
[INFO] [stdout] test tools::tests::test_registry_register_and_get ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_unknown_dependency_returns_error ... ok
[INFO] [stdout] test tracking::tests::test_cost_estimation_gpt4o ... ok
[INFO] [stdout] test tracking::tests::test_detailed_report_empty ... ok
[INFO] [stdout] test tracking::tests::test_cost_estimation_unknown_model ... ok
[INFO] [stdout] test tracking::tests::test_empty_tracker ... ok
[INFO] [stdout] test tracking::tests::test_detailed_report_with_turns ... ok
[INFO] [stdout] test tracking::tests::test_format_number ... ok
[INFO] [stdout] test tracking::tests::test_record_none_is_silently_skipped ... ok
[INFO] [stdout] test tracking::tests::test_record_some_usage ... ok
[INFO] [stdout] test tracking::tests::test_summary_line_with_known_model ... ok
[INFO] [stdout] test tracking::tests::test_summary_line_with_unknown_model ... ok
[INFO] [stdout] test tools::patch::tests::test_patch_missing_params ... ok
[INFO] [stdout] test tools::question::tests::test_question_schema_multiple_field ... ok
[INFO] [stdout] test tools::spawn_task::tests::test_max_concurrent_respected ... ok
[INFO] [stdout] test tools::fetch::tests::test_fetch_invalid_url ... ok
[INFO] [stdout] test sandbox::tests::test_nosandbox_timeout ... ok
[INFO] [stdout] test tools::bash::tests::test_bash_timeout ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 356 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.52s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/e2e_run.rs (/opt/rustwide/target/debug/deps/e2e_run-606e16d9cb7a9422)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test test_run_creates_file_via_tool_call ... FAILED
[INFO] [stdout] test test_session_persisted_after_run ... FAILED
[INFO] [stdout] test test_run_handles_llm_error ... FAILED
[INFO] [stdout] test test_run_simple_text_response ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- test_run_creates_file_via_tool_call stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'test_run_creates_file_via_tool_call' (771) panicked at tests/helpers.rs:31:29:
[INFO] [stdout] Failed to run "/opt/rustwide/workdir/target/debug/xcodeai": No such file or directory (os error 2)
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e658eb27ffa - std[ec419fa8110287d5]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5e658eb27ffa - std[ec419fa8110287d5]::backtrace_rs::backtrace::trace_unsynchronized::<std[ec419fa8110287d5]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5e658eb27ffa - std[ec419fa8110287d5]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5e658eb27ffa - <<std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[35159d6ffb30e017]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5e658eb3e93a - <core[35159d6ffb30e017]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5e658eb3e93a - core[35159d6ffb30e017]::fmt::write
[INFO] [stdout]    6:     0x5e658eb2d172 - std[ec419fa8110287d5]::io::default_write_fmt::<alloc[a8a7aba520129d98]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x5e658eb2d172 - <alloc[a8a7aba520129d98]::vec::Vec<u8> as std[ec419fa8110287d5]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x5e658eb04c5f - <std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5e658eb04c5f - std[ec419fa8110287d5]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5e658eb1f749 - std[ec419fa8110287d5]::panicking::default_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5e658e88f70c - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x5e658e88f70c - test[a8007afcd3effadc]::test_main_inner::<test[a8007afcd3effadc]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5e658eb1f9c2 - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x5e658eb1f9c2 - std[ec419fa8110287d5]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5e658eb04d18 - std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5e658eafc3a9 - std[ec419fa8110287d5]::sys::backtrace::__rust_end_short_backtrace::<std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5e658eb05bed - __rustc[cfb3622dd870db93]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5e658eb3f12c - core[35159d6ffb30e017]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5e658e7e087a - e2e_run[f17c409bbb288214]::helpers::run_xcode_with_env::{closure#0}::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/helpers.rs:31:29
[INFO] [stdout]   20:     0x5e658e80529a - <core[35159d6ffb30e017]::result::Result<std[ec419fa8110287d5]::process::Output, std[ec419fa8110287d5]::io::error::Error>>::unwrap_or_else::<e2e_run[f17c409bbb288214]::helpers::run_xcode_with_env::{closure#0}::{closure#0}>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/result.rs:1622:23
[INFO] [stdout]   21:     0x5e658e7e0fb6 - e2e_run[f17c409bbb288214]::helpers::run_xcode_with_env::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/helpers.rs:31:10
[INFO] [stdout]   22:     0x5e658e7fa913 - e2e_run[f17c409bbb288214]::test_run_creates_file_via_tool_call::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/e2e_run.rs:102:6
[INFO] [stdout]   23:     0x5e658e8327b2 - <core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>> as core[35159d6ffb30e017]::future::future::Future>::poll
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/future/future.rs:133:9
[INFO] [stdout]   24:     0x5e658e83282d - <core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>> as core[35159d6ffb30e017]::future::future::Future>::poll
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/future/future.rs:133:9
[INFO] [stdout]   25:     0x5e658e87ff2d - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:753:70
[INFO] [stdout]   26:     0x5e658e87fe2b - tokio[81848d6aa992384c]::task::coop::with_budget::<core[35159d6ffb30e017]::task::poll::Poll<()>, <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/task/coop/mod.rs:167:5
[INFO] [stdout]   27:     0x5e658e87fe2b - tokio[81848d6aa992384c]::task::coop::budget::<core[35159d6ffb30e017]::task::poll::Poll<()>, <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/task/coop/mod.rs:133:5
[INFO] [stdout]   28:     0x5e658e87fe2b - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:753:25
[INFO] [stdout]   29:     0x5e658e872d00 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Context>::enter::<core[35159d6ffb30e017]::task::poll::Poll<()>, <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:442:19
[INFO] [stdout]   30:     0x5e658e87efdd - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:752:44
[INFO] [stdout]   31:     0x5e658e87e2d4 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter::<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:840:68
[INFO] [stdout]   32:     0x5e658e7cc1fb - <tokio[81848d6aa992384c]::runtime::context::scoped::Scoped<tokio[81848d6aa992384c]::runtime::scheduler::Context>>::set::<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}, (alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>)>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/context/scoped.rs:40:9
[INFO] [stdout]   33:     0x5e658e824d49 - tokio[81848d6aa992384c]::runtime::context::set_scheduler::<(alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>), <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/context.rs:176:38
[INFO] [stdout]   34:     0x5e658e8752d2 - <std[ec419fa8110287d5]::thread::local::LocalKey<tokio[81848d6aa992384c]::runtime::context::Context>>::try_with::<tokio[81848d6aa992384c]::runtime::context::set_scheduler<(alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>), <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>)>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/local.rs:462:12
[INFO] [stdout]   35:     0x5e658e874e5e - <std[ec419fa8110287d5]::thread::local::LocalKey<tokio[81848d6aa992384c]::runtime::context::Context>>::with::<tokio[81848d6aa992384c]::runtime::context::set_scheduler<(alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>), <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>)>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/local.rs:426:20
[INFO] [stdout]   36:     0x5e658e8237cd - tokio[81848d6aa992384c]::runtime::context::set_scheduler::<(alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>), <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/context.rs:176:17
[INFO] [stdout]   37:     0x5e658e8784d0 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter::<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:840:27
[INFO] [stdout]   38:     0x5e658e8787c6 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:740:24
[INFO] [stdout]   39:     0x5e658e87d7f0 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CurrentThread>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:200:33
[INFO] [stdout]   40:     0x5e658e7f5443 - tokio[81848d6aa992384c]::runtime::context::runtime::enter_runtime::<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/context/runtime.rs:65:16
[INFO] [stdout]   41:     0x5e658e872411 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CurrentThread>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:188:9
[INFO] [stdout]   42:     0x5e658e862f64 - <tokio[81848d6aa992384c]::runtime::runtime::Runtime>::block_on_inner::<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/runtime.rs:368:52
[INFO] [stdout]   43:     0x5e658e86312f - <tokio[81848d6aa992384c]::runtime::runtime::Runtime>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/runtime.rs:342:18
[INFO] [stdout]   44:     0x5e658e7fb920 - e2e_run[f17c409bbb288214]::test_run_creates_file_via_tool_call
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/e2e_run.rs:119:56
[INFO] [stdout]   45:     0x5e658e7f6467 - e2e_run[f17c409bbb288214]::test_run_creates_file_via_tool_call::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/e2e_run.rs:73:47
[INFO] [stdout]   46:     0x5e658e7c9c66 - <e2e_run[f17c409bbb288214]::test_run_creates_file_via_tool_call::{closure#0} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   47:     0x5e658e8829eb - <fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   48:     0x5e658e8829eb - test[a8007afcd3effadc]::__rust_begin_short_backtrace::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:724:18
[INFO] [stdout]   49:     0x5e658e8901db - test[a8007afcd3effadc]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:74
[INFO] [stdout]   50:     0x5e658e8901db - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   51:     0x5e658e8901db - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   52:     0x5e658e8901db - std[ec419fa8110287d5]::panicking::catch_unwind::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   53:     0x5e658e8901db - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   54:     0x5e658e8901db - test[a8007afcd3effadc]::run_test_in_process
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:27
[INFO] [stdout]   55:     0x5e658e8901db - test[a8007afcd3effadc]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:668:43
[INFO] [stdout]   56:     0x5e658e88abb4 - test[a8007afcd3effadc]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:698:41
[INFO] [stdout]   57:     0x5e658e88abb4 - std[ec419fa8110287d5]::sys::backtrace::__rust_begin_short_backtrace::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   58:     0x5e658e892de2 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   59:     0x5e658e892de2 - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   60:     0x5e658e892de2 - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   61:     0x5e658e892de2 - std[ec419fa8110287d5]::panicking::catch_unwind::<(), core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   62:     0x5e658e892de2 - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   63:     0x5e658e892de2 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   64:     0x5e658e892de2 - <std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   65:     0x5e658eb273af - <alloc[a8a7aba520129d98]::boxed::Box<dyn core[35159d6ffb30e017]::ops::function::FnOnce<(), Output = ()> + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   66:     0x5e658eb273af - <std[ec419fa8110287d5]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   67:     0x71ebae0b3aa4 - <unknown>
[INFO] [stdout]   68:     0x71ebae140a64 - clone
[INFO] [stdout]   69:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test_session_persisted_after_run stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'test_session_persisted_after_run' (774) panicked at tests/helpers.rs:31:29:
[INFO] [stdout] Failed to run "/opt/rustwide/workdir/target/debug/xcodeai": No such file or directory (os error 2)
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e658eb27ffa - std[ec419fa8110287d5]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5e658eb27ffa - std[ec419fa8110287d5]::backtrace_rs::backtrace::trace_unsynchronized::<std[ec419fa8110287d5]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5e658eb27ffa - std[ec419fa8110287d5]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5e658eb27ffa - <<std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[35159d6ffb30e017]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5e658eb3e93a - <core[35159d6ffb30e017]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5e658eb3e93a - core[35159d6ffb30e017]::fmt::write
[INFO] [stdout]    6:     0x5e658eb2d172 - std[ec419fa8110287d5]::io::default_write_fmt::<alloc[a8a7aba520129d98]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x5e658eb2d172 - <alloc[a8a7aba520129d98]::vec::Vec<u8> as std[ec419fa8110287d5]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x5e658eb04c5f - <std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5e658eb04c5f - std[ec419fa8110287d5]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5e658eb1f749 - std[ec419fa8110287d5]::panicking::default_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5e658e88f70c - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x5e658e88f70c - test[a8007afcd3effadc]::test_main_inner::<test[a8007afcd3effadc]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5e658eb1f9c2 - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x5e658eb1f9c2 - std[ec419fa8110287d5]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5e658eb04d18 - std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5e658eafc3a9 - std[ec419fa8110287d5]::sys::backtrace::__rust_end_short_backtrace::<std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5e658eb05bed - __rustc[cfb3622dd870db93]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5e658eb3f12c - core[35159d6ffb30e017]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5e658e7e087a - e2e_run[f17c409bbb288214]::helpers::run_xcode_with_env::{closure#0}::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/helpers.rs:31:29
[INFO] [stdout]   20:     0x5e658e80529a - <core[35159d6ffb30e017]::result::Result<std[ec419fa8110287d5]::process::Output, std[ec419fa8110287d5]::io::error::Error>>::unwrap_or_else::<e2e_run[f17c409bbb288214]::helpers::run_xcode_with_env::{closure#0}::{closure#0}>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/result.rs:1622:23
[INFO] [stdout]   21:     0x5e658e7e0fb6 - e2e_run[f17c409bbb288214]::helpers::run_xcode_with_env::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/helpers.rs:31:10
[INFO] [stdout]   22:     0x5e658e7f9352 - e2e_run[f17c409bbb288214]::test_session_persisted_after_run::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/e2e_run.rs:205:6
[INFO] [stdout]   23:     0x5e658e8327b2 - <core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>> as core[35159d6ffb30e017]::future::future::Future>::poll
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/future/future.rs:133:9
[INFO] [stdout]   24:     0x5e658e83282d - <core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>> as core[35159d6ffb30e017]::future::future::Future>::poll
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/future/future.rs:133:9
[INFO] [stdout]   25:     0x5e658e87ff2d - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:753:70
[INFO] [stdout]   26:     0x5e658e87fe2b - tokio[81848d6aa992384c]::task::coop::with_budget::<core[35159d6ffb30e017]::task::poll::Poll<()>, <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/task/coop/mod.rs:167:5
[INFO] [stdout]   27:     0x5e658e87fe2b - tokio[81848d6aa992384c]::task::coop::budget::<core[35159d6ffb30e017]::task::poll::Poll<()>, <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/task/coop/mod.rs:133:5
[INFO] [stdout]   28:     0x5e658e87fe2b - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:753:25
[INFO] [stdout]   29:     0x5e658e872d00 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Context>::enter::<core[35159d6ffb30e017]::task::poll::Poll<()>, <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:442:19
[INFO] [stdout]   30:     0x5e658e87efdd - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:752:44
[INFO] [stdout]   31:     0x5e658e87e2d4 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter::<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:840:68
[INFO] [stdout]   32:     0x5e658e7cc1fb - <tokio[81848d6aa992384c]::runtime::context::scoped::Scoped<tokio[81848d6aa992384c]::runtime::scheduler::Context>>::set::<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}, (alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>)>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/context/scoped.rs:40:9
[INFO] [stdout]   33:     0x5e658e824d49 - tokio[81848d6aa992384c]::runtime::context::set_scheduler::<(alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>), <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/context.rs:176:38
[INFO] [stdout]   34:     0x5e658e8752d2 - <std[ec419fa8110287d5]::thread::local::LocalKey<tokio[81848d6aa992384c]::runtime::context::Context>>::try_with::<tokio[81848d6aa992384c]::runtime::context::set_scheduler<(alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>), <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>)>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/local.rs:462:12
[INFO] [stdout]   35:     0x5e658e874e5e - <std[ec419fa8110287d5]::thread::local::LocalKey<tokio[81848d6aa992384c]::runtime::context::Context>>::with::<tokio[81848d6aa992384c]::runtime::context::set_scheduler<(alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>), <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>)>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/local.rs:426:20
[INFO] [stdout]   36:     0x5e658e8237cd - tokio[81848d6aa992384c]::runtime::context::set_scheduler::<(alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>), <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/context.rs:176:17
[INFO] [stdout]   37:     0x5e658e8784d0 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter::<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:840:27
[INFO] [stdout]   38:     0x5e658e8787c6 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:740:24
[INFO] [stdout]   39:     0x5e658e87d7f0 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CurrentThread>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:200:33
[INFO] [stdout]   40:     0x5e658e7f5443 - tokio[81848d6aa992384c]::runtime::context::runtime::enter_runtime::<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/context/runtime.rs:65:16
[INFO] [stdout]   41:     0x5e658e872411 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CurrentThread>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:188:9
[INFO] [stdout]   42:     0x5e658e862f64 - <tokio[81848d6aa992384c]::runtime::runtime::Runtime>::block_on_inner::<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/runtime.rs:368:52
[INFO] [stdout]   43:     0x5e658e86312f - <tokio[81848d6aa992384c]::runtime::runtime::Runtime>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/runtime.rs:342:18
[INFO] [stdout]   44:     0x5e658e7fb763 - e2e_run[f17c409bbb288214]::test_session_persisted_after_run
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/e2e_run.rs:227:6
[INFO] [stdout]   45:     0x5e658e7f6437 - e2e_run[f17c409bbb288214]::test_session_persisted_after_run::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/e2e_run.rs:176:44
[INFO] [stdout]   46:     0x5e658e7c9c26 - <e2e_run[f17c409bbb288214]::test_session_persisted_after_run::{closure#0} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   47:     0x5e658e8829eb - <fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   48:     0x5e658e8829eb - test[a8007afcd3effadc]::__rust_begin_short_backtrace::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:724:18
[INFO] [stdout]   49:     0x5e658e8901db - test[a8007afcd3effadc]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:74
[INFO] [stdout]   50:     0x5e658e8901db - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   51:     0x5e658e8901db - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   52:     0x5e658e8901db - std[ec419fa8110287d5]::panicking::catch_unwind::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   53:     0x5e658e8901db - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   54:     0x5e658e8901db - test[a8007afcd3effadc]::run_test_in_process
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:27
[INFO] [stdout]   55:     0x5e658e8901db - test[a8007afcd3effadc]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:668:43
[INFO] [stdout]   56:     0x5e658e88abb4 - test[a8007afcd3effadc]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:698:41
[INFO] [stdout]   57:     0x5e658e88abb4 - std[ec419fa8110287d5]::sys::backtrace::__rust_begin_short_backtrace::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   58:     0x5e658e892de2 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   59:     0x5e658e892de2 - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   60:     0x5e658e892de2 - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   61:     0x5e658e892de2 - std[ec419fa8110287d5]::panicking::catch_unwind::<(), core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   62:     0x5e658e892de2 - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   63:     0x5e658e892de2 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   64:     0x5e658e892de2 - <std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   65:     0x5e658eb273af - <alloc[a8a7aba520129d98]::boxed::Box<dyn core[35159d6ffb30e017]::ops::function::FnOnce<(), Output = ()> + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   66:     0x5e658eb273af - <std[ec419fa8110287d5]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   67:     0x71ebae0b3aa4 - <unknown>
[INFO] [stdout]   68:     0x71ebae140a64 - clone
[INFO] [stdout]   69:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test_run_handles_llm_error stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'test_run_handles_llm_error' (772) panicked at tests/helpers.rs:31:29:
[INFO] [stderr] error: test failed, to rerun pass `--test e2e_run`
[INFO] [stdout] Failed to run "/opt/rustwide/workdir/target/debug/xcodeai": No such file or directory (os error 2)
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e658eb27ffa - std[ec419fa8110287d5]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5e658eb27ffa - std[ec419fa8110287d5]::backtrace_rs::backtrace::trace_unsynchronized::<std[ec419fa8110287d5]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5e658eb27ffa - std[ec419fa8110287d5]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5e658eb27ffa - <<std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[35159d6ffb30e017]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5e658eb3e93a - <core[35159d6ffb30e017]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5e658eb3e93a - core[35159d6ffb30e017]::fmt::write
[INFO] [stdout]    6:     0x5e658eb2d172 - std[ec419fa8110287d5]::io::default_write_fmt::<alloc[a8a7aba520129d98]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x5e658eb2d172 - <alloc[a8a7aba520129d98]::vec::Vec<u8> as std[ec419fa8110287d5]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x5e658eb04c5f - <std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5e658eb04c5f - std[ec419fa8110287d5]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5e658eb1f749 - std[ec419fa8110287d5]::panicking::default_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5e658e88f70c - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x5e658e88f70c - test[a8007afcd3effadc]::test_main_inner::<test[a8007afcd3effadc]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5e658eb1f9c2 - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x5e658eb1f9c2 - std[ec419fa8110287d5]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5e658eb04d18 - std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5e658eafc3a9 - std[ec419fa8110287d5]::sys::backtrace::__rust_end_short_backtrace::<std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5e658eb05bed - __rustc[cfb3622dd870db93]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5e658eb3f12c - core[35159d6ffb30e017]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5e658e7e087a - e2e_run[f17c409bbb288214]::helpers::run_xcode_with_env::{closure#0}::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/helpers.rs:31:29
[INFO] [stdout]   20:     0x5e658e80529a - <core[35159d6ffb30e017]::result::Result<std[ec419fa8110287d5]::process::Output, std[ec419fa8110287d5]::io::error::Error>>::unwrap_or_else::<e2e_run[f17c409bbb288214]::helpers::run_xcode_with_env::{closure#0}::{closure#0}>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/result.rs:1622:23
[INFO] [stdout]   21:     0x5e658e7e0fb6 - e2e_run[f17c409bbb288214]::helpers::run_xcode_with_env::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/helpers.rs:31:10
[INFO] [stdout]   22:     0x5e658e7f718f - e2e_run[f17c409bbb288214]::test_run_handles_llm_error::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/e2e_run.rs:154:6
[INFO] [stdout]   23:     0x5e658e8327b2 - <core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>> as core[35159d6ffb30e017]::future::future::Future>::poll
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/future/future.rs:133:9
[INFO] [stdout]   24:     0x5e658e83282d - <core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>> as core[35159d6ffb30e017]::future::future::Future>::poll
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/future/future.rs:133:9
[INFO] [stdout]   25:     0x5e658e87ff2d - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:753:70
[INFO] [stdout]   26:     0x5e658e87fe2b - tokio[81848d6aa992384c]::task::coop::with_budget::<core[35159d6ffb30e017]::task::poll::Poll<()>, <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/task/coop/mod.rs:167:5
[INFO] [stdout]   27:     0x5e658e87fe2b - tokio[81848d6aa992384c]::task::coop::budget::<core[35159d6ffb30e017]::task::poll::Poll<()>, <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/task/coop/mod.rs:133:5
[INFO] [stdout]   28:     0x5e658e87fe2b - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:753:25
[INFO] [stdout]   29:     0x5e658e872d00 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Context>::enter::<core[35159d6ffb30e017]::task::poll::Poll<()>, <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:442:19
[INFO] [stdout]   30:     0x5e658e87efdd - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:752:44
[INFO] [stdout]   31:     0x5e658e87e2d4 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter::<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:840:68
[INFO] [stdout]   32:     0x5e658e7cc1fb - <tokio[81848d6aa992384c]::runtime::context::scoped::Scoped<tokio[81848d6aa992384c]::runtime::scheduler::Context>>::set::<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}, (alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>)>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/context/scoped.rs:40:9
[INFO] [stdout]   33:     0x5e658e824d49 - tokio[81848d6aa992384c]::runtime::context::set_scheduler::<(alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>), <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/context.rs:176:38
[INFO] [stdout]   34:     0x5e658e8752d2 - <std[ec419fa8110287d5]::thread::local::LocalKey<tokio[81848d6aa992384c]::runtime::context::Context>>::try_with::<tokio[81848d6aa992384c]::runtime::context::set_scheduler<(alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>), <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>)>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/local.rs:462:12
[INFO] [stdout]   35:     0x5e658e874e5e - <std[ec419fa8110287d5]::thread::local::LocalKey<tokio[81848d6aa992384c]::runtime::context::Context>>::with::<tokio[81848d6aa992384c]::runtime::context::set_scheduler<(alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>), <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>)>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/local.rs:426:20
[INFO] [stdout]   36:     0x5e658e8237cd - tokio[81848d6aa992384c]::runtime::context::set_scheduler::<(alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>), <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/context.rs:176:17
[INFO] [stdout]   37:     0x5e658e8784d0 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter::<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:840:27
[INFO] [stdout]   38:     0x5e658e8787c6 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:740:24
[INFO] [stdout]   39:     0x5e658e87d7f0 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CurrentThread>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:200:33
[INFO] [stdout]   40:     0x5e658e7f5443 - tokio[81848d6aa992384c]::runtime::context::runtime::enter_runtime::<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/context/runtime.rs:65:16
[INFO] [stdout]   41:     0x5e658e872411 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CurrentThread>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:188:9
[INFO] [stdout]   42:     0x5e658e862f64 - <tokio[81848d6aa992384c]::runtime::runtime::Runtime>::block_on_inner::<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/runtime.rs:368:52
[INFO] [stdout]   43:     0x5e658e86312f - <tokio[81848d6aa992384c]::runtime::runtime::Runtime>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/runtime.rs:342:18
[INFO] [stdout]   44:     0x5e658e7fb3e0 - e2e_run[f17c409bbb288214]::test_run_handles_llm_error
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/e2e_run.rs:168:6
[INFO] [stdout]   45:     0x5e658e7f63d7 - e2e_run[f17c409bbb288214]::test_run_handles_llm_error::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/e2e_run.rs:127:38
[INFO] [stdout]   46:     0x5e658e7c9ba6 - <e2e_run[f17c409bbb288214]::test_run_handles_llm_error::{closure#0} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   47:     0x5e658e8829eb - <fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   48:     0x5e658e8829eb - test[a8007afcd3effadc]::__rust_begin_short_backtrace::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:724:18
[INFO] [stdout]   49:     0x5e658e8901db - test[a8007afcd3effadc]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:74
[INFO] [stdout]   50:     0x5e658e8901db - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   51:     0x5e658e8901db - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   52:     0x5e658e8901db - std[ec419fa8110287d5]::panicking::catch_unwind::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   53:     0x5e658e8901db - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   54:     0x5e658e8901db - test[a8007afcd3effadc]::run_test_in_process
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:27
[INFO] [stdout]   55:     0x5e658e8901db - test[a8007afcd3effadc]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:668:43
[INFO] [stdout]   56:     0x5e658e88abb4 - test[a8007afcd3effadc]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:698:41
[INFO] [stdout]   57:     0x5e658e88abb4 - std[ec419fa8110287d5]::sys::backtrace::__rust_begin_short_backtrace::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   58:     0x5e658e892de2 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   59:     0x5e658e892de2 - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   60:     0x5e658e892de2 - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   61:     0x5e658e892de2 - std[ec419fa8110287d5]::panicking::catch_unwind::<(), core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   62:     0x5e658e892de2 - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   63:     0x5e658e892de2 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   64:     0x5e658e892de2 - <std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   65:     0x5e658eb273af - <alloc[a8a7aba520129d98]::boxed::Box<dyn core[35159d6ffb30e017]::ops::function::FnOnce<(), Output = ()> + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   66:     0x5e658eb273af - <std[ec419fa8110287d5]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   67:     0x71ebae0b3aa4 - <unknown>
[INFO] [stdout]   68:     0x71ebae140a64 - clone
[INFO] [stdout]   69:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test_run_simple_text_response stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'test_run_simple_text_response' (773) panicked at tests/helpers.rs:31:29:
[INFO] [stdout] Failed to run "/opt/rustwide/workdir/target/debug/xcodeai": No such file or directory (os error 2)
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5e658eb27ffa - std[ec419fa8110287d5]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5e658eb27ffa - std[ec419fa8110287d5]::backtrace_rs::backtrace::trace_unsynchronized::<std[ec419fa8110287d5]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5e658eb27ffa - std[ec419fa8110287d5]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5e658eb27ffa - <<std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[35159d6ffb30e017]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5e658eb3e93a - <core[35159d6ffb30e017]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5e658eb3e93a - core[35159d6ffb30e017]::fmt::write
[INFO] [stdout]    6:     0x5e658eb2d172 - std[ec419fa8110287d5]::io::default_write_fmt::<alloc[a8a7aba520129d98]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x5e658eb2d172 - <alloc[a8a7aba520129d98]::vec::Vec<u8> as std[ec419fa8110287d5]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x5e658eb04c5f - <std[ec419fa8110287d5]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5e658eb04c5f - std[ec419fa8110287d5]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5e658eb1f749 - std[ec419fa8110287d5]::panicking::default_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5e658e88f70c - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x5e658e88f70c - test[a8007afcd3effadc]::test_main_inner::<test[a8007afcd3effadc]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5e658eb1f9c2 - <alloc[a8a7aba520129d98]::boxed::Box<dyn for<'a, 'b> core[35159d6ffb30e017]::ops::function::Fn<(&'a std[ec419fa8110287d5]::panic::PanicHookInfo<'b>,), Output = ()> + core[35159d6ffb30e017]::marker::Sync + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::Fn<(&std[ec419fa8110287d5]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x5e658eb1f9c2 - std[ec419fa8110287d5]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5e658eb04d18 - std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5e658eafc3a9 - std[ec419fa8110287d5]::sys::backtrace::__rust_end_short_backtrace::<std[ec419fa8110287d5]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5e658eb05bed - __rustc[cfb3622dd870db93]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5e658eb3f12c - core[35159d6ffb30e017]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5e658e7e087a - e2e_run[f17c409bbb288214]::helpers::run_xcode_with_env::{closure#0}::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/helpers.rs:31:29
[INFO] [stdout]   20:     0x5e658e80529a - <core[35159d6ffb30e017]::result::Result<std[ec419fa8110287d5]::process::Output, std[ec419fa8110287d5]::io::error::Error>>::unwrap_or_else::<e2e_run[f17c409bbb288214]::helpers::run_xcode_with_env::{closure#0}::{closure#0}>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/result.rs:1622:23
[INFO] [stdout]   21:     0x5e658e7e0fb6 - e2e_run[f17c409bbb288214]::helpers::run_xcode_with_env::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/helpers.rs:31:10
[INFO] [stdout]   22:     0x5e658e7f828d - e2e_run[f17c409bbb288214]::test_run_simple_text_response::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/e2e_run.rs:57:6
[INFO] [stdout]   23:     0x5e658e8327b2 - <core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>> as core[35159d6ffb30e017]::future::future::Future>::poll
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/future/future.rs:133:9
[INFO] [stdout]   24:     0x5e658e83282d - <core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>> as core[35159d6ffb30e017]::future::future::Future>::poll
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/future/future.rs:133:9
[INFO] [stdout]   25:     0x5e658e87ff2d - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:753:70
[INFO] [stdout]   26:     0x5e658e87fe2b - tokio[81848d6aa992384c]::task::coop::with_budget::<core[35159d6ffb30e017]::task::poll::Poll<()>, <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/task/coop/mod.rs:167:5
[INFO] [stdout]   27:     0x5e658e87fe2b - tokio[81848d6aa992384c]::task::coop::budget::<core[35159d6ffb30e017]::task::poll::Poll<()>, <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/task/coop/mod.rs:133:5
[INFO] [stdout]   28:     0x5e658e87fe2b - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:753:25
[INFO] [stdout]   29:     0x5e658e872d00 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Context>::enter::<core[35159d6ffb30e017]::task::poll::Poll<()>, <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:442:19
[INFO] [stdout]   30:     0x5e658e87efdd - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:752:44
[INFO] [stdout]   31:     0x5e658e87e2d4 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter::<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:840:68
[INFO] [stdout]   32:     0x5e658e7cc1fb - <tokio[81848d6aa992384c]::runtime::context::scoped::Scoped<tokio[81848d6aa992384c]::runtime::scheduler::Context>>::set::<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}, (alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>)>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/context/scoped.rs:40:9
[INFO] [stdout]   33:     0x5e658e824d49 - tokio[81848d6aa992384c]::runtime::context::set_scheduler::<(alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>), <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/context.rs:176:38
[INFO] [stdout]   34:     0x5e658e8752d2 - <std[ec419fa8110287d5]::thread::local::LocalKey<tokio[81848d6aa992384c]::runtime::context::Context>>::try_with::<tokio[81848d6aa992384c]::runtime::context::set_scheduler<(alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>), <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>)>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/local.rs:462:12
[INFO] [stdout]   35:     0x5e658e874e5e - <std[ec419fa8110287d5]::thread::local::LocalKey<tokio[81848d6aa992384c]::runtime::context::Context>>::with::<tokio[81848d6aa992384c]::runtime::context::set_scheduler<(alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>), <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>)>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/local.rs:426:20
[INFO] [stdout]   36:     0x5e658e8237cd - tokio[81848d6aa992384c]::runtime::context::set_scheduler::<(alloc[a8a7aba520129d98]::boxed::Box<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::Core>, core[35159d6ffb30e017]::option::Option<()>), <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/context.rs:176:17
[INFO] [stdout]   37:     0x5e658e8784d0 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::enter::<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>::{closure#0}, core[35159d6ffb30e017]::option::Option<()>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:840:27
[INFO] [stdout]   38:     0x5e658e8787c6 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:740:24
[INFO] [stdout]   39:     0x5e658e87d7f0 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CurrentThread>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:200:33
[INFO] [stdout]   40:     0x5e658e7f5443 - tokio[81848d6aa992384c]::runtime::context::runtime::enter_runtime::<<tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/context/runtime.rs:65:16
[INFO] [stdout]   41:     0x5e658e872411 - <tokio[81848d6aa992384c]::runtime::scheduler::current_thread::CurrentThread>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/scheduler/current_thread/mod.rs:188:9
[INFO] [stdout]   42:     0x5e658e862f64 - <tokio[81848d6aa992384c]::runtime::runtime::Runtime>::block_on_inner::<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/runtime.rs:368:52
[INFO] [stdout]   43:     0x5e658e86312f - <tokio[81848d6aa992384c]::runtime::runtime::Runtime>::block_on::<core[35159d6ffb30e017]::pin::Pin<&mut dyn core[35159d6ffb30e017]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.49.0/src/runtime/runtime.rs:342:18
[INFO] [stdout]   44:     0x5e658e7fb5a0 - e2e_run[f17c409bbb288214]::test_run_simple_text_response
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/e2e_run.rs:65:6
[INFO] [stdout]   45:     0x5e658e7f6407 - e2e_run[f17c409bbb288214]::test_run_simple_text_response::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/e2e_run.rs:30:41
[INFO] [stdout]   46:     0x5e658e7c9be6 - <e2e_run[f17c409bbb288214]::test_run_simple_text_response::{closure#0} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   47:     0x5e658e8829eb - <fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   48:     0x5e658e8829eb - test[a8007afcd3effadc]::__rust_begin_short_backtrace::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, fn() -> core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:724:18
[INFO] [stdout]   49:     0x5e658e8901db - test[a8007afcd3effadc]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:74
[INFO] [stdout]   50:     0x5e658e8901db - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   51:     0x5e658e8901db - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   52:     0x5e658e8901db - std[ec419fa8110287d5]::panicking::catch_unwind::<core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>, core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   53:     0x5e658e8901db - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<test[a8007afcd3effadc]::run_test_in_process::{closure#0}>, core[35159d6ffb30e017]::result::Result<(), alloc[a8a7aba520129d98]::string::String>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   54:     0x5e658e8901db - test[a8007afcd3effadc]::run_test_in_process
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:747:27
[INFO] [stdout]   55:     0x5e658e8901db - test[a8007afcd3effadc]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:668:43
[INFO] [stdout]   56:     0x5e658e88abb4 - test[a8007afcd3effadc]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/test/src/lib.rs:698:41
[INFO] [stdout]   57:     0x5e658e88abb4 - std[ec419fa8110287d5]::sys::backtrace::__rust_begin_short_backtrace::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   58:     0x5e658e892de2 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   59:     0x5e658e892de2 - <core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   60:     0x5e658e892de2 - std[ec419fa8110287d5]::panicking::catch_unwind::do_call::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:581:40
[INFO] [stdout]   61:     0x5e658e892de2 - std[ec419fa8110287d5]::panicking::catch_unwind::<(), core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panicking.rs:544:19
[INFO] [stdout]   62:     0x5e658e892de2 - std[ec419fa8110287d5]::panic::catch_unwind::<core[35159d6ffb30e017]::panic::unwind_safe::AssertUnwindSafe<std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/panic.rs:359:14
[INFO] [stdout]   63:     0x5e658e892de2 - std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked::<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   64:     0x5e658e892de2 - <std[ec419fa8110287d5]::thread::lifecycle::spawn_unchecked<test[a8007afcd3effadc]::run_test::{closure#1}, ()>::{closure#1} as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   65:     0x5e658eb273af - <alloc[a8a7aba520129d98]::boxed::Box<dyn core[35159d6ffb30e017]::ops::function::FnOnce<(), Output = ()> + core[35159d6ffb30e017]::marker::Send> as core[35159d6ffb30e017]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   66:     0x5e658eb273af - <std[ec419fa8110287d5]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/33835004928d3bf65db4d4712e1330766263b0bd/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   67:     0x71ebae0b3aa4 - <unknown>
[INFO] [stdout]   68:     0x71ebae140a64 - clone
[INFO] [stdout]   69:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     test_run_creates_file_via_tool_call
[INFO] [stdout]     test_run_handles_llm_error
[INFO] [stdout]     test_run_simple_text_response
[INFO] [stdout]     test_session_persisted_after_run
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 0 passed; 4 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.21s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "5b9b6cfe046b28c031e92b8ef76934222e2617d5b9a25df9f5b97f693d82b3e5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5b9b6cfe046b28c031e92b8ef76934222e2617d5b9a25df9f5b97f693d82b3e5", kill_on_drop: false }`
[INFO] [stdout] 5b9b6cfe046b28c031e92b8ef76934222e2617d5b9a25df9f5b97f693d82b3e5
