Nov 02 00:43:50.394 INFO testing vigil-reporter-1.0.3 against 1.30.0 for beta-1.31-1
Nov 02 00:43:50.395 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-1/1.30.0:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/beta-1.31-1/1.30.0:/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 +1.30.0 build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 02 00:43:51.099 INFO blam! 4429ba08fe1484d1eb7061c662015406d3b99c06727f603050121c448b4d0558
Nov 02 00:43:51.100 INFO running `"docker" "start" "-a" "4429ba08fe1484d1eb7061c662015406d3b99c06727f603050121c448b4d0558"`
Nov 02 00:43:52.491 INFO kablam! usermod: no changes
Nov 02 00:43:52.859 INFO kablam!    Compiling sys-info v0.5.6
Nov 02 00:43:52.895 INFO kablam!    Compiling tokio-core v0.1.17
Nov 02 00:43:59.321 INFO kablam!    Compiling hyper v0.11.27
Nov 02 00:43:59.321 INFO kablam!    Compiling tokio-tls v0.1.4
Nov 02 00:44:08.851 INFO kablam!    Compiling hyper-tls v0.1.4
Nov 02 00:44:12.468 INFO kablam!    Compiling reqwest v0.8.8
Nov 02 00:44:21.679 INFO kablam!    Compiling vigil-reporter v1.0.3 (/source)
Nov 02 00:44:27.788 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 35.25s
Nov 02 00:44:27.818 INFO kablam! su: No module specific data is present
Nov 02 00:44:28.528 INFO running `"docker" "rm" "-f" "4429ba08fe1484d1eb7061c662015406d3b99c06727f603050121c448b4d0558"`
Nov 02 00:44:28.865 INFO blam! 4429ba08fe1484d1eb7061c662015406d3b99c06727f603050121c448b4d0558
Nov 02 00:44:28.871 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-1/1.30.0:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/beta-1.31-1/1.30.0:/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 +1.30.0 test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 02 00:44:29.343 INFO blam! 0edc9abda8f5dc7dd7d30ec70b09bcd86ef4e8ba87868cb04f7293f482ecab64
Nov 02 00:44:29.346 INFO running `"docker" "start" "-a" "0edc9abda8f5dc7dd7d30ec70b09bcd86ef4e8ba87868cb04f7293f482ecab64"`
Nov 02 00:44:31.010 INFO kablam! usermod: no changes
Nov 02 00:44:31.271 INFO kablam!    Compiling vigil-reporter v1.0.3 (/source)
Nov 02 00:44:43.985 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 12.94s
Nov 02 00:44:43.998 INFO kablam! su: No module specific data is present
Nov 02 00:44:44.349 INFO running `"docker" "rm" "-f" "0edc9abda8f5dc7dd7d30ec70b09bcd86ef4e8ba87868cb04f7293f482ecab64"`
Nov 02 00:44:44.503 INFO blam! 0edc9abda8f5dc7dd7d30ec70b09bcd86ef4e8ba87868cb04f7293f482ecab64
Nov 02 00:44:44.506 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-1/worker-1/1.30.0:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/beta-1.31-1/1.30.0:/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 +1.30.0 test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 02 00:44:44.714 INFO blam! 464f9806a4f3924cebd4c98fedf7f892cd67a98ec43f5781c1f6cb7c5faf1ac5
Nov 02 00:44:44.727 INFO running `"docker" "start" "-a" "464f9806a4f3924cebd4c98fedf7f892cd67a98ec43f5781c1f6cb7c5faf1ac5"`
Nov 02 00:44:45.538 INFO kablam! usermod: no changes
Nov 02 00:44:45.730 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.17s
Nov 02 00:44:45.740 INFO kablam!      Running /target/debug/deps/vigil_reporter-fba4dc1c00fd7c2d
Nov 02 00:44:45.743 INFO blam! 
Nov 02 00:44:45.743 INFO blam! running 0 tests
Nov 02 00:44:45.743 INFO blam! 
Nov 02 00:44:45.743 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 02 00:44:45.743 INFO blam! 
Nov 02 00:44:45.746 INFO blam! 
Nov 02 00:44:45.746 INFO kablam!      Running /target/debug/deps/report-e61f268e58631787
Nov 02 00:44:45.746 INFO blam! running 5 tests
Nov 02 00:44:45.748 INFO blam! test initialize_valid ... ok
Nov 02 00:44:45.748 INFO kablam! DEBUG 2018-11-02T00:44:45Z: vigil_reporter: Vigil Reporter: Will run using URL: http://status.example.com.local
Nov 02 00:44:45.759 INFO kablam! TRACE 2018-11-02T00:44:45Z: mio::poll: registering with poller
Nov 02 00:44:45.760 INFO kablam! TRACE 2018-11-02T00:44:45Z: tokio_threadpool::builder: build; num-workers=8
Nov 02 00:44:45.760 INFO kablam! DEBUG 2018-11-02T00:44:45Z: tokio_reactor::background: starting background reactor
Nov 02 00:44:45.760 INFO kablam! DEBUG 2018-11-02T00:44:45Z: tokio_core::reactor: consuming notification queue
Nov 02 00:44:45.761 INFO kablam! DEBUG 2018-11-02T00:44:45Z: tokio_core::reactor: loop poll - 49.602µs
Nov 02 00:44:45.761 INFO kablam! DEBUG 2018-11-02T00:44:45Z: tokio_core::reactor: loop time - Instant { tv_sec: 2792661, tv_nsec: 641950119 }
Nov 02 00:44:45.761 INFO kablam! DEBUG 2018-11-02T00:44:45Z: tokio_core::reactor: loop process, 48.626µs
Nov 02 00:44:45.763 INFO kablam! DEBUG 2018-11-02T00:44:45Z: vigil_reporter: Vigil Reporter: Now running
Nov 02 00:44:45.826 INFO blam! test initialize_invalid_probe_id ... ok
Nov 02 00:44:45.827 INFO blam! test initialize_invalid_node_id ... ok
Nov 02 00:44:45.827 INFO blam! test initialize_invalid_replica_id ... ok
Nov 02 00:44:55.769 INFO kablam! DEBUG 2018-11-02T00:44:55Z: vigil_reporter: Vigil Reporter: Will dispatch request
Nov 02 00:44:55.769 INFO kablam! DEBUG 2018-11-02T00:44:55Z: vigil_reporter: Vigil Reporter: Will send request to URL: http://status.example.com.local/reporter/relay/socket-client/ with payload: ReportPayload { replica: "192.168.1.10", interval: 30, load: ReportPayloadLoad { cpu: 5.8825, ram: 0.15760052 } }
Nov 02 00:44:55.769 INFO kablam! DEBUG 2018-11-02T00:44:55Z: tokio_core::reactor: loop poll - 10.00729595s
Nov 02 00:44:55.769 INFO kablam! DEBUG 2018-11-02T00:44:55Z: tokio_core::reactor: loop time - Instant { tv_sec: 2792671, tv_nsec: 649314804 }
Nov 02 00:44:55.769 INFO kablam! DEBUG 2018-11-02T00:44:55Z: tokio_core::reactor: loop process, 53.003µs
Nov 02 00:44:55.769 INFO kablam! TRACE 2018-11-02T00:44:55Z: hyper::client::pool: park; waiting for idle connection: "http://status.example.com.local"
Nov 02 00:44:55.769 INFO kablam! TRACE 2018-11-02T00:44:55Z: hyper::client::connect: Http::connect("http://status.example.com.local/reporter/relay/socket-client/")
Nov 02 00:44:55.771 INFO kablam! DEBUG 2018-11-02T00:44:55Z: tokio_core::reactor: loop poll - 199.503µs
Nov 02 00:44:55.771 INFO kablam! DEBUG 2018-11-02T00:44:55Z: tokio_core::reactor: loop time - Instant { tv_sec: 2792671, tv_nsec: 649823897 }
Nov 02 00:44:55.771 INFO kablam! DEBUG 2018-11-02T00:44:55Z: tokio_core::reactor: loop process, 40.921µs
Nov 02 00:44:55.771 INFO kablam! DEBUG 2018-11-02T00:44:55Z: hyper::client::dns: resolving host="status.example.com.local", port=80
Nov 02 00:44:55.771 INFO kablam! DEBUG 2018-11-02T00:44:55Z: tokio_core::reactor: loop poll - 1.441682ms
Nov 02 00:44:55.771 INFO kablam! DEBUG 2018-11-02T00:44:55Z: tokio_core::reactor: loop time - Instant { tv_sec: 2792671, tv_nsec: 651328126 }
Nov 02 00:44:55.771 INFO kablam! DEBUG 2018-11-02T00:44:55Z: tokio_core::reactor: loop process, 48.151µs
Nov 02 00:44:55.771 INFO kablam! ERROR 2018-11-02T00:44:55Z: vigil_reporter: Vigil Reporter: Failed dispatching request: http://status.example.com.local/reporter/relay/socket-client/: failed to lookup address information: Temporary failure in name resolution
Nov 02 00:44:55.771 INFO kablam!  WARN 2018-11-02T00:44:55Z: vigil_reporter: Vigil Reporter: Last report failed, trying again sooner than usual
Nov 02 00:45:00.771 INFO blam! test run_and_end_valid ... ok
Nov 02 00:45:00.771 INFO blam! 
Nov 02 00:45:00.771 INFO blam! test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 02 00:45:00.771 INFO blam! 
Nov 02 00:45:00.775 INFO kablam!    Doc-tests vigil_reporter
Nov 02 00:45:10.891 INFO blam! 
Nov 02 00:45:10.891 INFO blam! running 0 tests
Nov 02 00:45:10.891 INFO blam! 
Nov 02 00:45:10.891 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 02 00:45:10.891 INFO blam! 
Nov 02 00:45:10.899 INFO kablam! su: No module specific data is present
Nov 02 00:45:11.565 INFO running `"docker" "rm" "-f" "464f9806a4f3924cebd4c98fedf7f892cd67a98ec43f5781c1f6cb7c5faf1ac5"`
Nov 02 00:45:11.815 INFO blam! 464f9806a4f3924cebd4c98fedf7f892cd67a98ec43f5781c1f6cb7c5faf1ac5
