Nov 18 14:13:47.745 INFO testing flac-0.5.0 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 18 14:13:47.745 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 18 14:13:47.966 INFO [stdout] 36017b9523f339dd82d6eb1fe93161aec988aee4df280e016e4e4973d6ab2b5f
Nov 18 14:13:47.975 INFO running `"docker" "start" "-a" "36017b9523f339dd82d6eb1fe93161aec988aee4df280e016e4e4973d6ab2b5f"`
Nov 18 14:13:48.479 INFO [stderr] usermod: no changes
Nov 18 14:13:48.563 INFO [stderr]    Compiling hound v1.1.0
Nov 18 14:13:49.388 INFO [stderr]    Compiling flac v0.5.0 (/source)
Nov 18 14:13:50.998 INFO [stderr] warning: variable does not need to be mutable
Nov 18 14:13:50.998 INFO [stderr]    --> src/utility/types.rs:362:9
Nov 18 14:13:50.998 INFO [stderr]     |
Nov 18 14:13:50.998 INFO [stderr] 362 |     let mut buffer = &mut self.buffer;
Nov 18 14:13:50.998 INFO [stderr]     |         ----^^^^^^
Nov 18 14:13:50.998 INFO [stderr]     |         |
Nov 18 14:13:50.998 INFO [stderr]     |         help: remove this `mut`
Nov 18 14:13:50.998 INFO [stderr]     |
Nov 18 14:13:50.998 INFO [stderr]     = note: #[warn(unused_mut)] on by default
Nov 18 14:13:50.998 INFO [stderr] 
Nov 18 14:13:52.449 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.95s
Nov 18 14:13:52.454 INFO [stderr] su: No module specific data is present
Nov 18 14:13:53.081 INFO running `"docker" "inspect" "36017b9523f339dd82d6eb1fe93161aec988aee4df280e016e4e4973d6ab2b5f"`
Nov 18 14:13:53.483 INFO running `"docker" "rm" "-f" "36017b9523f339dd82d6eb1fe93161aec988aee4df280e016e4e4973d6ab2b5f"`
Nov 18 14:13:53.877 INFO [stdout] 36017b9523f339dd82d6eb1fe93161aec988aee4df280e016e4e4973d6ab2b5f
Nov 18 14:13:53.881 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 18 14:13:54.323 INFO [stdout] 77ae4f9c766386332df7008871d9e24123de9afe62d7d502cf5e64c9e7430bc0
Nov 18 14:13:54.323 INFO running `"docker" "start" "-a" "77ae4f9c766386332df7008871d9e24123de9afe62d7d502cf5e64c9e7430bc0"`
Nov 18 14:13:55.192 INFO [stderr] usermod: no changes
Nov 18 14:13:55.295 INFO [stderr]    Compiling flac v0.5.0 (/source)
Nov 18 14:14:02.455 INFO [stderr] warning: variable does not need to be mutable
Nov 18 14:14:02.455 INFO [stderr]    --> src/utility/types.rs:362:9
Nov 18 14:14:02.455 INFO [stderr]     |
Nov 18 14:14:02.455 INFO [stderr] 362 |     let mut buffer = &mut self.buffer;
Nov 18 14:14:02.455 INFO [stderr]     |         ----^^^^^^
Nov 18 14:14:02.455 INFO [stderr]     |         |
Nov 18 14:14:02.455 INFO [stderr]     |         help: remove this `mut`
Nov 18 14:14:02.455 INFO [stderr]     |
Nov 18 14:14:02.455 INFO [stderr]     = note: #[warn(unused_mut)] on by default
Nov 18 14:14:02.455 INFO [stderr] 
Nov 18 14:14:05.127 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 9.90s
Nov 18 14:14:05.132 INFO [stderr] su: No module specific data is present
Nov 18 14:14:05.401 INFO running `"docker" "inspect" "77ae4f9c766386332df7008871d9e24123de9afe62d7d502cf5e64c9e7430bc0"`
Nov 18 14:14:05.476 INFO running `"docker" "rm" "-f" "77ae4f9c766386332df7008871d9e24123de9afe62d7d502cf5e64c9e7430bc0"`
Nov 18 14:14:05.550 INFO [stdout] 77ae4f9c766386332df7008871d9e24123de9afe62d7d502cf5e64c9e7430bc0
Nov 18 14:14:05.552 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 18 14:14:05.762 INFO [stdout] 64c88df4406a992013b1a9744c86cfe2c8341931dcacb3e28587b212c6ef59a7
Nov 18 14:14:05.764 INFO running `"docker" "start" "-a" "64c88df4406a992013b1a9744c86cfe2c8341931dcacb3e28587b212c6ef59a7"`
Nov 18 14:14:06.233 INFO [stderr] usermod: no changes
Nov 18 14:14:06.304 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Nov 18 14:14:06.317 INFO [stderr]      Running /target/debug/deps/flac-9f9af4c46af9768c
Nov 18 14:14:06.319 INFO [stdout] 
Nov 18 14:14:06.319 INFO [stdout] running 71 tests
Nov 18 14:14:06.320 INFO [stdout] test frame::decoder::tests::test_decode_left_side ... ok
Nov 18 14:14:06.320 INFO [stdout] test frame::decoder::tests::test_decode_midpoint_side ... ok
Nov 18 14:14:06.320 INFO [stdout] test frame::decoder::tests::test_decode ... ok
Nov 18 14:14:06.320 INFO [stdout] test frame::decoder::tests::test_decode_right_side ... ok
Nov 18 14:14:06.320 INFO [stdout] test frame::parser::tests::test_block_sample ... ok
Nov 18 14:14:06.320 INFO [stdout] test frame::parser::tests::test_blocking_strategy ... ok
Nov 18 14:14:06.320 INFO [stdout] test frame::parser::tests::test_channel_bits ... ok
Nov 18 14:14:06.320 INFO [stdout] test frame::parser::tests::test_footer ... ok
Nov 18 14:14:06.320 INFO [stdout] test frame::parser::tests::test_header ... ok
Nov 18 14:14:06.320 INFO [stdout] test frame::parser::tests::test_utf8_header ... ok
Nov 18 14:14:06.321 INFO [stdout] test metadata::metadata::tests::test_optional_eq ... ok
Nov 18 14:14:06.322 INFO [stdout] test metadata::metadata::tests::test_get_metadata ... ok
Nov 18 14:14:06.322 INFO [stdout] test metadata::parser::tests::test_padding ... ok
Nov 18 14:14:06.322 INFO [stdout] test metadata::parser::tests::test_cue_sheet ... ok
Nov 18 14:14:06.322 INFO [stdout] test metadata::parser::tests::test_seek_table ... ok
Nov 18 14:14:06.322 INFO [stdout] test metadata::parser::tests::test_picture ... ok
Nov 18 14:14:06.322 INFO [stdout] test frame::parser::tests::test_secondary_block_size ... ok
Nov 18 14:14:06.324 INFO [stdout] test frame::parser::tests::test_number_type ... ok
Nov 18 14:14:06.324 INFO [stdout] test metadata::parser::tests::test_header ... ok
Nov 18 14:14:06.324 INFO [stdout] test frame::parser::tests::test_secondary_sample_rate ... ok
Nov 18 14:14:06.324 INFO [stdout] test metadata::parser::tests::test_application ... ok
Nov 18 14:14:06.324 INFO [stdout] test metadata::parser::tests::test_stream_info ... ok
Nov 18 14:14:06.324 INFO [stdout] test metadata::parser::tests::test_unknown ... ok
Nov 18 14:14:06.324 INFO [stdout] test metadata::types::tests::test_cue_sheet_to_bytes ... ok
Nov 18 14:14:06.324 INFO [stdout] test metadata::types::tests::test_application_to_bytes ... ok
Nov 18 14:14:06.324 INFO [stdout] test metadata::parser::tests::test_vorbis_comment ... ok
Nov 18 14:14:06.324 INFO [stdout] test metadata::types::tests::test_is_varied_block_size ... ok
Nov 18 14:14:06.324 INFO [stdout] test metadata::types::tests::test_padding_to_bytes ... ok
Nov 18 14:14:06.324 INFO [stdout] test metadata::types::tests::test_picture_to_bytes ... ok
Nov 18 14:14:06.324 INFO [stdout] test metadata::types::tests::test_is_fixed_block_size ... ok
Nov 18 14:14:06.324 INFO [stdout] test subframe::decoder::tests::test_fixed_restore_signal ... ok
Nov 18 14:14:06.324 INFO [stdout] test subframe::decoder::tests::test_lpc_restore_signal ... ok
Nov 18 14:14:06.324 INFO [stdout] test subframe::decoder::tests::test_wasted_bit_decode ... ok
Nov 18 14:14:06.326 INFO [stdout] test subframe::parser::tests::test_adjust_bits_per_sample ... ok
Nov 18 14:14:06.326 INFO [stdout] test metadata::types::tests::test_seek_table_to_bytes ... ok
Nov 18 14:14:06.326 INFO [stdout] test metadata::types::tests::test_stream_info_to_bytes ... ok
Nov 18 14:14:06.326 INFO [stdout] test metadata::types::tests::test_vorbis_comment_to_bytes ... ok
Nov 18 14:14:06.327 INFO [stdout] test metadata::types::tests::test_unknown_to_bytes ... ok
Nov 18 14:14:06.327 INFO [stdout] test subframe::decoder::tests::test_decode ... ok
Nov 18 14:14:06.327 INFO [stdout] test subframe::parser::tests::test_constant ... ok
Nov 18 14:14:06.327 INFO [stdout] test subframe::parser::tests::test_leading_zeros ... ok
Nov 18 14:14:06.327 INFO [stdout] test subframe::parser::tests::test_header ... ok
Nov 18 14:14:06.327 INFO [stdout] test subframe::parser::tests::test_fixed ... ok
Nov 18 14:14:06.327 INFO [stdout] test utility::crc::tests::test_crc16 ... ok
Nov 18 14:14:06.327 INFO [stdout] test utility::crc::tests::test_crc8 ... ok
Nov 18 14:14:06.327 INFO [stdout] test subframe::parser::tests::test_lpc ... ok
Nov 18 14:14:06.327 INFO [stdout] test subframe::parser::tests::test_verbatim ... ok
Nov 18 14:14:06.328 INFO [stdout] test utility::tests::test_extend_sign ... ok
Nov 18 14:14:06.328 INFO [stdout] test utility::tests::test_to_u32 ... ok
Nov 18 14:14:06.328 INFO [stdout] test utility::tests::test_power_of_two ... ok
Nov 18 14:14:06.328 INFO [stdout] test utility::tests::test_write_be_u64 ... ok
Nov 18 14:14:06.328 INFO [stdout] test utility::tests::test_write_be_u32 ... ok
Nov 18 14:14:06.328 INFO [stdout] test utility::tests::test_write_be_u24 ... ok
Nov 18 14:14:06.328 INFO [stdout] test utility::tests::test_write_be_u16 ... ok
Nov 18 14:14:06.328 INFO [stdout] test utility::tests::test_write_le_u16 ... ok
Nov 18 14:14:06.328 INFO [stdout] test utility::tests::test_write_le_u24 ... ok
Nov 18 14:14:06.328 INFO [stdout] test utility::tests::test_write_le_u32 ... ok
Nov 18 14:14:06.328 INFO [stdout] test utility::tests::test_write_u8 ... ok
Nov 18 14:14:06.328 INFO [stdout] test utility::types::tests::test_from_i16 ... ok
Nov 18 14:14:06.328 INFO [stdout] test utility::tests::test_write_le_u64 ... ok
Nov 18 14:14:06.328 INFO [stdout] test utility::types::tests::test_buffer ... ok
Nov 18 14:14:06.329 INFO [stdout] test utility::types::tests::test_byte_stream ... ok
Nov 18 14:14:06.329 INFO [stdout] test utility::types::tests::test_from_i32 ... ok
Nov 18 14:14:06.330 INFO [stdout] test utility::types::tests::test_sample_to_normal ... ok
Nov 18 14:14:06.330 INFO [stdout] test utility::types::tests::test_from_i8 ... ok
Nov 18 14:14:06.330 INFO [stdout] test utility::types::tests::test_from_i32_lossy ... ok
Nov 18 14:14:06.332 INFO [stdout] test utility::types::tests::test_sample_size ... ok
Nov 18 14:14:06.332 INFO [stdout] test utility::types::tests::test_read_stream ... ok
Nov 18 14:14:06.361 INFO [stdout] test metadata::metadata::tests::test_panic_optional_eq ... ok
Nov 18 14:14:06.362 INFO [stdout] test utility::tests::test_panic_power_of_two ... ok
Nov 18 14:14:06.362 INFO [stdout] test utility::tests::test_panic_to_u32 ... ok
Nov 18 14:14:06.362 INFO [stdout] 
Nov 18 14:14:06.362 INFO [stdout] test result: ok. 71 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 14:14:06.362 INFO [stdout] 
Nov 18 14:14:06.363 INFO [stderr]      Running /target/debug/deps/metadata-ecfd4c07d486d570
Nov 18 14:14:06.365 INFO [stdout] 
Nov 18 14:14:06.365 INFO [stdout] running 4 tests
Nov 18 14:14:06.365 INFO [stdout] test test_get_stream_info ... ok
Nov 18 14:14:06.365 INFO [stdout] test test_get_cue_sheet ... ok
Nov 18 14:14:06.367 INFO [stdout] test test_get_picture ... ok
Nov 18 14:14:06.367 INFO [stdout] test test_get_vorbis_comment ... ok
Nov 18 14:14:06.367 INFO [stdout] 
Nov 18 14:14:06.367 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 14:14:06.367 INFO [stdout] 
Nov 18 14:14:06.367 INFO [stderr]      Running /target/debug/deps/stream-d041d08d29f4c907
Nov 18 14:14:06.369 INFO [stdout] 
Nov 18 14:14:06.369 INFO [stdout] running 1 test
Nov 18 14:14:06.377 INFO [stdout] test test_decoded_md5_sum ... ok
Nov 18 14:14:06.377 INFO [stdout] 
Nov 18 14:14:06.377 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 14:14:06.377 INFO [stdout] 
Nov 18 14:14:06.377 INFO [stderr]    Doc-tests flac
Nov 18 14:14:07.161 INFO [stdout] 
Nov 18 14:14:07.162 INFO [stdout] running 9 tests
Nov 18 14:14:09.303 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_cue_sheet (line 188) ... ok
Nov 18 14:14:09.330 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_picture (line 234) ... ok
Nov 18 14:14:09.495 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_stream_info (line 85) ... ok
Nov 18 14:14:09.655 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_picture (line 254) ... ok
Nov 18 14:14:10.012 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_vorbis_comment (line 123) ... ok
Nov 18 14:14:10.240 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_stream_info (line 72) ... ok
Nov 18 14:14:10.240 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_cue_sheet (line 175) ... ok
Nov 18 14:14:10.762 INFO [stdout] test src/metadata/metadata.rs - metadata::metadata::get_vorbis_comment (line 136) ... ok
Nov 18 14:14:10.907 INFO [stdout] test src/lib.rs -  (line 10) ... ok
Nov 18 14:14:10.907 INFO [stdout] 
Nov 18 14:14:10.907 INFO [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 14:14:10.907 INFO [stdout] 
Nov 18 14:14:10.931 INFO [stderr] su: No module specific data is present
Nov 18 14:14:11.253 INFO running `"docker" "inspect" "64c88df4406a992013b1a9744c86cfe2c8341931dcacb3e28587b212c6ef59a7"`
Nov 18 14:14:11.353 INFO running `"docker" "rm" "-f" "64c88df4406a992013b1a9744c86cfe2c8341931dcacb3e28587b212c6ef59a7"`
Nov 18 14:14:11.467 INFO [stdout] 64c88df4406a992013b1a9744c86cfe2c8341931dcacb3e28587b212c6ef59a7