01M21Y4AP0ZXKFH1KM433XP6MR: test-gimlet

BasicConfig {
    output_rules: [],
    rust_toolchain: Some(
        Bool(
            false,
        ),
    ),
    target: Some(
        "lab-2.0-gimlet",
    ),
    access_repos: [],
    publish: [],
    skip_clone: true,
}

Buildomat Job: 01M21Y4Y7MGQFB6WM0G25N4RA5

Tags:

Output:

SEQ GLOBAL TIME DETAILS
12026-09-09T02:08:54.691Zjob dependencies complete; ready to run (waiting for 11 m 22 s)
22026-09-09T02:34:56.778Zjob assigned to worker 01M2203CDRHEQJJRQT9KBD5KRV [factory edgar, gimlet/BRM42220010/1529] (queued for 26 m 2 s)
32026-09-09T02:34:57.342Zdownloading input: /input/phd-build/out/phd-run-with-args.sh
42026-09-09T02:34:57.366Zdownloaded input: /input/phd-build/out/phd-run-with-args.sh
52026-09-09T02:34:57.367Zdownloading input: /input/phd-build/out/phd-runner.sha256.txt
62026-09-09T02:34:57.407Zdownloaded input: /input/phd-build/out/phd-runner.sha256.txt
72026-09-09T02:34:57.407Zdownloading input: /input/phd-build/out/phd-runner.tar.gz
82026-09-09T02:35:05.955Zdownloaded input: /input/phd-build/out/phd-runner.tar.gz
92026-09-09T02:35:05.955Zdownloading input: /input/phd-build/out/propolis-server-debug.sha256.txt
102026-09-09T02:35:06.005Zdownloaded input: /input/phd-build/out/propolis-server-debug.sha256.txt
112026-09-09T02:35:06.005Zdownloading input: /input/phd-build/out/propolis-server-debug.tar.gz
122026-09-09T02:35:17.842Zdownloaded input: /input/phd-build/out/propolis-server-debug.tar.gz
132026-09-09T02:35:17.842Zdownloading input: /input/phd-build/out/propolis-tests-debug.tar.gz
142026-09-09T02:35:27.599Zdownloaded input: /input/phd-build/out/propolis-tests-debug.tar.gz
 
152026-09-09T02:35:27.599Zstarting task 0: "setup"
162026-09-09T02:35:27.624Z++ uname -s
172026-09-09T02:35:27.624Z+ kern=SunOS
182026-09-09T02:35:27.624Z+ build_user=build
192026-09-09T02:35:27.624Z+ build_uid=12345
202026-09-09T02:35:27.624Z+ work_dir=/work
212026-09-09T02:35:27.624Z+ input_dir=/input
222026-09-09T02:35:27.624Z+ [[ 0 == 12345 ]]
232026-09-09T02:35:27.624Z+ case "$kern" in
242026-09-09T02:35:27.624Z+ groupadd -g 12345 build
252026-09-09T02:35:27.648Z+ useradd -u 12345 -g build -d /home/build -s /bin/bash -c build -P 'Primary Administrator' build
262026-09-09T02:35:29.636Z+ zfs create -o mountpoint=/work rpool/work
272026-09-09T02:35:29.817Z++ awk '$2 == "/home" { print $3 }' /etc/mnttab
282026-09-09T02:35:29.841Z+ home_fs=
292026-09-09T02:35:29.842Z+ [[ '' == autofs ]]
302026-09-09T02:35:29.842Z+ mkdir -p /home/build
312026-09-09T02:35:29.842Z+ chown build:build /home/build /work
322026-09-09T02:35:31.832Z+ chmod 0700 /home/build /work
332026-09-09T02:35:31.856Zprocess exited: duration 4237 ms, exit code 0
 
342026-09-09T02:35:31.905Zstarting task 1: "authentication"
352026-09-09T02:35:31.971Zprocess exited: duration 66 ms, exit code 0
 
