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

{ "shards": [ { "bot_dimensions": [ { "key": "caches", "value": [ "swarming_module_cache_vpython" ] }, { "key": "cores", "value": [ "8" ] }, { "key": "cpu", "value": [ "x86", "x86-64", "x86-64-Broadwell_GCE", "x86-64-avx2" ] }, { "key": "gce", "value": [ "1" ] }, { "key": "gpu", "value": [ "none" ] }, { "key": "id", "value": [ "chrome-trusty-us-east1-d-105-go0q" ] }, { "key": "image", "value": [ "chrome-trusty-19041600-95c8804d634" ] }, { "key": "inside_docker", "value": [ "0" ] }, { "key": "kvm", "value": [ "1" ] }, { "key": "machine_type", "value": [ "n1-standard-8" ] }, { "key": "os", "value": [ "Linux", "Ubuntu", "Ubuntu-14.04" ] }, { "key": "pool", "value": [ "Chrome" ] }, { "key": "python", "value": [ "2.7.6" ] }, { "key": "server_version", "value": [ "4303-bae210e" ] }, { "key": "zone", "value": [ "us", "us-east", "us-east1", "us-east1-d" ] } ], "bot_id": "chrome-trusty-us-east1-d-105-go0q", "bot_version": "ec327ca04645110c43b092f9eb2d259c2461902ca791b7bcf390931d49bda575", "cipd_pins": { "client_package": { "package_name": "infra/tools/cipd/linux-amd64", "version": "nFftZl2kFquaI2EUmPGwzbc5sIbCocl9L55UeASqlLsC" }, "packages": [ { "package_name": "infra/python/cpython/linux-amd64", "path": ".swarming_module", "version": "46c0c897ca0f053799ee41fd148bb7a47232df47" }, { "package_name": "infra/tools/luci/logdog/butler/linux-amd64", "path": ".swarming_module", "version": "2737ea8ed9b958f4d5aa9ffe106115a649ada241" }, { "package_name": "infra/tools/luci/vpython-native/linux-amd64", "path": ".swarming_module", "version": "tfTmX4aGCfFtfQucj_nEfwiNisK0RmpKrITkZMBBq3cC" }, { "package_name": "infra/tools/luci/vpython/linux-amd64", "path": ".swarming_module", "version": "bmnYyAg9mbM_538s1dIP1hZZmOtc8C7ssF41ztN2cr0C" } ] }, "completed_ts": "2019-05-25T01:28:39.049488", "costs_usd": [ 0.002706239382761405 ], "created_ts": "2019-05-25T01:28:13.543209", "duration": 15.827064990997314, "modified_ts": "2019-05-25T01:28:39.049488", "name": "perfetto_unittests/Ubuntu-14.04/434b2ca574/Fuchsia x64/35860", "output": "Additional test environment:\n CHROME_DEVEL_SANDBOX=/opt/chromium/chrome_sandbox\n CHROME_HEADLESS=1\n LANG=en_US.UTF-8\nCommand: bin/run_perfetto_unittests --test-launcher-bot-mode --test-launcher-summary-output=/b/s/w/io1Czsgj/output.json\n\n2019-05-24 18:28:21,970:INFO:root:Connecting to Fuchsia using SSH.\n2019-05-24 18:28:28,143:INFO:root:Connected!\n2019-05-24 18:28:28,144:INFO:root:Attaching kernel logger.\n[00000.000] zbi: @ 0xffffff8000d28000 (12731768 bytes)\n[00000.000] UART: FIFO depth 16\n[00000.000] PMM: boot reserve add [0x100000, 0x311fff]\n[00000.000] PMM: boot reserve add [0xd28000, 0x194cfff]\n[00000.000] PMM: boot reserve marking WIRED [0x100000, 0x311fff]\n[00000.000] PMM: boot reserve marking WIRED [0xd28000, 0x194cfff]\n[00000.000]\n[00000.000] welcome to Zircon\n[00000.000]\n[00000.000] KASLR: .text section at 0xffffffff00100000\n[00000.000] INIT: cpu 0, calling hook 0xffffffff001183f4 (global_prng_seed) at level 0x30000, flags 0x1\n[00000.000] initializing vm pre-heap\n[00000.000] VM: marking boot alloc used range [0x194d000, 0x194d040)\n[00000.000] INIT: cpu 0, calling hook 0xffffffff00125650 (elf_build_id) at level 0x4fffe, flags 0x1\n[00000.000] INIT: cpu 0, calling hook 0xffffffff001257dc (version) at level 0x4ffff, flags 0x1\n[00000.000] version:\n[00000.000] \tarch: x86\n[00000.000] \tplatform: XXX\n[00000.000] \ttarget: XXX\n[00000.000] \tproject: x64\n[00000.000] \tbuildid: git-80c53851eb71b568b7e6640123d3c341405e913b-dirty\n[00000.000] \tELF build ID: e18c341cd5203fa6d21937035cf874594130b58e\n[00000.000] initializing heap\n[00000.000] INIT: cpu 0, calling hook 0xffffffff00101f78 (console) at level 0x50000, flags 0x1\n[00000.000] INIT: cpu 0, calling hook 0xffffffff001872ec (x86_resource_init) at level 0x50000, flags 0x1\n[00000.000] initializing vm\n[00000.000] VM: reserving kernel region [0xffffffff00100000, 0xffffffff00229000) flags 0x28 name 'kernel_code'\n[00000.000] VM: reserving kernel region [0xffffffff00229000, 0xffffffff0027c000) flags 0x8 name 'kernel_rodata'\n[00000.000] VM: reserving kernel region [0xffffffff0027c000, 0xffffffff00284000) flags 0x18 name 'kernel_data'\n[00000.000] VM: reserving kernel region [0xffffffff00284000, 0xffffffff00312000) flags 0x18 name 'kernel_bss'\n[00000.000] INIT: cpu 0, calling hook 0xffffffff00188010 (display_memtype) at level 0x60001, flags 0x1\n[00000.000] INIT: cpu 0, calling hook 0xffffffff0018b538 (acpi_tables) at level 0x60001, flags 0x1\n[00000.000] INIT: cpu 0, calling hook 0xffffffff00186014 (hpet) at level 0x60002, flags 0x1\n[00000.000] INIT: cpu 0, calling hook 0xffffffff00186430 (apic) at level 0x60002, flags 0x1\n[00000.000] x2APIC enabled\n[00000.000] INIT: cpu 0, calling hook 0xffffffff001ad2a8 (system_topology_init) at level 0x60002, flags 0x1\n[00000.000] WARNING: unable to find any cache levels.\n[00000.000] WARNING: unable to find any cache levels.\n[00000.000] Could not find SRAT table. ACPICA returned: 5\n[00000.000] INIT: cpu 0, calling hook 0xffffffff0018ab28 (timer) at level 0x60003, flags 0x1\n[00000.000] pvclock: Clocksource is stable\n[00000.000] HPET frequency: 100000 ticks/ms\n[00000.000] pvclock: Fetching TSC frequency\n[00000.000] TSC frequency: 2200000 ticks/ms\n[00000.395] timer features: constant_tsc 1 invariant_tsc 1 tsc_deadline 1\n[00000.395] Using TSC as wallclock\n[00000.395] INIT: cpu 0, calling hook 0xffffffff002190c4 (percpu_heap_init) at level 0x60003, flags 0x1\n[00000.395] initializing kernel\n[00000.395] initializing mp\n[00000.395] INIT: cpu 0, calling hook 0xffffffff00118648 (global_prng_thread_safe) at level 0x7ffff, flags 0x1\n[00000.395] creating bootstrap completion thread\n[00000.396] top of bootstrap2()\n[00000.396] INIT: cpu 0, calling hook 0xffffffff00134cac (libobject) at level 0x80000, flags 0x1\n[00000.396] OOM: started thread\n[00000.396] INIT: cpu 0, calling hook 0xffffffff00215ed4 (dpc) at level 0x80000, flags 0x1\n[00000.396] Processor Model Info: type 0 family 0x6 model 0xf stepping 0\n[00000.396] \tdisplay_family 0x6 display_model 0x4f\n[00000.396] Vendor: Intel\n[00000.396] Microarch: Broadwell\n[00000.396] F/M/S: 6/4f/0\n[00000.396] patch_level: 0\n[00000.396] Brand: Intel(R) Xeon(R) CPU @ 2.20GHz\n[00000.396] Features: fpu sse sse2 sse3 ssse3 sse4.1 sse4.2 mmx avx avx2 fxsr pcid xsave aesni clflush\n[00000.396] fsgsbase tsc_adj smep smap erms rdrand rdseed syscall nx rdtscp invar_tsc tsc_deadline\n[00000.396] x2apic hypervisor\n[00000.396] Properties: meltdown l1tf pcid_good\n[00000.396] initializing platform\n[00000.396] INIT: cpu 0, calling hook 0xffffffff001a692c (x86_perfmon) at level 0x90000, flags 0x1\n[00000.396] x86_perfmon_init_once:454: perfmon: unexpected programmable counter width 0 in cpuid.0AH\n[00000.396] UART: started IRQ driven RX\n[00000.396] UART: started IRQ driven TX\n[00000.396] cpu topology:\n[00000.396] \t0: apic id 0x0 BSP\n[00000.396] \t1: apic id 0x1\n[00000.396] \t2: apic id 0x2\n[00000.396] \t3: apic id 0x3\n[00000.396] Found 4 cpus\n[00000.397] booting apic ids: 0x1 0x2 0x3\n[00000.409] entering scheduler on cpu 1\n[00000.409] entering scheduler on cpu 2\n[00000.409] entering scheduler on cpu 3\n[00000.410] smbios: manufacturer=\"QEMU\" product=\"Standard PC (Q35 + ICH9, 2009)\"\n[00000.410] initializing target\n[00000.410] INIT: cpu 0, calling hook 0xffffffff00189ccc (x86_pcie_init) at level 0xa0000, flags 0x1\n[00000.410] moving to last init level\n[00000.410] INIT: cpu 0, calling hook 0xffffffff001248a8 (debuglog) at level 0xb0000, flags 0x1\n[00000.411] INIT: cpu 0, calling hook 0xffffffff001798f0 (kcounters) at level 0xb0000, flags 0x1\n[00000.411] INIT: cpu 0, calling hook 0xffffffff00102aa0 (kernel_shell) at level 0xc0000, flags 0x1\n[00000.411] INIT: cpu 0, calling hook 0xffffffff002128f8 (ktrace) at level 0xc0000, flags 0x1\n[00000.759] ktrace: buffer at 0xffffff9f77a10000 (33554432 bytes)\n[00000.759] INIT: cpu 0, calling hook 0xffffffff00225f08 (userboot) at level 0xc0000, flags 0x1\n[00000.759] userboot: ramdisk 0xc25000 @ 0xffffff8000d28000\n[00000.774] userboot: userboot rodata 0 @ [0x420143a3d000,0x420143a40000)\n[00000.774] userboot: userboot code 0x3000 @ [0x420143a40000,0x420143a4b000)\n[00000.774] userboot: vdso/full rodata 0 @ [0x420143a4b000,0x420143a52000)\n[00000.774] userboot: vdso/full code 0x7000 @ [0x420143a52000,0x420143a53000)\n[00000.774] userboot: entry point @ 0x420143a40c90\n[00000.798] userboot: option \"/b/s/w/ir/third_party/fuchsia-sdk/sdk/target/x64/qemu-kernel.bin=\"\n[00000.798] userboot: option \"devmgr.epoch=1558747701\"\n[00000.798] userboot: option \"TERM=dumb\"\n[00000.798] userboot: option \"kernel.serial=legacy\"\n[00000.798] userboot: option \"multiboot.boot_loader_name=qemu\"\n[00000.837] userboot: searching bootfs for 'bin/bootsvc'\n[00000.837] userboot: 'bin/bootsvc' has PT_INTERP \"lib/ld.so.1\"\n[00000.837] userboot: searching bootfs for 'lib/ld.so.1'\n[00000.837] userboot: userboot: loaded lib/ld.so.1 at 0x4099c49b0000, entry point 0x4099c49ce880\n[00000.837] userboot: userboot: loaded vDSO at 0x4eb9b3f26000, entry point 0x4eb9b3f2d947\n[00000.837] userboot: process bin/bootsvc started.\n[00000.837] userboot: waiting for loader-service requests...\n[00000.865] userboot: searching bootfs for 'lib/libfdio.so'\n[00000.865] userboot: searching bootfs for 'lib/libtrace-engine.so'\n[00000.865] userboot: searching bootfs for 'lib/libasync-default.so'\n[00000.866] userboot: searching bootfs for 'lib/liblaunchpad.so'\n[00000.866] userboot: searching bootfs for 'lib/libc++.so.2'\n[00000.884] userboot: searching bootfs for 'lib/libc++abi.so.1'\n[00000.884] userboot: searching bootfs for 'lib/libunwind.so.1'\n[00000.892] {{{reset}}}\n[00000.892] {{{module:0:<application>:elf:cb41ad5ff525119d5fb38913fececc6a4a9a91fe}}}\n[00000.892] {{{mmap:0x3ca80da51000:0x3b000:load:0:rx:0}}}\n[00000.892] {{{mmap:0x3ca80da8d000:0x4000:load:0:rw:0x3c000}}}\n[00000.892] dso: id=cb41ad5ff525119d5fb38913fececc6a4a9a91fe base=0x00003ca80da51000 name=<application>\n[00000.892] {{{module:0x2:<vDSO>:elf:2ddcbe6a7f3c2077addc9a53695676646bee1abf}}}\n[00000.892] {{{mmap:0x4eb9b3f26000:0x7000:load:0x2:r:0}}}\n[00000.892] {{{mmap:0x4eb9b3f2d000:0x1000:load:0x2:rx:0x7000}}}\n[00000.892] dso: id=2ddcbe6a7f3c2077addc9a53695676646bee1abf base=0x00004eb9b3f26000 name=<vDSO>\n[00000.892] {{{module:0x3:libfdio.so:elf:5f05a9dbbc82442cfe83235ad3b42ba339cb2cff}}}\n[00000.892] {{{mmap:0x50f48bf83000:0x39000:load:0x3:rx:0}}}\n[00000.892] {{{mmap:0x50f48bfbc000:0x6000:load:0x3:rw:0x39000}}}\n[00000.892] dso: id=5f05a9dbbc82442cfe83235ad3b42ba339cb2cff base=0x000050f48bf83000 name=libfdio.so\n[00000.892] {{{module:0x4:libtrace-engine.so:elf:36b9f8765d0109090c021638f2101b253564162e}}}\n[00000.892] {{{mmap:0x19fdd5162000:0x9000:load:0x4:rx:0}}}\n[00000.892] {{{mmap:0x19fdd516b000:0x2000:load:0x4:rw:0x9000}}}\n[00000.892] dso: id=36b9f8765d0109090c021638f2101b253564162e base=0x000019fdd5162000 name=libtrace-engine.so\n[00000.892] {{{module:0x5:libasync-default.so:elf:ecb2bce2176d0a131210570fb2d3e094fa6e1d49}}}\n[00000.892] {{{mmap:0x6f5271ea3000:0x1000:load:0x5:rx:0}}}\n[00000.892] {{{mmap:0x6f5271ea4000:0x1000:load:0x5:rw:0x1000}}}\n[00000.892] dso: id=ecb2bce2176d0a131210570fb2d3e094fa6e1d49 base=0x00006f5271ea3000 name=libasync-default.so\n[00000.892] {{{module:0x6:liblaunchpad.so:elf:4aa3c1bd360c85e919db0aeb1ff6d7adb1818ed0}}}\n[00000.892] {{{mmap:0x59ac221ea000:0x7000:load:0x6:rx:0}}}\n[00000.892] {{{mmap:0x59ac221f1000:0x2000:load:0x6:rw:0x7000}}}\n[00000.892] dso: id=4aa3c1bd360c85e919db0aeb1ff6d7adb1818ed0 base=0x000059ac221ea000 name=liblaunchpad.so\n[00000.892] {{{module:0x1:libc.so:elf:2d3da7ba6f1127c094f287551e1f1415d351c2ac}}}\n[00000.892] {{{mmap:0x4099c49b0000:0xa6000:load:0x1:rx:0}}}\n[00000.892] {{{mmap:0x4099c4a56000:0x5000:load:0x1:rw:0xa6000}}}\n[00000.892] dso: id=2d3da7ba6f1127c094f287551e1f1415d351c2ac base=0x00004099c49b0000 name=libc.so\n[00000.892] {{{module:0x7:libc++.so.2:elf:c40e3db9703e022b}}}\n[00000.892] {{{mmap:0x52595ec19000:0x53000:load:0x7:r:0}}}\n[00000.892] {{{mmap:0x52595ec6c000:0x7e000:load:0x7:rx:0x53000}}}\n[00000.892] {{{mmap:0x52595ecea000:0x5000:load:0x7:rw:0xd1000}}}\n[00000.892] {{{mmap:0x52595ecef000:0x3000:load:0x7:rw:0xd6000}}}\n[00000.892] dso: id=c40e3db9703e022b base=0x000052595ec19000 name=libc++.so.2\n[00000.892] {{{module:0x8:libc++abi.so.1:elf:7dd43029d9b84d36}}}\n[00000.892] {{{mmap:0x310819f90000:0x16000:load:0x8:r:0}}}\n[00000.892] {{{mmap:0x310819fa6000:0x23000:load:0x8:rx:0x16000}}}\n[00000.892] {{{mmap:0x310819fc9000:0x3000:load:0x8:rw:0x39000}}}\n[00000.892] {{{mmap:0x310819fcc000:0x1000:load:0x8:rw:0x3c000}}}\n[00000.892] dso: id=7dd43029d9b84d36 base=0x0000310819f90000 name=libc++abi.so.1\n[00000.892] {{{module:0x9:libunwind.so.1:elf:53013261665bb49a}}}\n[00000.892] {{{mmap:0xc8154c56000:0x6000:load:0x9:r:0}}}\n[00000.892] {{{mmap:0xc8154c5c000:0x8000:load:0x9:rx:0x6000}}}\n[00000.892] {{{mmap:0xc8154c64000:0x1000:load:0x9:rw:0xe000}}}\n[00000.892] {{{mmap:0xc8154c65000:0x1000:load:0x9:rw:0xf000}}}\n[00000.892] dso: id=53013261665bb49a base=0x00000c8154c56000 name=libunwind.so.1\n[00001.089] bootsvc: Starting...\n[00001.089] bootsvc: Creating bootfs service...\n[00001.089] userboot: loader-service channel peer closed\n[00001.089] userboot: finished!\n[00001.101] bootsvc: Retrieving boot image...\n[00001.101] bootsvc: Decommitted BOOTDATA VMO from 0 to 0xc24000\n[00001.101] bootsvc: Loading boot arguments...\n[00001.101] bootsvc: Creating svcfs service...\n[00001.101] bootsvc: Loading kernel VMOs...\n[00001.101] bootsvc: Creating loader service...\n[00001.101] bootsvc: Launching next process...\n[00001.101] bootsvc: bootsvc.next = bin/devcoordinator\n[00001.126] bootsvc: Launched bin/devcoordinator\n[00001.134] devcoordinator: launch /boot/bin/svchost (svchost) OK\n[00001.139] devcoordinator: launch /boot/bin/fshost (fshost) OK\n[00001.159] devcoordinator: launch /boot/bin/pwrbtn-monitor (pwrbtn-monitor) OK\n[00001.165] devcoordinator: launch /boot/bin/miscsvc (miscsvc) OK\n[00001.176] devcoordinator: launch /boot/bin/netsvc (netsvc) OK\n[00001.189] devcoordinator: launch /boot/bin/virtual-console (virtual-console) OK\n[00001.283] devcoordinator: full system required, ignoring fallback drivers until /system is loaded\n[00001.290] devcoordinator: launch devhost 'devhost:sys': pid=2468\n[00001.298] devcoordinator: launch devhost 'devhost:test': pid=2514\n[00001.305] devcoordinator: launch devhost 'devhost:root': pid=2555\n[00001.324] devcoordinator: launch devhost 'devhost:misc': pid=2644\n[00001.403] acpi-bus: not using IOMMU\n[00001.414] GetHwProperties: No PM support\n[00001.414] IntelPT: No PT support\n[00001.414] devhost[sys/cpu-trace] bind driver '/boot/driver/cpu-trace.so' failed: -2\n[00001.424] devcoordinator: launch /boot/bin/sh (sh:console) OK\n[00001.428] devcoordinator: rpc: bind-driver 'cpu-trace' status -2\n[00001.433] [sysmem_init 28] async_get_default_dispatcher(): 0x17fca3ea6450\n[00001.433] [sysmem_bind 40] sysmem_bind()\n[00001.440] acpi-pwrbtn: initialized\n[00001.444] vc: new input device /dev/class/input/000\n[00001.504] acpi: published device pci(0x17fbe3eb4b30), parent=sys(0x17fd23ea3610), handle=0x17fba3ea2110\n[00001.505] acpi: failed to get PCI base bus number for device 'PCI0' (status 4294967295)\n[00001.518] acpi: published device rtc(0x17fbe3ea35b0), parent=acpi(0x17fd23ea4010), handle=0x17fba3ea28d0\n[00001.525] acpi: published device i8042(0x17fbe3eaabd0), parent=acpi(0x17fd23ea4010), handle=0x17fba3ea2650\n[00001.526] acpi: published device serial(0x17fbe3eab0b0), parent=acpi(0x17fd23ea4010), handle=0x17fba3ea2cd0\n[00001.540] devcoordinator: launch devhost 'devhost:pci#1:1234:1111': pid=3303\n[00001.550] devcoordinator: launch devhost 'devhost:pci#2:1af4:1001': pid=3372\n[00001.559] devcoordinator: launch devhost 'devhost:pci#3:8086:100e': pid=3449\n[00001.578] devcoordinator: launch devhost 'devhost:pci#5:8086:2922': pid=3517\n[00001.584] acpi: published device serial(0x17fbe3eab650), parent=acpi(0x17fd23ea4010), handle=0x17fba3ea3e90\n[00001.600] devhost: WARNING: driver '/boot/driver/pc-ps2.so' did not add device in bind()\n[00001.613] i8042 device 0xab 0x41\n[00001.616] bochs_vbe: initialized display, 1024 x 768 (stride=1024 format=00020001)\n[00001.627] vc: new input device /dev/class/input/001\n[00001.649] vc: new display device /dev/class/display-controller/000\n[00001.661] GetSysmemConnection failed (continuing) - status: -2\n[00001.670] vc: Successfully attached to display 1\n[00001.681] ahci: using MSI interrupt\n[00001.709] fshost: Binding: /boot/driver/fvm.so\n[00001.713] DeviceControllerBind running: /boot/driver/fvm.so\n[00001.713] devcoordinator: rpc: bind-device 'block'\n[00001.720] DeviceControllerBind finished: /boot/driver/fvm.so ZX_OK\n[00001.738] fshost: BlockDevice::MountFilesystem(blobfs)\n[00001.745] devcoordinator: launch /boot/bin/blobfs (blobfs:/blob) OK\n[00001.785] i8042 device 0x00\n[00001.789] hid: boot mouse hack for \"hid-device-002\": report count (0->1), inp sz (24->24), out sz (0->0), feat sz (0->0)\n[00001.799] vc: new input device /dev/class/input/002\n[00001.921] fshost: starting 'bin/pkgsvr' '5084d6162c8ca8ec07404614ec08c0d801835d5457b2d1d62135368ebf0a31c9'...\n[00001.938] devcoordinator: launch bin/pkgsvr (pkgfs) OK\n[00001.976] pkgsvr: system: will be served from 5084d6162c8ca8ec07404614ec08c0d801835d5457b2d1d62135368ebf0a31c9\n[00001.976] pkgsvr: pkgfs serving index /data/pkgfs_index from blobfs /blob\n[00001.997] fshost: mounting minfs\n[00002.015] fshost: BlockDevice::MountFilesystem(minfs)\n[00002.023] devcoordinator: launch /boot/bin/minfs (minfs:/data) OK\n[00002.046] devcoordinator: adding system driver 'bt_hci_fake' '/system/driver/bt-hci-fake.so'\n[00002.046] minfs: filesystem in clean state.\n[00002.070] devcoordinator: launch /system/bin/appmgr (appmgr) OK\n[00002.094] devcoordinator: adding system driver 'bt_host' '/system/driver/bt-host.so'\n[00002.113] devcoordinator: adding system driver 'bt_hog' '/system/driver/bt-hog.so'\n[00002.121] devcoordinator: adding system driver 'bt_hci_passthrough' '/system/driver/bt-hci-passthrough.so'\n[00002.131] devcoordinator: driver 'bt_hog' added\n[00002.131] devcoordinator: driver 'bt_host' added\n[00002.131] devcoordinator: driver 'bt_hci_fake' added\n[00002.131] devcoordinator: driver 'bt_hci_passthrough' added\n[00002.131] devcoordinator: fallback driver 'usb_composite' is available\n[00002.131] devcoordinator: driver 'usb_composite' added\n[00002.131] devcoordinator: fallback driver 'intel_disp' is available\n[00002.131] devcoordinator: driver 'intel_disp' added\n[00002.464] [00002.464159][1425881415][0][netstack] INFO: netstack.go(679): NIC lo added [sniff = false]\n[00002.464] [00002.464906][1425881415][0][netstack] WARNING: main.go(148): OnInterfacesChanged failed: ErrPeerClosed: zx.Channel.Write\n[00003.372] netifc: ? /dev/class/ethernet/000\n[00003.377] netifc: create 512 eth buffers\n[00003.378] macaddr: 52:54:00:63:5e:7b\n[00003.378] ip6addr: fe80::5054:4d:fe63:5e7b\n[00003.378] snmaddr: ff02::1:ff63:5e7b\n[00003.378] netsvc: using /dev/class/ethernet/000\n[00003.378] netsvc: nodename='step-dime-yard-juicy'\n[00003.378] netsvc: start\n[00003.693] [INFO:main.cc(35)] Trace Manager starting with config: /pkg/data/tracing.config\n[00003.748] [00003.748453][1425881415][0][netstack] WARNING: netstack.go(551): getNodeName: device settings error: key not set\n[00003.779] [00003.779186][1425881415][0][netstack] INFO: netstack.go(679): NIC ethp0003 added [sniff = false]\n[00003.779] [00003.779368][1425881415][0][netstack] INFO: netstack.go(705): NIC ethp0003: link-local IPv6: fe80::5054:ff:fe63:5e7b\n[00003.795] [00003.794998][1425881415][0][netstack] WARNING: netstack.go(551): getNodeName: device settings error: key not set\n[00003.795] [00003.795301][1425881415][0][netstack] INFO: netstack.go(466): NIC ethp0003: starting\n[00003.816] [00003.816489][1425881415][0][netstack] INFO: netstack.go(381): NIC ethp0003: DHCP acquired IP 192.168.3.9 for 24h0m0s\n[00003.816] [00003.816620][1425881415][0][netstack] INFO: netstack.go(382): NIC ethp0003: Adding DNS servers: [192.168.3.3]\n[00003.816] [00003.816832][1425881415][0][netstack] INFO: netstack.go(395): adding routes [{Destination:0.0.0.0 Mask:0.0.0.0 Gateway:192.168.3.2 NIC:2} {Destination::: Mask::: Gateway: NIC:2} {Destination:192.168.3.0 Mask:255.255.255.0\n[00003.816] Gateway: NIC:2}] with metric=<not-set> dynamic=true\n[00003.894] wlanstack [I]: Starting\n[00004.059] [INFO:cobalt_main.cc(219)] Cobalt is starting with the following parameters: schedule_interval=3600 seconds, min_interval=10 seconds, initial_interval=60 seconds, max_bytes_per_observation_store=1048576, event_aggregator_bac\n[00004.059] kfill_days=2, start_event_aggregator_worker=1.\n[00004.115] [INFO:main.cc(20)] Exiting, perfmon device not supported\n[00004.197] [INFO:system_metrics_main.cc(23)] Cobalt SystemMetricsDaemon: System metrics daemon created.\n[00004.298] [INFO:display_watcher.cc(40)] Scenic: Acquired display controller /dev/class/display-controller/000.(000)\n[00004.305] GetSysmemConnection failed (continuing) - status: -2\n[00004.316] [ERROR:garnet/lib/ui/gfx/gfx_system.cc(198)] No Vulkan on device, Graphics system exiting.\n[00004.316] [INFO:input_system.cc(203)] Scenic input system initialized.\n[00004.327] DdkClose\n[00004.386] [INFO:input_interpreter.cc(421)] Can't process HID report descriptor for 000; All parsing attempts failed.\n[00004.404] [ERROR:garnet/bin/sysmgr/app.cc(185)] Singleton fuchsia-pkg://fuchsia.com/scenic#meta/scenic.cmx died\n[00004.553] [INFO:display_watcher.cc(40)] Scenic: Acquired display controller /dev/class/display-controller/000.(000)\n[00004.554] GetSysmemConnection failed (continuing) - status: -2\n[00004.564] [ERROR:garnet/lib/ui/gfx/gfx_system.cc(198)] No Vulkan on device, Graphics system exiting.\n[00004.564] [INFO:input_system.cc(203)] Scenic input system initialized.\n[00004.572] [ERROR:garnet/bin/sysmgr/app.cc(185)] Singleton fuchsia-pkg://fuchsia.com/scenic#meta/scenic.cmx died\n[00004.583] [ERROR:garnet/bin/ui/root_presenter/app.cc(214)] Session died, destroying all presentations.\n[00004.583] DdkClose\n[00004.770] Starting mDNS on interface ethp0003 192.168.3.9 using port 5356\n[00004.780] [WARNING:src/connectivity/network/mdns/service/mdns_interface_transceiver_v4.cc(68)] NET-2177 IP_TTL not supported (ENOPROTOOPT), continuing anyway. May cause spurious IP traffic\n[00004.781] Starting mDNS on interface ethp0003 fe80::5054:ff:fe63:5e7b using port 5356\n[00004.793] [00004.793913][1425881415][0][netstack] INFO: socket_conv.go(523): unimplemented setsockopt: SOL_IPV6 name=19 optVal=00\n[00004.794] [WARNING:src/connectivity/network/mdns/service/mdns_interface_transceiver_v6.cc(29)] NET-291 IPV6_MULTICAST_LOOP not supported (ENOPROTOOPT), continuing anyway\n[00004.794] [WARNING:src/connectivity/network/mdns/service/mdns_interface_transceiver_v6.cc(50)] NET-2180 IPV6_JOIN_GROUP returned ENODEV, mDNS will not communicate via IPV6\n[00004.820] Starting mDNS on interface ethp0003 ff02::1:ff63:5e7b using port 5356\n[00004.827] [0adding package perfetto_unittests/0\n2019/05/25 01:28:28 error removing source: Source not found\n2019-05-24 18:28:29,435:INFO:root:Installing perfetto_unittests version 0.\n2019-05-24 18:28:31,898:INFO:root:Running application.\n2019-05-24 18:28:31,901:INFO:root:Running \"/b/s/w/ir/third_party/fuchsia-sdk/sdk/tools/symbolize -ids-rel -llvm-symbolizer /b/s/w/ir/third_party/fuchsia-sdk/sdk/../../llvm-build/Release+Asserts/bin/llvm-symbolizer -build-id-dir /b/s/w/ir/third_party/fuchsia-sdk/sdk/.build-id -ids /b/s/w/ir/out/Release/gen/third_party/perfetto/perfetto_unittests/ids.txt\".\n0004.827509][1425881415][0][netstack] INFO: socket_conv.go(523): unimplemented setsockopt: SOL_IPV6 name=19 optVal=00\n[00004.828] [WARNING:src/connectivity/network/mdns/service/mdns_interface_transceiver_v6.cc(29)] NET-291 IPV6_MULTICAST_LOOP not supported (ENOPROTOOPT), continuing anyway\n[00004.844] [WARNING:src/connectivity/network/mdns/service/mdns_interface_transceiver_v6.cc(50)] NET-2180 IPV6_JOIN_GROUP returned ENODEV, mDNS will not communicate via IPV6\n[00004.846] mDNS: Verifying uniqueness of host name step-dime-yard-juicy.local.\n[00005.633] mDNS: Using unique host name step-dime-yard-juicy.local.\n[00006.144] setsockopt IP_TOS 32: Protocol not available:\n[00007.170] [ERROR:garnet/bin/sshd-host/sshd-host.cc(194)] Failed to kill child job: -11 (ZX_ERR_BAD_HANDLE)\n[00009.364] pkgsvr: package activated perfetto_unittests/0 (b5c442a3dddda3df9bc049523986abe4d1bf0738ae77352ae5b8a4c8cc0df5f2)\nIMPORTANT DEBUGGING NOTE: batches of tests are run inside their\nown process. For debugging a test inside a debugger, use the\n--gtest_filter=<your_test_name> flag along with\n--single-process-tests.\nUsing sharding settings from environment. This is shard 0/1\nUsing 4 parallel jobs.\n[1/375] OptionalTest.MoveConstructor (0 ms)\n[2/375] OptionalTest.MoveValueConstructor (0 ms)\n[3/375] OptionalTest.ConvertingCopyConstructor (0 ms)\n[4/375] OptionalTest.ConvertingMoveConstructor (0 ms)\n[5/375] OptionalTest.ConstructorForwardArguments (0 ms)\n[6/375] OptionalTest.ConstructorForwardInitListAndArguments (0 ms)\n[7/375] OptionalTest.ForwardConstructor (0 ms)\n[8/375] OptionalTest.NulloptConstructor (0 ms)\n[9/375] OptionalTest.AssignValue (0 ms)\n[10/375] OptionalTest.AssignObject (0 ms)\n[11/375] OptionalTest.Swap_outHasValue (0 ms)\n[12/375] OptionalTest.Swap_bothValue (0 ms)\n[13/375] OptionalTest.Emplace (0 ms)\n[14/375] OptionalTest.Equals_TwoEmpty (0 ms)\n[15/375] OptionalTest.Equals_TwoEquals (1 ms)\n[16/375] OptionalTest.Equals_OneEmpty (0 ms)\n[17/375] OptionalTest.Equals_TwoDifferent (0 ms)\n[18/375] OptionalTest.Equals_DifferentType (0 ms)\n[19/375] OptionalTest.NotEquals_TwoEmpty (0 ms)\n[20/375] OptionalTest.NotEquals_TwoEquals (0 ms)\n[21/375] OptionalTest.AssignObject_rvalue (0 ms)\n[22/375] OptionalTest.AssignNull (0 ms)\n[23/375] OptionalTest.AssignOverload (1 ms)\n[24/375] OptionalTest.OperatorStar (0 ms)\n[25/375] OptionalTest.OperatorStar_rvalue (0 ms)\n[26/375] OptionalTest.OperatorArrow (0 ms)\n[27/375] OptionalTest.Value_rvalue (0 ms)\n[28/375] OptionalTest.ValueOr (1 ms)\n[29/375] OptionalTest.Swap_bothNoValue (0 ms)\n[30/375] OptionalTest.Swap_inHasValue (0 ms)\n[31/375] CircularQueueTest.Int (6 ms)\n[32/375] CircularQueueTest.Sorting (9 ms)\n[33/375] CircularQueueTest.MoveOperators (1 ms)\n[34/375] CircularQueueTest.Iterators (0 ms)\n[35/375] CircularQueueTest.ObjectLifetime (1 ms)\n[36/375] NoDestructorTest.DoesNotDestruct (0 ms)\n[37/375] NoDestructorTest.ContainedObjectUsable (0 ms)\n[38/375] OptionalTest.DefaultConstructor (1 ms)\n[39/375] OptionalTest.CopyConstructor (0 ms)\n[40/375] OptionalTest.ValueConstructor (0 ms)\n[41/375] OptionalTest.NotEquals_OneEmpty (0 ms)\n[42/375] OptionalTest.NotEquals_TwoDifferent (1 ms)\n[43/375] OptionalTest.NotEquals_DifferentType (0 ms)\n[44/375] OptionalTest.Less_LeftEmpty (0 ms)\n[45/375] OptionalTest.Less_RightEmpty (0 ms)\n[46/375] OptionalTest.Less_BothEmpty (0 ms)\n[47/375] OptionalTest.Less_BothValues (0 ms)\n[48/375] OptionalTest.Less_DifferentType (1 ms)\n[49/375] OptionalTest.LessEq_LeftEmpty (0 ms)\n[50/375] OptionalTest.LessEq_RightEmpty (0 ms)\n[51/375] OptionalTest.LessEq_BothEmpty (1 ms)\n[52/375] OptionalTest.LessEq_BothValues (1 ms)\n[53/375] OptionalTest.LessEq_DifferentType (0 ms)\n[54/375] OptionalTest.Greater_BothEmpty (1 ms)\n[55/375] OptionalTest.Greater_LeftEmpty (0 ms)\n[56/375] OptionalTest.Greater_RightEmpty (0 ms)\n[57/375] OptionalTest.Greater_BothValue (0 ms)\n[58/375] OptionalTest.Greater_DifferentType (0 ms)\n[59/375] OptionalTest.GreaterEq_BothEmpty (0 ms)\n[60/375] OptionalTest.GreaterEq_LeftEmpty (0 ms)\n[61/375] OptionalTest.GreaterEq_RightEmpty (0 ms)\n[62/375] OptionalTest.GreaterEq_BothValue (0 ms)\n[63/375] OptionalTest.GreaterEq_DifferentType (1 ms)\n[64/375] OptionalTest.OptNullEq (0 ms)\n[65/375] OptionalTest.NullOptEq (1 ms)\n[66/375] OptionalTest.OptNullNotEq (0 ms)\n[67/375] OptionalTest.NullOptNotEq (0 ms)\n[68/375] OptionalTest.OptNullLower (0 ms)\n[69/375] OptionalTest.NullOptLower (0 ms)\n[70/375] OptionalTest.OptNullLowerEq (0 ms)\n[71/375] OptionalTest.NullOptLowerEq (0 ms)\n[72/375] OptionalTest.OptNullGreater (1 ms)\n[73/375] OptionalTest.NullOptGreater (0 ms)\n[74/375] OptionalTest.OptNullGreaterEq (0 ms)\n[75/375] OptionalTest.NullOptGreaterEq (0 ms)\n[76/375] OptionalTest.ValueEq_Empty (0 ms)\n[77/375] OptionalTest.ValueEq_NotEmpty (1 ms)\n[78/375] OptionalTest.ValueEq_DifferentType (0 ms)\n[79/375] OptionalTest.EqValue_Empty (0 ms)\n[80/375] OptionalTest.EqValue_NotEmpty (0 ms)\n[81/375] OptionalTest.EqValue_DifferentType (1 ms)\n[82/375] OptionalTest.ValueNotEq_Empty (0 ms)\n[83/375] OptionalTest.ValueNotEq_NotEmpty (0 ms)\n[84/375] OptionalTest.NotEqValue_Empty (0 ms)\n[85/375] OptionalTest.NotEqValue_NotEmpty (0 ms)\n[86/375] OptionalTest.NotEqValue_DifferentType (1 ms)\n[87/375] OptionalTest.ValueLess_Empty (0 ms)\n[88/375] OptionalTest.ValueLess_NotEmpty (0 ms)\n[89/375] OptionalTest.LessValue_Empty (0 ms)\n[90/375] OptionalTest.LessValue_NotEmpty (0 ms)\n[91/375] OptionalTest.LessValue_DifferentType (0 ms)\n[92/375] OptionalTest.ValueLessEq_Empty (1 ms)\n[93/375] OptionalTest.ValueLessEq_NotEmpty (0 ms)\n[94/375] OptionalTest.ValueLessEq_DifferentType (0 ms)\n[95/375] OptionalTest.LessEqValue_Empty (0 ms)\n[96/375] OptionalTest.LessEqValue_NotEmpty (0 ms)\n[97/375] OptionalTest.LessEqValue_DifferentType (0 ms)\n[98/375] OptionalTest.ValueGreater_Empty (0 ms)\n[99/375] OptionalTest.ValueGreater_NotEmpty (0 ms)\n[100/375] OptionalTest.ValueGreater_DifferentType (0 ms)\n[101/375] OptionalTest.GreaterValue_Empty (0 ms)\n[102/375] OptionalTest.GreaterValue_NotEmpty (0 ms)\n[103/375] OptionalTest.GreaterValue_DifferentType (0 ms)\n[104/375] OptionalTest.ValueGreaterEq_Empty (0 ms)\n[105/375] OptionalTest.ValueGreaterEq_NotEmpty (0 ms)\n[106/375] OptionalTest.ValueGreaterEq_DifferentType (1 ms)\n[107/375] OptionalTest.GreaterEqValue_Empty (0 ms)\n[108/375] OptionalTest.GreaterEqValue_NotEmpty (1 ms)\n[109/375] OptionalTest.GreaterEqValue_DifferentType (0 ms)\n[110/375] OptionalTest.NotEquals (0 ms)\n[111/375] OptionalTest.NotEqualsNull (0 ms)\n[112/375] OptionalTest.MakeOptional (1 ms)\n[113/375] OptionalTest.NonMemberSwap_bothNoValue (0 ms)\n[114/375] OptionalTest.NonMemberSwap_inHasValue (1 ms)\n[115/375] OptionalTest.NonMemberSwap_outHasValue (0 ms)\n[116/375] OptionalTest.NonMemberSwap_bothValue (0 ms)\n[117/375] OptionalTest.Hash_OptionalReflectsInternal (0 ms)\n[118/375] OptionalTest.Hash_NullOptEqualsNullOpt (0 ms)\n[119/375] OptionalTest.Hash_UseInSet (0 ms)\n[120/375] OptionalTest.HasValue (0 ms)\n[121/375] OptionalTest.Reset_int (0 ms)\n[122/375] OptionalTest.Reset_Object (0 ms)\n[123/375] OptionalTest.Reset_NoOp (0 ms)\n[124/375] OptionalTest.AssignFromRValue (0 ms)\n[125/375] OptionalTest.DontCallDefaultCtor (0 ms)\n[126/375] OptionalTest.DontCallNewMemberFunction (1 ms)\n[127/375] OptionalTest.Noexcept (0 ms)\n[128/375] OPtionalTest.ValueNotEq_DifferentType (0 ms)\n[129/375] OPtionalTest.ValueLess_DifferentType (0 ms)\n[130/375] PagedMemoryTest.Basic (1 ms)\n[131/375] StringWriterTest.WriteAllTypes (1 ms)\n[132/375] TimeTest.Conversions (0 ms)\n[133/375] TimeTest.GetTime (20 ms)\n[134/375] WeakPtrTest.AllCases (0 ms)\n[135/375] TaskRunnerTest/0.PostImmediateTask (0 ms)\n[136/375] TaskRunnerTest/0.PostDelayedTask (20 ms)\n[137/375] TaskRunnerTest/0.PostImmediateTaskFromTask (0 ms)\n[138/375] TaskRunnerTest/0.PostDelayedTaskFromTask (10 ms)\n[139/375] TaskRunnerTest/0.PostImmediateTaskFromOtherThread (1 ms)\n[140/375] TaskRunnerTest/0.PostDelayedTaskFromOtherThread (12 ms)\n[141/375] TaskRunnerTest/0.AddFileDescriptorWatch (0 ms)\n[142/375] TaskRunnerTest/0.RemoveFileDescriptorWatch (10 ms)\n[143/375] TaskRunnerTest/0.RemoveFileDescriptorWatchFromTask (10 ms)\n[144/375] TaskRunnerTest/0.AddFileDescriptorWatchFromAnotherWatch (0 ms)\n[145/375] TaskRunnerTest/0.RemoveFileDescriptorWatchFromAnotherWatch (10 ms)\n[146/375] TaskRunnerTest/0.ReplaceFileDescriptorWatchFromAnotherWatch (0 ms)\n[147/375] TaskRunnerTest/0.AddFileDescriptorWatchFromAnotherThread (1 ms)\n[148/375] TaskRunnerTest/0.FileDescriptorWatchWithMultipleEvents (0 ms)\n[149/375] TaskRunnerTest/0.FileDescriptorClosedEvent (0 ms)\n[150/375] TaskRunnerTest/0.PostManyDelayedTasks (19 ms)\n[151/375] PagedMemoryTest.Uncommitted (18 ms)\n[152/375] PagedMemoryTest.GuardRegions (45 ms)\n[153/375] ScopedDirTest.CloseOutOfScope (0 ms)\n[154/375] ScopedFileTest.CloseOutOfScope (1 ms)\n[155/375] ScopedFileTest.Reset (2 ms)\n[156/375] ScopedFileTest.Release (1 ms)\n[157/375] ScopedFileTest.MoveCtor (0 ms)\n[158/375] ScopedFileTest.MoveAssignment (1 ms)\n[159/375] ScopedFileTest.CloseFailureIsFatal (187 ms)\n[160/375] ScopedFstreamTest.CloseOutOfScope (1 ms)\n[161/375] TaskRunnerTest/0.RunAgain (4 ms)\n[162/375] TaskRunnerTest/0.FileDescriptorWatchesNotStarved (5 ms)\n[163/375] TaskRunnerTest/0.NoDuplicateFileDescriptorWatchCallbacks (0 ms)\n[164/375] TaskRunnerTest/0.ReplaceFileDescriptorWatchFromOtherThread (1 ms)\n[165/375] TaskRunnerTest/0.IsIdleForTesting (0 ms)\n[166/375] TaskRunnerTest/0.RunsTasksOnCurrentThread (1 ms)\n[167/375] TempFileTest.Create (5 ms)\n[168/375] TempFileTest.CreateUnlinked (14 ms)\n[169/375] TempFileTest.ReleaseUnlinked (9 ms)\n[170/375] TempFileTest.ReleaseLinked (5 ms)\n[171/375] TempFileTest.TempDir (9 ms)\n[172/375] ThreadCheckerTest.Basic (0 ms)\n[173/375] ThreadCheckerTest.Detach (1 ms)\n[174/375] ThreadCheckerTest.CopyConstructor (46 ms)\n[175/375] ThreadTaskRunnerTest.ConstructedRunning (7 ms)\n[176/375] ThreadTaskRunnerTest.RunsTasksOnOneDedicatedThread (17 ms)\n[177/375] ThreadTaskRunnerTest.MovableOwnership (15 ms)\n[178/375] ThreadTaskRunnerTest.EnqueuedTasksDestructedOnTaskThread (6 ms)\n[179/375] UtilsTest.ArraySize (0 ms)\n[180/375] UtilsTest.Align (0 ms)\n[181/375] MessageHandleTest.MoveHandleSharedMessageDoesntFinalize (0 ms)\n[182/375] MessageTest.ZeroLengthArraysAndStrings (1 ms)\n[183/375] MessageTest.BasicTypesNoNesting (0 ms)\n[184/375] MessageTest.NestedMessagesSimple (0 ms)\n[185/375] MessageTest.AppendScatteredBytes (0 ms)\n[186/375] MessageTest.BackfillSizeOnFinalization (0 ms)\n[187/375] MessageTest.StressTest (9 ms)\n[188/375] MessageTest.DestructInvalidMessageHandle (1 ms)\n[189/375] MessageTest.MessageHandle (0 ms)\n[190/375] MessageTest.MoveMessageHandle (0 ms)\n[191/375] ProtoUtilsTest.VarIntEncoding (0 ms)\n[192/375] ProtoUtilsTest.VarIntEncodingNegative (1 ms)\n[193/375] ProtoUtilsTest.RedundantVarIntEncoding (0 ms)\n[194/375] ProtoUtilsTest.VarIntDecoding (1 ms)\n[195/375] ProtoUtilsTest.VarIntDecodingOutOfBounds (0 ms)\n[196/375] ScatteredStreamWriterTest.ScatteredWrites (0 ms)\n[197/375] ProtoZeroConformanceTest.SimpleFieldsNoNesting (1 ms)\n[198/375] ProtoZeroConformanceTest.NestedMessages (0 ms)\n[199/375] ProtoZeroTest.Simple (0 ms)\n[200/375] ProtoZeroTest.FieldNumbers (0 ms)\n[201/375] ProtoDecoderTest.ReadString (0 ms)\n[202/375] ProtoDecoderTest.VeryLargeField (2 ms)\n[203/375] ProtoDecoderTest.SingleRepeatedField (0 ms)\n[204/375] ProtoDecoderTest.SingleRepeatedFieldWithExpansion (0 ms)\n[205/375] ProtoDecoderTest.NoRepeatedField (0 ms)\n[206/375] ProtoDecoderTest.RepeatedFields (0 ms)\n[207/375] ProtoDecoderTest.FixedData (0 ms)\n[208/375] ProtoDecoderTest.FindField (0 ms)\n[209/375] ProtoUtilsTest.FieldPreambleEncoding (0 ms)\n[210/375] ProtoUtilsTest.ZigZagEncoding (0 ms)\n[211/375] IdAllocatorTest.IdAllocation (1 ms)\n[212/375] IdAllocatorTest.IdAllocation_U8 (0 ms)\n[213/375] NullTraceWriterTest.WriterIdIsZero (0 ms)\n[214/375] NullTraceWriterTest.Writing (1 ms)\n[215/375] NullTraceWriterTest.FlushCallbackIsCalled (0 ms)\n[216/375] PacketStreamValidatorTest.NullPacket (0 ms)\n[217/375] PacketStreamValidatorTest.SimplePacket (2 ms)\n[218/375] PacketStreamValidatorTest.ComplexPacket (1 ms)\n[219/375] PacketStreamValidatorTest.SimplePacketWithUid (0 ms)\n[220/375] PacketStreamValidatorTest.SimplePacketWithZeroUid (0 ms)\n[221/375] PacketStreamValidatorTest.SimplePacketWithNegativeOneUid (1 ms)\n[222/375] PacketStreamValidatorTest.ComplexPacketWithUid (0 ms)\n[223/375] PacketStreamValidatorTest.FragmentedPacket (0 ms)\n[224/375] PacketStreamValidatorTest.FragmentedPacketWithUid (0 ms)\n[225/375] PacketStreamValidatorTest.TruncatedPacket (0 ms)\n[226/375] PacketStreamValidatorTest.TrailingGarbage (0 ms)\n[227/375] PatchListTest.InsertAndRemove (1 ms)\n[228/375] PatchListTest.PointerStability (0 ms)\n[229/375] SlicedProtobufInputStreamTest.SingleSlice (0 ms)\n[230/375] SlicedProtobufInputStreamTest.SimpleSequence (0 ms)\n[231/375] TraceBufferTest.ReadWrite_PaddingAtEndUpdatesIndexMisaligned (1 ms)\n[232/375] TraceBufferTest.ReadWrite_EmptyPacket (1 ms)\n[233/375] TraceBufferTest.Fragments_Simple (0 ms)\n[234/375] TraceBufferTest.Fragments_EdgeCases (0 ms)\n[235/375] TraceBufferTest.Fragments_OutOfOrderLastChunkIsMiddle (1 ms)\n[236/375] TraceBufferTest.Fragments_OutOfOrderLastChunkIsMiddleFragmentation (0 ms)\n[237/375] TraceBufferTest.Fragments_OutOfOrderLastChunkIsMaxFragmentation (0 ms)\n[238/375] TraceBufferTest.Fragments_OutOfOrderWithIdOverflowADCB (1 ms)\n[239/375] TraceBufferTest.Fragments_OutOfOrderWithIdOverflowACBD (0 ms)\n[240/375] TraceBufferTest.Fragments_EmptyChunkBefore (0 ms)\n[241/375] TraceBufferTest.Malicious_ChunkTooBig (2 ms)\n[242/375] TraceBufferTest.Malicious_DeclareMorePacketsBeyondBoundaries (3 ms)\n[243/375] TraceBufferTest.Malicious_ZeroVarintHeader (0 ms)\n[244/375] TraceBufferTest.Malicious_OverflowingVarintHeader (1 ms)\n[245/375] TraceBufferTest.Malicious_VarintHeaderTooBig (0 ms)\n[246/375] TraceBufferTest.Malicious_JumboVarint (0 ms)\n[247/375] TraceBufferTest.Malicious_ZeroVarintHeaderInSequence (0 ms)\n[248/375] TraceBufferTest.Malicious_ZeroVarintHeaderAtEndOfChunk (0 ms)\n[249/375] TraceBufferTest.Malicious_PatchOutOfBounds (0 ms)\n[250/375] TraceBufferTest.Malicious_OverrideWithShorterChunkSize (1 ms)\n[251/375] SlicedProtobufInputStreamTest.SequenceWithSkipsAndBackups (0 ms)\n[252/375] TraceBufferTest.ReadWrite_EmptyBuffer (0 ms)\n[253/375] TraceBufferTest.ReadWrite_Simple (16 ms)\n[254/375] TraceBufferTest.ReadWrite_OneChunkPerWriter (1 ms)\n[255/375] TraceBufferTest.ReadWrite_FillTillEnd (0 ms)\n[256/375] TraceBufferTest.ReadWrite_Padding (1 ms)\n[257/375] TraceBufferTest.ReadWrite_MinimalPadding (0 ms)\n[258/375] TraceBufferTest.ReadWrite_RandomChunksNoWrapping (154 ms)\n[259/375] TraceBufferTest.ReadWrite_WrappingCases (0 ms)\n[260/375] TraceBufferTest.ReadWrite_PaddingAtEndUpdatesIndex (0 ms)\n[261/375] TraceBufferTest.Fragments_EmptyChunkAfter (0 ms)\n[262/375] TraceBufferTest.Fragments_EmptyChunkInTheMiddle (0 ms)\n[263/375] TraceBufferTest.Fragments_LongPackets (1 ms)\n[264/375] TraceBufferTest.Fragments_LongPacketWithWrappingID (1 ms)\n[265/375] TraceBufferTest.Fragments_PreserveUID (0 ms)\n[266/375] TraceBufferTest.Patching_Simple (1 ms)\n[267/375] TraceBufferTest.Patching_SkipIfChunkDoesntExist (0 ms)\n[268/375] TraceBufferTest.Patching_AtBoundariesOfChunk (0 ms)\n[269/375] TraceBufferTest.Patching_ReadWaitsForPatchComplete (0 ms)\n[270/375] TraceBufferTest.Malicious_ZeroSizedChunk (0 ms)\n[271/375] StringSplitterTest.StdString (0 ms)\n[272/375] StringSplitterTest.CString (0 ms)\n[273/375] StringSplitterTest.SplitOnNUL (0 ms)\n[274/375] StringSplitterTest.NestedUsage (0 ms)\n[275/375] StringUtilsTest.StartsWith (0 ms)\n[276/375] StringUtilsTest.EndsWith (0 ms)\n[277/375] StringUtilsTest.SplitString (0 ms)\n[278/375] StringViewTest.BasicCases (1 ms)\n[279/375] StringViewTest.HashCollisions (1030 ms)\n[280/375] StringWriterTest.BasicCases (0 ms)\n[281/375] TraceBufferTest.Override_ReCommitReordered (2 ms)\n[282/375] TraceBufferTest.Override_ReCommitReorderedFragmenting (2 ms)\n[283/375] TraceBufferTest.Override_ReCommitSameBeforeRead (2 ms)\n[284/375] TraceBufferTest.Override_ReCommitSameAfterRead (2 ms)\n[285/375] TraceBufferTest.Override_ReCommitIncompleteAfterReadOutOfOrder (3 ms)\n[286/375] TraceBufferTest.Override_ReCommitIncompleteFragmenting (6 ms)\n[287/375] TraceBufferTest.DiscardPolicy (3 ms)\n[288/375] TraceBufferTest.MissingPacketsOnSequence (1 ms)\n[289/375] TracePacketTest.Simple (0 ms)\n[290/375] TracePacketTest.Sliced (0 ms)\n[291/375] TraceBufferTest.Malicious_OverrideWithShorterChunkSizeAfterRead (1 ms)\n[292/375] TraceBufferTest.Malicious_OverrideWithDifferentOffsetAfterRead (0 ms)\n[293/375] TraceBufferTest.Iterator_OneStreamOrdered (1 ms)\n[294/375] TraceBufferTest.Iterator_OneStreamWrapping (3 ms)\n[295/375] TraceBufferTest.Iterator_ManyStreamsOrdered (10 ms)\n[296/375] TraceBufferTest.Iterator_ManyStreamsWrapping (3 ms)\n[297/375] TraceBufferTest.Override_ReCommitBeforeRead (0 ms)\n[298/375] TraceBufferTest.Override_ReCommitAfterPartialRead (0 ms)\n[299/375] TraceBufferTest.Override_ReCommitAfterFullRead (0 ms)\n[300/375] TraceBufferTest.Override_ReCommitInvalid (1 ms)\n[301/375] TracePacketTest.Corrupted (2 ms)\n[302/375] TracePacketTest.GetProtoPreamble (0 ms)\n[303/375] TracePacketTest.MoveOperators (0 ms)\n[304/375] TracingServiceImplTest.AtMostOneConfig (10 ms)\n[305/375] TracingServiceImplTest.RegisterAndUnregister (1 ms)\n[306/375] TracingServiceImplTest.EnableAndDisableTracing (2 ms)\n[307/375] TracingServiceImplTest.StartTracingTriggerDeferredStart (27 ms)\n[308/375] TracingServiceImplTest.StartTracingTriggerTimeOut (4 ms)\n[309/375] TracingServiceImplTest.StartTracingTriggerDifferentProducer (7 ms)\n[310/375] TracingServiceImplTest.StartTracingTriggerCorrectProducer (61 ms)\n[311/375] TracingServiceImplTest.StartTracingTriggerDifferentTrigger (2 ms)\n[312/375] TracingServiceImplTest.StartTracingTriggerMultipleTriggers (26 ms)\n[313/375] TracingServiceImplTest.StartTracingTriggerMultipleTraces (55 ms)\n[314/375] TracingServiceImplTest.EmitTriggersWithStartTracingTrigger (24 ms)\n[315/375] TracingServiceImplTest.EmitTriggersWithStopTracingTrigger (19 ms)\n[316/375] TracingServiceImplTest.EmitTriggersRepeatedly (27 ms)\n[317/375] TracingServiceImplTest.StopTracingTriggerTimeout (9 ms)\n[318/375] TracingServiceImplTest.StopTracingTriggerRingBuffer (19 ms)\n[319/375] TracingServiceImplTest.StopTracingTriggerMultipleTriggers (15 ms)\n[320/375] TracingServiceImplTest.LockdownMode (3 ms)\n[321/375] TracingServiceImplTest.ProducerNameFilterChange (10 ms)\n[322/375] TracingServiceImplTest.DisconnectConsumerWhileTracing (18 ms)\n[323/375] TracingServiceImplTest.ReconnectProducerWhileTracing (6 ms)\n[324/375] TracingServiceImplTest.ProducerIDWrapping (0 ms)\n[325/375] TracingServiceImplTest.WriteIntoFileAndStopOnMaxSize (41 ms)\n[326/375] TracingServiceImplTest.ProducerShmAndPageSizeOverriddenByTraceConfig (3 ms)\n[327/375] TracingServiceImplTest.ExplicitFlush (19 ms)\n[328/375] TracingServiceImplTest.ImplicitFlushOnTimedTraces (16 ms)\n[329/375] TracingServiceImplTest.BatchFlushes (23 ms)\n[330/375] TracingServiceImplTest.PeriodicFlush (18 ms)\n[331/375] TracingServiceImplTest.RegisterAndUnregisterTraceWriter (15 ms)\n[332/375] TracingServiceImplTest.ScrapeBuffersOnFlush (126 ms)\n[333/375] TracingServiceImplTest.ScrapeBuffersFromAnotherThread (29 ms)\n[334/375] TracingServiceImplTest.ScrapeBuffersOnProducerDisconnect (15 ms)\n[335/375] TracingServiceImplTest.ScrapeBuffersOnDisable (11 ms)\n[336/375] TracingServiceImplTest.AbortIfTraceDurationIsTooLong (0 ms)\n[337/375] TracingServiceImplTest.GetTraceStats (1 ms)\n[338/375] TracingServiceImplTest.ObserveEventsDataSourceInstances (2 ms)\n[339/375] PageSize/SharedMemoryABITest.NominalCases/0 (0 ms)\n[340/375] PageSize/SharedMemoryABITest.NominalCases/1 (0 ms)\n[341/375] PageSize/StartupTraceWriterTest.CreateBound/1 (1 ms)\n[342/375] PageSize/StartupTraceWriterTest.WriteWhileUnboundAndDiscard/0 (0 ms)\n[343/375] PageSize/StartupTraceWriterTest.WriteWhileUnboundAndDiscard/1 (0 ms)\n[344/375] PageSize/StartupTraceWriterTest.WriteWhileUnboundAndBind/0 (1 ms)\n[345/375] PageSize/StartupTraceWriterTest.WriteWhileUnboundAndBind/1 (1 ms)\n[346/375] PageSize/StartupTraceWriterTest.WriteMultipleChunksWhileUnboundAndBind/0 (3 ms)\n[347/375] PageSize/StartupTraceWriterTest.WriteMultipleChunksWhileUnboundAndBind/1 (18 ms)\n[348/375] PageSize/StartupTraceWriterTest.BindingWhileWritingFails/0 (0 ms)\n[349/375] PageSize/StartupTraceWriterTest.BindingWhileWritingFails/1 (0 ms)\n[350/375] PageSize/StartupTraceWriterTest.CreateAndBindViaRegistry/0 (1 ms)\n[351/375] TracingServiceImplTest.Periodic2019-05-24 18:28:35,958:INFO:root:Process exited normally with status code 0.\n2019-05-24 18:28:35,958:INFO:root:Terminating kernel log reader.\n2019-05-24 18:28:36,253:INFO:root:Shutting down QEMU.\nClearIncrementalState (11 ms)\n[352/375] TracingServiceImplTest.OnTracingDisabledWaitsForDataSourceStopAcks (18 ms)\n[353/375] TracingServiceImplTest.OnDataSourceAddedWhilePendingDisableAcks (4 ms)\n[354/375] TracingServiceImplTest.OnTracingDisabledCalledAnywaysInCaseOfTimeout (14 ms)\n[355/375] TracingServiceImplTest.SessionId (20 ms)\n[356/375] TracingServiceImplTest.ResynchronizeTraceStreamUsingSyncMarker (196 ms)\n[357/375] TracingServiceImplTest.DeferredStart (2 ms)\n[358/375] TracingServiceImplTest.ProducerUIDsAndPacketSequenceIDs (11 ms)\n[359/375] TracingServiceImplTest.AllowedBuffers (3 ms)\n[360/375] TracingServiceImplTest.CommitToForbiddenBufferIsDiscarded (18 ms)\n[361/375] PageSize/StartupTraceWriterTest.CreateAndBindViaRegistry/1 (2 ms)\n[362/375] PageSize/TraceWriterImplTest.SingleWriter/0 (0 ms)\n[363/375] PageSize/TraceWriterImplTest.SingleWriter/1 (0 ms)\n[364/375] PageSize/TraceWriterImplTest.FragmentingPacket/0 (0 ms)\n[365/375] PageSize/TraceWriterImplTest.FragmentingPacket/1 (0 ms)\n[366/375] PageSize/SharedMemoryABITest.NominalCases/2 (1 ms)\n[367/375] PageSize/SharedMemoryABITest.NominalCases/3 (1 ms)\n[368/375] PageSize/SharedMemoryABITest.NominalCases/4 (0 ms)\n[369/375] PageSize/SharedMemoryArbiterImplTest.GetAndReturnChunks/0 (12 ms)\n[370/375] PageSize/SharedMemoryArbiterImplTest.GetAndReturnChunks/1 (1 ms)\n[371/375] PageSize/SharedMemoryArbiterImplTest.WriterIDsAllocation/0 (282 ms)\n[372/375] PageSize/SharedMemoryArbiterImplTest.WriterIDsAllocation/1 (190 ms)\n[373/375] PageSize/StartupTraceWriterTest.CreateUnboundAndBind/0 (1 ms)\n[374/375] PageSize/StartupTraceWriterTest.CreateUnboundAndBind/1 (0 ms)\n[375/375] PageSize/StartupTraceWriterTest.CreateBound/0 (0 ms)\nSUCCESS: all tests passed.\nTests took 3 seconds.\n", "outputs_ref": { "isolated": "89c0b1f80fee496e4100edc55c44039d0c8f062e", "isolatedserver": "https://isolateserver.appspot.com", "namespace": "default-gzip" }, "run_id": "45056bca12c7c111", "server_versions": [ "4303-bae210e" ], "started_ts": "2019-05-25T01:28:14.302681", "state": "COMPLETED", "tags": [ "build_is_experimental:false", "buildername:Fuchsia x64", "buildnumber:35860", "cpu:x86-64", "data:434b2ca5748aee48c91841c54a910c3d933a91a0", "gpu:none", "kvm:1", "master:chromium.linux", "name:perfetto_unittests", "os:Ubuntu-14.04", "pool:Chrome", "priority:25", "project:chromium", "purpose:CI", "purpose:luci", "purpose:post-commit", "service_account:none", "slavename:swarm973-c4", "spec_name:chromium.ci:Fuchsia x64", "stepname:perfetto_unittests", "swarming.pool.template:none", "swarming.pool.version:ccd91245d277b60137b7f72e33ea6072eedcc9f9", "user:None" ], "task_id": "45056bca12c7c110", "try_number": "1" } ] }