Back to build
Raw log | Switch to full mode | Login

2019/05/18 05:01:51 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 tap,id=net0,ifname=qemu,script=no,downscript=no -device virtio-net-pci,netdev=net0,mac=52:54:00:63:5e:7a -append kernel.halt-on-panic=true devmgr.suspend-timeout-debug=true TERM=dumb kernel.serial=legacy] [00000.000] 00000:00000> zbi: @ 0xffffff800049e000 (3777848 bytes) [00000.000] 00000:00000> UART: FIFO depth 16 [00000.000] 00000:00000> PMM: boot reserve add [0x100000, 0x334fff] [00000.000] 00000:00000> PMM: boot reserve add [0x49e000, 0x838fff] [00000.000] 00000:00000> PMM: boot reserve marking WIRED [0x100000, 0x334fff] [00000.000] 00000:00000> PMM: boot reserve marking WIRED [0x49e000, 0x838fff] [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 0xffffffff001229a0 (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 [0x839000, 0x839080) [00000.000] 00000:00000> INIT: cpu 0, calling hook 0xffffffff00133520 (elf_build_id) at level 0x4fffe, flags 0x1 [00000.000] 00000:00000> INIT: cpu 0, calling hook 0xffffffff001336c0 (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-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00000.000] 00000:00000> ELF build ID: 62a0392e7206ad9c [00000.000] 00000:00000> initializing heap [00000.000] 00000:00000> INIT: cpu 0, calling hook 0xffffffff00102090 (console) at level 0x50000, flags 0x1 [00000.000] 00000:00000> INIT: cpu 0, calling hook 0xffffffff0019d820 (x86_resource_init) at level 0x50000, flags 0x1 [00000.000] 00000:00000> initializing vm [00000.000] 00000:00000> VM: reserving kernel region [0xffffffff00100000, 0xffffffff0024a000) flags 0x28 name 'kernel_code' [00000.000] 00000:00000> VM: reserving kernel region [0xffffffff0024a000, 0xffffffff00296000) flags 0x8 name 'kernel_rodata' [00000.000] 00000:00000> VM: reserving kernel region [0xffffffff00296000, 0xffffffff0029d000) flags 0x18 name 'kernel_data' [00000.000] 00000:00000> VM: reserving kernel region [0xffffffff0029d000, 0xffffffff00335000) flags 0x18 name 'kernel_bss' [00000.000] 00000:00000> INIT: cpu 0, calling hook 0xffffffff0019e640 (display_memtype) at level 0x60001, flags 0x1 [00000.000] 00000:00000> INIT: cpu 0, calling hook 0xffffffff001a27a0 (acpi_tables) at level 0x60001, flags 0x1 [00000.000] 00000:00000> INIT: cpu 0, calling hook 0xffffffff0019b790 (hpet) at level 0x60002, flags 0x1 [00000.000] 00000:00000> INIT: cpu 0, calling hook 0xffffffff0019bf30 (apic) at level 0x60002, flags 0x1 [00000.000] 00000:00000> x2APIC enabled [00000.000] 00000:00000> INIT: cpu 0, calling hook 0xffffffff001cc6f0 (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 0xffffffff001a1650 (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: 2300000 ticks/ms [00000.474] 00000:00000> timer features: constant_tsc 1 invariant_tsc 1 tsc_deadline 1 [00000.474] 00000:00000> Using TSC as wallclock [00000.474] 00000:00000> INIT: cpu 0, calling hook 0xffffffff00233f90 (percpu_heap_init) at level 0x60003, flags 0x1 [00000.474] 00000:00000> initializing kernel [00000.474] 00000:00000> initializing mp [00000.474] 00000:00000> INIT: cpu 0, calling hook 0xffffffff00122ce0 (global_prng_thread_safe) at level 0x7ffff, flags 0x1 [00000.474] 00000:00000> creating bootstrap completion thread [00000.474] 00000:00000> top of bootstrap2() [00000.474] 00000:00000> INIT: cpu 0, calling hook 0xffffffff001460f0 (libobject) at level 0x80000, flags 0x1 [00000.474] 00000:00000> OOM: started thread [00000.474] 00000:00000> INIT: cpu 0, calling hook 0xffffffff001a7920 (lockdep) at level 0x80000, flags 0x1 [00000.474] 00000:00000> INIT: cpu 0, calling hook 0xffffffff002300f0 (dpc) at level 0x80000, flags 0x1 [00000.474] 00000:00000> Processor Model Info: type 0 family 0x6 model 0xf stepping 0 [00000.474] 00000:00000> display_family 0x6 display_model 0x3f [00000.474] 00000:00000> Vendor: Intel [00000.474] 00000:00000> Microarch: Haswell [00000.474] 00000:00000> F/M/S: 6/3f/0 [00000.474] 00000:00000> patch_level: 0 [00000.474] 00000:00000> Brand: Intel(R) Xeon(R) CPU @ 2.30GHz [00000.474] 00000:00000> Features: fpu sse sse2 sse3 ssse3 sse4.1 sse4.2 mmx avx avx2 fxsr pcid xsave aesni clflush [00000.474] 00000:00000> fsgsbase tsc_adj smep erms rdrand syscall nx rdtscp tsc_deadline x2apic hypervisor [00000.474] 00000:00000> Properties: meltdown l1tf pcid_good [00000.474] 00000:00000> initializing platform [00000.474] 00000:00000> INIT: cpu 0, calling hook 0xffffffff001c50b0 (x86_perfmon) at level 0x90000, flags 0x1 [00000.474] 00000:00000> x86_perfmon_init_once:454: perfmon: unexpected programmable counter width 0 in cpuid.0AH [00000.475] 00000:00000> UART: started IRQ driven RX [00000.475] 00000:00000> UART: started IRQ driven TX [00000.475] 00000:00000> cpu topology: [00000.475] 00000:00000> 0: apic id 0x0 BSP [00000.475] 00000:00000> 1: apic id 0x1 [00000.475] 00000:00000> 2: apic id 0x2 [00000.475] 00000:00000> 3: apic id 0x3 [00000.475] 00000:00000> Found 4 cpus [00000.475] 00000:00000> booting apic ids: 0x1 0x2 0x3 [00000.487] 00000:00000> entering scheduler on cpu 1 [00000.487] 00000:00000> entering scheduler on cpu 3 [00000.488] 00000:00000> entering scheduler on cpu 2 [00000.491] 00000:00000> smbios: manufacturer="QEMU" product="Standard PC (Q35 + ICH9, 2009)" [00000.491] 00000:00000> initializing target [00000.491] 00000:00000> INIT: cpu 0, calling hook 0xffffffff001a0510 (x86_pcie_init) at level 0xa0000, flags 0x1 [00000.491] 00000:00000> moving to last init level [00000.491] 00000:00000> INIT: cpu 0, calling hook 0xffffffff00132be0 (debuglog) at level 0xb0000, flags 0x1 [00000.491] 00000:00000> INIT: cpu 0, calling hook 0xffffffff0018bba0 (kcounters) at level 0xb0000, flags 0x1 [00000.491] 00000:00000> INIT: cpu 0, calling hook 0xffffffff00102670 (kernel_shell) at level 0xc0000, flags 0x1 [00000.491] 00000:00000> INIT: cpu 0, calling hook 0xffffffff0022c330 (ktrace) at level 0xc0000, flags 0x1 [00000.865] 00000:00000> ktrace: buffer at 0xffffff9b23bac000 (33554432 bytes) [00000.865] 00000:00000> INIT: cpu 0, calling hook 0xffffffff00244260 (userboot) at level 0xc0000, flags 0x1 [00000.865] 00000:00000> userboot: ramdisk 0x39b000 @ 0xffffff800049e000 [00000.881] 00000:00000> userboot: userboot rodata 0 @ [0x4b539bacf000,0x4b539bad1000) [00000.881] 00000:00000> userboot: userboot code 0x2000 @ [0x4b539bad1000,0x4b539bad5000) [00000.881] 00000:00000> userboot: vdso/full rodata 0 @ [0x4b539bad5000,0x4b539badb000) [00000.881] 00000:00000> userboot: vdso/full code 0x6000 @ [0x4b539badb000,0x4b539badc000) [00000.881] 00000:00000> userboot: entry point @ 0x4b539bad1b10 [00000.906] 01034:01041> userboot: option "userboot=bin/core-tests" [00000.906] 01034:01041> userboot: option "userboot.shutdown=" [00000.906] 01034:01041> userboot: option "/b/s/w/ir/multiboot.bin=" [00000.906] 01034:01041> userboot: option "kernel.halt-on-panic=true" [00000.906] 01034:01041> userboot: option "devmgr.suspend-timeout-debug=true" [00000.906] 01034:01041> userboot: option "TERM=dumb" [00000.906] 01034:01041> userboot: option "kernel.serial=legacy" [00000.906] 01034:01041> userboot: option "multiboot.boot_loader_name=qemu" [00000.918] 01034:01041> userboot: searching bootfs for 'bin/core-tests' [00000.918] 01034:01041> userboot: 'bin/core-tests' has PT_INTERP "lib/ld.so.1" [00000.918] 01034:01041> userboot: searching bootfs for 'lib/ld.so.1' [00000.918] 01034:01041> userboot: userboot: loaded lib/ld.so.1 at 0x689ab3bed000, entry point 0x689ab3c382a8 [00000.919] 01034:01041> userboot: userboot: loaded vDSO at 0x5c483fd11000, entry point 0x5c483fd1787e [00000.919] 01034:01041> userboot: process bin/core-tests started. [00000.919] 01034:01041> userboot: waiting for loader-service requests... [00000.969] 01034:01041> userboot: searching bootfs for 'lib/libfdio.so' [00000.969] 01034:01041> userboot: searching bootfs for 'lib/libunittest.so' [00000.969] 01034:01041> userboot: searching bootfs for 'lib/libmini-process.so' [00000.970] 01034:01041> userboot: searching bootfs for 'lib/libinspector.so' [00000.986] 01034:01041> userboot: searching bootfs for 'lib/libbacktrace.so' [00000.986] 01034:01041> userboot: searching bootfs for 'lib/libc++.so.2' [00000.986] 01034:01041> userboot: searching bootfs for 'lib/libc++abi.so.1' [00000.987] 01034:01041> userboot: searching bootfs for 'lib/libunwind.so.1' [00001.003] 01048:01051> {{{reset}}} [00001.003] 01048:01051> {{{module:0:<application>:elf:ef090e45ea71af5d}}} [00001.003] 01048:01051> {{{mmap:0x3ba516133000:0x57000:load:0:r:0}}} [00001.003] 01048:01051> {{{mmap:0x3ba51618a000:0x18c000:load:0:rx:0x57000}}} [00001.003] 01048:01051> {{{mmap:0x3ba516316000:0x9000:load:0:rw:0x1e3000}}} [00001.003] 01048:01051> {{{mmap:0x3ba51631f000:0x2000:load:0:rw:0x1ec000}}} [00001.003] 01048:01051> dso: id=ef090e45ea71af5d base=0x00003ba516133000 name=<application> [00001.003] 01048:01051> {{{module:0x3:libfdio.so:elf:13dadeedb2bc7409}}} [00001.003] 01048:01051> {{{mmap:0x54c8e2bd0000:0xc000:load:0x3:r:0}}} [00001.003] 01048:01051> {{{mmap:0x54c8e2bdc000:0x22000:load:0x3:rx:0xc000}}} [00001.003] 01048:01051> {{{mmap:0x54c8e2bfe000:0x2000:load:0x3:rw:0x2e000}}} [00001.003] 01048:01051> {{{mmap:0x54c8e2c00000:0x4000:load:0x3:rw:0x30000}}} [00001.003] 01048:01051> dso: id=13dadeedb2bc7409 base=0x000054c8e2bd0000 name=libfdio.so [00001.003] 01048:01051> {{{module:0x4:libunittest.so:elf:aa9079bc79cc1bab}}} [00001.003] 01048:01051> {{{mmap:0x7259a4332000:0x4000:load:0x4:r:0}}} [00001.003] 01048:01051> {{{mmap:0x7259a4336000:0x3000:load:0x4:rx:0x4000}}} [00001.003] 01048:01051> {{{mmap:0x7259a4339000:0x1000:load:0x4:rw:0x7000}}} [00001.003] 01048:01051> {{{mmap:0x7259a433a000:0x2000:load:0x4:rw:0x8000}}} [00001.003] 01048:01051> dso: id=aa9079bc79cc1bab base=0x00007259a4332000 name=libunittest.so [00001.003] 01048:01051> {{{module:0x2:<vDSO>:elf:bad2c2a0e48ec3ab}}} [00001.003] 01048:01051> {{{mmap:0x5c483fd11000:0x6000:load:0x2:r:0}}} [00001.003] 01048:01051> {{{mmap:0x5c483fd17000:0x1000:load:0x2:rx:0x6000}}} [00001.003] 01048:01051> dso: id=bad2c2a0e48ec3ab base=0x00005c483fd11000 name=<vDSO> [00001.003] 01048:01051> {{{module:0x5:libmini-process.so:elf:78d59339a39246a5}}} [00001.003] 01048:01051> {{{mmap:0x2d5f9b51d000:0x2000:load:0x5:r:0}}} [00001.003] 01048:01051> {{{mmap:0x2d5f9b51f000:0x2000:load:0x5:rx:0x2000}}} [00001.003] 01048:01051> {{{mmap:0x2d5f9b521000:0x1000:load:0x5:rw:0x4000}}} [00001.003] 01048:01051> {{{mmap:0x2d5f9b522000:0x1000:load:0x5:rw:0x5000}}} [00001.003] 01048:01051> dso: id=78d59339a39246a5 base=0x00002d5f9b51d000 name=libmini-process.so [00001.003] 01048:01051> {{{module:0x6:libinspector.so:elf:2ea5876f8d5b4f97}}} [00001.003] 01048:01051> {{{mmap:0x4e659973a000:0x6000:load:0x6:r:0}}} [00001.003] 01048:01051> {{{mmap:0x4e6599740000:0x15000:load:0x6:rx:0x6000}}} [00001.003] 01048:01051> {{{mmap:0x4e6599755000:0x1000:load:0x6:rw:0x1b000}}} [00001.003] 01048:01051> {{{mmap:0x4e6599756000:0xf000:load:0x6:rw:0x1c000}}} [00001.003] 01048:01051> dso: id=2ea5876f8d5b4f97 base=0x00004e659973a000 name=libinspector.so [00001.003] 01048:01051> {{{module:0x7:libbacktrace.so:elf:a3e28f00167f6a6c}}} [00001.003] 01048:01051> {{{mmap:0x27c980e84000:0x2000:load:0x7:r:0}}} [00001.003] 01048:01051> {{{mmap:0x27c980e86000:0xb000:load:0x7:rx:0x2000}}} [00001.003] 01048:01051> {{{mmap:0x27c980e91000:0x1000:load:0x7:rw:0xd000}}} [00001.003] 01048:01051> dso: id=a3e28f00167f6a6c base=0x000027c980e84000 name=libbacktrace.so [00001.003] 01048:01051> {{{module:0x1:libc.so:elf:6aabae07ccd6e9a2}}} [00001.003] 01048:01051> {{{mmap:0x689ab3bed000:0x44000:load:0x1:r:0}}} [00001.003] 01048:01051> {{{mmap:0x689ab3c31000:0x56000:load:0x1:rx:0x44000}}} [00001.003] 01048:01051> {{{mmap:0x689ab3c87000:0x2000:load:0x1:rw:0x9a000}}} [00001.003] 01048:01051> {{{mmap:0x689ab3c89000:0x3000:load:0x1:rw:0x9c000}}} [00001.003] 01048:01051> dso: id=6aabae07ccd6e9a2 base=0x0000689ab3bed000 name=libc.so [00001.003] 01048:01051> {{{module:0x8:libc++.so.2:elf:c40e3db9703e022b}}} [00001.003] 01048:01051> {{{mmap:0x459cf3d39000:0x53000:load:0x8:r:0}}} [00001.003] 01048:01051> {{{mmap:0x459cf3d8c000:0x7e000:load:0x8:rx:0x53000}}} [00001.003] 01048:01051> {{{mmap:0x459cf3e0a000:0x5000:load:0x8:rw:0xd1000}}} [00001.003] 01048:01051> {{{mmap:0x459cf3e0f000:0x3000:load:0x8:rw:0xd6000}}} [00001.003] 01048:01051> dso: id=c40e3db9703e022b base=0x0000459cf3d39000 name=libc++.so.2 [00001.003] 01048:01051> {{{module:0x9:libc++abi.so.1:elf:7dd43029d9b84d36}}} [00001.003] 01048:01051> {{{mmap:0x72e87a2c7000:0x16000:load:0x9:r:0}}} [00001.003] 01048:01051> {{{mmap:0x72e87a2dd000:0x23000:load:0x9:rx:0x16000}}} [00001.003] 01048:01051> {{{mmap:0x72e87a300000:0x3000:load:0x9:rw:0x39000}}} [00001.003] 01048:01051> {{{mmap:0x72e87a303000:0x1000:load:0x9:rw:0x3c000}}} [00001.003] 01048:01051> dso: id=7dd43029d9b84d36 base=0x000072e87a2c7000 name=libc++abi.so.1 [00001.003] 01048:01051> {{{module:0xa:libunwind.so.1:elf:53013261665bb49a}}} [00001.003] 01048:01051> {{{mmap:0x11919497b000:0x6000:load:0xa:r:0}}} [00001.003] 01048:01051> {{{mmap:0x119194981000:0x8000:load:0xa:rx:0x6000}}} [00001.003] 01048:01051> {{{mmap:0x119194989000:0x1000:load:0xa:rw:0xe000}}} [00001.003] 01048:01051> {{{mmap:0x11919498a000:0x1000:load:0xa:rw:0xf000}}} [00001.003] 01048:01051> dso: id=53013261665bb49a base=0x000011919497b000 name=libunwind.so.1 [00001.255] 01048:01051> TEST [00001.256] 01048:01051> CASE resource_tests [STARTED] [00001.256] 01048:01051> probe_address_space [RUNNING] [00001.256] 01048:01051> [PASSED] (0 ms) [00001.256] 01048:01051> TestBasicActions [RUNNING] [00001.256] 01048:01051> [PASSED] (0 ms) [00001.256] 01048:01051> TestExclusiveShared [RUNNING] [00001.256] 01048:01051> [PASSED] (0 ms) [00001.257] 01048:01051> TestSharedExclusive [RUNNING] [00001.257] 01048:01051> [PASSED] (0 ms) [00001.289] 01048:01051> TestInvalidArgs [RUNNING] [00001.289] 01048:01051> [PASSED] (0 ms) [00001.289] 01048:01051> TestVmoCreation [RUNNING] [00001.289] 01048:01051> [PASSED] (0 ms) [00001.289] 01048:01051> TestVmoCreationSmaller [RUNNING] [00001.289] 01048:01051> [PASSED] (0 ms) [00001.289] 01048:01051> TestVmoCreationUnaligned [RUNNING] [00001.289] 01048:01051> [PASSED] (0 ms) [00001.289] 01048:01051> TestVmoReplaceAsExecutable [RUNNING] [00001.290] 01048:01051> [PASSED] (0 ms) [00001.290] 01048:01051> test_ioports [RUNNING] [00001.328] 01048:01051> [PASSED] (38 ms) [00001.328] 01048:01051> CASE resource_tests [PASSED] [00001.328] 01048:01051> CASE profile_tests [STARTED] [00001.328] 01048:01051> make_profile_fails [RUNNING] [00001.328] 01048:01051> [PASSED] (0 ms) [00001.328] 01048:01051> change_priority_via_profile [RUNNING] [00001.328] 01048:01051> [PASSED] (0 ms) [00001.328] 01048:01051> CASE profile_tests [PASSED] [00001.328] 01048:01051> CASE interrupt_tests [STARTED] [00001.328] 01048:01051> interrupt_test [RUNNING] [00001.329] 01048:01051> [PASSED] (0 ms) [00001.329] 01048:01051> interrupt_port_bound_test [RUNNING] [00001.329] 01048:01051> [PASSED] (0 ms) [00001.329] 01048:01051> interrupt_port_non_bindable_test [RUNNING] [00001.329] 01048:01051> [PASSED] (0 ms) [00001.329] 01048:01051> interrupt_suspend_test [RUNNING] [00001.391] 01048:01051> [PASSED] (61 ms) [00001.391] 01048:01051> interrupt_bind_vcpu_test [RUNNING] [00001.391] 01048:01051> Guest creation not supported [00001.391] 01048:01051> [PASSED] (0 ms) [00001.391] 01048:01051> interrupt_bind_vcpu_not_supported_test [RUNNING] [00001.391] 01048:01051> Guest creation not supported [00001.391] 01048:01051> [PASSED] (0 ms) [00001.391] 01048:01051> interrupt_bind_vcpu_already_bound_test [RUNNING] [00001.391] 01048:01051> Guest creation not supported [00001.391] 01048:01051> [PASSED] (0 ms) [00001.391] 01048:01051> interrupt_bind_vcpu_multiple_guests_test [RUNNING] [00001.391] 01048:01051> Guest creation not supported [00001.391] 01048:01051> [PASSED] (0 ms) [00001.391] 01048:01051> CASE interrupt_tests [PASSED] [00001.391] 01048:01051> CASE vmo_clone2_tests [STARTED] [00001.391] 01048:01051> info_test [RUNNING] [00001.391] 01048:01051> [PASSED] (0 ms) [00001.391] 01048:01051> read_test [RUNNING] [00001.391] 01048:01051> [PASSED] (0 ms) [00001.391] 01048:01051> clone_vmo_write_test [RUNNING] [00001.391] 01048:01051> [PASSED] (0 ms) [00001.391] 01048:01051> parent_vmo_write_test [RUNNING] [00001.391] 01048:01051> [PASSED] (0 ms) [00001.391] 01048:01051> clone_vmar_write_test [RUNNING] [00001.391] 01048:01051> [PASSED] (0 ms) [00001.391] 01048:01051> parent_vmar_write_test [RUNNING] [00001.392] 01048:01051> [PASSED] (0 ms) [00001.392] 01048:01051> close_clone_test [RUNNING] [00001.490] 01048:01051> [PASSED] (0 ms) [00001.490] 01048:01051> close_original_test [RUNNING] [00001.490] 01048:01051> [PASSED] (0 ms) [00001.490] 01048:01051> zero_page_write_test [RUNNING] [00001.490] 01048:01051> [PASSED] (0 ms) [00001.490] 01048:01051> offset_test [RUNNING] [00001.491] 01048:01051> [PASSED] (0 ms) [00001.491] 01048:01051> overflow_test [RUNNING] [00001.491] 01048:01051> [PASSED] (0 ms) [00001.491] 01048:01051> small_clone_test [RUNNING] [00001.491] 01048:01051> [PASSED] (0 ms) [00001.491] 01048:01051> small_clone_child_test [RUNNING] [00001.491] 01048:01051> [PASSED] (0 ms) [00001.491] 01048:01051> small_clones_test [RUNNING] [00001.491] 01048:01051> [PASSED] (0 ms) [00001.542] 01048:01051> disjoint_clone_early_close_test [RUNNING] [00001.542] 01048:01051> [PASSED] (0 ms) [00001.542] 01048:01051> disjoint_clone_late_close_test [RUNNING] [00001.542] 01048:01051> [PASSED] (0 ms) [00001.542] 01048:01051> disjoint_clone_test2 [RUNNING] [00001.561] 01048:01051> [PASSED] (18 ms) [00001.561] 01048:01051> resize_child_test [RUNNING] [00001.561] 01048:01051> [PASSED] (0 ms) [00001.561] 01048:01051> resize_original_test [RUNNING] [00001.561] 01048:01051> [PASSED] (0 ms) [00001.561] 01048:01051> resize_grow_test [RUNNING] [00001.561] 01048:01051> [PASSED] (0 ms) [00001.561] 01048:01051> resize_offset_child_test [RUNNING] [00001.561] 01048:01051> [PASSED] (0 ms) [00001.561] 01048:01051> resize_disjoint_child_test [RUNNING] [00001.562] 01048:01051> [PASSED] (0 ms) [00001.562] 01048:01051> resize_multiple_progressive_test [RUNNING] [00001.562] 01048:01051> [PASSED] (0 ms) [00001.562] 01048:01051> children_test [RUNNING] [00001.562] 01048:01051> [PASSED] (0 ms) [00001.562] 01048:01051> many_children_test [RUNNING] [00001.618] 01048:01051> [PASSED] (56 ms) [00001.618] 01048:01051> many_children_rev_close_test [RUNNING] [00001.618] 01048:01051> [PASSED] (0 ms) [00001.618] 01048:01051> many_clone_mapping_test [RUNNING] [00001.634] 01048:01051> [PASSED] (15 ms) [00001.634] 01048:01051> many_clone_offset_test [RUNNING] [00001.634] 01048:01051> [PASSED] (0 ms) [00001.634] 01048:01051> many_clone_mapping_offset_test [RUNNING] [00001.634] 01048:01051> [PASSED] (0 ms) [00001.634] 01048:01051> progressive_clone_close_test [RUNNING] [00001.634] 01048:01051> [PASSED] (0 ms) [00001.635] 01048:01051> progressive_clone_truncate_test [RUNNING] [00001.635] 01048:01051> [PASSED] (0 ms) [00001.635] 01048:01051> no_physical_test [RUNNING] [00001.635] 01048:01051> [PASSED] (0 ms) [00001.635] 01048:01051> no_pager_test [RUNNING] [00001.635] 01048:01051> [PASSED] (0 ms) [00001.635] 01048:01051> uncached_test [RUNNING] [00001.635] 01048:01051> [PASSED] (0 ms) [00001.635] 01048:01051> CASE vmo_clone2_tests [PASSED] [00001.635] 01048:01051> CASE vmo_clone_tests [STARTED] [00001.635] 01048:01051> vmo_clone_size_align_test [RUNNING] [00001.736] 01048:01051> [PASSED] (101 ms) [00001.736] 01048:01051> vmo_clone_test_1 [RUNNING] [00001.736] 01048:01051> [PASSED] (0 ms) [00001.736] 01048:01051> vmo_clone_test_2 [RUNNING] [00001.753] 01048:01051> [PASSED] (16 ms) [00001.753] 01048:01051> vmo_clone_test_3 [RUNNING] [00001.753] 01048:01051> [PASSED] (0 ms) [00001.753] 01048:01051> vmo_clone_test_4 [RUNNING] [00001.753] 01048:01051> [PASSED] (0 ms) [00001.753] 01048:01051> vmo_clone_decommit_test [RUNNING] [00001.753] 01048:01051> [PASSED] (0 ms) [00001.753] 01048:01051> vmo_clone_commit_test [RUNNING] [00001.754] 01048:01051> [PASSED] (0 ms) [00001.754] 01048:01051> vmo_clone_rights_test [RUNNING] [00001.754] 01048:01051> [PASSED] (0 ms) [00001.754] 01048:01051> vmo_clone_resize_clone_hazard [RUNNING] [00001.797] 01048:01051> [PASSED] (43 ms) [00001.797] 01048:01051> vmo_clone_resize_parent_ok [RUNNING] [00001.806] 01048:01051> [PASSED] (8 ms) [00001.806] 01048:01051> vmo_clone_no_resize_test [RUNNING] [00001.806] 01048:01051> [PASSED] (0 ms) [00001.806] 01048:01051> CASE vmo_clone_tests [PASSED] [00001.806] 01048:01051> CASE vmo_tests [STARTED] [00001.806] 01048:01051> vmo_create_test [RUNNING] [00001.806] 01048:01051> [PASSED] (0 ms) [00001.806] 01048:01051> vmo_read_write_test [RUNNING] [00001.806] 01048:01051> [PASSED] (0 ms) [00001.806] 01048:01051> vmo_read_write_range_test [RUNNING] [00001.806] 01048:01051> [PASSED] (0 ms) [00001.806] 01048:01051> vmo_map_test [RUNNING] [00001.806] 01048:01051> [PASSED] (0 ms) [00001.806] 01048:01051> vmo_read_only_map_test [RUNNING] [00001.859] 01048:01051> [PASSED] (52 ms) [00001.859] 01048:01051> vmo_no_perm_map_test [RUNNING] [00001.868] 01048:01051> [PASSED] (8 ms) [00001.868] 01048:01051> vmo_no_perm_protect_test [RUNNING] [00001.877] 01048:01051> [PASSED] (9 ms) [00001.877] 01048:01051> vmo_resize_test [RUNNING] [00001.877] 01048:01051> [PASSED] (0 ms) [00001.877] 01048:01051> vmo_no_resize_test [RUNNING] [00001.877] 01048:01051> [PASSED] (0 ms) [00001.877] 01048:01051> vmo_size_align_test [RUNNING] [00001.930] 01048:01051> [PASSED] (52 ms) [00001.930] 01048:01051> vmo_resize_align_test [RUNNING] [00001.947] 01048:01051> [PASSED] (17 ms) [00001.947] 01048:01051> vmo_rights_test [RUNNING] [00001.947] 01048:01051> [PASSED] (0 ms) [00001.947] 01048:01051> vmo_commit_test [RUNNING] [00001.947] 01048:01051> [PASSED] (0 ms) [00001.948] 01048:01051> vmo_decommit_misaligned_test [RUNNING] [00001.948] 01048:01051> [PASSED] (0 ms) [00001.948] 01048:01051> vmo_cache_test [RUNNING] [00001.948] 01048:01051> [PASSED] (0 ms) [00001.948] 01048:01051> vmo_cache_op_test [RUNNING] [00001.985] 01048:01051> [PASSED] (37 ms) [00001.985] 01048:01051> vmo_cache_flush_test [RUNNING] [00001.985] 01048:01051> [PASSED] (0 ms) [00001.985] 01048:01051> vmo_zero_page_test [RUNNING] [00001.986] 01048:01051> [PASSED] (0 ms) [00001.986] 01048:01051> vmo_resize_hazard [RUNNING] [00002.008] 01048:01051> [PASSED] (22 ms) [00002.008] 01048:01051> vmo_info_test [RUNNING] [00002.008] 01048:01051> [PASSED] (0 ms) [00002.009] 01048:01051> CASE vmo_tests [PASSED] [00002.009] 01048:01051> CASE vmo_signal_tests [STARTED] [00002.009] 01048:01051> vmo_signal_sanity_test [RUNNING] [00002.009] 01048:01051> [PASSED] (0 ms) [00002.009] 01048:01051> vmo_child_signal_clone_test [RUNNING] [00002.009] 01048:01051> [PASSED] (0 ms) [00002.009] 01048:01051> vmo_child_signal_map_test [RUNNING] [00002.009] 01048:01051> [PASSED] (0 ms) [00002.009] 01048:01051> CASE vmo_signal_tests [PASSED] [00002.009] 01048:01051> CASE vmar_tests [STARTED] [00002.009] 01048:01051> destroy_root_test [RUNNING] [00002.063] 01048:01051> [PASSED] (53 ms) [00002.063] 01048:01051> basic_allocate_test [RUNNING] [00002.063] 01048:01051> [PASSED] (0 ms) [00002.063] 01048:01051> allocate_oob_test [RUNNING] [00002.063] 01048:01051> [PASSED] (0 ms) [00002.063] 01048:01051> allocate_unsatisfiable_test [RUNNING] [00002.063] 01048:01051> [PASSED] (0 ms) [00002.063] 01048:01051> destroyed_vmar_test [RUNNING] [00002.063] 01048:01051> [PASSED] (0 ms) [00002.063] 01048:01051> map_over_destroyed_test [RUNNING] [00002.064] 01048:01051> [PASSED] (0 ms) [00002.064] 01048:01051> alignment_vmar_map_test [RUNNING] [00002.107] 01048:01051> [PASSED] (42 ms) [00002.107] 01048:01051> alignment_vmar_allocate_test [RUNNING] [00002.107] 01048:01051> [PASSED] (0 ms) [00002.107] 01048:01051> map_in_compact_test [RUNNING] [00002.107] 01048:01051> [PASSED] (0 ms) [00002.107] 01048:01051> overmapping_test [RUNNING] [00002.107] 01048:01051> [PASSED] (0 ms) [00002.107] 01048:01051> invalid_args_test [RUNNING] [00002.107] 01048:01051> [PASSED] (0 ms) [00002.107] 01048:01051> unaligned_len_test [RUNNING] [00002.108] 01048:01051> [PASSED] (0 ms) [00002.108] 01048:01051> unaligned_len_map_test [RUNNING] [00002.150] 01048:01051> [PASSED] (42 ms) [00002.150] 01048:01051> rights_drop_test [RUNNING] [00002.150] 01048:01051> [PASSED] (0 ms) [00002.150] 01048:01051> protect_test [RUNNING] [00002.151] 01048:01051> [PASSED] (0 ms) [00002.151] 01048:01051> nested_region_perms_test [RUNNING] [00002.151] 01048:01051> [PASSED] (0 ms) [00002.151] 01048:01051> object_info_test [RUNNING] [00002.151] 01048:01051> [PASSED] (0 ms) [00002.151] 01048:01051> unmap_split_test [RUNNING] [00002.151] 01048:01051> [PASSED] (0 ms) [00002.151] 01048:01051> unmap_multiple_test [RUNNING] [00002.198] 01048:01051> [PASSED] (46 ms) [00002.198] 01048:01051> unmap_base_not_mapped_test [RUNNING] [00002.198] 01048:01051> [PASSED] (0 ms) [00002.198] 01048:01051> map_specific_overwrite_test [RUNNING] [00002.198] 01048:01051> [PASSED] (0 ms) [00002.198] 01048:01051> protect_split_test [RUNNING] [00002.198] 01048:01051> [PASSED] (0 ms) [00002.198] 01048:01051> protect_multiple_test [RUNNING] [00002.198] 01048:01051> [PASSED] (0 ms) [00002.198] 01048:01051> protect_over_demand_paged_test [RUNNING] [00002.237] 01048:01051> [PASSED] (39 ms) [00002.237] 01048:01051> protect_large_uncommitted_test [RUNNING] [00002.247] 01048:01051> [PASSED] (10 ms) [00002.247] 01048:01051> unmap_large_uncommitted_test [RUNNING] [00002.256] 01048:34557> PageFault: 1028773 free pages [00002.256] 01048:34557> [00002.256] 01048:34557> ZIRCON KERNEL OOPS [00002.256] 01048:34557> Lock validation failed for thread 0xffffff8000390660 pid 1048 tid 34557 (bin/core-tests:vmar_test_addr): [00002.256] 01048:34557> Reason: Already Acquired [00002.256] 01048:34557> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00002.256] 01048:34557> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00002.256] 01048:34557> caller=0xffffffff0014c5ab frame=0xffffff9b25bb6d60 [00002.256] 01048:34557> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00002.256] 01048:34557> [00002.256] 01048:34557> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00002.256] 01048:34557> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00002.256] 01048:34557> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00002.256] 01048:34557> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00002.256] 01048:34557> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00002.256] 01048:34557> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00002.256] 01048:34557> bt#00: 0xffffffff0014c5ab [00002.256] 01048:34557> bt#01: 0xffffffff0014c9ef [00002.256] 01048:34557> bt#02: 0xffffffff00138d3e [00002.256] 01048:34557> bt#03: 0xffffffff001f4eec [00002.256] 01048:34557> bt#04: 0xffffffff001bc61a [00002.256] 01048:34557> bt#05: 0xffffffff001bc27b [00002.256] 01048:34557> bt#06: end [00002.256] 01048:34557> {{{bt:0:0xffffffff0014c5ab}}} [00002.256] 01048:34557> {{{bt:1:0xffffffff0014c9ef}}} [00002.256] 01048:34557> {{{bt:2:0xffffffff00138d3e}}} [00002.256] 01048:34557> {{{bt:3:0xffffffff001f4eec}}} [00002.256] 01048:34557> {{{bt:4:0xffffffff001bc61a}}} [00002.256] 01048:34557> {{{bt:5:0xffffffff001bc27b}}} [00002.256] 01048:34557> [00002.369] 01048:34560> PageFault: 1028773 free pages [00002.369] 01048:34560> [00002.369] 01048:34560> ZIRCON KERNEL OOPS [00002.369] 01048:34560> Lock validation failed for thread 0xffffff8000390660 pid 1048 tid 34560 (bin/core-tests:vmar_test_addr): [00002.369] 01048:34560> Reason: Already Acquired [00002.369] 01048:34560> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00002.369] 01048:34560> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00002.369] 01048:34560> caller=0xffffffff0014c5ab frame=0xffffff9b25bb6d60 [00002.369] 01048:34560> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00002.369] 01048:34560> [00002.369] 01048:34560> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00002.369] 01048:34560> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00002.369] 01048:34560> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00002.369] 01048:34560> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00002.369] 01048:34560> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00002.369] 01048:34560> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00002.369] 01048:34560> bt#00: 0xffffffff0014c5ab [00002.369] 01048:34560> bt#01: 0xffffffff0014c9ef [00002.369] 01048:34560> bt#02: 0xffffffff00138d3e [00002.369] 01048:34560> bt#03: 0xffffffff001f4eec [00002.369] 01048:34560> bt#04: 0xffffffff001bc61a [00002.369] 01048:34560> bt#05: 0xffffffff001bc27b [00002.369] 01048:34560> bt#06: end [00002.369] 01048:34560> {{{bt:0:0xffffffff0014c5ab}}} [00002.369] 01048:34560> {{{bt:1:0xffffffff0014c9ef}}} [00002.369] 01048:34560> {{{bt:2:0xffffffff00138d3e}}} [00002.369] 01048:34560> {{{bt:3:0xffffffff001f4eec}}} [00002.369] 01048:34560> {{{bt:4:0xffffffff001bc61a}}} [00002.369] 01048:34560> {{{bt:5:0xffffffff001bc27b}}} [00002.369] 01048:34560> [00002.484] 01048:34563> PageFault: 1028773 free pages [00002.484] 01048:34563> [00002.484] 01048:34563> ZIRCON KERNEL OOPS [00002.484] 01048:34563> Lock validation failed for thread 0xffffff8000390660 pid 1048 tid 34563 (bin/core-tests:vmar_test_addr): [00002.484] 01048:34563> Reason: Already Acquired [00002.484] 01048:34563> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00002.484] 01048:34563> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00002.484] 01048:34563> caller=0xffffffff0014c5ab frame=0xffffff9b25bb6d60 [00002.484] 01048:34563> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00002.484] 01048:34563> [00002.484] 01048:34563> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00002.484] 01048:34563> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00002.484] 01048:34563> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00002.484] 01048:34563> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00002.484] 01048:34563> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00002.484] 01048:34563> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00002.484] 01048:34563> bt#00: 0xffffffff0014c5ab [00002.484] 01048:34563> bt#01: 0xffffffff0014c9ef [00002.484] 01048:34563> bt#02: 0xffffffff00138d3e [00002.484] 01048:34563> bt#03: 0xffffffff001f4eec [00002.484] 01048:34563> bt#04: 0xffffffff001bc61a [00002.484] 01048:34563> bt#05: 0xffffffff001bc27b [00002.484] 01048:34563> bt#06: end [00002.484] 01048:34563> {{{bt:0:0xffffffff0014c5ab}}} [00002.484] 01048:34563> {{{bt:1:0xffffffff0014c9ef}}} [00002.484] 01048:34563> {{{bt:2:0xffffffff00138d3e}}} [00002.484] 01048:34563> {{{bt:3:0xffffffff001f4eec}}} [00002.484] 01048:34563> {{{bt:4:0xffffffff001bc61a}}} [00002.484] 01048:34563> {{{bt:5:0xffffffff001bc27b}}} [00002.484] 01048:34563> [00002.605] 01048:01051> [PASSED] (358 ms) [00002.605] 01048:01051> partial_unmap_and_read [RUNNING] [00002.606] 01048:01051> [PASSED] (0 ms) [00002.606] 01048:01051> partial_unmap_and_write [RUNNING] [00002.606] 01048:01051> [PASSED] (0 ms) [00002.606] 01048:01051> partial_unmap_with_vmar_offset [RUNNING] [00002.606] 01048:01051> [PASSED] (0 ms) [00002.606] 01048:01051> CASE vmar_tests [PASSED] [00002.606] 01048:01051> CASE threads_tests [STARTED] [00002.606] 01048:01051> TestBasics [RUNNING] [00002.707] 01048:01051> [PASSED] (100 ms) [00002.707] 01048:01051> TestInvalidRights [RUNNING] [00002.707] 01048:01051> [PASSED] (0 ms) [00002.707] 01048:01051> TestDetach [RUNNING] [00002.707] 01048:01051> [PASSED] (0 ms) [00002.707] 01048:01051> TestLongNameSucceeds [RUNNING] [00002.729] 01048:01051> [PASSED] (22 ms) [00002.729] 01048:01051> TestThreadStartOnInitialThread [RUNNING] [00002.729] 01048:01051> [PASSED] (0 ms) [00002.729] 01048:01051> TestThreadStartWithZeroInstructionPointer [RUNNING] [00002.730] 01048:01051> [00002.730] 01048:01051> ZIRCON KERNEL OOPS [00002.730] 01048:01051> Lock validation failed for thread 0xffffff8000382538 pid 1048 tid 1051 (bin/core-tests:bin/core-tests): [00002.730] 01048:01051> Reason: Out Of Order [00002.730] 01048:01051> Bad lock: name=lockdep::LockClass<SoloDispatcher<ThreadDispatcher, 316111, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00002.730] 01048:01051> Conflict: name=lockdep::LockClass<SoloDispatcher<ProcessDispatcher, 447439, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00002.730] 01048:01051> caller=0xffffffff0016423b frame=0xffffff9b22b91ed0 [00002.730] 01048:01051> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00002.730] 01048:01051> [00002.730] 01048:01051> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00002.730] 01048:01051> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00002.730] 01048:01051> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00002.730] 01048:01051> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00002.730] 01048:01051> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00002.730] 01048:01051> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00002.730] 01048:01051> bt#00: 0xffffffff0016423b [00002.730] 01048:01051> bt#01: 0xffffffff00159c9c [00002.730] 01048:01051> bt#02: 0xffffffff0015a4dd [00002.730] 01048:01051> bt#03: 0xffffffff002174f6 [00002.730] 01048:01051> bt#04: 0xffffffff00220691 [00002.730] 01048:01051> bt#05: 0xffffffff001cdb5e [00002.730] 01048:01051> bt#06: end [00002.730] 01048:01051> {{{bt:0:0xffffffff0016423b}}} [00002.730] 01048:01051> {{{bt:1:0xffffffff00159c9c}}} [00002.730] 01048:01051> {{{bt:2:0xffffffff0015a4dd}}} [00002.730] 01048:01051> {{{bt:3:0xffffffff002174f6}}} [00002.730] 01048:01051> {{{bt:4:0xffffffff00220691}}} [00002.730] 01048:01051> {{{bt:5:0xffffffff001cdb5e}}} [00002.730] 01048:01051> [00002.731] 01048:01051> [PASSED] (1 ms) [00002.731] 01048:01051> TestKillBusyThread [RUNNING] [00002.972] 01048:01051> [PASSED] (241 ms) [00002.972] 01048:01051> TestKillSleepThread [RUNNING] [00003.073] 01048:01051> [PASSED] (101 ms) [00003.073] 01048:01051> TestKillWaitThread [RUNNING] [00003.175] 01048:01051> [PASSED] (101 ms) [00003.175] 01048:01051> TestNonstartedThread [RUNNING] [00003.178] 01048:01051> [PASSED] (2 ms) [00003.178] 01048:01051> TestThreadKillsItself [RUNNING] [00003.191] 01048:01051> [PASSED] (12 ms) [00003.191] 01048:01051> TestInfoTaskStatsFails [RUNNING] [00003.292] 01048:01051> [PASSED] (100 ms) [00003.292] 01048:01051> TestResumeSuspended [RUNNING] [00003.401] 01048:01051> [PASSED] (109 ms) [00003.401] 01048:01051> TestSuspendSleeping [RUNNING] [00003.502] 01048:01051> [PASSED] (100 ms) [00003.502] 01048:01051> TestSuspendChannelCall [RUNNING] [00003.505] 01048:01051> [PASSED] (3 ms) [00003.505] 01048:01051> TestSuspendPortCall [RUNNING] [00003.707] 01048:01051> [PASSED] (201 ms) [00003.707] 01048:01051> TestSuspendStopsThread [RUNNING] [00003.758] 01048:01051> [PASSED] (50 ms) [00003.758] 01048:01051> TestSuspendMultiple [RUNNING] [00003.759] 01048:01051> [PASSED] (1 ms) [00003.759] 01048:01051> TestSuspendSelf [RUNNING] [00003.759] 01048:01051> [PASSED] (0 ms) [00003.759] 01048:01051> TestSuspendAfterDeath [RUNNING] [00003.759] 01048:01051> [PASSED] (0 ms) [00003.759] 01048:01051> TestKillSuspendedThread [RUNNING] [00003.760] 01048:01051> [PASSED] (0 ms) [00003.760] 01048:01051> TestStartSuspendedThread [RUNNING] [00003.760] 01048:01051> [PASSED] (0 ms) [00003.760] 01048:01051> TestStartSuspendedAndResumedThread [RUNNING] [00003.760] 01048:01051> [PASSED] (0 ms) [00003.761] 01048:01051> TestSuspendSingleWaitAsyncSignalDelivery [RUNNING] [00003.766] 01048:01051> [PASSED] (5 ms) [00003.766] 01048:01051> TestSuspendRepeatingWaitAsyncSignalDelivery [RUNNING] [00003.817] 01048:01051> [PASSED] (51 ms) [00003.818] 01048:01051> TestReadingGeneralRegisterState [RUNNING] [00003.918] 01048:01051> [PASSED] (100 ms) [00003.918] 01048:01051> TestWritingGeneralRegisterState [RUNNING] [00004.019] 01048:01051> [PASSED] (101 ms) [00004.019] 01048:01051> TestThreadLocalRegisterState [RUNNING] [00004.120] 01048:01051> [PASSED] (100 ms) [00004.120] 01048:01051> TestNoncanonicalRipAddress [RUNNING] [00004.222] 01048:01051> [PASSED] (101 ms) [00004.222] 01048:01051> TestWritingArmFlagsRegister [RUNNING] [00004.222] 01048:01051> [PASSED] (0 ms) [00004.222] 01048:01051> CASE threads_tests [PASSED] [00004.222] 01048:01051> CASE sync_mutex_tests [STARTED] [00004.222] 01048:01051> test_mutexes [RUNNING] [00004.304] 01048:01051> [PASSED] (81 ms) [00004.304] 01048:01051> test_try_mutexes [RUNNING] [00004.394] 01048:01051> [PASSED] (90 ms) [00004.395] 01048:01051> test_timeout_elapsed [RUNNING] [00004.905] 01048:01051> [PASSED] (510 ms) [00004.905] 01048:01051> CASE sync_mutex_tests [PASSED] [00004.905] 01048:01051> CASE sync_condition_tests [STARTED] [00004.905] 01048:01051> Condition::condition_test [RUNNING] [00004.925] 01048:01051> [PASSED] (19 ms) [00004.925] 01048:01051> Condition::condition_timeout_test [RUNNING] [00004.926] 01048:01051> [PASSED] (1 ms) [00004.926] 01048:01051> CASE sync_condition_tests [PASSED] [00004.926] 01048:01051> CASE sync_completion_tests [STARTED] [00004.926] 01048:01051> test_initializer [RUNNING] [00004.926] 01048:01051> [PASSED] (0 ms) [00004.926] 01048:01051> test_completions [RUNNING] [00004.971] 01048:01051> [PASSED] (45 ms) [00004.971] 01048:01051> test_timeout [RUNNING] [00004.972] 01048:01051> [PASSED] (0 ms) [00004.972] 01048:01051> CASE sync_completion_tests [PASSED] [00004.972] 01048:01051> CASE sync_completion_tests [STARTED] [00004.972] 01048:01051> test_initializer [RUNNING] [00004.972] 01048:01051> [PASSED] (0 ms) [00004.972] 01048:01051> test_completions [RUNNING] [00005.013] 01048:01051> [PASSED] (40 ms) [00005.013] 01048:01051> test_timeout [RUNNING] [00006.137] 01048:01051> [PASSED] (1123 ms) [00006.137] 01048:01051> test_signal_requeue [RUNNING] [00006.164] 01048:01051> [PASSED] (27 ms) [00006.164] 01048:01051> test_completion_signaled [RUNNING] [00006.164] 01048:01051> [PASSED] (0 ms) [00006.164] 01048:01051> CASE sync_completion_tests [PASSED] [00006.164] 01048:01051> CASE stack_tests [STARTED] [00006.164] 01048:01051> main_thread_stack_tests [RUNNING] [00006.164] 01048:01051> [PASSED] (0 ms) [00006.164] 01048:01051> other_thread_stack_tests [RUNNING] [00006.165] 01048:01051> [PASSED] (0 ms) [00006.165] 01048:01051> CASE stack_tests [PASSED] [00006.165] 01048:01051> CASE tls_tests [STARTED] [00006.165] 01048:01051> tls_test [RUNNING] [00008.250] 01048:01051> [PASSED] (2084 ms) [00008.250] 01048:01051> CASE tls_tests [PASSED] [00008.250] 01048:01051> CASE pthread_barrier_tests [STARTED] [00008.250] 01048:01051> test_barrier [RUNNING] [00008.372] 01048:01051> [PASSED] (122 ms) [00008.372] 01048:01051> CASE pthread_barrier_tests [PASSED] [00008.372] 01048:01051> CASE pthread_tests [STARTED] [00008.372] 01048:01051> pthread_test [RUNNING] [00011.486] 01048:01051> [PASSED] (3114 ms) [00011.486] 01048:01051> pthread_self_main_thread_test [RUNNING] [00011.486] 01048:01051> [PASSED] (0 ms) [00011.486] 01048:01051> pthread_big_stack_size [RUNNING] [00011.522] 01048:01051> [PASSED] (36 ms) [00011.522] 01048:01051> pthread_getstack_main_thread [RUNNING] [00011.522] 01048:01051> [PASSED] (0 ms) [00011.523] 01048:01051> pthread_getstack_other_thread [RUNNING] [00011.523] 01048:01051> [PASSED] (0 ms) [00011.523] 01048:01051> CASE pthread_tests [PASSED] [00011.523] 01048:01051> CASE process_tests [STARTED] [00011.523] 01048:01051> mini_process_sanity [RUNNING] [00011.541] 01048:01051> [PASSED] (18 ms) [00011.541] 01048:01051> process_start_fail [RUNNING] [00011.549] 01048:01051> [PASSED] (7 ms) [00011.549] 01048:01051> process_start_no_handle [RUNNING] [00011.549] 01048:01051> [PASSED] (0 ms) [00011.549] 01048:01051> process_not_killed_via_thread_close [RUNNING] [00011.561] 01048:01051> [PASSED] (11 ms) [00011.561] 01048:01051> process_not_killed_via_process_close [RUNNING] [00011.563] 01048:01051> [PASSED] (1 ms) [00011.563] 01048:01051> kill_process_via_thread_kill [RUNNING] [00011.569] 01048:01051> [PASSED] (6 ms) [00011.569] 01048:01051> kill_process_via_vmar_destroy [RUNNING] [00011.570] 35352:35354> PageFault: 1028570 free pages [00011.570] 35352:35354> [00011.570] 35352:35354> ZIRCON KERNEL OOPS [00011.570] 35352:35354> Lock validation failed for thread 0xffffff80003a9240 pid 35352 tid 35354 (ttp:th): [00011.570] 35352:35354> Reason: Already Acquired [00011.570] 35352:35354> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00011.570] 35352:35354> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00011.570] 35352:35354> caller=0xffffffff0014c5ab frame=0xffffff9b25c26d60 [00011.570] 35352:35354> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00011.570] 35352:35354> [00011.570] 35352:35354> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00011.570] 35352:35354> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00011.570] 35352:35354> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00011.570] 35352:35354> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00011.570] 35352:35354> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00011.570] 35352:35354> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00011.570] 35352:35354> bt#00: 0xffffffff0014c5ab [00011.570] 35352:35354> bt#01: 0xffffffff0014c9ef [00011.570] 35352:35354> bt#02: 0xffffffff00138d3e [00011.570] 35352:35354> bt#03: 0xffffffff001f4eec [00011.570] 35352:35354> bt#04: 0xffffffff001bc61a [00011.570] 35352:35354> bt#05: 0xffffffff001bc27b [00011.570] 35352:35354> bt#06: end [00011.570] 35352:35354> {{{bt:0:0xffffffff0014c5ab}}} [00011.570] 35352:35354> {{{bt:1:0xffffffff0014c9ef}}} [00011.570] 35352:35354> {{{bt:2:0xffffffff00138d3e}}} [00011.570] 35352:35354> {{{bt:3:0xffffffff001f4eec}}} [00011.570] 35352:35354> {{{bt:4:0xffffffff001bc61a}}} [00011.570] 35352:35354> {{{bt:5:0xffffffff001bc27b}}} [00011.570] 35352:35354> [00011.577] 01048:01051> [PASSED] (7 ms) [00011.577] 01048:01051> kill_channel_handle_cycle [RUNNING] [00012.336] 01048:01051> [PASSED] (759 ms) [00012.337] 01048:01051> info_reflects_process_state [RUNNING] [00012.590] 01048:01051> [PASSED] (253 ms) [00012.590] 01048:01051> suspend [RUNNING] [00012.591] 01048:01051> [PASSED] (0 ms) [00012.591] 01048:01051> suspend_self [RUNNING] [00012.591] 01048:01051> [PASSED] (0 ms) [00012.591] 01048:01051> suspend_multiple_threads [RUNNING] [00012.613] 01048:01051> [PASSED] (22 ms) [00012.614] 01048:01051> suspend_before_creating_threads [RUNNING] [00012.614] 01048:01051> [PASSED] (0 ms) [00012.614] 01048:01051> suspend_before_starting_threads [RUNNING] [00012.616] 01048:01051> [PASSED] (2 ms) [00012.616] 01048:01051> suspend_process_then_thread [RUNNING] [00012.874] 01048:01051> [PASSED] (257 ms) [00012.874] 01048:01051> suspend_thread_then_process [RUNNING] [00013.129] 01048:01051> [PASSED] (255 ms) [00013.129] 01048:01051> suspend_thread_and_process_before_starting_process [RUNNING] [00013.392] 01048:01051> [PASSED] (263 ms) [00013.393] 01048:01051> suspend_twice [RUNNING] [00013.652] 01048:01051> [PASSED] (259 ms) [00013.652] 01048:01051> suspend_twice_before_creating_threads [RUNNING] [00013.911] 01048:01051> [PASSED] (259 ms) [00013.911] 01048:01051> suspend_with_dying_thread [RUNNING] [00013.921] 01048:01051> [PASSED] (9 ms) [00013.921] 01048:01051> create_and_kill_job_race_stress [RUNNING] [00014.930] 01048:01051> [PASSED] (1009 ms) [00014.930] 01048:01051> CASE process_tests [PASSED] [00014.930] 01048:01051> CASE port_tests [STARTED] [00014.930] 01048:01051> basic_test [RUNNING] [00014.930] 01048:01051> [PASSED] (0 ms) [00014.930] 01048:01051> queue_and_close_test [RUNNING] [00014.930] 01048:01051> [PASSED] (0 ms) [00014.930] 01048:01051> queue_too_many [RUNNING] [00014.932] 01048:01051> [PASSED] (1 ms) [00014.932] 01048:01051> async_wait_channel_test [RUNNING] [00014.933] 01048:01051> [PASSED] (1 ms) [00014.934] 01048:01051> async_wait_event_test_single [RUNNING] [00014.934] 01048:01051> [PASSED] (0 ms) [00014.934] 01048:01051> async_wait_event_test_repeat [RUNNING] [00014.934] 01048:01051> [PASSED] (0 ms) [00014.934] 01048:01051> async_wait_event_all_processed [RUNNING] [00014.981] 01048:01051> [PASSED] (47 ms) [00014.981] 01048:01051> async_wait_invalid_option [RUNNING] [00014.981] 01048:01051> [PASSED] (0 ms) [00014.981] 01048:01051> async_wait_close_order_1 [RUNNING] [00014.981] 01048:01051> [PASSED] (0 ms) [00014.981] 01048:01051> async_wait_close_order_2 [RUNNING] [00014.981] 01048:01051> [PASSED] (0 ms) [00014.981] 01048:01051> async_wait_close_order_3 [RUNNING] [00014.981] 01048:01051> [PASSED] (0 ms) [00014.981] 01048:01051> async_wait_close_order_4 [RUNNING] [00014.981] 01048:01051> [PASSED] (0 ms) [00014.981] 01048:01051> async_wait_close_order_5 [RUNNING] [00014.981] 01048:01051> [PASSED] (0 ms) [00014.981] 01048:01051> async_wait_close_order_6 [RUNNING] [00014.981] 01048:01051> [PASSED] (0 ms) [00014.981] 01048:01051> channel_pre_writes_test [RUNNING] [00014.981] 01048:01051> [PASSED] (0 ms) [00014.981] 01048:01051> cancel_event_key [RUNNING] [00014.981] 01048:01051> [PASSED] (0 ms) [00014.981] 01048:01051> cancel_event_key_after [RUNNING] [00014.981] 01048:01051> [PASSED] (0 ms) [00014.981] 01048:01051> threads_event [RUNNING] [00015.062] 01048:01051> [PASSED] (80 ms) [00015.062] 01048:01051> cancel_stress [RUNNING] [00018.047] 01048:01051> [PASSED] (2985 ms) [00018.047] 01048:01051> signal_close_stress [RUNNING] [00019.091] 01048:01051> [PASSED] (1043 ms) [00019.091] 01048:01051> port_close_wait_race_stress [RUNNING] [00020.108] 01048:01051> [PASSED] (1009 ms) [00020.108] 01048:01051> CASE port_tests [PASSED] [00020.108] 01048:01051> CASE api_violations [STARTED] [00020.108] 01048:01051> invalid_pager_create [RUNNING] [00020.108] 01048:01051> [PASSED] (0 ms) [00020.108] 01048:01051> invalid_pager_create_vmo [RUNNING] [00020.108] 01048:01051> [PASSED] (0 ms) [00020.108] 01048:01051> invalid_pager_detach_vmo [RUNNING] [00020.108] 01048:01051> [PASSED] (0 ms) [00020.108] 01048:01051> invalid_pager_supply_pages [RUNNING] [00020.109] 01048:01051> [PASSED] (0 ms) [00020.109] 01048:01051> resize_nonresizable_vmo [RUNNING] [00020.109] 01048:01051> [PASSED] (0 ms) [00020.109] 01048:01051> CASE api_violations [PASSED] [00020.109] 01048:01051> CASE commit_tests [STARTED] [00020.109] 01048:01051> simple_commit_test [RUNNING] [00020.116] 01048:01051> [PASSED] (6 ms) [00020.116] 01048:01051> split_commit_test [RUNNING] [00020.120] 01048:01051> [PASSED] (4 ms) [00020.120] 01048:01051> overlap_commit_test [RUNNING] [00020.125] 01048:01051> [PASSED] (4 ms) [00020.125] 01048:01051> overlap_commit_supply_test [RUNNING] [00020.193] 01048:01051> [PASSED] (67 ms) [00020.193] 01048:01051> multisupply_commit_test [RUNNING] [00020.195] 01048:01051> [PASSED] (2 ms) [00020.195] 01048:01051> multicommit_supply_test [RUNNING] [00020.207] 01048:01051> [PASSED] (12 ms) [00020.208] 01048:01051> commit_redundant_supply_test [RUNNING] [00020.210] 01048:01051> [PASSED] (2 ms) [00020.210] 01048:01051> supply_decommit_test [RUNNING] [00020.215] 01048:01051> [PASSED] (4 ms) [00020.215] 01048:01051> resize_commit_test [RUNNING] [00020.217] 01048:01051> [PASSED] (2 ms) [00020.217] 01048:01051> suspend_commit_test [RUNNING] [00020.222] 01048:01051> [PASSED] (4 ms) [00020.222] 01048:01051> CASE commit_tests [PASSED] [00020.222] 01048:01051> CASE clone_tests [STARTED] [00020.222] 01048:01051> clone_read_from_clone_test_vmar [RUNNING] [00020.224] 01048:01051> [PASSED] (2 ms) [00020.224] 01048:01051> clone_read_from_clone_test_vmo [RUNNING] [00020.229] 01048:01051> [PASSED] (4 ms) [00020.229] 01048:01051> clone_read_from_parent_test_vmar [RUNNING] [00020.236] 01048:01051> [PASSED] (6 ms) [00020.236] 01048:01051> clone_read_from_parent_test_vmo [RUNNING] [00020.243] 01048:01051> [PASSED] (6 ms) [00020.243] 01048:01051> clone_simultaneous_read_test_vmar [RUNNING] [00020.248] 01048:01051> [PASSED] (5 ms) [00020.248] 01048:01051> clone_simultaneous_read_test_vmo [RUNNING] [00020.255] 01048:01051> [PASSED] (6 ms) [00020.255] 01048:01051> clone_simultaneous_child_read_test_vmar [RUNNING] [00020.260] 01048:01051> [PASSED] (4 ms) [00020.260] 01048:01051> clone_simultaneous_child_read_test_vmo [RUNNING] [00020.266] 01048:01051> [PASSED] (6 ms) [00020.266] 01048:01051> clone_write_to_clone_test [RUNNING] [00020.269] 01048:01051> [PASSED] (2 ms) [00020.269] 01048:01051> clone_detach_test [RUNNING] [00020.273] 01048:01051> [PASSED] (4 ms) [00020.273] 01048:01051> clone_commit_test [RUNNING] [00020.276] 01048:01051> [PASSED] (2 ms) [00020.276] 01048:01051> clone_split_commit_test [RUNNING] [00020.281] 01048:01051> [PASSED] (4 ms) [00020.281] 01048:01051> clone_decommit_test [RUNNING] [00020.281] 01048:01051> [PASSED] (0 ms) [00020.281] 01048:01051> CASE clone_tests [PASSED] [00020.281] 01048:01051> CASE lifecycle_tests [STARTED] [00020.281] 01048:01051> vmo_info_pager_test [RUNNING] [00020.281] 01048:01051> [PASSED] (0 ms) [00020.281] 01048:01051> detach_page_complete_test [RUNNING] [00020.281] 01048:01051> [PASSED] (0 ms) [00020.281] 01048:01051> close_page_complete_test [RUNNING] [00020.281] 01048:01051> [PASSED] (0 ms) [00020.281] 01048:01051> read_detach_interrupt_late_test_vmar [RUNNING] [00020.281] 01048:56026> PageFault: 1026887 free pages [00020.281] 01048:56026> [00020.281] 01048:56026> ZIRCON KERNEL OOPS [00020.281] 01048:56026> Lock validation failed for thread 0xffffff80030dad10 pid 1048 tid 56026 (bin/core-tests:test_thread): [00020.281] 01048:56026> Reason: Already Acquired [00020.281] 01048:56026> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.281] 01048:56026> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.281] 01048:56026> caller=0xffffffff0014c5ab frame=0xffffff9b25c26d60 [00020.281] 01048:56026> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00020.281] 01048:56026> [00020.281] 01048:56026> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00020.281] 01048:56026> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00020.281] 01048:56026> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00020.281] 01048:56026> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00020.281] 01048:56026> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00020.281] 01048:56026> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00020.281] 01048:56026> bt#00: 0xffffffff0014c5ab [00020.281] 01048:56026> bt#01: 0xffffffff0014c9ef [00020.281] 01048:56026> bt#02: 0xffffffff00138d3e [00020.281] 01048:56026> bt#03: 0xffffffff001f4eec [00020.281] 01048:56026> bt#04: 0xffffffff001bc61a [00020.281] 01048:56026> bt#05: 0xffffffff001bc27b [00020.281] 01048:56026> bt#06: end [00020.281] 01048:56026> {{{bt:0:0xffffffff0014c5ab}}} [00020.281] 01048:56026> {{{bt:1:0xffffffff0014c9ef}}} [00020.281] 01048:56026> {{{bt:2:0xffffffff00138d3e}}} [00020.281] 01048:56026> {{{bt:3:0xffffffff001f4eec}}} [00020.281] 01048:56026> {{{bt:4:0xffffffff001bc61a}}} [00020.281] 01048:56026> {{{bt:5:0xffffffff001bc27b}}} [00020.281] 01048:56026> [00020.281] 01048:56026> [00020.281] 01048:56026> ZIRCON KERNEL OOPS [00020.281] 01048:56026> Lock validation failed for thread 0xffffff80030dad10 pid 1048 tid 56026 (bin/core-tests:test_thread): [00020.281] 01048:56026> Reason: Already Acquired [00020.281] 01048:56026> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.281] 01048:56026> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.281] 01048:56026> caller=0xffffffff0014c5ab frame=0xffffff9b25c26cd0 [00020.281] 01048:56026> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00020.281] 01048:56026> [00020.281] 01048:56026> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00020.281] 01048:56026> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00020.281] 01048:56026> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00020.281] 01048:56026> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00020.281] 01048:56026> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00020.281] 01048:56026> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00020.281] 01048:56026> bt#00: 0xffffffff0014c5ab [00020.281] 01048:56026> bt#01: 0xffffffff0014c9ef [00020.281] 01048:56026> bt#02: 0xffffffff0014c9ef [00020.281] 01048:56026> bt#03: 0xffffffff00138d3e [00020.281] 01048:56026> bt#04: 0xffffffff001f4eec [00020.281] 01048:56026> bt#05: 0xffffffff001bc61a [00020.281] 01048:56026> bt#06: 0xffffffff001bc27b [00020.281] 01048:56026> bt#07: end [00020.281] 01048:56026> {{{bt:0:0xffffffff0014c5ab}}} [00020.281] 01048:56026> {{{bt:1:0xffffffff0014c9ef}}} [00020.281] 01048:56026> {{{bt:2:0xffffffff0014c9ef}}} [00020.281] 01048:56026> {{{bt:3:0xffffffff00138d3e}}} [00020.281] 01048:56026> {{{bt:4:0xffffffff001f4eec}}} [00020.281] 01048:56026> {{{bt:5:0xffffffff001bc61a}}} [00020.281] 01048:56026> {{{bt:6:0xffffffff001bc27b}}} [00020.281] 01048:56026> [00020.281] 01048:56026> [00020.281] 01048:56026> ZIRCON KERNEL OOPS [00020.281] 01048:56026> Lock validation failed for thread 0xffffff80030dad10 pid 1048 tid 56026 (bin/core-tests:test_thread): [00020.281] 01048:56026> Reason: Already Acquired [00020.281] 01048:56026> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.281] 01048:56026> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.281] 01048:56026> caller=0xffffffff0014c5ab frame=0xffffff9b25c26cd0 [00020.281] 01048:56026> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00020.281] 01048:56026> [00020.281] 01048:56026> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00020.281] 01048:56026> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00020.281] 01048:56026> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00020.281] 01048:56026> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00020.281] 01048:56026> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00020.281] 01048:56026> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00020.281] 01048:56026> bt#00: 0xffffffff0014c5ab [00020.281] 01048:56026> bt#01: 0xffffffff0014c9ef [00020.281] 01048:56026> bt#02: 0xffffffff0014c9ef [00020.281] 01048:56026> bt#03: 0xffffffff00138d3e [00020.281] 01048:56026> bt#04: 0xffffffff001f4eec [00020.281] 01048:56026> bt#05: 0xffffffff001bc61a [00020.281] 01048:56026> bt#06: 0xffffffff001bc27b [00020.281] 01048:56026> bt#07: end [00020.281] 01048:56026> {{{bt:0:0xffffffff0014c5ab}}} [00020.281] 01048:56026> {{{bt:1:0xffffffff0014c9ef}}} [00020.281] 01048:56026> {{{bt:2:0xffffffff0014c9ef}}} [00020.281] 01048:56026> {{{bt:3:0xffffffff00138d3e}}} [00020.281] 01048:56026> {{{bt:4:0xffffffff001f4eec}}} [00020.281] 01048:56026> {{{bt:5:0xffffffff001bc61a}}} [00020.281] 01048:56026> {{{bt:6:0xffffffff001bc27b}}} [00020.281] 01048:56026> [00020.283] 01048:01051> [PASSED] (2 ms) [00020.283] 01048:01051> read_detach_interrupt_late_test_vmo [RUNNING] [00020.288] 01048:01051> [PASSED] (4 ms) [00020.288] 01048:01051> read_close_interrupt_late_test_vmar [RUNNING] [00020.288] 01048:56046> PageFault: 1026888 free pages [00020.289] 01048:56046> [00020.289] 01048:56046> ZIRCON KERNEL OOPS [00020.289] 01048:56046> Lock validation failed for thread 0xffffff80030dad10 pid 1048 tid 56046 (bin/core-tests:test_thread): [00020.289] 01048:56046> Reason: Already Acquired [00020.289] 01048:56046> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.289] 01048:56046> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.289] 01048:56046> caller=0xffffffff0014c5ab frame=0xffffff9b25c26d60 [00020.289] 01048:56046> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00020.289] 01048:56046> [00020.289] 01048:56046> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00020.289] 01048:56046> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00020.289] 01048:56046> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00020.289] 01048:56046> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00020.289] 01048:56046> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00020.289] 01048:56046> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00020.289] 01048:56046> bt#00: 0xffffffff0014c5ab [00020.289] 01048:56046> bt#01: 0xffffffff0014c9ef [00020.289] 01048:56046> bt#02: 0xffffffff00138d3e [00020.289] 01048:56046> bt#03: 0xffffffff001f4eec [00020.289] 01048:56046> bt#04: 0xffffffff001bc61a [00020.289] 01048:56046> bt#05: 0xffffffff001bc27b [00020.289] 01048:56046> bt#06: end [00020.289] 01048:56046> {{{bt:0:0xffffffff0014c5ab}}} [00020.289] 01048:56046> {{{bt:1:0xffffffff0014c9ef}}} [00020.289] 01048:56046> {{{bt:2:0xffffffff00138d3e}}} [00020.289] 01048:56046> {{{bt:3:0xffffffff001f4eec}}} [00020.289] 01048:56046> {{{bt:4:0xffffffff001bc61a}}} [00020.289] 01048:56046> {{{bt:5:0xffffffff001bc27b}}} [00020.289] 01048:56046> [00020.289] 01048:56046> [00020.289] 01048:56046> ZIRCON KERNEL OOPS [00020.289] 01048:56046> Lock validation failed for thread 0xffffff80030dad10 pid 1048 tid 56046 (bin/core-tests:test_thread): [00020.289] 01048:56046> Reason: Already Acquired [00020.289] 01048:56046> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.289] 01048:56046> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.289] 01048:56046> caller=0xffffffff0014c5ab frame=0xffffff9b25c26cd0 [00020.289] 01048:56046> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00020.289] 01048:56046> [00020.289] 01048:56046> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00020.289] 01048:56046> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00020.289] 01048:56046> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00020.289] 01048:56046> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00020.289] 01048:56046> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00020.289] 01048:56046> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00020.289] 01048:56046> bt#00: 0xffffffff0014c5ab [00020.289] 01048:56046> bt#01: 0xffffffff0014c9ef [00020.289] 01048:56046> bt#02: 0xffffffff0014c9ef [00020.289] 01048:56046> bt#03: 0xffffffff00138d3e [00020.289] 01048:56046> bt#04: 0xffffffff001f4eec [00020.289] 01048:56046> bt#05: 0xffffffff001bc61a [00020.289] 01048:56046> bt#06: 0xffffffff001bc27b [00020.289] 01048:56046> bt#07: end [00020.289] 01048:56046> {{{bt:0:0xffffffff0014c5ab}}} [00020.289] 01048:56046> {{{bt:1:0xffffffff0014c9ef}}} [00020.289] 01048:56046> {{{bt:2:0xffffffff0014c9ef}}} [00020.289] 01048:56046> {{{bt:3:0xffffffff00138d3e}}} [00020.289] 01048:56046> {{{bt:4:0xffffffff001f4eec}}} [00020.289] 01048:56046> {{{bt:5:0xffffffff001bc61a}}} [00020.289] 01048:56046> {{{bt:6:0xffffffff001bc27b}}} [00020.289] 01048:56046> [00020.289] 01048:56046> [00020.289] 01048:56046> ZIRCON KERNEL OOPS [00020.289] 01048:56046> Lock validation failed for thread 0xffffff80030dad10 pid 1048 tid 56046 (bin/core-tests:test_thread): [00020.289] 01048:56046> Reason: Already Acquired [00020.289] 01048:56046> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.289] 01048:56046> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.289] 01048:56046> caller=0xffffffff0014c5ab frame=0xffffff9b25c26cd0 [00020.289] 01048:56046> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00020.289] 01048:56046> [00020.289] 01048:56046> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00020.289] 01048:56046> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00020.289] 01048:56046> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00020.289] 01048:56046> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00020.289] 01048:56046> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00020.289] 01048:56046> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00020.289] 01048:56046> bt#00: 0xffffffff0014c5ab [00020.289] 01048:56046> bt#01: 0xffffffff0014c9ef [00020.289] 01048:56046> bt#02: 0xffffffff0014c9ef [00020.289] 01048:56046> bt#03: 0xffffffff00138d3e [00020.289] 01048:56046> bt#04: 0xffffffff001f4eec [00020.289] 01048:56046> bt#05: 0xffffffff001bc61a [00020.289] 01048:56046> bt#06: 0xffffffff001bc27b [00020.289] 01048:56046> bt#07: end [00020.289] 01048:56046> {{{bt:0:0xffffffff0014c5ab}}} [00020.289] 01048:56046> {{{bt:1:0xffffffff0014c9ef}}} [00020.289] 01048:56046> {{{bt:2:0xffffffff0014c9ef}}} [00020.289] 01048:56046> {{{bt:3:0xffffffff00138d3e}}} [00020.289] 01048:56046> {{{bt:4:0xffffffff001f4eec}}} [00020.289] 01048:56046> {{{bt:5:0xffffffff001bc61a}}} [00020.289] 01048:56046> {{{bt:6:0xffffffff001bc27b}}} [00020.289] 01048:56046> [00020.290] 01048:01051> [PASSED] (2 ms) [00020.290] 01048:01051> read_close_interrupt_late_test_vmo [RUNNING] [00020.295] 01048:01051> [PASSED] (5 ms) [00020.295] 01048:01051> read_detach_interrupt_early_test_vmar [RUNNING] [00020.295] 01048:56066> PageFault: 1026888 free pages [00020.296] 01048:56066> [00020.296] 01048:56066> ZIRCON KERNEL OOPS [00020.296] 01048:56066> Lock validation failed for thread 0xffffff80030dad10 pid 1048 tid 56066 (bin/core-tests:test_thread): [00020.296] 01048:56066> Reason: Already Acquired [00020.296] 01048:56066> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.296] 01048:56066> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.296] 01048:56066> caller=0xffffffff0014c5ab frame=0xffffff9b25c26d60 [00020.296] 01048:56066> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00020.296] 01048:56066> [00020.296] 01048:56066> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00020.296] 01048:56066> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00020.296] 01048:56066> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00020.296] 01048:56066> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00020.296] 01048:56066> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00020.296] 01048:56066> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00020.296] 01048:56066> bt#00: 0xffffffff0014c5ab [00020.296] 01048:56066> bt#01: 0xffffffff0014c9ef [00020.296] 01048:56066> bt#02: 0xffffffff00138d3e [00020.296] 01048:56066> bt#03: 0xffffffff001f4eec [00020.296] 01048:56066> bt#04: 0xffffffff001bc61a [00020.296] 01048:56066> bt#05: 0xffffffff001bc27b [00020.296] 01048:56066> bt#06: end [00020.296] 01048:56066> {{{bt:0:0xffffffff0014c5ab}}} [00020.296] 01048:56066> {{{bt:1:0xffffffff0014c9ef}}} [00020.296] 01048:56066> {{{bt:2:0xffffffff00138d3e}}} [00020.296] 01048:56066> {{{bt:3:0xffffffff001f4eec}}} [00020.296] 01048:56066> {{{bt:4:0xffffffff001bc61a}}} [00020.296] 01048:56066> {{{bt:5:0xffffffff001bc27b}}} [00020.296] 01048:56066> [00020.296] 01048:56066> [00020.296] 01048:56066> ZIRCON KERNEL OOPS [00020.296] 01048:56066> Lock validation failed for thread 0xffffff80030dad10 pid 1048 tid 56066 (bin/core-tests:test_thread): [00020.296] 01048:56066> Reason: Already Acquired [00020.296] 01048:56066> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.296] 01048:56066> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.296] 01048:56066> caller=0xffffffff0014c5ab frame=0xffffff9b25c26cd0 [00020.296] 01048:56066> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00020.296] 01048:56066> [00020.296] 01048:56066> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00020.296] 01048:56066> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00020.296] 01048:56066> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00020.296] 01048:56066> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00020.296] 01048:56066> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00020.296] 01048:56066> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00020.296] 01048:56066> bt#00: 0xffffffff0014c5ab [00020.296] 01048:56066> bt#01: 0xffffffff0014c9ef [00020.296] 01048:56066> bt#02: 0xffffffff0014c9ef [00020.296] 01048:56066> bt#03: 0xffffffff00138d3e [00020.296] 01048:56066> bt#04: 0xffffffff001f4eec [00020.296] 01048:56066> bt#05: 0xffffffff001bc61a [00020.296] 01048:56066> bt#06: 0xffffffff001bc27b [00020.296] 01048:56066> bt#07: end [00020.296] 01048:56066> {{{bt:0:0xffffffff0014c5ab}}} [00020.296] 01048:56066> {{{bt:1:0xffffffff0014c9ef}}} [00020.296] 01048:56066> {{{bt:2:0xffffffff0014c9ef}}} [00020.296] 01048:56066> {{{bt:3:0xffffffff00138d3e}}} [00020.296] 01048:56066> {{{bt:4:0xffffffff001f4eec}}} [00020.296] 01048:56066> {{{bt:5:0xffffffff001bc61a}}} [00020.296] 01048:56066> {{{bt:6:0xffffffff001bc27b}}} [00020.296] 01048:56066> [00020.296] 01048:56066> [00020.296] 01048:56066> ZIRCON KERNEL OOPS [00020.296] 01048:56066> Lock validation failed for thread 0xffffff80030dad10 pid 1048 tid 56066 (bin/core-tests:test_thread): [00020.296] 01048:56066> Reason: Already Acquired [00020.296] 01048:56066> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.296] 01048:56066> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.296] 01048:56066> caller=0xffffffff0014c5ab frame=0xffffff9b25c26cd0 [00020.296] 01048:56066> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00020.296] 01048:56066> [00020.296] 01048:56066> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00020.296] 01048:56066> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00020.296] 01048:56066> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00020.296] 01048:56066> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00020.296] 01048:56066> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00020.296] 01048:56066> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00020.296] 01048:56066> bt#00: 0xffffffff0014c5ab [00020.296] 01048:56066> bt#01: 0xffffffff0014c9ef [00020.296] 01048:56066> bt#02: 0xffffffff0014c9ef [00020.296] 01048:56066> bt#03: 0xffffffff00138d3e [00020.296] 01048:56066> bt#04: 0xffffffff001f4eec [00020.296] 01048:56066> bt#05: 0xffffffff001bc61a [00020.296] 01048:56066> bt#06: 0xffffffff001bc27b [00020.296] 01048:56066> bt#07: end [00020.296] 01048:56066> {{{bt:0:0xffffffff0014c5ab}}} [00020.296] 01048:56066> {{{bt:1:0xffffffff0014c9ef}}} [00020.296] 01048:56066> {{{bt:2:0xffffffff0014c9ef}}} [00020.296] 01048:56066> {{{bt:3:0xffffffff00138d3e}}} [00020.296] 01048:56066> {{{bt:4:0xffffffff001f4eec}}} [00020.296] 01048:56066> {{{bt:5:0xffffffff001bc61a}}} [00020.296] 01048:56066> {{{bt:6:0xffffffff001bc27b}}} [00020.296] 01048:56066> [00020.297] 01048:01051> [PASSED] (1 ms) [00020.297] 01048:01051> read_detach_interrupt_early_test_vmo [RUNNING] [00020.301] 01048:01051> [PASSED] (4 ms) [00020.302] 01048:01051> read_close_interrupt_early_test_vmar [RUNNING] [00020.302] 01048:56086> PageFault: 1026888 free pages [00020.302] 01048:56086> [00020.302] 01048:56086> ZIRCON KERNEL OOPS [00020.302] 01048:56086> Lock validation failed for thread 0xffffff80030dad10 pid 1048 tid 56086 (bin/core-tests:test_thread): [00020.302] 01048:56086> Reason: Already Acquired [00020.302] 01048:56086> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.302] 01048:56086> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.302] 01048:56086> caller=0xffffffff0014c5ab frame=0xffffff9b25c26d60 [00020.302] 01048:56086> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00020.302] 01048:56086> [00020.302] 01048:56086> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00020.302] 01048:56086> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00020.302] 01048:56086> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00020.302] 01048:56086> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00020.302] 01048:56086> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00020.302] 01048:56086> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00020.302] 01048:56086> bt#00: 0xffffffff0014c5ab [00020.302] 01048:56086> bt#01: 0xffffffff0014c9ef [00020.302] 01048:56086> bt#02: 0xffffffff00138d3e [00020.302] 01048:56086> bt#03: 0xffffffff001f4eec [00020.302] 01048:56086> bt#04: 0xffffffff001bc61a [00020.302] 01048:56086> bt#05: 0xffffffff001bc27b [00020.302] 01048:56086> bt#06: end [00020.302] 01048:56086> {{{bt:0:0xffffffff0014c5ab}}} [00020.302] 01048:56086> {{{bt:1:0xffffffff0014c9ef}}} [00020.302] 01048:56086> {{{bt:2:0xffffffff00138d3e}}} [00020.302] 01048:56086> {{{bt:3:0xffffffff001f4eec}}} [00020.302] 01048:56086> {{{bt:4:0xffffffff001bc61a}}} [00020.302] 01048:56086> {{{bt:5:0xffffffff001bc27b}}} [00020.302] 01048:56086> [00020.302] 01048:56086> [00020.302] 01048:56086> ZIRCON KERNEL OOPS [00020.302] 01048:56086> Lock validation failed for thread 0xffffff80030dad10 pid 1048 tid 56086 (bin/core-tests:test_thread): [00020.302] 01048:56086> Reason: Already Acquired [00020.302] 01048:56086> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.302] 01048:56086> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.302] 01048:56086> caller=0xffffffff0014c5ab frame=0xffffff9b25c26cd0 [00020.302] 01048:56086> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00020.302] 01048:56086> [00020.302] 01048:56086> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00020.302] 01048:56086> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00020.302] 01048:56086> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00020.302] 01048:56086> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00020.302] 01048:56086> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00020.302] 01048:56086> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00020.302] 01048:56086> bt#00: 0xffffffff0014c5ab [00020.302] 01048:56086> bt#01: 0xffffffff0014c9ef [00020.302] 01048:56086> bt#02: 0xffffffff0014c9ef [00020.302] 01048:56086> bt#03: 0xffffffff00138d3e [00020.302] 01048:56086> bt#04: 0xffffffff001f4eec [00020.302] 01048:56086> bt#05: 0xffffffff001bc61a [00020.302] 01048:56086> bt#06: 0xffffffff001bc27b [00020.302] 01048:56086> bt#07: end [00020.302] 01048:56086> {{{bt:0:0xffffffff0014c5ab}}} [00020.302] 01048:56086> {{{bt:1:0xffffffff0014c9ef}}} [00020.302] 01048:56086> {{{bt:2:0xffffffff0014c9ef}}} [00020.302] 01048:56086> {{{bt:3:0xffffffff00138d3e}}} [00020.302] 01048:56086> {{{bt:4:0xffffffff001f4eec}}} [00020.302] 01048:56086> {{{bt:5:0xffffffff001bc61a}}} [00020.302] 01048:56086> {{{bt:6:0xffffffff001bc27b}}} [00020.302] 01048:56086> [00020.302] 01048:56086> [00020.302] 01048:56086> ZIRCON KERNEL OOPS [00020.302] 01048:56086> Lock validation failed for thread 0xffffff80030dad10 pid 1048 tid 56086 (bin/core-tests:test_thread): [00020.302] 01048:56086> Reason: Already Acquired [00020.302] 01048:56086> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.302] 01048:56086> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.302] 01048:56086> caller=0xffffffff0014c5ab frame=0xffffff9b25c26cd0 [00020.302] 01048:56086> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00020.302] 01048:56086> [00020.302] 01048:56086> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00020.302] 01048:56086> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00020.302] 01048:56086> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00020.302] 01048:56086> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00020.302] 01048:56086> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00020.302] 01048:56086> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00020.302] 01048:56086> bt#00: 0xffffffff0014c5ab [00020.302] 01048:56086> bt#01: 0xffffffff0014c9ef [00020.302] 01048:56086> bt#02: 0xffffffff0014c9ef [00020.302] 01048:56086> bt#03: 0xffffffff00138d3e [00020.302] 01048:56086> bt#04: 0xffffffff001f4eec [00020.302] 01048:56086> bt#05: 0xffffffff001bc61a [00020.302] 01048:56086> bt#06: 0xffffffff001bc27b [00020.302] 01048:56086> bt#07: end [00020.302] 01048:56086> {{{bt:0:0xffffffff0014c5ab}}} [00020.302] 01048:56086> {{{bt:1:0xffffffff0014c9ef}}} [00020.302] 01048:56086> {{{bt:2:0xffffffff0014c9ef}}} [00020.302] 01048:56086> {{{bt:3:0xffffffff00138d3e}}} [00020.302] 01048:56086> {{{bt:4:0xffffffff001f4eec}}} [00020.302] 01048:56086> {{{bt:5:0xffffffff001bc61a}}} [00020.302] 01048:56086> {{{bt:6:0xffffffff001bc27b}}} [00020.302] 01048:56086> [00020.304] 01048:01051> [PASSED] (2 ms) [00020.304] 01048:01051> read_close_interrupt_early_test_vmo [RUNNING] [00020.308] 01048:01051> [PASSED] (4 ms) [00020.309] 01048:01051> thread_kill_test_vmar [RUNNING] [00020.311] 01048:01051> [PASSED] (2 ms) [00020.311] 01048:01051> thread_kill_test_vmo [RUNNING] [00020.315] 01048:01051> [PASSED] (4 ms) [00020.315] 01048:01051> thread_kill_overlap_test_vmar [RUNNING] [00020.318] 01048:01051> [PASSED] (2 ms) [00020.318] 01048:01051> thread_kill_overlap_test_vmo [RUNNING] [00020.322] 01048:01051> [PASSED] (4 ms) [00020.322] 01048:01051> close_pager_test [RUNNING] [00020.323] 01048:56177> PageFault: 1026812 free pages [00020.323] 01048:56177> [00020.323] 01048:56177> ZIRCON KERNEL OOPS [00020.323] 01048:56177> Lock validation failed for thread 0xffffff8002fd1d90 pid 1048 tid 56177 (bin/core-tests:test_thread): [00020.323] 01048:56177> Reason: Already Acquired [00020.323] 01048:56177> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.323] 01048:56177> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.323] 01048:56177> caller=0xffffffff0014c5ab frame=0xffffff9b25c46d60 [00020.323] 01048:56177> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00020.323] 01048:56177> [00020.323] 01048:56177> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00020.323] 01048:56177> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00020.323] 01048:56177> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00020.323] 01048:56177> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00020.323] 01048:56177> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00020.323] 01048:56177> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00020.323] 01048:56177> bt#00: 0xffffffff0014c5ab [00020.323] 01048:56177> bt#01: 0xffffffff0014c9ef [00020.323] 01048:56177> bt#02: 0xffffffff00138d3e [00020.323] 01048:56177> bt#03: 0xffffffff001f4eec [00020.323] 01048:56177> bt#04: 0xffffffff001bc61a [00020.323] 01048:56177> bt#05: 0xffffffff001bc27b [00020.323] 01048:56177> bt#06: end [00020.323] 01048:56177> {{{bt:0:0xffffffff0014c5ab}}} [00020.323] 01048:56177> {{{bt:1:0xffffffff0014c9ef}}} [00020.323] 01048:56177> {{{bt:2:0xffffffff00138d3e}}} [00020.323] 01048:56177> {{{bt:3:0xffffffff001f4eec}}} [00020.323] 01048:56177> {{{bt:4:0xffffffff001bc61a}}} [00020.323] 01048:56177> {{{bt:5:0xffffffff001bc27b}}} [00020.323] 01048:56177> [00020.323] 01048:56177> [00020.323] 01048:56177> ZIRCON KERNEL OOPS [00020.323] 01048:56177> Lock validation failed for thread 0xffffff8002fd1d90 pid 1048 tid 56177 (bin/core-tests:test_thread): [00020.323] 01048:56177> Reason: Already Acquired [00020.323] 01048:56177> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.323] 01048:56177> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.323] 01048:56177> caller=0xffffffff0014c5ab frame=0xffffff9b25c46cd0 [00020.323] 01048:56177> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00020.323] 01048:56177> [00020.323] 01048:56177> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00020.323] 01048:56177> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00020.323] 01048:56177> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00020.323] 01048:56177> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00020.323] 01048:56177> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00020.323] 01048:56177> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00020.323] 01048:56177> bt#00: 0xffffffff0014c5ab [00020.323] 01048:56177> bt#01: 0xffffffff0014c9ef [00020.323] 01048:56177> bt#02: 0xffffffff0014c9ef [00020.323] 01048:56177> bt#03: 0xffffffff00138d3e [00020.323] 01048:56177> bt#04: 0xffffffff001f4eec [00020.323] 01048:56177> bt#05: 0xffffffff001bc61a [00020.323] 01048:56177> bt#06: 0xffffffff001bc27b [00020.323] 01048:56177> bt#07: end [00020.323] 01048:56177> {{{bt:0:0xffffffff0014c5ab}}} [00020.323] 01048:56177> {{{bt:1:0xffffffff0014c9ef}}} [00020.323] 01048:56177> {{{bt:2:0xffffffff0014c9ef}}} [00020.323] 01048:56177> {{{bt:3:0xffffffff00138d3e}}} [00020.323] 01048:56177> {{{bt:4:0xffffffff001f4eec}}} [00020.323] 01048:56177> {{{bt:5:0xffffffff001bc61a}}} [00020.323] 01048:56177> {{{bt:6:0xffffffff001bc27b}}} [00020.323] 01048:56177> [00020.323] 01048:56177> [00020.323] 01048:56177> ZIRCON KERNEL OOPS [00020.323] 01048:56177> Lock validation failed for thread 0xffffff8002fd1d90 pid 1048 tid 56177 (bin/core-tests:test_thread): [00020.323] 01048:56177> Reason: Already Acquired [00020.323] 01048:56177> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.323] 01048:56177> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.323] 01048:56177> caller=0xffffffff0014c5ab frame=0xffffff9b25c46cd0 [00020.323] 01048:56177> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00020.323] 01048:56177> [00020.323] 01048:56177> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00020.323] 01048:56177> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00020.323] 01048:56177> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00020.323] 01048:56177> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00020.323] 01048:56177> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00020.323] 01048:56177> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00020.323] 01048:56177> bt#00: 0xffffffff0014c5ab [00020.323] 01048:56177> bt#01: 0xffffffff0014c9ef [00020.323] 01048:56177> bt#02: 0xffffffff0014c9ef [00020.323] 01048:56177> bt#03: 0xffffffff00138d3e [00020.323] 01048:56177> bt#04: 0xffffffff001f4eec [00020.323] 01048:56177> bt#05: 0xffffffff001bc61a [00020.323] 01048:56177> bt#06: 0xffffffff001bc27b [00020.323] 01048:56177> bt#07: end [00020.323] 01048:56177> {{{bt:0:0xffffffff0014c5ab}}} [00020.323] 01048:56177> {{{bt:1:0xffffffff0014c9ef}}} [00020.323] 01048:56177> {{{bt:2:0xffffffff0014c9ef}}} [00020.323] 01048:56177> {{{bt:3:0xffffffff00138d3e}}} [00020.323] 01048:56177> {{{bt:4:0xffffffff001f4eec}}} [00020.323] 01048:56177> {{{bt:5:0xffffffff001bc61a}}} [00020.323] 01048:56177> {{{bt:6:0xffffffff001bc27b}}} [00020.323] 01048:56177> [00020.325] 01048:01051> [PASSED] (2 ms) [00020.325] 01048:01051> detach_close_pager_test [RUNNING] [00020.325] 01048:01051> [PASSED] (0 ms) [00020.325] 01048:01051> close_port_test [RUNNING] [00020.325] 01048:56190> PageFault: 1026809 free pages [00020.325] 01048:56190> [00020.325] 01048:56190> ZIRCON KERNEL OOPS [00020.325] 01048:56190> Lock validation failed for thread 0xffffff8002fd1cd0 pid 1048 tid 56190 (bin/core-tests:test_thread): [00020.325] 01048:56190> Reason: Already Acquired [00020.325] 01048:56190> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.325] 01048:56190> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.325] 01048:56190> caller=0xffffffff0014c5ab frame=0xffffff9b25c46d60 [00020.325] 01048:56190> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00020.325] 01048:56190> [00020.325] 01048:56190> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00020.325] 01048:56190> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00020.325] 01048:56190> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00020.325] 01048:56190> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00020.325] 01048:56190> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00020.325] 01048:56190> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00020.325] 01048:56190> bt#00: 0xffffffff0014c5ab [00020.325] 01048:56190> bt#01: 0xffffffff0014c9ef [00020.325] 01048:56190> bt#02: 0xffffffff00138d3e [00020.325] 01048:56190> bt#03: 0xffffffff001f4eec [00020.325] 01048:56190> bt#04: 0xffffffff001bc61a [00020.325] 01048:56190> bt#05: 0xffffffff001bc27b [00020.325] 01048:56190> bt#06: end [00020.325] 01048:56190> {{{bt:0:0xffffffff0014c5ab}}} [00020.325] 01048:56190> {{{bt:1:0xffffffff0014c9ef}}} [00020.325] 01048:56190> {{{bt:2:0xffffffff00138d3e}}} [00020.325] 01048:56190> {{{bt:3:0xffffffff001f4eec}}} [00020.325] 01048:56190> {{{bt:4:0xffffffff001bc61a}}} [00020.325] 01048:56190> {{{bt:5:0xffffffff001bc27b}}} [00020.325] 01048:56190> [00020.325] 01048:56190> [00020.325] 01048:56190> ZIRCON KERNEL OOPS [00020.325] 01048:56190> Lock validation failed for thread 0xffffff8002fd1cd0 pid 1048 tid 56190 (bin/core-tests:test_thread): [00020.325] 01048:56190> Reason: Already Acquired [00020.325] 01048:56190> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.325] 01048:56190> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.325] 01048:56190> caller=0xffffffff0014c5ab frame=0xffffff9b25c46cd0 [00020.325] 01048:56190> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00020.325] 01048:56190> [00020.325] 01048:56190> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00020.325] 01048:56190> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00020.325] 01048:56190> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00020.325] 01048:56190> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00020.325] 01048:56190> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00020.325] 01048:56190> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00020.325] 01048:56190> bt#00: 0xffffffff0014c5ab [00020.325] 01048:56190> bt#01: 0xffffffff0014c9ef [00020.325] 01048:56190> bt#02: 0xffffffff0014c9ef [00020.325] 01048:56190> bt#03: 0xffffffff00138d3e [00020.325] 01048:56190> bt#04: 0xffffffff001f4eec [00020.325] 01048:56190> bt#05: 0xffffffff001bc61a [00020.325] 01048:56190> bt#06: 0xffffffff001bc27b [00020.325] 01048:56190> bt#07: end [00020.325] 01048:56190> {{{bt:0:0xffffffff0014c5ab}}} [00020.325] 01048:56190> {{{bt:1:0xffffffff0014c9ef}}} [00020.325] 01048:56190> {{{bt:2:0xffffffff0014c9ef}}} [00020.325] 01048:56190> {{{bt:3:0xffffffff00138d3e}}} [00020.325] 01048:56190> {{{bt:4:0xffffffff001f4eec}}} [00020.325] 01048:56190> {{{bt:5:0xffffffff001bc61a}}} [00020.325] 01048:56190> {{{bt:6:0xffffffff001bc27b}}} [00020.325] 01048:56190> [00020.325] 01048:56190> [00020.325] 01048:56190> ZIRCON KERNEL OOPS [00020.325] 01048:56190> Lock validation failed for thread 0xffffff8002fd1cd0 pid 1048 tid 56190 (bin/core-tests:test_thread): [00020.325] 01048:56190> Reason: Already Acquired [00020.325] 01048:56190> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.325] 01048:56190> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.325] 01048:56190> caller=0xffffffff0014c5ab frame=0xffffff9b25c46cd0 [00020.325] 01048:56190> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00020.325] 01048:56190> [00020.325] 01048:56190> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00020.325] 01048:56190> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00020.325] 01048:56190> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00020.325] 01048:56190> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00020.325] 01048:56190> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00020.325] 01048:56190> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00020.325] 01048:56190> bt#00: 0xffffffff0014c5ab [00020.325] 01048:56190> bt#01: 0xffffffff0014c9ef [00020.325] 01048:56190> bt#02: 0xffffffff0014c9ef [00020.325] 01048:56190> bt#03: 0xffffffff00138d3e [00020.325] 01048:56190> bt#04: 0xffffffff001f4eec [00020.325] 01048:56190> bt#05: 0xffffffff001bc61a [00020.325] 01048:56190> bt#06: 0xffffffff001bc27b [00020.325] 01048:56190> bt#07: end [00020.325] 01048:56190> {{{bt:0:0xffffffff0014c5ab}}} [00020.325] 01048:56190> {{{bt:1:0xffffffff0014c9ef}}} [00020.325] 01048:56190> {{{bt:2:0xffffffff0014c9ef}}} [00020.325] 01048:56190> {{{bt:3:0xffffffff00138d3e}}} [00020.325] 01048:56190> {{{bt:4:0xffffffff001f4eec}}} [00020.325] 01048:56190> {{{bt:5:0xffffffff001bc61a}}} [00020.325] 01048:56190> {{{bt:6:0xffffffff001bc27b}}} [00020.325] 01048:56190> [00020.329] 01048:01051> [PASSED] (4 ms) [00020.329] 01048:01051> CASE lifecycle_tests [PASSED] [00020.329] 01048:01051> CASE pager_read_tests [STARTED] [00020.329] 01048:01051> single_page_test_vmar [RUNNING] [00020.332] 01048:01051> [PASSED] (2 ms) [00020.332] 01048:01051> single_page_test_vmo [RUNNING] [00020.336] 01048:01051> [PASSED] (4 ms) [00020.336] 01048:01051> presupply_test_vmar [RUNNING] [00020.338] 01048:01051> [PASSED] (2 ms) [00020.339] 01048:01051> presupply_test_vmo [RUNNING] [00020.343] 01048:01051> [PASSED] (4 ms) [00020.343] 01048:01051> early_supply_test_vmar [RUNNING] [00020.352] 01048:01051> [PASSED] (9 ms) [00020.352] 01048:01051> early_supply_test_vmo [RUNNING] [00020.359] 01048:01051> [PASSED] (6 ms) [00020.359] 01048:01051> sequential_multipage_test_vmar [RUNNING] [00020.366] 01048:01051> [PASSED] (6 ms) [00020.366] 01048:01051> sequential_multipage_test_vmo [RUNNING] [00020.373] 01048:01051> [PASSED] (6 ms) [00020.373] 01048:01051> concurrent_multipage_access_test_vmar [RUNNING] [00020.377] 01048:01051> [PASSED] (4 ms) [00020.377] 01048:01051> concurrent_multipage_access_test_vmo [RUNNING] [00020.386] 01048:01051> [PASSED] (8 ms) [00020.386] 01048:01051> concurrent_overlapping_access_test_vmar [RUNNING] [00020.481] 01048:01051> [PASSED] (94 ms) [00020.481] 01048:01051> concurrent_overlapping_access_test_vmo [RUNNING] [00020.583] 01048:01051> [PASSED] (102 ms) [00020.583] 01048:01051> bulk_single_supply_test_vmar [RUNNING] [00020.619] 01048:01051> [PASSED] (35 ms) [00020.619] 01048:01051> bulk_single_supply_test_vmo [RUNNING] [00020.651] 01048:01051> [PASSED] (32 ms) [00020.651] 01048:01051> bulk_odd_length_supply_test_vmar [RUNNING] [00020.927] 01048:01051> [PASSED] (275 ms) [00020.927] 01048:01051> bulk_odd_length_supply_test_vmo [RUNNING] [00021.238] 01048:01051> [PASSED] (311 ms) [00021.238] 01048:01051> bulk_odd_offset_supply_test_vmar [RUNNING] [00021.515] 01048:01051> [PASSED] (276 ms) [00021.515] 01048:01051> bulk_odd_offset_supply_test_vmo [RUNNING] [00021.785] 01048:01051> [PASSED] (270 ms) [00021.785] 01048:01051> overlap_supply_test_vmar [RUNNING] [00021.788] 01048:01051> [PASSED] (2 ms) [00021.788] 01048:01051> overlap_supply_test_vmo [RUNNING] [00021.792] 01048:01051> [PASSED] (4 ms) [00021.792] 01048:01051> many_request_test_vmar [RUNNING] [00022.521] 01048:01051> [PASSED] (728 ms) [00022.521] 01048:01051> many_request_test_vmo [RUNNING] [00022.704] 01048:01051> [PASSED] (182 ms) [00022.704] 01048:01051> successive_vmo_test [RUNNING] [00022.753] 01048:01051> [PASSED] (49 ms) [00022.753] 01048:01051> multiple_concurrent_vmo_test [RUNNING] [00022.762] 01048:01051> [PASSED] (9 ms) [00022.763] 01048:01051> vmar_unmap_test [RUNNING] [00022.763] 01048:63911> PageFault: 1026809 free pages [00022.763] 01048:63911> [00022.763] 01048:63911> ZIRCON KERNEL OOPS [00022.763] 01048:63911> Lock validation failed for thread 0xffffff8002fd1e40 pid 1048 tid 63911 (bin/core-tests:test_thread): [00022.763] 01048:63911> Reason: Already Acquired [00022.763] 01048:63911> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00022.763] 01048:63911> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00022.763] 01048:63911> caller=0xffffffff0014c5ab frame=0xffffff9b25c46d60 [00022.763] 01048:63911> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00022.763] 01048:63911> [00022.763] 01048:63911> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00022.763] 01048:63911> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00022.763] 01048:63911> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00022.763] 01048:63911> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00022.763] 01048:63911> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00022.763] 01048:63911> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00022.763] 01048:63911> bt#00: 0xffffffff0014c5ab [00022.763] 01048:63911> bt#01: 0xffffffff0014c9ef [00022.763] 01048:63911> bt#02: 0xffffffff00138d3e [00022.763] 01048:63911> bt#03: 0xffffffff001f4eec [00022.763] 01048:63911> bt#04: 0xffffffff001bc61a [00022.763] 01048:63911> bt#05: 0xffffffff001bc27b [00022.763] 01048:63911> bt#06: end [00022.763] 01048:63911> {{{bt:0:0xffffffff0014c5ab}}} [00022.763] 01048:63911> {{{bt:1:0xffffffff0014c9ef}}} [00022.763] 01048:63911> {{{bt:2:0xffffffff00138d3e}}} [00022.763] 01048:63911> {{{bt:3:0xffffffff001f4eec}}} [00022.763] 01048:63911> {{{bt:4:0xffffffff001bc61a}}} [00022.763] 01048:63911> {{{bt:5:0xffffffff001bc27b}}} [00022.763] 01048:63911> [00022.763] 01048:63911> [00022.763] 01048:63911> ZIRCON KERNEL OOPS [00022.763] 01048:63911> Lock validation failed for thread 0xffffff8002fd1e40 pid 1048 tid 63911 (bin/core-tests:test_thread): [00022.763] 01048:63911> Reason: Already Acquired [00022.763] 01048:63911> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00022.763] 01048:63911> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00022.763] 01048:63911> caller=0xffffffff0014c5ab frame=0xffffff9b25c46cd0 [00022.763] 01048:63911> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00022.763] 01048:63911> [00022.763] 01048:63911> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00022.763] 01048:63911> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00022.763] 01048:63911> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00022.763] 01048:63911> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00022.763] 01048:63911> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00022.763] 01048:63911> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00022.763] 01048:63911> bt#00: 0xffffffff0014c5ab [00022.763] 01048:63911> bt#01: 0xffffffff0014c9ef [00022.763] 01048:63911> bt#02: 0xffffffff0014c9ef [00022.763] 01048:63911> bt#03: 0xffffffff00138d3e [00022.763] 01048:63911> bt#04: 0xffffffff001f4eec [00022.763] 01048:63911> bt#05: 0xffffffff001bc61a [00022.763] 01048:63911> bt#06: 0xffffffff001bc27b [00022.763] 01048:63911> bt#07: end [00022.763] 01048:63911> {{{bt:0:0xffffffff0014c5ab}}} [00022.763] 01048:63911> {{{bt:1:0xffffffff0014c9ef}}} [00022.763] 01048:63911> {{{bt:2:0xffffffff0014c9ef}}} [00022.763] 01048:63911> {{{bt:3:0xffffffff00138d3e}}} [00022.763] 01048:63911> {{{bt:4:0xffffffff001f4eec}}} [00022.763] 01048:63911> {{{bt:5:0xffffffff001bc61a}}} [00022.763] 01048:63911> {{{bt:6:0xffffffff001bc27b}}} [00022.763] 01048:63911> [00022.763] 01048:63911> [00022.763] 01048:63911> ZIRCON KERNEL OOPS [00022.763] 01048:63911> Lock validation failed for thread 0xffffff8002fd1e40 pid 1048 tid 63911 (bin/core-tests:test_thread): [00022.763] 01048:63911> Reason: Already Acquired [00022.763] 01048:63911> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00022.763] 01048:63911> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00022.763] 01048:63911> caller=0xffffffff0014c5ab frame=0xffffff9b25c46cd0 [00022.763] 01048:63911> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00022.763] 01048:63911> [00022.763] 01048:63911> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00022.763] 01048:63911> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00022.763] 01048:63911> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00022.763] 01048:63911> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00022.763] 01048:63911> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00022.763] 01048:63911> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00022.763] 01048:63911> bt#00: 0xffffffff0014c5ab [00022.763] 01048:63911> bt#01: 0xffffffff0014c9ef [00022.763] 01048:63911> bt#02: 0xffffffff0014c9ef [00022.763] 01048:63911> bt#03: 0xffffffff00138d3e [00022.763] 01048:63911> bt#04: 0xffffffff001f4eec [00022.763] 01048:63911> bt#05: 0xffffffff001bc61a [00022.763] 01048:63911> bt#06: 0xffffffff001bc27b [00022.763] 01048:63911> bt#07: end [00022.763] 01048:63911> {{{bt:0:0xffffffff0014c5ab}}} [00022.763] 01048:63911> {{{bt:1:0xffffffff0014c9ef}}} [00022.763] 01048:63911> {{{bt:2:0xffffffff0014c9ef}}} [00022.763] 01048:63911> {{{bt:3:0xffffffff00138d3e}}} [00022.763] 01048:63911> {{{bt:4:0xffffffff001f4eec}}} [00022.763] 01048:63911> {{{bt:5:0xffffffff001bc61a}}} [00022.763] 01048:63911> {{{bt:6:0xffffffff001bc27b}}} [00022.763] 01048:63911> [00022.765] 01048:01051> [PASSED] (2 ms) [00022.765] 01048:01051> vmar_remap_test [RUNNING] [00022.784] 01048:01051> [PASSED] (18 ms) [00022.784] 01048:01051> vmar_map_range_test [RUNNING] [00022.793] 01048:01051> [PASSED] (9 ms) [00022.793] 01048:01051> read_resize_test_vmar [RUNNING] [00022.800] 01048:01051> [PASSED] (6 ms) [00022.800] 01048:01051> read_resize_test_vmo [RUNNING] [00022.804] 01048:01051> [PASSED] (3 ms) [00022.804] 01048:01051> suspend_read_test_vmar [RUNNING] [00022.808] 01048:01051> [PASSED] (4 ms) [00022.808] 01048:01051> suspend_read_test_vmo [RUNNING] [00022.811] 01048:01051> [PASSED] (2 ms) [00022.811] 01048:01051> CASE pager_read_tests [PASSED] [00022.811] 01048:01051> CASE object_get_child_tests [STARTED] [00022.811] 01048:01051> handle_invalid [RUNNING] [00022.811] 01048:01051> [PASSED] (0 ms) [00022.811] 01048:01051> CASE object_get_child_tests [PASSED] [00022.811] 01048:01051> CASE memory_mapping_tests [STARTED] [00022.811] 01048:01051> address_space_limits_test [RUNNING] [00022.811] 01048:01051> [PASSED] (0 ms) [00022.811] 01048:01051> mmap_zerofilled_test [RUNNING] [00022.811] 01048:01051> [PASSED] (0 ms) [00022.811] 01048:01051> mmap_len_test [RUNNING] [00022.811] 01048:01051> [PASSED] (0 ms) [00022.811] 01048:01051> mmap_PROT_EXEC_test [RUNNING] [00022.811] 01048:01051> [PASSED] (0 ms) [00022.811] 01048:01051> mmap_offset_test [RUNNING] [00022.811] 01048:01051> [PASSED] (0 ms) [00022.811] 01048:01051> mmap_prot_test [RUNNING] [00022.811] 01048:01051> [PASSED] (0 ms) [00022.811] 01048:01051> mmap_flags_test [RUNNING] [00022.811] 01048:01051> [PASSED] (0 ms) [00022.811] 01048:01051> mprotect_test [RUNNING] [00022.812] 01048:01051> [00022.812] 01048:01051> ZIRCON KERNEL OOPS [00022.812] 01048:01051> Lock validation failed for thread 0xffffff8000382538 pid 1048 tid 1051 (bin/core-tests:bin/core-tests): [00022.812] 01048:01051> Reason: Already Acquired [00022.812] 01048:01051> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00022.812] 01048:01051> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00022.812] 01048:01051> caller=0xffffffff0014c5ab frame=0xffffff9b22b91d50 [00022.812] 01048:01051> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00022.812] 01048:01051> [00022.812] 01048:01051> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00022.812] 01048:01051> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00022.812] 01048:01051> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00022.812] 01048:01051> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00022.812] 01048:01051> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00022.812] 01048:01051> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00022.812] 01048:01051> bt#00: 0xffffffff0014c5ab [00022.812] 01048:01051> bt#01: 0xffffffff0014c9ef [00022.812] 01048:01051> bt#02: 0xffffffff0014dbf2 [00022.812] 01048:01051> bt#03: 0xffffffff00141786 [00022.812] 01048:01051> bt#04: 0xffffffff00156f8b [00022.812] 01048:01051> bt#05: 0xffffffff00147338 [00022.812] 01048:01051> bt#06: 0xffffffff0020bcde [00022.812] 01048:01051> bt#07: 0xffffffff0021b643 [00022.812] 01048:01051> bt#08: 0xffffffff001cd80b [00022.812] 01048:01051> bt#09: end [00022.812] 01048:01051> {{{bt:0:0xffffffff0014c5ab}}} [00022.812] 01048:01051> {{{bt:1:0xffffffff0014c9ef}}} [00022.812] 01048:01051> {{{bt:2:0xffffffff0014dbf2}}} [00022.812] 01048:01051> {{{bt:3:0xffffffff00141786}}} [00022.812] 01048:01051> {{{bt:4:0xffffffff00156f8b}}} [00022.812] 01048:01051> {{{bt:5:0xffffffff00147338}}} [00022.812] 01048:01051> {{{bt:6:0xffffffff0020bcde}}} [00022.812] 01048:01051> {{{bt:7:0xffffffff0021b643}}} [00022.812] 01048:01051> {{{bt:8:0xffffffff001cd80b}}} [00022.812] 01048:01051> [00022.812] 01048:01051> [PASSED] (0 ms) [00022.812] 01048:01051> CASE memory_mapping_tests [PASSED] [00022.812] 01048:01051> CASE job_tests [STARTED] [00022.812] 01048:01051> basic_test [RUNNING] [00022.812] 01048:01051> [PASSED] (0 ms) [00022.812] 01048:01051> create_missing_rights_test [RUNNING] [00022.812] 01048:01051> [PASSED] (0 ms) [00022.812] 01048:01051> policy_invalid_topic_test [RUNNING] [00022.812] 01048:01051> [PASSED] (0 ms) [00022.812] 01048:01051> policy_basic_test [RUNNING] [00022.812] 01048:01051> [PASSED] (0 ms) [00022.812] 01048:01051> policy_timer_slack_invalid_options_test [RUNNING] [00022.812] 01048:01051> [PASSED] (0 ms) [00022.812] 01048:01051> policy_timer_slack_invalid_count_test [RUNNING] [00022.812] 01048:01051> [PASSED] (0 ms) [00022.812] 01048:01051> policy_timer_slack_invalid_policy_test [RUNNING] [00022.812] 01048:01051> [PASSED] (0 ms) [00022.812] 01048:01051> policy_timer_slack_non_empty_test [RUNNING] [00022.812] 01048:01051> [PASSED] (0 ms) [00022.812] 01048:01051> policy_timer_slack_valid [RUNNING] [00022.812] 01048:01051> [PASSED] (0 ms) [00022.812] 01048:01051> create_test [RUNNING] [00022.812] 01048:01051> [PASSED] (0 ms) [00022.812] 01048:01051> kill_test [RUNNING] [00022.822] 01048:01051> [PASSED] (9 ms) [00022.822] 01048:01051> kill_job_no_child_test [RUNNING] [00022.822] 01048:01051> [PASSED] (0 ms) [00022.822] 01048:01051> kill_job_removes_from_tree [RUNNING] [00022.822] 01048:01051> [PASSED] (0 ms) [00022.822] 01048:01051> close_job_removes_from_tree [RUNNING] [00022.822] 01048:01051> [PASSED] (0 ms) [00022.822] 01048:01051> kill_job_chain [RUNNING] [00022.827] 01048:01051> [PASSED] (4 ms) [00022.827] 01048:01051> set_job_oom_kill_bit [RUNNING] [00022.827] 01048:01051> [PASSED] (0 ms) [00022.827] 01048:01051> wait_test [RUNNING] [00022.851] 01048:01051> [PASSED] (24 ms) [00022.851] 01048:01051> info_task_stats_fails [RUNNING] [00022.851] 01048:01051> [PASSED] (0 ms) [00022.851] 01048:01051> max_height_smoke [RUNNING] [00022.852] 01048:01051> [PASSED] (0 ms) [00022.852] 01048:01051> CASE job_tests [PASSED] [00022.852] 01048:01051> CASE handle_wait_tests [STARTED] [00022.852] 01048:01051> handle_wait_test [RUNNING] [00022.853] 01048:01051> [PASSED] (1 ms) [00022.853] 01048:01051> CASE handle_wait_tests [PASSED] [00022.853] 01048:01051> CASE eventpair_tests [STARTED] [00022.853] 01048:01051> create_test [RUNNING] [00022.853] 01048:01051> [PASSED] (0 ms) [00022.853] 01048:01051> signal_test [RUNNING] [00022.853] 01048:01051> [PASSED] (0 ms) [00022.853] 01048:01051> signal_peer_test [RUNNING] [00022.853] 01048:01051> [PASSED] (0 ms) [00022.853] 01048:01051> signal_peer_closed_test [RUNNING] [00022.853] 01048:01051> [PASSED] (0 ms) [00022.853] 01048:01051> CASE eventpair_tests [PASSED] [00022.853] 01048:01051> CASE elf_tls_tests [STARTED] [00022.853] 01048:01051> ExecutableTlsTest [RUNNING] [00023.728] 01048:01051> [PASSED] (874 ms) [00023.728] 01048:01051> CASE elf_tls_tests [PASSED] [00023.728] 01048:01051> CASE channel_tests [STARTED] [00023.728] 01048:01051> channel_test [RUNNING] [00023.729] 01048:01051> [PASSED] (0 ms) [00023.729] 01048:01051> channel_read_error_test [RUNNING] [00023.729] 01048:01051> [PASSED] (0 ms) [00023.729] 01048:01051> channel_close_test [RUNNING] [00023.729] 01048:01051> [PASSED] (0 ms) [00023.729] 01048:01051> channel_peer_closed_test [RUNNING] [00023.729] 01048:01051> [PASSED] (0 ms) [00023.729] 01048:01051> channel_non_transferable [RUNNING] [00023.729] 01048:01051> [PASSED] (0 ms) [00023.729] 01048:01051> channel_duplicate_handles [RUNNING] [00023.729] 01048:01051> [PASSED] (0 ms) [00023.729] 01048:01051> channel_multithread_read [RUNNING] [00023.863] 01048:01051> [PASSED] (133 ms) [00023.863] 01048:01051> channel_may_discard [RUNNING] [00023.863] 01048:01051> [PASSED] (0 ms) [00023.863] 01048:01051> channel_call [RUNNING] [00023.880] 01048:01051> [PASSED] (16 ms) [00023.880] 01048:01051> channel_call_consumes_handles [RUNNING] [00023.880] 01048:01051> [PASSED] (0 ms) [00023.880] 01048:01051> channel_call2 [RUNNING] [00024.146] 01048:01051> [PASSED] (265 ms) [00024.146] 01048:01051> bad_channel_call_finish [RUNNING] [00024.146] 01048:01051> [PASSED] (0 ms) [00024.146] 01048:01051> channel_nest [RUNNING] [00024.147] 01048:01051> [PASSED] (0 ms) [00024.147] 01048:01051> channel_disallow_write_to_self [RUNNING] [00024.147] 01048:01051> [PASSED] (0 ms) [00024.147] 01048:01051> channel_read_etc [RUNNING] [00024.147] 01048:01051> [PASSED] (0 ms) [00024.147] 01048:01051> channel_write_different_sizes [RUNNING] [00024.250] 01048:01051> [PASSED] (103 ms) [00024.250] 01048:01051> channel_write_takes_all_handles [RUNNING] [00024.252] 01048:01051> [PASSED] (1 ms) [00024.252] 01048:01051> CASE channel_tests [PASSED] [00024.252] 01048:01051> CASE c11_thread_tests [STARTED] [00024.252] 01048:01051> c11_thread_test [RUNNING] [00025.083] 01048:01051> [PASSED] (830 ms) [00025.083] 01048:01051> long_name_succeeds [RUNNING] [00025.184] 01048:01051> [PASSED] (101 ms) [00025.184] 01048:01051> detach_self_test [RUNNING] [00026.322] 01048:01051> [PASSED] (1138 ms) [00026.323] 01048:01051> CASE c11_thread_tests [PASSED] [00026.323] 01048:01051> CASE mtx_tests [STARTED] [00026.323] 01048:01051> test_initializer [RUNNING] [00026.323] 01048:01051> [PASSED] (0 ms) [00026.323] 01048:01051> test_mutexes [RUNNING] [00026.434] 01048:01051> [PASSED] (111 ms) [00026.434] 01048:01051> test_try_mutexes [RUNNING] [00026.502] 01048:01051> [PASSED] (68 ms) [00026.502] 01048:01051> test_static_initializer [RUNNING] [00026.502] 01048:01051> [PASSED] (0 ms) [00026.502] 01048:01051> test_timeout_elapsed [RUNNING] [00027.005] 01048:01051> [PASSED] (502 ms) [00027.005] 01048:01051> CASE mtx_tests [PASSED] [00027.005] 01048:01051> CASE cnd_tests [STARTED] [00027.005] 01048:01051> cnd_test [RUNNING] [00027.025] 01048:01051> [PASSED] (20 ms) [00027.025] 01048:01051> cnd_timedwait_timeout_test [RUNNING] [00027.026] 01048:01051> [PASSED] (1 ms) [00027.026] 01048:01051> CASE cnd_tests [PASSED] [00027.026] 01048:01051> CASE bad_syscall_tests [STARTED] [00027.026] 01048:01051> bad_access_test [RUNNING] [00027.026] 01048:01051> [PASSED] (0 ms) [00027.026] 01048:01051> bad_syscall_num_test [RUNNING] [00027.029] 01048:01051> [PASSED] (2 ms) [00027.029] 01048:01051> CASE bad_syscall_tests [PASSED] [00027.029] 01048:01051> ==================================================== [00027.029] 01048:01051> Results: [00027.029] 01048:01051> SUCCESS! All test cases passed! [00027.029] 01048:01051> CASES: 35 SUCCESS: 35 FAILED: 0 [00027.029] 01048:01051> ==================================================== [00027.029] 01048:01051> Flags: [00027.029] 01048:01051> --gtest_random_seed = 27 [00027.029] 01048:01051> [00027.029] 01048:01051> [00027.029] 01048:01051> [==========] Running 243 tests from 14 test cases [00027.029] 01048:01051> . [00027.029] 01048:01051> [----------] Global test environment set-up. [00027.029] 01048:01051> [----------] 1 test from ClockTest [00027.029] 01048:01051> [00027.029] 01048:01051> [ RUN ] ClockTest.ClockMonotonic [00027.029] 01048:01051> [00027.146] 01048:01051> [ OK ] ClockTest.ClockMonotonic (116 [00027.146] 01048:01051> ms) [00027.146] 01048:01051> [----------] 1 test from ClockTest (116 [00027.146] 01048:01051> ms total) [00027.146] 01048:01051> [----------] 9 tests from FifoTest [00027.146] 01048:01051> [00027.146] 01048:01051> [ RUN ] FifoTest.InvalidParametersReturnOutOfRange [00027.146] 01048:01051> [00027.146] 01048:01051> [ OK ] FifoTest.InvalidParametersReturnOutOfRange (0 [00027.146] 01048:01051> ms) [00027.146] 01048:01051> [ RUN ] FifoTest.EndpointsAreRelated [00027.146] 01048:01051> [00027.146] 01048:01051> [ OK ] FifoTest.EndpointsAreRelated (0 [00027.146] 01048:01051> ms) [00027.146] 01048:01051> [ RUN ] FifoTest.EmptyQueueReturnsErrShouldWait [00027.146] 01048:01051> [00027.146] 01048:01051> [ OK ] FifoTest.EmptyQueueReturnsErrShouldWait (0 [00027.146] 01048:01051> ms) [00027.146] 01048:01051> [ RUN ] FifoTest.ReadAndWriteValidatesSizeAndElementCount [00027.146] 01048:01051> [00027.146] 01048:01051> [ OK ] FifoTest.ReadAndWriteValidatesSizeAndElementCount (0 [00027.146] 01048:01051> ms) [00027.146] 01048:01051> [ RUN ] FifoTest.DequeueSignalsWriteable [00027.146] 01048:01051> [00027.146] 01048:01051> [ OK ] FifoTest.DequeueSignalsWriteable (0 [00027.146] 01048:01051> ms) [00027.146] 01048:01051> [ RUN ] FifoTest.FifoOrderIsPreserved [00027.146] 01048:01051> [00027.146] 01048:01051> [ OK ] FifoTest.FifoOrderIsPreserved (0 [00027.146] 01048:01051> ms) [00027.146] 01048:01051> [ RUN ] FifoTest.PartialWriteQueuesElementsThatFit [00027.146] 01048:01051> [00027.146] 01048:01051> [ OK ] FifoTest.PartialWriteQueuesElementsThatFit (0 [00027.146] 01048:01051> ms) [00027.146] 01048:01051> [ RUN ] FifoTest.IndividualReadsPreserveOrder [00027.146] 01048:01051> [00027.146] 01048:01051> [ OK ] FifoTest.IndividualReadsPreserveOrder (0 [00027.146] 01048:01051> ms) [00027.146] 01048:01051> [ RUN ] FifoTest.EndpointCloseSignalsPeerClosed [00027.146] 01048:01051> [00027.146] 01048:01051> [ OK ] FifoTest.EndpointCloseSignalsPeerClosed (0 [00027.146] 01048:01051> ms) [00027.146] 01048:01051> [----------] 9 tests from FifoTest (0 [00027.147] 01048:01051> ms total) [00027.147] 01048:01051> [----------] 15 tests from FutexTest [00027.147] 01048:01051> [00027.147] 01048:01051> [ RUN ] FutexTest.WaitValueMismatch [00027.147] 01048:01051> [00027.147] 01048:01051> [ OK ] FutexTest.WaitValueMismatch (0 [00027.147] 01048:01051> ms) [00027.147] 01048:01051> [ RUN ] FutexTest.WaitTimeout [00027.147] 01048:01051> [00027.147] 01048:01051> [ OK ] FutexTest.WaitTimeout (0 [00027.147] 01048:01051> ms) [00027.147] 01048:01051> [ RUN ] FutexTest.WaitTimeoutElapsed [00027.147] 01048:01051> [00027.648] 01048:01051> [ OK ] FutexTest.WaitTimeoutElapsed (501 [00027.648] 01048:01051> ms) [00027.648] 01048:01051> [ RUN ] FutexTest.WaitBadAddress [00027.648] 01048:01051> [00027.648] 01048:01051> [ OK ] FutexTest.WaitBadAddress (0 [00027.648] 01048:01051> ms) [00027.648] 01048:01051> [ RUN ] FutexTest.Wakeup [00027.648] 01048:01051> [00027.652] 01048:01051> [ OK ] FutexTest.Wakeup (4 [00027.653] 01048:01051> ms) [00027.653] 01048:01051> [ RUN ] FutexTest.WakeupLimit [00027.653] 01048:01051> [00028.257] 01048:01051> [ OK ] FutexTest.WakeupLimit (604 [00028.257] 01048:01051> ms) [00028.257] 01048:01051> [ RUN ] FutexTest.WakeupAddress [00028.257] 01048:01051> [00028.263] 01048:01051> [ OK ] FutexTest.WakeupAddress (5 [00028.263] 01048:01051> ms) [00028.263] 01048:01051> [ RUN ] FutexTest.RequeueValueMismatch [00028.263] 01048:01051> [00028.263] 01048:01051> [ OK ] FutexTest.RequeueValueMismatch (0 [00028.263] 01048:01051> ms) [00028.263] 01048:01051> [ RUN ] FutexTest.RequeueSameAddr [00028.263] 01048:01051> [00028.263] 01048:01051> [ OK ] FutexTest.RequeueSameAddr (0 [00028.263] 01048:01051> ms) [00028.263] 01048:01051> [ RUN ] FutexTest.Requeue [00028.263] 01048:01051> [00029.168] 01048:01051> [ OK ] FutexTest.Requeue (905 [00029.168] 01048:01051> ms) [00029.168] 01048:01051> [ RUN ] FutexTest.RequeueUnqueuedOnTimeout [00029.168] 01048:01051> [00029.470] 01048:01051> [ OK ] FutexTest.RequeueUnqueuedOnTimeout (301 [00029.470] 01048:01051> ms) [00029.470] 01048:01051> [ RUN ] FutexTest.ThreadKilled [00029.470] 01048:01051> [00029.470] 01048:01051> [ OK ] FutexTest.ThreadKilled (0 [00029.470] 01048:01051> ms) [00029.470] 01048:01051> [ RUN ] FutexTest.ThreadSuspended [00029.470] 01048:01051> [00029.772] 01048:01051> [ OK ] FutexTest.ThreadSuspended (301 [00029.772] 01048:01051> ms) [00029.772] 01048:01051> [ RUN ] FutexTest.MisalignedFutextAddr [00029.772] 01048:01051> [00029.772] 01048:01051> [ OK ] FutexTest.MisalignedFutextAddr (0 [00029.772] 01048:01051> ms) [00029.772] 01048:01051> [ RUN ] FutexTest.EventSignaling [00029.772] 01048:01051> [00029.772] 01048:01051> [00000029.772822378]: starting signal threads [00029.773] 01048:136485> [00000029.773042700]: thread 1 waiting on event [00029.773] 01048:136490> [00000029.773572694]: thread 2 waiting on event [00029.773] 01048:136495> [00000029.773779271]: thread 3 waiting on event [00029.774] 01048:01051> [00000029.774039837]: signaling event [00029.774] 01048:01051> [00000029.774143317]: joining signal threads [00029.774] 01048:136495> [00000029.774166148]: thread 3 done [00029.774] 01048:136485> [00000029.774231301]: thread 1 done [00029.774] 01048:01051> [00000029.774465884]: signal_thread 1 joined [00029.776] 01048:136490> [00000029.776946865]: thread 2 done [00029.777] 01048:01051> [00000029.777148570]: signal_thread 2 joined [00029.777] 01048:01051> [00000029.777196957]: signal_thread 3 joined [00029.777] 01048:01051> [ OK ] FutexTest.EventSignaling (4 [00029.777] 01048:01051> ms) [00029.777] 01048:01051> [----------] 15 tests from FutexTest (2630 [00029.777] 01048:01051> ms total) [00029.777] 01048:01051> [----------] 3 tests from HandleCloseTest [00029.777] 01048:01051> [00029.777] 01048:01051> [ RUN ] HandleCloseTest.Many [00029.777] 01048:01051> [00029.777] 01048:01051> [ OK ] HandleCloseTest.Many (0 [00029.777] 01048:01051> ms) [00029.777] 01048:01051> [ RUN ] HandleCloseTest.ManyInvalidHandlesShouldNotFail [00029.777] 01048:01051> [00029.777] 01048:01051> [ OK ] HandleCloseTest.ManyInvalidHandlesShouldNotFail (0 [00029.777] 01048:01051> ms) [00029.777] 01048:01051> [ RUN ] HandleCloseTest.ManyDuplicateTest [00029.777] 01048:01051> [00029.777] 01048:01051> [ OK ] HandleCloseTest.ManyDuplicateTest (0 [00029.777] 01048:01051> ms) [00029.777] 01048:01051> [----------] 3 tests from HandleCloseTest (0 [00029.777] 01048:01051> ms total) [00029.777] 01048:01051> [----------] 6 tests from HandleInfoTest [00029.777] 01048:01051> [00029.777] 01048:01051> [ RUN ] HandleInfoTest.ReplaceSuccessOrigInvalid [00029.777] 01048:01051> [00029.777] 01048:01051> [ OK ] HandleInfoTest.ReplaceSuccessOrigInvalid (0 [00029.777] 01048:01051> ms) [00029.777] 01048:01051> [ RUN ] HandleInfoTest.ReplaceFailureBothInvalid [00029.777] 01048:01051> [00029.777] 01048:01051> [ OK ] HandleInfoTest.ReplaceFailureBothInvalid (0 [00029.777] 01048:01051> ms) [00029.777] 01048:01051> [ RUN ] HandleInfoTest.DupAndInfoRights [00029.777] 01048:01051> [00029.777] 01048:01051> [ OK ] HandleInfoTest.DupAndInfoRights (0 [00029.777] 01048:01051> ms) [00029.777] 01048:01051> [ RUN ] HandleInfoTest.RelatedKoid [00029.777] 01048:01051> [00029.788] 01048:01051> [ OK ] HandleInfoTest.RelatedKoid (10 [00029.788] 01048:01051> ms) [00029.788] 01048:01051> [ RUN ] HandleInfoTest.DuplicateRights [00029.788] 01048:01051> [00029.788] 01048:01051> [ OK ] HandleInfoTest.DuplicateRights (0 [00029.788] 01048:01051> ms) [00029.788] 01048:01051> [ RUN ] HandleInfoTest.ReplaceRights [00029.788] 01048:01051> [00029.788] 01048:01051> [ OK ] HandleInfoTest.ReplaceRights (0 [00029.788] 01048:01051> ms) [00029.788] 01048:01051> [----------] 6 tests from HandleInfoTest (11 [00029.788] 01048:01051> ms total) [00029.788] 01048:01051> [----------] 2 tests from HandleTransferTest [00029.788] 01048:01051> [00029.788] 01048:01051> [ RUN ] HandleTransferTest.OverChannelThenRead [00029.788] 01048:01051> [00029.788] 01048:01051> [ OK ] HandleTransferTest.OverChannelThenRead (0 [00029.788] 01048:01051> ms) [00029.788] 01048:01051> [ RUN ] HandleTransferTest.CancelsWait [00029.788] 01048:01051> [00029.790] 01048:01051> [ OK ] HandleTransferTest.CancelsWait (1 [00029.790] 01048:01051> ms) [00029.790] 01048:01051> [----------] 2 tests from HandleTransferTest (1 [00029.790] 01048:01051> ms total) [00029.790] 01048:01051> [----------] 4 tests from ObjectGetInfoTest [00029.790] 01048:01051> [00029.790] 01048:01051> [ RUN ] ObjectGetInfoTest.OpenValidHandleSuceeds [00029.790] 01048:01051> [00029.790] 01048:01051> [ OK ] ObjectGetInfoTest.OpenValidHandleSuceeds (0 [00029.790] 01048:01051> ms) [00029.790] 01048:01051> [ RUN ] ObjectGetInfoTest.ClosedValidHandleFails [00029.790] 01048:01051> [00029.790] 01048:01051> [ OK ] ObjectGetInfoTest.ClosedValidHandleFails (0 [00029.790] 01048:01051> ms) [00029.790] 01048:01051> [ RUN ] ObjectGetInfoTest.HandleCountCorrectness [00029.790] 01048:01051> [00029.790] 01048:01051> [ OK ] ObjectGetInfoTest.HandleCountCorrectness (0 [00029.790] 01048:01051> ms) [00029.790] 01048:01051> [ RUN ] ObjectGetInfoTest.InvalidHandleFails [00029.790] 01048:01051> [00029.790] 01048:01051> [ OK ] ObjectGetInfoTest.InvalidHandleFails (0 [00029.790] 01048:01051> ms) [00029.790] 01048:01051> [----------] 4 tests from ObjectGetInfoTest (0 [00029.790] 01048:01051> ms total) [00029.790] 01048:01051> [----------] 39 tests from JobGetInfoTest [00029.790] 01048:01051> [00029.790] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesGetChild [00029.790] 01048:01051> [00029.790] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesGetChild (0 [00029.790] 01048:01051> ms) [00029.790] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildJobsGetChild [00029.790] 01048:01051> [00029.790] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildJobsGetChild (0 [00029.790] 01048:01051> ms) [00029.790] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesOnSelfSuceeds [00029.790] 01048:01051> [00029.790] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesOnSelfSuceeds (0 [00029.790] 01048:01051> ms) [00029.790] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesInvalidHandleFails [00029.790] 01048:01051> [00029.790] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesInvalidHandleFails (0 [00029.790] 01048:01051> ms) [00029.790] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesNullAvailSucceeds [00029.790] 01048:01051> [00029.790] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesNullAvailSucceeds (0 [00029.790] 01048:01051> ms) [00029.790] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesNullActualSucceeds [00029.790] 01048:01051> [00029.790] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesNullActualSucceeds (0 [00029.790] 01048:01051> ms) [00029.790] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesNullActualAndAvailSucceeds [00029.790] 01048:01051> [00029.790] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesNullActualAndAvailSucceeds (0 [00029.790] 01048:01051> ms) [00029.790] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesInvalidBufferPointerFails [00029.790] 01048:01051> [00029.790] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesInvalidBufferPointerFails (0 [00029.790] 01048:01051> ms) [00029.790] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesBadActualgIsInvalidArg [00029.790] 01048:01051> [00029.790] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesBadActualgIsInvalidArg (0 [00029.790] 01048:01051> ms) [00029.790] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesBadAvailIsInvalidArg [00029.790] 01048:01051> [00029.790] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesBadAvailIsInvalidArg (0 [00029.790] 01048:01051> ms) [00029.790] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesZeroSizedBufferIsOk [00029.790] 01048:01051> [00029.790] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesZeroSizedBufferIsOk (0 [00029.790] 01048:01051> ms) [00029.790] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesSmallBufferIsOk [00029.790] 01048:01051> [00029.790] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesSmallBufferIsOk (0 [00029.790] 01048:01051> ms) [00029.790] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesPartiallyUnmappedBufferIsInvalidArgs [00029.790] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesPartiallyUnmappedBufferIsInvalidArgs (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesRequiresEnumerateRights [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesRequiresEnumerateRights (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesProcessbHandleIsBadHandle [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesProcessbHandleIsBadHandle (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobProcessesThreadHandleIsBadHandle [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoJobProcessesThreadHandleIsBadHandle (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenOnSelfSuceeds [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenOnSelfSuceeds (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenInvalidHandleFails [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenInvalidHandleFails (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenNullAvailSucceeds [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenNullAvailSucceeds (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenNullActualSucceeds [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenNullActualSucceeds (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenNullActualAndAvailSucceeds [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenNullActualAndAvailSucceeds (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenInvalidBufferPointerFails [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenInvalidBufferPointerFails (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenBadActualgIsInvalidArg [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenBadActualgIsInvalidArg (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenBadAvailIsInvalidArg [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenBadAvailIsInvalidArg (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenZeroSizedBufferIsOk [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenZeroSizedBufferIsOk (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenSmallBufferIsOk [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenSmallBufferIsOk (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenPartiallyUnmappedBufferIsInvalidArgs [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenPartiallyUnmappedBufferIsInvalidArgs (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenRequiresEnumerateRights [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenRequiresEnumerateRights (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenJobHandleIsBadHandle [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenJobHandleIsBadHandle (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoJobChildrenThreadHandleIsBadHandle [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoJobChildrenThreadHandleIsBadHandle (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoHandleBasicOnSelfSuceeds [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoHandleBasicOnSelfSuceeds (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoHandleBasicInvalidHandleFails [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoHandleBasicInvalidHandleFails (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoHandleBasicNullAvailSucceeds [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoHandleBasicNullAvailSucceeds (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoHandleBasicNullActualSucceeds [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoHandleBasicNullActualSucceeds (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoHandleBasicInvalidBufferPointerFails [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoHandleBasicInvalidBufferPointerFails (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [ RUN ] JobGetInfoTest.InfoHandleBasicZeroSizedBufferFails [00029.791] 01048:01051> [00029.791] 01048:01051> [ OK ] JobGetInfoTest.InfoHandleBasicZeroSizedBufferFails (0 [00029.791] 01048:01051> ms) [00029.791] 01048:01051> [----------] 39 tests from JobGetInfoTest (1 [00029.791] 01048:01051> ms total) [00029.791] 01048:01051> [----------] 61 tests from ProcessGetInfoTest [00029.791] 01048:01051> [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsUnstartedSuceeds [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsUnstartedSuceeds (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsSmokeTest [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsSmokeTest (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessHandleStats [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessHandleStats (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsOnSelfFails [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsOnSelfFails (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsInvalidHandleFails [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsInvalidHandleFails (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsNullAvailSucceeds [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsNullAvailSucceeds (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsNullActualSucceeds [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsNullActualSucceeds (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsNullActualAndAvailSucceeds [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsNullActualAndAvailSucceeds (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsInvalidBufferPointerFails [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsInvalidBufferPointerFails (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsBadActualgIsInvalidArg [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsBadActualgIsInvalidArg (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsBadAvailIsInvalidArg [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsBadAvailIsInvalidArg (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsZeroSizedBufferIsOk [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsZeroSizedBufferIsOk (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsSmallBufferIsOk [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsSmallBufferIsOk (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsPartiallyUnmappedBufferIsInvalidArgs [00029.792] 01048:01051> [00029.792] 01048:01051> [00029.792] 01048:01051> ZIRCON KERNEL OOPS [00029.792] 01048:01051> Lock validation failed for thread 0xffffff8000382538 pid 1048 tid 1051 (bin/core-tests:bin/core-tests): [00029.792] 01048:01051> Reason: Already Acquired [00029.792] 01048:01051> Bad lock: name=lockdep::LockClass<VmAspace, Mutex, 199, lockdep::LockFlagsNone> order=0 [00029.792] 01048:01051> Conflict: name=lockdep::LockClass<VmAspace, Mutex, 199, lockdep::LockFlagsNone> order=0 [00029.792] 01048:01051> caller=0xffffffff001e3e4c frame=0xffffff9b22b91bd0 [00029.792] 01048:01051> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00029.792] 01048:01051> [00029.792] 01048:01051> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00029.792] 01048:01051> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00029.792] 01048:01051> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00029.792] 01048:01051> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00029.792] 01048:01051> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00029.792] 01048:01051> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00029.792] 01048:01051> bt#00: 0xffffffff001e3e4c [00029.792] 01048:01051> bt#01: 0xffffffff001f4eba [00029.792] 01048:01051> bt#02: 0xffffffff001bc61a [00029.792] 01048:01051> bt#03: 0xffffffff001bc27b [00029.792] 01048:01051> bt#04: 0xffffffff00139b95 [00029.792] 01048:01051> bt#05: 0xffffffff001e414c [00029.792] 01048:01051> bt#06: 0xffffffff0013864f [00029.792] 01048:01051> bt#07: 0xffffffff0015bb08 [00029.792] 01048:01051> bt#08: 0xffffffff0020d681 [00029.792] 01048:01051> bt#09: 0xffffffff0021c918 [00029.792] 01048:01051> bt#10: 0xffffffff001cd8d8 [00029.792] 01048:01051> bt#11: end [00029.792] 01048:01051> {{{bt:0:0xffffffff001e3e4c}}} [00029.792] 01048:01051> {{{bt:1:0xffffffff001f4eba}}} [00029.792] 01048:01051> {{{bt:2:0xffffffff001bc61a}}} [00029.792] 01048:01051> {{{bt:3:0xffffffff001bc27b}}} [00029.792] 01048:01051> {{{bt:4:0xffffffff00139b95}}} [00029.792] 01048:01051> {{{bt:5:0xffffffff001e414c}}} [00029.792] 01048:01051> {{{bt:6:0xffffffff0013864f}}} [00029.792] 01048:01051> {{{bt:7:0xffffffff0015bb08}}} [00029.792] 01048:01051> {{{bt:8:0xffffffff0020d681}}} [00029.792] 01048:01051> {{{bt:9:0xffffffff0021c918}}} [00029.792] 01048:01051> {{{bt:10:0xffffffff001cd8d8}}} [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsPartiallyUnmappedBufferIsInvalidArgs (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsRequiresInspectRights [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsRequiresInspectRights (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsJobHandleIsBadHandle [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsJobHandleIsBadHandle (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessMapsThreadHandleIsBadHandle [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessMapsThreadHandleIsBadHandle (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosSmokeTest [00029.792] 01048:01051> [00029.792] 01048:01051> [00029.792] 01048:01051> ZIRCON KERNEL OOPS [00029.792] 01048:01051> Lock validation failed for thread 0xffffff8000382538 pid 1048 tid 1051 (bin/core-tests:bin/core-tests): [00029.792] 01048:01051> Reason: Out Of Order [00029.792] 01048:01051> Bad lock: name=lockdep::LockClass<ProcessDispatcher, internal::BrwLock<internal::BrwLockEnablePi::Yes>, 366, lockdep::LockFlags [00029.792] 01048:01051> None> order=0 [00029.792] 01048:01051> Conflict: name=lockdep::LockClass<SoloDispatcher<ProcessDispatcher, 447439, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00029.792] 01048:01051> caller=0xffffffff0013892c frame=0xffffff9b22b91df0 [00029.792] 01048:01051> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00029.792] 01048:01051> [00029.792] 01048:01051> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00029.792] 01048:01051> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00029.792] 01048:01051> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00029.792] 01048:01051> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00029.792] 01048:01051> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00029.792] 01048:01051> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00029.792] 01048:01051> bt#00: 0xffffffff0013892c [00029.792] 01048:01051> bt#01: 0xffffffff0015bccd [00029.792] 01048:01051> bt#02: 0xffffffff0020d95d [00029.792] 01048:01051> bt#03: 0xffffffff0021c918 [00029.792] 01048:01051> bt#04: 0xffffffff001cd8d8 [00029.792] 01048:01051> bt#05: end [00029.792] 01048:01051> {{{bt:0:0xffffffff0013892c}}} [00029.792] 01048:01051> {{{bt:1:0xffffffff0015bccd}}} [00029.792] 01048:01051> {{{bt:2:0xffffffff0020d95d}}} [00029.792] 01048:01051> {{{bt:3:0xffffffff0021c918}}} [00029.792] 01048:01051> {{{bt:4:0xffffffff001cd8d8}}} [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosSmokeTest (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosOnSelfFails [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosOnSelfFails (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosInvalidHandleFails [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosInvalidHandleFails (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosNullAvailSucceeds [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosNullAvailSucceeds (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosNullActualSucceeds [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosNullActualSucceeds (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosNullActualAndAvailSucceeds [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosNullActualAndAvailSucceeds (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosInvalidBufferPointerFails [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosInvalidBufferPointerFails (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosBadActualgIsInvalidArg [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosBadActualgIsInvalidArg (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosBadAvailIsInvalidArg [00029.792] 01048:01051> [00029.792] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosBadAvailIsInvalidArg (0 [00029.792] 01048:01051> ms) [00029.792] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosZeroSizedBufferIsOk [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosZeroSizedBufferIsOk (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosSmallBufferIsOk [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosSmallBufferIsOk (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosPartiallyUnmappedBufferIsInvalidArgs [00029.793] 01048:01051> [00029.793] 01048:01051> [00029.793] 01048:01051> ZIRCON KERNEL OOPS [00029.793] 01048:01051> Lock validation failed for thread 0xffffff8000382538 pid 1048 tid 1051 (bin/core-tests:bin/core-tests): [00029.793] 01048:01051> Reason: Already Acquired [00029.793] 01048:01051> Bad lock: name=lockdep::LockClass<VmAspace, Mutex, 199, lockdep::LockFlagsNone> order=0 [00029.793] 01048:01051> Conflict: name=lockdep::LockClass<VmAspace, Mutex, 199, lockdep::LockFlagsNone> order=0 [00029.793] 01048:01051> caller=0xffffffff001e3e4c frame=0xffffff9b22b91b50 [00029.793] 01048:01051> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00029.793] 01048:01051> [00029.793] 01048:01051> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00029.793] 01048:01051> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00029.793] 01048:01051> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00029.793] 01048:01051> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00029.793] 01048:01051> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00029.793] 01048:01051> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00029.793] 01048:01051> bt#00: 0xffffffff001e3e4c [00029.793] 01048:01051> bt#01: 0xffffffff001f4eba [00029.793] 01048:01051> bt#02: 0xffffffff001bc61a [00029.793] 01048:01051> bt#03: 0xffffffff001bc27b [00029.793] 01048:01051> bt#04: 0xffffffff00139ea7 [00029.793] 01048:01051> bt#05: 0xffffffff001de1f8 [00029.793] 01048:01051> bt#06: 0xffffffff001e4166 [00029.793] 01048:01051> bt#07: 0xffffffff00138797 [00029.793] 01048:01051> bt#08: 0xffffffff0015bd53 [00029.793] 01048:01051> bt#09: 0xffffffff0020d95d [00029.793] 01048:01051> bt#10: 0xffffffff0021c918 [00029.793] 01048:01051> bt#11: 0xffffffff001cd8d8 [00029.793] 01048:01051> bt#12: end [00029.793] 01048:01051> {{{bt:0:0xffffffff001e3e4c}}} [00029.793] 01048:01051> {{{bt:1:0xffffffff001f4eba}}} [00029.793] 01048:01051> {{{bt:2:0xffffffff001bc61a}}} [00029.793] 01048:01051> {{{bt:3:0xffffffff001bc27b}}} [00029.793] 01048:01051> {{{bt:4:0xffffffff00139ea7}}} [00029.793] 01048:01051> {{{bt:5:0xffffffff001de1f8}}} [00029.793] 01048:01051> {{{bt:6:0xffffffff001e4166}}} [00029.793] 01048:01051> {{{bt:7:0xffffffff00138797}}} [00029.793] 01048:01051> {{{bt:8:0xffffffff0015bd53}}} [00029.793] 01048:01051> {{{bt:9:0xffffffff0020d95d}}} [00029.793] 01048:01051> {{{bt:10:0xffffffff0021c918}}} [00029.793] 01048:01051> {{{bt:11:0xffffffff001cd8d8}}} [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosPartiallyUnmappedBufferIsInvalidArgs (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosRequiresInspectRights [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosRequiresInspectRights (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosJobHandleIsBadHandle [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosJobHandleIsBadHandle (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessVmosThreadHandleIsBadHandle [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessVmosThreadHandleIsBadHandle (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoHandleBasicOnSelfSuceeds [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoHandleBasicOnSelfSuceeds (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoHandleBasicInvalidHandleFails [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoHandleBasicInvalidHandleFails (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoHandleBasicNullAvailSucceeds [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoHandleBasicNullAvailSucceeds (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoHandleBasicNullActualSucceeds [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoHandleBasicNullActualSucceeds (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoHandleBasicInvalidBufferPointerFails [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoHandleBasicInvalidBufferPointerFails (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoHandleBasicZeroSizedFails [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoHandleBasicZeroSizedFails (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessOnSelfSuceeds [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessOnSelfSuceeds (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessInvalidHandleFails [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessInvalidHandleFails (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessNullAvailSucceeds [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessNullAvailSucceeds (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessNullActualSucceeds [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessNullActualSucceeds (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessNullActualAndAvailSucceeds [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessNullActualAndAvailSucceeds (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessInvalidBufferPointerFails [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessInvalidBufferPointerFails (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessBadActualgIsInvalidArg [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessBadActualgIsInvalidArg (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessBadAvailIsInvalidArg [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessBadAvailIsInvalidArg (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessZeroSizedBufferFails [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessZeroSizedBufferFails (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessJobHandleIsBadHandle [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessJobHandleIsBadHandle (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessThreadHandleIsBadHandle [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessThreadHandleIsBadHandle (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsSelfSuceeds [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessThreadsSelfSuceeds (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsInvalidHandleFails [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessThreadsInvalidHandleFails (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsNullAvailSucceeds [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessThreadsNullAvailSucceeds (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsNullActualSucceeds [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessThreadsNullActualSucceeds (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsNullActualAndAvailSucceeds [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessThreadsNullActualAndAvailSucceeds (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsInvalidBufferPointerFails [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessThreadsInvalidBufferPointerFails (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsBadActualgIsInvalidArg [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessThreadsBadActualgIsInvalidArg (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsBadAvailIsInvalidArg [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessThreadsBadAvailIsInvalidArg (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsZeroSizedBufferSucceeds [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] ProcessGetInfoTest.InfoProcessThreadsZeroSizedBufferSucceeds (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [----------] 61 tests from ProcessGetInfoTest (1 [00029.793] 01048:01051> ms total) [00029.793] 01048:01051> [----------] 12 tests from TaskGetInfoTest [00029.793] 01048:01051> [00029.793] 01048:01051> [ RUN ] TaskGetInfoTest.InfoStatsUnstartedSuceeds [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] TaskGetInfoTest.InfoStatsUnstartedSuceeds (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] TaskGetInfoTest.InfoStatsSmokeTest [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] TaskGetInfoTest.InfoStatsSmokeTest (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] TaskGetInfoTest.InfoTaskStatsInvalidHandleFails [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] TaskGetInfoTest.InfoTaskStatsInvalidHandleFails (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] TaskGetInfoTest.InfoTaskStatsNullAvailSucceeds [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] TaskGetInfoTest.InfoTaskStatsNullAvailSucceeds (0 [00029.793] 01048:01051> ms) [00029.793] 01048:01051> [ RUN ] TaskGetInfoTest.InfoTaskStatsNullActualSucceeds [00029.793] 01048:01051> [00029.793] 01048:01051> [ OK ] TaskGetInfoTest.InfoTaskStatsNullActualSucceeds (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] TaskGetInfoTest.InfoTaskStatsNullActualAndAvailSucceeds [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] TaskGetInfoTest.InfoTaskStatsNullActualAndAvailSucceeds (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] TaskGetInfoTest.InfoTaskStatsInvalidBufferPointerFails [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] TaskGetInfoTest.InfoTaskStatsInvalidBufferPointerFails (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] TaskGetInfoTest.InfoTaskStatsBadActualgIsInvalidArg [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] TaskGetInfoTest.InfoTaskStatsBadActualgIsInvalidArg (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] TaskGetInfoTest.InfoTaskStatsBadAvailIsInvalidArg [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] TaskGetInfoTest.InfoTaskStatsBadAvailIsInvalidArg (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] TaskGetInfoTest.InfoTaskStatsZeroSizedBufferIsTooSmall [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] TaskGetInfoTest.InfoTaskStatsZeroSizedBufferIsTooSmall (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] TaskGetInfoTest.InfoTaskStatsJobHandleIsBadHandle [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] TaskGetInfoTest.InfoTaskStatsJobHandleIsBadHandle (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] TaskGetInfoTest.InfoTaskStatsThreadHandleIsBadHandle [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] TaskGetInfoTest.InfoTaskStatsThreadHandleIsBadHandle (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [----------] 12 tests from TaskGetInfoTest (0 [00029.794] 01048:01051> ms total) [00029.794] 01048:01051> [----------] 41 tests from ThreadGetInfoTest [00029.794] 01048:01051> [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleBasicOnSelfSuceeds [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleBasicOnSelfSuceeds (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleBasicInvalidHandleFails [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleBasicInvalidHandleFails (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleBasicNullAvailSucceeds [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleBasicNullAvailSucceeds (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleBasicNullActualSucceeds [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleBasicNullActualSucceeds (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleBasicInvalidBufferPointerFails [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleBasicInvalidBufferPointerFails (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleBasicZeroSizedBufferFails [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleBasicZeroSizedBufferFails (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleCountOnSelfSuceeds [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleCountOnSelfSuceeds (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleCountInvalidHandleFails [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleCountInvalidHandleFails (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleCountNullAvailSucceeds [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleCountNullAvailSucceeds (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleCountNullActualSucceeds [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleCountNullActualSucceeds (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleCountNullActualAndAvailSucceeds [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleCountNullActualAndAvailSucceeds (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleCountInvalidBufferPointerFails [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleCountInvalidBufferPointerFails (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleCountBadActualgIsInvalidArg [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleCountBadActualgIsInvalidArg (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleCountBadAvailIsInvalidArg [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleCountBadAvailIsInvalidArg (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoHandleCountZeroSizedBufferFails [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoHandleCountZeroSizedBufferFails (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadOnSelfSuceeds [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadOnSelfSuceeds (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadInvalidHandleFails [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadInvalidHandleFails (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadNullAvailSucceeds [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadNullAvailSucceeds (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadNullActualSucceeds [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadNullActualSucceeds (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadNullActualAndAvailSucceeds [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadNullActualAndAvailSucceeds (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadInvalidBufferPointerFails [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadInvalidBufferPointerFails (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadBadActualgIsInvalidArg [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadBadActualgIsInvalidArg (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadBadAvailIsInvalidArg [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadBadAvailIsInvalidArg (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadZeroSizedBufferFails [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadZeroSizedBufferFails (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadJobHandleIsBadHandle [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadJobHandleIsBadHandle (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadProcessHandleIsBadHandle [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadProcessHandleIsBadHandle (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadStatsOnSelfSuceeds [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadStatsOnSelfSuceeds (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadStatsInvalidHandleFails [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadStatsInvalidHandleFails (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadStatsNullAvailSucceeds [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadStatsNullAvailSucceeds (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadStatsNullActualSucceeds [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadStatsNullActualSucceeds (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadStatsNullActualAndAvailSucceeds [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadStatsNullActualAndAvailSucceeds (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadStatsInvalidBufferPointerFails [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadStatsInvalidBufferPointerFails (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadStatsBadActualgIsInvalidArg [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadStatsBadActualgIsInvalidArg (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadStatsBadAvailIsInvalidArg [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadStatsBadAvailIsInvalidArg (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadStatsZeroSizedBufferFails [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadStatsZeroSizedBufferFails (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadStatsJobHandleIsBadHandle [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadStatsJobHandleIsBadHandle (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadStatsProcessHandleIsBadHandle [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadStatsProcessHandleIsBadHandle (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] ThreadGetInfoTest.InfoThreadExceptionReportInvalidHandleFails [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] ThreadGetInfoTest.InfoThreadExceptionReportInvalidHandleFails (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [----------] 41 tests from ThreadGetInfoTest (0 [00029.794] 01048:01051> ms total) [00029.794] 01048:01051> [----------] 21 tests from VmarGetInfoTest [00029.794] 01048:01051> [00029.794] 01048:01051> [ RUN ] VmarGetInfoTest.InfoHandleBasicOnSelfSuceeds [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] VmarGetInfoTest.InfoHandleBasicOnSelfSuceeds (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] VmarGetInfoTest.InfoHandleBasicInvalidHandleFails [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] VmarGetInfoTest.InfoHandleBasicInvalidHandleFails (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] VmarGetInfoTest.InfoHandleBasicNullAvailSucceeds [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] VmarGetInfoTest.InfoHandleBasicNullAvailSucceeds (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] VmarGetInfoTest.InfoHandleBasicNullActualSucceeds [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] VmarGetInfoTest.InfoHandleBasicNullActualSucceeds (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] VmarGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] VmarGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] VmarGetInfoTest.InfoHandleBasicInvalidBufferPointerFails [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] VmarGetInfoTest.InfoHandleBasicInvalidBufferPointerFails (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] VmarGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] VmarGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] VmarGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg [00029.794] 01048:01051> [00029.794] 01048:01051> [ OK ] VmarGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg (0 [00029.794] 01048:01051> ms) [00029.794] 01048:01051> [ RUN ] VmarGetInfoTest.InfoHandleBasicZeroSizedBufferFails [00029.795] 01048:01051> [00029.795] 01048:01051> [ OK ] VmarGetInfoTest.InfoHandleBasicZeroSizedBufferFails (0 [00029.795] 01048:01051> ms) [00029.795] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarOnSelfFails [00029.795] 01048:01051> [00029.795] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarOnSelfFails (0 [00029.795] 01048:01051> ms) [00029.795] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarInvalidHandleFails [00029.795] 01048:01051> [00029.795] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarInvalidHandleFails (0 [00029.795] 01048:01051> ms) [00029.795] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarNullAvailSucceeds [00029.795] 01048:01051> [00029.795] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarNullAvailSucceeds (0 [00029.795] 01048:01051> ms) [00029.795] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarNullActualSucceeds [00029.795] 01048:01051> [00029.795] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarNullActualSucceeds (0 [00029.795] 01048:01051> ms) [00029.795] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarNullActualAndAvailSucceeds [00029.795] 01048:01051> [00029.795] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarNullActualAndAvailSucceeds (0 [00029.795] 01048:01051> ms) [00029.795] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarInvalidBufferPointerFails [00029.795] 01048:01051> [00029.795] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarInvalidBufferPointerFails (0 [00029.795] 01048:01051> ms) [00029.795] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarBadActualgIsInvalidArg [00029.795] 01048:01051> [00029.795] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarBadActualgIsInvalidArg (0 [00029.795] 01048:01051> ms) [00029.795] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarBadAvailIsInvalidArg [00029.795] 01048:01051> [00029.795] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarBadAvailIsInvalidArg (0 [00029.795] 01048:01051> ms) [00029.795] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarZeroSizedBufferFails [00029.795] 01048:01051> [00029.795] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarZeroSizedBufferFails (0 [00029.795] 01048:01051> ms) [00029.795] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarJobHandleIsBadHandle [00029.795] 01048:01051> [00029.795] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarJobHandleIsBadHandle (0 [00029.795] 01048:01051> ms) [00029.795] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarProcessHandleIsBadHandle [00029.795] 01048:01051> [00029.795] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarProcessHandleIsBadHandle (0 [00029.795] 01048:01051> ms) [00029.795] 01048:01051> [ RUN ] VmarGetInfoTest.InfoVmarThreadHandleIsBadHandle [00029.795] 01048:01051> [00029.795] 01048:01051> [ OK ] VmarGetInfoTest.InfoVmarThreadHandleIsBadHandle (0 [00029.795] 01048:01051> ms) [00029.795] 01048:01051> [----------] 21 tests from VmarGetInfoTest (0 [00029.795] 01048:01051> ms total) [00029.795] 01048:01051> [----------] 28 tests from SocketTest [00029.795] 01048:01051> [00029.795] 01048:01051> [ RUN ] SocketTest.EndpointsAreRelated [00029.795] 01048:01051> [00029.795] 01048:01051> [ OK ] SocketTest.EndpointsAreRelated (0 [00029.795] 01048:01051> ms) [00029.795] 01048:01051> [ RUN ] SocketTest.EmptySocketShouldWait [00029.795] 01048:01051> [00029.795] 01048:01051> [ OK ] SocketTest.EmptySocketShouldWait (0 [00029.795] 01048:01051> ms) [00029.795] 01048:01051> [ RUN ] SocketTest.WriteReadDataVerify [00029.795] 01048:01051> [00029.795] 01048:01051> [ OK ] SocketTest.WriteReadDataVerify (0 [00029.795] 01048:01051> ms) [00029.795] 01048:01051> [ RUN ] SocketTest.PeerClosedError [00029.795] 01048:01051> [00029.795] 01048:01051> [ OK ] SocketTest.PeerClosedError (0 [00029.795] 01048:01051> ms) [00029.795] 01048:01051> [ RUN ] SocketTest.PeekingLeavesData [00029.795] 01048:01051> [00029.795] 01048:01051> [ OK ] SocketTest.PeekingLeavesData (0 [00029.795] 01048:01051> ms) [00029.795] 01048:01051> [ RUN ] SocketTest.PeekingIntoEmpty [00029.795] 01048:01051> [00029.795] 01048:01051> [ OK ] SocketTest.PeekingIntoEmpty (0 [00029.795] 01048:01051> ms) [00029.795] 01048:01051> [ RUN ] SocketTest.Signals [00029.795] 01048:01051> [00029.795] 01048:01051> [ OK ] SocketTest.Signals (0 [00029.795] 01048:01051> ms) [00029.795] 01048:01051> [ RUN ] SocketTest.SetThreshholdsProp [00029.795] 01048:01051> [00029.795] 01048:01051> [ OK ] SocketTest.SetThreshholdsProp (0 [00029.795] 01048:01051> ms) [00029.795] 01048:01051> [ RUN ] SocketTest.SetThreshholdsAndCheckSignals [00029.795] 01048:01051> [00029.796] 01048:01051> [ OK ] SocketTest.SetThreshholdsAndCheckSignals (0 [00029.796] 01048:01051> ms) [00029.796] 01048:01051> [ RUN ] SocketTest.SignalClosedPeer [00029.796] 01048:01051> [00029.796] 01048:01051> [ OK ] SocketTest.SignalClosedPeer (0 [00029.796] 01048:01051> ms) [00029.796] 01048:01051> [ RUN ] SocketTest.PeerClosedSetProperty [00029.796] 01048:01051> [00029.796] 01048:01051> [ OK ] SocketTest.PeerClosedSetProperty (0 [00029.796] 01048:01051> ms) [00029.796] 01048:01051> [ RUN ] SocketTest.ShutdownWrite [00029.796] 01048:01051> [00029.796] 01048:01051> [ OK ] SocketTest.ShutdownWrite (0 [00029.796] 01048:01051> ms) [00029.796] 01048:01051> [ RUN ] SocketTest.ShutdownRead [00029.796] 01048:01051> [00029.796] 01048:01051> [ OK ] SocketTest.ShutdownRead (0 [00029.796] 01048:01051> ms) [00029.796] 01048:01051> [ RUN ] SocketTest.BytesOutstanding [00029.796] 01048:01051> [00029.796] 01048:01051> [ OK ] SocketTest.BytesOutstanding (0 [00029.796] 01048:01051> ms) [00029.796] 01048:01051> [ RUN ] SocketTest.ShutdownWriteBytesOutstanding [00029.796] 01048:01051> [00029.796] 01048:01051> [ OK ] SocketTest.ShutdownWriteBytesOutstanding (0 [00029.796] 01048:01051> ms) [00029.796] 01048:01051> [ RUN ] SocketTest.ShutdownReadBytesOutstanding [00029.796] 01048:01051> [00029.796] 01048:01051> [ OK ] SocketTest.ShutdownReadBytesOutstanding (0 [00029.796] 01048:01051> ms) [00029.796] 01048:01051> [ RUN ] SocketTest.ShortWrite [00029.796] 01048:01051> [00029.796] 01048:01051> [ OK ] SocketTest.ShortWrite (0 [00029.796] 01048:01051> ms) [00029.796] 01048:01051> [ RUN ] SocketTest.Datagram [00029.796] 01048:01051> [00029.796] 01048:01051> [ OK ] SocketTest.Datagram (0 [00029.796] 01048:01051> ms) [00029.796] 01048:01051> [ RUN ] SocketTest.DatagramPeek [00029.796] 01048:01051> [00029.796] 01048:01051> [ OK ] SocketTest.DatagramPeek (0 [00029.796] 01048:01051> ms) [00029.796] 01048:01051> [ RUN ] SocketTest.DatagramPeekEmpty [00029.796] 01048:01051> [00029.796] 01048:01051> [ OK ] SocketTest.DatagramPeekEmpty (0 [00029.796] 01048:01051> ms) [00029.796] 01048:01051> [ RUN ] SocketTest.DatagramNoShortWrite [00029.796] 01048:01051> [00029.797] 01048:01051> [ OK ] SocketTest.DatagramNoShortWrite (0 [00029.797] 01048:01051> ms) [00029.797] 01048:01051> [ RUN ] SocketTest.ControlPlaneAbsent [00029.797] 01048:01051> [00029.797] 01048:01051> [ OK ] SocketTest.ControlPlaneAbsent (0 [00029.797] 01048:01051> ms) [00029.797] 01048:01051> [ RUN ] SocketTest.ControlPlane [00029.797] 01048:01051> [00029.797] 01048:01051> [ OK ] SocketTest.ControlPlane (0 [00029.797] 01048:01051> ms) [00029.797] 01048:01051> [ RUN ] SocketTest.ControlPlanePeek [00029.797] 01048:01051> [00029.797] 01048:01051> [ OK ] SocketTest.ControlPlanePeek (0 [00029.797] 01048:01051> ms) [00029.797] 01048:01051> [ RUN ] SocketTest.ControlPlanePeekEmpty [00029.797] 01048:01051> [00029.797] 01048:01051> [ OK ] SocketTest.ControlPlanePeekEmpty (0 [00029.797] 01048:01051> ms) [00029.797] 01048:01051> [ RUN ] SocketTest.ControlPlaneShutdown [00029.797] 01048:01051> [00029.797] 01048:01051> [ OK ] SocketTest.ControlPlaneShutdown (0 [00029.797] 01048:01051> ms) [00029.797] 01048:01051> [ RUN ] SocketTest.Accept [00029.797] 01048:01051> [00029.797] 01048:01051> [00029.797] 01048:01051> ZIRCON KERNEL OOPS [00029.797] 01048:01051> Lock validation failed for thread 0xffffff8000382538 pid 1048 tid 1051 (bin/core-tests:bin/core-tests): [00029.797] 01048:01051> Reason: Already Acquired [00029.797] 01048:01051> Bad lock: name=lockdep::LockClass<PeerHolder<SocketDispatcher>, Mutex, 319, lockdep::LockFlagsNone> order=0 [00029.797] 01048:01051> Conflict: name=lockdep::LockClass<PeerHolder<SocketDispatcher>, Mutex, 319, lockdep::LockFlagsNone> order=0 [00029.797] 01048:01051> caller=0xffffffff0013ba8a frame=0xffffff9b22b91e70 [00029.797] 01048:01051> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00029.797] 01048:01051> [00029.797] 01048:01051> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00029.797] 01048:01051> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00029.797] 01048:01051> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00029.797] 01048:01051> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00029.797] 01048:01051> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00029.797] 01048:01051> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00029.797] 01048:01051> bt#00: 0xffffffff0013ba8a [00029.797] 01048:01051> bt#01: 0xffffffff00147280 [00029.797] 01048:01051> bt#02: 0xffffffff00161812 [00029.797] 01048:01051> bt#03: 0xffffffff002144d2 [00029.797] 01048:01051> bt#04: 0xffffffff0021e26a [00029.797] 01048:01051> bt#05: 0xffffffff001cd9d5 [00029.797] 01048:01051> bt#06: end [00029.797] 01048:01051> {{{bt:0:0xffffffff0013ba8a}}} [00029.797] 01048:01051> {{{bt:1:0xffffffff00147280}}} [00029.797] 01048:01051> {{{bt:2:0xffffffff00161812}}} [00029.797] 01048:01051> {{{bt:3:0xffffffff002144d2}}} [00029.797] 01048:01051> {{{bt:4:0xffffffff0021e26a}}} [00029.797] 01048:01051> {{{bt:5:0xffffffff001cd9d5}}} [00029.797] 01048:01051> [00029.797] 01048:01051> [00029.797] 01048:01051> ZIRCON KERNEL OOPS [00029.797] 01048:01051> Lock validation failed for thread 0xffffff8000382538 pid 1048 tid 1051 (bin/core-tests:bin/core-tests): [00029.797] 01048:01051> Reason: Already Acquired [00029.797] 01048:01051> Bad lock: name=lockdep::LockClass<PeerHolder<SocketDispatcher>, Mutex, 319, lockdep::LockFlagsNone> order=0 [00029.797] 01048:01051> Conflict: name=lockdep::LockClass<PeerHolder<SocketDispatcher>, Mutex, 319, lockdep::LockFlagsNone> order=0 [00029.797] 01048:01051> caller=0xffffffff00162194 frame=0xffffff9b22b91e90 [00029.797] 01048:01051> BUILDID git-9a8bc896a115c956ea7bb299ce66983f7e3ac7ef-dirty [00029.797] 01048:01051> [00029.797] 01048:01051> {{{module:0:kernel:elf:62a0392e7206ad9c}}} [00029.797] 01048:01051> {{{mmap:0xffffffff00100000:0x1491e8:load:0:rx:0xffffffff80100000}}} [00029.797] 01048:01051> {{{mmap:0xffffffff0024a000:0x4c000:load:0:r:0xffffffff8024a000}}} [00029.797] 01048:01051> {{{mmap:0xffffffff00296000:0x63d0:load:0:rw:0xffffffff80296000}}} [00029.797] 01048:01051> {{{mmap:0xffffffff0029d000:0x98000:load:0:rw:0xffffffff8029d000}}} [00029.797] 01048:01051> dso: id=62a0392e7206ad9c base=0xffffffff00100000 name=zircon.elf [00029.797] 01048:01051> bt#00: 0xffffffff00162194 [00029.797] 01048:01051> bt#01: 0xffffffff00147338 [00029.797] 01048:01051> bt#02: 0xffffffff00161812 [00029.797] 01048:01051> bt#03: 0xffffffff002144d2 [00029.797] 01048:01051> bt#04: 0xffffffff0021e26a [00029.797] 01048:01051> bt#05: 0xffffffff001cd9d5 [00029.797] 01048:01051> bt#06: end [00029.797] 01048:01051> {{{bt:0:0xffffffff00162194}}} [00029.797] 01048:01051> {{{bt:1:0xffffffff00147338}}} [00029.797] 01048:01051> {{{bt:2:0xffffffff00161812}}} [00029.797] 01048:01051> {{{bt:3:0xffffffff002144d2}}} [00029.797] 01048:01051> {{{bt:4:0xffffffff0021e26a}}} [00029.797] 01048:01051> {{{bt:5:0xffffffff001cd9d5}}} [00029.797] 01048:01051> [00029.797] 01048:01051> [ OK ] SocketTest.Accept (0 [00029.797] 01048:01051> ms) [00029.797] 01048:01051> [ RUN ] SocketTest.ZeroSize [00029.797] 01048:01051> [00029.797] 01048:01051> [ OK ] SocketTest.ZeroSize (0 [00029.797] 01048:01051> ms) [00029.797] 01048:01051> [----------] 28 tests from SocketTest (2 [00029.797] 01048:01051> ms total) [00029.797] 01048:01051> [----------] 1 test from TicksTest [00029.797] 01048:01051> [00029.797] 01048:01051> [ RUN ] TicksTest.ElapsedTimeUsingTicks [00029.797] 01048:01051> [00029.797] 01048:01051> [ OK ] TicksTest.ElapsedTimeUsingTicks (0 [00029.797] 01048:01051> ms) [00029.797] 01048:01051> [----------] 1 test from TicksTest (0 [00029.797] 01048:01051> ms total) [00029.797] 01048:01051> [----------] Global test environment tear-down. [00029.797] 01048:01051> [==========] 243 tests from 14 test cases ran (2767 [00029.797] 01048:01051> ms total). [00029.797] 01048:01051> [ PASSED ] 243 tests [00029.797] 01048:01051> [00029.797] 01048:01051> core-tests succeeded RZMm59f7zOSs6aZUIXZR [00029.840] 01034:01041> userboot: loader-service channel peer closed [00029.841] 01034:01041> userboot: Waiting for bin/core-tests to exit... [00029.842] 01034:01041> userboot: Process exited. Executing "poweroff". [00029.850] 01034:01041> mp_unplug_cpu_mask_single_locked:362: WARNING: leaking thread for cpu 3 [00029.857] 01034:01041> mp_unplug_cpu_mask_single_locked:362: WARNING: leaking thread for cpu 2 [00029.862] 01034:01041> mp_unplug_cpu_mask_single_locked:362: WARNING: leaking thread for cpu 1 [00029.862] 01034:01041> Shutting down debuglog 2019/05/18 05:02:24 successful QEMU exit status: 31