2019/04/20 00:42:26 QEMU invocation: [/b/s/w/ir/qemu/bin/qemu-system-x86_64 -machine q35 -device isa-debug-exit,iobase=0xf4,iosize=0x04 -cpu host -enable-kvm -m 4096 -smp 4 -nographic -serial stdio -monitor none -kernel /b/s/w/ir/multiboot.bin -initrd /b/s/w/ir/core-tests-x64.zbi -netdev user,id=net0 -device virtio-net-pci,netdev=net0 -append kernel.halt-on-panic=true devmgr.suspend-timeout-debug=true TERM=dumb kernel.serial=legacy] [00000.000] 00000:00000> zbi: @ 0xffffff8000407000 (3161832 bytes) [00000.000] 00000:00000> UART: FIFO depth 16 [00000.000] 00000:00000> PMM: boot reserve add [0x100000, 0x333fff] [00000.000] 00000:00000> PMM: boot reserve add [0x407000, 0x70afff] [00000.000] 00000:00000> PMM: boot reserve marking WIRED [0x100000, 0x333fff] [00000.000] 00000:00000> PMM: boot reserve marking WIRED [0x407000, 0x70afff] [00000.000] 00000:00000> [00000.000] 00000:00000> welcome to Zircon [00000.000] 00000:00000> [00000.000] 00000:00000> KASLR: .text section at 0xffffffff00100000 [00000.000] 00000:00000> INIT: cpu 0, calling hook 0xffffffff001206d0 (global_prng_seed) at level 0x30000, flags 0x1 [00000.000] 00000:00000> initializing vm pre-heap [00000.000] 00000:00000> VM: marking boot alloc used range [0x70b000, 0x70b080) [00000.000] 00000:00000> INIT: cpu 0, calling hook 0xffffffff00131800 (elf_build_id) at level 0x4fffe, flags 0x1 [00000.000] 00000:00000> INIT: cpu 0, calling hook 0xffffffff001319a0 (version) at level 0x4ffff, flags 0x1 [00000.000] 00000:00000> version: [00000.000] 00000:00000> arch: x86 [00000.000] 00000:00000> platform: XXX [00000.000] 00000:00000> target: XXX [00000.000] 00000:00000> project: x64 [00000.000] 00000:00000> buildid: git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00000.000] 00000:00000> ELF build ID: 18da1e2da9d3a021 [00000.000] 00000:00000> initializing heap [00000.000] 00000:00000> INIT: cpu 0, calling hook 0xffffffff001020d0 (console) at level 0x50000, flags 0x1 [00000.000] 00000:00000> INIT: cpu 0, calling hook 0xffffffff0019e860 (x86_resource_init) at level 0x50000, flags 0x1 [00000.000] 00000:00000> initializing vm [00000.000] 00000:00000> VM: reserving kernel region [0xffffffff00100000, 0xffffffff0024d000) flags 0x28 name 'kernel_code' [00000.000] 00000:00000> VM: reserving kernel region [0xffffffff0024d000, 0xffffffff00297000) flags 0x8 name 'kernel_rodata' [00000.000] 00000:00000> VM: reserving kernel region [0xffffffff00297000, 0xffffffff0029e000) flags 0x18 name 'kernel_data' [00000.000] 00000:00000> VM: reserving kernel region [0xffffffff0029e000, 0xffffffff00334000) flags 0x18 name 'kernel_bss' [00000.000] 00000:00000> INIT: cpu 0, calling hook 0xffffffff0019f680 (display_memtype) at level 0x60001, flags 0x1 [00000.000] 00000:00000> INIT: cpu 0, calling hook 0xffffffff001a3760 (acpi_tables) at level 0x60001, flags 0x1 [00000.000] 00000:00000> INIT: cpu 0, calling hook 0xffffffff0019cc80 (hpet) at level 0x60002, flags 0x1 [00000.000] 00000:00000> INIT: cpu 0, calling hook 0xffffffff0019d1d0 (apic) at level 0x60002, flags 0x1 [00000.000] 00000:00000> x2APIC enabled [00000.000] 00000:00000> INIT: cpu 0, calling hook 0xffffffff001cd4f0 (system_topology_init) at level 0x60002, flags 0x1 [00000.000] 00000:00000> WARNING: unable to find any cache levels. [00000.000] 00000:00000> WARNING: unable to find any cache levels. [00000.000] 00000:00000> Could not find SRAT table. ACPICA returned: 5 [00000.000] 00000:00000> INIT: cpu 0, calling hook 0xffffffff001a2610 (timer) at level 0x60003, flags 0x1 [00000.000] 00000:00000> pvclock: Clocksource is stable [00000.000] 00000:00000> HPET frequency: 100000 ticks/ms [00000.000] 00000:00000> pvclock: Fetching TSC frequency [00000.000] 00000:00000> TSC frequency: 2299802 ticks/ms [00000.443] 00000:00000> timer features: constant_tsc 1 invariant_tsc 1 tsc_deadline 1 [00000.443] 00000:00000> Using TSC as wallclock [00000.443] 00000:00000> INIT: cpu 0, calling hook 0xffffffff002344e0 (percpu_heap_init) at level 0x60003, flags 0x1 [00000.443] 00000:00000> initializing kernel [00000.443] 00000:00000> initializing mp [00000.443] 00000:00000> INIT: cpu 0, calling hook 0xffffffff00120a10 (global_prng_thread_safe) at level 0x7ffff, flags 0x1 [00000.443] 00000:00000> creating bootstrap completion thread [00000.443] 00000:00000> top of bootstrap2() [00000.443] 00000:00000> INIT: cpu 0, calling hook 0xffffffff00144ff0 (libobject) at level 0x80000, flags 0x1 [00000.443] 00000:00000> OOM: started thread [00000.443] 00000:00000> INIT: cpu 0, calling hook 0xffffffff001a89c0 (lockdep) at level 0x80000, flags 0x1 [00000.443] 00000:00000> INIT: cpu 0, calling hook 0xffffffff002306b0 (dpc) at level 0x80000, flags 0x1 [00000.443] 00000:00000> Processor Model Info: type 0 family 0x6 model 0xf stepping 0 [00000.443] 00000:00000> display_family 0x6 display_model 0x3f [00000.443] 00000:00000> Vendor: Intel [00000.443] 00000:00000> Microarch: Haswell [00000.443] 00000:00000> F/M/S: 6/3f/0 [00000.443] 00000:00000> patch_level: 0 [00000.443] 00000:00000> Brand: Intel(R) Xeon(R) CPU @ 2.30GHz [00000.443] 00000:00000> Features: fpu sse sse2 sse3 ssse3 sse4.1 sse4.2 mmx avx avx2 fxsr pcid xsave aesni clflush [00000.443] 00000:00000> fsgsbase tsc_adj smep erms rdrand syscall nx rdtscp tsc_deadline x2apic hypervisor [00000.443] 00000:00000> Properties: meltdown l1tf pcid_good [00000.443] 00000:00000> initializing platform [00000.443] 00000:00000> INIT: cpu 0, calling hook 0xffffffff001c5fd0 (x86_perfmon) at level 0x90000, flags 0x1 [00000.443] 00000:00000> x86_perfmon_init_once:454: perfmon: unexpected programmable counter width 0 in cpuid.0AH [00000.444] 00000:00000> UART: started IRQ driven RX [00000.444] 00000:00000> UART: started IRQ driven TX [00000.444] 00000:00000> cpu topology: [00000.444] 00000:00000> 0: apic id 0x0 BSP [00000.444] 00000:00000> 1: apic id 0x1 [00000.444] 00000:00000> 2: apic id 0x2 [00000.444] 00000:00000> 3: apic id 0x3 [00000.444] 00000:00000> Found 4 cpus [00000.445] 00000:00000> booting apic ids: 0x1 0x2 0x3 [00000.457] 00000:00000> entering scheduler on cpu 1 [00000.457] 00000:00000> entering scheduler on cpu 2 [00000.457] 00000:00000> entering scheduler on cpu 3 [00000.460] 00000:00000> smbios: manufacturer="QEMU" product="Standard PC (Q35 + ICH9, 2009)" [00000.460] 00000:00000> initializing target [00000.460] 00000:00000> INIT: cpu 0, calling hook 0xffffffff001a1630 (x86_pcie_init) at level 0xa0000, flags 0x1 [00000.460] 00000:00000> moving to last init level [00000.460] 00000:00000> INIT: cpu 0, calling hook 0xffffffff00130ec0 (debuglog) at level 0xb0000, flags 0x1 [00000.460] 00000:00000> INIT: cpu 0, calling hook 0xffffffff0018c630 (kcounters) at level 0xb0000, flags 0x1 [00000.460] 00000:00000> INIT: cpu 0, calling hook 0xffffffff00102610 (kernel_shell) at level 0xc0000, flags 0x1 [00000.460] 00000:00000> INIT: cpu 0, calling hook 0xffffffff0022ce80 (ktrace) at level 0xc0000, flags 0x1 [00000.822] 00000:00000> ktrace: buffer at 0xffffff945b29e000 (33554432 bytes) [00000.822] 00000:00000> INIT: cpu 0, calling hook 0xffffffff00247b80 (userboot) at level 0xc0000, flags 0x1 [00000.822] 00000:00000> userboot: ramdisk 0x304000 @ 0xffffff8000407000 [00000.837] 00000:00000> userboot: userboot rodata 0 @ [0x150e01441000,0x150e01443000) [00000.837] 00000:00000> userboot: userboot code 0x2000 @ [0x150e01443000,0x150e01447000) [00000.837] 00000:00000> userboot: vdso/full rodata 0 @ [0x150e01447000,0x150e0144d000) [00000.837] 00000:00000> userboot: vdso/full code 0x6000 @ [0x150e0144d000,0x150e0144e000) [00000.837] 00000:00000> userboot: entry point @ 0x150e01443b10 [00000.860] 01034:01041> userboot: option "userboot=bin/core-tests" [00000.861] 01034:01041> userboot: option "userboot.shutdown=" [00000.861] 01034:01041> userboot: option "/b/s/w/ir/multiboot.bin=" [00000.861] 01034:01041> userboot: option "kernel.halt-on-panic=true" [00000.861] 01034:01041> userboot: option "devmgr.suspend-timeout-debug=true" [00000.861] 01034:01041> userboot: option "TERM=dumb" [00000.861] 01034:01041> userboot: option "kernel.serial=legacy" [00000.861] 01034:01041> userboot: option "multiboot.boot_loader_name=qemu" [00000.870] 01034:01041> userboot: searching bootfs for 'bin/core-tests' [00000.870] 01034:01041> userboot: 'bin/core-tests' has PT_INTERP "lib/ld.so.1" [00000.870] 01034:01041> userboot: searching bootfs for 'lib/ld.so.1' [00000.870] 01034:01041> userboot: userboot: loaded lib/ld.so.1 at 0x47ed1541c000, entry point 0x47ed15466ef8 [00000.870] 01034:01041> userboot: userboot: loaded vDSO at 0x4b177ac2b000, entry point 0x4b177ac31842 [00000.870] 01034:01041> userboot: process bin/core-tests started. [00000.870] 01034:01041> userboot: waiting for loader-service requests... [00000.920] 01034:01041> userboot: searching bootfs for 'lib/libfdio.so' [00000.921] 01034:01041> userboot: searching bootfs for 'lib/libunittest.so' [00000.921] 01034:01041> userboot: searching bootfs for 'lib/libmini-process.so' [00000.921] 01034:01041> userboot: searching bootfs for 'lib/libinspector.so' [00000.937] 01034:01041> userboot: searching bootfs for 'lib/libbacktrace.so' [00000.938] 01048:01051> {{{reset}}} [00000.938] 01048:01051> {{{module:0:<application>:elf:025704a287dc082a}}} [00000.938] 01048:01051> {{{mmap:0x71007ef6e000:0x50000:load:0:r:0}}} [00000.938] 01048:01051> {{{mmap:0x71007efbe000:0x162000:load:0:rx:0x50000}}} [00000.938] 01048:01051> {{{mmap:0x71007f120000:0x9000:load:0:rw:0x1b2000}}} [00000.938] 01048:01051> {{{mmap:0x71007f129000:0x2000:load:0:rw:0x1bb000}}} [00000.938] 01048:01051> dso: id=025704a287dc082a base=0x000071007ef6e000 name=<application> [00000.938] 01048:01051> {{{module:0x3:libfdio.so:elf:282003844db08664}}} [00000.938] 01048:01051> {{{mmap:0x1b94d162a000:0xc000:load:0x3:r:0}}} [00000.938] 01048:01051> {{{mmap:0x1b94d1636000:0x1c000:load:0x3:rx:0xc000}}} [00000.938] 01048:01051> {{{mmap:0x1b94d1652000:0x2000:load:0x3:rw:0x28000}}} [00000.938] 01048:01051> {{{mmap:0x1b94d1654000:0x2000:load:0x3:rw:0x2a000}}} [00000.938] 01048:01051> dso: id=282003844db08664 base=0x00001b94d162a000 name=libfdio.so [00000.938] 01048:01051> {{{module:0x4:libunittest.so:elf:1c101fe9cf91e4a8}}} [00000.938] 01048:01051> {{{mmap:0x4bb7b864000:0x4000:load:0x4:r:0}}} [00000.938] 01048:01051> {{{mmap:0x4bb7b868000:0x3000:load:0x4:rx:0x4000}}} [00000.938] 01048:01051> {{{mmap:0x4bb7b86b000:0x1000:load:0x4:rw:0x7000}}} [00000.938] 01048:01051> {{{mmap:0x4bb7b86c000:0x2000:load:0x4:rw:0x8000}}} [00000.938] 01048:01051> dso: id=1c101fe9cf91e4a8 base=0x000004bb7b864000 name=libunittest.so [00000.938] 01048:01051> {{{module:0x2:<vDSO>:elf:1b7804b5b4b7d4e9}}} [00000.938] 01048:01051> {{{mmap:0x4b177ac2b000:0x6000:load:0x2:r:0}}} [00000.938] 01048:01051> {{{mmap:0x4b177ac31000:0x1000:load:0x2:rx:0x6000}}} [00000.938] 01048:01051> dso: id=1b7804b5b4b7d4e9 base=0x00004b177ac2b000 name=<vDSO> [00000.938] 01048:01051> {{{module:0x5:libmini-process.so:elf:961c9ec3b6f98782}}} [00000.938] 01048:01051> {{{mmap:0x55639fd6b000:0x2000:load:0x5:r:0}}} [00000.938] 01048:01051> {{{mmap:0x55639fd6d000:0x2000:load:0x5:rx:0x2000}}} [00000.938] 01048:01051> {{{mmap:0x55639fd6f000:0x1000:load:0x5:rw:0x4000}}} [00000.938] 01048:01051> {{{mmap:0x55639fd70000:0x1000:load:0x5:rw:0x5000}}} [00000.938] 01048:01051> dso: id=961c9ec3b6f98782 base=0x000055639fd6b000 name=libmini-process.so [00000.938] 01048:01051> {{{module:0x6:libinspector.so:elf:d2d8950b17dc8a15}}} [00000.938] 01048:01051> {{{mmap:0x76574ab46000:0x6000:load:0x6:r:0}}} [00000.938] 01048:01051> {{{mmap:0x76574ab4c000:0x15000:load:0x6:rx:0x6000}}} [00000.938] 01048:01051> {{{mmap:0x76574ab61000:0x1000:load:0x6:rw:0x1b000}}} [00000.938] 01048:01051> {{{mmap:0x76574ab62000:0xf000:load:0x6:rw:0x1c000}}} [00000.938] 01048:01051> dso: id=d2d8950b17dc8a15 base=0x000076574ab46000 name=libinspector.so [00000.938] 01048:01051> {{{module:0x7:libbacktrace.so:elf:4b017048bddb2a3c}}} [00000.938] 01048:01051> {{{mmap:0x2195f91a4000:0x2000:load:0x7:r:0}}} [00000.938] 01048:01051> {{{mmap:0x2195f91a6000:0xb000:load:0x7:rx:0x2000}}} [00000.938] 01048:01051> {{{mmap:0x2195f91b1000:0x1000:load:0x7:rw:0xd000}}} [00000.938] 01048:01051> dso: id=4b017048bddb2a3c base=0x00002195f91a4000 name=libbacktrace.so [00000.938] 01048:01051> {{{module:0x1:libc.so:elf:015cc27bccc48dd1}}} [00000.938] 01048:01051> {{{mmap:0x47ed1541c000:0x44000:load:0x1:r:0}}} [00000.938] 01048:01051> {{{mmap:0x47ed15460000:0x56000:load:0x1:rx:0x44000}}} [00000.938] 01048:01051> {{{mmap:0x47ed154b6000:0x2000:load:0x1:rw:0x9a000}}} [00000.938] 01048:01051> {{{mmap:0x47ed154b8000:0x3000:load:0x1:rw:0x9c000}}} [00000.938] 01048:01051> dso: id=015cc27bccc48dd1 base=0x000047ed1541c000 name=libc.so [00001.129] 01048:01051> TEST [00001.129] 01048:01051> CASE resource_tests [STARTED] [00001.129] 01048:01051> probe_address_space [RUNNING] [00001.129] 01048:01051> [PASSED] (0 ms) [00001.129] 01048:01051> TestBasicActions [RUNNING] [00001.129] 01048:01051> [PASSED] (0 ms) [00001.129] 01048:01051> TestExclusiveShared [RUNNING] [00001.129] 01048:01051> [PASSED] (0 ms) [00001.129] 01048:01051> TestSharedExclusive [RUNNING] [00001.129] 01048:01051> [PASSED] (0 ms) [00001.129] 01048:01051> TestInvalidArgs [RUNNING] [00001.129] 01048:01051> [PASSED] (0 ms) [00001.129] 01048:01051> TestVmoCreation [RUNNING] [00001.129] 01048:01051> [PASSED] (0 ms) [00001.129] 01048:01051> TestVmoCreationSmaller [RUNNING] [00001.129] 01048:01051> [PASSED] (0 ms) [00001.129] 01048:01051> TestVmoCreationUnaligned [RUNNING] [00001.129] 01048:01051> [PASSED] (0 ms) [00001.129] 01048:01051> TestVmoReplaceAsExecutable [RUNNING] [00001.130] 01048:01051> [PASSED] (0 ms) [00001.130] 01048:01051> test_ioports [RUNNING] [00001.131] 01048:01051> [PASSED] (1 ms) [00001.131] 01048:01051> CASE resource_tests [PASSED] [00001.131] 01048:01051> CASE profile_tests [STARTED] [00001.131] 01048:01051> make_profile_fails [RUNNING] [00001.131] 01048:01051> [PASSED] (0 ms) [00001.131] 01048:01051> change_priority_via_profile [RUNNING] [00001.132] 01048:01051> [PASSED] (0 ms) [00001.132] 01048:01051> CASE profile_tests [PASSED] [00001.132] 01048:01051> CASE interrupt_tests [STARTED] [00001.132] 01048:01051> interrupt_test [RUNNING] [00001.132] 01048:01051> [PASSED] (0 ms) [00001.132] 01048:01051> interrupt_port_bound_test [RUNNING] [00001.132] 01048:01051> [PASSED] (0 ms) [00001.132] 01048:01051> interrupt_port_non_bindable_test [RUNNING] [00001.132] 01048:01051> [PASSED] (0 ms) [00001.132] 01048:01051> interrupt_suspend_test [RUNNING] [00001.277] 01048:01051> [PASSED] (145 ms) [00001.278] 01048:01051> interrupt_bind_vcpu_test [RUNNING] [00001.278] 01048:01051> Guest creation not supported [00001.278] 01048:01051> [PASSED] (0 ms) [00001.278] 01048:01051> interrupt_bind_vcpu_not_supported_test [RUNNING] [00001.278] 01048:01051> Guest creation not supported [00001.278] 01048:01051> [PASSED] (0 ms) [00001.278] 01048:01051> interrupt_bind_vcpu_already_bound_test [RUNNING] [00001.278] 01048:01051> Guest creation not supported [00001.278] 01048:01051> [PASSED] (0 ms) [00001.278] 01048:01051> interrupt_bind_vcpu_multiple_guests_test [RUNNING] [00001.278] 01048:01051> Guest creation not supported [00001.278] 01048:01051> [PASSED] (0 ms) [00001.278] 01048:01051> CASE interrupt_tests [PASSED] [00001.278] 01048:01051> CASE vmo_signal_tests [STARTED] [00001.278] 01048:01051> vmo_signal_sanity_test [RUNNING] [00001.278] 01048:01051> [PASSED] (0 ms) [00001.278] 01048:01051> vmo_child_signal_clone_test [RUNNING] [00001.278] 01048:01051> [PASSED] (0 ms) [00001.278] 01048:01051> vmo_child_signal_map_test [RUNNING] [00001.278] 01048:01051> [PASSED] (0 ms) [00001.278] 01048:01051> CASE vmo_signal_tests [PASSED] [00001.278] 01048:01051> CASE vmar_tests [STARTED] [00001.278] 01048:01051> destroy_root_test [RUNNING] [00001.278] 01048:01051> [PASSED] (0 ms) [00001.278] 01048:01051> basic_allocate_test [RUNNING] [00001.278] 01048:01051> [PASSED] (0 ms) [00001.278] 01048:01051> allocate_oob_test [RUNNING] [00001.278] 01048:01051> [PASSED] (0 ms) [00001.278] 01048:01051> allocate_unsatisfiable_test [RUNNING] [00001.278] 01048:01051> [PASSED] (0 ms) [00001.279] 01048:01051> destroyed_vmar_test [RUNNING] [00001.279] 01048:01051> [PASSED] (0 ms) [00001.279] 01048:01051> map_over_destroyed_test [RUNNING] [00001.279] 01048:01051> [PASSED] (0 ms) [00001.279] 01048:01051> map_in_compact_test [RUNNING] [00001.279] 01048:01051> [PASSED] (0 ms) [00001.279] 01048:01051> overmapping_test [RUNNING] [00001.415] 01048:01051> [PASSED] (135 ms) [00001.415] 01048:01051> invalid_args_test [RUNNING] [00001.415] 01048:01051> [PASSED] (0 ms) [00001.415] 01048:01051> unaligned_len_test [RUNNING] [00001.415] 01048:01051> [PASSED] (0 ms) [00001.415] 01048:01051> unaligned_len_map_test [RUNNING] [00001.415] 01048:01051> [PASSED] (0 ms) [00001.415] 01048:01051> rights_drop_test [RUNNING] [00001.415] 01048:01051> [PASSED] (0 ms) [00001.415] 01048:01051> protect_test [RUNNING] [00001.415] 01048:01051> [PASSED] (0 ms) [00001.415] 01048:01051> nested_region_perms_test [RUNNING] [00001.415] 01048:01051> [PASSED] (0 ms) [00001.415] 01048:01051> object_info_test [RUNNING] [00001.415] 01048:01051> [PASSED] (0 ms) [00001.415] 01048:01051> unmap_split_test [RUNNING] [00001.415] 01048:01051> [PASSED] (0 ms) [00001.415] 01048:01051> unmap_multiple_test [RUNNING] [00001.416] 01048:01051> [PASSED] (0 ms) [00001.416] 01048:01051> unmap_base_not_mapped_test [RUNNING] [00001.489] 01048:01051> [PASSED] (72 ms) [00001.489] 01048:01051> map_specific_overwrite_test [RUNNING] [00001.489] 01048:01051> [PASSED] (0 ms) [00001.489] 01048:01051> protect_split_test [RUNNING] [00001.489] 01048:01051> [PASSED] (0 ms) [00001.489] 01048:01051> protect_multiple_test [RUNNING] [00001.489] 01048:01051> [PASSED] (0 ms) [00001.489] 01048:01051> protect_over_demand_paged_test [RUNNING] [00001.521] 01048:01051> [PASSED] (31 ms) [00001.521] 01048:01051> protect_large_uncommitted_test [RUNNING] [00001.531] 01048:01051> [PASSED] (9 ms) [00001.531] 01048:01051> unmap_large_uncommitted_test [RUNNING] [00001.540] 01048:01285> PageFault: 1029302 free pages [00001.540] 01048:01285> [00001.540] 01048:01285> ZIRCON KERNEL PANIC [00001.540] 01048:01285> Lock validation failed for thread 0xffffff8000759b08 pid 1048 tid 1285 (bin/core-tests:vmar_test_addr): [00001.540] 01048:01285> Reason: Already Acquired [00001.540] 01048:01285> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00001.540] 01048:01285> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00001.540] 01048:01285> caller=0xffffffff0014b65b frame=0xffffff945d2a8d60 [00001.540] 01048:01285> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00001.540] 01048:01285> [00001.540] 01048:01285> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00001.540] 01048:01285> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00001.540] 01048:01285> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00001.540] 01048:01285> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00001.540] 01048:01285> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00001.540] 01048:01285> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00001.540] 01048:01285> bt#00: 0xffffffff0014b65b [00001.540] 01048:01285> bt#01: 0xffffffff0014ba8f [00001.540] 01048:01285> bt#02: 0xffffffff0013732e [00001.540] 01048:01285> bt#03: 0xffffffff001f6db4 [00001.540] 01048:01285> bt#04: 0xffffffff001bd5fe [00001.540] 01048:01285> bt#05: 0xffffffff001bd24b [00001.540] 01048:01285> bt#06: end [00001.540] 01048:01285> {{{bt:0:0xffffffff0014b65b}}} [00001.540] 01048:01285> {{{bt:1:0xffffffff0014ba8f}}} [00001.540] 01048:01285> {{{bt:2:0xffffffff0013732e}}} [00001.540] 01048:01285> {{{bt:3:0xffffffff001f6db4}}} [00001.540] 01048:01285> {{{bt:4:0xffffffff001bd5fe}}} [00001.540] 01048:01285> {{{bt:5:0xffffffff001bd24b}}} [00001.540] 01048:01285> [00001.657] 01048:01288> PageFault: 1029302 free pages [00001.657] 01048:01288> [00001.657] 01048:01288> ZIRCON KERNEL PANIC [00001.657] 01048:01288> Lock validation failed for thread 0xffffff8000759b08 pid 1048 tid 1288 (bin/core-tests:vmar_test_addr): [00001.657] 01048:01288> Reason: Already Acquired [00001.657] 01048:01288> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00001.657] 01048:01288> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00001.657] 01048:01288> caller=0xffffffff0014b65b frame=0xffffff945d2a8d60 [00001.657] 01048:01288> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00001.657] 01048:01288> [00001.657] 01048:01288> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00001.657] 01048:01288> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00001.657] 01048:01288> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00001.657] 01048:01288> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00001.657] 01048:01288> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00001.657] 01048:01288> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00001.657] 01048:01288> bt#00: 0xffffffff0014b65b [00001.657] 01048:01288> bt#01: 0xffffffff0014ba8f [00001.657] 01048:01288> bt#02: 0xffffffff0013732e [00001.657] 01048:01288> bt#03: 0xffffffff001f6db4 [00001.657] 01048:01288> bt#04: 0xffffffff001bd5fe [00001.657] 01048:01288> bt#05: 0xffffffff001bd24b [00001.657] 01048:01288> bt#06: end [00001.657] 01048:01288> {{{bt:0:0xffffffff0014b65b}}} [00001.657] 01048:01288> {{{bt:1:0xffffffff0014ba8f}}} [00001.657] 01048:01288> {{{bt:2:0xffffffff0013732e}}} [00001.657] 01048:01288> {{{bt:3:0xffffffff001f6db4}}} [00001.657] 01048:01288> {{{bt:4:0xffffffff001bd5fe}}} [00001.657] 01048:01288> {{{bt:5:0xffffffff001bd24b}}} [00001.657] 01048:01288> [00001.772] 01048:01291> PageFault: 1029302 free pages [00001.772] 01048:01291> [00001.772] 01048:01291> ZIRCON KERNEL PANIC [00001.772] 01048:01291> Lock validation failed for thread 0xffffff8000759b08 pid 1048 tid 1291 (bin/core-tests:vmar_test_addr): [00001.772] 01048:01291> Reason: Already Acquired [00001.772] 01048:01291> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00001.772] 01048:01291> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00001.772] 01048:01291> caller=0xffffffff0014b65b frame=0xffffff945d2a8d60 [00001.772] 01048:01291> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00001.772] 01048:01291> [00001.772] 01048:01291> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00001.772] 01048:01291> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00001.772] 01048:01291> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00001.772] 01048:01291> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00001.772] 01048:01291> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00001.772] 01048:01291> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00001.772] 01048:01291> bt#00: 0xffffffff0014b65b [00001.772] 01048:01291> bt#01: 0xffffffff0014ba8f [00001.772] 01048:01291> bt#02: 0xffffffff0013732e [00001.772] 01048:01291> bt#03: 0xffffffff001f6db4 [00001.772] 01048:01291> bt#04: 0xffffffff001bd5fe [00001.772] 01048:01291> bt#05: 0xffffffff001bd24b [00001.772] 01048:01291> bt#06: end [00001.772] 01048:01291> {{{bt:0:0xffffffff0014b65b}}} [00001.772] 01048:01291> {{{bt:1:0xffffffff0014ba8f}}} [00001.772] 01048:01291> {{{bt:2:0xffffffff0013732e}}} [00001.772] 01048:01291> {{{bt:3:0xffffffff001f6db4}}} [00001.772] 01048:01291> {{{bt:4:0xffffffff001bd5fe}}} [00001.772] 01048:01291> {{{bt:5:0xffffffff001bd24b}}} [00001.772] 01048:01291> [00001.887] 01048:01051> [PASSED] (355 ms) [00001.887] 01048:01051> partial_unmap_and_read [RUNNING] [00001.887] 01048:01051> [PASSED] (0 ms) [00001.887] 01048:01051> partial_unmap_and_write [RUNNING] [00001.887] 01048:01051> [PASSED] (0 ms) [00001.887] 01048:01051> partial_unmap_with_vmar_offset [RUNNING] [00001.887] 01048:01051> [PASSED] (0 ms) [00001.887] 01048:01051> CASE vmar_tests [PASSED] [00001.887] 01048:01051> CASE ticks_tests [STARTED] [00001.887] 01048:01051> elapsed_time_using_ticks [RUNNING] [00001.887] 01048:01051> [PASSED] (0 ms) [00001.887] 01048:01051> CASE ticks_tests [PASSED] [00001.887] 01048:01051> CASE threads_tests [STARTED] [00001.887] 01048:01051> TestBasics [RUNNING] [00001.988] 01048:01051> [PASSED] (100 ms) [00001.988] 01048:01051> TestInvalidRights [RUNNING] [00001.988] 01048:01051> [PASSED] (0 ms) [00001.988] 01048:01051> TestDetach [RUNNING] [00001.988] 01048:01051> [PASSED] (0 ms) [00001.988] 01048:01051> TestLongNameSucceeds [RUNNING] [00002.011] 01048:01051> [PASSED] (22 ms) [00002.011] 01048:01051> TestThreadStartOnInitialThread [RUNNING] [00002.019] 01048:01051> [PASSED] (8 ms) [00002.019] 01048:01051> TestThreadStartWithZeroInstructionPointer [RUNNING] [00002.020] 01048:01051> [00002.020] 01048:01051> ZIRCON KERNEL PANIC [00002.020] 01048:01051> Lock validation failed for thread 0xffffff800074e978 pid 1048 tid 1051 (bin/core-tests:bin/core-tests): [00002.020] 01048:01051> Reason: Out Of Order [00002.020] 01048:01051> Bad lock: name=lockdep::LockClass<SoloDispatcher<ThreadDispatcher, 316111, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00002.020] 01048:01051> Conflict: name=lockdep::LockClass<SoloDispatcher<ProcessDispatcher, 447439, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00002.020] 01048:01051> caller=0xffffffff0016498b frame=0xffffff945a283ec0 [00002.020] 01048:01051> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00002.020] 01048:01051> [00002.020] 01048:01051> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00002.020] 01048:01051> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00002.020] 01048:01051> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00002.020] 01048:01051> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00002.020] 01048:01051> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00002.020] 01048:01051> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00002.020] 01048:01051> bt#00: 0xffffffff0016498b [00002.020] 01048:01051> bt#01: 0xffffffff00159c5c [00002.020] 01048:01051> bt#02: 0xffffffff0015a48d [00002.020] 01048:01051> bt#03: 0xffffffff00217a26 [00002.020] 01048:01051> bt#04: 0xffffffff00220e9a [00002.020] 01048:01051> bt#05: 0xffffffff001ce98e [00002.020] 01048:01051> bt#06: end [00002.020] 01048:01051> {{{bt:0:0xffffffff0016498b}}} [00002.020] 01048:01051> {{{bt:1:0xffffffff00159c5c}}} [00002.020] 01048:01051> {{{bt:2:0xffffffff0015a48d}}} [00002.020] 01048:01051> {{{bt:3:0xffffffff00217a26}}} [00002.020] 01048:01051> {{{bt:4:0xffffffff00220e9a}}} [00002.020] 01048:01051> {{{bt:5:0xffffffff001ce98e}}} [00002.020] 01048:01051> [00002.020] 01048:01051> [PASSED] (1 ms) [00002.020] 01048:01051> TestKillBusyThread [RUNNING] [00002.238] 01048:01051> [PASSED] (218 ms) [00002.238] 01048:01051> TestKillSleepThread [RUNNING] [00002.340] 01048:01051> [PASSED] (101 ms) [00002.340] 01048:01051> TestKillWaitThread [RUNNING] [00002.441] 01048:01051> [PASSED] (101 ms) [00002.441] 01048:01051> TestNonstartedThread [RUNNING] [00002.444] 01048:01051> [PASSED] (2 ms) [00002.444] 01048:01051> TestThreadKillsItself [RUNNING] [00002.456] 01048:01051> [PASSED] (12 ms) [00002.456] 01048:01051> TestInfoTaskStatsFails [RUNNING] [00002.557] 01048:01051> [PASSED] (100 ms) [00002.557] 01048:01051> TestResumeSuspended [RUNNING] [00002.667] 01048:01051> [PASSED] (109 ms) [00002.667] 01048:01051> TestSuspendSleeping [RUNNING] [00002.768] 01048:01051> [PASSED] (100 ms) [00002.768] 01048:01051> TestSuspendChannelCall [RUNNING] [00002.775] 01048:01051> [PASSED] (7 ms) [00002.775] 01048:01051> TestSuspendPortCall [RUNNING] [00002.977] 01048:01051> [PASSED] (201 ms) [00002.977] 01048:01051> TestSuspendStopsThread [RUNNING] [00003.028] 01048:01051> [PASSED] (50 ms) [00003.028] 01048:01051> TestSuspendMultiple [RUNNING] [00003.029] 01048:01051> [PASSED] (1 ms) [00003.029] 01048:01051> TestSuspendSelf [RUNNING] [00003.029] 01048:01051> [PASSED] (0 ms) [00003.029] 01048:01051> TestKillSuspendedThread [RUNNING] [00003.035] 01048:01051> [PASSED] (6 ms) [00003.035] 01048:01051> TestStartSuspendedThread [RUNNING] [00003.057] 01048:01051> [PASSED] (21 ms) [00003.057] 01048:01051> TestStartSuspendedAndResumedThread [RUNNING] [00003.057] 01048:01051> [PASSED] (0 ms) [00003.057] 01048:01051> TestSuspendSingleWaitAsyncSignalDelivery [RUNNING] [00003.072] 01048:01051> [PASSED] (14 ms) [00003.072] 01048:01051> TestSuspendRepeatingWaitAsyncSignalDelivery [RUNNING] [00003.080] 01048:01051> [PASSED] (8 ms) [00003.080] 01048:01051> TestReadingGeneralRegisterState [RUNNING] [00003.181] 01048:01051> [PASSED] (100 ms) [00003.181] 01048:01051> TestWritingGeneralRegisterState [RUNNING] [00003.282] 01048:01051> [PASSED] (100 ms) [00003.282] 01048:01051> TestThreadLocalRegisterState [RUNNING] [00003.383] 01048:01051> [PASSED] (100 ms) [00003.383] 01048:01051> TestNoncanonicalRipAddress [RUNNING] [00003.484] 01048:01051> [PASSED] (101 ms) [00003.484] 01048:01051> TestWritingArmFlagsRegister [RUNNING] [00003.484] 01048:01051> [PASSED] (0 ms) [00003.484] 01048:01051> CASE threads_tests [PASSED] [00003.484] 01048:01051> CASE sync_mutex_tests [STARTED] [00003.484] 01048:01051> test_mutexes [RUNNING] [00003.564] 01048:01051> [PASSED] (80 ms) [00003.564] 01048:01051> test_try_mutexes [RUNNING] [00003.637] 01048:01051> [PASSED] (72 ms) [00003.637] 01048:01051> test_timeout_elapsed [RUNNING] [00004.138] 01048:01051> [PASSED] (501 ms) [00004.138] 01048:01051> CASE sync_mutex_tests [PASSED] [00004.138] 01048:01051> CASE sync_condition_tests [STARTED] [00004.138] 01048:01051> Condition::condition_test [RUNNING] [00004.163] 01048:01051> [PASSED] (24 ms) [00004.163] 01048:01051> Condition::condition_timeout_test [RUNNING] [00004.171] 01048:01051> [PASSED] (7 ms) [00004.171] 01048:01051> CASE sync_condition_tests [PASSED] [00004.171] 01048:01051> CASE sync_completion_tests [STARTED] [00004.171] 01048:01051> test_initializer [RUNNING] [00004.171] 01048:01051> [PASSED] (0 ms) [00004.171] 01048:01051> test_completions [RUNNING] [00004.193] 01048:01051> [PASSED] (22 ms) [00004.193] 01048:01051> test_timeout [RUNNING] [00004.194] 01048:01051> [PASSED] (0 ms) [00004.194] 01048:01051> CASE sync_completion_tests [PASSED] [00004.194] 01048:01051> CASE sync_completion_tests [STARTED] [00004.194] 01048:01051> test_initializer [RUNNING] [00004.194] 01048:01051> [PASSED] (0 ms) [00004.194] 01048:01051> test_completions [RUNNING] [00004.253] 01048:01051> [PASSED] (59 ms) [00004.253] 01048:01051> test_timeout [RUNNING] [00005.391] 01048:01051> [PASSED] (1137 ms) [00005.391] 01048:01051> test_signal_requeue [RUNNING] [00005.420] 01048:01051> [PASSED] (28 ms) [00005.420] 01048:01051> test_completion_signaled [RUNNING] [00005.420] 01048:01051> [PASSED] (0 ms) [00005.420] 01048:01051> CASE sync_completion_tests [PASSED] [00005.420] 01048:01051> CASE stack_tests [STARTED] [00005.420] 01048:01051> main_thread_stack_tests [RUNNING] [00005.420] 01048:01051> [PASSED] (0 ms) [00005.420] 01048:01051> other_thread_stack_tests [RUNNING] [00005.455] 01048:01051> [PASSED] (35 ms) [00005.455] 01048:01051> CASE stack_tests [PASSED] [00005.455] 01048:01051> CASE tls_tests [STARTED] [00005.455] 01048:01051> tls_test [RUNNING] [00007.513] 01048:01051> [PASSED] (2058 ms) [00007.513] 01048:01051> CASE tls_tests [PASSED] [00007.513] 01048:01051> CASE pthread_barrier_tests [STARTED] [00007.513] 01048:01051> test_barrier [RUNNING] [00007.669] 01048:01051> [PASSED] (155 ms) [00007.669] 01048:01051> CASE pthread_barrier_tests [PASSED] [00007.669] 01048:01051> CASE pthread_tests [STARTED] [00007.669] 01048:01051> pthread_test [RUNNING] [00010.795] 01048:01051> [PASSED] (3125 ms) [00010.795] 01048:01051> pthread_self_main_thread_test [RUNNING] [00010.795] 01048:01051> [PASSED] (0 ms) [00010.795] 01048:01051> pthread_big_stack_size [RUNNING] [00010.814] 01048:01051> [PASSED] (18 ms) [00010.814] 01048:01051> pthread_getstack_main_thread [RUNNING] [00010.814] 01048:01051> [PASSED] (0 ms) [00010.814] 01048:01051> pthread_getstack_other_thread [RUNNING] [00010.814] 01048:01051> [PASSED] (0 ms) [00010.814] 01048:01051> CASE pthread_tests [PASSED] [00010.814] 01048:01051> CASE process_tests [STARTED] [00010.814] 01048:01051> mini_process_sanity [RUNNING] [00010.823] 01048:01051> [PASSED] (9 ms) [00010.823] 01048:01051> process_start_fail [RUNNING] [00010.828] 01048:01051> [PASSED] (4 ms) [00010.828] 01048:01051> process_start_no_handle [RUNNING] [00010.828] 01048:01051> [PASSED] (0 ms) [00010.828] 01048:01051> process_not_killed_via_thread_close [RUNNING] [00010.836] 01048:01051> [PASSED] (7 ms) [00010.836] 01048:01051> process_not_killed_via_process_close [RUNNING] [00010.837] 01048:01051> [PASSED] (1 ms) [00010.838] 01048:01051> kill_process_via_thread_kill [RUNNING] [00010.839] 01048:01051> [PASSED] (1 ms) [00010.839] 01048:01051> kill_process_via_vmar_destroy [RUNNING] [00010.839] 02077:02079> PageFault: 1029100 free pages [00010.839] 02077:02079> [00010.839] 02077:02079> ZIRCON KERNEL PANIC [00010.839] 02077:02079> Lock validation failed for thread 0xffffff8000771390 pid 2077 tid 2079 (ttp:th): [00010.839] 02077:02079> Reason: Already Acquired [00010.839] 02077:02079> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00010.839] 02077:02079> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00010.839] 02077:02079> caller=0xffffffff0014b65b frame=0xffffff945d310d60 [00010.839] 02077:02079> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00010.839] 02077:02079> [00010.839] 02077:02079> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00010.839] 02077:02079> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00010.839] 02077:02079> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00010.839] 02077:02079> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00010.839] 02077:02079> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00010.839] 02077:02079> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00010.839] 02077:02079> bt#00: 0xffffffff0014b65b [00010.839] 02077:02079> bt#01: 0xffffffff0014ba8f [00010.839] 02077:02079> bt#02: 0xffffffff0013732e [00010.839] 02077:02079> bt#03: 0xffffffff001f6db4 [00010.839] 02077:02079> bt#04: 0xffffffff001bd5fe [00010.839] 02077:02079> bt#05: 0xffffffff001bd24b [00010.839] 02077:02079> bt#06: end [00010.839] 02077:02079> {{{bt:0:0xffffffff0014b65b}}} [00010.839] 02077:02079> {{{bt:1:0xffffffff0014ba8f}}} [00010.839] 02077:02079> {{{bt:2:0xffffffff0013732e}}} [00010.839] 02077:02079> {{{bt:3:0xffffffff001f6db4}}} [00010.839] 02077:02079> {{{bt:4:0xffffffff001bd5fe}}} [00010.839] 02077:02079> {{{bt:5:0xffffffff001bd24b}}} [00010.839] 02077:02079> [00010.843] 01048:01051> [PASSED] (4 ms) [00010.843] 01048:01051> kill_channel_handle_cycle [RUNNING] [00011.599] 01048:01051> [PASSED] (755 ms) [00011.599] 01048:01051> info_reflects_process_state [RUNNING] [00011.850] 01048:01051> [PASSED] (251 ms) [00011.850] 01048:01051> suspend [RUNNING] [00011.851] 01048:01051> [PASSED] (0 ms) [00011.851] 01048:01051> suspend_self [RUNNING] [00011.851] 01048:01051> [PASSED] (0 ms) [00011.851] 01048:01051> suspend_multiple_threads [RUNNING] [00011.876] 01048:01051> [PASSED] (25 ms) [00011.876] 01048:01051> suspend_before_creating_threads [RUNNING] [00011.877] 01048:01051> [PASSED] (0 ms) [00011.877] 01048:01051> suspend_before_starting_threads [RUNNING] [00011.891] 01048:01051> [PASSED] (14 ms) [00011.892] 01048:01051> suspend_process_then_thread [RUNNING] [00012.150] 01048:01051> [PASSED] (258 ms) [00012.150] 01048:01051> suspend_thread_then_process [RUNNING] [00012.409] 01048:01051> [PASSED] (258 ms) [00012.409] 01048:01051> suspend_thread_and_process_before_starting_process [RUNNING] [00012.661] 01048:01051> [PASSED] (251 ms) [00012.661] 01048:01051> suspend_twice [RUNNING] [00012.920] 01048:01051> [PASSED] (259 ms) [00012.920] 01048:01051> suspend_twice_before_creating_threads [RUNNING] [00013.180] 01048:01051> [PASSED] (259 ms) [00013.180] 01048:01051> suspend_with_dying_thread [RUNNING] [00013.189] 01048:01051> [PASSED] (9 ms) [00013.189] 01048:01051> create_and_kill_job_race_stress [RUNNING] [00014.200] 01048:01051> [PASSED] (1010 ms) [00014.200] 01048:01051> CASE process_tests [PASSED] [00014.200] 01048:01051> CASE port_tests [STARTED] [00014.200] 01048:01051> basic_test [RUNNING] [00014.200] 01048:01051> [PASSED] (0 ms) [00014.200] 01048:01051> queue_and_close_test [RUNNING] [00014.200] 01048:01051> [PASSED] (0 ms) [00014.200] 01048:01051> queue_too_many [RUNNING] [00014.201] 01048:01051> [PASSED] (1 ms) [00014.201] 01048:01051> async_wait_channel_test [RUNNING] [00014.203] 01048:01051> [PASSED] (1 ms) [00014.203] 01048:01051> async_wait_event_test_single [RUNNING] [00014.203] 01048:01051> [PASSED] (0 ms) [00014.203] 01048:01051> async_wait_event_test_repeat [RUNNING] [00014.203] 01048:01051> [PASSED] (0 ms) [00014.203] 01048:01051> async_wait_event_all_processed [RUNNING] [00014.248] 01048:01051> [PASSED] (44 ms) [00014.248] 01048:01051> async_wait_invalid_option [RUNNING] [00014.248] 01048:01051> [PASSED] (0 ms) [00014.248] 01048:01051> async_wait_close_order_1 [RUNNING] [00014.248] 01048:01051> [PASSED] (0 ms) [00014.248] 01048:01051> async_wait_close_order_2 [RUNNING] [00014.248] 01048:01051> [PASSED] (0 ms) [00014.248] 01048:01051> async_wait_close_order_3 [RUNNING] [00014.248] 01048:01051> [PASSED] (0 ms) [00014.248] 01048:01051> async_wait_close_order_4 [RUNNING] [00014.248] 01048:01051> [PASSED] (0 ms) [00014.248] 01048:01051> async_wait_close_order_5 [RUNNING] [00014.248] 01048:01051> [PASSED] (0 ms) [00014.248] 01048:01051> async_wait_close_order_6 [RUNNING] [00014.248] 01048:01051> [PASSED] (0 ms) [00014.248] 01048:01051> channel_pre_writes_test [RUNNING] [00014.248] 01048:01051> [PASSED] (0 ms) [00014.248] 01048:01051> cancel_event_key [RUNNING] [00014.248] 01048:01051> [PASSED] (0 ms) [00014.248] 01048:01051> cancel_event_key_after [RUNNING] [00014.248] 01048:01051> [PASSED] (0 ms) [00014.248] 01048:01051> threads_event [RUNNING] [00014.335] 01048:01051> [PASSED] (86 ms) [00014.335] 01048:01051> cancel_stress [RUNNING] [00019.659] 01048:01051> [PASSED] (5324 ms) [00019.660] 01048:01051> signal_close_stress [RUNNING] [00020.692] 01048:01051> [PASSED] (1032 ms) [00020.692] 01048:01051> port_close_wait_race_stress [RUNNING] [00021.706] 01048:01051> [PASSED] (1013 ms) [00021.706] 01048:01051> CASE port_tests [PASSED] [00021.706] 01048:01051> CASE api_violations [STARTED] [00021.706] 01048:01051> invalid_pager_create [RUNNING] [00021.706] 01048:01051> [PASSED] (0 ms) [00021.706] 01048:01051> invalid_pager_create_vmo [RUNNING] [00021.706] 01048:01051> [PASSED] (0 ms) [00021.706] 01048:01051> invalid_pager_detach_vmo [RUNNING] [00021.706] 01048:01051> [PASSED] (0 ms) [00021.706] 01048:01051> invalid_pager_supply_pages [RUNNING] [00021.706] 01048:01051> [PASSED] (0 ms) [00021.706] 01048:01051> resize_nonresizable_vmo [RUNNING] [00021.706] 01048:01051> [PASSED] (0 ms) [00021.706] 01048:01051> CASE api_violations [PASSED] [00021.706] 01048:01051> CASE commit_tests [STARTED] [00021.706] 01048:01051> simple_commit_test [RUNNING] [00021.709] 01048:01051> [PASSED] (3 ms) [00021.709] 01048:01051> split_commit_test [RUNNING] [00021.715] 01048:01051> [PASSED] (5 ms) [00021.715] 01048:01051> overlap_commit_test [RUNNING] [00021.721] 01048:01051> [PASSED] (6 ms) [00021.721] 01048:01051> overlap_commit_supply_test [RUNNING] [00021.800] 01048:01051> [PASSED] (78 ms) [00021.800] 01048:01051> multisupply_commit_test [RUNNING] [00021.802] 01048:01051> [PASSED] (2 ms) [00021.802] 01048:01051> multicommit_supply_test [RUNNING] [00021.815] 01048:01051> [PASSED] (12 ms) [00021.815] 01048:01051> commit_redundant_supply_test [RUNNING] [00021.817] 01048:01051> [PASSED] (2 ms) [00021.817] 01048:01051> supply_decommit_test [RUNNING] [00021.821] 01048:01051> [PASSED] (4 ms) [00021.821] 01048:01051> resize_commit_test [RUNNING] [00021.823] 01048:01051> [PASSED] (2 ms) [00021.823] 01048:01051> suspend_commit_test [RUNNING] [00021.828] 01048:01051> [PASSED] (4 ms) [00021.828] 01048:01051> CASE commit_tests [PASSED] [00021.828] 01048:01051> CASE clone_tests [STARTED] [00021.828] 01048:01051> clone_read_from_clone_test_vmar [RUNNING] [00021.830] 01048:01051> [PASSED] (2 ms) [00021.830] 01048:01051> clone_read_from_clone_test_vmo [RUNNING] [00021.834] 01048:01051> [PASSED] (4 ms) [00021.834] 01048:01051> clone_read_from_parent_test_vmar [RUNNING] [00021.841] 01048:01051> [PASSED] (6 ms) [00021.841] 01048:01051> clone_read_from_parent_test_vmo [RUNNING] [00021.847] 01048:01051> [PASSED] (6 ms) [00021.847] 01048:01051> clone_simultaneous_read_test_vmar [RUNNING] [00021.856] 01048:01051> [PASSED] (8 ms) [00021.856] 01048:01051> clone_simultaneous_read_test_vmo [RUNNING] [00021.859] 01048:01051> [PASSED] (2 ms) [00021.859] 01048:01051> clone_simultaneous_child_read_test_vmar [RUNNING] [00021.865] 01048:01051> [PASSED] (6 ms) [00021.865] 01048:01051> clone_simultaneous_child_read_test_vmo [RUNNING] [00021.872] 01048:01051> [PASSED] (7 ms) [00021.872] 01048:01051> clone_write_to_clone_test [RUNNING] [00021.876] 01048:01051> [PASSED] (4 ms) [00021.877] 01048:01051> clone_detach_test [RUNNING] [00021.879] 01048:01051> [PASSED] (2 ms) [00021.879] 01048:01051> clone_commit_test [RUNNING] [00021.883] 01048:01051> [PASSED] (4 ms) [00021.883] 01048:01051> clone_split_commit_test [RUNNING] [00021.885] 01048:01051> [PASSED] (2 ms) [00021.885] 01048:01051> clone_decommit_test [RUNNING] [00021.886] 01048:01051> [PASSED] (0 ms) [00021.886] 01048:01051> CASE clone_tests [PASSED] [00021.886] 01048:01051> CASE lifecycle_tests [STARTED] [00021.886] 01048:01051> vmo_info_pager_test [RUNNING] [00021.886] 01048:01051> [PASSED] (0 ms) [00021.886] 01048:01051> detach_page_complete_test [RUNNING] [00021.886] 01048:01051> [PASSED] (0 ms) [00021.886] 01048:01051> close_page_complete_test [RUNNING] [00021.886] 01048:01051> [PASSED] (0 ms) [00021.886] 01048:01051> read_detach_interrupt_late_test_vmar [RUNNING] [00021.886] 01048:26260> PageFault: 1027420 free pages [00021.886] 01048:26260> [00021.886] 01048:26260> ZIRCON KERNEL PANIC [00021.886] 01048:26260> Lock validation failed for thread 0xffffff8003180630 pid 1048 tid 26260 (bin/core-tests:test_thread): [00021.886] 01048:26260> Reason: Already Acquired [00021.886] 01048:26260> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.886] 01048:26260> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.886] 01048:26260> caller=0xffffffff0014b65b frame=0xffffff945d310d60 [00021.886] 01048:26260> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00021.886] 01048:26260> [00021.886] 01048:26260> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00021.886] 01048:26260> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00021.886] 01048:26260> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00021.886] 01048:26260> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00021.886] 01048:26260> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00021.886] 01048:26260> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00021.886] 01048:26260> bt#00: 0xffffffff0014b65b [00021.886] 01048:26260> bt#01: 0xffffffff0014ba8f [00021.886] 01048:26260> bt#02: 0xffffffff0013732e [00021.886] 01048:26260> bt#03: 0xffffffff001f6db4 [00021.886] 01048:26260> bt#04: 0xffffffff001bd5fe [00021.886] 01048:26260> bt#05: 0xffffffff001bd24b [00021.886] 01048:26260> bt#06: end [00021.886] 01048:26260> {{{bt:0:0xffffffff0014b65b}}} [00021.886] 01048:26260> {{{bt:1:0xffffffff0014ba8f}}} [00021.886] 01048:26260> {{{bt:2:0xffffffff0013732e}}} [00021.886] 01048:26260> {{{bt:3:0xffffffff001f6db4}}} [00021.886] 01048:26260> {{{bt:4:0xffffffff001bd5fe}}} [00021.886] 01048:26260> {{{bt:5:0xffffffff001bd24b}}} [00021.886] 01048:26260> [00021.886] 01048:26260> [00021.886] 01048:26260> ZIRCON KERNEL PANIC [00021.886] 01048:26260> Lock validation failed for thread 0xffffff8003180630 pid 1048 tid 26260 (bin/core-tests:test_thread): [00021.886] 01048:26260> Reason: Already Acquired [00021.886] 01048:26260> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.886] 01048:26260> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.886] 01048:26260> caller=0xffffffff0014b65b frame=0xffffff945d310cd0 [00021.886] 01048:26260> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00021.886] 01048:26260> [00021.886] 01048:26260> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00021.886] 01048:26260> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00021.886] 01048:26260> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00021.886] 01048:26260> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00021.886] 01048:26260> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00021.886] 01048:26260> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00021.886] 01048:26260> bt#00: 0xffffffff0014b65b [00021.886] 01048:26260> bt#01: 0xffffffff0014ba8f [00021.886] 01048:26260> bt#02: 0xffffffff0014ba8f [00021.886] 01048:26260> bt#03: 0xffffffff0013732e [00021.886] 01048:26260> bt#04: 0xffffffff001f6db4 [00021.886] 01048:26260> bt#05: 0xffffffff001bd5fe [00021.886] 01048:26260> bt#06: 0xffffffff001bd24b [00021.886] 01048:26260> bt#07: end [00021.886] 01048:26260> {{{bt:0:0xffffffff0014b65b}}} [00021.886] 01048:26260> {{{bt:1:0xffffffff0014ba8f}}} [00021.886] 01048:26260> {{{bt:2:0xffffffff0014ba8f}}} [00021.886] 01048:26260> {{{bt:3:0xffffffff0013732e}}} [00021.886] 01048:26260> {{{bt:4:0xffffffff001f6db4}}} [00021.886] 01048:26260> {{{bt:5:0xffffffff001bd5fe}}} [00021.886] 01048:26260> {{{bt:6:0xffffffff001bd24b}}} [00021.886] 01048:26260> [00021.886] 01048:26260> [00021.886] 01048:26260> ZIRCON KERNEL PANIC [00021.886] 01048:26260> Lock validation failed for thread 0xffffff8003180630 pid 1048 tid 26260 (bin/core-tests:test_thread): [00021.886] 01048:26260> Reason: Already Acquired [00021.886] 01048:26260> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.886] 01048:26260> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.886] 01048:26260> caller=0xffffffff0014b65b frame=0xffffff945d310cd0 [00021.886] 01048:26260> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00021.886] 01048:26260> [00021.886] 01048:26260> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00021.886] 01048:26260> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00021.886] 01048:26260> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00021.886] 01048:26260> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00021.886] 01048:26260> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00021.886] 01048:26260> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00021.886] 01048:26260> bt#00: 0xffffffff0014b65b [00021.886] 01048:26260> bt#01: 0xffffffff0014ba8f [00021.886] 01048:26260> bt#02: 0xffffffff0014ba8f [00021.886] 01048:26260> bt#03: 0xffffffff0013732e [00021.886] 01048:26260> bt#04: 0xffffffff001f6db4 [00021.886] 01048:26260> bt#05: 0xffffffff001bd5fe [00021.886] 01048:26260> bt#06: 0xffffffff001bd24b [00021.886] 01048:26260> bt#07: end [00021.886] 01048:26260> {{{bt:0:0xffffffff0014b65b}}} [00021.886] 01048:26260> {{{bt:1:0xffffffff0014ba8f}}} [00021.886] 01048:26260> {{{bt:2:0xffffffff0014ba8f}}} [00021.886] 01048:26260> {{{bt:3:0xffffffff0013732e}}} [00021.886] 01048:26260> {{{bt:4:0xffffffff001f6db4}}} [00021.886] 01048:26260> {{{bt:5:0xffffffff001bd5fe}}} [00021.886] 01048:26260> {{{bt:6:0xffffffff001bd24b}}} [00021.886] 01048:26260> [00021.890] 01048:01051> [PASSED] (3 ms) [00021.890] 01048:01051> read_detach_interrupt_late_test_vmo [RUNNING] [00021.892] 01048:01051> [PASSED] (2 ms) [00021.892] 01048:01051> read_close_interrupt_late_test_vmar [RUNNING] [00021.892] 01048:26280> PageFault: 1027420 free pages [00021.892] 01048:26280> [00021.892] 01048:26280> ZIRCON KERNEL PANIC [00021.892] 01048:26280> Lock validation failed for thread 0xffffff8003180630 pid 1048 tid 26280 (bin/core-tests:test_thread): [00021.892] 01048:26280> Reason: Already Acquired [00021.892] 01048:26280> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.892] 01048:26280> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.892] 01048:26280> caller=0xffffffff0014b65b frame=0xffffff945d310d60 [00021.892] 01048:26280> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00021.892] 01048:26280> [00021.892] 01048:26280> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00021.892] 01048:26280> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00021.892] 01048:26280> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00021.892] 01048:26280> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00021.892] 01048:26280> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00021.892] 01048:26280> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00021.892] 01048:26280> bt#00: 0xffffffff0014b65b [00021.892] 01048:26280> bt#01: 0xffffffff0014ba8f [00021.892] 01048:26280> bt#02: 0xffffffff0013732e [00021.892] 01048:26280> bt#03: 0xffffffff001f6db4 [00021.892] 01048:26280> bt#04: 0xffffffff001bd5fe [00021.892] 01048:26280> bt#05: 0xffffffff001bd24b [00021.892] 01048:26280> bt#06: end [00021.892] 01048:26280> {{{bt:0:0xffffffff0014b65b}}} [00021.892] 01048:26280> {{{bt:1:0xffffffff0014ba8f}}} [00021.892] 01048:26280> {{{bt:2:0xffffffff0013732e}}} [00021.892] 01048:26280> {{{bt:3:0xffffffff001f6db4}}} [00021.892] 01048:26280> {{{bt:4:0xffffffff001bd5fe}}} [00021.892] 01048:26280> {{{bt:5:0xffffffff001bd24b}}} [00021.892] 01048:26280> [00021.892] 01048:26280> [00021.892] 01048:26280> ZIRCON KERNEL PANIC [00021.892] 01048:26280> Lock validation failed for thread 0xffffff8003180630 pid 1048 tid 26280 (bin/core-tests:test_thread): [00021.892] 01048:26280> Reason: Already Acquired [00021.892] 01048:26280> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.892] 01048:26280> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.892] 01048:26280> caller=0xffffffff0014b65b frame=0xffffff945d310cd0 [00021.892] 01048:26280> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00021.892] 01048:26280> [00021.892] 01048:26280> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00021.892] 01048:26280> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00021.892] 01048:26280> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00021.892] 01048:26280> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00021.892] 01048:26280> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00021.892] 01048:26280> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00021.892] 01048:26280> bt#00: 0xffffffff0014b65b [00021.892] 01048:26280> bt#01: 0xffffffff0014ba8f [00021.892] 01048:26280> bt#02: 0xffffffff0014ba8f [00021.892] 01048:26280> bt#03: 0xffffffff0013732e [00021.892] 01048:26280> bt#04: 0xffffffff001f6db4 [00021.892] 01048:26280> bt#05: 0xffffffff001bd5fe [00021.892] 01048:26280> bt#06: 0xffffffff001bd24b [00021.892] 01048:26280> bt#07: end [00021.892] 01048:26280> {{{bt:0:0xffffffff0014b65b}}} [00021.892] 01048:26280> {{{bt:1:0xffffffff0014ba8f}}} [00021.892] 01048:26280> {{{bt:2:0xffffffff0014ba8f}}} [00021.892] 01048:26280> {{{bt:3:0xffffffff0013732e}}} [00021.892] 01048:26280> {{{bt:4:0xffffffff001f6db4}}} [00021.892] 01048:26280> {{{bt:5:0xffffffff001bd5fe}}} [00021.892] 01048:26280> {{{bt:6:0xffffffff001bd24b}}} [00021.892] 01048:26280> [00021.892] 01048:26280> [00021.892] 01048:26280> ZIRCON KERNEL PANIC [00021.892] 01048:26280> Lock validation failed for thread 0xffffff8003180630 pid 1048 tid 26280 (bin/core-tests:test_thread): [00021.892] 01048:26280> Reason: Already Acquired [00021.892] 01048:26280> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.892] 01048:26280> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.892] 01048:26280> caller=0xffffffff0014b65b frame=0xffffff945d310cd0 [00021.892] 01048:26280> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00021.892] 01048:26280> [00021.892] 01048:26280> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00021.892] 01048:26280> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00021.892] 01048:26280> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00021.892] 01048:26280> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00021.892] 01048:26280> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00021.892] 01048:26280> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00021.892] 01048:26280> bt#00: 0xffffffff0014b65b [00021.892] 01048:26280> bt#01: 0xffffffff0014ba8f [00021.892] 01048:26280> bt#02: 0xffffffff0014ba8f [00021.892] 01048:26280> bt#03: 0xffffffff0013732e [00021.892] 01048:26280> bt#04: 0xffffffff001f6db4 [00021.892] 01048:26280> bt#05: 0xffffffff001bd5fe [00021.892] 01048:26280> bt#06: 0xffffffff001bd24b [00021.892] 01048:26280> bt#07: end [00021.892] 01048:26280> {{{bt:0:0xffffffff0014b65b}}} [00021.892] 01048:26280> {{{bt:1:0xffffffff0014ba8f}}} [00021.892] 01048:26280> {{{bt:2:0xffffffff0014ba8f}}} [00021.892] 01048:26280> {{{bt:3:0xffffffff0013732e}}} [00021.892] 01048:26280> {{{bt:4:0xffffffff001f6db4}}} [00021.892] 01048:26280> {{{bt:5:0xffffffff001bd5fe}}} [00021.892] 01048:26280> {{{bt:6:0xffffffff001bd24b}}} [00021.892] 01048:26280> [00021.896] 01048:01051> [PASSED] (4 ms) [00021.896] 01048:01051> read_close_interrupt_late_test_vmo [RUNNING] [00021.898] 01048:01051> [PASSED] (2 ms) [00021.898] 01048:01051> read_detach_interrupt_early_test_vmar [RUNNING] [00021.899] 01048:26300> PageFault: 1027421 free pages [00021.899] 01048:26300> [00021.899] 01048:26300> ZIRCON KERNEL PANIC [00021.899] 01048:26300> Lock validation failed for thread 0xffffff8003180630 pid 1048 tid 26300 (bin/core-tests:test_thread): [00021.899] 01048:26300> Reason: Already Acquired [00021.899] 01048:26300> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.899] 01048:26300> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.899] 01048:26300> caller=0xffffffff0014b65b frame=0xffffff945d310d60 [00021.899] 01048:26300> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00021.899] 01048:26300> [00021.899] 01048:26300> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00021.899] 01048:26300> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00021.899] 01048:26300> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00021.899] 01048:26300> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00021.899] 01048:26300> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00021.899] 01048:26300> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00021.899] 01048:26300> bt#00: 0xffffffff0014b65b [00021.899] 01048:26300> bt#01: 0xffffffff0014ba8f [00021.899] 01048:26300> bt#02: 0xffffffff0013732e [00021.899] 01048:26300> bt#03: 0xffffffff001f6db4 [00021.899] 01048:26300> bt#04: 0xffffffff001bd5fe [00021.899] 01048:26300> bt#05: 0xffffffff001bd24b [00021.899] 01048:26300> bt#06: end [00021.899] 01048:26300> {{{bt:0:0xffffffff0014b65b}}} [00021.899] 01048:26300> {{{bt:1:0xffffffff0014ba8f}}} [00021.899] 01048:26300> {{{bt:2:0xffffffff0013732e}}} [00021.899] 01048:26300> {{{bt:3:0xffffffff001f6db4}}} [00021.899] 01048:26300> {{{bt:4:0xffffffff001bd5fe}}} [00021.899] 01048:26300> {{{bt:5:0xffffffff001bd24b}}} [00021.899] 01048:26300> [00021.899] 01048:26300> [00021.899] 01048:26300> ZIRCON KERNEL PANIC [00021.899] 01048:26300> Lock validation failed for thread 0xffffff8003180630 pid 1048 tid 26300 (bin/core-tests:test_thread): [00021.899] 01048:26300> Reason: Already Acquired [00021.899] 01048:26300> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.899] 01048:26300> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.899] 01048:26300> caller=0xffffffff0014b65b frame=0xffffff945d310cd0 [00021.899] 01048:26300> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00021.899] 01048:26300> [00021.899] 01048:26300> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00021.899] 01048:26300> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00021.899] 01048:26300> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00021.899] 01048:26300> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00021.899] 01048:26300> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00021.899] 01048:26300> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00021.899] 01048:26300> bt#00: 0xffffffff0014b65b [00021.899] 01048:26300> bt#01: 0xffffffff0014ba8f [00021.899] 01048:26300> bt#02: 0xffffffff0014ba8f [00021.899] 01048:26300> bt#03: 0xffffffff0013732e [00021.899] 01048:26300> bt#04: 0xffffffff001f6db4 [00021.899] 01048:26300> bt#05: 0xffffffff001bd5fe [00021.899] 01048:26300> bt#06: 0xffffffff001bd24b [00021.899] 01048:26300> bt#07: end [00021.899] 01048:26300> {{{bt:0:0xffffffff0014b65b}}} [00021.899] 01048:26300> {{{bt:1:0xffffffff0014ba8f}}} [00021.899] 01048:26300> {{{bt:2:0xffffffff0014ba8f}}} [00021.899] 01048:26300> {{{bt:3:0xffffffff0013732e}}} [00021.899] 01048:26300> {{{bt:4:0xffffffff001f6db4}}} [00021.899] 01048:26300> {{{bt:5:0xffffffff001bd5fe}}} [00021.899] 01048:26300> {{{bt:6:0xffffffff001bd24b}}} [00021.899] 01048:26300> [00021.899] 01048:26300> [00021.899] 01048:26300> ZIRCON KERNEL PANIC [00021.899] 01048:26300> Lock validation failed for thread 0xffffff8003180630 pid 1048 tid 26300 (bin/core-tests:test_thread): [00021.899] 01048:26300> Reason: Already Acquired [00021.899] 01048:26300> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.899] 01048:26300> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.899] 01048:26300> caller=0xffffffff0014b65b frame=0xffffff945d310cd0 [00021.899] 01048:26300> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00021.899] 01048:26300> [00021.899] 01048:26300> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00021.899] 01048:26300> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00021.899] 01048:26300> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00021.899] 01048:26300> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00021.899] 01048:26300> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00021.899] 01048:26300> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00021.899] 01048:26300> bt#00: 0xffffffff0014b65b [00021.899] 01048:26300> bt#01: 0xffffffff0014ba8f [00021.899] 01048:26300> bt#02: 0xffffffff0014ba8f [00021.899] 01048:26300> bt#03: 0xffffffff0013732e [00021.899] 01048:26300> bt#04: 0xffffffff001f6db4 [00021.899] 01048:26300> bt#05: 0xffffffff001bd5fe [00021.899] 01048:26300> bt#06: 0xffffffff001bd24b [00021.899] 01048:26300> bt#07: end [00021.899] 01048:26300> {{{bt:0:0xffffffff0014b65b}}} [00021.899] 01048:26300> {{{bt:1:0xffffffff0014ba8f}}} [00021.899] 01048:26300> {{{bt:2:0xffffffff0014ba8f}}} [00021.899] 01048:26300> {{{bt:3:0xffffffff0013732e}}} [00021.899] 01048:26300> {{{bt:4:0xffffffff001f6db4}}} [00021.899] 01048:26300> {{{bt:5:0xffffffff001bd5fe}}} [00021.899] 01048:26300> {{{bt:6:0xffffffff001bd24b}}} [00021.899] 01048:26300> [00021.903] 01048:01051> [PASSED] (4 ms) [00021.903] 01048:01051> read_detach_interrupt_early_test_vmo [RUNNING] [00021.905] 01048:01051> [PASSED] (2 ms) [00021.905] 01048:01051> read_close_interrupt_early_test_vmar [RUNNING] [00021.905] 01048:26320> PageFault: 1027420 free pages [00021.905] 01048:26320> [00021.905] 01048:26320> ZIRCON KERNEL PANIC [00021.905] 01048:26320> Lock validation failed for thread 0xffffff8003180630 pid 1048 tid 26320 (bin/core-tests:test_thread): [00021.905] 01048:26320> Reason: Already Acquired [00021.905] 01048:26320> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.905] 01048:26320> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.905] 01048:26320> caller=0xffffffff0014b65b frame=0xffffff945d310d60 [00021.905] 01048:26320> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00021.905] 01048:26320> [00021.905] 01048:26320> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00021.905] 01048:26320> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00021.905] 01048:26320> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00021.905] 01048:26320> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00021.905] 01048:26320> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00021.905] 01048:26320> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00021.905] 01048:26320> bt#00: 0xffffffff0014b65b [00021.905] 01048:26320> bt#01: 0xffffffff0014ba8f [00021.905] 01048:26320> bt#02: 0xffffffff0013732e [00021.905] 01048:26320> bt#03: 0xffffffff001f6db4 [00021.905] 01048:26320> bt#04: 0xffffffff001bd5fe [00021.905] 01048:26320> bt#05: 0xffffffff001bd24b [00021.905] 01048:26320> bt#06: end [00021.905] 01048:26320> {{{bt:0:0xffffffff0014b65b}}} [00021.905] 01048:26320> {{{bt:1:0xffffffff0014ba8f}}} [00021.905] 01048:26320> {{{bt:2:0xffffffff0013732e}}} [00021.905] 01048:26320> {{{bt:3:0xffffffff001f6db4}}} [00021.905] 01048:26320> {{{bt:4:0xffffffff001bd5fe}}} [00021.905] 01048:26320> {{{bt:5:0xffffffff001bd24b}}} [00021.905] 01048:26320> [00021.905] 01048:26320> [00021.905] 01048:26320> ZIRCON KERNEL PANIC [00021.905] 01048:26320> Lock validation failed for thread 0xffffff8003180630 pid 1048 tid 26320 (bin/core-tests:test_thread): [00021.905] 01048:26320> Reason: Already Acquired [00021.905] 01048:26320> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.905] 01048:26320> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.905] 01048:26320> caller=0xffffffff0014b65b frame=0xffffff945d310cd0 [00021.905] 01048:26320> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00021.905] 01048:26320> [00021.905] 01048:26320> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00021.905] 01048:26320> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00021.905] 01048:26320> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00021.905] 01048:26320> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00021.905] 01048:26320> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00021.905] 01048:26320> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00021.905] 01048:26320> bt#00: 0xffffffff0014b65b [00021.905] 01048:26320> bt#01: 0xffffffff0014ba8f [00021.905] 01048:26320> bt#02: 0xffffffff0014ba8f [00021.905] 01048:26320> bt#03: 0xffffffff0013732e [00021.905] 01048:26320> bt#04: 0xffffffff001f6db4 [00021.905] 01048:26320> bt#05: 0xffffffff001bd5fe [00021.905] 01048:26320> bt#06: 0xffffffff001bd24b [00021.905] 01048:26320> bt#07: end [00021.905] 01048:26320> {{{bt:0:0xffffffff0014b65b}}} [00021.905] 01048:26320> {{{bt:1:0xffffffff0014ba8f}}} [00021.905] 01048:26320> {{{bt:2:0xffffffff0014ba8f}}} [00021.905] 01048:26320> {{{bt:3:0xffffffff0013732e}}} [00021.905] 01048:26320> {{{bt:4:0xffffffff001f6db4}}} [00021.905] 01048:26320> {{{bt:5:0xffffffff001bd5fe}}} [00021.905] 01048:26320> {{{bt:6:0xffffffff001bd24b}}} [00021.905] 01048:26320> [00021.905] 01048:26320> [00021.905] 01048:26320> ZIRCON KERNEL PANIC [00021.905] 01048:26320> Lock validation failed for thread 0xffffff8003180630 pid 1048 tid 26320 (bin/core-tests:test_thread): [00021.905] 01048:26320> Reason: Already Acquired [00021.905] 01048:26320> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.905] 01048:26320> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.905] 01048:26320> caller=0xffffffff0014b65b frame=0xffffff945d310cd0 [00021.905] 01048:26320> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00021.905] 01048:26320> [00021.905] 01048:26320> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00021.905] 01048:26320> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00021.905] 01048:26320> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00021.905] 01048:26320> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00021.905] 01048:26320> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00021.905] 01048:26320> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00021.905] 01048:26320> bt#00: 0xffffffff0014b65b [00021.905] 01048:26320> bt#01: 0xffffffff0014ba8f [00021.905] 01048:26320> bt#02: 0xffffffff0014ba8f [00021.905] 01048:26320> bt#03: 0xffffffff0013732e [00021.905] 01048:26320> bt#04: 0xffffffff001f6db4 [00021.905] 01048:26320> bt#05: 0xffffffff001bd5fe [00021.905] 01048:26320> bt#06: 0xffffffff001bd24b [00021.905] 01048:26320> bt#07: end [00021.905] 01048:26320> {{{bt:0:0xffffffff0014b65b}}} [00021.905] 01048:26320> {{{bt:1:0xffffffff0014ba8f}}} [00021.905] 01048:26320> {{{bt:2:0xffffffff0014ba8f}}} [00021.905] 01048:26320> {{{bt:3:0xffffffff0013732e}}} [00021.905] 01048:26320> {{{bt:4:0xffffffff001f6db4}}} [00021.905] 01048:26320> {{{bt:5:0xffffffff001bd5fe}}} [00021.905] 01048:26320> {{{bt:6:0xffffffff001bd24b}}} [00021.905] 01048:26320> [00021.909] 01048:01051> [PASSED] (4 ms) [00021.909] 01048:01051> read_close_interrupt_early_test_vmo [RUNNING] [00021.912] 01048:01051> [PASSED] (2 ms) [00021.912] 01048:01051> thread_kill_test_vmar [RUNNING] [00021.916] 01048:01051> [PASSED] (4 ms) [00021.916] 01048:01051> thread_kill_test_vmo [RUNNING] [00021.918] 01048:01051> [PASSED] (2 ms) [00021.918] 01048:01051> thread_kill_overlap_test_vmar [RUNNING] [00021.922] 01048:01051> [PASSED] (4 ms) [00021.922] 01048:01051> thread_kill_overlap_test_vmo [RUNNING] [00021.925] 01048:01051> [PASSED] (2 ms) [00021.925] 01048:01051> close_pager_test [RUNNING] [00021.925] 01048:26411> PageFault: 1027345 free pages [00021.925] 01048:26411> [00021.925] 01048:26411> ZIRCON KERNEL PANIC [00021.925] 01048:26411> Lock validation failed for thread 0xffffff8000778498 pid 1048 tid 26411 (bin/core-tests:test_thread): [00021.925] 01048:26411> Reason: Already Acquired [00021.925] 01048:26411> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.925] 01048:26411> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.925] 01048:26411> caller=0xffffffff0014b65b frame=0xffffff945d330d60 [00021.925] 01048:26411> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00021.925] 01048:26411> [00021.925] 01048:26411> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00021.925] 01048:26411> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00021.925] 01048:26411> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00021.925] 01048:26411> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00021.925] 01048:26411> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00021.925] 01048:26411> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00021.925] 01048:26411> bt#00: 0xffffffff0014b65b [00021.925] 01048:26411> bt#01: 0xffffffff0014ba8f [00021.925] 01048:26411> bt#02: 0xffffffff0013732e [00021.925] 01048:26411> bt#03: 0xffffffff001f6db4 [00021.925] 01048:26411> bt#04: 0xffffffff001bd5fe [00021.925] 01048:26411> bt#05: 0xffffffff001bd24b [00021.925] 01048:26411> bt#06: end [00021.925] 01048:26411> {{{bt:0:0xffffffff0014b65b}}} [00021.925] 01048:26411> {{{bt:1:0xffffffff0014ba8f}}} [00021.925] 01048:26411> {{{bt:2:0xffffffff0013732e}}} [00021.925] 01048:26411> {{{bt:3:0xffffffff001f6db4}}} [00021.925] 01048:26411> {{{bt:4:0xffffffff001bd5fe}}} [00021.925] 01048:26411> {{{bt:5:0xffffffff001bd24b}}} [00021.925] 01048:26411> [00021.925] 01048:26411> [00021.925] 01048:26411> ZIRCON KERNEL PANIC [00021.925] 01048:26411> Lock validation failed for thread 0xffffff8000778498 pid 1048 tid 26411 (bin/core-tests:test_thread): [00021.925] 01048:26411> Reason: Already Acquired [00021.925] 01048:26411> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.925] 01048:26411> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.925] 01048:26411> caller=0xffffffff0014b65b frame=0xffffff945d330cd0 [00021.925] 01048:26411> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00021.925] 01048:26411> [00021.925] 01048:26411> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00021.925] 01048:26411> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00021.925] 01048:26411> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00021.925] 01048:26411> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00021.925] 01048:26411> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00021.925] 01048:26411> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00021.925] 01048:26411> bt#00: 0xffffffff0014b65b [00021.925] 01048:26411> bt#01: 0xffffffff0014ba8f [00021.925] 01048:26411> bt#02: 0xffffffff0014ba8f [00021.925] 01048:26411> bt#03: 0xffffffff0013732e [00021.925] 01048:26411> bt#04: 0xffffffff001f6db4 [00021.925] 01048:26411> bt#05: 0xffffffff001bd5fe [00021.925] 01048:26411> bt#06: 0xffffffff001bd24b [00021.925] 01048:26411> bt#07: end [00021.925] 01048:26411> {{{bt:0:0xffffffff0014b65b}}} [00021.925] 01048:26411> {{{bt:1:0xffffffff0014ba8f}}} [00021.925] 01048:26411> {{{bt:2:0xffffffff0014ba8f}}} [00021.925] 01048:26411> {{{bt:3:0xffffffff0013732e}}} [00021.925] 01048:26411> {{{bt:4:0xffffffff001f6db4}}} [00021.925] 01048:26411> {{{bt:5:0xffffffff001bd5fe}}} [00021.925] 01048:26411> {{{bt:6:0xffffffff001bd24b}}} [00021.925] 01048:26411> [00021.925] 01048:26411> [00021.925] 01048:26411> ZIRCON KERNEL PANIC [00021.925] 01048:26411> Lock validation failed for thread 0xffffff8000778498 pid 1048 tid 26411 (bin/core-tests:test_thread): [00021.925] 01048:26411> Reason: Already Acquired [00021.925] 01048:26411> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.925] 01048:26411> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.925] 01048:26411> caller=0xffffffff0014b65b frame=0xffffff945d330cd0 [00021.925] 01048:26411> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00021.925] 01048:26411> [00021.925] 01048:26411> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00021.925] 01048:26411> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00021.925] 01048:26411> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00021.925] 01048:26411> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00021.925] 01048:26411> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00021.925] 01048:26411> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00021.925] 01048:26411> bt#00: 0xffffffff0014b65b [00021.925] 01048:26411> bt#01: 0xffffffff0014ba8f [00021.925] 01048:26411> bt#02: 0xffffffff0014ba8f [00021.925] 01048:26411> bt#03: 0xffffffff0013732e [00021.925] 01048:26411> bt#04: 0xffffffff001f6db4 [00021.925] 01048:26411> bt#05: 0xffffffff001bd5fe [00021.925] 01048:26411> bt#06: 0xffffffff001bd24b [00021.925] 01048:26411> bt#07: end [00021.925] 01048:26411> {{{bt:0:0xffffffff0014b65b}}} [00021.925] 01048:26411> {{{bt:1:0xffffffff0014ba8f}}} [00021.925] 01048:26411> {{{bt:2:0xffffffff0014ba8f}}} [00021.925] 01048:26411> {{{bt:3:0xffffffff0013732e}}} [00021.925] 01048:26411> {{{bt:4:0xffffffff001f6db4}}} [00021.925] 01048:26411> {{{bt:5:0xffffffff001bd5fe}}} [00021.925] 01048:26411> {{{bt:6:0xffffffff001bd24b}}} [00021.925] 01048:26411> [00021.929] 01048:01051> [PASSED] (4 ms) [00021.929] 01048:01051> detach_close_pager_test [RUNNING] [00021.929] 01048:01051> [PASSED] (0 ms) [00021.929] 01048:01051> close_port_test [RUNNING] [00021.929] 01048:26424> PageFault: 1027342 free pages [00021.929] 01048:26424> [00021.929] 01048:26424> ZIRCON KERNEL PANIC [00021.929] 01048:26424> Lock validation failed for thread 0xffffff80007783d8 pid 1048 tid 26424 (bin/core-tests:test_thread): [00021.929] 01048:26424> Reason: Already Acquired [00021.929] 01048:26424> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.929] 01048:26424> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.929] 01048:26424> caller=0xffffffff0014b65b frame=0xffffff945d330d60 [00021.929] 01048:26424> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00021.929] 01048:26424> [00021.929] 01048:26424> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00021.929] 01048:26424> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00021.929] 01048:26424> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00021.929] 01048:26424> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00021.929] 01048:26424> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00021.929] 01048:26424> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00021.929] 01048:26424> bt#00: 0xffffffff0014b65b [00021.929] 01048:26424> bt#01: 0xffffffff0014ba8f [00021.929] 01048:26424> bt#02: 0xffffffff0013732e [00021.929] 01048:26424> bt#03: 0xffffffff001f6db4 [00021.929] 01048:26424> bt#04: 0xffffffff001bd5fe [00021.929] 01048:26424> bt#05: 0xffffffff001bd24b [00021.929] 01048:26424> bt#06: end [00021.929] 01048:26424> {{{bt:0:0xffffffff0014b65b}}} [00021.929] 01048:26424> {{{bt:1:0xffffffff0014ba8f}}} [00021.929] 01048:26424> {{{bt:2:0xffffffff0013732e}}} [00021.929] 01048:26424> {{{bt:3:0xffffffff001f6db4}}} [00021.929] 01048:26424> {{{bt:4:0xffffffff001bd5fe}}} [00021.929] 01048:26424> {{{bt:5:0xffffffff001bd24b}}} [00021.929] 01048:26424> [00021.930] 01048:26424> [00021.930] 01048:26424> ZIRCON KERNEL PANIC [00021.930] 01048:26424> Lock validation failed for thread 0xffffff80007783d8 pid 1048 tid 26424 (bin/core-tests:test_thread): [00021.930] 01048:26424> Reason: Already Acquired [00021.930] 01048:26424> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.930] 01048:26424> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.930] 01048:26424> caller=0xffffffff0014b65b frame=0xffffff945d330cd0 [00021.930] 01048:26424> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00021.930] 01048:26424> [00021.930] 01048:26424> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00021.930] 01048:26424> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00021.930] 01048:26424> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00021.930] 01048:26424> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00021.930] 01048:26424> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00021.930] 01048:26424> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00021.930] 01048:26424> bt#00: 0xffffffff0014b65b [00021.930] 01048:26424> bt#01: 0xffffffff0014ba8f [00021.930] 01048:26424> bt#02: 0xffffffff0014ba8f [00021.930] 01048:26424> bt#03: 0xffffffff0013732e [00021.930] 01048:26424> bt#04: 0xffffffff001f6db4 [00021.930] 01048:26424> bt#05: 0xffffffff001bd5fe [00021.930] 01048:26424> bt#06: 0xffffffff001bd24b [00021.930] 01048:26424> bt#07: end [00021.930] 01048:26424> {{{bt:0:0xffffffff0014b65b}}} [00021.930] 01048:26424> {{{bt:1:0xffffffff0014ba8f}}} [00021.930] 01048:26424> {{{bt:2:0xffffffff0014ba8f}}} [00021.930] 01048:26424> {{{bt:3:0xffffffff0013732e}}} [00021.930] 01048:26424> {{{bt:4:0xffffffff001f6db4}}} [00021.930] 01048:26424> {{{bt:5:0xffffffff001bd5fe}}} [00021.930] 01048:26424> {{{bt:6:0xffffffff001bd24b}}} [00021.930] 01048:26424> [00021.930] 01048:26424> [00021.930] 01048:26424> ZIRCON KERNEL PANIC [00021.930] 01048:26424> Lock validation failed for thread 0xffffff80007783d8 pid 1048 tid 26424 (bin/core-tests:test_thread): [00021.930] 01048:26424> Reason: Already Acquired [00021.930] 01048:26424> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.930] 01048:26424> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00021.930] 01048:26424> caller=0xffffffff0014b65b frame=0xffffff945d330cd0 [00021.930] 01048:26424> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00021.930] 01048:26424> [00021.930] 01048:26424> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00021.930] 01048:26424> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00021.930] 01048:26424> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00021.930] 01048:26424> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00021.930] 01048:26424> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00021.930] 01048:26424> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00021.930] 01048:26424> bt#00: 0xffffffff0014b65b [00021.930] 01048:26424> bt#01: 0xffffffff0014ba8f [00021.930] 01048:26424> bt#02: 0xffffffff0014ba8f [00021.930] 01048:26424> bt#03: 0xffffffff0013732e [00021.930] 01048:26424> bt#04: 0xffffffff001f6db4 [00021.930] 01048:26424> bt#05: 0xffffffff001bd5fe [00021.930] 01048:26424> bt#06: 0xffffffff001bd24b [00021.930] 01048:26424> bt#07: end [00021.930] 01048:26424> {{{bt:0:0xffffffff0014b65b}}} [00021.930] 01048:26424> {{{bt:1:0xffffffff0014ba8f}}} [00021.930] 01048:26424> {{{bt:2:0xffffffff0014ba8f}}} [00021.930] 01048:26424> {{{bt:3:0xffffffff0013732e}}} [00021.930] 01048:26424> {{{bt:4:0xffffffff001f6db4}}} [00021.930] 01048:26424> {{{bt:5:0xffffffff001bd5fe}}} [00021.930] 01048:26424> {{{bt:6:0xffffffff001bd24b}}} [00021.930] 01048:26424> [00021.931] 01048:01051> [PASSED] (2 ms) [00021.931] 01048:01051> CASE lifecycle_tests [PASSED] [00021.931] 01048:01051> CASE pager_read_tests [STARTED] [00021.931] 01048:01051> single_page_test_vmar [RUNNING] [00021.935] 01048:01051> [PASSED] (4 ms) [00021.935] 01048:01051> single_page_test_vmo [RUNNING] [00021.938] 01048:01051> [PASSED] (2 ms) [00021.938] 01048:01051> presupply_test_vmar [RUNNING] [00021.942] 01048:01051> [PASSED] (3 ms) [00021.942] 01048:01051> presupply_test_vmo [RUNNING] [00021.946] 01048:01051> [PASSED] (4 ms) [00021.946] 01048:01051> early_supply_test_vmar [RUNNING] [00021.951] 01048:01051> [PASSED] (4 ms) [00021.951] 01048:01051> early_supply_test_vmo [RUNNING] [00021.957] 01048:01051> [PASSED] (6 ms) [00021.957] 01048:01051> sequential_multipage_test_vmar [RUNNING] [00021.964] 01048:01051> [PASSED] (6 ms) [00021.964] 01048:01051> sequential_multipage_test_vmo [RUNNING] [00021.970] 01048:01051> [PASSED] (6 ms) [00021.971] 01048:01051> concurrent_multipage_access_test_vmar [RUNNING] [00021.975] 01048:01051> [PASSED] (4 ms) [00021.975] 01048:01051> concurrent_multipage_access_test_vmo [RUNNING] [00021.977] 01048:01051> [PASSED] (2 ms) [00021.978] 01048:01051> concurrent_overlapping_access_test_vmar [RUNNING] [00022.065] 01048:01051> [PASSED] (87 ms) [00022.065] 01048:01051> concurrent_overlapping_access_test_vmo [RUNNING] [00022.159] 01048:01051> [PASSED] (93 ms) [00022.159] 01048:01051> bulk_single_supply_test_vmar [RUNNING] [00022.176] 01048:01051> [PASSED] (16 ms) [00022.176] 01048:01051> bulk_single_supply_test_vmo [RUNNING] [00022.200] 01048:01051> [PASSED] (23 ms) [00022.200] 01048:01051> bulk_odd_length_supply_test_vmar [RUNNING] [00022.474] 01048:01051> [PASSED] (274 ms) [00022.474] 01048:01051> bulk_odd_length_supply_test_vmo [RUNNING] [00022.709] 01048:01051> [PASSED] (234 ms) [00022.709] 01048:01051> bulk_odd_offset_supply_test_vmar [RUNNING] [00022.976] 01048:01051> [PASSED] (266 ms) [00022.976] 01048:01051> bulk_odd_offset_supply_test_vmo [RUNNING] [00023.249] 01048:01051> [PASSED] (272 ms) [00023.249] 01048:01051> overlap_supply_test_vmar [RUNNING] [00023.253] 01048:01051> [PASSED] (4 ms) [00023.253] 01048:01051> overlap_supply_test_vmo [RUNNING] [00023.255] 01048:01051> [PASSED] (2 ms) [00023.255] 01048:01051> many_request_test_vmar [RUNNING] [00023.923] 01048:01051> [PASSED] (667 ms) [00023.923] 01048:01051> many_request_test_vmo [RUNNING] [00024.095] 01048:01051> [PASSED] (171 ms) [00024.095] 01048:01051> successive_vmo_test [RUNNING] [00024.131] 01048:01051> [PASSED] (36 ms) [00024.131] 01048:01051> multiple_concurrent_vmo_test [RUNNING] [00024.139] 01048:01051> [PASSED] (7 ms) [00024.139] 01048:01051> vmar_unmap_test [RUNNING] [00024.139] 01048:34145> PageFault: 1027343 free pages [00024.139] 01048:34145> [00024.139] 01048:34145> ZIRCON KERNEL PANIC [00024.139] 01048:34145> Lock validation failed for thread 0xffffff8002de0138 pid 1048 tid 34145 (bin/core-tests:test_thread): [00024.139] 01048:34145> Reason: Already Acquired [00024.139] 01048:34145> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00024.139] 01048:34145> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00024.139] 01048:34145> caller=0xffffffff0014b65b frame=0xffffff945d330d60 [00024.139] 01048:34145> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00024.139] 01048:34145> [00024.139] 01048:34145> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00024.139] 01048:34145> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00024.139] 01048:34145> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00024.139] 01048:34145> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00024.139] 01048:34145> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00024.139] 01048:34145> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00024.139] 01048:34145> bt#00: 0xffffffff0014b65b [00024.139] 01048:34145> bt#01: 0xffffffff0014ba8f [00024.139] 01048:34145> bt#02: 0xffffffff0013732e [00024.139] 01048:34145> bt#03: 0xffffffff001f6db4 [00024.139] 01048:34145> bt#04: 0xffffffff001bd5fe [00024.139] 01048:34145> bt#05: 0xffffffff001bd24b [00024.139] 01048:34145> bt#06: end [00024.139] 01048:34145> {{{bt:0:0xffffffff0014b65b}}} [00024.139] 01048:34145> {{{bt:1:0xffffffff0014ba8f}}} [00024.139] 01048:34145> {{{bt:2:0xffffffff0013732e}}} [00024.139] 01048:34145> {{{bt:3:0xffffffff001f6db4}}} [00024.139] 01048:34145> {{{bt:4:0xffffffff001bd5fe}}} [00024.139] 01048:34145> {{{bt:5:0xffffffff001bd24b}}} [00024.139] 01048:34145> [00024.140] 01048:34145> [00024.140] 01048:34145> ZIRCON KERNEL PANIC [00024.140] 01048:34145> Lock validation failed for thread 0xffffff8002de0138 pid 1048 tid 34145 (bin/core-tests:test_thread): [00024.140] 01048:34145> Reason: Already Acquired [00024.140] 01048:34145> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00024.140] 01048:34145> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00024.140] 01048:34145> caller=0xffffffff0014b65b frame=0xffffff945d330cd0 [00024.140] 01048:34145> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00024.140] 01048:34145> [00024.140] 01048:34145> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00024.140] 01048:34145> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00024.140] 01048:34145> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00024.140] 01048:34145> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00024.140] 01048:34145> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00024.140] 01048:34145> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00024.140] 01048:34145> bt#00: 0xffffffff0014b65b [00024.140] 01048:34145> bt#01: 0xffffffff0014ba8f [00024.140] 01048:34145> bt#02: 0xffffffff0014ba8f [00024.140] 01048:34145> bt#03: 0xffffffff0013732e [00024.140] 01048:34145> bt#04: 0xffffffff001f6db4 [00024.140] 01048:34145> bt#05: 0xffffffff001bd5fe [00024.140] 01048:34145> bt#06: 0xffffffff001bd24b [00024.140] 01048:34145> bt#07: end [00024.140] 01048:34145> {{{bt:0:0xffffffff0014b65b}}} [00024.140] 01048:34145> {{{bt:1:0xffffffff0014ba8f}}} [00024.140] 01048:34145> {{{bt:2:0xffffffff0014ba8f}}} [00024.140] 01048:34145> {{{bt:3:0xffffffff0013732e}}} [00024.140] 01048:34145> {{{bt:4:0xffffffff001f6db4}}} [00024.140] 01048:34145> {{{bt:5:0xffffffff001bd5fe}}} [00024.140] 01048:34145> {{{bt:6:0xffffffff001bd24b}}} [00024.140] 01048:34145> [00024.140] 01048:34145> [00024.140] 01048:34145> ZIRCON KERNEL PANIC [00024.140] 01048:34145> Lock validation failed for thread 0xffffff8002de0138 pid 1048 tid 34145 (bin/core-tests:test_thread): [00024.140] 01048:34145> Reason: Already Acquired [00024.140] 01048:34145> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00024.140] 01048:34145> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00024.140] 01048:34145> caller=0xffffffff0014b65b frame=0xffffff945d330cd0 [00024.140] 01048:34145> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00024.140] 01048:34145> [00024.140] 01048:34145> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00024.140] 01048:34145> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00024.140] 01048:34145> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00024.140] 01048:34145> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00024.140] 01048:34145> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00024.140] 01048:34145> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00024.140] 01048:34145> bt#00: 0xffffffff0014b65b [00024.140] 01048:34145> bt#01: 0xffffffff0014ba8f [00024.140] 01048:34145> bt#02: 0xffffffff0014ba8f [00024.140] 01048:34145> bt#03: 0xffffffff0013732e [00024.140] 01048:34145> bt#04: 0xffffffff001f6db4 [00024.140] 01048:34145> bt#05: 0xffffffff001bd5fe [00024.140] 01048:34145> bt#06: 0xffffffff001bd24b [00024.140] 01048:34145> bt#07: end [00024.140] 01048:34145> {{{bt:0:0xffffffff0014b65b}}} [00024.140] 01048:34145> {{{bt:1:0xffffffff0014ba8f}}} [00024.140] 01048:34145> {{{bt:2:0xffffffff0014ba8f}}} [00024.140] 01048:34145> {{{bt:3:0xffffffff0013732e}}} [00024.140] 01048:34145> {{{bt:4:0xffffffff001f6db4}}} [00024.140] 01048:34145> {{{bt:5:0xffffffff001bd5fe}}} [00024.140] 01048:34145> {{{bt:6:0xffffffff001bd24b}}} [00024.140] 01048:34145> [00024.141] 01048:01051> [PASSED] (2 ms) [00024.141] 01048:01051> vmar_remap_test [RUNNING] [00024.167] 01048:01051> [PASSED] (25 ms) [00024.167] 01048:01051> vmar_map_range_test [RUNNING] [00024.174] 01048:01051> [PASSED] (6 ms) [00024.174] 01048:01051> read_resize_test_vmar [RUNNING] [00024.177] 01048:01051> [PASSED] (3 ms) [00024.177] 01048:01051> read_resize_test_vmo [RUNNING] [00024.181] 01048:01051> [PASSED] (3 ms) [00024.181] 01048:01051> suspend_read_test_vmar [RUNNING] [00024.183] 01048:01051> [PASSED] (1 ms) [00024.183] 01048:01051> suspend_read_test_vmo [RUNNING] [00024.186] 01048:01051> [PASSED] (3 ms) [00024.186] 01048:01051> CASE pager_read_tests [PASSED] [00024.186] 01048:01051> CASE object_get_child_tests [STARTED] [00024.186] 01048:01051> handle_invalid [RUNNING] [00024.186] 01048:01051> [PASSED] (0 ms) [00024.186] 01048:01051> CASE object_get_child_tests [PASSED] [00024.186] 01048:01051> CASE memory_mapping_tests [STARTED] [00024.186] 01048:01051> address_space_limits_test [RUNNING] [00024.186] 01048:01051> [PASSED] (0 ms) [00024.186] 01048:01051> mmap_zerofilled_test [RUNNING] [00024.186] 01048:01051> [PASSED] (0 ms) [00024.186] 01048:01051> mmap_len_test [RUNNING] [00024.186] 01048:01051> [PASSED] (0 ms) [00024.186] 01048:01051> mmap_PROT_EXEC_test [RUNNING] [00024.186] 01048:01051> [PASSED] (0 ms) [00024.186] 01048:01051> mmap_offset_test [RUNNING] [00024.186] 01048:01051> [PASSED] (0 ms) [00024.186] 01048:01051> mmap_prot_test [RUNNING] [00024.186] 01048:01051> [PASSED] (0 ms) [00024.186] 01048:01051> mmap_flags_test [RUNNING] [00024.186] 01048:01051> [PASSED] (0 ms) [00024.186] 01048:01051> mprotect_test [RUNNING] [00024.187] 01048:01051> [00024.187] 01048:01051> ZIRCON KERNEL PANIC [00024.188] 01048:01051> Lock validation failed for thread 0xffffff800074e978 pid 1048 tid 1051 (bin/core-tests:bin/core-tests): [00024.188] 01048:01051> Reason: Already Acquired [00024.188] 01048:01051> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00024.188] 01048:01051> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00024.188] 01048:01051> caller=0xffffffff0014b65b frame=0xffffff945a283d50 [00024.188] 01048:01051> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00024.188] 01048:01051> [00024.188] 01048:01051> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00024.188] 01048:01051> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00024.188] 01048:01051> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00024.188] 01048:01051> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00024.188] 01048:01051> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00024.188] 01048:01051> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00024.188] 01048:01051> bt#00: 0xffffffff0014b65b [00024.188] 01048:01051> bt#01: 0xffffffff0014ba8f [00024.188] 01048:01051> bt#02: 0xffffffff0014cc92 [00024.188] 01048:01051> bt#03: 0xffffffff00140196 [00024.188] 01048:01051> bt#04: 0xffffffff0015676b [00024.188] 01048:01051> bt#05: 0xffffffff00146448 [00024.188] 01048:01051> bt#06: 0xffffffff0020c34e [00024.188] 01048:01051> bt#07: 0xffffffff0021bd2a [00024.188] 01048:01051> bt#08: 0xffffffff001ce63b [00024.188] 01048:01051> bt#09: end [00024.188] 01048:01051> {{{bt:0:0xffffffff0014b65b}}} [00024.188] 01048:01051> {{{bt:1:0xffffffff0014ba8f}}} [00024.188] 01048:01051> {{{bt:2:0xffffffff0014cc92}}} [00024.188] 01048:01051> {{{bt:3:0xffffffff00140196}}} [00024.188] 01048:01051> {{{bt:4:0xffffffff0015676b}}} [00024.188] 01048:01051> {{{bt:5:0xffffffff00146448}}} [00024.188] 01048:01051> {{{bt:6:0xffffffff0020c34e}}} [00024.188] 01048:01051> {{{bt:7:0xffffffff0021bd2a}}} [00024.188] 01048:01051> {{{bt:8:0xffffffff001ce63b}}} [00024.188] 01048:01051> [00024.188] 01048:01051> [PASSED] (1 ms) [00024.188] 01048:01051> CASE memory_mapping_tests [PASSED] [00024.188] 01048:01051> CASE job_tests [STARTED] [00024.188] 01048:01051> basic_test [RUNNING] [00024.188] 01048:01051> [PASSED] (0 ms) [00024.188] 01048:01051> create_missing_rights_test [RUNNING] [00024.188] 01048:01051> [PASSED] (0 ms) [00024.188] 01048:01051> policy_invalid_topic_test [RUNNING] [00024.188] 01048:01051> [PASSED] (0 ms) [00024.188] 01048:01051> policy_basic_test [RUNNING] [00024.188] 01048:01051> [PASSED] (0 ms) [00024.188] 01048:01051> policy_timer_slack_invalid_options_test [RUNNING] [00024.188] 01048:01051> [PASSED] (0 ms) [00024.188] 01048:01051> policy_timer_slack_invalid_count_test [RUNNING] [00024.188] 01048:01051> [PASSED] (0 ms) [00024.188] 01048:01051> policy_timer_slack_invalid_policy_test [RUNNING] [00024.188] 01048:01051> [PASSED] (0 ms) [00024.188] 01048:01051> policy_timer_slack_non_empty_test [RUNNING] [00024.188] 01048:01051> [PASSED] (0 ms) [00024.188] 01048:01051> policy_timer_slack_valid [RUNNING] [00024.188] 01048:01051> [PASSED] (0 ms) [00024.188] 01048:01051> create_test [RUNNING] [00024.188] 01048:01051> [PASSED] (0 ms) [00024.188] 01048:01051> kill_test [RUNNING] [00024.195] 01048:01051> [PASSED] (6 ms) [00024.195] 01048:01051> kill_job_no_child_test [RUNNING] [00024.195] 01048:01051> [PASSED] (0 ms) [00024.195] 01048:01051> set_job_oom_kill_bit [RUNNING] [00024.195] 01048:01051> [PASSED] (0 ms) [00024.195] 01048:01051> wait_test [RUNNING] [00024.203] 01048:01051> [PASSED] (8 ms) [00024.203] 01048:01051> info_task_stats_fails [RUNNING] [00024.203] 01048:01051> [PASSED] (0 ms) [00024.203] 01048:01051> max_height_smoke [RUNNING] [00024.203] 01048:01051> [PASSED] (0 ms) [00024.203] 01048:01051> CASE job_tests [PASSED] [00024.203] 01048:01051> CASE handle_wait_tests [STARTED] [00024.203] 01048:01051> handle_wait_test [RUNNING] [00024.205] 01048:01051> [PASSED] (1 ms) [00024.205] 01048:01051> CASE handle_wait_tests [PASSED] [00024.205] 01048:01051> CASE handle_transfer_tests [STARTED] [00024.205] 01048:01051> handle_transfer_test [RUNNING] [00024.205] 01048:01051> [PASSED] (0 ms) [00024.205] 01048:01051> handle_transfer_cancel_wait_test [RUNNING] [00024.223] 01048:01051> [PASSED] (18 ms) [00024.223] 01048:01051> CASE handle_transfer_tests [PASSED] [00024.223] 01048:01051> CASE eventpair_tests [STARTED] [00024.223] 01048:01051> create_test [RUNNING] [00024.223] 01048:01051> [PASSED] (0 ms) [00024.223] 01048:01051> signal_test [RUNNING] [00024.223] 01048:01051> [PASSED] (0 ms) [00024.223] 01048:01051> signal_peer_test [RUNNING] [00024.223] 01048:01051> [PASSED] (0 ms) [00024.223] 01048:01051> signal_peer_closed_test [RUNNING] [00024.223] 01048:01051> [PASSED] (0 ms) [00024.223] 01048:01051> CASE eventpair_tests [PASSED] [00024.223] 01048:01051> CASE elf_tls_tests [STARTED] [00024.223] 01048:01051> ExecutableTlsTest [RUNNING] [00025.320] 01048:01051> [PASSED] (1096 ms) [00025.320] 01048:01051> CASE elf_tls_tests [PASSED] [00025.320] 01048:01051> CASE channel_tests [STARTED] [00025.320] 01048:01051> channel_test [RUNNING] [00025.321] 01048:01051> [PASSED] (0 ms) [00025.321] 01048:01051> channel_read_error_test [RUNNING] [00025.321] 01048:01051> [PASSED] (0 ms) [00025.321] 01048:01051> channel_close_test [RUNNING] [00025.321] 01048:01051> [PASSED] (0 ms) [00025.321] 01048:01051> channel_peer_closed_test [RUNNING] [00025.321] 01048:01051> [PASSED] (0 ms) [00025.321] 01048:01051> channel_non_transferable [RUNNING] [00025.321] 01048:01051> [PASSED] (0 ms) [00025.321] 01048:01051> channel_duplicate_handles [RUNNING] [00025.321] 01048:01051> [PASSED] (0 ms) [00025.321] 01048:01051> channel_multithread_read [RUNNING] [00025.474] 01048:01051> [PASSED] (153 ms) [00025.474] 01048:01051> channel_may_discard [RUNNING] [00025.474] 01048:01051> [PASSED] (0 ms) [00025.474] 01048:01051> channel_call [RUNNING] [00025.477] 01048:01051> [PASSED] (2 ms) [00025.477] 01048:01051> channel_call_consumes_handles [RUNNING] [00025.477] 01048:01051> [PASSED] (0 ms) [00025.477] 01048:01051> channel_call2 [RUNNING] [00025.745] 01048:01051> [PASSED] (267 ms) [00025.745] 01048:01051> bad_channel_call_finish [RUNNING] [00025.745] 01048:01051> [PASSED] (0 ms) [00025.745] 01048:01051> channel_nest [RUNNING] [00025.746] 01048:01051> [PASSED] (0 ms) [00025.746] 01048:01051> channel_disallow_write_to_self [RUNNING] [00025.746] 01048:01051> [PASSED] (0 ms) [00025.746] 01048:01051> channel_read_etc [RUNNING] [00025.746] 01048:01051> [PASSED] (0 ms) [00025.746] 01048:01051> channel_write_different_sizes [RUNNING] [00025.831] 01048:01051> [PASSED] (84 ms) [00025.831] 01048:01051> channel_write_takes_all_handles [RUNNING] [00025.832] 01048:01051> [PASSED] (1 ms) [00025.832] 01048:01051> CASE channel_tests [PASSED] [00025.832] 01048:01051> CASE c11_thread_tests [STARTED] [00025.832] 01048:01051> c11_thread_test [RUNNING] [00026.638] 01048:01051> [PASSED] (806 ms) [00026.638] 01048:01051> long_name_succeeds [RUNNING] [00026.740] 01048:01051> [PASSED] (101 ms) [00026.740] 01048:01051> detach_self_test [RUNNING] [00027.584] 01048:01051> [PASSED] (844 ms) [00027.584] 01048:01051> CASE c11_thread_tests [PASSED] [00027.584] 01048:01051> CASE mtx_tests [STARTED] [00027.584] 01048:01051> test_initializer [RUNNING] [00027.584] 01048:01051> [PASSED] (0 ms) [00027.584] 01048:01051> test_mutexes [RUNNING] [00027.694] 01048:01051> [PASSED] (110 ms) [00027.694] 01048:01051> test_try_mutexes [RUNNING] [00027.781] 01048:01051> [PASSED] (86 ms) [00027.781] 01048:01051> test_static_initializer [RUNNING] [00027.781] 01048:01051> [PASSED] (0 ms) [00027.781] 01048:01051> test_timeout_elapsed [RUNNING] [00028.298] 01048:01051> [PASSED] (517 ms) [00028.298] 01048:01051> CASE mtx_tests [PASSED] [00028.298] 01048:01051> CASE cnd_tests [STARTED] [00028.298] 01048:01051> cnd_test [RUNNING] [00028.319] 01048:01051> [PASSED] (20 ms) [00028.319] 01048:01051> cnd_timedwait_timeout_test [RUNNING] [00028.320] 01048:01051> [PASSED] (1 ms) [00028.320] 01048:01051> CASE cnd_tests [PASSED] [00028.320] 01048:01051> CASE bad_syscall_tests [STARTED] [00028.320] 01048:01051> bad_access_test [RUNNING] [00028.320] 01048:01051> [PASSED] (0 ms) [00028.320] 01048:01051> bad_syscall_num_test [RUNNING] [00028.323] 01048:01051> [PASSED] (2 ms) [00028.323] 01048:01051> CASE bad_syscall_tests [PASSED] [00028.323] 01048:01051> ==================================================== [00028.323] 01048:01051> Results: [00028.323] 01048:01051> SUCCESS! All test cases passed! [00028.323] 01048:01051> CASES: 34 SUCCESS: 34 FAILED: 0 [00028.323] 01048:01051> ==================================================== [00028.323] 01048:01051> Flags: [00028.323] 01048:01051> --gtest_random_seed = 28 [00028.323] 01048:01051> [00028.323] 01048:01051> [00028.323] 01048:01051> [==========] Running 240 tests from 12 test cases [00028.323] 01048:01051> . [00028.323] 01048:01051> [----------] Global test environment set-up. [00028.323] 01048:01051> [----------] 1 test from ClockTest [00028.323] 01048:01051> [00028.323] 01048:01051> [ RUN ] ClockTest.ClockMonotonic [00028.323] 01048:01051> [00028.438] 01048:01051> [ OK ] ClockTest.ClockMonotonic (114 [00028.438] 01048:01051> ms) [00028.438] 01048:01051> [----------] 1 test from ClockTest (114 [00028.438] 01048:01051> ms total) [00028.438] 01048:01051> [----------] 9 tests from FifoTest [00028.438] 01048:01051> [00028.438] 01048:01051> [ RUN ] FifoTest.InvalidParametersReturnOutOfRange [00028.438] 01048:01051> [00028.438] 01048:01051> [ OK ] FifoTest.InvalidParametersReturnOutOfRange (0 [00028.438] 01048:01051> ms) [00028.438] 01048:01051> [ RUN ] FifoTest.EndpointsAreRelated [00028.438] 01048:01051> [00028.438] 01048:01051> [ OK ] FifoTest.EndpointsAreRelated (0 [00028.438] 01048:01051> ms) [00028.438] 01048:01051> [ RUN ] FifoTest.EmptyQueueReturnsErrShouldWait [00028.438] 01048:01051> [00028.438] 01048:01051> [ OK ] FifoTest.EmptyQueueReturnsErrShouldWait (0 [00028.438] 01048:01051> ms) [00028.438] 01048:01051> [ RUN ] FifoTest.ReadAndWriteValidatesSizeAndElementCount [00028.438] 01048:01051> [00028.438] 01048:01051> [ OK ] FifoTest.ReadAndWriteValidatesSizeAndElementCount (0 [00028.438] 01048:01051> ms) [00028.438] 01048:01051> [ RUN ] FifoTest.DequeueSignalsWriteable [00028.438] 01048:01051> [00028.438] 01048:01051> [ OK ] FifoTest.DequeueSignalsWriteable (0 [00028.438] 01048:01051> ms) [00028.438] 01048:01051> [ RUN ] FifoTest.FifoOrderIsPreserved [00028.438] 01048:01051> [00028.438] 01048:01051> [ OK ] FifoTest.FifoOrderIsPreserved (0 [00028.438] 01048:01051> ms) [00028.438] 01048:01051> [ RUN ] FifoTest.PartialWriteQueuesElementsThatFit [00028.438] 01048:01051> [00028.438] 01048:01051> [ OK ] FifoTest.PartialWriteQueuesElementsThatFit (0 [00028.438] 01048:01051> ms) [00028.438] 01048:01051> [ RUN ] FifoTest.IndividualReadsPreserveOrder [00028.438] 01048:01051> [00028.438] 01048:01051> [ OK ] FifoTest.IndividualReadsPreserveOrder (0 [00028.438] 01048:01051> ms) [00028.438] 01048:01051> [ RUN ] FifoTest.EndpointCloseSignalsPeerClosed [00028.438] 01048:01051> [00028.438] 01048:01051> [ OK ] FifoTest.EndpointCloseSignalsPeerClosed (0 [00028.438] 01048:01051> ms) [00028.438] 01048:01051> [----------] 9 tests from FifoTest (0 [00028.438] 01048:01051> ms total) [00028.438] 01048:01051> [----------] 15 tests from FutexTest [00028.438] 01048:01051> [00028.438] 01048:01051> [ RUN ] FutexTest.WaitValueMismatch [00028.438] 01048:01051> [00028.438] 01048:01051> [ OK ] FutexTest.WaitValueMismatch (0 [00028.438] 01048:01051> ms) [00028.438] 01048:01051> [ RUN ] FutexTest.WaitTimeout [00028.438] 01048:01051> [00028.438] 01048:01051> [ OK ] FutexTest.WaitTimeout (0 [00028.438] 01048:01051> ms) [00028.438] 01048:01051> [ RUN ] FutexTest.WaitTimeoutElapsed [00028.438] 01048:01051> [00028.939] 01048:01051> [ OK ] FutexTest.WaitTimeoutElapsed (501 [00028.939] 01048:01051> ms) [00028.939] 01048:01051> [ RUN ] FutexTest.WaitBadAddress [00028.939] 01048:01051> [00028.939] 01048:01051> [ OK ] FutexTest.WaitBadAddress (0 [00028.939] 01048:01051> ms) [00028.939] 01048:01051> [ RUN ] FutexTest.Wakeup [00028.939] 01048:01051> [00028.946] 01048:01051> [ OK ] FutexTest.Wakeup (6 [00028.946] 01048:01051> ms) [00028.946] 01048:01051> [ RUN ] FutexTest.WakeupLimit [00028.946] 01048:01051> [00029.550] 01048:01051> [ OK ] FutexTest.WakeupLimit (603 [00029.550] 01048:01051> ms) [00029.550] 01048:01051> [ RUN ] FutexTest.WakeupAddress [00029.550] 01048:01051> [00029.559] 01048:01051> [ OK ] FutexTest.WakeupAddress (9 [00029.559] 01048:01051> ms) [00029.559] 01048:01051> [ RUN ] FutexTest.RequeueValueMismatch [00029.559] 01048:01051> [00029.559] 01048:01051> [ OK ] FutexTest.RequeueValueMismatch (0 [00029.559] 01048:01051> ms) [00029.559] 01048:01051> [ RUN ] FutexTest.RequeueSameAddr [00029.559] 01048:01051> [00029.559] 01048:01051> [ OK ] FutexTest.RequeueSameAddr (0 [00029.559] 01048:01051> ms) [00029.559] 01048:01051> [ RUN ] FutexTest.Requeue [00029.559] 01048:01051> [00030.467] 01048:01051> [ OK ] FutexTest.Requeue (907 [00030.467] 01048:01051> ms) [00030.467] 01048:01051> [ RUN ] FutexTest.RequeueUnqueuedOnTimeout [00030.467] 01048:01051> [00030.769] 01048:01051> [ OK ] FutexTest.RequeueUnqueuedOnTimeout (301 [00030.769] 01048:01051> ms) [00030.769] 01048:01051> [ RUN ] FutexTest.ThreadKilled [00030.769] 01048:01051> [00030.769] 01048:01051> [ OK ] FutexTest.ThreadKilled (0 [00030.769] 01048:01051> ms) [00030.769] 01048:01051> [ RUN ] FutexTest.ThreadSuspended [00030.769] 01048:01051> [00031.071] 01048:01051> [ OK ] FutexTest.ThreadSuspended (301 [00031.071] 01048:01051> ms) [00031.071] 01048:01051> [ RUN ] FutexTest.MisalignedFutextAddr [00031.071] 01048:01051> [00031.071] 01048:01051> [ OK ] FutexTest.MisalignedFutextAddr (0 [00031.071] 01048:01051> ms) [00031.071] 01048:01051> [ RUN ] FutexTest.EventSignaling [00031.071] 01048:01051> [00031.071] 01048:01051> [00000031.71253928]: starting signal threads [00031.071] 01048:106682> [00000031.71548226]: thread 1 waiting on event [00031.071] 01048:106692> [00000031.71717753]: thread 3 waiting on event [00031.071] 01048:106687> [00000031.71869455]: thread 2 waiting on event [00031.071] 01048:01051> [00000031.71947705]: signaling event [00031.072] 01048:01051> [00000031.72032588]: joining signal threads [00031.072] 01048:106692> [00000031.72084548]: thread 3 done [00031.072] 01048:106682> [00000031.72154927]: thread 1 done [00031.072] 01048:106687> [00000031.72438155]: thread 2 done [00031.075] 01048:01051> [00000031.75437623]: signal_thread 1 joined [00031.075] 01048:01051> [00000031.75492775]: signal_thread 2 joined [00031.075] 01048:01051> [00000031.75505850]: signal_thread 3 joined [00031.075] 01048:01051> [ OK ] FutexTest.EventSignaling (4 [00031.075] 01048:01051> ms) [00031.075] 01048:01051> [----------] 15 tests from FutexTest (2636 [00031.075] 01048:01051> ms total) [00031.075] 01048:01051> [----------] 3 tests from HandleCloseTest [00031.075] 01048:01051> [00031.075] 01048:01051> [ RUN ] HandleCloseTest.Many [00031.075] 01048:01051> [00031.075] 01048:01051> [ OK ] HandleCloseTest.Many (0 [00031.075] 01048:01051> ms) [00031.075] 01048:01051> [ RUN ] HandleCloseTest.ManyInvalidHandlesShouldNotFail [00031.075] 01048:01051> [00031.075] 01048:01051> [ OK ] HandleCloseTest.ManyInvalidHandlesShouldNotFail (0 [00031.075] 01048:01051> ms) [00031.075] 01048:01051> [ RUN ] HandleCloseTest.ManyDuplicateTest [00031.075] 01048:01051> [00031.075] 01048:01051> [ OK ] HandleCloseTest.ManyDuplicateTest (0 [00031.075] 01048:01051> ms) [00031.075] 01048:01051> [----------] 3 tests from HandleCloseTest (0 [00031.075] 01048:01051> ms total) [00031.075] 01048:01051> [----------] 6 tests from HandleInfoTest [00031.075] 01048:01051> [00031.075] 01048:01051> [ RUN ] HandleInfoTest.ReplaceSuccessOrigInvalid [00031.075] 01048:01051> [00031.075] 01048:01051> [ OK ] HandleInfoTest.ReplaceSuccessOrigInvalid (0 [00031.075] 01048:01051> ms) [00031.075] 01048:01051> [ RUN ] HandleInfoTest.ReplaceFailureBothInvalid [00031.075] 01048:01051> [00031.075] 01048:01051> [ OK ] HandleInfoTest.ReplaceFailureBothInvalid (0 [00031.075] 01048:01051> ms) [00031.075] 01048:01051> [ RUN ] HandleInfoTest.DupAndInfoRights [00031.075] 01048:01051> [00031.075] 01048:01051> [ OK ] HandleInfoTest.DupAndInfoRights (0 [00031.075] 01048:01051> ms) [00031.075] 01048:01051> [ RUN ] HandleInfoTest.RelatedKoid [00031.075] 01048:01051> [00031.244] 01048:01051> [ OK ] HandleInfoTest.RelatedKoid (169 [00031.244] 01048:01051> ms) [00031.244] 01048:01051> [ RUN ] HandleInfoTest.DuplicateRights [00031.244] 01048:01051> [00031.244] 01048:01051> [ OK ] HandleInfoTest.DuplicateRights (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] HandleInfoTest.ReplaceRights [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] HandleInfoTest.ReplaceRights (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [----------] 6 tests from HandleInfoTest (169 [00031.245] 01048:01051> ms total) [00031.245] 01048:01051> [----------] 4 tests from ObjectGetInfoTest [00031.245] 01048:01051> [00031.245] 01048:01051> [ RUN ] ObjectGetInfoTest.OpenValidHandleSuceeds [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] ObjectGetInfoTest.OpenValidHandleSuceeds (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] ObjectGetInfoTest.ClosedValidHandleFails [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] ObjectGetInfoTest.ClosedValidHandleFails (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] ObjectGetInfoTest.HandleCountCorrectness [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] ObjectGetInfoTest.HandleCountCorrectness (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] ObjectGetInfoTest.InvalidHandleFails [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] ObjectGetInfoTest.InvalidHandleFails (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [----------] 4 tests from ObjectGetInfoTest (0 [00031.245] 01048:01051> ms total) [00031.245] 01048:01051> [----------] 39 tests from JobGetInfoTest [00031.245] 01048:01051> [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesGetChild [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesGetChild (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildJobsGetChild [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildJobsGetChild (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesOnSelfSuceeds [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesOnSelfSuceeds (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesInvalidHandleFails [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesInvalidHandleFails (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesNullAvailSucceeds [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesNullAvailSucceeds (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesNullActualSucceeds [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesNullActualSucceeds (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesNullActualAndAvailSucceeds [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesNullActualAndAvailSucceeds (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesInvalidBufferPointerFails [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesInvalidBufferPointerFails (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesBadActualgIsInvalidArg [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesBadActualgIsInvalidArg (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesBadAvailIsInvalidArg [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesBadAvailIsInvalidArg (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesZeroSizedBufferIsOk [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesZeroSizedBufferIsOk (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesSmallBufferIsOk [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesSmallBufferIsOk (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesPartiallyUnmappedBufferIsInvalidArgs [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesPartiallyUnmappedBufferIsInvalidArgs (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesRequiresEnumerateRights [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesRequiresEnumerateRights (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesProcessbHandleIsBadHandle [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesProcessbHandleIsBadHandle (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesThreadHandleIsBadHandle [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesThreadHandleIsBadHandle (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenOnSelfSuceeds [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenOnSelfSuceeds (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenInvalidHandleFails [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenInvalidHandleFails (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenNullAvailSucceeds [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenNullAvailSucceeds (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenNullActualSucceeds [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenNullActualSucceeds (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenNullActualAndAvailSucceeds [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenNullActualAndAvailSucceeds (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenInvalidBufferPointerFails [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenInvalidBufferPointerFails (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenBadActualgIsInvalidArg [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenBadActualgIsInvalidArg (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenBadAvailIsInvalidArg [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenBadAvailIsInvalidArg (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenZeroSizedBufferIsOk [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenZeroSizedBufferIsOk (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenSmallBufferIsOk [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenSmallBufferIsOk (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenPartiallyUnmappedBufferIsInvalidArgs [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenPartiallyUnmappedBufferIsInvalidArgs (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenRequiresEnumerateRights [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenRequiresEnumerateRights (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenJobHandleIsBadHandle [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenJobHandleIsBadHandle (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenThreadHandleIsBadHandle [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenThreadHandleIsBadHandle (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoHandleBasicOnSelfSuceeds [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoHandleBasicOnSelfSuceeds (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoHandleBasicInvalidHandleFails [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoHandleBasicInvalidHandleFails (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoHandleBasicNullAvailSucceeds [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoHandleBasicNullAvailSucceeds (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoHandleBasicNullActualSucceeds [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoHandleBasicNullActualSucceeds (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoHandleBasicInvalidBufferPointerFails [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoHandleBasicInvalidBufferPointerFails (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [ RUN ] JobGetInfoTest.InfoHandleBasicZeroSizedBufferFails [00031.245] 01048:01051> [00031.245] 01048:01051> [ OK ] JobGetInfoTest.InfoHandleBasicZeroSizedBufferFails (0 [00031.245] 01048:01051> ms) [00031.245] 01048:01051> [----------] 39 tests from JobGetInfoTest (0 [00031.245] 01048:01051> ms total) [00031.245] 01048:01051> [----------] 61 tests from ProcessGetInfoTest [00031.245] 01048:01051> [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsUnstartedSuceeds [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsUnstartedSuceeds (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsSmokeTest [00031.246] 01048:01051> [00031.246] 01048:01051> [00031.246] 01048:01051> ZIRCON KERNEL PANIC [00031.246] 01048:01051> Lock validation failed for thread 0xffffff800074e978 pid 1048 tid 1051 (bin/core-tests:bin/core-tests): [00031.246] 01048:01051> Reason: Already Acquired [00031.246] 01048:01051> Bad lock: name=lockdep::LockClass<VmAspace, Mutex, 199, lockdep::LockFlagsNone> order=0 [00031.246] 01048:01051> Conflict: name=lockdep::LockClass<VmAspace, Mutex, 199, lockdep::LockFlagsNone> order=0 [00031.246] 01048:01051> caller=0xffffffff001e5e5c frame=0xffffff945a283b50 [00031.246] 01048:01051> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00031.246] 01048:01051> [00031.246] 01048:01051> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00031.246] 01048:01051> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00031.246] 01048:01051> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00031.246] 01048:01051> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00031.246] 01048:01051> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00031.246] 01048:01051> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00031.246] 01048:01051> bt#00: 0xffffffff001e5e5c [00031.246] 01048:01051> bt#01: 0xffffffff001f6d82 [00031.246] 01048:01051> bt#02: 0xffffffff001bd5fe [00031.246] 01048:01051> bt#03: 0xffffffff001bd24b [00031.246] 01048:01051> bt#04: 0xffffffff00138351 [00031.246] 01048:01051> bt#05: 0xffffffff001dffe8 [00031.246] 01048:01051> bt#06: 0xffffffff001e6176 [00031.246] 01048:01051> bt#07: 0xffffffff00136c1f [00031.246] 01048:01051> bt#08: 0xffffffff0015ba68 [00031.246] 01048:01051> bt#09: 0xffffffff0020dcac [00031.246] 01048:01051> bt#10: 0xffffffff0021d048 [00031.246] 01048:01051> bt#11: 0xffffffff001ce708 [00031.246] 01048:01051> bt#12: end [00031.246] 01048:01051> {{{bt:0:0xffffffff001e5e5c}}} [00031.246] 01048:01051> {{{bt:1:0xffffffff001f6d82}}} [00031.246] 01048:01051> {{{bt:2:0xffffffff001bd5fe}}} [00031.246] 01048:01051> {{{bt:3:0xffffffff001bd24b}}} [00031.246] 01048:01051> {{{bt:4:0xffffffff00138351}}} [00031.246] 01048:01051> {{{bt:5:0xffffffff001dffe8}}} [00031.246] 01048:01051> {{{bt:6:0xffffffff001e6176}}} [00031.246] 01048:01051> {{{bt:7:0xffffffff00136c1f}}} [00031.246] 01048:01051> {{{bt:8:0xffffffff0015ba68}}} [00031.246] 01048:01051> {{{bt:9:0xffffffff0020dcac}}} [00031.246] 01048:01051> {{{bt:10:0xffffffff0021d048}}} [00031.246] 01048:01051> {{{bt:11:0xffffffff001ce708}}} [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsSmokeTest (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessHandleStats [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessHandleStats (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsOnSelfFails [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsOnSelfFails (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsInvalidHandleFails [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsInvalidHandleFails (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsNullAvailSucceeds [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsNullAvailSucceeds (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsNullActualSucceeds [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsNullActualSucceeds (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsNullActualAndAvailSucceeds [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsNullActualAndAvailSucceeds (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsInvalidBufferPointerFails [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsInvalidBufferPointerFails (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsBadActualgIsInvalidArg [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsBadActualgIsInvalidArg (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsBadAvailIsInvalidArg [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsBadAvailIsInvalidArg (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsZeroSizedBufferIsOk [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsZeroSizedBufferIsOk (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsSmallBufferIsOk [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsSmallBufferIsOk (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsPartiallyUnmappedBufferIsInvalidArgs [00031.246] 01048:01051> [00031.246] 01048:01051> [00031.246] 01048:01051> ZIRCON KERNEL PANIC [00031.246] 01048:01051> Lock validation failed for thread 0xffffff800074e978 pid 1048 tid 1051 (bin/core-tests:bin/core-tests): [00031.246] 01048:01051> Reason: Already Acquired [00031.246] 01048:01051> Bad lock: name=lockdep::LockClass<VmAspace, Mutex, 199, lockdep::LockFlagsNone> order=0 [00031.246] 01048:01051> Conflict: name=lockdep::LockClass<VmAspace, Mutex, 199, lockdep::LockFlagsNone> order=0 [00031.246] 01048:01051> caller=0xffffffff001e5e5c frame=0xffffff945a283bd0 [00031.246] 01048:01051> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00031.246] 01048:01051> [00031.246] 01048:01051> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00031.246] 01048:01051> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00031.246] 01048:01051> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00031.246] 01048:01051> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00031.246] 01048:01051> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00031.246] 01048:01051> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00031.246] 01048:01051> bt#00: 0xffffffff001e5e5c [00031.246] 01048:01051> bt#01: 0xffffffff001f6d82 [00031.246] 01048:01051> bt#02: 0xffffffff001bd5fe [00031.246] 01048:01051> bt#03: 0xffffffff001bd24b [00031.246] 01048:01051> bt#04: 0xffffffff00138195 [00031.246] 01048:01051> bt#05: 0xffffffff001e615c [00031.246] 01048:01051> bt#06: 0xffffffff00136c1f [00031.246] 01048:01051> bt#07: 0xffffffff0015ba68 [00031.246] 01048:01051> bt#08: 0xffffffff0020dcac [00031.246] 01048:01051> bt#09: 0xffffffff0021d048 [00031.246] 01048:01051> bt#10: 0xffffffff001ce708 [00031.246] 01048:01051> bt#11: end [00031.246] 01048:01051> {{{bt:0:0xffffffff001e5e5c}}} [00031.246] 01048:01051> {{{bt:1:0xffffffff001f6d82}}} [00031.246] 01048:01051> {{{bt:2:0xffffffff001bd5fe}}} [00031.246] 01048:01051> {{{bt:3:0xffffffff001bd24b}}} [00031.246] 01048:01051> {{{bt:4:0xffffffff00138195}}} [00031.246] 01048:01051> {{{bt:5:0xffffffff001e615c}}} [00031.246] 01048:01051> {{{bt:6:0xffffffff00136c1f}}} [00031.246] 01048:01051> {{{bt:7:0xffffffff0015ba68}}} [00031.246] 01048:01051> {{{bt:8:0xffffffff0020dcac}}} [00031.246] 01048:01051> {{{bt:9:0xffffffff0021d048}}} [00031.246] 01048:01051> {{{bt:10:0xffffffff001ce708}}} [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsPartiallyUnmappedBufferIsInvalidArgs (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsRequiresInspectRights [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsRequiresInspectRights (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsJobHandleIsBadHandle [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsJobHandleIsBadHandle (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsThreadHandleIsBadHandle [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsThreadHandleIsBadHandle (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosSmokeTest [00031.246] 01048:01051> [00031.246] 01048:01051> [00031.246] 01048:01051> ZIRCON KERNEL PANIC [00031.246] 01048:01051> Lock validation failed for thread 0xffffff800074e978 pid 1048 tid 1051 (bin/core-tests:bin/core-tests): [00031.246] 01048:01051> Reason: Out Of Order [00031.246] 01048:01051> Bad lock: name=lockdep::LockClass<ProcessDispatcher, BrwLock, 360, lockdep::LockFlagsNone> order=0 [00031.246] 01048:01051> Conflict: name=lockdep::LockClass<SoloDispatcher<ProcessDispatcher, 447439, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00031.246] 01048:01051> caller=0xffffffff00136f06 frame=0xffffff945a283de0 [00031.246] 01048:01051> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00031.246] 01048:01051> [00031.246] 01048:01051> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00031.246] 01048:01051> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00031.246] 01048:01051> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00031.246] 01048:01051> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00031.246] 01048:01051> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00031.246] 01048:01051> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00031.246] 01048:01051> bt#00: 0xffffffff00136f06 [00031.246] 01048:01051> bt#01: 0xffffffff0015bc2d [00031.246] 01048:01051> bt#02: 0xffffffff0020df88 [00031.246] 01048:01051> bt#03: 0xffffffff0021d048 [00031.246] 01048:01051> bt#04: 0xffffffff001ce708 [00031.246] 01048:01051> bt#05: end [00031.246] 01048:01051> {{{bt:0:0xffffffff00136f06}}} [00031.246] 01048:01051> {{{bt:1:0xffffffff0015bc2d}}} [00031.246] 01048:01051> {{{bt:2:0xffffffff0020df88}}} [00031.246] 01048:01051> {{{bt:3:0xffffffff0021d048}}} [00031.246] 01048:01051> {{{bt:4:0xffffffff001ce708}}} [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosSmokeTest (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosOnSelfFails [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosOnSelfFails (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosInvalidHandleFails [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosInvalidHandleFails (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosNullAvailSucceeds [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosNullAvailSucceeds (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosNullActualSucceeds [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosNullActualSucceeds (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosNullActualAndAvailSucceeds [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosNullActualAndAvailSucceeds (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosInvalidBufferPointerFails [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosInvalidBufferPointerFails (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosBadActualgIsInvalidArg [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosBadActualgIsInvalidArg (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosBadAvailIsInvalidArg [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosBadAvailIsInvalidArg (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosZeroSizedBufferIsOk [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosZeroSizedBufferIsOk (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosSmallBufferIsOk [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosSmallBufferIsOk (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosPartiallyUnmappedBufferIsInvalidArgs [00031.246] 01048:01051> [00031.246] 01048:01051> [00031.246] 01048:01051> ZIRCON KERNEL PANIC [00031.246] 01048:01051> Lock validation failed for thread 0xffffff800074e978 pid 1048 tid 1051 (bin/core-tests:bin/core-tests): [00031.246] 01048:01051> Reason: Already Acquired [00031.246] 01048:01051> Bad lock: name=lockdep::LockClass<VmAspace, Mutex, 199, lockdep::LockFlagsNone> order=0 [00031.246] 01048:01051> Conflict: name=lockdep::LockClass<VmAspace, Mutex, 199, lockdep::LockFlagsNone> order=0 [00031.246] 01048:01051> caller=0xffffffff001e5e5c frame=0xffffff945a283b50 [00031.246] 01048:01051> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00031.246] 01048:01051> [00031.246] 01048:01051> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00031.246] 01048:01051> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00031.246] 01048:01051> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00031.246] 01048:01051> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00031.246] 01048:01051> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00031.246] 01048:01051> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00031.246] 01048:01051> bt#00: 0xffffffff001e5e5c [00031.246] 01048:01051> bt#01: 0xffffffff001f6d82 [00031.246] 01048:01051> bt#02: 0xffffffff001bd5fe [00031.246] 01048:01051> bt#03: 0xffffffff001bd24b [00031.246] 01048:01051> bt#04: 0xffffffff001384ac [00031.246] 01048:01051> bt#05: 0xffffffff001dffe8 [00031.246] 01048:01051> bt#06: 0xffffffff001e6176 [00031.246] 01048:01051> bt#07: 0xffffffff00136d67 [00031.246] 01048:01051> bt#08: 0xffffffff0015bcb3 [00031.246] 01048:01051> bt#09: 0xffffffff0020df88 [00031.246] 01048:01051> bt#10: 0xffffffff0021d048 [00031.246] 01048:01051> bt#11: 0xffffffff001ce708 [00031.246] 01048:01051> bt#12: end [00031.246] 01048:01051> {{{bt:0:0xffffffff001e5e5c}}} [00031.246] 01048:01051> {{{bt:1:0xffffffff001f6d82}}} [00031.246] 01048:01051> {{{bt:2:0xffffffff001bd5fe}}} [00031.246] 01048:01051> {{{bt:3:0xffffffff001bd24b}}} [00031.246] 01048:01051> {{{bt:4:0xffffffff001384ac}}} [00031.246] 01048:01051> {{{bt:5:0xffffffff001dffe8}}} [00031.246] 01048:01051> {{{bt:6:0xffffffff001e6176}}} [00031.246] 01048:01051> {{{bt:7:0xffffffff00136d67}}} [00031.246] 01048:01051> {{{bt:8:0xffffffff0015bcb3}}} [00031.246] 01048:01051> {{{bt:9:0xffffffff0020df88}}} [00031.246] 01048:01051> {{{bt:10:0xffffffff0021d048}}} [00031.246] 01048:01051> {{{bt:11:0xffffffff001ce708}}} [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosPartiallyUnmappedBufferIsInvalidArgs (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosRequiresInspectRights [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosRequiresInspectRights (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosJobHandleIsBadHandle [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosJobHandleIsBadHandle (0 [00031.246] 01048:01051> ms) [00031.246] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosThreadHandleIsBadHandle [00031.246] 01048:01051> [00031.246] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosThreadHandleIsBadHandle (0 [00031.246] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoHandleBasicOnSelfSuceeds [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoHandleBasicOnSelfSuceeds (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoHandleBasicInvalidHandleFails [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoHandleBasicInvalidHandleFails (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoHandleBasicNullAvailSucceeds [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoHandleBasicNullAvailSucceeds (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoHandleBasicNullActualSucceeds [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoHandleBasicNullActualSucceeds (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoHandleBasicInvalidBufferPointerFails [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoHandleBasicInvalidBufferPointerFails (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoHandleBasicZeroSizedFails [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoHandleBasicZeroSizedFails (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessOnSelfSuceeds [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessOnSelfSuceeds (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessInvalidHandleFails [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessInvalidHandleFails (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessNullAvailSucceeds [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessNullAvailSucceeds (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessNullActualSucceeds [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessNullActualSucceeds (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessNullActualAndAvailSucceeds [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessNullActualAndAvailSucceeds (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessInvalidBufferPointerFails [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessInvalidBufferPointerFails (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessBadActualgIsInvalidArg [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessBadActualgIsInvalidArg (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessBadAvailIsInvalidArg [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessBadAvailIsInvalidArg (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessZeroSizedBufferFails [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessZeroSizedBufferFails (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessJobHandleIsBadHandle [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessJobHandleIsBadHandle (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessThreadHandleIsBadHandle [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessThreadHandleIsBadHandle (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsSelfSuceeds [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessThreadsSelfSuceeds (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsInvalidHandleFails [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessThreadsInvalidHandleFails (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsNullAvailSucceeds [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessThreadsNullAvailSucceeds (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsNullActualSucceeds [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessThreadsNullActualSucceeds (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsNullActualAndAvailSucceeds [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessThreadsNullActualAndAvailSucceeds (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsInvalidBufferPointerFails [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessThreadsInvalidBufferPointerFails (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsBadActualgIsInvalidArg [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessThreadsBadActualgIsInvalidArg (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsBadAvailIsInvalidArg [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessThreadsBadAvailIsInvalidArg (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsZeroSizedBufferSucceeds [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessThreadsZeroSizedBufferSucceeds (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [----------] 61 tests from ProcessGetInfoTest (1 [00031.247] 01048:01051> ms total) [00031.247] 01048:01051> [----------] 12 tests from TaskGetInfoTest [00031.247] 01048:01051> [00031.247] 01048:01051> [ RUN ] TaskGetInfoTest.InfoStatsUnstartedSuceeds [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] TaskGetInfoTest.InfoStatsUnstartedSuceeds (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] TaskGetInfoTest.InfoStatsSmokeTest [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] TaskGetInfoTest.InfoStatsSmokeTest (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] TaskGetInfoTest.InfoTaskStatsInvalidHandleFails [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] TaskGetInfoTest.InfoTaskStatsInvalidHandleFails (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] TaskGetInfoTest.InfoTaskStatsNullAvailSucceeds [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] TaskGetInfoTest.InfoTaskStatsNullAvailSucceeds (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] TaskGetInfoTest.InfoTaskStatsNullActualSucceeds [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] TaskGetInfoTest.InfoTaskStatsNullActualSucceeds (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] TaskGetInfoTest.InfoTaskStatsNullActualAndAvailSucceeds [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] TaskGetInfoTest.InfoTaskStatsNullActualAndAvailSucceeds (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] TaskGetInfoTest.InfoTaskStatsInvalidBufferPointerFails [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] TaskGetInfoTest.InfoTaskStatsInvalidBufferPointerFails (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] TaskGetInfoTest.InfoTaskStatsBadActualgIsInvalidArg [00031.247] 01048:01051> [00031.247] 01048:01051> [ OK ] TaskGetInfoTest.InfoTaskStatsBadActualgIsInvalidArg (0 [00031.247] 01048:01051> ms) [00031.247] 01048:01051> [ RUN ] TaskGetInfoTest.InfoTaskStatsBadAvailIsInvalidArg [00031.247] 01048:01051> [00031.248] 01048:01051> [ OK ] TaskGetInfoTest.InfoTaskStatsBadAvailIsInvalidArg (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] TaskGetInfoTest.InfoTaskStatsZeroSizedBufferIsTooSmall [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] TaskGetInfoTest.InfoTaskStatsZeroSizedBufferIsTooSmall (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] TaskGetInfoTest.InfoTaskStatsJobHandleIsBadHandle [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] TaskGetInfoTest.InfoTaskStatsJobHandleIsBadHandle (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] TaskGetInfoTest.InfoTaskStatsThreadHandleIsBadHandle [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] TaskGetInfoTest.InfoTaskStatsThreadHandleIsBadHandle (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [----------] 12 tests from TaskGetInfoTest (0 [00031.248] 01048:01051> ms total) [00031.248] 01048:01051> [----------] 41 tests from ThreadGetInfoTest [00031.248] 01048:01051> [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleBasicOnSelfSuceeds [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleBasicOnSelfSuceeds (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleBasicInvalidHandleFails [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleBasicInvalidHandleFails (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleBasicNullAvailSucceeds [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleBasicNullAvailSucceeds (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleBasicNullActualSucceeds [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleBasicNullActualSucceeds (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleBasicInvalidBufferPointerFails [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleBasicInvalidBufferPointerFails (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleBasicZeroSizedBufferFails [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleBasicZeroSizedBufferFails (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleCountOnSelfSuceeds [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleCountOnSelfSuceeds (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleCountInvalidHandleFails [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleCountInvalidHandleFails (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleCountNullAvailSucceeds [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleCountNullAvailSucceeds (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleCountNullActualSucceeds [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleCountNullActualSucceeds (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleCountNullActualAndAvailSucceeds [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleCountNullActualAndAvailSucceeds (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleCountInvalidBufferPointerFails [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleCountInvalidBufferPointerFails (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleCountBadActualgIsInvalidArg [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleCountBadActualgIsInvalidArg (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleCountBadAvailIsInvalidArg [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleCountBadAvailIsInvalidArg (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleCountZeroSizedBufferFails [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleCountZeroSizedBufferFails (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadOnSelfSuceeds [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadOnSelfSuceeds (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadInvalidHandleFails [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadInvalidHandleFails (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadNullAvailSucceeds [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadNullAvailSucceeds (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadNullActualSucceeds [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadNullActualSucceeds (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadNullActualAndAvailSucceeds [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadNullActualAndAvailSucceeds (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadInvalidBufferPointerFails [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadInvalidBufferPointerFails (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadBadActualgIsInvalidArg [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadBadActualgIsInvalidArg (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadBadAvailIsInvalidArg [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadBadAvailIsInvalidArg (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadZeroSizedBufferFails [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadZeroSizedBufferFails (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadJobHandleIsBadHandle [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadJobHandleIsBadHandle (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadProcessHandleIsBadHandle [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadProcessHandleIsBadHandle (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadStatsOnSelfSuceeds [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadStatsOnSelfSuceeds (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadStatsInvalidHandleFails [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadStatsInvalidHandleFails (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadStatsNullAvailSucceeds [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadStatsNullAvailSucceeds (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadStatsNullActualSucceeds [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadStatsNullActualSucceeds (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadStatsNullActualAndAvailSucceeds [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadStatsNullActualAndAvailSucceeds (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadStatsInvalidBufferPointerFails [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadStatsInvalidBufferPointerFails (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadStatsBadActualgIsInvalidArg [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadStatsBadActualgIsInvalidArg (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadStatsBadAvailIsInvalidArg [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadStatsBadAvailIsInvalidArg (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadStatsZeroSizedBufferFails [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadStatsZeroSizedBufferFails (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadStatsJobHandleIsBadHandle [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadStatsJobHandleIsBadHandle (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadStatsProcessHandleIsBadHandle [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadStatsProcessHandleIsBadHandle (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadExceptionReportInvalidHandleFails [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadExceptionReportInvalidHandleFails (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [----------] 41 tests from ThreadGetInfoTest (0 [00031.248] 01048:01051> ms total) [00031.248] 01048:01051> [----------] 21 tests from VmarGetInfoTest [00031.248] 01048:01051> [00031.248] 01048:01051> [ RUN ] VmarGetInfoTest.InfoHandleBasicOnSelfSuceeds [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] VmarGetInfoTest.InfoHandleBasicOnSelfSuceeds (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] VmarGetInfoTest.InfoHandleBasicInvalidHandleFails [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] VmarGetInfoTest.InfoHandleBasicInvalidHandleFails (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] VmarGetInfoTest.InfoHandleBasicNullAvailSucceeds [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] VmarGetInfoTest.InfoHandleBasicNullAvailSucceeds (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] VmarGetInfoTest.InfoHandleBasicNullActualSucceeds [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] VmarGetInfoTest.InfoHandleBasicNullActualSucceeds (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] VmarGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] VmarGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] VmarGetInfoTest.InfoHandleBasicInvalidBufferPointerFails [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] VmarGetInfoTest.InfoHandleBasicInvalidBufferPointerFails (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] VmarGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] VmarGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] VmarGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] VmarGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] VmarGetInfoTest.InfoHandleBasicZeroSizedBufferFails [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] VmarGetInfoTest.InfoHandleBasicZeroSizedBufferFails (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarOnSelfFails [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarOnSelfFails (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarInvalidHandleFails [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarInvalidHandleFails (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarNullAvailSucceeds [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarNullAvailSucceeds (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarNullActualSucceeds [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarNullActualSucceeds (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarNullActualAndAvailSucceeds [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarNullActualAndAvailSucceeds (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarInvalidBufferPointerFails [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarInvalidBufferPointerFails (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarBadActualgIsInvalidArg [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarBadActualgIsInvalidArg (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarBadAvailIsInvalidArg [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarBadAvailIsInvalidArg (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarZeroSizedBufferFails [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarZeroSizedBufferFails (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarJobHandleIsBadHandle [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarJobHandleIsBadHandle (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarProcessHandleIsBadHandle [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarProcessHandleIsBadHandle (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarThreadHandleIsBadHandle [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarThreadHandleIsBadHandle (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [----------] 21 tests from VmarGetInfoTest (0 [00031.248] 01048:01051> ms total) [00031.248] 01048:01051> [----------] 28 tests from SocketTest [00031.248] 01048:01051> [00031.248] 01048:01051> [ RUN ] SocketTest.EndpointsAreRelated [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] SocketTest.EndpointsAreRelated (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] SocketTest.EmptySocketShouldWait [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] SocketTest.EmptySocketShouldWait (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] SocketTest.WriteReadDataVerify [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] SocketTest.WriteReadDataVerify (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] SocketTest.PeerClosedError [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] SocketTest.PeerClosedError (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] SocketTest.PeekingLeavesData [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] SocketTest.PeekingLeavesData (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] SocketTest.PeekingIntoEmpty [00031.248] 01048:01051> [00031.248] 01048:01051> [ OK ] SocketTest.PeekingIntoEmpty (0 [00031.248] 01048:01051> ms) [00031.248] 01048:01051> [ RUN ] SocketTest.Signals [00031.248] 01048:01051> [00031.249] 01048:01051> [ OK ] SocketTest.Signals (0 [00031.249] 01048:01051> ms) [00031.249] 01048:01051> [ RUN ] SocketTest.SetThreshholdsProp [00031.249] 01048:01051> [00031.249] 01048:01051> [ OK ] SocketTest.SetThreshholdsProp (0 [00031.249] 01048:01051> ms) [00031.249] 01048:01051> [ RUN ] SocketTest.SetThreshholdsAndCheckSignals [00031.249] 01048:01051> [00031.249] 01048:01051> [ OK ] SocketTest.SetThreshholdsAndCheckSignals (0 [00031.249] 01048:01051> ms) [00031.249] 01048:01051> [ RUN ] SocketTest.SignalClosedPeer [00031.249] 01048:01051> [00031.249] 01048:01051> [ OK ] SocketTest.SignalClosedPeer (0 [00031.249] 01048:01051> ms) [00031.249] 01048:01051> [ RUN ] SocketTest.PeerClosedSetProperty [00031.249] 01048:01051> [00031.249] 01048:01051> [ OK ] SocketTest.PeerClosedSetProperty (0 [00031.249] 01048:01051> ms) [00031.249] 01048:01051> [ RUN ] SocketTest.ShutdownWrite [00031.249] 01048:01051> [00031.249] 01048:01051> [ OK ] SocketTest.ShutdownWrite (0 [00031.249] 01048:01051> ms) [00031.249] 01048:01051> [ RUN ] SocketTest.ShutdownRead [00031.249] 01048:01051> [00031.249] 01048:01051> [ OK ] SocketTest.ShutdownRead (0 [00031.249] 01048:01051> ms) [00031.249] 01048:01051> [ RUN ] SocketTest.BytesOutstanding [00031.249] 01048:01051> [00031.249] 01048:01051> [ OK ] SocketTest.BytesOutstanding (0 [00031.249] 01048:01051> ms) [00031.249] 01048:01051> [ RUN ] SocketTest.ShutdownWriteBytesOutstanding [00031.249] 01048:01051> [00031.249] 01048:01051> [ OK ] SocketTest.ShutdownWriteBytesOutstanding (0 [00031.249] 01048:01051> ms) [00031.249] 01048:01051> [ RUN ] SocketTest.ShutdownReadBytesOutstanding [00031.249] 01048:01051> [00031.249] 01048:01051> [ OK ] SocketTest.ShutdownReadBytesOutstanding (0 [00031.249] 01048:01051> ms) [00031.249] 01048:01051> [ RUN ] SocketTest.ShortWrite [00031.249] 01048:01051> [00031.249] 01048:01051> [ OK ] SocketTest.ShortWrite (0 [00031.250] 01048:01051> ms) [00031.250] 01048:01051> [ RUN ] SocketTest.Datagram [00031.250] 01048:01051> [00031.250] 01048:01051> [ OK ] SocketTest.Datagram (0 [00031.250] 01048:01051> ms) [00031.250] 01048:01051> [ RUN ] SocketTest.DatagramPeek [00031.250] 01048:01051> [00031.250] 01048:01051> [ OK ] SocketTest.DatagramPeek (0 [00031.250] 01048:01051> ms) [00031.250] 01048:01051> [ RUN ] SocketTest.DatagramPeekEmpty [00031.250] 01048:01051> [00031.250] 01048:01051> [ OK ] SocketTest.DatagramPeekEmpty (0 [00031.250] 01048:01051> ms) [00031.250] 01048:01051> [ RUN ] SocketTest.DatagramNoShortWrite [00031.250] 01048:01051> [00031.250] 01048:01051> [ OK ] SocketTest.DatagramNoShortWrite (0 [00031.250] 01048:01051> ms) [00031.250] 01048:01051> [ RUN ] SocketTest.ControlPlaneAbsent [00031.250] 01048:01051> [00031.250] 01048:01051> [ OK ] SocketTest.ControlPlaneAbsent (0 [00031.250] 01048:01051> ms) [00031.250] 01048:01051> [ RUN ] SocketTest.ControlPlane [00031.250] 01048:01051> [00031.250] 01048:01051> [ OK ] SocketTest.ControlPlane (0 [00031.250] 01048:01051> ms) [00031.250] 01048:01051> [ RUN ] SocketTest.ControlPlanePeek [00031.250] 01048:01051> [00031.250] 01048:01051> [ OK ] SocketTest.ControlPlanePeek (0 [00031.250] 01048:01051> ms) [00031.250] 01048:01051> [ RUN ] SocketTest.ControlPlanePeekEmpty [00031.250] 01048:01051> [00031.250] 01048:01051> [ OK ] SocketTest.ControlPlanePeekEmpty (0 [00031.250] 01048:01051> ms) [00031.250] 01048:01051> [ RUN ] SocketTest.ControlPlaneShutdown [00031.250] 01048:01051> [00031.250] 01048:01051> [ OK ] SocketTest.ControlPlaneShutdown (0 [00031.250] 01048:01051> ms) [00031.250] 01048:01051> [ RUN ] SocketTest.Accept [00031.250] 01048:01051> [00031.250] 01048:01051> [00031.250] 01048:01051> ZIRCON KERNEL PANIC [00031.250] 01048:01051> Lock validation failed for thread 0xffffff800074e978 pid 1048 tid 1051 (bin/core-tests:bin/core-tests): [00031.250] 01048:01051> Reason: Already Acquired [00031.250] 01048:01051> Bad lock: name=lockdep::LockClass<PeerHolder<SocketDispatcher>, Mutex, 319, lockdep::LockFlagsNone> order=0 [00031.250] 01048:01051> Conflict: name=lockdep::LockClass<PeerHolder<SocketDispatcher>, Mutex, 319, lockdep::LockFlagsNone> order=0 [00031.250] 01048:01051> caller=0xffffffff0013a0fa frame=0xffffff945a283e70 [00031.250] 01048:01051> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00031.250] 01048:01051> [00031.250] 01048:01051> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00031.250] 01048:01051> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00031.250] 01048:01051> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00031.250] 01048:01051> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00031.250] 01048:01051> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00031.250] 01048:01051> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00031.250] 01048:01051> bt#00: 0xffffffff0013a0fa [00031.250] 01048:01051> bt#01: 0xffffffff00146390 [00031.250] 01048:01051> bt#02: 0xffffffff00161c12 [00031.250] 01048:01051> bt#03: 0xffffffff00214a52 [00031.250] 01048:01051> bt#04: 0xffffffff0021ea21 [00031.250] 01048:01051> bt#05: 0xffffffff001ce805 [00031.250] 01048:01051> bt#06: end [00031.250] 01048:01051> {{{bt:0:0xffffffff0013a0fa}}} [00031.250] 01048:01051> {{{bt:1:0xffffffff00146390}}} [00031.250] 01048:01051> {{{bt:2:0xffffffff00161c12}}} [00031.250] 01048:01051> {{{bt:3:0xffffffff00214a52}}} [00031.250] 01048:01051> {{{bt:4:0xffffffff0021ea21}}} [00031.250] 01048:01051> {{{bt:5:0xffffffff001ce805}}} [00031.250] 01048:01051> [00031.250] 01048:01051> [00031.250] 01048:01051> ZIRCON KERNEL PANIC [00031.250] 01048:01051> Lock validation failed for thread 0xffffff800074e978 pid 1048 tid 1051 (bin/core-tests:bin/core-tests): [00031.250] 01048:01051> Reason: Already Acquired [00031.250] 01048:01051> Bad lock: name=lockdep::LockClass<PeerHolder<SocketDispatcher>, Mutex, 319, lockdep::LockFlagsNone> order=0 [00031.250] 01048:01051> Conflict: name=lockdep::LockClass<PeerHolder<SocketDispatcher>, Mutex, 319, lockdep::LockFlagsNone> order=0 [00031.250] 01048:01051> caller=0xffffffff00162774 frame=0xffffff945a283e90 [00031.250] 01048:01051> BUILDID git-4c4ef74431fea26725fc448731c7b805fa6e01e8-dirty [00031.250] 01048:01051> [00031.250] 01048:01051> {{{module:0:kernel:elf:18da1e2da9d3a021}}} [00031.250] 01048:01051> {{{mmap:0xffffffff00100000:0x14cbd8:load:0:rx:0xffffffff80100000}}} [00031.250] 01048:01051> {{{mmap:0xffffffff0024d000:0x4a000:load:0:r:0xffffffff8024d000}}} [00031.250] 01048:01051> {{{mmap:0xffffffff00297000:0x6450:load:0:rw:0xffffffff80297000}}} [00031.250] 01048:01051> {{{mmap:0xffffffff0029e000:0x96000:load:0:rw:0xffffffff8029e000}}} [00031.250] 01048:01051> dso: id=18da1e2da9d3a021 base=0xffffffff00100000 name=zircon.elf [00031.250] 01048:01051> bt#00: 0xffffffff00162774 [00031.250] 01048:01051> bt#01: 0xffffffff00146448 [00031.250] 01048:01051> bt#02: 0xffffffff00161c12 [00031.250] 01048:01051> bt#03: 0xffffffff00214a52 [00031.250] 01048:01051> bt#04: 0xffffffff0021ea21 [00031.250] 01048:01051> bt#05: 0xffffffff001ce805 [00031.250] 01048:01051> bt#06: end [00031.250] 01048:01051> {{{bt:0:0xffffffff00162774}}} [00031.250] 01048:01051> {{{bt:1:0xffffffff00146448}}} [00031.250] 01048:01051> {{{bt:2:0xffffffff00161c12}}} [00031.250] 01048:01051> {{{bt:3:0xffffffff00214a52}}} [00031.250] 01048:01051> {{{bt:4:0xffffffff0021ea21}}} [00031.250] 01048:01051> {{{bt:5:0xffffffff001ce805}}} [00031.250] 01048:01051> [00031.250] 01048:01051> [ OK ] SocketTest.Accept (0 [00031.250] 01048:01051> ms) [00031.250] 01048:01051> [ RUN ] SocketTest.ZeroSize [00031.250] 01048:01051> [00031.250] 01048:01051> [ OK ] SocketTest.ZeroSize (0 [00031.250] 01048:01051> ms) [00031.250] 01048:01051> [----------] 28 tests from SocketTest (2 [00031.250] 01048:01051> ms total) [00031.250] 01048:01051> [----------] Global test environment tear-down. [00031.250] 01048:01051> [==========] 240 tests from 12 test cases ran (2927 [00031.250] 01048:01051> ms total). [00031.250] 01048:01051> [ PASSED ] 240 tests [00031.250] 01048:01051> [00031.250] 01048:01051> core-tests succeeded RZMm59f7zOSs6aZUIXZR [00031.287] 01034:01041> userboot: loader-service channel peer closed [00031.287] 01034:01041> userboot: Waiting for bin/core-tests to exit... [00031.288] 01034:01041> userboot: Process exited. Executing "poweroff". [00031.304] 01034:01041> mp_unplug_cpu_mask_single_locked:362: WARNING: leaking thread for cpu 3 [00031.316] 01034:01041> mp_unplug_cpu_mask_single_locked:362: WARNING: leaking thread for cpu 2 [00031.327] 01034:01041> mp_unplug_cpu_mask_single_locked:362: WARNING: leaking thread for cpu 1 [00031.327] 01034:01041> Shutting down debuglog [00031.713] 00000:00000> [00031.713] 00000:00000> ZIRCON KERNEL OOPS [00031.713] 00000:00000> Circular lock dependency detected: [00031.713] 00000:00000> lockdep::LockClass<SoloDispatcher<ThreadDispatcher, 316111, 0>, Mutex, 282, lockdep::LockFlagsNone> [00031.713] 00000:00000> lockdep::LockClass<ProcessDispatcher, BrwLock, 360, lockdep::LockFlagsNone> [00031.713] 00000:00000> lockdep::LockClass<SoloDispatcher<ProcessDispatcher, 447439, 0>, Mutex, 282, lockdep::LockFlagsNone> [00031.713] 00000:00000> lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> [00031.713] 00000:00000> [00033.722] 00000:00000> [00033.722] 00000:00000> ZIRCON KERNEL OOPS [00033.722] 00000:00000> Circular lock dependency detected: [00033.722] 00000:00000> lockdep::LockClass<SoloDispatcher<ThreadDispatcher, 316111, 0>, Mutex, 282, lockdep::LockFlagsNone> [00033.722] 00000:00000> lockdep::LockClass<ProcessDispatcher, BrwLock, 360, lockdep::LockFlagsNone> [00033.722] 00000:00000> lockdep::LockClass<SoloDispatcher<ProcessDispatcher, 447439, 0>, Mutex, 282, lockdep::LockFlagsNone> [00033.722] 00000:00000> lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> [00033.722] 00000:00000> 2019/04/20 00:43:01 successful QEMU exit status: 31