[00000.000000][0][0][klog] INFO: zbi: @ 0xffffff800077d000 (5530576 bytes) [00000.000000][0][0][klog] INFO: UART: FIFO depth 16 [00000.000000][0][0][klog] INFO: PMM: boot reserve add [0x100000, 0x2b5fff] [00000.000000][0][0][klog] INFO: PMM: boot reserve add [0x77d000, 0xcc3fff] [00000.000000][0][0][klog] INFO: PMM: boot reserve marking WIRED [0x100000, 0x2b5fff] [00000.000000][0][0][klog] INFO: PMM: boot reserve marking WIRED [0x77d000, 0xcc3fff] [00000.000000][0][0][klog] INFO: [00000.000000][0][0][klog] INFO: welcome to Zircon [00000.000000][0][0][klog] INFO: [00000.000000][0][0][klog] INFO: KASLR: .text section at 0xffffffff00100000 [00000.000000][0][0][klog] INFO: INIT: cpu 0, calling hook 0xffffffff001a0e3c (global_prng_seed) at level 0x30000, flags 0x1 [00000.000000][0][0][klog] INFO: initializing vm pre-heap [00000.000000][0][0][klog] INFO: VM: marking boot alloc used range [0xcc4000, 0xcc4080) [00000.000000][0][0][klog] INFO: INIT: cpu 0, calling hook 0xffffffff00142b00 (elf_build_id) at level 0x4fffe, flags 0x1 [00000.000000][0][0][klog] INFO: INIT: cpu 0, calling hook 0xffffffff00142c8c (version) at level 0x4ffff, flags 0x1 [00000.000000][0][0][klog] INFO: version: [00000.000000][0][0][klog] INFO: arch: x86 [00000.000000][0][0][klog] INFO: platform: pc [00000.000000][0][0][klog] INFO: target: pc [00000.000000][0][0][klog] INFO: project: x64 [00000.000000][0][0][klog] INFO: buildid: git-8bb257375057869e2a2583b098942760f0477d23 [00000.000000][0][0][klog] INFO: ELF build ID: 73a9b010b50bebef36f31a99acc986e106e218ee [00000.000000][0][0][klog] INFO: initializing heap [00000.000000][0][0][klog] INFO: INIT: cpu 0, calling hook 0xffffffff001033d8 (x86_resource_init) at level 0x50000, flags 0x1 [00000.000000][0][0][klog] INFO: INIT: cpu 0, calling hook 0xffffffff0019f2bc (console) at level 0x50000, flags 0x1 [00000.000000][0][0][klog] INFO: initializing vm [00000.000000][0][0][klog] INFO: VM: reserving kernel region [0xffffffff00100000, 0xffffffff001e0000) flags 0x28 name 'kernel_code' [00000.000000][0][0][klog] INFO: VM: reserving kernel region [0xffffffff001e0000, 0xffffffff00222000) flags 0x8 name 'kernel_rodata' [00000.000000][0][0][klog] INFO: VM: reserving kernel region [0xffffffff00222000, 0xffffffff00232000) flags 0x18 name 'kernel_data' [00000.000000][0][0][klog] INFO: VM: reserving kernel region [0xffffffff00232000, 0xffffffff002b6000) flags 0x18 name 'kernel_bss' [00000.000000][0][0][klog] INFO: INIT: cpu 0, calling hook 0xffffffff00101168 (acpi_tables) at level 0x60001, flags 0x1 [00000.000000][0][0][klog] INFO: INIT: cpu 0, calling hook 0xffffffff001040a8 (display_memtype) at level 0x60001, flags 0x1 [00000.000000][0][0][klog] INFO: INIT: cpu 0, calling hook 0xffffffff00102130 (hpet) at level 0x60002, flags 0x1 [00000.000000][0][0][klog] INFO: INIT: cpu 0, calling hook 0xffffffff001024b8 (apic) at level 0x60002, flags 0x1 [00000.000000][0][0][klog] INFO: x2APIC enabled [00000.000000][0][0][klog] INFO: INIT: cpu 0, calling hook 0xffffffff001067d4 (timer) at level 0x60003, flags 0x1 [00000.000000][0][0][klog] INFO: pvclock: Clocksource is stable [00000.000000][0][0][klog] INFO: HPET frequency: 100000 ticks/ms [00000.000000][0][0][klog] INFO: pvclock: Fetching TSC frequency [00000.000000][0][0][klog] INFO: TSC frequency: 2299786 ticks/ms [00000.450743][0][0][klog] INFO: timer features: constant_tsc 1 invariant_tsc 1 tsc_deadline 1 [00000.450744][0][0][klog] INFO: Using TSC as wallclock [00000.450745][0][0][klog] INFO: initializing kernel [00000.450745][0][0][klog] INFO: initializing mp [00000.450746][0][0][klog] INFO: initializing timers [00000.450753][0][0][klog] INFO: INIT: cpu 0, calling hook 0xffffffff00137774 (debuglog) at level 0x7ffff, flags 0x1 [00000.450789][0][0][klog] INFO: INIT: cpu 0, calling hook 0xffffffff0018d284 (thread_set_priority_experiment) at level 0x7ffff, flags 0x1 [00000.450796][0][0][klog] INFO: thread set priority experiment is : ENABLED [00000.450797][0][0][klog] INFO: INIT: cpu 0, calling hook 0xffffffff001a1090 (global_prng_thread_safe) at level 0x7ffff, flags 0x1 [00000.450801][0][0][klog] INFO: creating bootstrap completion thread [00000.623231][0][0][klog] INFO: top of bootstrap2() [00000.623233][0][0][klog] INFO: INIT: cpu 0, calling hook 0xffffffff0012dc54 (dpc) at level 0x80000, flags 0x1 [00000.630011][0][0][klog] INFO: INIT: cpu 0, calling hook 0xffffffff0014d980 (libobject) at level 0x80000, flags 0x1 [00000.630071][0][0][klog] INFO: OOM: started thread [00000.637153][0][0][klog] INFO: Processor Model Info: type 0 family 0x6 model 0xf stepping 0 [00000.637154][0][0][klog] INFO: display_family 0x6 display_model 0x3f [00000.637155][0][0][klog] INFO: Vendor: Intel [00000.637155][0][0][klog] INFO: Microarch: Haswell [00000.637155][0][0][klog] INFO: F/M/S: 6/3f/0 [00000.637156][0][0][klog] INFO: Brand: Intel(R) Xeon(R) CPU @ 2.30GHz [00000.637157][0][0][klog] INFO: Features: fpu sse sse2 sse3 ssse3 sse4.1 sse4.2 mmx avx avx2 fxsr pcid xsave aesni clflush [00000.637159][0][0][klog] INFO: fsgsbase tsc_adj smep erms rdrand syscall nx rdtscp tsc_deadline x2apic hypervisor [00000.637172][0][0][klog] INFO: initializing platform [00000.637173][0][0][klog] INFO: INIT: cpu 0, calling hook 0xffffffff0011084c (x86_perfmon) at level 0x90000, flags 0x1 [00000.637197][0][0][klog] INFO: x86_perfmon_init_once:495: perfmon: unexpected programmable counter width 0 in cpuid.0AH [00000.637795][0][0][klog] INFO: UART: started IRQ driven RX [00000.637795][0][0][klog] INFO: UART: started IRQ driven TX [00000.637817][0][0][klog] INFO: cpu topology: [00000.637818][0][0][klog] INFO: 0: apic id 0x0 package 0 node 0 core 0 smt 0 BSP [00000.637819][0][0][klog] INFO: 1: apic id 0x1 package 1 node 0 core 0 smt 0 [00000.637819][0][0][klog] INFO: 2: apic id 0x2 package 2 node 0 core 0 smt 0 [00000.637819][0][0][klog] INFO: 3: apic id 0x3 package 3 node 0 core 0 smt 0 [00000.637820][0][0][klog] INFO: Found 4 cpus [00000.638283][0][0][klog] INFO: booting apic ids: 0x1 0x2 0x3 [00000.711559][0][0][klog] INFO: entering scheduler on cpu 2 [00000.711856][0][0][klog] INFO: entering scheduler on cpu 1 [00000.711889][0][0][klog] INFO: entering scheduler on cpu 3 [00000.722097][0][0][klog] INFO: smbios: manufacturer="QEMU" product="Standard PC (Q35 + ICH9, 2009)" [00000.722119][0][0][klog] INFO: initializing target [00000.722121][0][0][klog] INFO: INIT: cpu 0, calling hook 0xffffffff001059b8 (x86_pcie_init) at level 0xa0000, flags 0x1 [00000.722175][0][0][klog] INFO: moving to last init level [00000.722184][0][0][klog] INFO: INIT: cpu 0, calling hook 0xffffffff0013f338 (ktrace) at level 0xc0000, flags 0x1 [00000.756600][0][0][klog] INFO: ktrace: buffer at 0xffffff939c38c000 (33554432 bytes) [00000.756664][0][0][klog] INFO: INIT: cpu 0, calling hook 0xffffffff00142af8 (userboot) at level 0xc0000, flags 0x1 [00000.756669][0][0][klog] INFO: userboot: ramdisk 0x547000 @ 0xffffff800077d000 [00000.772100][0][0][klog] INFO: userboot: userboot rodata 0 @ [0x445f350bb000,0x445f350be000) [00000.772126][0][0][klog] INFO: userboot: userboot code 0x3000 @ [0x445f350be000,0x445f350c9000) [00000.772127][0][0][klog] INFO: userboot: vdso/full rodata 0 @ [0x445f350c9000,0x445f350d0000) [00000.772128][0][0][klog] INFO: userboot: vdso/full code 0x7000 @ [0x445f350d0000,0x445f350d1000) [00000.772202][0][0][klog] INFO: userboot: entry point @ 0x445f350bec10 [00000.772266][0][0][klog] INFO: INIT: cpu 0, calling hook 0xffffffff0019fcbc (kernel_shell) at level 0xc0000, flags 0x1 [00000.772605][1032][1039][klog] INFO: userboot: option "/b/s/w/ir/multiboot.bin=" [00000.772648][1032][1039][klog] INFO: userboot: option "zircon.autorun.system=/boot/bin/sh+/boot/infra/runcmds" [00000.772649][1032][1039][klog] INFO: userboot: option "kernel.halt-on-panic=true" [00000.772649][1032][1039][klog] INFO: userboot: option "devmgr.suspend-timeout-debug=true" [00000.772650][1032][1039][klog] INFO: userboot: option "TERM=dumb" [00000.772651][1032][1039][klog] INFO: userboot: option "kernel.serial=legacy" [00000.772651][1032][1039][klog] INFO: userboot: option "multiboot.boot_loader_name=qemu" [00000.794332][1032][1039][klog] INFO: userboot: searching bootfs for 'bin/bootsvc' [00000.794392][1032][1039][klog] INFO: userboot: 'bin/bootsvc' has PT_INTERP "lib/ld.so.1" [00000.794393][1032][1039][klog] INFO: userboot: searching bootfs for 'lib/ld.so.1' [00000.794436][1032][1039][klog] INFO: userboot: userboot: loaded lib/ld.so.1 at 0x444eda436000, entry point 0x444eda4bc623 [00000.794456][1032][1039][klog] INFO: userboot: userboot: loaded vDSO at 0x45535e80c000, entry point 0x0 [00000.794556][1032][1039][klog] INFO: userboot: process bin/bootsvc started. [00000.794596][1032][1039][klog] INFO: userboot: waiting for loader-service requests... [00000.870056][1032][1039][klog] INFO: userboot: searching bootfs for 'lib/libasync-default.so' [00000.870331][1032][1039][klog] INFO: userboot: searching bootfs for 'lib/libfdio.so' [00000.870558][1032][1039][klog] INFO: userboot: searching bootfs for 'lib/liblaunchpad.so' [00000.870840][1032][1039][klog] INFO: userboot: searching bootfs for 'lib/libtrace-engine.so' [00000.887966][1046][1049][klog] INFO: {{{reset}}} [00000.888005][1046][1049][klog] INFO: {{{module:0:<application>:elf:f8e5b0ae4c0db3ae166d652f108da057e26573dc}}} [00000.888005][1046][1049][klog] INFO: {{{mmap:0x256a902c2000:0x2d000:load:0:rx:0}}} [00000.888006][1046][1049][klog] INFO: {{{mmap:0x256a902ef000:0x4000:load:0:rw:0x2d000}}} [00000.888007][1046][1049][klog] INFO: dso: id=f8e5b0ae4c0db3ae166d652f108da057e26573dc base=0x0000256a902c2000 name=<application> [00000.888008][1046][1049][klog] INFO: {{{module:0x3:libasync-default.so:elf:5e3c55aea09e8943ae76d3603cc8c0b1ba27bfb7}}} [00000.888008][1046][1049][klog] INFO: {{{mmap:0x7e3e33016000:0x1000:load:0x3:rx:0}}} [00000.888009][1046][1049][klog] INFO: {{{mmap:0x7e3e33017000:0x1000:load:0x3:rw:0x1000}}} [00000.888010][1046][1049][klog] INFO: dso: id=5e3c55aea09e8943ae76d3603cc8c0b1ba27bfb7 base=0x00007e3e33016000 name=libasync-default.so [00000.888010][1046][1049][klog] INFO: {{{module:0x2:<vDSO>:elf:1a34fba7caf24078ee471c50d1de84f810448877}}} [00000.888011][1046][1049][klog] INFO: {{{mmap:0x45535e80c000:0x7000:load:0x2:r:0}}} [00000.888011][1046][1049][klog] INFO: {{{mmap:0x45535e813000:0x1000:load:0x2:rx:0x7000}}} [00000.888012][1046][1049][klog] INFO: dso: id=1a34fba7caf24078ee471c50d1de84f810448877 base=0x000045535e80c000 name=<vDSO> [00000.888013][1046][1049][klog] INFO: {{{module:0x1:libc.so:elf:a3c5a3bb3ab016d0bc21ad3b934d4347d27a4ac2}}} [00000.888018][1046][1049][klog] INFO: {{{mmap:0x444eda436000:0xcb000:load:0x1:rx:0}}} [00000.888019][1046][1049][klog] INFO: {{{mmap:0x444eda502000:0x6000:load:0x1:rw:0xcc000}}} [00000.888019][1046][1049][klog] INFO: dso: id=a3c5a3bb3ab016d0bc21ad3b934d4347d27a4ac2 base=0x0000444eda436000 name=libc.so [00000.888020][1046][1049][klog] INFO: {{{module:0x4:libfdio.so:elf:25f32644dbc281d9de73dae21668edd2b273236a}}} [00000.888020][1046][1049][klog] INFO: {{{mmap:0x3b809e384000:0x22000:load:0x4:rx:0}}} [00000.888021][1046][1049][klog] INFO: {{{mmap:0x3b809e3a6000:0x5000:load:0x4:rw:0x22000}}} [00000.888021][1046][1049][klog] INFO: dso: id=25f32644dbc281d9de73dae21668edd2b273236a base=0x00003b809e384000 name=libfdio.so [00000.888022][1046][1049][klog] INFO: {{{module:0x5:liblaunchpad.so:elf:3275d148fdc55d5dfbd06f5a7edb9dc4c294763f}}} [00000.888022][1046][1049][klog] INFO: {{{mmap:0x171ec2f6e000:0x7000:load:0x5:rx:0}}} [00000.888023][1046][1049][klog] INFO: {{{mmap:0x171ec2f75000:0x2000:load:0x5:rw:0x7000}}} [00000.888023][1046][1049][klog] INFO: dso: id=3275d148fdc55d5dfbd06f5a7edb9dc4c294763f base=0x0000171ec2f6e000 name=liblaunchpad.so [00000.888024][1046][1049][klog] INFO: {{{module:0x6:libtrace-engine.so:elf:071211ffaf06a901ea660bf9f3876a312b524143}}} [00000.888024][1046][1049][klog] INFO: {{{mmap:0x6b4b81f3000:0x9000:load:0x6:rx:0}}} [00000.888025][1046][1049][klog] INFO: {{{mmap:0x6b4b81fc000:0x2000:load:0x6:rw:0x9000}}} [00000.888025][1046][1049][klog] INFO: dso: id=071211ffaf06a901ea660bf9f3876a312b524143 base=0x000006b4b81f3000 name=libtrace-engine.so [00000.888288][1046][1049][klog] INFO: bootsvc: Starting... [00000.888467][1046][1049][klog] INFO: bootsvc: Creating bootfs service... [00000.888487][1032][1039][klog] INFO: userboot: loader-service channel peer closed [00000.888540][1032][1039][klog] INFO: userboot: finished! [00001.042119][1046][1049][klog] INFO: bootsvc: Processing bootdata... [00001.042165][1046][1049][klog] INFO: bootsvc: Loading boot cmdline overrides... [00001.042199][1046][1049][klog] INFO: bootsvc: Loading kernel VMOs... [00001.042212][1046][1049][klog] INFO: bootsvc: Creating loader service... [00001.042221][1046][1049][klog] INFO: bootsvc: Launching next process... [00001.043188][1046][1093][klog] INFO: bootsvc: launched bin/devmgr [00001.063204][1101][1114][klog] INFO: devmgr: main() [00001.063255][1101][1114][klog] INFO: devmgr: init [00001.063289][1101][1114][klog] INFO: coordinator_init() [00001.063357][1101][1114][klog] INFO: cmdline: /b/s/w/ir/multiboot.bin= [00001.063386][1101][1114][klog] INFO: cmdline: zircon.autorun.system=/boot/bin/sh+/boot/infra/runcmds [00001.063387][1101][1114][klog] INFO: cmdline: kernel.halt-on-panic=true [00001.063388][1101][1114][klog] INFO: cmdline: devmgr.suspend-timeout-debug=true [00001.063389][1101][1114][klog] INFO: cmdline: TERM=dumb [00001.063390][1101][1114][klog] INFO: cmdline: kernel.serial=legacy [00001.063390][1101][1114][klog] INFO: cmdline: multiboot.boot_loader_name=qemu [00001.063391][1101][1114][klog] INFO: cmdline: devhost.asan.strict=false [00001.063392][1101][1114][klog] INFO: cmdline: devmgr.require-system=true [00001.063393][1101][1114][klog] INFO: cmdline: zircon.system.pkgfs.cmd=bin/pkgsvr+b309a9fa8845f4ab29c22c15f5a372bb748a88ddfd4ce09fa9d2fb1cbc12c420 [00001.063394][1101][1114][klog] INFO: cmdline: zircon.system.pkgfs.file.bin/pkgsvr=f97e96cc498d1cc37c62cd0bbc24065075cc1ef7220b3e00b55aa330becbf49f [00001.063395][1101][1114][klog] INFO: cmdline: zircon.system.pkgfs.file.lib/ld.so.1=9f9954f7cb3c3490edc45e24b2181196753cf990f69387b5c564214a9d66f681 [00001.063396][1101][1114][klog] INFO: cmdline: zircon.system.pkgfs.file.lib/libfdio.so=e180b0d8191e157034f2ce8ad1614706e8729ca104053974391908f2b32d77ef [00001.063401][1101][1114][klog] INFO: devmgr: svc init [00001.064040][1101][1114][klog] INFO: devmgr: launch /boot/bin/svchost (svchost) OK [00001.064091][1101][1114][klog] INFO: devmgr: vfs init [00001.140081][1101][1114][klog] INFO: devmgr: launch /boot/bin/fshost (fshost) OK [00001.140566][1101][1114][klog] INFO: devmgr: coordinator() [00001.140678][1101][1218][klog] INFO: devmgr: shell startup [00001.176809][1177][1204][klog] INFO: fshost: started. [00001.181689][1101][1223][klog] INFO: devmgr: launch /boot/bin/crashsvc (crashsvc) OK [00001.194533][1101][1213][klog] INFO: devmgr: launch /boot/bin/pwrbtn-monitor (pwrbtn-monitor) OK [00001.211527][1101][1223][klog] INFO: devmgr: launch /boot/bin/netsvc (netsvc) OK [00001.235309][1101][1223][klog] INFO: devmgr: launch /boot/bin/virtual-console (virtual-console) OK [00001.270464][1101][1114][klog] INFO: devcoord: launch devhost 'devhost:sys': pid=2008 [00001.276072][1101][1114][klog] INFO: devcoord: launch devhost 'devhost:test': pid=2045 [00001.276107][1101][1114][klog] INFO: devcoord: full system required, ignoring fallback drivers until /system is loaded [00001.291757][1101][1114][klog] INFO: devcoord: launch devhost 'devhost:root': pid=2087 [00001.301408][1101][1114][klog] INFO: devcoord: launch devhost 'devhost:misc': pid=2138 [00001.306131][2008][2032][klog] INFO: acpi-bus: not using IOMMU [00001.325676][2008][2032][klog] INFO: acpi-pwrbtn: initialized [00001.343231][1101][1218][klog] INFO: devmgr: launch /boot/bin/sh (sh:console) OK [00001.408471][2008][2032][klog] INFO: acpi: published device pci(0x7852846de5c0), parent=proxy(0x7852846c50c0), handle=0x7852846b0390 [00001.408813][2008][2032][klog] INFO: acpi: failed to get PCI base bus number for device 'PCI0' (status 4294967295) [00001.421473][2008][2032][klog] INFO: acpi: published device rtc(0x7852846de540), parent=acpi(0x7852846c5240), handle=0x7852846b0840 [00001.431825][2008][2032][klog] INFO: acpi: published device i8042(0x7852846de4c0), parent=acpi(0x7852846c5240), handle=0x7852846b08d0 [00001.434386][2008][2032][klog] INFO: cpuperf_init_once: No PM support [00001.434484][2008][2032][klog] INFO: IntelPT: No PT support [00001.434495][2008][2032][klog] INFO: devhost[proxy/cpu-trace] bind driver '/boot/driver/cpu-trace.so' failed: -2 [00001.434785][1101][1114][klog] INFO: devcoord: rpc: bind-driver 'cpu-trace' status -2 [00001.435201][1609][1701][klog] INFO: vc: new input device /dev/class/input/000 [00001.441810][1101][1114][klog] INFO: devcoord: launch devhost 'devhost:pci#1:1234:1111': pid=2556 [00001.447033][1101][1114][klog] INFO: devcoord: launch devhost 'devhost:pci#2:1af4:1001': pid=2599 [00001.449393][1101][1114][klog] INFO: devcoord: launch devhost 'devhost:pci#3:1af4:1001': pid=2672 [00001.469432][1101][1114][klog] INFO: devcoord: launch devhost 'devhost:pci#5:8086:2922': pid=2739 [00001.476849][2008][2032][klog] INFO: devhost: WARNING: driver '/boot/driver/pc-ps2.so' did not add device in bind() [00001.487093][2008][2826][klog] INFO: i8042 device 0xab 0x41 [00001.495527][2556][2579][klog] INFO: bochs_vbe: initialized display, 1024 x 768 (stride=1024 format=00020001) [00001.496056][1609][1701][klog] INFO: vc: new input device /dev/class/input/001 [00001.509606][1609][1701][klog] INFO: vc: new display device /dev/class/display-controller/000/virtcon [00001.514005][1609][1701][klog] INFO: vc: Successfully attached to display 1 [00001.523283][2739][2778][klog] INFO: ahci: using MSI interrupt [00001.544015][1177][1204][klog] INFO: devmgr: /dev/class/block/000: FVM? [00001.548019][1101][1114][klog] INFO: devcoord: dc_bind_device() '/boot/driver/fvm.so' [00001.569532][1177][1204][klog] INFO: devmgr: launch /boot/bin/blobfs (blobfs:/blob) OK [00001.635238][2008][2826][klog] INFO: i8042 device 0x00 [00001.640935][2008][2032][klog] INFO: hid: boot mouse hack for "hid-device-002": report count (1->1), inp sz (24->24), out sz (0->0), feat sz (0->0) [00001.660874][1177][1204][klog] INFO: fshost: starting 'bin/pkgsvr' 'b309a9fa8845f4ab29c22c15f5a372bb748a88ddfd4ce09fa9d2fb1cbc12c420'... [00001.678196][1609][1701][klog] INFO: vc: new input device /dev/class/input/002 [00001.703756][1177][1204][klog] INFO: devmgr: launch bin/pkgsvr (pkgfs) OK [00001.736328][3260][3484][klog] INFO: pkgsvr: system: will be served from b309a9fa8845f4ab29c22c15f5a372bb748a88ddfd4ce09fa9d2fb1cbc12c420 [00001.736417][3260][3484][klog] INFO: pkgsvr: pkgfs serving index /data/pkgfs_index from blobfs /blob [00001.752490][1177][1204][klog] INFO: devmgr: mounting minfs [00001.760597][1177][1204][klog] INFO: devmgr: launch /boot/bin/minfs (minfs:/data) OK [00001.777893][1101][1720][klog] INFO: devmgr: launch /system/bin/appmgr (appmgr) OK [00001.777966][1101][1720][klog] INFO: zircon.autorun.system: starting '/boot/bin/sh' '/boot/infra/runcmds'... [00001.810119][1101][3540][klog] INFO: devmgr: adding system driver 'wlan' '/system/driver/wlanif.so' [00001.818947][1101][1720][klog] INFO: devmgr: launch /boot/bin/sh (autorun:system) OK [00001.830377][1177][1204][klog] INFO: devmgr: mounting minfs [00001.833505][1177][1204][klog] INFO: fshost: cannot read GUID from minfs-formatted device [00001.844786][1101][3540][klog] INFO: devmgr: adding system driver 'ralink' '/system/driver/ralink.so' [00001.855514][1101][3540][klog] INFO: devmgr: adding system driver 'bt_passthrough_hci' '/system/driver/bthci-passthrough.so' [00001.886328][1101][3540][klog] INFO: devmgr: adding system driver 'qmi_usb' '/system/driver/qmi-transport.so' [00001.931476][1101][3540][klog] INFO: devmgr: adding system driver 'bthost' '/system/driver/bthost.so' [00001.955246][1101][3540][klog] INFO: devmgr: adding system driver 'wlantapctl' '/system/driver/wlantap.so' [00001.977476][1101][3540][klog] INFO: devmgr: adding system driver 'bthci_fake' '/system/driver/bthci-fake.so' [00001.992908][1101][3540][klog] INFO: devmgr: adding system driver 'bthog' '/system/driver/bthog.so' [00002.034314][1101][3540][klog] INFO: devmgr: adding system driver 'btintel' '/system/driver/btintel.so' [00002.068093][1101][3540][klog] INFO: devmgr: adding system driver 'wlan' '/system/driver/wlanphy.so' [00002.095693][4563][4581][klog] INFO: [00002.095721][4563][4581][klog] INFO: ------------------------------------------------ [00002.095724][4563][4581][klog] INFO: RUNNING TEST: /pkgfs/packages/catapult_converter/0/test/catapult_converter_test [00002.095725][4563][4581][klog] INFO: [00002.112103][1101][3540][klog] INFO: devmgr: adding system driver 'usb_video' '/system/driver/usb_video.so' [00002.130408][1101][3540][klog] INFO: devmgr: adding system driver 'rtl88xx' '/system/driver/rtl88xx.so' [00002.151255][1101][3540][klog] INFO: devmgr: adding system driver 'gpu' '/system/driver/libmsd_intel.so' [00002.184527][1101][3540][klog] INFO: devmgr: adding system driver 'ath10k_pci' '/system/driver/ath10k.so' [00002.199400][1101][3540][klog] INFO: devmgr: adding system driver 'brcmfmac' '/system/driver/brcmfmac.so' [00002.235356][1101][3540][klog] INFO: devmgr: adding system driver 'wlan' '/system/driver/wlan.so' [00002.241952][1101][1114][klog] INFO: devcoord: fallback driver 'usb_composite' is available [00002.242038][1101][1114][klog] INFO: devcoord: fallback driver 'intel_disp' is available [00002.242071][1101][1114][klog] INFO: devcoord: driver 'wlan' added [00002.242084][1101][1114][klog] INFO: devcoord: driver 'brcmfmac' added [00002.242086][1101][1114][klog] INFO: devcoord: driver 'ath10k_pci' added [00002.242093][1101][1114][klog] INFO: devcoord: driver 'gpu' added [00002.242096][1101][1114][klog] INFO: devcoord: driver 'rtl88xx' added [00002.242099][1101][1114][klog] INFO: devcoord: driver 'usb_video' added [00002.242101][1101][1114][klog] INFO: devcoord: driver 'wlan' added [00002.242103][1101][1114][klog] INFO: devcoord: driver 'btintel' added [00002.242111][1101][1114][klog] INFO: devcoord: driver 'bthog' added [00002.242133][1101][1114][klog] INFO: devcoord: driver 'bthci_fake' added [00002.242164][1101][1114][klog] INFO: devcoord: driver 'wlantapctl' added [00002.242210][1101][1114][klog] INFO: devcoord: driver 'bthost' added [00002.242212][1101][1114][klog] INFO: devcoord: driver 'qmi_usb' added [00002.242214][1101][1114][klog] INFO: devcoord: driver 'ralink' added [00002.242216][1101][1114][klog] INFO: devcoord: driver 'wlan' added [00002.242218][1101][1114][klog] INFO: devcoord: driver 'bt_passthrough_hci' added [00002.242219][1101][1114][klog] INFO: devcoord: driver 'usb_composite' added [00002.242221][1101][1114][klog] INFO: devcoord: driver 'intel_disp' added [00002.316404][4563][4581][klog] INFO: Running main() from gtest_main.cc [00002.316441][4563][4581][klog] INFO: [==========] Running 8 tests from 2 test cases. [00002.316810][4563][4581][klog] INFO: [----------] Global test environment set-up. [00002.316837][4563][4581][klog] INFO: [----------] 1 test from TestTools [00002.316838][4563][4581][klog] INFO: [ RUN ] TestTools.SplitLines [00002.316838][4563][4581][klog] INFO: [ OK ] TestTools.SplitLines (0 ms) [00002.316839][4563][4581][klog] INFO: [----------] 1 test from TestTools (0 ms total) [00002.316839][4563][4581][klog] INFO: [00002.316840][4563][4581][klog] INFO: [----------] 7 tests from CatapultConverter [00002.316840][4563][4581][klog] INFO: [ RUN ] CatapultConverter.Convert [00002.316841][4563][4581][klog] INFO: [ OK ] CatapultConverter.Convert (0 ms) [00002.316841][4563][4581][klog] INFO: [ RUN ] CatapultConverter.ConvertWithSplitFirst [00002.316842][4563][4581][klog] INFO: [ OK ] CatapultConverter.ConvertWithSplitFirst (0 ms) [00002.316842][4563][4581][klog] INFO: [ RUN ] CatapultConverter.ConvertThroughputUnits [00002.316842][4563][4581][klog] INFO: [ OK ] CatapultConverter.ConvertThroughputUnits (1 ms) [00002.316843][4563][4581][klog] INFO: [ RUN ] CatapultConverter.ConvertBytesUnit [00002.316843][4563][4581][klog] INFO: [ OK ] CatapultConverter.ConvertBytesUnit (0 ms) [00002.316844][4563][4581][klog] INFO: [ RUN ] CatapultConverter.ZeroValues [00002.316844][4563][4581][klog] INFO: [ OK ] CatapultConverter.ZeroValues (0 ms) [00002.316845][4563][4581][klog] INFO: [ RUN ] CatapultConverter.NegativeValues [00002.316845][4563][4581][klog] INFO: [ OK ] CatapultConverter.NegativeValues (0 ms) [00002.316845][4563][4581][klog] INFO: [ RUN ] CatapultConverter.ConverterMain [00002.403986][4563][4581][klog] INFO: [ OK ] CatapultConverter.ConverterMain (5 ms) [00002.404011][4563][4581][klog] INFO: [----------] 7 tests from CatapultConverter (6 ms total) [00002.404012][4563][4581][klog] INFO: [00002.404012][4563][4581][klog] INFO: [----------] Global test environment tear-down [00002.404013][4563][4581][klog] INFO: [==========] 8 tests from 2 test cases ran. (6 ms total) [00002.404013][4563][4581][klog] INFO: [ PASSED ] 8 tests. [00002.404543][4563][4581][klog] INFO: PASSED: /pkgfs/packages/catapult_converter/0/test/catapult_converter_test passed [00002.484202][4563][4581][klog] INFO: [00002.484227][4563][4581][klog] INFO: ------------------------------------------------ [00002.484274][4563][4581][klog] INFO: RUNNING TEST: /pkgfs/packages/dart_zircon_test/0/test/dart_zircon_test [00002.484277][4563][4581][klog] INFO: [00002.889339][6352][6364][klog] INFO: netstack: main.go:40: started [00002.889639][6352][6364][klog] INFO: netstack: main.go:61: socket server started [00002.890005][6352][6364][klog] INFO: netstack: main.go:117: OnInterfacesChanged failed: ErrPeerClosed: zx.Channel.Write [00003.245001][7207][7221][klog] INFO: [INFO:cobalt_main.cc(102)] Cobalt client schedule params: schedule_interval=3600 seconds, min_interval=10 seconds, initial_interval=60 seconds. [00003.324713][2122105589][0][amber] INFO: monitoring for updates [00003.325904][2122105589][0][amber] INFO: system update monitor exited [00003.342617][2122105589][0][amber] INFO: control_server: could not get update for network_time/0: daemon: no update found for network_time/0/ [00003.345394][2122105589][0][amber] INFO: control_server: could not get update for wlancfg/0: daemon: no update found for wlancfg/0/ [00003.346449][2122105589][0][amber] INFO: control_server: could not get update for cobalt_system_metrics/0: daemon: no update found for cobalt_system_metrics/0/ [00003.347209][2122105589][0][amber] INFO: control_server: could not get update for device_settings_manager/0: daemon: no update found for device_settings_manager/0/ [00003.347971][2122105589][0][amber] INFO: control_server: could not get update for mdns/0: daemon: no update found for mdns/0/ [00003.348024][2122105589][0][amber] INFO: control_server: could not get update for netcfg/0: daemon: no update found for netcfg/0/ [00003.348049][2122105589][0][amber] INFO: control_server: could not get update for sshd-host/0: daemon: no update found for sshd-host/0/ [00003.348067][2122105589][0][amber] INFO: control_server: could not get update for thermd/0: daemon: no update found for thermd/0/ [00003.348224][2122105589][0][amber] INFO: control_server: could not get update for dart_zircon_test/0: daemon: no update found for dart_zircon_test/0/ [00003.348561][2122105589][0][amber] INFO: control_server: could not get update for trace_manager/0: daemon: no update found for trace_manager/0/ [00003.466840][7686][7698][network_time] INFO: main.cc(29): Opening client config from /pkg/data/roughtime-servers.json [00003.466854][7686][7698][network_time] INFO: timezone.cc(24): started [00003.699131][7686][7698][network_time] ERROR: garnet/bin/network_time/roughtime_server.cc(61): resolving roughtime.sandbox.google.com:2002: Name does not resolve [00003.735329][8620][8640][klog] INFO: netcfg: started [00003.854377][2122105589][0][amber] INFO: control_server: could not get update for dart_jit_runner/0: daemon: no update found for dart_jit_runner/0/ [00003.854593][2122105589][0][amber] INFO: control_server: could not get update for wlanstack2/0: daemon: no update found for wlanstack2/0/ [00003.985752][9228][9240][klog] INFO: [INFO:main.cc(35)] Trace Manager starting with config: /pkg/data/tracing.config [00004.144677][2122105589][0][amber] INFO: control_server: could not get update for cpuperf_provider/0: daemon: no update found for cpuperf_provider/0/ [00004.147048][2122105589][0][amber] INFO: control_server: could not get update for ktrace_provider/0: daemon: no update found for ktrace_provider/0/ [00004.200457][9564][9579][klog] INFO: wlanstack2 [I]: Starting [00004.495591][9406][10391][klog] INFO: Observatory server failed to start after 1 tries [00004.585972][9406][9812][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/dart_zircon_test#meta/dart_zircon_test.cmx is running from kernel [00004.660730][9406][9812][klog] INFO: 00:00 +0: fromFile [00004.709168][9406][9812][klog] INFO: 00:00 +1: create socket [00004.716606][9406][9812][klog] INFO: 00:00 +2: close socket [00004.723070][9406][9812][klog] INFO: 00:00 +3: read write socket [00004.729515][9406][9812][klog] INFO: 00:00 +4: partial read socket [00004.736865][9406][9812][klog] INFO: 00:00 +5: partial write socket [00004.742782][9406][9812][klog] INFO: 00:00 +6: async wait socket read [00004.749819][9406][9812][klog] INFO: 00:00 +7: async wait socket closed [00004.756617][9406][9812][klog] INFO: 00:00 +8: create channel [00004.761973][9406][9812][klog] INFO: 00:00 +9: close channel [00004.768026][9406][9812][klog] INFO: 00:00 +10: channel bytes [00004.773814][9406][9812][klog] INFO: 00:00 +11: channel handles [00004.779171][9406][9812][klog] INFO: 00:00 +12: async wait channel read [00004.787340][9406][9812][klog] INFO: 00:00 +13: async wait channel closed [00004.801683][9406][9812][klog] INFO: 00:00 +14: All tests passed! [00004.850683][4563][4581][klog] INFO: PASSED: /pkgfs/packages/dart_zircon_test/0/test/dart_zircon_test passed [00004.903062][4563][4581][klog] INFO: [00004.903097][4563][4581][klog] INFO: ------------------------------------------------ [00004.903100][4563][4581][klog] INFO: RUNNING TEST: /pkgfs/packages/deprecated_loop_tests/0/test/deprecated_loop_unittests [00004.903101][4563][4581][klog] INFO: [00004.957327][4563][4581][klog] INFO: [==========] Running 15 tests from 2 test cases. [00004.957360][4563][4581][klog] INFO: [----------] Global test environment set-up. [00004.957360][4563][4581][klog] INFO: [----------] 14 tests from MessageLoop [00004.957361][4563][4581][klog] INFO: [ RUN ] MessageLoop.Current [00004.957361][4563][4581][klog] INFO: [ OK ] MessageLoop.Current (0 ms) [00004.957962][4563][4581][klog] INFO: [ RUN ] MessageLoop.RunsTasksOnCurrentThread [00004.962818][4563][4581][klog] INFO: [ OK ] MessageLoop.RunsTasksOnCurrentThread (1 ms) [00004.962845][4563][4581][klog] INFO: [ RUN ] MessageLoop.CanRunTasks [00004.962846][4563][4581][klog] INFO: [ OK ] MessageLoop.CanRunTasks (0 ms) [00004.962847][4563][4581][klog] INFO: [ RUN ] MessageLoop.CanPostTasksFromTasks [00004.962847][4563][4581][klog] INFO: [ OK ] MessageLoop.CanPostTasksFromTasks (0 ms) [00004.962848][4563][4581][klog] INFO: [ RUN ] MessageLoop.TriplyNestedTasks [00004.962848][4563][4581][klog] INFO: [ OK ] MessageLoop.TriplyNestedTasks (0 ms) [00004.962849][4563][4581][klog] INFO: [ RUN ] MessageLoop.CanRunTasksInOrder [00004.962849][4563][4581][klog] INFO: [ OK ] MessageLoop.CanRunTasksInOrder (0 ms) [00004.962850][4563][4581][klog] INFO: [ RUN ] MessageLoop.CanPreloadTasks [00004.962850][4563][4581][klog] INFO: [ OK ] MessageLoop.CanPreloadTasks (0 ms) [00004.962850][4563][4581][klog] INFO: [ RUN ] MessageLoop.AfterTaskCallbacks [00004.962851][4563][4581][klog] INFO: [ OK ] MessageLoop.AfterTaskCallbacks (0 ms) [00004.962851][4563][4581][klog] INFO: [ RUN ] MessageLoop.RemoveAfterTaskCallbacksDuringCallback [00004.962852][4563][4581][klog] INFO: [ OK ] MessageLoop.RemoveAfterTaskCallbacksDuringCallback (0 ms) [00004.962852][4563][4581][klog] INFO: [ RUN ] MessageLoop.TaskDestructionTime [00004.962853][4563][4581][klog] INFO: [ OK ] MessageLoop.TaskDestructionTime (0 ms) [00004.962853][4563][4581][klog] INFO: [ RUN ] MessageLoop.CanQuitCurrent [00004.962853][4563][4581][klog] INFO: [ OK ] MessageLoop.CanQuitCurrent (0 ms) [00004.962854][4563][4581][klog] INFO: [ RUN ] MessageLoop.CanQuitManyTimes [00004.962854][4563][4581][klog] INFO: [ OK ] MessageLoop.CanQuitManyTimes (0 ms) [00004.962857][4563][4581][klog] INFO: [ RUN ] MessageLoop.FDWaiter [00004.962858][4563][4581][klog] INFO: [ OK ] MessageLoop.FDWaiter (3 ms) [00004.962858][4563][4581][klog] INFO: [ RUN ] MessageLoop.TaskRunnerAvailableDuringLoopDestruction [00004.962859][4563][4581][klog] INFO: [ OK ] MessageLoop.TaskRunnerAvailableDuringLoopDestruction (0 ms) [00004.962859][4563][4581][klog] INFO: [----------] 14 tests from MessageLoop (5 ms total) [00004.962860][4563][4581][klog] INFO: [00004.962861][4563][4581][klog] INFO: [----------] 1 test from Thread [00004.962861][4563][4581][klog] INFO: [ RUN ] Thread.Control [00004.966235][4563][4581][klog] INFO: [ OK ] Thread.Control (4 ms) [00004.966263][4563][4581][klog] INFO: [----------] 1 test from Thread (4 ms total) [00004.966264][4563][4581][klog] INFO: [00004.966264][4563][4581][klog] INFO: [----------] Global test environment tear-down [00004.966265][4563][4581][klog] INFO: [==========] 15 tests from 2 test cases ran. (9 ms total) [00004.966266][4563][4581][klog] INFO: [ PASSED ] 15 tests. [00004.968839][4563][4581][klog] INFO: PASSED: /pkgfs/packages/deprecated_loop_tests/0/test/deprecated_loop_unittests passed [00005.145471][4563][4581][klog] INFO: [00005.145511][4563][4581][klog] INFO: ------------------------------------------------ [00005.145514][4563][4581][klog] INFO: RUNNING TEST: /pkgfs/packages/fidl_bindings_test/0/test/fidl_bindings_test [00005.145515][4563][4581][klog] INFO: [00005.219489][2122105589][0][amber] INFO: control_server: could not get update for fidl_bindings_test/0: daemon: no update found for fidl_bindings_test/0/ [00005.266813][2122105589][0][amber] INFO: control_server: could not get update for dart_jit_runner/0: daemon: no update found for dart_jit_runner/0/ [00005.654151][11458][11806][klog] INFO: Observatory server failed to start after 1 tries [00005.766424][11458][11672][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_bindings_test#meta/fidl_bindings_test.cmx is running from kernel [00005.803284][11458][11672][klog] INFO: clone-test [00005.843311][11458][11672][klog] INFO: 00:00 +0: two way (setUpAll) [00005.886108][2122105589][0][amber] INFO: control_server: could not get update for fidl_bindings_test_server/0: daemon: no update found for fidl_bindings_test_server/0/ [00005.887318][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_bindings_test_server was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_bindings_test_server#meta/fidl_bindings_test_server [00005.887356][4907][4927][klog] INFO: .cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00005.899921][11458][11672][klog] INFO: 00:00 +0: two way no args [00005.985904][11458][12098][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_bindings_test_server is running from kernel [00006.042306][11458][11672][klog] INFO: 00:00 +1: two way string arg [00006.051159][11458][11672][klog] INFO: 00:00 +2: two way three args [00006.068304][11458][11672][klog] INFO: 00:00 +3: two way (tearDownAll) [00006.089935][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00006.091065][11458][11672][klog] INFO: 00:00 +3: proxy state initial [00006.091626][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00006.094379][11458][11672][klog] INFO: 00:00 +4: proxy state request [00006.098012][11458][11672][klog] INFO: 00:00 +5: proxy state bind [00006.102061][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00006.102776][11458][11672][klog] INFO: 00:00 +6: proxy state after bind [00006.106489][11458][11672][klog] INFO: 00:00 +7: proxy state unbind [00006.109919][11458][11672][klog] INFO: 00:00 +8: proxy state close [00006.113084][11458][11672][klog] INFO: 00:00 +9: proxy state after close [00006.120268][11458][11672][klog] INFO: 00:00 +10: hash and equality enums simple [00006.122594][11458][11672][klog] INFO: 00:00 +11: hash and equality enums constructed [00006.124547][11458][11672][klog] INFO: 00:00 +12: hash and equality enums different types [00006.126490][11458][11672][klog] INFO: 00:00 +13: hash and equality enums map [00006.128563][11458][11672][klog] INFO: 00:00 +14: hash and equality structs no handles [00006.131804][11458][11672][klog] INFO: 00:00 +15: hash and equality structs handles [00006.134775][11458][11672][klog] INFO: 00:00 +16: hash and equality unions equality [00006.139474][11458][11672][klog] INFO: 00:00 +17: hash and equality unions hash [00006.141698][11458][11672][klog] INFO: 00:00 +18: one way (setUpAll) [00006.144885][2122105589][0][amber] INFO: control_server: could not get update for fidl_bindings_test_server/0: daemon: no update found for fidl_bindings_test_server/0/ [00006.147618][11458][11672][klog] INFO: 00:00 +18: one way no args [00006.155499][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_bindings_test_server was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_bindings_test_server#meta/fidl_bindings_test_server [00006.155541][4907][4927][klog] INFO: .cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00006.258418][11458][12308][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_bindings_test_server is running from kernel [00006.320526][11458][11672][klog] INFO: 00:00 +19: one way string arg [00006.329397][11458][11672][klog] INFO: 00:00 +20: one way three args [00006.346442][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00006.346864][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00006.347533][11458][11672][klog] INFO: 00:00 +21: one way table [00006.362541][11458][11672][klog] INFO: 00:00 +22: one way partial table [00006.366946][11458][11672][klog] INFO: 00:00 +23: one way empty table [00006.370838][11458][11672][klog] INFO: 00:00 +24: one way (tearDownAll) [00006.373567][11458][11672][klog] INFO: 00:00 +24: clone exact [00006.376133][11458][11672][klog] INFO: 00:00 +25: clone modify field [00006.378047][11458][11672][klog] INFO: 00:00 +26: clone set field [00006.380366][11458][11672][klog] INFO: 00:00 +27: clone unset field [00006.382942][11458][11672][klog] INFO: 00:00 +28: failure remote close during call [00006.391536][2122105589][0][amber] INFO: control_server: could not get update for fidl_bindings_test_server/0: daemon: no update found for fidl_bindings_test_server/0/ [00006.393026][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_bindings_test_server was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_bindings_test_server#meta/fidl_bindings_test_server [00006.393099][4907][4927][klog] INFO: .cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00006.393277][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00006.407756][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00006.479190][11458][12494][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_bindings_test_server is running from kernel [00006.628306][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00006.639025][11458][11672][klog] INFO: 00:00 +29: failure local close during call [00006.640116][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00006.648109][2122105589][0][amber] INFO: control_server: could not get update for fidl_bindings_test_server/0: daemon: no update found for fidl_bindings_test_server/0/ [00006.648800][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_bindings_test_server was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_bindings_test_server#meta/fidl_bindings_test_server [00006.648845][4907][4927][klog] INFO: .cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00006.650780][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00006.651634][11458][11672][klog] INFO: 00:00 +30: failure server killed during call [00006.665295][11458][12000][klog] INFO: Observatory server failed to start after 2 tries [00006.687043][2122105589][0][amber] INFO: control_server: could not get update for fidl_bindings_test_server/0: daemon: no update found for fidl_bindings_test_server/0/ [00006.687740][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_bindings_test_server was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_bindings_test_server#meta/fidl_bindings_test_server [00006.687849][4907][4927][klog] INFO: .cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00006.830330][11458][12678][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_bindings_test_server is running from kernel [00006.833406][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00006.844419][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00006.857304][11458][12753][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_bindings_test_server is running from kernel [00006.868286][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00006.873146][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00006.873487][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00006.876033][11458][11672][klog] INFO: 00:01 +31: failure one-way call on closed proxy [00006.879087][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_bindings_test_server was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_bindings_test_server#meta/fidl_bindings_test_server [00006.879120][4907][4927][klog] INFO: .cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00006.878622][2122105589][0][amber] INFO: control_server: could not get update for fidl_bindings_test_server/0: daemon: no update found for fidl_bindings_test_server/0/ [00006.883073][11458][11672][klog] INFO: 00:01 +32: failure two-way call on closed proxy [00006.888250][11458][11672][klog] INFO: 00:01 +33: failure listen for events on a closed proxy [00006.894853][11458][11672][klog] INFO: 00:01 +34: failure proxy closes while listening for events [00006.899936][11458][11672][klog] INFO: 00:01 +35: failure binding closes immediately after sending response [00006.908748][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00006.911766][11458][11672][klog] INFO: 00:01 +36: unbound one-way call on unbound proxy [00006.915016][11458][11672][klog] INFO: 00:01 +37: unbound two-way call on unbound proxy [00006.916528][2122105589][0][amber] INFO: control_server: could not get update for fidl_bindings_test_server/0: daemon: no update found for fidl_bindings_test_server/0/ [00006.917334][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_bindings_test_server was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_bindings_test_server#meta/fidl_bindings_test_server [00006.917447][4907][4927][klog] INFO: .cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00006.919992][11458][11672][klog] INFO: 00:01 +38: unbound event listen on unbound proxy [00006.922910][2122105589][0][amber] INFO: control_server: could not get update for fidl_bindings_test_server/0: daemon: no update found for fidl_bindings_test_server/0/ [00006.924239][2122105589][0][amber] INFO: control_server: could not get update for fidl_bindings_test_server/0: daemon: no update found for fidl_bindings_test_server/0/ [00006.924390][2122105589][0][amber] INFO: control_server: could not get update for fidl_bindings_test_server/0: daemon: no update found for fidl_bindings_test_server/0/ [00006.927862][11458][11672][klog] INFO: 00:01 +39: events (setUpAll) [00006.934691][11458][11672][klog] INFO: 00:01 +39: events empty [00006.974978][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_bindings_test_server was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_bindings_test_server#meta/fidl_bindings_test_server [00006.975237][2122105589][0][amber] INFO: control_server: could not get update for fidl_bindings_test_server/0: daemon: no update found for fidl_bindings_test_server/0/ [00006.975008][4907][4927][klog] INFO: .cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00006.996592][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_bindings_test_server was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_bindings_test_server#meta/fidl_bindings_test_server [00006.996625][4907][4927][klog] INFO: .cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00007.000164][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_bindings_test_server was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_bindings_test_server#meta/fidl_bindings_test_server [00007.000194][4907][4927][klog] INFO: .cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00007.003107][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_bindings_test_server was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_bindings_test_server#meta/fidl_bindings_test_server [00007.003136][4907][4927][klog] INFO: .cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00007.022517][11458][12999][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_bindings_test_server is running from kernel [00007.026616][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00007.057624][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00007.660854][11458][13161][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_bindings_test_server is running from kernel [00007.672761][11458][12410][klog] INFO: Observatory server failed to start after 3 tries [00007.709596][11458][13200][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_bindings_test_server is running from kernel [00007.720113][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00007.733517][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00007.739577][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00007.743551][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00007.817766][11458][13280][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_bindings_test_server is running from kernel [00007.831928][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00007.839355][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00007.977706][11458][13403][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_bindings_test_server is running from kernel [00007.978290][11458][13369][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_bindings_test_server is running from kernel [00007.987086][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00007.997008][11458][11672][klog] INFO: Proxy error: Peer unexpectedly closed [00008.047565][11458][11672][klog] INFO: 00:02 +40: events string arg [00008.054395][11458][11672][klog] INFO: 00:02 +41: events three args [00008.064753][11458][11672][klog] INFO: 00:02 +42: events multiple events [00008.189572][11458][11672][klog] INFO: 00:02 +43: events (tearDownAll) [00008.210336][11458][11672][klog] INFO: 00:02 +43: All tests passed! [00008.249188][4563][4581][klog] INFO: PASSED: /pkgfs/packages/fidl_bindings_test/0/test/fidl_bindings_test passed [00008.303070][4563][4581][klog] INFO: [00008.303122][4563][4581][klog] INFO: ------------------------------------------------ [00008.303125][4563][4581][klog] INFO: RUNNING TEST: /pkgfs/packages/fidl_compatibility_test/0/test/run_fidl_compatibility_test_topaz.sh [00008.303126][4563][4581][klog] INFO: [00008.368804][4563][4581][klog] INFO: [==========] Running 32 tests from 1 test case. [00008.368835][4563][4581][klog] INFO: [----------] Global test environment set-up. [00008.368836][4563][4581][klog] INFO: [----------] 32 tests from CompatibilityTest/CompatibilityTest [00008.368836][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStruct/0 [00008.371520][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_cpp was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_cpp#meta/fidl_co [00008.371564][4907][4927][klog] INFO: mpatibility_test_server_cpp.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00008.370998][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_cpp/0: daemon: no update found for fidl_compatibility_test_server_cpp/0/ [00008.452447][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_cpp/0: daemon: no update found for fidl_compatibility_test_server_cpp/0/ [00008.453560][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_cpp was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_cpp#meta/fidl_co [00008.453628][4907][4927][klog] INFO: mpatibility_test_server_cpp.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00008.551473][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStruct/0 (182 ms) [00008.551509][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStruct/1 [00008.564285][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_cpp/0: daemon: no update found for fidl_compatibility_test_server_cpp/0/ [00008.565067][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_cpp was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_cpp#meta/fidl_co [00008.565099][4907][4927][klog] INFO: mpatibility_test_server_cpp.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00008.631144][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_dart/0: daemon: no update found for fidl_compatibility_test_server_dart/0/ [00008.631921][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_dart was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart#meta/fidl_ [00008.631965][4907][4927][klog] INFO: compatibility_test_server_dart.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00008.674886][2122105589][0][amber] INFO: control_server: could not get update for dart_jit_runner/0: daemon: no update found for dart_jit_runner/0/ [00008.831483][2122105589][0][amber] INFO: control_server: could not get update for timezone/0: daemon: no update found for timezone/0/ [00009.081309][14925][15511][klog] INFO: Observatory listening on http://127.0.0.1:26913/ [00009.084564][14925][15511][klog] INFO: Creating /tmp/dart.services/26913 [00009.090765][14925][15162][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart is running from kernel [00009.191624][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStruct/1 (640 ms) [00009.191657][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStruct/2 [00009.203099][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_cpp/0: daemon: no update found for fidl_compatibility_test_server_cpp/0/ [00009.203826][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_cpp was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_cpp#meta/fidl_co [00009.203867][4907][4927][klog] INFO: mpatibility_test_server_cpp.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00009.260143][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_go/0: daemon: no update found for fidl_compatibility_test_server_go/0/ [00009.260592][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_go was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_go#meta/fidl_comp [00009.260638][4907][4927][klog] INFO: atibility_test_server_go.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00009.369195][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStruct/2 (178 ms) [00009.369255][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStruct/3 [00009.381419][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_cpp/0: daemon: no update found for fidl_compatibility_test_server_cpp/0/ [00009.382150][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_cpp was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_cpp#meta/fidl_co [00009.382197][4907][4927][klog] INFO: mpatibility_test_server_cpp.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00009.445830][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_rust/0: daemon: no update found for fidl_compatibility_test_server_rust/0/ [00009.446554][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_rust was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_rust#meta/fidl_ [00009.446626][4907][4927][klog] INFO: compatibility_test_server_rust.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00009.530378][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStruct/3 (161 ms) [00009.530410][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStruct/4 [00009.544786][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_dart/0: daemon: no update found for fidl_compatibility_test_server_dart/0/ [00009.545097][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_dart was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart#meta/fidl_ [00009.545135][4907][4927][klog] INFO: compatibility_test_server_dart.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00009.638382][14925][16646][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart is running from kernel [00009.706103][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_cpp/0: daemon: no update found for fidl_compatibility_test_server_cpp/0/ [00009.706455][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_cpp was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_cpp#meta/fidl_co [00009.706485][4907][4927][klog] INFO: mpatibility_test_server_cpp.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00009.783832][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStruct/4 (253 ms) [00009.783885][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStruct/5 [00009.787984][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_dart/0: daemon: no update found for fidl_compatibility_test_server_dart/0/ [00009.801019][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_dart was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart#meta/fidl_ [00009.801612][4907][4927][klog] INFO: compatibility_test_server_dart.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00009.912344][14925][17081][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart is running from kernel [00009.980916][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_dart was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart#meta/fidl_ [00009.980951][4907][4927][klog] INFO: compatibility_test_server_dart.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00009.980535][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_dart/0: daemon: no update found for fidl_compatibility_test_server_dart/0/ [00010.051459][14925][17266][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart is running from kernel [00010.137684][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStruct/5 (353 ms) [00010.144526][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStruct/6 [00010.152664][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_dart/0: daemon: no update found for fidl_compatibility_test_server_dart/0/ [00010.153340][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_dart was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart#meta/fidl_ [00010.153398][4907][4927][klog] INFO: compatibility_test_server_dart.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00010.249020][14925][17482][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart is running from kernel [00010.327995][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_go/0: daemon: no update found for fidl_compatibility_test_server_go/0/ [00010.329252][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_go was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_go#meta/fidl_comp [00010.329296][4907][4927][klog] INFO: atibility_test_server_go.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00010.429020][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStruct/6 (273 ms) [00010.427005][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_dart/0: daemon: no update found for fidl_compatibility_test_server_dart/0/ [00010.430465][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStruct/7 [00010.451130][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_dart was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart#meta/fidl_ [00010.451686][4907][4927][klog] INFO: compatibility_test_server_dart.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00010.554967][14925][18006][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart is running from kernel [00010.630954][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_rust/0: daemon: no update found for fidl_compatibility_test_server_rust/0/ [00010.631449][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_rust was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_rust#meta/fidl_ [00010.631487][4907][4927][klog] INFO: compatibility_test_server_rust.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00010.713408][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStruct/7 (294 ms) [00010.713452][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStruct/8 [00010.732315][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_go/0: daemon: no update found for fidl_compatibility_test_server_go/0/ [00010.738466][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_go was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_go#meta/fidl_comp [00010.738740][4907][4927][klog] INFO: atibility_test_server_go.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00010.833363][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_cpp/0: daemon: no update found for fidl_compatibility_test_server_cpp/0/ [00010.833966][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_cpp was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_cpp#meta/fidl_co [00010.834030][4907][4927][klog] INFO: mpatibility_test_server_cpp.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00010.902006][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStruct/8 (188 ms) [00010.902330][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStruct/9 [00010.918413][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_go/0: daemon: no update found for fidl_compatibility_test_server_go/0/ [00010.919166][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_go was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_go#meta/fidl_comp [00010.919216][4907][4927][klog] INFO: atibility_test_server_go.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00011.009537][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_dart/0: daemon: no update found for fidl_compatibility_test_server_dart/0/ [00011.010102][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_dart was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart#meta/fidl_ [00011.010138][4907][4927][klog] INFO: compatibility_test_server_dart.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00011.114561][14925][19134][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart is running from kernel [00011.199161][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStruct/9 (298 ms) [00011.199186][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStruct/10 [00011.217427][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_go/0: daemon: no update found for fidl_compatibility_test_server_go/0/ [00011.227574][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_go was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_go#meta/fidl_comp [00011.242549][4907][4927][klog] INFO: atibility_test_server_go.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00011.338689][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_go/0: daemon: no update found for fidl_compatibility_test_server_go/0/ [00011.339361][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_go was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_go#meta/fidl_comp [00011.339396][4907][4927][klog] INFO: atibility_test_server_go.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00011.399864][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStruct/10 (201 ms) [00011.399903][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStruct/11 [00011.412242][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_go/0: daemon: no update found for fidl_compatibility_test_server_go/0/ [00011.412993][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_go was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_go#meta/fidl_comp [00011.413021][4907][4927][klog] INFO: atibility_test_server_go.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00011.499877][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_rust/0: daemon: no update found for fidl_compatibility_test_server_rust/0/ [00011.503002][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_rust was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_rust#meta/fidl_ [00011.503065][4907][4927][klog] INFO: compatibility_test_server_rust.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00011.576260][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStruct/11 (176 ms) [00011.576398][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStruct/12 [00011.589466][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_rust/0: daemon: no update found for fidl_compatibility_test_server_rust/0/ [00011.593142][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_rust was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_rust#meta/fidl_ [00011.593167][4907][4927][klog] INFO: compatibility_test_server_rust.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00011.663642][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_cpp/0: daemon: no update found for fidl_compatibility_test_server_cpp/0/ [00011.664244][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_cpp was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_cpp#meta/fidl_co [00011.664307][4907][4927][klog] INFO: mpatibility_test_server_cpp.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00011.734927][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStruct/12 (159 ms) [00011.734951][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStruct/13 [00011.760884][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_rust/0: daemon: no update found for fidl_compatibility_test_server_rust/0/ [00011.761357][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_rust was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_rust#meta/fidl_ [00011.761402][4907][4927][klog] INFO: compatibility_test_server_rust.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00011.834480][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_dart/0: daemon: no update found for fidl_compatibility_test_server_dart/0/ [00011.835138][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_dart was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart#meta/fidl_ [00011.835220][4907][4927][klog] INFO: compatibility_test_server_dart.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00011.920072][14925][20847][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart is running from kernel [00012.018039][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStruct/13 (281 ms) [00012.025241][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStruct/14 [00012.058628][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_rust/0: daemon: no update found for fidl_compatibility_test_server_rust/0/ [00012.064983][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_rust was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_rust#meta/fidl_ [00012.065009][4907][4927][klog] INFO: compatibility_test_server_rust.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00012.135580][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_go/0: daemon: no update found for fidl_compatibility_test_server_go/0/ [00012.136709][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_go was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_go#meta/fidl_comp [00012.136751][4907][4927][klog] INFO: atibility_test_server_go.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00012.221860][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_rust/0: daemon: no update found for fidl_compatibility_test_server_rust/0/ [00012.222332][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_rust was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_rust#meta/fidl_ [00012.222357][4907][4927][klog] INFO: compatibility_test_server_rust.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00012.251899][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStruct/14 (200 ms) [00012.251954][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStruct/15 [00012.307726][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_rust/0: daemon: no update found for fidl_compatibility_test_server_rust/0/ [00012.308086][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_rust was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_rust#meta/fidl_ [00012.308148][4907][4927][klog] INFO: compatibility_test_server_rust.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00012.361934][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStruct/15 (144 ms) [00012.361990][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/0 [00012.374969][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_cpp/0: daemon: no update found for fidl_compatibility_test_server_cpp/0/ [00012.375292][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_cpp was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_cpp#meta/fidl_co [00012.375357][4907][4927][klog] INFO: mpatibility_test_server_cpp.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00012.438330][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_cpp/0: daemon: no update found for fidl_compatibility_test_server_cpp/0/ [00012.438953][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_cpp was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_cpp#meta/fidl_co [00012.438979][4907][4927][klog] INFO: mpatibility_test_server_cpp.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00012.495649][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/0 (133 ms) [00012.495693][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/1 [00012.536353][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_cpp/0: daemon: no update found for fidl_compatibility_test_server_cpp/0/ [00012.539389][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_cpp was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_cpp#meta/fidl_co [00012.539466][4907][4927][klog] INFO: mpatibility_test_server_cpp.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00012.615875][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_dart/0: daemon: no update found for fidl_compatibility_test_server_dart/0/ [00012.616207][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_dart was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart#meta/fidl_ [00012.616243][4907][4927][klog] INFO: compatibility_test_server_dart.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00012.714723][14925][22367][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart is running from kernel [00012.801930][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/1 (307 ms) [00012.801965][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/2 [00012.824889][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_cpp/0: daemon: no update found for fidl_compatibility_test_server_cpp/0/ [00012.826623][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_cpp was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_cpp#meta/fidl_co [00012.826691][4907][4927][klog] INFO: mpatibility_test_server_cpp.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00012.907098][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_go/0: daemon: no update found for fidl_compatibility_test_server_go/0/ [00012.907521][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_go was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_go#meta/fidl_comp [00012.907578][4907][4927][klog] INFO: atibility_test_server_go.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00012.996001][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/2 (194 ms) [00012.996059][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/3 [00013.009612][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_cpp was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_cpp#meta/fidl_co [00013.009718][4907][4927][klog] INFO: mpatibility_test_server_cpp.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00013.005603][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_cpp/0: daemon: no update found for fidl_compatibility_test_server_cpp/0/ [00013.074082][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_rust/0: daemon: no update found for fidl_compatibility_test_server_rust/0/ [00013.074756][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_rust was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_rust#meta/fidl_ [00013.074846][4907][4927][klog] INFO: compatibility_test_server_rust.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00013.142883][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/3 (146 ms) [00013.143843][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/4 [00013.157699][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_dart/0: daemon: no update found for fidl_compatibility_test_server_dart/0/ [00013.161259][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_dart was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart#meta/fidl_ [00013.161286][4907][4927][klog] INFO: compatibility_test_server_dart.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00013.260132][14925][23441][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart is running from kernel [00013.326803][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_cpp/0: daemon: no update found for fidl_compatibility_test_server_cpp/0/ [00013.327175][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_cpp was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_cpp#meta/fidl_co [00013.327214][4907][4927][klog] INFO: mpatibility_test_server_cpp.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00013.405325][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/4 (261 ms) [00013.405362][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/5 [00013.421752][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_dart/0: daemon: no update found for fidl_compatibility_test_server_dart/0/ [00013.425757][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_dart was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart#meta/fidl_ [00013.425790][4907][4927][klog] INFO: compatibility_test_server_dart.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00013.527531][14925][23848][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart is running from kernel [00013.605281][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_dart/0: daemon: no update found for fidl_compatibility_test_server_dart/0/ [00013.605801][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_dart was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart#meta/fidl_ [00013.605844][4907][4927][klog] INFO: compatibility_test_server_dart.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00013.681799][14925][24026][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart is running from kernel [00013.787522][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/5 (381 ms) [00013.787553][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/6 [00013.803219][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_dart was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart#meta/fidl_ [00013.803260][4907][4927][klog] INFO: compatibility_test_server_dart.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00013.799274][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_dart/0: daemon: no update found for fidl_compatibility_test_server_dart/0/ [00013.905812][14925][24244][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart is running from kernel [00013.990554][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_go/0: daemon: no update found for fidl_compatibility_test_server_go/0/ [00013.990963][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_go was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_go#meta/fidl_comp [00013.990989][4907][4927][klog] INFO: atibility_test_server_go.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00014.089854][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/6 (304 ms) [00014.089903][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/7 [00014.097677][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_dart/0: daemon: no update found for fidl_compatibility_test_server_dart/0/ [00014.098153][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_dart was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart#meta/fidl_ [00014.098191][4907][4927][klog] INFO: compatibility_test_server_dart.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00014.196739][14925][24761][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart is running from kernel [00014.273269][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_rust/0: daemon: no update found for fidl_compatibility_test_server_rust/0/ [00014.273984][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_rust was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_rust#meta/fidl_ [00014.274018][4907][4927][klog] INFO: compatibility_test_server_rust.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00014.357308][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/7 (267 ms) [00014.357342][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/8 [00014.369153][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_go/0: daemon: no update found for fidl_compatibility_test_server_go/0/ [00014.369779][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_go was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_go#meta/fidl_comp [00014.369825][4907][4927][klog] INFO: atibility_test_server_go.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00014.478917][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_cpp/0: daemon: no update found for fidl_compatibility_test_server_cpp/0/ [00014.479641][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_cpp was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_cpp#meta/fidl_co [00014.479705][4907][4927][klog] INFO: mpatibility_test_server_cpp.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00014.552255][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/8 (195 ms) [00014.552278][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/9 [00014.553710][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_go/0: daemon: no update found for fidl_compatibility_test_server_go/0/ [00014.558273][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_go was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_go#meta/fidl_comp [00014.558476][4907][4927][klog] INFO: atibility_test_server_go.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00014.653501][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_dart/0: daemon: no update found for fidl_compatibility_test_server_dart/0/ [00014.653910][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_dart was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart#meta/fidl_ [00014.653945][4907][4927][klog] INFO: compatibility_test_server_dart.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00014.754135][14925][25871][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart is running from kernel [00014.848774][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/9 (296 ms) [00014.848801][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/10 [00014.861498][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_go/0: daemon: no update found for fidl_compatibility_test_server_go/0/ [00014.862261][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_go was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_go#meta/fidl_comp [00014.862325][4907][4927][klog] INFO: atibility_test_server_go.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00014.947609][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_go/0: daemon: no update found for fidl_compatibility_test_server_go/0/ [00014.948376][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_go was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_go#meta/fidl_comp [00014.948406][4907][4927][klog] INFO: atibility_test_server_go.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00015.017562][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/10 (168 ms) [00015.017589][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/11 [00015.018806][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_go/0: daemon: no update found for fidl_compatibility_test_server_go/0/ [00015.024871][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_go was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_go#meta/fidl_comp [00015.024905][4907][4927][klog] INFO: atibility_test_server_go.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00015.115793][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_rust/0: daemon: no update found for fidl_compatibility_test_server_rust/0/ [00015.116596][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_rust was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_rust#meta/fidl_ [00015.116667][4907][4927][klog] INFO: compatibility_test_server_rust.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00015.198027][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/11 (180 ms) [00015.198070][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/12 [00015.200169][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_rust was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_rust#meta/fidl_ [00015.200199][4907][4927][klog] INFO: compatibility_test_server_rust.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00015.199776][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_rust/0: daemon: no update found for fidl_compatibility_test_server_rust/0/ [00015.292215][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_cpp/0: daemon: no update found for fidl_compatibility_test_server_cpp/0/ [00015.292802][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_cpp was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_cpp#meta/fidl_co [00015.292845][4907][4927][klog] INFO: mpatibility_test_server_cpp.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00015.370200][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/12 (172 ms) [00015.370223][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/13 [00015.391255][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_rust/0: daemon: no update found for fidl_compatibility_test_server_rust/0/ [00015.391731][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_rust was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_rust#meta/fidl_ [00015.391776][4907][4927][klog] INFO: compatibility_test_server_rust.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00015.465826][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_dart/0: daemon: no update found for fidl_compatibility_test_server_dart/0/ [00015.466477][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_dart was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart#meta/fidl_ [00015.466528][4907][4927][klog] INFO: compatibility_test_server_dart.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00015.568371][14925][27561][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_dart is running from kernel [00015.648825][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/13 (280 ms) [00015.648857][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/14 [00015.681463][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_rust/0: daemon: no update found for fidl_compatibility_test_server_rust/0/ [00015.684631][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_rust was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_rust#meta/fidl_ [00015.684658][4907][4927][klog] INFO: compatibility_test_server_rust.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00015.768699][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_go/0: daemon: no update found for fidl_compatibility_test_server_go/0/ [00015.770370][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_go was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_go#meta/fidl_comp [00015.770414][4907][4927][klog] INFO: atibility_test_server_go.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00015.879388][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/14 (230 ms) [00015.879416][4563][4581][klog] INFO: [ RUN ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/15 [00015.901706][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_rust/0: daemon: no update found for fidl_compatibility_test_server_rust/0/ [00015.902155][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_rust was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_rust#meta/fidl_ [00015.902219][4907][4927][klog] INFO: compatibility_test_server_rust.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00015.975241][2122105589][0][amber] INFO: control_server: could not get update for fidl_compatibility_test_server_rust/0: daemon: no update found for fidl_compatibility_test_server_rust/0/ [00015.976151][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://fidl_compatibility_test_server_rust was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/fidl_compatibility_test_server_rust#meta/fidl_ [00015.976190][4907][4927][klog] INFO: compatibility_test_server_rust.cmx instead. See https://fuchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00016.028546][4563][4581][klog] INFO: [ OK ] CompatibilityTest/CompatibilityTest.EchoStructNoRetVal/15 (149 ms) [00016.028587][4563][4581][klog] INFO: [----------] 32 tests from CompatibilityTest/CompatibilityTest (7659 ms total) [00016.028690][4563][4581][klog] INFO: [00016.028712][4563][4581][klog] INFO: [----------] Global test environment tear-down [00016.028737][4563][4581][klog] INFO: [==========] 32 tests from 1 test case ran. (7660 ms total) [00016.028739][4563][4581][klog] INFO: [ PASSED ] 32 tests. [00016.043206][4563][4581][klog] INFO: PASSED: /pkgfs/packages/fidl_compatibility_test/0/test/run_fidl_compatibility_test_topaz.sh passed [00018.947769][4563][4581][klog] INFO: [00018.947800][4563][4581][klog] INFO: ------------------------------------------------ [00018.947803][4563][4581][klog] INFO: RUNNING TEST: /pkgfs/packages/flutter_runner_tests/0/test/flutter_runner_unittests [00018.947803][4563][4581][klog] INFO: [00019.091358][4563][4581][klog] INFO: Running main() from gtest_main.cc [00019.091538][4563][4581][klog] INFO: [==========] Running 10 tests from 1 test case. [00019.091581][4563][4581][klog] INFO: [----------] Global test environment set-up. [00019.091581][4563][4581][klog] INFO: [----------] 10 tests from FuchsiaFontManagerTest [00019.091581][4563][4581][klog] INFO: [ RUN ] FuchsiaFontManagerTest.ValidResponseWhenCharacterFound [00019.104196][2122105589][0][amber] INFO: control_server: could not get update for fonts/0: daemon: no update found for fonts/0/ [00019.292653][4563][4581][klog] INFO: [ OK ] FuchsiaFontManagerTest.ValidResponseWhenCharacterFound (201 ms) [00019.292682][4563][4581][klog] INFO: [ RUN ] FuchsiaFontManagerTest.EmptyResponseWhenCharacterNotFound [00019.306912][2122105589][0][amber] INFO: control_server: could not get update for fonts/0: daemon: no update found for fonts/0/ [00019.475002][4563][4581][klog] INFO: [ OK ] FuchsiaFontManagerTest.EmptyResponseWhenCharacterNotFound (183 ms) [00019.475024][4563][4581][klog] INFO: [ RUN ] FuchsiaFontManagerTest.Caching [00019.497327][2122105589][0][amber] INFO: control_server: could not get update for fonts/0: daemon: no update found for fonts/0/ [00019.694261][4563][4581][klog] INFO: [ OK ] FuchsiaFontManagerTest.Caching (219 ms) [00019.694289][4563][4581][klog] INFO: [ RUN ] FuchsiaFontManagerTest.TypefaceOutlivesManager [00019.706788][2122105589][0][amber] INFO: control_server: could not get update for fonts/0: daemon: no update found for fonts/0/ [00019.888214][4563][4581][klog] INFO: [ OK ] FuchsiaFontManagerTest.TypefaceOutlivesManager (194 ms) [00019.888261][4563][4581][klog] INFO: [ RUN ] FuchsiaFontManagerTest.ReleaseThenCreateAgain [00019.901723][2122105589][0][amber] INFO: control_server: could not get update for fonts/0: daemon: no update found for fonts/0/ [00020.076834][4563][4581][klog] INFO: [ OK ] FuchsiaFontManagerTest.ReleaseThenCreateAgain (189 ms) [00020.076876][4563][4581][klog] INFO: [ RUN ] FuchsiaFontManagerTest.ReleasedTypefaceIsPurged [00020.088887][2122105589][0][amber] INFO: control_server: could not get update for fonts/0: daemon: no update found for fonts/0/ [00020.274115][4563][4581][klog] INFO: [ OK ] FuchsiaFontManagerTest.ReleasedTypefaceIsPurged (197 ms) [00020.274155][4563][4581][klog] INFO: [ RUN ] FuchsiaFontManagerTest.MatchUnknownFamily [00020.296190][2122105589][0][amber] INFO: control_server: could not get update for fonts/0: daemon: no update found for fonts/0/ [00020.470140][4563][4581][klog] INFO: [ OK ] FuchsiaFontManagerTest.MatchUnknownFamily (194 ms) [00020.470164][4563][4581][klog] INFO: [ RUN ] FuchsiaFontManagerTest.MatchKnownFamily [00020.498571][2122105589][0][amber] INFO: control_server: could not get update for fonts/0: daemon: no update found for fonts/0/ [00020.683061][4563][4581][klog] INFO: [ OK ] FuchsiaFontManagerTest.MatchKnownFamily (215 ms) [00020.683084][4563][4581][klog] INFO: [ RUN ] FuchsiaFontManagerTest.FontFamilyGetStyle [00020.700375][2122105589][0][amber] INFO: control_server: could not get update for fonts/0: daemon: no update found for fonts/0/ [00020.875094][4563][4581][klog] INFO: [ OK ] FuchsiaFontManagerTest.FontFamilyGetStyle (192 ms) [00020.875118][4563][4581][klog] INFO: [ RUN ] FuchsiaFontManagerTest.FontFamilyCreateTypeface [00020.919828][2122105589][0][amber] INFO: control_server: could not get update for fonts/0: daemon: no update found for fonts/0/ [00021.087355][4563][4581][klog] INFO: [ OK ] FuchsiaFontManagerTest.FontFamilyCreateTypeface (212 ms) [00021.087392][4563][4581][klog] INFO: [----------] 10 tests from FuchsiaFontManagerTest (1996 ms total) [00021.087414][4563][4581][klog] INFO: [00021.087415][4563][4581][klog] INFO: [----------] Global test environment tear-down [00021.087415][4563][4581][klog] INFO: [==========] 10 tests from 1 test case ran. (1996 ms total) [00021.087416][4563][4581][klog] INFO: [ PASSED ] 10 tests. [00021.115746][4563][4581][klog] INFO: PASSED: /pkgfs/packages/flutter_runner_tests/0/test/flutter_runner_unittests passed [00021.160948][4563][4581][klog] INFO: [00021.160980][4563][4581][klog] INFO: ------------------------------------------------ [00021.160982][4563][4581][klog] INFO: RUNNING TEST: /pkgfs/packages/fuchsia_modular_package_integration_tests/0/test/fuchsia_modular_package_integration_tests [00021.160983][4563][4581][klog] INFO: [00021.227331][2122105589][0][amber] INFO: control_server: could not get update for fuchsia_modular_package_integration_tests/0: daemon: no update found for fuchsia_modular_package_integration_tests/0/ [00021.255159][2122105589][0][amber] INFO: control_server: could not get update for dart_jit_runner/0: daemon: no update found for dart_jit_runner/0/ [00021.524174][32848][33169][klog] INFO: Observatory server failed to start after 1 tries [00021.728477][32848][33043][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fuchsia_modular_package_integration_tests#meta/fuchsia_modular_package_integration_tests.cmx is running from kernel [00021.839494][32848][33043][klog] INFO: 00:00 +0: calls the set onAccept function [00021.871969][32848][33043][klog] INFO: 00:00 +1: sets values on display [00021.878254][32848][33043][klog] INFO: 00:00 +2: addModuleAffinity [00021.882152][32848][33043][klog] INFO: 00:00 +3: addStoryAffinity [00021.884499][32848][33043][klog] INFO: 00:00 +4: calls the callback when proposal accepted [00021.887561][32848][33043][klog] INFO: 00:00 +5: factory should return same instance [00021.890130][32848][33043][klog] INFO: 00:00 +6: startupContext [00021.904517][32848][33043][klog] INFO: 00:00 +7: verify Lifecycle init during the construction of ModuleImpl [00021.912896][32848][33043][klog] INFO: 00:00 +8: verify exposeService arguments [00021.918148][32848][33043][klog] INFO: 00:00 +9: verify exposeServiceProvider arguments [00021.921186][32848][33043][klog] INFO: 00:00 +10: service bindings tests verify exposeService binds the correct service on connect request [00021.928265][32848][33043][klog] INFO: 00:00 +11: service bindings tests verify exposeService waits for all futures and binds the correct service on connect request [00021.934628][32848][33043][klog] INFO: 00:00 +12: service bindings tests verify exposeServiceProvider waits for all futures and binds the correct service on connect request [00021.938308][32848][33043][klog] INFO: 00:00 +13: service bindings tests verify exposeServiceProvider waits binds the correct service on connect request [00021.943167][32848][33043][klog] INFO: 00:00 +14: verify getTokenManager should call context.getTokenManager [00021.947361][32848][33043][klog] INFO: 00:00 +15: Agent Tasks: verify calling scheduleTask with null task throws [00021.950605][32848][33043][klog] INFO: 00:00 +16: Agent Tasks: verify calling scheduleTask without handler throws [00021.953862][32848][33043][klog] INFO: 00:00 +17: Agent Tasks: verify scheduleTask should call context.scheduleTask [00021.957081][32848][33043][klog] INFO: 00:00 +18: Agent Tasks: verify calling deleteTask with null task throws [00021.959323][32848][33043][klog] INFO: 00:00 +19: Agent Tasks: verify deleteTask should call context.deleteTask [00021.961586][32848][33043][klog] INFO: 00:00 +20: Agent Tasks: verify calling registerTaskHandler with null task throws [00021.964608][32848][33043][klog] INFO: 00:00 +21: Agent Tasks: verify calling registerTaskHandler twice should throw [00021.966826][32848][33043][klog] INFO: 00:00 +22: Agent Tasks: verify runTask invokes registered taskHandler [00021.970984][32848][33043][klog] INFO: 00:00 +23: Agent Tasks: verify out of band runTasks are queued up and run after task handler is registered [00021.976420][32848][33043][klog] INFO: [WARNING:null] Attempting to run a task [1] before a task handler was registered. Queuing up this task to be executed as soon a task handler is registered. [00021.977043][32848][33043][klog] INFO: [WARNING:null] Attempting to run a task [2] before a task handler was registered. Queuing up this task to be executed as soon a task handler is registered. [00021.977231][32848][33043][klog] INFO: [WARNING:null] Attempting to run a task [3] before a task handler was registered. Queuing up this task to be executed as soon a task handler is registered. [00021.980034][32848][33043][klog] INFO: 00:00 +24: module tests factory returns same instance [00021.982695][32848][33043][klog] INFO: 00:00 +25: no-op intent handler calling handle intent does nothing [00021.985244][32848][33043][klog] INFO: 00:00 +26: intent constructors intent sets the action [00021.988688][32848][33043][klog] INFO: 00:00 +27: intent constructors intent with handler sets the handler [00021.991229][32848][33043][klog] INFO: 00:00 +28: intent parameters addParameterFromEntityReference adds it to the list [00021.994786][32848][33043][klog] INFO: 00:00 +29: intent parameters getEntity throws for missing name [00021.997812][32848][33043][klog] INFO: 00:00 +30: intent parameters getEntity returns valid entity for link entity [00022.000842][32848][33043][klog] INFO: 00:00 +31: addModuleToStory should return ModuleController upon success [00022.009090][32848][33043][klog] INFO: 00:00 +32: addModuleToStory should throw ModuleResolutionException if no module found [00022.016953][32848][33043][klog] INFO: 00:00 +33: addModuleToStory should throw ModuleStateException for unknown errors [00022.020269][32848][33043][klog] INFO: 00:00 +34: embedModule should throw ModuleResolutionException if no module found [00022.024438][32848][33043][klog] INFO: 00:00 +35: embedModule should throw ModuleStateException for unknown errors [00022.026948][32848][33043][klog] INFO: 00:00 +36: embedModule should throw ArgumentError for invalid name [00022.029761][32848][33043][klog] INFO: 00:00 +37: intent handling throws when registerIntentHandler called twice [00022.031883][32848][33043][klog] INFO: 00:00 +38: intent handling throws when no intent handler registered [00022.034575][32848][33043][klog] INFO: 00:00 +39: intent handling module proxies intents to handler [00022.036879][32848][33043][klog] INFO: 00:00 +40: verify Lifecycle init during the construction of ModuleImpl [00022.038839][32848][33043][klog] INFO: 00:00 +41: embedModule throws for empty name [00022.040865][32848][33043][klog] INFO: 00:00 +42: embedModule throws for null intent [00022.043790][32848][33043][klog] INFO: 00:00 +43: addModuleToStory throws for empty name [00022.045431][32848][33043][klog] INFO: 00:00 +44: addModuleToStory throws for null intent [00022.047723][32848][33043][klog] INFO: 00:00 +45: verify requestFocus should call context.requestFocus [00022.050200][32848][33043][klog] INFO: 00:00 +46: verify removeSelfFromStory should call context.removeSelfFromStory [00022.052455][32848][33043][klog] INFO: 00:00 +47: intent handler impl handleIntent calls registered handler [00022.054491][32848][33043][klog] INFO: 00:00 +48: intent handler impl handleIntent passes along the correct action [00022.056832][32848][33043][klog] INFO: 00:00 +49: intent transformers convertFidlIntentToIntent clones correct fields [00022.058818][32848][33043][klog] INFO: 00:00 +50: intent transformers convertFidlIntentToIntent handles null fidl intent parametsrs [00022.060747][32848][33043][klog] INFO: 00:00 +51: intent transformers Intents with const parameter lists can still be modified [00022.062423][32848][33043][klog] INFO: 00:00 +52: ComponentContext: getComponentContext does not return null instance [00022.067656][3547][3694][klog] INFO: [WARNING:garnet/bin/appmgr/service_provider_dir_impl.cc(87)] Component fuchsia-pkg://fuchsia.com/fuchsia_modular_package_integration_tests#meta/fuchsia_modular_package_integration_tests.cmx is not allowed to connect to fuchs [00022.067688][3547][3694][klog] INFO: ia.modular.ComponentContext because this service is not present in the component's sandbox. [00022.067689][3547][3694][klog] INFO: Refer to https://fuchsia.googlesource.com/docs/+/master/the-book/sandboxing.md#services for more information. [00022.069309][32848][33043][klog] INFO: Proxy error: Peer unexpectedly closed [00022.070237][32848][33043][klog] INFO: 00:00 +53: ComponentContext: getComponentContext returns the same instance [00022.072352][32848][33043][klog] INFO: 00:00 +54: connectToAgentService:= throws for null or empty agent url [00022.075036][32848][33043][klog] INFO: 00:00 +55: connectToAgentService:= throws if serviceProxy is null [00022.076804][32848][33043][klog] INFO: 00:00 +56: factory should return same instance [00022.078747][32848][33043][klog] INFO: 00:00 +57: addTerminateListener throws for null listener [00022.080470][32848][33043][klog] INFO: 00:00 +58: addTerminateListener should return false when adding same handler [00022.082084][32848][33043][klog] INFO: 00:00 +59: addTerminateListener successful add [00022.083673][32848][33043][klog] INFO: 00:00 +60: failing terminate handler should error [00022.085526][32848][33043][klog] INFO: testing 1 [00022.090501][32848][33043][klog] INFO: terminateListener1 [00022.091791][32848][33043][klog] INFO: throwingTerminateListener [00022.094271][32848][33043][klog] INFO: 00:00 +61: terminate should trigger all added listeners to execute [00022.094844][32848][33043][klog] INFO: Skip: this test will cause other tests to not run after it is invoked since it calls exit() [00022.102624][32848][33043][klog] INFO: 00:00 +61 ~1: All tests passed! [00022.139664][4563][4581][klog] INFO: PASSED: /pkgfs/packages/fuchsia_modular_package_integration_tests/0/test/fuchsia_modular_package_integration_tests passed [00022.357272][4563][4581][klog] INFO: [00022.357303][4563][4581][klog] INFO: ------------------------------------------------ [00022.357306][4563][4581][klog] INFO: RUNNING TEST: /pkgfs/packages/fuchsia_services_package_integration_tests/0/test/fuchsia_services_package_integration_tests [00022.357306][4563][4581][klog] INFO: [00022.440252][2122105589][0][amber] INFO: control_server: could not get update for fuchsia_services_package_integration_tests/0: daemon: no update found for fuchsia_services_package_integration_tests/0/ [00022.470265][2122105589][0][amber] INFO: control_server: could not get update for dart_jit_runner/0: daemon: no update found for dart_jit_runner/0/ [00022.705143][34117][34444][klog] INFO: Observatory server failed to start after 1 tries [00022.785321][34117][34310][klog] INFO: [INFO:dart_component_controller.cc(109)] fuchsia-pkg://fuchsia.com/fuchsia_services_package_integration_tests#meta/fuchsia_services_package_integration_tests.cmx is running from kernel [00022.850234][34117][34310][klog] INFO: 00:00 +0: StartupContext fromStartupInfo does not return null instance [00022.890346][34117][34310][klog] INFO: 00:00 +1: StartupContext fromStartupInfo returns the same instance [00022.894058][34117][34310][klog] INFO: 00:00 +2: connectToEnvironmentService throws if serviceProxy is null [00022.898738][34117][34310][klog] INFO: 00:00 +3: service provider impl connect to service calls correct thunk [00022.910435][34117][34310][klog] INFO: 00:00 +4: All tests passed! [00022.951626][4563][4581][klog] INFO: PASSED: /pkgfs/packages/fuchsia_services_package_integration_tests/0/test/fuchsia_services_package_integration_tests passed [00023.003264][4563][4581][klog] INFO: [00023.003300][4563][4581][klog] INFO: ------------------------------------------------ [00023.003303][4563][4581][klog] INFO: RUNNING TEST: /pkgfs/packages/goodbye_dart_test/0/test/goodbye_dart_test [00023.003303][4563][4581][klog] INFO: [00023.080069][2122105589][0][amber] INFO: control_server: could not get update for goodbye_dart_test/0: daemon: no update found for goodbye_dart_test/0/ [00023.128589][2122105589][0][amber] INFO: control_server: could not get update for run/0: daemon: no update found for run/0/ [00023.156281][2122105589][0][amber] INFO: control_server: could not get update for goodbye_dart_aot/0: daemon: no update found for goodbye_dart_aot/0/ [00023.156602][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://goodbye_dart_aot was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/goodbye_dart_aot#meta/goodbye_dart_aot.cmx instead. See https://f [00023.156654][4907][4927][klog] INFO: uchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00023.196753][2122105589][0][amber] INFO: control_server: could not get update for dart_aot_runner/0: daemon: no update found for dart_aot_runner/0/ [00023.486677][35458][35652][klog] INFO: [INFO:dart_component_controller.cc(107)] fuchsia-pkg://fuchsia.com/goodbye_dart_aot is running from an app snapshot [00023.500291][35458][35652][klog] INFO: Hello, Dart! [00023.500359][35458][35652][klog] INFO: Goodbye now! [00023.522236][2122105589][0][amber] INFO: control_server: could not get update for run/0: daemon: no update found for run/0/ [00023.527268][35458][35812][klog] INFO: Observatory server failed to start after 1 tries [00023.550559][2122105589][0][amber] INFO: control_server: could not get update for goodbye_dart_aot/0: daemon: no update found for goodbye_dart_aot/0/ [00023.550866][4907][4927][klog] INFO: [WARNING:garnet/lib/loader/package_loader.cc(53)] Component file://goodbye_dart_aot was launched without using fuchsia-pkg URLs! Use fuchsia-pkg://fuchsia.com/goodbye_dart_aot#meta/goodbye_dart_aot.cmx instead. See https://f [00023.550924][4907][4927][klog] INFO: uchsia.googlesource.com/docs/+/master/glossary.md#fuchsia_pkg-url for more information. [00023.631000][35458][35989][klog] INFO: [INFO:dart_component_controller.cc(107)] fuchsia-pkg://fuchsia.com/goodbye_dart_aot is running from an app snapshot [00023.631867][35458][35989][klog] INFO: Hello, Dart! [00024.529403][35458][35812][klog] INFO: Observatory server failed to start after 2 tries [00024.633270][35458][35989][klog] INFO: Goodbye, Dart! [00024.661317][4563][4581][klog] INFO: PASSED: /pkgfs/packages/goodbye_dart_test/0/test/goodbye_dart_test passed [00024.708843][4563][4581][klog] INFO: [00024.708881][4563][4581][klog] INFO: ------------------------------------------------ [00024.708884][4563][4581][klog] INFO: RUNNING TEST: /pkgfs/packages/run_test_component_test/0/test/run_test_component_test [00024.708885][4563][4581][klog] INFO: [00024.786189][2122105589][0][amber] INFO: control_server: could not get update for run_test_component_test/0: daemon: no update found for run_test_component_test/0/ [00024.837510][4563][4581][klog] INFO: [==========] Running 1 test from 1 test case. [00024.837809][4563][4581][klog] INFO: [----------] Global test environment set-up. [00024.837836][4563][4581][klog] INFO: [----------] 1 test from Run [00024.837963][4563][4581][klog] INFO: [ RUN ] Run.TestHermeticEnv [00024.854403][4563][4581][klog] INFO: [ OK ] Run.TestHermeticEnv (16 ms) [00024.854434][4563][4581][klog] INFO: [----------] 1 test from Run (16 ms total) [00024.854434][4563][4581][klog] INFO: [00024.854435][4563][4581][klog] INFO: [----------] Global test environment tear-down [00024.854435][4563][4581][klog] INFO: [==========] 1 test from 1 test case ran. (16 ms total) [00024.854436][4563][4581][klog] INFO: [ PASSED ] 1 test. [00024.879226][4563][4581][klog] INFO: PASSED: /pkgfs/packages/run_test_component_test/0/test/run_test_component_test passed [00024.926639][4563][4581][klog] INFO: [00024.926684][4563][4581][klog] INFO: ------------------------------------------------ [00024.926687][4563][4581][klog] INFO: RUNNING TEST: /pkgfs/packages/run_test_component_unittests/0/test/run_test_component_unittests [00024.926687][4563][4581][klog] INFO: [00025.010178][2122105589][0][amber] INFO: control_server: could not get update for run_test_component_unittests/0: daemon: no update found for run_test_component_unittests/0/ [00025.081111][4563][4581][klog] INFO: [==========] Running 19 tests from 4 test cases. [00025.081152][4563][4581][klog] INFO: [----------] Global test environment set-up. [00025.081188][4563][4581][klog] INFO: [----------] 5 tests from EnvironmentConfigTest [00025.081189][4563][4581][klog] INFO: [ RUN ] EnvironmentConfigTest.InvalidJson [00025.101480][4563][4581][klog] INFO: [ OK ] EnvironmentConfigTest.InvalidJson (20 ms) [00025.101521][4563][4581][klog] INFO: [ RUN ] EnvironmentConfigTest.NoRootElement [00025.113200][4563][4581][klog] INFO: [ OK ] EnvironmentConfigTest.NoRootElement (12 ms) [00025.113248][4563][4581][klog] INFO: [ RUN ] EnvironmentConfigTest.NoSysElement [00025.122300][4563][4581][klog] INFO: [ OK ] EnvironmentConfigTest.NoSysElement (5 ms) [00025.122323][4563][4581][klog] INFO: [ RUN ] EnvironmentConfigTest.InvalidSection [00025.132486][4563][4581][klog] INFO: [ OK ] EnvironmentConfigTest.InvalidSection (14 ms) [00025.132544][4563][4581][klog] INFO: [ RUN ] EnvironmentConfigTest.ValidConfig [00025.137094][4563][4581][klog] INFO: [ OK ] EnvironmentConfigTest.ValidConfig (5 ms) [00025.137121][4563][4581][klog] INFO: [----------] 5 tests from EnvironmentConfigTest (56 ms total) [00025.137121][4563][4581][klog] INFO: [00025.137122][4563][4581][klog] INFO: [----------] 2 tests from Url [00025.137122][4563][4581][klog] INFO: [ RUN ] Url.ParseURL [00025.137722][4563][4581][klog] INFO: [ OK ] Url.ParseURL (1 ms) [00025.137747][4563][4581][klog] INFO: [ RUN ] Url.GenerateComponentUrl [00025.138272][4563][4581][klog] INFO: [ OK ] Url.GenerateComponentUrl (0 ms) [00025.138297][4563][4581][klog] INFO: [----------] 2 tests from Url (1 ms total) [00025.138298][4563][4581][klog] INFO: [00025.138298][4563][4581][klog] INFO: [----------] 1 test from RunTest [00025.138298][4563][4581][klog] INFO: [ RUN ] RunTest.ParseArgs [00025.180236][4563][4581][klog] INFO: [ OK ] RunTest.ParseArgs (15 ms) [00025.180280][4563][4581][klog] INFO: [----------] 1 test from RunTest (15 ms total) [00025.180280][4563][4581][klog] INFO: [00025.180281][4563][4581][klog] INFO: [----------] 11 tests from TestMetadataTest [00025.180281][4563][4581][klog] INFO: [ RUN ] TestMetadataTest.InvalidJson [00025.180285][4563][4581][klog] INFO: [ OK ] TestMetadataTest.InvalidJson (3 ms) [00025.180285][4563][4581][klog] INFO: [ RUN ] TestMetadataTest.NoFacet [00025.180285][4563][4581][klog] INFO: [ OK ] TestMetadataTest.NoFacet (4 ms) [00025.180286][4563][4581][klog] INFO: [ RUN ] TestMetadataTest.NoFuchsiaTestFacet [00025.180286][4563][4581][klog] INFO: [ OK ] TestMetadataTest.NoFuchsiaTestFacet (3 ms) [00025.180288][4563][4581][klog] INFO: [ RUN ] TestMetadataTest.NoServices [00025.180288][4563][4581][klog] INFO: [ OK ] TestMetadataTest.NoServices (3 ms) [00025.180288][4563][4581][klog] INFO: [ RUN ] TestMetadataTest.InvalidTestFacet [00025.180289][4563][4581][klog] INFO: [ OK ] TestMetadataTest.InvalidTestFacet (6 ms) [00025.180289][4563][4581][klog] INFO: [ RUN ] TestMetadataTest.InvalidServicesType [00025.180290][4563][4581][klog] INFO: [ OK ] TestMetadataTest.InvalidServicesType (3 ms) [00025.180291][4563][4581][klog] INFO: [ RUN ] TestMetadataTest.InvalidSystemServicesType [00025.186024][4563][4581][klog] INFO: [ OK ] TestMetadataTest.InvalidSystemServicesType (11 ms) [00025.186046][4563][4581][klog] INFO: [ RUN ] TestMetadataTest.InvalidServices [00025.195502][4563][4581][klog] INFO: [ OK ] TestMetadataTest.InvalidServices (9 ms) [00025.195555][4563][4581][klog] INFO: [ RUN ] TestMetadataTest.EmptyServices [00025.200004][4563][4581][klog] INFO: [ OK ] TestMetadataTest.EmptyServices (5 ms) [00025.200029][4563][4581][klog] INFO: [ RUN ] TestMetadataTest.ValidServices [00025.204631][4563][4581][klog] INFO: [ OK ] TestMetadataTest.ValidServices (4 ms) [00025.204677][4563][4581][klog] INFO: [ RUN ] TestMetadataTest.ValidSystemServices [00025.212810][4563][4581][klog] INFO: [ OK ] TestMetadataTest.ValidSystemServices (8 ms) [00025.212831][4563][4581][klog] INFO: [----------] 11 tests from TestMetadataTest (59 ms total) [00025.212832][4563][4581][klog] INFO: [00025.212832][4563][4581][klog] INFO: [----------] Global test environment tear-down [00025.212833][4563][4581][klog] INFO: [==========] 19 tests from 4 test cases ran. (131 ms total) [00025.212833][4563][4581][klog] INFO: [ PASSED ] 19 tests. [00025.215809][4563][4581][klog] INFO: PASSED: /pkgfs/packages/run_test_component_unittests/0/test/run_test_component_unittests passed [00025.340471][4563][4581][klog] INFO: [00025.340524][4563][4581][klog] INFO: ------------------------------------------------ [00025.340527][4563][4581][klog] INFO: RUNNING TEST: /pkgfs/packages/scenic_tests/0/test/geometry_util_unittests [00025.340527][4563][4581][klog] INFO: [00025.369742][4563][4581][klog] INFO: Running main() from gtest_main.cc [00025.369777][4563][4581][klog] INFO: [==========] Running 10 tests from 4 test cases. [00025.369778][4563][4581][klog] INFO: [----------] Global test environment set-up. [00025.369780][4563][4581][klog] INFO: [----------] 1 test from RectTest [00025.370172][4563][4581][klog] INFO: [ RUN ] RectTest.Comparisons [00025.370571][4563][4581][klog] INFO: [ OK ] RectTest.Comparisons (0 ms) [00025.370709][4563][4581][klog] INFO: [----------] 1 test from RectTest (0 ms total) [00025.370729][4563][4581][klog] INFO: [00025.370869][4563][4581][klog] INFO: [----------] 1 test from SizeTest [00025.370900][4563][4581][klog] INFO: [ RUN ] SizeTest.Comparisons [00025.370901][4563][4581][klog] INFO: [ OK ] SizeTest.Comparisons (0 ms) [00025.370901][4563][4581][klog] INFO: [----------] 1 test from SizeTest (0 ms total) [00025.370902][4563][4581][klog] INFO: [00025.379038][4563][4581][klog] INFO: [----------] 1 test from PointTest [00025.379064][4563][4581][klog] INFO: [ RUN ] PointTest.Comparisons [00025.379064][4563][4581][klog] INFO: [ OK ] PointTest.Comparisons (0 ms) [00025.379065][4563][4581][klog] INFO: [----------] 1 test from PointTest (0 ms total) [00025.379065][4563][4581][klog] INFO: [00025.379065][4563][4581][klog] INFO: [----------] 7 tests from TransformFunctionsTest [00025.379066][4563][4581][klog] INFO: [ RUN ] TransformFunctionsTest.SetIdentityTransform [00025.379066][4563][4581][klog] INFO: [ OK ] TransformFunctionsTest.SetIdentityTransform (0 ms) [00025.379067][4563][4581][klog] INFO: [ RUN ] TransformFunctionsTest.SetTranslationTransform [00025.379067][4563][4581][klog] INFO: [ OK ] TransformFunctionsTest.SetTranslationTransform (0 ms) [00025.379068][4563][4581][klog] INFO: [ RUN ] TransformFunctionsTest.Translate [00025.379068][4563][4581][klog] INFO: [ OK ] TransformFunctionsTest.Translate (0 ms) [00025.379068][4563][4581][klog] INFO: [ RUN ] TransformFunctionsTest.Scale [00025.379069][4563][4581][klog] INFO: [ OK ] TransformFunctionsTest.Scale (0 ms) [00025.379069][4563][4581][klog] INFO: [ RUN ] TransformFunctionsTest.CreateIdentityTransform [00025.379070][4563][4581][klog] INFO: [ OK ] TransformFunctionsTest.CreateIdentityTransform (0 ms) [00025.379070][4563][4581][klog] INFO: [ RUN ] TransformFunctionsTest.CreateTranslationTransform [00025.379071][4563][4581][klog] INFO: [ OK ] TransformFunctionsTest.CreateTranslationTransform (0 ms) [00025.379071][4563][4581][klog] INFO: [ RUN ] TransformFunctionsTest.CreateScaleTransform [00025.379075][4563][4581][klog] INFO: [ OK ] TransformFunctionsTest.CreateScaleTransform (0 ms) [00025.379076][4563][4581][klog] INFO: [----------] 7 tests from TransformFunctionsTest (0 ms total) [00025.379077][4563][4581][klog] INFO: [00025.379077][4563][4581][klog] INFO: [----------] Global test environment tear-down [00025.379078][4563][4581][klog] INFO: [==========] 10 tests from 4 test cases ran. (1 ms total) [00025.379078][4563][4581][klog] INFO: [ PASSED ] 10 tests. [00025.379783][4563][4581][klog] INFO: PASSED: /pkgfs/packages/scenic_tests/0/test/geometry_util_unittests passed [00025.532094][4563][4581][klog] INFO: [00025.532136][4563][4581][klog] INFO: ------------------------------------------------ [00025.532139][4563][4581][klog] INFO: RUNNING TEST: /pkgfs/packages/scenic_tests/0/test/gfx_apptests [00025.532140][4563][4581][klog] INFO: [00025.667488][4563][4581][klog] INFO: Running main() from gtest_main.cc [00025.667550][4563][4581][klog] INFO: [==========] Running 0 tests from 0 test cases. [00025.667575][4563][4581][klog] INFO: [==========] 0 tests from 0 test cases ran. (0 ms total) [00025.667575][4563][4581][klog] INFO: [ PASSED ] 0 tests. [00025.667576][4563][4581][klog] INFO: [00025.667576][4563][4581][klog] INFO: YOU HAVE 4 DISABLED TESTS [00025.667576][4563][4581][klog] INFO: [00025.693641][4563][4581][klog] INFO: PASSED: /pkgfs/packages/scenic_tests/0/test/gfx_apptests passed [00025.738307][4563][4581][klog] INFO: [00025.738343][4563][4581][klog] INFO: ------------------------------------------------ [00025.738345][4563][4581][klog] INFO: RUNNING TEST: /pkgfs/packages/scenic_tests/0/test/gfx_unittests [00025.738346][4563][4581][klog] INFO: [00025.881246][4563][4581][klog] INFO: [==========] Running 113 tests from 13 test cases. [00025.881279][4563][4581][klog] INFO: [----------] Global test environment set-up. [00025.881280][4563][4581][klog] INFO: [----------] 5 tests from HLATest [00025.881280][4563][4581][klog] INFO: [ RUN ] HLATest.HasHardwareLayerAssignment [00025.881281][4563][4581][klog] INFO: [00025.881281][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="441554374" [00025.881282][4563][4581][klog] INFO: [ OK ] HLATest.HasHardwareLayerAssignment (0 ms) [00025.881282][4563][4581][klog] INFO: [ RUN ] HLATest.HardwareLayerAssignmentMissingSwapchain [00025.881284][4563][4581][klog] INFO: [00025.881285][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2269578396" [00025.881285][4563][4581][klog] INFO: [WARNING:garnet/lib/ui/gfx/engine/hardware_layer_assignment.cc(16)] Invalid HardwareLayerAssignment: no swapchain. [00025.881286][4563][4581][klog] INFO: [ OK ] HLATest.HardwareLayerAssignmentMissingSwapchain (0 ms) [00025.881286][4563][4581][klog] INFO: [ RUN ] HLATest.HardwareLayerAssignmentMissingLayers [00025.881286][4563][4581][klog] INFO: [00025.881287][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1002554851" [00025.881290][4563][4581][klog] INFO: [WARNING:garnet/lib/ui/gfx/engine/hardware_layer_assignment.cc(26)] Invalid HardwareLayerAssignment: item with no layers. [00025.882487][4563][4581][klog] INFO: [ OK ] HLATest.HardwareLayerAssignmentMissingLayers (0 ms) [00025.882682][4563][4581][klog] INFO: [ RUN ] HLATest.HardwareLayerAssignmentMissingItems [00025.882682][4563][4581][klog] INFO: [00025.882683][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3465471366" [00025.882683][4563][4581][klog] INFO: [WARNING:garnet/lib/ui/gfx/engine/hardware_layer_assignment.cc(19)] Invalid HardwareLayerAssignment: no items. [00025.882686][4563][4581][klog] INFO: [ OK ] HLATest.HardwareLayerAssignmentMissingItems (0 ms) [00025.882687][4563][4581][klog] INFO: [ RUN ] HLATest.HardwareLayerAssignmentDuplicateLayerIDs [00025.882687][4563][4581][klog] INFO: [00025.882687][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3617019507" [00025.882688][4563][4581][klog] INFO: [WARNING:garnet/lib/ui/gfx/engine/hardware_layer_assignment.cc(32)] Invalid HardwareLayerAssignment: duplicate layer ID [00025.882688][4563][4581][klog] INFO: [ OK ] HLATest.HardwareLayerAssignmentDuplicateLayerIDs (0 ms) [00025.882688][4563][4581][klog] INFO: [----------] 5 tests from HLATest (0 ms total) [00025.882689][4563][4581][klog] INFO: [00025.882689][4563][4581][klog] INFO: [----------] 1 test from MultiSessionHitTestTest [00025.882689][4563][4581][klog] INFO: [ RUN ] MultiSessionHitTestTest.GlobalHits [00025.882690][4563][4581][klog] INFO: [00025.882690][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2472776140" [00025.883253][4563][4581][klog] INFO: [WARNING:garnet/lib/ui/scenic/event_reporter.cc(23)] EventReporter not set up, dropped event: ViewConnectedEvent(view_id=1008) [00025.883254][4563][4581][klog] INFO: [WARNING:garnet/lib/ui/scenic/event_reporter.cc(23)] EventReporter not set up, dropped event: ViewAttachedToSceneEvent(view_id=2001, properties=<TBD> [00025.883255][4563][4581][klog] INFO: [WARNING:garnet/lib/ui/scenic/event_reporter.cc(23)] EventReporter not set up, dropped event: ViewPropertiesChangedEvent(view_id=2001, properties=<TBD>) [00026.039947][4563][4581][klog] INFO: [WARNING:garnet/lib/ui/scenic/event_reporter.cc(23)] EventReporter not set up, dropped event: ViewConnectedEvent(view_id=1009) [00026.039970][4563][4581][klog] INFO: [WARNING:garnet/lib/ui/scenic/event_reporter.cc(23)] EventReporter not set up, dropped event: ViewAttachedToSceneEvent(view_id=3001, properties=<TBD> [00026.039971][4563][4581][klog] INFO: [WARNING:garnet/lib/ui/scenic/event_reporter.cc(23)] EventReporter not set up, dropped event: ViewPropertiesChangedEvent(view_id=3001, properties=<TBD>) [00026.039975][4563][4581][klog] INFO: [WARNING:garnet/lib/ui/scenic/event_reporter.cc(23)] EventReporter not set up, dropped event: ViewDisconnectedEvent(view_id=1009) [00026.039976][4563][4581][klog] INFO: [WARNING:garnet/lib/ui/scenic/event_reporter.cc(23)] EventReporter not set up, dropped event: ViewDisconnectedEvent(view_id=1008) [00026.039977][4563][4581][klog] INFO: [ OK ] MultiSessionHitTestTest.GlobalHits (3 ms) [00026.039977][4563][4581][klog] INFO: [----------] 1 test from MultiSessionHitTestTest (3 ms total) [00026.039977][4563][4581][klog] INFO: [00026.039978][4563][4581][klog] INFO: [----------] 17 tests from HitTestTest [00026.039979][4563][4581][klog] INFO: [ RUN ] HitTestTest.InvalidNodeId [00026.056553][4563][4581][klog] INFO: [00026.056601][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2521723435" [00026.056602][4563][4581][klog] INFO: [ OK ] HitTestTest.InvalidNodeId (4 ms) [00026.056602][4563][4581][klog] INFO: [ RUN ] HitTestTest.RayBelowScenePointingDown [00026.056603][4563][4581][klog] INFO: [00026.056603][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="191812913" [00026.056603][4563][4581][klog] INFO: [ OK ] HitTestTest.RayBelowScenePointingDown (151 ms) [00026.056604][4563][4581][klog] INFO: [ RUN ] HitTestTest.RayBelowScenePointingUp [00026.056604][4563][4581][klog] INFO: [00026.056604][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3621007893" [00026.056605][4563][4581][klog] INFO: [ OK ] HitTestTest.RayBelowScenePointingUp (1 ms) [00026.056605][4563][4581][klog] INFO: [ RUN ] HitTestTest.RayAboveScenePointingUp [00026.136041][4563][4581][klog] INFO: [00026.136099][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3096808852" [00026.136100][4563][4581][klog] INFO: [ OK ] HitTestTest.RayAboveScenePointingUp (0 ms) [00026.136123][4563][4581][klog] INFO: [ RUN ] HitTestTest.Hit10InTopLeftCornerFromNode1 [00026.136123][4563][4581][klog] INFO: [00026.136124][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="209298820" [00026.136124][4563][4581][klog] INFO: [ OK ] HitTestTest.Hit10InTopLeftCornerFromNode1 (8 ms) [00026.136125][4563][4581][klog] INFO: [ RUN ] HitTestTest.Hit10InTopLeftCornerFromNode2 [00026.136125][4563][4581][klog] INFO: [00026.136125][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2272193772" [00026.136131][4563][4581][klog] INFO: [ OK ] HitTestTest.Hit10InTopLeftCornerFromNode2 (9 ms) [00026.136132][4563][4581][klog] INFO: [ RUN ] HitTestTest.Hit10InTopLeftCornerFromNode3 [00026.136132][4563][4581][klog] INFO: [00026.136132][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3135807370" [00026.180903][4563][4581][klog] INFO: [ OK ] HitTestTest.Hit10InTopLeftCornerFromNode3 (124 ms) [00026.180927][4563][4581][klog] INFO: [ RUN ] HitTestTest.Hit10InTopLeftCornerFromNode4 [00026.180928][4563][4581][klog] INFO: [00026.180929][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3989062769" [00026.196201][4563][4581][klog] INFO: [ OK ] HitTestTest.Hit10InTopLeftCornerFromNode4 (15 ms) [00026.196238][4563][4581][klog] INFO: [ RUN ] HitTestTest.Hit20InMiddleFromNode1 [00026.196260][4563][4581][klog] INFO: [00026.196260][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3914416293" [00026.201307][4563][4581][klog] INFO: [ OK ] HitTestTest.Hit20InMiddleFromNode1 (1 ms) [00026.201349][4563][4581][klog] INFO: [ RUN ] HitTestTest.Hit20InMiddleFromNode2 [00026.201350][4563][4581][klog] INFO: [00026.201351][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3342901450" [00026.206998][4563][4581][klog] INFO: [ OK ] HitTestTest.Hit20InMiddleFromNode2 (5 ms) [00026.219891][4563][4581][klog] INFO: [ RUN ] HitTestTest.Hit20InMiddleFromNode3 [00026.219938][4563][4581][klog] INFO: [00026.219938][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1908922631" [00026.251982][4563][4581][klog] INFO: [ OK ] HitTestTest.Hit20InMiddleFromNode3 (49 ms) [00026.252461][4563][4581][klog] INFO: [ RUN ] HitTestTest.Hit20InMiddleFromNode5 [00026.252509][4563][4581][klog] INFO: [00026.252510][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2504505340" [00026.268663][4563][4581][klog] INFO: [ OK ] HitTestTest.Hit20InMiddleFromNode5 (16 ms) [00026.268683][4563][4581][klog] INFO: [ RUN ] HitTestTest.Hit20InMiddleFromNode6 [00026.268684][4563][4581][klog] INFO: [00026.268684][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3020735796" [00026.284513][4563][4581][klog] INFO: [ OK ] HitTestTest.Hit20InMiddleFromNode6 (16 ms) [00026.284627][4563][4581][klog] INFO: [ RUN ] HitTestTest.HitBoth10And20FromNode1 [00026.284628][4563][4581][klog] INFO: [00026.284628][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2840692564" [00026.284838][4563][4581][klog] INFO: [ OK ] HitTestTest.HitBoth10And20FromNode1 (1 ms) [00026.284862][4563][4581][klog] INFO: [ RUN ] HitTestTest.HitBoth20And30FromNode1 [00026.284866][4563][4581][klog] INFO: [00026.284866][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3082825679" [00026.290015][4563][4581][klog] INFO: [ OK ] HitTestTest.HitBoth20And30FromNode1 (5 ms) [00026.290047][4563][4581][klog] INFO: [ RUN ] HitTestTest.SuppressNode25FromNode1 [00026.290047][4563][4581][klog] INFO: [00026.290047][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="967168105" [00026.294827][4563][4581][klog] INFO: [ OK ] HitTestTest.SuppressNode25FromNode1 (5 ms) [00026.294879][4563][4581][klog] INFO: [ RUN ] HitTestTest.Clipping [00026.294880][4563][4581][klog] INFO: [00026.294880][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3473613795" [00026.296991][4563][4581][klog] INFO: [ OK ] HitTestTest.Clipping (2 ms) [00026.297039][4563][4581][klog] INFO: [----------] 17 tests from HitTestTest (413 ms total) [00026.297043][4563][4581][klog] INFO: [00026.297044][4563][4581][klog] INFO: [----------] 7 tests from ImagePipeTest [00026.297044][4563][4581][klog] INFO: [ RUN ] ImagePipeTest.ImagePipeImageIdMustNotBeZero [00026.297045][4563][4581][klog] INFO: [00026.297045][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="918629370" [00026.297376][4563][4581][klog] INFO: [WARNING:garnet/lib/ui/gfx/engine/engine.cc(138)] No FrameScheduler available; applying update immediately [00026.305774][4563][4581][klog] INFO: [ OK ] ImagePipeTest.ImagePipeImageIdMustNotBeZero (1 ms) [00026.305808][4563][4581][klog] INFO: [ RUN ] ImagePipeTest.PresentImagesOutOfOrder [00026.305808][4563][4581][klog] INFO: [00026.305809][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="4208588353" [00026.305810][4563][4581][klog] INFO: [WARNING:garnet/lib/ui/gfx/engine/engine.cc(138)] No FrameScheduler available; applying update immediately [00026.305810][4563][4581][klog] INFO: [INFO:image.cc(62)] Destroying Image with unowned VkImage (perhaps a swapchain image?) [00026.407368][4563][4581][klog] INFO: [ OK ] ImagePipeTest.PresentImagesOutOfOrder (109 ms) [00026.407404][4563][4581][klog] INFO: [ RUN ] ImagePipeTest.PresentImagesInOrder [00026.407408][4563][4581][klog] INFO: [00026.407408][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3205435426" [00026.407915][4563][4581][klog] INFO: [INFO:image.cc(62)] Destroying Image with unowned VkImage (perhaps a swapchain image?) [00026.429952][4563][4581][klog] INFO: [ OK ] ImagePipeTest.PresentImagesInOrder (1 ms) [00026.429975][4563][4581][klog] INFO: [ RUN ] ImagePipeTest.PresentImagesWithOffset [00026.429975][4563][4581][klog] INFO: [00026.429976][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3511041466" [00026.429976][4563][4581][klog] INFO: [INFO:image.cc(62)] Destroying Image with unowned VkImage (perhaps a swapchain image?) [00026.429977][4563][4581][klog] INFO: [ OK ] ImagePipeTest.PresentImagesWithOffset (5 ms) [00026.429978][4563][4581][klog] INFO: [ RUN ] ImagePipeTest.ImagePipePresentTwoFrames [00026.429978][4563][4581][klog] INFO: [00026.429978][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="565911876" [00026.429979][4563][4581][klog] INFO: [WARNING:garnet/lib/ui/gfx/engine/engine.cc(138)] No FrameScheduler available; applying update immediately [00026.429979][4563][4581][klog] INFO: [WARNING:garnet/lib/ui/gfx/engine/engine.cc(138)] No FrameScheduler available; applying update immediately [00026.429980][4563][4581][klog] INFO: [INFO:image.cc(62)] Destroying Image with unowned VkImage (perhaps a swapchain image?) [00026.429980][4563][4581][klog] INFO: [INFO:image.cc(62)] Destroying Image with unowned VkImage (perhaps a swapchain image?) [00026.429981][4563][4581][klog] INFO: [ OK ] ImagePipeTest.ImagePipePresentTwoFrames (5 ms) [00026.429981][4563][4581][klog] INFO: [ RUN ] ImagePipeTest.ImagePipeUpdateTwoFrames [00026.429981][4563][4581][klog] INFO: [00026.429982][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3363296902" [00026.429982][4563][4581][klog] INFO: [WARNING:garnet/lib/ui/gfx/engine/engine.cc(138)] No FrameScheduler available; applying update immediately [00026.429986][4563][4581][klog] INFO: [WARNING:garnet/lib/ui/gfx/engine/engine.cc(138)] No FrameScheduler available; applying update immediately [00026.429987][4563][4581][klog] INFO: [WARNING:garnet/lib/ui/gfx/engine/engine.cc(138)] No FrameScheduler available; applying update immediately [00026.429987][4563][4581][klog] INFO: [WARNING:garnet/lib/ui/gfx/engine/engine.cc(138)] No FrameScheduler available; applying update immediately [00026.429988][4563][4581][klog] INFO: [INFO:image.cc(62)] Destroying Image with unowned VkImage (perhaps a swapchain image?) [00026.429988][4563][4581][klog] INFO: [INFO:image.cc(62)] Destroying Image with unowned VkImage (perhaps a swapchain image?) [00026.429988][4563][4581][klog] INFO: [ OK ] ImagePipeTest.ImagePipeUpdateTwoFrames (2 ms) [00026.429989][4563][4581][klog] INFO: [ RUN ] ImagePipeTest.ImagePipeRemoveImageThatIsPendingPresent [00026.429989][4563][4581][klog] INFO: [00026.429989][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="815929871" [00026.429990][4563][4581][klog] INFO: [WARNING:garnet/lib/ui/gfx/engine/engine.cc(138)] No FrameScheduler available; applying update immediately [00026.429990][4563][4581][klog] INFO: [WARNING:garnet/lib/ui/gfx/engine/engine.cc(138)] No FrameScheduler available; applying update immediately [00026.429991][4563][4581][klog] INFO: [INFO:image.cc(62)] Destroying Image with unowned VkImage (perhaps a swapchain image?) [00026.431021][4563][4581][klog] INFO: [INFO:image.cc(62)] Destroying Image with unowned VkImage (perhaps a swapchain image?) [00026.431044][4563][4581][klog] INFO: [ OK ] ImagePipeTest.ImagePipeRemoveImageThatIsPendingPresent (3 ms) [00026.431045][4563][4581][klog] INFO: [----------] 7 tests from ImagePipeTest (126 ms total) [00026.431046][4563][4581][klog] INFO: [00026.431046][4563][4581][klog] INFO: [----------] 16 tests from ImportTest [00026.431046][4563][4581][klog] INFO: [ RUN ] ImportTest.ExportsResourceViaCmd [00026.431047][4563][4581][klog] INFO: [00026.431047][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="4144714123" [00026.431048][4563][4581][klog] INFO: [ OK ] ImportTest.ExportsResourceViaCmd (6 ms) [00026.431048][4563][4581][klog] INFO: [ RUN ] ImportTest.ImportsUnlinkedImportViaCmd [00026.431048][4563][4581][klog] INFO: [00026.431049][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="4011512055" [00026.431049][4563][4581][klog] INFO: [ OK ] ImportTest.ImportsUnlinkedImportViaCmd (0 ms) [00026.431050][4563][4581][klog] INFO: [ RUN ] ImportTest.PerformsFullLinking [00026.431050][4563][4581][klog] INFO: [00026.431050][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="334301043" [00026.431053][4563][4581][klog] INFO: [ OK ] ImportTest.PerformsFullLinking (0 ms) [00026.431053][4563][4581][klog] INFO: [ RUN ] ImportTest.HandlesDeadSourceHandle [00026.431054][4563][4581][klog] INFO: [00026.431054][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1274637026" [00026.643558][4563][4581][klog] INFO: [ OK ] ImportTest.HandlesDeadSourceHandle (213 ms) [00026.643599][4563][4581][klog] INFO: [ RUN ] ImportTest.HandlesDeadDestinationHandle [00026.643600][4563][4581][klog] INFO: [00026.643600][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1201243036" [00026.644094][4563][4581][klog] INFO: [ OK ] ImportTest.HandlesDeadDestinationHandle (1 ms) [00026.644119][4563][4581][klog] INFO: [ RUN ] ImportTest.DestroyingExportedResourceSendsEvent [00026.644119][4563][4581][klog] INFO: [00026.644120][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1496865145" [00026.649585][4563][4581][klog] INFO: [ OK ] ImportTest.DestroyingExportedResourceSendsEvent (5 ms) [00026.654844][4563][4581][klog] INFO: [ RUN ] ImportTest.ImportingNodeAfterDestroyingExportedResourceSendsEvent [00026.654884][4563][4581][klog] INFO: [00026.654885][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="932436344" [00026.686589][4563][4581][klog] INFO: [ OK ] ImportTest.ImportingNodeAfterDestroyingExportedResourceSendsEvent (31 ms) [00026.686620][4563][4581][klog] INFO: [ RUN ] ImportTest.KillingImportedResourceEvictsFromResourceLinker [00026.686623][4563][4581][klog] INFO: [00026.686624][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2341666995" [00026.705159][4563][4581][klog] INFO: [ OK ] ImportTest.KillingImportedResourceEvictsFromResourceLinker (2 ms) [00026.705207][4563][4581][klog] INFO: [ RUN ] ImportTest.ResourceUnexportedAfterImportsAndImportHandlesDie1 [00026.705208][4563][4581][klog] INFO: [00026.705208][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1669335221" [00026.705209][4563][4581][klog] INFO: [ OK ] ImportTest.ResourceUnexportedAfterImportsAndImportHandlesDie1 (6 ms) [00026.705209][4563][4581][klog] INFO: [ RUN ] ImportTest.ResourceUnexportedAfterImportsAndImportHandlesDie2 [00026.705209][4563][4581][klog] INFO: [00026.705210][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3621839217" [00026.705210][4563][4581][klog] INFO: [ OK ] ImportTest.ResourceUnexportedAfterImportsAndImportHandlesDie2 (5 ms) [00026.705211][4563][4581][klog] INFO: [ RUN ] ImportTest.ResourceUnexportedAfterImportsAndImportHandlesDie3 [00026.705211][4563][4581][klog] INFO: [00026.705211][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3242588047" [00026.705212][4563][4581][klog] INFO: [ OK ] ImportTest.ResourceUnexportedAfterImportsAndImportHandlesDie3 (2 ms) [00026.705212][4563][4581][klog] INFO: [ RUN ] ImportTest.ResourceUnexportedAfterImportsAndImportHandlesDie4 [00026.705213][4563][4581][klog] INFO: [00026.705213][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1699373263" [00026.711335][4563][4581][klog] INFO: [ OK ] ImportTest.ResourceUnexportedAfterImportsAndImportHandlesDie4 (5 ms) [00026.711359][4563][4581][klog] INFO: [ RUN ] ImportTest.ProxiesCanBeFoundByTheirContainerOrTheirUnderlyingEntityType [00026.711387][4563][4581][klog] INFO: [00026.711387][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2722974550" [00026.711388][4563][4581][klog] INFO: [ OK ] ImportTest.ProxiesCanBeFoundByTheirContainerOrTheirUnderlyingEntityType (0 ms) [00026.711389][4563][4581][klog] INFO: [ RUN ] ImportTest.UnlinkedImportedResourceCanAcceptCommands [00026.711389][4563][4581][klog] INFO: [00026.711389][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1526737188" [00026.717434][4563][4581][klog] INFO: [ OK ] ImportTest.UnlinkedImportedResourceCanAcceptCommands (6 ms) [00026.717484][4563][4581][klog] INFO: [ RUN ] ImportTest.LinkedResourceShouldBeAbleToAcceptCommands [00026.717513][4563][4581][klog] INFO: [00026.717514][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="4239363589" [00026.718014][4563][4581][klog] INFO: [ OK ] ImportTest.LinkedResourceShouldBeAbleToAcceptCommands (6 ms) [00026.718045][4563][4581][klog] INFO: [ RUN ] ImportTest.EmbedderCanEmbedNodesFromElsewhere [00026.718046][4563][4581][klog] INFO: [00026.718047][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2903226545" [00026.721833][4563][4581][klog] INFO: [ OK ] ImportTest.EmbedderCanEmbedNodesFromElsewhere (4 ms) [00026.721863][4563][4581][klog] INFO: [----------] 16 tests from ImportTest (299 ms total) [00026.721863][4563][4581][klog] INFO: [00026.721864][4563][4581][klog] INFO: [----------] 1 test from MemoryTest [00026.721864][4563][4581][klog] INFO: [ RUN ] MemoryTest.MemoryAllocationSizeValidation [00026.721867][4563][4581][klog] INFO: [00026.721867][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="4260410106" [00026.724649][4563][4581][klog] INFO: [ OK ] MemoryTest.MemoryAllocationSizeValidation (1 ms) [00026.724674][4563][4581][klog] INFO: [----------] 1 test from MemoryTest (1 ms total) [00026.724675][4563][4581][klog] INFO: [00026.724749][4563][4581][klog] INFO: [----------] 4 tests from NodeTest [00026.724750][4563][4581][klog] INFO: [ RUN ] NodeTest.Tagging [00026.724750][4563][4581][klog] INFO: [00026.724750][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3883608173" [00026.724754][4563][4581][klog] INFO: [ OK ] NodeTest.Tagging (1 ms) [00026.724754][4563][4581][klog] INFO: [ RUN ] NodeTest.ShapeNodeMaterialAndShape [00026.724754][4563][4581][klog] INFO: [00026.724755][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3259255328" [00026.725432][4563][4581][klog] INFO: [ OK ] NodeTest.ShapeNodeMaterialAndShape (1 ms) [00026.725542][4563][4581][klog] INFO: [ RUN ] NodeTest.NodesWithChildren [00026.725632][4563][4581][klog] INFO: [00026.725722][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1238433825" [00026.730723][4563][4581][klog] INFO: [ OK ] NodeTest.NodesWithChildren (5 ms) [00026.730754][4563][4581][klog] INFO: [ RUN ] NodeTest.SettingHitTestBehavior [00026.730755][4563][4581][klog] INFO: [00026.730756][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3147905042" [00026.736652][4563][4581][klog] INFO: [ OK ] NodeTest.SettingHitTestBehavior (1 ms) [00026.736673][4563][4581][klog] INFO: [----------] 4 tests from NodeTest (8 ms total) [00026.736829][4563][4581][klog] INFO: [00026.736829][4563][4581][klog] INFO: [----------] 21 tests from ObjectLinkerTest [00026.736830][4563][4581][klog] INFO: [ RUN ] ObjectLinkerTest.InitialState [00026.736830][4563][4581][klog] INFO: [00026.736831][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1532416013" [00026.736831][4563][4581][klog] INFO: [ OK ] ObjectLinkerTest.InitialState (0 ms) [00026.736832][4563][4581][klog] INFO: [ RUN ] ObjectLinkerTest.AllowsExport [00026.736832][4563][4581][klog] INFO: [00026.736832][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2026013364" [00026.736833][4563][4581][klog] INFO: [ OK ] ObjectLinkerTest.AllowsExport (0 ms) [00026.736833][4563][4581][klog] INFO: [ RUN ] ObjectLinkerTest.CannotExportInvalidToken [00026.736834][4563][4581][klog] INFO: [00026.736834][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="830989115" [00026.736840][4563][4581][klog] INFO: [ OK ] ObjectLinkerTest.CannotExportInvalidToken (0 ms) [00026.736840][4563][4581][klog] INFO: [ RUN ] ObjectLinkerTest.CannotExportWithDeadExportToken [00026.736841][4563][4581][klog] INFO: [00026.736841][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="4004678450" [00026.736842][4563][4581][klog] INFO: [ OK ] ObjectLinkerTest.CannotExportWithDeadExportToken (0 ms) [00026.736842][4563][4581][klog] INFO: [ RUN ] ObjectLinkerTest.CanExportWithDeadImportToken [00026.736843][4563][4581][klog] INFO: [00026.736843][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3757136068" [00026.736843][4563][4581][klog] INFO: [ OK ] ObjectLinkerTest.CanExportWithDeadImportToken (0 ms) [00026.736844][4563][4581][klog] INFO: [ RUN ] ObjectLinkerTest.CannotExportSameTokenTwice [00026.736844][4563][4581][klog] INFO: [00026.736845][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3644868013" [00026.736849][4563][4581][klog] INFO: [ OK ] ObjectLinkerTest.CannotExportSameTokenTwice (0 ms) [00026.736849][4563][4581][klog] INFO: [ RUN ] ObjectLinkerTest.LinkDeathRemovesExport [00026.736850][4563][4581][klog] INFO: [00026.736850][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="901245891" [00026.736851][4563][4581][klog] INFO: [ OK ] ObjectLinkerTest.LinkDeathRemovesExport (0 ms) [00026.736851][4563][4581][klog] INFO: [ RUN ] ObjectLinkerTest.AllowsImport [00026.736851][4563][4581][klog] INFO: [00026.736852][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3635207514" [00026.736852][4563][4581][klog] INFO: [ OK ] ObjectLinkerTest.AllowsImport (0 ms) [00026.736852][4563][4581][klog] INFO: [ RUN ] ObjectLinkerTest.CannotImportInvalidToken [00026.736853][4563][4581][klog] INFO: [00026.736853][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1035744966" [00026.736853][4563][4581][klog] INFO: [ OK ] ObjectLinkerTest.CannotImportInvalidToken (0 ms) [00026.736854][4563][4581][klog] INFO: [ RUN ] ObjectLinkerTest.CannotImportWithDeadImportToken [00026.736854][4563][4581][klog] INFO: [00026.736854][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1021193648" [00026.736855][4563][4581][klog] INFO: [ OK ] ObjectLinkerTest.CannotImportWithDeadImportToken (0 ms) [00026.736856][4563][4581][klog] INFO: [ RUN ] ObjectLinkerTest.CanImportWithDeadExportToken [00026.736856][4563][4581][klog] INFO: [00026.736857][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2699610926" [00026.736857][4563][4581][klog] INFO: [ OK ] ObjectLinkerTest.CanImportWithDeadExportToken (0 ms) [00026.736858][4563][4581][klog] INFO: [ RUN ] ObjectLinkerTest.CannotImportSameTokenTwice [00026.736858][4563][4581][klog] INFO: [00026.736858][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="4126672383" [00026.736859][4563][4581][klog] INFO: [ OK ] ObjectLinkerTest.CannotImportSameTokenTwice (0 ms) [00026.736859][4563][4581][klog] INFO: [ RUN ] ObjectLinkerTest.LinkDeathRemovesImport [00026.736859][4563][4581][klog] INFO: [00026.736860][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2351724605" [00026.737163][4563][4581][klog] INFO: [ OK ] ObjectLinkerTest.LinkDeathRemovesImport (0 ms) [00026.737164][4563][4581][klog] INFO: [ RUN ] ObjectLinkerTest.InitializingLinkTwiceCausesDeath [00026.737164][4563][4581][klog] INFO: [00026.737164][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2636831390" [00026.737165][4563][4581][klog] INFO: [00026.737165][4563][4581][klog] INFO: [WARNING] ../../garnet/lib/ui/gfx/tests/object_linker_unittest.cc:264:: Death tests are not supported on this platform. [00026.737168][4563][4581][klog] INFO: Statement 'export_link.Initialize(&export_obj2, std::bind( []() { switch (0) case 0: default: if (const ::testing::AssertionResult gtest_ar_ = ::testing::AssertionResult(false)) ; else ::testing::internal::AssertHelper(::tes [00026.737169][4563][4581][klog] INFO: ting::TestPartResult::kNonFatalFailure, "../../garnet/lib/ui/gfx/tests/object_linker_unittest.cc", 262, ::testing::internal::GetBoolAssertionFailureMessage( gtest_ar_, "false", "false", "true").c_str()) = ::testing::Message( [00026.737169][4563][4581][klog] INFO: ) << "Delegate called unexpectedly: " << "export.link_resolved"; }), std::bind( []() { switch (0) case 0: default: if (const ::testing::AssertionResult gtest_ar_ = ::testing::AssertionResult(false)) ; else ::testing::interna [00026.737170][4563][4581][klog] INFO: l::AssertHelper(::testing::TestPartResult::kNonFatalFailure, "../../garnet/lib/ui/gfx/tests/object_linker_unittest.cc", 263, ::testing::internal::GetBoolAssertionFailureMessage( gtest_ar_, "false", "false", "true").c_str()) [00026.737171][4563][4581][klog] INFO: = ::testing::Message() << "Delegate called unexpectedly: " << "export.link_disconnected"; }))' cannot be verified. [00026.737171][4563][4581][klog] INFO: [ OK ] ObjectLinkerTest.InitializingLinkTwiceCausesDeath (1 ms) [00026.737172][4563][4581][klog] INFO: [ RUN ] ObjectLinkerTest.InitializeLinksMatchingPeers [00026.737172][4563][4581][klog] INFO: [00026.737172][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1982793585" [00026.737173][4563][4581][klog] INFO: [ OK ] ObjectLinkerTest.InitializeLinksMatchingPeers (0 ms) [00026.737173][4563][4581][klog] INFO: [ RUN ] ObjectLinkerTest.InitializeLinksMatchingPeersWithImportBeforeExport [00026.737173][4563][4581][klog] INFO: [00026.737174][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2766455443" [00026.737174][4563][4581][klog] INFO: [ OK ] ObjectLinkerTest.InitializeLinksMatchingPeersWithImportBeforeExport (0 ms) [00026.737174][4563][4581][klog] INFO: [ RUN ] ObjectLinkerTest.InitializeDoesNotLinkNonMatchingPeers [00026.737175][4563][4581][klog] INFO: [00026.737175][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1378356974" [00026.737175][4563][4581][klog] INFO: [ OK ] ObjectLinkerTest.InitializeDoesNotLinkNonMatchingPeers (0 ms) [00026.737176][4563][4581][klog] INFO: [ RUN ] ObjectLinkerTest.EarlyImportTokenDeathCausesExportDisconnection [00026.737182][4563][4581][klog] INFO: [00026.737183][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3243688185" [00026.737432][4563][4581][klog] INFO: [ OK ] ObjectLinkerTest.EarlyImportTokenDeathCausesExportDisconnection (0 ms) [00026.737432][4563][4581][klog] INFO: [ RUN ] ObjectLinkerTest.ImportTokenDeathCausesExportDisconnection [00026.737433][4563][4581][klog] INFO: [00026.737433][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3370850756" [00026.737434][4563][4581][klog] INFO: [ OK ] ObjectLinkerTest.ImportTokenDeathCausesExportDisconnection (0 ms) [00026.737434][4563][4581][klog] INFO: [ RUN ] ObjectLinkerTest.EarlyExportTokenDeathCausesImportDisconnection [00026.737435][4563][4581][klog] INFO: [00026.737435][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1253559090" [00026.737436][4563][4581][klog] INFO: [ OK ] ObjectLinkerTest.EarlyExportTokenDeathCausesImportDisconnection (0 ms) [00026.737436][4563][4581][klog] INFO: [ RUN ] ObjectLinkerTest.ExportTokenDeathCausesImportDisconnection [00026.737437][4563][4581][klog] INFO: [00026.737437][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3747181638" [00026.737438][4563][4581][klog] INFO: [ OK ] ObjectLinkerTest.ExportTokenDeathCausesImportDisconnection (0 ms) [00026.737438][4563][4581][klog] INFO: [----------] 21 tests from ObjectLinkerTest (1 ms total) [00026.737438][4563][4581][klog] INFO: [00026.737439][4563][4581][klog] INFO: [----------] 15 tests from ResourceLinkerTest [00026.737439][4563][4581][klog] INFO: [ RUN ] ResourceLinkerTest.AllowsExport [00026.737439][4563][4581][klog] INFO: [00026.737440][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1257821741" [00026.737440][4563][4581][klog] INFO: [ OK ] ResourceLinkerTest.AllowsExport (5 ms) [00026.737440][4563][4581][klog] INFO: [ RUN ] ResourceLinkerTest.AllowsImport [00026.737441][4563][4581][klog] INFO: [00026.737441][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="346654657" [00026.742829][4563][4581][klog] INFO: [ OK ] ResourceLinkerTest.AllowsImport (2 ms) [00026.742852][4563][4581][klog] INFO: [ RUN ] ResourceLinkerTest.CannotImportWithDeadSourceAndDestinationHandles [00026.742852][4563][4581][klog] INFO: [00026.742852][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1451006739" [00026.742853][4563][4581][klog] INFO: [ OK ] ResourceLinkerTest.CannotImportWithDeadSourceAndDestinationHandles (1 ms) [00026.742853][4563][4581][klog] INFO: [ RUN ] ResourceLinkerTest.CannotImportWithDeadDestinationHandles [00026.742854][4563][4581][klog] INFO: [00026.742854][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2796878478" [00026.744145][4563][4581][klog] INFO: [ OK ] ResourceLinkerTest.CannotImportWithDeadDestinationHandles (3 ms) [00026.744176][4563][4581][klog] INFO: [ RUN ] ResourceLinkerTest.CanImportWithDeadSourceHandle [00026.744490][4563][4581][klog] INFO: [00026.744522][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="533807579" [00027.332370][4563][4581][klog] INFO: [ OK ] ResourceLinkerTest.CanImportWithDeadSourceHandle (588 ms) [00027.332425][4563][4581][klog] INFO: [ RUN ] ResourceLinkerTest.CannotExportWithDeadSourceAndDestinationHandles [00027.332426][4563][4581][klog] INFO: [00027.332427][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1785717519" [00027.333246][4563][4581][klog] INFO: [ OK ] ResourceLinkerTest.CannotExportWithDeadSourceAndDestinationHandles (1 ms) [00027.333268][4563][4581][klog] INFO: [ RUN ] ResourceLinkerTest.CannotExportWithDeadSourceHandle [00027.333270][4563][4581][klog] INFO: [00027.333270][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="367597437" [00027.374178][4563][4581][klog] INFO: [ OK ] ResourceLinkerTest.CannotExportWithDeadSourceHandle (6 ms) [00027.374206][4563][4581][klog] INFO: [ RUN ] ResourceLinkerTest.CanExportWithDeadDestinationHandle [00027.374233][4563][4581][klog] INFO: [00027.374234][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3469942716" [00027.374790][4563][4581][klog] INFO: [ OK ] ResourceLinkerTest.CanExportWithDeadDestinationHandle (36 ms) [00027.374811][4563][4581][klog] INFO: [ RUN ] ResourceLinkerTest.DestinationHandleDeathAutomaticallyCleansUpResourceExport [00027.374812][4563][4581][klog] INFO: [00027.374812][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2948466639" [00027.375253][4563][4581][klog] INFO: [ OK ] ResourceLinkerTest.DestinationHandleDeathAutomaticallyCleansUpResourceExport (0 ms) [00027.375275][4563][4581][klog] INFO: [ RUN ] ResourceLinkerTest.SourceHandleDeathAutomaticallyCleansUpUnresolvedImports [00027.375591][4563][4581][klog] INFO: [00027.375638][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3533873595" [00027.426618][4563][4581][klog] INFO: [ OK ] ResourceLinkerTest.SourceHandleDeathAutomaticallyCleansUpUnresolvedImports (51 ms) [00027.426699][4563][4581][klog] INFO: [ RUN ] ResourceLinkerTest.ResourceDeathAutomaticallyCleansUpResourceExport [00027.426701][4563][4581][klog] INFO: [00027.426702][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1311311017" [00027.427551][4563][4581][klog] INFO: [ OK ] ResourceLinkerTest.ResourceDeathAutomaticallyCleansUpResourceExport (1 ms) [00027.427579][4563][4581][klog] INFO: [ RUN ] ResourceLinkerTest.ImportsBeforeExportsAreServiced [00027.427580][4563][4581][klog] INFO: [00027.427783][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2471367367" [00027.460953][4563][4581][klog] INFO: [ OK ] ResourceLinkerTest.ImportsBeforeExportsAreServiced (34 ms) [00027.460991][4563][4581][klog] INFO: [ RUN ] ResourceLinkerTest.ImportAfterReleasedExportedResourceFails [00027.460991][4563][4581][klog] INFO: [00027.460992][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1343853080" [00027.467711][4563][4581][klog] INFO: [ OK ] ResourceLinkerTest.ImportAfterReleasedExportedResourceFails (0 ms) [00027.467742][4563][4581][klog] INFO: [ RUN ] ResourceLinkerTest.DuplicatedDestinationHandlesAllowMultipleImports [00027.467742][4563][4581][klog] INFO: [00027.467743][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="766189402" [00027.494353][4563][4581][klog] INFO: [ OK ] ResourceLinkerTest.DuplicatedDestinationHandlesAllowMultipleImports (33 ms) [00027.494403][4563][4581][klog] INFO: [ RUN ] ResourceLinkerTest.UnresolvedImportIsRemovedIfDestroyed [00027.494404][4563][4581][klog] INFO: [00027.494405][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="4158381848" [00027.494999][4563][4581][klog] INFO: [ OK ] ResourceLinkerTest.UnresolvedImportIsRemovedIfDestroyed (1 ms) [00027.495027][4563][4581][klog] INFO: [----------] 15 tests from ResourceLinkerTest (763 ms total) [00027.495027][4563][4581][klog] INFO: [00027.495028][4563][4581][klog] INFO: [----------] 6 tests from SessionTest [00027.495028][4563][4581][klog] INFO: [ RUN ] SessionTest.ScheduleUpdateOutOfOrder [00027.495029][4563][4581][klog] INFO: [00027.495029][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="449295214" [00027.536310][4563][4581][klog] INFO: [ OK ] SessionTest.ScheduleUpdateOutOfOrder (41 ms) [00027.536352][4563][4581][klog] INFO: [ RUN ] SessionTest.ScheduleUpdateInOrder [00027.536352][4563][4581][klog] INFO: [00027.536353][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1893674010" [00027.537907][4563][4581][klog] INFO: [ OK ] SessionTest.ScheduleUpdateInOrder (1 ms) [00027.555901][4563][4581][klog] INFO: [ RUN ] SessionTest.ResourceIdAlreadyUsed [00027.555965][4563][4581][klog] INFO: [00027.555966][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2388673345" [00027.566321][4563][4581][klog] INFO: [ OK ] SessionTest.ResourceIdAlreadyUsed (10 ms) [00027.566351][4563][4581][klog] INFO: [ RUN ] SessionTest.AddAndRemoveResource [00027.566352][4563][4581][klog] INFO: [00027.566352][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1570786548" [00027.571051][4563][4581][klog] INFO: [ OK ] SessionTest.AddAndRemoveResource (1 ms) [00027.571170][4563][4581][klog] INFO: [ RUN ] SessionTest.Labeling [00027.571171][4563][4581][klog] INFO: [00027.571171][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2831557478" [00027.593860][4563][4581][klog] INFO: [ OK ] SessionTest.Labeling (5 ms) [00027.593891][4563][4581][klog] INFO: [ RUN ] SessionTest.SendingSizeChangeEventWorks [00027.593891][4563][4581][klog] INFO: [00027.593892][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1097228302" [00027.593896][4563][4581][klog] INFO: [ OK ] SessionTest.SendingSizeChangeEventWorks (4 ms) [00027.593897][4563][4581][klog] INFO: [----------] 6 tests from SessionTest (81 ms total) [00027.593897][4563][4581][klog] INFO: [00027.593898][4563][4581][klog] INFO: [----------] 2 tests from ShapeTest [00027.593898][4563][4581][klog] INFO: [ RUN ] ShapeTest.Circle [00027.593899][4563][4581][klog] INFO: [00027.593899][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="593156585" [00027.593900][4563][4581][klog] INFO: [ OK ] ShapeTest.Circle (2 ms) [00027.593900][4563][4581][klog] INFO: [ RUN ] ShapeTest.Rectangle [00027.593901][4563][4581][klog] INFO: [00027.593901][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1193586175" [00027.593902][4563][4581][klog] INFO: [ OK ] ShapeTest.Rectangle (3 ms) [00027.593902][4563][4581][klog] INFO: [----------] 2 tests from ShapeTest (5 ms total) [00027.593903][4563][4581][klog] INFO: [00027.593903][4563][4581][klog] INFO: [----------] 1 test from StereoCameraTest [00027.593904][4563][4581][klog] INFO: [ RUN ] StereoCameraTest.Basic [00027.593904][4563][4581][klog] INFO: [00027.593904][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="4059030686" [00027.593905][4563][4581][klog] INFO: [ OK ] StereoCameraTest.Basic (5 ms) [00027.593906][4563][4581][klog] INFO: [----------] 1 test from StereoCameraTest (5 ms total) [00027.593906][4563][4581][klog] INFO: [00027.593907][4563][4581][klog] INFO: [----------] 17 tests from ViewTest [00027.593908][4563][4581][klog] INFO: [ RUN ] ViewTest.CreateViewWithBadTokenDies [00027.593909][4563][4581][klog] INFO: [00027.593909][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="333397833" [00027.593910][4563][4581][klog] INFO: [00027.593911][4563][4581][klog] INFO: [WARNING] ../../garnet/lib/ui/gfx/tests/view_unittest.cc:25:: Death tests are not supported on this platform. [00027.593911][4563][4581][klog] INFO: Statement 'Apply(scenic::NewCreateViewCmd(1, zx::eventpair(), ""))' cannot be verified. [00027.593913][4563][4581][klog] INFO: [00027.701418][4563][4581][klog] INFO: [WARNING] ../../garnet/lib/ui/gfx/tests/view_unittest.cc:27:: Death tests are not supported on this platform. [00027.701457][4563][4581][klog] INFO: Statement 'Apply(scenic::NewCreateViewHolderCmd(2, zx::eventpair(), ""))' cannot be verified. [00027.701458][4563][4581][klog] INFO: [ OK ] ViewTest.CreateViewWithBadTokenDies (2 ms) [00027.701483][4563][4581][klog] INFO: [ RUN ] ViewTest.Children [00027.701515][4563][4581][klog] INFO: [00027.701516][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1270653367" [00027.701516][4563][4581][klog] INFO: [ OK ] ViewTest.Children (2 ms) [00027.701517][4563][4581][klog] INFO: [ RUN ] ViewTest.ExportsViewHolderViaCmd [00027.701518][4563][4581][klog] INFO: [00027.701518][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2804595078" [00027.701519][4563][4581][klog] INFO: [ OK ] ViewTest.ExportsViewHolderViaCmd (4 ms) [00027.701519][4563][4581][klog] INFO: [ RUN ] ViewTest.ImportsViewViaCmd [00027.701519][4563][4581][klog] INFO: [00027.701520][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1886719170" [00027.701524][4563][4581][klog] INFO: [ OK ] ViewTest.ImportsViewViaCmd (0 ms) [00027.701525][4563][4581][klog] INFO: [ RUN ] ViewTest.PairedViewAndHolderAreLinked [00027.701525][4563][4581][klog] INFO: [00027.701525][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="658029901" [00027.701526][4563][4581][klog] INFO: [ OK ] ViewTest.PairedViewAndHolderAreLinked (2 ms) [00027.701526][4563][4581][klog] INFO: [ RUN ] ViewTest.ExportViewHolderWithDeadHandleFails [00027.701526][4563][4581][klog] INFO: [00027.701527][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3502636484" [00027.709625][4563][4581][klog] INFO: [ OK ] ViewTest.ExportViewHolderWithDeadHandleFails (106 ms) [00027.709651][4563][4581][klog] INFO: [ RUN ] ViewTest.ViewHolderDestroyedBeforeView [00027.709697][4563][4581][klog] INFO: [00027.709698][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3494929430" [00027.710980][4563][4581][klog] INFO: [ OK ] ViewTest.ViewHolderDestroyedBeforeView (9 ms) [00027.711007][4563][4581][klog] INFO: [ RUN ] ViewTest.ViewDestroyedBeforeViewHolder [00027.711096][4563][4581][klog] INFO: [00027.711096][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3451862363" [00027.811350][4563][4581][klog] INFO: [ OK ] ViewTest.ViewDestroyedBeforeViewHolder (100 ms) [00027.811373][4563][4581][klog] INFO: [ RUN ] ViewTest.ViewHolderConnectsToScene [00027.811374][4563][4581][klog] INFO: [00027.811374][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1269253777" [00027.825939][4563][4581][klog] INFO: [ OK ] ViewTest.ViewHolderConnectsToScene (14 ms) [00027.825975][4563][4581][klog] INFO: [ RUN ] ViewTest.ViewHolderGrandchildGetsSceneRefreshed [00027.825975][4563][4581][klog] INFO: [00027.825976][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="4035567443" [00027.827046][4563][4581][klog] INFO: [ OK ] ViewTest.ViewHolderGrandchildGetsSceneRefreshed (2 ms) [00027.827072][4563][4581][klog] INFO: [ RUN ] ViewTest.ViewLinksAfterViewHolderConnectsToScene [00027.827187][4563][4581][klog] INFO: [00027.853986][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="4098829507" [00027.854013][4563][4581][klog] INFO: [ OK ] ViewTest.ViewLinksAfterViewHolderConnectsToScene (25 ms) [00027.864102][4563][4581][klog] INFO: [ RUN ] ViewTest.ViewStateChangeNotifiesViewHolder [00027.864127][4563][4581][klog] INFO: [00027.864128][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3472551952" [00027.864141][4563][4581][klog] INFO: [ OK ] ViewTest.ViewStateChangeNotifiesViewHolder (2 ms) [00027.864142][4563][4581][klog] INFO: [ RUN ] ViewTest.RenderStateAcrossManyFrames [00027.864142][4563][4581][klog] INFO: [00027.864142][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3724089262" [00027.864650][4563][4581][klog] INFO: [ OK ] ViewTest.RenderStateAcrossManyFrames (10 ms) [00027.864681][4563][4581][klog] INFO: [ RUN ] ViewTest.RenderStateFalseWhenViewDisconnects [00027.864745][4563][4581][klog] INFO: [00027.864775][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="4007743377" [00027.904844][4563][4581][klog] INFO: [ OK ] ViewTest.RenderStateFalseWhenViewDisconnects (40 ms) [00027.911667][4563][4581][klog] INFO: [ RUN ] ViewTest.ViewHolderRenderWaitClearedWhenViewDestroyed [00027.912331][4563][4581][klog] INFO: [00027.912575][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1796024359" [00027.925536][4563][4581][klog] INFO: [ OK ] ViewTest.ViewHolderRenderWaitClearedWhenViewDestroyed (21 ms) [00027.925627][4563][4581][klog] INFO: [ RUN ] ViewTest.RenderSignalDoesntCrashWhenViewHolderDestroyed [00027.925649][4563][4581][klog] INFO: [00027.925649][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2803774646" [00027.947303][4563][4581][klog] INFO: [ OK ] ViewTest.RenderSignalDoesntCrashWhenViewHolderDestroyed (22 ms) [00027.947350][4563][4581][klog] INFO: [ RUN ] ViewTest.RenderStateFalseWhenViewHolderDisconnectsFromScene [00027.947351][4563][4581][klog] INFO: [00027.947351][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2386218883" [00027.965221][4563][4581][klog] INFO: [ OK ] ViewTest.RenderStateFalseWhenViewHolderDisconnectsFromScene (1 ms) [00027.965292][4563][4581][klog] INFO: [----------] 17 tests from ViewTest (362 ms total) [00027.965292][4563][4581][klog] INFO: [00027.965292][4563][4581][klog] INFO: [----------] Global test environment tear-down [00027.965296][4563][4581][klog] INFO: [==========] 113 tests from 13 test cases ran. (2067 ms total) [00027.965297][4563][4581][klog] INFO: [ PASSED ] 113 tests. [00027.965297][4563][4581][klog] INFO: [00027.965297][4563][4581][klog] INFO: YOU HAVE 2 DISABLED TESTS [00027.965298][4563][4581][klog] INFO: [00027.965783][4563][4581][klog] INFO: PASSED: /pkgfs/packages/scenic_tests/0/test/gfx_unittests passed [00028.038587][4563][4581][klog] INFO: [00028.038619][4563][4581][klog] INFO: ------------------------------------------------ [00028.038622][4563][4581][klog] INFO: RUNNING TEST: /pkgfs/packages/scenic_tests/0/test/input_apptests [00028.038623][4563][4581][klog] INFO: [00028.100135][4563][4581][klog] INFO: Running main() from gtest_main.cc [00028.100169][4563][4581][klog] INFO: [==========] Running 6 tests from 3 test cases. [00028.100169][4563][4581][klog] INFO: [----------] Global test environment set-up. [00028.100170][4563][4581][klog] INFO: [----------] 2 tests from InputInterfaceTest [00028.100172][4563][4581][klog] INFO: [ RUN ] InputInterfaceTest.RegisterKeyboardTest [00028.100329][4563][4581][klog] INFO: [00028.100345][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2151888514" [00028.100533][4563][4581][klog] INFO: [ OK ] InputInterfaceTest.RegisterKeyboardTest (0 ms) [00028.100565][4563][4581][klog] INFO: [ RUN ] InputInterfaceTest.InputKeyboardTest [00028.100566][4563][4581][klog] INFO: [00028.100566][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1422837340" [00028.100743][4563][4581][klog] INFO: [ OK ] InputInterfaceTest.InputKeyboardTest (0 ms) [00028.100772][4563][4581][klog] INFO: [----------] 2 tests from InputInterfaceTest (1 ms total) [00028.100773][4563][4581][klog] INFO: [00028.100773][4563][4581][klog] INFO: [----------] 2 tests from ReaderInterpreterTest [00028.100774][4563][4581][klog] INFO: [ RUN ] ReaderInterpreterTest.RegisterKeyboardTest [00028.100775][4563][4581][klog] INFO: [00028.100775][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2337005982" [00028.101193][4563][4581][klog] INFO: [ OK ] ReaderInterpreterTest.RegisterKeyboardTest (0 ms) [00028.101227][4563][4581][klog] INFO: [ RUN ] ReaderInterpreterTest.RemoveKeyboardTest [00028.101227][4563][4581][klog] INFO: [00028.101250][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2921872777" [00028.101282][4563][4581][klog] INFO: [ERROR:garnet/bin/ui/input_reader/input_interpreter.cc(490)] Failed to read from input: -1 for MockHidDecoder [00028.186317][4563][4581][klog] INFO: [ OK ] ReaderInterpreterTest.RemoveKeyboardTest (0 ms) [00028.186344][4563][4581][klog] INFO: [----------] 2 tests from ReaderInterpreterTest (0 ms total) [00028.186344][4563][4581][klog] INFO: [00028.186345][4563][4581][klog] INFO: [----------] 2 tests from ReaderInterpreterInputTest [00028.186345][4563][4581][klog] INFO: [ RUN ] ReaderInterpreterInputTest.KeyboardTest [00028.186350][4563][4581][klog] INFO: [00028.186351][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="283815232" [00028.187031][4563][4581][klog] INFO: [ OK ] ReaderInterpreterInputTest.KeyboardTest (85 ms) [00028.187063][4563][4581][klog] INFO: [ RUN ] ReaderInterpreterInputTest.LightSensorTest [00028.187156][4563][4581][klog] INFO: [00028.187205][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3254411984" [00028.187380][4563][4581][klog] INFO: [ OK ] ReaderInterpreterInputTest.LightSensorTest (0 ms) [00028.187407][4563][4581][klog] INFO: [----------] 2 tests from ReaderInterpreterInputTest (86 ms total) [00028.187407][4563][4581][klog] INFO: [00028.187408][4563][4581][klog] INFO: [----------] Global test environment tear-down [00028.187408][4563][4581][klog] INFO: [==========] 6 tests from 3 test cases ran. (87 ms total) [00028.187409][4563][4581][klog] INFO: [ PASSED ] 6 tests. [00028.191742][4563][4581][klog] INFO: PASSED: /pkgfs/packages/scenic_tests/0/test/input_apptests passed [00028.304365][4563][4581][klog] INFO: [00028.304406][4563][4581][klog] INFO: ------------------------------------------------ [00028.304410][4563][4581][klog] INFO: RUNNING TEST: /pkgfs/packages/scenic_tests/0/test/input_tool_unittests [00028.304410][4563][4581][klog] INFO: [00028.352973][4563][4581][klog] INFO: Running main() from gtest_main.cc [00028.353021][4563][4581][klog] INFO: [==========] Running 5 tests from 1 test case. [00028.353022][4563][4581][klog] INFO: [----------] Global test environment set-up. [00028.353023][4563][4581][klog] INFO: [----------] 5 tests from InverseKeymapTest [00028.353023][4563][4581][klog] INFO: [ RUN ] InverseKeymapTest.PlainKey [00028.353269][4563][4581][klog] INFO: [ OK ] InverseKeymapTest.PlainKey (0 ms) [00028.353305][4563][4581][klog] INFO: [ RUN ] InverseKeymapTest.ShiftKey [00028.354140][4563][4581][klog] INFO: [ OK ] InverseKeymapTest.ShiftKey (0 ms) [00028.354169][4563][4581][klog] INFO: [ RUN ] InverseKeymapTest.Lowercase [00028.354170][4563][4581][klog] INFO: [ OK ] InverseKeymapTest.Lowercase (1 ms) [00028.354170][4563][4581][klog] INFO: [ RUN ] InverseKeymapTest.Sentence [00028.395316][4563][4581][klog] INFO: [ OK ] InverseKeymapTest.Sentence (41 ms) [00028.395362][4563][4581][klog] INFO: [ RUN ] InverseKeymapTest.HoldShift [00028.395503][4563][4581][klog] INFO: [ OK ] InverseKeymapTest.HoldShift (0 ms) [00028.395538][4563][4581][klog] INFO: [----------] 5 tests from InverseKeymapTest (42 ms total) [00028.395538][4563][4581][klog] INFO: [00028.395538][4563][4581][klog] INFO: [----------] Global test environment tear-down [00028.395539][4563][4581][klog] INFO: [==========] 5 tests from 1 test case ran. (42 ms total) [00028.395855][4563][4581][klog] INFO: [ PASSED ] 5 tests. [00028.427369][4563][4581][klog] INFO: PASSED: /pkgfs/packages/scenic_tests/0/test/input_tool_unittests passed [00028.476751][4563][4581][klog] INFO: [00028.476785][4563][4581][klog] INFO: ------------------------------------------------ [00028.476788][4563][4581][klog] INFO: RUNNING TEST: /pkgfs/packages/scenic_tests/0/test/input_unittests [00028.476788][4563][4581][klog] INFO: [00028.608043][4563][4581][klog] INFO: [==========] Running 7 tests from 5 test cases. [00028.608105][4563][4581][klog] INFO: [----------] Global test environment set-up. [00028.608184][4563][4581][klog] INFO: [----------] 1 test from CoordinateTransformTest [00028.608215][4563][4581][klog] INFO: [ RUN ] CoordinateTransformTest.CoordinateTransform [00028.608215][4563][4581][klog] INFO: [00028.608215][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="64305252" [00028.608592][4563][4581][klog] INFO: [INFO:gfx_system.cc(176)] No Vulkan found, but using a test-only "display". [00028.608926][4563][4581][klog] INFO: [INFO:input_system.cc(236)] Scenic input system initialized. [00028.609373][4563][4581][klog] INFO: [ERROR:garnet/lib/ui/input/input_system.cc(233)] Scenic lost connection to TextSync [00028.625500][4563][4581][klog] INFO: [ OK ] CoordinateTransformTest.CoordinateTransform (6 ms) [00028.625537][4563][4581][klog] INFO: [----------] 1 test from CoordinateTransformTest (6 ms total) [00028.625537][4563][4581][klog] INFO: [00028.625538][4563][4581][klog] INFO: [----------] 2 tests from FocusAvoidanceTest [00028.625538][4563][4581][klog] INFO: [ RUN ] FocusAvoidanceTest.ViewHierarchyByViewManager [00028.625539][4563][4581][klog] INFO: [00028.625539][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="4084549641" [00028.625540][4563][4581][klog] INFO: [INFO:gfx_system.cc(176)] No Vulkan found, but using a test-only "display". [00028.625540][4563][4581][klog] INFO: [INFO:input_system.cc(236)] Scenic input system initialized. [00028.625541][4563][4581][klog] INFO: [ERROR:garnet/lib/ui/input/input_system.cc(233)] Scenic lost connection to TextSync [00028.695008][4563][4581][klog] INFO: [ OK ] FocusAvoidanceTest.ViewHierarchyByViewManager (12 ms) [00028.695030][4563][4581][klog] INFO: [ RUN ] FocusAvoidanceTest.ViewHierarchyByScenic [00028.695030][4563][4581][klog] INFO: [00028.695031][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1472762264" [00028.695034][4563][4581][klog] INFO: [INFO:gfx_system.cc(176)] No Vulkan found, but using a test-only "display". [00028.695035][4563][4581][klog] INFO: [INFO:input_system.cc(236)] Scenic input system initialized. [00028.695035][4563][4581][klog] INFO: [ERROR:garnet/lib/ui/input/input_system.cc(233)] Scenic lost connection to TextSync [00028.695036][4563][4581][klog] INFO: [ OK ] FocusAvoidanceTest.ViewHierarchyByScenic (68 ms) [00028.695036][4563][4581][klog] INFO: [----------] 2 tests from FocusAvoidanceTest (80 ms total) [00028.695037][4563][4581][klog] INFO: [00028.695037][4563][4581][klog] INFO: [----------] 1 test from HardKeyboardDeliveryTest [00028.695038][4563][4581][klog] INFO: [ RUN ] HardKeyboardDeliveryTest.Test [00028.695038][4563][4581][klog] INFO: [00028.695038][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2531421379" [00028.695039][4563][4581][klog] INFO: [INFO:gfx_system.cc(176)] No Vulkan found, but using a test-only "display". [00028.695039][4563][4581][klog] INFO: [INFO:input_system.cc(236)] Scenic input system initialized. [00028.695478][4563][4581][klog] INFO: [ERROR:garnet/lib/ui/input/input_system.cc(233)] Scenic lost connection to TextSync [00028.773764][4563][4581][klog] INFO: [ OK ] HardKeyboardDeliveryTest.Test (3 ms) [00028.773796][4563][4581][klog] INFO: [----------] 1 test from HardKeyboardDeliveryTest (3 ms total) [00028.773819][4563][4581][klog] INFO: [00028.773821][4563][4581][klog] INFO: [----------] 1 test from ImportNodeTest [00028.773822][4563][4581][klog] INFO: [ RUN ] ImportNodeTest.ImportNodeEventDelivery [00028.773846][4563][4581][klog] INFO: [00028.773846][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1339886309" [00028.773847][4563][4581][klog] INFO: [INFO:gfx_system.cc(176)] No Vulkan found, but using a test-only "display". [00028.773847][4563][4581][klog] INFO: [INFO:input_system.cc(236)] Scenic input system initialized. [00028.773870][4563][4581][klog] INFO: [ERROR:garnet/lib/ui/input/input_system.cc(233)] Scenic lost connection to TextSync [00028.773872][4563][4581][klog] INFO: [ OK ] ImportNodeTest.ImportNodeEventDelivery (7 ms) [00028.773983][4563][4581][klog] INFO: [----------] 1 test from ImportNodeTest (7 ms total) [00028.774010][4563][4581][klog] INFO: [00028.774012][4563][4581][klog] INFO: [----------] 2 tests from MouseDeliveryTest [00028.774013][4563][4581][klog] INFO: [ RUN ] MouseDeliveryTest.StandardTest [00028.774013][4563][4581][klog] INFO: [00028.774014][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3424724620" [00028.774014][4563][4581][klog] INFO: [INFO:gfx_system.cc(176)] No Vulkan found, but using a test-only "display". [00028.774015][4563][4581][klog] INFO: [INFO:input_system.cc(236)] Scenic input system initialized. [00028.774016][4563][4581][klog] INFO: [ERROR:garnet/lib/ui/input/input_system.cc(233)] Scenic lost connection to TextSync [00028.774016][4563][4581][klog] INFO: [ OK ] MouseDeliveryTest.StandardTest (6 ms) [00028.774016][4563][4581][klog] INFO: [ RUN ] MouseDeliveryTest.NoFocusTest [00028.774017][4563][4581][klog] INFO: [00028.774025][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3999002199" [00028.774049][4563][4581][klog] INFO: [INFO:gfx_system.cc(176)] No Vulkan found, but using a test-only "display". [00028.774049][4563][4581][klog] INFO: [INFO:input_system.cc(236)] Scenic input system initialized. [00028.774050][4563][4581][klog] INFO: [ERROR:garnet/lib/ui/input/input_system.cc(233)] Scenic lost connection to TextSync [00028.774050][4563][4581][klog] INFO: [ OK ] MouseDeliveryTest.NoFocusTest (10 ms) [00028.774051][4563][4581][klog] INFO: [----------] 2 tests from MouseDeliveryTest (16 ms total) [00028.774051][4563][4581][klog] INFO: [00028.774052][4563][4581][klog] INFO: [----------] Global test environment tear-down [00028.774052][4563][4581][klog] INFO: [==========] 7 tests from 5 test cases ran. (112 ms total) [00028.774053][4563][4581][klog] INFO: [ PASSED ] 7 tests. [00028.946441][4563][4581][klog] INFO: PASSED: /pkgfs/packages/scenic_tests/0/test/input_unittests passed [00034.755651][4563][4581][klog] INFO: [00034.755678][4563][4581][klog] INFO: ------------------------------------------------ [00034.755733][4563][4581][klog] INFO: RUNNING TEST: /pkgfs/packages/scenic_tests/0/test/presentation_mode_unittests [00034.755760][4563][4581][klog] INFO: [00034.809914][4563][4581][klog] INFO: Running main() from gtest_main.cc [00034.809953][4563][4581][klog] INFO: [==========] Running 7 tests from 3 test cases. [00034.809954][4563][4581][klog] INFO: [----------] Global test environment set-up. [00034.809955][4563][4581][klog] INFO: [----------] 1 test from PositiveData [00034.809958][4563][4581][klog] INFO: [ RUN ] PositiveData.MovingAverage [00034.810149][4563][4581][klog] INFO: [ OK ] PositiveData.MovingAverage (0 ms) [00034.810276][4563][4581][klog] INFO: [----------] 1 test from PositiveData (0 ms total) [00034.810276][4563][4581][klog] INFO: [00034.810277][4563][4581][klog] INFO: [----------] 1 test from NegativeData [00034.810277][4563][4581][klog] INFO: [ RUN ] NegativeData.MovingAverage [00034.810278][4563][4581][klog] INFO: [ OK ] NegativeData.MovingAverage (0 ms) [00034.810278][4563][4581][klog] INFO: [----------] 1 test from NegativeData (0 ms total) [00034.810279][4563][4581][klog] INFO: [00034.810279][4563][4581][klog] INFO: [----------] 5 tests from Detector [00034.810279][4563][4581][klog] INFO: [ RUN ] Detector.Closed [00034.810280][4563][4581][klog] INFO: [ OK ] Detector.Closed (0 ms) [00034.810280][4563][4581][klog] INFO: [ RUN ] Detector.Laptop [00034.810280][4563][4581][klog] INFO: [ OK ] Detector.Laptop (0 ms) [00034.810281][4563][4581][klog] INFO: [ RUN ] Detector.Tablet [00034.810281][4563][4581][klog] INFO: [ OK ] Detector.Tablet (0 ms) [00034.810281][4563][4581][klog] INFO: [ RUN ] Detector.Tent [00034.810282][4563][4581][klog] INFO: [ OK ] Detector.Tent (0 ms) [00034.810282][4563][4581][klog] INFO: [ RUN ] Detector.NonAccelerometer [00034.888207][4563][4581][klog] INFO: [ OK ] Detector.NonAccelerometer (0 ms) [00034.888257][4563][4581][klog] INFO: [----------] 5 tests from Detector (0 ms total) [00034.888484][4563][4581][klog] INFO: [00034.888513][4563][4581][klog] INFO: [----------] Global test environment tear-down [00034.888522][4563][4581][klog] INFO: [==========] 7 tests from 3 test cases ran. (0 ms total) [00034.888523][4563][4581][klog] INFO: [ PASSED ] 7 tests. [00034.888959][4563][4581][klog] INFO: PASSED: /pkgfs/packages/scenic_tests/0/test/presentation_mode_unittests passed [00034.961812][4563][4581][klog] INFO: [00034.961843][4563][4581][klog] INFO: ------------------------------------------------ [00034.961847][4563][4581][klog] INFO: RUNNING TEST: /pkgfs/packages/scenic_tests/0/test/scenic_unittests [00034.961847][4563][4581][klog] INFO: [00035.022521][4563][4581][klog] INFO: Running main() from gtest_main.cc [00035.022567][4563][4581][klog] INFO: [==========] Running 1 test from 1 test case. [00035.022568][4563][4581][klog] INFO: [----------] Global test environment set-up. [00035.022569][4563][4581][klog] INFO: [----------] 1 test from ScenicTest [00035.022570][4563][4581][klog] INFO: [ RUN ] ScenicTest.SessionCreatedAfterAllSystemsInitialized [00035.022738][4563][4581][klog] INFO: [00035.022923][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2128174527" [00035.023311][4563][4581][klog] INFO: [ OK ] ScenicTest.SessionCreatedAfterAllSystemsInitialized (1 ms) [00035.023367][4563][4581][klog] INFO: [----------] 1 test from ScenicTest (1 ms total) [00035.023489][4563][4581][klog] INFO: [00035.023489][4563][4581][klog] INFO: [----------] Global test environment tear-down [00035.023490][4563][4581][klog] INFO: [==========] 1 test from 1 test case ran. (1 ms total) [00035.023490][4563][4581][klog] INFO: [ PASSED ] 1 test. [00035.027374][4563][4581][klog] INFO: PASSED: /pkgfs/packages/scenic_tests/0/test/scenic_unittests passed [00035.115935][4563][4581][klog] INFO: [00035.115974][4563][4581][klog] INFO: ------------------------------------------------ [00035.115977][4563][4581][klog] INFO: RUNNING TEST: /pkgfs/packages/scenic_tests/0/test/view_manager_apptests [00035.115977][4563][4581][klog] INFO: [00035.239683][4563][4581][klog] INFO: Running main() from gtest_main.cc [00035.240545][4563][4581][klog] INFO: [==========] Running 0 tests from 0 test cases. [00035.240589][4563][4581][klog] INFO: [==========] 0 tests from 0 test cases ran. (0 ms total) [00035.240590][4563][4581][klog] INFO: [ PASSED ] 0 tests. [00035.257131][4563][4581][klog] INFO: PASSED: /pkgfs/packages/scenic_tests/0/test/view_manager_apptests passed [00035.304688][4563][4581][klog] INFO: [00035.304737][4563][4581][klog] INFO: ------------------------------------------------ [00035.304741][4563][4581][klog] INFO: RUNNING TEST: /pkgfs/packages/web_runner_tests/0/test/web_runner_unittests [00035.304742][4563][4581][klog] INFO: [00035.358956][4563][4581][klog] INFO: Running main() from gtest_main.cc [00035.358991][4563][4581][klog] INFO: [==========] Running 2 tests from 1 test case. [00035.358992][4563][4581][klog] INFO: [----------] Global test environment set-up. [00035.358992][4563][4581][klog] INFO: [----------] 2 tests from RunnerTest [00035.358993][4563][4581][klog] INFO: [ RUN ] RunnerTest.Trivial [00035.370538][4563][4581][klog] INFO: [00035.370577][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="872307780" [00035.370579][4563][4581][klog] INFO: [ OK ] RunnerTest.Trivial (1 ms) [00035.370579][4563][4581][klog] INFO: [ RUN ] RunnerTest.CreatesWebView [00035.370621][4563][4581][klog] INFO: [00035.370622][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2860787669" [00035.370623][4563][4581][klog] INFO: [ OK ] RunnerTest.CreatesWebView (1 ms) [00035.370624][4563][4581][klog] INFO: [----------] 2 tests from RunnerTest (2 ms total) [00035.370624][4563][4581][klog] INFO: [00035.370625][4563][4581][klog] INFO: [----------] Global test environment tear-down [00035.370682][4563][4581][klog] INFO: [==========] 2 tests from 1 test case ran. (2 ms total) [00035.370682][4563][4581][klog] INFO: [ PASSED ] 2 tests. [00035.417527][4563][4581][klog] INFO: PASSED: /pkgfs/packages/web_runner_tests/0/test/web_runner_unittests passed [00035.437032][4563][4581][klog] INFO: [00035.437057][4563][4581][klog] INFO: ------------------------------------------------ [00035.437059][4563][4581][klog] INFO: RUNNING TEST: /system/test/auth_provider_unittests [00035.437059][4563][4581][klog] INFO: [00035.489289][4563][4581][klog] INFO: Running main() from gtest_main.cc [00035.489515][4563][4581][klog] INFO: [==========] Running 27 tests from 6 test cases. [00035.489657][4563][4581][klog] INFO: [----------] Global test environment set-up. [00035.489658][4563][4581][klog] INFO: [----------] 1 test from GoogleFactoryImplTest [00035.489659][4563][4581][klog] INFO: [ RUN ] GoogleFactoryImplTest.GetAuthProvider [00035.489661][4563][4581][klog] INFO: [00035.489662][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="753371639" [00035.490424][4563][4581][klog] INFO: [ OK ] GoogleFactoryImplTest.GetAuthProvider (1 ms) [00035.490451][4563][4581][klog] INFO: [----------] 1 test from GoogleFactoryImplTest (1 ms total) [00035.490458][4563][4581][klog] INFO: [00035.490459][4563][4581][klog] INFO: [----------] 12 tests from GoogleAuthProviderImplTest [00035.490460][4563][4581][klog] INFO: [ RUN ] GoogleAuthProviderImplTest.EmptyWhenClientDisconnected [00035.490540][4563][4581][klog] INFO: [00035.490540][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3521285952" [00035.490749][4563][4581][klog] INFO: [ OK ] GoogleAuthProviderImplTest.EmptyWhenClientDisconnected (0 ms) [00035.490772][4563][4581][klog] INFO: [ RUN ] GoogleAuthProviderImplTest.GetAppAccessTokenSuccess [00035.490772][4563][4581][klog] INFO: [00035.490773][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3324868550" [00035.562831][4563][4581][klog] INFO: [ OK ] GoogleAuthProviderImplTest.GetAppAccessTokenSuccess (2 ms) [00035.562859][4563][4581][klog] INFO: [ RUN ] GoogleAuthProviderImplTest.GetAppAccessTokenBadRequestError [00035.562859][4563][4581][klog] INFO: [00035.562860][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3824219791" [00035.562860][4563][4581][klog] INFO: [ OK ] GoogleAuthProviderImplTest.GetAppAccessTokenBadRequestError (0 ms) [00035.562861][4563][4581][klog] INFO: [ RUN ] GoogleAuthProviderImplTest.GetAppAccessTokenInvalidClientError [00035.562866][4563][4581][klog] INFO: [00035.562866][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3318549946" [00035.562867][4563][4581][klog] INFO: [WARNING:topaz/auth_providers/google/google_auth_provider_impl.cc(196)] Got error: OAuth backend returned error: 401 [00035.562867][4563][4581][klog] INFO: [WARNING:topaz/auth_providers/google/google_auth_provider_impl.cc(197)] Got response: { [00035.562868][4563][4581][klog] INFO: "error": "invalid_client" [00035.562868][4563][4581][klog] INFO: } [00035.562869][4563][4581][klog] INFO: [ OK ] GoogleAuthProviderImplTest.GetAppAccessTokenInvalidClientError (3 ms) [00035.562869][4563][4581][klog] INFO: [ RUN ] GoogleAuthProviderImplTest.GetAppAccessTokenInvalidUserError [00035.562869][4563][4581][klog] INFO: [00035.562870][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2134725266" [00035.562870][4563][4581][klog] INFO: [WARNING:topaz/auth_providers/google/google_auth_provider_impl.cc(196)] Got error: OAuth backend returned error: 401 [00035.562871][4563][4581][klog] INFO: [WARNING:topaz/auth_providers/google/google_auth_provider_impl.cc(197)] Got response: { [00035.562871][4563][4581][klog] INFO: "error": "invalid_credential" [00035.562872][4563][4581][klog] INFO: } [00035.562872][4563][4581][klog] INFO: [ OK ] GoogleAuthProviderImplTest.GetAppAccessTokenInvalidUserError (3 ms) [00035.562873][4563][4581][klog] INFO: [ RUN ] GoogleAuthProviderImplTest.GetAppIdTokenSuccess [00035.562873][4563][4581][klog] INFO: [00035.562873][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3568630507" [00035.562874][4563][4581][klog] INFO: [ OK ] GoogleAuthProviderImplTest.GetAppIdTokenSuccess (2 ms) [00035.562875][4563][4581][klog] INFO: [ RUN ] GoogleAuthProviderImplTest.GetAppIdTokenBadRequestError [00035.562875][4563][4581][klog] INFO: [00035.563345][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3022883742" [00035.563397][4563][4581][klog] INFO: [ OK ] GoogleAuthProviderImplTest.GetAppIdTokenBadRequestError (0 ms) [00035.563398][4563][4581][klog] INFO: [ RUN ] GoogleAuthProviderImplTest.GetAppIdTokenInvalidAudienceError [00035.563399][4563][4581][klog] INFO: [00035.563399][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3707757521" [00035.563400][4563][4581][klog] INFO: [WARNING:topaz/auth_providers/google/google_auth_provider_impl.cc(234)] Got error: OAuth backend returned error: 401 [00035.563401][4563][4581][klog] INFO: [WARNING:topaz/auth_providers/google/google_auth_provider_impl.cc(235)] Got response: { [00035.563401][4563][4581][klog] INFO: "error": "invalid_client" [00035.563401][4563][4581][klog] INFO: } [00035.563402][4563][4581][klog] INFO: [ OK ] GoogleAuthProviderImplTest.GetAppIdTokenInvalidAudienceError (3 ms) [00035.563432][4563][4581][klog] INFO: [ RUN ] GoogleAuthProviderImplTest.GetAppIdTokenInvalidUserError [00035.563433][4563][4581][klog] INFO: [00035.563433][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="509245251" [00035.563434][4563][4581][klog] INFO: [WARNING:topaz/auth_providers/google/google_auth_provider_impl.cc(234)] Got error: OAuth backend returned error: 401 [00035.563434][4563][4581][klog] INFO: [WARNING:topaz/auth_providers/google/google_auth_provider_impl.cc(235)] Got response: { [00035.563435][4563][4581][klog] INFO: "error": "invalid_credential" [00035.563435][4563][4581][klog] INFO: } [00035.563436][4563][4581][klog] INFO: [ OK ] GoogleAuthProviderImplTest.GetAppIdTokenInvalidUserError (3 ms) [00035.563440][4563][4581][klog] INFO: [ RUN ] GoogleAuthProviderImplTest.GetAppFirebaseTokenSuccess [00035.563441][4563][4581][klog] INFO: [00035.563441][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2733188493" [00035.563442][4563][4581][klog] INFO: [ OK ] GoogleAuthProviderImplTest.GetAppFirebaseTokenSuccess (2 ms) [00035.563443][4563][4581][klog] INFO: [ RUN ] GoogleAuthProviderImplTest.GetAppFirebaseTokenBadRequestError [00035.563443][4563][4581][klog] INFO: [00035.563444][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2695406049" [00035.563444][4563][4581][klog] INFO: [ OK ] GoogleAuthProviderImplTest.GetAppFirebaseTokenBadRequestError (0 ms) [00035.563445][4563][4581][klog] INFO: [ RUN ] GoogleAuthProviderImplTest.RevokeAppOrPersistentCredentialUnsupported [00035.563445][4563][4581][klog] INFO: [00035.563446][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="286048390" [00035.563485][4563][4581][klog] INFO: [ OK ] GoogleAuthProviderImplTest.RevokeAppOrPersistentCredentialUnsupported (1 ms) [00035.563486][4563][4581][klog] INFO: [----------] 12 tests from GoogleAuthProviderImplTest (20 ms total) [00035.563487][4563][4581][klog] INFO: [00035.563487][4563][4581][klog] INFO: [----------] 6 tests from OAuthRequestBuilderTest [00035.563488][4563][4581][klog] INFO: [ RUN ] OAuthRequestBuilderTest.JsonEncodedPostRequest [00035.563558][4563][4581][klog] INFO: [ OK ] OAuthRequestBuilderTest.JsonEncodedPostRequest (0 ms) [00035.563559][4563][4581][klog] INFO: [ RUN ] OAuthRequestBuilderTest.UrlEncodedPostRequest [00035.563560][4563][4581][klog] INFO: [ OK ] OAuthRequestBuilderTest.UrlEncodedPostRequest (0 ms) [00035.563561][4563][4581][klog] INFO: [ RUN ] OAuthRequestBuilderTest.EmptyBodyPostRequest [00035.563561][4563][4581][klog] INFO: [ OK ] OAuthRequestBuilderTest.EmptyBodyPostRequest (0 ms) [00035.851962][4563][4581][klog] INFO: [ RUN ] OAuthRequestBuilderTest.CheckAuthHeader [00035.851998][4563][4581][klog] INFO: [ OK ] OAuthRequestBuilderTest.CheckAuthHeader (0 ms) [00035.851998][4563][4581][klog] INFO: [ RUN ] OAuthRequestBuilderTest.GetRequest [00035.851999][4563][4581][klog] INFO: [ OK ] OAuthRequestBuilderTest.GetRequest (0 ms) [00035.851999][4563][4581][klog] INFO: [ RUN ] OAuthRequestBuilderTest.GetRequestWithQueryParams [00035.852000][4563][4581][klog] INFO: [ OK ] OAuthRequestBuilderTest.GetRequestWithQueryParams (0 ms) [00035.852000][4563][4581][klog] INFO: [----------] 6 tests from OAuthRequestBuilderTest (0 ms total) [00035.852000][4563][4581][klog] INFO: [00035.852001][4563][4581][klog] INFO: [----------] 1 test from OAuthResponseTest [00035.852001][4563][4581][klog] INFO: [ RUN ] OAuthResponseTest.CheckParseOAuthResponse [00035.852002][4563][4581][klog] INFO: [ERROR:topaz/auth_providers/oauth/oauth_response.cc(22)] Encountered error: -2 ,with description: Bad request [00035.852002][4563][4581][klog] INFO: [ OK ] OAuthResponseTest.CheckParseOAuthResponse (10 ms) [00035.852002][4563][4581][klog] INFO: [----------] 1 test from OAuthResponseTest (11 ms total) [00035.852003][4563][4581][klog] INFO: [00035.852003][4563][4581][klog] INFO: [----------] 1 test from SpotifyFactoryImplTest [00035.852004][4563][4581][klog] INFO: [ RUN ] SpotifyFactoryImplTest.GetAuthProvider [00035.852004][4563][4581][klog] INFO: [00035.852004][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="8528048" [00035.852005][4563][4581][klog] INFO: [ OK ] SpotifyFactoryImplTest.GetAuthProvider (0 ms) [00035.852005][4563][4581][klog] INFO: [----------] 1 test from SpotifyFactoryImplTest (0 ms total) [00035.852005][4563][4581][klog] INFO: [00035.852010][4563][4581][klog] INFO: [----------] 6 tests from SpotifyAuthProviderImplTest [00035.852010][4563][4581][klog] INFO: [ RUN ] SpotifyAuthProviderImplTest.EmptyWhenClientDisconnected [00035.852010][4563][4581][klog] INFO: [00035.852011][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="852575710" [00035.852011][4563][4581][klog] INFO: [ OK ] SpotifyAuthProviderImplTest.EmptyWhenClientDisconnected (0 ms) [00035.852012][4563][4581][klog] INFO: [ RUN ] SpotifyAuthProviderImplTest.GetAppAccessTokenSuccess [00035.852012][4563][4581][klog] INFO: [00035.852012][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="322392418" [00035.852013][4563][4581][klog] INFO: [ OK ] SpotifyAuthProviderImplTest.GetAppAccessTokenSuccess (2 ms) [00035.852013][4563][4581][klog] INFO: [ RUN ] SpotifyAuthProviderImplTest.GetAppAccessTokenError [00035.852013][4563][4581][klog] INFO: [00035.852014][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="2668776203" [00035.852014][4563][4581][klog] INFO: [ OK ] SpotifyAuthProviderImplTest.GetAppAccessTokenError (2 ms) [00035.852015][4563][4581][klog] INFO: [ RUN ] SpotifyAuthProviderImplTest.GetAppIdTokenUnsupported [00035.852015][4563][4581][klog] INFO: [00035.852015][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="3365280598" [00035.852016][4563][4581][klog] INFO: [ OK ] SpotifyAuthProviderImplTest.GetAppIdTokenUnsupported (0 ms) [00035.852016][4563][4581][klog] INFO: [ RUN ] SpotifyAuthProviderImplTest.GetAppFirebaseTokenUnsupported [00035.852017][4563][4581][klog] INFO: [00035.852017][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="1118882491" [00035.852018][4563][4581][klog] INFO: [ OK ] SpotifyAuthProviderImplTest.GetAppFirebaseTokenUnsupported (0 ms) [00035.852018][4563][4581][klog] INFO: [ RUN ] SpotifyAuthProviderImplTest.RevokeAppOrPersistentCredentialUnsupported [00035.852019][4563][4581][klog] INFO: [00035.852019][4563][4581][klog] INFO: TEST_LOOP_RANDOM_SEED="4247911960" [00035.853092][4563][4581][klog] INFO: [ OK ] SpotifyAuthProviderImplTest.RevokeAppOrPersistentCredentialUnsupported (0 ms) [00035.853134][4563][4581][klog] INFO: [----------] 6 tests from SpotifyAuthProviderImplTest (4 ms total) [00035.853135][4563][4581][klog] INFO: [00035.853135][4563][4581][klog] INFO: [----------] Global test environment tear-down [00035.853136][4563][4581][klog] INFO: [==========] 27 tests from 6 test cases ran. (36 ms total) [00035.853136][4563][4581][klog] INFO: [ PASSED ] 27 tests. [00036.053016][4563][4581][klog] INFO: PASSED: /system/test/auth_provider_unittests passed [00036.084602][4563][4581][klog] INFO: [00036.084634][4563][4581][klog] INFO: ------------------------------------------------ [00036.084636][4563][4581][klog] INFO: RUNNING TEST: /system/test/web_view_link_test [00036.084637][4563][4581][klog] INFO: [00036.381000][4563][4581][klog] INFO: PASSED: /system/test/web_view_link_test passed