Oct 12 05:42:49.522 INFO testing assert_cmd-0.9.1 against master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513 for rustdoc-test-static-cling
Oct 12 05:42:49.523 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-1/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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"`
Oct 12 05:42:50.078 INFO blam! d27bf71c7e4771290825c02a29a17d6115c89a513adf2c2f0c086fb13cc84f61
Oct 12 05:42:50.079 INFO running `"docker" "start" "-a" "d27bf71c7e4771290825c02a29a17d6115c89a513adf2c2f0c086fb13cc84f61"`
Oct 12 05:42:51.896 INFO kablam! usermod: no changes
Oct 12 05:42:52.105 INFO kablam!    Compiling predicates v0.9.1
Oct 12 05:42:52.105 INFO kablam!    Compiling escargot v0.3.1
Oct 12 05:42:56.788 INFO kablam!    Compiling assert_cmd v0.9.1 (/source)
Oct 12 05:43:01.780 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 9.84s
Oct 12 05:43:01.784 INFO kablam! su: No module specific data is present
Oct 12 05:43:03.040 INFO running `"docker" "rm" "-f" "d27bf71c7e4771290825c02a29a17d6115c89a513adf2c2f0c086fb13cc84f61"`
Oct 12 05:43:03.369 INFO blam! d27bf71c7e4771290825c02a29a17d6115c89a513adf2c2f0c086fb13cc84f61
Oct 12 05:43:03.374 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-1/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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"`
Oct 12 05:43:03.839 INFO blam! cd2125ee79e13739360068443565a31a3b96bad71f2595d19ce96cc1892a3967
Oct 12 05:43:03.841 INFO running `"docker" "start" "-a" "cd2125ee79e13739360068443565a31a3b96bad71f2595d19ce96cc1892a3967"`
Oct 12 05:43:05.313 INFO kablam! usermod: no changes
Oct 12 05:43:05.512 INFO kablam!    Compiling docmatic v0.1.2
Oct 12 05:43:07.455 INFO kablam!    Compiling assert_cmd v0.9.1 (/source)
Oct 12 05:43:17.926 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 12.59s
Oct 12 05:43:18.702 INFO kablam! su: No module specific data is present
Oct 12 05:43:19.700 INFO running `"docker" "rm" "-f" "cd2125ee79e13739360068443565a31a3b96bad71f2595d19ce96cc1892a3967"`
Oct 12 05:43:20.036 INFO blam! cd2125ee79e13739360068443565a31a3b96bad71f2595d19ce96cc1892a3967
Oct 12 05:43:20.047 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-1/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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"`
Oct 12 05:43:20.493 INFO blam! ad594f70ecd6d41a16b00a149540195126ac3090e7ff5e103afffc50cb3a5e0f
Oct 12 05:43:20.495 INFO running `"docker" "start" "-a" "ad594f70ecd6d41a16b00a149540195126ac3090e7ff5e103afffc50cb3a5e0f"`
Oct 12 05:43:22.052 INFO kablam! usermod: no changes
Oct 12 05:43:22.200 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.12s
Oct 12 05:43:22.214 INFO kablam!      Running /target/debug/deps/assert_cmd-93e787e97af451ce
Oct 12 05:43:22.214 INFO blam! 
Oct 12 05:43:22.214 INFO blam! running 7 tests
Oct 12 05:43:22.214 INFO blam! test assert::test::into_output_from_pred ... ok
Oct 12 05:43:22.214 INFO blam! test assert::test::into_output_from_bytes ... ok
Oct 12 05:43:22.214 INFO blam! test assert::test::into_code_from_vec ... ok
Oct 12 05:43:22.214 INFO blam! test assert::test::into_code_from_pred ... ok
Oct 12 05:43:22.215 INFO blam! test assert::test::into_code_from_i32 ... ok
Oct 12 05:43:22.225 INFO blam! test assert::test::into_output_from_str ... ok
Oct 12 05:43:22.225 INFO kablam!      Running /target/debug/deps/bin_fixture-303a15a282856dea
Oct 12 05:43:22.225 INFO blam! test assert::test::into_code_from_array ... ok
Oct 12 05:43:22.225 INFO kablam!      Running /target/debug/deps/assert-d251c358d708b06c
Oct 12 05:43:22.225 INFO blam! 
Oct 12 05:43:22.225 INFO blam! test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 05:43:22.225 INFO blam! 
Oct 12 05:43:22.225 INFO blam! 
Oct 12 05:43:22.225 INFO blam! running 0 tests
Oct 12 05:43:22.225 INFO blam! 
Oct 12 05:43:22.225 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 05:43:22.225 INFO blam! 
Oct 12 05:43:22.228 INFO blam! 
Oct 12 05:43:22.228 INFO blam! running 3 tests
Oct 12 05:43:22.732 INFO blam! test code_example ... ok
Oct 12 05:43:22.753 INFO blam! test stderr_example ... ok
Oct 12 05:43:22.793 INFO blam! test stdout_example ... ok
Oct 12 05:43:22.793 INFO kablam!      Running /target/debug/deps/cargo-57e0211b8b21f113
Oct 12 05:43:22.793 INFO blam! 
Oct 12 05:43:22.793 INFO blam! test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 05:43:22.793 INFO blam! 
Oct 12 05:43:22.795 INFO blam! 
Oct 12 05:43:22.795 INFO blam! running 7 tests
Oct 12 05:44:22.820 INFO blam! test cargo_example ... test cargo_example has been running for over 60 seconds
Oct 12 05:44:22.820 INFO blam! test cargo_example_cache ... test cargo_example_cache has been running for over 60 seconds
Oct 12 05:44:22.820 INFO blam! test cargo_binary ... test cargo_binary has been running for over 60 seconds
Oct 12 05:44:22.821 INFO blam! test cargo_binary_with_empty_env ... test cargo_binary_with_empty_env has been running for over 60 seconds
Oct 12 05:44:22.821 INFO blam! test cargo_example_with_empty_env ... test cargo_example_with_empty_env has been running for over 60 seconds
Oct 12 05:44:22.821 INFO blam! test main_binary_with_empty_env ... test main_binary_with_empty_env has been running for over 60 seconds
Oct 12 05:44:22.822 INFO blam! test main_binary ... test main_binary has been running for over 60 seconds
Oct 12 05:45:03.845 INFO blam! test cargo_example_cache ... ok
Oct 12 05:46:23.784 INFO blam! test main_binary ... ok
Oct 12 05:46:24.988 INFO blam! test cargo_example ... ok
Oct 12 05:46:25.052 INFO blam! test cargo_binary ... ok
Oct 12 05:46:25.092 INFO blam! test cargo_binary_with_empty_env ... ok
Oct 12 05:46:25.137 INFO blam! test main_binary_with_empty_env ... ok
Oct 12 05:46:25.154 INFO blam! test cargo_example_with_empty_env ... ok
Oct 12 05:46:25.154 INFO kablam!      Running /target/debug/deps/docmatic-d3fbeab9462ed75c
Oct 12 05:46:25.154 INFO blam! 
Oct 12 05:46:25.155 INFO blam! test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 05:46:25.155 INFO blam! 
Oct 12 05:46:25.160 INFO blam! 
Oct 12 05:46:25.161 INFO blam! running 1 test
Oct 12 05:46:25.232 INFO blam! 
Oct 12 05:46:25.232 INFO blam! running 1 test
Oct 12 05:46:25.232 INFO blam! test README.md - assert::Example (line 24) ... ignored
Oct 12 05:46:25.232 INFO blam! 
Oct 12 05:46:25.232 INFO blam! test result: ok. 0 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Oct 12 05:46:25.232 INFO blam! 
Oct 12 05:46:25.236 INFO blam! test test_readme ... ok
Oct 12 05:46:25.236 INFO kablam!    Doc-tests assert_cmd
Oct 12 05:46:25.236 INFO blam! 
Oct 12 05:46:25.236 INFO blam! test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 05:46:25.236 INFO blam! 
Oct 12 05:46:29.383 INFO blam! 
Oct 12 05:46:29.383 INFO blam! running 32 tests
Oct 12 05:46:29.383 INFO blam! test src/assert.rs - assert::Assert::code (line 198) ... ignored
Oct 12 05:46:29.383 INFO blam! test src/assert.rs - assert::Assert::stderr (line 295) ... ignored
Oct 12 05:46:29.383 INFO blam! test src/assert.rs - assert::Assert::stdout (line 246) ... ignored
Oct 12 05:46:29.388 INFO blam! test src/assert.rs - assert::IntoCodePredicate (line 363) ... ignored
Oct 12 05:46:29.388 INFO blam! test src/assert.rs - assert::IntoOutputPredicate (line 436) ... ignored
Oct 12 05:46:29.388 INFO blam! test src/cargo.rs - cargo (line 25) ... ignored
Oct 12 05:46:54.936 INFO blam! test src/assert.rs - assert::OutputAssertExt (line 21) ... ok
Oct 12 05:46:59.108 INFO blam! test src/assert.rs - assert::Assert (line 72) ... ok
Oct 12 05:46:59.452 INFO blam! test src/cargo.rs - cargo::CommandCargoExt (line 66) ... ok
Oct 12 05:47:00.845 INFO blam! test src/assert.rs - assert::Assert::success (line 135) ... ok
Oct 12 05:47:02.232 INFO blam! test src/assert.rs - assert::OutputAssertExt::assert (line 38) ... ok
Oct 12 05:47:02.795 INFO blam! test src/assert.rs - assert::Assert::append_context (line 105) ... ok
Oct 12 05:47:03.525 INFO blam! test src/cargo.rs - cargo (line 13) ... ok
Oct 12 05:47:04.024 INFO blam! test src/assert.rs - assert::Assert::failure (line 168) ... ok
Oct 12 05:47:22.462 INFO blam! test src/cargo.rs - cargo::CommandCargoExt::cargo_example (line 122) ... ok
Oct 12 05:47:23.051 INFO blam! test src/cargo.rs - cargo::CommandCargoExt::cargo_bin (line 105) ... ok
Oct 12 05:47:23.113 INFO blam! test src/cargo.rs - cargo::CommandCargoExt::main_binary (line 88) ... ok
Oct 12 05:47:23.170 INFO blam! test src/cargo.rs - cargo::cargo_bin_path (line 196) ... ok
Oct 12 05:47:24.476 INFO blam! test src/cargo.rs - cargo::main_binary_path (line 172) ... ok
Oct 12 05:47:24.735 INFO blam! test src/cmd.rs - cmd::OutputOkExt (line 13) ... ok
Oct 12 05:47:24.735 INFO blam! test src/lib.rs -  (line 16) ... ignored
Oct 12 05:47:24.956 INFO blam! test src/cargo.rs - cargo::cargo_example_path (line 221) ... ok
Oct 12 05:47:25.160 INFO blam! test src/cmd.rs - cmd::OutputOkExt::ok (line 34) ... ok
Oct 12 05:47:36.544 INFO blam! test src/errors.rs - errors::OutputError::as_output (line 97) ... ok
Oct 12 05:47:37.220 INFO blam! test src/cmd.rs - cmd::OutputOkExt::unwrap (line 53) ... ok
Oct 12 05:47:37.478 INFO blam! test src/stdin.rs - stdin::StdInCommandBuilder<'a>::buffer (line 57) ... ok
Oct 12 05:47:37.736 INFO blam! test src/errors.rs - errors::OutputError (line 34) ... ok
Oct 12 05:47:37.772 INFO blam! test src/stdin.rs - stdin::CommandStdInExt::with_stdin (line 24) ... ok
Oct 12 05:47:37.786 INFO blam! test src/cmd.rs - cmd::OutputOkExt::unwrap_err (line 75) ... ok
Oct 12 05:47:38.240 INFO blam! test src/errors.rs - errors::OutputResult (line 12) ... ok
Oct 12 05:47:38.579 INFO blam! test src/stdin.rs - stdin::StdInCommand (line 123) ... ok
Oct 12 05:47:41.532 INFO blam! test src/stdin.rs - stdin::StdInCommandBuilder<'a>::path (line 87) ... ok
Oct 12 05:47:41.532 INFO blam! 
Oct 12 05:47:41.532 INFO blam! test result: ok. 25 passed; 0 failed; 7 ignored; 0 measured; 0 filtered out
Oct 12 05:47:41.532 INFO blam! 
Oct 12 05:47:41.556 INFO kablam! su: No module specific data is present
Oct 12 05:47:41.946 INFO running `"docker" "rm" "-f" "ad594f70ecd6d41a16b00a149540195126ac3090e7ff5e103afffc50cb3a5e0f"`
Oct 12 05:47:42.104 INFO blam! ad594f70ecd6d41a16b00a149540195126ac3090e7ff5e103afffc50cb3a5e0f