[INFO] cloning repository https://github.com/mova-compact/mova-agent-api
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/mova-compact/mova-agent-api" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmova-compact%2Fmova-agent-api", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmova-compact%2Fmova-agent-api'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 39ad813e2115b47c50e45378d0e1e733039f6a77
[INFO] testing mova-compact/mova-agent-api against 1.98.0-beta.1 for beta-1.98-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmova-compact%2Fmova-agent-api" "/workspace/builds/worker-4-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-4-tc2/source'...
[INFO] [stderr] done.
[INFO] removed /workspace/builds/worker-4-tc2/source/.cargo/config.toml
[INFO] started tweaking git repo https://github.com/mova-compact/mova-agent-api
[INFO] finished tweaking git repo https://github.com/mova-compact/mova-agent-api
[INFO] tweaked toml for git repo https://github.com/mova-compact/mova-agent-api written to /workspace/builds/worker-4-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/mova-compact/mova-agent-api on toolchain 1.98.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.98.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/mova-compact/mova-agent-api already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.98.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3d5ced03c013a94a2f102a4510f48a6e9184255caf5fd8244f58017bde7f5210" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] d2a8dd87db8e1714e6f9364ad3aefb1fdb174e4b0ec3e179006ab2aae300df0b
[INFO] running `Command { std: "docker" "start" "d2a8dd87db8e1714e6f9364ad3aefb1fdb174e4b0ec3e179006ab2aae300df0b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d2a8dd87db8e1714e6f9364ad3aefb1fdb174e4b0ec3e179006ab2aae300df0b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "d2a8dd87db8e1714e6f9364ad3aefb1fdb174e4b0ec3e179006ab2aae300df0b" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d2a8dd87db8e1714e6f9364ad3aefb1fdb174e4b0ec3e179006ab2aae300df0b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "d2a8dd87db8e1714e6f9364ad3aefb1fdb174e4b0ec3e179006ab2aae300df0b" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling quote v1.0.45
[INFO] [stderr]    Compiling unicode-ident v1.0.24
[INFO] [stderr]    Compiling libc v0.2.186
[INFO] [stderr]    Compiling stable_deref_trait v1.2.1
[INFO] [stderr]    Compiling bytes v1.11.1
[INFO] [stderr]    Compiling pin-project-lite v0.2.17
[INFO] [stderr]    Compiling itoa v1.0.18
[INFO] [stderr]    Compiling futures-core v0.3.32
[INFO] [stderr]    Compiling log v0.4.29
[INFO] [stderr]    Compiling find-msvc-tools v0.1.9
[INFO] [stderr]    Compiling shlex v1.3.0
[INFO] [stderr]    Compiling once_cell v1.21.4
[INFO] [stderr]    Compiling vcpkg v0.2.15
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling slab v0.4.12
[INFO] [stderr]    Compiling pkg-config v0.3.33
[INFO] [stderr]    Compiling writeable v0.6.3
[INFO] [stderr]    Compiling litemap v0.8.2
[INFO] [stderr]    Compiling icu_normalizer_data v2.2.0
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling utf8_iter v1.0.4
[INFO] [stderr]    Compiling futures-task v0.3.32
[INFO] [stderr]    Compiling cc v1.2.62
[INFO] [stderr]    Compiling percent-encoding v2.3.2
[INFO] [stderr]    Compiling icu_properties_data v2.2.0
[INFO] [stderr]    Compiling http v1.4.0
[INFO] [stderr]    Compiling tower-service v0.3.3
[INFO] [stderr]    Compiling futures-sink v0.3.32
[INFO] [stderr]    Compiling tracing-core v0.1.36
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling equivalent v1.0.2
[INFO] [stderr]    Compiling httparse v1.10.1
[INFO] [stderr]    Compiling hashbrown v0.17.1
[INFO] [stderr]    Compiling fnv v1.0.7
[INFO] [stderr]    Compiling cfg-if v1.0.4
[INFO] [stderr]    Compiling bitflags v2.11.1
[INFO] [stderr]    Compiling try-lock v0.2.5
[INFO] [stderr]    Compiling foreign-types-shared v0.1.1
[INFO] [stderr]    Compiling openssl v0.10.80
[INFO] [stderr]    Compiling atomic-waker v1.1.2
[INFO] [stderr]    Compiling foreign-types v0.3.2
[INFO] [stderr]    Compiling want v0.3.1
[INFO] [stderr]    Compiling form_urlencoded v1.2.2
[INFO] [stderr]    Compiling futures-channel v0.3.32
[INFO] [stderr]    Compiling sync_wrapper v1.0.2
[INFO] [stderr]    Compiling tower-layer v0.3.3
[INFO] [stderr]    Compiling indexmap v2.14.0
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling native-tls v0.2.18
[INFO] [stderr]    Compiling zmij v1.0.21
[INFO] [stderr]    Compiling httpdate v1.0.3
[INFO] [stderr]    Compiling serde_json v1.0.150
[INFO] [stderr]    Compiling openssl-probe v0.2.1
[INFO] [stderr]    Compiling base64 v0.22.1
[INFO] [stderr]    Compiling ipnet v2.12.0
[INFO] [stderr]    Compiling rustversion v1.0.22
[INFO] [stderr]    Compiling memchr v2.8.0
[INFO] [stderr]    Compiling ryu v1.0.23
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling mime v0.3.17
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling zeroize v1.8.2
[INFO] [stderr]    Compiling encoding_rs v0.8.35
[INFO] [stderr]    Compiling rustls-pki-types v1.14.1
[INFO] [stderr]    Compiling matchit v0.7.3
[INFO] [stderr]    Compiling openssl-sys v0.9.116
[INFO] [stderr]    Compiling http-body v1.0.1
[INFO] [stderr]    Compiling serde_path_to_error v0.1.20
[INFO] [stderr]    Compiling http-body-util v0.1.3
[INFO] [stderr]    Compiling socket2 v0.6.3
[INFO] [stderr]    Compiling mio v1.2.0
[INFO] [stderr]    Compiling synstructure v0.13.2
[INFO] [stderr]    Compiling zerofrom-derive v0.1.7
[INFO] [stderr]    Compiling yoke-derive v0.8.2
[INFO] [stderr]    Compiling zerovec-derive v0.11.3
[INFO] [stderr]    Compiling displaydoc v0.2.5
[INFO] [stderr]    Compiling tokio-macros v2.7.0
[INFO] [stderr]    Compiling openssl-macros v0.1.1
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling async-trait v0.1.89
[INFO] [stderr]    Compiling tokio v1.52.3
[INFO] [stderr]    Compiling zerofrom v0.1.8
[INFO] [stderr]    Compiling yoke v0.8.2
[INFO] [stderr]    Compiling axum-core v0.4.5
[INFO] [stderr]    Compiling zerotrie v0.2.4
[INFO] [stderr]    Compiling zerovec v0.11.6
[INFO] [stderr]    Compiling tinystr v0.8.3
[INFO] [stderr]    Compiling potential_utf v0.1.5
[INFO] [stderr]    Compiling icu_locale_core v2.2.0
[INFO] [stderr]    Compiling icu_collections v2.2.0
[INFO] [stderr]    Compiling icu_provider v2.2.0
[INFO] [stderr]    Compiling serde_urlencoded v0.7.1
[INFO] [stderr]    Compiling icu_normalizer v2.2.0
[INFO] [stderr]    Compiling icu_properties v2.2.0
[INFO] [stderr]    Compiling idna_adapter v1.2.2
[INFO] [stderr]    Compiling idna v1.1.0
[INFO] [stderr]    Compiling url v2.5.8
[INFO] [stderr]    Compiling tokio-util v0.7.18
[INFO] [stderr]    Compiling tower v0.5.3
[INFO] [stderr]    Compiling tokio-native-tls v0.3.1
[INFO] [stderr]    Compiling h2 v0.4.13
[INFO] [stderr]    Compiling tower-http v0.6.11
[INFO] [stderr]    Compiling hyper v1.9.0
[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 mova-agent-api v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized] target(s) in 53.63s
[INFO] running `Command { std: "docker" "inspect" "d2a8dd87db8e1714e6f9364ad3aefb1fdb174e4b0ec3e179006ab2aae300df0b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "d2a8dd87db8e1714e6f9364ad3aefb1fdb174e4b0ec3e179006ab2aae300df0b" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling tokio v1.52.3
[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 tower-http v0.6.11
[INFO] [stderr]    Compiling h2 v0.4.13
[INFO] [stderr]    Compiling hyper v1.9.0
[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 mova-agent-api v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized] target(s) in 32.52s
[INFO] running `Command { std: "docker" "inspect" "d2a8dd87db8e1714e6f9364ad3aefb1fdb174e4b0ec3e179006ab2aae300df0b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "d2a8dd87db8e1714e6f9364ad3aefb1fdb174e4b0ec3e179006ab2aae300df0b" "/opt/rustwide/cargo-home/bin/cargo" "+1.98.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized] target(s) in 0.26s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/mova_agent_api-8f23414c5c063997)
[INFO] [stdout] 
[INFO] [stdout] running 42 tests
[INFO] [stdout] test auth::tests::offline_stub_verifier_returns_fixture_result ... ok
[INFO] [stdout] test auth::tests::verifier_factory_returns_explicit_unverified_adapter_on_invalid_config ... ok
[INFO] [stdout] test auth::tests::offline_stub_verifier_returns_unverified_for_missing_fixture ... ok
[INFO] [stdout] test auth::tests::verifier_filters_scopes_using_allowed_scope_config ... ok
[INFO] [stdout] test auth::tests::verifier_marks_trusted_token_as_verified ... ok
[INFO] [stdout] test auth::tests::verifier_rejects_missing_audience_when_trust_config_requires_it ... ok
[INFO] [stdout] test connectors::tests::connector_status_serialization_is_snake_case ... ok
[INFO] [stdout] test auth::tests::verifier_rejects_untrusted_issuer ... ok
[INFO] [stdout] test connectors::tests::deterministic_local_executor_allows_none_intent ... ok
[INFO] [stdout] test connectors::tests::deterministic_local_executor_denies_unknown_connector ... ok
[INFO] [stdout] test connectors::tests::deterministic_local_executor_allows_http_generic_with_allowlisted_endpoint ... ok
[INFO] [stdout] test contract_run::tests::validate_contract_run_flow_rejects_duplicate_step_ids ... ok
[INFO] [stdout] test connectors::tests::offline_stub_executor_uses_stub_rule ... ok
[INFO] [stdout] test connectors::tests::deterministic_local_executor_denies_external_network ... ok
[INFO] [stdout] test contract_run::tests::validate_contract_run_flow_rejects_missing_operation_id ... ok
[INFO] [stdout] test contracts::tests::flow_validation_rejects_missing_step_ref ... ok
[INFO] [stdout] test evidence::tests::evidence_builder_collects_observation_refs ... ok
[INFO] [stdout] test contracts::tests::map_contract_to_agent_request_uses_contract_identity ... ok
[INFO] [stdout] test evidence::tests::run_status_wire_shape_is_snake_case ... ok
[INFO] [stdout] test execution::tests::flat_plan_from_action_is_single_path ... ok
[INFO] [stdout] test execution::tests::flat_plan_complete_transitions_state ... ok
[INFO] [stdout] test observation::tests::observation_journal_appends_records ... ok
[INFO] [stdout] test policy::tests::admission_decision_serialization_shape_is_stable ... ok
[INFO] [stdout] test policy::tests::policy_admission_allows_verified_production_auth_with_required_scope ... ok
[INFO] [stdout] test policy::tests::policy_admission_from_auth_context_normalizes_to_placeholder_mode ... ok
[INFO] [stdout] test policy::tests::policy_admission_new_sets_default_shape ... ok
[INFO] [stdout] test policy::tests::policy_admission_summary_maps_fields ... ok
[INFO] [stdout] test request::tests::parse_request_envelope_parses_minimal_shape ... ok
[INFO] [stdout] test request::tests::validate_request_envelope_accepts_minimal_shape ... ok
[INFO] [stdout] test policy::tests::policy_admission_denies_when_required_scope_is_missing ... ok
[INFO] [stdout] test request::tests::validate_request_envelope_rejects_missing_input_choice ... ok
[INFO] [stdout] test storage::tests::in_memory_store_roundtrip_snapshot ... ok
[INFO] [stdout] test runtime::tests::deterministic_default_runtime_config_validates ... ok
[INFO] [stdout] test policy::tests::policy_admission_denies_unverified_production_auth ... ok
[INFO] [stdout] test runtime::tests::invalid_runtime_config_fails_validation ... ok
[INFO] [stdout] test request::tests::validate_request_envelope_rejects_verified_true_for_v0 ... ok
[INFO] [stdout] test storage::tests::file_backed_store_roundtrip_snapshot ... ok
[INFO] [stdout] test secrets::tests::redact_json_redacts_secret_like_keys ... ok
[INFO] [stdout] test runtime::tests::local_env_secret_resolver_supports_runtime_secret_kind ... ok
[INFO] [stdout] test runtime::tests::local_env_provider_capabilities_are_provider_safe ... ok
[INFO] [stdout] test secrets::tests::redact_text_redacts_secret_like_content ... ok
[INFO] [stdout] test contract_run::tests::resolve_flow_transition_rejects_missing_outcome ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 42 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/auth_verifier_conformance.rs (/opt/rustwide/target/debug/deps/auth_verifier_conformance-3539e13ac5d1e349)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test deterministic_verifier_conformance_invalid_issuer ... ok
[INFO] [stdout] test deterministic_verifier_conformance_invalid_config_path ... ok
[INFO] [stdout] test offline_stub_verifier_conformance_missing_fixture ... ok
[INFO] [stdout] test deterministic_verifier_conformance_invalid_audience ... ok
[INFO] [stdout] test deterministic_verifier_conformance_verified ... ok
[INFO] [stdout] test offline_stub_verifier_conformance_verified_fixture ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/barbershop_admission_bridge_live_smoke.rs (/opt/rustwide/target/debug/deps/barbershop_admission_bridge_live_smoke-00f87c2733db0174)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test barbershop_bridge_live_smoke_e2e ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- barbershop_bridge_live_smoke_e2e stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'barbershop_bridge_live_smoke_e2e' (2496) panicked at tests/barbershop_admission_bridge_live_smoke.rs:19:52:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 2, kind: NotFound, message: "No such file or directory" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x64910d731a61 - <<std[73adb7dc35730857]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[6883ba1bc0fe4ed1]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x64910d74815a - core[6883ba1bc0fe4ed1]::fmt::write
[INFO] [stdout]    2:     0x64910d73664c - <alloc[55a36b64bcbf2c0d]::vec::Vec<u8> as std[73adb7dc35730857]::io::Write>::write_fmt
[INFO] [stdout]    3:     0x64910d70d626 - std[73adb7dc35730857]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x64910d728a09 - std[73adb7dc35730857]::panicking::default_hook
[INFO] [stdout]    5:     0x64910d1829f0 - test[980ffaebd391d06d]::test_main_inner::<test[980ffaebd391d06d]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x64910d728d32 - std[73adb7dc35730857]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x64910d70d6d2 - std[73adb7dc35730857]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x64910d704c49 - std[73adb7dc35730857]::sys::backtrace::__rust_end_short_backtrace::<std[73adb7dc35730857]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x64910d70e5ad - __rustc[a7b7b02e776dd976]::rust_begin_unwind
[INFO] [stdout]   10:     0x64910d74895c - core[6883ba1bc0fe4ed1]::panicking::panic_fmt
[INFO] [stdout]   11:     0x64910d7486d2 - core[6883ba1bc0fe4ed1]::result::unwrap_failed
[INFO] [stdout]   12:     0x64910d17592a - barbershop_admission_bridge_live_smoke[e23f277f8b9baa3a]::read_json
[INFO] [stdout]   13:     0x64910d1660aa - barbershop_admission_bridge_live_smoke[e23f277f8b9baa3a]::barbershop_bridge_live_smoke_e2e::{closure#0}
[INFO] [stdout]   14:     0x64910d165664 - <core[6883ba1bc0fe4ed1]::pin::Pin<&mut dyn core[6883ba1bc0fe4ed1]::future::future::Future<Output = ()>> as core[6883ba1bc0fe4ed1]::future::future::Future>::poll
[INFO] [stdout]   15:     0x64910d1656a6 - <core[6883ba1bc0fe4ed1]::pin::Pin<&mut core[6883ba1bc0fe4ed1]::pin::Pin<&mut dyn core[6883ba1bc0fe4ed1]::future::future::Future<Output = ()>>> as core[6883ba1bc0fe4ed1]::future::future::Future>::poll
[INFO] [stdout]   16:     0x64910d15cf36 - <tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[6883ba1bc0fe4ed1]::pin::Pin<&mut core[6883ba1bc0fe4ed1]::pin::Pin<&mut dyn core[6883ba1bc0fe4ed1]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}::{closure#0}
[INFO] [stdout]   17:     0x64910d15ce84 - <tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[6883ba1bc0fe4ed1]::pin::Pin<&mut core[6883ba1bc0fe4ed1]::pin::Pin<&mut dyn core[6883ba1bc0fe4ed1]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}
[INFO] [stdout]   18:     0x64910d156350 - <tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::Context>::enter::<core[6883ba1bc0fe4ed1]::task::poll::Poll<()>, <tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[6883ba1bc0fe4ed1]::pin::Pin<&mut core[6883ba1bc0fe4ed1]::pin::Pin<&mut dyn core[6883ba1bc0fe4ed1]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   19:     0x64910d15b9ad - <tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[6883ba1bc0fe4ed1]::pin::Pin<&mut core[6883ba1bc0fe4ed1]::pin::Pin<&mut dyn core[6883ba1bc0fe4ed1]::future::future::Future<Output = ()>>>>::{closure#0}
[INFO] [stdout]   20:     0x64910d15acb4 - <tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::CoreGuard>::enter::<<tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[6883ba1bc0fe4ed1]::pin::Pin<&mut core[6883ba1bc0fe4ed1]::pin::Pin<&mut dyn core[6883ba1bc0fe4ed1]::future::future::Future<Output = ()>>>>::{closure#0}, core[6883ba1bc0fe4ed1]::option::Option<()>>::{closure#0}
[INFO] [stdout]   21:     0x64910d15f471 - <tokio[9a0ebc49c8267c0f]::runtime::context::scoped::Scoped<tokio[9a0ebc49c8267c0f]::runtime::scheduler::Context>>::set::<<tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[6883ba1bc0fe4ed1]::pin::Pin<&mut core[6883ba1bc0fe4ed1]::pin::Pin<&mut dyn core[6883ba1bc0fe4ed1]::future::future::Future<Output = ()>>>>::{closure#0}, core[6883ba1bc0fe4ed1]::option::Option<()>>::{closure#0}, (alloc[55a36b64bcbf2c0d]::boxed::Box<tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::Core>, core[6883ba1bc0fe4ed1]::option::Option<()>)>
[INFO] [stdout]   22:     0x64910d160fd4 - tokio[9a0ebc49c8267c0f]::runtime::context::set_scheduler::<(alloc[55a36b64bcbf2c0d]::boxed::Box<tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::Core>, core[6883ba1bc0fe4ed1]::option::Option<()>), <tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[6883ba1bc0fe4ed1]::pin::Pin<&mut core[6883ba1bc0fe4ed1]::pin::Pin<&mut dyn core[6883ba1bc0fe4ed1]::future::future::Future<Output = ()>>>>::{closure#0}, core[6883ba1bc0fe4ed1]::option::Option<()>>::{closure#0}>::{closure#0}
[INFO] [stdout]   23:     0x64910d15724a - <std[73adb7dc35730857]::thread::local::LocalKey<tokio[9a0ebc49c8267c0f]::runtime::context::Context>>::try_with::<tokio[9a0ebc49c8267c0f]::runtime::context::set_scheduler<(alloc[55a36b64bcbf2c0d]::boxed::Box<tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::Core>, core[6883ba1bc0fe4ed1]::option::Option<()>), <tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[6883ba1bc0fe4ed1]::pin::Pin<&mut core[6883ba1bc0fe4ed1]::pin::Pin<&mut dyn core[6883ba1bc0fe4ed1]::future::future::Future<Output = ()>>>>::{closure#0}, core[6883ba1bc0fe4ed1]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[55a36b64bcbf2c0d]::boxed::Box<tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::Core>, core[6883ba1bc0fe4ed1]::option::Option<()>)>
[INFO] [stdout]   24:     0x64910d156e79 - <std[73adb7dc35730857]::thread::local::LocalKey<tokio[9a0ebc49c8267c0f]::runtime::context::Context>>::with::<tokio[9a0ebc49c8267c0f]::runtime::context::set_scheduler<(alloc[55a36b64bcbf2c0d]::boxed::Box<tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::Core>, core[6883ba1bc0fe4ed1]::option::Option<()>), <tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[6883ba1bc0fe4ed1]::pin::Pin<&mut core[6883ba1bc0fe4ed1]::pin::Pin<&mut dyn core[6883ba1bc0fe4ed1]::future::future::Future<Output = ()>>>>::{closure#0}, core[6883ba1bc0fe4ed1]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[55a36b64bcbf2c0d]::boxed::Box<tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::Core>, core[6883ba1bc0fe4ed1]::option::Option<()>)>
[INFO] [stdout]   25:     0x64910d160a5b - tokio[9a0ebc49c8267c0f]::runtime::context::set_scheduler::<(alloc[55a36b64bcbf2c0d]::boxed::Box<tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::Core>, core[6883ba1bc0fe4ed1]::option::Option<()>), <tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[6883ba1bc0fe4ed1]::pin::Pin<&mut core[6883ba1bc0fe4ed1]::pin::Pin<&mut dyn core[6883ba1bc0fe4ed1]::future::future::Future<Output = ()>>>>::{closure#0}, core[6883ba1bc0fe4ed1]::option::Option<()>>::{closure#0}>
[INFO] [stdout]   26:     0x64910d1587c4 - <tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::CoreGuard>::enter::<<tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[6883ba1bc0fe4ed1]::pin::Pin<&mut core[6883ba1bc0fe4ed1]::pin::Pin<&mut dyn core[6883ba1bc0fe4ed1]::future::future::Future<Output = ()>>>>::{closure#0}, core[6883ba1bc0fe4ed1]::option::Option<()>>
[INFO] [stdout]   27:     0x64910d158a92 - <tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[6883ba1bc0fe4ed1]::pin::Pin<&mut core[6883ba1bc0fe4ed1]::pin::Pin<&mut dyn core[6883ba1bc0fe4ed1]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   28:     0x64910d15a3a0 - <tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::CurrentThread>::block_on::<core[6883ba1bc0fe4ed1]::pin::Pin<&mut dyn core[6883ba1bc0fe4ed1]::future::future::Future<Output = ()>>>::{closure#0}
[INFO] [stdout]   29:     0x64910d159dcb - tokio[9a0ebc49c8267c0f]::runtime::context::runtime::enter_runtime::<<tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[6883ba1bc0fe4ed1]::pin::Pin<&mut dyn core[6883ba1bc0fe4ed1]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   30:     0x64910d155e88 - <tokio[9a0ebc49c8267c0f]::runtime::scheduler::current_thread::CurrentThread>::block_on::<core[6883ba1bc0fe4ed1]::pin::Pin<&mut dyn core[6883ba1bc0fe4ed1]::future::future::Future<Output = ()>>>
[INFO] [stdout]   31:     0x64910d15f0a5 - <tokio[9a0ebc49c8267c0f]::runtime::runtime::Runtime>::block_on_inner::<core[6883ba1bc0fe4ed1]::pin::Pin<&mut dyn core[6883ba1bc0fe4ed1]::future::future::Future<Output = ()>>>
[INFO] [stdout]   32:     0x64910d15f20b - <tokio[9a0ebc49c8267c0f]::runtime::runtime::Runtime>::block_on::<core[6883ba1bc0fe4ed1]::pin::Pin<&mut dyn core[6883ba1bc0fe4ed1]::future::future::Future<Output = ()>>>
[INFO] [stdout]   33:     0x64910d175c06 - barbershop_admission_bridge_live_smoke[e23f277f8b9baa3a]::barbershop_bridge_live_smoke_e2e
[INFO] [stdout]   34:     0x64910d165b83 - barbershop_admission_bridge_live_smoke[e23f277f8b9baa3a]::barbershop_bridge_live_smoke_e2e::{closure#0}
[INFO] [stdout]   35:     0x64910d15ebd6 - <barbershop_admission_bridge_live_smoke[e23f277f8b9baa3a]::barbershop_bridge_live_smoke_e2e::{closure#0} as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   36:     0x64910d175d2b - test[980ffaebd391d06d]::__rust_begin_short_backtrace::<core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String>, fn() -> core[6883ba1bc0fe4ed1]::result::Result<(), alloc[55a36b64bcbf2c0d]::string::String>>
[INFO] [stdout]   37:     0x64910d183375 - test[980ffaebd391d06d]::run_test::{closure#0}
[INFO] [stdout]   38:     0x64910d17de24 - std[73adb7dc35730857]::sys::backtrace::__rust_begin_short_backtrace::<test[980ffaebd391d06d]::run_test::{closure#1}, ()>
[INFO] [stdout]   39:     0x64910d1864c2 - <std[73adb7dc35730857]::thread::lifecycle::spawn_unchecked<test[980ffaebd391d06d]::run_test::{closure#1}, ()>::{closure#1} as core[6883ba1bc0fe4ed1]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   40:     0x64910d73069f - <std[73adb7dc35730857]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   41:     0x7f56250e7aa4 - <unknown>
[INFO] [stdout]   42:     0x7f5625174a64 - clone
[INFO] [stdout]   43:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     barbershop_bridge_live_smoke_e2e
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--test barbershop_admission_bridge_live_smoke`
[INFO] running `Command { std: "docker" "inspect" "d2a8dd87db8e1714e6f9364ad3aefb1fdb174e4b0ec3e179006ab2aae300df0b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d2a8dd87db8e1714e6f9364ad3aefb1fdb174e4b0ec3e179006ab2aae300df0b", kill_on_drop: false }`
[INFO] [stdout] d2a8dd87db8e1714e6f9364ad3aefb1fdb174e4b0ec3e179006ab2aae300df0b
