New issue
Advanced search Search tips
Note: Color blocks (like or ) mean that a user may not be available. Tooltip shows the reason.

Issue 775207 link

Starred by 2 users

Issue metadata

Status: Untriaged
Owner: ----
Cc:
EstimatedDays: ----
NextAction: 2019-07-09
OS: ----
Pri: 3
Type: Bug



Sign in to add a comment

Chrome crashes with R61-9765.84.0

Project Member Reported by mzhuo@chromium.org, Oct 16 2017

Issue description

Guado run R61-9765.84.0

What steps will reproduce the problem?
(1)
(2)
(3)

What is the expected result?
no crash

What happens instead?
chrome crash

crash files and log file are uploaded to https://drive.google.com/corp/drive/u/0/folders/0B8sYeJbsz9zKRTFjRlNUci0tbHM

Please use labels and text to provide additional information.


For graphics-related bugs, please copy/paste the contents of the about:gpu
page at the end of this report.
localhost ~ # grep -E "10-15T11:11|10-15T11:12" /var/log/messages.1 | grep -E "10-15T11:10|10-15T11:11|USB disconnect|ERR kernel|ERR cras|ERR Chrome|ERR"
2017-10-15T11:11:00.469669-07:00 ERR cras_server[8799]: hw_params: Input/output error: rate: 48000, ret_rate: 48000, channel: 1, format: 2
2017-10-15T11:11:00.469811-07:00 ERR cras_server[8799]: Init Hangouts Meet speakermic: USB Audio:2,0 failed, rc = -5
2017-10-15T11:11:00.470032-07:00 ERR kernel: [170672.391775] 20:1:1: usb_set_interface failed (-110)
2017-10-15T11:11:00.946155-07:00 INFO kernel: [170672.868280] usb 1-2: USB disconnect, device number 24
2017-10-15T11:11:00.946183-07:00 INFO kernel: [170672.868304] usb 1-2.1: USB disconnect, device number 25
2017-10-15T11:11:05.471630-07:00 ERR cras_server[8799]: hw_params: Input/output error: rate: 48000, ret_rate: 48000, channel: 2, format: 2
2017-10-15T11:11:05.472127-07:00 ERR kernel: [170677.397719] 20:2:1: usb_set_interface failed (-110)
2017-10-15T11:11:05.492934-07:00 ERR kernel: [170677.418473] [drm:udl_submit_urb] *ERROR* usb_submit_urb error ffffffed
2017-10-15T11:11:05.525971-07:00 ERR kernel: [170677.451689] [drm:udl_submit_urb] *ERROR* usb_submit_urb error ffffffed
2017-10-15T11:11:05.593954-07:00 ERR kernel: [170677.520179] [drm:udl_submit_urb] *ERROR* usb_submit_urb error ffffffed
2017-10-15T11:11:10.474702-07:00 ERR cras_server[8799]: hw_params: Input/output error: rate: 48000, ret_rate: 48000, channel: 2, format: 2
2017-10-15T11:11:10.474964-07:00 ERR kernel: [170682.404889] 20:2:1: usb_set_interface failed (-110)
2017-10-15T11:11:10.474864-07:00 ERR cras_server[8799]: Enable Hangouts Meet speakermic: USB Audio:2,0 failed, rc = -5
2017-10-15T11:11:10.474886-07:00 ERR cras_server[8799]: Init device retry failed
2017-10-15T11:11:10.482962-07:00 INFO kernel: [170682.412420] usb 1-2.3: USB disconnect, device number 26
2017-10-15T11:11:10.979571-07:00 ERR cras_server[8799]: fetch err: -32 for 2
2017-10-15T11:11:11.072936-07:00 ERR kernel: [170683.002838] [drm:udl_submit_urb] *ERROR* usb_submit_urb error ffffffed
2017-10-15T11:11:11.517712-07:00 NOTICE ag[11716]: autotest server[stack::get_video_state|get_video_by_name|run] -> ssh_run(ls /sys/class/video4linux/)
2017-10-15T11:11:11.573186-07:00 NOTICE ag[11719]: autotest server[stack::get_video_state|get_video_by_name|run] -> ssh_run(cat /sys/class/video4linux/video0/name)
2017-10-15T11:11:11.624736-07:00 NOTICE ag[11722]: autotest server[stack::get_video_state|get_video_by_name|run] -> ssh_run(cat /sys/class/video4linux/video1/name)
2017-10-15T11:11:11.678443-07:00 NOTICE ag[11725]: autotest server[stack::get_video_state|get_video_by_name|run] -> ssh_run(cat /sys/class/video4linux/video3/name)
2017-10-15T11:11:11.731550-07:00 NOTICE ag[11728]: autotest server[stack::get_video_state|get_video_by_name|run] -> ssh_run(cat /sys/class/video4linux/video4/name)
2017-10-15T11:11:11.792114-07:00 NOTICE ag[11731]: autotest server[stack::get_video_state|get_lsof4_video|run] -> ssh_run(lsof /dev/video3 | grep chrome)
2017-10-15T11:11:11.920126-07:00 NOTICE ag[11736]: autotest server[stack::_kernel_usb_sanity_test|_cmd_usb_devices|run] -> ssh_run(usb-devices)
2017-10-15T11:11:14.529020-07:00 ERR kernel: [170686.461592] [drm:udl_submit_urb] *ERROR* usb_submit_urb error ffffffed
2017-10-15T11:11:15.476878-07:00 ERR cras_server[8799]: hw_params: Input/output error: rate: 48000, ret_rate: 48000, channel: 2, format: 2
2017-10-15T11:11:15.477003-07:00 ERR kernel: [170687.411102] 20:2:1: usb_set_interface failed (-110)
2017-10-15T11:11:17.533963-07:00 INFO kernel: [170689.469028] [drm] wait for urb interrupted: ffffffc2 available: 4
2017-10-15T11:11:18.533970-07:00 INFO kernel: [170690.469836] [drm] wait for urb interrupted: ffffffc2 available: 4
2017-10-15T11:11:20.477550-07:00 ERR cras_server[8799]: hw_params: Input/output error: rate: 48000, ret_rate: 48000, channel: 2, format: 2
2017-10-15T11:11:20.477720-07:00 ERR cras_server[8799]: Init Hangouts Meet speakermic: USB Audio:2,0 failed, rc = -5
2017-10-15T11:11:20.477796-07:00 ERR cras_server[8799]: fetch err: -32 for 70001
2017-10-15T11:11:20.478201-07:00 ERR kernel: [170692.415777] 20:2:1: usb_set_interface failed (-110)
2017-10-15T11:11:20.491176-07:00 WARNING kernel: [170692.429163] udevd[11761]: Process '/opt/displaylink/udev.sh /dev usb-001-026-DisplayLink_MIMO_VUE_HD_MXACP17040058 /dev/bus/usb/001/026' failed with exit code 1.
2017-10-15T11:11:20.738964-07:00 INFO kernel: [170692.676936] usb 1-2: new high-speed USB device number 27 using xhci_hcd
2017-10-15T11:11:20.902970-07:00 INFO kernel: [170692.841023] usb 1-2: New USB device found, idVendor=058f, idProduct=6254
2017-10-15T11:11:20.902996-07:00 INFO kernel: [170692.841048] usb 1-2: New USB device strings: Mfr=0, Product=0, SerialNumber=0
2017-10-15T11:11:25.480972-07:00 ERR kernel: [170697.422788] 20:2:1: usb_set_interface failed (-110)
2017-10-15T11:11:25.481000-07:00 INFO kernel: [170697.423369] hub 1-2:1.0: USB hub found
2017-10-15T11:11:25.480502-07:00 ERR cras_server[8799]: hw_params: Input/output error: rate: 48000, ret_rate: 48000, channel: 2, format: 2
2017-10-15T11:11:25.481968-07:00 INFO kernel: [170697.424129] hub 1-2:1.0: 4 ports detected
2017-10-15T11:11:28.697960-07:00 ERR kernel: [170700.642556] go2001 0000:03:00.0: go2001_dec_g_fmt_cap:1579 Frame info not available yet
2017-10-15T11:11:30.481521-07:00 ERR cras_server[8799]: hw_params: Input/output error: rate: 48000, ret_rate: 48000, channel: 2, format: 2
2017-10-15T11:11:30.481658-07:00 ERR cras_server[8799]: Init Hangouts Meet speakermic: USB Audio:2,0 failed, rc = -5
2017-10-15T11:11:30.482689-07:00 ERR kernel: [170702.427890] 20:2:1: usb_set_interface failed (-110)
2017-10-15T11:11:30.656959-07:00 INFO kernel: [170702.603199] usb 1-2.1: new full-speed USB device number 28 using xhci_hcd
2017-10-15T11:11:30.741951-07:00 INFO kernel: [170702.688606] usb 1-2.1: not running at top speed; connect to a high speed hub
2017-10-15T11:11:30.755941-07:00 INFO kernel: [170702.701863] usb 1-2.1: New USB device found, idVendor=266e, idProduct=0110
2017-10-15T11:11:30.755955-07:00 INFO kernel: [170702.701877] usb 1-2.1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
2017-10-15T11:11:30.755957-07:00 INFO kernel: [170702.701887] usb 1-2.1: Product: SiS HID Touch Controller
2017-10-15T11:11:30.755958-07:00 INFO kernel: [170702.701895] usb 1-2.1: Manufacturer: USBest Technology
2017-10-15T11:11:31.382145-07:00 NOTICE ag[12262]: autotest server[stack::_install|path_exists|run] -> ssh_run(test -e "/tmp/sysinfo/autoserv-KIWHlU")
2017-10-15T11:11:31.444294-07:00 NOTICE ag[12264]: autotest server[stack::_install|path_exists|run] -> ssh_run(test -e "/tmp/autoserv-0AVerU")
2017-10-15T11:11:31.505601-07:00 NOTICE ag[12266]: autotest server[stack::wrapper|erase_dir_contents|run] -> ssh_run(find "/tmp/autoserv-0AVerU" -mindepth 1 -maxdepth 1 -print0 | xargs -0 rm -rf)
2017-10-15T11:11:31.549342-07:00 ERR cras_server[8799]: fetch err: -32 for 90000
2017-10-15T11:11:31.630451-07:00 NOTICE ag[12273]: autotest server[stack::is_up|ssh_ping|run] -> ssh_run(true)
2017-10-15T11:11:31.689801-07:00 NOTICE ag[12275]: autotest server[stack::_do_run|verify_machine|run] -> ssh_run(ls /tmp/sysinfo/autoserv-KIWHlU/bin/autotest > /dev/null 2>&1)
2017-10-15T11:11:31.751164-07:00 NOTICE ag[12278]: autotest server[stack::_do_run|verify_machine|run] -> ssh_run(umount /tmp/sysinfo/autoserv-KIWHlU/tmp)
2017-10-15T11:11:31.814901-07:00 NOTICE ag[12281]: autotest server[stack::_do_run|verify_machine|run] -> ssh_run(umount /tmp/sysinfo/autoserv-KIWHlU/tests/download)
2017-10-15T11:11:31.878990-07:00 NOTICE ag[12284]: autotest server[stack::run|_do_run|run] -> ssh_run(rm -f /tmp/sysinfo/autoserv-KIWHlU/control.autoserv;rm -f /tmp/sysinfo/autoserv-KIWHlU/control.autoserv.state;rm -f /tmp/sysinfo/autoserv-KIWHlU/control;rm -f /tmp/sysinfo/autoserv-KIWHlU/control.state)
2017-10-15T11:11:32.057016-07:00 NOTICE ag[12294]: autotest server[stack::execute_control|get_boot_id|run] -> ssh_run(if [ -f '/proc/sys/kernel/random/boot_id' ]; then cat '/proc/sys/kernel/random/boot_id'; else echo 'no boot_id available'; fi)
2017-10-15T11:11:32.120060-07:00 NOTICE ag[12297]: autotest server[stack::_execute_daemon|get_tmp_dir|run] -> ssh_run(mkdir -p /tmp)
2017-10-15T11:11:32.185200-07:00 NOTICE ag[12300]: autotest server[stack::_execute_daemon|get_tmp_dir|run] -> ssh_run(mktemp -d /tmp/autoserv-XXXXXX)
2017-10-15T11:11:32.302717-07:00 NOTICE ag[12305]: autotest server[stack::execute_section|_execute_daemon|run] -> ssh_run(nohup /tmp/sysinfo/autoserv-KIWHlU/bin/autotestd /tmp/autoserv-Evkc8Y -H autoserv --verbose --hostname=100.107.146.16 --user=autotest_system /tmp/sysinfo/autoserv-KIWHlU/control.autoserv >/dev/null 2>/dev/null &)
2017-10-15T11:11:32.358736-07:00 NOTICE ag[12310]: autotest server[stack::execute_section|_execute_daemon|run] -> ssh_run(/tmp/sysinfo/autoserv-KIWHlU/bin/autotestd_monitor /tmp/autoserv-Evkc8Y 0 0)
2017-10-15T11:11:32.623078-07:00 NOTICE ag[12359]: autotest server[stack::write|_process_line|run] -> ssh_run(echo B > /tmp/sysinfo/autoserv-KIWHlU/tmp/_autotmp_bGGNebharness-fifo/autoserv.fifo)
2017-10-15T11:11:32.666639-07:00 NOTICE root[12365]: autotest finished iteration /tmp/autoserv-0AVerU/sysinfo/iteration.1
2017-10-15T11:11:34.787427-07:00 NOTICE ag[12371]: autotest server[stack::is_up|ssh_ping|run] -> ssh_run(true)
2017-10-15T11:11:34.848332-07:00 NOTICE ag[12373]: autotest server[stack::collect_client_job_results|run_on_client|run] -> ssh_run(/usr/local/autotest/result_tools/utils.py -p /tmp/sysinfo/autoserv-KIWHlU/results/default )
2017-10-15T11:11:35.320762-07:00 NOTICE ag[12378]: autotest server[stack::_install|path_exists|run] -> ssh_run(test -e "/tmp/sysinfo/autoserv-KIWHlU")
2017-10-15T11:11:35.379467-07:00 NOTICE ag[12380]: autotest server[stack::_install|path_exists|run] -> ssh_run(test -e "/tmp/autoserv-0AVerU")
2017-10-15T11:11:35.436124-07:00 NOTICE ag[12382]: autotest server[stack::wrapper|erase_dir_contents|run] -> ssh_run(find "/tmp/autoserv-0AVerU" -mindepth 1 -maxdepth 1 -print0 | xargs -0 rm -rf)
2017-10-15T11:11:35.483542-07:00 ERR cras_server[8799]: hw_params: Input/output error: rate: 48000, ret_rate: 48000, channel: 1, format: 2
2017-10-15T11:11:35.483989-07:00 ERR kernel: [170707.433923] 20:1:1: usb_set_interface failed (-110)
2017-10-15T11:11:35.501991-07:00 INFO kernel: [170707.452376] input: USBest Technology SiS HID Touch Controller as /devices/pci0000:00/0000:00:14.0/usb1/1-2/1-2.1/1-2.1:1.0/0003:266E:0110.0032/input/input101
2017-10-15T11:11:35.559263-07:00 NOTICE ag[12389]: autotest server[stack::is_up|ssh_ping|run] -> ssh_run(true)
2017-10-15T11:11:35.621485-07:00 NOTICE ag[12391]: autotest server[stack::_do_run|verify_machine|run] -> ssh_run(ls /tmp/sysinfo/autoserv-KIWHlU/bin/autotest > /dev/null 2>&1)
2017-10-15T11:11:35.682872-07:00 NOTICE ag[12394]: autotest server[stack::_do_run|verify_machine|run] -> ssh_run(umount /tmp/sysinfo/autoserv-KIWHlU/tmp)
2017-10-15T11:11:35.745026-07:00 NOTICE ag[12397]: autotest server[stack::_do_run|verify_machine|run] -> ssh_run(umount /tmp/sysinfo/autoserv-KIWHlU/tests/download)
2017-10-15T11:11:35.810146-07:00 NOTICE ag[12400]: autotest server[stack::run|_do_run|run] -> ssh_run(rm -f /tmp/sysinfo/autoserv-KIWHlU/control.autoserv;rm -f /tmp/sysinfo/autoserv-KIWHlU/control.autoserv.state;rm -f /tmp/sysinfo/autoserv-KIWHlU/control;rm -f /tmp/sysinfo/autoserv-KIWHlU/control.state)
2017-10-15T11:11:35.982191-07:00 NOTICE ag[12410]: autotest server[stack::execute_control|get_boot_id|run] -> ssh_run(if [ -f '/proc/sys/kernel/random/boot_id' ]; then cat '/proc/sys/kernel/random/boot_id'; else echo 'no boot_id available'; fi)
2017-10-15T11:11:36.045495-07:00 NOTICE ag[12413]: autotest server[stack::_execute_daemon|get_tmp_dir|run] -> ssh_run(mkdir -p /tmp)
2017-10-15T11:11:36.106673-07:00 NOTICE ag[12416]: autotest server[stack::_execute_daemon|get_tmp_dir|run] -> ssh_run(mktemp -d /tmp/autoserv-XXXXXX)
2017-10-15T11:11:36.228794-07:00 NOTICE ag[12421]: autotest server[stack::execute_section|_execute_daemon|run] -> ssh_run(nohup /tmp/sysinfo/autoserv-KIWHlU/bin/autotestd /tmp/autoserv-cSO11l -H autoserv --verbose --hostname=100.107.146.16 --user=autotest_system /tmp/sysinfo/autoserv-KIWHlU/control.autoserv >/dev/null 2>/dev/null &)
2017-10-15T11:11:36.282770-07:00 NOTICE ag[12426]: autotest server[stack::execute_section|_execute_daemon|run] -> ssh_run(/tmp/sysinfo/autoserv-KIWHlU/bin/autotestd_monitor /tmp/autoserv-cSO11l 0 0)
2017-10-15T11:11:36.619006-07:00 NOTICE ag[12475]: autotest server[stack::write|_process_line|run] -> ssh_run(echo B > /tmp/sysinfo/autoserv-KIWHlU/tmp/_autotmp_Iut0sCharness-fifo/autoserv.fifo)
2017-10-15T11:11:36.869976-07:00 INFO kernel: [170708.820748] tpm_tis tpm_tis: command 0x65 (size 20) returned code 0x0
2017-10-15T11:11:36.899991-07:00 INFO kernel: [170708.850750] tpm_tis tpm_tis: command 0x65 (size 22) returned code 0x0
2017-10-15T11:11:36.929974-07:00 INFO kernel: [170708.881146] tpm_tis tpm_tis: command 0x65 (size 22) returned code 0x0
2017-10-15T11:11:36.954968-07:00 INFO kernel: [170708.905863] tpm_tis tpm_tis: command 0x15 (size 14) returned code 0x0
2017-10-15T11:11:36.981000-07:00 INFO kernel: [170708.931872] tpm_tis tpm_tis: command 0x15 (size 14) returned code 0x0
2017-10-15T11:11:39.176972-07:00 INFO kernel: [170711.129676] hid-multitouch 0003:266E:0110.0032: input,hiddev0,hidraw0: USB HID v1.11 Device [USBest Technology SiS HID Touch Controller] on usb-0000:00:14.0-2.1/input0
2017-10-15T11:11:40.484609-07:00 ERR cras_server[8799]: hw_params: Input/output error: rate: 48000, ret_rate: 48000, channel: 1, format: 2
2017-10-15T11:11:40.484973-07:00 ERR kernel: [170712.438969] 20:1:1: usb_set_interface failed (-110)
2017-10-15T11:11:40.484794-07:00 ERR cras_server[8799]: Enable Hangouts Meet speakermic: USB Audio:2,0 failed, rc = -5
2017-10-15T11:11:40.484816-07:00 ERR cras_server[8799]: Init device retry failed
2017-10-15T11:11:40.499906-07:00 INFO minijail0[12520]: libminijail[12520]: not running init loop, exiting immediately
2017-10-15T11:11:40.523213-07:00 INFO sis-updater[12526]: -----
2017-10-15T11:11:40.523277-07:00 INFO sis-updater[12526]: Only detect hidraw
2017-10-15T11:11:40.523312-07:00 INFO sis-updater[12526]: invalid input device name
2017-10-15T11:11:40.526783-07:00 INFO sis-updater[12526]: [check HID: /dev/hidraw0]
2017-10-15T11:11:40.558937-07:00 INFO kernel: [170712.512666] usb 1-2.3: new high-speed USB device number 29 using xhci_hcd
2017-10-15T11:11:40.646214-07:00 INFO kernel: [170712.600330] usb 1-2.3: New USB device found, idVendor=17e9, idProduct=016b
2017-10-15T11:11:40.646241-07:00 INFO kernel: [170712.600355] usb 1-2.3: New USB device strings: Mfr=1, Product=2, SerialNumber=3
2017-10-15T11:11:40.646245-07:00 INFO kernel: [170712.600373] usb 1-2.3: Product: MIMO VUE HD
2017-10-15T11:11:40.646248-07:00 INFO kernel: [170712.600386] usb 1-2.3: Manufacturer: DisplayLink
2017-10-15T11:11:40.646251-07:00 INFO kernel: [170712.600398] usb 1-2.3: SerialNumber: MXACP17040058
2017-10-15T11:11:41.303080-07:00 NOTICE ag[12534]: autotest server[stack::is_up|ssh_ping|run] -> ssh_run(true)
2017-10-15T11:11:41.364276-07:00 NOTICE ag[12536]: autotest server[stack::collect_client_job_results|run_on_client|run] -> ssh_run(/usr/local/autotest/result_tools/utils.py -p /tmp/sysinfo/autoserv-KIWHlU/results/default )
2017-10-15T11:11:44.185993-07:00 INFO sis-updater[12526]: [rawName=USBest Technology SiS HID Touch Controller]
2017-10-15T11:11:44.186007-07:00 INFO sis-updater[12526]: [vid=0x266e]
2017-10-15T11:11:44.186044-07:00 INFO sis-updater[12526]: find activeDeviceName=/dev/hidraw0
2017-10-15T11:11:44.186050-07:00 INFO sis-updater[12526]: con=8
2017-10-15T11:11:44.186060-07:00 INFO sis-updater[12526]: multi..
2017-10-15T11:11:44.186066-07:00 INFO sis-updater[12526]: opening firmware bin: /lib/firmware/sis/WYD_101_WYD_9255_A353_V03.bin
2017-10-15T11:11:44.186089-07:00 INFO sis-updater[12526]: Pattern file contains 65440 bytes
2017-10-15T11:11:44.186112-07:00 INFO sis-updater[12526]: sis_usb_stop: devName = /dev/hidraw0#012
2017-10-15T11:11:44.574684-07:00 NOTICE ag[12542]: autotest server[stack::cleanup|uninstall|run] -> ssh_run(rm -rf /tmp/sysinfo/autoserv-KIWHlU)
2017-10-15T11:11:44.654059-07:00 NOTICE ag[12545]: autotest server[stack::close|close|run] -> ssh_run(rm -rf "/tmp/sysinfo/autoserv-KIWHlU")
2017-10-15T11:11:44.718396-07:00 NOTICE ag[12548]: autotest server[stack::close|close|run] -> ssh_run(rm -rf "/tmp/autoserv-0AVerU")
2017-10-15T11:11:44.821582-07:00 NOTICE ag[12551]: autotest server[stack::close|close|run] -> ssh_run(rm -rf "/tmp/autoserv-QzkHw9")
2017-10-15T11:11:44.882773-07:00 NOTICE ag[12554]: autotest server[stack::close|close|run] -> ssh_run(rm -rf "/tmp/autoserv-uzF9fc")
2017-10-15T11:11:44.940413-07:00 NOTICE ag[12557]: autotest server[stack::close|close|run] -> ssh_run(rm -rf "/tmp/autoserv-Evkc8Y")
2017-10-15T11:11:45.001542-07:00 NOTICE ag[12560]: autotest server[stack::close|close|run] -> ssh_run(rm -rf "/tmp/autoserv-cSO11l")
2017-10-15T11:11:45.065716-07:00 NOTICE ag[12563]: autotest server[stack::__del__|disconnect|run] -> ssh_run(pkill -f 'multimedia_xmlrpc_server')
2017-10-15T11:11:45.152403-07:00 NOTICE ag[12566]: autotest server[stack::__del__|disconnect|run] -> ssh_run(pgrep -f 'multimedia_xmlrpc_server')
2017-10-15T11:11:45.177026-07:00 INFO sshd[8676]: Received disconnect from 100.123.202.88 port 42074:11: disconnected by user
2017-10-15T11:11:45.177080-07:00 INFO sshd[8676]: Disconnected from 100.123.202.88 port 42074
2017-10-15T11:11:45.266036-07:00 NOTICE ag[12569]: autotest server[stack::_detect_host|check_host|run] -> ssh_run(grep -q CHROMEOS /etc/lsb-release && ! test -f /mnt/stateful_partition/.android_tester && ! grep -q moblab /etc/lsb-release)
2017-10-15T11:11:45.324629-07:00 NOTICE ag[12573]: autotest server[stack::_detect_host|check_host|run] -> ssh_run(grep CHROMEOS_RELEASE_BOARD /etc/lsb-release)
2017-10-15T11:11:45.486585-07:00 ERR cras_server[8799]: hw_params: Input/output error: rate: 48000, ret_rate: 48000, channel: 2, format: 2
2017-10-15T11:11:45.486957-07:00 ERR kernel: [170717.445049] 20:2:1: usb_set_interface failed (-110)
2017-10-15T11:11:47.444616-07:00 NOTICE ag[12614]: autotest server[stack::_find_orphaned_crashdumps|list_files_glob|run] -> ssh_run(python -c 'import cPickle, glob, sys;cPickle.dump(glob.glob(sys.argv[1]), sys.stdout, 0)')
2017-10-15T11:11:47.568180-07:00 NOTICE ag[12617]: autotest server[stack::_detect_host|check_host|run] -> ssh_run(grep -q CHROMEOS /etc/lsb-release && ! test -f /mnt/stateful_partition/.android_tester && ! grep -q moblab /etc/lsb-release)
2017-10-15T11:11:47.631678-07:00 NOTICE ag[12621]: autotest server[stack::_detect_host|check_host|run] -> ssh_run(grep CHROMEOS_RELEASE_BOARD /etc/lsb-release)
2017-10-15T11:11:47.753330-07:00 NOTICE ag[12624]: autotest server[stack::parallel_simple|get_network_stats|run] -> ssh_run(route; echo SEPARATOR; cat /proc/net/dev)
2017-10-15T11:11:47.802572-07:00 INFO sshd[5991]: Received disconnect from 100.123.202.88 port 42042:11: disconnected by user
2017-10-15T11:11:47.802656-07:00 INFO sshd[5991]: Disconnected from 100.123.202.88 port 42042
2017-10-15T11:11:50.489064-07:00 ERR kernel: [170722.451483] 20:2:1: usb_set_interface failed (-110)
2017-10-15T11:11:50.489011-07:00 ERR cras_server[8799]: hw_params: Input/output error: rate: 48000, ret_rate: 48000, channel: 2, format: 2
2017-10-15T11:11:50.489212-07:00 ERR cras_server[8799]: Enable Hangouts Meet speakermic: USB Audio:2,0 failed, rc = -5
2017-10-15T11:11:50.489235-07:00 ERR cras_server[8799]: Init device retry failed
2017-10-15T11:11:50.490277-07:00 INFO kernel: [170722.452156] [drm] vendor descriptor length:17 data:17 5f 01 00 15 05 00 01 03 00 04
2017-10-15T11:11:50.575956-07:00 INFO kernel: [170722.538224] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
2017-10-15T11:11:50.575984-07:00 INFO kernel: [170722.538250] [drm] No driver support for vblank timestamp query.
2017-10-15T11:11:50.575989-07:00 INFO kernel: [170722.538268] [drm] Initialized udl 0.0.1 20120220 on minor 2
2017-10-15T11:11:50.664963-07:00 WARNING kernel: [170722.627117] init: debugd main process (9369) killed by KILL signal
2017-10-15T11:11:50.665090-07:00 INFO session_manager[9255]: [INFO:browser_job.cc(157)] Terminating process: 
2017-10-15T11:11:50.665222-07:00 INFO session_manager[9255]: [INFO:system_utils_impl.cc(111)] Sending 15 to 9396 as 1000
2017-10-15T11:11:50.698493-07:00 ERR chrome[9396]: [9396:9396:1015/111150.698448:INFO:remote_commands_invalidator.cc(45)] Shutdown RemoteCommandsInvalidator.
2017-10-15T11:11:50.698589-07:00 ERR chrome[9396]: [9396:9396:1015/111150.698573:INFO:remote_commands_invalidator.cc(68)] Stopping RemoteCommandsInvalidator.
2017-10-15T11:11:50.698632-07:00 ERR chrome[9396]: [9396:9396:1015/111150.698619:INFO:remote_commands_invalidator.cc(167)] Unregister RemoteCommandsInvalidator.
2017-10-15T11:11:54.210080-07:00 INFO sis-updater[12526]: fw boot flag: 
2017-10-15T11:11:54.210113-07:00 INFO sis-updater[12526]: 50383130
2017-10-15T11:11:55.492354-07:00 ERR kernel: [170727.458196] 20:2:1: usb_set_interface failed (-110)
2017-10-15T11:11:55.491734-07:00 ERR cras_server[8799]: hw_params: Input/output error: rate: 48000, ret_rate: 48000, channel: 2, format: 2
2017-10-15T11:11:55.498359-07:00 INFO minijail0[12633]: libminijail[12633]: not running init loop, exiting immediately
2017-10-15T11:11:59.218817-07:00 INFO sis-updater[12526]: sis_usb_stop: devName = /dev/hidraw0#012
2017-10-15T11:12:00.492782-07:00 ERR cras_server[8799]: hw_params: Input/output error: rate: 48000, ret_rate: 48000, channel: 2, format: 2
2017-10-15T11:12:00.493040-07:00 ERR cras_server[8799]: Init Hangouts Meet speakermic: USB Audio:2,0 failed, rc = -5
2017-10-15T11:12:00.493562-07:00 ERR kernel: [170732.463372] 20:2:1: usb_set_interface failed (-110)
2017-10-15T11:12:00.605088-07:00 ERR crash_reporter[12641]: Could not create /var/spool/crash/chrome.20171015.111200.9396.chrome.txt: Permission denied
2017-10-15T11:12:00.606061-07:00 ERR crash_reporter[12640]: Failed to call method: org.chromium.debugd.GetLog: object_path= /org/chromium/debugd: org.freedesktop.DBus.Error.ServiceUnknown: The name org.chromium.debugd was not provided by any .service files
2017-10-15T11:12:00.606088-07:00 ERR crash_reporter[12640]: CallMethodAndBlockWithTimeout(...): Domain=dbus, Code=org.freedesktop.DBus.Error.ServiceUnknown, Message=The name org.chromium.debugd was not provided by any .service files
2017-10-15T11:12:00.606109-07:00 ERR crash_reporter[12640]: Error calling D-Bus proxy call to interface '/org/chromium/debugd':The name org.chromium.debugd was not provided by any .service files
2017-10-15T11:12:00.606373-07:00 ERR crash_reporter[12640]: Unable to write /var/spool/crash/chrome.20171015.111200.9396.meta
2017-10-15T11:12:00.675078-07:00 ERR crash_reporter[12645]: Could not create /var/spool/crash/chrome.20171015.111200.9396.chrome.txt: Permission denied
2017-10-15T11:12:00.675861-07:00 ERR crash_reporter[12644]: Failed to call method: org.chromium.debugd.GetLog: object_path= /org/chromium/debugd: org.freedesktop.DBus.Error.ServiceUnknown: The name org.chromium.debugd was not provided by any .service files
2017-10-15T11:12:00.675884-07:00 ERR crash_reporter[12644]: CallMethodAndBlockWithTimeout(...): Domain=dbus, Code=org.freedesktop.DBus.Error.ServiceUnknown, Message=The name org.chromium.debugd was not provided by any .service files
2017-10-15T11:12:00.675906-07:00 ERR crash_reporter[12644]: Error calling D-Bus proxy call to interface '/org/chromium/debugd':The name org.chromium.debugd was not provided by any .service files
2017-10-15T11:12:00.676126-07:00 ERR crash_reporter[12644]: Unable to write /var/spool/crash/chrome.20171015.111200.9396.meta
2017-10-15T11:12:01.195435-07:00 ERR cras_server[8799]: fetch err: -32 for a0000
2017-10-15T11:12:04.430249-07:00 ERR imageloader[12769]: Failed to read latest-version file.
2017-10-15T11:12:04.430269-07:00 ERR imageloader[12769]: Failed to verify and mount component.
localhost ~ # ls -altr /var/spool/crash
total 485356
drwxr-xr-x 5 root root      4096 Oct 11 14:11 ..
-rw-r--r-- 1 root root     15262 Oct 15 11:12 chrome.20171015.111200.9396.log
-rw-r--r-- 1 root root 496496640 Oct 15 11:12 chrome.20171015.111200.9396.core
-rw-r--r-- 1 root root       168 Oct 15 11:12 chrome.20171015.111200.9396.meta
-rw------- 1 root root    472784 Oct 15 11:12 chrome.20171015.111200.9396.dmp
drwxr-xr-t 2 root root      4096 Oct 16 12:42 .
localhost ~ # 


 

