Dec 14 19:12:14.865 INFO testing solana_rbpf-0.1.5 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 14 19:12:14.865 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +aa49d8ef14939ddec0e34b346b60174a5673d48f-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 14 19:12:15.155 INFO [stdout] aeb045e7e225b0175033ec1fb5c00ed4e85ecb8ce47c0e064c89389eff18a77e
Dec 14 19:12:15.157 INFO running `"docker" "start" "-a" "aeb045e7e225b0175033ec1fb5c00ed4e85ecb8ce47c0e064c89389eff18a77e"`
Dec 14 19:12:16.011 INFO [stderr] usermod: no changes
Dec 14 19:12:16.251 INFO [stderr]    Compiling bloom v0.3.2
Dec 14 19:12:16.251 INFO [stderr]    Compiling combine v2.5.2
Dec 14 19:12:16.256 INFO [stderr]    Compiling pretty_env_logger v0.2.5
Dec 14 19:12:18.911 INFO [stderr]    Compiling elfkit v0.0.6
Dec 14 19:12:29.119 INFO [stderr]    Compiling solana_rbpf v0.1.5 (/source)
Dec 14 19:12:35.326 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 19.29s
Dec 14 19:12:35.341 INFO [stderr] su: No module specific data is present
Dec 14 19:12:36.332 INFO running `"docker" "inspect" "aeb045e7e225b0175033ec1fb5c00ed4e85ecb8ce47c0e064c89389eff18a77e"`
Dec 14 19:12:36.652 INFO running `"docker" "rm" "-f" "aeb045e7e225b0175033ec1fb5c00ed4e85ecb8ce47c0e064c89389eff18a77e"`
Dec 14 19:12:37.001 INFO [stdout] aeb045e7e225b0175033ec1fb5c00ed4e85ecb8ce47c0e064c89389eff18a77e
Dec 14 19:12:37.005 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +aa49d8ef14939ddec0e34b346b60174a5673d48f-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 14 19:12:37.435 INFO [stdout] 1780e926504d619b3e2872701d79169cda2b17bc584cdd8a5201aa915d3f81e1
Dec 14 19:12:37.441 INFO running `"docker" "start" "-a" "1780e926504d619b3e2872701d79169cda2b17bc584cdd8a5201aa915d3f81e1"`
Dec 14 19:12:38.454 INFO [stderr] usermod: no changes
Dec 14 19:12:38.639 INFO [stderr]    Compiling elf v0.0.10
Dec 14 19:12:40.583 INFO [stderr]    Compiling solana_rbpf v0.1.5 (/source)
Dec 14 19:13:18.390 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 39.91s
Dec 14 19:13:18.423 INFO [stderr] su: No module specific data is present
Dec 14 19:13:19.465 INFO running `"docker" "inspect" "1780e926504d619b3e2872701d79169cda2b17bc584cdd8a5201aa915d3f81e1"`
Dec 14 19:13:19.757 INFO running `"docker" "rm" "-f" "1780e926504d619b3e2872701d79169cda2b17bc584cdd8a5201aa915d3f81e1"`
Dec 14 19:13:20.007 INFO [stdout] 1780e926504d619b3e2872701d79169cda2b17bc584cdd8a5201aa915d3f81e1
Dec 14 19:13:20.009 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +aa49d8ef14939ddec0e34b346b60174a5673d48f-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 14 19:13:20.599 INFO [stdout] 7f293b4a83c603f09e1901861e5e75d0d032bee83a196ce955b4403c26305c22
Dec 14 19:13:20.605 INFO running `"docker" "start" "-a" "7f293b4a83c603f09e1901861e5e75d0d032bee83a196ce955b4403c26305c22"`
Dec 14 19:13:21.658 INFO [stderr] usermod: no changes
Dec 14 19:13:21.931 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.25s
Dec 14 19:13:21.947 INFO [stderr]      Running /target/debug/deps/solana_rbpf-0d018d924f1d4563
Dec 14 19:13:21.947 INFO [stdout] 
Dec 14 19:13:21.947 INFO [stdout] running 119 tests
Dec 14 19:13:21.955 INFO [stdout] test asm_parser::tests::test_integer ... ok
Dec 14 19:13:21.955 INFO [stdout] test asm_parser::tests::test_initial_whitespace ... ok
Dec 14 19:13:21.955 INFO [stdout] test asm_parser::tests::test_instruction ... ok
Dec 14 19:13:21.955 INFO [stdout] test asm_parser::tests::test_ident ... ok
Dec 14 19:13:21.955 INFO [stdout] test asm_parser::tests::test_exit ... ok
Dec 14 19:13:21.955 INFO [stdout] test asm_parser::tests::test_error_unexpected_character ... ok
Dec 14 19:13:21.955 INFO [stdout] test asm_parser::tests::test_error_eof ... ok
Dec 14 19:13:21.955 INFO [stdout] test asm_parser::tests::test_lsh ... ok
Dec 14 19:13:21.955 INFO [stdout] test asm_parser::tests::test_operand ... ok
Dec 14 19:13:21.955 INFO [stdout] test asm_parser::tests::test_register ... ok
Dec 14 19:13:21.955 INFO [stdout] test asm_parser::tests::test_empty ... ok
Dec 14 19:13:21.955 INFO [stdout] test asm_parser::tests::test_tcp_sack ... ok
Dec 14 19:13:21.955 INFO [stdout] test elf::test::test_relocate ... ok
Dec 14 19:13:21.955 INFO [stdout] test elf::test::test_validate ... ok
Dec 14 19:13:21.955 INFO [stdout] test insn_builder::tests::byte_swap_instructions::convert_host_to_big_endian_16bits ... ok
Dec 14 19:13:21.955 INFO [stdout] test insn_builder::tests::byte_swap_instructions::convert_host_to_big_endian_32bits ... ok
Dec 14 19:13:21.955 INFO [stdout] test insn_builder::tests::byte_swap_instructions::convert_host_to_big_endian_64bit ... ok
Dec 14 19:13:21.955 INFO [stdout] test insn_builder::tests::byte_swap_instructions::convert_host_to_little_endian_16bits ... ok
Dec 14 19:13:21.955 INFO [stdout] test insn_builder::tests::byte_swap_instructions::convert_host_to_little_endian_64bit ... ok
Dec 14 19:13:21.955 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_bit_and_with_const_not_equal_zero ... ok
Dec 14 19:13:21.955 INFO [stdout] test asm_parser::tests::test_ldxh ... ok
Dec 14 19:13:21.959 INFO [stdout] test insn_builder::tests::byte_swap_instructions::convert_host_to_little_endian_32bits ... ok
Dec 14 19:13:21.959 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_equals_const ... ok
Dec 14 19:13:21.959 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_greater_or_equals_src_signed ... ok
Dec 14 19:13:21.959 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_greater_or_equals_to_const ... ok
Dec 14 19:13:21.959 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_greater_than_const ... ok
Dec 14 19:13:21.963 INFO [stdout] test asm_parser::tests::test_ja ... ok
Dec 14 19:13:21.963 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_greater_than_const_signed ... ok
Dec 14 19:13:21.963 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_equals_src ... ok
Dec 14 19:13:21.963 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_bit_and_with_src_not_equal_zero ... ok
Dec 14 19:13:21.963 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_not_equals_const ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_lower_or_equals_src_signed ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_greater_or_equals_src_signed ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_greater_or_equals_to_src ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_lower_or_equals_to_const ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_lower_than_const ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_lower_than_const_signed ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_to_label ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_greater_than_src_signed ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_lower_or_equals_src_signed ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_lower_than_src ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_abs_double_word ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_greater_than_src ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_not_equals_src ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_abs_word ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_lower_or_equals_to_src ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_lower_than_src_signed ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_indirect_double_word ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::load_instructions::register::load_byte_from_set_src_with_offset ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_indirect_byte ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::load_instructions::register::load_double_word_from_set_src_with_offset ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_abs_half_word ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_abs_byte ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::load_instructions::register::load_half_word_from_set_src_with_offset ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::load_instructions::register::load_word_from_set_src_with_offset ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_double_word ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_and_add_const_to_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_bit_and_const_to_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_bit_or_const_to_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_indirect_word ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_const_to_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_div_constant_to_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_indirect_half_word ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_left_shift_const_to_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_logical_right_shift_const_to_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_mod_const_to_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_mul_const_to_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_negate_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_signed_right_shift_const_to_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_sub_const_to_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_bit_xor_const_to_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_and_add_from_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_bit_and_from_register_to_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_bit_or_from_register_to_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_bit_xor_from_register_to_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_div_from_register_to_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_from_register_to_another_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_left_shift_from_register_to_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_logical_right_shift_from_register_to_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_mod_from_register_to_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_mul_from_register_to_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_signed_right_shift_from_register_to_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_sub_from_register_to_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_and_add_const_to_register ... ok
Dec 14 19:13:21.967 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_bit_and_const_to_register ... ok
Dec 14 19:13:21.968 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_bit_or_const_to_register ... ok
Dec 14 19:13:21.968 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_bit_xor_const_to_register ... ok
Dec 14 19:13:21.968 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_const_to_register ... ok
Dec 14 19:13:21.968 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_div_constant_to_register ... ok
Dec 14 19:13:21.968 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_left_shift_const_to_register ... ok
Dec 14 19:13:21.968 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_logical_right_shift_const_to_register ... ok
Dec 14 19:13:21.968 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_mod_const_to_register ... ok
Dec 14 19:13:21.968 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_mul_const_to_register ... ok
Dec 14 19:13:21.968 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_negate_register ... ok
Dec 14 19:13:21.968 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_signed_right_shift_const_to_register ... ok
Dec 14 19:13:21.968 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_bit_xor_from_register_to_register ... ok
Dec 14 19:13:21.971 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_logical_right_shift_from_register_to_register ... ok
Dec 14 19:13:21.971 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_and_add_from_register ... ok
Dec 14 19:13:21.979 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_sub_const_to_register ... ok
Dec 14 19:13:21.979 INFO [stderr]      Running /target/debug/deps/assembler-7ecf0ab924c16d28
Dec 14 19:13:21.979 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_signed_right_shift_from_register_to_register ... ok
Dec 14 19:13:21.979 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_mul_from_register_to_register ... ok
Dec 14 19:13:21.979 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_mod_from_register_to_register ... ok
Dec 14 19:13:21.979 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_sub_from_register_to_register ... ok
Dec 14 19:13:21.979 INFO [stdout] test insn_builder::tests::programs::example_from_assembler ... ok
Dec 14 19:13:21.979 INFO [stdout] test insn_builder::tests::special::call_immediate ... ok
Dec 14 19:13:21.979 INFO [stdout] test insn_builder::tests::special::exit_operation ... ok
Dec 14 19:13:21.979 INFO [stdout] test insn_builder::tests::store_instructions::store_byte_from_dst_into_src_address ... ok
Dec 14 19:13:21.979 INFO [stdout] test insn_builder::tests::store_instructions::store_byte_from_dst_into_immediate_address ... ok
Dec 14 19:13:21.979 INFO [stdout] test insn_builder::tests::store_instructions::store_double_word_from_dst_into_immediate_address ... ok
Dec 14 19:13:21.979 INFO [stdout] test insn_builder::tests::store_instructions::store_double_word_from_dst_into_src_address ... ok
Dec 14 19:13:21.979 INFO [stdout] test insn_builder::tests::store_instructions::store_half_word_from_dst_into_immediate_address ... ok
Dec 14 19:13:21.979 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_from_register_to_another_register ... ok
Dec 14 19:13:21.979 INFO [stdout] test insn_builder::tests::store_instructions::store_half_word_from_dst_into_src_address ... ok
Dec 14 19:13:21.979 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_left_shift_from_register_to_register ... ok
Dec 14 19:13:21.979 INFO [stdout] test insn_builder::tests::store_instructions::store_word_from_dst_into_src_address ... ok
Dec 14 19:13:21.979 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_div_from_register_to_register ... ok
Dec 14 19:13:21.979 INFO [stdout] test insn_builder::tests::store_instructions::store_word_from_dst_into_immediate_address ... ok
Dec 14 19:13:21.979 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_bit_and_from_register_to_register ... ok
Dec 14 19:13:21.979 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_bit_or_from_register_to_register ... ok
Dec 14 19:13:21.979 INFO [stdout] 
Dec 14 19:13:21.979 INFO [stdout] test result: ok. 119 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 19:13:21.979 INFO [stdout] 
Dec 14 19:13:21.979 INFO [stdout] 
Dec 14 19:13:21.979 INFO [stdout] running 32 tests
Dec 14 19:13:21.999 INFO [stdout] test test_call ... ok
Dec 14 19:13:21.999 INFO [stdout] test test_add64 ... ok
Dec 14 19:13:22.011 INFO [stdout] test test_alu_unary ... ok
Dec 14 19:13:22.011 INFO [stdout] test test_alu_binary ... ok
Dec 14 19:13:22.011 INFO [stdout] test test_error_invalid_instruction ... ok
Dec 14 19:13:22.011 INFO [stdout] test test_endian ... ok
Dec 14 19:13:22.011 INFO [stdout] test test_be32 ... ok
Dec 14 19:13:22.011 INFO [stdout] test test_empty ... ok
Dec 14 19:13:22.011 INFO [stdout] test test_error_too_many_operands ... ok
Dec 14 19:13:22.011 INFO [stdout] test test_large_immediate ... ok
Dec 14 19:13:22.011 INFO [stdout] test test_jeq ... ok
Dec 14 19:13:22.011 INFO [stdout] test test_ja ... ok
Dec 14 19:13:22.027 INFO [stdout] test test_error_unexpected_operands ... ok
Dec 14 19:13:22.027 INFO [stdout] test test_exit ... ok
Dec 14 19:13:22.027 INFO [stdout] test test_error_operands_out_of_range ... ok
Dec 14 19:13:22.027 INFO [stdout] test test_jump_conditional ... ok
Dec 14 19:13:22.031 INFO [stdout] test test_ldabsw ... ok
Dec 14 19:13:22.031 INFO [stdout] test test_lddw ... ok
Dec 14 19:13:22.031 INFO [stdout] test test_ldxdw ... ok
Dec 14 19:13:22.031 INFO [stdout] test test_ldindw ... ok
Dec 14 19:13:22.031 INFO [stdout] test test_load_abs ... ok
Dec 14 19:13:22.031 INFO [stdout] test test_load_reg ... ok
Dec 14 19:13:22.031 INFO [stdout] test test_neg64 ... ok
Dec 14 19:13:22.039 INFO [stdout] test test_sth ... ok
Dec 14 19:13:22.039 INFO [stdout] test test_stxh ... ok
Dec 14 19:13:22.039 INFO [stdout] test test_stxw ... ok
Dec 14 19:13:22.039 INFO [stdout] test test_tcp_sack ... ok
Dec 14 19:13:22.047 INFO [stdout] test test_ldxw ... ok
Dec 14 19:13:22.047 INFO [stdout] test test_store_reg ... ok
Dec 14 19:13:22.047 INFO [stdout] test test_store_imm ... ok
Dec 14 19:13:22.047 INFO [stdout] test test_stw ... ok
Dec 14 19:13:22.047 INFO [stdout] test test_load_ind ... ok
Dec 14 19:13:22.047 INFO [stdout] 
Dec 14 19:13:22.047 INFO [stdout] test result: ok. 32 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 19:13:22.047 INFO [stdout] 
Dec 14 19:13:22.051 INFO [stderr]      Running /target/debug/deps/common-4c7353557a35bea0
Dec 14 19:13:22.059 INFO [stderr]      Running /target/debug/deps/disassembler-073819e0335a82fd
Dec 14 19:13:22.059 INFO [stdout] 
Dec 14 19:13:22.059 INFO [stdout] running 0 tests
Dec 14 19:13:22.059 INFO [stdout] 
Dec 14 19:13:22.059 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 19:13:22.059 INFO [stdout] 
Dec 14 19:13:22.059 INFO [stdout] 
Dec 14 19:13:22.059 INFO [stdout] running 27 tests
Dec 14 19:13:22.059 INFO [stdout] test test_exit ... ok
Dec 14 19:13:22.059 INFO [stdout] test test_empty ... ok
Dec 14 19:13:22.059 INFO [stdout] test test_call ... ok
Dec 14 19:13:22.059 INFO [stdout] test test_be32 ... ok
Dec 14 19:13:22.059 INFO [stdout] test test_add64 ... ok
Dec 14 19:13:22.067 INFO [stdout] test test_alu_unary ... ok
Dec 14 19:13:22.067 INFO [stdout] test test_ja ... ok
Dec 14 19:13:22.067 INFO [stdout] test test_endian ... ok
Dec 14 19:13:22.067 INFO [stdout] test test_jump_conditional ... ok
Dec 14 19:13:22.067 INFO [stdout] test test_alu_binary ... ok
Dec 14 19:13:22.079 INFO [stdout] test test_ldxdw ... ok
Dec 14 19:13:22.079 INFO [stdout] test test_ldxw ... ok
Dec 14 19:13:22.079 INFO [stdout] test test_large_immediate ... ok
Dec 14 19:13:22.079 INFO [stdout] test test_ldindw ... ok
Dec 14 19:13:22.079 INFO [stdout] test test_ldabsw ... ok
Dec 14 19:13:22.079 INFO [stdout] test test_jeq ... ok
Dec 14 19:13:22.079 INFO [stdout] test test_neg64 ... ok
Dec 14 19:13:22.079 INFO [stdout] test test_lddw ... ok
Dec 14 19:13:22.080 INFO [stdout] test test_load_abs ... ok
Dec 14 19:13:22.080 INFO [stdout] test test_sth ... ok
Dec 14 19:13:22.080 INFO [stdout] test test_load_ind ... ok
Dec 14 19:13:22.080 INFO [stdout] test test_load_reg ... ok
Dec 14 19:13:22.080 INFO [stdout] test test_store_imm ... ok
Dec 14 19:13:22.082 INFO [stdout] test test_stxw ... ok
Dec 14 19:13:22.082 INFO [stdout] test test_stw ... ok
Dec 14 19:13:22.095 INFO [stdout] test test_store_reg ... ok
Dec 14 19:13:22.095 INFO [stderr]      Running /target/debug/deps/misc-9ab9fd0d78f327fa
Dec 14 19:13:22.095 INFO [stdout] test test_stxh ... ok
Dec 14 19:13:22.095 INFO [stdout] 
Dec 14 19:13:22.095 INFO [stdout] test result: ok. 27 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 19:13:22.095 INFO [stdout] 
Dec 14 19:13:22.095 INFO [stdout] 
Dec 14 19:13:22.095 INFO [stdout] running 29 tests
Dec 14 19:13:22.099 INFO [stdout] test test_load_elf ... ok
Dec 14 19:13:22.099 INFO [stdout] test test_jit_mbuff ... ok
Dec 14 19:13:22.099 INFO [stdout] test test_symbol_relocation ... ok
Dec 14 19:13:22.099 INFO [stdout] test test_jit_block_port ... ok
Dec 14 19:13:22.099 INFO [stdout] test test_get_last_instruction_count ... ok
Dec 14 19:13:22.112 INFO [stdout] test test_non_terminate_early ... ok
Dec 14 19:13:22.112 INFO [stdout] test test_non_terminate_capped ... ok
Dec 14 19:13:22.112 INFO [stdout] test test_verifier_success ... ok
Dec 14 19:13:22.119 INFO [stdout] test test_vm_block_port ... ok
Dec 14 19:13:22.275 INFO [stdout] test test_unterminated_string ... ok
Dec 14 19:13:22.275 INFO [stdout] test test_verifier_fail ... ok
Dec 14 19:13:22.276 INFO [stdout] test test_non_terminating ... ok
Dec 14 19:13:22.276 INFO [stdout] test test_vm_exec_no_program ... ok
Dec 14 19:13:22.276 INFO [stdout] test test_vm_jit_ldabsdw ... ok
Dec 14 19:13:22.276 INFO [stdout] test test_vm_jit_ldabsh ... ok
Dec 14 19:13:22.276 INFO [stdout] test test_vm_jit_ldabsw ... ok
Dec 14 19:13:22.276 INFO [stdout] test test_vm_jit_ldindb ... ok
Dec 14 19:13:22.276 INFO [stdout] test test_vm_jit_ldinddw ... ok
Dec 14 19:13:22.276 INFO [stdout] test test_vm_jit_ldindh ... ok
Dec 14 19:13:22.276 INFO [stdout] test test_vm_jit_ldindw ... ok
Dec 14 19:13:22.276 INFO [stdout] test test_vm_mbuff ... ok
Dec 14 19:13:22.276 INFO [stdout] test test_vm_mbuff_with_rust_api ... ok
Dec 14 19:13:22.276 INFO [stdout] test test_vm_jit_ldabsb ... ok
Dec 14 19:13:22.282 INFO [stdout] test test_null_string ... ok
Dec 14 19:13:22.282 INFO [stdout] test test_jit_call_helper_wo_verifier ... ok
Dec 14 19:13:22.282 INFO [stdout] test test_vm_err_ldabsb_nomem ... ok
Dec 14 19:13:22.282 INFO [stdout] test test_vm_err_ldindb_nomem ... ok
Dec 14 19:13:22.282 INFO [stdout] test test_vm_err_ldabsb_oob ... ok
Dec 14 19:13:22.282 INFO [stdout] test test_vm_err_ldindb_oob ... ok
Dec 14 19:13:22.282 INFO [stdout] 
Dec 14 19:13:22.282 INFO [stdout] test result: ok. 29 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 19:13:22.282 INFO [stdout] 
Dec 14 19:13:22.283 INFO [stderr]      Running /target/debug/deps/ubpf_jit_x86_64-028f74de9cfd9fc4
Dec 14 19:13:22.295 INFO [stdout] 
Dec 14 19:13:22.295 INFO [stdout] running 97 tests
Dec 14 19:13:22.307 INFO [stdout] test test_jit_add ... ok
Dec 14 19:13:22.307 INFO [stdout] test test_jit_alu64_bit ... ok
Dec 14 19:13:22.307 INFO [stdout] test test_jit_alu64_arith ... ok
Dec 14 19:13:22.319 INFO [stdout] test test_jit_alu_arith ... ok
Dec 14 19:13:22.319 INFO [stdout] test test_jit_arsh32_high_shift ... ok
Dec 14 19:13:22.319 INFO [stdout] test test_jit_arsh64 ... ok
Dec 14 19:13:22.327 INFO [stdout] test test_jit_arsh_reg ... ok
Dec 14 19:13:22.339 INFO [stdout] test test_jit_call ... ok
Dec 14 19:13:22.339 INFO [stdout] test test_jit_alu_bit ... ok
Dec 14 19:13:22.339 INFO [stdout] test test_jit_arsh ... ok
Dec 14 19:13:22.339 INFO [stdout] test test_jit_be32_high ... ok
Dec 14 19:13:22.347 INFO [stdout] test test_jit_be16 ... ok
Dec 14 19:13:22.347 INFO [stdout] test test_jit_be32 ... ok
Dec 14 19:13:22.347 INFO [stdout] test test_jit_be16_high ... ok
Dec 14 19:13:22.347 INFO [stdout] test test_jit_be64 ... ok
Dec 14 19:13:22.347 INFO [stdout] test test_jit_early_exit ... ok
Dec 14 19:13:22.355 INFO [stdout] test test_jit_div32_high_divisor ... ok
Dec 14 19:13:22.355 INFO [stdout] test test_jit_div32_imm ... ok
Dec 14 19:13:22.355 INFO [stdout] test test_jit_div64_reg ... ok
Dec 14 19:13:22.363 INFO [stdout] test test_jit_call_memfrob ... ok
Dec 14 19:13:22.363 INFO [stdout] test test_jit_div64_imm ... ok
Dec 14 19:13:22.371 INFO [stdout] test test_jit_exit ... ok
Dec 14 19:13:22.379 INFO [stdout] test test_jit_div32_reg ... ok
Dec 14 19:13:22.379 INFO [stdout] test test_jit_ja ... ok
Dec 14 19:13:22.379 INFO [stdout] test test_jit_jeq_imm ... ok
Dec 14 19:13:22.379 INFO [stdout] test test_jit_jgt_reg ... ok
Dec 14 19:13:22.387 INFO [stdout] test test_jit_jeq_reg ... ok
Dec 14 19:13:22.387 INFO [stdout] test test_jit_jgt_imm ... ok
Dec 14 19:13:22.387 INFO [stdout] test test_jit_jle_imm ... ok
Dec 14 19:13:22.387 INFO [stdout] test test_jit_jle_reg ... ok
Dec 14 19:13:22.387 INFO [stdout] test test_jit_jge_imm ... ok
Dec 14 19:13:22.387 INFO [stdout] test test_jit_jit_bounce ... ok
Dec 14 19:13:22.399 INFO [stdout] test test_jit_jlt_reg ... ok
Dec 14 19:13:22.411 INFO [stdout] test test_jit_jlt_imm ... ok
Dec 14 19:13:22.411 INFO [stdout] test test_jit_jset_reg ... ok
Dec 14 19:13:22.411 INFO [stdout] test test_jit_jsge_reg ... ok
Dec 14 19:13:22.411 INFO [stdout] test test_jit_jne_reg ... ok
Dec 14 19:13:22.411 INFO [stdout] test test_jit_jsge_imm ... ok
Dec 14 19:13:22.411 INFO [stdout] test test_jit_jset_imm ... ok
Dec 14 19:13:22.432 INFO [stdout] test test_jit_jsgt_reg ... ok
Dec 14 19:13:22.439 INFO [stdout] test test_jit_jsgt_imm ... ok
Dec 14 19:13:22.439 INFO [stdout] test test_jit_jsle_imm ... ok
Dec 14 19:13:22.455 INFO [stdout] test test_jit_lddw ... ok
Dec 14 19:13:22.464 INFO [stdout] test test_jit_jsle_reg ... ok
Dec 14 19:13:22.464 INFO [stdout] test test_jit_jslt_imm ... ok
Dec 14 19:13:22.464 INFO [stdout] test test_jit_jslt_reg ... ok
Dec 14 19:13:22.464 INFO [stdout] test test_jit_ldxb ... ok
Dec 14 19:13:22.467 INFO [stdout] test test_jit_ldxdw ... ok
Dec 14 19:13:22.467 INFO [stdout] test test_jit_lddw2 ... ok
Dec 14 19:13:22.467 INFO [stdout] test test_jit_ldxb_all ... ok
Dec 14 19:13:22.470 INFO [stdout] test test_jit_ldxh_all2 ... ok
Dec 14 19:13:22.473 INFO [stdout] test test_jit_ldxh_same_reg ... ok
Dec 14 19:13:22.475 INFO [stdout] test test_jit_le16 ... ok
Dec 14 19:13:22.475 INFO [stdout] test test_jit_ldxw ... ok
Dec 14 19:13:22.476 INFO [stdout] test test_jit_ldxh ... ok
Dec 14 19:13:22.483 INFO [stdout] test test_jit_le32 ... ok
Dec 14 19:13:22.483 INFO [stdout] test test_jit_ldxw_all ... ok
Dec 14 19:13:22.487 INFO [stdout] test test_jit_ldxh_all ... ok
Dec 14 19:13:22.491 INFO [stdout] test test_jit_le64 ... ok
Dec 14 19:13:22.491 INFO [stdout] test test_jit_mod ... ok
Dec 14 19:13:22.495 INFO [stdout] test test_jit_lsh_reg ... ok
Dec 14 19:13:22.495 INFO [stdout] test test_jit_mod32 ... ok
Dec 14 19:13:22.495 INFO [stdout] test test_jit_mov ... ok
Dec 14 19:13:22.515 INFO [stdout] test test_jit_mul32_imm ... ok
Dec 14 19:13:22.515 INFO [stdout] test test_jit_mod64 ... ok
Dec 14 19:13:22.515 INFO [stdout] test test_jit_mul32_reg ... ok
Dec 14 19:13:22.515 INFO [stdout] test test_jit_mul64_imm ... ok
Dec 14 19:13:22.515 INFO [stdout] test test_jit_mul32_reg_overflow ... ok
Dec 14 19:13:22.543 INFO [stdout] test test_jit_mul64_reg ... ok
Dec 14 19:13:22.543 INFO [stdout] test test_jit_mul_loop ... ok
Dec 14 19:13:22.547 INFO [stdout] test test_jit_neg64 ... ok
Dec 14 19:13:22.547 INFO [stdout] test test_jit_neg ... ok
Dec 14 19:13:22.547 INFO [stdout] test test_jit_prime ... ok
Dec 14 19:13:22.547 INFO [stdout] test test_jit_stack ... ok
Dec 14 19:13:22.547 INFO [stdout] test test_jit_rsh_reg ... ok
Dec 14 19:13:22.550 INFO [stdout] test test_jit_rhs32 ... ok
Dec 14 19:13:22.550 INFO [stdout] test test_jit_stack2 ... ok
Dec 14 19:13:22.553 INFO [stdout] test test_jit_stb ... ok
Dec 14 19:13:22.553 INFO [stdout] test test_jit_sth ... ok
Dec 14 19:13:22.553 INFO [stdout] test test_jit_stdw ... ok
Dec 14 19:13:22.553 INFO [stdout] test test_jit_stw ... ok
Dec 14 19:13:22.571 INFO [stdout] test test_jit_string_stack ... ok
Dec 14 19:13:22.571 INFO [stdout] test test_jit_stxb ... ok
Dec 14 19:13:22.571 INFO [stdout] test test_jit_stxdw ... ok
Dec 14 19:13:22.571 INFO [stdout] test test_jit_stxh ... ok
Dec 14 19:13:22.571 INFO [stdout] test test_jit_stxb_all2 ... ok
Dec 14 19:13:22.571 INFO [stdout] test test_jit_stxb_all ... ok
Dec 14 19:13:22.571 INFO [stdout] test test_jit_stxb_chain ... ok
Dec 14 19:13:22.573 INFO [stdout] test test_jit_tcp_port80_match ... ok
Dec 14 19:13:22.573 INFO [stdout] test test_jit_stxw ... ok
Dec 14 19:13:22.575 INFO [stdout] test test_jit_subnet ... ok
Dec 14 19:13:22.575 INFO [stdout] test test_jit_tcp_port80_nomatch_ethertype ... ok
Dec 14 19:13:22.575 INFO [stdout] test test_jit_tcp_port80_nomatch ... ok
Dec 14 19:13:22.575 INFO [stdout] test test_jit_tcp_sack_match ... ok
Dec 14 19:13:22.575 INFO [stdout] test test_jit_tcp_port80_nomatch_proto ... ok
Dec 14 19:13:22.580 INFO [stdout] test test_jit_tcp_sack_nomatch ... ok
Dec 14 19:13:22.615 INFO [stdout] test test_jit_err_call_unreg ... ok
Dec 14 19:13:22.615 INFO [stdout] 
Dec 14 19:13:22.615 INFO [stdout] test result: ok. 97 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 19:13:22.615 INFO [stdout] 
Dec 14 19:13:22.619 INFO [stdout] 
Dec 14 19:13:22.619 INFO [stdout] running 12 tests
Dec 14 19:13:22.619 INFO [stderr]      Running /target/debug/deps/ubpf_verifier-554cce8c666ff2f1
Dec 14 19:13:22.748 INFO [stdout] test test_verifier_err_endian_size ... ok
Dec 14 19:13:22.748 INFO [stdout] test test_verifier_err_incomplete_lddw ... ok
Dec 14 19:13:22.748 INFO [stdout] test test_verifier_err_jmp_out ... ok
Dec 14 19:13:22.748 INFO [stdout] test test_verifier_err_infinite_loop ... ok
Dec 14 19:13:22.748 INFO [stdout] test test_verifier_err_invalid_reg_dst ... ok
Dec 14 19:13:22.748 INFO [stdout] test test_verifier_err_jmp_lddw ... ok
Dec 14 19:13:22.748 INFO [stdout] test test_verifier_err_invalid_reg_src ... ok
Dec 14 19:13:22.748 INFO [stdout] test test_verifier_err_div_by_zero_imm ... ok
Dec 14 19:13:22.748 INFO [stdout] test test_verifier_err_unknown_opcode ... ok
Dec 14 19:13:22.759 INFO [stdout] test test_verifier_err_no_exit ... ok
Dec 14 19:13:22.759 INFO [stdout] test test_verifier_err_too_many_instructions ... ok
Dec 14 19:13:22.763 INFO [stdout] test test_verifier_err_write_r10 ... ok
Dec 14 19:13:22.763 INFO [stdout] 
Dec 14 19:13:22.763 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 19:13:22.763 INFO [stdout] 
Dec 14 19:13:22.765 INFO [stderr]      Running /target/debug/deps/ubpf_vm-dda0698e0224529c
Dec 14 19:13:22.768 INFO [stdout] 
Dec 14 19:13:22.768 INFO [stdout] running 102 tests
Dec 14 19:13:22.771 INFO [stdout] test test_vm_arsh64 ... ok
Dec 14 19:13:22.773 INFO [stdout] test test_vm_alu_arith ... ok
Dec 14 19:13:22.783 INFO [stdout] test test_vm_arsh_reg ... ok
Dec 14 19:13:22.791 INFO [stdout] test test_vm_arsh32_high_shift ... ok
Dec 14 19:13:22.792 INFO [stdout] test test_vm_alu64_arith ... ok
Dec 14 19:13:22.807 INFO [stdout] test test_vm_alu64_bit ... ok
Dec 14 19:13:22.807 INFO [stdout] test test_vm_be32 ... ok
Dec 14 19:13:22.815 INFO [stdout] test test_vm_arsh ... ok
Dec 14 19:13:22.815 INFO [stdout] test test_vm_be64 ... ok
Dec 14 19:13:22.815 INFO [stdout] test test_vm_be16 ... ok
Dec 14 19:13:22.819 INFO [stdout] test test_vm_add ... ok
Dec 14 19:13:22.819 INFO [stdout] test test_vm_alu_bit ... ok
Dec 14 19:13:22.820 INFO [stdout] test test_vm_be16_high ... ok
Dec 14 19:13:22.821 INFO [stdout] test test_vm_call ... ok
Dec 14 19:13:22.821 INFO [stdout] test test_vm_be32_high ... ok
Dec 14 19:13:22.822 INFO [stdout] test test_vm_div32_high_divisor ... ok
Dec 14 19:13:22.823 INFO [stdout] test test_vm_call_memfrob ... ok
Dec 14 19:13:22.824 INFO [stdout] test test_vm_div64_reg ... ok
Dec 14 19:13:22.824 INFO [stdout] test test_vm_div64_imm ... ok
Dec 14 19:13:22.825 INFO [stdout] test test_vm_div32_imm ... ok
Dec 14 19:13:22.833 INFO [stdout] test test_vm_early_exit ... ok
Dec 14 19:13:22.833 INFO [stdout] test test_vm_div32_reg ... ok
Dec 14 19:13:22.836 INFO [stdout] test test_vm_exit ... ok
Dec 14 19:13:22.841 INFO [stdout] test test_vm_ja ... ok
Dec 14 19:13:22.858 INFO [stdout] test test_vm_jeq_imm ... ok
Dec 14 19:13:22.859 INFO [stdout] test test_vm_jge_imm ... ok
Dec 14 19:13:22.875 INFO [stdout] test test_vm_jeq_reg ... ok
Dec 14 19:13:22.875 INFO [stdout] test test_vm_jgt_imm ... ok
Dec 14 19:13:22.875 INFO [stdout] test test_vm_jit_bounce ... ok
Dec 14 19:13:22.875 INFO [stdout] test test_vm_jgt_reg ... ok
Dec 14 19:13:22.875 INFO [stdout] test test_vm_jle_reg ... ok
Dec 14 19:13:22.875 INFO [stdout] test test_vm_jle_imm ... ok
Dec 14 19:13:22.879 INFO [stdout] test test_vm_jlt_imm ... ok
Dec 14 19:13:22.879 INFO [stdout] test test_vm_jlt_reg ... ok
Dec 14 19:13:22.883 INFO [stdout] test test_vm_jne_reg ... ok
Dec 14 19:13:22.883 INFO [stdout] test test_vm_jset_imm ... ok
Dec 14 19:13:22.907 INFO [stdout] test test_vm_jset_reg ... ok
Dec 14 19:13:22.907 INFO [stdout] test test_vm_jsge_imm ... ok
Dec 14 19:13:22.927 INFO [stdout] test test_vm_jsge_reg ... ok
Dec 14 19:13:22.927 INFO [stdout] test test_vm_jsgt_imm ... ok
Dec 14 19:13:22.939 INFO [stdout] test test_vm_jsgt_reg ... ok
Dec 14 19:13:22.939 INFO [stdout] test test_vm_jsle_imm ... ok
Dec 14 19:13:22.951 INFO [stdout] test test_vm_jsle_reg ... ok
Dec 14 19:13:22.951 INFO [stdout] test test_vm_jslt_imm ... ok
Dec 14 19:13:22.951 INFO [stdout] test test_vm_lddw ... ok
Dec 14 19:13:22.951 INFO [stdout] test test_vm_jslt_reg ... ok
Dec 14 19:13:22.967 INFO [stdout] test test_vm_ldxb ... ok
Dec 14 19:13:22.967 INFO [stdout] test test_vm_lddw2 ... ok
Dec 14 19:13:22.971 INFO [stdout] test test_vm_ldxb_all ... ok
Dec 14 19:13:22.979 INFO [stdout] test test_vm_ldxh ... ok
Dec 14 19:13:22.979 INFO [stdout] test test_vm_ldxdw ... ok
Dec 14 19:13:22.983 INFO [stdout] test test_vm_ldxh_all2 ... ok
Dec 14 19:13:22.983 INFO [stdout] test test_vm_ldxh_same_reg ... ok
Dec 14 19:13:22.991 INFO [stdout] test test_vm_ldxh_all ... ok
Dec 14 19:13:22.991 INFO [stdout] test test_vm_ldxw ... ok
Dec 14 19:13:22.995 INFO [stdout] test test_vm_ldxw_all ... ok
Dec 14 19:13:22.995 INFO [stdout] test test_vm_le16 ... ok
Dec 14 19:13:22.999 INFO [stdout] test test_vm_le64 ... ok
Dec 14 19:13:23.003 INFO [stdout] test test_vm_le32 ... ok
Dec 14 19:13:23.004 INFO [stdout] test test_vm_lsh_reg ... ok
Dec 14 19:13:23.005 INFO [stdout] test test_vm_mod ... ok
Dec 14 19:13:23.015 INFO [stdout] test test_vm_mod32 ... ok
Dec 14 19:13:23.015 INFO [stdout] test test_vm_mod64 ... ok
Dec 14 19:13:23.015 INFO [stdout] test test_vm_mov ... ok
Dec 14 19:13:23.015 INFO [stdout] test test_vm_mul32_imm ... ok
Dec 14 19:13:23.015 INFO [stdout] test test_vm_mul32_reg ... ok
Dec 14 19:13:23.015 INFO [stdout] test test_vm_mul64_imm ... ok
Dec 14 19:13:23.019 INFO [stdout] test test_vm_mul64_reg ... ok
Dec 14 19:13:23.019 INFO [stdout] test test_vm_mul_loop ... ok
Dec 14 19:13:23.019 INFO [stdout] test test_vm_neg ... ok
Dec 14 19:13:23.019 INFO [stdout] test test_vm_neg64 ... ok
Dec 14 19:13:23.019 INFO [stdout] test test_vm_prime ... ok
Dec 14 19:13:23.063 INFO [stdout] test test_vm_rhs32 ... ok
Dec 14 19:13:23.063 INFO [stdout] test test_vm_mul32_reg_overflow ... ok
Dec 14 19:13:23.063 INFO [stdout] test test_vm_err_call_unreg ... ok
Dec 14 19:13:23.067 INFO [stdout] test test_vm_rsh_reg ... ok
Dec 14 19:13:23.071 INFO [stdout] test test_vm_err_div64_by_zero_reg ... ok
Dec 14 19:13:23.071 INFO [stdout] test test_vm_err_mod_by_zero_reg ... ok
Dec 14 19:13:23.071 INFO [stdout] test test_vm_err_mod64_by_zero_reg ... ok
Dec 14 19:13:23.071 INFO [stdout] test test_vm_err_stack_out_of_bound ... ok
Dec 14 19:13:23.071 INFO [stdout] test test_vm_err_div_by_zero_reg ... ok
Dec 14 19:13:23.071 INFO [stdout] test test_vm_stack2 ... ok
Dec 14 19:13:23.071 INFO [stdout] test test_vm_stb ... ok
Dec 14 19:13:23.071 INFO [stdout] test test_vm_stack ... ok
Dec 14 19:13:23.071 INFO [stdout] test test_vm_stw ... ok
Dec 14 19:13:23.072 INFO [stdout] test test_vm_stxb ... ok
Dec 14 19:13:23.075 INFO [stdout] test test_vm_stxb_all2 ... ok
Dec 14 19:13:23.075 INFO [stdout] test test_vm_stxb_all ... ok
Dec 14 19:13:23.075 INFO [stdout] test test_vm_sth ... ok
Dec 14 19:13:23.076 INFO [stdout] test test_vm_stxh ... ok
Dec 14 19:13:23.076 INFO [stdout] test test_vm_tcp_port80_match ... ok
Dec 14 19:13:23.076 INFO [stdout] test test_vm_tcp_port80_nomatch ... ok
Dec 14 19:13:23.083 INFO [stdout] test test_vm_subnet ... ok
Dec 14 19:13:23.083 INFO [stdout] test test_vm_stdw ... ok
Dec 14 19:13:23.083 INFO [stdout] test test_vm_string_stack ... ok
Dec 14 19:13:23.083 INFO [stdout] test test_vm_stxdw ... ok
Dec 14 19:13:23.083 INFO [stdout] test test_vm_tcp_port80_nomatch_ethertype ... ok
Dec 14 19:13:23.083 INFO [stdout] test test_vm_tcp_port80_nomatch_proto ... ok
Dec 14 19:13:23.083 INFO [stdout] test test_vm_stxb_chain ... ok
Dec 14 19:13:23.083 INFO [stdout] test test_vm_tcp_sack_match ... ok
Dec 14 19:13:23.083 INFO [stdout] test test_vm_stxw ... ok
Dec 14 19:13:23.083 INFO [stdout] test test_vm_tcp_sack_nomatch ... ok
Dec 14 19:13:23.083 INFO [stdout] 
Dec 14 19:13:23.083 INFO [stdout] test result: ok. 102 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 19:13:23.083 INFO [stdout] 
Dec 14 19:13:23.095 INFO [stderr]    Doc-tests solana_rbpf
Dec 14 19:13:27.187 INFO [stdout] 
Dec 14 19:13:27.187 INFO [stdout] running 55 tests
Dec 14 19:13:53.339 INFO [stdout] test src/ebpf.rs - ebpf::Insn::to_vec (line 468) ... ok
Dec 14 19:13:53.687 INFO [stdout] test src/ebpf.rs - ebpf::Insn::to_array (line 436) ... ok
Dec 14 19:13:53.691 INFO [stdout] test src/ebpf.rs - ebpf::get_insn (line 507) ... ok
Dec 14 19:13:54.300 INFO [stdout] test src/disassembler.rs - disassembler::disassemble (line 323) ... ok
Dec 14 19:13:54.815 INFO [stdout] test src/ebpf.rs - ebpf::get_insn (line 520) ... ok
Dec 14 19:13:55.078 INFO [stdout] test src/ebpf.rs - ebpf::to_insn_vec (line 556) ... ok
Dec 14 19:13:55.219 INFO [stdout] test src/assembler.rs - assembler::assemble (line 210) ... ok
Dec 14 19:13:55.623 INFO [stdout] test src/disassembler.rs - disassembler::to_insn_vec (line 122) ... ok
Dec 14 19:14:18.491 INFO [stdout] test src/helpers.rs - helpers::bpf_time_getns (line 41) ... ok
Dec 14 19:14:18.627 INFO [stdout] test src/helpers.rs - helpers::rand (line 251) ... ok
Dec 14 19:14:18.995 INFO [stdout] test src/helpers.rs - helpers::gather_bytes (line 122) ... ok
Dec 14 19:14:19.151 INFO [stdout] test src/helpers.rs - helpers::memfrob (line 142) ... ok
Dec 14 19:14:19.383 INFO [stdout] test src/helpers.rs - helpers::sqrti (line 190) ... ok
Dec 14 19:14:19.531 INFO [stdout] test src/helpers.rs - helpers::strcmp (line 206) ... ok
Dec 14 19:14:19.682 INFO [stdout] test src/helpers.rs - helpers::bpf_trace_printf (line 72) ... ok
Dec 14 19:14:22.392 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff (line 881) ... ok
Dec 14 19:14:43.411 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::jit_compile (line 1208) ... ok
Dec 14 19:14:43.411 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::new (line 926) ... ok
Dec 14 19:14:45.567 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::set_max_instruction_count (line 1036) ... ok
Dec 14 19:14:45.671 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::set_program (line 962) ... ok
Dec 14 19:14:45.775 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::execute_program (line 1168) ... ok
Dec 14 19:14:45.960 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::get_last_instruction_count (line 1058) ... ok
Dec 14 19:14:46.015 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::register_helper (line 1091) ... ok
Dec 14 19:14:48.514 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::execute_program_jit (line 1262) ... ok
Dec 14 19:14:58.251 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::set_verifier (line 1003) ... ok
Dec 14 19:15:08.159 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::jit_compile (line 744) ... ok
Dec 14 19:15:09.734 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::execute_program (line 359) ... ok
Dec 14 19:15:10.317 INFO [stdout] test src/lib.rs - EbpfVmMbuff (line 73) ... ok
Dec 14 19:15:10.675 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::new (line 117) ... ok
Dec 14 19:15:11.111 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::execute_program_jit (line 794) ... ok
Dec 14 19:15:11.576 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::get_last_instruction_count (line 244) ... ok
Dec 14 19:15:19.191 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::register_helper (line 287) ... ok
Dec 14 19:15:21.711 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::set_max_instruction_count (line 221) ... ok
Dec 14 19:15:27.267 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::set_verifier (line 182) ... ok
Dec 14 19:15:27.710 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::set_program (line 147) ... ok
Dec 14 19:15:31.838 INFO [stdout] test src/lib.rs - EbpfVmNoData (line 1669) ... ok
Dec 14 19:15:32.207 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::execute_program (line 1940) ... ok
Dec 14 19:15:33.555 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::execute_program_jit (line 1971) ... ok
Dec 14 19:15:36.375 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::get_last_instruction_count (line 1828) ... ok
Dec 14 19:15:39.455 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::jit_compile (line 1920) ... ok
Dec 14 19:15:47.655 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::new (line 1714) ... ok
Dec 14 19:15:54.575 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::register_helper (line 1857) ... ok
Dec 14 19:15:58.127 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::set_max_instruction_count (line 1806) ... ok
Dec 14 19:16:02.854 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::set_program (line 1735) ... ok
Dec 14 19:16:04.203 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::set_verifier (line 1773) ... ok
Dec 14 19:16:06.839 INFO [stdout] test src/lib.rs - EbpfVmRaw (line 1319) ... ok
Dec 14 19:16:09.775 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::execute_program (line 1562) ... ok
Dec 14 19:16:13.131 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::execute_program_jit (line 1635) ... ok
Dec 14 19:16:20.915 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::get_last_instruction_count (line 1464) ... ok
Dec 14 19:16:23.599 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::jit_compile (line 1590) ... ok
Dec 14 19:16:28.240 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::register_helper (line 1497) ... ok
Dec 14 19:16:28.707 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::new (line 1348) ... ok
Dec 14 19:16:29.439 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::set_max_instruction_count (line 1442) ... ok
Dec 14 19:16:29.979 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::set_program (line 1370) ... ok
Dec 14 19:16:30.756 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::set_verifier (line 1409) ... ok
Dec 14 19:16:30.757 INFO [stdout] 
Dec 14 19:16:30.757 INFO [stdout] test result: ok. 55 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 19:16:30.757 INFO [stdout] 
Dec 14 19:16:30.799 INFO [stderr] su: No module specific data is present
Dec 14 19:16:31.697 INFO running `"docker" "inspect" "7f293b4a83c603f09e1901861e5e75d0d032bee83a196ce955b4403c26305c22"`
Dec 14 19:16:32.056 INFO running `"docker" "rm" "-f" "7f293b4a83c603f09e1901861e5e75d0d032bee83a196ce955b4403c26305c22"`
Dec 14 19:16:32.302 INFO [stdout] 7f293b4a83c603f09e1901861e5e75d0d032bee83a196ce955b4403c26305c22