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

2019/03/22 20:49:31 QEMU invocation: [/b/s/w/ir/qemu/bin/qemu-system-x86_64 -machine q35 -device isa-debug-exit,iobase=0xf4,iosize=0x04 -cpu host -enable-kvm -m 4096 -smp 4 -nographic -serial stdio -monitor none -kernel /b/s/w/ir/multiboot.bin -initrd /b/s/w/ir/core-tests-x64.zbi -append kernel.halt-on-panic=true devmgr.suspend-timeout-debug=true TERM=dumb kernel.serial=legacy] [00000.000] 00000.00000> zbi: @ 0xffffff80003ac000 (2788400 bytes) [00000.000] 00000.00000> UART: FIFO depth 16 [00000.000] 00000.00000> PMM: boot reserve add [0x100000, 0x2fffff] [00000.000] 00000.00000> PMM: boot reserve add [0x3ac000, 0x654fff] [00000.000] 00000.00000> PMM: boot reserve marking WIRED [0x100000, 0x2fffff] [00000.000] 00000.00000> PMM: boot reserve marking WIRED [0x3ac000, 0x654fff] [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 0xffffffff00112cd0 (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 [0x655000, 0x655080) [00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00123280 (elf_build_id) at level 0x4fffe, flags 0x1 [00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00123420 (version) at level 0x4ffff, flags 0x1 [00000.000] 00000.00000> version: [00000.000] 00000.00000> arch: x86 [00000.000] 00000.00000> platform: XXX [00000.000] 00000.00000> target: XXX [00000.000] 00000.00000> project: x64 [00000.000] 00000.00000> buildid: git-dc74ab6de5720e1881177c9e2a0734a87cf814db-dirty [00000.000] 00000.00000> ELF build ID: 5141ea43e162bfa8 [00000.000] 00000.00000> initializing heap [00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00102070 (console) at level 0x50000, flags 0x1 [00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff001812e0 (x86_resource_init) at level 0x50000, flags 0x1 [00000.000] 00000.00000> initializing vm [00000.000] 00000.00000> VM: reserving kernel region [0xffffffff00100000, 0xffffffff00223000) flags 0x28 name 'kernel_code' [00000.000] 00000.00000> VM: reserving kernel region [0xffffffff00223000, 0xffffffff00269000) flags 0x8 name 'kernel_rodata' [00000.000] 00000.00000> VM: reserving kernel region [0xffffffff00269000, 0xffffffff00279000) flags 0x18 name 'kernel_data' [00000.000] 00000.00000> VM: reserving kernel region [0xffffffff00279000, 0xffffffff00300000) flags 0x18 name 'kernel_bss' [00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00182100 (display_memtype) at level 0x60001, flags 0x1 [00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00185d90 (acpi_tables) at level 0x60001, flags 0x1 [00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0017f720 (hpet) at level 0x60002, flags 0x1 [00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0017fc70 (apic) at level 0x60002, flags 0x1 [00000.000] 00000.00000> x2APIC enabled [00000.000] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00184c50 (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: 2299788 ticks/ms [00000.425] 00000.00000> timer features: constant_tsc 1 invariant_tsc 1 tsc_deadline 1 [00000.425] 00000.00000> Using TSC as wallclock [00000.425] 00000.00000> initializing kernel [00000.425] 00000.00000> initializing mp [00000.425] 00000.00000> initializing timers [00000.425] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00113010 (global_prng_thread_safe) at level 0x7ffff, flags 0x1 [00000.425] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00122a70 (debuglog) at level 0x7ffff, flags 0x1 [00000.425] 00000.00000> INIT: cpu 0, calling hook 0xffffffff002080e0 (thread_set_priority_experiment) at level 0x7ffff, flags 0x1 [00000.425] 00000.00000> thread set priority experiment is : ENABLED [00000.425] 00000.00000> creating bootstrap completion thread [00000.589] 00000.00000> top of bootstrap2() [00000.589] 00000.00000> INIT: cpu 0, calling hook 0xffffffff001309a0 (libobject) at level 0x80000, flags 0x1 [00000.590] 00000.00000> OOM: started thread [00000.598] 00000.00000> INIT: cpu 0, calling hook 0xffffffff001b7c00 (dpc) at level 0x80000, flags 0x1 [00000.603] 00000.00000> Processor Model Info: type 0 family 0x6 model 0xf stepping 0 [00000.603] 00000.00000> display_family 0x6 display_model 0x3f [00000.603] 00000.00000> Vendor: Intel [00000.603] 00000.00000> Microarch: Haswell [00000.603] 00000.00000> F/M/S: 6/3f/0 [00000.603] 00000.00000> Brand: Intel(R) Xeon(R) CPU @ 2.30GHz [00000.603] 00000.00000> Features: fpu sse sse2 sse3 ssse3 sse4.1 sse4.2 mmx avx avx2 fxsr pcid xsave aesni clflush [00000.603] 00000.00000> fsgsbase tsc_adj smep erms rdrand syscall nx rdtscp tsc_deadline x2apic hypervisor [00000.603] 00000.00000> initializing platform [00000.603] 00000.00000> INIT: cpu 0, calling hook 0xffffffff001a4c40 (x86_perfmon) at level 0x90000, flags 0x1 [00000.603] 00000.00000> x86_perfmon_init_once:497: perfmon: unexpected programmable counter width 0 in cpuid.0AH [00000.604] 00000.00000> UART: started IRQ driven RX [00000.604] 00000.00000> UART: started IRQ driven TX [00000.604] 00000.00000> cpu topology: [00000.604] 00000.00000> 0: apic id 0x0 package 0 node 0 core 0 smt 0 BSP [00000.604] 00000.00000> 1: apic id 0x1 package 1 node 0 core 0 smt 0 [00000.604] 00000.00000> 2: apic id 0x2 package 2 node 0 core 0 smt 0 [00000.604] 00000.00000> 3: apic id 0x3 package 3 node 0 core 0 smt 0 [00000.604] 00000.00000> Found 4 cpus [00000.604] 00000.00000> booting apic ids: 0x1 0x2 0x3 [00000.674] 00000.00000> entering scheduler on cpu 1 [00000.674] 00000.00000> entering scheduler on cpu 2 [00000.674] 00000.00000> entering scheduler on cpu 3 [00000.685] 00000.00000> smbios: manufacturer="QEMU" product="Standard PC (Q35 + ICH9, 2009)" [00000.685] 00000.00000> initializing target [00000.685] 00000.00000> INIT: cpu 0, calling hook 0xffffffff00183c70 (x86_pcie_init) at level 0xa0000, flags 0x1 [00000.685] 00000.00000> moving to last init level [00000.685] 00000.00000> INIT: cpu 0, calling hook 0xffffffff001025b0 (kernel_shell) at level 0xc0000, flags 0x1 [00000.686] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0021cc40 (ktrace) at level 0xc0000, flags 0x1 [00000.744] 00000.00000> ktrace: buffer at 0xffffff90907aa000 (33554432 bytes) [00000.744] 00000.00000> INIT: cpu 0, calling hook 0xffffffff0021d800 (userboot) at level 0xc0000, flags 0x1 [00000.744] 00000.00000> userboot: ramdisk 0x2a9000 @ 0xffffff80003ac000 [00000.759] 00000.00000> userboot: userboot rodata 0 @ [0x231dd1547000,0x231dd1549000) [00000.759] 00000.00000> userboot: userboot code 0x2000 @ [0x231dd1549000,0x231dd154d000) [00000.759] 00000.00000> userboot: vdso/full rodata 0 @ [0x231dd154d000,0x231dd1554000) [00000.759] 00000.00000> userboot: vdso/full code 0x7000 @ [0x231dd1554000,0x231dd1555000) [00000.759] 00000.00000> userboot: entry point @ 0x231dd1549b10 [00000.783] 01034.01041> userboot: option "userboot=bin/core-tests" [00000.783] 01034.01041> userboot: option "userboot.shutdown=" [00000.783] 01034.01041> userboot: option "/b/s/w/ir/multiboot.bin=" [00000.783] 01034.01041> userboot: option "kernel.halt-on-panic=true" [00000.783] 01034.01041> userboot: option "devmgr.suspend-timeout-debug=true" [00000.783] 01034.01041> userboot: option "TERM=dumb" [00000.783] 01034.01041> userboot: option "kernel.serial=legacy" [00000.783] 01034.01041> userboot: option "multiboot.boot_loader_name=qemu" [00000.790] 01034.01041> userboot: searching bootfs for 'bin/core-tests' [00000.790] 01034.01041> userboot: 'bin/core-tests' has PT_INTERP "lib/ld.so.1" [00000.790] 01034.01041> userboot: searching bootfs for 'lib/ld.so.1' [00000.790] 01034.01041> userboot: userboot: loaded lib/ld.so.1 at 0x60ee58077000, entry point 0x60ee580df718 [00000.790] 01034.01041> userboot: userboot: loaded vDSO at 0x681cdf7a1000, entry point 0x0 [00000.790] 01034.01041> userboot: process bin/core-tests started. [00000.790] 01034.01041> userboot: waiting for loader-service requests... [00000.843] 01034.01041> userboot: searching bootfs for 'lib/libfdio.so' [00000.844] 01034.01041> userboot: searching bootfs for 'lib/libunittest.so' [00000.844] 01034.01041> userboot: searching bootfs for 'lib/libmini-process.so' [00000.844] 01034.01041> userboot: searching bootfs for 'lib/libbacktrace.so' [00000.861] 01034.01041> userboot: searching bootfs for 'lib/libngunwind.so' [00000.861] 01048.01051> {{{reset}}} [00000.862] 01048.01051> {{{module:0:<application>:elf:125a13518eb13bed}}} [00000.862] 01048.01051> {{{mmap:0x5e9ee3821000:0x34000:load:0:r:0}}} [00000.862] 01048.01051> {{{mmap:0x5e9ee3855000:0xe6000:load:0:rx:0x34000}}} [00000.862] 01048.01051> {{{mmap:0x5e9ee393b000:0x5000:load:0:rw:0x11a000}}} [00000.862] 01048.01051> dso: id=125a13518eb13bed base=0x00005e9ee3821000 name=<application> [00000.862] 01048.01051> {{{module:0x3:libfdio.so:elf:533970f95b2ccfe6}}} [00000.862] 01048.01051> {{{mmap:0x116318ee0000:0xb000:load:0x3:r:0}}} [00000.862] 01048.01051> {{{mmap:0x116318eeb000:0x1c000:load:0x3:rx:0xb000}}} [00000.862] 01048.01051> {{{mmap:0x116318f07000:0x5000:load:0x3:rw:0x27000}}} [00000.862] 01048.01051> dso: id=533970f95b2ccfe6 base=0x0000116318ee0000 name=libfdio.so [00000.862] 01048.01051> {{{module:0x4:libunittest.so:elf:5e9ac7a2e5051a4c}}} [00000.862] 01048.01051> {{{mmap:0x4b155e196000:0x4000:load:0x4:r:0}}} [00000.862] 01048.01051> {{{mmap:0x4b155e19a000:0x3000:load:0x4:rx:0x4000}}} [00000.862] 01048.01051> {{{mmap:0x4b155e19d000:0x4000:load:0x4:rw:0x7000}}} [00000.862] 01048.01051> dso: id=5e9ac7a2e5051a4c base=0x00004b155e196000 name=libunittest.so [00000.862] 01048.01051> {{{module:0x2:<vDSO>:elf:aafd65d279c791a277aef74d68e82587c0331200}}} [00000.934] 01048.01051> {{{mmap:0x681cdf7a1000:0x7000:load:0x2:r:0}}} [00000.934] 01048.01051> {{{mmap:0x681cdf7a8000:0x1000:load:0x2:rx:0x7000}}} [00000.934] 01048.01051> dso: id=aafd65d279c791a277aef74d68e82587c0331200 base=0x0000681cdf7a1000 name=<vDSO> [00000.934] 01048.01051> {{{module:0x5:libmini-process.so:elf:ea10fac28ded8015}}} [00000.934] 01048.01051> {{{mmap:0x1938f6626000:0x2000:load:0x5:r:0}}} [00000.934] 01048.01051> {{{mmap:0x1938f6628000:0x2000:load:0x5:rx:0x2000}}} [00000.934] 01048.01051> {{{mmap:0x1938f662a000:0x2000:load:0x5:rw:0x4000}}} [00000.934] 01048.01051> dso: id=ea10fac28ded8015 base=0x00001938f6626000 name=libmini-process.so [00000.934] 01048.01051> {{{module:0x6:libbacktrace.so:elf:10c01962e93b9633}}} [00000.934] 01048.01051> {{{mmap:0x4dcbf44c7000:0x2000:load:0x6:r:0}}} [00000.934] 01048.01051> {{{mmap:0x4dcbf44c9000:0xb000:load:0x6:rx:0x2000}}} [00000.934] 01048.01051> {{{mmap:0x4dcbf44d4000:0x1000:load:0x6:rw:0xd000}}} [00000.934] 01048.01051> dso: id=10c01962e93b9633 base=0x00004dcbf44c7000 name=libbacktrace.so [00000.934] 01048.01051> {{{module:0x7:libngunwind.so:elf:a4e5ea06d4b632c4}}} [00000.934] 01048.01051> {{{mmap:0x41c5ec808000:0x5000:load:0x7:r:0}}} [00000.934] 01048.01051> {{{mmap:0x41c5ec80d000:0x12000:load:0x7:rx:0x5000}}} [00000.934] 01048.01051> {{{mmap:0x41c5ec81f000:0x11000:load:0x7:rw:0x17000}}} [00000.934] 01048.01051> dso: id=a4e5ea06d4b632c4 base=0x000041c5ec808000 name=libngunwind.so [00000.934] 01048.01051> {{{module:0x1:libc.so:elf:d14933ca74fc69cb}}} [00000.934] 01048.01051> {{{mmap:0x60ee58077000:0x42000:load:0x1:r:0}}} [00000.934] 01048.01051> {{{mmap:0x60ee580b9000:0x75000:load:0x1:rx:0x42000}}} [00000.934] 01048.01051> {{{mmap:0x60ee5812e000:0x7000:load:0x1:rw:0xb7000}}} [00000.934] 01048.01051> dso: id=d14933ca74fc69cb base=0x000060ee58077000 name=libc.so [00000.934] 01048.01051> TEST [00000.935] 01048.01051> CASE resource_tests [STARTED] [00000.935] 01048.01051> probe_address_space [RUNNING] [00000.935] 01048.01051> [PASSED] (0 ms) [00001.045] 01048.01051> TestBasicActions [RUNNING] [00001.045] 01048.01051> [PASSED] (0 ms) [00001.045] 01048.01051> TestExclusiveShared [RUNNING] [00001.045] 01048.01051> [PASSED] (0 ms) [00001.045] 01048.01051> TestSharedExclusive [RUNNING] [00001.045] 01048.01051> [PASSED] (0 ms) [00001.045] 01048.01051> TestInvalidArgs [RUNNING] [00001.045] 01048.01051> [PASSED] (0 ms) [00001.045] 01048.01051> TestVmoCreation [RUNNING] [00001.045] 01048.01051> [PASSED] (0 ms) [00001.045] 01048.01051> TestVmoCreationSmaller [RUNNING] [00001.045] 01048.01051> [PASSED] (0 ms) [00001.045] 01048.01051> TestVmoCreationUnaligned [RUNNING] [00001.045] 01048.01051> [PASSED] (0 ms) [00001.045] 01048.01051> TestVmoReplaceAsExecutable [RUNNING] [00001.045] 01048.01051> [PASSED] (0 ms) [00001.045] 01048.01051> test_ioports [RUNNING] [00001.050] 01048.01051> [PASSED] (4 ms) [00001.050] 01048.01051> CASE resource_tests [PASSED] [00001.050] 01048.01051> CASE profile_tests [STARTED] [00001.050] 01048.01051> make_profile_fails [RUNNING] [00001.050] 01048.01051> [PASSED] (0 ms) [00001.050] 01048.01051> change_priority_via_profile [RUNNING] [00001.050] 01048.01051> [PASSED] (0 ms) [00001.050] 01048.01051> CASE profile_tests [PASSED] [00001.050] 01048.01051> CASE interrupt_tests [STARTED] [00001.050] 01048.01051> interrupt_test [RUNNING] [00001.050] 01048.01051> [PASSED] (0 ms) [00001.050] 01048.01051> interrupt_port_bound_test [RUNNING] [00001.050] 01048.01051> [PASSED] (0 ms) [00001.050] 01048.01051> interrupt_port_non_bindable_test [RUNNING] [00001.050] 01048.01051> [PASSED] (0 ms) [00001.050] 01048.01051> interrupt_suspend_test [RUNNING] [00001.170] 01048.01051> [PASSED] (119 ms) [00001.170] 01048.01051> interrupt_bind_vcpu_test [RUNNING] [00001.170] 01048.01051> Guest creation not supported [00001.170] 01048.01051> [PASSED] (0 ms) [00001.170] 01048.01051> interrupt_bind_vcpu_not_supported_test [RUNNING] [00001.170] 01048.01051> Guest creation not supported [00001.170] 01048.01051> [PASSED] (0 ms) [00001.170] 01048.01051> interrupt_bind_vcpu_already_bound_test [RUNNING] [00001.170] 01048.01051> Guest creation not supported [00001.170] 01048.01051> [PASSED] (0 ms) [00001.170] 01048.01051> interrupt_bind_vcpu_multiple_guests_test [RUNNING] [00001.170] 01048.01051> Guest creation not supported [00001.170] 01048.01051> [PASSED] (0 ms) [00001.170] 01048.01051> CASE interrupt_tests [PASSED] [00001.170] 01048.01051> CASE vmo_signal_tests [STARTED] [00001.170] 01048.01051> vmo_signal_sanity_test [RUNNING] [00001.170] 01048.01051> [PASSED] (0 ms) [00001.170] 01048.01051> vmo_child_signal_clone_test [RUNNING] [00001.171] 01048.01051> [PASSED] (0 ms) [00001.171] 01048.01051> vmo_child_signal_map_test [RUNNING] [00001.171] 01048.01051> [PASSED] (0 ms) [00001.171] 01048.01051> CASE vmo_signal_tests [PASSED] [00001.171] 01048.01051> CASE vmar_tests [STARTED] [00001.171] 01048.01051> destroy_root_test [RUNNING] [00001.171] 01048.01051> [PASSED] (0 ms) [00001.171] 01048.01051> basic_allocate_test [RUNNING] [00001.171] 01048.01051> [PASSED] (0 ms) [00001.171] 01048.01051> allocate_oob_test [RUNNING] [00001.171] 01048.01051> [PASSED] (0 ms) [00001.171] 01048.01051> allocate_unsatisfiable_test [RUNNING] [00001.171] 01048.01051> [PASSED] (0 ms) [00001.171] 01048.01051> destroyed_vmar_test [RUNNING] [00001.171] 01048.01051> [PASSED] (0 ms) [00001.171] 01048.01051> map_over_destroyed_test [RUNNING] [00001.171] 01048.01051> [PASSED] (0 ms) [00001.171] 01048.01051> map_in_compact_test [RUNNING] [00001.171] 01048.01051> [PASSED] (0 ms) [00001.171] 01048.01051> overmapping_test [RUNNING] [00001.171] 01048.01051> [PASSED] (0 ms) [00001.171] 01048.01051> invalid_args_test [RUNNING] [00001.171] 01048.01051> [PASSED] (0 ms) [00001.171] 01048.01051> unaligned_len_test [RUNNING] [00001.171] 01048.01051> [PASSED] (0 ms) [00001.323] 01048.01051> unaligned_len_map_test [RUNNING] [00001.323] 01048.01051> [PASSED] (0 ms) [00001.323] 01048.01051> rights_drop_test [RUNNING] [00001.323] 01048.01051> [PASSED] (0 ms) [00001.323] 01048.01051> protect_test [RUNNING] [00001.324] 01048.01051> [PASSED] (0 ms) [00001.324] 01048.01051> nested_region_perms_test [RUNNING] [00001.324] 01048.01051> [PASSED] (0 ms) [00001.324] 01048.01051> object_info_test [RUNNING] [00001.324] 01048.01051> [PASSED] (0 ms) [00001.324] 01048.01051> unmap_split_test [RUNNING] [00001.324] 01048.01051> [PASSED] (0 ms) [00001.324] 01048.01051> unmap_multiple_test [RUNNING] [00001.324] 01048.01051> [PASSED] (0 ms) [00001.324] 01048.01051> unmap_base_not_mapped_test [RUNNING] [00001.324] 01048.01051> [PASSED] (0 ms) [00001.324] 01048.01051> map_specific_overwrite_test [RUNNING] [00001.324] 01048.01051> [PASSED] (0 ms) [00001.324] 01048.01051> protect_split_test [RUNNING] [00001.324] 01048.01051> [PASSED] (0 ms) [00001.324] 01048.01051> protect_multiple_test [RUNNING] [00001.324] 01048.01051> [PASSED] (0 ms) [00001.324] 01048.01051> protect_over_demand_paged_test [RUNNING] [00001.408] 01048.01051> [PASSED] (83 ms) [00001.408] 01048.01051> protect_large_uncommitted_test [RUNNING] [00001.417] 01048.01051> [PASSED] (9 ms) [00001.417] 01048.01051> unmap_large_uncommitted_test [RUNNING] [00001.424] 01048.01264> PageFault: 1029642 free pages [00001.428] 01048.01266> PageFault: 1029642 free pages [00001.431] 01048.01268> PageFault: 1029642 free pages [00001.435] 01048.01051> [PASSED] (17 ms) [00001.435] 01048.01051> partial_unmap_and_read [RUNNING] [00001.435] 01048.01051> [PASSED] (0 ms) [00001.435] 01048.01051> partial_unmap_and_write [RUNNING] [00001.435] 01048.01051> [PASSED] (0 ms) [00001.435] 01048.01051> partial_unmap_with_vmar_offset [RUNNING] [00001.435] 01048.01051> [PASSED] (0 ms) [00001.435] 01048.01051> CASE vmar_tests [PASSED] [00001.435] 01048.01051> CASE ticks_tests [STARTED] [00001.435] 01048.01051> elapsed_time_using_ticks [RUNNING] [00001.435] 01048.01051> [PASSED] (0 ms) [00001.435] 01048.01051> CASE ticks_tests [PASSED] [00001.435] 01048.01051> CASE threads_tests [STARTED] [00001.435] 01048.01051> TestBasics [RUNNING] [00001.536] 01048.01051> [PASSED] (100 ms) [00001.536] 01048.01051> TestInvalidRights [RUNNING] [00001.536] 01048.01051> [PASSED] (0 ms) [00001.536] 01048.01051> TestDetach [RUNNING] [00001.536] 01048.01051> [PASSED] (0 ms) [00001.536] 01048.01051> TestLongNameSucceeds [RUNNING] [00001.543] 01048.01051> [PASSED] (6 ms) [00001.543] 01048.01051> TestThreadStartOnInitialThread [RUNNING] [00001.550] 01048.01051> [PASSED] (7 ms) [00001.550] 01048.01051> TestThreadStartWithZeroInstructionPointer [RUNNING] [00001.572] 01048.01051> [PASSED] (21 ms) [00001.572] 01048.01051> TestKillBusyThread [RUNNING] [00001.673] 01048.01051> [PASSED] (100 ms) [00001.673] 01048.01051> TestKillSleepThread [RUNNING] [00001.773] 01048.01051> [PASSED] (100 ms) [00001.773] 01048.01051> TestKillWaitThread [RUNNING] [00001.874] 01048.01051> [PASSED] (100 ms) [00001.874] 01048.01051> TestNonstartedThread [RUNNING] [00001.882] 01048.01051> [PASSED] (7 ms) [00001.882] 01048.01051> TestThreadKillsItself [RUNNING] [00001.889] 01048.01051> [PASSED] (7 ms) [00001.889] 01048.01051> TestInfoTaskStatsFails [RUNNING] [00001.990] 01048.01051> [PASSED] (100 ms) [00001.990] 01048.01051> TestResumeSuspended [RUNNING] [00002.098] 01048.01051> [PASSED] (108 ms) [00002.098] 01048.01051> TestSuspendSleeping [RUNNING] [00002.199] 01048.01051> [PASSED] (100 ms) [00002.199] 01048.01051> TestSuspendChannelCall [RUNNING] [00002.207] 01048.01051> [PASSED] (7 ms) [00002.207] 01048.01051> TestSuspendPortCall [RUNNING] [00002.408] 01048.01051> [PASSED] (201 ms) [00002.408] 01048.01051> TestSuspendStopsThread [RUNNING] [00002.460] 01048.01051> [PASSED] (51 ms) [00002.460] 01048.01051> TestSuspendMultiple [RUNNING] [00002.461] 01048.01051> [PASSED] (0 ms) [00002.461] 01048.01051> TestSuspendSelf [RUNNING] [00002.461] 01048.01051> [PASSED] (0 ms) [00002.461] 01048.01051> TestKillSuspendedThread [RUNNING] [00002.461] 01048.01051> [PASSED] (0 ms) [00002.461] 01048.01051> TestStartSuspendedThread [RUNNING] [00002.462] 01048.01051> [PASSED] (0 ms) [00002.462] 01048.01051> TestStartSuspendedAndResumedThread [RUNNING] [00002.462] 01048.01051> [PASSED] (0 ms) [00002.462] 01048.01051> TestSuspendSingleWaitAsyncSignalDelivery [RUNNING] [00002.467] 01048.01051> [PASSED] (4 ms) [00002.467] 01048.01051> TestSuspendRepeatingWaitAsyncSignalDelivery [RUNNING] [00002.470] 01048.01051> [PASSED] (2 ms) [00002.470] 01048.01051> TestReadingGeneralRegisterState [RUNNING] [00002.570] 01048.01051> [PASSED] (100 ms) [00002.570] 01048.01051> TestWritingGeneralRegisterState [RUNNING] [00002.671] 01048.01051> [PASSED] (100 ms) [00002.671] 01048.01051> TestNoncanonicalRipAddress [RUNNING] [00002.772] 01048.01051> [PASSED] (101 ms) [00002.772] 01048.01051> TestWritingArmFlagsRegister [RUNNING] [00002.772] 01048.01051> [PASSED] (0 ms) [00002.772] 01048.01051> CASE threads_tests [PASSED] [00002.772] 01048.01051> CASE sync_mutex_tests [STARTED] [00002.772] 01048.01051> test_mutexes [RUNNING] [00002.862] 01048.01051> [PASSED] (89 ms) [00002.862] 01048.01051> test_try_mutexes [RUNNING] [00002.957] 01048.01051> [PASSED] (94 ms) [00002.957] 01048.01051> test_timeout_elapsed [RUNNING] [00003.459] 01048.01051> [PASSED] (501 ms) [00003.459] 01048.01051> CASE sync_mutex_tests [PASSED] [00003.459] 01048.01051> CASE sync_condition_tests [STARTED] [00003.459] 01048.01051> Condition::condition_test [RUNNING] [00003.479] 01048.01051> [PASSED] (20 ms) [00003.479] 01048.01051> Condition::condition_timeout_test [RUNNING] [00003.481] 01048.01051> [PASSED] (1 ms) [00003.481] 01048.01051> CASE sync_condition_tests [PASSED] [00003.481] 01048.01051> CASE sync_completion_tests [STARTED] [00003.481] 01048.01051> test_initializer [RUNNING] [00003.481] 01048.01051> [PASSED] (0 ms) [00003.481] 01048.01051> test_completions [RUNNING] [00003.518] 01048.01051> [PASSED] (36 ms) [00003.518] 01048.01051> test_timeout [RUNNING] [00003.519] 01048.01051> [PASSED] (0 ms) [00003.519] 01048.01051> CASE sync_completion_tests [PASSED] [00003.519] 01048.01051> CASE sync_completion_tests [STARTED] [00003.519] 01048.01051> test_initializer [RUNNING] [00003.519] 01048.01051> [PASSED] (0 ms) [00003.519] 01048.01051> test_completions [RUNNING] [00003.563] 01048.01051> [PASSED] (44 ms) [00003.563] 01048.01051> test_timeout [RUNNING] [00004.676] 01048.01051> [PASSED] (1112 ms) [00004.676] 01048.01051> test_signal_requeue [RUNNING] [00004.704] 01048.01051> [PASSED] (28 ms) [00004.704] 01048.01051> test_completion_signaled [RUNNING] [00004.704] 01048.01051> [PASSED] (0 ms) [00004.704] 01048.01051> CASE sync_completion_tests [PASSED] [00004.704] 01048.01051> CASE stack_tests [STARTED] [00004.704] 01048.01051> main_thread_stack_tests [RUNNING] [00004.704] 01048.01051> [PASSED] (0 ms) [00004.704] 01048.01051> other_thread_stack_tests [RUNNING] [00004.704] 01048.01051> [PASSED] (0 ms) [00004.705] 01048.01051> CASE stack_tests [PASSED] [00004.705] 01048.01051> CASE socket_tests [STARTED] [00004.705] 01048.01051> socket_basic [RUNNING] [00004.705] 01048.01051> [PASSED] (0 ms) [00004.705] 01048.01051> socket_peek [RUNNING] [00004.705] 01048.01051> [PASSED] (0 ms) [00004.705] 01048.01051> socket_peek_empty [RUNNING] [00004.705] 01048.01051> [PASSED] (0 ms) [00004.705] 01048.01051> socket_signals [RUNNING] [00004.705] 01048.01051> [PASSED] (0 ms) [00004.705] 01048.01051> socket_peer_closed_signal [RUNNING] [00004.705] 01048.01051> [PASSED] (0 ms) [00004.705] 01048.01051> socket_peer_closed_set_property [RUNNING] [00004.705] 01048.01051> [PASSED] (0 ms) [00004.705] 01048.01051> socket_shutdown_write [RUNNING] [00004.705] 01048.01051> [PASSED] (0 ms) [00004.705] 01048.01051> socket_shutdown_read [RUNNING] [00004.705] 01048.01051> [PASSED] (0 ms) [00004.807] 01048.01051> socket_bytes_outstanding [RUNNING] [00004.807] 01048.01051> [PASSED] (0 ms) [00004.807] 01048.01051> socket_bytes_outstanding_shutdown_write [RUNNING] [00004.807] 01048.01051> [PASSED] (0 ms) [00004.807] 01048.01051> socket_bytes_outstanding_shutdown_read [RUNNING] [00004.807] 01048.01051> [PASSED] (0 ms) [00004.807] 01048.01051> socket_short_write [RUNNING] [00004.807] 01048.01051> [PASSED] (0 ms) [00004.808] 01048.01051> socket_datagram [RUNNING] [00004.808] 01048.01051> [PASSED] (0 ms) [00004.808] 01048.01051> socket_datagram_peek [RUNNING] [00004.808] 01048.01051> [PASSED] (0 ms) [00004.808] 01048.01051> socket_datagram_peek_empty [RUNNING] [00004.808] 01048.01051> [PASSED] (0 ms) [00004.808] 01048.01051> socket_datagram_no_short_write [RUNNING] [00004.863] 01048.01051> [PASSED] (55 ms) [00004.863] 01048.01051> socket_control_plane_absent [RUNNING] [00004.863] 01048.01051> [PASSED] (0 ms) [00004.863] 01048.01051> socket_control_plane [RUNNING] [00004.863] 01048.01051> [PASSED] (0 ms) [00004.863] 01048.01051> socket_control_plane_peek [RUNNING] [00004.863] 01048.01051> [PASSED] (0 ms) [00004.863] 01048.01051> socket_control_plane_peek_empty [RUNNING] [00004.863] 01048.01051> [PASSED] (0 ms) [00004.863] 01048.01051> socket_control_plane_shutdown [RUNNING] [00004.863] 01048.01051> [PASSED] (0 ms) [00004.863] 01048.01051> socket_accept [RUNNING] [00004.863] 01048.01051> [PASSED] (0 ms) [00004.863] 01048.01051> socket_share_invalid_handle [RUNNING] [00004.863] 01048.01051> [PASSED] (0 ms) [00004.863] 01048.01051> socket_share_consumes_on_failure [RUNNING] [00004.863] 01048.01051> [PASSED] (0 ms) [00004.863] 01048.01051> socket_signals2 [RUNNING] [00004.928] 01048.01051> [PASSED] (64 ms) [00004.928] 01048.01051> CASE socket_tests [PASSED] [00004.928] 01048.01051> CASE tls_tests [STARTED] [00004.928] 01048.01051> tls_test [RUNNING] [00006.961] 01048.01051> [PASSED] (2033 ms) [00006.961] 01048.01051> CASE tls_tests [PASSED] [00006.961] 01048.01051> CASE pthread_barrier_tests [STARTED] [00006.961] 01048.01051> test_barrier [RUNNING] [00007.166] 01048.01051> [PASSED] (205 ms) [00007.166] 01048.01051> CASE pthread_barrier_tests [PASSED] [00007.166] 01048.01051> CASE pthread_tests [STARTED] [00007.167] 01048.01051> pthread_test [RUNNING] [00010.293] 01048.01051> [PASSED] (3126 ms) [00010.293] 01048.01051> pthread_self_main_thread_test [RUNNING] [00010.293] 01048.01051> [PASSED] (0 ms) [00010.293] 01048.01051> pthread_big_stack_size [RUNNING] [00010.329] 01048.01051> [PASSED] (35 ms) [00010.329] 01048.01051> pthread_getstack_main_thread [RUNNING] [00010.329] 01048.01051> [PASSED] (0 ms) [00010.329] 01048.01051> pthread_getstack_other_thread [RUNNING] [00010.329] 01048.01051> [PASSED] (0 ms) [00010.329] 01048.01051> CASE pthread_tests [PASSED] [00010.329] 01048.01051> CASE process_tests [STARTED] [00010.329] 01048.01051> mini_process_sanity [RUNNING] [00010.343] 01048.01051> [PASSED] (13 ms) [00010.343] 01048.01051> process_start_fail [RUNNING] [00010.350] 01048.01051> [PASSED] (6 ms) [00010.350] 01048.01051> process_not_killed_via_thread_close [RUNNING] [00010.352] 01048.01051> [PASSED] (1 ms) [00010.352] 01048.01051> process_not_killed_via_process_close [RUNNING] [00010.353] 01048.01051> [PASSED] (1 ms) [00010.353] 01048.01051> kill_process_via_thread_kill [RUNNING] [00010.359] 01048.01051> [PASSED] (6 ms) [00010.359] 01048.01051> kill_process_via_vmar_destroy [RUNNING] [00010.360] 02111.02113> PageFault: 1029200 free pages [00010.367] 01048.01051> [PASSED] (7 ms) [00010.367] 01048.01051> kill_channel_handle_cycle [RUNNING] [00011.126] 01048.01051> [PASSED] (759 ms) [00011.126] 01048.01051> info_reflects_process_state [RUNNING] [00011.377] 01048.01051> [PASSED] (251 ms) [00011.377] 01048.01051> suspend [RUNNING] [00011.378] 01048.01051> [PASSED] (0 ms) [00011.378] 01048.01051> suspend_self [RUNNING] [00011.378] 01048.01051> [PASSED] (0 ms) [00011.378] 01048.01051> suspend_multiple_threads [RUNNING] [00011.401] 01048.01051> [PASSED] (22 ms) [00011.401] 01048.01051> suspend_before_creating_threads [RUNNING] [00011.409] 01048.01051> [PASSED] (8 ms) [00011.409] 01048.01051> suspend_before_starting_threads [RUNNING] [00011.410] 01048.01051> [PASSED] (0 ms) [00011.410] 01048.01051> suspend_process_then_thread [RUNNING] [00011.676] 01048.01051> [PASSED] (265 ms) [00011.676] 01048.01051> suspend_thread_then_process [RUNNING] [00011.927] 01048.01051> [PASSED] (251 ms) [00011.927] 01048.01051> suspend_thread_and_process_before_starting_process [RUNNING] [00012.186] 01048.01051> [PASSED] (259 ms) [00012.186] 01048.01051> suspend_twice [RUNNING] [00012.445] 01048.01051> [PASSED] (258 ms) [00012.445] 01048.01051> suspend_twice_before_creating_threads [RUNNING] [00012.704] 01048.01051> [PASSED] (259 ms) [00012.704] 01048.01051> suspend_with_dying_thread [RUNNING] [00012.714] 01048.01051> [PASSED] (9 ms) [00012.714] 01048.01051> CASE process_tests [PASSED] [00012.714] 01048.01051> CASE port_tests [STARTED] [00012.714] 01048.01051> basic_test [RUNNING] [00012.714] 01048.01051> [PASSED] (0 ms) [00012.714] 01048.01051> queue_and_close_test [RUNNING] [00012.714] 01048.01051> [PASSED] (0 ms) [00012.714] 01048.01051> queue_too_many [RUNNING] [00012.745] 01048.01051> [PASSED] (30 ms) [00012.745] 01048.01051> async_wait_channel_test [RUNNING] [00012.753] 01048.01051> [PASSED] (8 ms) [00012.753] 01048.01051> async_wait_event_test_single [RUNNING] [00012.753] 01048.01051> [PASSED] (0 ms) [00012.753] 01048.01051> async_wait_event_test_repeat [RUNNING] [00012.753] 01048.01051> [PASSED] (0 ms) [00012.753] 01048.01051> async_wait_invalid_option [RUNNING] [00012.753] 01048.01051> [PASSED] (0 ms) [00012.753] 01048.01051> async_wait_close_order_1 [RUNNING] [00012.753] 01048.01051> [PASSED] (0 ms) [00012.753] 01048.01051> async_wait_close_order_2 [RUNNING] [00012.753] 01048.01051> [PASSED] (0 ms) [00012.753] 01048.01051> async_wait_close_order_3 [RUNNING] [00012.753] 01048.01051> [PASSED] (0 ms) [00012.753] 01048.01051> async_wait_close_order_4 [RUNNING] [00012.753] 01048.01051> [PASSED] (0 ms) [00012.753] 01048.01051> async_wait_close_order_5 [RUNNING] [00012.753] 01048.01051> [PASSED] (0 ms) [00012.753] 01048.01051> async_wait_close_order_6 [RUNNING] [00012.753] 01048.01051> [PASSED] (0 ms) [00012.753] 01048.01051> channel_pre_writes_test [RUNNING] [00012.753] 01048.01051> [PASSED] (0 ms) [00012.753] 01048.01051> cancel_event_key [RUNNING] [00012.753] 01048.01051> [PASSED] (0 ms) [00012.753] 01048.01051> cancel_event_key_after [RUNNING] [00012.753] 01048.01051> [PASSED] (0 ms) [00012.753] 01048.01051> threads_event [RUNNING] [00012.845] 01048.01051> [PASSED] (91 ms) [00012.845] 01048.01051> cancel_stress [RUNNING] [00014.011] 01048.01051> [PASSED] (1165 ms) [00014.011] 01048.01051> CASE port_tests [PASSED] [00014.011] 01048.01051> CASE api_violations [STARTED] [00014.011] 01048.01051> invalid_pager_create [RUNNING] [00014.011] 01048.01051> [PASSED] (0 ms) [00014.011] 01048.01051> invalid_pager_create_vmo [RUNNING] [00014.011] 01048.01051> [PASSED] (0 ms) [00014.011] 01048.01051> invalid_pager_detach_vmo [RUNNING] [00014.011] 01048.01051> [PASSED] (0 ms) [00014.011] 01048.01051> invalid_pager_supply_pages [RUNNING] [00014.011] 01048.01051> [PASSED] (0 ms) [00014.011] 01048.01051> resize_nonresizable_vmo [RUNNING] [00014.011] 01048.01051> [PASSED] (0 ms) [00014.011] 01048.01051> CASE api_violations [PASSED] [00014.011] 01048.01051> CASE commit_tests [STARTED] [00014.011] 01048.01051> simple_commit_test [RUNNING] [00014.076] 01048.01051> [PASSED] (64 ms) [00014.076] 01048.01051> split_commit_test [RUNNING] [00014.083] 01048.01051> [PASSED] (7 ms) [00014.083] 01048.01051> overlap_commit_test [RUNNING] [00014.092] 01048.01051> [PASSED] (8 ms) [00014.092] 01048.01051> overlap_commit_supply_test [RUNNING] [00014.123] 01048.01051> [PASSED] (30 ms) [00014.123] 01048.01051> multisupply_commit_test [RUNNING] [00014.130] 01048.01051> [PASSED] (7 ms) [00014.130] 01048.01051> multicommit_supply_test [RUNNING] [00014.140] 01048.01051> [PASSED] (10 ms) [00014.140] 01048.01051> commit_redundant_supply_test [RUNNING] [00014.148] 01048.01051> [PASSED] (7 ms) [00014.148] 01048.01051> supply_decommit_test [RUNNING] [00014.155] 01048.01051> [PASSED] (7 ms) [00014.155] 01048.01051> resize_commit_test [RUNNING] [00014.163] 01048.01051> [PASSED] (7 ms) [00014.163] 01048.01051> suspend_commit_test [RUNNING] [00014.171] 01048.01051> [PASSED] (7 ms) [00014.171] 01048.01051> CASE commit_tests [PASSED] [00014.171] 01048.01051> CASE clone_tests [STARTED] [00014.171] 01048.01051> clone_read_from_clone_test_vmar [RUNNING] [00014.189] 01048.01051> [PASSED] (17 ms) [00014.189] 01048.01051> clone_read_from_clone_test_vmo [RUNNING] [00014.196] 01048.01051> [PASSED] (7 ms) [00014.196] 01048.01051> clone_read_from_parent_test_vmar [RUNNING] [00014.205] 01048.01051> [PASSED] (8 ms) [00014.205] 01048.01051> clone_read_from_parent_test_vmo [RUNNING] [00014.213] 01048.01051> [PASSED] (7 ms) [00014.213] 01048.01051> clone_simultaneous_read_test_vmar [RUNNING] [00014.221] 01048.01051> [PASSED] (7 ms) [00014.221] 01048.01051> clone_simultaneous_read_test_vmo [RUNNING] [00014.228] 01048.01051> [PASSED] (7 ms) [00014.228] 01048.01051> clone_simultaneous_child_read_test_vmar [RUNNING] [00014.237] 01048.01051> [PASSED] (8 ms) [00014.237] 01048.01051> clone_simultaneous_child_read_test_vmo [RUNNING] [00014.246] 01048.01051> [PASSED] (8 ms) [00014.246] 01048.01051> clone_write_to_clone_test [RUNNING] [00014.253] 01048.01051> [PASSED] (7 ms) [00014.253] 01048.01051> clone_detach_test [RUNNING] [00014.261] 01048.01051> [PASSED] (7 ms) [00014.261] 01048.01051> clone_commit_test [RUNNING] [00014.268] 01048.01051> [PASSED] (7 ms) [00014.268] 01048.01051> clone_split_commit_test [RUNNING] [00014.276] 01048.01051> [PASSED] (7 ms) [00014.276] 01048.01051> clone_decommit_test [RUNNING] [00014.276] 01048.01051> [PASSED] (0 ms) [00014.276] 01048.01051> CASE clone_tests [PASSED] [00014.276] 01048.01051> CASE lifecycle_tests [STARTED] [00014.276] 01048.01051> vmo_info_pager_test [RUNNING] [00014.276] 01048.01051> [PASSED] (0 ms) [00014.276] 01048.01051> detach_page_complete_test [RUNNING] [00014.276] 01048.01051> [PASSED] (0 ms) [00014.276] 01048.01051> close_page_complete_test [RUNNING] [00014.276] 01048.01051> [PASSED] (0 ms) [00014.276] 01048.01051> read_detach_interrupt_late_test_vmar [RUNNING] [00014.277] 01048.02939> PageFault: 1029035 free pages [00014.323] 01048.01051> [PASSED] (47 ms) [00014.323] 01048.01051> read_detach_interrupt_late_test_vmo [RUNNING] [00014.331] 01048.01051> [PASSED] (7 ms) [00014.331] 01048.01051> read_close_interrupt_late_test_vmar [RUNNING] [00014.331] 01048.02958> PageFault: 1029034 free pages [00014.341] 01048.01051> [PASSED] (10 ms) [00014.341] 01048.01051> read_close_interrupt_late_test_vmo [RUNNING] [00014.348] 01048.01051> [PASSED] (7 ms) [00014.348] 01048.01051> read_detach_interrupt_early_test_vmar [RUNNING] [00014.349] 01048.02977> PageFault: 1029034 free pages [00014.358] 01048.01051> [PASSED] (10 ms) [00014.358] 01048.01051> read_detach_interrupt_early_test_vmo [RUNNING] [00014.366] 01048.01051> [PASSED] (7 ms) [00014.366] 01048.01051> read_close_interrupt_early_test_vmar [RUNNING] [00014.366] 01048.02996> PageFault: 1029034 free pages [00014.377] 01048.01051> [PASSED] (10 ms) [00014.377] 01048.01051> read_close_interrupt_early_test_vmo [RUNNING] [00014.385] 01048.01051> [PASSED] (8 ms) [00014.385] 01048.01051> thread_kill_test_vmar [RUNNING] [00014.393] 01048.01051> [PASSED] (7 ms) [00014.393] 01048.01051> thread_kill_test_vmo [RUNNING] [00014.401] 01048.01051> [PASSED] (7 ms) [00014.401] 01048.01051> thread_kill_overlap_test_vmar [RUNNING] [00014.408] 01048.01051> [PASSED] (7 ms) [00014.408] 01048.01051> thread_kill_overlap_test_vmo [RUNNING] [00014.416] 01048.01051> [PASSED] (7 ms) [00014.416] 01048.01051> close_pager_test [RUNNING] [00014.416] 01048.03084> PageFault: 1028962 free pages [00014.426] 01048.01051> [PASSED] (10 ms) [00014.426] 01048.01051> detach_close_pager_test [RUNNING] [00014.426] 01048.01051> [PASSED] (0 ms) [00014.426] 01048.01051> close_port_test [RUNNING] [00014.426] 01048.03096> PageFault: 1028959 free pages [00014.443] 01048.01051> [PASSED] (16 ms) [00014.443] 01048.01051> CASE lifecycle_tests [PASSED] [00014.443] 01048.01051> CASE pager_read_tests [STARTED] [00014.443] 01048.01051> single_page_test_vmar [RUNNING] [00014.460] 01048.01051> [PASSED] (16 ms) [00014.460] 01048.01051> single_page_test_vmo [RUNNING] [00014.467] 01048.01051> [PASSED] (7 ms) [00014.467] 01048.01051> presupply_test_vmar [RUNNING] [00014.474] 01048.01051> [PASSED] (7 ms) [00014.474] 01048.01051> presupply_test_vmo [RUNNING] [00014.481] 01048.01051> [PASSED] (7 ms) [00014.481] 01048.01051> early_supply_test_vmar [RUNNING] [00014.489] 01048.01051> [PASSED] (7 ms) [00014.489] 01048.01051> early_supply_test_vmo [RUNNING] [00014.497] 01048.01051> [PASSED] (7 ms) [00014.497] 01048.01051> sequential_multipage_test_vmar [RUNNING] [00014.508] 01048.01051> [PASSED] (10 ms) [00014.508] 01048.01051> sequential_multipage_test_vmo [RUNNING] [00014.519] 01048.01051> [PASSED] (11 ms) [00014.519] 01048.01051> concurrent_multipage_access_test_vmar [RUNNING] [00014.528] 01048.01051> [PASSED] (8 ms) [00014.528] 01048.01051> concurrent_multipage_access_test_vmo [RUNNING] [00014.536] 01048.01051> [PASSED] (8 ms) [00014.536] 01048.01051> concurrent_overlapping_access_test_vmar [RUNNING] [00014.567] 01048.01051> [PASSED] (31 ms) [00014.567] 01048.01051> concurrent_overlapping_access_test_vmo [RUNNING] [00014.598] 01048.01051> [PASSED] (31 ms) [00014.598] 01048.01051> bulk_single_supply_test_vmar [RUNNING] [00014.612] 01048.01051> [PASSED] (13 ms) [00014.612] 01048.01051> bulk_single_supply_test_vmo [RUNNING] [00014.625] 01048.01051> [PASSED] (12 ms) [00014.625] 01048.01051> bulk_odd_length_supply_test_vmar [RUNNING] [00014.700] 01048.01051> [PASSED] (75 ms) [00014.700] 01048.01051> bulk_odd_length_supply_test_vmo [RUNNING] [00014.779] 01048.01051> [PASSED] (78 ms) [00014.779] 01048.01051> bulk_odd_offset_supply_test_vmar [RUNNING] [00014.853] 01048.01051> [PASSED] (74 ms) [00014.853] 01048.01051> bulk_odd_offset_supply_test_vmo [RUNNING] [00014.930] 01048.01051> [PASSED] (76 ms) [00014.930] 01048.01051> overlap_supply_test_vmar [RUNNING] [00014.938] 01048.01051> [PASSED] (7 ms) [00014.938] 01048.01051> overlap_supply_test_vmo [RUNNING] [00014.945] 01048.01051> [PASSED] (7 ms) [00014.946] 01048.01051> many_request_test_vmar [RUNNING] [00015.123] 01048.01051> [PASSED] (177 ms) [00015.123] 01048.01051> many_request_test_vmo [RUNNING] [00015.307] 01048.01051> [PASSED] (183 ms) [00015.307] 01048.01051> successive_vmo_test [RUNNING] [00015.359] 01048.01051> [PASSED] (51 ms) [00015.359] 01048.01051> multiple_concurrent_vmo_test [RUNNING] [00015.371] 01048.01051> [PASSED] (11 ms) [00015.371] 01048.01051> vmar_unmap_test [RUNNING] [00015.371] 01048.10816> PageFault: 1028689 free pages [00015.381] 01048.01051> [PASSED] (10 ms) [00015.381] 01048.01051> vmar_remap_test [RUNNING] [00015.393] 01048.01051> [PASSED] (12 ms) [00015.393] 01048.01051> vmar_map_range_test [RUNNING] [00015.401] 01048.01051> [PASSED] (7 ms) [00015.401] 01048.01051> read_resize_test_vmar [RUNNING] [00015.409] 01048.01051> [PASSED] (7 ms) [00015.409] 01048.01051> read_resize_test_vmo [RUNNING] [00015.416] 01048.01051> [PASSED] (7 ms) [00015.416] 01048.01051> suspend_read_test_vmar [RUNNING] [00015.424] 01048.01051> [PASSED] (7 ms) [00015.424] 01048.01051> suspend_read_test_vmo [RUNNING] [00015.431] 01048.01051> [PASSED] (7 ms) [00015.431] 01048.01051> CASE pager_read_tests [PASSED] [00015.431] 01048.01051> CASE object_info_tests [STARTED] [00015.431] 01048.01051> handle_valid_on_valid_handle_succeeds [RUNNING] [00015.431] 01048.01051> [PASSED] (0 ms) [00015.431] 01048.01051> handle_valid_on_closed_handle_fails [RUNNING] [00015.431] 01048.01051> [PASSED] (0 ms) [00015.431] 01048.01051> (invalid_handle_fails<ZX_INFO_HANDLE_VALID, void*>) [RUNNING] [00015.431] 01048.01051> [PASSED] (0 ms) [00015.431] 01048.01051> task_stats_unstarted [RUNNING] [00015.431] 01048.01051> [PASSED] (0 ms) [00015.432] 01048.01051> task_stats_smoke [RUNNING] [00015.432] 01048.01051> [PASSED] (0 ms) [00015.432] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t>) [RUNNING] [00015.432] 01048.01051> [PASSED] (0 ms) [00015.432] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING] [00015.432] 01048.01051> [PASSED] (0 ms) [00015.432] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING] [00015.432] 01048.01051> [PASSED] (0 ms) [00015.432] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING] [00015.432] 01048.01051> [PASSED] (0 ms) [00015.432] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING] [00015.432] 01048.01051> [PASSED] (0 ms) [00015.432] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING] [00015.432] 01048.01051> [PASSED] (0 ms) [00015.432] 01048.01051> (wrong_handle_type_fails<ZX_INFO_TASK_STATS, zx_info_task_stats_t, get_test_job>) [RUNNING] [00015.432] 01048.01051> [PASSED] (0 ms) [00015.539] 01048.01051> (wrong_handle_type_fails<ZX_INFO_TASK_STATS, zx_info_task_stats_t, zx_thread_self>) [RUNNING] [00015.539] 01048.01051> [PASSED] (0 ms) [00015.539] 01048.01051> process_maps_unstarted [RUNNING] [00015.539] 01048.01051> [PASSED] (0 ms) [00015.539] 01048.01051> process_maps_smoke [RUNNING] [00015.540] 01048.01051> [PASSED] (0 ms) [00015.540] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t>) [RUNNING] [00015.540] 01048.01051> [PASSED] (0 ms) [00015.540] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING] [00015.540] 01048.01051> [PASSED] (0 ms) [00015.540] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING] [00015.540] 01048.01051> [PASSED] (0 ms) [00015.540] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING] [00015.540] 01048.01051> [PASSED] (0 ms) [00015.540] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING] [00015.540] 01048.01051> [PASSED] (0 ms) [00015.540] 01048.01051> (multi_zero_buffer_succeeds<((zx_object_info_topic_t) 13u), get_test_process>) [RUNNING] [00015.540] 01048.01051> [PASSED] (0 ms) [00015.540] 01048.01051> (short_buffer_succeeds<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING] [00015.540] 01048.01051> [PASSED] (0 ms) [00015.540] 01048.01051> (partially_unmapped_buffer_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING] [00015.540] 01048.01051> [PASSED] (0 ms) [00015.540] 01048.01051> (self_fails<ZX_INFO_PROCESS_MAPS, zx_info_maps_t>) [RUNNING] [00015.540] 01048.01051> [PASSED] (0 ms) [00015.540] 01048.01051> (wrong_handle_type_fails<ZX_INFO_PROCESS_MAPS, zx_info_maps_t, get_test_job>) [RUNNING] [00015.540] 01048.01051> [PASSED] (0 ms) [00015.540] 01048.01051> (wrong_handle_type_fails<ZX_INFO_PROCESS_MAPS, zx_info_maps_t, zx_thread_self>) [RUNNING] [00015.540] 01048.01051> [PASSED] (0 ms) [00015.540] 01048.01051> (missing_rights_fails<ZX_INFO_PROCESS_MAPS, zx_info_maps_t, get_test_process, ZX_RIGHT_INSPECT>) [RUNNING] [00015.540] 01048.01051> [PASSED] (0 ms) [00015.540] 01048.01051> process_vmos_smoke [RUNNING] [00015.667] 01048.01051> [PASSED] (126 ms) [00015.667] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (multi_zero_buffer_succeeds<((zx_object_info_topic_t) 14u), get_test_process>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (short_buffer_succeeds<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (partially_unmapped_buffer_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (self_fails<ZX_INFO_PROCESS_VMOS, zx_info_vmo_t>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (wrong_handle_type_fails<ZX_INFO_PROCESS_VMOS, zx_info_vmo_t, get_test_job>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (wrong_handle_type_fails<ZX_INFO_PROCESS_VMOS, zx_info_vmo_t, zx_thread_self>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (missing_rights_fails<ZX_INFO_PROCESS_VMOS, zx_info_vmo_t, get_test_process, ZX_RIGHT_INSPECT>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> job_processes_smoke [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 9u), zx_koid_t>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (multi_zero_buffer_succeeds<((zx_object_info_topic_t) 9u), get_test_job>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (short_buffer_succeeds<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (partially_unmapped_buffer_fails<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (wrong_handle_type_fails<ZX_INFO_JOB_PROCESSES, zx_koid_t, get_test_process>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (wrong_handle_type_fails<ZX_INFO_JOB_PROCESSES, zx_koid_t, zx_thread_self>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (missing_rights_fails<ZX_INFO_JOB_PROCESSES, zx_koid_t, get_test_job, ZX_RIGHT_ENUMERATE>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> job_children_smoke [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 8u), zx_koid_t>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (multi_zero_buffer_succeeds<((zx_object_info_topic_t) 8u), get_test_job>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (short_buffer_succeeds<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (partially_unmapped_buffer_fails<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.667] 01048.01051> (wrong_handle_type_fails<ZX_INFO_JOB_CHILDREN, zx_koid_t, get_test_process>) [RUNNING] [00015.667] 01048.01051> [PASSED] (0 ms) [00015.668] 01048.01051> (wrong_handle_type_fails<ZX_INFO_JOB_CHILDREN, zx_koid_t, zx_thread_self>) [RUNNING] [00015.668] 01048.01051> [PASSED] (0 ms) [00015.668] 01048.01051> (missing_rights_fails<ZX_INFO_JOB_CHILDREN, zx_koid_t, get_test_job, ZX_RIGHT_ENUMERATE>) [RUNNING] [00015.668] 01048.01051> [PASSED] (0 ms) [00015.668] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t>) [RUNNING] [00015.668] 01048.01051> [PASSED] (0 ms) [00015.668] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING] [00015.668] 01048.01051> [PASSED] (0 ms) [00015.668] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING] [00015.668] 01048.01051> [PASSED] (0 ms) [00015.668] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING] [00015.668] 01048.01051> [PASSED] (0 ms) [00015.668] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING] [00015.668] 01048.01051> [PASSED] (0 ms) [00015.668] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING] [00015.668] 01048.01051> [PASSED] (0 ms) [00015.668] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t>) [RUNNING] [00015.668] 01048.01051> [PASSED] (0 ms) [00015.668] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING] [00015.668] 01048.01051> [PASSED] (0 ms) [00015.668] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING] [00015.668] 01048.01051> [PASSED] (0 ms) [00015.668] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING] [00015.668] 01048.01051> [PASSED] (0 ms) [00015.668] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING] [00015.668] 01048.01051> [PASSED] (0 ms) [00016.069] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING] [00016.069] 01048.01051> [PASSED] (0 ms) [00016.069] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t>) [RUNNING] [00016.069] 01048.01051> [PASSED] (0 ms) [00016.069] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING] [00016.069] 01048.01051> [PASSED] (0 ms) [00016.069] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING] [00016.069] 01048.01051> [PASSED] (0 ms) [00016.069] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING] [00016.069] 01048.01051> [PASSED] (0 ms) [00016.069] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING] [00016.069] 01048.01051> [PASSED] (0 ms) [00016.069] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING] [00016.069] 01048.01051> [PASSED] (0 ms) [00016.069] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t>) [RUNNING] [00016.069] 01048.01051> [PASSED] (0 ms) [00016.069] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING] [00016.069] 01048.01051> [PASSED] (0 ms) [00016.069] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING] [00016.069] 01048.01051> [PASSED] (0 ms) [00016.069] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING] [00016.069] 01048.01051> [PASSED] (0 ms) [00016.069] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 3u), zx_info_process_t>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (wrong_handle_type_fails<ZX_INFO_PROCESS, zx_info_process_t, get_test_job>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (wrong_handle_type_fails<ZX_INFO_PROCESS, zx_info_process_t, zx_thread_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (wrong_handle_type_fails<ZX_INFO_VMAR, zx_info_vmar_t, get_test_job>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (wrong_handle_type_fails<ZX_INFO_VMAR, zx_info_vmar_t, get_test_process>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (wrong_handle_type_fails<ZX_INFO_VMAR, zx_info_vmar_t, zx_thread_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (wrong_handle_type_fails<ZX_INFO_THREAD, zx_info_thread_t, get_test_job>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (wrong_handle_type_fails<ZX_INFO_THREAD, zx_info_thread_t, get_test_process>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (invalid_handle_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (null_avail_actual_succeeds<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (bad_buffer_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (bad_actual_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (bad_avail_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (single_zero_buffer_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (wrong_handle_type_fails<ZX_INFO_THREAD_STATS, zx_info_thread_t, get_test_job>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (wrong_handle_type_fails<ZX_INFO_THREAD_STATS, zx_info_thread_t, get_test_process>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (invalid_handle_fails<ZX_INFO_PROCESS_THREADS, zx_koid_t>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (null_avail_actual_succeeds<ZX_INFO_PROCESS_THREADS, zx_koid_t, get_test_process>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (bad_buffer_fails<ZX_INFO_PROCESS_THREADS, zx_koid_t, get_test_process>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (bad_actual_fails<ZX_INFO_PROCESS_THREADS, zx_koid_t, get_test_process>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (bad_avail_fails<ZX_INFO_PROCESS_THREADS, zx_koid_t, get_test_process>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (multi_zero_buffer_succeeds<ZX_INFO_PROCESS_THREADS, get_test_process>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> (invalid_handle_fails<ZX_INFO_THREAD_EXCEPTION_REPORT, zx_exception_report_t>) [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> handle_count_valid [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> handle_stats_control [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> CASE object_info_tests [PASSED] [00016.070] 01048.01051> CASE object_get_child_tests [STARTED] [00016.070] 01048.01051> handle_invalid [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> CASE object_get_child_tests [PASSED] [00016.070] 01048.01051> CASE memory_mapping_tests [STARTED] [00016.070] 01048.01051> address_space_limits_test [RUNNING] [00016.070] 01048.01051> [PASSED] (0 ms) [00016.070] 01048.01051> mmap_zerofilled_test [RUNNING] [00016.071] 01048.01051> [PASSED] (0 ms) [00016.646] 01048.01051> mmap_len_test [RUNNING] [00016.646] 01048.01051> [PASSED] (0 ms) [00016.646] 01048.01051> mmap_PROT_EXEC_test [RUNNING] [00016.646] 01048.01051> [PASSED] (0 ms) [00016.646] 01048.01051> mmap_offset_test [RUNNING] [00016.647] 01048.01051> [PASSED] (0 ms) [00016.647] 01048.01051> mmap_prot_test [RUNNING] [00016.647] 01048.01051> [PASSED] (0 ms) [00016.647] 01048.01051> mmap_flags_test [RUNNING] [00016.647] 01048.01051> [PASSED] (0 ms) [00016.647] 01048.01051> mprotect_test [RUNNING] [00016.687] 01048.01051> [PASSED] (40 ms) [00016.687] 01048.01051> CASE memory_mapping_tests [PASSED] [00016.687] 01048.01051> CASE job_tests [STARTED] [00016.687] 01048.01051> basic_test [RUNNING] [00016.687] 01048.01051> [PASSED] (0 ms) [00016.687] 01048.01051> create_missing_rights_test [RUNNING] [00016.687] 01048.01051> [PASSED] (0 ms) [00016.687] 01048.01051> policy_invalid_topic_test [RUNNING] [00016.687] 01048.01051> [PASSED] (0 ms) [00016.687] 01048.01051> policy_basic_test [RUNNING] [00016.687] 01048.01051> [PASSED] (0 ms) [00016.687] 01048.01051> policy_timer_slack_invalid_options_test [RUNNING] [00016.687] 01048.01051> [PASSED] (0 ms) [00016.687] 01048.01051> policy_timer_slack_invalid_count_test [RUNNING] [00016.687] 01048.01051> [PASSED] (0 ms) [00016.687] 01048.01051> policy_timer_slack_invalid_policy_test [RUNNING] [00016.687] 01048.01051> [PASSED] (0 ms) [00016.687] 01048.01051> policy_timer_slack_non_empty_test [RUNNING] [00016.687] 01048.01051> [PASSED] (0 ms) [00016.687] 01048.01051> policy_timer_slack_valid [RUNNING] [00016.687] 01048.01051> [PASSED] (0 ms) [00016.687] 01048.01051> create_test [RUNNING] [00016.687] 01048.01051> [PASSED] (0 ms) [00016.687] 01048.01051> kill_test [RUNNING] [00016.775] 01048.01051> [PASSED] (87 ms) [00016.775] 01048.01051> kill_job_no_child_test [RUNNING] [00016.775] 01048.01051> [PASSED] (0 ms) [00016.775] 01048.01051> set_job_oom_kill_bit [RUNNING] [00016.775] 01048.01051> [PASSED] (0 ms) [00016.775] 01048.01051> wait_test [RUNNING] [00016.798] 01048.01051> [PASSED] (22 ms) [00016.798] 01048.01051> info_task_stats_fails [RUNNING] [00016.798] 01048.01051> [PASSED] (0 ms) [00016.798] 01048.01051> max_height_smoke [RUNNING] [00016.798] 01048.01051> [PASSED] (0 ms) [00016.798] 01048.01051> CASE job_tests [PASSED] [00016.798] 01048.01051> CASE handle_wait_tests [STARTED] [00016.798] 01048.01051> handle_wait_test [RUNNING] [00016.830] 01048.01051> [PASSED] (32 ms) [00016.830] 01048.01051> CASE handle_wait_tests [PASSED] [00016.830] 01048.01051> CASE handle_transfer_tests [STARTED] [00016.830] 01048.01051> handle_transfer_test [RUNNING] [00016.830] 01048.01051> [PASSED] (0 ms) [00016.830] 01048.01051> handle_transfer_cancel_wait_test [RUNNING] [00016.866] 01048.01051> [PASSED] (35 ms) [00016.866] 01048.01051> CASE handle_transfer_tests [PASSED] [00016.866] 01048.01051> CASE handle_info_tests [STARTED] [00016.866] 01048.01051> handle_replace_test [RUNNING] [00016.866] 01048.01051> [PASSED] (0 ms) [00016.866] 01048.01051> handle_info_test [RUNNING] [00016.866] 01048.01051> [PASSED] (0 ms) [00016.866] 01048.01051> handle_related_koid_test [RUNNING] [00016.896] 01048.01051> [PASSED] (29 ms) [00016.896] 01048.01051> handle_rights_test [RUNNING] [00016.896] 01048.01051> [PASSED] (0 ms) [00016.896] 01048.01051> CASE handle_info_tests [PASSED] [00016.896] 01048.01051> CASE handle_close_tests [STARTED] [00016.896] 01048.01051> handle_close_many_test [RUNNING] [00016.896] 01048.01051> [PASSED] (0 ms) [00016.896] 01048.01051> handle_close_many_invalid_test [RUNNING] [00016.896] 01048.01051> [PASSED] (0 ms) [00016.896] 01048.01051> handle_close_many_duplicate_test [RUNNING] [00016.896] 01048.01051> [PASSED] (0 ms) [00016.896] 01048.01051> CASE handle_close_tests [PASSED] [00016.896] 01048.01051> CASE futex_tests [STARTED] [00016.896] 01048.01051> TestFutexWaitValueMismatch [RUNNING] [00016.896] 01048.01051> [PASSED] (0 ms) [00016.896] 01048.01051> TestFutexWaitTimeout [RUNNING] [00016.896] 01048.01051> [PASSED] (0 ms) [00016.896] 01048.01051> TestFutexWaitTimeoutElapsed [RUNNING] [00017.397] 01048.01051> [PASSED] (501 ms) [00017.397] 01048.01051> TestFutexWaitBadAddress [RUNNING] [00017.397] 01048.01051> [PASSED] (0 ms) [00017.397] 01048.01051> TestFutexWakeup [RUNNING] [00017.411] 01048.01051> [PASSED] (13 ms) [00017.411] 01048.01051> TestFutexWakeupLimit [RUNNING] [00017.620] 01048.01051> [PASSED] (208 ms) [00017.620] 01048.01051> TestFutexWakeupAddress [RUNNING] [00017.627] 01048.01051> [PASSED] (7 ms) [00017.627] 01048.01051> TestFutexRequeueValueMismatch [RUNNING] [00017.627] 01048.01051> [PASSED] (0 ms) [00017.627] 01048.01051> TestFutexRequeueSameAddr [RUNNING] [00017.627] 01048.01051> [PASSED] (0 ms) [00017.627] 01048.01051> TestFutexRequeue [RUNNING] [00017.950] 01048.01051> [PASSED] (322 ms) [00017.950] 01048.01051> TestFutexRequeueUnqueuedOnTimeout [RUNNING] [00018.251] 01048.01051> [PASSED] (301 ms) [00018.251] 01048.01051> TestFutexThreadKilled [RUNNING] [00018.252] 01048.01051> [PASSED] (0 ms) [00018.252] 01048.01051> TestFutexThreadSuspended [RUNNING] [00018.376] 01048.01051> [PASSED] (123 ms) [00018.376] 01048.01051> TestFutexMisaligned [RUNNING] [00018.376] 01048.01051> [PASSED] (0 ms) [00018.376] 01048.01051> TestEventSignaling [RUNNING] [00018.677] 01048.01051> [PASSED] (301 ms) [00018.677] 01048.01051> CASE futex_tests [PASSED] [00018.677] 01048.01051> CASE fifo_tests [STARTED] [00018.677] 01048.01051> basic_test [RUNNING] [00018.678] 01048.01051> [PASSED] (0 ms) [00018.678] 01048.01051> peer_closed_test [RUNNING] [00018.678] 01048.01051> [PASSED] (0 ms) [00018.678] 01048.01051> options_test [RUNNING] [00018.678] 01048.01051> [PASSED] (0 ms) [00018.678] 01048.01051> CASE fifo_tests [PASSED] [00018.678] 01048.01051> CASE eventpair_tests [STARTED] [00018.678] 01048.01051> create_test [RUNNING] [00018.678] 01048.01051> [PASSED] (0 ms) [00018.678] 01048.01051> signal_test [RUNNING] [00018.678] 01048.01051> [PASSED] (0 ms) [00018.678] 01048.01051> signal_peer_test [RUNNING] [00018.678] 01048.01051> [PASSED] (0 ms) [00018.678] 01048.01051> signal_peer_closed_test [RUNNING] [00018.678] 01048.01051> [PASSED] (0 ms) [00018.678] 01048.01051> CASE eventpair_tests [PASSED] [00018.678] 01048.01051> CASE elf_tls_tests [STARTED] [00018.678] 01048.01051> ExecutableTlsTest [RUNNING] [00019.635] 01048.01051> [PASSED] (957 ms) [00019.635] 01048.01051> CASE elf_tls_tests [PASSED] [00019.635] 01048.01051> CASE cookie_tests [STARTED] [00019.635] 01048.01051> test_cookie_actions [RUNNING] [00019.635] 01048.01051> [PASSED] (0 ms) [00019.635] 01048.01051> test_cookie_eventpair [RUNNING] [00019.635] 01048.01051> [PASSED] (0 ms) [00019.635] 01048.01051> CASE cookie_tests [PASSED] [00019.635] 01048.01051> CASE clock_tests [STARTED] [00019.635] 01048.01051> clock_monotonic_test [RUNNING] [00019.650] 01048.01051> [PASSED] (14 ms) [00019.650] 01048.01051> CASE clock_tests [PASSED] [00019.650] 01048.01051> CASE channel_tests [STARTED] [00019.650] 01048.01051> channel_test [RUNNING] [00019.650] 01048.01051> [PASSED] (0 ms) [00019.651] 01048.01051> channel_read_error_test [RUNNING] [00019.651] 01048.01051> [PASSED] (0 ms) [00019.651] 01048.01051> channel_close_test [RUNNING] [00019.651] 01048.01051> [PASSED] (0 ms) [00019.651] 01048.01051> channel_peer_closed_test [RUNNING] [00019.651] 01048.01051> [PASSED] (0 ms) [00019.651] 01048.01051> channel_non_transferable [RUNNING] [00019.651] 01048.01051> [PASSED] (0 ms) [00019.651] 01048.01051> channel_duplicate_handles [RUNNING] [00019.651] 01048.01051> [PASSED] (0 ms) [00019.651] 01048.01051> channel_multithread_read [RUNNING] [00019.786] 01048.01051> [PASSED] (135 ms) [00019.786] 01048.01051> channel_may_discard [RUNNING] [00019.786] 01048.01051> [PASSED] (0 ms) [00019.786] 01048.01051> channel_call [RUNNING] [00019.789] 01048.01051> [PASSED] (2 ms) [00019.789] 01048.01051> channel_call_consumes_handles [RUNNING] [00019.789] 01048.01051> [PASSED] (0 ms) [00019.789] 01048.01051> channel_call2 [RUNNING] [00020.064] 01048.01051> [PASSED] (274 ms) [00020.064] 01048.01051> bad_channel_call_finish [RUNNING] [00020.064] 01048.01051> [PASSED] (0 ms) [00020.064] 01048.01051> channel_nest [RUNNING] [00020.065] 01048.01051> [PASSED] (1 ms) [00020.065] 01048.01051> channel_disallow_write_to_self [RUNNING] [00020.065] 01048.01051> [PASSED] (0 ms) [00020.065] 01048.01051> channel_read_etc [RUNNING] [00020.065] 01048.01051> [PASSED] (0 ms) [00020.065] 01048.01051> channel_write_different_sizes [RUNNING] [00020.138] 01048.01051> [PASSED] (73 ms) [00020.138] 01048.01051> channel_write_takes_all_handles [RUNNING] [00020.140] 01048.01051> [PASSED] (1 ms) [00020.140] 01048.01051> CASE channel_tests [PASSED] [00020.140] 01048.01051> CASE c11_thread_tests [STARTED] [00020.140] 01048.01051> c11_thread_test [RUNNING] [00020.946] 01048.01051> [PASSED] (805 ms) [00020.946] 01048.01051> long_name_succeeds [RUNNING] [00021.047] 01048.01051> [PASSED] (100 ms) [00021.047] 01048.01051> detach_self_test [RUNNING] [00022.018] 01048.01051> [PASSED] (971 ms) [00022.018] 01048.01051> CASE c11_thread_tests [PASSED] [00022.018] 01048.01051> CASE mtx_tests [STARTED] [00022.018] 01048.01051> test_initializer [RUNNING] [00022.018] 01048.01051> [PASSED] (0 ms) [00022.018] 01048.01051> test_mutexes [RUNNING] [00022.105] 01048.01051> [PASSED] (86 ms) [00022.105] 01048.01051> test_try_mutexes [RUNNING] [00022.190] 01048.01051> [PASSED] (85 ms) [00022.190] 01048.01051> test_static_initializer [RUNNING] [00022.190] 01048.01051> [PASSED] (0 ms) [00022.190] 01048.01051> test_timeout_elapsed [RUNNING] [00022.706] 01048.01051> [PASSED] (515 ms) [00022.706] 01048.01051> CASE mtx_tests [PASSED] [00022.706] 01048.01051> CASE cnd_tests [STARTED] [00022.706] 01048.01051> cnd_test [RUNNING] [00022.724] 01048.01051> [PASSED] (17 ms) [00022.724] 01048.01051> cnd_timedwait_timeout_test [RUNNING] [00022.725] 01048.01051> [PASSED] (1 ms) [00022.725] 01048.01051> CASE cnd_tests [PASSED] [00022.725] 01048.01051> CASE bad_syscall_tests [STARTED] [00022.725] 01048.01051> bad_access_test [RUNNING] [00022.725] 01048.01051> [PASSED] (0 ms) [00022.725] 01048.01051> bad_syscall_num_test [RUNNING] [00022.755] 01048.01051> [PASSED] (29 ms) [00022.755] 01048.01051> CASE bad_syscall_tests [PASSED] [00022.755] 01048.01051> ==================================================== [00022.755] 01048.01051> Results: [00022.755] 01048.01051> SUCCESS! All test cases passed! [00022.755] 01048.01051> CASES: 42 SUCCESS: 42 FAILED: 0 [00022.755] 01048.01051> ==================================================== [00022.756] 01048.01051> core-tests succeeded RZMm59f7zOSs6aZUIXZR [00022.787] 01034.01041> userboot: loader-service channel peer closed [00022.788] 01034.01041> userboot: Waiting for bin/core-tests to exit... [00022.796] 01034.01041> userboot: Process exited. Executing "poweroff". [00022.800] 01034.01041> mp_unplug_cpu_mask_single_locked:357: WARNING: leaking thread for cpu 3 [00022.806] 01034.01041> mp_unplug_cpu_mask_single_locked:357: WARNING: leaking thread for cpu 2 [00022.812] 01034.01041> mp_unplug_cpu_mask_single_locked:357: WARNING: leaking thread for cpu 1 [00022.812] 01034.01041> Shutting down debuglog 2019/03/22 20:49:54 successful QEMU exit status: 31