Comment 1 by mzhuo@chromium.org, Oct 25 2017

Hit chrome crash on 100.107.146.14 running R61-9765.86.0. pls see debug file and core file at https://drive.google.com/corp/drive/u/0/folders/1tR6PTibtjjoVM2CJ9ZJo651MVPRr4AUw

localhost chrome # ls -altr /var/spool/crash
total 265468
drwxr-xr-x 5 root root      4096 Oct 19 23:11 ..
-rw-r--r-- 1 root root     13229 Oct 25 14:37 chrome.20171025.143737.18127.log
-rw-r--r-- 1 root root 271540224 Oct 25 14:37 chrome.20171025.143737.18127.core
-rw------- 1 root root    265880 Oct 25 14:37 chrome.20171025.143737.18127.dmp
-rw-r--r-- 1 root root       170 Oct 25 14:37 chrome.20171025.143737.18127.meta
drwxr-xr-t 2 root root      4096 Oct 25 15:09 .
localhost chrome # vi chrome
localhost chrome # generate_logs 
[1025/151624:INFO:generate_logs.cc(86)] Gathering logs, please wait
[1025/151628:INFO:generate_logs.cc(91)] Logs saved to /tmp/debug-logs_20171025-151624.tgz
localhost chrome # exit

Comment 2 by egemih@chromium.org, Oct 26 2017

