Dec 07 16:57:20.745 INFO testing ferrous-0.1.0 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514 Dec 07 16:57:20.745 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 16:57:21.289 INFO [stdout] 4916d845fb01cd7d7c10137d022eed618a329b8e3424c522a770284a901d6b09 Dec 07 16:57:21.294 INFO running `"docker" "start" "-a" "4916d845fb01cd7d7c10137d022eed618a329b8e3424c522a770284a901d6b09"` Dec 07 16:57:22.667 INFO [stderr] usermod: no changes Dec 07 16:57:22.752 INFO [stderr] Compiling ferrous v0.1.0 (/source) Dec 07 16:57:23.504 INFO [stderr] warning: use of deprecated item 'std::thread::sleep_ms': replaced by `std::thread::sleep` Dec 07 16:57:23.504 INFO [stderr] --> src/dsl/assertions.rs:123:13 Dec 07 16:57:23.504 INFO [stderr] | Dec 07 16:57:23.504 INFO [stderr] 123 | thread::sleep_ms(self.polling_interval); Dec 07 16:57:23.504 INFO [stderr] | ^^^^^^^^^^^^^^^^ Dec 07 16:57:23.505 INFO [stderr] | Dec 07 16:57:23.505 INFO [stderr] = note: #[warn(deprecated)] on by default Dec 07 16:57:23.505 INFO [stderr] Dec 07 16:57:23.505 INFO [stderr] warning: use of deprecated item 'std::thread::sleep_ms': replaced by `std::thread::sleep` Dec 07 16:57:23.508 INFO [stderr] --> src/dsl/assertions.rs:138:13 Dec 07 16:57:23.508 INFO [stderr] | Dec 07 16:57:23.508 INFO [stderr] 138 | thread::sleep_ms(self.polling_interval); Dec 07 16:57:23.508 INFO [stderr] | ^^^^^^^^^^^^^^^^ Dec 07 16:57:23.508 INFO [stderr] Dec 07 16:57:23.721 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 1.02s Dec 07 16:57:23.724 INFO [stderr] su: No module specific data is present Dec 07 16:57:24.583 INFO running `"docker" "inspect" "4916d845fb01cd7d7c10137d022eed618a329b8e3424c522a770284a901d6b09"` Dec 07 16:57:24.804 INFO running `"docker" "rm" "-f" "4916d845fb01cd7d7c10137d022eed618a329b8e3424c522a770284a901d6b09"` Dec 07 16:57:25.044 INFO [stdout] 4916d845fb01cd7d7c10137d022eed618a329b8e3424c522a770284a901d6b09 Dec 07 16:57:25.046 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 16:57:25.536 INFO [stdout] 0b5855cc56664904a6ee1dbcf773b1b8ada1094082616ac30d196cf8c3c6bb39 Dec 07 16:57:25.538 INFO running `"docker" "start" "-a" "0b5855cc56664904a6ee1dbcf773b1b8ada1094082616ac30d196cf8c3c6bb39"` Dec 07 16:57:27.847 INFO [stderr] usermod: no changes Dec 07 16:57:27.924 INFO [stderr] Compiling ferrous v0.1.0 (/source) Dec 07 16:57:29.540 INFO [stderr] warning: use of deprecated item 'std::thread::sleep_ms': replaced by `std::thread::sleep` Dec 07 16:57:29.540 INFO [stderr] --> src/dsl/assertions.rs:172:13 Dec 07 16:57:29.540 INFO [stderr] | Dec 07 16:57:29.540 INFO [stderr] 172 | thread::sleep_ms(500); Dec 07 16:57:29.540 INFO [stderr] | ^^^^^^^^^^^^^^^^ Dec 07 16:57:29.540 INFO [stderr] | Dec 07 16:57:29.540 INFO [stderr] = note: #[warn(deprecated)] on by default Dec 07 16:57:29.540 INFO [stderr] Dec 07 16:57:29.540 INFO [stderr] warning: use of deprecated item 'std::thread::sleep_ms': replaced by `std::thread::sleep` Dec 07 16:57:29.540 INFO [stderr] --> src/dsl/assertions.rs:205:13 Dec 07 16:57:29.540 INFO [stderr] | Dec 07 16:57:29.540 INFO [stderr] 205 | thread::sleep_ms(500); Dec 07 16:57:29.540 INFO [stderr] | ^^^^^^^^^^^^^^^^ Dec 07 16:57:29.540 INFO [stderr] Dec 07 16:57:29.540 INFO [stderr] warning: use of deprecated item 'std::thread::sleep_ms': replaced by `std::thread::sleep` Dec 07 16:57:29.540 INFO [stderr] --> src/dsl/assertions.rs:249:13 Dec 07 16:57:29.540 INFO [stderr] | Dec 07 16:57:29.540 INFO [stderr] 249 | thread::sleep_ms(500); Dec 07 16:57:29.540 INFO [stderr] | ^^^^^^^^^^^^^^^^ Dec 07 16:57:29.540 INFO [stderr] Dec 07 16:57:29.540 INFO [stderr] warning: use of deprecated item 'std::thread::sleep_ms': replaced by `std::thread::sleep` Dec 07 16:57:29.540 INFO [stderr] --> src/dsl/assertions.rs:282:13 Dec 07 16:57:29.540 INFO [stderr] | Dec 07 16:57:29.540 INFO [stderr] 282 | thread::sleep_ms(500); Dec 07 16:57:29.540 INFO [stderr] | ^^^^^^^^^^^^^^^^ Dec 07 16:57:29.540 INFO [stderr] Dec 07 16:57:29.540 INFO [stderr] warning: use of deprecated item 'std::thread::sleep_ms': replaced by `std::thread::sleep` Dec 07 16:57:29.540 INFO [stderr] --> src/dsl/assertions.rs:123:13 Dec 07 16:57:29.540 INFO [stderr] | Dec 07 16:57:29.540 INFO [stderr] 123 | thread::sleep_ms(self.polling_interval); Dec 07 16:57:29.540 INFO [stderr] | ^^^^^^^^^^^^^^^^ Dec 07 16:57:29.540 INFO [stderr] Dec 07 16:57:29.540 INFO [stderr] warning: use of deprecated item 'std::thread::sleep_ms': replaced by `std::thread::sleep` Dec 07 16:57:29.540 INFO [stderr] --> src/dsl/assertions.rs:138:13 Dec 07 16:57:29.540 INFO [stderr] | Dec 07 16:57:29.540 INFO [stderr] 138 | thread::sleep_ms(self.polling_interval); Dec 07 16:57:29.540 INFO [stderr] | ^^^^^^^^^^^^^^^^ Dec 07 16:57:29.540 INFO [stderr] Dec 07 16:57:31.675 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 3.80s Dec 07 16:57:31.679 INFO [stderr] su: No module specific data is present Dec 07 16:57:33.039 INFO running `"docker" "inspect" "0b5855cc56664904a6ee1dbcf773b1b8ada1094082616ac30d196cf8c3c6bb39"` Dec 07 16:57:33.384 INFO running `"docker" "rm" "-f" "0b5855cc56664904a6ee1dbcf773b1b8ada1094082616ac30d196cf8c3c6bb39"` Dec 07 16:57:33.654 INFO [stdout] 0b5855cc56664904a6ee1dbcf773b1b8ada1094082616ac30d196cf8c3c6bb39 Dec 07 16:57:33.660 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 16:57:34.113 INFO [stdout] 64299f4b5a0094e7a86ab5c9014d62828f9dccf313d851d0c1bdfd7be8048a6a Dec 07 16:57:34.115 INFO running `"docker" "start" "-a" "64299f4b5a0094e7a86ab5c9014d62828f9dccf313d851d0c1bdfd7be8048a6a"` Dec 07 16:57:36.674 INFO [stderr] usermod: no changes Dec 07 16:57:36.794 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.08s Dec 07 16:57:36.795 INFO [stderr] Running /target/debug/deps/ferrous-31d7eaf698d9c4f5 Dec 07 16:57:36.801 INFO [stdout] Dec 07 16:57:36.802 INFO [stdout] running 30 tests Dec 07 16:57:36.942 INFO [stdout] test dsl::assertions::tests::test_consistently_negated_fail ... ok Dec 07 16:57:36.944 INFO [stdout] test dsl::matchers::contain::tests::test_equal_failure_msg ... ok Dec 07 16:57:36.945 INFO [stdout] test dsl::matchers::contain::tests::test_equal_matches ... ok Dec 07 16:57:36.945 INFO [stdout] test dsl::matchers::contain::tests::test_equal_negated_failure_msg ... ok Dec 07 16:57:36.946 INFO [stdout] test dsl::matchers::equals::tests::test_equal_failure_msg ... ok Dec 07 16:57:36.946 INFO [stdout] test dsl::matchers::equals::tests::test_equal_matches ... ok Dec 07 16:57:36.947 INFO [stdout] test dsl::matchers::equals::tests::test_equal_negated_failure_msg ... ok Dec 07 16:57:36.947 INFO [stdout] test dsl::matchers::option::tests::test_none_failure_msg ... ok Dec 07 16:57:36.948 INFO [stdout] test dsl::matchers::option::tests::test_none_matches ... ok Dec 07 16:57:36.948 INFO [stdout] test dsl::matchers::option::tests::test_none_matches_fail ... ok Dec 07 16:57:36.956 INFO [stdout] test dsl::matchers::option::tests::test_none_negated_failure_msg ... ok Dec 07 16:57:36.957 INFO [stdout] test dsl::matchers::option::tests::test_some_failure_msg ... ok Dec 07 16:57:36.957 INFO [stdout] test dsl::matchers::option::tests::test_some_matches ... ok Dec 07 16:57:36.958 INFO [stdout] test dsl::matchers::option::tests::test_some_matches_fails ... ok Dec 07 16:57:36.958 INFO [stdout] test dsl::matchers::option::tests::test_some_negated_failure_msg ... ok Dec 07 16:57:36.959 INFO [stdout] test dsl::matchers::result::tests::test_err_failure_msg ... ok Dec 07 16:57:36.959 INFO [stdout] test dsl::matchers::result::tests::test_err_matches ... ok Dec 07 16:57:36.959 INFO [stdout] test dsl::matchers::result::tests::test_err_matches_fails ... ok Dec 07 16:57:36.960 INFO [stdout] test dsl::matchers::result::tests::test_err_negated_failure_msg ... ok Dec 07 16:57:36.960 INFO [stdout] test dsl::matchers::result::tests::test_ok_failure_msg ... ok Dec 07 16:57:36.961 INFO [stdout] test dsl::matchers::result::tests::test_ok_matches ... ok Dec 07 16:57:36.961 INFO [stdout] test dsl::matchers::result::tests::test_ok_matches_fail ... ok Dec 07 16:57:36.962 INFO [stdout] test dsl::matchers::result::tests::test_ok_negated_failure_msg ... ok Dec 07 16:57:37.324 INFO [stdout] test dsl::assertions::tests::test_consistently_fail ... ok Dec 07 16:57:37.355 INFO [stdout] test dsl::assertions::tests::test_eventually_negated ... ok Dec 07 16:57:37.356 INFO [stdout] test dsl::assertions::tests::test_eventually ... ok Dec 07 16:57:37.812 INFO [stdout] test dsl::assertions::tests::test_consistently_negated ... ok Dec 07 16:57:37.812 INFO [stdout] test dsl::assertions::tests::test_consistently ... ok Dec 07 16:57:37.852 INFO [stdout] test dsl::assertions::tests::test_eventually_negated_timeout ... ok Dec 07 16:57:37.862 INFO [stdout] test dsl::assertions::tests::test_eventually_timeout ... ok Dec 07 16:57:37.862 INFO [stdout] Dec 07 16:57:37.862 INFO [stdout] test result: ok. 30 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 07 16:57:37.862 INFO [stdout] Dec 07 16:57:37.863 INFO [stderr] Running /target/debug/deps/mod-39decaf8da9e1e6d Dec 07 16:57:37.876 INFO [stdout] Dec 07 16:57:37.876 INFO [stdout] running 24 tests Dec 07 16:57:37.886 INFO [stdout] test test_eventually_should_err ... ok Dec 07 16:57:37.892 INFO [stdout] test test_expect_not_to ... ok Dec 07 16:57:38.012 INFO [stdout] test test_consistently_should_not_err_panic ... ok Dec 07 16:57:38.012 INFO [stdout] test test_expect_not_to_none_panic ... ok Dec 07 16:57:38.012 INFO [stdout] test test_expect_to ... ok Dec 07 16:57:38.012 INFO [stdout] test test_expect_not_to_err_panic ... ok Dec 07 16:57:38.012 INFO [stdout] test test_expect_not_to_ok_panic ... ok Dec 07 16:57:38.012 INFO [stdout] test test_expect_not_to_some_panic ... ok Dec 07 16:57:38.012 INFO [stdout] test test_expect_not_to_panic ... ok Dec 07 16:57:38.012 INFO [stdout] test test_expect_to_custom ... ok Dec 07 16:57:38.012 INFO [stdout] test test_expect_to_none ... ok Dec 07 16:57:38.012 INFO [stdout] test test_expect_to_err ... ok Dec 07 16:57:38.012 INFO [stdout] test test_expect_to_custom_panic ... ok Dec 07 16:57:38.012 INFO [stdout] test test_expect_to_err_panic ... ok Dec 07 16:57:38.012 INFO [stdout] test test_expect_to_ok ... ok Dec 07 16:57:38.012 INFO [stdout] test test_expect_to_ok_panic ... ok Dec 07 16:57:38.012 INFO [stdout] test test_expect_to_none_panic ... ok Dec 07 16:57:38.013 INFO [stdout] test test_expect_to_contain ... ok Dec 07 16:57:38.013 INFO [stdout] test test_expect_to_contain_panic ... ok Dec 07 16:57:38.016 INFO [stdout] test test_expect_to_panic ... ok Dec 07 16:57:38.024 INFO [stdout] test test_expect_to_some_panic ... ok Dec 07 16:57:38.024 INFO [stdout] test test_expect_to_some ... ok Dec 07 16:57:38.879 INFO [stdout] test test_eventually_should_not_err_panic ... ok Dec 07 16:57:38.879 INFO [stdout] test test_consistently_should_err ... ok Dec 07 16:57:38.879 INFO [stdout] Dec 07 16:57:38.879 INFO [stdout] test result: ok. 24 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 07 16:57:38.879 INFO [stdout] Dec 07 16:57:38.881 INFO [stderr] Doc-tests ferrous Dec 07 16:57:40.193 INFO [stdout] Dec 07 16:57:40.193 INFO [stdout] running 1 test Dec 07 16:57:41.828 INFO [stdout] test src/dsl/mod.rs - dsl (line 5) ... ok Dec 07 16:57:41.828 INFO [stdout] Dec 07 16:57:41.828 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 07 16:57:41.828 INFO [stdout] Dec 07 16:57:41.846 INFO [stderr] su: No module specific data is present Dec 07 16:57:42.820 INFO running `"docker" "inspect" "64299f4b5a0094e7a86ab5c9014d62828f9dccf313d851d0c1bdfd7be8048a6a"` Dec 07 16:57:43.154 INFO running `"docker" "rm" "-f" "64299f4b5a0094e7a86ab5c9014d62828f9dccf313d851d0c1bdfd7be8048a6a"` Dec 07 16:57:43.432 INFO [stdout] 64299f4b5a0094e7a86ab5c9014d62828f9dccf313d851d0c1bdfd7be8048a6a