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

Issue 795805 link

Starred by 1 user

Issue metadata

Status: WontFix
Owner:
Closed: Oct 5
Cc:
EstimatedDays: ----
NextAction: ----
OS: Chrome
Pri: 3
Type: Bug



Sign in to add a comment

cheets_MediaPlayerVideoHWDecodeUsed hung on edgar

Reported by jrbarnette@chromium.org, Dec 18 2017

Issue description

The cheets_MediaPlayerVideoHWDecodeUsed test in arc-bvt-cq
hung during testing on this edgar paladin run:
    https://luci-milo.appspot.com/buildbot/chromeos/edgar-paladin/1687

The test ran for about a minute, then stopped forward progress.  The
test was aborted after 90 minutes inactivity.

The AFE entry for the failed test is here:
    http://cautotest-prod.corp.google.com/afe/#tab_id=view_job&object_id=163070759

There are no CLs in the run that might plausibly cause the test
failure.

The last few lines from the test logs look like this:

12/16 22:54:29.538 INFO |     helper_logger:0095| videobuf2 log enable : echo 1 > /sys/module/videobuf2_core/parameters/debug
12/16 22:54:29.539 DEBUG|      global_hooks:0056| 'echo 1 > /sys/module/videobuf2_core/parameters/debug'
12/16 22:54:29.561 DEBUG|             utils:0212| Running 'android-sh -c 'getprop ro.boot.partial_boot''
12/16 22:54:29.562 DEBUG|      global_hooks:0056| "android-sh -c 'getprop ro.boot.partial_boot'"
12/16 22:54:29.610 DEBUG|             utils:0212| Running 'adb get-state'
12/16 22:54:29.611 DEBUG|      global_hooks:0056| 'adb get-state'
12/16 22:54:29.634 DEBUG|               arc:0070| adb get-state: device
12/16 22:54:29.636 DEBUG|             utils:0212| Running 'adb shell 'pm grant org.chromium.arc.testapp.video android.permission.READ_EXTERNAL_STORAGE''
12/16 22:54:29.637 DEBUG|      global_hooks:0056| "adb shell 'pm grant org.chromium.arc.testapp.video android.permission.READ_EXTERNAL_STORAGE'"
12/16 22:54:30.385 DEBUG|             utils:0212| Running 'android-sh -c 'getprop ro.boot.partial_boot''
12/16 22:54:30.386 DEBUG|      global_hooks:0056| "android-sh -c 'getprop ro.boot.partial_boot'"
12/16 22:54:30.436 DEBUG|             utils:0212| Running 'adb get-state'
12/16 22:54:30.437 DEBUG|      global_hooks:0056| 'adb get-state'
12/16 22:54:30.459 DEBUG|               arc:0070| adb get-state: device
12/16 22:54:30.461 DEBUG|             utils:0212| Running 'adb shell 'am start --activity-clear-top --es PATH /sdcard/720_h264.mp4 org.chromium.arc.testapp.video/.MainActivity''
12/16 22:54:30.462 DEBUG|      global_hooks:0056| "adb shell 'am start --activity-clear-top --es PATH /sdcard/720_h264.mp4 org.chromium.arc.testapp.video/.MainActivity'"

Assigning to the PST ARC constable for triage.


 
Cc: levarum@chromium.org
+levarum since I'm OOO today.
Cc: victorhsieh@chromium.org
Owner: apronin@chromium.org
Looks like cryptohome issue again.
@apronin to confirm

[3399:3399:1216/225313.632586:ERROR:input_method_manager_impl.cc(1032)] IMEEngine for "jkghodnilhceideoidjikpgommlajknk" is not registered

DevTools listening on ws://127.0.0.1:45022/devtools/browser/e13a839c-f382-418f-b2f8-60c638a104e3
device-enumerator: scan all dirs
  device-enumerator: scanning /sys/bus
  device-enumerator: scanning /sys/class
device-enumerator: scan all dirs
  device-enumerator: scanning /sys/bus
  device-enumerator: scanning /sys/class
device-enumerator: scan all dirs
  device-enumerator: scanning /sys/bus
  device-enumerator: scanning /sys/class
[3399:3399:1216/225319.071574:ERROR:device_event_log_impl.cc(156)] [22:53:19.071] Login: homedir_methods.cc:274 HomedirMethods MountEx error (CryptohomeErrorCode): 1
[3399:3399:1216/225319.071677:ERROR:device_event_log_impl.cc(156)] [22:53:19.071] Login: cryptohome_authenticator.cc:932 Cryptohome failure: state(AuthState)=1, code(cryptohome::MountError)=32
device-enumerator: scan all dirs
  device-enumerator: scanning /sys/bus
  device-enumerator: scanning /sys/class
