Dec 15 04:13:28.449 INFO testing msql-srv-0.8.1 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550 Dec 15 04:13:28.449 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 15 04:13:28.908 INFO [stdout] ae2fb742294096e4a5e60c5e184f1a08ce88eaf876cc6023727eda46da851427 Dec 15 04:13:28.913 INFO running `"docker" "start" "-a" "ae2fb742294096e4a5e60c5e184f1a08ce88eaf876cc6023727eda46da851427"` Dec 15 04:13:30.271 INFO [stderr] usermod: no changes Dec 15 04:13:30.521 INFO [stderr] Compiling mysql_common v0.5.0 Dec 15 04:13:38.701 INFO [stderr] Compiling msql-srv v0.8.1 (/source) Dec 15 04:13:44.492 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 14.19s Dec 15 04:13:44.509 INFO [stderr] su: No module specific data is present Dec 15 04:13:45.808 INFO running `"docker" "inspect" "ae2fb742294096e4a5e60c5e184f1a08ce88eaf876cc6023727eda46da851427"` Dec 15 04:13:46.201 INFO running `"docker" "rm" "-f" "ae2fb742294096e4a5e60c5e184f1a08ce88eaf876cc6023727eda46da851427"` Dec 15 04:13:46.512 INFO [stdout] ae2fb742294096e4a5e60c5e184f1a08ce88eaf876cc6023727eda46da851427 Dec 15 04:13:46.520 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 15 04:13:47.000 INFO [stdout] ee1968ca7ac4b383736825570714165d1b74216cf32d05e936b6b838b893eb84 Dec 15 04:13:47.002 INFO running `"docker" "start" "-a" "ee1968ca7ac4b383736825570714165d1b74216cf32d05e936b6b838b893eb84"` Dec 15 04:13:49.135 INFO [stderr] usermod: no changes Dec 15 04:13:49.487 INFO [stderr] Compiling tokio-reactor v0.1.7 Dec 15 04:13:49.487 INFO [stderr] Compiling mysql v12.3.1 Dec 15 04:13:55.560 INFO [stderr] Compiling tokio-udp v0.1.3 Dec 15 04:13:55.572 INFO [stderr] Compiling tokio-uds v0.2.4 Dec 15 04:13:55.573 INFO [stderr] Compiling tokio-tcp v0.1.2 Dec 15 04:14:04.244 INFO [stderr] Compiling tokio v0.1.13 Dec 15 04:14:12.202 INFO [stderr] Compiling tokio-core v0.1.17 Dec 15 04:14:18.559 INFO [stderr] Compiling mysql_async v0.14.2 Dec 15 04:14:33.003 INFO [stderr] Compiling msql-srv v0.8.1 (/source) Dec 15 04:15:16.006 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 1m 26s Dec 15 04:15:16.022 INFO [stderr] su: No module specific data is present Dec 15 04:15:16.857 INFO running `"docker" "inspect" "ee1968ca7ac4b383736825570714165d1b74216cf32d05e936b6b838b893eb84"` Dec 15 04:15:17.213 INFO running `"docker" "rm" "-f" "ee1968ca7ac4b383736825570714165d1b74216cf32d05e936b6b838b893eb84"` Dec 15 04:15:17.537 INFO [stdout] ee1968ca7ac4b383736825570714165d1b74216cf32d05e936b6b838b893eb84 Dec 15 04:15:17.543 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 15 04:15:17.968 INFO [stdout] ebab40949a0c01894486cf8c72db1b44eb8840d929ce051cc0e38a8bdb7440a3 Dec 15 04:15:17.970 INFO running `"docker" "start" "-a" "ebab40949a0c01894486cf8c72db1b44eb8840d929ce051cc0e38a8bdb7440a3"` Dec 15 04:15:19.871 INFO [stderr] usermod: no changes Dec 15 04:15:20.187 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.30s Dec 15 04:15:20.196 INFO [stderr] Running /target/debug/deps/msql_srv-a5d8021c3194981d Dec 15 04:15:20.201 INFO [stdout] Dec 15 04:15:20.201 INFO [stdout] running 103 tests Dec 15 04:15:20.207 INFO [stdout] test commands::tests::it_parses_handshake ... ok Dec 15 04:15:20.223 INFO [stdout] test commands::tests::it_parses_request ... ok Dec 15 04:15:20.227 INFO [stdout] test packet::tests::test_one_ping ... ok Dec 15 04:15:20.231 INFO [stdout] test packet::tests::test_ping ... ok Dec 15 04:15:20.231 INFO [stdout] test value::decode::tests::bytes ... ok Dec 15 04:15:20.231 INFO [stdout] test value::decode::tests::datetime ... ok Dec 15 04:15:20.231 INFO [stdout] test value::decode::tests::dur ... ok Dec 15 04:15:20.231 INFO [stdout] test value::decode::tests::f32_one_double ... ok Dec 15 04:15:20.231 INFO [stdout] test value::decode::tests::f64_one ... ok Dec 15 04:15:20.235 INFO [stdout] test value::decode::tests::i32_one_long ... ok Dec 15 04:15:20.235 INFO [stdout] test value::decode::tests::i16_one_long ... ok Dec 15 04:15:20.238 INFO [stdout] test value::decode::tests::i16_one_longlong ... ok Dec 15 04:15:20.238 INFO [stdout] test value::decode::tests::i32_max ... ok Dec 15 04:15:20.243 INFO [stdout] test value::decode::tests::i64_max ... ok Dec 15 04:15:20.243 INFO [stdout] test value::decode::tests::i32_one_longlong ... ok Dec 15 04:15:20.243 INFO [stdout] test value::decode::tests::i16_max ... ok Dec 15 04:15:20.243 INFO [stdout] test value::decode::tests::i16_one ... ok Dec 15 04:15:20.243 INFO [stdout] test value::decode::tests::i64_one ... ok Dec 15 04:15:20.259 INFO [stdout] test value::decode::tests::string ... ok Dec 15 04:15:20.259 INFO [stdout] test value::decode::tests::i8_one ... ok Dec 15 04:15:20.259 INFO [stdout] test value::decode::tests::i8_one_long ... ok Dec 15 04:15:20.259 INFO [stdout] test value::decode::tests::i8_one_longlong ... ok Dec 15 04:15:20.260 INFO [stdout] test value::decode::tests::u16_one ... ok Dec 15 04:15:20.260 INFO [stdout] test value::decode::tests::i8_one_short ... ok Dec 15 04:15:20.260 INFO [stdout] test value::decode::tests::i8_max ... ok Dec 15 04:15:20.260 INFO [stdout] test value::decode::tests::u32_one_long ... ok Dec 15 04:15:20.260 INFO [stdout] test value::decode::tests::u32_max ... ok Dec 15 04:15:20.266 INFO [stdout] test value::decode::tests::u64_max ... ok Dec 15 04:15:20.267 INFO [stdout] test value::decode::tests::u32_one_longlong ... ok Dec 15 04:15:20.267 INFO [stdout] test value::decode::tests::u16_max ... ok Dec 15 04:15:20.267 INFO [stdout] test value::decode::tests::u16_one_longlong ... ok Dec 15 04:15:20.267 INFO [stdout] test value::decode::tests::u8_one_long ... ok Dec 15 04:15:20.267 INFO [stdout] test value::decode::tests::u8_max ... ok Dec 15 04:15:20.278 INFO [stdout] test value::decode::tests::u8_one_longlong ... ok Dec 15 04:15:20.279 INFO [stdout] test value::decode::tests::u64_one ... ok Dec 15 04:15:20.279 INFO [stdout] test value::decode::tests::u8_one ... ok Dec 15 04:15:20.279 INFO [stdout] test value::decode::tests::time ... ok Dec 15 04:15:20.279 INFO [stdout] test value::decode::tests::u16_one_long ... ok Dec 15 04:15:20.287 INFO [stdout] test value::decode::tests::u8_one_short ... ok Dec 15 04:15:20.288 INFO [stdout] test value::encode::tests::roundtrip_bin::f32_one ... ok Dec 15 04:15:20.288 INFO [stdout] test value::encode::tests::roundtrip_bin::datetime ... ok Dec 15 04:15:20.288 INFO [stdout] test value::encode::tests::roundtrip_bin::dur ... ok Dec 15 04:15:20.307 INFO [stdout] test value::encode::tests::roundtrip_bin::i16_one ... ok Dec 15 04:15:20.307 INFO [stdout] test value::encode::tests::roundtrip_bin::i16_one_long ... ok Dec 15 04:15:20.308 INFO [stdout] test value::encode::tests::roundtrip_bin::i16_max ... ok Dec 15 04:15:20.308 INFO [stdout] test value::encode::tests::roundtrip_bin::f32_one_double ... ok Dec 15 04:15:20.308 INFO [stdout] test value::encode::tests::roundtrip_bin::bytes ... ok Dec 15 04:15:20.309 INFO [stdout] test value::encode::tests::roundtrip_bin::f64_one ... ok Dec 15 04:15:20.319 INFO [stdout] test value::encode::tests::roundtrip_bin::i32_max ... ok Dec 15 04:15:20.319 INFO [stdout] test value::encode::tests::roundtrip_bin::i32_one_long ... ok Dec 15 04:15:20.320 INFO [stdout] test value::encode::tests::roundtrip_bin::i32_one_longlong ... ok Dec 15 04:15:20.320 INFO [stdout] test value::encode::tests::roundtrip_bin::i16_one_longlong ... ok Dec 15 04:15:20.321 INFO [stdout] test value::encode::tests::roundtrip_bin::i64_max ... ok Dec 15 04:15:20.321 INFO [stdout] test value::encode::tests::roundtrip_bin::i64_one ... ok Dec 15 04:15:20.322 INFO [stdout] test value::encode::tests::roundtrip_bin::i8_one_long ... ok Dec 15 04:15:20.322 INFO [stdout] test value::encode::tests::roundtrip_bin::i8_one_short ... ok Dec 15 04:15:20.322 INFO [stdout] test value::encode::tests::roundtrip_bin::i8_max ... ok Dec 15 04:15:20.323 INFO [stdout] test value::encode::tests::roundtrip_bin::i8_one_longlong ... ok Dec 15 04:15:20.323 INFO [stdout] test value::encode::tests::roundtrip_bin::i8_one ... ok Dec 15 04:15:20.331 INFO [stdout] test value::encode::tests::roundtrip_bin::opt_some ... ok Dec 15 04:15:20.331 INFO [stdout] test value::encode::tests::roundtrip_bin::string ... ok Dec 15 04:15:20.332 INFO [stdout] test value::encode::tests::roundtrip_bin::time ... ok Dec 15 04:15:20.332 INFO [stdout] test value::encode::tests::roundtrip_bin::u16_max ... ok Dec 15 04:15:20.333 INFO [stdout] test value::encode::tests::roundtrip_bin::u16_one_long ... ok Dec 15 04:15:20.333 INFO [stdout] test value::encode::tests::roundtrip_bin::u16_one ... ok Dec 15 04:15:20.333 INFO [stdout] test value::encode::tests::roundtrip_bin::u64_max ... ok Dec 15 04:15:20.333 INFO [stdout] test value::encode::tests::roundtrip_bin::u64_one ... ok Dec 15 04:15:20.335 INFO [stdout] test value::encode::tests::roundtrip_bin::u32_one_longlong ... ok Dec 15 04:15:20.335 INFO [stdout] test value::encode::tests::roundtrip_bin::u32_max ... ok Dec 15 04:15:20.336 INFO [stdout] test value::encode::tests::roundtrip_bin::u16_one_longlong ... ok Dec 15 04:15:20.343 INFO [stdout] test value::encode::tests::roundtrip_bin::u32_one_long ... ok Dec 15 04:15:20.343 INFO [stdout] test value::encode::tests::roundtrip_bin::u8_one ... ok Dec 15 04:15:20.344 INFO [stdout] test value::encode::tests::roundtrip_bin::u8_max ... ok Dec 15 04:15:20.344 INFO [stdout] test value::encode::tests::roundtrip_bin::u8_one_short ... ok Dec 15 04:15:20.345 INFO [stdout] test value::encode::tests::roundtrip_bin::u8_one_long ... ok Dec 15 04:15:20.345 INFO [stdout] test value::encode::tests::roundtrip_bin::u8_one_longlong ... ok Dec 15 04:15:20.346 INFO [stdout] test value::encode::tests::roundtrip_text::bytes ... ok Dec 15 04:15:20.348 INFO [stdout] test value::encode::tests::roundtrip_text::i16_one ... ok Dec 15 04:15:20.359 INFO [stdout] test value::encode::tests::roundtrip_text::i16_max ... ok Dec 15 04:15:20.359 INFO [stdout] test value::encode::tests::roundtrip_text::f32_one ... ok Dec 15 04:15:20.360 INFO [stdout] test value::encode::tests::roundtrip_text::f64_one ... ok Dec 15 04:15:20.360 INFO [stdout] test value::encode::tests::roundtrip_text::i32_max ... ok Dec 15 04:15:20.363 INFO [stdout] test value::encode::tests::roundtrip_text::i32_one ... ok Dec 15 04:15:20.363 INFO [stdout] test value::encode::tests::roundtrip_text::i8_max ... ok Dec 15 04:15:20.364 INFO [stdout] test value::encode::tests::roundtrip_text::i64_one ... ok Dec 15 04:15:20.364 INFO [stdout] test value::encode::tests::roundtrip_text::i64_max ... ok Dec 15 04:15:20.371 INFO [stdout] test value::encode::tests::roundtrip_text::opt_none ... ok Dec 15 04:15:20.371 INFO [stdout] test value::encode::tests::roundtrip_text::opt_some ... ok Dec 15 04:15:20.372 INFO [stdout] test value::encode::tests::roundtrip_text::string ... ok Dec 15 04:15:20.387 INFO [stdout] test value::encode::tests::roundtrip_text::u16_max ... ok Dec 15 04:15:20.387 INFO [stdout] test value::encode::tests::roundtrip_text::i8_one ... ok Dec 15 04:15:20.388 INFO [stdout] test value::encode::tests::roundtrip_text::u16_one ... ok Dec 15 04:15:20.388 INFO [stdout] test value::encode::tests::roundtrip_text::u32_one ... ok Dec 15 04:15:20.388 INFO [stdout] test value::encode::tests::roundtrip_text::u32_max ... ok Dec 15 04:15:20.389 INFO [stdout] test value::encode::tests::roundtrip_text::u64_max ... ok Dec 15 04:15:20.389 INFO [stdout] test value::encode::tests::roundtrip_text::u64_one ... ok Dec 15 04:15:20.411 INFO [stdout] test value::encode::tests::roundtrip_text::u8_one ... ok Dec 15 04:15:20.411 INFO [stdout] test value::encode::tests::roundtrip_text::u8_max ... ok Dec 15 04:15:20.434 INFO [stdout] test value::encode::tests::roundtrip_text::datetime ... ok Dec 15 04:15:20.443 INFO [stdout] test value::encode::tests::roundtrip_text::time ... ok Dec 15 04:15:20.471 INFO [stdout] test value::encode::tests::roundtrip_text::dur ... ok Dec 15 04:15:20.523 INFO [stdout] test packet::tests::test_long_exact ... ok Dec 15 04:15:20.523 INFO [stdout] test packet::tests::test_long_more ... ok Dec 15 04:15:20.523 INFO [stdout] Dec 15 04:15:20.524 INFO [stdout] test result: ok. 103 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 04:15:20.524 INFO [stdout] Dec 15 04:15:20.533 INFO [stderr] Running /target/debug/deps/async-9f26ad0b8e7fb127 Dec 15 04:15:20.537 INFO [stdout] Dec 15 04:15:20.537 INFO [stdout] running 21 tests Dec 15 04:15:20.755 INFO [stdout] test it_connects ... ok Dec 15 04:15:20.781 INFO [stdout] test it_pings ... ok Dec 15 04:15:20.815 INFO [stdout] test empty_response ... ok Dec 15 04:15:20.825 INFO [stdout] test insert_exec ... ok Dec 15 04:15:20.848 INFO [stdout] test it_queries ... ok Dec 15 04:15:20.859 INFO [stdout] test empty_on_drop ... ok Dec 15 04:15:20.876 INFO [stdout] test it_prepares ... ok Dec 15 04:15:20.887 INFO [stdout] test it_prepares_many ... ok Dec 15 04:15:20.907 INFO [stdout] test no_columns ... ok Dec 15 04:15:20.912 INFO [stdout] test no_columns_but_rows ... ok Dec 15 04:15:20.940 INFO [stdout] test it_queries_many_rows ... ok Dec 15 04:15:20.947 INFO [stdout] test prepared_no_cols ... ok Dec 15 04:15:20.951 INFO [stdout] test it_queries_nulls ... ok Dec 15 04:15:20.959 INFO [stdout] test no_rows ... ok Dec 15 04:15:20.967 INFO [stdout] test prepared_no_cols_but_rows ... ok Dec 15 04:15:21.007 INFO [stdout] test prepared_empty ... ok Dec 15 04:15:21.068 INFO [stdout] test prepared_no_params ... ok Dec 15 04:15:21.096 INFO [stdout] test prepared_no_rows ... ok Dec 15 04:15:21.100 INFO [stdout] test send_long ... ok Dec 15 04:15:21.107 INFO [stdout] test prepared_nulls ... ok Dec 15 04:15:21.475 INFO [stdout] test error_response ... ok Dec 15 04:15:21.475 INFO [stdout] Dec 15 04:15:21.475 INFO [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 04:15:21.475 INFO [stdout] Dec 15 04:15:21.479 INFO [stderr] Running /target/debug/deps/main-13c24cc4031660c7 Dec 15 04:15:21.487 INFO [stdout] Dec 15 04:15:21.487 INFO [stdout] running 22 tests Dec 15 04:15:21.543 INFO [stdout] test error_response ... ok Dec 15 04:15:21.543 INFO [stdout] test empty_response ... ok Dec 15 04:15:21.544 INFO [stdout] test it_pings ... ok Dec 15 04:15:21.551 INFO [stdout] test it_connects ... ok Dec 15 04:15:21.584 INFO [stdout] test insert_exec ... ok Dec 15 04:15:21.587 INFO [stdout] test empty_on_drop ... ok Dec 15 04:15:21.631 INFO [stdout] test it_queries_many_rows ... ok Dec 15 04:15:21.631 INFO [stdout] test it_queries ... ok Dec 15 04:15:21.635 INFO [stdout] test it_prepares_many ... ok Dec 15 04:15:21.635 INFO [stdout] test no_columns ... ok Dec 15 04:15:21.635 INFO [stdout] test it_prepares ... ok Dec 15 04:15:21.635 INFO [stdout] test it_queries_nulls ... ok Dec 15 04:15:21.643 INFO [stdout] test no_columns_but_rows ... ok Dec 15 04:15:21.643 INFO [stdout] test multi_result ... ok Dec 15 04:15:21.683 INFO [stdout] test prepared_no_cols ... ok Dec 15 04:15:21.687 INFO [stdout] test prepared_no_cols_but_rows ... ok Dec 15 04:15:21.727 INFO [stdout] test no_rows ... ok Dec 15 04:15:21.727 INFO [stdout] test prepared_empty ... ok Dec 15 04:15:21.771 INFO [stdout] test prepared_no_params ... ok Dec 15 04:15:21.775 INFO [stdout] test prepared_no_rows ... ok Dec 15 04:15:21.787 INFO [stdout] test prepared_nulls ... ok Dec 15 04:15:21.787 INFO [stderr] Doc-tests msql-srv Dec 15 04:15:21.787 INFO [stdout] test send_long ... ok Dec 15 04:15:21.787 INFO [stdout] Dec 15 04:15:21.787 INFO [stdout] test result: ok. 22 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 04:15:21.787 INFO [stdout] Dec 15 04:15:27.331 INFO [stdout] Dec 15 04:15:27.331 INFO [stdout] running 1 test Dec 15 04:15:37.395 INFO [stdout] test src/lib.rs - (line 15) ... ok Dec 15 04:15:37.395 INFO [stdout] Dec 15 04:15:37.395 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 04:15:37.395 INFO [stdout] Dec 15 04:15:37.415 INFO [stderr] su: No module specific data is present Dec 15 04:15:38.307 INFO running `"docker" "inspect" "ebab40949a0c01894486cf8c72db1b44eb8840d929ce051cc0e38a8bdb7440a3"` Dec 15 04:15:38.543 INFO running `"docker" "rm" "-f" "ebab40949a0c01894486cf8c72db1b44eb8840d929ce051cc0e38a8bdb7440a3"` Dec 15 04:15:38.879 INFO [stdout] ebab40949a0c01894486cf8c72db1b44eb8840d929ce051cc0e38a8bdb7440a3