Dec 05 23:27:33.227 INFO testing flyingcircusio/check_journal against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 05 23:27:33.227 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 05 23:27:33.762 INFO [stdout] c1771f94944ddb0e17f705cb0b010d6f2c760261deeaa26f5debd55302781564
Dec 05 23:27:33.764 INFO running `"docker" "start" "-a" "c1771f94944ddb0e17f705cb0b010d6f2c760261deeaa26f5debd55302781564"`
Dec 05 23:27:35.280 INFO [stderr] usermod: no changes
Dec 05 23:27:35.684 INFO [stderr]    Compiling httparse v1.3.1
Dec 05 23:27:35.686 INFO [stderr]    Compiling term_size v0.3.1
Dec 05 23:27:35.696 INFO [stderr]    Compiling subprocess v0.1.12
Dec 05 23:27:35.721 INFO [stderr]    Compiling crossbeam-epoch v0.4.3
Dec 05 23:27:35.722 INFO [stderr]    Compiling nix v0.11.0
Dec 05 23:27:35.723 INFO [stderr]    Compiling serde_json v1.0.22
Dec 05 23:27:35.723 INFO [stderr]    Compiling serde_yaml v0.7.4
Dec 05 23:27:35.729 INFO [stderr]    Compiling regex v1.0.0
Dec 05 23:27:37.384 INFO [stderr]    Compiling openssl v0.9.24
Dec 05 23:27:49.494 INFO [stderr]    Compiling serde_derive v1.0.59
Dec 05 23:27:49.657 INFO [stderr]    Compiling textwrap v0.9.0
Dec 05 23:27:49.663 INFO [stderr]    Compiling error-chain v0.11.0
Dec 05 23:27:49.835 INFO [stderr]    Compiling crossbeam-deque v0.3.1
Dec 05 23:27:56.169 INFO [stderr]    Compiling tokio-threadpool v0.1.4
Dec 05 23:28:07.866 INFO [stderr]    Compiling clap v2.31.2
Dec 05 23:28:14.214 INFO [stderr]    Compiling native-tls v0.1.5
Dec 05 23:28:17.816 INFO [stderr]    Compiling tokio-fs v0.1.1
Dec 05 23:28:20.700 INFO [stderr]    Compiling tokio v0.1.7
Dec 05 23:28:30.704 INFO [stderr]    Compiling tokio-core v0.1.17
Dec 05 23:28:40.764 INFO [stderr]    Compiling tokio-proto v0.1.1
Dec 05 23:28:40.764 INFO [stderr]    Compiling tokio-tls v0.1.4
Dec 05 23:28:44.508 INFO [stderr]    Compiling hyper v0.11.27
Dec 05 23:28:52.999 INFO [stderr]    Compiling hyper-tls v0.1.3
Dec 05 23:28:55.315 INFO [stderr]    Compiling reqwest v0.8.6
Dec 05 23:29:04.908 INFO [stderr]    Compiling check_journal v1.0.5 (/source)
Dec 05 23:29:15.717 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 40s
Dec 05 23:29:15.740 INFO [stderr] su: No module specific data is present
Dec 05 23:29:17.229 INFO running `"docker" "inspect" "c1771f94944ddb0e17f705cb0b010d6f2c760261deeaa26f5debd55302781564"`
Dec 05 23:29:17.590 INFO running `"docker" "rm" "-f" "c1771f94944ddb0e17f705cb0b010d6f2c760261deeaa26f5debd55302781564"`
Dec 05 23:29:17.880 INFO [stdout] c1771f94944ddb0e17f705cb0b010d6f2c760261deeaa26f5debd55302781564
Dec 05 23:29:17.886 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 05 23:29:18.332 INFO [stdout] 3d5ba2e25cc9494f5114dbf87051005acf8297b7b51ad839ced8ecdfdfd9d146
Dec 05 23:29:18.334 INFO running `"docker" "start" "-a" "3d5ba2e25cc9494f5114dbf87051005acf8297b7b51ad839ced8ecdfdfd9d146"`
Dec 05 23:29:19.864 INFO [stderr] usermod: no changes
Dec 05 23:29:20.144 INFO [stderr]    Compiling check_journal v1.0.5 (/source)
Dec 05 23:29:29.980 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 10.08s
Dec 05 23:29:29.994 INFO [stderr] su: No module specific data is present
Dec 05 23:29:30.626 INFO running `"docker" "inspect" "3d5ba2e25cc9494f5114dbf87051005acf8297b7b51ad839ced8ecdfdfd9d146"`
Dec 05 23:29:30.906 INFO running `"docker" "rm" "-f" "3d5ba2e25cc9494f5114dbf87051005acf8297b7b51ad839ced8ecdfdfd9d146"`
Dec 05 23:29:31.168 INFO [stdout] 3d5ba2e25cc9494f5114dbf87051005acf8297b7b51ad839ced8ecdfdfd9d146
Dec 05 23:29:31.174 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 05 23:29:31.593 INFO [stdout] a6a12de40336a888e86859723e01c93a87c8075c69e0505d1deb9643b625a17c
Dec 05 23:29:31.595 INFO running `"docker" "start" "-a" "a6a12de40336a888e86859723e01c93a87c8075c69e0505d1deb9643b625a17c"`
Dec 05 23:29:32.180 INFO [stderr] usermod: no changes
Dec 05 23:29:32.335 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.13s
Dec 05 23:29:32.358 INFO [stderr]      Running /target/debug/deps/check_journal-c0e6397bfae3161a
Dec 05 23:29:32.367 INFO [stdout] 
Dec 05 23:29:32.367 INFO [stdout] running 13 tests
Dec 05 23:29:32.488 INFO [stdout] test check::test::fmt_matches_should_truncate_lines ... ok
Dec 05 23:29:32.503 INFO [stdout] test check::test::fmt_matches_should_list_matches ... ok
Dec 05 23:29:32.503 INFO [stdout] test check::test::should_match_on_exit_0_or_1 ... ok
Dec 05 23:29:32.514 INFO [stdout] test check::test::should_disregard_stderr_on_exit_0_1 ... ok
Dec 05 23:29:32.515 INFO [stdout] test check::test::filter_crit_warn ... ok
Dec 05 23:29:32.544 INFO [stdout] test check::test::should_report_no_output ... ok
Dec 05 23:29:32.545 INFO [stdout] test rules::test::load_from_file ... ok
Dec 05 23:29:32.552 INFO [stdout] test rules::test::matches_and_exceptions ... ok
Dec 05 23:29:32.693 INFO [stdout] test check::test::should_fail_on_exit_status ... ok
Dec 05 23:29:32.694 INFO [stdout] test check::test::report_should_truncate_output ... ok
Dec 05 23:29:32.698 INFO [stdout] test rules::test::parse_failure_should_be_reported ... ok
Dec 05 23:29:32.698 INFO [stdout] test check::test::report_should_return_warn_crit_status ... ok
Dec 05 23:29:32.699 INFO [stdout] test rules::test::load_from_nonexistent_url_should_fail ... ok
Dec 05 23:29:32.699 INFO [stdout] 
Dec 05 23:29:32.699 INFO [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 23:29:32.699 INFO [stdout] 
Dec 05 23:29:32.706 INFO [stderr] su: No module specific data is present
Dec 05 23:29:32.898 INFO running `"docker" "inspect" "a6a12de40336a888e86859723e01c93a87c8075c69e0505d1deb9643b625a17c"`
Dec 05 23:29:32.981 INFO running `"docker" "rm" "-f" "a6a12de40336a888e86859723e01c93a87c8075c69e0505d1deb9643b625a17c"`
Dec 05 23:29:33.057 INFO [stdout] a6a12de40336a888e86859723e01c93a87c8075c69e0505d1deb9643b625a17c