[INFO] fetching crate tricord 0.1.5...
[INFO] testing tricord-0.1.5 against 1.99.0-beta.8 for beta-1.100-2
[INFO] extracting crate tricord 0.1.5 into /workspace/builds/worker-7-tc1/source
[INFO] removed /workspace/builds/worker-7-tc1/source/.cargo/config.toml
[INFO] removed /workspace/builds/worker-7-tc1/source/rust-toolchain.toml
[INFO] started tweaking crates.io crate tricord 0.1.5
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate tricord 0.1.5
[INFO] tweaked toml for crates.io crate tricord 0.1.5 written to /workspace/builds/worker-7-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate tricord 0.1.5 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 tricord 0.1.5 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]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-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:3111399a4047eeb3a02b7a90e478d715f38a8c6669b5c4b49d30a17385265909" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 5456eebd704c337f1e291527425d4b97c7def719c08c65e1ddf73f8cc3794b2a
[INFO] running `Command { std: "docker" "start" "5456eebd704c337f1e291527425d4b97c7def719c08c65e1ddf73f8cc3794b2a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "5456eebd704c337f1e291527425d4b97c7def719c08c65e1ddf73f8cc3794b2a", 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" "5456eebd704c337f1e291527425d4b97c7def719c08c65e1ddf73f8cc3794b2a" "/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" "5456eebd704c337f1e291527425d4b97c7def719c08c65e1ddf73f8cc3794b2a", 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" "5456eebd704c337f1e291527425d4b97c7def719c08c65e1ddf73f8cc3794b2a" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling linux-raw-sys v0.12.1
[INFO] [stderr]    Compiling aho-corasick v1.1.5
[INFO] [stderr]    Compiling signal-hook v0.4.4
[INFO] [stderr]    Compiling procfs v0.18.0
[INFO] [stderr]    Compiling jiff-core v0.1.0
[INFO] [stderr]    Compiling log v0.4.34
[INFO] [stderr]    Compiling syn v3.0.4
[INFO] [stderr]    Compiling procfs-core v0.18.0
[INFO] [stderr]    Compiling jiff v0.2.35
[INFO] [stderr]    Compiling regex-automata v0.4.18
[INFO] [stderr]    Compiling regex v1.13.1
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling thiserror-impl v2.0.20
[INFO] [stderr]    Compiling clap_derive v4.6.4
[INFO] [stderr]    Compiling terminal_size v0.4.4
[INFO] [stderr]    Compiling env_filter v2.0.0
[INFO] [stderr]    Compiling clap_builder v4.6.6
[INFO] [stderr]    Compiling env_logger v0.11.11
[INFO] [stderr]    Compiling thiserror v2.0.20
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling clap v4.6.6
[INFO] [stderr]    Compiling tricord v0.1.5 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 16.86s
[INFO] running `Command { std: "docker" "inspect" "5456eebd704c337f1e291527425d4b97c7def719c08c65e1ddf73f8cc3794b2a", 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" "5456eebd704c337f1e291527425d4b97c7def719c08c65e1ddf73f8cc3794b2a" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling getrandom v0.4.3
[INFO] [stderr]    Compiling tempfile v3.27.0
[INFO] [stderr]    Compiling tricord v0.1.5 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.89s
[INFO] running `Command { std: "docker" "inspect" "5456eebd704c337f1e291527425d4b97c7def719c08c65e1ddf73f8cc3794b2a", 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" "5456eebd704c337f1e291527425d4b97c7def719c08c65e1ddf73f8cc3794b2a" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.08s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/tricord-ecec9b189bebcbcb)
[INFO] [stdout] 
[INFO] [stdout] running 74 tests
[INFO] [stdout] test cli::tests::snakemake_flag_defaults_to_false ... ok
[INFO] [stdout] test cli::tests::parses_json_pretty_format ... ok
[INFO] [stdout] test format::tests::json_pretty_writer_full_mode_includes_tricord_fields ... ok
[INFO] [stdout] test cli::tests::snakemake_flag_set_to_true ... ok
[INFO] [stdout] test cli::tests::log_level_scales_with_verbosity ... ok
[INFO] [stdout] test cli::tests::trace_defaults_to_none ... ok
[INFO] [stdout] test format::tests::extension_matches_each_format ... ok
[INFO] [stdout] test cli::tests::parses_export_markdown_path ... ok
[INFO] [stdout] test format::tests::json_pretty_writer_emits_trailing_newline ... ok
[INFO] [stdout] test cli::tests::export_markdown_defaults_to_none ... ok
[INFO] [stdout] test cli::tests::parses_json_format_and_summary ... ok
[INFO] [stdout] test cli::tests::parses_trace_path ... ok
[INFO] [stdout] test cli::tests::parses_basic_args ... ok
[INFO] [stdout] test format::tests::json_pretty_writer_strict_mode_omits_tricord_fields ... ok
[INFO] [stdout] test cli::tests::missing_command_fails ... ok
[INFO] [stdout] test cli::tests::interval_respects_user_value ... ok
[INFO] [stdout] test format::tests::json_writer_strict_mode_omits_tricord_fields ... ok
[INFO] [stdout] test format::tests::tsv_writer_full_mode_emits_full_header_and_data_row ... ok
[INFO] [stdout] test format::tests::tsv_writer_strict_mode_emits_snakemake_header ... ok
[INFO] [stdout] test record::tests::hms_minutes_hours ... ok
[INFO] [stdout] test record::tests::hms_seconds ... ok
[INFO] [stdout] test record::tests::json_full_mode_preserves_fields ... ok
[INFO] [stdout] test record::tests::hms_zero ... ok
[INFO] [stdout] test record::tests::json_strict_mode_omits_tricord_added_fields ... ok
[INFO] [stdout] test format::tests::write_markdown_to_path_emits_table_and_creates_parents ... ok
[INFO] [stdout] test record::tests::markdown_full_row_count_tracks_tsv_header_full ... ok
[INFO] [stdout] test record::tests::markdown_strict_mode_drops_tricord_added_rows ... ok
[INFO] [stdout] test record::tests::markdown_missing_optionals_render_as_dash ... ok
[INFO] [stdout] test record::tests::tick_row_full_data ... ok
[INFO] [stdout] test record::tests::tick_row_missing_optionals_render_as_dash ... ok
[INFO] [stdout] test record::tests::trace_header_lists_per_tick_columns_including_page_faults ... ok
[INFO] [stdout] test format::tests::json_writer_emits_no_trailing_newline ... ok
[INFO] [stdout] test format::tests::write_to_path_creates_parent_directories ... ok
[INFO] [stdout] test record::tests::markdown_no_data_uses_na_in_resource_cells ... ok
[INFO] [stdout] test record::tests::header_full_appends_tricord_columns ... ok
[INFO] [stdout] test record::tests::tsv_document_strict_uses_snakemake_header ... ok
[INFO] [stdout] test record::tests::tsv_header_dispatches_on_mode ... ok
[INFO] [stdout] test record::tests::tsv_row_full_mode_appends_all_tricord_columns ... ok
[INFO] [stdout] test format::tests::write_markdown_to_path_strict_omits_page_faults ... ok
[INFO] [stdout] test record::tests::tsv_row_missing_io_renders_dash ... ok
[INFO] [stdout] test record::tests::tsv_row_no_data_strict_has_10_nas ... ok
[INFO] [stdout] test record::tests::tsv_row_strict_mode_omits_tricord_columns ... ok
[INFO] [stdout] test record::tests::tsv_row_no_data_full_has_one_na_per_full_column ... ok
[INFO] [stdout] test record::tests::header_matches_snakemake ... ok
[INFO] [stdout] test record::tests::tsv_row_full_mode_renders_missing_tricord_metrics_as_dash ... ok
[INFO] [stdout] test run::tests::exit_code_signal_uses_128_plus_signum ... ok
[INFO] [stdout] test run::tests::exit_code_normal_exit_passes_through ... ok
[INFO] [stdout] test record::tests::tsv_document_full_uses_full_header ... ok
[INFO] [stdout] test run::tests::validate_output_paths_accepts_all_distinct ... ok
[INFO] [stdout] test record::tests::hms_days_singular_and_plural ... ok
[INFO] [stdout] test run::tests::validate_output_paths_accepts_when_sidecars_absent ... ok
[INFO] [stdout] test run::tests::validate_output_paths_rejects_out_equals_trace ... ok
[INFO] [stdout] test run::tests::validate_output_paths_rejects_out_equals_markdown ... ok
[INFO] [stdout] test record::tests::markdown_full_data_exact_layout ... ok
[INFO] [stdout] test cli::tests::interval_clamps_to_minimum ... ok
[INFO] [stdout] test sampler::tests::empty_state_records_no_data ... ok
[INFO] [stdout] test sampler::tests::io_read_only_leaves_io_out_none ... ok
[INFO] [stdout] test sampler::tests::io_and_cpu_aggregate_across_pids_after_exit ... ok
[INFO] [stdout] test format::tests::json_writer_full_mode_includes_tricord_fields ... ok
[INFO] [stdout] test run::tests::validate_output_paths_rejects_trace_equals_markdown ... ok
[INFO] [stdout] test sampler::tests::io_write_only_leaves_io_in_none ... ok
[INFO] [stdout] test sampler::tests::memory_max_uses_summed_tree ... ok
[INFO] [stdout] test platform::linux::tests::self_pid_produces_a_snapshot ... ok
[INFO] [stdout] test sampler::tests::missing_uss_and_io_remain_none_in_record ... ok
[INFO] [stdout] test sampler::tests::page_faults_aggregate_sums_per_pid_max_across_tree ... ok
[INFO] [stdout] test sampler::tests::single_snapshot_populates_record ... ok
[INFO] [stdout] test sampler::tests::tick_io_and_cpu_include_exited_children ... ok
[INFO] [stdout] test sampler::tests::tick_page_faults_are_per_tick_deltas ... ok
[INFO] [stdout] test sampler::tests::tick_page_faults_none_when_no_process_exposes_them ... ok
[INFO] [stdout] test sampler::tests::tick_page_faults_saturate_on_pid_reuse ... ok
[INFO] [stdout] test sampler::tests::tick_summarizes_live_memory_and_cumulative_io_cpu ... ok
[INFO] [stdout] test signals::tests::forwarder_installs_and_drops_cleanly ... ok
[INFO] [stdout] test sampler::tests::tick_returns_none_for_empty_snapshots ... ok
[INFO] [stdout] test sampler::tests::sampler_thread_writes_trace_file_when_path_set ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 74 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.34s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/tricorder-c5c83c2adf43604c)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/integration.rs (/opt/rustwide/target/debug/deps/integration-09aea614ab715fb5)
[INFO] [stdout] 
[INFO] [stdout] running 36 tests
[INFO] [stdout] test export_markdown_same_path_as_trace_is_rejected ... ok
[INFO] [stdout] test export_markdown_same_path_as_out_is_rejected ... ok
[INFO] [stdout] test json_pretty_output_emits_trailing_newline ... ok
[INFO] [stdout] test nested_output_directory_is_created ... ok
[INFO] [stdout] test exit_code_is_passed_through ... ok
[INFO] [stdout] test export_markdown_is_independent_of_primary_format ... ok
[INFO] [stdout] test instant_exit_yields_na_row ... ok
[INFO] [stdout] test export_markdown_parent_directory_is_created ... ok
[INFO] [stdout] test json_output_emits_no_trailing_newline ... ok
[INFO] [stdout] test loadavg_start_and_end_appear_in_aggregate_tsv ... ok
[INFO] [stdout] test page_cache_start_and_end_appear_in_aggregate_tsv ... ok
[INFO] [stdout] test loadavg_is_not_added_to_trace_columns ... ok
[INFO] [stdout] test export_markdown_and_trace_can_be_combined ... ok
[INFO] [stdout] test page_cache_is_not_added_to_trace_columns ... ok
[INFO] [stdout] test export_markdown_writes_table_alongside_tsv ... ok
[INFO] [stdout] test peak_thread_and_proc_counts_appear_in_aggregate_tsv ... ok
[INFO] [stdout] test snakemake_strict_mode_does_not_affect_trace_columns ... ok
[INFO] [stdout] test context_switches_appear_in_aggregate_tsv ... ok
[INFO] [stdout] test snakemake_strict_mode_strips_ctx_switch_columns ... ok
[INFO] [stdout] test snakemake_strict_mode_strips_page_cache_columns ... ok
[INFO] [stdout] test trace_same_path_as_out_is_rejected ... ok
[INFO] [stdout] test snakemake_strict_mode_strips_loadavg_columns ... ok
[INFO] [stdout] test json_pretty_output_round_trips_to_object ... ok
[INFO] [stdout] test json_output_round_trips_to_object ... ok
[INFO] [stdout] test snakemake_strict_mode_strips_peak_n_columns ... ok
[INFO] [stdout] test snakemake_strict_mode_strips_page_faults_from_json ... ok
[INFO] [stdout] test snakemake_strict_mode_strips_swap_column ... ok
[INFO] [stdout] test page_faults_appear_in_aggregate_tsv ... ok
[INFO] [stdout] test snakemake_strict_mode_strips_page_fault_columns ... ok
[INFO] [stdout] test trace_parent_directory_is_created ... ok
[INFO] [stdout] test snakemake_strict_mode_strips_page_faults_from_markdown ... ok
[INFO] [stdout] test swap_columns_appear_in_aggregate_and_trace ... ok
[INFO] [stdout] test trace_includes_n_threads_per_tick ... ok
[INFO] [stdout] test trace_flag_writes_per_tick_tsv ... ok
[INFO] [stdout] test tsv_output_for_short_lived_command_has_correct_shape ... ok
[INFO] [stdout] test end_to_end_resource_usage_against_known_workload ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 36 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 2.06s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests tricord
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test src/lib.rs - (line 14) - compile ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.43s; merged doctests compilation took 0.41s
[INFO] running `Command { std: "docker" "inspect" "5456eebd704c337f1e291527425d4b97c7def719c08c65e1ddf73f8cc3794b2a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5456eebd704c337f1e291527425d4b97c7def719c08c65e1ddf73f8cc3794b2a", kill_on_drop: false }`
[INFO] [stdout] 5456eebd704c337f1e291527425d4b97c7def719c08c65e1ddf73f8cc3794b2a
