Dec 06 22:16:09.956 INFO testing solana_rbpf-0.1.4 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 06 22:16:09.956 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 06 22:16:10.206 INFO [stdout] 5aad7fc19c832bfe28d9c3e5c70b708d5a23f5c1afa41c3e9954c66b7bb07fcd
Dec 06 22:16:10.207 INFO running `"docker" "start" "-a" "5aad7fc19c832bfe28d9c3e5c70b708d5a23f5c1afa41c3e9954c66b7bb07fcd"`
Dec 06 22:16:11.284 INFO [stderr] usermod: no changes
Dec 06 22:16:11.631 INFO [stderr]    Compiling bloom v0.3.2
Dec 06 22:16:11.631 INFO [stderr]    Compiling ar v0.6.2
Dec 06 22:16:11.652 INFO [stderr]    Compiling combine v2.5.2
Dec 06 22:16:11.667 INFO [stderr]    Compiling enum-primitive-derive v0.1.2
Dec 06 22:16:11.667 INFO [stderr]    Compiling pretty_env_logger v0.2.5
Dec 06 22:16:15.456 INFO [stderr]    Compiling elfkit v0.0.6
Dec 06 22:16:25.101 INFO [stderr]    Compiling solana_rbpf v0.1.4 (/source)
Dec 06 22:16:29.377 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 18.07s
Dec 06 22:16:29.386 INFO [stderr] su: No module specific data is present
Dec 06 22:16:29.756 INFO running `"docker" "inspect" "5aad7fc19c832bfe28d9c3e5c70b708d5a23f5c1afa41c3e9954c66b7bb07fcd"`
Dec 06 22:16:30.031 INFO running `"docker" "rm" "-f" "5aad7fc19c832bfe28d9c3e5c70b708d5a23f5c1afa41c3e9954c66b7bb07fcd"`
Dec 06 22:16:30.340 INFO [stdout] 5aad7fc19c832bfe28d9c3e5c70b708d5a23f5c1afa41c3e9954c66b7bb07fcd
Dec 06 22:16:30.340 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 06 22:16:30.662 INFO [stdout] fd466b5f3abea9f8af06f2281dbc5c903e720e7a39460456b32f66ff947d5cef
Dec 06 22:16:30.666 INFO running `"docker" "start" "-a" "fd466b5f3abea9f8af06f2281dbc5c903e720e7a39460456b32f66ff947d5cef"`
Dec 06 22:16:31.760 INFO [stderr] usermod: no changes
Dec 06 22:16:31.920 INFO [stderr]    Compiling solana_rbpf v0.1.4 (/source)
Dec 06 22:16:49.692 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 17.91s
Dec 06 22:16:49.708 INFO [stderr] su: No module specific data is present
Dec 06 22:16:49.934 INFO running `"docker" "inspect" "fd466b5f3abea9f8af06f2281dbc5c903e720e7a39460456b32f66ff947d5cef"`
Dec 06 22:16:50.021 INFO running `"docker" "rm" "-f" "fd466b5f3abea9f8af06f2281dbc5c903e720e7a39460456b32f66ff947d5cef"`
Dec 06 22:16:50.123 INFO [stdout] fd466b5f3abea9f8af06f2281dbc5c903e720e7a39460456b32f66ff947d5cef
Dec 06 22:16:50.125 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 06 22:16:50.293 INFO [stdout] fa9b4a7bf34a124379e0afff59d7ebc2d3b234aba7edd617fffeca552639e33f
Dec 06 22:16:50.298 INFO running `"docker" "start" "-a" "fa9b4a7bf34a124379e0afff59d7ebc2d3b234aba7edd617fffeca552639e33f"`
Dec 06 22:16:50.743 INFO [stderr] usermod: no changes
Dec 06 22:16:50.954 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.18s
Dec 06 22:16:50.971 INFO [stderr]      Running /target/debug/deps/solana_rbpf-06997f35815b3807
Dec 06 22:16:50.974 INFO [stdout] 
Dec 06 22:16:50.974 INFO [stdout] running 119 tests
Dec 06 22:16:50.975 INFO [stdout] test asm_parser::tests::test_integer ... ok
Dec 06 22:16:50.976 INFO [stdout] test asm_parser::tests::test_empty ... ok
Dec 06 22:16:50.980 INFO [stdout] test asm_parser::tests::test_ldxh ... ok
Dec 06 22:16:50.980 INFO [stdout] test asm_parser::tests::test_initial_whitespace ... ok
Dec 06 22:16:50.980 INFO [stdout] test asm_parser::tests::test_instruction ... ok
Dec 06 22:16:50.980 INFO [stdout] test asm_parser::tests::test_lsh ... ok
Dec 06 22:16:50.980 INFO [stdout] test asm_parser::tests::test_exit ... ok
Dec 06 22:16:50.980 INFO [stdout] test asm_parser::tests::test_register ... ok
Dec 06 22:16:50.980 INFO [stdout] test asm_parser::tests::test_operand ... ok
Dec 06 22:16:50.980 INFO [stdout] test asm_parser::tests::test_error_eof ... ok
Dec 06 22:16:50.980 INFO [stdout] test asm_parser::tests::test_error_unexpected_character ... ok
Dec 06 22:16:50.980 INFO [stdout] test asm_parser::tests::test_ident ... ok
Dec 06 22:16:50.980 INFO [stdout] test asm_parser::tests::test_ja ... ok
Dec 06 22:16:50.980 INFO [stdout] test insn_builder::tests::byte_swap_instructions::convert_host_to_big_endian_16bits ... ok
Dec 06 22:16:50.980 INFO [stdout] test insn_builder::tests::byte_swap_instructions::convert_host_to_big_endian_32bits ... ok
Dec 06 22:16:50.980 INFO [stdout] test insn_builder::tests::byte_swap_instructions::convert_host_to_big_endian_64bit ... ok
Dec 06 22:16:50.980 INFO [stdout] test insn_builder::tests::byte_swap_instructions::convert_host_to_little_endian_16bits ... ok
Dec 06 22:16:50.980 INFO [stdout] test elf::test::test_validate ... ok
Dec 06 22:16:50.980 INFO [stdout] test insn_builder::tests::byte_swap_instructions::convert_host_to_little_endian_64bit ... ok
Dec 06 22:16:50.980 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_equals_const ... ok
Dec 06 22:16:50.980 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_bit_and_with_const_not_equal_zero ... ok
Dec 06 22:16:50.980 INFO [stdout] test insn_builder::tests::byte_swap_instructions::convert_host_to_little_endian_32bits ... ok
Dec 06 22:16:50.982 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_greater_than_const ... ok
Dec 06 22:16:50.982 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_lower_or_equals_src_signed ... ok
Dec 06 22:16:50.982 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_greater_or_equals_to_const ... ok
Dec 06 22:16:50.982 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_greater_or_equals_src_signed ... ok
Dec 06 22:16:50.982 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_greater_than_const_signed ... ok
Dec 06 22:16:50.982 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_lower_or_equals_to_const ... ok
Dec 06 22:16:50.983 INFO [stdout] test asm_parser::tests::test_tcp_sack ... ok
Dec 06 22:16:50.983 INFO [stdout] test elf::test::test_relocate ... ok
Dec 06 22:16:50.983 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_not_equals_const ... ok
Dec 06 22:16:50.984 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_equals_src ... ok
Dec 06 22:16:50.984 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_lower_than_const_signed ... ok
Dec 06 22:16:50.988 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_greater_or_equals_src_signed ... ok
Dec 06 22:16:50.988 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_to_label ... ok
Dec 06 22:16:50.988 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_bit_and_with_src_not_equal_zero ... ok
Dec 06 22:16:50.988 INFO [stdout] test insn_builder::tests::jump_instructions::immediate::jump_on_dst_lower_than_const ... ok
Dec 06 22:16:50.988 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_greater_than_src ... ok
Dec 06 22:16:50.988 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_greater_or_equals_to_src ... ok
Dec 06 22:16:50.988 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_lower_or_equals_to_src ... ok
Dec 06 22:16:50.988 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_lower_than_src ... ok
Dec 06 22:16:50.989 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_lower_than_src_signed ... ok
Dec 06 22:16:50.989 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_lower_or_equals_src_signed ... ok
Dec 06 22:16:50.989 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_not_equals_src ... ok
Dec 06 22:16:50.989 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_abs_byte ... ok
Dec 06 22:16:50.989 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_abs_word ... ok
Dec 06 22:16:50.989 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_abs_half_word ... ok
Dec 06 22:16:50.989 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_double_word ... ok
Dec 06 22:16:50.989 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_indirect_byte ... ok
Dec 06 22:16:50.989 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_indirect_double_word ... ok
Dec 06 22:16:50.990 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_indirect_half_word ... ok
Dec 06 22:16:50.990 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_indirect_word ... ok
Dec 06 22:16:50.990 INFO [stdout] test insn_builder::tests::jump_instructions::register::jump_on_dst_greater_than_src_signed ... ok
Dec 06 22:16:50.990 INFO [stdout] test insn_builder::tests::load_instructions::register::load_byte_from_set_src_with_offset ... ok
Dec 06 22:16:50.990 INFO [stdout] test insn_builder::tests::load_instructions::register::load_double_word_from_set_src_with_offset ... ok
Dec 06 22:16:50.990 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_const_to_register ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_bit_and_const_to_register ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::load_instructions::register::load_half_word_from_set_src_with_offset ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::load_instructions::register::load_word_from_set_src_with_offset ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_and_add_const_to_register ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::load_instructions::immediate::load_abs_double_word ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_mul_const_to_register ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_negate_register ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_signed_right_shift_const_to_register ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_sub_const_to_register ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_and_add_from_register ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_bit_or_from_register_to_register ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_bit_xor_from_register_to_register ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_div_from_register_to_register ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_from_register_to_another_register ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_left_shift_from_register_to_register ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_logical_right_shift_from_register_to_register ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_mod_from_register_to_register ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_mul_from_register_to_register ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_signed_right_shift_from_register_to_register ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_sub_from_register_to_register ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_and_add_const_to_register ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_bit_and_const_to_register ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_bit_or_const_to_register ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_bit_xor_const_to_register ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_const_to_register ... ok
Dec 06 22:16:50.996 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_div_constant_to_register ... ok
Dec 06 22:16:50.997 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_left_shift_const_to_register ... ok
Dec 06 22:16:50.997 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_logical_right_shift_const_to_register ... ok
Dec 06 22:16:50.997 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_mod_const_to_register ... ok
Dec 06 22:16:51.000 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::register::move_bit_and_from_register_to_register ... ok
Dec 06 22:16:51.000 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_div_constant_to_register ... ok
Dec 06 22:16:51.000 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_bit_or_const_to_register ... ok
Dec 06 22:16:51.000 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_bit_xor_const_to_register ... ok
Dec 06 22:16:51.000 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_left_shift_const_to_register ... ok
Dec 06 22:16:51.000 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_mod_const_to_register ... ok
Dec 06 22:16:51.000 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x32::immediate::move_logical_right_shift_const_to_register ... ok
Dec 06 22:16:51.001 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_and_add_from_register ... ok
Dec 06 22:16:51.001 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_sub_const_to_register ... ok
Dec 06 22:16:51.001 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_negate_register ... ok
Dec 06 22:16:51.001 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_mul_const_to_register ... ok
Dec 06 22:16:51.001 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::immediate::move_signed_right_shift_const_to_register ... ok
Dec 06 22:16:51.001 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_bit_xor_from_register_to_register ... ok
Dec 06 22:16:51.001 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_bit_or_from_register_to_register ... ok
Dec 06 22:16:51.001 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_left_shift_from_register_to_register ... ok
Dec 06 22:16:51.001 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_bit_and_from_register_to_register ... ok
Dec 06 22:16:51.001 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_div_from_register_to_register ... ok
Dec 06 22:16:51.002 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_from_register_to_another_register ... ok
Dec 06 22:16:51.002 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_mod_from_register_to_register ... ok
Dec 06 22:16:51.002 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_logical_right_shift_from_register_to_register ... ok
Dec 06 22:16:51.002 INFO [stdout] test insn_builder::tests::programs::example_from_assembler ... ok
Dec 06 22:16:51.002 INFO [stdout] test insn_builder::tests::store_instructions::store_byte_from_dst_into_immediate_address ... ok
Dec 06 22:16:51.002 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_mul_from_register_to_register ... ok
Dec 06 22:16:51.002 INFO [stdout] test insn_builder::tests::store_instructions::store_byte_from_dst_into_src_address ... ok
Dec 06 22:16:51.002 INFO [stdout] test insn_builder::tests::store_instructions::store_double_word_from_dst_into_immediate_address ... ok
Dec 06 22:16:51.003 INFO [stdout] test insn_builder::tests::store_instructions::store_word_from_dst_into_immediate_address ... ok
Dec 06 22:16:51.003 INFO [stdout] test insn_builder::tests::store_instructions::store_half_word_from_dst_into_src_address ... ok
Dec 06 22:16:51.003 INFO [stdout] test insn_builder::tests::store_instructions::store_half_word_from_dst_into_immediate_address ... ok
Dec 06 22:16:51.003 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_signed_right_shift_from_register_to_register ... ok
Dec 06 22:16:51.008 INFO [stdout] test insn_builder::tests::moves_instructions::arch_x64::register::move_sub_from_register_to_register ... ok
Dec 06 22:16:51.008 INFO [stderr]      Running /target/debug/deps/assembler-35c98c77783b0f45
Dec 06 22:16:51.008 INFO [stdout] test insn_builder::tests::store_instructions::store_word_from_dst_into_src_address ... ok
Dec 06 22:16:51.008 INFO [stdout] test insn_builder::tests::store_instructions::store_double_word_from_dst_into_src_address ... ok
Dec 06 22:16:51.008 INFO [stdout] test insn_builder::tests::special::call_immediate ... ok
Dec 06 22:16:51.008 INFO [stdout] test insn_builder::tests::special::exit_operation ... ok
Dec 06 22:16:51.008 INFO [stdout] 
Dec 06 22:16:51.008 INFO [stdout] test result: ok. 119 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 22:16:51.008 INFO [stdout] 
Dec 06 22:16:51.010 INFO [stdout] 
Dec 06 22:16:51.010 INFO [stdout] running 32 tests
Dec 06 22:16:51.010 INFO [stdout] test test_call ... ok
Dec 06 22:16:51.011 INFO [stdout] test test_be32 ... ok
Dec 06 22:16:51.011 INFO [stdout] test test_alu_unary ... ok
Dec 06 22:16:51.012 INFO [stdout] test test_empty ... ok
Dec 06 22:16:51.013 INFO [stdout] test test_error_invalid_instruction ... ok
Dec 06 22:16:51.014 INFO [stdout] test test_exit ... ok
Dec 06 22:16:51.015 INFO [stdout] test test_error_operands_out_of_range ... ok
Dec 06 22:16:51.020 INFO [stdout] test test_endian ... ok
Dec 06 22:16:51.026 INFO [stdout] test test_add64 ... ok
Dec 06 22:16:51.026 INFO [stdout] test test_ja ... ok
Dec 06 22:16:51.026 INFO [stdout] test test_error_unexpected_operands ... ok
Dec 06 22:16:51.026 INFO [stdout] test test_jeq ... ok
Dec 06 22:16:51.026 INFO [stdout] test test_jump_conditional ... ok
Dec 06 22:16:51.027 INFO [stdout] test test_large_immediate ... ok
Dec 06 22:16:51.029 INFO [stdout] test test_ldabsw ... ok
Dec 06 22:16:51.029 INFO [stdout] test test_error_too_many_operands ... ok
Dec 06 22:16:51.031 INFO [stdout] test test_alu_binary ... ok
Dec 06 22:16:51.032 INFO [stdout] test test_load_abs ... ok
Dec 06 22:16:51.032 INFO [stdout] test test_load_ind ... ok
Dec 06 22:16:51.032 INFO [stdout] test test_neg64 ... ok
Dec 06 22:16:51.032 INFO [stdout] test test_lddw ... ok
Dec 06 22:16:51.038 INFO [stdout] test test_load_reg ... ok
Dec 06 22:16:51.038 INFO [stdout] test test_sth ... ok
Dec 06 22:16:51.038 INFO [stdout] test test_ldxdw ... ok
Dec 06 22:16:51.040 INFO [stdout] test test_ldindw ... ok
Dec 06 22:16:51.040 INFO [stdout] test test_tcp_sack ... ok
Dec 06 22:16:51.040 INFO [stdout] test test_store_imm ... ok
Dec 06 22:16:51.040 INFO [stdout] test test_ldxw ... ok
Dec 06 22:16:51.040 INFO [stdout] test test_store_reg ... ok
Dec 06 22:16:51.040 INFO [stdout] test test_stxh ... ok
Dec 06 22:16:51.040 INFO [stdout] test test_stxw ... ok
Dec 06 22:16:51.041 INFO [stdout] test test_stw ... ok
Dec 06 22:16:51.041 INFO [stdout] 
Dec 06 22:16:51.041 INFO [stdout] test result: ok. 32 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 22:16:51.041 INFO [stdout] 
Dec 06 22:16:51.042 INFO [stderr]      Running /target/debug/deps/common-0336fdb8ecfbfb75
Dec 06 22:16:51.056 INFO [stderr]      Running /target/debug/deps/disassembler-c90123008ceeac50
Dec 06 22:16:51.056 INFO [stdout] 
Dec 06 22:16:51.056 INFO [stdout] running 0 tests
Dec 06 22:16:51.056 INFO [stdout] 
Dec 06 22:16:51.056 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 22:16:51.056 INFO [stdout] 
Dec 06 22:16:51.068 INFO [stdout] 
Dec 06 22:16:51.068 INFO [stdout] running 27 tests
Dec 06 22:16:51.078 INFO [stdout] test test_be32 ... ok
Dec 06 22:16:51.080 INFO [stdout] test test_add64 ... ok
Dec 06 22:16:51.081 INFO [stdout] test test_alu_binary ... ok
Dec 06 22:16:51.092 INFO [stdout] test test_jeq ... ok
Dec 06 22:16:51.092 INFO [stdout] test test_endian ... ok
Dec 06 22:16:51.092 INFO [stdout] test test_alu_unary ... ok
Dec 06 22:16:51.092 INFO [stdout] test test_exit ... ok
Dec 06 22:16:51.092 INFO [stdout] test test_call ... ok
Dec 06 22:16:51.093 INFO [stdout] test test_empty ... ok
Dec 06 22:16:51.093 INFO [stdout] test test_ja ... ok
Dec 06 22:16:51.093 INFO [stdout] test test_ldindw ... ok
Dec 06 22:16:51.099 INFO [stdout] test test_large_immediate ... ok
Dec 06 22:16:51.099 INFO [stdout] test test_ldabsw ... ok
Dec 06 22:16:51.099 INFO [stdout] test test_lddw ... ok
Dec 06 22:16:51.099 INFO [stdout] test test_load_abs ... ok
Dec 06 22:16:51.100 INFO [stdout] test test_ldxdw ... ok
Dec 06 22:16:51.100 INFO [stdout] test test_jump_conditional ... ok
Dec 06 22:16:51.101 INFO [stdout] test test_ldxw ... ok
Dec 06 22:16:51.101 INFO [stdout] test test_store_reg ... ok
Dec 06 22:16:51.102 INFO [stdout] test test_stw ... ok
Dec 06 22:16:51.103 INFO [stdout] test test_sth ... ok
Dec 06 22:16:51.103 INFO [stdout] test test_neg64 ... ok
Dec 06 22:16:51.104 INFO [stdout] test test_load_reg ... ok
Dec 06 22:16:51.104 INFO [stdout] test test_load_ind ... ok
Dec 06 22:16:51.105 INFO [stdout] test test_stxh ... ok
Dec 06 22:16:51.105 INFO [stdout] test test_store_imm ... ok
Dec 06 22:16:51.109 INFO [stdout] test test_stxw ... ok
Dec 06 22:16:51.109 INFO [stdout] 
Dec 06 22:16:51.109 INFO [stdout] test result: ok. 27 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 22:16:51.109 INFO [stdout] 
Dec 06 22:16:51.110 INFO [stderr]      Running /target/debug/deps/misc-2340a269c61b2765
Dec 06 22:16:51.112 INFO [stdout] 
Dec 06 22:16:51.112 INFO [stdout] running 30 tests
Dec 06 22:16:51.116 INFO [stdout] test test_jit_mbuff ... ok
Dec 06 22:16:51.116 INFO [stdout] test test_jit_block_port ... ok
Dec 06 22:16:51.116 INFO [stdout] test test_get_last_instruction_count ... ok
Dec 06 22:16:51.116 INFO [stdout] test test_load_elf ... ok
Dec 06 22:16:51.116 INFO [stdout] test test_non_terminate_capped ... ok
Dec 06 22:16:51.117 INFO [stdout] test test_non_terminate_early ... ok
Dec 06 22:16:51.118 INFO [stdout] test test_verifier_success ... ok
Dec 06 22:16:51.118 INFO [stdout] test test_vm_block_port ... ok
Dec 06 22:16:51.119 INFO [stdout] test test_symbol_relocation ... ok
Dec 06 22:16:51.168 INFO [stdout] test test_jit_call_helper_wo_verifier ... ok
Dec 06 22:16:51.168 INFO [stdout] test test_verifier_fail ... ok
Dec 06 22:16:51.169 INFO [stdout] test test_load_elf_multiple_text ... ok
Dec 06 22:16:51.169 INFO [stdout] test test_unterminated_string ... ok
Dec 06 22:16:51.170 INFO [stdout] test test_null_string ... ok
Dec 06 22:16:51.170 INFO [stdout] test test_non_terminating ... ok
Dec 06 22:16:51.171 INFO [stdout] test test_vm_err_ldabsb_nomem ... ok
Dec 06 22:16:51.171 INFO [stdout] test test_vm_jit_ldabsh ... ok
Dec 06 22:16:51.176 INFO [stdout] test test_vm_exec_no_program ... ok
Dec 06 22:16:51.177 INFO [stdout] test test_vm_err_ldindb_nomem ... ok
Dec 06 22:16:51.177 INFO [stdout] test test_vm_err_ldindb_oob ... ok
Dec 06 22:16:51.177 INFO [stdout] test test_vm_jit_ldabsdw ... ok
Dec 06 22:16:51.177 INFO [stdout] test test_vm_err_ldabsb_oob ... ok
Dec 06 22:16:51.177 INFO [stdout] test test_vm_jit_ldabsb ... ok
Dec 06 22:16:51.177 INFO [stdout] test test_vm_jit_ldabsw ... ok
Dec 06 22:16:51.178 INFO [stdout] test test_vm_jit_ldindb ... ok
Dec 06 22:16:51.178 INFO [stdout] test test_vm_jit_ldinddw ... ok
Dec 06 22:16:51.178 INFO [stdout] test test_vm_jit_ldindw ... ok
Dec 06 22:16:51.178 INFO [stdout] test test_vm_jit_ldindh ... ok
Dec 06 22:16:51.178 INFO [stdout] test test_vm_mbuff_with_rust_api ... ok
Dec 06 22:16:51.178 INFO [stdout] test test_vm_mbuff ... ok
Dec 06 22:16:51.178 INFO [stdout] 
Dec 06 22:16:51.178 INFO [stdout] test result: ok. 30 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 22:16:51.178 INFO [stdout] 
Dec 06 22:16:51.182 INFO [stderr]      Running /target/debug/deps/ubpf_jit_x86_64-c0aca1043019d1d8
Dec 06 22:16:51.183 INFO [stdout] 
Dec 06 22:16:51.184 INFO [stdout] running 97 tests
Dec 06 22:16:51.187 INFO [stdout] test test_jit_alu64_bit ... ok
Dec 06 22:16:51.187 INFO [stdout] test test_jit_add ... ok
Dec 06 22:16:51.187 INFO [stdout] test test_jit_alu_arith ... ok
Dec 06 22:16:51.187 INFO [stdout] test test_jit_alu_bit ... ok
Dec 06 22:16:51.188 INFO [stdout] test test_jit_be16 ... ok
Dec 06 22:16:51.188 INFO [stdout] test test_jit_arsh ... ok
Dec 06 22:16:51.189 INFO [stdout] test test_jit_arsh_reg ... ok
Dec 06 22:16:51.189 INFO [stdout] test test_jit_arsh32_high_shift ... ok
Dec 06 22:16:51.190 INFO [stdout] test test_jit_be32 ... ok
Dec 06 22:16:51.190 INFO [stdout] test test_jit_call_memfrob ... ok
Dec 06 22:16:51.191 INFO [stdout] test test_jit_arsh64 ... ok
Dec 06 22:16:51.191 INFO [stdout] test test_jit_be64 ... ok
Dec 06 22:16:51.192 INFO [stdout] test test_jit_be16_high ... ok
Dec 06 22:16:51.192 INFO [stdout] test test_jit_call ... ok
Dec 06 22:16:51.193 INFO [stdout] test test_jit_early_exit ... ok
Dec 06 22:16:51.194 INFO [stdout] test test_jit_div64_imm ... ok
Dec 06 22:16:51.194 INFO [stdout] test test_jit_div64_reg ... ok
Dec 06 22:16:51.195 INFO [stdout] test test_jit_be32_high ... ok
Dec 06 22:16:51.200 INFO [stdout] test test_jit_div32_high_divisor ... ok
Dec 06 22:16:51.210 INFO [stdout] test test_jit_div32_imm ... ok
Dec 06 22:16:51.210 INFO [stdout] test test_jit_alu64_arith ... ok
Dec 06 22:16:51.212 INFO [stdout] test test_jit_div32_reg ... ok
Dec 06 22:16:51.214 INFO [stdout] test test_jit_jgt_reg ... ok
Dec 06 22:16:51.216 INFO [stdout] test test_jit_jeq_reg ... ok
Dec 06 22:16:51.217 INFO [stdout] test test_jit_exit ... ok
Dec 06 22:16:51.219 INFO [stdout] test test_jit_jeq_imm ... ok
Dec 06 22:16:51.219 INFO [stdout] test test_jit_jge_imm ... ok
Dec 06 22:16:51.220 INFO [stdout] test test_jit_ja ... ok
Dec 06 22:16:51.222 INFO [stdout] test test_jit_jgt_imm ... ok
Dec 06 22:16:51.223 INFO [stdout] test test_jit_jlt_imm ... ok
Dec 06 22:16:51.227 INFO [stdout] test test_jit_jit_bounce ... ok
Dec 06 22:16:51.227 INFO [stdout] test test_jit_jle_reg ... ok
Dec 06 22:16:51.230 INFO [stdout] test test_jit_jset_imm ... ok
Dec 06 22:16:51.252 INFO [stdout] test test_jit_jlt_reg ... ok
Dec 06 22:16:51.252 INFO [stdout] test test_jit_jne_reg ... ok
Dec 06 22:16:51.252 INFO [stdout] test test_jit_jsge_reg ... ok
Dec 06 22:16:51.252 INFO [stdout] test test_jit_jset_reg ... ok
Dec 06 22:16:51.253 INFO [stdout] test test_jit_jle_imm ... ok
Dec 06 22:16:51.253 INFO [stdout] test test_jit_jsge_imm ... ok
Dec 06 22:16:51.261 INFO [stdout] test test_jit_jslt_reg ... ok
Dec 06 22:16:51.262 INFO [stdout] test test_jit_jslt_imm ... ok
Dec 06 22:16:51.264 INFO [stdout] test test_jit_lddw ... ok
Dec 06 22:16:51.272 INFO [stdout] test test_jit_jsle_imm ... ok
Dec 06 22:16:51.272 INFO [stdout] test test_jit_jsgt_imm ... ok
Dec 06 22:16:51.278 INFO [stdout] test test_jit_jsgt_reg ... ok
Dec 06 22:16:51.278 INFO [stdout] test test_jit_ldxb_all ... ok
Dec 06 22:16:51.279 INFO [stdout] test test_jit_jsle_reg ... ok
Dec 06 22:16:51.279 INFO [stdout] test test_jit_ldxdw ... ok
Dec 06 22:16:51.295 INFO [stdout] test test_jit_ldxh_all ... ok
Dec 06 22:16:51.296 INFO [stdout] test test_jit_lddw2 ... ok
Dec 06 22:16:51.298 INFO [stdout] test test_jit_ldxw ... ok
Dec 06 22:16:51.300 INFO [stdout] test test_jit_ldxb ... ok
Dec 06 22:16:51.308 INFO [stdout] test test_jit_ldxh ... ok
Dec 06 22:16:51.309 INFO [stdout] test test_jit_ldxw_all ... ok
Dec 06 22:16:51.309 INFO [stdout] test test_jit_ldxh_all2 ... ok
Dec 06 22:16:51.309 INFO [stdout] test test_jit_ldxh_same_reg ... ok
Dec 06 22:16:51.313 INFO [stdout] test test_jit_mod ... ok
Dec 06 22:16:51.315 INFO [stdout] test test_jit_lsh_reg ... ok
Dec 06 22:16:51.336 INFO [stdout] test test_jit_mod64 ... ok
Dec 06 22:16:51.349 INFO [stdout] test test_jit_le64 ... ok
Dec 06 22:16:51.349 INFO [stdout] test test_jit_le32 ... ok
Dec 06 22:16:51.349 INFO [stdout] test test_jit_mod32 ... ok
Dec 06 22:16:51.349 INFO [stdout] test test_jit_mov ... ok
Dec 06 22:16:51.350 INFO [stdout] test test_jit_mul32_reg ... ok
Dec 06 22:16:51.350 INFO [stdout] test test_jit_le16 ... ok
Dec 06 22:16:51.351 INFO [stdout] test test_jit_mul32_imm ... ok
Dec 06 22:16:51.364 INFO [stdout] test test_jit_mul64_reg ... ok
Dec 06 22:16:51.368 INFO [stdout] test test_jit_mul32_reg_overflow ... ok
Dec 06 22:16:51.369 INFO [stdout] test test_jit_prime ... ok
Dec 06 22:16:51.384 INFO [stdout] test test_jit_neg64 ... ok
Dec 06 22:16:51.385 INFO [stdout] test test_jit_mul_loop ... ok
Dec 06 22:16:51.389 INFO [stdout] test test_jit_neg ... ok
Dec 06 22:16:51.389 INFO [stdout] test test_jit_mul64_imm ... ok
Dec 06 22:16:51.404 INFO [stdout] test test_jit_rhs32 ... ok
Dec 06 22:16:51.440 INFO [stdout] test test_jit_rsh_reg ... ok
Dec 06 22:16:51.441 INFO [stdout] test test_jit_stdw ... ok
Dec 06 22:16:51.441 INFO [stdout] test test_jit_stack ... ok
Dec 06 22:16:51.448 INFO [stdout] test test_jit_stb ... ok
Dec 06 22:16:51.449 INFO [stdout] test test_jit_string_stack ... ok
Dec 06 22:16:51.456 INFO [stdout] test test_jit_sth ... ok
Dec 06 22:16:51.458 INFO [stdout] test test_jit_stack2 ... ok
Dec 06 22:16:51.464 INFO [stdout] test test_jit_stw ... ok
Dec 06 22:16:51.496 INFO [stdout] test test_jit_stxb_all ... ok
Dec 06 22:16:51.516 INFO [stdout] test test_jit_stxb ... ok
Dec 06 22:16:51.516 INFO [stdout] test test_jit_stxb_all2 ... ok
Dec 06 22:16:51.520 INFO [stdout] test test_jit_stxb_chain ... ok
Dec 06 22:16:51.521 INFO [stdout] test test_jit_tcp_port80_match ... ok
Dec 06 22:16:51.522 INFO [stdout] test test_jit_tcp_port80_nomatch ... ok
Dec 06 22:16:51.536 INFO [stdout] test test_jit_stxw ... ok
Dec 06 22:16:51.536 INFO [stdout] test test_jit_stxh ... ok
Dec 06 22:16:51.536 INFO [stdout] test test_jit_tcp_port80_nomatch_ethertype ... ok
Dec 06 22:16:51.541 INFO [stdout] test test_jit_tcp_port80_nomatch_proto ... ok
Dec 06 22:16:51.542 INFO [stdout] test test_jit_stxdw ... ok
Dec 06 22:16:51.568 INFO [stdout] test test_jit_subnet ... ok
Dec 06 22:16:51.568 INFO [stdout] test test_jit_tcp_sack_match ... ok
Dec 06 22:16:51.594 INFO [stdout] test test_jit_tcp_sack_nomatch ... ok
Dec 06 22:16:51.656 INFO [stdout] test test_jit_err_call_unreg ... ok
Dec 06 22:16:51.656 INFO [stdout] 
Dec 06 22:16:51.656 INFO [stdout] test result: ok. 97 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 22:16:51.656 INFO [stdout] 
Dec 06 22:16:51.660 INFO [stderr]      Running /target/debug/deps/ubpf_verifier-69d205cb71b138e4
Dec 06 22:16:51.670 INFO [stdout] 
Dec 06 22:16:51.670 INFO [stdout] running 12 tests
Dec 06 22:16:51.799 INFO [stdout] test test_verifier_err_endian_size ... ok
Dec 06 22:16:51.800 INFO [stdout] test test_verifier_err_jmp_out ... ok
Dec 06 22:16:51.801 INFO [stdout] test test_verifier_err_jmp_lddw ... ok
Dec 06 22:16:51.802 INFO [stdout] test test_verifier_err_invalid_reg_src ... ok
Dec 06 22:16:51.802 INFO [stdout] test test_verifier_err_infinite_loop ... ok
Dec 06 22:16:51.803 INFO [stdout] test test_verifier_err_invalid_reg_dst ... ok
Dec 06 22:16:51.803 INFO [stdout] test test_verifier_err_incomplete_lddw ... ok
Dec 06 22:16:51.804 INFO [stdout] test test_verifier_err_unknown_opcode ... ok
Dec 06 22:16:51.805 INFO [stdout] test test_verifier_err_write_r10 ... ok
Dec 06 22:16:51.812 INFO [stdout] test test_verifier_err_too_many_instructions ... ok
Dec 06 22:16:51.812 INFO [stdout] test test_verifier_err_div_by_zero_imm ... ok
Dec 06 22:16:51.814 INFO [stdout] test test_verifier_err_no_exit ... ok
Dec 06 22:16:51.814 INFO [stdout] 
Dec 06 22:16:51.814 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 22:16:51.814 INFO [stdout] 
Dec 06 22:16:51.821 INFO [stderr]      Running /target/debug/deps/ubpf_vm-944e963eb30857f4
Dec 06 22:16:51.826 INFO [stdout] 
Dec 06 22:16:51.826 INFO [stdout] running 102 tests
Dec 06 22:16:51.827 INFO [stdout] test test_vm_arsh32_high_shift ... ok
Dec 06 22:16:51.828 INFO [stdout] test test_vm_arsh64 ... ok
Dec 06 22:16:51.828 INFO [stdout] test test_vm_arsh ... ok
Dec 06 22:16:51.829 INFO [stdout] test test_vm_alu_bit ... ok
Dec 06 22:16:51.831 INFO [stdout] test test_vm_alu_arith ... ok
Dec 06 22:16:51.833 INFO [stdout] test test_vm_alu64_arith ... ok
Dec 06 22:16:51.833 INFO [stdout] test test_vm_alu64_bit ... ok
Dec 06 22:16:51.834 INFO [stdout] test test_vm_arsh_reg ... ok
Dec 06 22:16:51.849 INFO [stdout] test test_vm_be16 ... ok
Dec 06 22:16:51.849 INFO [stdout] test test_vm_be32 ... ok
Dec 06 22:16:51.850 INFO [stdout] test test_vm_be16_high ... ok
Dec 06 22:16:51.850 INFO [stdout] test test_vm_add ... ok
Dec 06 22:16:51.851 INFO [stdout] test test_vm_be32_high ... ok
Dec 06 22:16:51.851 INFO [stdout] test test_vm_div32_high_divisor ... ok
Dec 06 22:16:51.851 INFO [stdout] test test_vm_call_memfrob ... ok
Dec 06 22:16:51.851 INFO [stdout] test test_vm_early_exit ... ok
Dec 06 22:16:51.852 INFO [stdout] test test_vm_be64 ... ok
Dec 06 22:16:51.852 INFO [stdout] test test_vm_div32_reg ... ok
Dec 06 22:16:51.853 INFO [stdout] test test_vm_div32_imm ... ok
Dec 06 22:16:51.894 INFO [stdout] test test_vm_div64_imm ... ok
Dec 06 22:16:51.894 INFO [stdout] test test_vm_div64_reg ... ok
Dec 06 22:16:51.897 INFO [stdout] test test_vm_exit ... ok
Dec 06 22:16:51.898 INFO [stdout] test test_vm_call ... ok
Dec 06 22:16:51.899 INFO [stdout] test test_vm_ja ... ok
Dec 06 22:16:51.899 INFO [stdout] test test_vm_jeq_imm ... ok
Dec 06 22:16:51.921 INFO [stdout] test test_vm_jge_imm ... ok
Dec 06 22:16:51.940 INFO [stdout] test test_vm_jeq_reg ... ok
Dec 06 22:16:51.981 INFO [stdout] test test_vm_jgt_imm ... ok
Dec 06 22:16:51.988 INFO [stdout] test test_vm_jgt_reg ... ok
Dec 06 22:16:51.988 INFO [stdout] test test_vm_jit_bounce ... ok
Dec 06 22:16:52.004 INFO [stdout] test test_vm_jle_imm ... ok
Dec 06 22:16:52.004 INFO [stdout] test test_vm_jle_reg ... ok
Dec 06 22:16:52.007 INFO [stdout] test test_vm_jlt_reg ... ok
Dec 06 22:16:52.007 INFO [stdout] test test_vm_jlt_imm ... ok
Dec 06 22:16:52.007 INFO [stdout] test test_vm_jset_imm ... ok
Dec 06 22:16:52.012 INFO [stdout] test test_vm_jset_reg ... ok
Dec 06 22:16:52.012 INFO [stdout] test test_vm_jsge_imm ... ok
Dec 06 22:16:52.012 INFO [stdout] test test_vm_jne_reg ... ok
Dec 06 22:16:52.012 INFO [stdout] test test_vm_jsgt_imm ... ok
Dec 06 22:16:52.012 INFO [stdout] test test_vm_jsge_reg ... ok
Dec 06 22:16:52.012 INFO [stdout] test test_vm_jsle_imm ... ok
Dec 06 22:16:52.016 INFO [stdout] test test_vm_jsgt_reg ... ok
Dec 06 22:16:52.016 INFO [stdout] test test_vm_jslt_imm ... ok
Dec 06 22:16:52.016 INFO [stdout] test test_vm_jsle_reg ... ok
Dec 06 22:16:52.016 INFO [stdout] test test_vm_jslt_reg ... ok
Dec 06 22:16:52.016 INFO [stdout] test test_vm_lddw ... ok
Dec 06 22:16:52.016 INFO [stdout] test test_vm_lddw2 ... ok
Dec 06 22:16:52.028 INFO [stdout] test test_vm_ldxb ... ok
Dec 06 22:16:52.028 INFO [stdout] test test_vm_ldxb_all ... ok
Dec 06 22:16:52.048 INFO [stdout] test test_vm_ldxdw ... ok
Dec 06 22:16:52.048 INFO [stdout] test test_vm_ldxh ... ok
Dec 06 22:16:52.058 INFO [stdout] test test_vm_ldxh_all ... ok
Dec 06 22:16:52.058 INFO [stdout] test test_vm_ldxh_all2 ... ok
Dec 06 22:16:52.060 INFO [stdout] test test_vm_ldxh_same_reg ... ok
Dec 06 22:16:52.060 INFO [stdout] test test_vm_ldxw ... ok
Dec 06 22:16:52.072 INFO [stdout] test test_vm_ldxw_all ... ok
Dec 06 22:16:52.072 INFO [stdout] test test_vm_le16 ... ok
Dec 06 22:16:52.076 INFO [stdout] test test_vm_le32 ... ok
Dec 06 22:16:52.076 INFO [stdout] test test_vm_le64 ... ok
Dec 06 22:16:52.077 INFO [stdout] test test_vm_lsh_reg ... ok
Dec 06 22:16:52.092 INFO [stdout] test test_vm_mod32 ... ok
Dec 06 22:16:52.092 INFO [stdout] test test_vm_mod ... ok
Dec 06 22:16:52.092 INFO [stdout] test test_vm_mod64 ... ok
Dec 06 22:16:52.096 INFO [stdout] test test_vm_mov ... ok
Dec 06 22:16:52.100 INFO [stdout] test test_vm_err_call_unreg ... ok
Dec 06 22:16:52.100 INFO [stdout] test test_vm_err_mod_by_zero_reg ... ok
Dec 06 22:16:52.100 INFO [stdout] test test_vm_err_div64_by_zero_reg ... ok
Dec 06 22:16:52.104 INFO [stdout] test test_vm_mul32_imm ... ok
Dec 06 22:16:52.104 INFO [stdout] test test_vm_err_stack_out_of_bound ... ok
Dec 06 22:16:52.104 INFO [stdout] test test_vm_err_mod64_by_zero_reg ... ok
Dec 06 22:16:52.112 INFO [stdout] test test_vm_mul64_reg ... ok
Dec 06 22:16:52.112 INFO [stdout] test test_vm_mul_loop ... ok
Dec 06 22:16:52.112 INFO [stdout] test test_vm_mul64_imm ... ok
Dec 06 22:16:52.112 INFO [stdout] test test_vm_mul32_reg_overflow ... ok
Dec 06 22:16:52.112 INFO [stdout] test test_vm_mul32_reg ... ok
Dec 06 22:16:52.113 INFO [stdout] test test_vm_neg ... ok
Dec 06 22:16:52.113 INFO [stdout] test test_vm_neg64 ... ok
Dec 06 22:16:52.113 INFO [stdout] test test_vm_err_div_by_zero_reg ... ok
Dec 06 22:16:52.114 INFO [stdout] test test_vm_rsh_reg ... ok
Dec 06 22:16:52.115 INFO [stdout] test test_vm_prime ... ok
Dec 06 22:16:52.115 INFO [stdout] test test_vm_stb ... ok
Dec 06 22:16:52.115 INFO [stdout] test test_vm_stdw ... ok
Dec 06 22:16:52.115 INFO [stdout] test test_vm_stack2 ... ok
Dec 06 22:16:52.115 INFO [stdout] test test_vm_rhs32 ... ok
Dec 06 22:16:52.116 INFO [stdout] test test_vm_string_stack ... ok
Dec 06 22:16:52.116 INFO [stdout] test test_vm_sth ... ok
Dec 06 22:16:52.116 INFO [stdout] test test_vm_stxb ... ok
Dec 06 22:16:52.116 INFO [stdout] test test_vm_stw ... ok
Dec 06 22:16:52.116 INFO [stdout] test test_vm_stxb_all2 ... ok
Dec 06 22:16:52.116 INFO [stdout] test test_vm_stack ... ok
Dec 06 22:16:52.120 INFO [stdout] test test_vm_stxdw ... ok
Dec 06 22:16:52.120 INFO [stdout] test test_vm_stxh ... ok
Dec 06 22:16:52.121 INFO [stdout] test test_vm_tcp_port80_nomatch ... ok
Dec 06 22:16:52.121 INFO [stdout] test test_vm_tcp_port80_nomatch_proto ... ok
Dec 06 22:16:52.121 INFO [stdout] test test_vm_tcp_port80_match ... ok
Dec 06 22:16:52.122 INFO [stdout] test test_vm_stxb_all ... ok
Dec 06 22:16:52.123 INFO [stdout] test test_vm_stxw ... ok
Dec 06 22:16:52.134 INFO [stdout] test test_vm_subnet ... ok
Dec 06 22:16:52.137 INFO [stdout] test test_vm_stxb_chain ... ok
Dec 06 22:16:52.140 INFO [stdout] test test_vm_tcp_sack_match ... ok
Dec 06 22:16:52.144 INFO [stdout] test test_vm_tcp_sack_nomatch ... ok
Dec 06 22:16:52.163 INFO [stdout] test test_vm_tcp_port80_nomatch_ethertype ... ok
Dec 06 22:16:52.163 INFO [stdout] 
Dec 06 22:16:52.163 INFO [stdout] test result: ok. 102 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 22:16:52.163 INFO [stdout] 
Dec 06 22:16:52.176 INFO [stderr]    Doc-tests solana_rbpf
Dec 06 22:16:54.424 INFO [stdout] 
Dec 06 22:16:54.424 INFO [stdout] running 55 tests
Dec 06 22:17:05.056 INFO [stdout] test src/ebpf.rs - ebpf::get_insn (line 507) ... ok
Dec 06 22:17:05.312 INFO [stdout] test src/disassembler.rs - disassembler::disassemble (line 323) ... ok
Dec 06 22:17:06.636 INFO [stdout] test src/ebpf.rs - ebpf::Insn::to_array (line 436) ... ok
Dec 06 22:17:11.668 INFO [stdout] test src/assembler.rs - assembler::assemble (line 210) ... ok
Dec 06 22:17:11.920 INFO [stdout] test src/ebpf.rs - ebpf::Insn::to_vec (line 468) ... ok
Dec 06 22:17:12.491 INFO [stdout] test src/ebpf.rs - ebpf::get_insn (line 520) ... ok
Dec 06 22:17:13.032 INFO [stdout] test src/ebpf.rs - ebpf::to_insn_vec (line 556) ... ok
Dec 06 22:17:13.033 INFO [stdout] test src/disassembler.rs - disassembler::to_insn_vec (line 122) ... ok
Dec 06 22:17:21.164 INFO [stdout] test src/helpers.rs - helpers::bpf_time_getns (line 41) ... ok
Dec 06 22:17:23.332 INFO [stdout] test src/helpers.rs - helpers::bpf_trace_printf (line 72) ... ok
Dec 06 22:17:24.547 INFO [stdout] test src/helpers.rs - helpers::gather_bytes (line 122) ... ok
Dec 06 22:17:25.057 INFO [stdout] test src/helpers.rs - helpers::rand (line 251) ... ok
Dec 06 22:17:26.432 INFO [stdout] test src/helpers.rs - helpers::memfrob (line 142) ... ok
Dec 06 22:17:29.460 INFO [stdout] test src/helpers.rs - helpers::sqrti (line 190) ... ok
Dec 06 22:17:32.616 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff (line 881) ... ok
Dec 06 22:17:34.680 INFO [stdout] test src/helpers.rs - helpers::strcmp (line 206) ... ok
Dec 06 22:17:36.703 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::execute_program (line 1168) ... ok
Dec 06 22:17:41.648 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::jit_compile (line 1208) ... ok
Dec 06 22:17:42.008 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::execute_program_jit (line 1262) ... ok
Dec 06 22:17:47.473 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::get_last_instruction_count (line 1058) ... ok
Dec 06 22:17:49.052 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::new (line 926) ... ok
Dec 06 22:17:49.057 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::register_helper (line 1091) ... ok
Dec 06 22:17:49.984 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::set_program (line 962) ... ok
Dec 06 22:17:50.336 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::set_max_instruction_count (line 1036) ... ok
Dec 06 22:17:53.928 INFO [stdout] test src/lib.rs - EbpfVmMbuff (line 73) ... ok
Dec 06 22:17:54.347 INFO [stdout] test src/lib.rs - EbpfVmFixedMbuff<'a>::set_verifier (line 1003) ... ok
Dec 06 22:17:55.919 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::execute_program (line 359) ... ok
Dec 06 22:17:58.172 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::execute_program_jit (line 794) ... ok
Dec 06 22:17:59.272 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::jit_compile (line 744) ... ok
Dec 06 22:17:59.868 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::register_helper (line 287) ... ok
Dec 06 22:18:00.293 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::get_last_instruction_count (line 244) ... ok
Dec 06 22:18:03.335 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::new (line 117) ... ok
Dec 06 22:18:04.715 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::set_max_instruction_count (line 221) ... ok
Dec 06 22:18:05.698 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::set_verifier (line 182) ... ok
Dec 06 22:18:06.437 INFO [stdout] test src/lib.rs - EbpfVmMbuff<'a>::set_program (line 147) ... ok
Dec 06 22:18:08.852 INFO [stdout] test src/lib.rs - EbpfVmNoData (line 1669) ... ok
Dec 06 22:18:09.947 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::execute_program_jit (line 1971) ... ok
Dec 06 22:18:11.160 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::execute_program (line 1940) ... ok
Dec 06 22:18:11.416 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::get_last_instruction_count (line 1828) ... ok
Dec 06 22:18:13.536 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::jit_compile (line 1920) ... ok
Dec 06 22:18:16.672 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::register_helper (line 1857) ... ok
Dec 06 22:18:17.415 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::new (line 1714) ... ok
Dec 06 22:18:17.447 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::set_max_instruction_count (line 1806) ... ok
Dec 06 22:18:20.873 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::set_program (line 1735) ... ok
Dec 06 22:18:21.252 INFO [stdout] test src/lib.rs - EbpfVmNoData<'a>::set_verifier (line 1773) ... ok
Dec 06 22:18:22.392 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::execute_program (line 1562) ... ok
Dec 06 22:18:25.372 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::execute_program_jit (line 1635) ... ok
Dec 06 22:18:26.055 INFO [stdout] test src/lib.rs - EbpfVmRaw (line 1319) ... ok
Dec 06 22:18:28.896 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::get_last_instruction_count (line 1464) ... ok
Dec 06 22:18:29.690 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::new (line 1348) ... ok
Dec 06 22:18:29.729 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::jit_compile (line 1590) ... ok
Dec 06 22:18:32.300 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::set_program (line 1370) ... ok
Dec 06 22:18:32.448 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::register_helper (line 1497) ... ok
Dec 06 22:18:32.540 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::set_max_instruction_count (line 1442) ... ok
Dec 06 22:18:33.508 INFO [stdout] test src/lib.rs - EbpfVmRaw<'a>::set_verifier (line 1409) ... ok
Dec 06 22:18:33.508 INFO [stdout] 
Dec 06 22:18:33.508 INFO [stdout] test result: ok. 55 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 22:18:33.508 INFO [stdout] 
Dec 06 22:18:33.528 INFO [stderr] su: No module specific data is present
Dec 06 22:18:33.897 INFO running `"docker" "inspect" "fa9b4a7bf34a124379e0afff59d7ebc2d3b234aba7edd617fffeca552639e33f"`
Dec 06 22:18:34.002 INFO running `"docker" "rm" "-f" "fa9b4a7bf34a124379e0afff59d7ebc2d3b234aba7edd617fffeca552639e33f"`
Dec 06 22:18:34.140 INFO [stdout] fa9b4a7bf34a124379e0afff59d7ebc2d3b234aba7edd617fffeca552639e33f