Dec 15 14:46:01.758 INFO testing flac-0.5.0 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 15 14:46:01.758 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 15 14:46:01.989 INFO [stdout] af45ac6a61897b08cd3fb373d20dc57f9edbcb686020265cdd45cab26f6c7248
Dec 15 14:46:01.991 INFO running `"docker" "start" "-a" "af45ac6a61897b08cd3fb373d20dc57f9edbcb686020265cdd45cab26f6c7248"`
Dec 15 14:46:03.064 INFO [stderr] usermod: no changes
Dec 15 14:46:03.147 INFO [stderr]    Compiling hound v1.1.0
Dec 15 14:46:04.228 INFO [stderr]    Compiling flac v0.5.0 (/source)
Dec 15 14:46:06.103 INFO [stderr] warning: variable does not need to be mutable
Dec 15 14:46:06.103 INFO [stderr]    --> src/utility/types.rs:362:9
Dec 15 14:46:06.103 INFO [stderr]     |
Dec 15 14:46:06.103 INFO [stderr] 362 |     let mut buffer = &mut self.buffer;
Dec 15 14:46:06.103 INFO [stderr]     |         ----^^^^^^
Dec 15 14:46:06.103 INFO [stderr]     |         |
Dec 15 14:46:06.103 INFO [stderr]     |         help: remove this `mut`
Dec 15 14:46:06.103 INFO [stderr]     |
Dec 15 14:46:06.103 INFO [stderr]     = note: #[warn(unused_mut)] on by default
Dec 15 14:46:06.103 INFO [stderr] 
Dec 15 14:46:07.350 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.32s
Dec 15 14:46:07.354 INFO [stderr] su: No module specific data is present
Dec 15 14:46:07.642 INFO running `"docker" "inspect" "af45ac6a61897b08cd3fb373d20dc57f9edbcb686020265cdd45cab26f6c7248"`
Dec 15 14:46:07.730 INFO running `"docker" "rm" "-f" "af45ac6a61897b08cd3fb373d20dc57f9edbcb686020265cdd45cab26f6c7248"`
Dec 15 14:46:07.840 INFO [stdout] af45ac6a61897b08cd3fb373d20dc57f9edbcb686020265cdd45cab26f6c7248
Dec 15 14:46:07.844 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 15 14:46:08.011 INFO [stdout] 1ff3f3dca09b86b95304daee4255eb2954edaabff1492f3c72be1bba4c324ae3
Dec 15 14:46:08.026 INFO running `"docker" "start" "-a" "1ff3f3dca09b86b95304daee4255eb2954edaabff1492f3c72be1bba4c324ae3"`
Dec 15 14:46:08.919 INFO [stderr] usermod: no changes
Dec 15 14:46:09.067 INFO [stderr]    Compiling flac v0.5.0 (/source)
Dec 15 14:46:15.895 INFO [stderr] warning: variable does not need to be mutable
Dec 15 14:46:15.895 INFO [stderr]    --> src/utility/types.rs:362:9
Dec 15 14:46:15.895 INFO [stderr]     |
Dec 15 14:46:15.895 INFO [stderr] 362 |     let mut buffer = &mut self.buffer;
Dec 15 14:46:15.895 INFO [stderr]     |         ----^^^^^^
Dec 15 14:46:15.895 INFO [stderr]     |         |
Dec 15 14:46:15.895 INFO [stderr]     |         help: remove this `mut`
Dec 15 14:46:15.895 INFO [stderr]     |
Dec 15 14:46:15.895 INFO [stderr]     = note: #[warn(unused_mut)] on by default
Dec 15 14:46:15.895 INFO [stderr] 
Dec 15 14:46:18.188 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 9.22s
Dec 15 14:46:18.195 INFO [stderr] su: No module specific data is present
Dec 15 14:46:18.503 INFO running `"docker" "inspect" "1ff3f3dca09b86b95304daee4255eb2954edaabff1492f3c72be1bba4c324ae3"`
Dec 15 14:46:18.604 INFO running `"docker" "rm" "-f" "1ff3f3dca09b86b95304daee4255eb2954edaabff1492f3c72be1bba4c324ae3"`
Dec 15 14:46:18.692 INFO [stdout] 1ff3f3dca09b86b95304daee4255eb2954edaabff1492f3c72be1bba4c324ae3
Dec 15 14:46:18.694 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 15 14:46:18.927 INFO [stdout] 31cfc34e3e640e038fbd183dc34b3169cf19f74587bf8ae48dcc9087aca5c962
Dec 15 14:46:18.932 INFO running `"docker" "start" "-a" "31cfc34e3e640e038fbd183dc34b3169cf19f74587bf8ae48dcc9087aca5c962"`
Dec 15 14:46:19.379 INFO [stderr] usermod: no changes
Dec 15 14:46:19.452 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Dec 15 14:46:19.455 INFO [stderr]      Running /target/debug/deps/flac-47368f401ec3b569
Dec 15 14:46:19.461 INFO [stdout] 
Dec 15 14:46:19.461 INFO [stdout] running 71 tests
Dec 15 14:46:19.461 INFO [stdout] test frame::decoder::tests::test_decode ... ok
Dec 15 14:46:19.461 INFO [stdout] test frame::decoder::tests::test_decode_left_side ... ok
Dec 15 14:46:19.461 INFO [stdout] test frame::parser::tests::test_channel_bits ... ok
Dec 15 14:46:19.463 INFO [stdout] test frame::decoder::tests::test_decode_midpoint_side ... ok
Dec 15 14:46:19.463 INFO [stdout] test frame::parser::tests::test_number_type ... ok
Dec 15 14:46:19.463 INFO [stdout] test frame::parser::tests::test_blocking_strategy ... ok
Dec 15 14:46:19.463 INFO [stdout] test frame::parser::tests::test_footer ... ok
Dec 15 14:46:19.463 INFO [stdout] test frame::decoder::tests::test_decode_right_side ... ok
Dec 15 14:46:19.463 INFO [stdout] test frame::parser::tests::test_block_sample ... ok
Dec 15 14:46:19.463 INFO [stdout] test frame::parser::tests::test_header ... ok
Dec 15 14:46:19.463 INFO [stdout] test frame::parser::tests::test_secondary_block_size ... ok
Dec 15 14:46:19.463 INFO [stdout] test frame::parser::tests::test_secondary_sample_rate ... ok
Dec 15 14:46:19.471 INFO [stdout] test frame::parser::tests::test_utf8_header ... ok
Dec 15 14:46:19.471 INFO [stdout] test metadata::metadata::tests::test_optional_eq ... ok
Dec 15 14:46:19.471 INFO [stdout] test metadata::parser::tests::test_application ... ok
Dec 15 14:46:19.471 INFO [stdout] test metadata::metadata::tests::test_get_metadata ... ok
Dec 15 14:46:19.472 INFO [stdout] test metadata::parser::tests::test_cue_sheet ... ok
Dec 15 14:46:19.472 INFO [stdout] test metadata::parser::tests::test_header ... ok
Dec 15 14:46:19.472 INFO [stdout] test metadata::parser::tests::test_seek_table ... ok
Dec 15 14:46:19.472 INFO [stdout] test metadata::parser::tests::test_picture ... ok
Dec 15 14:46:19.473 INFO [stdout] test metadata::parser::tests::test_stream_info ... ok
Dec 15 14:46:19.473 INFO [stdout] test metadata::parser::tests::test_unknown ... ok
Dec 15 14:46:19.474 INFO [stdout] test metadata::types::tests::test_is_fixed_block_size ... ok
Dec 15 14:46:19.474 INFO [stdout] test metadata::parser::tests::test_padding ... ok
Dec 15 14:46:19.474 INFO [stdout] test metadata::types::tests::test_application_to_bytes ... ok
Dec 15 14:46:19.474 INFO [stdout] test metadata::types::tests::test_cue_sheet_to_bytes ... ok
Dec 15 14:46:19.474 INFO [stdout] test metadata::types::tests::test_is_varied_block_size ... ok
Dec 15 14:46:19.474 INFO [stdout] test metadata::parser::tests::test_vorbis_comment ... ok
Dec 15 14:46:19.474 INFO [stdout] test metadata::types::tests::test_unknown_to_bytes ... ok
Dec 15 14:46:19.474 INFO [stdout] test subframe::decoder::tests::test_decode ... ok
Dec 15 14:46:19.474 INFO [stdout] test metadata::types::tests::test_stream_info_to_bytes ... ok
Dec 15 14:46:19.474 INFO [stdout] test metadata::types::tests::test_seek_table_to_bytes ... ok
Dec 15 14:46:19.474 INFO [stdout] test metadata::types::tests::test_picture_to_bytes ... ok
Dec 15 14:46:19.479 INFO [stdout] test subframe::decoder::tests::test_lpc_restore_signal ... ok
Dec 15 14:46:19.479 INFO [stdout] test subframe::decoder::tests::test_wasted_bit_decode ... ok
Dec 15 14:46:19.479 INFO [stdout] test metadata::types::tests::test_vorbis_comment_to_bytes ... ok
Dec 15 14:46:19.479 INFO [stdout] test metadata::types::tests::test_padding_to_bytes ... ok
Dec 15 14:46:19.479 INFO [stdout] test subframe::decoder::tests::test_fixed_restore_signal ... ok
Dec 15 14:46:19.479 INFO [stdout] test subframe::parser::tests::test_adjust_bits_per_sample ... ok
Dec 15 14:46:19.483 INFO [stdout] test subframe::parser::tests::test_header ... ok
Dec 15 14:46:19.483 INFO [stdout] test utility::crc::tests::test_crc8 ... ok
Dec 15 14:46:19.483 INFO [stdout] test subframe::parser::tests::test_lpc ... ok
Dec 15 14:46:19.483 INFO [stdout] test utility::tests::test_extend_sign ... ok
Dec 15 14:46:19.483 INFO [stdout] test subframe::parser::tests::test_verbatim ... ok
Dec 15 14:46:19.483 INFO [stdout] test subframe::parser::tests::test_leading_zeros ... ok
Dec 15 14:46:19.484 INFO [stdout] test subframe::parser::tests::test_constant ... ok
Dec 15 14:46:19.484 INFO [stdout] test utility::crc::tests::test_crc16 ... ok
Dec 15 14:46:19.484 INFO [stdout] test subframe::parser::tests::test_fixed ... ok
Dec 15 14:46:19.484 INFO [stdout] test utility::tests::test_power_of_two ... ok
Dec 15 14:46:19.484 INFO [stdout] test utility::tests::test_to_u32 ... ok
Dec 15 14:46:19.484 INFO [stdout] test utility::tests::test_write_be_u16 ... ok
Dec 15 14:46:19.484 INFO [stdout] test utility::tests::test_write_le_u16 ... ok
Dec 15 14:46:19.487 INFO [stdout] test utility::tests::test_write_le_u24 ... ok
Dec 15 14:46:19.487 INFO [stdout] test utility::tests::test_write_be_u24 ... ok
Dec 15 14:46:19.487 INFO [stdout] test utility::tests::test_write_be_u64 ... ok
Dec 15 14:46:19.487 INFO [stdout] test utility::tests::test_write_le_u32 ... ok
Dec 15 14:46:19.487 INFO [stdout] test utility::tests::test_write_be_u32 ... ok
Dec 15 14:46:19.487 INFO [stdout] test utility::types::tests::test_from_i16 ... ok
Dec 15 14:46:19.487 INFO [stdout] test utility::types::tests::test_buffer ... ok
Dec 15 14:46:19.487 INFO [stdout] test utility::tests::test_write_u8 ... ok
Dec 15 14:46:19.487 INFO [stdout] test utility::types::tests::test_byte_stream ... ok
Dec 15 14:46:19.487 INFO [stdout] test utility::types::tests::test_from_i32_lossy ... ok
Dec 15 14:46:19.487 INFO [stdout] test utility::types::tests::test_from_i32 ... ok
Dec 15 14:46:19.487 INFO [stdout] test utility::types::tests::test_from_i8 ... ok
Dec 15 14:46:19.487 INFO [stdout] test utility::types::tests::test_sample_to_normal ... ok
Dec 15 14:46:19.491 INFO [stdout] test utility::types::tests::test_read_stream ... ok
Dec 15 14:46:19.491 INFO [stdout] test utility::tests::test_write_le_u64 ... ok
Dec 15 14:46:19.491 INFO [stdout] test utility::types::tests::test_sample_size ... ok
Dec 15 14:46:19.511 INFO [stdout] test metadata::metadata::tests::test_panic_optional_eq ... ok
Dec 15 14:46:19.511 INFO [stdout] test utility::tests::test_panic_power_of_two ... ok
Dec 15 14:46:19.511 INFO [stdout] test utility::tests::test_panic_to_u32 ... ok
Dec 15 14:46:19.511 INFO [stdout] 
Dec 15 14:46:19.511 INFO [stdout] test result: ok. 71 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 14:46:19.511 INFO [stdout] 
Dec 15 14:46:19.512 INFO [stderr]      Running /target/debug/deps/metadata-de0f5cf4a75aed0a
Dec 15 14:46:19.514 INFO [stdout] 
Dec 15 14:46:19.514 INFO [stdout] running 4 tests
Dec 15 14:46:19.516 INFO [stdout] test test_get_stream_info ... ok
Dec 15 14:46:19.516 INFO [stdout] test test_get_vorbis_comment ... ok
Dec 15 14:46:19.516 INFO [stdout] test test_get_cue_sheet ... ok
Dec 15 14:46:19.516 INFO [stdout] test test_get_picture ... ok
Dec 15 14:46:19.516 INFO [stdout] 
Dec 15 14:46:19.516 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 14:46:19.516 INFO [stdout] 
Dec 15 14:46:19.518 INFO [stderr]      Running /target/debug/deps/stream-a0bb1eded35ddbf6
Dec 15 14:46:19.520 INFO [stdout] 
Dec 15 14:46:19.520 INFO [stdout] running 1 test
Dec 15 14:46:19.532 INFO [stdout] test test_decoded_md5_sum ... ok
Dec 15 14:46:19.532 INFO [stdout] 
Dec 15 14:46:19.532 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 14:46:19.532 INFO [stdout] 
Dec 15 14:46:19.533 INFO [stderr]    Doc-tests flac
Dec 15 14:46:20.655 INFO [stdout] 
Dec 15 14:46:20.655 INFO [stdout] running 9 tests
Dec 15 14:46:23.403 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_stream_info (line 85) ... ok
Dec 15 14:46:23.735 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_picture (line 234) ... ok
Dec 15 14:46:24.291 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_cue_sheet (line 188) ... ok
Dec 15 14:46:24.307 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_cue_sheet (line 175) ... ok
Dec 15 14:46:24.569 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_picture (line 254) ... ok
Dec 15 14:46:24.835 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_vorbis_comment (line 123) ... ok
Dec 15 14:46:25.167 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_stream_info (line 72) ... ok
Dec 15 14:46:25.465 INFO [stdout] test src/lib.rs -  (line 10) ... ok
Dec 15 14:46:25.555 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_vorbis_comment (line 136) ... ok
Dec 15 14:46:25.555 INFO [stdout] 
Dec 15 14:46:25.555 INFO [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 14:46:25.555 INFO [stdout] 
Dec 15 14:46:25.578 INFO [stderr] su: No module specific data is present
Dec 15 14:46:25.824 INFO running `"docker" "inspect" "31cfc34e3e640e038fbd183dc34b3169cf19f74587bf8ae48dcc9087aca5c962"`
Dec 15 14:46:25.903 INFO running `"docker" "rm" "-f" "31cfc34e3e640e038fbd183dc34b3169cf19f74587bf8ae48dcc9087aca5c962"`
Dec 15 14:46:25.999 INFO [stdout] 31cfc34e3e640e038fbd183dc34b3169cf19f74587bf8ae48dcc9087aca5c962