Oct 11 08:51:23.285 INFO testing vigil-reporter-1.0.3 against master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513 for rustdoc-test-static-cling
Oct 11 08:51:23.285 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt build --frozen
Oct 11 08:51:23.285 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-7/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-7/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,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" "CMD=cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt build --frozen" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-m" "1536M" "--network" "none" "crater"`
Oct 11 08:51:23.650 INFO blam! 87ce83b42e8d0eeaaf44288ba5a54a6faec0db5b1dd0a7a4da7443ae2f53c420
Oct 11 08:51:23.651 INFO running `"docker" "start" "-a" "87ce83b42e8d0eeaaf44288ba5a54a6faec0db5b1dd0a7a4da7443ae2f53c420"`
Oct 11 08:51:25.020 INFO kablam! usermod: no changes
Oct 11 08:51:25.278 INFO kablam!    Compiling hyper v0.11.27
Oct 11 08:51:38.973 INFO kablam!    Compiling hyper-tls v0.1.4
Oct 11 08:51:44.968 INFO kablam!    Compiling reqwest v0.8.8
Oct 11 08:51:58.282 INFO kablam!    Compiling vigil-reporter v1.0.3 (/source)
Oct 11 08:52:06.580 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 41.53s
Oct 11 08:52:06.596 INFO kablam! su: No module specific data is present
Oct 11 08:52:07.038 INFO running `"docker" "rm" "-f" "87ce83b42e8d0eeaaf44288ba5a54a6faec0db5b1dd0a7a4da7443ae2f53c420"`
Oct 11 08:52:07.218 INFO blam! 87ce83b42e8d0eeaaf44288ba5a54a6faec0db5b1dd0a7a4da7443ae2f53c420
Oct 11 08:52:07.218 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen --no-run
Oct 11 08:52:07.218 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-7/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-7/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,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" "CMD=cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen --no-run" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-m" "1536M" "--network" "none" "crater"`
Oct 11 08:52:07.577 INFO blam! 876ce09d86693c63950449686efab3e9209fb81a4b1d9cf8aea8513aaeefc2b8
Oct 11 08:52:07.579 INFO running `"docker" "start" "-a" "876ce09d86693c63950449686efab3e9209fb81a4b1d9cf8aea8513aaeefc2b8"`
Oct 11 08:52:08.440 INFO kablam! usermod: no changes
Oct 11 08:52:08.864 INFO kablam!    Compiling vigil-reporter v1.0.3 (/source)
Oct 11 08:52:26.845 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 18.39s
Oct 11 08:52:26.864 INFO kablam! su: No module specific data is present
Oct 11 08:52:27.588 INFO running `"docker" "rm" "-f" "876ce09d86693c63950449686efab3e9209fb81a4b1d9cf8aea8513aaeefc2b8"`
Oct 11 08:52:27.756 INFO blam! 876ce09d86693c63950449686efab3e9209fb81a4b1d9cf8aea8513aaeefc2b8
Oct 11 08:52:27.762 INFO running: cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen
Oct 11 08:52:27.762 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/test-source/worker-7/rustdoc-test-static-cling/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/source:ro,Z" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling/worker-7/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,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" "CMD=cargo +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-alt test --frozen" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-m" "1536M" "--network" "none" "crater"`
Oct 11 08:52:27.991 INFO blam! b5280de3be69bd8697fb38f1c25b01b5e4b0d614051e300edfba4e52ac44734d
Oct 11 08:52:27.994 INFO running `"docker" "start" "-a" "b5280de3be69bd8697fb38f1c25b01b5e4b0d614051e300edfba4e52ac44734d"`
Oct 11 08:52:28.874 INFO kablam! usermod: no changes
Oct 11 08:52:29.108 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.20s
Oct 11 08:52:29.136 INFO kablam!      Running /target/debug/deps/vigil_reporter-06ad2cacd2aa50c3
Oct 11 08:52:29.138 INFO blam! 
Oct 11 08:52:29.138 INFO blam! running 0 tests
Oct 11 08:52:29.138 INFO blam! 
Oct 11 08:52:29.139 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 11 08:52:29.139 INFO kablam!      Running /target/debug/deps/report-d7e49a205ecc5803
Oct 11 08:52:29.139 INFO blam! 
Oct 11 08:52:29.149 INFO blam! 
Oct 11 08:52:29.149 INFO blam! running 5 tests
Oct 11 08:52:29.178 INFO kablam! DEBUG 2018-10-11T08:52:29Z: vigil_reporter: Vigil Reporter: Will run using URL: http://status.example.com.local
Oct 11 08:52:29.181 INFO blam! test initialize_valid ... ok
Oct 11 08:52:29.220 INFO kablam! TRACE 2018-10-11T08:52:29Z: mio::poll: registering with poller
Oct 11 08:52:29.220 INFO kablam! TRACE 2018-10-11T08:52:29Z: tokio_threadpool::builder: build; num-workers=8
Oct 11 08:52:29.228 INFO kablam! DEBUG 2018-10-11T08:52:29Z: tokio_core::reactor: consuming notification queue
Oct 11 08:52:29.228 INFO kablam! DEBUG 2018-10-11T08:52:29Z: tokio_core::reactor: loop poll - 70.844µs
Oct 11 08:52:29.228 INFO kablam! DEBUG 2018-10-11T08:52:29Z: tokio_reactor::background: starting background reactor
Oct 11 08:52:29.228 INFO kablam! DEBUG 2018-10-11T08:52:29Z: tokio_core::reactor: loop time - Instant { tv_sec: 921006, tv_nsec: 559690559 }
Oct 11 08:52:29.228 INFO kablam! DEBUG 2018-10-11T08:52:29Z: tokio_core::reactor: loop process, 304.063µs
Oct 11 08:52:29.240 INFO kablam! DEBUG 2018-10-11T08:52:29Z: vigil_reporter: Vigil Reporter: Now running
Oct 11 08:52:29.324 INFO blam! test initialize_invalid_probe_id ... ok
Oct 11 08:52:29.324 INFO blam! test initialize_invalid_replica_id ... ok
Oct 11 08:52:29.324 INFO blam! test initialize_invalid_node_id ... ok
Oct 11 08:52:39.251 INFO kablam! DEBUG 2018-10-11T08:52:39Z: vigil_reporter: Vigil Reporter: Will dispatch request
Oct 11 08:52:39.251 INFO kablam! DEBUG 2018-10-11T08:52:39Z: 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.07375, ram: 0.14652383 } }
Oct 11 08:52:39.251 INFO kablam! DEBUG 2018-10-11T08:52:39Z: tokio_core::reactor: loop poll - 10.013374973s
Oct 11 08:52:39.251 INFO kablam! DEBUG 2018-10-11T08:52:39Z: tokio_core::reactor: loop time - Instant { tv_sec: 921016, tv_nsec: 573421895 }
Oct 11 08:52:39.251 INFO kablam! DEBUG 2018-10-11T08:52:39Z: tokio_core::reactor: loop process, 51.695µs
Oct 11 08:52:39.251 INFO kablam! TRACE 2018-10-11T08:52:39Z: hyper::client::pool: park; waiting for idle connection: "http://status.example.com.local"
Oct 11 08:52:39.251 INFO kablam! TRACE 2018-10-11T08:52:39Z: hyper::client::connect: Http::connect("http://status.example.com.local/reporter/relay/socket-client/")
Oct 11 08:52:39.251 INFO kablam! DEBUG 2018-10-11T08:52:39Z: tokio_core::reactor: loop poll - 216.943µs
Oct 11 08:52:39.251 INFO kablam! DEBUG 2018-10-11T08:52:39Z: tokio_core::reactor: loop time - Instant { tv_sec: 921016, tv_nsec: 573945213 }
Oct 11 08:52:39.251 INFO kablam! DEBUG 2018-10-11T08:52:39Z: tokio_core::reactor: loop process, 38.172µs
Oct 11 08:52:39.251 INFO kablam! DEBUG 2018-10-11T08:52:39Z: hyper::client::dns: resolving host="status.example.com.local", port=80
Oct 11 08:52:39.251 INFO kablam! ERROR 2018-10-11T08:52:39Z: 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
Oct 11 08:52:39.251 INFO kablam!  WARN 2018-10-11T08:52:39Z: vigil_reporter: Vigil Reporter: Last report failed, trying again sooner than usual
Oct 11 08:52:39.251 INFO kablam! DEBUG 2018-10-11T08:52:39Z: tokio_core::reactor: loop poll - 996.03µs
Oct 11 08:52:39.251 INFO kablam! DEBUG 2018-10-11T08:52:39Z: tokio_core::reactor: loop time - Instant { tv_sec: 921016, tv_nsec: 575001298 }
Oct 11 08:52:39.251 INFO kablam! DEBUG 2018-10-11T08:52:39Z: tokio_core::reactor: loop process, 34.589µs
Oct 11 08:52:44.229 INFO blam! test run_and_end_valid ... ok
Oct 11 08:52:44.229 INFO blam! 
Oct 11 08:52:44.229 INFO blam! test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 11 08:52:44.229 INFO blam! 
Oct 11 08:52:44.236 INFO kablam!    Doc-tests vigil_reporter
Oct 11 08:52:58.345 INFO blam! 
Oct 11 08:52:58.345 INFO blam! running 0 tests
Oct 11 08:52:58.345 INFO blam! 
Oct 11 08:52:58.345 INFO blam! test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 11 08:52:58.346 INFO blam! 
Oct 11 08:52:58.357 INFO kablam! su: No module specific data is present
Oct 11 08:52:58.920 INFO running `"docker" "rm" "-f" "b5280de3be69bd8697fb38f1c25b01b5e4b0d614051e300edfba4e52ac44734d"`
Oct 11 08:52:59.256 INFO blam! b5280de3be69bd8697fb38f1c25b01b5e4b0d614051e300edfba4e52ac44734d