The stacktrace of the crash in comment#1 is attached. The segfault that occurs seems to be very generic and the consensus on crash/ seems to be that the stacktrace is not trustworthy enough to begin with. Keeping this bug open to keep an eye out on segfaults stemming from v4l2_video_decode_accelerator.cc. As of now, this bug does not seem very actionable. 

Comment 3 by egemih@chromium.org, Oct 26 2017

Forgot to attach. Here is the attachment referred to in comment#2.
trace.txt
72.4 KB View Download

Comment 4 by tovep@chromium.org, Nov 1 2017

Labels: hotrod-platfrom-tracking
Owner: tovep@chromium.org
Status: Assigned (was: Untriaged)

Comment 5 by tovep@chromium.org, Nov 7 2017

Cc: sadolfsson@chromium.org
Hmm, I got a stack trace starting with:

#0  0x0000600cf9e6b58e in (anonymous namespace)::CrasAudioHandler::Get () at ../../../../../../../home/chrome-bot/chrome_root/src/chromeos/audio/cras_audio_handler.cc:135
#1  0x0000600cf7b31e9e in (anonymous namespace)::AudioManagerCras::GetDefaultOutputDeviceID (this=0x24823ff20b60)
    at ../../../../../../../home/chrome-bot/chrome_root/src/media/audio/cras/audio_manager_cras.cc:310
#2  0x0000600cf7b1c52b in (anonymous namespace)::AudioManagerBase::GetDefaultOutputStreamParameters (this=0x24823ff20b60)
    at ../../../../../../../home/chrome-bot/chrome_root/src/media/audio/audio_manager_base.cc:397
#3  0x0000600cf7b2471b in (anonymous namespace)::AudioSystemImpl::GetOutputParametersOnDeviceThread (audio_manager=0x24823ff20b60, device_id=...)
    at ../../../../../../../home/chrome-bot/chrome_root/src/media/audio/audio_system_impl.cc:193

which looks somewhat plausible in light of the cras errors reported in the above log.

sadolfsson, since this is when initializing a speakermic - do you see anything notable in the logs/traces above?

Comment 6 by tovep@chromium.org, Mar 22 2018

Cc: tovep@chromium.org
Owner: ----
Labels: Pri-3
NextAction: 2019-07-09
Downgrading P2s that haven't been modified in more than 6 months, which have no component or owner.
Status: Untriaged (was: Assigned)
Assigned, but no owner or component? Please find a component and/or owner

Sign in to add a comment