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

2019/04/20 14:28:35 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.307] 00000:00000> cntpct_per_ns: 00000000.3333333333333333 [00001.307] 00000:00000> ns_per_cntpct: 00000005.0000000000000000 [00001.307] 00000:00000> test_time_conversion_check_result:253: FAIL, off by 230584300921369395 [00001.307] 00000:00000> reserving ramdisk phys range [0x48000000, 0x4813bfff] [00001.307] 00000:00000> PMM: boot reserve add [0x48000000, 0x4813bfff] [00001.368] 00000:00000> PMM: boot reserve marking WIRED [0x48000000, 0x4813bfff] [00001.368] 00000:00000> PMM: boot reserve marking WIRED [0x48290000, 0x48455fff] [00001.368] 00000:00000> [00001.368] 00000:00000> welcome to Zircon [00001.368] 00000:00000> [00001.368] 00000:00000> KASLR: .text section at 0xffffffff10000000 [00001.368] 00000:00000> INIT: cpu 0, calling hook 0xffffffff1001dbbc (global_prng_seed) at level 0x30000, flags 0x1 [00001.383] 00000:00000> initializing vm pre-heap [00001.383] 00000:00000> VM: marking boot alloc used range [0x48456000, 0x4845b040) [00001.385] 00000:00000> INIT: cpu 0, calling hook 0xffffffff1002c8a0 (elf_build_id) at level 0x4fffe, flags 0x1 [00001.385] 00000:00000> INIT: cpu 0, calling hook 0xffffffff1002ca44 (version) at level 0x4ffff, flags 0x1 [00001.385] 00000:00000> version: [00001.385] 00000:00000> arch: arm64 [00001.385] 00000:00000> platform: XXX [00001.385] 00000:00000> target: XXX [00001.385] 00000:00000> project: arm64 [00001.385] 00000:00000> buildid: git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00001.385] 00000:00000> ELF build ID: c195e43bc3eeddba [00001.385] 00000:00000> initializing heap [00001.385] 00000:00000> INIT: cpu 0, calling hook 0xffffffff10002240 (arm_resource_init) at level 0x50000, flags 0x1 [00001.385] 00000:00000> INIT: cpu 0, calling hook 0xffffffff1000366c (console) at level 0x50000, flags 0x1 [00001.385] 00000:00000> initializing vm [00001.385] 00000:00000> VM: reserving kernel region [0xffffffff10000000, 0xffffffff1010e000) flags 0x28 name 'kernel_code' [00001.386] 00000:00000> VM: reserving kernel region [0xffffffff1010e000, 0xffffffff1014c000) flags 0x8 name 'kernel_rodata' [00001.386] 00000:00000> VM: reserving kernel region [0xffffffff1014c000, 0xffffffff1014d000) flags 0x18 name 'kernel_data' [00001.386] 00000:00000> VM: reserving kernel region [0xffffffff10150000, 0xffffffff101c6000) flags 0x18 name 'kernel_bss' [00001.386] 00000:00000> INIT: cpu 0, calling hook 0xffffffff100018b8 (platform_init_pre_thread) at level 0x60000, flags 0x1 [00001.386] 00000:00000> System topology: CPU 0:0:0:0 [00001.386] 00000:00000> System topology: CPU 0:0:0:1 [00001.386] 00000:00000> System topology: CPU 0:0:0:2 [00001.386] 00000:00000> System topology: CPU 0:0:0:3 [00001.386] 00000:00000> INIT: cpu 0, calling hook 0xffffffff10001b74 (platform_postvm) at level 0x60000, flags 0x1 [00001.386] 00000:00000> CreateSubVmarInternal:114: warning: mapping periph has conflicting cache policies: vmo 00 arch_mmu_flags 02. [00001.386] 00000:00000> INIT: cpu 0, calling hook 0xffffffff100f6c98 (percpu_heap_init) at level 0x60003, flags 0x1 [00001.386] 00000:00000> initializing kernel [00001.386] 00000:00000> initializing mp [00001.386] 00000:00000> INIT: cpu 0, calling hook 0xffffffff1001de80 (global_prng_thread_safe) at level 0x7ffff, flags 0x1 [00001.386] 00000:00000> creating bootstrap completion thread [00001.386] 00000:00000> top of bootstrap2() [00001.386] 00000:00000> INIT: cpu 0, calling hook 0xffffffff1003eb30 (libobject) at level 0x80000, flags 0x1 [00001.386] 00000:00000> OOM: started thread [00001.386] 00000:00000> INIT: cpu 0, calling hook 0xffffffff100f3294 (dpc) at level 0x80000, flags 0x1 [00001.386] 00000:00000> INIT: cpu 0, calling hook 0xffffffff1010cc60 (lockdep) at level 0x80000, flags 0x1 [00001.386] 00000:00000> ARM boot EL1 [00001.386] 00000:00000> ARM cpu 0: midr 0x431f0af1 'Cavium CN99XX r1p1' mpidr 0x80000000 aff 0:0:0:0 [00001.386] 00000:00000> ARM Features: fp asimd aes pmull sha1 sha2 crc32 atomics rdm [00001.386] 00000:00000> ARM cache line sizes: icache 64 dcache 64 zva 64 [00001.386] 00000:00000> ==== ARM64 CACHE INFO CORE 0 ==== [00001.386] 00000:00000> Inner Boundary = L0 [00001.386] 00000:00000> Level of Unification Uniprocessor = L1 [00001.386] 00000:00000> Level of Coherence = L3 [00001.386] 00000:00000> Level of Unification Inner Shareable = L1 [00001.386] 00000:00000> L1 Details: Data Cache, sets=64, associativity=8, line size=64 bytes [00001.386] 00000:00000> Instruction Cache, sets=64, associativity=8, line size=64 bytes [00001.386] 00000:00000> L2 Details: Unified Cache, sets=512, associativity=8, line size=64 bytes [00001.386] 00000:00000> L3 Details: Unified Cache, sets=16384, associativity=32, line size=64 bytes [00001.386] 00000:00000> L4 Details: Not Implemented [00001.386] 00000:00000> L5 Details: Not Implemented [00001.386] 00000:00000> L6 Details: Not Implemented [00001.386] 00000:00000> L7 Details: Not Implemented [00001.386] 00000:00000> initializing platform [00001.386] 00000:00000> INIT: cpu 0, calling hook 0xffffffff10098aa8 (arm64_perfmon) at level 0x90000, flags 0x1 [00001.386] 00000:00000> Trying to start cpu 1 returned: 0 [00001.386] 00000:00000> Trying to start cpu 2 returned: 0 [00001.386] 00000:00000> Trying to start cpu 3 returned: 0 [00001.386] 00000:00000> initializing target [00001.386] 00000:00000> INIT: cpu 0, calling hook 0xffffffff1008e57c (platform_dev_init) at level 0xa0000, flags 0x1 [00001.386] 00000:00000> UART: started IRQ driven TX [00001.386] 00000:00000> moving to last init level [00001.386] 00000:00000> INIT: cpu 0, calling hook 0xffffffff1002bffc (debuglog) at level 0xb0000, flags 0x1 [00001.386] 00000:00000> INIT: cpu 0, calling hook 0xffffffff1007f514 (kcounters) at level 0xb0000, flags 0x1 [00001.386] 00000:00000> INIT: cpu 0, calling hook 0xffffffff10003b5c (kernel_shell) at level 0xc0000, flags 0x1 [00001.386] 00000:00000> INIT: cpu 0, calling hook 0xffffffff100efb6c (ktrace) at level 0xc0000, flags 0x1 [00001.468] 00000:00000> ktrace: buffer at 0xffff008b44394000 (33554432 bytes) [00001.468] 00000:00000> INIT: cpu 0, calling hook 0xffffffff101087cc (userboot) at level 0xc0000, flags 0x1 [00001.468] 00000:00000> userboot: ramdisk 0x13c000 @ 0xffff000048000000 [00001.468] 00000:00000> userboot: userboot rodata 0 @ [0x9ae990461000,0x9ae990463000) [00001.468] 00000:00000> userboot: userboot code 0x2000 @ [0x9ae990463000,0x9ae990467000) [00001.468] 00000:00000> userboot: vdso/full rodata 0 @ [0x9ae990467000,0x9ae99046d000) [00001.468] 00000:00000> userboot: vdso/full code 0x6000 @ [0x9ae99046d000,0x9ae99046f000) [00001.468] 00000:00000> userboot: entry point @ 0x9ae990463b60 [00001.471] 01032:01039> userboot: option "userboot=bin/core-tests" [00001.471] 01032:01039> userboot: option "userboot.shutdown=" [00001.471] 01032:01039> userboot: option "kernel.halt-on-panic=true" [00001.471] 01032:01039> userboot: option "devmgr.suspend-timeout-debug=true" [00001.471] 01032:01039> userboot: option "TERM=dumb" [00001.485] 01032:01039> userboot: searching bootfs for 'bin/core-tests' [00001.485] 01032:01039> userboot: 'bin/core-tests' has PT_INTERP "lib/ld.so.1" [00001.485] 01032:01039> userboot: searching bootfs for 'lib/ld.so.1' [00001.485] 01032:01039> userboot: userboot: loaded lib/ld.so.1 at 0xcc26b1aa3000, entry point 0xcc26b1aeb318 [00001.485] 01032:01039> userboot: userboot: loaded vDSO at 0xf63714e22000, entry point 0xf63714e28a20 [00001.485] 01032:01039> userboot: process bin/core-tests started. [00001.485] 01032:01039> userboot: waiting for loader-service requests... [00001.494] 01032:01039> userboot: searching bootfs for 'lib/libfdio.so' [00001.498] 01032:01039> userboot: searching bootfs for 'lib/libunittest.so' [00001.507] 01032:01039> userboot: searching bootfs for 'lib/libmini-process.so' [00001.516] 01032:01039> userboot: searching bootfs for 'lib/libinspector.so' [00001.524] 01032:01039> userboot: searching bootfs for 'lib/libbacktrace.so' [00001.529] 01046:01049> {{{reset}}} [00001.529] 01046:01049> {{{module:0:<application>:elf:5d399e53a9b55c57}}} [00001.529] 01046:01049> {{{mmap:0xfaf699332000:0x4b000:load:0:r:0}}} [00001.529] 01046:01049> {{{mmap:0xfaf69937d000:0x135000:load:0:rx:0x4b000}}} [00001.529] 01046:01049> {{{mmap:0xfaf6994b2000:0x9000:load:0:rw:0x180000}}} [00001.529] 01046:01049> {{{mmap:0xfaf6994bb000:0x2000:load:0:rw:0x189000}}} [00001.529] 01046:01049> dso: id=5d399e53a9b55c57 base=0x0000faf699332000 name=<application> [00001.529] 01046:01049> {{{module:0x3:libfdio.so:elf:959eea3604636d51}}} [00001.529] 01046:01049> {{{mmap:0x247b9a74f000:0xb000:load:0x3:r:0}}} [00001.529] 01046:01049> {{{mmap:0x247b9a75a000:0x1a000:load:0x3:rx:0xb000}}} [00001.529] 01046:01049> {{{mmap:0x247b9a774000:0x2000:load:0x3:rw:0x25000}}} [00001.529] 01046:01049> {{{mmap:0x247b9a776000:0x2000:load:0x3:rw:0x27000}}} [00001.529] 01046:01049> dso: id=959eea3604636d51 base=0x0000247b9a74f000 name=libfdio.so [00001.529] 01046:01049> {{{module:0x4:libunittest.so:elf:5e146513e5a933f2}}} [00001.529] 01046:01049> {{{mmap:0x6b2beb1ff000:0x4000:load:0x4:r:0}}} [00001.529] 01046:01049> {{{mmap:0x6b2beb203000:0x3000:load:0x4:rx:0x4000}}} [00001.529] 01046:01049> {{{mmap:0x6b2beb206000:0x1000:load:0x4:rw:0x7000}}} [00001.529] 01046:01049> {{{mmap:0x6b2beb207000:0x2000:load:0x4:rw:0x8000}}} [00001.529] 01046:01049> dso: id=5e146513e5a933f2 base=0x00006b2beb1ff000 name=libunittest.so [00001.529] 01046:01049> {{{module:0x2:<vDSO>:elf:943f08c781db91fd}}} [00001.529] 01046:01049> {{{mmap:0xf63714e22000:0x6000:load:0x2:r:0}}} [00001.529] 01046:01049> {{{mmap:0xf63714e28000:0x2000:load:0x2:rx:0x6000}}} [00001.529] 01046:01049> dso: id=943f08c781db91fd base=0x0000f63714e22000 name=<vDSO> [00001.529] 01046:01049> {{{module:0x5:libmini-process.so:elf:42d0b3f6b8fe1368}}} [00001.529] 01046:01049> {{{mmap:0xe57d933f9000:0x2000:load:0x5:r:0}}} [00001.529] 01046:01049> {{{mmap:0xe57d933fb000:0x2000:load:0x5:rx:0x2000}}} [00001.529] 01046:01049> {{{mmap:0xe57d933fd000:0x1000:load:0x5:rw:0x4000}}} [00001.529] 01046:01049> {{{mmap:0xe57d933fe000:0x1000:load:0x5:rw:0x5000}}} [00001.529] 01046:01049> dso: id=42d0b3f6b8fe1368 base=0x0000e57d933f9000 name=libmini-process.so [00001.529] 01046:01049> {{{module:0x6:libinspector.so:elf:918da762c7a4738c}}} [00001.529] 01046:01049> {{{mmap:0xa0e18b714000:0x6000:load:0x6:r:0}}} [00001.529] 01046:01049> {{{mmap:0xa0e18b71a000:0x14000:load:0x6:rx:0x6000}}} [00001.529] 01046:01049> {{{mmap:0xa0e18b72e000:0x1000:load:0x6:rw:0x1a000}}} [00001.529] 01046:01049> {{{mmap:0xa0e18b72f000:0x37000:load:0x6:rw:0x1b000}}} [00001.529] 01046:01049> dso: id=918da762c7a4738c base=0x0000a0e18b714000 name=libinspector.so [00001.529] 01046:01049> {{{module:0x7:libbacktrace.so:elf:9c1b7a73933a2f9d}}} [00001.529] 01046:01049> {{{mmap:0x6b5646454000:0x2000:load:0x7:r:0}}} [00001.529] 01046:01049> {{{mmap:0x6b5646456000:0xa000:load:0x7:rx:0x2000}}} [00001.529] 01046:01049> {{{mmap:0x6b5646460000:0x1000:load:0x7:rw:0xc000}}} [00001.529] 01046:01049> dso: id=9c1b7a73933a2f9d base=0x00006b5646454000 name=libbacktrace.so [00001.529] 01046:01049> {{{module:0x1:libc.so:elf:1779c5c1f1ea634e}}} [00001.529] 01046:01049> {{{mmap:0xcc26b1aa3000:0x42000:load:0x1:r:0}}} [00001.529] 01046:01049> {{{mmap:0xcc26b1ae5000:0x53000:load:0x1:rx:0x42000}}} [00001.529] 01046:01049> {{{mmap:0xcc26b1b38000:0x2000:load:0x1:rw:0x95000}}} [00001.529] 01046:01049> {{{mmap:0xcc26b1b3a000:0x3000:load:0x1:rw:0x97000}}} [00001.529] 01046:01049> dso: id=1779c5c1f1ea634e base=0x0000cc26b1aa3000 name=libc.so [00001.530] 01046:01049> TEST [00001.542] 01046:01049> CASE resource_tests [STARTED] [00001.542] 01046:01049> probe_address_space [RUNNING] [00001.542] 01046:01049> [PASSED] (0 ms) [00001.542] 01046:01049> TestBasicActions [RUNNING] [00001.542] 01046:01049> [PASSED] (0 ms) [00001.542] 01046:01049> TestExclusiveShared [RUNNING] [00001.542] 01046:01049> [PASSED] (0 ms) [00001.542] 01046:01049> TestSharedExclusive [RUNNING] [00001.542] 01046:01049> [PASSED] (0 ms) [00001.542] 01046:01049> TestInvalidArgs [RUNNING] [00001.542] 01046:01049> [PASSED] (0 ms) [00001.542] 01046:01049> TestVmoCreation [RUNNING] [00001.542] 01046:01049> [PASSED] (0 ms) [00001.542] 01046:01049> TestVmoCreationSmaller [RUNNING] [00001.542] 01046:01049> [PASSED] (0 ms) [00001.542] 01046:01049> TestVmoCreationUnaligned [RUNNING] [00001.542] 01046:01049> [PASSED] (0 ms) [00001.542] 01046:01049> TestVmoReplaceAsExecutable [RUNNING] [00001.542] 01046:01049> [PASSED] (0 ms) [00001.542] 01046:01049> CASE resource_tests [PASSED] [00001.542] 01046:01049> CASE profile_tests [STARTED] [00001.542] 01046:01049> make_profile_fails [RUNNING] [00001.542] 01046:01049> [PASSED] (0 ms) [00001.542] 01046:01049> change_priority_via_profile [RUNNING] [00001.542] 01046:01049> [PASSED] (0 ms) [00001.542] 01046:01049> CASE profile_tests [PASSED] [00001.542] 01046:01049> CASE interrupt_tests [STARTED] [00001.542] 01046:01049> interrupt_test [RUNNING] [00001.542] 01046:01049> [PASSED] (0 ms) [00001.542] 01046:01049> interrupt_port_bound_test [RUNNING] [00001.542] 01046:01049> [PASSED] (0 ms) [00001.542] 01046:01049> interrupt_port_non_bindable_test [RUNNING] [00001.542] 01046:01049> [PASSED] (0 ms) [00001.542] 01046:01049> interrupt_suspend_test [RUNNING] [00001.556] 01046:01049> [PASSED] (13 ms) [00001.556] 01046:01049> interrupt_bind_vcpu_test [RUNNING] [00001.556] 01046:01049> Guest creation not supported [00001.556] 01046:01049> [PASSED] (0 ms) [00001.556] 01046:01049> interrupt_bind_vcpu_not_supported_test [RUNNING] [00001.556] 01046:01049> Guest creation not supported [00001.556] 01046:01049> [PASSED] (0 ms) [00001.556] 01046:01049> interrupt_bind_vcpu_already_bound_test [RUNNING] [00001.556] 01046:01049> Guest creation not supported [00001.556] 01046:01049> [PASSED] (0 ms) [00001.556] 01046:01049> interrupt_bind_vcpu_multiple_guests_test [RUNNING] [00001.556] 01046:01049> Guest creation not supported [00001.556] 01046:01049> [PASSED] (0 ms) [00001.556] 01046:01049> CASE interrupt_tests [PASSED] [00001.556] 01046:01049> CASE vmo_signal_tests [STARTED] [00001.556] 01046:01049> vmo_signal_sanity_test [RUNNING] [00001.556] 01046:01049> [PASSED] (0 ms) [00001.556] 01046:01049> vmo_child_signal_clone_test [RUNNING] [00001.556] 01046:01049> [PASSED] (0 ms) [00001.556] 01046:01049> vmo_child_signal_map_test [RUNNING] [00001.556] 01046:01049> [PASSED] (0 ms) [00001.556] 01046:01049> CASE vmo_signal_tests [PASSED] [00001.556] 01046:01049> CASE vmar_tests [STARTED] [00001.556] 01046:01049> destroy_root_test [RUNNING] [00001.556] 01046:01049> [PASSED] (0 ms) [00001.556] 01046:01049> basic_allocate_test [RUNNING] [00001.556] 01046:01049> [PASSED] (0 ms) [00001.556] 01046:01049> allocate_oob_test [RUNNING] [00001.556] 01046:01049> [PASSED] (0 ms) [00001.556] 01046:01049> allocate_unsatisfiable_test [RUNNING] [00001.556] 01046:01049> [PASSED] (0 ms) [00001.556] 01046:01049> destroyed_vmar_test [RUNNING] [00001.556] 01046:01049> [PASSED] (0 ms) [00001.556] 01046:01049> map_over_destroyed_test [RUNNING] [00001.556] 01046:01049> [PASSED] (0 ms) [00001.556] 01046:01049> map_in_compact_test [RUNNING] [00001.556] 01046:01049> [PASSED] (0 ms) [00001.556] 01046:01049> overmapping_test [RUNNING] [00001.556] 01046:01049> [PASSED] (0 ms) [00001.556] 01046:01049> invalid_args_test [RUNNING] [00001.557] 01046:01049> [PASSED] (0 ms) [00001.557] 01046:01049> unaligned_len_test [RUNNING] [00001.557] 01046:01049> [PASSED] (0 ms) [00001.557] 01046:01049> unaligned_len_map_test [RUNNING] [00001.557] 01046:01049> [PASSED] (0 ms) [00001.557] 01046:01049> rights_drop_test [RUNNING] [00001.557] 01046:01049> [PASSED] (0 ms) [00001.557] 01046:01049> protect_test [RUNNING] [00001.557] 01046:01049> [PASSED] (0 ms) [00001.557] 01046:01049> nested_region_perms_test [RUNNING] [00001.557] 01046:01049> [PASSED] (0 ms) [00001.557] 01046:01049> object_info_test [RUNNING] [00001.557] 01046:01049> [PASSED] (0 ms) [00001.557] 01046:01049> unmap_split_test [RUNNING] [00001.557] 01046:01049> [PASSED] (0 ms) [00001.557] 01046:01049> unmap_multiple_test [RUNNING] [00001.557] 01046:01049> [PASSED] (0 ms) [00001.557] 01046:01049> unmap_base_not_mapped_test [RUNNING] [00001.557] 01046:01049> [PASSED] (0 ms) [00001.557] 01046:01049> map_specific_overwrite_test [RUNNING] [00001.557] 01046:01049> [PASSED] (0 ms) [00001.557] 01046:01049> protect_split_test [RUNNING] [00001.557] 01046:01049> [PASSED] (0 ms) [00001.557] 01046:01049> protect_multiple_test [RUNNING] [00001.557] 01046:01049> [PASSED] (0 ms) [00001.557] 01046:01049> protect_over_demand_paged_test [RUNNING] [00001.625] 01046:01049> [PASSED] (67 ms) [00001.625] 01046:01049> protect_large_uncommitted_test [RUNNING] [00001.679] 01046:01049> [PASSED] (54 ms) [00001.679] 01046:01049> unmap_large_uncommitted_test [RUNNING] [00001.681] 01046:01282> PageFault: 1030183 free pages [00001.681] 01046:01282> [00001.681] 01046:01282> ZIRCON KERNEL PANIC [00001.681] 01046:01282> Lock validation failed for thread 0xffff00004003b970 pid 1046 tid 1282 (bin/core-tests:vmar_test_addr): [00001.681] 01046:01282> Reason: Already Acquired [00001.681] 01046:01282> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00001.681] 01046:01282> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00001.681] 01046:01282> caller=0xffffffff1004478c frame=0xffff008b463a6c90 [00001.681] 01046:01282> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00001.681] 01046:01282> [00001.681] 01046:01282> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00001.681] 01046:01282> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00001.681] 01046:01282> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00001.681] 01046:01282> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00001.681] 01046:01282> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00001.681] 01046:01282> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00001.681] 01046:01282> bt#00: 0xffffffff1004478c [00001.681] 01046:01282> bt#01: 0xffffffff10044b3c [00001.681] 01046:01282> bt#02: 0xffffffff10031c50 [00001.681] 01046:01282> bt#03: 0xffffffff100b9bb0 [00001.681] 01046:01282> bt#04: 0xffffffff10095554 [00001.681] 01046:01282> bt#05: 0xffffffff1009447c [00001.681] 01046:01282> bt#06: end [00001.681] 01046:01282> {{{bt:0:0xffffffff1004478c}}} [00001.681] 01046:01282> {{{bt:1:0xffffffff10044b3c}}} [00001.681] 01046:01282> {{{bt:2:0xffffffff10031c50}}} [00001.681] 01046:01282> {{{bt:3:0xffffffff100b9bb0}}} [00001.681] 01046:01282> {{{bt:4:0xffffffff10095554}}} [00001.681] 01046:01282> {{{bt:5:0xffffffff1009447c}}} [00001.681] 01046:01282> [00001.698] 01046:01285> PageFault: 1030183 free pages [00001.698] 01046:01285> [00001.698] 01046:01285> ZIRCON KERNEL PANIC [00001.698] 01046:01285> Lock validation failed for thread 0xffff00004003b970 pid 1046 tid 1285 (bin/core-tests:vmar_test_addr): [00001.698] 01046:01285> Reason: Already Acquired [00001.698] 01046:01285> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00001.698] 01046:01285> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00001.698] 01046:01285> caller=0xffffffff1004478c frame=0xffff008b463a6c90 [00001.698] 01046:01285> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00001.698] 01046:01285> [00001.698] 01046:01285> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00001.698] 01046:01285> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00001.698] 01046:01285> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00001.698] 01046:01285> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00001.698] 01046:01285> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00001.698] 01046:01285> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00001.698] 01046:01285> bt#00: 0xffffffff1004478c [00001.698] 01046:01285> bt#01: 0xffffffff10044b3c [00001.698] 01046:01285> bt#02: 0xffffffff10031c50 [00001.698] 01046:01285> bt#03: 0xffffffff100b9bb0 [00001.698] 01046:01285> bt#04: 0xffffffff10095554 [00001.698] 01046:01285> bt#05: 0xffffffff1009447c [00001.698] 01046:01285> bt#06: end [00001.698] 01046:01285> {{{bt:0:0xffffffff1004478c}}} [00001.698] 01046:01285> {{{bt:1:0xffffffff10044b3c}}} [00001.698] 01046:01285> {{{bt:2:0xffffffff10031c50}}} [00001.698] 01046:01285> {{{bt:3:0xffffffff100b9bb0}}} [00001.698] 01046:01285> {{{bt:4:0xffffffff10095554}}} [00001.698] 01046:01285> {{{bt:5:0xffffffff1009447c}}} [00001.698] 01046:01285> [00001.716] 01046:01288> PageFault: 1030183 free pages [00001.716] 01046:01288> [00001.716] 01046:01288> ZIRCON KERNEL PANIC [00001.716] 01046:01288> Lock validation failed for thread 0xffff00004003b970 pid 1046 tid 1288 (bin/core-tests:vmar_test_addr): [00001.716] 01046:01288> Reason: Already Acquired [00001.716] 01046:01288> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00001.716] 01046:01288> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00001.716] 01046:01288> caller=0xffffffff1004478c frame=0xffff008b463a6c90 [00001.716] 01046:01288> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00001.716] 01046:01288> [00001.716] 01046:01288> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00001.716] 01046:01288> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00001.716] 01046:01288> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00001.716] 01046:01288> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00001.716] 01046:01288> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00001.716] 01046:01288> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00001.716] 01046:01288> bt#00: 0xffffffff1004478c [00001.716] 01046:01288> bt#01: 0xffffffff10044b3c [00001.716] 01046:01288> bt#02: 0xffffffff10031c50 [00001.716] 01046:01288> bt#03: 0xffffffff100b9bb0 [00001.716] 01046:01288> bt#04: 0xffffffff10095554 [00001.716] 01046:01288> bt#05: 0xffffffff1009447c [00001.716] 01046:01288> bt#06: end [00001.716] 01046:01288> {{{bt:0:0xffffffff1004478c}}} [00001.716] 01046:01288> {{{bt:1:0xffffffff10044b3c}}} [00001.716] 01046:01288> {{{bt:2:0xffffffff10031c50}}} [00001.716] 01046:01288> {{{bt:3:0xffffffff100b9bb0}}} [00001.716] 01046:01288> {{{bt:4:0xffffffff10095554}}} [00001.716] 01046:01288> {{{bt:5:0xffffffff1009447c}}} [00001.716] 01046:01288> [00001.728] 01046:01049> [PASSED] (48 ms) [00001.728] 01046:01049> partial_unmap_and_read [RUNNING] [00001.728] 01046:01049> [PASSED] (0 ms) [00001.728] 01046:01049> partial_unmap_and_write [RUNNING] [00001.728] 01046:01049> [PASSED] (0 ms) [00001.728] 01046:01049> partial_unmap_with_vmar_offset [RUNNING] [00001.728] 01046:01049> [PASSED] (0 ms) [00001.728] 01046:01049> CASE vmar_tests [PASSED] [00001.728] 01046:01049> CASE ticks_tests [STARTED] [00001.728] 01046:01049> elapsed_time_using_ticks [RUNNING] [00001.728] 01046:01049> [PASSED] (0 ms) [00001.728] 01046:01049> CASE ticks_tests [PASSED] [00001.728] 01046:01049> CASE threads_tests [STARTED] [00001.728] 01046:01049> TestBasics [RUNNING] [00001.828] 01046:01049> [PASSED] (100 ms) [00001.828] 01046:01049> TestInvalidRights [RUNNING] [00001.828] 01046:01049> [PASSED] (0 ms) [00001.828] 01046:01049> TestDetach [RUNNING] [00001.832] 01046:01049> [PASSED] (3 ms) [00001.832] 01046:01049> TestLongNameSucceeds [RUNNING] [00001.832] 01046:01049> [PASSED] (0 ms) [00001.832] 01046:01049> TestThreadStartOnInitialThread [RUNNING] [00001.832] 01046:01049> [PASSED] (0 ms) [00001.832] 01046:01049> TestThreadStartWithZeroInstructionPointer [RUNNING] [00001.837] 01046:01049> [00001.837] 01046:01049> ZIRCON KERNEL PANIC [00001.837] 01046:01049> Lock validation failed for thread 0xffff000040031188 pid 1046 tid 1049 (bin/core-tests:bin/core-tests): [00001.837] 01046:01049> Reason: Out Of Order [00001.837] 01046:01049> Bad lock: name=lockdep::LockClass<SoloDispatcher<ThreadDispatcher, 316111, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00001.837] 01046:01049> Conflict: name=lockdep::LockClass<SoloDispatcher<ProcessDispatcher, 447439, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00001.837] 01046:01049> caller=0xffffffff1005b360 frame=0xffff008b43394d60 [00001.837] 01046:01049> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00001.837] 01046:01049> [00001.837] 01046:01049> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00001.837] 01046:01049> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00001.837] 01046:01049> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00001.837] 01046:01049> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00001.837] 01046:01049> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00001.837] 01046:01049> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00001.837] 01046:01049> bt#00: 0xffffffff1005b360 [00001.837] 01046:01049> bt#01: 0xffffffff10051844 [00001.837] 01046:01049> bt#02: 0xffffffff10051e30 [00001.837] 01046:01049> bt#03: 0xffffffff100d8ff4 [00001.837] 01046:01049> bt#04: 0xffffffff100e21fc [00001.837] 01046:01049> bt#05: 0xffffffff10094b70 [00001.837] 01046:01049> bt#06: end [00001.837] 01046:01049> {{{bt:0:0xffffffff1005b360}}} [00001.837] 01046:01049> {{{bt:1:0xffffffff10051844}}} [00001.837] 01046:01049> {{{bt:2:0xffffffff10051e30}}} [00001.837] 01046:01049> {{{bt:3:0xffffffff100d8ff4}}} [00001.837] 01046:01049> {{{bt:4:0xffffffff100e21fc}}} [00001.837] 01046:01049> {{{bt:5:0xffffffff10094b70}}} [00001.837] 01046:01049> [00001.848] 01046:01049> [PASSED] (16 ms) [00001.848] 01046:01049> TestKillBusyThread [RUNNING] [00001.950] 01046:01049> [PASSED] (101 ms) [00001.950] 01046:01049> TestKillSleepThread [RUNNING] [00002.050] 01046:01049> [PASSED] (100 ms) [00002.050] 01046:01049> TestKillWaitThread [RUNNING] [00002.150] 01046:01049> [PASSED] (100 ms) [00002.150] 01046:01049> TestNonstartedThread [RUNNING] [00002.150] 01046:01049> [PASSED] (0 ms) [00002.150] 01046:01049> TestThreadKillsItself [RUNNING] [00002.154] 01046:01049> [PASSED] (3 ms) [00002.154] 01046:01049> TestInfoTaskStatsFails [RUNNING] [00002.254] 01046:01049> [PASSED] (100 ms) [00002.254] 01046:01049> TestResumeSuspended [RUNNING] [00002.356] 01046:01049> [PASSED] (101 ms) [00002.356] 01046:01049> TestSuspendSleeping [RUNNING] [00002.456] 01046:01049> [PASSED] (100 ms) [00002.456] 01046:01049> TestSuspendChannelCall [RUNNING] [00002.457] 01046:01049> [PASSED] (1 ms) [00002.457] 01046:01049> TestSuspendPortCall [RUNNING] [00002.584] 00000:00000> INIT: cpu 1, calling hook 0xffffffff10090bac (arm_generic_timer_init_secondary_cpu) at level 0x7ffff, flags 0x2 [00002.584] 00000:00000> ARM cpu 1: midr 0x431f0af1 'Cavium CN99XX r1p1' mpidr 0x80000001 aff 0:0:0:1 [00002.584] 00000:00000> entering scheduler on cpu 1 [00002.598] 00000:00000> INIT: cpu 3, calling hook 0xffffffff10090bac (arm_generic_timer_init_secondary_cpu) at level 0x7ffff, flags 0x2 [00002.598] 00000:00000> ARM cpu 3: midr 0x431f0af1 'Cavium CN99XX r1p1' mpidr 0x80000003 aff 0:0:0:3 [00002.598] 00000:00000> entering scheduler on cpu 3 [00002.613] 00000:00000> INIT: cpu 2, calling hook 0xffffffff10090bac (arm_generic_timer_init_secondary_cpu) at level 0x7ffff, flags 0x2 [00002.613] 00000:00000> ARM cpu 2: midr 0x431f0af1 'Cavium CN99XX r1p1' mpidr 0x80000002 aff 0:0:0:2 [00002.613] 00000:00000> entering scheduler on cpu 2 [00002.658] 01046:01049> [PASSED] (200 ms) [00002.658] 01046:01049> TestSuspendStopsThread [RUNNING] [00002.708] 01046:01049> [PASSED] (50 ms) [00002.708] 01046:01049> TestSuspendMultiple [RUNNING] [00002.708] 01046:01049> [PASSED] (0 ms) [00002.708] 01046:01049> TestSuspendSelf [RUNNING] [00002.708] 01046:01049> [PASSED] (0 ms) [00002.708] 01046:01049> TestKillSuspendedThread [RUNNING] [00002.708] 01046:01049> [PASSED] (0 ms) [00002.708] 01046:01049> TestStartSuspendedThread [RUNNING] [00002.708] 01046:01049> [PASSED] (0 ms) [00002.708] 01046:01049> TestStartSuspendedAndResumedThread [RUNNING] [00002.708] 01046:01049> [PASSED] (0 ms) [00002.708] 01046:01049> TestSuspendSingleWaitAsyncSignalDelivery [RUNNING] [00002.709] 01046:01049> [PASSED] (0 ms) [00002.709] 01046:01049> TestSuspendRepeatingWaitAsyncSignalDelivery [RUNNING] [00002.709] 01046:01049> [PASSED] (0 ms) [00002.709] 01046:01049> TestReadingGeneralRegisterState [RUNNING] [00002.809] 01046:01049> [PASSED] (100 ms) [00002.809] 01046:01049> TestWritingGeneralRegisterState [RUNNING] [00002.909] 01046:01049> [PASSED] (100 ms) [00002.909] 01046:01049> TestThreadLocalRegisterState [RUNNING] [00003.009] 01046:01049> [PASSED] (100 ms) [00003.009] 01046:01049> TestNoncanonicalRipAddress [RUNNING] [00003.009] 01046:01049> [PASSED] (0 ms) [00003.009] 01046:01049> TestWritingArmFlagsRegister [RUNNING] [00003.009] 01046:01049> [PASSED] (0 ms) [00003.009] 01046:01049> CASE threads_tests [PASSED] [00003.009] 01046:01049> CASE sync_mutex_tests [STARTED] [00003.009] 01046:01049> test_mutexes [RUNNING] [00003.017] 01046:01049> [PASSED] (7 ms) [00003.017] 01046:01049> test_try_mutexes [RUNNING] [00003.022] 01046:01049> [PASSED] (5 ms) [00003.022] 01046:01049> test_timeout_elapsed [RUNNING] [00003.523] 01046:01049> [PASSED] (500 ms) [00003.523] 01046:01049> CASE sync_mutex_tests [PASSED] [00003.523] 01046:01049> CASE sync_condition_tests [STARTED] [00003.523] 01046:01049> Condition::condition_test [RUNNING] [00003.523] 01046:01049> [PASSED] (0 ms) [00003.523] 01046:01049> Condition::condition_timeout_test [RUNNING] [00003.524] 01046:01049> [PASSED] (1 ms) [00003.524] 01046:01049> CASE sync_condition_tests [PASSED] [00003.524] 01046:01049> CASE sync_completion_tests [STARTED] [00003.524] 01046:01049> test_initializer [RUNNING] [00003.524] 01046:01049> [PASSED] (0 ms) [00003.524] 01046:01049> test_completions [RUNNING] [00003.533] 01046:01049> [PASSED] (8 ms) [00003.533] 01046:01049> test_timeout [RUNNING] [00003.534] 01046:01049> [PASSED] (0 ms) [00003.534] 01046:01049> CASE sync_completion_tests [PASSED] [00003.534] 01046:01049> CASE sync_completion_tests [STARTED] [00003.534] 01046:01049> test_initializer [RUNNING] [00003.534] 01046:01049> [PASSED] (0 ms) [00003.534] 01046:01049> test_completions [RUNNING] [00003.540] 01046:01049> [PASSED] (6 ms) [00003.540] 01046:01049> test_timeout [RUNNING] [00004.560] 01046:01049> [PASSED] (1019 ms) [00004.560] 01046:01049> test_signal_requeue [RUNNING] [00004.573] 01046:01049> [PASSED] (12 ms) [00004.573] 01046:01049> test_completion_signaled [RUNNING] [00004.573] 01046:01049> [PASSED] (0 ms) [00004.573] 01046:01049> CASE sync_completion_tests [PASSED] [00004.573] 01046:01049> CASE stack_tests [STARTED] [00004.573] 01046:01049> main_thread_stack_tests [RUNNING] [00004.573] 01046:01049> [PASSED] (0 ms) [00004.573] 01046:01049> other_thread_stack_tests [RUNNING] [00004.580] 01046:01049> [PASSED] (7 ms) [00004.580] 01046:01049> CASE stack_tests [PASSED] [00004.580] 01046:01049> CASE tls_tests [STARTED] [00004.580] 01046:01049> tls_test [RUNNING] [00006.587] 01046:01049> [PASSED] (2006 ms) [00006.587] 01046:01049> CASE tls_tests [PASSED] [00006.587] 01046:01049> CASE pthread_barrier_tests [STARTED] [00006.587] 01046:01049> test_barrier [RUNNING] [00006.610] 01046:01049> [PASSED] (23 ms) [00006.610] 01046:01049> CASE pthread_barrier_tests [PASSED] [00006.610] 01046:01049> CASE pthread_tests [STARTED] [00006.610] 01046:01049> pthread_test [RUNNING] [00009.718] 01046:01049> [PASSED] (3108 ms) [00009.718] 01046:01049> pthread_self_main_thread_test [RUNNING] [00009.718] 01046:01049> [PASSED] (0 ms) [00009.718] 01046:01049> pthread_big_stack_size [RUNNING] [00009.752] 01046:01049> [PASSED] (34 ms) [00009.752] 01046:01049> pthread_getstack_main_thread [RUNNING] [00009.752] 01046:01049> [PASSED] (0 ms) [00009.753] 01046:01049> pthread_getstack_other_thread [RUNNING] [00009.753] 01046:01049> [PASSED] (0 ms) [00009.753] 01046:01049> CASE pthread_tests [PASSED] [00009.753] 01046:01049> CASE process_tests [STARTED] [00009.753] 01046:01049> mini_process_sanity [RUNNING] [00009.753] 01046:01049> [PASSED] (0 ms) [00009.753] 01046:01049> process_start_fail [RUNNING] [00009.753] 01046:01049> [PASSED] (0 ms) [00009.753] 01046:01049> process_start_no_handle [RUNNING] [00009.753] 01046:01049> [PASSED] (0 ms) [00009.753] 01046:01049> process_not_killed_via_thread_close [RUNNING] [00009.755] 01046:01049> [PASSED] (1 ms) [00009.755] 01046:01049> process_not_killed_via_process_close [RUNNING] [00009.756] 01046:01049> [PASSED] (1 ms) [00009.756] 01046:01049> kill_process_via_thread_kill [RUNNING] [00009.756] 01046:01049> [PASSED] (0 ms) [00009.756] 01046:01049> kill_process_via_vmar_destroy [RUNNING] [00009.756] 02073:02075> PageFault: 1029969 free pages [00009.756] 02073:02075> [00009.756] 02073:02075> ZIRCON KERNEL PANIC [00009.756] 02073:02075> Lock validation failed for thread 0xffff000040054168 pid 2073 tid 2075 (ttp:th): [00009.756] 02073:02075> Reason: Already Acquired [00009.756] 02073:02075> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00009.756] 02073:02075> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00009.756] 02073:02075> caller=0xffffffff1004478c frame=0xffff008b46416c90 [00009.756] 02073:02075> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00009.756] 02073:02075> [00009.756] 02073:02075> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00009.756] 02073:02075> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00009.756] 02073:02075> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00009.756] 02073:02075> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00009.756] 02073:02075> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00009.756] 02073:02075> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00009.756] 02073:02075> bt#00: 0xffffffff1004478c [00009.756] 02073:02075> bt#01: 0xffffffff10044b3c [00009.756] 02073:02075> bt#02: 0xffffffff10031c50 [00009.756] 02073:02075> bt#03: 0xffffffff100b9bb0 [00009.756] 02073:02075> bt#04: 0xffffffff10095188 [00009.756] 02073:02075> bt#05: 0xffffffff1009447c [00009.756] 02073:02075> bt#06: end [00009.756] 02073:02075> {{{bt:0:0xffffffff1004478c}}} [00009.756] 02073:02075> {{{bt:1:0xffffffff10044b3c}}} [00009.756] 02073:02075> {{{bt:2:0xffffffff10031c50}}} [00009.756] 02073:02075> {{{bt:3:0xffffffff100b9bb0}}} [00009.756] 02073:02075> {{{bt:4:0xffffffff10095188}}} [00009.756] 02073:02075> {{{bt:5:0xffffffff1009447c}}} [00009.756] 02073:02075> [00009.757] 01046:01049> [PASSED] (0 ms) [00009.757] 01046:01049> kill_channel_handle_cycle [RUNNING] [00010.507] 01046:01049> [PASSED] (750 ms) [00010.507] 01046:01049> info_reflects_process_state [RUNNING] [00010.758] 01046:01049> [PASSED] (250 ms) [00010.758] 01046:01049> suspend [RUNNING] [00010.758] 01046:01049> [PASSED] (0 ms) [00010.758] 01046:01049> suspend_self [RUNNING] [00010.758] 01046:01049> [PASSED] (0 ms) [00010.758] 01046:01049> suspend_multiple_threads [RUNNING] [00010.761] 01046:01049> [PASSED] (3 ms) [00010.761] 01046:01049> suspend_before_creating_threads [RUNNING] [00010.761] 01046:01049> [PASSED] (0 ms) [00010.761] 01046:01049> suspend_before_starting_threads [RUNNING] [00010.761] 01046:01049> [PASSED] (0 ms) [00010.761] 01046:01049> suspend_process_then_thread [RUNNING] [00011.011] 01046:01049> [PASSED] (250 ms) [00011.011] 01046:01049> suspend_thread_then_process [RUNNING] [00011.262] 01046:01049> [PASSED] (250 ms) [00011.262] 01046:01049> suspend_thread_and_process_before_starting_process [RUNNING] [00011.530] 01046:01049> [PASSED] (268 ms) [00011.530] 01046:01049> suspend_twice [RUNNING] [00011.780] 01046:01049> [PASSED] (250 ms) [00011.780] 01046:01049> suspend_twice_before_creating_threads [RUNNING] [00012.030] 01046:01049> [PASSED] (250 ms) [00012.030] 01046:01049> suspend_with_dying_thread [RUNNING] [00012.031] 01046:01049> [PASSED] (0 ms) [00012.031] 01046:01049> create_and_kill_job_race_stress [RUNNING] [00013.031] 01046:01049> [PASSED] (1000 ms) [00013.031] 01046:01049> CASE process_tests [PASSED] [00013.031] 01046:01049> CASE port_tests [STARTED] [00013.032] 01046:01049> basic_test [RUNNING] [00013.032] 01046:01049> [PASSED] (0 ms) [00013.032] 01046:01049> queue_and_close_test [RUNNING] [00013.032] 01046:01049> [PASSED] (0 ms) [00013.032] 01046:01049> queue_too_many [RUNNING] [00013.033] 01046:01049> [PASSED] (1 ms) [00013.033] 01046:01049> async_wait_channel_test [RUNNING] [00013.035] 01046:01049> [PASSED] (1 ms) [00013.035] 01046:01049> async_wait_event_test_single [RUNNING] [00013.035] 01046:01049> [PASSED] (0 ms) [00013.035] 01046:01049> async_wait_event_test_repeat [RUNNING] [00013.035] 01046:01049> [PASSED] (0 ms) [00013.035] 01046:01049> async_wait_event_all_processed [RUNNING] [00013.103] 01046:01049> [PASSED] (68 ms) [00013.103] 01046:01049> async_wait_invalid_option [RUNNING] [00013.103] 01046:01049> [PASSED] (0 ms) [00013.103] 01046:01049> async_wait_close_order_1 [RUNNING] [00013.103] 01046:01049> [PASSED] (0 ms) [00013.103] 01046:01049> async_wait_close_order_2 [RUNNING] [00013.103] 01046:01049> [PASSED] (0 ms) [00013.103] 01046:01049> async_wait_close_order_3 [RUNNING] [00013.103] 01046:01049> [PASSED] (0 ms) [00013.103] 01046:01049> async_wait_close_order_4 [RUNNING] [00013.103] 01046:01049> [PASSED] (0 ms) [00013.103] 01046:01049> async_wait_close_order_5 [RUNNING] [00013.103] 01046:01049> [PASSED] (0 ms) [00013.103] 01046:01049> async_wait_close_order_6 [RUNNING] [00013.103] 01046:01049> [PASSED] (0 ms) [00013.103] 01046:01049> channel_pre_writes_test [RUNNING] [00013.104] 01046:01049> [PASSED] (0 ms) [00013.104] 01046:01049> cancel_event_key [RUNNING] [00013.104] 01046:01049> [PASSED] (0 ms) [00013.104] 01046:01049> cancel_event_key_after [RUNNING] [00013.104] 01046:01049> [PASSED] (0 ms) [00013.104] 01046:01049> threads_event [RUNNING] [00013.104] 01046:01049> [PASSED] (0 ms) [00013.104] 01046:01049> cancel_stress [RUNNING] [00013.381] 01046:01049> [PASSED] (276 ms) [00013.381] 01046:01049> signal_close_stress [RUNNING] [00014.386] 01046:01049> [PASSED] (1004 ms) [00014.386] 01046:01049> port_close_wait_race_stress [RUNNING] [00015.387] 01046:01049> [PASSED] (1000 ms) [00015.387] 01046:01049> CASE port_tests [PASSED] [00015.387] 01046:01049> CASE api_violations [STARTED] [00015.387] 01046:01049> invalid_pager_create [RUNNING] [00015.387] 01046:01049> [PASSED] (0 ms) [00015.387] 01046:01049> invalid_pager_create_vmo [RUNNING] [00015.387] 01046:01049> [PASSED] (0 ms) [00015.387] 01046:01049> invalid_pager_detach_vmo [RUNNING] [00015.387] 01046:01049> [PASSED] (0 ms) [00015.387] 01046:01049> invalid_pager_supply_pages [RUNNING] [00015.387] 01046:01049> [PASSED] (0 ms) [00015.387] 01046:01049> resize_nonresizable_vmo [RUNNING] [00015.387] 01046:01049> [PASSED] (0 ms) [00015.387] 01046:01049> CASE api_violations [PASSED] [00015.387] 01046:01049> CASE commit_tests [STARTED] [00015.387] 01046:01049> simple_commit_test [RUNNING] [00015.388] 01046:01049> [PASSED] (1 ms) [00015.388] 01046:01049> split_commit_test [RUNNING] [00015.389] 01046:01049> [PASSED] (0 ms) [00015.389] 01046:01049> overlap_commit_test [RUNNING] [00015.389] 01046:01049> [PASSED] (0 ms) [00015.389] 01046:01049> overlap_commit_supply_test [RUNNING] [00015.399] 01046:01049> [PASSED] (10 ms) [00015.400] 01046:01049> multisupply_commit_test [RUNNING] [00015.400] 01046:01049> [PASSED] (0 ms) [00015.400] 01046:01049> multicommit_supply_test [RUNNING] [00015.401] 01046:01049> [PASSED] (0 ms) [00015.401] 01046:01049> commit_redundant_supply_test [RUNNING] [00015.401] 01046:01049> [PASSED] (0 ms) [00015.401] 01046:01049> supply_decommit_test [RUNNING] [00015.401] 01046:01049> [PASSED] (0 ms) [00015.401] 01046:01049> resize_commit_test [RUNNING] [00015.401] 01046:01049> [PASSED] (0 ms) [00015.401] 01046:01049> suspend_commit_test [RUNNING] [00015.402] 01046:01049> [PASSED] (0 ms) [00015.402] 01046:01049> CASE commit_tests [PASSED] [00015.402] 01046:01049> CASE clone_tests [STARTED] [00015.402] 01046:01049> clone_read_from_clone_test_vmar [RUNNING] [00015.402] 01046:01049> [PASSED] (0 ms) [00015.402] 01046:01049> clone_read_from_clone_test_vmo [RUNNING] [00015.402] 01046:01049> [PASSED] (0 ms) [00015.402] 01046:01049> clone_read_from_parent_test_vmar [RUNNING] [00015.403] 01046:01049> [PASSED] (0 ms) [00015.403] 01046:01049> clone_read_from_parent_test_vmo [RUNNING] [00015.403] 01046:01049> [PASSED] (0 ms) [00015.403] 01046:01049> clone_simultaneous_read_test_vmar [RUNNING] [00015.403] 01046:01049> [PASSED] (0 ms) [00015.403] 01046:01049> clone_simultaneous_read_test_vmo [RUNNING] [00015.404] 01046:01049> [PASSED] (0 ms) [00015.404] 01046:01049> clone_simultaneous_child_read_test_vmar [RUNNING] [00015.404] 01046:01049> [PASSED] (0 ms) [00015.404] 01046:01049> clone_simultaneous_child_read_test_vmo [RUNNING] [00015.405] 01046:01049> [PASSED] (0 ms) [00015.405] 01046:01049> clone_write_to_clone_test [RUNNING] [00015.405] 01046:01049> [PASSED] (0 ms) [00015.405] 01046:01049> clone_detach_test [RUNNING] [00015.405] 01046:01049> [PASSED] (0 ms) [00015.405] 01046:01049> clone_commit_test [RUNNING] [00015.405] 01046:01049> [PASSED] (0 ms) [00015.406] 01046:01049> clone_split_commit_test [RUNNING] [00015.406] 01046:01049> [PASSED] (0 ms) [00015.406] 01046:01049> clone_decommit_test [RUNNING] [00015.406] 01046:01049> [PASSED] (0 ms) [00015.406] 01046:01049> CASE clone_tests [PASSED] [00015.406] 01046:01049> CASE lifecycle_tests [STARTED] [00015.406] 01046:01049> vmo_info_pager_test [RUNNING] [00015.406] 01046:01049> [PASSED] (0 ms) [00015.406] 01046:01049> detach_page_complete_test [RUNNING] [00015.406] 01046:01049> [PASSED] (0 ms) [00015.406] 01046:01049> close_page_complete_test [RUNNING] [00015.406] 01046:01049> [PASSED] (0 ms) [00015.406] 01046:01049> read_detach_interrupt_late_test_vmar [RUNNING] [00015.406] 01046:67788> PageFault: 1028287 free pages [00015.406] 01046:67788> [00015.406] 01046:67788> ZIRCON KERNEL PANIC [00015.406] 01046:67788> Lock validation failed for thread 0xffff000042b30120 pid 1046 tid 67788 (bin/core-tests:test_thread): [00015.406] 01046:67788> Reason: Already Acquired [00015.406] 01046:67788> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.406] 01046:67788> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.406] 01046:67788> caller=0xffffffff1004478c frame=0xffff008b4640ec90 [00015.406] 01046:67788> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00015.406] 01046:67788> [00015.406] 01046:67788> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00015.406] 01046:67788> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00015.406] 01046:67788> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00015.406] 01046:67788> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00015.406] 01046:67788> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00015.406] 01046:67788> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00015.406] 01046:67788> bt#00: 0xffffffff1004478c [00015.406] 01046:67788> bt#01: 0xffffffff10044b3c [00015.406] 01046:67788> bt#02: 0xffffffff10031c50 [00015.406] 01046:67788> bt#03: 0xffffffff100b9bb0 [00015.406] 01046:67788> bt#04: 0xffffffff10095554 [00015.406] 01046:67788> bt#05: 0xffffffff1009447c [00015.406] 01046:67788> bt#06: end [00015.406] 01046:67788> {{{bt:0:0xffffffff1004478c}}} [00015.406] 01046:67788> {{{bt:1:0xffffffff10044b3c}}} [00015.406] 01046:67788> {{{bt:2:0xffffffff10031c50}}} [00015.406] 01046:67788> {{{bt:3:0xffffffff100b9bb0}}} [00015.406] 01046:67788> {{{bt:4:0xffffffff10095554}}} [00015.406] 01046:67788> {{{bt:5:0xffffffff1009447c}}} [00015.406] 01046:67788> [00015.406] 01046:67788> [00015.406] 01046:67788> ZIRCON KERNEL PANIC [00015.406] 01046:67788> Lock validation failed for thread 0xffff000042b30120 pid 1046 tid 67788 (bin/core-tests:test_thread): [00015.406] 01046:67788> Reason: Already Acquired [00015.406] 01046:67788> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.406] 01046:67788> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.406] 01046:67788> caller=0xffffffff1004478c frame=0xffff008b4640ebf0 [00015.406] 01046:67788> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00015.406] 01046:67788> [00015.406] 01046:67788> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00015.406] 01046:67788> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00015.406] 01046:67788> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00015.406] 01046:67788> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00015.406] 01046:67788> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00015.406] 01046:67788> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00015.406] 01046:67788> bt#00: 0xffffffff1004478c [00015.406] 01046:67788> bt#01: 0xffffffff10044b3c [00015.406] 01046:67788> bt#02: 0xffffffff10044b3c [00015.406] 01046:67788> bt#03: 0xffffffff10031c50 [00015.406] 01046:67788> bt#04: 0xffffffff100b9bb0 [00015.406] 01046:67788> bt#05: 0xffffffff10095554 [00015.406] 01046:67788> bt#06: 0xffffffff1009447c [00015.406] 01046:67788> bt#07: end [00015.406] 01046:67788> {{{bt:0:0xffffffff1004478c}}} [00015.406] 01046:67788> {{{bt:1:0xffffffff10044b3c}}} [00015.406] 01046:67788> {{{bt:2:0xffffffff10044b3c}}} [00015.406] 01046:67788> {{{bt:3:0xffffffff10031c50}}} [00015.406] 01046:67788> {{{bt:4:0xffffffff100b9bb0}}} [00015.406] 01046:67788> {{{bt:5:0xffffffff10095554}}} [00015.406] 01046:67788> {{{bt:6:0xffffffff1009447c}}} [00015.406] 01046:67788> [00015.406] 01046:67788> [00015.406] 01046:67788> ZIRCON KERNEL PANIC [00015.406] 01046:67788> Lock validation failed for thread 0xffff000042b30120 pid 1046 tid 67788 (bin/core-tests:test_thread): [00015.406] 01046:67788> Reason: Already Acquired [00015.406] 01046:67788> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.406] 01046:67788> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.406] 01046:67788> caller=0xffffffff1004478c frame=0xffff008b4640ebf0 [00015.406] 01046:67788> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00015.406] 01046:67788> [00015.406] 01046:67788> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00015.406] 01046:67788> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00015.406] 01046:67788> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00015.406] 01046:67788> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00015.406] 01046:67788> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00015.406] 01046:67788> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00015.406] 01046:67788> bt#00: 0xffffffff1004478c [00015.406] 01046:67788> bt#01: 0xffffffff10044b3c [00015.406] 01046:67788> bt#02: 0xffffffff10044b3c [00015.406] 01046:67788> bt#03: 0xffffffff10031c50 [00015.406] 01046:67788> bt#04: 0xffffffff100b9bb0 [00015.406] 01046:67788> bt#05: 0xffffffff10095554 [00015.406] 01046:67788> bt#06: 0xffffffff1009447c [00015.406] 01046:67788> bt#07: end [00015.406] 01046:67788> {{{bt:0:0xffffffff1004478c}}} [00015.406] 01046:67788> {{{bt:1:0xffffffff10044b3c}}} [00015.406] 01046:67788> {{{bt:2:0xffffffff10044b3c}}} [00015.406] 01046:67788> {{{bt:3:0xffffffff10031c50}}} [00015.406] 01046:67788> {{{bt:4:0xffffffff100b9bb0}}} [00015.406] 01046:67788> {{{bt:5:0xffffffff10095554}}} [00015.406] 01046:67788> {{{bt:6:0xffffffff1009447c}}} [00015.406] 01046:67788> [00015.406] 01046:01049> [PASSED] (0 ms) [00015.406] 01046:01049> read_detach_interrupt_late_test_vmo [RUNNING] [00015.407] 01046:01049> [PASSED] (0 ms) [00015.407] 01046:01049> read_close_interrupt_late_test_vmar [RUNNING] [00015.407] 01046:67808> PageFault: 1028287 free pages [00015.407] 01046:67808> [00015.407] 01046:67808> ZIRCON KERNEL PANIC [00015.407] 01046:67808> Lock validation failed for thread 0xffff000042b30120 pid 1046 tid 67808 (bin/core-tests:test_thread): [00015.407] 01046:67808> Reason: Already Acquired [00015.407] 01046:67808> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.407] 01046:67808> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.407] 01046:67808> caller=0xffffffff1004478c frame=0xffff008b4640ec90 [00015.407] 01046:67808> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00015.407] 01046:67808> [00015.407] 01046:67808> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00015.407] 01046:67808> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00015.407] 01046:67808> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00015.407] 01046:67808> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00015.407] 01046:67808> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00015.407] 01046:67808> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00015.407] 01046:67808> bt#00: 0xffffffff1004478c [00015.407] 01046:67808> bt#01: 0xffffffff10044b3c [00015.407] 01046:67808> bt#02: 0xffffffff10031c50 [00015.407] 01046:67808> bt#03: 0xffffffff100b9bb0 [00015.407] 01046:67808> bt#04: 0xffffffff10095554 [00015.407] 01046:67808> bt#05: 0xffffffff1009447c [00015.407] 01046:67808> bt#06: end [00015.407] 01046:67808> {{{bt:0:0xffffffff1004478c}}} [00015.407] 01046:67808> {{{bt:1:0xffffffff10044b3c}}} [00015.407] 01046:67808> {{{bt:2:0xffffffff10031c50}}} [00015.407] 01046:67808> {{{bt:3:0xffffffff100b9bb0}}} [00015.407] 01046:67808> {{{bt:4:0xffffffff10095554}}} [00015.407] 01046:67808> {{{bt:5:0xffffffff1009447c}}} [00015.407] 01046:67808> [00015.407] 01046:67808> [00015.407] 01046:67808> ZIRCON KERNEL PANIC [00015.407] 01046:67808> Lock validation failed for thread 0xffff000042b30120 pid 1046 tid 67808 (bin/core-tests:test_thread): [00015.407] 01046:67808> Reason: Already Acquired [00015.407] 01046:67808> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.407] 01046:67808> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.407] 01046:67808> caller=0xffffffff1004478c frame=0xffff008b4640ebf0 [00015.407] 01046:67808> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00015.407] 01046:67808> [00015.407] 01046:67808> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00015.407] 01046:67808> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00015.407] 01046:67808> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00015.407] 01046:67808> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00015.407] 01046:67808> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00015.407] 01046:67808> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00015.407] 01046:67808> bt#00: 0xffffffff1004478c [00015.407] 01046:67808> bt#01: 0xffffffff10044b3c [00015.407] 01046:67808> bt#02: 0xffffffff10044b3c [00015.407] 01046:67808> bt#03: 0xffffffff10031c50 [00015.407] 01046:67808> bt#04: 0xffffffff100b9bb0 [00015.407] 01046:67808> bt#05: 0xffffffff10095554 [00015.407] 01046:67808> bt#06: 0xffffffff1009447c [00015.407] 01046:67808> bt#07: end [00015.407] 01046:67808> {{{bt:0:0xffffffff1004478c}}} [00015.407] 01046:67808> {{{bt:1:0xffffffff10044b3c}}} [00015.407] 01046:67808> {{{bt:2:0xffffffff10044b3c}}} [00015.407] 01046:67808> {{{bt:3:0xffffffff10031c50}}} [00015.407] 01046:67808> {{{bt:4:0xffffffff100b9bb0}}} [00015.407] 01046:67808> {{{bt:5:0xffffffff10095554}}} [00015.407] 01046:67808> {{{bt:6:0xffffffff1009447c}}} [00015.407] 01046:67808> [00015.407] 01046:67808> [00015.407] 01046:67808> ZIRCON KERNEL PANIC [00015.407] 01046:67808> Lock validation failed for thread 0xffff000042b30120 pid 1046 tid 67808 (bin/core-tests:test_thread): [00015.407] 01046:67808> Reason: Already Acquired [00015.407] 01046:67808> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.407] 01046:67808> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.407] 01046:67808> caller=0xffffffff1004478c frame=0xffff008b4640ebf0 [00015.407] 01046:67808> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00015.407] 01046:67808> [00015.407] 01046:67808> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00015.407] 01046:67808> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00015.407] 01046:67808> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00015.407] 01046:67808> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00015.407] 01046:67808> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00015.407] 01046:67808> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00015.407] 01046:67808> bt#00: 0xffffffff1004478c [00015.407] 01046:67808> bt#01: 0xffffffff10044b3c [00015.407] 01046:67808> bt#02: 0xffffffff10044b3c [00015.407] 01046:67808> bt#03: 0xffffffff10031c50 [00015.407] 01046:67808> bt#04: 0xffffffff100b9bb0 [00015.407] 01046:67808> bt#05: 0xffffffff10095554 [00015.407] 01046:67808> bt#06: 0xffffffff1009447c [00015.407] 01046:67808> bt#07: end [00015.407] 01046:67808> {{{bt:0:0xffffffff1004478c}}} [00015.407] 01046:67808> {{{bt:1:0xffffffff10044b3c}}} [00015.407] 01046:67808> {{{bt:2:0xffffffff10044b3c}}} [00015.407] 01046:67808> {{{bt:3:0xffffffff10031c50}}} [00015.407] 01046:67808> {{{bt:4:0xffffffff100b9bb0}}} [00015.407] 01046:67808> {{{bt:5:0xffffffff10095554}}} [00015.407] 01046:67808> {{{bt:6:0xffffffff1009447c}}} [00015.407] 01046:67808> [00015.407] 01046:01049> [PASSED] (0 ms) [00015.407] 01046:01049> read_close_interrupt_late_test_vmo [RUNNING] [00015.407] 01046:01049> [PASSED] (0 ms) [00015.407] 01046:01049> read_detach_interrupt_early_test_vmar [RUNNING] [00015.408] 01046:67828> PageFault: 1028287 free pages [00015.408] 01046:67828> [00015.408] 01046:67828> ZIRCON KERNEL PANIC [00015.408] 01046:67828> Lock validation failed for thread 0xffff000042b30120 pid 1046 tid 67828 (bin/core-tests:test_thread): [00015.408] 01046:67828> Reason: Already Acquired [00015.408] 01046:67828> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.408] 01046:67828> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.408] 01046:67828> caller=0xffffffff1004478c frame=0xffff008b4640ec90 [00015.408] 01046:67828> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00015.408] 01046:67828> [00015.408] 01046:67828> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00015.408] 01046:67828> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00015.408] 01046:67828> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00015.408] 01046:67828> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00015.408] 01046:67828> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00015.408] 01046:67828> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00015.408] 01046:67828> bt#00: 0xffffffff1004478c [00015.408] 01046:67828> bt#01: 0xffffffff10044b3c [00015.408] 01046:67828> bt#02: 0xffffffff10031c50 [00015.408] 01046:67828> bt#03: 0xffffffff100b9bb0 [00015.408] 01046:67828> bt#04: 0xffffffff10095554 [00015.408] 01046:67828> bt#05: 0xffffffff1009447c [00015.408] 01046:67828> bt#06: end [00015.408] 01046:67828> {{{bt:0:0xffffffff1004478c}}} [00015.408] 01046:67828> {{{bt:1:0xffffffff10044b3c}}} [00015.408] 01046:67828> {{{bt:2:0xffffffff10031c50}}} [00015.408] 01046:67828> {{{bt:3:0xffffffff100b9bb0}}} [00015.408] 01046:67828> {{{bt:4:0xffffffff10095554}}} [00015.408] 01046:67828> {{{bt:5:0xffffffff1009447c}}} [00015.408] 01046:67828> [00015.408] 01046:67828> [00015.408] 01046:67828> ZIRCON KERNEL PANIC [00015.408] 01046:67828> Lock validation failed for thread 0xffff000042b30120 pid 1046 tid 67828 (bin/core-tests:test_thread): [00015.408] 01046:67828> Reason: Already Acquired [00015.408] 01046:67828> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.408] 01046:67828> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.408] 01046:67828> caller=0xffffffff1004478c frame=0xffff008b4640ebf0 [00015.408] 01046:67828> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00015.408] 01046:67828> [00015.408] 01046:67828> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00015.408] 01046:67828> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00015.408] 01046:67828> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00015.408] 01046:67828> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00015.408] 01046:67828> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00015.408] 01046:67828> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00015.408] 01046:67828> bt#00: 0xffffffff1004478c [00015.408] 01046:67828> bt#01: 0xffffffff10044b3c [00015.408] 01046:67828> bt#02: 0xffffffff10044b3c [00015.408] 01046:67828> bt#03: 0xffffffff10031c50 [00015.408] 01046:67828> bt#04: 0xffffffff100b9bb0 [00015.408] 01046:67828> bt#05: 0xffffffff10095554 [00015.408] 01046:67828> bt#06: 0xffffffff1009447c [00015.408] 01046:67828> bt#07: end [00015.408] 01046:67828> {{{bt:0:0xffffffff1004478c}}} [00015.408] 01046:67828> {{{bt:1:0xffffffff10044b3c}}} [00015.408] 01046:67828> {{{bt:2:0xffffffff10044b3c}}} [00015.408] 01046:67828> {{{bt:3:0xffffffff10031c50}}} [00015.408] 01046:67828> {{{bt:4:0xffffffff100b9bb0}}} [00015.408] 01046:67828> {{{bt:5:0xffffffff10095554}}} [00015.408] 01046:67828> {{{bt:6:0xffffffff1009447c}}} [00015.408] 01046:67828> [00015.408] 01046:67828> [00015.408] 01046:67828> ZIRCON KERNEL PANIC [00015.408] 01046:67828> Lock validation failed for thread 0xffff000042b30120 pid 1046 tid 67828 (bin/core-tests:test_thread): [00015.408] 01046:67828> Reason: Already Acquired [00015.408] 01046:67828> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.408] 01046:67828> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.408] 01046:67828> caller=0xffffffff1004478c frame=0xffff008b4640ebf0 [00015.408] 01046:67828> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00015.408] 01046:67828> [00015.408] 01046:67828> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00015.408] 01046:67828> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00015.408] 01046:67828> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00015.408] 01046:67828> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00015.408] 01046:67828> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00015.408] 01046:67828> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00015.408] 01046:67828> bt#00: 0xffffffff1004478c [00015.408] 01046:67828> bt#01: 0xffffffff10044b3c [00015.408] 01046:67828> bt#02: 0xffffffff10044b3c [00015.408] 01046:67828> bt#03: 0xffffffff10031c50 [00015.408] 01046:67828> bt#04: 0xffffffff100b9bb0 [00015.408] 01046:67828> bt#05: 0xffffffff10095554 [00015.408] 01046:67828> bt#06: 0xffffffff1009447c [00015.408] 01046:67828> bt#07: end [00015.408] 01046:67828> {{{bt:0:0xffffffff1004478c}}} [00015.408] 01046:67828> {{{bt:1:0xffffffff10044b3c}}} [00015.408] 01046:67828> {{{bt:2:0xffffffff10044b3c}}} [00015.408] 01046:67828> {{{bt:3:0xffffffff10031c50}}} [00015.408] 01046:67828> {{{bt:4:0xffffffff100b9bb0}}} [00015.408] 01046:67828> {{{bt:5:0xffffffff10095554}}} [00015.408] 01046:67828> {{{bt:6:0xffffffff1009447c}}} [00015.408] 01046:67828> [00015.408] 01046:01049> [PASSED] (0 ms) [00015.408] 01046:01049> read_detach_interrupt_early_test_vmo [RUNNING] [00015.408] 01046:01049> [PASSED] (0 ms) [00015.408] 01046:01049> read_close_interrupt_early_test_vmar [RUNNING] [00015.408] 01046:67848> PageFault: 1028287 free pages [00015.408] 01046:67848> [00015.408] 01046:67848> ZIRCON KERNEL PANIC [00015.408] 01046:67848> Lock validation failed for thread 0xffff000042b30120 pid 1046 tid 67848 (bin/core-tests:test_thread): [00015.408] 01046:67848> Reason: Already Acquired [00015.408] 01046:67848> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.408] 01046:67848> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.408] 01046:67848> caller=0xffffffff1004478c frame=0xffff008b4640ec90 [00015.408] 01046:67848> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00015.408] 01046:67848> [00015.408] 01046:67848> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00015.408] 01046:67848> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00015.408] 01046:67848> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00015.408] 01046:67848> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00015.408] 01046:67848> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00015.408] 01046:67848> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00015.408] 01046:67848> bt#00: 0xffffffff1004478c [00015.408] 01046:67848> bt#01: 0xffffffff10044b3c [00015.408] 01046:67848> bt#02: 0xffffffff10031c50 [00015.408] 01046:67848> bt#03: 0xffffffff100b9bb0 [00015.408] 01046:67848> bt#04: 0xffffffff10095554 [00015.408] 01046:67848> bt#05: 0xffffffff1009447c [00015.408] 01046:67848> bt#06: end [00015.408] 01046:67848> {{{bt:0:0xffffffff1004478c}}} [00015.408] 01046:67848> {{{bt:1:0xffffffff10044b3c}}} [00015.408] 01046:67848> {{{bt:2:0xffffffff10031c50}}} [00015.408] 01046:67848> {{{bt:3:0xffffffff100b9bb0}}} [00015.408] 01046:67848> {{{bt:4:0xffffffff10095554}}} [00015.408] 01046:67848> {{{bt:5:0xffffffff1009447c}}} [00015.408] 01046:67848> [00015.408] 01046:67848> [00015.408] 01046:67848> ZIRCON KERNEL PANIC [00015.408] 01046:67848> Lock validation failed for thread 0xffff000042b30120 pid 1046 tid 67848 (bin/core-tests:test_thread): [00015.408] 01046:67848> Reason: Already Acquired [00015.408] 01046:67848> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.408] 01046:67848> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.408] 01046:67848> caller=0xffffffff1004478c frame=0xffff008b4640ebf0 [00015.409] 01046:67848> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00015.409] 01046:67848> [00015.409] 01046:67848> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00015.409] 01046:67848> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00015.409] 01046:67848> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00015.409] 01046:67848> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00015.409] 01046:67848> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00015.409] 01046:67848> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00015.409] 01046:67848> bt#00: 0xffffffff1004478c [00015.409] 01046:67848> bt#01: 0xffffffff10044b3c [00015.409] 01046:67848> bt#02: 0xffffffff10044b3c [00015.409] 01046:67848> bt#03: 0xffffffff10031c50 [00015.409] 01046:67848> bt#04: 0xffffffff100b9bb0 [00015.409] 01046:67848> bt#05: 0xffffffff10095554 [00015.409] 01046:67848> bt#06: 0xffffffff1009447c [00015.409] 01046:67848> bt#07: end [00015.409] 01046:67848> {{{bt:0:0xffffffff1004478c}}} [00015.409] 01046:67848> {{{bt:1:0xffffffff10044b3c}}} [00015.409] 01046:67848> {{{bt:2:0xffffffff10044b3c}}} [00015.409] 01046:67848> {{{bt:3:0xffffffff10031c50}}} [00015.409] 01046:67848> {{{bt:4:0xffffffff100b9bb0}}} [00015.409] 01046:67848> {{{bt:5:0xffffffff10095554}}} [00015.409] 01046:67848> {{{bt:6:0xffffffff1009447c}}} [00015.409] 01046:67848> [00015.409] 01046:67848> [00015.409] 01046:67848> ZIRCON KERNEL PANIC [00015.409] 01046:67848> Lock validation failed for thread 0xffff000042b30120 pid 1046 tid 67848 (bin/core-tests:test_thread): [00015.409] 01046:67848> Reason: Already Acquired [00015.409] 01046:67848> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.409] 01046:67848> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.409] 01046:67848> caller=0xffffffff1004478c frame=0xffff008b4640ebf0 [00015.409] 01046:67848> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00015.409] 01046:67848> [00015.409] 01046:67848> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00015.409] 01046:67848> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00015.409] 01046:67848> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00015.409] 01046:67848> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00015.409] 01046:67848> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00015.409] 01046:67848> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00015.409] 01046:67848> bt#00: 0xffffffff1004478c [00015.409] 01046:67848> bt#01: 0xffffffff10044b3c [00015.409] 01046:67848> bt#02: 0xffffffff10044b3c [00015.409] 01046:67848> bt#03: 0xffffffff10031c50 [00015.409] 01046:67848> bt#04: 0xffffffff100b9bb0 [00015.409] 01046:67848> bt#05: 0xffffffff10095554 [00015.409] 01046:67848> bt#06: 0xffffffff1009447c [00015.409] 01046:67848> bt#07: end [00015.409] 01046:67848> {{{bt:0:0xffffffff1004478c}}} [00015.409] 01046:67848> {{{bt:1:0xffffffff10044b3c}}} [00015.409] 01046:67848> {{{bt:2:0xffffffff10044b3c}}} [00015.409] 01046:67848> {{{bt:3:0xffffffff10031c50}}} [00015.409] 01046:67848> {{{bt:4:0xffffffff100b9bb0}}} [00015.409] 01046:67848> {{{bt:5:0xffffffff10095554}}} [00015.409] 01046:67848> {{{bt:6:0xffffffff1009447c}}} [00015.409] 01046:67848> [00015.409] 01046:01049> [PASSED] (0 ms) [00015.409] 01046:01049> read_close_interrupt_early_test_vmo [RUNNING] [00015.409] 01046:01049> [PASSED] (0 ms) [00015.409] 01046:01049> thread_kill_test_vmar [RUNNING] [00015.410] 01046:01049> [PASSED] (0 ms) [00015.410] 01046:01049> thread_kill_test_vmo [RUNNING] [00015.410] 01046:01049> [PASSED] (0 ms) [00015.410] 01046:01049> thread_kill_overlap_test_vmar [RUNNING] [00015.411] 01046:01049> [PASSED] (0 ms) [00015.411] 01046:01049> thread_kill_overlap_test_vmo [RUNNING] [00015.411] 01046:01049> [PASSED] (0 ms) [00015.411] 01046:01049> close_pager_test [RUNNING] [00015.411] 01046:67939> PageFault: 1028209 free pages [00015.411] 01046:67939> [00015.411] 01046:67939> ZIRCON KERNEL PANIC [00015.411] 01046:67939> Lock validation failed for thread 0xffff00004299da00 pid 1046 tid 67939 (bin/core-tests:test_thread): [00015.411] 01046:67939> Reason: Already Acquired [00015.411] 01046:67939> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.411] 01046:67939> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.411] 01046:67939> caller=0xffffffff1004478c frame=0xffff008b46436c90 [00015.411] 01046:67939> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00015.411] 01046:67939> [00015.411] 01046:67939> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00015.411] 01046:67939> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00015.411] 01046:67939> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00015.411] 01046:67939> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00015.411] 01046:67939> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00015.411] 01046:67939> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00015.411] 01046:67939> bt#00: 0xffffffff1004478c [00015.411] 01046:67939> bt#01: 0xffffffff10044b3c [00015.411] 01046:67939> bt#02: 0xffffffff10031c50 [00015.411] 01046:67939> bt#03: 0xffffffff100b9bb0 [00015.411] 01046:67939> bt#04: 0xffffffff10095554 [00015.411] 01046:67939> bt#05: 0xffffffff1009447c [00015.411] 01046:67939> bt#06: end [00015.411] 01046:67939> {{{bt:0:0xffffffff1004478c}}} [00015.411] 01046:67939> {{{bt:1:0xffffffff10044b3c}}} [00015.411] 01046:67939> {{{bt:2:0xffffffff10031c50}}} [00015.411] 01046:67939> {{{bt:3:0xffffffff100b9bb0}}} [00015.411] 01046:67939> {{{bt:4:0xffffffff10095554}}} [00015.411] 01046:67939> {{{bt:5:0xffffffff1009447c}}} [00015.411] 01046:67939> [00015.411] 01046:67939> [00015.411] 01046:67939> ZIRCON KERNEL PANIC [00015.411] 01046:67939> Lock validation failed for thread 0xffff00004299da00 pid 1046 tid 67939 (bin/core-tests:test_thread): [00015.411] 01046:67939> Reason: Already Acquired [00015.411] 01046:67939> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.411] 01046:67939> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.411] 01046:67939> caller=0xffffffff1004478c frame=0xffff008b46436bf0 [00015.411] 01046:67939> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00015.411] 01046:67939> [00015.411] 01046:67939> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00015.411] 01046:67939> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00015.411] 01046:67939> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00015.411] 01046:67939> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00015.411] 01046:67939> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00015.411] 01046:67939> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00015.411] 01046:67939> bt#00: 0xffffffff1004478c [00015.411] 01046:67939> bt#01: 0xffffffff10044b3c [00015.411] 01046:67939> bt#02: 0xffffffff10044b3c [00015.411] 01046:67939> bt#03: 0xffffffff10031c50 [00015.411] 01046:67939> bt#04: 0xffffffff100b9bb0 [00015.411] 01046:67939> bt#05: 0xffffffff10095554 [00015.411] 01046:67939> bt#06: 0xffffffff1009447c [00015.412] 01046:67939> bt#07: end [00015.412] 01046:67939> {{{bt:0:0xffffffff1004478c}}} [00015.412] 01046:67939> {{{bt:1:0xffffffff10044b3c}}} [00015.412] 01046:67939> {{{bt:2:0xffffffff10044b3c}}} [00015.412] 01046:67939> {{{bt:3:0xffffffff10031c50}}} [00015.412] 01046:67939> {{{bt:4:0xffffffff100b9bb0}}} [00015.412] 01046:67939> {{{bt:5:0xffffffff10095554}}} [00015.412] 01046:67939> {{{bt:6:0xffffffff1009447c}}} [00015.412] 01046:67939> [00015.412] 01046:67939> [00015.412] 01046:67939> ZIRCON KERNEL PANIC [00015.412] 01046:67939> Lock validation failed for thread 0xffff00004299da00 pid 1046 tid 67939 (bin/core-tests:test_thread): [00015.412] 01046:67939> Reason: Already Acquired [00015.412] 01046:67939> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.412] 01046:67939> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.412] 01046:67939> caller=0xffffffff1004478c frame=0xffff008b46436bf0 [00015.412] 01046:67939> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00015.412] 01046:67939> [00015.412] 01046:67939> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00015.412] 01046:67939> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00015.412] 01046:67939> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00015.412] 01046:67939> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00015.412] 01046:67939> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00015.412] 01046:67939> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00015.412] 01046:67939> bt#00: 0xffffffff1004478c [00015.412] 01046:67939> bt#01: 0xffffffff10044b3c [00015.412] 01046:67939> bt#02: 0xffffffff10044b3c [00015.412] 01046:67939> bt#03: 0xffffffff10031c50 [00015.412] 01046:67939> bt#04: 0xffffffff100b9bb0 [00015.412] 01046:67939> bt#05: 0xffffffff10095554 [00015.412] 01046:67939> bt#06: 0xffffffff1009447c [00015.412] 01046:67939> bt#07: end [00015.412] 01046:67939> {{{bt:0:0xffffffff1004478c}}} [00015.412] 01046:67939> {{{bt:1:0xffffffff10044b3c}}} [00015.412] 01046:67939> {{{bt:2:0xffffffff10044b3c}}} [00015.412] 01046:67939> {{{bt:3:0xffffffff10031c50}}} [00015.412] 01046:67939> {{{bt:4:0xffffffff100b9bb0}}} [00015.412] 01046:67939> {{{bt:5:0xffffffff10095554}}} [00015.412] 01046:67939> {{{bt:6:0xffffffff1009447c}}} [00015.412] 01046:67939> [00015.412] 01046:01049> [PASSED] (0 ms) [00015.412] 01046:01049> detach_close_pager_test [RUNNING] [00015.412] 01046:01049> [PASSED] (0 ms) [00015.412] 01046:01049> close_port_test [RUNNING] [00015.412] 01046:67952> PageFault: 1028206 free pages [00015.412] 01046:67952> [00015.412] 01046:67952> ZIRCON KERNEL PANIC [00015.412] 01046:67952> Lock validation failed for thread 0xffff00004299d940 pid 1046 tid 67952 (bin/core-tests:test_thread): [00015.412] 01046:67952> Reason: Already Acquired [00015.412] 01046:67952> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.412] 01046:67952> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.412] 01046:67952> caller=0xffffffff1004478c frame=0xffff008b46436c90 [00015.412] 01046:67952> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00015.412] 01046:67952> [00015.412] 01046:67952> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00015.412] 01046:67952> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00015.412] 01046:67952> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00015.412] 01046:67952> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00015.412] 01046:67952> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00015.412] 01046:67952> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00015.412] 01046:67952> bt#00: 0xffffffff1004478c [00015.412] 01046:67952> bt#01: 0xffffffff10044b3c [00015.412] 01046:67952> bt#02: 0xffffffff10031c50 [00015.412] 01046:67952> bt#03: 0xffffffff100b9bb0 [00015.412] 01046:67952> bt#04: 0xffffffff10095554 [00015.412] 01046:67952> bt#05: 0xffffffff1009447c [00015.412] 01046:67952> bt#06: end [00015.412] 01046:67952> {{{bt:0:0xffffffff1004478c}}} [00015.412] 01046:67952> {{{bt:1:0xffffffff10044b3c}}} [00015.412] 01046:67952> {{{bt:2:0xffffffff10031c50}}} [00015.412] 01046:67952> {{{bt:3:0xffffffff100b9bb0}}} [00015.412] 01046:67952> {{{bt:4:0xffffffff10095554}}} [00015.412] 01046:67952> {{{bt:5:0xffffffff1009447c}}} [00015.412] 01046:67952> [00015.412] 01046:67952> [00015.412] 01046:67952> ZIRCON KERNEL PANIC [00015.412] 01046:67952> Lock validation failed for thread 0xffff00004299d940 pid 1046 tid 67952 (bin/core-tests:test_thread): [00015.412] 01046:67952> Reason: Already Acquired [00015.412] 01046:67952> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.412] 01046:67952> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.412] 01046:67952> caller=0xffffffff1004478c frame=0xffff008b46436bf0 [00015.412] 01046:67952> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00015.412] 01046:67952> [00015.412] 01046:67952> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00015.412] 01046:67952> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00015.412] 01046:67952> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00015.412] 01046:67952> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00015.412] 01046:67952> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00015.412] 01046:67952> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00015.412] 01046:67952> bt#00: 0xffffffff1004478c [00015.412] 01046:67952> bt#01: 0xffffffff10044b3c [00015.412] 01046:67952> bt#02: 0xffffffff10044b3c [00015.412] 01046:67952> bt#03: 0xffffffff10031c50 [00015.412] 01046:67952> bt#04: 0xffffffff100b9bb0 [00015.412] 01046:67952> bt#05: 0xffffffff10095554 [00015.412] 01046:67952> bt#06: 0xffffffff1009447c [00015.412] 01046:67952> bt#07: end [00015.412] 01046:67952> {{{bt:0:0xffffffff1004478c}}} [00015.412] 01046:67952> {{{bt:1:0xffffffff10044b3c}}} [00015.412] 01046:67952> {{{bt:2:0xffffffff10044b3c}}} [00015.412] 01046:67952> {{{bt:3:0xffffffff10031c50}}} [00015.412] 01046:67952> {{{bt:4:0xffffffff100b9bb0}}} [00015.412] 01046:67952> {{{bt:5:0xffffffff10095554}}} [00015.412] 01046:67952> {{{bt:6:0xffffffff1009447c}}} [00015.412] 01046:67952> [00015.412] 01046:67952> [00015.412] 01046:67952> ZIRCON KERNEL PANIC [00015.412] 01046:67952> Lock validation failed for thread 0xffff00004299d940 pid 1046 tid 67952 (bin/core-tests:test_thread): [00015.412] 01046:67952> Reason: Already Acquired [00015.412] 01046:67952> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.412] 01046:67952> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.412] 01046:67952> caller=0xffffffff1004478c frame=0xffff008b46436bf0 [00015.412] 01046:67952> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00015.412] 01046:67952> [00015.412] 01046:67952> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00015.412] 01046:67952> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00015.412] 01046:67952> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00015.412] 01046:67952> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00015.412] 01046:67952> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00015.412] 01046:67952> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00015.412] 01046:67952> bt#00: 0xffffffff1004478c [00015.412] 01046:67952> bt#01: 0xffffffff10044b3c [00015.412] 01046:67952> bt#02: 0xffffffff10044b3c [00015.412] 01046:67952> bt#03: 0xffffffff10031c50 [00015.412] 01046:67952> bt#04: 0xffffffff100b9bb0 [00015.412] 01046:67952> bt#05: 0xffffffff10095554 [00015.412] 01046:67952> bt#06: 0xffffffff1009447c [00015.412] 01046:67952> bt#07: end [00015.412] 01046:67952> {{{bt:0:0xffffffff1004478c}}} [00015.412] 01046:67952> {{{bt:1:0xffffffff10044b3c}}} [00015.412] 01046:67952> {{{bt:2:0xffffffff10044b3c}}} [00015.412] 01046:67952> {{{bt:3:0xffffffff10031c50}}} [00015.412] 01046:67952> {{{bt:4:0xffffffff100b9bb0}}} [00015.412] 01046:67952> {{{bt:5:0xffffffff10095554}}} [00015.412] 01046:67952> {{{bt:6:0xffffffff1009447c}}} [00015.412] 01046:67952> [00015.412] 01046:01049> [PASSED] (0 ms) [00015.412] 01046:01049> CASE lifecycle_tests [PASSED] [00015.412] 01046:01049> CASE pager_read_tests [STARTED] [00015.412] 01046:01049> single_page_test_vmar [RUNNING] [00015.413] 01046:01049> [PASSED] (0 ms) [00015.413] 01046:01049> single_page_test_vmo [RUNNING] [00015.413] 01046:01049> [PASSED] (0 ms) [00015.413] 01046:01049> presupply_test_vmar [RUNNING] [00015.413] 01046:01049> [PASSED] (0 ms) [00015.413] 01046:01049> presupply_test_vmo [RUNNING] [00015.413] 01046:01049> [PASSED] (0 ms) [00015.413] 01046:01049> early_supply_test_vmar [RUNNING] [00015.414] 01046:01049> [PASSED] (0 ms) [00015.414] 01046:01049> early_supply_test_vmo [RUNNING] [00015.414] 01046:01049> [PASSED] (0 ms) [00015.414] 01046:01049> sequential_multipage_test_vmar [RUNNING] [00015.416] 01046:01049> [PASSED] (1 ms) [00015.416] 01046:01049> sequential_multipage_test_vmo [RUNNING] [00015.416] 01046:01049> [PASSED] (0 ms) [00015.416] 01046:01049> concurrent_multipage_access_test_vmar [RUNNING] [00015.417] 01046:01049> [PASSED] (0 ms) [00015.417] 01046:01049> concurrent_multipage_access_test_vmo [RUNNING] [00015.417] 01046:01049> [PASSED] (0 ms) [00015.417] 01046:01049> concurrent_overlapping_access_test_vmar [RUNNING] [00015.425] 01046:01049> [PASSED] (7 ms) [00015.425] 01046:01049> concurrent_overlapping_access_test_vmo [RUNNING] [00015.433] 01046:01049> [PASSED] (8 ms) [00015.433] 01046:01049> bulk_single_supply_test_vmar [RUNNING] [00015.439] 01046:01049> [PASSED] (5 ms) [00015.439] 01046:01049> bulk_single_supply_test_vmo [RUNNING] [00015.444] 01046:01049> [PASSED] (5 ms) [00015.444] 01046:01049> bulk_odd_length_supply_test_vmar [RUNNING] [00015.467] 01046:01049> [PASSED] (22 ms) [00015.467] 01046:01049> bulk_odd_length_supply_test_vmo [RUNNING] [00015.484] 01046:01049> [PASSED] (17 ms) [00015.484] 01046:01049> bulk_odd_offset_supply_test_vmar [RUNNING] [00015.507] 01046:01049> [PASSED] (22 ms) [00015.507] 01046:01049> bulk_odd_offset_supply_test_vmo [RUNNING] [00015.525] 01046:01049> [PASSED] (17 ms) [00015.525] 01046:01049> overlap_supply_test_vmar [RUNNING] [00015.525] 01046:01049> [PASSED] (0 ms) [00015.525] 01046:01049> overlap_supply_test_vmo [RUNNING] [00015.526] 01046:01049> [PASSED] (0 ms) [00015.526] 01046:01049> many_request_test_vmar [RUNNING] [00015.621] 01046:01049> [PASSED] (95 ms) [00015.621] 01046:01049> many_request_test_vmo [RUNNING] [00015.803] 01046:01049> [PASSED] (182 ms) [00015.803] 01046:01049> successive_vmo_test [RUNNING] [00015.817] 01046:01049> [PASSED] (13 ms) [00015.817] 01046:01049> multiple_concurrent_vmo_test [RUNNING] [00015.818] 01046:01049> [PASSED] (1 ms) [00015.818] 01046:01049> vmar_unmap_test [RUNNING] [00015.819] 01046:75673> PageFault: 1028205 free pages [00015.819] 01046:75673> [00015.819] 01046:75673> ZIRCON KERNEL PANIC [00015.819] 01046:75673> Lock validation failed for thread 0xffff00004299db10 pid 1046 tid 75673 (bin/core-tests:test_thread): [00015.819] 01046:75673> Reason: Already Acquired [00015.819] 01046:75673> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.819] 01046:75673> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.819] 01046:75673> caller=0xffffffff1004478c frame=0xffff008b46436c90 [00015.819] 01046:75673> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00015.819] 01046:75673> [00015.819] 01046:75673> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00015.819] 01046:75673> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00015.819] 01046:75673> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00015.819] 01046:75673> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00015.819] 01046:75673> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00015.819] 01046:75673> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00015.819] 01046:75673> bt#00: 0xffffffff1004478c [00015.819] 01046:75673> bt#01: 0xffffffff10044b3c [00015.819] 01046:75673> bt#02: 0xffffffff10031c50 [00015.819] 01046:75673> bt#03: 0xffffffff100b9bb0 [00015.819] 01046:75673> bt#04: 0xffffffff10095554 [00015.819] 01046:75673> bt#05: 0xffffffff1009447c [00015.819] 01046:75673> bt#06: end [00015.819] 01046:75673> {{{bt:0:0xffffffff1004478c}}} [00015.819] 01046:75673> {{{bt:1:0xffffffff10044b3c}}} [00015.819] 01046:75673> {{{bt:2:0xffffffff10031c50}}} [00015.819] 01046:75673> {{{bt:3:0xffffffff100b9bb0}}} [00015.819] 01046:75673> {{{bt:4:0xffffffff10095554}}} [00015.819] 01046:75673> {{{bt:5:0xffffffff1009447c}}} [00015.819] 01046:75673> [00015.819] 01046:75673> [00015.819] 01046:75673> ZIRCON KERNEL PANIC [00015.819] 01046:75673> Lock validation failed for thread 0xffff00004299db10 pid 1046 tid 75673 (bin/core-tests:test_thread): [00015.819] 01046:75673> Reason: Already Acquired [00015.819] 01046:75673> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.819] 01046:75673> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.819] 01046:75673> caller=0xffffffff1004478c frame=0xffff008b46436bf0 [00015.819] 01046:75673> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00015.819] 01046:75673> [00015.819] 01046:75673> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00015.819] 01046:75673> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00015.819] 01046:75673> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00015.819] 01046:75673> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00015.819] 01046:75673> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00015.819] 01046:75673> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00015.819] 01046:75673> bt#00: 0xffffffff1004478c [00015.819] 01046:75673> bt#01: 0xffffffff10044b3c [00015.819] 01046:75673> bt#02: 0xffffffff10044b3c [00015.819] 01046:75673> bt#03: 0xffffffff10031c50 [00015.819] 01046:75673> bt#04: 0xffffffff100b9bb0 [00015.819] 01046:75673> bt#05: 0xffffffff10095554 [00015.819] 01046:75673> bt#06: 0xffffffff1009447c [00015.819] 01046:75673> bt#07: end [00015.819] 01046:75673> {{{bt:0:0xffffffff1004478c}}} [00015.819] 01046:75673> {{{bt:1:0xffffffff10044b3c}}} [00015.819] 01046:75673> {{{bt:2:0xffffffff10044b3c}}} [00015.819] 01046:75673> {{{bt:3:0xffffffff10031c50}}} [00015.819] 01046:75673> {{{bt:4:0xffffffff100b9bb0}}} [00015.819] 01046:75673> {{{bt:5:0xffffffff10095554}}} [00015.819] 01046:75673> {{{bt:6:0xffffffff1009447c}}} [00015.819] 01046:75673> [00015.819] 01046:75673> [00015.819] 01046:75673> ZIRCON KERNEL PANIC [00015.819] 01046:75673> Lock validation failed for thread 0xffff00004299db10 pid 1046 tid 75673 (bin/core-tests:test_thread): [00015.819] 01046:75673> Reason: Already Acquired [00015.819] 01046:75673> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.819] 01046:75673> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.819] 01046:75673> caller=0xffffffff1004478c frame=0xffff008b46436bf0 [00015.819] 01046:75673> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00015.819] 01046:75673> [00015.819] 01046:75673> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00015.819] 01046:75673> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00015.819] 01046:75673> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00015.819] 01046:75673> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00015.819] 01046:75673> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00015.819] 01046:75673> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00015.819] 01046:75673> bt#00: 0xffffffff1004478c [00015.819] 01046:75673> bt#01: 0xffffffff10044b3c [00015.819] 01046:75673> bt#02: 0xffffffff10044b3c [00015.819] 01046:75673> bt#03: 0xffffffff10031c50 [00015.819] 01046:75673> bt#04: 0xffffffff100b9bb0 [00015.819] 01046:75673> bt#05: 0xffffffff10095554 [00015.819] 01046:75673> bt#06: 0xffffffff1009447c [00015.819] 01046:75673> bt#07: end [00015.819] 01046:75673> {{{bt:0:0xffffffff1004478c}}} [00015.819] 01046:75673> {{{bt:1:0xffffffff10044b3c}}} [00015.819] 01046:75673> {{{bt:2:0xffffffff10044b3c}}} [00015.819] 01046:75673> {{{bt:3:0xffffffff10031c50}}} [00015.819] 01046:75673> {{{bt:4:0xffffffff100b9bb0}}} [00015.819] 01046:75673> {{{bt:5:0xffffffff10095554}}} [00015.819] 01046:75673> {{{bt:6:0xffffffff1009447c}}} [00015.819] 01046:75673> [00015.819] 01046:01049> [PASSED] (0 ms) [00015.819] 01046:01049> vmar_remap_test [RUNNING] [00015.820] 01046:01049> [PASSED] (1 ms) [00015.820] 01046:01049> vmar_map_range_test [RUNNING] [00015.821] 01046:01049> [PASSED] (0 ms) [00015.821] 01046:01049> read_resize_test_vmar [RUNNING] [00015.821] 01046:01049> [PASSED] (0 ms) [00015.821] 01046:01049> read_resize_test_vmo [RUNNING] [00015.821] 01046:01049> [PASSED] (0 ms) [00015.821] 01046:01049> suspend_read_test_vmar [RUNNING] [00015.821] 01046:01049> [PASSED] (0 ms) [00015.821] 01046:01049> suspend_read_test_vmo [RUNNING] [00015.822] 01046:01049> [PASSED] (0 ms) [00015.822] 01046:01049> CASE pager_read_tests [PASSED] [00015.822] 01046:01049> CASE object_get_child_tests [STARTED] [00015.822] 01046:01049> handle_invalid [RUNNING] [00015.822] 01046:01049> [PASSED] (0 ms) [00015.822] 01046:01049> CASE object_get_child_tests [PASSED] [00015.822] 01046:01049> CASE memory_mapping_tests [STARTED] [00015.822] 01046:01049> address_space_limits_test [RUNNING] [00015.822] 01046:01049> [PASSED] (0 ms) [00015.822] 01046:01049> mmap_zerofilled_test [RUNNING] [00015.822] 01046:01049> [PASSED] (0 ms) [00015.822] 01046:01049> mmap_len_test [RUNNING] [00015.822] 01046:01049> [PASSED] (0 ms) [00015.822] 01046:01049> mmap_PROT_EXEC_test [RUNNING] [00015.822] 01046:01049> [PASSED] (0 ms) [00015.822] 01046:01049> mmap_offset_test [RUNNING] [00015.822] 01046:01049> [PASSED] (0 ms) [00015.822] 01046:01049> mmap_prot_test [RUNNING] [00015.822] 01046:01049> [PASSED] (0 ms) [00015.822] 01046:01049> mmap_flags_test [RUNNING] [00015.822] 01046:01049> [PASSED] (0 ms) [00015.822] 01046:01049> mprotect_test [RUNNING] [00015.822] 01046:01049> [00015.822] 01046:01049> ZIRCON KERNEL PANIC [00015.822] 01046:01049> Lock validation failed for thread 0xffff000040031188 pid 1046 tid 1049 (bin/core-tests:bin/core-tests): [00015.822] 01046:01049> Reason: Already Acquired [00015.822] 01046:01049> Bad lock: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.822] 01046:01049> Conflict: name=lockdep::LockClass<SoloDispatcher<JobDispatcher, 516047, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00015.822] 01046:01049> caller=0xffffffff1004478c frame=0xffff008b43394b90 [00015.822] 01046:01049> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00015.822] 01046:01049> [00015.822] 01046:01049> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00015.822] 01046:01049> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00015.822] 01046:01049> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00015.822] 01046:01049> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00015.822] 01046:01049> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00015.822] 01046:01049> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00015.822] 01046:01049> bt#00: 0xffffffff1004478c [00015.822] 01046:01049> bt#01: 0xffffffff10044b3c [00015.822] 01046:01049> bt#02: 0xffffffff10045c14 [00015.822] 01046:01049> bt#03: 0xffffffff1003a354 [00015.822] 01046:01049> bt#04: 0xffffffff1004eaa4 [00015.822] 01046:01049> bt#05: 0xffffffff1003fe64 [00015.822] 01046:01049> bt#06: 0xffffffff100ce4c4 [00015.822] 01046:01049> bt#07: 0xffffffff100dd31c [00015.822] 01046:01049> bt#08: 0xffffffff10094958 [00015.822] 01046:01049> bt#09: end [00015.822] 01046:01049> {{{bt:0:0xffffffff1004478c}}} [00015.822] 01046:01049> {{{bt:1:0xffffffff10044b3c}}} [00015.822] 01046:01049> {{{bt:2:0xffffffff10045c14}}} [00015.822] 01046:01049> {{{bt:3:0xffffffff1003a354}}} [00015.822] 01046:01049> {{{bt:4:0xffffffff1004eaa4}}} [00015.822] 01046:01049> {{{bt:5:0xffffffff1003fe64}}} [00015.822] 01046:01049> {{{bt:6:0xffffffff100ce4c4}}} [00015.822] 01046:01049> {{{bt:7:0xffffffff100dd31c}}} [00015.822] 01046:01049> {{{bt:8:0xffffffff10094958}}} [00015.822] 01046:01049> [00015.822] 01046:01049> [PASSED] (0 ms) [00015.822] 01046:01049> CASE memory_mapping_tests [PASSED] [00015.822] 01046:01049> CASE job_tests [STARTED] [00015.823] 01046:01049> basic_test [RUNNING] [00015.823] 01046:01049> [PASSED] (0 ms) [00015.823] 01046:01049> create_missing_rights_test [RUNNING] [00015.823] 01046:01049> [PASSED] (0 ms) [00015.823] 01046:01049> policy_invalid_topic_test [RUNNING] [00015.823] 01046:01049> [PASSED] (0 ms) [00015.823] 01046:01049> policy_basic_test [RUNNING] [00015.823] 01046:01049> [PASSED] (0 ms) [00015.823] 01046:01049> policy_timer_slack_invalid_options_test [RUNNING] [00015.823] 01046:01049> [PASSED] (0 ms) [00015.823] 01046:01049> policy_timer_slack_invalid_count_test [RUNNING] [00015.823] 01046:01049> [PASSED] (0 ms) [00015.823] 01046:01049> policy_timer_slack_invalid_policy_test [RUNNING] [00015.823] 01046:01049> [PASSED] (0 ms) [00015.823] 01046:01049> policy_timer_slack_non_empty_test [RUNNING] [00015.823] 01046:01049> [PASSED] (0 ms) [00015.823] 01046:01049> policy_timer_slack_valid [RUNNING] [00015.823] 01046:01049> [PASSED] (0 ms) [00015.823] 01046:01049> create_test [RUNNING] [00015.823] 01046:01049> [PASSED] (0 ms) [00015.823] 01046:01049> kill_test [RUNNING] [00015.823] 01046:01049> [PASSED] (0 ms) [00015.823] 01046:01049> kill_job_no_child_test [RUNNING] [00015.823] 01046:01049> [PASSED] (0 ms) [00015.823] 01046:01049> set_job_oom_kill_bit [RUNNING] [00015.823] 01046:01049> [PASSED] (0 ms) [00015.823] 01046:01049> wait_test [RUNNING] [00015.828] 01046:01049> [PASSED] (5 ms) [00015.828] 01046:01049> info_task_stats_fails [RUNNING] [00015.828] 01046:01049> [PASSED] (0 ms) [00015.828] 01046:01049> max_height_smoke [RUNNING] [00015.829] 01046:01049> [PASSED] (0 ms) [00015.829] 01046:01049> CASE job_tests [PASSED] [00015.829] 01046:01049> CASE handle_wait_tests [STARTED] [00015.829] 01046:01049> handle_wait_test [RUNNING] [00015.829] 01046:01049> [PASSED] (0 ms) [00015.829] 01046:01049> CASE handle_wait_tests [PASSED] [00015.829] 01046:01049> CASE handle_transfer_tests [STARTED] [00015.829] 01046:01049> handle_transfer_test [RUNNING] [00015.829] 01046:01049> [PASSED] (0 ms) [00015.829] 01046:01049> handle_transfer_cancel_wait_test [RUNNING] [00015.839] 01046:01049> [PASSED] (10 ms) [00015.839] 01046:01049> CASE handle_transfer_tests [PASSED] [00015.839] 01046:01049> CASE eventpair_tests [STARTED] [00015.839] 01046:01049> create_test [RUNNING] [00015.839] 01046:01049> [PASSED] (0 ms) [00015.840] 01046:01049> signal_test [RUNNING] [00015.840] 01046:01049> [PASSED] (0 ms) [00015.840] 01046:01049> signal_peer_test [RUNNING] [00015.840] 01046:01049> [PASSED] (0 ms) [00015.840] 01046:01049> signal_peer_closed_test [RUNNING] [00015.840] 01046:01049> [PASSED] (0 ms) [00015.840] 01046:01049> CASE eventpair_tests [PASSED] [00015.840] 01046:01049> CASE elf_tls_tests [STARTED] [00015.840] 01046:01049> ExecutableTlsTest [RUNNING] [00015.988] 01046:01049> [PASSED] (148 ms) [00015.988] 01046:01049> CASE elf_tls_tests [PASSED] [00015.988] 01046:01049> CASE channel_tests [STARTED] [00015.988] 01046:01049> channel_test [RUNNING] [00015.988] 01046:01049> [PASSED] (0 ms) [00015.988] 01046:01049> channel_read_error_test [RUNNING] [00015.988] 01046:01049> [PASSED] (0 ms) [00015.988] 01046:01049> channel_close_test [RUNNING] [00015.988] 01046:01049> [PASSED] (0 ms) [00015.988] 01046:01049> channel_peer_closed_test [RUNNING] [00015.988] 01046:01049> [PASSED] (0 ms) [00015.988] 01046:01049> channel_non_transferable [RUNNING] [00015.988] 01046:01049> [PASSED] (0 ms) [00015.988] 01046:01049> channel_duplicate_handles [RUNNING] [00015.988] 01046:01049> [PASSED] (0 ms) [00015.988] 01046:01049> channel_multithread_read [RUNNING] [00015.995] 01046:01049> [PASSED] (6 ms) [00015.995] 01046:01049> channel_may_discard [RUNNING] [00015.995] 01046:01049> [PASSED] (0 ms) [00015.995] 01046:01049> channel_call [RUNNING] [00015.996] 01046:01049> [PASSED] (0 ms) [00015.996] 01046:01049> channel_call_consumes_handles [RUNNING] [00015.996] 01046:01049> [PASSED] (0 ms) [00015.996] 01046:01049> channel_call2 [RUNNING] [00016.246] 01046:01049> [PASSED] (250 ms) [00016.246] 01046:01049> bad_channel_call_finish [RUNNING] [00016.246] 01046:01049> [PASSED] (0 ms) [00016.246] 01046:01049> channel_nest [RUNNING] [00016.247] 01046:01049> [PASSED] (0 ms) [00016.247] 01046:01049> channel_disallow_write_to_self [RUNNING] [00016.247] 01046:01049> [PASSED] (0 ms) [00016.247] 01046:01049> channel_read_etc [RUNNING] [00016.247] 01046:01049> [PASSED] (0 ms) [00016.247] 01046:01049> channel_write_different_sizes [RUNNING] [00016.368] 01046:01049> [PASSED] (120 ms) [00016.368] 01046:01049> channel_write_takes_all_handles [RUNNING] [00016.370] 01046:01049> [PASSED] (2 ms) [00016.370] 01046:01049> CASE channel_tests [PASSED] [00016.370] 01046:01049> CASE c11_thread_tests [STARTED] [00016.370] 01046:01049> c11_thread_test [RUNNING] [00017.172] 01046:01049> [PASSED] (801 ms) [00017.172] 01046:01049> long_name_succeeds [RUNNING] [00017.272] 01046:01049> [PASSED] (100 ms) [00017.272] 01046:01049> detach_self_test [RUNNING] [00017.407] 01046:01049> [PASSED] (135 ms) [00017.407] 01046:01049> CASE c11_thread_tests [PASSED] [00017.407] 01046:01049> CASE mtx_tests [STARTED] [00017.407] 01046:01049> test_initializer [RUNNING] [00017.407] 01046:01049> [PASSED] (0 ms) [00017.408] 01046:01049> test_mutexes [RUNNING] [00017.416] 01046:01049> [PASSED] (8 ms) [00017.416] 01046:01049> test_try_mutexes [RUNNING] [00017.420] 01046:01049> [PASSED] (4 ms) [00017.420] 01046:01049> test_static_initializer [RUNNING] [00017.420] 01046:01049> [PASSED] (0 ms) [00017.420] 01046:01049> test_timeout_elapsed [RUNNING] [00017.921] 01046:01049> [PASSED] (500 ms) [00017.921] 01046:01049> CASE mtx_tests [PASSED] [00017.921] 01046:01049> CASE cnd_tests [STARTED] [00017.921] 01046:01049> cnd_test [RUNNING] [00017.921] 01046:01049> [PASSED] (0 ms) [00017.921] 01046:01049> cnd_timedwait_timeout_test [RUNNING] [00017.923] 01046:01049> [PASSED] (1 ms) [00017.923] 01046:01049> CASE cnd_tests [PASSED] [00017.923] 01046:01049> CASE bad_syscall_tests [STARTED] [00017.923] 01046:01049> bad_access_test [RUNNING] [00017.923] 01046:01049> [PASSED] (0 ms) [00017.923] 01046:01049> bad_syscall_num_test [RUNNING] [00017.923] 01046:01049> [PASSED] (0 ms) [00017.923] 01046:01049> CASE bad_syscall_tests [PASSED] [00017.923] 01046:01049> ==================================================== [00017.923] 01046:01049> Results: [00017.923] 01046:01049> SUCCESS! All test cases passed! [00017.923] 01046:01049> CASES: 34 SUCCESS: 34 FAILED: 0 [00017.923] 01046:01049> ==================================================== [00017.924] 01046:01049> Flags: [00017.924] 01046:01049> --gtest_random_seed = 17 [00017.924] 01046:01049> [00017.924] 01046:01049> [00017.924] 01046:01049> [==========] Running 240 tests from 12 test cases [00017.924] 01046:01049> . [00017.924] 01046:01049> [----------] Global test environment set-up. [00017.924] 01046:01049> [----------] 1 test from ClockTest [00017.924] 01046:01049> [00017.924] 01046:01049> [ RUN ] ClockTest.ClockMonotonic [00017.924] 01046:01049> [00018.026] 01046:01049> [ OK ] ClockTest.ClockMonotonic (102 [00018.026] 01046:01049> ms) [00018.026] 01046:01049> [----------] 1 test from ClockTest (102 [00018.026] 01046:01049> ms total) [00018.026] 01046:01049> [----------] 9 tests from FifoTest [00018.026] 01046:01049> [00018.026] 01046:01049> [ RUN ] FifoTest.InvalidParametersReturnOutOfRange [00018.026] 01046:01049> [00018.026] 01046:01049> [ OK ] FifoTest.InvalidParametersReturnOutOfRange (0 [00018.026] 01046:01049> ms) [00018.026] 01046:01049> [ RUN ] FifoTest.EndpointsAreRelated [00018.026] 01046:01049> [00018.026] 01046:01049> [ OK ] FifoTest.EndpointsAreRelated (0 [00018.026] 01046:01049> ms) [00018.026] 01046:01049> [ RUN ] FifoTest.EmptyQueueReturnsErrShouldWait [00018.026] 01046:01049> [00018.026] 01046:01049> [ OK ] FifoTest.EmptyQueueReturnsErrShouldWait (0 [00018.026] 01046:01049> ms) [00018.026] 01046:01049> [ RUN ] FifoTest.ReadAndWriteValidatesSizeAndElementCount [00018.026] 01046:01049> [00018.026] 01046:01049> [ OK ] FifoTest.ReadAndWriteValidatesSizeAndElementCount (0 [00018.026] 01046:01049> ms) [00018.026] 01046:01049> [ RUN ] FifoTest.DequeueSignalsWriteable [00018.026] 01046:01049> [00018.026] 01046:01049> [ OK ] FifoTest.DequeueSignalsWriteable (0 [00018.026] 01046:01049> ms) [00018.026] 01046:01049> [ RUN ] FifoTest.FifoOrderIsPreserved [00018.026] 01046:01049> [00018.026] 01046:01049> [ OK ] FifoTest.FifoOrderIsPreserved (0 [00018.026] 01046:01049> ms) [00018.026] 01046:01049> [ RUN ] FifoTest.PartialWriteQueuesElementsThatFit [00018.026] 01046:01049> [00018.026] 01046:01049> [ OK ] FifoTest.PartialWriteQueuesElementsThatFit (0 [00018.026] 01046:01049> ms) [00018.026] 01046:01049> [ RUN ] FifoTest.IndividualReadsPreserveOrder [00018.026] 01046:01049> [00018.026] 01046:01049> [ OK ] FifoTest.IndividualReadsPreserveOrder (0 [00018.026] 01046:01049> ms) [00018.026] 01046:01049> [ RUN ] FifoTest.EndpointCloseSignalsPeerClosed [00018.026] 01046:01049> [00018.026] 01046:01049> [ OK ] FifoTest.EndpointCloseSignalsPeerClosed (0 [00018.026] 01046:01049> ms) [00018.026] 01046:01049> [----------] 9 tests from FifoTest (0 [00018.026] 01046:01049> ms total) [00018.026] 01046:01049> [----------] 15 tests from FutexTest [00018.026] 01046:01049> [00018.026] 01046:01049> [ RUN ] FutexTest.WaitValueMismatch [00018.026] 01046:01049> [00018.026] 01046:01049> [ OK ] FutexTest.WaitValueMismatch (0 [00018.026] 01046:01049> ms) [00018.026] 01046:01049> [ RUN ] FutexTest.WaitTimeout [00018.026] 01046:01049> [00018.026] 01046:01049> [ OK ] FutexTest.WaitTimeout (0 [00018.026] 01046:01049> ms) [00018.026] 01046:01049> [ RUN ] FutexTest.WaitTimeoutElapsed [00018.026] 01046:01049> [00018.526] 01046:01049> [ OK ] FutexTest.WaitTimeoutElapsed (500 [00018.527] 01046:01049> ms) [00018.527] 01046:01049> [ RUN ] FutexTest.WaitBadAddress [00018.527] 01046:01049> [00018.527] 01046:01049> [ OK ] FutexTest.WaitBadAddress (0 [00018.527] 01046:01049> ms) [00018.527] 01046:01049> [ RUN ] FutexTest.Wakeup [00018.527] 01046:01049> [00018.527] 01046:01049> [ OK ] FutexTest.Wakeup (0 [00018.527] 01046:01049> ms) [00018.527] 01046:01049> [ RUN ] FutexTest.WakeupLimit [00018.527] 01046:01049> [00019.128] 01046:01049> [ OK ] FutexTest.WakeupLimit (601 [00019.128] 01046:01049> ms) [00019.128] 01046:01049> [ RUN ] FutexTest.WakeupAddress [00019.128] 01046:01049> [00019.129] 01046:01049> [ OK ] FutexTest.WakeupAddress (0 [00019.129] 01046:01049> ms) [00019.129] 01046:01049> [ RUN ] FutexTest.RequeueValueMismatch [00019.129] 01046:01049> [00019.129] 01046:01049> [ OK ] FutexTest.RequeueValueMismatch (0 [00019.129] 01046:01049> ms) [00019.129] 01046:01049> [ RUN ] FutexTest.RequeueSameAddr [00019.129] 01046:01049> [00019.129] 01046:01049> [ OK ] FutexTest.RequeueSameAddr (0 [00019.129] 01046:01049> ms) [00019.129] 01046:01049> [ RUN ] FutexTest.Requeue [00019.129] 01046:01049> [00020.031] 01046:01049> [ OK ] FutexTest.Requeue (901 [00020.031] 01046:01049> ms) [00020.031] 01046:01049> [ RUN ] FutexTest.RequeueUnqueuedOnTimeout [00020.031] 01046:01049> [00020.331] 01046:01049> [ OK ] FutexTest.RequeueUnqueuedOnTimeout (300 [00020.331] 01046:01049> ms) [00020.331] 01046:01049> [ RUN ] FutexTest.ThreadKilled [00020.331] 01046:01049> [00020.331] 01046:01049> [ OK ] FutexTest.ThreadKilled (0 [00020.331] 01046:01049> ms) [00020.331] 01046:01049> [ RUN ] FutexTest.ThreadSuspended [00020.331] 01046:01049> [00020.632] 01046:01049> [ OK ] FutexTest.ThreadSuspended (300 [00020.632] 01046:01049> ms) [00020.632] 01046:01049> [ RUN ] FutexTest.MisalignedFutextAddr [00020.632] 01046:01049> [00020.632] 01046:01049> [ OK ] FutexTest.MisalignedFutextAddr (0 [00020.632] 01046:01049> ms) [00020.632] 01046:01049> [ RUN ] FutexTest.EventSignaling [00020.632] 01046:01049> [00020.632] 01046:01049> [00000020.632336880]: starting signal threads [00020.632] 01046:148209> [00000020.632456285]: thread 1 waiting on event [00020.632] 01046:148214> [00000020.632555305]: thread 2 waiting on event [00020.632] 01046:148219> [00000020.632618310]: thread 3 waiting on event [00020.632] 01046:01049> [00000020.632752050]: signaling event [00020.632] 01046:01049> [00000020.632788595]: joining signal threads [00020.632] 01046:148214> [00000020.632800175]: thread 2 done [00020.632] 01046:148219> [00000020.632814995]: thread 3 done [00020.632] 01046:148209> [00000020.632790215]: thread 1 done [00020.632] 01046:01049> [00000020.632920530]: signal_thread 1 joined [00020.632] 01046:01049> [00000020.632945840]: signal_thread 2 joined [00020.632] 01046:01049> [00000020.632965895]: signal_thread 3 joined [00020.632] 01046:01049> [ OK ] FutexTest.EventSignaling (0 [00020.632] 01046:01049> ms) [00020.632] 01046:01049> [----------] 15 tests from FutexTest (2606 [00020.633] 01046:01049> ms total) [00020.633] 01046:01049> [----------] 3 tests from HandleCloseTest [00020.633] 01046:01049> [00020.633] 01046:01049> [ RUN ] HandleCloseTest.Many [00020.633] 01046:01049> [00020.633] 01046:01049> [ OK ] HandleCloseTest.Many (0 [00020.633] 01046:01049> ms) [00020.633] 01046:01049> [ RUN ] HandleCloseTest.ManyInvalidHandlesShouldNotFail [00020.633] 01046:01049> [00020.633] 01046:01049> [ OK ] HandleCloseTest.ManyInvalidHandlesShouldNotFail (0 [00020.633] 01046:01049> ms) [00020.633] 01046:01049> [ RUN ] HandleCloseTest.ManyDuplicateTest [00020.633] 01046:01049> [00020.633] 01046:01049> [ OK ] HandleCloseTest.ManyDuplicateTest (0 [00020.633] 01046:01049> ms) [00020.633] 01046:01049> [----------] 3 tests from HandleCloseTest (0 [00020.633] 01046:01049> ms total) [00020.633] 01046:01049> [----------] 6 tests from HandleInfoTest [00020.633] 01046:01049> [00020.633] 01046:01049> [ RUN ] HandleInfoTest.ReplaceSuccessOrigInvalid [00020.633] 01046:01049> [00020.633] 01046:01049> [ OK ] HandleInfoTest.ReplaceSuccessOrigInvalid (0 [00020.633] 01046:01049> ms) [00020.633] 01046:01049> [ RUN ] HandleInfoTest.ReplaceFailureBothInvalid [00020.633] 01046:01049> [00020.633] 01046:01049> [ OK ] HandleInfoTest.ReplaceFailureBothInvalid (0 [00020.633] 01046:01049> ms) [00020.633] 01046:01049> [ RUN ] HandleInfoTest.DupAndInfoRights [00020.633] 01046:01049> [00020.633] 01046:01049> [ OK ] HandleInfoTest.DupAndInfoRights (0 [00020.633] 01046:01049> ms) [00020.633] 01046:01049> [ RUN ] HandleInfoTest.RelatedKoid [00020.633] 01046:01049> [00020.633] 01046:01049> [ OK ] HandleInfoTest.RelatedKoid (0 [00020.633] 01046:01049> ms) [00020.633] 01046:01049> [ RUN ] HandleInfoTest.DuplicateRights [00020.633] 01046:01049> [00020.633] 01046:01049> [ OK ] HandleInfoTest.DuplicateRights (0 [00020.633] 01046:01049> ms) [00020.633] 01046:01049> [ RUN ] HandleInfoTest.ReplaceRights [00020.633] 01046:01049> [00020.633] 01046:01049> [ OK ] HandleInfoTest.ReplaceRights (0 [00020.633] 01046:01049> ms) [00020.633] 01046:01049> [----------] 6 tests from HandleInfoTest (0 [00020.633] 01046:01049> ms total) [00020.633] 01046:01049> [----------] 4 tests from ObjectGetInfoTest [00020.633] 01046:01049> [00020.633] 01046:01049> [ RUN ] ObjectGetInfoTest.OpenValidHandleSuceeds [00020.633] 01046:01049> [00020.633] 01046:01049> [ OK ] ObjectGetInfoTest.OpenValidHandleSuceeds (0 [00020.633] 01046:01049> ms) [00020.633] 01046:01049> [ RUN ] ObjectGetInfoTest.ClosedValidHandleFails [00020.633] 01046:01049> [00020.633] 01046:01049> [ OK ] ObjectGetInfoTest.ClosedValidHandleFails (0 [00020.633] 01046:01049> ms) [00020.633] 01046:01049> [ RUN ] ObjectGetInfoTest.HandleCountCorrectness [00020.633] 01046:01049> [00020.633] 01046:01049> [ OK ] ObjectGetInfoTest.HandleCountCorrectness (0 [00020.633] 01046:01049> ms) [00020.633] 01046:01049> [ RUN ] ObjectGetInfoTest.InvalidHandleFails [00020.633] 01046:01049> [00020.633] 01046:01049> [ OK ] ObjectGetInfoTest.InvalidHandleFails (0 [00020.633] 01046:01049> ms) [00020.633] 01046:01049> [----------] 4 tests from ObjectGetInfoTest (0 [00020.633] 01046:01049> ms total) [00020.633] 01046:01049> [----------] 39 tests from JobGetInfoTest [00020.633] 01046:01049> [00020.633] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesGetChild [00020.633] 01046:01049> [00020.633] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesGetChild (0 [00020.633] 01046:01049> ms) [00020.633] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildJobsGetChild [00020.633] 01046:01049> [00020.633] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildJobsGetChild (0 [00020.633] 01046:01049> ms) [00020.633] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesOnSelfSuceeds [00020.633] 01046:01049> [00020.633] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesOnSelfSuceeds (0 [00020.633] 01046:01049> ms) [00020.633] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesInvalidHandleFails [00020.633] 01046:01049> [00020.633] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesInvalidHandleFails (0 [00020.633] 01046:01049> ms) [00020.633] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesNullAvailSucceeds [00020.633] 01046:01049> [00020.633] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesNullAvailSucceeds (0 [00020.633] 01046:01049> ms) [00020.633] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesNullActualSucceeds [00020.633] 01046:01049> [00020.633] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesNullActualSucceeds (0 [00020.633] 01046:01049> ms) [00020.633] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesNullActualAndAvailSucceeds [00020.633] 01046:01049> [00020.633] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesNullActualAndAvailSucceeds (0 [00020.633] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesInvalidBufferPointerFails [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesInvalidBufferPointerFails (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesBadActualgIsInvalidArg [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesBadActualgIsInvalidArg (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesBadAvailIsInvalidArg [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesBadAvailIsInvalidArg (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesZeroSizedBufferIsOk [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesZeroSizedBufferIsOk (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesSmallBufferIsOk [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesSmallBufferIsOk (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesPartiallyUnmappedBufferIsInvalidArgs [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesPartiallyUnmappedBufferIsInvalidArgs (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesRequiresEnumerateRights [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesRequiresEnumerateRights (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesProcessbHandleIsBadHandle [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesProcessbHandleIsBadHandle (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobProcessesThreadHandleIsBadHandle [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoJobProcessesThreadHandleIsBadHandle (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenOnSelfSuceeds [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenOnSelfSuceeds (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenInvalidHandleFails [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenInvalidHandleFails (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenNullAvailSucceeds [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenNullAvailSucceeds (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenNullActualSucceeds [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenNullActualSucceeds (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenNullActualAndAvailSucceeds [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenNullActualAndAvailSucceeds (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenInvalidBufferPointerFails [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenInvalidBufferPointerFails (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenBadActualgIsInvalidArg [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenBadActualgIsInvalidArg (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenBadAvailIsInvalidArg [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenBadAvailIsInvalidArg (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenZeroSizedBufferIsOk [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenZeroSizedBufferIsOk (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenSmallBufferIsOk [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenSmallBufferIsOk (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenPartiallyUnmappedBufferIsInvalidArgs [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenPartiallyUnmappedBufferIsInvalidArgs (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenRequiresEnumerateRights [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenRequiresEnumerateRights (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenJobHandleIsBadHandle [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenJobHandleIsBadHandle (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoJobChildrenThreadHandleIsBadHandle [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoJobChildrenThreadHandleIsBadHandle (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoHandleBasicOnSelfSuceeds [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoHandleBasicOnSelfSuceeds (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoHandleBasicInvalidHandleFails [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoHandleBasicInvalidHandleFails (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoHandleBasicNullAvailSucceeds [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoHandleBasicNullAvailSucceeds (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoHandleBasicNullActualSucceeds [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoHandleBasicNullActualSucceeds (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoHandleBasicInvalidBufferPointerFails [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoHandleBasicInvalidBufferPointerFails (0 [00020.634] 01046:01049> ms) [00020.634] 01046:01049> [ RUN ] JobGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg [00020.634] 01046:01049> [00020.634] 01046:01049> [ OK ] JobGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg (0 [00020.635] 01046:01049> ms) [00020.635] 01046:01049> [ RUN ] JobGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg [00020.635] 01046:01049> [00020.635] 01046:01049> [ OK ] JobGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg (0 [00020.635] 01046:01049> ms) [00020.635] 01046:01049> [ RUN ] JobGetInfoTest.InfoHandleBasicZeroSizedBufferFails [00020.635] 01046:01049> [00020.635] 01046:01049> [ OK ] JobGetInfoTest.InfoHandleBasicZeroSizedBufferFails (0 [00020.635] 01046:01049> ms) [00020.635] 01046:01049> [----------] 39 tests from JobGetInfoTest (1 [00020.635] 01046:01049> ms total) [00020.635] 01046:01049> [----------] 61 tests from ProcessGetInfoTest [00020.635] 01046:01049> [00020.635] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsUnstartedSuceeds [00020.635] 01046:01049> [00020.635] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsUnstartedSuceeds (0 [00020.635] 01046:01049> ms) [00020.635] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsSmokeTest [00020.635] 01046:01049> [00020.635] 01046:01049> [00020.635] 01046:01049> ZIRCON KERNEL PANIC [00020.635] 01046:01049> Lock validation failed for thread 0xffff000040031188 pid 1046 tid 1049 (bin/core-tests:bin/core-tests): [00020.635] 01046:01049> Reason: Already Acquired [00020.635] 01046:01049> Bad lock: name=lockdep::LockClass<VmAspace, Mutex, 199, lockdep::LockFlagsNone> order=0 [00020.635] 01046:01049> Conflict: name=lockdep::LockClass<VmAspace, Mutex, 199, lockdep::LockFlagsNone> order=0 [00020.635] 01046:01049> caller=0xffffffff100ab264 frame=0xffff008b433948d0 [00020.635] 01046:01049> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00020.635] 01046:01049> [00020.635] 01046:01049> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00020.635] 01046:01049> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00020.635] 01046:01049> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00020.635] 01046:01049> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00020.635] 01046:01049> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00020.635] 01046:01049> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00020.635] 01046:01049> bt#00: 0xffffffff100ab264 [00020.635] 01046:01049> bt#01: 0xffffffff100b9b80 [00020.635] 01046:01049> bt#02: 0xffffffff10095554 [00020.635] 01046:01049> bt#03: 0xffffffff10094270 [00020.635] 01046:01049> bt#04: 0xffffffff100a5cd4 [00020.635] 01046:01049> bt#05: 0xffffffff100ab570 [00020.635] 01046:01049> bt#06: 0xffffffff10031620 [00020.635] 01046:01049> bt#07: 0xffffffff10053118 [00020.635] 01046:01049> bt#08: 0xffffffff100d0a10 [00020.635] 01046:01049> bt#09: 0xffffffff100de590 [00020.635] 01046:01049> bt#10: 0xffffffff100949dc [00020.635] 01046:01049> bt#11: end [00020.635] 01046:01049> {{{bt:0:0xffffffff100ab264}}} [00020.635] 01046:01049> {{{bt:1:0xffffffff100b9b80}}} [00020.635] 01046:01049> {{{bt:2:0xffffffff10095554}}} [00020.635] 01046:01049> {{{bt:3:0xffffffff10094270}}} [00020.635] 01046:01049> {{{bt:4:0xffffffff100a5cd4}}} [00020.635] 01046:01049> {{{bt:5:0xffffffff100ab570}}} [00020.635] 01046:01049> {{{bt:6:0xffffffff10031620}}} [00020.635] 01046:01049> {{{bt:7:0xffffffff10053118}}} [00020.635] 01046:01049> {{{bt:8:0xffffffff100d0a10}}} [00020.635] 01046:01049> {{{bt:9:0xffffffff100de590}}} [00020.635] 01046:01049> {{{bt:10:0xffffffff100949dc}}} [00020.635] 01046:01049> [00020.635] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsSmokeTest (0 [00020.635] 01046:01049> ms) [00020.635] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessHandleStats [00020.635] 01046:01049> [00020.635] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessHandleStats (0 [00020.635] 01046:01049> ms) [00020.635] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsOnSelfFails [00020.635] 01046:01049> [00020.635] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsOnSelfFails (0 [00020.635] 01046:01049> ms) [00020.635] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsInvalidHandleFails [00020.635] 01046:01049> [00020.635] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsInvalidHandleFails (0 [00020.635] 01046:01049> ms) [00020.635] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsNullAvailSucceeds [00020.635] 01046:01049> [00020.635] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsNullAvailSucceeds (0 [00020.635] 01046:01049> ms) [00020.635] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsNullActualSucceeds [00020.635] 01046:01049> [00020.635] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsNullActualSucceeds (0 [00020.635] 01046:01049> ms) [00020.635] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsNullActualAndAvailSucceeds [00020.635] 01046:01049> [00020.635] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsNullActualAndAvailSucceeds (0 [00020.635] 01046:01049> ms) [00020.635] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsInvalidBufferPointerFails [00020.635] 01046:01049> [00020.635] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsInvalidBufferPointerFails (0 [00020.635] 01046:01049> ms) [00020.635] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsBadActualgIsInvalidArg [00020.635] 01046:01049> [00020.635] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsBadActualgIsInvalidArg (0 [00020.635] 01046:01049> ms) [00020.635] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsBadAvailIsInvalidArg [00020.635] 01046:01049> [00020.635] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsBadAvailIsInvalidArg (0 [00020.635] 01046:01049> ms) [00020.636] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsZeroSizedBufferIsOk [00020.636] 01046:01049> [00020.636] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsZeroSizedBufferIsOk (0 [00020.636] 01046:01049> ms) [00020.636] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsSmallBufferIsOk [00020.636] 01046:01049> [00020.636] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsSmallBufferIsOk (0 [00020.636] 01046:01049> ms) [00020.636] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsPartiallyUnmappedBufferIsInvalidArgs [00020.636] 01046:01049> [00020.636] 01046:01049> [00020.636] 01046:01049> ZIRCON KERNEL PANIC [00020.636] 01046:01049> Lock validation failed for thread 0xffff000040031188 pid 1046 tid 1049 (bin/core-tests:bin/core-tests): [00020.636] 01046:01049> Reason: Already Acquired [00020.636] 01046:01049> Bad lock: name=lockdep::LockClass<VmAspace, Mutex, 199, lockdep::LockFlagsNone> order=0 [00020.636] 01046:01049> Conflict: name=lockdep::LockClass<VmAspace, Mutex, 199, lockdep::LockFlagsNone> order=0 [00020.636] 01046:01049> caller=0xffffffff100ab264 frame=0xffff008b43394970 [00020.636] 01046:01049> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00020.636] 01046:01049> [00020.636] 01046:01049> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00020.636] 01046:01049> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00020.636] 01046:01049> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00020.636] 01046:01049> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00020.636] 01046:01049> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00020.636] 01046:01049> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00020.636] 01046:01049> bt#00: 0xffffffff100ab264 [00020.636] 01046:01049> bt#01: 0xffffffff100b9b80 [00020.636] 01046:01049> bt#02: 0xffffffff10095554 [00020.636] 01046:01049> bt#03: 0xffffffff10094270 [00020.636] 01046:01049> bt#04: 0xffffffff100ab550 [00020.636] 01046:01049> bt#05: 0xffffffff10031620 [00020.636] 01046:01049> bt#06: 0xffffffff10053118 [00020.636] 01046:01049> bt#07: 0xffffffff100d0a10 [00020.636] 01046:01049> bt#08: 0xffffffff100de590 [00020.636] 01046:01049> bt#09: 0xffffffff100949dc [00020.636] 01046:01049> bt#10: end [00020.636] 01046:01049> {{{bt:0:0xffffffff100ab264}}} [00020.636] 01046:01049> {{{bt:1:0xffffffff100b9b80}}} [00020.636] 01046:01049> {{{bt:2:0xffffffff10095554}}} [00020.636] 01046:01049> {{{bt:3:0xffffffff10094270}}} [00020.636] 01046:01049> {{{bt:4:0xffffffff100ab550}}} [00020.636] 01046:01049> {{{bt:5:0xffffffff10031620}}} [00020.636] 01046:01049> {{{bt:6:0xffffffff10053118}}} [00020.636] 01046:01049> {{{bt:7:0xffffffff100d0a10}}} [00020.636] 01046:01049> {{{bt:8:0xffffffff100de590}}} [00020.636] 01046:01049> {{{bt:9:0xffffffff100949dc}}} [00020.636] 01046:01049> [00020.636] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsPartiallyUnmappedBufferIsInvalidArgs (0 [00020.636] 01046:01049> ms) [00020.636] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsRequiresInspectRights [00020.636] 01046:01049> [00020.636] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsRequiresInspectRights (0 [00020.636] 01046:01049> ms) [00020.636] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsJobHandleIsBadHandle [00020.636] 01046:01049> [00020.636] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsJobHandleIsBadHandle (0 [00020.636] 01046:01049> ms) [00020.636] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessMapsThreadHandleIsBadHandle [00020.636] 01046:01049> [00020.636] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessMapsThreadHandleIsBadHandle (0 [00020.636] 01046:01049> ms) [00020.636] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosSmokeTest [00020.636] 01046:01049> [00020.636] 01046:01049> [00020.636] 01046:01049> ZIRCON KERNEL PANIC [00020.636] 01046:01049> Lock validation failed for thread 0xffff000040031188 pid 1046 tid 1049 (bin/core-tests:bin/core-tests): [00020.636] 01046:01049> Reason: Out Of Order [00020.636] 01046:01049> Bad lock: name=lockdep::LockClass<ProcessDispatcher, BrwLock, 360, lockdep::LockFlagsNone> order=0 [00020.636] 01046:01049> Conflict: name=lockdep::LockClass<SoloDispatcher<ProcessDispatcher, 447439, 0>, Mutex, 282, lockdep::LockFlagsNone> order=0 [00020.636] 01046:01049> caller=0xffffffff10031878 frame=0xffff008b43394c20 [00020.636] 01046:01049> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00020.636] 01046:01049> [00020.636] 01046:01049> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00020.636] 01046:01049> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00020.636] 01046:01049> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00020.636] 01046:01049> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00020.636] 01046:01049> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00020.636] 01046:01049> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00020.636] 01046:01049> bt#00: 0xffffffff10031878 [00020.636] 01046:01049> bt#01: 0xffffffff100532a8 [00020.636] 01046:01049> bt#02: 0xffffffff100cffe8 [00020.636] 01046:01049> bt#03: 0xffffffff100de590 [00020.636] 01046:01049> bt#04: 0xffffffff100949dc [00020.636] 01046:01049> bt#05: end [00020.636] 01046:01049> {{{bt:0:0xffffffff10031878}}} [00020.636] 01046:01049> {{{bt:1:0xffffffff100532a8}}} [00020.636] 01046:01049> {{{bt:2:0xffffffff100cffe8}}} [00020.636] 01046:01049> {{{bt:3:0xffffffff100de590}}} [00020.636] 01046:01049> {{{bt:4:0xffffffff100949dc}}} [00020.636] 01046:01049> [00020.636] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosSmokeTest (0 [00020.636] 01046:01049> ms) [00020.636] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosOnSelfFails [00020.636] 01046:01049> [00020.636] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosOnSelfFails (0 [00020.636] 01046:01049> ms) [00020.636] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosInvalidHandleFails [00020.636] 01046:01049> [00020.636] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosInvalidHandleFails (0 [00020.636] 01046:01049> ms) [00020.636] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosNullAvailSucceeds [00020.636] 01046:01049> [00020.636] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosNullAvailSucceeds (0 [00020.636] 01046:01049> ms) [00020.636] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosNullActualSucceeds [00020.636] 01046:01049> [00020.636] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosNullActualSucceeds (0 [00020.636] 01046:01049> ms) [00020.636] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosNullActualAndAvailSucceeds [00020.636] 01046:01049> [00020.636] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosNullActualAndAvailSucceeds (0 [00020.636] 01046:01049> ms) [00020.636] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosInvalidBufferPointerFails [00020.636] 01046:01049> [00020.636] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosInvalidBufferPointerFails (0 [00020.636] 01046:01049> ms) [00020.636] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosBadActualgIsInvalidArg [00020.636] 01046:01049> [00020.636] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosBadActualgIsInvalidArg (0 [00020.636] 01046:01049> ms) [00020.636] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosBadAvailIsInvalidArg [00020.636] 01046:01049> [00020.636] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosBadAvailIsInvalidArg (0 [00020.636] 01046:01049> ms) [00020.636] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosZeroSizedBufferIsOk [00020.636] 01046:01049> [00020.636] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosZeroSizedBufferIsOk (0 [00020.636] 01046:01049> ms) [00020.636] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosSmallBufferIsOk [00020.636] 01046:01049> [00020.636] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosSmallBufferIsOk (0 [00020.636] 01046:01049> ms) [00020.636] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosPartiallyUnmappedBufferIsInvalidArgs [00020.636] 01046:01049> [00020.636] 01046:01049> [00020.636] 01046:01049> ZIRCON KERNEL PANIC [00020.636] 01046:01049> Lock validation failed for thread 0xffff000040031188 pid 1046 tid 1049 (bin/core-tests:bin/core-tests): [00020.636] 01046:01049> Reason: Already Acquired [00020.636] 01046:01049> Bad lock: name=lockdep::LockClass<VmAspace, Mutex, 199, lockdep::LockFlagsNone> order=0 [00020.636] 01046:01049> Conflict: name=lockdep::LockClass<VmAspace, Mutex, 199, lockdep::LockFlagsNone> order=0 [00020.636] 01046:01049> caller=0xffffffff100ab264 frame=0xffff008b433948f0 [00020.636] 01046:01049> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00020.636] 01046:01049> [00020.636] 01046:01049> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00020.636] 01046:01049> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00020.636] 01046:01049> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00020.636] 01046:01049> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00020.636] 01046:01049> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00020.636] 01046:01049> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00020.636] 01046:01049> bt#00: 0xffffffff100ab264 [00020.636] 01046:01049> bt#01: 0xffffffff100b9b80 [00020.636] 01046:01049> bt#02: 0xffffffff10095554 [00020.636] 01046:01049> bt#03: 0xffffffff10094270 [00020.636] 01046:01049> bt#04: 0xffffffff100a5cd4 [00020.636] 01046:01049> bt#05: 0xffffffff100ab570 [00020.636] 01046:01049> bt#06: 0xffffffff10031738 [00020.636] 01046:01049> bt#07: 0xffffffff1005331c [00020.636] 01046:01049> bt#08: 0xffffffff100cffe8 [00020.636] 01046:01049> bt#09: 0xffffffff100de590 [00020.636] 01046:01049> bt#10: 0xffffffff100949dc [00020.636] 01046:01049> bt#11: end [00020.636] 01046:01049> {{{bt:0:0xffffffff100ab264}}} [00020.636] 01046:01049> {{{bt:1:0xffffffff100b9b80}}} [00020.636] 01046:01049> {{{bt:2:0xffffffff10095554}}} [00020.636] 01046:01049> {{{bt:3:0xffffffff10094270}}} [00020.636] 01046:01049> {{{bt:4:0xffffffff100a5cd4}}} [00020.636] 01046:01049> {{{bt:5:0xffffffff100ab570}}} [00020.636] 01046:01049> {{{bt:6:0xffffffff10031738}}} [00020.636] 01046:01049> {{{bt:7:0xffffffff1005331c}}} [00020.637] 01046:01049> {{{bt:8:0xffffffff100cffe8}}} [00020.637] 01046:01049> {{{bt:9:0xffffffff100de590}}} [00020.637] 01046:01049> {{{bt:10:0xffffffff100949dc}}} [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosPartiallyUnmappedBufferIsInvalidArgs (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosRequiresInspectRights [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosRequiresInspectRights (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosJobHandleIsBadHandle [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosJobHandleIsBadHandle (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessVmosThreadHandleIsBadHandle [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessVmosThreadHandleIsBadHandle (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoHandleBasicOnSelfSuceeds [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoHandleBasicOnSelfSuceeds (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoHandleBasicInvalidHandleFails [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoHandleBasicInvalidHandleFails (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoHandleBasicNullAvailSucceeds [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoHandleBasicNullAvailSucceeds (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoHandleBasicNullActualSucceeds [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoHandleBasicNullActualSucceeds (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoHandleBasicInvalidBufferPointerFails [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoHandleBasicInvalidBufferPointerFails (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoHandleBasicZeroSizedFails [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoHandleBasicZeroSizedFails (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessOnSelfSuceeds [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessOnSelfSuceeds (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessInvalidHandleFails [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessInvalidHandleFails (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessNullAvailSucceeds [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessNullAvailSucceeds (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessNullActualSucceeds [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessNullActualSucceeds (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessNullActualAndAvailSucceeds [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessNullActualAndAvailSucceeds (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessInvalidBufferPointerFails [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessInvalidBufferPointerFails (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessBadActualgIsInvalidArg [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessBadActualgIsInvalidArg (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessBadAvailIsInvalidArg [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessBadAvailIsInvalidArg (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessZeroSizedBufferFails [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessZeroSizedBufferFails (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessJobHandleIsBadHandle [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessJobHandleIsBadHandle (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessThreadHandleIsBadHandle [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessThreadHandleIsBadHandle (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsSelfSuceeds [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessThreadsSelfSuceeds (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsInvalidHandleFails [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessThreadsInvalidHandleFails (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsNullAvailSucceeds [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessThreadsNullAvailSucceeds (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsNullActualSucceeds [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessThreadsNullActualSucceeds (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsNullActualAndAvailSucceeds [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessThreadsNullActualAndAvailSucceeds (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsInvalidBufferPointerFails [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessThreadsInvalidBufferPointerFails (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsBadActualgIsInvalidArg [00020.637] 01046:01049> [00020.637] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessThreadsBadActualgIsInvalidArg (0 [00020.637] 01046:01049> ms) [00020.637] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsBadAvailIsInvalidArg [00020.637] 01046:01049> [00020.638] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessThreadsBadAvailIsInvalidArg (0 [00020.638] 01046:01049> ms) [00020.638] 01046:01049> [ RUN ] ProcessGetInfoTest.InfoProcessThreadsZeroSizedBufferSucceeds [00020.638] 01046:01049> [00020.638] 01046:01049> [ OK ] ProcessGetInfoTest.InfoProcessThreadsZeroSizedBufferSucceeds (0 [00020.638] 01046:01049> ms) [00020.638] 01046:01049> [----------] 61 tests from ProcessGetInfoTest (2 [00020.638] 01046:01049> ms total) [00020.638] 01046:01049> [----------] 12 tests from TaskGetInfoTest [00020.638] 01046:01049> [00020.638] 01046:01049> [ RUN ] TaskGetInfoTest.InfoStatsUnstartedSuceeds [00020.638] 01046:01049> [00020.638] 01046:01049> [ OK ] TaskGetInfoTest.InfoStatsUnstartedSuceeds (0 [00020.638] 01046:01049> ms) [00020.638] 01046:01049> [ RUN ] TaskGetInfoTest.InfoStatsSmokeTest [00020.638] 01046:01049> [00020.638] 01046:01049> [ OK ] TaskGetInfoTest.InfoStatsSmokeTest (0 [00020.638] 01046:01049> ms) [00020.638] 01046:01049> [ RUN ] TaskGetInfoTest.InfoTaskStatsInvalidHandleFails [00020.638] 01046:01049> [00020.638] 01046:01049> [ OK ] TaskGetInfoTest.InfoTaskStatsInvalidHandleFails (0 [00020.638] 01046:01049> ms) [00020.638] 01046:01049> [ RUN ] TaskGetInfoTest.InfoTaskStatsNullAvailSucceeds [00020.638] 01046:01049> [00020.638] 01046:01049> [ OK ] TaskGetInfoTest.InfoTaskStatsNullAvailSucceeds (0 [00020.638] 01046:01049> ms) [00020.638] 01046:01049> [ RUN ] TaskGetInfoTest.InfoTaskStatsNullActualSucceeds [00020.638] 01046:01049> [00020.638] 01046:01049> [ OK ] TaskGetInfoTest.InfoTaskStatsNullActualSucceeds (0 [00020.638] 01046:01049> ms) [00020.638] 01046:01049> [ RUN ] TaskGetInfoTest.InfoTaskStatsNullActualAndAvailSucceeds [00020.638] 01046:01049> [00020.638] 01046:01049> [ OK ] TaskGetInfoTest.InfoTaskStatsNullActualAndAvailSucceeds (0 [00020.638] 01046:01049> ms) [00020.638] 01046:01049> [ RUN ] TaskGetInfoTest.InfoTaskStatsInvalidBufferPointerFails [00020.638] 01046:01049> [00020.638] 01046:01049> [ OK ] TaskGetInfoTest.InfoTaskStatsInvalidBufferPointerFails (0 [00020.638] 01046:01049> ms) [00020.638] 01046:01049> [ RUN ] TaskGetInfoTest.InfoTaskStatsBadActualgIsInvalidArg [00020.638] 01046:01049> [00020.638] 01046:01049> [ OK ] TaskGetInfoTest.InfoTaskStatsBadActualgIsInvalidArg (0 [00020.638] 01046:01049> ms) [00020.638] 01046:01049> [ RUN ] TaskGetInfoTest.InfoTaskStatsBadAvailIsInvalidArg [00020.638] 01046:01049> [00020.638] 01046:01049> [ OK ] TaskGetInfoTest.InfoTaskStatsBadAvailIsInvalidArg (0 [00020.638] 01046:01049> ms) [00020.638] 01046:01049> [ RUN ] TaskGetInfoTest.InfoTaskStatsZeroSizedBufferIsTooSmall [00020.638] 01046:01049> [00020.638] 01046:01049> [ OK ] TaskGetInfoTest.InfoTaskStatsZeroSizedBufferIsTooSmall (0 [00020.638] 01046:01049> ms) [00020.638] 01046:01049> [ RUN ] TaskGetInfoTest.InfoTaskStatsJobHandleIsBadHandle [00020.638] 01046:01049> [00020.638] 01046:01049> [ OK ] TaskGetInfoTest.InfoTaskStatsJobHandleIsBadHandle (0 [00020.638] 01046:01049> ms) [00020.638] 01046:01049> [ RUN ] TaskGetInfoTest.InfoTaskStatsThreadHandleIsBadHandle [00020.638] 01046:01049> [00020.638] 01046:01049> [ OK ] TaskGetInfoTest.InfoTaskStatsThreadHandleIsBadHandle (0 [00020.638] 01046:01049> ms) [00020.638] 01046:01049> [----------] 12 tests from TaskGetInfoTest (0 [00020.638] 01046:01049> ms total) [00020.638] 01046:01049> [----------] 41 tests from ThreadGetInfoTest [00020.638] 01046:01049> [00020.638] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleBasicOnSelfSuceeds [00020.638] 01046:01049> [00020.638] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleBasicOnSelfSuceeds (0 [00020.638] 01046:01049> ms) [00020.638] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleBasicInvalidHandleFails [00020.638] 01046:01049> [00020.638] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleBasicInvalidHandleFails (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleBasicNullAvailSucceeds [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleBasicNullAvailSucceeds (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleBasicNullActualSucceeds [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleBasicNullActualSucceeds (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleBasicInvalidBufferPointerFails [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleBasicInvalidBufferPointerFails (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleBasicZeroSizedBufferFails [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleBasicZeroSizedBufferFails (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleCountOnSelfSuceeds [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleCountOnSelfSuceeds (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleCountInvalidHandleFails [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleCountInvalidHandleFails (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleCountNullAvailSucceeds [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleCountNullAvailSucceeds (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleCountNullActualSucceeds [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleCountNullActualSucceeds (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleCountNullActualAndAvailSucceeds [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleCountNullActualAndAvailSucceeds (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleCountInvalidBufferPointerFails [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleCountInvalidBufferPointerFails (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleCountBadActualgIsInvalidArg [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleCountBadActualgIsInvalidArg (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleCountBadAvailIsInvalidArg [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleCountBadAvailIsInvalidArg (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoHandleCountZeroSizedBufferFails [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoHandleCountZeroSizedBufferFails (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadOnSelfSuceeds [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadOnSelfSuceeds (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadInvalidHandleFails [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadInvalidHandleFails (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadNullAvailSucceeds [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadNullAvailSucceeds (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadNullActualSucceeds [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadNullActualSucceeds (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadNullActualAndAvailSucceeds [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadNullActualAndAvailSucceeds (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadInvalidBufferPointerFails [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadInvalidBufferPointerFails (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadBadActualgIsInvalidArg [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadBadActualgIsInvalidArg (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadBadAvailIsInvalidArg [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadBadAvailIsInvalidArg (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadZeroSizedBufferFails [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadZeroSizedBufferFails (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadJobHandleIsBadHandle [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadJobHandleIsBadHandle (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadProcessHandleIsBadHandle [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadProcessHandleIsBadHandle (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadStatsOnSelfSuceeds [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadStatsOnSelfSuceeds (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadStatsInvalidHandleFails [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadStatsInvalidHandleFails (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadStatsNullAvailSucceeds [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadStatsNullAvailSucceeds (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadStatsNullActualSucceeds [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadStatsNullActualSucceeds (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadStatsNullActualAndAvailSucceeds [00020.639] 01046:01049> [00020.639] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadStatsNullActualAndAvailSucceeds (0 [00020.639] 01046:01049> ms) [00020.639] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadStatsInvalidBufferPointerFails [00020.639] 01046:01049> [00020.640] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadStatsInvalidBufferPointerFails (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadStatsBadActualgIsInvalidArg [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadStatsBadActualgIsInvalidArg (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadStatsBadAvailIsInvalidArg [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadStatsBadAvailIsInvalidArg (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadStatsZeroSizedBufferFails [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadStatsZeroSizedBufferFails (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadStatsJobHandleIsBadHandle [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadStatsJobHandleIsBadHandle (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadStatsProcessHandleIsBadHandle [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadStatsProcessHandleIsBadHandle (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] ThreadGetInfoTest.InfoThreadExceptionReportInvalidHandleFails [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] ThreadGetInfoTest.InfoThreadExceptionReportInvalidHandleFails (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [----------] 41 tests from ThreadGetInfoTest (1 [00020.640] 01046:01049> ms total) [00020.640] 01046:01049> [----------] 21 tests from VmarGetInfoTest [00020.640] 01046:01049> [00020.640] 01046:01049> [ RUN ] VmarGetInfoTest.InfoHandleBasicOnSelfSuceeds [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] VmarGetInfoTest.InfoHandleBasicOnSelfSuceeds (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] VmarGetInfoTest.InfoHandleBasicInvalidHandleFails [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] VmarGetInfoTest.InfoHandleBasicInvalidHandleFails (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] VmarGetInfoTest.InfoHandleBasicNullAvailSucceeds [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] VmarGetInfoTest.InfoHandleBasicNullAvailSucceeds (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] VmarGetInfoTest.InfoHandleBasicNullActualSucceeds [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] VmarGetInfoTest.InfoHandleBasicNullActualSucceeds (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] VmarGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] VmarGetInfoTest.InfoHandleBasicNullActualAndAvailSucceeds (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] VmarGetInfoTest.InfoHandleBasicInvalidBufferPointerFails [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] VmarGetInfoTest.InfoHandleBasicInvalidBufferPointerFails (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] VmarGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] VmarGetInfoTest.InfoHandleBasicBadActualgIsInvalidArg (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] VmarGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] VmarGetInfoTest.InfoHandleBasicBadAvailIsInvalidArg (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] VmarGetInfoTest.InfoHandleBasicZeroSizedBufferFails [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] VmarGetInfoTest.InfoHandleBasicZeroSizedBufferFails (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarOnSelfFails [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarOnSelfFails (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarInvalidHandleFails [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarInvalidHandleFails (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarNullAvailSucceeds [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarNullAvailSucceeds (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarNullActualSucceeds [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarNullActualSucceeds (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarNullActualAndAvailSucceeds [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarNullActualAndAvailSucceeds (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarInvalidBufferPointerFails [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarInvalidBufferPointerFails (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarBadActualgIsInvalidArg [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarBadActualgIsInvalidArg (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarBadAvailIsInvalidArg [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarBadAvailIsInvalidArg (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarZeroSizedBufferFails [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarZeroSizedBufferFails (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarJobHandleIsBadHandle [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarJobHandleIsBadHandle (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarProcessHandleIsBadHandle [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarProcessHandleIsBadHandle (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] VmarGetInfoTest.InfoVmarThreadHandleIsBadHandle [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] VmarGetInfoTest.InfoVmarThreadHandleIsBadHandle (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [----------] 21 tests from VmarGetInfoTest (0 [00020.640] 01046:01049> ms total) [00020.640] 01046:01049> [----------] 28 tests from SocketTest [00020.640] 01046:01049> [00020.640] 01046:01049> [ RUN ] SocketTest.EndpointsAreRelated [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] SocketTest.EndpointsAreRelated (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] SocketTest.EmptySocketShouldWait [00020.640] 01046:01049> [00020.640] 01046:01049> [ OK ] SocketTest.EmptySocketShouldWait (0 [00020.640] 01046:01049> ms) [00020.640] 01046:01049> [ RUN ] SocketTest.WriteReadDataVerify [00020.640] 01046:01049> [00020.641] 01046:01049> [ OK ] SocketTest.WriteReadDataVerify (0 [00020.641] 01046:01049> ms) [00020.641] 01046:01049> [ RUN ] SocketTest.PeerClosedError [00020.641] 01046:01049> [00020.641] 01046:01049> [ OK ] SocketTest.PeerClosedError (0 [00020.641] 01046:01049> ms) [00020.641] 01046:01049> [ RUN ] SocketTest.PeekingLeavesData [00020.641] 01046:01049> [00020.641] 01046:01049> [ OK ] SocketTest.PeekingLeavesData (0 [00020.641] 01046:01049> ms) [00020.641] 01046:01049> [ RUN ] SocketTest.PeekingIntoEmpty [00020.641] 01046:01049> [00020.641] 01046:01049> [ OK ] SocketTest.PeekingIntoEmpty (0 [00020.641] 01046:01049> ms) [00020.641] 01046:01049> [ RUN ] SocketTest.Signals [00020.641] 01046:01049> [00020.641] 01046:01049> [ OK ] SocketTest.Signals (0 [00020.641] 01046:01049> ms) [00020.641] 01046:01049> [ RUN ] SocketTest.SetThreshholdsProp [00020.641] 01046:01049> [00020.641] 01046:01049> [ OK ] SocketTest.SetThreshholdsProp (0 [00020.641] 01046:01049> ms) [00020.641] 01046:01049> [ RUN ] SocketTest.SetThreshholdsAndCheckSignals [00020.641] 01046:01049> [00020.642] 01046:01049> [ OK ] SocketTest.SetThreshholdsAndCheckSignals (0 [00020.642] 01046:01049> ms) [00020.642] 01046:01049> [ RUN ] SocketTest.SignalClosedPeer [00020.642] 01046:01049> [00020.642] 01046:01049> [ OK ] SocketTest.SignalClosedPeer (0 [00020.642] 01046:01049> ms) [00020.642] 01046:01049> [ RUN ] SocketTest.PeerClosedSetProperty [00020.642] 01046:01049> [00020.642] 01046:01049> [ OK ] SocketTest.PeerClosedSetProperty (0 [00020.642] 01046:01049> ms) [00020.642] 01046:01049> [ RUN ] SocketTest.ShutdownWrite [00020.642] 01046:01049> [00020.642] 01046:01049> [ OK ] SocketTest.ShutdownWrite (0 [00020.642] 01046:01049> ms) [00020.642] 01046:01049> [ RUN ] SocketTest.ShutdownRead [00020.642] 01046:01049> [00020.642] 01046:01049> [ OK ] SocketTest.ShutdownRead (0 [00020.642] 01046:01049> ms) [00020.642] 01046:01049> [ RUN ] SocketTest.BytesOutstanding [00020.642] 01046:01049> [00020.642] 01046:01049> [ OK ] SocketTest.BytesOutstanding (0 [00020.642] 01046:01049> ms) [00020.642] 01046:01049> [ RUN ] SocketTest.ShutdownWriteBytesOutstanding [00020.642] 01046:01049> [00020.642] 01046:01049> [ OK ] SocketTest.ShutdownWriteBytesOutstanding (0 [00020.642] 01046:01049> ms) [00020.642] 01046:01049> [ RUN ] SocketTest.ShutdownReadBytesOutstanding [00020.642] 01046:01049> [00020.642] 01046:01049> [ OK ] SocketTest.ShutdownReadBytesOutstanding (0 [00020.642] 01046:01049> ms) [00020.642] 01046:01049> [ RUN ] SocketTest.ShortWrite [00020.642] 01046:01049> [00020.642] 01046:01049> [ OK ] SocketTest.ShortWrite (0 [00020.642] 01046:01049> ms) [00020.642] 01046:01049> [ RUN ] SocketTest.Datagram [00020.642] 01046:01049> [00020.642] 01046:01049> [ OK ] SocketTest.Datagram (0 [00020.642] 01046:01049> ms) [00020.642] 01046:01049> [ RUN ] SocketTest.DatagramPeek [00020.642] 01046:01049> [00020.642] 01046:01049> [ OK ] SocketTest.DatagramPeek (0 [00020.642] 01046:01049> ms) [00020.642] 01046:01049> [ RUN ] SocketTest.DatagramPeekEmpty [00020.642] 01046:01049> [00020.642] 01046:01049> [ OK ] SocketTest.DatagramPeekEmpty (0 [00020.642] 01046:01049> ms) [00020.642] 01046:01049> [ RUN ] SocketTest.DatagramNoShortWrite [00020.642] 01046:01049> [00020.643] 01046:01049> [ OK ] SocketTest.DatagramNoShortWrite (0 [00020.643] 01046:01049> ms) [00020.643] 01046:01049> [ RUN ] SocketTest.ControlPlaneAbsent [00020.643] 01046:01049> [00020.643] 01046:01049> [ OK ] SocketTest.ControlPlaneAbsent (0 [00020.643] 01046:01049> ms) [00020.643] 01046:01049> [ RUN ] SocketTest.ControlPlane [00020.643] 01046:01049> [00020.643] 01046:01049> [ OK ] SocketTest.ControlPlane (0 [00020.643] 01046:01049> ms) [00020.643] 01046:01049> [ RUN ] SocketTest.ControlPlanePeek [00020.643] 01046:01049> [00020.643] 01046:01049> [ OK ] SocketTest.ControlPlanePeek (0 [00020.643] 01046:01049> ms) [00020.643] 01046:01049> [ RUN ] SocketTest.ControlPlanePeekEmpty [00020.643] 01046:01049> [00020.643] 01046:01049> [ OK ] SocketTest.ControlPlanePeekEmpty (0 [00020.643] 01046:01049> ms) [00020.643] 01046:01049> [ RUN ] SocketTest.ControlPlaneShutdown [00020.643] 01046:01049> [00020.643] 01046:01049> [ OK ] SocketTest.ControlPlaneShutdown (0 [00020.643] 01046:01049> ms) [00020.643] 01046:01049> [ RUN ] SocketTest.Accept [00020.643] 01046:01049> [00020.643] 01046:01049> [00020.643] 01046:01049> ZIRCON KERNEL PANIC [00020.643] 01046:01049> Lock validation failed for thread 0xffff000040031188 pid 1046 tid 1049 (bin/core-tests:bin/core-tests): [00020.643] 01046:01049> Reason: Already Acquired [00020.643] 01046:01049> Bad lock: name=lockdep::LockClass<PeerHolder<SocketDispatcher>, Mutex, 319, lockdep::LockFlagsNone> order=0 [00020.643] 01046:01049> Conflict: name=lockdep::LockClass<PeerHolder<SocketDispatcher>, Mutex, 319, lockdep::LockFlagsNone> order=0 [00020.643] 01046:01049> caller=0xffffffff10034760 frame=0xffff008b43394d10 [00020.643] 01046:01049> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00020.643] 01046:01049> [00020.643] 01046:01049> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00020.643] 01046:01049> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00020.643] 01046:01049> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00020.643] 01046:01049> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00020.643] 01046:01049> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00020.643] 01046:01049> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00020.643] 01046:01049> bt#00: 0xffffffff10034760 [00020.643] 01046:01049> bt#01: 0xffffffff1003fdc8 [00020.643] 01046:01049> bt#02: 0xffffffff10058954 [00020.643] 01046:01049> bt#03: 0xffffffff100d64cc [00020.643] 01046:01049> bt#04: 0xffffffff100dfe30 [00020.643] 01046:01049> bt#05: 0xffffffff10094a80 [00020.643] 01046:01049> bt#06: end [00020.643] 01046:01049> {{{bt:0:0xffffffff10034760}}} [00020.643] 01046:01049> {{{bt:1:0xffffffff1003fdc8}}} [00020.643] 01046:01049> {{{bt:2:0xffffffff10058954}}} [00020.643] 01046:01049> {{{bt:3:0xffffffff100d64cc}}} [00020.643] 01046:01049> {{{bt:4:0xffffffff100dfe30}}} [00020.643] 01046:01049> {{{bt:5:0xffffffff10094a80}}} [00020.643] 01046:01049> [00020.643] 01046:01049> [00020.643] 01046:01049> ZIRCON KERNEL PANIC [00020.643] 01046:01049> Lock validation failed for thread 0xffff000040031188 pid 1046 tid 1049 (bin/core-tests:bin/core-tests): [00020.643] 01046:01049> Reason: Already Acquired [00020.643] 01046:01049> Bad lock: name=lockdep::LockClass<PeerHolder<SocketDispatcher>, Mutex, 319, lockdep::LockFlagsNone> order=0 [00020.643] 01046:01049> Conflict: name=lockdep::LockClass<PeerHolder<SocketDispatcher>, Mutex, 319, lockdep::LockFlagsNone> order=0 [00020.643] 01046:01049> caller=0xffffffff10059384 frame=0xffff008b43394d40 [00020.643] 01046:01049> BUILDID git-2b53c557b839d2876b61b4e4cbad333520db1bc9-dirty [00020.643] 01046:01049> [00020.643] 01046:01049> {{{module:0:kernel:elf:c195e43bc3eeddba}}} [00020.643] 01046:01049> {{{mmap:0xffffffff10000000:0x10dc84:load:0:rx:0xffffffff00000000}}} [00020.643] 01046:01049> {{{mmap:0xffffffff1010e000:0x3e000:load:0:r:0xffffffff0010e000}}} [00020.643] 01046:01049> {{{mmap:0xffffffff1014c000:0xf50:load:0:rw:0xffffffff0014c000}}} [00020.643] 01046:01049> {{{mmap:0xffffffff10150000:0x76000:load:0:rw:0xffffffff00150000}}} [00020.643] 01046:01049> dso: id=c195e43bc3eeddba base=0xffffffff10000000 name=zircon.elf [00020.643] 01046:01049> bt#00: 0xffffffff10059384 [00020.643] 01046:01049> bt#01: 0xffffffff1003fe64 [00020.643] 01046:01049> bt#02: 0xffffffff10058954 [00020.643] 01046:01049> bt#03: 0xffffffff100d64cc [00020.643] 01046:01049> bt#04: 0xffffffff100dfe30 [00020.643] 01046:01049> bt#05: 0xffffffff10094a80 [00020.643] 01046:01049> bt#06: end [00020.643] 01046:01049> {{{bt:0:0xffffffff10059384}}} [00020.643] 01046:01049> {{{bt:1:0xffffffff1003fe64}}} [00020.643] 01046:01049> {{{bt:2:0xffffffff10058954}}} [00020.643] 01046:01049> {{{bt:3:0xffffffff100d64cc}}} [00020.643] 01046:01049> {{{bt:4:0xffffffff100dfe30}}} [00020.643] 01046:01049> {{{bt:5:0xffffffff10094a80}}} [00020.643] 01046:01049> [00020.643] 01046:01049> [ OK ] SocketTest.Accept (0 [00020.643] 01046:01049> ms) [00020.643] 01046:01049> [ RUN ] SocketTest.ZeroSize [00020.643] 01046:01049> [00020.643] 01046:01049> [ OK ] SocketTest.ZeroSize (0 [00020.643] 01046:01049> ms) [00020.643] 01046:01049> [----------] 28 tests from SocketTest (2 [00020.643] 01046:01049> ms total) [00020.643] 01046:01049> [----------] Global test environment tear-down. [00020.643] 01046:01049> [==========] 240 tests from 12 test cases ran (2719 [00020.643] 01046:01049> ms total). [00020.643] 01046:01049> [ PASSED ] 240 tests [00020.643] 01046:01049> [00020.643] 01046:01049> core-tests succeeded RZMm59f7zOSs6aZUIXZR [00020.644] 01032:01039> userboot: loader-service channel peer closed [00020.644] 01032:01039> userboot: Waiting for bin/core-tests to exit... [00020.645] 01032:01039> userboot: Process exited. Executing "poweroff". [00021.438] 01032:01039> mp_unplug_cpu_mask_single_locked:362: WARNING: leaking thread for cpu 3 [00021.440] 01032:01039> mp_unplug_cpu_mask_single_locked:362: WARNING: leaking thread for cpu 2 [00021.441] 01032:01039> mp_unplug_cpu_mask_single_locked:362: WARNING: leaking thread for cpu 1 [00021.441] 01032:01039> Shutting down debuglog