[INFO] fetching crate siftr 0.3.1...
[INFO] testing siftr-0.3.1 against 1.99.0-beta.8+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate siftr 0.3.1 into /workspace/builds/worker-5-tc1/source
[INFO] started tweaking crates.io crate siftr 0.3.1
[INFO] finished tweaking crates.io crate siftr 0.3.1
[INFO] tweaked toml for crates.io crate siftr 0.3.1 written to /workspace/builds/worker-5-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate siftr 0.3.1 on toolchain 1.99.0-beta.8
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate siftr 0.3.1 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded rsqlite-vfs v0.1.1
[INFO] [stderr]   Downloaded rusqlite v0.40.2
[INFO] [stderr]   Downloaded libsqlite3-sys v0.38.2
[INFO] [stderr]   Downloaded sqlite-wasm-rs v0.5.5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 2dbe510a388f176ecb85a362805d250043a151ba0f2f22a48de6291e850917ba
[INFO] running `Command { std: "docker" "start" "2dbe510a388f176ecb85a362805d250043a151ba0f2f22a48de6291e850917ba", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "2dbe510a388f176ecb85a362805d250043a151ba0f2f22a48de6291e850917ba", 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" "2dbe510a388f176ecb85a362805d250043a151ba0f2f22a48de6291e850917ba" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "2dbe510a388f176ecb85a362805d250043a151ba0f2f22a48de6291e850917ba", 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" "2dbe510a388f176ecb85a362805d250043a151ba0f2f22a48de6291e850917ba" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling find-msvc-tools v0.1.12
[INFO] [stderr]    Compiling rustix v1.1.5
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling linux-raw-sys v0.12.1
[INFO] [stderr]    Compiling serde_spanned v1.1.1
[INFO] [stderr]    Compiling hashlink v0.12.2
[INFO] [stderr]    Compiling toml_datetime v1.1.1+spec-1.1.0
[INFO] [stderr]    Compiling syn v3.0.5
[INFO] [stderr]    Compiling getrandom v0.4.3
[INFO] [stderr]    Compiling clap_builder v4.6.7
[INFO] [stderr]    Compiling toml_parser v1.1.3+spec-1.1.0
[INFO] [stderr]    Compiling fallible-streaming-iterator v0.1.9
[INFO] [stderr]    Compiling fallible-iterator v0.3.0
[INFO] [stderr]    Compiling smallvec v1.16.1
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling signal-hook-registry v1.4.8
[INFO] [stderr]    Compiling cc v1.4.6
[INFO] [stderr]    Compiling signal-hook v0.3.18
[INFO] [stderr]    Compiling toml v1.1.6+spec-1.1.0
[INFO] [stderr]    Compiling libsqlite3-sys v0.38.2
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling clap_derive v4.6.7
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling clap v4.6.7
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling rusqlite v0.40.2
[INFO] [stderr]    Compiling siftr v0.3.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 2m 07s
[INFO] running `Command { std: "docker" "inspect" "2dbe510a388f176ecb85a362805d250043a151ba0f2f22a48de6291e850917ba", 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" "2dbe510a388f176ecb85a362805d250043a151ba0f2f22a48de6291e850917ba" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling siftr v0.3.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 18.11s
[INFO] running `Command { std: "docker" "inspect" "2dbe510a388f176ecb85a362805d250043a151ba0f2f22a48de6291e850917ba", 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" "2dbe510a388f176ecb85a362805d250043a151ba0f2f22a48de6291e850917ba" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.10s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/deps/siftr-a8451bb17aab8389)
[INFO] [stdout] 
[INFO] [stdout] running 111 tests
[INFO] [stdout] test aggregate::histogram::tests::buckets_contain_their_values ... ok
[INFO] [stdout] test baseline::tests::the_current_run_is_incomplete_only_for_examples_it_skipped ... ok
[INFO] [stdout] test aggregate::tests::summarizes_durations ... ok
[INFO] [stdout] test behavior::tests::behavior_ids_are_pinned ... ok
[INFO] [stdout] test analyze::tests::lines_that_differ_only_in_values_are_one_behavior ... ok
[INFO] [stdout] test context::tests::quotes_only_what_the_shell_would_split ... ok
[INFO] [stdout] test analyze::tests::interpreters_claim_in_order_and_flush_at_finish ... ok
[INFO] [stdout] test behavior::tests::kind_and_template_both_distinguish ... ok
[INFO] [stdout] test context::tests::a_credential_in_the_command_is_masked_and_still_a_stable_key ... ok
[INFO] [stdout] test interpret::cargo::tests::a_tests_identity_is_its_name_and_its_verdict_is_an_outcome ... ok
[INFO] [stdout] test aggregate::tests::phases_round_trip_through_scope_ids ... ok
[INFO] [stdout] test interpret::cargo::tests::every_test_binary_counts_into_one_summary ... ok
[INFO] [stdout] test interpret::cargo::tests::only_libtests_own_lines_are_claimed ... ok
[INFO] [stdout] test interpret::cargo::tests::stderr_is_cargos_not_libtests ... ok
[INFO] [stdout] test aggregate::tests::exemplars_are_bounded_and_start_with_the_first_occurrences ... ok
[INFO] [stdout] test aggregate::tests::exemplar_text_is_capped_on_a_char_boundary ... ok
[INFO] [stdout] test baseline::tests::a_run_without_a_test_summary_compares_with_every_recent_run ... ok
[INFO] [stdout] test interpret::fixtures::a_failure_carries_its_exception_class_scoped_to_the_example ... FAILED
[INFO] [stdout] test baseline::tests::errors_outside_examples_that_persist_do_not_skip_every_run ... ok
[INFO] [stdout] test baseline::tests::evidence_grows_with_quiet_runs ... ok
[INFO] [stdout] test interpret::fixtures::clean_runs_produce_identical_behaviors_scopes_and_counts ... FAILED
[INFO] [stdout] test baseline::tests::ignores_runs_beyond_the_cap ... ok
[INFO] [stdout] test interpret::fixtures::n_plus_one_changes_only_the_show_example ... FAILED
[INFO] [stdout] test baseline::tests::runs_that_skipped_the_same_examples_compare ... ok
[INFO] [stdout] test interpret::fixtures::listener_offsets_land_on_log_line_starts ... FAILED
[INFO] [stdout] test interpret::fixtures::only_log_lines_before_the_first_example_are_unscoped ... FAILED
[INFO] [stdout] test interpret::rails::tests::a_blocks_lines_scope_to_its_endpoint_when_no_example_encloses_them ... ok
[INFO] [stdout] test interpret::rails::tests::a_completed_line_without_its_request_is_a_log ... ok
[INFO] [stdout] test interpret::rails::tests::a_request_block_is_one_behavior_carrying_the_reported_query_count ... ok
[INFO] [stdout] test interpret::rails::tests::query_lines_key_on_name_and_statement_without_binds ... ok
[INFO] [stdout] test interpret::rails::tests::without_a_reported_count_a_request_counts_its_queries_but_not_transactions ... ok
[INFO] [stdout] test interpret::resources::tests::the_behavior_is_the_same_however_much_the_run_burned ... ok
[INFO] [stdout] test interpret::rspec::tests::a_load_error_is_named_by_its_file_class_and_cause ... ok
[INFO] [stdout] test interpret::rspec::tests::a_named_example_keeps_the_description_its_author_wrote ... ok
[INFO] [stdout] test interpret::rspec::tests::an_error_outside_examples_is_an_unscoped_failed_exception ... ok
[INFO] [stdout] test interpret::rspec::tests::an_event_without_the_declared_description_keeps_its_full_description ... ok
[INFO] [stdout] test interpret::resources::tests::what_was_recorded_reads_back_unchanged ... ok
[INFO] [stdout] test interpret::generic::tests::a_log_show_column_header_is_not_a_behavior ... ok
[INFO] [stdout] test interpret::generic::tests::detects_error_levels_only_as_words_near_the_start ... ok
[INFO] [stdout] test interpret::generic::tests::takes_the_duration_from_the_first_duration_slot ... ok
[INFO] [stdout] test interpret::resources::tests::one_run_level_behavior_carries_every_measure_once ... ok
[INFO] [stdout] test interpret::resources::tests::the_evidence_line_reads_without_a_unit_lookup ... ok
[INFO] [stdout] test behavior::tests::ids_and_kinds_round_trip_through_text ... ok
[INFO] [stdout] test interpret::cargo::tests::cargos_notice_that_a_target_failed_is_dropped ... ok
[INFO] [stdout] test interpret::rspec::tests::the_summary_carries_counts_and_fails_on_errors_outside_examples ... ok
[INFO] [stdout] test interpret::rspec::tests::an_unnamed_examples_identity_survives_what_rspec_writes_for_it ... ok
[INFO] [stdout] test normalize::hash::tests::fnv1a64_matches_reference_vectors ... ok
[INFO] [stdout] test interpret::rspec::tests::inserting_an_example_above_another_keeps_both_ids ... ok
[INFO] [stdout] test interpret::resources::tests::typical_usage_is_the_median_of_each_field ... ok
[INFO] [stdout] test normalize::recognize::tests::epoch_seconds_stay_int ... ok
[INFO] [stdout] test normalize::path::tests::roles_round_trip_through_text ... ok
[INFO] [stdout] test normalize::recognize::tests::identifiers ... ok
[INFO] [stdout] test interpret::rspec::tests::examples_sharing_a_file_and_description_are_one_behavior ... ok
[INFO] [stdout] test normalize::path::tests::package_names_drop_versions_platforms_and_revisions ... ok
[INFO] [stdout] test normalize::recognize::tests::emails ... ok
[INFO] [stdout] test normalize::recognize::tests::network ... ok
[INFO] [stdout] test interpret::rspec::tests::lines_not_in_the_listener_shape_are_kept_as_logs ... ok
[INFO] [stdout] test interpret::rspec::tests::log_lines_take_the_scope_of_the_example_whose_range_holds_their_first_byte ... ok
[INFO] [stdout] test interpret::rspec::tests::lines_outside_examples_are_setup_between_or_teardown ... ok
[INFO] [stdout] test baseline::tests::a_recent_run_is_skipped_only_for_examples_it_skipped_that_this_run_ran ... ok
[INFO] [stdout] test normalize::recognize::tests::numbers_and_units ... ok
[INFO] [stdout] test normalize::recognize::tests::timestamps ... ok
[INFO] [stdout] test normalize::syslog::tests::spans ... ok
[INFO] [stdout] test observation::tests::joins_lines_across_chunks_and_numbers_them ... ok
[INFO] [stdout] test normalize::syslog::tests::rejects_near_misses ... ok
[INFO] [stdout] test observation::tests::stream_names_round_trip ... ok
[INFO] [stdout] test num::tests::rounds_integers_to_significant_figures ... ok
[INFO] [stdout] test signal::rules::tests::latency_vectors ... ok
[INFO] [stdout] test num::tests::medians_and_deviations ... ok
[INFO] [stdout] test num::tests::rounds_floats_to_significant_figures ... ok
[INFO] [stdout] test signal::rules::tests::presence_vectors ... ok
[INFO] [stdout] test signal::tests::a_clean_run_has_no_signals ... ok
[INFO] [stdout] test normalize::recognize::tests::versions ... ok
[INFO] [stdout] test signal::tests::a_new_error_outside_examples_that_skipped_nothing_is_the_change ... ok
[INFO] [stdout] test signal::tests::a_count_that_tracks_the_suite_size_is_demoted_below_the_examples_that_explain_it ... ok
[INFO] [stdout] test signal::tests::a_recurring_behavior_is_vetoed_only_when_its_window_moved_without_it ... ok
[INFO] [stdout] test signal::tests::a_known_flaky_failure_is_not_an_error_but_a_new_exception_is ... ok
[INFO] [stdout] test signal::tests::a_request_blocks_signals_are_one_group_headed_by_the_request ... ok
[INFO] [stdout] test signal::tests::a_slow_example_is_latency_unless_its_neighbour_slowed_too ... ok
[INFO] [stdout] test signal::tests::a_request_that_slowed_groups_with_the_count_that_moved_inside_it ... ok
[INFO] [stdout] test signal::tests::an_n_plus_one_is_one_group_headed_by_the_request ... ok
[INFO] [stdout] test signal::tests::changes_after_the_last_example_are_teardown_ranked_with_setup ... ok
[INFO] [stdout] test signal::tests::changes_before_the_first_example_form_one_setup_group_ranked_last ... ok
[INFO] [stdout] test signal::rules::tests::error_vectors ... ok
[INFO] [stdout] test signal::tests::a_slow_request_is_latency_with_no_example_in_sight ... ok
[INFO] [stdout] test signal::tests::a_slow_example_is_vetoed_once_enough_distant_examples_slowed_with_it ... ok
[INFO] [stdout] test signal::tests::one_incomplete_run_in_the_baseline_does_not_blind_the_rest ... ok
[INFO] [stdout] test signal::tests::a_truncated_run_does_not_turn_its_absences_into_changes ... ok
[INFO] [stdout] test signal::tests::examples_added_in_two_files_stay_two_groups ... ok
[INFO] [stdout] test signal::tests::an_incomplete_run_keeps_what_ran_and_names_what_did_not ... ok
[INFO] [stdout] test signal::tests::examples_renamed_within_one_file_stay_two_groups ... ok
[INFO] [stdout] test signal::tests::examples_that_disappeared_from_one_file_are_one_group_below_a_regression ... ok
[INFO] [stdout] test signal::tests::runs_recorded_before_test_results_were_read_are_no_baseline_for_a_test_run ... ok
[INFO] [stdout] test observation::tests::truncates_overlong_lines_without_renumbering_or_losing_their_length ... ok
[INFO] [stdout] test signal::tests::examples_added_in_one_file_are_one_group ... ok
[INFO] [stdout] test interpret::cargo::tests::a_summary_that_isnt_libtests_shape_is_left_alone ... ok
[INFO] [stdout] test signal::tests::stderr_messages_group_by_prefix_and_stdout_only_counts_without_a_reporter ... ok
[INFO] [stdout] test store::retention::tests::settings_come_from_the_environment_within_their_floors ... ok
[INFO] [stdout] test signal::tests::unattributed_occurrences_leave_a_signal_ungrouped ... ok
[INFO] [stdout] test signal::tests::the_suite_size_demotion_spares_a_moved_rate_and_a_change_one_example_owns ... ok
[INFO] [stdout] test store::capture::tests::a_file_stream_keeps_its_own_extension ... ok
[INFO] [stdout] test store::ids::tests::ids_parse_with_or_without_prefix ... ok
[INFO] [stdout] test interpret::rspec::tests::crlf_and_overlong_lines_keep_later_lines_in_their_own_example ... ok
[INFO] [stdout] test interpret::cargo::tests::a_failure_with_no_test_behind_it_is_left_alone ... ok
[INFO] [stdout] test signal::rules::tests::frequency_vectors ... ok
[INFO] [stdout] test store::capture::tests::a_capture_recorded_under_the_old_name_is_still_found ... ok
[INFO] [stdout] test aggregate::tests::attributes_occurrences_and_measures_to_scopes ... ok
[INFO] [stdout] test aggregate::tests::distinct_behaviors_are_capped_into_one_overflow_behavior ... ok
[INFO] [stdout] test store::schema::tests::first_occurrence_is_backfilled_from_the_first_exemplar ... ok
[INFO] [stdout] test store::schema::tests::credentials_an_older_siftr_stored_are_redacted_in_place_and_its_captures_removed ... ok
[INFO] [stdout] test store::schema::tests::runs_an_old_build_recorded_as_killed_by_a_signal_leave_baselines ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- interpret::fixtures::a_failure_carries_its_exception_class_scoped_to_the_example stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'interpret::fixtures::a_failure_carries_its_exception_class_scoped_to_the_example' (824) panicked at src/interpret/fixtures.rs:79:49:
[INFO] [stdout] reading /opt/rustwide/workdir/fixtures/rails_demo/fail/rspec.ndjson: No such file or directory (os error 2)
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x651ef016b6b1 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x651ef0181f4a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x651ef017033c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x651ef01450a6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x651ef0162ac9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x651eeff52ab0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x651ef0162c82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x651ef0145152 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x651ef013d5f9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x651ef0145e5d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x651ef01826ac - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x651eeff39b9a - siftr[5e8587948f812f92]::interpret::fixtures::read::{closure#0}
[INFO] [stdout]   12:     0x651eeff3afa4 - siftr[5e8587948f812f92]::interpret::fixtures::read
[INFO] [stdout]   13:     0x651eeff3b477 - siftr[5e8587948f812f92]::interpret::fixtures::capture
[INFO] [stdout]   14:     0x651eeff3e097 - siftr[5e8587948f812f92]::interpret::fixtures::a_failure_carries_its_exception_class_scoped_to_the_example
[INFO] [stdout]   15:     0x651eefecd1c9 - <siftr[5e8587948f812f92]::interpret::fixtures::a_failure_carries_its_exception_class_scoped_to_the_example::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x651eeff45d9b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x651eeff53405 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x651eeff4ccc4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x651eeff56562 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x651ef016a709 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x76273bd7ddfa - <unknown>
[INFO] [stdout]   22:     0x76273be113d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- interpret::fixtures::clean_runs_produce_identical_behaviors_scopes_and_counts stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'interpret::fixtures::clean_runs_produce_identical_behaviors_scopes_and_counts' (825) panicked at src/interpret/fixtures.rs:79:49:
[INFO] [stdout] reading /opt/rustwide/workdir/fixtures/rails_demo/baseline/rspec.ndjson: No such file or directory (os error 2)
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x651ef016b6b1 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x651ef0181f4a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x651ef017033c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x651ef01450a6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x651ef0162ac9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x651eeff52ab0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x651ef0162c82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x651ef0145152 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x651ef013d5f9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x651ef0145e5d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x651ef01826ac - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x651eeff39b9a - siftr[5e8587948f812f92]::interpret::fixtures::read::{closure#0}
[INFO] [stdout]   12:     0x651eeff3afa4 - siftr[5e8587948f812f92]::interpret::fixtures::read
[INFO] [stdout]   13:     0x651eeff3b477 - siftr[5e8587948f812f92]::interpret::fixtures::capture
[INFO] [stdout]   14:     0x651eeff3d22a - siftr[5e8587948f812f92]::interpret::fixtures::clean_runs_produce_identical_behaviors_scopes_and_counts
[INFO] [stdout]   15:     0x651eefecd1a9 - <siftr[5e8587948f812f92]::interpret::fixtures::clean_runs_produce_identical_behaviors_scopes_and_counts::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x651eeff45d9b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x651eeff53405 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x651eeff4ccc4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x651eeff56562 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x651ef016a709 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x76273bd7ddfa - <unknown>
[INFO] [stdout]   22:     0x76273be113d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- interpret::fixtures::n_plus_one_changes_only_the_show_example stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'interpret::fixtures::n_plus_one_changes_only_the_show_example' (827) panicked at src/interpret/fixtures.rs:79:49:
[INFO] [stdout] reading /opt/rustwide/workdir/fixtures/rails_demo/baseline/rspec.ndjson: No such file or directory (os error 2)
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x651ef016b6b1 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x651ef0181f4a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x651ef017033c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x651ef01450a6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x651ef0162ac9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x651eeff52ab0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x651ef0162c82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x651ef0145152 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x651ef013d5f9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x651ef0145e5d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x651ef01826ac - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x651eeff39b9a - siftr[5e8587948f812f92]::interpret::fixtures::read::{closure#0}
[INFO] [stdout]   12:     0x651eeff3afa4 - siftr[5e8587948f812f92]::interpret::fixtures::read
[INFO] [stdout]   13:     0x651eeff3b477 - siftr[5e8587948f812f92]::interpret::fixtures::capture
[INFO] [stdout]   14:     0x651eeff3c15a - siftr[5e8587948f812f92]::interpret::fixtures::n_plus_one_changes_only_the_show_example
[INFO] [stdout]   15:     0x651eefecd169 - <siftr[5e8587948f812f92]::interpret::fixtures::n_plus_one_changes_only_the_show_example::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x651eeff45d9b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x651eeff53405 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x651eeff4ccc4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x651eeff56562 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x651ef016a709 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x76273bd7ddfa - <unknown>
[INFO] [stdout]   22:     0x76273be113d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- interpret::fixtures::listener_offsets_land_on_log_line_starts stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'interpret::fixtures::listener_offsets_land_on_log_line_starts' (826) panicked at src/interpret/fixtures.rs:79:49:
[INFO] [stdout] reading /opt/rustwide/workdir/fixtures/rails_demo/baseline/test.log: No such file or directory (os error 2)
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x651ef016b6b1 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x651ef0181f4a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x651ef017033c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x651ef01450a6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x651ef0162ac9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x651eeff52ab0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x651ef0162c82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x651ef0145152 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x651ef013d5f9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x651ef0145e5d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x651ef01826ac - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x651eeff39b9a - siftr[5e8587948f812f92]::interpret::fixtures::read::{closure#0}
[INFO] [stdout]   12:     0x651eeff3afa4 - siftr[5e8587948f812f92]::interpret::fixtures::read
[INFO] [stdout]   13:     0x651eeff3bb3e - siftr[5e8587948f812f92]::interpret::fixtures::listener_offsets_land_on_log_line_starts
[INFO] [stdout]   14:     0x651eefecd149 - <siftr[5e8587948f812f92]::interpret::fixtures::listener_offsets_land_on_log_line_starts::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   15:     0x651eeff45d9b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   16:     0x651eeff53405 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   17:     0x651eeff4ccc4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   18:     0x651eeff56562 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   19:     0x651ef016a709 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   20:     0x76273bd7ddfa - <unknown>
[INFO] [stdout]   21:     0x76273be113d4 - clone
[INFO] [stdout]   22:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- interpret::fixtures::only_log_lines_before_the_first_example_are_unscoped stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'interpret::fixtures::only_log_lines_before_the_first_example_are_unscoped' (828) panicked at src/interpret/fixtures.rs:79:49:
[INFO] [stdout] reading /opt/rustwide/workdir/fixtures/rails_demo/baseline/rspec.ndjson: No such file or directory (os error 2)
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x651ef016b6b1 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x651ef0181f4a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x651ef017033c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x651ef01450a6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x651ef0162ac9 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x651eeff52ab0 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x651ef0162c82 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x651ef0145152 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x651ef013d5f9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x651ef0145e5d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x651ef01826ac - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x651eeff39b9a - siftr[5e8587948f812f92]::interpret::fixtures::read::{closure#0}
[INFO] [stdout]   12:     0x651eeff3afa4 - siftr[5e8587948f812f92]::interpret::fixtures::read
[INFO] [stdout]   13:     0x651eeff3b477 - siftr[5e8587948f812f92]::interpret::fixtures::capture
[INFO] [stdout]   14:     0x651eeff3cf12 - siftr[5e8587948f812f92]::interpret::fixtures::only_log_lines_before_the_first_example_are_unscoped
[INFO] [stdout]   15:     0x651eefecd189 - <siftr[5e8587948f812f92]::interpret::fixtures::only_log_lines_before_the_first_example_are_unscoped::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   16:     0x651eeff45d9b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   17:     0x651eeff53405 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   18:     0x651eeff4ccc4 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   19:     0x651eeff56562 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   20:     0x651ef016a709 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   21:     0x76273bd7ddfa - <unknown>
[INFO] [stdout]   22:     0x76273be113d4 - clone
[INFO] [stdout]   23:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     interpret::fixtures::a_failure_carries_its_exception_class_scoped_to_the_example
[INFO] [stdout]     interpret::fixtures::clean_runs_produce_identical_behaviors_scopes_and_counts
[INFO] [stdout]     interpret::fixtures::listener_offsets_land_on_log_line_starts
[INFO] [stdout]     interpret::fixtures::n_plus_one_changes_only_the_show_example
[INFO] [stdout]     interpret::fixtures::only_log_lines_before_the_first_example_are_unscoped
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 106 passed; 5 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.70s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "2dbe510a388f176ecb85a362805d250043a151ba0f2f22a48de6291e850917ba", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2dbe510a388f176ecb85a362805d250043a151ba0f2f22a48de6291e850917ba", kill_on_drop: false }`
[INFO] [stdout] 2dbe510a388f176ecb85a362805d250043a151ba0f2f22a48de6291e850917ba
