[INFO] fetching crate ph-eventing 0.1.2...
[INFO] testing ph-eventing-0.1.2 against master#562dee4820c458d823175268e41601d4c060588a for pr-154210-2
[INFO] extracting crate ph-eventing 0.1.2 into /workspace/builds/worker-7-tc1/source
[INFO] removed /workspace/builds/worker-7-tc1/source/rust-toolchain.toml
[INFO] started tweaking crates.io crate ph-eventing 0.1.2
[INFO] finished tweaking crates.io crate ph-eventing 0.1.2
[INFO] tweaked toml for crates.io crate ph-eventing 0.1.2 written to /workspace/builds/worker-7-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate ph-eventing 0.1.2 on toolchain 562dee4820c458d823175268e41601d4c060588a
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate ph-eventing 0.1.2 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/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" "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" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 38c91624f29fe00893fa41136f254fbef81298ac65c5c57f50ee1435622bfda7
[INFO] running `Command { std: "docker" "start" "-a" "38c91624f29fe00893fa41136f254fbef81298ac65c5c57f50ee1435622bfda7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "38c91624f29fe00893fa41136f254fbef81298ac65c5c57f50ee1435622bfda7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "38c91624f29fe00893fa41136f254fbef81298ac65c5c57f50ee1435622bfda7", kill_on_drop: false }`
[INFO] [stdout] 38c91624f29fe00893fa41136f254fbef81298ac65c5c57f50ee1435622bfda7
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/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" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 4e9a5eab02daa70bb2a618bec8ce7e87c3dc299e785f9702f0650fc0462b5031
[INFO] running `Command { std: "docker" "start" "-a" "4e9a5eab02daa70bb2a618bec8ce7e87c3dc299e785f9702f0650fc0462b5031", kill_on_drop: false }`
[INFO] [stderr]    Compiling ph-eventing v0.1.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.23s
[INFO] running `Command { std: "docker" "inspect" "4e9a5eab02daa70bb2a618bec8ce7e87c3dc299e785f9702f0650fc0462b5031", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4e9a5eab02daa70bb2a618bec8ce7e87c3dc299e785f9702f0650fc0462b5031", kill_on_drop: false }`
[INFO] [stdout] 4e9a5eab02daa70bb2a618bec8ce7e87c3dc299e785f9702f0650fc0462b5031
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/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" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d2e9ae699f63387b8e8dfa3d8803300f84f68092e98f98532684374cb199d2d0
[INFO] running `Command { std: "docker" "start" "-a" "d2e9ae699f63387b8e8dfa3d8803300f84f68092e98f98532684374cb199d2d0", kill_on_drop: false }`
[INFO] [stderr]    Compiling ph-eventing v0.1.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.59s
[INFO] running `Command { std: "docker" "inspect" "d2e9ae699f63387b8e8dfa3d8803300f84f68092e98f98532684374cb199d2d0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d2e9ae699f63387b8e8dfa3d8803300f84f68092e98f98532684374cb199d2d0", kill_on_drop: false }`
[INFO] [stdout] d2e9ae699f63387b8e8dfa3d8803300f84f68092e98f98532684374cb199d2d0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc1/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" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 70e1171448e48c06933de21be24c4a4a8131ee2611c9011e0802b12e2c1caf5c
[INFO] running `Command { std: "docker" "start" "-a" "70e1171448e48c06933de21be24c4a4a8131ee2611c9011e0802b12e2c1caf5c", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ph_eventing-6271247a4e07ab61)
[INFO] [stdout] 
[INFO] [stdout] running 46 tests
[INFO] [stdout] test event_buf::tests::drain_returns_count ... ok
[INFO] [stdout] test event_buf::tests::handles_are_send ... ok
[INFO] [stdout] test event_buf::tests::len_and_full_track_state ... ok
[INFO] [stdout] test event_buf::tests::new_buf_is_empty ... ok
[INFO] [stdout] test event_buf::tests::producer_consumer_can_be_recreated ... ok
[INFO] [stdout] test event_buf::tests::push_and_pop_fifo ... ok
[INFO] [stdout] test event_buf::tests::push_rejects_when_full ... ok
[INFO] [stdout] test event_buf::tests::drain_on_empty_returns_zero ... ok
[INFO] [stdout] test event_buf::tests::wraps_around_correctly ... ok
[INFO] [stdout] test ring::tests::capacity_returns_n ... ok
[INFO] [stdout] test event_buf::tests::default_is_new ... ok
[INFO] [stdout] test ring::tests::into_iter_for_ref ... ok
[INFO] [stdout] test ring::tests::iter_exact_size ... ok
[INFO] [stdout] test ring::tests::iter_oldest_to_newest ... ok
[INFO] [stdout] test ring::tests::new_ring_is_empty ... ok
[INFO] [stdout] test ring::tests::clear_resets_state ... ok
[INFO] [stdout] test ring::tests::overwrite_oldest_when_full ... ok
[INFO] [stdout] test ring::tests::default_is_new ... ok
[INFO] [stdout] test seq_ring::tests::dropped_counter_can_reset ... ok
[INFO] [stdout] test ring::tests::push_and_get ... ok
[INFO] [stdout] test seq_ring::tests::capacity_returns_n ... ok
[INFO] [stdout] test seq_ring::tests::drops_when_consumer_lags ... ok
[INFO] [stdout] test seq_ring::tests::latest_empty_returns_false ... ok
[INFO] [stdout] test seq_ring::tests::latest_reads_newest ... ok
[INFO] [stdout] test seq_ring::tests::latest_returns_false_when_slot_missing ... ok
[INFO] [stdout] test seq_ring::tests::poll_up_to_counts_dropped_when_slot_missing ... ok
[INFO] [stdout] test seq_ring::tests::poll_one_empty_returns_false ... ok
[INFO] [stdout] test seq_ring::tests::poll_up_to_zero_returns_newest_only ... ok
[INFO] [stdout] test seq_ring::tests::polls_in_order ... ok
[INFO] [stdout] test seq_ring::tests::push_wraps_seq_from_zero_to_one ... ok
[INFO] [stdout] test seq_ring::tests::read_seq_inner_detects_overwrite_during_read ... ok
[INFO] [stdout] test seq_ring::tests::skip_to_latest_makes_next_poll_latest ... ok
[INFO] [stdout] test traits::tests::event_producer_as_sink ... ok
[INFO] [stdout] test traits::tests::event_consumer_as_source ... ok
[INFO] [stdout] test traits::tests::forward_stops_when_sink_full ... ok
[INFO] [stdout] test traits::tests::generic_drain_event ... ok
[INFO] [stdout] test traits::tests::generic_drain_seq ... ok
[INFO] [stdout] test traits::tests::forward_empty_source_transfers_nothing ... ok
[INFO] [stdout] test traits::tests::forward_event_to_ringbuf ... ok
[INFO] [stdout] test traits::tests::seq_consumer_as_source ... ok
[INFO] [stdout] test traits::tests::ringbuf_as_sink ... ok
[INFO] [stdout] test traits::tests::seq_producer_as_sink ... ok
[INFO] [stdout] test traits::tests::forward_seq_to_event ... ok
[INFO] [stderr]    Doc-tests ph_eventing
[INFO] [stdout] test event_buf::tests::double_consumer_panics - should panic ... ok
[INFO] [stdout] test event_buf::tests::double_producer_panics - should panic ... ok
[INFO] [stdout] test ring::tests::zero_capacity_panics - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 46 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.07s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 7 tests
[INFO] [stdout] test src/lib.rs - (line 36) ... ok
[INFO] [stdout] test src/event_buf.rs - event_buf (line 25) ... ok
[INFO] [stdout] test src/lib.rs - (line 64) ... ok
[INFO] [stdout] test src/lib.rs - (line 25) ... ok
[INFO] [stdout] test src/lib.rs - (line 51) ... ok
[INFO] [stdout] test src/traits.rs - traits::forward (line 67) ... ok
[INFO] [stdout] test src/ring.rs - ring (line 12) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.67s; merged doctests compilation took 0.65s
[INFO] running `Command { std: "docker" "inspect" "70e1171448e48c06933de21be24c4a4a8131ee2611c9011e0802b12e2c1caf5c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "70e1171448e48c06933de21be24c4a4a8131ee2611c9011e0802b12e2c1caf5c", kill_on_drop: false }`
[INFO] [stdout] 70e1171448e48c06933de21be24c4a4a8131ee2611c9011e0802b12e2c1caf5c