[INFO] fetching crate ph-esp32-mac 0.1.1...
[INFO] testing ph-esp32-mac-0.1.1 against master#562dee4820c458d823175268e41601d4c060588a for pr-154210-2
[INFO] extracting crate ph-esp32-mac 0.1.1 into /workspace/builds/worker-4-tc1/source
[INFO] started tweaking crates.io crate ph-esp32-mac 0.1.1
[INFO] finished tweaking crates.io crate ph-esp32-mac 0.1.1
[INFO] tweaked toml for crates.io crate ph-esp32-mac 0.1.1 written to /workspace/builds/worker-4-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate ph-esp32-mac 0.1.1 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-esp32-mac 0.1.1 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] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded riscv-pac v0.2.0
[INFO] [stderr]   Downloaded xtensa-lx v0.13.0
[INFO] [stderr]   Downloaded fugit v0.3.9
[INFO] [stderr]   Downloaded embassy-net-driver v0.2.0
[INFO] [stderr]   Downloaded defmt v1.0.1
[INFO] [stderr]   Downloaded defmt-parser v1.0.0
[INFO] [stderr]   Downloaded riscv-macros v0.3.0
[INFO] [stderr]   Downloaded bitfield-macros v0.19.4
[INFO] [stderr]   Downloaded riscv v0.15.0
[INFO] [stderr]   Downloaded bitfield v0.19.4
[INFO] [stderr]   Downloaded embassy-sync v0.7.2
[INFO] [stderr]   Downloaded somni-parser v0.2.2
[INFO] [stderr]   Downloaded esp-metadata-generated v0.3.0
[INFO] [stderr]   Downloaded esp-hal v1.0.0
[INFO] [stderr]   Downloaded embedded-io-async v0.6.1
[INFO] [stderr]   Downloaded defmt-macros v1.0.1
[INFO] [stderr]   Downloaded defmt v0.3.100
[INFO] [stderr]   Downloaded embassy-sync v0.6.2
[INFO] [stderr]   Downloaded managed v0.8.0
[INFO] [stderr]   Downloaded gcd v2.3.0
[INFO] [stderr]   Downloaded smoltcp v0.12.0
[INFO] [stderr]   Downloaded somni-expr v0.2.0
[INFO] [stderr]   Downloaded delegate v0.13.5
[INFO] [stderr]   Downloaded esp-config v0.6.1
[INFO] [stderr]   Downloaded esp-hal-procmacros v0.21.0
[INFO] [stderr]   Downloaded esp-sync v0.1.1
[INFO] [stderr]   Downloaded esp-rom-sys v0.1.3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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] a0a61f07572515906e25266688a6a17e0f0c060aa09020e5ef74ae7b09fdf3e0
[INFO] running `Command { std: "docker" "start" "-a" "a0a61f07572515906e25266688a6a17e0f0c060aa09020e5ef74ae7b09fdf3e0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "a0a61f07572515906e25266688a6a17e0f0c060aa09020e5ef74ae7b09fdf3e0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a0a61f07572515906e25266688a6a17e0f0c060aa09020e5ef74ae7b09fdf3e0", kill_on_drop: false }`
[INFO] [stdout] a0a61f07572515906e25266688a6a17e0f0c060aa09020e5ef74ae7b09fdf3e0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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] 33f1f7e0b08d923cb1e262cd485791f22aaf6d90417734537bd86556d8333141
[INFO] running `Command { std: "docker" "start" "-a" "33f1f7e0b08d923cb1e262cd485791f22aaf6d90417734537bd86556d8333141", kill_on_drop: false }`
[INFO] [stderr]    Compiling embedded-hal v1.0.0
[INFO] [stderr]    Compiling ph-esp32-mac v0.1.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.97s
[INFO] running `Command { std: "docker" "inspect" "33f1f7e0b08d923cb1e262cd485791f22aaf6d90417734537bd86556d8333141", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "33f1f7e0b08d923cb1e262cd485791f22aaf6d90417734537bd86556d8333141", kill_on_drop: false }`
[INFO] [stdout] 33f1f7e0b08d923cb1e262cd485791f22aaf6d90417734537bd86556d8333141
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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] 266c05c37048f3497e99475faa9f93798553170d393d0579a10d8a157bed9957
[INFO] running `Command { std: "docker" "start" "-a" "266c05c37048f3497e99475faa9f93798553170d393d0579a10d8a157bed9957", kill_on_drop: false }`
[INFO] [stderr]    Compiling critical-section v1.2.0
[INFO] [stderr]    Compiling ph-esp32-mac v0.1.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.80s
[INFO] running `Command { std: "docker" "inspect" "266c05c37048f3497e99475faa9f93798553170d393d0579a10d8a157bed9957", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "266c05c37048f3497e99475faa9f93798553170d393d0579a10d8a157bed9957", kill_on_drop: false }`
[INFO] [stdout] 266c05c37048f3497e99475faa9f93798553170d393d0579a10d8a157bed9957
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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] 3e8ef5c58f7124e2e68d5481ef9963f732abb48a2e67088a3c258070a1f93854
[INFO] running `Command { std: "docker" "start" "-a" "3e8ef5c58f7124e2e68d5481ef9963f732abb48a2e67088a3c258070a1f93854", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ph_esp32_mac-fe47328a4c935c3d)
[INFO] [stdout] running 269 tests
[INFO] [stdout] test boards::wt32_eth01::tests::phy_id_validation ... ok
[INFO] [stdout] test driver::config::tests::config_builder_chaining ... ok
[INFO] [stdout] test driver::config::tests::config_builder_mac_address ... ok
[INFO] [stdout] test driver::config::tests::config_builder_dma_burst_len ... ok
[INFO] [stdout] test boards::wt32_eth01::tests::pin_assignments_match_board ... ok
[INFO] [stdout] test driver::config::tests::config_builder_phy_interface ... ok
[INFO] [stdout] test driver::config::tests::config_builder_promiscuous ... ok
[INFO] [stdout] test driver::config::tests::config_builder_rmii_external_clock ... ok
[INFO] [stdout] test driver::config::tests::config_builder_rmii_internal_clock ... ok
[INFO] [stdout] test driver::config::tests::config_default_trait_matches_new ... ok
[INFO] [stdout] test driver::config::tests::config_default_values ... ok
[INFO] [stdout] test driver::config::tests::config_rmii_esp32_default_matches_new ... ok
[INFO] [stdout] test driver::config::tests::dma_burst_len_to_pbl ... ok
[INFO] [stdout] test driver::config::tests::duplex_default ... ok
[INFO] [stdout] test driver::config::tests::mac_filter_with_mask ... ok
[INFO] [stdout] test driver::config::tests::phy_interface_default ... ok
[INFO] [stdout] test driver::config::tests::speed_default ... ok
[INFO] [stdout] test driver::error::tests::config_error_equality ... ok
[INFO] [stdout] test driver::error::tests::config_error_clone ... ok
[INFO] [stdout] test driver::error::tests::config_result_type_works ... ok
[INFO] [stdout] test driver::error::tests::config_error_display ... ok
[INFO] [stdout] test driver::error::tests::dma_result_type_works ... ok
[INFO] [stdout] test driver::error::tests::error_clone ... ok
[INFO] [stdout] test driver::error::tests::error_display_config ... ok
[INFO] [stdout] test driver::error::tests::error_display_dma ... ok
[INFO] [stdout] test driver::error::tests::error_equality ... ok
[INFO] [stdout] test driver::error::tests::error_display_io ... ok
[INFO] [stdout] test driver::config::tests::flow_control_default ... ok
[INFO] [stdout] test driver::config::tests::flow_control_with_water_marks ... ok
[INFO] [stdout] test driver::error::tests::error_from_config_error ... ok
[INFO] [stdout] test driver::config::tests::mac_filter_new ... ok
[INFO] [stdout] test driver::error::tests::error_from_io_error ... ok
[INFO] [stdout] test driver::config::tests::state_default ... ok
[INFO] [stdout] test driver::error::tests::io_error_as_str_non_empty ... ok
[INFO] [stdout] test driver::error::tests::error_from_dma_error ... ok
[INFO] [stdout] test driver::error::tests::config_error_as_str_non_empty ... ok
[INFO] [stdout] test driver::error::tests::dma_error_as_str_non_empty ... ok
[INFO] [stdout] test driver::error::tests::dma_error_display ... ok
[INFO] [stdout] test driver::error::tests::dma_error_equality ... ok
[INFO] [stdout] test driver::error::tests::io_error_display ... ok
[INFO] [stdout] test driver::error::tests::io_error_equality ... ok
[INFO] [stdout] test driver::error::tests::result_type_works ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_any_false_when_zero ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_any_ignores_summary_bits ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_any_true_for_error ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_any_true_for_rx ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_any_true_for_tx ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_default_is_zero ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_from_raw_fatal_bus_error ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_from_raw_abnormal_summary ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_from_raw_rx_complete ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_from_raw_normal_summary ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_from_raw_rx_overflow ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_from_raw_rx_stopped ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_from_raw_tx_buf_unavailable ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_from_raw_tx_complete ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_from_raw_zero ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_from_raw_tx_underflow ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_has_error_false_for_normal ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_from_raw_tx_stopped ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_has_error_true_for_multiple_errors ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_has_error_true_for_overflow ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_has_error_false_when_zero ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_to_raw_roundtrip_all ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_to_raw_roundtrip ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_has_error_true_for_underflow ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_to_raw_zero ... ok
[INFO] [stdout] test driver::error::tests::io_result_type_works ... ok
[INFO] [stdout] test driver::config::tests::mac_filter_source ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_from_raw_rx_buf_unavailable ... ok
[INFO] [stdout] test hal::mdio::tests::anlpar_100_fd_parsing ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_has_error_true_for_fatal_bus ... ok
[INFO] [stdout] test hal::mdio::tests::anar_selector_field ... ok
[INFO] [stdout] test hal::mdio::tests::anar_bit_positions ... ok
[INFO] [stdout] test hal::mdio::tests::anlpar_10_hd_parsing ... ok
[INFO] [stdout] test hal::mdio::tests::anlpar_bit_positions ... ok
[INFO] [stdout] test hal::mdio::tests::anar_full_advertisement ... ok
[INFO] [stdout] test hal::mdio::tests::anlpar_full_capability ... ok
[INFO] [stdout] test hal::mdio::tests::anlpar_pause_capability ... ok
[INFO] [stdout] test driver::interrupt::tests::interrupt_status_from_raw_all_bits ... ok
[INFO] [stdout] test hal::mdio::tests::bmcr_reset_bit ... ok
[INFO] [stdout] test hal::mdio::tests::bmcr_bits_are_distinct ... ok
[INFO] [stdout] test hal::mdio::tests::bmcr_speed_duplex_bits ... ok
[INFO] [stdout] test hal::mdio::tests::bmsr_link_status_bit ... ok
[INFO] [stdout] test driver::config::tests::config_builder_checksum ... ok
[INFO] [stdout] test hal::mdio::tests::clock_divider_boundary_100mhz ... ok
[INFO] [stdout] test hal::mdio::tests::anlpar_selector_field ... ok
[INFO] [stdout] test hal::mdio::tests::bmcr_auto_neg_bits ... ok
[INFO] [stdout] test hal::mdio::tests::bmcr_bit_positions ... ok
[INFO] [stdout] test hal::mdio::tests::bmsr_bit_positions ... ok
[INFO] [stdout] test hal::mdio::tests::bmsr_auto_neg_complete_bit ... ok
[INFO] [stdout] test hal::mdio::tests::clock_divider_boundary_150mhz ... ok
[INFO] [stdout] test hal::mdio::tests::clock_divider_boundary_250mhz ... ok
[INFO] [stdout] test hal::mdio::tests::clock_divider_boundary_60mhz ... ok
[INFO] [stdout] test hal::mdio::tests::clock_divider_default ... ok
[INFO] [stdout] test hal::mdio::tests::clock_divider_from_sys_clock ... ok
[INFO] [stdout] test hal::mdio::tests::clock_divider_to_reg_value ... ok
[INFO] [stdout] test hal::mdio::tests::max_reg_addr_is_5_bits ... ok
[INFO] [stdout] test hal::mdio::tests::mdio_timeout_is_reasonable ... ok
[INFO] [stdout] test hal::mdio::tests::phy_reg_all_valid ... ok
[INFO] [stdout] test driver::config::tests::config_builder_rmii_clock ... ok
[INFO] [stdout] test hal::mdio::tests::clock_divider_boundary_35mhz ... ok
[INFO] [stdout] test hal::mdio::tests::max_phy_addr_is_5_bits ... ok
[INFO] [stdout] test hal::mdio::tests::phy_reg_extended_addresses ... ok
[INFO] [stdout] test hal::mdio::tests::phy_status_100_half ... ok
[INFO] [stdout] test hal::mdio::tests::phy_reg_standard_addresses ... ok
[INFO] [stdout] test internal::constants::tests::default_buffer_size_exceeds_max_frame ... ok
[INFO] [stdout] test hal::mdio::tests::phy_status_10_full ... ok
[INFO] [stdout] test internal::constants::tests::default_mac_is_locally_administered ... ok
[INFO] [stdout] test hal::mdio::tests::phy_status_clone ... ok
[INFO] [stdout] test internal::constants::tests::eth_header_size_is_14_bytes ... ok
[INFO] [stdout] test hal::mdio::tests::phy_status_default ... ok
[INFO] [stdout] test internal::constants::tests::crc_size_is_4_bytes ... ok
[INFO] [stdout] test internal::constants::tests::csr_clock_dividers_fit_in_3_bits ... ok
[INFO] [stdout] test internal::constants::tests::default_mac_has_correct_length ... ok
[INFO] [stdout] test internal::constants::tests::dma_state_masks_are_3_bits ... ok
[INFO] [stdout] test hal::mdio::tests::phy_status_all_true ... ok
[INFO] [stdout] test hal::mdio::tests::phy_status_10_half ... ok
[INFO] [stdout] test hal::mdio::tests::phy_status_partial ... ok
[INFO] [stdout] test internal::constants::tests::csr_clock_dividers_are_sequential ... ok
[INFO] [stdout] test internal::constants::tests::dma_state_fields_dont_overlap ... ok
[INFO] [stdout] test internal::constants::tests::default_mac_is_unicast ... ok
[INFO] [stdout] test internal::constants::tests::flow_control_water_marks_fit_buffers ... ok
[INFO] [stdout] test internal::constants::tests::flow_control_water_marks_ordered ... ok
[INFO] [stdout] test internal::constants::tests::mac_addr_len_is_6 ... ok
[INFO] [stdout] test internal::constants::tests::default_buffer_counts_are_reasonable ... ok
[INFO] [stdout] test internal::constants::tests::mii_10m_equals_mdc_max ... ok
[INFO] [stdout] test internal::constants::tests::mii_busy_timeout_is_positive ... ok
[INFO] [stdout] test internal::constants::tests::mtu_is_standard_ethernet ... ok
[INFO] [stdout] test internal::constants::tests::pause_time_max_is_16_bits ... ok
[INFO] [stdout] test internal::constants::tests::rmii_clock_is_50mhz ... ok
[INFO] [stdout] test internal::constants::tests::mdc_max_freq_per_ieee_802_3 ... ok
[INFO] [stdout] test internal::constants::tests::soft_reset_timeout_is_reasonable ... ok
[INFO] [stdout] test internal::constants::tests::mii_100m_clock_is_25mhz ... ok
[INFO] [stdout] test internal::constants::tests::tx_dma_state_shift_position ... ok
[INFO] [stdout] test internal::dma::descriptor::rx::tests::rx_descriptor_clear_owned ... ok
[INFO] [stdout] test internal::constants::tests::max_frame_size_includes_all_headers ... ok
[INFO] [stdout] test internal::constants::tests::mii_10m_clock_is_2_5mhz ... ok
[INFO] [stdout] test internal::constants::tests::min_frame_size_is_60_bytes ... ok
[INFO] [stdout] test internal::dma::descriptor::rx::tests::rx_descriptor_alignment ... ok
[INFO] [stdout] test internal::dma::descriptor::rx::tests::rx_descriptor_buffer_size ... ok
[INFO] [stdout] test internal::dma::descriptor::rx::tests::rx_descriptor_const_size ... ok
[INFO] [stdout] test internal::dma::descriptor::rx::tests::rx_descriptor_error_detection ... ok
[INFO] [stdout] test internal::constants::tests::rx_dma_state_shift_position ... ok
[INFO] [stdout] test internal::constants::tests::max_frame_size_is_1522 ... ok
[INFO] [stdout] test internal::dma::descriptor::rx::tests::rx_descriptor_frame_length_with_other_bits ... ok
[INFO] [stdout] test internal::dma::descriptor::rx::tests::rx_descriptor_first_last_flags ... ok
[INFO] [stdout] test internal::dma::descriptor::rx::tests::rx_descriptor_new_not_owned ... ok
[INFO] [stdout] test internal::dma::descriptor::rx::tests::rx_descriptor_own_bit_position ... ok
[INFO] [stdout] test internal::dma::descriptor::rx::tests::rx_descriptor_set_owned ... ok
[INFO] [stdout] test internal::dma::descriptor::rx::tests::rx_descriptor_recycle ... ok
[INFO] [stdout] test internal::dma::descriptor::tx::tests::tx_descriptor_checksum_mode_full ... ok
[INFO] [stdout] test internal::dma::descriptor::tx::tests::tx_descriptor_checksum_mode_ip_only ... ok
[INFO] [stdout] test hal::mdio::tests::bmsr_capability_bits ... ok
[INFO] [stdout] test internal::constants::tests::flush_timeout_is_positive ... ok
[INFO] [stdout] test internal::dma::descriptor::tx::tests::tx_descriptor_error_detection ... ok
[INFO] [stdout] test internal::dma::descriptor::tx::tests::tx_descriptor_frame_length ... ok
[INFO] [stdout] test internal::dma::descriptor::tx::tests::tx_descriptor_no_errors_initially ... ok
[INFO] [stdout] test internal::dma::descriptor::tx::tests::tx_descriptor_own_bit_position ... ok
[INFO] [stdout] test internal::dma::descriptor::tx::tests::tx_descriptor_reset ... ok
[INFO] [stdout] test internal::dma::descriptor::tx::tests::tx_descriptor_prepare_and_submit ... ok
[INFO] [stdout] test internal::dma::descriptor::rx::tests::rx_descriptor_size ... ok
[INFO] [stdout] test internal::dma::descriptor::tx::tests::tx_descriptor_alignment ... ok
[INFO] [stdout] test internal::dma::descriptor::tx::tests::tx_descriptor_checksum_mode_disabled ... ok
[INFO] [stdout] test internal::dma::descriptor::tx::tests::tx_descriptor_clear_owned ... ok
[INFO] [stdout] test internal::dma::descriptor::tx::tests::tx_descriptor_const_size ... ok
[INFO] [stdout] test internal::dma::descriptor::tx::tests::tx_descriptor_new_not_owned ... ok
[INFO] [stdout] test internal::dma::descriptor::rx::tests::rx_descriptor_frame_length_extraction ... ok
[INFO] [stdout] test internal::dma::descriptor::tx::tests::tx_descriptor_prepare_complete_frame ... ok
[INFO] [stdout] test internal::dma::descriptor::tx::tests::tx_descriptor_set_owned ... ok
[INFO] [stdout] test internal::dma::descriptor::tx::tests::tx_descriptor_prepare_last_segment ... ok
[INFO] [stdout] test internal::dma::descriptor::tx::tests::tx_descriptor_size ... ok
[INFO] [stdout] test internal::dma::engine::tests::dma_engine_buffer_access ... ok
[INFO] [stdout] test internal::dma::engine::tests::dma_engine_default_trait ... ok
[INFO] [stdout] test internal::dma::descriptor::tx::tests::tx_descriptor_prepare_first_segment ... ok
[INFO] [stdout] test internal::dma::engine::tests::dma_engine_memory_usage_scales_with_buffer_size ... ok
[INFO] [stdout] test internal::dma::engine::tests::dma_engine_set_tx_ctrl_flags ... ok
[INFO] [stdout] test internal::dma::engine::tests::dma_engine_initial_indices ... ok
[INFO] [stdout] test internal::dma::engine::tests::simulate_rx_receive_flow ... ok
[INFO] [stdout] test internal::dma::engine::tests::dma_engine_new_is_not_initialized ... ok
[INFO] [stdout] test internal::dma::engine::tests::dma_engine_memory_usage_scales_with_buffers ... ok
[INFO] [stdout] test internal::dma::engine::tests::test_memory_usage ... ok
[INFO] [stdout] test internal::dma::ring::tests::descriptor_ring_advance_by ... ok
[INFO] [stdout] test internal::dma::engine::tests::dma_engine_buffer_sizes ... ok
[INFO] [stdout] test internal::dma::ring::tests::descriptor_ring_advance_by_wraparound ... ok
[INFO] [stdout] test internal::dma::engine::tests::dma_engine_tx_ctrl_flags_default ... ok
[INFO] [stdout] test internal::dma::ring::tests::descriptor_ring_at_offset ... ok
[INFO] [stdout] test internal::dma::engine::tests::simulate_rx_error_handling ... ok
[INFO] [stdout] test internal::dma::engine::tests::dma_engine_ring_base_addresses ... ok
[INFO] [stdout] test internal::dma::ring::tests::descriptor_ring_base_addr_u32 ... ok
[INFO] [stdout] test internal::dma::engine::tests::simulate_tx_submission_flow ... ok
[INFO] [stdout] test internal::dma::ring::tests::descriptor_ring_count_owned ... ok
[INFO] [stdout] test internal::dma::ring::tests::descriptor_ring_current_mut_allows_modification ... ok
[INFO] [stdout] test internal::dma::ring::tests::descriptor_ring_base_addr ... ok
[INFO] [stdout] test internal::dma::ring::tests::descriptor_ring_is_empty_false_for_non_zero_size ... ok
[INFO] [stdout] test internal::dma::ring::tests::descriptor_ring_current_returns_reference ... ok
[INFO] [stdout] test internal::dma::ring::tests::descriptor_ring_find_next_available ... ok
[INFO] [stdout] test internal::dma::ring::tests::descriptor_ring_is_empty_true_for_zero_size ... ok
[INFO] [stdout] test internal::dma::ring::tests::descriptor_ring_from_array ... ok
[INFO] [stdout] test internal::dma::ring::tests::descriptor_ring_iter ... ok
[INFO] [stdout] test internal::dma::ring::tests::descriptor_ring_get_by_index ... ok
[INFO] [stdout] test internal::dma::ring::tests::descriptor_ring_iter_mut ... ok
[INFO] [stdout] test internal::dma::engine::tests::simulate_tx_completion_flow ... ok
[INFO] [stdout] test internal::dma::ring::tests::descriptor_ring_len ... ok
[INFO] [stdout] test internal::dma::ring::tests::descriptor_ring_get_wraps_index ... ok
[INFO] [stdout] test internal::dma::ring::tests::descriptor_ring_get_mut_by_index ... ok
[INFO] [stdout] test internal::dma::ring::tests::descriptor_ring_reset ... ok
[INFO] [stdout] test internal::dma::ring::tests::descriptor_ring_wraparound_stress ... ok
[INFO] [stdout] test internal::dma::ring::tests::descriptor_ring_single_element ... ok
[INFO] [stdout] test internal::dma::ring::tests::mock_descriptor_ring_simulate_multi_desc_frame ... ok
[INFO] [stdout] test internal::dma::ring::tests::mock_descriptor_ring_simulate_rx_flow ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_configure_advertisement ... ok
[INFO] [stdout] test internal::dma::ring::tests::mock_rx_back_pressure ... ok
[INFO] [stdout] test internal::dma::ring::tests::mock_descriptor_ring_basic_operations ... ok
[INFO] [stdout] test internal::dma::ring::tests::test_descriptor_ring_advance ... ok
[INFO] [stdout] test internal::register::gpio::tests::test_gpio_in_sel_address ... ok
[INFO] [stdout] test internal::register::gpio::tests::test_signal_indices ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_capabilities_reads_from_bmsr ... ok
[INFO] [stdout] test internal::register::gpio::tests::test_iomux_addresses ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_force_link_100_half ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_interrupt_mask ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_enable_auto_negotiation_restarts_an ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_enable_auto_negotiation_writes_anar ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_is_auto_negotiation_complete_when_done ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_enable_link_interrupt ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_energy_detect_powerdown_disable ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_energy_detect_powerdown_enable ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_force_link_100_full ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_force_link_10_full ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_force_link_10_half ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_force_link_disables_auto_negotiation ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_init_disables_energy_detect_powerdown ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_init_performs_soft_reset ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_init_resets_link_state ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_is_auto_negotiation_complete_when_not_done ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_is_energy_on ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_link_partner_abilities_after_an ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_link_status_returns_speed_duplex_when_up ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_operations_use_correct_address ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_is_link_up_when_link_up ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_link_status_returns_none_when_down ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_phy_id_check ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_poll_link_returns_none_when_link_stays_down ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_phy_id_reads_both_registers ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_poll_link_returns_none_when_link_stays_up ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_poll_link_detects_link_flap ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_init_enables_auto_negotiation ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_is_link_up_when_link_down ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_poll_link_returns_status_on_link_up_transition ... ok
[INFO] [stdout] test internal::register::gpio::tests::test_gpio_out_sel_address ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_poll_link_tracks_link_down_transition ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_phy_address ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_read_speed_indication_100fd ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_read_speed_indication_100hd ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_read_speed_indication_10hd ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_read_speed_indication_when_an_not_done ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_revision_extracts_low_bits ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_verify_id_returns_false_for_other_phy ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_verify_id_returns_true_for_lan8720a ... ok
[INFO] [stdout] test testing::tests::mock_delay_tracking ... ok
[INFO] [stdout] test testing::tests::mock_mdio_multiple_phys ... ok
[INFO] [stdout] test testing::tests::mock_mdio_read_write ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_read_speed_indication_10fd ... ok
[INFO] [stderr]    Doc-tests ph_esp32_mac
[INFO] [stdout] test phy::lan8720a::tests::test_soft_reset_writes_reset_bit ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_soft_reset_waits_for_reset_clear ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_speed_indication ... ok
[INFO] [stdout] test phy::lan8720a::tests::test_symbol_error_count ... ok
[INFO] [stdout] test testing::tests::mock_mdio_lan8720a_setup ... ok
[INFO] [stdout] test testing::tests::mock_mdio_link_simulation ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 269 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 21 tests
[INFO] [stdout] test src/driver/emac.rs - driver::emac::Emac (line 73) ... ignored
[INFO] [stdout] test src/driver/error.rs - driver::error::Error (line 151) ... ignored
[INFO] [stdout] test src/driver/filtering.rs - driver::filtering::Emac<RX_BUFS,TX_BUFS,BUF_SIZE>::add_hash_filter (line 163) ... ignored
[INFO] [stdout] test src/driver/filtering.rs - driver::filtering::Emac<RX_BUFS,TX_BUFS,BUF_SIZE>::add_mac_filter (line 57) ... ignored
[INFO] [stdout] test src/driver/filtering.rs - driver::filtering::Emac<RX_BUFS,TX_BUFS,BUF_SIZE>::set_vlan_filter (line 275) ... ignored
[INFO] [stdout] test src/driver/flow.rs - driver::flow (line 17) ... ignored
[INFO] [stdout] test src/driver/flow.rs - driver::flow::Emac<RX_BUFS,TX_BUFS,BUF_SIZE>::check_flow_control (line 108) ... ignored
[INFO] [stdout] test src/driver/flow.rs - driver::flow::Emac<RX_BUFS,TX_BUFS,BUF_SIZE>::set_peer_pause_ability (line 86) ... ignored
[INFO] [stdout] test src/driver/interrupt.rs - driver::interrupt::InterruptStatus (line 22) ... ignored
[INFO] [stdout] test src/driver/mod.rs - driver (line 17) ... ignored
[INFO] [stdout] test src/hal/mod.rs - hal (line 14) ... ignored
[INFO] [stdout] test src/internal/register/mod.rs - internal::register::reg_bit_ops (line 175) ... ignored
[INFO] [stdout] test src/internal/register/mod.rs - internal::register::reg_rw (line 136) ... ignored
[INFO] [stdout] test src/lib.rs - (line 20) ... ignored
[INFO] [stdout] test src/lib.rs - (line 41) ... ignored
[INFO] [stdout] test src/phy/generic.rs - phy::generic::PhyDriver (line 110) ... ignored
[INFO] [stdout] test src/phy/lan8720a.rs - phy::lan8720a (line 34) ... ignored
[INFO] [stdout] test src/phy/lan8720a.rs - phy::lan8720a (line 63) ... ignored
[INFO] [stdout] test src/phy/lan8720a.rs - phy::lan8720a::Lan8720aWithReset (line 495) ... ignored
[INFO] [stdout] test src/phy/mod.rs - phy (line 21) ... ignored
[INFO] [stdout] test src/phy/mod.rs - phy (line 38) ... ignored
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 21 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.46s; merged doctests compilation took 0.43s
[INFO] running `Command { std: "docker" "inspect" "3e8ef5c58f7124e2e68d5481ef9963f732abb48a2e67088a3c258070a1f93854", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3e8ef5c58f7124e2e68d5481ef9963f732abb48a2e67088a3c258070a1f93854", kill_on_drop: false }`
[INFO] [stdout] 3e8ef5c58f7124e2e68d5481ef9963f732abb48a2e67088a3c258070a1f93854