Dec 12 23:05:24.942 INFO testing twitter/rpc-perf against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 12 23:05:24.942 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 12 23:05:25.472 INFO [stdout] 92623713967da9541ac767a860825279588a3cab3181c39cfde7dca2dc1e042f
Dec 12 23:05:25.474 INFO running `"docker" "start" "-a" "92623713967da9541ac767a860825279588a3cab3181c39cfde7dca2dc1e042f"`
Dec 12 23:05:26.763 INFO [stderr] usermod: no changes
Dec 12 23:05:27.047 INFO [stderr]    Compiling num-traits v0.2.5
Dec 12 23:05:27.047 INFO [stderr]    Compiling num-integer v0.1.39
Dec 12 23:05:27.079 INFO [stderr]    Compiling num-iter v0.1.37
Dec 12 23:05:27.079 INFO [stderr]    Compiling libc v0.2.42
Dec 12 23:05:27.079 INFO [stderr]    Compiling nodrop v0.1.12
Dec 12 23:05:27.079 INFO [stderr]    Compiling adler32 v1.0.3
Dec 12 23:05:27.091 INFO [stderr]    Compiling byteorder v0.4.2
Dec 12 23:05:27.127 INFO [stderr]    Compiling rustc-serialize v0.3.24
Dec 12 23:05:28.395 INFO [stderr]    Compiling cfg-if v0.1.4
Dec 12 23:05:29.155 INFO [stderr]    Compiling encoding_index_tests v0.1.4
Dec 12 23:05:29.235 INFO [stderr]    Compiling byteorder v1.1.0
Dec 12 23:05:29.787 INFO [stderr]    Compiling odds v0.2.26
Dec 12 23:05:29.803 INFO [stderr]    Compiling serde v1.0.70
Dec 12 23:05:31.571 INFO [stderr]    Compiling build_const v0.2.1
Dec 12 23:05:31.763 INFO [stderr]    Compiling crc-core v0.1.2
Dec 12 23:05:32.275 INFO [stderr]    Compiling histogram v0.6.9
Dec 12 23:05:32.291 INFO [stderr]    Compiling matches v0.1.7
Dec 12 23:05:32.971 INFO [stderr]    Compiling inflate v0.2.0
Dec 12 23:05:33.175 INFO [stderr]    Compiling bitflags v0.7.0
Dec 12 23:05:33.999 INFO [stderr]    Compiling lazycell v0.5.1
Dec 12 23:05:34.077 INFO [stderr]    Compiling hsl v0.1.1
Dec 12 23:05:34.515 INFO [stderr]    Compiling slab v0.3.0
Dec 12 23:05:35.020 INFO [stderr]    Compiling ascii v0.7.1
Dec 12 23:05:35.315 INFO [stderr]    Compiling chunked_transfer v0.3.1
Dec 12 23:05:35.631 INFO [stderr]    Compiling unicode-width v0.1.5
Dec 12 23:05:35.653 INFO [stderr]    Compiling fnv v1.0.6
Dec 12 23:05:35.923 INFO [stderr]    Compiling getopts v0.2.15
Dec 12 23:05:36.119 INFO [stderr]    Compiling mpmc v0.1.2
Dec 12 23:05:36.395 INFO [stderr]    Compiling allan v0.2.4
Dec 12 23:05:36.663 INFO [stderr]    Compiling ratelimit v0.4.2
Dec 12 23:05:36.863 INFO [stderr]    Compiling bytes v0.3.0
Dec 12 23:05:37.211 INFO [stderr]    Compiling log v0.4.3
Dec 12 23:05:39.760 INFO [stderr]    Compiling encoding-index-simpchinese v1.20141219.5
Dec 12 23:05:41.064 INFO [stderr]    Compiling encoding-index-tradchinese v1.20141219.5
Dec 12 23:05:41.955 INFO [stderr]    Compiling encoding-index-japanese v1.20141219.5
Dec 12 23:05:43.131 INFO [stderr]    Compiling encoding-index-singlebyte v1.20141219.5
Dec 12 23:05:45.572 INFO [stderr]    Compiling encoding-index-korean v1.20141219.5
Dec 12 23:05:46.733 INFO [stderr]    Compiling stb_truetype v0.1.2
Dec 12 23:05:48.467 INFO [stderr]    Compiling deflate v0.7.18
Dec 12 23:05:49.369 INFO [stderr]    Compiling crc v1.5.0
Dec 12 23:05:49.837 INFO [stderr]    Compiling rand v0.3.17
Dec 12 23:05:49.932 INFO [stderr]    Compiling time v0.1.38
Dec 12 23:05:52.327 INFO [stderr]    Compiling iovec v0.1.2
Dec 12 23:05:52.552 INFO [stderr]    Compiling net2 v0.2.33
Dec 12 23:05:53.296 INFO [stderr]    Compiling clocksource v0.2.4
Dec 12 23:05:54.324 INFO [stderr]    Compiling shuteye v0.3.2
Dec 12 23:05:54.987 INFO [stderr]    Compiling arrayvec v0.3.25
Dec 12 23:05:55.809 INFO [stderr]    Compiling pad v0.1.4
Dec 12 23:05:59.667 INFO [stderr]    Compiling log v0.3.9
Dec 12 23:06:01.615 INFO [stderr]    Compiling encoding v0.2.33
Dec 12 23:06:03.594 INFO [stderr]    Compiling rusttype v0.1.2
Dec 12 23:06:05.999 INFO [stderr]    Compiling heatmap v0.6.6
Dec 12 23:06:06.846 INFO [stderr]    Compiling mio v0.6.10
Dec 12 23:06:08.615 INFO [stderr]    Compiling log-panics v1.1.0
Dec 12 23:06:09.111 INFO [stderr]    Compiling simple_logger v0.4.0
Dec 12 23:06:11.191 INFO [stderr]    Compiling uuid v0.1.18
Dec 12 23:06:14.135 INFO [stderr]    Compiling url v0.2.38
Dec 12 23:06:18.055 INFO [stderr]    Compiling num v0.1.42
Dec 12 23:06:18.055 INFO [stderr]    Compiling png v0.7.0
Dec 12 23:06:18.796 INFO [stderr]    Compiling chrono v0.2.25
Dec 12 23:06:24.455 INFO [stderr]    Compiling waterfall v0.7.1
Dec 12 23:06:26.519 INFO [stderr]    Compiling tiny_http v0.5.9
Dec 12 23:06:34.335 INFO [stderr]    Compiling toml v0.4.6
Dec 12 23:06:35.761 INFO [stderr]    Compiling tic v0.2.4
Dec 12 23:06:41.697 INFO [stderr]    Compiling rpc-perf v2.1.0-pre (/source)
Dec 12 23:06:52.245 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 25s
Dec 12 23:06:52.259 INFO [stderr] su: No module specific data is present
Dec 12 23:06:53.553 INFO running `"docker" "inspect" "92623713967da9541ac767a860825279588a3cab3181c39cfde7dca2dc1e042f"`
Dec 12 23:06:53.895 INFO running `"docker" "rm" "-f" "92623713967da9541ac767a860825279588a3cab3181c39cfde7dca2dc1e042f"`
Dec 12 23:06:54.283 INFO [stdout] 92623713967da9541ac767a860825279588a3cab3181c39cfde7dca2dc1e042f
Dec 12 23:06:54.291 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 12 23:06:54.881 INFO [stdout] 5448b04623d7d02956d6606fe74fe45d07f7ef4c1e093d84e79e8d91061afc89
Dec 12 23:06:54.883 INFO running `"docker" "start" "-a" "5448b04623d7d02956d6606fe74fe45d07f7ef4c1e093d84e79e8d91061afc89"`
Dec 12 23:06:56.855 INFO [stderr] usermod: no changes
Dec 12 23:06:57.015 INFO [stderr]    Compiling rpc-perf v2.1.0-pre (/source)
Dec 12 23:07:03.149 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.26s
Dec 12 23:07:03.157 INFO [stderr] su: No module specific data is present
Dec 12 23:07:04.761 INFO running `"docker" "inspect" "5448b04623d7d02956d6606fe74fe45d07f7ef4c1e093d84e79e8d91061afc89"`
Dec 12 23:07:05.101 INFO running `"docker" "rm" "-f" "5448b04623d7d02956d6606fe74fe45d07f7ef4c1e093d84e79e8d91061afc89"`
Dec 12 23:07:05.475 INFO [stdout] 5448b04623d7d02956d6606fe74fe45d07f7ef4c1e093d84e79e8d91061afc89
Dec 12 23:07:05.477 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 12 23:07:05.928 INFO [stdout] e5ae10569da38c8f1e945585950e1cf4f74248d974a1a5f83a39d2e342fec964
Dec 12 23:07:05.930 INFO running `"docker" "start" "-a" "e5ae10569da38c8f1e945585950e1cf4f74248d974a1a5f83a39d2e342fec964"`
Dec 12 23:07:08.012 INFO [stderr] usermod: no changes
Dec 12 23:07:08.183 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.16s
Dec 12 23:07:08.203 INFO [stderr]      Running /target/debug/deps/rpc_perf-377d73c9ef1f7c1b
Dec 12 23:07:08.207 INFO [stdout] 
Dec 12 23:07:08.214 INFO [stdout] running 73 tests
Dec 12 23:07:08.233 INFO [stdout] test codec::echo::parse::tests::test_parse_error ... ok
Dec 12 23:07:08.233 INFO [stdout] test codec::echo::parse::tests::test_parse_ok ... ok
Dec 12 23:07:08.233 INFO [stdout] test codec::memcache::gen::tests::test_add ... ok
Dec 12 23:07:08.233 INFO [stdout] test codec::echo::parse::tests::test_parse_incomplete ... ok
Dec 12 23:07:08.233 INFO [stdout] test codec::echo::gen::tests::echo_test ... ok
Dec 12 23:07:08.233 INFO [stdout] test codec::memcache::gen::tests::test_append ... ok
Dec 12 23:07:08.233 INFO [stdout] test codec::memcache::gen::tests::test_cas ... ok
Dec 12 23:07:08.233 INFO [stdout] test codec::memcache::gen::tests::test_gets ... ok
Dec 12 23:07:08.234 INFO [stdout] test codec::memcache::gen::tests::test_incr ... ok
Dec 12 23:07:08.234 INFO [stdout] test codec::memcache::gen::tests::test_quit ... ok
Dec 12 23:07:08.234 INFO [stdout] test codec::memcache::gen::tests::test_prepend ... ok
Dec 12 23:07:08.234 INFO [stdout] test codec::memcache::gen::tests::test_get ... ok
Dec 12 23:07:08.234 INFO [stdout] test codec::memcache::gen::tests::test_flush_all ... ok
Dec 12 23:07:08.234 INFO [stdout] test codec::memcache::gen::tests::test_delete ... ok
Dec 12 23:07:08.234 INFO [stdout] test codec::memcache::gen::tests::test_decr ... ok
Dec 12 23:07:08.234 INFO [stdout] test codec::memcache::gen::tests::test_replace ... ok
Dec 12 23:07:08.234 INFO [stdout] test codec::memcache::gen::tests::test_set ... ok
Dec 12 23:07:08.234 INFO [stdout] test codec::memcache::gen::tests::test_touch ... ok
Dec 12 23:07:08.235 INFO [stdout] test codec::memcache::gen::tests::test_verbosity ... ok
Dec 12 23:07:08.235 INFO [stdout] test codec::memcache::gen::tests::test_version ... ok
Dec 12 23:07:08.243 INFO [stdout] test codec::memcache::parse::tests::test_parse_version ... ok
Dec 12 23:07:08.243 INFO [stdout] test codec::ping::gen::tests::test_ping ... ok
Dec 12 23:07:08.243 INFO [stdout] test codec::memcache::parse::tests::test_parse_error ... ok
Dec 12 23:07:08.244 INFO [stdout] test codec::memcache::parse::tests::test_parse_miss ... ok
Dec 12 23:07:08.244 INFO [stdout] test codec::memcache::parse::tests::test_parse_incomplete ... ok
Dec 12 23:07:08.244 INFO [stdout] test codec::memcache::parse::tests::test_parse_invalid ... ok
Dec 12 23:07:08.244 INFO [stdout] test codec::memcache::parse::tests::test_parse_ok ... ok
Dec 12 23:07:08.244 INFO [stdout] test codec::redis_inline::gen::tests::test_append ... ok
Dec 12 23:07:08.244 INFO [stdout] test codec::redis_inline::gen::tests::test_decr ... ok
Dec 12 23:07:08.244 INFO [stdout] test codec::ping::parse::tests::test_parse_pong ... ok
Dec 12 23:07:08.244 INFO [stdout] test codec::redis_inline::gen::tests::test_del ... ok
Dec 12 23:07:08.244 INFO [stdout] test codec::redis_inline::gen::tests::test_flushall ... ok
Dec 12 23:07:08.244 INFO [stdout] test codec::redis_inline::gen::tests::test_get ... ok
Dec 12 23:07:08.244 INFO [stdout] test codec::redis_inline::gen::tests::test_hget ... ok
Dec 12 23:07:08.245 INFO [stdout] test codec::redis_inline::gen::tests::test_hset ... ok
Dec 12 23:07:08.245 INFO [stdout] test codec::redis_inline::gen::tests::test_incr ... ok
Dec 12 23:07:08.245 INFO [stdout] test codec::redis_inline::parse::tests::test_parse_error ... ok
Dec 12 23:07:08.245 INFO [stdout] test codec::redis_inline::gen::tests::test_prepend ... ok
Dec 12 23:07:08.245 INFO [stdout] test codec::redis_inline::parse::tests::test_parse_incomplete ... ok
Dec 12 23:07:08.245 INFO [stdout] test codec::redis_inline::parse::tests::test_parse_invalid ... ok
Dec 12 23:07:08.245 INFO [stdout] test codec::redis_resp::gen::tests::test_decr ... ok
Dec 12 23:07:08.246 INFO [stdout] test codec::redis_resp::gen::tests::test_expire ... ok
Dec 12 23:07:08.246 INFO [stdout] test codec::redis_resp::gen::tests::test_flushall ... ok
Dec 12 23:07:08.246 INFO [stdout] test codec::redis_resp::gen::tests::test_get ... ok
Dec 12 23:07:08.246 INFO [stdout] test codec::redis_inline::parse::tests::test_parse_miss ... ok
Dec 12 23:07:08.249 INFO [stdout] test codec::redis_inline::parse::tests::test_parse_ok ... ok
Dec 12 23:07:08.249 INFO [stdout] test codec::redis_resp::gen::tests::test_del ... ok
Dec 12 23:07:08.249 INFO [stdout] test codec::redis_resp::gen::tests::test_hget ... ok
Dec 12 23:07:08.249 INFO [stdout] test codec::redis_resp::gen::tests::test_hset ... ok
Dec 12 23:07:08.249 INFO [stdout] test codec::redis_resp::gen::tests::test_prepend ... ok
Dec 12 23:07:08.249 INFO [stdout] test codec::redis_resp::gen::tests::test_incr ... ok
Dec 12 23:07:08.249 INFO [stdout] test codec::redis_resp::gen::tests::test_select ... ok
Dec 12 23:07:08.249 INFO [stdout] test codec::redis_resp::gen::tests::test_set ... ok
Dec 12 23:07:08.249 INFO [stdout] test codec::redis_resp::gen::tests::test_append ... ok
Dec 12 23:07:08.249 INFO [stdout] test codec::redis_resp::parse::tests::test_parse_error ... ok
Dec 12 23:07:08.249 INFO [stdout] test codec::redis_inline::gen::tests::test_expire ... ok
Dec 12 23:07:08.249 INFO [stdout] test codec::redis_resp::parse::tests::test_parse_incomplete ... ok
Dec 12 23:07:08.249 INFO [stdout] test codec::redis_resp::parse::tests::test_parse_invalid ... ok
Dec 12 23:07:08.249 INFO [stdout] test codec::redis_inline::gen::tests::test_set ... ok
Dec 12 23:07:08.249 INFO [stdout] test codec::thrift::buffer::tests::test_stop ... ok
Dec 12 23:07:08.249 INFO [stdout] test codec::redis_resp::parse::tests::test_parse_miss ... ok
Dec 12 23:07:08.249 INFO [stdout] test codec::thrift::buffer::tests::test_protocol_header ... ok
Dec 12 23:07:08.249 INFO [stdout] test codec::redis_resp::parse::tests::test_parse_ok ... ok
Dec 12 23:07:08.249 INFO [stdout] test codec::thrift::buffer::tests::test_sequence_id ... ok
Dec 12 23:07:08.249 INFO [stdout] test codec::thrift::gen::test::thrift_ping ... ok
Dec 12 23:07:08.249 INFO [stdout] test codec::thrift::parse::tests::test_parse_ok ... ok
Dec 12 23:07:08.251 INFO [stdout] test codec::thrift::config::test_load_config ... ok
Dec 12 23:07:08.251 INFO [stdout] test codec::thrift::buffer::tests::test_method_name ... ok
Dec 12 23:07:08.251 INFO [stdout] test codec::thrift::gen::test::test_ping ... ok
Dec 12 23:07:08.251 INFO [stdout] test codec::thrift::testutil::thrift_subtract ... ok
Dec 12 23:07:08.251 INFO [stdout] test codec::thrift::buffer::tests::into_vec ... ok
Dec 12 23:07:08.251 INFO [stdout] test codec::thrift::parse::tests::test_parse_incomplete ... ok
Dec 12 23:07:08.251 INFO [stdout] test codec::thrift::testutil::thrift_add ... ok
Dec 12 23:07:08.251 INFO [stdout] 
Dec 12 23:07:08.251 INFO [stdout] test result: ok. 73 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 12 23:07:08.251 INFO [stdout] 
Dec 12 23:07:08.271 INFO [stderr] su: No module specific data is present
Dec 12 23:07:09.579 INFO running `"docker" "inspect" "e5ae10569da38c8f1e945585950e1cf4f74248d974a1a5f83a39d2e342fec964"`
Dec 12 23:07:09.897 INFO running `"docker" "rm" "-f" "e5ae10569da38c8f1e945585950e1cf4f74248d974a1a5f83a39d2e342fec964"`
Dec 12 23:07:10.203 INFO [stdout] e5ae10569da38c8f1e945585950e1cf4f74248d974a1a5f83a39d2e342fec964