[INFO] fetching crate cradle 0.0.17...
[INFO] testing cradle-0.0.17 against beta-2021-08-01 for beta-1.55-1
[INFO] extracting crate cradle 0.0.17 into /workspace/builds/worker-32/source
[INFO] validating manifest of crates.io crate cradle 0.0.17 on toolchain beta-2021-08-01
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-08-01" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate cradle 0.0.17
[INFO] finished tweaking crates.io crate cradle 0.0.17
[INFO] tweaked toml for crates.io crate cradle 0.0.17 written to /workspace/builds/worker-32/source/Cargo.toml
[INFO] crate crates.io crate cradle 0.0.17 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2021-08-01" "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-32/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-32/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-08-01" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 9e47a433cd467b96aabc096f58b46964dec4a3487c42eaa2dc4ec0b2a6bd5577
[INFO] running `Command { std: "docker" "start" "-a" "9e47a433cd467b96aabc096f58b46964dec4a3487c42eaa2dc4ec0b2a6bd5577", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9e47a433cd467b96aabc096f58b46964dec4a3487c42eaa2dc4ec0b2a6bd5577", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9e47a433cd467b96aabc096f58b46964dec4a3487c42eaa2dc4ec0b2a6bd5577", kill_on_drop: false }`
[INFO] [stdout] 9e47a433cd467b96aabc096f58b46964dec4a3487c42eaa2dc4ec0b2a6bd5577
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-32/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-32/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=warn" "-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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-08-01" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 2ac7f92c4dc8c5633e998208e031d0c12118fbcac33af99783c43ea2fe410b5b
[INFO] running `Command { std: "docker" "start" "-a" "2ac7f92c4dc8c5633e998208e031d0c12118fbcac33af99783c43ea2fe410b5b", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling rustversion v1.0.5
[INFO] [stderr]    Compiling cradle v0.0.17 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 13.91s
[INFO] running `Command { std: "docker" "inspect" "2ac7f92c4dc8c5633e998208e031d0c12118fbcac33af99783c43ea2fe410b5b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2ac7f92c4dc8c5633e998208e031d0c12118fbcac33af99783c43ea2fe410b5b", kill_on_drop: false }`
[INFO] [stdout] 2ac7f92c4dc8c5633e998208e031d0c12118fbcac33af99783c43ea2fe410b5b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-32/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-32/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=warn" "-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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-08-01" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 611d4123854776a01a6f3eb3f54ba4d5f739fe1f54d18cbf625232dc94a32d6c
[INFO] running `Command { std: "docker" "start" "-a" "611d4123854776a01a6f3eb3f54ba4d5f739fe1f54d18cbf625232dc94a32d6c", kill_on_drop: false }`
[INFO] [stderr]    Compiling diff v0.1.12
[INFO] [stderr]    Compiling ansi_term v0.12.1
[INFO] [stderr]    Compiling executable-path v1.0.0
[INFO] [stderr]    Compiling pretty_assertions v0.7.2
[INFO] [stderr]    Compiling cradle v0.0.17 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 5.20s
[INFO] running `Command { std: "docker" "inspect" "611d4123854776a01a6f3eb3f54ba4d5f739fe1f54d18cbf625232dc94a32d6c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "611d4123854776a01a6f3eb3f54ba4d5f739fe1f54d18cbf625232dc94a32d6c", kill_on_drop: false }`
[INFO] [stdout] 611d4123854776a01a6f3eb3f54ba4d5f739fe1f54d18cbf625232dc94a32d6c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-32/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-32/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=warn" "-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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2021-08-01" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 2173db781b5c6ec9d748e8be777f12a0664407038768dcbaca92ad6cb19a3931
[INFO] running `Command { std: "docker" "start" "-a" "2173db781b5c6ec9d748e8be777f12a0664407038768dcbaca92ad6cb19a3931", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/cradle-9cb6d7b8ac104f74)
[INFO] [stdout] 
[INFO] [stdout] running 128 tests
[INFO] [stderr] + echo foo
[INFO] [stderr] + cargo build --bin test_executables_helper --features test_executables
[INFO] [stdout] foo
[INFO] [stdout] foo
[INFO] [stdout] test error::tests::invalid_utf8_to_stderr_has_source ... ok
[INFO] [stdout] test error::tests::invalid_utf8_to_stdout_has_source ... ok
[INFO] [stdout] test tests::capturing_stdout::untrimmed::does_not_trim_trailing_newline ... ok
[INFO] [stdout] test tests::arguments_can_be_given_as_references ... ok
[INFO] [stdout] test tests::bool_output::success_exit_status_is_true ... ok
[INFO] [stdout] test tests::capturing_stdout::trimmed::does_not_modify_output_without_whitespace ... ok
[INFO] [stdout] test tests::command_and_argument_as_separate_ref_str ... ok
[INFO] [stdout] test tests::capturing_stdout::untrimmed::does_not_relay_stdout ... ok
[INFO] [stdout] test tests::capturing_stdout::trimmed::trims_trailing_whitespace ... ok
[INFO] [stdout] test tests::capturing_stdout::untrimmed::does_not_trim_leading_whitespace ... ok
[INFO] [stdout] test tests::errors::result_types::missing_executable_file_error_can_be_caused_by_relative_paths ... ok
[INFO] [stdout] test tests::errors::result_types::no_executable ... ok
[INFO] [stdout] test tests::errors::result_types::combine_err_with_other_outputs ... ok
[INFO] [stdout] test tests::errors::result_types::missing_executable_file_error_can_be_matched_against ... ok
[INFO] [stdout] test tests::bool_output::failure_exit_status_is_false ... ok
[INFO] [stdout] test tests::allows_to_retrieve_stdout ... ok
[INFO] [stdout] test tests::capturing_stdout::trimmed::trims_leading_whitespace ... ok
[INFO] [stdout] test tests::capturing_stdout::trimmed::does_not_remove_whitespace_within_output ... ok
[INFO] [stdout] test tests::errors::result_types::combine_ok_with_other_outputs ... ok
[INFO] [stdout] test tests::errors::result_types::missing_executable_file_error_message ... ok
[INFO] [stdout] test tests::capturing_stdout::trimmed::does_not_relay_stdout ... ok
[INFO] [stdout] test tests::errors::result_types::no_errors ... ok
[INFO] [stdout] test tests::errors::result_types::non_zero_exit_codes ... ok
[INFO] [stdout] test tests::errors::result_types::includes_full_command_on_non_zero_exit_codes ... ok
[INFO] [stdout] test tests::allows_to_execute_a_command ... ok
[INFO] [stdout] test tests::exit_status::zero ... ok
[INFO] [stdout] test tests::log_commands::arguments_with_invalid_utf8_will_be_logged_with_lossy_conversion ... ok
[INFO] [stdout] test tests::exit_status::one ... ok
[INFO] [stdout] test tests::log_commands::logs_simple_commands ... ok
[INFO] [stdout] test tests::sequences::vector_of_non_strings ... ok
[INFO] [stdout] test tests::log_commands::logs_commands_with_arguments ... ok
[INFO] [stdout] test tests::exit_status::failing_commands_return_oks_when_exit_status_is_captured ... ok
[INFO] [stdout] test tests::multiple_arguments_as_ref_str ... ok
[INFO] [stdout] test tests::split::percent_sign::splits_words ... ok
[INFO] [stdout] test tests::sequences::arrays_of_non_strings ... ok
[INFO] [stdout] foo
[INFO] [stdout] test tests::split::splits_owned_strings ... ok
[INFO] [stdout] test tests::os_strings::works_for_os_str ... ok
[INFO] [stdout] test tests::split::trims_leading_whitespace ... ok
[INFO] [stdout] test tests::sequences::vector_of_vectors ... ok
[INFO] [stdout] test tests::run_interface::allows_to_bundle_arguments_up_in_tuples ... ok
[INFO] [stdout] test tests::sequences::array_refs_as_arguments ... ok
[INFO] [stdout] test tests::split::percent_sign::works_for_later_arguments ... ok
[INFO] [stdout] test tests::splitting_with_library_functions::split_ascii_whitespace ... ok
[INFO] [stdout] test tests::run_interface::works_for_different_output_types ... ok
[INFO] [stderr]    Compiling libc v0.2.98
[INFO] [stderr]    Compiling memoffset v0.6.4
[INFO] [stdout] foo
[INFO] [stdout] test tests::stdin::writing_too_many_bytes_into_a_non_reading_child_may_error ... ok
[INFO] [stdout] test tests::sequences::arrays_as_arguments ... ok
[INFO] [stdout] test tests::log_commands::quotes_arguments_with_spaces ... ok
[INFO] [stdout] test tests::sequences::slices_of_non_strings ... ok
[INFO] [stdout] test tests::split::percent_sign::for_first_of_multiple_arguments ... ok
[INFO] [stdout] test tests::os_strings::works_for_os_string ... ok
[INFO] [stdout] test tests::split::skips_multiple_whitespace_characters ... ok
[INFO] [stdout] test tests::sequences::slices_as_arguments ... ok
[INFO] [stdout] test tests::split::splits_words_by_whitespace ... ok
[INFO] [stdout] test tests::sequences::allows_to_pass_in_arguments_as_a_vec_of_ref_str ... ok
[INFO] [stdout] test tests::log_commands::quotes_empty_arguments ... ok
[INFO] [stdout] test tests::split::percent_sign::in_cmd_result ... ok
[INFO] [stdout] test tests::splitting_with_library_functions::allow_to_use_split ... ok
[INFO] [stdout] test tests::split::percent_sign::in_cmd_unit ... ok
[INFO] [stdout] test tests::tuple_inputs::nested_tuples ... ok
[INFO] [stdout] test tests::strings::multiple_strings ... ok
[INFO] [stdout] test tests::strings::works_for_string ... ok
[INFO] [stdout] test tests::tuple_outputs::three_tuples ... ok
[INFO] [stdout] test tests::bool_output::io_error_panics - should panic ... ok
[INFO] [stdout] test tests::tuple_inputs::two_tuple ... ok
[INFO] [stdout] test tests::run_interface::allows_to_run_commands_with_dot_run ... ok
[INFO] [stdout] test tests::stdout::does_not_relay_stdout_when_collecting_into_string ... ok
[INFO] [stdout] test tests::tuple_inputs::unit_input ... ok
[INFO] [stdout] test tests::stdout::relays_stdout_by_default ... ok
[INFO] [stdout] test tests::splitting_with_library_functions::split_whitespace ... ok
[INFO] [stdout] foo
[INFO] [stdout] test tests::stdout::does_not_relay_stdout_when_collecting_into_result_of_string ... ok
[INFO] [stdout] test tests::split::percent_sign::non_literals ... ok
[INFO] [stdout] test tests::split::trims_trailing_whitespace ... ok
[INFO] [stdout] test tests::run_interface::run_result ... ok
[INFO] [stdout] test tests::strings::mix_ref_str_and_string ... ok
[INFO] [stdout] test tests::invocation_syntax::trailing_comma_is_accepted_after_split_argument ... ok
[INFO] [stdout] test tests::tuple_outputs::result_of_tuple_when_erroring ... ok
[INFO] [stdout] test tests::tuple_outputs::result_of_tuple ... ok
[INFO] [stdout] test tests::errors::panics_by_default::includes_full_command_on_non_zero_exit_codes - should panic ... ok
[INFO] [stdout] test tests::tuple_inputs::three_tuples ... ok
[INFO] [stdout] test tests::invocation_syntax::trailing_comma_is_accepted_after_normal_argument ... ok
[INFO] [stdout] test tests::errors::panics_by_default::no_executable - should panic ... ok
[INFO] [stdout] test tests::errors::panics_by_default::includes_full_command_on_io_errors - should panic ... ok
[INFO] [stdout] test tests::errors::panics_by_default::executable_cannot_be_found - should panic ... ok
[INFO] [stdout] test tests::errors::panics_by_default::combine_panics_with_other_outputs - should panic ... ok
[INFO] [stdout] test tests::errors::panics_by_default::non_zero_exit_codes - should panic ... ok
[INFO] [stdout] test tests::current_dir::works_for_other_types ... ok
[INFO] [stdout] test tests::errors::result_types::includes_full_command_on_io_errors ... ok
[INFO] [stdout] test tests::paths::path_buf_as_argument ... ok
[INFO] [stdout] test tests::paths::ref_path_as_executable ... ok
[INFO] [stdout] test tests::sequences::elements_in_array_refs_are_not_split_by_whitespace ... ok
[INFO] [stdout] test tests::sequences::elements_in_arrays_are_not_split_by_whitespace ... ok
[INFO] [stdout] test tests::sequences::elements_in_slices_are_not_split_by_whitespace ... ok
[INFO] [stdout] test tests::paths::path_buf_as_executable ... ok
[INFO] [stdout] test tests::paths::ref_path_as_argument ... ok
[INFO] [stdout] test tests::run_interface::run_unit ... ok
[INFO] [stdout] test tests::strings::does_not_split_strings_in_vectors ... ok
[INFO] [stderr]    Compiling getrandom v0.2.3
[INFO] [stderr]    Compiling nix v0.21.0
[INFO] [stderr]    Compiling rand_core v0.6.3
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.4
[INFO] [stderr]    Compiling tempfile v3.2.0
[INFO] [stderr]    Compiling gag v0.1.10
[INFO] [stderr]    Compiling cradle v0.0.17 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 9.20s
[INFO] [stderr] + cargo build --bin test_executables_panic --features test_executables
[INFO] [stdout] test tests::environment_variables::variables_are_overwritten_by_subsequent_variables_with_the_same_name ... ok
[INFO] [stdout] test tests::environment_variables::allows_to_add_variables ... ok
[INFO] [stdout] test tests::environment_variables::variables_can_be_set_to_the_empty_string ... ok
[INFO] [stdout] test tests::environment_variables::works_for_multiple_variables ... ok
[INFO] [stderr]    Compiling cradle v0.0.17 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.44s
[ERROR] error running command: stream did not contain valid UTF-8
[INFO] running `Command { std: "docker" "inspect" "2173db781b5c6ec9d748e8be777f12a0664407038768dcbaca92ad6cb19a3931", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2173db781b5c6ec9d748e8be777f12a0664407038768dcbaca92ad6cb19a3931", kill_on_drop: false }`
[INFO] [stdout] 2173db781b5c6ec9d748e8be777f12a0664407038768dcbaca92ad6cb19a3931
