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

Issue 895727 link

Starred by 1 user

Issue metadata

Status: Assigned
Owner:
Cc:
Components:
EstimatedDays: ----
NextAction: ----
OS: Chrome
Pri: 1
Type: Bug



Sign in to add a comment

daisy_skate: video_ChromeRTCHWDecodeUsed: Expect Media.RTCVideoDecoderInitDecodeSucces has 1. Histogram: {}

Project Member Reported by tfiga@chromium.org, Oct 16

Issue description

Board: daisy_skate
Build: 11021.48.0
Logs: http://ubercautotest.corp.google.com/tko/retrieve_logs.cgi?job=/results/248347472-chromeos-test/chromeos4-row9-rack5-host1

Seems to be quite flaky and present on both R70 and R71 as per the dashboard:

https://cros-goldeneye.corp.google.com/chromeos/healthmonitoring/testDetails?testName=video_ChromeRTCHWDecodeUsed&suite=&daysBack=30&board=daisy_skate&architecture=&boardFamily=&buildConfig=&reason=&version=&milestone=&dut=&token=AOheusMKNlJV86rFEn8kevT25PMY%3A1539668071995

From the end of the test log:

10/14 04:28:50.860 DEBUG|              test:0381| Test failed due to Expect Media.RTCVideoDecoderInitDecodeSucces has 1. Histogram: {}. Exception log follows the after_iteration_hooks.
10/14 04:28:50.862 DEBUG|              test:0386| Starting after_iteration_hooks for video_ChromeRTCHWDecodeUsed.vp8
10/14 04:28:50.864 DEBUG|      base_sysinfo:0124| Loggable saves logs to /usr/local/autotest/results/default/video_ChromeRTCHWDecodeUsed.vp8/sysinfo/iteration.1/interrupts.after
10/14 04:28:50.865 DEBUG|             utils:0219| Running 'mkdir -p /usr/local/autotest/results/default/video_ChromeRTCHWDecodeUsed.vp8/sysinfo/iteration.1/var/spool'
10/14 04:28:50.866 DEBUG|      global_hooks:0056| 'mkdir -p /usr/local/autotest/results/default/video_ChromeRTCHWDecodeUsed.vp8/sysinfo/iteration.1/var/spool'
10/14 04:28:50.908 DEBUG|             utils:0219| Running 'rsync --no-perms --chmod=ugo+r -a --safe-links --exclude=/crash/**autoserv* --exclude=/crash/*.core /var/spool/crash /usr/local/autotest/results/default/video_ChromeRTCHWDecodeUsed.vp8/sysinfo/iteration.1/var/spool'
10/14 04:28:50.911 DEBUG|      global_hooks:0056| 'rsync --no-perms --chmod=ugo+r -a --safe-links --exclude=/crash/**autoserv* --exclude=/crash/*.core /var/spool/crash /usr/local/autotest/results/default/video_ChromeRTCHWDecodeUsed.vp8/sysinfo/iteration.1/var/spool'
10/14 04:28:50.958 DEBUG|             utils:0219| Running 'rm -rf /var/spool/crash/*'
10/14 04:28:50.959 DEBUG|      global_hooks:0056| 'rm -rf /var/spool/crash/*'
10/14 04:28:50.999 DEBUG|      base_sysinfo:0124| Loggable saves logs to /usr/local/autotest/results/default/video_ChromeRTCHWDecodeUsed.vp8/sysinfo/iteration.1/meminfo.after
10/14 04:28:51.001 DEBUG|      base_sysinfo:0124| Loggable saves logs to /usr/local/autotest/results/default/video_ChromeRTCHWDecodeUsed.vp8/sysinfo/iteration.1/slabinfo.after
10/14 04:28:51.002 DEBUG|      base_sysinfo:0124| Loggable saves logs to /usr/local/autotest/results/default/video_ChromeRTCHWDecodeUsed.vp8/sysinfo/iteration.1/schedstat.after
10/14 04:28:51.003 DEBUG|             utils:0219| Running 'logger "autotest finished iteration /usr/local/autotest/results/default/video_ChromeRTCHWDecodeUsed.vp8/sysinfo/iteration.1"'
10/14 04:28:51.004 DEBUG|      global_hooks:0056| 'logger "autotest finished iteration /usr/local/autotest/results/default/video_ChromeRTCHWDecodeUsed.vp8/sysinfo/iteration.1"'
10/14 04:28:51.025 DEBUG|              test:0391| after_iteration_hooks completed
10/14 04:28:51.026 WARNI|              test:0606| The test failed with the following exception
Traceback (most recent call last):
  File "/usr/local/autotest/common_lib/test.py", line 600, in _exec
    _call_test_function(self.execute, *p_args, **p_dargs)
  File "/usr/local/autotest/common_lib/test.py", line 800, in _call_test_function
    return func(*args, **dargs)
  File "/usr/local/autotest/common_lib/test.py", line 464, in execute
    postprocess_profiled_run, args, dargs)
  File "/usr/local/autotest/common_lib/test.py", line 371, in _call_run_once
    self.run_once(*args, **dargs)
  File "/usr/local/autotest/cros/video/helper_logger.py", line 82, in call
    return func(*args, **kwargs)
  File "/usr/local/autotest/tests/video_ChromeRTCHWDecodeUsed/video_ChromeRTCHWDecodeUsed.py", line 91, in run_once
    histogram_differ, histogram_bucket_val, histogram_bucket_val)
  File "/usr/local/autotest/cros/video/histogram_verifier.py", line 197, in expect_sole_bucket
    (histogram_name, bucket_name, histogram))
TestError: Expect Media.RTCVideoDecoderInitDecodeSucces has 1. Histogram: {}
10/14 04:28:51.046 DEBUG|              test:0611| Running cleanup for test.
10/14 04:28:51.048 DEBUG|   logging_manager:0627| Logging subprocess finished
10/14 04:28:51.054 DEBUG|   logging_manager:0627| Logging subprocess finished
 
Labels: cros-media-sheriff
Cc: nverne@chromium.org agawronska@chromium.org
Recently fails on PFQ: peach_pit-tot-chrome-pfq-informational 
Also failed on peach_pit-chrome-pfq:
https://bugs.chromium.org/p/chromium/issues/detail?id=907132

Comment 4 by semenzato@chromium.org, Jan 16 (6 days ago)

Cc: akes...@chromium.org evanhernandez@chromium.org
Labels: -Pri-3 Pri-1
This caused a CQ failure for eve-paladin.

https://ci.chromium.org/p/chromeos/builders/luci.chromeos.general/CQ/b8924167982478820208

Comment 5 by hiroh@chromium.org, Jan 17 (6 days ago)

This issue is for daisy_skate and we consider it is due to some daisy specific flakiness.
If the test fails on eve, it may be a different problem on ToT. We should file a new issue. How often does the test fail on eve now?

Comment 6 by posciak@chromium.org, Jan 17 (6 days ago)

The issue on eve appears to be an error loading libva. This is likely caused by the recent libva uprev (http://crrev.com/c/1339059).

Comment 7 by posciak@chromium.org, Jan 17 (6 days ago)

crrev.com/c/1415587 is a candidate fix.

Comment 8 by agawronska@chromium.org, Jan 17 (6 days ago)

Cc: -agawronska@chromium.org

Sign in to add a comment