Nov 18 01:16:29.786 INFO testing rsbx-1.1.2 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 18 01:16:29.787 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 18 01:16:30.239 INFO [stdout] b3330a84bda4bdec247b58c664b295dff1e63545eeec614bbf7c9d7ec3dcb33c
Nov 18 01:16:30.243 INFO running `"docker" "start" "-a" "b3330a84bda4bdec247b58c664b295dff1e63545eeec614bbf7c9d7ec3dcb33c"`
Nov 18 01:16:31.471 INFO [stderr] usermod: no changes
Nov 18 01:16:31.706 INFO [stderr]    Compiling rsbx v1.1.2 (/source)
Nov 18 01:16:31.706 INFO [stderr]    Compiling cty v0.1.5
Nov 18 01:16:31.709 INFO [stderr]    Compiling blake2_c v0.3.3
Nov 18 01:16:31.710 INFO [stderr]    Compiling reed-solomon-erasure v3.1.1
Nov 18 01:16:53.607 INFO [stderr] warning: unused `#[macro_use]` import
Nov 18 01:16:53.608 INFO [stderr]  --> src/bin/main.rs:4:1
Nov 18 01:16:53.608 INFO [stderr]   |
Nov 18 01:16:53.608 INFO [stderr] 4 | #[macro_use]
Nov 18 01:16:53.609 INFO [stderr]   | ^^^^^^^^^^^^
Nov 18 01:16:53.609 INFO [stderr]   |
Nov 18 01:16:53.609 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Nov 18 01:16:53.610 INFO [stderr] 
Nov 18 01:16:55.999 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 24.51s
Nov 18 01:16:56.016 INFO [stderr] su: No module specific data is present
Nov 18 01:16:56.559 INFO running `"docker" "inspect" "b3330a84bda4bdec247b58c664b295dff1e63545eeec614bbf7c9d7ec3dcb33c"`
Nov 18 01:16:56.819 INFO running `"docker" "rm" "-f" "b3330a84bda4bdec247b58c664b295dff1e63545eeec614bbf7c9d7ec3dcb33c"`
Nov 18 01:16:57.086 INFO [stdout] b3330a84bda4bdec247b58c664b295dff1e63545eeec614bbf7c9d7ec3dcb33c
Nov 18 01:16:57.088 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 18 01:16:57.495 INFO [stdout] 90ea1dc430f6ccad9e23c6c6eb3ee70bc464c039e37a3818bf58bf09b3b12de1
Nov 18 01:16:57.501 INFO running `"docker" "start" "-a" "90ea1dc430f6ccad9e23c6c6eb3ee70bc464c039e37a3818bf58bf09b3b12de1"`
Nov 18 01:16:58.518 INFO [stderr] usermod: no changes
Nov 18 01:16:58.683 INFO [stderr]    Compiling rsbx v1.1.2 (/source)
Nov 18 01:17:01.674 INFO [stderr] warning: unused `#[macro_use]` import
Nov 18 01:17:01.674 INFO [stderr]  --> src/bin/main.rs:4:1
Nov 18 01:17:01.674 INFO [stderr]   |
Nov 18 01:17:01.674 INFO [stderr] 4 | #[macro_use]
Nov 18 01:17:01.674 INFO [stderr]   | ^^^^^^^^^^^^
Nov 18 01:17:01.674 INFO [stderr]   |
Nov 18 01:17:01.674 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Nov 18 01:17:01.674 INFO [stderr] 
Nov 18 01:17:18.625 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 20.07s
Nov 18 01:17:18.639 INFO [stderr] su: No module specific data is present
Nov 18 01:17:19.873 INFO running `"docker" "inspect" "90ea1dc430f6ccad9e23c6c6eb3ee70bc464c039e37a3818bf58bf09b3b12de1"`
Nov 18 01:17:20.211 INFO running `"docker" "rm" "-f" "90ea1dc430f6ccad9e23c6c6eb3ee70bc464c039e37a3818bf58bf09b3b12de1"`
Nov 18 01:17:20.496 INFO [stdout] 90ea1dc430f6ccad9e23c6c6eb3ee70bc464c039e37a3818bf58bf09b3b12de1
Nov 18 01:17:20.498 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 18 01:17:20.873 INFO [stdout] 7d3df05864ba6a37cacfc34c84546c49721bc826027a2f861c7d8726c5682918
Nov 18 01:17:20.877 INFO running `"docker" "start" "-a" "7d3df05864ba6a37cacfc34c84546c49721bc826027a2f861c7d8726c5682918"`
Nov 18 01:17:22.391 INFO [stderr] usermod: no changes
Nov 18 01:17:22.562 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.13s
Nov 18 01:17:22.583 INFO [stderr]      Running /target/debug/deps/rsbx_lib-9a42ddd16150498d
Nov 18 01:17:22.583 INFO [stdout] 
Nov 18 01:17:22.583 INFO [stdout] running 93 tests
Nov 18 01:17:22.599 INFO [stdout] test crc_ccitt::tests::basic_value_tests_0x1d0f ... ok
Nov 18 01:17:22.599 INFO [stdout] test crc_ccitt::tests::basic_value_tests_0xffff ... ok
Nov 18 01:17:22.599 INFO [stdout] test file_utils_tests::from_orig_file_size::qc_calc_data_only_and_parity_block_count_exc_burst_gaps_rs_disabled ... ok
Nov 18 01:17:22.599 INFO [stdout] test file_utils_tests::from_orig_file_size::qc_calc_data_block_count_exc_burst_gaps_consistent_rs_enabled ... ok
Nov 18 01:17:22.599 INFO [stdout] test file_utils_tests::from_orig_file_size::qc_calc_data_block_count_exc_burst_gaps_consistent_rs_disabled ... ok
Nov 18 01:17:22.599 INFO [stdout] test file_utils_tests::from_orig_file_size::qc_calc_container_size_rs_enabled_not_too_off ... ok
Nov 18 01:17:22.607 INFO [stdout] test file_utils_tests::from_orig_file_size::qc_calc_total_block_count_exc_burst_gaps_consistent_rs_disabled ... ok
Nov 18 01:17:22.607 INFO [stdout] test file_utils_tests::from_orig_file_size::qc_calc_total_block_count_exc_burst_gaps_consistent_rs_enabled ... ok
Nov 18 01:17:22.607 INFO [stdout] test file_utils_tests::from_orig_file_size::test_calc_container_size_simple_cases ... ok
Nov 18 01:17:22.607 INFO [stdout] test file_utils_tests::qc_calc_meta_block_count_exc_burst_gaps_rs_enabled ... ok
Nov 18 01:17:22.607 INFO [stdout] test file_utils_tests::test_calc_meta_block_count_exc_burst_gaps_rs_disabled ... ok
Nov 18 01:17:22.608 INFO [stdout] test file_utils_tests::test_get_file_name_part_of_path_simple_cases ... ok
Nov 18 01:17:22.611 INFO [stdout] test file_utils_tests::from_orig_file_size::qc_calc_container_size_rs_enabled_no_data ... ok
Nov 18 01:17:22.613 INFO [stdout] test integer_utils_tests::test_round_down_to_multiple_simple_cases ... ok
Nov 18 01:17:22.613 INFO [stdout] test integer_utils_tests::test_round_up_to_multiple_simple_cases ... ok
Nov 18 01:17:22.614 INFO [stdout] test integer_utils_tests::qc_round_up_to_multiple ... ok
Nov 18 01:17:22.614 INFO [stdout] test file_utils_tests::from_orig_file_size::qc_calc_data_only_and_parity_block_count_exc_burst_gaps_rs_enabled ... ok
Nov 18 01:17:22.614 INFO [stdout] test integer_utils_tests::qc_ensure_at_most ... ok
Nov 18 01:17:22.614 INFO [stdout] test integer_utils_tests::qc_round_down_to_multiple ... ok
Nov 18 01:17:22.615 INFO [stdout] test integer_utils_tests::qc_ensure_at_least ... ok
Nov 18 01:17:22.616 INFO [stdout] test misc_utils_tests::test_f64_max_simple_cases ... ok
Nov 18 01:17:22.616 INFO [stdout] test misc_utils_tests::qc_calc_required_len_and_seek_to_from_byte_range ... ok
Nov 18 01:17:22.616 INFO [stdout] test misc_utils_tests::test_camelcase ... ok
Nov 18 01:17:22.617 INFO [stdout] test misc_utils_tests::test_buffer_is_blank_simple_cases ... ok
Nov 18 01:17:22.623 INFO [stdout] test misc_utils_tests::hex_tests::error_handling ... ok
Nov 18 01:17:22.623 INFO [stdout] test misc_utils_tests::hex_tests::hex_to_bytes_test_cases ... ok
Nov 18 01:17:22.623 INFO [stdout] test misc_utils_tests::hex_tests::bytes_to_hex_test_cases ... ok
Nov 18 01:17:22.623 INFO [stdout] test misc_utils_tests::test_make_path_simple_cases ... ok
Nov 18 01:17:22.623 INFO [stdout] test multihash_tests::test_string_to_hash_type ... ok
Nov 18 01:17:22.623 INFO [stdout] test multihash_tests::test_specs ... ok
Nov 18 01:17:22.623 INFO [stdout] test multihash_tests::test_hash_type_to_string ... ok
Nov 18 01:17:22.631 INFO [stdout] test multihash_tests::test_vectors::multihash_blake2b_512_bytes ... ok
Nov 18 01:17:22.635 INFO [stdout] test multihash_tests::test_vectors::blake2b_512_test_vectors ... ok
Nov 18 01:17:22.635 INFO [stdout] test multihash_tests::test_vectors::multihash_sha1_bytes ... ok
Nov 18 01:17:22.635 INFO [stdout] test multihash_tests::test_vectors::multihash_sha512_bytes ... ok
Nov 18 01:17:22.635 INFO [stdout] test multihash_tests::test_vectors::multihash_sha256_bytes ... ok
Nov 18 01:17:22.847 INFO [stdout] test rs_codec::encoder_tests::test_encoder_encode_correctly_simple_cases ... ok
Nov 18 01:17:22.847 INFO [stdout] test sbx_block::header_tests::test_from_bytes_error_handling ... ok
Nov 18 01:17:22.887 INFO [stdout] test sbx_block::header_tests::test_from_bytes_versions ... ok
Nov 18 01:17:22.892 INFO [stdout] test rs_codec::repairer_tests::test_repairer_repair_properly_simple_cases ... ok
Nov 18 01:17:23.152 INFO [stdout] test sbx_block::header_tests::test_from_to_from_bytes ... ok
Nov 18 01:17:23.699 INFO [stdout] test multihash_tests::test_vectors::sha512_test_vectors ... ok
Nov 18 01:17:23.699 INFO [stdout] test multihash_tests::test_vectors::sha256_test_vectors ... ok
Nov 18 01:17:23.699 INFO [stdout] test sbx_block::header_tests::test_to_bytes_versions ... ok
Nov 18 01:17:23.703 INFO [stdout] test sbx_block::metadata_tests::test_filter_invalid_metadata_simple_cases ... ok
Nov 18 01:17:23.703 INFO [stdout] test sbx_block::metadata_tests::test_from_bytes_simple_cases ... ok
Nov 18 01:17:23.703 INFO [stdout] test sbx_block::metadata_tests::test_get_meta_ref_by_id ... ok
Nov 18 01:17:23.704 INFO [stdout] test sbx_block::metadata_tests::test_get_meta_ref_mut_by_id ... ok
Nov 18 01:17:23.737 INFO [stdout] test sbx_block::metadata_tests::test_id_to_str ... ok
Nov 18 01:17:23.737 INFO [stdout] test sbx_block::header_tests::test_to_from_to_bytes ... ok
Nov 18 01:17:23.738 INFO [stdout] test sbx_block::metadata_tests::test_to_bytes_simple_cases ... ok
Nov 18 01:17:23.747 INFO [stdout] test sbx_block::tests::qc_add_seq_num ... ok
Nov 18 01:17:23.776 INFO [stdout] test sbx_block::metadata_tests::test_meta_to_id ... ok
Nov 18 01:17:23.776 INFO [stdout] test sbx_block::tests::qc_block_is_parity_matches_seq_num_is_parity ... ok
Nov 18 01:17:23.787 INFO [stdout] test sbx_block::tests::qc_calc_data_chunk_write_index_rs_disabled ... ok
Nov 18 01:17:23.807 INFO [stdout] test sbx_block::tests::qc_calc_data_chunk_write_index_rs_enabled_ret_opt_correctly ... ok
Nov 18 01:17:23.843 INFO [stdout] test sbx_block::tests::qc_calc_data_chunk_write_pos_consistent_rs_disabled ... ok
Nov 18 01:17:23.851 INFO [stdout] test sbx_block::header_tests::test_to_bytes_error_handling_case1 ... ok
Nov 18 01:17:23.851 INFO [stdout] test sbx_block::header_tests::test_to_bytes_error_handling_case2 ... ok
Nov 18 01:17:23.851 INFO [stdout] test sbx_block::tests::qc_data_block_write_pos_consistent_rs_disabled ... ok
Nov 18 01:17:23.851 INFO [stdout] test sbx_block::tests::qc_data_seq_num_to_index_to_seq_num_meta_default ... ok
Nov 18 01:17:23.851 INFO [stdout] test sbx_block::tests::qc_data_seq_num_to_index_to_seq_num_meta_disabled ... ok
Nov 18 01:17:23.851 INFO [stdout] test sbx_block::tests::qc_data_seq_num_to_index_to_seq_num_meta_enabled ... ok
Nov 18 01:17:23.863 INFO [stdout] test sbx_block::tests::qc_data_seq_num_to_index_to_seq_num_rs_enabled ... ok
Nov 18 01:17:23.871 INFO [stdout] test sbx_block::tests::qc_data_block_write_pos_consistent_rs_enabled ... ok
Nov 18 01:17:23.871 INFO [stdout] test sbx_block::tests::qc_meta_block_write_indices_data_block_write_indices_disjoint_rs_disabled ... ok
Nov 18 01:17:23.871 INFO [stdout] test sbx_block::tests::qc_calc_data_chunk_write_pos_consistent_rs_enabled ... ok
Nov 18 01:17:23.887 INFO [stdout] test sbx_block::tests::qc_meta_block_write_indices_data_block_write_indices_disjoint_rs_enabled ... ok
Nov 18 01:17:23.887 INFO [stdout] test sbx_block::tests::qc_meta_block_write_pos_s_consistent_rs_disabled ... ok
Nov 18 01:17:23.891 INFO [stdout] test sbx_block::tests::test_calc_data_chunk_write_index_simple_cases ... ok
Nov 18 01:17:23.891 INFO [stdout] test sbx_block::tests::qc_set_get_seq_num ... ok
Nov 18 01:17:23.891 INFO [stdout] test sbx_block::tests::test_calc_rs_enabled_meta_write_indices ... ok
Nov 18 01:17:23.903 INFO [stdout] test sbx_block::tests::test_calc_rs_enabled_data_write_index_simple_cases ... ok
Nov 18 01:17:23.903 INFO [stdout] test sbx_block::tests::test_calc_rs_enabled_seq_num_at_index_simple_cases ... ok
Nov 18 01:17:23.923 INFO [stdout] test sbx_block::tests::test_get_version_simple_cases ... ok
Nov 18 01:17:23.923 INFO [stdout] test sbx_block::tests::test_seq_num_is_parity_simple_cases ... ok
Nov 18 01:17:23.931 INFO [stdout] test sbx_block::tests::test_set_uid ... ok
Nov 18 01:17:23.931 INFO [stdout] test sbx_block::tests::test_get_uid ... ok
Nov 18 01:17:23.931 INFO [stdout] test sbx_block::tests::test_set_version_simple_cases ... ok
Nov 18 01:17:23.963 INFO [stdout] test sbx_block::tests::test_sync_to_buffer_simple_cases ... ok
Nov 18 01:17:23.963 INFO [stdout] test sbx_block::tests::test_sync_from_buffer_simple_cases ... ok
Nov 18 01:17:23.963 INFO [stdout] test sbx_specs_tests::test_string_to_ver ... ok
Nov 18 01:17:23.963 INFO [stdout] test sbx_specs_tests::test_ver_to_block_size ... ok
Nov 18 01:17:23.963 INFO [stdout] test sbx_specs_tests::test_ver_to_data_size ... ok
Nov 18 01:17:23.963 INFO [stdout] test sbx_specs_tests::test_ver_uses_rs ... ok
Nov 18 01:17:23.963 INFO [stdout] test time_utils_tests::qc_seconds_to_hms_to_seconds ... ok
Nov 18 01:17:23.971 INFO [stdout] test sbx_specs_tests::test_ver_forces_meta_enabled ... ok
Nov 18 01:17:24.129 INFO [stdout] test sbx_block::tests::qc_meta_block_write_pos_s_consistent_rs_enabled ... ok
Nov 18 01:17:25.307 INFO [stdout] test multihash_tests::test_vectors::sha1_test_vectors ... ok
Nov 18 01:17:25.471 INFO [stdout] test misc_utils_tests::hex_tests::hex_to_bytes_to_hex ... ok
Nov 18 01:17:29.543 INFO [stdout] test sbx_block::tests::qc_calc_data_chunk_write_index_rs_enabled_calc_correctly ... ok
Nov 18 01:17:52.668 INFO [stdout] test rs_codec::encoder_tests::qc_encoder_encode_same_as_encode ... ok
Nov 18 01:18:22.647 INFO [stdout] test rs_codec::repairer_tests::qc_repairer_repair_properly ... test rs_codec::repairer_tests::qc_repairer_repair_properly has been running for over 60 seconds
Nov 18 01:18:45.886 INFO [stdout] test rs_codec::repairer_tests::qc_repairer_repair_properly ... ok
Nov 18 01:18:45.886 INFO [stdout] 
Nov 18 01:18:45.887 INFO [stdout] test result: ok. 93 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 01:18:45.887 INFO [stdout] 
Nov 18 01:18:45.895 INFO [stderr]      Running /target/debug/deps/rsbx-bcd48e773f6b96c3
Nov 18 01:18:45.903 INFO [stderr]    Doc-tests rsbx_lib
Nov 18 01:18:45.903 INFO [stdout] 
Nov 18 01:18:45.904 INFO [stdout] running 0 tests
Nov 18 01:18:45.904 INFO [stdout] 
Nov 18 01:18:45.904 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 01:18:45.905 INFO [stdout] 
Nov 18 01:18:50.951 INFO [stdout] 
Nov 18 01:18:50.951 INFO [stdout] running 0 tests
Nov 18 01:18:50.951 INFO [stdout] 
Nov 18 01:18:50.952 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 01:18:50.952 INFO [stdout] 
Nov 18 01:18:50.991 INFO [stderr] su: No module specific data is present
Nov 18 01:18:51.607 INFO running `"docker" "inspect" "7d3df05864ba6a37cacfc34c84546c49721bc826027a2f861c7d8726c5682918"`
Nov 18 01:18:51.950 INFO running `"docker" "rm" "-f" "7d3df05864ba6a37cacfc34c84546c49721bc826027a2f861c7d8726c5682918"`
Nov 18 01:18:52.306 INFO [stdout] 7d3df05864ba6a37cacfc34c84546c49721bc826027a2f861c7d8726c5682918