[INFO] fetching crate stallwatch-core 0.2.2...
[INFO] testing stallwatch-core-0.2.2 against 1.99.0-beta.8 for beta-1.100-2
[INFO] extracting crate stallwatch-core 0.2.2 into /workspace/builds/worker-3-tc1/source
[INFO] started tweaking crates.io crate stallwatch-core 0.2.2
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate stallwatch-core 0.2.2
[INFO] tweaked toml for crates.io crate stallwatch-core 0.2.2 written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate stallwatch-core 0.2.2 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 stallwatch-core 0.2.2 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] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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] 2e8e789bc1ce51484d841132da784aa4221151dc6345052a9dd025e418e8cb83
[INFO] running `Command { std: "docker" "start" "2e8e789bc1ce51484d841132da784aa4221151dc6345052a9dd025e418e8cb83", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "2e8e789bc1ce51484d841132da784aa4221151dc6345052a9dd025e418e8cb83", 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" "2e8e789bc1ce51484d841132da784aa4221151dc6345052a9dd025e418e8cb83" "/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" "2e8e789bc1ce51484d841132da784aa4221151dc6345052a9dd025e418e8cb83", 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" "2e8e789bc1ce51484d841132da784aa4221151dc6345052a9dd025e418e8cb83" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling stallwatch-core v0.2.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 2.05s
[INFO] running `Command { std: "docker" "inspect" "2e8e789bc1ce51484d841132da784aa4221151dc6345052a9dd025e418e8cb83", 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" "2e8e789bc1ce51484d841132da784aa4221151dc6345052a9dd025e418e8cb83" "/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 stallwatch-core v0.2.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 3.63s
[INFO] running `Command { std: "docker" "inspect" "2e8e789bc1ce51484d841132da784aa4221151dc6345052a9dd025e418e8cb83", 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" "2e8e789bc1ce51484d841132da784aa4221151dc6345052a9dd025e418e8cb83" "/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.01s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/stallwatch_core-328b6ceaf5528e89)
[INFO] [stdout] 
[INFO] [stdout] running 164 tests
[INFO] [stdout] test appname::tests::empty_input_is_returned_unchanged ... ok
[INFO] [stdout] test attribution::responsibility_tests::agrees_with_reference_on_a_deep_tree ... ok
[INFO] [stdout] test attribution::responsibility_tests::agrees_on_zero_and_single_entries ... ok
[INFO] [stdout] test attribution::responsibility_tests::agrees_when_children_are_diffuse ... ok
[INFO] [stdout] test appname::tests::ignores_names_in_action_sections ... ok
[INFO] [stdout] test appname::tests::reads_the_name_from_the_desktop_entry_section ... ok
[INFO] [stdout] test attribution::tests::parent_keeps_blame_when_children_are_diffuse ... ok
[INFO] [stdout] test attribution::tests::just_under_threshold_keeps_blame ... ok
[INFO] [stdout] test cgroup::tests::names_flatpak_apps ... ok
[INFO] [stdout] test cgroup::tests::names_slices_as_groups_not_units ... ok
[INFO] [stdout] test cgroup::tests::names_plain_services ... ok
[INFO] [stdout] test cgroup::tests::names_user_sessions ... ok
[INFO] [stdout] test cgroup::tests::unescapes_systemd_names ... ok
[INFO] [stdout] test attribution::responsibility_tests::agrees_on_sibling_prefix_traps ... ok
[INFO] [stdout] test config::tests::a_broken_filter_refuses_to_load_rather_than_dropping_the_rule ... ok
[INFO] [stdout] test attribution::sampler_tests::recommended_interval_scales_with_sweep_cost_and_respects_bounds ... ok
[INFO] [stdout] test cgroup::tests::names_the_root_cgroup ... ok
[INFO] [stdout] test config::tests::a_rule_without_when_is_an_error_with_a_line_number ... ok
[INFO] [stdout] test config::tests::capture_settings_load_and_remember_their_source ... ok
[INFO] [stdout] test appname::tests::falls_back_to_the_last_component_of_a_reverse_dns_id ... ok
[INFO] [stdout] test appname::tests::leaves_a_plain_unit_name_alone ... ok
[INFO] [stdout] test config::tests::a_key_outside_any_table_is_an_error_not_a_shrug ... ok
[INFO] [stdout] test config::tests::arrays_and_booleans_parse ... ok
[INFO] [stdout] test config::tests::comments_do_not_eat_a_hash_inside_a_quoted_filter ... ok
[INFO] [stdout] test config::tests::a_rule_matches_using_that_filter ... ok
[INFO] [stdout] test attribution::tests::sibling_prefix_is_not_treated_as_a_child ... ok
[INFO] [stdout] test attribution::tests::zero_delta_is_never_responsible ... ok
[INFO] [stdout] test attribution::tests::exactly_at_dominance_threshold_yields ... ok
[INFO] [stdout] test appname::tests::a_name_before_any_section_header_is_not_used ... ok
[INFO] [stdout] test attribution::tests::parent_yields_to_dominant_child ... ok
[INFO] [stdout] test config::tests::rules_parse_their_filter_with_the_same_grammar_as_the_cli ... ok
[INFO] [stdout] test attribution::sampler_tests::sampler_reports_sweep_cost ... ok
[INFO] [stdout] test doctor::tests::proc_io_is_never_reported_as_healthy ... ok
[INFO] [stdout] test config::tests::escaped_quotes_survive_inside_a_basic_string ... ok
[INFO] [stdout] test config::tests::expand_substitutes_from_the_matching_stall ... ok
[INFO] [stdout] test doctor::tests::json_is_wellformed_and_complete ... ok
[INFO] [stdout] test config::tests::explain_names_the_layer_that_won ... ok
[INFO] [stdout] test doctor::tests::every_check_that_is_not_ok_explains_what_breaks ... ok
[INFO] [stdout] test config::tests::unknown_tables_are_rejected_rather_than_silently_ignored ... ok
[INFO] [stdout] test config::tests::garbage_never_panics ... ok
[INFO] [stdout] test doctor::tests::wrapping_never_loses_a_word ... ok
[INFO] [stdout] test filter::tests::a_single_equals_is_accepted_because_everyone_types_it ... ok
[INFO] [stdout] test filter::tests::boolean_operators_and_precedence ... ok
[INFO] [stdout] test filter::tests::compares_text_case_insensitively ... ok
[INFO] [stdout] test filter::tests::match_operator_supports_alternation ... ok
[INFO] [stdout] test filter::tests::round_trips_its_own_source_for_display ... ok
[INFO] [stdout] test filter::tests::unknown_fields_never_match_and_never_error ... ok
[INFO] [stdout] test filter::tests::warnings_expose_their_own_fields ... ok
[INFO] [stdout] test filter::tests::unit_suffixes_scale_the_number ... ok
[INFO] [stdout] test incident::tests::durations_switch_units_where_a_person_would ... ok
[INFO] [stdout] test incident::tests::explain_says_kernel_side_when_no_process_was_moving_data ... ok
[INFO] [stdout] test incident::tests::role_separates_the_cause_from_the_casualty ... ok
[INFO] [stdout] test attribution::responsibility_tests::agrees_with_gaps_in_the_hierarchy ... ok
[INFO] [stdout] test incident::tests::jsonl_is_one_line_and_parses ... ok
[INFO] [stdout] test incident::tests::explain_names_the_cause_and_absolves_the_victim ... ok
[INFO] [stdout] test filter::tests::compares_numbers ... ok
[INFO] [stdout] test incident::tests::relative_time_reads_like_a_person_wrote_it ... ok
[INFO] [stdout] test filter::tests::errors_report_where_the_problem_is ... ok
[INFO] [stdout] test incident::tests::explain_survives_having_nothing_to_say ... ok
[INFO] [stdout] test iostat::tests::parses_a_real_line ... ok
[INFO] [stdout] test doctor::tests::text_output_names_every_check ... ok
[INFO] [stdout] test filter::tests::garbage_never_panics ... ok
[INFO] [stdout] test incident::tests::transient_warnings_reassure_rather_than_alarm ... ok
[INFO] [stdout] test filter::tests::parentheses_override_precedence ... ok
[INFO] [stdout] test iostat::tests::delta_saturates_when_a_cgroup_path_is_reused ... ok
[INFO] [stdout] test iostat::tests::sums_across_devices ... ok
[INFO] [stdout] test iostat::tests::an_empty_file_is_zero_not_an_error ... ok
[INFO] [stdout] test iostat::tests::delta_is_the_difference ... ok
[INFO] [stdout] test iostat::tests::discard_is_excluded_from_total ... ok
[INFO] [stdout] test iostat::tests::unknown_fields_are_ignored_so_a_newer_kernel_still_parses ... ok
[INFO] [stdout] test ipc::tests::parses_verbs_case_insensitively ... ok
[INFO] [stdout] test json::tests::handles_empty_and_nested_structures ... ok
[INFO] [stdout] test ipc::tests::rejects_malformed_input_instead_of_guessing ... ok
[INFO] [stdout] test ipc::tests::format_token_is_optional_and_defaults_to_json ... ok
[INFO] [stdout] test ipc::tests::socket_path_is_under_xdg_runtime_dir_when_set ... ok
[INFO] [stdout] test json::tests::deeply_nested_input_does_not_crash ... ok
[INFO] [stdout] test json::tests::handles_escapes_and_unicode ... ok
[INFO] [stdout] test metrics::tests::escapes_label_values ... ok
[INFO] [stdout] test logfile::tests::the_previous_generation_is_kept_not_deleted ... ok
[INFO] [stdout] test logfile::tests::only_one_old_generation_is_ever_retained ... ok
[INFO] [stdout] test notify::tests::a_brief_stall_never_reaches_the_threshold ... ok
[INFO] [stdout] test logfile::tests::a_zero_cap_disables_rotation ... ok
[INFO] [stdout] test logfile::tests::missing_parent_directories_are_created ... ok
[INFO] [stdout] test notify::tests::a_chronic_condition_is_described_as_chronic ... ok
[INFO] [stdout] test notify::tests::a_disabled_notifier_stays_quiet ... ok
[INFO] [stdout] test notify::tests::a_process_level_culprit_still_counts_as_actionable ... ok
[INFO] [stdout] test json::tests::negative_and_float_numbers_do_not_become_u64 ... ok
[INFO] [stdout] test json::tests::parses_a_varlink_request ... ok
[INFO] [stdout] test notify::tests::a_transient_alongside_a_real_cause_still_speaks ... ok
[INFO] [stdout] test json::tests::rejects_malformed_input_rather_than_guessing ... ok
[INFO] [stdout] test notify::tests::an_empty_incident_says_nothing ... ok
[INFO] [stdout] test notify::tests::an_episode_speaks_once ... ok
[INFO] [stdout] test notify::tests::no_message_ever_reports_the_capture_window_as_a_freeze_duration ... ok
[INFO] [stdout] test notify::tests::one_capture_says_nothing ... ok
[INFO] [stdout] test notify::tests::an_unactionable_transient_is_never_announced ... ok
[INFO] [stdout] test notify::tests::the_cooldown_eventually_expires ... ok
[INFO] [stdout] test metrics::tests::each_metric_family_is_contiguous ... ok
[INFO] [stdout] test notify::tests::the_message_names_the_cause_not_the_casualty ... ok
[INFO] [stdout] test pathology::btrfs::tests::check_is_infallible_regardless_of_host_filesystem ... ok
[INFO] [stdout] test metrics::tests::every_metric_has_help_and_type ... ok
[INFO] [stdout] test metrics::tests::cardinality_cap_is_enforced_and_reported ... ok
[INFO] [stdout] test pathology::thermal::tests::at_or_over_limit_escalates_but_still_defers_to_the_counters ... ok
[INFO] [stdout] test metrics::tests::cpu_has_no_stalled_series ... ok
[INFO] [stdout] test metrics::tests::output_is_wellformed_exposition ... ok
[INFO] [stdout] test pathology::thermal::tests::comfortably_under_limit_is_silent ... ok
[INFO] [stdout] test pathology::btrfs::tests::discard_warning_respects_the_floor ... ok
[INFO] [stdout] test pathology::tests::severity_renders_for_the_wire ... ok
[INFO] [stdout] test metrics::tests::output_is_deterministically_ordered ... ok
[INFO] [stdout] test pathology::btrfs::tests::read_u64_rejects_garbage ... ok
[INFO] [stdout] test pathology::tests::scan_never_panics_on_this_machine ... ok
[INFO] [stdout] test pathology::thermal::tests::within_margin_reports_without_claiming_causation ... ok
[INFO] [stdout] test process::tests::blocked_pct_handles_zero_samples ... ok
[INFO] [stdout] test process::tests::comm_containing_spaces_and_parens_does_not_break_parsing ... ok
[INFO] [stdout] test process::tests::parses_state_and_ticks_from_real_format ... ok
[INFO] [stdout] test process::tests::delayacct_probe_does_not_panic ... ok
[INFO] [stdout] test process::tests::the_biggest_mover_survives_truncation_alongside_the_worst_blocked ... ok
[INFO] [stdout] test psi::tests::cpu_uses_some_because_full_cannot_exist_for_it ... ok
[INFO] [stdout] test pathology::thermal::tests::sensors_without_a_published_limit_are_never_warned_on ... ok
[INFO] [stdout] test process::tests::pids_in_deduplicates ... ok
[INFO] [stdout] test process::tests::truncated_stat_yields_no_ticks_rather_than_panicking ... ok
[INFO] [stdout] test pathology::thermal::tests::check_is_infallible_regardless_of_host_hardware ... ok
[INFO] [stdout] test psi::tests::display_matches_wire_vocabulary ... ok
[INFO] [stdout] test process::tests::drill_on_a_nonexistent_cgroup_is_empty_not_a_panic ... ok
[INFO] [stdout] test notify::tests::stall_outside_the_window_does_not_accumulate ... ok
[INFO] [stdout] test psi::tests::tolerates_missing_full_line ... ok
[INFO] [stdout] test ring::tests::aggregate_sums_usec_across_frames ... ok
[INFO] [stdout] test ring::tests::evicts_oldest_beyond_capacity ... ok
[INFO] [stdout] test ring::tests::empty_window_yields_empty_report ... ok
[INFO] [stdout] test psi::tests::tolerates_garbage_without_panicking ... ok
[INFO] [stdout] test psi::tests::parses_both_lines ... ok
[INFO] [stdout] test ring::tests::peak_survives_averaging ... ok
[INFO] [stdout] test ring::tests::same_unit_different_resources_stay_separate ... ok
[INFO] [stdout] test tests::a_trickle_is_never_a_cause ... ok
[INFO] [stdout] test ring::tests::ranks_by_peak_not_average ... ok
[INFO] [stdout] test tests::classify_needs_real_bytes_and_an_unblocked_mover ... ok
[INFO] [stdout] test logfile::tests::rotation_bounds_the_total_size ... ok
[INFO] [stdout] test tests::causes_reach_both_json_renderers ... ok
[INFO] [stdout] test tests::json_escapes_systemd_backslash_encoding ... ok
[INFO] [stdout] test tests::report_json_includes_stall_fields ... ok
[INFO] [stdout] test tests::the_headline_names_the_biggest_mover_even_when_it_is_contended ... ok
[INFO] [stdout] test ring::tests::capacity_is_never_zero ... ok
[INFO] [stdout] test trigger::tests::a_short_timeout_returns_quiet_rather_than_blocking ... ok
[INFO] [stdout] test ring::tests::since_filters_older_frames ... ok
[INFO] [stdout] test tests::bytes_phrase_reads_like_a_person ... ok
[INFO] [stdout] test trigger::tests::windows_round_up_to_the_unprivileged_granularity ... ok
[INFO] [stdout] test ring::tests::noise_is_filtered_on_peak_not_average ... ok
[INFO] [stdout] test varlink::tests::errors_are_wellformed_varlink ... ok
[INFO] [stdout] test tests::root_never_takes_the_headline_but_is_reported_as_context ... ok
[INFO] [stdout] test trigger::tests::windows_stay_inside_what_the_kernel_accepts ... ok
[INFO] [stdout] test tests::the_root_cgroup_is_never_nameable ... ok
[INFO] [stdout] test varlink::tests::get_stalls_defaults_and_clamps ... ok
[INFO] [stdout] test trigger::tests::registers_unprivileged_against_the_real_kernel ... ok
[INFO] [stdout] test trigger::tests::threshold_can_never_exceed_the_window ... ok
[INFO] [stdout] test varlink::tests::info_and_description_replies_are_valid_json ... ok
[INFO] [stdout] test varlink::tests::get_history_requires_seconds ... ok
[INFO] [stdout] test tests::empty_report_is_valid_json_shape ... ok
[INFO] [stdout] test varlink::tests::distinguishes_unknown_method_from_unknown_interface ... ok
[INFO] [stdout] test varlink::tests::parses_mandatory_service_methods ... ok
[INFO] [stdout] test varlink::tests::rejects_garbage_without_panicking ... ok
[INFO] [stdout] test process::tests::pids_in_descends_into_child_cgroups ... FAILED
[INFO] [stdout] test notify::tests::a_storm_produces_one_notice_not_hundreds ... ok
[INFO] [stdout] test attribution::sampler_tests::sampler_produces_a_measured_window ... ok
[INFO] [stdout] test attribution::sampler_tests::consecutive_ticks_do_not_double_count ... ok
[INFO] [stdout] test attribution::responsibility_tests::scales_without_quadratic_blowup ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- process::tests::pids_in_descends_into_child_cgroups stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'process::tests::pids_in_descends_into_child_cgroups' (403) panicked at src/process.rs:373:13:
[INFO] [stdout] recursive 3 should exceed direct 3
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x640332a3a411 - std[70759c8f55707aa4]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x640332a3a411 - std[70759c8f55707aa4]::backtrace_rs::backtrace::trace_unsynchronized::<std[70759c8f55707aa4]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x640332a3a411 - std[70759c8f55707aa4]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x640332a3a411 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x640332a503fa - <core[df12db4294e9bfd3]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x640332a503fa - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    6:     0x640332a3ec8c - core[df12db4294e9bfd3]::io::write::default_write_fmt::<alloc[2182bb758b4b3781]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/io/write.rs:402:11
[INFO] [stdout]    7:     0x640332a3ec8c - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/io/write.rs:335:13
[INFO] [stdout]    8:     0x640332a14076 - <std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x640332a14076 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x640332a31869 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x6403329cbe30 - <alloc[2182bb758b4b3781]::boxed::Box<dyn for<'a, 'b> core[df12db4294e9bfd3]::ops::function::Fn<(&'a std[70759c8f55707aa4]::panic::PanicHookInfo<'b>,), Output = ()> + core[df12db4294e9bfd3]::marker::Send + core[df12db4294e9bfd3]::marker::Sync> as core[df12db4294e9bfd3]::ops::function::Fn<(&std[70759c8f55707aa4]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/alloc/src/boxed.rs:2334:9
[INFO] [stdout]   12:     0x6403329cbe30 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x640332a31a22 - <alloc[2182bb758b4b3781]::boxed::Box<dyn for<'a, 'b> core[df12db4294e9bfd3]::ops::function::Fn<(&'a std[70759c8f55707aa4]::panic::PanicHookInfo<'b>,), Output = ()> + core[df12db4294e9bfd3]::marker::Send + core[df12db4294e9bfd3]::marker::Sync> as core[df12db4294e9bfd3]::ops::function::Fn<(&std[70759c8f55707aa4]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/alloc/src/boxed.rs:2334:9
[INFO] [stdout]   14:     0x640332a31a22 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:823:13
[INFO] [stdout]   15:     0x640332a14122 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:688:13
[INFO] [stdout]   16:     0x640332a0caf9 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x640332a14e0d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:679:5
[INFO] [stdout]   18:     0x640332a50bec - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x64033292d1d7 - stallwatch_core[fcc82a4c22e5d941]::process::tests::pids_in_descends_into_child_cgroups
[INFO] [stdout]                                at /opt/rustwide/workdir/src/process.rs:373:13
[INFO] [stdout]   20:     0x640332922cc7 - stallwatch_core[fcc82a4c22e5d941]::process::tests::pids_in_descends_into_child_cgroups::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/src/process.rs:362:45
[INFO] [stdout]   21:     0x640332908486 - <stallwatch_core[fcc82a4c22e5d941]::process::tests::pids_in_descends_into_child_cgroups::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   22:     0x6403329bf11b - <fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String> as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x6403329bf11b - 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]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/test/src/lib.rs:733:18
[INFO] [stdout]   24:     0x6403329cc785 - test[9d35eded1c95d3be]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/test/src/lib.rs:756:74
[INFO] [stdout]   25:     0x6403329cc785 - <core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<test[9d35eded1c95d3be]::run_test_in_process::{closure#0}> as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   26:     0x6403329cc785 - std[70759c8f55707aa4]::panicking::catch_unwind::do_call::<core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<test[9d35eded1c95d3be]::run_test_in_process::{closure#0}>, core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:576:43
[INFO] [stdout]   27:     0x6403329cc785 - std[70759c8f55707aa4]::panicking::catch_unwind::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<test[9d35eded1c95d3be]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:544:19
[INFO] [stdout]   28:     0x6403329cc785 - std[70759c8f55707aa4]::panic::catch_unwind::<core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<test[9d35eded1c95d3be]::run_test_in_process::{closure#0}>, core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panic.rs:359:14
[INFO] [stdout]   29:     0x6403329cc785 - test[9d35eded1c95d3be]::run_test_in_process
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/test/src/lib.rs:756:27
[INFO] [stdout]   30:     0x6403329cc785 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/test/src/lib.rs:677:43
[INFO] [stdout]   31:     0x6403329c6044 - test[9d35eded1c95d3be]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/test/src/lib.rs:707:41
[INFO] [stdout]   32:     0x6403329c6044 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   33:     0x6403329cf8e2 - std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   34:     0x6403329cf8e2 - <core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   35:     0x6403329cf8e2 - std[70759c8f55707aa4]::panicking::catch_unwind::do_call::<core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:576:43
[INFO] [stdout]   36:     0x6403329cf8e2 - std[70759c8f55707aa4]::panicking::catch_unwind::<(), core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panicking.rs:544:19
[INFO] [stdout]   37:     0x6403329cf8e2 - std[70759c8f55707aa4]::panic::catch_unwind::<core[df12db4294e9bfd3]::panic::unwind_safe::AssertUnwindSafe<std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/panic.rs:359:14
[INFO] [stdout]   38:     0x6403329cf8e2 - std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   39:     0x6403329cf8e2 - <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]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   40:     0x640332a39789 - <alloc[2182bb758b4b3781]::boxed::Box<dyn core[df12db4294e9bfd3]::ops::function::FnOnce<(), Output = ()> + core[df12db4294e9bfd3]::marker::Send> as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/alloc/src/boxed.rs:2320:9
[INFO] [stdout]   41:     0x640332a39789 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/dfb0accb7f508ae8be965d8629557221c889dd98/library/std/src/sys/thread/unix.rs:123:17
[INFO] [stdout]   42:     0x73f3a3f70dfa - <unknown>
[INFO] [stdout]   43:     0x73f3a40043d4 - clone
[INFO] [stdout]   44:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     process::tests::pids_in_descends_into_child_cgroups
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 163 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.16s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "2e8e789bc1ce51484d841132da784aa4221151dc6345052a9dd025e418e8cb83", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2e8e789bc1ce51484d841132da784aa4221151dc6345052a9dd025e418e8cb83", kill_on_drop: false }`
[INFO] [stdout] 2e8e789bc1ce51484d841132da784aa4221151dc6345052a9dd025e418e8cb83
