[INFO] cloning repository https://github.com/google/alioth
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/google/alioth" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fgoogle%2Falioth", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fgoogle%2Falioth'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 641b22f8dd37604fc3a4d117a016dc01e135f4ba
[INFO] testing google/alioth against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fgoogle%2Falioth" "/workspace/builds/worker-4-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-4-tc2/source'...
[INFO] [stderr] done.
[INFO] removed /workspace/builds/worker-4-tc2/source/rust-toolchain.toml
[INFO] started tweaking git repo https://github.com/google/alioth
[INFO] finished tweaking git repo https://github.com/google/alioth
[INFO] tweaked toml for git repo https://github.com/google/alioth written to /workspace/builds/worker-4-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/google/alioth on toolchain dec9417b8611e34e787a3e4c37686b5131f9e5c5
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/google/alioth 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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 9758b758dac6de78781127ebf1fbd7770b4a7063355800fc27e8ae92fa290aa5
[INFO] running `Command { std: "docker" "start" "-a" "9758b758dac6de78781127ebf1fbd7770b4a7063355800fc27e8ae92fa290aa5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9758b758dac6de78781127ebf1fbd7770b4a7063355800fc27e8ae92fa290aa5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9758b758dac6de78781127ebf1fbd7770b4a7063355800fc27e8ae92fa290aa5", kill_on_drop: false }`
[INFO] [stdout] 9758b758dac6de78781127ebf1fbd7770b4a7063355800fc27e8ae92fa290aa5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 2f6be19b4b19906a14324cec631e05c6fe427e0ee4f39d7180a73df5383bcd0e
[INFO] running `Command { std: "docker" "start" "-a" "2f6be19b4b19906a14324cec631e05c6fe427e0ee4f39d7180a73df5383bcd0e", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling unicode-ident v1.0.22
[INFO] [stderr]    Compiling quote v1.0.44
[INFO] [stderr]    Compiling libc v0.2.182
[INFO] [stderr]    Compiling autocfg v1.5.0
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling utf8parse v0.2.2
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling memchr v2.7.6
[INFO] [stderr]    Compiling cfg-if v1.0.4
[INFO] [stderr]    Compiling thiserror v2.0.17
[INFO] [stderr]    Compiling io-uring v0.7.11
[INFO] [stderr]    Compiling log v0.4.29
[INFO] [stderr]    Compiling regex-syntax v0.8.8
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling anstyle-parse v0.2.7
[INFO] [stderr]    Compiling anstyle v1.0.13
[INFO] [stderr]    Compiling iana-time-zone v0.1.64
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.2
[INFO] [stderr]    Compiling anstyle-query v1.1.5
[INFO] [stderr]    Compiling zerocopy v0.8.40
[INFO] [stderr]    Compiling colorchoice v1.0.4
[INFO] [stderr]    Compiling lock_api v0.4.14
[INFO] [stderr]    Compiling bitflags v2.11.0
[INFO] [stderr]    Compiling strsim v0.11.1
[INFO] [stderr]    Compiling anstream v0.6.21
[INFO] [stderr]    Compiling clap_lex v1.0.0
[INFO] [stderr]    Compiling simd-adler32 v0.3.8
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling nu-ansi-term v0.50.3
[INFO] [stderr]    Compiling adler2 v2.0.1
[INFO] [stderr]    Compiling aho-corasick v1.1.4
[INFO] [stderr]    Compiling clap_builder v4.5.60
[INFO] [stderr]    Compiling miniz_oxide v0.9.0
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling mio v1.1.1
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling regex-automata v0.4.13
[INFO] [stderr]    Compiling regex v1.12.2
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling serde-aco-derive v0.12.0 (/opt/rustwide/workdir/serde-aco-derive)
[INFO] [stderr]    Compiling thiserror-impl v2.0.17
[INFO] [stderr]    Compiling snafu-derive v0.8.9
[INFO] [stderr]    Compiling zerocopy-derive v0.8.40
[INFO] [stderr]    Compiling bitfield-macros v0.19.4
[INFO] [stderr]    Compiling alioth-macros v0.12.0 (/opt/rustwide/workdir/alioth-macros)
[INFO] [stderr]    Compiling clap_derive v4.5.55
[INFO] [stderr]    Compiling bitfield v0.19.4
[INFO] [stderr]    Compiling flexi_logger v0.31.8
[INFO] [stderr]    Compiling snafu v0.8.9
[INFO] [stderr]    Compiling clap v4.5.60
[INFO] [stderr]    Compiling serde-aco v0.12.0 (/opt/rustwide/workdir/serde-aco)
[INFO] [stderr]    Compiling alioth v0.12.0 (/opt/rustwide/workdir/alioth)
[INFO] [stderr]    Compiling alioth-cli v0.12.0 (/opt/rustwide/workdir/alioth-cli)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 51.16s
[INFO] running `Command { std: "docker" "inspect" "2f6be19b4b19906a14324cec631e05c6fe427e0ee4f39d7180a73df5383bcd0e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2f6be19b4b19906a14324cec631e05c6fe427e0ee4f39d7180a73df5383bcd0e", kill_on_drop: false }`
[INFO] [stdout] 2f6be19b4b19906a14324cec631e05c6fe427e0ee4f39d7180a73df5383bcd0e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 239e210df168746bea4c9fb1b8dd79aeab288d633ea6d69161141f519d6642e4
[INFO] running `Command { std: "docker" "start" "-a" "239e210df168746bea4c9fb1b8dd79aeab288d633ea6d69161141f519d6642e4", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling equivalent v1.0.2
[INFO] [stderr]    Compiling winnow v0.7.14
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling semver v1.0.27
[INFO] [stderr]    Compiling toml_datetime v0.7.5+spec-1.1.0
[INFO] [stderr]    Compiling bitflags v2.11.0
[INFO] [stderr]    Compiling assert_matches v1.5.0
[INFO] [stderr]    Compiling slab v0.4.11
[INFO] [stderr]    Compiling relative-path v1.9.3
[INFO] [stderr]    Compiling dtor-proc-macro v0.0.6
[INFO] [stderr]    Compiling futures-core v0.3.31
[INFO] [stderr]    Compiling rustix v1.1.3
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling glob v0.3.3
[INFO] [stderr]    Compiling ctor-proc-macro v0.0.7
[INFO] [stderr]    Compiling linux-raw-sys v0.11.0
[INFO] [stderr]    Compiling futures-timer v3.0.3
[INFO] [stderr]    Compiling serde_bytes v0.11.19
[INFO] [stderr]    Compiling io-uring v0.7.11
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling dtor v0.1.1
[INFO] [stderr]    Compiling fastrand v2.3.0
[INFO] [stderr]    Compiling rustc_version v0.4.1
[INFO] [stderr]    Compiling diff v0.1.13
[INFO] [stderr]    Compiling yansi v1.0.1
[INFO] [stderr]    Compiling ctor v0.6.3
[INFO] [stderr]    Compiling rstest_macros v0.26.1
[INFO] [stderr]    Compiling indexmap v2.12.1
[INFO] [stderr]    Compiling pretty_assertions v1.4.1
[INFO] [stderr]    Compiling toml_parser v1.0.6+spec-1.1.0
[INFO] [stderr]    Compiling tempfile v3.25.0
[INFO] [stderr]    Compiling toml_edit v0.23.10+spec-1.0.0
[INFO] [stderr]    Compiling proc-macro-crate v3.4.0
[INFO] [stderr]    Compiling serde-aco-derive v0.12.0 (/opt/rustwide/workdir/serde-aco-derive)
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling bitfield-macros v0.19.4
[INFO] [stderr]    Compiling snafu-derive v0.8.9
[INFO] [stderr]    Compiling alioth-macros v0.12.0 (/opt/rustwide/workdir/alioth-macros)
[INFO] [stderr]    Compiling zerocopy-derive v0.8.40
[INFO] [stderr]    Compiling thiserror-impl v2.0.17
[INFO] [stderr]    Compiling clap_derive v4.5.55
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling bitfield v0.19.4
[INFO] [stderr]    Compiling zerocopy v0.8.40
[INFO] [stderr]    Compiling thiserror v2.0.17
[INFO] [stderr]    Compiling flexi_logger v0.31.8
[INFO] [stderr]    Compiling clap v4.5.60
[INFO] [stderr]    Compiling snafu v0.8.9
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling rstest v0.26.1
[INFO] [stderr]    Compiling serde-aco v0.12.0 (/opt/rustwide/workdir/serde-aco)
[INFO] [stderr]    Compiling alioth v0.12.0 (/opt/rustwide/workdir/alioth)
[INFO] [stderr]    Compiling alioth-cli v0.12.0 (/opt/rustwide/workdir/alioth-cli)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 34.56s
[INFO] running `Command { std: "docker" "inspect" "239e210df168746bea4c9fb1b8dd79aeab288d633ea6d69161141f519d6642e4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "239e210df168746bea4c9fb1b8dd79aeab288d633ea6d69161141f519d6642e4", kill_on_drop: false }`
[INFO] [stdout] 239e210df168746bea4c9fb1b8dd79aeab288d633ea6d69161141f519d6642e4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 27647b16ce4d73a4b4acf84b9125812abac54ccf08172271b57a0eaa43232c90
[INFO] running `Command { std: "docker" "start" "-a" "27647b16ce4d73a4b4acf84b9125812abac54ccf08172271b57a0eaa43232c90", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.13s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/alioth-3a49c7ce1a517229)
[INFO] [stdout] 
[INFO] [stdout] running 239 tests
[INFO] [stdout] test blk::qcow2::tests::test_cmpr_desc_offset_size::case_1 ... ok
[INFO] [stdout] test blk::qcow2::tests::test_cmpr_desc_offset_size::case_2 ... ok
[INFO] [stdout] test board::tests::test_cpu_topology_encode_decode::case_1 ... ok
[INFO] [stdout] test blk::qcow2::tests::test_l1entry_l2_offset::case_1 ... ok
[INFO] [stdout] test board::tests::test_cpu_topology_encode_decode::case_2 ... ok
[INFO] [stdout] test blk::qcow2::tests::test_std_desc_cluster_offset::case_1 ... ok
[INFO] [stdout] test board::tests::test_cpu_topology_encode_decode::case_3 ... ok
[INFO] [stdout] test board::tests::test_cpu_topology_encode_decode::case_4 ... ok
[INFO] [stdout] test board::tests::test_cpu_topology_encode_decode::case_5 ... ok
[INFO] [stdout] test board::tests::test_cpu_topology_encode_decode::case_6 ... ok
[INFO] [stdout] test board::tests::test_cpu_topology_encode_decode::case_7 ... ok
[INFO] [stdout] test board::tests::test_cpu_topology_encode_decode::case_8 ... ok
[INFO] [stdout] test board::tests::test_cpu_topology_encode_decode::case_9 ... ok
[INFO] [stdout] test board::tests::test_cpu_topology_fixup ... ok
[INFO] [stdout] test board::x86_64::tests::test_encode_x2apic::case_1 ... ok
[INFO] [stdout] test board::x86_64::tests::test_encode_x2apic::case_2 ... ok
[INFO] [stdout] test board::x86_64::tests::test_encode_x2apic::case_3 ... ok
[INFO] [stdout] test board::x86_64::tests::test_encode_x2apic::case_4 ... ok
[INFO] [stdout] test board::x86_64::tests::test_encode_x2apic::case_5 ... ok
[INFO] [stdout] test board::x86_64::tests::test_encode_x2apic::case_7 ... ok
[INFO] [stdout] test board::x86_64::tests::test_encode_x2apic::case_6 ... ok
[INFO] [stdout] test board::x86_64::tests::test_encode_x2apic::case_8 ... ok
[INFO] [stdout] test board::x86_64::tests::test_encode_x2apic::case_9 ... ok
[INFO] [stdout] test device::clock::tests::test_system_clock ... ok
[INFO] [stdout] test device::cmos::tests::test_cmos_upgrade_in_progress ... ok
[INFO] [stdout] test device::fw_cfg::acpi::tests::test_size ... ok
[INFO] [stdout] test device::cmos::tests::test_cmos ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_access::case_03 ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_access::case_04 ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_access::case_05 ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_access::case_07 ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_access::case_02 ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_access::case_08 ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_access::case_09 ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_access::case_06 ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_access::case_01 ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_read::case_2 ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_read::case_4 ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_read::case_5 ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_access::case_10 ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_size::case_1 ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_read::case_1 ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_size::case_2 ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_read::case_6 ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_size::case_3 ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_size::case_5 ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_read::case_3 ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_size::case_6 ... ok
[INFO] [stderr] WARN [alioth::device::pl031] pl031@2fffe000: write 0x21 to unknown offset 0x0
[INFO] [stderr] WARN [alioth::device::pl031] pl031@2fffe000: guest tries to unmask interrupt
[INFO] [stderr] WARN [alioth::device::pl031] pl031@2fffe000: read from unknown offset 0x1c
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_size::case_4 ... ok
[INFO] [stderr] ERROR [alioth::device::pl011] pl011@0x2ffff000: UART_FR is read only
[INFO] [stderr] ERROR [alioth::device::serial] serial_0x3f8: read unreachable offset 0x100
[INFO] [stderr] ERROR [alioth::device::serial] serial_0x3f8: write unreachable offset 0x100
[INFO] [stdout] test device::net::tests::test_mac_addr_visitor ... ok
[INFO] [stdout] test device::ioapic::tests::test_ioapic_read_write ... ok
[INFO] [stdout] test device::ioapic::tests::test_ioapic_service_pin ... ok
[INFO] [stderr] ERROR [alioth::device::fw_cfg] fw_cfg: reading File { fd: 27, path: "/tmp/.tmpXuZaZD/test_file (deleted)", read: true, write: false }: Error { kind: UnexpectedEof, message: "failed to fill whole buffer" }
[INFO] [stdout] test device::pl031::tests::test_pl031 ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_file_access ... ok
[INFO] [stdout] test device::pl011::tests::test_pl011_basic ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_file_size ... ok
[INFO] [stdout] test device::serial::tests::test_serial_loopback ... ok
[INFO] [stdout] test device::fw_cfg::tests::test_fw_cfg_content_file_read ... ok
[INFO] [stdout] test firmware::acpi::reg::tests::test_pm_timer ... ok
[INFO] [stdout] test device::serial::tests::test_serial_pause_resume ... ok
[INFO] [stdout] test device::pl011::tests::test_pl011_tx ... ok
[INFO] [stdout] test firmware::dt::dtb::tests::test_prop_val_write_as_blob::case_01 ... ok
[INFO] [stdout] test firmware::dt::dtb::tests::test_prop_val_write_as_blob::case_02 ... ok
[INFO] [stdout] test firmware::dt::dtb::tests::test_prop_val_write_as_blob::case_03 ... ok
[INFO] [stdout] test firmware::dt::dtb::tests::test_prop_val_write_as_blob::case_04 ... ok
[INFO] [stdout] test firmware::acpi::bindings::tests::test_size ... ok
[INFO] [stdout] test device::serial::tests::test_serial_basic ... ok
[INFO] [stdout] test firmware::dt::dtb::tests::test_prop_val_write_as_blob::case_06 ... ok
[INFO] [stdout] test firmware::dt::dtb::tests::test_prop_val_write_as_blob::case_07 ... ok
[INFO] [stdout] test firmware::dt::dtb::tests::test_prop_val_write_as_blob::case_09 ... ok
[INFO] [stdout] test firmware::dt::dtb::tests::test_prop_val_write_as_blob::case_08 ... ok
[INFO] [stdout] test device::pl011::tests::test_pl011_rx_interrupt_enabled ... ok
[INFO] [stdout] test firmware::dt::tests::test_val_size ... ok
[INFO] [stdout] test device::serial::tests::test_serial_tx ... ok
[INFO] [stdout] test firmware::dt::dtb::tests::test_prop_val_write_as_blob::case_05 ... ok
[INFO] [stdout] test firmware::dt::dtb::tests::test_prop_val_write_as_blob::case_10 ... ok
[INFO] [stdout] test hv::kvm::vcpu::x86_64::tests::test_kvm_run ... ignored
[INFO] [stdout] test hv::kvm::vcpu::x86_64::tests::test_vcpu_regs ... ignored
[INFO] [stdout] test hv::kvm::vm::tests::test_mem_map ... ignored
[INFO] [stdout] test firmware::ovmf::x86_64::tdx::tests::test_create_hob ... ok
[INFO] [stdout] test hv::kvm::vm::x86_64::test::test_determine_vm_type::case_2 ... ok
[INFO] [stdout] test hv::kvm::vm::x86_64::test::test_determine_vm_type::case_1 ... ok
[INFO] [stdout] test firmware::dt::dtb::tests::test_string_block ... ok
[INFO] [stdout] test hv::kvm::vm::x86_64::test::test_determine_vm_type::case_3 ... ok
[INFO] [stdout] test hv::kvm::vm::x86_64::test::test_determine_vm_type::case_4 ... ok
[INFO] [stdout] test hv::kvm::vm::x86_64::test::test_translate_msi_addr::case_1 ... ok
[INFO] [stdout] test hv::kvm::vm::x86_64::test::test_translate_msi_addr::case_3 ... ok
[INFO] [stdout] test hv::kvm::x86_64::tests::test_convert_cpuid_entry::case_1 ... ok
[INFO] [stdout] test hv::kvm::x86_64::tests::test_get_supported_cpuid ... ignored
[INFO] [stdout] test hv::kvm::vm::x86_64::test::test_translate_msi_addr::case_4 ... ok
[INFO] [stdout] test hv::kvm::x86_64::tests::test_convert_cpuid_entry::case_2 ... ok
[INFO] [stdout] test hv::kvm::vm::x86_64::test::test_translate_msi_addr::case_2 ... ok
[INFO] [stdout] test loader::elf::tests::test_size ... ok
[INFO] [stdout] test loader::xen::start_info::tests::test_size ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_read::case_03 ... ok
[INFO] [stdout] test mem::addressable::tests::test_addressable ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_read::case_04 ... ok
[INFO] [stdout] test hv::kvm::vm::x86_64::test::test_translate_msi_addr::case_5 ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_read::case_05 ... ok
[INFO] [stdout] test mem::addressable::tests::test_new_slot ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_read::case_08 ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_read::case_09 ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_read::case_01 ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_read::case_10 ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_read::case_07 ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_read::case_11 ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_read::case_02 ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_read::case_06 ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_read::case_14 ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_read::case_12 ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_read::case_15 ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_read::case_13 ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_read::case_17 ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_read::case_16 ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_write::case_01 ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_write::case_03 ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_write::case_04 ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_write::case_02 ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_write::case_05 ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_write::case_07 ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_write::case_08 ... ok
[INFO] [stderr] INFO [alioth::pci::config] 00:00.0: updating bar 0: 0x0000000c -> 0xec00000c, mask=0xfffff000
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_write::case_06 ... ok
[INFO] [stderr] INFO [alioth::pci::config] 00:00.0: bar 0: write 0xec000000, update: 0x0000000c -> 0xec00000c
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_write::case_10 ... ok
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b8a82a000, 1000) = 0, done
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_write::case_09 ... ok
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b8a829000, 1000) = 0, done
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_write::case_11 ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_write::case_13 ... ok
[INFO] [stdout] test mem::emulated::tests::test_mmio_bus_write::case_12 ... ok
[INFO] [stderr] ERROR [alioth::pci::cap] MsiCapMmio: write 0xaabbccdd to invalid offset 0xc.
[INFO] [stdout] test pci::bus::tests::test_host_bridge ... ok
[INFO] [stdout] test pci::bus::tests::test_pci_bus ... ok
[INFO] [stdout] test pci::bus::tests::test_pci_io_bus_unaligned_address_access ... ok
[INFO] [stdout] test pci::bus::tests::test_pci_io_bus_disabled_address ... ok
[INFO] [stdout] test pci::bus::tests::test_pci_io_bus ... ok
[INFO] [stdout] test mem::mapped::tests::test_ram_bus_read ... ok
[INFO] [stdout] test pci::cap::tests::test_msi_cap_mmio_64_pvm ... ok
[INFO] [stdout] test pci::cap::tests::test_msi_cap_mmio_32_pvm ... ok
[INFO] [stdout] test pci::cap::tests::test_msi_msg_ctrl_cap_size::case_3 ... ok
[INFO] [stdout] test pci::cap::tests::test_msi_msg_ctrl_cap_size::case_2 ... ok
[INFO] [stderr] ERROR [alioth::pci::cap] unaligned access to msix table: size = 2, offset = 0x0
[INFO] [stderr] ERROR [alioth::pci::cap] unaligned access to msix table: size = 2, offset = 0x0
[INFO] [stderr] ERROR [alioth::pci::cap] unaligned access to msix table: size = 4, offset = 0xe
[INFO] [stderr] ERROR [alioth::pci::cap] unaligned access to msix table: size = 4, offset = 0x12
[INFO] [stderr] ERROR [alioth::pci::cap] MSI-X table size: 2, accessing index 2
[INFO] [stdout] test pci::cap::tests::test_msi_msg_ctrl_cap_size::case_4 ... ok
[INFO] [stderr] ERROR [alioth::pci::cap] MSI-X table size: 2, accessing index 2
[INFO] [stdout] test pci::cap::tests::test_msi_cap_mmio_32 ... ok
[INFO] [stdout] test pci::cap::tests::test_msix_msg_ctrl::case_1 ... ok
[INFO] [stdout] test pci::cap::tests::test_msix_cap_mmio ... ok
[INFO] [stdout] test pci::cap::tests::test_msix_msg_ctrl::case_2 ... ok
[INFO] [stdout] test pci::cap::tests::test_msi_msg_ctrl_cap_size::case_1 ... ok
[INFO] [stdout] test pci::cap::tests::test_null_cap::case_1 ... ok
[INFO] [stdout] test pci::cap::tests::test_null_cap::case_4 ... ok
[INFO] [stdout] test pci::cap::tests::test_null_cap::case_5 ... ok
[INFO] [stdout] test pci::cap::tests::test_msix_table_mmio ... ok
[INFO] [stdout] test pci::cap::tests::test_null_cap::case_7 ... ok
[INFO] [stdout] test pci::cap::tests::test_null_cap::case_2 ... ok
[INFO] [stdout] test pci::cap::tests::test_null_cap::case_3 ... ok
[INFO] [stdout] test pci::cap::tests::test_pci_cap_list ... ok
[INFO] [stdout] test pci::cap::tests::test_null_cap::case_9 ... ok
[INFO] [stderr] INFO [alioth::pci::config] 00:01.0: updating bar 5: 0x0000e001 -> 0x0000c001, mask=0xfffffffc
[INFO] [stdout] test pci::cap::tests::test_pci_cap_list_default ... ok
[INFO] [stderr] INFO [alioth::pci::config] 00:01.0: bar 5: write 0x0000c000, update: 0x0000e001 -> 0x0000c001
[INFO] [stdout] test pci::cap::tests::test_null_cap::case_6 ... ok
[INFO] [stdout] test pci::config::tests::test_emulated_config ... ok
[INFO] [stderr] INFO [alioth::pci::config] 00:01.0: updating bar 0: 0xe0000000 -> 0xfffff000, mask=0xfffff000
[INFO] [stdout] test pci::config::tests::test_emulated_header_bar_callbacks ... ok
[INFO] [stderr] INFO [alioth::pci::config] 00:01.0: bar 0: write 0xffffffff, update: 0xe0000000 -> 0xfffff000
[INFO] [stderr] INFO [alioth::pci::config] 00:01.0: updating bar 0: 0xe0000000 -> 0xd0000000, mask=0xfffff000
[INFO] [stdout] test pci::cap::tests::test_null_cap::case_8 ... ok
[INFO] [stdout] test pci::config::tests::test_emulated_header_change_command::case_1 ... ok
[INFO] [stderr] INFO [alioth::pci::config] 00:01.0: updating bar 2: 0x00000004 -> 0x80000004, mask=0xc0000000
[INFO] [stdout] test pci::config::tests::test_emulated_header_change_command::case_2 ... ok
[INFO] [stderr] INFO [alioth::pci::config] 00:01.0: updating bar 5: 0x0000e001 -> 0x0000f001, mask=0xfffffffc
[INFO] [stdout] test pci::config::tests::test_emulated_header_change_command::case_3 ... ok
[INFO] [stdout] test pci::config::tests::test_emulated_header_change_command::case_4 ... ok
[INFO] [stdout] test pci::config::tests::test_emulated_header_masks ... ok
[INFO] [stdout] test pci::config::tests::test_emulated_header_write_bar::case_2 ... ok
[INFO] [stderr] INFO [alioth::pci::config] 00:00.0: bar 5: set to 0x0000e000, update: 0x0000e001 -> 0x0000e001
[INFO] [stderr] INFO [alioth::pci::config] 00:00.0: updating bar 5: 0x0000e001 -> 0x0000e101, mask=0xfffffffc
[INFO] [stdout] test pci::config::tests::test_emulated_header_write_bar::case_1 ... ok
[INFO] [stderr] INFO [alioth::pci::config] 00:00.0: bar 5: set to 0x0000e100, update: 0x0000e001 -> 0x0000e101
[INFO] [stdout] test pci::config::tests::test_emulated_header_write_bar::case_4 ... ok
[INFO] [stderr] INFO [alioth::pci::config] 00:00.0: bar 0: set to 0xe0000000, update: 0xe0000000 -> 0xe0000000
[INFO] [stdout] test pci::config::tests::test_emulated_header_write_bar::case_5 ... ok
[INFO] [stderr] INFO [alioth::pci::config] 00:00.0: bar 2: set to 0x00000000, update: 0x00000004 -> 0x00000004
[INFO] [stdout] test pci::config::tests::test_emulated_header_write_bar::case_6 ... ok
[INFO] [stderr] INFO [alioth::pci::config] 00:00.0: bar 3: set to 0x00000001, update: 0x00000001 -> 0x00000001
[INFO] [stdout] test pci::config::tests::test_emulated_header_write_bar::case_3 ... ok
[INFO] [stderr] INFO [alioth::pci::config] 00:00.0: updating bar 0: 0xe0000000 -> 0xe0010000, mask=0xfffff000
[INFO] [stdout] test pci::config::tests::test_emulated_header_write_status::case_2 ... ok
[INFO] [stderr] INFO [alioth::pci::config] 00:00.0: bar 0: set to 0xe0010000, update: 0xe0000000 -> 0xe0010000
[INFO] [stderr] INFO [alioth::pci::config] 00:00.0: updating bar 3: 0x00000001 -> 0x00000002, mask=0xffffffff
[INFO] [stderr] INFO [alioth::pci::config] 00:00.0: bar 2: set to 0x00000000, update: 0x00000004 -> 0x00000004
[INFO] [stderr] INFO [alioth::pci::config] 00:00.0: bar 3: set to 0x00000002, update: 0x00000001 -> 0x00000002
[INFO] [stderr] INFO [alioth::pci::pvpanic] pvpanic: PANICKED
[INFO] [stdout] test pci::config::tests::test_emulated_header_write_status::case_3 ... ok
[INFO] [stderr] INFO [alioth::pci::config] 00:01.0: updating bar 3: 0x00000001 -> 0x00000002, mask=0xffffffff
[INFO] [stdout] test pci::config::tests::test_emulated_header_write_bar::case_8 ... ok
[INFO] [stdout] test pci::config::tests::test_io_bar_layout_change ... ok
[INFO] [stdout] test pci::host_bridge::tests::test_host_bridge ... ok
[INFO] [stdout] test pci::config::tests::test_mem_bar_layout_change ... ok
[INFO] [stdout] test pci::pvpanic::tests::test_pvpanic_bar ... ok
[INFO] [stdout] test pci::config::tests::test_emulated_header_write_status::case_1 ... ok
[INFO] [stdout] test pci::config::tests::test_emulated_header_write_status::case_4 ... ok
[INFO] [stdout] test pci::pvpanic::tests::test_pvpanic_read_config::case_02 ... ok
[INFO] [stderr] INFO [alioth::pci::config] 00:00.0: updating bar 0: 0x0000000c -> 0xee00000c, mask=0xfffff000
[INFO] [stdout] test pci::pvpanic::tests::test_pvpanic_read_config::case_01 ... ok
[INFO] [stderr] INFO [alioth::pci::config] 00:00.0: bar 0: write 0xee000000, update: 0x0000000c -> 0xee00000c
[INFO] [stdout] test pci::pvpanic::tests::test_pvpanic_read_config::case_03 ... ok
[INFO] [stdout] test pci::pvpanic::tests::test_pvpanic_read_config::case_04 ... ok
[INFO] [stdout] test pci::config::tests::test_emulated_header_write_bar::case_7 ... ok
[INFO] [stdout] test pci::pvpanic::tests::test_pvpanic_read_config::case_05 ... ok
[INFO] [stdout] test pci::pvpanic::tests::test_pvpanic_read_config::case_06 ... ok
[INFO] [stdout] test pci::pvpanic::tests::test_pvpanic_read_config::case_07 ... ok
[INFO] [stdout] test pci::pvpanic::tests::test_pvpanic_read_config::case_08 ... ok
[INFO] [stdout] test pci::pvpanic::tests::test_pvpanic_read_config::case_09 ... ok
[INFO] [stdout] test pci::pvpanic::tests::test_pvpanic_read_config::case_10 ... ok
[INFO] [stdout] test pci::pvpanic::tests::test_pvpanic_read_config::case_11 ... ok
[INFO] [stdout] test pci::pvpanic::tests::test_pvpanic_read_config::case_12 ... ok
[INFO] [stdout] test pci::segment::tests::test_pci_segment_mmio ... ok
[INFO] [stdout] test pci::segment::tests::test_pci_segment_next_bdf_wrapping ... ok
[INFO] [stdout] test pci::segment::tests::test_pci_segment_reserve::case_1 ... ok
[INFO] [stdout] test pci::segment::tests::test_pci_segment_reserve::case_2 ... ok
[INFO] [stdout] test pci::segment::tests::test_pci_segment_reserve::case_3 ... ok
[INFO] [stdout] test sys::linux::ioctl::tests::test_codes ... ok
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5ee00000, 200000) = 0, done
[INFO] [stdout] test utils::endian::tests::test_big_endian ... ok
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5ea00000, 200000) = 0, done
[INFO] [stdout] test utils::endian::tests::test_little_endian ... ok
[INFO] [stdout] test sync::notifier::tests::test_notifier ... ok
[INFO] [stdout] test utils::tests::test_align_up ... ok
[INFO] [stdout] test pci::segment::tests::test_pci_segment_reserve::case_4 ... ok
[INFO] [stdout] test virtio::dev::entropy::tests::entry_config_test ... ok
[INFO] [stdout] test virtio::queue::packed::tests::disabled_queue ... ok
[INFO] [stdout] test virtio::queue::packed::tests::enable_notification ... ok
[INFO] [stdout] test virtio::queue::packed::tests::index_wrapping_add::case_1 ... ok
[INFO] [stdout] test virtio::queue::packed::tests::index_wrapping_add::case_2 ... ok
[INFO] [stdout] test virtio::queue::packed::tests::index_wrapping_sub::case_1 ... ok
[INFO] [stdout] test virtio::queue::packed::tests::index_wrapping_add::case_4 ... ok
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5ea00000, 200000) = 0, done
[INFO] [stderr] ERROR [alioth::virtio::dev::vsock] alioth::virtio::dev::vsock::VsockConfig: write 0x0000000000000000 to readonly offset 0x0.
[INFO] [stdout] test virtio::queue::packed::tests::index_wrapping_add::case_3 ... ok
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5e600000, 200000) = 0, done
[INFO] [stdout] test virtio::queue::packed::tests::index_wrapping_sub::case_2 ... ok
[INFO] [stdout] test virtio::queue::packed::tests::index_wrapping_sub::case_4 ... ok
[INFO] [stdout] test virtio::queue::packed::tests::is_interrupt_enabled::case_01 ... ok
[INFO] [stdout] test virtio::dev::vsock::uds_vsock::tests::vsock_config_test ... ok
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5e600000, 200000) = 0, done
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5e200000, 200000) = 0, done
[INFO] [stdout] test virtio::queue::packed::tests::is_interrupt_enabled::case_05 ... ok
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5e800000, 200000) = 0, done
[INFO] [stdout] test virtio::queue::packed::tests::is_interrupt_enabled::case_03 ... ok
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5ea00000, 200000) = 0, done
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5e000000, 200000) = 0, done
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5e200000, 200000) = 0, done
[INFO] [stderr] ERROR [alioth::virtio::dev::vsock::uds_vsock] vsock: queue RX: no enough writable buffers for VsockOp::RST
[INFO] [stderr] ERROR [alioth::virtio::dev::vsock::uds_vsock] vsock: failed to respond to shutdown: Invalid virtq buffer
[INFO] [stderr] 0: Invalid virtq buffer, at alioth/src/virtio/dev/vsock/uds_vsock.rs:223:41
[INFO] [stderr] 
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5e400000, 200000) = 0, done
[INFO] [stdout] test virtio::queue::packed::tests::is_interrupt_enabled::case_08 ... ok
[INFO] [stdout] test virtio::queue::packed::tests::is_interrupt_enabled::case_02 ... ok
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5e600000, 200000) = 0, done
[INFO] [stdout] test virtio::queue::packed::tests::index_wrapping_sub::case_3 ... ok
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5e800000, 200000) = 0, done
[INFO] [stdout] test virtio::queue::packed::tests::is_interrupt_enabled::case_07 ... ok
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5de00000, 200000) = 0, done
[INFO] [stdout] test virtio::queue::packed::tests::is_interrupt_enabled::case_04 ... ok
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5e600000, 200000) = 0, done
[INFO] [stdout] test virtio::queue::packed::tests::is_interrupt_enabled::case_11 ... ok
[INFO] [stdout] test virtio::queue::packed::tests::is_interrupt_enabled::case_06 ... ok
[INFO] [stdout] test virtio::queue::packed::tests::is_interrupt_enabled::case_12 ... ok
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5f000000, 200000) = 0, done
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5e400000, 200000) = 0, done
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5ea00000, 200000) = 0, done
[INFO] [stdout] test virtio::queue::packed::tests::is_interrupt_enabled::case_09 ... ok
[INFO] [stdout] test virtio::queue::packed::tests::is_interrupt_enabled::case_10 ... ok
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5e800000, 200000) = 0, done
[INFO] [stdout] test virtio::queue::packed::tests::is_interrupt_enabled::case_13 ... ok
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5f000000, 200000) = 0, done
[INFO] [stdout] test virtio::dev::entropy::tests::entropy_test ... ok
[INFO] [stdout] test virtio::queue::tests::test_handle_deferred ... ok
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5e600000, 200000) = 0, done
[INFO] [stdout] test virtio::queue::split::tests::disabled_queue ... ok
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5ec00000, 200000) = 0, done
[INFO] [stdout] test virtio::queue::packed::tests::enabled_queue ... ok
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5ea00000, 200000) = 0, done
[INFO] [stderr] INFO [alioth::mem::mapped] munmap(0x7f1b5f000000, 200000) = 0, done
[INFO] [stdout] test virtio::queue::tests::test_written_bytes ... ok
[INFO] [stdout] test virtio::queue::tests::test_copy_from_reader ... ok
[INFO] [stdout] test virtio::queue::tests::test_copy_to_writer ... ok
[INFO] [stdout] test virtio::dev::vsock::uds_vsock::tests::vsock_conn_test ... ok
[INFO] [stdout] test virtio::queue::split::tests::event_idx_enabled ... ok
[INFO] [stdout] test virtio::queue::split::tests::enabled_queue ... ok
[INFO] [stdout] test device::serial::tests::test_serial_rx ... ok
[INFO] [stdout] test device::serial::tests::test_serial_rx_no_interrupt ... ok
[INFO] [stdout] test device::pl011::tests::test_pl011_rx_interrupt_disabled ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 235 passed; 0 failed; 4 ignored; 0 measured; 0 filtered out; finished in 0.51s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/alioth-aa8fbe1439c4897c)
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test boot::tests::test_parse_blk_arg::case_2 ... ok
[INFO] [stdout] test boot::tests::test_parse_blk_arg::case_1 ... ok
[INFO] [stdout] test boot::tests::test_parse_blk_arg::case_3 ... ok
[INFO] [stdout] test boot::tests::test_parse_args ... ok
[INFO] [stdout] test boot::tests::test_parse_blk_arg::case_4 ... ok
[INFO] [stdout] test boot::tests::test_parse_cpu_arg::case_2 ... ok
[INFO] [stdout] test boot::tests::test_parse_cpu_arg::case_1 ... ok
[INFO] [stdout] test boot::tests::test_parse_mem_arg::case_1 ... ok
[INFO] [stdout] test boot::tests::test_parse_mem_arg::case_2 ... ok
[INFO] [stdout] test boot::tests::test_parse_net_arg::case_1 ... ok
[INFO] [stdout] test boot::tests::test_parse_payload_arg::case_1 ... ok
[INFO] [stdout] test boot::tests::test_parse_payload_arg::case_2 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/alioth_macros-9dcc0613a92ea4c4)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/serde_aco-62ea78ce230140ff)
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test de::test::test_bytes ... ok
[INFO] [stdout] test de::test::test_char ... ok
[INFO] [stdout] test de::test::test_bool ... ok
[INFO] [stdout] test de::test::test_enum ... ok
[INFO] [stdout] test de::test::test_numbers ... ok
[INFO] [stdout] test de::test::test_map ... ok
[INFO] [stdout] test de::test::test_option ... ok
[INFO] [stdout] test de::test::test_nested_struct ... ok
[INFO] [stdout] test de::test::test_string ... ok
[INFO] [stdout] test de::test::test_seq ... ok
[INFO] [stdout] test de::test::test_unit ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/help_test.rs (/opt/rustwide/target/debug/deps/help_test-0dccb3284066bcad)
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test test_enum_help ... ok
[INFO] [stdout] test test_struct_help ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/serde_aco_derive-267fea53d30dba0a)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests alioth
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests alioth_macros
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests serde_aco
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests serde_aco_derive
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "27647b16ce4d73a4b4acf84b9125812abac54ccf08172271b57a0eaa43232c90", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "27647b16ce4d73a4b4acf84b9125812abac54ccf08172271b57a0eaa43232c90", kill_on_drop: false }`
[INFO] [stdout] 27647b16ce4d73a4b4acf84b9125812abac54ccf08172271b57a0eaa43232c90