[INFO] fetching crate sysknife-daemon 0.25.0...
[INFO] testing sysknife-daemon-0.25.0 against 1.100.0-beta.1 for beta-1.100-2
[INFO] extracting crate sysknife-daemon 0.25.0 into /workspace/builds/worker-6-tc2/source
[INFO] started tweaking crates.io crate sysknife-daemon 0.25.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate sysknife-daemon 0.25.0
[INFO] tweaked toml for crates.io crate sysknife-daemon 0.25.0 written to /workspace/builds/worker-6-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate sysknife-daemon 0.25.0 on toolchain 1.100.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate sysknife-daemon 0.25.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.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/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:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] f87c95844b4d33a8a02dae4638455ec4476390ccf4224712fbdcf27ff23e83c5
[INFO] running `Command { std: "docker" "start" "f87c95844b4d33a8a02dae4638455ec4476390ccf4224712fbdcf27ff23e83c5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f87c95844b4d33a8a02dae4638455ec4476390ccf4224712fbdcf27ff23e83c5", 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" "f87c95844b4d33a8a02dae4638455ec4476390ccf4224712fbdcf27ff23e83c5" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f87c95844b4d33a8a02dae4638455ec4476390ccf4224712fbdcf27ff23e83c5", 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" "f87c95844b4d33a8a02dae4638455ec4476390ccf4224712fbdcf27ff23e83c5" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde_core v1.0.229
[INFO] [stderr]    Compiling cc v1.2.61
[INFO] [stderr]    Compiling typenum v1.20.0
[INFO] [stderr]    Compiling either v1.15.0
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling syn v3.0.2
[INFO] [stderr]    Compiling anyhow v1.0.104
[INFO] [stderr]    Compiling bytes v1.11.1
[INFO] [stderr]    Compiling itertools v0.14.0
[INFO] [stderr]    Compiling hashbrown v0.17.0
[INFO] [stderr]    Compiling regex-syntax v0.8.10
[INFO] [stderr]    Compiling futures-sink v0.3.34
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling hybrid-array v0.4.11
[INFO] [stderr]    Compiling bitflags v2.11.1
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling block-buffer v0.12.0
[INFO] [stderr]    Compiling crypto-common v0.2.1
[INFO] [stderr]    Compiling ring v0.17.14
[INFO] [stderr]    Compiling futures-channel v0.3.34
[INFO] [stderr]    Compiling indexmap v2.14.0
[INFO] [stderr]    Compiling digest v0.11.2
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling fastrand v2.4.1
[INFO] [stderr]    Compiling futures-io v0.3.34
[INFO] [stderr]    Compiling once_cell v1.21.4
[INFO] [stderr]    Compiling petgraph v0.8.3
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling mio v1.2.0
[INFO] [stderr]    Compiling getrandom v0.2.17
[INFO] [stderr]    Compiling socket2 v0.6.3
[INFO] [stderr]    Compiling memoffset v0.9.1
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling semver v1.0.28
[INFO] [stderr]    Compiling thiserror v2.0.21
[INFO] [stderr]    Compiling cfg_aliases v0.2.1
[INFO] [stderr]    Compiling subtle v2.6.1
[INFO] [stderr]    Compiling rustc_version v0.4.1
[INFO] [stderr]    Compiling nix v0.31.2
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling allocator-api2 v0.2.21
[INFO] [stderr]    Compiling rustls v0.23.45
[INFO] [stderr]    Compiling tinyvec v1.11.0
[INFO] [stderr]    Compiling synstructure v0.13.2
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling futures-macro v0.3.34
[INFO] [stderr]    Compiling prettyplease v0.2.37
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling thiserror-impl v2.0.21
[INFO] [stderr]    Compiling futures-util v0.3.34
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling libsqlite3-sys v0.38.2
[INFO] [stderr]    Compiling curve25519-dalek v5.0.0
[INFO] [stderr]    Compiling concurrent-queue v2.5.0
[INFO] [stderr]    Compiling zerofrom-derive v0.1.7
[INFO] [stderr]    Compiling yoke-derive v0.8.2
[INFO] [stderr]    Compiling zerovec-derive v0.11.3
[INFO] [stderr]    Compiling displaydoc v0.2.5
[INFO] [stderr]    Compiling zeroize_derive v1.5.0
[INFO] [stderr]    Compiling prost-derive v0.14.4
[INFO] [stderr]    Compiling tokio-macros v2.7.0
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling curve25519-dalek-derive v0.1.1
[INFO] [stderr]    Compiling zerofrom v0.1.7
[INFO] [stderr]    Compiling yoke v0.8.2
[INFO] [stderr]    Compiling zeroize v1.9.0
[INFO] [stderr]    Compiling zerovec v0.11.6
[INFO] [stderr]    Compiling zerotrie v0.2.4
[INFO] [stderr]    Compiling rustls-pki-types v1.14.1
[INFO] [stderr]    Compiling tokio v1.53.1
[INFO] [stderr]    Compiling event-listener v5.4.1
[INFO] [stderr]    Compiling rustls-webpki v0.103.15
[INFO] [stderr]    Compiling webpki-roots v1.0.7
[INFO] [stderr]    Compiling tinystr v0.8.3
[INFO] [stderr]    Compiling potential_utf v0.1.5
[INFO] [stderr]    Compiling icu_collections v2.2.0
[INFO] [stderr]    Compiling icu_locale_core v2.2.0
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling prost v0.14.4
[INFO] [stderr]    Compiling prost-types v0.14.4
[INFO] [stderr]    Compiling chrono v0.4.45
[INFO] [stderr]    Compiling futures-executor v0.3.34
[INFO] [stderr]    Compiling hashlink v0.11.0
[INFO] [stderr]    Compiling futures-intrusive v0.5.0
[INFO] [stderr]    Compiling unicode-normalization v0.1.25
[INFO] [stderr]    Compiling icu_provider v2.2.0
[INFO] [stderr]    Compiling uuid v1.26.1
[INFO] [stderr]    Compiling icu_properties v2.2.0
[INFO] [stderr]    Compiling icu_normalizer v2.2.0
[INFO] [stderr]    Compiling prost-build v0.14.4
[INFO] [stderr]    Compiling crossbeam-queue v0.3.12
[INFO] [stderr]    Compiling serde_spanned v1.1.1
[INFO] [stderr]    Compiling toml_datetime v1.1.1+spec-1.1.0
[INFO] [stderr]    Compiling chacha20 v0.10.2
[INFO] [stderr]    Compiling sha2 v0.11.0
[INFO] [stderr]    Compiling hmac v0.13.0
[INFO] [stderr]    Compiling unicode-properties v0.1.4
[INFO] [stderr]    Compiling base64 v0.22.1
[INFO] [stderr]    Compiling idna_adapter v1.2.1
[INFO] [stderr]    Compiling idna v1.1.0
[INFO] [stderr]    Compiling signature v3.0.0
[INFO] [stderr]    Compiling sysknife-proto v0.25.0
[INFO] [stderr]    Compiling toml_writer v1.1.2+spec-1.1.0
[INFO] [stderr]    Compiling ed25519 v3.0.0
[INFO] [stderr]    Compiling toml v1.1.3+spec-1.1.0
[INFO] [stderr]    Compiling url v2.5.8
[INFO] [stderr]    Compiling stringprep v0.1.5
[INFO] [stderr]    Compiling hkdf v0.13.0
[INFO] [stderr]    Compiling rand v0.10.2
[INFO] [stderr]    Compiling futures v0.3.34
[INFO] [stderr]    Compiling vsock v0.5.4
[INFO] [stderr]    Compiling atoi v2.0.0
[INFO] [stderr]    Compiling hashlink v0.12.1
[INFO] [stderr]    Compiling md-5 v0.11.0
[INFO] [stderr]    Compiling hex v0.4.3
[INFO] [stderr]    Compiling whoami v2.1.2
[INFO] [stderr]    Compiling byteorder v1.5.0
[INFO] [stderr]    Compiling tokio-stream v0.1.18
[INFO] [stderr]    Compiling dotenvy v0.15.7
[INFO] [stderr]    Compiling tokio-vsock v0.7.2
[INFO] [stderr]    Compiling sqlx-core v0.9.0
[INFO] [stderr]    Compiling sysknife-core v0.25.0
[INFO] [stderr]    Compiling ed25519-dalek v3.0.0
[INFO] [stderr]    Compiling sysknife-types v0.25.0
[INFO] [stderr]    Compiling async-trait v0.1.92
[INFO] [stderr]    Compiling sqlx-postgres v0.9.0
[INFO] [stderr]    Compiling rusqlite v0.40.2
[INFO] [stderr]    Compiling sysknife-daemon v0.25.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 2m 27s
[INFO] [stderr] warning: the following packages contain code that will be rejected by a future version of Rust: nix v0.31.2
[INFO] [stderr] note: to see what the problems were, use the option `--future-incompat-report`, or run `cargo report future-incompatibilities --id 1`
[INFO] running `Command { std: "docker" "inspect" "f87c95844b4d33a8a02dae4638455ec4476390ccf4224712fbdcf27ff23e83c5", 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" "f87c95844b4d33a8a02dae4638455ec4476390ccf4224712fbdcf27ff23e83c5" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling jobserver v0.1.34
[INFO] [stderr]    Compiling tokio v1.53.1
[INFO] [stderr]    Compiling futures-task v0.3.34
[INFO] [stderr]    Compiling aws-lc-rs v1.18.1
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling indexmap v2.14.0
[INFO] [stderr]    Compiling rustls v0.23.45
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling futures-util v0.3.34
[INFO] [stderr]    Compiling icu_normalizer v2.2.0
[INFO] [stderr]    Compiling http v1.5.0
[INFO] [stderr]    Compiling cc v1.2.61
[INFO] [stderr]    Compiling idna_adapter v1.2.1
[INFO] [stderr]    Compiling idna v1.1.0
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling petgraph v0.8.3
[INFO] [stderr]    Compiling http-body v1.0.1
[INFO] [stderr]    Compiling cmake v0.1.58
[INFO] [stderr]    Compiling url v2.5.8
[INFO] [stderr]    Compiling darling_core v0.20.11
[INFO] [stderr]    Compiling unicase v2.9.0
[INFO] [stderr]    Compiling mime_guess v2.0.5
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling aws-lc-sys v0.45.0
[INFO] [stderr]    Compiling ring v0.17.14
[INFO] [stderr]    Compiling winnow v1.0.2
[INFO] [stderr]    Compiling rustls-native-certs v0.8.3
[INFO] [stderr]    Compiling prost-build v0.14.4
[INFO] [stderr]    Compiling libsqlite3-sys v0.38.2
[INFO] [stderr]    Compiling chrono v0.4.45
[INFO] [stderr]    Compiling futures-executor v0.3.34
[INFO] [stderr]    Compiling futures v0.3.34
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling toml_parser v1.1.2+spec-1.1.0
[INFO] [stderr]    Compiling sysknife-proto v0.25.0
[INFO] [stderr]    Compiling iri-string v0.7.12
[INFO] [stderr]    Compiling darling_macro v0.20.11
[INFO] [stderr]    Compiling nom v7.1.3
[INFO] [stderr]    Compiling darling v0.20.11
[INFO] [stderr]    Compiling derive_builder_core v0.20.2
[INFO] [stderr]    Compiling toml_edit v0.25.11+spec-1.1.0
[INFO] [stderr]    Compiling serde_urlencoded v0.7.1
[INFO] [stderr]    Compiling nix v0.31.2
[INFO] [stderr]    Compiling futures-intrusive v0.5.0
[INFO] [stderr]    Compiling tokio-util v0.7.18
[INFO] [stderr]    Compiling tokio-stream v0.1.18
[INFO] [stderr]    Compiling http-body-util v0.1.3
[INFO] [stderr]    Compiling h2 v0.4.16
[INFO] [stderr]    Compiling tower v0.5.3
[INFO] [stderr]    Compiling serde_derive_internals v0.29.1
[INFO] [stderr]    Compiling ref-cast-impl v1.0.25
[INFO] [stderr]    Compiling pin-project-internal v1.1.11
[INFO] [stderr]    Compiling tower-http v0.6.8
[INFO] [stderr]    Compiling unicode-segmentation v1.13.2
[INFO] [stderr]    Compiling schemars_derive v1.2.1
[INFO] [stderr]    Compiling convert_case v0.11.0
[INFO] [stderr]    Compiling pin-project v1.1.11
[INFO] [stderr]    Compiling ref-cast v1.0.25
[INFO] [stderr]    Compiling eventsource-stream v0.2.3
[INFO] [stderr]    Compiling vsock v0.5.4
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling derive_builder_macro v0.20.2
[INFO] [stderr]    Compiling proc-macro-crate v3.5.0
[INFO] [stderr]    Compiling sysknife-core v0.25.0
[INFO] [stderr]    Compiling sysknife-types v0.25.0
[INFO] [stderr]    Compiling async-stream-impl v0.3.6
[INFO] [stderr]    Compiling indoc v2.0.7
[INFO] [stderr]    Compiling schemars v1.2.1
[INFO] [stderr]    Compiling async-stream v0.3.6
[INFO] [stderr]    Compiling rand v0.9.4
[INFO] [stderr]    Compiling rig-derive v0.40.0
[INFO] [stderr]    Compiling derive_builder v0.20.2
[INFO] [stderr]    Compiling tokio-vsock v0.7.2
[INFO] [stderr]    Compiling tracing-futures v0.2.5
[INFO] [stderr]    Compiling ordered-float v5.3.0
[INFO] [stderr]    Compiling secrecy v0.10.3
[INFO] [stderr]    Compiling async-openai-macros v0.3.0
[INFO] [stderr]    Compiling as-any v0.3.2
[INFO] [stderr]    Compiling futures-timer v3.0.3
[INFO] [stderr]    Compiling nom v8.0.0
[INFO] [stderr]    Compiling hyper v1.9.0
[INFO] [stderr]    Compiling hyper-util v0.1.20
[INFO] [stderr]    Compiling syslog_loose v0.23.0
[INFO] [stderr]    Compiling rusqlite v0.40.2
[INFO] [stderr]    Compiling rustls-webpki v0.103.15
[INFO] [stderr]    Compiling tokio-rustls v0.26.4
[INFO] [stderr]    Compiling rustls-platform-verifier v0.6.2
[INFO] [stderr]    Compiling sqlx-core v0.9.0
[INFO] [stderr]    Compiling hyper-rustls v0.27.9
[INFO] [stderr]    Compiling reqwest v0.13.2
[INFO] [stderr]    Compiling sqlx-postgres v0.9.0
[INFO] [stderr]    Compiling rig-core v0.40.0
[INFO] [stderr]    Compiling async-openai v0.42.0
[INFO] [stderr]    Compiling sysknife-daemon v0.25.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling sysknife-brain v0.25.0
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 5m 08s
[INFO] [stderr] warning: the following packages contain code that will be rejected by a future version of Rust: nix v0.31.2
[INFO] [stderr] note: to see what the problems were, use the option `--future-incompat-report`, or run `cargo report future-incompatibilities --id 1`
[INFO] running `Command { std: "docker" "inspect" "f87c95844b4d33a8a02dae4638455ec4476390ccf4224712fbdcf27ff23e83c5", 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" "f87c95844b4d33a8a02dae4638455ec4476390ccf4224712fbdcf27ff23e83c5" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.02s
[INFO] [stderr] warning: the following packages contain code that will be rejected by a future version of Rust: nix v0.31.2
[INFO] [stderr] note: to see what the problems were, use the option `--future-incompat-report`, or run `cargo report future-incompatibilities --id 1`
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/sysknife-daemon/15cc1def05cd0832/out/sysknife_daemon-15cc1def05cd0832)
[INFO] [stdout] 
[INFO] [stdout] running 923 tests
[INFO] [stdout] test actions::apparmor::tests::apparmor_complain_argv ... ok
[INFO] [stdout] test actions::apparmor::tests::apparmor_status_action_name ... ok
[INFO] [stdout] test actions::apparmor::tests::apparmor_enforce_action_name ... ok
[INFO] [stdout] test actions::apparmor::tests::apparmor_enforce_argv ... ok
[INFO] [stdout] test actions::apparmor::tests::apparmor_status_argv ... ok
[INFO] [stdout] test actions::apparmor::tests::apparmor_status_risk_is_low ... ok
[INFO] [stdout] test actions::apparmor::tests::complain_uses_aa_complain_not_aa_enforce ... ok
[INFO] [stdout] test actions::apparmor::tests::specs_covers_all_action_names ... ok
[INFO] [stdout] test actions::apt::tests::apt_autoremove_action_name ... ok
[INFO] [stdout] test actions::apparmor::tests::apparmor_complain_action_name ... ok
[INFO] [stdout] test actions::apt::tests::apt_autoremove_argv_correct ... ok
[INFO] [stdout] test actions::apt::tests::apt_autoremove_risk_is_medium ... ok
[INFO] [stdout] test actions::apt::tests::apt_history_list_uses_bash_and_grep ... ok
[INFO] [stdout] test actions::apparmor::tests::apparmor_complain_risk_is_high ... ok
[INFO] [stdout] test actions::apparmor::tests::apparmor_enforce_risk_is_high ... ok
[INFO] [stdout] test actions::apt::tests::apt_history_list_risk_is_low ... ok
[INFO] [stdout] test actions::apt::tests::apt_install_includes_package_name ... ok
[INFO] [stdout] test actions::apt::tests::apt_install_risk_is_medium ... ok
[INFO] [stdout] test actions::apt::tests::apt_install_action_name ... ok
[INFO] [stdout] test actions::apt::tests::apt_history_list_action_name ... ok
[INFO] [stdout] test actions::apt::tests::apt_hold_action_name ... ok
[INFO] [stdout] test actions::apt::tests::apt_list_installed_action_name ... ok
[INFO] [stdout] test actions::apt::tests::apt_hold_risk_is_medium ... ok
[INFO] [stdout] test actions::apt::tests::apt_list_installed_uses_dpkg ... ok
[INFO] [stdout] test actions::apt::tests::apt_list_upgradable_uses_bash_and_apt_list ... ok
[INFO] [stdout] test actions::apt::tests::apt_list_installed_risk_is_low ... ok
[INFO] [stdout] test actions::apt::tests::apt_purge_action_name ... ok
[INFO] [stdout] test actions::apt::tests::apt_remove_action_name ... ok
[INFO] [stdout] test actions::apt::tests::apt_remove_argv_contains_remove_not_purge ... ok
[INFO] [stdout] test actions::apt::tests::apt_purge_argv_uses_purge_subcommand ... ok
[INFO] [stdout] test actions::apt::tests::apt_purge_risk_is_medium ... ok
[INFO] [stdout] test actions::apt::tests::apt_search_action_name ... ok
[INFO] [stdout] test actions::apt::tests::apt_search_risk_is_low ... ok
[INFO] [stdout] test actions::apt::tests::apt_show_action_name ... ok
[INFO] [stdout] test actions::apt::tests::apt_show_risk_is_low ... ok
[INFO] [stdout] test actions::apt::tests::apt_show_uses_apt_cache_show ... ok
[INFO] [stdout] test actions::apt::tests::apt_list_upgradable_action_name ... ok
[INFO] [stdout] test actions::apt::tests::apt_hold_uses_apt_mark_hold ... ok
[INFO] [stdout] test actions::apt::tests::apt_list_upgradable_risk_is_low ... ok
[INFO] [stdout] test actions::apparmor::tests::enforce_uses_aa_enforce_not_aa_complain ... ok
[INFO] [stdout] test actions::apt::tests::apt_remove_risk_is_medium ... ok
[INFO] [stdout] test actions::apt::tests::apt_unhold_uses_apt_mark_unhold ... ok
[INFO] [stdout] test actions::apt::tests::apt_update_no_reboot_no_rollback ... ok
[INFO] [stdout] test actions::apt::tests::apt_update_risk_is_low ... ok
[INFO] [stdout] test actions::apt::tests::apt_upgrade_argv_correct ... ok
[INFO] [stdout] test actions::apt::tests::apt_upgrade_risk_is_high ... ok
[INFO] [stdout] test actions::apt::tests::mutating_apt_commands_carry_env_vars ... ok
[INFO] [stdout] test actions::apt::tests::parse_autoremove_deduplicates_and_sorts ... ok
[INFO] [stdout] test actions::apt::tests::apt_search_no_sudo ... ok
[INFO] [stdout] test actions::apt::tests::apt_search_uses_apt_cache_search ... ok
[INFO] [stdout] test actions::apt::tests::parse_autoremove_keeps_arch_suffix_and_ignores_non_remv_lines ... ok
[INFO] [stdout] test actions::apt::tests::parse_autoremove_on_empty_or_nothing_to_remove_is_empty ... ok
[INFO] [stdout] test actions::apt::tests::apt_unhold_action_name ... ok
[INFO] [stdout] test actions::apt::tests::apt_unhold_risk_is_medium ... ok
[INFO] [stdout] test actions::apt::tests::apt_update_action_name ... ok
[INFO] [stdout] test actions::apt::tests::apt_update_argv_correct ... ok
[INFO] [stdout] test actions::apt::tests::specs_covers_all_action_names ... ok
[INFO] [stdout] test actions::auditd::tests::remove_rule_shape ... ok
[INFO] [stdout] test actions::apt_preferences::tests::get_pins_optional_package ... ok
[INFO] [stdout] test actions::apt::tests::apt_upgrade_action_name ... ok
[INFO] [stdout] test actions::apt::tests::parse_autoremove_extracts_the_remv_package_set ... ok
[INFO] [stdout] test actions::auditd::tests::add_rule_shape ... ok
[INFO] [stdout] test actions::cloudinit::tests::cloud_init_status_action_name ... ok
[INFO] [stdout] test actions::cloudinit::tests::cloud_init_status_argv ... ok
[INFO] [stdout] test actions::certbot::tests::get_certs_read_only ... ok
[INFO] [stdout] test actions::cloudinit::tests::cloud_init_status_no_sudo ... ok
[INFO] [stdout] test actions::distrobox::tests::distrobox_create_action_name ... ok
[INFO] [stdout] test actions::distrobox::tests::distrobox_create_argv_includes_name_and_image ... ok
[INFO] [stdout] test actions::distrobox::tests::distrobox_create_includes_yes_flag ... ok
[INFO] [stdout] test actions::distrobox::tests::distrobox_list_action_name ... ok
[INFO] [stdout] test actions::certbot::tests::obtain_builds_multi_domain_argv ... ok
[INFO] [stdout] test actions::apt_preferences::tests::set_and_remove_shapes ... ok
[INFO] [stdout] test actions::certbot::tests::renew_shape ... ok
[INFO] [stdout] test actions::auditd::tests::get_rules_is_read_only ... ok
[INFO] [stdout] test actions::distrobox::tests::distrobox_list_argv ... ok
[INFO] [stdout] test actions::distrobox::tests::distrobox_list_risk_low ... ok
[INFO] [stdout] test actions::distrobox::tests::distrobox_remove_risk_medium ... ok
[INFO] [stdout] test actions::distrobox::tests::distrobox_remove_uses_force_flag ... ok
[INFO] [stdout] test actions::distrobox::tests::specs_covers_all_action_names ... ok
[INFO] [stdout] test actions::distrobox::tests::distrobox_list_no_reboot ... ok
[INFO] [stdout] test actions::cloudinit::tests::cloud_init_status_risk_is_low ... ok
[INFO] [stdout] test actions::distrobox::tests::distrobox_remove_action_name ... ok
[INFO] [stdout] test actions::cloudinit::tests::specs_covers_cloud_init_status ... ok
[INFO] [stdout] test actions::distrobox::tests::distrobox_create_risk_medium ... ok
[INFO] [stdout] test actions::fail2ban::tests::configure_fail2ban_jail_rejects_invalid_name ... ok
[INFO] [stdout] test actions::fail2ban::tests::fail2ban_ban_ip_accepts_ipv6 ... ok
[INFO] [stdout] test actions::fail2ban::tests::configure_jail_routes_through_helper ... ok
[INFO] [stdout] test actions::fail2ban::tests::fail2ban_ban_ip_rejects_jail_with_shell_metachars ... ok
[INFO] [stdout] test actions::fail2ban::tests::fail2ban_ban_ip_action_name ... ok
[INFO] [stdout] test actions::fail2ban::tests::fail2ban_ban_ip_rejects_leading_dash_jail ... ok
[INFO] [stdout] test actions::fail2ban::tests::fail2ban_ban_ip_risk_is_high ... ok
[INFO] [stdout] test actions::fail2ban::tests::fail2ban_status_action_name ... ok
[INFO] [stdout] test actions::fail2ban::tests::fail2ban_status_risk_is_low ... ok
[INFO] [stdout] test actions::fail2ban::tests::fail2ban_unban_ip_argv_ordering ... ok
[INFO] [stdout] test actions::fail2ban::tests::fail2ban_unban_ip_rejects_invalid_ip ... ok
[INFO] [stdout] test actions::fail2ban::tests::fail2ban_unban_ip_rejects_invalid_jail ... ok
[INFO] [stdout] test actions::fail2ban::tests::fail2ban_unban_ip_risk_is_medium ... ok
[INFO] [stdout] test actions::fail2ban::tests::specs_covers_all_action_names ... ok
[INFO] [stdout] test actions::fail2ban::tests::fail2ban_status_global_argv ... ok
[INFO] [stdout] test actions::fail2ban::tests::fail2ban_ban_ip_argv_ordering ... ok
[INFO] [stdout] test actions::fail2ban::tests::fail2ban_ban_ip_rejects_invalid_ip ... ok
[INFO] [stdout] test actions::fail2ban::tests::fail2ban_status_jail_argv ... ok
[INFO] [stdout] test actions::fail2ban::tests::fail2ban_status_rejects_invalid_jail ... ok
[INFO] [stdout] test actions::fail2ban::tests::fail2ban_unban_ip_action_name ... ok
[INFO] [stdout] test actions::grub::tests::grub_get_kargs_action_name ... ok
[INFO] [stdout] test actions::grub::tests::grub_get_kargs_no_reboot_no_rollback ... ok
[INFO] [stdout] test actions::grub::tests::grub_get_kargs_risk_is_low ... ok
[INFO] [stdout] test actions::grub::tests::grub_get_kargs_uses_grep_on_grub_default ... ok
[INFO] [stdout] test actions::grub::tests::grub_set_kargs_action_name ... ok
[INFO] [stdout] test actions::grub::tests::grub_set_kargs_argv_shape_append_only ... ok
[INFO] [stdout] test actions::grub::tests::grub_set_kargs_argv_shape_both ... ok
[INFO] [stdout] test actions::grub::tests::grub_set_kargs_argv_shape_delete_only ... ok
[INFO] [stdout] test actions::grub::tests::grub_set_kargs_invokes_sudo_helper ... ok
[INFO] [stdout] test actions::grub::tests::grub_set_kargs_no_automatic_rollback ... ok
[INFO] [stdout] test actions::grub::tests::grub_set_kargs_reboot_required ... ok
[INFO] [stdout] test actions::grub::tests::grub_set_kargs_rejects_both_empty ... ok
[INFO] [stdout] test actions::journald::tests::vacuum_by_size_and_time ... ok
[INFO] [stdout] test actions::livepatch::tests::livepatch_status_action_name ... ok
[INFO] [stdout] test actions::grub::tests::specs_covers_all_action_names ... ok
[INFO] [stdout] test actions::journald::tests::get_journal_log_builds_attached_filters ... ok
[INFO] [stdout] test actions::journald::tests::kernel_query_uses_dmesg ... ok
[INFO] [stdout] test actions::grub::tests::grub_set_kargs_risk_is_high ... ok
[INFO] [stdout] test actions::livepatch::tests::livepatch_status_argv ... ok
[INFO] [stdout] test actions::livepatch::tests::livepatch_status_risk_low ... ok
[INFO] [stdout] test actions::logging::tests::syslog_forward_tcp_and_removes ... ok
[INFO] [stdout] test actions::lvm::tests::create_lv_and_snapshot_shapes ... ok
[INFO] [stdout] test actions::lvm::tests::extend_uses_resizefs_flag_and_vg_lv_ref ... ok
[INFO] [stdout] test actions::lvm::tests::report_is_read_only_json ... ok
[INFO] [stdout] test actions::livepatch::tests::livepatch_status_no_reboot ... ok
[INFO] [stdout] test actions::mounts::tests::add_mount_passes_op_and_optional_options ... ok
[INFO] [stdout] test actions::livepatch::tests::livepatch_status_no_rollback ... ok
[INFO] [stdout] test actions::logging::tests::logrotate_status_dry_run ... ok
[INFO] [stdout] test actions::multipass::tests::multipass_list_action_name ... ok
[INFO] [stdout] test actions::multipass::tests::multipass_list_argv ... ok
[INFO] [stdout] test actions::multipass::tests::multipass_list_no_reboot ... ok
[INFO] [stdout] test actions::mounts::tests::get_mounts_is_read_only_json ... ok
[INFO] [stdout] test actions::netplan::tests::netplan_apply_action_name ... ok
[INFO] [stdout] test actions::mounts::tests::swap_ops_shapes ... ok
[INFO] [stdout] test actions::livepatch::tests::specs_covers_all_action_names ... ok
[INFO] [stdout] test actions::netplan::tests::netplan_apply_argv ... ok
[INFO] [stdout] test actions::logging::tests::configure_rotation_with_compress ... ok
[INFO] [stdout] test actions::netplan::tests::netplan_apply_no_reboot ... ok
[INFO] [stdout] test actions::multipass::tests::specs_covers_all_action_names ... ok
[INFO] [stdout] test actions::netplan::tests::netplan_apply_risk_high ... ok
[INFO] [stdout] test actions::netplan::tests::netplan_generate_action_name ... ok
[INFO] [stdout] test actions::netplan::tests::netplan_generate_argv ... ok
[INFO] [stdout] test actions::netplan::tests::netplan_generate_no_reboot ... ok
[INFO] [stdout] test actions::netplan::tests::netplan_get_config_risk_low ... ok
[INFO] [stdout] test actions::netplan::tests::netplan_get_config_uses_find_directly ... ok
[INFO] [stdout] test actions::netplan::tests::netplan_set_action_name ... ok
[INFO] [stdout] test actions::netplan::tests::netplan_set_argv_never_contains_literal_quote_bytes ... ok
[INFO] [stdout] test actions::netplan::tests::netplan_get_config_no_reboot ... ok
[INFO] [stdout] test actions::netplan::tests::netplan_generate_risk_medium ... ok
[INFO] [stdout] test actions::netplan::tests::netplan_get_config_action_name ... ok
[INFO] [stdout] test actions::netplan::tests::netplan_generate_no_rollback ... ok
[INFO] [stdout] test actions::netplan::tests::netplan_set_risk_high ... ok
[INFO] [stdout] test actions::multipass::tests::multipass_list_no_rollback ... ok
[INFO] [stdout] test actions::netplan::tests::netplan_set_argv_simple_value ... ok
[INFO] [stdout] test actions::netplan::tests::specs_covers_all_action_names ... ok
[INFO] [stdout] test actions::multipass::tests::multipass_list_risk_low ... ok
[INFO] [stdout] test actions::netplan::tests::netplan_set_no_automatic_rollback ... ok
[INFO] [stdout] test actions::netplan::tests::netplan_set_no_reboot ... ok
[INFO] [stdout] test actions::pam::tests::get_aging_is_read_only_direct_chage ... ok
[INFO] [stdout] test actions::ppa::tests::add_ppa_argv_correct ... ok
[INFO] [stdout] test actions::ppa::tests::add_ppa_no_automatic_rollback ... ok
[INFO] [stdout] test actions::ppa::tests::remove_ppa_action_name ... ok
[INFO] [stdout] test actions::ppa::tests::remove_ppa_argv_contains_remove_flag ... ok
[INFO] [stdout] test actions::pam::tests::set_aging_appends_user_after_flags ... ok
[INFO] [stdout] test actions::ppa::tests::add_ppa_action_name ... ok
[INFO] [stdout] test actions::ppa::tests::specs_covers_all_action_names ... ok
[INFO] [stdout] test actions::reboot::tests::check_pending_reboot_action_name ... ok
[INFO] [stdout] test actions::network::firewall_tests::firewall_queries_have_fixed_read_only_mechanisms ... ok
[INFO] [stdout] test actions::reboot::tests::check_pending_reboot_no_reboot_no_rollback ... ok
[INFO] [stdout] test actions::pam::tests::policy_and_lockout_route_through_helper ... ok
[INFO] [stdout] test actions::reboot::tests::check_pending_reboot_risk_is_low ... ok
[INFO] [stdout] test actions::reboot::tests::check_pending_reboot_script_references_sentinel_file ... ok
[INFO] [stdout] test actions::ppa::tests::add_ppa_risk_is_high ... ok
[INFO] [stdout] test actions::ppa::tests::remove_ppa_no_automatic_rollback ... ok
[INFO] [stdout] test actions::reboot::tests::check_pending_reboot_script_uses_ubuntu_dot_pkgs_filename ... ok
[INFO] [stdout] test actions::ppa::tests::ppa_arg_prepends_ppa_prefix ... ok
[INFO] [stdout] test actions::reboot::tests::check_pending_reboot_uses_bash ... ok
[INFO] [stdout] test actions::reboot::tests::specs_covers_check_pending_reboot ... ok
[INFO] [stdout] test actions::reboot::tests::check_pending_reboot_script_references_pkgs_file ... ok
[INFO] [stdout] test actions::ppa::tests::remove_ppa_risk_is_medium ... ok
[INFO] [stdout] test actions::release_upgrade::tests::specs_covers_all_action_names ... ok
[INFO] [stdout] test actions::release_upgrade::tests::ubuntu_release_upgrade_no_rollback ... ok
[INFO] [stdout] test actions::release_upgrade::tests::ubuntu_release_upgrade_action_name ... ok
[INFO] [stdout] test actions::release_upgrade::tests::ubuntu_release_upgrade_argv ... ok
[INFO] [stdout] test actions::resolvectl::tests::resolvectl_set_dns_action_name ... ok
[INFO] [stdout] test actions::resolvectl::tests::resolvectl_set_dns_argv_ordering ... ok
[INFO] [stdout] test actions::resolvectl::tests::resolvectl_set_dns_risk_is_high ... ok
[INFO] [stdout] test actions::release_upgrade::tests::ubuntu_release_upgrade_reboot_required ... ok
[INFO] [stdout] test actions::release_upgrade::tests::ubuntu_release_upgrade_risk_high ... ok
[INFO] [stdout] test actions::resolvectl::tests::resolvectl_set_dns_accepts_ipv6 ... ok
[INFO] [stdout] test actions::resolvectl::tests::resolvectl_status_action_name ... ok
[INFO] [stdout] test actions::resolvectl::tests::resolvectl_status_argv ... ok
[INFO] [stdout] test actions::resolvectl::tests::resolvectl_status_risk_is_low ... ok
[INFO] [stdout] test actions::resolvectl::tests::specs_covers_all_action_names ... ok
[INFO] [stdout] test actions::resolvectl::tests::resolvectl_status_no_sudo ... ok
[INFO] [stdout] test actions::resolvectl::tests::resolvectl_set_dns_single_server ... ok
[INFO] [stdout] test actions::services::tests::get_resource_limits_is_read_only_show ... ok
[INFO] [stdout] test actions::services::tests::set_resource_limits_builds_set_property ... ok
[INFO] [stdout] test actions::snap::tests::snap_classic_install_risk_medium ... ok
[INFO] [stdout] test actions::snap::tests::snap_hold_argv_uses_refresh_hold ... ok
[INFO] [stdout] test actions::snap::tests::snap_info_action_name ... ok
[INFO] [stdout] test actions::snap::tests::snap_classic_install_action_name ... ok
[INFO] [stdout] test actions::snap::tests::snap_info_no_sudo ... ok
[INFO] [stdout] test actions::snap::tests::snap_info_includes_name ... ok
[INFO] [stdout] test actions::reboot::tests::pending_reboot_without_sentinel_reports_no_reboot ... ok
[INFO] [stdout] test actions::snap::tests::snap_info_risk_low ... ok
[INFO] [stdout] test actions::snap::tests::snap_hold_action_name ... ok
[INFO] [stdout] test actions::snap::tests::snap_install_action_name ... ok
[INFO] [stdout] test actions::snap::tests::snap_classic_install_argv_contains_classic_flag ... ok
[INFO] [stdout] test actions::snap::tests::snap_install_auto_update_no_hold ... ok
[INFO] [stdout] test actions::snap::tests::snap_install_custom_channel ... ok
[INFO] [stdout] test actions::snap::tests::snap_list_action_name ... ok
[INFO] [stdout] test actions::snap::tests::snap_install_rejects_shell_metacharacters_in_name ... ok
[INFO] [stdout] test actions::snap::tests::snap_list_no_sudo ... ok
[INFO] [stdout] test actions::snap::tests::snap_install_default_includes_hold ... ok
[INFO] [stdout] test actions::snap::tests::snap_install_rejects_leading_dash_name ... ok
[INFO] [stdout] test actions::snap::tests::snap_install_rejects_shell_metacharacters_in_channel ... ok
[INFO] [stdout] test actions::snap::tests::snap_install_risk_medium ... ok
[INFO] [stdout] test actions::snap::tests::snap_list_risk_low ... ok
[INFO] [stdout] test actions::snap::tests::snap_refresh_all_no_extra_args ... ok
[INFO] [stdout] test actions::snap::tests::snap_refresh_named ... ok
[INFO] [stdout] test actions::snap::tests::snap_remove_action_name ... ok
[INFO] [stdout] test actions::snap::tests::snap_remove_argv ... ok
[INFO] [stdout] test actions::snap::tests::snap_remove_risk_medium ... ok
[INFO] [stdout] test actions::snap::tests::snap_revert_argv_correct ... ok
[INFO] [stdout] test actions::snap::tests::snap_revert_risk_medium ... ok
[INFO] [stdout] test actions::snap::tests::snap_unhold_action_name ... ok
[INFO] [stdout] test actions::snap::tests::snap_unhold_argv_uses_refresh_unhold ... ok
[INFO] [stdout] test actions::snap::tests::specs_covers_all_action_names ... ok
[INFO] [stdout] test actions::sudoers::tests::grant_builds_flags_including_optional_runas_and_nopasswd ... ok
[INFO] [stdout] test actions::sudoers::tests::list_is_read_only_bare_helper ... ok
[INFO] [stdout] test actions::sudoers::tests::revoke_shape ... ok
[INFO] [stdout] test actions::sysctl::tests::get_all_uses_minus_a ... ok
[INFO] [stdout] test actions::sysctl::tests::get_one_key_uses_dash_dash_guard ... ok
[INFO] [stdout] test actions::sysctl::tests::set_delegates_to_scoped_helper ... ok
[INFO] [stdout] test actions::system_info::tests::get_host_state_is_a_read_only_unprivileged_query ... ok
[INFO] [stdout] test actions::ubuntu_pro::tests::disable_service_argv ... ok
[INFO] [stdout] test actions::ubuntu_pro::tests::enable_service_argv ... ok
[INFO] [stdout] test actions::ubuntu_pro::tests::pro_attach_action_name ... ok
[INFO] [stdout] test actions::ubuntu_pro::tests::pro_attach_action_name_does_not_contain_token ... ok
[INFO] [stdout] test actions::ubuntu_pro::tests::pro_attach_no_automatic_rollback ... ok
[INFO] [stdout] test actions::snap::tests::snap_revert_action_name ... ok
[INFO] [stdout] test actions::ubuntu_pro::tests::pro_attach_specs_uses_redacted_sentinel ... ok
[INFO] [stdout] test actions::ubuntu_pro::tests::pro_attach_risk_high ... ok
[INFO] [stdout] test actions::reboot::tests::pending_reboot_with_sentinel_and_pkgs_lists_both ... ok
[INFO] [stdout] test actions::ubuntu_pro::tests::pro_attach_token_in_args ... ok
[INFO] [stdout] test actions::ubuntu_pro::tests::pro_detach_risk_high ... ok
[INFO] [stdout] test actions::ubuntu_pro::tests::pro_detach_action_name ... ok
[INFO] [stdout] test actions::ubuntu_pro::tests::pro_detach_no_automatic_rollback ... ok
[INFO] [stdout] test actions::ubuntu_pro::tests::pro_status_argv ... ok
[INFO] [stdout] test actions::ubuntu_pro::tests::pro_status_no_reboot ... ok
[INFO] [stdout] test actions::ufw::tests::specs_covers_all_action_names ... ok
[INFO] [stdout] test actions::ubuntu_pro::tests::pro_status_action_name ... ok
[INFO] [stdout] test actions::ubuntu_pro::tests::pro_detach_argv ... ok
[INFO] [stdout] test actions::ubuntu_pro::tests::pro_status_risk_low ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_allow_port_in_args ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_delete_rule_accepts_one ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_allow_risk_high ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_allow_service_name ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_delete_rule_argv ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_allow_action_name ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_delete_rule_no_reboot ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_delete_rule_action_name ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_delete_rule_rejects_zero ... ok
[INFO] [stdout] test actions::ubuntu_pro::tests::specs_covers_all_action_names ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_deny_action_name ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_delete_rule_risk_high ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_disable_action_name ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_disable_argv ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_disable_risk_high ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_enable_no_reboot ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_enable_action_name ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_enable_risk_high ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_limit_action_name ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_limit_argv ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_limit_no_reboot ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_reset_action_name ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_status_action_name ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_limit_risk_high ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_status_risk_low ... ok
[INFO] [stdout] test actions::validate::tests::activatable_unit_accepts_ordinary_services ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_status_uses_verbose ... ok
[INFO] [stdout] test actions::reboot::tests::pending_reboot_with_sentinel_only_is_not_an_error ... ok
[INFO] [stdout] test actions::validate::tests::apparmor_profile_accepts_absolute_path ... ok
[INFO] [stdout] test actions::validate::tests::apparmor_profile_accepts_profile_name ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_deny_argv ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_reset_risk_high ... ok
[INFO] [stdout] test actions::validate::tests::apparmor_profile_rejects_empty ... ok
[INFO] [stdout] test actions::validate::tests::apparmor_profile_rejects_relative_with_slash ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_deny_risk_high ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_enable_argv ... ok
[INFO] [stdout] test actions::validate::tests::apparmor_profile_rejects_shell_metachars ... ok
[INFO] [stdout] test actions::validate::tests::apparmor_profile_rejects_too_long ... ok
[INFO] [stdout] test actions::validate::tests::apparmor_profile_rejects_traversal_in_path ... ok
[INFO] [stdout] test actions::validate::tests::audit_path_and_perms ... ok
[INFO] [stdout] test actions::validate::tests::domain_and_email ... ok
[INFO] [stdout] test actions::validate::tests::cpu_quota_requires_percent ... ok
[INFO] [stdout] test actions::validate::tests::group_delegates_to_username_rules ... ok
[INFO] [stdout] test actions::validate::tests::apparmor_profile_rejects_traversal_relative ... ok
[INFO] [stdout] test actions::validate::tests::group_not_critical_rejects_denylisted_groups ... ok
[INFO] [stdout] test actions::validate::tests::apparmor_profile_rejects_wrong_prefix ... ok
[INFO] [stdout] test actions::validate::tests::fstype_allowlist ... ok
[INFO] [stdout] test actions::validate::tests::group_not_critical_allows_normal_group ... ok
[INFO] [stdout] test actions::validate::tests::hostname_accepts_max_length ... ok
[INFO] [stdout] test actions::validate::tests::hostname_accepts_valid ... ok
[INFO] [stdout] test actions::validate::tests::hostname_rejects_empty ... ok
[INFO] [stdout] test actions::validate::tests::hostname_rejects_leading_dash ... ok
[INFO] [stdout] test actions::validate::tests::hostname_rejects_too_long ... ok
[INFO] [stdout] test actions::ufw::tests::ufw_reset_uses_force_flag ... ok
[INFO] [stdout] test actions::validate::tests::activatable_unit_rejects_root_shell_units ... ok
[INFO] [stdout] test actions::validate::tests::apt_pin_name_package_expr ... ok
[INFO] [stdout] test actions::validate::tests::install_package_rejects_local_file_paths ... ok
[INFO] [stdout] test actions::validate::tests::journal_priority_accepts_levels_and_ranges ... ok
[INFO] [stdout] test actions::validate::tests::locale_accepts_valid ... ok
[INFO] [stdout] test actions::validate::tests::locale_rejects_empty ... ok
[INFO] [stdout] test actions::validate::tests::hostname_rejects_empty_label ... ok
[INFO] [stdout] test actions::validate::tests::hostname_rejects_label_too_long ... ok
[INFO] [stdout] test actions::validate::tests::locale_rejects_leading_dash ... ok
[INFO] [stdout] test actions::validate::tests::locale_rejects_null_bytes ... ok
[INFO] [stdout] test actions::validate::tests::locale_rejects_slashes ... ok
[INFO] [stdout] test actions::validate::tests::hostname_rejects_spaces ... ok
[INFO] [stdout] test actions::validate::tests::hostname_rejects_underscores ... ok
[INFO] [stdout] test actions::validate::tests::journal_time_allows_forms_and_rejects_control ... ok
[INFO] [stdout] test actions::validate::tests::log_path_and_syslog_host ... ok
[INFO] [stdout] test actions::validate::tests::lvm_name_accepts_valid_and_rejects_injection ... ok
[INFO] [stdout] test actions::validate::tests::install_package_accepts_real_names ... ok
[INFO] [stdout] test actions::validate::tests::log_path_is_confined_to_the_log_root ... ok
[INFO] [stdout] test actions::validate::tests::lvm_size_accepts_absolute_relative_decimal ... ok
[INFO] [stdout] test actions::validate::tests::mount_point_rejects_critical_and_traversal ... ok
[INFO] [stdout] test actions::validate::tests::port_or_service_accepts_app_profile_names ... ok
[INFO] [stdout] test actions::validate::tests::port_or_service_accepts_app_profile_names_with_internal_spaces ... ok
[INFO] [stdout] test actions::validate::tests::port_or_service_accepts_bare_ports ... ok
[INFO] [stdout] test actions::validate::tests::port_or_service_rejects_bad_protocol_forms ... ok
[INFO] [stdout] test actions::validate::tests::port_or_service_rejects_digit_leading_non_port ... ok
[INFO] [stdout] test actions::validate::tests::port_or_service_rejects_empty ... ok
[INFO] [stdout] test actions::validate::tests::port_or_service_rejects_metachar_with_space_in_app_name ... ok
[INFO] [stdout] test actions::validate::tests::port_or_service_rejects_out_of_range_ports ... ok
[INFO] [stdout] test actions::validate::tests::lvm_size_rejects_shrink_and_junk ... ok
[INFO] [stdout] test actions::validate::tests::port_or_service_rejects_port_without_slash ... ok
[INFO] [stdout] test actions::validate::tests::memory_limit_accepts_bytes_suffix_infinity ... ok
[INFO] [stdout] test actions::validate::tests::port_or_service_rejects_shell_metachars ... ok
[INFO] [stdout] test actions::validate::tests::port_or_service_rejects_too_long_app_name ... ok
[INFO] [stdout] test actions::validate::tests::port_or_service_rejects_trailing_space_in_app_name ... ok
[INFO] [stdout] test actions::validate::tests::ppa_name_rejects_empty_ppa ... ok
[INFO] [stdout] test actions::validate::tests::ppa_name_accepts_valid ... ok
[INFO] [stdout] test actions::validate::tests::journal_grep_rejects_control_chars ... ok
[INFO] [stdout] test actions::validate::tests::ppa_name_rejects_empty_user ... ok
[INFO] [stdout] test actions::validate::tests::pro_service_allowlist ... ok
[INFO] [stdout] test actions::validate::tests::locale_rejects_spaces ... ok
[INFO] [stdout] test actions::validate::tests::resource_limit_unit_rejects_every_slice_and_scope ... ok
[INFO] [stdout] test actions::validate::tests::resource_limit_unit_rejects_the_enforcement_and_evidence_path ... ok
[INFO] [stdout] test actions::validate::tests::safe_arg_accepts_dash_not_at_start ... ok
[INFO] [stdout] test actions::validate::tests::safe_arg_accepts_valid ... ok
[INFO] [stdout] test actions::validate::tests::safe_arg_rejects_empty ... ok
[INFO] [stdout] test actions::validate::tests::safe_arg_rejects_every_shell_metacharacter ... ok
[INFO] [stdout] test actions::validate::tests::ppa_name_rejects_multiple_slashes ... ok
[INFO] [stdout] test actions::validate::tests::ppa_name_rejects_no_slash ... ok
[INFO] [stdout] test actions::validate::tests::mount_device_accepts_forms_and_rejects_junk ... ok
[INFO] [stdout] test actions::validate::tests::ppa_name_rejects_shell_metacharacters ... ok
[INFO] [stdout] test actions::validate::tests::safe_arg_rejects_null_bytes ... ok
[INFO] [stdout] test actions::validate::tests::mount_options_and_swap_path ... ok
[INFO] [stdout] test actions::validate::tests::safe_arg_rejects_unicode_and_non_ascii ... ok
[INFO] [stdout] test actions::validate::tests::port_or_service_accepts_port_protocol ... ok
[INFO] [stdout] test actions::validate::tests::sudoers_name_no_dots_or_tildes ... ok
[INFO] [stdout] test actions::validate::tests::safe_arg_rejects_oversized_input ... ok
[INFO] [stdout] test actions::validate::tests::sysctl_key_accepts_dotted_and_rejects_injection ... ok
[INFO] [stdout] test actions::validate::tests::tasks_max_positive_int_or_infinity ... ok
[INFO] [stdout] test actions::validate::tests::timezone_accepts_valid ... ok
[INFO] [stdout] test actions::validate::tests::timezone_rejects_dot_dot ... ok
[INFO] [stdout] test actions::validate::tests::timezone_rejects_empty ... ok
[INFO] [stdout] test actions::validate::tests::timezone_rejects_leading_dash ... ok
[INFO] [stdout] test actions::validate::tests::timezone_rejects_spaces ... ok
[INFO] [stdout] test actions::validate::tests::unit_name_accepts_valid ... ok
[INFO] [stdout] test actions::validate::tests::unit_name_rejects_empty ... ok
[INFO] [stdout] test actions::validate::tests::unit_name_rejects_leading_dash ... ok
[INFO] [stdout] test actions::validate::tests::unit_name_rejects_null_bytes ... ok
[INFO] [stdout] test actions::validate::tests::unit_name_rejects_slashes ... ok
[INFO] [stdout] test actions::validate::tests::unit_name_rejects_spaces ... ok
[INFO] [stdout] test actions::validate::tests::username_accepts_max_length ... ok
[INFO] [stdout] test actions::validate::tests::username_accepts_valid ... ok
[INFO] [stdout] test actions::validate::tests::username_not_critical_allows_normal_user ... ok
[INFO] [stdout] test actions::validate::tests::username_not_critical_rejects_denylisted_accounts ... ok
[INFO] [stdout] test actions::validate::tests::username_not_critical_still_enforces_charset ... ok
[INFO] [stdout] test actions::validate::tests::username_rejects_empty ... ok
[INFO] [stdout] test actions::validate::tests::username_rejects_null_bytes ... ok
[INFO] [stdout] test actions::validate::tests::username_rejects_slashes ... ok
[INFO] [stdout] test actions::validate::tests::resource_limit_unit_accepts_ordinary_services ... ok
[INFO] [stdout] test actions::validate::tests::sysctl_value_accepts_numbers_and_lists ... ok
[INFO] [stdout] test actions::validate::tests::username_rejects_starts_with_dash ... ok
[INFO] [stdout] test actions::validate::tests::username_rejects_too_long ... ok
[INFO] [stdout] test actions::validate::tests::validators_return_invalid_param_with_correct_field_name ... ok
[INFO] [stdout] test actions::validate::tests::safe_arg_rejects_starts_with_dash ... ok
[INFO] [stdout] test actions::validate::tests::sudo_commands_all_or_abs_paths ... ok
[INFO] [stdout] test actions::validate::tests::timezone_rejects_null_bytes ... ok
[INFO] [stdout] test audit_chain::tests::a_blank_principal_column_is_counted_as_naming_nobody ... ok
[INFO] [stdout] test actions::validate::tests::username_rejects_spaces ... ok
[INFO] [stdout] test actions::validate::tests::username_rejects_traversal_forms ... ok
[INFO] [stdout] test audit_chain::tests::a_chain_version_this_binary_does_not_know_is_cannot_verify ... ok
[INFO] [stdout] test audit_chain::tests::a_clean_transaction_chain_does_not_mask_a_broken_event_chain ... ok
[INFO] [stdout] test audit_chain::tests::a_detected_break_outranks_an_inconclusive_check_in_the_exit_code ... ok
[INFO] [stdout] test audit_chain::tests::a_future_encoding_reports_cannot_verify_with_the_supported_range ... ok
[INFO] [stdout] test audit_chain::tests::a_legacy_event_row_signed_by_the_previous_release_still_verifies ... ok
[INFO] [stdout] test audit_chain::tests::a_legacy_row_written_before_the_migration_still_verifies ... ok
[INFO] [stdout] test audit_chain::tests::a_chain_predating_the_principal_field_reports_no_row_as_attributed ... ok
[INFO] [stdout] test audit_chain::tests::a_broken_chain_censuses_more_rows_than_it_verified ... ok
[INFO] [stdout] test audit_chain::tests::a_grant_and_a_consume_by_different_accounts_are_distinguishable ... ok
[INFO] [stdout] test audit_chain::tests::a_legacy_v1_row_on_disk_still_verifies ... ok
[INFO] [stdout] test audit_chain::tests::a_row_signature_cannot_be_replayed_as_an_event_signature ... ok
[INFO] [stdout] test audit_chain::tests::a_row_recording_an_attribution_failure_verifies ... ok
[INFO] [stdout] test audit_chain::tests::a_chain_that_names_nobody_still_exits_zero ... ok
[INFO] [stdout] test audit_chain::tests::a_v2_event_naming_nobody_is_broken_not_accepted ... ok
[INFO] [stdout] test audit_chain::tests::a_row_written_by_the_previous_release_still_verifies ... ok
[INFO] [stdout] test audit_chain::tests::a_v2_row_with_a_nulled_caller_role_is_broken_not_merely_unverifiable ... ok
[INFO] [stdout] test audit_chain::tests::a_mixed_legacy_and_v2_event_chain_verifies ... ok
[INFO] [stdout] test audit_chain::tests::a_row_signed_with_a_blank_principal_is_rejected_even_though_it_signs ... ok
[INFO] [stdout] test audit_chain::tests::a_v3_row_without_a_usable_principal_is_broken ... ok
[INFO] [stdout] test audit_chain::tests::all_three_clean_is_exit_zero ... ok
[INFO] [stdout] test audit_chain::tests::an_unknown_event_version_cannot_verify_rather_than_breaking ... ok
[INFO] [stdout] test audit_chain::tests::a_chain_spanning_all_three_encodings_verifies ... ok
[INFO] [stdout] test audit_chain::tests::an_unrecognised_event_kind_is_a_break_not_a_panic ... ok
[INFO] [stdout] test audit_chain::tests::bad_public_key_hex_yields_cannot_verify ... ok
[INFO] [stdout] test audit_chain::tests::approval_receipt_framing_is_injective ... ok
[INFO] [stdout] test audit_chain::tests::a_v2_event_signs_and_verifies_with_the_acting_account ... ok
[INFO] [stdout] test audit_chain::tests::binding_exit_codes_split_clean_tampered_and_unchecked ... ok
[INFO] [stdout] test audit_chain::tests::caller_role_is_covered_by_the_row_signature ... ok
[INFO] [stdout] test audit_chain::tests::canonical_bytes_have_stable_field_order ... ok
[INFO] [stdout] test audit_chain::tests::checkpoint_bad_signature_detected ... ok
[INFO] [stdout] test audit_chain::tests::a_v3_row_on_disk_still_verifies ... ok
[INFO] [stdout] test audit_chain::tests::a_chain_that_spans_the_migration_verifies_end_to_end ... ok
[INFO] [stdout] test audit_chain::tests::checkpoint_detects_full_wipe ... ok
[INFO] [stdout] test audit_chain::tests::a_principal_written_into_an_encoding_that_does_not_sign_it_is_never_an_account ... ok
[INFO] [stdout] test audit_chain::tests::checkpoint_created_at_is_signed ... ok
[INFO] [stdout] test audit_chain::tests::checkpoint_consistent_with_intact_chain ... ok
[INFO] [stdout] test audit_chain::tests::debug_preserves_key_id ... ok
[INFO] [stdout] test audit_chain::tests::debug_redacts_key_bytes_and_their_hex_encoding ... ok
[INFO] [stdout] test audit_chain::tests::checkpoint_detects_rewrite ... ok
[INFO] [stdout] test audit_chain::tests::checkpoint_foreign_key_rejected ... ok
[INFO] [stdout] test audit_chain::tests::checkpoint_seq_is_signed ... ok
[INFO] [stdout] test audit_chain::tests::different_keys_yield_different_hashes ... ok
[INFO] [stdout] test audit_chain::tests::different_prev_hash_yields_different_hash ... ok
[INFO] [stdout] test audit_chain::tests::different_seq_yields_different_hash ... ok
[INFO] [stdout] test audit_chain::tests::domain_tags_are_distinct_and_prefix_free ... ok
[INFO] [stdout] test audit_chain::tests::checkpoint_detects_truncation ... ok
[INFO] [stdout] test audit_chain::tests::deleting_an_approval_event_from_the_middle_breaks_the_event_chain ... ok
[INFO] [stdout] test audit_chain::tests::deleted_middle_row_breaks_chain_via_prev_hash_mismatch ... ok
[INFO] [stdout] test audit_chain::tests::deleting_the_last_approval_event_is_caught_by_the_transaction_binding ... ok
[INFO] [stdout] test audit_chain::tests::empty_chain_verifies ... ok
[INFO] [stdout] test audit_chain::tests::event_kind_spellings_are_stable ... ok
[INFO] [stdout] test audit_chain::tests::event_tip_is_covered_by_the_row_signature ... ok
[INFO] [stdout] test audit_chain::tests::every_variant_is_in_all ... ok
[INFO] [stdout] test audit_chain::tests::exit_code_for_each_outcome ... ok
[INFO] [stdout] test audit_chain::tests::export_rejects_an_invalid_since_timestamp ... ok
[INFO] [stdout] test audit_chain::tests::export_since_is_inclusive_and_limit_preserves_chain_order ... ok
[INFO] [stdout] test audit_chain::tests::downgrading_a_v2_event_to_legacy_reports_broken ... ok
[INFO] [stdout] test audit_chain::tests::exported_chain_row_uses_the_stored_column_contract_and_json_nulls ... ok
[INFO] [stdout] test audit_chain::tests::exported_chain_row_json_round_trips_without_changing_the_signature ... ok
[INFO] [stdout] test audit_chain::tests::downgrading_a_v3_row_to_v2_to_hide_the_account_breaks_it ... ok
[INFO] [stdout] test audit_chain::tests::foreign_public_key_cannot_validate_chain ... ok
[INFO] [stdout] test audit_chain::tests::inserted_forged_row_breaks_chain ... ok
[INFO] [stdout] test audit_chain::tests::editing_the_stored_principal_breaks_the_row ... ok
[INFO] [stdout] test audit_chain::tests::legacy_rows_carry_no_binding_to_check ... ok
[INFO] [stdout] test audit_chain::tests::literal_backslash_zero_chain_hash_differs_from_raw_nul ... ok
[INFO] [stdout] test audit_chain::tests::literal_backslash_zero_does_not_collide_with_raw_nul_escape ... ok
[INFO] [stdout] test audit_chain::tests::a_principal_this_binary_cannot_read_is_counted_as_unattested_not_as_an_account ... ok
[INFO] [stdout] test audit_chain::tests::load_or_generate_creates_with_0600_mode ... ok
[INFO] [stdout] test audit_chain::tests::malformed_signature_hex_is_broken_not_panic ... ok
[INFO] [stdout] test audit_chain::tests::load_or_generate_writes_public_key_sidecar ... ok
[INFO] [stdout] test audit_chain::tests::load_or_generate_is_idempotent ... ok
[INFO] [stdout] test audit_chain::tests::nul_bytes_in_field_value_are_escaped ... ok
[INFO] [stdout] test audit_chain::tests::downgrading_a_v2_row_to_hide_the_caller_role_breaks_it ... ok
[INFO] [stdout] test audit_chain::tests::rejects_short_key_file ... ok
[INFO] [stdout] test audit_chain::tests::rejects_world_readable_key_file ... ok
[INFO] [stdout] test audit_chain::tests::editing_a_stored_event_principal_reports_broken ... ok
[INFO] [stdout] test audit_chain::tests::same_inputs_yield_same_hash ... ok
[INFO] [stdout] test audit_chain::tests::audit_key_env_resolution_is_centralised ... FAILED
[INFO] [stdout] test audit_chain::tests::relabelling_a_revocation_as_a_grant_breaks_the_event_chain ... ok
[INFO] [stdout] test audit_chain::tests::intact_event_chain_verifies ... ok
[INFO] [stdout] test audit_chain::tests::the_escape_table_and_absent_approval_encoding_are_frozen ... ok
[INFO] [stdout] test audit_chain::tests::middle_checkpoint_failure_is_reported ... ok
[INFO] [stdout] test audit_chain::tests::two_admins_are_distinguishable_in_the_signed_record ... ok
[INFO] [stdout] test audit_chain::tests::verifying_key_hex_is_a_32_byte_public_key ... ok
[INFO] [stdout] test audit_chain::tests::wrong_key_id_yields_cannot_verify ... ok
[INFO] [stdout] test audit_forward::tests::empty_hostname_falls_back_to_nilvalue ... ok
[INFO] [stdout] test audit_forward::tests::forwarder_drops_on_closed_channel ... ok
[INFO] [stdout] test audit_forward::tests::forwarder_drops_when_full_and_warns_at_threshold ... ok
[INFO] [stdout] test audit_chain::tests::multiple_checkpoints_all_consistent ... ok
[INFO] [stdout] test audit_forward::tests::hostname_over_255_bytes_is_rejected ... ok
[INFO] [stdout] test audit_forward::tests::forwarder_resets_drop_counter_after_successful_submit ... ok
[INFO] [stdout] test audit_forward::tests::hostname_with_control_byte_is_rejected ... ok
[INFO] [stdout] test audit_forward::tests::hostname_with_non_ascii_is_rejected ... ok
[INFO] [stdout] test audit_forward::tests::legitimate_hostname_passes_through ... ok
[INFO] [stdout] test audit_forward::tests::hostname_with_space_is_rejected ... ok
[INFO] [stdout] test audit_forward::tests::next_backoff_secs_doubles_then_caps ... ok
[INFO] [stdout] test audit_forward::tests::open_udp_ipv6_host_binds_ipv6_local_socket ... ok
[INFO] [stdout] test audit_forward::tests::rfc5424_contains_sd_with_chain_hash_and_seq ... ok
[INFO] [stdout] test audit_forward::tests::rfc5424_caller_role_with_quote_is_escaped ... ok
[INFO] [stdout] test audit_forward::tests::rfc5424_message_section_contains_summary_and_action_tag ... ok
[INFO] [stdout] test audit_forward::tests::rfc5424_facility_changes_pri ... ok
[INFO] [stdout] test audit_forward::tests::rfc5424_round_trip_through_syslog_loose ... ok
[INFO] [stdout] test audit_forward::tests::rfc5424_starts_with_pri_and_version ... ok
[INFO] [stdout] test audit_forward::tests::rfc5424_uses_configured_enterprise_number ... ok
[INFO] [stdout] test audit_forward::tests::sd_escape_handles_dquote_backslash_bracket ... ok
[INFO] [stdout] test audit_forward::tests::sd_escape_strips_control_characters ... ok
[INFO] [stdout] test audit_forward::tests::rfc5424_missing_approval_renders_empty_string ... ok
[INFO] [stdout] test audit_forward::tests::sd_escape_strips_non_ascii_to_avoid_strict_siem_rejection ... ok
[INFO] [stdout] test audit_forward::tests::sd_escape_strips_del_and_c1_controls ... ok
[INFO] [stdout] test audit_forward::tests::spawn_sends_udp_datagrams_to_listener ... ok
[INFO] [stdout] test audit_forward::tests::terminal_status_emitted_when_present ... ok
[INFO] [stdout] test audit_watermark::tests::sink_records_seq_and_hex ... ok
[INFO] [stdout] test audit_chain::tests::tampered_summary_breaks_chain_at_first_offending_row ... ok
[INFO] [stdout] test audit_watermark::tests::syslog_identifier_constant_is_correct ... ok
[INFO] [stdout] test auth::tests::a_denial_says_which_group_to_join_and_how ... ok
[INFO] [stdout] test auth::tests::absent_token_file_returns_none ... ok
[INFO] [stdout] test auth::tests::a_principal_this_binary_cannot_read_is_never_credited_as_an_account ... ok
[INFO] [stdout] test auth::tests::an_unattributed_caller_is_never_privileged ... ok
[INFO] [stdout] test audit_watermark::tests::take_watermarks_drains_sink ... ok
[INFO] [stdout] test auth::tests::boot_role_beats_admin_and_wheel ... ok
[INFO] [stdout] test auth::tests::empty_presented_token_is_always_rejected ... ok
[INFO] [stdout] test auth::tests::empty_stored_token_is_rejected_even_with_matching_presented ... ok
[INFO] [stdout] test auth::tests::every_principal_renders_as_a_non_empty_known_scheme ... ok
[INFO] [stdout] test auth::tests::every_principal_the_daemon_signs_classifies_back_to_its_own_class ... ok
[INFO] [stdout] test auth::tests::every_role_maps_back_to_the_group_that_grants_it ... ok
[INFO] [stdout] test auth::tests::highest_role_wins_when_multiple_groups_present ... ok
[INFO] [stdout] test auth::tests::lacs_admin_group_resolves_to_admin ... ok
[INFO] [stdout] test auth::tests::lacs_boot_group_resolves_to_boot ... ok
[INFO] [stdout] test auth::tests::empty_groups_resolves_to_observer ... ok
[INFO] [stdout] test auth::tests::mixed_known_and_unknown_groups_returns_highest_known ... ok
[INFO] [stdout] test audit_chain::tests::signature_verifies_under_exported_public_key ... ok
[INFO] [stdout] test auth::tests::principal_renderings_are_frozen ... ok
[INFO] [stdout] test audit_chain::tests::the_pubkey_only_path_takes_the_same_census ... ok
[INFO] [stdout] test auth::tests::lacs_dev_group_resolves_to_dev ... ok
[INFO] [stdout] test auth::tests::lacs_observer_group_resolves_to_observer ... ok
[INFO] [stdout] test auth::tests::no_scheme_is_a_prefix_of_another ... ok
[INFO] [stdout] test auth::tests::token_compare_rejects_equal_length_wrong_prefix_and_wrong_suffix ... ok
[INFO] [stdout] test auth::tests::the_group_a_role_maps_to_actually_grants_that_role ... ok
[INFO] [stdout] test auth::tests::token_role_defaults_to_dev_when_unset ... ok
[INFO] [stdout] test auth::tests::token_role_explicit_dev ... ok
[INFO] [stdout] test auth::tests::token_file_with_trailing_newline_still_matches ... ok
[INFO] [stdout] test auth::tests::token_role_admin ... ok
[INFO] [stdout] test auth::tests::token_role_boot ... ok
[INFO] [stdout] test auth::tests::token_role_trims_surrounding_whitespace ... ok
[INFO] [stdout] test auth::tests::token_role_unknown_value_fails_closed_to_observer ... ok
[INFO] [stdout] test auth::tests::transport_constructors_pick_the_matching_evidence_class ... ok
[INFO] [stdout] test auth::tests::unknown_group_resolves_to_observer ... ok
[INFO] [stdout] test auth::tests::token_role_is_case_insensitive ... ok
[INFO] [stdout] test auth::tests::token_role_observer ... ok
[INFO] [stdout] test auth::tests::valid_token_matches_and_returns_dev_by_default ... ok
[INFO] [stdout] test auth::tests::wheel_group_resolves_to_admin ... ok
[INFO] [stdout] test audit_chain::tests::intact_chain_verifies ... ok
[INFO] [stdout] test checkpoint_sink::anchor_tests::an_anchor_with_no_checkpoints_is_not_reported_as_consistent ... ok
[INFO] [stdout] test auth::tests::wrong_token_returns_none ... ok
[INFO] [stdout] test checkpoint_sink::anchor_tests::anchor_once_reports_an_empty_chain_rather_than_anchoring_nothing ... ok
[INFO] [stdout] test audit_chain::tests::pubkey_verify_detects_tampered_middle_row ... ok
[INFO] [stdout] test checkpoint_sink::anchor_tests::anchor_once_detects_a_write_that_did_not_land ... ok
[INFO] [stdout] test checkpoint_sink::anchor_tests::anchor_once_refuses_to_launder_a_tampered_chain ... ok
[INFO] [stdout] test checkpoint_sink::tests::in_memory_append_and_load_round_trip ... ok
[INFO] [stdout] test checkpoint_sink::tests::refuses_a_downgradeable_remote_url_before_connecting ... ok
[INFO] [stdout] test dispatcher::tests::a_deployment_preview_binds_execute_to_the_deployment_not_the_slot ... ok
[INFO] [stdout] test dispatcher::tests::a_vsock_principal_does_not_claim_an_account ... ok
[INFO] [stdout] test dispatcher::tests::an_action_that_could_not_be_stopped_is_never_rolled_back_over ... ok
[INFO] [stdout] test dispatcher::tests::an_ordinary_failure_still_rolls_back ... ok
[INFO] [stdout] test dispatcher::tests::a_low_risk_action_that_mutates_is_not_treated_as_a_read ... ok
[INFO] [stdout] test checkpoint_sink::tests::anchored_checkpoints_verify_and_catch_truncation ... ok
[INFO] [stdout] test checkpoint_sink::anchor_tests::verifying_against_the_anchor_catches_what_the_chain_alone_cannot ... ok
[INFO] [stdout] test checkpoint_sink::anchor_tests::verify_chain_alone_cannot_detect_tail_truncation ... ok
[INFO] [stdout] test checkpoint_sink::anchor_tests::anchor_once_writes_and_verifies_the_tip ... ok
[INFO] [stdout] test dispatcher::tests::autoremove_binding_accepts_the_same_set ... ok
[INFO] [stdout] test dispatcher::tests::autoremove_binding_refuses_a_malformed_captured_set ... ok
[INFO] [stdout] test dispatcher::tests::autoremove_binding_refuses_a_preview_that_captured_no_set ... ok
[INFO] [stdout] test dispatcher::tests::autoremove_binding_rejects_a_newly_added_package ... ok
[INFO] [stdout] test dispatcher::tests::autoremove_binding_rejects_a_no_longer_removed_package ... ok
[INFO] [stdout] test dispatcher::tests::autoremove_kernel_warning_flags_kernel_and_driver_packages ... ok
[INFO] [stdout] test dispatcher::tests::autoremove_kernel_warning_is_silent_for_ordinary_packages ... ok
[INFO] [stdout] test dispatcher::tests::approval_details_returns_persisted_preview_before_approval ... ok
[INFO] [stdout] test dispatcher::tests::cancel_missing_transaction_is_rejected ... ok
[INFO] [stdout] test audit_chain::tests::the_census_separates_attribution_failures_from_encodings_without_the_field ... ok
[INFO] [stdout] test dispatcher::tests::approve_missing_transaction_maps_to_stale_approval ... ok
[INFO] [stdout] test dispatcher::tests::canonical_json_preserves_array_element_order ... ok
[INFO] [stdout] test dispatcher::tests::canonical_json_recurses_into_arrays ... ok
[INFO] [stdout] test dispatcher::tests::approval_details_for_running_transaction_maps_to_stale_approval ... ok
[INFO] [stdout] test dispatcher::tests::approving_same_transaction_twice_maps_second_to_stale_approval ... ok
[INFO] [stdout] test dispatcher::tests::deployment_identity_is_read_from_rpm_ostree_status ... ok
[INFO] [stdout] test dispatcher::tests::approve_with_forged_commitment_maps_to_integrity_failure ... ok
[INFO] [stdout] test dispatcher::tests::cancel_queued_transaction_succeeds_and_marks_it_canceled ... ok
[INFO] [stdout] test dispatcher::tests::describe_refuses_an_action_the_host_family_cannot_run ... ok
[INFO] [stdout] test dispatcher::tests::describe_refuses_an_action_the_caller_is_not_allowed_to_run ... ok
[INFO] [stdout] test dispatcher::tests::cancel_running_transaction_is_rejected_and_left_running ... ok
[INFO] [stdout] test dispatcher::tests::describe_returns_command_and_risk_for_known_action ... ok
[INFO] [stdout] test dispatcher::tests::describe_returns_error_for_unknown_action ... ok
[INFO] [stdout] test dispatcher::tests::connection_handler_accepts_duplex_stream ... ok
[INFO] [stdout] test dispatcher::tests::concurrent_executes_against_one_preview_serialise_to_one_winner ... ok
[INFO] [stdout] test dispatcher::tests::cancelling_an_approved_transaction_signs_the_cancelling_account ... ok
[INFO] [stdout] test dispatcher::tests::describe_still_answers_for_an_allowed_action ... ok
[INFO] [stdout] test dispatcher::tests::execute_without_prior_preview_returns_stale_approval ... ok
[INFO] [stdout] test dispatcher::tests::execute_with_changed_action_rejects_without_consuming_approval ... ok
[INFO] [stdout] test dispatcher::tests::first_request_deadline_is_much_tighter_than_the_idle_deadline ... ok
[INFO] [stdout] test dispatcher::tests::execute_refuses_when_the_autoremove_re_simulate_fails ... ok
[INFO] [stdout] test dispatcher::tests::execute_proceeds_when_the_autoremove_set_is_unchanged ... ok
[INFO] [stdout] test dispatcher::tests::execute_refuses_autoremove_when_the_deletion_set_drifted ... ok
[INFO] [stdout] test dispatcher::tests::execute_with_changed_params_rejects_without_consuming_approval ... ok
[INFO] [stdout] test dispatcher::tests::execute_after_preview_with_receipt_returns_job_completed ... ok
[INFO] [stdout] test dispatcher::tests::peer_pidfd_reports_live_self ... ok
[INFO] [stdout] test dispatcher::tests::peer_pin_only_unsupported_option_allows_best_effort_groups ... ok
[INFO] [stdout] test dispatcher::tests::high_risk_action_rejected_for_observer ... ok
[INFO] [stdout] test dispatcher::tests::preview_hash_is_deterministic ... ok
[INFO] [stdout] test dispatcher::tests::medium_risk_action_rejected_for_observer ... ok
[INFO] [stdout] test dispatcher::tests::low_risk_action_allowed_for_observer ... ok
[INFO] [stdout] test checkpoint_sink::anchor_tests::a_previously_anchored_checkpoint_catches_a_key_holder_rewrite ... ok
[INFO] [stdout] test dispatcher::tests::fast_executor_progress_is_drained_before_job_completed ... ok
[INFO] [stdout] test dispatcher::tests::preview_captures_the_autoremove_set_and_warns_on_kernel_packages ... ok
[INFO] [stdout] test dispatcher::tests::preview_returns_hash_and_transaction_id ... ok
[INFO] [stdout] test dispatcher::tests::query_action_refuses_an_action_the_host_family_cannot_run ... ok
[INFO] [stdout] test dispatcher::tests::query_history_honours_policy_override_raising_history_above_observer ... ok
[INFO] [stdout] test dispatcher::tests::redact_argv_handles_password_valued_password ... ok
[INFO] [stdout] test dispatcher::tests::job_started_send_failure_releases_slot_and_marks_transaction_failed ... ok
[INFO] [stdout] test dispatcher::tests::redact_argv_leaves_open_network_argv_intact ... ok
[INFO] [stdout] test dispatcher::tests::redact_argv_passes_through_when_no_credentials ... ok
[INFO] [stdout] test dispatcher::tests::redact_argv_replaces_argv_element_matching_token_value ... ok
[INFO] [stdout] test dispatcher::tests::redact_argv_handles_ssid_named_password ... ok
[INFO] [stdout] test dispatcher::tests::redact_argv_token_equal_to_attach_preserves_structural_attach ... ok
[INFO] [stdout] test dispatcher::tests::redact_params_passes_through_for_actions_with_no_credentials ... ok
[INFO] [stdout] test dispatcher::tests::redact_params_replaces_configure_wifi_password ... ok
[INFO] [stdout] test dispatcher::tests::redact_params_replaces_pro_attach_token ... ok
[INFO] [stdout] test dispatcher::tests::redact_argv_replaces_wifi_password_after_keyword ... ok
[INFO] [stdout] test dispatcher::tests::resolve_caller_attributes_a_unix_peer_to_its_kernel_reported_uid ... ok
[INFO] [stdout] test dispatcher::tests::resolve_caller_never_exceeds_observer_without_a_privileged_group ... ok
[INFO] [stdout] test dispatcher::tests::served_connections_keep_the_full_idle_allowance ... ok
[INFO] [stdout] test dispatcher::tests::resolve_caller_matches_the_peers_actual_groups ... ok
[INFO] [stdout] test dispatcher::tests::query_state_returns_state_response ... ok
[INFO] [stdout] test dispatcher::tests::raising_a_read_only_action_via_risk_overrides_does_not_arm_the_platform_fence ... ok
[INFO] [stdout] test dispatcher::tests::handlers_sign_the_connection_account_into_approval_events ... ok
[INFO] [stdout] test dispatcher::tests::query_history_returns_structured_rows_with_created_at_and_risk_level ... ok
[INFO] [stdout] test dispatcher::tests::unpinnable_peer_keeps_only_its_primary_group ... ok
[INFO] [stdout] test dispatcher::tests::supported_hosts_still_enforce_action_family ... ok
[INFO] [stdout] test dispatcher::tests::unknown_message_type_returns_validation_failure ... ok
[INFO] [stdout] test dispatcher::tests::vsock_auth::eof_before_auth_frame_closes_connection ... ok
[INFO] [stdout] test dispatcher::tests::the_recorded_principal_is_the_one_the_connection_was_attributed_to ... ok
[INFO] [stdout] test dispatcher::tests::vsock_auth::group_or_world_readable_token_file_is_rejected ... ok
[INFO] [stdout] test dispatcher::tests::vsock_auth::malformed_json_frame_closes_connection ... ok
[INFO] [stdout] test dispatcher::tests::vsock_auth::wrong_msg_type_closes_connection ... ok
[INFO] [stdout] test dispatcher::tests::unsupported_distros_cannot_reach_mutation_paths ... ok
[INFO] [stdout] test dispatcher::tests::preview_that_cannot_simulate_captures_no_set_and_execute_refuses ... ok
[INFO] [stdout] test executor::tests::action_not_stopped_names_the_group_and_the_timeout ... ok
[INFO] [stdout] test executor::tests::activating_actions_refuse_a_root_shell_unit ... ok
[INFO] [stdout] test executor::tests::add_package_repository_is_high_risk ... ok
[INFO] [stdout] test executor::tests::authorized_keys_actions_reject_a_traversal_username ... ok
[INFO] [stdout] test executor::tests::build_spec_add_package_repository_accepts_valid_repo_id ... ok
[INFO] [stdout] test executor::tests::build_spec_add_package_repository_rejects_newline_in_url ... ok
[INFO] [stdout] test executor::tests::build_spec_add_package_repository_rejects_path_traversal ... ok
[INFO] [stdout] test executor::tests::build_spec_flatpak_accepts_user_alias ... ok
[INFO] [stdout] test executor::tests::build_spec_get_datetime_is_low_risk ... ok
[INFO] [stdout] test executor::tests::build_spec_install_flatpak_defaults_remote_to_flathub ... ok
[INFO] [stdout] test executor::tests::build_spec_install_flatpak_injects_app_and_remote ... ok
[INFO] [stdout] test executor::tests::build_spec_missing_param_for_install_flatpak ... ok
[INFO] [stdout] test executor::tests::build_spec_no_params_for_get_system_state ... ok
[INFO] [stdout] test executor::tests::build_spec_pin_deployment_injects_index ... ok
[INFO] [stdout] test executor::tests::build_spec_rebase_system_injects_target_ref ... ok
[INFO] [stdout] test executor::tests::build_spec_remove_package_repository_rejects_path_traversal ... ok
[INFO] [stdout] test executor::tests::build_spec_resolve_username_prefers_explicit_username ... ok
[INFO] [stdout] test executor::tests::build_spec_set_kernel_arguments_appends_and_deletes ... ok
[INFO] [stdout] test executor::tests::build_spec_set_kernel_arguments_defaults_when_keys_absent ... ok
[INFO] [stdout] test executor::tests::build_spec_set_kernel_arguments_with_empty_arrays ... ok
[INFO] [stdout] test executor::tests::build_spec_unknown_action_returns_error ... ok
[INFO] [stdout] test executor::tests::build_spec_unpin_deployment_includes_unpin_flag ... ok
[INFO] [stdout] test executor::tests::configure_firewall_is_high_risk ... ok
[INFO] [stdout] test executor::tests::configure_unattended_upgrades_toggles_helper_flag ... ok
[INFO] [stdout] test executor::tests::create_scheduled_job_validates_name_command_schedule ... ok
[INFO] [stdout] test executor::tests::create_user_home_must_be_an_absolute_path_without_dot_dot ... ok
[INFO] [stdout] test executor::tests::create_user_is_high_risk ... ok
[INFO] [stdout] test executor::tests::delete_group_rejects_critical_group ... ok
[INFO] [stdout] test executor::tests::delete_user_lock_user_account_and_delete_group_allow_normal_names ... ok
[INFO] [stdout] test executor::tests::delete_user_rejects_critical_account ... ok
[INFO] [stdout] test executor::tests::execute_spec_command_captures_stdout ... ok
[INFO] [stdout] test executor::tests::execute_spec_file_delete_removes_file ... ok
[INFO] [stdout] test executor::tests::execute_spec_file_patch_allows_empty_search_string ... ok
[INFO] [stdout] test executor::tests::execute_spec_file_patch_replaces_first_occurrence ... ok
[INFO] [stdout] test executor::tests::execute_spec_file_patch_returns_error_when_search_not_found ... ok
[INFO] [stdout] test executor::tests::execute_spec_file_scan_lists_directory_entries ... ok
[INFO] [stdout] test executor::tests::execute_spec_file_write_creates_file ... ok
[INFO] [stdout] test executor::tests::grub_set_kargs_append_blocks_single_user_shortcut ... ok
[INFO] [stdout] test executor::tests::grub_set_kargs_cannot_delete_a_protective_karg ... ok
[INFO] [stdout] test executor::tests::ip_taking_actions_reject_a_malformed_address ... ok
[INFO] [stdout] test executor::tests::is_rpm_ostree_action_detects_the_transaction_client_behind_sudo ... ok
[INFO] [stdout] test executor::tests::kernel_arg_allows_safe_args ... ok
[INFO] [stdout] test executor::tests::kernel_arg_blocks_apparmor_disable ... ok
[INFO] [stdout] test executor::tests::kernel_arg_blocks_init_override ... ok
[INFO] [stdout] test executor::tests::kernel_arg_blocks_lockdown_override ... ok
[INFO] [stdout] test executor::tests::kernel_arg_blocks_mitigations_off ... ok
[INFO] [stdout] test executor::tests::kernel_arg_blocks_module_blacklist ... ok
[INFO] [stdout] test executor::tests::kernel_arg_blocks_pti_off ... ok
[INFO] [stdout] test executor::tests::kernel_arg_blocks_security_override ... ok
[INFO] [stdout] test executor::tests::kernel_arg_blocks_selinux_disable ... ok
[INFO] [stdout] test executor::tests::kernel_arg_blocks_single_user_shortcuts ... ok
[INFO] [stdout] test executor::tests::kernel_arg_blocks_smap_smep_disable ... ok
[INFO] [stdout] test executor::tests::kernel_arg_blocks_systemd_unit_emergency_rescue ... ok
[INFO] [stdout] test executor::tests::kernel_arg_build_spec_rejects_dangerous_arg ... ok
[INFO] [stdout] test executor::tests::kernel_arg_removal_allows_ordinary_args ... ok
[INFO] [stdout] test executor::tests::kernel_arg_removal_allows_undoing_a_weakening_arg ... ok
[INFO] [stdout] test executor::tests::kernel_arg_removal_blocks_stripping_a_hardening_arg ... ok
[INFO] [stdout] test executor::tests::kill_and_reap_confirms_a_killable_group_stopped_and_returns_bounded ... ok
[INFO] [stdout] test executor::tests::lock_user_account_rejects_critical_account ... ok
[INFO] [stdout] test executor::tests::mask_service_is_high_risk ... ok
[INFO] [stdout] test executor::tests::package_actions_reject_a_local_file_target ... ok
[INFO] [stdout] test executor::tests::public_key_accepts_regex_metacharacters_so_consumers_must_not_use_regex ... ok
[INFO] [stdout] test executor::tests::public_key_accepts_valid_ed25519 ... ok
[INFO] [stdout] test executor::tests::public_key_accepts_valid_rsa ... ok
[INFO] [stdout] test executor::tests::public_key_rejects_empty ... ok
[INFO] [stdout] test executor::tests::public_key_rejects_newline ... ok
[INFO] [stdout] test executor::tests::public_key_rejects_pipe_metacharacter ... ok
[INFO] [stdout] test executor::tests::public_key_rejects_shell_metacharacters ... ok
[INFO] [stdout] test executor::tests::public_key_rejects_single_quote ... ok
[INFO] [stdout] test executor::tests::public_key_rejects_too_long ... ok
[INFO] [stdout] test executor::tests::public_key_rejects_unknown_prefix ... ok
[INFO] [stdout] test executor::tests::real_executor_streams_each_stdout_line ... ok
[INFO] [stdout] test executor::tests::reap_command_cancels_rpm_ostree_but_group_kills_everything_else ... ok
[INFO] [stdout] test dispatcher::tests::under_privileged_caller_cannot_act_on_admin_transaction ... ok
[INFO] [stdout] test executor::tests::rollback_available_matches_rollback_spec_for_all_actions ... ok
[INFO] [stdout] test executor::tests::require_u32_rejects_overflow ... ok
[INFO] [stdout] test executor::tests::rollback_spec_for_install_packages_is_rpm_ostree_rollback ... ok
[INFO] [stdout] test executor::tests::rollback_spec_for_non_rollbackable_actions_return_none ... ok
[INFO] [stdout] test executor::tests::rollback_spec_for_read_only_action_returns_none ... ok
[INFO] [stdout] test executor::tests::rollback_spec_for_rebase_system_is_rpm_ostree_rollback ... ok
[INFO] [stdout] test executor::tests::rollback_spec_for_remove_packages_is_rpm_ostree_rollback ... ok
[INFO] [stdout] test executor::tests::rollback_spec_for_set_kernel_arguments_is_rpm_ostree_rollback ... ok
[INFO] [stdout] test dispatcher::tests::vsock_auth::valid_token_grants_access ... ok
[INFO] [stdout] test executor::tests::root_group_kill_argv_targets_the_whole_group_non_interactively ... ok
[INFO] [stdout] test executor::tests::rollback_spec_for_update_system_is_rpm_ostree_rollback ... ok
[INFO] [stdout] test executor::tests::set_sshd_option_allowlist_guardrails ... ok
[INFO] [stdout] test executor::tests::signal_process_guardrails ... ok
[INFO] [stdout] test executor::tests::str_array_or_empty_rejects_non_string_element ... ok
[INFO] [stdout] test executor::tests::set_dns_servers_is_high_risk ... ok
[INFO] [stdout] test executor::tests::str_array_or_empty_returns_empty_when_key_absent ... ok
[INFO] [stdout] test jobs::tests::every_other_edge_is_refused ... ok
[INFO] [stdout] test jobs::tests::every_permitted_edge_is_allowed ... ok
[INFO] [stdout] test jobs::tests::queued_and_running_are_not_terminal ... ok
[INFO] [stdout] test jobs::tests::terminal_states_cannot_be_left ... ok
[INFO] [stdout] test executor::tests::str_array_or_empty_accepts_string_array ... ok
[INFO] [stdout] test jobs::tests::a_job_cannot_restart_after_finishing ... ok
[INFO] [stdout] test pg_tls::tests::a_non_loopback_ip_without_sslmode_is_refused ... ok
[INFO] [stdout] test pg_tls::tests::a_remote_host_built_without_a_url_is_refused ... ok
[INFO] [stdout] test pg_tls::tests::a_remote_tcp_url_with_sslmode_allow_is_refused ... ok
[INFO] [stdout] test pg_tls::tests::a_loopback_host_without_sslmode_is_allowed ... ok
[INFO] [stdout] test pg_tls::tests::a_remote_tcp_url_with_sslmode_disable_is_refused ... ok
[INFO] [stdout] test pg_tls::tests::a_remote_tcp_url_with_sslmode_require_is_refused ... ok
[INFO] [stdout] test pg_tls::tests::a_remote_tcp_url_with_sslmode_prefer_is_refused ... ok
[INFO] [stdout] test dispatcher::tests::re_executing_a_completed_approval_returns_stale_approval ... ok
[INFO] [stdout] test pg_tls::tests::a_unix_socket_without_sslmode_is_allowed ... ok
[INFO] [stdout] test pg_tls::tests::an_ipv6_loopback_url_is_allowed ... ok
[INFO] [stdout] test pg_tls::tests::a_remote_tcp_url_with_verify_ca_is_allowed ... ok
[INFO] [stdout] test pg_tls::tests::a_remote_tcp_url_with_verify_full_is_allowed ... ok
[INFO] [stdout] test pg_tls::tests::a_remote_tcp_url_without_sslmode_is_refused ... ok
[INFO] [stdout] test policy::tests::active_overrides_returns_sorted_entries ... ok
[INFO] [stdout] test policy::tests::admin_can_add_package_repository ... ok
[INFO] [stdout] test policy::tests::admin_can_call_high_risk_actions ... ok
[INFO] [stdout] test policy::tests::admin_can_create_user ... ok
[INFO] [stdout] test policy::tests::admin_can_configure_firewall ... ok
[INFO] [stdout] test policy::tests::boot_can_call_everything ... ok
[INFO] [stdout] test policy::tests::dev_cannot_add_package_repository ... ok
[INFO] [stdout] test policy::tests::admin_can_mask_service ... ok
[INFO] [stdout] test policy::tests::admin_can_set_dns_servers ... ok
[INFO] [stdout] test policy::tests::dev_can_call_medium_risk_actions ... ok
[INFO] [stdout] test policy::tests::dev_cannot_call_high_risk_actions ... ok
[INFO] [stdout] test policy::tests::dev_cannot_mask_service ... ok
[INFO] [stdout] test policy::tests::dev_cannot_create_user ... ok
[INFO] [stdout] test policy::tests::dev_cannot_configure_firewall ... ok
[INFO] [stdout] test policy::tests::dev_cannot_set_dns_servers ... ok
[INFO] [stdout] test policy::tests::empty_policy_table_matches_baseline ... ok
[INFO] [stdout] test policy::tests::observer_can_call_read_only_actions ... ok
[INFO] [stdout] test policy::tests::group_create_is_dev_delete_is_admin_and_listening_ports_is_observer ... ok
[INFO] [stdout] test policy::tests::invalid_risk_level_is_rejected ... ok
[INFO] [stdout] test policy::tests::observer_cannot_call_medium_or_high_risk_actions ... ok
[INFO] [stdout] test policy::tests::dns_and_apparmor_mutations_require_admin ... ok
[INFO] [stdout] test policy::tests::override_at_baseline_is_noop ... ok
[INFO] [stdout] test policy::tests::override_below_baseline_is_rejected ... ok
[INFO] [stdout] test policy::tests::override_raises_minimum_role ... ok
[INFO] [stdout] test policy::tests::override_unknown_action_is_rejected ... ok
[INFO] [stdout] test policy::tests::process_and_account_control_require_admin ... ok
[INFO] [stdout] test policy::tests::risk_level_parsing_is_case_insensitive ... ok
[INFO] [stdout] test policy::tests::role_for_risk_level_mapping ... ok
[INFO] [stdout] test policy::tests::unknown_action_denied_for_all_roles ... ok
[INFO] [stdout] test policy::tests::unknown_action_denied_under_override_table_too ... ok
[INFO] [stdout] test preview::tests::cleanup_deployments_is_high_no_reboot ... ok
[INFO] [stdout] test preview::tests::create_scheduled_job_preview_names_exact_unit_paths ... ok
[INFO] [stdout] test preview::tests::all_low_risk_actions ... ok
[INFO] [stdout] test preview::tests::apparmor_enforce_and_complain_profiles_are_not_swapped ... ok
[INFO] [stdout] test preview::tests::fail2ban_ban_and_unban_profiles_are_not_swapped ... ok
[INFO] [stdout] test preview::tests::high_risk_actions_previously_misclassified_use_exact_approval ... ok
[INFO] [stdout] test preview::tests::high_risk_access_control_actions ... ok
[INFO] [stdout] test preview::tests::preview_action_passes_current_and_proposed_state ... ok
[INFO] [stdout] test preview::tests::preview_action_preserves_request_hash ... ok
[INFO] [stdout] test preview::tests::high_risk_system_reboot_actions ... ok
[INFO] [stdout] test preview::tests::medium_risk_actions ... ok
[INFO] [stdout] test preview::tests::pin_unpin_deployment_are_high ... ok
[INFO] [stdout] test preview::tests::preview_action_summary_format ... ok
[INFO] [stdout] test preview::tests::reboot_system_no_rollback ... ok
[INFO] [stdout] test preview::tests::reload_service_is_medium_risk ... ok
[INFO] [stdout] test dispatcher::tests::vsock_auth::wrong_token_closes_connection ... ok
[INFO] [stdout] test preview::tests::unknown_action_defaults_to_high ... ok
[INFO] [stdout] test state_collector::tests::collect_state_defaults_to_empty_lists_on_optional_command_failure ... ok
[INFO] [stdout] test state_collector::tests::collect_state_parses_hostname_and_deployment ... ok
[INFO] [stdout] test state_collector::tests::collect_state_parses_multiple_services ... ok
[INFO] [stdout] test state_collector::tests::collect_state_returns_empty_deployment_when_rpm_ostree_missing ... ok
[INFO] [stdout] test state_collector::tests::collect_state_returns_error_when_hostname_fails ... ok
[INFO] [stdout] test state_collector::tests::collect_state_trims_hostname_whitespace ... ok
[INFO] [stdout] test state_collector::tests::collected_state_round_trips_through_json ... ok
[INFO] [stdout] test state_collector::tests::machine_id_hash_is_stable_domain_separated_and_hides_the_raw_id ... ok
[INFO] [stdout] test state_collector::tests::parse_deployment_summary_extracts_origin_and_version ... ok
[INFO] [stdout] test dispatcher::tests::undelivered_approval_is_revoked_so_the_user_can_retry ... ok
[INFO] [stdout] test state_collector::tests::parse_deployment_summary_handles_missing_version ... ok
[INFO] [stdout] test state_collector::tests::parse_deployment_summary_returns_empty_on_invalid_json ... ok
[INFO] [stdout] test state_collector::tests::parse_layered_packages_extracts_requested_packages ... ok
[INFO] [stdout] test state_collector::tests::parse_layered_packages_handles_empty_deployments ... ok
[INFO] [stdout] test state_collector::tests::parse_layered_packages_handles_invalid_json ... ok
[INFO] [stdout] test state_collector::tests::parse_local_users_filters_by_uid_and_excludes_system_accounts ... ok
[INFO] [stdout] test state_collector::tests::parse_local_users_handles_empty_output ... ok
[INFO] [stdout] test store::postgres::tests::now_iso_matches_the_sqlite_backends_timestamp_shape ... ok
[INFO] [stdout] test store::postgres::tests::default_config_keeps_statement_cache_enabled ... ok
[INFO] [stdout] test store::postgres::tests::now_iso_produces_a_parseable_rfc3339_timestamp ... ok
[INFO] [stdout] test store::postgres::tests::schema_decode_errors_are_classified_as_invariant_failures ... ok
[INFO] [stdout] test store::postgres::tests::url_parsing_accepts_standard_postgres_url ... ok
[INFO] [stdout] test store::tests::chain_row_columns_pinned ... ok
[INFO] [stdout] test state::tests::open_with_audit_uses_the_provided_audit_store_verbatim ... ok
[INFO] [stdout] test state::tests::open_creates_state_with_empty_policy_and_no_forwarder ... ok
[INFO] [stdout] test state::tests::bootstrap_returns_a_runtime_with_a_bound_listener ... ok
[INFO] [stdout] test state::tests::open_full_threads_the_provided_forwarder_through ... ok
[INFO] [stdout] test dispatcher::tests::update_status_failure_surfaces_as_audit_warning_in_job_completed ... ok
[INFO] [stdout] test transactions::tests::a_read_only_store_cannot_revoke_or_claim ... ok
[INFO] [stdout] test transactions::tests::a_failed_approval_appends_no_event ... ok
[INFO] [stdout] test transactions::tests::a_database_written_before_the_migration_still_verifies_after_upgrading ... ok
[INFO] [stdout] test transactions::tests::a_schema_newer_than_this_binary_is_refused ... ok
[INFO] [stdout] test store::tests::reconcile_interrupted_running_fails_only_running_rows ... ok
[INFO] [stdout] test transactions::tests::a_stored_approval_event_names_the_account_that_acted ... ok
[INFO] [stdout] test transactions::tests::a_stored_status_event_carries_no_principal_and_stays_legacy ... ok
[INFO] [stdout] test transactions::tests::approve_rejects_a_forged_commitment_at_runtime ... ok
[INFO] [stdout] test transactions::tests::approval_commitment_is_covered_by_the_signed_chain ... ok
[INFO] [stdout] test transactions::tests::approve_refuses_a_transaction_that_is_no_longer_queued ... ok
[INFO] [stdout] test transactions::tests::a_terminal_outcome_is_chained_so_rewriting_status_is_detectable ... ok
[INFO] [stdout] test transactions::tests::approved_receipt_is_required_and_consumed_once ... ok
[INFO] [stdout] test transactions::tests::cancel_queued_cancels_a_queued_transaction_once ... ok
[INFO] [stdout] test transactions::tests::cancel_queued_refuses_a_running_transaction ... ok
[INFO] [stdout] test transactions::tests::cancel_queued_revokes_an_unconsumed_approval_and_appends_event ... ok
[INFO] [stdout] test transactions::tests::ensure_private_dir_creates_with_0700_mode ... ok
[INFO] [stdout] test transactions::tests::ensure_private_dir_is_idempotent_and_does_not_widen_existing_mode ... ok
[INFO] [stdout] test transactions::tests::cleanup_stale_queued_cancels_old_records ... ok
[INFO] [stdout] test transactions::tests::list_history_populates_created_at_and_risk_level ... ok
[INFO] [stdout] test transactions::tests::list_history_applies_the_same_filters_as_list_transactions ... ok
[INFO] [stdout] test transactions::tests::cleanup_stale_queued_revokes_every_unconsumed_approval ... ok
[INFO] [stdout] test transactions::tests::deleting_the_record_that_an_approval_happened_no_longer_goes_unnoticed ... ok
[INFO] [stdout] test transactions::tests::approving_consuming_and_revoking_each_append_a_chained_event ... ok
[INFO] [stdout] test transactions::tests::list_transactions_filters_by_action_name ... ok
[INFO] [stdout] test transactions::tests::a_v2_database_keeps_verifying_and_accepts_v3_rows ... ok
[INFO] [stdout] test transactions::tests::list_transactions_filters_by_since_hours ... ok
[INFO] [stdout] test transactions::tests::list_transactions_rejects_invalid_status_filter ... ok
[INFO] [stdout] test transactions::tests::list_transactions_returns_empty_for_fresh_store ... ok
[INFO] [stdout] test transactions::tests::no_watermark_emitted_before_any_record ... FAILED
[INFO] [stdout] test transactions::tests::list_transactions_returns_all_records_ordered_by_newest_first ... ok
[INFO] [stdout] test transactions::tests::list_transactions_filters_by_status ... ok
[INFO] [stdout] test transactions::tests::record_emits_one_watermark_per_entry ... FAILED
[INFO] [stdout] test transactions::tests::open_creates_parent_with_private_mode ... ok
[INFO] [stdout] test transactions::tests::record_previewed_emits_one_watermark ... FAILED
[INFO] [stdout] test transactions::tests::list_transactions_respects_limit ... ok
[INFO] [stdout] test transactions::tests::open_read_only_rejects_record ... ok
[INFO] [stdout] test transactions::tests::multiple_records_produce_one_watermark_each ... FAILED
[INFO] [stdout] test transactions::tests::only_one_of_two_concurrent_claims_can_execute ... ok
[INFO] [stdout] test transactions::tests::record_persists_the_caller_principal_under_the_current_encoding ... ok
[INFO] [stdout] test transactions::tests::record_writes_audit_chain_columns ... ok
[INFO] [stdout] test transactions::tests::revoke_cannot_retract_an_approval_that_was_already_used ... ok
[INFO] [stdout] test transactions::tests::revoke_unconsumed_approval_removes_an_unused_receipt ... ok
[INFO] [stdout] test transactions::tests::stale_iso_timestamp_cannot_be_approved ... ok
[INFO] [stdout] test transactions::tests::the_audit_database_is_created_owner_only ... ok
[INFO] [stdout] test transactions::tests::sequential_records_produce_chained_hashes ... ok
[INFO] [stdout] test transactions::tests::stale_iso_timestamp_cannot_be_claimed_for_execution ... ok
[INFO] [stdout] test transactions::tests::the_signed_row_records_which_role_asked ... ok
[INFO] [stdout] test transactions::tests::status_update_does_not_break_chain ... ok
[INFO] [stdout] test transactions::tests::update_status_for_unknown_id_returns_not_found ... ok
[INFO] [stdout] test transactions::tests::update_status_accepts_running_to_rolled_back ... ok
[INFO] [stdout] test transactions::tests::rows_appended_after_the_migration_chain_onto_legacy_rows ... ok
[INFO] [stdout] test transactions::tests::update_status_accepts_running_to_failed ... ok
[INFO] [stdout] test transactions::tests::update_status_rejects_queued_to_succeeded ... ok
[INFO] [stdout] test transactions::tests::update_status_is_atomic_under_concurrent_conflicting_transitions ... ok
[INFO] [stdout] test transactions::tests::update_status_transitions_queued_to_running ... ok
[INFO] [stdout] test transactions::tests::update_status_leaves_other_fields_intact ... ok
[INFO] [stdout] test transactions::tests::update_status_rejects_succeeded_to_running ... ok
[INFO] [stdout] test transactions::tests::update_status_transitions_running_to_succeeded ... ok
[INFO] [stdout] test transactions::tests::watermark_seq_and_hash_match_chain_row ... FAILED
[INFO] [stdout] test transport::framing::tests::a_withheld_body_after_a_large_length_claim_errors_promptly ... ok
[INFO] [stdout] test transport::framing::tests::a_body_arriving_in_many_small_chunks_is_reassembled ... ok
[INFO] [stdout] test transport::framing::tests::recv_never_requests_more_than_one_chunk_per_read ... ok
[INFO] [stdout] test transport::framing::tests::recv_rejects_header_claiming_over_4mib ... ok
[INFO] [stdout] test transport::framing::tests::round_trip_4095_bytes ... ok
[INFO] [stdout] test transport::framing::tests::round_trip_4096_bytes ... ok
[INFO] [stdout] test transport::framing::tests::round_trip_a_body_of_exactly_one_chunk ... ok
[INFO] [stdout] test transport::framing::tests::multiple_messages_on_same_stream ... ok
[INFO] [stdout] test transport::framing::tests::round_trip_empty_message ... ok
[INFO] [stdout] test transport::framing::tests::round_trip_a_full_max_size_body ... ok
[INFO] [stdout] test transport::framing::tests::round_trip_single_byte ... ok
[INFO] [stdout] test transport::framing::tests::send_rejects_message_over_4mib ... ok
[INFO] [stdout] test transport::framing::tests::truncated_body_errors_instead_of_hanging ... ok
[INFO] [stdout] test transport::framing::tests::round_trip_json_payload ... ok
[INFO] [stdout] test transport::framing::tests::truncated_header_errors_instead_of_hanging ... ok
[INFO] [stdout] test transport::listen::tests::cleans_up_a_stale_socket_left_by_a_crashed_daemon ... ok
[INFO] [stdout] test transport::listen::tests::a_bind_failure_names_the_path_it_failed_on ... ok
[INFO] [stdout] test transport::listen::tests::existing_socket_parent_keeps_its_mode ... ok
[INFO] [stdout] test transport::listen::tests::newly_created_socket_parent_uses_runtime_directory_mode ... ok
[INFO] [stdout] test transport::listen::tests::unix_uri_parses ... ok
[INFO] [stdout] test transport::listen::tests::unknown_scheme_returns_error ... ok
[INFO] [stdout] test transport::listen::tests::vsock_listen_uri_missing_colon_separator_is_invalid ... ok
[INFO] [stdout] test transport::listen::tests::refuses_to_bind_over_a_daemon_that_is_still_listening ... ok
[INFO] [stdout] test transport::listen::tests::vsock_listen_uri_missing_port_is_invalid ... ok
[INFO] [stdout] test transport::listen::tests::vsock_listen_uri_non_numeric_port_is_invalid ... ok
[INFO] [stdout] test transport::listen::tests::vsock_listen_uri_parses_port ... ok
[INFO] [stdout] test transport::listen::tests::vsock_listen_uri_port_zero_is_valid ... ok
[INFO] [stdout] test transport::listen::tests::vsock_listen_uri_with_cid_is_invalid ... ok
[INFO] [stdout] test transactions::tests::verify_detects_tampered_summary ... ok
[INFO] [stdout] test transactions::tests::verify_audit_chain_with_wrong_pubkey_is_broken ... ok
[INFO] [stdout] test transactions::tests::verify_audit_chain_intact_after_inserts ... ok
[INFO] [stdout] test transactions::tests::verify_audit_chain_with_pubkey_intact_after_inserts ... ok
[INFO] [stdout] test transactions::tests::concurrent_record_keeps_chain_intact_and_seqs_contiguous ... ok
[INFO] [stdout] test executor::tests::a_child_that_outlives_a_stdout_read_failure_is_stopped_not_orphaned ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- audit_chain::tests::audit_key_env_resolution_is_centralised stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'audit_chain::tests::audit_key_env_resolution_is_centralised' (5711) panicked at src/audit_chain.rs:1890:50:
[INFO] [stdout] source directory must be readable: Os { code: 2, kind: NotFound, message: "No such file or directory" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x60529284f7f1 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x60529284f7f1 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::trace_unsynchronized::<std[617be2ca0a6fd877]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x60529284f7f1 - std[617be2ca0a6fd877]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x60529284f7f1 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x605292867f8a - <core[a373ad73a504971]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x605292867f8a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    6:     0x605292854aec - core[a373ad73a504971]::io::write::default_write_fmt::<alloc[2e1b2a31b91974c5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:402:11
[INFO] [stdout]    7:     0x605292854aec - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:335:13
[INFO] [stdout]    8:     0x605292827296 - <std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x605292827296 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:289:27
[INFO] [stdout]   10:     0x605292845d39 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:313:9
[INFO] [stdout]   11:     0x6052920af640 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   12:     0x6052920af640 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:137:21
[INFO] [stdout]   13:     0x605292846062 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   14:     0x605292846062 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:819:13
[INFO] [stdout]   15:     0x605292827342 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:685:13
[INFO] [stdout]   16:     0x60529281fa99 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x60529282841d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:676:5
[INFO] [stdout]   18:     0x6052928687ac - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x605292868502 - core[a373ad73a504971]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/result.rs:1870:5
[INFO] [stdout]   20:     0x605291ccf7f8 - <core[a373ad73a504971]::result::Result<std[617be2ca0a6fd877]::fs::ReadDir, core[a373ad73a504971]::io::error::Error>>::expect
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/result.rs:1184:23
[INFO] [stdout]   21:     0x605291fd0701 - sysknife_daemon[ab2de4712a080799]::audit_chain::tests::audit_key_env_resolution_is_centralised
[INFO] [stdout]                                at /opt/rustwide/workdir/src/audit_chain.rs:1890:50
[INFO] [stdout]   22:     0x605291faf107 - sysknife_daemon[ab2de4712a080799]::audit_chain::tests::audit_key_env_resolution_is_centralised::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/audit_chain.rs:1881:49
[INFO] [stdout]   23:     0x605291b8b9b6 - <sysknife_daemon[ab2de4712a080799]::audit_chain::tests::audit_key_env_resolution_is_centralised::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x6052920a2a8b - <fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x6052920a2a8b - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:701:18
[INFO] [stdout]   26:     0x6052920afc65 - test[aada8e7e76ba119b]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:74
[INFO] [stdout]   27:     0x6052920afc65 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x6052920afc65 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   29:     0x6052920afc65 - std[617be2ca0a6fd877]::panicking::catch_unwind::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   30:     0x6052920afc65 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x6052920afc65 - test[aada8e7e76ba119b]::run_test_in_process
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:27
[INFO] [stdout]   32:     0x6052920afc65 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:645:43
[INFO] [stdout]   33:     0x6052920a9554 - test[aada8e7e76ba119b]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:675:41
[INFO] [stdout]   34:     0x6052920a9554 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x6052920b2cf2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   36:     0x6052920b2cf2 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x6052920b2cf2 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   38:     0x6052920b2cf2 - std[617be2ca0a6fd877]::panicking::catch_unwind::<(), core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   39:     0x6052920b2cf2 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x6052920b2cf2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   41:     0x6052920b2cf2 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x60529284e1ef - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn core[a373ad73a504971]::ops::function::FnOnce<(), Output = ()> + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2314:9
[INFO] [stdout]   43:     0x60529284e1ef - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   44:     0x745505851dfa - <unknown>
[INFO] [stdout]   45:     0x7455058e53d4 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- transactions::tests::no_watermark_emitted_before_any_record stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'transactions::tests::no_watermark_emitted_before_any_record' (6363) panicked at src/audit_watermark.rs:185:10:
[INFO] [stdout] watermark test sink already installed in this process: Mutex { data: [], poisoned: false, .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x60529284f7f1 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x60529284f7f1 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::trace_unsynchronized::<std[617be2ca0a6fd877]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x60529284f7f1 - std[617be2ca0a6fd877]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x60529284f7f1 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x605292867f8a - <core[a373ad73a504971]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x605292867f8a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    6:     0x605292854aec - core[a373ad73a504971]::io::write::default_write_fmt::<alloc[2e1b2a31b91974c5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:402:11
[INFO] [stdout]    7:     0x605292854aec - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:335:13
[INFO] [stdout]    8:     0x605292827296 - <std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x605292827296 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:289:27
[INFO] [stdout]   10:     0x605292845d39 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:313:9
[INFO] [stdout]   11:     0x6052920af640 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   12:     0x6052920af640 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:137:21
[INFO] [stdout]   13:     0x605292846062 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   14:     0x605292846062 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:819:13
[INFO] [stdout]   15:     0x605292827342 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:685:13
[INFO] [stdout]   16:     0x60529281fa99 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x60529282841d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:676:5
[INFO] [stdout]   18:     0x6052928687ac - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x605292868502 - core[a373ad73a504971]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/result.rs:1870:5
[INFO] [stdout]   20:     0x605291cd15fc - <core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::sync::Arc<std[617be2ca0a6fd877]::sync::poison::mutex::Mutex<alloc[2e1b2a31b91974c5]::vec::Vec<sysknife_daemon[ab2de4712a080799]::audit_watermark::WatermarkCall>>>>>::expect
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/result.rs:1184:23
[INFO] [stdout]   21:     0x605291ce9c9f - sysknife_daemon[ab2de4712a080799]::audit_watermark::install_test_sink
[INFO] [stdout]                                at /opt/rustwide/workdir/src/audit_watermark.rs:185:10
[INFO] [stdout]   22:     0x605292022b2d - sysknife_daemon[ab2de4712a080799]::transactions::tests::no_watermark_emitted_before_any_record
[INFO] [stdout]                                at /opt/rustwide/workdir/src/transactions.rs:3540:9
[INFO] [stdout]   23:     0x605292007f97 - sysknife_daemon[ab2de4712a080799]::transactions::tests::no_watermark_emitted_before_any_record::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/transactions.rs:3538:48
[INFO] [stdout]   24:     0x605291b8c2d6 - <sysknife_daemon[ab2de4712a080799]::transactions::tests::no_watermark_emitted_before_any_record::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x6052920a2a8b - <fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x6052920a2a8b - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:701:18
[INFO] [stdout]   27:     0x6052920afc65 - test[aada8e7e76ba119b]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:74
[INFO] [stdout]   28:     0x6052920afc65 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   29:     0x6052920afc65 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   30:     0x6052920afc65 - std[617be2ca0a6fd877]::panicking::catch_unwind::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   31:     0x6052920afc65 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x6052920afc65 - test[aada8e7e76ba119b]::run_test_in_process
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:27
[INFO] [stdout]   33:     0x6052920afc65 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:645:43
[INFO] [stdout]   34:     0x6052920a9554 - test[aada8e7e76ba119b]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:675:41
[INFO] [stdout]   35:     0x6052920a9554 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x6052920b2cf2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   37:     0x6052920b2cf2 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   38:     0x6052920b2cf2 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   39:     0x6052920b2cf2 - std[617be2ca0a6fd877]::panicking::catch_unwind::<(), core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   40:     0x6052920b2cf2 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x6052920b2cf2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   42:     0x6052920b2cf2 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x60529284e1ef - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn core[a373ad73a504971]::ops::function::FnOnce<(), Output = ()> + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2314:9
[INFO] [stdout]   44:     0x60529284e1ef - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   45:     0x745505851dfa - <unknown>
[INFO] [stdout]   46:     0x7455058e53d4 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- transactions::tests::record_emits_one_watermark_per_entry stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'transactions::tests::record_emits_one_watermark_per_entry' (6367) panicked at src/audit_watermark.rs:185:10:
[INFO] [stdout] watermark test sink already installed in this process: Mutex { data: [], poisoned: false, .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x60529284f7f1 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x60529284f7f1 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::trace_unsynchronized::<std[617be2ca0a6fd877]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x60529284f7f1 - std[617be2ca0a6fd877]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x60529284f7f1 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x605292867f8a - <core[a373ad73a504971]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x605292867f8a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    6:     0x605292854aec - core[a373ad73a504971]::io::write::default_write_fmt::<alloc[2e1b2a31b91974c5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:402:11
[INFO] [stdout]    7:     0x605292854aec - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:335:13
[INFO] [stdout]    8:     0x605292827296 - <std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x605292827296 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:289:27
[INFO] [stdout]   10:     0x605292845d39 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:313:9
[INFO] [stdout]   11:     0x6052920af640 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   12:     0x6052920af640 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:137:21
[INFO] [stdout]   13:     0x605292846062 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   14:     0x605292846062 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:819:13
[INFO] [stdout]   15:     0x605292827342 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:685:13
[INFO] [stdout]   16:     0x60529281fa99 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x60529282841d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:676:5
[INFO] [stdout]   18:     0x6052928687ac - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x605292868502 - core[a373ad73a504971]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/result.rs:1870:5
[INFO] [stdout]   20:     0x605291cd15fc - <core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::sync::Arc<std[617be2ca0a6fd877]::sync::poison::mutex::Mutex<alloc[2e1b2a31b91974c5]::vec::Vec<sysknife_daemon[ab2de4712a080799]::audit_watermark::WatermarkCall>>>>>::expect
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/result.rs:1184:23
[INFO] [stdout]   21:     0x605291ce9c9f - sysknife_daemon[ab2de4712a080799]::audit_watermark::install_test_sink
[INFO] [stdout]                                at /opt/rustwide/workdir/src/audit_watermark.rs:185:10
[INFO] [stdout]   22:     0x605292021b00 - sysknife_daemon[ab2de4712a080799]::transactions::tests::record_emits_one_watermark_per_entry
[INFO] [stdout]                                at /opt/rustwide/workdir/src/transactions.rs:3441:9
[INFO] [stdout]   23:     0x605292007f07 - sysknife_daemon[ab2de4712a080799]::transactions::tests::record_emits_one_watermark_per_entry::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/transactions.rs:3439:46
[INFO] [stdout]   24:     0x605291b8c276 - <sysknife_daemon[ab2de4712a080799]::transactions::tests::record_emits_one_watermark_per_entry::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x6052920a2a8b - <fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x6052920a2a8b - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:701:18
[INFO] [stdout]   27:     0x6052920afc65 - test[aada8e7e76ba119b]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:74
[INFO] [stdout]   28:     0x6052920afc65 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   29:     0x6052920afc65 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   30:     0x6052920afc65 - std[617be2ca0a6fd877]::panicking::catch_unwind::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   31:     0x6052920afc65 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x6052920afc65 - test[aada8e7e76ba119b]::run_test_in_process
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:27
[INFO] [stdout]   33:     0x6052920afc65 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:645:43
[INFO] [stdout]   34:     0x6052920a9554 - test[aada8e7e76ba119b]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:675:41
[INFO] [stdout]   35:     0x6052920a9554 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x6052920b2cf2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   37:     0x6052920b2cf2 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   38:     0x6052920b2cf2 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   39:     0x6052920b2cf2 - std[617be2ca0a6fd877]::panicking::catch_unwind::<(), core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   40:     0x6052920b2cf2 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x6052920b2cf2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   42:     0x6052920b2cf2 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x60529284e1ef - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn core[a373ad73a504971]::ops::function::FnOnce<(), Output = ()> + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2314:9
[INFO] [stdout]   44:     0x60529284e1ef - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   45:     0x745505851dfa - <unknown>
[INFO] [stdout]   46:     0x7455058e53d4 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- transactions::tests::record_previewed_emits_one_watermark stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'transactions::tests::record_previewed_emits_one_watermark' (6369) panicked at src/audit_watermark.rs:185:10:
[INFO] [stdout] watermark test sink already installed in this process: Mutex { data: [], poisoned: false, .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x60529284f7f1 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x60529284f7f1 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::trace_unsynchronized::<std[617be2ca0a6fd877]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x60529284f7f1 - std[617be2ca0a6fd877]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x60529284f7f1 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x605292867f8a - <core[a373ad73a504971]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x605292867f8a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    6:     0x605292854aec - core[a373ad73a504971]::io::write::default_write_fmt::<alloc[2e1b2a31b91974c5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:402:11
[INFO] [stdout]    7:     0x605292854aec - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:335:13
[INFO] [stdout]    8:     0x605292827296 - <std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x605292827296 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:289:27
[INFO] [stdout]   10:     0x605292845d39 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:313:9
[INFO] [stdout]   11:     0x6052920af640 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   12:     0x6052920af640 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:137:21
[INFO] [stdout]   13:     0x605292846062 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   14:     0x605292846062 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:819:13
[INFO] [stdout]   15:     0x605292827342 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:685:13
[INFO] [stdout]   16:     0x60529281fa99 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x60529282841d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:676:5
[INFO] [stdout]   18:     0x6052928687ac - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x605292868502 - core[a373ad73a504971]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/result.rs:1870:5
[INFO] [stdout]   20:     0x605291cd15fc - <core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::sync::Arc<std[617be2ca0a6fd877]::sync::poison::mutex::Mutex<alloc[2e1b2a31b91974c5]::vec::Vec<sysknife_daemon[ab2de4712a080799]::audit_watermark::WatermarkCall>>>>>::expect
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/result.rs:1184:23
[INFO] [stdout]   21:     0x605291ce9c9f - sysknife_daemon[ab2de4712a080799]::audit_watermark::install_test_sink
[INFO] [stdout]                                at /opt/rustwide/workdir/src/audit_watermark.rs:185:10
[INFO] [stdout]   22:     0x605292021fb8 - sysknife_daemon[ab2de4712a080799]::transactions::tests::record_previewed_emits_one_watermark
[INFO] [stdout]                                at /opt/rustwide/workdir/src/transactions.rs:3455:9
[INFO] [stdout]   23:     0x605292007f37 - sysknife_daemon[ab2de4712a080799]::transactions::tests::record_previewed_emits_one_watermark::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/transactions.rs:3453:46
[INFO] [stdout]   24:     0x605291b8c296 - <sysknife_daemon[ab2de4712a080799]::transactions::tests::record_previewed_emits_one_watermark::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x6052920a2a8b - <fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x6052920a2a8b - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:701:18
[INFO] [stdout]   27:     0x6052920afc65 - test[aada8e7e76ba119b]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:74
[INFO] [stdout]   28:     0x6052920afc65 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   29:     0x6052920afc65 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   30:     0x6052920afc65 - std[617be2ca0a6fd877]::panicking::catch_unwind::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   31:     0x6052920afc65 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x6052920afc65 - test[aada8e7e76ba119b]::run_test_in_process
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:27
[INFO] [stdout]   33:     0x6052920afc65 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:645:43
[INFO] [stdout]   34:     0x6052920a9554 - test[aada8e7e76ba119b]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:675:41
[INFO] [stdout]   35:     0x6052920a9554 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x6052920b2cf2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   37:     0x6052920b2cf2 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   38:     0x6052920b2cf2 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   39:     0x6052920b2cf2 - std[617be2ca0a6fd877]::panicking::catch_unwind::<(), core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   40:     0x6052920b2cf2 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x6052920b2cf2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   42:     0x6052920b2cf2 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x60529284e1ef - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn core[a373ad73a504971]::ops::function::FnOnce<(), Output = ()> + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2314:9
[INFO] [stdout]   44:     0x60529284e1ef - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   45:     0x745505851dfa - <unknown>
[INFO] [stdout]   46:     0x7455058e53d4 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- transactions::tests::multiple_records_produce_one_watermark_each stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'transactions::tests::multiple_records_produce_one_watermark_each' (6362) panicked at src/transactions.rs:3518:9:
[INFO] [stdout] assertion `left == right` failed: one watermark per record call
[INFO] [stdout]   left: 30
[INFO] [stdout]  right: 3
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x60529284f7f1 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x60529284f7f1 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::trace_unsynchronized::<std[617be2ca0a6fd877]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x60529284f7f1 - std[617be2ca0a6fd877]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x60529284f7f1 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x605292867f8a - <core[a373ad73a504971]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x605292867f8a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    6:     0x605292854aec - core[a373ad73a504971]::io::write::default_write_fmt::<alloc[2e1b2a31b91974c5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:402:11
[INFO] [stdout]    7:     0x605292854aec - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:335:13
[INFO] [stdout]    8:     0x605292827296 - <std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x605292827296 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:289:27
[INFO] [stdout]   10:     0x605292845d39 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:313:9
[INFO] [stdout]   11:     0x6052920af640 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   12:     0x6052920af640 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:137:21
[INFO] [stdout]   13:     0x605292846062 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   14:     0x605292846062 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:819:13
[INFO] [stdout]   15:     0x605292827342 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:685:13
[INFO] [stdout]   16:     0x60529281fa99 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x60529282841d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:676:5
[INFO] [stdout]   18:     0x6052928687ac - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x6052928686a3 - core[a373ad73a504971]::panicking::assert_failed_inner
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:447:23
[INFO] [stdout]   20:     0x605292862efd - core[a373ad73a504971]::panicking::assert_failed::<usize, usize>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:407:5
[INFO] [stdout]   21:     0x60529202be39 - sysknife_daemon[ab2de4712a080799]::transactions::tests::multiple_records_produce_one_watermark_each
[INFO] [stdout]                                at /opt/rustwide/workdir/src/transactions.rs:3518:9
[INFO] [stdout]   22:     0x6052920082f7 - sysknife_daemon[ab2de4712a080799]::transactions::tests::multiple_records_produce_one_watermark_each::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/transactions.rs:3507:53
[INFO] [stdout]   23:     0x605291b8c516 - <sysknife_daemon[ab2de4712a080799]::transactions::tests::multiple_records_produce_one_watermark_each::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x6052920a2a8b - <fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x6052920a2a8b - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:701:18
[INFO] [stdout]   26:     0x6052920afc65 - test[aada8e7e76ba119b]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:74
[INFO] [stdout]   27:     0x6052920afc65 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x6052920afc65 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   29:     0x6052920afc65 - std[617be2ca0a6fd877]::panicking::catch_unwind::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   30:     0x6052920afc65 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x6052920afc65 - test[aada8e7e76ba119b]::run_test_in_process
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:27
[INFO] [stdout]   32:     0x6052920afc65 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:645:43
[INFO] [stdout]   33:     0x6052920a9554 - test[aada8e7e76ba119b]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:675:41
[INFO] [stdout]   34:     0x6052920a9554 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x6052920b2cf2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   36:     0x6052920b2cf2 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x6052920b2cf2 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   38:     0x6052920b2cf2 - std[617be2ca0a6fd877]::panicking::catch_unwind::<(), core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   39:     0x6052920b2cf2 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x6052920b2cf2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   41:     0x6052920b2cf2 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x60529284e1ef - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn core[a373ad73a504971]::ops::function::FnOnce<(), Output = ()> + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2314:9
[INFO] [stdout]   43:     0x60529284e1ef - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   44:     0x745505851dfa - <unknown>
[INFO] [stdout]   45:     0x7455058e53d4 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- transactions::tests::watermark_seq_and_hash_match_chain_row stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'transactions::tests::watermark_seq_and_hash_match_chain_row' (6397) panicked at src/audit_watermark.rs:185:10:
[INFO] [stdout] watermark test sink already installed in this process: Mutex { data: [], poisoned: false, .. }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x60529284f7f1 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x60529284f7f1 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::trace_unsynchronized::<std[617be2ca0a6fd877]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x60529284f7f1 - std[617be2ca0a6fd877]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x60529284f7f1 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x605292867f8a - <core[a373ad73a504971]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x605292867f8a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    6:     0x605292854aec - core[a373ad73a504971]::io::write::default_write_fmt::<alloc[2e1b2a31b91974c5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:402:11
[INFO] [stdout]    7:     0x605292854aec - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:335:13
[INFO] [stdout]    8:     0x605292827296 - <std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x605292827296 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:289:27
[INFO] [stdout]   10:     0x605292845d39 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:313:9
[INFO] [stdout]   11:     0x6052920af640 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   12:     0x6052920af640 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:137:21
[INFO] [stdout]   13:     0x605292846062 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   14:     0x605292846062 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:819:13
[INFO] [stdout]   15:     0x605292827342 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:685:13
[INFO] [stdout]   16:     0x60529281fa99 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x60529282841d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:676:5
[INFO] [stdout]   18:     0x6052928687ac - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x605292868502 - core[a373ad73a504971]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/result.rs:1870:5
[INFO] [stdout]   20:     0x605291cd15fc - <core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::sync::Arc<std[617be2ca0a6fd877]::sync::poison::mutex::Mutex<alloc[2e1b2a31b91974c5]::vec::Vec<sysknife_daemon[ab2de4712a080799]::audit_watermark::WatermarkCall>>>>>::expect
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/result.rs:1184:23
[INFO] [stdout]   21:     0x605291ce9c9f - sysknife_daemon[ab2de4712a080799]::audit_watermark::install_test_sink
[INFO] [stdout]                                at /opt/rustwide/workdir/src/audit_watermark.rs:185:10
[INFO] [stdout]   22:     0x60529202365a - sysknife_daemon[ab2de4712a080799]::transactions::tests::watermark_seq_and_hash_match_chain_row
[INFO] [stdout]                                at /opt/rustwide/workdir/src/transactions.rs:3486:9
[INFO] [stdout]   23:     0x605292007ff7 - sysknife_daemon[ab2de4712a080799]::transactions::tests::watermark_seq_and_hash_match_chain_row::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/transactions.rs:3484:48
[INFO] [stdout]   24:     0x605291b8c316 - <sysknife_daemon[ab2de4712a080799]::transactions::tests::watermark_seq_and_hash_match_chain_row::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x6052920a2a8b - <fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x6052920a2a8b - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:701:18
[INFO] [stdout]   27:     0x6052920afc65 - test[aada8e7e76ba119b]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:74
[INFO] [stdout]   28:     0x6052920afc65 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   29:     0x6052920afc65 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   30:     0x6052920afc65 - std[617be2ca0a6fd877]::panicking::catch_unwind::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   31:     0x6052920afc65 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x6052920afc65 - test[aada8e7e76ba119b]::run_test_in_process
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:27
[INFO] [stdout]   33:     0x6052920afc65 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:645:43
[INFO] [stdout]   34:     0x6052920a9554 - test[aada8e7e76ba119b]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:675:41
[INFO] [stdout]   35:     0x6052920a9554 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x6052920b2cf2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   37:     0x6052920b2cf2 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   38:     0x6052920b2cf2 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   39:     0x6052920b2cf2 - std[617be2ca0a6fd877]::panicking::catch_unwind::<(), core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   40:     0x6052920b2cf2 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x6052920b2cf2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   42:     0x6052920b2cf2 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x60529284e1ef - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn core[a373ad73a504971]::ops::function::FnOnce<(), Output = ()> + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2314:9
[INFO] [stdout]   44:     0x60529284e1ef - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   45:     0x745505851dfa - <unknown>
[INFO] [stdout]   46:     0x7455058e53d4 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- executor::tests::a_child_that_outlives_a_stdout_read_failure_is_stopped_not_orphaned stdout ----
[INFO] [stdout] [sysknife-daemon] sh could not be read (stream did not contain valid UTF-8) and process group 6027 could not be confirmed stopped (AliveReachable)
[INFO] [stdout] 
[INFO] [stdout] thread 'executor::tests::a_child_that_outlives_a_stdout_read_failure_is_stopped_not_orphaned' (6023) panicked at src/executor.rs:2809:9:
[INFO] [stdout] the read failure itself must be surfaced, got: ActionNotStopped { program: "sh", pgid: 6027, timeout_secs: 7200 }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x60529284f7f1 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x60529284f7f1 - std[617be2ca0a6fd877]::backtrace_rs::backtrace::trace_unsynchronized::<std[617be2ca0a6fd877]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x60529284f7f1 - std[617be2ca0a6fd877]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x60529284f7f1 - <<std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[a373ad73a504971]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x605292867f8a - <core[a373ad73a504971]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x605292867f8a - core[a373ad73a504971]::fmt::write
[INFO] [stdout]    6:     0x605292854aec - core[a373ad73a504971]::io::write::default_write_fmt::<alloc[2e1b2a31b91974c5]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:402:11
[INFO] [stdout]    7:     0x605292854aec - <alloc[2e1b2a31b91974c5]::vec::Vec<u8> as core[a373ad73a504971]::io::write::Write>::write_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/io/write.rs:335:13
[INFO] [stdout]    8:     0x605292827296 - <std[617be2ca0a6fd877]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x605292827296 - std[617be2ca0a6fd877]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:289:27
[INFO] [stdout]   10:     0x605292845d39 - std[617be2ca0a6fd877]::panicking::default_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:313:9
[INFO] [stdout]   11:     0x6052920af640 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   12:     0x6052920af640 - test[aada8e7e76ba119b]::test_main_inner::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:137:21
[INFO] [stdout]   13:     0x605292846062 - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn for<'a, 'b> core[a373ad73a504971]::ops::function::Fn<(&'a std[617be2ca0a6fd877]::panic::PanicHookInfo<'b>,), Output = ()> + core[a373ad73a504971]::marker::Sync + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::Fn<(&std[617be2ca0a6fd877]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2328:9
[INFO] [stdout]   14:     0x605292846062 - std[617be2ca0a6fd877]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:819:13
[INFO] [stdout]   15:     0x605292827342 - std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:685:13
[INFO] [stdout]   16:     0x60529281fa99 - std[617be2ca0a6fd877]::sys::backtrace::__rust_end_short_backtrace::<std[617be2ca0a6fd877]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x60529282841d - __rustc[ea4f61d10b84890b]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:676:5
[INFO] [stdout]   18:     0x6052928687ac - core[a373ad73a504971]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x605291e136e7 - sysknife_daemon[ab2de4712a080799]::executor::tests::a_child_that_outlives_a_stdout_read_failure_is_stopped_not_orphaned::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/executor.rs:2809:9
[INFO] [stdout]   20:     0x605292068732 - <core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>> as core[a373ad73a504971]::future::future::Future>::poll
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/future/future.rs:133:9
[INFO] [stdout]   21:     0x60529206884d - <core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>> as core[a373ad73a504971]::future::future::Future>::poll
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/future/future.rs:133:9
[INFO] [stdout]   22:     0x605291ccb5dd - <tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/scheduler/current_thread/mod.rs:830:70
[INFO] [stdout]   23:     0x605291cc92f5 - tokio[76dfe31076b92a49]::task::coop::with_budget::<core[a373ad73a504971]::task::poll::Poll<()>, <tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/task/coop/mod.rs:167:5
[INFO] [stdout]   24:     0x605291cc92f5 - tokio[76dfe31076b92a49]::task::coop::budget::<core[a373ad73a504971]::task::poll::Poll<()>, <tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/task/coop/mod.rs:133:5
[INFO] [stdout]   25:     0x605291cc92f5 - <tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/scheduler/current_thread/mod.rs:830:25
[INFO] [stdout]   26:     0x605291c9fb72 - <tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::Context>::enter::<core[a373ad73a504971]::task::poll::Poll<()>, <tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/scheduler/current_thread/mod.rs:488:19
[INFO] [stdout]   27:     0x605291cc501d - <tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/scheduler/current_thread/mod.rs:829:44
[INFO] [stdout]   28:     0x605291cc3754 - <tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CoreGuard>::enter::<<tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}, core[a373ad73a504971]::option::Option<()>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/scheduler/current_thread/mod.rs:906:68
[INFO] [stdout]   29:     0x605291e6a02b - <tokio[76dfe31076b92a49]::runtime::context::scoped::Scoped<tokio[76dfe31076b92a49]::runtime::scheduler::Context>>::set::<<tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}, core[a373ad73a504971]::option::Option<()>>::{closure#0}, (alloc[2e1b2a31b91974c5]::boxed::Box<tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::Core>, core[a373ad73a504971]::option::Option<()>)>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/context/scoped.rs:40:9
[INFO] [stdout]   30:     0x605291bb1789 - tokio[76dfe31076b92a49]::runtime::context::set_scheduler::<(alloc[2e1b2a31b91974c5]::boxed::Box<tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::Core>, core[a373ad73a504971]::option::Option<()>), <tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}, core[a373ad73a504971]::option::Option<()>>::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/context.rs:187:38
[INFO] [stdout]   31:     0x605291ca06ff - <std[617be2ca0a6fd877]::thread::local::LocalKey<tokio[76dfe31076b92a49]::runtime::context::Context>>::try_with::<tokio[76dfe31076b92a49]::runtime::context::set_scheduler<(alloc[2e1b2a31b91974c5]::boxed::Box<tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::Core>, core[a373ad73a504971]::option::Option<()>), <tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}, core[a373ad73a504971]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[2e1b2a31b91974c5]::boxed::Box<tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::Core>, core[a373ad73a504971]::option::Option<()>)>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/local.rs:463:12
[INFO] [stdout]   32:     0x605291c9fe0e - <std[617be2ca0a6fd877]::thread::local::LocalKey<tokio[76dfe31076b92a49]::runtime::context::Context>>::with::<tokio[76dfe31076b92a49]::runtime::context::set_scheduler<(alloc[2e1b2a31b91974c5]::boxed::Box<tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::Core>, core[a373ad73a504971]::option::Option<()>), <tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}, core[a373ad73a504971]::option::Option<()>>::{closure#0}>::{closure#0}, (alloc[2e1b2a31b91974c5]::boxed::Box<tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::Core>, core[a373ad73a504971]::option::Option<()>)>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/local.rs:427:20
[INFO] [stdout]   33:     0x605291ba3afd - tokio[76dfe31076b92a49]::runtime::context::set_scheduler::<(alloc[2e1b2a31b91974c5]::boxed::Box<tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::Core>, core[a373ad73a504971]::option::Option<()>), <tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CoreGuard>::enter<<tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}, core[a373ad73a504971]::option::Option<()>>::{closure#0}>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/context.rs:187:17
[INFO] [stdout]   34:     0x605291cb9610 - <tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CoreGuard>::enter::<<tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CoreGuard>::block_on<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>::{closure#0}, core[a373ad73a504971]::option::Option<()>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/scheduler/current_thread/mod.rs:906:27
[INFO] [stdout]   35:     0x605291cb9e06 - <tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CoreGuard>::block_on::<core[a373ad73a504971]::pin::Pin<&mut core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/scheduler/current_thread/mod.rs:817:24
[INFO] [stdout]   36:     0x605291cc29f0 - <tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CurrentThread>::block_on::<core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/scheduler/current_thread/mod.rs:218:33
[INFO] [stdout]   37:     0x605291ea5e98 - tokio[76dfe31076b92a49]::runtime::context::runtime::enter_runtime::<<tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CurrentThread>::block_on<core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>::{closure#0}, ()>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/context/runtime.rs:65:16
[INFO] [stdout]   38:     0x605291c9ef24 - <tokio[76dfe31076b92a49]::runtime::scheduler::current_thread::CurrentThread>::block_on::<core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/scheduler/current_thread/mod.rs:206:9
[INFO] [stdout]   39:     0x605291c2815f - <tokio[76dfe31076b92a49]::runtime::runtime::Runtime>::block_on_inner::<core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/runtime.rs:374:52
[INFO] [stdout]   40:     0x605291c2844b - <tokio[76dfe31076b92a49]::runtime::runtime::Runtime>::block_on::<core[a373ad73a504971]::pin::Pin<&mut dyn core[a373ad73a504971]::future::future::Future<Output = ()>>>
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.53.1/src/runtime/runtime.rs:343:18
[INFO] [stdout]   41:     0x605291e55421 - sysknife_daemon[ab2de4712a080799]::executor::tests::a_child_that_outlives_a_stdout_read_failure_is_stopped_not_orphaned
[INFO] [stdout]                                at /opt/rustwide/workdir/src/executor.rs:2823:10
[INFO] [stdout]   42:     0x605291e0dfd7 - sysknife_daemon[ab2de4712a080799]::executor::tests::a_child_that_outlives_a_stdout_read_failure_is_stopped_not_orphaned::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/executor.rs:2795:83
[INFO] [stdout]   43:     0x605291b8e836 - <sysknife_daemon[ab2de4712a080799]::executor::tests::a_child_that_outlives_a_stdout_read_failure_is_stopped_not_orphaned::{closure#0} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   44:     0x6052920a2a8b - <fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   45:     0x6052920a2a8b - test[aada8e7e76ba119b]::__rust_begin_short_backtrace::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, fn() -> core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:701:18
[INFO] [stdout]   46:     0x6052920afc65 - test[aada8e7e76ba119b]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:74
[INFO] [stdout]   47:     0x6052920afc65 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   48:     0x6052920afc65 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   49:     0x6052920afc65 - std[617be2ca0a6fd877]::panicking::catch_unwind::<core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>, core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   50:     0x6052920afc65 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<test[aada8e7e76ba119b]::run_test_in_process::{closure#0}>, core[a373ad73a504971]::result::Result<(), alloc[2e1b2a31b91974c5]::string::String>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   51:     0x6052920afc65 - test[aada8e7e76ba119b]::run_test_in_process
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:724:27
[INFO] [stdout]   52:     0x6052920afc65 - test[aada8e7e76ba119b]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:645:43
[INFO] [stdout]   53:     0x6052920a9554 - test[aada8e7e76ba119b]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/test/src/lib.rs:675:41
[INFO] [stdout]   54:     0x6052920a9554 - std[617be2ca0a6fd877]::sys::backtrace::__rust_begin_short_backtrace::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   55:     0x6052920b2cf2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   56:     0x6052920b2cf2 - <core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   57:     0x6052920b2cf2 - std[617be2ca0a6fd877]::panicking::catch_unwind::do_call::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:573:43
[INFO] [stdout]   58:     0x6052920b2cf2 - std[617be2ca0a6fd877]::panicking::catch_unwind::<(), core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panicking.rs:541:19
[INFO] [stdout]   59:     0x6052920b2cf2 - std[617be2ca0a6fd877]::panic::catch_unwind::<core[a373ad73a504971]::panic::unwind_safe::AssertUnwindSafe<std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/panic.rs:359:14
[INFO] [stdout]   60:     0x6052920b2cf2 - std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked::<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   61:     0x6052920b2cf2 - <std[617be2ca0a6fd877]::thread::lifecycle::spawn_unchecked<test[aada8e7e76ba119b]::run_test::{closure#1}, ()>::{closure#1} as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   62:     0x60529284e1ef - <alloc[2e1b2a31b91974c5]::boxed::Box<dyn core[a373ad73a504971]::ops::function::FnOnce<(), Output = ()> + core[a373ad73a504971]::marker::Send> as core[a373ad73a504971]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/alloc/src/boxed.rs:2314:9
[INFO] [stdout]   63:     0x60529284e1ef - <std[617be2ca0a6fd877]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/e3feeb59cd1bdd011a2bfcc0747b55125d9b8527/library/std/src/sys/thread/unix.rs:127:17
[INFO] [stdout]   64:     0x745505851dfa - <unknown>
[INFO] [stdout]   65:     0x7455058e53d4 - clone
[INFO] [stdout]   66:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     audit_chain::tests::audit_key_env_resolution_is_centralised
[INFO] [stdout]     executor::tests::a_child_that_outlives_a_stdout_read_failure_is_stopped_not_orphaned
[INFO] [stdout]     transactions::tests::multiple_records_produce_one_watermark_each
[INFO] [stdout]     transactions::tests::no_watermark_emitted_before_any_record
[INFO] [stdout]     transactions::tests::record_emits_one_watermark_per_entry
[INFO] [stdout]     transactions::tests::record_previewed_emits_one_watermark
[INFO] [stdout]     transactions::tests::watermark_seq_and_hash_match_chain_row
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 916 passed; 7 failed; 0 ignored; 0 measured; 0 filtered out; finished in 7.70s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "f87c95844b4d33a8a02dae4638455ec4476390ccf4224712fbdcf27ff23e83c5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f87c95844b4d33a8a02dae4638455ec4476390ccf4224712fbdcf27ff23e83c5", kill_on_drop: false }`
[INFO] [stdout] f87c95844b4d33a8a02dae4638455ec4476390ccf4224712fbdcf27ff23e83c5
