[INFO] fetching crate onlyne-testkit 2.2.0...
[INFO] testing onlyne-testkit-2.2.0 against 1.99.0-beta.8+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate onlyne-testkit 2.2.0 into /workspace/builds/worker-2-tc1/source
[INFO] started tweaking crates.io crate onlyne-testkit 2.2.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate onlyne-testkit 2.2.0
[INFO] tweaked toml for crates.io crate onlyne-testkit 2.2.0 written to /workspace/builds/worker-2-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate onlyne-testkit 2.2.0 on toolchain 1.99.0-beta.8
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate onlyne-testkit 2.2.0 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.99.0-beta.8" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded onlyne-adapter v2.2.0
[INFO] [stderr]   Downloaded onlyne-wire v2.2.0
[INFO] [stderr]   Downloaded onlyne-config v2.2.0
[INFO] [stderr]   Downloaded onlyne-proto v2.2.0
[INFO] [stderr]   Downloaded interprocess v2.4.4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 7af7e8059ecde1341fb33446b0f1454d7713e136faa7c8d6a6581176ec39e67d
[INFO] running `Command { std: "docker" "start" "7af7e8059ecde1341fb33446b0f1454d7713e136faa7c8d6a6581176ec39e67d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "7af7e8059ecde1341fb33446b0f1454d7713e136faa7c8d6a6581176ec39e67d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "7af7e8059ecde1341fb33446b0f1454d7713e136faa7c8d6a6581176ec39e67d" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "7af7e8059ecde1341fb33446b0f1454d7713e136faa7c8d6a6581176ec39e67d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "7af7e8059ecde1341fb33446b0f1454d7713e136faa7c8d6a6581176ec39e67d" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.186
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]    Compiling tokio-macros v2.7.0
[INFO] [stderr]    Compiling serde_json v1.0.150
[INFO] [stderr]    Compiling serde_derive_internals v0.29.1
[INFO] [stderr]    Compiling schemars v0.8.22
[INFO] [stderr]    Compiling sha2 v0.10.9
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling doctest-file v1.1.1
[INFO] [stderr]    Compiling onlyne-proto v2.2.0
[INFO] [stderr]    Compiling winnow v0.7.15
[INFO] [stderr]    Compiling toml_write v0.1.2
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling async-stream-impl v0.3.6
[INFO] [stderr]    Compiling futures-macro v0.3.32
[INFO] [stderr]    Compiling schemars_derive v0.8.22
[INFO] [stderr]    Compiling log v0.4.32
[INFO] [stderr]    Compiling bitflags v2.13.0
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling mio v1.2.1
[INFO] [stderr]    Compiling socket2 v0.6.4
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling uuid v1.23.3
[INFO] [stderr]    Compiling tokio v1.52.3
[INFO] [stderr]    Compiling onlyne-config v2.2.0
[INFO] [stderr]    Compiling clap_builder v4.6.0
[INFO] [stderr]    Compiling futures-util v0.3.32
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling clap_derive v4.6.1
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling anyhow v1.0.102
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling async-stream v0.3.6
[INFO] [stderr]    Compiling smallvec v1.15.2
[INFO] [stderr]    Compiling fastrand v2.4.1
[INFO] [stderr]    Compiling chrono v0.4.45
[INFO] [stderr]    Compiling toml_datetime v0.6.11
[INFO] [stderr]    Compiling serde_spanned v0.6.9
[INFO] [stderr]    Compiling toml_edit v0.22.27
[INFO] [stderr]    Compiling tracing-subscriber v0.3.23
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling clap v4.6.1
[INFO] [stderr]    Compiling toml v0.8.23
[INFO] [stderr]    Compiling interprocess v2.4.4
[INFO] [stderr]    Compiling onlyne-wire v2.2.0
[INFO] [stderr]    Compiling tokio-stream v0.1.18
[INFO] [stderr]    Compiling onlyne-adapter v2.2.0
[INFO] [stderr]    Compiling onlyne-testkit v2.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 3m 51s
[INFO] running `Command { std: "docker" "inspect" "7af7e8059ecde1341fb33446b0f1454d7713e136faa7c8d6a6581176ec39e67d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "7af7e8059ecde1341fb33446b0f1454d7713e136faa7c8d6a6581176ec39e67d" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling onlyne-testkit v2.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 52.78s
[INFO] running `Command { std: "docker" "inspect" "7af7e8059ecde1341fb33446b0f1454d7713e136faa7c8d6a6581176ec39e67d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-w" "/opt/rustwide/workdir" "--user" "0:0" "7af7e8059ecde1341fb33446b0f1454d7713e136faa7c8d6a6581176ec39e67d" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.21s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/deps/onlyne_testkit-ff1079641754e74b)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/bin/onlyne-agent-fake.rs (/opt/rustwide/target/release/deps/onlyne_agent_fake-6af91912441430ff)
[INFO] [stderr]      Running unittests src/bin/onlyne-gateway-fake.rs (/opt/rustwide/target/release/deps/onlyne_gateway_fake-7c603010970a4374)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/conformance.rs (/opt/rustwide/target/release/deps/conformance-d8ec8bac0904e41c)
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test missing_report_records_idle_fault ... ok
[INFO] [stdout] test frame_before_hello_is_rejected_and_connection_closes ... ok
[INFO] [stdout] test duplicate_send_returns_original_receipt_unchanged ... ok
[INFO] [stdout] test fake_agent_over_hostsim_completes_scripted_task ... ok
[INFO] [stdout] test dropped_assign_reconnect_redelivers_same_op_id_with_original_receipt ... ok
[INFO] [stdout] test stale_generation_is_conflict_and_watermark_is_unchanged ... ok
[INFO] [stdout] test missing_recycle_uses_probe_resource_loss_path ... ok
[INFO] [stdout] test empty_body_is_rejected_naming_body ... ok
[INFO] [stdout] test platform_payload_stays_on_gateway_side ... ok
[INFO] [stdout] test oversized_image_is_rejected_with_wire_field ... ok
[INFO] [stderr]      Running tests/scenarios.rs (/opt/rustwide/target/release/deps/scenarios-cffbff2d7ae9fd31)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 21 tests
[INFO] [stdout] test scenario_01_delivery_loop ... FAILED
[INFO] [stdout] test scenario_05_disconnect_recovery ... FAILED
[INFO] [stdout] test scenario_07_large_frames_interleaved ... FAILED
[INFO] [stdout] test scenario_11_federation ... ignored, needs a two-server harness; the case runs in e2e/two-cluster.sh
[INFO] [stdout] test scenario_02_handoff_chain ... FAILED
[INFO] [stdout] test scenario_04_idempotency ... FAILED
[INFO] [stdout] test scenario_06_server_restart ... FAILED
[INFO] [stdout] test scenario_03_acl_denial ... FAILED
[INFO] [stdout] test scenario_08_legacy_layout_refusal ... FAILED
[INFO] [stdout] test scenario_15_role_scope_pools_up_to_max_sessions ... FAILED
[INFO] [stdout] test scenario_17_no_resume_capability_keeps_the_process_and_the_session ... FAILED
[INFO] [stdout] test scenario_10_plugin_conformance ... FAILED
[INFO] [stdout] test scenario_12_generate_relocate ... FAILED
[INFO] [stdout] test scenario_09_heartbeat_watch ... FAILED
[INFO] [stdout] test scenario_13_oneshot_gives_each_delivery_its_own_session ... FAILED
[INFO] [stdout] test scenario_14_task_scope_keeps_a_family_in_one_session ... FAILED
[INFO] [stdout] test scenario_18_a_last_seen_only_heartbeat_writes_no_updated_at_and_no_event ... FAILED
[INFO] [stdout] test scenario_19_a_standing_runtime_serves_every_session_from_one_connection ... FAILED
[INFO] [stdout] test scenario_21_a_completion_behind_a_verdict_is_answered_with_it ... FAILED
[INFO] [stdout] test scenario_20_reach_is_permission_and_the_obligation_is_declared ... FAILED
[INFO] [stdout] test scenario_16_suspend_frees_the_slot_and_the_family_resumes_it ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- scenario_01_delivery_loop stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'scenario_01_delivery_loop' (1441) panicked at tests/scenarios.rs:37:46:
[INFO] [stdout] start cluster: workspace root not found
[INFO] [stdout] 
[INFO] [stdout] Stack backtrace:
[INFO] [stdout]    0: <anyhow::Error>::msg::<&str>
[INFO] [stdout]    1: <onlyne_testkit::harness::Cluster>::repo_root
[INFO] [stdout]    2: <onlyne_testkit::harness::Cluster>::bin_path
[INFO] [stdout]    3: <onlyne_testkit::harness::Cluster>::start::{closure#0}
[INFO] [stdout]    4: scenarios::scenario_01_delivery_loop::{closure#0}
[INFO] [stdout]    5: <tokio::runtime::scheduler::current_thread::Context>::enter::<core::task::poll::Poll<()>, <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]    6: <tokio::runtime::context::scoped::Scoped<tokio::runtime::scheduler::Context>>::set::<<tokio::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}, core::option::Option<()>>::{closure#0}, (alloc::boxed::Box<tokio::runtime::scheduler::current_thread::Core>, core::option::Option<()>)>
[INFO] [stdout]    7: <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on::<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>
[INFO] [stdout]    8: tokio::runtime::context::runtime::enter_runtime::<<tokio::runtime::scheduler::current_thread::CurrentThread>::block_on<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]    9: <tokio::runtime::runtime::Runtime>::block_on::<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>
[INFO] [stdout]   10: <scenarios::scenario_01_delivery_loop::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   11: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stdout]   12: test::run_test::{closure#0}
[INFO] [stdout]   13: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stdout]   14: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   15: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   16: <unknown>
[INFO] [stdout]   17: clone
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d81e6952591 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5d81e696a63a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5d81e6957aac - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5d81e69297c6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5d81e6947db9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5d81e67fb430 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5d81e69480e2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5d81e6929872 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5d81e6921c09 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5d81e692a91d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5d81e696ae1c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5d81e696abf2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5d81e673370a - scenarios[88a3bfada67b4cf9]::scenario_01_delivery_loop::{closure#0}
[INFO] [stdout]   13:     0x5d81e67d6c33 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Context>::enter::<core[df12db4294e9bfd3]::task::poll::Poll<()>, <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   14:     0x5d81e67c725c - <tokio[b93e2003b00ac85]::runtime::context::scoped::Scoped<tokio[b93e2003b00ac85]::runtime::scheduler::Context>>::set::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}, core[df12db4294e9bfd3]::option::Option<()>>::{closure#0}, (alloc[2182bb758b4b3781]::boxed::Box<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Core>, core[df12db4294e9bfd3]::option::Option<()>)>
[INFO] [stdout]   15:     0x5d81e67d7387 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   16:     0x5d81e67c93ed - tokio[b93e2003b00ac85]::runtime::context::runtime::enter_runtime::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   17:     0x5d81e67d6755 - <tokio[b93e2003b00ac85]::runtime::runtime::Runtime>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>
[INFO] [stdout]   18:     0x5d81e677a9ee - <scenarios[88a3bfada67b4cf9]::scenario_01_delivery_loop::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   19:     0x5d81e67ee71b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   20:     0x5d81e67fbd85 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   21:     0x5d81e67f5644 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   22:     0x5d81e67feee2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   23:     0x5d81e6951179 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   24:     0x7fd569e29dfa - <unknown>
[INFO] [stdout]   25:     0x7fd569ebd3d4 - clone
[INFO] [stdout]   26:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- scenario_05_disconnect_recovery stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'scenario_05_disconnect_recovery' (1445) panicked at tests/scenarios.rs:636:46:
[INFO] [stdout] start cluster: workspace root not found
[INFO] [stdout] 
[INFO] [stdout] Stack backtrace:
[INFO] [stdout]    0: <anyhow::Error>::msg::<&str>
[INFO] [stdout]    1: <onlyne_testkit::harness::Cluster>::repo_root
[INFO] [stdout]    2: <onlyne_testkit::harness::Cluster>::bin_path
[INFO] [stdout]    3: <onlyne_testkit::harness::Cluster>::start::{closure#0}
[INFO] [stdout]    4: scenarios::scenario_05_disconnect_recovery::{closure#0}
[INFO] [stdout]    5: <tokio::runtime::scheduler::current_thread::Context>::enter::<core::task::poll::Poll<()>, <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]    6: <tokio::runtime::context::scoped::Scoped<tokio::runtime::scheduler::Context>>::set::<<tokio::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}, core::option::Option<()>>::{closure#0}, (alloc::boxed::Box<tokio::runtime::scheduler::current_thread::Core>, core::option::Option<()>)>
[INFO] [stdout]    7: <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on::<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>
[INFO] [stdout]    8: tokio::runtime::context::runtime::enter_runtime::<<tokio::runtime::scheduler::current_thread::CurrentThread>::block_on<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]    9: <tokio::runtime::runtime::Runtime>::block_on::<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>
[INFO] [stdout]   10: <scenarios::scenario_05_disconnect_recovery::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   11: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stdout]   12: test::run_test::{closure#0}
[INFO] [stdout]   13: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stdout]   14: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   15: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   16: <unknown>
[INFO] [stdout]   17: clone
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d81e6952591 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5d81e696a63a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5d81e6957aac - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5d81e69297c6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5d81e6947db9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5d81e67fb430 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5d81e69480e2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5d81e6929872 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5d81e6921c09 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5d81e692a91d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5d81e696ae1c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5d81e696abf2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5d81e67468d8 - scenarios[88a3bfada67b4cf9]::scenario_05_disconnect_recovery::{closure#0}
[INFO] [stdout]   13:     0x5d81e67d6c33 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Context>::enter::<core[df12db4294e9bfd3]::task::poll::Poll<()>, <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   14:     0x5d81e67c725c - <tokio[b93e2003b00ac85]::runtime::context::scoped::Scoped<tokio[b93e2003b00ac85]::runtime::scheduler::Context>>::set::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}, core[df12db4294e9bfd3]::option::Option<()>>::{closure#0}, (alloc[2182bb758b4b3781]::boxed::Box<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Core>, core[df12db4294e9bfd3]::option::Option<()>)>
[INFO] [stdout]   15:     0x5d81e67d7387 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   16:     0x5d81e67c93ed - tokio[b93e2003b00ac85]::runtime::context::runtime::enter_runtime::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   17:     0x5d81e67d6755 - <tokio[b93e2003b00ac85]::runtime::runtime::Runtime>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>
[INFO] [stdout]   18:     0x5d81e677b22e - <scenarios[88a3bfada67b4cf9]::scenario_05_disconnect_recovery::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   19:     0x5d81e67ee71b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   20:     0x5d81e67fbd85 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   21:     0x5d81e67f5644 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   22:     0x5d81e67feee2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   23:     0x5d81e6951179 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   24:     0x7fd569e29dfa - <unknown>
[INFO] [stdout]   25:     0x7fd569ebd3d4 - clone
[INFO] [stdout]   26:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- scenario_07_large_frames_interleaved stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'scenario_07_large_frames_interleaved' (1447) panicked at tests/scenarios.rs:1032:46:
[INFO] [stdout] start cluster: workspace root not found
[INFO] [stdout] 
[INFO] [stdout] Stack backtrace:
[INFO] [stdout]    0: <anyhow::Error>::msg::<&str>
[INFO] [stdout]    1: <onlyne_testkit::harness::Cluster>::repo_root
[INFO] [stdout]    2: <onlyne_testkit::harness::Cluster>::bin_path
[INFO] [stdout]    3: <onlyne_testkit::harness::Cluster>::start::{closure#0}
[INFO] [stdout]    4: scenarios::scenario_07_large_frames_interleaved::{closure#0}
[INFO] [stdout]    5: <tokio::runtime::scheduler::current_thread::Context>::enter::<core::task::poll::Poll<()>, <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]    6: <tokio::runtime::context::scoped::Scoped<tokio::runtime::scheduler::Context>>::set::<<tokio::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}, core::option::Option<()>>::{closure#0}, (alloc::boxed::Box<tokio::runtime::scheduler::current_thread::Core>, core::option::Option<()>)>
[INFO] [stdout]    7: <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on::<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>
[INFO] [stdout]    8: tokio::runtime::context::runtime::enter_runtime::<<tokio::runtime::scheduler::current_thread::CurrentThread>::block_on<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]    9: <tokio::runtime::runtime::Runtime>::block_on::<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>
[INFO] [stdout]   10: <scenarios::scenario_07_large_frames_interleaved::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   11: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stdout]   12: test::run_test::{closure#0}
[INFO] [stdout]   13: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stdout]   14: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   15: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   16: <unknown>
[INFO] [stdout]   17: clone
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d81e6952591 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5d81e696a63a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5d81e6957aac - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5d81e69297c6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5d81e6947db9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5d81e67fb430 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5d81e69480e2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5d81e6929872 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5d81e6921c09 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5d81e692a91d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5d81e696ae1c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5d81e696abf2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5d81e674ae7d - scenarios[88a3bfada67b4cf9]::scenario_07_large_frames_interleaved::{closure#0}
[INFO] [stdout]   13:     0x5d81e67d6c33 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Context>::enter::<core[df12db4294e9bfd3]::task::poll::Poll<()>, <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   14:     0x5d81e67c725c - <tokio[b93e2003b00ac85]::runtime::context::scoped::Scoped<tokio[b93e2003b00ac85]::runtime::scheduler::Context>>::set::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}, core[df12db4294e9bfd3]::option::Option<()>>::{closure#0}, (alloc[2182bb758b4b3781]::boxed::Box<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Core>, core[df12db4294e9bfd3]::option::Option<()>)>
[INFO] [stdout]   15:     0x5d81e67d7387 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   16:     0x5d81e67c93ed - tokio[b93e2003b00ac85]::runtime::context::runtime::enter_runtime::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   17:     0x5d81e67d6755 - <tokio[b93e2003b00ac85]::runtime::runtime::Runtime>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>
[INFO] [stdout]   18:     0x5d81e677b4ee - <scenarios[88a3bfada67b4cf9]::scenario_07_large_frames_interleaved::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   19:     0x5d81e67ee71b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   20:     0x5d81e67fbd85 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   21:     0x5d81e67f5644 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   22:     0x5d81e67feee2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   23:     0x5d81e6951179 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   24:     0x7fd569e29dfa - <unknown>
[INFO] [stdout]   25:     0x7fd569ebd3d4 - clone
[INFO] [stdout]   26:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- scenario_02_handoff_chain stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'scenario_02_handoff_chain' (1442) panicked at tests/scenarios.rs:172:46:
[INFO] [stdout] cluster start: workspace root not found
[INFO] [stdout] 
[INFO] [stdout] Stack backtrace:
[INFO] [stdout]    0: <anyhow::Error>::msg::<&str>
[INFO] [stdout]    1: <onlyne_testkit::harness::Cluster>::repo_root
[INFO] [stdout]    2: <onlyne_testkit::harness::Cluster>::bin_path
[INFO] [stdout]    3: <onlyne_testkit::harness::Cluster>::start::{closure#0}
[INFO] [stdout]    4: scenarios::scenario_02_handoff_chain::{closure#0}
[INFO] [stdout]    5: <tokio::runtime::scheduler::current_thread::Context>::enter::<core::task::poll::Poll<()>, <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]    6: <tokio::runtime::context::scoped::Scoped<tokio::runtime::scheduler::Context>>::set::<<tokio::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}, core::option::Option<()>>::{closure#0}, (alloc::boxed::Box<tokio::runtime::scheduler::current_thread::Core>, core::option::Option<()>)>
[INFO] [stdout]    7: <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on::<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>
[INFO] [stdout]    8: tokio::runtime::context::runtime::enter_runtime::<<tokio::runtime::scheduler::current_thread::CurrentThread>::block_on<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]    9: <tokio::runtime::runtime::Runtime>::block_on::<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>
[INFO] [stdout]   10: <scenarios::scenario_02_handoff_chain::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   11: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stdout]   12: test::run_test::{closure#0}
[INFO] [stdout]   13: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stdout]   14: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   15: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   16: <unknown>
[INFO] [stdout]   17: clone
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d81e6952591 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5d81e696a63a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5d81e6957aac - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5d81e69297c6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5d81e6947db9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5d81e67fb430 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5d81e69480e2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5d81e6929872 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5d81e6921c09 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5d81e692a91d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5d81e696ae1c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5d81e696abf2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5d81e6736839 - scenarios[88a3bfada67b4cf9]::scenario_02_handoff_chain::{closure#0}
[INFO] [stdout]   13:     0x5d81e67d6c33 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Context>::enter::<core[df12db4294e9bfd3]::task::poll::Poll<()>, <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   14:     0x5d81e67c725c - <tokio[b93e2003b00ac85]::runtime::context::scoped::Scoped<tokio[b93e2003b00ac85]::runtime::scheduler::Context>>::set::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}, core[df12db4294e9bfd3]::option::Option<()>>::{closure#0}, (alloc[2182bb758b4b3781]::boxed::Box<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Core>, core[df12db4294e9bfd3]::option::Option<()>)>
[INFO] [stdout]   15:     0x5d81e67d7387 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   16:     0x5d81e67c93ed - tokio[b93e2003b00ac85]::runtime::context::runtime::enter_runtime::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   17:     0x5d81e67d6755 - <tokio[b93e2003b00ac85]::runtime::runtime::Runtime>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>
[INFO] [stdout]   18:     0x5d81e677ab4e - <scenarios[88a3bfada67b4cf9]::scenario_02_handoff_chain::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   19:     0x5d81e67ee71b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   20:     0x5d81e67fbd85 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   21:     0x5d81e67f5644 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   22:     0x5d81e67feee2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   23:     0x5d81e6951179 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   24:     0x7fd569e29dfa - <unknown>
[INFO] [stdout]   25:     0x7fd569ebd3d4 - clone
[INFO] [stdout]   26:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- scenario_04_idempotency stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'scenario_04_idempotency' (1444) panicked at tests/scenarios.rs:496:46:
[INFO] [stdout] start cluster: workspace root not found
[INFO] [stdout] 
[INFO] [stdout] Stack backtrace:
[INFO] [stdout]    0: <anyhow::Error>::msg::<&str>
[INFO] [stdout]    1: <onlyne_testkit::harness::Cluster>::repo_root
[INFO] [stdout]    2: <onlyne_testkit::harness::Cluster>::bin_path
[INFO] [stdout]    3: <onlyne_testkit::harness::Cluster>::start::{closure#0}
[INFO] [stdout]    4: scenarios::scenario_04_idempotency::{closure#0}
[INFO] [stdout]    5: <tokio::runtime::scheduler::current_thread::Context>::enter::<core::task::poll::Poll<()>, <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]    6: <tokio::runtime::context::scoped::Scoped<tokio::runtime::scheduler::Context>>::set::<<tokio::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}, core::option::Option<()>>::{closure#0}, (alloc::boxed::Box<tokio::runtime::scheduler::current_thread::Core>, core::option::Option<()>)>
[INFO] [stdout]    7: <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on::<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>
[INFO] [stdout]    8: tokio::runtime::context::runtime::enter_runtime::<<tokio::runtime::scheduler::current_thread::CurrentThread>::block_on<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]    9: <tokio::runtime::runtime::Runtime>::block_on::<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>
[INFO] [stdout]   10: <scenarios::scenario_04_idempotency::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   11: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stdout]   12: test::run_test::{closure#0}
[INFO] [stdout]   13: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stdout]   14: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   15: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   16: <unknown>
[INFO] [stdout]   17: clone
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d81e6952591 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5d81e696a63a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5d81e6957aac - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5d81e69297c6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5d81e6947db9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5d81e67fb430 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5d81e69480e2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5d81e6929872 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5d81e6921c09 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5d81e692a91d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5d81e696ae1c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5d81e696abf2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5d81e6731dee - scenarios[88a3bfada67b4cf9]::scenario_04_idempotency::{closure#0}
[INFO] [stdout]   13:     0x5d81e67d6c33 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Context>::enter::<core[df12db4294e9bfd3]::task::poll::Poll<()>, <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   14:     0x5d81e67c725c - <tokio[b93e2003b00ac85]::runtime::context::scoped::Scoped<tokio[b93e2003b00ac85]::runtime::scheduler::Context>>::set::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}, core[df12db4294e9bfd3]::option::Option<()>>::{closure#0}, (alloc[2182bb758b4b3781]::boxed::Box<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Core>, core[df12db4294e9bfd3]::option::Option<()>)>
[INFO] [stdout]   15:     0x5d81e67d7387 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   16:     0x5d81e67c93ed - tokio[b93e2003b00ac85]::runtime::context::runtime::enter_runtime::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   17:     0x5d81e67d6755 - <tokio[b93e2003b00ac85]::runtime::runtime::Runtime>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>
[INFO] [stdout]   18:     0x5d81e677a89d - <scenarios[88a3bfada67b4cf9]::scenario_04_idempotency::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   19:     0x5d81e67ee71b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   20:     0x5d81e67fbd85 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   21:     0x5d81e67f5644 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   22:     0x5d81e67feee2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   23:     0x5d81e6951179 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   24:     0x7fd569e29dfa - <unknown>
[INFO] [stdout]   25:     0x7fd569ebd3d4 - clone
[INFO] [stdout]   26:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- scenario_06_server_restart stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'scenario_06_server_restart' (1446) panicked at tests/scenarios.rs:843:46:
[INFO] [stdout] start cluster: workspace root not found
[INFO] [stdout] 
[INFO] [stdout] Stack backtrace:
[INFO] [stdout]    0: <anyhow::Error>::msg::<&str>
[INFO] [stdout]    1: <onlyne_testkit::harness::Cluster>::repo_root
[INFO] [stdout]    2: <onlyne_testkit::harness::Cluster>::bin_path
[INFO] [stdout]    3: <onlyne_testkit::harness::Cluster>::start::{closure#0}
[INFO] [stdout]    4: scenarios::scenario_06_server_restart::{closure#0}
[INFO] [stdout]    5: <tokio::runtime::scheduler::current_thread::Context>::enter::<core::task::poll::Poll<()>, <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]    6: <tokio::runtime::context::scoped::Scoped<tokio::runtime::scheduler::Context>>::set::<<tokio::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}, core::option::Option<()>>::{closure#0}, (alloc::boxed::Box<tokio::runtime::scheduler::current_thread::Core>, core::option::Option<()>)>
[INFO] [stdout]    7: <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on::<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>
[INFO] [stdout]    8: tokio::runtime::context::runtime::enter_runtime::<<tokio::runtime::scheduler::current_thread::CurrentThread>::block_on<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]    9: <tokio::runtime::runtime::Runtime>::block_on::<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>
[INFO] [stdout]   10: <scenarios::scenario_06_server_restart::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   11: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stdout]   12: test::run_test::{closure#0}
[INFO] [stdout]   13: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stdout]   14: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   15: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   16: <unknown>
[INFO] [stdout]   17: clone
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d81e6952591 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5d81e696a63a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5d81e6957aac - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5d81e69297c6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5d81e6947db9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5d81e67fb430 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5d81e69480e2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5d81e6929872 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5d81e6921c09 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5d81e692a91d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5d81e696ae1c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5d81e696abf2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5d81e6739e8c - scenarios[88a3bfada67b4cf9]::scenario_06_server_restart::{closure#0}
[INFO] [stdout]   13:     0x5d81e67d6c33 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Context>::enter::<core[df12db4294e9bfd3]::task::poll::Poll<()>, <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   14:     0x5d81e67c725c - <tokio[b93e2003b00ac85]::runtime::context::scoped::Scoped<tokio[b93e2003b00ac85]::runtime::scheduler::Context>>::set::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}, core[df12db4294e9bfd3]::option::Option<()>>::{closure#0}, (alloc[2182bb758b4b3781]::boxed::Box<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Core>, core[df12db4294e9bfd3]::option::Option<()>)>
[INFO] [stdout]   15:     0x5d81e67d7387 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   16:     0x5d81e67c93ed - tokio[b93e2003b00ac85]::runtime::context::runtime::enter_runtime::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   17:     0x5d81e67d6755 - <tokio[b93e2003b00ac85]::runtime::runtime::Runtime>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>
[INFO] [stdout]   18:     0x5d81e677acae - <scenarios[88a3bfada67b4cf9]::scenario_06_server_restart::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   19:     0x5d81e67ee71b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   20:     0x5d81e67fbd85 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   21:     0x5d81e67f5644 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   22:     0x5d81e67feee2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   23:     0x5d81e6951179 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   24:     0x7fd569e29dfa - <unknown>
[INFO] [stdout]   25:     0x7fd569ebd3d4 - clone
[INFO] [stdout]   26:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- scenario_03_acl_denial stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'scenario_03_acl_denial' (1443) panicked at tests/scenarios.rs:392:46:
[INFO] [stdout] cluster start: workspace root not found
[INFO] [stdout] 
[INFO] [stdout] Stack backtrace:
[INFO] [stdout]    0: <anyhow::Error>::msg::<&str>
[INFO] [stdout]    1: <onlyne_testkit::harness::Cluster>::repo_root
[INFO] [stdout]    2: <onlyne_testkit::harness::Cluster>::bin_path
[INFO] [stdout]    3: <onlyne_testkit::harness::Cluster>::start::{closure#0}
[INFO] [stdout]    4: scenarios::scenario_03_acl_denial::{closure#0}
[INFO] [stdout]    5: <tokio::runtime::scheduler::current_thread::Context>::enter::<core::task::poll::Poll<()>, <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]    6: <tokio::runtime::context::scoped::Scoped<tokio::runtime::scheduler::Context>>::set::<<tokio::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}, core::option::Option<()>>::{closure#0}, (alloc::boxed::Box<tokio::runtime::scheduler::current_thread::Core>, core::option::Option<()>)>
[INFO] [stdout]    7: <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on::<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>
[INFO] [stdout]    8: tokio::runtime::context::runtime::enter_runtime::<<tokio::runtime::scheduler::current_thread::CurrentThread>::block_on<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]    9: <tokio::runtime::runtime::Runtime>::block_on::<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>
[INFO] [stdout]   10: <scenarios::scenario_03_acl_denial::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   11: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stdout]   12: test::run_test::{closure#0}
[INFO] [stdout]   13: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stdout]   14: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   15: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   16: <unknown>
[INFO] [stdout]   17: clone
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d81e6952591 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5d81e696a63a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5d81e6957aac - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5d81e69297c6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5d81e6947db9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5d81e67fb430 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5d81e69480e2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5d81e6929872 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5d81e6921c09 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5d81e692a91d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5d81e696ae1c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5d81e696abf2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5d81e673020d - scenarios[88a3bfada67b4cf9]::scenario_03_acl_denial::{closure#0}
[INFO] [stdout]   13:     0x5d81e67d6c33 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Context>::enter::<core[df12db4294e9bfd3]::task::poll::Poll<()>, <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   14:     0x5d81e67c725c - <tokio[b93e2003b00ac85]::runtime::context::scoped::Scoped<tokio[b93e2003b00ac85]::runtime::scheduler::Context>>::set::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}, core[df12db4294e9bfd3]::option::Option<()>>::{closure#0}, (alloc[2182bb758b4b3781]::boxed::Box<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Core>, core[df12db4294e9bfd3]::option::Option<()>)>
[INFO] [stdout]   15:     0x5d81e67d7387 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   16:     0x5d81e67c93ed - tokio[b93e2003b00ac85]::runtime::context::runtime::enter_runtime::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   17:     0x5d81e67d6755 - <tokio[b93e2003b00ac85]::runtime::runtime::Runtime>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>
[INFO] [stdout]   18:     0x5d81e677a5ee - <scenarios[88a3bfada67b4cf9]::scenario_03_acl_denial::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   19:     0x5d81e67ee71b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   20:     0x5d81e67fbd85 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   21:     0x5d81e67f5644 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   22:     0x5d81e67feee2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   23:     0x5d81e6951179 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   24:     0x7fd569e29dfa - <unknown>
[INFO] [stdout]   25:     0x7fd569ebd3d4 - clone
[INFO] [stdout]   26:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- scenario_08_legacy_layout_refusal stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'scenario_08_legacy_layout_refusal' (1448) panicked at tests/scenarios.rs:1196:57:
[INFO] [stdout] resolve onlyne-client: workspace root not found
[INFO] [stdout] 
[INFO] [stdout] Stack backtrace:
[INFO] [stdout]    0: <anyhow::Error>::msg::<&str>
[INFO] [stdout]    1: <onlyne_testkit::harness::Cluster>::repo_root
[INFO] [stdout]    2: <onlyne_testkit::harness::Cluster>::bin_path
[INFO] [stdout]    3: scenarios::scenario_08_legacy_layout_refusal::{closure#0}
[INFO] [stdout]    4: <tokio::runtime::scheduler::current_thread::Context>::enter::<core::task::poll::Poll<()>, <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]    5: <tokio::runtime::context::scoped::Scoped<tokio::runtime::scheduler::Context>>::set::<<tokio::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}, core::option::Option<()>>::{closure#0}, (alloc::boxed::Box<tokio::runtime::scheduler::current_thread::Core>, core::option::Option<()>)>
[INFO] [stdout]    6: <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on::<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>
[INFO] [stdout]    7: tokio::runtime::context::runtime::enter_runtime::<<tokio::runtime::scheduler::current_thread::CurrentThread>::block_on<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]    8: <tokio::runtime::runtime::Runtime>::block_on::<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>
[INFO] [stdout]    9: <scenarios::scenario_08_legacy_layout_refusal::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   10: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stdout]   11: test::run_test::{closure#0}
[INFO] [stdout]   12: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stdout]   13: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   14: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   15: <unknown>
[INFO] [stdout]   16: clone
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d81e6952591 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5d81e696a63a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5d81e6957aac - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5d81e69297c6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5d81e6947db9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5d81e67fb430 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5d81e69480e2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5d81e6929872 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5d81e6921c09 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5d81e692a91d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5d81e696ae1c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5d81e696abf2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5d81e6749938 - scenarios[88a3bfada67b4cf9]::scenario_08_legacy_layout_refusal::{closure#0}
[INFO] [stdout]   13:     0x5d81e67d6c33 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Context>::enter::<core[df12db4294e9bfd3]::task::poll::Poll<()>, <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   14:     0x5d81e67c725c - <tokio[b93e2003b00ac85]::runtime::context::scoped::Scoped<tokio[b93e2003b00ac85]::runtime::scheduler::Context>>::set::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}, core[df12db4294e9bfd3]::option::Option<()>>::{closure#0}, (alloc[2182bb758b4b3781]::boxed::Box<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Core>, core[df12db4294e9bfd3]::option::Option<()>)>
[INFO] [stdout]   15:     0x5d81e67d7387 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   16:     0x5d81e67c93ed - tokio[b93e2003b00ac85]::runtime::context::runtime::enter_runtime::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   17:     0x5d81e67d6755 - <tokio[b93e2003b00ac85]::runtime::runtime::Runtime>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>
[INFO] [stdout]   18:     0x5d81e677b38e - <scenarios[88a3bfada67b4cf9]::scenario_08_legacy_layout_refusal::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   19:     0x5d81e67ee71b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   20:     0x5d81e67fbd85 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   21:     0x5d81e67f5644 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   22:     0x5d81e67feee2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   23:     0x5d81e6951179 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   24:     0x7fd569e29dfa - <unknown>
[INFO] [stdout]   25:     0x7fd569ebd3d4 - clone
[INFO] [stdout]   26:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- scenario_15_role_scope_pools_up_to_max_sessions stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'scenario_15_role_scope_pools_up_to_max_sessions' (1455) panicked at tests/scenarios.rs:1918:6:
[INFO] [stdout] start cluster: workspace root not found
[INFO] [stdout] 
[INFO] [stdout] Stack backtrace:
[INFO] [stdout]    0: <anyhow::Error>::msg::<&str>
[INFO] [stdout]    1: <onlyne_testkit::harness::Cluster>::repo_root
[INFO] [stdout]    2: <onlyne_testkit::harness::Cluster>::bin_path
[INFO] [stdout]    3: <onlyne_testkit::harness::Cluster>::start::{closure#0}
[INFO] [stdout]    4: scenarios::scenario_15_role_scope_pools_up_to_max_sessions::{closure#0}
[INFO] [stdout]    5: <tokio::runtime::scheduler::current_thread::Context>::enter::<core::task::poll::Poll<()>, <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]    6: <tokio::runtime::context::scoped::Scoped<tokio::runtime::scheduler::Context>>::set::<<tokio::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}, core::option::Option<()>>::{closure#0}, (alloc::boxed::Box<tokio::runtime::scheduler::current_thread::Core>, core::option::Option<()>)>
[INFO] [stdout]    7: <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on::<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>
[INFO] [stdout]    8: tokio::runtime::context::runtime::enter_runtime::<<tokio::runtime::scheduler::current_thread::CurrentThread>::block_on<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]    9: <tokio::runtime::runtime::Runtime>::block_on::<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>
[INFO] [stdout]   10: <scenarios::scenario_15_role_scope_pools_up_to_max_sessions::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   11: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stdout]   12: test::run_test::{closure#0}
[INFO] [stdout]   13: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stdout]   14: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   15: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   16: <unknown>
[INFO] [stdout]   17: clone
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d81e6952591 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5d81e696a63a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5d81e6957aac - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5d81e69297c6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5d81e6947db9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5d81e67fb430 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5d81e69480e2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5d81e6929872 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5d81e6921c09 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5d81e692a91d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5d81e696ae1c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5d81e696abf2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5d81e674e64a - scenarios[88a3bfada67b4cf9]::scenario_15_role_scope_pools_up_to_max_sessions::{closure#0}
[INFO] [stdout]   13:     0x5d81e67d6c33 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Context>::enter::<core[df12db4294e9bfd3]::task::poll::Poll<()>, <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   14:     0x5d81e67c725c - <tokio[b93e2003b00ac85]::runtime::context::scoped::Scoped<tokio[b93e2003b00ac85]::runtime::scheduler::Context>>::set::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}, core[df12db4294e9bfd3]::option::Option<()>>::{closure#0}, (alloc[2182bb758b4b3781]::boxed::Box<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Core>, core[df12db4294e9bfd3]::option::Option<()>)>
[INFO] [stdout]   15:     0x5d81e67d7387 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   16:     0x5d81e67c93ed - tokio[b93e2003b00ac85]::runtime::context::runtime::enter_runtime::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   17:     0x5d81e67d6755 - <tokio[b93e2003b00ac85]::runtime::runtime::Runtime>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>
[INFO] [stdout]   18:     0x5d81e677b64e - <scenarios[88a3bfada67b4cf9]::scenario_15_role_scope_pools_up_to_max_sessions::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   19:     0x5d81e67ee71b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   20:     0x5d81e67fbd85 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   21:     0x5d81e67f5644 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   22:     0x5d81e67feee2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   23:     0x5d81e6951179 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   24:     0x7fd569e29dfa - <unknown>
[INFO] [stdout]   25:     0x7fd569ebd3d4 - clone
[INFO] [stdout]   26:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- scenario_17_no_resume_capability_keeps_the_process_and_the_session stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'scenario_17_no_resume_capability_keeps_the_process_and_the_session' (1457) panicked at tests/scenarios.rs:2200:6:
[INFO] [stdout] start cluster: workspace root not found
[INFO] [stdout] 
[INFO] [stdout] Stack backtrace:
[INFO] [stdout]    0: <anyhow::Error>::msg::<&str>
[INFO] [stdout]    1: <onlyne_testkit::harness::Cluster>::repo_root
[INFO] [stdout]    2: <onlyne_testkit::harness::Cluster>::bin_path
[INFO] [stdout]    3: <onlyne_testkit::harness::Cluster>::start::{closure#0}
[INFO] [stdout]    4: scenarios::scenario_17_no_resume_capability_keeps_the_process_and_the_session::{closure#0}
[INFO] [stdout]    5: <tokio::runtime::scheduler::current_thread::Context>::enter::<core::task::poll::Poll<()>, <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]    6: <tokio::runtime::context::scoped::Scoped<tokio::runtime::scheduler::Context>>::set::<<tokio::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}, core::option::Option<()>>::{closure#0}, (alloc::boxed::Box<tokio::runtime::scheduler::current_thread::Core>, core::option::Option<()>)>
[INFO] [stdout]    7: <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on::<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>
[INFO] [stdout]    8: tokio::runtime::context::runtime::enter_runtime::<<tokio::runtime::scheduler::current_thread::CurrentThread>::block_on<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]    9: <tokio::runtime::runtime::Runtime>::block_on::<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>
[INFO] [stdout]   10: <scenarios::scenario_17_no_resume_capability_keeps_the_process_and_the_session::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   11: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stdout]   12: test::run_test::{closure#0}
[INFO] [stdout]   13: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stdout]   14: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   15: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   16: <unknown>
[INFO] [stdout]   17: clone
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d81e6952591 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5d81e696a63a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5d81e6957aac - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5d81e69297c6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5d81e6947db9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5d81e67fb430 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5d81e69480e2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5d81e6929872 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5d81e6921c09 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5d81e692a91d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5d81e696ae1c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5d81e696abf2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5d81e6761f09 - scenarios[88a3bfada67b4cf9]::scenario_17_no_resume_capability_keeps_the_process_and_the_session::{closure#0}
[INFO] [stdout]   13:     0x5d81e67d6c33 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Context>::enter::<core[df12db4294e9bfd3]::task::poll::Poll<()>, <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   14:     0x5d81e67c725c - <tokio[b93e2003b00ac85]::runtime::context::scoped::Scoped<tokio[b93e2003b00ac85]::runtime::scheduler::Context>>::set::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}, core[df12db4294e9bfd3]::option::Option<()>>::{closure#0}, (alloc[2182bb758b4b3781]::boxed::Box<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Core>, core[df12db4294e9bfd3]::option::Option<()>)>
[INFO] [stdout]   15:     0x5d81e67d7387 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   16:     0x5d81e67c93ed - tokio[b93e2003b00ac85]::runtime::context::runtime::enter_runtime::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   17:     0x5d81e67d6755 - <tokio[b93e2003b00ac85]::runtime::runtime::Runtime>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>
[INFO] [stdout]   18:     0x5d81e677be8e - <scenarios[88a3bfada67b4cf9]::scenario_17_no_resume_capability_keeps_the_process_and_the_session::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   19:     0x5d81e67ee71b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   20:     0x5d81e67fbd85 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   21:     0x5d81e67f5644 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   22:     0x5d81e67feee2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   23:     0x5d81e6951179 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   24:     0x7fd569e29dfa - <unknown>
[INFO] [stdout]   25:     0x7fd569ebd3d4 - clone
[INFO] [stdout]   26:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- scenario_10_plugin_conformance stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'scenario_10_plugin_conformance' (1451) panicked at tests/scenarios.rs:1397:46:
[INFO] [stdout] start cluster: workspace root not found
[INFO] [stdout] 
[INFO] [stdout] Stack backtrace:
[INFO] [stdout]    0: <anyhow::Error>::msg::<&str>
[INFO] [stdout]    1: <onlyne_testkit::harness::Cluster>::repo_root
[INFO] [stdout]    2: <onlyne_testkit::harness::Cluster>::bin_path
[INFO] [stdout]    3: <onlyne_testkit::harness::Cluster>::start::{closure#0}
[INFO] [stdout]    4: scenarios::scenario_10_plugin_conformance::{closure#0}
[INFO] [stdout]    5: <tokio::runtime::scheduler::current_thread::Context>::enter::<core::task::poll::Poll<()>, <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]    6: <tokio::runtime::context::scoped::Scoped<tokio::runtime::scheduler::Context>>::set::<<tokio::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}, core::option::Option<()>>::{closure#0}, (alloc::boxed::Box<tokio::runtime::scheduler::current_thread::Core>, core::option::Option<()>)>
[INFO] [stdout]    7: <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on::<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>
[INFO] [stdout]    8: tokio::runtime::context::runtime::enter_runtime::<<tokio::runtime::scheduler::current_thread::CurrentThread>::block_on<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]    9: <tokio::runtime::runtime::Runtime>::block_on::<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>
[INFO] [stdout]   10: <scenarios::scenario_10_plugin_conformance::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   11: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stdout]   12: test::run_test::{closure#0}
[INFO] [stdout]   13: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stdout]   14: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   15: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   16: <unknown>
[INFO] [stdout]   17: clone
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d81e6952591 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5d81e696a63a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5d81e6957aac - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5d81e69297c6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5d81e6947db9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5d81e67fb430 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5d81e69480e2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5d81e6929872 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5d81e6921c09 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5d81e692a91d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5d81e696ae1c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5d81e696abf2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5d81e674533e - scenarios[88a3bfada67b4cf9]::scenario_10_plugin_conformance::{closure#0}
[INFO] [stdout]   13:     0x5d81e67d6c33 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Context>::enter::<core[df12db4294e9bfd3]::task::poll::Poll<()>, <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   14:     0x5d81e67c725c - <tokio[b93e2003b00ac85]::runtime::context::scoped::Scoped<tokio[b93e2003b00ac85]::runtime::scheduler::Context>>::set::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}, core[df12db4294e9bfd3]::option::Option<()>>::{closure#0}, (alloc[2182bb758b4b3781]::boxed::Box<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Core>, core[df12db4294e9bfd3]::option::Option<()>)>
[INFO] [stdout]   15:     0x5d81e67d7387 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   16:     0x5d81e67c93ed - tokio[b93e2003b00ac85]::runtime::context::runtime::enter_runtime::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   17:     0x5d81e67d6755 - <tokio[b93e2003b00ac85]::runtime::runtime::Runtime>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>
[INFO] [stdout]   18:     0x5d81e677b0ce - <scenarios[88a3bfada67b4cf9]::scenario_10_plugin_conformance::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   19:     0x5d81e67ee71b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   20:     0x5d81e67fbd85 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   21:     0x5d81e67f5644 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   22:     0x5d81e67feee2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   23:     0x5d81e6951179 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   24:     0x7fd569e29dfa - <unknown>
[INFO] [stdout]   25:     0x7fd569ebd3d4 - clone
[INFO] [stdout]   26:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- scenario_12_generate_relocate stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'scenario_12_generate_relocate' (1452) panicked at tests/scenarios.rs:1515:46:
[INFO] [stdout] start cluster: workspace root not found
[INFO] [stdout] 
[INFO] [stdout] Stack backtrace:
[INFO] [stdout]    0: <anyhow::Error>::msg::<&str>
[INFO] [stdout]    1: <onlyne_testkit::harness::Cluster>::repo_root
[INFO] [stdout]    2: <onlyne_testkit::harness::Cluster>::bin_path
[INFO] [stdout]    3: <onlyne_testkit::harness::Cluster>::start::{closure#0}
[INFO] [stdout]    4: scenarios::scenario_12_generate_relocate::{closure#0}
[INFO] [stdout]    5: <tokio::runtime::scheduler::current_thread::Context>::enter::<core::task::poll::Poll<()>, <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]    6: <tokio::runtime::context::scoped::Scoped<tokio::runtime::scheduler::Context>>::set::<<tokio::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}, core::option::Option<()>>::{closure#0}, (alloc::boxed::Box<tokio::runtime::scheduler::current_thread::Core>, core::option::Option<()>)>
[INFO] [stdout]    7: <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on::<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>
[INFO] [stdout]    8: tokio::runtime::context::runtime::enter_runtime::<<tokio::runtime::scheduler::current_thread::CurrentThread>::block_on<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]    9: <tokio::runtime::runtime::Runtime>::block_on::<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>
[INFO] [stdout]   10: <scenarios::scenario_12_generate_relocate::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   11: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stdout]   12: test::run_test::{closure#0}
[INFO] [stdout]   13: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stdout]   14: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   15: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   16: <unknown>
[INFO] [stdout]   17: clone
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d81e6952591 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5d81e696a63a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5d81e6957aac - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5d81e69297c6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5d81e6947db9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5d81e67fb430 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5d81e69480e2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5d81e6929872 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5d81e6921c09 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5d81e692a91d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5d81e696ae1c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5d81e696abf2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5d81e6741a4f - scenarios[88a3bfada67b4cf9]::scenario_12_generate_relocate::{closure#0}
[INFO] [stdout]   13:     0x5d81e67d6c33 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Context>::enter::<core[df12db4294e9bfd3]::task::poll::Poll<()>, <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   14:     0x5d81e67c725c - <tokio[b93e2003b00ac85]::runtime::context::scoped::Scoped<tokio[b93e2003b00ac85]::runtime::scheduler::Context>>::set::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}, core[df12db4294e9bfd3]::option::Option<()>>::{closure#0}, (alloc[2182bb758b4b3781]::boxed::Box<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Core>, core[df12db4294e9bfd3]::option::Option<()>)>
[INFO] [stdout]   15:     0x5d81e67d7387 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   16:     0x5d81e67c93ed - tokio[b93e2003b00ac85]::runtime::context::runtime::enter_runtime::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   17:     0x5d81e67d6755 - <tokio[b93e2003b00ac85]::runtime::runtime::Runtime>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>
[INFO] [stdout]   18:     0x5d81e677af6e - <scenarios[88a3bfada67b4cf9]::scenario_12_generate_relocate::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   19:     0x5d81e67ee71b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   20:     0x5d81e67fbd85 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   21:     0x5d81e67f5644 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   22:     0x5d81e67feee2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   23:     0x5d81e6951179 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   24:     0x7fd569e29dfa - <unknown>
[INFO] [stdout]   25:     0x7fd569ebd3d4 - clone
[INFO] [stdout]   26:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- scenario_09_heartbeat_watch stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'scenario_09_heartbeat_watch' (1450) panicked at tests/scenarios.rs:1248:46:
[INFO] [stdout] start cluster: workspace root not found
[INFO] [stdout] 
[INFO] [stdout] Stack backtrace:
[INFO] [stdout]    0: <anyhow::Error>::msg::<&str>
[INFO] [stdout]    1: <onlyne_testkit::harness::Cluster>::repo_root
[INFO] [stdout]    2: <onlyne_testkit::harness::Cluster>::bin_path
[INFO] [stdout]    3: <onlyne_testkit::harness::Cluster>::start::{closure#0}
[INFO] [stdout]    4: scenarios::scenario_09_heartbeat_watch::{closure#0}
[INFO] [stdout]    5: <tokio::runtime::scheduler::current_thread::Context>::enter::<core::task::poll::Poll<()>, <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]    6: <tokio::runtime::context::scoped::Scoped<tokio::runtime::scheduler::Context>>::set::<<tokio::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}, core::option::Option<()>>::{closure#0}, (alloc::boxed::Box<tokio::runtime::scheduler::current_thread::Core>, core::option::Option<()>)>
[INFO] [stdout]    7: <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on::<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>
[INFO] [stdout]    8: tokio::runtime::context::runtime::enter_runtime::<<tokio::runtime::scheduler::current_thread::CurrentThread>::block_on<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]    9: <tokio::runtime::runtime::Runtime>::block_on::<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>
[INFO] [stdout]   10: <scenarios::scenario_09_heartbeat_watch::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   11: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stdout]   12: test::run_test::{closure#0}
[INFO] [stdout]   13: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stdout]   14: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   15: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   16: <unknown>
[INFO] [stdout]   17: clone
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d81e6952591 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5d81e696a63a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5d81e6957aac - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5d81e69297c6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5d81e6947db9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5d81e67fb430 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5d81e69480e2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5d81e6929872 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5d81e6921c09 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5d81e692a91d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5d81e696ae1c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5d81e696abf2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5d81e673df19 - scenarios[88a3bfada67b4cf9]::scenario_09_heartbeat_watch::{closure#0}
[INFO] [stdout]   13:     0x5d81e67d6c33 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Context>::enter::<core[df12db4294e9bfd3]::task::poll::Poll<()>, <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   14:     0x5d81e67c725c - <tokio[b93e2003b00ac85]::runtime::context::scoped::Scoped<tokio[b93e2003b00ac85]::runtime::scheduler::Context>>::set::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}, core[df12db4294e9bfd3]::option::Option<()>>::{closure#0}, (alloc[2182bb758b4b3781]::boxed::Box<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Core>, core[df12db4294e9bfd3]::option::Option<()>)>
[INFO] [stdout]   15:     0x5d81e67d7387 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   16:     0x5d81e67c93ed - tokio[b93e2003b00ac85]::runtime::context::runtime::enter_runtime::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   17:     0x5d81e67d6755 - <tokio[b93e2003b00ac85]::runtime::runtime::Runtime>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>
[INFO] [stdout]   18:     0x5d81e677ae0e - <scenarios[88a3bfada67b4cf9]::scenario_09_heartbeat_watch::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   19:     0x5d81e67ee71b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   20:     0x5d81e67fbd85 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   21:     0x5d81e67f5644 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   22:     0x5d81e67feee2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   23:     0x5d81e6951179 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   24:     0x7fd569e29dfa - <unknown>
[INFO] [stdout]   25:     0x7fd569ebd3d4 - clone
[INFO] [stdout]   26:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- scenario_13_oneshot_gives_each_delivery_its_own_session stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'scenario_13_oneshot_gives_each_delivery_its_own_session' (1453) panicked at tests/scenarios.rs:1700:6:
[INFO] [stdout] start cluster: workspace root not found
[INFO] [stdout] 
[INFO] [stdout] Stack backtrace:
[INFO] [stdout]    0: <anyhow::Error>::msg::<&str>
[INFO] [stdout]    1: <onlyne_testkit::harness::Cluster>::repo_root
[INFO] [stdout]    2: <onlyne_testkit::harness::Cluster>::bin_path
[INFO] [stdout]    3: <onlyne_testkit::harness::Cluster>::start::{closure#0}
[INFO] [stdout]    4: scenarios::scenario_13_oneshot_gives_each_delivery_its_own_session::{closure#0}
[INFO] [stdout]    5: <tokio::runtime::scheduler::current_thread::Context>::enter::<core::task::poll::Poll<()>, <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]    6: <tokio::runtime::context::scoped::Scoped<tokio::runtime::scheduler::Context>>::set::<<tokio::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}, core::option::Option<()>>::{closure#0}, (alloc::boxed::Box<tokio::runtime::scheduler::current_thread::Core>, core::option::Option<()>)>
[INFO] [stdout]    7: <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on::<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>
[INFO] [stdout]    8: tokio::runtime::context::runtime::enter_runtime::<<tokio::runtime::scheduler::current_thread::CurrentThread>::block_on<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]    9: <tokio::runtime::runtime::Runtime>::block_on::<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>
[INFO] [stdout]   10: <scenarios::scenario_13_oneshot_gives_each_delivery_its_own_session::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   11: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stdout]   12: test::run_test::{closure#0}
[INFO] [stdout]   13: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stdout]   14: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   15: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   16: <unknown>
[INFO] [stdout]   17: clone
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d81e6952591 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5d81e696a63a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5d81e6957aac - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5d81e69297c6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5d81e6947db9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5d81e67fb430 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5d81e69480e2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5d81e6929872 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5d81e6921c09 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5d81e692a91d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5d81e696ae1c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5d81e696abf2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5d81e675681d - scenarios[88a3bfada67b4cf9]::scenario_13_oneshot_gives_each_delivery_its_own_session::{closure#0}
[INFO] [stdout]   13:     0x5d81e67d6c33 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Context>::enter::<core[df12db4294e9bfd3]::task::poll::Poll<()>, <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   14:     0x5d81e67c725c - <tokio[b93e2003b00ac85]::runtime::context::scoped::Scoped<tokio[b93e2003b00ac85]::runtime::scheduler::Context>>::set::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}, core[df12db4294e9bfd3]::option::Option<()>>::{closure#0}, (alloc[2182bb758b4b3781]::boxed::Box<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Core>, core[df12db4294e9bfd3]::option::Option<()>)>
[INFO] [stdout]   15:     0x5d81e67d7387 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   16:     0x5d81e67c93ed - tokio[b93e2003b00ac85]::runtime::context::runtime::enter_runtime::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   17:     0x5d81e67d6755 - <tokio[b93e2003b00ac85]::runtime::runtime::Runtime>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>
[INFO] [stdout]   18:     0x5d81e677b90e - <scenarios[88a3bfada67b4cf9]::scenario_13_oneshot_gives_each_delivery_its_own_session::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   19:     0x5d81e67ee71b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   20:     0x5d81e67fbd85 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   21:     0x5d81e67f5644 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   22:     0x5d81e67feee2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   23:     0x5d81e6951179 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   24:     0x7fd569e29dfa - <unknown>
[INFO] [stdout]   25:     0x7fd569ebd3d4 - clone
[INFO] [stdout]   26:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- scenario_14_task_scope_keeps_a_family_in_one_session stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'scenario_14_task_scope_keeps_a_family_in_one_session' (1454) panicked at tests/scenarios.rs:1793:6:
[INFO] [stdout] start cluster: workspace root not found
[INFO] [stdout] 
[INFO] [stdout] Stack backtrace:
[INFO] [stdout]    0: <anyhow::Error>::msg::<&str>
[INFO] [stdout]    1: <onlyne_testkit::harness::Cluster>::repo_root
[INFO] [stdout]    2: <onlyne_testkit::harness::Cluster>::bin_path
[INFO] [stdout]    3: <onlyne_testkit::harness::Cluster>::start::{closure#0}
[INFO] [stdout]    4: scenarios::scenario_14_task_scope_keeps_a_family_in_one_session::{closure#0}
[INFO] [stdout]    5: <tokio::runtime::scheduler::current_thread::Context>::enter::<core::task::poll::Poll<()>, <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]    6: <tokio::runtime::context::scoped::Scoped<tokio::runtime::scheduler::Context>>::set::<<tokio::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}, core::option::Option<()>>::{closure#0}, (alloc::boxed::Box<tokio::runtime::scheduler::current_thread::Core>, core::option::Option<()>)>
[INFO] [stdout]    7: <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on::<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>
[INFO] [stdout]    8: tokio::runtime::context::runtime::enter_runtime::<<tokio::runtime::scheduler::current_thread::CurrentThread>::block_on<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]    9: <tokio::runtime::runtime::Runtime>::block_on::<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>
[INFO] [stdout]   10: <scenarios::scenario_14_task_scope_keeps_a_family_in_one_session::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   11: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stdout]   12: test::run_test::{closure#0}
[INFO] [stdout]   13: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stdout]   14: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   15: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   16: <unknown>
[INFO] [stdout]   17: clone
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d81e6952591 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5d81e696a63a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5d81e6957aac - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5d81e69297c6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5d81e6947db9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5d81e67fb430 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5d81e69480e2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5d81e6929872 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5d81e6921c09 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5d81e692a91d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5d81e696ae1c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5d81e696abf2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5d81e67525db - scenarios[88a3bfada67b4cf9]::scenario_14_task_scope_keeps_a_family_in_one_session::{closure#0}
[INFO] [stdout]   13:     0x5d81e67d6c33 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Context>::enter::<core[df12db4294e9bfd3]::task::poll::Poll<()>, <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   14:     0x5d81e67c725c - <tokio[b93e2003b00ac85]::runtime::context::scoped::Scoped<tokio[b93e2003b00ac85]::runtime::scheduler::Context>>::set::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}, core[df12db4294e9bfd3]::option::Option<()>>::{closure#0}, (alloc[2182bb758b4b3781]::boxed::Box<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Core>, core[df12db4294e9bfd3]::option::Option<()>)>
[INFO] [stdout]   15:     0x5d81e67d7387 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   16:     0x5d81e67c93ed - tokio[b93e2003b00ac85]::runtime::context::runtime::enter_runtime::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   17:     0x5d81e67d6755 - <tokio[b93e2003b00ac85]::runtime::runtime::Runtime>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>
[INFO] [stdout]   18:     0x5d81e677b7ae - <scenarios[88a3bfada67b4cf9]::scenario_14_task_scope_keeps_a_family_in_one_session::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   19:     0x5d81e67ee71b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   20:     0x5d81e67fbd85 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   21:     0x5d81e67f5644 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   22:     0x5d81e67feee2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   23:     0x5d81e6951179 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   24:     0x7fd569e29dfa - <unknown>
[INFO] [stdout]   25:     0x7fd569ebd3d4 - clone
[INFO] [stdout]   26:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- scenario_18_a_last_seen_only_heartbeat_writes_no_updated_at_and_no_event stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'scenario_18_a_last_seen_only_heartbeat_writes_no_updated_at_and_no_event' (1458) panicked at tests/scenarios.rs:2318:6:
[INFO] [stdout] start cluster: workspace root not found
[INFO] [stdout] 
[INFO] [stdout] Stack backtrace:
[INFO] [stdout]    0: <anyhow::Error>::msg::<&str>
[INFO] [stdout]    1: <onlyne_testkit::harness::Cluster>::repo_root
[INFO] [stdout]    2: <onlyne_testkit::harness::Cluster>::bin_path
[INFO] [stdout]    3: <onlyne_testkit::harness::Cluster>::start::{closure#0}
[INFO] [stdout]    4: scenarios::scenario_18_a_last_seen_only_heartbeat_writes_no_updated_at_and_no_event::{closure#0}
[INFO] [stdout]    5: <tokio::runtime::scheduler::current_thread::Context>::enter::<core::task::poll::Poll<()>, <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]    6: <tokio::runtime::context::scoped::Scoped<tokio::runtime::scheduler::Context>>::set::<<tokio::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}, core::option::Option<()>>::{closure#0}, (alloc::boxed::Box<tokio::runtime::scheduler::current_thread::Core>, core::option::Option<()>)>
[INFO] [stdout]    7: <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on::<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>
[INFO] [stdout]    8: tokio::runtime::context::runtime::enter_runtime::<<tokio::runtime::scheduler::current_thread::CurrentThread>::block_on<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]    9: <tokio::runtime::runtime::Runtime>::block_on::<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>
[INFO] [stdout]   10: <scenarios::scenario_18_a_last_seen_only_heartbeat_writes_no_updated_at_and_no_event::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   11: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stdout]   12: test::run_test::{closure#0}
[INFO] [stdout]   13: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stdout]   14: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   15: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   16: <unknown>
[INFO] [stdout]   17: clone
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d81e6952591 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5d81e696a63a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5d81e6957aac - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5d81e69297c6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5d81e6947db9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5d81e67fb430 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5d81e69480e2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5d81e6929872 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5d81e6921c09 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5d81e692a91d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5d81e696ae1c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5d81e696abf2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5d81e6768715 - scenarios[88a3bfada67b4cf9]::scenario_18_a_last_seen_only_heartbeat_writes_no_updated_at_and_no_event::{closure#0}
[INFO] [stdout]   13:     0x5d81e67d6c33 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Context>::enter::<core[df12db4294e9bfd3]::task::poll::Poll<()>, <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   14:     0x5d81e67c725c - <tokio[b93e2003b00ac85]::runtime::context::scoped::Scoped<tokio[b93e2003b00ac85]::runtime::scheduler::Context>>::set::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}, core[df12db4294e9bfd3]::option::Option<()>>::{closure#0}, (alloc[2182bb758b4b3781]::boxed::Box<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Core>, core[df12db4294e9bfd3]::option::Option<()>)>
[INFO] [stdout]   15:     0x5d81e67d7387 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   16:     0x5d81e67c93ed - tokio[b93e2003b00ac85]::runtime::context::runtime::enter_runtime::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   17:     0x5d81e67d6755 - <tokio[b93e2003b00ac85]::runtime::runtime::Runtime>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>
[INFO] [stdout]   18:     0x5d81e677c14e - <scenarios[88a3bfada67b4cf9]::scenario_18_a_last_seen_only_heartbeat_writes_no_updated_at_and_no_event::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   19:     0x5d81e67ee71b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   20:     0x5d81e67fbd85 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   21:     0x5d81e67f5644 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   22:     0x5d81e67feee2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   23:     0x5d81e6951179 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   24:     0x7fd569e29dfa - <unknown>
[INFO] [stdout]   25:     0x7fd569ebd3d4 - clone
[INFO] [stdout]   26:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- scenario_19_a_standing_runtime_serves_every_session_from_one_connection stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'scenario_19_a_standing_runtime_serves_every_session_from_one_connection' (1459) panicked at tests/scenarios.rs:2561:6:
[INFO] [stdout] start cluster: workspace root not found
[INFO] [stdout] 
[INFO] [stdout] Stack backtrace:
[INFO] [stdout]    0: <anyhow::Error>::msg::<&str>
[INFO] [stdout]    1: <onlyne_testkit::harness::Cluster>::repo_root
[INFO] [stdout]    2: <onlyne_testkit::harness::Cluster>::bin_path
[INFO] [stdout]    3: <onlyne_testkit::harness::Cluster>::start::{closure#0}
[INFO] [stdout]    4: scenarios::scenario_19_a_standing_runtime_serves_every_session_from_one_connection::{closure#0}
[INFO] [stdout]    5: <tokio::runtime::scheduler::current_thread::Context>::enter::<core::task::poll::Poll<()>, <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]    6: <tokio::runtime::context::scoped::Scoped<tokio::runtime::scheduler::Context>>::set::<<tokio::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}, core::option::Option<()>>::{closure#0}, (alloc::boxed::Box<tokio::runtime::scheduler::current_thread::Core>, core::option::Option<()>)>
[INFO] [stdout]    7: <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on::<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>
[INFO] [stdout]    8: tokio::runtime::context::runtime::enter_runtime::<<tokio::runtime::scheduler::current_thread::CurrentThread>::block_on<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]    9: <tokio::runtime::runtime::Runtime>::block_on::<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>
[INFO] [stdout]   10: <scenarios::scenario_19_a_standing_runtime_serves_every_session_from_one_connection::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   11: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stdout]   12: test::run_test::{closure#0}
[INFO] [stdout]   13: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stdout]   14: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   15: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   16: <unknown>
[INFO] [stdout]   17: clone
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d81e6952591 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5d81e696a63a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5d81e6957aac - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5d81e69297c6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5d81e6947db9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5d81e67fb430 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5d81e69480e2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5d81e6929872 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5d81e6921c09 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5d81e692a91d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5d81e696ae1c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5d81e696abf2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5d81e6765908 - scenarios[88a3bfada67b4cf9]::scenario_19_a_standing_runtime_serves_every_session_from_one_connection::{closure#0}
[INFO] [stdout]   13:     0x5d81e67d6c33 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Context>::enter::<core[df12db4294e9bfd3]::task::poll::Poll<()>, <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   14:     0x5d81e67c725c - <tokio[b93e2003b00ac85]::runtime::context::scoped::Scoped<tokio[b93e2003b00ac85]::runtime::scheduler::Context>>::set::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}, core[df12db4294e9bfd3]::option::Option<()>>::{closure#0}, (alloc[2182bb758b4b3781]::boxed::Box<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Core>, core[df12db4294e9bfd3]::option::Option<()>)>
[INFO] [stdout]   15:     0x5d81e67d7387 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   16:     0x5d81e67c93ed - tokio[b93e2003b00ac85]::runtime::context::runtime::enter_runtime::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   17:     0x5d81e67d6755 - <tokio[b93e2003b00ac85]::runtime::runtime::Runtime>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>
[INFO] [stdout]   18:     0x5d81e677bfee - <scenarios[88a3bfada67b4cf9]::scenario_19_a_standing_runtime_serves_every_session_from_one_connection::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   19:     0x5d81e67ee71b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   20:     0x5d81e67fbd85 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   21:     0x5d81e67f5644 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   22:     0x5d81e67feee2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   23:     0x5d81e6951179 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   24:     0x7fd569e29dfa - <unknown>
[INFO] [stdout]   25:     0x7fd569ebd3d4 - clone
[INFO] [stdout]   26:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- scenario_21_a_completion_behind_a_verdict_is_answered_with_it stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'scenario_21_a_completion_behind_a_verdict_is_answered_with_it' (1461) panicked at tests/scenarios.rs:2818:6:
[INFO] [stdout] start cluster: workspace root not found
[INFO] [stdout] 
[INFO] [stdout] Stack backtrace:
[INFO] [stdout]    0: <anyhow::Error>::msg::<&str>
[INFO] [stdout]    1: <onlyne_testkit::harness::Cluster>::repo_root
[INFO] [stdout]    2: <onlyne_testkit::harness::Cluster>::bin_path
[INFO] [stdout]    3: <onlyne_testkit::harness::Cluster>::start::{closure#0}
[INFO] [stdout]    4: scenarios::scenario_21_a_completion_behind_a_verdict_is_answered_with_it::{closure#0}
[INFO] [stdout]    5: <tokio::runtime::scheduler::current_thread::Context>::enter::<core::task::poll::Poll<()>, <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]    6: <tokio::runtime::context::scoped::Scoped<tokio::runtime::scheduler::Context>>::set::<<tokio::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}, core::option::Option<()>>::{closure#0}, (alloc::boxed::Box<tokio::runtime::scheduler::current_thread::Core>, core::option::Option<()>)>
[INFO] [stdout]    7: <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on::<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>
[INFO] [stdout]    8: tokio::runtime::context::runtime::enter_runtime::<<tokio::runtime::scheduler::current_thread::CurrentThread>::block_on<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]    9: <tokio::runtime::runtime::Runtime>::block_on::<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>
[INFO] [stdout]   10: <scenarios::scenario_21_a_completion_behind_a_verdict_is_answered_with_it::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   11: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stdout]   12: test::run_test::{closure#0}
[INFO] [stdout]   13: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stdout]   14: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   15: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   16: <unknown>
[INFO] [stdout]   17: clone
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d81e6952591 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5d81e696a63a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5d81e6957aac - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5d81e69297c6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5d81e6947db9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5d81e67fb430 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5d81e69480e2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5d81e6929872 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5d81e6921c09 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5d81e692a91d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5d81e696ae1c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5d81e696abf2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5d81e675d06b - scenarios[88a3bfada67b4cf9]::scenario_21_a_completion_behind_a_verdict_is_answered_with_it::{closure#0}
[INFO] [stdout]   13:     0x5d81e67d6c33 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Context>::enter::<core[df12db4294e9bfd3]::task::poll::Poll<()>, <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   14:     0x5d81e67c725c - <tokio[b93e2003b00ac85]::runtime::context::scoped::Scoped<tokio[b93e2003b00ac85]::runtime::scheduler::Context>>::set::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}, core[df12db4294e9bfd3]::option::Option<()>>::{closure#0}, (alloc[2182bb758b4b3781]::boxed::Box<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Core>, core[df12db4294e9bfd3]::option::Option<()>)>
[INFO] [stdout]   15:     0x5d81e67d7387 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   16:     0x5d81e67c93ed - tokio[b93e2003b00ac85]::runtime::context::runtime::enter_runtime::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   17:     0x5d81e67d6755 - <tokio[b93e2003b00ac85]::runtime::runtime::Runtime>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>
[INFO] [stdout]   18:     0x5d81e677bbce - <scenarios[88a3bfada67b4cf9]::scenario_21_a_completion_behind_a_verdict_is_answered_with_it::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   19:     0x5d81e67ee71b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   20:     0x5d81e67fbd85 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   21:     0x5d81e67f5644 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   22:     0x5d81e67feee2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   23:     0x5d81e6951179 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   24:     0x7fd569e29dfa - <unknown>
[INFO] [stdout]   25:     0x7fd569ebd3d4 - clone
[INFO] [stdout]   26:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- scenario_20_reach_is_permission_and_the_obligation_is_declared stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'scenario_20_reach_is_permission_and_the_obligation_is_declared' (1460) panicked at tests/scenarios.rs:2672:6:
[INFO] [stdout] start cluster: workspace root not found
[INFO] [stdout] 
[INFO] [stdout] Stack backtrace:
[INFO] [stdout]    0: <anyhow::Error>::msg::<&str>
[INFO] [stdout]    1: <onlyne_testkit::harness::Cluster>::repo_root
[INFO] [stdout]    2: <onlyne_testkit::harness::Cluster>::bin_path
[INFO] [stdout]    3: <onlyne_testkit::harness::Cluster>::start::{closure#0}
[INFO] [stdout]    4: scenarios::scenario_20_reach_is_permission_and_the_obligation_is_declared::{closure#0}
[INFO] [stdout]    5: <tokio::runtime::scheduler::current_thread::Context>::enter::<core::task::poll::Poll<()>, <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]    6: <tokio::runtime::context::scoped::Scoped<tokio::runtime::scheduler::Context>>::set::<<tokio::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}, core::option::Option<()>>::{closure#0}, (alloc::boxed::Box<tokio::runtime::scheduler::current_thread::Core>, core::option::Option<()>)>
[INFO] [stdout]    7: <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on::<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>
[INFO] [stdout]    8: tokio::runtime::context::runtime::enter_runtime::<<tokio::runtime::scheduler::current_thread::CurrentThread>::block_on<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]    9: <tokio::runtime::runtime::Runtime>::block_on::<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>
[INFO] [stdout]   10: <scenarios::scenario_20_reach_is_permission_and_the_obligation_is_declared::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   11: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stdout]   12: test::run_test::{closure#0}
[INFO] [stdout]   13: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stdout]   14: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   15: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   16: <unknown>
[INFO] [stdout]   17: clone
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d81e6952591 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5d81e696a63a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5d81e6957aac - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5d81e69297c6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5d81e6947db9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5d81e67fb430 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5d81e69480e2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5d81e6929872 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5d81e6921c09 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5d81e692a91d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5d81e696ae1c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5d81e696abf2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5d81e675f9ea - scenarios[88a3bfada67b4cf9]::scenario_20_reach_is_permission_and_the_obligation_is_declared::{closure#0}
[INFO] [stdout]   13:     0x5d81e67d6c33 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Context>::enter::<core[df12db4294e9bfd3]::task::poll::Poll<()>, <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   14:     0x5d81e67c725c - <tokio[b93e2003b00ac85]::runtime::context::scoped::Scoped<tokio[b93e2003b00ac85]::runtime::scheduler::Context>>::set::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}, core[df12db4294e9bfd3]::option::Option<()>>::{closure#0}, (alloc[2182bb758b4b3781]::boxed::Box<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Core>, core[df12db4294e9bfd3]::option::Option<()>)>
[INFO] [stdout]   15:     0x5d81e67d7387 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   16:     0x5d81e67c93ed - tokio[b93e2003b00ac85]::runtime::context::runtime::enter_runtime::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   17:     0x5d81e67d6755 - <tokio[b93e2003b00ac85]::runtime::runtime::Runtime>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>
[INFO] [stdout]   18:     0x5d81e677bd2e - <scenarios[88a3bfada67b4cf9]::scenario_20_reach_is_permission_and_the_obligation_is_declared::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   19:     0x5d81e67ee71b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   20:     0x5d81e67fbd85 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   21:     0x5d81e67f5644 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   22:     0x5d81e67feee2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   23:     0x5d81e6951179 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   24:     0x7fd569e29dfa - <unknown>
[INFO] [stdout]   25:     0x7fd569ebd3d4 - clone
[INFO] [stdout]   26:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- scenario_16_suspend_frees_the_slot_and_the_family_resumes_it stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'scenario_16_suspend_frees_the_slot_and_the_family_resumes_it' (1456) panicked at tests/scenarios.rs:2072:6:
[INFO] [stdout] start cluster: workspace root not found
[INFO] [stdout] 
[INFO] [stdout] Stack backtrace:
[INFO] [stdout]    0: <anyhow::Error>::msg::<&str>
[INFO] [stdout]    1: <onlyne_testkit::harness::Cluster>::repo_root
[INFO] [stdout]    2: <onlyne_testkit::harness::Cluster>::bin_path
[INFO] [stdout]    3: <onlyne_testkit::harness::Cluster>::start::{closure#0}
[INFO] [stdout]    4: scenarios::scenario_16_suspend_frees_the_slot_and_the_family_resumes_it::{closure#0}
[INFO] [stdout]    5: <tokio::runtime::scheduler::current_thread::Context>::enter::<core::task::poll::Poll<()>, <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]    6: <tokio::runtime::context::scoped::Scoped<tokio::runtime::scheduler::Context>>::set::<<tokio::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio::runtime::scheduler::current_thread::CoreGuard>::block_on<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>::{closure#0}, core::option::Option<()>>::{closure#0}, (alloc::boxed::Box<tokio::runtime::scheduler::current_thread::Core>, core::option::Option<()>)>
[INFO] [stdout]    7: <tokio::runtime::scheduler::current_thread::CoreGuard>::block_on::<core::pin::Pin<&mut core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>>
[INFO] [stdout]    8: tokio::runtime::context::runtime::enter_runtime::<<tokio::runtime::scheduler::current_thread::CurrentThread>::block_on<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]    9: <tokio::runtime::runtime::Runtime>::block_on::<core::pin::Pin<&mut dyn core::future::future::Future<Output = ()>>>
[INFO] [stdout]   10: <scenarios::scenario_16_suspend_frees_the_slot_and_the_family_resumes_it::{closure#0} as core::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   11: test::__rust_begin_short_backtrace::<core::result::Result<(), alloc::string::String>, fn() -> core::result::Result<(), alloc::string::String>>
[INFO] [stdout]   12: test::run_test::{closure#0}
[INFO] [stdout]   13: std::sys::backtrace::__rust_begin_short_backtrace::<test::run_test::{closure#1}, ()>
[INFO] [stdout]   14: <std::thread::lifecycle::spawn_unchecked<test::run_test::{closure#1}, ()>::{closure#1} as core::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   15: <std::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   16: <unknown>
[INFO] [stdout]   17: clone
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d81e6952591 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5d81e696a63a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x5d81e6957aac - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x5d81e69297c6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5d81e6947db9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x5d81e67fb430 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5d81e69480e2 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5d81e6929872 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5d81e6921c09 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5d81e692a91d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x5d81e696ae1c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5d81e696abf2 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x5d81e67591e4 - scenarios[88a3bfada67b4cf9]::scenario_16_suspend_frees_the_slot_and_the_family_resumes_it::{closure#0}
[INFO] [stdout]   13:     0x5d81e67d6c33 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Context>::enter::<core[df12db4294e9bfd3]::task::poll::Poll<()>, <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]   14:     0x5d81e67c725c - <tokio[b93e2003b00ac85]::runtime::context::scoped::Scoped<tokio[b93e2003b00ac85]::runtime::scheduler::Context>>::set::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>::{closure#0}, core[df12db4294e9bfd3]::option::Option<()>>::{closure#0}, (alloc[2182bb758b4b3781]::boxed::Box<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::Core>, core[df12db4294e9bfd3]::option::Option<()>)>
[INFO] [stdout]   15:     0x5d81e67d7387 - <tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>>
[INFO] [stdout]   16:     0x5d81e67c93ed - tokio[b93e2003b00ac85]::runtime::context::runtime::enter_runtime::<<tokio[b93e2003b00ac85]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]   17:     0x5d81e67d6755 - <tokio[b93e2003b00ac85]::runtime::runtime::Runtime>::block_on::<core[df12db4294e9bfd3]::pin::Pin<&mut dyn core[df12db4294e9bfd3]::future::future::Future<Output = ()>>>
[INFO] [stdout]   18:     0x5d81e677ba6e - <scenarios[88a3bfada67b4cf9]::scenario_16_suspend_frees_the_slot_and_the_family_resumes_it::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   19:     0x5d81e67ee71b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   20:     0x5d81e67fbd85 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   21:     0x5d81e67f5644 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   22:     0x5d81e67feee2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   23:     0x5d81e6951179 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   24:     0x7fd569e29dfa - <unknown>
[INFO] [stdout]   25:     0x7fd569ebd3d4 - clone
[INFO] [stdout]   26:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     scenario_01_delivery_loop
[INFO] [stdout]     scenario_02_handoff_chain
[INFO] [stdout]     scenario_03_acl_denial
[INFO] [stdout]     scenario_04_idempotency
[INFO] [stdout]     scenario_05_disconnect_recovery
[INFO] [stdout]     scenario_06_server_restart
[INFO] [stdout]     scenario_07_large_frames_interleaved
[INFO] [stdout]     scenario_08_legacy_layout_refusal
[INFO] [stdout]     scenario_09_heartbeat_watch
[INFO] [stdout]     scenario_10_plugin_conformance
[INFO] [stdout]     scenario_12_generate_relocate
[INFO] [stdout]     scenario_13_oneshot_gives_each_delivery_its_own_session
[INFO] [stdout]     scenario_14_task_scope_keeps_a_family_in_one_session
[INFO] [stdout]     scenario_15_role_scope_pools_up_to_max_sessions
[INFO] [stdout]     scenario_16_suspend_frees_the_slot_and_the_family_resumes_it
[INFO] [stdout]     scenario_17_no_resume_capability_keeps_the_process_and_the_session
[INFO] [stdout]     scenario_18_a_last_seen_only_heartbeat_writes_no_updated_at_and_no_event
[INFO] [stdout]     scenario_19_a_standing_runtime_serves_every_session_from_one_connection
[INFO] [stdout]     scenario_20_reach_is_permission_and_the_obligation_is_declared
[INFO] [stdout]     scenario_21_a_completion_behind_a_verdict_is_answered_with_it
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 0 passed; 20 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--test scenarios`
[INFO] running `Command { std: "docker" "inspect" "7af7e8059ecde1341fb33446b0f1454d7713e136faa7c8d6a6581176ec39e67d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7af7e8059ecde1341fb33446b0f1454d7713e136faa7c8d6a6581176ec39e67d", kill_on_drop: false }`
[INFO] [stdout] 7af7e8059ecde1341fb33446b0f1454d7713e136faa7c8d6a6581176ec39e67d
