Dec 07 23:09:21.341 INFO testing bamrescue-0.1.0 against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514
Dec 07 23:09:21.341 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-0/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 07 23:09:21.732 INFO [stdout] 40a6fca3d918ddb313c2e9bca75cdd36cca95903eae305c988a2e47d54fd3e74
Dec 07 23:09:21.740 INFO running `"docker" "start" "-a" "40a6fca3d918ddb313c2e9bca75cdd36cca95903eae305c988a2e47d54fd3e74"`
Dec 07 23:09:22.933 INFO [stderr] usermod: no changes
Dec 07 23:09:23.105 INFO [stderr]    Compiling bamrescue v0.1.0 (/source)
Dec 07 23:09:23.988 INFO [stderr] warning: value assigned to `current_block_corrupted` is never read
Dec 07 23:09:23.988 INFO [stderr]    --> src/lib.rs:209:66
Dec 07 23:09:23.988 INFO [stderr]     |
Dec 07 23:09:23.988 INFO [stderr] 209 |                 fail!(fail_fast, results, previous_block, false, current_block_corrupted, false, false);
Dec 07 23:09:23.988 INFO [stderr]     |                                                                  ^^^^^^^^^^^^^^^^^^^^^^^
Dec 07 23:09:23.988 INFO [stderr]     |
Dec 07 23:09:23.988 INFO [stderr]     = note: #[warn(unused_assignments)] on by default
Dec 07 23:09:23.988 INFO [stderr] 
Dec 07 23:09:23.988 INFO [stderr] warning: value assigned to `current_block_corrupted` is never read
Dec 07 23:09:23.988 INFO [stderr]    --> src/lib.rs:420:62
Dec 07 23:09:23.988 INFO [stderr]     |
Dec 07 23:09:23.988 INFO [stderr] 420 |             fail!(fail_fast, results, previous_block, false, current_block_corrupted, false, false);
Dec 07 23:09:23.988 INFO [stderr]     |                                                              ^^^^^^^^^^^^^^^^^^^^^^^
Dec 07 23:09:23.988 INFO [stderr] 
Dec 07 23:09:23.988 INFO [stderr] warning: unused variable: `reader`
Dec 07 23:09:23.988 INFO [stderr]    --> src/lib.rs:449:15
Dec 07 23:09:23.988 INFO [stderr]     |
Dec 07 23:09:23.988 INFO [stderr] 449 | pub fn rescue(reader: &mut Rescuable, writer: &mut Write, logger: &slog::Logger) -> Result<(), Error> {
Dec 07 23:09:23.988 INFO [stderr]     |               ^^^^^^ help: consider using `_reader` instead
Dec 07 23:09:23.988 INFO [stderr]     |
Dec 07 23:09:23.988 INFO [stderr]     = note: #[warn(unused_variables)] on by default
Dec 07 23:09:23.988 INFO [stderr] 
Dec 07 23:09:23.988 INFO [stderr] warning: unused variable: `writer`
Dec 07 23:09:23.988 INFO [stderr]    --> src/lib.rs:449:39
Dec 07 23:09:23.988 INFO [stderr]     |
Dec 07 23:09:23.988 INFO [stderr] 449 | pub fn rescue(reader: &mut Rescuable, writer: &mut Write, logger: &slog::Logger) -> Result<(), Error> {
Dec 07 23:09:23.988 INFO [stderr]     |                                       ^^^^^^ help: consider using `_writer` instead
Dec 07 23:09:23.988 INFO [stderr] 
Dec 07 23:09:23.998 INFO [stderr] warning: field is never used: `header_bytes`
Dec 07 23:09:23.998 INFO [stderr]   --> src/lib.rs:51:5
Dec 07 23:09:23.998 INFO [stderr]    |
Dec 07 23:09:23.998 INFO [stderr] 51 |     header_bytes: Vec<u8>,
Dec 07 23:09:23.999 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^
Dec 07 23:09:23.999 INFO [stderr]    |
Dec 07 23:09:23.999 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 07 23:09:23.999 INFO [stderr] 
Dec 07 23:09:30.709 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.75s
Dec 07 23:09:30.715 INFO [stderr] su: No module specific data is present
Dec 07 23:09:31.687 INFO running `"docker" "inspect" "40a6fca3d918ddb313c2e9bca75cdd36cca95903eae305c988a2e47d54fd3e74"`
Dec 07 23:09:31.945 INFO running `"docker" "rm" "-f" "40a6fca3d918ddb313c2e9bca75cdd36cca95903eae305c988a2e47d54fd3e74"`
Dec 07 23:09:32.252 INFO [stdout] 40a6fca3d918ddb313c2e9bca75cdd36cca95903eae305c988a2e47d54fd3e74
Dec 07 23:09:32.252 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-0/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 07 23:09:32.622 INFO [stdout] bf3d5e1ad5e867c2414c2f772b77f135f76a8d054cff5f2cb4c97855a6dcf3cd
Dec 07 23:09:32.624 INFO running `"docker" "start" "-a" "bf3d5e1ad5e867c2414c2f772b77f135f76a8d054cff5f2cb4c97855a6dcf3cd"`
Dec 07 23:09:34.611 INFO [stderr] usermod: no changes
Dec 07 23:09:34.788 INFO [stderr]    Compiling bamrescue v0.1.0 (/source)
Dec 07 23:09:36.267 INFO [stderr] warning: value assigned to `current_block_corrupted` is never read
Dec 07 23:09:36.269 INFO [stderr]    --> src/lib.rs:209:66
Dec 07 23:09:36.269 INFO [stderr]     |
Dec 07 23:09:36.269 INFO [stderr] 209 |                 fail!(fail_fast, results, previous_block, false, current_block_corrupted, false, false);
Dec 07 23:09:36.269 INFO [stderr]     |                                                                  ^^^^^^^^^^^^^^^^^^^^^^^
Dec 07 23:09:36.279 INFO [stderr]     |
Dec 07 23:09:36.279 INFO [stderr]     = note: #[warn(unused_assignments)] on by default
Dec 07 23:09:36.279 INFO [stderr] 
Dec 07 23:09:36.279 INFO [stderr] warning: value assigned to `current_block_corrupted` is never read
Dec 07 23:09:36.279 INFO [stderr]    --> src/lib.rs:420:62
Dec 07 23:09:36.279 INFO [stderr]     |
Dec 07 23:09:36.279 INFO [stderr] 420 |             fail!(fail_fast, results, previous_block, false, current_block_corrupted, false, false);
Dec 07 23:09:36.279 INFO [stderr]     |                                                              ^^^^^^^^^^^^^^^^^^^^^^^
Dec 07 23:09:36.279 INFO [stderr] 
Dec 07 23:09:36.279 INFO [stderr] warning: unused variable: `reader`
Dec 07 23:09:36.279 INFO [stderr]    --> src/lib.rs:449:15
Dec 07 23:09:36.279 INFO [stderr]     |
Dec 07 23:09:36.279 INFO [stderr] 449 | pub fn rescue(reader: &mut Rescuable, writer: &mut Write, logger: &slog::Logger) -> Result<(), Error> {
Dec 07 23:09:36.279 INFO [stderr]     |               ^^^^^^ help: consider using `_reader` instead
Dec 07 23:09:36.279 INFO [stderr]     |
Dec 07 23:09:36.284 INFO [stderr]     = note: #[warn(unused_variables)] on by default
Dec 07 23:09:36.284 INFO [stderr] 
Dec 07 23:09:36.284 INFO [stderr] warning: unused variable: `writer`
Dec 07 23:09:36.284 INFO [stderr]    --> src/lib.rs:449:39
Dec 07 23:09:36.284 INFO [stderr]     |
Dec 07 23:09:36.284 INFO [stderr] 449 | pub fn rescue(reader: &mut Rescuable, writer: &mut Write, logger: &slog::Logger) -> Result<(), Error> {
Dec 07 23:09:36.284 INFO [stderr]     |                                       ^^^^^^ help: consider using `_writer` instead
Dec 07 23:09:36.284 INFO [stderr] 
Dec 07 23:09:36.333 INFO [stderr] warning: field is never used: `header_bytes`
Dec 07 23:09:36.333 INFO [stderr]   --> src/lib.rs:51:5
Dec 07 23:09:36.333 INFO [stderr]    |
Dec 07 23:09:36.333 INFO [stderr] 51 |     header_bytes: Vec<u8>,
Dec 07 23:09:36.333 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^
Dec 07 23:09:36.338 INFO [stderr]    |
Dec 07 23:09:36.338 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 07 23:09:36.338 INFO [stderr] 
Dec 07 23:09:38.958 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.32s
Dec 07 23:09:38.963 INFO [stderr] su: No module specific data is present
Dec 07 23:09:39.494 INFO running `"docker" "inspect" "bf3d5e1ad5e867c2414c2f772b77f135f76a8d054cff5f2cb4c97855a6dcf3cd"`
Dec 07 23:09:39.834 INFO running `"docker" "rm" "-f" "bf3d5e1ad5e867c2414c2f772b77f135f76a8d054cff5f2cb4c97855a6dcf3cd"`
Dec 07 23:09:40.088 INFO [stdout] bf3d5e1ad5e867c2414c2f772b77f135f76a8d054cff5f2cb4c97855a6dcf3cd
Dec 07 23:09:40.092 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-0/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 07 23:09:40.496 INFO [stdout] cf67c81df4fdfcadadcda8963adf1d4b5f45defe7c2fb38feb847a425a5f6fd9
Dec 07 23:09:40.502 INFO running `"docker" "start" "-a" "cf67c81df4fdfcadadcda8963adf1d4b5f45defe7c2fb38feb847a425a5f6fd9"`
Dec 07 23:09:41.676 INFO [stderr] usermod: no changes
Dec 07 23:09:41.830 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.12s
Dec 07 23:09:41.847 INFO [stderr]      Running /target/debug/deps/bamrescue-280ecec5f5e79834
Dec 07 23:09:41.857 INFO [stderr]      Running /target/debug/deps/bamrescue-4ead2e93e3a8cb68
Dec 07 23:09:41.857 INFO [stdout] 
Dec 07 23:09:41.857 INFO [stdout] running 0 tests
Dec 07 23:09:41.857 INFO [stdout] 
Dec 07 23:09:41.857 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 23:09:41.857 INFO [stdout] 
Dec 07 23:09:41.862 INFO [stdout] 
Dec 07 23:09:41.862 INFO [stdout] running 0 tests
Dec 07 23:09:41.862 INFO [stdout] 
Dec 07 23:09:41.862 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 23:09:41.862 INFO [stdout] 
Dec 07 23:09:41.868 INFO [stderr]      Running /target/debug/deps/check-d26cb4068e08829e
Dec 07 23:09:41.870 INFO [stdout] 
Dec 07 23:09:41.870 INFO [stdout] running 26 tests
Dec 07 23:09:41.905 INFO [stdout] test empty_file ... ok
Dec 07 23:09:41.907 INFO [stdout] test empty_with_extra_similar_subfields_before_bam ... ok
Dec 07 23:09:41.920 INFO [stdout] test empty_with_extra_similar_subfields_before_and_after_bam ... ok
Dec 07 23:09:41.921 INFO [stdout] test empty_with_extra_subfields_after_bam ... ok
Dec 07 23:09:41.921 INFO [stdout] test empty_with_extra_similar_subfields_after_bam ... ok
Dec 07 23:09:41.924 INFO [stdout] test empty_with_extra_subfields_before_and_after_bam ... ok
Dec 07 23:09:41.928 INFO [stdout] test empty_with_extra_subfields_before_bam ... ok
Dec 07 23:09:41.944 INFO [stdout] test single_block_missing_bgzf_identifier ... ok
Dec 07 23:09:41.944 INFO [stdout] test empty_bam ... ok
Dec 07 23:09:41.950 INFO [stdout] test three_blocks_bad_inflated_payload_crc32_bam ... ok
Dec 07 23:09:41.953 INFO [stdout] test single_block_bam ... ok
Dec 07 23:09:41.953 INFO [stdout] test three_blocks_bam ... ok
Dec 07 23:09:41.955 INFO [stdout] test three_blocks_too_large_bgzf_size_bam ... ok
Dec 07 23:09:41.965 INFO [stdout] test three_blocks_bad_inflated_payload_size_bam ... ok
Dec 07 23:09:41.966 INFO [stdout] test single_block_missing_gzip_identifier ... ok
Dec 07 23:09:41.976 INFO [stdout] test three_blocks_too_small_bgzf_size_bam ... ok
Dec 07 23:09:41.976 INFO [stdout] test single_block_missing_empty_bam ... ok
Dec 07 23:09:41.976 INFO [stdout] test three_blocks_empty_inside_bam ... ok
Dec 07 23:09:41.986 INFO [stdout] test three_blocks_with_extra_subfields_after_bam ... ok
Dec 07 23:09:42.004 INFO [stdout] test three_blocks_with_extra_similar_subfields_before_bam ... ok
Dec 07 23:09:42.008 INFO [stdout] test three_blocks_with_extra_similar_subfields_after_bam ... ok
Dec 07 23:09:42.009 INFO [stdout] test three_blocks_with_extra_similar_subfields_before_and_after_bam ... ok
Dec 07 23:09:42.018 INFO [stdout] test two_blocks_bam ... ok
Dec 07 23:09:42.019 INFO [stdout] test three_blocks_with_extra_subfields_before_bam ... ok
Dec 07 23:09:42.020 INFO [stdout] test three_blocks_with_extra_subfields_before_and_after_bam ... ok
Dec 07 23:09:42.029 INFO [stdout] test two_blocks_missing_empty_bam ... ok
Dec 07 23:09:42.029 INFO [stdout] 
Dec 07 23:09:42.029 INFO [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 23:09:42.029 INFO [stdout] 
Dec 07 23:09:42.041 INFO [stderr]      Running /target/debug/deps/version-5dc83516ebaa5f57
Dec 07 23:09:42.044 INFO [stdout] 
Dec 07 23:09:42.044 INFO [stdout] running 1 test
Dec 07 23:09:42.045 INFO [stdout] test version ... ok
Dec 07 23:09:42.045 INFO [stdout] 
Dec 07 23:09:42.046 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 23:09:42.046 INFO [stdout] 
Dec 07 23:09:42.047 INFO [stderr]    Doc-tests bamrescue
Dec 07 23:09:43.039 INFO [stdout] 
Dec 07 23:09:43.039 INFO [stdout] running 0 tests
Dec 07 23:09:43.039 INFO [stdout] 
Dec 07 23:09:43.039 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 23:09:43.039 INFO [stdout] 
Dec 07 23:09:43.048 INFO [stderr] su: No module specific data is present
Dec 07 23:09:43.770 INFO running `"docker" "inspect" "cf67c81df4fdfcadadcda8963adf1d4b5f45defe7c2fb38feb847a425a5f6fd9"`
Dec 07 23:09:44.074 INFO running `"docker" "rm" "-f" "cf67c81df4fdfcadadcda8963adf1d4b5f45defe7c2fb38feb847a425a5f6fd9"`
Dec 07 23:09:44.556 INFO [stdout] cf67c81df4fdfcadadcda8963adf1d4b5f45defe7c2fb38feb847a425a5f6fd9