Nov 18 20:20:07.368 INFO testing assert_cli-0.6.3 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 18 20:20:07.368 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 18 20:20:07.844 INFO [stdout] 1a07b0a1877c21b979c1fc1ffb7f180f6496a81d435fcd0f72b6a6c4d2299623
Nov 18 20:20:07.846 INFO running `"docker" "start" "-a" "1a07b0a1877c21b979c1fc1ffb7f180f6496a81d435fcd0f72b6a6c4d2299623"`
Nov 18 20:20:08.595 INFO [stderr] usermod: no changes
Nov 18 20:20:08.703 INFO [stderr]    Compiling assert_cli v0.6.3 (/source)
Nov 18 20:20:10.026 INFO [stderr] warning: use of deprecated item 'failure::Error::cause': please use 'as_fail()' method instead
Nov 18 20:20:10.026 INFO [stderr]   --> src/errors.rs:80:33
Nov 18 20:20:10.026 INFO [stderr]    |
Nov 18 20:20:10.026 INFO [stderr] 80 |         self.cause.as_ref().map(failure::Error::cause)
Nov 18 20:20:10.026 INFO [stderr]    |                                 ^^^^^^^^^^^^^^^^^^^^^
Nov 18 20:20:10.026 INFO [stderr]    |
Nov 18 20:20:10.026 INFO [stderr]    = note: #[warn(deprecated)] on by default
Nov 18 20:20:10.026 INFO [stderr] 
Nov 18 20:20:10.026 INFO [stderr] warning: use of deprecated item 'failure::Error::cause': please use 'as_fail()' method instead
Nov 18 20:20:10.026 INFO [stderr]    --> src/errors.rs:125:33
Nov 18 20:20:10.026 INFO [stderr]     |
Nov 18 20:20:10.026 INFO [stderr] 125 |         self.cause.as_ref().map(failure::Error::cause)
Nov 18 20:20:10.026 INFO [stderr]     |                                 ^^^^^^^^^^^^^^^^^^^^^
Nov 18 20:20:10.026 INFO [stderr] 
Nov 18 20:20:10.032 INFO [stderr] warning: use of deprecated item 'failure::Error::cause': please use 'as_fail()' method instead
Nov 18 20:20:10.032 INFO [stderr]    --> src/errors.rs:184:33
Nov 18 20:20:10.032 INFO [stderr]     |
Nov 18 20:20:10.032 INFO [stderr] 184 |         self.cause.as_ref().map(failure::Error::cause)
Nov 18 20:20:10.032 INFO [stderr]     |                                 ^^^^^^^^^^^^^^^^^^^^^
Nov 18 20:20:10.032 INFO [stderr] 
Nov 18 20:20:10.067 INFO [stderr] warning: use of deprecated item 'failure::Fail::causes': please use the 'iter_chain()' method instead
Nov 18 20:20:10.067 INFO [stderr]    --> src/assert.rs:441:44
Nov 18 20:20:10.067 INFO [stderr]     |
Nov 18 20:20:10.067 INFO [stderr] 441 |             panic!(Self::format_causes(err.causes()));
Nov 18 20:20:10.067 INFO [stderr]     |                                            ^^^^^^
Nov 18 20:20:10.067 INFO [stderr] 
Nov 18 20:20:10.164 INFO [stderr] warning: use of deprecated item 'failure::Error::cause': please use 'as_fail()' method instead
Nov 18 20:20:10.164 INFO [stderr]    --> src/output.rs:539:33
Nov 18 20:20:10.164 INFO [stderr]     |
Nov 18 20:20:10.164 INFO [stderr] 539 |         self.cause.as_ref().map(failure::Error::cause)
Nov 18 20:20:10.164 INFO [stderr]     |                                 ^^^^^^^^^^^^^^^^^^^^^
Nov 18 20:20:10.164 INFO [stderr] 
Nov 18 20:20:13.403 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.78s
Nov 18 20:20:13.405 INFO [stderr] su: No module specific data is present
Nov 18 20:20:14.239 INFO running `"docker" "inspect" "1a07b0a1877c21b979c1fc1ffb7f180f6496a81d435fcd0f72b6a6c4d2299623"`
Nov 18 20:20:14.535 INFO running `"docker" "rm" "-f" "1a07b0a1877c21b979c1fc1ffb7f180f6496a81d435fcd0f72b6a6c4d2299623"`
Nov 18 20:20:14.847 INFO [stdout] 1a07b0a1877c21b979c1fc1ffb7f180f6496a81d435fcd0f72b6a6c4d2299623
Nov 18 20:20:14.852 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 18 20:20:15.227 INFO [stdout] 5327191fa6d20e3f1ad84a7c101c8185b7bf65dbf25dec4e05ba80a8ae73d050
Nov 18 20:20:15.230 INFO running `"docker" "start" "-a" "5327191fa6d20e3f1ad84a7c101c8185b7bf65dbf25dec4e05ba80a8ae73d050"`
Nov 18 20:20:16.330 INFO [stderr] usermod: no changes
Nov 18 20:20:16.439 INFO [stderr]    Compiling docmatic v0.1.2
Nov 18 20:20:18.181 INFO [stderr]    Compiling assert_cli v0.6.3 (/source)
Nov 18 20:20:21.067 INFO [stderr] warning: use of deprecated item 'failure::Error::cause': please use 'as_fail()' method instead
Nov 18 20:20:21.067 INFO [stderr]   --> src/errors.rs:80:33
Nov 18 20:20:21.067 INFO [stderr]    |
Nov 18 20:20:21.067 INFO [stderr] 80 |         self.cause.as_ref().map(failure::Error::cause)
Nov 18 20:20:21.067 INFO [stderr]    |                                 ^^^^^^^^^^^^^^^^^^^^^
Nov 18 20:20:21.067 INFO [stderr]    |
Nov 18 20:20:21.067 INFO [stderr]    = note: #[warn(deprecated)] on by default
Nov 18 20:20:21.067 INFO [stderr] 
Nov 18 20:20:21.067 INFO [stderr] warning: use of deprecated item 'failure::Error::cause': please use 'as_fail()' method instead
Nov 18 20:20:21.067 INFO [stderr]    --> src/errors.rs:125:33
Nov 18 20:20:21.067 INFO [stderr]     |
Nov 18 20:20:21.067 INFO [stderr] 125 |         self.cause.as_ref().map(failure::Error::cause)
Nov 18 20:20:21.067 INFO [stderr]     |                                 ^^^^^^^^^^^^^^^^^^^^^
Nov 18 20:20:21.067 INFO [stderr] 
Nov 18 20:20:21.075 INFO [stderr] warning: use of deprecated item 'failure::Error::cause': please use 'as_fail()' method instead
Nov 18 20:20:21.075 INFO [stderr]    --> src/errors.rs:184:33
Nov 18 20:20:21.075 INFO [stderr]     |
Nov 18 20:20:21.075 INFO [stderr] 184 |         self.cause.as_ref().map(failure::Error::cause)
Nov 18 20:20:21.075 INFO [stderr]     |                                 ^^^^^^^^^^^^^^^^^^^^^
Nov 18 20:20:21.075 INFO [stderr] 
Nov 18 20:20:21.122 INFO [stderr] warning: use of deprecated item 'failure::Fail::causes': please use the 'iter_chain()' method instead
Nov 18 20:20:21.122 INFO [stderr]    --> src/assert.rs:441:44
Nov 18 20:20:21.122 INFO [stderr]     |
Nov 18 20:20:21.122 INFO [stderr] 441 |             panic!(Self::format_causes(err.causes()));
Nov 18 20:20:21.122 INFO [stderr]     |                                            ^^^^^^
Nov 18 20:20:21.122 INFO [stderr] 
Nov 18 20:20:21.258 INFO [stderr] warning: use of deprecated item 'failure::Error::cause': please use 'as_fail()' method instead
Nov 18 20:20:21.266 INFO [stderr]    --> src/output.rs:539:33
Nov 18 20:20:21.267 INFO [stderr]     |
Nov 18 20:20:21.267 INFO [stderr] 539 |         self.cause.as_ref().map(failure::Error::cause)
Nov 18 20:20:21.268 INFO [stderr]     |                                 ^^^^^^^^^^^^^^^^^^^^^
Nov 18 20:20:21.268 INFO [stderr] 
Nov 18 20:20:23.179 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.82s
Nov 18 20:20:23.183 INFO [stderr] su: No module specific data is present
Nov 18 20:20:24.187 INFO running `"docker" "inspect" "5327191fa6d20e3f1ad84a7c101c8185b7bf65dbf25dec4e05ba80a8ae73d050"`
Nov 18 20:20:24.418 INFO running `"docker" "rm" "-f" "5327191fa6d20e3f1ad84a7c101c8185b7bf65dbf25dec4e05ba80a8ae73d050"`
Nov 18 20:20:24.721 INFO [stdout] 5327191fa6d20e3f1ad84a7c101c8185b7bf65dbf25dec4e05ba80a8ae73d050
Nov 18 20:20:24.723 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 18 20:20:25.145 INFO [stdout] fea5189fc24982356374617921129a3ddd7ed5a2c1ed1e23b4fbfd8e9ddc8e6a
Nov 18 20:20:25.150 INFO running `"docker" "start" "-a" "fea5189fc24982356374617921129a3ddd7ed5a2c1ed1e23b4fbfd8e9ddc8e6a"`
Nov 18 20:20:26.115 INFO [stderr] usermod: no changes
Nov 18 20:20:26.223 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.07s
Nov 18 20:20:26.224 INFO [stdout] 
Nov 18 20:20:26.224 INFO [stderr]      Running /target/debug/deps/assert_cli-2085e9f9993e2f69
Nov 18 20:20:26.224 INFO [stdout] running 19 tests
Nov 18 20:20:26.231 INFO [stdout] test assert::test::cargo_binary_default_uses_active_profile ... ok
Nov 18 20:20:26.231 INFO [stdout] test assert::test::in_place_mod ... ok
Nov 18 20:20:26.232 INFO [stdout] test assert::test::main_binary_default_uses_active_profile ... ok
Nov 18 20:20:26.237 INFO [stdout] test assert::test::in_place_mod3 ... ok
Nov 18 20:20:26.237 INFO [stdout] test assert::test::empty_env ... ok
Nov 18 20:20:26.238 INFO [stdout] test diff::tests::added_first_line_diff ... ok
Nov 18 20:20:26.244 INFO [stdout] test assert::test::take_ownership ... ok
Nov 18 20:20:26.244 INFO [stdout] test assert::test::take_slice ... ok
Nov 18 20:20:26.244 INFO [stdout] test diff::tests::basic_diff ... ok
Nov 18 20:20:26.251 INFO [stdout] test macros::test::flatten_escaped ... ok
Nov 18 20:20:26.251 INFO [stdout] test macros::test::flatten_quoted ... ok
Nov 18 20:20:26.255 INFO [stdout] test assert::test::take_string_i32 ... ok
Nov 18 20:20:26.256 INFO [stdout] test assert::test::in_place_mod2 ... ok
Nov 18 20:20:26.256 INFO [stdout] test assert::test::take_slice_of_strings ... ok
Nov 18 20:20:26.256 INFO [stdout] test diff::tests::multiline_diff ... ok
Nov 18 20:20:26.257 INFO [stdout] test output::test_find_subsequence ... ok
Nov 18 20:20:26.257 INFO [stdout] test assert::test::take_slice_of_strs ... ok
Nov 18 20:20:26.257 INFO [stdout] test macros::test::flatten_unquoted ... ok
Nov 18 20:20:26.259 INFO [stdout] test assert::test::take_vec ... ok
Nov 18 20:20:26.259 INFO [stdout] 
Nov 18 20:20:26.260 INFO [stdout] test result: ok. 19 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 20:20:26.260 INFO [stdout] 
Nov 18 20:20:26.268 INFO [stderr]      Running /target/debug/deps/assert_fixture-1310645895605200
Nov 18 20:20:26.279 INFO [stderr]      Running /target/debug/deps/cargo-b88ce2837ce3edb5
Nov 18 20:20:26.279 INFO [stdout] 
Nov 18 20:20:26.280 INFO [stdout] running 0 tests
Nov 18 20:20:26.280 INFO [stdout] 
Nov 18 20:20:26.280 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 20:20:26.280 INFO [stdout] 
Nov 18 20:20:26.283 INFO [stdout] 
Nov 18 20:20:26.283 INFO [stdout] running 2 tests
Nov 18 20:20:26.381 INFO [stdout] test cargo_binary ... ok
Nov 18 20:20:26.411 INFO [stdout] test main_binary ... ok
Nov 18 20:20:26.412 INFO [stderr]      Running /target/debug/deps/docmatic-06e58dd1d6c9f7cb
Nov 18 20:20:26.412 INFO [stdout] 
Nov 18 20:20:26.412 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 20:20:26.413 INFO [stdout] 
Nov 18 20:20:26.413 INFO [stdout] 
Nov 18 20:20:26.413 INFO [stdout] running 1 test
Nov 18 20:20:26.440 INFO [stdout] 
Nov 18 20:20:26.440 INFO [stdout] running 0 tests
Nov 18 20:20:26.441 INFO [stdout] 
Nov 18 20:20:26.441 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 20:20:26.442 INFO [stdout] 
Nov 18 20:20:26.442 INFO [stdout] test test_readme ... ok
Nov 18 20:20:26.442 INFO [stdout] 
Nov 18 20:20:26.443 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 20:20:26.443 INFO [stdout] 
Nov 18 20:20:26.443 INFO [stderr]    Doc-tests assert_cli
Nov 18 20:20:28.775 INFO [stdout] 
Nov 18 20:20:28.775 INFO [stdout] running 32 tests
Nov 18 20:20:42.479 INFO [stdout] test src/assert.rs - assert::Assert::command (line 110) ... ok
Nov 18 20:20:46.012 INFO [stdout] test src/assert.rs - assert::Assert::and (line 215) ... ok
Nov 18 20:20:47.779 INFO [stdout] test src/assert.rs - assert::Assert::ignore_status (line 292) ... ok
Nov 18 20:20:48.271 INFO [stdout] test src/assert.rs - assert::Assert::current_dir (line 162) ... ok
Nov 18 20:20:48.579 INFO [stdout] test src/assert.rs - assert::Assert::execute (line 351) ... ok
Nov 18 20:20:48.859 INFO [stdout] test src/assert.rs - assert::Assert::stderr (line 331) ... ok
Nov 18 20:20:49.087 INFO [stdout] test src/assert.rs - assert::Assert::fails (line 252) ... ok
Nov 18 20:20:50.236 INFO [stdout] test src/assert.rs - assert::Assert::fails_with (line 270) ... ok
Nov 18 20:21:03.179 INFO [stdout] test src/assert.rs - assert::Assert::stdin (line 145) ... ok
Nov 18 20:21:08.027 INFO [stdout] test src/assert.rs - assert::Assert::succeeds (line 232) ... ok
Nov 18 20:21:08.307 INFO [stdout] test src/assert.rs - assert::Assert::unwrap (line 432) ... ok
Nov 18 20:21:09.479 INFO [stdout] test src/assert.rs - assert::OutputAssertionBuilder::contains (line 467) ... ok
Nov 18 20:21:09.951 INFO [stdout] test src/assert.rs - assert::Assert::with_env (line 180) ... ok
Nov 18 20:21:09.963 INFO [stdout] test src/assert.rs - assert::Assert::stdout (line 313) ... ok
Nov 18 20:21:10.811 INFO [stdout] test src/assert.rs - assert::Assert::with_args (line 127) ... ok
Nov 18 20:21:12.030 INFO [stdout] test src/assert.rs - assert::OutputAssertionBuilder::doesnt_contain (line 501) ... ok
Nov 18 20:21:14.491 INFO [stdout] test src/assert.rs - assert::OutputAssertionBuilder::is (line 484) ... ok
Nov 18 20:21:22.483 INFO [stdout] test src/lib.rs -  (line 27) ... ok
Nov 18 20:21:23.007 INFO [stdout] test src/assert.rs - assert::OutputAssertionBuilder::isnt (line 518) ... ok
Nov 18 20:21:23.660 INFO [stdout] test src/lib.rs -  (line 45) ... ok
Nov 18 20:21:24.539 INFO [stdout] test src/assert.rs - assert::OutputAssertionBuilder::satisfies (line 535) ... ok
Nov 18 20:21:25.991 INFO [stdout] test src/lib.rs -  (line 110) ... ok
Nov 18 20:21:26.091 INFO [stdout] test src/lib.rs -  (line 19) ... ok
Nov 18 20:21:27.635 INFO [stdout] test src/lib.rs -  (line 65) ... ok
Nov 18 20:21:30.228 INFO [stdout] test src/lib.rs -  (line 87) ... ok
Nov 18 20:21:34.474 INFO [stdout] test src/lib.rs -  (line 9) ... ok
Nov 18 20:21:34.552 INFO [stdout] test src/output.rs - output::Output::contains (line 196) ... ok
Nov 18 20:21:36.059 INFO [stdout] test src/output.rs - output::Output::doesnt_contain (line 236) ... ok
Nov 18 20:21:36.355 INFO [stdout] test src/macros.rs - assert_cmd (line 20) ... ok
Nov 18 20:21:36.607 INFO [stdout] test src/output.rs - output::Output::is (line 216) ... ok
Nov 18 20:21:37.327 INFO [stdout] test src/output.rs - output::Output::isnt (line 256) ... ok
Nov 18 20:21:37.806 INFO [stdout] test src/output.rs - output::Output::satisfies (line 276) ... ok
Nov 18 20:21:37.807 INFO [stdout] 
Nov 18 20:21:37.807 INFO [stdout] test result: ok. 32 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 20:21:37.807 INFO [stdout] 
Nov 18 20:21:37.808 INFO [stderr] su: No module specific data is present
Nov 18 20:21:38.271 INFO running `"docker" "inspect" "fea5189fc24982356374617921129a3ddd7ed5a2c1ed1e23b4fbfd8e9ddc8e6a"`
Nov 18 20:21:38.489 INFO running `"docker" "rm" "-f" "fea5189fc24982356374617921129a3ddd7ed5a2c1ed1e23b4fbfd8e9ddc8e6a"`
Nov 18 20:21:38.722 INFO [stdout] fea5189fc24982356374617921129a3ddd7ed5a2c1ed1e23b4fbfd8e9ddc8e6a