Dec 15 22:14:18.802 INFO testing asciicast-0.2.2 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 15 22:14:18.802 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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:14:19.156 INFO [stdout] c3b93a6db8e4370a521309a182b07e9b5c9e673f152804d43ce08a34f7ba39e5
Dec 15 22:14:19.158 INFO running `"docker" "start" "-a" "c3b93a6db8e4370a521309a182b07e9b5c9e673f152804d43ce08a34f7ba39e5"`
Dec 15 22:14:19.664 INFO [stderr] usermod: no changes
Dec 15 22:14:19.742 INFO [stderr]    Compiling asciicast v0.2.2 (/source)
Dec 15 22:14:21.298 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.61s
Dec 15 22:14:21.298 INFO [stderr] su: No module specific data is present
Dec 15 22:14:21.811 INFO running `"docker" "inspect" "c3b93a6db8e4370a521309a182b07e9b5c9e673f152804d43ce08a34f7ba39e5"`
Dec 15 22:14:22.131 INFO running `"docker" "rm" "-f" "c3b93a6db8e4370a521309a182b07e9b5c9e673f152804d43ce08a34f7ba39e5"`
Dec 15 22:14:22.343 INFO [stdout] c3b93a6db8e4370a521309a182b07e9b5c9e673f152804d43ce08a34f7ba39e5
Dec 15 22:14:22.345 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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:14:22.646 INFO [stdout] ff1d70d9d5770c7b09ca6eb0e00a95d2df58e2753f7051e92a22f27c7b82e965
Dec 15 22:14:22.648 INFO running `"docker" "start" "-a" "ff1d70d9d5770c7b09ca6eb0e00a95d2df58e2753f7051e92a22f27c7b82e965"`
Dec 15 22:14:23.267 INFO [stderr] usermod: no changes
Dec 15 22:14:23.337 INFO [stderr]    Compiling asciicast v0.2.2 (/source)
Dec 15 22:14:26.028 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.74s
Dec 15 22:14:26.033 INFO [stderr] su: No module specific data is present
Dec 15 22:14:26.259 INFO running `"docker" "inspect" "ff1d70d9d5770c7b09ca6eb0e00a95d2df58e2753f7051e92a22f27c7b82e965"`
Dec 15 22:14:26.328 INFO running `"docker" "rm" "-f" "ff1d70d9d5770c7b09ca6eb0e00a95d2df58e2753f7051e92a22f27c7b82e965"`
Dec 15 22:14:26.430 INFO [stdout] ff1d70d9d5770c7b09ca6eb0e00a95d2df58e2753f7051e92a22f27c7b82e965
Dec 15 22:14:26.432 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-2/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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:14:26.619 INFO [stdout] ae72c20c3374e25c19a406dc9b8de6e3cbfa92c40a4a99349f69ea8b3962c008
Dec 15 22:14:26.622 INFO running `"docker" "start" "-a" "ae72c20c3374e25c19a406dc9b8de6e3cbfa92c40a4a99349f69ea8b3962c008"`
Dec 15 22:14:27.127 INFO [stderr] usermod: no changes
Dec 15 22:14:27.205 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.06s
Dec 15 22:14:27.218 INFO [stderr]      Running /target/debug/deps/asciicast-e7a258d4a733f09f
Dec 15 22:14:27.220 INFO [stdout] 
Dec 15 22:14:27.220 INFO [stdout] running 5 tests
Dec 15 22:14:27.220 INFO [stdout] test entry::tests::test_serializes ... ok
Dec 15 22:14:27.220 INFO [stdout] test entry::tests::test_deserializes ... ok
Dec 15 22:14:27.221 INFO [stdout] test header::tests::test_deserializes_with_optional_data ... ok
Dec 15 22:14:27.224 INFO [stdout] test header::tests::test_serializes_env ... ok
Dec 15 22:14:27.224 INFO [stdout] test header::tests::test_serializes_with_optional_data ... ok
Dec 15 22:14:27.224 INFO [stdout] 
Dec 15 22:14:27.224 INFO [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 22:14:27.224 INFO [stdout] 
Dec 15 22:14:27.226 INFO [stderr]    Doc-tests asciicast
Dec 15 22:14:28.864 INFO [stdout] 
Dec 15 22:14:28.864 INFO [stdout] running 0 tests
Dec 15 22:14:28.864 INFO [stdout] 
Dec 15 22:14:28.864 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 22:14:28.864 INFO [stdout] 
Dec 15 22:14:28.874 INFO [stderr] su: No module specific data is present
Dec 15 22:14:29.098 INFO running `"docker" "inspect" "ae72c20c3374e25c19a406dc9b8de6e3cbfa92c40a4a99349f69ea8b3962c008"`
Dec 15 22:14:29.235 INFO running `"docker" "rm" "-f" "ae72c20c3374e25c19a406dc9b8de6e3cbfa92c40a4a99349f69ea8b3962c008"`
Dec 15 22:14:29.368 INFO [stdout] ae72c20c3374e25c19a406dc9b8de6e3cbfa92c40a4a99349f69ea8b3962c008