[INFO] cloning repository https://github.com/noosehack/BLISP
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/noosehack/BLISP" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fnoosehack%2FBLISP", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fnoosehack%2FBLISP'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] bc76aad8bec835e1e12cdb85c548778310d666f8
[INFO] testing noosehack/BLISP against master#562dee4820c458d823175268e41601d4c060588a for pr-154210
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fnoosehack%2FBLISP" "/workspace/builds/worker-0-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-0-tc1/source'...
[INFO] [stderr] done.
[INFO] removed /workspace/builds/worker-0-tc1/source/rust-toolchain.toml
[INFO] started tweaking git repo https://github.com/noosehack/BLISP
[INFO] finished tweaking git repo https://github.com/noosehack/BLISP
[INFO] tweaked toml for git repo https://github.com/noosehack/BLISP written to /workspace/builds/worker-0-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/noosehack/BLISP on toolchain 562dee4820c458d823175268e41601d4c060588a
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/noosehack/BLISP 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" "+562dee4820c458d823175268e41601d4c060588a" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating git repository `https://github.com/noosehack/blawktrust`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded fd-lock v3.0.13
[INFO] [stderr]   Downloaded rustyline v12.0.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" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] dd15205c5f64b410545406056294396c10847864234c6e3d867406fa02912546
[INFO] running `Command { std: "docker" "start" "-a" "dd15205c5f64b410545406056294396c10847864234c6e3d867406fa02912546", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "dd15205c5f64b410545406056294396c10847864234c6e3d867406fa02912546", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dd15205c5f64b410545406056294396c10847864234c6e3d867406fa02912546", kill_on_drop: false }`
[INFO] [stdout] dd15205c5f64b410545406056294396c10847864234c6e3d867406fa02912546
[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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] aad035a54dd7bb104f672ae963738f68a7836fd9d67171983e06b2631c5b1fec
[INFO] running `Command { std: "docker" "start" "-a" "aad035a54dd7bb104f672ae963738f68a7836fd9d67171983e06b2631c5b1fec", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.182
[INFO] [stderr]    Compiling rustix v0.38.44
[INFO] [stderr]    Compiling linux-raw-sys v0.4.15
[INFO] [stderr]    Compiling radium v0.7.0
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling bitflags v2.11.0
[INFO] [stderr]    Compiling tap v1.0.1
[INFO] [stderr]    Compiling funty v2.0.0
[INFO] [stderr]    Compiling csv-core v0.1.13
[INFO] [stderr]    Compiling blawktrust v0.1.0 (https://github.com/noosehack/blawktrust?tag=v0.1.1-orientation-stable#daf29d32)
[INFO] [stderr]    Compiling wyz v0.5.1
[INFO] [stderr]    Compiling bitvec v1.0.1
[INFO] [stderr]    Compiling nix v0.26.4
[INFO] [stderr]    Compiling csv v1.4.0
[INFO] [stderr]    Compiling fd-lock v3.0.13
[INFO] [stderr]    Compiling rustyline v12.0.0
[INFO] [stderr]    Compiling blisp v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 13.61s
[INFO] running `Command { std: "docker" "inspect" "aad035a54dd7bb104f672ae963738f68a7836fd9d67171983e06b2631c5b1fec", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "aad035a54dd7bb104f672ae963738f68a7836fd9d67171983e06b2631c5b1fec", kill_on_drop: false }`
[INFO] [stdout] aad035a54dd7bb104f672ae963738f68a7836fd9d67171983e06b2631c5b1fec
[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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 059a341292d04f522ea997603d793ac8a7a0ca919eefec9b395e1610d261676c
[INFO] running `Command { std: "docker" "start" "-a" "059a341292d04f522ea997603d793ac8a7a0ca919eefec9b395e1610d261676c", kill_on_drop: false }`
[INFO] [stderr]    Compiling unicode-ident v1.0.24
[INFO] [stderr]    Compiling zerocopy v0.8.40
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling getrandom v0.4.1
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling regex-syntax v0.8.10
[INFO] [stderr]    Compiling linux-raw-sys v0.12.1
[INFO] [stderr]    Compiling clap_lex v1.0.0
[INFO] [stderr]    Compiling csv v1.4.0
[INFO] [stderr]    Compiling wait-timeout v0.2.1
[INFO] [stderr]    Compiling quick-error v1.2.3
[INFO] [stderr]    Compiling bit-vec v0.8.0
[INFO] [stderr]    Compiling is-terminal v0.4.17
[INFO] [stderr]    Compiling unarray v0.1.4
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling clap_builder v4.5.60
[INFO] [stderr]    Compiling bit-set v0.8.0
[INFO] [stderr]    Compiling quote v1.0.44
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling blisp v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling rand_xorshift v0.4.0
[INFO] [stderr]    Compiling clap v4.5.60
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling tempfile v3.26.0
[INFO] [stderr]    Compiling rusty-fork v0.3.1
[INFO] [stderr]    Compiling zerocopy-derive v0.8.40
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling ciborium-ll v0.2.2
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling ciborium v0.2.2
[INFO] [stderr]    Compiling proptest v1.10.0
[INFO] [stderr]    Compiling criterion v0.5.1
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 28.66s
[INFO] running `Command { std: "docker" "inspect" "059a341292d04f522ea997603d793ac8a7a0ca919eefec9b395e1610d261676c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "059a341292d04f522ea997603d793ac8a7a0ca919eefec9b395e1610d261676c", kill_on_drop: false }`
[INFO] [stdout] 059a341292d04f522ea997603d793ac8a7a0ca919eefec9b395e1610d261676c
[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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 28be74dcb8a55e7afdf31d329edfc2ddd6cc3b863f3ac8bec7bb812e4a3e033e
[INFO] running `Command { std: "docker" "start" "-a" "28be74dcb8a55e7afdf31d329edfc2ddd6cc3b863f3ac8bec7bb812e4a3e033e", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.18s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/blisp-0e22cf48e98396c9)
[INFO] [stdout] 
[INFO] [stdout] running 151 tests
[INFO] [stdout] test ast::tests::test_interner ... ok
[INFO] [stdout] test builtins::test_sum0_aggregation ... ok
[INFO] [stdout] test builtins::test_mean_aggregation ... ok
[INFO] [stdout] test builtins::test_mean0_aggregation ... ok
[INFO] [stdout] test builtins::test_sum_aggregation ... ok
[INFO] [stdout] test builtins::tests::test_abs ... ok
[INFO] [stdout] test builtins::tests::test_add_column_scalar ... ok
[INFO] [stdout] test builtins::tests::test_add_float_int ... ok
[INFO] [stdout] test builtins::tests::test_col_extraction_with_string ... ok
[INFO] [stdout] test builtins::tests::test_add_scalars ... ok
[INFO] [stdout] test builtins::tests::test_col_extraction ... ok
[INFO] [stdout] test builtins::tests::test_diff ... ok
[INFO] [stdout] test ast::tests::test_expr_types ... ok
[INFO] [stdout] test builtins::tests::test_len_col ... ok
[INFO] [stdout] test builtins::tests::test_type_of ... ok
[INFO] [stdout] test builtins::tests::test_w_extraction ... ok
[INFO] [stdout] test builtins::tests::test_shift ... ok
[INFO] [stdout] test env::tests::test_global_define_resolve ... ok
[INFO] [stdout] test env::tests::test_lexical_shadowing ... ok
[INFO] [stdout] test builtins::tests::test_div_by_zero ... ok
[INFO] [stdout] test builtins::tests::test_mul_column_scalar ... ok
[INFO] [stdout] test builtins::tests::test_mul_scalars ... ok
[INFO] [stdout] test env::tests::test_lexical_depth ... ok
[INFO] [stdout] test env::tests::test_lexical_set ... ok
[INFO] [stdout] test env::tests::test_global_update ... ok
[INFO] [stdout] test eval::tests::test_eval_complex_expression ... ok
[INFO] [stdout] test eval::tests::test_eval_defparameter ... ok
[INFO] [stdout] test eval::tests::test_eval_let_star ... ok
[INFO] [stdout] test eval::tests::test_eval_let_star_shadowing ... ok
[INFO] [stdout] test eval::tests::test_eval_if_nested ... ok
[INFO] [stdout] test builtins::tests::test_div_scalars ... ok
[INFO] [stdout] test builtins::tests::test_dlog ... ok
[INFO] [stdout] test eval::tests::test_eval_setf ... ok
[INFO] [stdout] test eval::tests::test_undefined_variable_error ... ok
[INFO] [stdout] test eval::tests::test_eval_nested_let_star ... ok
[INFO] [stdout] test eval::tests::test_eval_if ... ok
[INFO] [stdout] test eval::tests::test_unknown_function_error ... ok
[INFO] [stdout] test eval::tests::test_eval_let_star_sequential ... ok
[INFO] [stdout] test eval::tests::test_eval_literals ... ok
[INFO] [stdout] test eval::tests::test_eval_progn ... ok
[INFO] [stdout] test eval::tests::test_eval_quote ... ok
[INFO] [stdout] test exec::tests::test_dlog_kernel_equivalence ... ok
[INFO] [stdout] test exec::tests::test_dlog_semantic_divergence ... ok
[INFO] [stdout] test exec::tests::test_shift_equivalence_clean ... ok
[INFO] [stdout] test env::tests::test_lexical_single_frame ... ok
[INFO] [stdout] test exec::tests::test_shift_ir_routing ... ok
[INFO] [stdout] test exec::tests::test_shift_obs_kernel_with_mask ... ok
[INFO] [stdout] test exec::tests::test_shift_ofs_kernel ... ok
[INFO] [stdout] test frame::tests::property_arc_preservation_numeric_ops ... ok
[INFO] [stdout] test exec::tests::test_shift_semantic_divergence ... ok
[INFO] [stdout] test frame::tests::property_asofr_equivalence_to_naive ... ok
[INFO] [stdout] test frame::tests::property_asofr_identity_when_indices_match ... ok
[INFO] [stdout] test frame::tests::property_asofr_no_forward_looking_bias ... ok
[INFO] [stdout] test frame::tests::property_asofr_idempotence ... ok
[INFO] [stdout] test frame::tests::property_mapr_idempotence ... ok
[INFO] [stdout] test frame::tests::property_no_forward_looking_bias ... ok
[INFO] [stdout] test frame::tests::property_mapr_monotonicity ... ok
[INFO] [stdout] test frame::tests::property_mapr_identity_when_indices_match ... ok
[INFO] [stdout] test frame::tests::test_asofr_basic_carry_forward ... ok
[INFO] [stdout] test frame::tests::test_frame_creation ... ok
[INFO] [stdout] test frame::tests::test_i1_i2_i3_with_dlog ... ok
[INFO] [stdout] test frame::tests::test_reindex_by_reordering ... ok
[INFO] [stdout] test frame::tests::test_map_numeric_preserve_tags_invariants ... ok
[INFO] [stdout] test frame::tests::property_asofr_monotonicity ... ok
[INFO] [stdout] test frame::tests::test_asofr_no_past_values ... ok
[INFO] [stdout] test frame::tests::test_index_column_len ... ok
[INFO] [stdout] test frame::tests::test_reindex_by_semantics_right_outer_join ... ok
[INFO] [stdout] test frame::tests::test_tags_creation ... ok
[INFO] [stdout] test io::tests::test_load_csv_mixed_types ... ok
[INFO] [stdout] test io::tests::test_parse_csv_header_trimming ... ok
[INFO] [stdout] test io::tests::test_load_csv_with_dates ... ok
[INFO] [stdout] test io::tests::test_parse_csv_simple ... ok
[INFO] [stdout] test frame::tests::test_reindex_by_with_missing_rows ... ok
[INFO] [stdout] test frame::tests::test_tags_arc_clone ... ok
[INFO] [stdout] test io::tests::test_detect_date_vs_timestamp ... ok
[INFO] [stdout] test io::tests::test_load_csv_with_timestamps ... ok
[INFO] [stdout] test io::tests::test_is_date_format ... ok
[INFO] [stdout] test io::tests::test_parse_csv_with_na ... ok
[INFO] [stdout] test io::tests::test_parse_date_or_null ... ok
[INFO] [stdout] test io::tests::test_parse_timestamp_fractional_seconds ... ok
[INFO] [stdout] test io::tests::test_parse_timestamp_roundtrip ... ok
[INFO] [stdout] test io::tests::test_type_detection_with_leading_na ... ok
[INFO] [stdout] test exec::tests::test_dlog_ir_routing ... ok
[INFO] [stdout] test frame::tests::test_reindex_by_all_matching ... ok
[INFO] [stdout] test io::tests::test_bloomberg_style_csv ... ok
[INFO] [stdout] test io::tests::test_parse_csv_with_dates ... ok
[INFO] [stdout] test io::tests::test_parse_date_leap_years ... ok
[INFO] [stdout] test io::tests::test_parse_date_roundtrip ... ok
[INFO] [stdout] test io::tests::test_parse_date_to_days ... ok
[INFO] [stdout] test io::tests::test_parse_numeric_with_na ... ok
[INFO] [stdout] test ir::tests::test_index_type_mismatch ... ok
[INFO] [stdout] test ir::tests::test_join_op ... ok
[INFO] [stdout] test ir::tests::test_plan_creation ... ok
[INFO] [stdout] test ir_fusion::tests::test_tripwire_cs1_dlog_fusion ... ok
[INFO] [stdout] test mask::tests::test_compile_mask_name ... ok
[INFO] [stdout] test mask::tests::test_compile_mask_not ... ok
[INFO] [stdout] test normalize::tests::test_idempotence ... ok
[INFO] [stdout] test ir_fusion::tests::test_tripwire_elementwise_fusion ... ok
[INFO] [stdout] test ir_fusion::tests::test_tripwire_cs1_elementwise_fusion ... ok
[INFO] [stdout] test normalize::tests::test_normalize_simple_list ... ok
[INFO] [stdout] test normalize::tests::test_recursive_normalization ... ok
[INFO] [stdout] test normalize::tests::test_thread_first_chain ... ok
[INFO] [stdout] test normalize::tests::test_thread_first_identity ... ok
[INFO] [stdout] test normalize::tests::test_thread_first_single ... ok
[INFO] [stdout] test planner::tests::test_plan_file_source ... ok
[INFO] [stdout] test planner::tests::test_plan_join_mapr ... ok
[INFO] [stdout] test normalize::tests::test_thread_first_bare_symbol ... ok
[INFO] [stdout] test planner::tests::test_plan_let_binding ... ok
[INFO] [stdout] test planner::tests::test_plan_thread_first ... ok
[INFO] [stdout] test planner::tests::test_plan_unary_dlog ... ok
[INFO] [stdout] test reader::tests::test_comment ... ok
[INFO] [stdout] test mask::tests::test_empty_active_mask ... ok
[INFO] [stdout] test mask::tests::test_mask_set_insert ... ok
[INFO] [stdout] test reader::tests::test_read_list ... ok
[INFO] [stdout] test normalize::tests::test_nested_thread_first ... ok
[INFO] [stdout] test reader::tests::test_read_simple ... ok
[INFO] [stdout] test reader::tests::test_tokenize ... ok
[INFO] [stdout] test runtime::tests::test_interner_integration ... ok
[INFO] [stdout] test env::tests::test_lexical_set_updates_correct_frame ... ok
[INFO] [stdout] test mask::tests::test_compile_mask_or ... ok
[INFO] [stdout] test normalize::tests::test_normalize_atoms ... ok
[INFO] [stdout] test reader::tests::test_read_quote ... ok
[INFO] [stdout] test reader::tests::test_read_string ... ok
[INFO] [stdout] test ir::tests::test_unary_op ... ok
[INFO] [stdout] test ir::tests::test_unary_breaks_invariants ... ok
[INFO] [stdout] test value::tests::test_as_int ... ok
[INFO] [stdout] test runtime::tests::test_resolve_undefined ... ok
[INFO] [stdout] test runtime::tests::test_multiple_frames ... ok
[INFO] [stdout] test runtime::tests::test_setf_creates_global_if_not_exists ... ok
[INFO] [stdout] test runtime::tests::test_setf_global ... ok
[INFO] [stdout] test runtime::tests::test_setf_lexical ... ok
[INFO] [stdout] test value::tests::test_col_type ... ok
[INFO] [stdout] test value::tests::test_clone ... ok
[INFO] [stdout] test verify::tests::test_ieee_equal_finite ... ok
[INFO] [stdout] test value::tests::test_display ... ok
[INFO] [stdout] test value::tests::test_is_truthy ... ok
[INFO] [stdout] test value::tests::test_table_add_column ... ok
[INFO] [stdout] test value::tests::test_table_type ... ok
[INFO] [stdout] test value::tests::test_value_types ... ok
[INFO] [stdout] test verify::tests::test_ieee_equal_inf ... ok
[INFO] [stdout] test verify::tests::test_ieee_equal_nan ... ok
[INFO] [stdout] test runtime::tests::test_resolve_global ... ok
[INFO] [stdout] test value::tests::test_as_float ... ok
[INFO] [stdout] test ir_fusion::proptests::prop_optimizer_preserves_semantics ... ok
[INFO] [stdout] test runtime::tests::test_lexical_shadows_global ... ok
[INFO] [stdout] test exec::tests::test_exec_dlog ... ok
[INFO] [stdout] test exec::tests::test_exec_file_source ... ok
[INFO] [stdout] test exec::tests::test_exec_thread_first ... ok
[INFO] [stdout] test io::tests::test_save_and_load_csv ... ok
[INFO] [stdout] test ir_fusion::proptests::prop_optimizer_is_idempotent ... ok
[INFO] [stdout] test runtime::tests::test_resolve_lexical ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 151 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.35s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/blisp-bbf79e32eb06c5ab)
[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] [stderr]      Running tests/blawktrust_api_integration.rs (/opt/rustwide/target/debug/deps/blawktrust_api_integration-d196cef6913617ee)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test test_column_has_nulls ... ok
[INFO] [stdout] test test_column_types_exist ... ok
[INFO] [stdout] test test_column_pattern_matching ... ok
[INFO] [stdout] test test_null_sentinels_exist ... ok
[INFO] [stdout] test test_csv_io_column_usage ... ok
[INFO] [stdout] test test_orientation_operations ... ok
[INFO] [stdout] test test_table_clone ... ok
[INFO] [stdout] test test_tableview_and_orientations ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.14s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/differential_exec.rs (/opt/rustwide/target/debug/deps/differential_exec-89f968f2f732a383)
[INFO] [stdout] 
[INFO] [stdout] running 15 tests
[INFO] [stdout] test common::tests::test_frame_equiv_cloned ... ok
[INFO] [stdout] test common::tests::test_direct_eval_dlog ... ok
[INFO] [stdout] test common::tests::test_expr_gen_depth_0 ... ok
[INFO] [stdout] test common::tests::test_direct_eval_var ... ok
[INFO] [stdout] test common::tests::test_expr_gen_depth_1 ... ok
[INFO] [stdout] test diff_prop_small_date_frames ... ignored, Random expr generator hits unimplemented AST ops. Will be replaced by proper differential fuzz (step 3) with approved safe-ops subset.
[INFO] [stdout] test diff_prop_small_timestamp_frames ... ignored, Random expr generator hits unimplemented AST ops. Will be replaced by proper differential fuzz (step 3) with approved safe-ops subset.
[INFO] [stdout] test common::tests::test_frame_equiv_identical ... ok
[INFO] [stdout] test diff_small_join_asofr ... ok
[INFO] [stdout] test diff_small_nested_pipeline ... ok
[INFO] [stdout] test diff_small_pipeline ... ok
[INFO] [stdout] test diff_small_let_binding ... ok
[INFO] [stdout] test diff_small_join_mapr ... ok
[INFO] [stdout] test diff_small_unary_dlog ... ok
[INFO] [stderr]      Running tests/ieee_dlog_obs_tripwire.rs (/opt/rustwide/target/debug/deps/ieee_dlog_obs_tripwire-2a1b3b3bfec2982b)
[INFO] [stdout] test common::tests::test_frame_equiv_different_rows - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 2 ignored; 0 measured; 0 filtered out; finished in 0.08s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test tripwire_dlog_obs_ln_zero_gives_neg_inf ... ok
[INFO] [stdout] test tripwire_dlog_obs_na_propagation ... ok
[INFO] [stdout] test tripwire_dlog_obs_zero_denominator_gives_pos_inf ... ok
[INFO] [stdout] test tripwire_dlog_obs_zero_over_zero_gives_nan ... ok
[INFO] [stdout] test tripwire_dlog_obs_negative_gives_nan ... ok
[INFO] [stdout] test tripwire_fused_dlog_obs_elementwise_matches_unfused ... ok
[INFO] [stdout] test tripwire_fused_cs1_dlog_obs_matches_unfused_edge_cases ... ok
[INFO] [stdout] test tripwire_regression_cs1_exp_inv_dlog_cs1 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/ir_equivalence.rs (/opt/rustwide/target/debug/deps/ir_equivalence-afd0dbae722744f6)
[INFO] [stdout] 
[INFO] [stdout] running 9 tests
[INFO] [stdout] test ir_equiv_date_frames ... ignored, Known issue: NA handling mismatch in IR execution (NaN vs valid values). Needs investigation.
[INFO] [stdout] test ir_equiv_timestamp_frames ... ignored, Known issue: NA handling mismatch in IR execution (NaN vs valid values). Needs investigation.
[INFO] [stdout] test common::tests::test_expr_gen_depth_1 ... ok
[INFO] [stdout] test common::tests::test_frame_equiv_identical ... ok
[INFO] [stdout] test common::tests::test_frame_equiv_cloned ... ok
[INFO] [stdout] test common::tests::test_expr_gen_depth_0 ... ok
[INFO] [stdout] test common::tests::test_direct_eval_dlog ... ok
[INFO] [stdout] test common::tests::test_direct_eval_var ... ok
[INFO] [stderr]      Running tests/ir_equivalence_smoke.rs (/opt/rustwide/target/debug/deps/ir_equivalence_smoke-4d9cec9a2d814f38)
[INFO] [stdout] test common::tests::test_frame_equiv_different_rows - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 2 ignored; 0 measured; 0 filtered out; finished in 0.08s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 48 tests
[INFO] [stdout] test common::tests::test_expr_gen_depth_1 ... ok
[INFO] [stdout] test common::tests::test_direct_eval_dlog ... ok
[INFO] [stdout] test common::tests::test_direct_eval_var ... ok
[INFO] [stdout] test common::tests::test_expr_gen_depth_0 ... ok
[INFO] [stdout] test common::tests::test_frame_equiv_cloned ... ok
[INFO] [stdout] test common::tests::test_frame_equiv_identical ... ok
[INFO] [stdout] test smoke_asofr ... ok
[INFO] [stdout] test smoke_binary_after_join ... ok
[INFO] [stdout] test smoke_let_sequential_binding ... ok
[INFO] [stdout] test smoke_binary_pipeline_with_scalar ... ok
[INFO] [stdout] test smoke_binary_scalar_add ... ok
[INFO] [stdout] test smoke_dlog_identity_handcrafted ... ok
[INFO] [stdout] test smoke_mapr ... ok
[INFO] [stdout] test smoke_binary_scalar_div ... ok
[INFO] [stdout] test smoke_join_after_unary ... ok
[INFO] [stdout] test smoke_binary_scalar_sub ... ok
[INFO] [stdout] test smoke_let_join_of_bound ... ok
[INFO] [stdout] test smoke_dlog ... ok
[INFO] [stdout] test smoke_binary_frame_frame_add ... ok
[INFO] [stdout] test smoke_ft_zscore_no_self_reference ... ok
[INFO] [stdout] test smoke_nested_joins ... ok
[INFO] [stdout] test smoke_rolling_mean_handcrafted ... ignored, Test expects fixed-window semantics, but IR uses OBS semantics (validated by GLD_NUM). Needs rewrite with correct expectations.
[INFO] [stdout] test smoke_rolling_std_after_unary ... ignored, Test expects fixed-window semantics, but IR uses OBS semantics (validated by GLD_NUM). Needs rewrite with correct expectations.
[INFO] [stdout] test smoke_rolling_std_known_window ... ignored, Test expects fixed-window semantics, but IR uses OBS semantics (validated by GLD_NUM). Needs rewrite with correct expectations.
[INFO] [stdout] test smoke_binary_scalar_mul ... ok
[INFO] [stdout] test smoke_let_simple_reuse ... ok
[INFO] [stdout] test smoke_nested_unary ... ok
[INFO] [stdout] test smoke_rolling_std_with_na ... ignored, Test expects fixed-window semantics, but IR uses OBS semantics (validated by GLD_NUM). Needs rewrite with correct expectations.
[INFO] [stdout] test smoke_rolling_mean_window_three ... ok
[INFO] [stdout] test smoke_rolling_zscore_known_window ... ignored, Test expects fixed-window semantics, but IR uses OBS semantics (validated by GLD_NUM). Needs rewrite with correct expectations.
[INFO] [stdout] test smoke_rolling_zscore_constant_series ... ok
[INFO] [stdout] test smoke_rolling_mean_window_one ... ok
[INFO] [stdout] test smoke_rolling_std_constant_series ... ok
[INFO] [stdout] test smoke_shift_zero_identity ... ok
[INFO] [stdout] test smoke_timestamp_pipeline ... ok
[INFO] [stdout] test smoke_rolling_mean_large_window ... ok
[INFO] [stdout] test smoke_rolling_std_window_one ... ok
[INFO] [stdout] test smoke_rolling_mean_after_unary ... ok
[INFO] [stdout] test smoke_timestamp_asofr ... ok
[INFO] [stdout] test smoke_timestamp_mapr ... ok
[INFO] [stdout] test smoke_let_shadowing ... ok
[INFO] [stdout] test smoke_shift_one_lag ... ok
[INFO] [stdout] test smoke_shift_after_unary ... ok
[INFO] [stdout] test smoke_shift_composition ... ok
[INFO] [stdout] test smoke_shift_large_k ... ok
[INFO] [stdout] test smoke_var_only ... ok
[INFO] [stdout] test smoke_timestamp_var ... ok
[INFO] [stdout] test common::tests::test_frame_equiv_different_rows - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 43 passed; 0 failed; 5 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/mask_tripwires.rs (/opt/rustwide/target/debug/deps/mask_tripwires-e708eaa7de5f4a56)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test t1_masked_rows_are_na_for_all_unary_ops ... ok
[INFO] [stdout] test t4_binary_ops_or_active_masks ... ok
[INFO] [stdout] test t5_join_inherits_y_masks ... ok
[INFO] [stdout] test t6_mask_name_collision_deterministic ... ok
[INFO] [stdout] test t3_rolling_with_source_nas ... ok
[INFO] [stdout] test t2_rolling_strict_vs_partial_start_dates ... ok
[INFO] [stdout] test perf_rolling_strict_is_not_quadratic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/mask_ux.rs (/opt/rustwide/target/debug/deps/mask_ux-d072a9cdc13e7743)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test test_mask_list_contains_weekend ... ok
[INFO] [stdout] test test_mask_define_or_equals_weekend ... ok
[INFO] [stdout] test test_mask_stats_counts_match_known_calendar ... ok
[INFO] [stdout] test test_mask_define_collision_errors_deterministically ... ok
[INFO] [stdout] test test_mask_off_clears_active_mask ... ok
[INFO] [stderr]      Running tests/metamorphic.rs (/opt/rustwide/target/debug/deps/metamorphic-6ec5c75f1ef08275)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 44 tests
[INFO] [stdout] test common::tests::test_expr_gen_depth_1 ... ok
[INFO] [stdout] test common::tests::test_expr_gen_depth_0 ... ok
[INFO] [stdout] test common::tests::test_direct_eval_var ... ok
[INFO] [stdout] test common::tests::test_frame_equiv_cloned ... ok
[INFO] [stdout] test common::tests::test_direct_eval_dlog ... ok
[INFO] [stdout] test common::tests::test_frame_equiv_identical ... ok
[INFO] [stdout] test meta_binary_additive_identity ... ok
[INFO] [stdout] test meta_binary_absorption_law ... ok
[INFO] [stdout] test meta_binary_multiplicative_identity ... ok
[INFO] [stdout] test meta_dlog_identity_positive_domain ... ignored, Pre-existing failure (Feb 20). Property assumes fixed-window semantics, but IR uses OBS semantics (validated by GLD_NUM).
[INFO] [stdout] test meta_ft_zscore_rewrite_identity ... ignored, Pre-existing failure (Feb 20). Fails due to OBS semantics NA handling differences. Needs investigation.
[INFO] [stdout] test meta_asofr_output_shape_law ... ok
[INFO] [stdout] test meta_rolling_mean_mask_monotone ... ignored, Pre-existing failure (Feb 20). Property invalid with OBS semantics - rolling ops skip NAs and look back further, so input NA doesn't guarantee output NA.
[INFO] [stdout] test meta_plan_deterministic ... ok
[INFO] [stdout] test meta_rolling_std_mask_monotone ... ignored, Pre-existing failure (Feb 20). Property invalid with OBS semantics - rolling ops skip NAs and look back further, so input NA doesn't guarantee output NA.
[INFO] [stdout] test meta_let_shadowing_law ... ok
[INFO] [stdout] test meta_ft_mean_derived_form_identity ... ok
[INFO] [stdout] test meta_rolling_mean_shift_commutation ... ok
[INFO] [stdout] test meta_ft_std_derived_form_identity ... ok
[INFO] [stdout] test meta_rolling_std_non_negativity ... ok
[INFO] [stdout] test meta_rolling_std_scale_equivariance ... ok
[INFO] [stdout] test meta_rolling_std_translation_invariance ... ok
[INFO] [stdout] test meta_mapr_column_projection_law ... ok
[INFO] [stdout] test meta_binary_na_propagation ... ok
[INFO] [stdout] test meta_rolling_mean_constant_series ... ok
[INFO] [stdout] test meta_rolling_mean_window_one_identity ... ok
[INFO] [stdout] test meta_join_index_arc_identity ... ok
[INFO] [stdout] test meta_let_sequential_dependency ... ok
[INFO] [stdout] test meta_binary_preserves_lhs_tags ... ok
[INFO] [stdout] test meta_rolling_zscore_rewrite_identity ... ignored, Pre-existing failure (Feb 20). Fails due to OBS semantics NA handling differences. Needs investigation.
[INFO] [stdout] test meta_mapr_output_shape_law ... ok
[INFO] [stdout] test meta_shift_mask_monotonic ... ok
[INFO] [stdout] test meta_rolling_zscore_scale_invariance ... ok
[INFO] [stdout] test meta_shift_preserves_tags_arc ... ok
[INFO] [stdout] test meta_rolling_zscore_translation_invariance ... ok
[INFO] [stdout] test meta_shift_composition_law ... ok
[INFO] [stdout] test meta_shift_all_na_when_k_exceeds_nrows ... ok
[INFO] [stdout] test meta_unary_na_positions_monotonic ... ok
[INFO] [stdout] test meta_unary_preserves_shape ... ok
[INFO] [stdout] test meta_rolling_std_shift_commutation ... ok
[INFO] [stdout] test meta_normalize_idempotent ... ok
[INFO] [stdout] test meta_shift_zero_identity ... ok
[INFO] [stdout] test meta_unary_preserves_tags_arc ... ok
[INFO] [stdout] test common::tests::test_frame_equiv_different_rows - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 39 passed; 0 failed; 5 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/orientation_tripwires.rs (/opt/rustwide/target/debug/deps/orientation_tripwires-407452f695de9351)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test tripwire_orientation_z_affects_sum ... ok
[INFO] [stdout] test tripwire_orientation_z_vs_h_sum ... ok
[INFO] [stdout] test tripwire_all_rowwise_vs_colwise_orientations ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/phase_f_streaming_rolling.rs (/opt/rustwide/target/debug/deps/phase_f_streaming_rolling-1df5641c87e4b5a2)
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test test_masked_rows_always_na_in_streaming ... ok
[INFO] [stdout] test test_streaming_correctness_mean_strict ... ok
[INFO] [stdout] test test_streaming_matches_legacy_simple_case ... ok
[INFO] [stdout] test test_streaming_performance_benefit ... ok
[INFO] [stdout] test test_streaming_with_source_nas ... ok
[INFO] [stdout] test test_partial_vs_strict_semantics ... ok
[INFO] [stdout] test test_numerical_stability_variance ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/reindex_mask.rs (/opt/rustwide/target/debug/deps/reindex_mask-b705d821e41711f9)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test reindex_active_mask_without_expr_uses_bitvec ... ok
[INFO] [stdout] test reindex_empty_overlap_all_new_rows ... ok
[INFO] [stdout] test reindex_defaults_false_for_new_rows ... ok
[INFO] [stdout] test reindex_preserves_active_mask_via_expr ... ok
[INFO] [stdout] test reindex_preserves_named_masks_on_overlap ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests blisp
[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" "28be74dcb8a55e7afdf31d329edfc2ddd6cc3b863f3ac8bec7bb812e4a3e033e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "28be74dcb8a55e7afdf31d329edfc2ddd6cc3b863f3ac8bec7bb812e4a3e033e", kill_on_drop: false }`
[INFO] [stdout] 28be74dcb8a55e7afdf31d329edfc2ddd6cc3b863f3ac8bec7bb812e4a3e033e