Dec 05 20:13:47.280 INFO testing jasonwhite/button-rs against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 05 20:13:47.280 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 20:13:47.792 INFO [stdout] f558e3edccf2d74e6b7f9a79d9d0c475a6b85edee29e3f5faaec4a70b6e023a4
Dec 05 20:13:47.795 INFO running `"docker" "start" "-a" "f558e3edccf2d74e6b7f9a79d9d0c475a6b85edee29e3f5faaec4a70b6e023a4"`
Dec 05 20:13:49.974 INFO [stderr] usermod: no changes
Dec 05 20:13:50.487 INFO [stderr]    Compiling smallvec v0.6.6
Dec 05 20:13:50.496 INFO [stderr]    Compiling holyhashmap v0.1.1
Dec 05 20:13:50.497 INFO [stderr]    Compiling generic-array v0.9.0
Dec 05 20:13:50.509 INFO [stderr]    Compiling os_pipe v0.8.0
Dec 05 20:13:50.509 INFO [stderr]    Compiling nom v4.1.1
Dec 05 20:13:50.509 INFO [stderr]    Compiling chrono v0.4.6
Dec 05 20:13:50.510 INFO [stderr]    Compiling rand v0.6.1
Dec 05 20:13:53.186 INFO [stderr]    Compiling parking_lot_core v0.3.1
Dec 05 20:13:53.440 INFO [stderr]    Compiling digest v0.7.6
Dec 05 20:13:54.357 INFO [stderr]    Compiling sha2 v0.7.1
Dec 05 20:13:57.358 INFO [stderr]    Compiling parking_lot v0.6.4
Dec 05 20:13:59.863 INFO [stderr]    Compiling tokio-reactor v0.1.7
Dec 05 20:13:59.879 INFO [stderr]    Compiling crossbeam-channel v0.3.2
Dec 05 20:13:59.889 INFO [stderr]    Compiling tokio-threadpool v0.1.9
Dec 05 20:13:59.891 INFO [stderr]    Compiling tempfile v3.0.5
Dec 05 20:14:02.308 INFO [stderr]    Compiling crossbeam v0.5.0
Dec 05 20:14:02.720 INFO [stderr]    Compiling tokio-uds v0.2.4
Dec 05 20:14:02.720 INFO [stderr]    Compiling tokio-tcp v0.1.2
Dec 05 20:14:02.720 INFO [stderr]    Compiling tokio-udp v0.1.3
Dec 05 20:14:03.928 INFO [stderr]    Compiling tokio-fs v0.1.4
Dec 05 20:14:06.653 INFO [stderr]    Compiling tokio v0.1.13
Dec 05 20:14:08.811 INFO [stderr]    Compiling hyper v0.12.16
Dec 05 20:14:16.416 INFO [stderr]    Compiling hyper-tls v0.3.1
Dec 05 20:14:18.693 INFO [stderr]    Compiling reqwest v0.9.5
Dec 05 20:14:28.299 INFO [stderr]    Compiling button v0.1.0 (/source)
Dec 05 20:15:00.174 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 10s
Dec 05 20:15:00.192 INFO [stderr] su: No module specific data is present
Dec 05 20:15:00.506 INFO running `"docker" "inspect" "f558e3edccf2d74e6b7f9a79d9d0c475a6b85edee29e3f5faaec4a70b6e023a4"`
Dec 05 20:15:00.674 INFO running `"docker" "rm" "-f" "f558e3edccf2d74e6b7f9a79d9d0c475a6b85edee29e3f5faaec4a70b6e023a4"`
Dec 05 20:15:00.858 INFO [stdout] f558e3edccf2d74e6b7f9a79d9d0c475a6b85edee29e3f5faaec4a70b6e023a4
Dec 05 20:15:00.860 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 20:15:01.059 INFO [stdout] 4c5709a551c65d147258e8e7750b55d6ea949a7f6085cceef080ca3a4e54d920
Dec 05 20:15:01.066 INFO running `"docker" "start" "-a" "4c5709a551c65d147258e8e7750b55d6ea949a7f6085cceef080ca3a4e54d920"`
Dec 05 20:15:01.418 INFO [stderr] usermod: no changes
Dec 05 20:15:01.703 INFO [stderr]    Compiling button v0.1.0 (/source)
Dec 05 20:15:15.616 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 14.17s
Dec 05 20:15:15.636 INFO [stderr] su: No module specific data is present
Dec 05 20:15:16.845 INFO running `"docker" "inspect" "4c5709a551c65d147258e8e7750b55d6ea949a7f6085cceef080ca3a4e54d920"`
Dec 05 20:15:17.166 INFO running `"docker" "rm" "-f" "4c5709a551c65d147258e8e7750b55d6ea949a7f6085cceef080ca3a4e54d920"`
Dec 05 20:15:17.500 INFO [stdout] 4c5709a551c65d147258e8e7750b55d6ea949a7f6085cceef080ca3a4e54d920
Dec 05 20:15:17.508 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 20:15:18.051 INFO [stdout] 812714e373d19b8bba771eec44361c4e88c049cdfa9584a1a7780c9067ab2a76
Dec 05 20:15:18.053 INFO running `"docker" "start" "-a" "812714e373d19b8bba771eec44361c4e88c049cdfa9584a1a7780c9067ab2a76"`
Dec 05 20:15:20.063 INFO [stderr] usermod: no changes
Dec 05 20:15:20.438 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.35s
Dec 05 20:15:20.471 INFO [stderr]      Running /target/debug/deps/button-449a73d125ba1da3
Dec 05 20:15:20.493 INFO [stdout] 
Dec 05 20:15:20.494 INFO [stdout] running 15 tests
Dec 05 20:15:20.540 INFO [stdout] test res::file::tests::test_normalized ... ok
Dec 05 20:15:20.549 INFO [stdout] test graph::base::tests::test_smoke ... ok
Dec 05 20:15:20.549 INFO [stdout] test build_graph::tests::test_cycles ... ok
Dec 05 20:15:20.576 INFO [stdout] test build_graph::tests::test_races ... ok
Dec 05 20:15:20.576 INFO [stdout] test graph::base::tests::diff ... ok
Dec 05 20:15:20.576 INFO [stdout] test task::makedir::tests::test_known_outputs ... ok
Dec 05 20:15:20.576 INFO [stdout] test graph::base::tests::test_tarjan ... ok
Dec 05 20:15:20.580 INFO [stdout] test task::command::tests::test_command_display ... ok
Dec 05 20:15:20.580 INFO [stdout] test util::make::tests::it_works ... ok
Dec 05 20:15:20.580 INFO [stdout] test util::iter::tests::test_empty_or_any ... ok
Dec 05 20:15:20.581 INFO [stdout] test build_graph::tests::test_good_graph ... ok
Dec 05 20:15:20.584 INFO [stdout] test util::path::tests::test_norm ... ok
Dec 05 20:15:20.584 INFO [stdout] test util::path::tests::test_relative_from ... ok
Dec 05 20:15:20.584 INFO [stdout] test util::args::tests::test_arg_display ... ok
Dec 05 20:15:20.596 INFO [stdout] test rules::tests::test_loading ... ok
Dec 05 20:15:20.596 INFO [stdout] 
Dec 05 20:15:20.596 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 20:15:20.596 INFO [stdout] 
Dec 05 20:15:20.600 INFO [stderr]      Running /target/debug/deps/button-27ea1ec5a791762b
Dec 05 20:15:20.606 INFO [stdout] 
Dec 05 20:15:20.606 INFO [stdout] running 0 tests
Dec 05 20:15:20.606 INFO [stdout] 
Dec 05 20:15:20.606 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 20:15:20.606 INFO [stdout] 
Dec 05 20:15:20.607 INFO [stderr]    Doc-tests button
Dec 05 20:15:28.019 INFO [stdout] 
Dec 05 20:15:28.019 INFO [stdout] running 1 test
Dec 05 20:15:35.955 INFO [stdout] test src/button/util/retry.rs - util::retry (line 25) ... ok
Dec 05 20:15:35.955 INFO [stdout] 
Dec 05 20:15:35.955 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 20:15:35.955 INFO [stdout] 
Dec 05 20:15:36.012 INFO [stderr] su: No module specific data is present
Dec 05 20:15:36.776 INFO running `"docker" "inspect" "812714e373d19b8bba771eec44361c4e88c049cdfa9584a1a7780c9067ab2a76"`
Dec 05 20:15:37.086 INFO running `"docker" "rm" "-f" "812714e373d19b8bba771eec44361c4e88c049cdfa9584a1a7780c9067ab2a76"`
Dec 05 20:15:37.509 INFO [stdout] 812714e373d19b8bba771eec44361c4e88c049cdfa9584a1a7780c9067ab2a76