Dec 14 22:35:06.434 INFO testing rsbx-1.1.2 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 14 22:35:06.434 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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.810 INFO [stdout] 0d31cae15cd31c5e86d60c49b84aeb53ea45899841bfdafae7072aaf8ab70f46
Dec 14 22:35:06.819 INFO running `"docker" "start" "-a" "0d31cae15cd31c5e86d60c49b84aeb53ea45899841bfdafae7072aaf8ab70f46"`
Dec 14 22:35:08.106 INFO [stderr] usermod: no changes
Dec 14 22:35:08.307 INFO [stderr]    Compiling cty v0.1.5
Dec 14 22:35:08.307 INFO [stderr]    Compiling rsbx v1.1.2 (/source)
Dec 14 22:35:08.307 INFO [stderr]    Compiling blake2_c v0.3.3
Dec 14 22:35:08.307 INFO [stderr]    Compiling reed-solomon-erasure v3.1.1
Dec 14 22:35:08.307 INFO [stderr]    Compiling ctrlc v3.1.1
Dec 14 22:35:28.533 INFO [stderr] warning: unused `#[macro_use]` import
Dec 14 22:35:28.533 INFO [stderr]  --> src/bin/main.rs:4:1
Dec 14 22:35:28.533 INFO [stderr]   |
Dec 14 22:35:28.533 INFO [stderr] 4 | #[macro_use]
Dec 14 22:35:28.533 INFO [stderr]   | ^^^^^^^^^^^^
Dec 14 22:35:28.533 INFO [stderr]   |
Dec 14 22:35:28.533 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 14 22:35:28.533 INFO [stderr] 
Dec 14 22:35:30.810 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 22.67s
Dec 14 22:35:30.819 INFO [stderr] su: No module specific data is present
Dec 14 22:35:31.497 INFO running `"docker" "inspect" "0d31cae15cd31c5e86d60c49b84aeb53ea45899841bfdafae7072aaf8ab70f46"`
Dec 14 22:35:31.828 INFO running `"docker" "rm" "-f" "0d31cae15cd31c5e86d60c49b84aeb53ea45899841bfdafae7072aaf8ab70f46"`
Dec 14 22:35:32.139 INFO [stdout] 0d31cae15cd31c5e86d60c49b84aeb53ea45899841bfdafae7072aaf8ab70f46
Dec 14 22:35:32.144 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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:32.684 INFO [stdout] 7e47cf8869eb8be8b3e4bc8ca6a186d96ef44c9d2936a96f346a3affdb4d58e3
Dec 14 22:35:32.688 INFO running `"docker" "start" "-a" "7e47cf8869eb8be8b3e4bc8ca6a186d96ef44c9d2936a96f346a3affdb4d58e3"`
Dec 14 22:35:34.135 INFO [stderr] usermod: no changes
Dec 14 22:35:34.363 INFO [stderr]    Compiling rsbx v1.1.2 (/source)
Dec 14 22:35:37.667 INFO [stderr] warning: unused `#[macro_use]` import
Dec 14 22:35:37.667 INFO [stderr]  --> src/bin/main.rs:4:1
Dec 14 22:35:37.667 INFO [stderr]   |
Dec 14 22:35:37.667 INFO [stderr] 4 | #[macro_use]
Dec 14 22:35:37.667 INFO [stderr]   | ^^^^^^^^^^^^
Dec 14 22:35:37.667 INFO [stderr]   |
Dec 14 22:35:37.667 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 14 22:35:37.667 INFO [stderr] 
Dec 14 22:35:53.664 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 19.48s
Dec 14 22:35:53.674 INFO [stderr] su: No module specific data is present
Dec 14 22:35:54.212 INFO running `"docker" "inspect" "7e47cf8869eb8be8b3e4bc8ca6a186d96ef44c9d2936a96f346a3affdb4d58e3"`
Dec 14 22:35:54.631 INFO running `"docker" "rm" "-f" "7e47cf8869eb8be8b3e4bc8ca6a186d96ef44c9d2936a96f346a3affdb4d58e3"`
Dec 14 22:35:54.879 INFO [stdout] 7e47cf8869eb8be8b3e4bc8ca6a186d96ef44c9d2936a96f346a3affdb4d58e3
Dec 14 22:35:54.887 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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:55.440 INFO [stdout] 643c6d1d03e6aad2d5f8f93bf9a322aaaec3ee85bf93846b6b04b159ea884ebe
Dec 14 22:35:55.443 INFO running `"docker" "start" "-a" "643c6d1d03e6aad2d5f8f93bf9a322aaaec3ee85bf93846b6b04b159ea884ebe"`
Dec 14 22:35:56.866 INFO [stderr] usermod: no changes
Dec 14 22:35:57.183 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.28s
Dec 14 22:35:57.191 INFO [stderr]      Running /target/debug/deps/rsbx_lib-1363a32688777c15
Dec 14 22:35:57.197 INFO [stdout] 
Dec 14 22:35:57.197 INFO [stdout] running 93 tests
Dec 14 22:35:57.202 INFO [stdout] test crc_ccitt::tests::basic_value_tests_0x1d0f ... ok
Dec 14 22:35:57.207 INFO [stdout] test crc_ccitt::tests::basic_value_tests_0xffff ... ok
Dec 14 22:35:57.208 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:57.209 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:57.216 INFO [stdout] test file_utils_tests::from_orig_file_size::test_calc_container_size_simple_cases ... ok
Dec 14 22:35:57.217 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:57.218 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:57.219 INFO [stdout] test file_utils_tests::from_orig_file_size::qc_calc_container_size_rs_enabled_not_too_off ... ok
Dec 14 22:35:57.223 INFO [stdout] test file_utils_tests::test_calc_meta_block_count_exc_burst_gaps_rs_disabled ... ok
Dec 14 22:35:57.223 INFO [stdout] test file_utils_tests::test_get_file_name_part_of_path_simple_cases ... ok
Dec 14 22:35:57.229 INFO [stdout] test file_utils_tests::from_orig_file_size::qc_calc_container_size_rs_enabled_no_data ... ok
Dec 14 22:35:57.232 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:57.232 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:57.233 INFO [stdout] test integer_utils_tests::qc_ensure_at_least ... ok
Dec 14 22:35:57.233 INFO [stdout] test integer_utils_tests::qc_round_up_to_multiple ... ok
Dec 14 22:35:57.234 INFO [stdout] test integer_utils_tests::qc_ensure_at_most ... ok
Dec 14 22:35:57.235 INFO [stdout] test integer_utils_tests::qc_round_down_to_multiple ... ok
Dec 14 22:35:57.239 INFO [stdout] test integer_utils_tests::test_round_up_to_multiple_simple_cases ... ok
Dec 14 22:35:57.239 INFO [stdout] test misc_utils_tests::hex_tests::hex_to_bytes_test_cases ... ok
Dec 14 22:35:57.239 INFO [stdout] test misc_utils_tests::hex_tests::error_handling ... ok
Dec 14 22:35:57.239 INFO [stdout] test integer_utils_tests::test_round_down_to_multiple_simple_cases ... ok
Dec 14 22:35:57.239 INFO [stdout] test misc_utils_tests::hex_tests::bytes_to_hex_test_cases ... ok
Dec 14 22:35:57.247 INFO [stdout] test file_utils_tests::qc_calc_meta_block_count_exc_burst_gaps_rs_enabled ... ok
Dec 14 22:35:57.247 INFO [stdout] test misc_utils_tests::test_make_path_simple_cases ... ok
Dec 14 22:35:57.247 INFO [stdout] test misc_utils_tests::test_f64_max_simple_cases ... ok
Dec 14 22:35:57.247 INFO [stdout] test multihash_tests::test_hash_type_to_string ... ok
Dec 14 22:35:57.247 INFO [stdout] test misc_utils_tests::test_buffer_is_blank_simple_cases ... ok
Dec 14 22:35:57.248 INFO [stdout] test misc_utils_tests::qc_calc_required_len_and_seek_to_from_byte_range ... ok
Dec 14 22:35:57.263 INFO [stdout] test multihash_tests::test_string_to_hash_type ... ok
Dec 14 22:35:57.283 INFO [stdout] test multihash_tests::test_vectors::multihash_sha256_bytes ... ok
Dec 14 22:35:57.283 INFO [stdout] test multihash_tests::test_vectors::multihash_sha1_bytes ... ok
Dec 14 22:35:57.284 INFO [stdout] test multihash_tests::test_vectors::multihash_blake2b_512_bytes ... ok
Dec 14 22:35:57.284 INFO [stdout] test multihash_tests::test_specs ... ok
Dec 14 22:35:57.287 INFO [stdout] test multihash_tests::test_vectors::multihash_sha512_bytes ... ok
Dec 14 22:35:57.287 INFO [stdout] test misc_utils_tests::test_camelcase ... ok
Dec 14 22:35:57.289 INFO [stdout] test multihash_tests::test_vectors::blake2b_512_test_vectors ... ok
Dec 14 22:35:57.481 INFO [stdout] test rs_codec::encoder_tests::test_encoder_encode_correctly_simple_cases ... ok
Dec 14 22:35:57.519 INFO [stdout] test sbx_block::header_tests::test_from_bytes_error_handling ... ok
Dec 14 22:35:57.532 INFO [stdout] test sbx_block::header_tests::test_from_bytes_versions ... ok
Dec 14 22:35:57.638 INFO [stdout] test sbx_block::header_tests::test_from_to_from_bytes ... ok
Dec 14 22:35:57.646 INFO [stdout] test rs_codec::repairer_tests::test_repairer_repair_properly_simple_cases ... ok
Dec 14 22:35:57.712 INFO [stdout] test sbx_block::header_tests::test_to_bytes_error_handling_case1 ... ok
Dec 14 22:35:57.712 INFO [stdout] test sbx_block::header_tests::test_to_bytes_error_handling_case2 ... ok
Dec 14 22:35:57.719 INFO [stdout] test sbx_block::header_tests::test_to_bytes_versions ... ok
Dec 14 22:35:57.720 INFO [stdout] test sbx_block::metadata_tests::test_filter_invalid_metadata_simple_cases ... ok
Dec 14 22:35:57.723 INFO [stdout] test sbx_block::header_tests::test_to_from_to_bytes ... ok
Dec 14 22:35:57.724 INFO [stdout] test sbx_block::metadata_tests::test_from_bytes_simple_cases ... ok
Dec 14 22:35:57.724 INFO [stdout] test sbx_block::metadata_tests::test_get_meta_ref_by_id ... ok
Dec 14 22:35:57.725 INFO [stdout] test sbx_block::metadata_tests::test_id_to_str ... ok
Dec 14 22:35:57.725 INFO [stdout] test sbx_block::metadata_tests::test_get_meta_ref_mut_by_id ... ok
Dec 14 22:35:57.726 INFO [stdout] test sbx_block::metadata_tests::test_meta_to_id ... ok
Dec 14 22:35:57.726 INFO [stdout] test sbx_block::metadata_tests::test_to_bytes_simple_cases ... ok
Dec 14 22:35:57.727 INFO [stdout] test sbx_block::tests::qc_add_seq_num ... ok
Dec 14 22:35:57.728 INFO [stdout] test sbx_block::tests::qc_block_is_parity_matches_seq_num_is_parity ... ok
Dec 14 22:35:57.731 INFO [stdout] test sbx_block::tests::qc_calc_data_chunk_write_index_rs_disabled ... ok
Dec 14 22:35:57.735 INFO [stdout] test sbx_block::tests::qc_calc_data_chunk_write_index_rs_enabled_ret_opt_correctly ... ok
Dec 14 22:35:57.767 INFO [stdout] test sbx_block::tests::qc_calc_data_chunk_write_pos_consistent_rs_disabled ... ok
Dec 14 22:35:57.822 INFO [stdout] test sbx_block::tests::qc_calc_data_chunk_write_pos_consistent_rs_enabled ... ok
Dec 14 22:35:57.928 INFO [stdout] test sbx_block::tests::qc_data_block_write_pos_consistent_rs_disabled ... ok
Dec 14 22:35:57.928 INFO [stdout] test sbx_block::tests::qc_data_block_write_pos_consistent_rs_enabled ... ok
Dec 14 22:35:57.928 INFO [stdout] test sbx_block::tests::qc_data_seq_num_to_index_to_seq_num_meta_default ... ok
Dec 14 22:35:57.959 INFO [stdout] test sbx_block::tests::qc_data_seq_num_to_index_to_seq_num_meta_disabled ... ok
Dec 14 22:35:57.959 INFO [stdout] test sbx_block::tests::qc_data_seq_num_to_index_to_seq_num_meta_enabled ... ok
Dec 14 22:35:57.960 INFO [stdout] test sbx_block::tests::qc_data_seq_num_to_index_to_seq_num_rs_enabled ... ok
Dec 14 22:35:57.960 INFO [stdout] test sbx_block::tests::qc_meta_block_write_indices_data_block_write_indices_disjoint_rs_disabled ... ok
Dec 14 22:35:58.051 INFO [stdout] test sbx_block::tests::qc_meta_block_write_indices_data_block_write_indices_disjoint_rs_enabled ... ok
Dec 14 22:35:58.051 INFO [stdout] test sbx_block::tests::qc_meta_block_write_pos_s_consistent_rs_disabled ... ok
Dec 14 22:35:58.531 INFO [stdout] test sbx_block::tests::qc_meta_block_write_pos_s_consistent_rs_enabled ... ok
Dec 14 22:35:58.531 INFO [stdout] test sbx_block::tests::qc_set_get_seq_num ... ok
Dec 14 22:35:58.531 INFO [stdout] test sbx_block::tests::test_calc_data_chunk_write_index_simple_cases ... ok
Dec 14 22:35:58.531 INFO [stdout] test sbx_block::tests::test_calc_rs_enabled_data_write_index_simple_cases ... ok
Dec 14 22:35:58.531 INFO [stdout] test sbx_block::tests::test_calc_rs_enabled_meta_write_indices ... ok
Dec 14 22:35:58.531 INFO [stdout] test sbx_block::tests::test_calc_rs_enabled_seq_num_at_index_simple_cases ... ok
Dec 14 22:35:58.579 INFO [stdout] test sbx_block::tests::test_get_uid ... ok
Dec 14 22:35:58.606 INFO [stdout] test sbx_block::tests::test_get_version_simple_cases ... ok
Dec 14 22:35:58.643 INFO [stdout] test sbx_block::tests::test_seq_num_is_parity_simple_cases ... ok
Dec 14 22:35:58.659 INFO [stdout] test sbx_block::tests::test_set_uid ... ok
Dec 14 22:35:58.659 INFO [stdout] test sbx_block::tests::test_set_version_simple_cases ... ok
Dec 14 22:35:58.659 INFO [stdout] test sbx_block::tests::test_sync_from_buffer_simple_cases ... ok
Dec 14 22:35:58.667 INFO [stdout] test sbx_block::tests::test_sync_to_buffer_simple_cases ... ok
Dec 14 22:35:58.676 INFO [stdout] test sbx_specs_tests::test_string_to_ver ... ok
Dec 14 22:35:58.676 INFO [stdout] test sbx_specs_tests::test_ver_forces_meta_enabled ... ok
Dec 14 22:35:58.679 INFO [stdout] test sbx_specs_tests::test_ver_to_block_size ... ok
Dec 14 22:35:58.679 INFO [stdout] test sbx_specs_tests::test_ver_to_data_size ... ok
Dec 14 22:35:58.679 INFO [stdout] test sbx_specs_tests::test_ver_uses_rs ... ok
Dec 14 22:35:58.679 INFO [stdout] test time_utils_tests::qc_seconds_to_hms_to_seconds ... ok
Dec 14 22:35:58.771 INFO [stdout] test multihash_tests::test_vectors::sha512_test_vectors ... ok
Dec 14 22:35:59.131 INFO [stdout] test multihash_tests::test_vectors::sha256_test_vectors ... ok
Dec 14 22:36:00.283 INFO [stdout] test multihash_tests::test_vectors::sha1_test_vectors ... ok
Dec 14 22:36:00.342 INFO [stdout] test misc_utils_tests::hex_tests::hex_to_bytes_to_hex ... ok
Dec 14 22:36:03.951 INFO [stdout] test sbx_block::tests::qc_calc_data_chunk_write_index_rs_enabled_calc_correctly ... ok
Dec 14 22:36:26.788 INFO [stdout] test rs_codec::encoder_tests::qc_encoder_encode_same_as_encode ... ok
Dec 14 22:36:57.299 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:20.673 INFO [stdout] test rs_codec::repairer_tests::qc_repairer_repair_properly ... ok
Dec 14 22:37:20.673 INFO [stdout] 
Dec 14 22:37:20.673 INFO [stdout] test result: ok. 93 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 22:37:20.673 INFO [stdout] 
Dec 14 22:37:20.676 INFO [stderr]      Running /target/debug/deps/rsbx-650a42b65a831584
Dec 14 22:37:20.685 INFO [stdout] 
Dec 14 22:37:20.685 INFO [stdout] running 0 tests
Dec 14 22:37:20.685 INFO [stdout] 
Dec 14 22:37:20.685 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 22:37:20.685 INFO [stdout] 
Dec 14 22:37:20.685 INFO [stderr]    Doc-tests rsbx_lib
Dec 14 22:37:26.706 INFO [stdout] 
Dec 14 22:37:26.707 INFO [stdout] running 0 tests
Dec 14 22:37:26.707 INFO [stdout] 
Dec 14 22:37:26.707 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 22:37:26.707 INFO [stdout] 
Dec 14 22:37:26.747 INFO [stderr] su: No module specific data is present
Dec 14 22:37:27.565 INFO running `"docker" "inspect" "643c6d1d03e6aad2d5f8f93bf9a322aaaec3ee85bf93846b6b04b159ea884ebe"`
Dec 14 22:37:27.845 INFO running `"docker" "rm" "-f" "643c6d1d03e6aad2d5f8f93bf9a322aaaec3ee85bf93846b6b04b159ea884ebe"`
Dec 14 22:37:28.128 INFO [stdout] 643c6d1d03e6aad2d5f8f93bf9a322aaaec3ee85bf93846b6b04b159ea884ebe