Dec 14 22:35:06.266 INFO testing rsbx-1.1.2 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 14 22:35:06.266 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 22:35:06.647 INFO [stdout] 40c988f316baa5cb5d0c0b4911a6d2f115a10d021d5e6a095c17268a26e177a3
Dec 14 22:35:06.651 INFO running `"docker" "start" "-a" "40c988f316baa5cb5d0c0b4911a6d2f115a10d021d5e6a095c17268a26e177a3"`
Dec 14 22:35:08.031 INFO [stderr] usermod: no changes
Dec 14 22:35:08.251 INFO [stderr]    Compiling rsbx v1.1.2 (/source)
Dec 14 22:35:08.255 INFO [stderr]    Compiling cty v0.1.5
Dec 14 22:35:08.263 INFO [stderr]    Compiling blake2_c v0.3.3
Dec 14 22:35:08.263 INFO [stderr]    Compiling reed-solomon-erasure v3.1.1
Dec 14 22:35:08.271 INFO [stderr]    Compiling ctrlc v3.1.1
Dec 14 22:35:27.527 INFO [stderr] warning: unused `#[macro_use]` import
Dec 14 22:35:27.527 INFO [stderr]  --> src/bin/main.rs:4:1
Dec 14 22:35:27.527 INFO [stderr]   |
Dec 14 22:35:27.527 INFO [stderr] 4 | #[macro_use]
Dec 14 22:35:27.527 INFO [stderr]   | ^^^^^^^^^^^^
Dec 14 22:35:27.527 INFO [stderr]   |
Dec 14 22:35:27.527 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 14 22:35:27.527 INFO [stderr] 
Dec 14 22:35:29.559 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 21.49s
Dec 14 22:35:29.570 INFO [stderr] su: No module specific data is present
Dec 14 22:35:30.217 INFO running `"docker" "inspect" "40c988f316baa5cb5d0c0b4911a6d2f115a10d021d5e6a095c17268a26e177a3"`
Dec 14 22:35:30.488 INFO running `"docker" "rm" "-f" "40c988f316baa5cb5d0c0b4911a6d2f115a10d021d5e6a095c17268a26e177a3"`
Dec 14 22:35:30.687 INFO [stdout] 40c988f316baa5cb5d0c0b4911a6d2f115a10d021d5e6a095c17268a26e177a3
Dec 14 22:35:30.689 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 22:35:31.232 INFO [stdout] ec696920b5347ec67fce3c672d3e057376f98c90f1a1e0a4940b3f1a40ab3930
Dec 14 22:35:31.235 INFO running `"docker" "start" "-a" "ec696920b5347ec67fce3c672d3e057376f98c90f1a1e0a4940b3f1a40ab3930"`
Dec 14 22:35:32.590 INFO [stderr] usermod: no changes
Dec 14 22:35:32.811 INFO [stderr]    Compiling rsbx v1.1.2 (/source)
Dec 14 22:35:36.423 INFO [stderr] warning: unused `#[macro_use]` import
Dec 14 22:35:36.423 INFO [stderr]  --> src/bin/main.rs:4:1
Dec 14 22:35:36.423 INFO [stderr]   |
Dec 14 22:35:36.423 INFO [stderr] 4 | #[macro_use]
Dec 14 22:35:36.423 INFO [stderr]   | ^^^^^^^^^^^^
Dec 14 22:35:36.423 INFO [stderr]   |
Dec 14 22:35:36.423 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 14 22:35:36.423 INFO [stderr] 
Dec 14 22:35:52.119 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 19.50s
Dec 14 22:35:52.128 INFO [stderr] su: No module specific data is present
Dec 14 22:35:52.891 INFO running `"docker" "inspect" "ec696920b5347ec67fce3c672d3e057376f98c90f1a1e0a4940b3f1a40ab3930"`
Dec 14 22:35:53.299 INFO running `"docker" "rm" "-f" "ec696920b5347ec67fce3c672d3e057376f98c90f1a1e0a4940b3f1a40ab3930"`
Dec 14 22:35:53.553 INFO [stdout] ec696920b5347ec67fce3c672d3e057376f98c90f1a1e0a4940b3f1a40ab3930
Dec 14 22:35:53.563 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 22:35:54.134 INFO [stdout] d351af3550738c145e613cdb3bb5557203935c08678eb7b755a22b99246e37e0
Dec 14 22:35:54.136 INFO running `"docker" "start" "-a" "d351af3550738c145e613cdb3bb5557203935c08678eb7b755a22b99246e37e0"`
Dec 14 22:35:55.281 INFO [stderr] usermod: no changes
Dec 14 22:35:55.470 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.16s
Dec 14 22:35:55.486 INFO [stderr]      Running /target/debug/deps/rsbx_lib-eb83e76f9e641dd1
Dec 14 22:35:55.487 INFO [stdout] 
Dec 14 22:35:55.487 INFO [stdout] running 93 tests
Dec 14 22:35:55.487 INFO [stdout] test file_utils_tests::from_orig_file_size::qc_calc_data_only_and_parity_block_count_exc_burst_gaps_rs_enabled ... ok
Dec 14 22:35:55.495 INFO [stdout] test file_utils_tests::from_orig_file_size::qc_calc_data_only_and_parity_block_count_exc_burst_gaps_rs_disabled ... ok
Dec 14 22:35:55.495 INFO [stdout] test file_utils_tests::from_orig_file_size::qc_calc_data_block_count_exc_burst_gaps_consistent_rs_enabled ... ok
Dec 14 22:35:55.495 INFO [stdout] test file_utils_tests::from_orig_file_size::qc_calc_total_block_count_exc_burst_gaps_consistent_rs_disabled ... ok
Dec 14 22:35:55.495 INFO [stdout] test file_utils_tests::from_orig_file_size::qc_calc_data_block_count_exc_burst_gaps_consistent_rs_disabled ... ok
Dec 14 22:35:55.527 INFO [stdout] test crc_ccitt::tests::basic_value_tests_0xffff ... ok
Dec 14 22:35:55.527 INFO [stdout] test crc_ccitt::tests::basic_value_tests_0x1d0f ... ok
Dec 14 22:35:55.527 INFO [stdout] test file_utils_tests::from_orig_file_size::qc_calc_container_size_rs_enabled_not_too_off ... ok
Dec 14 22:35:55.538 INFO [stdout] test file_utils_tests::from_orig_file_size::qc_calc_container_size_rs_enabled_no_data ... ok
Dec 14 22:35:55.539 INFO [stdout] test file_utils_tests::from_orig_file_size::test_calc_container_size_simple_cases ... ok
Dec 14 22:35:55.539 INFO [stdout] test file_utils_tests::test_calc_meta_block_count_exc_burst_gaps_rs_disabled ... ok
Dec 14 22:35:55.551 INFO [stdout] test file_utils_tests::from_orig_file_size::qc_calc_total_block_count_exc_burst_gaps_consistent_rs_enabled ... ok
Dec 14 22:35:55.551 INFO [stdout] test file_utils_tests::test_get_file_name_part_of_path_simple_cases ... ok
Dec 14 22:35:55.551 INFO [stdout] test file_utils_tests::qc_calc_meta_block_count_exc_burst_gaps_rs_enabled ... ok
Dec 14 22:35:55.551 INFO [stdout] test integer_utils_tests::qc_round_up_to_multiple ... ok
Dec 14 22:35:55.551 INFO [stdout] test integer_utils_tests::qc_round_down_to_multiple ... ok
Dec 14 22:35:55.551 INFO [stdout] test integer_utils_tests::qc_ensure_at_least ... ok
Dec 14 22:35:55.551 INFO [stdout] test integer_utils_tests::qc_ensure_at_most ... ok
Dec 14 22:35:55.551 INFO [stdout] test misc_utils_tests::hex_tests::hex_to_bytes_test_cases ... ok
Dec 14 22:35:55.551 INFO [stdout] test integer_utils_tests::test_round_up_to_multiple_simple_cases ... ok
Dec 14 22:35:55.551 INFO [stdout] test misc_utils_tests::hex_tests::bytes_to_hex_test_cases ... ok
Dec 14 22:35:55.551 INFO [stdout] test misc_utils_tests::test_buffer_is_blank_simple_cases ... ok
Dec 14 22:35:55.551 INFO [stdout] test misc_utils_tests::test_make_path_simple_cases ... ok
Dec 14 22:35:55.551 INFO [stdout] test misc_utils_tests::test_f64_max_simple_cases ... ok
Dec 14 22:35:55.555 INFO [stdout] test misc_utils_tests::test_camelcase ... ok
Dec 14 22:35:55.555 INFO [stdout] test multihash_tests::test_vectors::blake2b_512_test_vectors ... ok
Dec 14 22:35:55.555 INFO [stdout] test multihash_tests::test_specs ... ok
Dec 14 22:35:55.555 INFO [stdout] test multihash_tests::test_vectors::multihash_sha1_bytes ... ok
Dec 14 22:35:55.555 INFO [stdout] test misc_utils_tests::qc_calc_required_len_and_seek_to_from_byte_range ... ok
Dec 14 22:35:55.555 INFO [stdout] test multihash_tests::test_vectors::multihash_blake2b_512_bytes ... ok
Dec 14 22:35:55.563 INFO [stdout] test multihash_tests::test_vectors::multihash_sha256_bytes ... ok
Dec 14 22:35:55.563 INFO [stdout] test multihash_tests::test_hash_type_to_string ... ok
Dec 14 22:35:55.571 INFO [stdout] test multihash_tests::test_vectors::multihash_sha512_bytes ... ok
Dec 14 22:35:55.579 INFO [stdout] test multihash_tests::test_string_to_hash_type ... ok
Dec 14 22:35:55.579 INFO [stdout] test misc_utils_tests::hex_tests::error_handling ... ok
Dec 14 22:35:55.579 INFO [stdout] test integer_utils_tests::test_round_down_to_multiple_simple_cases ... ok
Dec 14 22:35:55.843 INFO [stdout] test rs_codec::repairer_tests::test_repairer_repair_properly_simple_cases ... ok
Dec 14 22:35:55.863 INFO [stdout] test sbx_block::header_tests::test_from_bytes_error_handling ... ok
Dec 14 22:35:55.879 INFO [stdout] test sbx_block::header_tests::test_from_bytes_versions ... ok
Dec 14 22:35:55.991 INFO [stdout] test sbx_block::header_tests::test_from_to_from_bytes ... ok
Dec 14 22:35:56.143 INFO [stdout] test rs_codec::encoder_tests::test_encoder_encode_correctly_simple_cases ... ok
Dec 14 22:35:56.301 INFO [stdout] test multihash_tests::test_vectors::sha256_test_vectors ... ok
Dec 14 22:35:56.303 INFO [stdout] test sbx_block::header_tests::test_to_bytes_versions ... ok
Dec 14 22:35:56.364 INFO [stdout] test sbx_block::header_tests::test_to_from_to_bytes ... ok
Dec 14 22:35:56.370 INFO [stdout] test sbx_block::metadata_tests::test_filter_invalid_metadata_simple_cases ... ok
Dec 14 22:35:56.370 INFO [stdout] test sbx_block::metadata_tests::test_from_bytes_simple_cases ... ok
Dec 14 22:35:56.370 INFO [stdout] test sbx_block::metadata_tests::test_get_meta_ref_by_id ... ok
Dec 14 22:35:56.370 INFO [stdout] test sbx_block::metadata_tests::test_get_meta_ref_mut_by_id ... ok
Dec 14 22:35:56.370 INFO [stdout] test sbx_block::metadata_tests::test_id_to_str ... ok
Dec 14 22:35:56.370 INFO [stdout] test sbx_block::metadata_tests::test_meta_to_id ... ok
Dec 14 22:35:56.370 INFO [stdout] test sbx_block::metadata_tests::test_to_bytes_simple_cases ... ok
Dec 14 22:35:56.370 INFO [stdout] test sbx_block::tests::qc_add_seq_num ... ok
Dec 14 22:35:56.370 INFO [stdout] test sbx_block::tests::qc_block_is_parity_matches_seq_num_is_parity ... ok
Dec 14 22:35:56.375 INFO [stdout] test sbx_block::tests::qc_calc_data_chunk_write_index_rs_disabled ... ok
Dec 14 22:35:56.683 INFO [stdout] test sbx_block::header_tests::test_to_bytes_error_handling_case2 ... ok
Dec 14 22:35:56.683 INFO [stdout] test sbx_block::header_tests::test_to_bytes_error_handling_case1 ... ok
Dec 14 22:35:56.691 INFO [stdout] test sbx_block::tests::qc_calc_data_chunk_write_index_rs_enabled_ret_opt_correctly ... ok
Dec 14 22:35:56.691 INFO [stdout] test sbx_block::tests::qc_calc_data_chunk_write_pos_consistent_rs_disabled ... ok
Dec 14 22:35:56.691 INFO [stdout] test sbx_block::tests::qc_calc_data_chunk_write_pos_consistent_rs_enabled ... ok
Dec 14 22:35:56.691 INFO [stdout] test sbx_block::tests::qc_data_block_write_pos_consistent_rs_disabled ... ok
Dec 14 22:35:56.691 INFO [stdout] test sbx_block::tests::qc_data_seq_num_to_index_to_seq_num_meta_default ... ok
Dec 14 22:35:56.691 INFO [stdout] test sbx_block::tests::qc_data_block_write_pos_consistent_rs_enabled ... ok
Dec 14 22:35:56.691 INFO [stdout] test sbx_block::tests::qc_data_seq_num_to_index_to_seq_num_meta_disabled ... ok
Dec 14 22:35:56.691 INFO [stdout] test sbx_block::tests::qc_data_seq_num_to_index_to_seq_num_meta_enabled ... ok
Dec 14 22:35:56.691 INFO [stdout] test sbx_block::tests::qc_meta_block_write_indices_data_block_write_indices_disjoint_rs_disabled ... ok
Dec 14 22:35:56.695 INFO [stdout] test sbx_block::tests::qc_meta_block_write_indices_data_block_write_indices_disjoint_rs_enabled ... ok
Dec 14 22:35:56.703 INFO [stdout] test sbx_block::tests::qc_meta_block_write_pos_s_consistent_rs_disabled ... ok
Dec 14 22:35:56.719 INFO [stdout] test sbx_block::tests::qc_data_seq_num_to_index_to_seq_num_rs_enabled ... ok
Dec 14 22:35:56.727 INFO [stdout] test sbx_block::tests::qc_set_get_seq_num ... ok
Dec 14 22:35:56.727 INFO [stdout] test sbx_block::tests::test_calc_data_chunk_write_index_simple_cases ... ok
Dec 14 22:35:56.727 INFO [stdout] test sbx_block::tests::test_calc_rs_enabled_data_write_index_simple_cases ... ok
Dec 14 22:35:56.727 INFO [stdout] test sbx_block::tests::test_calc_rs_enabled_meta_write_indices ... ok
Dec 14 22:35:56.727 INFO [stdout] test sbx_block::tests::test_calc_rs_enabled_seq_num_at_index_simple_cases ... ok
Dec 14 22:35:56.731 INFO [stdout] test sbx_block::tests::test_get_uid ... ok
Dec 14 22:35:56.731 INFO [stdout] test sbx_block::tests::test_get_version_simple_cases ... ok
Dec 14 22:35:56.731 INFO [stdout] test sbx_block::tests::test_seq_num_is_parity_simple_cases ... ok
Dec 14 22:35:56.745 INFO [stdout] test sbx_block::tests::test_set_uid ... ok
Dec 14 22:35:56.748 INFO [stdout] test sbx_block::tests::test_set_version_simple_cases ... ok
Dec 14 22:35:56.767 INFO [stdout] test sbx_block::tests::test_sync_from_buffer_simple_cases ... ok
Dec 14 22:35:56.767 INFO [stdout] test sbx_block::tests::test_sync_to_buffer_simple_cases ... ok
Dec 14 22:35:56.767 INFO [stdout] test sbx_specs_tests::test_string_to_ver ... ok
Dec 14 22:35:56.767 INFO [stdout] test sbx_specs_tests::test_ver_forces_meta_enabled ... ok
Dec 14 22:35:56.767 INFO [stdout] test sbx_specs_tests::test_ver_to_block_size ... ok
Dec 14 22:35:56.767 INFO [stdout] test sbx_specs_tests::test_ver_to_data_size ... ok
Dec 14 22:35:56.767 INFO [stdout] test sbx_specs_tests::test_ver_uses_rs ... ok
Dec 14 22:35:56.775 INFO [stdout] test time_utils_tests::qc_seconds_to_hms_to_seconds ... ok
Dec 14 22:35:56.831 INFO [stdout] test multihash_tests::test_vectors::sha512_test_vectors ... ok
Dec 14 22:35:56.888 INFO [stdout] test sbx_block::tests::qc_meta_block_write_pos_s_consistent_rs_enabled ... ok
Dec 14 22:35:59.027 INFO [stdout] test multihash_tests::test_vectors::sha1_test_vectors ... ok
Dec 14 22:35:59.132 INFO [stdout] test misc_utils_tests::hex_tests::hex_to_bytes_to_hex ... ok
Dec 14 22:36:00.750 INFO [stdout] test sbx_block::tests::qc_calc_data_chunk_write_index_rs_enabled_calc_correctly ... ok
Dec 14 22:36:24.655 INFO [stdout] test rs_codec::encoder_tests::qc_encoder_encode_same_as_encode ... ok
Dec 14 22:36:55.579 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
Dec 14 22:37:17.791 INFO [stdout] test rs_codec::repairer_tests::qc_repairer_repair_properly ... ok
Dec 14 22:37:17.791 INFO [stdout] 
Dec 14 22:37:17.791 INFO [stdout] test result: ok. 93 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 22:37:17.791 INFO [stdout] 
Dec 14 22:37:17.795 INFO [stderr]      Running /target/debug/deps/rsbx-d2ddce00cd9a1fa7
Dec 14 22:37:17.800 INFO [stdout] 
Dec 14 22:37:17.800 INFO [stdout] running 0 tests
Dec 14 22:37:17.800 INFO [stdout] 
Dec 14 22:37:17.800 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 22:37:17.800 INFO [stdout] 
Dec 14 22:37:17.803 INFO [stderr]    Doc-tests rsbx_lib
Dec 14 22:37:23.454 INFO [stdout] 
Dec 14 22:37:23.454 INFO [stdout] running 0 tests
Dec 14 22:37:23.454 INFO [stdout] 
Dec 14 22:37:23.454 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 22:37:23.454 INFO [stdout] 
Dec 14 22:37:23.481 INFO [stderr] su: No module specific data is present
Dec 14 22:37:24.672 INFO running `"docker" "inspect" "d351af3550738c145e613cdb3bb5557203935c08678eb7b755a22b99246e37e0"`
Dec 14 22:37:24.959 INFO running `"docker" "rm" "-f" "d351af3550738c145e613cdb3bb5557203935c08678eb7b755a22b99246e37e0"`
Dec 14 22:37:25.287 INFO [stdout] d351af3550738c145e613cdb3bb5557203935c08678eb7b755a22b99246e37e0