362026-09-09T02:35:32.020Zstarting task 2: "build"
372026-09-09T02:35:32.045Z+ banner prepare
382026-09-09T02:35:32.045Z
392026-09-09T02:35:32.045Z ##### ##### ###### ##### ## ##### ######
402026-09-09T02:35:32.045Z # # # # # # # # # # # #
412026-09-09T02:35:32.045Z # # # # ##### # # # # # # #####
422026-09-09T02:35:32.045Z ##### ##### # ##### ###### ##### #
432026-09-09T02:35:32.045Z # # # # # # # # # #
442026-09-09T02:35:32.046Z # # # ###### # # # # # ######
452026-09-09T02:35:32.046Z
462026-09-09T02:35:32.046Z+ TEST_TAR=propolis-tests-debug.tar.gz
472026-09-09T02:35:32.046Z+ cp /input/phd-build/out/propolis-tests-debug.tar.gz .
482026-09-09T02:35:32.238Z+ tar xvf propolis-tests-debug.tar.gz
492026-09-09T02:35:46.377ZDecompressing 'propolis-tests-debug.tar.gz' with '/usr/bin/gzcat'...
502026-09-09T02:35:46.377Zx target/debug/deps/propolis-2a163edea74e5646, 902210880 bytes, 1762131 tape blocks
512026-09-09T02:35:46.401Z+ banner test-propolis
522026-09-09T02:35:46.401Z
532026-09-09T02:35:46.401Z ##### ###### #### ##### ##### ##### #### ##### ####
542026-09-09T02:35:46.401Z # # # # # # # # # # # # # #
552026-09-09T02:35:46.401Z # ##### #### # ##### # # # # # # # # # #
562026-09-09T02:35:46.401Z # # # # ##### ##### # # ##### # #
572026-09-09T02:35:46.401Z # # # # # # # # # # # # #
582026-09-09T02:35:46.401Z # ###### #### # # # # #### # ####
592026-09-09T02:35:46.401Z
602026-09-09T02:35:46.401Z+ TEST_DEV=prop_viona_test0
612026-09-09T02:35:46.402Z+ pfexec dladm create-etherstub prop_viona_test0
622026-09-09T02:35:46.402Z+ for testbin in ./target/debug/deps/propolis-*
632026-09-09T02:35:46.402Z+ VIONA_TEST_NIC=prop_viona_test0
642026-09-09T02:35:46.402Z+ pfexec ptime -m ./target/debug/deps/propolis-2a163edea74e5646
652026-09-09T02:35:46.426Z
662026-09-09T02:35:46.426Zrunning 213 tests
672026-09-09T02:35:46.472Ztest accessors::test::simple_orphan ... ok
682026-09-09T02:35:46.472Ztest accessors::test::tree_root ... ok
692026-09-09T02:35:46.472Ztest accessors::test::only_root_can_remove_resource - should panic ... ok
702026-09-09T02:35:46.472Ztest accessors::test::adopt_self - should panic ... ok
712026-09-09T02:35:46.472Ztest accessors::test::orphan_sibling ... ok
722026-09-09T02:35:46.472Ztest accessors::test::adopt_nonroot - should panic ... ok
732026-09-09T02:35:46.472Ztest accessors::test::print_names ... ok
742026-09-09T02:35:46.472Ztest block::crucible::test::block_calc_ok ... ok
752026-09-09T02:35:46.472Ztest accessors::test::orphan_split ... ok
762026-09-09T02:35:46.472Ztest accessors::test::simple_depth ... ok
772026-09-09T02:35:46.472Ztest block::crucible::test::err_on_bad_offset ... ok
782026-09-09T02:35:46.472Ztest block::crucible::test::err_on_bad_size ... ok
792026-09-09T02:35:46.472Ztest block::crucible::test::ok_for_valid ... ok
802026-09-09T02:35:46.472Ztest chardev::pollers::test_copy_and_consume_1 ... ok
812026-09-09T02:35:46.472Ztest chardev::pollers::test_copy_and_consume_one_u8 ... ok
822026-09-09T02:35:46.472Ztest common::test::readop_base_size ... ok
832026-09-09T02:35:46.472Ztest common::device_metadata_test::device_metadata_test ... ok
842026-09-09T02:35:46.472Ztest common::test::readop_short ... ok
852026-09-09T02:35:46.472Ztest common::test::readop_oversize - should panic ... ok
862026-09-09T02:35:46.472Ztest common::test::writeop_base_size ... ok
872026-09-09T02:35:46.472Ztest common::test::writeop_short ... ok
882026-09-09T02:35:46.472Ztest common::test::writeop_oversize - should panic ... ok
892026-09-09T02:35:46.472Ztest chardev::pollers::test::write_bytes_beyond_internal_buffer_size ... ok
902026-09-09T02:35:46.472Ztest firmware::acpi::dsdt::test::dsdt_generator_aml ... ok
912026-09-09T02:35:46.472Ztest firmware::acpi::dsdt::test::field_references ... ok
922026-09-09T02:35:46.472Ztest firmware::acpi::dsdt::test::panic_if_generator_not_called - should panic ... ok
932026-09-09T02:35:46.472Ztest chardev::pollers::test::read_byte ... ok
942026-09-09T02:35:46.472Ztest chardev::pollers::test::read_bytes ... ok
952026-09-09T02:35:46.472Ztest chardev::pollers::test::write_bytes ... ok
962026-09-09T02:35:46.472Ztest firmware::acpi::rsdp::test::field_references ... ok
972026-09-09T02:35:46.472Ztest chardev::pollers::test::write_empty_fills_zero_bytes ... ok
982026-09-09T02:35:46.473Ztest chardev::pollers::test::read_empty_returns_zero_bytes ... ok
992026-09-09T02:35:46.473Ztest chardev::pollers::test::write_byte ... ok
1002026-09-09T02:35:46.473Ztest enlightenment::hyperv::overlay::test::out_of_bounds_pfn ... ok
1012026-09-09T02:35:46.473Ztest firmware::acpi::ssdt_edk2::test::field_references ... ok
1022026-09-09T02:35:46.473Ztest firmware::smbios::bits::test::baseboard_information ... ok
1032026-09-09T02:35:46.473Ztest enlightenment::hyperv::overlay::test::remove_nonexistent_overlay ... ok
1042026-09-09T02:35:46.473Ztest enlightenment::hyperv::overlay::test::duplicate_kind_at_pfn ... ok
1052026-09-09T02:35:46.473Ztest enlightenment::hyperv::overlay::test::basic_add ... ok
1062026-09-09T02:35:46.473Ztest enlightenment::hyperv::overlay::test::underlay_restored_after_drop ... ok
1072026-09-09T02:35:46.473Ztest enlightenment::hyperv::overlay::test::multiple_overlays ... ok
1082026-09-09T02:35:46.473Ztest firmware::acpi::dsdt::test::dsdt_valid_aml ... ok
1092026-09-09T02:35:46.473Ztest firmware::smbios::bits::test::entry_point ... ok
1102026-09-09T02:35:46.473Ztest firmware::smbios::bits::test::bios_information ... ok
1112026-09-09T02:35:46.473Ztest firmware::smbios::bits::test::memory_device ... ok
1122026-09-09T02:35:46.473Ztest firmware::acpi::fadt::test::field_references ... ok
1132026-09-09T02:35:46.473Ztest enlightenment::hyperv::overlay::test::basic_move ... ok
1142026-09-09T02:35:46.473Ztest firmware::smbios::bits::test::physical_memory_array ... ok
1152026-09-09T02:35:46.473Ztest firmware::smbios::bits::test::processor_information ... ok
1162026-09-09T02:35:46.473Ztest firmware::smbios::bits::test::struct_header ... ok
1172026-09-09T02:35:46.473Ztest firmware::smbios::bits::test::system_boot_information ... ok
1182026-09-09T02:35:46.473Ztest firmware::smbios::bits::test::system_enclosure ... ok
1192026-09-09T02:35:46.473Ztest firmware::smbios::bits::test::system_information ... ok
1202026-09-09T02:35:46.473Ztest firmware::smbios::table::type16::test::array_use_serde_roundtrip ... ok
1212026-09-09T02:35:46.473Ztest firmware::smbios::table::type16::test::error_correction_serde_roundtrip ... ok
1222026-09-09T02:35:46.473Ztest firmware::smbios::table::type16::test::array_use_deserialize ... ok
1232026-09-09T02:35:46.473Ztest firmware::smbios::table::type16::test::error_correction_deserialize ... ok
1242026-09-09T02:35:46.473Ztest firmware::smbios::table::type16::test::location_serde_roundtrip ... ok
1252026-09-09T02:35:46.473Ztest firmware::smbios::table::type1::test::wake_up_type_serde_roundtrip ... ok
1262026-09-09T02:35:46.473Ztest chardev::sock::test::abort_wait_for_connect ... ok
1272026-09-09T02:35:46.473Ztest firmware::smbios::table::type4::test::proc_status_serde_roundtrip ... ok
1282026-09-09T02:35:46.473Ztest firmware::smbios::table::type4::test::proc_type_serde_roundtrip ... ok
1292026-09-09T02:35:46.473Ztest firmware::smbios::table::type1::test::wake_up_type_deserialize ... ok
1302026-09-09T02:35:46.473Ztest firmware::smbios::table::type16::test::location_deserialize ... ok
1312026-09-09T02:35:46.473Ztest firmware::smbios::table::type4::test::proc_type_deserialize ... ok
1322026-09-09T02:35:46.473Ztest firmware::smbios::table::type4::test::proc_status_deserialize ... ok
1332026-09-09T02:35:46.473Ztest chardev::sock::test::bail_on_shutdown_sock ... ok
1342026-09-09T02:35:46.474Ztest hw::nvme::bits::test::entry_sizing ... ok
1352026-09-09T02:35:46.474Ztest hw::chipset::i440fx::test::hb_pci_cfg_write ... ok
1362026-09-09T02:35:46.474Ztest hw::chipset::i440fx::test::hb_pci_cfg_read ... ok
1372026-09-09T02:35:46.474Ztest hw::chipset::i440fx::test::lpc_pci_cfg_write ... ok
1382026-09-09T02:35:46.474Ztest hw::chipset::i440fx::test::lpc_pci_cfg_read ... ok
1392026-09-09T02:35:46.474Ztest hw::nvme::cmds::test::test_dsmgmt_ranges ... ok
1402026-09-09T02:35:46.474Ztest hw::nvme::cmds::test::test_dsmgmt_ranges_bad_address ... ok
1412026-09-09T02:35:46.474Ztest hw::chipset::i440fx::test::pm_pci_cfg_write ... ok
1422026-09-09T02:35:46.474Ztest hw::chipset::i440fx::test::pm_pci_cfg_read ... ok
1432026-09-09T02:35:46.474Ztest hw::nvme::cmds::test::test_prp_dual ... ok
1442026-09-09T02:35:46.474Ztest hw::pci::bar::test::write_place ... ok
1452026-09-09T02:35:46.474Ztest hw::pci::bar::test::init ... ok
1462026-09-09T02:35:46.474Ztest hw::nvme::cmds::test::test_prp_list_offset_last ... ok
1472026-09-09T02:35:46.474Ztest hw::nvme::cmds::test::test_dsmgmt_ranges_dual ... ok
1482026-09-09T02:35:46.474Ztest hw::pci::bar::test::read_type ... ok
1492026-09-09T02:35:46.474Ztest hw::nvme::cmds::test::test_prp_single ... ok
1502026-09-09T02:35:46.474Ztest hw::nvme::cmds::test::test_dsmgmt_ranges_bad_dual ... ok
1512026-09-09T02:35:46.474Ztest hw::nvme::cmds::test::test_prp_multiple ... ok
1522026-09-09T02:35:46.474Ztest hw::pci::bus::test::empty ... ok
1532026-09-09T02:35:46.474Ztest hw::pci::bus::test::set_multifunc ... ok
1542026-09-09T02:35:46.474Ztest hw::pci::device::test::msix_cfg_zero - should panic ... ok
1552026-09-09T02:35:46.474Ztest hw::pci::test::pcie_decoder_access_spans_multiple_devs ... ok
1562026-09-09T02:35:46.474Ztest hw::pci::test::pcie_decoder ... ok
1572026-09-09T02:35:46.474Ztest hw::pci::bar::test::limits ... ok
1582026-09-09T02:35:46.474Ztest hw::pci::device::test::msix_cfg_too_big - should panic ... ok
1592026-09-09T02:35:46.474Ztest hw::pci::topology::test::builder_conflicts ... ok
1602026-09-09T02:35:46.474Ztest hw::pci::test::pcie_decoder_min_buses ... ok
1612026-09-09T02:35:46.474Ztest hw::pci::test::pcie_decoder_multiple_bdfs ... ok
1622026-09-09T02:35:46.474Ztest hw::pci::topology::test::builder_bus_zero_reserved ... ok
1632026-09-09T02:35:46.474Ztest hw::nvme::cmds::test::test_prp_list ... ok
1642026-09-09T02:35:46.474Ztest hw::pci::topology::test::build_with_bridges ... ok
1652026-09-09T02:35:46.474Ztest hw::pci::topology::test::cfg_read ... ok
1662026-09-09T02:35:46.474Ztest hw::qemu::fwcfg::formats::test_e820::entry_size_is_correct ... ok
1672026-09-09T02:35:46.499Ztest hw::qemu::fwcfg::formats::test_bootorder::basic ... ok
1682026-09-09T02:35:46.499Ztest hw::pci::topology::test::build_without_bridges ... ok
1692026-09-09T02:35:46.499Ztest hw::qemu::fwcfg::formats::test_pci_window::basic ... ok
1702026-09-09T02:35:46.499Ztest hw::qemu::fwcfg::formats::test_table_loader::basic ... ok
1712026-09-09T02:35:46.499Ztest hw::uart::uart16550::test::interrupt_codes ... ok
1722026-09-09T02:35:46.499Ztest hw::qemu::ramfb::test::config_reg_size ... ok
1732026-09-09T02:35:46.499Ztest hw::qemu::fwcfg::test::struct_sizing ... ok
1742026-09-09T02:35:46.499Ztest hw::qemu::fwcfg::formats::test_e820::basic ... ok
1752026-09-09T02:35:46.499Ztest hw::qemu::fwcfg::test::pio_read_basic ... ok
1762026-09-09T02:35:46.499Ztest hw::qemu::fwcfg::test::read_version ... ok
1772026-09-09T02:35:46.499Ztest hw::qemu::fwcfg::test::dma_read_missing ... ok
1782026-09-09T02:35:46.499Ztest chardev::pollers::test::read_bytes_blocking ... ok
1792026-09-09T02:35:46.499Ztest hw::pci::topology::test::created_bridges ... ok
1802026-09-09T02:35:46.500Ztest hw::uart::uart16550::test::intr_thre_on_etbei_toggle ... ok
1812026-09-09T02:35:46.500Ztest hw::uart::uart16550::test::reset_state ... ok
1822026-09-09T02:35:46.500Ztest hw::qemu::fwcfg::test::pio_read_missing ... ok
1832026-09-09T02:35:46.500Ztest hw::uart::uart16550::test::safe_read_write_all ... ok
1842026-09-09T02:35:46.500Ztest hw::uart::uart16550::test::intr_dr_on_incoming ... ok
1852026-09-09T02:35:46.500Ztest hw::virtio::pci::test::common_feature_renegotiate_after_reset_flag ... ok
1862026-09-09T02:35:46.500Ztest hw::virtio::pci::test::legacy_feature_rewrite_after_driver_ok_flag ... ok
1872026-09-09T02:35:46.500Ztest hw::virtio::pci::test::common_feature_retry_after_device_error_flag ... ok
1882026-09-09T02:35:46.500Ztest hw::virtio::pci::test::common_feature_rewrite_after_driver_ok_flag ... ok
1892026-09-09T02:35:46.500Ztest hw::uart::uart16550::test::intr_thre_on_outgoing ... ok
1902026-09-09T02:35:46.500Ztest hw::virtio::pci::test::common_feature_rewrite_after_features_ok_flag ... ok
1912026-09-09T02:35:46.500Ztest hw::qemu::fwcfg::test::dma_read_basic ... ok
1922026-09-09T02:35:46.500Ztest hw::qemu::fwcfg::test::state_cleared_on_reset ... ok
1932026-09-09T02:35:46.500Ztest hw::virtio::pci::test::legacy_feature_rewrite_after_features_ok_flag ... ok
1942026-09-09T02:35:46.500Ztest hw::virtio::pci::test::legacy_feature_noop_rewrite_after_driver_ok_flag ... ok
1952026-09-09T02:35:46.500Ztest hw::virtio::pci::test::legacy_feature_rewrite_before_driver_ok_flag ... ok
1962026-09-09T02:35:46.500Ztest hw::virtio::viona::test::test_mac_filters_semantic_results ... ok
1972026-09-09T02:35:46.500Ztest hw::virtio::pci::test::legacy_feature_write_device_error_flag ... ok
1982026-09-09T02:35:46.500Ztest hw::virtio::viona::test::test_mcast_table_actions ... ok
1992026-09-09T02:35:46.500Ztest hw::virtio::testutil::test::multi_queue_smoke ... ok
2002026-09-09T02:35:46.500Ztest hw::virtio::viona::test::test_common_cfg_size_is_right ... ok
2012026-09-09T02:35:46.500Ztest hw::virtio::viona::test::test_mac_addr_carries_no_padding ... ok
2022026-09-09T02:35:46.500Ztest hw::virtio::testutil::test::empty_avail_ring_returns_none ... ok
2032026-09-09T02:35:46.500Ztest hw::virtio::viona::test::test_multicast_mac_addr_admits_group_bit_only ... ok
2042026-09-09T02:35:46.500Ztest hw::pci::bridge::test::bridge_properties ... ok
2052026-09-09T02:35:46.500Ztest hw::virtio::viona::test::test_mac_filters_ioctl_error_overrides_semantic_result ... ok
2062026-09-09T02:35:46.500Ztest hw::virtio::testutil::test::smoke_mixed_chain ... ok
2072026-09-09T02:35:46.500Ztest hw::pci::bridge::test::bridge_routing ... ok
2082026-09-09T02:35:46.500Ztest hw::virtio::viona::test::test_viona_state_v1_export_raises_promisc_for_pre_filter_targets ... ok
2092026-09-09T02:35:46.500Ztest hw::virtio::testutil::test::smoke_chained_descriptors ... ok
2102026-09-09T02:35:46.500Ztest hw::virtio::testutil::test::multiple_chains ... ok
2112026-09-09T02:35:46.500Ztest migrate::test::test_rejects_wrong_version_and_duplicates ... ok
2122026-09-09T02:35:46.500Ztest hw::virtio::testutil::test::queue_writer_reset_cursors ... ok
2132026-09-09T02:35:46.500Ztest hw::virtio::viona::test::test_viona_state_v1_multicast_table_managed_default ... ok
2142026-09-09T02:35:46.500Ztest util::aspace::safe_end_bounds ... ok
2152026-09-09T02:35:46.500Ztest util::aspace::test::create_max ... ok
2162026-09-09T02:35:46.500Ztest hw::virtio::testutil::test::smoke_pop_avail_readable ... ok
2172026-09-09T02:35:46.500Ztest util::aspace::test::inverse_iterator_alloc_ends ... ok
2182026-09-09T02:35:46.501Ztest util::aspace::test::inverse_iterator_alloc_middle ... ok
2192026-09-09T02:35:46.501Ztest migrate::test::test_take_exact_match ... ok
2202026-09-09T02:35:46.501Ztest util::aspace::test::create_normal ... ok
2212026-09-09T02:35:46.501Ztest util::aspace::test::inverse_iterator_full ... ok
2222026-09-09T02:35:46.501Ztest util::aspace::test::inverse_iterator_empty ... ok
2232026-09-09T02:35:46.501Ztest util::aspace::test::create_one_elem ... ok
2242026-09-09T02:35:46.501Ztest util::aspace::test::bounds_accessors ... ok
2252026-09-09T02:35:46.501Ztest migrate::test::test_take_missing_payload ... ok
2262026-09-09T02:35:46.501Ztest hw::virtio::testutil::test::smoke_pop_avail_writable ... ok
2272026-09-09T02:35:46.501Ztest migrate::test::test_take_matching_version_among_offers ... ok
2282026-09-09T02:35:46.501Ztest util::aspace::test::inverse_iterator_sequential_registrations ... ok
2292026-09-09T02:35:46.501Ztest util::aspace::test::region_at_normal ... ok
2302026-09-09T02:35:46.501Ztest util::aspace::test::region_at_outside ... ok
2312026-09-09T02:35:46.501Ztest util::aspace::test::register_invalid ... ok
2322026-09-09T02:35:46.501Ztest util::aspace::test::register_outside ... ok
2332026-09-09T02:35:46.501Ztest util::regmap::test::misaligned ... ok
2342026-09-09T02:35:46.501Ztest util::aspace::test::register_plain ... ok
2352026-09-09T02:35:46.501Ztest vmm::mem::test::mapping_shortens_read_bytes_beyond_end ... ok
2362026-09-09T02:35:46.501Ztest util::regmap::test::simple ... ok
2372026-09-09T02:35:46.501Ztest vmm::mem::test::mapping_denies_read_beyond_end ... ok
2382026-09-09T02:35:46.501Ztest vmm::mem::test::mapping_create_empty ... ok
2392026-09-09T02:35:46.501Ztest util::aspace::test::register_overlaps ... ok
2402026-09-09T02:35:46.501Ztest vmm::mem::test::subregion_protection ... ok
2412026-09-09T02:35:46.501Ztest vmm::mem::test::memory_protections_match_libc ... ok
2422026-09-09T02:35:46.501Ztest vmm::mem::test::mapping_invalid_subregions ... ok
2432026-09-09T02:35:46.501Ztest vmm::time::test::test_calc_boot_hrtime_delta ... ok
2442026-09-09T02:35:46.501Ztest vmm::time::test::test_calc_boot_hrtime ... ok
2452026-09-09T02:35:46.501Ztest vmm::mem::test::mapping_valid_subregions ... ok
2462026-09-09T02:35:46.501Ztest vmm::time::test::test_calc_guest_tsc ... ok
2472026-09-09T02:35:46.501Ztest vmm::mem::test::region_lookup ... ok
2482026-09-09T02:35:46.501Ztest vmm::time::test::test_calc_migrate_delta ... ok
2492026-09-09T02:35:46.501Ztest vmm::time::test::test_calc_guest_uptime ... ok
2502026-09-09T02:35:46.501Ztest vmm::time::test::test_calc_tsc_delta ... ok
2512026-09-09T02:35:46.501Ztest vmm::time::test::test_invalid_hrtime ... ok
2522026-09-09T02:35:46.501Ztest vsock::buffer::test::test_capacity_and_len ... ok
2532026-09-09T02:35:46.501Ztest vmm::mem::test::mapping_shortens_write_bytes_beyond_end ... ok
2542026-09-09T02:35:46.501Ztest vsock::buffer::test::test_push_less_than_capacity ... ok
2552026-09-09T02:35:46.501Ztest vsock::buffer::test::test_partial_write_to ... ok
2562026-09-09T02:35:46.501Ztest vsock::buffer::test::test_push_more_than_capacity ... ok
2572026-09-09T02:35:46.502Ztest vsock::buffer::test::test_wrap_around ... ok
2582026-09-09T02:35:46.502Ztest vsock::buffer::test::test_write_to ... ok
2592026-09-09T02:35:46.502ZSep 09 02:35:46.437Sep 09 02:35:46.437Sep 09 02:35:46.437Sep 09 02:35:46.437Sep 09 02:35:46.437Sep 09 02:35:46.437Sep 09 02:35:46.437 INFO INFOvsock poller configured with vsock poller configured withINFO, , mappingsmappings:: {8000: VsockPortMapping { port: 8000, addr: 127.0.0.1:37345 }}{}INFOINFO vsock poller configured withvsock poller configured withINFO, , , , componentcomponent:: vsock-testvsock-testmappingsmappings:: {4000: VsockPortMapping { port: 4000, addr: 127.0.0.1:63562 }}{3000: VsockPortMapping { port: 3000, addr: 127.0.0.1:37766 }}, ,
2602026-09-09T02:35:46.502Z
2612026-09-09T02:35:46.502Zcomponentcomponent:: vsock-testvsock-test
2622026-09-09T02:35:46.502Z
2632026-09-09T02:35:46.502Z vsock poller configured with, mappingsvsock poller configured with:, mappings{3000: VsockPortMapping { port: 3000, addr: 127.0.0.1:61567 }}:, component{7000: VsockPortMapping { port: 7000, addr: 127.0.0.1:64526 }}: , vsock-testcomponent
2642026-09-09T02:35:46.502Z: vsock-test
2652026-09-09T02:35:46.502ZINFO vsock poller configured with, mappings: {9300: VsockPortMapping { port: 9300, addr: 127.0.0.1:34258 }}, component: vsock-test
2662026-09-09T02:35:46.502ZSep 09 02:35:46.438 INFO vsock poller configured with, mappings: {6000: VsockPortMapping { port: 6000, addr: 127.0.0.1:47640 }}, component: vsock-test
2672026-09-09T02:35:46.527ZSep 09 02:35:46.439 WARN received invalid vsock packet type, packet: VsockPacket { header: VsockPacketHeader { src_cid: U64(50), dst_cid: U64(2), src_port: U32(5555), dst_port: U32(8080), len: U32(0), socket_type: U16(478), op: U16(5), flags: U32(0), buf_alloc: U32(65536), fwd_cnt: U32(0) }, data_len: 0 }, component: vsock-test
2682026-09-09T02:35:46.527ZSep 09 02:35:46.440 INFO vsock poller configured with, mappings: {9400: VsockPortMapping { port: 9400, addr: 127.0.0.1:43112 }}, component: vsock-test
2692026-09-09T02:35:46.527ZSep 09 02:35:46.440 INFO vsock poller configured with, mappings: {9000: VsockPortMapping { port: 9000, addr: 127.0.0.1:65151 }}, component: vsock-test
2702026-09-09T02:35:46.527ZSep 09 02:35:46.440 INFO vsock poller configured with, mappings: {9500: VsockPortMapping { port: 9500, addr: 127.0.0.1:37334 }}, component: vsock-test
2712026-09-09T02:35:46.527Ztest vsock::poller::test::rw_with_invalid_socket_type_receives_rst ... ok
2722026-09-09T02:35:46.527ZSep 09 02:35:46.441 INFO vsock poller configured with, mappings: {5000: VsockPortMapping { port: 5000, addr: 127.0.0.1:56229 }}, component: vsock-test
2732026-09-09T02:35:46.527Ztest vsock::poller::test::request_receives_response ... ok
2742026-09-09T02:35:46.527Ztest vsock::poller::test::request_then_rw_delivers_data ... ok
2752026-09-09T02:35:46.527Ztest vsock::poller::test::end_to_end_guest_to_host_closes_half_open ... ok
2762026-09-09T02:35:46.527Ztest vsock::poller::test::end_to_end_guest_to_host ... ok
2772026-09-09T02:35:46.527ZSep 09 02:35:46.442 INFO vsock poller configured with, mappings: {}, component: vsock-test
2782026-09-09T02:35:46.527Ztest vsock::poller::test::reset_clears_connections ... ok
2792026-09-09T02:35:46.527Ztest vsock::poller::test::halt_from_paused ... ok
2802026-09-09T02:35:46.527Ztest vsock::poller::test::pause_resume_preserves_connections ... ok
2812026-09-09T02:35:46.527Ztest vsock::poller::test::rst_removes_established_connection ... ok
2822026-09-09T02:35:46.527Ztest hw::nvme::queue::test::push_failures ... ok
2832026-09-09T02:35:46.527Ztest vsock::poller::test::credit_update_sent_after_flushing_half_buffer ... ok
2842026-09-09T02:35:46.527Ztest hw::pci::device::test::msix_cfg_sizing ... ok
2852026-09-09T02:35:46.527Ztest hw::nvme::queue::test::create_sqs ... ok
2862026-09-09T02:35:46.527Ztest hw::nvme::queue::test::cq_kicks ... ok
2872026-09-09T02:35:46.527Ztest hw::nvme::queue::test::create_cqs ... ok
2882026-09-09T02:35:46.552Ztest hw::virtio::viona::test::run_viona_tests ... FAILED
2892026-09-09T02:35:46.577Ztest vsock::poller::test::rx_blocked_resumes_when_descriptors_available ... ok
2902026-09-09T02:35:47.290Ztest vsock::poller::test::end_to_end_large_data ... ok
2912026-09-09T02:35:47.346Ztest hw::nvme::queue::test::push_pop ... ok
2922026-09-09T02:35:48.457Ztest vsock::poller::test::host_socket_eof_sends_shutdown ... ok
2932026-09-09T02:35:50.363Ztest hw::pci::propolis_types_pcipath_is_always_valid_bdf ... ok
2942026-09-09T02:35:50.363Z
2952026-09-09T02:35:50.363Zfailures:
2962026-09-09T02:35:50.363Z
2972026-09-09T02:35:50.363Z---- hw::virtio::viona::test::run_viona_tests stdout ----
2982026-09-09T02:35:50.363Zrunning viona test 'test_device_status_writes'
2992026-09-09T02:35:50.364Z
3002026-09-09T02:35:50.364Zthread 'hw::virtio::viona::test::run_viona_tests' (156) panicked at lib/propolis/src/hw/virtio/viona.rs:3583:9:
3012026-09-09T02:35:50.364Zassertion failed: driver.read_status().contains(Status::FEATURES_OK)
3022026-09-09T02:35:50.364Z
3032026-09-09T02:35:50.364Zthread 'hw::virtio::viona::test::run_viona_tests' (156) panicked at lib/propolis/src/hw/virtio/viona.rs:4434:21:
3042026-09-09T02:35:50.364Zviona test 'test_device_status_writes' was unsuccessful
3052026-09-09T02:35:50.364Z
3062026-09-09T02:35:50.364Z
3072026-09-09T02:35:50.364Z
3082026-09-09T02:35:50.364Zfailures:
3092026-09-09T02:35:50.364Z hw::virtio::viona::test::run_viona_tests
3102026-09-09T02:35:50.364Z
3112026-09-09T02:35:50.364Ztest result: FAILED. 212 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 3.95s
3122026-09-09T02:35:50.364Z
3132026-09-09T02:35:50.389Z
3142026-09-09T02:35:50.389Zreal 3.966741497
3152026-09-09T02:35:50.389Zuser 4.842320663
3162026-09-09T02:35:50.389Zsys 0.700675576
3172026-09-09T02:35:50.389Ztrap 0.018527551
3182026-09-09T02:35:50.389Ztflt 0.009611451
3192026-09-09T02:35:50.389Zdflt 0.012642679
3202026-09-09T02:35:50.389Zkflt 0.000050224
3212026-09-09T02:35:50.389Zlock 18.719449387
3222026-09-09T02:35:50.389Zslp 7.809442773
3232026-09-09T02:35:50.389Zlat 0.089253845
3242026-09-09T02:35:50.389Zstop 0.736766352
3252026-09-09T02:35:50.389Zprocess exited: duration 18359 ms, exit code 101
 
3262026-09-09T02:35:50.440Zfound 0 output files