[INFO] crate rustypipes 0.1.1 is already in cache
[INFO] testing rustypipes-0.1.1 against beta-2020-07-24 for beta-1.46-1
[INFO] extracting crate rustypipes 0.1.1 into /workspace/builds/worker-11/source
[INFO] validating manifest of crates.io crate rustypipes 0.1.1 on toolchain beta-2020-07-24
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2020-07-24" "read-manifest" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] started tweaking crates.io crate rustypipes 0.1.1
[INFO] finished tweaking crates.io crate rustypipes 0.1.1
[INFO] tweaked toml for crates.io crate rustypipes 0.1.1 written to /workspace/builds/worker-11/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2020-07-24" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2020-07-24" "fetch" "--locked" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-11/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-11/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=0" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env@sha256:a636fd89d022f18117e1dc8fb37a0a009933cdbbe082814857f0e2024962d47c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-07-24" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] c2e01e56c019efdf4a7374b5915177ee9808c0a3c67b5bc3ffc4e9cada62c123
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "c2e01e56c019efdf4a7374b5915177ee9808c0a3c67b5bc3ffc4e9cada62c123", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "c2e01e56c019efdf4a7374b5915177ee9808c0a3c67b5bc3ffc4e9cada62c123", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c2e01e56c019efdf4a7374b5915177ee9808c0a3c67b5bc3ffc4e9cada62c123", kill_on_drop: false }`
[INFO] [stdout] c2e01e56c019efdf4a7374b5915177ee9808c0a3c67b5bc3ffc4e9cada62c123
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-11/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-11/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=0" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env@sha256:a636fd89d022f18117e1dc8fb37a0a009933cdbbe082814857f0e2024962d47c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-07-24" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ecf85f4c79877cd16661bf6a4afd9efd2b488ba44595103647665a26a3ef636c
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "ecf85f4c79877cd16661bf6a4afd9efd2b488ba44595103647665a26a3ef636c", kill_on_drop: false }`
[INFO] [stderr]    Compiling unix-named-pipe v0.2.0
[INFO] [stderr]    Compiling rustypipes v0.1.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.98s
[INFO] running `Command { std: "docker" "inspect" "ecf85f4c79877cd16661bf6a4afd9efd2b488ba44595103647665a26a3ef636c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ecf85f4c79877cd16661bf6a4afd9efd2b488ba44595103647665a26a3ef636c", kill_on_drop: false }`
[INFO] [stdout] ecf85f4c79877cd16661bf6a4afd9efd2b488ba44595103647665a26a3ef636c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-11/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-11/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=0" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env@sha256:a636fd89d022f18117e1dc8fb37a0a009933cdbbe082814857f0e2024962d47c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-07-24" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ada524e241afb93fb8c004efc7e38a370d83002cb4b5f88b305ca7e8099a8a13
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "ada524e241afb93fb8c004efc7e38a370d83002cb4b5f88b305ca7e8099a8a13", kill_on_drop: false }`
[INFO] [stderr]    Compiling rustypipes v0.1.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 3.72s
[INFO] running `Command { std: "docker" "inspect" "ada524e241afb93fb8c004efc7e38a370d83002cb4b5f88b305ca7e8099a8a13", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ada524e241afb93fb8c004efc7e38a370d83002cb4b5f88b305ca7e8099a8a13", kill_on_drop: false }`
[INFO] [stdout] ada524e241afb93fb8c004efc7e38a370d83002cb4b5f88b305ca7e8099a8a13
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-11/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-11/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=0" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env@sha256:a636fd89d022f18117e1dc8fb37a0a009933cdbbe082814857f0e2024962d47c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2020-07-24" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 68a792b9d5d75b0998c71e4c3e28e02226d171ad2821350d343ccda9f1a091ff
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "68a792b9d5d75b0998c71e4c3e28e02226d171ad2821350d343ccda9f1a091ff", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.19s
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/rustypipes-944f592dffc876ac
[INFO] [stdout] 
[INFO] [stdout] running 26 tests
[INFO] [stdout] test cap::tests::test_parse_assignment_with_error ... ok
[INFO] [stdout] test cap::tests::test_encode_assignment_with_pipes ... ok
[INFO] [stdout] test cap::tests::test_parse_assignment_cap_error ... ok
[INFO] [stdout] test serializer::tests::test_decode_bad_checksum ... ok
[INFO] [stdout] test serializer::tests::test_decode_bad_encoded ... ok
[INFO] [stdout] test serializer::tests::test_decode_no_origin ... ok
[INFO] [stdout] test pipes::tests::test_pipe_create_and_delete ... ok
[INFO] [stdout] test cap::tests::test_parse_unsubscription ... ok
[INFO] [stdout] test cap::tests::test_get_cap_message_type ... ok
[INFO] [stdout] test cap::tests::test_parse_assignment ... ok
[INFO] [stdout] test cap::tests::test_parse_subscribe ... ok
[INFO] [stdout] test cap::tests::test_encode_assignment_with_error ... ok
[INFO] [stdout] test cap::tests::test_parse_subscribe_nok ... ok
[INFO] [stdout] test cap::tests::test_parse_unsubscription_with_error ... ok
[INFO] [stdout] test cap::tests::test_encode_unsubscription ... ok
[INFO] [stdout] test cap::tests::test_encode_subscription_without_groups ... ok
[INFO] [stdout] test serializer::tests::test_decode_simple ... ok
[INFO] [stdout] test serializer::tests::test_decode_unsupported_version ... ok
[INFO] [stdout] test serializer::tests::test_decode_no_remote ... ok
[INFO] [stdout] Successfully wrote 255 bytes to pipe rx
[INFO] [stdout] test cap::tests::test_encode_subscription_with_groups ... ok
[INFO] [stdout] test pipes::tests::test_pipe_io ... ok
[INFO] [stdout] test serializer::tests::test_encode_rck ... ok
[INFO] [stdout] test serializer::tests::test_encode_empty ... ok
[INFO] [stdout] test serializer::tests::test_encode_ick ... ok
[INFO] [stdout] test pipes::tests::test_pipe_write_no_endpoint ... ok
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/rustypipes-29c58610f3da1e83
[INFO] [stdout] test pipes::tests::test_pipe_read_no_endpoint ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] Client_r thread started
[INFO] [stdout] Client_r subscribed (no CAP error)
[INFO] [stdout] It took 212ms for client_r to subscribe
[INFO] [stdout] Client_r is now waiting for incoming messages...
[INFO] [stdout] Client_w thread started
[INFO] [stdout] Client_w subscribed (no CAP error)
[INFO] [stdout] It took 212ms for client_w to subscribe
[INFO] [stdout] It took 0ms for client_w to send a message
[INFO] [stdout] It took 0ms for client_w to unsubscribe
[INFO] [stdout] Client_w terminated after 212ms
[INFO] [stdout] test tests::server_sim ... test tests::server_sim has been running for over 60 seconds
[ERROR] error running command: no output for 300 seconds
[INFO] running `Command { std: "docker" "inspect" "68a792b9d5d75b0998c71e4c3e28e02226d171ad2821350d343ccda9f1a091ff", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "68a792b9d5d75b0998c71e4c3e28e02226d171ad2821350d343ccda9f1a091ff", kill_on_drop: false }`
[INFO] [stdout] 68a792b9d5d75b0998c71e4c3e28e02226d171ad2821350d343ccda9f1a091ff