[INFO] fetching crate tonari-actor 0.12.1... [INFO] testing tonari-actor-0.12.1 against master#d933cf483edf1605142ac6899ff32536c0ad8b22 for pr-150933 [INFO] extracting crate tonari-actor 0.12.1 into /workspace/builds/worker-3-tc1/source [INFO] removed /workspace/builds/worker-3-tc1/source/.cargo/config.toml [INFO] started tweaking crates.io crate tonari-actor 0.12.1 [INFO] removed 0 missing examples [INFO] finished tweaking crates.io crate tonari-actor 0.12.1 [INFO] tweaked toml for crates.io crate tonari-actor 0.12.1 written to /workspace/builds/worker-3-tc1/source/Cargo.toml [INFO] validating manifest of crates.io crate tonari-actor 0.12.1 on toolchain d933cf483edf1605142ac6899ff32536c0ad8b22 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+d933cf483edf1605142ac6899ff32536c0ad8b22" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate crates.io crate tonari-actor 0.12.1 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" "+d933cf483edf1605142ac6899ff32536c0ad8b22" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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" "+d933cf483edf1605142ac6899ff32536c0ad8b22" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 0f8b31fbabe4f7790986463aca86646a6065f7ca4a2813bb7e9ca9f9268f50d6 [INFO] running `Command { std: "docker" "start" "-a" "0f8b31fbabe4f7790986463aca86646a6065f7ca4a2813bb7e9ca9f9268f50d6", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "0f8b31fbabe4f7790986463aca86646a6065f7ca4a2813bb7e9ca9f9268f50d6", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "0f8b31fbabe4f7790986463aca86646a6065f7ca4a2813bb7e9ca9f9268f50d6", kill_on_drop: false }` [INFO] [stdout] 0f8b31fbabe4f7790986463aca86646a6065f7ca4a2813bb7e9ca9f9268f50d6 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+d933cf483edf1605142ac6899ff32536c0ad8b22" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] a93bf8b0aa24ba2919fb947beac36b8a10603a06f996fcbdd742b6ec6724036d [INFO] running `Command { std: "docker" "start" "-a" "a93bf8b0aa24ba2919fb947beac36b8a10603a06f996fcbdd742b6ec6724036d", kill_on_drop: false }` [INFO] [stderr] Compiling hashbrown v0.14.5 [INFO] [stderr] Compiling log v0.4.28 [INFO] [stderr] Compiling spin v0.9.8 [INFO] [stderr] Compiling flume v0.11.1 [INFO] [stderr] Compiling dashmap v6.1.0 [INFO] [stderr] Compiling tonari-actor v0.12.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 1.63s [INFO] running `Command { std: "docker" "inspect" "a93bf8b0aa24ba2919fb947beac36b8a10603a06f996fcbdd742b6ec6724036d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "a93bf8b0aa24ba2919fb947beac36b8a10603a06f996fcbdd742b6ec6724036d", kill_on_drop: false }` [INFO] [stdout] a93bf8b0aa24ba2919fb947beac36b8a10603a06f996fcbdd742b6ec6724036d [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+d933cf483edf1605142ac6899ff32536c0ad8b22" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] a581c40c09c62b6b886b7cc5d4f6213d37fc0704884a5942284e4fec73a2b092 [INFO] running `Command { std: "docker" "start" "-a" "a581c40c09c62b6b886b7cc5d4f6213d37fc0704884a5942284e4fec73a2b092", kill_on_drop: false }` [INFO] [stderr] Compiling zerocopy v0.8.27 [INFO] [stderr] Compiling regex-automata v0.4.13 [INFO] [stderr] Compiling nix v0.30.1 [INFO] [stderr] Compiling syn v2.0.110 [INFO] [stderr] Compiling parking_lot_core v0.9.12 [INFO] [stderr] Compiling clap_builder v4.5.51 [INFO] [stderr] Compiling serde_json v1.0.145 [INFO] [stderr] Compiling anstyle-query v1.1.4 [INFO] [stderr] Compiling plotters v0.3.7 [INFO] [stderr] Compiling criterion-plot v0.6.0 [INFO] [stderr] Compiling socket2 v0.6.2 [INFO] [stderr] Compiling mio v1.1.0 [INFO] [stderr] Compiling jiff v0.2.16 [INFO] [stderr] Compiling num_cpus v1.17.0 [INFO] [stderr] Compiling anstream v0.6.21 [INFO] [stderr] Compiling parking_lot v0.12.5 [INFO] [stderr] Compiling dashmap v6.1.0 [INFO] [stderr] Compiling tokio v1.49.0 [INFO] [stderr] Compiling tonari-actor v0.12.1 (/opt/rustwide/workdir) [INFO] [stderr] Compiling ctrlc v3.5.1 [INFO] [stderr] Compiling clap v4.5.51 [INFO] [stderr] Compiling regex v1.12.2 [INFO] [stderr] Compiling env_filter v0.1.4 [INFO] [stderr] Compiling zerocopy-derive v0.8.27 [INFO] [stderr] Compiling serde_derive v1.0.228 [INFO] [stderr] Compiling env_logger v0.11.8 [INFO] [stderr] Compiling serde v1.0.228 [INFO] [stderr] Compiling tinytemplate v1.2.1 [INFO] [stderr] Compiling half v2.7.1 [INFO] [stderr] Compiling ciborium-ll v0.2.2 [INFO] [stderr] Compiling ciborium v0.2.2 [INFO] [stderr] Compiling criterion v0.7.0 [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 19.97s [INFO] running `Command { std: "docker" "inspect" "a581c40c09c62b6b886b7cc5d4f6213d37fc0704884a5942284e4fec73a2b092", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "a581c40c09c62b6b886b7cc5d4f6213d37fc0704884a5942284e4fec73a2b092", kill_on_drop: false }` [INFO] [stdout] a581c40c09c62b6b886b7cc5d4f6213d37fc0704884a5942284e4fec73a2b092 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+d933cf483edf1605142ac6899ff32536c0ad8b22" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] d839e8983334f13ede1cb49a914754d9a8c545f2441dbc7f9c566819aab80d09 [INFO] running `Command { std: "docker" "start" "-a" "d839e8983334f13ede1cb49a914754d9a8c545f2441dbc7f9c566819aab80d09", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.25s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/tonari_actor-fbb488fffe665b0c) [INFO] [stdout] [INFO] [stdout] running 8 tests [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] started actor: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z INFO tonari_actor] [hi] thread tests::errors shutting down the actor system. [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] joining 1 actor threads. [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] [0] joining actor thread: TestActor [INFO] [stdout] test tests::errors ... ok [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] stopped actor: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] [0] joined actor thread: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z INFO tonari_actor] [hi] system finished shutting down in 3.90967ms. [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [hi] thread tests::errors called system.shutdown() but the system is already shutting down or stopped. [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [priorities] started actor: tonari_actor::tests::message_priorities::PriorityActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [last cached event] started actor: tonari_actor::tests::last_cached_event::Subscriber [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] started actor: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] started actor: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z INFO tonari_actor] [send_constraints prepare_fn] thread tonari_actor::tests::send_constraints::LocalActor shutting down the actor system. [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [timeouts] started actor: tonari_actor::tests::timeouts::TimeoutActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [timed test] started actor: tonari_actor::timed::tests::TimedTestActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] started actor: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [send_constraints prepare_fn] thread tests::send_constraints called system.shutdown() but the system is already shutting down or stopped. [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [timed test] message received by tonari_actor::timed::tests::TimedTestActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [last cached event] message received by tonari_actor::tests::last_cached_event::Subscriber [INFO] [stderr] [2026-03-07T16:15:58Z INFO tonari_actor] [last cached event] thread tests::last_cached_event shutting down the actor system. [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [last cached event] joining 1 actor threads. [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [last cached event] [0] skipping join of an actor running in-place: tests::last_cached_event [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [send_constraints prepare_fn] joining 1 actor threads. [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] started actor: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [hi] message received by TestActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [priorities] message received by tonari_actor::tests::message_priorities::PriorityActor [INFO] [stderr] [2026-03-07T16:15:58Z INFO tonari_actor] [send_constraints run_and_block] thread tests::send_constraints shutting down the actor system. [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [timed test] message received by tonari_actor::timed::tests::TimedTestActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [timeouts] message received by tonari_actor::tests::timeouts::TimeoutActor [INFO] [stderr] [2026-03-07T16:15:58Z INFO tonari_actor] [last cached event] system finished shutting down in 288.99µs. [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [send_constraints prepare_fn] [0] skipping join of the actor thread currently executing SystemHandle::shutdown(): tonari_actor::tests::send_constraints::LocalActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [hi] message received by TestActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [hi] message received by TestActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [send_constraints run_and_block] joining 1 actor threads. [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [send_constraints run_and_block] [0] skipping join of an actor running in-place: tests::send_constraints [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [last cached event] stopped actor: tonari_actor::tests::last_cached_event::Subscriber [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [last cached event] thread tests::last_cached_event called system.shutdown() but the system is already shutting down or stopped. [INFO] [stderr] [2026-03-07T16:15:58Z INFO tonari_actor] [send_constraints run_and_block] system finished shutting down in 13.3583ms. [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [priorities] message received by tonari_actor::tests::message_priorities::PriorityActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [priorities] message received by tonari_actor::tests::message_priorities::PriorityActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [priorities] message received by tonari_actor::tests::message_priorities::PriorityActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [priorities] message received by tonari_actor::tests::message_priorities::PriorityActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [priorities] message received by tonari_actor::tests::message_priorities::PriorityActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [priorities] message received by tonari_actor::tests::message_priorities::PriorityActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [priorities] message received by tonari_actor::tests::message_priorities::PriorityActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [priorities] message received by tonari_actor::tests::message_priorities::PriorityActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [priorities] message received by tonari_actor::tests::message_priorities::PriorityActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [priorities] message received by tonari_actor::tests::message_priorities::PriorityActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [priorities] message received by tonari_actor::tests::message_priorities::PriorityActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [priorities] message received by tonari_actor::tests::message_priorities::PriorityActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [priorities] message received by tonari_actor::tests::message_priorities::PriorityActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [priorities] message received by tonari_actor::tests::message_priorities::PriorityActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [priorities] message received by tonari_actor::tests::message_priorities::PriorityActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [priorities] message received by tonari_actor::tests::message_priorities::PriorityActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [priorities] message received by tonari_actor::tests::message_priorities::PriorityActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [priorities] message received by tonari_actor::tests::message_priorities::PriorityActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [priorities] message received by tonari_actor::tests::message_priorities::PriorityActor [INFO] [stderr] [2026-03-07T16:15:58Z INFO tonari_actor] [priorities] thread tests::message_priorities shutting down the actor system. [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [priorities] joining 1 actor threads. [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [priorities] [0] skipping join of an actor running in-place: tests::message_priorities [INFO] [stdout] test tests::last_cached_event ... ok [INFO] [stderr] [2026-03-07T16:15:58Z INFO tonari_actor] [priorities] system finished shutting down in 135.23µs. [INFO] [stdout] test tests::message_priorities ... ok [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [priorities] stopped actor: tonari_actor::tests::message_priorities::PriorityActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [priorities] thread tests::message_priorities called system.shutdown() but the system is already shutting down or stopped. [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [hi] message received by TestActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] started actor: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z INFO tonari_actor] [send_constraints prepare_fn] system finished shutting down in 8.30768ms. [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [send_constraints prepare_fn] started actor: tonari_actor::tests::send_constraints::LocalActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [send_constraints prepare_fn] stopped actor: tonari_actor::tests::send_constraints::LocalActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [timeouts] message received by tonari_actor::tests::timeouts::TimeoutActor [INFO] [stdout] test tests::send_constraints ... ok [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [send_constraints run_and_block] started actor: tonari_actor::tests::send_constraints::LocalActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [send_constraints run_and_block] stopped actor: tonari_actor::tests::send_constraints::LocalActor [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [send_constraints run_and_block] thread tests::send_constraints called system.shutdown() but the system is already shutting down or stopped. [INFO] [stderr] [2026-03-07T16:15:58Z INFO tonari_actor] [timeouts] thread tests::timeouts shutting down the actor system. [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [timeouts] joining 1 actor threads. [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [timeouts] stopped actor: tonari_actor::tests::timeouts::TimeoutActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [timeouts] [0] joining actor thread: tonari_actor::tests::timeouts::TimeoutActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [timeouts] [0] joined actor thread: tonari_actor::tests::timeouts::TimeoutActor [INFO] [stderr] [2026-03-07T16:15:58Z INFO tonari_actor] [timeouts] system finished shutting down in 2.69797ms. [INFO] [stdout] test tests::timeouts ... FAILED [INFO] [stderr] [2026-03-07T16:15:58Z INFO tonari_actor] [hi] thread tests::it_works shutting down the actor system. [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] joining 5 actor threads. [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] [4] joining actor thread: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] stopped actor: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] stopped actor: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] stopped actor: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] stopped actor: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z INFO tonari_actor] [hi] thread tests::test_ignore_on_full shutting down the actor system. [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] joining 1 actor threads. [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] [0] joining actor thread: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] [4] joined actor thread: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] [3] joining actor thread: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] [3] joined actor thread: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] [2] joining actor thread: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] stopped actor: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] stopped actor: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] [2] joined actor thread: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] [1] joining actor thread: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] [1] joined actor thread: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] [0] joining actor thread: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] [0] joined actor thread: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z INFO tonari_actor] [hi] system finished shutting down in 7.818849ms. [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [hi] [0] joined actor thread: TestActor [INFO] [stderr] [2026-03-07T16:15:58Z INFO tonari_actor] [hi] system finished shutting down in 7.032839ms. [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [timed test] message received by tonari_actor::timed::tests::TimedTestActor [INFO] [stdout] test tests::test_ignore_on_full ... ok [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [hi] thread tests::test_ignore_on_full called system.shutdown() but the system is already shutting down or stopped. [INFO] [stdout] test tests::it_works ... ok [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [hi] thread tests::it_works called system.shutdown() but the system is already shutting down or stopped. [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [timed test] message received by tonari_actor::timed::tests::TimedTestActor [INFO] [stderr] [2026-03-07T16:15:58Z INFO tonari_actor] [timed test] thread timed::tests::recurring_messages_for_busy_actors shutting down the actor system. [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [timed test] joining 1 actor threads. [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [timed test] [0] joining actor thread: tonari_actor::timed::tests::TimedTestActor [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [timed test] stopped actor: tonari_actor::timed::tests::TimedTestActor [INFO] [stdout] test timed::tests::recurring_messages_for_busy_actors ... ok [INFO] [stderr] [2026-03-07T16:15:58Z DEBUG tonari_actor] [timed test] [0] joined actor thread: tonari_actor::timed::tests::TimedTestActor [INFO] [stdout] [INFO] [stderr] [2026-03-07T16:15:58Z INFO tonari_actor] [timed test] system finished shutting down in 86.751417ms. [INFO] [stdout] failures: [INFO] [stderr] [2026-03-07T16:15:58Z TRACE tonari_actor] [timed test] thread timed::tests::recurring_messages_for_busy_actors called system.shutdown() but the system is already shutting down or stopped. [INFO] [stdout] [INFO] [stdout] ---- tests::timeouts stdout ---- [INFO] [stdout] [INFO] [stdout] thread 'tests::timeouts' (37) panicked at src/lib.rs:1320:9: [INFO] [stdout] assertion `left == right` failed [INFO] [stdout] left: 1 [INFO] [stdout] right: 2 [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5e7e49f3fd8a - std[69d51b4813ba037]::backtrace_rs::backtrace::libunwind::trace [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x5e7e49f3fd8a - std[69d51b4813ba037]::backtrace_rs::backtrace::trace_unsynchronized:: [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x5e7e49f3fd8a - std[69d51b4813ba037]::sys::backtrace::_print_fmt [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/std/src/sys/backtrace.rs:74:9 [INFO] [stdout] 3: 0x5e7e49f3fd8a - <::print::DisplayBacktrace as core[51d4adbef590f61]::fmt::Display>::fmt [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/std/src/sys/backtrace.rs:44:26 [INFO] [stdout] 4: 0x5e7e49f56aaa - ::fmt [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/core/src/fmt/rt.rs:152:76 [INFO] [stdout] 5: 0x5e7e49f56aaa - core[51d4adbef590f61]::fmt::write [INFO] [stdout] 6: 0x5e7e49f45c72 - std[69d51b4813ba037]::io::default_write_fmt::> [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/std/src/io/mod.rs:639:11 [INFO] [stdout] 7: 0x5e7e49f45c72 - as std[69d51b4813ba037]::io::Write>::write_fmt [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/std/src/io/mod.rs:1994:13 [INFO] [stdout] 8: 0x5e7e49f1eb2f - ::print [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/std/src/sys/backtrace.rs:47:9 [INFO] [stdout] 9: 0x5e7e49f1eb2f - std[69d51b4813ba037]::panicking::default_hook::{closure#0} [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/std/src/panicking.rs:292:27 [INFO] [stdout] 10: 0x5e7e49f37f99 - std[69d51b4813ba037]::panicking::default_hook [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/std/src/panicking.rs:316:9 [INFO] [stdout] 11: 0x5e7e49ebe08c - core[51d4adbef590f61]::ops::function::Fn<(&'a std[69d51b4813ba037]::panic::PanicHookInfo<'b>,), Output = ()> + core[51d4adbef590f61]::marker::Sync + core[51d4adbef590f61]::marker::Send> as core[51d4adbef590f61]::ops::function::Fn<(&std[69d51b4813ba037]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/alloc/src/boxed.rs:2254:9 [INFO] [stdout] 12: 0x5e7e49ebe08c - test[8fe65b9e05bf4c74]::test_main_with_exit_callback::::{closure#0} [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/test/src/lib.rs:145:21 [INFO] [stdout] 13: 0x5e7e49f38152 - core[51d4adbef590f61]::ops::function::Fn<(&'a std[69d51b4813ba037]::panic::PanicHookInfo<'b>,), Output = ()> + core[51d4adbef590f61]::marker::Sync + core[51d4adbef590f61]::marker::Send> as core[51d4adbef590f61]::ops::function::Fn<(&std[69d51b4813ba037]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/alloc/src/boxed.rs:2254:9 [INFO] [stdout] 14: 0x5e7e49f38152 - std[69d51b4813ba037]::panicking::panic_with_hook [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/std/src/panicking.rs:833:13 [INFO] [stdout] 15: 0x5e7e49f1ebe8 - std[69d51b4813ba037]::panicking::panic_handler::{closure#0} [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/std/src/panicking.rs:698:13 [INFO] [stdout] 16: 0x5e7e49f16589 - std[69d51b4813ba037]::sys::backtrace::__rust_end_short_backtrace:: [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/std/src/sys/backtrace.rs:182:18 [INFO] [stdout] 17: 0x5e7e49f1f8fd - __rustc[cb16bc19fc993bd7]::rust_begin_unwind [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/std/src/panicking.rs:689:5 [INFO] [stdout] 18: 0x5e7e49f5743c - core[51d4adbef590f61]::panicking::panic_fmt [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/core/src/panicking.rs:80:14 [INFO] [stdout] 19: 0x5e7e49f572c3 - core[51d4adbef590f61]::panicking::assert_failed_inner [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/core/src/panicking.rs:439:17 [INFO] [stdout] 20: 0x5e7e49f13a9a - core[51d4adbef590f61]::panicking::assert_failed:: [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/core/src/panicking.rs:394:5 [INFO] [stdout] 21: 0x5e7e49be6fe0 - tonari_actor[8615e4f720ea8e61]::tests::timeouts [INFO] [stdout] at /opt/rustwide/workdir/src/lib.rs:1320:9 [INFO] [stdout] 22: 0x5e7e49be3b27 - tonari_actor[8615e4f720ea8e61]::tests::timeouts::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/src/lib.rs:1274:18 [INFO] [stdout] 23: 0x5e7e49be31f6 - >::call_once [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 24: 0x5e7e49eb216b - core[51d4adbef590f61]::result::Result<(), alloc[18203fec9a0cd4ec]::string::String> as core[51d4adbef590f61]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 25: 0x5e7e49eb216b - test[8fe65b9e05bf4c74]::__rust_begin_short_backtrace::, fn() -> core[51d4adbef590f61]::result::Result<(), alloc[18203fec9a0cd4ec]::string::String>> [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/test/src/lib.rs:663:18 [INFO] [stdout] 26: 0x5e7e49ebeb5b - test[8fe65b9e05bf4c74]::run_test_in_process::{closure#0} [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/test/src/lib.rs:686:74 [INFO] [stdout] 27: 0x5e7e49ebeb5b - as core[51d4adbef590f61]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/core/src/panic/unwind_safe.rs:274:9 [INFO] [stdout] 28: 0x5e7e49ebeb5b - std[69d51b4813ba037]::panicking::catch_unwind::do_call::, core[51d4adbef590f61]::result::Result<(), alloc[18203fec9a0cd4ec]::string::String>> [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/std/src/panicking.rs:581:40 [INFO] [stdout] 29: 0x5e7e49ebeb5b - std[69d51b4813ba037]::panicking::catch_unwind::, core[51d4adbef590f61]::panic::unwind_safe::AssertUnwindSafe> [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/std/src/panicking.rs:544:19 [INFO] [stdout] 30: 0x5e7e49ebeb5b - std[69d51b4813ba037]::panic::catch_unwind::, core[51d4adbef590f61]::result::Result<(), alloc[18203fec9a0cd4ec]::string::String>> [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/std/src/panic.rs:359:14 [INFO] [stdout] 31: 0x5e7e49ebeb5b - test[8fe65b9e05bf4c74]::run_test_in_process [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/test/src/lib.rs:686:27 [INFO] [stdout] 32: 0x5e7e49ebeb5b - test[8fe65b9e05bf4c74]::run_test::{closure#0} [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/test/src/lib.rs:607:43 [INFO] [stdout] 33: 0x5e7e49eba274 - test[8fe65b9e05bf4c74]::run_test::{closure#1} [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/test/src/lib.rs:637:41 [INFO] [stdout] 34: 0x5e7e49eba274 - std[69d51b4813ba037]::sys::backtrace::__rust_begin_short_backtrace:: [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/std/src/sys/backtrace.rs:166:18 [INFO] [stdout] 35: 0x5e7e49ec1762 - std[69d51b4813ba037]::thread::lifecycle::spawn_unchecked::::{closure#1}::{closure#0} [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/std/src/thread/lifecycle.rs:91:13 [INFO] [stdout] 36: 0x5e7e49ec1762 - ::{closure#1}::{closure#0}> as core[51d4adbef590f61]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/core/src/panic/unwind_safe.rs:274:9 [INFO] [stdout] 37: 0x5e7e49ec1762 - std[69d51b4813ba037]::panicking::catch_unwind::do_call::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/std/src/panicking.rs:581:40 [INFO] [stdout] 38: 0x5e7e49ec1762 - std[69d51b4813ba037]::panicking::catch_unwind::<(), core[51d4adbef590f61]::panic::unwind_safe::AssertUnwindSafe::{closure#1}::{closure#0}>> [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/std/src/panicking.rs:544:19 [INFO] [stdout] 39: 0x5e7e49ec1762 - std[69d51b4813ba037]::panic::catch_unwind::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/std/src/panic.rs:359:14 [INFO] [stdout] 40: 0x5e7e49ec1762 - std[69d51b4813ba037]::thread::lifecycle::spawn_unchecked::::{closure#1} [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/std/src/thread/lifecycle.rs:89:26 [INFO] [stdout] 41: 0x5e7e49ec1762 - ::{closure#1} as core[51d4adbef590f61]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0} [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 42: 0x5e7e49f3f66f - + core[51d4adbef590f61]::marker::Send> as core[51d4adbef590f61]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/alloc/src/boxed.rs:2240:9 [INFO] [stdout] 43: 0x5e7e49f3f66f - ::new::thread_start [INFO] [stdout] at /rustc/d933cf483edf1605142ac6899ff32536c0ad8b22/library/std/src/sys/thread/unix.rs:118:17 [INFO] [stdout] 44: 0x7ece47700aa4 - [INFO] [stdout] 45: 0x7ece4778da64 - clone [INFO] [stdout] 46: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] tests::timeouts [INFO] [stdout] [INFO] [stdout] test result: FAILED. 7 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.32s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--lib` [INFO] running `Command { std: "docker" "inspect" "d839e8983334f13ede1cb49a914754d9a8c545f2441dbc7f9c566819aab80d09", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "d839e8983334f13ede1cb49a914754d9a8c545f2441dbc7f9c566819aab80d09", kill_on_drop: false }` [INFO] [stdout] d839e8983334f13ede1cb49a914754d9a8c545f2441dbc7f9c566819aab80d09