Dec 05 03:26:52.065 INFO testing twitter/rpc-perf against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 05 03:26:52.065 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 03:26:52.450 INFO [stdout] bdc8499254f5fec49d35ec9e24211886c2936c2d16e80edea9cf9343f87c0eea
Dec 05 03:26:52.452 INFO running `"docker" "start" "-a" "bdc8499254f5fec49d35ec9e24211886c2936c2d16e80edea9cf9343f87c0eea"`
Dec 05 03:26:53.824 INFO [stderr] usermod: no changes
Dec 05 03:26:54.034 INFO [stderr]    Compiling num-traits v0.2.5
Dec 05 03:26:54.034 INFO [stderr]    Compiling num-integer v0.1.39
Dec 05 03:26:54.034 INFO [stderr]    Compiling num-iter v0.1.37
Dec 05 03:26:54.034 INFO [stderr]    Compiling libc v0.2.42
Dec 05 03:26:54.034 INFO [stderr]    Compiling encoding_index_tests v0.1.4
Dec 05 03:26:54.034 INFO [stderr]    Compiling cfg-if v0.1.4
Dec 05 03:26:54.034 INFO [stderr]    Compiling adler32 v1.0.3
Dec 05 03:26:54.040 INFO [stderr]    Compiling byteorder v1.1.0
Dec 05 03:26:54.532 INFO [stderr]    Compiling byteorder v0.4.2
Dec 05 03:26:55.007 INFO [stderr]    Compiling nodrop v0.1.12
Dec 05 03:26:55.556 INFO [stderr]    Compiling odds v0.2.26
Dec 05 03:26:56.177 INFO [stderr]    Compiling rustc-serialize v0.3.24
Dec 05 03:26:57.674 INFO [stderr]    Compiling build_const v0.2.1
Dec 05 03:26:57.703 INFO [stderr]    Compiling bitflags v0.7.0
Dec 05 03:26:58.377 INFO [stderr]    Compiling histogram v0.6.9
Dec 05 03:26:58.905 INFO [stderr]    Compiling matches v0.1.7
Dec 05 03:26:58.907 INFO [stderr]    Compiling crc-core v0.1.2
Dec 05 03:26:59.026 INFO [stderr]    Compiling inflate v0.2.0
Dec 05 03:26:59.304 INFO [stderr]    Compiling serde v1.0.70
Dec 05 03:26:59.776 INFO [stderr]    Compiling chunked_transfer v0.3.1
Dec 05 03:27:00.336 INFO [stderr]    Compiling ascii v0.7.1
Dec 05 03:27:01.130 INFO [stderr]    Compiling lazycell v0.5.1
Dec 05 03:27:01.504 INFO [stderr]    Compiling hsl v0.1.1
Dec 05 03:27:01.616 INFO [stderr]    Compiling slab v0.3.0
Dec 05 03:27:02.136 INFO [stderr]    Compiling allan v0.2.4
Dec 05 03:27:02.628 INFO [stderr]    Compiling fnv v1.0.6
Dec 05 03:27:02.628 INFO [stderr]    Compiling mpmc v0.1.2
Dec 05 03:27:02.628 INFO [stderr]    Compiling getopts v0.2.15
Dec 05 03:27:02.844 INFO [stderr]    Compiling unicode-width v0.1.5
Dec 05 03:27:03.561 INFO [stderr]    Compiling ratelimit v0.4.2
Dec 05 03:27:03.974 INFO [stderr]    Compiling bytes v0.3.0
Dec 05 03:27:04.148 INFO [stderr]    Compiling log v0.4.3
Dec 05 03:27:06.517 INFO [stderr]    Compiling encoding-index-japanese v1.20141219.5
Dec 05 03:27:07.176 INFO [stderr]    Compiling encoding-index-tradchinese v1.20141219.5
Dec 05 03:27:07.478 INFO [stderr]    Compiling encoding-index-singlebyte v1.20141219.5
Dec 05 03:27:09.244 INFO [stderr]    Compiling encoding-index-simpchinese v1.20141219.5
Dec 05 03:27:09.358 INFO [stderr]    Compiling encoding-index-korean v1.20141219.5
Dec 05 03:27:13.344 INFO [stderr]    Compiling stb_truetype v0.1.2
Dec 05 03:27:13.850 INFO [stderr]    Compiling deflate v0.7.18
Dec 05 03:27:15.002 INFO [stderr]    Compiling crc v1.5.0
Dec 05 03:27:15.479 INFO [stderr]    Compiling rand v0.3.17
Dec 05 03:27:15.822 INFO [stderr]    Compiling time v0.1.38
Dec 05 03:27:15.833 INFO [stderr]    Compiling iovec v0.1.2
Dec 05 03:27:17.871 INFO [stderr]    Compiling net2 v0.2.33
Dec 05 03:27:18.210 INFO [stderr]    Compiling clocksource v0.2.4
Dec 05 03:27:20.306 INFO [stderr]    Compiling shuteye v0.3.2
Dec 05 03:27:20.504 INFO [stderr]    Compiling arrayvec v0.3.25
Dec 05 03:27:21.712 INFO [stderr]    Compiling pad v0.1.4
Dec 05 03:27:25.097 INFO [stderr]    Compiling log v0.3.9
Dec 05 03:27:25.642 INFO [stderr]    Compiling encoding v0.2.33
Dec 05 03:27:29.089 INFO [stderr]    Compiling heatmap v0.6.6
Dec 05 03:27:30.808 INFO [stderr]    Compiling rusttype v0.1.2
Dec 05 03:27:33.016 INFO [stderr]    Compiling mio v0.6.10
Dec 05 03:27:33.632 INFO [stderr]    Compiling log-panics v1.1.0
Dec 05 03:27:35.760 INFO [stderr]    Compiling simple_logger v0.4.0
Dec 05 03:27:42.428 INFO [stderr]    Compiling uuid v0.1.18
Dec 05 03:27:45.748 INFO [stderr]    Compiling url v0.2.38
Dec 05 03:27:46.388 INFO [stderr]    Compiling num v0.1.42
Dec 05 03:27:46.399 INFO [stderr]    Compiling png v0.7.0
Dec 05 03:27:47.132 INFO [stderr]    Compiling chrono v0.2.25
Dec 05 03:27:54.328 INFO [stderr]    Compiling waterfall v0.7.1
Dec 05 03:27:54.592 INFO [stderr]    Compiling tiny_http v0.5.9
Dec 05 03:28:04.793 INFO [stderr]    Compiling tic v0.2.4
Dec 05 03:28:05.960 INFO [stderr]    Compiling toml v0.4.6
Dec 05 03:28:12.384 INFO [stderr]    Compiling rpc-perf v2.1.0-pre (/source)
Dec 05 03:28:23.075 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 29s
Dec 05 03:28:23.092 INFO [stderr] su: No module specific data is present
Dec 05 03:28:24.260 INFO running `"docker" "inspect" "bdc8499254f5fec49d35ec9e24211886c2936c2d16e80edea9cf9343f87c0eea"`
Dec 05 03:28:24.588 INFO running `"docker" "rm" "-f" "bdc8499254f5fec49d35ec9e24211886c2936c2d16e80edea9cf9343f87c0eea"`
Dec 05 03:28:24.860 INFO [stdout] bdc8499254f5fec49d35ec9e24211886c2936c2d16e80edea9cf9343f87c0eea
Dec 05 03:28:24.864 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 03:28:25.496 INFO [stdout] fe0b34e3eaaf002568b444ac7b928a82d6e138343ec6dbbc8c84f1e9f6e46198
Dec 05 03:28:25.500 INFO running `"docker" "start" "-a" "fe0b34e3eaaf002568b444ac7b928a82d6e138343ec6dbbc8c84f1e9f6e46198"`
Dec 05 03:28:27.281 INFO [stderr] usermod: no changes
Dec 05 03:28:27.465 INFO [stderr]    Compiling rpc-perf v2.1.0-pre (/source)
Dec 05 03:28:32.730 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.41s
Dec 05 03:28:32.738 INFO [stderr] su: No module specific data is present
Dec 05 03:28:33.688 INFO running `"docker" "inspect" "fe0b34e3eaaf002568b444ac7b928a82d6e138343ec6dbbc8c84f1e9f6e46198"`
Dec 05 03:28:33.976 INFO running `"docker" "rm" "-f" "fe0b34e3eaaf002568b444ac7b928a82d6e138343ec6dbbc8c84f1e9f6e46198"`
Dec 05 03:28:34.236 INFO [stdout] fe0b34e3eaaf002568b444ac7b928a82d6e138343ec6dbbc8c84f1e9f6e46198
Dec 05 03:28:34.242 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 03:28:34.770 INFO [stdout] 0afd8ba1a14a709aa5fe23f3559d5e44571ad65c2d4f2f9f2a35f41746b22789
Dec 05 03:28:34.772 INFO running `"docker" "start" "-a" "0afd8ba1a14a709aa5fe23f3559d5e44571ad65c2d4f2f9f2a35f41746b22789"`
Dec 05 03:28:36.040 INFO [stderr] usermod: no changes
Dec 05 03:28:36.296 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.22s
Dec 05 03:28:36.316 INFO [stderr]      Running /target/debug/deps/rpc_perf-b3175e1845d20117
Dec 05 03:28:36.316 INFO [stdout] 
Dec 05 03:28:36.316 INFO [stdout] running 73 tests
Dec 05 03:28:36.316 INFO [stdout] test codec::memcache::gen::tests::test_cas ... ok
Dec 05 03:28:36.317 INFO [stdout] test codec::memcache::gen::tests::test_decr ... ok
Dec 05 03:28:36.317 INFO [stdout] test codec::memcache::gen::tests::test_append ... ok
Dec 05 03:28:36.317 INFO [stdout] test codec::memcache::gen::tests::test_add ... ok
Dec 05 03:28:36.317 INFO [stdout] test codec::echo::parse::tests::test_parse_ok ... ok
Dec 05 03:28:36.317 INFO [stdout] test codec::echo::parse::tests::test_parse_incomplete ... ok
Dec 05 03:28:36.317 INFO [stdout] test codec::memcache::gen::tests::test_delete ... ok
Dec 05 03:28:36.317 INFO [stdout] test codec::memcache::gen::tests::test_flush_all ... ok
Dec 05 03:28:36.317 INFO [stdout] test codec::memcache::gen::tests::test_get ... ok
Dec 05 03:28:36.317 INFO [stdout] test codec::echo::parse::tests::test_parse_error ... ok
Dec 05 03:28:36.317 INFO [stdout] test codec::memcache::gen::tests::test_gets ... ok
Dec 05 03:28:36.317 INFO [stdout] test codec::memcache::gen::tests::test_incr ... ok
Dec 05 03:28:36.317 INFO [stdout] test codec::echo::gen::tests::echo_test ... ok
Dec 05 03:28:36.317 INFO [stdout] test codec::memcache::gen::tests::test_prepend ... ok
Dec 05 03:28:36.317 INFO [stdout] test codec::memcache::gen::tests::test_quit ... ok
Dec 05 03:28:36.317 INFO [stdout] test codec::memcache::gen::tests::test_replace ... ok
Dec 05 03:28:36.317 INFO [stdout] test codec::memcache::gen::tests::test_set ... ok
Dec 05 03:28:36.317 INFO [stdout] test codec::memcache::gen::tests::test_touch ... ok
Dec 05 03:28:36.317 INFO [stdout] test codec::memcache::gen::tests::test_verbosity ... ok
Dec 05 03:28:36.317 INFO [stdout] test codec::memcache::gen::tests::test_version ... ok
Dec 05 03:28:36.317 INFO [stdout] test codec::memcache::parse::tests::test_parse_error ... ok
Dec 05 03:28:36.317 INFO [stdout] test codec::memcache::parse::tests::test_parse_incomplete ... ok
Dec 05 03:28:36.317 INFO [stdout] test codec::memcache::parse::tests::test_parse_invalid ... ok
Dec 05 03:28:36.324 INFO [stdout] test codec::memcache::parse::tests::test_parse_miss ... ok
Dec 05 03:28:36.324 INFO [stdout] test codec::memcache::parse::tests::test_parse_ok ... ok
Dec 05 03:28:36.324 INFO [stdout] test codec::memcache::parse::tests::test_parse_version ... ok
Dec 05 03:28:36.324 INFO [stdout] test codec::ping::gen::tests::test_ping ... ok
Dec 05 03:28:36.324 INFO [stdout] test codec::ping::parse::tests::test_parse_pong ... ok
Dec 05 03:28:36.324 INFO [stdout] test codec::redis_inline::gen::tests::test_flushall ... ok
Dec 05 03:28:36.324 INFO [stdout] test codec::redis_inline::gen::tests::test_append ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_inline::gen::tests::test_decr ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_inline::gen::tests::test_get ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_inline::gen::tests::test_hget ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_inline::gen::tests::test_hset ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_inline::gen::tests::test_incr ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_inline::gen::tests::test_expire ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_inline::gen::tests::test_del ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_inline::gen::tests::test_prepend ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_inline::parse::tests::test_parse_incomplete ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_inline::parse::tests::test_parse_miss ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_inline::parse::tests::test_parse_error ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_inline::gen::tests::test_set ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_inline::parse::tests::test_parse_invalid ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_resp::gen::tests::test_del ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_resp::gen::tests::test_flushall ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_resp::gen::tests::test_expire ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_resp::gen::tests::test_hset ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_resp::gen::tests::test_incr ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_resp::gen::tests::test_prepend ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_resp::gen::tests::test_select ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_resp::gen::tests::test_set ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_resp::parse::tests::test_parse_error ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_resp::parse::tests::test_parse_incomplete ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_resp::parse::tests::test_parse_invalid ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_resp::parse::tests::test_parse_miss ... ok
Dec 05 03:28:36.352 INFO [stdout] test codec::redis_resp::parse::tests::test_parse_ok ... ok
Dec 05 03:28:36.353 INFO [stdout] test codec::thrift::buffer::tests::into_vec ... ok
Dec 05 03:28:36.353 INFO [stdout] test codec::thrift::buffer::tests::test_method_name ... ok
Dec 05 03:28:36.353 INFO [stdout] test codec::thrift::buffer::tests::test_protocol_header ... ok
Dec 05 03:28:36.353 INFO [stdout] test codec::thrift::buffer::tests::test_sequence_id ... ok
Dec 05 03:28:36.353 INFO [stdout] test codec::thrift::buffer::tests::test_stop ... ok
Dec 05 03:28:36.353 INFO [stdout] test codec::thrift::config::test_load_config ... ok
Dec 05 03:28:36.353 INFO [stdout] test codec::redis_resp::gen::tests::test_get ... ok
Dec 05 03:28:36.353 INFO [stdout] test codec::thrift::gen::test::test_ping ... ok
Dec 05 03:28:36.353 INFO [stdout] test codec::redis_resp::gen::tests::test_decr ... ok
Dec 05 03:28:36.353 INFO [stdout] test codec::redis_resp::gen::tests::test_hget ... ok
Dec 05 03:28:36.353 INFO [stdout] test codec::thrift::parse::tests::test_parse_incomplete ... ok
Dec 05 03:28:36.353 INFO [stdout] test codec::redis_resp::gen::tests::test_append ... ok
Dec 05 03:28:36.353 INFO [stdout] test codec::thrift::gen::test::thrift_ping ... ok
Dec 05 03:28:36.353 INFO [stdout] test codec::redis_inline::parse::tests::test_parse_ok ... ok
Dec 05 03:28:36.353 INFO [stdout] test codec::thrift::parse::tests::test_parse_ok ... ok
Dec 05 03:28:36.363 INFO [stdout] test codec::thrift::testutil::thrift_add ... ok
Dec 05 03:28:36.363 INFO [stdout] test codec::thrift::testutil::thrift_subtract ... ok
Dec 05 03:28:36.363 INFO [stdout] 
Dec 05 03:28:36.363 INFO [stdout] test result: ok. 73 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 03:28:36.363 INFO [stdout] 
Dec 05 03:28:36.368 INFO [stderr] su: No module specific data is present
Dec 05 03:28:37.344 INFO running `"docker" "inspect" "0afd8ba1a14a709aa5fe23f3559d5e44571ad65c2d4f2f9f2a35f41746b22789"`
Dec 05 03:28:37.714 INFO running `"docker" "rm" "-f" "0afd8ba1a14a709aa5fe23f3559d5e44571ad65c2d4f2f9f2a35f41746b22789"`
Dec 05 03:28:38.044 INFO [stdout] 0afd8ba1a14a709aa5fe23f3559d5e44571ad65c2d4f2f9f2a35f41746b22789