[INFO] cloning repository https://github.com/matthewbjones/tracing-better-stack [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/matthewbjones/tracing-better-stack" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmatthewbjones%2Ftracing-better-stack", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmatthewbjones%2Ftracing-better-stack'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 4b55b871e6aa2fbd5081040f123778736340459d [INFO] testing matthewbjones/tracing-better-stack against master#2fd6efc32704647e64d3d646d21c4c68eae100e4 for pr-149852-1 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmatthewbjones%2Ftracing-better-stack" "/workspace/builds/worker-1-tc1/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-1-tc1/source'... [INFO] [stderr] done. [INFO] started tweaking git repo https://github.com/matthewbjones/tracing-better-stack [INFO] finished tweaking git repo https://github.com/matthewbjones/tracing-better-stack [INFO] tweaked toml for git repo https://github.com/matthewbjones/tracing-better-stack written to /workspace/builds/worker-1-tc1/source/Cargo.toml [INFO] validating manifest of git repo https://github.com/matthewbjones/tracing-better-stack on toolchain 2fd6efc32704647e64d3d646d21c4c68eae100e4 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+2fd6efc32704647e64d3d646d21c4c68eae100e4" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate git repo https://github.com/matthewbjones/tracing-better-stack 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" "+2fd6efc32704647e64d3d646d21c4c68eae100e4" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Updating crates.io index [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded wiremock v0.6.4 [INFO] [stderr] Downloaded tracing-test-macro v0.2.5 [INFO] [stderr] Downloaded windows-registry v0.5.3 [INFO] [stderr] Downloaded tokio-rustls v0.26.2 [INFO] [stderr] Downloaded deadpool v0.10.0 [INFO] [stderr] Downloaded tracing-test v0.2.5 [INFO] [stderr] Downloaded iri-string v0.7.8 [INFO] [stderr] Downloaded reqwest v0.12.23 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:aa71247004a7fa38d13ec170f48f06cdedf5bc50b2a8645e56ed7e992e6fa513" "/opt/rustwide/cargo-home/bin/cargo" "+2fd6efc32704647e64d3d646d21c4c68eae100e4" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 49f56b061da6cd775eecf229cb3619bf4617083e71de599e6c5be9ad8b246f64 [INFO] running `Command { std: "docker" "start" "-a" "49f56b061da6cd775eecf229cb3619bf4617083e71de599e6c5be9ad8b246f64", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "49f56b061da6cd775eecf229cb3619bf4617083e71de599e6c5be9ad8b246f64", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "49f56b061da6cd775eecf229cb3619bf4617083e71de599e6c5be9ad8b246f64", kill_on_drop: false }` [INFO] [stdout] 49f56b061da6cd775eecf229cb3619bf4617083e71de599e6c5be9ad8b246f64 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:aa71247004a7fa38d13ec170f48f06cdedf5bc50b2a8645e56ed7e992e6fa513" "/opt/rustwide/cargo-home/bin/cargo" "+2fd6efc32704647e64d3d646d21c4c68eae100e4" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 040d4f75372e855f2e39e5bfc111756b3f378ad2bba6a6f942349f75228bf1bd [INFO] running `Command { std: "docker" "start" "-a" "040d4f75372e855f2e39e5bfc111756b3f378ad2bba6a6f942349f75228bf1bd", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.101 [INFO] [stderr] Compiling writeable v0.6.1 [INFO] [stderr] Compiling litemap v0.8.0 [INFO] [stderr] Compiling libc v0.2.175 [INFO] [stderr] Compiling cc v1.2.33 [INFO] [stderr] Compiling icu_normalizer_data v2.0.0 [INFO] [stderr] Compiling icu_properties_data v2.0.1 [INFO] [stderr] Compiling openssl v0.10.73 [INFO] [stderr] Compiling hashbrown v0.15.5 [INFO] [stderr] Compiling bitflags v2.9.2 [INFO] [stderr] Compiling num-traits v0.2.19 [INFO] [stderr] Compiling serde v1.0.219 [INFO] [stderr] Compiling http-body-util v0.1.3 [INFO] [stderr] Compiling zeroize v1.8.1 [INFO] [stderr] Compiling iri-string v0.7.8 [INFO] [stderr] Compiling tracing-log v0.2.0 [INFO] [stderr] Compiling encoding_rs v0.8.35 [INFO] [stderr] Compiling rustls-pki-types v1.12.0 [INFO] [stderr] Compiling iana-time-zone v0.1.63 [INFO] [stderr] Compiling tracing-subscriber v0.3.19 [INFO] [stderr] Compiling quote v1.0.40 [INFO] [stderr] Compiling syn v2.0.106 [INFO] [stderr] Compiling mio v1.0.4 [INFO] [stderr] Compiling socket2 v0.6.0 [INFO] [stderr] Compiling indexmap v2.10.0 [INFO] [stderr] Compiling rmp v0.8.14 [INFO] [stderr] Compiling openssl-sys v0.9.109 [INFO] [stderr] Compiling native-tls v0.2.14 [INFO] [stderr] Compiling synstructure v0.13.2 [INFO] [stderr] Compiling zerofrom-derive v0.1.6 [INFO] [stderr] Compiling yoke-derive v0.8.0 [INFO] [stderr] Compiling zerovec-derive v0.11.1 [INFO] [stderr] Compiling displaydoc v0.2.5 [INFO] [stderr] Compiling tokio-macros v2.5.0 [INFO] [stderr] Compiling tracing-attributes v0.1.30 [INFO] [stderr] Compiling serde_derive v1.0.219 [INFO] [stderr] Compiling openssl-macros v0.1.1 [INFO] [stderr] Compiling tokio v1.47.1 [INFO] [stderr] Compiling zerofrom v0.1.6 [INFO] [stderr] Compiling yoke v0.8.0 [INFO] [stderr] Compiling tracing v0.1.41 [INFO] [stderr] Compiling zerotrie v0.2.2 [INFO] [stderr] Compiling zerovec v0.11.4 [INFO] [stderr] Compiling tinystr v0.8.1 [INFO] [stderr] Compiling potential_utf v0.1.2 [INFO] [stderr] Compiling icu_collections v2.0.0 [INFO] [stderr] Compiling icu_locale_core v2.0.0 [INFO] [stderr] Compiling icu_provider v2.0.0 [INFO] [stderr] Compiling icu_properties v2.0.1 [INFO] [stderr] Compiling icu_normalizer v2.0.0 [INFO] [stderr] Compiling idna_adapter v1.2.1 [INFO] [stderr] Compiling idna v1.0.3 [INFO] [stderr] Compiling serde_urlencoded v0.7.1 [INFO] [stderr] Compiling chrono v0.4.41 [INFO] [stderr] Compiling rmp-serde v1.3.0 [INFO] [stderr] Compiling url v2.5.4 [INFO] [stderr] Compiling tokio-util v0.7.16 [INFO] [stderr] Compiling tokio-native-tls v0.3.1 [INFO] [stderr] Compiling tower v0.5.2 [INFO] [stderr] Compiling h2 v0.4.12 [INFO] [stderr] Compiling tower-http v0.6.6 [INFO] [stderr] Compiling hyper v1.6.0 [INFO] [stderr] Compiling hyper-util v0.1.16 [INFO] [stderr] Compiling hyper-tls v0.6.0 [INFO] [stderr] Compiling reqwest v0.12.23 [INFO] [stderr] Compiling tracing-better-stack v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 39.66s [INFO] running `Command { std: "docker" "inspect" "040d4f75372e855f2e39e5bfc111756b3f378ad2bba6a6f942349f75228bf1bd", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "040d4f75372e855f2e39e5bfc111756b3f378ad2bba6a6f942349f75228bf1bd", kill_on_drop: false }` [INFO] [stdout] 040d4f75372e855f2e39e5bfc111756b3f378ad2bba6a6f942349f75228bf1bd [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:aa71247004a7fa38d13ec170f48f06cdedf5bc50b2a8645e56ed7e992e6fa513" "/opt/rustwide/cargo-home/bin/cargo" "+2fd6efc32704647e64d3d646d21c4c68eae100e4" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 83a27104bd19c70aa0ecb744b1eaabe41f130f5c8cbf02bfffe2dd37b5437925 [INFO] running `Command { std: "docker" "start" "-a" "83a27104bd19c70aa0ecb744b1eaabe41f130f5c8cbf02bfffe2dd37b5437925", kill_on_drop: false }` [INFO] [stderr] Compiling futures-channel v0.3.31 [INFO] [stderr] Compiling futures-io v0.3.31 [INFO] [stderr] Compiling parking_lot_core v0.9.11 [INFO] [stderr] Compiling signal-hook-registry v1.4.6 [INFO] [stderr] Compiling futures-macro v0.3.31 [INFO] [stderr] Compiling serde_json v1.0.142 [INFO] [stderr] Compiling tracing-subscriber v0.3.19 [INFO] [stderr] Compiling async-trait v0.1.89 [INFO] [stderr] Compiling num_cpus v1.17.0 [INFO] [stderr] Compiling deadpool-runtime v0.1.4 [INFO] [stderr] Compiling tracing-test-macro v0.2.5 [INFO] [stderr] Compiling parking_lot v0.12.4 [INFO] [stderr] Compiling tokio v1.47.1 [INFO] [stderr] Compiling futures-util v0.3.31 [INFO] [stderr] Compiling assert-json-diff v2.0.2 [INFO] [stderr] Compiling tracing-test v0.2.5 [INFO] [stderr] Compiling futures-executor v0.3.31 [INFO] [stderr] Compiling futures v0.3.31 [INFO] [stderr] Compiling tokio-util v0.7.16 [INFO] [stderr] Compiling tokio-native-tls v0.3.1 [INFO] [stderr] Compiling tower v0.5.2 [INFO] [stderr] Compiling deadpool v0.10.0 [INFO] [stderr] Compiling h2 v0.4.12 [INFO] [stderr] Compiling tower-http v0.6.6 [INFO] [stderr] Compiling hyper v1.6.0 [INFO] [stderr] Compiling hyper-util v0.1.16 [INFO] [stderr] Compiling hyper-tls v0.6.0 [INFO] [stderr] Compiling wiremock v0.6.4 [INFO] [stderr] Compiling reqwest v0.12.23 [INFO] [stderr] Compiling tracing-better-stack v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 35.25s [INFO] running `Command { std: "docker" "inspect" "83a27104bd19c70aa0ecb744b1eaabe41f130f5c8cbf02bfffe2dd37b5437925", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "83a27104bd19c70aa0ecb744b1eaabe41f130f5c8cbf02bfffe2dd37b5437925", kill_on_drop: false }` [INFO] [stdout] 83a27104bd19c70aa0ecb744b1eaabe41f130f5c8cbf02bfffe2dd37b5437925 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:aa71247004a7fa38d13ec170f48f06cdedf5bc50b2a8645e56ed7e992e6fa513" "/opt/rustwide/cargo-home/bin/cargo" "+2fd6efc32704647e64d3d646d21c4c68eae100e4" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 16a93e21c45e248f5a6b1c08cc616d3be574f03e1460d47f5b464e95f58a0022 [INFO] running `Command { std: "docker" "start" "-a" "16a93e21c45e248f5a6b1c08cc616d3be574f03e1460d47f5b464e95f58a0022", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.29s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/tracing_better_stack-086e4e9408babb67) [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stdout] test tests::test_layer_creation ... ok [INFO] [stdout] test tests::test_basic_logging ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.27s [INFO] [stdout] [INFO] [stderr] Running tests/base_tests.rs (/opt/rustwide/target/debug/deps/base_tests-ad368d448143ca57) [INFO] [stdout] [INFO] [stdout] running 11 tests [INFO] [stdout] test test_configuration_validation ... ok [INFO] [stdout] test test_graceful_shutdown ... ok [INFO] [stdout] test test_batching_behavior ... FAILED [INFO] [stdout] test test_basic_logging ... ok [INFO] [stdout] test test_message_ordering_preservation ... ok [INFO] [stdout] test test_large_payload_handling ... ok [INFO] [stdout] test test_different_log_levels ... ok [INFO] [stdout] test test_retry_on_failure ... ok [INFO] [stdout] test test_concurrent_logging ... ok [INFO] [stdout] test test_retry_with_eventual_success ... ok [INFO] [stdout] test test_timeout_batching ... ok [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- test_batching_behavior stdout ---- [INFO] [stdout] [INFO] [stdout] thread 'test_batching_behavior' (29) panicked at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/wiremock-0.6.4/src/mock_server/exposed_server.rs:367:17: [INFO] [stdout] Verifications failed: [INFO] [stdout] - Mock #0. [INFO] [stdout] Expected range of matching incoming requests: == 2 [INFO] [stdout] Number of matched incoming requests: 3 [INFO] [stdout] [INFO] [stdout] Received requests: [INFO] [stdout] - Request #1 [INFO] [stdout] POST http://localhost/ [INFO] [stdout] authorization: Bearer test-token [INFO] [stdout] content-type: application/msgpack [INFO] [stdout] accept: */* [INFO] [stdout] host: 127.0.0.1:33473 [INFO] [stdout] content-length: 261 [INFO] [stdout] Body is likely binary (invalid utf-8) size is 261 bytes [INFO] [stdout] - Request #2 [INFO] [stdout] POST http://localhost/ [INFO] [stdout] authorization: Bearer test-token [INFO] [stdout] content-type: application/msgpack [INFO] [stdout] accept: */* [INFO] [stdout] host: 127.0.0.1:33473 [INFO] [stdout] content-length: 651 [INFO] [stdout] Body is likely binary (invalid utf-8) size is 651 bytes [INFO] [stdout] - Request #3 [INFO] [stdout] POST http://localhost/ [INFO] [stdout] authorization: Bearer test-token [INFO] [stdout] content-type: application/msgpack [INFO] [stdout] accept: */* [INFO] [stdout] host: 127.0.0.1:33473 [INFO] [stdout] content-length: 578 [INFO] [stdout] Body is likely binary (invalid utf-8) size is 578 bytes [INFO] [stdout] [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x55c1f102e212 - std[716c9a7a72e5c14e]::backtrace_rs::backtrace::libunwind::trace [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x55c1f102e212 - std[716c9a7a72e5c14e]::backtrace_rs::backtrace::trace_unsynchronized:: [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x55c1f102e212 - std[716c9a7a72e5c14e]::sys::backtrace::_print_fmt [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/sys/backtrace.rs:74:9 [INFO] [stdout] 3: 0x55c1f102e212 - <::print::DisplayBacktrace as core[c5ed12ab89cc536a]::fmt::Display>::fmt [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/sys/backtrace.rs:44:26 [INFO] [stdout] 4: 0x55c1f10454ca - ::fmt [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/core/src/fmt/rt.rs:152:76 [INFO] [stdout] 5: 0x55c1f10454ca - core[c5ed12ab89cc536a]::fmt::write [INFO] [stdout] 6: 0x55c1f10337d6 - std[716c9a7a72e5c14e]::io::default_write_fmt::> [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/io/mod.rs:639:11 [INFO] [stdout] 7: 0x55c1f10337d6 - as std[716c9a7a72e5c14e]::io::Write>::write_fmt [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/io/mod.rs:1994:13 [INFO] [stdout] 8: 0x55c1f100ad5f - ::print [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/sys/backtrace.rs:47:9 [INFO] [stdout] 9: 0x55c1f100ad5f - std[716c9a7a72e5c14e]::panicking::default_hook::{closure#0} [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/panicking.rs:292:27 [INFO] [stdout] 10: 0x55c1f1025b79 - std[716c9a7a72e5c14e]::panicking::default_hook [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/panicking.rs:316:9 [INFO] [stdout] 11: 0x55c1f0a6adae - core[c5ed12ab89cc536a]::ops::function::Fn<(&'a std[716c9a7a72e5c14e]::panic::PanicHookInfo<'b>,), Output = ()> + core[c5ed12ab89cc536a]::marker::Sync + core[c5ed12ab89cc536a]::marker::Send> as core[c5ed12ab89cc536a]::ops::function::Fn<(&std[716c9a7a72e5c14e]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/alloc/src/boxed.rs:2220:9 [INFO] [stdout] 12: 0x55c1f0a6adae - test[64760d2bdea328cc]::test_main_with_exit_callback::::{closure#0} [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/test/src/lib.rs:145:21 [INFO] [stdout] 13: 0x55c1f1025de2 - core[c5ed12ab89cc536a]::ops::function::Fn<(&'a std[716c9a7a72e5c14e]::panic::PanicHookInfo<'b>,), Output = ()> + core[c5ed12ab89cc536a]::marker::Sync + core[c5ed12ab89cc536a]::marker::Send> as core[c5ed12ab89cc536a]::ops::function::Fn<(&std[716c9a7a72e5c14e]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/alloc/src/boxed.rs:2220:9 [INFO] [stdout] 14: 0x55c1f1025de2 - std[716c9a7a72e5c14e]::panicking::panic_with_hook [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/panicking.rs:833:13 [INFO] [stdout] 15: 0x55c1f100ae18 - std[716c9a7a72e5c14e]::panicking::panic_handler::{closure#0} [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/panicking.rs:698:13 [INFO] [stdout] 16: 0x55c1f1002709 - std[716c9a7a72e5c14e]::sys::backtrace::__rust_end_short_backtrace:: [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/sys/backtrace.rs:182:18 [INFO] [stdout] 17: 0x55c1f100be3d - __rustc[4f0b026143eab78e]::rust_begin_unwind [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/panicking.rs:689:5 [INFO] [stdout] 18: 0x55c1f1045c3c - core[c5ed12ab89cc536a]::panicking::panic_fmt [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/core/src/panicking.rs:80:14 [INFO] [stdout] 19: 0x55c1f0d60278 - core[c5ed12ab89cc536a]::panicking::panic_display::<&alloc[9c68fdf4f4f29218]::string::String> [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/core/src/panicking.rs:259:5 [INFO] [stdout] 20: 0x55c1f0d0de26 - ::verify::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/wiremock-0.6.4/src/mock_server/exposed_server.rs:367:17 [INFO] [stdout] 21: 0x55c1f0a1230d - base_tests[f7c17d63698b713a]::test_batching_behavior::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/base_tests.rs:107:26 [INFO] [stdout] 22: 0x55c1f0a2ba92 - > as core[c5ed12ab89cc536a]::future::future::Future>::poll [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/core/src/future/future.rs:133:9 [INFO] [stdout] 23: 0x55c1f0a2bb0d - >> as core[c5ed12ab89cc536a]::future::future::Future>::poll [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/core/src/future/future.rs:133:9 [INFO] [stdout] 24: 0x55c1f0a1fc0d - ::block_on::>>>::{closure#0}::{closure#0}::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.47.1/src/runtime/scheduler/current_thread/mod.rs:742:70 [INFO] [stdout] 25: 0x55c1f0a1fb0b - tokio[b872640127ec6ab]::task::coop::with_budget::, ::block_on>>>::{closure#0}::{closure#0}::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.47.1/src/task/coop/mod.rs:167:5 [INFO] [stdout] 26: 0x55c1f0a1fb0b - tokio[b872640127ec6ab]::task::coop::budget::, ::block_on>>>::{closure#0}::{closure#0}::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.47.1/src/task/coop/mod.rs:133:5 [INFO] [stdout] 27: 0x55c1f0a1fb0b - ::block_on::>>>::{closure#0}::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.47.1/src/runtime/scheduler/current_thread/mod.rs:742:25 [INFO] [stdout] 28: 0x55c1f0a19400 - ::enter::, ::block_on>>>::{closure#0}::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.47.1/src/runtime/scheduler/current_thread/mod.rs:432:19 [INFO] [stdout] 29: 0x55c1f0a1ec2d - ::block_on::>>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.47.1/src/runtime/scheduler/current_thread/mod.rs:741:44 [INFO] [stdout] 30: 0x55c1f0a1df14 - ::enter::<::block_on>>>::{closure#0}, core[c5ed12ab89cc536a]::option::Option<()>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.47.1/src/runtime/scheduler/current_thread/mod.rs:829:68 [INFO] [stdout] 31: 0x55c1f0a4afab - >::set::<::enter<::block_on>>>::{closure#0}, core[c5ed12ab89cc536a]::option::Option<()>>::{closure#0}, (alloc[9c68fdf4f4f29218]::boxed::Box, core[c5ed12ab89cc536a]::option::Option<()>)> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.47.1/src/runtime/context/scoped.rs:40:9 [INFO] [stdout] 32: 0x55c1f0a1f5d9 - tokio[b872640127ec6ab]::runtime::context::set_scheduler::<(alloc[9c68fdf4f4f29218]::boxed::Box, core[c5ed12ab89cc536a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[c5ed12ab89cc536a]::option::Option<()>>::{closure#0}>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.47.1/src/runtime/context.rs:176:38 [INFO] [stdout] 33: 0x55c1f0a3d802 - >::try_with::, core[c5ed12ab89cc536a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[c5ed12ab89cc536a]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[9c68fdf4f4f29218]::boxed::Box, core[c5ed12ab89cc536a]::option::Option<()>)> [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/thread/local.rs:513:12 [INFO] [stdout] 34: 0x55c1f0a3d38e - >::with::, core[c5ed12ab89cc536a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[c5ed12ab89cc536a]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[9c68fdf4f4f29218]::boxed::Box, core[c5ed12ab89cc536a]::option::Option<()>)> [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/thread/local.rs:477:20 [INFO] [stdout] 35: 0x55c1f0a1d07d - tokio[b872640127ec6ab]::runtime::context::set_scheduler::<(alloc[9c68fdf4f4f29218]::boxed::Box, core[c5ed12ab89cc536a]::option::Option<()>), ::enter<::block_on>>>::{closure#0}, core[c5ed12ab89cc536a]::option::Option<()>>::{closure#0}> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.47.1/src/runtime/context.rs:176:17 [INFO] [stdout] 36: 0x55c1f0a1ca30 - ::enter::<::block_on>>>::{closure#0}, core[c5ed12ab89cc536a]::option::Option<()>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.47.1/src/runtime/scheduler/current_thread/mod.rs:829:27 [INFO] [stdout] 37: 0x55c1f0a1cd26 - ::block_on::>>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.47.1/src/runtime/scheduler/current_thread/mod.rs:729:24 [INFO] [stdout] 38: 0x55c1f0a1da20 - ::block_on::>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.47.1/src/runtime/scheduler/current_thread/mod.rs:200:33 [INFO] [stdout] 39: 0x55c1f0a2f843 - tokio[b872640127ec6ab]::runtime::context::runtime::enter_runtime::<::block_on>>::{closure#0}, ()> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.47.1/src/runtime/context/runtime.rs:65:16 [INFO] [stdout] 40: 0x55c1f0a18f31 - ::block_on::>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.47.1/src/runtime/scheduler/current_thread/mod.rs:188:9 [INFO] [stdout] 41: 0x55c1f0a5a704 - ::block_on_inner::>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.47.1/src/runtime/runtime.rs:356:52 [INFO] [stdout] 42: 0x55c1f0a5a8cc - ::block_on::>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.47.1/src/runtime/runtime.rs:330:18 [INFO] [stdout] 43: 0x55c1f0a18087 - base_tests[f7c17d63698b713a]::test_batching_behavior [INFO] [stdout] at /opt/rustwide/workdir/tests/base_tests.rs:107:31 [INFO] [stdout] 44: 0x55c1f0a0dfe7 - base_tests[f7c17d63698b713a]::test_batching_behavior::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/base_tests.rs:55:34 [INFO] [stdout] 45: 0x55c1f0a07bb6 - >::call_once [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 46: 0x55c1f0a5f15b - core[c5ed12ab89cc536a]::result::Result<(), alloc[9c68fdf4f4f29218]::string::String> as core[c5ed12ab89cc536a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 47: 0x55c1f0a5f15b - test[64760d2bdea328cc]::__rust_begin_short_backtrace::, fn() -> core[c5ed12ab89cc536a]::result::Result<(), alloc[9c68fdf4f4f29218]::string::String>> [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/test/src/lib.rs:663:18 [INFO] [stdout] 48: 0x55c1f0a6b9ba - test[64760d2bdea328cc]::run_test_in_process::{closure#0} [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/test/src/lib.rs:686:74 [INFO] [stdout] 49: 0x55c1f0a6b9ba - as core[c5ed12ab89cc536a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/core/src/panic/unwind_safe.rs:274:9 [INFO] [stdout] 50: 0x55c1f0a6b9ba - std[716c9a7a72e5c14e]::panicking::catch_unwind::do_call::, core[c5ed12ab89cc536a]::result::Result<(), alloc[9c68fdf4f4f29218]::string::String>> [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/panicking.rs:581:40 [INFO] [stdout] 51: 0x55c1f0a6b9ba - std[716c9a7a72e5c14e]::panicking::catch_unwind::, core[c5ed12ab89cc536a]::panic::unwind_safe::AssertUnwindSafe> [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/panicking.rs:544:19 [INFO] [stdout] 52: 0x55c1f0a6b9ba - std[716c9a7a72e5c14e]::panic::catch_unwind::, core[c5ed12ab89cc536a]::result::Result<(), alloc[9c68fdf4f4f29218]::string::String>> [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/panic.rs:359:14 [INFO] [stdout] 53: 0x55c1f0a6b9ba - test[64760d2bdea328cc]::run_test_in_process [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/test/src/lib.rs:686:27 [INFO] [stdout] 54: 0x55c1f0a6b9ba - test[64760d2bdea328cc]::run_test::{closure#0} [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/test/src/lib.rs:607:43 [INFO] [stdout] 55: 0x55c1f0a65e84 - test[64760d2bdea328cc]::run_test::{closure#1} [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/test/src/lib.rs:637:41 [INFO] [stdout] 56: 0x55c1f0a65e84 - std[716c9a7a72e5c14e]::sys::backtrace::__rust_begin_short_backtrace:: [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/sys/backtrace.rs:166:18 [INFO] [stdout] 57: 0x55c1f0a6e4b2 - std[716c9a7a72e5c14e]::thread::lifecycle::spawn_unchecked::::{closure#1}::{closure#0} [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/thread/lifecycle.rs:91:13 [INFO] [stdout] 58: 0x55c1f0a6e4b2 - ::{closure#1}::{closure#0}> as core[c5ed12ab89cc536a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/core/src/panic/unwind_safe.rs:274:9 [INFO] [stdout] 59: 0x55c1f0a6e4b2 - std[716c9a7a72e5c14e]::panicking::catch_unwind::do_call::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/panicking.rs:581:40 [INFO] [stdout] 60: 0x55c1f0a6e4b2 - std[716c9a7a72e5c14e]::panicking::catch_unwind::<(), core[c5ed12ab89cc536a]::panic::unwind_safe::AssertUnwindSafe::{closure#1}::{closure#0}>> [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/panicking.rs:544:19 [INFO] [stdout] 61: 0x55c1f0a6e4b2 - std[716c9a7a72e5c14e]::panic::catch_unwind::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/panic.rs:359:14 [INFO] [stdout] 62: 0x55c1f0a6e4b2 - std[716c9a7a72e5c14e]::thread::lifecycle::spawn_unchecked::::{closure#1} [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/thread/lifecycle.rs:89:26 [INFO] [stdout] 63: 0x55c1f0a6e4b2 - ::{closure#1} as core[c5ed12ab89cc536a]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0} [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 64: 0x55c1f102d8ff - + core[c5ed12ab89cc536a]::marker::Send> as core[c5ed12ab89cc536a]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/alloc/src/boxed.rs:2206:9 [INFO] [stdout] 65: 0x55c1f102d8ff - ::new::thread_start [INFO] [stdout] at /rustc/2fd6efc32704647e64d3d646d21c4c68eae100e4/library/std/src/sys/thread/unix.rs:119:17 [INFO] [stdout] 66: 0x7d22d331eaa4 - [INFO] [stdout] 67: 0x7d22d33aba64 - clone [INFO] [stdout] 68: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] test_batching_behavior [INFO] [stdout] [INFO] [stdout] test result: FAILED. 10 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.41s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--test base_tests` [INFO] running `Command { std: "docker" "inspect" "16a93e21c45e248f5a6b1c08cc616d3be574f03e1460d47f5b464e95f58a0022", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "16a93e21c45e248f5a6b1c08cc616d3be574f03e1460d47f5b464e95f58a0022", kill_on_drop: false }` [INFO] [stdout] 16a93e21c45e248f5a6b1c08cc616d3be574f03e1460d47f5b464e95f58a0022