Nov 18 03:25:01.701 INFO testing poston-0.2.1 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 18 03:25:01.701 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 18 03:25:01.892 INFO [stdout] 3f983b93f4d62027e3a5895fd76a24103288bf1861212620452108716eb3511a
Nov 18 03:25:01.895 INFO running `"docker" "start" "-a" "3f983b93f4d62027e3a5895fd76a24103288bf1861212620452108716eb3511a"`
Nov 18 03:25:02.344 INFO [stderr] usermod: no changes
Nov 18 03:25:02.447 INFO [stderr]    Compiling proc-macro2 v0.4.24
Nov 18 03:25:02.448 INFO [stderr]    Compiling num-traits v0.2.6
Nov 18 03:25:02.449 INFO [stderr]    Compiling unicode-xid v0.1.0
Nov 18 03:25:02.450 INFO [stderr]    Compiling libc v0.2.43
Nov 18 03:25:02.450 INFO [stderr]    Compiling serde v1.0.80
Nov 18 03:25:02.450 INFO [stderr]    Compiling byteorder v1.2.7
Nov 18 03:25:02.451 INFO [stderr]    Compiling cfg-if v0.1.6
Nov 18 03:25:02.451 INFO [stderr]    Compiling safemem v0.3.0
Nov 18 03:25:02.791 INFO [stderr]    Compiling log v0.4.6
Nov 18 03:25:05.695 INFO [stderr]    Compiling base64 v0.9.3
Nov 18 03:25:05.935 INFO [stderr]    Compiling rand v0.4.3
Nov 18 03:25:10.043 INFO [stderr]    Compiling num-traits v0.1.43
Nov 18 03:25:11.026 INFO [stderr]    Compiling rand v0.3.22
Nov 18 03:25:11.027 INFO [stderr]    Compiling uuid v0.6.5
Nov 18 03:25:11.031 INFO [stderr]    Compiling rmp v0.8.7
Nov 18 03:25:11.995 INFO [stderr]    Compiling backoff v0.1.2
Nov 18 03:25:16.323 INFO [stderr]    Compiling quote v0.6.10
Nov 18 03:25:22.066 INFO [stderr]    Compiling syn v0.15.21
Nov 18 03:25:24.811 INFO [stderr]    Compiling rmp-serde v0.13.7
Nov 18 03:25:37.053 INFO [stderr]    Compiling serde_derive v1.0.80
Nov 18 03:25:56.247 INFO [stderr]    Compiling poston v0.2.1 (/source)
Nov 18 03:25:59.699 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 57.33s
Nov 18 03:25:59.727 INFO [stderr] su: No module specific data is present
Nov 18 03:26:00.810 INFO running `"docker" "inspect" "3f983b93f4d62027e3a5895fd76a24103288bf1861212620452108716eb3511a"`
Nov 18 03:26:01.194 INFO running `"docker" "rm" "-f" "3f983b93f4d62027e3a5895fd76a24103288bf1861212620452108716eb3511a"`
Nov 18 03:26:01.627 INFO [stdout] 3f983b93f4d62027e3a5895fd76a24103288bf1861212620452108716eb3511a
Nov 18 03:26:01.636 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 18 03:26:02.212 INFO [stdout] 1c9ff92737bdf5dab382352487f5ec315988596d03314528d85e4836f8b2e703
Nov 18 03:26:02.214 INFO running `"docker" "start" "-a" "1c9ff92737bdf5dab382352487f5ec315988596d03314528d85e4836f8b2e703"`
Nov 18 03:26:03.747 INFO [stderr] usermod: no changes
Nov 18 03:26:03.895 INFO [stderr]    Compiling version_check v0.1.5
Nov 18 03:26:03.896 INFO [stderr]    Compiling libc v0.2.43
Nov 18 03:26:03.896 INFO [stderr]    Compiling cfg-if v0.1.6
Nov 18 03:26:03.896 INFO [stderr]    Compiling regex v1.0.6
Nov 18 03:26:03.896 INFO [stderr]    Compiling ucd-util v0.1.3
Nov 18 03:26:03.903 INFO [stderr]    Compiling lazy_static v1.2.0
Nov 18 03:26:03.904 INFO [stderr]    Compiling num-integer v0.1.39
Nov 18 03:26:03.904 INFO [stderr]    Compiling quick-error v1.2.2
Nov 18 03:26:04.447 INFO [stderr]    Compiling byteorder v1.2.7
Nov 18 03:26:06.362 INFO [stderr]    Compiling utf8-ranges v1.0.2
Nov 18 03:26:06.999 INFO [stderr]    Compiling termcolor v1.0.4
Nov 18 03:26:06.999 INFO [stderr]    Compiling rand_core v0.3.0
Nov 18 03:26:07.117 INFO [stderr]    Compiling safemem v0.3.0
Nov 18 03:26:08.111 INFO [stderr]    Compiling ansi_term v0.11.0
Nov 18 03:26:08.727 INFO [stderr]    Compiling log v0.4.6
Nov 18 03:26:08.727 INFO [stderr]    Compiling thread_local v0.3.6
Nov 18 03:26:09.019 INFO [stderr]    Compiling humantime v1.1.1
Nov 18 03:26:11.122 INFO [stderr]    Compiling base64 v0.9.3
Nov 18 03:26:11.495 INFO [stderr]    Compiling num-traits v0.2.6
Nov 18 03:26:11.863 INFO [stderr]    Compiling serde v1.0.80
Nov 18 03:26:12.484 INFO [stderr]    Compiling regex-syntax v0.6.3
Nov 18 03:26:12.496 INFO [stderr]    Compiling memchr v2.1.1
Nov 18 03:26:12.571 INFO [stderr]    Compiling rand_core v0.2.2
Nov 18 03:26:13.091 INFO [stderr]    Compiling rand v0.4.3
Nov 18 03:26:13.575 INFO [stderr]    Compiling atty v0.2.11
Nov 18 03:26:13.942 INFO [stderr]    Compiling time v0.1.40
Nov 18 03:26:14.663 INFO [stderr]    Compiling rand v0.5.5
Nov 18 03:26:20.405 INFO [stderr]    Compiling num-traits v0.1.43
Nov 18 03:26:20.677 INFO [stderr]    Compiling rand v0.3.22
Nov 18 03:26:20.677 INFO [stderr]    Compiling uuid v0.6.5
Nov 18 03:26:20.782 INFO [stderr]    Compiling aho-corasick v0.6.9
Nov 18 03:26:21.587 INFO [stderr]    Compiling rmp v0.8.7
Nov 18 03:26:22.327 INFO [stderr]    Compiling backoff v0.1.2
Nov 18 03:26:24.020 INFO [stderr]    Compiling chrono v0.4.6
Nov 18 03:26:33.524 INFO [stderr]    Compiling rmp-serde v0.13.7
Nov 18 03:26:34.879 INFO [stderr]    Compiling poston v0.2.1 (/source)
Nov 18 03:26:44.002 INFO [stderr]    Compiling env_logger v0.5.13
Nov 18 03:26:46.065 INFO [stderr]    Compiling pretty_env_logger v0.2.5
Nov 18 03:26:53.960 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 50.19s
Nov 18 03:26:53.970 INFO [stderr] su: No module specific data is present
Nov 18 03:26:54.365 INFO running `"docker" "inspect" "1c9ff92737bdf5dab382352487f5ec315988596d03314528d85e4836f8b2e703"`
Nov 18 03:26:54.697 INFO running `"docker" "rm" "-f" "1c9ff92737bdf5dab382352487f5ec315988596d03314528d85e4836f8b2e703"`
Nov 18 03:26:54.923 INFO [stdout] 1c9ff92737bdf5dab382352487f5ec315988596d03314528d85e4836f8b2e703
Nov 18 03:26:54.923 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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"`
Nov 18 03:26:55.345 INFO [stdout] 1c1b12f3686faad7d510d0d179a264130d8b37225abb8258a8b67254fef6c14a
Nov 18 03:26:55.349 INFO running `"docker" "start" "-a" "1c1b12f3686faad7d510d0d179a264130d8b37225abb8258a8b67254fef6c14a"`
Nov 18 03:26:56.151 INFO [stderr] usermod: no changes
Nov 18 03:26:56.355 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.17s
Nov 18 03:26:56.371 INFO [stderr]      Running /target/debug/deps/poston-c42462c314e8518c
Nov 18 03:26:56.371 INFO [stdout] 
Nov 18 03:26:56.371 INFO [stdout] running 10 tests
Nov 18 03:26:56.375 INFO [stdout] test buffer::test_take::it_should_move_elements_to_passed_buffer ... ok
Nov 18 03:26:56.375 INFO [stdout] test buffer::test_pack_record::it_should_make_forward_mode_buffer ... ok
Nov 18 03:26:56.387 INFO [stdout] test buffer::unpack_response::it_should_unpack_as_ack_reply ... ok
Nov 18 03:26:56.387 INFO [stdout] test time_pack::test::it_should_pack_to_event_time_format ... ok
Nov 18 03:26:56.387 INFO [stdout] test connect::tests::connect ... ok
Nov 18 03:26:56.387 INFO [stdout] test connect::tests::connect_giveup ... ok
Nov 18 03:26:56.387 INFO [stdout] test connect::tests::write_giveup ... ok
Nov 18 03:26:56.387 INFO [stdout] test connect::tests::reconnect ... ok
Nov 18 03:26:56.393 INFO [stdout] test connect::tests::write ... ok
Nov 18 03:26:56.395 INFO [stdout] test worker::tests::worker_new_should_return_err_when_the_connection_open_is_failed ... ok
Nov 18 03:26:56.395 INFO [stdout] 
Nov 18 03:26:56.395 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 03:26:56.395 INFO [stdout] 
Nov 18 03:26:56.400 INFO [stderr]    Doc-tests poston
Nov 18 03:26:58.087 INFO [stderr] su: No module specific data is present
Nov 18 03:26:58.087 INFO [stdout] 
Nov 18 03:26:58.087 INFO [stdout] running 0 tests
Nov 18 03:26:58.087 INFO [stdout] 
Nov 18 03:26:58.087 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 03:26:58.087 INFO [stdout] 
Nov 18 03:26:58.653 INFO running `"docker" "inspect" "1c1b12f3686faad7d510d0d179a264130d8b37225abb8258a8b67254fef6c14a"`
Nov 18 03:26:58.799 INFO running `"docker" "rm" "-f" "1c1b12f3686faad7d510d0d179a264130d8b37225abb8258a8b67254fef6c14a"`
Nov 18 03:26:58.870 INFO [stdout] 1c1b12f3686faad7d510d0d179a264130d8b37225abb8258a8b67254fef6c14a