[INFO] fetching crate relux-resolver 0.5.0...
[INFO] testing relux-resolver-0.5.0 against 1.95.0 for beta-1.96-2
[INFO] extracting crate relux-resolver 0.5.0 into /workspace/builds/worker-0-tc1/source
[INFO] started tweaking crates.io crate relux-resolver 0.5.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate relux-resolver 0.5.0
[INFO] tweaked toml for crates.io crate relux-resolver 0.5.0 written to /workspace/builds/worker-0-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate relux-resolver 0.5.0 on toolchain 1.95.0
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.95.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate relux-resolver 0.5.0 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.95.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded humantime v2.3.0
[INFO] [stderr]   Downloaded relux-lexer v0.5.0
[INFO] [stderr]   Downloaded rand_core v0.10.1
[INFO] [stderr]   Downloaded relux-core v0.5.0
[INFO] [stderr]   Downloaded concolor v0.1.1
[INFO] [stderr]   Downloaded logos-derive v0.16.1
[INFO] [stderr]   Downloaded stacker v0.1.23
[INFO] [stderr]   Downloaded relux-ir v0.5.0
[INFO] [stderr]   Downloaded relux-ast v0.5.0
[INFO] [stderr]   Downloaded ar_archive_writer v0.5.1
[INFO] [stderr]   Downloaded rand v0.10.1
[INFO] [stderr]   Downloaded cc v1.2.60
[INFO] [stderr]   Downloaded winnow v0.7.15
[INFO] [stderr]   Downloaded yansi v1.0.1
[INFO] [stderr]   Downloaded logos-codegen v0.16.1
[INFO] [stderr]   Downloaded allocator-api2 v0.2.21
[INFO] [stderr]   Downloaded chumsky v0.12.0
[INFO] [stderr]   Downloaded ariadne v0.6.0
[INFO] [stderr]   Downloaded bs58 v0.5.1
[INFO] [stderr]   Downloaded psm v0.1.30
[INFO] [stderr]   Downloaded logos v0.16.1
[INFO] [stderr]   Downloaded regex-syntax v0.7.5
[INFO] [stderr]   Downloaded regex-automata v0.3.9
[INFO] [stderr]   Downloaded libc v0.2.185
[INFO] [stderr]   Downloaded relux-parser v0.5.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 21919c04de9d06b7f804d67e593ba46155c072f9ea3aff46ce8b3ef184290c31
[INFO] running `Command { std: "docker" "start" "-a" "21919c04de9d06b7f804d67e593ba46155c072f9ea3aff46ce8b3ef184290c31", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "21919c04de9d06b7f804d67e593ba46155c072f9ea3aff46ce8b3ef184290c31", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "21919c04de9d06b7f804d67e593ba46155c072f9ea3aff46ce8b3ef184290c31", kill_on_drop: false }`
[INFO] [stdout] 21919c04de9d06b7f804d67e593ba46155c072f9ea3aff46ce8b3ef184290c31
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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=warn" "-e" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ad320cab68516765ba1e485fad32f307a15f9fefef7b47aa6dc269d0c12f892e
[INFO] running `Command { std: "docker" "start" "-a" "ad320cab68516765ba1e485fad32f307a15f9fefef7b47aa6dc269d0c12f892e", kill_on_drop: false }`
[INFO] [stderr]    Compiling unicode-ident v1.0.24
[INFO] [stderr]    Compiling quote v1.0.45
[INFO] [stderr]    Compiling memchr v2.8.0
[INFO] [stderr]    Compiling libc v0.2.185
[INFO] [stderr]    Compiling object v0.37.3
[INFO] [stderr]    Compiling shlex v1.3.0
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]    Compiling regex-syntax v0.8.10
[INFO] [stderr]    Compiling rand_core v0.10.1
[INFO] [stderr]    Compiling find-msvc-tools v0.1.9
[INFO] [stderr]    Compiling hashbrown v0.17.0
[INFO] [stderr]    Compiling cpufeatures v0.3.0
[INFO] [stderr]    Compiling winnow v0.7.15
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling yansi v1.0.1
[INFO] [stderr]    Compiling unicode-width v0.2.2
[INFO] [stderr]    Compiling stable_deref_trait v1.2.1
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling same-file v1.0.6
[INFO] [stderr]    Compiling chacha20 v0.10.0
[INFO] [stderr]    Compiling cc v1.2.60
[INFO] [stderr]    Compiling elsa v1.11.2
[INFO] [stderr]    Compiling humantime v2.3.0
[INFO] [stderr]    Compiling fnv v1.0.7
[INFO] [stderr]    Compiling walkdir v2.5.0
[INFO] [stderr]    Compiling bs58 v0.5.1
[INFO] [stderr]    Compiling allocator-api2 v0.2.21
[INFO] [stderr]    Compiling foldhash v0.1.5
[INFO] [stderr]    Compiling unicode-segmentation v1.13.2
[INFO] [stderr]    Compiling aho-corasick v1.1.4
[INFO] [stderr]    Compiling hashbrown v0.15.5
[INFO] [stderr]    Compiling indexmap v2.14.0
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling is-terminal v0.4.17
[INFO] [stderr]    Compiling concolor v0.1.1
[INFO] [stderr]    Compiling rand v0.10.1
[INFO] [stderr]    Compiling uuid v1.23.1
[INFO] [stderr]    Compiling ariadne v0.6.0
[INFO] [stderr]    Compiling stacker v0.1.23
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling ar_archive_writer v0.5.1
[INFO] [stderr]    Compiling logos-codegen v0.16.1
[INFO] [stderr]    Compiling psm v0.1.30
[INFO] [stderr]    Compiling chumsky v0.12.0
[INFO] [stderr]    Compiling logos-derive v0.16.1
[INFO] [stderr]    Compiling logos v0.16.1
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling serde_spanned v0.6.9
[INFO] [stderr]    Compiling toml_datetime v0.6.11
[INFO] [stderr]    Compiling toml_edit v0.22.27
[INFO] [stderr]    Compiling toml v0.8.23
[INFO] [stderr]    Compiling relux-core v0.5.0
[INFO] [stderr]    Compiling relux-ast v0.5.0
[INFO] [stderr]    Compiling relux-lexer v0.5.0
[INFO] [stderr]    Compiling relux-ir v0.5.0
[INFO] [stderr]    Compiling relux-parser v0.5.0
[INFO] [stderr]    Compiling relux-resolver v0.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 33s
[INFO] running `Command { std: "docker" "inspect" "ad320cab68516765ba1e485fad32f307a15f9fefef7b47aa6dc269d0c12f892e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ad320cab68516765ba1e485fad32f307a15f9fefef7b47aa6dc269d0c12f892e", kill_on_drop: false }`
[INFO] [stdout] ad320cab68516765ba1e485fad32f307a15f9fefef7b47aa6dc269d0c12f892e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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=warn" "-e" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 600fe09f6698e7adbf8c540c60b9cf321782a2f1361e82e81ca22b4c8dfcccbd
[INFO] running `Command { std: "docker" "start" "-a" "600fe09f6698e7adbf8c540c60b9cf321782a2f1361e82e81ca22b4c8dfcccbd", kill_on_drop: false }`
[INFO] [stderr]    Compiling relux-resolver v0.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 10.10s
[INFO] running `Command { std: "docker" "inspect" "600fe09f6698e7adbf8c540c60b9cf321782a2f1361e82e81ca22b4c8dfcccbd", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "600fe09f6698e7adbf8c540c60b9cf321782a2f1361e82e81ca22b4c8dfcccbd", kill_on_drop: false }`
[INFO] [stdout] 600fe09f6698e7adbf8c540c60b9cf321782a2f1361e82e81ca22b4c8dfcccbd
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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=warn" "-e" "RUSTDOCFLAGS=--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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1.95.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 9639c90776eb85895be57df9de253cb28a7621172363fbc2061a8a2fcb7de256
[INFO] running `Command { std: "docker" "start" "-a" "9639c90776eb85895be57df9de253cb28a7621172363fbc2061a8a2fcb7de256", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.22s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/relux_resolver-c1b1a6c2298368b5)
[INFO] [stdout] 
[INFO] [stdout] running 27 tests
[INFO] [stdout] test loader::tests::in_memory_loader_empty ... ok
[INFO] [stdout] test loader::tests::in_memory_loader_returns_source ... ok
[INFO] [stdout] test loader::tests::in_memory_loader_returns_none ... ok
[INFO] [stdout] test loader::tests::load_missing_root_module ... ok
[INFO] [stdout] test loader::tests::load_already_loaded_skipped ... ok
[INFO] [stdout] test loader::tests::load_multiple_parse_errors_accumulated ... ok
[INFO] [stdout] test loader::tests::load_module_with_import ... ok
[INFO] [stdout] test loader::tests::load_missing_module_records_cause ... ok
[INFO] [stdout] test loader::tests::load_deeply_nested_transitive ... ok
[INFO] [stdout] test loader::tests::load_parse_error_other_modules_still_loaded ... ok
[INFO] [stdout] test loader::tests::load_parse_error_in_transitive_dep ... ok
[INFO] [stdout] test loader::tests::load_empty_source ... ok
[INFO] [stdout] test loader::tests::load_module_with_only_comments ... ok
[INFO] [stdout] test loader::tests::load_diamond_import ... ok
[INFO] [stdout] test loader::tests::load_lib_only_via_import ... ok
[INFO] [stdout] test loader::tests::load_empty_module ... ok
[INFO] [stdout] test loader::tests::load_missing_transitive_dep ... ok
[INFO] [stdout] test loader::tests::load_missing_module_other_modules_still_loaded ... ok
[INFO] [stdout] test loader::tests::load_multiple_missing_modules ... ok
[INFO] [stdout] test loader::tests::load_circular_import_no_error ... ok
[INFO] [stdout] test loader::tests::load_parse_error_records_cause ... ok
[INFO] [stdout] test loader::tests::load_multiple_test_modules ... ok
[INFO] [stdout] test loader::tests::load_single_module_no_imports ... ok
[INFO] [stdout] test loader::tests::load_transitive_imports ... ok
[INFO] [stdout] test loader::tests::load_circular_with_transitive ... ok
[INFO] [stdout] test loader::tests::load_source_stored_in_source_table ... ok
[INFO] [stdout] test loader::tests::load_unused_lib_not_loaded ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 27 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.19s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/ir_block.rs (/opt/rustwide/target/debug/deps/ir_block-94471d50284d0e46)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test ir_cleanup_block ... ok
[INFO] [stdout] test ir_shell_block ... ok
[INFO] [stdout] test ir_shell_block_empty_body ... ok
[INFO] [stdout] test ir_cleanup_block_empty_body ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/ir_comment.rs (/opt/rustwide/target/debug/deps/ir_comment-ca707ac65d8b8a2a)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test ir_comment_stub ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/ir_effect.rs (/opt/rustwide/target/debug/deps/ir_effect-ea97a674588b4d83)
[INFO] [stdout] 
[INFO] [stdout] running 38 tests
[INFO] [stdout] test ir_effect_start_no_overlay ... ok
[INFO] [stdout] test ir_effect_start_with_alias ... ok
[INFO] [stdout] test ir_effect_start_without_alias ... ok
[INFO] [stdout] test ir_effect_with_starts ... ok
[INFO] [stdout] test ir_overlay_entry ... ok
[INFO] [stdout] test lower_effect_cycle_self ... ok
[INFO] [stdout] test lower_effect_expose_invalid_shell ... ok
[INFO] [stdout] test lower_effect_expose_invalid_var ... ok
[INFO] [stdout] test lower_effect_cycle_deep ... ok
[INFO] [stdout] test lower_effect_expose_qualified_invalid_alias ... ok
[INFO] [stdout] test lower_effect_error_cached ... ok
[INFO] [stdout] test lower_effect_cycle_mutual ... ok
[INFO] [stdout] test lower_effect_expose_valid_local_shell ... ok
[INFO] [stdout] test lower_effect_let_accepts_var_ref ... ok
[INFO] [stdout] test lower_effect_no_expose_is_valid ... ok
[INFO] [stdout] test lower_effect_expose_local_with_alias ... ok
[INFO] [stdout] test lower_effect_let_rejects_impure_fn_call ... ok
[INFO] [stdout] test lower_effect_simple ... ok
[INFO] [stdout] test lower_effect_memoized ... ok
[INFO] [stdout] test lower_effect_expose_qualified_valid ... ok
[INFO] [stdout] test ir_effect_empty_starts ... ok
[INFO] [stdout] test lower_effect_expose_qualified_unexposed_shell ... ok
[INFO] [stdout] test lower_effect_start_with_alias ... ok
[INFO] [stdout] test lower_effect_start_without_alias ... ok
[INFO] [stdout] test lower_effect_expose_rejects_qualified_shell_name ... ok
[INFO] [stdout] test lower_effect_let_accepts_string_literal ... ok
[INFO] [stdout] test lower_effect_no_expect_is_valid ... ok
[INFO] [stdout] test lower_effect_let_accepts_pure_fn_call ... ok
[INFO] [stdout] test lower_effect_expect_vars ... ok
[INFO] [stdout] test lower_effect_undefined_start ... ok
[INFO] [stdout] test lower_effect_with_fn_calls ... ok
[INFO] [stdout] test lower_effect_with_cleanup ... ok
[INFO] [stdout] test lower_effect_with_let_vars ... ok
[INFO] [stdout] test lower_effect_with_overlay ... ok
[INFO] [stdout] test lower_effect_with_start ... ok
[INFO] [stdout] test lower_effect_recursive_start ... ok
[INFO] [stdout] test lower_overlay_accepts_pure_fn_call ... ok
[INFO] [stdout] test lower_overlay_rejects_impure_fn_call ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 38 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.37s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/ir_evaluator.rs (/opt/rustwide/target/debug/deps/ir_evaluator-583340bd2bea4eac)
[INFO] [stdout] 
[INFO] [stdout] running 36 tests
[INFO] [stdout] test eval_fn_last_expr_is_return ... ok
[INFO] [stdout] test eval_fn_empty_body ... ok
[INFO] [stdout] test eval_call_user_defined ... ok
[INFO] [stdout] test eval_call_builtin ... ok
[INFO] [stdout] test eval_fn_last_stmt_is_assign_returns_value ... ok
[INFO] [stdout] test eval_call_nested ... ok
[INFO] [stdout] test eval_fn_identity ... ok
[INFO] [stdout] test eval_fn_last_stmt_is_let_returns_value ... ok
[INFO] [stdout] test eval_fn_let_without_value ... ok
[INFO] [stdout] test eval_fn_nested_call ... ok
[INFO] [stdout] test eval_fn_param_overrides_outer_var ... ok
[INFO] [stdout] test eval_fn_multiple_params ... ok
[INFO] [stdout] test eval_fn_deeply_nested_call ... ok
[INFO] [stdout] test eval_fn_params_not_visible_after_return ... ok
[INFO] [stdout] test eval_fn_params_shadow_outer ... ok
[INFO] [stdout] test eval_fn_with_assign ... ok
[INFO] [stdout] test eval_fn_with_let ... ok
[INFO] [stdout] test eval_fn_with_multiple_lets ... ok
[INFO] [stdout] test eval_string_adjacent_vars ... ok
[INFO] [stdout] test eval_string_empty ... ok
[INFO] [stdout] test eval_string_escaped_dollar ... ok
[INFO] [stdout] test eval_interpolation_with_env_layer ... ok
[INFO] [stdout] test eval_string_only_var ... ok
[INFO] [stdout] test eval_string_var_shadows_env ... ok
[INFO] [stdout] test eval_string_with_var ... ok
[INFO] [stdout] test eval_var_empty_value ... ok
[INFO] [stdout] test eval_var_present ... ok
[INFO] [stdout] test eval_var_vars_shadow_env_layer ... ok
[INFO] [stdout] test eval_string_with_env_var ... ok
[INFO] [stdout] test eval_string_concatenation ... ok
[INFO] [stdout] test eval_string_missing_var ... ok
[INFO] [stdout] test eval_var_child_layer_shadows_parent ... ok
[INFO] [stderr]      Running tests/ir_expr.rs (/opt/rustwide/target/debug/deps/ir_expr-ec316f8b97e0478f)
[INFO] [stdout] test eval_var_from_env_layer ... ok
[INFO] [stdout] test eval_var_falls_through_to_base_env ... ok
[INFO] [stdout] test eval_string_literal ... ok
[INFO] [stdout] test eval_var_missing ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 36 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 21 tests
[INFO] [stdout] test ir_expr_capture_ref_variant ... ok
[INFO] [stdout] test ir_expr_capture_ref_index_zero ... ok
[INFO] [stdout] test ir_node_enum_span_different_values ... ok
[INFO] [stdout] test ir_expr_var_variant ... ok
[INFO] [stdout] test ir_node_enum_span_each_variant ... ok
[INFO] [stdout] test ir_pure_expr_all_three_variants ... ok
[INFO] [stdout] test ir_expr_call_variant ... ok
[INFO] [stdout] test ir_expr_string_variant ... ok
[INFO] [stdout] test lower_expr_call_multi_arg ... ok
[INFO] [stdout] test lower_expr_call_resolved ... ok
[INFO] [stdout] test lower_expr_capture_ref_multi_digit ... ok
[INFO] [stdout] test lower_pure_expr_rejects_capture_ref ... ok
[INFO] [stdout] test lower_expr_string ... ok
[INFO] [stdout] test lower_pure_expr_call ... ok
[INFO] [stdout] test lower_pure_expr_var ... ok
[INFO] [stdout] test lower_pure_expr_string ... ok
[INFO] [stdout] test lower_expr_capture_ref ... ok
[INFO] [stdout] test lower_pure_expr_string_rejects_capture_ref_in_parts ... ok
[INFO] [stdout] test lower_expr_var ... ok
[INFO] [stdout] test lower_expr_call_nested ... ok
[INFO] [stdout] test lower_expr_call_bif ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 31 tests
[INFO] [stderr]      Running tests/ir_func.rs (/opt/rustwide/target/debug/deps/ir_func-3ecd0216617bce45)
[INFO] [stdout] test ir_fn_builtin ... ok
[INFO] [stdout] test ir_fn_user_defined_empty_body ... ok
[INFO] [stdout] test ir_fn_user_defined ... ok
[INFO] [stdout] test ir_fn_user_defined_zero_params ... ok
[INFO] [stdout] test ir_pure_fn_user_defined ... ok
[INFO] [stdout] test ir_fn_builtin_arity_zero ... ok
[INFO] [stdout] test ir_pure_fn_builtin ... ok
[INFO] [stdout] test lower_fn_calls_other_fn ... ok
[INFO] [stdout] test lower_fn_multiple_params ... ok
[INFO] [stdout] test lower_fn_simple ... ok
[INFO] [stdout] test lower_fn_calls_bif ... ok
[INFO] [stdout] test lower_fn_zero_params ... ok
[INFO] [stdout] test lower_pure_fn_calls_pure_fn ... ok
[INFO] [stdout] test lower_fn_cycle_mutual ... ok
[INFO] [stdout] test lower_fn_calls_pure_fn ... ok
[INFO] [stdout] test lower_pure_fn_calls_pure_bif ... ok
[INFO] [stdout] test lower_fn_wrong_arity ... ok
[INFO] [stdout] test lower_fn_error_cached ... ok
[INFO] [stdout] test lower_fn_empty_body ... ok
[INFO] [stdout] test lower_fn_cycle_deep ... ok
[INFO] [stdout] test lower_fn_undefined_call ... ok
[INFO] [stdout] test lower_fn_cycle_self ... ok
[INFO] [stdout] test lower_fn_same_name_different_arity ... ok
[INFO] [stdout] test lower_pure_fn_cycle ... ok
[INFO] [stdout] test lower_fn_memoized ... ok
[INFO] [stdout] test lower_pure_fn_empty_body ... ok
[INFO] [stdout] test lower_pure_fn_rejects_shell_op ... ok
[INFO] [stdout] test lower_pure_fn_simple ... ok
[INFO] [stdout] test lower_pure_fn_rejects_impure_bif ... ok
[INFO] [stdout] test lower_pure_fn_transitive_purity_violation ... ok
[INFO] [stdout] test lower_pure_fn_memoized ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 31 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/ir_ident.rs (/opt/rustwide/target/debug/deps/ir_ident-8f067113baa7fa4a)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test ir_ident_empty_name ... ok
[INFO] [stdout] test ir_ident_name_and_span ... ok
[INFO] [stdout] test lower_ident_preserves_span_file ... ok
[INFO] [stdout] test lower_ident_name_and_span ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/ir_interpolation.rs (/opt/rustwide/target/debug/deps/ir_interpolation-6ce66a3aa757eefc)
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stdout] test ir_string_part_all_variants ... ok
[INFO] [stdout] test ir_interpolation_mixed_parts ... ok
[INFO] [stdout] test ir_interpolation_single_literal ... ok
[INFO] [stdout] test ir_interpolation_empty_parts ... ok
[INFO] [stdout] test lower_interpolation_adjacent_vars ... ok
[INFO] [stdout] test lower_string_part_literal ... ok
[INFO] [stdout] test lower_string_part_var ... ok
[INFO] [stdout] test lower_interpolation_mixed ... ok
[INFO] [stdout] test lower_string_part_capture_ref_zero ... ok
[INFO] [stdout] test lower_string_part_capture_ref ... ok
[INFO] [stdout] test lower_string_part_escaped_dollar ... ok
[INFO] [stdout] test lower_interpolation_single_part ... ok
[INFO] [stderr]      Running tests/ir_lower.rs (/opt/rustwide/target/debug/deps/ir_lower-aeac767ffe53f25f)
[INFO] [stdout] test lower_interpolation_empty ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 111 tests
[INFO] [stdout] test bif_entries_are_ok_builtin ... ok
[INFO] [stdout] test bif_arity_matches_definition ... ok
[INFO] [stdout] test bif_no_user_module_collides_with_builtin ... ok
[INFO] [stdout] test bif_module_path_is_builtin ... ok
[INFO] [stdout] test bifs_registered_in_fn_table ... ok
[INFO] [stdout] test context_new_has_empty_ir_registries ... ok
[INFO] [stdout] test context_new_preserves_ast_table ... ok
[INFO] [stdout] test context_new_preserves_env ... ok
[INFO] [stdout] test context_new_preserves_multiplier ... ok
[INFO] [stdout] test context_new_preserves_warning_table ... ok
[INFO] [stdout] test context_new_default_multiplier ... ok
[INFO] [stdout] test empty_test_body_is_invalid ... ok
[INFO] [stdout] test default_multiplier_leaves_tolerance_unscaled ... ok
[INFO] [stdout] test expect_satisfied_by_base_env ... ok
[INFO] [stdout] test cross_module_multiple_tests_across_modules ... ok
[INFO] [stdout] test expect_nested_effect_satisfied ... ok
[INFO] [stdout] test cross_module_diamond_import ... ok
[INFO] [stdout] test cross_module_fn_import ... ok
[INFO] [stdout] test cross_module_effect_import ... ok
[INFO] [stdout] test find_effect_cycle_not_on_stack ... ok
[INFO] [stdout] test expect_nested_unsatisfied_produces_invalid ... ok
[INFO] [stdout] test expect_satisfied_by_let_binding ... ok
[INFO] [stdout] test effect_lowering_uses_both_stacks ... ok
[INFO] [stdout] test context_new_has_empty_stacks ... ok
[INFO] [stdout] test expect_unsatisfied_produces_invalid ... ok
[INFO] [stdout] test effect_cycle_via_start ... ok
[INFO] [stdout] test completely_empty_test_is_invalid ... ok
[INFO] [stdout] test find_effect_cycle_self ... ok
[INFO] [stdout] test find_effect_cycle_chain ... ok
[INFO] [stdout] test find_fn_cycle_chain ... ok
[INFO] [stdout] test find_fn_cycle_chain_preserves_spans ... ok
[INFO] [stdout] test find_fn_cycle_self ... ok
[INFO] [stdout] test find_fn_cycle_not_on_stack ... ok
[INFO] [stdout] test fn_and_effect_stacks_independent ... ok
[INFO] [stdout] test find_fn_cycle_deep ... ok
[INFO] [stdout] test expect_satisfied_by_overlay ... ok
[INFO] [stdout] test find_fn_cycle_empty_stack ... ok
[INFO] [stdout] test expect_shallow_env_not_corrupted_by_sibling_start ... ok
[INFO] [stdout] test into_suite_empty ... ok
[INFO] [stdout] test impure_bifs_in_fn_table ... ok
[INFO] [stdout] test into_suite_transfers_env ... ok
[INFO] [stdout] test local_effect_table_initially_empty ... ok
[INFO] [stdout] test into_suite_transfers_causes ... ok
[INFO] [stdout] test impure_bifs_not_in_pure_fn_table ... ok
[INFO] [stdout] test local_fn_table_sees_registered_bifs ... ok
[INFO] [stdout] test local_fn_table_independent_locals ... ok
[INFO] [stdout] test into_suite_transfers_source_table ... ok
[INFO] [stdout] test into_suite_transfers_plans ... ok
[INFO] [stdout] test local_pure_fn_table_shares_registry ... ok
[INFO] [stdout] test fn_cycle_self_recursive ... ok
[INFO] [stdout] test cross_module_transitive_fn ... ok
[INFO] [stdout] test fn_cycle_cross_module ... ok
[INFO] [stdout] test invalid_dependency_propagates_to_caller ... ok
[INFO] [stdout] test fn_cycle_mutual_two ... ok
[INFO] [stdout] test lower_fn_from_different_modules_distinct ... ok
[INFO] [stdout] test lower_imported_effect_with_sub_starts ... ok
[INFO] [stdout] test lower_span_points_to_correct_file ... ok
[INFO] [stdout] test lower_imported_fn_call ... ok
[INFO] [stdout] test lower_deep_transitive_fn_call ... ok
[INFO] [stdout] test lower_undefined_call_span_covers_name ... ok
[INFO] [stdout] test lower_fn_invalid_propagates_to_caller ... ok
[INFO] [stdout] test fn_cycle_three_way ... ok
[INFO] [stdout] test lower_diamond_dependency_fn ... ok
[INFO] [stdout] test populate_empty_module ... ok
[INFO] [stdout] test memoization_shared_fn_lowered_once ... ok
[INFO] [stdout] test populate_aliased_effect_import ... ok
[INFO] [stdout] test memoization_fn_ok_and_error_independent ... ok
[INFO] [stdout] test lower_effect_invalid_propagates ... ok
[INFO] [stdout] test multiplier_scales_inline_timed_literal_match ... ok
[INFO] [stdout] test multiplier_does_not_scale_assertion_timeout ... ok
[INFO] [stdout] test memoization_shared_error_propagates ... ok
[INFO] [stdout] test lower_transitive_fn_call ... ok
[INFO] [stdout] test multiplier_scales_inline_timed_regex_match ... ok
[INFO] [stdout] test multiplier_scales_scoped_tolerance_timeout ... ok
[INFO] [stdout] test memoization_shared_effect_lowered_once ... ok
[INFO] [stdout] test populate_aliased_fn_import ... ok
[INFO] [stdout] test populate_fn_and_effect_same_name_ok ... ok
[INFO] [stdout] test populate_import_missing_effect_name ... ok
[INFO] [stdout] test populate_import_missing_module ... ok
[INFO] [stdout] test populate_multiple_imports ... ok
[INFO] [stdout] test populate_name_conflict_two_imports ... ok
[INFO] [stdout] test populate_name_conflict_own_and_import ... ok
[INFO] [stdout] test populate_name_conflict_reports_both_spans ... ok
[INFO] [stdout] test populate_name_conflict_wildcard ... ok
[INFO] [stdout] test populate_import_missing_fn_name ... ok
[INFO] [stdout] test populate_own_effect_definitions ... ok
[INFO] [stdout] test populate_own_fn_multiple_arities ... ok
[INFO] [stdout] test populate_own_pure_fn_definitions ... ok
[INFO] [stdout] test populate_selective_import_fn ... ok
[INFO] [stdout] test populate_own_fn_definitions ... ok
[INFO] [stdout] test populate_own_mixed_definitions ... ok
[INFO] [stdout] test populate_selective_import_effect ... ok
[INFO] [stdout] test register_cause_retrievable ... ok
[INFO] [stdout] test populate_selective_import_multiple ... ok
[INFO] [stdout] test register_cause_skip_variant ... ok
[INFO] [stdout] test register_cause_returns_id ... ok
[INFO] [stdout] test populate_wildcard_does_not_import_bifs ... ok
[INFO] [stdout] test push_pop_fn_stack_nested ... ok
[INFO] [stdout] test register_cause_invalid_variant ... ok
[INFO] [stdout] test register_multiple_causes ... ok
[INFO] [stdout] test test_with_only_comment_is_invalid ... ok
[INFO] [stdout] test undefined_effect_start ... ok
[INFO] [stdout] test push_pop_effect_stack ... ok
[INFO] [stdout] test skip_dependency_propagates_transitively ... ok
[INFO] [stdout] test push_pop_fn_stack ... ok
[INFO] [stdout] test test_with_no_shell_blocks_is_invalid ... ok
[INFO] [stdout] test context_new_preserves_cause_table ... ok
[INFO] [stdout] test populate_wildcard_import ... ok
[INFO] [stdout] test pure_bifs_registered_in_pure_fn_table ... ok
[INFO] [stdout] test lower_transitive_invalid_three_levels ... ok
[INFO] [stderr]      Running tests/ir_marker.rs (/opt/rustwide/target/debug/deps/ir_marker-874f4ed8da9cd05e)
[INFO] [stdout] test cross_module_plans_sorted_by_module_path ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 111 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 42 tests
[INFO] [stdout] test marker_flaky_with_skip_skip_wins ... ok
[INFO] [stdout] test marker_run_if_eq_no_match ... ok
[INFO] [stdout] test marker_flaky_unless_truthy_not_flaky ... ok
[INFO] [stdout] test marker_run_if_eq_match ... ok
[INFO] [stdout] test marker_run_met_on_fn_allows_test ... ok
[INFO] [stdout] test marker_run_if_bare_falsy ... ok
[INFO] [stdout] test marker_first_skip_triggers ... ok
[INFO] [stdout] test marker_flaky_unless_empty_is_flaky ... ok
[INFO] [stdout] test marker_flaky_if_falsy_not_flaky ... ok
[INFO] [stdout] test marker_flaky_if_truthy_sets_flag ... ok
[INFO] [stdout] test marker_run_if_bare_truthy ... ok
[INFO] [stdout] test marker_invalid_regex_in_condition ... ok
[INFO] [stdout] test marker_flaky_unconditional_sets_flag ... ok
[INFO] [stdout] test marker_no_flaky_by_default ... ok
[INFO] [stdout] test marker_run_unless_falsy ... ok
[INFO] [stdout] test marker_none_trigger ... ok
[INFO] [stdout] test marker_run_unconditional ... ok
[INFO] [stdout] test marker_skip_if_bare_truthy ... ok
[INFO] [stdout] test marker_skip_if_env_var ... ok
[INFO] [stdout] test marker_skip_if_bare_whitespace_is_truthy ... ok
[INFO] [stdout] test marker_skip_if_eq_match ... ok
[INFO] [stdout] test marker_skip_if_eq_no_match ... ok
[INFO] [stdout] test marker_skip_if_eq_both_empty ... ok
[INFO] [stdout] test marker_skip_if_pure_fn_call ... ok
[INFO] [stdout] test marker_second_skip_triggers ... ok
[INFO] [stdout] test marker_run_unless_truthy ... ok
[INFO] [stdout] test marker_run_if_regex_no_match ... ok
[INFO] [stdout] test marker_skip_if_regex_empty_value ... ok
[INFO] [stdout] test marker_skip_if_eq_one_empty ... ok
[INFO] [stdout] test marker_run_unmet_on_fn_propagates_skip_to_test ... ok
[INFO] [stdout] test marker_run_if_pure_fn_call_returns_empty ... ok
[INFO] [stdout] test marker_skip_on_effect_propagates_to_test ... ok
[INFO] [stdout] test marker_skip_on_fn_propagates_to_test ... ok
[INFO] [stdout] test marker_skip_unless_falsy ... ok
[INFO] [stdout] test marker_run_if_regex_match ... ok
[INFO] [stdout] test marker_skip_if_bare_falsy ... ok
[INFO] [stdout] test marker_skip_if_regex_no_match ... ok
[INFO] [stdout] test marker_skip_unless_truthy ... ok
[INFO] [stdout] test marker_skip_unconditional ... ok
[INFO] [stdout] test marker_skip_if_regex_match ... ok
[INFO] [stdout] test marker_undefined_fn_in_condition ... ok
[INFO] [stdout] test marker_skip_if_missing_env ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 42 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/ir_plan.rs (/opt/rustwide/target/debug/deps/ir_plan-a440a63387d2d3a6)
[INFO] [stdout] 
[INFO] [stdout] running 41 tests
[INFO] [stdout] test plan_effect_let_impure_fn_invalidates ... ok
[INFO] [stdout] test plan_invalid_has_cause_id ... ok
[INFO] [stdout] test plan_invalid_fn_cycle ... ok
[INFO] [stdout] test plan_invalid_multiple_causes ... ok
[INFO] [stdout] test build_all_plans_tests_within_module_in_order ... ok
[INFO] [stdout] test plan_invalid_variant ... ok
[INFO] [stdout] test plan_invalid_purity_violation ... ok
[INFO] [stdout] test plan_runnable_variant ... ok
[INFO] [stdout] test plan_invalid_undefined_effect ... ok
[INFO] [stdout] test plan_runnable_with_warnings ... ok
[INFO] [stdout] test plan_multiple_tests ... ok
[INFO] [stdout] test plan_own_skip_skips_body_lowering ... ok
[INFO] [stdout] test plan_invalid_undefined_fn ... ok
[INFO] [stdout] test plan_simple_test ... ok
[INFO] [stdout] test plan_skip_effect_dep_propagates ... ok
[INFO] [stdout] test plan_test_with_docstring ... ok
[INFO] [stdout] test plan_skip_has_cause_id ... ok
[INFO] [stdout] test plan_skipped_variant ... ok
[INFO] [stdout] test plan_skipped_multiple_causes ... ok
[INFO] [stdout] test plan_skip_bare_condition ... ok
[INFO] [stdout] test plan_multiple_effects ... ok
[INFO] [stdout] test plan_skip_unconditional ... ok
[INFO] [stdout] test plan_skip_fn_dep_propagates ... ok
[INFO] [stdout] test plan_test_with_cleanup ... ok
[INFO] [stdout] test plan_test_with_effect ... ok
[INFO] [stdout] test plan_test_let_impure_fn_invalidates ... ok
[INFO] [stdout] test plan_test_with_let ... ok
[INFO] [stdout] test plan_test_with_fn_call ... ok
[INFO] [stdout] test test_meta_with_all_fields ... ok
[INFO] [stdout] test plan_test_without_docstring ... ok
[INFO] [stdout] test plan_test_with_bif ... ok
[INFO] [stdout] test plan_test_without_timeout ... ok
[INFO] [stdout] test plan_test_with_pure_fn ... ok
[INFO] [stdout] test suite_has_source_table ... ok
[INFO] [stdout] test suite_has_all_plans ... ok
[INFO] [stdout] test plan_test_with_timeout ... ok
[INFO] [stdout] test suite_empty ... ok
[INFO] [stdout] test test_meta_minimal ... ok
[INFO] [stdout] test suite_mixed_variants ... ok
[INFO] [stdout] test suite_has_env ... ok
[INFO] [stdout] test effect_start_no_overlay_same_as_empty_overlay ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 41 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.17s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/ir_regex_validate.rs (/opt/rustwide/target/debug/deps/ir_regex_validate-5956e7e5ffc93337)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test lower_invalid_regex_match ... ok
[INFO] [stdout] test lower_invalid_regex_includes_error_message ... ok
[INFO] [stdout] test lower_invalid_regex_fail ... ok
[INFO] [stdout] test lower_regex_with_interpolation_not_validated ... ok
[INFO] [stdout] test lower_invalid_regex_timed_match ... ok
[INFO] [stdout] test lower_invalid_regex_includes_pattern ... ok
[INFO] [stdout] test lower_valid_regex ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/ir_shallow_env.rs (/opt/rustwide/target/debug/deps/ir_shallow_env-7be521a98ab47988)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test child_sees_own_and_parent ... ok
[INFO] [stdout] test with_name_adds_single_binding ... ok
[INFO] [stdout] test root_contains_env_keys ... ok
[INFO] [stdout] test three_level_chain ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/ir_stmt.rs (/opt/rustwide/target/debug/deps/ir_stmt-77caa7391e03c230)
[INFO] [stdout] 
[INFO] [stdout] running 55 tests
[INFO] [stdout] test ir_pure_stmt_assign ... ok
[INFO] [stdout] test ir_pure_stmt_let ... ok
[INFO] [stdout] test ir_shell_stmt_assign ... ok
[INFO] [stdout] test ir_shell_stmt_buffer_reset ... ok
[INFO] [stdout] test ir_shell_stmt_clear_fail_pattern ... ok
[INFO] [stdout] test ir_shell_stmt_expr ... ok
[INFO] [stdout] test ir_shell_stmt_fail_literal ... ok
[INFO] [stdout] test ir_shell_stmt_fail_regex ... ok
[INFO] [stdout] test ir_shell_stmt_let ... ok
[INFO] [stdout] test ir_shell_stmt_match_literal ... ok
[INFO] [stdout] test ir_shell_stmt_match_regex ... ok
[INFO] [stdout] test ir_shell_stmt_send ... ok
[INFO] [stdout] test ir_shell_stmt_timed_match_literal ... ok
[INFO] [stdout] test ir_shell_stmt_timed_match_regex ... ok
[INFO] [stderr]      Running tests/ir_tables.rs (/opt/rustwide/target/debug/deps/ir_tables-42518512fe7c4a46)
[INFO] [stdout] test lower_assign_stmt_basic ... ok
[INFO] [stdout] test lower_buffer_reset_regex ... ok
[INFO] [stdout] test lower_assign_stmt_with_call ... ok
[INFO] [stdout] test lower_buffer_reset_literal ... ok
[INFO] [stdout] test lower_let_stmt_no_value ... ok
[INFO] [stdout] test ir_pure_stmt_expr ... ok
[INFO] [stdout] test lower_let_stmt_with_value ... ok
[INFO] [stdout] test lower_match_literal_stmt ... ok
[INFO] [stdout] test lower_clear_fail_literal ... ok
[INFO] [stdout] test ir_shell_stmt_send_raw ... ok
[INFO] [stdout] test ir_shell_stmt_timeout ... ok
[INFO] [stdout] test lower_clear_fail_regex ... ok
[INFO] [stdout] test lower_fail_literal_stmt ... ok
[INFO] [stdout] test lower_pure_stmt_assign ... ok
[INFO] [stdout] test lower_pure_stmt_rejects_fail_literal ... ok
[INFO] [stdout] test lower_pure_stmt_rejects_buffer_reset ... ok
[INFO] [stdout] test lower_pure_stmt_let ... ok
[INFO] [stdout] test lower_pure_stmt_rejects_match_literal ... ok
[INFO] [stdout] test lower_pure_stmt_expr ... ok
[INFO] [stdout] test lower_pure_stmt_rejects_send_raw ... ok
[INFO] [stdout] test lower_pure_stmt_rejects_timeout ... ok
[INFO] [stdout] test lower_pure_stmt_rejects_fail_regex ... ok
[INFO] [stdout] test lower_pure_stmt_rejects_timed_match ... ok
[INFO] [stdout] test lower_pure_stmt_rejects_clear_fail ... ok
[INFO] [stdout] test lower_match_literal_with_var ... ok
[INFO] [stdout] test lower_match_regex_stmt ... ok
[INFO] [stdout] test lower_send_stmt ... ok
[INFO] [stdout] test lower_timeout_stmt_tolerance ... ok
[INFO] [stdout] test lower_timed_match_literal ... ok
[INFO] [stdout] test lower_send_stmt_with_var ... ok
[INFO] [stdout] test lower_match_regex_with_var ... ok
[INFO] [stdout] test lower_pure_stmt_rejects_match_regex ... ok
[INFO] [stdout] test lower_timeout_stmt_assertion ... ok
[INFO] [stdout] test lower_comments_pass_through ... ok
[INFO] [stdout] test lower_let_stmt_with_call_value ... ok
[INFO] [stdout] test lower_send_raw_stmt ... ok
[INFO] [stdout] test lower_pure_stmt_rejects_send ... ok
[INFO] [stdout] test lower_timed_match_assertion ... ok
[INFO] [stdout] test lower_fail_regex_stmt ... ok
[INFO] [stdout] test lower_timed_match_milliseconds ... ok
[INFO] [stdout] test lower_timed_match_regex ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 55 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test local_table_get_missing_global_returns_none ... ok
[INFO] [stdout] test local_table_get_span ... ok
[INFO] [stdout] test local_table_insert_and_get ... ok
[INFO] [stdout] test local_table_multiple_locals_same_global ... ok
[INFO] [stdout] test local_table_insert_overwrites ... ok
[INFO] [stdout] test local_table_registry_updated_after_insert ... ok
[INFO] [stdout] test local_table_get_span_missing ... ok
[INFO] [stdout] test local_table_get_missing_local_returns_none ... ok
[INFO] [stdout] test local_table_empty ... ok
[INFO] [stderr]      Running tests/ir_test_def.rs (/opt/rustwide/target/debug/deps/ir_test_def-cc5798b8434d3ef5)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test lower_test_comments_stripped ... ok
[INFO] [stdout] test lower_test_with_cleanup ... ok
[INFO] [stdout] test lower_test_simple ... ok
[INFO] [stdout] test lower_test_with_multiple_starts ... ok
[INFO] [stdout] test lower_test_calls_bif ... ok
[INFO] [stdout] test lower_test_let_accepts_string_literal ... ok
[INFO] [stdout] test lower_test_no_timeout ... ok
[INFO] [stdout] test lower_test_calls_fn ... ok
[INFO] [stdout] test lower_test_let_rejects_impure_fn_call ... ok
[INFO] [stdout] test lower_test_with_starts ... ok
[INFO] [stdout] test lower_test_let_accepts_pure_fn_call ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/ir_timeout.rs (/opt/rustwide/target/debug/deps/ir_timeout-bdb926020bddc4e7)
[INFO] [stdout] 
[INFO] [stdout] running 14 tests
[INFO] [stdout] test assertion_ignores_flaky_multiplier ... ok
[INFO] [stdout] test assertion_ignores_multiplier ... ok
[INFO] [stdout] test assertion_adjusted_is_raw ... ok
[INFO] [stdout] test tolerance_apply_multiplier ... ok
[INFO] [stdout] test tolerance_apply_multiplier_fractional ... ok
[INFO] [stdout] test tolerance_constructor_synthetic_span ... ok
[INFO] [stdout] test tolerance_default_multiplier ... ok
[INFO] [stdout] test tolerance_flaky_multiplier ... ok
[INFO] [stdout] test tolerance_scaled_fractional ... ok
[INFO] [stdout] test tolerance_flaky_multiplier_unit ... ok
[INFO] [stdout] test tolerance_scaled_applies_multiplier ... ok
[INFO] [stdout] test tolerance_scaled_with_unit_multiplier ... ok
[INFO] [stdout] test tolerance_apply_multiplier_zero ... ok
[INFO] [stderr]    Doc-tests relux_resolver
[INFO] [stdout] test tolerance_raw_duration ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.15s
[INFO] [stdout] 
[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" "9639c90776eb85895be57df9de253cb28a7621172363fbc2061a8a2fcb7de256", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9639c90776eb85895be57df9de253cb28a7621172363fbc2061a8a2fcb7de256", kill_on_drop: false }`
[INFO] [stdout] 9639c90776eb85895be57df9de253cb28a7621172363fbc2061a8a2fcb7de256
