Dec 15 22:54:02.474 INFO testing alac-0.5.0 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 15 22:54:02.474 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 22:54:03.051 INFO [stdout] e78b0578e3adca5da996972823dfda3ed24aa83bc7940df8e0efeed5d30b37fb
Dec 15 22:54:03.053 INFO running `"docker" "start" "-a" "e78b0578e3adca5da996972823dfda3ed24aa83bc7940df8e0efeed5d30b37fb"`
Dec 15 22:54:03.681 INFO [stderr] usermod: no changes
Dec 15 22:54:03.739 INFO [stderr]    Compiling alac v0.5.0 (/source)
Dec 15 22:54:05.507 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.79s
Dec 15 22:54:05.507 INFO [stderr] su: No module specific data is present
Dec 15 22:54:05.831 INFO running `"docker" "inspect" "e78b0578e3adca5da996972823dfda3ed24aa83bc7940df8e0efeed5d30b37fb"`
Dec 15 22:54:06.007 INFO running `"docker" "rm" "-f" "e78b0578e3adca5da996972823dfda3ed24aa83bc7940df8e0efeed5d30b37fb"`
Dec 15 22:54:06.225 INFO [stdout] e78b0578e3adca5da996972823dfda3ed24aa83bc7940df8e0efeed5d30b37fb
Dec 15 22:54:06.229 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 22:54:06.606 INFO [stdout] 3273dd7f262b0336f0bb4dfe5f7b1d6a99ae3da2c8aaf748c86d965ad6a1a940
Dec 15 22:54:06.611 INFO running `"docker" "start" "-a" "3273dd7f262b0336f0bb4dfe5f7b1d6a99ae3da2c8aaf748c86d965ad6a1a940"`
Dec 15 22:54:07.335 INFO [stderr] usermod: no changes
Dec 15 22:54:07.378 INFO [stderr]    Compiling alac v0.5.0 (/source)
Dec 15 22:54:09.719 INFO [stderr] warning: static item is never used: `COMPARE_CAF_I16`
Dec 15 22:54:09.719 INFO [stderr]   --> tests/decode_comparison.rs:20:1
Dec 15 22:54:09.719 INFO [stderr]    |
Dec 15 22:54:09.719 INFO [stderr] 20 | / static COMPARE_CAF_I16: &'static [(&'static str, &'static str)] = &[
Dec 15 22:54:09.719 INFO [stderr] 21 | |     ("synth_44100_16_bit.wav", "synth_44100_16_bit_afconvert.caf"),
Dec 15 22:54:09.719 INFO [stderr] 22 | | ];
Dec 15 22:54:09.719 INFO [stderr]    | |__^
Dec 15 22:54:09.719 INFO [stderr]    |
Dec 15 22:54:09.719 INFO [stderr]    = note: #[warn(dead_code)] on by default
Dec 15 22:54:09.719 INFO [stderr] 
Dec 15 22:54:09.719 INFO [stderr] warning: static item is never used: `COMPARE_CAF_I32`
Dec 15 22:54:09.719 INFO [stderr]   --> tests/decode_comparison.rs:24:1
Dec 15 22:54:09.719 INFO [stderr]    |
Dec 15 22:54:09.719 INFO [stderr] 24 | / static COMPARE_CAF_I32: &'static [(&'static str, &'static str)] = &[
Dec 15 22:54:09.719 INFO [stderr] 25 | |     ("synth_44100_16_bit.wav", "synth_44100_16_bit_afconvert.caf"),
Dec 15 22:54:09.719 INFO [stderr] 26 | |     ("synth_44100_24_bit.wav", "synth_44100_24_bit_afconvert.caf"),
Dec 15 22:54:09.719 INFO [stderr] 27 | | ];
Dec 15 22:54:09.719 INFO [stderr]    | |__^
Dec 15 22:54:09.719 INFO [stderr] 
Dec 15 22:54:12.555 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.20s
Dec 15 22:54:12.562 INFO [stderr] su: No module specific data is present
Dec 15 22:54:13.288 INFO running `"docker" "inspect" "3273dd7f262b0336f0bb4dfe5f7b1d6a99ae3da2c8aaf748c86d965ad6a1a940"`
Dec 15 22:54:13.559 INFO running `"docker" "rm" "-f" "3273dd7f262b0336f0bb4dfe5f7b1d6a99ae3da2c8aaf748c86d965ad6a1a940"`
Dec 15 22:54:13.766 INFO [stdout] 3273dd7f262b0336f0bb4dfe5f7b1d6a99ae3da2c8aaf748c86d965ad6a1a940
Dec 15 22:54:13.772 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 22:54:14.240 INFO [stdout] eff08517bbd8f2b8af7df60aa09b1239c806978c8921e12764a5aa1498eeb00d
Dec 15 22:54:14.247 INFO running `"docker" "start" "-a" "eff08517bbd8f2b8af7df60aa09b1239c806978c8921e12764a5aa1498eeb00d"`
Dec 15 22:54:15.474 INFO [stderr] usermod: no changes
Dec 15 22:54:15.567 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Dec 15 22:54:15.567 INFO [stderr]      Running /target/debug/deps/alac-ff28d8f4785d25cd
Dec 15 22:54:15.568 INFO [stdout] 
Dec 15 22:54:15.568 INFO [stdout] running 3 tests
Dec 15 22:54:15.569 INFO [stdout] test tests::test_from_sdp_format_parameters ... ok
Dec 15 22:54:15.569 INFO [stdout] test tests::test_from_cookie ... ok
Dec 15 22:54:15.569 INFO [stdout] test bitcursor::tests::skip_to_byte ... ok
Dec 15 22:54:15.569 INFO [stdout] 
Dec 15 22:54:15.569 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 22:54:15.569 INFO [stdout] 
Dec 15 22:54:15.575 INFO [stdout] 
Dec 15 22:54:15.575 INFO [stderr]      Running /target/debug/deps/decode_comparison-0c62a59c374f5fa3
Dec 15 22:54:15.575 INFO [stdout] running 1 test
Dec 15 22:54:19.014 INFO [stdout] test mp4 ... ok
Dec 15 22:54:19.015 INFO [stderr]      Running /target/debug/deps/single_packet-dda9ab1d1552f1ca
Dec 15 22:54:19.015 INFO [stdout] 
Dec 15 22:54:19.015 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 22:54:19.015 INFO [stdout] 
Dec 15 22:54:19.015 INFO [stdout] 
Dec 15 22:54:19.015 INFO [stdout] running 1 test
Dec 15 22:54:19.043 INFO [stderr]    Doc-tests alac
Dec 15 22:54:19.043 INFO [stdout] test main ... ok
Dec 15 22:54:19.043 INFO [stdout] 
Dec 15 22:54:19.043 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 22:54:19.043 INFO [stdout] 
Dec 15 22:54:20.819 INFO [stdout] 
Dec 15 22:54:20.819 INFO [stdout] running 0 tests
Dec 15 22:54:20.819 INFO [stdout] 
Dec 15 22:54:20.819 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 22:54:20.819 INFO [stdout] 
Dec 15 22:54:20.823 INFO [stderr] su: No module specific data is present
Dec 15 22:54:21.723 INFO running `"docker" "inspect" "eff08517bbd8f2b8af7df60aa09b1239c806978c8921e12764a5aa1498eeb00d"`
Dec 15 22:54:22.051 INFO running `"docker" "rm" "-f" "eff08517bbd8f2b8af7df60aa09b1239c806978c8921e12764a5aa1498eeb00d"`
Dec 15 22:54:22.363 INFO [stdout] eff08517bbd8f2b8af7df60aa09b1239c806978c8921e12764a5aa1498eeb00d