2019/03/26 17:08:16 QEMU invocation:
[/b/s/w/ir/qemu/bin/qemu-system-x86_64 -machine q35 -device isa-debug-exit,iobase=0xf4,iosize=0x04 -cpu host -enable-kvm -m 4096 -smp 4 -nographic -serial stdio -monitor none -kernel /b/s/w/ir/multiboot.bin -initrd /b/s/w/ir/core-tests-x64.zbi -append kernel.halt-on-panic=true devmgr.suspend-timeout-debug=true TERM=dumb kernel.serial=legacy]
[00000.000] 00000.00000> zbi: @ 0xffffff8000771000 (6741056 bytes)
[00000.000] 00000.00000> UART: FIFO depth 16
[00000.000] 00000.00000> PMM: boot reserve add [0x100000, 0x2f6fff]
[00000.000] 00000.00000> PMM: boot reserve add [0x771000, 0xddefff]
[00000.000] 00000.00000> PMM: boot reserve marking WIRED [0x100000, 0x2f6fff]
[00000.000] 00000.00000> PMM: boot reserve marking WIRED [0x771000, 0xddefff]
[00000.000] 00000.00000>
[00000.000] 00000.00000> welcome to Zircon
[00000.000] 00000.00000>
[00000.000] 00000.00000> KASLR: .text section at 0xffffffff00100000
[00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0010f204 (global_prng_seed) at level 0x30000, flags 0x1
[00000.000] 00000.00000> initializing vm pre-heap
[00000.000] 00000.00000> VM: marking boot alloc used range [0xddf000, 0xddf080)
[00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0011c4a8 (elf_build_id) at level 0x4fffe, flags 0x1
[00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0011c634 (version) at level 0x4ffff, flags 0x1
[00000.000] 00000.00000> version:
[00000.000] 00000.00000> arch: x86
[00000.000] 00000.00000> platform: XXX
[00000.000] 00000.00000> target: XXX
[00000.000] 00000.00000> project: x64
[00000.000] 00000.00000> buildid: git-0f192d2e18a63b9428bcda071d0a4c25f58037d3-dirty
[00000.000] 00000.00000> ELF build ID: 5b2ed783e7275a7fa08c655d270d140dd165c776
[00000.000] 00000.00000> initializing heap
[00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00101f78 (console) at level 0x50000, flags 0x1
[00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00175974 (x86_resource_init) at level 0x50000, flags 0x1
[00000.000] 00000.00000> initializing vm
[00000.000] 00000.00000> VM: reserving kernel region [0xffffffff00100000, 0xffffffff00205000) flags 0x28 name 'kernel_code'
[00000.000] 00000.00000> VM: reserving kernel region [0xffffffff00205000, 0xffffffff00253000) flags 0x8 name 'kernel_rodata'
[00000.000] 00000.00000> VM: reserving kernel region [0xffffffff00253000, 0xffffffff0026d000) flags 0x18 name 'kernel_data'
[00000.000] 00000.00000> VM: reserving kernel region [0xffffffff0026d000, 0xffffffff002f7000) flags 0x18 name 'kernel_bss'
[00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00176638 (display_memtype) at level 0x60001, flags 0x1
[00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff001796a0 (acpi_tables) at level 0x60001, flags 0x1
[00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00174798 (hpet) at level 0x60002, flags 0x1
[00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00174b58 (apic) at level 0x60002, flags 0x1
[00000.000] 00000.00000> x2APIC enabled
[00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00178c90 (timer) at level 0x60003, flags 0x1
[00000.000] 00000.00000> pvclock: Clocksource is stable
[00000.000] 00000.00000> HPET frequency: 100000 ticks/ms
[00000.000] 00000.00000> pvclock: Fetching TSC frequency
[00000.000] 00000.00000> TSC frequency: 2299998 ticks/ms
[00000.418] 00000.00000> timer features: constant_tsc 1 invariant_tsc 1 tsc_deadline 1
[00000.418] 00000.00000> Using TSC as wallclock
[00000.418] 00000.00000> initializing kernel
[00000.418] 00000.00000> initializing mp
[00000.418] 00000.00000> initializing timers
[00000.418] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0010f458 (global_prng_thread_safe) at level 0x7ffff, flags 0x1
[00000.418] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0011b760 (debuglog) at level 0x7ffff, flags 0x1
[00000.418] 00000.00000> INIT: cpu 0, calling hook 0xffffffff001ea134 (thread_set_priority_experiment) at level 0x7ffff, flags 0x1
[00000.418] 00000.00000> thread set priority experiment is : ENABLED
[00000.418] 00000.00000> creating bootstrap completion thread
[00000.593] 00000.00000> top of bootstrap2()
[00000.593] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0012936c (libobject) at level 0x80000, flags 0x1
[00000.593] 00000.00000> OOM: started thread
[00000.602] 00000.00000> INIT: cpu 0, calling hook 0xffffffff001a1b80 (dpc) at level 0x80000, flags 0x1
[00000.607] 00000.00000> Processor Model Info: type 0 family 0x6 model 0xf stepping 0
[00000.607] 00000.00000> display_family 0x6 display_model 0x3f
[00000.607] 00000.00000> Vendor: Intel
[00000.607] 00000.00000> Microarch: Haswell
[00000.607] 00000.00000> F/M/S: 6/3f/0
[00000.607] 00000.00000> Brand: Intel(R) Xeon(R) CPU @ 2.30GHz
[00000.607] 00000.00000> Features: fpu sse sse2 sse3 ssse3 sse4.1 sse4.2 mmx avx avx2 fxsr pcid xsave aesni clflush
[00000.607] 00000.00000> fsgsbase tsc_adj smep erms rdrand syscall nx rdtscp tsc_deadline x2apic hypervisor
[00000.607] 00000.00000> initializing platform
[00000.607] 00000.00000> INIT: cpu 0, calling hook 0xffffffff001921b8 (x86_perfmon) at level 0x90000, flags 0x1
[00000.607] 00000.00000> x86_perfmon_init_once:497: perfmon: unexpected programmable counter width 0 in cpuid.0AH
[00000.608] 00000.00000> UART: started IRQ driven RX
[00000.608] 00000.00000> UART: started IRQ driven TX
[00000.608] 00000.00000> cpu topology:
[00000.608] 00000.00000> 0: apic id 0x0 package 0 node 0 core 0 smt 0 BSP
[00000.608] 00000.00000> 1: apic id 0x1 package 1 node 0 core 0 smt 0
[00000.608] 00000.00000> 2: apic id 0x2 package 2 node 0 core 0 smt 0
[00000.608] 00000.00000> 3: apic id 0x3 package 3 node 0 core 0 smt 0
[00000.608] 00000.00000> Found 4 cpus
[00000.608] 00000.00000> booting apic ids: 0x1 0x2 0x3
[00000.682] 00000.00000> entering scheduler on cpu 3
[00000.682] 00000.00000> entering scheduler on cpu 1
[00000.682] 00000.00000> entering scheduler on cpu 2
[00000.692] 00000.00000> smbios: manufacturer="QEMU" product="Standard PC (Q35 + ICH9, 2009)"
[00000.692] 00000.00000> initializing target
[00000.692] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00177f40 (x86_pcie_init) at level 0xa0000, flags 0x1
[00000.692] 00000.00000> moving to last init level
[00000.692] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00102a48 (kernel_shell) at level 0xc0000, flags 0x1
[00000.692] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00200330 (ktrace) at level 0xc0000, flags 0x1
[00000.730] 00000.00000> ktrace: buffer at 0xffffff96fd229000 (33554432 bytes)
[00000.731] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0020240c (userboot) at level 0xc0000, flags 0x1
[00000.731] 00000.00000> userboot: ramdisk 0x66e000 @ 0xffffff8000771000
[00000.746] 00000.00000> userboot: userboot rodata 0 @ [0x2ac7cb48e000,0x2ac7cb491000)
[00000.746] 00000.00000> userboot: userboot code 0x3000 @ [0x2ac7cb491000,0x2ac7cb49c000)
[00000.746] 00000.00000> userboot: vdso/full rodata 0 @ [0x2ac7cb49c000,0x2ac7cb4a3000)
[00000.746] 00000.00000> userboot: vdso/full code 0x7000 @ [0x2ac7cb4a3000,0x2ac7cb4a4000)
[00000.746] 00000.00000> userboot: entry point @ 0x2ac7cb491c90
[00000.770] 01034.01041> userboot: option "userboot=bin/core-tests"
[00000.770] 01034.01041> userboot: option "userboot.shutdown="
[00000.770] 01034.01041> userboot: option "/b/s/w/ir/multiboot.bin="
[00000.770] 01034.01041> userboot: option "kernel.halt-on-panic=true"
[00000.770] 01034.01041> userboot: option "devmgr.suspend-timeout-debug=true"
[00000.770] 01034.01041> userboot: option "TERM=dumb"
[00000.770] 01034.01041> userboot: option "kernel.serial=legacy"
[00000.770] 01034.01041> userboot: option "multiboot.boot_loader_name=qemu"
[00000.795] 01034.01041> userboot: searching bootfs for 'bin/core-tests'
[00000.795] 01034.01041> userboot: 'bin/core-tests' has PT_INTERP "lib/asan/ld.so.1"
[00000.795] 01034.01041> userboot: searching bootfs for 'lib/asan/ld.so.1'
[00000.795] 01034.01041> userboot: userboot: loaded lib/asan/ld.so.1 at 0x78b2add31000, entry point 0x78b2ade071a8
[00000.795] 01034.01041> userboot: userboot: loaded vDSO at 0x42362eaae000, entry point 0x0
[00000.795] 01034.01041> userboot: process bin/core-tests started.
[00000.795] 01034.01041> userboot: waiting for loader-service requests...
[00000.831] 01034.01041> userboot: searching bootfs for 'lib/asan/libclang_rt.asan.so'
[00000.831] 01034.01041> userboot: file not found
[00000.831] 01034.01041> userboot: searching bootfs for 'lib/libclang_rt.asan.so'
[00000.850] 01034.01041> userboot: searching bootfs for 'lib/asan/libc++abi.so.1'
[00000.850] 01034.01041> userboot: searching bootfs for 'lib/asan/libunwind.so.1'
[00000.850] 01034.01041> userboot: searching bootfs for 'lib/asan/libfdio.so'
[00000.851] 01034.01041> userboot: searching bootfs for 'lib/asan/libunittest.so'
[00000.867] 01034.01041> userboot: searching bootfs for 'lib/asan/libmini-process.so'
[00000.868] 01034.01041> userboot: searching bootfs for 'lib/asan/libbacktrace.so'
[00000.868] 01034.01041> userboot: searching bootfs for 'lib/asan/libngunwind.so'
[00000.882] 01048.01051> {{{reset}}}
[00000.882] 01048.01051> {{{module:0:<application>:elf:ad8ea19432e23219}}}
[00000.882] 01048.01051> {{{mmap:0x7bf38caf0000:0x77000:load:0:r:0}}}
[00000.882] 01048.01051> {{{mmap:0x7bf38cb67000:0x185000:load:0:rx:0x77000}}}
[00000.882] 01048.01051> {{{mmap:0x7bf38ccec000:0x5b000:load:0:rw:0x1fc000}}}
[00000.882] 01048.01051> dso: id=ad8ea19432e23219 base=0x00007bf38caf0000 name=<application>
[00000.882] 01048.01051> {{{module:0x3:libclang_rt.asan.so:elf:c0c6dc57f211fcce}}}
[00000.882] 01048.01051> {{{mmap:0x3e9e89e6e000:0x23000:load:0x3:r:0}}}
[00000.882] 01048.01051> {{{mmap:0x3e9e89e91000:0x3d000:load:0x3:rx:0x23000}}}
[00000.882] 01048.01051> {{{mmap:0x3e9e89ece000:0x924000:load:0x3:rw:0x60000}}}
[00000.882] 01048.01051> dso: id=c0c6dc57f211fcce base=0x00003e9e89e6e000 name=libclang_rt.asan.so
[00000.882] 01048.01051> {{{module:0x6:libfdio.so:elf:d65d99195d24603a}}}
[00000.882] 01048.01051> {{{mmap:0x5f8cb7f20000:0x15000:load:0x6:r:0}}}
[00000.882] 01048.01051> {{{mmap:0x5f8cb7f35000:0x4c000:load:0x6:rx:0x15000}}}
[00000.882] 01048.01051> {{{mmap:0x5f8cb7f81000:0xe000:load:0x6:rw:0x61000}}}
[00000.882] 01048.01051> dso: id=d65d99195d24603a base=0x00005f8cb7f20000 name=libfdio.so
[00000.882] 01048.01051> {{{module:0x7:libunittest.so:elf:7cf945e5a11317e0}}}
[00000.882] 01048.01051> {{{mmap:0x498c8032a000:0x6000:load:0x7:r:0}}}
[00000.882] 01048.01051> {{{mmap:0x498c80330000:0x5000:load:0x7:rx:0x6000}}}
[00000.882] 01048.01051> {{{mmap:0x498c80335000:0x5000:load:0x7:rw:0xb000}}}
[00000.882] 01048.01051> dso: id=7cf945e5a11317e0 base=0x0000498c8032a000 name=libunittest.so
[00000.882] 01048.01051> {{{module:0x2:<vDSO>:elf:8076fab1ee42c4a51a329c4d5d03c323b251e9ad}}}
[00000.882] 01048.01051> {{{mmap:0x42362eaae000:0x7000:load:0x2:r:0}}}
[00000.882] 01048.01051> {{{mmap:0x42362eab5000:0x1000:load:0x2:rx:0x7000}}}
[00000.882] 01048.01051> dso: id=8076fab1ee42c4a51a329c4d5d03c323b251e9ad base=0x000042362eaae000 name=<vDSO>
[00000.882] 01048.01051> {{{module:0x8:libmini-process.so:elf:a12b993364ef9bad}}}
[00000.882] 01048.01051> {{{mmap:0x7fc625567000:0x3000:load:0x8:r:0}}}
[00000.882] 01048.01051> {{{mmap:0x7fc62556a000:0x4000:load:0x8:rx:0x3000}}}
[00000.882] 01048.01051> {{{mmap:0x7fc62556e000:0x3000:load:0x8:rw:0x7000}}}
[00000.882] 01048.01051> dso: id=a12b993364ef9bad base=0x00007fc625567000 name=libmini-process.so
[00000.882] 01048.01051> {{{module:0x9:libbacktrace.so:elf:5d3baed54ca638db}}}
[00000.882] 01048.01051> {{{mmap:0x6249e623c000:0x5000:load:0x9:r:0}}}
[00000.882] 01048.01051> {{{mmap:0x6249e6241000:0x23000:load:0x9:rx:0x5000}}}
[00000.882] 01048.01051> {{{mmap:0x6249e6264000:0x3000:load:0x9:rw:0x28000}}}
[00000.882] 01048.01051> dso: id=5d3baed54ca638db base=0x00006249e623c000 name=libbacktrace.so
[00000.882] 01048.01051> {{{module:0xa:libngunwind.so:elf:85d3f025dcf77cc4}}}
[00000.882] 01048.01051> {{{mmap:0x3ddd9db48000:0xc000:load:0xa:r:0}}}
[00000.882] 01048.01051> {{{mmap:0x3ddd9db54000:0x2e000:load:0xa:rx:0xc000}}}
[00000.882] 01048.01051> {{{mmap:0x3ddd9db82000:0x1b000:load:0xa:rw:0x3a000}}}
[00000.882] 01048.01051> dso: id=85d3f025dcf77cc4 base=0x00003ddd9db48000 name=libngunwind.so
[00000.882] 01048.01051> {{{module:0x4:libc++abi.so.1:elf:11c299f503022124}}}
[00000.882] 01048.01051> {{{mmap:0x5a4fd3b98000:0x34000:load:0x4:r:0}}}
[00000.882] 01048.01051> {{{mmap:0x5a4fd3bcc000:0x6a000:load:0x4:rx:0x34000}}}
[00000.882] 01048.01051> {{{mmap:0x5a4fd3c36000:0x15000:load:0x4:rw:0x9e000}}}
[00000.882] 01048.01051> dso: id=11c299f503022124 base=0x00005a4fd3b98000 name=libc++abi.so.1
[00000.882] 01048.01051> {{{module:0x5:libunwind.so.1:elf:db715a3efdfdc69c}}}
[00000.882] 01048.01051> {{{mmap:0x70a870e51000:0x11000:load:0x5:r:0}}}
[00000.882] 01048.01051> {{{mmap:0x70a870e62000:0x12000:load:0x5:rx:0x11000}}}
[00000.882] 01048.01051> {{{mmap:0x70a870e74000:0x7000:load:0x5:rw:0x23000}}}
[00000.882] 01048.01051> dso: id=db715a3efdfdc69c base=0x000070a870e51000 name=libunwind.so.1
[00000.882] 01048.01051> {{{module:0x1:libc.so:elf:45403cf4bb3497bf}}}
[00000.882] 01048.01051> {{{mmap:0x78b2add31000:0x7a000:load:0x1:r:0}}}
[00000.882] 01048.01051> {{{mmap:0x78b2addab000:0x10f000:load:0x1:rx:0x7a000}}}
[00000.882] 01048.01051> {{{mmap:0x78b2adeba000:0x21000:load:0x1:rw:0x189000}}}
[00000.882] 01048.01051> dso: id=45403cf4bb3497bf base=0x000078b2add31000 name=libc.so
[00001.114] 01048.01051> TEST
[00001.114] 01048.01051>
CASE resource_tests [STARTED]
[00001.114] 01048.01051> probe_address_space [RUNNING]
[00001.114] 01048.01051> [PASSED] (0 ms)
[00001.114] 01048.01051> TestBasicActions [RUNNING]
[00001.115] 01048.01051> [PASSED] (0 ms)
[00001.115] 01048.01051> TestExclusiveShared [RUNNING]
[00001.115] 01048.01051> [PASSED] (0 ms)
[00001.115] 01048.01051> TestSharedExclusive [RUNNING]
[00001.115] 01048.01051> [PASSED] (0 ms)
[00001.115] 01048.01051> TestInvalidArgs [RUNNING]
[00001.115] 01048.01051> [PASSED] (0 ms)
[00001.115] 01048.01051> TestVmoCreation [RUNNING]
[00001.115] 01048.01051> [PASSED] (0 ms)
[00001.115] 01048.01051> TestVmoCreationSmaller [RUNNING]
[00001.115] 01048.01051> [PASSED] (0 ms)
[00001.115] 01048.01051> TestVmoCreationUnaligned [RUNNING]
[00001.115] 01048.01051> [PASSED] (0 ms)
[00001.115] 01048.01051> TestVmoReplaceAsExecutable [RUNNING]
[00001.115] 01048.01051> [PASSED] (0 ms)
[00001.115] 01048.01051> test_ioports [RUNNING]
[00001.116] 01048.01051> [PASSED] (1 ms)
[00001.116] 01048.01051> CASE resource_tests [PASSED]
[00001.116] 01048.01051>
CASE profile_tests [STARTED]
[00001.116] 01048.01051> make_profile_fails [RUNNING]
[00001.116] 01048.01051> [PASSED] (0 ms)
[00001.116] 01048.01051> change_priority_via_profile [RUNNING]
[00001.116] 01048.01051> [PASSED] (0 ms)
[00001.116] 01048.01051> CASE profile_tests [PASSED]
[00001.116] 01048.01051>
CASE interrupt_tests [STARTED]
[00001.116] 01048.01051> interrupt_test [RUNNING]
[00001.116] 01048.01051> [PASSED] (0 ms)
[00001.116] 01048.01051> interrupt_port_bound_test [RUNNING]
[00001.117] 01048.01051> [PASSED] (0 ms)
[00001.117] 01048.01051> interrupt_port_non_bindable_test [RUNNING]
[00001.117] 01048.01051> [PASSED] (0 ms)
[00001.117] 01048.01051> interrupt_suspend_test [RUNNING]
[00001.253] 01048.01051> [PASSED] (136 ms)
[00001.253] 01048.01051> interrupt_bind_vcpu_test [RUNNING]
[00001.253] 01048.01051> Guest creation not supported
[00001.253] 01048.01051> [PASSED] (0 ms)
[00001.253] 01048.01051> interrupt_bind_vcpu_not_supported_test [RUNNING]
[00001.253] 01048.01051> Guest creation not supported
[00001.253] 01048.01051> [PASSED] (0 ms)
[00001.253] 01048.01051> interrupt_bind_vcpu_already_bound_test [RUNNING]
[00001.253] 01048.01051> Guest creation not supported
[00001.253] 01048.01051> [PASSED] (0 ms)
[00001.253] 01048.01051> interrupt_bind_vcpu_multiple_guests_test [RUNNING]
[00001.253] 01048.01051> Guest creation not supported
[00001.253] 01048.01051> [PASSED] (0 ms)
[00001.253] 01048.01051> CASE interrupt_tests [PASSED]
[00001.253] 01048.01051>
CASE vmo_signal_tests [STARTED]
[00001.253] 01048.01051> vmo_signal_sanity_test [RUNNING]
[00001.253] 01048.01051> [PASSED] (0 ms)
[00001.253] 01048.01051> vmo_child_signal_clone_test [RUNNING]
[00001.253] 01048.01051> [PASSED] (0 ms)
[00001.253] 01048.01051> vmo_child_signal_map_test [RUNNING]
[00001.253] 01048.01051> [PASSED] (0 ms)
[00001.253] 01048.01051> CASE vmo_signal_tests [PASSED]
[00001.253] 01048.01051>
CASE vmar_tests [STARTED]
[00001.253] 01048.01051> destroy_root_test [RUNNING]
[00001.254] 01048.01051> [PASSED] (0 ms)
[00001.254] 01048.01051> basic_allocate_test [RUNNING]
[00001.254] 01048.01051> [PASSED] (0 ms)
[00001.254] 01048.01051> allocate_oob_test [RUNNING]
[00001.254] 01048.01051> [PASSED] (0 ms)
[00001.254] 01048.01051> allocate_unsatisfiable_test [RUNNING]
[00001.254] 01048.01051> [PASSED] (0 ms)
[00001.254] 01048.01051> destroyed_vmar_test [RUNNING]
[00001.367] 01048.01051> [PASSED] (113 ms)
[00001.367] 01048.01051> map_over_destroyed_test [RUNNING]
[00001.367] 01048.01051> [PASSED] (0 ms)
[00001.367] 01048.01051> map_in_compact_test [RUNNING]
[00001.367] 01048.01051> [PASSED] (0 ms)
[00001.367] 01048.01051> overmapping_test [RUNNING]
[00001.367] 01048.01051> [PASSED] (0 ms)
[00001.367] 01048.01051> invalid_args_test [RUNNING]
[00001.367] 01048.01051> [PASSED] (0 ms)
[00001.367] 01048.01051> unaligned_len_test [RUNNING]
[00001.367] 01048.01051> [PASSED] (0 ms)
[00001.367] 01048.01051> unaligned_len_map_test [RUNNING]
[00001.367] 01048.01051> [PASSED] (0 ms)
[00001.367] 01048.01051> rights_drop_test [RUNNING]
[00001.367] 01048.01051> [PASSED] (0 ms)
[00001.367] 01048.01051> protect_test [RUNNING]
[00001.367] 01048.01051> [PASSED] (0 ms)
[00001.367] 01048.01051> nested_region_perms_test [RUNNING]
[00001.368] 01048.01051> [PASSED] (0 ms)
[00001.368] 01048.01051> object_info_test [RUNNING]
[00001.368] 01048.01051> [PASSED] (0 ms)
[00001.368] 01048.01051> unmap_split_test [RUNNING]
[00001.368] 01048.01051> [PASSED] (0 ms)
[00001.368] 01048.01051> unmap_multiple_test [RUNNING]
[00001.368] 01048.01051> [PASSED] (0 ms)
[00001.368] 01048.01051> unmap_base_not_mapped_test [RUNNING]
[00001.368] 01048.01051> [PASSED] (0 ms)
[00001.460] 01048.01051> map_specific_overwrite_test [RUNNING]
[00001.460] 01048.01051> [PASSED] (0 ms)
[00001.460] 01048.01051> protect_split_test [RUNNING]
[00001.461] 01048.01051> [PASSED] (0 ms)
[00001.461] 01048.01051> protect_multiple_test [RUNNING]
[00001.461] 01048.01051> [PASSED] (0 ms)
[00001.461] 01048.01051> protect_over_demand_paged_test [RUNNING]
[00001.488] 01048.01051> [PASSED] (27 ms)
[00001.489] 01048.01051> protect_large_uncommitted_test [RUNNING]
[00001.489] 01048.01310> PageFault: 1023199 free pages
[00001.489] 01048.01310> PageFault: MemoryUsed: proc 1034 12M 'userboot'
[00001.489] 01048.01310> PageFault: MemoryUsed: proc 1048 10M 'bin/core-tests'
[00001.509] 01048.01051> [PASSED] (20 ms)
[00001.509] 01048.01051> unmap_large_uncommitted_test [RUNNING]
[00001.509] 01048.01319> PageFault: 1023197 free pages
[00001.509] 01048.01319> PageFault: MemoryUsed: proc 1034 12M 'userboot'
[00001.510] 01048.01319> PageFault: MemoryUsed: proc 1048 10M 'bin/core-tests'
[00001.512] 01048.01321> PageFault: 1023196 free pages
[00001.512] 01048.01321> PageFault: MemoryUsed: proc 1034 12M 'userboot'
[00001.512] 01048.01321> PageFault: MemoryUsed: proc 1048 10M 'bin/core-tests'
[00001.517] 01048.01323> PageFault: 1023196 free pages
[00001.517] 01048.01323> PageFault: MemoryUsed: proc 1034 12M 'userboot'
[00001.517] 01048.01323> PageFault: MemoryUsed: proc 1048 10M 'bin/core-tests'
[00001.520] 01048.01325> PageFault: 1023196 free pages
[00001.520] 01048.01325> PageFault: MemoryUsed: proc 1034 12M 'userboot'
[00001.520] 01048.01325> PageFault: MemoryUsed: proc 1048 10M 'bin/core-tests'
[00001.524] 01048.01051> [PASSED] (14 ms)
[00001.524] 01048.01051> partial_unmap_and_read [RUNNING]
[00001.524] 01048.01051> [PASSED] (0 ms)
[00001.524] 01048.01051> partial_unmap_and_write [RUNNING]
[00001.524] 01048.01051> [PASSED] (0 ms)
[00001.524] 01048.01051> partial_unmap_with_vmar_offset [RUNNING]
[00001.524] 01048.01051> [PASSED] (0 ms)
[00001.524] 01048.01051> CASE vmar_tests [PASSED]
[00001.524] 01048.01051>
CASE ticks_tests [STARTED]
[00001.524] 01048.01051> elapsed_time_using_ticks [RUNNING]
[00001.524] 01048.01051> [PASSED] (0 ms)
[00001.524] 01048.01051> CASE ticks_tests [PASSED]
[00001.524] 01048.01051>
CASE threads_tests [STARTED]
[00001.524] 01048.01051> TestBasics [RUNNING]
[00001.625] 01048.01051> [PASSED] (100 ms)
[00001.625] 01048.01051> TestInvalidRights [RUNNING]
[00001.625] 01048.01051> [PASSED] (0 ms)
[00001.625] 01048.01051> TestDetach [RUNNING]
[00001.625] 01048.01051> [PASSED] (0 ms)
[00001.625] 01048.01051> TestLongNameSucceeds [RUNNING]
[00001.627] 01048.01051> [PASSED] (2 ms)
[00001.627] 01048.01051> TestThreadStartOnInitialThread [RUNNING]
[00001.632] 01048.01051> [PASSED] (4 ms)
[00001.632] 01048.01051> TestThreadStartWithZeroInstructionPointer [RUNNING]
[00001.661] 01048.01051> [PASSED] (28 ms)
[00001.661] 01048.01051> TestKillBusyThread [RUNNING]
[00001.761] 01048.01051> [PASSED] (100 ms)
[00001.761] 01048.01051> TestKillSleepThread [RUNNING]
[00001.862] 01048.01051> [PASSED] (100 ms)
[00001.862] 01048.01051> TestKillWaitThread [RUNNING]
[00001.963] 01048.01051> [PASSED] (100 ms)
[00001.963] 01048.01051> TestNonstartedThread [RUNNING]
[00001.963] 01048.01051> [PASSED] (0 ms)
[00001.963] 01048.01051> TestThreadKillsItself [RUNNING]
[00001.978] 01048.01051> [PASSED] (14 ms)
[00001.978] 01048.01051> TestInfoTaskStatsFails [RUNNING]
[00002.079] 01048.01051> [PASSED] (100 ms)
[00002.079] 01048.01051> TestResumeSuspended [RUNNING]
[00002.188] 01048.01051> [PASSED] (109 ms)
[00002.188] 01048.01051> TestSuspendSleeping [RUNNING]
[00002.289] 01048.01051> [PASSED] (100 ms)
[00002.289] 01048.01051> TestSuspendChannelCall [RUNNING]
[00002.303] 01048.01051> [PASSED] (13 ms)
[00002.303] 01048.01051> TestSuspendPortCall [RUNNING]
[00002.504] 01048.01051> [PASSED] (201 ms)
[00002.504] 01048.01051> TestSuspendStopsThread [RUNNING]
[00002.555] 01048.01051> [PASSED] (50 ms)
[00002.555] 01048.01051> TestSuspendMultiple [RUNNING]
[00002.556] 01048.01051> [PASSED] (1 ms)
[00002.556] 01048.01051> TestSuspendSelf [RUNNING]
[00002.556] 01048.01051> [PASSED] (0 ms)
[00002.556] 01048.01051> TestKillSuspendedThread [RUNNING]
[00002.556] 01048.01051> [PASSED] (0 ms)
[00002.556] 01048.01051> TestStartSuspendedThread [RUNNING]
[00002.557] 01048.01051> [PASSED] (0 ms)
[00002.557] 01048.01051> TestStartSuspendedAndResumedThread [RUNNING]
[00002.557] 01048.01051> [PASSED] (0 ms)
[00002.557] 01048.01051> TestSuspendSingleWaitAsyncSignalDelivery [RUNNING]
[00002.558] 01048.01051> [PASSED] (0 ms)
[00002.558] 01048.01051> TestSuspendRepeatingWaitAsyncSignalDelivery [RUNNING]
[00002.563] 01048.01051> [PASSED] (5 ms)
[00002.563] 01048.01051> TestReadingGeneralRegisterState [RUNNING]
[00002.665] 01048.01051> [PASSED] (101 ms)
[00002.665] 01048.01051> TestWritingGeneralRegisterState [RUNNING]
[00002.766] 01048.01051> [PASSED] (100 ms)
[00002.766] 01048.01051> TestNoncanonicalRipAddress [RUNNING]
[00002.867] 01048.01051> [PASSED] (100 ms)
[00002.867] 01048.01051> TestWritingArmFlagsRegister [RUNNING]
[00002.867] 01048.01051> [PASSED] (0 ms)
[00002.867] 01048.01051> CASE threads_tests [PASSED]
[00002.867] 01048.01051>
CASE sync_mutex_tests [STARTED]
[00002.867] 01048.01051> test_mutexes [RUNNING]
[00002.962] 01048.01051> [PASSED] (95 ms)
[00002.962] 01048.01051> test_try_mutexes [RUNNING]
[00003.043] 01048.01051> [PASSED] (80 ms)
[00003.044] 01048.01051> test_timeout_elapsed [RUNNING]
[00003.546] 01048.01051> [PASSED] (502 ms)
[00003.546] 01048.01051> CASE sync_mutex_tests [PASSED]
[00003.546] 01048.01051>
CASE sync_condition_tests [STARTED]
[00003.546] 01048.01051> Condition::condition_test [RUNNING]
[00003.569] 01048.01051> [PASSED] (22 ms)
[00003.569] 01048.01051> Condition::condition_timeout_test [RUNNING]
[00003.577] 01048.01051> [PASSED] (7 ms)
[00003.577] 01048.01051> CASE sync_condition_tests [PASSED]
[00003.577] 01048.01051>
CASE sync_completion_tests [STARTED]
[00003.577] 01048.01051> test_initializer [RUNNING]
[00003.577] 01048.01051> [PASSED] (0 ms)
[00003.577] 01048.01051> test_completions [RUNNING]
[00003.633] 01048.01051> [PASSED] (56 ms)
[00003.633] 01048.01051> test_timeout [RUNNING]
[00003.634] 01048.01051> [PASSED] (0 ms)
[00003.634] 01048.01051> CASE sync_completion_tests [PASSED]
[00003.634] 01048.01051>
CASE sync_completion_tests [STARTED]
[00003.634] 01048.01051> test_initializer [RUNNING]
[00003.634] 01048.01051> [PASSED] (0 ms)
[00003.634] 01048.01051> test_completions [RUNNING]
[00003.697] 01048.01051> [PASSED] (62 ms)
[00003.697] 01048.01051> test_timeout [RUNNING]
[00004.831] 01048.01051> [PASSED] (1133 ms)
[00004.831] 01048.01051> test_signal_requeue [RUNNING]
[00004.874] 01048.01051> [PASSED] (43 ms)
[00004.875] 01048.01051> test_completion_signaled [RUNNING]
[00004.875] 01048.01051> [PASSED] (0 ms)
[00004.875] 01048.01051> CASE sync_completion_tests [PASSED]
[00004.875] 01048.01051>
CASE stack_tests [STARTED]
[00004.875] 01048.01051> main_thread_stack_tests [RUNNING]
[00004.875] 01048.01051> [PASSED] (0 ms)
[00004.875] 01048.01051> other_thread_stack_tests [RUNNING]
[00004.875] 01048.01051> [PASSED] (0 ms)
[00004.875] 01048.01051> CASE stack_tests [PASSED]
[00004.875] 01048.01051>
CASE socket_tests [STARTED]
[00004.875] 01048.01051> socket_basic [RUNNING]
[00004.875] 01048.01051> [PASSED] (0 ms)
[00004.875] 01048.01051> socket_peek [RUNNING]
[00004.875] 01048.01051> [PASSED] (0 ms)
[00004.875] 01048.01051> socket_peek_empty [RUNNING]
[00004.875] 01048.01051> [PASSED] (0 ms)
[00004.875] 01048.01051> socket_signals [RUNNING]
[00004.876] 01048.01051> [PASSED] (0 ms)
[00004.876] 01048.01051> socket_peer_closed_signal [RUNNING]
[00004.876] 01048.01051> [PASSED] (0 ms)
[00004.876] 01048.01051> socket_peer_closed_set_property [RUNNING]
[00004.876] 01048.01051> [PASSED] (0 ms)
[00004.876] 01048.01051> socket_shutdown_write [RUNNING]
[00004.876] 01048.01051> [PASSED] (0 ms)
[00004.876] 01048.01051> socket_shutdown_read [RUNNING]
[00004.876] 01048.01051> [PASSED] (0 ms)
[00004.876] 01048.01051> socket_bytes_outstanding [RUNNING]
[00004.876] 01048.01051> [PASSED] (0 ms)
[00004.876] 01048.01051> socket_bytes_outstanding_shutdown_write [RUNNING]
[00004.876] 01048.01051> [PASSED] (0 ms)
[00004.876] 01048.01051> socket_bytes_outstanding_shutdown_read [RUNNING]
[00004.876] 01048.01051> [PASSED] (0 ms)
[00004.876] 01048.01051> socket_short_write [RUNNING]
[00004.877] 01048.01051> [PASSED] (0 ms)
[00004.877] 01048.01051> socket_datagram [RUNNING]
[00004.877] 01048.01051> [PASSED] (0 ms)
[00004.877] 01048.01051> socket_datagram_peek [RUNNING]
[00004.877] 01048.01051> [PASSED] (0 ms)
[00004.877] 01048.01051> socket_datagram_peek_empty [RUNNING]
[00004.877] 01048.01051> [PASSED] (0 ms)
[00004.877] 01048.01051> socket_datagram_no_short_write [RUNNING]
[00004.878] 01048.01051> [PASSED] (0 ms)
[00004.878] 01048.01051> socket_control_plane_absent [RUNNING]
[00004.878] 01048.01051> [PASSED] (0 ms)
[00004.878] 01048.01051> socket_control_plane [RUNNING]
[00004.878] 01048.01051> [PASSED] (0 ms)
[00004.878] 01048.01051> socket_control_plane_peek [RUNNING]
[00004.878] 01048.01051> [PASSED] (0 ms)
[00004.878] 01048.01051> socket_control_plane_peek_empty [RUNNING]
[00004.878] 01048.01051> [PASSED] (0 ms)
[00004.878] 01048.01051> socket_control_plane_shutdown [RUNNING]
[00004.878] 01048.01051> [PASSED] (0 ms)
[00004.878] 01048.01051> socket_accept [RUNNING]
[00004.878] 01048.01051> [PASSED] (0 ms)
[00004.878] 01048.01051> socket_share_invalid_handle [RUNNING]
[00004.878] 01048.01051> [PASSED] (0 ms)
[00004.878] 01048.01051> socket_share_consumes_on_failure [RUNNING]
[00004.878] 01048.01051> [PASSED] (0 ms)
[00004.878] 01048.01051> socket_signals2 [RUNNING]
[00004.880] 01048.01051> [PASSED] (1 ms)
[00004.880] 01048.01051> CASE socket_tests [PASSED]
[00004.880] 01048.01051>
CASE tls_tests [STARTED]
[00004.880] 01048.01051> tls_test [RUNNING]
[00007.156] 01048.01051> [PASSED] (2275 ms)
[00007.156] 01048.01051> CASE tls_tests [PASSED]
[00007.156] 01048.01051>
CASE pthread_barrier_tests [STARTED]
[00007.156] 01048.01051> test_barrier [RUNNING]
[00007.416] 01048.01051> [PASSED] (258 ms)
[00007.416] 01048.01051> CASE pthread_barrier_tests [PASSED]
[00007.416] 01048.01051>
CASE pthread_tests [STARTED]
[00007.416] 01048.01051> pthread_test [RUNNING]
[00010.525] 01048.01051> [PASSED] (3108 ms)
[00010.525] 01048.01051> pthread_self_main_thread_test [RUNNING]
[00010.525] 01048.01051> [PASSED] (0 ms)
[00010.525] 01048.01051> pthread_big_stack_size [RUNNING]
[00010.549] 01048.01051> [PASSED] (24 ms)
[00010.549] 01048.01051> pthread_getstack_main_thread [RUNNING]
[00010.549] 01048.01051> [PASSED] (0 ms)
[00010.549] 01048.01051> pthread_getstack_other_thread [RUNNING]
[00010.550] 01048.01051> [PASSED] (0 ms)
[00010.550] 01048.01051> CASE pthread_tests [PASSED]
[00010.550] 01048.01051>
CASE process_tests [STARTED]
[00010.550] 01048.01051> mini_process_sanity [RUNNING]
[00010.583] 01048.01051> [PASSED] (32 ms)
[00010.583] 01048.01051> process_start_fail [RUNNING]
[00010.585] 01048.01051> [PASSED] (2 ms)
[00010.585] 01048.01051> process_not_killed_via_thread_close [RUNNING]
[00010.599] 01048.01051> [PASSED] (13 ms)
[00010.599] 01048.01051> process_not_killed_via_process_close [RUNNING]
[00010.601] 01048.01051> [PASSED] (1 ms)
[00010.601] 01048.01051> kill_process_via_thread_kill [RUNNING]
[00010.602] 01048.01051> [PASSED] (1 ms)
[00010.602] 01048.01051> kill_process_via_vmar_destroy [RUNNING]
[00010.602] 02308.02310> PageFault: 1020468 free pages
[00010.603] 02308.02310> PageFault: MemoryUsed: proc 1034 12M 'userboot'
[00010.603] 02308.02310> PageFault: MemoryUsed: proc 1048 18M 'bin/core-tests'
[00010.607] 01048.01051> [PASSED] (4 ms)
[00010.607] 01048.01051> kill_channel_handle_cycle [RUNNING]
[00011.359] 01048.01051> [PASSED] (752 ms)
[00011.359] 01048.01051> info_reflects_process_state [RUNNING]
[00011.610] 01048.01051> [PASSED] (250 ms)
[00011.610] 01048.01051> suspend [RUNNING]
[00011.611] 01048.01051> [PASSED] (0 ms)
[00011.611] 01048.01051> suspend_self [RUNNING]
[00011.611] 01048.01051> [PASSED] (0 ms)
[00011.611] 01048.01051> suspend_multiple_threads [RUNNING]
[00011.633] 01048.01051> [PASSED] (21 ms)
[00011.633] 01048.01051> suspend_before_creating_threads [RUNNING]
[00011.641] 01048.01051> [PASSED] (8 ms)
[00011.641] 01048.01051> suspend_before_starting_threads [RUNNING]
[00011.642] 01048.01051> [PASSED] (0 ms)
[00011.642] 01048.01051> suspend_process_then_thread [RUNNING]
[00011.907] 01048.01051> [PASSED] (265 ms)
[00011.907] 01048.01051> suspend_thread_then_process [RUNNING]
[00012.158] 01048.01051> [PASSED] (251 ms)
[00012.158] 01048.01051> suspend_thread_and_process_before_starting_process [RUNNING]
[00012.410] 01048.01051> [PASSED] (251 ms)
[00012.410] 01048.01051> suspend_twice [RUNNING]
[00012.661] 01048.01051> [PASSED] (251 ms)
[00012.661] 01048.01051> suspend_twice_before_creating_threads [RUNNING]
[00012.912] 01048.01051> [PASSED] (251 ms)
[00012.912] 01048.01051> suspend_with_dying_thread [RUNNING]
[00012.920] 01048.01051> [PASSED] (7 ms)
[00012.920] 01048.01051> CASE process_tests [PASSED]
[00012.920] 01048.01051>
CASE port_tests [STARTED]
[00012.920] 01048.01051> basic_test [RUNNING]
[00012.920] 01048.01051> [PASSED] (0 ms)
[00012.920] 01048.01051> queue_and_close_test [RUNNING]
[00012.920] 01048.01051> [PASSED] (0 ms)
[00012.920] 01048.01051> queue_too_many [RUNNING]
[00012.921] 01048.01051> [PASSED] (0 ms)
[00012.921] 01048.01051> async_wait_channel_test [RUNNING]
[00012.923] 01048.01051> [PASSED] (1 ms)
[00012.923] 01048.01051> async_wait_event_test_single [RUNNING]
[00012.923] 01048.01051> [PASSED] (0 ms)
[00012.923] 01048.01051> async_wait_event_test_repeat [RUNNING]
[00012.923] 01048.01051> [PASSED] (0 ms)
[00012.923] 01048.01051> async_wait_invalid_option [RUNNING]
[00012.923] 01048.01051> [PASSED] (0 ms)
[00012.923] 01048.01051> async_wait_close_order_1 [RUNNING]
[00012.923] 01048.01051> [PASSED] (0 ms)
[00012.923] 01048.01051> async_wait_close_order_2 [RUNNING]
[00012.923] 01048.01051> [PASSED] (0 ms)
[00012.923] 01048.01051> async_wait_close_order_3 [RUNNING]
[00012.923] 01048.01051> [PASSED] (0 ms)
[00012.923] 01048.01051> async_wait_close_order_4 [RUNNING]
[00012.923] 01048.01051> [PASSED] (0 ms)
[00012.923] 01048.01051> async_wait_close_order_5 [RUNNING]
[00012.923] 01048.01051> [PASSED] (0 ms)
[00012.923] 01048.01051> async_wait_close_order_6 [RUNNING]
[00012.923] 01048.01051> [PASSED] (0 ms)
[00012.923] 01048.01051> channel_pre_writes_test [RUNNING]
[00012.923] 01048.01051> [PASSED] (0 ms)
[00012.924] 01048.01051> cancel_event_key [RUNNING]
[00012.924] 01048.01051> [PASSED] (0 ms)
[00012.924] 01048.01051> cancel_event_key_after [RUNNING]
[00012.924] 01048.01051> [PASSED] (0 ms)
[00012.924] 01048.01051> threads_event [RUNNING]
[00012.925] 01048.01051> [PASSED] (1 ms)
[00012.925] 01048.01051> cancel_stress [RUNNING]
[00014.687] 01048.01051> [PASSED] (1761 ms)
[00014.687] 01048.01051> CASE port_tests [PASSED]
[00014.687] 01048.01051>
CASE api_violations [STARTED]
[00014.687] 01048.01051> invalid_pager_create [RUNNING]
[00014.687] 01048.01051> [PASSED] (0 ms)
[00014.687] 01048.01051> invalid_pager_create_vmo [RUNNING]
[00014.687] 01048.01051> [PASSED] (0 ms)
[00014.687] 01048.01051> invalid_pager_detach_vmo [RUNNING]
[00014.687] 01048.01051> [PASSED] (0 ms)
[00014.688] 01048.01051> invalid_pager_supply_pages [RUNNING]
[00014.688] 01048.01051> [PASSED] (0 ms)
[00014.688] 01048.01051> resize_nonresizable_vmo [RUNNING]
[00014.688] 01048.01051> [PASSED] (0 ms)
[00014.688] 01048.01051> CASE api_violations [PASSED]
[00014.688] 01048.01051>
CASE commit_tests [STARTED]
[00014.688] 01048.01051> simple_commit_test [RUNNING]
[00014.690] 01048.01051> [PASSED] (2 ms)
[00014.690] 01048.01051> split_commit_test [RUNNING]
[00014.694] 01048.01051> [PASSED] (4 ms)
[00014.695] 01048.01051> overlap_commit_test [RUNNING]
[00014.699] 01048.01051> [PASSED] (4 ms)
[00014.699] 01048.01051> overlap_commit_supply_test [RUNNING]
[00014.772] 01048.01051> [PASSED] (72 ms)
[00014.772] 01048.01051> multisupply_commit_test [RUNNING]
[00014.775] 01048.01051> [PASSED] (2 ms)
[00014.775] 01048.01051> multicommit_supply_test [RUNNING]
[00014.786] 01048.01051> [PASSED] (11 ms)
[00014.787] 01048.01051> commit_redundant_supply_test [RUNNING]
[00014.789] 01048.01051> [PASSED] (2 ms)
[00014.789] 01048.01051> supply_decommit_test [RUNNING]
[00014.793] 01048.01051> [PASSED] (4 ms)
[00014.793] 01048.01051> resize_commit_test [RUNNING]
[00014.796] 01048.01051> [PASSED] (2 ms)
[00014.796] 01048.01051> suspend_commit_test [RUNNING]
[00014.800] 01048.01051> [PASSED] (4 ms)
[00014.800] 01048.01051> CASE commit_tests [PASSED]
[00014.800] 01048.01051>
CASE clone_tests [STARTED]
[00014.800] 01048.01051> clone_read_from_clone_test_vmar [RUNNING]
[00014.803] 01048.01051> [PASSED] (2 ms)
[00014.803] 01048.01051> clone_read_from_clone_test_vmo [RUNNING]
[00014.807] 01048.01051> [PASSED] (4 ms)
[00014.807] 01048.01051> clone_read_from_parent_test_vmar [RUNNING]
[00014.810] 01048.01051> [PASSED] (2 ms)
[00014.810] 01048.01051> clone_read_from_parent_test_vmo [RUNNING]
[00014.814] 01048.01051> [PASSED] (4 ms)
[00014.814] 01048.01051> clone_simultaneous_read_test_vmar [RUNNING]
[00014.821] 01048.01051> [PASSED] (6 ms)
[00014.821] 01048.01051> clone_simultaneous_read_test_vmo [RUNNING]
[00014.826] 01048.01051> [PASSED] (4 ms)
[00014.826] 01048.01051> clone_simultaneous_child_read_test_vmar [RUNNING]
[00014.830] 01048.01051> [PASSED] (4 ms)
[00014.830] 01048.01051> clone_simultaneous_child_read_test_vmo [RUNNING]
[00014.837] 01048.01051> [PASSED] (6 ms)
[00014.837] 01048.01051> clone_write_to_clone_test [RUNNING]
[00014.839] 01048.01051> [PASSED] (2 ms)
[00014.839] 01048.01051> clone_detach_test [RUNNING]
[00014.844] 01048.01051> [PASSED] (4 ms)
[00014.844] 01048.01051> clone_commit_test [RUNNING]
[00014.846] 01048.01051> [PASSED] (2 ms)
[00014.846] 01048.01051> clone_split_commit_test [RUNNING]
[00014.851] 01048.01051> [PASSED] (4 ms)
[00014.851] 01048.01051> clone_decommit_test [RUNNING]
[00014.851] 01048.01051> [PASSED] (0 ms)
[00014.851] 01048.01051> CASE clone_tests [PASSED]
[00014.851] 01048.01051>
CASE lifecycle_tests [STARTED]
[00014.851] 01048.01051> vmo_info_pager_test [RUNNING]
[00014.851] 01048.01051> [PASSED] (0 ms)
[00014.851] 01048.01051> detach_page_complete_test [RUNNING]
[00014.851] 01048.01051> [PASSED] (0 ms)
[00014.851] 01048.01051> close_page_complete_test [RUNNING]
[00014.851] 01048.01051> [PASSED] (0 ms)
[00014.851] 01048.01051> read_detach_interrupt_late_test_vmar [RUNNING]
[00014.851] 01048.03218> PageFault: 1019252 free pages
[00014.851] 01048.03218> PageFault: MemoryUsed: proc 1034 12M 'userboot'
[00014.852] 01048.03218> PageFault: MemoryUsed: proc 1048 21M 'bin/core-tests'
[00014.853] 01048.01051> [PASSED] (1 ms)
[00014.853] 01048.01051> read_detach_interrupt_late_test_vmo [RUNNING]
[00014.858] 01048.01051> [PASSED] (4 ms)
[00014.858] 01048.01051> read_close_interrupt_late_test_vmar [RUNNING]
[00014.858] 01048.03239> PageFault: 1019225 free pages
[00014.858] 01048.03239> PageFault: MemoryUsed: proc 1034 12M 'userboot'
[00014.858] 01048.03239> PageFault: MemoryUsed: proc 1048 21M 'bin/core-tests'
[00014.860] 01048.01051> [PASSED] (2 ms)
[00014.860] 01048.01051> read_close_interrupt_late_test_vmo [RUNNING]
[00014.865] 01048.01051> [PASSED] (4 ms)
[00014.865] 01048.01051> read_detach_interrupt_early_test_vmar [RUNNING]
[00014.865] 01048.03260> PageFault: 1019196 free pages
[00014.865] 01048.03260> PageFault: MemoryUsed: proc 1034 12M 'userboot'
[00014.865] 01048.03260> PageFault: MemoryUsed: proc 1048 21M 'bin/core-tests'
[00014.867] 01048.01051> [PASSED] (2 ms)
[00014.867] 01048.01051> read_detach_interrupt_early_test_vmo [RUNNING]
[00014.871] 01048.01051> [PASSED] (4 ms)
[00014.872] 01048.01051> read_close_interrupt_early_test_vmar [RUNNING]
[00014.872] 01048.03281> PageFault: 1019170 free pages
[00014.872] 01048.03281> PageFault: MemoryUsed: proc 1034 12M 'userboot'
[00014.872] 01048.03281> PageFault: MemoryUsed: proc 1048 21M 'bin/core-tests'
[00014.874] 01048.01051> [PASSED] (2 ms)
[00014.874] 01048.01051> read_close_interrupt_early_test_vmo [RUNNING]
[00014.878] 01048.01051> [PASSED] (4 ms)
[00014.878] 01048.01051> thread_kill_test_vmar [RUNNING]
[00014.881] 01048.01051> [PASSED] (2 ms)
[00014.881] 01048.01051> thread_kill_test_vmo [RUNNING]
[00014.885] 01048.01051> [PASSED] (4 ms)
[00014.886] 01048.01051> thread_kill_overlap_test_vmar [RUNNING]
[00014.888] 01048.01051> [PASSED] (2 ms)
[00014.888] 01048.01051> thread_kill_overlap_test_vmo [RUNNING]
[00014.892] 01048.01051> [PASSED] (4 ms)
[00014.893] 01048.01051> close_pager_test [RUNNING]
[00014.893] 01048.03379> PageFault: 1018958 free pages
[00014.893] 01048.03379> PageFault: MemoryUsed: proc 1034 12M 'userboot'
[00014.893] 01048.03379> PageFault: MemoryUsed: proc 1048 21M 'bin/core-tests'
[00014.895] 01048.01051> [PASSED] (2 ms)
[00014.895] 01048.01051> detach_close_pager_test [RUNNING]
[00014.895] 01048.01051> [PASSED] (0 ms)
[00014.895] 01048.01051> close_port_test [RUNNING]
[00014.895] 01048.03392> PageFault: 1018941 free pages
[00014.895] 01048.03392> PageFault: MemoryUsed: proc 1034 12M 'userboot'
[00014.896] 01048.03392> PageFault: MemoryUsed: proc 1048 22M 'bin/core-tests'
[00014.899] 01048.01051> [PASSED] (4 ms)
[00014.899] 01048.01051> CASE lifecycle_tests [PASSED]
[00014.899] 01048.01051>
CASE pager_read_tests [STARTED]
[00014.899] 01048.01051> single_page_test_vmar [RUNNING]
[00014.902] 01048.01051> [PASSED] (2 ms)
[00014.902] 01048.01051> single_page_test_vmo [RUNNING]
[00014.906] 01048.01051> [PASSED] (4 ms)
[00014.906] 01048.01051> presupply_test_vmar [RUNNING]
[00014.909] 01048.01051> [PASSED] (2 ms)
[00014.909] 01048.01051> presupply_test_vmo [RUNNING]
[00014.913] 01048.01051> [PASSED] (4 ms)
[00014.913] 01048.01051> early_supply_test_vmar [RUNNING]
[00014.916] 01048.01051> [PASSED] (2 ms)
[00014.916] 01048.01051> early_supply_test_vmo [RUNNING]
[00014.920] 01048.01051> [PASSED] (4 ms)
[00014.920] 01048.01051> sequential_multipage_test_vmar [RUNNING]
[00014.925] 01048.01051> [PASSED] (4 ms)
[00014.925] 01048.01051> sequential_multipage_test_vmo [RUNNING]
[00014.930] 01048.01051> [PASSED] (4 ms)
[00014.930] 01048.01051> concurrent_multipage_access_test_vmar [RUNNING]
[00014.937] 01048.01051> [PASSED] (7 ms)
[00014.937] 01048.01051> concurrent_multipage_access_test_vmo [RUNNING]
[00014.944] 01048.01051> [PASSED] (7 ms)
[00014.944] 01048.01051> concurrent_overlapping_access_test_vmar [RUNNING]
[00015.034] 01048.01051> [PASSED] (89 ms)
[00015.034] 01048.01051> concurrent_overlapping_access_test_vmo [RUNNING]
[00015.143] 01048.01051> [PASSED] (109 ms)
[00015.143] 01048.01051> bulk_single_supply_test_vmar [RUNNING]
[00015.167] 01048.01051> [PASSED] (23 ms)
[00015.168] 01048.01051> bulk_single_supply_test_vmo [RUNNING]
[00015.193] 01048.01051> [PASSED] (25 ms)
[00015.193] 01048.01051> bulk_odd_length_supply_test_vmar [RUNNING]
[00015.340] 01048.01051> [PASSED] (146 ms)
[00015.340] 01048.01051> bulk_odd_length_supply_test_vmo [RUNNING]
[00015.478] 01048.01051> [PASSED] (138 ms)
[00015.478] 01048.01051> bulk_odd_offset_supply_test_vmar [RUNNING]
[00015.610] 01048.01051> [PASSED] (131 ms)
[00015.610] 01048.01051> bulk_odd_offset_supply_test_vmo [RUNNING]
[00015.751] 01048.01051> [PASSED] (141 ms)
[00015.751] 01048.01051> overlap_supply_test_vmar [RUNNING]
[00015.754] 01048.01051> [PASSED] (2 ms)
[00015.754] 01048.01051> overlap_supply_test_vmo [RUNNING]
[00015.767] 01048.01051> [PASSED] (12 ms)
[00015.767] 01048.01051> many_request_test_vmar [RUNNING]
[00015.974] 01048.01051> [PASSED] (207 ms)
[00015.974] 01048.01051> many_request_test_vmo [RUNNING]
[00016.179] 01048.01051> [PASSED] (205 ms)
[00016.179] 01048.01051> successive_vmo_test [RUNNING]
[00016.232] 01048.01051> [PASSED] (52 ms)
[00016.232] 01048.01051> multiple_concurrent_vmo_test [RUNNING]
[00016.244] 01048.01051> [PASSED] (12 ms)
[00016.244] 01048.01051> vmar_unmap_test [RUNNING]
[00016.244] 01048.12222> PageFault: 1003545 free pages
[00016.245] 01048.12222> PageFault: MemoryUsed: proc 1034 12M 'userboot'
[00016.245] 01048.12222> PageFault: MemoryUsed: proc 1048 59M 'bin/core-tests'
[00016.247] 01048.01051> [PASSED] (2 ms)
[00016.247] 01048.01051> vmar_remap_test [RUNNING]
[00016.274] 01048.01051> [PASSED] (27 ms)
[00016.274] 01048.01051> vmar_map_range_test [RUNNING]
[00016.282] 01048.01051> [PASSED] (7 ms)
[00016.282] 01048.01051> read_resize_test_vmar [RUNNING]
[00016.285] 01048.01051> [PASSED] (3 ms)
[00016.285] 01048.01051> read_resize_test_vmo [RUNNING]
[00016.291] 01048.01051> [PASSED] (5 ms)
[00016.291] 01048.01051> suspend_read_test_vmar [RUNNING]
[00016.294] 01048.01051> [PASSED] (3 ms)
[00016.294] 01048.01051> suspend_read_test_vmo [RUNNING]
[00016.301] 01048.01051> [PASSED] (6 ms)
[00016.301] 01048.01051> CASE pager_read_tests [PASSED]
[00016.301] 01048.01051>
CASE object_info_tests [STARTED]
[00016.301] 01048.01051> handle_valid_on_valid_handle_succeeds [RUNNING]
[00016.301] 01048.01051> [PASSED] (0 ms)
[00016.301] 01048.01051> handle_valid_on_closed_handle_fails [RUNNING]
[00016.301] 01048.01051> [PASSED] (0 ms)
[00016.301] 01048.01051> (invalid_handle_fails<ZX_INFO_HANDLE_VALID, void*>) [RUNNING]
[00016.301] 01048.01051> [PASSED] (0 ms)
[00016.301] 01048.01051> task_stats_unstarted [RUNNING]
[00016.301] 01048.01051> [PASSED] (0 ms)
[00016.301] 01048.01051> task_stats_smoke [RUNNING]
[00016.301] 01048.01051> [PASSED] (0 ms)
[00016.301] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t>) [RUNNING]
[00016.301] 01048.01051> [PASSED] (0 ms)
[00016.301] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING]
[00016.301] 01048.01051> [PASSED] (0 ms)
[00016.301] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING]
[00016.302] 01048.01051> [PASSED] (0 ms)
[00016.302] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING]
[00016.302] 01048.01051> [PASSED] (0 ms)
[00016.302] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING]
[00016.302] 01048.01051> [PASSED] (0 ms)
[00016.302] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING]
[00016.302] 01048.01051> [PASSED] (0 ms)
[00016.302] 01048.01051> (wrong_handle_type_fails<ZX_INFO_TASK_STATS, zx_info_task_stats_t, get_test_job>) [RUNNING]
[00016.302] 01048.01051> [PASSED] (0 ms)
[00016.302] 01048.01051> (wrong_handle_type_fails<ZX_INFO_TASK_STATS, zx_info_task_stats_t, zx_thread_self>) [RUNNING]
[00016.302] 01048.01051> [PASSED] (0 ms)
[00016.302] 01048.01051> process_maps_unstarted [RUNNING]
[00016.302] 01048.01051> [PASSED] (0 ms)
[00016.302] 01048.01051> process_maps_smoke [RUNNING]
[00016.303] 01048.01051> [PASSED] (0 ms)
[00016.303] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t>) [RUNNING]
[00016.303] 01048.01051> [PASSED] (0 ms)
[00016.303] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING]
[00016.303] 01048.01051> [PASSED] (0 ms)
[00016.303] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING]
[00016.303] 01048.01051> [PASSED] (0 ms)
[00016.303] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING]
[00016.303] 01048.01051> [PASSED] (0 ms)
[00016.303] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING]
[00016.303] 01048.01051> [PASSED] (0 ms)
[00016.303] 01048.01051> (multi_zero_buffer_succeeds<((zx_object_info_topic_t) 13u), get_test_process>) [RUNNING]
[00016.303] 01048.01051> [PASSED] (0 ms)
[00016.303] 01048.01051> (short_buffer_succeeds<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING]
[00016.303] 01048.01051> [PASSED] (0 ms)
[00016.303] 01048.01051> (partially_unmapped_buffer_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING]
[00016.303] 01048.01051> [PASSED] (0 ms)
[00016.303] 01048.01051> (self_fails<ZX_INFO_PROCESS_MAPS, zx_info_maps_t>) [RUNNING]
[00016.303] 01048.01051> [PASSED] (0 ms)
[00016.303] 01048.01051> (wrong_handle_type_fails<ZX_INFO_PROCESS_MAPS, zx_info_maps_t, get_test_job>) [RUNNING]
[00016.303] 01048.01051> [PASSED] (0 ms)
[00016.303] 01048.01051> (wrong_handle_type_fails<ZX_INFO_PROCESS_MAPS, zx_info_maps_t, zx_thread_self>) [RUNNING]
[00016.303] 01048.01051> [PASSED] (0 ms)
[00016.303] 01048.01051> (missing_rights_fails<ZX_INFO_PROCESS_MAPS, zx_info_maps_t, get_test_process, ZX_RIGHT_INSPECT>) [RUNNING]
[00016.303] 01048.01051> [PASSED] (0 ms)
[00016.303] 01048.01051> process_vmos_smoke [RUNNING]
[00016.303] 01048.01051> [PASSED] (0 ms)
[00016.303] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t>) [RUNNING]
[00016.303] 01048.01051> [PASSED] (0 ms)
[00016.303] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING]
[00016.303] 01048.01051> [PASSED] (0 ms)
[00016.303] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING]
[00016.303] 01048.01051> [PASSED] (0 ms)
[00016.303] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING]
[00016.303] 01048.01051> [PASSED] (0 ms)
[00016.303] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING]
[00016.303] 01048.01051> [PASSED] (0 ms)
[00016.303] 01048.01051> (multi_zero_buffer_succeeds<((zx_object_info_topic_t) 14u), get_test_process>) [RUNNING]
[00016.303] 01048.01051> [PASSED] (0 ms)
[00016.303] 01048.01051> (short_buffer_succeeds<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING]
[00016.303] 01048.01051> [PASSED] (0 ms)
[00016.303] 01048.01051> (partially_unmapped_buffer_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (self_fails<ZX_INFO_PROCESS_VMOS, zx_info_vmo_t>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (wrong_handle_type_fails<ZX_INFO_PROCESS_VMOS, zx_info_vmo_t, get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (wrong_handle_type_fails<ZX_INFO_PROCESS_VMOS, zx_info_vmo_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (missing_rights_fails<ZX_INFO_PROCESS_VMOS, zx_info_vmo_t, get_test_process, ZX_RIGHT_INSPECT>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> job_processes_smoke [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 9u), zx_koid_t>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (multi_zero_buffer_succeeds<((zx_object_info_topic_t) 9u), get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (short_buffer_succeeds<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (partially_unmapped_buffer_fails<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (wrong_handle_type_fails<ZX_INFO_JOB_PROCESSES, zx_koid_t, get_test_process>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (wrong_handle_type_fails<ZX_INFO_JOB_PROCESSES, zx_koid_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (missing_rights_fails<ZX_INFO_JOB_PROCESSES, zx_koid_t, get_test_job, ZX_RIGHT_ENUMERATE>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> job_children_smoke [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 8u), zx_koid_t>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (multi_zero_buffer_succeeds<((zx_object_info_topic_t) 8u), get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (short_buffer_succeeds<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (partially_unmapped_buffer_fails<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (wrong_handle_type_fails<ZX_INFO_JOB_CHILDREN, zx_koid_t, get_test_process>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (wrong_handle_type_fails<ZX_INFO_JOB_CHILDREN, zx_koid_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (missing_rights_fails<ZX_INFO_JOB_CHILDREN, zx_koid_t, get_test_job, ZX_RIGHT_ENUMERATE>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 3u), zx_info_process_t>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (wrong_handle_type_fails<ZX_INFO_PROCESS, zx_info_process_t, get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (wrong_handle_type_fails<ZX_INFO_PROCESS, zx_info_process_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (wrong_handle_type_fails<ZX_INFO_VMAR, zx_info_vmar_t, get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (wrong_handle_type_fails<ZX_INFO_VMAR, zx_info_vmar_t, get_test_process>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (wrong_handle_type_fails<ZX_INFO_VMAR, zx_info_vmar_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (wrong_handle_type_fails<ZX_INFO_THREAD, zx_info_thread_t, get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (wrong_handle_type_fails<ZX_INFO_THREAD, zx_info_thread_t, get_test_process>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (wrong_handle_type_fails<ZX_INFO_THREAD_STATS, zx_info_thread_t, get_test_job>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (wrong_handle_type_fails<ZX_INFO_THREAD_STATS, zx_info_thread_t, get_test_process>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (invalid_handle_fails<ZX_INFO_PROCESS_THREADS, zx_koid_t>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (null_avail_actual_succeeds<ZX_INFO_PROCESS_THREADS, zx_koid_t, get_test_process>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_buffer_fails<ZX_INFO_PROCESS_THREADS, zx_koid_t, get_test_process>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_actual_fails<ZX_INFO_PROCESS_THREADS, zx_koid_t, get_test_process>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (bad_avail_fails<ZX_INFO_PROCESS_THREADS, zx_koid_t, get_test_process>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (multi_zero_buffer_succeeds<ZX_INFO_PROCESS_THREADS, get_test_process>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> (invalid_handle_fails<ZX_INFO_THREAD_EXCEPTION_REPORT, zx_exception_report_t>) [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> handle_count_valid [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> handle_stats_control [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> CASE object_info_tests [PASSED]
[00016.304] 01048.01051>
CASE object_get_child_tests [STARTED]
[00016.304] 01048.01051> handle_invalid [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> CASE object_get_child_tests [PASSED]
[00016.304] 01048.01051>
CASE memory_mapping_tests [STARTED]
[00016.304] 01048.01051> address_space_limits_test [RUNNING]
[00016.304] 01048.01051> [PASSED] (0 ms)
[00016.304] 01048.01051> mmap_zerofilled_test [RUNNING]
[00016.305] 01048.01051> [PASSED] (0 ms)
[00016.305] 01048.01051> mmap_len_test [RUNNING]
[00016.305] 01048.01051> [PASSED] (0 ms)
[00016.305] 01048.01051> mmap_PROT_EXEC_test [RUNNING]
[00016.305] 01048.01051> [PASSED] (0 ms)
[00016.305] 01048.01051> mmap_offset_test [RUNNING]
[00016.305] 01048.01051> [PASSED] (0 ms)
[00016.305] 01048.01051> mmap_prot_test [RUNNING]
[00016.305] 01048.01051> [PASSED] (0 ms)
[00016.305] 01048.01051> mmap_flags_test [RUNNING]
[00016.305] 01048.01051> [PASSED] (0 ms)
[00016.305] 01048.01051> mprotect_test [RUNNING]
[00016.306] 01048.01051> [PASSED] (1 ms)
[00016.306] 01048.01051> CASE memory_mapping_tests [PASSED]
[00016.306] 01048.01051>
CASE job_tests [STARTED]
[00016.306] 01048.01051> basic_test [RUNNING]
[00016.306] 01048.01051> [PASSED] (0 ms)
[00016.306] 01048.01051> create_missing_rights_test [RUNNING]
[00016.306] 01048.01051> [PASSED] (0 ms)
[00016.306] 01048.01051> policy_invalid_topic_test [RUNNING]
[00016.306] 01048.01051> [PASSED] (0 ms)
[00016.306] 01048.01051> policy_basic_test [RUNNING]
[00016.306] 01048.01051> [PASSED] (0 ms)
[00016.306] 01048.01051> policy_timer_slack_invalid_options_test [RUNNING]
[00016.306] 01048.01051> [PASSED] (0 ms)
[00016.306] 01048.01051> policy_timer_slack_invalid_count_test [RUNNING]
[00016.306] 01048.01051> [PASSED] (0 ms)
[00016.306] 01048.01051> policy_timer_slack_invalid_policy_test [RUNNING]
[00016.306] 01048.01051> [PASSED] (0 ms)
[00016.306] 01048.01051> policy_timer_slack_non_empty_test [RUNNING]
[00016.306] 01048.01051> [PASSED] (0 ms)
[00016.306] 01048.01051> policy_timer_slack_valid [RUNNING]
[00016.306] 01048.01051> [PASSED] (0 ms)
[00016.306] 01048.01051> create_test [RUNNING]
[00016.306] 01048.01051> [PASSED] (0 ms)
[00016.306] 01048.01051> kill_test [RUNNING]
[00016.313] 01048.01051> [PASSED] (6 ms)
[00016.313] 01048.01051> kill_job_no_child_test [RUNNING]
[00016.313] 01048.01051> [PASSED] (0 ms)
[00016.313] 01048.01051> set_job_oom_kill_bit [RUNNING]
[00016.313] 01048.01051> [PASSED] (0 ms)
[00016.313] 01048.01051> wait_test [RUNNING]
[00016.320] 01048.01051> [PASSED] (7 ms)
[00016.320] 01048.01051> info_task_stats_fails [RUNNING]
[00016.320] 01048.01051> [PASSED] (0 ms)
[00016.320] 01048.01051> max_height_smoke [RUNNING]
[00016.320] 01048.01051> [PASSED] (0 ms)
[00016.320] 01048.01051> CASE job_tests [PASSED]
[00016.320] 01048.01051>
CASE handle_wait_tests [STARTED]
[00016.320] 01048.01051> handle_wait_test [RUNNING]
[00017.705] 01048.01051> [PASSED] (1384 ms)
[00017.705] 01048.01051> CASE handle_wait_tests [PASSED]
[00017.705] 01048.01051>
CASE handle_transfer_tests [STARTED]
[00017.705] 01048.01051> handle_transfer_test [RUNNING]
[00017.705] 01048.01051> [PASSED] (0 ms)
[00017.705] 01048.01051> handle_transfer_cancel_wait_test [RUNNING]
[00017.731] 01048.01051> [PASSED] (26 ms)
[00017.731] 01048.01051> CASE handle_transfer_tests [PASSED]
[00017.731] 01048.01051>
CASE handle_info_tests [STARTED]
[00017.731] 01048.01051> handle_replace_test [RUNNING]
[00017.731] 01048.01051> [PASSED] (0 ms)
[00017.732] 01048.01051> handle_info_test [RUNNING]
[00017.732] 01048.01051> [PASSED] (0 ms)
[00017.732] 01048.01051> handle_related_koid_test [RUNNING]
[00017.734] 01048.01051> [PASSED] (2 ms)
[00017.734] 01048.01051> handle_rights_test [RUNNING]
[00017.734] 01048.01051> [PASSED] (0 ms)
[00017.734] 01048.01051> CASE handle_info_tests [PASSED]
[00017.734] 01048.01051>
CASE handle_close_tests [STARTED]
[00017.734] 01048.01051> handle_close_many_test [RUNNING]
[00017.734] 01048.01051> [PASSED] (0 ms)
[00017.734] 01048.01051> handle_close_many_invalid_test [RUNNING]
[00017.734] 01048.01051> [PASSED] (0 ms)
[00017.734] 01048.01051> handle_close_many_duplicate_test [RUNNING]
[00017.734] 01048.01051> [PASSED] (0 ms)
[00017.734] 01048.01051> CASE handle_close_tests [PASSED]
[00017.734] 01048.01051>
CASE futex_tests [STARTED]
[00017.734] 01048.01051> TestFutexWaitValueMismatch [RUNNING]
[00017.734] 01048.01051> [PASSED] (0 ms)
[00017.734] 01048.01051> TestFutexWaitTimeout [RUNNING]
[00017.734] 01048.01051> [PASSED] (0 ms)
[00017.734] 01048.01051> TestFutexWaitTimeoutElapsed [RUNNING]
[00018.236] 01048.01051> [PASSED] (501 ms)
[00018.236] 01048.01051> TestFutexWaitBadAddress [RUNNING]
[00018.236] 01048.01051> [PASSED] (0 ms)
[00018.236] 01048.01051> TestFutexWakeup [RUNNING]
[00018.239] 01048.01051> [PASSED] (2 ms)
[00018.239] 01048.01051> TestFutexWakeupLimit [RUNNING]
[00018.861] 01048.01051> [PASSED] (622 ms)
[00018.861] 01048.01051> TestFutexWakeupAddress [RUNNING]
[00018.869] 01048.01051> [PASSED] (7 ms)
[00018.869] 01048.01051> TestFutexRequeueValueMismatch [RUNNING]
[00018.869] 01048.01051> [PASSED] (0 ms)
[00018.869] 01048.01051> TestFutexRequeueSameAddr [RUNNING]
[00018.869] 01048.01051> [PASSED] (0 ms)
[00018.869] 01048.01051> TestFutexRequeue [RUNNING]
[00019.795] 01048.01051> [PASSED] (925 ms)
[00019.795] 01048.01051> TestFutexRequeueUnqueuedOnTimeout [RUNNING]
[00020.097] 01048.01051> [PASSED] (301 ms)
[00020.097] 01048.01051> TestFutexThreadKilled [RUNNING]
[00020.097] 01048.01051> [PASSED] (0 ms)
[00020.097] 01048.01051> TestFutexThreadSuspended [RUNNING]
[00020.419] 01048.01051> [PASSED] (321 ms)
[00020.419] 01048.01051> TestFutexMisaligned [RUNNING]
[00020.419] 01048.01051> [PASSED] (0 ms)
[00020.419] 01048.01051> TestEventSignaling [RUNNING]
[00020.723] 01048.01051> [PASSED] (304 ms)
[00020.723] 01048.01051> CASE futex_tests [PASSED]
[00020.723] 01048.01051>
CASE fifo_tests [STARTED]
[00020.723] 01048.01051> basic_test [RUNNING]
[00020.723] 01048.01051> [PASSED] (0 ms)
[00020.723] 01048.01051> peer_closed_test [RUNNING]
[00020.723] 01048.01051> [PASSED] (0 ms)
[00020.723] 01048.01051> options_test [RUNNING]
[00020.723] 01048.01051> [PASSED] (0 ms)
[00020.723] 01048.01051> CASE fifo_tests [PASSED]
[00020.723] 01048.01051>
CASE eventpair_tests [STARTED]
[00020.723] 01048.01051> create_test [RUNNING]
[00020.723] 01048.01051> [PASSED] (0 ms)
[00020.723] 01048.01051> signal_test [RUNNING]
[00020.723] 01048.01051> [PASSED] (0 ms)
[00020.723] 01048.01051> signal_peer_test [RUNNING]
[00020.723] 01048.01051> [PASSED] (0 ms)
[00020.723] 01048.01051> signal_peer_closed_test [RUNNING]
[00020.723] 01048.01051> [PASSED] (0 ms)
[00020.723] 01048.01051> CASE eventpair_tests [PASSED]
[00020.723] 01048.01051>
CASE elf_tls_tests [STARTED]
[00020.723] 01048.01051> ExecutableTlsTest [RUNNING]
[00021.760] 01048.01051> [PASSED] (1036 ms)
[00021.760] 01048.01051> CASE elf_tls_tests [PASSED]
[00021.760] 01048.01051>
CASE cookie_tests [STARTED]
[00021.760] 01048.01051> test_cookie_actions [RUNNING]
[00021.760] 01048.01051> [PASSED] (0 ms)
[00021.760] 01048.01051> test_cookie_eventpair [RUNNING]
[00021.760] 01048.01051> [PASSED] (0 ms)
[00021.760] 01048.01051> CASE cookie_tests [PASSED]
[00021.760] 01048.01051>
CASE clock_tests [STARTED]
[00021.760] 01048.01051> clock_monotonic_test [RUNNING]
[00021.771] 01048.01051> [PASSED] (10 ms)
[00021.771] 01048.01051> CASE clock_tests [PASSED]
[00021.771] 01048.01051>
CASE channel_tests [STARTED]
[00021.771] 01048.01051> channel_test [RUNNING]
[00021.771] 01048.01051> [PASSED] (0 ms)
[00021.771] 01048.01051> channel_read_error_test [RUNNING]
[00021.771] 01048.01051> [PASSED] (0 ms)
[00021.771] 01048.01051> channel_close_test [RUNNING]
[00021.772] 01048.01051> [PASSED] (0 ms)
[00021.772] 01048.01051> channel_peer_closed_test [RUNNING]
[00021.772] 01048.01051> [PASSED] (0 ms)
[00021.772] 01048.01051> channel_non_transferable [RUNNING]
[00021.772] 01048.01051> [PASSED] (0 ms)
[00021.772] 01048.01051> channel_duplicate_handles [RUNNING]
[00021.772] 01048.01051> [PASSED] (0 ms)
[00021.772] 01048.01051> channel_multithread_read [RUNNING]
[00021.855] 01048.01051> [PASSED] (83 ms)
[00021.855] 01048.01051> channel_may_discard [RUNNING]
[00021.855] 01048.01051> [PASSED] (0 ms)
[00021.855] 01048.01051> channel_call [RUNNING]
[00021.872] 01048.01051> [PASSED] (17 ms)
[00021.872] 01048.01051> channel_call_consumes_handles [RUNNING]
[00021.873] 01048.01051> [PASSED] (0 ms)
[00021.873] 01048.01051> channel_call2 [RUNNING]
[00022.123] 01048.01051> [PASSED] (250 ms)
[00022.123] 01048.01051> bad_channel_call_finish [RUNNING]
[00022.123] 01048.01051> [PASSED] (0 ms)
[00022.123] 01048.01051> channel_nest [RUNNING]
[00022.125] 01048.01051> [PASSED] (1 ms)
[00022.125] 01048.01051> channel_disallow_write_to_self [RUNNING]
[00022.125] 01048.01051> [PASSED] (0 ms)
[00022.125] 01048.01051> channel_read_etc [RUNNING]
[00022.125] 01048.01051> [PASSED] (0 ms)
[00022.125] 01048.01051> channel_write_different_sizes [RUNNING]
[00022.218] 01048.01051> [PASSED] (93 ms)
[00022.218] 01048.01051> channel_write_takes_all_handles [RUNNING]
[00022.222] 01048.01051> [PASSED] (4 ms)
[00022.222] 01048.01051> CASE channel_tests [PASSED]
[00022.222] 01048.01051>
CASE c11_thread_tests [STARTED]
[00022.222] 01048.01051> c11_thread_test [RUNNING]
[00023.028] 01048.01051> [PASSED] (806 ms)
[00023.028] 01048.01051> long_name_succeeds [RUNNING]
[00023.130] 01048.01051> [PASSED] (101 ms)
[00023.130] 01048.01051> detach_self_test [RUNNING]
[00026.610] 01048.01051> [PASSED] (3480 ms)
[00026.610] 01048.01051> CASE c11_thread_tests [PASSED]
[00026.610] 01048.01051>
CASE mtx_tests [STARTED]
[00026.611] 01048.01051> test_initializer [RUNNING]
[00026.611] 01048.01051> [PASSED] (0 ms)
[00026.611] 01048.01051> test_mutexes [RUNNING]
[00026.749] 01048.01051> [PASSED] (138 ms)
[00026.749] 01048.01051> test_try_mutexes [RUNNING]
[00026.855] 01048.01051> [PASSED] (105 ms)
[00026.855] 01048.01051> test_static_initializer [RUNNING]
[00026.855] 01048.01051> [PASSED] (0 ms)
[00026.855] 01048.01051> test_timeout_elapsed [RUNNING]
[00027.358] 01048.01051> [PASSED] (502 ms)
[00027.358] 01048.01051> CASE mtx_tests [PASSED]
[00027.358] 01048.01051>
CASE cnd_tests [STARTED]
[00027.358] 01048.01051> cnd_test [RUNNING]
[00027.379] 01048.01051> [PASSED] (21 ms)
[00027.379] 01048.01051> cnd_timedwait_timeout_test [RUNNING]
[00027.386] 01048.01051> [PASSED] (7 ms)
[00027.387] 01048.01051> CASE cnd_tests [PASSED]
[00027.387] 01048.01051>
CASE bad_syscall_tests [STARTED]
[00027.387] 01048.01051> bad_access_test [RUNNING]
[00027.387] 01048.01051> [PASSED] (0 ms)
[00027.387] 01048.01051> bad_syscall_num_test [RUNNING]
[00027.412] 01048.01051> [PASSED] (25 ms)
[00027.412] 01048.01051> CASE bad_syscall_tests [PASSED]
[00027.412] 01048.01051> ====================================================
[00027.412] 01048.01051> Results:
[00027.412] 01048.01051> SUCCESS! All test cases passed!
[00027.412] 01048.01051> CASES: 42 SUCCESS: 42 FAILED: 0
[00027.412] 01048.01051> ====================================================
[00027.412] 01048.01051> core-tests succeeded RZMm59f7zOSs6aZUIXZR
[00027.442] 01034.01041> userboot: loader-service channel peer closed
[00027.442] 01034.01041> userboot: Waiting for bin/core-tests to exit...
[00027.472] 01034.01041> userboot: Process exited. Executing "poweroff".
[00027.476] 01034.01041> mp_unplug_cpu_mask_single_locked:357: WARNING: leaking thread for cpu 3
[00027.482] 01034.01041> mp_unplug_cpu_mask_single_locked:357: WARNING: leaking thread for cpu 2
[00027.488] 01034.01041> mp_unplug_cpu_mask_single_locked:357: WARNING: leaking thread for cpu 1
[00027.488] 01034.01041> Shutting down debuglog
2019/03/26 17:08:44 successful QEMU exit status: 31