Nov 17 17:23:07.188 INFO testing zmq-pw-0.9.8 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982 Nov 17 17:23:07.190 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 17 17:23:07.655 INFO [stdout] 804b4ae8626573a177ab9e32018d946b4d85d6e045ea63125d0f1a01bed9e843 Nov 17 17:23:07.660 INFO running `"docker" "start" "-a" "804b4ae8626573a177ab9e32018d946b4d85d6e045ea63125d0f1a01bed9e843"` Nov 17 17:23:09.003 INFO [stderr] usermod: no changes Nov 17 17:23:09.138 INFO [stderr] Compiling metadeps v1.1.2 Nov 17 17:23:10.299 INFO [stderr] Compiling zmq-pw-sys v0.9.8 Nov 17 17:25:07.163 INFO [stderr] warning: redundant linker flag specified for library `zmq-pw` Nov 17 17:25:07.163 INFO [stderr] Nov 17 17:25:07.208 INFO [stderr] Compiling zmq-pw v0.9.8 (/source) Nov 17 17:25:09.560 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 2m 00s Nov 17 17:25:09.575 INFO [stderr] su: No module specific data is present Nov 17 17:25:10.167 INFO running `"docker" "inspect" "804b4ae8626573a177ab9e32018d946b4d85d6e045ea63125d0f1a01bed9e843"` Nov 17 17:25:10.391 INFO running `"docker" "rm" "-f" "804b4ae8626573a177ab9e32018d946b4d85d6e045ea63125d0f1a01bed9e843"` Nov 17 17:25:10.551 INFO [stdout] 804b4ae8626573a177ab9e32018d946b4d85d6e045ea63125d0f1a01bed9e843 Nov 17 17:25:10.556 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 17 17:25:10.852 INFO [stdout] b3becf753b64bc6b83f48aa386e06536ddff01026d3bb2d4e333dcef1d9cd9ef Nov 17 17:25:10.856 INFO running `"docker" "start" "-a" "b3becf753b64bc6b83f48aa386e06536ddff01026d3bb2d4e333dcef1d9cd9ef"` Nov 17 17:25:11.592 INFO [stderr] usermod: no changes Nov 17 17:25:11.785 INFO [stderr] Compiling pulse v0.5.3 Nov 17 17:25:11.788 INFO [stderr] Compiling env_logger v0.3.5 Nov 17 17:25:12.992 INFO [stderr] Compiling timebomb v0.1.2 Nov 17 17:25:13.463 INFO [stderr] Compiling quickcheck v0.4.1 Nov 17 17:25:16.295 INFO [stderr] Compiling zmq-pw v0.9.8 (/source) Nov 17 17:25:46.739 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 35.13s Nov 17 17:25:46.775 INFO [stderr] su: No module specific data is present Nov 17 17:25:47.615 INFO running `"docker" "inspect" "b3becf753b64bc6b83f48aa386e06536ddff01026d3bb2d4e333dcef1d9cd9ef"` Nov 17 17:25:47.864 INFO running `"docker" "rm" "-f" "b3becf753b64bc6b83f48aa386e06536ddff01026d3bb2d4e333dcef1d9cd9ef"` Nov 17 17:25:48.181 INFO [stdout] b3becf753b64bc6b83f48aa386e06536ddff01026d3bb2d4e333dcef1d9cd9ef Nov 17 17:25:48.190 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 17 17:25:48.627 INFO [stdout] 7d4582a21a4195469417f14493db76a94c9dfe9cd0b9346cb14b97d60d25fb9f Nov 17 17:25:48.631 INFO running `"docker" "start" "-a" "7d4582a21a4195469417f14493db76a94c9dfe9cd0b9346cb14b97d60d25fb9f"` Nov 17 17:25:49.569 INFO [stderr] usermod: no changes Nov 17 17:25:49.713 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.12s Nov 17 17:25:49.726 INFO [stderr] Running /target/debug/deps/zmq_pw-b5bf6759b52b4da4 Nov 17 17:25:49.729 INFO [stdout] Nov 17 17:25:49.729 INFO [stdout] running 0 tests Nov 17 17:25:49.729 INFO [stdout] Nov 17 17:25:49.729 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Nov 17 17:25:49.729 INFO [stdout] Nov 17 17:25:49.729 INFO [stderr] Running /target/debug/deps/compile_tests-241f215f9966ece3 Nov 17 17:25:49.730 INFO [stdout] Nov 17 17:25:49.731 INFO [stdout] running 0 tests Nov 17 17:25:49.731 INFO [stdout] Nov 17 17:25:49.731 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Nov 17 17:25:49.731 INFO [stdout] Nov 17 17:25:49.735 INFO [stderr] Running /target/debug/deps/connection-0f66cad6b39537be Nov 17 17:25:49.738 INFO [stdout] Nov 17 17:25:49.738 INFO [stdout] running 7 tests Nov 17 17:25:49.748 INFO [stdout] test unix::test_external_poll_inproc ... ok Nov 17 17:25:49.748 INFO [stdout] test test_inproc ... ok Nov 17 17:25:49.748 INFO [stdout] test test_poll_inproc ... ok Nov 17 17:25:49.752 INFO [stdout] test test_tcp ... ok Nov 17 17:25:49.757 INFO [stdout] test unix::test_external_poll_ipc ... ok Nov 17 17:25:49.758 INFO [stdout] test unix::test_external_poll_tcp ... ok Nov 17 17:25:49.764 INFO [stdout] test test_poll_tcp ... ok Nov 17 17:25:49.764 INFO [stdout] Nov 17 17:25:49.764 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Nov 17 17:25:49.765 INFO [stdout] Nov 17 17:25:49.766 INFO [stderr] Running /target/debug/deps/curve-5544d44695418aa0 Nov 17 17:25:49.773 INFO [stdout] Nov 17 17:25:49.773 INFO [stdout] running 1 test Nov 17 17:25:49.795 INFO [stdout] this is it foo Nov 17 17:25:49.796 INFO [stdout] test test_curve_messages ... ok Nov 17 17:25:49.797 INFO [stderr] Running /target/debug/deps/error-62575be7df571eb9 Nov 17 17:25:49.797 INFO [stdout] Nov 17 17:25:49.797 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Nov 17 17:25:49.797 INFO [stdout] Nov 17 17:25:49.809 INFO [stdout] Nov 17 17:25:49.809 INFO [stdout] running 1 test Nov 17 17:25:49.809 INFO [stdout] test from_raw_eintr ... ok Nov 17 17:25:49.810 INFO [stdout] Nov 17 17:25:49.810 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Nov 17 17:25:49.810 INFO [stdout] Nov 17 17:25:49.811 INFO [stderr] Running /target/debug/deps/message-058b611fabb931a6 Nov 17 17:25:49.821 INFO [stdout] Nov 17 17:25:49.822 INFO [stdout] running 3 tests Nov 17 17:25:49.837 INFO [stdout] test msg_cmp_eq ... ok Nov 17 17:25:49.838 INFO [stdout] test msg_vec_roundtrip ... ok Nov 17 17:25:49.842 INFO [stdout] test msg_cmp_ne ... ok Nov 17 17:25:49.843 INFO [stdout] Nov 17 17:25:49.843 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Nov 17 17:25:49.843 INFO [stdout] Nov 17 17:25:49.845 INFO [stderr] Running /target/debug/deps/test-8d6bef45f173e88b Nov 17 17:25:49.859 INFO [stdout] Nov 17 17:25:49.859 INFO [stdout] running 50 tests Nov 17 17:25:49.872 INFO [stdout] test test_curve_keypair ... ok Nov 17 17:25:49.874 INFO [stdout] test test_exchanging_messages ... ok Nov 17 17:25:49.874 INFO [stdout] test test_exchanging_bytes ... ok Nov 17 17:25:49.875 INFO [stdout] test test_ctx_nohang ... ok Nov 17 17:25:49.877 INFO [stdout] test test_create_stream_socket ... ok Nov 17 17:25:49.877 INFO [stdout] test test_disconnect_err ... ok Nov 17 17:25:49.879 INFO [stdout] test test_get_fd ... ok Nov 17 17:25:49.891 INFO [stdout] test test_disconnect ... ok Nov 17 17:25:49.892 INFO [stdout] test test_exchanging_multipart ... ok Nov 17 17:25:49.893 INFO [stdout] test test_exchanging_strings ... ok Nov 17 17:25:49.899 INFO [stdout] test test_get_socket_type ... ok Nov 17 17:25:49.899 INFO [stdout] test test_getset_affinity ... ok Nov 17 17:25:49.899 INFO [stdout] test test_getset_curve_publickey ... ok Nov 17 17:25:49.900 INFO [stdout] test test_getset_conflate ... ok Nov 17 17:25:49.901 INFO [stdout] test test_getset_curve_serverkey ... ok Nov 17 17:25:49.901 INFO [stdout] test test_getset_immediate ... ok Nov 17 17:25:49.905 INFO [stdout] test test_getset_backlog ... ok Nov 17 17:25:49.905 INFO [stdout] test test_getset_identity ... ok Nov 17 17:25:49.905 INFO [stdout] test test_getset_curve_secretkey ... ok Nov 17 17:25:49.905 INFO [stdout] test test_getset_ipv6 ... ok Nov 17 17:25:49.906 INFO [stdout] test test_getset_plain_password ... ok Nov 17 17:25:49.906 INFO [stdout] test test_getset_linger ... ok Nov 17 17:25:49.906 INFO [stdout] test test_getset_keepalive_idle ... ok Nov 17 17:25:49.907 INFO [stdout] test test_getset_plain_server ... ok Nov 17 17:25:49.909 INFO [stdout] test test_getset_keepalive_cnt ... ok Nov 17 17:25:49.909 INFO [stdout] test test_getset_curve_server ... ok Nov 17 17:25:49.910 INFO [stdout] test test_getset_rcvhwm ... ok Nov 17 17:25:49.911 INFO [stdout] test test_getset_rcvtimeo ... ok Nov 17 17:25:49.915 INFO [stdout] test test_getset_rate ... ok Nov 17 17:25:49.915 INFO [stdout] test test_getset_rcvbuf ... ok Nov 17 17:25:49.915 INFO [stdout] test test_getset_plain_username ... ok Nov 17 17:25:49.916 INFO [stdout] test test_getset_reconnect_ivl_max ... ok Nov 17 17:25:49.919 INFO [stdout] test test_getset_reconnect_ivl ... ok Nov 17 17:25:49.923 INFO [stdout] test test_getset_keepalive ... ok Nov 17 17:25:49.923 INFO [stdout] test test_getset_recovery_ivl ... ok Nov 17 17:25:49.924 INFO [stdout] test test_getset_maxmsgsize ... ok Nov 17 17:25:49.929 INFO [stdout] test test_getset_sndhwm ... ok Nov 17 17:25:49.929 INFO [stdout] test test_getset_multicast_hops ... ok Nov 17 17:25:49.929 INFO [stdout] test test_getset_sndbuf ... ok Nov 17 17:25:49.929 INFO [stdout] test test_getset_sndtimeo ... ok Nov 17 17:25:49.931 INFO [stdout] test test_getset_tos ... ok Nov 17 17:25:49.932 INFO [stdout] test test_getset_zap_domain ... ok Nov 17 17:25:49.932 INFO [stdout] test test_getset_tcp_keepalive_intvl ... ok Nov 17 17:25:49.939 INFO [stdout] test test_into_io_error ... ok Nov 17 17:25:49.939 INFO [stdout] test test_getset_socks_proxy ... ok Nov 17 17:25:49.939 INFO [stdout] test test_zmq_error ... ok Nov 17 17:25:49.943 INFO [stdout] test test_subscription ... ok Nov 17 17:25:49.943 INFO [stdout] test test_version ... ok Nov 17 17:25:49.943 INFO [stdout] test test_raw_roundtrip ... ok Nov 17 17:25:50.943 INFO [stdout] test test_polling ... ok Nov 17 17:25:50.944 INFO [stderr] Running /target/debug/deps/z85-966847f254ea22c8 Nov 17 17:25:50.944 INFO [stdout] Nov 17 17:25:50.944 INFO [stdout] test result: ok. 50 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Nov 17 17:25:50.945 INFO [stdout] Nov 17 17:25:50.945 INFO [stdout] Nov 17 17:25:50.945 INFO [stdout] running 3 tests Nov 17 17:25:50.951 INFO [stdout] test test_decode_errors ... ok Nov 17 17:25:50.952 INFO [stdout] test test_z85 ... ok Nov 17 17:25:51.007 INFO [stdout] test z85_roundtrip ... ok Nov 17 17:25:51.008 INFO [stdout] Nov 17 17:25:51.008 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Nov 17 17:25:51.008 INFO [stdout] Nov 17 17:25:51.008 INFO [stderr] Doc-tests zmq-pw Nov 17 17:25:51.987 INFO [stdout] Nov 17 17:25:51.987 INFO [stdout] running 1 test Nov 17 17:25:53.799 INFO [stdout] test src/lib.rs - Socket::get_events (line 478) ... ok Nov 17 17:25:53.799 INFO [stdout] Nov 17 17:25:53.799 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Nov 17 17:25:53.799 INFO [stdout] Nov 17 17:25:53.811 INFO [stderr] su: No module specific data is present Nov 17 17:25:54.463 INFO running `"docker" "inspect" "7d4582a21a4195469417f14493db76a94c9dfe9cd0b9346cb14b97d60d25fb9f"` Nov 17 17:25:54.649 INFO running `"docker" "rm" "-f" "7d4582a21a4195469417f14493db76a94c9dfe9cd0b9346cb14b97d60d25fb9f"` Nov 17 17:25:54.909 INFO [stdout] 7d4582a21a4195469417f14493db76a94c9dfe9cd0b9346cb14b97d60d25fb9f