[INFO] fetching crate rez-next-rex 0.3.8...
[INFO] testing rez-next-rex-0.3.8 against 1.100.0-beta.1 for beta-1.100-2
[INFO] extracting crate rez-next-rex 0.3.8 into /workspace/builds/worker-7-tc2/source
[INFO] started tweaking crates.io crate rez-next-rex 0.3.8
[INFO] finished tweaking crates.io crate rez-next-rex 0.3.8
[INFO] tweaked toml for crates.io crate rez-next-rex 0.3.8 written to /workspace/builds/worker-7-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate rez-next-rex 0.3.8 on toolchain 1.100.0-beta.1
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate rez-next-rex 0.3.8 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.100.0-beta.1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/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] 505107f23fd469de446f26a418740c8e9d4b68cd289d893b76cd439f7e8496ec
[INFO] running `Command { std: "docker" "start" "505107f23fd469de446f26a418740c8e9d4b68cd289d893b76cd439f7e8496ec", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "505107f23fd469de446f26a418740c8e9d4b68cd289d893b76cd439f7e8496ec", 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" "505107f23fd469de446f26a418740c8e9d4b68cd289d893b76cd439f7e8496ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "505107f23fd469de446f26a418740c8e9d4b68cd289d893b76cd439f7e8496ec", 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" "505107f23fd469de446f26a418740c8e9d4b68cd289d893b76cd439f7e8496ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling unsafe-libyaml v0.2.11
[INFO] [stderr]    Compiling regex-automata v0.4.16
[INFO] [stderr]    Compiling syn v3.0.0
[INFO] [stderr]    Compiling serde_json v1.0.151
[INFO] [stderr]    Compiling serde_derive v1.0.229
[INFO] [stderr]    Compiling thiserror-impl v2.0.19
[INFO] [stderr]    Compiling thiserror v2.0.19
[INFO] [stderr]    Compiling regex v1.13.1
[INFO] [stderr]    Compiling serde v1.0.229
[INFO] [stderr]    Compiling serde_yaml v0.9.34+deprecated
[INFO] [stderr]    Compiling rez-next-common v0.3.8
[INFO] [stderr]    Compiling rez-next-rex v0.3.8 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 10.53s
[INFO] running `Command { std: "docker" "inspect" "505107f23fd469de446f26a418740c8e9d4b68cd289d893b76cd439f7e8496ec", 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" "505107f23fd469de446f26a418740c8e9d4b68cd289d893b76cd439f7e8496ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling rez-next-rex v0.3.8 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.75s
[INFO] running `Command { std: "docker" "inspect" "505107f23fd469de446f26a418740c8e9d4b68cd289d893b76cd439f7e8496ec", 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" "505107f23fd469de446f26a418740c8e9d4b68cd289d893b76cd439f7e8496ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.100.0-beta.1" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.04s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/build/rez-next-rex/02612fe5b106cc9c/out/rez_next_rex-02612fe5b106cc9c)
[INFO] [stdout] 
[INFO] [stdout] running 161 tests
[INFO] [stdout] test actions::tests::test_action_type_variants::test_append_path_with_custom_separator ... ok
[INFO] [stdout] test actions::tests::test_action_type_variants::test_command_variant ... ok
[INFO] [stdout] test actions::tests::test_action_type_variants::test_error_variant ... ok
[INFO] [stdout] test actions::tests::test_action_type_variants::test_stop_with_message ... ok
[INFO] [stdout] test actions::tests::test_action_type_variants::test_resetenv_variant ... ok
[INFO] [stdout] test actions::tests::test_action_type_variants::test_prepend_path_with_custom_separator ... ok
[INFO] [stdout] test actions::tests::test_action_type_variants::test_setenv_if_empty_variant_exists ... ok
[INFO] [stdout] test actions::tests::test_action_type_variants::test_comment_variant ... ok
[INFO] [stdout] test actions::tests::test_action_type_variants::test_info_variant ... ok
[INFO] [stdout] test actions::tests::test_serialization::test_prepend_path_roundtrip ... ok
[INFO] [stdout] test actions::tests::test_constructors::test_setenv_accepts_string_owned ... ok
[INFO] [stdout] test actions::tests::test_constructors::test_with_source_sets_package ... ok
[INFO] [stdout] test actions::tests::test_constructors::test_setenv_creates_correct_action ... ok
[INFO] [stdout] test actions::tests::test_constructors::test_unsetenv_creates_correct_action ... ok
[INFO] [stdout] test actions::tests::test_serialization::test_setenv_serializes_to_json ... ok
[INFO] [stdout] test actions::tests::test_constructors::test_with_source_chaining_overwrites ... ok
[INFO] [stdout] test actions::tests::test_action_type_variants::test_alias_variant ... ok
[INFO] [stdout] test actions::tests::test_constructors::test_append_path_creates_correct_action ... ok
[INFO] [stdout] test actions::tests::test_serialization::test_stop_with_none_message_roundtrip ... ok
[INFO] [stdout] test actions::tests::test_action_type_variants::test_stop_without_message ... ok
[INFO] [stdout] test actions::tests::test_action_type_variants::test_source_variant ... ok
[INFO] [stdout] test actions::tests::test_serialization::test_setenv_roundtrip ... ok
[INFO] [stdout] test actions::tests::test_constructors::test_prepend_path_creates_correct_action ... ok
[INFO] [stdout] test executor::phase_cmd_tests::test_pre_and_main_commands_accumulate_path ... ok
[INFO] [stdout] test executor::phase_cmd_tests::test_pre_build_commands_setenv_if_empty ... ok
[INFO] [stdout] test executor::phase_cmd_tests::test_pre_commands_then_commands_sequential ... ok
[INFO] [stdout] test executor::stop_error_tests::test_error_action_custom_context_var_expansion ... ok
[INFO] [stdout] test executor::stop_error_tests::test_actions_after_stop_are_not_applied ... ok
[INFO] [stdout] test executor::phase_cmd_tests::test_command_with_custom_context_var ... ok
[INFO] [stdout] test executor::phase_cmd_tests::test_multiple_commands_order_preserved ... ok
[INFO] [stdout] test executor::phase_cmd_tests::test_no_command_leaves_startup_commands_empty ... ok
[INFO] [stdout] test executor::phase_cmd_tests::test_post_commands_overrides_main ... ok
[INFO] [stdout] test executor::stop_error_tests::test_error_action_does_not_set_stopped ... ok
[INFO] [stdout] test executor::phase_cmd_tests::test_multi_phase_actions_source_tracking ... ok
[INFO] [stdout] test executor::phase_cmd_tests::test_command_with_version_expansion ... ok
[INFO] [stdout] test executor::phase_cmd_tests::test_command_mixed_with_setenv ... ok
[INFO] [stdout] test executor::phase_cmd_tests::test_command_with_root_expansion ... ok
[INFO] [stdout] test executor::stop_error_tests::test_error_action_recorded_in_info_messages ... ok
[INFO] [stdout] test executor::stop_error_tests::test_stop_with_message_sets_both_fields ... ok
[INFO] [stdout] test executor::tests::test_empty_commands_returns_empty_env ... ok
[INFO] [stdout] test executor::tests::test_context_variable_expansion_root ... ok
[INFO] [stdout] test executor::stop_error_tests::test_error_action_variable_expansion ... ok
[INFO] [stdout] test executor::stop_error_tests::test_error_then_stop_combined ... ok
[INFO] [stdout] test executor::stop_error_tests::test_stop_message_version_expansion ... ok
[INFO] [stdout] test executor::stop_error_tests::test_stop_message_name_expansion ... ok
[INFO] [stdout] test executor::stop_error_tests::test_stop_message_variable_expansion ... ok
[INFO] [stdout] test executor::tests::test_actions_have_correct_source_package ... ok
[INFO] [stdout] test executor::tests::test_execute_then_generate_bash_script ... ok
[INFO] [stdout] test executor::tests::test_context_variable_expansion_version ... ok
[INFO] [stdout] test executor::stop_error_tests::test_multiple_error_actions_all_recorded ... ok
[INFO] [stdout] test executor::tests::test_execute_alias ... ok
[INFO] [stdout] test executor::tests::test_execute_append_path ... ok
[INFO] [stdout] test executor::tests::test_execute_prepend_path ... ok
[INFO] [stdout] test executor::tests::test_execute_setenv ... ok
[INFO] [stdout] test executor::tests::test_package_commands_unsetenv ... ok
[INFO] [stdout] test executor::tests::test_execute_unsetenv ... ok
[INFO] [stdout] test executor::tests::test_package_commands_with_comments_and_blanks ... ok
[INFO] [stdout] test executor::tests::test_rez_this_context_variable_expansion ... ok
[INFO] [stdout] test executor::tests::test_setenv_if_empty_does_not_overwrite ... ok
[INFO] [stdout] test parser::tests::test_info_with_root_expansion ... ok
[INFO] [stdout] test parser::tests::test_info_message_recorded_in_env ... ok
[INFO] [stdout] test executor::tests::test_package_commands_python_simulation ... ok
[INFO] [stdout] test parser::tests::test_parse_command_executed_in_rex_environment ... ok
[INFO] [stdout] test parser::tests::test_parse_command_with_context_expansion ... ok
[INFO] [stdout] test executor::tests::test_sequential_package_commands_path_accumulation ... ok
[INFO] [stdout] test executor::tests::test_set_context_var ... ok
[INFO] [stdout] test executor::stop_error_tests::test_stop_action_does_not_populate_info_messages ... ok
[INFO] [stdout] test executor::stop_error_tests::test_stop_no_message_sets_stopped_flag ... ok
[INFO] [stdout] test executor::tests::test_package_commands_maya_simulation ... ok
[INFO] [stdout] test parser::tests::test_parse_comment_fn_double_quotes ... ok
[INFO] [stdout] test parser::tests::test_parse_command_empty_string ... ok
[INFO] [stdout] test parser::tests::test_parse_comment_fn_single_quotes ... ok
[INFO] [stdout] test parser::tests::test_parse_command_single_quotes ... ok
[INFO] [stdout] test parser::tests::test_parse_command_with_path_args ... ok
[INFO] [stdout] test parser::tests::test_parse_source_expands_via_executor ... ok
[INFO] [stdout] test parser::tests::test_parse_prepend_path ... ok
[INFO] [stdout] test executor::tests::test_multiple_commands_applied_in_order ... ok
[INFO] [stdout] test executor::tests::test_clear_resets_actions ... ok
[INFO] [stdout] test parser::tests::test_parse_resetenv_bare ... ok
[INFO] [stdout] test parser::tests::test_parse_resetenv_env_dotted ... ok
[INFO] [stdout] test parser::tests::test_parse_comment_fn_mixed_with_other_commands ... ok
[INFO] [stdout] test parser::tests::test_resetenv_removes_var_from_env ... ok
[INFO] [stdout] test parser::tests::test_parse_export ... ok
[INFO] [stdout] test parser::tests::test_stop_sets_stopped_flag ... ok
[INFO] [stdout] test parser::tests::test_parse_error_message ... ok
[INFO] [stdout] test parser::tests::test_parse_info_message ... ok
[INFO] [stdout] test shell::tests::test_bash_escapes_special_chars ... ok
[INFO] [stdout] test shell::tests::test_bash_alias_with_spaces_escaped ... ok
[INFO] [stdout] test shell::tests::test_bash_full_output ... ok
[INFO] [stdout] test shell::tests::test_bash_source_script ... ok
[INFO] [stdout] test shell::tests::test_bash_script_contains_export ... ok
[INFO] [stdout] test shell::tests::test_cmd_full_output ... ok
[INFO] [stdout] test shell::tests::test_cmd_call_script ... ok
[INFO] [stdout] test shell::tests::test_cmd_quotes_environment_values_with_metacharacters ... ok
[INFO] [stdout] test parser::tests::test_parse_source_double_quotes ... ok
[INFO] [stdout] test parser::tests::test_parse_command_double_quotes ... ok
[INFO] [stdout] test parser::tests::test_comment_fn_and_hash_comment_both_produce_comment_action ... ok
[INFO] [stdout] test shell::tests::test_empty_env_no_spurious_sections ... ok
[INFO] [stdout] test shell::tests::test_fish_script_uses_set_gx ... ok
[INFO] [stdout] test shell::tests::test_multiple_sources_order ... ok
[INFO] [stdout] test shell::tests::test_fish_full_output ... ok
[INFO] [stdout] test parser::tests::test_parse_unsetenv_shorthand ... ok
[INFO] [stdout] test shell::tests::test_powershell_braces_environment_names_with_special_characters ... ok
[INFO] [stdout] test shell::tests::test_powershell_dot_source ... ok
[INFO] [stdout] test shell::tests::test_powershell_escapes_single_quotes ... ok
[INFO] [stdout] test shell::tests::test_powershell_full_output ... ok
[INFO] [stdout] test shell::tests::test_fish_source_script ... ok
[INFO] [stdout] test shell::tests::test_shell_from_str_all_variants ... ok
[INFO] [stdout] test shell::tests::test_shell_type_from_str ... ok
[INFO] [stdout] test shell::tests::test_multiple_startup_commands_order ... ok
[INFO] [stdout] test shell::tests::test_powershell_script_uses_env_var ... ok
[INFO] [stdout] test shell::tests::test_cmd_script_uses_set ... ok
[INFO] [stdout] test shell::tests::test_empty_env_generates_header_only ... ok
[INFO] [stdout] test shell::tests::test_source_expands_with_executor ... ok
[INFO] [stdout] test tests::test_apply_misc::test_alias_recorded ... ok
[INFO] [stdout] test tests::test_apply_misc::test_command_added_to_startup ... ok
[INFO] [stdout] test shell::tests::test_zsh_same_as_bash ... ok
[INFO] [stdout] test tests::test_apply_misc::test_comment_is_ignored ... ok
[INFO] [stdout] test tests::test_apply_misc::test_error_recorded_as_info_with_prefix ... ok
[INFO] [stdout] test tests::test_apply_misc::test_error_does_not_abort_remaining_actions ... ok
[INFO] [stdout] test tests::test_apply_misc::test_info_recorded_in_messages ... ok
[INFO] [stdout] test tests::test_apply_misc::test_stop_aborts_remaining_actions ... ok
[INFO] [stdout] test tests::test_apply_misc::test_source_added_to_sourced_scripts ... ok
[INFO] [stdout] test tests::test_apply_misc::test_stop_with_message_stores_message ... ok
[INFO] [stdout] test tests::test_apply_misc::test_resetenv_removes_var ... ok
[INFO] [stdout] test shell::tests::test_startup_commands_included ... ok
[INFO] [stdout] test tests::test_apply_multiple_actions::test_apply_batch_of_actions ... ok
[INFO] [stdout] test tests::test_apply_multiple_actions::test_info_message_collected ... ok
[INFO] [stdout] test tests::test_apply_multiple_actions::test_multiple_stops_first_takes_effect ... ok
[INFO] [stdout] test tests::test_apply_misc::test_stop_sets_stopped_flag ... ok
[INFO] [stdout] test tests::test_apply_multiple_actions::test_apply_empty_actions ... ok
[INFO] [stdout] test parser::tests::test_unknown_rex_statement_is_rejected ... ok
[INFO] [stdout] test parser::tests::test_parse_source_single_quotes ... ok
[INFO] [stdout] test tests::test_apply_multiple_actions::test_very_long_var_name ... ok
[INFO] [stdout] test tests::test_apply_paths::test_append_path_on_empty_var ... ok
[INFO] [stdout] test tests::test_apply_paths::test_append_path_on_existing_var ... ok
[INFO] [stdout] test tests::test_apply_paths::test_prepend_path_on_empty_var ... ok
[INFO] [stdout] test parser::tests::test_parse_source_with_root_variable ... ok
[INFO] [stdout] test tests::test_apply_multiple_actions::test_unicode_var_name ... ok
[INFO] [stdout] test tests::test_apply_paths::test_prepend_then_append_order ... ok
[INFO] [stdout] test tests::test_apply_paths::test_setenv_if_empty_sets_when_absent ... ok
[INFO] [stdout] test tests::test_apply_setenv::test_setenv_overwrites_existing ... ok
[INFO] [stdout] test tests::test_merge_with_base::test_merge_does_not_overwrite_existing ... ok
[INFO] [stdout] test tests::test_merge_with_base::test_merge_adds_missing_base_vars ... ok
[INFO] [stdout] test tests::test_apply_setenv::test_setenv_sets_variable ... ok
[INFO] [stdout] test tests::test_apply_paths::test_prepend_path_on_existing_var ... ok
[INFO] [stdout] test tests::test_apply_paths::test_setenv_if_empty_does_not_overwrite ... ok
[INFO] [stdout] test tests::test_apply_setenv::test_unsetenv_nonexistent_is_noop ... ok
[INFO] [stdout] test tests::test_apply_setenv::test_unsetenv_removes_variable ... ok
[INFO] [stdout] test parser::tests::test_parse_multiple_commands ... ok
[INFO] [stdout] test tests::test_rex_environment_new::test_default_equals_new ... ok
[INFO] [stdout] test parser::tests::test_parse_mixed ... ok
[INFO] [stdout] test tests::test_rex_environment_new::test_new_is_empty ... ok
[INFO] [stdout] test tests::test_merge_with_base::test_merge_with_empty_base_is_noop ... ok
[INFO] [stdout] test tests::test_merge_with_base::test_merge_multiple_base_vars_all_added ... ok
[INFO] [stdout] test parser::tests::test_parse_stop_with_message ... ok
[INFO] [stdout] test parser::tests::test_parse_stop_no_message ... ok
[INFO] [stdout] test parser::tests::test_rex_statement_must_match_the_whole_line ... ok
[INFO] [stdout] test parser::tests::test_parse_setenv ... ok
[INFO] [stdout] test tests::test_apply_multiple_actions::test_very_long_var_value ... ok
[INFO] [stdout] test parser::tests::test_parse_source_mixed_with_other_commands ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 161 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.34s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests rez_next_rex
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "505107f23fd469de446f26a418740c8e9d4b68cd289d893b76cd439f7e8496ec", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "505107f23fd469de446f26a418740c8e9d4b68cd289d893b76cd439f7e8496ec", kill_on_drop: false }`
[INFO] [stdout] 505107f23fd469de446f26a418740c8e9d4b68cd289d893b76cd439f7e8496ec
