[INFO] fetching crate cradle 0.2.0...
[INFO] testing cradle-0.2.0 against try#722e1797249a965b6335aebd65d777f917e498f1 for pr-91031
[INFO] extracting crate cradle 0.2.0 into /workspace/builds/worker-12/source
[INFO] validating manifest of crates.io crate cradle 0.2.0 on toolchain 722e1797249a965b6335aebd65d777f917e498f1
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate cradle 0.2.0
[INFO] finished tweaking crates.io crate cradle 0.2.0
[INFO] tweaked toml for crates.io crate cradle 0.2.0 written to /workspace/builds/worker-12/source/Cargo.toml
[INFO] crate crates.io crate cradle 0.2.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded executable-path v1.0.0
[INFO] [stderr]   Downloaded nix v0.21.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 62dd25bc70b6d36e32965e24a51caae88a78480400c57d313d379e36c232cb14
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "62dd25bc70b6d36e32965e24a51caae88a78480400c57d313d379e36c232cb14", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "62dd25bc70b6d36e32965e24a51caae88a78480400c57d313d379e36c232cb14", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "62dd25bc70b6d36e32965e24a51caae88a78480400c57d313d379e36c232cb14", kill_on_drop: false }`
[INFO] [stdout] 62dd25bc70b6d36e32965e24a51caae88a78480400c57d313d379e36c232cb14
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 44b8959f8ec2a7d78188a7d21e833e10fa66f1a62e2726315ab7a29010fbf3d3
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "44b8959f8ec2a7d78188a7d21e833e10fa66f1a62e2726315ab7a29010fbf3d3", kill_on_drop: false }`
[INFO] [stderr]    Compiling cradle v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.67s
[INFO] running `Command { std: "docker" "inspect" "44b8959f8ec2a7d78188a7d21e833e10fa66f1a62e2726315ab7a29010fbf3d3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "44b8959f8ec2a7d78188a7d21e833e10fa66f1a62e2726315ab7a29010fbf3d3", kill_on_drop: false }`
[INFO] [stdout] 44b8959f8ec2a7d78188a7d21e833e10fa66f1a62e2726315ab7a29010fbf3d3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] c0bd6665b0deaeee59daddc0f6d505e5d7fd0174da80c5fa89df7be334dac99a
[INFO] running `Command { std: "docker" "start" "-a" "c0bd6665b0deaeee59daddc0f6d505e5d7fd0174da80c5fa89df7be334dac99a", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.102
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling ppv-lite86 v0.2.10
[INFO] [stderr]    Compiling bitflags v1.2.1
[INFO] [stderr]    Compiling ansi_term v0.12.1
[INFO] [stderr]    Compiling unindent v0.1.7
[INFO] [stderr]    Compiling executable-path v1.0.0
[INFO] [stderr]    Compiling pretty_assertions v0.7.2
[INFO] [stderr]    Compiling getrandom v0.2.3
[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 cradle v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 13.69s
[INFO] running `Command { std: "docker" "inspect" "c0bd6665b0deaeee59daddc0f6d505e5d7fd0174da80c5fa89df7be334dac99a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c0bd6665b0deaeee59daddc0f6d505e5d7fd0174da80c5fa89df7be334dac99a", kill_on_drop: false }`
[INFO] [stdout] c0bd6665b0deaeee59daddc0f6d505e5d7fd0174da80c5fa89df7be334dac99a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-12/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" "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:5736fa189c1c60b01babf4b8b698fe57b6ecc41933a7ff2e0b8d7a221459412b" "/opt/rustwide/cargo-home/bin/cargo" "+722e1797249a965b6335aebd65d777f917e498f1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 05a0e44aee9710df7fd7e1394704046bd3ec28c137821058557a1359710a52c8
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "05a0e44aee9710df7fd7e1394704046bd3ec28c137821058557a1359710a52c8", 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-fd775aa9387248bb)
[INFO] [stderr] + echo foo
[INFO] [stdout] 
[INFO] [stderr] + cargo build --bin test_executables_helper --features test_executables
[INFO] [stdout] running 141 tests
[INFO] [stdout] test macros::tests::tuple_up::percent_shortcut ... ok
[INFO] [stdout] test macros::tests::tuple_up::one_value ... ok
[INFO] [stdout] test macros::tests::tuple_up::percent_shortcut_with_preceeding_values ... ok
[INFO] [stdout] test macros::tests::tuple_up::nested_tuples ... ok
[INFO] [stdout] test macros::tests::tuple_up::percent_shortcut_with_subsequent_values ... ok
[INFO] [stdout] test macros::tests::tuple_up::two_values ... ok
[INFO] [stdout] test macros::tests::tuple_up::three_values ... ok
[INFO] [stdout] test error::tests::english_list::three ... ok
[INFO] [stdout] test macros::tests::tuple_up::percent_shortcut_with_multiple_values ... ok
[INFO] [stdout] test error::tests::english_list::two ... ok
[INFO] [stdout] test error::tests::english_list::four ... ok
[INFO] [stdout] test error::tests::invalid_utf8_to_stdout_has_source ... ok
[INFO] [stdout] test error::tests::english_list::one ... ok
[INFO] [stdout] test error::tests::invalid_utf8_to_stderr_has_source ... ok
[INFO] [stdout] test tests::capturing_stdout::untrimmed::does_not_relay_stdout ... ok
[INFO] [stdout] test tests::capturing_stdout::trimmed::trims_leading_whitespace ... ok
[INFO] [stdout] test tests::capturing_stdout::untrimmed::does_not_trim_leading_whitespace ... ok
[INFO] [stdout] test tests::capturing_stdout::untrimmed::does_not_trim_trailing_newline ... ok
[INFO] [stdout] test tests::bool_output::success_exit_status_is_true ... ok
[INFO] [stdout] test tests::allows_to_retrieve_stdout ... ok
[INFO] [stdout] test tests::capturing_stdout::trimmed::does_not_remove_whitespace_within_output ... ok
[INFO] [stdout] test tests::command_and_argument_as_separate_ref_str ... ok
[INFO] [stdout] test tests::capturing_stdout::trimmed::does_not_relay_stdout ... ok
[INFO] [stdout] test tests::arguments_can_be_given_as_references ... ok
[INFO] [stdout] test tests::allows_to_execute_a_command ... ok
[INFO] [stdout] test tests::capturing_stdout::trimmed::trims_trailing_whitespace ... ok
[INFO] [stdout] test tests::capturing_stdout::trimmed::does_not_modify_output_without_whitespace ... ok
[INFO] [stdout] test tests::bool_output::failure_exit_status_is_false ... ok
[INFO] [stdout] test tests::bool_output::io_error_panics - 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::includes_full_command_on_io_errors - should panic ... ok
[INFO] [stdout] test tests::errors::panics_by_default::includes_full_command_on_non_zero_exit_codes - should panic ... ok
[INFO] [stdout] test tests::errors::panics_by_default::non_zero_exit_codes - 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::no_executable - should panic ... ok
[INFO] [stdout] test tests::errors::result_types::combine_err_with_other_outputs ... ok
[INFO] [stdout] test tests::errors::result_types::combine_ok_with_other_outputs ... ok
[INFO] [stdout] test tests::errors::result_types::includes_full_command_on_non_zero_exit_codes ... ok
[INFO] [stdout] test tests::errors::result_types::missing_executable_file_error_can_be_caused_by_relative_paths ... ok
[INFO] [stdout] test tests::current_dir::works_for_other_types ... ok
[INFO] [stdout] test tests::errors::result_types::missing_executable_file_error_message ... ok
[INFO] [stdout] test tests::errors::result_types::no_executable ... ok
[INFO] [stdout] test tests::errors::result_types::missing_executable_file_error_can_be_matched_against ... ok
[INFO] [stdout] test tests::errors::result_types::no_errors ... ok
[INFO] [stdout] test tests::errors::whitespace_in_executable_note::missing_executable_file_with_whitespace_includes_note ... ok
[INFO] [stdout] test tests::errors::whitespace_in_executable_note::single_argument ... ok
[INFO] [stdout] test tests::errors::result_types::non_zero_exit_codes ... ok
[INFO] [stdout] test tests::current_dir::sets_the_working_directory ... ok
[INFO] [stdout] test tests::errors::result_types::includes_full_command_on_io_errors ... ok
[INFO] [stdout] test tests::exit_status::one ... ok
[INFO] [stdout] test tests::exit_status::zero ... ok
[INFO] [stdout] test tests::exit_status::failing_commands_return_oks_when_exit_status_is_captured ... ok
[INFO] [stdout] foo
[INFO] [stdout] foo
[INFO] [stdout] test tests::log_commands::arguments_with_invalid_utf8_will_be_logged_with_lossy_conversion ... ok
[INFO] [stdout] test tests::log_commands::logs_commands_with_arguments ... ok
[INFO] [stdout] foo
[INFO] [stdout] test tests::invocation_syntax::trailing_comma_is_accepted_after_split_argument ... ok
[INFO] [stdout] test tests::log_commands::logs_simple_commands ... ok
[INFO] [stdout] test tests::log_commands::quotes_arguments_with_spaces ... ok
[INFO] [stdout] foo
[INFO] [stdout] test tests::invocation_syntax::trailing_comma_is_accepted_after_normal_argument ... ok
[INFO] [stdout] test tests::log_commands::quotes_empty_arguments ... ok
[INFO] [stdout] test tests::multiple_arguments_as_ref_str ... ok
[INFO] [stdout] test tests::paths::path_buf_as_argument ... ok
[INFO] [stdout] test tests::os_strings::works_for_os_str ... ok
[INFO] [stdout] test tests::os_strings::works_for_os_string ... ok
[INFO] [stderr]    Compiling libc v0.2.102
[INFO] [stderr]    Compiling autocfg v1.0.1
[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::allows_to_run_commands_with_dot_run ... ok
[INFO] [stdout] test tests::run_interface::allows_to_bundle_arguments_up_in_tuples ... ok
[INFO] [stdout] test tests::paths::ref_path_as_executable ... ok
[INFO] [stdout] test tests::run_interface::run_result ... ok
[INFO] [stdout] test tests::run_interface::run ... ok
[INFO] [stdout] test tests::run_interface::works_for_different_output_types ... ok
[INFO] [stdout] test tests::sequences::arrays_as_arguments ... ok
[INFO] [stdout] test tests::sequences::allows_to_pass_in_arguments_as_a_vec_of_ref_str ... ok
[INFO] [stdout] test tests::sequences::array_refs_as_arguments ... ok
[INFO] [stdout] test tests::sequences::arrays_of_non_strings ... ok
[INFO] [stdout] test tests::sequences::elements_in_array_refs_are_not_split_by_whitespace ... ok
[INFO] [stdout] test tests::sequences::slices_as_arguments ... ok
[INFO] [stdout] test tests::sequences::elements_in_arrays_are_not_split_by_whitespace ... ok
[INFO] [stdout] test tests::sequences::vector_of_non_strings ... ok
[INFO] [stdout] test tests::sequences::vector_of_vectors ... ok
[INFO] [stdout] test tests::sequences::slices_of_non_strings ... ok
[INFO] [stdout] test tests::sequences::elements_in_slices_are_not_split_by_whitespace ... ok
[INFO] [stdout] foo
[INFO] [stdout] test tests::split::percent_sign::in_run ... ok
[INFO] [stdout] test tests::split::percent_sign::in_run_result ... ok
[INFO] [stdout] test tests::split::percent_sign::splits_words ... ok
[INFO] [stdout] test tests::split::percent_sign::for_first_of_multiple_arguments ... ok
[INFO] [stdout] test tests::split::percent_sign::works_for_later_arguments ... ok
[INFO] [stdout] test tests::split::skips_multiple_whitespace_characters ... ok
[INFO] [stdout] test tests::split::percent_sign::non_literals ... ok
[INFO] [stdout] test tests::split::splits_words_by_whitespace ... ok
[INFO] [stdout] test tests::split::trims_leading_whitespace ... ok
[INFO] [stdout] test tests::split::trims_trailing_whitespace ... ok
[INFO] [stdout] test tests::splitting_with_library_functions::allow_to_use_split ... ok
[INFO] [stdout] test tests::splitting_with_library_functions::split_ascii_whitespace ... ok
[INFO] [stdout] test tests::splitting_with_library_functions::split_whitespace ... ok
[INFO] [stderr]    Compiling memoffset v0.6.4
[INFO] [stderr]    Compiling getrandom v0.2.3
[INFO] [stderr]    Compiling nix v0.21.1
[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.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 20.53s
[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::works_for_multiple_variables ... ok
[INFO] [stdout] test tests::environment_variables::overwrites_existing_parent_variables ... ok
[INFO] [stdout] test tests::environment_variables::child_processes_inherit_the_environment ... ok
[INFO] [stdout] test tests::environment_variables::variables_can_be_set_to_the_empty_string ... ok
[INFO] [stderr]    Compiling cradle v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.35s
[ERROR] error running command: stream did not contain valid UTF-8
[INFO] running `Command { std: "docker" "inspect" "05a0e44aee9710df7fd7e1394704046bd3ec28c137821058557a1359710a52c8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "05a0e44aee9710df7fd7e1394704046bd3ec28c137821058557a1359710a52c8", kill_on_drop: false }`
[INFO] [stdout] 05a0e44aee9710df7fd7e1394704046bd3ec28c137821058557a1359710a52c8