2018/12/15 03:00:13 running:
Args: [/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 -net none -append userboot=bin/core-tests userboot.shutdown kernel.halt-on-panic=true devmgr.suspend-timeout-debug=true TERM=dumb kernel.serial=legacy -kernel /b/s/w/ir/multiboot.bin -initrd /b/s/w/ir/zircon.zbi]
Env: []
[00000.000] 00000.00000> zbi: @ 0xffffff8001070000 (14914096 bytes)
[00000.000] 00000.00000> UART: FIFO depth 16
[00000.000] 00000.00000> PMM: boot reserve add [0x100000, 0x2b5fff]
[00000.000] 00000.00000> PMM: boot reserve add [0x1070000, 0x1ea9fff]
[00000.000] 00000.00000> PMM: boot reserve marking WIRED [0x100000, 0x2b5fff]
[00000.000] 00000.00000> PMM: boot reserve marking WIRED [0x1070000, 0x1ea9fff]
[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 0xffffffff001a0e3c (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 [0x1eaa000, 0x1eaa080)
[00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00142b00 (elf_build_id) at level 0x4fffe, flags 0x1
[00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00142c8c (version) at level 0x4ffff, flags 0x1
[00000.000] 00000.00000> version:
[00000.000] 00000.00000> arch: x86
[00000.000] 00000.00000> platform: pc
[00000.000] 00000.00000> target: pc
[00000.000] 00000.00000> project: x64
[00000.000] 00000.00000> buildid: git-0ea31bfc33a658b9469f5989f5ba35993f6df713
[00000.000] 00000.00000> ELF build ID: d470095ccb829aecca7b01ffb2627397e1fd1482
[00000.000] 00000.00000> initializing heap
[00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff001033d8 (x86_resource_init) at level 0x50000, flags 0x1
[00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0019f2bc (console) at level 0x50000, flags 0x1
[00000.000] 00000.00000> initializing vm
[00000.000] 00000.00000> VM: reserving kernel region [0xffffffff00100000, 0xffffffff001e0000) flags 0x28 name 'kernel_code'
[00000.000] 00000.00000> VM: reserving kernel region [0xffffffff001e0000, 0xffffffff00222000) flags 0x8 name 'kernel_rodata'
[00000.000] 00000.00000> VM: reserving kernel region [0xffffffff00222000, 0xffffffff00232000) flags 0x18 name 'kernel_data'
[00000.000] 00000.00000> VM: reserving kernel region [0xffffffff00232000, 0xffffffff002b6000) flags 0x18 name 'kernel_bss'
[00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00101168 (acpi_tables) at level 0x60001, flags 0x1
[00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff001040a8 (display_memtype) at level 0x60001, flags 0x1
[00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00102130 (hpet) at level 0x60002, flags 0x1
[00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff001024b8 (apic) at level 0x60002, flags 0x1
[00000.000] 00000.00000> x2APIC enabled
[00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff001067d4 (timer) at level 0x60003, flags 0x1
[00000.000] 00000.00000> pvclock: Clocksource is stable
[00000.000] 00000.00000> HPET frequency: 100000 ticks/ms
[00000.000] 00000.00000> pvclock: Fetching TSC frequency
[00000.000] 00000.00000> TSC frequency: 2299802 ticks/ms
[00000.505] 00000.00000> timer features: constant_tsc 1 invariant_tsc 1 tsc_deadline 1
[00000.505] 00000.00000> Using TSC as wallclock
[00000.505] 00000.00000> initializing kernel
[00000.505] 00000.00000> initializing mp
[00000.505] 00000.00000> initializing timers
[00000.505] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00137774 (debuglog) at level 0x7ffff, flags 0x1
[00000.506] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0018d284 (thread_set_priority_experiment) at level 0x7ffff, flags 0x1
[00000.506] 00000.00000> thread set priority experiment is : ENABLED
[00000.506] 00000.00000> INIT: cpu 0, calling hook 0xffffffff001a1090 (global_prng_thread_safe) at level 0x7ffff, flags 0x1
[00000.506] 00000.00000> creating bootstrap completion thread
[00000.707] 00000.00000> top of bootstrap2()
[00000.707] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0012dc54 (dpc) at level 0x80000, flags 0x1
[00000.715] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0014d980 (libobject) at level 0x80000, flags 0x1
[00000.715] 00000.00000> OOM: started thread
[00000.724] 00000.00000> Processor Model Info: type 0 family 0x6 model 0xf stepping 0
[00000.724] 00000.00000> display_family 0x6 display_model 0x3f
[00000.724] 00000.00000> Vendor: Intel
[00000.724] 00000.00000> Microarch: Haswell
[00000.724] 00000.00000> F/M/S: 6/3f/0
[00000.724] 00000.00000> Brand: Intel(R) Xeon(R) CPU @ 2.30GHz
[00000.724] 00000.00000> Features: fpu sse sse2 sse3 ssse3 sse4.1 sse4.2 mmx avx avx2 fxsr pcid xsave aesni clflush
[00000.724] 00000.00000> fsgsbase tsc_adj smep erms rdrand syscall nx rdtscp tsc_deadline x2apic hypervisor
[00000.724] 00000.00000> initializing platform
[00000.724] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0011084c (x86_perfmon) at level 0x90000, flags 0x1
[00000.724] 00000.00000> x86_perfmon_init_once:495: perfmon: unexpected programmable counter width 0 in cpuid.0AH
[00000.724] 00000.00000> UART: started IRQ driven RX
[00000.724] 00000.00000> UART: started IRQ driven TX
[00000.724] 00000.00000> cpu topology:
[00000.724] 00000.00000> 0: apic id 0x0 package 0 node 0 core 0 smt 0 BSP
[00000.724] 00000.00000> 1: apic id 0x1 package 1 node 0 core 0 smt 0
[00000.724] 00000.00000> 2: apic id 0x2 package 2 node 0 core 0 smt 0
[00000.724] 00000.00000> 3: apic id 0x3 package 3 node 0 core 0 smt 0
[00000.724] 00000.00000> Found 4 cpus
[00000.725] 00000.00000> booting apic ids: 0x1 0x2 0x3
[00000.810] 00000.00000> entering scheduler on cpu 1
[00000.810] 00000.00000> entering scheduler on cpu 2
[00000.810] 00000.00000> entering scheduler on cpu 3
[00000.822] 00000.00000> smbios: manufacturer="QEMU" product="Standard PC (Q35 + ICH9, 2009)"
[00000.822] 00000.00000> initializing target
[00000.822] 00000.00000> INIT: cpu 0, calling hook 0xffffffff001059b8 (x86_pcie_init) at level 0xa0000, flags 0x1
[00000.822] 00000.00000> moving to last init level
[00000.822] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0013f338 (ktrace) at level 0xc0000, flags 0x1
[00000.894] 00000.00000> ktrace: buffer at 0xffffff936e1c4000 (33554432 bytes)
[00000.894] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00142af8 (userboot) at level 0xc0000, flags 0x1
[00000.894] 00000.00000> userboot: ramdisk 0xe3a000 @ 0xffffff8001070000
[00000.912] 00000.00000> userboot: userboot rodata 0 @ [0x7ac256069000,0x7ac25606c000)
[00000.912] 00000.00000> userboot: userboot code 0x3000 @ [0x7ac25606c000,0x7ac256077000)
[00000.912] 00000.00000> userboot: vdso/full rodata 0 @ [0x7ac256077000,0x7ac25607e000)
[00000.912] 00000.00000> userboot: vdso/full code 0x7000 @ [0x7ac25607e000,0x7ac25607f000)
[00000.912] 00000.00000> userboot: entry point @ 0x7ac25606cc10
[00000.912] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0019fcbc (kernel_shell) at level 0xc0000, flags 0x1
[00000.948] 01032.01039> userboot: option "/b/s/w/ir/multiboot.bin="
[00000.948] 01032.01039> userboot: option "userboot=bin/core-tests"
[00000.948] 01032.01039> userboot: option "userboot.shutdown="
[00000.948] 01032.01039> userboot: option "kernel.halt-on-panic=true"
[00000.948] 01032.01039> userboot: option "devmgr.suspend-timeout-debug=true"
[00000.948] 01032.01039> userboot: option "TERM=dumb"
[00000.948] 01032.01039> userboot: option "kernel.serial=legacy"
[00000.948] 01032.01039> userboot: option "multiboot.boot_loader_name=qemu"
[00001.032] 01032.01039> userboot: searching bootfs for 'bin/core-tests'
[00001.032] 01032.01039> userboot: 'bin/core-tests' has PT_INTERP "lib/ld.so.1"
[00001.032] 01032.01039> userboot: searching bootfs for 'lib/ld.so.1'
[00001.032] 01032.01039> userboot: userboot: loaded lib/ld.so.1 at 0x55666b563000, entry point 0x55666b5e8f63
[00001.032] 01032.01039> userboot: userboot: loaded vDSO at 0x7f31bec62000, entry point 0x0
[00001.032] 01032.01039> userboot: process bin/core-tests started.
[00001.032] 01032.01039> userboot: waiting for loader-service requests...
[00001.033] 01032.01039> userboot: searching bootfs for 'lib/libunittest.so'
[00001.033] 01032.01039> userboot: searching bootfs for 'lib/libmini-process.so'
[00001.033] 01046.01049> {{{reset}}}
[00001.034] 01046.01049> {{{module:0:<application>:elf:144df795e5af5f0b35817bbbd40942a0dbf8bc3e}}}
[00001.034] 01046.01049> {{{mmap:0x1e5698296000:0xee000:load:0:rx:0}}}
[00001.034] 01046.01049> {{{mmap:0x1e5698385000:0x4000:load:0:rw:0xef000}}}
[00001.034] 01046.01049> dso: id=144df795e5af5f0b35817bbbd40942a0dbf8bc3e base=0x00001e5698296000 name=<application>
[00001.034] 01046.01049> {{{module:0x3:libunittest.so:elf:3065069fdd438c09c58cf1de5043b59a370de46f}}}
[00001.034] 01046.01049> {{{mmap:0x61d8c29e9000:0x6000:load:0x3:rx:0}}}
[00001.034] 01046.01049> {{{mmap:0x61d8c29ef000:0x3000:load:0x3:rw:0x6000}}}
[00001.034] 01046.01049> dso: id=3065069fdd438c09c58cf1de5043b59a370de46f base=0x000061d8c29e9000 name=libunittest.so
[00001.034] 01046.01049> {{{module:0x4:libmini-process.so:elf:f663cce7cc6a567d21696ab926219c9be67c394e}}}
[00001.034] 01046.01049> {{{mmap:0x4109ebacc000:0x3000:load:0x4:rx:0}}}
[00001.034] 01046.01049> {{{mmap:0x4109ebacf000:0x2000:load:0x4:rw:0x3000}}}
[00001.034] 01046.01049> dso: id=f663cce7cc6a567d21696ab926219c9be67c394e base=0x00004109ebacc000 name=libmini-process.so
[00001.034] 01046.01049> {{{module:0x2:<vDSO>:elf:e215fca514bde144c386aa4db5a9ac3877fb962f}}}
[00001.034] 01046.01049> {{{mmap:0x7f31bec62000:0x7000:load:0x2:r:0}}}
[00001.034] 01046.01049> {{{mmap:0x7f31bec69000:0x1000:load:0x2:rx:0x7000}}}
[00001.034] 01046.01049> dso: id=e215fca514bde144c386aa4db5a9ac3877fb962f base=0x00007f31bec62000 name=<vDSO>
[00001.034] 01046.01049> {{{module:0x1:libc.so:elf:42b6ea0c3ac41d2132fc847d32d3d758b7c92adf}}}
[00001.034] 01046.01049> {{{mmap:0x55666b563000:0xcb000:load:0x1:rx:0}}}
[00001.034] 01046.01049> {{{mmap:0x55666b62f000:0x6000:load:0x1:rw:0xcc000}}}
[00001.034] 01046.01049> dso: id=42b6ea0c3ac41d2132fc847d32d3d758b7c92adf base=0x000055666b563000 name=libc.so
[00001.034] 01046.01049> TEST
[00001.034] 01046.01049>
CASE sync_completion_tests [STARTED]
[00001.034] 01046.01049> test_initializer [RUNNING]
[00001.034] 01046.01049> [PASSED] (0 ms)
[00001.034] 01046.01049> test_completions [RUNNING]
[00001.071] 01046.01049> [PASSED] (37 ms)
[00001.071] 01046.01049> test_timeout [RUNNING]
[00002.187] 01046.01049> [PASSED] (1116 ms)
[00002.187] 01046.01049> test_signal_requeue [RUNNING]
[00002.213] 01046.01049> [PASSED] (25 ms)
[00002.213] 01046.01049> CASE sync_completion_tests [PASSED]
[00002.213] 01046.01049>
CASE interrupt_tests [STARTED]
[00002.213] 01046.01049> interrupt_test [RUNNING]
[00002.213] 01046.01049> [PASSED] (0 ms)
[00002.213] 01046.01049> interrupt_port_bound_test [RUNNING]
[00002.213] 01046.01049> [PASSED] (0 ms)
[00002.213] 01046.01049> interrupt_port_non_bindable_test [RUNNING]
[00002.213] 01046.01049> [PASSED] (0 ms)
[00002.213] 01046.01049> interrupt_suspend_test [RUNNING]
[00002.217] 01046.01049> [PASSED] (3 ms)
[00002.217] 01046.01049> interrupt_bind_vcpu_test [RUNNING]
[00002.217] 01046.01049> Guest creation not supported
[00002.217] 01046.01049> [PASSED] (0 ms)
[00002.217] 01046.01049> interrupt_bind_vcpu_not_supported_test [RUNNING]
[00002.217] 01046.01049> Guest creation not supported
[00002.217] 01046.01049> [PASSED] (0 ms)
[00002.217] 01046.01049> interrupt_bind_vcpu_already_bound_test [RUNNING]
[00002.217] 01046.01049> Guest creation not supported
[00002.217] 01046.01049> [PASSED] (0 ms)
[00002.217] 01046.01049> interrupt_bind_vcpu_multiple_guests_test [RUNNING]
[00002.217] 01046.01049> Guest creation not supported
[00002.217] 01046.01049> [PASSED] (0 ms)
[00002.217] 01046.01049> CASE interrupt_tests [PASSED]
[00002.217] 01046.01049>
CASE pthread_tests [STARTED]
[00002.217] 01046.01049> pthread_test [RUNNING]
[00006.026] 01046.01049> [PASSED] (3809 ms)
[00006.027] 01046.01049> pthread_self_main_thread_test [RUNNING]
[00006.027] 01046.01049> [PASSED] (0 ms)
[00006.027] 01046.01049> pthread_big_stack_size [RUNNING]
[00006.054] 01046.01049> [PASSED] (27 ms)
[00006.054] 01046.01049> pthread_getstack_main_thread [RUNNING]
[00006.054] 01046.01049> [PASSED] (0 ms)
[00006.054] 01046.01049> pthread_getstack_other_thread [RUNNING]
[00006.055] 01046.01049> [PASSED] (0 ms)
[00006.055] 01046.01049> CASE pthread_tests [PASSED]
[00006.055] 01046.01049>
CASE elf_tls_tests [STARTED]
[00006.055] 01046.01049> ExecutableTlsTest [RUNNING]
[00007.075] 01046.01049> [PASSED] (1020 ms)
[00007.075] 01046.01049> CASE elf_tls_tests [PASSED]
[00007.075] 01046.01049>
CASE sync_condition_tests [STARTED]
[00007.075] 01046.01049> Condition::condition_test [RUNNING]
[00007.097] 01046.01049> [PASSED] (22 ms)
[00007.097] 01046.01049> Condition::condition_timeout_test [RUNNING]
[00007.107] 01046.01049> [PASSED] (1 ms)
[00007.107] 01046.01049> CASE sync_condition_tests [PASSED]
[00007.107] 01046.01049>
CASE memory_mapping_tests [STARTED]
[00007.107] 01046.01049> address_space_limits_test [RUNNING]
[00007.107] 01046.01049> [PASSED] (0 ms)
[00007.107] 01046.01049> mmap_zerofilled_test [RUNNING]
[00007.107] 01046.01049> [PASSED] (0 ms)
[00007.107] 01046.01049> mmap_len_test [RUNNING]
[00007.107] 01046.01049> [PASSED] (0 ms)
[00007.107] 01046.01049> mmap_PROT_EXEC_test [RUNNING]
[00007.107] 01046.01049> [PASSED] (0 ms)
[00007.107] 01046.01049> mmap_offset_test [RUNNING]
[00007.107] 01046.01049> [PASSED] (0 ms)
[00007.107] 01046.01049> mmap_prot_test [RUNNING]
[00007.107] 01046.01049> [PASSED] (0 ms)
[00007.107] 01046.01049> mmap_flags_test [RUNNING]
[00007.107] 01046.01049> [PASSED] (0 ms)
[00007.107] 01046.01049> mprotect_test [RUNNING]
[00007.188] 01046.01049> [PASSED] (81 ms)
[00007.188] 01046.01049> CASE memory_mapping_tests [PASSED]
[00007.188] 01046.01049>
CASE object_info_tests [STARTED]
[00007.188] 01046.01049> handle_valid_on_valid_handle_succeeds [RUNNING]
[00007.188] 01046.01049> [PASSED] (0 ms)
[00007.188] 01046.01049> handle_valid_on_closed_handle_fails [RUNNING]
[00007.188] 01046.01049> [PASSED] (0 ms)
[00007.188] 01046.01049> (invalid_handle_fails<ZX_INFO_HANDLE_VALID, void*>) [RUNNING]
[00007.188] 01046.01049> [PASSED] (0 ms)
[00007.188] 01046.01049> task_stats_unstarted [RUNNING]
[00007.188] 01046.01049> [PASSED] (0 ms)
[00007.188] 01046.01049> task_stats_smoke [RUNNING]
[00007.188] 01046.01049> [PASSED] (0 ms)
[00007.188] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t>) [RUNNING]
[00007.189] 01046.01049> [PASSED] (0 ms)
[00007.189] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING]
[00007.189] 01046.01049> [PASSED] (0 ms)
[00007.189] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING]
[00007.189] 01046.01049> [PASSED] (0 ms)
[00007.189] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING]
[00007.189] 01046.01049> [PASSED] (0 ms)
[00007.189] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING]
[00007.189] 01046.01049> [PASSED] (0 ms)
[00007.189] 01046.01049> (single_zero_buffer_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING]
[00007.189] 01046.01049> [PASSED] (0 ms)
[00007.189] 01046.01049> (wrong_handle_type_fails<ZX_INFO_TASK_STATS, zx_info_task_stats_t, get_test_job>) [RUNNING]
[00007.189] 01046.01049> [PASSED] (0 ms)
[00007.189] 01046.01049> (wrong_handle_type_fails<ZX_INFO_TASK_STATS, zx_info_task_stats_t, zx_thread_self>) [RUNNING]
[00007.189] 01046.01049> [PASSED] (0 ms)
[00007.189] 01046.01049> process_maps_unstarted [RUNNING]
[00007.189] 01046.01049> [PASSED] (0 ms)
[00007.189] 01046.01049> process_maps_smoke [RUNNING]
[00007.189] 01046.01049> [PASSED] (0 ms)
[00007.189] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t>) [RUNNING]
[00007.190] 01046.01049> [PASSED] (0 ms)
[00007.190] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING]
[00007.190] 01046.01049> [PASSED] (0 ms)
[00007.190] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING]
[00007.190] 01046.01049> [PASSED] (0 ms)
[00007.190] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING]
[00007.190] 01046.01049> [PASSED] (0 ms)
[00007.190] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING]
[00007.190] 01046.01049> [PASSED] (0 ms)
[00007.407] 01046.01049> (multi_zero_buffer_succeeds<((zx_object_info_topic_t) 13u), get_test_process>) [RUNNING]
[00007.407] 01046.01049> [PASSED] (0 ms)
[00007.407] 01046.01049> (short_buffer_succeeds<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING]
[00007.407] 01046.01049> [PASSED] (0 ms)
[00007.407] 01046.01049> (partially_unmapped_buffer_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING]
[00007.407] 01046.01049> [PASSED] (0 ms)
[00007.407] 01046.01049> (self_fails<ZX_INFO_PROCESS_MAPS, zx_info_maps_t>) [RUNNING]
[00007.407] 01046.01049> [PASSED] (0 ms)
[00007.407] 01046.01049> (wrong_handle_type_fails<ZX_INFO_PROCESS_MAPS, zx_info_maps_t, get_test_job>) [RUNNING]
[00007.407] 01046.01049> [PASSED] (0 ms)
[00007.407] 01046.01049> (wrong_handle_type_fails<ZX_INFO_PROCESS_MAPS, zx_info_maps_t, zx_thread_self>) [RUNNING]
[00007.407] 01046.01049> [PASSED] (0 ms)
[00007.407] 01046.01049> (missing_rights_fails<ZX_INFO_PROCESS_MAPS, zx_info_maps_t, get_test_process, ZX_RIGHT_INSPECT>) [RUNNING]
[00007.407] 01046.01049> [PASSED] (0 ms)
[00007.407] 01046.01049> process_vmos_smoke [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (multi_zero_buffer_succeeds<((zx_object_info_topic_t) 14u), get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (short_buffer_succeeds<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (partially_unmapped_buffer_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (self_fails<ZX_INFO_PROCESS_VMOS, zx_info_vmo_t>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (wrong_handle_type_fails<ZX_INFO_PROCESS_VMOS, zx_info_vmo_t, get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (wrong_handle_type_fails<ZX_INFO_PROCESS_VMOS, zx_info_vmo_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (missing_rights_fails<ZX_INFO_PROCESS_VMOS, zx_info_vmo_t, get_test_process, ZX_RIGHT_INSPECT>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> job_processes_smoke [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 9u), zx_koid_t>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (multi_zero_buffer_succeeds<((zx_object_info_topic_t) 9u), get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (short_buffer_succeeds<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (partially_unmapped_buffer_fails<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (wrong_handle_type_fails<ZX_INFO_JOB_PROCESSES, zx_koid_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (wrong_handle_type_fails<ZX_INFO_JOB_PROCESSES, zx_koid_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (missing_rights_fails<ZX_INFO_JOB_PROCESSES, zx_koid_t, get_test_job, ZX_RIGHT_ENUMERATE>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> job_children_smoke [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 8u), zx_koid_t>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (multi_zero_buffer_succeeds<((zx_object_info_topic_t) 8u), get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (short_buffer_succeeds<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (partially_unmapped_buffer_fails<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (wrong_handle_type_fails<ZX_INFO_JOB_CHILDREN, zx_koid_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (wrong_handle_type_fails<ZX_INFO_JOB_CHILDREN, zx_koid_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (missing_rights_fails<ZX_INFO_JOB_CHILDREN, zx_koid_t, get_test_job, ZX_RIGHT_ENUMERATE>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (single_zero_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (single_zero_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (single_zero_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (single_zero_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (single_zero_buffer_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 3u), zx_info_process_t>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (single_zero_buffer_fails<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (wrong_handle_type_fails<ZX_INFO_PROCESS, zx_info_process_t, get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (wrong_handle_type_fails<ZX_INFO_PROCESS, zx_info_process_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (single_zero_buffer_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (wrong_handle_type_fails<ZX_INFO_VMAR, zx_info_vmar_t, get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (wrong_handle_type_fails<ZX_INFO_VMAR, zx_info_vmar_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (wrong_handle_type_fails<ZX_INFO_VMAR, zx_info_vmar_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (single_zero_buffer_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (wrong_handle_type_fails<ZX_INFO_THREAD, zx_info_thread_t, get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (wrong_handle_type_fails<ZX_INFO_THREAD, zx_info_thread_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (single_zero_buffer_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (wrong_handle_type_fails<ZX_INFO_THREAD_STATS, zx_info_thread_t, get_test_job>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (wrong_handle_type_fails<ZX_INFO_THREAD_STATS, zx_info_thread_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (invalid_handle_fails<ZX_INFO_PROCESS_THREADS, zx_koid_t>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (null_avail_actual_succeeds<ZX_INFO_PROCESS_THREADS, zx_koid_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_buffer_fails<ZX_INFO_PROCESS_THREADS, zx_koid_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_actual_fails<ZX_INFO_PROCESS_THREADS, zx_koid_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (bad_avail_fails<ZX_INFO_PROCESS_THREADS, zx_koid_t, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (multi_zero_buffer_succeeds<ZX_INFO_PROCESS_THREADS, get_test_process>) [RUNNING]
[00007.408] 01046.01049> [PASSED] (0 ms)
[00007.408] 01046.01049> (invalid_handle_fails<ZX_INFO_THREAD_EXCEPTION_REPORT, zx_exception_report_t>) [RUNNING]
[00007.409] 01046.01049> [PASSED] (0 ms)
[00007.409] 01046.01049> handle_count_valid [RUNNING]
[00007.409] 01046.01049> [PASSED] (0 ms)
[00007.409] 01046.01049> handle_stats_control [RUNNING]
[00007.409] 01046.01049> [PASSED] (0 ms)
[00007.409] 01046.01049> CASE object_info_tests [PASSED]
[00007.409] 01046.01049>
CASE process_tests [STARTED]
[00007.409] 01046.01049> mini_process_sanity [RUNNING]
[00008.629] 01046.01049> [PASSED] (1219 ms)
[00008.629] 01046.01049> process_start_fail [RUNNING]
[00008.638] 01046.01049> [PASSED] (8 ms)
[00008.638] 01046.01049> process_not_killed_via_thread_close [RUNNING]
[00008.647] 01046.01049> [PASSED] (8 ms)
[00008.647] 01046.01049> process_not_killed_via_process_close [RUNNING]
[00008.656] 01046.01049> [PASSED] (9 ms)
[00008.656] 01046.01049> kill_process_via_thread_kill [RUNNING]
[00008.659] 01046.01049> [PASSED] (2 ms)
[00008.659] 01046.01049> kill_process_via_vmar_destroy [RUNNING]
[00008.659] 01751.01753> PageFault: 1019529 free pages
[00008.659] 01751.01753> PageFault: MemoryUsed: proc 1032 30M 'userboot'
[00008.665] 01046.01049> [PASSED] (5 ms)
[00008.665] 01046.01049> kill_channel_handle_cycle [RUNNING]
[00009.417] 01046.01049> [PASSED] (752 ms)
[00009.417] 01046.01049> info_reflects_process_state [RUNNING]
[00009.668] 01046.01049> [PASSED] (251 ms)
[00009.668] 01046.01049> suspend [RUNNING]
[00009.669] 01046.01049> [PASSED] (0 ms)
[00009.669] 01046.01049> suspend_multiple_threads [RUNNING]
[00009.685] 01046.01049> [PASSED] (16 ms)
[00009.685] 01046.01049> suspend_before_creating_threads [RUNNING]
[00009.695] 01046.01049> [PASSED] (9 ms)
[00009.695] 01046.01049> suspend_before_starting_threads [RUNNING]
[00009.695] 01046.01049> [PASSED] (0 ms)
[00009.695] 01046.01049> suspend_process_then_thread [RUNNING]
[00009.963] 01046.01049> [PASSED] (267 ms)
[00009.963] 01046.01049> suspend_thread_then_process [RUNNING]
[00010.214] 01046.01049> [PASSED] (251 ms)
[00010.214] 01046.01049> suspend_thread_and_process_before_starting_process [RUNNING]
[00010.466] 01046.01049> [PASSED] (251 ms)
[00010.466] 01046.01049> suspend_twice [RUNNING]
[00010.717] 01046.01049> [PASSED] (251 ms)
[00010.717] 01046.01049> suspend_twice_before_creating_threads [RUNNING]
[00010.968] 01046.01049> [PASSED] (251 ms)
[00010.968] 01046.01049> suspend_with_dying_thread [RUNNING]
[00010.978] 01046.01049> [PASSED] (9 ms)
[00010.978] 01046.01049> CASE process_tests [PASSED]
[00010.978] 01046.01049>
CASE threads_tests [STARTED]
[00010.978] 01046.01049> TestBasics [RUNNING]
[00011.079] 01046.01049> [PASSED] (100 ms)
[00011.079] 01046.01049> TestInvalidRights [RUNNING]
[00011.079] 01046.01049> [PASSED] (0 ms)
[00011.079] 01046.01049> TestDetach [RUNNING]
[00011.079] 01046.01049> [PASSED] (0 ms)
[00011.080] 01046.01049> TestLongNameSucceeds [RUNNING]
[00011.105] 01046.01049> [PASSED] (25 ms)
[00011.105] 01046.01049> TestThreadStartOnInitialThread [RUNNING]
[00011.106] 01046.01049> [PASSED] (0 ms)
[00011.106] 01046.01049> TestThreadStartWithZeroInstructionPointer [RUNNING]
[00011.107] 01046.01049> [PASSED] (0 ms)
[00011.107] 01046.01049> TestKillBusyThread [RUNNING]
[00011.233] 01046.01049> [PASSED] (126 ms)
[00011.233] 01046.01049> TestKillSleepThread [RUNNING]
[00011.334] 01046.01049> [PASSED] (100 ms)
[00011.334] 01046.01049> TestKillWaitThread [RUNNING]
[00011.435] 01046.01049> [PASSED] (101 ms)
[00011.435] 01046.01049> TestNonstartedThread [RUNNING]
[00011.435] 01046.01049> [PASSED] (0 ms)
[00011.435] 01046.01049> TestThreadKillsItself [RUNNING]
[00011.439] 01046.01049> [PASSED] (3 ms)
[00011.439] 01046.01049> TestInfoTaskStatsFails [RUNNING]
[00011.539] 01046.01049> [PASSED] (100 ms)
[00011.540] 01046.01049> TestResumeSuspended [RUNNING]
[00011.642] 01046.01049> [PASSED] (102 ms)
[00011.642] 01046.01049> TestSuspendSleeping [RUNNING]
[00011.743] 01046.01049> [PASSED] (100 ms)
[00011.743] 01046.01049> TestSuspendChannelCall [RUNNING]
[00011.746] 01046.01049> [PASSED] (3 ms)
[00011.746] 01046.01049> TestSuspendPortCall [RUNNING]
[00011.947] 01046.01049> [PASSED] (201 ms)
[00011.947] 01046.01049> TestSuspendStopsThread [RUNNING]
[00011.998] 01046.01049> [PASSED] (50 ms)
[00011.998] 01046.01049> TestSuspendMultiple [RUNNING]
[00011.999] 01046.01049> [PASSED] (1 ms)
[00011.999] 01046.01049> TestKillSuspendedThread [RUNNING]
[00012.002] 01046.01049> [PASSED] (2 ms)
[00012.002] 01046.01049> TestStartSuspendedThread [RUNNING]
[00012.025] 01046.01049> [PASSED] (23 ms)
[00012.025] 01046.01049> TestStartSuspendedAndResumedThread [RUNNING]
[00012.026] 01046.01049> [PASSED] (0 ms)
[00012.026] 01046.01049> TestSuspendSingleWaitAsyncSignalDelivery [RUNNING]
[00012.028] 01046.01049> [PASSED] (2 ms)
[00012.028] 01046.01049> TestSuspendRepeatingWaitAsyncSignalDelivery [RUNNING]
[00012.034] 01046.01049> [PASSED] (5 ms)
[00012.034] 01046.01049> TestReadingGeneralRegisterState [RUNNING]
[00012.134] 01046.01049> [PASSED] (100 ms)
[00012.134] 01046.01049> TestWritingGeneralRegisterState [RUNNING]
[00012.235] 01046.01049> [PASSED] (100 ms)
[00012.235] 01046.01049> TestNoncanonicalRipAddress [RUNNING]
[00012.336] 01046.01049> [PASSED] (101 ms)
[00012.336] 01046.01049> TestWritingArmFlagsRegister [RUNNING]
[00012.336] 01046.01049> [PASSED] (0 ms)
[00012.336] 01046.01049> CASE threads_tests [PASSED]
[00012.336] 01046.01049>
CASE port_tests [STARTED]
[00012.336] 01046.01049> basic_test [RUNNING]
[00012.337] 01046.01049> [PASSED] (0 ms)
[00012.337] 01046.01049> queue_and_close_test [RUNNING]
[00012.337] 01046.01049> [PASSED] (0 ms)
[00012.337] 01046.01049> queue_too_many [RUNNING]
[00012.338] 01046.01049> [PASSED] (0 ms)
[00012.338] 01046.01049> async_wait_channel_test [RUNNING]
[00012.340] 01046.01049> [PASSED] (2 ms)
[00012.340] 01046.01049> async_wait_event_test_single [RUNNING]
[00012.340] 01046.01049> [PASSED] (0 ms)
[00012.340] 01046.01049> async_wait_event_test_repeat [RUNNING]
[00012.340] 01046.01049> [PASSED] (0 ms)
[00012.340] 01046.01049> async_wait_invalid_option [RUNNING]
[00012.340] 01046.01049> [PASSED] (0 ms)
[00012.340] 01046.01049> async_wait_close_order_1 [RUNNING]
[00012.340] 01046.01049> [PASSED] (0 ms)
[00012.340] 01046.01049> async_wait_close_order_2 [RUNNING]
[00012.340] 01046.01049> [PASSED] (0 ms)
[00012.340] 01046.01049> async_wait_close_order_3 [RUNNING]
[00012.340] 01046.01049> [PASSED] (0 ms)
[00012.340] 01046.01049> async_wait_close_order_4 [RUNNING]
[00012.340] 01046.01049> [PASSED] (0 ms)
[00012.340] 01046.01049> async_wait_close_order_5 [RUNNING]
[00012.340] 01046.01049> [PASSED] (0 ms)
[00012.340] 01046.01049> async_wait_close_order_6 [RUNNING]
[00012.340] 01046.01049> [PASSED] (0 ms)
[00012.340] 01046.01049> channel_pre_writes_once [RUNNING]
[00012.340] 01046.01049> [PASSED] (0 ms)
[00012.340] 01046.01049> channel_pre_writes_repeat [RUNNING]
[00012.340] 01046.01049> [PASSED] (0 ms)
[00012.340] 01046.01049> cancel_event_key_once [RUNNING]
[00012.340] 01046.01049> [PASSED] (0 ms)
[00012.340] 01046.01049> cancel_event_key_repeat [RUNNING]
[00012.340] 01046.01049> [PASSED] (0 ms)
[00012.340] 01046.01049> cancel_event_key_once_after [RUNNING]
[00012.340] 01046.01049> [PASSED] (0 ms)
[00012.340] 01046.01049> cancel_event_key_repeat_after [RUNNING]
[00012.340] 01046.01049> [PASSED] (0 ms)
[00012.340] 01046.01049> threads_event_once [RUNNING]
[00012.534] 01046.01049> [PASSED] (193 ms)
[00012.534] 01046.01049> threads_event_repeat [RUNNING]
[00012.535] 01046.01049> [PASSED] (1 ms)
[00012.535] 01046.01049> cancel_stress [RUNNING]
[00017.901] 01046.01049> [PASSED] (5365 ms)
[00017.901] 01046.01049> CASE port_tests [PASSED]
[00017.901] 01046.01049>
CASE object_get_child_tests [STARTED]
[00017.901] 01046.01049> handle_invalid [RUNNING]
[00017.901] 01046.01049> [PASSED] (0 ms)
[00017.901] 01046.01049> CASE object_get_child_tests [PASSED]
[00017.901] 01046.01049>
CASE vmar_tests [STARTED]
[00017.901] 01046.01049> destroy_root_test [RUNNING]
[00017.901] 01046.01049> [PASSED] (0 ms)
[00017.901] 01046.01049> basic_allocate_test [RUNNING]
[00017.901] 01046.01049> [PASSED] (0 ms)
[00017.901] 01046.01049> allocate_oob_test [RUNNING]
[00017.901] 01046.01049> [PASSED] (0 ms)
[00017.901] 01046.01049> allocate_unsatisfiable_test [RUNNING]
[00017.901] 01046.01049> [PASSED] (0 ms)
[00017.901] 01046.01049> destroyed_vmar_test [RUNNING]
[00017.901] 01046.01049> [PASSED] (0 ms)
[00017.901] 01046.01049> map_over_destroyed_test [RUNNING]
[00017.901] 01046.01049> [PASSED] (0 ms)
[00017.901] 01046.01049> map_in_compact_test [RUNNING]
[00017.901] 01046.01049> [PASSED] (0 ms)
[00017.901] 01046.01049> overmapping_test [RUNNING]
[00017.901] 01046.01049> [PASSED] (0 ms)
[00017.901] 01046.01049> invalid_args_test [RUNNING]
[00017.901] 01046.01049> [PASSED] (0 ms)
[00017.901] 01046.01049> unaligned_len_test [RUNNING]
[00017.901] 01046.01049> [PASSED] (0 ms)
[00017.901] 01046.01049> unaligned_len_map_test [RUNNING]
[00017.901] 01046.01049> [PASSED] (0 ms)
[00017.901] 01046.01049> rights_drop_test [RUNNING]
[00017.901] 01046.01049> [PASSED] (0 ms)
[00017.901] 01046.01049> protect_test [RUNNING]
[00017.901] 01046.01049> [PASSED] (0 ms)
[00017.901] 01046.01049> nested_region_perms_test [RUNNING]
[00017.901] 01046.01049> [PASSED] (0 ms)
[00017.902] 01046.01049> object_info_test [RUNNING]
[00017.902] 01046.01049> [PASSED] (0 ms)
[00017.902] 01046.01049> unmap_split_test [RUNNING]
[00017.902] 01046.01049> [PASSED] (0 ms)
[00017.902] 01046.01049> unmap_multiple_test [RUNNING]
[00017.902] 01046.01049> [PASSED] (0 ms)
[00017.902] 01046.01049> unmap_base_not_mapped_test [RUNNING]
[00017.902] 01046.01049> [PASSED] (0 ms)
[00017.902] 01046.01049> map_specific_overwrite_test [RUNNING]
[00017.902] 01046.01049> [PASSED] (0 ms)
[00017.902] 01046.01049> protect_split_test [RUNNING]
[00017.902] 01046.01049> [PASSED] (0 ms)
[00017.902] 01046.01049> protect_multiple_test [RUNNING]
[00017.902] 01046.01049> [PASSED] (0 ms)
[00017.902] 01046.01049> protect_over_demand_paged_test [RUNNING]
[00018.126] 01046.01049> [PASSED] (223 ms)
[00018.126] 01046.01049> protect_large_uncommitted_test [RUNNING]
[00018.136] 01046.01049> [PASSED] (10 ms)
[00018.136] 01046.01049> unmap_large_uncommitted_test [RUNNING]
[00018.139] 01046.02168> PageFault: 1019361 free pages
[00018.139] 01046.02168> PageFault: MemoryUsed: proc 1032 30M 'userboot'
[00018.145] 01046.02170> PageFault: 1019361 free pages
[00018.145] 01046.02170> PageFault: MemoryUsed: proc 1032 30M 'userboot'
[00018.149] 01046.02172> PageFault: 1019361 free pages
[00018.149] 01046.02172> PageFault: MemoryUsed: proc 1032 30M 'userboot'
[00018.153] 01046.01049> [PASSED] (17 ms)
[00018.153] 01046.01049> partial_unmap_and_read [RUNNING]
[00018.153] 01046.01049> [PASSED] (0 ms)
[00018.153] 01046.01049> partial_unmap_and_write [RUNNING]
[00018.153] 01046.01049> [PASSED] (0 ms)
[00018.153] 01046.01049> partial_unmap_with_vmar_offset [RUNNING]
[00018.153] 01046.01049> [PASSED] (0 ms)
[00018.153] 01046.01049> CASE vmar_tests [PASSED]
[00018.153] 01046.01049>
CASE profile_cpp_tests [STARTED]
[00018.153] 01046.01049> profile_failures_test [RUNNING]
[00018.153] 01046.01049> [PASSED] (0 ms)
[00018.153] 01046.01049> profile_priority_test [RUNNING]
[00018.153] 01046.01049> [PASSED] (0 ms)
[00018.153] 01046.01049> CASE profile_cpp_tests [PASSED]
[00018.153] 01046.01049>
CASE resource_tests [STARTED]
[00018.153] 01046.01049> probe_address_space [RUNNING]
[00018.153] 01046.01049> [PASSED] (0 ms)
[00018.153] 01046.01049> TestBasicActions [RUNNING]
[00018.153] 01046.01049> [PASSED] (0 ms)
[00018.153] 01046.01049> TestExclusiveShared [RUNNING]
[00018.153] 01046.01049> [PASSED] (0 ms)
[00018.153] 01046.01049> TestSharedExclusive [RUNNING]
[00018.153] 01046.01049> [PASSED] (0 ms)
[00018.153] 01046.01049> TestInvalidArgs [RUNNING]
[00018.153] 01046.01049> [PASSED] (0 ms)
[00018.153] 01046.01049> TestVmoCreation [RUNNING]
[00018.153] 01046.01049> [PASSED] (0 ms)
[00018.153] 01046.01049> TestVmoCreationSmaller [RUNNING]
[00018.153] 01046.01049> [PASSED] (0 ms)
[00018.153] 01046.01049> TestVmoCreationUnaligned [RUNNING]
[00018.153] 01046.01049> [PASSED] (0 ms)
[00018.153] 01046.01049> TestVmoReplaceAsExecutable [RUNNING]
[00018.154] 01046.01049> [PASSED] (0 ms)
[00018.154] 01046.01049> test_ioports [RUNNING]
[00018.157] 01046.01049> [PASSED] (3 ms)
[00018.157] 01046.01049> CASE resource_tests [PASSED]
[00018.157] 01046.01049>
CASE futex_tests [STARTED]
[00018.157] 01046.01049> TestFutexWaitValueMismatch [RUNNING]
[00018.157] 01046.01049> [PASSED] (0 ms)
[00018.157] 01046.01049> TestFutexWaitTimeout [RUNNING]
[00018.157] 01046.01049> [PASSED] (0 ms)
[00018.157] 01046.01049> TestFutexWaitTimeoutElapsed [RUNNING]
[00020.658] 01046.01049> [PASSED] (2501 ms)
[00020.658] 01046.01049> TestFutexWaitBadAddress [RUNNING]
[00020.658] 01046.01049> [PASSED] (0 ms)
[00020.658] 01046.01049> TestFutexWakeup [RUNNING]
[00020.659] 01046.01049> [PASSED] (0 ms)
[00020.659] 01046.01049> TestFutexWakeupLimit [RUNNING]
[00020.688] 01046.01049> [PASSED] (28 ms)
[00020.688] 01046.01049> TestFutexWakeupAddress [RUNNING]
[00020.689] 01046.01049> [PASSED] (0 ms)
[00020.689] 01046.01049> TestFutexUnqueuedOnTimeout [RUNNING]
[00020.707] 01046.01049> [PASSED] (17 ms)
[00020.707] 01046.01049> TestFutexUnqueuedOnTimeout_2 [RUNNING]
[00020.909] 01046.01049> [PASSED] (202 ms)
[00020.909] 01046.01049> TestFutexUnqueuedOnTimeout_3 [RUNNING]
[00021.313] 01046.01049> [PASSED] (403 ms)
[00021.313] 01046.01049> TestFutexRequeueValueMismatch [RUNNING]
[00021.313] 01046.01049> [PASSED] (0 ms)
[00021.313] 01046.01049> TestFutexRequeueSameAddr [RUNNING]
[00021.313] 01046.01049> [PASSED] (0 ms)
[00021.313] 01046.01049> TestFutexRequeue [RUNNING]
[00021.325] 01046.01049> [PASSED] (11 ms)
[00021.325] 01046.01049> TestFutexRequeueUnqueuedOnTimeout [RUNNING]
[00021.631] 01046.01049> [PASSED] (305 ms)
[00021.631] 01046.01049> TestFutexThreadKilled [RUNNING]
[00021.642] 01046.01049> [PASSED] (10 ms)
[00021.642] 01046.01049> TestFutexThreadSuspended [RUNNING]
[00021.663] 01046.01049> [PASSED] (20 ms)
[00021.663] 01046.01049> TestFutexMisaligned [RUNNING]
[00021.663] 01046.01049> [PASSED] (0 ms)
[00021.663] 01046.01049> TestEventSignaling [RUNNING]
[00021.965] 01046.01049> [PASSED] (302 ms)
[00021.965] 01046.01049> CASE futex_tests [PASSED]
[00021.965] 01046.01049>
CASE sync_completion_tests [STARTED]
[00021.965] 01046.01049> test_initializer [RUNNING]
[00021.965] 01046.01049> [PASSED] (0 ms)
[00021.965] 01046.01049> test_completions [RUNNING]
[00022.011] 01046.01049> [PASSED] (45 ms)
[00022.011] 01046.01049> test_timeout [RUNNING]
[00022.012] 01046.01049> [PASSED] (0 ms)
[00022.012] 01046.01049> CASE sync_completion_tests [PASSED]
[00022.012] 01046.01049>
CASE ticks_tests [STARTED]
[00022.012] 01046.01049> elapsed_time_using_ticks [RUNNING]
[00022.012] 01046.01049> [PASSED] (0 ms)
[00022.012] 01046.01049> CASE ticks_tests [PASSED]
[00022.012] 01046.01049>
CASE eventpair_tests [STARTED]
[00022.012] 01046.01049> create_test [RUNNING]
[00022.012] 01046.01049> [PASSED] (0 ms)
[00022.012] 01046.01049> signal_test [RUNNING]
[00022.012] 01046.01049> [PASSED] (0 ms)
[00022.012] 01046.01049> signal_peer_test [RUNNING]
[00022.012] 01046.01049> [PASSED] (0 ms)
[00022.012] 01046.01049> signal_peer_closed_test [RUNNING]
[00022.012] 01046.01049> [PASSED] (0 ms)
[00022.012] 01046.01049> CASE eventpair_tests [PASSED]
[00022.012] 01046.01049>
CASE stack_tests [STARTED]
[00022.012] 01046.01049> main_thread_stack_tests [RUNNING]
[00022.012] 01046.01049> [PASSED] (0 ms)
[00022.012] 01046.01049> other_thread_stack_tests [RUNNING]
[00022.012] 01046.01049> [PASSED] (0 ms)
[00022.012] 01046.01049> CASE stack_tests [PASSED]
[00022.012] 01046.01049>
CASE mtx_tests [STARTED]
[00022.012] 01046.01049> test_initializer [RUNNING]
[00022.012] 01046.01049> [PASSED] (0 ms)
[00022.012] 01046.01049> test_mutexes [RUNNING]
[00022.206] 01046.01049> [PASSED] (193 ms)
[00022.206] 01046.01049> test_try_mutexes [RUNNING]
[00022.304] 01046.01049> [PASSED] (97 ms)
[00022.304] 01046.01049> test_static_initializer [RUNNING]
[00022.304] 01046.01049> [PASSED] (0 ms)
[00022.304] 01046.01049> test_timeout_elapsed [RUNNING]
[00022.806] 01046.01049> [PASSED] (501 ms)
[00022.806] 01046.01049> CASE mtx_tests [PASSED]
[00022.806] 01046.01049>
CASE c11_thread_tests [STARTED]
[00022.806] 01046.01049> c11_thread_test [RUNNING]
[00023.612] 01046.01049> [PASSED] (805 ms)
[00023.612] 01046.01049> long_name_succeeds [RUNNING]
[00023.713] 01046.01049> [PASSED] (100 ms)
[00023.713] 01046.01049> detach_self_test [RUNNING]
[00024.633] 01046.01049> [PASSED] (920 ms)
[00024.634] 01046.01049> CASE c11_thread_tests [PASSED]
[00024.634] 01046.01049>
CASE echo_tests [STARTED]
[00024.634] 01046.01049> echo_test [RUNNING]
[00024.634] 01046.01049> [PASSED] (0 ms)
[00024.634] 01046.01049> CASE echo_tests [PASSED]
[00024.634] 01046.01049>
CASE socket_tests [STARTED]
[00024.634] 01046.01049> socket_basic [RUNNING]
[00024.649] 01046.01049> [PASSED] (14 ms)
[00024.649] 01046.01049> socket_signals [RUNNING]
[00024.649] 01046.01049> [PASSED] (0 ms)
[00024.649] 01046.01049> socket_peer_closed_signal [RUNNING]
[00024.649] 01046.01049> [PASSED] (0 ms)
[00024.649] 01046.01049> socket_peer_closed_set_property [RUNNING]
[00024.649] 01046.01049> [PASSED] (0 ms)
[00024.649] 01046.01049> socket_shutdown_write [RUNNING]
[00024.649] 01046.01049> [PASSED] (0 ms)
[00024.649] 01046.01049> socket_shutdown_read [RUNNING]
[00024.649] 01046.01049> [PASSED] (0 ms)
[00024.649] 01046.01049> socket_bytes_outstanding [RUNNING]
[00024.649] 01046.01049> [PASSED] (0 ms)
[00024.649] 01046.01049> socket_bytes_outstanding_shutdown_write [RUNNING]
[00024.649] 01046.01049> [PASSED] (0 ms)
[00024.649] 01046.01049> socket_bytes_outstanding_shutdown_read [RUNNING]
[00024.649] 01046.01049> [PASSED] (0 ms)
[00024.649] 01046.01049> socket_short_write [RUNNING]
[00024.649] 01046.01049> [PASSED] (0 ms)
[00024.649] 01046.01049> socket_datagram [RUNNING]
[00024.649] 01046.01049> [PASSED] (0 ms)
[00024.649] 01046.01049> socket_datagram_no_short_write [RUNNING]
[00024.650] 01046.01049> [PASSED] (0 ms)
[00024.650] 01046.01049> socket_control_plane_absent [RUNNING]
[00024.650] 01046.01049> [PASSED] (0 ms)
[00024.650] 01046.01049> socket_control_plane [RUNNING]
[00024.650] 01046.01049> [PASSED] (0 ms)
[00024.650] 01046.01049> socket_control_plane_shutdown [RUNNING]
[00024.650] 01046.01049> [PASSED] (0 ms)
[00024.650] 01046.01049> socket_accept [RUNNING]
[00024.650] 01046.01049> [PASSED] (0 ms)
[00024.650] 01046.01049> socket_share_invalid_handle [RUNNING]
[00024.650] 01046.01049> [PASSED] (0 ms)
[00024.650] 01046.01049> socket_share_consumes_on_failure [RUNNING]
[00024.650] 01046.01049> [PASSED] (0 ms)
[00024.650] 01046.01049> socket_signals2 [RUNNING]
[00024.650] 01046.01049> [PASSED] (0 ms)
[00024.650] 01046.01049> CASE socket_tests [PASSED]
[00024.650] 01046.01049>
CASE handle_info_tests [STARTED]
[00024.650] 01046.01049> handle_replace_test [RUNNING]
[00024.650] 01046.01049> [PASSED] (0 ms)
[00024.650] 01046.01049> handle_info_test [RUNNING]
[00024.650] 01046.01049> [PASSED] (0 ms)
[00024.650] 01046.01049> handle_related_koid_test [RUNNING]
[00024.872] 01046.01049> [PASSED] (222 ms)
[00024.872] 01046.01049> handle_rights_test [RUNNING]
[00024.872] 01046.01049> [PASSED] (0 ms)
[00024.872] 01046.01049> CASE handle_info_tests [PASSED]
[00024.872] 01046.01049>
CASE handle_wait_tests [STARTED]
[00024.872] 01046.01049> handle_wait_test [RUNNING]
[00024.874] 01046.01049> [PASSED] (1 ms)
[00024.874] 01046.01049> CASE handle_wait_tests [PASSED]
[00024.874] 01046.01049>
CASE pthread_barrier_tests [STARTED]
[00024.874] 01046.01049> test_barrier [RUNNING]
[00025.150] 01046.01049> [PASSED] (276 ms)
[00025.150] 01046.01049> CASE pthread_barrier_tests [PASSED]
[00025.150] 01046.01049>
CASE handle_transfer_tests [STARTED]
[00025.150] 01046.01049> handle_transfer_test [RUNNING]
[00025.150] 01046.01049> [PASSED] (0 ms)
[00025.150] 01046.01049> handle_transfer_cancel_wait_test [RUNNING]
[00025.180] 01046.01049> [PASSED] (29 ms)
[00025.180] 01046.01049> CASE handle_transfer_tests [PASSED]
[00025.180] 01046.01049>
CASE fifo_tests [STARTED]
[00025.180] 01046.01049> basic_test [RUNNING]
[00025.180] 01046.01049> [PASSED] (0 ms)
[00025.180] 01046.01049> peer_closed_test [RUNNING]
[00025.180] 01046.01049> [PASSED] (0 ms)
[00025.180] 01046.01049> options_test [RUNNING]
[00025.180] 01046.01049> [PASSED] (0 ms)
[00025.180] 01046.01049> CASE fifo_tests [PASSED]
[00025.180] 01046.01049>
CASE vmo_signal_tests [STARTED]
[00025.180] 01046.01049> vmo_signal_sanity_test [RUNNING]
[00025.180] 01046.01049> [PASSED] (0 ms)
[00025.180] 01046.01049> vmo_child_signal_clone_test [RUNNING]
[00025.180] 01046.01049> [PASSED] (0 ms)
[00025.180] 01046.01049> vmo_child_signal_map_test [RUNNING]
[00025.180] 01046.01049> [PASSED] (0 ms)
[00025.180] 01046.01049> CASE vmo_signal_tests [PASSED]
[00025.180] 01046.01049>
CASE cookie_tests [STARTED]
[00025.180] 01046.01049> test_cookie_actions [RUNNING]
[00025.180] 01046.01049> [PASSED] (0 ms)
[00025.180] 01046.01049> test_cookie_eventpair [RUNNING]
[00025.180] 01046.01049> [PASSED] (0 ms)
[00025.180] 01046.01049> CASE cookie_tests [PASSED]
[00025.180] 01046.01049>
CASE job_tests [STARTED]
[00025.180] 01046.01049> basic_test [RUNNING]
[00025.180] 01046.01049> [PASSED] (0 ms)
[00025.180] 01046.01049> create_missing_rights_test [RUNNING]
[00025.180] 01046.01049> [PASSED] (0 ms)
[00025.180] 01046.01049> policy_basic_test [RUNNING]
[00025.180] 01046.01049> [PASSED] (0 ms)
[00025.180] 01046.01049> create_test [RUNNING]
[00025.180] 01046.01049> [PASSED] (0 ms)
[00025.180] 01046.01049> kill_test [RUNNING]
[00025.339] 01046.01049> [PASSED] (158 ms)
[00025.339] 01046.01049> kill_job_no_child_test [RUNNING]
[00025.339] 01046.01049> [PASSED] (0 ms)
[00025.339] 01046.01049> set_job_oom_kill_bit [RUNNING]
[00025.339] 01046.01049> [PASSED] (0 ms)
[00025.339] 01046.01049> wait_test [RUNNING]
[00025.367] 01046.01049> [PASSED] (28 ms)
[00025.367] 01046.01049> info_task_stats_fails [RUNNING]
[00025.367] 01046.01049> [PASSED] (0 ms)
[00025.367] 01046.01049> max_height_smoke [RUNNING]
[00025.367] 01046.01049> [PASSED] (0 ms)
[00025.368] 01046.01049> CASE job_tests [PASSED]
[00025.368] 01046.01049>
CASE bad_syscall_tests [STARTED]
[00025.368] 01046.01049> bad_access_test [RUNNING]
[00025.368] 01046.01049> [PASSED] (0 ms)
[00025.368] 01046.01049> bad_syscall_num_test [RUNNING]
[00025.419] 01046.01049> [PASSED] (51 ms)
[00025.419] 01046.01049> CASE bad_syscall_tests [PASSED]
[00025.419] 01046.01049>
CASE cnd_tests [STARTED]
[00025.419] 01046.01049> cnd_test [RUNNING]
[00025.441] 01046.01049> [PASSED] (21 ms)
[00025.441] 01046.01049> cnd_timedwait_timeout_test [RUNNING]
[00025.442] 01046.01049> [PASSED] (1 ms)
[00025.442] 01046.01049> CASE cnd_tests [PASSED]
[00025.442] 01046.01049>
CASE handle_close_tests [STARTED]
[00025.442] 01046.01049> handle_close_many_test [RUNNING]
[00025.470] 01046.01049> [PASSED] (27 ms)
[00025.470] 01046.01049> handle_close_many_invalid_test [RUNNING]
[00025.470] 01046.01049> [PASSED] (0 ms)
[00025.470] 01046.01049> handle_close_many_duplicate_test [RUNNING]
[00025.470] 01046.01049> [PASSED] (0 ms)
[00025.470] 01046.01049> CASE handle_close_tests [PASSED]
[00025.470] 01046.01049>
CASE sync_mutex_tests [STARTED]
[00025.470] 01046.01049> test_mutexes [RUNNING]
[00025.570] 01046.01049> [PASSED] (100 ms)
[00025.570] 01046.01049> test_try_mutexes [RUNNING]
[00025.657] 01046.01049> [PASSED] (86 ms)
[00025.657] 01046.01049> test_timeout_elapsed [RUNNING]
[00026.159] 01046.01049> [PASSED] (501 ms)
[00026.159] 01046.01049> CASE sync_mutex_tests [PASSED]
[00026.159] 01046.01049>
CASE clock_tests [STARTED]
[00026.159] 01046.01049> clock_monotonic_test [RUNNING]
[00026.192] 01046.01049> [PASSED] (33 ms)
[00026.192] 01046.01049> CASE clock_tests [PASSED]
[00026.192] 01046.01049>
CASE profile_tests [STARTED]
[00026.192] 01046.01049> make_profile_fails [RUNNING]
[00026.192] 01046.01049> [PASSED] (0 ms)
[00026.192] 01046.01049> change_priority_via_profile [RUNNING]
[00026.192] 01046.01049> [PASSED] (0 ms)
[00026.192] 01046.01049> CASE profile_tests [PASSED]
[00026.192] 01046.01049>
CASE tls_tests [STARTED]
[00026.192] 01046.01049> tls_test [RUNNING]
[00028.216] 01046.01049> [PASSED] (2024 ms)
[00028.216] 01046.01049> CASE tls_tests [PASSED]
[00028.216] 01046.01049>
CASE channel_tests [STARTED]
[00028.216] 01046.01049> channel_test [RUNNING]
[00028.217] 01046.01049> [PASSED] (1 ms)
[00028.217] 01046.01049> channel_read_error_test [RUNNING]
[00028.217] 01046.01049> [PASSED] (0 ms)
[00028.217] 01046.01049> channel_close_test [RUNNING]
[00028.217] 01046.01049> [PASSED] (0 ms)
[00028.217] 01046.01049> channel_peer_closed_test [RUNNING]
[00028.217] 01046.01049> [PASSED] (0 ms)
[00028.217] 01046.01049> channel_non_transferable [RUNNING]
[00028.217] 01046.01049> [PASSED] (0 ms)
[00028.217] 01046.01049> channel_duplicate_handles [RUNNING]
[00028.217] 01046.01049> [PASSED] (0 ms)
[00028.217] 01046.01049> channel_multithread_read [RUNNING]
[00028.381] 01046.01049> [PASSED] (163 ms)
[00028.381] 01046.01049> channel_may_discard [RUNNING]
[00028.381] 01046.01049> [PASSED] (0 ms)
[00028.381] 01046.01049> channel_call [RUNNING]
[00028.400] 01046.01049> [PASSED] (18 ms)
[00028.400] 01046.01049> channel_call_consumes_handles [RUNNING]
[00028.400] 01046.01049> [PASSED] (0 ms)
[00028.400] 01046.01049> channel_call2 [RUNNING]
[00028.652] 01046.01049> [PASSED] (251 ms)
[00028.652] 01046.01049> bad_channel_call_finish [RUNNING]
[00028.652] 01046.01049> [PASSED] (0 ms)
[00028.652] 01046.01049> channel_nest [RUNNING]
[00028.653] 01046.01049> [PASSED] (1 ms)
[00028.653] 01046.01049> channel_disallow_write_to_self [RUNNING]
[00028.653] 01046.01049> [PASSED] (0 ms)
[00028.653] 01046.01049> channel_read_etc [RUNNING]
[00028.653] 01046.01049> [PASSED] (0 ms)
[00028.653] 01046.01049> channel_write_different_sizes [RUNNING]
[00028.729] 01046.01049> [PASSED] (75 ms)
[00028.729] 01046.01049> channel_write_takes_all_handles [RUNNING]
[00028.730] 01046.01049> [PASSED] (1 ms)
[00028.730] 01046.01049> CASE channel_tests [PASSED]
[00028.730] 01046.01049> ====================================================
[00028.730] 01046.01049> Results:
[00028.730] 01046.01049> SUCCESS! All test cases passed!
[00028.730] 01046.01049> CASES: 39 SUCCESS: 39 FAILED: 0
[00028.730] 01046.01049> ====================================================
[00028.731] 01046.01049> core-tests succeeded RZMm59f7zOSs6aZUIXZR
[00028.780] 01032.01039> userboot: loader-service channel peer closed
[00028.780] 01032.01039> userboot: Waiting for bin/core-tests to exit...
[00028.780] 01032.01039> userboot: Process exited. Executing "poweroff".
[00028.797] 01032.01039> Shutting down debuglog
2018/12/15 03:00:42 successful QEMU exit status: 31