[INFO] cloning repository https://github.com/Aditya-PS-05/Cinder
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/Aditya-PS-05/Cinder" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FAditya-PS-05%2FCinder", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FAditya-PS-05%2FCinder'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] a4bb9b3a414116456454238eda7d3d54e2d96e1d
[INFO] testing Aditya-PS-05/Cinder against 1.97.0-beta.6 for beta-1.98-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FAditya-PS-05%2FCinder" "/workspace/builds/worker-3-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc1/source'...
[INFO] [stderr] done.
[INFO] removed /workspace/builds/worker-3-tc1/source/rust-toolchain.toml
[INFO] started tweaking git repo https://github.com/Aditya-PS-05/Cinder
[INFO] finished tweaking git repo https://github.com/Aditya-PS-05/Cinder
[INFO] tweaked toml for git repo https://github.com/Aditya-PS-05/Cinder written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/Aditya-PS-05/Cinder on toolchain 1.97.0-beta.6
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.97.0-beta.6" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/Aditya-PS-05/Cinder 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.97.0-beta.6" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded rand_xorshift v0.4.0
[INFO] [stderr]   Downloaded unarray v0.1.4
[INFO] [stderr]   Downloaded serde_yaml_ng v0.10.0
[INFO] [stderr]   Downloaded wasite v1.0.2
[INFO] [stderr]   Downloaded phf_shared v0.13.1
[INFO] [stderr]   Downloaded siphasher v1.0.2
[INFO] [stderr]   Downloaded wasm-bindgen-futures v0.4.68
[INFO] [stderr]   Downloaded wasi v0.14.7+wasi-0.2.4
[INFO] [stderr]   Downloaded md-5 v0.11.0
[INFO] [stderr]   Downloaded postgres-protocol v0.6.11
[INFO] [stderr]   Downloaded phf v0.13.1
[INFO] [stderr]   Downloaded whoami v2.1.1
[INFO] [stderr]   Downloaded postgres-types v0.2.13
[INFO] [stderr]   Downloaded tokio-postgres v0.7.17
[INFO] [stderr]   Downloaded objc2-system-configuration v0.3.2
[INFO] [stderr]   Downloaded futures-executor v0.3.32
[INFO] [stderr]   Downloaded tokio-tungstenite v0.24.0
[INFO] [stderr]   Downloaded deadpool-postgres v0.14.1
[INFO] [stderr]   Downloaded cc v1.2.60
[INFO] [stderr]   Downloaded futures v0.3.32
[INFO] [stderr]   Downloaded clap_derive v4.6.0
[INFO] [stderr]   Downloaded rustls-webpki v0.103.12
[INFO] [stderr]   Downloaded tungstenite v0.24.0
[INFO] [stderr]   Downloaded proptest v1.11.0
[INFO] [stderr]   Downloaded iri-string v0.7.12
[INFO] [stderr]   Downloaded rustls v0.23.38
[INFO] [stderr]   Downloaded web-sys v0.3.95
[INFO] [stderr]   Downloaded tokio v1.52.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3d5ced03c013a94a2f102a4510f48a6e9184255caf5fd8244f58017bde7f5210" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] dad0703a0f00af32577ec8ab0de238da83f3345b4d53d182792591b8cce16297
[INFO] running `Command { std: "docker" "start" "dad0703a0f00af32577ec8ab0de238da83f3345b4d53d182792591b8cce16297", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "dad0703a0f00af32577ec8ab0de238da83f3345b4d53d182792591b8cce16297", 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" "dad0703a0f00af32577ec8ab0de238da83f3345b4d53d182792591b8cce16297" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "dad0703a0f00af32577ec8ab0de238da83f3345b4d53d182792591b8cce16297", 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" "dad0703a0f00af32577ec8ab0de238da83f3345b4d53d182792591b8cce16297" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "build" "--frozen" "--message-format=json", 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.45
[INFO] [stderr]    Compiling libc v0.2.185
[INFO] [stderr]    Compiling cfg-if v1.0.4
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling bytes v1.11.1
[INFO] [stderr]    Compiling typenum v1.19.0
[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 memchr v2.8.0
[INFO] [stderr]    Compiling futures-sink v0.3.32
[INFO] [stderr]    Compiling once_cell v1.21.4
[INFO] [stderr]    Compiling stable_deref_trait v1.2.1
[INFO] [stderr]    Compiling slab v0.4.12
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling find-msvc-tools v0.1.9
[INFO] [stderr]    Compiling futures-channel v0.3.32
[INFO] [stderr]    Compiling shlex v1.3.0
[INFO] [stderr]    Compiling futures-io v0.3.32
[INFO] [stderr]    Compiling futures-task v0.3.32
[INFO] [stderr]    Compiling zeroize v1.8.2
[INFO] [stderr]    Compiling version_check v0.9.5
[INFO] [stderr]    Compiling tracing-core v0.1.36
[INFO] [stderr]    Compiling percent-encoding v2.3.2
[INFO] [stderr]    Compiling hashbrown v0.17.0
[INFO] [stderr]    Compiling rustls-pki-types v1.14.0
[INFO] [stderr]    Compiling cc v1.2.60
[INFO] [stderr]    Compiling httparse v1.10.1
[INFO] [stderr]    Compiling litemap v0.8.2
[INFO] [stderr]    Compiling writeable v0.6.3
[INFO] [stderr]    Compiling utf8parse v0.2.2
[INFO] [stderr]    Compiling generic-array v0.14.7
[INFO] [stderr]    Compiling untrusted v0.9.0
[INFO] [stderr]    Compiling equivalent v1.0.2
[INFO] [stderr]    Compiling anstyle-parse v1.0.0
[INFO] [stderr]    Compiling base64 v0.22.1
[INFO] [stderr]    Compiling anstyle v1.0.14
[INFO] [stderr]    Compiling http v1.4.0
[INFO] [stderr]    Compiling utf8_iter v1.0.4
[INFO] [stderr]    Compiling rustls v0.23.38
[INFO] [stderr]    Compiling colorchoice v1.0.5
[INFO] [stderr]    Compiling icu_normalizer_data v2.2.0
[INFO] [stderr]    Compiling log v0.4.29
[INFO] [stderr]    Compiling icu_properties_data v2.2.0
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.2
[INFO] [stderr]    Compiling anstyle-query v1.1.5
[INFO] [stderr]    Compiling anstream v1.0.0
[INFO] [stderr]    Compiling subtle v2.6.1
[INFO] [stderr]    Compiling strsim v0.11.1
[INFO] [stderr]    Compiling byteorder v1.5.0
[INFO] [stderr]    Compiling indexmap v2.14.0
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling heck v0.5.0
[INFO] [stderr]    Compiling clap_lex v1.1.0
[INFO] [stderr]    Compiling anyhow v1.0.102
[INFO] [stderr]    Compiling zerocopy v0.8.48
[INFO] [stderr]    Compiling tower-service v0.3.3
[INFO] [stderr]    Compiling try-lock v0.2.5
[INFO] [stderr]    Compiling atomic-waker v1.1.2
[INFO] [stderr]    Compiling hybrid-array v0.4.10
[INFO] [stderr]    Compiling webpki-roots v1.0.6
[INFO] [stderr]    Compiling ryu v1.0.23
[INFO] [stderr]    Compiling clap_builder v4.6.0
[INFO] [stderr]    Compiling want v0.3.1
[INFO] [stderr]    Compiling cpufeatures v0.2.17
[INFO] [stderr]    Compiling lazy_static v1.5.0
[INFO] [stderr]    Compiling form_urlencoded v1.2.2
[INFO] [stderr]    Compiling sync_wrapper v1.0.2
[INFO] [stderr]    Compiling zmij v1.0.21
[INFO] [stderr]    Compiling tower-layer v0.3.3
[INFO] [stderr]    Compiling ipnet v2.12.0
[INFO] [stderr]    Compiling http-body v1.0.1
[INFO] [stderr]    Compiling cmov v0.5.3
[INFO] [stderr]    Compiling regex-syntax v0.8.10
[INFO] [stderr]    Compiling const-oid v0.10.2
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling ctutils v0.4.2
[INFO] [stderr]    Compiling iri-string v0.7.12
[INFO] [stderr]    Compiling bitflags v2.11.1
[INFO] [stderr]    Compiling http-body-util v0.1.3
[INFO] [stderr]    Compiling sharded-slab v0.1.7
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling block-buffer v0.12.0
[INFO] [stderr]    Compiling crypto-common v0.2.1
[INFO] [stderr]    Compiling thread_local v1.1.9
[INFO] [stderr]    Compiling rand_core v0.10.1
[INFO] [stderr]    Compiling cpufeatures v0.3.0
[INFO] [stderr]    Compiling ring v0.17.14
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling mio v1.2.0
[INFO] [stderr]    Compiling socket2 v0.6.3
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling getrandom v0.2.17
[INFO] [stderr]    Compiling block-buffer v0.10.4
[INFO] [stderr]    Compiling crypto-common v0.1.7
[INFO] [stderr]    Compiling nu-ansi-term v0.50.3
[INFO] [stderr]    Compiling autocfg v1.5.0
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]    Compiling tinyvec v1.11.0
[INFO] [stderr]    Compiling sha2 v0.10.9
[INFO] [stderr]    Compiling digest v0.11.2
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling sha1 v0.10.6
[INFO] [stderr]    Compiling data-encoding v2.10.0
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling unsafe-libyaml v0.2.11
[INFO] [stderr]    Compiling utf-8 v0.7.6
[INFO] [stderr]    Compiling chacha20 v0.10.0
[INFO] [stderr]    Compiling webpki-roots v0.26.11
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling unicode-properties v0.1.4
[INFO] [stderr]    Compiling unicode-bidi v0.3.18
[INFO] [stderr]    Compiling rand v0.10.1
[INFO] [stderr]    Compiling unicode-normalization v0.1.25
[INFO] [stderr]    Compiling md-5 v0.11.0
[INFO] [stderr]    Compiling hmac v0.13.0
[INFO] [stderr]    Compiling sha2 v0.11.0
[INFO] [stderr]    Compiling fallible-iterator v0.2.0
[INFO] [stderr]    Compiling siphasher v1.0.2
[INFO] [stderr]    Compiling iana-time-zone v0.1.65
[INFO] [stderr]    Compiling phf_shared v0.13.1
[INFO] [stderr]    Compiling stringprep v0.1.5
[INFO] [stderr]    Compiling lock_api v0.4.14
[INFO] [stderr]    Compiling whoami v2.1.1
[INFO] [stderr]    Compiling num_cpus v1.17.0
[INFO] [stderr]    Compiling postgres-protocol v0.6.11
[INFO] [stderr]    Compiling phf v0.13.1
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling rustls-webpki v0.103.12
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling synstructure v0.13.2
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling tokio-macros v2.7.0
[INFO] [stderr]    Compiling zerovec-derive v0.11.3
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling futures-macro v0.3.32
[INFO] [stderr]    Compiling displaydoc v0.2.5
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling clap_derive v4.6.0
[INFO] [stderr]    Compiling async-trait v0.1.89
[INFO] [stderr]    Compiling zerofrom-derive v0.1.7
[INFO] [stderr]    Compiling yoke-derive v0.8.2
[INFO] [stderr]    Compiling tokio v1.52.0
[INFO] [stderr]    Compiling zerofrom v0.1.7
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling yoke v0.8.2
[INFO] [stderr]    Compiling tracing-subscriber v0.3.23
[INFO] [stderr]    Compiling zerovec v0.11.6
[INFO] [stderr]    Compiling zerotrie v0.2.4
[INFO] [stderr]    Compiling tinystr v0.8.3
[INFO] [stderr]    Compiling potential_utf v0.1.5
[INFO] [stderr]    Compiling icu_collections v2.2.0
[INFO] [stderr]    Compiling icu_locale_core v2.2.0
[INFO] [stderr]    Compiling clap v4.6.0
[INFO] [stderr]    Compiling futures-executor v0.3.32
[INFO] [stderr]    Compiling futures v0.3.32
[INFO] [stderr]    Compiling ts-core v0.0.1 (/opt/rustwide/workdir/crates/core)
[INFO] [stderr]    Compiling serde_urlencoded v0.7.1
[INFO] [stderr]    Compiling serde_yaml_ng v0.10.0
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling icu_provider v2.2.0
[INFO] [stderr]    Compiling icu_normalizer v2.2.0
[INFO] [stderr]    Compiling icu_properties v2.2.0
[INFO] [stderr]    Compiling ts-book v0.1.0 (/opt/rustwide/workdir/crates/book)
[INFO] [stderr]    Compiling ts-risk v0.1.0 (/opt/rustwide/workdir/crates/risk)
[INFO] [stderr]    Compiling ts-pnl v0.1.0 (/opt/rustwide/workdir/crates/pnl)
[INFO] [stderr]    Compiling ts-report v0.1.0 (/opt/rustwide/workdir/crates/report)
[INFO] [stderr]    Compiling ts-strategy v0.1.0 (/opt/rustwide/workdir/crates/strategy)
[INFO] [stderr]    Compiling ts-paper v0.1.0 (/opt/rustwide/workdir/crates/paper)
[INFO] [stderr]    Compiling ts-oms v0.1.0 (/opt/rustwide/workdir/crates/oms)
[INFO] [stderr]    Compiling ts-replay v0.1.0 (/opt/rustwide/workdir/crates/replay)
[INFO] [stderr]    Compiling ts-backtest v0.1.0 (/opt/rustwide/workdir/crates/backtest)
[INFO] [stderr]    Compiling postgres-types v0.2.13
[INFO] [stderr]    Compiling ts-config v0.0.1 (/opt/rustwide/workdir/crates/config)
[INFO] [stderr]    Compiling tungstenite v0.24.0
[INFO] [stderr]    Compiling idna_adapter v1.2.1
[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 tokio-rustls v0.26.4
[INFO] [stderr]    Compiling tower v0.5.3
[INFO] [stderr]    Compiling deadpool-runtime v0.1.4
[INFO] [stderr]    Compiling deadpool v0.12.3
[INFO] [stderr]    Compiling tokio-tungstenite v0.24.0
[INFO] [stderr]    Compiling tower-http v0.6.8
[INFO] [stderr]    Compiling h2 v0.4.13
[INFO] [stderr]    Compiling tokio-postgres v0.7.17
[INFO] [stderr]    Compiling deadpool-postgres v0.14.1
[INFO] [stderr]    Compiling hyper v1.9.0
[INFO] [stderr]    Compiling hyper-util v0.1.20
[INFO] [stderr]    Compiling hyper-rustls v0.27.9
[INFO] [stderr]    Compiling reqwest v0.12.28
[INFO] [stderr]    Compiling ts-binance v0.1.0 (/opt/rustwide/workdir/crates/binance)
[INFO] [stderr]    Compiling ts-storage v0.1.0 (/opt/rustwide/workdir/crates/storage)
[INFO] [stderr]    Compiling ts-runner v0.1.0 (/opt/rustwide/workdir/crates/runner)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 40s
[INFO] running `Command { std: "docker" "inspect" "dad0703a0f00af32577ec8ab0de238da83f3345b4d53d182792591b8cce16297", 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" "dad0703a0f00af32577ec8ab0de238da83f3345b4d53d182792591b8cce16297" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling regex-syntax v0.8.10
[INFO] [stderr]    Compiling tokio v1.52.0
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling unarray v0.1.4
[INFO] [stderr]    Compiling ts-report v0.1.0 (/opt/rustwide/workdir/crates/report)
[INFO] [stderr]    Compiling ts-config v0.0.1 (/opt/rustwide/workdir/crates/config)
[INFO] [stderr]    Compiling ts-backtest v0.1.0 (/opt/rustwide/workdir/crates/backtest)
[INFO] [stderr]    Compiling ts-replay v0.1.0 (/opt/rustwide/workdir/crates/replay)
[INFO] [stderr]    Compiling ts-oms v0.1.0 (/opt/rustwide/workdir/crates/oms)
[INFO] [stderr]    Compiling ts-strategy v0.1.0 (/opt/rustwide/workdir/crates/strategy)
[INFO] [stderr]    Compiling ts-paper v0.1.0 (/opt/rustwide/workdir/crates/paper)
[INFO] [stderr]    Compiling ts-book v0.1.0 (/opt/rustwide/workdir/crates/book)
[INFO] [stderr]    Compiling ts-risk v0.1.0 (/opt/rustwide/workdir/crates/risk)
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling rand v0.9.4
[INFO] [stderr]    Compiling rand_xorshift v0.4.0
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling proptest v1.11.0
[INFO] [stderr]    Compiling postgres-types v0.2.13
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling tracing-subscriber v0.3.23
[INFO] [stderr]    Compiling tokio-util v0.7.18
[INFO] [stderr]    Compiling tokio-rustls v0.26.4
[INFO] [stderr]    Compiling tower v0.5.3
[INFO] [stderr]    Compiling deadpool-runtime v0.1.4
[INFO] [stderr]    Compiling deadpool v0.12.3
[INFO] [stderr]    Compiling tokio-tungstenite v0.24.0
[INFO] [stderr]    Compiling tower-http v0.6.8
[INFO] [stderr]    Compiling h2 v0.4.13
[INFO] [stderr]    Compiling tokio-postgres v0.7.17
[INFO] [stderr]    Compiling ts-core v0.0.1 (/opt/rustwide/workdir/crates/core)
[INFO] [stderr]    Compiling ts-pnl v0.1.0 (/opt/rustwide/workdir/crates/pnl)
[INFO] [stderr]    Compiling deadpool-postgres v0.14.1
[INFO] [stderr]    Compiling hyper v1.9.0
[INFO] [stderr]    Compiling hyper-util v0.1.20
[INFO] [stderr]    Compiling hyper-rustls v0.27.9
[INFO] [stderr]    Compiling reqwest v0.12.28
[INFO] [stderr]    Compiling ts-binance v0.1.0 (/opt/rustwide/workdir/crates/binance)
[INFO] [stderr]    Compiling ts-storage v0.1.0 (/opt/rustwide/workdir/crates/storage)
[INFO] [stderr]    Compiling ts-runner v0.1.0 (/opt/rustwide/workdir/crates/runner)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 56.88s
[INFO] running `Command { std: "docker" "inspect" "dad0703a0f00af32577ec8ab0de238da83f3345b4d53d182792591b8cce16297", 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" "dad0703a0f00af32577ec8ab0de238da83f3345b4d53d182792591b8cce16297" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.42s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ts_backtest-5ce02cf1423845ad)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test tests::run_scenario_executes_all_actions ... ok
[INFO] [stdout] test scenarios::tests::by_name_resolves_known_scenarios ... ok
[INFO] [stdout] test scenarios::tests::different_seeds_yield_different_actions ... ok
[INFO] [stdout] test tests::run_scenario_produces_pnl_on_adverse_flow ... ok
[INFO] [stdout] test scenarios::tests::trending_up_mid_rises_each_step ... ok
[INFO] [stdout] test tests::tuning_default_is_sane ... ok
[INFO] [stdout] test scenarios::tests::seeded_scenarios_are_deterministic ... ok
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/bin/ts_backtest.rs (/opt/rustwide/target/debug/deps/ts_backtest-fbce04eee82c0df6)
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ts_binance-3722673cc6b637bc)
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 85 tests
[INFO] [stdout] test book::tests::buffers_before_snapshot ... ok
[INFO] [stdout] test book::tests::mid_stream_gap_transitions_to_lost ... ok
[INFO] [stdout] test book::tests::reset_returns_to_needs_snapshot ... ok
[INFO] [stdout] test book::tests::aligns_snapshot_and_replays_pending ... ok
[INFO] [stdout] test book::tests::live_delta_after_alignment_applies ... ok
[INFO] [stdout] test book::tests::alignment_gap_sets_lost ... ok
[INFO] [stdout] test live_engine::tests::binance_tif_returns_none_only_for_post_only ... ok
[INFO] [stdout] test live_engine::tests::ack_to_report_new_has_no_avg_price ... ok
[INFO] [stdout] test live_engine::tests::ack_to_report_filled_computes_avg_price ... ok
[INFO] [stdout] test live_engine::tests::ack_to_report_rejected_attaches_reason ... ok
[INFO] [stdout] test decode::tests::unknown_symbol_errors ... ok
[INFO] [stdout] test decode::tests::ack_frame_returns_none ... ok
[INFO] [stdout] test live_engine::tests::ts_status_covers_known_binance_strings ... ok
[INFO] [stdout] test decode::tests::unsupported_event_tag_errors ... ok
[INFO] [stdout] test order_rest::tests::account_summary_decodes_subset ... ok
[INFO] [stdout] test decode::tests::decodes_trade_fixture ... ok
[INFO] [stdout] test decode::tests::decodes_depth_fixture ... ok
[INFO] [stdout] test order_rest::tests::build_query_preserves_order_and_encodes_values ... ok
[INFO] [stdout] test order_rest::tests::cancel_and_query_select_by_orig_cid ... ok
[INFO] [stdout] test live_engine::tests::unknown_symbol_on_submit_returns_error_synchronously ... ok
[INFO] [stdout] test live_engine::tests::to_new_order_request_maps_post_only_to_limit_maker_without_tif ... ok
[INFO] [stdout] test live_engine::tests::to_new_order_request_encodes_limit_order_at_instrument_scale ... ok
[INFO] [stdout] test live_engine::tests::cancel_unknown_cid_is_rejected_synchronously_without_http ... ok
[INFO] [stdout] test live_engine::tests::resync_open_orders_is_noop_without_live_cids ... ok
[INFO] [stdout] test order_rest::tests::percent_encode_encodes_reserved_bytes ... ok
[INFO] [stdout] test order_rest::tests::order_ack_decodes_binance_payload ... ok
[INFO] [stdout] test order_rest::tests::percent_encode_passes_unreserved_untouched ... ok
[INFO] [stdout] test live_engine::tests::http_error_surfaces_as_rejected_report ... ok
[INFO] [stdout] test live_engine::tests::cancel_after_submit_uses_symbol_from_cid_map ... ok
[INFO] [stdout] test live_engine::tests::submit_returns_pending_new_then_reconcile_surfaces_filled ... ok
[INFO] [stdout] test order_rest::tests::hmac_sha256_matches_binance_doc_vector ... ok
[INFO] [stdout] test live_engine::tests::resync_open_orders_surfaces_venue_state_via_reconcile ... ok
[INFO] [stdout] test order_rest::tests::hmac_handles_long_key ... ok
[INFO] [stdout] test rest::tests::parses_fixture ... ok
[INFO] [stdout] test resync::tests::alignment_fails_when_bridge_missing_in_buffer ... ok
[INFO] [stdout] test live_engine::tests::query_returns_none_until_reconcile_runs ... ok
[INFO] [stdout] test resync::tests::active_chains_then_flags_gap ... ok
[INFO] [stdout] test resync::tests::apply_snapshot_drops_stale_and_aligns_bridge ... ok
[INFO] [stdout] test resync::tests::apply_snapshot_with_empty_pending_enters_bridging ... ok
[INFO] [stdout] test live_engine::tests::reconcile_accepts_normal_progression_new_partial_filled ... ok
[INFO] [stdout] test order_rest::tests::new_order_request_serializes_limit_params ... ok
[INFO] [stdout] test live_engine::tests::reconcile_drops_illegal_status_transition_and_counts_it ... ok
[INFO] [stdout] test resync::tests::bridging_accepts_bridge_event_and_transitions_active ... ok
[INFO] [stdout] test resync::tests::bridging_drops_strictly_pre_snapshot_events ... ok
[INFO] [stdout] test resync::tests::buffered_replay_chain_break_errors ... ok
[INFO] [stdout] test resync::tests::lost_state_remains_lost_until_reset ... ok
[INFO] [stdout] test resync::tests::new_state_buffers_every_delta ... ok
[INFO] [stdout] test resync::tests::trade_event_passes_through_even_while_needs_snapshot ... ok
[INFO] [stdout] test spot::tests::default_config_ships_with_health_probe_enabled ... ok
[INFO] [stdout] test spot::tests::dispatch_book_outcome_bumps_counter_and_errors_on_resync ... ok
[INFO] [stdout] test spot::tests::default_config_ships_with_nonzero_jitter ... ok
[INFO] [stdout] test spot::tests::health_probe_with_zero_silence_is_disabled ... ok
[INFO] [stdout] test spot::tests::jittered_backoff_clamps_out_of_range_inputs ... ok
[INFO] [stdout] test spot::tests::jittered_backoff_zero_base_stays_zero ... ok
[INFO] [stdout] test spot::tests::dispatch_book_outcome_does_not_bump_counter_on_buffered_or_ready ... ok
[INFO] [stdout] test spot::tests::jittered_backoff_is_identity_at_zero_ratio ... ok
[INFO] [stdout] test spot::tests::health_probe_activity_clears_ping_and_records_rtt ... ok
[INFO] [stdout] test resync::tests::bridging_rejects_post_snapshot_gap ... ok
[INFO] [stdout] test spot::tests::health_probe_activity_without_ping_does_not_touch_rtt_gauge ... ok
[INFO] [stdout] test spot::tests::dispatch_book_outcome_counter_is_cumulative ... ok
[INFO] [stdout] test spot::tests::health_probe_gives_up_after_pong_deadline ... ok
[INFO] [stdout] test spot::tests::health_probe_is_idle_while_within_silence_window ... ok
[INFO] [stdout] test spot::tests::jittered_backoff_respects_ratio_window ... ok
[INFO] [stdout] test spot::tests::probe_tick_period_tracks_silence_and_pong_windows ... ok
[INFO] [stdout] test spot::tests::health_probe_sends_one_ping_when_silence_expires ... ok
[INFO] [stdout] test spot::tests::xorshift_rng_zero_seed_is_rescued ... ok
[INFO] [stdout] test spot::tests::route_event_increments_counter_on_lost_state_delta ... ok
[INFO] [stdout] test user_stream::tests::avg_price_helper_is_zero_safe ... ok
[INFO] [stdout] test spot::tests::spot_client_exposes_shared_ping_rtt_gauge ... ok
[INFO] [stdout] test spot::tests::xorshift_rng_is_deterministic_and_in_unit_interval ... ok
[INFO] [stdout] test user_stream::tests::frame_dispatcher_forwards_execution_report ... ok
[INFO] [stdout] test user_stream::tests::decoder_accepts_new_order_report_with_no_fill ... ok
[INFO] [stdout] test user_stream::tests::decoder_errors_on_unknown_symbol ... ok
[INFO] [stdout] test user_stream::tests::decoder_emits_fill_on_partial_fill_frame ... ok
[INFO] [stdout] test user_stream::tests::frame_dispatcher_skips_balance_updates_but_flags_unknown_events ... ok
[INFO] [stdout] test user_stream::tests::decoder_marks_canceled_report_without_fills ... ok
[INFO] [stdout] test spot::tests::xorshift_rng_differs_across_seeds ... ok
[INFO] [stdout] test user_stream::tests::decoder_computes_avg_price_across_two_fills ... ok
[INFO] [stdout] test user_stream::tests::decoder_attaches_reason_to_rejected_report ... ok
[INFO] [stdout] test user_stream::tests::transition_guard_admits_first_report_for_any_cid ... ok
[INFO] [stdout] test user_stream::tests::transition_guard_drops_stale_partial_after_filled ... ok
[INFO] [stdout] test user_stream::tests::transition_guard_allows_new_partial_filled_progression ... ok
[INFO] [stdout] test user_stream::tests::transition_guard_counter_is_shared_across_clones ... ok
[INFO] [stdout] test user_stream::tests::transition_guard_isolates_cids ... ok
[INFO] [stdout] test order_rest::tests::testnet_constructor_points_at_testnet_base ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 85 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/bin/ts_md_binance.rs (/opt/rustwide/target/debug/deps/ts_md_binance-643d41d5c42c670a)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ts_book-a386e327d29946a4)
[INFO] [stdout] 
[INFO] [stdout] running 57 tests
[INFO] [stdout] test features::tests::ewma_constant_stream_converges_to_constant ... ok
[INFO] [stdout] test features::tests::ewma_alpha_one_tracks_last_observation ... ok
[INFO] [stdout] test features::tests::ewma_first_update_seeds_without_blend ... ok
[INFO] [stdout] test features::tests::ewma_fresh_has_no_value ... ok
[INFO] [stdout] test features::tests::ewma_recursion_is_respected ... ok
[INFO] [stdout] test features::tests::vpin_balanced_flow_gives_zero_imbalance ... ok
[INFO] [stdout] test features::tests::vpin_fresh_has_no_value ... ok
[INFO] [stdout] test features::tests::vpin_one_sided_bucket_saturates_at_one ... ok
[INFO] [stdout] test features::tests::vpin_rolling_window_evicts_old_buckets ... ok
[INFO] [stdout] test features::tests::vpin_reset_clears_state_but_keeps_configuration ... ok
[INFO] [stdout] test features::tests::vpin_splits_oversized_trade_across_buckets ... ok
[INFO] [stdout] test features::tests::vpin_trade_landing_exactly_on_boundary_does_not_over_complete ... ok
[INFO] [stdout] test features::tests::window_constant_stream_has_zero_variance ... ok
[INFO] [stdout] test features::tests::window_evicts_oldest_on_overflow ... ok
[INFO] [stdout] test features::tests::window_reset_clears_state ... ok
[INFO] [stdout] test features::tests::window_tracks_mean_and_population_variance ... ok
[INFO] [stdout] test features::tests::vpin_ignores_unknown_side_and_nonpositive_qty ... ok
[INFO] [stdout] test tests::apply_snapshot_sets_state ... ok
[INFO] [stdout] test features::tests::window_variance_never_negative_after_churn ... ok
[INFO] [stdout] test features::tests::window_mean_handles_single_sample ... ok
[INFO] [stdout] test features::tests::vpin_window_of_mixed_buckets_averages_correctly ... ok
[INFO] [stdout] test tests::delta_without_snapshot_errors ... ok
[INFO] [stdout] test tests::detects_gap ... ok
[INFO] [stdout] test features::tests::window_fresh_is_empty ... ok
[INFO] [stdout] test tests::empty_side_leaves_mid_none ... ok
[INFO] [stdout] test tests::imbalance_is_none_when_a_side_is_empty ... ok
[INFO] [stdout] test tests::imbalance_saturates_at_one_when_a_side_has_trivial_size ... ok
[INFO] [stdout] test tests::imbalance_is_zero_for_symmetric_top_of_book ... ok
[INFO] [stdout] test tests::delta_chains_and_advances_seq ... ok
[INFO] [stdout] test tests::imbalance_sign_tracks_dominant_side ... ok
[INFO] [stdout] test tests::microprice_is_none_when_a_side_is_empty ... ok
[INFO] [stdout] test tests::microprice_is_mid_when_top_quantities_match ... ok
[INFO] [stdout] test tests::microprice_leans_toward_ask_when_bid_queue_is_heavier ... ok
[INFO] [stdout] test tests::unchained_delta_skips_gap_check ... ok
[INFO] [stdout] test tests::microprice_leans_toward_bid_when_ask_queue_is_heavier ... ok
[INFO] [stdout] test features::tests::ewma_reset_clears_samples_but_not_alpha ... ok
[INFO] [stdout] test tests::rebase_seq_enables_backdated_chain ... ok
[INFO] [stdout] test tests::snapshot_drops_zero_qty_levels ... ok
[INFO] [stdout] test tests::spread_and_mid_round_down ... ok
[INFO] [stdout] test tests::top_n_returns_sorted_levels ... ok
[INFO] [stdout] test vol::tests::ewma_blend_formula_is_respected_after_seed ... ok
[INFO] [stdout] test vol::tests::first_update_primes_without_reading ... ok
[INFO] [stdout] test vol::tests::fresh_tracker_has_no_reading ... ok
[INFO] [stdout] test vol::tests::identical_mids_produce_zero_volatility ... ok
[INFO] [stdout] test vol::tests::negative_delta_has_same_magnitude_as_positive ... ok
[INFO] [stdout] test vol::tests::reset_clears_state_but_keeps_lambda ... ok
[INFO] [stdout] test vol::tests::second_update_seeds_variance_directly ... ok
[INFO] [stdout] test vol::tests::variance_converges_toward_true_variance_for_constant_magnitude_walk ... ok
[INFO] [stdout] test vol::tests::shock_decays_on_subsequent_calm_ticks ... ok
[INFO] [stdout] test features::tests::ewma_alpha_above_one_rejected - should panic ... ok
[INFO] [stdout] test features::tests::ewma_alpha_zero_rejected - should panic ... ok
[INFO] [stdout] test features::tests::vpin_zero_bucket_rejected - should panic ... ok
[INFO] [stdout] test features::tests::window_zero_cap_rejected - should panic ... ok
[INFO] [stdout] test features::tests::vpin_zero_window_rejected - should panic ... ok
[INFO] [stdout] test vol::tests::lambda_negative_rejected - should panic ... ok
[INFO] [stdout] test vol::tests::lambda_one_rejected - should panic ... ok
[INFO] [stdout] test vol::tests::lambda_zero_rejected - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 57 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.11s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ts_config-19cd0d014143469f)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test tests::env_parse_rejects_unknown ... ok
[INFO] [stdout] test tests::overlay_wins ... ok
[INFO] [stdout] test tests::env_override_coerces_scalar ... ok
[INFO] [stdout] test tests::base_only ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/real_configs.rs (/opt/rustwide/target/debug/deps/real_configs-8a3fc281dd421ca4)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ts_core-749bc5b2602990c4)
[INFO] [stdout] test dev_overlay_lowers_risk_limits ... ok
[INFO] [stdout] test prod_overlay_wins_over_base_for_pool_size ... ok
[INFO] [stdout] test loads_for_every_environment ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 32 tests
[INFO] [stdout] test decimal::tests::float_roundtrip_within_epsilon ... ok
[INFO] [stdout] test decimal::tests::float_rejects_nan_inf ... ok
[INFO] [stdout] test bus::tests::iter_terminates_after_close ... ok
[INFO] [stdout] test bus::tests::drop_removes_from_bus ... ok
[INFO] [stdout] test decimal::tests::overflow_detected ... ok
[INFO] [stdout] test bus::tests::slow_subscriber_drops_not_blocks ... ok
[INFO] [stdout] test bus::tests::basic_pub_sub ... ok
[INFO] [stdout] test bus::tests::close_is_idempotent_and_publish_becomes_noop ... ok
[INFO] [stdout] test decimal::tests::format_happy_paths ... ok
[INFO] [stdout] test decimal::tests::price_qty_helpers ... ok
[INFO] [stdout] test decimal::tests::parse_format_roundtrip ... ok
[INFO] [stdout] test decimal::tests::parse_rejects_garbage ... ok
[INFO] [stdout] test market::tests::latency_nanos_simple ... ok
[INFO] [stdout] test market::tests::latency_zero_when_unset ... ok
[INFO] [stdout] test market::tests::payload_match_is_exhaustive ... ok
[INFO] [stdout] test order::tests::is_terminal_matches_spec ... ok
[INFO] [stdout] test order::tests::partially_filled_cannot_go_back_to_new_or_rejected ... ok
[INFO] [stdout] test order::tests::rejected_builder_populates_fields ... ok
[INFO] [stdout] test order::tests::try_transition_surfaces_illegal_edge ... ok
[INFO] [stdout] test time::tests::default_is_unset ... ok
[INFO] [stdout] test time::tests::now_is_after_unset ... ok
[INFO] [stdout] test order::tests::new_can_reach_every_other_state ... ok
[INFO] [stdout] test market::tests::json_roundtrip_preserves_payload ... ok
[INFO] [stdout] test order::tests::self_transition_is_always_legal ... ok
[INFO] [stdout] test order::tests::terminal_states_do_not_transition_anywhere_else ... ok
[INFO] [stdout] test venue::tests::side_opposite_and_display ... ok
[INFO] [stdout] test venue::tests::instrument_spec_construction ... ok
[INFO] [stdout] test venue::tests::symbol_from_static_is_const ... ok
[INFO] [stdout] test venue::tests::venue_constants_and_runtime ... ok
[INFO] [stdout] test time::tests::unix_conversions ... ok
[INFO] [stdout] test bus::tests::concurrent_multi_producer_multi_subscriber ... ok
[INFO] [stdout] test decimal::tests::parse_happy_paths ... ok
[INFO] [stderr]      Running tests/proptest_order_status.rs (/opt/rustwide/target/debug/deps/proptest_order_status-89900c93f8e8aabc)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 32 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test self_transition_is_always_legal ... ok
[INFO] [stdout] test can_transition_matches_hand_rolled_spec ... ok
[INFO] [stdout] test rejected_is_only_reachable_from_new ... ok
[INFO] [stdout] test try_transition_matches_can_transition ... ok
[INFO] [stdout] test terminal_states_reject_all_other_transitions ... ok
[INFO] [stdout] test non_terminal_never_spontaneously_terminates_backwards ... ok
[INFO] [stdout] test random_legal_walk_respects_terminal_absorption ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.18s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ts_oms-06bf5f967bcdcc91)
[INFO] [stdout] 
[INFO] [stdout] running 27 tests
[INFO] [stdout] test order_engine::tests::paper_engine_trait_reconcile_is_empty ... ok
[INFO] [stdout] test tests::drain_shutdown_emits_cancels_even_when_paused ... ok
[INFO] [stdout] test order_engine::tests::generic_helper_drives_paper_engine_through_trait ... ok
[INFO] [stdout] test tests::apply_timer_fans_out_to_on_timer_and_actions_reach_engine ... ok
[INFO] [stdout] test order_engine::tests::paper_engine_trait_query_is_always_none ... ok
[INFO] [stdout] test tests::cancel_unknown_cid_rejects_without_touching_state ... ok
[INFO] [stdout] test tests::delta_before_snapshot_errors ... ok
[INFO] [stdout] test order_engine::tests::cancel_replace_stops_when_cancel_leg_rejected ... ok
[INFO] [stdout] test tests::duplicate_submit_for_live_cid_is_rejected ... ok
[INFO] [stdout] test tests::fill_driven_inventory_steers_maker_quotes_via_skew ... ok
[INFO] [stdout] test tests::external_market_order_fills_and_updates_risk_position ... ok
[INFO] [stdout] test tests::market_order_uses_fallback_price_when_book_one_sided ... ok
[INFO] [stdout] test tests::market_order_without_opposite_side_and_no_fallback_is_rejected ... ok
[INFO] [stdout] test tests::paused_engine_drops_on_timer_actions ... ok
[INFO] [stdout] test tests::paused_engine_drops_on_trade_actions ... ok
[INFO] [stdout] test tests::post_only_buy_crossing_best_ask_is_rejected ... ok
[INFO] [stdout] test tests::paused_engine_drops_strategy_actions_on_book_update ... ok
[INFO] [stdout] test tests::post_only_sell_crossing_best_bid_is_rejected ... ok
[INFO] [stdout] test tests::trade_payload_invokes_on_trade_and_default_impl_emits_nothing ... ok
[INFO] [stdout] test tests::snapshot_event_ticks_maker_and_places_two_quotes ... ok
[INFO] [stdout] test tests::risk_rejection_surfaces_as_exec_report_rejected ... ok
[INFO] [stdout] test tests::second_snapshot_cancels_prior_quotes_and_places_new ... ok
[INFO] [stdout] test tests::trade_payload_fans_out_to_on_trade_and_actions_reach_engine ... ok
[INFO] [stdout] test tests::post_only_limit_not_crossing_accepts_as_resting_maker ... ok
[INFO] [stdout] test order_engine::tests::cancel_replace_happy_path_retires_old_and_submits_new ... ok
[INFO] [stdout] test order_engine::tests::paper_engine_implements_order_engine_submit ... ok
[INFO] [stdout] test order_engine::tests::paper_engine_trait_cancel_unknown_cid_is_rejected ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 27 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ts_paper-d578b29c9f535672)
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ts_pnl-b3358daaaf0dc927)
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test tests::fok_fills_when_depth_sufficient ... ok
[INFO] [stdout] test tests::fok_rejects_on_insufficient_depth ... ok
[INFO] [stdout] test tests::limit_buy_no_cross_reports_new ... ok
[INFO] [stdout] test tests::limit_ioc_partial_is_canceled_with_fills ... ok
[INFO] [stdout] test tests::limit_buy_only_crosses_up_to_limit ... ok
[INFO] [stdout] test tests::market_buy_fills_across_asks ... ok
[INFO] [stdout] test tests::market_buy_insufficient_depth_is_canceled ... ok
[INFO] [stdout] test tests::market_sell_walks_bids_descending ... ok
[INFO] [stdout] test tests::rejects_zero_qty ... ok
[INFO] [stdout] test tests::rejects_unknown_side ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 34 tests
[INFO] [stdout] test tax_lots::tests::extending_fills_queue_as_separate_lots_not_averaged ... ok
[INFO] [stdout] test tax_lots::tests::exact_close_empties_queue ... ok
[INFO] [stdout] test tax_lots::tests::closed_lots_preserve_open_and_close_timestamps ... ok
[INFO] [stdout] test tax_lots::tests::cross_asset_fee_is_ignored_even_when_labeled ... ok
[INFO] [stdout] test tax_lots::tests::close_larger_than_front_lot_spills_to_next_lot ... ok
[INFO] [stdout] test tax_lots::tests::fifo_matches_wac_totals_on_single_cycle ... ok
[INFO] [stdout] test tax_lots::tests::fees_accumulate_on_quote_commissions_only ... ok
[INFO] [stdout] test tax_lots::tests::opens_long_from_flat ... ok
[INFO] [stdout] test tax_lots::tests::overshoot_flips_side_and_opens_fresh_lot ... ok
[INFO] [stdout] test tax_lots::tests::partial_close_consumes_oldest_lot_first ... ok
[INFO] [stdout] test tax_lots::tests::short_close_realizes_loss_on_higher_buyback ... ok
[INFO] [stdout] test tax_lots::tests::short_close_realizes_on_lower_buyback ... ok
[INFO] [stdout] test tax_lots::tests::unknown_side_and_zero_qty_are_noops ... ok
[INFO] [stdout] test tax_lots::tests::unrealized_sums_per_lot_for_long_queue ... ok
[INFO] [stdout] test tax_lots::tests::unrealized_sums_per_lot_for_short_queue ... ok
[INFO] [stdout] test tax_lots::tests::unrealized_total_applies_per_symbol_mark ... ok
[INFO] [stdout] test tests::exact_close_clears_avg ... ok
[INFO] [stdout] test tests::cross_asset_fee_is_captured_on_fill_but_skipped_by_accountant ... ok
[INFO] [stdout] test tests::fees_total_sums_across_symbols ... ok
[INFO] [stdout] test tests::flip_long_to_short_realizes_and_opens ... ok
[INFO] [stdout] test tests::extends_long_with_weighted_avg ... ok
[INFO] [stdout] test tests::opens_long_from_flat ... ok
[INFO] [stdout] test tests::partial_close_long_realizes_pnl ... ok
[INFO] [stdout] test tests::quote_fee_reduces_realized_net_but_keeps_gross_intact ... ok
[INFO] [stdout] test tests::opens_short_from_flat ... ok
[INFO] [stdout] test tests::short_close_realizes_loss_on_higher_buyback ... ok
[INFO] [stdout] test tests::short_close_realizes_on_lower_buyback ... ok
[INFO] [stdout] test tests::unrealized_flat_is_zero ... ok
[INFO] [stdout] test tests::unknown_side_is_ignored ... ok
[INFO] [stdout] test tests::unrealized_long_positive_when_mark_above_avg ... ok
[INFO] [stdout] test tests::realized_total_sums_across_symbols ... ok
[INFO] [stdout] test tests::zero_qty_is_ignored ... ok
[INFO] [stdout] test tests::unrealized_total_applies_per_symbol_mark ... ok
[INFO] [stdout] test tests::unrealized_short_positive_when_mark_below_avg ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 34 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/proptest_accountant.rs (/opt/rustwide/target/debug/deps/proptest_accountant-56b05bba1a52e132)
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test fifo_unrealized_is_zero_when_flat ... ok
[INFO] [stdout] test fifo_matches_closed_form_on_full_close ... ok
[INFO] [stdout] test wac_matches_fifo_when_all_opens_share_a_price ... ok
[INFO] [stdout] test extension_only_stream_has_zero_realized_and_exact_position ... ok
[INFO] [stdout] test fifo_realized_net_is_gross_minus_fees ... ok
[INFO] [stdout] test totals_equal_per_symbol_sums ... ok
[INFO] [stdout] test fifo_queue_is_homogeneous_and_position_sums_open_lots ... ok
[INFO] [stdout] test wac_realized_net_is_gross_minus_fees ... ok
[INFO] [stdout] test wac_and_fifo_agree_on_signed_position ... ok
[INFO] [stdout] test fifo_closed_lots_sum_to_realized ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.10s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ts_replay-0d9d26037acc97b2)
[INFO] [stdout] 
[INFO] [stdout] running 19 tests
[INFO] [stdout] test invariants::tests::position_bound_breached_when_accumulation_exceeds_cap ... ok
[INFO] [stdout] test invariants::tests::position_bound_holds_on_flat_book ... ok
[INFO] [stdout] test tests::run_over_snapshots_counts_book_updates_and_places_quotes ... ok
[INFO] [stdout] test tests::registered_position_bound_captures_breach_on_oversized_taker_fill ... ok
[INFO] [stdout] test tests::summary_reports_unrealized_from_book_mid ... ok
[INFO] [stdout] test invariants::tests::position_bound_also_catches_short_side ... ok
[INFO] [stdout] test invariants::tests::gross_filled_qty_monotone_breaches_on_regression ... ok
[INFO] [stdout] test tests::summary_mark_is_none_on_one_sided_book ... ok
[INFO] [stdout] test tests::no_invariants_registered_produces_empty_violations_vec ... ok
[INFO] [stdout] test tests::set_paused_propagates_and_gates_strategy_actions ... ok
[INFO] [stdout] test tests::taker_fill_updates_position_and_realized_pnl ... ok
[INFO] [stdout] test tests::gross_filled_qty_monotone_holds_across_normal_replay ... ok
[INFO] [stdout] test tests::drain_shutdown_cancels_the_makers_open_quotes ... ok
[INFO] [stdout] test tests::tick_timer_fans_out_to_on_timer_without_market_events ... ok
[INFO] [stdout] test tests::tick_timer_is_gated_by_pause ... ok
[INFO] [stdout] test tests::gross_notional_and_filled_qty_accumulate_across_fills ... ok
[INFO] [stdout] test tests::unknown_cid_cancel_surfaces_rejected ... ok
[INFO] [stdout] test tests::run_propagates_book_error_on_bad_delta ... ok
[INFO] [stdout] test invariants::tests::gross_filled_qty_monotone_never_fires_on_a_growing_counter ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 19 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ts_report-e09a9a0921e524d1)
[INFO] [stderr]      Running unittests src/bin/ts_report.rs (/opt/rustwide/target/debug/deps/ts_report-2f5da8a48d49a8e8)
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test tests::fills_per_min_is_none_on_single_instant ... ok
[INFO] [stdout] test tests::drawdown_captures_peak_to_trough_on_realized_curve ... ok
[INFO] [stdout] test tests::realized_pnl_matches_accountant_rules ... ok
[INFO] [stdout] test tests::liquidity_breakdown_counts_maker_taker_and_unknown ... ok
[INFO] [stdout] test tests::status_counters_track_each_variant ... ok
[INFO] [stdout] test tests::sharpe_like_is_signed_and_finite_for_mixed_returns ... ok
[INFO] [stdout] test tests::format_text_renders_key_fields ... ok
[INFO] [stdout] test tests::sharpe_like_is_none_for_zero_variance_curve ... ok
[INFO] [stdout] test tests::read_ndjson_roundtrips_writer_shape ... ok
[INFO] [stdout] test tests::malformed_lines_are_counted_and_skipped ... ok
[INFO] [stdout] test tests::fills_aggregate_per_symbol_and_track_position_extremes ... ok
[INFO] [stdout] test tests::fills_per_min_uses_tape_span ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ts_risk-5cbdd893679f47a9)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 56 tests
[INFO] [stdout] test clock_skew_guard::tests::negative_skew_past_limit_also_breaches ... ok
[INFO] [stdout] test clock_skew_guard::tests::permissive_guard_never_breaches ... ok
[INFO] [stdout] test clock_skew_guard::tests::positive_skew_past_limit_breaches_once ... ok
[INFO] [stdout] test clock_skew_guard::tests::reset_rearms_without_dropping_history ... ok
[INFO] [stdout] test clock_skew_guard::tests::unset_timestamps_are_ignored ... ok
[INFO] [stdout] test clock_skew_tracker::tests::empty_tracker_has_no_entries ... ok
[INFO] [stdout] test clock_skew_tracker::tests::iter_surfaces_every_tracked_venue ... ok
[INFO] [stdout] test clock_skew_tracker::tests::max_abs_never_regresses ... ok
[INFO] [stdout] test clock_skew_tracker::tests::max_abs_tracks_unsigned_magnitude_of_both_polarities ... ok
[INFO] [stdout] test clock_skew_tracker::tests::multiple_venues_are_isolated ... ok
[INFO] [stdout] test clock_skew_tracker::tests::running_mean_matches_naive_average ... ok
[INFO] [stdout] test clock_skew_tracker::tests::single_sample_mean_equals_value_and_stddev_is_zero ... ok
[INFO] [stdout] test clock_skew_tracker::tests::stddev_matches_naive_sample_variance ... ok
[INFO] [stdout] test clock_skew_tracker::tests::zero_skew_is_recorded_as_a_sample_not_a_no_op ... ok
[INFO] [stdout] test kill_switch::tests::fresh_switch_is_armed ... ok
[INFO] [stdout] test kill_switch::tests::old_rejects_age_out_of_window ... ok
[INFO] [stdout] test pnl_guard::tests::both_limits_report_daily_first_on_combined_tick ... ok
[INFO] [stdout] test kill_switch::tests::reject_threshold_trips_with_reason ... ok
[INFO] [stdout] test kill_switch::tests::reset_clears_state_and_window ... ok
[INFO] [stdout] test pnl_guard::tests::daily_loss_fires_on_realized_drop_only ... ok
[INFO] [stdout] test pnl_guard::tests::day_rollover_reseats_baseline_and_rearms ... ok
[INFO] [stdout] test pnl_guard::tests::drawdown_breach_fires_once_with_context ... ok
[INFO] [stdout] test pnl_guard::tests::drawdown_exactly_equal_to_limit_does_not_trip ... ok
[INFO] [stdout] test pnl_guard::tests::peak_tracks_high_water_mark ... ok
[INFO] [stdout] test kill_switch::tests::manual_trip_locks_reason_from_first_caller ... ok
[INFO] [stdout] test pnl_guard::tests::permissive_guard_never_breaches ... ok
[INFO] [stdout] test pnl_guard::tests::drawdown_does_not_reset_on_day_rollover ... ok
[INFO] [stdout] test staleness_guard::tests::exact_limit_does_not_trip ... ok
[INFO] [stdout] test pnl_guard::tests::reset_rearms_both_limits_but_keeps_history ... ok
[INFO] [stdout] test staleness_guard::tests::fresh_event_rearms_and_moves_the_baseline ... ok
[INFO] [stdout] test staleness_guard::tests::permissive_guard_never_breaches ... ok
[INFO] [stdout] test staleness_guard::tests::breach_fires_once_after_silent_stretch ... ok
[INFO] [stdout] test pnl_guard::tests::daily_loss_does_not_fire_on_unrealized_only ... ok
[INFO] [stdout] test staleness_guard::tests::manual_reset_rearms_without_moving_baseline ... ok
[INFO] [stdout] test staleness_guard::tests::check_without_any_event_is_a_no_op ... ok
[INFO] [stdout] test tests::notional_cap_blocks_oversized_orders ... ok
[INFO] [stdout] test tests::rejects_non_positive_qty ... ok
[INFO] [stdout] test tests::rejects_unknown_side ... ok
[INFO] [stdout] test tests::rejects_limit_without_price ... ok
[INFO] [stdout] test tests::permissive_accepts ... ok
[INFO] [stdout] test clock_skew_tracker::tests::new_observations_mutate_snapshot_monotonically_in_sample_count ... ok
[INFO] [stdout] test tests::position_cap_blocks_short_buildup ... ok
[INFO] [stdout] test pnl_guard::tests::drawdown_from_negative_peak_still_works ... ok
[INFO] [stdout] test tests::position_cap_blocks_long_buildup ... ok
[INFO] [stdout] test tests::open_order_cap_enforced ... ok
[INFO] [stdout] test clock_skew_guard::tests::exact_limit_does_not_breach ... ok
[INFO] [stdout] test tests::record_fill_tracks_signed_position ... ok
[INFO] [stdout] test tests::whitelist_excludes_non_members ... ok
[INFO] [stdout] test venue_error_guard::tests::breach_fires_when_count_exceeds_limit ... ok
[INFO] [stdout] test venue_error_guard::tests::breach_fires_at_most_once_until_reset ... ok
[INFO] [stdout] test venue_error_guard::tests::old_errors_outside_window_do_not_count ... ok
[INFO] [stdout] test venue_error_guard::tests::window_sized_boundary_is_exclusive_on_the_old_side ... ok
[INFO] [stdout] test venue_error_guard::tests::permissive_never_breaches ... ok
[INFO] [stdout] test venue_error_guard::tests::zero_limit_trips_on_very_first_error ... ok
[INFO] [stdout] test clock_skew_tracker::tests::large_magnitudes_do_not_overflow_running_stats ... ok
[INFO] [stdout] test clock_skew_guard::tests::within_limit_does_not_breach ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 56 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.12s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ts_runner-5ae9b6738974d7d0)
[INFO] [stdout] 
[INFO] [stdout] running 94 tests
[INFO] [stdout] test audit::tests::fsync_every_defaults_to_zero_and_is_configurable ... ok
[INFO] [stdout] test audit::tests::writer_appends_both_event_kinds_as_ndjson ... ok
[INFO] [stdout] test intent_log::tests::replay_of_missing_file_yields_empty_vec ... ok
[INFO] [stdout] test intent_log::tests::compact_is_noop_on_missing_file ... ok
[INFO] [stdout] test audit::tests::sync_all_pushes_buffered_writes_to_disk ... ok
[INFO] [stdout] test audit::tests::spawned_writer_fsyncs_on_shutdown_even_without_cadence ... ok
[INFO] [stdout] test kill_switch_watch::tests::exits_if_switch_is_already_tripped ... ok
[INFO] [stdout] test intent_log::tests::complete_before_submit_is_a_noop ... ok
[INFO] [stdout] test intent_log::tests::malformed_line_is_skipped_not_fatal ... ok
[INFO] [stdout] test intent_log::tests::completion_after_submit_closes_the_intent ... ok
[INFO] [stdout] test audit::tests::fsync_cadence_partial_batch_is_still_durable_on_shutdown ... ok
[INFO] [stdout] test intent_log::tests::replay_is_deterministically_ordered_by_cid ... ok
[INFO] [stdout] test intent_log::tests::restart_replays_previously_written_entries ... ok
[INFO] [stdout] test audit::tests::spawned_writer_drains_channel_and_closes ... ok
[INFO] [stdout] test intent_log::tests::compact_clobbers_stale_sibling_compact_file ... ok
[INFO] [stdout] test audit::tests::spawned_writer_with_fsync_cadence_records_every_event ... ok
[INFO] [stdout] test live::tests::dropped_event_channel_ends_runner_cleanly ... ok
[INFO] [stdout] test intent_log::tests::compact_preserves_orphan_set_and_shrinks_file ... ok
[INFO] [stdout] test intent_log::tests::submit_without_complete_surfaces_on_replay ... ok
[INFO] [stdout] test intent_log::tests::compact_all_closed_yields_empty_but_valid_log ... ok
[INFO] [stdout] test live::tests::engine_illegal_transition_count_is_mirrored_into_runner_metrics ... ok
[INFO] [stdout] test intent_log::tests::compact_followed_by_append_still_replays_correctly ... ok
[INFO] [stdout] test intent_log::tests::compact_is_idempotent ... ok
[INFO] [stdout] test live::tests::pnl_guard_breach_trips_kill_switch ... ok
[INFO] [stdout] test live::tests::clock_skew_guard_trips_on_event_with_large_skew ... ok
[INFO] [stdout] test kill_switch_watch::tests::trips_when_halt_file_appears ... ok
[INFO] [stdout] test live::tests::pnl_guard_does_not_trip_below_limit ... ok
[INFO] [stdout] test live::tests::reconnect_counter_advance_triggers_resync ... ok
[INFO] [stdout] test live::tests::reconnect_counter_stable_triggers_no_resync ... ok
[INFO] [stdout] test live::tests::stream_illegal_counter_is_published_under_stream_label ... ok
[INFO] [stdout] test live::tests::clock_skew_guard_does_not_trip_on_within_limit_events ... ok
[INFO] [stdout] test live::tests::resync_interval_disabled_by_default ... ok
[INFO] [stdout] test live::tests::clock_skew_tracker_skips_events_with_unset_timestamps ... ok
[INFO] [stdout] test live::tests::clock_skew_tracker_folds_every_event_into_summary ... ok
[INFO] [stdout] test live::tests::resync_interval_ticks_increment_venue_resyncs_counter ... ok
[INFO] [stdout] test live::tests::pre_trade_notional_cap_blocks_oversized_order ... ok
[INFO] [stdout] test live::tests::staleness_guard_does_not_trip_when_feed_stays_alive ... ok
[INFO] [stdout] test live::tests::venue_error_guard_is_noop_without_kill_switch ... ok
[INFO] [stdout] test live::tests::venue_error_guard_trips_kill_switch_on_error_burst ... ok
[INFO] [stdout] test live_cfg::tests::default_targets_testnet ... ok
[INFO] [stdout] test live_cfg::tests::loads_full_base_and_env_overlay ... ok
[INFO] [stdout] test metrics::tests::encoder_emits_required_fields ... ok
[INFO] [stdout] test metrics::tests::histogram_encodes_cumulative_buckets_and_count ... ok
[INFO] [stdout] test metrics::tests::histogram_skips_events_without_timestamps ... ok
[INFO] [stdout] test metrics::tests::illegal_transitions_emits_labeled_series_for_engine_and_stream ... ok
[INFO] [stdout] test metrics::tests::mark_price_omitted_when_unknown ... ok
[INFO] [stdout] test metrics::tests::no_per_symbol_block_emitted_when_no_symbols_observed ... ok
[INFO] [stdout] test metrics::tests::observe_pnl_populates_position_realized_unrealized_and_mark ... ok
[INFO] [stdout] test metrics::tests::observe_pnl_saturates_overflow_and_hides_absent_mark ... ok
[INFO] [stdout] test metrics::tests::observe_pnl_symbol_emits_labeled_gauges ... ok
[INFO] [stdout] test metrics::tests::observe_pnl_symbol_overwrites_on_repeated_observation ... ok
[INFO] [stdout] test metrics::tests::quote_suppressions_render_per_reason_labels ... ok
[INFO] [stdout] test metrics::tests::quotes_posted_counter_reflects_observe_call ... ok
[INFO] [stdout] test metrics::tests::server_404s_unknown_paths ... ok
[INFO] [stdout] test metrics::tests::server_returns_metrics_body ... ok
[INFO] [stdout] test metrics::tests::spot_ws_handles_are_hidden_until_attached ... ok
[INFO] [stdout] test metrics::tests::spot_ws_handles_surface_shared_atomic_values ... ok
[INFO] [stdout] test metrics::tests::trip_sweep_orphan_cancels_counter_tracks_live_summary ... ok
[INFO] [stdout] test metrics::tests::venue_resyncs_counter_tracks_live_summary ... ok
[INFO] [stdout] test paper_cfg::tests::audit_sink_round_trips ... ok
[INFO] [stdout] test paper_cfg::tests::default_is_self_consistent ... ok
[INFO] [stdout] test paper_cfg::tests::loads_full_base_and_env_overlay ... ok
[INFO] [stdout] test paper_cfg::tests::pre_trade_round_trips ... ok
[INFO] [stdout] test paper_cfg::tests::timer_ms_defaults_to_none_and_round_trips ... ok
[INFO] [stdout] test tape::tests::pump_tape_forwards_all_events_then_closes_channel ... ok
[INFO] [stdout] test tape::tests::reader_skips_blank_lines_and_reports_corrupt_ones ... ok
[INFO] [stdout] test tape::tests::writer_reader_roundtrip_preserves_events ... ok
[INFO] [stdout] test tests::audit_tap_detaches_when_receiver_drops ... ok
[INFO] [stdout] test tests::audit_tap_forwards_reports_and_fills ... ok
[INFO] [stdout] test tests::book_error_is_logged_and_swallowed ... ok
[INFO] [stdout] test live::tests::pre_trade_whitelist_rejects_orders_before_reaching_venue ... ok
[INFO] [stdout] test tests::halted_runner_drops_timer_actions ... ok
[INFO] [stdout] test tests::bridge_bus_forwards_events_to_runner ... FAILED
[INFO] [stdout] test tests::kill_switch_trip_triggers_cancel_sweep ... ok
[INFO] [stdout] test tests::periodic_summary_tap_broadcasts_state ... ok
[INFO] [stdout] test tests::metrics_snapshot_tracks_processed_events ... ok
[INFO] [stdout] test tests::shutdown_handle_stops_runner ... ok
[INFO] [stdout] test tests::runs_to_channel_close_and_returns_summary ... ok
[INFO] [stdout] test tests::timer_tick_drives_on_timer_and_reaches_engine ... ok
[INFO] [stdout] test tests::trip_sweep_runs_once_per_halted_epoch ... ok
[INFO] [stdout] test live::tests::halted_live_runner_skips_timer_ticks ... ok
[INFO] [stdout] test live::tests::halted_runner_skips_strategy_tick ... ok
[INFO] [stdout] test live::tests::venue_error_counter_advances_trip_kill_switch_via_guard ... ok
[INFO] [stdout] test live::tests::venue_error_counter_startup_value_is_snapshotted_not_replayed ... ok
[INFO] [stdout] test live::tests::staleness_guard_trips_kill_switch_on_silent_feed ... ok
[INFO] [stdout] test live::tests::trade_payload_reaches_strategy_on_trade_and_actions_dispatch ... ok
[INFO] [stdout] test live::tests::user_stream_push_reaches_strategy_via_reconcile ... ok
[INFO] [stdout] test live::tests::book_update_produces_submit_calls_and_counters_track_them ... ok
[INFO] [stdout] test live::tests::timer_tick_invokes_on_timer_and_dispatches_actions ... ok
[INFO] [stdout] test live::tests::intent_log_preserves_open_submits_before_terminal_status ... ok
[INFO] [stdout] test live::tests::intent_log_records_submit_then_complete_on_terminal_report ... ok
[INFO] [stdout] test live::tests::kill_switch_trip_cancels_open_quotes_via_reconcile_sweep ... ok
[INFO] [stdout] test live::tests::trip_sweep_cancels_engine_tracked_cids_the_strategy_forgot ... ok
[INFO] [stdout] test live::tests::trip_sweep_fires_once_per_halted_epoch ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- tests::bridge_bus_forwards_events_to_runner stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'tests::bridge_bus_forwards_events_to_runner' (5313) panicked at crates/runner/src/lib.rs:630:9:
[INFO] [stdout] assertion failed: summary.metrics.events_ingested >= 2
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5f74aaf00ea8 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5f74aaf00ea8 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::trace_unsynchronized::<std[10d71ac2c42b111e]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5f74aaf00ea8 - std[10d71ac2c42b111e]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5f74aaf00ea8 - <<std[10d71ac2c42b111e]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[8fb95b77d25ab6c8]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5f74aaf1848a - <core[8fb95b77d25ab6c8]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5f74aaf1848a - core[8fb95b77d25ab6c8]::fmt::write
[INFO] [stdout]    6:     0x5f74aaf05ef2 - std[10d71ac2c42b111e]::io::default_write_fmt::<alloc[a7ee25936407c584]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:622:11
[INFO] [stdout]    7:     0x5f74aaf05ef2 - <alloc[a7ee25936407c584]::vec::Vec<u8> as std[10d71ac2c42b111e]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:1977:13
[INFO] [stdout]    8:     0x5f74aaedd186 - <std[10d71ac2c42b111e]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5f74aaedd186 - std[10d71ac2c42b111e]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5f74aaef7f79 - std[10d71ac2c42b111e]::panicking::default_hook
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5f74aacf98cc - <alloc[a7ee25936407c584]::boxed::Box<dyn for<'a, 'b> core[8fb95b77d25ab6c8]::ops::function::Fn<(&'a std[10d71ac2c42b111e]::panic::PanicHookInfo<'b>,), Output = ()> + core[8fb95b77d25ab6c8]::marker::Sync + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::Fn<(&std[10d71ac2c42b111e]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2289:9
[INFO] [stdout]   12:     0x5f74aacf98cc - test[213991da798b1c03]::test_main_inner::<test[213991da798b1c03]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5f74aaef81f2 - <alloc[a7ee25936407c584]::boxed::Box<dyn for<'a, 'b> core[8fb95b77d25ab6c8]::ops::function::Fn<(&'a std[10d71ac2c42b111e]::panic::PanicHookInfo<'b>,), Output = ()> + core[8fb95b77d25ab6c8]::marker::Sync + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::Fn<(&std[10d71ac2c42b111e]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2289:9
[INFO] [stdout]   14:     0x5f74aaef81f2 - std[10d71ac2c42b111e]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5f74aaedd274 - std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:691:13
[INFO] [stdout]   16:     0x5f74aaed2139 - std[10d71ac2c42b111e]::sys::backtrace::__rust_end_short_backtrace::<std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5f74aaede1dd - __rustc[3be9ba60078d4c86]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5f74aaf18c4c - core[8fb95b77d25ab6c8]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5f74aaf18c12 - core[8fb95b77d25ab6c8]::panicking::panic
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panicking.rs:150:5
[INFO] [stdout]   20:     0x5f74aab8eb92 - ts_runner[1319c780509aefaa]::tests::bridge_bus_forwards_events_to_runner::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/crates/runner/src/lib.rs:630:9
[INFO] [stdout]   21:     0x5f74aabfa2e2 - <core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>> as core[8fb95b77d25ab6c8]::future::future::Future>::poll
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/future/future.rs:133:9
[INFO] [stdout]   22:     0x5f74aabfa35d - <core[8fb95b77d25ab6c8]::pin::Pin<&mut core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>> as core[8fb95b77d25ab6c8]::future::future::Future>::poll
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/future/future.rs:133:9
[INFO] [stdout]   23:     0x5f74aac9845d - <tokio[1c9080080a784219]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[8fb95b77d25ab6c8]::pin::Pin<&mut core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::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.52.0/src/runtime/scheduler/current_thread/mod.rs:778:70
[INFO] [stdout]   24:     0x5f74aac9831b - tokio[1c9080080a784219]::task::coop::with_budget::<core[8fb95b77d25ab6c8]::task::poll::Poll<()>, <tokio[1c9080080a784219]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[8fb95b77d25ab6c8]::pin::Pin<&mut core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::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.52.0/src/task/coop/mod.rs:167:5
[INFO] [stdout]   25:     0x5f74aac9831b - tokio[1c9080080a784219]::task::coop::budget::<core[8fb95b77d25ab6c8]::task::poll::Poll<()>, <tokio[1c9080080a784219]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[8fb95b77d25ab6c8]::pin::Pin<&mut core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::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.52.0/src/task/coop/mod.rs:133:5
[INFO] [stdout]   26:     0x5f74aac9831b - <tokio[1c9080080a784219]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[8fb95b77d25ab6c8]::pin::Pin<&mut core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.0/src/runtime/scheduler/current_thread/mod.rs:778:25
[INFO] [stdout]   27:     0x5f74aac7b520 - <tokio[1c9080080a784219]::runtime::scheduler::current_thread::Context>::enter::<core[8fb95b77d25ab6c8]::task::poll::Poll<()>, <tokio[1c9080080a784219]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[8fb95b77d25ab6c8]::pin::Pin<&mut core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.0/src/runtime/scheduler/current_thread/mod.rs:451:19
[INFO] [stdout]   28:     0x5f74aac964dd - <tokio[1c9080080a784219]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[8fb95b77d25ab6c8]::pin::Pin<&mut core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.0/src/runtime/scheduler/current_thread/mod.rs:777:44
[INFO] [stdout]   29:     0x5f74aac95784 - <tokio[1c9080080a784219]::runtime::scheduler::current_thread::CoreGuard>::enter::<<tokio[1c9080080a784219]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[8fb95b77d25ab6c8]::pin::Pin<&mut core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>>::{closure#0}, core[8fb95b77d25ab6c8]::option::Option<()>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.0/src/runtime/scheduler/current_thread/mod.rs:865:68
[INFO] [stdout]   30:     0x5f74aac7ae7b - <tokio[1c9080080a784219]::runtime::context::scoped::Scoped<tokio[1c9080080a784219]::runtime::scheduler::Context>>::set::<<tokio[1c9080080a784219]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[1c9080080a784219]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[8fb95b77d25ab6c8]::pin::Pin<&mut core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>>::{closure#0}, core[8fb95b77d25ab6c8]::option::Option<()>>::{closure#0}, (alloc[a7ee25936407c584]::boxed::Box<tokio[1c9080080a784219]::runtime::scheduler::current_thread::Core>, core[8fb95b77d25ab6c8]::option::Option<()>)>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.0/src/runtime/context/scoped.rs:40:9
[INFO] [stdout]   31:     0x5f74aab51ba9 - tokio[1c9080080a784219]::runtime::context::set_scheduler::<(alloc[a7ee25936407c584]::boxed::Box<tokio[1c9080080a784219]::runtime::scheduler::current_thread::Core>, core[8fb95b77d25ab6c8]::option::Option<()>), <tokio[1c9080080a784219]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[1c9080080a784219]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[8fb95b77d25ab6c8]::pin::Pin<&mut core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>>::{closure#0}, core[8fb95b77d25ab6c8]::option::Option<()>>::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.0/src/runtime/context.rs:181:38
[INFO] [stdout]   32:     0x5f74aacc4502 - <std[10d71ac2c42b111e]::thread::local::LocalKey<tokio[1c9080080a784219]::runtime::context::Context>>::try_with::<tokio[1c9080080a784219]::runtime::context::set_scheduler<(alloc[a7ee25936407c584]::boxed::Box<tokio[1c9080080a784219]::runtime::scheduler::current_thread::Core>, core[8fb95b77d25ab6c8]::option::Option<()>), <tokio[1c9080080a784219]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[1c9080080a784219]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[8fb95b77d25ab6c8]::pin::Pin<&mut core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>>::{closure#0}, core[8fb95b77d25ab6c8]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[a7ee25936407c584]::boxed::Box<tokio[1c9080080a784219]::runtime::scheduler::current_thread::Core>, core[8fb95b77d25ab6c8]::option::Option<()>)>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/local.rs:462:12
[INFO] [stdout]   33:     0x5f74aacc408e - <std[10d71ac2c42b111e]::thread::local::LocalKey<tokio[1c9080080a784219]::runtime::context::Context>>::with::<tokio[1c9080080a784219]::runtime::context::set_scheduler<(alloc[a7ee25936407c584]::boxed::Box<tokio[1c9080080a784219]::runtime::scheduler::current_thread::Core>, core[8fb95b77d25ab6c8]::option::Option<()>), <tokio[1c9080080a784219]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[1c9080080a784219]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[8fb95b77d25ab6c8]::pin::Pin<&mut core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>>::{closure#0}, core[8fb95b77d25ab6c8]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[a7ee25936407c584]::boxed::Box<tokio[1c9080080a784219]::runtime::scheduler::current_thread::Core>, core[8fb95b77d25ab6c8]::option::Option<()>)>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/local.rs:426:20
[INFO] [stdout]   34:     0x5f74aab4fc3d - tokio[1c9080080a784219]::runtime::context::set_scheduler::<(alloc[a7ee25936407c584]::boxed::Box<tokio[1c9080080a784219]::runtime::scheduler::current_thread::Core>, core[8fb95b77d25ab6c8]::option::Option<()>), <tokio[1c9080080a784219]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[1c9080080a784219]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[8fb95b77d25ab6c8]::pin::Pin<&mut core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>>::{closure#0}, core[8fb95b77d25ab6c8]::option::Option<()>>::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.0/src/runtime/context.rs:181:17
[INFO] [stdout]   35:     0x5f74aac81580 - <tokio[1c9080080a784219]::runtime::scheduler::current_thread::CoreGuard>::enter::<<tokio[1c9080080a784219]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[8fb95b77d25ab6c8]::pin::Pin<&mut core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>>::{closure#0}, core[8fb95b77d25ab6c8]::option::Option<()>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.0/src/runtime/scheduler/current_thread/mod.rs:865:27
[INFO] [stdout]   36:     0x5f74aac81876 - <tokio[1c9080080a784219]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[8fb95b77d25ab6c8]::pin::Pin<&mut core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.0/src/runtime/scheduler/current_thread/mod.rs:765:24
[INFO] [stdout]   37:     0x5f74aac95230 - <tokio[1c9080080a784219]::runtime::scheduler::current_thread::CurrentThread>::block_on::<core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.0/src/runtime/scheduler/current_thread/mod.rs:205:33
[INFO] [stdout]   38:     0x5f74aab50263 - tokio[1c9080080a784219]::runtime::context::runtime::enter_runtime::<<tokio[1c9080080a784219]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.0/src/runtime/context/runtime.rs:65:16
[INFO] [stdout]   39:     0x5f74aac7b051 - <tokio[1c9080080a784219]::runtime::scheduler::current_thread::CurrentThread>::block_on::<core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.0/src/runtime/scheduler/current_thread/mod.rs:193:9
[INFO] [stdout]   40:     0x5f74aac9dfa4 - <tokio[1c9080080a784219]::runtime::runtime::Runtime>::block_on_inner::<core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.0/src/runtime/runtime.rs:371:52
[INFO] [stdout]   41:     0x5f74aac9e16f - <tokio[1c9080080a784219]::runtime::runtime::Runtime>::block_on::<core[8fb95b77d25ab6c8]::pin::Pin<&mut dyn core[8fb95b77d25ab6c8]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.52.0/src/runtime/runtime.rs:345:18
[INFO] [stdout]   42:     0x5f74aaba3dcf - ts_runner[1319c780509aefaa]::tests::bridge_bus_forwards_events_to_runner
[INFO] [stdout]                                at /opt/rustwide/workdir/crates/runner/src/lib.rs:630:54
[INFO] [stdout]   43:     0x5f74aab8a9a7 - ts_runner[1319c780509aefaa]::tests::bridge_bus_forwards_events_to_runner::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/crates/runner/src/lib.rs:602:52
[INFO] [stdout]   44:     0x5f74aab12686 - <ts_runner[1319c780509aefaa]::tests::bridge_bus_forwards_events_to_runner::{closure#0} as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   45:     0x5f74aacec9ab - <fn() -> core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   46:     0x5f74aacec9ab - test[213991da798b1c03]::__rust_begin_short_backtrace::<core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>, fn() -> core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:724:18
[INFO] [stdout]   47:     0x5f74aacfa225 - test[213991da798b1c03]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:747:74
[INFO] [stdout]   48:     0x5f74aacfa225 - <core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   49:     0x5f74aacfa225 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>, core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   50:     0x5f74aacfa225 - std[10d71ac2c42b111e]::panicking::catch_unwind::<core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>, core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   51:     0x5f74aacfa225 - std[10d71ac2c42b111e]::panic::catch_unwind::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>, core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14
[INFO] [stdout]   52:     0x5f74aacfa225 - test[213991da798b1c03]::run_test_in_process
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:747:27
[INFO] [stdout]   53:     0x5f74aacfa225 - test[213991da798b1c03]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:668:43
[INFO] [stdout]   54:     0x5f74aacf3b34 - test[213991da798b1c03]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:698:41
[INFO] [stdout]   55:     0x5f74aacf3b34 - std[10d71ac2c42b111e]::sys::backtrace::__rust_begin_short_backtrace::<test[213991da798b1c03]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   56:     0x5f74aacfd2a2 - std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked::<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   57:     0x5f74aacfd2a2 - <core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   58:     0x5f74aacfd2a2 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   59:     0x5f74aacfd2a2 - std[10d71ac2c42b111e]::panicking::catch_unwind::<(), core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   60:     0x5f74aacfd2a2 - std[10d71ac2c42b111e]::panic::catch_unwind::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14
[INFO] [stdout]   61:     0x5f74aacfd2a2 - std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked::<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   62:     0x5f74aacfd2a2 - <std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1} as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   63:     0x5f74aaeffe1f - <alloc[a7ee25936407c584]::boxed::Box<dyn core[8fb95b77d25ab6c8]::ops::function::FnOnce<(), Output = ()> + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2275:9
[INFO] [stdout]   64:     0x5f74aaeffe1f - <std[10d71ac2c42b111e]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   65:     0x711dc4f73aa4 - <unknown>
[INFO] [stdout]   66:     0x711dc5000a64 - clone
[INFO] [stdout]   67:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     tests::bridge_bus_forwards_events_to_runner
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 93 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.18s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `-p ts-runner --lib`
[INFO] running `Command { std: "docker" "inspect" "dad0703a0f00af32577ec8ab0de238da83f3345b4d53d182792591b8cce16297", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dad0703a0f00af32577ec8ab0de238da83f3345b4d53d182792591b8cce16297", kill_on_drop: false }`
[INFO] [stdout] dad0703a0f00af32577ec8ab0de238da83f3345b4d53d182792591b8cce16297
