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

2019/03/22 20:49:40 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] [0.000] 00000.00000> zbi: @ 0xffffff8000910000 (8440304 bytes) [0.000] 00000.00000> UART: FIFO depth 16 [0.000] 00000.00000> PMM: boot reserve add [0x100000, 0x2e6fff] [0.000] 00000.00000> PMM: boot reserve add [0x910000, 0x111cfff] [0.000] 00000.00000> PMM: boot reserve marking WIRED [0x100000, 0x2e6fff] [0.000] 00000.00000> PMM: boot reserve marking WIRED [0x910000, 0x111cfff] [0.000] 00000.00000> welcome to Zircon [0.000] 00000.00000> KASLR: .text section at 0xffffffff00100000 [0.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0010f234 (global_prng_seed) at level 0x30000, flags 0x1 [0.000] 00000.00000> initializing vm pre-heap [0.000] 00000.00000> VM: marking boot alloc used range [0x111d000, 0x111d080) [0.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0011c4d8 (elf_build_id) at level 0x4fffe, flags 0x1 [0.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0011c664 (version) at level 0x4ffff, flags 0x1 [0.000] 00000.00000> version: [0.000] 00000.00000> arch: x86 [0.000] 00000.00000> platform: XXX [0.000] 00000.00000> target: XXX [0.000] 00000.00000> project: x64 [0.000] 00000.00000> buildid: git-dc74ab6de5720e1881177c9e2a0734a87cf814db-dirty [0.000] 00000.00000> ELF build ID: 730285c00abf6d4fd267c303b82cdfd2ba276c29 [0.000] 00000.00000> initializing heap [0.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00101f78 (console) at level 0x50000, flags 0x1 [0.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff001739d4 (x86_resource_init) at level 0x50000, flags 0x1 [0.000] 00000.00000> initializing vm [0.000] 00000.00000> VM: reserving kernel region [0xffffffff00100000, 0xffffffff00203000) flags 0x28 name 'kernel_code' [0.000] 00000.00000> VM: reserving kernel region [0xffffffff00203000, 0xffffffff00251000) flags 0x8 name 'kernel_rodata' [0.000] 00000.00000> VM: reserving kernel region [0xffffffff00251000, 0xffffffff00261000) flags 0x18 name 'kernel_data' [0.000] 00000.00000> VM: reserving kernel region [0xffffffff00261000, 0xffffffff002e7000) flags 0x18 name 'kernel_bss' [0.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00174698 (display_memtype) at level 0x60001, flags 0x1 [0.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00177700 (acpi_tables) at level 0x60001, flags 0x1 [0.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff001727f8 (hpet) at level 0x60002, flags 0x1 [0.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00172bb8 (apic) at level 0x60002, flags 0x1 [0.000] 00000.00000> x2APIC enabled [0.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00176cf0 (timer) at level 0x60003, flags 0x1 [0.000] 00000.00000> pvclock: Clocksource is stable [0.000] 00000.00000> HPET frequency: 100000 ticks/ms [0.000] 00000.00000> pvclock: Fetching TSC frequency [0.000] 00000.00000> TSC frequency: 2299798 ticks/ms [0.442] 00000.00000> timer features: constant_tsc 1 invariant_tsc 1 tsc_deadline 1 [0.442] 00000.00000> Using TSC as wallclock [0.442] 00000.00000> initializing kernel [0.442] 00000.00000> initializing mp [0.442] 00000.00000> initializing timers [0.442] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0010f488 (global_prng_thread_safe) at level 0x7ffff, flags 0x1 [0.442] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0011b790 (debuglog) at level 0x7ffff, flags 0x1 [0.442] 00000.00000> INIT: cpu 0, calling hook 0xffffffff001e8130 (thread_set_priority_experiment) at level 0x7ffff, flags 0x1 [0.442] 00000.00000> thread set priority experiment is : ENABLED [0.442] 00000.00000> creating bootstrap completion thread [0.608] 00000.00000> top of bootstrap2() [0.608] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00127f70 (libobject) at level 0x80000, flags 0x1 [0.608] 00000.00000> OOM: started thread [0.616] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0019fbf0 (dpc) at level 0x80000, flags 0x1 [0.621] 00000.00000> Processor Model Info: type 0 family 0x6 model 0xf stepping 0 [0.621] 00000.00000> display_family 0x6 display_model 0x3f [0.621] 00000.00000> Vendor: Intel [0.621] 00000.00000> Microarch: Haswell [0.621] 00000.00000> F/M/S: 6/3f/0 [0.621] 00000.00000> Brand: Intel(R) Xeon(R) CPU @ 2.30GHz [0.621] 00000.00000> Features: fpu sse sse2 sse3 ssse3 sse4.1 sse4.2 mmx avx avx2 fxsr pcid xsave aesni clflush [0.621] 00000.00000> fsgsbase tsc_adj smep erms rdrand syscall nx rdtscp tsc_deadline x2apic hypervisor [0.621] 00000.00000> initializing platform [0.621] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00190224 (x86_perfmon) at level 0x90000, flags 0x1 [0.621] 00000.00000> x86_perfmon_init_once:497: perfmon: unexpected programmable counter width 0 in cpuid.0AH [0.622] 00000.00000> UART: started IRQ driven RX [0.622] 00000.00000> UART: started IRQ driven TX [0.622] 00000.00000> cpu topology: [0.622] 00000.00000> 0: apic id 0x0 package 0 node 0 core 0 smt 0 BSP [0.622] 00000.00000> 1: apic id 0x1 package 1 node 0 core 0 smt 0 [0.622] 00000.00000> 2: apic id 0x2 package 2 node 0 core 0 smt 0 [0.622] 00000.00000> 3: apic id 0x3 package 3 node 0 core 0 smt 0 [0.622] 00000.00000> Found 4 cpus [0.622] 00000.00000> booting apic ids: 0x1 0x2 0x3 [0.692] 00000.00000> entering scheduler on cpu 2 [0.692] 00000.00000> entering scheduler on cpu 3 [0.692] 00000.00000> entering scheduler on cpu 1 [0.703] 00000.00000> smbios: manufacturer="QEMU" product="Standard PC (Q35 + ICH9, 2009)" [0.703] 00000.00000> initializing target [0.703] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00175fa0 (x86_pcie_init) at level 0xa0000, flags 0x1 [0.703] 00000.00000> moving to last init level [0.703] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00102a48 (kernel_shell) at level 0xc0000, flags 0x1 [0.703] 00000.00000> INIT: cpu 0, calling hook 0xffffffff001fe4c8 (ktrace) at level 0xc0000, flags 0x1 [0.745] 00000.00000> ktrace: buffer at 0xffffff9340335000 (33554432 bytes) [0.745] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00200408 (userboot) at level 0xc0000, flags 0x1 [0.745] 00000.00000> userboot: ramdisk 0x80d000 @ 0xffffff8000910000 [0.761] 00000.00000> userboot: userboot rodata 0 @ [0x344297ca7000,0x344297caa000) [0.761] 00000.00000> userboot: userboot code 0x3000 @ [0x344297caa000,0x344297cb5000) [0.761] 00000.00000> userboot: vdso/full rodata 0 @ [0x344297cb5000,0x344297cbc000) [0.761] 00000.00000> userboot: vdso/full code 0x7000 @ [0x344297cbc000,0x344297cbd000) [0.761] 00000.00000> userboot: entry point @ 0x344297caac90 [0.785] 01034.01041> userboot: option "userboot=bin/core-tests" [0.785] 01034.01041> userboot: option "userboot.shutdown=" [0.785] 01034.01041> userboot: option "/b/s/w/ir/multiboot.bin=" [0.785] 01034.01041> userboot: option "kernel.halt-on-panic=true" [0.785] 01034.01041> userboot: option "devmgr.suspend-timeout-debug=true" [0.785] 01034.01041> userboot: option "TERM=dumb" [0.785] 01034.01041> userboot: option "kernel.serial=legacy" [0.785] 01034.01041> userboot: option "multiboot.boot_loader_name=qemu" [0.817] 01034.01041> userboot: searching bootfs for 'bin/core-tests' [0.817] 01034.01041> userboot: 'bin/core-tests' has PT_INTERP "lib/asan/ld.so.1" [0.817] 01034.01041> userboot: searching bootfs for 'lib/asan/ld.so.1' [0.817] 01034.01041> userboot: userboot: loaded lib/asan/ld.so.1 at 0x5cc12ee3d000, entry point 0x5cc12ef133b8 [0.817] 01034.01041> userboot: userboot: loaded vDSO at 0x77ab1e23a000, entry point 0x0 [0.817] 01034.01041> userboot: process bin/core-tests started. [0.817] 01034.01041> userboot: waiting for loader-service requests... [0.818] 01034.01041> userboot: searching bootfs for 'lib/asan/libclang_rt.asan.so' [0.818] 01034.01041> userboot: file not found [0.818] 01034.01041> userboot: searching bootfs for 'lib/libclang_rt.asan.so' [0.868] 01034.01041> userboot: searching bootfs for 'lib/asan/libc++abi.so.1' [0.868] 01034.01041> userboot: searching bootfs for 'lib/asan/libunwind.so.1' [0.868] 01034.01041> userboot: searching bootfs for 'lib/asan/libfdio.so' [0.868] 01034.01041> userboot: searching bootfs for 'lib/asan/libunittest.so' [0.869] 01034.01041> userboot: searching bootfs for 'lib/asan/libmini-process.so' [0.869] 01034.01041> userboot: searching bootfs for 'lib/asan/libbacktrace.so' [0.896] 01034.01041> userboot: searching bootfs for 'lib/asan/libngunwind.so' [0.902] 01048.01051> dso: id=f9387264cc5002d1 base=0x000059c8dd2b2000 name=<application> [0.902] 01048.01051> dso: id=6b0961ced144a614 base=0x00005362d1161000 name=libclang_rt.asan.so [0.902] 01048.01051> dso: id=35a66bbcda9fb2f5 base=0x0000751d91686000 name=libfdio.so [0.902] 01048.01051> dso: id=42943fdcd5390a69 base=0x00003362a74fa000 name=libunittest.so [0.902] 01048.01051> dso: id=aafd65d279c791a277aef74d68e82587c0331200 base=0x000077ab1e23a000 name=<vDSO> [0.902] 01048.01051> dso: id=16e5ecae45061ed4 base=0x00007cbed71e7000 name=libmini-process.so [0.902] 01048.01051> dso: id=d63c63bf9187c66b base=0x000022fa945a6000 name=libbacktrace.so [0.902] 01048.01051> dso: id=9219ce3d0da556c1 base=0x000027a556ee9000 name=libngunwind.so [0.902] 01048.01051> dso: id=f56c1dabad48a940 base=0x00006ce177f9d000 name=libc++abi.so.1 [0.902] 01048.01051> dso: id=b1bbfb6cb9376b0f base=0x00002aa1b5356000 name=libunwind.so.1 [0.902] 01048.01051> dso: id=293e8c8ae1048390 base=0x00005cc12ee3d000 name=libc.so [1.136] 01048.01051> TEST CASE resource_tests [STARTED] [1.136] 01048.01051> probe_address_space [RUNNING] [1.136] 01048.01051> [PASSED] (0 ms) [1.136] 01048.01051> TestBasicActions [RUNNING] [1.137] 01048.01051> [PASSED] (0 ms) [1.137] 01048.01051> TestExclusiveShared [RUNNING] [1.137] 01048.01051> [PASSED] (0 ms) [1.137] 01048.01051> TestSharedExclusive [RUNNING] [1.137] 01048.01051> [PASSED] (0 ms) [1.137] 01048.01051> TestInvalidArgs [RUNNING] [1.137] 01048.01051> [PASSED] (0 ms) [1.137] 01048.01051> TestVmoCreation [RUNNING] [1.137] 01048.01051> [PASSED] (0 ms) [1.137] 01048.01051> TestVmoCreationSmaller [RUNNING] [1.137] 01048.01051> [PASSED] (0 ms) [1.137] 01048.01051> TestVmoCreationUnaligned [RUNNING] [1.137] 01048.01051> [PASSED] (0 ms) [1.137] 01048.01051> TestVmoReplaceAsExecutable [RUNNING] [1.137] 01048.01051> [PASSED] (0 ms) [1.137] 01048.01051> test_ioports [RUNNING] [1.215] 01048.01051> [PASSED] (77 ms) [1.215] 01048.01051> CASE resource_tests [PASSED] CASE profile_tests [STARTED] [1.215] 01048.01051> make_profile_fails [RUNNING] [1.215] 01048.01051> [PASSED] (0 ms) [1.215] 01048.01051> change_priority_via_profile [RUNNING] [1.215] 01048.01051> [PASSED] (0 ms) [1.215] 01048.01051> CASE profile_tests [PASSED] CASE interrupt_tests [STARTED] [1.215] 01048.01051> interrupt_test [RUNNING] [1.215] 01048.01051> [PASSED] (0 ms) [1.215] 01048.01051> interrupt_port_bound_test [RUNNING] [1.215] 01048.01051> [PASSED] (0 ms) [1.215] 01048.01051> interrupt_port_non_bindable_test [RUNNING] [1.215] 01048.01051> [PASSED] (0 ms) [1.215] 01048.01051> interrupt_suspend_test [RUNNING] [1.280] 01048.01051> [PASSED] (64 ms) [1.280] 01048.01051> interrupt_bind_vcpu_test [RUNNING] [1.280] 01048.01051> Guest creation not supported [1.280] 01048.01051> [PASSED] (0 ms) [1.280] 01048.01051> interrupt_bind_vcpu_not_supported_test [RUNNING] [1.280] 01048.01051> Guest creation not supported [1.280] 01048.01051> [PASSED] (0 ms) [1.280] 01048.01051> interrupt_bind_vcpu_already_bound_test [RUNNING] [1.280] 01048.01051> Guest creation not supported [1.280] 01048.01051> [PASSED] (0 ms) [1.280] 01048.01051> interrupt_bind_vcpu_multiple_guests_test [RUNNING] [1.280] 01048.01051> Guest creation not supported [1.280] 01048.01051> [PASSED] (0 ms) [1.280] 01048.01051> CASE interrupt_tests [PASSED] CASE vmo_signal_tests [STARTED] [1.280] 01048.01051> vmo_signal_sanity_test [RUNNING] [1.280] 01048.01051> [PASSED] (0 ms) [1.280] 01048.01051> vmo_child_signal_clone_test [RUNNING] [1.280] 01048.01051> [PASSED] (0 ms) [1.280] 01048.01051> vmo_child_signal_map_test [RUNNING] [1.281] 01048.01051> [PASSED] (0 ms) [1.281] 01048.01051> CASE vmo_signal_tests [PASSED] CASE vmar_tests [STARTED] [1.281] 01048.01051> destroy_root_test [RUNNING] [1.281] 01048.01051> [PASSED] (0 ms) [1.281] 01048.01051> basic_allocate_test [RUNNING] [1.281] 01048.01051> [PASSED] (0 ms) [1.281] 01048.01051> allocate_oob_test [RUNNING] [1.281] 01048.01051> [PASSED] (0 ms) [1.281] 01048.01051> allocate_unsatisfiable_test [RUNNING] [1.281] 01048.01051> [PASSED] (0 ms) [1.281] 01048.01051> destroyed_vmar_test [RUNNING] [1.398] 01048.01051> [PASSED] (116 ms) [1.398] 01048.01051> map_over_destroyed_test [RUNNING] [1.398] 01048.01051> [PASSED] (0 ms) [1.398] 01048.01051> map_in_compact_test [RUNNING] [1.398] 01048.01051> [PASSED] (0 ms) [1.398] 01048.01051> overmapping_test [RUNNING] [1.398] 01048.01051> [PASSED] (0 ms) [1.398] 01048.01051> invalid_args_test [RUNNING] [1.398] 01048.01051> [PASSED] (0 ms) [1.398] 01048.01051> unaligned_len_test [RUNNING] [1.398] 01048.01051> [PASSED] (0 ms) [1.398] 01048.01051> unaligned_len_map_test [RUNNING] [1.398] 01048.01051> [PASSED] (0 ms) [1.398] 01048.01051> rights_drop_test [RUNNING] [1.398] 01048.01051> [PASSED] (0 ms) [1.398] 01048.01051> protect_test [RUNNING] [1.398] 01048.01051> [PASSED] (0 ms) [1.398] 01048.01051> nested_region_perms_test [RUNNING] [1.398] 01048.01051> [PASSED] (0 ms) [1.398] 01048.01051> object_info_test [RUNNING] [1.398] 01048.01051> [PASSED] (0 ms) [1.398] 01048.01051> unmap_split_test [RUNNING] [1.398] 01048.01051> [PASSED] (0 ms) [1.398] 01048.01051> unmap_multiple_test [RUNNING] [1.399] 01048.01051> [PASSED] (0 ms) [1.399] 01048.01051> unmap_base_not_mapped_test [RUNNING] [1.399] 01048.01051> [PASSED] (0 ms) [1.399] 01048.01051> map_specific_overwrite_test [RUNNING] [1.399] 01048.01051> [PASSED] (0 ms) [1.501] 01048.01051> protect_split_test [RUNNING] [1.501] 01048.01051> [PASSED] (0 ms) [1.501] 01048.01051> protect_multiple_test [RUNNING] [1.501] 01048.01051> [PASSED] (0 ms) [1.501] 01048.01051> protect_over_demand_paged_test [RUNNING] [1.523] 01048.01051> [PASSED] (21 ms) [1.523] 01048.01051> protect_large_uncommitted_test [RUNNING] [1.523] 01048.01310> PageFault: 1021398 free pages [1.523] 01048.01310> PageFault: MemoryUsed: proc 1034 18M 'userboot' [1.524] 01048.01310> PageFault: MemoryUsed: proc 1048 10M 'bin/core-tests' [1.544] 01048.01051> [PASSED] (20 ms) [1.544] 01048.01051> unmap_large_uncommitted_test [RUNNING] [1.544] 01048.01319> PageFault: 1021395 free pages [1.544] 01048.01319> PageFault: MemoryUsed: proc 1034 18M 'userboot' [1.544] 01048.01319> PageFault: MemoryUsed: proc 1048 10M 'bin/core-tests' [1.563] 01048.01321> PageFault: 1021394 free pages [1.563] 01048.01321> PageFault: MemoryUsed: proc 1034 18M 'userboot' [1.563] 01048.01321> PageFault: MemoryUsed: proc 1048 10M 'bin/core-tests' [1.566] 01048.01323> PageFault: 1021394 free pages [1.566] 01048.01323> PageFault: MemoryUsed: proc 1034 18M 'userboot' [1.566] 01048.01323> PageFault: MemoryUsed: proc 1048 10M 'bin/core-tests' [1.570] 01048.01325> PageFault: 1021394 free pages [1.570] 01048.01325> PageFault: MemoryUsed: proc 1034 18M 'userboot' [1.570] 01048.01325> PageFault: MemoryUsed: proc 1048 10M 'bin/core-tests' [1.575] 01048.01051> [PASSED] (30 ms) [1.575] 01048.01051> partial_unmap_and_read [RUNNING] [1.575] 01048.01051> [PASSED] (0 ms) [1.575] 01048.01051> partial_unmap_and_write [RUNNING] [1.575] 01048.01051> [PASSED] (0 ms) [1.575] 01048.01051> partial_unmap_with_vmar_offset [RUNNING] [1.575] 01048.01051> [PASSED] (0 ms) [1.575] 01048.01051> CASE vmar_tests [PASSED] CASE ticks_tests [STARTED] [1.575] 01048.01051> elapsed_time_using_ticks [RUNNING] [1.575] 01048.01051> [PASSED] (0 ms) [1.575] 01048.01051> CASE ticks_tests [PASSED] CASE threads_tests [STARTED] [1.575] 01048.01051> TestBasics [RUNNING] [1.676] 01048.01051> [PASSED] (100 ms) [1.676] 01048.01051> TestInvalidRights [RUNNING] [1.676] 01048.01051> [PASSED] (0 ms) [1.676] 01048.01051> TestDetach [RUNNING] [1.676] 01048.01051> [PASSED] (0 ms) [1.676] 01048.01051> TestLongNameSucceeds [RUNNING] [1.679] 01048.01051> [PASSED] (2 ms) [1.679] 01048.01051> TestThreadStartOnInitialThread [RUNNING] [1.683] 01048.01051> [PASSED] (4 ms) [1.683] 01048.01051> TestThreadStartWithZeroInstructionPointer [RUNNING] [1.712] 01048.01051> [PASSED] (28 ms) [1.712] 01048.01051> TestKillBusyThread [RUNNING] [1.813] 01048.01051> [PASSED] (100 ms) [1.813] 01048.01051> TestKillSleepThread [RUNNING] [1.914] 01048.01051> [PASSED] (100 ms) [1.914] 01048.01051> TestKillWaitThread [RUNNING] [2.015] 01048.01051> [PASSED] (100 ms) [2.015] 01048.01051> TestNonstartedThread [RUNNING] [2.015] 01048.01051> [PASSED] (0 ms) [2.015] 01048.01051> TestThreadKillsItself [RUNNING] [2.029] 01048.01051> [PASSED] (14 ms) [2.029] 01048.01051> TestInfoTaskStatsFails [RUNNING] [2.130] 01048.01051> [PASSED] (100 ms) [2.130] 01048.01051> TestResumeSuspended [RUNNING] [2.239] 01048.01051> [PASSED] (108 ms) [2.239] 01048.01051> TestSuspendSleeping [RUNNING] [2.340] 01048.01051> [PASSED] (100 ms) [2.340] 01048.01051> TestSuspendChannelCall [RUNNING] [2.342] 01048.01051> [PASSED] (2 ms) [2.342] 01048.01051> TestSuspendPortCall [RUNNING] [2.544] 01048.01051> [PASSED] (201 ms) [2.544] 01048.01051> TestSuspendStopsThread [RUNNING] [2.595] 01048.01051> [PASSED] (50 ms) [2.595] 01048.01051> TestSuspendMultiple [RUNNING] [2.596] 01048.01051> [PASSED] (1 ms) [2.596] 01048.01051> TestSuspendSelf [RUNNING] [2.596] 01048.01051> [PASSED] (0 ms) [2.596] 01048.01051> TestKillSuspendedThread [RUNNING] [2.597] 01048.01051> [PASSED] (0 ms) [2.597] 01048.01051> TestStartSuspendedThread [RUNNING] [2.625] 01048.01051> [PASSED] (28 ms) [2.625] 01048.01051> TestStartSuspendedAndResumedThread [RUNNING] [2.626] 01048.01051> [PASSED] (0 ms) [2.626] 01048.01051> TestSuspendSingleWaitAsyncSignalDelivery [RUNNING] [2.642] 01048.01051> [PASSED] (16 ms) [2.642] 01048.01051> TestSuspendRepeatingWaitAsyncSignalDelivery [RUNNING] [2.650] 01048.01051> [PASSED] (8 ms) [2.650] 01048.01051> TestReadingGeneralRegisterState [RUNNING] [2.751] 01048.01051> [PASSED] (100 ms) [2.751] 01048.01051> TestWritingGeneralRegisterState [RUNNING] [2.852] 01048.01051> [PASSED] (100 ms) [2.852] 01048.01051> TestNoncanonicalRipAddress [RUNNING] [2.953] 01048.01051> [PASSED] (101 ms) [2.953] 01048.01051> TestWritingArmFlagsRegister [RUNNING] [2.953] 01048.01051> [PASSED] (0 ms) [2.953] 01048.01051> CASE threads_tests [PASSED] CASE sync_mutex_tests [STARTED] [2.953] 01048.01051> test_mutexes [RUNNING] [3.036] 01048.01051> [PASSED] (82 ms) [3.036] 01048.01051> test_try_mutexes [RUNNING] [3.115] 01048.01051> [PASSED] (78 ms) [3.115] 01048.01051> test_timeout_elapsed [RUNNING] [3.617] 01048.01051> [PASSED] (501 ms) [3.617] 01048.01051> CASE sync_mutex_tests [PASSED] CASE sync_condition_tests [STARTED] [3.617] 01048.01051> Condition::condition_test [RUNNING] [3.639] 01048.01051> [PASSED] (21 ms) [3.639] 01048.01051> Condition::condition_timeout_test [RUNNING] [3.646] 01048.01051> [PASSED] (7 ms) [3.646] 01048.01051> CASE sync_condition_tests [PASSED] CASE sync_completion_tests [STARTED] [3.646] 01048.01051> test_initializer [RUNNING] [3.646] 01048.01051> [PASSED] (0 ms) [3.646] 01048.01051> test_completions [RUNNING] [3.707] 01048.01051> [PASSED] (61 ms) [3.707] 01048.01051> test_timeout [RUNNING] [3.708] 01048.01051> [PASSED] (0 ms) [3.708] 01048.01051> CASE sync_completion_tests [PASSED] CASE sync_completion_tests [STARTED] [3.708] 01048.01051> test_initializer [RUNNING] [3.708] 01048.01051> [PASSED] (0 ms) [3.708] 01048.01051> test_completions [RUNNING] [3.782] 01048.01051> [PASSED] (74 ms) [3.782] 01048.01051> test_timeout [RUNNING] [4.892] 01048.01051> [PASSED] (1109 ms) [4.892] 01048.01051> test_signal_requeue [RUNNING] [4.932] 01048.01051> [PASSED] (40 ms) [4.932] 01048.01051> test_completion_signaled [RUNNING] [4.932] 01048.01051> [PASSED] (0 ms) [4.932] 01048.01051> CASE sync_completion_tests [PASSED] CASE stack_tests [STARTED] [4.932] 01048.01051> main_thread_stack_tests [RUNNING] [4.932] 01048.01051> [PASSED] (0 ms) [4.932] 01048.01051> other_thread_stack_tests [RUNNING] [4.933] 01048.01051> [PASSED] (0 ms) [4.933] 01048.01051> CASE stack_tests [PASSED] CASE socket_tests [STARTED] [4.933] 01048.01051> socket_basic [RUNNING] [4.933] 01048.01051> [PASSED] (0 ms) [4.933] 01048.01051> socket_peek [RUNNING] [4.933] 01048.01051> [PASSED] (0 ms) [4.933] 01048.01051> socket_peek_empty [RUNNING] [4.933] 01048.01051> [PASSED] (0 ms) [4.933] 01048.01051> socket_signals [RUNNING] [4.933] 01048.01051> [PASSED] (0 ms) [4.933] 01048.01051> socket_peer_closed_signal [RUNNING] [4.933] 01048.01051> [PASSED] (0 ms) [4.933] 01048.01051> socket_peer_closed_set_property [RUNNING] [4.933] 01048.01051> [PASSED] (0 ms) [4.933] 01048.01051> socket_shutdown_write [RUNNING] [4.933] 01048.01051> [PASSED] (0 ms) [4.933] 01048.01051> socket_shutdown_read [RUNNING] [4.933] 01048.01051> [PASSED] (0 ms) [4.933] 01048.01051> socket_bytes_outstanding [RUNNING] [4.933] 01048.01051> [PASSED] (0 ms) [4.933] 01048.01051> socket_bytes_outstanding_shutdown_write [RUNNING] [4.933] 01048.01051> [PASSED] (0 ms) [4.933] 01048.01051> socket_bytes_outstanding_shutdown_read [RUNNING] [4.933] 01048.01051> [PASSED] (0 ms) [4.933] 01048.01051> socket_short_write [RUNNING] [4.934] 01048.01051> [PASSED] (0 ms) [4.934] 01048.01051> socket_datagram [RUNNING] [4.934] 01048.01051> [PASSED] (0 ms) [4.934] 01048.01051> socket_datagram_peek [RUNNING] [4.934] 01048.01051> [PASSED] (0 ms) [4.934] 01048.01051> socket_datagram_peek_empty [RUNNING] [4.934] 01048.01051> [PASSED] (0 ms) [4.934] 01048.01051> socket_datagram_no_short_write [RUNNING] [4.934] 01048.01051> [PASSED] (0 ms) [4.934] 01048.01051> socket_control_plane_absent [RUNNING] [4.934] 01048.01051> [PASSED] (0 ms) [4.934] 01048.01051> socket_control_plane [RUNNING] [4.935] 01048.01051> [PASSED] (0 ms) [4.935] 01048.01051> socket_control_plane_peek [RUNNING] [4.935] 01048.01051> [PASSED] (0 ms) [4.935] 01048.01051> socket_control_plane_peek_empty [RUNNING] [4.935] 01048.01051> [PASSED] (0 ms) [4.935] 01048.01051> socket_control_plane_shutdown [RUNNING] [4.935] 01048.01051> [PASSED] (0 ms) [4.935] 01048.01051> socket_accept [RUNNING] [4.935] 01048.01051> [PASSED] (0 ms) [4.935] 01048.01051> socket_share_invalid_handle [RUNNING] [4.935] 01048.01051> [PASSED] (0 ms) [4.935] 01048.01051> socket_share_consumes_on_failure [RUNNING] [4.935] 01048.01051> [PASSED] (0 ms) [4.935] 01048.01051> socket_signals2 [RUNNING] [4.935] 01048.01051> [PASSED] (0 ms) [4.936] 01048.01051> CASE socket_tests [PASSED] CASE tls_tests [STARTED] [4.936] 01048.01051> tls_test [RUNNING] [7.183] 01048.01051> [PASSED] (2247 ms) [7.183] 01048.01051> CASE tls_tests [PASSED] CASE pthread_barrier_tests [STARTED] [7.183] 01048.01051> test_barrier [RUNNING] [7.413] 01048.01051> [PASSED] (229 ms) [7.413] 01048.01051> CASE pthread_barrier_tests [PASSED] CASE pthread_tests [STARTED] [7.413] 01048.01051> pthread_test [RUNNING] [10.537] 01048.01051> [PASSED] (3123 ms) [10.537] 01048.01051> pthread_self_main_thread_test [RUNNING] [10.537] 01048.01051> [PASSED] (0 ms) [10.537] 01048.01051> pthread_big_stack_size [RUNNING] [10.562] 01048.01051> [PASSED] (24 ms) [10.562] 01048.01051> pthread_getstack_main_thread [RUNNING] [10.562] 01048.01051> [PASSED] (0 ms) [10.562] 01048.01051> pthread_getstack_other_thread [RUNNING] [10.563] 01048.01051> [PASSED] (0 ms) [10.563] 01048.01051> CASE pthread_tests [PASSED] CASE process_tests [STARTED] [10.563] 01048.01051> mini_process_sanity [RUNNING] [10.595] 01048.01051> [PASSED] (32 ms) [10.595] 01048.01051> process_start_fail [RUNNING] [10.598] 01048.01051> [PASSED] (2 ms) [10.598] 01048.01051> process_not_killed_via_thread_close [RUNNING] [10.611] 01048.01051> [PASSED] (13 ms) [10.611] 01048.01051> process_not_killed_via_process_close [RUNNING] [10.613] 01048.01051> [PASSED] (1 ms) [10.613] 01048.01051> kill_process_via_thread_kill [RUNNING] [10.614] 01048.01051> [PASSED] (1 ms) [10.614] 01048.01051> kill_process_via_vmar_destroy [RUNNING] [10.633] 02308.02310> PageFault: 1018665 free pages [10.634] 02308.02310> PageFault: MemoryUsed: proc 1034 18M 'userboot' [10.634] 02308.02310> PageFault: MemoryUsed: proc 1048 18M 'bin/core-tests' [10.646] 01048.01051> [PASSED] (31 ms) [10.646] 01048.01051> kill_channel_handle_cycle [RUNNING] [11.398] 01048.01051> [PASSED] (751 ms) [11.398] 01048.01051> info_reflects_process_state [RUNNING] [11.656] 01048.01051> [PASSED] (258 ms) [11.656] 01048.01051> suspend [RUNNING] [11.656] 01048.01051> [PASSED] (0 ms) [11.657] 01048.01051> suspend_self [RUNNING] [11.657] 01048.01051> [PASSED] (0 ms) [11.657] 01048.01051> suspend_multiple_threads [RUNNING] [11.670] 01048.01051> [PASSED] (12 ms) [11.670] 01048.01051> suspend_before_creating_threads [RUNNING] [11.673] 01048.01051> [PASSED] (2 ms) [11.673] 01048.01051> suspend_before_starting_threads [RUNNING] [11.677] 01048.01051> [PASSED] (4 ms) [11.677] 01048.01051> suspend_process_then_thread [RUNNING] [11.930] 01048.01051> [PASSED] (252 ms) [11.930] 01048.01051> suspend_thread_then_process [RUNNING] [12.181] 01048.01051> [PASSED] (251 ms) [12.181] 01048.01051> suspend_thread_and_process_before_starting_process [RUNNING] [12.432] 01048.01051> [PASSED] (251 ms) [12.432] 01048.01051> suspend_twice [RUNNING] [12.683] 01048.01051> [PASSED] (251 ms) [12.683] 01048.01051> suspend_twice_before_creating_threads [RUNNING] [12.934] 01048.01051> [PASSED] (251 ms) [12.934] 01048.01051> suspend_with_dying_thread [RUNNING] [12.943] 01048.01051> [PASSED] (8 ms) [12.943] 01048.01051> CASE process_tests [PASSED] CASE port_tests [STARTED] [12.943] 01048.01051> basic_test [RUNNING] [12.943] 01048.01051> [PASSED] (0 ms) [12.943] 01048.01051> queue_and_close_test [RUNNING] [12.943] 01048.01051> [PASSED] (0 ms) [12.943] 01048.01051> queue_too_many [RUNNING] [12.944] 01048.01051> [PASSED] (0 ms) [12.944] 01048.01051> async_wait_channel_test [RUNNING] [12.946] 01048.01051> [PASSED] (2 ms) [12.946] 01048.01051> async_wait_event_test_single [RUNNING] [12.946] 01048.01051> [PASSED] (0 ms) [12.946] 01048.01051> async_wait_event_test_repeat [RUNNING] [12.946] 01048.01051> [PASSED] (0 ms) [12.946] 01048.01051> async_wait_invalid_option [RUNNING] [12.946] 01048.01051> [PASSED] (0 ms) [12.946] 01048.01051> async_wait_close_order_1 [RUNNING] [12.946] 01048.01051> [PASSED] (0 ms) [12.946] 01048.01051> async_wait_close_order_2 [RUNNING] [12.946] 01048.01051> [PASSED] (0 ms) [12.946] 01048.01051> async_wait_close_order_3 [RUNNING] [12.946] 01048.01051> [PASSED] (0 ms) [12.946] 01048.01051> async_wait_close_order_4 [RUNNING] [12.946] 01048.01051> [PASSED] (0 ms) [12.946] 01048.01051> async_wait_close_order_5 [RUNNING] [12.946] 01048.01051> [PASSED] (0 ms) [12.946] 01048.01051> async_wait_close_order_6 [RUNNING] [12.946] 01048.01051> [PASSED] (0 ms) [12.946] 01048.01051> channel_pre_writes_test [RUNNING] [12.946] 01048.01051> [PASSED] (0 ms) [12.946] 01048.01051> cancel_event_key [RUNNING] [12.946] 01048.01051> [PASSED] (0 ms) [12.946] 01048.01051> cancel_event_key_after [RUNNING] [12.947] 01048.01051> [PASSED] (0 ms) [12.947] 01048.01051> threads_event [RUNNING] [12.955] 01048.01051> [PASSED] (8 ms) [12.955] 01048.01051> cancel_stress [RUNNING] [16.263] 01048.01051> [PASSED] (3307 ms) [16.263] 01048.01051> CASE port_tests [PASSED] CASE api_violations [STARTED] [16.263] 01048.01051> invalid_pager_create [RUNNING] [16.263] 01048.01051> [PASSED] (0 ms) [16.263] 01048.01051> invalid_pager_create_vmo [RUNNING] [16.264] 01048.01051> [PASSED] (0 ms) [16.264] 01048.01051> invalid_pager_detach_vmo [RUNNING] [16.264] 01048.01051> [PASSED] (0 ms) [16.264] 01048.01051> invalid_pager_supply_pages [RUNNING] [16.264] 01048.01051> [PASSED] (0 ms) [16.264] 01048.01051> resize_nonresizable_vmo [RUNNING] [16.264] 01048.01051> [PASSED] (0 ms) [16.264] 01048.01051> CASE api_violations [PASSED] CASE commit_tests [STARTED] [16.264] 01048.01051> simple_commit_test [RUNNING] [16.327] 01048.01051> [PASSED] (63 ms) [16.327] 01048.01051> split_commit_test [RUNNING] [16.330] 01048.01051> [PASSED] (2 ms) [16.330] 01048.01051> overlap_commit_test [RUNNING] [16.344] 01048.01051> [PASSED] (14 ms) [16.344] 01048.01051> overlap_commit_supply_test [RUNNING] [16.401] 01048.01051> [PASSED] (56 ms) [16.401] 01048.01051> multisupply_commit_test [RUNNING] [16.409] 01048.01051> [PASSED] (7 ms) [16.409] 01048.01051> multicommit_supply_test [RUNNING] [16.422] 01048.01051> [PASSED] (13 ms) [16.422] 01048.01051> commit_redundant_supply_test [RUNNING] [16.430] 01048.01051> [PASSED] (7 ms) [16.430] 01048.01051> supply_decommit_test [RUNNING] [16.438] 01048.01051> [PASSED] (7 ms) [16.438] 01048.01051> resize_commit_test [RUNNING] [16.446] 01048.01051> [PASSED] (7 ms) [16.446] 01048.01051> suspend_commit_test [RUNNING] [16.454] 01048.01051> [PASSED] (7 ms) [16.454] 01048.01051> CASE commit_tests [PASSED] CASE clone_tests [STARTED] [16.454] 01048.01051> clone_read_from_clone_test_vmar [RUNNING] [16.471] 01048.01051> [PASSED] (17 ms) [16.471] 01048.01051> clone_read_from_clone_test_vmo [RUNNING] [16.478] 01048.01051> [PASSED] (7 ms) [16.479] 01048.01051> clone_read_from_parent_test_vmar [RUNNING] [16.487] 01048.01051> [PASSED] (8 ms) [16.487] 01048.01051> clone_read_from_parent_test_vmo [RUNNING] [16.500] 01048.01051> [PASSED] (12 ms) [16.500] 01048.01051> clone_simultaneous_read_test_vmar [RUNNING] [16.512] 01048.01051> [PASSED] (11 ms) [16.512] 01048.01051> clone_simultaneous_read_test_vmo [RUNNING] [16.522] 01048.01051> [PASSED] (10 ms) [16.522] 01048.01051> clone_simultaneous_child_read_test_vmar [RUNNING] [16.533] 01048.01051> [PASSED] (10 ms) [16.533] 01048.01051> clone_simultaneous_child_read_test_vmo [RUNNING] [16.542] 01048.01051> [PASSED] (9 ms) [16.542] 01048.01051> clone_write_to_clone_test [RUNNING] [16.545] 01048.01051> [PASSED] (2 ms) [16.545] 01048.01051> clone_detach_test [RUNNING] [16.550] 01048.01051> [PASSED] (4 ms) [16.550] 01048.01051> clone_commit_test [RUNNING] [16.565] 01048.01051> [PASSED] (15 ms) [16.565] 01048.01051> clone_split_commit_test [RUNNING] [16.568] 01048.01051> [PASSED] (2 ms) [16.568] 01048.01051> clone_decommit_test [RUNNING] [16.568] 01048.01051> [PASSED] (0 ms) [16.568] 01048.01051> CASE clone_tests [PASSED] CASE lifecycle_tests [STARTED] [16.568] 01048.01051> vmo_info_pager_test [RUNNING] [16.568] 01048.01051> [PASSED] (0 ms) [16.568] 01048.01051> detach_page_complete_test [RUNNING] [16.568] 01048.01051> [PASSED] (0 ms) [16.568] 01048.01051> close_page_complete_test [RUNNING] [16.568] 01048.01051> [PASSED] (0 ms) [16.568] 01048.01051> read_detach_interrupt_late_test_vmar [RUNNING] [16.619] 01048.03218> PageFault: 1017441 free pages [16.619] 01048.03218> PageFault: MemoryUsed: proc 1034 18M 'userboot' [16.620] 01048.03218> PageFault: MemoryUsed: proc 1048 21M 'bin/core-tests' [16.623] 01048.01051> [PASSED] (54 ms) [16.623] 01048.01051> read_detach_interrupt_late_test_vmo [RUNNING] [16.627] 01048.01051> [PASSED] (4 ms) [16.627] 01048.01051> read_close_interrupt_late_test_vmar [RUNNING] [16.647] 01048.03239> PageFault: 1017411 free pages [16.647] 01048.03239> PageFault: MemoryUsed: proc 1034 18M 'userboot' [16.647] 01048.03239> PageFault: MemoryUsed: proc 1048 21M 'bin/core-tests' [16.651] 01048.01051> [PASSED] (23 ms) [16.651] 01048.01051> read_close_interrupt_late_test_vmo [RUNNING] [16.655] 01048.01051> [PASSED] (4 ms) [16.655] 01048.01051> read_detach_interrupt_early_test_vmar [RUNNING] [16.675] 01048.03260> PageFault: 1017382 free pages [16.675] 01048.03260> PageFault: MemoryUsed: proc 1034 18M 'userboot' [16.675] 01048.03260> PageFault: MemoryUsed: proc 1048 21M 'bin/core-tests' [16.678] 01048.01051> [PASSED] (22 ms) [16.678] 01048.01051> read_detach_interrupt_early_test_vmo [RUNNING] [16.682] 01048.01051> [PASSED] (4 ms) [16.682] 01048.01051> read_close_interrupt_early_test_vmar [RUNNING] [16.702] 01048.03281> PageFault: 1017351 free pages [16.702] 01048.03281> PageFault: MemoryUsed: proc 1034 18M 'userboot' [16.702] 01048.03281> PageFault: MemoryUsed: proc 1048 21M 'bin/core-tests' [16.705] 01048.01051> [PASSED] (23 ms) [16.705] 01048.01051> read_close_interrupt_early_test_vmo [RUNNING] [16.709] 01048.01051> [PASSED] (4 ms) [16.709] 01048.01051> thread_kill_test_vmar [RUNNING] [16.730] 01048.01051> [PASSED] (20 ms) [16.730] 01048.01051> thread_kill_test_vmo [RUNNING] [16.738] 01048.01051> [PASSED] (7 ms) [16.738] 01048.01051> thread_kill_overlap_test_vmar [RUNNING] [16.741] 01048.01051> [PASSED] (2 ms) [16.741] 01048.01051> thread_kill_overlap_test_vmo [RUNNING] [16.754] 01048.01051> [PASSED] (13 ms) [16.754] 01048.01051> close_pager_test [RUNNING] [16.755] 01048.03379> PageFault: 1017138 free pages [16.755] 01048.03379> PageFault: MemoryUsed: proc 1034 18M 'userboot' [16.755] 01048.03379> PageFault: MemoryUsed: proc 1048 22M 'bin/core-tests' [16.774] 01048.01051> [PASSED] (19 ms) [16.774] 01048.01051> detach_close_pager_test [RUNNING] [16.774] 01048.01051> [PASSED] (0 ms) [16.774] 01048.01051> close_port_test [RUNNING] [16.775] 01048.03392> PageFault: 1017120 free pages [16.775] 01048.03392> PageFault: MemoryUsed: proc 1034 18M 'userboot' [16.775] 01048.03392> PageFault: MemoryUsed: proc 1048 22M 'bin/core-tests' [16.777] 01048.01051> [PASSED] (2 ms) [16.777] 01048.01051> CASE lifecycle_tests [PASSED] CASE pager_read_tests [STARTED] [16.777] 01048.01051> single_page_test_vmar [RUNNING] [16.782] 01048.01051> [PASSED] (4 ms) [16.782] 01048.01051> single_page_test_vmo [RUNNING] [16.784] 01048.01051> [PASSED] (2 ms) [16.784] 01048.01051> presupply_test_vmar [RUNNING] [16.789] 01048.01051> [PASSED] (4 ms) [16.789] 01048.01051> presupply_test_vmo [RUNNING] [16.792] 01048.01051> [PASSED] (3 ms) [16.792] 01048.01051> early_supply_test_vmar [RUNNING] [16.801] 01048.01051> [PASSED] (8 ms) [16.801] 01048.01051> early_supply_test_vmo [RUNNING] [16.808] 01048.01051> [PASSED] (7 ms) [16.808] 01048.01051> sequential_multipage_test_vmar [RUNNING] [16.813] 01048.01051> [PASSED] (5 ms) [16.813] 01048.01051> sequential_multipage_test_vmo [RUNNING] [16.820] 01048.01051> [PASSED] (7 ms) [16.820] 01048.01051> concurrent_multipage_access_test_vmar [RUNNING] [16.877] 01048.01051> [PASSED] (56 ms) [16.877] 01048.01051> concurrent_multipage_access_test_vmo [RUNNING] [16.887] 01048.01051> [PASSED] (9 ms) [16.887] 01048.01051> concurrent_overlapping_access_test_vmar [RUNNING] [16.941] 01048.01051> [PASSED] (54 ms) [16.941] 01048.01051> concurrent_overlapping_access_test_vmo [RUNNING] [17.000] 01048.01051> [PASSED] (58 ms) [17.000] 01048.01051> bulk_single_supply_test_vmar [RUNNING] [17.019] 01048.01051> [PASSED] (19 ms) [17.019] 01048.01051> bulk_single_supply_test_vmo [RUNNING] [17.038] 01048.01051> [PASSED] (18 ms) [17.038] 01048.01051> bulk_odd_length_supply_test_vmar [RUNNING] [17.174] 01048.01051> [PASSED] (135 ms) [17.174] 01048.01051> bulk_odd_length_supply_test_vmo [RUNNING] [17.322] 01048.01051> [PASSED] (147 ms) [17.322] 01048.01051> bulk_odd_offset_supply_test_vmar [RUNNING] [17.462] 01048.01051> [PASSED] (140 ms) [17.462] 01048.01051> bulk_odd_offset_supply_test_vmo [RUNNING] [17.620] 01048.01051> [PASSED] (157 ms) [17.620] 01048.01051> overlap_supply_test_vmar [RUNNING] [17.622] 01048.01051> [PASSED] (2 ms) [17.622] 01048.01051> overlap_supply_test_vmo [RUNNING] [17.627] 01048.01051> [PASSED] (4 ms) [17.627] 01048.01051> many_request_test_vmar [RUNNING] [17.815] 01048.01051> [PASSED] (188 ms) [17.815] 01048.01051> many_request_test_vmo [RUNNING] [18.014] 01048.01051> [PASSED] (198 ms) [18.014] 01048.01051> successive_vmo_test [RUNNING] [18.062] 01048.01051> [PASSED] (48 ms) [18.063] 01048.01051> multiple_concurrent_vmo_test [RUNNING] [18.070] 01048.01051> [PASSED] (7 ms) [18.071] 01048.01051> vmar_unmap_test [RUNNING] [18.071] 01048.12222> PageFault: 1001742 free pages [18.071] 01048.12222> PageFault: MemoryUsed: proc 1034 18M 'userboot' [18.072] 01048.12222> PageFault: MemoryUsed: proc 1048 59M 'bin/core-tests' [18.073] 01048.01051> [PASSED] (2 ms) [18.073] 01048.01051> vmar_remap_test [RUNNING] [18.096] 01048.01051> [PASSED] (22 ms) [18.096] 01048.01051> vmar_map_range_test [RUNNING] [18.098] 01048.01051> [PASSED] (2 ms) [18.098] 01048.01051> read_resize_test_vmar [RUNNING] [18.103] 01048.01051> [PASSED] (4 ms) [18.103] 01048.01051> read_resize_test_vmo [RUNNING] [18.105] 01048.01051> [PASSED] (2 ms) [18.105] 01048.01051> suspend_read_test_vmar [RUNNING] [18.109] 01048.01051> [PASSED] (4 ms) [18.110] 01048.01051> suspend_read_test_vmo [RUNNING] [18.112] 01048.01051> [PASSED] (2 ms) [18.112] 01048.01051> CASE pager_read_tests [PASSED] CASE object_info_tests [STARTED] [18.112] 01048.01051> handle_valid_on_valid_handle_succeeds [RUNNING] [18.112] 01048.01051> [PASSED] (0 ms) [18.112] 01048.01051> handle_valid_on_closed_handle_fails [RUNNING] [18.112] 01048.01051> [PASSED] (0 ms) [18.112] 01048.01051> (invalid_handle_fails<ZX_INFO_HANDLE_VALID, void*>) [RUNNING] [18.112] 01048.01051> [PASSED] (0 ms) [18.112] 01048.01051> task_stats_unstarted [RUNNING] [18.112] 01048.01051> [PASSED] (0 ms) [18.112] 01048.01051> task_stats_smoke [RUNNING] [18.113] 01048.01051> [PASSED] (0 ms) [18.113] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t>) [RUNNING] [18.113] 01048.01051> [PASSED] (0 ms) [18.113] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING] [18.113] 01048.01051> [PASSED] (0 ms) [18.113] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING] [18.113] 01048.01051> [PASSED] (0 ms) [18.113] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING] [18.113] 01048.01051> [PASSED] (0 ms) [18.113] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING] [18.113] 01048.01051> [PASSED] (0 ms) [18.113] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING] [18.114] 01048.01051> [PASSED] (0 ms) [18.114] 01048.01051> (wrong_handle_type_fails<ZX_INFO_TASK_STATS, zx_info_task_stats_t, get_test_job>) [RUNNING] [18.114] 01048.01051> [PASSED] (0 ms) [18.114] 01048.01051> (wrong_handle_type_fails<ZX_INFO_TASK_STATS, zx_info_task_stats_t, zx_thread_self>) [RUNNING] [18.114] 01048.01051> [PASSED] (0 ms) [18.114] 01048.01051> process_maps_unstarted [RUNNING] [18.114] 01048.01051> [PASSED] (0 ms) [18.114] 01048.01051> process_maps_smoke [RUNNING] [18.114] 01048.01051> [PASSED] (0 ms) [18.114] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t>) [RUNNING] [18.114] 01048.01051> [PASSED] (0 ms) [18.114] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING] [18.114] 01048.01051> [PASSED] (0 ms) [18.114] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING] [18.114] 01048.01051> [PASSED] (0 ms) [18.114] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING] [18.114] 01048.01051> [PASSED] (0 ms) [18.114] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING] [18.114] 01048.01051> [PASSED] (0 ms) [18.114] 01048.01051> (multi_zero_buffer_succeeds<((zx_object_info_topic_t) 13u), get_test_process>) [RUNNING] [18.114] 01048.01051> [PASSED] (0 ms) [18.114] 01048.01051> (short_buffer_succeeds<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING] [18.114] 01048.01051> [PASSED] (0 ms) [18.114] 01048.01051> (partially_unmapped_buffer_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING] [18.114] 01048.01051> [PASSED] (0 ms) [18.114] 01048.01051> (self_fails<ZX_INFO_PROCESS_MAPS, zx_info_maps_t>) [RUNNING] [18.114] 01048.01051> [PASSED] (0 ms) [18.114] 01048.01051> (wrong_handle_type_fails<ZX_INFO_PROCESS_MAPS, zx_info_maps_t, get_test_job>) [RUNNING] [18.114] 01048.01051> [PASSED] (0 ms) [18.114] 01048.01051> (wrong_handle_type_fails<ZX_INFO_PROCESS_MAPS, zx_info_maps_t, zx_thread_self>) [RUNNING] [18.114] 01048.01051> [PASSED] (0 ms) [18.114] 01048.01051> (missing_rights_fails<ZX_INFO_PROCESS_MAPS, zx_info_maps_t, get_test_process, ZX_RIGHT_INSPECT>) [RUNNING] [18.114] 01048.01051> [PASSED] (0 ms) [18.114] 01048.01051> process_vmos_smoke [RUNNING] [18.114] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (multi_zero_buffer_succeeds<((zx_object_info_topic_t) 14u), get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (short_buffer_succeeds<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (partially_unmapped_buffer_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (self_fails<ZX_INFO_PROCESS_VMOS, zx_info_vmo_t>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (wrong_handle_type_fails<ZX_INFO_PROCESS_VMOS, zx_info_vmo_t, get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (wrong_handle_type_fails<ZX_INFO_PROCESS_VMOS, zx_info_vmo_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (missing_rights_fails<ZX_INFO_PROCESS_VMOS, zx_info_vmo_t, get_test_process, ZX_RIGHT_INSPECT>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> job_processes_smoke [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 9u), zx_koid_t>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (multi_zero_buffer_succeeds<((zx_object_info_topic_t) 9u), get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (short_buffer_succeeds<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (partially_unmapped_buffer_fails<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (wrong_handle_type_fails<ZX_INFO_JOB_PROCESSES, zx_koid_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (wrong_handle_type_fails<ZX_INFO_JOB_PROCESSES, zx_koid_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (missing_rights_fails<ZX_INFO_JOB_PROCESSES, zx_koid_t, get_test_job, ZX_RIGHT_ENUMERATE>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> job_children_smoke [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 8u), zx_koid_t>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (multi_zero_buffer_succeeds<((zx_object_info_topic_t) 8u), get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (short_buffer_succeeds<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (partially_unmapped_buffer_fails<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (wrong_handle_type_fails<ZX_INFO_JOB_CHILDREN, zx_koid_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (wrong_handle_type_fails<ZX_INFO_JOB_CHILDREN, zx_koid_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (missing_rights_fails<ZX_INFO_JOB_CHILDREN, zx_koid_t, get_test_job, ZX_RIGHT_ENUMERATE>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 3u), zx_info_process_t>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (wrong_handle_type_fails<ZX_INFO_PROCESS, zx_info_process_t, get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (wrong_handle_type_fails<ZX_INFO_PROCESS, zx_info_process_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (wrong_handle_type_fails<ZX_INFO_VMAR, zx_info_vmar_t, get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (wrong_handle_type_fails<ZX_INFO_VMAR, zx_info_vmar_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (wrong_handle_type_fails<ZX_INFO_VMAR, zx_info_vmar_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (wrong_handle_type_fails<ZX_INFO_THREAD, zx_info_thread_t, get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (wrong_handle_type_fails<ZX_INFO_THREAD, zx_info_thread_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (wrong_handle_type_fails<ZX_INFO_THREAD_STATS, zx_info_thread_t, get_test_job>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (wrong_handle_type_fails<ZX_INFO_THREAD_STATS, zx_info_thread_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (invalid_handle_fails<ZX_INFO_PROCESS_THREADS, zx_koid_t>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (null_avail_actual_succeeds<ZX_INFO_PROCESS_THREADS, zx_koid_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_buffer_fails<ZX_INFO_PROCESS_THREADS, zx_koid_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_actual_fails<ZX_INFO_PROCESS_THREADS, zx_koid_t, get_test_process>) [RUNNING] [18.115] 01048.01051> [PASSED] (0 ms) [18.115] 01048.01051> (bad_avail_fails<ZX_INFO_PROCESS_THREADS, zx_koid_t, get_test_process>) [RUNNING] [18.116] 01048.01051> [PASSED] (0 ms) [18.116] 01048.01051> (multi_zero_buffer_succeeds<ZX_INFO_PROCESS_THREADS, get_test_process>) [RUNNING] [18.116] 01048.01051> [PASSED] (0 ms) [18.116] 01048.01051> (invalid_handle_fails<ZX_INFO_THREAD_EXCEPTION_REPORT, zx_exception_report_t>) [RUNNING] [18.116] 01048.01051> [PASSED] (0 ms) [18.116] 01048.01051> handle_count_valid [RUNNING] [18.116] 01048.01051> [PASSED] (0 ms) [18.116] 01048.01051> handle_stats_control [RUNNING] [18.116] 01048.01051> [PASSED] (0 ms) [18.116] 01048.01051> CASE object_info_tests [PASSED] CASE object_get_child_tests [STARTED] [18.116] 01048.01051> handle_invalid [RUNNING] [18.116] 01048.01051> [PASSED] (0 ms) [18.116] 01048.01051> CASE object_get_child_tests [PASSED] CASE memory_mapping_tests [STARTED] [18.116] 01048.01051> address_space_limits_test [RUNNING] [18.116] 01048.01051> [PASSED] (0 ms) [18.116] 01048.01051> mmap_zerofilled_test [RUNNING] [18.116] 01048.01051> [PASSED] (0 ms) [18.116] 01048.01051> mmap_len_test [RUNNING] [18.116] 01048.01051> [PASSED] (0 ms) [18.116] 01048.01051> mmap_PROT_EXEC_test [RUNNING] [18.116] 01048.01051> [PASSED] (0 ms) [18.116] 01048.01051> mmap_offset_test [RUNNING] [18.116] 01048.01051> [PASSED] (0 ms) [18.116] 01048.01051> mmap_prot_test [RUNNING] [18.116] 01048.01051> [PASSED] (0 ms) [18.116] 01048.01051> mmap_flags_test [RUNNING] [18.116] 01048.01051> [PASSED] (0 ms) [18.116] 01048.01051> mprotect_test [RUNNING] [18.117] 01048.01051> [PASSED] (0 ms) [18.117] 01048.01051> CASE memory_mapping_tests [PASSED] CASE job_tests [STARTED] [18.117] 01048.01051> basic_test [RUNNING] [18.117] 01048.01051> [PASSED] (0 ms) [18.117] 01048.01051> create_missing_rights_test [RUNNING] [18.117] 01048.01051> [PASSED] (0 ms) [18.117] 01048.01051> policy_invalid_topic_test [RUNNING] [18.117] 01048.01051> [PASSED] (0 ms) [18.117] 01048.01051> policy_basic_test [RUNNING] [18.117] 01048.01051> [PASSED] (0 ms) [18.117] 01048.01051> policy_timer_slack_invalid_options_test [RUNNING] [18.117] 01048.01051> [PASSED] (0 ms) [18.117] 01048.01051> policy_timer_slack_invalid_count_test [RUNNING] [18.117] 01048.01051> [PASSED] (0 ms) [18.117] 01048.01051> policy_timer_slack_invalid_policy_test [RUNNING] [18.117] 01048.01051> [PASSED] (0 ms) [18.117] 01048.01051> policy_timer_slack_non_empty_test [RUNNING] [18.117] 01048.01051> [PASSED] (0 ms) [18.117] 01048.01051> policy_timer_slack_valid [RUNNING] [18.117] 01048.01051> [PASSED] (0 ms) [18.117] 01048.01051> create_test [RUNNING] [18.118] 01048.01051> [PASSED] (0 ms) [18.118] 01048.01051> kill_test [RUNNING] [18.119] 01048.01051> [PASSED] (1 ms) [18.119] 01048.01051> kill_job_no_child_test [RUNNING] [18.119] 01048.01051> [PASSED] (0 ms) [18.119] 01048.01051> set_job_oom_kill_bit [RUNNING] [18.119] 01048.01051> [PASSED] (0 ms) [18.119] 01048.01051> wait_test [RUNNING] [18.126] 01048.01051> [PASSED] (6 ms) [18.126] 01048.01051> info_task_stats_fails [RUNNING] [18.126] 01048.01051> [PASSED] (0 ms) [18.126] 01048.01051> max_height_smoke [RUNNING] [18.126] 01048.01051> [PASSED] (0 ms) [18.126] 01048.01051> CASE job_tests [PASSED] CASE handle_wait_tests [STARTED] [18.126] 01048.01051> handle_wait_test [RUNNING] [18.129] 01048.01051> [PASSED] (2 ms) [18.129] 01048.01051> CASE handle_wait_tests [PASSED] CASE handle_transfer_tests [STARTED] [18.129] 01048.01051> handle_transfer_test [RUNNING] [18.129] 01048.01051> [PASSED] (0 ms) [18.129] 01048.01051> handle_transfer_cancel_wait_test [RUNNING] [18.142] 01048.01051> [PASSED] (13 ms) [18.142] 01048.01051> CASE handle_transfer_tests [PASSED] CASE handle_info_tests [STARTED] [18.143] 01048.01051> handle_replace_test [RUNNING] [18.143] 01048.01051> [PASSED] (0 ms) [18.143] 01048.01051> handle_info_test [RUNNING] [18.143] 01048.01051> [PASSED] (0 ms) [18.143] 01048.01051> handle_related_koid_test [RUNNING] [18.143] 01048.01051> [PASSED] (0 ms) [18.143] 01048.01051> handle_rights_test [RUNNING] [18.143] 01048.01051> [PASSED] (0 ms) [18.143] 01048.01051> CASE handle_info_tests [PASSED] CASE handle_close_tests [STARTED] [18.143] 01048.01051> handle_close_many_test [RUNNING] [18.143] 01048.01051> [PASSED] (0 ms) [18.143] 01048.01051> handle_close_many_invalid_test [RUNNING] [18.143] 01048.01051> [PASSED] (0 ms) [18.143] 01048.01051> handle_close_many_duplicate_test [RUNNING] [18.143] 01048.01051> [PASSED] (0 ms) [18.143] 01048.01051> CASE handle_close_tests [PASSED] CASE futex_tests [STARTED] [18.143] 01048.01051> TestFutexWaitValueMismatch [RUNNING] [18.143] 01048.01051> [PASSED] (0 ms) [18.143] 01048.01051> TestFutexWaitTimeout [RUNNING] [18.143] 01048.01051> [PASSED] (0 ms) [18.143] 01048.01051> TestFutexWaitTimeoutElapsed [RUNNING] [18.644] 01048.01051> [PASSED] (501 ms) [18.644] 01048.01051> TestFutexWaitBadAddress [RUNNING] [18.644] 01048.01051> [PASSED] (0 ms) [18.644] 01048.01051> TestFutexWakeup [RUNNING] [18.650] 01048.01051> [PASSED] (5 ms) [18.650] 01048.01051> TestFutexWakeupLimit [RUNNING] [18.861] 01048.01051> [PASSED] (210 ms) [18.861] 01048.01051> TestFutexWakeupAddress [RUNNING] [18.867] 01048.01051> [PASSED] (6 ms) [18.867] 01048.01051> TestFutexRequeueValueMismatch [RUNNING] [18.867] 01048.01051> [PASSED] (0 ms) [18.867] 01048.01051> TestFutexRequeueSameAddr [RUNNING] [18.867] 01048.01051> [PASSED] (0 ms) [18.867] 01048.01051> TestFutexRequeue [RUNNING] [19.182] 01048.01051> [PASSED] (314 ms) [19.182] 01048.01051> TestFutexRequeueUnqueuedOnTimeout [RUNNING] [19.486] 01048.01051> [PASSED] (304 ms) [19.486] 01048.01051> TestFutexThreadKilled [RUNNING] [19.486] 01048.01051> [PASSED] (0 ms) [19.486] 01048.01051> TestFutexThreadSuspended [RUNNING] [19.609] 01048.01051> [PASSED] (122 ms) [19.609] 01048.01051> TestFutexMisaligned [RUNNING] [19.609] 01048.01051> [PASSED] (0 ms) [19.609] 01048.01051> TestEventSignaling [RUNNING] [19.914] 01048.01051> [PASSED] (304 ms) [19.914] 01048.01051> CASE futex_tests [PASSED] CASE fifo_tests [STARTED] [19.914] 01048.01051> basic_test [RUNNING] [19.914] 01048.01051> [PASSED] (0 ms) [19.914] 01048.01051> peer_closed_test [RUNNING] [19.914] 01048.01051> [PASSED] (0 ms) [19.914] 01048.01051> options_test [RUNNING] [19.914] 01048.01051> [PASSED] (0 ms) [19.914] 01048.01051> CASE fifo_tests [PASSED] CASE eventpair_tests [STARTED] [19.914] 01048.01051> create_test [RUNNING] [19.914] 01048.01051> [PASSED] (0 ms) [19.914] 01048.01051> signal_test [RUNNING] [19.914] 01048.01051> [PASSED] (0 ms) [19.914] 01048.01051> signal_peer_test [RUNNING] [19.914] 01048.01051> [PASSED] (0 ms) [19.914] 01048.01051> signal_peer_closed_test [RUNNING] [19.914] 01048.01051> [PASSED] (0 ms) [19.914] 01048.01051> CASE eventpair_tests [PASSED] CASE elf_tls_tests [STARTED] [19.914] 01048.01051> ExecutableTlsTest [RUNNING] [21.075] 01048.01051> [PASSED] (1161 ms) [21.075] 01048.01051> CASE elf_tls_tests [PASSED] CASE cookie_tests [STARTED] [21.076] 01048.01051> test_cookie_actions [RUNNING] [21.076] 01048.01051> [PASSED] (0 ms) [21.076] 01048.01051> test_cookie_eventpair [RUNNING] [21.076] 01048.01051> [PASSED] (0 ms) [21.076] 01048.01051> CASE cookie_tests [PASSED] CASE clock_tests [STARTED] [21.076] 01048.01051> clock_monotonic_test [RUNNING] [21.125] 01048.01051> [PASSED] (49 ms) [21.125] 01048.01051> CASE clock_tests [PASSED] CASE channel_tests [STARTED] [21.125] 01048.01051> channel_test [RUNNING] [21.126] 01048.01051> [PASSED] (1 ms) [21.126] 01048.01051> channel_read_error_test [RUNNING] [21.126] 01048.01051> [PASSED] (0 ms) [21.126] 01048.01051> channel_close_test [RUNNING] [21.126] 01048.01051> [PASSED] (0 ms) [21.126] 01048.01051> channel_peer_closed_test [RUNNING] [21.126] 01048.01051> [PASSED] (0 ms) [21.126] 01048.01051> channel_non_transferable [RUNNING] [21.169] 01048.01051> [PASSED] (0 ms) [21.169] 01048.01051> channel_duplicate_handles [RUNNING] [21.169] 01048.01051> [PASSED] (0 ms) [21.169] 01048.01051> channel_multithread_read [RUNNING] [21.294] 01048.01051> [PASSED] (124 ms) [21.294] 01048.01051> channel_may_discard [RUNNING] [21.294] 01048.01051> [PASSED] (0 ms) [21.294] 01048.01051> channel_call [RUNNING] [21.315] 01048.01051> [PASSED] (21 ms) [21.315] 01048.01051> channel_call_consumes_handles [RUNNING] [21.315] 01048.01051> [PASSED] (0 ms) [21.315] 01048.01051> channel_call2 [RUNNING] [21.566] 01048.01051> [PASSED] (250 ms) [21.566] 01048.01051> bad_channel_call_finish [RUNNING] [21.566] 01048.01051> [PASSED] (0 ms) [21.566] 01048.01051> channel_nest [RUNNING] [21.567] 01048.01051> [PASSED] (0 ms) [21.567] 01048.01051> channel_disallow_write_to_self [RUNNING] [21.567] 01048.01051> [PASSED] (0 ms) [21.567] 01048.01051> channel_read_etc [RUNNING] [21.567] 01048.01051> [PASSED] (0 ms) [21.598] 01048.01051> channel_write_different_sizes [RUNNING] [21.695] 01048.01051> [PASSED] (96 ms) [21.695] 01048.01051> channel_write_takes_all_handles [RUNNING] [21.704] 01048.01051> [PASSED] (9 ms) [21.704] 01048.01051> CASE channel_tests [PASSED] CASE c11_thread_tests [STARTED] [21.704] 01048.01051> c11_thread_test [RUNNING] [22.511] 01048.01051> [PASSED] (806 ms) [22.511] 01048.01051> long_name_succeeds [RUNNING] [22.612] 01048.01051> [PASSED] (101 ms) [22.612] 01048.01051> detach_self_test [RUNNING] [26.290] 01048.01051> [PASSED] (3677 ms) [26.290] 01048.01051> CASE c11_thread_tests [PASSED] CASE mtx_tests [STARTED] [26.291] 01048.01051> test_initializer [RUNNING] [26.291] 01048.01051> [PASSED] (0 ms) [26.291] 01048.01051> test_mutexes [RUNNING] [26.472] 01048.01051> [PASSED] (180 ms) [26.472] 01048.01051> test_try_mutexes [RUNNING] [26.571] 01048.01051> [PASSED] (99 ms) [26.571] 01048.01051> test_static_initializer [RUNNING] [26.571] 01048.01051> [PASSED] (0 ms) [26.571] 01048.01051> test_timeout_elapsed [RUNNING] [27.074] 01048.01051> [PASSED] (502 ms) [27.074] 01048.01051> CASE mtx_tests [PASSED] CASE cnd_tests [STARTED] [27.074] 01048.01051> cnd_test [RUNNING] [27.099] 01048.01051> [PASSED] (24 ms) [27.099] 01048.01051> cnd_timedwait_timeout_test [RUNNING] [27.106] 01048.01051> [PASSED] (7 ms) [27.106] 01048.01051> CASE cnd_tests [PASSED] CASE bad_syscall_tests [STARTED] [27.106] 01048.01051> bad_access_test [RUNNING] [27.106] 01048.01051> [PASSED] (0 ms) [27.106] 01048.01051> bad_syscall_num_test [RUNNING] [27.133] 01048.01051> [PASSED] (26 ms) [27.133] 01048.01051> CASE bad_syscall_tests [PASSED] [27.133] 01048.01051> ==================================================== [27.133] 01048.01051> Results: [27.133] 01048.01051> SUCCESS! All test cases passed! [27.133] 01048.01051> CASES: 42 SUCCESS: 42 FAILED: 0 [27.133] 01048.01051> ==================================================== [27.133] 01048.01051> core-tests succeeded RZMm59f7zOSs6aZUIXZR [27.164] 01034.01041> userboot: loader-service channel peer closed [27.164] 01034.01041> userboot: Waiting for bin/core-tests to exit... [27.194] 01034.01041> userboot: Process exited. Executing "poweroff". [27.200] 01034.01041> mp_unplug_cpu_mask_single_locked:357: WARNING: leaking thread for cpu 3 [27.205] 01034.01041> mp_unplug_cpu_mask_single_locked:357: WARNING: leaking thread for cpu 2 [27.211] 01034.01041> mp_unplug_cpu_mask_single_locked:357: WARNING: leaking thread for cpu 1 [27.211] 01034.01041> Shutting down debuglog 2019/03/22 20:50:08 successful QEMU exit status: 31