Dec 05 12:28:08.237 INFO testing nuclearfurnace/synchrotron against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514 Dec 05 12:28:08.237 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 12:28:08.466 INFO [stdout] 0e92c95d95086607748538e98d236872127470ad2a078f89195028b2e0e289df Dec 05 12:28:08.468 INFO running `"docker" "start" "-a" "0e92c95d95086607748538e98d236872127470ad2a078f89195028b2e0e289df"` Dec 05 12:28:08.883 INFO [stderr] usermod: no changes Dec 05 12:28:09.165 INFO [stderr] Compiling slog v2.4.1 Dec 05 12:28:09.165 INFO [stderr] Compiling arc-swap v0.3.0 Dec 05 12:28:09.166 INFO [stderr] Compiling synchrotron v0.1.0 (/source) Dec 05 12:28:09.172 INFO [stderr] Compiling log v0.4.6 Dec 05 12:28:09.172 INFO [stderr] Compiling crossbeam-utils v0.3.2 Dec 05 12:28:09.172 INFO [stderr] Compiling futures-turnstyle v3.0.0 Dec 05 12:28:09.172 INFO [stderr] Compiling crossbeam-epoch v0.6.0 Dec 05 12:28:09.172 INFO [stderr] Compiling bytes v0.4.11 Dec 05 12:28:10.568 INFO [stderr] Compiling parking_lot_core v0.4.0 Dec 05 12:28:10.568 INFO [stderr] Compiling crossbeam-deque v0.5.2 Dec 05 12:28:10.568 INFO [stderr] Compiling mio v0.6.16 Dec 05 12:28:10.574 INFO [stderr] Compiling log v0.3.9 Dec 05 12:28:10.589 INFO [stderr] Compiling crossbeam-epoch v0.4.3 Dec 05 12:28:10.936 INFO [stderr] Compiling tokio-evacuate v1.1.0 Dec 05 12:28:11.774 INFO [stderr] Compiling generic-array v0.8.3 Dec 05 12:28:11.789 INFO [stderr] Compiling btoi v0.4.0 Dec 05 12:28:11.791 INFO [stderr] Compiling serde_json v1.0.33 Dec 05 12:28:11.797 INFO [stderr] Compiling rust-crypto v0.2.36 Dec 05 12:28:11.799 INFO [stderr] Compiling tokio-threadpool v0.1.7 Dec 05 12:28:11.826 INFO [stderr] Compiling nom v4.1.0 Dec 05 12:28:13.122 INFO [stderr] Compiling signal-hook v0.1.5 Dec 05 12:28:13.189 INFO [stderr] Compiling flate2 v1.0.3 Dec 05 12:28:13.380 INFO [stderr] Compiling tokio-io v0.1.9 Dec 05 12:28:20.236 INFO [stderr] Compiling regex v1.0.5 Dec 05 12:28:20.296 INFO [stderr] Compiling digest v0.6.2 Dec 05 12:28:20.503 INFO [stderr] Compiling crossbeam-arccell v0.6.4 Dec 05 12:28:20.612 INFO [stderr] Compiling serde_derive v1.0.80 Dec 05 12:28:21.144 INFO [stderr] Compiling rand v0.6.1 Dec 05 12:28:21.176 INFO [stderr] Compiling mio-uds v0.6.7 Dec 05 12:28:21.356 INFO [stderr] Compiling hdrhistogram v6.1.0 Dec 05 12:28:22.572 INFO [stderr] Compiling tokio-codec v0.1.1 Dec 05 12:28:24.484 INFO [stderr] Compiling config v0.9.1 Dec 05 12:28:24.510 INFO [stderr] Compiling tokio-reactor v0.1.6 Dec 05 12:28:27.251 INFO [stderr] Compiling crossbeam-channel v0.2.6 Dec 05 12:28:27.356 INFO [stderr] Compiling pruefung v0.2.1 Dec 05 12:28:29.148 INFO [stderr] Compiling tokio-fs v0.1.3 Dec 05 12:28:35.932 INFO [stderr] Compiling slog-scope v4.0.1 Dec 05 12:28:35.992 INFO [stderr] Compiling slog-term v2.4.0 Dec 05 12:28:37.017 INFO [stderr] Compiling slog-async v2.3.0 Dec 05 12:28:49.065 INFO [stderr] Compiling crossbeam v0.4.1 Dec 05 12:28:49.147 INFO [stderr] Compiling tokio-tcp v0.1.2 Dec 05 12:28:49.812 INFO [stderr] Compiling tokio-udp v0.1.2 Dec 05 12:28:49.840 INFO [stderr] Compiling tokio-uds v0.2.2 Dec 05 12:28:50.392 INFO [stderr] Compiling slog-stdlog v3.0.2 Dec 05 12:28:52.736 INFO [stderr] Compiling env_logger v0.5.13 Dec 05 12:28:54.996 INFO [stderr] Compiling parking_lot v0.7.0 Dec 05 12:28:56.744 INFO [stderr] Compiling tokio v0.1.11 Dec 05 12:28:58.244 INFO [stderr] Compiling hotmic v0.2.1 Dec 05 12:29:07.817 INFO [stderr] Compiling tokio-io-pool v0.1.4 Dec 05 12:29:14.656 INFO [stderr] warning: unused variable: `client_addr` Dec 05 12:29:14.656 INFO [stderr] --> src/listener.rs:194:17 Dec 05 12:29:14.656 INFO [stderr] | Dec 05 12:29:14.656 INFO [stderr] 194 | let client_addr = client.peer_addr().unwrap(); Dec 05 12:29:14.656 INFO [stderr] | ^^^^^^^^^^^ help: consider using `_client_addr` instead Dec 05 12:29:14.656 INFO [stderr] | Dec 05 12:29:14.656 INFO [stderr] = note: #[warn(unused_variables)] on by default Dec 05 12:29:14.656 INFO [stderr] Dec 05 12:29:15.188 INFO [stderr] warning: method is never used: `update_latency` Dec 05 12:29:15.188 INFO [stderr] --> src/metrics/mod.rs:102:5 Dec 05 12:29:15.188 INFO [stderr] | Dec 05 12:29:15.188 INFO [stderr] 102 | pub fn update_latency(&mut self, key: Metrics, start: Instant, stop: Instant) { Dec 05 12:29:15.188 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 05 12:29:15.188 INFO [stderr] | Dec 05 12:29:15.188 INFO [stderr] = note: #[warn(dead_code)] on by default Dec 05 12:29:15.188 INFO [stderr] Dec 05 12:29:29.712 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 1m 20s Dec 05 12:29:29.727 INFO [stderr] su: No module specific data is present Dec 05 12:29:31.004 INFO running `"docker" "inspect" "0e92c95d95086607748538e98d236872127470ad2a078f89195028b2e0e289df"` Dec 05 12:29:31.328 INFO running `"docker" "rm" "-f" "0e92c95d95086607748538e98d236872127470ad2a078f89195028b2e0e289df"` Dec 05 12:29:31.572 INFO [stdout] 0e92c95d95086607748538e98d236872127470ad2a078f89195028b2e0e289df Dec 05 12:29:31.578 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 12:29:32.031 INFO [stdout] 5ed79832f298b42d3700dd7a4f5bd5307a924c3a30b2d1857b6b1307329fc40e Dec 05 12:29:32.033 INFO running `"docker" "start" "-a" "5ed79832f298b42d3700dd7a4f5bd5307a924c3a30b2d1857b6b1307329fc40e"` Dec 05 12:29:34.440 INFO [stderr] usermod: no changes Dec 05 12:29:34.858 INFO [stderr] Compiling spectral v0.6.0 Dec 05 12:29:36.385 INFO [stderr] Compiling synchrotron v0.1.0 (/source) Dec 05 12:29:39.576 INFO [stderr] warning: unused variable: `client_addr` Dec 05 12:29:39.576 INFO [stderr] --> src/listener.rs:194:17 Dec 05 12:29:39.576 INFO [stderr] | Dec 05 12:29:39.576 INFO [stderr] 194 | let client_addr = client.peer_addr().unwrap(); Dec 05 12:29:39.576 INFO [stderr] | ^^^^^^^^^^^ help: consider using `_client_addr` instead Dec 05 12:29:39.576 INFO [stderr] | Dec 05 12:29:39.576 INFO [stderr] = note: #[warn(unused_variables)] on by default Dec 05 12:29:39.576 INFO [stderr] Dec 05 12:29:40.207 INFO [stderr] warning: method is never used: `update_latency` Dec 05 12:29:40.207 INFO [stderr] --> src/metrics/mod.rs:102:5 Dec 05 12:29:40.208 INFO [stderr] | Dec 05 12:29:40.208 INFO [stderr] 102 | pub fn update_latency(&mut self, key: Metrics, start: Instant, stop: Instant) { Dec 05 12:29:40.208 INFO [stderr] | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ Dec 05 12:29:40.208 INFO [stderr] | Dec 05 12:29:40.208 INFO [stderr] = note: #[warn(dead_code)] on by default Dec 05 12:29:40.208 INFO [stderr] Dec 05 12:29:43.749 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 9.28s Dec 05 12:29:43.764 INFO [stderr] su: No module specific data is present Dec 05 12:29:45.014 INFO running `"docker" "inspect" "5ed79832f298b42d3700dd7a4f5bd5307a924c3a30b2d1857b6b1307329fc40e"` Dec 05 12:29:45.374 INFO running `"docker" "rm" "-f" "5ed79832f298b42d3700dd7a4f5bd5307a924c3a30b2d1857b6b1307329fc40e"` Dec 05 12:29:45.661 INFO [stdout] 5ed79832f298b42d3700dd7a4f5bd5307a924c3a30b2d1857b6b1307329fc40e Dec 05 12:29:45.668 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 12:29:46.263 INFO [stdout] 857c5020d52fcb05ee20448d667fd664392898fa0131809bf4cad2aa20da53c3 Dec 05 12:29:46.265 INFO running `"docker" "start" "-a" "857c5020d52fcb05ee20448d667fd664392898fa0131809bf4cad2aa20da53c3"` Dec 05 12:29:49.239 INFO [stderr] usermod: no changes Dec 05 12:29:49.665 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.40s Dec 05 12:29:49.679 INFO [stderr] Running /target/debug/deps/synchrotron-b68bfffda40fdcc1 Dec 05 12:29:49.689 INFO [stdout] Dec 05 12:29:49.689 INFO [stdout] running 26 tests Dec 05 12:29:49.719 INFO [stdout] test protocol::redis::tests::bench_ping_lower ... ok Dec 05 12:29:49.719 INFO [stdout] test protocol::redis::tests::bench_ping_upper ... ok Dec 05 12:29:49.719 INFO [stdout] test backend::redis::tests::test_is_multi_message ... ok Dec 05 12:29:49.719 INFO [stdout] test backend::redis::tests::test_get_data_buffer ... ok Dec 05 12:29:49.719 INFO [stdout] test protocol::redis::tests::bench_short_circuit_0_zero_data ... ok Dec 05 12:29:49.720 INFO [stdout] test protocol::redis::tests::bench_parse_get_simple ... ok Dec 05 12:29:49.720 INFO [stdout] test protocol::redis::tests::bench_short_circuit_1_no_array_crlf ... ok Dec 05 12:29:49.720 INFO [stdout] test protocol::redis::tests::bench_short_circuit_4_missing_arg ... ok Dec 05 12:29:49.720 INFO [stdout] test protocol::redis::tests::parse_get_simple ... ok Dec 05 12:29:49.720 INFO [stdout] test protocol::redis::tests::bench_short_circuit_3_partial_arg ... ok Dec 05 12:29:49.720 INFO [stdout] test protocol::redis::tests::bench_short_circuit_5_arg_len_past_end ... ok Dec 05 12:29:49.720 INFO [stdout] test protocol::redis::tests::bench_short_circuit_2_no_arg_len_crlf ... ok Dec 05 12:29:49.720 INFO [stdout] test protocol::redis::tests::parse_ping ... ok Dec 05 12:29:49.720 INFO [stdout] test protocol::redis::tests::parse_ok ... ok Dec 05 12:29:49.720 INFO [stdout] test protocol::redis::tests::parse_quit ... ok Dec 05 12:29:49.720 INFO [stdout] test protocol::redis::tests::parse_short_circuit_arg_len_past_end ... ok Dec 05 12:29:49.720 INFO [stdout] test protocol::redis::tests::parse_null ... ok Dec 05 12:29:49.720 INFO [stdout] test protocol::redis::tests::parse_short_circuit_missing_arg ... ok Dec 05 12:29:49.724 INFO [stdout] test protocol::redis::tests::parse_short_circuit_no_arg_len_crlf ... ok Dec 05 12:29:49.724 INFO [stdout] test protocol::redis::tests::parse_short_circuit_partial_arg ... ok Dec 05 12:29:49.724 INFO [stdout] test protocol::redis::tests::parse_integer ... ok Dec 05 12:29:49.724 INFO [stdout] test protocol::redis::tests::parse_short_circuit_no_array_crlf ... ok Dec 05 12:29:49.730 INFO [stdout] test protocol::redis::tests::parse_status ... ok Dec 05 12:29:49.730 INFO [stdout] test protocol::redis::tests::parse_short_circuit_zero_data ... ok Dec 05 12:29:49.731 INFO [stdout] test protocol::redis::tests::parse_error ... ok Dec 05 12:29:49.736 INFO [stdout] test protocol::redis::tests::parse_bulk_with_null ... ok Dec 05 12:29:49.736 INFO [stdout] Dec 05 12:29:49.736 INFO [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 05 12:29:49.736 INFO [stdout] Dec 05 12:29:49.748 INFO [stderr] su: No module specific data is present Dec 05 12:29:51.328 INFO running `"docker" "inspect" "857c5020d52fcb05ee20448d667fd664392898fa0131809bf4cad2aa20da53c3"` Dec 05 12:29:51.700 INFO running `"docker" "rm" "-f" "857c5020d52fcb05ee20448d667fd664392898fa0131809bf4cad2aa20da53c3"` Dec 05 12:29:52.112 INFO [stdout] 857c5020d52fcb05ee20448d667fd664392898fa0131809bf4cad2aa20da53c3