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": [ "gce-trusty-e833d7b0-us-east1-b-jj7g" ] }, { "key": "image", "value": [ "chrome-trusty-18091700-38cc06ee3ee" ] }, { "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": [ "4201-b04f7f8" ] }, { "key": "zone", "value": [ "us", "us-east", "us-east1", "us-east1-b" ] } ], "bot_id": "gce-trusty-e833d7b0-us-east1-b-jj7g", "bot_version": "51d929b905e4fffb3652f17e0ff8dceb0f7077275d215d276fb6c5a2f238b3f7", "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": "OAXVAmcUSrvDygYUrCDzv20LRono9938YOHPu0zKowgC" }, { "package_name": "infra/tools/luci/vpython/linux-amd64", "path": ".swarming_module", "version": "ucaOciwAE9aweCUDOrmSvyiwrjmbywuB0NzAGUXIHjAC" } ] }, "completed_ts": "2019-03-17T02:44:20.711716", "costs_usd": [ 0.028607526263370063 ], "created_ts": "2019-03-17T02:40:11.504133", "duration": 200.9385290145874, "modified_ts": "2019-03-17T02:44:20.711716", "name": "cast_runner_integration_tests/Ubuntu-14.04/0f82c87760/fuchsia-fyi-x64-dbg/5857", "output": "9 files remaining...\nAdditional test environment:\n CHROME_DEVEL_SANDBOX=/opt/chromium/chrome_sandbox\n CHROME_HEADLESS=1\n LANG=en_US.UTF-8\nCommand: bin/run_cast_runner_integration_tests --test-launcher-bot-mode --test-launcher-summary-output=/b/s/w/io8_NWVj/output.json\n\n2019-03-16 19:41:00,917:INFO:root:Connecting to Fuchsia using SSH.\n2019-03-16 19:41:09,178:INFO:root:Connected!\n2019-03-16 19:41:09,179:INFO:root:Attaching kernel logger.\n[00000.000] zbi: @ 0xffffff8000a6a000 (9856728 bytes)\n[00000.000] UART: FIFO depth 16\n[00000.000] PMM: boot reserve add [0x100000, 0x2e4fff]\n[00000.000] PMM: boot reserve add [0xa6a000, 0x13d0fff]\n[00000.000] PMM: boot reserve marking WIRED [0x100000, 0x2e4fff]\n[00000.000] PMM: boot reserve marking WIRED [0xa6a000, 0x13d0fff]\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 0xffffffff0010f234 (global_prng_seed) at level 0x30000, flags 0x1\n[00000.000] initializing vm pre-heap\n[00000.000] VM: marking boot alloc used range [0x13d1000, 0x13d1040)\n[00000.000] INIT: cpu 0, calling hook 0xffffffff0011c4d8 (elf_build_id) at level 0x4fffe, flags 0x1\n[00000.000] INIT: cpu 0, calling hook 0xffffffff0011c664 (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-5f2dd2258e6159b2f5ca75e2ccbe358e1fa782d2-dirty\n[00000.000] \tELF build ID: fa087b26b89e407aec091d2abcc2c221a9bf149e\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 0xffffffff00171648 (x86_resource_init) at level 0x50000, flags 0x1\n[00000.000] initializing vm\n[00000.000] VM: reserving kernel region [0xffffffff00100000, 0xffffffff00201000) flags 0x28 name 'kernel_code'\n[00000.000] VM: reserving kernel region [0xffffffff00201000, 0xffffffff0024f000) flags 0x8 name 'kernel_rodata'\n[00000.000] VM: reserving kernel region [0xffffffff0024f000, 0xffffffff0025f000) flags 0x18 name 'kernel_data'\n[00000.000] VM: reserving kernel region [0xffffffff0025f000, 0xffffffff002e5000) flags 0x18 name 'kernel_bss'\n[00000.000] INIT: cpu 0, calling hook 0xffffffff0017230c (display_memtype) at level 0x60001, flags 0x1\n[00000.000] INIT: cpu 0, calling hook 0xffffffff0017534c (acpi_tables) at level 0x60001, flags 0x1\n[00000.000] INIT: cpu 0, calling hook 0xffffffff0017046c (hpet) at level 0x60002, flags 0x1\n[00000.000] INIT: cpu 0, calling hook 0xffffffff0017082c (apic) at level 0x60002, flags 0x1\n[00000.000] x2APIC enabled\n[00000.000] INIT: cpu 0, calling hook 0xffffffff0017493c (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: 2199854 ticks/ms\n[00000.383] timer features: constant_tsc 1 invariant_tsc 1 tsc_deadline 1\n[00000.383] Using TSC as wallclock\n[00000.383] initializing kernel\n[00000.383] initializing mp\n[00000.383] initializing timers\n[00000.383] INIT: cpu 0, calling hook 0xffffffff0010f488 (global_prng_thread_safe) at level 0x7ffff, flags 0x1\n[00000.383] INIT: cpu 0, calling hook 0xffffffff0011b790 (debuglog) at level 0x7ffff, flags 0x1\n[00000.383] INIT: cpu 0, calling hook 0xffffffff001e5d10 (thread_set_priority_experiment) at level 0x7ffff, flags 0x1\n[00000.383] thread set priority experiment is : ENABLED\n[00000.383] creating bootstrap completion thread\n[00000.526] top of bootstrap2()\n[00000.526] INIT: cpu 0, calling hook 0xffffffff00127f70 (libobject) at level 0x80000, flags 0x1\n[00000.526] OOM: started thread\n[00000.533] INIT: cpu 0, calling hook 0xffffffff0019d880 (dpc) at level 0x80000, flags 0x1\n[00000.537] Processor Model Info: type 0 family 0x6 model 0xf stepping 0\n[00000.537] \tdisplay_family 0x6 display_model 0x4f\n[00000.537] Vendor: Intel\n[00000.537] Microarch: Broadwell\n[00000.537] F/M/S: 6/4f/0\n[00000.537] Brand: Intel(R) Xeon(R) CPU @ 2.20GHz\n[00000.537] Features: fpu sse sse2 sse3 ssse3 sse4.1 sse4.2 mmx avx avx2 fxsr pcid xsave aesni clflush\n[00000.537] fsgsbase tsc_adj smep smap erms rdrand rdseed syscall nx rdtscp invar_tsc tsc_deadline\n[00000.537] x2apic hypervisor\n[00000.537] initializing platform\n[00000.537] INIT: cpu 0, calling hook 0xffffffff0018deb4 (x86_perfmon) at level 0x90000, flags 0x1\n[00000.537] x86_perfmon_init_once:497: perfmon: unexpected programmable counter width 0 in cpuid.0AH\n[00000.538] UART: started IRQ driven RX\n[00000.538] UART: started IRQ driven TX\n[00000.538] cpu topology:\n[00000.538] \t0: apic id 0x0 package 0 node 0 core 0 smt 0 BSP\n[00000.538] \t1: apic id 0x1 package 1 node 0 core 0 smt 0\n[00000.538] \t2: apic id 0x2 package 2 node 0 core 0 smt 0\n[00000.538] \t3: apic id 0x3 package 3 node 0 core 0 smt 0\n[00000.538] Found 4 cpus\n[00000.538] booting apic ids: 0x1 0x2 0x3\n[00000.601] entering scheduler on cpu 2\n[00000.601] entering scheduler on cpu 3\n[00000.601] entering scheduler on cpu 1\n[00000.610] smbios: manufacturer=\"QEMU\" product=\"Standard PC (Q35 + ICH9, 2009)\"\n[00000.610] initializing target\n[00000.610] INIT: cpu 0, calling hook 0xffffffff00173bec (x86_pcie_init) at level 0xa0000, flags 0x1\n[00000.610] moving to last init level\n[00000.610] INIT: cpu 0, calling hook 0xffffffff00102a48 (kernel_shell) at level 0xc0000, flags 0x1\n[00000.610] INIT: cpu 0, calling hook 0xffffffff001fc0a8 (ktrace) at level 0xc0000, flags 0x1\n[00000.686] ktrace: buffer at 0xffffff9954b1d000 (33554432 bytes)\n[00000.686] INIT: cpu 0, calling hook 0xffffffff001fdfe8 (userboot) at level 0xc0000, flags 0x1\n[00000.686] userboot: ramdisk 0x967000 @ 0xffffff8000a6a000\n[00000.699] userboot: userboot rodata 0 @ [0x1291d2d76000,0x1291d2d79000)\n[00000.699] userboot: userboot code 0x3000 @ [0x1291d2d79000,0x1291d2d84000)\n[00000.699] userboot: vdso/full rodata 0 @ [0x1291d2d84000,0x1291d2d8b000)\n[00000.699] userboot: vdso/full code 0x7000 @ [0x1291d2d8b000,0x1291d2d8c000)\n[00000.700] userboot: entry point @ 0x1291d2d79c90\n[00000.720] userboot: option \"/b/s/w/ir/third_party/fuchsia-sdk/sdk/target/x64/qemu-kernel.bin=\"\n[00000.720] userboot: option \"devmgr.epoch=1552790458\"\n[00000.720] userboot: option \"zircon.nodename=e357727f-2e07-47f1-aef6-5eea04bf41c4\"\n[00000.720] userboot: option \"TERM=dumb\"\n[00000.720] userboot: option \"kernel.serial=legacy\"\n[00000.720] userboot: option \"multiboot.boot_loader_name=qemu\"\n[00000.761] userboot: searching bootfs for 'bin/bootsvc'\n[00000.761] userboot: 'bin/bootsvc' has PT_INTERP \"lib/ld.so.1\"\n[00000.761] userboot: searching bootfs for 'lib/ld.so.1'\n[00000.761] userboot: userboot: loaded lib/ld.so.1 at 0x719a2e457000, entry point 0x719a2e4942f1\n[00000.761] userboot: userboot: loaded vDSO at 0x4059c23bd000, entry point 0x0\n[00000.761] userboot: process bin/bootsvc started.\n[00000.762] userboot: waiting for loader-service requests...\n[00000.762] userboot: searching bootfs for 'lib/libasync-default.so'\n[00000.791] userboot: searching bootfs for 'lib/libfdio.so'\n[00000.792] userboot: searching bootfs for 'lib/libtrace-engine.so'\n[00000.792] userboot: searching bootfs for 'lib/liblaunchpad.so'\n[00000.802] {{{reset}}}\n[00000.803] {{{module:0:<application>:elf:be910e109aaa900057274be2c91b44fd9251d077}}}\n[00000.803] {{{mmap:0x647af96fa000:0x39000:load:0:rx:0}}}\n[00000.803] {{{mmap:0x647af9733000:0x4000:load:0:rw:0x39000}}}\n[00000.803] dso: id=be910e109aaa900057274be2c91b44fd9251d077 base=0x0000647af96fa000 name=<application>\n[00000.803] {{{module:0x2:<vDSO>:elf:5db6a550b7c22b4e5d9c55acc5bbc1d2583f0380}}}\n[00000.803] {{{mmap:0x4059c23bd000:0x7000:load:0x2:r:0}}}\n[00000.803] {{{mmap:0x4059c23c4000:0x1000:load:0x2:rx:0x7000}}}\n[00000.803] dso: id=5db6a550b7c22b4e5d9c55acc5bbc1d2583f0380 base=0x00004059c23bd000 name=<vDSO>\n[00000.803] {{{module:0x3:libasync-default.so:elf:179378e0029e9d73bcaaf61330269def68f524f0}}}\n[00000.803] {{{mmap:0x2cb1fa5ca000:0x1000:load:0x3:rx:0}}}\n[00000.803] {{{mmap:0x2cb1fa5cb000:0x1000:load:0x3:rw:0x1000}}}\n[00000.803] dso: id=179378e0029e9d73bcaaf61330269def68f524f0 base=0x00002cb1fa5ca000 name=libasync-default.so\n[00000.803] {{{module:0x1:libc.so:elf:608526d5035c0cab2fdd1718baca2d9ed1f3441b}}}\n[00000.803] {{{mmap:0x719a2e457000:0xcb000:load:0x1:rx:0}}}\n[00000.803] {{{mmap:0x719a2e523000:0x6000:load:0x1:rw:0xcc000}}}\n[00000.803] dso: id=608526d5035c0cab2fdd1718baca2d9ed1f3441b base=0x0000719a2e457000 name=libc.so\n[00000.803] {{{module:0x4:libfdio.so:elf:b9e13f817983faaf4b0927a0a26c6ae9fc2df591}}}\n[00000.803] {{{mmap:0x1065e1ada000:0x32000:load:0x4:rx:0}}}\n[00000.803] {{{mmap:0x1065e1b0d000:0x4000:load:0x4:rw:0x33000}}}\n[00000.803] dso: id=b9e13f817983faaf4b0927a0a26c6ae9fc2df591 base=0x00001065e1ada000 name=libfdio.so\n[00000.803] {{{module:0x5:libtrace-engine.so:elf:e693b8371adfd5db148ebbe7e9af42cfd4b2408f}}}\n[00000.803] {{{mmap:0x784b08c8d000:0x9000:load:0x5:rx:0}}}\n[00000.803] {{{mmap:0x784b08c96000:0x2000:load:0x5:rw:0x9000}}}\n[00000.803] dso: id=e693b8371adfd5db148ebbe7e9af42cfd4b2408f base=0x0000784b08c8d000 name=libtrace-engine.so\n[00000.803] {{{module:0x6:liblaunchpad.so:elf:7bbb5d72e7b50ffd31348f1fff0031cd559eaa75}}}\n[00000.803] {{{mmap:0x250aea87000:0x7000:load:0x6:rx:0}}}\n[00000.803] {{{mmap:0x250aea8e000:0x2000:load:0x6:rw:0x7000}}}\n[00000.803] dso: id=7bbb5d72e7b50ffd31348f1fff0031cd559eaa75 base=0x00000250aea87000 name=liblaunchpad.so\n[00000.803] bootsvc: Starting...\n[00000.803] userboot: loader-service channel peer closed\n[00000.803] bootsvc: Creating bootfs service...\n[00000.803] userboot: finished!\n[00000.804] bootsvc: Processing bootdata...\n[00000.932] bootsvc: Loading boot cmdline overrides...\n[00000.933] bootsvc: Loading kernel VMOs...\n[00000.933] bootsvc: Creating loader service...\n[00000.933] bootsvc: Launching next process...\n[00000.945] bootsvc: launched bin/devcoordinator\n[00000.949] devcoordinator: main()\n[00000.950] devcoordinator: coordinator_init()\n[00000.950] devcoordinator: init\n[00000.950] devcoordinator: svc init\n[00000.951] devcoordinator: launch /boot/bin/svchost (svchost) OK\n[00000.951] devcoordinator: vfs init\n[00000.971] devcoordinator: launch /boot/bin/fshost (fshost) OK\n[00000.972] devcoordinator: shell startup\n[00000.982] fshost: started.\n[00000.985] devcoordinator: launch /boot/bin/netsvc (netsvc) OK\n[00000.996] devcoordinator: launch /boot/bin/pwrbtn-monitor (pwrbtn-monitor) OK\n[00001.008] devcoordinator: launch /boot/bin/virtual-console (virtual-console) OK\n[00001.034] devcoordinator: no driver info in '/boot/driver/mtk-power.so'\n[00001.055] devcoordinator: full system required, ignoring fallback drivers until /system is loaded\n[00001.062] devcoordinator: launch devhost 'devhost:sys': pid=2083\n[00001.067] devcoordinator: launch devhost 'devhost:test': pid=2133\n[00001.069] devcoordinator: launch devhost 'devhost:root': pid=2185\n[00001.074] devhost: trace provider registry begun\n[00001.075] devcoordinator: launch devhost 'devhost:misc': pid=2262\n[00001.077] devhost: trace provider registry begun\n[00001.080] devhost: trace provider registry begun\n[00001.097] devhost: trace provider registry begun\n[00001.103] GetZbiMetadata metadata not found for type 524f426d, extra 0\n[00001.113] devcoordinator: launch /boot/bin/sh (sh:console) OK\n[00001.125] acpi-bus: not using IOMMU\n[00001.131] GetHwProperties: No PM support\n[00001.131] IntelPT: No PT support\n[00001.131] devhost[sys/cpu-trace] bind driver '/boot/driver/cpu-trace.so' failed: -2\n[00001.131] devcoordinator: rpc: bind-driver 'cpu-trace' status -2\n[00001.146] [sysmem_init 28] async_get_default_dispatcher(): 0x46c9afe410a0\n[00001.146] [sysmem_bind 40] sysmem_bind()\n[00001.154] acpi-pwrbtn: initialized\n[00001.158] vc: new input device /dev/class/input/000\n[00001.234] acpi: published device pci(0x4633a1540180), parent=sys(0x46c9afe4f0c0), handle=0x46c9afe4c300\n[00001.235] acpi: failed to get PCI base bus number for device 'PCI0' (status 4294967295)\n[00001.247] acpi: published device rtc(0x4633a1540200), parent=acpi(0x46c9afe4f300), handle=0x46c9afe4c7b0\n[00001.255] acpi: published device i8042(0x4633a1540280), parent=acpi(0x46c9afe4f300), handle=0x46c9afe4c840\n[00001.265] devcoordinator: launch devhost 'devhost:pci#1:1234:1111': pid=2781\n[00001.276] devhost: trace provider registry begun\n[00001.276] devcoordinator: launch devhost 'devhost:pci#2:1af4:1001': pid=2843\n[00001.288] devhost: trace provider registry begun\n[00001.289] devcoordinator: launch devhost 'devhost:pci#3:8086:100e': pid=2940\n[00001.300] devcoordinator: launch devhost 'devhost:pci#5:8086:2922': pid=3029\n[00001.306] devhost: trace provider registry begun\n[00001.312] devhost: WARNING: driver '/boot/driver/pc-ps2.so' did not add device in bind()\n[00001.312] devhost: trace provider registry begun\n[00001.318] i8042 device 0xab 0x41\n[00001.334] vc: new input device /dev/class/input/001\n[00001.346] ahci: using MSI interrupt\n[00001.350] bochs_vbe: initialized display, 1024 x 768 (stride=1024 format=00020001)\n[00001.351] vc: new display device /dev/class/display-controller/000/virtcon\n[00001.353] vc: Successfully attached to display 1\n[00001.390] fshost: /dev/class/block/000: FVM?\n[00001.409] devcoordinator: launch /boot/bin/blobfs (blobfs:/blob) OK\n[00001.460] i8042 device 0x00\n[00001.465] 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.498] vc: new input device /dev/class/input/002\n[00001.617] fshost: starting 'bin/pkgsvr' 'ac8bdc046e71a5b2101645292fd640ca71d4bfbacaacb13b59d98cc1538a8966'...\n[00001.638] devcoordinator: launch bin/pkgsvr (pkgfs) OK\n[00001.675] pkgsvr: system: will be served from ac8bdc046e71a5b2101645292fd640ca71d4bfbacaacb13b59d98cc1538a8966\n[00001.675] pkgsvr: pkgfs serving index /data/pkgfs_index from blobfs /blob\n[00001.689] fshost: mounting minfs\n[00001.702] devcoordinator: launch /boot/bin/minfs (minfs:/data) OK\n[00001.714] devcoordinator: adding system driver 'bt_hci_fake' '/system/driver/bt-hci-fake.so'\n[00001.731] devcoordinator: launch /system/bin/appmgr (appmgr) OK\n[00001.757] devcoordinator: adding system driver 'gpu' '/system/driver/libmsd_intel.so'\n[00001.798] devcoordinator: adding system driver 'bt_host' '/system/driver/bt-host.so'\n[00001.814] devcoordinator: adding system driver 'bt_hog' '/system/driver/bt-hog.so'\n[00001.830] devcoordinator: adding system driver 'bt_hci_passthrough' '/system/driver/bt-hci-passthrough.so'\n[00001.839] devcoordinator: driver 'bt_hog' added\n[00001.839] devcoordinator: driver 'bt_host' added\n[00001.839] devcoordinator: driver 'gpu' added\n[00001.840] devcoordinator: driver 'bt_hci_fake' added\n[00001.840] devcoordinator: driver 'bt_hci_passthrough' added\n[00001.840] devcoordinator: fallback driver 'usb_composite' is available\n[00001.840] devcoordinator: driver 'usb_composite' added\n[00001.840] devcoordinator: fallback driver 'intel_disp' is available\n[00001.840] devcoordinator: driver 'intel_disp' added\n[00001.907] [INFO:namespace_builder.cc(93)] config-data for sysmgr\n[00002.624] [INFO:cobalt_main.cc(145)] Cobalt client schedule params: schedule_interval=3600 seconds, min_interval=10 seconds, initial_interval=60 seconds.\n[00002.775] [ERROR:garnet/lib/loader/package_loader.cc(55)] Could not open directory /pkgfs/packages/modem-mgr/0 No such file or directory\n[00002.813] [ERROR:garnet/bin/sysmgr/app.cc(166)] Singleton fuchsia-pkg://fuchsia.com/modem-mgr#meta/modem_mgr.cmx died\n[00002.905] netifc: ? /dev/class/ethernet/000\n[00002.909] netifc: create 512 eth buffers\n[00002.911] macaddr: 52:54:00:63:5e:7b\n[00002.911] ip6addr: fe80::5054:4d:fe63:5e7b\n[00002.911] snmaddr: ff02::1:ff63:5e7b\n[00002.911] netsvc: using /dev/class/ethernet/000\n[00002.924] netsvc: nodename='e357727f-2e07-47f1-aef6-5eea04bf41c4'\n[00002.924] netsvc: start\n[00003.421] [INFO:namespace_builder.cc(93)] config-data for crashpad_agent\n[00003.581] [INFO:main.cc(35)] Trace Manager starting with config: /pkg/data/tracing.config\n[00003.651] wlanstack2 [I]: Starting\n[00003.766] [INFO:a11y_input_system.cc(9)] Scenic accessibility input system started.\n[00003.766] [INFO:display_watcher.cc(40)] Scenic: Acquired display controller /dev/class/display-controller/000.(000)\n[00004.037] [INFO:input_interpreter.cc(1006)] hid-parser succesful for 000 with usage page 1 and usage 128\n[00004.201] ERROR: setupLoaderTermPhysDevs: Failed to detect any valid GPUs in the current config\n[00004.201] ERROR: setupLoaderTrampPhysDevs: Failed during dispatch call of 'vkEnumeratePhysicalDevices' to lower layers or loader to get count.\n[00004.201] [ERROR:garnet/lib/ui/gfx/gfx_system.cc(188)] No Vulkan on device, Graphics system exiting.\n[00004.201] [INFO:input_system.cc(245)] Scenic input system initialized.\n[00004.224] [ERROR:garnet/bin/initialized repo /b/s/w/itIooNm6/tmpxZ_qHB\nadding package cast_runner_integration_tests/0\ninitialized repo /b/s/w/itIooNm6/tmpxZ_qHB\nadding package chromium/0\n2019/03/17 02:41:11 error removing source: Source not found\n2019-03-16 19:41:11,777:INFO:root:Installing cast_runner_integration_tests version 0.\n2019/03/17 02:41:14 Awaiting response...\n2019/03/17 02:41:17 Awaiting response...\n2019/03/17 02:41:20 Awaiting response...\n2019/03/17 02:41:24 Awaiting response...\n2019/03/17 02:41:27 Awaiting response...\n2019/03/17 02:41:30 Awaiting response...\n2019/03/17 02:41:33 Awaiting response...\n2019/03/17 02:41:36 Awaiting response...\n2019/03/17 02:41:39 Awaiting response...\n2019/03/17 02:41:42 Awaiting response...\n2019/03/17 02:41:45 Awaiting response...\n2019/03/17 02:41:49 Awaiting response...\n2019/03/17 02:41:52 Awaiting response...\n2019/03/17 02:41:55 Awaiting response...\n2019/03/17 02:41:58 Awaiting response...\n2019/03/17 02:42:01 Awaiting response...\n2019/03/17 02:42:04 Awaiting response...\n2019/03/17 02:42:07 Awaiting response...\n2019/03/17 02:42:10 Awaiting response...\n2019/03/17 02:42:13 Awaiting response...\n2019/03/17 02:42:16 Awaiting response...\n2019/03/17 02:42:20 Awaiting response...\n2019/03/17 02:42:23 Awaiting response...\n2019/03/17 02:42:26 Awaiting response...\n2019/03/17 02:42:29 Awaiting response...\n2019/03/17 02:42:32 Awaiting response...\n2019/03/17 02:42:35 Awaiting response...\n2019/03/17 02:42:38 Awaiting response...\n2019/03/17 02:42:41 Awaiting response...\n2019/03/17 02:42:45 Awaiting response...\n2019/03/17 02:42:48 Awaiting response...\n2019/03/17 02:42:51 Awaiting response...\n2019/03/17 02:42:54 Awaiting response...\n2019/03/17 02:42:57 Awaiting response...\n2019/03/17 02:43:00 Awaiting response...\n2019/03/17 02:43:03 Awaiting response...\n2019/03/17 02:43:06 Awaiting response...\n2019/03/17 02:43:10 Awaiting response...\n2019/03/17 02:43:13 Awaiting response...\n2019/03/17 02:43:16 Awaiting response...\n2019/03/17 02:43:19 Awaiting response...\n2019/03/17 02:43:22 Awaiting response...\n2019/03/17 02:43:25 Awaiting response...\n2019/03/17 02:43:28 Awaiting response...\n2019/03/17 02:43:31 Awaiting response...\n2019/03/17 02:43:34 Awaiting response...\n2019/03/17 02:43:37 Awaiting response...\n2019/03/17 02:43:40 Awaiting response...\n2019/03/17 02:43:43 Awaiting response...\n2019/03/17 02:43:46 Awaiting response...\n2019/03/17 02:43:49 Awaiting response...\n2019/03/17 02:43:52 Awaiting response...\n2019/03/17 02:43:55 Awaiting response...\n2019/03/17 02:43:58 Awaiting response...\n2019/03/17 02:44:01 Success cast_runner_integration_tests/0: 1c7fc251be096bf0069a74bde673be1602a083b428c13b1b4271ba26562f4340\n2019-03-16 19:44:04,336:INFO:root:Installing chromium version 0.\n2019/03/17 02:44:05 Success chromium/0: dc46fadcee016ddd93dc2c40bbece302b141eabfe530ae16fab3e127f50d74e8\n2019-03-16 19:44:05,700:INFO:root:Running application.\n2019-03-16 19:44:05,703:INFO:root:Running \"/b/s/w/ir/third_party/fuchsia-sdk/sdk/tools/symbolize -ids /b/s/w/ir/out/Debug/gen/fuchsia/runners/cast_runner_integration_tests/ids.txt -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\".\nui/root_presenter/app.cc(214)] Scenic died, destroying all presentations.\n[00004.231] [ERROR:garnet/bin/ui/view_manager/view_registry.cc(80)] Exiting due to scene manager connection error.\n[00004.249] [ERROR:garnet/bin/sysmgr/app.cc(166)] Singleton fuchsia-pkg://fuchsia.com/view_manager#meta/view_manager.cmx died\n[00004.256] [ERROR:garnet/bin/sysmgr/app.cc(166)] Singleton fuchsia-pkg://fuchsia.com/scenic#meta/scenic.cmx died\n[00004.613] Starting mDNS on interface ethp0003 192.168.3.9\n[00004.763] Starting mDNS on interface ethp0003 [80fe::5450:ff00:63fe:7b5e]\n[00004.770] [ERROR:garnet/bin/mdns/service/mdns_interface_transceiver_v6.cc(49)] Failed to set socket option IPV6_JOIN_GROUP, No such device\n[00004.770] mDNS: Verifying uniqueness of host name step-dime-yard-juicy.local.\n[00005.672] mDNS: Using unique host name step-dime-yard-juicy.local.\n[00009.651] pkgsvr: asking amber to fetch 2555 needed blobs\n[00179.251] pkgsvr: package activated cast_runner_integration_tests/0 (1c7fc251be096bf0069a74bde673be1602a083b428c13b1b4271ba26562f4340)\n[00182.147] pkgsvr: asking amber to fetch 4 needed blobs\n[00183.069] pkgsvr: package activated chromium/0 (dc46fadcee016ddd93dc2c40bbece302b141eabfe530ae16fab3e127f50d74e8)\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[00189.519] pkgsvr: pkgfs:unsupported(/packages/chromium/0): dir unlink \"webrunner.log\"\n[00189.557] [141487:1649041901:0317/024411.927562:ERROR:base_paths_fuchsia.cc(21)] Not implemented reached in bool base::PathProviderFuchsia(int, base::FilePath *) for FILE_MODULE.\n[00189.564] [141487:1649041901:0317/024411.934537:ERROR:platform_thread_fuchsia.cc(42)] Not implemented reached in static void base::PlatformThread::SetCurrentThreadPriorityImpl(base::ThreadPriority)\n[00189.714] [141487:1661091535:0317/024412.083187:ERROR:child_process_launcher_helper_fuchsia.cc(22)] Not implemented reached in void content::internal::ChildProcessLauncherHelper::SetProcessPriorityOnLauncherThread(base::Process, const\n[00189.715] content::ChildProcessLauncherPriority &)\n[00189.818] [141487:1663174105:0317/024412.187959:ERROR:gpu_process_host.cc(560)] BrowserMainRunner::ExitedMainMessageLoop()\n[00189.838] [141487:1663174105:0317/024412.208579:ERROR:gpu_process_host.cc(560)] BrowserMainRunner::ExitedMainMessageLoop()\n[00189.848] [141487:1663174105:0317/024412.218053:ERROR:gpu_process_host.cc(560)] BrowserMainRunner::ExitedMainMessageLoop()\n[00189.862] [141487:1663174105:0317/024412.232640:WARNING:discardable_shared_memory_manager.cc(410)] Some MojoDiscardableSharedMemoryManagerImpls are still alive. They will be leaked.\n[00191.415] pkgsvr: pkgfs:unsupported(/packages/chromium/0): dir unlink \"webrunner.log\"\n[00191.456] [142876:651002981:0317/024413.825918:ERROR:base_paths_fuchsia.cc(21)] Not implemented reached in bool base::PathProviderFuchsia(int, base::FilePath *) for FILE_MODULE.\n[00191.586] [142876:656230747:0317/024413.956027:ERROR:platform_thread_fuchsia.cc(42)] Not implemented reached in static void base::PlatformThread::SetCurrentThreadPriorityImpl(base::ThreadPriority)\n[00191.736] pkgsvr: pkgfs:unsupported(/packages/chromium/0): dir unlink \"webrunner.log\"\n[00191.770] pkgsvr: pkgfs:unsupported(/packages/chromium/0): dir unlink \"webrunner.log\"\n[00191.777] pkgsvr: pkgfs:unsupported(/packages/chromium/0): dir unlink \"webrunner.log\"\n[00191.778] [143060:1865031161:0317/024414.148011:ERROR:base_paths_fuchsia.cc(21)] Not implemented reached in bool base::PathProviderFuchsia(int, base::FilePath *) for FILE_MODULE.\n[00191.799] [142950:1481438001:0317/024414.169038:ERROR:base_paths_fuchsia.cc(21)] Not implemented reached in bool base::PathProviderFuchsia(int, base::FilePath *) for FILE_MODULE.\n[00191.816] [143253:391912643:0317/024414.185961:ERROR:base_paths_fuchsia.cc(21)] Not implemented reached in bool base::PathProviderFuchsia(int, base::FilePath *) for FILE_MODULE.\n[00191.820] [143060:1868175463:0317/024414.178874:ERROR:platform_thread_fuchsia.cc(42)] Not implemented reached in static void base::PlatformThread::SetCurrentThreadPriorityImpl(base::ThreadPriority)\n[00191.824] pkgsvr: pkgfs:unsupported(/packages/chromium/0): dir unlink \"webrunner.log\"\n[00191.829] [143119:463766189:0317/024414.199566:ERROR:base_paths_fuchsia.cc(21)] Not implemented reached in bool base::PathProviderFuchsia(int, base::FilePath *) for FILE_MODULE.\n[00191.863] [143253:391912643:0317/024414.233472:ERROR:platform_thread_fuchsia.cc(42)] Not implemented reached in static void base::PlatformThread::SetCurrentThreadPriorityImpl(base::ThreadPriority)\n[00191.884] [143253:389809685:0317/024414.227606:ERROR:platform_thread_fuchsia.cc(42)] Not implemented reached in static void base::PlatformThread::SetCurrentThreadPriorityImpl(base::ThreadPriority)\n[00191.983] [143060:1868175463:0317/024414.352798:WARNING:discardable_shared_memory_manager.cc(410)] Some MojoDiscardableSharedMemoryManagerImpls are still alive. They will be leaked.\n[00192.135] [142950:1491400231:0317/024414.505324:ERROR:platform_thread_fuchsia.cc(42)] Not implemented reached in static void base::PlatformThread::SetCurrentThreadPriorityImpl(base::ThreadPriority)\n[00192.214] [143253:381945491:0317/024414.584446:ERROR:child_process_launcher_helper_fuchsia.cc(22)] Not implemented reached in void content::internal::ChildProcessLauncherHelper::SetProcessPriorityOnLauncherThread(base::Process, const\n[00192.214] content::ChildProcessLauncherPriority &)\n[00192.291] [143119:458542793:0317/024414.549822:ERROR:platform_thread_fuchsia.cc(42)] Not implemented reached in static void base::PlatformThread::SetCurrentThreadPriorityImpl(base::ThreadPriority)\n[00193.522] pkgsvr: pkgfs:unsupported(/packages/chromium/0): dir unlink \"webrunner.log\"\n[00193.537] [149132:1282843331:0317/024415.906880:ERROR:base_paths_fuchsia.cc(21)] Not implemented reached in bool base::PathProviderFuchsia(int, base::FilePath *) for FILE_MODULE.\n[00193.549] [149132:1282843331:0317/024415.919482:ERROR:platform_thread_fuchsia.cc(42)] Not implemented reached in static void base::PlatformThread::SetCurrentThreadPriorityImpl(base::ThreadPriority)\n[00193.562] [149132:1282843331:0317/024415.931336:ERROR:gpu_info_collector_fuchsia.cc(22)] Not implemented reached in bool gpu::CollectBasicGraphicsInfo(gpu::GPUInfo *)\n[00193.575] [149132:1282843331:0317/024415.944954:ERROR:egl_util.cc(60)] Failed to load GLES library: libswiftshader_libGLESv2.so: open library: FILE_ERROR_NOT_FOUND\n[00193.748] pkgsvr: pkgfs:unsupported(/packages/chromium/0): dir unlink \"webrunner.log\"\n[00193.748] pkgsvr: pkgfs:unsupported(/packages/chromium/0): dir unlink \"webrunner.log\"\n[00193.766] [149275:1731014985:0317/024416.135980:ERROR:base_paths_fuchsia.cc(21)] Not implemented reached in bool base::PathProviderFuchsia(int, base::FilePath *) for FILE_MODULE.\n[00193.769] [149331:1380942431:0317/024416.138857:ERROR:base_paths_fuchsia.cc(21)] Not implemented reached in bool base::PathProviderFuchsia(int, base::FilePath *) for FILE_MODULE.\n[00193.799] [149275:1731014985:0317/024416.169649:ERROR:platform_thread_fuchsia.cc(42)] Not implemented reached in static void base::PlatformThread::SetCurrentThreadPriorityImpl(base::ThreadPriority)\n[00193.810] [149275:1731014985:0317/024416.180619:ERROR:gpu_info_collector_fuchsia.cc(22)] Not implemented reached in bool gpu::CollectBasicGraphicsInfo(gpu::GPUInfo *)\n[00193.811] pkgsvr: pkgfs:unsupported(/packages/chromium/0): dir unlink \"webrunner.log\"\n[00193.818] [149423:26716607:0317/024416.188704:ERROR:base_paths_fuchsia.cc(21)] Not implemented reached in bool base::PathProviderFuchsia(int, base::FilePath *) for FILE_MODULE.\n[00193.836] [149275:1731014985:0317/024416.205817:ERROR:egl_util.cc(60)] Failed to load GLES library: libswiftshader_libGLESv2.so: open library: FILE_ERROR_NOT_FOUND\n[00193.889] [149275:1731014985:0317/024416.259124:ERROR:viz_main_impl.cc(170)] Exiting GPU process due to errors during initialization\n[00193.965] [149331:1391966045:0317/024416.335382:ERROR:platform_thread_fuchsi2019-03-16 19:44:17,550:INFO:root:Process exited normally with status code 0.\n2019-03-16 19:44:17,551:INFO:root:Terminating kernel log reader.\n2019-03-16 19:44:19,032:INFO:root:Shutting down QEMU.\na.cc(42)] Not implemented reached in static void base::PlatformThread::SetCurrentThreadPriorityImpl(base::ThreadPriority)\n[00193.984] [149423:24091907:0317/024416.353652:ERROR:platform_thread_fuchsia.cc(42)] Not implemented reached in static void base::PlatformThread::SetCurrentThreadPriorityImpl(base::ThreadPriority)\n[00194.028] [143253:391912643:0317/024416.398319:ERROR:time_zone_monitor_fuchsia.cc(30)] Not implemented reached in static std::unique_ptr<TimeZoneMonitor> device::TimeZoneMonitor::Create(scoped_refptr<base::SequencedTaskRunner>)\n[00194.145] [149423:26716607:0317/024416.514912:ERROR:process_metrics_fuchsia.cc(24)] Not implemented reached in static std::unique_ptr<ProcessMetrics> base::ProcessMetrics::CreateProcessMetrics(base::ProcessHandle)\n[00194.216] [143253:389809685:0317/024416.586241:ERROR:gpu_process_host.cc(560)] BrowserMainRunner::ExitedMainMessageLoop()\n[00194.228] [143253:389809685:0317/024416.598654:WARNING:discardable_shared_memory_manager.cc(410)] Some MojoDiscardableSharedMemoryManagerImpls are still alive. They will be leaked.\n[1/5] CastRunnerIntegrationTest.BasicRequest (1596 ms)\n[2/5] CastRunnerIntegrationTest.IncorrectCastAppId (99 ms)\n[3/5] CastRunnerIntegrationTest.CastChannel (4376 ms)\n[4/5] CastRunnerIntegrationTest.CastChannelConsumerDropped (173 ms)\n[5/5] CastRunnerIntegrationTest.CastChannelComponentControllerDropped (162 ms)\nSUCCESS: all tests passed.\nTests took 7 seconds.\n", "outputs_ref": { "isolated": "92278588d68124e2c8dbdeb690dfe210068c0774", "isolatedserver": "https://isolateserver.appspot.com", "namespace": "default-gzip" }, "run_id": "43a256e102773811", "server_versions": [ "4201-b04f7f8" ], "started_ts": "2019-03-17T02:40:11.813816", "state": "COMPLETED", "tags": [ "build_is_experimental:false", "buildername:fuchsia-fyi-x64-dbg", "buildnumber:5857", "cpu:x86-64", "data:0f82c87760abd67466884b0a4c126190688ae32b", "gpu:none", "kvm:1", "master:chromium.fyi", "name:cast_runner_integration_tests", "os:Ubuntu-14.04", "pool:Chrome", "priority:35", "project:chromium", "purpose:CI", "purpose:luci", "purpose:post-commit", "service_account:none", "slavename:swarm1860-c4", "spec_name:chromium.ci:fuchsia-fyi-x64-dbg", "stepname:cast_runner_integration_tests", "swarming.pool.template:none", "swarming.pool.version:84dc2e055f380db17943d027893da36f2780b31c", "user:None" ], "task_id": "43a256e102773810", "try_number": "1" } ] }