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-pb6z" ] }, { "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-pb6z", "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-18T12:20:54.590512", "cost_saved_usd": 0.011706150472639256, "created_ts": "2019-03-18T15:24:56.653814", "deduped_from": "43a98f55fcc5d311", "duration": 76.92802786827087, "modified_ts": "2019-03-18T15:24:56.667025", "name": "cronet_tests/Ubuntu-14.04/f40210c815/fuchsia-fyi-x64-dbg/5879", "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_cronet_tests --test-launcher-bot-mode --test-launcher-summary-output=/b/s/w/iov6Ah3x/output.json\n\n2019-03-18 05:19:37,701:INFO:root:Connecting to Fuchsia using SSH.\n2019-03-18 05:19:44,954:INFO:root:Connected!\n2019-03-18 05:19:44,954:INFO:root:Attaching kernel logger.\n[00000.000] zbi: @ 0xffffff8000a6a000 (9859064 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-f06654a350f387bb10b0cacb33f90aaba07a8f37-dirty\n[00000.000] \tELF build ID: 23c5e0f51c6dbc28cc446022f0cfcb98db30de88\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: 2199798 ticks/ms\n[00000.339] timer features: constant_tsc 1 invariant_tsc 1 tsc_deadline 1\n[00000.339] Using TSC as wallclock\n[00000.339] initializing kernel\n[00000.339] initializing mp\n[00000.339] initializing timers\n[00000.339] INIT: cpu 0, calling hook 0xffffffff0010f488 (global_prng_thread_safe) at level 0x7ffff, flags 0x1\n[00000.339] INIT: cpu 0, calling hook 0xffffffff0011b790 (debuglog) at level 0x7ffff, flags 0x1\n[00000.339] INIT: cpu 0, calling hook 0xffffffff001e5d10 (thread_set_priority_experiment) at level 0x7ffff, flags 0x1\n[00000.339] thread set priority experiment is : ENABLED\n[00000.339] creating bootstrap completion thread\n[00000.479] top of bootstrap2()\n[00000.479] INIT: cpu 0, calling hook 0xffffffff00127f70 (libobject) at level 0x80000, flags 0x1\n[00000.479] OOM: started thread\n[00000.486] INIT: cpu 0, calling hook 0xffffffff0019d880 (dpc) at level 0x80000, flags 0x1\n[00000.490] Processor Model Info: type 0 family 0x6 model 0xf stepping 0\n[00000.490] \tdisplay_family 0x6 display_model 0x4f\n[00000.490] Vendor: Intel\n[00000.490] Microarch: Broadwell\n[00000.490] F/M/S: 6/4f/0\n[00000.490] Brand: Intel(R) Xeon(R) CPU @ 2.20GHz\n[00000.490] Features: fpu sse sse2 sse3 ssse3 sse4.1 sse4.2 mmx avx avx2 fxsr pcid xsave aesni clflush\n[00000.490] fsgsbase tsc_adj smep smap erms rdrand rdseed syscall nx rdtscp invar_tsc tsc_deadline\n[00000.490] x2apic hypervisor\n[00000.490] initializing platform\n[00000.490] INIT: cpu 0, calling hook 0xffffffff0018deb4 (x86_perfmon) at level 0x90000, flags 0x1\n[00000.490] x86_perfmon_init_once:497: perfmon: unexpected programmable counter width 0 in cpuid.0AH\n[00000.491] UART: started IRQ driven RX\n[00000.491] UART: started IRQ driven TX\n[00000.491] cpu topology:\n[00000.491] \t0: apic id 0x0 package 0 node 0 core 0 smt 0 BSP\n[00000.491] \t1: apic id 0x1 package 1 node 0 core 0 smt 0\n[00000.491] \t2: apic id 0x2 package 2 node 0 core 0 smt 0\n[00000.491] \t3: apic id 0x3 package 3 node 0 core 0 smt 0\n[00000.491] Found 4 cpus\n[00000.491] booting apic ids: 0x1 0x2 0x3\n[00000.552] entering scheduler on cpu 2\n[00000.553] entering scheduler on cpu 3\n[00000.553] entering scheduler on cpu 1\n[00000.564] smbios: manufacturer=\"QEMU\" product=\"Standard PC (Q35 + ICH9, 2009)\"\n[00000.564] initializing target\n[00000.564] INIT: cpu 0, calling hook 0xffffffff00173bec (x86_pcie_init) at level 0xa0000, flags 0x1\n[00000.564] moving to last init level\n[00000.564] INIT: cpu 0, calling hook 0xffffffff00102a48 (kernel_shell) at level 0xc0000, flags 0x1\n[00000.564] INIT: cpu 0, calling hook 0xffffffff001fc0a8 (ktrace) at level 0xc0000, flags 0x1\n[00000.598] ktrace: buffer at 0xffffff9c680ef000 (33554432 bytes)\n[00000.598] INIT: cpu 0, calling hook 0xffffffff001fdfe8 (userboot) at level 0xc0000, flags 0x1\n[00000.598] userboot: ramdisk 0x967000 @ 0xffffff8000a6a000\n[00000.620] userboot: userboot rodata 0 @ [0x502da594c000,0x502da594f000)\n[00000.620] userboot: userboot code 0x3000 @ [0x502da594f000,0x502da595a000)\n[00000.620] userboot: vdso/full rodata 0 @ [0x502da595a000,0x502da5961000)\n[00000.620] userboot: vdso/full code 0x7000 @ [0x502da5961000,0x502da5962000)\n[00000.620] userboot: entry point @ 0x502da594fc90\n[00000.640] userboot: option \"/b/s/w/ir/third_party/fuchsia-sdk/sdk/target/x64/qemu-kernel.bin=\"\n[00000.640] userboot: option \"devmgr.epoch=1552911577\"\n[00000.640] userboot: option \"zircon.nodename=65ffaf67-fc6e-420b-8af6-079d57408f17\"\n[00000.640] userboot: option \"TERM=dumb\"\n[00000.640] userboot: option \"kernel.serial=legacy\"\n[00000.640] userboot: option \"multiboot.boot_loader_name=qemu\"\n[00000.666] userboot: searching bootfs for 'bin/bootsvc'\n[00000.666] userboot: 'bin/bootsvc' has PT_INTERP \"lib/ld.so.1\"\n[00000.666] userboot: searching bootfs for 'lib/ld.so.1'\n[00000.666] userboot: userboot: loaded lib/ld.so.1 at 0x610b5964e000, entry point 0x610b5968b2f1\n[00000.666] userboot: userboot: loaded vDSO at 0x73488708e000, entry point 0x0\n[00000.666] userboot: process bin/bootsvc started.\n[00000.666] userboot: waiting for loader-service requests...\n[00000.667] userboot: searching bootfs for 'lib/libasync-default.so'\n[00000.695] userboot: searching bootfs for 'lib/libfdio.so'\n[00000.695] userboot: searching bootfs for 'lib/libtrace-engine.so'\n[00000.696] userboot: searching bootfs for 'lib/liblaunchpad.so'\n[00000.706] {{{reset}}}\n[00000.706] {{{module:0:<application>:elf:64913060bc657fc459f4ab5301a5cb477104c184}}}\n[00000.706] {{{mmap:0x3fe204191000:0x39000:load:0:rx:0}}}\n[00000.706] {{{mmap:0x3fe2041ca000:0x4000:load:0:rw:0x39000}}}\n[00000.706] dso: id=64913060bc657fc459f4ab5301a5cb477104c184 base=0x00003fe204191000 name=<application>\n[00000.706] {{{module:0x2:<vDSO>:elf:5db6a550b7c22b4e5d9c55acc5bbc1d2583f0380}}}\n[00000.706] {{{mmap:0x73488708e000:0x7000:load:0x2:r:0}}}\n[00000.706] {{{mmap:0x734887095000:0x1000:load:0x2:rx:0x7000}}}\n[00000.706] dso: id=5db6a550b7c22b4e5d9c55acc5bbc1d2583f0380 base=0x000073488708e000 name=<vDSO>\n[00000.706] {{{module:0x3:libasync-default.so:elf:179378e0029e9d73bcaaf61330269def68f524f0}}}\n[00000.706] {{{mmap:0x585876835000:0x1000:load:0x3:rx:0}}}\n[00000.706] {{{mmap:0x585876836000:0x1000:load:0x3:rw:0x1000}}}\n[00000.706] dso: id=179378e0029e9d73bcaaf61330269def68f524f0 base=0x0000585876835000 name=libasync-default.so\n[00000.706] {{{module:0x1:libc.so:elf:608526d5035c0cab2fdd1718baca2d9ed1f3441b}}}\n[00000.706] {{{mmap:0x610b5964e000:0xcb000:load:0x1:rx:0}}}\n[00000.706] {{{mmap:0x610b5971a000:0x6000:load:0x1:rw:0xcc000}}}\n[00000.706] dso: id=608526d5035c0cab2fdd1718baca2d9ed1f3441b base=0x0000610b5964e000 name=libc.so\n[00000.706] {{{module:0x4:libfdio.so:elf:b8b2c5016c76236a2d5415d1063cfcebb8fb5101}}}\n[00000.706] {{{mmap:0x75594924f000:0x32000:load:0x4:rx:0}}}\n[00000.706] {{{mmap:0x755949282000:0x4000:load:0x4:rw:0x33000}}}\n[00000.706] dso: id=b8b2c5016c76236a2d5415d1063cfcebb8fb5101 base=0x000075594924f000 name=libfdio.so\n[00000.706] {{{module:0x5:libtrace-engine.so:elf:0f28e2222418dde22d6dd647ddb13d0d42ff310a}}}\n[00000.706] {{{mmap:0x2033e64e5000:0x9000:load:0x5:rx:0}}}\n[00000.706] {{{mmap:0x2033e64ee000:0x2000:load:0x5:rw:0x9000}}}\n[00000.706] dso: id=0f28e2222418dde22d6dd647ddb13d0d42ff310a base=0x00002033e64e5000 name=libtrace-engine.so\n[00000.706] {{{module:0x6:liblaunchpad.so:elf:7bbb5d72e7b50ffd31348f1fff0031cd559eaa75}}}\n[00000.706] {{{mmap:0x5be585c8b000:0x7000:load:0x6:rx:0}}}\n[00000.706] {{{mmap:0x5be585c92000:0x2000:load:0x6:rw:0x7000}}}\n[00000.706] dso: id=7bbb5d72e7b50ffd31348f1fff0031cd559eaa75 base=0x00005be585c8b000 name=liblaunchpad.so\n[00000.707] bootsvc: Starting...\n[00000.707] bootsvc: Creating bootfs service...\n[00000.707] userboot: loader-service channel peer closed\n[00000.707] userboot: finished!\n[00000.832] bootsvc: Processing bootdata...\n[00000.832] bootsvc: Loading boot cmdline overrides...\n[00000.832] bootsvc: Loading kernel VMOs...\n[00000.832] bootsvc: Creating loader service...\n[00000.832] bootsvc: Launching next process...\n[00000.833] bootsvc: launched bin/devcoordinator\n[00000.850] devcoordinator: main()\n[00000.851] devcoordinator: coordinator_init()\n[00000.851] devcoordinator: init\n[00000.851] devcoordinator: svc init\n[00000.852] devcoordinator: launch /boot/bin/svchost (svchost) OK\n[00000.852] devcoordinator: vfs init\n[00000.868] devcoordinator: launch /boot/bin/fshost (fshost) OK\n[00000.870] devcoordinator: shell startup\n[00000.873] fshost: started.\n[00000.878] devcoordinator: launch /boot/bin/netsvc (netsvc) OK\n[00000.885] devcoordinator: launch /boot/bin/pwrbtn-monitor (pwrbtn-monitor) OK\n[00000.895] devcoordinator: launch /boot/bin/virtual-console (virtual-console) OK\n[00000.920] devcoordinator: no driver info in '/boot/driver/mtk-power.so'\n[00000.937] devcoordinator: full system required, ignoring fallback drivers until /system is loaded\n[00000.943] devcoordinator: launch devhost 'devhost:sys': pid=2083\n[00000.947] devcoordinator: launch devhost 'devhost:test': pid=2129\n[00000.952] devhost: trace provider registry begun\n[00000.957] devcoordinator: launch devhost 'devhost:root': pid=2213\n[00000.965] devhost: trace provider registry begun\n[00000.972] devcoordinator: launch devhost 'devhost:misc': pid=2287\n[00000.979] devhost: trace provider registry begun\n[00000.984] devhost: trace provider registry begun\n[00000.990] GetZbiMetadata metadata not found for type 524f426d, extra 0\n[00001.003] devcoordinator: launch /boot/bin/sh (sh:console) OK\n[00001.011] acpi-bus: not using IOMMU\n[00001.013] GetHwProperties: No PM support\n[00001.013] IntelPT: No PT support\n[00001.013] devhost[sys/cpu-trace] bind driver '/boot/driver/cpu-trace.so' failed: -2\n[00001.014] devcoordinator: rpc: bind-driver 'cpu-trace' status -2\n[00001.014] [sysmem_init 28] async_get_default_dispatcher(): 0x72558aa140a0\n[00001.014] [sysmem_bind 40] sysmem_bind()\n[00001.015] acpi-pwrbtn: initialized\n[00001.025] vc: new input device /dev/class/input/000\n[00001.080] acpi: published device pci(0x71d32e1d9180), parent=sys(0x72558aa220c0), handle=0x72558aa1f300\n[00001.080] acpi: failed to get PCI base bus number for device 'PCI0' (status 4294967295)\n[00001.089] acpi: published device rtc(0x71d32e1d9200), parent=acpi(0x72558aa22300), handle=0x72558aa1f7b0\n[00001.096] acpi: published device i8042(0x71d32e1d9280), parent=acpi(0x72558aa22300), handle=0x72558aa1f840\n[00001.104] devcoordinator: launch devhost 'devhost:pci#1:1234:1111': pid=2781\n[00001.111] devhost: trace provider registry begun\n[00001.113] devcoordinator: launch devhost 'devhost:pci#2:1af4:1001': pid=2874\n[00001.120] devcoordinator: launch devhost 'devhost:pci#3:8086:100e': pid=2931\n[00001.134] devhost: trace provider registry begun\n[00001.138] devcoordinator: launch devhost 'devhost:pci#5:8086:2922': pid=3021\n[00001.145] devhost: WARNING: driver '/boot/driver/pc-ps2.so' did not add device in bind()\n[00001.145] devhost: trace provider registry begun\n[00001.155] devhost: trace provider registry begun\n[00001.157] ahci: using MSI interrupt\n[00001.161] i8042 device 0xab 0x41\n[00001.165] vc: new input device /dev/class/input/001\n[00001.171] bochs_vbe: initialized display, 1024 x 768 (stride=1024 format=00020001)\n[00001.177] vc: new display device /dev/class/display-controller/000/virtcon\n[00001.185] vc: Successfully attached to display 1\n[00001.219] fshost: /dev/class/block/000: FVM?\n[00001.239] devcoordinator: launch /boot/bin/blobfs (blobfs:/blob) OK\n[00001.306] i8042 device 0x00\n[00001.316] 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.327] vc: new input device /dev/class/input/002\n[00001.389] fshost: starting 'bin/pkgsvr' '991b7b9c21d69fa223ae98733f40cadfcb4cf2ef6900596fa39f889061bea000'...\n[00001.409] devcoordinator: launch bin/pkgsvr (pkgfs) OK\n[00001.443] pkgsvr: system: will be served from 991b7b9c21d69fa223ae98733f40cadfcb4cf2ef6900596fa39f889061bea000\n[00001.443] pkgsvr: pkgfs serving index /data/pkgfs_index from blobfs /blob\n[00001.466] fshost: mounting minfs\n[00001.481] devcoordinator: launch /boot/bin/minfs (minfs:/data) OK\n[00001.499] devcoordinator: adding system driver 'bt_hci_intel' '/system/driver/bt-hci-intel.so'\n[00001.500] devcoordinator: launch /system/bin/appmgr (appmgr) OK\n[00001.538] devcoordinator: adding system driver 'gpu' '/system/driver/libmsd_intel.so'\n[00001.549] devcoordinator: adding system driver 'wlan' '/system/driver/wlanif.so'\n[00001.576] devcoordinator: adding system driver 'qmi_usb' '/system/driver/qmi-transport.so'\n[00001.598] devcoordinator: adding system driver 'wlan' '/system/driver/wlanphy.so'\n[00001.613] devcoordinator: adding system driver 'bt_hci_atheros' '/system/driver/bt-hci-atheros.so'\n[00001.625] devcoordinator: adding system driver 'mt8167s_gpu' '/system/driver/libmsd_img_rgx_mtk.so'\n[00001.664] devcoordinator: adding system driver 'ralink' '/system/driver/ralink.so'\n[00001.676] devcoordinator: adding system driver 'bt_hog' '/system/driver/bt-hog.so'\n[00001.691] devcoordinator: adding system driver 'virtual_audio' '/system/driver/virtual_audio_driver.so'\n[00001.717] devcoordinator: adding system driver 'bt_host' '/system/driver/bt-host.so'\n[00001.733] devcoordinator: adding system driver 'usb_video' '/system/driver/usb_video.so'\n[00001.748] devcoordinator: adding system driver 'bt_hci_fake' '/system/driver/bt-hci-fake.so'\n[00001.766] devcoordinator: adding system driver 'bt_hci_passthrough' '/system/driver/bt-hci-passthrough.so'\n[00001.777] [INFO:namespace_builder.cc(93)] config-data for sysmgr\n[00001.786] devcoordinator: adding system driver 'qmi_fake' '/system/driver/qmi-fake.so'\n[00001.803] devcoordinator: adding system driver 'rtl88xx' '/system/driver/rtl88xx.so'\n[00001.849] devcoordinator: adding system driver 'wlan' '/system/driver/wlan.so'\n[00001.866] devcoordinator: adding system driver 'brcmfmac' '/system/driver/brcmfmac.so'\n[00001.879] devcoordinator: adding system driver 'ath10k_pci' '/system/driver/ath10k.so'\n[00001.897] devcoordinator: adding system driver 'wlantapctl' '/system/driver/wlantap.so'\n[00001.908] devcoordinator: driver 'ath10k_pci' added\n[00001.908] devcoordinator: driver 'brcmfmac' added\n[00001.908] devcoordinator: driver 'wlan' added\n[00001.908] devcoordinator: driver 'rtl88xx' added\n[00001.908] devcoordinator: driver 'qmi_fake' added\n[00001.908] devcoordinator: driver 'bt_hci_fake' added\n[00001.908] devcoordinator: driver 'usb_video' added\n[00001.908] devcoordinator: driver 'bt_host' added\n[00001.908] devcoordinator: driver 'bt_hog' added\n[00001.908] devcoordinator: driver 'ralink' added\n[00001.908] devcoordinator: driver 'mt8167s_gpu' added\n[00001.908] devcoordinator: driver 'bt_hci_atheros' added\n[00001.908] devcoordinator: driver 'wlan' added\n[00001.908] devcoordinator: driver 'qmi_usb' added\n[00001.908] devcoordinator: driver 'wlan' added\n[00001.908] devcoordinator: driver 'gpu' added\n[00001.908] devcoordinator: driver 'bt_hci_intel' added\n[00001.9initialized repo /b/s/w/itCIExQA/tmpE1hu14\nadding package cronet_tests/0\n2019/03/18 12:19:45 error removing source: Source not found\n2019-03-18 05:19:46,232:INFO:root:Installing cronet_tests version 0.\n2019/03/18 12:19:48 Awaiting response...\n2019/03/18 12:19:51 Awaiting response...\n2019/03/18 12:19:54 Awaiting response...\n2019/03/18 12:19:58 Awaiting response...\n2019/03/18 12:20:01 Awaiting response...\n2019/03/18 12:20:04 Awaiting response...\n2019/03/18 12:20:07 Awaiting response...\n2019/03/18 12:20:10 Awaiting response...\n2019/03/18 12:20:13 Awaiting response...\n2019/03/18 12:20:16 Awaiting response...\n2019/03/18 12:20:19 Awaiting response...\n2019/03/18 12:20:22 Awaiting response...\n2019/03/18 12:20:25 Awaiting response...\n2019/03/18 12:20:28 Awaiting response...\n2019/03/18 12:20:32 Awaiting response...\n2019/03/18 12:20:35 Awaiting response...\n2019/03/18 12:20:37 Success cronet_tests/0: 155558d06df7b871c652c18395ebe91f74e6ce74cb22f88ee8be1b576f721504\n2019-03-18 05:20:38,652:INFO:root:Running application.\n2019-03-18 05:20:38,654:INFO:root:Running \"/b/s/w/ir/third_party/fuchsia-sdk/sdk/tools/symbolize -ids /b/s/w/ir/out/Debug/gen/components/cronet/cronet_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\".\n08] devcoordinator: driver 'bt_hci_passthrough' added\n[00001.908] devcoordinator: fallback driver 'usb_composite' is available\n[00001.908] devcoordinator: driver 'usb_composite' added\n[00001.908] devcoordinator: fallback driver 'intel_disp' is available\n[00001.909] devcoordinator: driver 'intel_disp' added\n[00002.682] [INFO:cobalt_main.cc(145)] Cobalt client schedule params: schedule_interval=3600 seconds, min_interval=10 seconds, initial_interval=60 seconds.\n[00002.779] netifc: ? /dev/class/ethernet/000\n[00002.780] netifc: create 512 eth buffers\n[00002.781] macaddr: 52:54:00:63:5e:7b\n[00002.781] ip6addr: fe80::5054:4d:fe63:5e7b\n[00002.781] snmaddr: ff02::1:ff63:5e7b\n[00002.781] netsvc: using /dev/class/ethernet/000\n[00002.782] netsvc: nodename='65ffaf67-fc6e-420b-8af6-079d57408f17'\n[00002.782] netsvc: start\n[00002.877] [INFO:namespace_builder.cc(93)] config-data for wlancfg\n[00003.566] [INFO:namespace_builder.cc(93)] config-data for crashpad_agent\n[00003.775] [INFO:main.cc(35)] Trace Manager starting with config: /pkg/data/tracing.config\n[00003.842] wlanstack2 [I]: Starting\n[00004.016] [INFO:a11y_input_system.cc(9)] Scenic accessibility input system started.\n[00004.017] [INFO:display_watcher.cc(40)] Scenic: Acquired display controller /dev/class/display-controller/000.(000)\n[00004.257] [INFO:input_interpreter.cc(1006)] hid-parser succesful for 000 with usage page 1 and usage 128\n[00004.407] ERROR: setupLoaderTermPhysDevs: Failed to detect any valid GPUs in the current config\n[00004.407] ERROR: setupLoaderTrampPhysDevs: Failed during dispatch call of 'vkEnumeratePhysicalDevices' to lower layers or loader to get count.\n[00004.407] [ERROR:garnet/lib/ui/gfx/gfx_system.cc(188)] No Vulkan on device, Graphics system exiting.\n[00004.407] [INFO:input_system.cc(245)] Scenic input system initialized.\n[00004.429] [ERROR:garnet/bin/ui/view_manager/view_registry.cc(80)] Exiting due to scene manager connection error.\n[00004.429] [ERROR:garnet/bin/ui/root_presenter/app.cc(214)] Scenic died, destroying all presentations.\n[00004.457] [ERROR:garnet/bin/sysmgr/app.cc(166)] Singleton fuchsia-pkg://fuchsia.com/scenic#meta/scenic.cmx died\n[00004.464] [ERROR:garnet/bin/sysmgr/app.cc(166)] Singleton fuchsia-pkg://fuchsia.com/view_manager#meta/view_manager.cmx died\n[00004.821] Starting mDNS on interface ethp0003 192.168.3.9\n[00004.827] Starting mDNS on interface ethp0003 [80fe::5450:ff00:63fe:7b5e]\n[00004.833] [ERROR:garnet/bin/mdns/service/mdns_interface_transceiver_v6.cc(49)] Failed to set socket option IPV6_JOIN_GROUP, No such device\n[00004.839] mDNS: Verifying uniqueness of host name step-dime-yard-juicy.local.\n[00005.776] mDNS: Using unique host name step-dime-yard-juicy.local.\n[00008.825] pkgsvr: asking amber to fetch 2345 needed blobs\n[00060.715] pkgsvr: package activated cronet_tests/0 (155558d06df7b871c652c18395ebe91f74e6ce74cb22f88ee8be1b576f721504)\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/100] BufferTest.TestInitWithAlloc (19 ms)\n[2/100] BufferTest.TestInitWithDataAndCallback (1 ms)\n[3/100] BufferTest.TestCronetBufferAsync (0 ms)\n[4/100] EngineTest.StartCronetEngine (67 ms)\n[5/100] EngineTest.CronetEngineDefaultUserAgent (1 ms)\n[6/100] EngineTest.InitDifferentEngines (49 ms)\n[7/100] EngineTest.StartResults (63 ms)\n[8/100] EngineTest.InvalidPkpParams (0 ms)\n[9/100] EngineTest.ValidPkpParams (6 ms)\n[10/100] EngineTest.SetMockCertVerifierForTesting (17 ms)\n[11/100] EngineTest.StartNetLogToFile (126 ms)\n[12/100] ExecutorsTest.TestCustom (1 ms)\n[13/100] ExecutorsTest.TestTestExecutor (1 ms)\n[14/100] UrlRequestTest.UploadWithDirectExecutor (48 ms)\n[15/100] UrlRequestTest.InitChecks/0 (31 ms)\n[16/100] UrlRequestTest.InitChecks/1 (34 ms)\n[17/100] UrlRequestTest.SimpleGet/0 (81 ms)\n[18/100] UrlRequestTest.SimpleGet/1 (57 ms)\n[19/100] UrlRequestTest.UploadEmptyBodySync/0 (60 ms)\n[20/100] UrlRequestTest.UploadEmptyBodySync/1 (44 ms)\n[21/100] UrlRequestTest.UploadWithSetMethod/0 (117 ms)\n[22/100] UrlRequestTest.UploadWithSetMethod/1 (72 ms)\n[23/100] UrlRequestTest.UploadWithBigRead/0 (43 ms)\n[24/100] UrlRequestTest.UploadWithBigRead/1 (92 ms)\n[25/100] UrlRequestTest.UploadRedirectSync/0 (85 ms)\n[26/100] UrlRequestTest.UploadRedirectSync/1 (91 ms)\n[27/100] UrlRequestTest.UploadRedirectAsync/0 (74 ms)\n[28/100] UrlRequestTest.UploadRedirectAsync/1 (155 ms)\n[29/100] UrlRequestTest.UploadWithBadLength/0 (42 ms)\n[30/100] UrlRequestTest.UploadWithBadLength/1 (67 ms)\n[31/100] UrlRequestTest.UploadSync/0 (110 ms)\n[32/100] UrlRequestTest.UploadSync/1 (72 ms)\n[33/100] UrlRequestTest.SSLCertificateError/0 (108 ms)\n[34/100] UrlRequestTest.SSLCertificateError/1 (211 ms)\n[35/100] UrlRequestTest.UploadMultiplePiecesSync/0 (38 ms)\n[36/100] UrlRequestTest.UploadMultiplePiecesSync/1 (115 ms)\n[37/100] UrlRequestTest.UploadMultiplePiecesAsync/0 (129 ms)\n[38/100] UrlRequestTest.UploadMultiplePiecesAsync/1 (96 ms)\n[39/100] UrlRequestTest.UploadChangesDefaultMethod/0 (98 ms)\n[40/100] UrlRequestTest.UploadChangesDefaultMethod/1 (152 ms)\n[41/100] UrlRequestTest.UploadWithBadLengthBufferAligned/0 (340 ms)\n[42/100] UrlRequestTest.UploadWithBadLengthBufferAligned/1 (362 ms)\n[43/100] UrlRequestTest.UploadReadFailSync/0 (112 ms)\n[44/100] UrlRequestTest.UploadReadFailSync/1 (48 ms)\n[45/100] UrlRequestTest.UploadReadFailAsync/0 (41 ms)\n[46/100] UrlRequestTest.UploadReadFailAsync/1 (32 ms)\n[47/100] UrlRequestTest.UploadRewindFailSync/0 (65 ms)\n[48/100] UrlRequestTest.UploadRewindFailSync/1 (53 ms)\n[49/100] UrlRequestTest.UploadRewindFailAsync/0 (42 ms)\n[50/100] UrlRequestTest.UploadRewindFailAsync/1 (63 ms)\n[51/100] UrlRequestTest.UploadChunked/0 (120 ms)\n[52/100] UrlRequestTest.UploadChunked/1 (39 ms)\n[53/100] UrlRequestTest.UploadChunkedLastReadZeroLengthBody/0 (142 ms)\n[54/100] UrlRequestTest.UploadChunkedLastReadZeroLengthBody/1 (46 ms)\n[55/100] UrlRequestTest.UploadFailsWithoutInitializingStream/0 (38 ms)\n[56/100] UrlRequestTest.UploadFailsWithoutInitializingStream/1 (58 ms)\n[57/100] UrlRequestTest.SimpleRequest/0 (35 ms)\n[58/100] UrlRequestTest.SimpleRequest/1 (42 ms)\n[59/100] UrlRequestTest.MultiRedirect/0 (186 ms)\n[60/100] UrlRequestTest.MultiRedirect/1 (148 ms)\n[61/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StartExampleBidiStream/0 (149 ms)\n[62/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StartExampleBidiStream/1 (113 ms)\n[63/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePutWithEmptyWriteDataAtTheEnd/0 (122 ms)\n[64/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePutWithEmptyWriteDataAtTheEnd/1 (94 ms)\n[65/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimpleGetWithFlush/0 (65 ms)\n[66/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimpleGetWithFlush/1 (96 ms)\n[67/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlush/0 (79 ms)\n[68/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlush/1 (73 ms)\n[69/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushTwice/0 (99 ms)\n[70/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushTwice/1 (100 ms)\n[71/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushAfterOneWrite/0 (161 ms)\n[72/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.SimplePostWithFlushAfterOneWrite/1 (98 ms)\n[73/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.TestDelayedFlush/0 (100 ms)\n[74/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.TestDelayedFlush/1 (89 ms)\n[75/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnRead/0 (93 ms)\n[76/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStrea2019-03-18 05:20:52,744:INFO:root:Process exited normally with status code 0.\n2019-03-18 05:20:52,744:INFO:root:Terminating kernel log reader.\n2019-03-18 05:20:53,168:INFO:root:Shutting down QEMU.\nmTest.CancelOnRead/1 (142 ms)\n[77/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnResponse/0 (58 ms)\n[78/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnResponse/1 (55 ms)\n[79/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnSucceeded/0 (67 ms)\n[80/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.CancelOnSucceeded/1 (59 ms)\n[81/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.ReadFailsBeforeRequestStarted/0 (104 ms)\n[82/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.ReadFailsBeforeRequestStarted/1 (43 ms)\n[83/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.WriteFailsBeforeRequestStarted/0 (24 ms)\n[84/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.WriteFailsBeforeRequestStarted/1 (67 ms)\n[85/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailAfterStreamReadyCallback/0 (121 ms)\n[86/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailAfterStreamReadyCallback/1 (120 ms)\n[87/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeWriteIsExecutedOnNetworkThread/0 (59 ms)\n[88/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.StreamFailBeforeWriteIsExecutedOnNetworkThread/1 (82 ms)\n[89/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.FailedResolution/0 (32 ms)\n[90/100] BidirectionalStreamDelayRequestHeadersUntilFlush/BidirectionalStreamTest.FailedResolution/1 (39 ms)\n[91/100] UrlRequestTest.CancelRequest/0 (134 ms)\n[92/100] UrlRequestTest.CancelRequest/1 (67 ms)\n[93/100] UrlRequestTest.FailedRequestHostNotFound/0 (17 ms)\n[94/100] UrlRequestTest.FailedRequestHostNotFound/1 (29 ms)\n[95/100] UrlRequestTest.TestCancel/0 (720 ms)\n[96/100] UrlRequestTest.TestCancel/1 (750 ms)\n[97/100] UrlRequestTest.PerfTest/0 (4329 ms)\n[98/100] UrlRequestTest.PerfTest/1 (5814 ms)\n[99/100] UrlRequestTest.GetStatus/0 (13 ms)\n[100/100] UrlRequestTest.GetStatus/1 (14 ms)\nSUCCESS: all tests passed.\nTests took 13 seconds.\n", "outputs_ref": { "isolated": "a44d718900ec213526ab91c52157c3be5cc6091c", "isolatedserver": "https://isolateserver.appspot.com", "namespace": "default-gzip" }, "run_id": "43a98f55fcc5d311", "server_versions": [ "4201-b04f7f8" ], "started_ts": "2019-03-18T12:19:12.831446", "state": "COMPLETED", "tags": [ "build_is_experimental:false", "buildername:fuchsia-fyi-x64-dbg", "buildnumber:5879", "cpu:x86-64", "data:f40210c81526236cca4d0282eb0486ad50a517da", "gpu:none", "kvm:1", "master:chromium.fyi", "name:cronet_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:cronet_tests", "swarming.pool.template:none", "swarming.pool.version:84dc2e055f380db17943d027893da36f2780b31c", "user:None" ], "task_id": "43aa3963db22f010" } ] }