Dec 15 14:46:02.019 INFO testing flac-0.5.0 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 15 14:46:02.019 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 15 14:46:02.296 INFO [stdout] e017e7c50882bfc7497465ccb0e81a0f9929a7a78cc8d427e4c4288df5a59302
Dec 15 14:46:02.307 INFO running `"docker" "start" "-a" "e017e7c50882bfc7497465ccb0e81a0f9929a7a78cc8d427e4c4288df5a59302"`
Dec 15 14:46:03.391 INFO [stderr] usermod: no changes
Dec 15 14:46:03.479 INFO [stderr]    Compiling flac v0.5.0 (/source)
Dec 15 14:46:05.322 INFO [stderr] warning: variable does not need to be mutable
Dec 15 14:46:05.322 INFO [stderr]    --> src/utility/types.rs:362:9
Dec 15 14:46:05.322 INFO [stderr]     |
Dec 15 14:46:05.322 INFO [stderr] 362 |     let mut buffer = &mut self.buffer;
Dec 15 14:46:05.322 INFO [stderr]     |         ----^^^^^^
Dec 15 14:46:05.322 INFO [stderr]     |         |
Dec 15 14:46:05.322 INFO [stderr]     |         help: remove this `mut`
Dec 15 14:46:05.322 INFO [stderr]     |
Dec 15 14:46:05.322 INFO [stderr]     = note: #[warn(unused_mut)] on by default
Dec 15 14:46:05.322 INFO [stderr] 
Dec 15 14:46:06.833 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.44s
Dec 15 14:46:06.847 INFO [stderr] su: No module specific data is present
Dec 15 14:46:07.363 INFO running `"docker" "inspect" "e017e7c50882bfc7497465ccb0e81a0f9929a7a78cc8d427e4c4288df5a59302"`
Dec 15 14:46:07.435 INFO running `"docker" "rm" "-f" "e017e7c50882bfc7497465ccb0e81a0f9929a7a78cc8d427e4c4288df5a59302"`
Dec 15 14:46:07.505 INFO [stdout] e017e7c50882bfc7497465ccb0e81a0f9929a7a78cc8d427e4c4288df5a59302
Dec 15 14:46:07.506 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 15 14:46:07.638 INFO [stdout] 6bbbd44038c322208d15fa379f149ef04bdad76ce4e8769cc011a08ed467b27f
Dec 15 14:46:07.640 INFO running `"docker" "start" "-a" "6bbbd44038c322208d15fa379f149ef04bdad76ce4e8769cc011a08ed467b27f"`
Dec 15 14:46:08.140 INFO [stderr] usermod: no changes
Dec 15 14:46:08.230 INFO [stderr]    Compiling flac v0.5.0 (/source)
Dec 15 14:46:15.155 INFO [stderr] warning: variable does not need to be mutable
Dec 15 14:46:15.155 INFO [stderr]    --> src/utility/types.rs:362:9
Dec 15 14:46:15.155 INFO [stderr]     |
Dec 15 14:46:15.155 INFO [stderr] 362 |     let mut buffer = &mut self.buffer;
Dec 15 14:46:15.155 INFO [stderr]     |         ----^^^^^^
Dec 15 14:46:15.155 INFO [stderr]     |         |
Dec 15 14:46:15.155 INFO [stderr]     |         help: remove this `mut`
Dec 15 14:46:15.155 INFO [stderr]     |
Dec 15 14:46:15.155 INFO [stderr]     = note: #[warn(unused_mut)] on by default
Dec 15 14:46:15.155 INFO [stderr] 
Dec 15 14:46:17.593 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 9.43s
Dec 15 14:46:17.598 INFO [stderr] su: No module specific data is present
Dec 15 14:46:17.940 INFO running `"docker" "inspect" "6bbbd44038c322208d15fa379f149ef04bdad76ce4e8769cc011a08ed467b27f"`
Dec 15 14:46:18.054 INFO running `"docker" "rm" "-f" "6bbbd44038c322208d15fa379f149ef04bdad76ce4e8769cc011a08ed467b27f"`
Dec 15 14:46:18.170 INFO [stdout] 6bbbd44038c322208d15fa379f149ef04bdad76ce4e8769cc011a08ed467b27f
Dec 15 14:46:18.176 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 15 14:46:18.378 INFO [stdout] 29444fb7ef9b365b9ecabca224c082b13cb76331640b025815a3f757cf18ac6a
Dec 15 14:46:18.380 INFO running `"docker" "start" "-a" "29444fb7ef9b365b9ecabca224c082b13cb76331640b025815a3f757cf18ac6a"`
Dec 15 14:46:18.819 INFO [stderr] usermod: no changes
Dec 15 14:46:18.882 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Dec 15 14:46:18.884 INFO [stderr]      Running /target/debug/deps/flac-53a16361e306b358
Dec 15 14:46:18.887 INFO [stdout] 
Dec 15 14:46:18.888 INFO [stdout] running 71 tests
Dec 15 14:46:18.888 INFO [stdout] test frame::parser::tests::test_channel_bits ... ok
Dec 15 14:46:18.888 INFO [stdout] test frame::parser::tests::test_footer ... ok
Dec 15 14:46:18.888 INFO [stdout] test frame::parser::tests::test_blocking_strategy ... ok
Dec 15 14:46:18.888 INFO [stdout] test frame::parser::tests::test_block_sample ... ok
Dec 15 14:46:18.888 INFO [stdout] test frame::decoder::tests::test_decode_right_side ... ok
Dec 15 14:46:18.888 INFO [stdout] test frame::decoder::tests::test_decode_midpoint_side ... ok
Dec 15 14:46:18.888 INFO [stdout] test frame::parser::tests::test_header ... ok
Dec 15 14:46:18.888 INFO [stdout] test frame::parser::tests::test_number_type ... ok
Dec 15 14:46:18.888 INFO [stdout] test frame::parser::tests::test_secondary_block_size ... ok
Dec 15 14:46:18.888 INFO [stdout] test frame::parser::tests::test_secondary_sample_rate ... ok
Dec 15 14:46:18.888 INFO [stdout] test frame::decoder::tests::test_decode_left_side ... ok
Dec 15 14:46:18.888 INFO [stdout] test metadata::metadata::tests::test_get_metadata ... ok
Dec 15 14:46:18.888 INFO [stdout] test frame::parser::tests::test_utf8_header ... ok
Dec 15 14:46:18.888 INFO [stdout] test metadata::metadata::tests::test_optional_eq ... ok
Dec 15 14:46:18.891 INFO [stdout] test metadata::parser::tests::test_application ... ok
Dec 15 14:46:18.891 INFO [stdout] test metadata::parser::tests::test_cue_sheet ... ok
Dec 15 14:46:18.891 INFO [stdout] test metadata::parser::tests::test_header ... ok
Dec 15 14:46:18.891 INFO [stdout] test metadata::parser::tests::test_padding ... ok
Dec 15 14:46:18.891 INFO [stdout] test metadata::parser::tests::test_picture ... ok
Dec 15 14:46:18.891 INFO [stdout] test metadata::parser::tests::test_seek_table ... ok
Dec 15 14:46:18.891 INFO [stdout] test frame::decoder::tests::test_decode ... ok
Dec 15 14:46:18.891 INFO [stdout] test metadata::types::tests::test_is_fixed_block_size ... ok
Dec 15 14:46:18.891 INFO [stdout] test metadata::types::tests::test_padding_to_bytes ... ok
Dec 15 14:46:18.891 INFO [stdout] test metadata::types::tests::test_application_to_bytes ... ok
Dec 15 14:46:18.892 INFO [stdout] test metadata::parser::tests::test_vorbis_comment ... ok
Dec 15 14:46:18.892 INFO [stdout] test metadata::types::tests::test_is_varied_block_size ... ok
Dec 15 14:46:18.892 INFO [stdout] test metadata::types::tests::test_picture_to_bytes ... ok
Dec 15 14:46:18.897 INFO [stdout] test metadata::parser::tests::test_unknown ... ok
Dec 15 14:46:18.897 INFO [stdout] test metadata::types::tests::test_unknown_to_bytes ... ok
Dec 15 14:46:18.897 INFO [stdout] test metadata::types::tests::test_cue_sheet_to_bytes ... ok
Dec 15 14:46:18.897 INFO [stdout] test metadata::types::tests::test_seek_table_to_bytes ... ok
Dec 15 14:46:18.897 INFO [stdout] test metadata::parser::tests::test_stream_info ... ok
Dec 15 14:46:18.897 INFO [stdout] test metadata::types::tests::test_stream_info_to_bytes ... ok
Dec 15 14:46:18.897 INFO [stdout] test subframe::parser::tests::test_adjust_bits_per_sample ... ok
Dec 15 14:46:18.897 INFO [stdout] test subframe::decoder::tests::test_wasted_bit_decode ... ok
Dec 15 14:46:18.897 INFO [stdout] test subframe::decoder::tests::test_lpc_restore_signal ... ok
Dec 15 14:46:18.898 INFO [stdout] test metadata::types::tests::test_vorbis_comment_to_bytes ... ok
Dec 15 14:46:18.898 INFO [stdout] test subframe::decoder::tests::test_fixed_restore_signal ... ok
Dec 15 14:46:18.898 INFO [stdout] test subframe::parser::tests::test_header ... ok
Dec 15 14:46:18.898 INFO [stdout] test subframe::parser::tests::test_constant ... ok
Dec 15 14:46:18.898 INFO [stdout] test subframe::parser::tests::test_fixed ... ok
Dec 15 14:46:18.898 INFO [stdout] test utility::crc::tests::test_crc16 ... ok
Dec 15 14:46:18.898 INFO [stdout] test subframe::parser::tests::test_verbatim ... ok
Dec 15 14:46:18.898 INFO [stdout] test utility::crc::tests::test_crc8 ... ok
Dec 15 14:46:18.898 INFO [stdout] test utility::tests::test_extend_sign ... ok
Dec 15 14:46:18.898 INFO [stdout] test utility::tests::test_power_of_two ... ok
Dec 15 14:46:18.898 INFO [stdout] test utility::tests::test_to_u32 ... ok
Dec 15 14:46:18.898 INFO [stdout] test utility::tests::test_write_be_u16 ... ok
Dec 15 14:46:18.898 INFO [stdout] test utility::tests::test_write_be_u24 ... ok
Dec 15 14:46:18.898 INFO [stdout] test utility::tests::test_write_be_u32 ... ok
Dec 15 14:46:18.899 INFO [stdout] test utility::tests::test_write_be_u64 ... ok
Dec 15 14:46:18.899 INFO [stdout] test utility::tests::test_write_le_u16 ... ok
Dec 15 14:46:18.899 INFO [stdout] test subframe::decoder::tests::test_decode ... ok
Dec 15 14:46:18.899 INFO [stdout] test utility::tests::test_write_le_u32 ... ok
Dec 15 14:46:18.900 INFO [stdout] test subframe::parser::tests::test_leading_zeros ... ok
Dec 15 14:46:18.900 INFO [stdout] test utility::tests::test_write_u8 ... ok
Dec 15 14:46:18.900 INFO [stdout] test utility::tests::test_write_le_u24 ... ok
Dec 15 14:46:18.900 INFO [stdout] test subframe::parser::tests::test_lpc ... ok
Dec 15 14:46:18.901 INFO [stdout] test utility::types::tests::test_from_i32 ... ok
Dec 15 14:46:18.901 INFO [stdout] test utility::types::tests::test_from_i16 ... ok
Dec 15 14:46:18.901 INFO [stdout] test utility::types::tests::test_from_i32_lossy ... ok
Dec 15 14:46:18.902 INFO [stdout] test utility::types::tests::test_from_i8 ... ok
Dec 15 14:46:18.902 INFO [stdout] test utility::types::tests::test_read_stream ... ok
Dec 15 14:46:18.902 INFO [stdout] test utility::types::tests::test_sample_size ... ok
Dec 15 14:46:18.902 INFO [stdout] test utility::types::tests::test_sample_to_normal ... ok
Dec 15 14:46:18.902 INFO [stdout] test utility::types::tests::test_byte_stream ... ok
Dec 15 14:46:18.902 INFO [stdout] test utility::types::tests::test_buffer ... ok
Dec 15 14:46:18.902 INFO [stdout] test utility::tests::test_write_le_u64 ... ok
Dec 15 14:46:18.937 INFO [stdout] test metadata::metadata::tests::test_panic_optional_eq ... ok
Dec 15 14:46:18.937 INFO [stdout] test utility::tests::test_panic_power_of_two ... ok
Dec 15 14:46:18.939 INFO [stdout] test utility::tests::test_panic_to_u32 ... ok
Dec 15 14:46:18.939 INFO [stdout] 
Dec 15 14:46:18.939 INFO [stdout] test result: ok. 71 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 14:46:18.939 INFO [stdout] 
Dec 15 14:46:18.939 INFO [stderr]      Running /target/debug/deps/metadata-f2042989daf50ff5
Dec 15 14:46:18.942 INFO [stdout] 
Dec 15 14:46:18.942 INFO [stdout] running 4 tests
Dec 15 14:46:18.942 INFO [stdout] test test_get_vorbis_comment ... ok
Dec 15 14:46:18.945 INFO [stdout] test test_get_stream_info ... ok
Dec 15 14:46:18.945 INFO [stdout] test test_get_cue_sheet ... ok
Dec 15 14:46:18.946 INFO [stdout] test test_get_picture ... ok
Dec 15 14:46:18.946 INFO [stdout] 
Dec 15 14:46:18.946 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 14:46:18.946 INFO [stdout] 
Dec 15 14:46:18.946 INFO [stderr]      Running /target/debug/deps/stream-cbfb23257b31df8d
Dec 15 14:46:18.948 INFO [stdout] 
Dec 15 14:46:18.948 INFO [stdout] running 1 test
Dec 15 14:46:18.959 INFO [stdout] test test_decoded_md5_sum ... ok
Dec 15 14:46:18.959 INFO [stdout] 
Dec 15 14:46:18.959 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 14:46:18.959 INFO [stdout] 
Dec 15 14:46:18.960 INFO [stderr]    Doc-tests flac
Dec 15 14:46:19.896 INFO [stdout] 
Dec 15 14:46:19.896 INFO [stdout] running 9 tests
Dec 15 14:46:22.939 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_picture (line 254) ... ok
Dec 15 14:46:24.335 INFO [stdout] test src/lib.rs -  (line 10) ... ok
Dec 15 14:46:24.343 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_stream_info (line 85) ... ok
Dec 15 14:46:24.539 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_cue_sheet (line 188) ... ok
Dec 15 14:46:24.606 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_stream_info (line 72) ... ok
Dec 15 14:46:24.663 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_picture (line 234) ... ok
Dec 15 14:46:24.663 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_vorbis_comment (line 123) ... ok
Dec 15 14:46:24.679 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_cue_sheet (line 175) ... ok
Dec 15 14:46:25.338 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_vorbis_comment (line 136) ... ok
Dec 15 14:46:25.338 INFO [stdout] 
Dec 15 14:46:25.338 INFO [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 14:46:25.338 INFO [stdout] 
Dec 15 14:46:25.363 INFO [stderr] su: No module specific data is present
Dec 15 14:46:25.701 INFO running `"docker" "inspect" "29444fb7ef9b365b9ecabca224c082b13cb76331640b025815a3f757cf18ac6a"`
Dec 15 14:46:25.797 INFO running `"docker" "rm" "-f" "29444fb7ef9b365b9ecabca224c082b13cb76331640b025815a3f757cf18ac6a"`
Dec 15 14:46:25.879 INFO [stdout] 29444fb7ef9b365b9ecabca224c082b13cb76331640b025815a3f757cf18ac6a