[1216/225321:INFO:policy_key.cc(51)] No policy key on disk at /home/user/9111cbbb3d8d602cfed6ef7d317865eee207c53f/key.pub
[1216/225321:INFO:keygen_worker.cc(46)] Generating Owner key.
[3399:3399:1216/225321.870741:ERROR:input_method_manager_impl.cc(1032)] IMEEngine for "jkghodnilhceideoidjikpgommlajknk" is not registered
[3399:3399:1216/225322.513918:ERROR:customization_document.cc(623)] Customization manifest is missing on server: https://ssl.gstatic.com/chrome/chromeos-customization/edgar.json
[3399:3421:1216/225323.179984:ERROR:owner_key_util_impl.cc(30)] Could not get size of /var/lib/whitelist/owner.key
[1216/225325:INFO:keygen_worker.cc(53)] Writing Owner key to /home/user/9111cbbb3d8d602cfed6ef7d317865eee207c53f/key.pub
[1216/225325:INFO:policy_key.cc(120)] wrote 294 bytes to /home/user/9111cbbb3d8d602cfed6ef7d317865eee207c53f/key.pub
[3399:3399:1216/225326.684335:ERROR:server.cc(1915)] Not implemented reached in void exo::wayland::(anonymous namespace)::remote_surface_set_rectangular_shadow_background_opacity_DEPRECATED(wl_client *, wl_resource *, wl_fixed_t)
[3399:3399:1216/225335.784569:ERROR:object_proxy.cc(626)] Failed to call method: org.chromium.Midis.BootstrapMojoConnection: object_path= /org/chromium/Midis: org.freedesktop.DBus.Error.ServiceUnknown: The name org.chromium.Midis was not provided by any .service files
[3399:3399:1216/225335.784654:ERROR:arc_midis_bridge.cc(65)] ArcMidisBridge had a failure in D-Bus with the daemon.
[3399:3399:1216/225431.311718:ERROR:server.cc(1915)] Not implemented reached in void exo::wayland::(anonymous namespace)::remote_surface_set_rectangular_shadow_background_opacity_DEPRECATED(wl_client *, wl_resource *, wl_fixed_t)
[3399:3399:1216/225431.317863:ERROR:multi_user_window_manager_stub.cc(17)] Not implemented reached in virtual void MultiUserWindowManagerStub::SetWindowOwner(aura::Window *, const AccountId &)
MountEx error lines in chrome logs are not necessarily an indication of an issue. I see the same lines for successful runs of that test. And they just mean that the test is run on a device where the local homedir for this user is not created yet, so it returns an error on the 1st attempt to mount an existing homedir, and then goes ahead and creates the user. 

E.g. here is the successful test: https://pantheon.corp.google.com/storage/browser/chromeos-autotest-results/167039175-chromeos-test/chromeos4-row9-rack9-host2/cheets_MediaPlayerVideoHWDecodeUsed/sysinfo/var/log_diff :

[4451:4451:0102/081516.343339:VERBOSE1:gaia_screen_handler.cc(971)] LoadAuthExtension, force: 1, offline: 0
[4451:4451:0102/081516.344806:ERROR:device_event_log_impl.cc(156)] [08:15:16.344] Login: homedir_methods.cc:274 HomedirMethods MountEx error (CryptohomeErrorCode): 1
[4451:4451:0102/081516.344952:ERROR:device_event_log_impl.cc(156)] [08:15:16.344] Login: cryptohome_authenticator.cc:932 Cryptohome failure: state(AuthState)=1, code(cryptohome::MountError)=32
[4451:4451:0102/081516.345044:VERBOSE1:cryptohome_authenticator.cc(776)] Resolved state to: 6
[4451:4451:0102/081516.680231:VERBOSE1:signin_screen_handler.cc(1357)] Login WebUI >> loginVisible, src: oobe, webui_visible_: 0
[4451:4451:0102/081516.681155:VERBOSE1:webui_login_view.cc(633)] Login WebUI >> login-prompt-visible
[4451:4451:0102/081516.681284:VERBOSE1:arc_session_runner.cc(185)] Session start requested: MINI_INSTANCE
[4451:4451:0102/081516.681339:VERBOSE1:arc_session_runner.cc(258)] Starting ARC instance
[4451:4451:0102/081516.808157:INFO:signin_screen_handler.cc(1403)] Login WebUI >> active: 1, source: gaia-signin
[4451:4451:0102/081516.958286:VERBOSE1:gaia_screen_handler.cc(551)] Auth extension finished loading
[4451:4451:0102/081517.107195:VERBOSE1:cryptohome_authenticator.cc(776)] Resolved state to: 13
[4451:4451:0102/081517.107470:VERBOSE1:cryptohome_authenticator.cc(666)] Login success

So, so far doesn't seem to be a cryptohome error. However, I'd like to take a look at the full logs, just in case.
Could you please also point to the place where the chrome log from #2 was taken from - somehow couldn't find it for that test.

Triage nag: This Chrome OS bug has an owner but no component. Please add a component so that this can be tracked by the relevant team.
Status: WontFix (was: Assigned)
Looks obsolete. Feel free to reopen if that is not the case.

Sign in to add a comment