[INFO] cloning repository https://github.com/keiv-fly/202507_Kayton
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/keiv-fly/202507_Kayton" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fkeiv-fly%2F202507_Kayton", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fkeiv-fly%2F202507_Kayton'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 9ada69fa60164f0fbf03f45c9751dc1e4c591102
[INFO] testing keiv-fly/202507_Kayton against beta-2026-03-05 for beta-1.95-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fkeiv-fly%2F202507_Kayton" "/workspace/builds/worker-3-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/keiv-fly/202507_Kayton
[INFO] finished tweaking git repo https://github.com/keiv-fly/202507_Kayton
[INFO] tweaked toml for git repo https://github.com/keiv-fly/202507_Kayton written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/keiv-fly/202507_Kayton on toolchain beta-2026-03-05
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2026-03-05" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/keiv-fly/202507_Kayton 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" "+beta-2026-03-05" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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" "+beta-2026-03-05" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] ec96eca8181fb700b6ecf5cf473064898bbe2413d2c6b16d68fe6060ffa83cfe
[INFO] running `Command { std: "docker" "start" "-a" "ec96eca8181fb700b6ecf5cf473064898bbe2413d2c6b16d68fe6060ffa83cfe", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "ec96eca8181fb700b6ecf5cf473064898bbe2413d2c6b16d68fe6060ffa83cfe", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ec96eca8181fb700b6ecf5cf473064898bbe2413d2c6b16d68fe6060ffa83cfe", kill_on_drop: false }`
[INFO] [stdout] ec96eca8181fb700b6ecf5cf473064898bbe2413d2c6b16d68fe6060ffa83cfe
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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" "+beta-2026-03-05" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d421bbcd41142839059c9d7d4121c78e30ba8b08917caae7a1c8cf011dd9dd17
[INFO] running `Command { std: "docker" "start" "-a" "d421bbcd41142839059c9d7d4121c78e30ba8b08917caae7a1c8cf011dd9dd17", kill_on_drop: false }`
[INFO] [stderr]    Compiling windows_x86_64_gnu v0.53.0
[INFO] [stderr]    Compiling libc v0.2.174
[INFO] [stderr]    Compiling bumpalo v3.19.0
[INFO] [stderr]    Compiling windows-targets v0.53.3
[INFO] [stderr]    Compiling windows-sys v0.60.2
[INFO] [stderr]    Compiling kayton v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 3.32s
[INFO] running `Command { std: "docker" "inspect" "d421bbcd41142839059c9d7d4121c78e30ba8b08917caae7a1c8cf011dd9dd17", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d421bbcd41142839059c9d7d4121c78e30ba8b08917caae7a1c8cf011dd9dd17", kill_on_drop: false }`
[INFO] [stdout] d421bbcd41142839059c9d7d4121c78e30ba8b08917caae7a1c8cf011dd9dd17
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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" "+beta-2026-03-05" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 2faf67543cf60f57c26ad88bcda30628462e83b384d86deb4785d93b4452643d
[INFO] running `Command { std: "docker" "start" "-a" "2faf67543cf60f57c26ad88bcda30628462e83b384d86deb4785d93b4452643d", kill_on_drop: false }`
[INFO] [stderr]    Compiling kayton v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.83s
[INFO] running `Command { std: "docker" "inspect" "2faf67543cf60f57c26ad88bcda30628462e83b384d86deb4785d93b4452643d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2faf67543cf60f57c26ad88bcda30628462e83b384d86deb4785d93b4452643d", kill_on_drop: false }`
[INFO] [stdout] 2faf67543cf60f57c26ad88bcda30628462e83b384d86deb4785d93b4452643d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/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" "+beta-2026-03-05" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 3fc6c2c6c35f61ef2246cfd41b665a2edce779f7673d1d3977e874d738e77819
[INFO] running `Command { std: "docker" "start" "-a" "3fc6c2c6c35f61ef2246cfd41b665a2edce779f7673d1d3977e874d738e77819", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.06s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/kayton-dc74e14053f460b8)
[INFO] [stdout] 
[INFO] [stdout] running 111 tests
[INFO] [stdout] test codegen::tests::populates_global_vars ... ok
[INFO] [stdout] test codegen::tests::program1_codegen ... ok
[INFO] [stdout] test lexer::tests::program2_tokens ... ok
[INFO] [stdout] test codegen::tests::program2_codegen ... ok
[INFO] [stdout] test lexer::tests::program3_tokens ... ok
[INFO] [stdout] test parser::tests::program1_ast ... ok
[INFO] [stdout] test parser::tests::program2_ast ... ok
[INFO] [stdout] test vm::tests::test_backward_compatibility ... ok
[INFO] [stdout] test lexer::tests::program1_tokens ... ok
[INFO] [stdout] test vm::tests::test_backward_jump_bounds_check ... ok
[INFO] [stdout] test vm::tests::test_basic_i64_arithmetic ... ok
[INFO] [stdout] test vm::tests::test_complex_f64_operations ... ok
[INFO] [stdout] test vm::tests::test_execution_with_no_timeout_specified ... ok
[INFO] [stdout] test vm::tests::test_execution_with_timeout_no_timeout ... ok
[INFO] [stdout] test vm::tests::test_f64_comparison ... ok
[INFO] [stdout] test vm::tests::test_f64_comparison_ops ... ok
[INFO] [stdout] test vm::tests::test_f64_comparison_with_negatives ... ok
[INFO] [stdout] test vm::tests::test_f64_subtraction ... ok
[INFO] [stdout] test parser::tests::program3_ast ... ok
[INFO] [stdout] test vm::tests::test_execution_with_short_timeout ... ok
[INFO] [stdout] test vm::tests::test_i64_comparison_ops ... ok
[INFO] [stdout] test vm::tests::test_unexpected_end_of_program ... ok
[INFO] [stdout] test vm::tests::test_invalid_opcode ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_builder_load_const_instructions ... ok
[INFO] [stdout] test vm::tests::test_negative_numbers ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_comparison_and_jumps_with_labels ... ok
[INFO] [stdout] test vm::tests::test_register_base_offset ... ok
[INFO] [stdout] test vm::tests::test_register_raw_operations ... ok
[INFO] [stdout] test vm::tests::test_basic_f64_arithmetic ... ok
[INFO] [stdout] test vm::tests::test_type_conversions ... ok
[INFO] [stdout] test vm::tests::test_timeout_error_display ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_comparison_old_vs_new_approach ... ok
[INFO] [stdout] test vm::tests::test_mixed_arithmetic ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_complex_control_flow ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_conditional_jump_with_zero ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_fibonacci_with_labels ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_jump_backward_if_false_exit_loop ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_jump_backward_if_true_loop ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_factorial_loop_with_labels ... ok
[INFO] [stdout] test vm::tests::test_timeout_check_interval ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_target_based_jumps ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_jump_forward_if_true_with_labels ... ok
[INFO] [stdout] test vm::tests_call::test_call_host_basic ... ok
[INFO] [stdout] test vm::tests_call::test_call_host_register_isolation ... ok
[INFO] [stdout] test vm::tests_const_opcodes::test_load_const_value_and_slice ... ok
[INFO] [stdout] test vm::tests_const_pool::test_add_and_get_slice_constants ... ok
[INFO] [stdout] test vm::tests_call::test_call_host_invalid_index ... ok
[INFO] [stdout] test vm::tests::test_invalid_jump_target ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_builder_comparison_ops ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_jump_forward_if_true_false_condition ... ok
[INFO] [stdout] test vm::tests_const_pool::test_add_and_get_value_constants ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_nested_conditional_jumps_with_labels ... ok
[INFO] [stdout] test vm::tests_global_vars::test_insert_and_get_ptr_var ... ok
[INFO] [stdout] test vm::tests_global_vars::test_vm_has_global_vars ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_add_i64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_add_f64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_complex_program ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_consistent_with_print_bytecode ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_empty_bytecode ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_gt_f64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_gt_i64 ... ok
[INFO] [stdout] test vm::tests_global_vars::test_insert_and_get_value_var ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_gte_f64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_incomplete_all_jump_instructions ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_gte_i64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_incomplete_conversion_instructions ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_incomplete_all_f64_arithmetic ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_incomplete_jmp ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_incomplete_jump ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_incomplete_load_const_value_missing_register ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_incomplete_type_conversion ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_jmp ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_jump_backward_if_false ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_extreme_values ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_incomplete_arithmetic ... ok
[INFO] [stdout] test vm::tests_call::test_call_host_multiple_calls ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_incomplete_sub_i64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_jump_backward_if_true ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_incomplete_all_i64_arithmetic ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_incomplete_load_const_slice ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_incomplete_load_const_value ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_jump_forward_if_false ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_jump_forward_if_true ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_load_const_slice ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_load_const_value ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_load_f64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_load_i64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_lt_i64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_lte_f64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_incomplete_jump_missing_register ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_lt_f64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_mul_f64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_mul_i64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_negative_i64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_lte_i64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_output_ends_with_newline ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_special_f64_values ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_sub_f64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_sub_i64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_unknown_opcode ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_various_register_numbers ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_with_labels_simulation ... ok
[INFO] [stdout] test vm::tests_registers::basic_get_set ... ok
[INFO] [stdout] test vm::tests_registers::overflow_fixed_register ... ok
[INFO] [stdout] test vm::tests_registers::overflow_starting_vec_allocation ... ok
[INFO] [stdout] test vm::tests_registers::default_zero_after_growth ... ok
[ERROR] error running command: no output for 300 seconds
[INFO] running `Command { std: "docker" "inspect" "3fc6c2c6c35f61ef2246cfd41b665a2edce779f7673d1d3977e874d738e77819", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3fc6c2c6c35f61ef2246cfd41b665a2edce779f7673d1d3977e874d738e77819", kill_on_drop: false }`
[INFO] [stdout] 3fc6c2c6c35f61ef2246cfd41b665a2edce779f7673d1d3977e874d738e77819
