[INFO] fetching crate yash-env 0.8.1...
[INFO] testing yash-env-0.8.1 against master#caccb4d0368bd918ef6668af8e13834d07040417 for pr-146098-1
[INFO] extracting crate yash-env 0.8.1 into /workspace/builds/worker-6-tc1/source
[INFO] started tweaking crates.io crate yash-env 0.8.1
[INFO] finished tweaking crates.io crate yash-env 0.8.1
[INFO] tweaked toml for crates.io crate yash-env 0.8.1 written to /workspace/builds/worker-6-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate yash-env 0.8.1 on toolchain caccb4d0368bd918ef6668af8e13834d07040417
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate yash-env 0.8.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" "+caccb4d0368bd918ef6668af8e13834d07040417" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded unix_str v1.0.0
[INFO] [stderr]   Downloaded tempfile v3.22.0
[INFO] [stderr]   Downloaded yash-executor v1.0.0
[INFO] [stderr]   Downloaded unix_path v1.0.1
[INFO] [stderr]   Downloaded yash-quote v1.1.1
[INFO] [stderr]   Downloaded yash-syntax v0.15.2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] ea07904644bba1cf54bf0d919b22cc25c48e6b70aed6884423ff6ac28bfc85b3
[INFO] running `Command { std: "docker" "start" "-a" "ea07904644bba1cf54bf0d919b22cc25c48e6b70aed6884423ff6ac28bfc85b3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "ea07904644bba1cf54bf0d919b22cc25c48e6b70aed6884423ff6ac28bfc85b3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ea07904644bba1cf54bf0d919b22cc25c48e6b70aed6884423ff6ac28bfc85b3", kill_on_drop: false }`
[INFO] [stdout] ea07904644bba1cf54bf0d919b22cc25c48e6b70aed6884423ff6ac28bfc85b3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 531a1c4a9b6ea67ebfae358eceb80261800d43e7dbd7051ea8703ba472b453dc
[INFO] running `Command { std: "docker" "start" "-a" "531a1c4a9b6ea67ebfae358eceb80261800d43e7dbd7051ea8703ba472b453dc", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.175
[INFO] [stderr]    Compiling quote v1.0.40
[INFO] [stderr]    Compiling itertools v0.14.0
[INFO] [stderr]    Compiling annotate-snippets v0.11.5
[INFO] [stderr]    Compiling unix_str v1.0.0
[INFO] [stderr]    Compiling dyn-clone v1.0.20
[INFO] [stderr]    Compiling yash-executor v1.0.0
[INFO] [stderr]    Compiling yash-quote v1.1.1
[INFO] [stderr]    Compiling unix_path v1.0.1
[INFO] [stderr]    Compiling syn v2.0.106
[INFO] [stderr]    Compiling getrandom v0.3.3
[INFO] [stderr]    Compiling errno v0.3.14
[INFO] [stderr]    Compiling tempfile v3.22.0
[INFO] [stderr]    Compiling darling_core v0.21.3
[INFO] [stderr]    Compiling thiserror-impl v2.0.16
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling strum_macros v0.27.2
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling thiserror v2.0.16
[INFO] [stderr]    Compiling strum v0.27.2
[INFO] [stderr]    Compiling darling_macro v0.21.3
[INFO] [stderr]    Compiling darling v0.21.3
[INFO] [stderr]    Compiling enumset_derive v0.14.0
[INFO] [stderr]    Compiling yash-syntax v0.15.2
[INFO] [stderr]    Compiling enumset v1.1.10
[INFO] [stderr]    Compiling yash-env v0.8.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 7.05s
[INFO] running `Command { std: "docker" "inspect" "531a1c4a9b6ea67ebfae358eceb80261800d43e7dbd7051ea8703ba472b453dc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "531a1c4a9b6ea67ebfae358eceb80261800d43e7dbd7051ea8703ba472b453dc", kill_on_drop: false }`
[INFO] [stdout] 531a1c4a9b6ea67ebfae358eceb80261800d43e7dbd7051ea8703ba472b453dc
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 1971a83d137f229e59cbfc6e617e08e1fa0cf2be931015d3285ea3be7ff6e126
[INFO] running `Command { std: "docker" "start" "-a" "1971a83d137f229e59cbfc6e617e08e1fa0cf2be931015d3285ea3be7ff6e126", kill_on_drop: false }`
[INFO] [stderr]    Compiling futures-channel v0.3.31
[INFO] [stderr]    Compiling assert_matches v1.5.0
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling yash-syntax v0.15.2
[INFO] [stderr]    Compiling futures-executor v0.3.31
[INFO] [stderr]    Compiling yash-env v0.8.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 6.53s
[INFO] running `Command { std: "docker" "inspect" "1971a83d137f229e59cbfc6e617e08e1fa0cf2be931015d3285ea3be7ff6e126", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1971a83d137f229e59cbfc6e617e08e1fa0cf2be931015d3285ea3be7ff6e126", kill_on_drop: false }`
[INFO] [stdout] 1971a83d137f229e59cbfc6e617e08e1fa0cf2be931015d3285ea3be7ff6e126
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+caccb4d0368bd918ef6668af8e13834d07040417" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 3f0a59a0eeb6fb8c215c51c7c725abd2106c49544a708491e33335c221712125
[INFO] running `Command { std: "docker" "start" "-a" "3f0a59a0eeb6fb8c215c51c7c725abd2106c49544a708491e33335c221712125", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/yash_env-7ddd8baaf06c3c2f)
[INFO] [stdout] 
[INFO] [stdout] running 420 tests
[INFO] [stdout] test any::tests::clone ... ok
[INFO] [stdout] test any::tests::get_mut ... ok
[INFO] [stdout] test any::tests::insert_again ... ok
[INFO] [stdout] test any::tests::get_or_insert_with ... ok
[INFO] [stdout] test any::tests::remove_existing ... ok
[INFO] [stdout] test any::tests::insert_and_get ... ok
[INFO] [stdout] test any::tests::remove_nonexisting ... ok
[INFO] [stdout] test function::tests::unsetting_nonexisting_function ... ok
[INFO] [stdout] test function::tests::defining_new_function ... ok
[INFO] [stdout] test function::tests::iteration ... ok
[INFO] [stdout] test function::tests::unsetting_existing_function ... ok
[INFO] [stdout] test function::tests::redefining_existing_function ... ok
[INFO] [stdout] test input::echo::tests::verbose_off ... ok
[INFO] [stdout] test function::tests::redefining_readonly_function ... ok
[INFO] [stdout] test function::tests::unsetting_readonly_function ... ok
[INFO] [stdout] test input::echo::tests::verbose_on ... ok
[INFO] [stdout] test input::fd_reader::tests::reader_with_many_lines ... ok
[INFO] [stdout] test input::fd_reader::tests::echo_on ... ok
[INFO] [stdout] test input::fd_reader::tests::one_line_reader ... ok
[INFO] [stdout] test input::ignore_eof::tests::decorator_reads_input_up_to_50_times ... ok
[INFO] [stdout] test input::ignore_eof::tests::decorator_returns_empty_line_after_reading_51_times ... ok
[INFO] [stdout] test input::fd_reader::tests::reading_from_file ... ok
[INFO] [stdout] test input::fd_reader::tests::echo_off ... ok
[INFO] [stdout] test input::reporter::tests::all_jobs_with_changed_status_are_reported ... ok
[INFO] [stdout] test input::reporter::tests::no_report_if_not_interactive ... ok
[INFO] [stdout] test input::fd_reader::tests::reader_error ... ok
[INFO] [stdout] test input::ignore_eof::tests::decorator_reads_from_inner_input ... ok
[INFO] [stdout] test input::fd_reader::tests::empty_reader ... ok
[INFO] [stdout] test input::reporter::tests::no_report_if_not_monitor ... ok
[INFO] [stdout] test input::ignore_eof::tests::decorator_returns_immediately_if_not_ignore_eof ... ok
[INFO] [stdout] test input::reporter::tests::reporter_clears_state_changed_flag ... ok
[INFO] [stdout] test job::fmt::tests::report_display ... ok
[INFO] [stdout] test input::reporter::tests::reporter_shows_job_status_before_reading_input ... ok
[INFO] [stdout] test job::fmt::tests::state_display ... ok
[INFO] [stdout] test job::id::tests::find_ambiguous_prefix ... ok
[INFO] [stdout] test job::id::tests::find_ambiguous_substring ... ok
[INFO] [stdout] test job::id::tests::find_no_current_job ... ok
[INFO] [stdout] test job::id::tests::find_no_job_for_job_number ... ok
[INFO] [stdout] test input::ignore_eof::tests::decorator_returns_immediately_if_not_terminal ... ok
[INFO] [stdout] test input::reporter::tests::reporter_reads_from_inner_input ... ok
[INFO] [stdout] test job::id::tests::find_unique_current_job ... ok
[INFO] [stdout] test job::id::tests::find_no_job_for_prefix ... ok
[INFO] [stdout] test input::ignore_eof::tests::decorator_reads_input_again_on_eof ... ok
[INFO] [stdout] test job::id::tests::find_unique_job_by_job_number ... ok
[INFO] [stdout] test job::id::tests::find_unique_job_by_name_prefix ... ok
[INFO] [stdout] test job::id::tests::find_unique_job_by_name_substring ... ok
[INFO] [stdout] test job::id::tests::find_no_previous_job ... ok
[INFO] [stdout] test input::ignore_eof::tests::decorator_returns_immediately_if_not_interactive ... ok
[INFO] [stdout] test job::id::tests::find_no_job_for_substring ... ok
[INFO] [stdout] test job::tests::adding_suspended_job_with_running_current_and_previous_job ... ok
[INFO] [stdout] test job::id::tests::find_unique_previous_job ... ok
[INFO] [stdout] test job::id::tests::job_id_display ... ok
[INFO] [stdout] test job::tests::disowning_jobs ... ok
[INFO] [stdout] test job::tests::adding_suspended_job_with_suspended_current_and_running_previous_job ... ok
[INFO] [stdout] test job::tests::job_list_add_and_remove ... ok
[INFO] [stdout] test job::tests::current_and_previous_job_in_job_list_with_two_job ... ok
[INFO] [stdout] test job::tests::current_and_previous_job_in_job_list_with_one_job ... ok
[INFO] [stdout] test job::tests::job_list_extract_if ... ok
[INFO] [stdout] test job::tests::job_list_find_by_pid ... ok
[INFO] [stdout] test job::tests::no_current_and_previous_job_in_empty_job_list ... ok
[INFO] [stdout] test job::tests::job_list_add_same_pid ... ok
[INFO] [stdout] test job::tests::removing_current_job ... ok
[INFO] [stdout] test job::tests::removing_previous_job_with_running_job ... ok
[INFO] [stdout] test job::tests::removing_previous_job_with_suspended_job ... ok
[INFO] [stdout] test job::tests::resuming_current_job_with_another_suspended_job ... ok
[INFO] [stdout] test job::tests::resuming_current_job_with_other_suspended_jobs ... ok
[INFO] [stdout] test job::tests::resuming_current_job_without_other_suspended_jobs ... ok
[INFO] [stdout] test job::tests::resuming_previous_job ... ok
[INFO] [stdout] test job::tests::set_current_job_no_change ... ok
[INFO] [stdout] test job::tests::resuming_other_job ... ok
[INFO] [stdout] test job::tests::set_current_job_no_such_job ... ok
[INFO] [stdout] test job::tests::set_current_job_not_suspended ... ok
[INFO] [stdout] test job::tests::set_current_job_to_suspended_job ... ok
[INFO] [stdout] test job::tests::suspending_job_with_running_current_job ... ok
[INFO] [stdout] test job::tests::suspending_current_job ... ok
[INFO] [stdout] test job::tests::suspending_job_with_running_previous_job ... ok
[INFO] [stdout] test job::tests::suspending_previous_job ... ok
[INFO] [stdout] test job::tests::updating_job_status_without_expected_state ... ok
[INFO] [stdout] test option::tests::display_and_from_str_round_trip ... ok
[INFO] [stdout] test job::tests::updating_job_status_with_matching_expected_state ... ok
[INFO] [stdout] test option::tests::display_and_parse_negated_round_trip ... ok
[INFO] [stdout] test job::tests::set_current_job_with_running_jobs_only ... ok
[INFO] [stdout] test option::tests::from_str_no_match ... ok
[INFO] [stdout] test job::tests::updating_job_status_with_unmatched_expected_state ... ok
[INFO] [stdout] test option::tests::from_str_unambiguous_abbreviation ... ok
[INFO] [stdout] test option::tests::parse_ambiguous_abbreviation ... ok
[INFO] [stdout] test option::tests::display_and_parse_round_trip ... ok
[INFO] [stdout] test option::tests::parse_no_match ... ok
[INFO] [stdout] test option::tests::parse_unambiguous_abbreviation ... ok
[INFO] [stdout] test option::tests::short_name_round_trip ... ok
[INFO] [stdout] test option::tests::from_str_ambiguous_abbreviation ... ok
[INFO] [stdout] test option::tests::test_canonicalize ... ok
[INFO] [stdout] test pwd::tests::has_dot_or_dot_dot_cases ... ok
[INFO] [stdout] test pwd::tests::prepare_pwd_no_value ... ok
[INFO] [stdout] test pwd::tests::prepare_pwd_with_dot_dot ... ok
[INFO] [stdout] test pwd::tests::prepare_pwd_with_correct_path ... ok
[INFO] [stdout] test pwd::tests::prepare_pwd_with_dot ... ok
[INFO] [stdout] test signal::test_name_from_str ... ok
[INFO] [stdout] test signal::test_name_to_string ... ok
[INFO] [stdout] test pwd::tests::prepare_pwd_with_wrong_path ... ok
[INFO] [stdout] test stack::tests::current_builtin ... ok
[INFO] [stdout] test stack::tests::loop_count_empty ... ok
[INFO] [stdout] test semantics::tests::exit_status_to_signal ... ok
[INFO] [stdout] test stack::tests::loop_count_with_builtins ... ok
[INFO] [stdout] test stack::tests::loop_count_with_conditions ... ok
[INFO] [stdout] test pwd::tests::prepare_pwd_with_non_absolute_path ... ok
[INFO] [stdout] test stack::tests::loop_count_with_small_max_count ... ok
[INFO] [stdout] test stack::tests::loop_count_with_subshells ... ok
[INFO] [stdout] test stack::tests::loop_count_with_traps ... ok
[INFO] [stdout] test stack::tests::loop_count_with_two_loops ... ok
[INFO] [stdout] test stack::tests::loop_count_with_dot_scripts ... ok
[INFO] [stdout] test stack::tests::loop_count_with_non_loop_frames ... ok
[INFO] [stdout] test subshell::tests::internal_dispositions_for_stoppers_kept_in_uncontrolled_subshell_of_controlling_interactive_shell ... ok
[INFO] [stdout] test subshell::tests::internal_dispositions_for_stoppers_unset_in_subshell_of_non_controlling_interactive_shell ... ok
[INFO] [stdout] test subshell::tests::internal_dispositions_for_stoppers_reset_in_controlled_subshell_of_interactive_shell ... ok
[INFO] [stdout] test subshell::tests::internal_dispositions_for_stoppers_unset_in_uncontrolled_subshell_of_controlling_non_interactive_shell ... ok
[INFO] [stdout] test stack::tests::loop_count_with_one_loop ... ok
[INFO] [stdout] test subshell::tests::job_control_without_tty ... ok
[INFO] [stdout] test subshell::tests::no_job_control_with_option_disabled ... ok
[INFO] [stdout] test subshell::tests::sigint_sigquit_not_ignored_by_default ... ok
[INFO] [stdout] test subshell::tests::jobs_disowned_in_subshell ... ok
[INFO] [stdout] test subshell::tests::sigint_sigquit_ignored_in_uncontrolled_job ... ok
[INFO] [stdout] test subshell::tests::subshell_start_failing ... ok
[INFO] [stdout] test subshell::tests::stack_frame_in_subshell ... ok
[INFO] [stdout] test subshell::tests::sigint_sigquit_not_ignored_if_job_controlled ... ok
[INFO] [stdout] test subshell::tests::no_job_control_for_nested_subshell ... ok
[INFO] [stdout] test subshell::tests::subshell_in_background ... ok
[INFO] [stdout] test subshell::tests::subshell_start_returns_child_process_id ... ok
[INFO] [stdout] test subshell::tests::subshell_with_no_job_control ... ok
[INFO] [stdout] test system::r#virtual::file_system::tests::empty_virtual_dir ... ok
[INFO] [stdout] test system::r#virtual::file_system::tests::file_system_get_no_search_permission ... ok
[INFO] [stdout] test system::r#virtual::file_system::tests::file_system_get_non_existent_file ... ok
[INFO] [stdout] test subshell::tests::trap_reset_in_subshell ... ok
[INFO] [stdout] test subshell::tests::wait_without_job_control ... ok
[INFO] [stdout] test subshell::tests::wait_for_foreground_job_to_exit ... ok
[INFO] [stdout] test system::r#virtual::file_system::tests::file_system_get_parents ... ok
[INFO] [stdout] test system::r#virtual::file_system::tests::file_system_get_root ... ok
[INFO] [stdout] test subshell::tests::tty_after_starting_foreground_subshell ... ok
[INFO] [stdout] test system::r#virtual::file_system::tests::file_system_get_not_directory ... ok
[INFO] [stdout] test subshell::tests::subshell_in_foreground ... ok
[INFO] [stdout] test system::r#virtual::file_system::tests::file_system_save_and_get_directory ... ok
[INFO] [stdout] test system::r#virtual::file_system::tests::virtual_dir_try_from_file_body_non_directory ... ok
[INFO] [stdout] test system::r#virtual::file_system::tests::file_system_save_invalid_name ... ok
[INFO] [stdout] test system::r#virtual::io::tests::fifo_is_ready_for_writing ... ok
[INFO] [stdout] test system::r#virtual::io::tests::fifo_read_empty ... ok
[INFO] [stdout] test system::r#virtual::io::tests::fifo_read_non_empty ... ok
[INFO] [stdout] test system::r#virtual::io::tests::fifo_read_not_ready ... ok
[INFO] [stdout] test system::r#virtual::file_system::tests::non_empty_virtual_dir ... ok
[INFO] [stdout] test system::r#virtual::io::tests::fifo_reader_drop ... ok
[INFO] [stdout] test system::r#virtual::file_system::tests::file_system_save_and_get_file ... ok
[INFO] [stdout] test system::r#virtual::io::tests::fifo_write_non_atomic_full ... ok
[INFO] [stdout] test system::r#virtual::io::tests::fifo_write_atomic_full ... ok
[INFO] [stdout] test system::r#virtual::io::tests::fifo_write_orphan ... ok
[INFO] [stdout] test system::r#virtual::file_system::tests::virtual_dir_try_from_file_body_directory ... ok
[INFO] [stdout] test system::r#virtual::io::tests::fifo_write_full ... ok
[INFO] [stdout] test system::r#virtual::io::tests::regular_file_read_beyond_file_length ... ok
[INFO] [stdout] test system::r#virtual::io::tests::fifo_writer_drop ... ok
[INFO] [stdout] test system::r#virtual::io::tests::regular_file_seek_from_current ... ok
[INFO] [stdout] test system::r#virtual::io::tests::regular_file_read_unreadable ... ok
[INFO] [stdout] test system::r#virtual::io::tests::regular_file_read_less_than_content ... ok
[INFO] [stdout] test system::r#virtual::io::tests::regular_file_read_more_than_content ... ok
[INFO] [stdout] test system::r#virtual::io::tests::regular_file_seek_from_start ... ok
[INFO] [stdout] test system::r#virtual::io::tests::regular_file_seek_from_end ... ok
[INFO] [stdout] test system::r#virtual::io::tests::regular_file_write_beyond_file_length ... ok
[INFO] [stdout] test system::r#virtual::io::tests::fifo_write_vacant ... ok
[INFO] [stdout] test system::r#virtual::io::tests::regular_file_write_unwritable ... ok
[INFO] [stdout] test system::r#virtual::process::tests::process_raise_signal_blocked ... ok
[INFO] [stdout] test system::r#virtual::io::tests::regular_file_write_less_than_content ... ok
[INFO] [stdout] test system::r#virtual::process::tests::process_raise_signal_caught ... ok
[INFO] [stdout] test system::r#virtual::process::tests::process_raise_signal_default_aborting ... ok
[INFO] [stdout] test system::r#virtual::io::tests::regular_file_write_more_than_content ... ok
[INFO] [stdout] test system::r#virtual::process::tests::process_raise_signal_default_continuing ... ok
[INFO] [stdout] test system::r#virtual::process::tests::process_raise_signal_default_nop ... ok
[INFO] [stdout] test system::r#virtual::process::tests::process_raise_signal_default_terminating ... ok
[INFO] [stdout] test system::r#virtual::process::tests::process_raise_signal_default_stopping ... ok
[INFO] [stdout] test system::r#virtual::process::tests::process_raise_signal_ignored ... ok
[INFO] [stdout] test system::r#virtual::process::tests::min_unused_fd_for_various_arguments ... ok
[INFO] [stdout] test system::r#virtual::process::tests::process_raise_signal_ignored_and_blocked_sigcont ... ok
[INFO] [stdout] test system::r#virtual::process::tests::process_set_disposition ... ok
[INFO] [stdout] test system::r#virtual::io::tests::regular_file_write_appending ... ok
[INFO] [stdout] test system::r#virtual::process::tests::process_default_signal_blocking_mask ... ok
[INFO] [stdout] test system::r#virtual::process::tests::process_set_state_closes_all_fds_on_signaled ... ok
[INFO] [stdout] test system::r#virtual::process::tests::process_set_state_wakes_on_resumed ... ok
[INFO] [stdout] test system::r#virtual::process::tests::process_sigmask_block ... ok
[INFO] [stdout] test system::r#virtual::process::tests::process_sigmask_setmask ... ok
[INFO] [stdout] test system::r#virtual::process::tests::process_sigmask_unblock ... ok
[INFO] [stdout] test system::r#virtual::process::tests::process_set_state_closes_all_fds_on_exit ... ok
[INFO] [stdout] test system::r#virtual::tests::close ... ok
[INFO] [stdout] test system::r#virtual::tests::chdir_fails_with_non_directory_file ... ok
[INFO] [stdout] test system::r#virtual::tests::chdir_changes_directory ... ok
[INFO] [stdout] test system::r#virtual::tests::chdir_fails_with_non_existing_directory ... ok
[INFO] [stdout] test system::r#virtual::tests::dup2_clears_cloexec ... ok
[INFO] [stdout] test system::r#virtual::tests::dup_can_set_cloexec ... ok
[INFO] [stdout] test system::r#virtual::tests::dup2_shares_open_file_description ... ok
[INFO] [stdout] test system::r#virtual::tests::execve_returns_enoent_on_file_not_found ... ok
[INFO] [stdout] test system::r#virtual::tests::dup_shares_open_file_description ... ok
[INFO] [stdout] test system::r#virtual::tests::execve_returns_enoexec_for_non_executable_file ... ok
[INFO] [stdout] test system::r#virtual::tests::execve_saves_arguments ... ok
[INFO] [stdout] test system::r#virtual::tests::exit_sets_current_process_state_to_exited ... ok
[INFO] [stdout] test system::r#virtual::tests::execve_returns_enosys_for_executable_file ... ok
[INFO] [stdout] test system::r#virtual::tests::fcntl_getfd_and_setfd ... ok
[INFO] [stdout] test system::r#virtual::tests::fstatat_directory ... ok
[INFO] [stdout] test system::r#virtual::tests::fstatat_non_existent_file ... ok
[INFO] [stdout] test system::r#virtual::tests::fstatat_fifo ... ok
[INFO] [stdout] test system::r#virtual::tests::exit_sends_sigchld_to_parent ... ok
[INFO] [stdout] test system::r#virtual::tests::fstatat_regular_file ... ok
[INFO] [stdout] test system::r#virtual::tests::exiting_child_sends_sigchld_to_parent ... ok
[INFO] [stdout] test system::r#virtual::tests::fstatat_symlink_to_regular_file ... ok
[INFO] [stdout] test system::r#virtual::tests::fstatat_symlink_no_follow ... ok
[INFO] [stdout] test system::r#virtual::tests::getrlimit_for_unset_resource_returns_infinity ... ok
[INFO] [stdout] test system::r#virtual::tests::is_executable_file_non_existing_file ... ok
[INFO] [stdout] test system::r#virtual::tests::is_executable_file_with_executable_file ... ok
[INFO] [stdout] test system::r#virtual::tests::kill_process_group ... ok
[INFO] [stdout] test system::r#virtual::tests::kill_processes_in_same_group ... ok
[INFO] [stdout] test system::r#virtual::tests::kill_process ... ok
[INFO] [stdout] test system::r#virtual::tests::kill_all_processes ... ok
[INFO] [stdout] test system::r#virtual::tests::kill_returns_success_even_if_process_state_did_not_change ... ok
[INFO] [stdout] test system::r#virtual::tests::new_child_process_with_executor ... ok
[INFO] [stdout] test system::r#virtual::tests::new_child_process_without_executor ... ok
[INFO] [stdout] test system::r#virtual::tests::open_appending ... ok
[INFO] [stdout] test system::r#virtual::tests::is_executable_file_existing_but_non_executable_file ... ok
[INFO] [stdout] test system::r#virtual::tests::open_creating_non_existing_file_umask ... ok
[INFO] [stdout] test system::r#virtual::tests::open_creating_non_existing_file ... ok
[INFO] [stdout] test system::r#virtual::tests::open_directory ... ok
[INFO] [stdout] test system::r#virtual::tests::open_existing_file ... ok
[INFO] [stdout] test system::r#virtual::tests::open_non_directory_file ... ok
[INFO] [stdout] test system::r#virtual::tests::open_non_existing_file_no_creation ... ok
[INFO] [stdout] test system::r#virtual::tests::open_existing_file_excl ... ok
[INFO] [stdout] test system::r#virtual::tests::open_tmpfile ... ok
[INFO] [stdout] test system::r#virtual::tests::open_default_working_directory ... ok
[INFO] [stdout] test system::r#virtual::tests::open_truncating ... ok
[INFO] [stdout] test system::r#virtual::tests::open_non_directory_path_prefix ... ok
[INFO] [stdout] test system::r#virtual::tests::opendir_default_working_directory ... ok
[INFO] [stdout] test system::r#virtual::tests::select_on_pending_signal ... ok
[INFO] [stdout] test system::r#virtual::tests::select_on_unreadable_fd ... ok
[INFO] [stdout] test system::r#virtual::tests::select_on_closed_fd ... ok
[INFO] [stdout] test system::r#virtual::tests::select_on_unwritable_fd ... ok
[INFO] [stdout] test system::r#virtual::tests::pipe_read_write ... ok
[INFO] [stdout] test system::r#virtual::tests::select_pipe_reader_is_not_ready_if_writer_has_written_nothing ... ok
[INFO] [stdout] test system::r#virtual::tests::select_pipe_reader_is_ready_if_something_has_been_written ... ok
[INFO] [stdout] test system::r#virtual::tests::select_regular_file_is_always_ready ... ok
[INFO] [stdout] test system::r#virtual::tests::select_on_non_pending_signal ... ok
[INFO] [stdout] test system::r#virtual::tests::select_timeout ... ok
[INFO] [stdout] test system::r#virtual::tests::setpgid_creating_new_group_from_child ... ok
[INFO] [stdout] test system::r#virtual::tests::select_pipe_reader_is_ready_if_writer_is_closed ... ok
[INFO] [stdout] test system::r#virtual::tests::setpgid_creating_new_group_from_parent ... ok
[INFO] [stdout] test system::r#virtual::tests::setpgid_extending_existing_group_from_parent ... ok
[INFO] [stdout] test system::r#virtual::tests::setpgid_with_execed_child ... ok
[INFO] [stdout] test system::r#virtual::tests::setpgid_with_nonexisting_pgid ... ok
[INFO] [stdout] test system::r#virtual::tests::setpgid_with_unrelated_pid ... ok
[INFO] [stdout] test system::r#virtual::tests::setpgid_with_nonexisting_pid ... ok
[INFO] [stdout] test system::r#virtual::tests::setrlimit_refuses_raising_hard_limit ... ok
[INFO] [stdout] test system::r#virtual::tests::setrlimit_and_getrlimit_with_finite_limits ... ok
[INFO] [stdout] test system::r#virtual::tests::select_pipe_writer_is_ready_if_pipe_is_not_full ... ok
[INFO] [stdout] test system::r#virtual::tests::tcsetpgrp_with_invalid_fd ... ok
[INFO] [stdout] test system::r#virtual::tests::setrlimit_rejects_soft_limit_higher_than_hard_limit ... ok
[INFO] [stdout] test system::r#virtual::tests::tcsetpgrp_success ... ok
[INFO] [stdout] test system::r#virtual::tests::tcsetpgrp_with_nonexisting_pgrp ... ok
[INFO] [stdout] test system::r#virtual::tests::wait_for_exited_child ... ok
[INFO] [stdout] test system::r#virtual::tests::wait_for_resumed_child ... ok
[INFO] [stdout] test system::r#virtual::tests::wait_for_running_child ... ok
[INFO] [stdout] test system::r#virtual::tests::wait_for_signaled_child ... ok
[INFO] [stdout] test system::r#virtual::tests::wait_for_stopped_child ... ok
[INFO] [stdout] test system::r#virtual::tests::wait_without_child ... ok
[INFO] [stdout] test system::real::tests::real_system_caught_signals ... ok
[INFO] [stdout] test system::real::tests::real_system_directory_entries ... ok
[INFO] [stdout] test system::select::tests::async_io_non_empty_readers_and_writers ... ok
[INFO] [stdout] test system::select::tests::async_io_has_no_default_readers_or_writers ... ok
[INFO] [stdout] test system::select::tests::async_io_wake ... ok
[INFO] [stdout] test system::select::tests::async_io_wake_all ... ok
[INFO] [stdout] test system::select::tests::async_signal_empty_wake ... ok
[INFO] [stdout] test system::select::tests::async_signal_phantom_wake ... ok
[INFO] [stdout] test system::select::tests::async_signal_wait_and_wake ... ok
[INFO] [stdout] test system::select::tests::async_signal_wake_and_wait ... ok
[INFO] [stdout] test system::select::tests::async_signal_wake_twice_and_wait ... ok
[INFO] [stdout] test system::select::tests::async_time_first_target ... ok
[INFO] [stdout] test system::select::tests::async_time_wake_if_passed ... ok
[INFO] [stdout] test system::shared::tests::shared_system_read_async_not_ready_at_first ... ok
[INFO] [stdout] test system::shared::tests::shared_system_read_async_ready ... ok
[INFO] [stdout] test system::shared::tests::shared_system_select_consumes_all_pending_signals ... ok
[INFO] [stdout] test system::shared::tests::shared_system_select_does_not_wake_signal_waiters_on_io ... ok
[INFO] [stdout] test system::shared::tests::shared_system_select_poll ... ok
[INFO] [stdout] test system::shared::tests::shared_system_wait_for_signal_ignores_irrelevant_signals ... ok
[INFO] [stdout] test system::shared::tests::shared_system_wait_for_signal_returns_on_caught ... ok
[INFO] [stdout] test system::shared::tests::shared_system_wait_for_signals ... ok
[INFO] [stdout] test system::shared::tests::shared_system_wait_until ... ok
[INFO] [stdout] test system::shared::tests::shared_system_write_all_empty ... ok
[INFO] [stdout] test system::shared::tests::shared_system_write_all_ready ... ok
[INFO] [stdout] test tests::apply_result_with_continue ... ok
[INFO] [stdout] test system::shared::tests::shared_system_write_all_not_ready_at_first ... ok
[INFO] [stdout] test tests::apply_result_with_divert_with_exit_status ... ok
[INFO] [stdout] test tests::apply_result_with_divert_without_exit_status ... ok
[INFO] [stdout] test tests::errexit_in_condition ... ok
[INFO] [stdout] test tests::errexit_on ... ok
[INFO] [stdout] test tests::errexit_off ... ok
[INFO] [stdout] test tests::errexit_with_zero_exit_status ... ok
[INFO] [stdout] test tests::get_or_create_variable_with_all_export_on ... ok
[INFO] [stdout] test tests::get_or_create_variable_with_all_export_off ... ok
[INFO] [stdout] test tests::get_tty_opens_tty ... ok
[INFO] [stdout] test tests::poll_signals_none ... ok
[INFO] [stdout] test tests::poll_signals_some ... ok
[INFO] [stdout] test tests::start_and_wait_for_subshell ... ok
[INFO] [stdout] test tests::update_all_subshell_statuses_without_subshells ... ok
[INFO] [stdout] test tests::start_and_wait_for_subshell_with_job_list ... ok
[INFO] [stdout] test tests::wait_for_subshell_no_subshell ... ok
[INFO] [stdout] test tests::update_all_subshell_statuses_with_subshells ... ok
[INFO] [stdout] test trap::state::tests::action_ignore_and_internal_disposition_catch ... ok
[INFO] [stdout] test trap::state::tests::action_catch_and_internal_disposition_ignore ... ok
[INFO] [stdout] test trap::state::tests::clearing_parent_setting ... ok
[INFO] [stdout] test tests::wait_for_signal_remembers_signal_in_trap_set ... ok
[INFO] [stdout] test trap::state::tests::enter_subshell_with_command_and_no_internal_disposition ... ok
[INFO] [stdout] test trap::state::tests::enter_subshell_with_command_clearing_internal_disposition ... ok
[INFO] [stdout] test trap::state::tests::enter_subshell_with_command_ignoring ... ok
[INFO] [stdout] test trap::state::tests::enter_subshell_with_ignore_clearing_internal_disposition ... ok
[INFO] [stdout] test trap::state::tests::enter_subshell_with_command_keeping_internal_disposition ... ok
[INFO] [stdout] test trap::state::tests::enter_subshell_with_internal_disposition_clearing_internal_disposition ... ok
[INFO] [stdout] test trap::state::tests::ignoring_initially_defaulted_signal ... ok
[INFO] [stdout] test trap::state::tests::enter_subshell_with_ignore_and_no_internal_disposition ... ok
[INFO] [stdout] test trap::state::tests::ignoring_initially_ignored_signal ... ok
[INFO] [stdout] test trap::state::tests::insertion_with_default_inherited_disposition ... ok
[INFO] [stdout] test trap::state::tests::insertion_with_inherited_disposition_of_ignore ... ok
[INFO] [stdout] test trap::state::tests::insertion_with_occupied_entry ... ok
[INFO] [stdout] test trap::state::tests::insertion_with_non_signal_condition ... ok
[INFO] [stdout] test trap::state::tests::internal_disposition_catch ... ok
[INFO] [stdout] test trap::state::tests::enter_subshell_with_internal_disposition_keeping_internal_disposition ... ok
[INFO] [stdout] test trap::state::tests::marking_as_caught_and_handling ... ok
[INFO] [stdout] test trap::state::tests::internal_disposition_ignore ... ok
[INFO] [stdout] test trap::state::tests::resetting_trap_from_ignore_no_override ... ok
[INFO] [stdout] test trap::state::tests::set_internal_disposition_for_initially_defaulted_signal_then_allow_override ... ok
[INFO] [stdout] test trap::state::tests::set_internal_disposition_for_initially_ignored_signal_then_reject_override ... ok
[INFO] [stdout] test trap::state::tests::setting_trap_to_default ... ok
[INFO] [stdout] test trap::state::tests::setting_trap_to_ignore_with_override_ignore ... ok
[INFO] [stdout] test trap::state::tests::setting_trap_to_command ... ok
[INFO] [stdout] test trap::tests::basic_iteration ... ok
[INFO] [stdout] test trap::state::tests::resetting_trap_from_ignore_override ... ok
[INFO] [stdout] test trap::tests::catching_signal ... ok
[INFO] [stdout] test trap::state::tests::setting_trap_to_ignore_without_override_ignore ... ok
[INFO] [stdout] test trap::tests::default_trap ... ok
[INFO] [stdout] test trap::tests::enabling_internal_disposition_for_sigchld ... ok
[INFO] [stdout] test trap::tests::enabling_internal_dispositions_for_stoppers ... ok
[INFO] [stdout] test trap::tests::disabling_internal_dispositions_for_initially_defaulted_signals ... ok
[INFO] [stdout] test trap::tests::disabling_internal_dispositions_without_enabling ... ok
[INFO] [stdout] test trap::tests::disabling_internal_disposition_with_ignore_trap ... ok
[INFO] [stdout] test trap::tests::enabling_internal_dispositions_for_terminators ... ok
[INFO] [stdout] test trap::tests::disabling_internal_dispositions_after_enabling_twice ... ok
[INFO] [stdout] test trap::tests::entering_subshell_resets_command_traps ... ok
[INFO] [stdout] test trap::tests::entering_subshell_with_internal_disposition_for_sigchld ... ok
[INFO] [stdout] test trap::tests::entering_subshell_keeps_ignore_traps ... ok
[INFO] [stdout] test trap::tests::disabling_internal_dispositions_for_initially_ignored_signals ... ok
[INFO] [stdout] test trap::tests::entering_subshell_with_internal_disposition_for_sigquit ... ok
[INFO] [stdout] test trap::tests::entering_subshell_with_internal_disposition_for_sigterm ... ok
[INFO] [stdout] test trap::tests::entering_subshell_with_internal_disposition_for_sigtstp ... ok
[INFO] [stdout] test trap::tests::entering_nested_subshell_clears_parent_states ... ok
[INFO] [stdout] test trap::tests::entering_subshell_with_internal_disposition_for_sigttou ... ok
[INFO] [stdout] test trap::tests::entering_subshell_with_internal_disposition_for_sigttin ... ok
[INFO] [stdout] test trap::tests::entering_subshell_with_internal_disposition_for_sigint ... ok
[INFO] [stdout] test trap::tests::ignoring_sigint_and_sigquit_on_entering_subshell_without_action_set ... ok
[INFO] [stdout] test trap::tests::ignoring_sigint_on_entering_subshell_with_action_set ... ok
[INFO] [stdout] test trap::tests::ignoring_sigquit_on_entering_subshell_with_action_set ... ok
[INFO] [stdout] test trap::tests::keeping_stopper_internal_dispositions_ignored ... ok
[INFO] [stdout] test trap::tests::no_stopper_internal_dispositions_enabled_to_be_kept_ignored ... ok
[INFO] [stdout] test trap::tests::peeking_state_with_inherited_disposition_of_ignore ... ok
[INFO] [stdout] test trap::tests::peeking_state_with_parent_state ... ok
[INFO] [stdout] test trap::tests::iteration_after_setting_trap_in_subshell ... ok
[INFO] [stdout] test trap::tests::setting_trap_for_sigstop ... ok
[INFO] [stdout] test trap::tests::setting_trap_after_entering_subshell_clears_parent_states ... ok
[INFO] [stdout] test trap::tests::resetting_trap_from_ignore_override_after_enabling_internal_dispositions ... ok
[INFO] [stdout] test trap::tests::resetting_trap_from_ignore_no_override_after_enabling_internal_dispositions ... ok
[INFO] [stdout] test trap::tests::peeking_state_with_default_inherited_disposition ... ok
[INFO] [stdout] test trap::tests::iteration_after_entering_subshell ... ok
[INFO] [stdout] test trap::tests::setting_trap_to_ignore_after_enabling_internal_disposition ... ok
[INFO] [stdout] test trap::tests::reenabling_internal_dispositions ... ok
[INFO] [stdout] test trap::tests::setting_trap_for_two_signals ... ok
[INFO] [stdout] test trap::tests::setting_trap_for_sigkill ... ok
[INFO] [stdout] test trap::tests::taking_signal_if_caught ... ok
[INFO] [stdout] test trap::tests::taking_caught_signal ... ok
[INFO] [stdout] test variable::guard::tests::env_scope_guard ... ok
[INFO] [stdout] test variable::main::tests::assigning_values ... ok
[INFO] [stdout] test variable::main::tests::assigning_to_readonly_variable ... ok
[INFO] [stdout] test variable::main::tests::exporting ... ok
[INFO] [stdout] test variable::main::tests::making_variables_read_only ... ok
[INFO] [stdout] test variable::quirk::tests::expand_line_number_in_alias ... ok
[INFO] [stdout] test variable::quirk::tests::expand_line_number_of_first_line ... ok
[INFO] [stdout] test variable::guard::tests::scope_guard ... ok
[INFO] [stdout] test variable::quirk::tests::expand_line_number_of_third_line ... ok
[INFO] [stdout] test variable::tests::env_c_strings_with_equal_in_name ... ok
[INFO] [stdout] test variable::tests::cloning_existing_regular_variable_to_volatile_context ... ok
[INFO] [stdout] test variable::tests::existing_variable_in_global_scope ... ok
[INFO] [stdout] test variable::quirk::tests::expand_no_quirk ... ok
[INFO] [stdout] test variable::tests::init_lineno ... ok
[INFO] [stdout] test variable::tests::iter_global ... ok
[INFO] [stdout] test variable::tests::lowering_volatile_variable_to_base_context ... ok
[INFO] [stdout] test variable::tests::lowering_volatile_variable_to_middle_regular_context ... ok
[INFO] [stdout] test variable::tests::existing_variable_in_local_scope ... ok
[INFO] [stdout] test variable::tests::existing_variable_in_volatile_scope ... ok
[INFO] [stdout] test variable::tests::extend_env ... ok
[INFO] [stdout] test variable::tests::getting_positional_params_in_volatile_context ... ok
[INFO] [stdout] test variable::tests::getting_variables_with_scopes ... ok
[INFO] [stdout] test variable::tests::env_c_strings ... ok
[INFO] [stdout] test variable::tests::iter_local ... ok
[INFO] [stdout] test variable::tests::iter_size_hint ... ok
[INFO] [stdout] test variable::tests::lowering_volatile_variable_to_topmost_regular_context_overwriting_existing_variable ... ok
[INFO] [stdout] test variable::tests::iter_volatile ... ok
[INFO] [stdout] test variable::tests::lowering_volatile_variable_to_topmost_regular_context_without_existing_variable ... ok
[INFO] [stdout] test variable::tests::new_variable_in_global_scope ... ok
[INFO] [stdout] test variable::tests::new_variable_in_local_scope ... ok
[INFO] [stdout] test variable::tests::new_variable_in_volatile_scope ... ok
[INFO] [stdout] test variable::tests::positional_params_in_base_context ... ok
[INFO] [stdout] test variable::tests::positional_params_in_second_regular_context ... ok
[INFO] [stdout] test variable::tests::setting_positional_params_in_volatile_context ... ok
[INFO] [stdout] test variable::tests::unsetting_nonexisting_variable ... ok
[INFO] [stdout] test variable::tests::unsetting_nonexisting_variable_in_local_context ... ok
[INFO] [stdout] test variable::tests::unsetting_nonexisting_variable_in_volatile_context ... ok
[INFO] [stdout] test variable::tests::unsetting_readonly_variable ... ok
[INFO] [stdout] test variable::tests::unsetting_variable_from_local_context ... ok
[INFO] [stdout] test variable::tests::unsetting_variable_with_one_context ... ok
[INFO] [stdout] test variable::tests::unsetting_variable_from_volatile_context ... ok
[INFO] [stdout] test variable::tests::unsetting_variables_from_all_contexts ... ok
[INFO] [stdout] test variable::tests::cannot_pop_base_context - should panic ... ok
[INFO] [stdout] test variable::tests::missing_volatile_context - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 420 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests yash_env
[INFO] [stdout] 
[INFO] [stdout] running 14 tests
[INFO] [stdout] test src/job/fmt.rs - job::fmt (line 35) ... ok
[INFO] [stdout] test src/job/fmt.rs - job::fmt::Accumulator (line 214) ... ok
[INFO] [stdout] test src/job/id.rs - job::id::parse (line 127) ... ok
[INFO] [stdout] test src/option.rs - option::parse_long (line 392) ... ok
[INFO] [stdout] test src/job/id.rs - job::id::parse_tail (line 97) ... ok
[INFO] [stdout] test src/option.rs - option::parse_short (line 303) ... ok
[INFO] [stdout] test src/variable/quirk.rs - variable::quirk::Expansion<'_>::split (line 214) ... ok
[INFO] [stdout] test src/system/shared.rs - system::shared::SharedSystem (line 83) ... ok
[INFO] [stdout] test src/variable/quirk.rs - variable::quirk::Expansion<'_>::split (line 221) ... ok
[INFO] [stdout] test src/variable.rs - variable (line 69) ... ok
[INFO] [stdout] test src/variable/quirk.rs - variable::quirk::Expansion<'_>::split (line 228) ... ok
[INFO] [stdout] test src/variable/value.rs - variable::value::Value::quote (line 83) ... ok
[INFO] [stdout] test src/variable/value.rs - variable::value::Value::split (line 55) ... ok
[INFO] [stdout] test src/variable/value.rs - variable::value::Value::split (line 62) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "3f0a59a0eeb6fb8c215c51c7c725abd2106c49544a708491e33335c221712125", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3f0a59a0eeb6fb8c215c51c7c725abd2106c49544a708491e33335c221712125", kill_on_drop: false }`
[INFO] [stdout] 3f0a59a0eeb6fb8c215c51c7c725abd2106c49544a708491e33335c221712125