[INFO] fetching crate seesaw_core 0.26.3...
[INFO] testing seesaw_core-0.26.3 against 1.95.0 for beta-1.96-2
[INFO] extracting crate seesaw_core 0.26.3 into /workspace/builds/worker-4-tc1/source
[INFO] started tweaking crates.io crate seesaw_core 0.26.3
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate seesaw_core 0.26.3
[INFO] tweaked toml for crates.io crate seesaw_core 0.26.3 written to /workspace/builds/worker-4-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate seesaw_core 0.26.3 on toolchain 1.95.0
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.95.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate seesaw_core 0.26.3 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.95.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded wasm-bindgen-macro v0.2.114
[INFO] [stderr]   Downloaded sha1_smol v1.0.1
[INFO] [stderr]   Downloaded heck v0.5.0
[INFO] [stderr]   Downloaded windows-interface v0.59.3
[INFO] [stderr]   Downloaded iana-time-zone-haiku v0.1.2
[INFO] [stderr]   Downloaded windows-link v0.2.1
[INFO] [stderr]   Downloaded target-triple v1.0.0
[INFO] [stderr]   Downloaded serde_spanned v1.0.4
[INFO] [stderr]   Downloaded futures-sink v0.3.32
[INFO] [stderr]   Downloaded windows-strings v0.5.1
[INFO] [stderr]   Downloaded lock_api v0.4.14
[INFO] [stderr]   Downloaded android_system_properties v0.1.5
[INFO] [stderr]   Downloaded windows-result v0.4.1
[INFO] [stderr]   Downloaded windows-core v0.62.2
[INFO] [stderr]   Downloaded prettyplease v0.2.37
[INFO] [stderr]   Downloaded futures-util v0.3.32
[INFO] [stderr]   Downloaded winnow v0.7.15
[INFO] [stderr]   Downloaded wasmparser v0.244.0
[INFO] [stderr]   Downloaded hashbrown v0.15.5
[INFO] [stderr]   Downloaded chrono v0.4.44
[INFO] [stderr]   Downloaded tracing v0.1.44
[INFO] [stderr]   Downloaded r-efi v6.0.0
[INFO] [stderr]   Downloaded cc v1.2.56
[INFO] [stderr]   Downloaded hashbrown v0.14.5
[INFO] [stderr]   Downloaded tokio v1.50.0
[INFO] [stderr]   Downloaded libc v0.2.183
[INFO] [stderr]   Downloaded wasip2 v1.0.2+wasi-0.2.9
[INFO] [stderr]   Downloaded serde_json v1.0.149
[INFO] [stderr]   Downloaded unicode-xid v0.2.6
[INFO] [stderr]   Downloaded async-trait v0.1.89
[INFO] [stderr]   Downloaded log v0.4.29
[INFO] [stderr]   Downloaded fastrand v2.3.0
[INFO] [stderr]   Downloaded futures-core v0.3.32
[INFO] [stderr]   Downloaded wit-parser v0.244.0
[INFO] [stderr]   Downloaded wasip3 v0.4.0+wasi-0.3.0-rc-2026-01-06
[INFO] [stderr]   Downloaded equivalent v1.0.2
[INFO] [stderr]   Downloaded serde v1.0.228
[INFO] [stderr]   Downloaded indexmap v2.13.0
[INFO] [stderr]   Downloaded futures-channel v0.3.32
[INFO] [stderr]   Downloaded futures-task v0.3.32
[INFO] [stderr]   Downloaded wasm-bindgen-shared v0.2.114
[INFO] [stderr]   Downloaded windows-sys v0.61.2
[INFO] [stderr]   Downloaded wasm-encoder v0.244.0
[INFO] [stderr]   Downloaded getrandom v0.4.2
[INFO] [stderr]   Downloaded js-sys v0.3.91
[INFO] [stderr]   Downloaded wit-component v0.244.0
[INFO] [stderr]   Downloaded memchr v2.8.0
[INFO] [stderr]   Downloaded iana-time-zone v0.1.65
[INFO] [stderr]   Downloaded num-traits v0.2.19
[INFO] [stderr]   Downloaded futures-executor v0.3.32
[INFO] [stderr]   Downloaded parking_lot_core v0.9.12
[INFO] [stderr]   Downloaded parking_lot v0.12.5
[INFO] [stderr]   Downloaded tracing-core v0.1.36
[INFO] [stderr]   Downloaded toml_parser v1.0.9+spec-1.1.0
[INFO] [stderr]   Downloaded wit-bindgen-core v0.51.0
[INFO] [stderr]   Downloaded wasm-metadata v0.244.0
[INFO] [stderr]   Downloaded anyhow v1.0.102
[INFO] [stderr]   Downloaded zmij v1.0.21
[INFO] [stderr]   Downloaded foldhash v0.1.5
[INFO] [stderr]   Downloaded semver v1.0.27
[INFO] [stderr]   Downloaded wit-bindgen-rust v0.51.0
[INFO] [stderr]   Downloaded wit-bindgen v0.51.0
[INFO] [stderr]   Downloaded wasm-bindgen-macro-support v0.2.114
[INFO] [stderr]   Downloaded wasm-bindgen v0.2.114
[INFO] [stderr]   Downloaded core-foundation-sys v0.8.7
[INFO] [stderr]   Downloaded autocfg v1.5.0
[INFO] [stderr]   Downloaded crossbeam-utils v0.8.21
[INFO] [stderr]   Downloaded dashmap v6.1.0
[INFO] [stderr]   Downloaded futures-macro v0.3.32
[INFO] [stderr]   Downloaded futures v0.3.32
[INFO] [stderr]   Downloaded tokio-macros v2.6.1
[INFO] [stderr]   Downloaded tracing-attributes v0.1.31
[INFO] [stderr]   Downloaded glob v0.3.3
[INFO] [stderr]   Downloaded toml v1.0.6+spec-1.1.0
[INFO] [stderr]   Downloaded trybuild v1.0.116
[INFO] [stderr]   Downloaded pin-project-lite v0.2.17
[INFO] [stderr]   Downloaded toml_writer v1.0.6+spec-1.1.0
[INFO] [stderr]   Downloaded itoa v1.0.17
[INFO] [stderr]   Downloaded slab v0.4.12
[INFO] [stderr]   Downloaded leb128fmt v0.1.0
[INFO] [stderr]   Downloaded once_cell v1.21.3
[INFO] [stderr]   Downloaded scopeguard v1.2.0
[INFO] [stderr]   Downloaded redox_syscall v0.5.18
[INFO] [stderr]   Downloaded seesaw_core_macros v0.26.3
[INFO] [stderr]   Downloaded termcolor v1.4.1
[INFO] [stderr]   Downloaded toml_datetime v1.0.0+spec-1.1.0
[INFO] [stderr]   Downloaded id-arena v2.3.0
[INFO] [stderr]   Downloaded wit-bindgen-rust-macro v0.51.0
[INFO] [stderr]   Downloaded uuid v1.22.0
[INFO] [stderr]   Downloaded serde_derive v1.0.228
[INFO] [stderr]   Downloaded serde_core v1.0.228
[INFO] [stderr]   Downloaded windows-implement v0.60.2
[INFO] [stderr]   Downloaded futures-io v0.3.32
[INFO] [stderr]   Downloaded winapi-util v0.1.11
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] ff6680009b1cb72d3c7fa0b2f62ec32fd3d2e1919fc673115b5893134c7ecdc1
[INFO] running `Command { std: "docker" "start" "-a" "ff6680009b1cb72d3c7fa0b2f62ec32fd3d2e1919fc673115b5893134c7ecdc1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "ff6680009b1cb72d3c7fa0b2f62ec32fd3d2e1919fc673115b5893134c7ecdc1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ff6680009b1cb72d3c7fa0b2f62ec32fd3d2e1919fc673115b5893134c7ecdc1", kill_on_drop: false }`
[INFO] [stdout] ff6680009b1cb72d3c7fa0b2f62ec32fd3d2e1919fc673115b5893134c7ecdc1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d964efe63542788f694dd1877ee71f2b2116fa7dcbcf8a6f1b3042454c9a75d5
[INFO] running `Command { std: "docker" "start" "-a" "d964efe63542788f694dd1877ee71f2b2116fa7dcbcf8a6f1b3042454c9a75d5", 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.183
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling pin-project-lite v0.2.17
[INFO] [stderr]    Compiling cfg-if v1.0.4
[INFO] [stderr]    Compiling memchr v2.8.0
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling futures-core v0.3.32
[INFO] [stderr]    Compiling autocfg v1.5.0
[INFO] [stderr]    Compiling futures-sink v0.3.32
[INFO] [stderr]    Compiling crossbeam-utils v0.8.21
[INFO] [stderr]    Compiling scopeguard v1.2.0
[INFO] [stderr]    Compiling zmij v1.0.21
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling futures-task v0.3.32
[INFO] [stderr]    Compiling futures-io v0.3.32
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]    Compiling futures-channel v0.3.32
[INFO] [stderr]    Compiling slab v0.4.12
[INFO] [stderr]    Compiling lock_api v0.4.14
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling anyhow v1.0.102
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling tracing-core v0.1.36
[INFO] [stderr]    Compiling sha1_smol v1.0.1
[INFO] [stderr]    Compiling itoa v1.0.17
[INFO] [stderr]    Compiling hashbrown v0.14.5
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling iana-time-zone v0.1.65
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling dashmap v6.1.0
[INFO] [stderr]    Compiling uuid v1.22.0
[INFO] [stderr]    Compiling futures-macro v0.3.32
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling tokio-macros v2.6.1
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling seesaw_core_macros v0.26.3
[INFO] [stderr]    Compiling async-trait v0.1.89
[INFO] [stderr]    Compiling tokio v1.50.0
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling futures-executor v0.3.32
[INFO] [stderr]    Compiling futures v0.3.32
[INFO] [stderr]    Compiling seesaw_core v0.26.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 15.36s
[INFO] running `Command { std: "docker" "inspect" "d964efe63542788f694dd1877ee71f2b2116fa7dcbcf8a6f1b3042454c9a75d5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d964efe63542788f694dd1877ee71f2b2116fa7dcbcf8a6f1b3042454c9a75d5", kill_on_drop: false }`
[INFO] [stdout] d964efe63542788f694dd1877ee71f2b2116fa7dcbcf8a6f1b3042454c9a75d5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 7f4b13b114f8745832e958977957719f14054890299677186a65129b47dc6e2e
[INFO] running `Command { std: "docker" "start" "-a" "7f4b13b114f8745832e958977957719f14054890299677186a65129b47dc6e2e", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling winnow v0.7.15
[INFO] [stderr]    Compiling target-triple v1.0.0
[INFO] [stderr]    Compiling toml_writer v1.0.6+spec-1.1.0
[INFO] [stderr]    Compiling glob v0.3.3
[INFO] [stderr]    Compiling termcolor v1.4.1
[INFO] [stderr]    Compiling fastrand v2.3.0
[INFO] [stderr]    Compiling tokio v1.50.0
[INFO] [stderr]    Compiling toml_parser v1.0.9+spec-1.1.0
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling serde_spanned v1.0.4
[INFO] [stderr]    Compiling toml_datetime v1.0.0+spec-1.1.0
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling uuid v1.22.0
[INFO] [stderr]    Compiling toml v1.0.6+spec-1.1.0
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling trybuild v1.0.116
[INFO] [stderr]    Compiling seesaw_core v0.26.3 (/opt/rustwide/workdir)
[INFO] [stdout] warning: struct `EnrichmentResult` is never constructed
[INFO] [stdout]    --> tests/macro_api.rs:531:8
[INFO] [stdout]     |
[INFO] [stdout] 531 | struct EnrichmentResult {
[INFO] [stdout]     |        ^^^^^^^^^^^^^^^^
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `handle`
[INFO] [stdout]     --> tests/engine_integration.rs:2383:9
[INFO] [stdout]      |
[INFO] [stdout] 2383 |     let handle = engine
[INFO] [stdout]      |         ^^^^^^ help: if this is intentional, prefix it with an underscore: `_handle`
[INFO] [stdout]      |
[INFO] [stdout]      = note: `#[warn(unused_variables)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `handle`
[INFO] [stdout]     --> tests/engine_integration.rs:2430:9
[INFO] [stdout]      |
[INFO] [stdout] 2430 |     let handle = engine
[INFO] [stdout]      |         ^^^^^^ help: if this is intentional, prefix it with an underscore: `_handle`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: field `transient` is never read
[INFO] [stdout]     --> tests/engine_integration.rs:3358:9
[INFO] [stdout]      |
[INFO] [stdout] 3355 |     struct FailSkip {
[INFO] [stdout]      |            -------- field in this struct
[INFO] [stdout] ...
[INFO] [stdout] 3358 |         transient: String,
[INFO] [stdout]      |         ^^^^^^^^^
[INFO] [stdout]      |
[INFO] [stdout]      = note: `FailSkip` has derived impls for the traits `Clone` and `Debug`, but these are intentionally ignored during dead code analysis
[INFO] [stdout]      = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: field `secret_data` is never read
[INFO] [stdout]     --> tests/engine_integration.rs:3415:9
[INFO] [stdout]      |
[INFO] [stdout] 3411 |     struct ExtractEvent {
[INFO] [stdout]      |            ------------ field in this struct
[INFO] [stdout] ...
[INFO] [stdout] 3415 |         secret_data: Vec<u8>,
[INFO] [stdout]      |         ^^^^^^^^^^^
[INFO] [stdout]      |
[INFO] [stdout]      = note: `ExtractEvent` has derived impls for the traits `Clone` and `Debug`, but these are intentionally ignored during dead code analysis
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `ExpansionTriggered` is never constructed
[INFO] [stdout]     --> tests/engine_integration.rs:3613:8
[INFO] [stdout]      |
[INFO] [stdout] 3613 | struct ExpansionTriggered;
[INFO] [stdout]      |        ^^^^^^^^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: struct `Enriched` is never constructed
[INFO] [stdout]     --> tests/engine_integration.rs:3735:8
[INFO] [stdout]      |
[INFO] [stdout] 3735 | struct Enriched {
[INFO] [stdout]      |        ^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 22.72s
[INFO] running `Command { std: "docker" "inspect" "7f4b13b114f8745832e958977957719f14054890299677186a65129b47dc6e2e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7f4b13b114f8745832e958977957719f14054890299677186a65129b47dc6e2e", kill_on_drop: false }`
[INFO] [stdout] 7f4b13b114f8745832e958977957719f14054890299677186a65129b47dc6e2e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] a53c9bbcf9279ad822417314a14c5fc7650a8a459403c9d70ebe3087f783bca3
[INFO] running `Command { std: "docker" "start" "-a" "a53c9bbcf9279ad822417314a14c5fc7650a8a459403c9d70ebe3087f783bca3", kill_on_drop: false }`
[INFO] [stderr] warning: struct `EnrichmentResult` is never constructed
[INFO] [stderr]    --> tests/macro_api.rs:531:8
[INFO] [stderr]     |
[INFO] [stderr] 531 | struct EnrichmentResult {
[INFO] [stderr]     |        ^^^^^^^^^^^^^^^^
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: unused variable: `handle`
[INFO] [stderr]     --> tests/engine_integration.rs:2383:9
[INFO] [stderr]      |
[INFO] [stderr] 2383 |     let handle = engine
[INFO] [stderr]      |         ^^^^^^ help: if this is intentional, prefix it with an underscore: `_handle`
[INFO] [stderr]      |
[INFO] [stderr]      = note: `#[warn(unused_variables)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: unused variable: `handle`
[INFO] [stderr]     --> tests/engine_integration.rs:2430:9
[INFO] [stderr]      |
[INFO] [stderr] 2430 |     let handle = engine
[INFO] [stderr]      |         ^^^^^^ help: if this is intentional, prefix it with an underscore: `_handle`
[INFO] [stderr] 
[INFO] [stderr] warning: field `transient` is never read
[INFO] [stderr]     --> tests/engine_integration.rs:3358:9
[INFO] [stderr]      |
[INFO] [stderr] 3355 |     struct FailSkip {
[INFO] [stderr]      |            -------- field in this struct
[INFO] [stderr] ...
[INFO] [stderr] 3358 |         transient: String,
[INFO] [stderr]      |         ^^^^^^^^^
[INFO] [stderr]      |
[INFO] [stderr]      = note: `FailSkip` has derived impls for the traits `Clone` and `Debug`, but these are intentionally ignored during dead code analysis
[INFO] [stderr]      = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: field `secret_data` is never read
[INFO] [stderr]     --> tests/engine_integration.rs:3415:9
[INFO] [stderr]      |
[INFO] [stderr] 3411 |     struct ExtractEvent {
[INFO] [stderr]      |            ------------ field in this struct
[INFO] [stderr] ...
[INFO] [stderr] 3415 |         secret_data: Vec<u8>,
[INFO] [stderr]      |         ^^^^^^^^^^^
[INFO] [stderr]      |
[INFO] [stderr]      = note: `ExtractEvent` has derived impls for the traits `Clone` and `Debug`, but these are intentionally ignored during dead code analysis
[INFO] [stderr] 
[INFO] [stderr] warning: struct `ExpansionTriggered` is never constructed
[INFO] [stderr]     --> tests/engine_integration.rs:3613:8
[INFO] [stderr]      |
[INFO] [stderr] 3613 | struct ExpansionTriggered;
[INFO] [stderr]      |        ^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: struct `Enriched` is never constructed
[INFO] [stderr]     --> tests/engine_integration.rs:3735:8
[INFO] [stderr]      |
[INFO] [stderr] 3735 | struct Enriched {
[INFO] [stderr]      |        ^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `seesaw_core` (test "macro_api") generated 1 warning
[INFO] [stderr] warning: `seesaw_core` (test "engine_integration") generated 6 warnings (run `cargo fix --test "engine_integration" -p seesaw_core` to apply 2 suggestions)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.15s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/seesaw_core-70d1acc2591fa6fc)
[INFO] [stdout] 
[INFO] [stdout] running 63 tests
[INFO] [stdout] test event_store::tests::append_and_load_aggregate_events ... ok
[INFO] [stdout] test event_store::tests::empty_metadata_round_trips ... ok
[INFO] [stdout] test event_store::tests::empty_stream_returns_empty ... ok
[INFO] [stdout] test event_store::tests::load_global_from_empty_when_caught_up ... ok
[INFO] [stdout] test event_store::tests::causal_metadata_round_trips ... ok
[INFO] [stdout] test event_store::tests::load_global_from_respects_limit ... ok
[INFO] [stdout] test event_store::tests::load_global_from_returns_events_after_position ... ok
[INFO] [stdout] test event_store::tests::event_type_short_name_extracts_last_segment ... ok
[INFO] [stdout] test event_store::tests::streams_are_isolated ... ok
[INFO] [stdout] test handler::context::tests::journal_clear_on_resolve_complete ... ok
[INFO] [stdout] test handler::context::tests::journal_cloned_context_shares_sequence_counter ... ok
[INFO] [stdout] test handler::context::tests::journal_crash_retry_simulation ... ok
[INFO] [stdout] test handler::context::tests::ctx_run_unit_return ... ok
[INFO] [stdout] test handler::context::tests::journal_error_not_journaled_allows_retry ... ok
[INFO] [stdout] test event_store::tests::non_aggregate_event_is_persisted ... ok
[INFO] [stdout] test event_store::tests::load_stream_from_filters_by_version ... ok
[INFO] [stdout] test handler::context::tests::journal_error_midway_preserves_prior_entries ... ok
[INFO] [stdout] test handler::builders::tests::filter_does_not_force_queued_execution ... ok
[INFO] [stdout] test event_store::tests::position_increments_globally ... ok
[INFO] [stdout] test handler::context::tests::journal_error_then_retry_replays_and_continues ... ok
[INFO] [stdout] test handler::context::tests::ctx_run_executes_closure_and_returns_result ... ok
[INFO] [stdout] test handler::context::tests::ctx_run_multiple_calls_return_independent_results ... ok
[INFO] [stdout] test event_store::tests::metadata_round_trips ... ok
[INFO] [stdout] test handler::context::tests::journal_isolation_by_event_id ... ok
[INFO] [stdout] test handler::context::tests::ctx_run_propagates_errors ... ok
[INFO] [stdout] test handler::context::tests::journal_isolation_by_handler_id ... ok
[INFO] [stdout] test handler::context::tests::journal_preserved_on_retry_resolution ... ok
[INFO] [stdout] test handler::context::tests::journal_replay_many_then_continue ... ok
[INFO] [stdout] test handler::context::tests::journal_replays_multiple_entries_in_sequence ... ok
[INFO] [stdout] test handler::context::tests::journal_many_sequential_runs ... ok
[INFO] [stdout] test handler::context::tests::journal_replay_with_option_none ... ok
[INFO] [stdout] test handler::context::tests::journal_persists_new_entries_to_store ... ok
[INFO] [stdout] test handler::context::tests::journal_replay_empty_vec ... ok
[INFO] [stdout] test handler::context::tests::journal_replay_unit_type ... ok
[INFO] [stdout] test handler::context::tests::journal_replay_with_complex_struct ... ok
[INFO] [stdout] test handler::context::tests::journal_replays_then_executes_fresh_after_journal_exhausted ... ok
[INFO] [stdout] test handler::context::tests::journal_seq_counter_advances_even_on_error ... ok
[INFO] [stdout] test handler::context::tests::journal_replay_with_gap_in_seq_from_prior_error ... ok
[INFO] [stdout] test handler::context::tests::journal_replay_with_option_some ... ok
[INFO] [stdout] test handler::context::tests::journal_replays_single_entry_without_executing ... ok
[INFO] [stdout] test handler::context::tests::journal_type_mismatch_on_replay_returns_error ... ok
[INFO] [stdout] test handler::error_event::tests::test_clone ... ok
[INFO] [stdout] test handler::error_event::tests::test_debug_formatting ... ok
[INFO] [stdout] test handler::error_event::tests::test_downcast_success ... ok
[INFO] [stdout] test handler::types::tests::test_any_event_downcast ... ok
[INFO] [stdout] test handler_registry::tests::test_handler_can_handle ... ok
[INFO] [stdout] test handler_registry::tests::test_handler_registry_registers_handlers ... ok
[INFO] [stdout] test handler::context::tests::test_effect_context_accessors ... ok
[INFO] [stdout] test handler_registry::tests::test_group_handler ... ok
[INFO] [stdout] test handler::types::tests::test_emit_conversions ... ok
[INFO] [stdout] test handler::types::tests::test_event_output_debug ... ok
[INFO] [stdout] test handler_registry::tests::test_multiple_handlers ... ok
[INFO] [stdout] test upcaster::tests::upcast_chain_v1_to_v3 ... ok
[INFO] [stdout] test upcaster::tests::upcast_noop_for_unknown_event ... ok
[INFO] [stdout] test handler::context::tests::test_effect_context_clone ... ok
[INFO] [stdout] test upcaster::tests::upcast_noop_when_current ... ok
[INFO] [stdout] test handler::context::tests::journal_sorts_unsorted_entries_on_load ... ok
[INFO] [stdout] test event_store::tests::idempotent_append_returns_existing_position ... ok
[INFO] [stdout] test handler::error_event::tests::test_downcast_failure ... ok
[INFO] [stdout] test handler::error_event::tests::test_handler_error_creation ... ok
[INFO] [stdout] test handler_registry::tests::test_register_rejects_duplicate_handler_ids - should panic ... ok
[INFO] [stdout] test upcaster::tests::upcast_error_propagates ... ok
[INFO] [stdout] test handler_registry::tests::test_register_rejects_generated_id_for_queued_handler - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 63 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/compile_fail.rs (/opt/rustwide/target/debug/deps/compile_fail-4eaeb61f32fb6316)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[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.183
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]     Checking pin-project-lite v0.2.17
[INFO] [stderr]     Checking cfg-if v1.0.4
[INFO] [stderr]     Checking futures-core v0.3.32
[INFO] [stderr]     Checking futures-sink v0.3.32
[INFO] [stderr]    Compiling autocfg v1.5.0
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]     Checking memchr v2.8.0
[INFO] [stderr]    Compiling zmij v1.0.21
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]     Checking scopeguard v1.2.0
[INFO] [stderr]     Checking futures-io v0.3.32
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling crossbeam-utils v0.8.21
[INFO] [stderr]     Checking once_cell v1.21.3
[INFO] [stderr]     Checking futures-task v0.3.32
[INFO] [stderr]     Checking smallvec v1.15.1
[INFO] [stderr]     Checking futures-channel v0.3.32
[INFO] [stderr]     Checking slab v0.4.12
[INFO] [stderr]     Checking lock_api v0.4.14
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling anyhow v1.0.102
[INFO] [stderr]     Checking itoa v1.0.17
[INFO] [stderr]     Checking tracing-core v0.1.36
[INFO] [stderr]     Checking hashbrown v0.14.5
[INFO] [stderr]     Checking iana-time-zone v0.1.65
[INFO] [stderr]     Checking sha1_smol v1.0.1
[INFO] [stderr]     Checking fastrand v2.3.0
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]     Checking dashmap v6.1.0
[INFO] [stderr]     Checking parking_lot v0.12.5
[INFO] [stderr]     Checking uuid v1.22.0
[INFO] [stderr]    Compiling futures-macro v0.3.32
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling tokio-macros v2.6.1
[INFO] [stderr]    Compiling async-trait v0.1.89
[INFO] [stderr]    Compiling seesaw_core_macros v0.26.3
[INFO] [stderr]     Checking tokio v1.50.0
[INFO] [stderr]     Checking futures-util v0.3.32
[INFO] [stderr]     Checking tracing v0.1.44
[INFO] [stderr]     Checking futures-executor v0.3.32
[INFO] [stderr]     Checking futures v0.3.32
[INFO] [stderr]     Checking chrono v0.4.44
[INFO] [stderr]     Checking seesaw_core v0.26.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Checking seesaw_core-tests v0.0.0 (/opt/rustwide/target/tests/trybuild/seesaw_core)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 19.98s
[INFO] [stderr] 
[INFO] [stderr] 
[INFO] [stderr] test tests/compile_fail/event_enum_no_prefix.rs ... ok
[INFO] [stdout] test compile_fail ... ok
[INFO] [stderr] test tests/compile_fail/event_enum_no_serde_tag.rs ... ok
[INFO] [stdout] 
[INFO] [stderr] test tests/compile_fail/event_enum_untagged.rs ... ok
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 30.54s
[INFO] [stderr] test tests/compile_fail/filter_extract_exclusive.rs ... ok
[INFO] [stdout] 
[INFO] [stderr] 
[INFO] [stderr] 
[INFO] [stderr]      Running tests/engine_integration.rs (/opt/rustwide/target/debug/deps/engine_integration-f9b203a8e4e6194e)
[INFO] [stdout] 
[INFO] [stdout] running 115 tests
[INFO] [stdout] test cancel_mid_settle_rejects_downstream_events ... ok
[INFO] [stdout] test cancel_prevents_event_processing ... ok
[INFO] [stdout] test auto_persist_events_per_aggregate_stream ... ok
[INFO] [stdout] test custom_correlation_id_on_process_handle ... ok
[INFO] [stdout] test auto_snapshot_every_n_events ... ok
[INFO] [stdout] test cold_start_hydration ... ok
[INFO] [stdout] test ctx_run_executes_side_effect_in_handler ... ok
[INFO] [stdout] test deep_ephemeral_chain_with_hop_counting ... ok
[INFO] [stdout] test describe_fires_for_ephemeral_events ... ok
[INFO] [stdout] test cross_aggregate_event_persisted_to_multiple_streams ... ok
[INFO] [stdout] test custom_correlation_id_propagates_to_child_events ... ok
[INFO] [stdout] test basic_handler_fires ... ok
[INFO] [stdout] test chained_ephemeral_to_ephemeral_to_persistent ... ok
[INFO] [stdout] test cancel_does_not_affect_other_correlations ... ok
[INFO] [stdout] test correlation_preserved_through_queued_chain ... ok
[INFO] [stdout] test cancel_is_idempotent ... ok
[INFO] [stdout] test engine_status_delegates_to_store ... ok
[INFO] [stdout] test describe_reflects_post_handler_aggregate_state ... ok
[INFO] [stdout] test dlq_terminal_event_from_ephemeral_triggered_handler ... ok
[INFO] [stdout] test ephemeral_available_via_on_any_handler ... ok
[INFO] [stdout] test auto_snapshot_hydration_uses_checkpoint ... ok
[INFO] [stdout] test emit_requires_settled ... ok
[INFO] [stdout] test cancel_dlqs_pending_handlers ... ok
[INFO] [stdout] test dlq_terminal_preserves_correlation ... ok
[INFO] [stdout] test dlq_terminal_event_published ... ok
[INFO] [stdout] test ephemeral_available_in_projection ... ok
[INFO] [stdout] test dlq_event_carries_failed_handler_id_in_metadata ... ok
[INFO] [stdout] test ephemeral_does_not_break_dlq_path ... ok
[INFO] [stdout] test empty_aggregate_access_returns_default ... ok
[INFO] [stdout] test ephemeral_event_handler_emits_persistent ... ok
[INFO] [stdout] test ephemeral_event_does_not_apply_to_aggregates ... ok
[INFO] [stdout] test ephemeral_only_root_event_still_settles ... ok
[INFO] [stdout] test ephemeral_event_hop_counting ... ok
[INFO] [stdout] test ephemeral_event_does_not_run_projections ... ok
[INFO] [stdout] test ephemeral_persistent_flag_propagates_through_causal_chain ... ok
[INFO] [stdout] test cancel_correlation_with_ephemeral_events ... ok
[INFO] [stdout] test ephemeral_event_not_in_store ... ok
[INFO] [stdout] test ephemeral_event_with_retry_handler ... ok
[INFO] [stdout] test ephemeral_preserved_in_batch_fanout ... ok
[INFO] [stdout] test engine_without_event_store_identical_behavior ... ok
[INFO] [stdout] test engine_without_on_dlq_unchanged ... ok
[INFO] [stdout] test ephemeral_events_excluded_from_aggregate_streams ... ok
[INFO] [stdout] test event_metadata_stamped_on_persisted_events ... ok
[INFO] [stdout] test ephemeral_shared_across_multiple_handlers ... ok
[INFO] [stdout] test ephemeral_event_idempotent_append ... ok
[INFO] [stdout] test events_without_aggregator_not_in_stream ... ok
[INFO] [stdout] test handler_returns_nothing ... ok
[INFO] [stdout] test ephemeral_triggers_on_any_handler ... ok
[INFO] [stdout] test ephemeral_via_emit_output ... ok
[INFO] [stdout] test ephemeral_events_advance_checkpoint ... ok
[INFO] [stdout] test ephemeral_with_extract_handler ... ok
[INFO] [stdout] test event_metadata_on_non_aggregate_events ... ok
[INFO] [stdout] test ephemeral_preserved_in_handler_chain ... ok
[INFO] [stdout] test ephemeral_preserves_serde_skip_fields ... ok
[INFO] [stdout] test ephemeral_root_via_emit_output ... ok
[INFO] [stdout] test journal_cleared_after_successful_handler ... ok
[INFO] [stdout] test mixed_aggregate_types_independent_streams ... ok
[INFO] [stdout] test mixed_persistent_and_ephemeral_in_same_batch ... ok
[INFO] [stdout] test journal_concurrent_ctx_run_from_spawned_tasks ... ok
[INFO] [stdout] test journal_replays_completed_run_calls_on_retry ... ok
[INFO] [stdout] test interleaved_persistent_ephemeral_batch_ordering ... ok
[INFO] [stdout] test invalidate_aggregate_forces_rehydration ... ok
[INFO] [stdout] test journal_isolation_across_different_events ... ok
[INFO] [stdout] test ephemeral_root_event_not_persisted ... ok
[INFO] [stdout] test missing_snapshot_falls_back_to_full_replay ... ok
[INFO] [stdout] test journal_large_nested_payload_round_trips ... ok
[INFO] [stdout] test multi_type_handler_fires_on_both_event_types ... ok
[INFO] [stdout] test multiple_handlers_same_event ... ok
[INFO] [stdout] test multi_type_handler_with_filter_fires_on_both_types ... ok
[INFO] [stdout] test multiple_ephemeral_root_events ... ok
[INFO] [stdout] test no_metadata_produces_empty_map ... ok
[INFO] [stdout] test handler_emits_chain ... ok
[INFO] [stdout] test omitted_correlation_id_auto_generates ... ok
[INFO] [stdout] test on_dlq_not_called_on_success ... ok
[INFO] [stdout] test no_snapshot_without_threshold ... ok
[INFO] [stdout] test handler_panic_does_not_crash_engine ... ok
[INFO] [stdout] test on_dlq_preserves_correlation_id ... ok
[INFO] [stdout] test journal_panic_mid_execution_preserves_prior_entries ... ok
[INFO] [stdout] test journal_works_for_ephemeral_event_handlers ... ok
[INFO] [stdout] test on_dlq_receives_correct_info ... ok
[INFO] [stdout] test process_handle_cancel_works ... ok
[INFO] [stdout] test on_dlq_fires_on_queued_handler_panic ... ok
[INFO] [stdout] test projection_error_recorded_as_projection_failure ... ok
[INFO] [stdout] test on_dlq_fires_on_custom_error_type ... ok
[INFO] [stdout] test on_dlq_not_fired_when_retry_succeeds ... ok
[INFO] [stdout] test on_dlq_fires_after_all_retries_exhausted ... ok
[INFO] [stdout] test queue_status_empty_after_settle ... ok
[INFO] [stdout] test queue_status_shows_pending_before_settle ... ok
[INFO] [stdout] test queued_handler_executes ... ok
[INFO] [stdout] test retry_succeeds_on_second_attempt ... ok
[INFO] [stdout] test save_snapshot_helper_works ... ok
[INFO] [stdout] test sequential_events_same_aggregate_correct_versions ... ok
[INFO] [stdout] test reclaimed_handler_sees_hydrated_aggregate_state ... ok
[INFO] [stdout] test settled_timeout_succeeds_when_fast ... ok
[INFO] [stdout] test singleton_hydrated_across_event_types_for_handler_filter ... ok
[INFO] [stdout] test snapshot_acceleration ... ok
[INFO] [stdout] test on_dlq_mapper_error_does_not_crash_engine ... ok
[INFO] [stdout] test on_dlq_emits_event_on_handler_failure ... ok
[INFO] [stdout] test snapshot_not_triggered_by_ephemeral_events ... ok
[INFO] [stdout] test projection_error_does_not_stop_other_handlers ... ok
[INFO] [stdout] test on_failure_with_source_event_access ... ok
[INFO] [stdout] test stale_snapshot_partial_replay_fills_gap ... ok
[INFO] [stdout] test transition_guard_works_after_cold_start ... ok
[INFO] [stdout] test on_dlq_fires_for_each_failing_handler ... ok
[INFO] [stdout] test on_dlq_per_handler_on_failure_takes_precedence ... ok
[INFO] [stdout] test on_dlq_fires_on_anyhow_bail ... ok
[INFO] [stdout] test snapshot_at_version_prevents_immediate_re_snapshot ... ok
[INFO] [stdout] test upcaster_chain_in_aggregate_replay ... ok
[INFO] [stdout] test rapid_fire_events_same_aggregate ... ok
[INFO] [stdout] test upcaster_transforms_old_event_for_handler ... ok
[INFO] [stdout] test on_dlq_event_handler_failure_does_not_cascade ... ok
[INFO] [stdout] test large_event_replay_produces_correct_state ... ok
[INFO] [stdout] test backoff_retries_handler_with_exponential_delay ... FAILED
[INFO] [stdout] test settled_timeout_errors_when_slow ... ok
[INFO] [stdout] test on_dlq_fires_on_timeout ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- backoff_retries_handler_with_exponential_delay stdout ----
[INFO] [stdout] Handler sent to DLQ: 9149d40f-bf3f-48b8-b08a-446f41811ff2:backoff_ping - always fails (attempts: 3)
[INFO] [stdout] 
[INFO] [stdout] thread 'backoff_retries_handler_with_exponential_delay' (1372) panicked at tests/engine_integration.rs:692:5:
[INFO] [stdout] second retry gap (43.04867ms) should be longer than first (174.151379ms)
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x597500a684da - std[e28293b1aa0f68bd]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x597500a684da - std[e28293b1aa0f68bd]::backtrace_rs::backtrace::trace_unsynchronized::<std[e28293b1aa0f68bd]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x597500a684da - std[e28293b1aa0f68bd]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x597500a684da - <<std[e28293b1aa0f68bd]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[c1f1a4ba060b9bfa]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x597500a7d00a - <core[c1f1a4ba060b9bfa]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x597500a7d00a - core[c1f1a4ba060b9bfa]::fmt::write
[INFO] [stdout]    6:     0x597500a6d2b2 - std[e28293b1aa0f68bd]::io::default_write_fmt::<alloc[fdfd2bd8633a6659]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x597500a6d2b2 - <alloc[fdfd2bd8633a6659]::vec::Vec<u8> as std[e28293b1aa0f68bd]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x597500a46d5f - <std[e28293b1aa0f68bd]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x597500a46d5f - std[e28293b1aa0f68bd]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x597500a60779 - std[e28293b1aa0f68bd]::panicking::default_hook
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5975008e48dc - <alloc[fdfd2bd8633a6659]::boxed::Box<dyn for<'a, 'b> core[c1f1a4ba060b9bfa]::ops::function::Fn<(&'a std[e28293b1aa0f68bd]::panic::PanicHookInfo<'b>,), Output = ()> + core[c1f1a4ba060b9bfa]::marker::Sync + core[c1f1a4ba060b9bfa]::marker::Send> as core[c1f1a4ba060b9bfa]::ops::function::Fn<(&std[e28293b1aa0f68bd]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x5975008e48dc - test[273d7611820c9051]::test_main_with_exit_callback::<test[273d7611820c9051]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x597500a609f2 - <alloc[fdfd2bd8633a6659]::boxed::Box<dyn for<'a, 'b> core[c1f1a4ba060b9bfa]::ops::function::Fn<(&'a std[e28293b1aa0f68bd]::panic::PanicHookInfo<'b>,), Output = ()> + core[c1f1a4ba060b9bfa]::marker::Sync + core[c1f1a4ba060b9bfa]::marker::Send> as core[c1f1a4ba060b9bfa]::ops::function::Fn<(&std[e28293b1aa0f68bd]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x597500a609f2 - std[e28293b1aa0f68bd]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x597500a46e18 - std[e28293b1aa0f68bd]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x597500a3e259 - std[e28293b1aa0f68bd]::sys::backtrace::__rust_end_short_backtrace::<std[e28293b1aa0f68bd]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x597500a47c1d - __rustc[b7974e8690430dd9]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x597500a7d8ec - core[c1f1a4ba060b9bfa]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5975006b13a5 - engine_integration::backoff_retries_handler_with_exponential_delay::{{closure}}::hae90f9d3af49ee37
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/engine_integration.rs:692:5
[INFO] [stdout]   20:     0x597500863b25 - <core::pin::Pin<P> as core::future::future::Future>::poll::hf2f49bc0d6207d8f
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/future/future.rs:133:9
[INFO] [stdout]   21:     0x59750086365d - <core::pin::Pin<P> as core::future::future::Future>::poll::h049e3977de4872ae
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/future/future.rs:133:9
[INFO] [stdout]   22:     0x5975008bdeed - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::{{closure}}::hd04762fa5260ecf2
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.50.0/src/runtime/scheduler/current_thread/mod.rs:769:70
[INFO] [stdout]   23:     0x5975008bd85c - tokio::task::coop::with_budget::h9d627e4b7a03d420
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.50.0/src/task/coop/mod.rs:167:5
[INFO] [stdout]   24:     0x5975008bd85c - tokio::task::coop::budget::h8165d6069991080e
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.50.0/src/task/coop/mod.rs:133:5
[INFO] [stdout]   25:     0x5975008bd85c - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::h4260dfb0485b941b
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.50.0/src/runtime/scheduler/current_thread/mod.rs:769:25
[INFO] [stdout]   26:     0x5975008b7aba - tokio::runtime::scheduler::current_thread::Context::enter::h66f12df6df8f6129
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.50.0/src/runtime/scheduler/current_thread/mod.rs:446:19
[INFO] [stdout]   27:     0x5975008bce9d - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::h8275bc62c46d3772
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.50.0/src/runtime/scheduler/current_thread/mod.rs:768:44
[INFO] [stdout]   28:     0x5975008ba8fb - tokio::runtime::scheduler::current_thread::CoreGuard::enter::{{closure}}::h78c0a25266bf32ed
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.50.0/src/runtime/scheduler/current_thread/mod.rs:856:68
[INFO] [stdout]   29:     0x59750083e9ca - tokio::runtime::context::scoped::Scoped<T>::set::hb2c185b1952d03ab
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.50.0/src/runtime/context/scoped.rs:40:9
[INFO] [stdout]   30:     0x5975008b5a7a - tokio::runtime::context::set_scheduler::{{closure}}::h6775cce295c5cca7
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.50.0/src/runtime/context.rs:176:38
[INFO] [stdout]   31:     0x5975008a52e6 - std::thread::local::LocalKey<T>::try_with::hbd71dc6c844b1ab2
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/thread/local.rs:513:12
[INFO] [stdout]   32:     0x5975008a398c - std::thread::local::LocalKey<T>::with::he3dde01f21b3d7ec
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/thread/local.rs:477:20
[INFO] [stdout]   33:     0x5975008b5a21 - tokio::runtime::context::set_scheduler::hf5c4d8fd55509425
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.50.0/src/runtime/context.rs:176:17
[INFO] [stdout]   34:     0x5975008ba649 - tokio::runtime::scheduler::current_thread::CoreGuard::enter::hb74d646ab1b8648c
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.50.0/src/runtime/scheduler/current_thread/mod.rs:856:27
[INFO] [stdout]   35:     0x5975008ba996 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::h0a6700dcdc3632ae
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.50.0/src/runtime/scheduler/current_thread/mod.rs:756:24
[INFO] [stdout]   36:     0x5975008b6b39 - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::{{closure}}::h8a1cd9fb81f5e83a
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.50.0/src/runtime/scheduler/current_thread/mod.rs:200:33
[INFO] [stdout]   37:     0x597500874693 - tokio::runtime::context::runtime::enter_runtime::hacaf632b6b13f80e
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.50.0/src/runtime/context/runtime.rs:65:16
[INFO] [stdout]   38:     0x5975008b60b1 - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::h8bedac0735fba44e
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.50.0/src/runtime/scheduler/current_thread/mod.rs:188:9
[INFO] [stdout]   39:     0x5975008a7d0f - tokio::runtime::runtime::Runtime::block_on_inner::h45f2e818a4879576
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.50.0/src/runtime/runtime.rs:371:52
[INFO] [stdout]   40:     0x5975008a8033 - tokio::runtime::runtime::Runtime::block_on::ha641648f5cf9a153
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.50.0/src/runtime/runtime.rs:345:18
[INFO] [stdout]   41:     0x5975006b07a3 - engine_integration::backoff_retries_handler_with_exponential_delay::hff660a3c2821bf6c
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/engine_integration.rs:699:7
[INFO] [stdout]   42:     0x5975006b0847 - engine_integration::backoff_retries_handler_with_exponential_delay::{{closure}}::h4c3ac038eb50090a
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/engine_integration.rs:652:62
[INFO] [stdout]   43:     0x59750077e176 - core::ops::function::FnOnce::call_once::h18b2f64ccffb30c1
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   44:     0x5975008d89bb - <fn() -> core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String> as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   45:     0x5975008d89bb - test[273d7611820c9051]::__rust_begin_short_backtrace::<core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>, fn() -> core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:663:18
[INFO] [stdout]   46:     0x5975008e53ab - test[273d7611820c9051]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:686:74
[INFO] [stdout]   47:     0x5975008e53ab - <core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<test[273d7611820c9051]::run_test_in_process::{closure#0}> as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   48:     0x5975008e53ab - std[e28293b1aa0f68bd]::panicking::catch_unwind::do_call::<core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<test[273d7611820c9051]::run_test_in_process::{closure#0}>, core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:581:40
[INFO] [stdout]   49:     0x5975008e53ab - std[e28293b1aa0f68bd]::panicking::catch_unwind::<core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>, core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<test[273d7611820c9051]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:544:19
[INFO] [stdout]   50:     0x5975008e53ab - std[e28293b1aa0f68bd]::panic::catch_unwind::<core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<test[273d7611820c9051]::run_test_in_process::{closure#0}>, core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panic.rs:359:14
[INFO] [stdout]   51:     0x5975008e53ab - test[273d7611820c9051]::run_test_in_process
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:686:27
[INFO] [stdout]   52:     0x5975008e53ab - test[273d7611820c9051]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:607:43
[INFO] [stdout]   53:     0x5975008e0ac4 - test[273d7611820c9051]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:637:41
[INFO] [stdout]   54:     0x5975008e0ac4 - std[e28293b1aa0f68bd]::sys::backtrace::__rust_begin_short_backtrace::<test[273d7611820c9051]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   55:     0x5975008e7fb2 - std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked::<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   56:     0x5975008e7fb2 - <core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   57:     0x5975008e7fb2 - std[e28293b1aa0f68bd]::panicking::catch_unwind::do_call::<core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:581:40
[INFO] [stdout]   58:     0x5975008e7fb2 - std[e28293b1aa0f68bd]::panicking::catch_unwind::<(), core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:544:19
[INFO] [stdout]   59:     0x5975008e7fb2 - std[e28293b1aa0f68bd]::panic::catch_unwind::<core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panic.rs:359:14
[INFO] [stdout]   60:     0x5975008e7fb2 - std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked::<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   61:     0x5975008e7fb2 - <std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1} as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   62:     0x597500a67daf - <alloc[fdfd2bd8633a6659]::boxed::Box<dyn core[c1f1a4ba060b9bfa]::ops::function::FnOnce<(), Output = ()> + core[c1f1a4ba060b9bfa]::marker::Send> as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   63:     0x597500a67daf - <std[e28293b1aa0f68bd]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   64:     0x75999a40caa4 - <unknown>
[INFO] [stdout]   65:     0x75999a499a64 - clone
[INFO] [stdout]   66:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     backoff_retries_handler_with_exponential_delay
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 114 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.04s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--test engine_integration`
[INFO] running `Command { std: "docker" "inspect" "a53c9bbcf9279ad822417314a14c5fc7650a8a459403c9d70ebe3087f783bca3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a53c9bbcf9279ad822417314a14c5fc7650a8a459403c9d70ebe3087f783bca3", kill_on_drop: false }`
[INFO] [stdout] a53c9bbcf9279ad822417314a14c5fc7650a8a459403c9d70ebe3087f783bca3
