Dec 15 22:09:37.996 INFO testing assert_cli-0.6.3 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 15 22:09:37.996 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:09:38.447 INFO [stdout] 93136ac951d7635a402b76d5316aabfda17aebde674dd6bb050ba0b5f8694ffe
Dec 15 22:09:38.452 INFO running `"docker" "start" "-a" "93136ac951d7635a402b76d5316aabfda17aebde674dd6bb050ba0b5f8694ffe"`
Dec 15 22:09:39.471 INFO [stderr] usermod: no changes
Dec 15 22:09:39.587 INFO [stderr]    Compiling assert_cli v0.6.3 (/source)
Dec 15 22:09:41.349 INFO [stderr] warning: use of deprecated item 'failure::Error::cause': please use 'as_fail()' method instead
Dec 15 22:09:41.349 INFO [stderr]   --> src/errors.rs:80:33
Dec 15 22:09:41.349 INFO [stderr]    |
Dec 15 22:09:41.349 INFO [stderr] 80 |         self.cause.as_ref().map(failure::Error::cause)
Dec 15 22:09:41.349 INFO [stderr]    |                                 ^^^^^^^^^^^^^^^^^^^^^
Dec 15 22:09:41.349 INFO [stderr]    |
Dec 15 22:09:41.349 INFO [stderr]    = note: #[warn(deprecated)] on by default
Dec 15 22:09:41.349 INFO [stderr] 
Dec 15 22:09:41.353 INFO [stderr] warning: use of deprecated item 'failure::Error::cause': please use 'as_fail()' method instead
Dec 15 22:09:41.353 INFO [stderr]    --> src/errors.rs:125:33
Dec 15 22:09:41.353 INFO [stderr]     |
Dec 15 22:09:41.353 INFO [stderr] 125 |         self.cause.as_ref().map(failure::Error::cause)
Dec 15 22:09:41.353 INFO [stderr]     |                                 ^^^^^^^^^^^^^^^^^^^^^
Dec 15 22:09:41.353 INFO [stderr] 
Dec 15 22:09:41.359 INFO [stderr] warning: use of deprecated item 'failure::Error::cause': please use 'as_fail()' method instead
Dec 15 22:09:41.359 INFO [stderr]    --> src/errors.rs:184:33
Dec 15 22:09:41.359 INFO [stderr]     |
Dec 15 22:09:41.359 INFO [stderr] 184 |         self.cause.as_ref().map(failure::Error::cause)
Dec 15 22:09:41.359 INFO [stderr]     |                                 ^^^^^^^^^^^^^^^^^^^^^
Dec 15 22:09:41.359 INFO [stderr] 
Dec 15 22:09:41.412 INFO [stderr] warning: use of deprecated item 'failure::Fail::causes': please use the 'iter_chain()' method instead
Dec 15 22:09:41.412 INFO [stderr]    --> src/assert.rs:441:44
Dec 15 22:09:41.412 INFO [stderr]     |
Dec 15 22:09:41.412 INFO [stderr] 441 |             panic!(Self::format_causes(err.causes()));
Dec 15 22:09:41.412 INFO [stderr]     |                                            ^^^^^^
Dec 15 22:09:41.412 INFO [stderr] 
Dec 15 22:09:41.495 INFO [stderr] warning: use of deprecated item 'failure::Error::cause': please use 'as_fail()' method instead
Dec 15 22:09:41.495 INFO [stderr]    --> src/output.rs:539:33
Dec 15 22:09:41.495 INFO [stderr]     |
Dec 15 22:09:41.495 INFO [stderr] 539 |         self.cause.as_ref().map(failure::Error::cause)
Dec 15 22:09:41.495 INFO [stderr]     |                                 ^^^^^^^^^^^^^^^^^^^^^
Dec 15 22:09:41.495 INFO [stderr] 
Dec 15 22:09:45.319 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.80s
Dec 15 22:09:45.319 INFO [stderr] su: No module specific data is present
Dec 15 22:09:45.737 INFO running `"docker" "inspect" "93136ac951d7635a402b76d5316aabfda17aebde674dd6bb050ba0b5f8694ffe"`
Dec 15 22:09:46.012 INFO running `"docker" "rm" "-f" "93136ac951d7635a402b76d5316aabfda17aebde674dd6bb050ba0b5f8694ffe"`
Dec 15 22:09:46.205 INFO [stdout] 93136ac951d7635a402b76d5316aabfda17aebde674dd6bb050ba0b5f8694ffe
Dec 15 22:09:46.208 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:09:46.535 INFO [stdout] a2aa03f9bcc809d15ea7dd2cc5fbf76b1d319fc58071e291d3692a024d4e0e26
Dec 15 22:09:46.541 INFO running `"docker" "start" "-a" "a2aa03f9bcc809d15ea7dd2cc5fbf76b1d319fc58071e291d3692a024d4e0e26"`
Dec 15 22:09:47.349 INFO [stderr] usermod: no changes
Dec 15 22:09:47.439 INFO [stderr]    Compiling docmatic v0.1.2
Dec 15 22:09:49.337 INFO [stderr]    Compiling assert_cli v0.6.3 (/source)
Dec 15 22:09:53.479 INFO [stderr] warning: use of deprecated item 'failure::Error::cause': please use 'as_fail()' method instead
Dec 15 22:09:53.479 INFO [stderr]   --> src/errors.rs:80:33
Dec 15 22:09:53.479 INFO [stderr]    |
Dec 15 22:09:53.479 INFO [stderr] 80 |         self.cause.as_ref().map(failure::Error::cause)
Dec 15 22:09:53.479 INFO [stderr]    |                                 ^^^^^^^^^^^^^^^^^^^^^
Dec 15 22:09:53.479 INFO [stderr]    |
Dec 15 22:09:53.479 INFO [stderr]    = note: #[warn(deprecated)] on by default
Dec 15 22:09:53.479 INFO [stderr] 
Dec 15 22:09:53.479 INFO [stderr] warning: use of deprecated item 'failure::Error::cause': please use 'as_fail()' method instead
Dec 15 22:09:53.479 INFO [stderr]    --> src/errors.rs:125:33
Dec 15 22:09:53.479 INFO [stderr]     |
Dec 15 22:09:53.479 INFO [stderr] 125 |         self.cause.as_ref().map(failure::Error::cause)
Dec 15 22:09:53.479 INFO [stderr]     |                                 ^^^^^^^^^^^^^^^^^^^^^
Dec 15 22:09:53.479 INFO [stderr] 
Dec 15 22:09:53.479 INFO [stderr] warning: use of deprecated item 'failure::Error::cause': please use 'as_fail()' method instead
Dec 15 22:09:53.479 INFO [stderr]    --> src/errors.rs:184:33
Dec 15 22:09:53.479 INFO [stderr]     |
Dec 15 22:09:53.479 INFO [stderr] 184 |         self.cause.as_ref().map(failure::Error::cause)
Dec 15 22:09:53.479 INFO [stderr]     |                                 ^^^^^^^^^^^^^^^^^^^^^
Dec 15 22:09:53.479 INFO [stderr] 
Dec 15 22:09:53.573 INFO [stderr] warning: use of deprecated item 'failure::Fail::causes': please use the 'iter_chain()' method instead
Dec 15 22:09:53.573 INFO [stderr]    --> src/assert.rs:441:44
Dec 15 22:09:53.573 INFO [stderr]     |
Dec 15 22:09:53.573 INFO [stderr] 441 |             panic!(Self::format_causes(err.causes()));
Dec 15 22:09:53.574 INFO [stderr]     |                                            ^^^^^^
Dec 15 22:09:53.574 INFO [stderr] 
Dec 15 22:09:53.971 INFO [stderr] warning: use of deprecated item 'failure::Error::cause': please use 'as_fail()' method instead
Dec 15 22:09:53.971 INFO [stderr]    --> src/output.rs:539:33
Dec 15 22:09:53.971 INFO [stderr]     |
Dec 15 22:09:53.971 INFO [stderr] 539 |         self.cause.as_ref().map(failure::Error::cause)
Dec 15 22:09:53.971 INFO [stderr]     |                                 ^^^^^^^^^^^^^^^^^^^^^
Dec 15 22:09:53.971 INFO [stderr] 
Dec 15 22:09:56.220 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 8.85s
Dec 15 22:09:56.226 INFO [stderr] su: No module specific data is present
Dec 15 22:09:56.625 INFO running `"docker" "inspect" "a2aa03f9bcc809d15ea7dd2cc5fbf76b1d319fc58071e291d3692a024d4e0e26"`
Dec 15 22:09:56.752 INFO running `"docker" "rm" "-f" "a2aa03f9bcc809d15ea7dd2cc5fbf76b1d319fc58071e291d3692a024d4e0e26"`
Dec 15 22:09:56.860 INFO [stdout] a2aa03f9bcc809d15ea7dd2cc5fbf76b1d319fc58071e291d3692a024d4e0e26
Dec 15 22:09:56.861 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:09:57.077 INFO [stdout] bfa1a2f1775f0ce2fd5969913bb1f85d314541bbff32274c39449859a8ed7d62
Dec 15 22:09:57.084 INFO running `"docker" "start" "-a" "bfa1a2f1775f0ce2fd5969913bb1f85d314541bbff32274c39449859a8ed7d62"`
Dec 15 22:09:58.054 INFO [stderr] usermod: no changes
Dec 15 22:09:58.155 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.06s
Dec 15 22:09:58.158 INFO [stdout] 
Dec 15 22:09:58.158 INFO [stdout] running 19 tests
Dec 15 22:09:58.158 INFO [stderr]      Running /target/debug/deps/assert_cli-1ad9afbe0cda8ec6
Dec 15 22:09:58.171 INFO [stdout] test assert::test::main_binary_default_uses_active_profile ... ok
Dec 15 22:09:58.171 INFO [stdout] test assert::test::in_place_mod ... ok
Dec 15 22:09:58.173 INFO [stdout] test assert::test::in_place_mod3 ... ok
Dec 15 22:09:58.173 INFO [stdout] test assert::test::cargo_binary_default_uses_active_profile ... ok
Dec 15 22:09:58.175 INFO [stdout] test assert::test::take_string_i32 ... ok
Dec 15 22:09:58.183 INFO [stdout] test diff::tests::added_first_line_diff ... ok
Dec 15 22:09:58.195 INFO [stdout] test assert::test::take_slice_of_strings ... ok
Dec 15 22:09:58.195 INFO [stdout] test assert::test::take_ownership ... ok
Dec 15 22:09:58.195 INFO [stdout] test assert::test::in_place_mod2 ... ok
Dec 15 22:09:58.195 INFO [stdout] test diff::tests::basic_diff ... ok
Dec 15 22:09:58.195 INFO [stdout] test macros::test::flatten_escaped ... ok
Dec 15 22:09:58.195 INFO [stdout] test macros::test::flatten_unquoted ... ok
Dec 15 22:09:58.195 INFO [stdout] test macros::test::flatten_quoted ... ok
Dec 15 22:09:58.195 INFO [stdout] test assert::test::take_slice_of_strs ... ok
Dec 15 22:09:58.195 INFO [stdout] test output::test_find_subsequence ... ok
Dec 15 22:09:58.203 INFO [stdout] test diff::tests::multiline_diff ... ok
Dec 15 22:09:58.203 INFO [stdout] test assert::test::empty_env ... ok
Dec 15 22:09:58.215 INFO [stdout] test assert::test::take_slice ... ok
Dec 15 22:09:58.215 INFO [stdout] test assert::test::take_vec ... ok
Dec 15 22:09:58.215 INFO [stdout] 
Dec 15 22:09:58.215 INFO [stdout] test result: ok. 19 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 22:09:58.215 INFO [stdout] 
Dec 15 22:09:58.215 INFO [stdout] 
Dec 15 22:09:58.215 INFO [stdout] running 0 tests
Dec 15 22:09:58.215 INFO [stdout] 
Dec 15 22:09:58.215 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 22:09:58.215 INFO [stdout] 
Dec 15 22:09:58.215 INFO [stderr]      Running /target/debug/deps/assert_fixture-9410af0242bc09e1
Dec 15 22:09:58.215 INFO [stderr]      Running /target/debug/deps/cargo-fb1bb26f69fa7a0e
Dec 15 22:09:58.215 INFO [stdout] 
Dec 15 22:09:58.215 INFO [stdout] running 2 tests
Dec 15 22:09:58.359 INFO [stdout] test main_binary ... ok
Dec 15 22:09:58.372 INFO [stdout] test cargo_binary ... ok
Dec 15 22:09:58.372 INFO [stdout] 
Dec 15 22:09:58.372 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 22:09:58.372 INFO [stdout] 
Dec 15 22:09:58.376 INFO [stderr]      Running /target/debug/deps/docmatic-74be1b0e7ce2b522
Dec 15 22:09:58.376 INFO [stdout] 
Dec 15 22:09:58.376 INFO [stdout] running 1 test
Dec 15 22:09:58.407 INFO [stdout] 
Dec 15 22:09:58.407 INFO [stdout] running 0 tests
Dec 15 22:09:58.407 INFO [stdout] 
Dec 15 22:09:58.407 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 22:09:58.407 INFO [stdout] 
Dec 15 22:09:58.416 INFO [stdout] test test_readme ... ok
Dec 15 22:09:58.416 INFO [stdout] 
Dec 15 22:09:58.416 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 22:09:58.416 INFO [stdout] 
Dec 15 22:09:58.421 INFO [stderr]    Doc-tests assert_cli
Dec 15 22:10:01.444 INFO [stdout] 
Dec 15 22:10:01.444 INFO [stdout] running 32 tests
Dec 15 22:10:23.751 INFO [stdout] test src/assert.rs - assert::Assert::command (line 110) ... ok
Dec 15 22:10:25.283 INFO [stdout] test src/assert.rs - assert::Assert::current_dir (line 162) ... ok
Dec 15 22:10:30.255 INFO [stdout] test src/assert.rs - assert::Assert::and (line 215) ... ok
Dec 15 22:10:30.615 INFO [stdout] test src/assert.rs - assert::Assert::ignore_status (line 292) ... ok
Dec 15 22:10:31.103 INFO [stdout] test src/assert.rs - assert::Assert::fails_with (line 270) ... ok
Dec 15 22:10:31.295 INFO [stdout] test src/assert.rs - assert::Assert::stderr (line 331) ... ok
Dec 15 22:10:32.402 INFO [stdout] test src/assert.rs - assert::Assert::execute (line 351) ... ok
Dec 15 22:10:32.959 INFO [stdout] test src/assert.rs - assert::Assert::fails (line 252) ... ok
Dec 15 22:10:49.463 INFO [stdout] test src/assert.rs - assert::Assert::stdout (line 313) ... ok
Dec 15 22:10:50.587 INFO [stdout] test src/assert.rs - assert::Assert::stdin (line 145) ... ok
Dec 15 22:10:53.731 INFO [stdout] test src/assert.rs - assert::Assert::with_args (line 127) ... ok
Dec 15 22:10:57.015 INFO [stdout] test src/assert.rs - assert::Assert::succeeds (line 232) ... ok
Dec 15 22:10:58.403 INFO [stdout] test src/assert.rs - assert::OutputAssertionBuilder::doesnt_contain (line 501) ... ok
Dec 15 22:10:58.799 INFO [stdout] test src/assert.rs - assert::Assert::with_env (line 180) ... ok
Dec 15 22:11:01.113 INFO [stdout] test src/assert.rs - assert::Assert::unwrap (line 432) ... ok
Dec 15 22:11:01.779 INFO [stdout] test src/assert.rs - assert::OutputAssertionBuilder::contains (line 467) ... ok
Dec 15 22:11:11.723 INFO [stdout] test src/assert.rs - assert::OutputAssertionBuilder::isnt (line 518) ... ok
Dec 15 22:11:13.647 INFO [stdout] test src/assert.rs - assert::OutputAssertionBuilder::is (line 484) ... ok
Dec 15 22:11:16.819 INFO [stdout] test src/assert.rs - assert::OutputAssertionBuilder::satisfies (line 535) ... ok
Dec 15 22:11:22.551 INFO [stdout] test src/lib.rs -  (line 45) ... ok
Dec 15 22:11:23.575 INFO [stdout] test src/lib.rs -  (line 110) ... ok
Dec 15 22:11:24.483 INFO [stdout] test src/lib.rs -  (line 27) ... ok
Dec 15 22:11:26.203 INFO [stdout] test src/lib.rs -  (line 65) ... ok
Dec 15 22:11:26.831 INFO [stdout] test src/lib.rs -  (line 19) ... ok
Dec 15 22:11:37.459 INFO [stdout] test src/lib.rs -  (line 9) ... ok
Dec 15 22:11:38.139 INFO [stdout] test src/lib.rs -  (line 87) ... ok
Dec 15 22:11:43.459 INFO [stdout] test src/macros.rs - assert_cmd (line 20) ... ok
Dec 15 22:11:44.143 INFO [stdout] test src/output.rs - output::Output::doesnt_contain (line 236) ... ok
Dec 15 22:11:45.135 INFO [stdout] test src/output.rs - output::Output::satisfies (line 276) ... ok
Dec 15 22:11:45.315 INFO [stdout] test src/output.rs - output::Output::isnt (line 256) ... ok
Dec 15 22:11:45.456 INFO [stdout] test src/output.rs - output::Output::is (line 216) ... ok
Dec 15 22:11:45.478 INFO [stdout] test src/output.rs - output::Output::contains (line 196) ... ok
Dec 15 22:11:45.478 INFO [stdout] 
Dec 15 22:11:45.479 INFO [stdout] test result: ok. 32 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 22:11:45.479 INFO [stdout] 
Dec 15 22:11:45.506 INFO [stderr] su: No module specific data is present
Dec 15 22:11:45.834 INFO running `"docker" "inspect" "bfa1a2f1775f0ce2fd5969913bb1f85d314541bbff32274c39449859a8ed7d62"`
Dec 15 22:11:45.940 INFO running `"docker" "rm" "-f" "bfa1a2f1775f0ce2fd5969913bb1f85d314541bbff32274c39449859a8ed7d62"`
Dec 15 22:11:46.036 INFO [stdout] bfa1a2f1775f0ce2fd5969913bb1f85d314541bbff32274c39449859a8ed7d62