Oct 16 02:16:29.602 INFO testing msql-srv-0.8.0 against master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513 for rustdoc-test-static-cling-1 Oct 16 02:16:29.604 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-3/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-3/rustdoc-test-static-cling-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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"` Oct 16 02:16:29.968 INFO blam! 9233bb72822f003eccb466017d495747eca899eeadccfb66cc0dfd9707b33df5 Oct 16 02:16:29.977 INFO running `"docker" "start" "-a" "9233bb72822f003eccb466017d495747eca899eeadccfb66cc0dfd9707b33df5"` Oct 16 02:16:31.015 INFO kablam! usermod: no changes Oct 16 02:16:31.243 INFO kablam! Compiling smallvec v0.4.5 Oct 16 02:16:31.243 INFO kablam! Compiling atoi v0.2.3 Oct 16 02:16:31.244 INFO kablam! Compiling nom v4.1.1 Oct 16 02:16:33.119 INFO kablam! Compiling mysql_common v0.5.0 Oct 16 02:16:41.613 INFO kablam! Compiling msql-srv v0.8.0 (/source) Oct 16 02:16:47.035 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 15.98s Oct 16 02:16:47.045 INFO kablam! su: No module specific data is present Oct 16 02:16:47.923 INFO running `"docker" "rm" "-f" "9233bb72822f003eccb466017d495747eca899eeadccfb66cc0dfd9707b33df5"` Oct 16 02:16:48.267 INFO blam! 9233bb72822f003eccb466017d495747eca899eeadccfb66cc0dfd9707b33df5 Oct 16 02:16:48.269 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-3/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-3/rustdoc-test-static-cling-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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"` Oct 16 02:16:48.696 INFO blam! 86d5218283f33c9f25d519a1226cff02e1374204d6d40b96c387308fa8410fcf Oct 16 02:16:48.697 INFO running `"docker" "start" "-a" "86d5218283f33c9f25d519a1226cff02e1374204d6d40b96c387308fa8410fcf"` Oct 16 02:16:49.945 INFO kablam! usermod: no changes Oct 16 02:16:50.315 INFO kablam! Compiling tokio-reactor v0.1.6 Oct 16 02:16:50.315 INFO kablam! Compiling mysql v12.3.1 Oct 16 02:16:55.335 INFO kablam! Compiling tokio-udp v0.1.2 Oct 16 02:16:55.335 INFO kablam! Compiling tokio-uds v0.2.2 Oct 16 02:16:55.335 INFO kablam! Compiling tokio-tcp v0.1.2 Oct 16 02:17:00.768 INFO kablam! Compiling tokio v0.1.11 Oct 16 02:17:05.987 INFO kablam! Compiling tokio-core v0.1.17 Oct 16 02:17:11.127 INFO kablam! Compiling mysql_async v0.14.2 Oct 16 02:17:24.868 INFO kablam! Compiling msql-srv v0.8.0 (/source) Oct 16 02:18:17.941 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 1m 27s Oct 16 02:18:17.960 INFO kablam! su: No module specific data is present Oct 16 02:18:21.335 INFO running `"docker" "rm" "-f" "86d5218283f33c9f25d519a1226cff02e1374204d6d40b96c387308fa8410fcf"` Oct 16 02:18:21.623 INFO blam! 86d5218283f33c9f25d519a1226cff02e1374204d6d40b96c387308fa8410fcf Oct 16 02:18:21.636 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-3/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-3/rustdoc-test-static-cling-1/master#0e07c4281c343e9e15a0a8fca79538ad1a8eb513:/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 +0e07c4281c343e9e15a0a8fca79538ad1a8eb513-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"` Oct 16 02:18:21.971 INFO blam! 48404f061f17c7bbd8b3f045739087b76864ca4f6bdb138d1875b71bea4c37e2 Oct 16 02:18:21.979 INFO running `"docker" "start" "-a" "48404f061f17c7bbd8b3f045739087b76864ca4f6bdb138d1875b71bea4c37e2"` Oct 16 02:18:23.051 INFO kablam! usermod: no changes Oct 16 02:18:23.395 INFO kablam! Finished dev [unoptimized + debuginfo] target(s) in 0.30s Oct 16 02:18:23.411 INFO kablam! Running /target/debug/deps/msql_srv-d9409459f1feafaf Oct 16 02:18:23.415 INFO blam! Oct 16 02:18:23.415 INFO blam! running 103 tests Oct 16 02:18:23.415 INFO blam! test commands::tests::it_parses_handshake ... ok Oct 16 02:18:23.415 INFO blam! test commands::tests::it_parses_request ... ok Oct 16 02:18:23.415 INFO blam! test value::decode::tests::datetime ... ok Oct 16 02:18:23.415 INFO blam! test value::decode::tests::bytes ... ok Oct 16 02:18:23.415 INFO blam! test value::decode::tests::dur ... ok Oct 16 02:18:23.415 INFO blam! test packet::tests::test_ping ... ok Oct 16 02:18:23.415 INFO blam! test packet::tests::test_one_ping ... ok Oct 16 02:18:23.415 INFO blam! test value::decode::tests::i16_max ... ok Oct 16 02:18:23.415 INFO blam! test value::decode::tests::i16_one ... ok Oct 16 02:18:23.415 INFO blam! test value::decode::tests::i16_one_long ... ok Oct 16 02:18:23.415 INFO blam! test value::decode::tests::i16_one_longlong ... ok Oct 16 02:18:23.415 INFO blam! test value::decode::tests::f64_one ... ok Oct 16 02:18:23.415 INFO blam! test value::decode::tests::i32_max ... ok Oct 16 02:18:23.415 INFO blam! test value::decode::tests::i32_one_long ... ok Oct 16 02:18:23.415 INFO blam! test value::decode::tests::i32_one_longlong ... ok Oct 16 02:18:23.415 INFO blam! test value::decode::tests::i64_max ... ok Oct 16 02:18:23.415 INFO blam! test value::decode::tests::i64_one ... ok Oct 16 02:18:23.422 INFO blam! test value::decode::tests::i8_max ... ok Oct 16 02:18:23.435 INFO blam! test value::decode::tests::f32_one_double ... ok Oct 16 02:18:23.435 INFO blam! test value::decode::tests::i8_one_long ... ok Oct 16 02:18:23.435 INFO blam! test value::decode::tests::string ... ok Oct 16 02:18:23.435 INFO blam! test value::decode::tests::i8_one ... ok Oct 16 02:18:23.435 INFO blam! test value::decode::tests::i8_one_longlong ... ok Oct 16 02:18:23.435 INFO blam! test value::decode::tests::u16_one_long ... ok Oct 16 02:18:23.435 INFO blam! test value::decode::tests::i8_one_short ... ok Oct 16 02:18:23.439 INFO blam! test value::decode::tests::u16_max ... ok Oct 16 02:18:23.440 INFO blam! test value::decode::tests::time ... ok Oct 16 02:18:23.440 INFO blam! test value::decode::tests::u16_one ... ok Oct 16 02:18:23.440 INFO blam! test value::decode::tests::u32_one_long ... ok Oct 16 02:18:23.451 INFO blam! test value::decode::tests::u64_max ... ok Oct 16 02:18:23.451 INFO blam! test value::decode::tests::u64_one ... ok Oct 16 02:18:23.451 INFO blam! test value::decode::tests::u8_max ... ok Oct 16 02:18:23.451 INFO blam! test value::decode::tests::u32_one_longlong ... ok Oct 16 02:18:23.455 INFO blam! test value::decode::tests::u16_one_longlong ... ok Oct 16 02:18:23.455 INFO blam! test value::decode::tests::u32_max ... ok Oct 16 02:18:23.465 INFO blam! test value::decode::tests::u8_one_longlong ... ok Oct 16 02:18:23.465 INFO blam! test value::encode::tests::roundtrip_bin::datetime ... ok Oct 16 02:18:23.465 INFO blam! test value::decode::tests::u8_one_short ... ok Oct 16 02:18:23.465 INFO blam! test value::decode::tests::u8_one ... ok Oct 16 02:18:23.465 INFO blam! test value::decode::tests::u8_one_long ... ok Oct 16 02:18:23.465 INFO blam! test value::encode::tests::roundtrip_bin::bytes ... ok Oct 16 02:18:23.483 INFO blam! test value::encode::tests::roundtrip_bin::f32_one ... ok Oct 16 02:18:23.483 INFO blam! test value::encode::tests::roundtrip_bin::dur ... ok Oct 16 02:18:23.483 INFO blam! test value::encode::tests::roundtrip_bin::f64_one ... ok Oct 16 02:18:23.483 INFO blam! test value::encode::tests::roundtrip_bin::i16_max ... ok Oct 16 02:18:23.483 INFO blam! test value::encode::tests::roundtrip_bin::f32_one_double ... ok Oct 16 02:18:23.483 INFO blam! test value::encode::tests::roundtrip_bin::i16_one ... ok Oct 16 02:18:23.483 INFO blam! test value::encode::tests::roundtrip_bin::i16_one_longlong ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_bin::i16_one_long ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_bin::i8_max ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_bin::i8_one ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_bin::i8_one_long ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_bin::i8_one_longlong ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_bin::i8_one_short ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_bin::opt_some ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_bin::string ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_bin::time ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_bin::u16_max ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_bin::u16_one ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_bin::u16_one_long ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_bin::u16_one_longlong ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_bin::u32_max ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_bin::u32_one_long ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_bin::u32_one_longlong ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_bin::u64_max ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_bin::u64_one ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_bin::u8_max ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_bin::u8_one ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_bin::u8_one_long ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_bin::u8_one_longlong ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_bin::u8_one_short ... ok Oct 16 02:18:23.491 INFO blam! test value::encode::tests::roundtrip_text::bytes ... ok Oct 16 02:18:23.495 INFO blam! test value::encode::tests::roundtrip_bin::i32_one_long ... ok Oct 16 02:18:23.495 INFO blam! test value::encode::tests::roundtrip_bin::i32_max ... ok Oct 16 02:18:23.495 INFO blam! test value::encode::tests::roundtrip_bin::i32_one_longlong ... ok Oct 16 02:18:23.495 INFO blam! test value::encode::tests::roundtrip_bin::i64_max ... ok Oct 16 02:18:23.495 INFO blam! test value::encode::tests::roundtrip_bin::i64_one ... ok Oct 16 02:18:23.523 INFO blam! test value::encode::tests::roundtrip_text::f64_one ... ok Oct 16 02:18:23.523 INFO blam! test value::encode::tests::roundtrip_text::i16_one ... ok Oct 16 02:18:23.523 INFO blam! test value::encode::tests::roundtrip_text::i16_max ... ok Oct 16 02:18:23.523 INFO blam! test value::encode::tests::roundtrip_text::f32_one ... ok Oct 16 02:18:23.523 INFO blam! test value::encode::tests::roundtrip_text::dur ... ok Oct 16 02:18:23.523 INFO blam! test value::encode::tests::roundtrip_text::i64_max ... ok Oct 16 02:18:23.523 INFO blam! test value::encode::tests::roundtrip_text::i8_max ... ok Oct 16 02:18:23.523 INFO blam! test value::encode::tests::roundtrip_text::i32_max ... ok Oct 16 02:18:23.523 INFO blam! test value::encode::tests::roundtrip_text::i64_one ... ok Oct 16 02:18:23.523 INFO blam! test value::encode::tests::roundtrip_text::opt_none ... ok Oct 16 02:18:23.523 INFO blam! test value::encode::tests::roundtrip_text::i8_one ... ok Oct 16 02:18:23.523 INFO blam! test value::encode::tests::roundtrip_text::string ... ok Oct 16 02:18:23.523 INFO blam! test value::encode::tests::roundtrip_text::u16_one ... ok Oct 16 02:18:23.523 INFO blam! test value::encode::tests::roundtrip_text::u32_max ... ok Oct 16 02:18:23.523 INFO blam! test value::encode::tests::roundtrip_text::i32_one ... ok Oct 16 02:18:23.523 INFO blam! test value::encode::tests::roundtrip_text::u64_max ... ok Oct 16 02:18:23.543 INFO blam! test value::encode::tests::roundtrip_text::opt_some ... ok Oct 16 02:18:23.543 INFO blam! test value::encode::tests::roundtrip_text::u16_max ... ok Oct 16 02:18:23.543 INFO blam! test value::encode::tests::roundtrip_text::u32_one ... ok Oct 16 02:18:23.555 INFO blam! test value::encode::tests::roundtrip_text::u8_max ... ok Oct 16 02:18:23.575 INFO blam! test value::encode::tests::roundtrip_text::time ... ok Oct 16 02:18:23.575 INFO blam! test value::encode::tests::roundtrip_text::u64_one ... ok Oct 16 02:18:23.575 INFO blam! test value::encode::tests::roundtrip_text::u8_one ... ok Oct 16 02:18:23.579 INFO blam! test value::encode::tests::roundtrip_text::datetime ... ok Oct 16 02:18:23.731 INFO blam! test packet::tests::test_long_exact ... ok Oct 16 02:18:23.760 INFO blam! test packet::tests::test_long_more ... ok Oct 16 02:18:23.760 INFO blam! Oct 16 02:18:23.760 INFO blam! test result: ok. 103 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Oct 16 02:18:23.760 INFO blam! Oct 16 02:18:23.763 INFO kablam! Running /target/debug/deps/async-a0904e02606419f0 Oct 16 02:18:23.768 INFO blam! Oct 16 02:18:23.768 INFO blam! running 21 tests Oct 16 02:18:23.891 INFO blam! test empty_response ... ok Oct 16 02:18:23.891 INFO blam! test it_pings ... ok Oct 16 02:18:23.915 INFO blam! test it_connects ... ok Oct 16 02:18:23.935 INFO blam! test empty_on_drop ... ok Oct 16 02:18:23.935 INFO blam! test insert_exec ... ok Oct 16 02:18:23.987 INFO blam! test it_prepares_many ... ok Oct 16 02:18:23.987 INFO blam! test no_columns ... ok Oct 16 02:18:23.987 INFO blam! test no_columns_but_rows ... ok Oct 16 02:18:23.987 INFO blam! test it_prepares ... ok Oct 16 02:18:24.006 INFO blam! test it_queries_nulls ... ok Oct 16 02:18:24.008 INFO blam! test it_queries ... ok Oct 16 02:18:24.016 INFO blam! test it_queries_many_rows ... ok Oct 16 02:18:24.044 INFO blam! test prepared_no_cols ... ok Oct 16 02:18:24.067 INFO blam! test prepared_no_cols_but_rows ... ok Oct 16 02:18:24.099 INFO blam! test no_rows ... ok Oct 16 02:18:24.099 INFO blam! test prepared_empty ... ok Oct 16 02:18:24.147 INFO blam! test prepared_no_params ... ok Oct 16 02:18:24.159 INFO blam! test prepared_nulls ... ok Oct 16 02:18:24.187 INFO blam! test send_long ... ok Oct 16 02:18:24.194 INFO blam! test prepared_no_rows ... ok Oct 16 02:18:24.388 INFO blam! test error_response ... ok Oct 16 02:18:24.388 INFO blam! Oct 16 02:18:24.388 INFO blam! test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Oct 16 02:18:24.388 INFO blam! Oct 16 02:18:24.397 INFO kablam! Running /target/debug/deps/main-81898f649939bb8e Oct 16 02:18:24.398 INFO blam! Oct 16 02:18:24.398 INFO blam! running 22 tests Oct 16 02:18:24.485 INFO blam! test it_pings ... ok Oct 16 02:18:24.488 INFO blam! test empty_response ... ok Oct 16 02:18:24.499 INFO blam! test error_response ... ok Oct 16 02:18:24.499 INFO blam! test it_connects ... ok Oct 16 02:18:24.543 INFO blam! test insert_exec ... ok Oct 16 02:18:24.543 INFO blam! test empty_on_drop ... ok Oct 16 02:18:24.576 INFO blam! test it_prepares ... ok Oct 16 02:18:24.583 INFO blam! test it_queries_many_rows ... ok Oct 16 02:18:24.583 INFO blam! test it_prepares_many ... ok Oct 16 02:18:24.584 INFO blam! test it_queries ... ok Oct 16 02:18:24.585 INFO blam! test no_columns ... ok Oct 16 02:18:24.595 INFO blam! test it_queries_nulls ... ok Oct 16 02:18:24.597 INFO blam! test multi_result ... ok Oct 16 02:18:24.599 INFO blam! test no_columns_but_rows ... ok Oct 16 02:18:24.631 INFO blam! test prepared_no_cols ... ok Oct 16 02:18:24.632 INFO blam! test prepared_no_cols_but_rows ... ok Oct 16 02:18:24.671 INFO blam! test no_rows ... ok Oct 16 02:18:24.675 INFO blam! test prepared_empty ... ok Oct 16 02:18:24.719 INFO blam! test prepared_no_params ... ok Oct 16 02:18:24.731 INFO blam! test prepared_no_rows ... ok Oct 16 02:18:24.731 INFO blam! test prepared_nulls ... ok Oct 16 02:18:24.732 INFO blam! test send_long ... ok Oct 16 02:18:24.732 INFO blam! Oct 16 02:18:24.732 INFO blam! test result: ok. 22 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Oct 16 02:18:24.732 INFO blam! Oct 16 02:18:24.740 INFO kablam! Doc-tests msql-srv Oct 16 02:18:28.750 INFO blam! Oct 16 02:18:28.750 INFO blam! running 1 test Oct 16 02:18:36.581 INFO blam! test src/lib.rs - (line 15) ... ok Oct 16 02:18:36.582 INFO blam! Oct 16 02:18:36.582 INFO blam! test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Oct 16 02:18:36.582 INFO blam! Oct 16 02:18:36.599 INFO kablam! su: No module specific data is present Oct 16 02:18:37.134 INFO running `"docker" "rm" "-f" "48404f061f17c7bbd8b3f045739087b76864ca4f6bdb138d1875b71bea4c37e2"` Oct 16 02:18:37.314 INFO blam! 48404f061f17c7bbd8b3f045739087b76864ca4f6bdb138d1875b71bea4c37e2