Dec 15 01:12:16.742 INFO testing poston-0.3.1 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 15 01:12:16.742 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 01:12:17.093 INFO [stdout] 8ab17829c0d7556d7cca19f4e9e309af1b90661487b5f1b32979b86f34fc45ab
Dec 15 01:12:17.100 INFO running `"docker" "start" "-a" "8ab17829c0d7556d7cca19f4e9e309af1b90661487b5f1b32979b86f34fc45ab"`
Dec 15 01:12:18.193 INFO [stderr] usermod: no changes
Dec 15 01:12:18.363 INFO [stderr]    Compiling proc-macro2 v0.4.24
Dec 15 01:12:18.363 INFO [stderr]    Compiling num-traits v0.2.6
Dec 15 01:12:18.367 INFO [stderr]    Compiling unicode-xid v0.1.0
Dec 15 01:12:18.367 INFO [stderr]    Compiling rand_core v0.3.0
Dec 15 01:12:18.367 INFO [stderr]    Compiling serde v1.0.82
Dec 15 01:12:18.367 INFO [stderr]    Compiling byteorder v1.2.7
Dec 15 01:12:18.367 INFO [stderr]    Compiling safemem v0.3.0
Dec 15 01:12:18.367 INFO [stderr]    Compiling cfg-if v0.1.6
Dec 15 01:12:19.131 INFO [stderr]    Compiling libc v0.2.45
Dec 15 01:12:19.138 INFO [stderr]    Compiling log v0.4.6
Dec 15 01:12:21.327 INFO [stderr]    Compiling base64 v0.9.3
Dec 15 01:12:21.603 INFO [stderr]    Compiling rand_core v0.2.2
Dec 15 01:12:23.479 INFO [stderr]    Compiling rand v0.4.3
Dec 15 01:12:23.479 INFO [stderr]    Compiling rand v0.5.5
Dec 15 01:12:27.843 INFO [stderr]    Compiling num-traits v0.1.43
Dec 15 01:12:27.956 INFO [stderr]    Compiling quote v0.6.10
Dec 15 01:12:29.615 INFO [stderr]    Compiling rmp v0.8.7
Dec 15 01:12:30.515 INFO [stderr]    Compiling syn v0.15.22
Dec 15 01:12:31.854 INFO [stderr]    Compiling rand v0.3.22
Dec 15 01:12:33.583 INFO [stderr]    Compiling backoff v0.1.2
Dec 15 01:12:34.422 INFO [stderr]    Compiling uuid v0.7.1
Dec 15 01:12:46.867 INFO [stderr]    Compiling rmp-serde v0.13.7
Dec 15 01:12:49.307 INFO [stderr]    Compiling serde_derive v1.0.82
Dec 15 01:13:06.051 INFO [stderr]    Compiling poston v0.3.1 (/source)
Dec 15 01:13:09.748 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 51.53s
Dec 15 01:13:09.759 INFO [stderr] su: No module specific data is present
Dec 15 01:13:10.609 INFO running `"docker" "inspect" "8ab17829c0d7556d7cca19f4e9e309af1b90661487b5f1b32979b86f34fc45ab"`
Dec 15 01:13:11.005 INFO running `"docker" "rm" "-f" "8ab17829c0d7556d7cca19f4e9e309af1b90661487b5f1b32979b86f34fc45ab"`
Dec 15 01:13:11.344 INFO [stdout] 8ab17829c0d7556d7cca19f4e9e309af1b90661487b5f1b32979b86f34fc45ab
Dec 15 01:13:11.348 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 01:13:11.874 INFO [stdout] 2df40708af427b978559d0bcd21fd18eab20d8986763068d49931202c5857637
Dec 15 01:13:11.880 INFO running `"docker" "start" "-a" "2df40708af427b978559d0bcd21fd18eab20d8986763068d49931202c5857637"`
Dec 15 01:13:13.039 INFO [stderr] usermod: no changes
Dec 15 01:13:13.194 INFO [stderr]    Compiling version_check v0.1.5
Dec 15 01:13:13.195 INFO [stderr]    Compiling regex v1.1.0
Dec 15 01:13:13.195 INFO [stderr]    Compiling rand_core v0.3.0
Dec 15 01:13:13.195 INFO [stderr]    Compiling num-integer v0.1.39
Dec 15 01:13:13.195 INFO [stderr]    Compiling lazy_static v1.2.0
Dec 15 01:13:13.199 INFO [stderr]    Compiling ucd-util v0.1.3
Dec 15 01:13:13.199 INFO [stderr]    Compiling quick-error v1.2.2
Dec 15 01:13:13.199 INFO [stderr]    Compiling byteorder v1.2.7
Dec 15 01:13:16.638 INFO [stderr]    Compiling utf8-ranges v1.0.2
Dec 15 01:13:17.149 INFO [stderr]    Compiling safemem v0.3.0
Dec 15 01:13:17.180 INFO [stderr]    Compiling termcolor v1.0.4
Dec 15 01:13:19.657 INFO [stderr]    Compiling ansi_term v0.11.0
Dec 15 01:13:19.705 INFO [stderr]    Compiling thread_local v0.3.6
Dec 15 01:13:19.751 INFO [stderr]    Compiling humantime v1.2.0
Dec 15 01:13:21.587 INFO [stderr]    Compiling regex-syntax v0.6.4
Dec 15 01:13:21.661 INFO [stderr]    Compiling num-traits v0.2.6
Dec 15 01:13:21.756 INFO [stderr]    Compiling serde v1.0.82
Dec 15 01:13:23.140 INFO [stderr]    Compiling rand_core v0.2.2
Dec 15 01:13:26.524 INFO [stderr]    Compiling memchr v2.1.2
Dec 15 01:13:27.053 INFO [stderr]    Compiling time v0.1.41
Dec 15 01:13:27.341 INFO [stderr]    Compiling atty v0.2.11
Dec 15 01:13:28.544 INFO [stderr]    Compiling base64 v0.9.3
Dec 15 01:13:28.666 INFO [stderr]    Compiling rand v0.5.5
Dec 15 01:13:30.467 INFO [stderr]    Compiling backoff v0.1.2
Dec 15 01:13:34.847 INFO [stderr]    Compiling num-traits v0.1.43
Dec 15 01:13:36.989 INFO [stderr]    Compiling rmp v0.8.7
Dec 15 01:13:36.996 INFO [stderr]    Compiling aho-corasick v0.6.9
Dec 15 01:13:38.155 INFO [stderr]    Compiling chrono v0.4.6
Dec 15 01:13:40.193 INFO [stderr]    Compiling uuid v0.7.1
Dec 15 01:13:51.460 INFO [stderr]    Compiling rmp-serde v0.13.7
Dec 15 01:13:53.203 INFO [stderr]    Compiling poston v0.3.1 (/source)
Dec 15 01:14:03.679 INFO [stderr]    Compiling env_logger v0.5.13
Dec 15 01:14:05.982 INFO [stderr]    Compiling pretty_env_logger v0.2.5
Dec 15 01:14:17.049 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 03s
Dec 15 01:14:17.057 INFO [stderr] su: No module specific data is present
Dec 15 01:14:17.396 INFO running `"docker" "inspect" "2df40708af427b978559d0bcd21fd18eab20d8986763068d49931202c5857637"`
Dec 15 01:14:17.473 INFO running `"docker" "rm" "-f" "2df40708af427b978559d0bcd21fd18eab20d8986763068d49931202c5857637"`
Dec 15 01:14:17.594 INFO [stdout] 2df40708af427b978559d0bcd21fd18eab20d8986763068d49931202c5857637
Dec 15 01:14:17.599 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 01:14:17.810 INFO [stdout] 184f46b01d79fb18c48461d57ffea8058dbe9195ca66f4e0fce8172716683cfa
Dec 15 01:14:17.816 INFO running `"docker" "start" "-a" "184f46b01d79fb18c48461d57ffea8058dbe9195ca66f4e0fce8172716683cfa"`
Dec 15 01:14:18.413 INFO [stderr] usermod: no changes
Dec 15 01:14:18.483 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Dec 15 01:14:18.486 INFO [stderr]      Running /target/debug/deps/poston-b8a019832c90f884
Dec 15 01:14:18.488 INFO [stdout] 
Dec 15 01:14:18.488 INFO [stdout] running 10 tests
Dec 15 01:14:18.489 INFO [stdout] test buffer::test_take::it_should_move_elements_to_passed_buffer ... ok
Dec 15 01:14:18.489 INFO [stdout] test connect::tests::write ... ok
Dec 15 01:14:18.489 INFO [stdout] test buffer::test_pack_record::it_should_make_forward_mode_buffer ... ok
Dec 15 01:14:18.489 INFO [stdout] test time_pack::test::it_should_pack_to_event_time_format ... ok
Dec 15 01:14:18.490 INFO [stdout] test connect::tests::connect ... ok
Dec 15 01:14:18.490 INFO [stdout] test connect::tests::reconnect ... ok
Dec 15 01:14:18.491 INFO [stdout] test buffer::unpack_response::it_should_unpack_as_ack_reply ... ok
Dec 15 01:14:18.491 INFO [stdout] test connect::tests::write_giveup ... ok
Dec 15 01:14:18.494 INFO [stdout] test connect::tests::connect_giveup ... ok
Dec 15 01:14:18.500 INFO [stdout] test worker::tests::worker_create_should_return_err_when_the_connection_open_is_failed ... ok
Dec 15 01:14:18.500 INFO [stdout] 
Dec 15 01:14:18.500 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 01:14:18.500 INFO [stdout] 
Dec 15 01:14:18.500 INFO [stderr]    Doc-tests poston
Dec 15 01:14:20.493 INFO [stdout] 
Dec 15 01:14:20.493 INFO [stdout] running 0 tests
Dec 15 01:14:20.493 INFO [stdout] 
Dec 15 01:14:20.493 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 01:14:20.493 INFO [stdout] 
Dec 15 01:14:20.502 INFO [stderr] su: No module specific data is present
Dec 15 01:14:21.039 INFO running `"docker" "inspect" "184f46b01d79fb18c48461d57ffea8058dbe9195ca66f4e0fce8172716683cfa"`
Dec 15 01:14:21.102 INFO running `"docker" "rm" "-f" "184f46b01d79fb18c48461d57ffea8058dbe9195ca66f4e0fce8172716683cfa"`
Dec 15 01:14:21.204 INFO [stdout] 184f46b01d79fb18c48461d57ffea8058dbe9195ca66f4e0fce8172716683cfa