Dec 14 12:53:33.298 INFO testing zmq-pw-0.9.8 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 14 12:53:33.298 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 14 12:53:33.611 INFO [stdout] 0eeedf3ad341863bfcadfb8ec82e898ceea21a971c7dd878781eadc7dde1fddf
Dec 14 12:53:33.613 INFO running `"docker" "start" "-a" "0eeedf3ad341863bfcadfb8ec82e898ceea21a971c7dd878781eadc7dde1fddf"`
Dec 14 12:53:34.135 INFO [stderr] usermod: no changes
Dec 14 12:53:34.242 INFO [stderr]    Compiling metadeps v1.1.2
Dec 14 12:53:35.239 INFO [stderr]    Compiling zmq-pw-sys v0.9.8
Dec 14 12:55:31.310 INFO [stderr] warning: redundant linker flag specified for library `zmq-pw`
Dec 14 12:55:31.310 INFO [stderr] 
Dec 14 12:55:31.393 INFO [stderr]    Compiling zmq-pw v0.9.8 (/source)
Dec 14 12:55:34.477 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2m 00s
Dec 14 12:55:34.483 INFO [stderr] su: No module specific data is present
Dec 14 12:55:35.448 INFO running `"docker" "inspect" "0eeedf3ad341863bfcadfb8ec82e898ceea21a971c7dd878781eadc7dde1fddf"`
Dec 14 12:55:35.724 INFO running `"docker" "rm" "-f" "0eeedf3ad341863bfcadfb8ec82e898ceea21a971c7dd878781eadc7dde1fddf"`
Dec 14 12:55:35.874 INFO [stdout] 0eeedf3ad341863bfcadfb8ec82e898ceea21a971c7dd878781eadc7dde1fddf
Dec 14 12:55:35.881 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 14 12:55:36.259 INFO [stdout] 41e60b067930a58481f3bf734d4619e89437d5fd97a1b2b621474e644976af0b
Dec 14 12:55:36.259 INFO running `"docker" "start" "-a" "41e60b067930a58481f3bf734d4619e89437d5fd97a1b2b621474e644976af0b"`
Dec 14 12:55:37.403 INFO [stderr] usermod: no changes
Dec 14 12:55:37.621 INFO [stderr]    Compiling memchr v0.1.11
Dec 14 12:55:37.621 INFO [stderr]    Compiling thread-id v2.0.0
Dec 14 12:55:37.621 INFO [stderr]    Compiling rand v0.3.22
Dec 14 12:55:37.621 INFO [stderr]    Compiling pulse v0.5.3
Dec 14 12:55:37.621 INFO [stderr]    Compiling nix v0.7.0
Dec 14 12:55:38.476 INFO [stderr]    Compiling thread_local v0.2.7
Dec 14 12:55:39.191 INFO [stderr]    Compiling aho-corasick v0.5.3
Dec 14 12:55:39.867 INFO [stderr]    Compiling tempfile v2.2.0
Dec 14 12:55:43.140 INFO [stderr]    Compiling timebomb v0.1.2
Dec 14 12:55:43.755 INFO [stderr]    Compiling regex v0.1.80
Dec 14 12:55:57.618 INFO [stderr]    Compiling env_logger v0.3.5
Dec 14 12:55:59.475 INFO [stderr]    Compiling quickcheck v0.4.1
Dec 14 12:56:02.632 INFO [stderr]    Compiling zmq-pw v0.9.8 (/source)
Dec 14 12:56:41.582 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 04s
Dec 14 12:56:41.629 INFO [stderr] su: No module specific data is present
Dec 14 12:56:43.335 INFO running `"docker" "inspect" "41e60b067930a58481f3bf734d4619e89437d5fd97a1b2b621474e644976af0b"`
Dec 14 12:56:43.604 INFO running `"docker" "rm" "-f" "41e60b067930a58481f3bf734d4619e89437d5fd97a1b2b621474e644976af0b"`
Dec 14 12:56:43.949 INFO [stdout] 41e60b067930a58481f3bf734d4619e89437d5fd97a1b2b621474e644976af0b
Dec 14 12:56:43.952 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 14 12:56:44.518 INFO [stdout] fc0ff1f468b66e961fc73f622d9b688838bfec077588a78188eebfade39bf00a
Dec 14 12:56:44.520 INFO running `"docker" "start" "-a" "fc0ff1f468b66e961fc73f622d9b688838bfec077588a78188eebfade39bf00a"`
Dec 14 12:56:46.763 INFO [stderr] usermod: no changes
Dec 14 12:56:46.967 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.17s
Dec 14 12:56:46.983 INFO [stderr]      Running /target/debug/deps/zmq_pw-18489d3484cfe509
Dec 14 12:56:46.991 INFO [stderr]      Running /target/debug/deps/compile_tests-a7b645449369b601
Dec 14 12:56:46.991 INFO [stdout] 
Dec 14 12:56:46.991 INFO [stderr]      Running /target/debug/deps/connection-77293a7b940cefdd
Dec 14 12:56:46.991 INFO [stdout] running 0 tests
Dec 14 12:56:46.991 INFO [stdout] 
Dec 14 12:56:46.991 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 12:56:46.991 INFO [stdout] 
Dec 14 12:56:46.991 INFO [stdout] 
Dec 14 12:56:46.991 INFO [stdout] running 0 tests
Dec 14 12:56:46.991 INFO [stdout] 
Dec 14 12:56:46.991 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 12:56:46.991 INFO [stdout] 
Dec 14 12:56:46.999 INFO [stdout] 
Dec 14 12:56:46.999 INFO [stdout] running 7 tests
Dec 14 12:56:47.031 INFO [stdout] test test_poll_inproc ... ok
Dec 14 12:56:47.031 INFO [stdout] test test_inproc ... ok
Dec 14 12:56:47.031 INFO [stdout] test test_poll_tcp ... ok
Dec 14 12:56:47.031 INFO [stdout] test unix::test_external_poll_tcp ... ok
Dec 14 12:56:47.031 INFO [stdout] test unix::test_external_poll_inproc ... ok
Dec 14 12:56:47.031 INFO [stdout] test test_tcp ... ok
Dec 14 12:56:47.031 INFO [stdout] test unix::test_external_poll_ipc ... ok
Dec 14 12:56:47.031 INFO [stdout] 
Dec 14 12:56:47.031 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 12:56:47.031 INFO [stdout] 
Dec 14 12:56:47.039 INFO [stderr]      Running /target/debug/deps/curve-b40308388b5183b1
Dec 14 12:56:47.043 INFO [stdout] 
Dec 14 12:56:47.043 INFO [stdout] running 1 test
Dec 14 12:56:47.091 INFO [stdout] this is it foo
Dec 14 12:56:47.091 INFO [stderr]      Running /target/debug/deps/error-eaed1b9d004c4a22
Dec 14 12:56:47.091 INFO [stdout] test test_curve_messages ... ok
Dec 14 12:56:47.091 INFO [stdout] 
Dec 14 12:56:47.091 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 12:56:47.091 INFO [stdout] 
Dec 14 12:56:47.093 INFO [stdout] 
Dec 14 12:56:47.093 INFO [stdout] running 1 test
Dec 14 12:56:47.094 INFO [stdout] test from_raw_eintr ... ok
Dec 14 12:56:47.094 INFO [stdout] 
Dec 14 12:56:47.094 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 12:56:47.094 INFO [stdout] 
Dec 14 12:56:47.096 INFO [stderr]      Running /target/debug/deps/message-97e4a536af8c0d0d
Dec 14 12:56:47.106 INFO [stdout] 
Dec 14 12:56:47.106 INFO [stdout] running 3 tests
Dec 14 12:56:47.110 INFO [stdout] test msg_vec_roundtrip ... ok
Dec 14 12:56:47.115 INFO [stdout] test msg_cmp_eq ... ok
Dec 14 12:56:47.151 INFO [stdout] test msg_cmp_ne ... ok
Dec 14 12:56:47.151 INFO [stdout] 
Dec 14 12:56:47.151 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 12:56:47.151 INFO [stdout] 
Dec 14 12:56:47.154 INFO [stderr]      Running /target/debug/deps/test-19234e371ec9da48
Dec 14 12:56:47.163 INFO [stdout] 
Dec 14 12:56:47.163 INFO [stdout] running 50 tests
Dec 14 12:56:47.193 INFO [stdout] test test_curve_keypair ... ok
Dec 14 12:56:47.193 INFO [stdout] test test_ctx_nohang ... ok
Dec 14 12:56:47.193 INFO [stdout] test test_create_stream_socket ... ok
Dec 14 12:56:47.193 INFO [stdout] test test_disconnect ... ok
Dec 14 12:56:47.197 INFO [stdout] test test_disconnect_err ... ok
Dec 14 12:56:47.197 INFO [stdout] test test_exchanging_bytes ... ok
Dec 14 12:56:47.197 INFO [stdout] test test_getset_affinity ... ok
Dec 14 12:56:47.198 INFO [stdout] test test_get_socket_type ... ok
Dec 14 12:56:47.198 INFO [stdout] test test_getset_curve_publickey ... ok
Dec 14 12:56:47.199 INFO [stdout] test test_getset_curve_secretkey ... ok
Dec 14 12:56:47.199 INFO [stdout] test test_exchanging_messages ... ok
Dec 14 12:56:47.199 INFO [stdout] test test_getset_curve_serverkey ... ok
Dec 14 12:56:47.199 INFO [stdout] test test_getset_curve_server ... ok
Dec 14 12:56:47.204 INFO [stdout] test test_getset_identity ... ok
Dec 14 12:56:47.205 INFO [stdout] test test_getset_immediate ... ok
Dec 14 12:56:47.205 INFO [stdout] test test_exchanging_multipart ... ok
Dec 14 12:56:47.206 INFO [stdout] test test_exchanging_strings ... ok
Dec 14 12:56:47.223 INFO [stdout] test test_getset_conflate ... ok
Dec 14 12:56:47.228 INFO [stdout] test test_getset_backlog ... ok
Dec 14 12:56:47.239 INFO [stdout] test test_get_fd ... ok
Dec 14 12:56:47.251 INFO [stdout] test test_getset_keepalive ... ok
Dec 14 12:56:47.251 INFO [stdout] test test_getset_maxmsgsize ... ok
Dec 14 12:56:47.251 INFO [stdout] test test_getset_keepalive_idle ... ok
Dec 14 12:56:47.251 INFO [stdout] test test_getset_linger ... ok
Dec 14 12:56:47.251 INFO [stdout] test test_getset_ipv6 ... ok
Dec 14 12:56:47.251 INFO [stdout] test test_getset_keepalive_cnt ... ok
Dec 14 12:56:47.251 INFO [stdout] test test_getset_rcvtimeo ... ok
Dec 14 12:56:47.251 INFO [stdout] test test_getset_multicast_hops ... ok
Dec 14 12:56:47.251 INFO [stdout] test test_getset_reconnect_ivl ... ok
Dec 14 12:56:47.251 INFO [stdout] test test_getset_plain_server ... ok
Dec 14 12:56:47.251 INFO [stdout] test test_getset_rcvbuf ... ok
Dec 14 12:56:47.251 INFO [stdout] test test_getset_plain_username ... ok
Dec 14 12:56:47.251 INFO [stdout] test test_getset_rcvhwm ... ok
Dec 14 12:56:47.253 INFO [stdout] test test_getset_rate ... ok
Dec 14 12:56:47.253 INFO [stdout] test test_getset_plain_password ... ok
Dec 14 12:56:47.253 INFO [stdout] test test_getset_reconnect_ivl_max ... ok
Dec 14 12:56:47.253 INFO [stdout] test test_getset_sndbuf ... ok
Dec 14 12:56:47.253 INFO [stdout] test test_getset_recovery_ivl ... ok
Dec 14 12:56:47.253 INFO [stdout] test test_getset_sndhwm ... ok
Dec 14 12:56:47.253 INFO [stdout] test test_getset_sndtimeo ... ok
Dec 14 12:56:47.253 INFO [stdout] test test_getset_socks_proxy ... ok
Dec 14 12:56:47.253 INFO [stdout] test test_into_io_error ... ok
Dec 14 12:56:47.255 INFO [stdout] test test_getset_zap_domain ... ok
Dec 14 12:56:47.255 INFO [stdout] test test_version ... ok
Dec 14 12:56:47.255 INFO [stdout] test test_getset_tcp_keepalive_intvl ... ok
Dec 14 12:56:47.255 INFO [stdout] test test_getset_tos ... ok
Dec 14 12:56:47.256 INFO [stdout] test test_raw_roundtrip ... ok
Dec 14 12:56:47.256 INFO [stdout] test test_subscription ... ok
Dec 14 12:56:47.256 INFO [stdout] test test_zmq_error ... ok
Dec 14 12:56:48.257 INFO [stdout] test test_polling ... ok
Dec 14 12:56:48.257 INFO [stdout] 
Dec 14 12:56:48.257 INFO [stdout] test result: ok. 50 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 12:56:48.257 INFO [stdout] 
Dec 14 12:56:48.257 INFO [stderr]      Running /target/debug/deps/z85-0967b66b780089df
Dec 14 12:56:48.267 INFO [stdout] 
Dec 14 12:56:48.267 INFO [stdout] running 3 tests
Dec 14 12:56:48.267 INFO [stdout] test test_decode_errors ... ok
Dec 14 12:56:48.275 INFO [stdout] test test_z85 ... ok
Dec 14 12:56:48.331 INFO [stdout] test z85_roundtrip ... ok
Dec 14 12:56:48.331 INFO [stderr]    Doc-tests zmq-pw
Dec 14 12:56:48.331 INFO [stdout] 
Dec 14 12:56:48.331 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 12:56:48.331 INFO [stdout] 
Dec 14 12:56:49.507 INFO [stdout] 
Dec 14 12:56:49.507 INFO [stdout] running 1 test
Dec 14 12:56:51.451 INFO [stdout] test src/lib.rs - Socket::get_events (line 478) ... ok
Dec 14 12:56:51.451 INFO [stdout] 
Dec 14 12:56:51.451 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 12:56:51.451 INFO [stdout] 
Dec 14 12:56:51.462 INFO [stderr] su: No module specific data is present
Dec 14 12:56:51.947 INFO running `"docker" "inspect" "fc0ff1f468b66e961fc73f622d9b688838bfec077588a78188eebfade39bf00a"`
Dec 14 12:56:52.253 INFO running `"docker" "rm" "-f" "fc0ff1f468b66e961fc73f622d9b688838bfec077588a78188eebfade39bf00a"`
Dec 14 12:56:52.527 INFO [stdout] fc0ff1f468b66e961fc73f622d9b688838bfec077588a78188eebfade39bf00a