[INFO] cloning repository https://github.com/maithanhduyan/aegis
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/maithanhduyan/aegis" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmaithanhduyan%2Faegis", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmaithanhduyan%2Faegis'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 8450d6b2a76400774d7bfd37559ae143a88640c1
[INFO] testing maithanhduyan/aegis against master#ec6f9a5b4413f74386267ef8efc93712c2ce6db6 for pr-155739-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fmaithanhduyan%2Faegis" "/workspace/builds/worker-1-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-1-tc1/source'...
[INFO] [stderr] done.
[INFO] removed /workspace/builds/worker-1-tc1/source/.cargo/config.toml
[INFO] removed /workspace/builds/worker-1-tc1/source/rust-toolchain.toml
[INFO] started tweaking git repo https://github.com/maithanhduyan/aegis
[INFO] finished tweaking git repo https://github.com/maithanhduyan/aegis
[INFO] tweaked toml for git repo https://github.com/maithanhduyan/aegis written to /workspace/builds/worker-1-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/maithanhduyan/aegis on toolchain ec6f9a5b4413f74386267ef8efc93712c2ce6db6
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/maithanhduyan/aegis 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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 35b8b1c971c6a2d9c48955c50ef829081c8ac3d66e0de1121706b61579958eb1
[INFO] running `Command { std: "docker" "start" "-a" "35b8b1c971c6a2d9c48955c50ef829081c8ac3d66e0de1121706b61579958eb1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "35b8b1c971c6a2d9c48955c50ef829081c8ac3d66e0de1121706b61579958eb1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "35b8b1c971c6a2d9c48955c50ef829081c8ac3d66e0de1121706b61579958eb1", kill_on_drop: false }`
[INFO] [stdout] 35b8b1c971c6a2d9c48955c50ef829081c8ac3d66e0de1121706b61579958eb1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 76833373f003b779685b4074c74e3c0978d4b6dc116c0977e5c8f43a6e3a99d2
[INFO] running `Command { std: "docker" "start" "-a" "76833373f003b779685b4074c74e3c0978d4b6dc116c0977e5c8f43a6e3a99d2", kill_on_drop: false }`
[INFO] [stderr]    Compiling aegis_os v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused variable: `peer`
[INFO] [stdout]    --> src/kernel/grant.rs:169:21
[INFO] [stdout]     |
[INFO] [stdout] 169 |         if let Some(peer) = (*GRANTS.get_mut())[grant_id].peer {
[INFO] [stdout]     |                     ^^^^ help: if this is intentional, prefix it with an underscore: `_peer`
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_variables)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `peer`
[INFO] [stdout]    --> src/kernel/grant.rs:203:29
[INFO] [stdout]     |
[INFO] [stdout] 203 |                 if let Some(peer) = (*GRANTS.get_mut())[i].peer {
[INFO] [stdout]     |                             ^^^^ help: if this is intentional, prefix it with an underscore: `_peer`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `task_id`
[INFO] [stdout]    --> src/kernel/irq.rs:231:35
[INFO] [stdout]     |
[INFO] [stdout] 231 | pub fn irq_route_test(intid: u32, task_id: usize) {
[INFO] [stdout]     |                                   ^^^^^^^ help: if this is intentional, prefix it with an underscore: `_task_id`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 0.53s
[INFO] running `Command { std: "docker" "inspect" "76833373f003b779685b4074c74e3c0978d4b6dc116c0977e5c8f43a6e3a99d2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "76833373f003b779685b4074c74e3c0978d4b6dc116c0977e5c8f43a6e3a99d2", kill_on_drop: false }`
[INFO] [stdout] 76833373f003b779685b4074c74e3c0978d4b6dc116c0977e5c8f43a6e3a99d2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a996b9eff4e02bc5842077b83b2730de2daf433b71a82a50f867fb520c7d0d5c
[INFO] running `Command { std: "docker" "start" "-a" "a996b9eff4e02bc5842077b83b2730de2daf433b71a82a50f867fb520c7d0d5c", kill_on_drop: false }`
[INFO] [stderr]    Compiling aegis_os v0.1.0 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused variable: `peer`
[INFO] [stdout]    --> src/kernel/grant.rs:169:21
[INFO] [stdout]     |
[INFO] [stdout] 169 |         if let Some(peer) = (*GRANTS.get_mut())[grant_id].peer {
[INFO] [stdout]     |                     ^^^^ help: if this is intentional, prefix it with an underscore: `_peer`
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_variables)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `peer`
[INFO] [stdout]    --> src/kernel/grant.rs:203:29
[INFO] [stdout]     |
[INFO] [stdout] 203 |                 if let Some(peer) = (*GRANTS.get_mut())[i].peer {
[INFO] [stdout]     |                             ^^^^ help: if this is intentional, prefix it with an underscore: `_peer`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `task_id`
[INFO] [stdout]    --> src/kernel/irq.rs:231:35
[INFO] [stdout]     |
[INFO] [stdout] 231 | pub fn irq_route_test(intid: u32, task_id: usize) {
[INFO] [stdout]     |                                   ^^^^^^^ help: if this is intentional, prefix it with an underscore: `_task_id`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused imports: `ElfInfo`, `ElfSegment`, `MAX_SEGMENTS`, and `PF_W`
[INFO] [stdout]   --> tests/host_tests.rs:39:51
[INFO] [stdout]    |
[INFO] [stdout] 39 | use aegis_os::elf::{self, ElfError, ElfLoadError, ElfSegment, ElfInfo, MAX_SEGMENTS, PF_R, PF_W, PF_X};
[INFO] [stdout]    |                                                   ^^^^^^^^^^  ^^^^^^^  ^^^^^^^^^^^^        ^^^^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `peer`
[INFO] [stdout]    --> src/kernel/grant.rs:169:21
[INFO] [stdout]     |
[INFO] [stdout] 169 |         if let Some(peer) = (*GRANTS.get_mut())[grant_id].peer {
[INFO] [stdout]     |                     ^^^^ help: if this is intentional, prefix it with an underscore: `_peer`
[INFO] [stdout]     |
[INFO] [stdout]     = note: `#[warn(unused_variables)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `peer`
[INFO] [stdout]    --> src/kernel/grant.rs:203:29
[INFO] [stdout]     |
[INFO] [stdout] 203 |                 if let Some(peer) = (*GRANTS.get_mut())[i].peer {
[INFO] [stdout]     |                             ^^^^ help: if this is intentional, prefix it with an underscore: `_peer`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused variable: `task_id`
[INFO] [stdout]    --> src/kernel/irq.rs:231:35
[INFO] [stdout]     |
[INFO] [stdout] 231 | pub fn irq_route_test(intid: u32, task_id: usize) {
[INFO] [stdout]     |                                   ^^^^^^^ help: if this is intentional, prefix it with an underscore: `_task_id`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unnecessary `unsafe` block
[INFO] [stdout]     --> tests/host_tests.rs:3447:13
[INFO] [stdout]      |
[INFO] [stdout] 3421 |     unsafe {
[INFO] [stdout]      |     ------ because it's nested under this `unsafe` block
[INFO] [stdout] ...
[INFO] [stdout] 3447 |             unsafe { *sched::CURRENT.get() }, 2,
[INFO] [stdout]      |             ^^^^^^ unnecessary `unsafe` block
[INFO] [stdout]      |
[INFO] [stdout]      = note: `#[warn(unused_unsafe)]` (part of `#[warn(unused)]`) on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.68s
[INFO] running `Command { std: "docker" "inspect" "a996b9eff4e02bc5842077b83b2730de2daf433b71a82a50f867fb520c7d0d5c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a996b9eff4e02bc5842077b83b2730de2daf433b71a82a50f867fb520c7d0d5c", kill_on_drop: false }`
[INFO] [stdout] a996b9eff4e02bc5842077b83b2730de2daf433b71a82a50f867fb520c7d0d5c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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" "+ec6f9a5b4413f74386267ef8efc93712c2ce6db6" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 619c9a3e2a754335902c8a4ef5d6e4d2f64fa48550697cbc246fc7fee524fe1f
[INFO] running `Command { std: "docker" "start" "-a" "619c9a3e2a754335902c8a4ef5d6e4d2f64fa48550697cbc246fc7fee524fe1f", kill_on_drop: false }`
[INFO] [stderr] warning: unused variable: `peer`
[INFO] [stderr]    --> src/kernel/grant.rs:169:21
[INFO] [stderr]     |
[INFO] [stderr] 169 |         if let Some(peer) = (*GRANTS.get_mut())[grant_id].peer {
[INFO] [stderr]     |                     ^^^^ help: if this is intentional, prefix it with an underscore: `_peer`
[INFO] [stderr]     |
[INFO] [stderr]     = note: `#[warn(unused_variables)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: unused variable: `peer`
[INFO] [stderr]    --> src/kernel/grant.rs:203:29
[INFO] [stderr]     |
[INFO] [stderr] 203 |                 if let Some(peer) = (*GRANTS.get_mut())[i].peer {
[INFO] [stderr]     |                             ^^^^ help: if this is intentional, prefix it with an underscore: `_peer`
[INFO] [stderr] 
[INFO] [stderr] warning: unused variable: `task_id`
[INFO] [stderr]    --> src/kernel/irq.rs:231:35
[INFO] [stderr]     |
[INFO] [stderr] 231 | pub fn irq_route_test(intid: u32, task_id: usize) {
[INFO] [stderr]     |                                   ^^^^^^^ help: if this is intentional, prefix it with an underscore: `_task_id`
[INFO] [stderr] 
[INFO] [stderr] warning: `aegis_os` (lib) generated 3 warnings (run `cargo fix --lib -p aegis_os` to apply 3 suggestions)
[INFO] [stderr] warning: unused imports: `ElfInfo`, `ElfSegment`, `MAX_SEGMENTS`, and `PF_W`
[INFO] [stderr]   --> tests/host_tests.rs:39:51
[INFO] [stderr]    |
[INFO] [stderr] 39 | use aegis_os::elf::{self, ElfError, ElfLoadError, ElfSegment, ElfInfo, MAX_SEGMENTS, PF_R, PF_W, PF_X};
[INFO] [stderr]    |                                                   ^^^^^^^^^^  ^^^^^^^  ^^^^^^^^^^^^        ^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(unused_imports)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: unnecessary `unsafe` block
[INFO] [stderr]     --> tests/host_tests.rs:3447:13
[INFO] [stderr]      |
[INFO] [stderr] 3421 |     unsafe {
[INFO] [stderr]      |     ------ because it's nested under this `unsafe` block
[INFO] [stderr] ...
[INFO] [stderr] 3447 |             unsafe { *sched::CURRENT.get() }, 2,
[INFO] [stderr]      |             ^^^^^^ unnecessary `unsafe` block
[INFO] [stderr]      |
[INFO] [stderr]      = note: `#[warn(unused_unsafe)]` (part of `#[warn(unused)]`) on by default
[INFO] [stderr] 
[INFO] [stderr] warning: `aegis_os` (test "host_tests") generated 2 warnings (run `cargo fix --test "host_tests" -p aegis_os` to apply 1 suggestion)
[INFO] [stderr] warning: `aegis_os` (lib test) generated 3 warnings (3 duplicates)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/aegis_os-c17c4f62c344a187)
[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/main.rs (/opt/rustwide/target/debug/deps/aegis_os-c6483b01f716b658)
[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 tests/host_tests.rs (/opt/rustwide/target/debug/deps/host_tests-4164da645532a706)
[INFO] [stdout] 
[INFO] [stdout] running 250 tests
[INFO] [stdout] test addr_different_asids_produce_different_ttbr0 ... ok
[INFO] [stdout] test cap_all_includes_every_bit ... ok
[INFO] [stdout] test addr_max_asid_fits_in_8_bits ... ok
[INFO] [stdout] test addr_schedule_preserves_ttbr0_in_tcb ... ok
[INFO] [stdout] test addr_ttbr0_for_task_embeds_asid ... ok
[INFO] [stdout] test cap_all_includes_grants ... ok
[INFO] [stdout] test addr_empty_tcb_has_zero_ttbr0 ... ok
[INFO] [stdout] test addr_ttbr0_survives_restart ... ok
[INFO] [stdout] test cap_all_includes_device_map ... ok
[INFO] [stdout] test cap_all_includes_heartbeat ... ok
[INFO] [stdout] test cap_all_includes_irq ... ok
[INFO] [stdout] test cap_bits_are_distinct_powers_of_two ... ok
[INFO] [stdout] test addr_page_table_base_is_4k_aligned ... ok
[INFO] [stdout] test addr_asid_zero_reserved_for_kernel ... ok
[INFO] [stdout] test cap_check_multi_bit_requirement ... ok
[INFO] [stdout] test cap_check_single_bit ... ok
[INFO] [stdout] test cap_empty_tcb_has_zero_caps ... ok
[INFO] [stdout] test cap_check_zero_required_always_passes ... ok
[INFO] [stdout] test cap_exit_bit_18 ... ok
[INFO] [stdout] test cap_exit_granted_with_cap ... ok
[INFO] [stdout] test cap_exit_denied_without_cap ... ok
[INFO] [stdout] test cap_for_syscall_ep2_ep3 ... ok
[INFO] [stdout] test cap_for_syscall_all_endpoints ... ok
[INFO] [stdout] test cap_for_syscall_exit ... ok
[INFO] [stdout] test cap_exit_in_cap_all ... ok
[INFO] [stdout] test cap_for_syscall_grant_irq_device ... ok
[INFO] [stdout] test cap_for_syscall_grant ... ok
[INFO] [stdout] test cap_for_syscall_call_needs_both ... ok
[INFO] [stdout] test cap_for_syscall_device_map ... ok
[INFO] [stdout] test cap_for_syscall_heartbeat ... ok
[INFO] [stdout] test cap_none_grants_nothing ... ok
[INFO] [stdout] test cap_heartbeat_bit_is_power_of_two ... ok
[INFO] [stdout] test cap_for_syscall_invalid_returns_zero ... ok
[INFO] [stdout] test cap_for_syscall_send_recv ... ok
[INFO] [stdout] test cap_for_syscall_write ... ok
[INFO] [stdout] test device_map_invalid_task_id ... ok
[INFO] [stdout] test device_map_valid_uart ... ok
[INFO] [stdout] test cap_survives_restart_simulation ... ok
[INFO] [stdout] test elf_load_segments_copy_and_zero ... ok
[INFO] [stdout] test cap_name_all_missing_arms ... ok
[INFO] [stdout] test cap_name_heartbeat ... ok
[INFO] [stdout] test cap_name_returns_expected_strings ... ok
[INFO] [stdout] test device_map_invalid_device_id ... ok
[INFO] [stdout] test addr_ttbr0_preserves_base_address ... ok
[INFO] [stdout] test cap_name_exit ... ok
[INFO] [stdout] test cap_for_syscall_irq ... ok
[INFO] [stdout] test device_registry_uart_l2_index ... ok
[INFO] [stdout] test elf_parse_bad_magic ... ok
[INFO] [stdout] test elf_parse_entry_point ... ok
[INFO] [stdout] test elf_parse_not_64bit ... ok
[INFO] [stdout] test elf_load_segments_rejects_invalid ... ok
[INFO] [stdout] test cap_for_syscall_yield ... ok
[INFO] [stdout] test elf_validate_for_load_entry_out_of_range ... ok
[INFO] [stdout] test elf_parse_no_segments ... ok
[INFO] [stdout] test elf_parse_not_executable ... ok
[INFO] [stdout] test elf_validate_for_load_no_segments ... ok
[INFO] [stdout] test elf_parse_too_many_segments ... ok
[INFO] [stdout] test elf_parse_too_small ... ok
[INFO] [stdout] test elf_validate_for_load_segment_too_large ... ok
[INFO] [stdout] test elf_parse_segment_out_of_bounds ... ok
[INFO] [stdout] test cap_heartbeat_is_bit_17 ... ok
[INFO] [stdout] test elf_validate_for_load_vaddr_below_base ... ok
[INFO] [stdout] test exited_task_not_auto_restarted ... ok
[INFO] [stdout] test elf_validate_for_load_wx_violation ... ok
[INFO] [stdout] test grant_cleanup_clears_both_roles ... ok
[INFO] [stdout] test grant_cleanup_peer_faulted ... ok
[INFO] [stdout] test grant_create_duplicate_rejected ... ok
[INFO] [stdout] test grant_create_invalid_id ... ok
[INFO] [stdout] test grant_create_self_grant_rejected ... ok
[INFO] [stdout] test grant_cleanup_owner_faulted ... ok
[INFO] [stdout] test exited_task_skipped_by_scheduler ... ok
[INFO] [stdout] test grant_create_invalid_peer ... ok
[INFO] [stdout] test elf_validate_for_load_valid ... ok
[INFO] [stdout] test grant_create_success ... ok
[INFO] [stdout] test addr_page_table_base_returns_distinct_per_task ... ok
[INFO] [stdout] test elf_parse_not_little_endian ... ok
[INFO] [stdout] test elf_parse_valid_multiple_segments ... ok
[INFO] [stdout] test elf_parse_valid_single_segment ... ok
[INFO] [stdout] test elf_parse_wrong_arch ... ok
[INFO] [stdout] test grant_page_addr_invalid ... ok
[INFO] [stdout] test grant_page_addr_valid ... ok
[INFO] [stdout] test grant_re_create_after_revoke ... ok
[INFO] [stdout] test grant_revoke_by_owner ... ok
[INFO] [stdout] test grant_revoke_by_non_owner_rejected ... ok
[INFO] [stdout] test grant_revoke_inactive_is_noop ... ok
[INFO] [stdout] test grant_two_grants_independent ... ok
[INFO] [stdout] test idle_task_id_is_last ... ok
[INFO] [stdout] test ipc_round_trip_message_integrity ... ok
[INFO] [stdout] test ipc_cleanup_all_four_endpoints ... ok
[INFO] [stdout] test ipc_send_restores_receiver_priority ... ok
[INFO] [stdout] test ipc_cleanup_clears_both_endpoints ... ok
[INFO] [stdout] test ipc_cleanup_clears_sender_slot ... ok
[INFO] [stdout] test ipc_sys_call_invalid_endpoint ... ok
[INFO] [stdout] test ipc_cleanup_doesnt_affect_other_tasks ... ok
[INFO] [stdout] test ipc_msg_regs_count ... ok
[INFO] [stdout] test ipc_sys_call_no_receiver ... ok
[INFO] [stdout] test ipc_four_endpoints_exist ... ok
[INFO] [stdout] test ipc_cleanup_clears_receiver_slot ... ok
[INFO] [stdout] test ipc_sys_call_priority_boost ... ok
[INFO] [stdout] test ipc_copy_message ... ok
[INFO] [stdout] test ipc_endpoint_initial_state ... ok
[INFO] [stdout] test grant_revoke_invalid_id ... ok
[INFO] [stdout] test ipc_max_endpoints ... ok
[INFO] [stdout] test ipc_sys_call_queue_full ... ok
[INFO] [stdout] test ipc_sys_call_with_receiver_waiting ... ok
[INFO] [stdout] test ipc_recv_loads_frame_on_immediate ... ok
[INFO] [stdout] test ipc_sys_recv_blocks_when_no_sender ... ok
[INFO] [stdout] test irq_ack_already_acked_is_noop ... ok
[INFO] [stdout] test ipc_sys_recv_immediate_delivery ... ok
[INFO] [stdout] test ipc_sys_recv_invalid_endpoint ... ok
[INFO] [stdout] test irq_ack_success ... ok
[INFO] [stdout] test irq_ack_not_bound ... ok
[INFO] [stdout] test irq_ack_wrong_task ... ok
[INFO] [stdout] test irq_bind_reject_duplicate ... ok
[INFO] [stdout] test irq_bind_reject_ppi ... ok
[INFO] [stdout] test irq_bind_reject_zero_bit ... ok
[INFO] [stdout] test ipc_sys_send_blocks_when_no_receiver ... ok
[INFO] [stdout] test irq_bind_table_full ... ok
[INFO] [stdout] test irq_bind_success ... ok
[INFO] [stdout] test irq_cleanup_does_not_affect_other_tasks ... ok
[INFO] [stdout] test ipc_sys_send_immediate_delivery ... ok
[INFO] [stdout] test ipc_sys_send_invalid_endpoint ... ok
[INFO] [stdout] test irq_route_accumulates_bits ... ok
[INFO] [stdout] test ipc_sys_send_queue_full ... ok
[INFO] [stdout] test irq_cleanup_unbinds_all ... ok
[INFO] [stdout] test irq_rebind_after_cleanup ... ok
[INFO] [stdout] test irq_route_sets_notify_pending ... ok
[INFO] [stdout] test irq_route_unblocks_waiting_task ... ok
[INFO] [stdout] test kernel_cell_as_ptr_stable ... ok
[INFO] [stdout] test kernel_cell_get_read ... ok
[INFO] [stdout] test kernel_cell_get_then_get_mut_roundtrip ... ok
[INFO] [stdout] test klog_macro_compiles ... ok
[INFO] [stdout] test l6_arch_module_exists ... ok
[INFO] [stdout] test l6_cfg_separation_works ... ok
[INFO] [stdout] test l6_elf_wxn_flag_properties ... ok
[INFO] [stdout] test l6_kernel_module_exports ... ok
[INFO] [stdout] test l6_platform_constants ... ok
[INFO] [stdout] test l6_use_paths_unchanged ... ok
[INFO] [stdout] test log_level_ordering ... ok
[INFO] [stdout] test log_message_basic ... ok
[INFO] [stdout] test log_prefix_all_levels ... ok
[INFO] [stdout] test mmu_access_flag ... ok
[INFO] [stdout] test mmu_access_permissions ... ok
[INFO] [stdout] test mmu_attr_indices ... ok
[INFO] [stdout] test mmu_device_block_has_af ... ok
[INFO] [stdout] test mmu_device_block_is_el1_only ... ok
[INFO] [stdout] test mmu_device_block_is_non_executable ... ok
[INFO] [stdout] test mmu_execute_never_bits ... ok
[INFO] [stdout] test mmu_kernel_data_page_is_el1_only ... ok
[INFO] [stdout] test mmu_kernel_data_page_is_non_executable ... ok
[INFO] [stdout] test mmu_set_page_attr_host_stub ... ok
[INFO] [stdout] test mmu_shareability ... ok
[INFO] [stdout] test mmu_shared_code_page_is_executable ... ok
[INFO] [stdout] test mmu_shared_code_page_is_readonly ... ok
[INFO] [stdout] test mmu_table_vs_block_vs_page ... ok
[INFO] [stdout] test mmu_user_code_page_el0_exec_only ... ok
[INFO] [stdout] test mmu_user_data_page_is_el0_accessible ... ok
[INFO] [stdout] test mmu_user_data_page_is_non_executable ... ok
[INFO] [stdout] test mmu_valid_bit ... ok
[INFO] [stdout] test mmu_wxn_invariant ... ok
[INFO] [stdout] test notify_cap_for_syscall_notify ... ok
[INFO] [stdout] test notify_cap_for_syscall_wait_notify ... ok
[INFO] [stdout] test notify_cleared_on_restart ... ok
[INFO] [stdout] test notify_empty_tcb_has_no_pending ... ok
[INFO] [stdout] test notify_pending_cleared_on_read ... ok
[INFO] [stdout] test notify_pending_or_merge ... ok
[INFO] [stdout] test notify_waiting_flag ... ok
[INFO] [stdout] test page_table_constants_computed ... ok
[INFO] [stdout] test sched_auto_restart_after_delay ... ok
[INFO] [stdout] test sched_budget_exhausted_skips_task ... ok
[INFO] [stdout] test sched_context_save_restore ... ok
[INFO] [stdout] test sched_empty_tcb_is_zeroed ... ok
[INFO] [stdout] test sched_empty_tcb_phase_k_fields_zeroed ... ok
[INFO] [stdout] test sched_epoch_length_constant ... ok
[INFO] [stdout] test sched_fault_current_task_basic ... ok
[INFO] [stdout] test sched_epoch_reset_clears_ticks ... ok
[INFO] [stdout] test sched_get_set_task_reg ... ok
[INFO] [stdout] test sched_fault_current_task_cleans_irq ... ok
[INFO] [stdout] test sched_get_task_base_priority ... ok
[INFO] [stdout] test sched_get_task_base_priority_out_of_range ... ok
[INFO] [stdout] test sched_get_task_priority ... ok
[INFO] [stdout] test sched_get_task_priority_out_of_range ... ok
[INFO] [stdout] test sched_out_of_range_set_priority_is_noop ... ok
[INFO] [stdout] test sched_priority_higher_wins ... ok
[INFO] [stdout] test sched_record_heartbeat ... ok
[INFO] [stdout] test sched_priority_restored_on_fault ... ok
[INFO] [stdout] test sched_record_heartbeat_disable ... ok
[INFO] [stdout] test sched_restart_task_non_faulted_noop ... ok
[INFO] [stdout] test sched_restore_base_priority ... ok
[INFO] [stdout] test sched_num_tasks ... ok
[INFO] [stdout] test sched_restore_base_priority_out_of_range ... ok
[INFO] [stdout] test sched_restart_delay ... ok
[INFO] [stdout] test sched_same_priority_round_robin ... ok
[INFO] [stdout] test sched_round_robin_all_ready ... ok
[INFO] [stdout] test sched_save_load_frame ... ok
[INFO] [stdout] test sched_schedule_no_ready_task_forces_idle ... ok
[INFO] [stdout] test sched_set_task_priority ... ok
[INFO] [stdout] test sched_set_task_state_out_of_range ... ok
[INFO] [stdout] test sched_skip_blocked_task ... ok
[INFO] [stdout] test sched_skip_faulted_task ... ok
[INFO] [stdout] test sched_task_state_values ... ok
[INFO] [stdout] test sched_tcb_size ... ok
[INFO] [stdout] test sched_set_task_priority_out_of_range ... ok
[INFO] [stdout] test sched_ticks_used_reset_on_restart ... ok
[INFO] [stdout] test sched_unlimited_budget_never_exhausted ... ok
[INFO] [stdout] test sched_watchdog_scan_no_violation ... ok
[INFO] [stdout] test sched_watchdog_scan_period_constant ... ok
[INFO] [stdout] test sched_watchdog_scan_skips_already_faulted ... ok
[INFO] [stdout] test sched_watchdog_scan_skips_disabled ... ok
[INFO] [stdout] test sched_watchdog_scan_violation_faults_task ... ok
[INFO] [stdout] test sender_queue_contains ... ok
[INFO] [stdout] test sender_queue_full_rejects ... ok
[INFO] [stdout] test sender_queue_push_pop_fifo ... ok
[INFO] [stdout] test sender_queue_remove_middle ... ok
[INFO] [stdout] test sender_queue_wrap_around ... ok
[INFO] [stdout] test task_state_exited_distinct ... ok
[INFO] [stdout] test task_state_exited_value ... ok
[INFO] [stdout] test test_budget_epoch_reset_fairness_logic ... ok
[INFO] [stdout] test test_grant_cleanup_completeness_logic ... ok
[INFO] [stdout] test test_grant_slot_exhaustion_safe_logic ... ok
[INFO] [stdout] test test_irq_bind_no_duplicate_intid_logic ... ok
[INFO] [stdout] test test_irq_cleanup_no_orphaned_binding ... ok
[INFO] [stdout] test test_irq_route_correctness_logic ... ok
[INFO] [stdout] test sched_schedule_idle_faulted_gets_restarted ... ok
[INFO] [stdout] test test_watchdog_should_not_fault_within_interval ... ok
[INFO] [stdout] test test_watchdog_should_fault_violated ... ok
[INFO] [stdout] test timer_tick_count_accessor ... ok
[INFO] [stdout] test trapframe_alignment_is_16 ... ok
[INFO] [stdout] test uart_print_dec_nonzero ... ok
[INFO] [stdout] test trapframe_size_is_288 ... ok
[INFO] [stdout] test test_grant_create_validates_correctly ... ok
[INFO] [stdout] test validate_write_end_of_ram ... ok
[INFO] [stdout] test validate_write_null_ptr ... ok
[INFO] [stdout] test trapframe_zeroed_is_valid ... ok
[INFO] [stdout] test validate_write_over_256 ... ok
[INFO] [stdout] test validate_write_spans_boundary ... ok
[INFO] [stdout] test uart_print_dec_zero ... ok
[INFO] [stdout] test uart_print_empty_and_nonempty ... ok
[INFO] [stdout] test uart_print_hex_basic ... ok
[INFO] [stdout] test validate_write_start_of_ram ... ok
[INFO] [stdout] test validate_write_uart_mmio ... ok
[INFO] [stdout] test validate_write_valid_ptr_in_ram ... ok
[INFO] [stdout] test validate_write_exactly_256 ... ok
[INFO] [stdout] test validate_write_past_ram_end ... ok
[INFO] [stdout] test validate_write_wrapping_overflow ... ok
[INFO] [stdout] test validate_write_before_ram ... ok
[INFO] [stdout] test trapframe_field_offsets ... ok
[INFO] [stdout] test validate_write_zero_length ... ok
[INFO] [stdout] test sched_idle_fallback ... FAILED
[INFO] [stderr] error: test failed, to rerun pass `--test host_tests`
[INFO] [stdout] test sched_heartbeat_reset_on_restart ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- sched_idle_fallback stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'sched_idle_fallback' (203) panicked at tests/host_tests.rs:538:9:
[INFO] [stdout] assertion `left == right` failed
[INFO] [stdout]   left: 2
[INFO] [stdout]  right: 7
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x60ef15d5fe4a - std[29689e6404d28ef9]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x60ef15d5fe4a - std[29689e6404d28ef9]::backtrace_rs::backtrace::trace_unsynchronized::<std[29689e6404d28ef9]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x60ef15d5fe4a - std[29689e6404d28ef9]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x60ef15d5fe4a - <<std[29689e6404d28ef9]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[e929cb53b82a81ca]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x60ef15d73f1a - <core[e929cb53b82a81ca]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x60ef15d73f1a - core[e929cb53b82a81ca]::fmt::write
[INFO] [stdout]    6:     0x60ef15d64682 - std[29689e6404d28ef9]::io::default_write_fmt::<alloc[9d7caffeb3b5d2c6]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x60ef15d64682 - <alloc[9d7caffeb3b5d2c6]::vec::Vec<u8> as std[29689e6404d28ef9]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x60ef15d3ee4f - <std[29689e6404d28ef9]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x60ef15d3ee4f - std[29689e6404d28ef9]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x60ef15d582a9 - std[29689e6404d28ef9]::panicking::default_hook
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x60ef15cecdfc - <alloc[9d7caffeb3b5d2c6]::boxed::Box<dyn for<'a, 'b> core[e929cb53b82a81ca]::ops::function::Fn<(&'a std[29689e6404d28ef9]::panic::PanicHookInfo<'b>,), Output = ()> + core[e929cb53b82a81ca]::marker::Send + core[e929cb53b82a81ca]::marker::Sync> as core[e929cb53b82a81ca]::ops::function::Fn<(&std[29689e6404d28ef9]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x60ef15cecdfc - test[a24b3028667022f7]::test_main_inner::<test[a24b3028667022f7]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x60ef15d58462 - <alloc[9d7caffeb3b5d2c6]::boxed::Box<dyn for<'a, 'b> core[e929cb53b82a81ca]::ops::function::Fn<(&'a std[29689e6404d28ef9]::panic::PanicHookInfo<'b>,), Output = ()> + core[e929cb53b82a81ca]::marker::Send + core[e929cb53b82a81ca]::marker::Sync> as core[e929cb53b82a81ca]::ops::function::Fn<(&std[29689e6404d28ef9]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x60ef15d58462 - std[29689e6404d28ef9]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x60ef15d3ef08 - std[29689e6404d28ef9]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x60ef15d34119 - std[29689e6404d28ef9]::sys::backtrace::__rust_end_short_backtrace::<std[29689e6404d28ef9]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x60ef15d3fc1d - __rustc[3aed6af316653e63]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x60ef15d7466c - core[e929cb53b82a81ca]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x60ef15d74523 - core[e929cb53b82a81ca]::panicking::assert_failed_inner
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panicking.rs:439:17
[INFO] [stdout]   20:     0x60ef15d7095d - core[e929cb53b82a81ca]::panicking::assert_failed::<usize, usize>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panicking.rs:394:5
[INFO] [stdout]   21:     0x60ef15cc4a40 - host_tests[913209df1c27eaf2]::sched_idle_fallback
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/host_tests.rs:538:9
[INFO] [stdout]   22:     0x60ef15cbece7 - host_tests[913209df1c27eaf2]::sched_idle_fallback::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/host_tests.rs:521:25
[INFO] [stdout]   23:     0x60ef15cdc866 - <host_tests[913209df1c27eaf2]::sched_idle_fallback::{closure#0} as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x60ef15ce00db - <fn() -> core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String> as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x60ef15ce00db - test[a24b3028667022f7]::__rust_begin_short_backtrace::<core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String>, fn() -> core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:724:18
[INFO] [stdout]   26:     0x60ef15ced8cb - test[a24b3028667022f7]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:747:74
[INFO] [stdout]   27:     0x60ef15ced8cb - <core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<test[a24b3028667022f7]::run_test_in_process::{closure#0}> as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x60ef15ced8cb - std[29689e6404d28ef9]::panicking::catch_unwind::do_call::<core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<test[a24b3028667022f7]::run_test_in_process::{closure#0}>, core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x60ef15ced8cb - std[29689e6404d28ef9]::panicking::catch_unwind::<core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String>, core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<test[a24b3028667022f7]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x60ef15ced8cb - std[29689e6404d28ef9]::panic::catch_unwind::<core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<test[a24b3028667022f7]::run_test_in_process::{closure#0}>, core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x60ef15ced8cb - test[a24b3028667022f7]::run_test_in_process
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:747:27
[INFO] [stdout]   32:     0x60ef15ced8cb - test[a24b3028667022f7]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:668:43
[INFO] [stdout]   33:     0x60ef15ce6fe4 - test[a24b3028667022f7]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:698:41
[INFO] [stdout]   34:     0x60ef15ce6fe4 - std[29689e6404d28ef9]::sys::backtrace::__rust_begin_short_backtrace::<test[a24b3028667022f7]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x60ef15cf04d2 - std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked::<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   36:     0x60ef15cf04d2 - <core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x60ef15cf04d2 - std[29689e6404d28ef9]::panicking::catch_unwind::do_call::<core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x60ef15cf04d2 - std[29689e6404d28ef9]::panicking::catch_unwind::<(), core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x60ef15cf04d2 - std[29689e6404d28ef9]::panic::catch_unwind::<core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x60ef15cf04d2 - std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked::<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   41:     0x60ef15cf04d2 - <std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1} as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x60ef15d5f75f - <alloc[9d7caffeb3b5d2c6]::boxed::Box<dyn core[e929cb53b82a81ca]::ops::function::FnOnce<(), Output = ()> + core[e929cb53b82a81ca]::marker::Send> as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   43:     0x60ef15d5f75f - <std[29689e6404d28ef9]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   44:     0x71dd10591aa4 - <unknown>
[INFO] [stdout]   45:     0x71dd1061ea64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- sched_heartbeat_reset_on_restart stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'sched_heartbeat_reset_on_restart' (202) panicked at tests/host_tests.rs:2137:9:
[INFO] [stdout] assertion `left == right` failed: last_heartbeat should be reset to current tick on restart
[INFO] [stdout]   left: 0
[INFO] [stdout]  right: 100
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x60ef15d5fe4a - std[29689e6404d28ef9]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x60ef15d5fe4a - std[29689e6404d28ef9]::backtrace_rs::backtrace::trace_unsynchronized::<std[29689e6404d28ef9]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x60ef15d5fe4a - std[29689e6404d28ef9]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x60ef15d5fe4a - <<std[29689e6404d28ef9]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[e929cb53b82a81ca]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x60ef15d73f1a - <core[e929cb53b82a81ca]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x60ef15d73f1a - core[e929cb53b82a81ca]::fmt::write
[INFO] [stdout]    6:     0x60ef15d64682 - std[29689e6404d28ef9]::io::default_write_fmt::<alloc[9d7caffeb3b5d2c6]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/io/mod.rs:621:11
[INFO] [stdout]    7:     0x60ef15d64682 - <alloc[9d7caffeb3b5d2c6]::vec::Vec<u8> as std[29689e6404d28ef9]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/io/mod.rs:1976:13
[INFO] [stdout]    8:     0x60ef15d3ee4f - <std[29689e6404d28ef9]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x60ef15d3ee4f - std[29689e6404d28ef9]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x60ef15d582a9 - std[29689e6404d28ef9]::panicking::default_hook
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x60ef15cecdfc - <alloc[9d7caffeb3b5d2c6]::boxed::Box<dyn for<'a, 'b> core[e929cb53b82a81ca]::ops::function::Fn<(&'a std[29689e6404d28ef9]::panic::PanicHookInfo<'b>,), Output = ()> + core[e929cb53b82a81ca]::marker::Send + core[e929cb53b82a81ca]::marker::Sync> as core[e929cb53b82a81ca]::ops::function::Fn<(&std[29689e6404d28ef9]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   12:     0x60ef15cecdfc - test[a24b3028667022f7]::test_main_inner::<test[a24b3028667022f7]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x60ef15d58462 - <alloc[9d7caffeb3b5d2c6]::boxed::Box<dyn for<'a, 'b> core[e929cb53b82a81ca]::ops::function::Fn<(&'a std[29689e6404d28ef9]::panic::PanicHookInfo<'b>,), Output = ()> + core[e929cb53b82a81ca]::marker::Send + core[e929cb53b82a81ca]::marker::Sync> as core[e929cb53b82a81ca]::ops::function::Fn<(&std[29689e6404d28ef9]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/alloc/src/boxed.rs:2285:9
[INFO] [stdout]   14:     0x60ef15d58462 - std[29689e6404d28ef9]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x60ef15d3ef08 - std[29689e6404d28ef9]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x60ef15d34119 - std[29689e6404d28ef9]::sys::backtrace::__rust_end_short_backtrace::<std[29689e6404d28ef9]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x60ef15d3fc1d - __rustc[3aed6af316653e63]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x60ef15d7466c - core[e929cb53b82a81ca]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x60ef15d74583 - core[e929cb53b82a81ca]::panicking::assert_failed_inner
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panicking.rs:434:23
[INFO] [stdout]   20:     0x60ef15d70992 - core[e929cb53b82a81ca]::panicking::assert_failed::<u64, u64>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panicking.rs:394:5
[INFO] [stdout]   21:     0x60ef15cd389e - host_tests[913209df1c27eaf2]::sched_heartbeat_reset_on_restart
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/host_tests.rs:2137:9
[INFO] [stdout]   22:     0x60ef15cc0a57 - host_tests[913209df1c27eaf2]::sched_heartbeat_reset_on_restart::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/host_tests.rs:2123:38
[INFO] [stdout]   23:     0x60ef15cdefa6 - <host_tests[913209df1c27eaf2]::sched_heartbeat_reset_on_restart::{closure#0} as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x60ef15ce00db - <fn() -> core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String> as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x60ef15ce00db - test[a24b3028667022f7]::__rust_begin_short_backtrace::<core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String>, fn() -> core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:724:18
[INFO] [stdout]   26:     0x60ef15ced8cb - test[a24b3028667022f7]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:747:74
[INFO] [stdout]   27:     0x60ef15ced8cb - <core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<test[a24b3028667022f7]::run_test_in_process::{closure#0}> as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x60ef15ced8cb - std[29689e6404d28ef9]::panicking::catch_unwind::do_call::<core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<test[a24b3028667022f7]::run_test_in_process::{closure#0}>, core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x60ef15ced8cb - std[29689e6404d28ef9]::panicking::catch_unwind::<core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String>, core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<test[a24b3028667022f7]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x60ef15ced8cb - std[29689e6404d28ef9]::panic::catch_unwind::<core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<test[a24b3028667022f7]::run_test_in_process::{closure#0}>, core[e929cb53b82a81ca]::result::Result<(), alloc[9d7caffeb3b5d2c6]::string::String>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x60ef15ced8cb - test[a24b3028667022f7]::run_test_in_process
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:747:27
[INFO] [stdout]   32:     0x60ef15ced8cb - test[a24b3028667022f7]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:668:43
[INFO] [stdout]   33:     0x60ef15ce6fe4 - test[a24b3028667022f7]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/test/src/lib.rs:698:41
[INFO] [stdout]   34:     0x60ef15ce6fe4 - std[29689e6404d28ef9]::sys::backtrace::__rust_begin_short_backtrace::<test[a24b3028667022f7]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x60ef15cf04d2 - std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked::<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   36:     0x60ef15cf04d2 - <core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x60ef15cf04d2 - std[29689e6404d28ef9]::panicking::catch_unwind::do_call::<core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x60ef15cf04d2 - std[29689e6404d28ef9]::panicking::catch_unwind::<(), core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x60ef15cf04d2 - std[29689e6404d28ef9]::panic::catch_unwind::<core[e929cb53b82a81ca]::panic::unwind_safe::AssertUnwindSafe<std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x60ef15cf04d2 - std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked::<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   41:     0x60ef15cf04d2 - <std[29689e6404d28ef9]::thread::lifecycle::spawn_unchecked<test[a24b3028667022f7]::run_test::{closure#1}, ()>::{closure#1} as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x60ef15d5f75f - <alloc[9d7caffeb3b5d2c6]::boxed::Box<dyn core[e929cb53b82a81ca]::ops::function::FnOnce<(), Output = ()> + core[e929cb53b82a81ca]::marker::Send> as core[e929cb53b82a81ca]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/alloc/src/boxed.rs:2271:9
[INFO] [stdout]   43:     0x60ef15d5f75f - <std[29689e6404d28ef9]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/ec6f9a5b4413f74386267ef8efc93712c2ce6db6/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   44:     0x71dd10591aa4 - <unknown>
[INFO] [stdout]   45:     0x71dd1061ea64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     sched_heartbeat_reset_on_restart
[INFO] [stdout]     sched_idle_fallback
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 248 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.22s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "619c9a3e2a754335902c8a4ef5d6e4d2f64fa48550697cbc246fc7fee524fe1f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "619c9a3e2a754335902c8a4ef5d6e4d2f64fa48550697cbc246fc7fee524fe1f", kill_on_drop: false }`
[INFO] [stdout] 619c9a3e2a754335902c8a4ef5d6e4d2f64fa48550697cbc246fc7fee524fe1f
