[INFO] cloning repository https://github.com/flying7eleven/scribe [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/flying7eleven/scribe" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fflying7eleven%2Fscribe", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fflying7eleven%2Fscribe'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 18627a235ff043862356307e3c74a5f93d21049c [INFO] testing flying7eleven/scribe against 1.100.0-beta.1 for beta-1.100-2 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fflying7eleven%2Fscribe" "/workspace/builds/worker-6-tc2/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-6-tc2/source'... [INFO] [stderr] done. [INFO] started tweaking git repo https://github.com/flying7eleven/scribe [INFO] finished tweaking git repo https://github.com/flying7eleven/scribe [INFO] tweaked toml for git repo https://github.com/flying7eleven/scribe written to /workspace/builds/worker-6-tc2/source/Cargo.toml [INFO] validating manifest of git repo https://github.com/flying7eleven/scribe 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 git repo https://github.com/flying7eleven/scribe 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] ec164493d80f5a176bc0d88daf2e384d87b34fc34bb919017da8db80c2316010 [INFO] running `Command { std: "docker" "start" "ec164493d80f5a176bc0d88daf2e384d87b34fc34bb919017da8db80c2316010", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "ec164493d80f5a176bc0d88daf2e384d87b34fc34bb919017da8db80c2316010", 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" "ec164493d80f5a176bc0d88daf2e384d87b34fc34bb919017da8db80c2316010" "/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" "ec164493d80f5a176bc0d88daf2e384d87b34fc34bb919017da8db80c2316010", 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" "ec164493d80f5a176bc0d88daf2e384d87b34fc34bb919017da8db80c2316010" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stderr] Compiling quote v1.0.45 [INFO] [stderr] Compiling libc v0.2.183 [INFO] [stderr] Compiling serde_core v1.0.228 [INFO] [stderr] Compiling futures-io v0.3.32 [INFO] [stderr] Compiling futures-sink v0.3.32 [INFO] [stderr] Compiling cc v1.2.57 [INFO] [stderr] Compiling num-traits v0.2.19 [INFO] [stderr] Compiling event-listener v5.4.1 [INFO] [stderr] Compiling hashlink v0.10.0 [INFO] [stderr] Compiling crypto-common v0.1.7 [INFO] [stderr] Compiling spin v0.9.8 [INFO] [stderr] Compiling base64 v0.22.1 [INFO] [stderr] Compiling serde_json v1.0.149 [INFO] [stderr] Compiling bitflags v2.11.0 [INFO] [stderr] Compiling futures-util v0.3.32 [INFO] [stderr] Compiling digest v0.10.7 [INFO] [stderr] Compiling futures-channel v0.3.32 [INFO] [stderr] Compiling anstyle-parse v1.0.0 [INFO] [stderr] Compiling flume v0.11.1 [INFO] [stderr] Compiling colorchoice v1.0.5 [INFO] [stderr] Compiling rustix v1.1.4 [INFO] [stderr] Compiling anstyle v1.0.14 [INFO] [stderr] Compiling sha2 v0.10.9 [INFO] [stderr] Compiling dotenvy v0.15.7 [INFO] [stderr] Compiling syn v2.0.117 [INFO] [stderr] Compiling anstream v1.0.0 [INFO] [stderr] Compiling instability v0.3.12 [INFO] [stderr] Compiling litrs v1.0.0 [INFO] [stderr] Compiling clap_lex v1.1.0 [INFO] [stderr] Compiling hex v0.4.3 [INFO] [stderr] Compiling rustix v0.38.44 [INFO] [stderr] Compiling clap_builder v4.6.0 [INFO] [stderr] Compiling parking_lot_core v0.9.12 [INFO] [stderr] Compiling socket2 v0.6.3 [INFO] [stderr] Compiling mio v1.1.1 [INFO] [stderr] Compiling errno v0.3.14 [INFO] [stderr] Compiling signal-hook-registry v1.4.8 [INFO] [stderr] Compiling document-features v0.2.12 [INFO] [stderr] Compiling toml_write v0.1.2 [INFO] [stderr] Compiling parking_lot v0.12.5 [INFO] [stderr] Compiling signal-hook v0.3.18 [INFO] [stderr] Compiling winnow v0.7.15 [INFO] [stderr] Compiling futures-intrusive v0.5.0 [INFO] [stderr] Compiling tokio v1.50.0 [INFO] [stderr] Compiling atoi v2.0.0 [INFO] [stderr] Compiling dirs-sys v0.5.0 [INFO] [stderr] Compiling signal-hook-mio v0.2.5 [INFO] [stderr] Compiling crossterm v0.29.0 [INFO] [stderr] Compiling compact_str v0.8.1 [INFO] [stderr] Compiling csv-core v0.1.13 [INFO] [stderr] Compiling scribe v1.0.0-beta4 (/opt/rustwide/workdir) [INFO] [stderr] Compiling libsqlite3-sys v0.30.1 [INFO] [stderr] Compiling dirs v6.0.0 [INFO] [stderr] Compiling crossterm v0.28.1 [INFO] [stderr] Compiling humantime v2.3.0 [INFO] [stderr] Compiling comfy-table v7.2.2 [INFO] [stderr] Compiling csv v1.4.0 [INFO] [stderr] Compiling futures-executor v0.3.32 [INFO] [stderr] Compiling synstructure v0.13.2 [INFO] [stderr] Compiling darling_core v0.23.0 [INFO] [stderr] Compiling serde_derive v1.0.228 [INFO] [stderr] Compiling zerovec-derive v0.11.2 [INFO] [stderr] Compiling displaydoc v0.2.5 [INFO] [stderr] Compiling tracing-attributes v0.1.31 [INFO] [stderr] Compiling thiserror-impl v2.0.18 [INFO] [stderr] Compiling futures-macro v0.3.32 [INFO] [stderr] Compiling tokio-macros v2.6.1 [INFO] [stderr] Compiling clap_derive v4.6.0 [INFO] [stderr] Compiling strum_macros v0.26.4 [INFO] [stderr] Compiling zerofrom-derive v0.1.6 [INFO] [stderr] Compiling yoke-derive v0.8.1 [INFO] [stderr] Compiling tokio-stream v0.1.18 [INFO] [stderr] Compiling zerofrom v0.1.6 [INFO] [stderr] Compiling yoke v0.8.1 [INFO] [stderr] Compiling zerotrie v0.2.3 [INFO] [stderr] Compiling tracing v0.1.44 [INFO] [stderr] Compiling strum v0.26.3 [INFO] [stderr] Compiling zerovec v0.11.5 [INFO] [stderr] Compiling thiserror v2.0.18 [INFO] [stderr] Compiling clap v4.6.0 [INFO] [stderr] Compiling clap_complete v4.6.0 [INFO] [stderr] Compiling tinystr v0.8.2 [INFO] [stderr] Compiling potential_utf v0.1.4 [INFO] [stderr] Compiling icu_locale_core v2.1.1 [INFO] [stderr] Compiling icu_collections v2.1.1 [INFO] [stderr] Compiling darling_macro v0.23.0 [INFO] [stderr] Compiling darling v0.23.0 [INFO] [stderr] Compiling serde v1.0.228 [INFO] [stderr] Compiling icu_provider v2.1.1 [INFO] [stderr] Compiling either v1.15.0 [INFO] [stderr] Compiling serde_urlencoded v0.7.1 [INFO] [stderr] Compiling toml_datetime v0.6.11 [INFO] [stderr] Compiling serde_spanned v0.6.9 [INFO] [stderr] Compiling chrono v0.4.44 [INFO] [stderr] Compiling toml_edit v0.22.27 [INFO] [stderr] Compiling itertools v0.13.0 [INFO] [stderr] Compiling icu_properties v2.1.2 [INFO] [stderr] Compiling icu_normalizer v2.1.1 [INFO] [stderr] Compiling futures v0.3.32 [INFO] [stderr] Compiling idna_adapter v1.2.1 [INFO] [stderr] Compiling idna v1.1.0 [INFO] [stderr] Compiling url v2.5.8 [INFO] [stderr] Compiling toml v0.8.23 [INFO] [stderr] Compiling unicode-truncate v1.1.0 [INFO] [stderr] Compiling ratatui v0.29.0 [INFO] [stderr] Compiling sqlx-core v0.8.6 [INFO] [stderr] Compiling sqlx-sqlite v0.8.6 [INFO] [stderr] Compiling sqlx-macros-core v0.8.6 [INFO] [stderr] Compiling sqlx-macros v0.8.6 [INFO] [stderr] Compiling sqlx v0.8.6 [INFO] [stdout] warning: function `in_placeholders` is never used [INFO] [stdout] --> src/db.rs:2635:4 [INFO] [stdout] | [INFO] [stdout] 2635 | fn in_placeholders(count: usize) -> String { [INFO] [stdout] | ^^^^^^^^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 06s [INFO] running `Command { std: "docker" "inspect" "ec164493d80f5a176bc0d88daf2e384d87b34fc34bb919017da8db80c2316010", 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" "ec164493d80f5a176bc0d88daf2e384d87b34fc34bb919017da8db80c2316010" "/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 rustix v1.1.4 [INFO] [stderr] Compiling getrandom v0.4.2 [INFO] [stderr] Compiling crossterm v0.29.0 [INFO] [stderr] Compiling tempfile v3.27.0 [INFO] [stderr] Compiling comfy-table v7.2.2 [INFO] [stderr] Compiling scribe v1.0.0-beta4 (/opt/rustwide/workdir) [INFO] [stdout] warning: function `in_placeholders` is never used [INFO] [stdout] --> src/db.rs:2635:4 [INFO] [stdout] | [INFO] [stdout] 2635 | fn in_placeholders(count: usize) -> String { [INFO] [stdout] | ^^^^^^^^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] warning: function `in_placeholders` is never used [INFO] [stdout] --> src/db.rs:2635:4 [INFO] [stdout] | [INFO] [stdout] 2635 | fn in_placeholders(count: usize) -> String { [INFO] [stdout] | ^^^^^^^^^^^^^^^ [INFO] [stdout] | [INFO] [stdout] = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 10.25s [INFO] running `Command { std: "docker" "inspect" "ec164493d80f5a176bc0d88daf2e384d87b34fc34bb919017da8db80c2316010", 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" "ec164493d80f5a176bc0d88daf2e384d87b34fc34bb919017da8db80c2316010" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen", kill_on_drop: false }` [INFO] [stderr] warning: function `in_placeholders` is never used [INFO] [stderr] --> src/db.rs:2635:4 [INFO] [stderr] | [INFO] [stderr] 2635 | fn in_placeholders(count: usize) -> String { [INFO] [stderr] | ^^^^^^^^^^^^^^^ [INFO] [stderr] | [INFO] [stderr] = note: `#[warn(dead_code)]` (part of `#[warn(unused)]`) on by default [INFO] [stderr] [INFO] [stderr] warning: `scribe` (bin "scribe") generated 1 warning [INFO] [stderr] warning: `scribe` (bin "scribe" test) generated 1 warning (1 duplicate) [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 1.68s [INFO] [stderr] Running unittests src/main.rs (/opt/rustwide/target/debug/build/scribe/5e0dceeb9d3324ee/out/scribe-5e0dceeb9d3324ee) [INFO] [stdout] [INFO] [stdout] running 297 tests [INFO] [stdout] test cmd_init::tests::test_all_25_events_present ... ok [INFO] [stdout] test cmd_init::tests::test_is_scribe_entry_detects_guard ... ok [INFO] [stdout] test cmd_init::tests::test_canonical_event_order ... ok [INFO] [stdout] test cmd_init::tests::test_guard_has_correct_timeout ... ok [INFO] [stdout] test cmd_init::tests::test_invalid_json_returns_error ... ok [INFO] [stdout] test cmd_init::tests::test_generates_valid_json ... ok [INFO] [stdout] test cmd_init::tests::test_hook_command_and_timeout ... ok [INFO] [stdout] test cmd_init::tests::test_matcher_events_have_matcher ... ok [INFO] [stdout] test cmd_init::tests::test_global_home_override_takes_precedence_over_env ... ok [INFO] [stdout] test cmd_init::tests::test_non_matcher_events_omit_matcher ... ok [INFO] [stdout] test cmd_init::tests::test_merge_cleans_up_duplicate_scribe_entries ... ok [INFO] [stdout] test cmd_init::tests::test_merge_appends_when_no_scribe_entry ... ok [INFO] [stdout] test cmd_init::tests::test_global_respects_claude_config_dir_env ... ok [INFO] [stdout] test cmd_init::tests::test_merge_preserves_non_hooks_keys ... ok [INFO] [stdout] test cmd_init::tests::test_new_file_created ... ok [INFO] [stdout] test cmd_init::tests::test_merge_preserves_non_scribe_event_hooks ... ok [INFO] [stdout] test cmd_init::tests::test_merge_preserves_non_scribe_hooks_on_same_event ... ok [INFO] [stdout] test cmd_init::tests::test_with_guard_only_on_pretooluse ... ok [INFO] [stdout] test cmd_init::tests::test_merge_is_idempotent ... ok [INFO] [stdout] test cmd_init::tests::test_without_guard_unchanged ... ok [INFO] [stdout] test cmd_init::tests::test_merge_is_idempotent_with_guard ... ok [INFO] [stdout] test cmd_init::tests::test_run_config_dir_creates_file ... ok [INFO] [stdout] test cmd_init::tests::test_with_guard_adds_guard_to_pretooluse ... ok [INFO] [stdout] test cmd_init::tests::test_run_config_dir_merges_existing ... ok [INFO] [stdout] test cmd_init::tests::test_run_global_with_home_override ... ok [INFO] [stdout] test cmd_init::tests::test_run_config_dir_with_guard ... ok [INFO] [stdout] test cmd_backfill::tests::test_backfill_unparseable_payload_skipped ... ok [INFO] [stdout] test cmd_log::tests::test_empty_stdin_returns_ok ... ok [INFO] [stdout] test cmd_backfill::tests::test_backfill_stop_failure ... ok [INFO] [stdout] test cmd_backfill::tests::test_backfill_subagent_stop_dual_insert ... ok [INFO] [stdout] test cmd_backfill::tests::test_backfill_idempotent ... ok [INFO] [stdout] test cmd_backfill::tests::test_backfill_dry_run_no_rows ... ok [INFO] [stdout] test cmd_log::tests::test_event_instructions_loaded ... ok [INFO] [stdout] test cmd_log::tests::test_event_config_change ... ok [INFO] [stdout] test cmd_log::tests::test_event_permission_request ... ok [INFO] [stdout] test cmd_log::tests::test_event_file_changed ... ok [INFO] [stdout] test cmd_log::tests::test_event_elicitation_result ... ok [INFO] [stdout] test cmd_log::tests::test_event_cwd_changed ... ok [INFO] [stdout] test cmd_log::tests::test_event_notification ... ok [INFO] [stdout] test cmd_log::tests::test_event_post_compact ... ok [INFO] [stdout] test cmd_log::tests::test_event_elicitation ... ok [INFO] [stdout] test cmd_backfill::tests::test_backfill_batch_boundary ... ok [INFO] [stdout] test cmd_log::tests::test_event_post_tool_use ... ok [INFO] [stdout] test cmd_log::tests::test_event_pre_compact ... ok [INFO] [stdout] test cmd_log::tests::test_event_post_tool_use_failure ... ok [INFO] [stdout] test cmd_log::tests::test_event_session_start ... ok [INFO] [stdout] test cmd_log::tests::test_event_task_completed ... ok [INFO] [stdout] test cmd_log::tests::test_event_stop ... ok [INFO] [stdout] test cmd_log::tests::test_event_session_end ... ok [INFO] [stdout] test cmd_log::tests::test_event_subagent_stop ... ok [INFO] [stdout] test cmd_log::tests::test_event_pre_tool_use ... ok [INFO] [stdout] test cmd_log::tests::test_event_user_prompt_submit ... ok [INFO] [stdout] test cmd_log::tests::test_event_stop_failure ... ok [INFO] [stdout] test cmd_log::tests::test_event_subagent_start ... ok [INFO] [stdout] test cmd_log::tests::test_event_worktree_create ... ok [INFO] [stdout] test cmd_log::tests::test_event_task_created ... ok [INFO] [stdout] test cmd_log::tests::test_event_worktree_remove ... ok [INFO] [stdout] test cmd_log::tests::test_event_teammate_idle ... ok [INFO] [stdout] test cmd_query::tests::test_duration_hours_minutes ... ok [INFO] [stdout] test cmd_query::tests::test_duration_less_than_1m ... ok [INFO] [stdout] test cmd_query::tests::test_duration_days_hours ... ok [INFO] [stdout] test cmd_query::tests::test_duration_minutes ... ok [INFO] [stdout] test cmd_query::tests::test_format_timestamp ... ok [INFO] [stdout] test cmd_query::tests::test_parse_absolute_datetime ... ok [INFO] [stdout] test cmd_query::tests::test_parse_absolute_date ... ok [INFO] [stdout] test cmd_query::tests::test_parse_duration ... ok [INFO] [stdout] test cmd_query::tests::test_parse_duration_days ... ok [INFO] [stdout] test cmd_query::tests::test_parse_invalid_input ... ok [INFO] [stdout] test cmd_query::tests::test_truncate_cwd_long ... ok [INFO] [stdout] test cmd_query::tests::test_truncate_cwd_none ... ok [INFO] [stdout] test cmd_query::tests::test_truncate_session_id_long ... ok [INFO] [stdout] test cmd_query::tests::test_truncate_cwd_short ... ok [INFO] [stdout] test cmd_query::tests::test_truncate_session_id_short ... ok [INFO] [stdout] test cmd_query::tests::test_truncate_summary_bash_command ... ok [INFO] [stdout] test cmd_query::tests::test_truncate_summary_file_path ... ok [INFO] [stdout] test cmd_query::tests::test_truncate_summary_long ... ok [INFO] [stdout] test cmd_query::tests::test_truncate_summary_none ... ok [INFO] [stdout] test cmd_query::tests::test_truncate_summary_short ... ok [INFO] [stdout] test cmd_log::tests::test_malformed_json_returns_ok ... ok [INFO] [stdout] test cmd_log::tests::test_field_mapping_and_serialization ... ok [INFO] [stdout] test config::tests::test_created_config_loads_as_default ... ok [INFO] [stdout] test config::tests::test_ensure_config_creates_file ... ok [INFO] [stdout] test cmd_log::tests::test_retention_invalid_check_interval ... ok [INFO] [stdout] test config::tests::test_ensure_config_creates_parent_dirs ... ok [INFO] [stdout] test config::tests::test_ensure_config_noop_when_exists ... ok [INFO] [stdout] test config::tests::test_load_config_missing_file ... ok [INFO] [stdout] test config::tests::test_load_config_from_file ... ok [INFO] [stdout] test config::tests::test_migrate_adds_missing_fields ... ok [INFO] [stdout] test config::tests::test_migrate_commented_out_field_not_readded ... ok [INFO] [stdout] test config::tests::test_migrate_missing_file_returns_none ... ok [INFO] [stdout] test config::tests::test_migrate_empty_file ... ok [INFO] [stdout] test config::tests::test_migrate_mix_active_and_commented ... ok [INFO] [stdout] test cmd_log::tests::test_latency_warm_db ... ok [INFO] [stdout] test config::tests::test_migrate_noop_when_current ... ok [INFO] [stdout] test config::tests::test_migrate_preserves_user_values ... ok [INFO] [stdout] test config::tests::test_migrate_preserves_user_comments ... ok [INFO] [stdout] test config::tests::test_migrate_unknown_fields_left_alone ... ok [INFO] [stdout] test config::tests::test_migration_report_format ... ok [INFO] [stdout] test config::tests::test_parse_empty_file ... ok [INFO] [stdout] test config::tests::test_parse_full_config ... ok [INFO] [stdout] test config::tests::test_parse_invalid_toml ... ok [INFO] [stdout] test config::tests::test_migrate_unparseable_file ... ok [INFO] [stdout] test config::tests::test_parse_partial_config ... ok [INFO] [stdout] test config::tests::test_template_contains_all_config_fields ... ok [INFO] [stdout] test config::tests::test_template_is_valid_toml ... ok [INFO] [stdout] test cmd_log::tests::test_raw_payload_preserved_exactly ... ok [INFO] [stdout] test cmd_log::tests::test_retention_check_not_elapsed ... ok [INFO] [stdout] test cmd_retain::tests::test_handler_invalid_duration ... ok [INFO] [stdout] test cmd_log::tests::test_sessions_upsert_via_handler ... ok [INFO] [stdout] test cmd_log::tests::test_retention_invalid_retention_string ... ok [INFO] [stdout] test cmd_log::tests::test_whitespace_only_returns_ok ... ok [INFO] [stdout] test cmd_stats::tests::test_get_stats_empty ... ok [INFO] [stdout] test cmd_log::tests::test_sessions_separate_rows ... ok [INFO] [stdout] test cmd_retain::tests::test_handler_no_old_events ... ok [INFO] [stdout] test cmd_retain::tests::test_handler_valid_duration ... ok [INFO] [stdout] test cmd_log::tests::test_retention_missing_key_triggers_cleanup ... ok [INFO] [stdout] test cmd_log::tests::test_retention_check_elapsed ... ok [INFO] [stdout] test db::tests::test_avg_session_duration_no_sessions ... ok [INFO] [stdout] test cmd_stats::tests::test_get_stats_populated ... ok [INFO] [stdout] test db::tests::test_auto_vacuum_incremental ... ok [INFO] [stdout] test db::tests::test_avg_session_duration_excludes_single_event ... ok [INFO] [stdout] test db::tests::test_avg_session_duration_cap_excludes_all ... ok [INFO] [stdout] test db::tests::test_busy_timeout ... ok [INFO] [stdout] test db::tests::test_daily_activity_empty_db ... ok [INFO] [stdout] test db::tests::test_cascade_delete_with_retain ... ok [INFO] [stdout] test db::tests::test_cascade_delete_removes_detail_rows ... ok [INFO] [stdout] test db::tests::test_connect_creates_directory_and_db ... ok [INFO] [stdout] test db::tests::test_avg_session_duration_with_max_cap ... ok [INFO] [stdout] test db::tests::test_avg_session_duration_normal ... ok [INFO] [stdout] test db::tests::test_avg_session_duration_with_since ... ok [INFO] [stdout] test db::tests::test_daily_activity_populated ... ok [INFO] [stdout] test db::tests::test_delete_events_before ... ok [INFO] [stdout] test db::tests::test_daily_activity_with_since ... ok [INFO] [stdout] test db::tests::test_detail_config_change ... ok [INFO] [stdout] test db::tests::test_delete_orphaned_sessions_no_orphans ... ok [INFO] [stdout] test db::tests::test_delete_events_before_no_matches ... ok [INFO] [stdout] test db::tests::test_delete_orphaned_sessions ... ok [INFO] [stdout] test db::tests::test_detail_elicitation ... ok [INFO] [stdout] test db::tests::test_detail_instructions_loaded ... ok [INFO] [stdout] test db::tests::test_detail_elicitation_result ... ok [INFO] [stdout] test db::tests::test_detail_post_compact ... ok [INFO] [stdout] test db::tests::test_detail_permission_request_suggestions ... ok [INFO] [stdout] test db::tests::test_detail_notification ... ok [INFO] [stdout] test db::tests::test_detail_pre_compact ... ok [INFO] [stdout] test db::tests::test_detail_post_tool_use_failure_error_fields ... ok [INFO] [stdout] test db::tests::test_detail_pre_tool_use_tool_use_id ... ok [INFO] [stdout] test db::tests::test_detail_session_end ... ok [INFO] [stdout] test db::tests::test_detail_stop_event ... ok [INFO] [stdout] test db::tests::test_detail_round_trip_with_join ... ok [INFO] [stdout] test db::tests::test_detail_session_start ... ok [INFO] [stdout] test db::tests::test_detail_subagent_stop ... ok [INFO] [stdout] test db::tests::test_detail_subagent_start ... ok [INFO] [stdout] test db::tests::test_detail_stop_failure ... ok [INFO] [stdout] test db::tests::test_detail_subagent_stop_dual_insert ... ok [INFO] [stdout] test db::tests::test_detail_task_completed ... ok [INFO] [stdout] test db::tests::test_detail_teammate_idle ... ok [INFO] [stdout] test db::tests::test_detail_unknown_event_no_detail_row ... ok [INFO] [stdout] test db::tests::test_detail_worktree_remove ... ok [INFO] [stdout] test db::tests::test_error_summary_fallback ... ok [INFO] [stdout] test db::tests::test_detail_user_prompt_submit ... ok [INFO] [stdout] test db::tests::test_error_summary_no_errors ... ok [INFO] [stdout] test db::tests::test_error_summary_with_detail_tables ... ok [INFO] [stdout] test db::tests::test_event_type_breakdown_empty_db ... ok [INFO] [stdout] test db::tests::test_is_default_path ... ok [INFO] [stdout] test db::tests::test_migrate_legacy_db_moves_files ... ok [INFO] [stdout] test db::tests::test_migrate_skipped_when_not_default ... ok [INFO] [stdout] test db::tests::test_fetch_event_detail_missing ... ok [INFO] [stdout] test db::tests::test_fetch_event_detail_stop_failure ... ok [INFO] [stdout] test db::tests::test_fetch_event_detail_session ... ok [INFO] [stdout] test db::tests::test_error_summary_with_errors ... ok [INFO] [stdout] test db::tests::test_event_type_breakdown_populated ... ok [INFO] [stdout] test db::tests::test_error_summary_with_since ... ok [INFO] [stdout] test db::tests::test_fetch_event_detail_subagent_stop_dual ... ok [INFO] [stdout] test db::tests::test_fetch_event_detail_tool ... ok [INFO] [stdout] test db::tests::test_event_type_breakdown_with_since ... ok [INFO] [stdout] test db::tests::test_fetch_event_detail_unknown_type ... ok [INFO] [stdout] test db::tests::test_foreign_keys_enabled ... ok [INFO] [stdout] test db::tests::test_insert_event_returns_id ... ok [INFO] [stdout] test db::tests::test_get_stats_with_since ... ok [INFO] [stdout] test db::tests::test_get_stats_without_since ... ok [INFO] [stdout] test db::tests::test_resolve_db_path_cli_overrides_all ... ok [INFO] [stdout] test db::tests::test_resolve_db_path_config_overrides_default ... ok [INFO] [stdout] test db::tests::test_resolve_db_path_default ... ok [INFO] [stdout] test db::tests::test_resolve_db_path_env_overrides_config ... ok [INFO] [stdout] test db::tests::test_insert_event_round_trip ... ok [INFO] [stdout] test db::tests::test_migration_adds_cwd_index ... ok [INFO] [stdout] test db::tests::test_migration_creates_tables_and_indexes ... ok [INFO] [stdout] test db::tests::test_query_events_combined_filters ... ok [INFO] [stdout] test db::tests::test_migration_is_idempotent ... ok [INFO] [stdout] test db::tests::test_query_events_empty_result ... ok [INFO] [stdout] test db::tests::test_query_events_limit ... ok [INFO] [stdout] test db::tests::test_query_events_event_type_filter ... ok [INFO] [stdout] test db::tests::test_query_events_no_filters ... ok [INFO] [stdout] test db::tests::test_query_events_search_filter ... ok [INFO] [stdout] test db::tests::test_query_events_session_filter ... ok [INFO] [stdout] test db::tests::test_query_events_since_filter ... ok [INFO] [stdout] test db::tests::test_query_events_tool_name_filter ... ok [INFO] [stdout] test format::tests::test_format_count_millions ... ok [INFO] [stdout] test format::tests::test_format_count_small ... ok [INFO] [stdout] test format::tests::test_format_count_thousands ... ok [INFO] [stdout] test format::tests::test_format_count_zero ... ok [INFO] [stdout] test format::tests::test_format_duration_hours_minutes ... ok [INFO] [stdout] test format::tests::test_format_duration_large_minutes_no_seconds ... ok [INFO] [stdout] test format::tests::test_format_duration_minutes_only ... ok [INFO] [stdout] test format::tests::test_format_duration_minutes_seconds ... ok [INFO] [stdout] test format::tests::test_format_duration_negative ... ok [INFO] [stdout] test format::tests::test_format_duration_seconds_only ... ok [INFO] [stdout] test format::tests::test_format_duration_zero ... ok [INFO] [stdout] test format::tests::test_format_size_bytes ... ok [INFO] [stdout] test format::tests::test_format_size_gb ... ok [INFO] [stdout] test format::tests::test_format_size_kb ... ok [INFO] [stdout] test format::tests::test_format_size_mb ... ok [INFO] [stdout] test format::tests::test_format_timestamp_iso ... ok [INFO] [stdout] test format::tests::test_histogram_bar_full ... ok [INFO] [stdout] test format::tests::test_histogram_bar_half ... ok [INFO] [stdout] test format::tests::test_histogram_bar_small_value_at_least_one ... ok [INFO] [stdout] test format::tests::test_histogram_bar_zero_max ... ok [INFO] [stdout] test format::tests::test_histogram_bar_zero_value ... ok [INFO] [stdout] test format::tests::test_truncate_path_exact_fit ... ok [INFO] [stdout] test format::tests::test_truncate_path_long ... ok [INFO] [stdout] test format::tests::test_truncate_path_preserves_trailing ... ok [INFO] [stdout] test format::tests::test_truncate_path_short ... ok [INFO] [stdout] test format::tests::test_truncate_path_very_narrow ... ok [INFO] [stdout] test models::tests::test_config_change ... ok [INFO] [stdout] test models::tests::test_cwd_changed ... ok [INFO] [stdout] test models::tests::test_elicitation ... ok [INFO] [stdout] test models::tests::test_elicitation_result ... ok [INFO] [stdout] test models::tests::test_file_changed ... ok [INFO] [stdout] test models::tests::test_instructions_loaded ... ok [INFO] [stdout] test models::tests::test_missing_optional_fields ... ok [INFO] [stdout] test models::tests::test_notification ... ok [INFO] [stdout] test models::tests::test_permission_request ... ok [INFO] [stdout] test models::tests::test_post_compact ... ok [INFO] [stdout] test models::tests::test_post_tool_use ... ok [INFO] [stdout] test models::tests::test_post_tool_use_failure ... ok [INFO] [stdout] test models::tests::test_pre_compact ... ok [INFO] [stdout] test models::tests::test_pre_tool_use ... ok [INFO] [stdout] test models::tests::test_session_end ... ok [INFO] [stdout] test models::tests::test_session_start ... ok [INFO] [stdout] test models::tests::test_stop ... ok [INFO] [stdout] test models::tests::test_stop_failure ... ok [INFO] [stdout] test models::tests::test_subagent_start ... ok [INFO] [stdout] test models::tests::test_subagent_stop ... ok [INFO] [stdout] test models::tests::test_task_completed ... ok [INFO] [stdout] test models::tests::test_task_created ... ok [INFO] [stdout] test models::tests::test_teammate_idle ... ok [INFO] [stdout] test models::tests::test_unknown_fields_ignored ... ok [INFO] [stdout] test models::tests::test_user_prompt_submit ... ok [INFO] [stdout] test models::tests::test_worktree_create ... ok [INFO] [stdout] test models::tests::test_worktree_remove ... ok [INFO] [stdout] test tui::app::tests::test_app_prev_tab_wraps ... ok [INFO] [stdout] test tui::app::tests::test_app_quit ... ok [INFO] [stdout] test tui::app::tests::test_app_set_tab ... ok [INFO] [stdout] test tui::app::tests::test_app_tab_switching ... ok [INFO] [stdout] test tui::app::tests::test_app_toggle_help ... ok [INFO] [stdout] test tui::app::tests::test_tab_index_roundtrip ... ok [INFO] [stdout] test tui::app::tests::test_tab_titles ... ok [INFO] [stdout] test tui::filter::tests::test_activate_deactivate ... ok [INFO] [stdout] test tui::filter::tests::test_filter_events ... ok [INFO] [stdout] test tui::filter::tests::test_filter_sessions ... ok [INFO] [stdout] test tui::filter::tests::test_matches_case_insensitive ... ok [INFO] [stdout] test tui::filter::tests::test_matches_empty_input ... ok [INFO] [stdout] test tui::filter::tests::test_push_delete_char ... ok [INFO] [stdout] test tui::tabs::events::tests::test_clear_session_filter ... ok [INFO] [stdout] test tui::tabs::events::tests::test_navigation_collapses_detail ... ok [INFO] [stdout] test tui::tabs::events::tests::test_pretty_json_truncated ... ok [INFO] [stdout] test tui::tabs::events::tests::test_raw_json_format ... ok [INFO] [stdout] test tui::tabs::events::tests::test_set_session_filter ... ok [INFO] [stdout] test tui::tabs::events::tests::test_structured_detail_contains_fields ... ok [INFO] [stdout] test tui::tabs::events::tests::test_toggle_detail_mode ... ok [INFO] [stdout] test tui::tabs::events::tests::test_toggle_expand ... ok [INFO] [stdout] test tui::tabs::live::tests::test_auto_scroll_behavior ... ok [INFO] [stdout] test tui::tabs::live::tests::test_events_per_minute ... ok [INFO] [stdout] test tui::tabs::live::tests::test_ring_buffer_trimming ... ok [INFO] [stdout] test tui::tabs::live::tests::test_scroll_empty_feed ... ok [INFO] [stdout] test tui::tabs::sessions::tests::test_next_empty ... ok [INFO] [stdout] test tui::tabs::sessions::tests::test_next_wraps ... ok [INFO] [stdout] test tui::tabs::sessions::tests::test_prev_wraps ... ok [INFO] [stdout] test tui::tabs::sessions::tests::test_selected_session_id ... ok [INFO] [stdout] test tui::tabs::sessions::tests::test_top_bottom ... ok [INFO] [stdout] test tui::tabs::stats::tests::test_scroll_clamping ... ok [INFO] [stdout] test tui::tabs::stats::tests::test_scroll_empty ... ok [INFO] [stdout] test db::tests::test_query_sessions_no_filters ... ok [INFO] [stdout] test db::tests::test_sessions_by_model_empty ... ok [INFO] [stdout] test db::tests::test_sessions_by_model ... ok [INFO] [stdout] test db::tests::test_query_sessions_since_filter ... ok [INFO] [stdout] test db::tests::test_sessions_upsert_different_sessions ... ok [INFO] [stdout] test db::tests::test_top_directories_empty_db ... ok [INFO] [stdout] test db::tests::test_tool_failures_by_error ... ok [INFO] [stdout] test db::tests::test_sessions_upsert_same_session ... ok [INFO] [stdout] test db::tests::test_top_tools_empty_db ... ok [INFO] [stdout] test db::tests::test_wal_mode_enabled ... ok [INFO] [stdout] test db::tests::test_top_directories_populated ... ok [INFO] [stdout] test db::tests::test_top_tools_limit ... ok [INFO] [stdout] test db::tests::test_top_directories_with_since ... ok [INFO] [stdout] test db::tests::test_top_tools_with_since ... ok [INFO] [stdout] test db::tests::test_top_tools_populated ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 297 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.59s [INFO] [stdout] [INFO] [stderr] Running tests/completions_integration.rs (/opt/rustwide/target/debug/build/scribe/80ece7db0720e9b1/out/completions_integration-80ece7db0720e9b1) [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test test_completions_invalid_shell ... ok [INFO] [stdout] test test_completions_fish ... ok [INFO] [stdout] test test_completions_bash ... ok [INFO] [stdout] test test_completions_zsh ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stderr] Running tests/concurrent_integration.rs (/opt/rustwide/target/debug/build/scribe/5f4b23b30590377b/out/concurrent_integration-5f4b23b30590377b) [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test test_concurrent_db_wal_mode ... ok [INFO] [stdout] test test_concurrent_different_profiles_staggered ... ok [INFO] [stdout] test test_concurrent_log_no_lost_events ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.28s [INFO] [stdout] [INFO] [stderr] Running tests/config_integration.rs (/opt/rustwide/target/debug/build/scribe/9423c5880edf3182/out/config_integration-9423c5880edf3182) [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stdout] test log_does_not_fail_without_config ... ok [INFO] [stdout] test stats_works_with_no_config ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s [INFO] [stdout] [INFO] [stderr] Running tests/init_integration.rs (/opt/rustwide/target/debug/build/scribe/50ea1fab8e844dbc/out/init_integration-50ea1fab8e844dbc) [INFO] [stdout] [INFO] [stdout] running 18 tests [INFO] [stdout] test test_init_config_dir_conflicts_with_global ... ok [INFO] [stdout] test test_init_config_dir_conflicts_with_project ... ok [INFO] [stdout] test test_init_no_db_created ... ok [INFO] [stdout] test test_init_config_dir_creates_file ... ok [INFO] [stdout] test test_init_stdout_command_and_timeout ... ok [INFO] [stdout] test test_init_project_creates_file ... ok [INFO] [stdout] test test_init_project_global_mutually_exclusive ... ok [INFO] [stdout] test test_init_stdout_all_25_events ... ok [INFO] [stdout] test test_init_config_dir_merges_existing ... ok [INFO] [stdout] test test_init_project_invalid_json_error ... ok [INFO] [stdout] test test_init_global_creates_file ... ok [INFO] [stdout] test test_init_stdout_valid_json ... ok [INFO] [stdout] test test_init_stdout_matcher_correctness ... ok [INFO] [stdout] test test_init_project_preserves_existing_keys ... ok [INFO] [stdout] test test_init_project_preserves_non_scribe_events ... ok [INFO] [stdout] test test_init_global_respects_claude_config_dir ... ok [INFO] [stdout] test test_init_project_preserves_user_hooks_on_same_event ... ok [INFO] [stdout] test test_init_project_idempotent ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 18 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stderr] Running tests/log_integration.rs (/opt/rustwide/target/debug/build/scribe/24f32f109fb976fd/out/log_integration-24f32f109fb976fd) [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test test_binary_log_malformed_json_exits_zero ... ok [INFO] [stdout] test test_binary_log_empty_stdin_exits_zero ... ok [INFO] [stdout] test test_binary_log_valid_json ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s [INFO] [stdout] [INFO] [stderr] Running tests/query_integration.rs (/opt/rustwide/target/debug/build/scribe/8b8fddb4448fc70b/out/query_integration-8b8fddb4448fc70b) [INFO] [stdout] [INFO] [stdout] running 16 tests [INFO] [stdout] test test_query_json_csv_mutually_exclusive ... ok [INFO] [stdout] test test_query_invalid_since ... ok [INFO] [stdout] test test_query_sessions_basic ... ok [INFO] [stdout] test test_query_json_output ... ok [INFO] [stdout] test test_query_sessions_csv ... ok [INFO] [stdout] test test_query_tool_filter ... ok [INFO] [stdout] test test_query_event_type_filter ... ok [INFO] [stdout] test test_query_sessions_json ... ok [INFO] [stdout] test test_query_basic ... ok [INFO] [stdout] test test_query_session_filter ... ok [INFO] [stdout] test test_query_search_filter ... ok [INFO] [stdout] test test_query_empty_result ... ok [INFO] [stdout] test test_query_since_date ... ok [INFO] [stdout] test test_query_limit ... ok [INFO] [stdout] test test_query_csv_output ... ok [INFO] [stdout] test test_query_sessions_limit ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.22s [INFO] [stdout] [INFO] [stderr] Running tests/retain_integration.rs (/opt/rustwide/target/debug/build/scribe/9600aa5c9f14382a/out/retain_integration-9600aa5c9f14382a) [INFO] [stdout] [INFO] [stdout] running 4 tests [INFO] [stdout] test test_retain_invalid_duration ... ok [INFO] [stdout] test test_retain_reports_deleted_count ... ok [INFO] [stdout] test test_retain_deletes_old_events ... ok [INFO] [stdout] test test_retain_orphan_cleanup ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.12s [INFO] [stdout] [INFO] [stderr] Running tests/stats_integration.rs (/opt/rustwide/target/debug/build/scribe/7f2abc25e9d43f92/out/stats_integration-7f2abc25e9d43f92) [INFO] [stdout] [INFO] [stdout] running 7 tests [INFO] [stdout] test test_stats_json_empty_db ... ok [INFO] [stdout] test test_stats_empty_db ... ok [INFO] [stdout] test test_stats_json_populated ... ok [INFO] [stdout] test test_stats_populated_db ... ok [INFO] [stdout] test test_stats_json_valid_single_object ... ok [INFO] [stdout] test test_stats_json_with_since ... ok [INFO] [stdout] test test_stats_with_since ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.25s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "ec164493d80f5a176bc0d88daf2e384d87b34fc34bb919017da8db80c2316010", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "ec164493d80f5a176bc0d88daf2e384d87b34fc34bb919017da8db80c2316010", kill_on_drop: false }` [INFO] [stdout] ec164493d80f5a176bc0d88daf2e384d87b34fc34bb919017da8db80c2316010