2019/03/26 17:10:37 QEMU invocation:
[/b/s/w/ir/qemu/bin/qemu-system-aarch64 -machine virt,gic_version=host -cpu host -enable-kvm -m 4096 -smp 4 -nographic -serial stdio -monitor none -kernel /b/s/w/ir/qemu-boot-shim.bin -initrd /b/s/w/ir/core-tests-arm64.zbi -append kernel.halt-on-panic=true devmgr.suspend-timeout-debug=true TERM=dumb]
[00000.000] 00000.00000> PMM: boot reserve add [0x485c0000, 0x48784fff]
[00000.000] 00000.00000> mem_arena.base 0x40000000 size 0x8000000
[00000.000] 00000.00000> overriding mem arena 0 base from FDT: 0x40000000
[00000.000] 00000.00000> overriding mem arena 0 size from FDT: 0x100000000
[00000.000] 00000.00000> detected GICv3
[00000.000] 00000.00000> PSCI version 1.0
[00000.000] 00000.00000> PSCI supported features:
[00000.000] 00000.00000> PSCI64_SYSTEM_OFF 0
[00000.000] 00000.00000> PSCI64_SYSTEM_RESET 0
[00000.000] 00000.00000> PSCI64_CPU_ON 0
[00000.000] 00000.00000> PSCI64_CPU_OFF 0
[00000.000] 00000.00000> arm generic timer freq 200000000 Hz
[00001.681] 00000.00000> cntpct_per_ns: 00000000.3333333333333333
[00001.681] 00000.00000> ns_per_cntpct: 00000005.0000000000000000
[00001.681] 00000.00000> test_time_conversion_check_result:253: FAIL, off by 230584300921369395
[00001.681] 00000.00000> reserving ramdisk phys range [0x48000000, 0x48469fff]
[00001.681] 00000.00000> PMM: boot reserve add [0x48000000, 0x48469fff]
[00001.735] 00000.00000> PMM: boot reserve marking WIRED [0x48000000, 0x48469fff]
[00001.735] 00000.00000> PMM: boot reserve marking WIRED [0x485c0000, 0x48784fff]
[00001.735] 00000.00000>
[00001.735] 00000.00000> welcome to Zircon
[00001.735] 00000.00000>
[00001.735] 00000.00000> KASLR: .text section at 0xffffffff10000000
[00001.735] 00000.00000> INIT: cpu 0, calling hook 0xffffffff10011b20 (global_prng_seed) at level 0x30000, flags 0x1
[00001.749] 00000.00000> initializing vm pre-heap
[00001.749] 00000.00000> VM: marking boot alloc used range [0x48785000, 0x4878a040)
[00001.751] 00000.00000> INIT: cpu 0, calling hook 0xffffffff1001f060 (elf_build_id) at level 0x4fffe, flags 0x1
[00001.751] 00000.00000> INIT: cpu 0, calling hook 0xffffffff1001f230 (version) at level 0x4ffff, flags 0x1
[00001.751] 00000.00000> version:
[00001.751] 00000.00000> arch: arm64
[00001.751] 00000.00000> platform: XXX
[00001.751] 00000.00000> target: XXX
[00001.751] 00000.00000> project: arm64
[00001.751] 00000.00000> buildid: git-0f192d2e18a63b9428bcda071d0a4c25f58037d3-dirty
[00001.751] 00000.00000> ELF build ID: 5764578902a21596a7a4c4466ecabb90534dfbf7
[00001.751] 00000.00000> initializing heap
[00001.751] 00000.00000> INIT: cpu 0, calling hook 0xffffffff100014c0 (arm_resource_init) at level 0x50000, flags 0x1
[00001.751] 00000.00000> INIT: cpu 0, calling hook 0xffffffff10003600 (console) at level 0x50000, flags 0x1
[00001.751] 00000.00000> initializing vm
[00001.751] 00000.00000> VM: reserving kernel region [0xffffffff10000000, 0xffffffff10100000) flags 0x28 name 'kernel_code'
[00001.752] 00000.00000> VM: reserving kernel region [0xffffffff10100000, 0xffffffff10144000) flags 0x8 name 'kernel_rodata'
[00001.752] 00000.00000> VM: reserving kernel region [0xffffffff10144000, 0xffffffff1014e000) flags 0x18 name 'kernel_data'
[00001.752] 00000.00000> VM: reserving kernel region [0xffffffff10150000, 0xffffffff101c5000) flags 0x18 name 'kernel_bss'
[00001.752] 00000.00000> INIT: cpu 0, calling hook 0xffffffff100014b0 (platform_postvm) at level 0x60000, flags 0x1
[00001.752] 00000.00000> CreateSubVmarInternal:114: warning: mapping periph has conflicting cache policies: vmo 00 arch_mmu_flags 02.
[00001.752] 00000.00000> initializing kernel
[00001.752] 00000.00000> initializing mp
[00001.752] 00000.00000> initializing timers
[00001.752] 00000.00000> INIT: cpu 0, calling hook 0xffffffff10001920 (platform_init_pre_thread) at level 0x7ffff, flags 0x1
[00001.754] 00000.00000> System topology: CPU 0:0:0:0
[00001.754] 00000.00000> System topology: CPU 0:0:0:1
[00001.754] 00000.00000> System topology: CPU 0:0:0:2
[00001.754] 00000.00000> System topology: CPU 0:0:0:3
[00001.754] 00000.00000> INIT: cpu 0, calling hook 0xffffffff10011d70 (global_prng_thread_safe) at level 0x7ffff, flags 0x1
[00001.754] 00000.00000> INIT: cpu 0, calling hook 0xffffffff1001e130 (debuglog) at level 0x7ffff, flags 0x1
[00001.754] 00000.00000> INIT: cpu 0, calling hook 0xffffffff100cfc40 (thread_set_priority_experiment) at level 0x7ffff, flags 0x1
[00001.754] 00000.00000> thread set priority experiment is : ENABLED
[00001.754] 00000.00000> creating bootstrap completion thread
[00001.807] 00000.00000> top of bootstrap2()
[00001.807] 00000.00000> INIT: cpu 0, calling hook 0xffffffff1002de70 (libobject) at level 0x80000, flags 0x1
[00001.807] 00000.00000> OOM: started thread
[00001.809] 00000.00000> INIT: cpu 0, calling hook 0xffffffff100eba80 (dpc) at level 0x80000, flags 0x1
[00001.811] 00000.00000> ARM boot EL1
[00001.811] 00000.00000> ARM cpu 0: midr 0x431f0af1 'Cavium CN99XX r1p1' mpidr 0x80000000 aff 0:0:0:0
[00001.811] 00000.00000> ARM Features: fp asimd aes pmull sha1 sha2 crc32 atomics rdm
[00001.811] 00000.00000> ARM cache line sizes: icache 64 dcache 64 zva 64
[00001.811] 00000.00000> ==== ARM64 CACHE INFO CORE 0 ====
[00001.811] 00000.00000> Inner Boundary = L0
[00001.811] 00000.00000> Level of Unification Uniprocessor = L1
[00001.811] 00000.00000> Level of Coherence = L3
[00001.811] 00000.00000> Level of Unification Inner Shareable = L1
[00001.811] 00000.00000> L1 Details: Data Cache, sets=64, associativity=8, line size=64 bytes
[00001.811] 00000.00000> Instruction Cache, sets=64, associativity=8, line size=64 bytes
[00001.811] 00000.00000> L2 Details: Unified Cache, sets=512, associativity=8, line size=64 bytes
[00001.811] 00000.00000> L3 Details: Unified Cache, sets=16384, associativity=32, line size=64 bytes
[00001.811] 00000.00000> L4 Details: Not Implemented
[00001.811] 00000.00000> L5 Details: Not Implemented
[00001.811] 00000.00000> L6 Details: Not Implemented
[00001.811] 00000.00000> L7 Details: Not Implemented
[00001.811] 00000.00000> initializing platform
[00001.811] 00000.00000> INIT: cpu 0, calling hook 0xffffffff1008d270 (arm64_perfmon) at level 0x90000, flags 0x1
[00001.811] 00000.00000> Trying to start cpu 1 returned: 0
[00001.811] 00000.00000> Trying to start cpu 2 returned: 0
[00001.811] 00000.00000> Trying to start cpu 3 returned: 0
[00001.811] 00000.00000> initializing target
[00001.811] 00000.00000> INIT: cpu 0, calling hook 0xffffffff100827e0 (platform_dev_init) at level 0xa0000, flags 0x1
[00001.811] 00000.00000> UART: started IRQ driven TX
[00001.811] 00000.00000> moving to last init level
[00001.811] 00000.00000> INIT: cpu 0, calling hook 0xffffffff100040d0 (kernel_shell) at level 0xc0000, flags 0x1
[00001.811] 00000.00000> INIT: cpu 0, calling hook 0xffffffff100e83c0 (ktrace) at level 0xc0000, flags 0x1
[00001.878] 00000.00000> ktrace: buffer at 0xffff0086f2ccb000 (33554432 bytes)
[00001.878] 00000.00000> INIT: cpu 0, calling hook 0xffffffff100fa450 (userboot) at level 0xc0000, flags 0x1
[00001.878] 00000.00000> userboot: ramdisk 0x46a000 @ 0xffff000048000000
[00001.878] 00000.00000> userboot: userboot rodata 0 @ [0xa7759aa37000,0xa7759aa3a000)
[00001.878] 00000.00000> userboot: userboot code 0x3000 @ [0xa7759aa3a000,0xa7759aa44000)
[00001.878] 00000.00000> userboot: vdso/full rodata 0 @ [0xa7759aa44000,0xa7759aa4b000)
[00001.878] 00000.00000> userboot: vdso/full code 0x7000 @ [0xa7759aa4b000,0xa7759aa4d000)
[00001.878] 00000.00000> userboot: entry point @ 0xa7759aa3ac30
[00001.888] 01032.01039> userboot: option "userboot=bin/core-tests"
[00001.888] 01032.01039> userboot: option "userboot.shutdown="
[00001.888] 01032.01039> userboot: option "kernel.halt-on-panic=true"
[00001.888] 01032.01039> userboot: option "devmgr.suspend-timeout-debug=true"
[00001.888] 01032.01039> userboot: option "TERM=dumb"
[00001.928] 01032.01039> userboot: searching bootfs for 'bin/core-tests'
[00001.928] 01032.01039> userboot: 'bin/core-tests' has PT_INTERP "lib/asan/ld.so.1"
[00001.928] 01032.01039> userboot: searching bootfs for 'lib/asan/ld.so.1'
[00001.928] 01032.01039> userboot: userboot: loaded lib/asan/ld.so.1 at 0xfa66f48ec000, entry point 0xfa66f49b7aac
[00001.928] 01032.01039> userboot: userboot: loaded vDSO at 0xb947d4a80000, entry point 0x0
[00001.934] 01032.01039> userboot: process bin/core-tests started.
[00001.934] 01032.01039> userboot: waiting for loader-service requests...
[00001.936] 01032.01039> userboot: searching bootfs for 'lib/asan/libclang_rt.asan.so'
[00001.936] 01032.01039> userboot: file not found
[00001.936] 01032.01039> userboot: searching bootfs for 'lib/libclang_rt.asan.so'
[00001.954] 01032.01039> userboot: searching bootfs for 'lib/asan/libc++abi.so.1'
[00001.955] 01032.01039> userboot: searching bootfs for 'lib/asan/libunwind.so.1'
[00001.956] 01032.01039> userboot: searching bootfs for 'lib/asan/libfdio.so'
[00001.957] 01032.01039> userboot: searching bootfs for 'lib/asan/libunittest.so'
[00001.958] 01032.01039> userboot: searching bootfs for 'lib/asan/libmini-process.so'
[00001.960] 01032.01039> userboot: searching bootfs for 'lib/asan/libbacktrace.so'
[00001.961] 01032.01039> userboot: searching bootfs for 'lib/asan/libngunwind.so'
[00001.966] 01046.01049> {{{reset}}}
[00001.966] 01046.01049> {{{module:0:<application>:elf:965c235ad1d6fcd7}}}
[00001.966] 01046.01049> {{{mmap:0xd00ce8e7d000:0x75000:load:0:r:0}}}
[00001.966] 01046.01049> {{{mmap:0xd00ce8ef2000:0x16e000:load:0:rx:0x75000}}}
[00001.966] 01046.01049> {{{mmap:0xd00ce9060000:0x5a000:load:0:rw:0x1e3000}}}
[00001.966] 01046.01049> dso: id=965c235ad1d6fcd7 base=0x0000d00ce8e7d000 name=<application>
[00001.966] 01046.01049> {{{module:0x3:libclang_rt.asan.so:elf:3691f56d7e7762f6}}}
[00001.966] 01046.01049> {{{mmap:0x9b37438f5000:0x20000:load:0x3:r:0}}}
[00001.966] 01046.01049> {{{mmap:0x9b3743915000:0x38000:load:0x3:rx:0x20000}}}
[00001.966] 01046.01049> {{{mmap:0x9b3743955000:0x982000:load:0x3:rw:0x60000}}}
[00001.966] 01046.01049> dso: id=3691f56d7e7762f6 base=0x00009b37438f5000 name=libclang_rt.asan.so
[00001.966] 01046.01049> {{{module:0x6:libfdio.so:elf:ea55203f02662d86}}}
[00001.966] 01046.01049> {{{mmap:0xac5670227000:0x14000:load:0x6:r:0}}}
[00001.966] 01046.01049> {{{mmap:0xac567023b000:0x46000:load:0x6:rx:0x14000}}}
[00001.966] 01046.01049> {{{mmap:0xac5670281000:0xe000:load:0x6:rw:0x5a000}}}
[00001.966] 01046.01049> dso: id=ea55203f02662d86 base=0x0000ac5670227000 name=libfdio.so
[00001.966] 01046.01049> {{{module:0x7:libunittest.so:elf:7e4b9183bd1cf406}}}
[00001.966] 01046.01049> {{{mmap:0xb9fd31502000:0x6000:load:0x7:r:0}}}
[00001.966] 01046.01049> {{{mmap:0xb9fd31508000:0x5000:load:0x7:rx:0x6000}}}
[00001.966] 01046.01049> {{{mmap:0xb9fd3150d000:0x5000:load:0x7:rw:0xb000}}}
[00001.966] 01046.01049> dso: id=7e4b9183bd1cf406 base=0x0000b9fd31502000 name=libunittest.so
[00001.966] 01046.01049> {{{module:0x2:<vDSO>:elf:ecd6324cd4d019ee0efe56cb03dbc28e57eb65ef}}}
[00001.966] 01046.01049> {{{mmap:0xb947d4a80000:0x7000:load:0x2:r:0}}}
[00001.966] 01046.01049> {{{mmap:0xb947d4a87000:0x2000:load:0x2:rx:0x7000}}}
[00001.966] 01046.01049> dso: id=ecd6324cd4d019ee0efe56cb03dbc28e57eb65ef base=0x0000b947d4a80000 name=<vDSO>
[00001.966] 01046.01049> {{{module:0x8:libmini-process.so:elf:d735cfe3b9782fc4}}}
[00001.966] 01046.01049> {{{mmap:0x912d63184000:0x3000:load:0x8:r:0}}}
[00001.966] 01046.01049> {{{mmap:0x912d63187000:0x4000:load:0x8:rx:0x3000}}}
[00001.966] 01046.01049> {{{mmap:0x912d6318b000:0x3000:load:0x8:rw:0x7000}}}
[00001.966] 01046.01049> dso: id=d735cfe3b9782fc4 base=0x0000912d63184000 name=libmini-process.so
[00001.966] 01046.01049> {{{module:0x9:libbacktrace.so:elf:d27e5eb8bd8da525}}}
[00001.966] 01046.01049> {{{mmap:0x85bf5c900000:0x4000:load:0x9:r:0}}}
[00001.966] 01046.01049> {{{mmap:0x85bf5c904000:0x1d000:load:0x9:rx:0x4000}}}
[00001.966] 01046.01049> {{{mmap:0x85bf5c921000:0x3000:load:0x9:rw:0x21000}}}
[00001.966] 01046.01049> dso: id=d27e5eb8bd8da525 base=0x000085bf5c900000 name=libbacktrace.so
[00001.966] 01046.01049> {{{module:0xa:libngunwind.so:elf:3200de7e1c54d36b}}}
[00001.966] 01046.01049> {{{mmap:0x61dcc201a000:0xc000:load:0xa:r:0}}}
[00001.966] 01046.01049> {{{mmap:0x61dcc2026000:0x2a000:load:0xa:rx:0xc000}}}
[00001.966] 01046.01049> {{{mmap:0x61dcc2050000:0x4e000:load:0xa:rw:0x36000}}}
[00001.966] 01046.01049> dso: id=3200de7e1c54d36b base=0x000061dcc201a000 name=libngunwind.so
[00001.966] 01046.01049> {{{module:0x4:libc++abi.so.1:elf:afabd14fa351bf88}}}
[00001.966] 01046.01049> {{{mmap:0xbc60f3b2d000:0x33000:load:0x4:r:0}}}
[00001.966] 01046.01049> {{{mmap:0xbc60f3b6d000:0x60000:load:0x4:rx:0x40000}}}
[00001.966] 01046.01049> {{{mmap:0xbc60f3bcd000:0x21000:load:0x4:rw:0xa0000}}}
[00001.966] 01046.01049> dso: id=afabd14fa351bf88 base=0x0000bc60f3b2d000 name=libc++abi.so.1
[00001.966] 01046.01049> {{{module:0x5:libunwind.so.1:elf:5214f8492511c394}}}
[00001.966] 01046.01049> {{{mmap:0xaa30fbdfa000:0x11000:load:0x5:r:0}}}
[00001.966] 01046.01049> {{{mmap:0xaa30fbe1a000:0xf000:load:0x5:rx:0x20000}}}
[00001.966] 01046.01049> {{{mmap:0xaa30fbe2a000:0x21000:load:0x5:rw:0x30000}}}
[00001.966] 01046.01049> dso: id=5214f8492511c394 base=0x0000aa30fbdfa000 name=libunwind.so.1
[00001.966] 01046.01049> {{{module:0x1:libc.so:elf:b7945be572506f49}}}
[00001.966] 01046.01049> {{{mmap:0xfa66f48ec000:0x76000:load:0x1:r:0}}}
[00001.966] 01046.01049> {{{mmap:0xfa66f4962000:0xf0000:load:0x1:rx:0x76000}}}
[00001.966] 01046.01049> {{{mmap:0xfa66f4a52000:0x20000:load:0x1:rw:0x166000}}}
[00001.966] 01046.01049> dso: id=b7945be572506f49 base=0x0000fa66f48ec000 name=libc.so
[00001.968] 01046.01049> TEST
[00002.024] 01046.01049>
CASE resource_tests [STARTED]
[00002.024] 01046.01049> probe_address_space [RUNNING]
[00002.024] 01046.01049> [PASSED] (0 ms)
[00002.024] 01046.01049> TestBasicActions [RUNNING]
[00002.024] 01046.01049> [PASSED] (0 ms)
[00002.024] 01046.01049> TestExclusiveShared [RUNNING]
[00002.024] 01046.01049> [PASSED] (0 ms)
[00002.024] 01046.01049> TestSharedExclusive [RUNNING]
[00002.024] 01046.01049> [PASSED] (0 ms)
[00002.024] 01046.01049> TestInvalidArgs [RUNNING]
[00002.024] 01046.01049> [PASSED] (0 ms)
[00002.024] 01046.01049> TestVmoCreation [RUNNING]
[00002.024] 01046.01049> [PASSED] (0 ms)
[00002.024] 01046.01049> TestVmoCreationSmaller [RUNNING]
[00002.024] 01046.01049> [PASSED] (0 ms)
[00002.024] 01046.01049> TestVmoCreationUnaligned [RUNNING]
[00002.024] 01046.01049> [PASSED] (0 ms)
[00002.024] 01046.01049> TestVmoReplaceAsExecutable [RUNNING]
[00002.024] 01046.01049> [PASSED] (0 ms)
[00002.024] 01046.01049> CASE resource_tests [PASSED]
[00002.024] 01046.01049>
CASE profile_tests [STARTED]
[00002.024] 01046.01049> make_profile_fails [RUNNING]
[00002.024] 01046.01049> [PASSED] (0 ms)
[00002.024] 01046.01049> change_priority_via_profile [RUNNING]
[00002.046] 01046.01049> [PASSED] (21 ms)
[00002.046] 01046.01049> CASE profile_tests [PASSED]
[00002.046] 01046.01049>
CASE interrupt_tests [STARTED]
[00002.046] 01046.01049> interrupt_test [RUNNING]
[00002.046] 01046.01049> [PASSED] (0 ms)
[00002.046] 01046.01049> interrupt_port_bound_test [RUNNING]
[00002.046] 01046.01049> [PASSED] (0 ms)
[00002.046] 01046.01049> interrupt_port_non_bindable_test [RUNNING]
[00002.046] 01046.01049> [PASSED] (0 ms)
[00002.046] 01046.01049> interrupt_suspend_test [RUNNING]
[00002.055] 01046.01049> [PASSED] (9 ms)
[00002.055] 01046.01049> interrupt_bind_vcpu_test [RUNNING]
[00002.055] 01046.01049> Guest creation not supported
[00002.055] 01046.01049> [PASSED] (0 ms)
[00002.055] 01046.01049> interrupt_bind_vcpu_not_supported_test [RUNNING]
[00002.055] 01046.01049> Guest creation not supported
[00002.055] 01046.01049> [PASSED] (0 ms)
[00002.055] 01046.01049> interrupt_bind_vcpu_already_bound_test [RUNNING]
[00002.055] 01046.01049> Guest creation not supported
[00002.055] 01046.01049> [PASSED] (0 ms)
[00002.055] 01046.01049> interrupt_bind_vcpu_multiple_guests_test [RUNNING]
[00002.055] 01046.01049> Guest creation not supported
[00002.055] 01046.01049> [PASSED] (0 ms)
[00002.055] 01046.01049> CASE interrupt_tests [PASSED]
[00002.055] 01046.01049>
CASE vmo_signal_tests [STARTED]
[00002.055] 01046.01049> vmo_signal_sanity_test [RUNNING]
[00002.055] 01046.01049> [PASSED] (0 ms)
[00002.055] 01046.01049> vmo_child_signal_clone_test [RUNNING]
[00002.055] 01046.01049> [PASSED] (0 ms)
[00002.055] 01046.01049> vmo_child_signal_map_test [RUNNING]
[00002.055] 01046.01049> [PASSED] (0 ms)
[00002.055] 01046.01049> CASE vmo_signal_tests [PASSED]
[00002.055] 01046.01049>
CASE vmar_tests [STARTED]
[00002.055] 01046.01049> destroy_root_test [RUNNING]
[00002.056] 01046.01049> [PASSED] (0 ms)
[00002.056] 01046.01049> basic_allocate_test [RUNNING]
[00002.056] 01046.01049> [PASSED] (0 ms)
[00002.056] 01046.01049> allocate_oob_test [RUNNING]
[00002.056] 01046.01049> [PASSED] (0 ms)
[00002.056] 01046.01049> allocate_unsatisfiable_test [RUNNING]
[00002.056] 01046.01049> [PASSED] (0 ms)
[00002.056] 01046.01049> destroyed_vmar_test [RUNNING]
[00002.056] 01046.01049> [PASSED] (0 ms)
[00002.056] 01046.01049> map_over_destroyed_test [RUNNING]
[00002.056] 01046.01049> [PASSED] (0 ms)
[00002.056] 01046.01049> map_in_compact_test [RUNNING]
[00002.056] 01046.01049> [PASSED] (0 ms)
[00002.056] 01046.01049> overmapping_test [RUNNING]
[00002.056] 01046.01049> [PASSED] (0 ms)
[00002.056] 01046.01049> invalid_args_test [RUNNING]
[00002.056] 01046.01049> [PASSED] (0 ms)
[00002.056] 01046.01049> unaligned_len_test [RUNNING]
[00002.056] 01046.01049> [PASSED] (0 ms)
[00002.056] 01046.01049> unaligned_len_map_test [RUNNING]
[00002.056] 01046.01049> [PASSED] (0 ms)
[00002.056] 01046.01049> rights_drop_test [RUNNING]
[00002.056] 01046.01049> [PASSED] (0 ms)
[00002.056] 01046.01049> protect_test [RUNNING]
[00002.056] 01046.01049> [PASSED] (0 ms)
[00002.056] 01046.01049> nested_region_perms_test [RUNNING]
[00002.056] 01046.01049> [PASSED] (0 ms)
[00002.056] 01046.01049> object_info_test [RUNNING]
[00002.056] 01046.01049> [PASSED] (0 ms)
[00002.056] 01046.01049> unmap_split_test [RUNNING]
[00002.056] 01046.01049> [PASSED] (0 ms)
[00002.056] 01046.01049> unmap_multiple_test [RUNNING]
[00002.057] 01046.01049> [PASSED] (0 ms)
[00002.057] 01046.01049> unmap_base_not_mapped_test [RUNNING]
[00002.057] 01046.01049> [PASSED] (0 ms)
[00002.057] 01046.01049> map_specific_overwrite_test [RUNNING]
[00002.057] 01046.01049> [PASSED] (0 ms)
[00002.057] 01046.01049> protect_split_test [RUNNING]
[00002.057] 01046.01049> [PASSED] (0 ms)
[00002.057] 01046.01049> protect_multiple_test [RUNNING]
[00002.057] 01046.01049> [PASSED] (0 ms)
[00002.057] 01046.01049> protect_over_demand_paged_test [RUNNING]
[00002.116] 01046.01049> [PASSED] (58 ms)
[00002.116] 01046.01049> protect_large_uncommitted_test [RUNNING]
[00002.118] 01046.01049> [PASSED] (2 ms)
[00002.118] 01046.01049> unmap_large_uncommitted_test [RUNNING]
[00002.120] 01046.01318> PageFault: 1023933 free pages
[00002.120] 01046.01318> PageFault: MemoryUsed: proc 1032 12M 'userboot'
[00002.120] 01046.01318> PageFault: MemoryUsed: proc 1046 11M 'bin/core-tests'
[00002.122] 01046.01320> PageFault: 1023933 free pages
[00002.122] 01046.01320> PageFault: MemoryUsed: proc 1032 12M 'userboot'
[00002.122] 01046.01320> PageFault: MemoryUsed: proc 1046 11M 'bin/core-tests'
[00002.125] 01046.01322> PageFault: 1023933 free pages
[00002.125] 01046.01322> PageFault: MemoryUsed: proc 1032 12M 'userboot'
[00002.125] 01046.01322> PageFault: MemoryUsed: proc 1046 11M 'bin/core-tests'
[00002.128] 01046.01049> [PASSED] (10 ms)
[00002.128] 01046.01049> partial_unmap_and_read [RUNNING]
[00002.128] 01046.01049> [PASSED] (0 ms)
[00002.128] 01046.01049> partial_unmap_and_write [RUNNING]
[00002.128] 01046.01049> [PASSED] (0 ms)
[00002.128] 01046.01049> partial_unmap_with_vmar_offset [RUNNING]
[00002.128] 01046.01049> [PASSED] (0 ms)
[00002.128] 01046.01049> CASE vmar_tests [PASSED]
[00002.128] 01046.01049>
CASE ticks_tests [STARTED]
[00002.128] 01046.01049> elapsed_time_using_ticks [RUNNING]
[00002.128] 01046.01049> [PASSED] (0 ms)
[00002.128] 01046.01049> CASE ticks_tests [PASSED]
[00002.128] 01046.01049>
CASE threads_tests [STARTED]
[00002.128] 01046.01049> TestBasics [RUNNING]
[00002.228] 01046.01049> [PASSED] (100 ms)
[00002.228] 01046.01049> TestInvalidRights [RUNNING]
[00002.228] 01046.01049> [PASSED] (0 ms)
[00002.228] 01046.01049> TestDetach [RUNNING]
[00002.232] 01046.01049> [PASSED] (3 ms)
[00002.232] 01046.01049> TestLongNameSucceeds [RUNNING]
[00002.232] 01046.01049> [PASSED] (0 ms)
[00002.232] 01046.01049> TestThreadStartOnInitialThread [RUNNING]
[00002.232] 01046.01049> [PASSED] (0 ms)
[00002.232] 01046.01049> TestThreadStartWithZeroInstructionPointer [RUNNING]
[00002.237] 01046.01049> [PASSED] (5 ms)
[00002.237] 01046.01049> TestKillBusyThread [RUNNING]
[00002.349] 01046.01049> [PASSED] (111 ms)
[00002.349] 01046.01049> TestKillSleepThread [RUNNING]
[00002.451] 01046.01049> [PASSED] (101 ms)
[00002.451] 01046.01049> TestKillWaitThread [RUNNING]
[00002.553] 01046.01049> [PASSED] (101 ms)
[00002.553] 01046.01049> TestNonstartedThread [RUNNING]
[00002.553] 01046.01049> [PASSED] (0 ms)
[00002.553] 01046.01049> TestThreadKillsItself [RUNNING]
[00002.557] 01046.01049> [PASSED] (3 ms)
[00002.557] 01046.01049> TestInfoTaskStatsFails [RUNNING]
[00002.657] 01046.01049> [PASSED] (100 ms)
[00002.657] 01046.01049> TestResumeSuspended [RUNNING]
[00002.761] 01046.01049> [PASSED] (104 ms)
[00002.761] 01046.01049> TestSuspendSleeping [RUNNING]
[00002.861] 01046.01049> [PASSED] (100 ms)
[00002.861] 01046.01049> TestSuspendChannelCall [RUNNING]
[00002.863] 01046.01049> [PASSED] (1 ms)
[00002.863] 01046.01049> TestSuspendPortCall [RUNNING]
[00002.967] 00000.00000> INIT: cpu 3, calling hook 0xffffffff100850a0 (arm_generic_timer_init_secondary_cpu) at level 0x7ffff, flags 0x2
[00002.967] 00000.00000> ARM cpu 3: midr 0x431f0af1 'Cavium CN99XX r1p1' mpidr 0x80000003 aff 0:0:0:3
[00002.967] 00000.00000> entering scheduler on cpu 3
[00002.985] 00000.00000> INIT: cpu 1, calling hook 0xffffffff100850a0 (arm_generic_timer_init_secondary_cpu) at level 0x7ffff, flags 0x2
[00002.985] 00000.00000> ARM cpu 1: midr 0x431f0af1 'Cavium CN99XX r1p1' mpidr 0x80000001 aff 0:0:0:1
[00002.985] 00000.00000> entering scheduler on cpu 1
[00003.003] 00000.00000> INIT: cpu 2, calling hook 0xffffffff100850a0 (arm_generic_timer_init_secondary_cpu) at level 0x7ffff, flags 0x2
[00003.003] 00000.00000> ARM cpu 2: midr 0x431f0af1 'Cavium CN99XX r1p1' mpidr 0x80000002 aff 0:0:0:2
[00003.003] 00000.00000> entering scheduler on cpu 2
[00003.065] 01046.01049> [PASSED] (201 ms)
[00003.065] 01046.01049> TestSuspendStopsThread [RUNNING]
[00003.116] 01046.01049> [PASSED] (50 ms)
[00003.116] 01046.01049> TestSuspendMultiple [RUNNING]
[00003.116] 01046.01049> [PASSED] (0 ms)
[00003.116] 01046.01049> TestSuspendSelf [RUNNING]
[00003.116] 01046.01049> [PASSED] (0 ms)
[00003.116] 01046.01049> TestKillSuspendedThread [RUNNING]
[00003.116] 01046.01049> [PASSED] (0 ms)
[00003.116] 01046.01049> TestStartSuspendedThread [RUNNING]
[00003.116] 01046.01049> [PASSED] (0 ms)
[00003.116] 01046.01049> TestStartSuspendedAndResumedThread [RUNNING]
[00003.116] 01046.01049> [PASSED] (0 ms)
[00003.116] 01046.01049> TestSuspendSingleWaitAsyncSignalDelivery [RUNNING]
[00003.117] 01046.01049> [PASSED] (0 ms)
[00003.117] 01046.01049> TestSuspendRepeatingWaitAsyncSignalDelivery [RUNNING]
[00003.117] 01046.01049> [PASSED] (0 ms)
[00003.117] 01046.01049> TestReadingGeneralRegisterState [RUNNING]
[00003.217] 01046.01049> [PASSED] (100 ms)
[00003.217] 01046.01049> TestWritingGeneralRegisterState [RUNNING]
[00003.317] 01046.01049> [PASSED] (100 ms)
[00003.317] 01046.01049> TestNoncanonicalRipAddress [RUNNING]
[00003.317] 01046.01049> [PASSED] (0 ms)
[00003.317] 01046.01049> TestWritingArmFlagsRegister [RUNNING]
[00003.317] 01046.01049> [PASSED] (0 ms)
[00003.318] 01046.01049> CASE threads_tests [PASSED]
[00003.318] 01046.01049>
CASE sync_mutex_tests [STARTED]
[00003.318] 01046.01049> test_mutexes [RUNNING]
[00003.326] 01046.01049> [PASSED] (8 ms)
[00003.326] 01046.01049> test_try_mutexes [RUNNING]
[00003.331] 01046.01049> [PASSED] (4 ms)
[00003.331] 01046.01049> test_timeout_elapsed [RUNNING]
[00003.831] 01046.01049> [PASSED] (500 ms)
[00003.831] 01046.01049> CASE sync_mutex_tests [PASSED]
[00003.831] 01046.01049>
CASE sync_condition_tests [STARTED]
[00003.831] 01046.01049> Condition::condition_test [RUNNING]
[00003.832] 01046.01049> [PASSED] (1 ms)
[00003.832] 01046.01049> Condition::condition_timeout_test [RUNNING]
[00003.833] 01046.01049> [PASSED] (1 ms)
[00003.833] 01046.01049> CASE sync_condition_tests [PASSED]
[00003.833] 01046.01049>
CASE sync_completion_tests [STARTED]
[00003.834] 01046.01049> test_initializer [RUNNING]
[00003.834] 01046.01049> [PASSED] (0 ms)
[00003.834] 01046.01049> test_completions [RUNNING]
[00003.847] 01046.01049> [PASSED] (13 ms)
[00003.847] 01046.01049> test_timeout [RUNNING]
[00003.847] 01046.01049> [PASSED] (0 ms)
[00003.847] 01046.01049> CASE sync_completion_tests [PASSED]
[00003.848] 01046.01049>
CASE sync_completion_tests [STARTED]
[00003.848] 01046.01049> test_initializer [RUNNING]
[00003.848] 01046.01049> [PASSED] (0 ms)
[00003.848] 01046.01049> test_completions [RUNNING]
[00003.858] 01046.01049> [PASSED] (10 ms)
[00003.858] 01046.01049> test_timeout [RUNNING]
[00004.883] 01046.01049> [PASSED] (1025 ms)
[00004.883] 01046.01049> test_signal_requeue [RUNNING]
[00004.899] 01046.01049> [PASSED] (15 ms)
[00004.899] 01046.01049> test_completion_signaled [RUNNING]
[00004.899] 01046.01049> [PASSED] (0 ms)
[00004.899] 01046.01049> CASE sync_completion_tests [PASSED]
[00004.899] 01046.01049>
CASE stack_tests [STARTED]
[00004.899] 01046.01049> main_thread_stack_tests [RUNNING]
[00004.899] 01046.01049> [PASSED] (0 ms)
[00004.899] 01046.01049> other_thread_stack_tests [RUNNING]
[00004.899] 01046.01049> [PASSED] (0 ms)
[00004.899] 01046.01049> CASE stack_tests [PASSED]
[00004.899] 01046.01049>
CASE socket_tests [STARTED]
[00004.899] 01046.01049> socket_basic [RUNNING]
[00004.899] 01046.01049> [PASSED] (0 ms)
[00004.899] 01046.01049> socket_peek [RUNNING]
[00004.899] 01046.01049> [PASSED] (0 ms)
[00004.899] 01046.01049> socket_peek_empty [RUNNING]
[00004.899] 01046.01049> [PASSED] (0 ms)
[00004.899] 01046.01049> socket_signals [RUNNING]
[00004.899] 01046.01049> [PASSED] (0 ms)
[00004.899] 01046.01049> socket_peer_closed_signal [RUNNING]
[00004.899] 01046.01049> [PASSED] (0 ms)
[00004.899] 01046.01049> socket_peer_closed_set_property [RUNNING]
[00004.899] 01046.01049> [PASSED] (0 ms)
[00004.899] 01046.01049> socket_shutdown_write [RUNNING]
[00004.899] 01046.01049> [PASSED] (0 ms)
[00004.899] 01046.01049> socket_shutdown_read [RUNNING]
[00004.899] 01046.01049> [PASSED] (0 ms)
[00004.899] 01046.01049> socket_bytes_outstanding [RUNNING]
[00004.899] 01046.01049> [PASSED] (0 ms)
[00004.900] 01046.01049> socket_bytes_outstanding_shutdown_write [RUNNING]
[00004.900] 01046.01049> [PASSED] (0 ms)
[00004.900] 01046.01049> socket_bytes_outstanding_shutdown_read [RUNNING]
[00004.900] 01046.01049> [PASSED] (0 ms)
[00004.900] 01046.01049> socket_short_write [RUNNING]
[00004.900] 01046.01049> [PASSED] (0 ms)
[00004.900] 01046.01049> socket_datagram [RUNNING]
[00004.900] 01046.01049> [PASSED] (0 ms)
[00004.900] 01046.01049> socket_datagram_peek [RUNNING]
[00004.900] 01046.01049> [PASSED] (0 ms)
[00004.900] 01046.01049> socket_datagram_peek_empty [RUNNING]
[00004.900] 01046.01049> [PASSED] (0 ms)
[00004.900] 01046.01049> socket_datagram_no_short_write [RUNNING]
[00004.900] 01046.01049> [PASSED] (0 ms)
[00004.900] 01046.01049> socket_control_plane_absent [RUNNING]
[00004.900] 01046.01049> [PASSED] (0 ms)
[00004.900] 01046.01049> socket_control_plane [RUNNING]
[00004.900] 01046.01049> [PASSED] (0 ms)
[00004.900] 01046.01049> socket_control_plane_peek [RUNNING]
[00004.900] 01046.01049> [PASSED] (0 ms)
[00004.900] 01046.01049> socket_control_plane_peek_empty [RUNNING]
[00004.900] 01046.01049> [PASSED] (0 ms)
[00004.900] 01046.01049> socket_control_plane_shutdown [RUNNING]
[00004.900] 01046.01049> [PASSED] (0 ms)
[00004.900] 01046.01049> socket_accept [RUNNING]
[00004.900] 01046.01049> [PASSED] (0 ms)
[00004.900] 01046.01049> socket_share_invalid_handle [RUNNING]
[00004.900] 01046.01049> [PASSED] (0 ms)
[00004.900] 01046.01049> socket_share_consumes_on_failure [RUNNING]
[00004.901] 01046.01049> [PASSED] (0 ms)
[00004.901] 01046.01049> socket_signals2 [RUNNING]
[00004.901] 01046.01049> [PASSED] (0 ms)
[00004.901] 01046.01049> CASE socket_tests [PASSED]
[00004.901] 01046.01049>
CASE tls_tests [STARTED]
[00004.901] 01046.01049> tls_test [RUNNING]
[00006.914] 01046.01049> [PASSED] (2013 ms)
[00006.914] 01046.01049> CASE tls_tests [PASSED]
[00006.914] 01046.01049>
CASE pthread_barrier_tests [STARTED]
[00006.914] 01046.01049> test_barrier [RUNNING]
[00006.937] 01046.01049> [PASSED] (23 ms)
[00006.937] 01046.01049> CASE pthread_barrier_tests [PASSED]
[00006.937] 01046.01049>
CASE pthread_tests [STARTED]
[00006.937] 01046.01049> pthread_test [RUNNING]
[00010.042] 01046.01049> [PASSED] (3104 ms)
[00010.042] 01046.01049> pthread_self_main_thread_test [RUNNING]
[00010.042] 01046.01049> [PASSED] (0 ms)
[00010.042] 01046.01049> pthread_big_stack_size [RUNNING]
[00010.095] 01046.01049> [PASSED] (53 ms)
[00010.095] 01046.01049> pthread_getstack_main_thread [RUNNING]
[00010.095] 01046.01049> [PASSED] (0 ms)
[00010.095] 01046.01049> pthread_getstack_other_thread [RUNNING]
[00010.095] 01046.01049> [PASSED] (0 ms)
[00010.096] 01046.01049> CASE pthread_tests [PASSED]
[00010.096] 01046.01049>
CASE process_tests [STARTED]
[00010.096] 01046.01049> mini_process_sanity [RUNNING]
[00010.096] 01046.01049> [PASSED] (0 ms)
[00010.096] 01046.01049> process_start_fail [RUNNING]
[00010.096] 01046.01049> [PASSED] (0 ms)
[00010.096] 01046.01049> process_not_killed_via_thread_close [RUNNING]
[00010.097] 01046.01049> [PASSED] (1 ms)
[00010.097] 01046.01049> process_not_killed_via_process_close [RUNNING]
[00010.098] 01046.01049> [PASSED] (1 ms)
[00010.098] 01046.01049> kill_process_via_thread_kill [RUNNING]
[00010.099] 01046.01049> [PASSED] (0 ms)
[00010.099] 01046.01049> kill_process_via_vmar_destroy [RUNNING]
[00010.099] 02304.02306> PageFault: 1021179 free pages
[00010.099] 02304.02306> PageFault: MemoryUsed: proc 1032 12M 'userboot'
[00010.099] 02304.02306> PageFault: MemoryUsed: proc 1046 19M 'bin/core-tests'
[00010.099] 01046.01049> [PASSED] (0 ms)
[00010.099] 01046.01049> kill_channel_handle_cycle [RUNNING]
[00010.850] 01046.01049> [PASSED] (750 ms)
[00010.850] 01046.01049> info_reflects_process_state [RUNNING]
[00011.100] 01046.01049> [PASSED] (250 ms)
[00011.100] 01046.01049> suspend [RUNNING]
[00011.101] 01046.01049> [PASSED] (0 ms)
[00011.101] 01046.01049> suspend_self [RUNNING]
[00011.101] 01046.01049> [PASSED] (0 ms)
[00011.101] 01046.01049> suspend_multiple_threads [RUNNING]
[00011.106] 01046.01049> [PASSED] (5 ms)
[00011.106] 01046.01049> suspend_before_creating_threads [RUNNING]
[00011.106] 01046.01049> [PASSED] (0 ms)
[00011.106] 01046.01049> suspend_before_starting_threads [RUNNING]
[00011.106] 01046.01049> [PASSED] (0 ms)
[00011.106] 01046.01049> suspend_process_then_thread [RUNNING]
[00011.356] 01046.01049> [PASSED] (250 ms)
[00011.356] 01046.01049> suspend_thread_then_process [RUNNING]
[00011.607] 01046.01049> [PASSED] (250 ms)
[00011.607] 01046.01049> suspend_thread_and_process_before_starting_process [RUNNING]
[00011.857] 01046.01049> [PASSED] (250 ms)
[00011.857] 01046.01049> suspend_twice [RUNNING]
[00012.107] 01046.01049> [PASSED] (250 ms)
[00012.107] 01046.01049> suspend_twice_before_creating_threads [RUNNING]
[00012.382] 01046.01049> [PASSED] (274 ms)
[00012.382] 01046.01049> suspend_with_dying_thread [RUNNING]
[00012.382] 01046.01049> [PASSED] (0 ms)
[00012.382] 01046.01049> CASE process_tests [PASSED]
[00012.382] 01046.01049>
CASE port_tests [STARTED]
[00012.382] 01046.01049> basic_test [RUNNING]
[00012.382] 01046.01049> [PASSED] (0 ms)
[00012.382] 01046.01049> queue_and_close_test [RUNNING]
[00012.382] 01046.01049> [PASSED] (0 ms)
[00012.382] 01046.01049> queue_too_many [RUNNING]
[00012.384] 01046.01049> [PASSED] (1 ms)
[00012.384] 01046.01049> async_wait_channel_test [RUNNING]
[00012.385] 01046.01049> [PASSED] (1 ms)
[00012.385] 01046.01049> async_wait_event_test_single [RUNNING]
[00012.385] 01046.01049> [PASSED] (0 ms)
[00012.385] 01046.01049> async_wait_event_test_repeat [RUNNING]
[00012.386] 01046.01049> [PASSED] (0 ms)
[00012.386] 01046.01049> async_wait_invalid_option [RUNNING]
[00012.386] 01046.01049> [PASSED] (0 ms)
[00012.386] 01046.01049> async_wait_close_order_1 [RUNNING]
[00012.386] 01046.01049> [PASSED] (0 ms)
[00012.386] 01046.01049> async_wait_close_order_2 [RUNNING]
[00012.386] 01046.01049> [PASSED] (0 ms)
[00012.386] 01046.01049> async_wait_close_order_3 [RUNNING]
[00012.386] 01046.01049> [PASSED] (0 ms)
[00012.386] 01046.01049> async_wait_close_order_4 [RUNNING]
[00012.386] 01046.01049> [PASSED] (0 ms)
[00012.386] 01046.01049> async_wait_close_order_5 [RUNNING]
[00012.386] 01046.01049> [PASSED] (0 ms)
[00012.386] 01046.01049> async_wait_close_order_6 [RUNNING]
[00012.386] 01046.01049> [PASSED] (0 ms)
[00012.386] 01046.01049> channel_pre_writes_test [RUNNING]
[00012.386] 01046.01049> [PASSED] (0 ms)
[00012.386] 01046.01049> cancel_event_key [RUNNING]
[00012.386] 01046.01049> [PASSED] (0 ms)
[00012.386] 01046.01049> cancel_event_key_after [RUNNING]
[00012.386] 01046.01049> [PASSED] (0 ms)
[00012.386] 01046.01049> threads_event [RUNNING]
[00012.387] 01046.01049> [PASSED] (1 ms)
[00012.387] 01046.01049> cancel_stress [RUNNING]
[00012.538] 01046.01049> [PASSED] (151 ms)
[00012.538] 01046.01049> CASE port_tests [PASSED]
[00012.538] 01046.01049>
CASE api_violations [STARTED]
[00012.538] 01046.01049> invalid_pager_create [RUNNING]
[00012.538] 01046.01049> [PASSED] (0 ms)
[00012.538] 01046.01049> invalid_pager_create_vmo [RUNNING]
[00012.539] 01046.01049> [PASSED] (0 ms)
[00012.539] 01046.01049> invalid_pager_detach_vmo [RUNNING]
[00012.539] 01046.01049> [PASSED] (0 ms)
[00012.539] 01046.01049> invalid_pager_supply_pages [RUNNING]
[00012.539] 01046.01049> [PASSED] (0 ms)
[00012.539] 01046.01049> resize_nonresizable_vmo [RUNNING]
[00012.539] 01046.01049> [PASSED] (0 ms)
[00012.539] 01046.01049> CASE api_violations [PASSED]
[00012.539] 01046.01049>
CASE commit_tests [STARTED]
[00012.539] 01046.01049> simple_commit_test [RUNNING]
[00012.541] 01046.01049> [PASSED] (1 ms)
[00012.541] 01046.01049> split_commit_test [RUNNING]
[00012.541] 01046.01049> [PASSED] (0 ms)
[00012.541] 01046.01049> overlap_commit_test [RUNNING]
[00012.542] 01046.01049> [PASSED] (0 ms)
[00012.542] 01046.01049> overlap_commit_supply_test [RUNNING]
[00012.570] 01046.01049> [PASSED] (28 ms)
[00012.570] 01046.01049> multisupply_commit_test [RUNNING]
[00012.570] 01046.01049> [PASSED] (0 ms)
[00012.570] 01046.01049> multicommit_supply_test [RUNNING]
[00012.575] 01046.01049> [PASSED] (4 ms)
[00012.575] 01046.01049> commit_redundant_supply_test [RUNNING]
[00012.575] 01046.01049> [PASSED] (0 ms)
[00012.575] 01046.01049> supply_decommit_test [RUNNING]
[00012.575] 01046.01049> [PASSED] (0 ms)
[00012.575] 01046.01049> resize_commit_test [RUNNING]
[00012.576] 01046.01049> [PASSED] (0 ms)
[00012.576] 01046.01049> suspend_commit_test [RUNNING]
[00012.577] 01046.01049> [PASSED] (0 ms)
[00012.577] 01046.01049> CASE commit_tests [PASSED]
[00012.577] 01046.01049>
CASE clone_tests [STARTED]
[00012.577] 01046.01049> clone_read_from_clone_test_vmar [RUNNING]
[00012.577] 01046.01049> [PASSED] (0 ms)
[00012.577] 01046.01049> clone_read_from_clone_test_vmo [RUNNING]
[00012.578] 01046.01049> [PASSED] (0 ms)
[00012.578] 01046.01049> clone_read_from_parent_test_vmar [RUNNING]
[00012.579] 01046.01049> [PASSED] (0 ms)
[00012.579] 01046.01049> clone_read_from_parent_test_vmo [RUNNING]
[00012.580] 01046.01049> [PASSED] (0 ms)
[00012.580] 01046.01049> clone_simultaneous_read_test_vmar [RUNNING]
[00012.581] 01046.01049> [PASSED] (1 ms)
[00012.581] 01046.01049> clone_simultaneous_read_test_vmo [RUNNING]
[00012.582] 01046.01049> [PASSED] (0 ms)
[00012.582] 01046.01049> clone_simultaneous_child_read_test_vmar [RUNNING]
[00012.583] 01046.01049> [PASSED] (1 ms)
[00012.583] 01046.01049> clone_simultaneous_child_read_test_vmo [RUNNING]
[00012.584] 01046.01049> [PASSED] (0 ms)
[00012.584] 01046.01049> clone_write_to_clone_test [RUNNING]
[00012.584] 01046.01049> [PASSED] (0 ms)
[00012.584] 01046.01049> clone_detach_test [RUNNING]
[00012.585] 01046.01049> [PASSED] (0 ms)
[00012.585] 01046.01049> clone_commit_test [RUNNING]
[00012.585] 01046.01049> [PASSED] (0 ms)
[00012.585] 01046.01049> clone_split_commit_test [RUNNING]
[00012.586] 01046.01049> [PASSED] (0 ms)
[00012.586] 01046.01049> clone_decommit_test [RUNNING]
[00012.586] 01046.01049> [PASSED] (0 ms)
[00012.586] 01046.01049> CASE clone_tests [PASSED]
[00012.586] 01046.01049>
CASE lifecycle_tests [STARTED]
[00012.586] 01046.01049> vmo_info_pager_test [RUNNING]
[00012.586] 01046.01049> [PASSED] (0 ms)
[00012.586] 01046.01049> detach_page_complete_test [RUNNING]
[00012.586] 01046.01049> [PASSED] (0 ms)
[00012.586] 01046.01049> close_page_complete_test [RUNNING]
[00012.586] 01046.01049> [PASSED] (0 ms)
[00012.586] 01046.01049> read_detach_interrupt_late_test_vmar [RUNNING]
[00012.586] 01046.03214> PageFault: 1019954 free pages
[00012.586] 01046.03214> PageFault: MemoryUsed: proc 1032 12M 'userboot'
[00012.586] 01046.03214> PageFault: MemoryUsed: proc 1046 21M 'bin/core-tests'
[00012.587] 01046.01049> [PASSED] (0 ms)
[00012.587] 01046.01049> read_detach_interrupt_late_test_vmo [RUNNING]
[00012.587] 01046.01049> [PASSED] (0 ms)
[00012.587] 01046.01049> read_close_interrupt_late_test_vmar [RUNNING]
[00012.587] 01046.03235> PageFault: 1019925 free pages
[00012.587] 01046.03235> PageFault: MemoryUsed: proc 1032 12M 'userboot'
[00012.587] 01046.03235> PageFault: MemoryUsed: proc 1046 22M 'bin/core-tests'
[00012.587] 01046.01049> [PASSED] (0 ms)
[00012.587] 01046.01049> read_close_interrupt_late_test_vmo [RUNNING]
[00012.588] 01046.01049> [PASSED] (0 ms)
[00012.588] 01046.01049> read_detach_interrupt_early_test_vmar [RUNNING]
[00012.588] 01046.03256> PageFault: 1019896 free pages
[00012.588] 01046.03256> PageFault: MemoryUsed: proc 1032 12M 'userboot'
[00012.588] 01046.03256> PageFault: MemoryUsed: proc 1046 22M 'bin/core-tests'
[00012.588] 01046.01049> [PASSED] (0 ms)
[00012.588] 01046.01049> read_detach_interrupt_early_test_vmo [RUNNING]
[00012.589] 01046.01049> [PASSED] (0 ms)
[00012.589] 01046.01049> read_close_interrupt_early_test_vmar [RUNNING]
[00012.589] 01046.03277> PageFault: 1019865 free pages
[00012.589] 01046.03277> PageFault: MemoryUsed: proc 1032 12M 'userboot'
[00012.589] 01046.03277> PageFault: MemoryUsed: proc 1046 22M 'bin/core-tests'
[00012.589] 01046.01049> [PASSED] (0 ms)
[00012.589] 01046.01049> read_close_interrupt_early_test_vmo [RUNNING]
[00012.590] 01046.01049> [PASSED] (0 ms)
[00012.590] 01046.01049> thread_kill_test_vmar [RUNNING]
[00012.591] 01046.01049> [PASSED] (0 ms)
[00012.591] 01046.01049> thread_kill_test_vmo [RUNNING]
[00012.591] 01046.01049> [PASSED] (0 ms)
[00012.591] 01046.01049> thread_kill_overlap_test_vmar [RUNNING]
[00012.592] 01046.01049> [PASSED] (0 ms)
[00012.592] 01046.01049> thread_kill_overlap_test_vmo [RUNNING]
[00012.593] 01046.01049> [PASSED] (0 ms)
[00012.593] 01046.01049> close_pager_test [RUNNING]
[00012.593] 01046.03375> PageFault: 1019643 free pages
[00012.593] 01046.03375> PageFault: MemoryUsed: proc 1032 12M 'userboot'
[00012.593] 01046.03375> PageFault: MemoryUsed: proc 1046 22M 'bin/core-tests'
[00012.593] 01046.01049> [PASSED] (0 ms)
[00012.593] 01046.01049> detach_close_pager_test [RUNNING]
[00012.593] 01046.01049> [PASSED] (0 ms)
[00012.593] 01046.01049> close_port_test [RUNNING]
[00012.594] 01046.03388> PageFault: 1019627 free pages
[00012.594] 01046.03388> PageFault: MemoryUsed: proc 1032 12M 'userboot'
[00012.594] 01046.03388> PageFault: MemoryUsed: proc 1046 22M 'bin/core-tests'
[00012.594] 01046.01049> [PASSED] (0 ms)
[00012.594] 01046.01049> CASE lifecycle_tests [PASSED]
[00012.594] 01046.01049>
CASE pager_read_tests [STARTED]
[00012.594] 01046.01049> single_page_test_vmar [RUNNING]
[00012.594] 01046.01049> [PASSED] (0 ms)
[00012.594] 01046.01049> single_page_test_vmo [RUNNING]
[00012.595] 01046.01049> [PASSED] (0 ms)
[00012.595] 01046.01049> presupply_test_vmar [RUNNING]
[00012.595] 01046.01049> [PASSED] (0 ms)
[00012.595] 01046.01049> presupply_test_vmo [RUNNING]
[00012.596] 01046.01049> [PASSED] (0 ms)
[00012.596] 01046.01049> early_supply_test_vmar [RUNNING]
[00012.596] 01046.01049> [PASSED] (0 ms)
[00012.596] 01046.01049> early_supply_test_vmo [RUNNING]
[00012.597] 01046.01049> [PASSED] (0 ms)
[00012.597] 01046.01049> sequential_multipage_test_vmar [RUNNING]
[00012.599] 01046.01049> [PASSED] (2 ms)
[00012.599] 01046.01049> sequential_multipage_test_vmo [RUNNING]
[00012.601] 01046.01049> [PASSED] (1 ms)
[00012.601] 01046.01049> concurrent_multipage_access_test_vmar [RUNNING]
[00012.602] 01046.01049> [PASSED] (0 ms)
[00012.602] 01046.01049> concurrent_multipage_access_test_vmo [RUNNING]
[00012.603] 01046.01049> [PASSED] (0 ms)
[00012.603] 01046.01049> concurrent_overlapping_access_test_vmar [RUNNING]
[00012.628] 01046.01049> [PASSED] (24 ms)
[00012.628] 01046.01049> concurrent_overlapping_access_test_vmo [RUNNING]
[00012.651] 01046.01049> [PASSED] (23 ms)
[00012.651] 01046.01049> bulk_single_supply_test_vmar [RUNNING]
[00012.657] 01046.01049> [PASSED] (5 ms)
[00012.657] 01046.01049> bulk_single_supply_test_vmo [RUNNING]
[00012.662] 01046.01049> [PASSED] (4 ms)
[00012.662] 01046.01049> bulk_odd_length_supply_test_vmar [RUNNING]
[00012.717] 01046.01049> [PASSED] (55 ms)
[00012.717] 01046.01049> bulk_odd_length_supply_test_vmo [RUNNING]
[00012.759] 01046.01049> [PASSED] (41 ms)
[00012.759] 01046.01049> bulk_odd_offset_supply_test_vmar [RUNNING]
[00012.799] 01046.01049> [PASSED] (40 ms)
[00012.799] 01046.01049> bulk_odd_offset_supply_test_vmo [RUNNING]
[00012.845] 01046.01049> [PASSED] (45 ms)
[00012.845] 01046.01049> overlap_supply_test_vmar [RUNNING]
[00012.845] 01046.01049> [PASSED] (0 ms)
[00012.845] 01046.01049> overlap_supply_test_vmo [RUNNING]
[00012.846] 01046.01049> [PASSED] (0 ms)
[00012.846] 01046.01049> many_request_test_vmar [RUNNING]
[00012.989] 01046.01049> [PASSED] (143 ms)
[00012.989] 01046.01049> many_request_test_vmo [RUNNING]
[00013.127] 01046.01049> [PASSED] (137 ms)
[00013.127] 01046.01049> successive_vmo_test [RUNNING]
[00013.147] 01046.01049> [PASSED] (19 ms)
[00013.147] 01046.01049> multiple_concurrent_vmo_test [RUNNING]
[00013.149] 01046.01049> [PASSED] (2 ms)
[00013.149] 01046.01049> vmar_unmap_test [RUNNING]
[00013.149] 01046.12218> PageFault: 1004004 free pages
[00013.149] 01046.12218> PageFault: MemoryUsed: proc 1032 12M 'userboot'
[00013.150] 01046.12218> PageFault: MemoryUsed: proc 1046 60M 'bin/core-tests'
[00013.150] 01046.01049> [PASSED] (1 ms)
[00013.150] 01046.01049> vmar_remap_test [RUNNING]
[00013.153] 01046.01049> [PASSED] (2 ms)
[00013.153] 01046.01049> vmar_map_range_test [RUNNING]
[00013.154] 01046.01049> [PASSED] (0 ms)
[00013.154] 01046.01049> read_resize_test_vmar [RUNNING]
[00013.154] 01046.01049> [PASSED] (0 ms)
[00013.154] 01046.01049> read_resize_test_vmo [RUNNING]
[00013.154] 01046.01049> [PASSED] (0 ms)
[00013.154] 01046.01049> suspend_read_test_vmar [RUNNING]
[00013.155] 01046.01049> [PASSED] (0 ms)
[00013.155] 01046.01049> suspend_read_test_vmo [RUNNING]
[00013.156] 01046.01049> [PASSED] (0 ms)
[00013.156] 01046.01049> CASE pager_read_tests [PASSED]
[00013.156] 01046.01049>
CASE object_info_tests [STARTED]
[00013.156] 01046.01049> handle_valid_on_valid_handle_succeeds [RUNNING]
[00013.156] 01046.01049> [PASSED] (0 ms)
[00013.156] 01046.01049> handle_valid_on_closed_handle_fails [RUNNING]
[00013.156] 01046.01049> [PASSED] (0 ms)
[00013.156] 01046.01049> (invalid_handle_fails<ZX_INFO_HANDLE_VALID, void*>) [RUNNING]
[00013.156] 01046.01049> [PASSED] (0 ms)
[00013.156] 01046.01049> task_stats_unstarted [RUNNING]
[00013.156] 01046.01049> [PASSED] (0 ms)
[00013.156] 01046.01049> task_stats_smoke [RUNNING]
[00013.156] 01046.01049> [PASSED] (0 ms)
[00013.156] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t>) [RUNNING]
[00013.156] 01046.01049> [PASSED] (0 ms)
[00013.156] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING]
[00013.156] 01046.01049> [PASSED] (0 ms)
[00013.156] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING]
[00013.157] 01046.01049> [PASSED] (0 ms)
[00013.157] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING]
[00013.157] 01046.01049> [PASSED] (0 ms)
[00013.157] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING]
[00013.157] 01046.01049> [PASSED] (0 ms)
[00013.157] 01046.01049> (single_zero_buffer_fails<((zx_object_info_topic_t) 12u), zx_info_task_stats_t, zx_process_self>) [RUNNING]
[00013.158] 01046.01049> [PASSED] (0 ms)
[00013.158] 01046.01049> (wrong_handle_type_fails<ZX_INFO_TASK_STATS, zx_info_task_stats_t, get_test_job>) [RUNNING]
[00013.158] 01046.01049> [PASSED] (0 ms)
[00013.158] 01046.01049> (wrong_handle_type_fails<ZX_INFO_TASK_STATS, zx_info_task_stats_t, zx_thread_self>) [RUNNING]
[00013.158] 01046.01049> [PASSED] (0 ms)
[00013.158] 01046.01049> process_maps_unstarted [RUNNING]
[00013.158] 01046.01049> [PASSED] (0 ms)
[00013.158] 01046.01049> process_maps_smoke [RUNNING]
[00013.158] 01046.01049> [PASSED] (0 ms)
[00013.158] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t>) [RUNNING]
[00013.158] 01046.01049> [PASSED] (0 ms)
[00013.158] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING]
[00013.158] 01046.01049> [PASSED] (0 ms)
[00013.158] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING]
[00013.158] 01046.01049> [PASSED] (0 ms)
[00013.158] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING]
[00013.158] 01046.01049> [PASSED] (0 ms)
[00013.158] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING]
[00013.158] 01046.01049> [PASSED] (0 ms)
[00013.158] 01046.01049> (multi_zero_buffer_succeeds<((zx_object_info_topic_t) 13u), get_test_process>) [RUNNING]
[00013.158] 01046.01049> [PASSED] (0 ms)
[00013.158] 01046.01049> (short_buffer_succeeds<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (partially_unmapped_buffer_fails<((zx_object_info_topic_t) 13u), zx_info_maps_t, get_test_process>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (self_fails<ZX_INFO_PROCESS_MAPS, zx_info_maps_t>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (wrong_handle_type_fails<ZX_INFO_PROCESS_MAPS, zx_info_maps_t, get_test_job>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (wrong_handle_type_fails<ZX_INFO_PROCESS_MAPS, zx_info_maps_t, zx_thread_self>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (missing_rights_fails<ZX_INFO_PROCESS_MAPS, zx_info_maps_t, get_test_process, ZX_RIGHT_INSPECT>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> process_vmos_smoke [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (multi_zero_buffer_succeeds<((zx_object_info_topic_t) 14u), get_test_process>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (short_buffer_succeeds<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (partially_unmapped_buffer_fails<((zx_object_info_topic_t) 14u), zx_info_vmo_t, get_test_process>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (self_fails<ZX_INFO_PROCESS_VMOS, zx_info_vmo_t>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (wrong_handle_type_fails<ZX_INFO_PROCESS_VMOS, zx_info_vmo_t, get_test_job>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (wrong_handle_type_fails<ZX_INFO_PROCESS_VMOS, zx_info_vmo_t, zx_thread_self>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (missing_rights_fails<ZX_INFO_PROCESS_VMOS, zx_info_vmo_t, get_test_process, ZX_RIGHT_INSPECT>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> job_processes_smoke [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 9u), zx_koid_t>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (multi_zero_buffer_succeeds<((zx_object_info_topic_t) 9u), get_test_job>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (short_buffer_succeeds<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (partially_unmapped_buffer_fails<((zx_object_info_topic_t) 9u), zx_koid_t, get_test_job>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (wrong_handle_type_fails<ZX_INFO_JOB_PROCESSES, zx_koid_t, get_test_process>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (wrong_handle_type_fails<ZX_INFO_JOB_PROCESSES, zx_koid_t, zx_thread_self>) [RUNNING]
[00013.159] 01046.01049> [PASSED] (0 ms)
[00013.159] 01046.01049> (missing_rights_fails<ZX_INFO_JOB_PROCESSES, zx_koid_t, get_test_job, ZX_RIGHT_ENUMERATE>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> job_children_smoke [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 8u), zx_koid_t>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (multi_zero_buffer_succeeds<((zx_object_info_topic_t) 8u), get_test_job>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (short_buffer_succeeds<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (partially_unmapped_buffer_fails<((zx_object_info_topic_t) 8u), zx_koid_t, get_test_job>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (wrong_handle_type_fails<ZX_INFO_JOB_CHILDREN, zx_koid_t, get_test_process>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (wrong_handle_type_fails<ZX_INFO_JOB_CHILDREN, zx_koid_t, zx_thread_self>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (missing_rights_fails<ZX_INFO_JOB_CHILDREN, zx_koid_t, get_test_job, ZX_RIGHT_ENUMERATE>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (single_zero_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_job>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (single_zero_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, get_test_process>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (single_zero_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_thread_self>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (single_zero_buffer_fails<((zx_object_info_topic_t) 2u), zx_info_handle_basic_t, zx_vmar_root_self>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING]
[00013.160] 01046.01049> [PASSED] (0 ms)
[00013.160] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (single_zero_buffer_fails<((zx_object_info_topic_t) 19u), zx_info_handle_count_t, zx_thread_self>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 3u), zx_info_process_t>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (single_zero_buffer_fails<((zx_object_info_topic_t) 3u), zx_info_process_t, get_test_process>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (wrong_handle_type_fails<ZX_INFO_PROCESS, zx_info_process_t, get_test_job>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (wrong_handle_type_fails<ZX_INFO_PROCESS, zx_info_process_t, zx_thread_self>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (single_zero_buffer_fails<((zx_object_info_topic_t) 7u), zx_info_vmar_t, zx_vmar_root_self>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (wrong_handle_type_fails<ZX_INFO_VMAR, zx_info_vmar_t, get_test_job>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (wrong_handle_type_fails<ZX_INFO_VMAR, zx_info_vmar_t, get_test_process>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (wrong_handle_type_fails<ZX_INFO_VMAR, zx_info_vmar_t, zx_thread_self>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (single_zero_buffer_fails<((zx_object_info_topic_t) 10u), zx_info_thread_t, zx_thread_self>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (wrong_handle_type_fails<ZX_INFO_THREAD, zx_info_thread_t, get_test_job>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (wrong_handle_type_fails<ZX_INFO_THREAD, zx_info_thread_t, get_test_process>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (invalid_handle_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (null_avail_actual_succeeds<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (bad_buffer_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (bad_actual_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (bad_avail_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (single_zero_buffer_fails<((zx_object_info_topic_t) 15u), zx_info_thread_stats_t, zx_thread_self>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (wrong_handle_type_fails<ZX_INFO_THREAD_STATS, zx_info_thread_t, get_test_job>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (wrong_handle_type_fails<ZX_INFO_THREAD_STATS, zx_info_thread_t, get_test_process>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (invalid_handle_fails<ZX_INFO_PROCESS_THREADS, zx_koid_t>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (null_avail_actual_succeeds<ZX_INFO_PROCESS_THREADS, zx_koid_t, get_test_process>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (bad_buffer_fails<ZX_INFO_PROCESS_THREADS, zx_koid_t, get_test_process>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (bad_actual_fails<ZX_INFO_PROCESS_THREADS, zx_koid_t, get_test_process>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (bad_avail_fails<ZX_INFO_PROCESS_THREADS, zx_koid_t, get_test_process>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (multi_zero_buffer_succeeds<ZX_INFO_PROCESS_THREADS, get_test_process>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> (invalid_handle_fails<ZX_INFO_THREAD_EXCEPTION_REPORT, zx_exception_report_t>) [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> handle_count_valid [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> handle_stats_control [RUNNING]
[00013.161] 01046.01049> [PASSED] (0 ms)
[00013.161] 01046.01049> CASE object_info_tests [PASSED]
[00013.161] 01046.01049>
CASE object_get_child_tests [STARTED]
[00013.161] 01046.01049> handle_invalid [RUNNING]
[00013.162] 01046.01049> [PASSED] (0 ms)
[00013.162] 01046.01049> CASE object_get_child_tests [PASSED]
[00013.162] 01046.01049>
CASE memory_mapping_tests [STARTED]
[00013.162] 01046.01049> address_space_limits_test [RUNNING]
[00013.162] 01046.01049> [PASSED] (0 ms)
[00013.162] 01046.01049> mmap_zerofilled_test [RUNNING]
[00013.162] 01046.01049> [PASSED] (0 ms)
[00013.162] 01046.01049> mmap_len_test [RUNNING]
[00013.162] 01046.01049> [PASSED] (0 ms)
[00013.162] 01046.01049> mmap_PROT_EXEC_test [RUNNING]
[00013.162] 01046.01049> [PASSED] (0 ms)
[00013.162] 01046.01049> mmap_offset_test [RUNNING]
[00013.162] 01046.01049> [PASSED] (0 ms)
[00013.162] 01046.01049> mmap_prot_test [RUNNING]
[00013.162] 01046.01049> [PASSED] (0 ms)
[00013.162] 01046.01049> mmap_flags_test [RUNNING]
[00013.162] 01046.01049> [PASSED] (0 ms)
[00013.162] 01046.01049> mprotect_test [RUNNING]
[00013.162] 01046.01049> [PASSED] (0 ms)
[00013.162] 01046.01049> CASE memory_mapping_tests [PASSED]
[00013.162] 01046.01049>
CASE job_tests [STARTED]
[00013.162] 01046.01049> basic_test [RUNNING]
[00013.162] 01046.01049> [PASSED] (0 ms)
[00013.162] 01046.01049> create_missing_rights_test [RUNNING]
[00013.162] 01046.01049> [PASSED] (0 ms)
[00013.162] 01046.01049> policy_invalid_topic_test [RUNNING]
[00013.163] 01046.01049> [PASSED] (0 ms)
[00013.163] 01046.01049> policy_basic_test [RUNNING]
[00013.163] 01046.01049> [PASSED] (0 ms)
[00013.163] 01046.01049> policy_timer_slack_invalid_options_test [RUNNING]
[00013.163] 01046.01049> [PASSED] (0 ms)
[00013.163] 01046.01049> policy_timer_slack_invalid_count_test [RUNNING]
[00013.163] 01046.01049> [PASSED] (0 ms)
[00013.163] 01046.01049> policy_timer_slack_invalid_policy_test [RUNNING]
[00013.163] 01046.01049> [PASSED] (0 ms)
[00013.163] 01046.01049> policy_timer_slack_non_empty_test [RUNNING]
[00013.163] 01046.01049> [PASSED] (0 ms)
[00013.163] 01046.01049> policy_timer_slack_valid [RUNNING]
[00013.163] 01046.01049> [PASSED] (0 ms)
[00013.163] 01046.01049> create_test [RUNNING]
[00013.163] 01046.01049> [PASSED] (0 ms)
[00013.163] 01046.01049> kill_test [RUNNING]
[00013.163] 01046.01049> [PASSED] (0 ms)
[00013.163] 01046.01049> kill_job_no_child_test [RUNNING]
[00013.163] 01046.01049> [PASSED] (0 ms)
[00013.163] 01046.01049> set_job_oom_kill_bit [RUNNING]
[00013.163] 01046.01049> [PASSED] (0 ms)
[00013.163] 01046.01049> wait_test [RUNNING]
[00013.168] 01046.01049> [PASSED] (5 ms)
[00013.168] 01046.01049> info_task_stats_fails [RUNNING]
[00013.168] 01046.01049> [PASSED] (0 ms)
[00013.168] 01046.01049> max_height_smoke [RUNNING]
[00013.169] 01046.01049> [PASSED] (0 ms)
[00013.169] 01046.01049> CASE job_tests [PASSED]
[00013.169] 01046.01049>
CASE handle_wait_tests [STARTED]
[00013.169] 01046.01049> handle_wait_test [RUNNING]
[00013.170] 01046.01049> [PASSED] (0 ms)
[00013.170] 01046.01049> CASE handle_wait_tests [PASSED]
[00013.170] 01046.01049>
CASE handle_transfer_tests [STARTED]
[00013.170] 01046.01049> handle_transfer_test [RUNNING]
[00013.170] 01046.01049> [PASSED] (0 ms)
[00013.170] 01046.01049> handle_transfer_cancel_wait_test [RUNNING]
[00013.180] 01046.01049> [PASSED] (10 ms)
[00013.180] 01046.01049> CASE handle_transfer_tests [PASSED]
[00013.180] 01046.01049>
CASE handle_info_tests [STARTED]
[00013.180] 01046.01049> handle_replace_test [RUNNING]
[00013.180] 01046.01049> [PASSED] (0 ms)
[00013.180] 01046.01049> handle_info_test [RUNNING]
[00013.180] 01046.01049> [PASSED] (0 ms)
[00013.180] 01046.01049> handle_related_koid_test [RUNNING]
[00013.180] 01046.01049> [PASSED] (0 ms)
[00013.180] 01046.01049> handle_rights_test [RUNNING]
[00013.181] 01046.01049> [PASSED] (0 ms)
[00013.181] 01046.01049> CASE handle_info_tests [PASSED]
[00013.181] 01046.01049>
CASE handle_close_tests [STARTED]
[00013.181] 01046.01049> handle_close_many_test [RUNNING]
[00013.181] 01046.01049> [PASSED] (0 ms)
[00013.181] 01046.01049> handle_close_many_invalid_test [RUNNING]
[00013.181] 01046.01049> [PASSED] (0 ms)
[00013.181] 01046.01049> handle_close_many_duplicate_test [RUNNING]
[00013.181] 01046.01049> [PASSED] (0 ms)
[00013.181] 01046.01049> CASE handle_close_tests [PASSED]
[00013.181] 01046.01049>
CASE futex_tests [STARTED]
[00013.181] 01046.01049> TestFutexWaitValueMismatch [RUNNING]
[00013.181] 01046.01049> [PASSED] (0 ms)
[00013.181] 01046.01049> TestFutexWaitTimeout [RUNNING]
[00013.181] 01046.01049> [PASSED] (0 ms)
[00013.181] 01046.01049> TestFutexWaitTimeoutElapsed [RUNNING]
[00013.681] 01046.01049> [PASSED] (500 ms)
[00013.681] 01046.01049> TestFutexWaitBadAddress [RUNNING]
[00013.681] 01046.01049> [PASSED] (0 ms)
[00013.681] 01046.01049> TestFutexWakeup [RUNNING]
[00013.682] 01046.01049> [PASSED] (0 ms)
[00013.682] 01046.01049> TestFutexWakeupLimit [RUNNING]
[00014.283] 01046.01049> [PASSED] (601 ms)
[00014.283] 01046.01049> TestFutexWakeupAddress [RUNNING]
[00014.284] 01046.01049> [PASSED] (0 ms)
[00014.284] 01046.01049> TestFutexRequeueValueMismatch [RUNNING]
[00014.284] 01046.01049> [PASSED] (0 ms)
[00014.284] 01046.01049> TestFutexRequeueSameAddr [RUNNING]
[00014.284] 01046.01049> [PASSED] (0 ms)
[00014.284] 01046.01049> TestFutexRequeue [RUNNING]
[00015.186] 01046.01049> [PASSED] (901 ms)
[00015.186] 01046.01049> TestFutexRequeueUnqueuedOnTimeout [RUNNING]
[00015.486] 01046.01049> [PASSED] (300 ms)
[00015.486] 01046.01049> TestFutexThreadKilled [RUNNING]
[00015.486] 01046.01049> [PASSED] (0 ms)
[00015.486] 01046.01049> TestFutexThreadSuspended [RUNNING]
[00015.807] 01046.01049> [PASSED] (320 ms)
[00015.807] 01046.01049> TestFutexMisaligned [RUNNING]
[00015.807] 01046.01049> [PASSED] (0 ms)
[00015.807] 01046.01049> TestEventSignaling [RUNNING]
[00016.108] 01046.01049> [PASSED] (301 ms)
[00016.108] 01046.01049> CASE futex_tests [PASSED]
[00016.108] 01046.01049>
CASE fifo_tests [STARTED]
[00016.108] 01046.01049> basic_test [RUNNING]
[00016.108] 01046.01049> [PASSED] (0 ms)
[00016.108] 01046.01049> peer_closed_test [RUNNING]
[00016.108] 01046.01049> [PASSED] (0 ms)
[00016.108] 01046.01049> options_test [RUNNING]
[00016.108] 01046.01049> [PASSED] (0 ms)
[00016.108] 01046.01049> CASE fifo_tests [PASSED]
[00016.108] 01046.01049>
CASE eventpair_tests [STARTED]
[00016.108] 01046.01049> create_test [RUNNING]
[00016.108] 01046.01049> [PASSED] (0 ms)
[00016.108] 01046.01049> signal_test [RUNNING]
[00016.109] 01046.01049> [PASSED] (0 ms)
[00016.109] 01046.01049> signal_peer_test [RUNNING]
[00016.109] 01046.01049> [PASSED] (0 ms)
[00016.109] 01046.01049> signal_peer_closed_test [RUNNING]
[00016.109] 01046.01049> [PASSED] (0 ms)
[00016.109] 01046.01049> CASE eventpair_tests [PASSED]
[00016.109] 01046.01049>
CASE elf_tls_tests [STARTED]
[00016.109] 01046.01049> ExecutableTlsTest [RUNNING]
[00016.309] 01046.01049> [PASSED] (200 ms)
[00016.309] 01046.01049> CASE elf_tls_tests [PASSED]
[00016.309] 01046.01049>
CASE cookie_tests [STARTED]
[00016.309] 01046.01049> test_cookie_actions [RUNNING]
[00016.309] 01046.01049> [PASSED] (0 ms)
[00016.309] 01046.01049> test_cookie_eventpair [RUNNING]
[00016.309] 01046.01049> [PASSED] (0 ms)
[00016.309] 01046.01049> CASE cookie_tests [PASSED]
[00016.309] 01046.01049>
CASE clock_tests [STARTED]
[00016.309] 01046.01049> clock_monotonic_test [RUNNING]
[00016.310] 01046.01049> [PASSED] (0 ms)
[00016.310] 01046.01049> CASE clock_tests [PASSED]
[00016.310] 01046.01049>
CASE channel_tests [STARTED]
[00016.310] 01046.01049> channel_test [RUNNING]
[00016.311] 01046.01049> [PASSED] (0 ms)
[00016.311] 01046.01049> channel_read_error_test [RUNNING]
[00016.311] 01046.01049> [PASSED] (0 ms)
[00016.311] 01046.01049> channel_close_test [RUNNING]
[00016.311] 01046.01049> [PASSED] (0 ms)
[00016.311] 01046.01049> channel_peer_closed_test [RUNNING]
[00016.311] 01046.01049> [PASSED] (0 ms)
[00016.311] 01046.01049> channel_non_transferable [RUNNING]
[00016.311] 01046.01049> [PASSED] (0 ms)
[00016.311] 01046.01049> channel_duplicate_handles [RUNNING]
[00016.311] 01046.01049> [PASSED] (0 ms)
[00016.311] 01046.01049> channel_multithread_read [RUNNING]
[00016.334] 01046.01049> [PASSED] (22 ms)
[00016.334] 01046.01049> channel_may_discard [RUNNING]
[00016.334] 01046.01049> [PASSED] (0 ms)
[00016.334] 01046.01049> channel_call [RUNNING]
[00016.337] 01046.01049> [PASSED] (3 ms)
[00016.337] 01046.01049> channel_call_consumes_handles [RUNNING]
[00016.337] 01046.01049> [PASSED] (0 ms)
[00016.337] 01046.01049> channel_call2 [RUNNING]
[00016.588] 01046.01049> [PASSED] (250 ms)
[00016.588] 01046.01049> bad_channel_call_finish [RUNNING]
[00016.588] 01046.01049> [PASSED] (0 ms)
[00016.588] 01046.01049> channel_nest [RUNNING]
[00016.588] 01046.01049> [PASSED] (0 ms)
[00016.588] 01046.01049> channel_disallow_write_to_self [RUNNING]
[00016.588] 01046.01049> [PASSED] (0 ms)
[00016.588] 01046.01049> channel_read_etc [RUNNING]
[00016.588] 01046.01049> [PASSED] (0 ms)
[00016.588] 01046.01049> channel_write_different_sizes [RUNNING]
[00016.708] 01046.01049> [PASSED] (119 ms)
[00016.708] 01046.01049> channel_write_takes_all_handles [RUNNING]
[00016.711] 01046.01049> [PASSED] (2 ms)
[00016.711] 01046.01049> CASE channel_tests [PASSED]
[00016.711] 01046.01049>
CASE c11_thread_tests [STARTED]
[00016.711] 01046.01049> c11_thread_test [RUNNING]
[00017.513] 01046.01049> [PASSED] (802 ms)
[00017.513] 01046.01049> long_name_succeeds [RUNNING]
[00017.614] 01046.01049> [PASSED] (100 ms)
[00017.614] 01046.01049> detach_self_test [RUNNING]
[00017.951] 01046.01049> [PASSED] (337 ms)
[00017.951] 01046.01049> CASE c11_thread_tests [PASSED]
[00017.951] 01046.01049>
CASE mtx_tests [STARTED]
[00017.951] 01046.01049> test_initializer [RUNNING]
[00017.951] 01046.01049> [PASSED] (0 ms)
[00017.951] 01046.01049> test_mutexes [RUNNING]
[00018.146] 01046.01049> [PASSED] (194 ms)
[00018.146] 01046.01049> test_try_mutexes [RUNNING]
[00018.153] 01046.01049> [PASSED] (6 ms)
[00018.153] 01046.01049> test_static_initializer [RUNNING]
[00018.153] 01046.01049> [PASSED] (0 ms)
[00018.153] 01046.01049> test_timeout_elapsed [RUNNING]
[00018.658] 01046.01049> [PASSED] (505 ms)
[00018.658] 01046.01049> CASE mtx_tests [PASSED]
[00018.658] 01046.01049>
CASE cnd_tests [STARTED]
[00018.658] 01046.01049> cnd_test [RUNNING]
[00018.674] 01046.01049> [PASSED] (15 ms)
[00018.674] 01046.01049> cnd_timedwait_timeout_test [RUNNING]
[00018.675] 01046.01049> [PASSED] (1 ms)
[00018.675] 01046.01049> CASE cnd_tests [PASSED]
[00018.675] 01046.01049>
CASE bad_syscall_tests [STARTED]
[00018.675] 01046.01049> bad_access_test [RUNNING]
[00018.675] 01046.01049> [PASSED] (0 ms)
[00018.675] 01046.01049> bad_syscall_num_test [RUNNING]
[00018.685] 01046.01049> [PASSED] (10 ms)
[00018.686] 01046.01049> CASE bad_syscall_tests [PASSED]
[00018.686] 01046.01049> ====================================================
[00018.686] 01046.01049> Results:
[00018.686] 01046.01049> SUCCESS! All test cases passed!
[00018.686] 01046.01049> CASES: 42 SUCCESS: 42 FAILED: 0
[00018.686] 01046.01049> ====================================================
[00018.686] 01046.01049> core-tests succeeded RZMm59f7zOSs6aZUIXZR
[00018.691] 01032.01039> userboot: loader-service channel peer closed
[00018.691] 01032.01039> userboot: Waiting for bin/core-tests to exit...
[00018.870] 01032.01039> userboot: Process exited. Executing "poweroff".
[00018.871] 01032.01039> mp_unplug_cpu_mask_single_locked:357: WARNING: leaking thread for cpu 3
[00018.872] 01032.01039> mp_unplug_cpu_mask_single_locked:357: WARNING: leaking thread for cpu 2
[00018.875] 01032.01039> mp_unplug_cpu_mask_single_locked:357: WARNING: leaking thread for cpu 1
[00018.875] 01032.01039> Shutting down debuglog