[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-2025-09-21 for beta-1.91-3
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fkeiv-fly%2F202507_Kayton" "/workspace/builds/worker-0-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-0-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-0-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/keiv-fly/202507_Kayton on toolchain beta-2025-09-21
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2025-09-21" "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-2025-09-21" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2025-09-21" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] fff594b2b901e40a34e50890082b47a5a2ab0de73d13cc8341fc7db962682858
[INFO] running `Command { std: "docker" "start" "-a" "fff594b2b901e40a34e50890082b47a5a2ab0de73d13cc8341fc7db962682858", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "fff594b2b901e40a34e50890082b47a5a2ab0de73d13cc8341fc7db962682858", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "fff594b2b901e40a34e50890082b47a5a2ab0de73d13cc8341fc7db962682858", kill_on_drop: false }`
[INFO] [stdout] fff594b2b901e40a34e50890082b47a5a2ab0de73d13cc8341fc7db962682858
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2025-09-21" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d351eb907acce3a6e3dbe6ee0883c6dca710129a27c45fed3e9568d9892e9c16
[INFO] running `Command { std: "docker" "start" "-a" "d351eb907acce3a6e3dbe6ee0883c6dca710129a27c45fed3e9568d9892e9c16", 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.39s
[INFO] running `Command { std: "docker" "inspect" "d351eb907acce3a6e3dbe6ee0883c6dca710129a27c45fed3e9568d9892e9c16", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d351eb907acce3a6e3dbe6ee0883c6dca710129a27c45fed3e9568d9892e9c16", kill_on_drop: false }`
[INFO] [stdout] d351eb907acce3a6e3dbe6ee0883c6dca710129a27c45fed3e9568d9892e9c16
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2025-09-21" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a6ab1b3839a08b032e1cd073f72c3d70b294a9af8df08e84dab3daafbc92e477
[INFO] running `Command { std: "docker" "start" "-a" "a6ab1b3839a08b032e1cd073f72c3d70b294a9af8df08e84dab3daafbc92e477", 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.82s
[INFO] running `Command { std: "docker" "inspect" "a6ab1b3839a08b032e1cd073f72c3d70b294a9af8df08e84dab3daafbc92e477", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a6ab1b3839a08b032e1cd073f72c3d70b294a9af8df08e84dab3daafbc92e477", kill_on_drop: false }`
[INFO] [stdout] a6ab1b3839a08b032e1cd073f72c3d70b294a9af8df08e84dab3daafbc92e477
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:e90291280db7d1fac5b66fc6dad9f9662629e7365a55743daf9bdf73ebc4ea79" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2025-09-21" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 417ce70194972662ec06046068d3c62eecf57fc92b2d1f36807e8347c5fc61e7
[INFO] running `Command { std: "docker" "start" "-a" "417ce70194972662ec06046068d3c62eecf57fc92b2d1f36807e8347c5fc61e7", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/kayton-dd292751fa29a994)
[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 codegen::tests::program2_codegen ... ok
[INFO] [stdout] test lexer::tests::program3_tokens ... ok
[INFO] [stdout] test parser::tests::program1_ast ... ok
[INFO] [stdout] test lexer::tests::program1_tokens ... ok
[INFO] [stdout] test parser::tests::program2_ast ... ok
[INFO] [stdout] test lexer::tests::program2_tokens ... ok
[INFO] [stdout] test parser::tests::program3_ast ... ok
[INFO] [stdout] test vm::tests::test_backward_compatibility ... ok
[INFO] [stdout] test vm::tests::test_basic_f64_arithmetic ... ok
[INFO] [stdout] test vm::tests::test_basic_i64_arithmetic ... ok
[INFO] [stdout] test vm::tests::test_execution_with_no_timeout_specified ... ok
[INFO] [stdout] test vm::tests::test_complex_f64_operations ... ok
[INFO] [stdout] test vm::tests::test_execution_with_timeout_no_timeout ... ok
[INFO] [stdout] test vm::tests::test_f64_comparison_with_negatives ... ok
[INFO] [stdout] test vm::tests::test_f64_subtraction ... ok
[INFO] [stdout] test vm::tests::test_invalid_jump_target ... ok
[INFO] [stdout] test vm::tests::test_mixed_arithmetic ... ok
[INFO] [stdout] test vm::tests::test_invalid_opcode ... ok
[INFO] [stdout] test vm::tests::test_unexpected_end_of_program ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_builder_comparison_ops ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_comparison_and_jumps_with_labels ... ok
[INFO] [stdout] test vm::tests::test_backward_jump_bounds_check ... ok
[INFO] [stdout] test vm::tests::test_execution_with_short_timeout ... ok
[INFO] [stdout] test vm::tests::test_f64_comparison ... ok
[INFO] [stdout] test vm::tests::test_timeout_check_interval ... ok
[INFO] [stdout] test vm::tests::test_register_base_offset ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_conditional_jump_with_zero ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_comparison_old_vs_new_approach ... ok
[INFO] [stdout] test vm::tests::test_register_raw_operations ... ok
[INFO] [stdout] test vm::tests::test_negative_numbers ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_complex_control_flow ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_jump_forward_if_true_false_condition ... ok
[INFO] [stdout] test vm::tests::test_timeout_error_display ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_nested_conditional_jumps_with_labels ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_jump_forward_if_true_with_labels ... ok
[INFO] [stdout] test vm::tests::test_type_conversions ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_jump_backward_if_false_exit_loop ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_factorial_loop_with_labels ... ok
[INFO] [stdout] test vm::tests::test_f64_comparison_ops ... ok
[INFO] [stdout] test vm::tests_call::test_call_host_basic ... ok
[INFO] [stdout] test vm::tests_call::test_call_host_invalid_index ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_builder_load_const_instructions ... ok
[INFO] [stdout] test vm::tests_call::test_call_host_register_isolation ... ok
[INFO] [stdout] test vm::tests_call::test_call_host_multiple_calls ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_fibonacci_with_labels ... 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_value_constants ... ok
[INFO] [stdout] test vm::tests_global_vars::test_insert_and_get_value_var ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_target_based_jumps ... ok
[INFO] [stdout] test vm::tests_global_vars::test_insert_and_get_ptr_var ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_add_f64 ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_jump_backward_if_true_loop ... 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_gte_f64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_gte_i64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_incomplete_all_f64_arithmetic ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_extreme_values ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_gt_f64 ... ok
[INFO] [stdout] test vm::tests_global_vars::test_vm_has_global_vars ... 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_all_jump_instructions ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_empty_bytecode ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_incomplete_arithmetic ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_gt_i64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_add_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_jmp ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_incomplete_jump_missing_register ... 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_incomplete_load_const_value_missing_register ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_incomplete_sub_i64 ... 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_const_pool::test_add_and_get_slice_constants ... 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_i64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_lt_f64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_lt_i64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_load_f64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_lte_i64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_lte_f64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_jump_backward_if_true ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_jump_forward_if_false ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_mul_f64 ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_load_const_value ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_type_conversions ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_mul_i64 ... ok
[INFO] [stdout] test vm::tests_registers::basic_get_set ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_with_labels_simulation ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_negative_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_incomplete_jump ... 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_registers::default_zero_after_growth ... ok
[INFO] [stdout] test vm::tests_registers::overflow_fixed_register ... ok
[INFO] [stdout] test vm::tests_print_bytecode::test_format_various_register_numbers ... ok
[INFO] [stdout] test write::tests::unix::test_println_to_console ... ok
[INFO] [stdout] test vm::tests_registers::overflow_starting_vec_allocation ... ok
[INFO] [stdout] test vm::tests::test_i64_comparison_ops ... ok
[INFO] [stdout] test write::tests::unix::test_print_to_console ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_error_handling_with_labels ... ok
[INFO] [stdout] test vm::tests_bytecode_builder::test_target_based_error_handling ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 111 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/kayton-cab62c8745118919)
[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]    Doc-tests kayton
[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" "417ce70194972662ec06046068d3c62eecf57fc92b2d1f36807e8347c5fc61e7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "417ce70194972662ec06046068d3c62eecf57fc92b2d1f36807e8347c5fc61e7", kill_on_drop: false }`
[INFO] [stdout] 417ce70194972662ec06046068d3c62eecf57fc92b2d1f36807e8347c5fc61e7