Nov 30 22:25:23.666 INFO testing twitter/rpc-perf against 1.30.1 for beta-1.31-5
Nov 30 22:25:23.666 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-4/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/beta-1.31-5/1.30.1:/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.1 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 30 22:25:24.207 INFO [stdout] bc1bc1fcc02bb4ad59ae891554b741e4f4e09aaae8f4c5278256070b436816f6
Nov 30 22:25:24.215 INFO running `"docker" "start" "-a" "bc1bc1fcc02bb4ad59ae891554b741e4f4e09aaae8f4c5278256070b436816f6"`
Nov 30 22:25:25.690 INFO [stderr] usermod: no changes
Nov 30 22:25:25.879 INFO [stderr]    Compiling num-traits v0.2.5
Nov 30 22:25:25.891 INFO [stderr]    Compiling num-integer v0.1.39
Nov 30 22:25:25.903 INFO [stderr]    Compiling num-iter v0.1.37
Nov 30 22:25:25.903 INFO [stderr]    Compiling libc v0.2.42
Nov 30 22:25:25.907 INFO [stderr]    Compiling odds v0.2.26
Nov 30 22:25:25.919 INFO [stderr]    Compiling cfg-if v0.1.4
Nov 30 22:25:25.936 INFO [stderr]    Compiling nodrop v0.1.12
Nov 30 22:25:25.938 INFO [stderr]    Compiling byteorder v1.1.0
Nov 30 22:25:26.455 INFO [stderr]    Compiling encoding_index_tests v0.1.4
Nov 30 22:25:27.395 INFO [stderr]    Compiling byteorder v0.4.2
Nov 30 22:25:27.679 INFO [stderr]    Compiling adler32 v1.0.3
Nov 30 22:25:29.911 INFO [stderr]    Compiling rustc-serialize v0.3.24
Nov 30 22:25:30.379 INFO [stderr]    Compiling inflate v0.2.0
Nov 30 22:25:30.563 INFO [stderr]    Compiling bitflags v0.7.0
Nov 30 22:25:30.663 INFO [stderr]    Compiling matches v0.1.7
Nov 30 22:25:30.683 INFO [stderr]    Compiling histogram v0.6.9
Nov 30 22:25:30.745 INFO [stderr]    Compiling crc-core v0.1.2
Nov 30 22:25:31.415 INFO [stderr]    Compiling build_const v0.2.1
Nov 30 22:25:31.416 INFO [stderr]    Compiling serde v1.0.70
Nov 30 22:25:32.155 INFO [stderr]    Compiling chunked_transfer v0.3.1
Nov 30 22:25:34.244 INFO [stderr]    Compiling hsl v0.1.1
Nov 30 22:25:34.307 INFO [stderr]    Compiling ascii v0.7.1
Nov 30 22:25:34.932 INFO [stderr]    Compiling lazycell v0.5.1
Nov 30 22:25:35.159 INFO [stderr]    Compiling slab v0.3.0
Nov 30 22:25:36.192 INFO [stderr]    Compiling fnv v1.0.6
Nov 30 22:25:36.427 INFO [stderr]    Compiling allan v0.2.4
Nov 30 22:25:36.675 INFO [stderr]    Compiling mpmc v0.1.2
Nov 30 22:25:37.399 INFO [stderr]    Compiling unicode-width v0.1.5
Nov 30 22:25:37.583 INFO [stderr]    Compiling getopts v0.2.15
Nov 30 22:25:37.912 INFO [stderr]    Compiling bytes v0.3.0
Nov 30 22:25:38.247 INFO [stderr]    Compiling ratelimit v0.4.2
Nov 30 22:25:38.713 INFO [stderr]    Compiling log v0.4.3
Nov 30 22:25:40.524 INFO [stderr]    Compiling encoding-index-tradchinese v1.20141219.5
Nov 30 22:25:42.445 INFO [stderr]    Compiling encoding-index-korean v1.20141219.5
Nov 30 22:25:43.420 INFO [stderr]    Compiling encoding-index-japanese v1.20141219.5
Nov 30 22:25:45.091 INFO [stderr]    Compiling encoding-index-singlebyte v1.20141219.5
Nov 30 22:25:48.388 INFO [stderr]    Compiling encoding-index-simpchinese v1.20141219.5
Nov 30 22:25:49.343 INFO [stderr]    Compiling stb_truetype v0.1.2
Nov 30 22:25:49.764 INFO [stderr]    Compiling deflate v0.7.18
Nov 30 22:25:50.707 INFO [stderr]    Compiling arrayvec v0.3.25
Nov 30 22:25:50.804 INFO [stderr]    Compiling crc v1.5.0
Nov 30 22:25:52.100 INFO [stderr]    Compiling rand v0.3.17
Nov 30 22:25:54.726 INFO [stderr]    Compiling time v0.1.38
Nov 30 22:25:55.721 INFO [stderr]    Compiling iovec v0.1.2
Nov 30 22:25:56.415 INFO [stderr]    Compiling net2 v0.2.33
Nov 30 22:25:56.964 INFO [stderr]    Compiling clocksource v0.2.4
Nov 30 22:25:57.962 INFO [stderr]    Compiling shuteye v0.3.2
Nov 30 22:25:59.341 INFO [stderr]    Compiling pad v0.1.4
Nov 30 22:25:59.371 INFO [stderr]    Compiling log v0.3.9
Nov 30 22:26:03.627 INFO [stderr]    Compiling encoding v0.2.33
Nov 30 22:26:04.424 INFO [stderr]    Compiling rusttype v0.1.2
Nov 30 22:26:09.267 INFO [stderr]    Compiling log-panics v1.1.0
Nov 30 22:26:11.668 INFO [stderr]    Compiling mio v0.6.10
Nov 30 22:26:12.300 INFO [stderr]    Compiling heatmap v0.6.6
Nov 30 22:26:13.165 INFO [stderr]    Compiling simple_logger v0.4.0
Nov 30 22:26:20.132 INFO [stderr]    Compiling uuid v0.1.18
Nov 30 22:26:22.916 INFO [stderr]    Compiling url v0.2.38
Nov 30 22:26:25.115 INFO [stderr]    Compiling num v0.1.42
Nov 30 22:26:25.115 INFO [stderr]    Compiling png v0.7.0
Nov 30 22:26:25.824 INFO [stderr]    Compiling chrono v0.2.25
Nov 30 22:26:30.537 INFO [stderr]    Compiling waterfall v0.7.1
Nov 30 22:26:33.907 INFO [stderr]    Compiling tiny_http v0.5.9
Nov 30 22:26:43.157 INFO [stderr]    Compiling tic v0.2.4
Nov 30 22:26:43.631 INFO [stderr]    Compiling toml v0.4.6
Nov 30 22:26:49.499 INFO [stderr]    Compiling rpc-perf v2.1.0-pre (/source)
Nov 30 22:26:58.658 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 32s
Nov 30 22:26:58.668 INFO [stderr] su: No module specific data is present
Nov 30 22:27:00.264 INFO running `"docker" "inspect" "bc1bc1fcc02bb4ad59ae891554b741e4f4e09aaae8f4c5278256070b436816f6"`
Nov 30 22:27:00.661 INFO running `"docker" "rm" "-f" "bc1bc1fcc02bb4ad59ae891554b741e4f4e09aaae8f4c5278256070b436816f6"`
Nov 30 22:27:01.031 INFO [stdout] bc1bc1fcc02bb4ad59ae891554b741e4f4e09aaae8f4c5278256070b436816f6
Nov 30 22:27:01.041 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-4/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/beta-1.31-5/1.30.1:/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.1 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 30 22:27:01.565 INFO [stdout] 421d954ac08b1cab89e7af283a61759367a01bfe8d3ed53ba4780e88302da877
Nov 30 22:27:01.567 INFO running `"docker" "start" "-a" "421d954ac08b1cab89e7af283a61759367a01bfe8d3ed53ba4780e88302da877"`
Nov 30 22:27:04.010 INFO [stderr] usermod: no changes
Nov 30 22:27:04.186 INFO [stderr]    Compiling rpc-perf v2.1.0-pre (/source)
Nov 30 22:27:09.782 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.73s
Nov 30 22:27:09.784 INFO [stderr] su: No module specific data is present
Nov 30 22:27:10.723 INFO running `"docker" "inspect" "421d954ac08b1cab89e7af283a61759367a01bfe8d3ed53ba4780e88302da877"`
Nov 30 22:27:11.053 INFO running `"docker" "rm" "-f" "421d954ac08b1cab89e7af283a61759367a01bfe8d3ed53ba4780e88302da877"`
Nov 30 22:27:11.431 INFO [stdout] 421d954ac08b1cab89e7af283a61759367a01bfe8d3ed53ba4780e88302da877
Nov 30 22:27:11.435 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-4/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/beta-1.31-5/1.30.1:/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.1 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 30 22:27:11.967 INFO [stdout] ce107b57364afce8cc78a86bf89d239ca9f4797ea9af9bfd13152f42e1f675cb
Nov 30 22:27:11.975 INFO running `"docker" "start" "-a" "ce107b57364afce8cc78a86bf89d239ca9f4797ea9af9bfd13152f42e1f675cb"`
Nov 30 22:27:13.451 INFO [stderr] usermod: no changes
Nov 30 22:27:13.683 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.20s
Nov 30 22:27:13.695 INFO [stderr]      Running /target/debug/deps/rpc_perf-0e0da66f1ddccdd8
Nov 30 22:27:13.696 INFO [stdout] 
Nov 30 22:27:13.696 INFO [stdout] running 73 tests
Nov 30 22:27:13.696 INFO [stdout] test codec::memcache::gen::tests::test_cas ... ok
Nov 30 22:27:13.696 INFO [stdout] test codec::memcache::gen::tests::test_decr ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::memcache::gen::tests::test_append ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::memcache::gen::tests::test_add ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::echo::parse::tests::test_parse_ok ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::echo::parse::tests::test_parse_incomplete ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::echo::parse::tests::test_parse_error ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::memcache::gen::tests::test_delete ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::memcache::gen::tests::test_flush_all ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::memcache::gen::tests::test_get ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::memcache::gen::tests::test_gets ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::echo::gen::tests::echo_test ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::memcache::gen::tests::test_incr ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::memcache::gen::tests::test_prepend ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::memcache::gen::tests::test_quit ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::memcache::gen::tests::test_replace ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::memcache::gen::tests::test_set ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::memcache::gen::tests::test_touch ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::memcache::gen::tests::test_verbosity ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::memcache::gen::tests::test_version ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::memcache::parse::tests::test_parse_error ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::memcache::parse::tests::test_parse_incomplete ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::memcache::parse::tests::test_parse_invalid ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::memcache::parse::tests::test_parse_miss ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::memcache::parse::tests::test_parse_ok ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::memcache::parse::tests::test_parse_version ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::ping::gen::tests::test_ping ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::ping::parse::tests::test_parse_pong ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::redis_inline::gen::tests::test_append ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::redis_inline::gen::tests::test_decr ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::redis_inline::gen::tests::test_del ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::redis_inline::gen::tests::test_expire ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::redis_inline::gen::tests::test_flushall ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::redis_inline::gen::tests::test_get ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::redis_inline::gen::tests::test_hget ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::redis_inline::gen::tests::test_hset ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::redis_inline::gen::tests::test_incr ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::redis_inline::gen::tests::test_prepend ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::redis_inline::gen::tests::test_set ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::redis_inline::parse::tests::test_parse_error ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::redis_inline::parse::tests::test_parse_incomplete ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::redis_inline::parse::tests::test_parse_invalid ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::redis_inline::parse::tests::test_parse_miss ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::redis_inline::parse::tests::test_parse_ok ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::redis_resp::gen::tests::test_append ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::redis_resp::gen::tests::test_decr ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::redis_resp::gen::tests::test_del ... ok
Nov 30 22:27:13.703 INFO [stdout] test codec::redis_resp::gen::tests::test_expire ... ok
Nov 30 22:27:13.704 INFO [stdout] test codec::redis_resp::gen::tests::test_flushall ... ok
Nov 30 22:27:13.704 INFO [stdout] test codec::redis_resp::gen::tests::test_get ... ok
Nov 30 22:27:13.704 INFO [stdout] test codec::redis_resp::gen::tests::test_hget ... ok
Nov 30 22:27:13.704 INFO [stdout] test codec::redis_resp::gen::tests::test_hset ... ok
Nov 30 22:27:13.704 INFO [stdout] test codec::redis_resp::gen::tests::test_incr ... ok
Nov 30 22:27:13.704 INFO [stdout] test codec::redis_resp::gen::tests::test_prepend ... ok
Nov 30 22:27:13.704 INFO [stdout] test codec::redis_resp::gen::tests::test_select ... ok
Nov 30 22:27:13.704 INFO [stdout] test codec::redis_resp::gen::tests::test_set ... ok
Nov 30 22:27:13.704 INFO [stdout] test codec::redis_resp::parse::tests::test_parse_error ... ok
Nov 30 22:27:13.704 INFO [stdout] test codec::redis_resp::parse::tests::test_parse_incomplete ... ok
Nov 30 22:27:13.704 INFO [stdout] test codec::redis_resp::parse::tests::test_parse_invalid ... ok
Nov 30 22:27:13.704 INFO [stdout] test codec::redis_resp::parse::tests::test_parse_miss ... ok
Nov 30 22:27:13.704 INFO [stdout] test codec::redis_resp::parse::tests::test_parse_ok ... ok
Nov 30 22:27:13.704 INFO [stdout] test codec::thrift::buffer::tests::into_vec ... ok
Nov 30 22:27:13.704 INFO [stdout] test codec::thrift::buffer::tests::test_method_name ... ok
Nov 30 22:27:13.704 INFO [stdout] test codec::thrift::buffer::tests::test_protocol_header ... ok
Nov 30 22:27:13.704 INFO [stdout] test codec::thrift::buffer::tests::test_stop ... ok
Nov 30 22:27:13.704 INFO [stdout] test codec::thrift::config::test_load_config ... ok
Nov 30 22:27:13.704 INFO [stdout] test codec::thrift::gen::test::test_ping ... ok
Nov 30 22:27:13.712 INFO [stdout] test codec::thrift::gen::test::thrift_ping ... ok
Nov 30 22:27:13.712 INFO [stdout] test codec::thrift::parse::tests::test_parse_incomplete ... ok
Nov 30 22:27:13.712 INFO [stdout] test codec::thrift::parse::tests::test_parse_ok ... ok
Nov 30 22:27:13.718 INFO [stderr] su: No module specific data is present
Nov 30 22:27:13.718 INFO [stdout] test codec::thrift::testutil::thrift_add ... ok
Nov 30 22:27:13.718 INFO [stdout] test codec::thrift::testutil::thrift_subtract ... ok
Nov 30 22:27:13.718 INFO [stdout] test codec::thrift::buffer::tests::test_sequence_id ... ok
Nov 30 22:27:13.718 INFO [stdout] 
Nov 30 22:27:13.718 INFO [stdout] test result: ok. 73 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 30 22:27:13.718 INFO [stdout] 
Nov 30 22:27:14.815 INFO running `"docker" "inspect" "ce107b57364afce8cc78a86bf89d239ca9f4797ea9af9bfd13152f42e1f675cb"`
Nov 30 22:27:15.079 INFO running `"docker" "rm" "-f" "ce107b57364afce8cc78a86bf89d239ca9f4797ea9af9bfd13152f42e1f675cb"`
Nov 30 22:27:15.431 INFO [stdout] ce107b57364afce8cc78a86bf89d239ca9f4797ea9af9bfd13152f42e1f675cb
