2019/04/25 14:33:02 QEMU invocation:
[/b/s/w/ir/qemu/bin/qemu-system-aarch64 -machine virt,gic_version=host -cpu host -enable-kvm -m 4096 -smp 4 -nographic -serial stdio -monitor none -kernel /b/s/w/ir/qemu-boot-shim.bin -initrd /b/s/w/ir/core-tests-arm64.zbi -netdev user,id=net0 -device virtio-net-pci,netdev=net0 -append kernel.halt-on-panic=true devmgr.suspend-timeout-debug=true TERM=dumb]
[00000.000] 00000:00000> PMM: boot reserve add [0x48290000, 0x48455fff]
[00000.000] 00000:00000> mem_arena.base 0x40000000 size 0x8000000
[00000.000] 00000:00000> overriding mem arena 0 base from FDT: 0x40000000
[00000.000] 00000:00000> overriding mem arena 0 size from FDT: 0x100000000
[00000.000] 00000:00000> detected GICv3
[00000.000] 00000:00000> PSCI version 1.0
[00000.000] 00000:00000> PSCI supported features:
[00000.000] 00000:00000> PSCI64_SYSTEM_OFF 0
[00000.000] 00000:00000> PSCI64_SYSTEM_RESET 0
[00000.000] 00000:00000> PSCI64_CPU_ON 0
[00000.000] 00000:00000> PSCI64_CPU_OFF 0
[00000.000] 00000:00000> arm generic timer freq 200000000 Hz
[00001.308] 00000:00000> cntpct_per_ns: 00000000.3333333333333333
[00001.308] 00000:00000> ns_per_cntpct: 00000005.0000000000000000
[00001.308] 00000:00000> test_time_conversion_check_result:253: FAIL, off by 230584300921369395
[00001.308] 00000:00000> reserving ramdisk phys range [0x48000000, 0x4813dfff]
[00001.308] 00000:00000> PMM: boot reserve add [0x48000000, 0x4813dfff]
[00001.370] 00000:00000> PMM: boot reserve marking WIRED [0x48000000, 0x4813dfff]
[00001.370] 00000:00000> PMM: boot reserve marking WIRED [0x48290000, 0x48455fff]
[00001.370] 00000:00000>
[00001.370] 00000:00000> welcome to Zircon
[00001.370] 00000:00000>
[00001.370] 00000:00000> KASLR: .text section at 0xffffffff10000000
[00001.370] 00000:00000> INIT: cpu 0, calling hook 0xffffffff1001da40 (global_prng_seed) at level 0x30000, flags 0x1
[00001.385] 00000:00000> initializing vm pre-heap
[00001.385] 00000:00000> VM: marking boot alloc used range [0x48456000, 0x4845b040)
[00001.387] 00000:00000> INIT: cpu 0, calling hook 0xffffffff1002c724 (elf_build_id) at level 0x4fffe, flags 0x1
[00001.387] 00000:00000> INIT: cpu 0, calling hook 0xffffffff1002c8c8 (version) at level 0x4ffff, flags 0x1
[00001.387] 00000:00000> version:
[00001.387] 00000:00000> arch: arm64
[00001.387] 00000:00000> platform: XXX
[00001.387] 00000:00000> target: XXX
[00001.387] 00000:00000> project: arm64
[00001.387] 00000:00000> buildid: git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00001.387] 00000:00000> ELF build ID: 493e35f11d886ad5
[00001.387] 00000:00000> initializing heap
[00001.387] 00000:00000> INIT: cpu 0, calling hook 0xffffffff10002240 (arm_resource_init) at level 0x50000, flags 0x1
[00001.387] 00000:00000> INIT: cpu 0, calling hook 0xffffffff1000366c (console) at level 0x50000, flags 0x1
[00001.387] 00000:00000> initializing vm
[00001.387] 00000:00000> VM: reserving kernel region [0xffffffff10000000, 0xffffffff1010c000) flags 0x28 name 'kernel_code'
[00001.387] 00000:00000> VM: reserving kernel region [0xffffffff1010c000, 0xffffffff1014a000) flags 0x8 name 'kernel_rodata'
[00001.387] 00000:00000> VM: reserving kernel region [0xffffffff1014a000, 0xffffffff1014b000) flags 0x18 name 'kernel_data'
[00001.387] 00000:00000> VM: reserving kernel region [0xffffffff10150000, 0xffffffff101c6000) flags 0x18 name 'kernel_bss'
[00001.387] 00000:00000> INIT: cpu 0, calling hook 0xffffffff100018b8 (platform_init_pre_thread) at level 0x60000, flags 0x1
[00001.387] 00000:00000> System topology: CPU 0:0:0:0
[00001.387] 00000:00000> System topology: CPU 0:0:0:1
[00001.387] 00000:00000> System topology: CPU 0:0:0:2
[00001.387] 00000:00000> System topology: CPU 0:0:0:3
[00001.387] 00000:00000> INIT: cpu 0, calling hook 0xffffffff10001b74 (platform_postvm) at level 0x60000, flags 0x1
[00001.387] 00000:00000> CreateSubVmarInternal:114: warning: mapping periph has conflicting cache policies: vmo 00 arch_mmu_flags 02.
[00001.387] 00000:00000> INIT: cpu 0, calling hook 0xffffffff100f6f7c (percpu_heap_init) at level 0x60003, flags 0x1
[00001.387] 00000:00000> initializing kernel
[00001.387] 00000:00000> initializing mp
[00001.387] 00000:00000> INIT: cpu 0, calling hook 0xffffffff1001dd04 (global_prng_thread_safe) at level 0x7ffff, flags 0x1
[00001.387] 00000:00000> creating bootstrap completion thread
[00001.387] 00000:00000> top of bootstrap2()
[00001.387] 00000:00000> INIT: cpu 0, calling hook 0xffffffff1003e9c4 (libobject) at level 0x80000, flags 0x1
[00001.387] 00000:00000> OOM: started thread
[00001.387] 00000:00000> INIT: cpu 0, calling hook 0xffffffff100f35d4 (dpc) at level 0x80000, flags 0x1
[00001.387] 00000:00000> INIT: cpu 0, calling hook 0xffffffff1010ac7c (lockdep) at level 0x80000, flags 0x1
[00001.388] 00000:00000> ARM boot EL1
[00001.388] 00000:00000> ARM cpu 0: midr 0x431f0af1 'Cavium CN99XX r1p1' mpidr 0x80000000 aff 0:0:0:0
[00001.388] 00000:00000> ARM Features: fp asimd aes pmull sha1 sha2 crc32 atomics rdm
[00001.388] 00000:00000> ARM cache line sizes: icache 64 dcache 64 zva 64
[00001.388] 00000:00000> ==== ARM64 CACHE INFO CORE 0 ====
[00001.388] 00000:00000> Inner Boundary = L0
[00001.388] 00000:00000> Level of Unification Uniprocessor = L1
[00001.388] 00000:00000> Level of Coherence = L3
[00001.388] 00000:00000> Level of Unification Inner Shareable = L1
[00001.388] 00000:00000> L1 Details: Data Cache, sets=64, associativity=8, line size=64 bytes
[00001.388] 00000:00000> Instruction Cache, sets=64, associativity=8, line size=64 bytes
[00001.388] 00000:00000> L2 Details: Unified Cache, sets=512, associativity=8, line size=64 bytes
[00001.388] 00000:00000> L3 Details: Unified Cache, sets=16384, associativity=32, line size=64 bytes
[00001.388] 00000:00000> L4 Details: Not Implemented
[00001.388] 00000:00000> L5 Details: Not Implemented
[00001.388] 00000:00000> L6 Details: Not Implemented
[00001.388] 00000:00000> L7 Details: Not Implemented
[00001.388] 00000:00000> initializing platform
[00001.388] 00000:00000> INIT: cpu 0, calling hook 0xffffffff10098aa8 (arm64_perfmon) at level 0x90000, flags 0x1
[00001.388] 00000:00000> Trying to start cpu 1 returned: 0
[00001.388] 00000:00000> Trying to start cpu 2 returned: 0
[00001.388] 00000:00000> Trying to start cpu 3 returned: 0
[00001.388] 00000:00000> initializing target
[00001.388] 00000:00000> INIT: cpu 0, calling hook 0xffffffff1008e57c (platform_dev_init) at level 0xa0000, flags 0x1
[00001.388] 00000:00000> UART: started IRQ driven TX
[00001.388] 00000:00000> moving to last init level
[00001.388] 00000:00000> INIT: cpu 0, calling hook 0xffffffff1002be80 (debuglog) at level 0xb0000, flags 0x1
[00001.462] 00000:00000> INIT: cpu 0, calling hook 0xffffffff1007f728 (kcounters) at level 0xb0000, flags 0x1
[00001.462] 00000:00000> INIT: cpu 0, calling hook 0xffffffff10003b5c (kernel_shell) at level 0xc0000, flags 0x1
[00001.462] 00000:00000> INIT: cpu 0, calling hook 0xffffffff100efeac (ktrace) at level 0xc0000, flags 0x1
[00001.509] 00000:00000> ktrace: buffer at 0xffff00860888f000 (33554432 bytes)
[00001.509] 00000:00000> INIT: cpu 0, calling hook 0xffffffff1010654c (userboot) at level 0xc0000, flags 0x1
[00001.509] 00000:00000> userboot: ramdisk 0x13e000 @ 0xffff000048000000
[00001.509] 00000:00000> userboot: userboot rodata 0 @ [0xeb7bcd4c0000,0xeb7bcd4c2000)
[00001.509] 00000:00000> userboot: userboot code 0x2000 @ [0xeb7bcd4c2000,0xeb7bcd4c6000)
[00001.509] 00000:00000> userboot: vdso/full rodata 0 @ [0xeb7bcd4c6000,0xeb7bcd4cc000)
[00001.509] 00000:00000> userboot: vdso/full code 0x6000 @ [0xeb7bcd4cc000,0xeb7bcd4ce000)
[00001.509] 00000:00000> userboot: entry point @ 0xeb7bcd4c2b60
[00001.518] 01032:01039> userboot: option "userboot=bin/core-tests"
[00001.518] 01032:01039> userboot: option "userboot.shutdown="
[00001.518] 01032:01039> userboot: option "kernel.halt-on-panic=true"
[00001.518] 01032:01039> userboot: option "devmgr.suspend-timeout-debug=true"
[00001.518] 01032:01039> userboot: option "TERM=dumb"
[00001.525] 01032:01039> userboot: searching bootfs for 'bin/core-tests'
[00001.525] 01032:01039> userboot: 'bin/core-tests' has PT_INTERP "lib/ld.so.1"
[00001.525] 01032:01039> userboot: searching bootfs for 'lib/ld.so.1'
[00001.525] 01032:01039> userboot: userboot: loaded lib/ld.so.1 at 0xb8bdd8dad000, entry point 0xb8bdd8df5318
[00001.525] 01032:01039> userboot: userboot: loaded vDSO at 0xee1fcb84c000, entry point 0xee1fcb852a48
[00001.534] 01032:01039> userboot: process bin/core-tests started.
[00001.534] 01032:01039> userboot: waiting for loader-service requests...
[00001.538] 01032:01039> userboot: searching bootfs for 'lib/libfdio.so'
[00001.539] 01032:01039> userboot: searching bootfs for 'lib/libunittest.so'
[00001.540] 01032:01039> userboot: searching bootfs for 'lib/libmini-process.so'
[00001.541] 01032:01039> userboot: searching bootfs for 'lib/libinspector.so'
[00001.542] 01032:01039> userboot: searching bootfs for 'lib/libbacktrace.so'
[00001.544] 01046:01049> {{{reset}}}
[00001.544] 01046:01049> {{{module:0:<application>:elf:da73ecd9fb90f3a1}}}
[00001.544] 01046:01049> {{{mmap:0x9fa902d26000:0x4c000:load:0:r:0}}}
[00001.544] 01046:01049> {{{mmap:0x9fa902d72000:0x139000:load:0:rx:0x4c000}}}
[00001.544] 01046:01049> {{{mmap:0x9fa902eab000:0x9000:load:0:rw:0x185000}}}
[00001.544] 01046:01049> {{{mmap:0x9fa902eb4000:0x2000:load:0:rw:0x18e000}}}
[00001.544] 01046:01049> dso: id=da73ecd9fb90f3a1 base=0x00009fa902d26000 name=<application>
[00001.544] 01046:01049> {{{module:0x3:libfdio.so:elf:301ae1d1970af4ed}}}
[00001.544] 01046:01049> {{{mmap:0x9afc97218000:0xb000:load:0x3:r:0}}}
[00001.544] 01046:01049> {{{mmap:0x9afc97223000:0x1a000:load:0x3:rx:0xb000}}}
[00001.544] 01046:01049> {{{mmap:0x9afc9723d000:0x2000:load:0x3:rw:0x25000}}}
[00001.544] 01046:01049> {{{mmap:0x9afc9723f000:0x2000:load:0x3:rw:0x27000}}}
[00001.544] 01046:01049> dso: id=301ae1d1970af4ed base=0x00009afc97218000 name=libfdio.so
[00001.544] 01046:01049> {{{module:0x4:libunittest.so:elf:9e63522bca0bd1c4}}}
[00001.544] 01046:01049> {{{mmap:0x51aec0e40000:0x4000:load:0x4:r:0}}}
[00001.544] 01046:01049> {{{mmap:0x51aec0e44000:0x3000:load:0x4:rx:0x4000}}}
[00001.544] 01046:01049> {{{mmap:0x51aec0e47000:0x1000:load:0x4:rw:0x7000}}}
[00001.544] 01046:01049> {{{mmap:0x51aec0e48000:0x2000:load:0x4:rw:0x8000}}}
[00001.544] 01046:01049> dso: id=9e63522bca0bd1c4 base=0x000051aec0e40000 name=libunittest.so
[00001.544] 01046:01049> {{{module:0x2:<vDSO>:elf:9354a4e159cb64b6}}}
[00001.544] 01046:01049> {{{mmap:0xee1fcb84c000:0x6000:load:0x2:r:0}}}
[00001.544] 01046:01049> {{{mmap:0xee1fcb852000:0x2000:load:0x2:rx:0x6000}}}
[00001.544] 01046:01049> dso: id=9354a4e159cb64b6 base=0x0000ee1fcb84c000 name=<vDSO>
[00001.544] 01046:01049> {{{module:0x5:libmini-process.so:elf:45ad6ef8ef82e222}}}
[00001.544] 01046:01049> {{{mmap:0xfc443a88a000:0x2000:load:0x5:r:0}}}
[00001.544] 01046:01049> {{{mmap:0xfc443a88c000:0x2000:load:0x5:rx:0x2000}}}
[00001.544] 01046:01049> {{{mmap:0xfc443a88e000:0x1000:load:0x5:rw:0x4000}}}
[00001.544] 01046:01049> {{{mmap:0xfc443a88f000:0x1000:load:0x5:rw:0x5000}}}
[00001.544] 01046:01049> dso: id=45ad6ef8ef82e222 base=0x0000fc443a88a000 name=libmini-process.so
[00001.544] 01046:01049> {{{module:0x6:libinspector.so:elf:73574addbb26ce48}}}
[00001.544] 01046:01049> {{{mmap:0xc42831a4b000:0x6000:load:0x6:r:0}}}
[00001.544] 01046:01049> {{{mmap:0xc42831a51000:0x14000:load:0x6:rx:0x6000}}}
[00001.544] 01046:01049> {{{mmap:0xc42831a65000:0x1000:load:0x6:rw:0x1a000}}}
[00001.544] 01046:01049> {{{mmap:0xc42831a66000:0x37000:load:0x6:rw:0x1b000}}}
[00001.544] 01046:01049> dso: id=73574addbb26ce48 base=0x0000c42831a4b000 name=libinspector.so
[00001.544] 01046:01049> {{{module:0x7:libbacktrace.so:elf:9c1b7a73933a2f9d}}}
[00001.544] 01046:01049> {{{mmap:0xcd2e4ace1000:0x2000:load:0x7:r:0}}}
[00001.544] 01046:01049> {{{mmap:0xcd2e4ace3000:0xa000:load:0x7:rx:0x2000}}}
[00001.544] 01046:01049> {{{mmap:0xcd2e4aced000:0x1000:load:0x7:rw:0xc000}}}
[00001.544] 01046:01049> dso: id=9c1b7a73933a2f9d base=0x0000cd2e4ace1000 name=libbacktrace.so
[00001.544] 01046:01049> {{{module:0x1:libc.so:elf:a6b76763f7ad8ae9}}}
[00001.544] 01046:01049> {{{mmap:0xb8bdd8dad000:0x42000:load:0x1:r:0}}}
[00001.544] 01046:01049> {{{mmap:0xb8bdd8def000:0x53000:load:0x1:rx:0x42000}}}
[00001.544] 01046:01049> {{{mmap:0xb8bdd8e42000:0x2000:load:0x1:rw:0x95000}}}
[00001.544] 01046:01049> {{{mmap:0xb8bdd8e44000:0x3000:load:0x1:rw:0x97000}}}
[00001.544] 01046:01049> dso: id=a6b76763f7ad8ae9 base=0x0000b8bdd8dad000 name=libc.so
[00001.545] 01046:01049> TEST
[00001.588] 01046:01049>
CASE resource_tests [STARTED]
[00001.588] 01046:01049> probe_address_space [RUNNING]
[00001.588] 01046:01049> [PASSED] (0 ms)
[00001.588] 01046:01049> TestBasicActions [RUNNING]
[00001.588] 01046:01049> [PASSED] (0 ms)
[00001.588] 01046:01049> TestExclusiveShared [RUNNING]
[00001.588] 01046:01049> [PASSED] (0 ms)
[00001.588] 01046:01049> TestSharedExclusive [RUNNING]
[00001.588] 01046:01049> [PASSED] (0 ms)
[00001.588] 01046:01049> TestInvalidArgs [RUNNING]
[00001.588] 01046:01049> [PASSED] (0 ms)
[00001.588] 01046:01049> TestVmoCreation [RUNNING]
[00001.588] 01046:01049> [PASSED] (0 ms)
[00001.588] 01046:01049> TestVmoCreationSmaller [RUNNING]
[00001.588] 01046:01049> [PASSED] (0 ms)
[00001.588] 01046:01049> TestVmoCreationUnaligned [RUNNING]
[00001.588] 01046:01049> [PASSED] (0 ms)
[00001.588] 01046:01049> TestVmoReplaceAsExecutable [RUNNING]
[00001.588] 01046:01049> [PASSED] (0 ms)
[00001.588] 01046:01049> CASE resource_tests [PASSED]
[00001.588] 01046:01049>
CASE profile_tests [STARTED]
[00001.588] 01046:01049> make_profile_fails [RUNNING]
[00001.588] 01046:01049> [PASSED] (0 ms)
[00001.588] 01046:01049> change_priority_via_profile [RUNNING]
[00001.609] 01046:01049> [PASSED] (20 ms)
[00001.609] 01046:01049> CASE profile_tests [PASSED]
[00001.609] 01046:01049>
CASE interrupt_tests [STARTED]
[00001.609] 01046:01049> interrupt_test [RUNNING]
[00001.609] 01046:01049> [PASSED] (0 ms)
[00001.609] 01046:01049> interrupt_port_bound_test [RUNNING]
[00001.609] 01046:01049> [PASSED] (0 ms)
[00001.609] 01046:01049> interrupt_port_non_bindable_test [RUNNING]
[00001.609] 01046:01049> [PASSED] (0 ms)
[00001.609] 01046:01049> interrupt_suspend_test [RUNNING]
[00001.617] 01046:01049> [PASSED] (8 ms)
[00001.617] 01046:01049> interrupt_bind_vcpu_test [RUNNING]
[00001.617] 01046:01049> Guest creation not supported
[00001.617] 01046:01049> [PASSED] (0 ms)
[00001.617] 01046:01049> interrupt_bind_vcpu_not_supported_test [RUNNING]
[00001.617] 01046:01049> Guest creation not supported
[00001.617] 01046:01049> [PASSED] (0 ms)
[00001.617] 01046:01049> interrupt_bind_vcpu_already_bound_test [RUNNING]
[00001.617] 01046:01049> Guest creation not supported
[00001.617] 01046:01049> [PASSED] (0 ms)
[00001.617] 01046:01049> interrupt_bind_vcpu_multiple_guests_test [RUNNING]
[00001.617] 01046:01049> Guest creation not supported
[00001.617] 01046:01049> [PASSED] (0 ms)
[00001.617] 01046:01049> CASE interrupt_tests [PASSED]
[00001.617] 01046:01049>
CASE vmo_signal_tests [STARTED]
[00001.617] 01046:01049> vmo_signal_sanity_test [RUNNING]
[00001.617] 01046:01049> [PASSED] (0 ms)
[00001.617] 01046:01049> vmo_child_signal_clone_test [RUNNING]
[00001.617] 01046:01049> [PASSED] (0 ms)
[00001.617] 01046:01049> vmo_child_signal_map_test [RUNNING]
[00001.618] 01046:01049> [PASSED] (0 ms)
[00001.618] 01046:01049> CASE vmo_signal_tests [PASSED]
[00001.618] 01046:01049>
CASE vmar_tests [STARTED]
[00001.618] 01046:01049> destroy_root_test [RUNNING]
[00001.618] 01046:01049> [PASSED] (0 ms)
[00001.618] 01046:01049> basic_allocate_test [RUNNING]
[00001.618] 01046:01049> [PASSED] (0 ms)
[00001.618] 01046:01049> allocate_oob_test [RUNNING]
[00001.618] 01046:01049> [PASSED] (0 ms)
[00001.618] 01046:01049> allocate_unsatisfiable_test [RUNNING]
[00001.618] 01046:01049> [PASSED] (0 ms)
[00001.618] 01046:01049> destroyed_vmar_test [RUNNING]
[00001.618] 01046:01049> [PASSED] (0 ms)
[00001.618] 01046:01049> map_over_destroyed_test [RUNNING]
[00001.618] 01046:01049> [PASSED] (0 ms)
[00001.618] 01046:01049> map_in_compact_test [RUNNING]
[00001.618] 01046:01049> [PASSED] (0 ms)
[00001.618] 01046:01049> overmapping_test [RUNNING]
[00001.618] 01046:01049> [PASSED] (0 ms)
[00001.618] 01046:01049> invalid_args_test [RUNNING]
[00001.618] 01046:01049> [PASSED] (0 ms)
[00001.618] 01046:01049> unaligned_len_test [RUNNING]
[00001.618] 01046:01049> [PASSED] (0 ms)
[00001.618] 01046:01049> unaligned_len_map_test [RUNNING]
[00001.618] 01046:01049> [PASSED] (0 ms)
[00001.618] 01046:01049> rights_drop_test [RUNNING]
[00001.618] 01046:01049> [PASSED] (0 ms)
[00001.618] 01046:01049> protect_test [RUNNING]
[00001.618] 01046:01049> [PASSED] (0 ms)
[00001.618] 01046:01049> nested_region_perms_test [RUNNING]
[00001.618] 01046:01049> [PASSED] (0 ms)
[00001.618] 01046:01049> object_info_test [RUNNING]
[00001.618] 01046:01049> [PASSED] (0 ms)
[00001.618] 01046:01049> unmap_split_test [RUNNING]
[00001.618] 01046:01049> [PASSED] (0 ms)
[00001.618] 01046:01049> unmap_multiple_test [RUNNING]
[00001.619] 01046:01049> [PASSED] (0 ms)
[00001.619] 01046:01049> unmap_base_not_mapped_test [RUNNING]
[00001.619] 01046:01049> [PASSED] (0 ms)
[00001.619] 01046:01049> map_specific_overwrite_test [RUNNING]
[00001.619] 01046:01049> [PASSED] (0 ms)
[00001.619] 01046:01049> protect_split_test [RUNNING]
[00001.619] 01046:01049> [PASSED] (0 ms)
[00001.619] 01046:01049> protect_multiple_test [RUNNING]
[00001.619] 01046:01049> [PASSED] (0 ms)
[00001.619] 01046:01049> protect_over_demand_paged_test [RUNNING]
[00001.672] 01046:01049> [PASSED] (53 ms)
[00001.672] 01046:01049> protect_large_uncommitted_test [RUNNING]
[00001.674] 01046:01049> [PASSED] (1 ms)
[00001.674] 01046:01049> unmap_large_uncommitted_test [RUNNING]
[00001.676] 01046:01282> PageFault: 1030158 free pages
[00001.676] 01046:01282>
[00001.676] 01046:01282> ZIRCON KERNEL PANIC
[00001.676] 01046:01282> Lock validation failed for thread 0xffff000040045e90 pid 1046 tid 1282 (bin/core-tests:vmar_test_addr):
[00001.676] 01046:01282> Reason: Already Acquired
[00001.676] 01046:01282> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00001.676] 01046:01282> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00001.676] 01046:01282> caller=0xffffffff100449c8 frame=0xffff00860a8a9c90
[00001.676] 01046:01282> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00001.676] 01046:01282>
[00001.676] 01046:01282> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00001.676] 01046:01282> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00001.676] 01046:01282> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00001.676] 01046:01282> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00001.676] 01046:01282> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00001.676] 01046:01282> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00001.676] 01046:01282> bt#00: 0xffffffff100449c8
[00001.676] 01046:01282> bt#01: 0xffffffff10044d78
[00001.676] 01046:01282> bt#02: 0xffffffff10031ad4
[00001.676] 01046:01282> bt#03: 0xffffffff100b9f6c
[00001.676] 01046:01282> bt#04: 0xffffffff10095554
[00001.676] 01046:01282> bt#05: 0xffffffff1009447c
[00001.676] 01046:01282> bt#06: end
[00001.676] 01046:01282> {{{bt:0:0xffffffff100449c8}}}
[00001.676] 01046:01282> {{{bt:1:0xffffffff10044d78}}}
[00001.676] 01046:01282> {{{bt:2:0xffffffff10031ad4}}}
[00001.676] 01046:01282> {{{bt:3:0xffffffff100b9f6c}}}
[00001.676] 01046:01282> {{{bt:4:0xffffffff10095554}}}
[00001.676] 01046:01282> {{{bt:5:0xffffffff1009447c}}}
[00001.676] 01046:01282>
[00001.700] 01046:01285> PageFault: 1030158 free pages
[00001.700] 01046:01285>
[00001.700] 01046:01285> ZIRCON KERNEL PANIC
[00001.700] 01046:01285> Lock validation failed for thread 0xffff000040045e90 pid 1046 tid 1285 (bin/core-tests:vmar_test_addr):
[00001.700] 01046:01285> Reason: Already Acquired
[00001.700] 01046:01285> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00001.700] 01046:01285> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00001.700] 01046:01285> caller=0xffffffff100449c8 frame=0xffff00860a8a9c90
[00001.700] 01046:01285> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00001.700] 01046:01285>
[00001.700] 01046:01285> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00001.700] 01046:01285> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00001.700] 01046:01285> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00001.700] 01046:01285> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00001.700] 01046:01285> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00001.700] 01046:01285> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00001.700] 01046:01285> bt#00: 0xffffffff100449c8
[00001.700] 01046:01285> bt#01: 0xffffffff10044d78
[00001.700] 01046:01285> bt#02: 0xffffffff10031ad4
[00001.700] 01046:01285> bt#03: 0xffffffff100b9f6c
[00001.700] 01046:01285> bt#04: 0xffffffff10095554
[00001.700] 01046:01285> bt#05: 0xffffffff1009447c
[00001.700] 01046:01285> bt#06: end
[00001.700] 01046:01285> {{{bt:0:0xffffffff100449c8}}}
[00001.700] 01046:01285> {{{bt:1:0xffffffff10044d78}}}
[00001.700] 01046:01285> {{{bt:2:0xffffffff10031ad4}}}
[00001.700] 01046:01285> {{{bt:3:0xffffffff100b9f6c}}}
[00001.700] 01046:01285> {{{bt:4:0xffffffff10095554}}}
[00001.700] 01046:01285> {{{bt:5:0xffffffff1009447c}}}
[00001.700] 01046:01285>
[00001.724] 01046:01288> PageFault: 1030158 free pages
[00001.724] 01046:01288>
[00001.724] 01046:01288> ZIRCON KERNEL PANIC
[00001.724] 01046:01288> Lock validation failed for thread 0xffff000040045e90 pid 1046 tid 1288 (bin/core-tests:vmar_test_addr):
[00001.724] 01046:01288> Reason: Already Acquired
[00001.724] 01046:01288> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00001.724] 01046:01288> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00001.724] 01046:01288> caller=0xffffffff100449c8 frame=0xffff00860a8a9c90
[00001.724] 01046:01288> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00001.724] 01046:01288>
[00001.724] 01046:01288> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00001.724] 01046:01288> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00001.724] 01046:01288> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00001.724] 01046:01288> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00001.724] 01046:01288> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00001.724] 01046:01288> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00001.724] 01046:01288> bt#00: 0xffffffff100449c8
[00001.724] 01046:01288> bt#01: 0xffffffff10044d78
[00001.724] 01046:01288> bt#02: 0xffffffff10031ad4
[00001.724] 01046:01288> bt#03: 0xffffffff100b9f6c
[00001.724] 01046:01288> bt#04: 0xffffffff10095554
[00001.724] 01046:01288> bt#05: 0xffffffff1009447c
[00001.724] 01046:01288> bt#06: end
[00001.724] 01046:01288> {{{bt:0:0xffffffff100449c8}}}
[00001.724] 01046:01288> {{{bt:1:0xffffffff10044d78}}}
[00001.724] 01046:01288> {{{bt:2:0xffffffff10031ad4}}}
[00001.724] 01046:01288> {{{bt:3:0xffffffff100b9f6c}}}
[00001.724] 01046:01288> {{{bt:4:0xffffffff10095554}}}
[00001.724] 01046:01288> {{{bt:5:0xffffffff1009447c}}}
[00001.724] 01046:01288>
[00001.748] 01046:01049> [PASSED] (73 ms)
[00001.748] 01046:01049> partial_unmap_and_read [RUNNING]
[00001.748] 01046:01049> [PASSED] (0 ms)
[00001.748] 01046:01049> partial_unmap_and_write [RUNNING]
[00001.748] 01046:01049> [PASSED] (0 ms)
[00001.748] 01046:01049> partial_unmap_with_vmar_offset [RUNNING]
[00001.748] 01046:01049> [PASSED] (0 ms)
[00001.748] 01046:01049> CASE vmar_tests [PASSED]
[00001.748] 01046:01049>
CASE ticks_tests [STARTED]
[00001.748] 01046:01049> elapsed_time_using_ticks [RUNNING]
[00001.748] 01046:01049> [PASSED] (0 ms)
[00001.748] 01046:01049> CASE ticks_tests [PASSED]
[00001.748] 01046:01049>
CASE threads_tests [STARTED]
[00001.748] 01046:01049> TestBasics [RUNNING]
[00001.848] 01046:01049> [PASSED] (100 ms)
[00001.848] 01046:01049> TestInvalidRights [RUNNING]
[00001.848] 01046:01049> [PASSED] (0 ms)
[00001.848] 01046:01049> TestDetach [RUNNING]
[00001.851] 01046:01049> [PASSED] (3 ms)
[00001.851] 01046:01049> TestLongNameSucceeds [RUNNING]
[00001.851] 01046:01049> [PASSED] (0 ms)
[00001.851] 01046:01049> TestThreadStartOnInitialThread [RUNNING]
[00001.851] 01046:01049> [PASSED] (0 ms)
[00001.851] 01046:01049> TestThreadStartWithZeroInstructionPointer [RUNNING]
[00001.856] 01046:01049>
[00001.856] 01046:01049> ZIRCON KERNEL PANIC
[00001.856] 01046:01049> Lock validation failed for thread 0xffff00004003af00 pid 1046 tid 1049 (bin/core-tests:bin/core-tests):
[00001.856] 01046:01049> Reason: Out Of Order
[00001.856] 01046:01049> Bad lock: name=lockdep::LockClass<SoloDispatcher<ThreadDispatcher, 316111, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00001.856] 01046:01049> Conflict: name=lockdep::LockClass<SoloDispatcher<ProcessDispatcher, 447439, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00001.856] 01046:01049> caller=0xffffffff1005b570 frame=0xffff00860a899d60
[00001.856] 01046:01049> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00001.856] 01046:01049>
[00001.856] 01046:01049> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00001.856] 01046:01049> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00001.856] 01046:01049> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00001.856] 01046:01049> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00001.856] 01046:01049> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00001.856] 01046:01049> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00001.856] 01046:01049> bt#00: 0xffffffff1005b570
[00001.856] 01046:01049> bt#01: 0xffffffff10051a80
[00001.856] 01046:01049> bt#02: 0xffffffff1005206c
[00001.856] 01046:01049> bt#03: 0xffffffff100d932c
[00001.856] 01046:01049> bt#04: 0xffffffff100e253c
[00001.856] 01046:01049> bt#05: 0xffffffff10094b70
[00001.856] 01046:01049> bt#06: end
[00001.856] 01046:01049> {{{bt:0:0xffffffff1005b570}}}
[00001.856] 01046:01049> {{{bt:1:0xffffffff10051a80}}}
[00001.856] 01046:01049> {{{bt:2:0xffffffff1005206c}}}
[00001.856] 01046:01049> {{{bt:3:0xffffffff100d932c}}}
[00001.856] 01046:01049> {{{bt:4:0xffffffff100e253c}}}
[00001.856] 01046:01049> {{{bt:5:0xffffffff10094b70}}}
[00001.856] 01046:01049>
[00001.880] 01046:01049> [PASSED] (28 ms)
[00001.880] 01046:01049> TestKillBusyThread [RUNNING]
[00001.991] 01046:01049> [PASSED] (111 ms)
[00001.991] 01046:01049> TestKillSleepThread [RUNNING]
[00002.093] 01046:01049> [PASSED] (101 ms)
[00002.093] 01046:01049> TestKillWaitThread [RUNNING]
[00002.195] 01046:01049> [PASSED] (101 ms)
[00002.195] 01046:01049> TestNonstartedThread [RUNNING]
[00002.195] 01046:01049> [PASSED] (0 ms)
[00002.195] 01046:01049> TestThreadKillsItself [RUNNING]
[00002.198] 01046:01049> [PASSED] (3 ms)
[00002.198] 01046:01049> TestInfoTaskStatsFails [RUNNING]
[00002.298] 01046:01049> [PASSED] (100 ms)
[00002.298] 01046:01049> TestResumeSuspended [RUNNING]
[00002.402] 01046:01049> [PASSED] (103 ms)
[00002.402] 01046:01049> TestSuspendSleeping [RUNNING]
[00002.480] 00000:00000> INIT: cpu 3, calling hook 0xffffffff10090bac (arm_generic_timer_init_secondary_cpu) at level 0x7ffff, flags 0x2
[00002.480] 00000:00000> ARM cpu 3: midr 0x431f0af1 'Cavium CN99XX r1p1' mpidr 0x80000003 aff 0:0:0:3
[00002.480] 00000:00000> entering scheduler on cpu 3
[00002.500] 00000:00000> INIT: cpu 1, calling hook 0xffffffff10090bac (arm_generic_timer_init_secondary_cpu) at level 0x7ffff, flags 0x2
[00002.500] 00000:00000> ARM cpu 1: midr 0x431f0af1 'Cavium CN99XX r1p1' mpidr 0x80000001 aff 0:0:0:1
[00002.500] 00000:00000> entering scheduler on cpu 1
[00002.502] 01046:01049> [PASSED] (100 ms)
[00002.502] 01046:01049> TestSuspendChannelCall [RUNNING]
[00002.503] 01046:01049> [PASSED] (0 ms)
[00002.503] 01046:01049> TestSuspendPortCall [RUNNING]
[00002.519] 00000:00000> INIT: cpu 2, calling hook 0xffffffff10090bac (arm_generic_timer_init_secondary_cpu) at level 0x7ffff, flags 0x2
[00002.519] 00000:00000> ARM cpu 2: midr 0x431f0af1 'Cavium CN99XX r1p1' mpidr 0x80000002 aff 0:0:0:2
[00002.519] 00000:00000> entering scheduler on cpu 2
[00002.703] 01046:01049> [PASSED] (200 ms)
[00002.703] 01046:01049> TestSuspendStopsThread [RUNNING]
[00002.753] 01046:01049> [PASSED] (50 ms)
[00002.753] 01046:01049> TestSuspendMultiple [RUNNING]
[00002.753] 01046:01049> [PASSED] (0 ms)
[00002.753] 01046:01049> TestSuspendSelf [RUNNING]
[00002.753] 01046:01049> [PASSED] (0 ms)
[00002.753] 01046:01049> TestKillSuspendedThread [RUNNING]
[00002.753] 01046:01049> [PASSED] (0 ms)
[00002.753] 01046:01049> TestStartSuspendedThread [RUNNING]
[00002.754] 01046:01049> [PASSED] (0 ms)
[00002.754] 01046:01049> TestStartSuspendedAndResumedThread [RUNNING]
[00002.754] 01046:01049> [PASSED] (0 ms)
[00002.754] 01046:01049> TestSuspendSingleWaitAsyncSignalDelivery [RUNNING]
[00002.754] 01046:01049> [PASSED] (0 ms)
[00002.754] 01046:01049> TestSuspendRepeatingWaitAsyncSignalDelivery [RUNNING]
[00002.754] 01046:01049> [PASSED] (0 ms)
[00002.754] 01046:01049> TestReadingGeneralRegisterState [RUNNING]
[00002.854] 01046:01049> [PASSED] (100 ms)
[00002.854] 01046:01049> TestWritingGeneralRegisterState [RUNNING]
[00002.954] 01046:01049> [PASSED] (100 ms)
[00002.954] 01046:01049> TestThreadLocalRegisterState [RUNNING]
[00003.055] 01046:01049> [PASSED] (100 ms)
[00003.055] 01046:01049> TestNoncanonicalRipAddress [RUNNING]
[00003.055] 01046:01049> [PASSED] (0 ms)
[00003.055] 01046:01049> TestWritingArmFlagsRegister [RUNNING]
[00003.055] 01046:01049> [PASSED] (0 ms)
[00003.055] 01046:01049> CASE threads_tests [PASSED]
[00003.055] 01046:01049>
CASE sync_mutex_tests [STARTED]
[00003.055] 01046:01049> test_mutexes [RUNNING]
[00003.063] 01046:01049> [PASSED] (8 ms)
[00003.063] 01046:01049> test_try_mutexes [RUNNING]
[00003.068] 01046:01049> [PASSED] (4 ms)
[00003.068] 01046:01049> test_timeout_elapsed [RUNNING]
[00003.568] 01046:01049> [PASSED] (500 ms)
[00003.568] 01046:01049> CASE sync_mutex_tests [PASSED]
[00003.568] 01046:01049>
CASE sync_condition_tests [STARTED]
[00003.568] 01046:01049> Condition::condition_test [RUNNING]
[00003.569] 01046:01049> [PASSED] (0 ms)
[00003.569] 01046:01049> Condition::condition_timeout_test [RUNNING]
[00003.570] 01046:01049> [PASSED] (1 ms)
[00003.570] 01046:01049> CASE sync_condition_tests [PASSED]
[00003.570] 01046:01049>
CASE sync_completion_tests [STARTED]
[00003.570] 01046:01049> test_initializer [RUNNING]
[00003.570] 01046:01049> [PASSED] (0 ms)
[00003.570] 01046:01049> test_completions [RUNNING]
[00003.581] 01046:01049> [PASSED] (11 ms)
[00003.581] 01046:01049> test_timeout [RUNNING]
[00003.582] 01046:01049> [PASSED] (0 ms)
[00003.582] 01046:01049> CASE sync_completion_tests [PASSED]
[00003.602] 01046:01049>
CASE sync_completion_tests [STARTED]
[00003.602] 01046:01049> test_initializer [RUNNING]
[00003.602] 01046:01049> [PASSED] (0 ms)
[00003.602] 01046:01049> test_completions [RUNNING]
[00003.613] 01046:01049> [PASSED] (11 ms)
[00003.613] 01046:01049> test_timeout [RUNNING]
[00004.632] 01046:01049> [PASSED] (1018 ms)
[00004.632] 01046:01049> test_signal_requeue [RUNNING]
[00004.645] 01046:01049> [PASSED] (12 ms)
[00004.645] 01046:01049> test_completion_signaled [RUNNING]
[00004.645] 01046:01049> [PASSED] (0 ms)
[00004.645] 01046:01049> CASE sync_completion_tests [PASSED]
[00004.645] 01046:01049>
CASE stack_tests [STARTED]
[00004.645] 01046:01049> main_thread_stack_tests [RUNNING]
[00004.645] 01046:01049> [PASSED] (0 ms)
[00004.645] 01046:01049> other_thread_stack_tests [RUNNING]
[00004.645] 01046:01049> [PASSED] (0 ms)
[00004.645] 01046:01049> CASE stack_tests [PASSED]
[00004.645] 01046:01049>
CASE tls_tests [STARTED]
[00004.645] 01046:01049> tls_test [RUNNING]
[00006.652] 01046:01049> [PASSED] (2006 ms)
[00006.652] 01046:01049> CASE tls_tests [PASSED]
[00006.652] 01046:01049>
CASE pthread_barrier_tests [STARTED]
[00006.652] 01046:01049> test_barrier [RUNNING]
[00006.674] 01046:01049> [PASSED] (22 ms)
[00006.674] 01046:01049> CASE pthread_barrier_tests [PASSED]
[00006.674] 01046:01049>
CASE pthread_tests [STARTED]
[00006.674] 01046:01049> pthread_test [RUNNING]
[00009.778] 01046:01049> [PASSED] (3104 ms)
[00009.778] 01046:01049> pthread_self_main_thread_test [RUNNING]
[00009.778] 01046:01049> [PASSED] (0 ms)
[00009.778] 01046:01049> pthread_big_stack_size [RUNNING]
[00009.814] 01046:01049> [PASSED] (35 ms)
[00009.814] 01046:01049> pthread_getstack_main_thread [RUNNING]
[00009.814] 01046:01049> [PASSED] (0 ms)
[00009.814] 01046:01049> pthread_getstack_other_thread [RUNNING]
[00009.814] 01046:01049> [PASSED] (0 ms)
[00009.814] 01046:01049> CASE pthread_tests [PASSED]
[00009.814] 01046:01049>
CASE process_tests [STARTED]
[00009.814] 01046:01049> mini_process_sanity [RUNNING]
[00009.814] 01046:01049> [PASSED] (0 ms)
[00009.814] 01046:01049> process_start_fail [RUNNING]
[00009.814] 01046:01049> [PASSED] (0 ms)
[00009.814] 01046:01049> process_start_no_handle [RUNNING]
[00009.815] 01046:01049> [PASSED] (0 ms)
[00009.815] 01046:01049> process_not_killed_via_thread_close [RUNNING]
[00009.816] 01046:01049> [PASSED] (1 ms)
[00009.816] 01046:01049> process_not_killed_via_process_close [RUNNING]
[00009.817] 01046:01049> [PASSED] (1 ms)
[00009.817] 01046:01049> kill_process_via_thread_kill [RUNNING]
[00009.817] 01046:01049> [PASSED] (0 ms)
[00009.817] 01046:01049> kill_process_via_vmar_destroy [RUNNING]
[00009.817] 02073:02075> PageFault: 1029951 free pages
[00009.817] 02073:02075>
[00009.817] 02073:02075> ZIRCON KERNEL PANIC
[00009.817] 02073:02075> Lock validation failed for thread 0xffff00004005d3d0 pid 2073 tid 2075 (ttp:th):
[00009.817] 02073:02075> Reason: Already Acquired
[00009.817] 02073:02075> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00009.817] 02073:02075> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00009.817] 02073:02075> caller=0xffffffff100449c8 frame=0xffff00860a911c90
[00009.817] 02073:02075> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00009.817] 02073:02075>
[00009.817] 02073:02075> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00009.817] 02073:02075> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00009.817] 02073:02075> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00009.817] 02073:02075> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00009.818] 02073:02075> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00009.818] 02073:02075> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00009.818] 02073:02075> bt#00: 0xffffffff100449c8
[00009.818] 02073:02075> bt#01: 0xffffffff10044d78
[00009.818] 02073:02075> bt#02: 0xffffffff10031ad4
[00009.818] 02073:02075> bt#03: 0xffffffff100b9f6c
[00009.818] 02073:02075> bt#04: 0xffffffff10095188
[00009.818] 02073:02075> bt#05: 0xffffffff1009447c
[00009.818] 02073:02075> bt#06: end
[00009.818] 02073:02075> {{{bt:0:0xffffffff100449c8}}}
[00009.818] 02073:02075> {{{bt:1:0xffffffff10044d78}}}
[00009.818] 02073:02075> {{{bt:2:0xffffffff10031ad4}}}
[00009.818] 02073:02075> {{{bt:3:0xffffffff100b9f6c}}}
[00009.818] 02073:02075> {{{bt:4:0xffffffff10095188}}}
[00009.818] 02073:02075> {{{bt:5:0xffffffff1009447c}}}
[00009.818] 02073:02075>
[00009.818] 01046:01049> [PASSED] (0 ms)
[00009.818] 01046:01049> kill_channel_handle_cycle [RUNNING]
[00010.568] 01046:01049> [PASSED] (750 ms)
[00010.568] 01046:01049> info_reflects_process_state [RUNNING]
[00010.905] 01046:01049> [PASSED] (336 ms)
[00010.905] 01046:01049> suspend [RUNNING]
[00010.905] 01046:01049> [PASSED] (0 ms)
[00010.905] 01046:01049> suspend_self [RUNNING]
[00010.905] 01046:01049> [PASSED] (0 ms)
[00010.905] 01046:01049> suspend_multiple_threads [RUNNING]
[00010.910] 01046:01049> [PASSED] (4 ms)
[00010.910] 01046:01049> suspend_before_creating_threads [RUNNING]
[00010.910] 01046:01049> [PASSED] (0 ms)
[00010.910] 01046:01049> suspend_before_starting_threads [RUNNING]
[00010.910] 01046:01049> [PASSED] (0 ms)
[00010.910] 01046:01049> suspend_process_then_thread [RUNNING]
[00011.160] 01046:01049> [PASSED] (250 ms)
[00011.160] 01046:01049> suspend_thread_then_process [RUNNING]
[00011.410] 01046:01049> [PASSED] (250 ms)
[00011.410] 01046:01049> suspend_thread_and_process_before_starting_process [RUNNING]
[00011.661] 01046:01049> [PASSED] (250 ms)
[00011.661] 01046:01049> suspend_twice [RUNNING]
[00011.911] 01046:01049> [PASSED] (250 ms)
[00011.911] 01046:01049> suspend_twice_before_creating_threads [RUNNING]
[00012.161] 01046:01049> [PASSED] (250 ms)
[00012.161] 01046:01049> suspend_with_dying_thread [RUNNING]
[00012.163] 01046:01049> [PASSED] (1 ms)
[00012.163] 01046:01049> create_and_kill_job_race_stress [RUNNING]
[00013.164] 01046:01049> [PASSED] (1000 ms)
[00013.164] 01046:01049> CASE process_tests [PASSED]
[00013.164] 01046:01049>
CASE port_tests [STARTED]
[00013.164] 01046:01049> basic_test [RUNNING]
[00013.164] 01046:01049> [PASSED] (0 ms)
[00013.164] 01046:01049> queue_and_close_test [RUNNING]
[00013.164] 01046:01049> [PASSED] (0 ms)
[00013.164] 01046:01049> queue_too_many [RUNNING]
[00013.165] 01046:01049> [PASSED] (1 ms)
[00013.165] 01046:01049> async_wait_channel_test [RUNNING]
[00013.167] 01046:01049> [PASSED] (1 ms)
[00013.167] 01046:01049> async_wait_event_test_single [RUNNING]
[00013.167] 01046:01049> [PASSED] (0 ms)
[00013.167] 01046:01049> async_wait_event_test_repeat [RUNNING]
[00013.167] 01046:01049> [PASSED] (0 ms)
[00013.167] 01046:01049> async_wait_event_all_processed [RUNNING]
[00013.243] 01046:01049> [PASSED] (76 ms)
[00013.243] 01046:01049> async_wait_invalid_option [RUNNING]
[00013.243] 01046:01049> [PASSED] (0 ms)
[00013.243] 01046:01049> async_wait_close_order_1 [RUNNING]
[00013.243] 01046:01049> [PASSED] (0 ms)
[00013.243] 01046:01049> async_wait_close_order_2 [RUNNING]
[00013.243] 01046:01049> [PASSED] (0 ms)
[00013.243] 01046:01049> async_wait_close_order_3 [RUNNING]
[00013.243] 01046:01049> [PASSED] (0 ms)
[00013.243] 01046:01049> async_wait_close_order_4 [RUNNING]
[00013.243] 01046:01049> [PASSED] (0 ms)
[00013.243] 01046:01049> async_wait_close_order_5 [RUNNING]
[00013.243] 01046:01049> [PASSED] (0 ms)
[00013.243] 01046:01049> async_wait_close_order_6 [RUNNING]
[00013.243] 01046:01049> [PASSED] (0 ms)
[00013.243] 01046:01049> channel_pre_writes_test [RUNNING]
[00013.243] 01046:01049> [PASSED] (0 ms)
[00013.243] 01046:01049> cancel_event_key [RUNNING]
[00013.243] 01046:01049> [PASSED] (0 ms)
[00013.243] 01046:01049> cancel_event_key_after [RUNNING]
[00013.243] 01046:01049> [PASSED] (0 ms)
[00013.243] 01046:01049> threads_event [RUNNING]
[00013.246] 01046:01049> [PASSED] (2 ms)
[00013.246] 01046:01049> cancel_stress [RUNNING]
[00013.506] 01046:01049> [PASSED] (259 ms)
[00013.506] 01046:01049> signal_close_stress [RUNNING]
[00014.511] 01046:01049> [PASSED] (1004 ms)
[00014.511] 01046:01049> port_close_wait_race_stress [RUNNING]
[00015.512] 01046:01049> [PASSED] (1000 ms)
[00015.512] 01046:01049> CASE port_tests [PASSED]
[00015.512] 01046:01049>
CASE api_violations [STARTED]
[00015.512] 01046:01049> invalid_pager_create [RUNNING]
[00015.512] 01046:01049> [PASSED] (0 ms)
[00015.512] 01046:01049> invalid_pager_create_vmo [RUNNING]
[00015.512] 01046:01049> [PASSED] (0 ms)
[00015.512] 01046:01049> invalid_pager_detach_vmo [RUNNING]
[00015.512] 01046:01049> [PASSED] (0 ms)
[00015.512] 01046:01049> invalid_pager_supply_pages [RUNNING]
[00015.512] 01046:01049> [PASSED] (0 ms)
[00015.512] 01046:01049> resize_nonresizable_vmo [RUNNING]
[00015.512] 01046:01049> [PASSED] (0 ms)
[00015.512] 01046:01049> CASE api_violations [PASSED]
[00015.512] 01046:01049>
CASE commit_tests [STARTED]
[00015.512] 01046:01049> simple_commit_test [RUNNING]
[00015.516] 01046:01049> [PASSED] (3 ms)
[00015.516] 01046:01049> split_commit_test [RUNNING]
[00015.516] 01046:01049> [PASSED] (0 ms)
[00015.516] 01046:01049> overlap_commit_test [RUNNING]
[00015.517] 01046:01049> [PASSED] (0 ms)
[00015.517] 01046:01049> overlap_commit_supply_test [RUNNING]
[00015.533] 01046:01049> [PASSED] (16 ms)
[00015.533] 01046:01049> multisupply_commit_test [RUNNING]
[00015.533] 01046:01049> [PASSED] (0 ms)
[00015.533] 01046:01049> multicommit_supply_test [RUNNING]
[00015.534] 01046:01049> [PASSED] (0 ms)
[00015.534] 01046:01049> commit_redundant_supply_test [RUNNING]
[00015.534] 01046:01049> [PASSED] (0 ms)
[00015.534] 01046:01049> supply_decommit_test [RUNNING]
[00015.535] 01046:01049> [PASSED] (0 ms)
[00015.535] 01046:01049> resize_commit_test [RUNNING]
[00015.535] 01046:01049> [PASSED] (0 ms)
[00015.535] 01046:01049> suspend_commit_test [RUNNING]
[00015.535] 01046:01049> [PASSED] (0 ms)
[00015.535] 01046:01049> CASE commit_tests [PASSED]
[00015.535] 01046:01049>
CASE clone_tests [STARTED]
[00015.535] 01046:01049> clone_read_from_clone_test_vmar [RUNNING]
[00015.535] 01046:01049> [PASSED] (0 ms)
[00015.535] 01046:01049> clone_read_from_clone_test_vmo [RUNNING]
[00015.536] 01046:01049> [PASSED] (0 ms)
[00015.536] 01046:01049> clone_read_from_parent_test_vmar [RUNNING]
[00015.536] 01046:01049> [PASSED] (0 ms)
[00015.536] 01046:01049> clone_read_from_parent_test_vmo [RUNNING]
[00015.536] 01046:01049> [PASSED] (0 ms)
[00015.536] 01046:01049> clone_simultaneous_read_test_vmar [RUNNING]
[00015.537] 01046:01049> [PASSED] (0 ms)
[00015.537] 01046:01049> clone_simultaneous_read_test_vmo [RUNNING]
[00015.537] 01046:01049> [PASSED] (0 ms)
[00015.537] 01046:01049> clone_simultaneous_child_read_test_vmar [RUNNING]
[00015.538] 01046:01049> [PASSED] (0 ms)
[00015.538] 01046:01049> clone_simultaneous_child_read_test_vmo [RUNNING]
[00015.538] 01046:01049> [PASSED] (0 ms)
[00015.538] 01046:01049> clone_write_to_clone_test [RUNNING]
[00015.538] 01046:01049> [PASSED] (0 ms)
[00015.538] 01046:01049> clone_detach_test [RUNNING]
[00015.539] 01046:01049> [PASSED] (0 ms)
[00015.539] 01046:01049> clone_commit_test [RUNNING]
[00015.539] 01046:01049> [PASSED] (0 ms)
[00015.539] 01046:01049> clone_split_commit_test [RUNNING]
[00015.539] 01046:01049> [PASSED] (0 ms)
[00015.539] 01046:01049> clone_decommit_test [RUNNING]
[00015.539] 01046:01049> [PASSED] (0 ms)
[00015.539] 01046:01049> CASE clone_tests [PASSED]
[00015.539] 01046:01049>
CASE lifecycle_tests [STARTED]
[00015.539] 01046:01049> vmo_info_pager_test [RUNNING]
[00015.539] 01046:01049> [PASSED] (0 ms)
[00015.539] 01046:01049> detach_page_complete_test [RUNNING]
[00015.539] 01046:01049> [PASSED] (0 ms)
[00015.539] 01046:01049> close_page_complete_test [RUNNING]
[00015.539] 01046:01049> [PASSED] (0 ms)
[00015.539] 01046:01049> read_detach_interrupt_late_test_vmar [RUNNING]
[00015.540] 01046:66413> PageFault: 1028268 free pages
[00015.540] 01046:66413>
[00015.540] 01046:66413> ZIRCON KERNEL PANIC
[00015.540] 01046:66413> Lock validation failed for thread 0xffff00004005d898 pid 1046 tid 66413 (bin/core-tests:test_thread):
[00015.540] 01046:66413> Reason: Already Acquired
[00015.540] 01046:66413> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.540] 01046:66413> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.540] 01046:66413> caller=0xffffffff100449c8 frame=0xffff00860a911c90
[00015.540] 01046:66413> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00015.540] 01046:66413>
[00015.540] 01046:66413> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00015.540] 01046:66413> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00015.540] 01046:66413> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00015.540] 01046:66413> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00015.540] 01046:66413> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00015.540] 01046:66413> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00015.540] 01046:66413> bt#00: 0xffffffff100449c8
[00015.540] 01046:66413> bt#01: 0xffffffff10044d78
[00015.540] 01046:66413> bt#02: 0xffffffff10031ad4
[00015.540] 01046:66413> bt#03: 0xffffffff100b9f6c
[00015.540] 01046:66413> bt#04: 0xffffffff10095554
[00015.540] 01046:66413> bt#05: 0xffffffff1009447c
[00015.540] 01046:66413> bt#06: end
[00015.540] 01046:66413> {{{bt:0:0xffffffff100449c8}}}
[00015.540] 01046:66413> {{{bt:1:0xffffffff10044d78}}}
[00015.540] 01046:66413> {{{bt:2:0xffffffff10031ad4}}}
[00015.540] 01046:66413> {{{bt:3:0xffffffff100b9f6c}}}
[00015.540] 01046:66413> {{{bt:4:0xffffffff10095554}}}
[00015.540] 01046:66413> {{{bt:5:0xffffffff1009447c}}}
[00015.540] 01046:66413>
[00015.540] 01046:66413>
[00015.540] 01046:66413> ZIRCON KERNEL PANIC
[00015.540] 01046:66413> Lock validation failed for thread 0xffff00004005d898 pid 1046 tid 66413 (bin/core-tests:test_thread):
[00015.540] 01046:66413> Reason: Already Acquired
[00015.540] 01046:66413> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.540] 01046:66413> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.540] 01046:66413> caller=0xffffffff100449c8 frame=0xffff00860a911bf0
[00015.540] 01046:66413> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00015.540] 01046:66413>
[00015.540] 01046:66413> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00015.540] 01046:66413> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00015.540] 01046:66413> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00015.540] 01046:66413> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00015.540] 01046:66413> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00015.540] 01046:66413> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00015.540] 01046:66413> bt#00: 0xffffffff100449c8
[00015.540] 01046:66413> bt#01: 0xffffffff10044d78
[00015.540] 01046:66413> bt#02: 0xffffffff10044d78
[00015.540] 01046:66413> bt#03: 0xffffffff10031ad4
[00015.540] 01046:66413> bt#04: 0xffffffff100b9f6c
[00015.540] 01046:66413> bt#05: 0xffffffff10095554
[00015.540] 01046:66413> bt#06: 0xffffffff1009447c
[00015.540] 01046:66413> bt#07: end
[00015.540] 01046:66413> {{{bt:0:0xffffffff100449c8}}}
[00015.540] 01046:66413> {{{bt:1:0xffffffff10044d78}}}
[00015.540] 01046:66413> {{{bt:2:0xffffffff10044d78}}}
[00015.540] 01046:66413> {{{bt:3:0xffffffff10031ad4}}}
[00015.540] 01046:66413> {{{bt:4:0xffffffff100b9f6c}}}
[00015.540] 01046:66413> {{{bt:5:0xffffffff10095554}}}
[00015.540] 01046:66413> {{{bt:6:0xffffffff1009447c}}}
[00015.540] 01046:66413>
[00015.540] 01046:66413>
[00015.540] 01046:66413> ZIRCON KERNEL PANIC
[00015.540] 01046:66413> Lock validation failed for thread 0xffff00004005d898 pid 1046 tid 66413 (bin/core-tests:test_thread):
[00015.540] 01046:66413> Reason: Already Acquired
[00015.540] 01046:66413> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.540] 01046:66413> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.540] 01046:66413> caller=0xffffffff100449c8 frame=0xffff00860a911bf0
[00015.540] 01046:66413> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00015.540] 01046:66413>
[00015.540] 01046:66413> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00015.540] 01046:66413> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00015.540] 01046:66413> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00015.540] 01046:66413> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00015.540] 01046:66413> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00015.540] 01046:66413> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00015.540] 01046:66413> bt#00: 0xffffffff100449c8
[00015.540] 01046:66413> bt#01: 0xffffffff10044d78
[00015.540] 01046:66413> bt#02: 0xffffffff10044d78
[00015.540] 01046:66413> bt#03: 0xffffffff10031ad4
[00015.540] 01046:66413> bt#04: 0xffffffff100b9f6c
[00015.540] 01046:66413> bt#05: 0xffffffff10095554
[00015.540] 01046:66413> bt#06: 0xffffffff1009447c
[00015.540] 01046:66413> bt#07: end
[00015.540] 01046:66413> {{{bt:0:0xffffffff100449c8}}}
[00015.540] 01046:66413> {{{bt:1:0xffffffff10044d78}}}
[00015.540] 01046:66413> {{{bt:2:0xffffffff10044d78}}}
[00015.540] 01046:66413> {{{bt:3:0xffffffff10031ad4}}}
[00015.540] 01046:66413> {{{bt:4:0xffffffff100b9f6c}}}
[00015.540] 01046:66413> {{{bt:5:0xffffffff10095554}}}
[00015.540] 01046:66413> {{{bt:6:0xffffffff1009447c}}}
[00015.540] 01046:66413>
[00015.540] 01046:01049> [PASSED] (0 ms)
[00015.540] 01046:01049> read_detach_interrupt_late_test_vmo [RUNNING]
[00015.540] 01046:01049> [PASSED] (0 ms)
[00015.540] 01046:01049> read_close_interrupt_late_test_vmar [RUNNING]
[00015.540] 01046:66433> PageFault: 1028268 free pages
[00015.540] 01046:66433>
[00015.540] 01046:66433> ZIRCON KERNEL PANIC
[00015.540] 01046:66433> Lock validation failed for thread 0xffff00004005d898 pid 1046 tid 66433 (bin/core-tests:test_thread):
[00015.540] 01046:66433> Reason: Already Acquired
[00015.540] 01046:66433> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.540] 01046:66433> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.540] 01046:66433> caller=0xffffffff100449c8 frame=0xffff00860a911c90
[00015.540] 01046:66433> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00015.540] 01046:66433>
[00015.540] 01046:66433> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00015.540] 01046:66433> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00015.540] 01046:66433> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00015.540] 01046:66433> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00015.540] 01046:66433> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00015.540] 01046:66433> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00015.540] 01046:66433> bt#00: 0xffffffff100449c8
[00015.540] 01046:66433> bt#01: 0xffffffff10044d78
[00015.540] 01046:66433> bt#02: 0xffffffff10031ad4
[00015.540] 01046:66433> bt#03: 0xffffffff100b9f6c
[00015.540] 01046:66433> bt#04: 0xffffffff10095554
[00015.540] 01046:66433> bt#05: 0xffffffff1009447c
[00015.540] 01046:66433> bt#06: end
[00015.540] 01046:66433> {{{bt:0:0xffffffff100449c8}}}
[00015.540] 01046:66433> {{{bt:1:0xffffffff10044d78}}}
[00015.540] 01046:66433> {{{bt:2:0xffffffff10031ad4}}}
[00015.540] 01046:66433> {{{bt:3:0xffffffff100b9f6c}}}
[00015.540] 01046:66433> {{{bt:4:0xffffffff10095554}}}
[00015.540] 01046:66433> {{{bt:5:0xffffffff1009447c}}}
[00015.540] 01046:66433>
[00015.540] 01046:66433>
[00015.540] 01046:66433> ZIRCON KERNEL PANIC
[00015.540] 01046:66433> Lock validation failed for thread 0xffff00004005d898 pid 1046 tid 66433 (bin/core-tests:test_thread):
[00015.540] 01046:66433> Reason: Already Acquired
[00015.540] 01046:66433> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.540] 01046:66433> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.540] 01046:66433> caller=0xffffffff100449c8 frame=0xffff00860a911bf0
[00015.540] 01046:66433> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00015.540] 01046:66433>
[00015.540] 01046:66433> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00015.540] 01046:66433> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00015.540] 01046:66433> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00015.540] 01046:66433> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00015.541] 01046:66433> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00015.541] 01046:66433> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00015.541] 01046:66433> bt#00: 0xffffffff100449c8
[00015.541] 01046:66433> bt#01: 0xffffffff10044d78
[00015.541] 01046:66433> bt#02: 0xffffffff10044d78
[00015.541] 01046:66433> bt#03: 0xffffffff10031ad4
[00015.541] 01046:66433> bt#04: 0xffffffff100b9f6c
[00015.541] 01046:66433> bt#05: 0xffffffff10095554
[00015.541] 01046:66433> bt#06: 0xffffffff1009447c
[00015.541] 01046:66433> bt#07: end
[00015.541] 01046:66433> {{{bt:0:0xffffffff100449c8}}}
[00015.541] 01046:66433> {{{bt:1:0xffffffff10044d78}}}
[00015.541] 01046:66433> {{{bt:2:0xffffffff10044d78}}}
[00015.541] 01046:66433> {{{bt:3:0xffffffff10031ad4}}}
[00015.541] 01046:66433> {{{bt:4:0xffffffff100b9f6c}}}
[00015.541] 01046:66433> {{{bt:5:0xffffffff10095554}}}
[00015.541] 01046:66433> {{{bt:6:0xffffffff1009447c}}}
[00015.541] 01046:66433>
[00015.541] 01046:66433>
[00015.541] 01046:66433> ZIRCON KERNEL PANIC
[00015.541] 01046:66433> Lock validation failed for thread 0xffff00004005d898 pid 1046 tid 66433 (bin/core-tests:test_thread):
[00015.541] 01046:66433> Reason: Already Acquired
[00015.541] 01046:66433> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.541] 01046:66433> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.541] 01046:66433> caller=0xffffffff100449c8 frame=0xffff00860a911bf0
[00015.541] 01046:66433> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00015.541] 01046:66433>
[00015.541] 01046:66433> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00015.541] 01046:66433> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00015.541] 01046:66433> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00015.541] 01046:66433> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00015.541] 01046:66433> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00015.541] 01046:66433> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00015.541] 01046:66433> bt#00: 0xffffffff100449c8
[00015.541] 01046:66433> bt#01: 0xffffffff10044d78
[00015.541] 01046:66433> bt#02: 0xffffffff10044d78
[00015.541] 01046:66433> bt#03: 0xffffffff10031ad4
[00015.541] 01046:66433> bt#04: 0xffffffff100b9f6c
[00015.541] 01046:66433> bt#05: 0xffffffff10095554
[00015.541] 01046:66433> bt#06: 0xffffffff1009447c
[00015.541] 01046:66433> bt#07: end
[00015.541] 01046:66433> {{{bt:0:0xffffffff100449c8}}}
[00015.541] 01046:66433> {{{bt:1:0xffffffff10044d78}}}
[00015.541] 01046:66433> {{{bt:2:0xffffffff10044d78}}}
[00015.541] 01046:66433> {{{bt:3:0xffffffff10031ad4}}}
[00015.541] 01046:66433> {{{bt:4:0xffffffff100b9f6c}}}
[00015.541] 01046:66433> {{{bt:5:0xffffffff10095554}}}
[00015.541] 01046:66433> {{{bt:6:0xffffffff1009447c}}}
[00015.541] 01046:66433>
[00015.541] 01046:01049> [PASSED] (0 ms)
[00015.541] 01046:01049> read_close_interrupt_late_test_vmo [RUNNING]
[00015.541] 01046:01049> [PASSED] (0 ms)
[00015.541] 01046:01049> read_detach_interrupt_early_test_vmar [RUNNING]
[00015.541] 01046:66453> PageFault: 1028269 free pages
[00015.541] 01046:66453>
[00015.541] 01046:66453> ZIRCON KERNEL PANIC
[00015.541] 01046:66453> Lock validation failed for thread 0xffff00004005d898 pid 1046 tid 66453 (bin/core-tests:test_thread):
[00015.541] 01046:66453> Reason: Already Acquired
[00015.541] 01046:66453> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.541] 01046:66453> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.541] 01046:66453> caller=0xffffffff100449c8 frame=0xffff00860a911c90
[00015.541] 01046:66453> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00015.541] 01046:66453>
[00015.541] 01046:66453> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00015.541] 01046:66453> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00015.541] 01046:66453> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00015.541] 01046:66453> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00015.541] 01046:66453> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00015.541] 01046:66453> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00015.541] 01046:66453> bt#00: 0xffffffff100449c8
[00015.541] 01046:66453> bt#01: 0xffffffff10044d78
[00015.541] 01046:66453> bt#02: 0xffffffff10031ad4
[00015.541] 01046:66453> bt#03: 0xffffffff100b9f6c
[00015.541] 01046:66453> bt#04: 0xffffffff10095554
[00015.541] 01046:66453> bt#05: 0xffffffff1009447c
[00015.541] 01046:66453> bt#06: end
[00015.541] 01046:66453> {{{bt:0:0xffffffff100449c8}}}
[00015.541] 01046:66453> {{{bt:1:0xffffffff10044d78}}}
[00015.541] 01046:66453> {{{bt:2:0xffffffff10031ad4}}}
[00015.541] 01046:66453> {{{bt:3:0xffffffff100b9f6c}}}
[00015.541] 01046:66453> {{{bt:4:0xffffffff10095554}}}
[00015.541] 01046:66453> {{{bt:5:0xffffffff1009447c}}}
[00015.541] 01046:66453>
[00015.541] 01046:66453>
[00015.541] 01046:66453> ZIRCON KERNEL PANIC
[00015.541] 01046:66453> Lock validation failed for thread 0xffff00004005d898 pid 1046 tid 66453 (bin/core-tests:test_thread):
[00015.541] 01046:66453> Reason: Already Acquired
[00015.541] 01046:66453> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.541] 01046:66453> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.541] 01046:66453> caller=0xffffffff100449c8 frame=0xffff00860a911bf0
[00015.541] 01046:66453> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00015.541] 01046:66453>
[00015.541] 01046:66453> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00015.541] 01046:66453> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00015.541] 01046:66453> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00015.541] 01046:66453> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00015.541] 01046:66453> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00015.541] 01046:66453> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00015.541] 01046:66453> bt#00: 0xffffffff100449c8
[00015.541] 01046:66453> bt#01: 0xffffffff10044d78
[00015.541] 01046:66453> bt#02: 0xffffffff10044d78
[00015.541] 01046:66453> bt#03: 0xffffffff10031ad4
[00015.541] 01046:66453> bt#04: 0xffffffff100b9f6c
[00015.541] 01046:66453> bt#05: 0xffffffff10095554
[00015.541] 01046:66453> bt#06: 0xffffffff1009447c
[00015.541] 01046:66453> bt#07: end
[00015.541] 01046:66453> {{{bt:0:0xffffffff100449c8}}}
[00015.541] 01046:66453> {{{bt:1:0xffffffff10044d78}}}
[00015.541] 01046:66453> {{{bt:2:0xffffffff10044d78}}}
[00015.541] 01046:66453> {{{bt:3:0xffffffff10031ad4}}}
[00015.541] 01046:66453> {{{bt:4:0xffffffff100b9f6c}}}
[00015.541] 01046:66453> {{{bt:5:0xffffffff10095554}}}
[00015.541] 01046:66453> {{{bt:6:0xffffffff1009447c}}}
[00015.541] 01046:66453>
[00015.541] 01046:66453>
[00015.541] 01046:66453> ZIRCON KERNEL PANIC
[00015.541] 01046:66453> Lock validation failed for thread 0xffff00004005d898 pid 1046 tid 66453 (bin/core-tests:test_thread):
[00015.541] 01046:66453> Reason: Already Acquired
[00015.541] 01046:66453> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.541] 01046:66453> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.541] 01046:66453> caller=0xffffffff100449c8 frame=0xffff00860a911bf0
[00015.541] 01046:66453> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00015.541] 01046:66453>
[00015.541] 01046:66453> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00015.541] 01046:66453> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00015.541] 01046:66453> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00015.541] 01046:66453> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00015.541] 01046:66453> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00015.541] 01046:66453> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00015.541] 01046:66453> bt#00: 0xffffffff100449c8
[00015.541] 01046:66453> bt#01: 0xffffffff10044d78
[00015.541] 01046:66453> bt#02: 0xffffffff10044d78
[00015.541] 01046:66453> bt#03: 0xffffffff10031ad4
[00015.541] 01046:66453> bt#04: 0xffffffff100b9f6c
[00015.541] 01046:66453> bt#05: 0xffffffff10095554
[00015.541] 01046:66453> bt#06: 0xffffffff1009447c
[00015.541] 01046:66453> bt#07: end
[00015.541] 01046:66453> {{{bt:0:0xffffffff100449c8}}}
[00015.541] 01046:66453> {{{bt:1:0xffffffff10044d78}}}
[00015.541] 01046:66453> {{{bt:2:0xffffffff10044d78}}}
[00015.541] 01046:66453> {{{bt:3:0xffffffff10031ad4}}}
[00015.541] 01046:66453> {{{bt:4:0xffffffff100b9f6c}}}
[00015.541] 01046:66453> {{{bt:5:0xffffffff10095554}}}
[00015.541] 01046:66453> {{{bt:6:0xffffffff1009447c}}}
[00015.541] 01046:66453>
[00015.541] 01046:01049> [PASSED] (0 ms)
[00015.541] 01046:01049> read_detach_interrupt_early_test_vmo [RUNNING]
[00015.542] 01046:01049> [PASSED] (0 ms)
[00015.542] 01046:01049> read_close_interrupt_early_test_vmar [RUNNING]
[00015.542] 01046:66473> PageFault: 1028269 free pages
[00015.542] 01046:66473>
[00015.542] 01046:66473> ZIRCON KERNEL PANIC
[00015.542] 01046:66473> Lock validation failed for thread 0xffff00004005d898 pid 1046 tid 66473 (bin/core-tests:test_thread):
[00015.542] 01046:66473> Reason: Already Acquired
[00015.542] 01046:66473> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.542] 01046:66473> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.542] 01046:66473> caller=0xffffffff100449c8 frame=0xffff00860a911c90
[00015.542] 01046:66473> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00015.542] 01046:66473>
[00015.542] 01046:66473> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00015.542] 01046:66473> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00015.542] 01046:66473> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00015.542] 01046:66473> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00015.542] 01046:66473> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00015.542] 01046:66473> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00015.542] 01046:66473> bt#00: 0xffffffff100449c8
[00015.542] 01046:66473> bt#01: 0xffffffff10044d78
[00015.542] 01046:66473> bt#02: 0xffffffff10031ad4
[00015.542] 01046:66473> bt#03: 0xffffffff100b9f6c
[00015.542] 01046:66473> bt#04: 0xffffffff10095554
[00015.542] 01046:66473> bt#05: 0xffffffff1009447c
[00015.542] 01046:66473> bt#06: end
[00015.542] 01046:66473> {{{bt:0:0xffffffff100449c8}}}
[00015.542] 01046:66473> {{{bt:1:0xffffffff10044d78}}}
[00015.542] 01046:66473> {{{bt:2:0xffffffff10031ad4}}}
[00015.542] 01046:66473> {{{bt:3:0xffffffff100b9f6c}}}
[00015.542] 01046:66473> {{{bt:4:0xffffffff10095554}}}
[00015.542] 01046:66473> {{{bt:5:0xffffffff1009447c}}}
[00015.542] 01046:66473>
[00015.542] 01046:66473>
[00015.542] 01046:66473> ZIRCON KERNEL PANIC
[00015.542] 01046:66473> Lock validation failed for thread 0xffff00004005d898 pid 1046 tid 66473 (bin/core-tests:test_thread):
[00015.542] 01046:66473> Reason: Already Acquired
[00015.542] 01046:66473> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.542] 01046:66473> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.542] 01046:66473> caller=0xffffffff100449c8 frame=0xffff00860a911bf0
[00015.542] 01046:66473> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00015.542] 01046:66473>
[00015.542] 01046:66473> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00015.542] 01046:66473> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00015.542] 01046:66473> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00015.542] 01046:66473> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00015.542] 01046:66473> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00015.542] 01046:66473> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00015.542] 01046:66473> bt#00: 0xffffffff100449c8
[00015.542] 01046:66473> bt#01: 0xffffffff10044d78
[00015.542] 01046:66473> bt#02: 0xffffffff10044d78
[00015.542] 01046:66473> bt#03: 0xffffffff10031ad4
[00015.542] 01046:66473> bt#04: 0xffffffff100b9f6c
[00015.542] 01046:66473> bt#05: 0xffffffff10095554
[00015.542] 01046:66473> bt#06: 0xffffffff1009447c
[00015.542] 01046:66473> bt#07: end
[00015.542] 01046:66473> {{{bt:0:0xffffffff100449c8}}}
[00015.542] 01046:66473> {{{bt:1:0xffffffff10044d78}}}
[00015.542] 01046:66473> {{{bt:2:0xffffffff10044d78}}}
[00015.542] 01046:66473> {{{bt:3:0xffffffff10031ad4}}}
[00015.542] 01046:66473> {{{bt:4:0xffffffff100b9f6c}}}
[00015.542] 01046:66473> {{{bt:5:0xffffffff10095554}}}
[00015.542] 01046:66473> {{{bt:6:0xffffffff1009447c}}}
[00015.542] 01046:66473>
[00015.542] 01046:66473>
[00015.542] 01046:66473> ZIRCON KERNEL PANIC
[00015.542] 01046:66473> Lock validation failed for thread 0xffff00004005d898 pid 1046 tid 66473 (bin/core-tests:test_thread):
[00015.542] 01046:66473> Reason: Already Acquired
[00015.542] 01046:66473> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.542] 01046:66473> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.542] 01046:66473> caller=0xffffffff100449c8 frame=0xffff00860a911bf0
[00015.542] 01046:66473> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00015.542] 01046:66473>
[00015.542] 01046:66473> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00015.542] 01046:66473> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00015.542] 01046:66473> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00015.542] 01046:66473> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00015.542] 01046:66473> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00015.542] 01046:66473> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00015.542] 01046:66473> bt#00: 0xffffffff100449c8
[00015.542] 01046:66473> bt#01: 0xffffffff10044d78
[00015.542] 01046:66473> bt#02: 0xffffffff10044d78
[00015.542] 01046:66473> bt#03: 0xffffffff10031ad4
[00015.542] 01046:66473> bt#04: 0xffffffff100b9f6c
[00015.542] 01046:66473> bt#05: 0xffffffff10095554
[00015.542] 01046:66473> bt#06: 0xffffffff1009447c
[00015.542] 01046:66473> bt#07: end
[00015.542] 01046:66473> {{{bt:0:0xffffffff100449c8}}}
[00015.542] 01046:66473> {{{bt:1:0xffffffff10044d78}}}
[00015.542] 01046:66473> {{{bt:2:0xffffffff10044d78}}}
[00015.542] 01046:66473> {{{bt:3:0xffffffff10031ad4}}}
[00015.542] 01046:66473> {{{bt:4:0xffffffff100b9f6c}}}
[00015.542] 01046:66473> {{{bt:5:0xffffffff10095554}}}
[00015.542] 01046:66473> {{{bt:6:0xffffffff1009447c}}}
[00015.542] 01046:66473>
[00015.542] 01046:01049> [PASSED] (0 ms)
[00015.542] 01046:01049> read_close_interrupt_early_test_vmo [RUNNING]
[00015.543] 01046:01049> [PASSED] (0 ms)
[00015.543] 01046:01049> thread_kill_test_vmar [RUNNING]
[00015.543] 01046:01049> [PASSED] (0 ms)
[00015.543] 01046:01049> thread_kill_test_vmo [RUNNING]
[00015.544] 01046:01049> [PASSED] (0 ms)
[00015.544] 01046:01049> thread_kill_overlap_test_vmar [RUNNING]
[00015.544] 01046:01049> [PASSED] (0 ms)
[00015.544] 01046:01049> thread_kill_overlap_test_vmo [RUNNING]
[00015.545] 01046:01049> [PASSED] (0 ms)
[00015.545] 01046:01049> close_pager_test [RUNNING]
[00015.545] 01046:66564> PageFault: 1028191 free pages
[00015.545] 01046:66564>
[00015.545] 01046:66564> ZIRCON KERNEL PANIC
[00015.545] 01046:66564> Lock validation failed for thread 0xffff00004298d6e0 pid 1046 tid 66564 (bin/core-tests:test_thread):
[00015.545] 01046:66564> Reason: Already Acquired
[00015.545] 01046:66564> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.545] 01046:66564> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.545] 01046:66564> caller=0xffffffff100449c8 frame=0xffff00860a931c90
[00015.545] 01046:66564> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00015.545] 01046:66564>
[00015.545] 01046:66564> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00015.545] 01046:66564> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00015.545] 01046:66564> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00015.545] 01046:66564> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00015.545] 01046:66564> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00015.545] 01046:66564> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00015.545] 01046:66564> bt#00: 0xffffffff100449c8
[00015.545] 01046:66564> bt#01: 0xffffffff10044d78
[00015.545] 01046:66564> bt#02: 0xffffffff10031ad4
[00015.545] 01046:66564> bt#03: 0xffffffff100b9f6c
[00015.545] 01046:66564> bt#04: 0xffffffff10095554
[00015.545] 01046:66564> bt#05: 0xffffffff1009447c
[00015.545] 01046:66564> bt#06: end
[00015.545] 01046:66564> {{{bt:0:0xffffffff100449c8}}}
[00015.545] 01046:66564> {{{bt:1:0xffffffff10044d78}}}
[00015.545] 01046:66564> {{{bt:2:0xffffffff10031ad4}}}
[00015.545] 01046:66564> {{{bt:3:0xffffffff100b9f6c}}}
[00015.545] 01046:66564> {{{bt:4:0xffffffff10095554}}}
[00015.545] 01046:66564> {{{bt:5:0xffffffff1009447c}}}
[00015.545] 01046:66564>
[00015.545] 01046:66564>
[00015.545] 01046:66564> ZIRCON KERNEL PANIC
[00015.545] 01046:66564> Lock validation failed for thread 0xffff00004298d6e0 pid 1046 tid 66564 (bin/core-tests:test_thread):
[00015.545] 01046:66564> Reason: Already Acquired
[00015.545] 01046:66564> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.545] 01046:66564> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.545] 01046:66564> caller=0xffffffff100449c8 frame=0xffff00860a931bf0
[00015.545] 01046:66564> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00015.545] 01046:66564>
[00015.545] 01046:66564> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00015.545] 01046:66564> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00015.545] 01046:66564> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00015.545] 01046:66564> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00015.545] 01046:66564> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00015.545] 01046:66564> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00015.545] 01046:66564> bt#00: 0xffffffff100449c8
[00015.545] 01046:66564> bt#01: 0xffffffff10044d78
[00015.545] 01046:66564> bt#02: 0xffffffff10044d78
[00015.545] 01046:66564> bt#03: 0xffffffff10031ad4
[00015.545] 01046:66564> bt#04: 0xffffffff100b9f6c
[00015.545] 01046:66564> bt#05: 0xffffffff10095554
[00015.545] 01046:66564> bt#06: 0xffffffff1009447c
[00015.545] 01046:66564> bt#07: end
[00015.545] 01046:66564> {{{bt:0:0xffffffff100449c8}}}
[00015.545] 01046:66564> {{{bt:1:0xffffffff10044d78}}}
[00015.545] 01046:66564> {{{bt:2:0xffffffff10044d78}}}
[00015.545] 01046:66564> {{{bt:3:0xffffffff10031ad4}}}
[00015.545] 01046:66564> {{{bt:4:0xffffffff100b9f6c}}}
[00015.545] 01046:66564> {{{bt:5:0xffffffff10095554}}}
[00015.545] 01046:66564> {{{bt:6:0xffffffff1009447c}}}
[00015.545] 01046:66564>
[00015.545] 01046:66564>
[00015.545] 01046:66564> ZIRCON KERNEL PANIC
[00015.545] 01046:66564> Lock validation failed for thread 0xffff00004298d6e0 pid 1046 tid 66564 (bin/core-tests:test_thread):
[00015.545] 01046:66564> Reason: Already Acquired
[00015.545] 01046:66564> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.545] 01046:66564> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.545] 01046:66564> caller=0xffffffff100449c8 frame=0xffff00860a931bf0
[00015.545] 01046:66564> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00015.545] 01046:66564>
[00015.545] 01046:66564> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00015.545] 01046:66564> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00015.545] 01046:66564> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00015.545] 01046:66564> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00015.545] 01046:66564> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00015.545] 01046:66564> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00015.545] 01046:66564> bt#00: 0xffffffff100449c8
[00015.545] 01046:66564> bt#01: 0xffffffff10044d78
[00015.545] 01046:66564> bt#02: 0xffffffff10044d78
[00015.545] 01046:66564> bt#03: 0xffffffff10031ad4
[00015.545] 01046:66564> bt#04: 0xffffffff100b9f6c
[00015.545] 01046:66564> bt#05: 0xffffffff10095554
[00015.545] 01046:66564> bt#06: 0xffffffff1009447c
[00015.545] 01046:66564> bt#07: end
[00015.545] 01046:66564> {{{bt:0:0xffffffff100449c8}}}
[00015.545] 01046:66564> {{{bt:1:0xffffffff10044d78}}}
[00015.545] 01046:66564> {{{bt:2:0xffffffff10044d78}}}
[00015.545] 01046:66564> {{{bt:3:0xffffffff10031ad4}}}
[00015.545] 01046:66564> {{{bt:4:0xffffffff100b9f6c}}}
[00015.545] 01046:66564> {{{bt:5:0xffffffff10095554}}}
[00015.545] 01046:66564> {{{bt:6:0xffffffff1009447c}}}
[00015.545] 01046:66564>
[00015.545] 01046:01049> [PASSED] (0 ms)
[00015.545] 01046:01049> detach_close_pager_test [RUNNING]
[00015.545] 01046:01049> [PASSED] (0 ms)
[00015.545] 01046:01049> close_port_test [RUNNING]
[00015.545] 01046:66577> PageFault: 1028189 free pages
[00015.545] 01046:66577>
[00015.545] 01046:66577> ZIRCON KERNEL PANIC
[00015.545] 01046:66577> Lock validation failed for thread 0xffff00004298d620 pid 1046 tid 66577 (bin/core-tests:test_thread):
[00015.545] 01046:66577> Reason: Already Acquired
[00015.545] 01046:66577> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.545] 01046:66577> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.545] 01046:66577> caller=0xffffffff100449c8 frame=0xffff00860a931c90
[00015.545] 01046:66577> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00015.545] 01046:66577>
[00015.545] 01046:66577> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00015.546] 01046:66577> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00015.546] 01046:66577> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00015.546] 01046:66577> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00015.546] 01046:66577> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00015.546] 01046:66577> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00015.546] 01046:66577> bt#00: 0xffffffff100449c8
[00015.546] 01046:66577> bt#01: 0xffffffff10044d78
[00015.546] 01046:66577> bt#02: 0xffffffff10031ad4
[00015.546] 01046:66577> bt#03: 0xffffffff100b9f6c
[00015.546] 01046:66577> bt#04: 0xffffffff10095554
[00015.546] 01046:66577> bt#05: 0xffffffff1009447c
[00015.546] 01046:66577> bt#06: end
[00015.546] 01046:66577> {{{bt:0:0xffffffff100449c8}}}
[00015.546] 01046:66577> {{{bt:1:0xffffffff10044d78}}}
[00015.546] 01046:66577> {{{bt:2:0xffffffff10031ad4}}}
[00015.546] 01046:66577> {{{bt:3:0xffffffff100b9f6c}}}
[00015.546] 01046:66577> {{{bt:4:0xffffffff10095554}}}
[00015.546] 01046:66577> {{{bt:5:0xffffffff1009447c}}}
[00015.546] 01046:66577>
[00015.546] 01046:66577>
[00015.546] 01046:66577> ZIRCON KERNEL PANIC
[00015.546] 01046:66577> Lock validation failed for thread 0xffff00004298d620 pid 1046 tid 66577 (bin/core-tests:test_thread):
[00015.546] 01046:66577> Reason: Already Acquired
[00015.546] 01046:66577> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.546] 01046:66577> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.546] 01046:66577> caller=0xffffffff100449c8 frame=0xffff00860a931bf0
[00015.546] 01046:66577> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00015.546] 01046:66577>
[00015.546] 01046:66577> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00015.546] 01046:66577> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00015.546] 01046:66577> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00015.546] 01046:66577> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00015.546] 01046:66577> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00015.546] 01046:66577> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00015.546] 01046:66577> bt#00: 0xffffffff100449c8
[00015.546] 01046:66577> bt#01: 0xffffffff10044d78
[00015.546] 01046:66577> bt#02: 0xffffffff10044d78
[00015.546] 01046:66577> bt#03: 0xffffffff10031ad4
[00015.546] 01046:66577> bt#04: 0xffffffff100b9f6c
[00015.546] 01046:66577> bt#05: 0xffffffff10095554
[00015.546] 01046:66577> bt#06: 0xffffffff1009447c
[00015.546] 01046:66577> bt#07: end
[00015.546] 01046:66577> {{{bt:0:0xffffffff100449c8}}}
[00015.546] 01046:66577> {{{bt:1:0xffffffff10044d78}}}
[00015.546] 01046:66577> {{{bt:2:0xffffffff10044d78}}}
[00015.546] 01046:66577> {{{bt:3:0xffffffff10031ad4}}}
[00015.546] 01046:66577> {{{bt:4:0xffffffff100b9f6c}}}
[00015.546] 01046:66577> {{{bt:5:0xffffffff10095554}}}
[00015.546] 01046:66577> {{{bt:6:0xffffffff1009447c}}}
[00015.546] 01046:66577>
[00015.546] 01046:66577>
[00015.546] 01046:66577> ZIRCON KERNEL PANIC
[00015.546] 01046:66577> Lock validation failed for thread 0xffff00004298d620 pid 1046 tid 66577 (bin/core-tests:test_thread):
[00015.546] 01046:66577> Reason: Already Acquired
[00015.546] 01046:66577> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.546] 01046:66577> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.546] 01046:66577> caller=0xffffffff100449c8 frame=0xffff00860a931bf0
[00015.546] 01046:66577> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00015.546] 01046:66577>
[00015.546] 01046:66577> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00015.546] 01046:66577> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00015.546] 01046:66577> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00015.546] 01046:66577> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00015.546] 01046:66577> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00015.546] 01046:66577> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00015.546] 01046:66577> bt#00: 0xffffffff100449c8
[00015.546] 01046:66577> bt#01: 0xffffffff10044d78
[00015.546] 01046:66577> bt#02: 0xffffffff10044d78
[00015.546] 01046:66577> bt#03: 0xffffffff10031ad4
[00015.546] 01046:66577> bt#04: 0xffffffff100b9f6c
[00015.546] 01046:66577> bt#05: 0xffffffff10095554
[00015.546] 01046:66577> bt#06: 0xffffffff1009447c
[00015.546] 01046:66577> bt#07: end
[00015.546] 01046:66577> {{{bt:0:0xffffffff100449c8}}}
[00015.546] 01046:66577> {{{bt:1:0xffffffff10044d78}}}
[00015.546] 01046:66577> {{{bt:2:0xffffffff10044d78}}}
[00015.546] 01046:66577> {{{bt:3:0xffffffff10031ad4}}}
[00015.546] 01046:66577> {{{bt:4:0xffffffff100b9f6c}}}
[00015.546] 01046:66577> {{{bt:5:0xffffffff10095554}}}
[00015.546] 01046:66577> {{{bt:6:0xffffffff1009447c}}}
[00015.546] 01046:66577>
[00015.546] 01046:01049> [PASSED] (0 ms)
[00015.546] 01046:01049> CASE lifecycle_tests [PASSED]
[00015.546] 01046:01049>
CASE pager_read_tests [STARTED]
[00015.546] 01046:01049> single_page_test_vmar [RUNNING]
[00015.546] 01046:01049> [PASSED] (0 ms)
[00015.546] 01046:01049> single_page_test_vmo [RUNNING]
[00015.546] 01046:01049> [PASSED] (0 ms)
[00015.546] 01046:01049> presupply_test_vmar [RUNNING]
[00015.546] 01046:01049> [PASSED] (0 ms)
[00015.546] 01046:01049> presupply_test_vmo [RUNNING]
[00015.547] 01046:01049> [PASSED] (0 ms)
[00015.547] 01046:01049> early_supply_test_vmar [RUNNING]
[00015.547] 01046:01049> [PASSED] (0 ms)
[00015.547] 01046:01049> early_supply_test_vmo [RUNNING]
[00015.548] 01046:01049> [PASSED] (0 ms)
[00015.548] 01046:01049> sequential_multipage_test_vmar [RUNNING]
[00015.549] 01046:01049> [PASSED] (1 ms)
[00015.549] 01046:01049> sequential_multipage_test_vmo [RUNNING]
[00015.550] 01046:01049> [PASSED] (0 ms)
[00015.550] 01046:01049> concurrent_multipage_access_test_vmar [RUNNING]
[00015.550] 01046:01049> [PASSED] (0 ms)
[00015.550] 01046:01049> concurrent_multipage_access_test_vmo [RUNNING]
[00015.551] 01046:01049> [PASSED] (0 ms)
[00015.551] 01046:01049> concurrent_overlapping_access_test_vmar [RUNNING]
[00015.576] 01046:01049> [PASSED] (24 ms)
[00015.576] 01046:01049> concurrent_overlapping_access_test_vmo [RUNNING]
[00015.589] 01046:01049> [PASSED] (12 ms)
[00015.589] 01046:01049> bulk_single_supply_test_vmar [RUNNING]
[00015.590] 01046:01049> [PASSED] (1 ms)
[00015.590] 01046:01049> bulk_single_supply_test_vmo [RUNNING]
[00015.592] 01046:01049> [PASSED] (1 ms)
[00015.592] 01046:01049> bulk_odd_length_supply_test_vmar [RUNNING]
[00015.614] 01046:01049> [PASSED] (21 ms)
[00015.614] 01046:01049> bulk_odd_length_supply_test_vmo [RUNNING]
[00015.637] 01046:01049> [PASSED] (23 ms)
[00015.637] 01046:01049> bulk_odd_offset_supply_test_vmar [RUNNING]
[00015.653] 01046:01049> [PASSED] (15 ms)
[00015.653] 01046:01049> bulk_odd_offset_supply_test_vmo [RUNNING]
[00015.674] 01046:01049> [PASSED] (20 ms)
[00015.674] 01046:01049> overlap_supply_test_vmar [RUNNING]
[00015.674] 01046:01049> [PASSED] (0 ms)
[00015.674] 01046:01049> overlap_supply_test_vmo [RUNNING]
[00015.675] 01046:01049> [PASSED] (0 ms)
[00015.675] 01046:01049> many_request_test_vmar [RUNNING]
[00015.768] 01046:01049> [PASSED] (93 ms)
[00015.768] 01046:01049> many_request_test_vmo [RUNNING]
[00015.862] 01046:01049> [PASSED] (93 ms)
[00015.862] 01046:01049> successive_vmo_test [RUNNING]
[00015.873] 01046:01049> [PASSED] (11 ms)
[00015.873] 01046:01049> multiple_concurrent_vmo_test [RUNNING]
[00015.874] 01046:01049> [PASSED] (1 ms)
[00015.874] 01046:01049> vmar_unmap_test [RUNNING]
[00015.875] 01046:74298> PageFault: 1028187 free pages
[00015.875] 01046:74298>
[00015.875] 01046:74298> ZIRCON KERNEL PANIC
[00015.875] 01046:74298> Lock validation failed for thread 0xffff00004298d7d0 pid 1046 tid 74298 (bin/core-tests:test_thread):
[00015.875] 01046:74298> Reason: Already Acquired
[00015.875] 01046:74298> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.875] 01046:74298> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.875] 01046:74298> caller=0xffffffff100449c8 frame=0xffff00860a931c90
[00015.875] 01046:74298> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00015.875] 01046:74298>
[00015.875] 01046:74298> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00015.875] 01046:74298> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00015.875] 01046:74298> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00015.875] 01046:74298> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00015.875] 01046:74298> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00015.875] 01046:74298> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00015.875] 01046:74298> bt#00: 0xffffffff100449c8
[00015.875] 01046:74298> bt#01: 0xffffffff10044d78
[00015.875] 01046:74298> bt#02: 0xffffffff10031ad4
[00015.875] 01046:74298> bt#03: 0xffffffff100b9f6c
[00015.875] 01046:74298> bt#04: 0xffffffff10095554
[00015.875] 01046:74298> bt#05: 0xffffffff1009447c
[00015.875] 01046:74298> bt#06: end
[00015.875] 01046:74298> {{{bt:0:0xffffffff100449c8}}}
[00015.875] 01046:74298> {{{bt:1:0xffffffff10044d78}}}
[00015.875] 01046:74298> {{{bt:2:0xffffffff10031ad4}}}
[00015.875] 01046:74298> {{{bt:3:0xffffffff100b9f6c}}}
[00015.875] 01046:74298> {{{bt:4:0xffffffff10095554}}}
[00015.875] 01046:74298> {{{bt:5:0xffffffff1009447c}}}
[00015.875] 01046:74298>
[00015.875] 01046:74298>
[00015.875] 01046:74298> ZIRCON KERNEL PANIC
[00015.875] 01046:74298> Lock validation failed for thread 0xffff00004298d7d0 pid 1046 tid 74298 (bin/core-tests:test_thread):
[00015.875] 01046:74298> Reason: Already Acquired
[00015.875] 01046:74298> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.875] 01046:74298> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.875] 01046:74298> caller=0xffffffff100449c8 frame=0xffff00860a931bf0
[00015.875] 01046:74298> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00015.875] 01046:74298>
[00015.875] 01046:74298> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00015.875] 01046:74298> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00015.875] 01046:74298> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00015.875] 01046:74298> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00015.875] 01046:74298> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00015.875] 01046:74298> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00015.875] 01046:74298> bt#00: 0xffffffff100449c8
[00015.875] 01046:74298> bt#01: 0xffffffff10044d78
[00015.875] 01046:74298> bt#02: 0xffffffff10044d78
[00015.875] 01046:74298> bt#03: 0xffffffff10031ad4
[00015.875] 01046:74298> bt#04: 0xffffffff100b9f6c
[00015.875] 01046:74298> bt#05: 0xffffffff10095554
[00015.875] 01046:74298> bt#06: 0xffffffff1009447c
[00015.875] 01046:74298> bt#07: end
[00015.875] 01046:74298> {{{bt:0:0xffffffff100449c8}}}
[00015.875] 01046:74298> {{{bt:1:0xffffffff10044d78}}}
[00015.875] 01046:74298> {{{bt:2:0xffffffff10044d78}}}
[00015.875] 01046:74298> {{{bt:3:0xffffffff10031ad4}}}
[00015.875] 01046:74298> {{{bt:4:0xffffffff100b9f6c}}}
[00015.875] 01046:74298> {{{bt:5:0xffffffff10095554}}}
[00015.875] 01046:74298> {{{bt:6:0xffffffff1009447c}}}
[00015.875] 01046:74298>
[00015.875] 01046:74298>
[00015.875] 01046:74298> ZIRCON KERNEL PANIC
[00015.875] 01046:74298> Lock validation failed for thread 0xffff00004298d7d0 pid 1046 tid 74298 (bin/core-tests:test_thread):
[00015.875] 01046:74298> Reason: Already Acquired
[00015.875] 01046:74298> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.875] 01046:74298> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.875] 01046:74298> caller=0xffffffff100449c8 frame=0xffff00860a931bf0
[00015.875] 01046:74298> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00015.875] 01046:74298>
[00015.875] 01046:74298> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00015.875] 01046:74298> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00015.875] 01046:74298> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00015.875] 01046:74298> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00015.875] 01046:74298> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00015.875] 01046:74298> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00015.875] 01046:74298> bt#00: 0xffffffff100449c8
[00015.875] 01046:74298> bt#01: 0xffffffff10044d78
[00015.875] 01046:74298> bt#02: 0xffffffff10044d78
[00015.875] 01046:74298> bt#03: 0xffffffff10031ad4
[00015.875] 01046:74298> bt#04: 0xffffffff100b9f6c
[00015.875] 01046:74298> bt#05: 0xffffffff10095554
[00015.875] 01046:74298> bt#06: 0xffffffff1009447c
[00015.875] 01046:74298> bt#07: end
[00015.875] 01046:74298> {{{bt:0:0xffffffff100449c8}}}
[00015.875] 01046:74298> {{{bt:1:0xffffffff10044d78}}}
[00015.875] 01046:74298> {{{bt:2:0xffffffff10044d78}}}
[00015.875] 01046:74298> {{{bt:3:0xffffffff10031ad4}}}
[00015.875] 01046:74298> {{{bt:4:0xffffffff100b9f6c}}}
[00015.875] 01046:74298> {{{bt:5:0xffffffff10095554}}}
[00015.875] 01046:74298> {{{bt:6:0xffffffff1009447c}}}
[00015.875] 01046:74298>
[00015.875] 01046:01049> [PASSED] (0 ms)
[00015.875] 01046:01049> vmar_remap_test [RUNNING]
[00015.876] 01046:01049> [PASSED] (1 ms)
[00015.876] 01046:01049> vmar_map_range_test [RUNNING]
[00015.877] 01046:01049> [PASSED] (0 ms)
[00015.877] 01046:01049> read_resize_test_vmar [RUNNING]
[00015.877] 01046:01049> [PASSED] (0 ms)
[00015.877] 01046:01049> read_resize_test_vmo [RUNNING]
[00015.877] 01046:01049> [PASSED] (0 ms)
[00015.877] 01046:01049> suspend_read_test_vmar [RUNNING]
[00015.877] 01046:01049> [PASSED] (0 ms)
[00015.877] 01046:01049> suspend_read_test_vmo [RUNNING]
[00015.878] 01046:01049> [PASSED] (0 ms)
[00015.878] 01046:01049> CASE pager_read_tests [PASSED]
[00015.878] 01046:01049>
CASE object_get_child_tests [STARTED]
[00015.878] 01046:01049> handle_invalid [RUNNING]
[00015.878] 01046:01049> [PASSED] (0 ms)
[00015.878] 01046:01049> CASE object_get_child_tests [PASSED]
[00015.878] 01046:01049>
CASE memory_mapping_tests [STARTED]
[00015.878] 01046:01049> address_space_limits_test [RUNNING]
[00015.878] 01046:01049> [PASSED] (0 ms)
[00015.878] 01046:01049> mmap_zerofilled_test [RUNNING]
[00015.878] 01046:01049> [PASSED] (0 ms)
[00015.878] 01046:01049> mmap_len_test [RUNNING]
[00015.878] 01046:01049> [PASSED] (0 ms)
[00015.878] 01046:01049> mmap_PROT_EXEC_test [RUNNING]
[00015.878] 01046:01049> [PASSED] (0 ms)
[00015.878] 01046:01049> mmap_offset_test [RUNNING]
[00015.878] 01046:01049> [PASSED] (0 ms)
[00015.878] 01046:01049> mmap_prot_test [RUNNING]
[00015.878] 01046:01049> [PASSED] (0 ms)
[00015.878] 01046:01049> mmap_flags_test [RUNNING]
[00015.878] 01046:01049> [PASSED] (0 ms)
[00015.878] 01046:01049> mprotect_test [RUNNING]
[00015.878] 01046:01049>
[00015.878] 01046:01049> ZIRCON KERNEL PANIC
[00015.878] 01046:01049> Lock validation failed for thread 0xffff00004003af00 pid 1046 tid 1049 (bin/core-tests:bin/core-tests):
[00015.878] 01046:01049> Reason: Already Acquired
[00015.878] 01046:01049> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.878] 01046:01049> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00015.878] 01046:01049> caller=0xffffffff100449c8 frame=0xffff00860a899b90
[00015.878] 01046:01049> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00015.878] 01046:01049>
[00015.878] 01046:01049> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00015.878] 01046:01049> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00015.878] 01046:01049> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00015.878] 01046:01049> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00015.878] 01046:01049> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00015.878] 01046:01049> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00015.878] 01046:01049> bt#00: 0xffffffff100449c8
[00015.878] 01046:01049> bt#01: 0xffffffff10044d78
[00015.878] 01046:01049> bt#02: 0xffffffff10045e50
[00015.878] 01046:01049> bt#03: 0xffffffff1003a1e8
[00015.878] 01046:01049> bt#04: 0xffffffff1004ece0
[00015.878] 01046:01049> bt#05: 0xffffffff1003fdc4
[00015.878] 01046:01049> bt#06: 0xffffffff100ce880
[00015.878] 01046:01049> bt#07: 0xffffffff100dd65c
[00015.878] 01046:01049> bt#08: 0xffffffff10094958
[00015.878] 01046:01049> bt#09: end
[00015.878] 01046:01049> {{{bt:0:0xffffffff100449c8}}}
[00015.878] 01046:01049> {{{bt:1:0xffffffff10044d78}}}
[00015.878] 01046:01049> {{{bt:2:0xffffffff10045e50}}}
[00015.878] 01046:01049> {{{bt:3:0xffffffff1003a1e8}}}
[00015.878] 01046:01049> {{{bt:4:0xffffffff1004ece0}}}
[00015.878] 01046:01049> {{{bt:5:0xffffffff1003fdc4}}}
[00015.878] 01046:01049> {{{bt:6:0xffffffff100ce880}}}
[00015.878] 01046:01049> {{{bt:7:0xffffffff100dd65c}}}
[00015.878] 01046:01049> {{{bt:8:0xffffffff10094958}}}
[00015.878] 01046:01049>
[00015.878] 01046:01049> [PASSED] (0 ms)
[00015.878] 01046:01049> CASE memory_mapping_tests [PASSED]
[00015.879] 01046:01049>
CASE job_tests [STARTED]
[00015.879] 01046:01049> basic_test [RUNNING]
[00015.879] 01046:01049> [PASSED] (0 ms)
[00015.879] 01046:01049> create_missing_rights_test [RUNNING]
[00015.879] 01046:01049> [PASSED] (0 ms)
[00015.879] 01046:01049> policy_invalid_topic_test [RUNNING]
[00015.879] 01046:01049> [PASSED] (0 ms)
[00015.879] 01046:01049> policy_basic_test [RUNNING]
[00015.879] 01046:01049> [PASSED] (0 ms)
[00015.879] 01046:01049> policy_timer_slack_invalid_options_test [RUNNING]
[00015.879] 01046:01049> [PASSED] (0 ms)
[00015.879] 01046:01049> policy_timer_slack_invalid_count_test [RUNNING]
[00015.879] 01046:01049> [PASSED] (0 ms)
[00015.879] 01046:01049> policy_timer_slack_invalid_policy_test [RUNNING]
[00015.879] 01046:01049> [PASSED] (0 ms)
[00015.879] 01046:01049> policy_timer_slack_non_empty_test [RUNNING]
[00015.879] 01046:01049> [PASSED] (0 ms)
[00015.879] 01046:01049> policy_timer_slack_valid [RUNNING]
[00015.879] 01046:01049> [PASSED] (0 ms)
[00015.879] 01046:01049> create_test [RUNNING]
[00015.879] 01046:01049> [PASSED] (0 ms)
[00015.879] 01046:01049> kill_test [RUNNING]
[00015.879] 01046:01049> [PASSED] (0 ms)
[00015.879] 01046:01049> kill_job_no_child_test [RUNNING]
[00015.879] 01046:01049> [PASSED] (0 ms)
[00015.879] 01046:01049> kill_job_removes_from_tree [RUNNING]
[00015.879] 01046:01049> [PASSED] (0 ms)
[00015.879] 01046:01049> close_job_removes_from_tree [RUNNING]
[00015.879] 01046:01049> [PASSED] (0 ms)
[00015.879] 01046:01049> kill_job_chain [RUNNING]
[00016.234] 01046:01049> [PASSED] (355 ms)
[00016.234] 01046:01049> set_job_oom_kill_bit [RUNNING]
[00016.234] 01046:01049> [PASSED] (0 ms)
[00016.234] 01046:01049> wait_test [RUNNING]
[00016.240] 01046:01049> [PASSED] (5 ms)
[00016.240] 01046:01049> info_task_stats_fails [RUNNING]
[00016.240] 01046:01049> [PASSED] (0 ms)
[00016.240] 01046:01049> max_height_smoke [RUNNING]
[00016.240] 01046:01049> [PASSED] (0 ms)
[00016.240] 01046:01049> CASE job_tests [PASSED]
[00016.240] 01046:01049>
CASE handle_wait_tests [STARTED]
[00016.240] 01046:01049> handle_wait_test [RUNNING]
[00016.240] 01046:01049> [PASSED] (0 ms)
[00016.240] 01046:01049> CASE handle_wait_tests [PASSED]
[00016.240] 01046:01049>
CASE eventpair_tests [STARTED]
[00016.240] 01046:01049> create_test [RUNNING]
[00016.240] 01046:01049> [PASSED] (0 ms)
[00016.240] 01046:01049> signal_test [RUNNING]
[00016.240] 01046:01049> [PASSED] (0 ms)
[00016.240] 01046:01049> signal_peer_test [RUNNING]
[00016.240] 01046:01049> [PASSED] (0 ms)
[00016.240] 01046:01049> signal_peer_closed_test [RUNNING]
[00016.240] 01046:01049> [PASSED] (0 ms)
[00016.240] 01046:01049> CASE eventpair_tests [PASSED]
[00016.240] 01046:01049>
CASE elf_tls_tests [STARTED]
[00016.240] 01046:01049> ExecutableTlsTest [RUNNING]
[00016.389] 01046:01049> [PASSED] (148 ms)
[00016.389] 01046:01049> CASE elf_tls_tests [PASSED]
[00016.389] 01046:01049>
CASE channel_tests [STARTED]
[00016.389] 01046:01049> channel_test [RUNNING]
[00016.389] 01046:01049> [PASSED] (0 ms)
[00016.390] 01046:01049> channel_read_error_test [RUNNING]
[00016.390] 01046:01049> [PASSED] (0 ms)
[00016.390] 01046:01049> channel_close_test [RUNNING]
[00016.390] 01046:01049> [PASSED] (0 ms)
[00016.390] 01046:01049> channel_peer_closed_test [RUNNING]
[00016.390] 01046:01049> [PASSED] (0 ms)
[00016.390] 01046:01049> channel_non_transferable [RUNNING]
[00016.390] 01046:01049> [PASSED] (0 ms)
[00016.390] 01046:01049> channel_duplicate_handles [RUNNING]
[00016.390] 01046:01049> [PASSED] (0 ms)
[00016.390] 01046:01049> channel_multithread_read [RUNNING]
[00016.397] 01046:01049> [PASSED] (6 ms)
[00016.397] 01046:01049> channel_may_discard [RUNNING]
[00016.397] 01046:01049> [PASSED] (0 ms)
[00016.397] 01046:01049> channel_call [RUNNING]
[00016.398] 01046:01049> [PASSED] (1 ms)
[00016.398] 01046:01049> channel_call_consumes_handles [RUNNING]
[00016.398] 01046:01049> [PASSED] (0 ms)
[00016.398] 01046:01049> channel_call2 [RUNNING]
[00016.648] 01046:01049> [PASSED] (250 ms)
[00016.648] 01046:01049> bad_channel_call_finish [RUNNING]
[00016.648] 01046:01049> [PASSED] (0 ms)
[00016.648] 01046:01049> channel_nest [RUNNING]
[00016.649] 01046:01049> [PASSED] (0 ms)
[00016.649] 01046:01049> channel_disallow_write_to_self [RUNNING]
[00016.649] 01046:01049> [PASSED] (0 ms)
[00016.649] 01046:01049> channel_read_etc [RUNNING]
[00016.649] 01046:01049> [PASSED] (0 ms)
[00016.649] 01046:01049> channel_write_different_sizes [RUNNING]
[00016.767] 01046:01049> [PASSED] (118 ms)
[00016.767] 01046:01049> channel_write_takes_all_handles [RUNNING]
[00016.770] 01046:01049> [PASSED] (2 ms)
[00016.770] 01046:01049> CASE channel_tests [PASSED]
[00016.770] 01046:01049>
CASE c11_thread_tests [STARTED]
[00016.770] 01046:01049> c11_thread_test [RUNNING]
[00017.572] 01046:01049> [PASSED] (801 ms)
[00017.572] 01046:01049> long_name_succeeds [RUNNING]
[00017.672] 01046:01049> [PASSED] (100 ms)
[00017.672] 01046:01049> detach_self_test [RUNNING]
[00017.807] 01046:01049> [PASSED] (135 ms)
[00017.807] 01046:01049> CASE c11_thread_tests [PASSED]
[00017.807] 01046:01049>
CASE mtx_tests [STARTED]
[00017.807] 01046:01049> test_initializer [RUNNING]
[00017.807] 01046:01049> [PASSED] (0 ms)
[00017.807] 01046:01049> test_mutexes [RUNNING]
[00017.819] 01046:01049> [PASSED] (11 ms)
[00017.819] 01046:01049> test_try_mutexes [RUNNING]
[00017.823] 01046:01049> [PASSED] (3 ms)
[00017.823] 01046:01049> test_static_initializer [RUNNING]
[00017.823] 01046:01049> [PASSED] (0 ms)
[00017.823] 01046:01049> test_timeout_elapsed [RUNNING]
[00018.323] 01046:01049> [PASSED] (500 ms)
[00018.323] 01046:01049> CASE mtx_tests [PASSED]
[00018.323] 01046:01049>
CASE cnd_tests [STARTED]
[00018.323] 01046:01049> cnd_test [RUNNING]
[00018.324] 01046:01049> [PASSED] (0 ms)
[00018.324] 01046:01049> cnd_timedwait_timeout_test [RUNNING]
[00018.325] 01046:01049> [PASSED] (1 ms)
[00018.325] 01046:01049> CASE cnd_tests [PASSED]
[00018.325] 01046:01049>
CASE bad_syscall_tests [STARTED]
[00018.325] 01046:01049> bad_access_test [RUNNING]
[00018.325] 01046:01049> [PASSED] (0 ms)
[00018.325] 01046:01049> bad_syscall_num_test [RUNNING]
[00018.325] 01046:01049> [PASSED] (0 ms)
[00018.325] 01046:01049> CASE bad_syscall_tests [PASSED]
[00018.326] 01046:01049> ====================================================
[00018.326] 01046:01049> Results:
[00018.326] 01046:01049> SUCCESS! All test cases passed!
[00018.326] 01046:01049> CASES: 33 SUCCESS: 33 FAILED: 0
[00018.326] 01046:01049> ====================================================
[00018.326] 01046:01049> Flags:
[00018.326] 01046:01049> --gtest_random_seed = 18
[00018.326] 01046:01049>
[00018.326] 01046:01049>
[00018.326] 01046:01049> [==========] Running 242 tests from 13 test cases
[00018.326] 01046:01049> .
[00018.326] 01046:01049> [----------] Global test environment set-up.
[00018.326] 01046:01049> [----------] 1 test from ClockTest
[00018.326] 01046:01049>
[00018.326] 01046:01049> [ RUN ] ClockTest.ClockMonotonic
[00018.326] 01046:01049>
[00018.428] 01046:01049> [ OK ] ClockTest.ClockMonotonic (102
[00018.428] 01046:01049> ms)
[00018.428] 01046:01049> [----------] 1 test from ClockTest (102
[00018.428] 01046:01049> ms total)
[00018.428] 01046:01049> [----------] 9 tests from FifoTest
[00018.428] 01046:01049>
[00018.428] 01046:01049> [ RUN ] FifoTest.InvalidParametersReturnOutOfRange
[00018.428] 01046:01049>
[00018.428] 01046:01049> [ OK ] FifoTest.InvalidParametersReturnOutOfRange (0
[00018.428] 01046:01049> ms)
[00018.428] 01046:01049> [ RUN ] FifoTest.EndpointsAreRelated
[00018.428] 01046:01049>
[00018.428] 01046:01049> [ OK ] FifoTest.EndpointsAreRelated (0
[00018.428] 01046:01049> ms)
[00018.428] 01046:01049> [ RUN ] FifoTest.EmptyQueueReturnsErrShouldWait
[00018.428] 01046:01049>
[00018.428] 01046:01049> [ OK ] FifoTest.EmptyQueueReturnsErrShouldWait (0
[00018.428] 01046:01049> ms)
[00018.428] 01046:01049> [ RUN ] FifoTest.ReadAndWriteValidatesSizeAndElementCount
[00018.428] 01046:01049>
[00018.428] 01046:01049> [ OK ] FifoTest.ReadAndWriteValidatesSizeAndElementCount (0
[00018.428] 01046:01049> ms)
[00018.428] 01046:01049> [ RUN ] FifoTest.DequeueSignalsWriteable
[00018.428] 01046:01049>
[00018.428] 01046:01049> [ OK ] FifoTest.DequeueSignalsWriteable (0
[00018.428] 01046:01049> ms)
[00018.428] 01046:01049> [ RUN ] FifoTest.FifoOrderIsPreserved
[00018.428] 01046:01049>
[00018.428] 01046:01049> [ OK ] FifoTest.FifoOrderIsPreserved (0
[00018.428] 01046:01049> ms)
[00018.428] 01046:01049> [ RUN ] FifoTest.PartialWriteQueuesElementsThatFit
[00018.428] 01046:01049>
[00018.428] 01046:01049> [ OK ] FifoTest.PartialWriteQueuesElementsThatFit (0
[00018.428] 01046:01049> ms)
[00018.428] 01046:01049> [ RUN ] FifoTest.IndividualReadsPreserveOrder
[00018.428] 01046:01049>
[00018.428] 01046:01049> [ OK ] FifoTest.IndividualReadsPreserveOrder (0
[00018.428] 01046:01049> ms)
[00018.428] 01046:01049> [ RUN ] FifoTest.EndpointCloseSignalsPeerClosed
[00018.428] 01046:01049>
[00018.428] 01046:01049> [ OK ] FifoTest.EndpointCloseSignalsPeerClosed (0
[00018.428] 01046:01049> ms)
[00018.428] 01046:01049> [----------] 9 tests from FifoTest (0
[00018.428] 01046:01049> ms total)
[00018.428] 01046:01049> [----------] 15 tests from FutexTest
[00018.428] 01046:01049>
[00018.429] 01046:01049> [ RUN ] FutexTest.WaitValueMismatch
[00018.429] 01046:01049>
[00018.429] 01046:01049> [ OK ] FutexTest.WaitValueMismatch (0
[00018.429] 01046:01049> ms)
[00018.429] 01046:01049> [ RUN ] FutexTest.WaitTimeout
[00018.429] 01046:01049>
[00018.429] 01046:01049> [ OK ] FutexTest.WaitTimeout (0
[00018.429] 01046:01049> ms)
[00018.429] 01046:01049> [ RUN ] FutexTest.WaitTimeoutElapsed
[00018.429] 01046:01049>
[00018.929] 01046:01049> [ OK ] FutexTest.WaitTimeoutElapsed (500
[00018.929] 01046:01049> ms)
[00018.929] 01046:01049> [ RUN ] FutexTest.WaitBadAddress
[00018.929] 01046:01049>
[00018.929] 01046:01049> [ OK ] FutexTest.WaitBadAddress (0
[00018.929] 01046:01049> ms)
[00018.929] 01046:01049> [ RUN ] FutexTest.Wakeup
[00018.929] 01046:01049>
[00018.929] 01046:01049> [ OK ] FutexTest.Wakeup (0
[00018.929] 01046:01049> ms)
[00018.929] 01046:01049> [ RUN ] FutexTest.WakeupLimit
[00018.929] 01046:01049>
[00019.530] 01046:01049> [ OK ] FutexTest.WakeupLimit (601
[00019.530] 01046:01049> ms)
[00019.530] 01046:01049> [ RUN ] FutexTest.WakeupAddress
[00019.530] 01046:01049>
[00019.531] 01046:01049> [ OK ] FutexTest.WakeupAddress (0
[00019.531] 01046:01049> ms)
[00019.531] 01046:01049> [ RUN ] FutexTest.RequeueValueMismatch
[00019.531] 01046:01049>
[00019.531] 01046:01049> [ OK ] FutexTest.RequeueValueMismatch (0
[00019.531] 01046:01049> ms)
[00019.531] 01046:01049> [ RUN ] FutexTest.RequeueSameAddr
[00019.531] 01046:01049>
[00019.531] 01046:01049> [ OK ] FutexTest.RequeueSameAddr (0
[00019.531] 01046:01049> ms)
[00019.531] 01046:01049> [ RUN ] FutexTest.Requeue
[00019.531] 01046:01049>
[00020.433] 01046:01049> [ OK ] FutexTest.Requeue (901
[00020.433] 01046:01049> ms)
[00020.433] 01046:01049> [ RUN ] FutexTest.RequeueUnqueuedOnTimeout
[00020.433] 01046:01049>
[00020.733] 01046:01049> [ OK ] FutexTest.RequeueUnqueuedOnTimeout (300
[00020.733] 01046:01049> ms)
[00020.733] 01046:01049> [ RUN ] FutexTest.ThreadKilled
[00020.733] 01046:01049>
[00020.734] 01046:01049> [ OK ] FutexTest.ThreadKilled (0
[00020.734] 01046:01049> ms)
[00020.734] 01046:01049> [ RUN ] FutexTest.ThreadSuspended
[00020.734] 01046:01049>
[00021.034] 01046:01049> [ OK ] FutexTest.ThreadSuspended (300
[00021.034] 01046:01049> ms)
[00021.034] 01046:01049> [ RUN ] FutexTest.MisalignedFutextAddr
[00021.034] 01046:01049>
[00021.034] 01046:01049> [ OK ] FutexTest.MisalignedFutextAddr (0
[00021.034] 01046:01049> ms)
[00021.034] 01046:01049> [ RUN ] FutexTest.EventSignaling
[00021.034] 01046:01049>
[00021.034] 01046:01049> [00000021.34739180]: starting signal threads
[00021.034] 01046:146871> [00000021.34889535]: thread 1 waiting on event
[00021.035] 01046:146876> [00000021.34993055]: thread 2 waiting on event
[00021.035] 01046:146881> [00000021.35069705]: thread 3 waiting on event
[00021.035] 01046:01049> [00000021.35201220]: signaling event
[00021.035] 01046:01049> [00000021.35230430]: joining signal threads
[00021.035] 01046:146881> [00000021.35242015]: thread 3 done
[00021.035] 01046:146871> [00000021.35304100]: thread 1 done
[00021.035] 01046:146876> [00000021.35356640]: thread 2 done
[00021.035] 01046:01049> [00000021.35366705]: signal_thread 1 joined
[00021.035] 01046:01049> [00000021.35423785]: signal_thread 2 joined
[00021.035] 01046:01049> [00000021.35447845]: signal_thread 3 joined
[00021.035] 01046:01049> [ OK ] FutexTest.EventSignaling (0
[00021.035] 01046:01049> ms)
[00021.035] 01046:01049> [----------] 15 tests from FutexTest (2606
[00021.035] 01046:01049> ms total)
[00021.035] 01046:01049> [----------] 3 tests from HandleCloseTest
[00021.035] 01046:01049>
[00021.035] 01046:01049> [ RUN ] HandleCloseTest.Many
[00021.035] 01046:01049>
[00021.035] 01046:01049> [ OK ] HandleCloseTest.Many (0
[00021.035] 01046:01049> ms)
[00021.035] 01046:01049> [ RUN ] HandleCloseTest.ManyInvalidHandlesShouldNotFail
[00021.035] 01046:01049>
[00021.035] 01046:01049> [ OK ] HandleCloseTest.ManyInvalidHandlesShouldNotFail (0
[00021.035] 01046:01049> ms)
[00021.035] 01046:01049> [ RUN ] HandleCloseTest.ManyDuplicateTest
[00021.035] 01046:01049>
[00021.035] 01046:01049> [ OK ] HandleCloseTest.ManyDuplicateTest (0
[00021.035] 01046:01049> ms)
[00021.035] 01046:01049> [----------] 3 tests from HandleCloseTest (0
[00021.035] 01046:01049> ms total)
[00021.035] 01046:01049> [----------] 6 tests from HandleInfoTest
[00021.035] 01046:01049>
[00021.035] 01046:01049> [ RUN ] HandleInfoTest.ReplaceSuccessOrigInvalid
[00021.035] 01046:01049>
[00021.035] 01046:01049> [ OK ] HandleInfoTest.ReplaceSuccessOrigInvalid (0
[00021.035] 01046:01049> ms)
[00021.035] 01046:01049> [ RUN ] HandleInfoTest.ReplaceFailureBothInvalid
[00021.035] 01046:01049>
[00021.035] 01046:01049> [ OK ] HandleInfoTest.ReplaceFailureBothInvalid (0
[00021.035] 01046:01049> ms)
[00021.035] 01046:01049> [ RUN ] HandleInfoTest.DupAndInfoRights
[00021.035] 01046:01049>
[00021.035] 01046:01049> [ OK ] HandleInfoTest.DupAndInfoRights (0
[00021.035] 01046:01049> ms)
[00021.035] 01046:01049> [ RUN ] HandleInfoTest.RelatedKoid
[00021.035] 01046:01049>
[00021.035] 01046:01049> [ OK ] HandleInfoTest.RelatedKoid (0
[00021.035] 01046:01049> ms)
[00021.035] 01046:01049> [ RUN ] HandleInfoTest.DuplicateRights
[00021.035] 01046:01049>
[00021.035] 01046:01049> [ OK ] HandleInfoTest.DuplicateRights (0
[00021.035] 01046:01049> ms)
[00021.035] 01046:01049> [ RUN ] HandleInfoTest.ReplaceRights
[00021.035] 01046:01049>
[00021.035] 01046:01049> [ OK ] HandleInfoTest.ReplaceRights (0
[00021.035] 01046:01049> ms)
[00021.035] 01046:01049> [----------] 6 tests from HandleInfoTest (0
[00021.035] 01046:01049> ms total)
[00021.035] 01046:01049> [----------] 2 tests from HandleTransferTest
[00021.035] 01046:01049>
[00021.036] 01046:01049> [ RUN ] HandleTransferTest.OverChannelThenRead
[00021.036] 01046:01049>
[00021.036] 01046:01049> [ OK ] HandleTransferTest.OverChannelThenRead (0
[00021.036] 01046:01049> ms)
[00021.036] 01046:01049> [ RUN ] HandleTransferTest.CancelsWait
[00021.036] 01046:01049>
[00021.037] 01046:01049> [ OK ] HandleTransferTest.CancelsWait (1
[00021.037] 01046:01049> ms)
[00021.037] 01046:01049> [----------] 2 tests from HandleTransferTest (1
[00021.037] 01046:01049> ms total)
[00021.037] 01046:01049> [----------] 4 tests from ObjectGetInfoTest
[00021.037] 01046:01049>
[00021.037] 01046:01049> [ RUN ] ObjectGetInfoTest.OpenValidHandleSuceeds
[00021.037] 01046:01049>
[00021.037] 01046:01049> [ OK ] ObjectGetInfoTest.OpenValidHandleSuceeds (0
[00021.037] 01046:01049> ms)
[00021.037] 01046:01049> [ RUN ] ObjectGetInfoTest.ClosedValidHandleFails
[00021.037] 01046:01049>
[00021.037] 01046:01049> [ OK ] ObjectGetInfoTest.ClosedValidHandleFails (0
[00021.037] 01046:01049> ms)
[00021.037] 01046:01049> [ RUN ] ObjectGetInfoTest.HandleCountCorrectness
[00021.037] 01046:01049>
[00021.037] 01046:01049> [ OK ] ObjectGetInfoTest.HandleCountCorrectness (0
[00021.037] 01046:01049> ms)
[00021.037] 01046:01049> [ RUN ] ObjectGetInfoTest.InvalidHandleFails
[00021.037] 01046:01049>
[00021.037] 01046:01049> [ OK ] ObjectGetInfoTest.InvalidHandleFails (0
[00021.037] 01046:01049> ms)
[00021.037] 01046:01049> [----------] 4 tests from ObjectGetInfoTest (0
[00021.037] 01046:01049> ms total)
[00021.037] 01046:01049> [----------] 39 tests from JobGetInfoTest
[00021.037] 01046:01049>
[00021.037] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesGetChild
[00021.037] 01046:01049>
[00021.037] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesGetChild (0
[00021.037] 01046:01049> ms)
[00021.037] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildJobsGetChild
[00021.037] 01046:01049>
[00021.037] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildJobsGetChild (0
[00021.037] 01046:01049> ms)
[00021.037] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesOnSelfSuceeds
[00021.037] 01046:01049>
[00021.037] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesOnSelfSuceeds (0
[00021.037] 01046:01049> ms)
[00021.037] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesInvalidHandleFails
[00021.037] 01046:01049>
[00021.037] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesInvalidHandleFails (0
[00021.037] 01046:01049> ms)
[00021.037] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesNullAvailSucceeds
[00021.037] 01046:01049>
[00021.037] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesNullAvailSucceeds (0
[00021.037] 01046:01049> ms)
[00021.037] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesNullActualSucceeds
[00021.037] 01046:01049>
[00021.037] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesNullActualSucceeds (0
[00021.037] 01046:01049> ms)
[00021.037] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesNullActualAndAvailSucceeds
[00021.037] 01046:01049>
[00021.037] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesNullActualAndAvailSucceeds (0
[00021.037] 01046:01049> ms)
[00021.037] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesInvalidBufferPointerFails
[00021.037] 01046:01049>
[00021.037] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesInvalidBufferPointerFails (0
[00021.037] 01046:01049> ms)
[00021.037] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesBadActualgIsInvalidArg
[00021.037] 01046:01049>
[00021.037] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesBadActualgIsInvalidArg (0
[00021.037] 01046:01049> ms)
[00021.037] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesBadAvailIsInvalidArg
[00021.037] 01046:01049>
[00021.037] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesBadAvailIsInvalidArg (0
[00021.037] 01046:01049> ms)
[00021.037] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesZeroSizedBufferIsOk
[00021.037] 01046:01049>
[00021.037] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesZeroSizedBufferIsOk (0
[00021.037] 01046:01049> ms)
[00021.037] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesSmallBufferIsOk
[00021.037] 01046:01049>
[00021.037] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesSmallBufferIsOk (0
[00021.037] 01046:01049> ms)
[00021.037] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesPartiallyUnmappedBufferIsInvalidArgs
[00021.037] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesPartiallyUnmappedBufferIsInvalidArgs (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesRequiresEnumerateRights
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesRequiresEnumerateRights (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesProcessbHandleIsBadHandle
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesProcessbHandleIsBadHandle (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesThreadHandleIsBadHandle
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesThreadHandleIsBadHandle (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenOnSelfSuceeds
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenOnSelfSuceeds (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenInvalidHandleFails
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenInvalidHandleFails (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenNullAvailSucceeds
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenNullAvailSucceeds (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenNullActualSucceeds
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenNullActualSucceeds (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenNullActualAndAvailSucceeds
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenNullActualAndAvailSucceeds (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenInvalidBufferPointerFails
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenInvalidBufferPointerFails (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenBadActualgIsInvalidArg
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenBadActualgIsInvalidArg (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenBadAvailIsInvalidArg
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenBadAvailIsInvalidArg (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenZeroSizedBufferIsOk
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenZeroSizedBufferIsOk (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenSmallBufferIsOk
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenSmallBufferIsOk (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenPartiallyUnmappedBufferIsInvalidArgs
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenPartiallyUnmappedBufferIsInvalidArgs (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenRequiresEnumerateRights
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenRequiresEnumerateRights (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenJobHandleIsBadHandle
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenJobHandleIsBadHandle (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenThreadHandleIsBadHandle
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenThreadHandleIsBadHandle (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoHandleBasicOnSelfSuceeds
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoHandleBasicOnSelfSuceeds (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoHandleBasicInvalidHandleFails
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoHandleBasicInvalidHandleFails (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoHandleBasicNullAvailSucceeds
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoHandleBasicNullAvailSucceeds (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoHandleBasicNullActualSucceeds
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoHandleBasicNullActualSucceeds (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoHandleBasicInvalidBufferPointerFails
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoHandleBasicInvalidBufferPointerFails (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [ RUN ] JobGetInfoTest.InfoHandleBasicZeroSizedBufferFails
[00021.038] 01046:01049>
[00021.038] 01046:01049> [ OK ] JobGetInfoTest.InfoHandleBasicZeroSizedBufferFails (0
[00021.038] 01046:01049> ms)
[00021.038] 01046:01049> [----------] 39 tests from JobGetInfoTest (1
[00021.038] 01046:01049> ms total)
[00021.038] 01046:01049> [----------] 61 tests from ProcessGetInfoTest
[00021.038] 01046:01049>
[00021.039] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsUnstartedSuceeds
[00021.039] 01046:01049>
[00021.039] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsUnstartedSuceeds (0
[00021.039] 01046:01049> ms)
[00021.039] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsSmokeTest
[00021.039] 01046:01049>
[00021.039] 01046:01049>
[00021.039] 01046:01049> ZIRCON KERNEL PANIC
[00021.039] 01046:01049> Lock validation failed for thread 0xffff00004003af00 pid 1046 tid 1049 (bin/core-tests:bin/core-tests):
[00021.039] 01046:01049> Reason: Already Acquired
[00021.039] 01046:01049> Bad lock: name=lockdep::LockClass<VmAspace, Mutex, 199, lockdep::LockFlagsNone> order=0
[00021.039] 01046:01049> Conflict: name=lockdep::LockClass<VmAspace, Mutex, 199, lockdep::LockFlagsNone> order=0
[00021.039] 01046:01049> caller=0xffffffff100ab264 frame=0xffff00860a8998d0
[00021.039] 01046:01049> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00021.039] 01046:01049>
[00021.039] 01046:01049> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00021.039] 01046:01049> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00021.039] 01046:01049> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00021.039] 01046:01049> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00021.039] 01046:01049> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00021.039] 01046:01049> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00021.039] 01046:01049> bt#00: 0xffffffff100ab264
[00021.039] 01046:01049> bt#01: 0xffffffff100b9f3c
[00021.039] 01046:01049> bt#02: 0xffffffff10095554
[00021.039] 01046:01049> bt#03: 0xffffffff10094270
[00021.039] 01046:01049> bt#04: 0xffffffff100a5cd4
[00021.039] 01046:01049> bt#05: 0xffffffff100ab570
[00021.039] 01046:01049> bt#06: 0xffffffff100314a4
[00021.039] 01046:01049> bt#07: 0xffffffff10053354
[00021.039] 01046:01049> bt#08: 0xffffffff100d0d78
[00021.039] 01046:01049> bt#09: 0xffffffff100de8d0
[00021.039] 01046:01049> bt#10: 0xffffffff100949dc
[00021.039] 01046:01049> bt#11: end
[00021.039] 01046:01049> {{{bt:0:0xffffffff100ab264}}}
[00021.039] 01046:01049> {{{bt:1:0xffffffff100b9f3c}}}
[00021.039] 01046:01049> {{{bt:2:0xffffffff10095554}}}
[00021.039] 01046:01049> {{{bt:3:0xffffffff10094270}}}
[00021.039] 01046:01049> {{{bt:4:0xffffffff100a5cd4}}}
[00021.039] 01046:01049> {{{bt:5:0xffffffff100ab570}}}
[00021.039] 01046:01049> {{{bt:6:0xffffffff100314a4}}}
[00021.039] 01046:01049> {{{bt:7:0xffffffff10053354}}}
[00021.039] 01046:01049> {{{bt:8:0xffffffff100d0d78}}}
[00021.039] 01046:01049> {{{bt:9:0xffffffff100de8d0}}}
[00021.039] 01046:01049> {{{bt:10:0xffffffff100949dc}}}
[00021.039] 01046:01049>
[00021.039] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsSmokeTest (0
[00021.039] 01046:01049> ms)
[00021.039] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessHandleStats
[00021.039] 01046:01049>
[00021.039] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessHandleStats (0
[00021.039] 01046:01049> ms)
[00021.039] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsOnSelfFails
[00021.039] 01046:01049>
[00021.039] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsOnSelfFails (0
[00021.039] 01046:01049> ms)
[00021.039] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsInvalidHandleFails
[00021.039] 01046:01049>
[00021.039] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsInvalidHandleFails (0
[00021.039] 01046:01049> ms)
[00021.039] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsNullAvailSucceeds
[00021.039] 01046:01049>
[00021.039] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsNullAvailSucceeds (0
[00021.039] 01046:01049> ms)
[00021.039] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsNullActualSucceeds
[00021.039] 01046:01049>
[00021.039] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsNullActualSucceeds (0
[00021.039] 01046:01049> ms)
[00021.039] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsNullActualAndAvailSucceeds
[00021.039] 01046:01049>
[00021.039] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsNullActualAndAvailSucceeds (0
[00021.039] 01046:01049> ms)
[00021.039] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsInvalidBufferPointerFails
[00021.039] 01046:01049>
[00021.039] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsInvalidBufferPointerFails (0
[00021.039] 01046:01049> ms)
[00021.039] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsBadActualgIsInvalidArg
[00021.039] 01046:01049>
[00021.039] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsBadActualgIsInvalidArg (0
[00021.039] 01046:01049> ms)
[00021.039] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsBadAvailIsInvalidArg
[00021.039] 01046:01049>
[00021.039] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsBadAvailIsInvalidArg (0
[00021.039] 01046:01049> ms)
[00021.039] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsZeroSizedBufferIsOk
[00021.039] 01046:01049>
[00021.039] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsZeroSizedBufferIsOk (0
[00021.039] 01046:01049> ms)
[00021.039] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsSmallBufferIsOk
[00021.039] 01046:01049>
[00021.039] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsSmallBufferIsOk (0
[00021.039] 01046:01049> ms)
[00021.039] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsPartiallyUnmappedBufferIsInvalidArgs
[00021.039] 01046:01049>
[00021.039] 01046:01049>
[00021.039] 01046:01049> ZIRCON KERNEL PANIC
[00021.039] 01046:01049> Lock validation failed for thread 0xffff00004003af00 pid 1046 tid 1049 (bin/core-tests:bin/core-tests):
[00021.039] 01046:01049> Reason: Already Acquired
[00021.039] 01046:01049> Bad lock: name=lockdep::LockClass<VmAspace, Mutex, 199, lockdep::LockFlagsNone> order=0
[00021.039] 01046:01049> Conflict: name=lockdep::LockClass<VmAspace, Mutex, 199, lockdep::LockFlagsNone> order=0
[00021.039] 01046:01049> caller=0xffffffff100ab264 frame=0xffff00860a899970
[00021.039] 01046:01049> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00021.039] 01046:01049>
[00021.039] 01046:01049> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00021.039] 01046:01049> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00021.039] 01046:01049> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00021.039] 01046:01049> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00021.039] 01046:01049> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00021.039] 01046:01049> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00021.039] 01046:01049> bt#00: 0xffffffff100ab264
[00021.039] 01046:01049> bt#01: 0xffffffff100b9f3c
[00021.039] 01046:01049> bt#02: 0xffffffff10095554
[00021.039] 01046:01049> bt#03: 0xffffffff10094270
[00021.039] 01046:01049> bt#04: 0xffffffff100ab550
[00021.039] 01046:01049> bt#05: 0xffffffff100314a4
[00021.039] 01046:01049> bt#06: 0xffffffff10053354
[00021.039] 01046:01049> bt#07: 0xffffffff100d0d78
[00021.039] 01046:01049> bt#08: 0xffffffff100de8d0
[00021.039] 01046:01049> bt#09: 0xffffffff100949dc
[00021.039] 01046:01049> bt#10: end
[00021.039] 01046:01049> {{{bt:0:0xffffffff100ab264}}}
[00021.039] 01046:01049> {{{bt:1:0xffffffff100b9f3c}}}
[00021.039] 01046:01049> {{{bt:2:0xffffffff10095554}}}
[00021.039] 01046:01049> {{{bt:3:0xffffffff10094270}}}
[00021.039] 01046:01049> {{{bt:4:0xffffffff100ab550}}}
[00021.039] 01046:01049> {{{bt:5:0xffffffff100314a4}}}
[00021.039] 01046:01049> {{{bt:6:0xffffffff10053354}}}
[00021.039] 01046:01049> {{{bt:7:0xffffffff100d0d78}}}
[00021.039] 01046:01049> {{{bt:8:0xffffffff100de8d0}}}
[00021.040] 01046:01049> {{{bt:9:0xffffffff100949dc}}}
[00021.040] 01046:01049>
[00021.040] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsPartiallyUnmappedBufferIsInvalidArgs (0
[00021.040] 01046:01049> ms)
[00021.040] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsRequiresInspectRights
[00021.040] 01046:01049>
[00021.040] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsRequiresInspectRights (0
[00021.040] 01046:01049> ms)
[00021.040] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsJobHandleIsBadHandle
[00021.040] 01046:01049>
[00021.040] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsJobHandleIsBadHandle (0
[00021.040] 01046:01049> ms)
[00021.040] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsThreadHandleIsBadHandle
[00021.040] 01046:01049>
[00021.040] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsThreadHandleIsBadHandle (0
[00021.040] 01046:01049> ms)
[00021.040] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosSmokeTest
[00021.040] 01046:01049>
[00021.040] 01046:01049>
[00021.040] 01046:01049> ZIRCON KERNEL PANIC
[00021.040] 01046:01049> Lock validation failed for thread 0xffff00004003af00 pid 1046 tid 1049 (bin/core-tests:bin/core-tests):
[00021.040] 01046:01049> Reason: Out Of Order
[00021.040] 01046:01049> Bad lock: name=lockdep::LockClass<ProcessDispatcher, BrwLock, 360, lockdep::LockFlagsNone> order=0
[00021.040] 01046:01049> Conflict: name=lockdep::LockClass<SoloDispatcher<ProcessDispatcher, 447439, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0
[00021.040] 01046:01049> caller=0xffffffff100316fc frame=0xffff00860a899c20
[00021.040] 01046:01049> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00021.040] 01046:01049>
[00021.040] 01046:01049> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00021.040] 01046:01049> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00021.040] 01046:01049> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00021.040] 01046:01049> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00021.040] 01046:01049> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00021.040] 01046:01049> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00021.040] 01046:01049> bt#00: 0xffffffff100316fc
[00021.040] 01046:01049> bt#01: 0xffffffff100534e4
[00021.040] 01046:01049> bt#02: 0xffffffff100d0350
[00021.040] 01046:01049> bt#03: 0xffffffff100de8d0
[00021.040] 01046:01049> bt#04: 0xffffffff100949dc
[00021.040] 01046:01049> bt#05: end
[00021.040] 01046:01049> {{{bt:0:0xffffffff100316fc}}}
[00021.040] 01046:01049> {{{bt:1:0xffffffff100534e4}}}
[00021.040] 01046:01049> {{{bt:2:0xffffffff100d0350}}}
[00021.040] 01046:01049> {{{bt:3:0xffffffff100de8d0}}}
[00021.040] 01046:01049> {{{bt:4:0xffffffff100949dc}}}
[00021.040] 01046:01049>
[00021.040] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosSmokeTest (0
[00021.040] 01046:01049> ms)
[00021.040] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosOnSelfFails
[00021.040] 01046:01049>
[00021.040] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosOnSelfFails (0
[00021.040] 01046:01049> ms)
[00021.040] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosInvalidHandleFails
[00021.040] 01046:01049>
[00021.040] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosInvalidHandleFails (0
[00021.040] 01046:01049> ms)
[00021.040] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosNullAvailSucceeds
[00021.040] 01046:01049>
[00021.040] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosNullAvailSucceeds (0
[00021.040] 01046:01049> ms)
[00021.040] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosNullActualSucceeds
[00021.040] 01046:01049>
[00021.040] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosNullActualSucceeds (0
[00021.040] 01046:01049> ms)
[00021.040] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosNullActualAndAvailSucceeds
[00021.040] 01046:01049>
[00021.040] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosNullActualAndAvailSucceeds (0
[00021.040] 01046:01049> ms)
[00021.040] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosInvalidBufferPointerFails
[00021.040] 01046:01049>
[00021.040] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosInvalidBufferPointerFails (0
[00021.040] 01046:01049> ms)
[00021.040] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosBadActualgIsInvalidArg
[00021.040] 01046:01049>
[00021.040] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosBadActualgIsInvalidArg (0
[00021.040] 01046:01049> ms)
[00021.040] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosBadAvailIsInvalidArg
[00021.040] 01046:01049>
[00021.040] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosBadAvailIsInvalidArg (0
[00021.040] 01046:01049> ms)
[00021.040] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosZeroSizedBufferIsOk
[00021.040] 01046:01049>
[00021.040] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosZeroSizedBufferIsOk (0
[00021.040] 01046:01049> ms)
[00021.040] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosSmallBufferIsOk
[00021.040] 01046:01049>
[00021.040] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosSmallBufferIsOk (0
[00021.040] 01046:01049> ms)
[00021.040] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosPartiallyUnmappedBufferIsInvalidArgs
[00021.040] 01046:01049>
[00021.040] 01046:01049>
[00021.040] 01046:01049> ZIRCON KERNEL PANIC
[00021.040] 01046:01049> Lock validation failed for thread 0xffff00004003af00 pid 1046 tid 1049 (bin/core-tests:bin/core-tests):
[00021.040] 01046:01049> Reason: Already Acquired
[00021.040] 01046:01049> Bad lock: name=lockdep::LockClass<VmAspace, Mutex, 199, lockdep::LockFlagsNone> order=0
[00021.040] 01046:01049> Conflict: name=lockdep::LockClass<VmAspace, Mutex, 199, lockdep::LockFlagsNone> order=0
[00021.040] 01046:01049> caller=0xffffffff100ab264 frame=0xffff00860a8998f0
[00021.040] 01046:01049> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00021.040] 01046:01049>
[00021.040] 01046:01049> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00021.040] 01046:01049> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00021.040] 01046:01049> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00021.040] 01046:01049> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00021.040] 01046:01049> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00021.040] 01046:01049> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00021.040] 01046:01049> bt#00: 0xffffffff100ab264
[00021.040] 01046:01049> bt#01: 0xffffffff100b9f3c
[00021.040] 01046:01049> bt#02: 0xffffffff10095554
[00021.040] 01046:01049> bt#03: 0xffffffff10094270
[00021.040] 01046:01049> bt#04: 0xffffffff100a5cd4
[00021.040] 01046:01049> bt#05: 0xffffffff100ab570
[00021.040] 01046:01049> bt#06: 0xffffffff100315bc
[00021.040] 01046:01049> bt#07: 0xffffffff10053558
[00021.040] 01046:01049> bt#08: 0xffffffff100d0350
[00021.040] 01046:01049> bt#09: 0xffffffff100de8d0
[00021.040] 01046:01049> bt#10: 0xffffffff100949dc
[00021.040] 01046:01049> bt#11: end
[00021.040] 01046:01049> {{{bt:0:0xffffffff100ab264}}}
[00021.040] 01046:01049> {{{bt:1:0xffffffff100b9f3c}}}
[00021.040] 01046:01049> {{{bt:2:0xffffffff10095554}}}
[00021.040] 01046:01049> {{{bt:3:0xffffffff10094270}}}
[00021.040] 01046:01049> {{{bt:4:0xffffffff100a5cd4}}}
[00021.040] 01046:01049> {{{bt:5:0xffffffff100ab570}}}
[00021.040] 01046:01049> {{{bt:6:0xffffffff100315bc}}}
[00021.040] 01046:01049> {{{bt:7:0xffffffff10053558}}}
[00021.040] 01046:01049> {{{bt:8:0xffffffff100d0350}}}
[00021.040] 01046:01049> {{{bt:9:0xffffffff100de8d0}}}
[00021.040] 01046:01049> {{{bt:10:0xffffffff100949dc}}}
[00021.040] 01046:01049>
[00021.040] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosPartiallyUnmappedBufferIsInvalidArgs (0
[00021.040] 01046:01049> ms)
[00021.040] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosRequiresInspectRights
[00021.040] 01046:01049>
[00021.040] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosRequiresInspectRights (0
[00021.040] 01046:01049> ms)
[00021.040] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosJobHandleIsBadHandle
[00021.040] 01046:01049>
[00021.040] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosJobHandleIsBadHandle (0
[00021.040] 01046:01049> ms)
[00021.040] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosThreadHandleIsBadHandle
[00021.040] 01046:01049>
[00021.040] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosThreadHandleIsBadHandle (0
[00021.040] 01046:01049> ms)
[00021.040] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoHandleBasicOnSelfSuceeds
[00021.040] 01046:01049>
[00021.040] 01046:01049> [ OK ] ProcessGetInfoTest.InfoHandleBasicOnSelfSuceeds (0
[00021.040] 01046:01049> ms)
[00021.040] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoHandleBasicInvalidHandleFails
[00021.040] 01046:01049>
[00021.040] 01046:01049> [ OK ] ProcessGetInfoTest.InfoHandleBasicInvalidHandleFails (0
[00021.040] 01046:01049> ms)
[00021.040] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoHandleBasicNullAvailSucceeds
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoHandleBasicNullAvailSucceeds (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoHandleBasicNullActualSucceeds
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoHandleBasicNullActualSucceeds (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoHandleBasicInvalidBufferPointerFails
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoHandleBasicInvalidBufferPointerFails (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoHandleBasicZeroSizedFails
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoHandleBasicZeroSizedFails (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessOnSelfSuceeds
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessOnSelfSuceeds (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessInvalidHandleFails
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessInvalidHandleFails (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessNullAvailSucceeds
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessNullAvailSucceeds (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessNullActualSucceeds
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessNullActualSucceeds (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessNullActualAndAvailSucceeds
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessNullActualAndAvailSucceeds (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessInvalidBufferPointerFails
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessInvalidBufferPointerFails (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessBadActualgIsInvalidArg
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessBadActualgIsInvalidArg (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessBadAvailIsInvalidArg
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessBadAvailIsInvalidArg (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessZeroSizedBufferFails
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessZeroSizedBufferFails (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessJobHandleIsBadHandle
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessJobHandleIsBadHandle (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessThreadHandleIsBadHandle
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessThreadHandleIsBadHandle (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsSelfSuceeds
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessThreadsSelfSuceeds (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsInvalidHandleFails
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessThreadsInvalidHandleFails (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsNullAvailSucceeds
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessThreadsNullAvailSucceeds (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsNullActualSucceeds
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessThreadsNullActualSucceeds (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsNullActualAndAvailSucceeds
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessThreadsNullActualAndAvailSucceeds (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsInvalidBufferPointerFails
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessThreadsInvalidBufferPointerFails (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsBadActualgIsInvalidArg
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessThreadsBadActualgIsInvalidArg (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsBadAvailIsInvalidArg
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessThreadsBadAvailIsInvalidArg (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsZeroSizedBufferSucceeds
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessThreadsZeroSizedBufferSucceeds (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [----------] 61 tests from ProcessGetInfoTest (2
[00021.041] 01046:01049> ms total)
[00021.041] 01046:01049> [----------] 12 tests from TaskGetInfoTest
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ RUN ] TaskGetInfoTest.InfoStatsUnstartedSuceeds
[00021.041] 01046:01049>
[00021.041] 01046:01049> [ OK ] TaskGetInfoTest.InfoStatsUnstartedSuceeds (0
[00021.041] 01046:01049> ms)
[00021.041] 01046:01049> [ RUN ] TaskGetInfoTest.InfoStatsSmokeTest
[00021.041] 01046:01049>
[00021.042] 01046:01049> [ OK ] TaskGetInfoTest.InfoStatsSmokeTest (0
[00021.042] 01046:01049> ms)
[00021.042] 01046:01049> [ RUN ] TaskGetInfoTest.InfoTaskStatsInvalidHandleFails
[00021.042] 01046:01049>
[00021.042] 01046:01049> [ OK ] TaskGetInfoTest.InfoTaskStatsInvalidHandleFails (0
[00021.042] 01046:01049> ms)
[00021.042] 01046:01049> [ RUN ] TaskGetInfoTest.InfoTaskStatsNullAvailSucceeds
[00021.042] 01046:01049>
[00021.042] 01046:01049> [ OK ] TaskGetInfoTest.InfoTaskStatsNullAvailSucceeds (0
[00021.042] 01046:01049> ms)
[00021.042] 01046:01049> [ RUN ] TaskGetInfoTest.InfoTaskStatsNullActualSucceeds
[00021.042] 01046:01049>
[00021.042] 01046:01049> [ OK ] TaskGetInfoTest.InfoTaskStatsNullActualSucceeds (0
[00021.042] 01046:01049> ms)
[00021.042] 01046:01049> [ RUN ] TaskGetInfoTest.InfoTaskStatsNullActualAndAvailSucceeds
[00021.042] 01046:01049>
[00021.042] 01046:01049> [ OK ] TaskGetInfoTest.InfoTaskStatsNullActualAndAvailSucceeds (0
[00021.042] 01046:01049> ms)
[00021.042] 01046:01049> [ RUN ] TaskGetInfoTest.InfoTaskStatsInvalidBufferPointerFails
[00021.042] 01046:01049>
[00021.042] 01046:01049> [ OK ] TaskGetInfoTest.InfoTaskStatsInvalidBufferPointerFails (0
[00021.042] 01046:01049> ms)
[00021.042] 01046:01049> [ RUN ] TaskGetInfoTest.InfoTaskStatsBadActualgIsInvalidArg
[00021.042] 01046:01049>
[00021.042] 01046:01049> [ OK ] TaskGetInfoTest.InfoTaskStatsBadActualgIsInvalidArg (0
[00021.042] 01046:01049> ms)
[00021.042] 01046:01049> [ RUN ] TaskGetInfoTest.InfoTaskStatsBadAvailIsInvalidArg
[00021.042] 01046:01049>
[00021.042] 01046:01049> [ OK ] TaskGetInfoTest.InfoTaskStatsBadAvailIsInvalidArg (0
[00021.042] 01046:01049> ms)
[00021.042] 01046:01049> [ RUN ] TaskGetInfoTest.InfoTaskStatsZeroSizedBufferIsTooSmall
[00021.042] 01046:01049>
[00021.042] 01046:01049> [ OK ] TaskGetInfoTest.InfoTaskStatsZeroSizedBufferIsTooSmall (0
[00021.042] 01046:01049> ms)
[00021.042] 01046:01049> [ RUN ] TaskGetInfoTest.InfoTaskStatsJobHandleIsBadHandle
[00021.042] 01046:01049>
[00021.042] 01046:01049> [ OK ] TaskGetInfoTest.InfoTaskStatsJobHandleIsBadHandle (0
[00021.042] 01046:01049> ms)
[00021.042] 01046:01049> [ RUN ] TaskGetInfoTest.InfoTaskStatsThreadHandleIsBadHandle
[00021.042] 01046:01049>
[00021.042] 01046:01049> [ OK ] TaskGetInfoTest.InfoTaskStatsThreadHandleIsBadHandle (0
[00021.042] 01046:01049> ms)
[00021.042] 01046:01049> [----------] 12 tests from TaskGetInfoTest (0
[00021.042] 01046:01049> ms total)
[00021.042] 01046:01049> [----------] 41 tests from ThreadGetInfoTest
[00021.042] 01046:01049>
[00021.042] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleBasicOnSelfSuceeds
[00021.042] 01046:01049>
[00021.042] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleBasicOnSelfSuceeds (0
[00021.042] 01046:01049> ms)
[00021.042] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleBasicInvalidHandleFails
[00021.042] 01046:01049>
[00021.042] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleBasicInvalidHandleFails (0
[00021.042] 01046:01049> ms)
[00021.042] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleBasicNullAvailSucceeds
[00021.042] 01046:01049>
[00021.042] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleBasicNullAvailSucceeds (0
[00021.042] 01046:01049> ms)
[00021.042] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleBasicNullActualSucceeds
[00021.042] 01046:01049>
[00021.042] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleBasicNullActualSucceeds (0
[00021.042] 01046:01049> ms)
[00021.042] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds
[00021.042] 01046:01049>
[00021.042] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds (0
[00021.042] 01046:01049> ms)
[00021.042] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleBasicInvalidBufferPointerFails
[00021.042] 01046:01049>
[00021.042] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleBasicInvalidBufferPointerFails (0
[00021.042] 01046:01049> ms)
[00021.042] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg
[00021.042] 01046:01049>
[00021.042] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg (0
[00021.042] 01046:01049> ms)
[00021.042] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg
[00021.042] 01046:01049>
[00021.042] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg (0
[00021.042] 01046:01049> ms)
[00021.042] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleBasicZeroSizedBufferFails
[00021.042] 01046:01049>
[00021.042] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleBasicZeroSizedBufferFails (0
[00021.042] 01046:01049> ms)
[00021.042] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleCountOnSelfSuceeds
[00021.042] 01046:01049>
[00021.042] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleCountOnSelfSuceeds (0
[00021.042] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleCountInvalidHandleFails
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleCountInvalidHandleFails (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleCountNullAvailSucceeds
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleCountNullAvailSucceeds (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleCountNullActualSucceeds
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleCountNullActualSucceeds (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleCountNullActualAndAvailSucceeds
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleCountNullActualAndAvailSucceeds (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleCountInvalidBufferPointerFails
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleCountInvalidBufferPointerFails (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleCountBadActualgIsInvalidArg
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleCountBadActualgIsInvalidArg (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleCountBadAvailIsInvalidArg
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleCountBadAvailIsInvalidArg (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleCountZeroSizedBufferFails
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleCountZeroSizedBufferFails (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadOnSelfSuceeds
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadOnSelfSuceeds (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadInvalidHandleFails
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadInvalidHandleFails (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadNullAvailSucceeds
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadNullAvailSucceeds (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadNullActualSucceeds
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadNullActualSucceeds (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadNullActualAndAvailSucceeds
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadNullActualAndAvailSucceeds (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadInvalidBufferPointerFails
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadInvalidBufferPointerFails (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadBadActualgIsInvalidArg
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadBadActualgIsInvalidArg (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadBadAvailIsInvalidArg
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadBadAvailIsInvalidArg (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadZeroSizedBufferFails
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadZeroSizedBufferFails (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadJobHandleIsBadHandle
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadJobHandleIsBadHandle (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadProcessHandleIsBadHandle
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadProcessHandleIsBadHandle (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadStatsOnSelfSuceeds
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadStatsOnSelfSuceeds (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadStatsInvalidHandleFails
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadStatsInvalidHandleFails (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadStatsNullAvailSucceeds
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadStatsNullAvailSucceeds (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadStatsNullActualSucceeds
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadStatsNullActualSucceeds (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadStatsNullActualAndAvailSucceeds
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadStatsNullActualAndAvailSucceeds (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadStatsInvalidBufferPointerFails
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadStatsInvalidBufferPointerFails (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadStatsBadActualgIsInvalidArg
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadStatsBadActualgIsInvalidArg (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadStatsBadAvailIsInvalidArg
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadStatsBadAvailIsInvalidArg (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadStatsZeroSizedBufferFails
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadStatsZeroSizedBufferFails (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadStatsJobHandleIsBadHandle
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadStatsJobHandleIsBadHandle (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadStatsProcessHandleIsBadHandle
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadStatsProcessHandleIsBadHandle (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadExceptionReportInvalidHandleFails
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadExceptionReportInvalidHandleFails (0
[00021.043] 01046:01049> ms)
[00021.043] 01046:01049> [----------] 41 tests from ThreadGetInfoTest (1
[00021.043] 01046:01049> ms total)
[00021.043] 01046:01049> [----------] 21 tests from VmarGetInfoTest
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ RUN ] VmarGetInfoTest.InfoHandleBasicOnSelfSuceeds
[00021.043] 01046:01049>
[00021.043] 01046:01049> [ OK ] VmarGetInfoTest.InfoHandleBasicOnSelfSuceeds (0
[00021.043] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] VmarGetInfoTest.InfoHandleBasicInvalidHandleFails
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] VmarGetInfoTest.InfoHandleBasicInvalidHandleFails (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] VmarGetInfoTest.InfoHandleBasicNullAvailSucceeds
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] VmarGetInfoTest.InfoHandleBasicNullAvailSucceeds (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] VmarGetInfoTest.InfoHandleBasicNullActualSucceeds
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] VmarGetInfoTest.InfoHandleBasicNullActualSucceeds (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] VmarGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] VmarGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] VmarGetInfoTest.InfoHandleBasicInvalidBufferPointerFails
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] VmarGetInfoTest.InfoHandleBasicInvalidBufferPointerFails (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] VmarGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] VmarGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] VmarGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] VmarGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] VmarGetInfoTest.InfoHandleBasicZeroSizedBufferFails
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] VmarGetInfoTest.InfoHandleBasicZeroSizedBufferFails (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarOnSelfFails
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarOnSelfFails (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarInvalidHandleFails
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarInvalidHandleFails (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarNullAvailSucceeds
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarNullAvailSucceeds (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarNullActualSucceeds
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarNullActualSucceeds (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarNullActualAndAvailSucceeds
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarNullActualAndAvailSucceeds (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarInvalidBufferPointerFails
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarInvalidBufferPointerFails (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarBadActualgIsInvalidArg
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarBadActualgIsInvalidArg (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarBadAvailIsInvalidArg
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarBadAvailIsInvalidArg (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarZeroSizedBufferFails
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarZeroSizedBufferFails (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarJobHandleIsBadHandle
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarJobHandleIsBadHandle (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarProcessHandleIsBadHandle
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarProcessHandleIsBadHandle (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarThreadHandleIsBadHandle
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarThreadHandleIsBadHandle (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [----------] 21 tests from VmarGetInfoTest (0
[00021.044] 01046:01049> ms total)
[00021.044] 01046:01049> [----------] 28 tests from SocketTest
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ RUN ] SocketTest.EndpointsAreRelated
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] SocketTest.EndpointsAreRelated (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] SocketTest.EmptySocketShouldWait
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] SocketTest.EmptySocketShouldWait (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] SocketTest.WriteReadDataVerify
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] SocketTest.WriteReadDataVerify (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] SocketTest.PeerClosedError
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] SocketTest.PeerClosedError (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] SocketTest.PeekingLeavesData
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] SocketTest.PeekingLeavesData (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] SocketTest.PeekingIntoEmpty
[00021.044] 01046:01049>
[00021.044] 01046:01049> [ OK ] SocketTest.PeekingIntoEmpty (0
[00021.044] 01046:01049> ms)
[00021.044] 01046:01049> [ RUN ] SocketTest.Signals
[00021.044] 01046:01049>
[00021.045] 01046:01049> [ OK ] SocketTest.Signals (0
[00021.045] 01046:01049> ms)
[00021.045] 01046:01049> [ RUN ] SocketTest.SetThreshholdsProp
[00021.045] 01046:01049>
[00021.045] 01046:01049> [ OK ] SocketTest.SetThreshholdsProp (0
[00021.045] 01046:01049> ms)
[00021.045] 01046:01049> [ RUN ] SocketTest.SetThreshholdsAndCheckSignals
[00021.045] 01046:01049>
[00021.045] 01046:01049> [ OK ] SocketTest.SetThreshholdsAndCheckSignals (0
[00021.045] 01046:01049> ms)
[00021.045] 01046:01049> [ RUN ] SocketTest.SignalClosedPeer
[00021.045] 01046:01049>
[00021.045] 01046:01049> [ OK ] SocketTest.SignalClosedPeer (0
[00021.045] 01046:01049> ms)
[00021.045] 01046:01049> [ RUN ] SocketTest.PeerClosedSetProperty
[00021.045] 01046:01049>
[00021.045] 01046:01049> [ OK ] SocketTest.PeerClosedSetProperty (0
[00021.045] 01046:01049> ms)
[00021.045] 01046:01049> [ RUN ] SocketTest.ShutdownWrite
[00021.045] 01046:01049>
[00021.045] 01046:01049> [ OK ] SocketTest.ShutdownWrite (0
[00021.045] 01046:01049> ms)
[00021.045] 01046:01049> [ RUN ] SocketTest.ShutdownRead
[00021.045] 01046:01049>
[00021.045] 01046:01049> [ OK ] SocketTest.ShutdownRead (0
[00021.045] 01046:01049> ms)
[00021.045] 01046:01049> [ RUN ] SocketTest.BytesOutstanding
[00021.045] 01046:01049>
[00021.045] 01046:01049> [ OK ] SocketTest.BytesOutstanding (0
[00021.045] 01046:01049> ms)
[00021.046] 01046:01049> [ RUN ] SocketTest.ShutdownWriteBytesOutstanding
[00021.046] 01046:01049>
[00021.046] 01046:01049> [ OK ] SocketTest.ShutdownWriteBytesOutstanding (0
[00021.046] 01046:01049> ms)
[00021.046] 01046:01049> [ RUN ] SocketTest.ShutdownReadBytesOutstanding
[00021.046] 01046:01049>
[00021.046] 01046:01049> [ OK ] SocketTest.ShutdownReadBytesOutstanding (0
[00021.046] 01046:01049> ms)
[00021.046] 01046:01049> [ RUN ] SocketTest.ShortWrite
[00021.046] 01046:01049>
[00021.046] 01046:01049> [ OK ] SocketTest.ShortWrite (0
[00021.046] 01046:01049> ms)
[00021.046] 01046:01049> [ RUN ] SocketTest.Datagram
[00021.046] 01046:01049>
[00021.046] 01046:01049> [ OK ] SocketTest.Datagram (0
[00021.046] 01046:01049> ms)
[00021.046] 01046:01049> [ RUN ] SocketTest.DatagramPeek
[00021.046] 01046:01049>
[00021.046] 01046:01049> [ OK ] SocketTest.DatagramPeek (0
[00021.046] 01046:01049> ms)
[00021.046] 01046:01049> [ RUN ] SocketTest.DatagramPeekEmpty
[00021.046] 01046:01049>
[00021.046] 01046:01049> [ OK ] SocketTest.DatagramPeekEmpty (0
[00021.046] 01046:01049> ms)
[00021.046] 01046:01049> [ RUN ] SocketTest.DatagramNoShortWrite
[00021.046] 01046:01049>
[00021.046] 01046:01049> [ OK ] SocketTest.DatagramNoShortWrite (0
[00021.046] 01046:01049> ms)
[00021.046] 01046:01049> [ RUN ] SocketTest.ControlPlaneAbsent
[00021.046] 01046:01049>
[00021.046] 01046:01049> [ OK ] SocketTest.ControlPlaneAbsent (0
[00021.046] 01046:01049> ms)
[00021.047] 01046:01049> [ RUN ] SocketTest.ControlPlane
[00021.047] 01046:01049>
[00021.047] 01046:01049> [ OK ] SocketTest.ControlPlane (0
[00021.047] 01046:01049> ms)
[00021.047] 01046:01049> [ RUN ] SocketTest.ControlPlanePeek
[00021.047] 01046:01049>
[00021.047] 01046:01049> [ OK ] SocketTest.ControlPlanePeek (0
[00021.047] 01046:01049> ms)
[00021.047] 01046:01049> [ RUN ] SocketTest.ControlPlanePeekEmpty
[00021.047] 01046:01049>
[00021.047] 01046:01049> [ OK ] SocketTest.ControlPlanePeekEmpty (0
[00021.047] 01046:01049> ms)
[00021.047] 01046:01049> [ RUN ] SocketTest.ControlPlaneShutdown
[00021.047] 01046:01049>
[00021.047] 01046:01049> [ OK ] SocketTest.ControlPlaneShutdown (0
[00021.047] 01046:01049> ms)
[00021.047] 01046:01049> [ RUN ] SocketTest.Accept
[00021.047] 01046:01049>
[00021.047] 01046:01049>
[00021.047] 01046:01049> ZIRCON KERNEL PANIC
[00021.047] 01046:01049> Lock validation failed for thread 0xffff00004003af00 pid 1046 tid 1049 (bin/core-tests:bin/core-tests):
[00021.047] 01046:01049> Reason: Already Acquired
[00021.047] 01046:01049> Bad lock: name=lockdep::LockClass<PeerHolder<SocketDispatcher>, Mutex, 319, lockdep::LockFlagsNone> order=0
[00021.047] 01046:01049> Conflict: name=lockdep::LockClass<PeerHolder<SocketDispatcher>, Mutex, 319, lockdep::LockFlagsNone> order=0
[00021.047] 01046:01049> caller=0xffffffff100345f4 frame=0xffff00860a899d10
[00021.047] 01046:01049> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00021.047] 01046:01049>
[00021.047] 01046:01049> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00021.047] 01046:01049> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00021.047] 01046:01049> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00021.047] 01046:01049> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00021.047] 01046:01049> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00021.047] 01046:01049> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00021.047] 01046:01049> bt#00: 0xffffffff100345f4
[00021.047] 01046:01049> bt#01: 0xffffffff1003fd28
[00021.047] 01046:01049> bt#02: 0xffffffff10058b64
[00021.047] 01046:01049> bt#03: 0xffffffff100d6804
[00021.047] 01046:01049> bt#04: 0xffffffff100e0170
[00021.047] 01046:01049> bt#05: 0xffffffff10094a80
[00021.047] 01046:01049> bt#06: end
[00021.047] 01046:01049> {{{bt:0:0xffffffff100345f4}}}
[00021.047] 01046:01049> {{{bt:1:0xffffffff1003fd28}}}
[00021.047] 01046:01049> {{{bt:2:0xffffffff10058b64}}}
[00021.047] 01046:01049> {{{bt:3:0xffffffff100d6804}}}
[00021.047] 01046:01049> {{{bt:4:0xffffffff100e0170}}}
[00021.047] 01046:01049> {{{bt:5:0xffffffff10094a80}}}
[00021.047] 01046:01049>
[00021.047] 01046:01049>
[00021.047] 01046:01049> ZIRCON KERNEL PANIC
[00021.047] 01046:01049> Lock validation failed for thread 0xffff00004003af00 pid 1046 tid 1049 (bin/core-tests:bin/core-tests):
[00021.047] 01046:01049> Reason: Already Acquired
[00021.047] 01046:01049> Bad lock: name=lockdep::LockClass<PeerHolder<SocketDispatcher>, Mutex, 319, lockdep::LockFlagsNone> order=0
[00021.047] 01046:01049> Conflict: name=lockdep::LockClass<PeerHolder<SocketDispatcher>, Mutex, 319, lockdep::LockFlagsNone> order=0
[00021.047] 01046:01049> caller=0xffffffff10059594 frame=0xffff00860a899d40
[00021.047] 01046:01049> BUILDID git-71aec42d0c4724cc52eab689479bcf4335695c4c-dirty
[00021.047] 01046:01049>
[00021.047] 01046:01049> {{{module:0:kernel:elf:493e35f11d886ad5}}}
[00021.047] 01046:01049> {{{mmap:0xffffffff10000000:0x10bcb0:load:0:rx:0xffffffff00000000}}}
[00021.047] 01046:01049> {{{mmap:0xffffffff1010c000:0x3e000:load:0:r:0xffffffff0010c000}}}
[00021.047] 01046:01049> {{{mmap:0xffffffff1014a000:0xed0:load:0:rw:0xffffffff0014a000}}}
[00021.047] 01046:01049> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}}
[00021.047] 01046:01049> dso: id=493e35f11d886ad5 base=0xffffffff10000000 name=zircon.elf
[00021.047] 01046:01049> bt#00: 0xffffffff10059594
[00021.047] 01046:01049> bt#01: 0xffffffff1003fdc4
[00021.047] 01046:01049> bt#02: 0xffffffff10058b64
[00021.047] 01046:01049> bt#03: 0xffffffff100d6804
[00021.047] 01046:01049> bt#04: 0xffffffff100e0170
[00021.047] 01046:01049> bt#05: 0xffffffff10094a80
[00021.047] 01046:01049> bt#06: end
[00021.047] 01046:01049> {{{bt:0:0xffffffff10059594}}}
[00021.047] 01046:01049> {{{bt:1:0xffffffff1003fdc4}}}
[00021.047] 01046:01049> {{{bt:2:0xffffffff10058b64}}}
[00021.047] 01046:01049> {{{bt:3:0xffffffff100d6804}}}
[00021.047] 01046:01049> {{{bt:4:0xffffffff100e0170}}}
[00021.047] 01046:01049> {{{bt:5:0xffffffff10094a80}}}
[00021.047] 01046:01049>
[00021.047] 01046:01049> [ OK ] SocketTest.Accept (0
[00021.047] 01046:01049> ms)
[00021.047] 01046:01049> [ RUN ] SocketTest.ZeroSize
[00021.047] 01046:01049>
[00021.047] 01046:01049> [ OK ] SocketTest.ZeroSize (0
[00021.047] 01046:01049> ms)
[00021.047] 01046:01049> [----------] 28 tests from SocketTest (2
[00021.047] 01046:01049> ms total)
[00021.047] 01046:01049> [----------] Global test environment tear-down.
[00021.047] 01046:01049> [==========] 242 tests from 13 test cases ran (2721
[00021.047] 01046:01049> ms total).
[00021.047] 01046:01049> [ PASSED ] 242 tests
[00021.047] 01046:01049>
[00021.047] 01046:01049> core-tests succeeded RZMm59f7zOSs6aZUIXZR
[00021.048] 01032:01039> userboot: loader-service channel peer closed
[00021.048] 01032:01039> userboot: Waiting for bin/core-tests to exit...
[00021.049] 01032:01039> userboot: Process exited. Executing "poweroff".
[00021.050] 01032:01039> mp_unplug_cpu_mask_single_locked:362: WARNING: leaking thread for cpu 3
[00021.831] 01032:01039> mp_unplug_cpu_mask_single_locked:362: WARNING: leaking thread for cpu 2
[00021.833] 01032:01039> mp_unplug_cpu_mask_single_locked:362: WARNING: leaking thread for cpu 1
[00021.833] 01032:01039> Shutting down debuglog