[INFO] fetching crate stagecrew 0.4.3...
[INFO] testing stagecrew-0.4.3 against 1.95.0 for beta-1.96-2
[INFO] extracting crate stagecrew 0.4.3 into /workspace/builds/worker-0-tc1/source
[INFO] removed /workspace/builds/worker-0-tc1/source/rust-toolchain.toml
[INFO] started tweaking crates.io crate stagecrew 0.4.3
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate stagecrew 0.4.3
[INFO] tweaked toml for crates.io crate stagecrew 0.4.3 written to /workspace/builds/worker-0-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate stagecrew 0.4.3 on toolchain 1.95.0
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.95.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate stagecrew 0.4.3 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.95.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded windows-interface v0.56.0
[INFO] [stderr]   Downloaded xdg v3.0.0
[INFO] [stderr]   Downloaded termbg v0.6.2
[INFO] [stderr]   Downloaded windows-core v0.56.0
[INFO] [stderr]   Downloaded trash v5.2.5
[INFO] [stderr]   Downloaded windows-implement v0.56.0
[INFO] [stderr]   Downloaded unicode-plot v0.1.0
[INFO] [stderr]   Downloaded clap-verbosity-flag v3.0.4
[INFO] [stderr]   Downloaded zerocopy-derive v0.8.37
[INFO] [stderr]   Downloaded inquire v0.9.4
[INFO] [stderr]   Downloaded zerocopy v0.8.37
[INFO] [stderr]   Downloaded tui-piechart v0.2.8
[INFO] [stderr]   Downloaded windows v0.56.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] a91e0955db70dae71782b2a77c071f502f3d994853a2375fe619fbc6e25c431d
[INFO] running `Command { std: "docker" "start" "-a" "a91e0955db70dae71782b2a77c071f502f3d994853a2375fe619fbc6e25c431d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "a91e0955db70dae71782b2a77c071f502f3d994853a2375fe619fbc6e25c431d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a91e0955db70dae71782b2a77c071f502f3d994853a2375fe619fbc6e25c431d", kill_on_drop: false }`
[INFO] [stdout] a91e0955db70dae71782b2a77c071f502f3d994853a2375fe619fbc6e25c431d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] f46d75b972ec3397123688022ee0eac9d7321b925318d9f48591968573652d03
[INFO] running `Command { std: "docker" "start" "-a" "f46d75b972ec3397123688022ee0eac9d7321b925318d9f48591968573652d03", kill_on_drop: false }`
[INFO] [stderr]    Compiling scopeguard v1.2.0
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling syn v2.0.114
[INFO] [stderr]    Compiling mio v1.1.1
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling signal-hook v0.3.18
[INFO] [stderr]    Compiling rustix v0.38.44
[INFO] [stderr]    Compiling linux-raw-sys v0.4.15
[INFO] [stderr]    Compiling lock_api v0.4.14
[INFO] [stderr]    Compiling cc v1.2.55
[INFO] [stderr]    Compiling predicates-core v1.0.10
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling signal-hook-mio v0.2.5
[INFO] [stderr]    Compiling ryu v1.0.22
[INFO] [stderr]    Compiling mockall_derive v0.13.1
[INFO] [stderr]    Compiling owo-colors v4.2.3
[INFO] [stderr]    Compiling rustix v1.1.3
[INFO] [stderr]    Compiling time-macros v0.2.27
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling itertools v0.13.0
[INFO] [stderr]    Compiling ref-cast v1.0.25
[INFO] [stderr]    Compiling unicode-width v0.1.14
[INFO] [stderr]    Compiling crossterm v0.28.1
[INFO] [stderr]    Compiling termtree v0.5.1
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling color-spantrace v0.3.0
[INFO] [stderr]    Compiling predicates-tree v1.0.13
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling time v0.3.47
[INFO] [stderr]    Compiling libsqlite3-sys v0.36.0
[INFO] [stderr]    Compiling clap_builder v4.5.56
[INFO] [stderr]    Compiling dirs-sys v0.5.0
[INFO] [stderr]    Compiling compact_str v0.8.1
[INFO] [stderr]    Compiling unicode-truncate v1.1.0
[INFO] [stderr]    Compiling darling_core v0.23.0
[INFO] [stderr]    Compiling serde_derive_internals v0.29.1
[INFO] [stderr]    Compiling lru v0.12.5
[INFO] [stderr]    Compiling predicates v3.1.4
[INFO] [stderr]    Compiling cassowary v0.3.0
[INFO] [stderr]    Compiling dyn-clone v1.0.20
[INFO] [stderr]    Compiling fragile v2.0.1
[INFO] [stderr]    Compiling downcast v0.11.0
[INFO] [stderr]    Compiling simplelog v0.12.2
[INFO] [stderr]    Compiling backtrace v0.3.76
[INFO] [stderr]    Compiling toml_parser v1.0.6+spec-1.1.0
[INFO] [stderr]    Compiling chrono v0.4.43
[INFO] [stderr]    Compiling toml_datetime v0.7.5+spec-1.1.0
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling derive_more-impl v2.1.1
[INFO] [stderr]    Compiling strum_macros v0.26.4
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling darling_macro v0.23.0
[INFO] [stderr]    Compiling tracing-subscriber v0.3.22
[INFO] [stderr]    Compiling darling v0.23.0
[INFO] [stderr]    Compiling instability v0.3.11
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling derive_more v2.1.1
[INFO] [stderr]    Compiling clap_derive v4.5.55
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling ref-cast-impl v1.0.25
[INFO] [stderr]    Compiling strum v0.26.3
[INFO] [stderr]    Compiling ratatui v0.29.0
[INFO] [stderr]    Compiling tracing-error v0.2.1
[INFO] [stderr]    Compiling clap v4.5.56
[INFO] [stderr]    Compiling crossterm v0.29.0
[INFO] [stderr]    Compiling schemars_derive v1.2.1
[INFO] [stderr]    Compiling tokio-macros v2.6.0
[INFO] [stderr]    Compiling futures-executor v0.3.31
[INFO] [stderr]    Compiling serde_spanned v1.0.4
[INFO] [stderr]    Compiling dirs v6.0.0
[INFO] [stderr]    Compiling hashlink v0.11.0
[INFO] [stderr]    Compiling fuzzy-matcher v0.3.7
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling csv-core v0.1.13
[INFO] [stderr]    Compiling fallible-iterator v0.3.0
[INFO] [stderr]    Compiling toml_writer v1.0.6+spec-1.1.0
[INFO] [stderr]    Compiling mockall v0.13.1
[INFO] [stderr]    Compiling fallible-streaming-iterator v0.1.9
[INFO] [stderr]    Compiling termbg v0.6.2
[INFO] [stderr]    Compiling csv v1.4.0
[INFO] [stderr]    Compiling toml v0.9.11+spec-1.1.0
[INFO] [stderr]    Compiling inquire v0.9.4
[INFO] [stderr]    Compiling schemars v1.2.1
[INFO] [stderr]    Compiling tokio v1.49.0
[INFO] [stderr]    Compiling trash v5.2.5
[INFO] [stderr]    Compiling tui-piechart v0.2.8
[INFO] [stderr]    Compiling shellexpand v3.1.1
[INFO] [stderr]    Compiling futures v0.3.31
[INFO] [stderr]    Compiling clap-verbosity-flag v3.0.4
[INFO] [stderr]    Compiling color-eyre v0.6.5
[INFO] [stderr]    Compiling unicode-plot v0.1.0
[INFO] [stderr]    Compiling jwalk v0.8.1
[INFO] [stderr]    Compiling xdg v3.0.0
[INFO] [stderr]    Compiling jiff v0.2.18
[INFO] [stderr]    Compiling rusqlite v0.38.0
[INFO] [stderr]    Compiling stagecrew v0.4.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 2m 08s
[INFO] running `Command { std: "docker" "inspect" "f46d75b972ec3397123688022ee0eac9d7321b925318d9f48591968573652d03", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f46d75b972ec3397123688022ee0eac9d7321b925318d9f48591968573652d03", kill_on_drop: false }`
[INFO] [stdout] f46d75b972ec3397123688022ee0eac9d7321b925318d9f48591968573652d03
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 6eb7572ec48e67da9cb869c0b91317130550be3d48c56fd756ab7127ad3e542a
[INFO] running `Command { std: "docker" "start" "-a" "6eb7572ec48e67da9cb869c0b91317130550be3d48c56fd756ab7127ad3e542a", kill_on_drop: false }`
[INFO] [stderr]    Compiling rustix v1.1.3
[INFO] [stderr]    Compiling regex-automata v0.4.13
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling zerocopy v0.8.37
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling wait-timeout v0.2.1
[INFO] [stderr]    Compiling tracing-test-macro v0.2.6
[INFO] [stderr]    Compiling filetime v0.2.27
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling rand_xorshift v0.4.0
[INFO] [stderr]    Compiling chrono v0.4.43
[INFO] [stderr]    Compiling matchers v0.2.0
[INFO] [stderr]    Compiling tracing-subscriber v0.3.22
[INFO] [stderr]    Compiling trash v5.2.5
[INFO] [stderr]    Compiling crossterm v0.29.0
[INFO] [stderr]    Compiling tempfile v3.24.0
[INFO] [stderr]    Compiling rusty-fork v0.3.1
[INFO] [stderr]    Compiling tracing-error v0.2.1
[INFO] [stderr]    Compiling tracing-test v0.2.6
[INFO] [stderr]    Compiling color-spantrace v0.3.0
[INFO] [stderr]    Compiling inquire v0.9.4
[INFO] [stderr]    Compiling color-eyre v0.6.5
[INFO] [stderr]    Compiling stagecrew v0.4.3 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling proptest v1.9.0
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1m 02s
[INFO] running `Command { std: "docker" "inspect" "6eb7572ec48e67da9cb869c0b91317130550be3d48c56fd756ab7127ad3e542a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6eb7572ec48e67da9cb869c0b91317130550be3d48c56fd756ab7127ad3e542a", kill_on_drop: false }`
[INFO] [stdout] 6eb7572ec48e67da9cb869c0b91317130550be3d48c56fd756ab7127ad3e542a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 66162ad1e3df171edfe62eb73ed3aa4994fd854d30059a3ba95749061d9c2805
[INFO] running `Command { std: "docker" "start" "-a" "66162ad1e3df171edfe62eb73ed3aa4994fd854d30059a3ba95749061d9c2805", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.47s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/stagecrew-b586a9848f60e272)
[INFO] [stdout] 
[INFO] [stdout] running 175 tests
[INFO] [stdout] test audit::tests::audit_action_as_str_matches_schema_check_constraint ... ok
[INFO] [stdout] test audit::tests::audit_service_current_user_reads_environment ... ok
[INFO] [stdout] test audit::tests::audit_service_list_recent_respects_limit ... ok
[INFO] [stdout] test audit::tests::audit_service_list_recent_with_zero_limit ... ok
[INFO] [stdout] test audit::tests::audit_service_records_all_action_types ... ok
[INFO] [stdout] test audit::tests::audit_service_list_by_path_returns_empty_for_nonexistent ... ok
[INFO] [stdout] test audit::tests::audit_service_list_by_path_filters_correctly ... ok
[INFO] [stdout] test audit::tests::audit_service_list_recent_on_empty_db ... ok
[INFO] [stdout] test audit::tests::export_format_next_cycles_correctly ... ok
[INFO] [stdout] test audit::tests::audit_service_list_recent_orders_by_timestamp_desc ... ok
[INFO] [stdout] test audit::tests::audit_service_records_all_fields ... ok
[INFO] [stdout] test audit::tests::audit_service_records_entry ... ok
[INFO] [stdout] test audit::tests::audit_service_records_entry_without_target_path ... ok
[INFO] [stdout] test audit::tests::export_empty_audit_log_produces_valid_output ... ok
[INFO] [stdout] test audit::tests::export_csv_produces_valid_csv_with_header ... ok
[INFO] [stdout] test audit::tests::export_csv_handles_special_characters_in_fields ... ok
[INFO] [stdout] test config::tests::app_config_for_root_returns_global_when_no_local ... ok
[INFO] [stdout] test config::tests::app_config_from_global_has_empty_per_root ... ok
[INFO] [stdout] test config::tests::app_config_handles_malformed_local_config ... ok
[INFO] [stdout] test config::tests::app_config_load_per_root_clears_previous ... ok
[INFO] [stdout] test audit::tests::export_jsonl_produces_valid_json_lines ... ok
[INFO] [stdout] test config::tests::app_config_load_per_root_discovers_local_configs ... ok
[INFO] [stdout] test config::tests::config_default_values ... ok
[INFO] [stdout] test config::tests::config_deserializes_from_toml ... ok
[INFO] [stdout] test config::tests::config_expands_tilde_in_database_path ... ok
[INFO] [stdout] test config::tests::app_config_reload_refreshes_configs ... ok
[INFO] [stdout] test audit::tests::export_jsonl_preserves_null_optional_fields ... ok
[INFO] [stdout] test config::tests::config_expands_tilde_only_prefix ... ok
[INFO] [stdout] test config::tests::config_handles_paths_without_tilde ... ok
[INFO] [stdout] test config::tests::config_file_falls_back_to_xdg_when_no_override ... ok
[INFO] [stdout] test config::tests::config_file_uses_override_path ... ok
[INFO] [stdout] test config::tests::config_schema_includes_scan_start_time ... ok
[INFO] [stdout] test config::tests::config_rejects_invalid_scan_start_time ... ok
[INFO] [stdout] test config::tests::config_uses_defaults_for_missing_fields ... ok
[INFO] [stdout] test config::tests::config_load_expands_tilde_in_tracked_paths ... ok
[INFO] [stdout] test config::tests::database_file_derives_from_tracked_paths ... ok
[INFO] [stdout] test config::tests::config_serializes_to_toml ... ok
[INFO] [stdout] test config::tests::database_file_falls_back_to_xdg_when_no_tracked_paths ... ok
[INFO] [stdout] test config::tests::database_file_explicit_path_takes_precedence_over_tracked_paths ... ok
[INFO] [stdout] test config::tests::database_file_override_beats_config_database_path ... ok
[INFO] [stdout] test config::tests::database_file_falls_back_to_config_when_no_override ... ok
[INFO] [stdout] test config::tests::database_file_uses_explicit_path_when_set ... ok
[INFO] [stdout] test audit::tests::record_event_blocked_outcome_emits_warn_level ... ok
[INFO] [stdout] test config::tests::local_config_merge_overrides_non_expiration_fields ... ok
[INFO] [stdout] test config::tests::local_config_merge_preserves_base_when_none ... ok
[INFO] [stdout] test config::tests::local_config_nonexistent_root_returns_none ... ok
[INFO] [stdout] test config::tests::database_file_uses_override_path ... ok
[INFO] [stdout] test config::tests::local_config_merge_overrides_base_values ... ok
[INFO] [stdout] test config::tests::local_config_loads_from_root_directory ... ok
[INFO] [stdout] test config::tests::local_config_path_is_directory_returns_error ... ok
[INFO] [stdout] test config::tests::local_config_rejects_unknown_fields ... ok
[INFO] [stdout] test config::tests::local_config_rejects_database_path ... ok
[INFO] [stdout] test config::tests::local_config_rejects_tracked_paths ... ok
[INFO] [stdout] test config::tests::local_config_returns_none_when_missing ... ok
[INFO] [stdout] test config::tests::local_config_rejects_wrong_field_types ... ok
[INFO] [stdout] test audit::tests::record_event_blocked_outcome_writes_db_row ... ok
[INFO] [stdout] test audit::tests::record_event_scanner_transition_emits_tracing_event ... ok
[INFO] [stdout] test config::tests::local_config_unreadable_file_returns_error ... FAILED
[INFO] [stdout] test audit::tests::record_event_writes_db_row_and_emits_tracing_event ... ok
[INFO] [stdout] test audit::tests::record_event_scanner_transition_writes_db_row ... ok
[INFO] [stdout] test db::tests::compute_live_stats_cross_connection_visibility ... ok
[INFO] [stdout] test db::tests::compute_live_stats_counts_entries ... ok
[INFO] [stdout] test db::tests::database_open_fails_on_invalid_path ... ok
[INFO] [stdout] test db::tests::compute_live_stats_deduplicates_overlapping_paths ... ok
[INFO] [stdout] test db::tests::database_creates_indexes ... ok
[INFO] [stdout] test db::tests::compute_live_stats_prefers_active_rows_over_ignored_overlap_rows ... ok
[INFO] [stdout] test db::tests::database_creates_file_and_schema ... ok
[INFO] [stdout] test db::tests::database_enables_foreign_keys ... ok
[INFO] [stdout] test db::tests::database_enables_wal_mode ... ok
[INFO] [stdout] test db::tests::database_initializes_stats_singleton ... ok
[INFO] [stdout] test db::tests::database_open_rejects_future_schema_version ... ok
[INFO] [stdout] test db::tests::database_schema_is_idempotent ... ok
[INFO] [stdout] test db::tests::defer_entry_fails_on_nonexistent ... ok
[INFO] [stdout] test db::tests::defer_entry_sets_status_and_timestamp ... ok
[INFO] [stdout] test db::tests::database_sets_schema_user_version ... ok
[INFO] [stdout] test db::tests::database_open_upgrades_legacy_unversioned_schema ... ok
[INFO] [stdout] test db::tests::delete_root_fails_on_nonexistent ... ok
[INFO] [stdout] test db::tests::delete_root_cascades_to_entries ... ok
[INFO] [stdout] test db::tests::delete_root_removes_root ... ok
[INFO] [stdout] test db::tests::entries_rejects_invalid_status ... ok
[INFO] [stdout] test db::tests::get_entry_by_path_returns_none_when_not_found ... ok
[INFO] [stdout] test db::tests::foreign_key_constraint_prevents_orphan_entries ... ok
[INFO] [stdout] test db::tests::get_root_by_path_returns_none_when_not_found ... ok
[INFO] [stdout] test db::tests::enforce_ignored_directory_inheritance_ignores_descendants ... ok
[INFO] [stdout] test db::tests::get_stats_returns_defaults ... ok
[INFO] [stdout] test db::tests::insert_root_is_idempotent ... ok
[INFO] [stdout] test db::tests::insert_root_creates_new ... ok
[INFO] [stdout] test db::tests::list_entries_by_parent_excludes_removed ... ok
[INFO] [stdout] test db::tests::list_entries_by_parent_returns_children ... ok
[INFO] [stdout] test db::tests::list_entries_by_root_excludes_removed ... ok
[INFO] [stdout] test db::tests::list_entries_by_parent_is_root_scoped_for_overlapping_paths ... ok
[INFO] [stdout] test db::tests::list_entries_by_root_and_status_filters_correctly ... ok
[INFO] [stdout] test db::tests::list_entries_by_root_returns_all_descendants ... ok
[INFO] [stdout] test db::tests::list_roots_returns_all_ordered_by_path ... ok
[INFO] [stdout] test db::tests::list_entries_filters_by_status ... ok
[INFO] [stdout] test db::tests::update_entry_status_rejects_invalid_status ... ok
[INFO] [stdout] test db::tests::stats_enforces_singleton_constraint ... ok
[INFO] [stdout] test db::tests::update_entry_status_fails_on_nonexistent ... ok
[INFO] [stdout] test db::tests::update_entries_by_path_prefix_updates_all_matching ... ok
[INFO] [stdout] test db::tests::update_root_last_scanned_works ... ok
[INFO] [stdout] test db::tests::update_entry_status_works ... ok
[INFO] [stdout] test db::tests::upsert_entry_allows_same_path_in_multiple_roots ... ok
[INFO] [stdout] test removal::tests::check_removability_fails_for_nonexistent_path ... ok
[INFO] [stdout] test removal::tests::check_removability_succeeds_for_existing_directory ... ok
[INFO] [stdout] test removal::tests::check_removability_succeeds_for_existing_file ... ok
[INFO] [stdout] test db::tests::upsert_entry_creates_new_directory ... ok
[INFO] [stdout] test db::tests::upsert_entry_creates_new_file ... ok
[INFO] [stdout] test db::tests::upsert_entry_fails_with_invalid_root_id ... ok
[INFO] [stdout] test db::tests::upsert_entry_no_return_writes_entry ... ok
[INFO] [stdout] test db::tests::upsert_entry_updates_existing ... ok
[INFO] [stdout] test removal::tests::dry_run_approved_ignores_non_approved_entries ... ok
[INFO] [stdout] test removal::tests::dry_run_approved_all_entries_exist ... ok
[INFO] [stdout] test removal::tests::dry_run_approved_mixed_existing_and_nonexistent ... ok
[INFO] [stdout] test removal::tests::dry_run_approved_with_no_approved_entries ... ok
[INFO] [stdout] test removal::tests::remove_approved_handles_nonexistent_path ... ok
[INFO] [stdout] test scanner::tests::calculate_expiration_handles_custom_expiration_period ... ok
[INFO] [stdout] test scanner::tests::calculate_expiration_returns_negative_for_expired_files ... ok
[INFO] [stdout] test scanner::tests::calculate_expiration_returns_positive_for_recent_files ... ok
[INFO] [stdout] test scanner::tests::calculate_expiration_returns_zero_on_expiration_day ... ok
[INFO] [stdout] test removal::tests::remove_approved_handles_mixed_success_and_failure ... FAILED
[INFO] [stdout] test removal::tests::remove_approved_handles_permission_denied ... FAILED
[INFO] [stdout] test removal::tests::remove_approved_processes_approved_entries ... ok
[INFO] [stdout] test removal::tests::remove_approved_records_audit_entries_with_entry_id ... ok
[INFO] [stdout] test removal::tests::remove_approved_returns_empty_summary_when_no_approved ... ok
[INFO] [stdout] test scanner::tests::cleanup_missing_entries_marks_nonexistent_paths_as_removed ... ok
[INFO] [stdout] test scanner::tests::cleanup_missing_entries_keeps_undiscovered_paths_if_they_still_exist ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_creates_file_entries ... ok
[INFO] [stdout] test scanner::tests::expiration_uses_effective_timestamp ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_creates_root_and_entries ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_handles_multiple_paths ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_persists_empty_subdirectories ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_new_files_in_ignored_directory_stay_ignored ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_marks_removed_overlap_entries_per_root ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_ignored_inheritance_stays_root_local_for_overlap ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_preserves_overlapping_entries_for_both_roots ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_records_audit_entry ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_sets_recursive_directory_sizes ... ok
[INFO] [stdout] test scanner::tests::scanner_aggregates_by_directory ... ok
[INFO] [stdout] test scanner::tests::scanner_correctly_identifies_oldest_mtime ... ok
[INFO] [stdout] test scanner::tests::scanner_fails_on_file_path ... ok
[INFO] [stdout] test scanner::tests::scanner_fails_on_nonexistent_path ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_updates_global_stats_with_deduped_overlap_totals ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_updates_stats_table ... ok
[INFO] [stdout] test scanner::tests::scanner_handles_empty_directory ... ok
[INFO] [stdout] test scanner::tests::scanner_finds_all_files ... ok
[INFO] [stdout] test scanner::tests::scanner_includes_hidden_files ... ok
[INFO] [stdout] test scanner::tests::scanner_includes_empty_directories ... ok
[INFO] [stdout] test scanner::tests::scan_and_persist_upserts_existing_entries ... ok
[INFO] [stdout] test scanner::tests::scanner_skips_broken_symlinks_gracefully ... ok
[INFO] [stdout] test scanner::tests::scanner_resolves_symlinks ... ok
[INFO] [stdout] test scanner::tests::scanner_tracks_oldest_mtime ... ok
[INFO] [stdout] test scanner::tests::scan_sets_tracked_since_on_first_insert ... ok
[INFO] [stdout] test scanner::tests::stats_update_calculates_files_pending_approval ... ok
[INFO] [stdout] test scanner::tests::stats_update_calculates_files_overdue ... ok
[INFO] [stdout] test scanner::tests::stats_update_calculates_files_within_warning ... ok
[INFO] [stdout] test scanner::tests::stats_update_excludes_ignored_from_overdue_count ... ok
[INFO] [stdout] test scanner::tests::stats_update_custom_expiration_warning_periods ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_does_not_reset_active_deferral ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_does_not_transition_non_expired ... ok
[INFO] [stdout] test scanner::tests::stats_update_handles_entries_without_mtime ... ok
[INFO] [stdout] test scanner::tests::stats_update_sets_last_scan_completed_timestamp ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_handles_deferred_with_null_deferred_until ... ok
[INFO] [stdout] test scanner::tests::stats_update_handles_mixed_scenarios ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_handles_empty_database ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_handles_entry_without_mtime ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_handles_multiple_entries ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_ignores_directories ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_ignores_ignored_status ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_ignores_pending_approved_removed_blocked ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_moves_expired_tracked_to_approved_with_auto_remove ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_resets_expired_deferral ... ok
[INFO] [stdout] test scanner::tests::transition_expired_paths_moves_expired_tracked_to_pending ... ok
[INFO] [stdout] test db::tests::upsert_entry_preserves_tracked_since ... ok
[INFO] [stdout] test db::tests::upsert_entry_revives_removed_path_as_tracked ... ok
[INFO] [stdout] test scanner::tests::scan_preserves_tracked_since_on_update ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- config::tests::local_config_unreadable_file_returns_error stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'config::tests::local_config_unreadable_file_returns_error' (76) panicked at src/config/mod.rs:949:9:
[INFO] [stdout] should fail on unreadable file
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x61d71be2683a - std[e28293b1aa0f68bd]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x61d71be2683a - std[e28293b1aa0f68bd]::backtrace_rs::backtrace::trace_unsynchronized::<std[e28293b1aa0f68bd]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x61d71be2683a - std[e28293b1aa0f68bd]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x61d71be2683a - <<std[e28293b1aa0f68bd]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[c1f1a4ba060b9bfa]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x61d71be3e09a - <core[c1f1a4ba060b9bfa]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x61d71be3e09a - core[c1f1a4ba060b9bfa]::fmt::write
[INFO] [stdout]    6:     0x61d71be2b6c2 - std[e28293b1aa0f68bd]::io::default_write_fmt::<alloc[fdfd2bd8633a6659]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x61d71be2b6c2 - <alloc[fdfd2bd8633a6659]::vec::Vec<u8> as std[e28293b1aa0f68bd]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x61d71be014af - <std[e28293b1aa0f68bd]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x61d71be014af - std[e28293b1aa0f68bd]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x61d71be1c4c9 - std[e28293b1aa0f68bd]::panicking::default_hook
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x61d71ba22a9c - <alloc[fdfd2bd8633a6659]::boxed::Box<dyn for<'a, 'b> core[c1f1a4ba060b9bfa]::ops::function::Fn<(&'a std[e28293b1aa0f68bd]::panic::PanicHookInfo<'b>,), Output = ()> + core[c1f1a4ba060b9bfa]::marker::Sync + core[c1f1a4ba060b9bfa]::marker::Send> as core[c1f1a4ba060b9bfa]::ops::function::Fn<(&std[e28293b1aa0f68bd]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x61d71ba22a9c - test[273d7611820c9051]::test_main_with_exit_callback::<test[273d7611820c9051]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x61d71be1c742 - <alloc[fdfd2bd8633a6659]::boxed::Box<dyn for<'a, 'b> core[c1f1a4ba060b9bfa]::ops::function::Fn<(&'a std[e28293b1aa0f68bd]::panic::PanicHookInfo<'b>,), Output = ()> + core[c1f1a4ba060b9bfa]::marker::Sync + core[c1f1a4ba060b9bfa]::marker::Send> as core[c1f1a4ba060b9bfa]::ops::function::Fn<(&std[e28293b1aa0f68bd]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x61d71be1c742 - std[e28293b1aa0f68bd]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x61d71be0159a - std[e28293b1aa0f68bd]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:691:13
[INFO] [stdout]   16:     0x61d71bdf8a89 - std[e28293b1aa0f68bd]::sys::backtrace::__rust_end_short_backtrace::<std[e28293b1aa0f68bd]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x61d71be0264d - __rustc[b7974e8690430dd9]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x61d71be3ea2c - core[c1f1a4ba060b9bfa]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x61d71b8129a5 - stagecrew::config::tests::local_config_unreadable_file_returns_error::h77fd00a38eba8888
[INFO] [stdout]                                at /opt/rustwide/workdir/src/config/mod.rs:949:9
[INFO] [stdout]   20:     0x61d71b812a07 - stagecrew::config::tests::local_config_unreadable_file_returns_error::{{closure}}::h0112d7c4497b953a
[INFO] [stdout]                                at /opt/rustwide/workdir/src/config/mod.rs:934:52
[INFO] [stdout]   21:     0x61d71b7777d6 - core::ops::function::FnOnce::call_once::ha28f4d91de0cb4da
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   22:     0x61d71ba16b7b - <fn() -> core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String> as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x61d71ba16b7b - test[273d7611820c9051]::__rust_begin_short_backtrace::<core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>, fn() -> core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:663:18
[INFO] [stdout]   24:     0x61d71ba2356b - test[273d7611820c9051]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:686:74
[INFO] [stdout]   25:     0x61d71ba2356b - <core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<test[273d7611820c9051]::run_test_in_process::{closure#0}> as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   26:     0x61d71ba2356b - std[e28293b1aa0f68bd]::panicking::catch_unwind::do_call::<core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<test[273d7611820c9051]::run_test_in_process::{closure#0}>, core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:581:40
[INFO] [stdout]   27:     0x61d71ba2356b - std[e28293b1aa0f68bd]::panicking::catch_unwind::<core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>, core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<test[273d7611820c9051]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:544:19
[INFO] [stdout]   28:     0x61d71ba2356b - std[e28293b1aa0f68bd]::panic::catch_unwind::<core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<test[273d7611820c9051]::run_test_in_process::{closure#0}>, core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panic.rs:359:14
[INFO] [stdout]   29:     0x61d71ba2356b - test[273d7611820c9051]::run_test_in_process
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:686:27
[INFO] [stdout]   30:     0x61d71ba2356b - test[273d7611820c9051]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:607:43
[INFO] [stdout]   31:     0x61d71ba1ec84 - test[273d7611820c9051]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:637:41
[INFO] [stdout]   32:     0x61d71ba1ec84 - std[e28293b1aa0f68bd]::sys::backtrace::__rust_begin_short_backtrace::<test[273d7611820c9051]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   33:     0x61d71ba26172 - std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked::<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   34:     0x61d71ba26172 - <core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   35:     0x61d71ba26172 - std[e28293b1aa0f68bd]::panicking::catch_unwind::do_call::<core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:581:40
[INFO] [stdout]   36:     0x61d71ba26172 - std[e28293b1aa0f68bd]::panicking::catch_unwind::<(), core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:544:19
[INFO] [stdout]   37:     0x61d71ba26172 - std[e28293b1aa0f68bd]::panic::catch_unwind::<core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panic.rs:359:14
[INFO] [stdout]   38:     0x61d71ba26172 - std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked::<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   39:     0x61d71ba26172 - <std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1} as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   40:     0x61d71be2583f - <alloc[fdfd2bd8633a6659]::boxed::Box<dyn core[c1f1a4ba060b9bfa]::ops::function::FnOnce<(), Output = ()> + core[c1f1a4ba060b9bfa]::marker::Send> as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   41:     0x61d71be2583f - <std[e28293b1aa0f68bd]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   42:     0x7ac9bcb55aa4 - <unknown>
[INFO] [stdout]   43:     0x7ac9bcbe2a64 - clone
[INFO] [stdout]   44:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- removal::tests::remove_approved_handles_mixed_success_and_failure stdout ----
[INFO] [stdout] 2026-04-27T02:08:04.574342Z  INFO stagecrew::db: Migrating entries table to root-scoped uniqueness
[INFO] [stdout] 2026-04-27T02:08:04.578759Z  INFO stagecrew::db: entries table migration complete
[INFO] [stdout] 2026-04-27T02:08:04.591597Z DEBUG stagecrew::removal: Processing approved entry for removal path="/tmp/stagecrew-removal-files-GwgsVe/normal" is_dir=true
[INFO] [stdout] 2026-04-27T02:08:04.591773Z  INFO stagecrew::removal: Permanently deleted path="/tmp/stagecrew-removal-files-GwgsVe/normal"
[INFO] [stdout] 2026-04-27T02:08:04.593759Z  INFO stagecrew::removal: Entry removed successfully path="/tmp/stagecrew-removal-files-GwgsVe/normal" bytes=28
[INFO] [stdout] 2026-04-27T02:08:04.595434Z  INFO stagecrew::audit: audit_event audit_action="remove" audit_user="unknown" audit_actor_source="daemon" audit_target_path="/tmp/stagecrew-removal-files-GwgsVe/normal" audit_entry_id=1 audit_root_id=1 audit_status_before="approved" audit_status_after="removed" audit_outcome="removed" audit_details="Permanently deleted 28 bytes"
[INFO] [stdout] 2026-04-27T02:08:04.595466Z DEBUG stagecrew::removal: Processing approved entry for removal path="/tmp/stagecrew-removal-files-GwgsVe/protected" is_dir=true
[INFO] [stdout] 2026-04-27T02:08:04.595779Z  INFO stagecrew::removal: Permanently deleted path="/tmp/stagecrew-removal-files-GwgsVe/protected"
[INFO] [stdout] 2026-04-27T02:08:04.597942Z  INFO stagecrew::removal: Entry removed successfully path="/tmp/stagecrew-removal-files-GwgsVe/protected" bytes=28
[INFO] [stdout] 2026-04-27T02:08:04.600335Z  INFO stagecrew::audit: audit_event audit_action="remove" audit_user="unknown" audit_actor_source="daemon" audit_target_path="/tmp/stagecrew-removal-files-GwgsVe/protected" audit_entry_id=2 audit_root_id=1 audit_status_before="approved" audit_status_after="removed" audit_outcome="removed" audit_details="Permanently deleted 28 bytes"
[INFO] [stdout] 
[INFO] [stdout] thread 'removal::tests::remove_approved_handles_mixed_success_and_failure' (133) panicked at src/removal/mod.rs:664:9:
[INFO] [stdout] assertion `left == right` failed: Expected 1 entry removed
[INFO] [stdout]   left: 2
[INFO] [stdout]  right: 1
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x61d71be2683a - std[e28293b1aa0f68bd]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x61d71be2683a - std[e28293b1aa0f68bd]::backtrace_rs::backtrace::trace_unsynchronized::<std[e28293b1aa0f68bd]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x61d71be2683a - std[e28293b1aa0f68bd]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x61d71be2683a - <<std[e28293b1aa0f68bd]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[c1f1a4ba060b9bfa]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x61d71be3e09a - <core[c1f1a4ba060b9bfa]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x61d71be3e09a - core[c1f1a4ba060b9bfa]::fmt::write
[INFO] [stdout]    6:     0x61d71be2b6c2 - std[e28293b1aa0f68bd]::io::default_write_fmt::<alloc[fdfd2bd8633a6659]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x61d71be2b6c2 - <alloc[fdfd2bd8633a6659]::vec::Vec<u8> as std[e28293b1aa0f68bd]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x61d71be014af - <std[e28293b1aa0f68bd]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x61d71be014af - std[e28293b1aa0f68bd]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x61d71be1c4c9 - std[e28293b1aa0f68bd]::panicking::default_hook
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x61d71ba22a9c - <alloc[fdfd2bd8633a6659]::boxed::Box<dyn for<'a, 'b> core[c1f1a4ba060b9bfa]::ops::function::Fn<(&'a std[e28293b1aa0f68bd]::panic::PanicHookInfo<'b>,), Output = ()> + core[c1f1a4ba060b9bfa]::marker::Sync + core[c1f1a4ba060b9bfa]::marker::Send> as core[c1f1a4ba060b9bfa]::ops::function::Fn<(&std[e28293b1aa0f68bd]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x61d71ba22a9c - test[273d7611820c9051]::test_main_with_exit_callback::<test[273d7611820c9051]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x61d71be1c742 - <alloc[fdfd2bd8633a6659]::boxed::Box<dyn for<'a, 'b> core[c1f1a4ba060b9bfa]::ops::function::Fn<(&'a std[e28293b1aa0f68bd]::panic::PanicHookInfo<'b>,), Output = ()> + core[c1f1a4ba060b9bfa]::marker::Sync + core[c1f1a4ba060b9bfa]::marker::Send> as core[c1f1a4ba060b9bfa]::ops::function::Fn<(&std[e28293b1aa0f68bd]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x61d71be1c742 - std[e28293b1aa0f68bd]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x61d71be01568 - std[e28293b1aa0f68bd]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x61d71bdf8a89 - std[e28293b1aa0f68bd]::sys::backtrace::__rust_end_short_backtrace::<std[e28293b1aa0f68bd]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x61d71be0264d - __rustc[b7974e8690430dd9]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x61d71be3ea2c - core[c1f1a4ba060b9bfa]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x61d71be3e913 - core[c1f1a4ba060b9bfa]::panicking::assert_failed_inner
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/panicking.rs:434:23
[INFO] [stdout]   20:     0x61d71be3926d - core[c1f1a4ba060b9bfa]::panicking::assert_failed::<usize, usize>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/panicking.rs:394:5
[INFO] [stdout]   21:     0x61d71b72b851 - stagecrew::removal::tests::remove_approved_handles_mixed_success_and_failure::h4e8d3b8baa7741c2
[INFO] [stdout]                                at /opt/rustwide/workdir/src/removal/mod.rs:664:9
[INFO] [stdout]   22:     0x61d71b72be37 - stagecrew::removal::tests::remove_approved_handles_mixed_success_and_failure::{{closure}}::h79a4522a30df23ab
[INFO] [stdout]                                at /opt/rustwide/workdir/src/removal/mod.rs:611:59
[INFO] [stdout]   23:     0x61d71b778d06 - core::ops::function::FnOnce::call_once::hf904dcbba2cdd8fb
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x61d71ba16b7b - <fn() -> core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String> as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x61d71ba16b7b - test[273d7611820c9051]::__rust_begin_short_backtrace::<core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>, fn() -> core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:663:18
[INFO] [stdout]   26:     0x61d71ba2356b - test[273d7611820c9051]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:686:74
[INFO] [stdout]   27:     0x61d71ba2356b - <core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<test[273d7611820c9051]::run_test_in_process::{closure#0}> as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   28:     0x61d71ba2356b - std[e28293b1aa0f68bd]::panicking::catch_unwind::do_call::<core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<test[273d7611820c9051]::run_test_in_process::{closure#0}>, core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x61d71ba2356b - std[e28293b1aa0f68bd]::panicking::catch_unwind::<core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>, core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<test[273d7611820c9051]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x61d71ba2356b - std[e28293b1aa0f68bd]::panic::catch_unwind::<core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<test[273d7611820c9051]::run_test_in_process::{closure#0}>, core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x61d71ba2356b - test[273d7611820c9051]::run_test_in_process
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:686:27
[INFO] [stdout]   32:     0x61d71ba2356b - test[273d7611820c9051]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:607:43
[INFO] [stdout]   33:     0x61d71ba1ec84 - test[273d7611820c9051]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:637:41
[INFO] [stdout]   34:     0x61d71ba1ec84 - std[e28293b1aa0f68bd]::sys::backtrace::__rust_begin_short_backtrace::<test[273d7611820c9051]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x61d71ba26172 - std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked::<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   36:     0x61d71ba26172 - <core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   37:     0x61d71ba26172 - std[e28293b1aa0f68bd]::panicking::catch_unwind::do_call::<core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x61d71ba26172 - std[e28293b1aa0f68bd]::panicking::catch_unwind::<(), core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x61d71ba26172 - std[e28293b1aa0f68bd]::panic::catch_unwind::<core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x61d71ba26172 - std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked::<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   41:     0x61d71ba26172 - <std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1} as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x61d71be2583f - <alloc[fdfd2bd8633a6659]::boxed::Box<dyn core[c1f1a4ba060b9bfa]::ops::function::FnOnce<(), Output = ()> + core[c1f1a4ba060b9bfa]::marker::Send> as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   43:     0x61d71be2583f - <std[e28293b1aa0f68bd]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   44:     0x7ac9bcb55aa4 - <unknown>
[INFO] [stdout]   45:     0x7ac9bcbe2a64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- removal::tests::remove_approved_handles_permission_denied stdout ----
[INFO] [stdout] 2026-04-27T02:08:04.588263Z  INFO stagecrew::db: Migrating entries table to root-scoped uniqueness
[INFO] [stdout] 2026-04-27T02:08:04.594677Z  INFO stagecrew::db: entries table migration complete
[INFO] [stdout] 2026-04-27T02:08:04.604865Z DEBUG stagecrew::removal: Processing approved entry for removal path="/tmp/stagecrew-removal-files-1dZ4Fe/protected" is_dir=true
[INFO] [stdout] 2026-04-27T02:08:04.605037Z  INFO stagecrew::removal: Permanently deleted path="/tmp/stagecrew-removal-files-1dZ4Fe/protected"
[INFO] [stdout] 2026-04-27T02:08:04.607026Z  INFO stagecrew::removal: Entry removed successfully path="/tmp/stagecrew-removal-files-1dZ4Fe/protected" bytes=28
[INFO] [stdout] 2026-04-27T02:08:04.608837Z  INFO stagecrew::audit: audit_event audit_action="remove" audit_user="unknown" audit_actor_source="daemon" audit_target_path="/tmp/stagecrew-removal-files-1dZ4Fe/protected" audit_entry_id=1 audit_root_id=1 audit_status_before="approved" audit_status_after="removed" audit_outcome="removed" audit_details="Permanently deleted 28 bytes"
[INFO] [stdout] 
[INFO] [stdout] thread 'removal::tests::remove_approved_handles_permission_denied' (135) panicked at src/removal/mod.rs:523:9:
[INFO] [stdout] assertion `left == right` failed: Expected no entries removed
[INFO] [stdout]   left: 1
[INFO] [stdout]  right: 0
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x61d71be2683a - std[e28293b1aa0f68bd]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x61d71be2683a - std[e28293b1aa0f68bd]::backtrace_rs::backtrace::trace_unsynchronized::<std[e28293b1aa0f68bd]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x61d71be2683a - std[e28293b1aa0f68bd]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x61d71be2683a - <<std[e28293b1aa0f68bd]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[c1f1a4ba060b9bfa]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x61d71be3e09a - <core[c1f1a4ba060b9bfa]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x61d71be3e09a - core[c1f1a4ba060b9bfa]::fmt::write
[INFO] [stdout]    6:     0x61d71be2b6c2 - std[e28293b1aa0f68bd]::io::default_write_fmt::<alloc[fdfd2bd8633a6659]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/io/mod.rs:639:11
[INFO] [stdout]    7:     0x61d71be2b6c2 - <alloc[fdfd2bd8633a6659]::vec::Vec<u8> as std[e28293b1aa0f68bd]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/io/mod.rs:1994:13
[INFO] [stdout]    8:     0x61d71be014af - <std[e28293b1aa0f68bd]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x61d71be014af - std[e28293b1aa0f68bd]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x61d71be1c4c9 - std[e28293b1aa0f68bd]::panicking::default_hook
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x61d71ba22a9c - <alloc[fdfd2bd8633a6659]::boxed::Box<dyn for<'a, 'b> core[c1f1a4ba060b9bfa]::ops::function::Fn<(&'a std[e28293b1aa0f68bd]::panic::PanicHookInfo<'b>,), Output = ()> + core[c1f1a4ba060b9bfa]::marker::Sync + core[c1f1a4ba060b9bfa]::marker::Send> as core[c1f1a4ba060b9bfa]::ops::function::Fn<(&std[e28293b1aa0f68bd]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   12:     0x61d71ba22a9c - test[273d7611820c9051]::test_main_with_exit_callback::<test[273d7611820c9051]::test_main::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:145:21
[INFO] [stdout]   13:     0x61d71be1c742 - <alloc[fdfd2bd8633a6659]::boxed::Box<dyn for<'a, 'b> core[c1f1a4ba060b9bfa]::ops::function::Fn<(&'a std[e28293b1aa0f68bd]::panic::PanicHookInfo<'b>,), Output = ()> + core[c1f1a4ba060b9bfa]::marker::Sync + core[c1f1a4ba060b9bfa]::marker::Send> as core[c1f1a4ba060b9bfa]::ops::function::Fn<(&std[e28293b1aa0f68bd]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/alloc/src/boxed.rs:2254:9
[INFO] [stdout]   14:     0x61d71be1c742 - std[e28293b1aa0f68bd]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x61d71be01568 - std[e28293b1aa0f68bd]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x61d71bdf8a89 - std[e28293b1aa0f68bd]::sys::backtrace::__rust_end_short_backtrace::<std[e28293b1aa0f68bd]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x61d71be0264d - __rustc[b7974e8690430dd9]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x61d71be3ea2c - core[c1f1a4ba060b9bfa]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x61d71be3e913 - core[c1f1a4ba060b9bfa]::panicking::assert_failed_inner
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/panicking.rs:434:23
[INFO] [stdout]   20:     0x61d71be3926d - core[c1f1a4ba060b9bfa]::panicking::assert_failed::<usize, usize>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/panicking.rs:394:5
[INFO] [stdout]   21:     0x61d71b728532 - stagecrew::removal::tests::remove_approved_handles_permission_denied::hd8fd5d68b0b633b6
[INFO] [stdout]                                at /opt/rustwide/workdir/src/removal/mod.rs:523:9
[INFO] [stdout]   22:     0x61d71b728c87 - stagecrew::removal::tests::remove_approved_handles_permission_denied::{{closure}}::hbd91cf30f7b9de5d
[INFO] [stdout]                                at /opt/rustwide/workdir/src/removal/mod.rs:483:51
[INFO] [stdout]   23:     0x61d71b776b16 - core::ops::function::FnOnce::call_once::h689225b2f42beb70
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x61d71ba16b7b - <fn() -> core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String> as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x61d71ba16b7b - test[273d7611820c9051]::__rust_begin_short_backtrace::<core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>, fn() -> core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:663:18
[INFO] [stdout]   26:     0x61d71ba2356b - test[273d7611820c9051]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:686:74
[INFO] [stdout]   27:     0x61d71ba2356b - <core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<test[273d7611820c9051]::run_test_in_process::{closure#0}> as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   28:     0x61d71ba2356b - std[e28293b1aa0f68bd]::panicking::catch_unwind::do_call::<core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<test[273d7611820c9051]::run_test_in_process::{closure#0}>, core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x61d71ba2356b - std[e28293b1aa0f68bd]::panicking::catch_unwind::<core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>, core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<test[273d7611820c9051]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x61d71ba2356b - std[e28293b1aa0f68bd]::panic::catch_unwind::<core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<test[273d7611820c9051]::run_test_in_process::{closure#0}>, core[c1f1a4ba060b9bfa]::result::Result<(), alloc[fdfd2bd8633a6659]::string::String>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x61d71ba2356b - test[273d7611820c9051]::run_test_in_process
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:686:27
[INFO] [stdout]   32:     0x61d71ba2356b - test[273d7611820c9051]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:607:43
[INFO] [stdout]   33:     0x61d71ba1ec84 - test[273d7611820c9051]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/test/src/lib.rs:637:41
[INFO] [stdout]   34:     0x61d71ba1ec84 - std[e28293b1aa0f68bd]::sys::backtrace::__rust_begin_short_backtrace::<test[273d7611820c9051]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x61d71ba26172 - std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked::<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/thread/lifecycle.rs:91:13
[INFO] [stdout]   36:     0x61d71ba26172 - <core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/panic/unwind_safe.rs:274:9
[INFO] [stdout]   37:     0x61d71ba26172 - std[e28293b1aa0f68bd]::panicking::catch_unwind::do_call::<core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x61d71ba26172 - std[e28293b1aa0f68bd]::panicking::catch_unwind::<(), core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x61d71ba26172 - std[e28293b1aa0f68bd]::panic::catch_unwind::<core[c1f1a4ba060b9bfa]::panic::unwind_safe::AssertUnwindSafe<std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x61d71ba26172 - std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked::<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/thread/lifecycle.rs:89:26
[INFO] [stdout]   41:     0x61d71ba26172 - <std[e28293b1aa0f68bd]::thread::lifecycle::spawn_unchecked<test[273d7611820c9051]::run_test::{closure#1}, ()>::{closure#1} as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x61d71be2583f - <alloc[fdfd2bd8633a6659]::boxed::Box<dyn core[c1f1a4ba060b9bfa]::ops::function::FnOnce<(), Output = ()> + core[c1f1a4ba060b9bfa]::marker::Send> as core[c1f1a4ba060b9bfa]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/alloc/src/boxed.rs:2240:9
[INFO] [stdout]   43:     0x61d71be2583f - <std[e28293b1aa0f68bd]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/59807616e1fa2540724bfbac14d7976d7e4a3860/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   44:     0x7ac9bcb55aa4 - <unknown>
[INFO] [stdout]   45:     0x7ac9bcbe2a64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     config::tests::local_config_unreadable_file_returns_error
[INFO] [stdout]     removal::tests::remove_approved_handles_mixed_success_and_failure
[INFO] [stdout]     removal::tests::remove_approved_handles_permission_denied
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 172 passed; 3 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.10s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "66162ad1e3df171edfe62eb73ed3aa4994fd854d30059a3ba95749061d9c2805", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "66162ad1e3df171edfe62eb73ed3aa4994fd854d30059a3ba95749061d9c2805", kill_on_drop: false }`
[INFO] [stdout] 66162ad1e3df171edfe62eb73ed3aa4994fd854d30059a3ba95749061d9c2805
