Oct 12 05:42:47.532 INFO testing assert_cmd-0.9.1 against try#40d4795669493f1965de7c44029c69552134fe1f for rustdoc-test-static-cling
Oct 12 05:42:47.534 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-0/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-0/rustdoc-test-static-cling/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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:48.034 INFO blam! 11f184e88b9270ad69d365599d24c56ee7a723eff216da57fa533c50315affc1
Oct 12 05:42:48.035 INFO running `"docker" "start" "-a" "11f184e88b9270ad69d365599d24c56ee7a723eff216da57fa533c50315affc1"`
Oct 12 05:42:49.836 INFO kablam! usermod: no changes
Oct 12 05:42:50.034 INFO kablam!    Compiling predicates v0.9.1
Oct 12 05:42:52.120 INFO kablam!    Compiling assert_cmd v0.9.1 (/source)
Oct 12 05:42:54.921 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 5.06s
Oct 12 05:42:54.928 INFO kablam! su: No module specific data is present
Oct 12 05:42:56.441 INFO running `"docker" "rm" "-f" "11f184e88b9270ad69d365599d24c56ee7a723eff216da57fa533c50315affc1"`
Oct 12 05:42:56.796 INFO blam! 11f184e88b9270ad69d365599d24c56ee7a723eff216da57fa533c50315affc1
Oct 12 05:42:56.808 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-0/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-0/rustdoc-test-static-cling/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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:42:57.308 INFO blam! 92413a8a77d338f1b21e0745b36488442a3b2ab0e57e363fdf30fb67ddf3d8b2
Oct 12 05:42:57.310 INFO running `"docker" "start" "-a" "92413a8a77d338f1b21e0745b36488442a3b2ab0e57e363fdf30fb67ddf3d8b2"`
Oct 12 05:42:59.735 INFO kablam! usermod: no changes
Oct 12 05:42:59.980 INFO kablam!    Compiling which v2.0.0
Oct 12 05:43:01.176 INFO kablam!    Compiling docmatic v0.1.2
Oct 12 05:43:02.224 INFO kablam!    Compiling assert_cmd v0.9.1 (/source)
Oct 12 05:43:09.956 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 10.20s
Oct 12 05:43:09.973 INFO kablam! su: No module specific data is present
Oct 12 05:43:10.879 INFO running `"docker" "rm" "-f" "92413a8a77d338f1b21e0745b36488442a3b2ab0e57e363fdf30fb67ddf3d8b2"`
Oct 12 05:43:11.248 INFO blam! 92413a8a77d338f1b21e0745b36488442a3b2ab0e57e363fdf30fb67ddf3d8b2
Oct 12 05:43:11.258 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-0/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-0/rustdoc-test-static-cling/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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:11.716 INFO blam! 9345dd5cbecead5462e1e225e76d18f9677c7b559aa0952e2e3d9a4730332c14
Oct 12 05:43:11.717 INFO running `"docker" "start" "-a" "9345dd5cbecead5462e1e225e76d18f9677c7b559aa0952e2e3d9a4730332c14"`
Oct 12 05:43:12.853 INFO kablam! usermod: no changes
Oct 12 05:43:13.040 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.14s
Oct 12 05:43:13.040 INFO kablam!      Running /target/debug/deps/assert_cmd-342ee527cf90a334
Oct 12 05:43:13.051 INFO blam! 
Oct 12 05:43:13.051 INFO blam! running 7 tests
Oct 12 05:43:13.051 INFO blam! test assert::test::into_code_from_array ... ok
Oct 12 05:43:13.051 INFO blam! test assert::test::into_code_from_i32 ... ok
Oct 12 05:43:13.051 INFO blam! test assert::test::into_output_from_bytes ... ok
Oct 12 05:43:13.051 INFO blam! test assert::test::into_output_from_pred ... ok
Oct 12 05:43:13.060 INFO blam! test assert::test::into_output_from_str ... ok
Oct 12 05:43:13.060 INFO blam! test assert::test::into_code_from_pred ... ok
Oct 12 05:43:13.068 INFO blam! test assert::test::into_code_from_vec ... ok
Oct 12 05:43:13.068 INFO kablam!      Running /target/debug/deps/bin_fixture-59b576398bc1c63f
Oct 12 05:43:13.068 INFO blam! 
Oct 12 05:43:13.068 INFO blam! test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 05:43:13.068 INFO blam! 
Oct 12 05:43:13.084 INFO blam! 
Oct 12 05:43:13.084 INFO blam! running 0 tests
Oct 12 05:43:13.084 INFO blam! 
Oct 12 05:43:13.084 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 05:43:13.084 INFO blam! 
Oct 12 05:43:13.084 INFO kablam!      Running /target/debug/deps/assert-d2ec07d2ff983ddf
Oct 12 05:43:13.096 INFO blam! 
Oct 12 05:43:13.096 INFO blam! running 3 tests
Oct 12 05:43:13.416 INFO blam! test stdout_example ... ok
Oct 12 05:43:13.572 INFO blam! test code_example ... ok
Oct 12 05:43:13.626 INFO blam! test stderr_example ... ok
Oct 12 05:43:13.626 INFO kablam!      Running /target/debug/deps/cargo-4e4cdb3f450c7f3a
Oct 12 05:43:13.626 INFO blam! 
Oct 12 05:43:13.626 INFO blam! test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 05:43:13.626 INFO blam! 
Oct 12 05:43:13.632 INFO blam! 
Oct 12 05:43:13.632 INFO blam! running 7 tests
Oct 12 05:43:13.960 INFO blam! test cargo_example ... ok
Oct 12 05:43:13.987 INFO blam! test main_binary_with_empty_env ... ok
Oct 12 05:43:14.064 INFO blam! test cargo_example_with_empty_env ... ok
Oct 12 05:43:14.082 INFO blam! test cargo_binary_with_empty_env ... ok
Oct 12 05:44:13.640 INFO blam! test main_binary ... test main_binary has been running for over 60 seconds
Oct 12 05:44:13.640 INFO blam! test cargo_binary ... test cargo_binary has been running for over 60 seconds
Oct 12 05:44:13.640 INFO blam! test cargo_example_cache ... test cargo_example_cache has been running for over 60 seconds
Oct 12 05:44:36.617 INFO blam! test cargo_example_cache ... ok
Oct 12 05:45:34.516 INFO blam! test cargo_binary ... ok
Oct 12 05:45:34.552 INFO blam! test main_binary ... ok
Oct 12 05:45:34.552 INFO kablam!      Running /target/debug/deps/docmatic-27a3a735174d6beb
Oct 12 05:45:34.552 INFO blam! 
Oct 12 05:45:34.552 INFO blam! test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 05:45:34.552 INFO blam! 
Oct 12 05:45:34.552 INFO blam! 
Oct 12 05:45:34.552 INFO blam! running 1 test
Oct 12 05:45:34.580 INFO blam! 
Oct 12 05:45:34.580 INFO blam! running 1 test
Oct 12 05:45:34.580 INFO blam! test README.md - assert::Example (line 24) ... ignored
Oct 12 05:45:34.580 INFO blam! 
Oct 12 05:45:34.580 INFO blam! test result: ok. 0 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Oct 12 05:45:34.580 INFO blam! 
Oct 12 05:45:34.580 INFO blam! test test_readme ... ok
Oct 12 05:45:34.580 INFO blam! 
Oct 12 05:45:34.580 INFO blam! test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 12 05:45:34.580 INFO blam! 
Oct 12 05:45:34.584 INFO kablam!    Doc-tests assert_cmd
Oct 12 05:45:35.437 INFO blam! 
Oct 12 05:45:35.437 INFO blam! running 32 tests
Oct 12 05:45:35.437 INFO blam! test src/assert.rs - assert::Assert::code (line 198) ... ignored
Oct 12 05:45:35.437 INFO blam! test src/assert.rs - assert::Assert::stderr (line 295) ... ignored
Oct 12 05:45:35.437 INFO blam! test src/assert.rs - assert::Assert::stdout (line 246) ... ignored
Oct 12 05:45:35.437 INFO blam! test src/assert.rs - assert::IntoCodePredicate (line 363) ... ignored
Oct 12 05:45:35.437 INFO blam! test src/assert.rs - assert::IntoOutputPredicate (line 436) ... ignored
Oct 12 05:45:35.437 INFO blam! test src/cargo.rs - cargo (line 25) ... ignored
Oct 12 05:45:43.944 INFO blam! test src/assert.rs - assert::Assert (line 72) ... ok
Oct 12 05:45:44.404 INFO blam! test src/cargo.rs - cargo (line 13) ... ok
Oct 12 05:45:44.504 INFO blam! test src/assert.rs - assert::Assert::success (line 135) ... ok
Oct 12 05:45:44.540 INFO blam! test src/assert.rs - assert::OutputAssertExt::assert (line 38) ... ok
Oct 12 05:45:44.702 INFO blam! test src/cargo.rs - cargo::CommandCargoExt (line 66) ... ok
Oct 12 05:45:44.772 INFO blam! test src/assert.rs - assert::OutputAssertExt (line 21) ... ok
Oct 12 05:45:45.384 INFO blam! test src/assert.rs - assert::Assert::append_context (line 105) ... ok
Oct 12 05:45:46.116 INFO blam! test src/assert.rs - assert::Assert::failure (line 168) ... ok
Oct 12 05:45:50.444 INFO blam! test src/cargo.rs - cargo::CommandCargoExt::main_binary (line 88) ... ok
Oct 12 05:45:52.032 INFO blam! test src/cargo.rs - cargo::CommandCargoExt::cargo_bin (line 105) ... ok
Oct 12 05:45:52.641 INFO blam! test src/cmd.rs - cmd::OutputOkExt (line 13) ... ok
Oct 12 05:45:54.628 INFO blam! test src/cmd.rs - cmd::OutputOkExt::ok (line 34) ... ok
Oct 12 05:45:57.172 INFO blam! test src/cargo.rs - cargo::CommandCargoExt::cargo_example (line 122) ... ok
Oct 12 05:45:57.212 INFO blam! test src/cargo.rs - cargo::cargo_bin_path (line 196) ... ok
Oct 12 05:45:57.212 INFO blam! test src/lib.rs -  (line 16) ... ignored
Oct 12 05:45:57.284 INFO blam! test src/cargo.rs - cargo::cargo_example_path (line 221) ... ok
Oct 12 05:45:57.449 INFO blam! test src/cargo.rs - cargo::main_binary_path (line 172) ... ok
Oct 12 05:45:58.147 INFO blam! test src/cmd.rs - cmd::OutputOkExt::unwrap (line 53) ... ok
Oct 12 05:46:00.376 INFO blam! test src/errors.rs - errors::OutputError (line 34) ... ok
Oct 12 05:46:00.692 INFO blam! test src/cmd.rs - cmd::OutputOkExt::unwrap_err (line 75) ... ok
Oct 12 05:46:01.420 INFO blam! test src/errors.rs - errors::OutputError::as_output (line 97) ... ok
Oct 12 05:46:01.692 INFO blam! test src/errors.rs - errors::OutputResult (line 12) ... ok
Oct 12 05:46:01.898 INFO blam! test src/stdin.rs - stdin::CommandStdInExt::with_stdin (line 24) ... ok
Oct 12 05:46:01.960 INFO blam! test src/stdin.rs - stdin::StdInCommandBuilder<'a>::buffer (line 57) ... ok
Oct 12 05:46:02.220 INFO blam! test src/stdin.rs - stdin::StdInCommand (line 123) ... ok
Oct 12 05:46:02.306 INFO blam! test src/stdin.rs - stdin::StdInCommandBuilder<'a>::path (line 87) ... ok
Oct 12 05:46:02.306 INFO blam! 
Oct 12 05:46:02.306 INFO blam! test result: ok. 25 passed; 0 failed; 7 ignored; 0 measured; 0 filtered out
Oct 12 05:46:02.306 INFO blam! 
Oct 12 05:46:02.324 INFO kablam! su: No module specific data is present
Oct 12 05:46:02.860 INFO running `"docker" "rm" "-f" "9345dd5cbecead5462e1e225e76d18f9677c7b559aa0952e2e3d9a4730332c14"`
Oct 12 05:46:03.033 INFO blam! 9345dd5cbecead5462e1e225e76d18f9677c7b559aa0952e2e3d9a4730332c14