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

Android 32bit Flushing ICache Regression

Project Member Reported by sheriff-...@appspot.gserviceaccount.com, May 22 2018 
Filed by sheriff-o-matic@appspot.gserviceaccount.com on behalf of sullivan@google.com

speedometer*-future failing on Nexus5X WebView Perf

This is passing at r559162. I'll kick off a functional bisect.

Builders failed on: 
- Android Nexus5X WebView Perf: 
  https://ci.chromium.org/buildbot/chromium.perf/Android%20Nexus5X%20WebView%20Perf

Sample log:
https://logs.chromium.org/v/?s=chrome%2Fbb%2Fchromium.perf%2FAndroid_Nexus5X_WebView_Perf%2F1872%2F%2B%2Frecipes%2Fsteps%2Fspeedometer-future_on_Android%2F0%2Fstdout

(CRITICAL) 2018-05-22 03:31:35,868 reraiser_thread.JoinAll:191  Timed out. Dumping threads.
(CRITICAL) 2018-05-22 03:31:35,869 reraiser_thread.LogThreadStack:30  ********************************************************************************
(CRITICAL) 2018-05-22 03:31:35,869 reraiser_thread.LogThreadStack:31  Stack dump for thread 'TimeoutThread-1-for-MainThread'
(CRITICAL) 2018-05-22 03:31:35,869 reraiser_thread.LogThreadStack:32  ********************************************************************************
(CRITICAL) 2018-05-22 03:31:35,870 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/.swarming_module/lib/python2.7/threading.py", line 774, in __bootstrap
(CRITICAL) 2018-05-22 03:31:35,870 reraiser_thread.LogThreadStack:36    self.__bootstrap_inner()
(CRITICAL) 2018-05-22 03:31:35,870 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/.swarming_module/lib/python2.7/threading.py", line 801, in __bootstrap_inner
(CRITICAL) 2018-05-22 03:31:35,870 reraiser_thread.LogThreadStack:36    self.run()
(CRITICAL) 2018-05-22 03:31:35,870 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/utils/reraiser_thread.py", line 84, in run
(CRITICAL) 2018-05-22 03:31:35,870 reraiser_thread.LogThreadStack:36    self._ret = self._func(*self._args, **self._kwargs)
(CRITICAL) 2018-05-22 03:31:35,870 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/utils/timeout_retry.py", line 151, in <lambda>
(CRITICAL) 2018-05-22 03:31:35,870 reraiser_thread.LogThreadStack:36    child_thread = reraiser_thread.ReraiserThread(lambda: func(*args, **kwargs),
(CRITICAL) 2018-05-22 03:31:35,870 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py", line 47, in impl
(CRITICAL) 2018-05-22 03:31:35,870 reraiser_thread.LogThreadStack:36    return f(*args, **kwargs)
(CRITICAL) 2018-05-22 03:31:35,870 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1241, in StartActivity
(CRITICAL) 2018-05-22 03:31:35,870 reraiser_thread.LogThreadStack:36    for line in self.RunShellCommand(cmd, check_return=True):
(CRITICAL) 2018-05-22 03:31:35,870 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py", line 51, in timeout_retry_wrapper
(CRITICAL) 2018-05-22 03:31:35,871 reraiser_thread.LogThreadStack:36    return impl()
(CRITICAL) 2018-05-22 03:31:35,871 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py", line 47, in impl
(CRITICAL) 2018-05-22 03:31:35,871 reraiser_thread.LogThreadStack:36    return f(*args, **kwargs)
(CRITICAL) 2018-05-22 03:31:35,871 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1112, in RunShellCommand
(CRITICAL) 2018-05-22 03:31:35,871 reraiser_thread.LogThreadStack:36    output = handle_large_output(cmd, large_output)
(CRITICAL) 2018-05-22 03:31:35,871 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1081, in handle_large_output
(CRITICAL) 2018-05-22 03:31:35,871 reraiser_thread.LogThreadStack:36    return handle_large_command(cmd)
(CRITICAL) 2018-05-22 03:31:35,871 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1063, in handle_large_command
(CRITICAL) 2018-05-22 03:31:35,871 reraiser_thread.LogThreadStack:36    return handle_check_return(cmd)
(CRITICAL) 2018-05-22 03:31:35,871 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1054, in handle_check_return
(CRITICAL) 2018-05-22 03:31:35,871 reraiser_thread.LogThreadStack:36    return run(cmd)
(CRITICAL) 2018-05-22 03:31:35,871 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1050, in run
(CRITICAL) 2018-05-22 03:31:35,871 reraiser_thread.LogThreadStack:36    return self.adb.Shell(cmd)
(CRITICAL) 2018-05-22 03:31:35,871 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/sdk/adb_wrapper.py", line 522, in Shell
(CRITICAL) 2018-05-22 03:31:35,871 reraiser_thread.LogThreadStack:36    output = self._RunDeviceAdbCmd(args, timeout, retries, check_error=False)
(CRITICAL) 2018-05-22 03:31:35,872 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/sdk/adb_wrapper.py", line 305, in _RunDeviceAdbCmd
(CRITICAL) 2018-05-22 03:31:35,872 reraiser_thread.LogThreadStack:36    check_error=check_error)
(CRITICAL) 2018-05-22 03:31:35,872 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py", line 51, in timeout_retry_wrapper
(CRITICAL) 2018-05-22 03:31:35,872 reraiser_thread.LogThreadStack:36    return impl()
(CRITICAL) 2018-05-22 03:31:35,872 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py", line 47, in impl
(CRITICAL) 2018-05-22 03:31:35,872 reraiser_thread.LogThreadStack:36    return f(*args, **kwargs)
(CRITICAL) 2018-05-22 03:31:35,872 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/sdk/adb_wrapper.py", line 266, in _RunAdbCmd
(CRITICAL) 2018-05-22 03:31:35,872 reraiser_thread.LogThreadStack:36    env=cls._ADB_ENV)
(CRITICAL) 2018-05-22 03:31:35,872 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/utils/cmd_helper.py", line 413, in GetCmdStatusAndOutputWithTimeout
(CRITICAL) 2018-05-22 03:31:35,872 reraiser_thread.LogThreadStack:36    for data in _IterProcessStdout(process, timeout=timeout):
(CRITICAL) 2018-05-22 03:31:35,872 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/utils/cmd_helper.py", line 275, in _IterProcessStdoutFcntl
(CRITICAL) 2018-05-22 03:31:35,872 reraiser_thread.LogThreadStack:36    [child_fd], [], [], iter_aware_poll_interval)
(CRITICAL) 2018-05-22 03:31:35,872 reraiser_thread.LogThreadStack:37  ********************************************************************************
(INFO) 2018-05-22 03:31:35,873 cmd_helper._ValidateAndLogCommand:160  [host]> /b/swarming/w/ir/third_party/catapult/devil/bin/deps/linux2/x86_64/bin/adb -s 01fc0cb218c2a26c shell '( am start -W -d about:blank -n org.chromium.webview_shell/org.chromium.webview_shell.TelemetryActivity );echo %$?'
(CRITICAL) 2018-05-22 03:32:05,900 reraiser_thread.JoinAll:191  Timed out. Dumping threads.
(CRITICAL) 2018-05-22 03:32:05,900 reraiser_thread.LogThreadStack:30  ********************************************************************************
(CRITICAL) 2018-05-22 03:32:05,901 reraiser_thread.LogThreadStack:31  Stack dump for thread 'TimeoutThread-2-for-MainThread'
(CRITICAL) 2018-05-22 03:32:05,901 reraiser_thread.LogThreadStack:32  ********************************************************************************
(CRITICAL) 2018-05-22 03:32:05,901 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/.swarming_module/lib/python2.7/threading.py", line 774, in __bootstrap
(CRITICAL) 2018-05-22 03:32:05,901 reraiser_thread.LogThreadStack:36    self.__bootstrap_inner()
(CRITICAL) 2018-05-22 03:32:05,901 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/.swarming_module/lib/python2.7/threading.py", line 801, in __bootstrap_inner
(CRITICAL) 2018-05-22 03:32:05,901 reraiser_thread.LogThreadStack:36    self.run()
(CRITICAL) 2018-05-22 03:32:05,901 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/utils/reraiser_thread.py", line 84, in run
(CRITICAL) 2018-05-22 03:32:05,901 reraiser_thread.LogThreadStack:36    self._ret = self._func(*self._args, **self._kwargs)
(CRITICAL) 2018-05-22 03:32:05,901 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/utils/timeout_retry.py", line 151, in <lambda>
(CRITICAL) 2018-05-22 03:32:05,901 reraiser_thread.LogThreadStack:36    child_thread = reraiser_thread.ReraiserThread(lambda: func(*args, **kwargs),
(CRITICAL) 2018-05-22 03:32:05,901 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py", line 47, in impl
(CRITICAL) 2018-05-22 03:32:05,901 reraiser_thread.LogThreadStack:36    return f(*args, **kwargs)
(CRITICAL) 2018-05-22 03:32:05,902 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1241, in StartActivity
(CRITICAL) 2018-05-22 03:32:05,902 reraiser_thread.LogThreadStack:36    for line in self.RunShellCommand(cmd, check_return=True):
(CRITICAL) 2018-05-22 03:32:05,902 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py", line 51, in timeout_retry_wrapper
(CRITICAL) 2018-05-22 03:32:05,902 reraiser_thread.LogThreadStack:36    return impl()
(CRITICAL) 2018-05-22 03:32:05,902 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py", line 47, in impl
(CRITICAL) 2018-05-22 03:32:05,902 reraiser_thread.LogThreadStack:36    return f(*args, **kwargs)
(CRITICAL) 2018-05-22 03:32:05,902 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1112, in RunShellCommand
(CRITICAL) 2018-05-22 03:32:05,902 reraiser_thread.LogThreadStack:36    output = handle_large_output(cmd, large_output)
(CRITICAL) 2018-05-22 03:32:05,902 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1081, in handle_large_output
(CRITICAL) 2018-05-22 03:32:05,902 reraiser_thread.LogThreadStack:36    return handle_large_command(cmd)
(CRITICAL) 2018-05-22 03:32:05,902 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1063, in handle_large_command
(CRITICAL) 2018-05-22 03:32:05,902 reraiser_thread.LogThreadStack:36    return handle_check_return(cmd)
(CRITICAL) 2018-05-22 03:32:05,902 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1054, in handle_check_return
(CRITICAL) 2018-05-22 03:32:05,902 reraiser_thread.LogThreadStack:36    return run(cmd)
(CRITICAL) 2018-05-22 03:32:05,902 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1050, in run
(CRITICAL) 2018-05-22 03:32:05,902 reraiser_thread.LogThreadStack:36    return self.adb.Shell(cmd)
(CRITICAL) 2018-05-22 03:32:05,903 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/sdk/adb_wrapper.py", line 522, in Shell
(CRITICAL) 2018-05-22 03:32:05,903 reraiser_thread.LogThreadStack:36    output = self._RunDeviceAdbCmd(args, timeout, retries, check_error=False)
(CRITICAL) 2018-05-22 03:32:05,903 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/sdk/adb_wrapper.py", line 305, in _RunDeviceAdbCmd
(CRITICAL) 2018-05-22 03:32:05,903 reraiser_thread.LogThreadStack:36    check_error=check_error)
(CRITICAL) 2018-05-22 03:32:05,903 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py", line 51, in timeout_retry_wrapper
(CRITICAL) 2018-05-22 03:32:05,903 reraiser_thread.LogThreadStack:36    return impl()
(CRITICAL) 2018-05-22 03:32:05,903 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py", line 47, in impl
(CRITICAL) 2018-05-22 03:32:05,903 reraiser_thread.LogThreadStack:36    return f(*args, **kwargs)
(CRITICAL) 2018-05-22 03:32:05,903 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/sdk/adb_wrapper.py", line 266, in _RunAdbCmd
(CRITICAL) 2018-05-22 03:32:05,903 reraiser_thread.LogThreadStack:36    env=cls._ADB_ENV)
(CRITICAL) 2018-05-22 03:32:05,903 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/utils/cmd_helper.py", line 413, in GetCmdStatusAndOutputWithTimeout
(CRITICAL) 2018-05-22 03:32:05,903 reraiser_thread.LogThreadStack:36    for data in _IterProcessStdout(process, timeout=timeout):
(CRITICAL) 2018-05-22 03:32:05,903 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/utils/cmd_helper.py", line 275, in _IterProcessStdoutFcntl
(CRITICAL) 2018-05-22 03:32:05,903 reraiser_thread.LogThreadStack:36    [child_fd], [], [], iter_aware_poll_interval)
(CRITICAL) 2018-05-22 03:32:05,903 reraiser_thread.LogThreadStack:37  ********************************************************************************
(INFO) 2018-05-22 03:32:05,904 cmd_helper._ValidateAndLogCommand:160  [host]> /b/swarming/w/ir/third_party/catapult/devil/bin/deps/linux2/x86_64/bin/adb -s 01fc0cb218c2a26c shell '( am start -W -d about:blank -n org.chromium.webview_shell/org.chromium.webview_shell.TelemetryActivity );echo %$?'
(CRITICAL) 2018-05-22 03:32:35,932 reraiser_thread.JoinAll:191  Timed out. Dumping threads.
(CRITICAL) 2018-05-22 03:32:35,932 reraiser_thread.LogThreadStack:30  ********************************************************************************
(CRITICAL) 2018-05-22 03:32:35,932 reraiser_thread.LogThreadStack:31  Stack dump for thread 'TimeoutThread-3-for-MainThread'
(CRITICAL) 2018-05-22 03:32:35,932 reraiser_thread.LogThreadStack:32  ********************************************************************************
(CRITICAL) 2018-05-22 03:32:35,933 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/.swarming_module/lib/python2.7/threading.py", line 774, in __bootstrap
(CRITICAL) 2018-05-22 03:32:35,933 reraiser_thread.LogThreadStack:36    self.__bootstrap_inner()
(CRITICAL) 2018-05-22 03:32:35,933 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/.swarming_module/lib/python2.7/threading.py", line 801, in __bootstrap_inner
(CRITICAL) 2018-05-22 03:32:35,933 reraiser_thread.LogThreadStack:36    self.run()
(CRITICAL) 2018-05-22 03:32:35,933 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/utils/reraiser_thread.py", line 84, in run
(CRITICAL) 2018-05-22 03:32:35,933 reraiser_thread.LogThreadStack:36    self._ret = self._func(*self._args, **self._kwargs)
(CRITICAL) 2018-05-22 03:32:35,933 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/utils/timeout_retry.py", line 151, in <lambda>
(CRITICAL) 2018-05-22 03:32:35,933 reraiser_thread.LogThreadStack:36    child_thread = reraiser_thread.ReraiserThread(lambda: func(*args, **kwargs),
(CRITICAL) 2018-05-22 03:32:35,933 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py", line 47, in impl
(CRITICAL) 2018-05-22 03:32:35,933 reraiser_thread.LogThreadStack:36    return f(*args, **kwargs)
(CRITICAL) 2018-05-22 03:32:35,933 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1241, in StartActivity
(CRITICAL) 2018-05-22 03:32:35,933 reraiser_thread.LogThreadStack:36    for line in self.RunShellCommand(cmd, check_return=True):
(CRITICAL) 2018-05-22 03:32:35,933 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py", line 51, in timeout_retry_wrapper
(CRITICAL) 2018-05-22 03:32:35,933 reraiser_thread.LogThreadStack:36    return impl()
(CRITICAL) 2018-05-22 03:32:35,933 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py", line 47, in impl
(CRITICAL) 2018-05-22 03:32:35,934 reraiser_thread.LogThreadStack:36    return f(*args, **kwargs)
(CRITICAL) 2018-05-22 03:32:35,934 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1112, in RunShellCommand
(CRITICAL) 2018-05-22 03:32:35,934 reraiser_thread.LogThreadStack:36    output = handle_large_output(cmd, large_output)
(CRITICAL) 2018-05-22 03:32:35,934 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1081, in handle_large_output
(CRITICAL) 2018-05-22 03:32:35,934 reraiser_thread.LogThreadStack:36    return handle_large_command(cmd)
(CRITICAL) 2018-05-22 03:32:35,934 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1063, in handle_large_command
(CRITICAL) 2018-05-22 03:32:35,934 reraiser_thread.LogThreadStack:36    return handle_check_return(cmd)
(CRITICAL) 2018-05-22 03:32:35,934 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1054, in handle_check_return
(CRITICAL) 2018-05-22 03:32:35,934 reraiser_thread.LogThreadStack:36    return run(cmd)
(CRITICAL) 2018-05-22 03:32:35,934 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1050, in run
(CRITICAL) 2018-05-22 03:32:35,934 reraiser_thread.LogThreadStack:36    return self.adb.Shell(cmd)
(CRITICAL) 2018-05-22 03:32:35,934 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/sdk/adb_wrapper.py", line 522, in Shell
(CRITICAL) 2018-05-22 03:32:35,934 reraiser_thread.LogThreadStack:36    output = self._RunDeviceAdbCmd(args, timeout, retries, check_error=False)
(CRITICAL) 2018-05-22 03:32:35,934 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/sdk/adb_wrapper.py", line 305, in _RunDeviceAdbCmd
(CRITICAL) 2018-05-22 03:32:35,934 reraiser_thread.LogThreadStack:36    check_error=check_error)
(CRITICAL) 2018-05-22 03:32:35,934 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py", line 51, in timeout_retry_wrapper
(CRITICAL) 2018-05-22 03:32:35,935 reraiser_thread.LogThreadStack:36    return impl()
(CRITICAL) 2018-05-22 03:32:35,935 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py", line 47, in impl
(CRITICAL) 2018-05-22 03:32:35,935 reraiser_thread.LogThreadStack:36    return f(*args, **kwargs)
(CRITICAL) 2018-05-22 03:32:35,935 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/sdk/adb_wrapper.py", line 266, in _RunAdbCmd
(CRITICAL) 2018-05-22 03:32:35,935 reraiser_thread.LogThreadStack:36    env=cls._ADB_ENV)
(CRITICAL) 2018-05-22 03:32:35,935 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/utils/cmd_helper.py", line 413, in GetCmdStatusAndOutputWithTimeout
(CRITICAL) 2018-05-22 03:32:35,935 reraiser_thread.LogThreadStack:36    for data in _IterProcessStdout(process, timeout=timeout):
(CRITICAL) 2018-05-22 03:32:35,935 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/utils/cmd_helper.py", line 275, in _IterProcessStdoutFcntl
(CRITICAL) 2018-05-22 03:32:35,935 reraiser_thread.LogThreadStack:36    [child_fd], [], [], iter_aware_poll_interval)
(CRITICAL) 2018-05-22 03:32:35,935 reraiser_thread.LogThreadStack:37  ********************************************************************************
(INFO) 2018-05-22 03:32:35,935 cmd_helper._ValidateAndLogCommand:160  [host]> /b/swarming/w/ir/third_party/catapult/devil/bin/deps/linux2/x86_64/bin/adb -s 01fc0cb218c2a26c shell '( am start -W -d about:blank -n org.chromium.webview_shell/org.chromium.webview_shell.TelemetryActivity );echo %$?'
(CRITICAL) 2018-05-22 03:33:05,964 reraiser_thread.JoinAll:191  Timed out. Dumping threads.
(CRITICAL) 2018-05-22 03:33:05,964 reraiser_thread.LogThreadStack:30  ********************************************************************************
(CRITICAL) 2018-05-22 03:33:05,964 reraiser_thread.LogThreadStack:31  Stack dump for thread 'TimeoutThread-4-for-MainThread'
(CRITICAL) 2018-05-22 03:33:05,964 reraiser_thread.LogThreadStack:32  ********************************************************************************
(CRITICAL) 2018-05-22 03:33:05,965 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/.swarming_module/lib/python2.7/threading.py", line 774, in __bootstrap
(CRITICAL) 2018-05-22 03:33:05,965 reraiser_thread.LogThreadStack:36    self.__bootstrap_inner()
(CRITICAL) 2018-05-22 03:33:05,965 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/.swarming_module/lib/python2.7/threading.py", line 801, in __bootstrap_inner
(CRITICAL) 2018-05-22 03:33:05,965 reraiser_thread.LogThreadStack:36    self.run()
(CRITICAL) 2018-05-22 03:33:05,965 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/utils/reraiser_thread.py", line 84, in run
(CRITICAL) 2018-05-22 03:33:05,965 reraiser_thread.LogThreadStack:36    self._ret = self._func(*self._args, **self._kwargs)
(CRITICAL) 2018-05-22 03:33:05,965 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/utils/timeout_retry.py", line 151, in <lambda>
(CRITICAL) 2018-05-22 03:33:05,965 reraiser_thread.LogThreadStack:36    child_thread = reraiser_thread.ReraiserThread(lambda: func(*args, **kwargs),
(CRITICAL) 2018-05-22 03:33:05,965 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py", line 47, in impl
(CRITICAL) 2018-05-22 03:33:05,965 reraiser_thread.LogThreadStack:36    return f(*args, **kwargs)
(CRITICAL) 2018-05-22 03:33:05,965 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1241, in StartActivity
(CRITICAL) 2018-05-22 03:33:05,965 reraiser_thread.LogThreadStack:36    for line in self.RunShellCommand(cmd, check_return=True):
(CRITICAL) 2018-05-22 03:33:05,965 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py", line 51, in timeout_retry_wrapper
(CRITICAL) 2018-05-22 03:33:05,965 reraiser_thread.LogThreadStack:36    return impl()
(CRITICAL) 2018-05-22 03:33:05,965 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py", line 47, in impl
(CRITICAL) 2018-05-22 03:33:05,966 reraiser_thread.LogThreadStack:36    return f(*args, **kwargs)
(CRITICAL) 2018-05-22 03:33:05,966 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1112, in RunShellCommand
(CRITICAL) 2018-05-22 03:33:05,966 reraiser_thread.LogThreadStack:36    output = handle_large_output(cmd, large_output)
(CRITICAL) 2018-05-22 03:33:05,966 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1081, in handle_large_output
(CRITICAL) 2018-05-22 03:33:05,966 reraiser_thread.LogThreadStack:36    return handle_large_command(cmd)
(CRITICAL) 2018-05-22 03:33:05,966 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1063, in handle_large_command
(CRITICAL) 2018-05-22 03:33:05,966 reraiser_thread.LogThreadStack:36    return handle_check_return(cmd)
(CRITICAL) 2018-05-22 03:33:05,966 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1054, in handle_check_return
(CRITICAL) 2018-05-22 03:33:05,966 reraiser_thread.LogThreadStack:36    return run(cmd)
(CRITICAL) 2018-05-22 03:33:05,966 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/device_utils.py", line 1050, in run
(CRITICAL) 2018-05-22 03:33:05,966 reraiser_thread.LogThreadStack:36    return self.adb.Shell(cmd)
(CRITICAL) 2018-05-22 03:33:05,966 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/sdk/adb_wrapper.py", line 522, in Shell
(CRITICAL) 2018-05-22 03:33:05,966 reraiser_thread.LogThreadStack:36    output = self._RunDeviceAdbCmd(args, timeout, retries, check_error=False)
(CRITICAL) 2018-05-22 03:33:05,966 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/sdk/adb_wrapper.py", line 305, in _RunDeviceAdbCmd
(CRITICAL) 2018-05-22 03:33:05,966 reraiser_thread.LogThreadStack:36    check_error=check_error)
(CRITICAL) 2018-05-22 03:33:05,966 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py", line 51, in timeout_retry_wrapper
(CRITICAL) 2018-05-22 03:33:05,966 reraiser_thread.LogThreadStack:36    return impl()
(CRITICAL) 2018-05-22 03:33:05,967 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py", line 47, in impl
(CRITICAL) 2018-05-22 03:33:05,967 reraiser_thread.LogThreadStack:36    return f(*args, **kwargs)
(CRITICAL) 2018-05-22 03:33:05,967 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/android/sdk/adb_wrapper.py", line 266, in _RunAdbCmd
(CRITICAL) 2018-05-22 03:33:05,967 reraiser_thread.LogThreadStack:36    env=cls._ADB_ENV)
(CRITICAL) 2018-05-22 03:33:05,967 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/utils/cmd_helper.py", line 413, in GetCmdStatusAndOutputWithTimeout
(CRITICAL) 2018-05-22 03:33:05,967 reraiser_thread.LogThreadStack:36    for data in _IterProcessStdout(process, timeout=timeout):
(CRITICAL) 2018-05-22 03:33:05,967 reraiser_thread.LogThreadStack:34  File: "/b/swarming/w/ir/third_party/catapult/devil/devil/utils/cmd_helper.py", line 275, in _IterProcessStdoutFcntl
(CRITICAL) 2018-05-22 03:33:05,967 reraiser_thread.LogThreadStack:36    [child_fd], [], [], iter_aware_poll_interval)
(CRITICAL) 2018-05-22 03:33:05,967 reraiser_thread.LogThreadStack:37  ********************************************************************************
(ERROR) 2018-05-22 03:33:05,967 browser.__init__:54  Failed with CommandTimeoutError while starting the browser backend.
(INFO) 2018-05-22 03:33:05,968 cmd_helper._ValidateAndLogCommand:160  [host]> /b/swarming/w/ir/third_party/catapult/devil/bin/deps/linux2/x86_64/bin/adb -s 01fc0cb218c2a26c shell '( ps | grep -F org.chromium.webview_shell; echo "PIPESTATUS: ${PIPESTATUS[@]}" );echo %$?'
(INFO) 2018-05-22 03:33:06,076 cmd_helper._ValidateAndLogCommand:160  [host]> /b/swarming/w/ir/third_party/catapult/devil/bin/deps/linux2/x86_64/bin/adb -s 01fc0cb218c2a26c shell '( ps | grep -F org.chromium.webview_shell; echo "PIPESTATUS: ${PIPESTATUS[@]}" );echo %$?'
(INFO) 2018-05-22 03:33:06,191 cmd_helper._ValidateAndLogCommand:160  [host]> /b/swarming/w/ir/third_party/catapult/devil/bin/deps/linux2/x86_64/bin/adb -s 01fc0cb218c2a26c shell '( ps | grep -F org.chromium.webview_shell; echo "PIPESTATUS: ${PIPESTATUS[@]}" );echo %$?'
(INFO) 2018-05-22 03:33:06,299 browser.Close:220  Browser is closed.
(ERROR) 2018-05-22 03:33:06,299 android_browser_finder._GetBrowserInstance:196  Failed with CommandTimeoutError while creating Android browser.
(INFO) 2018-05-22 03:33:06,300 cmd_helper._ValidateAndLogCommand:160  [host]> /b/swarming/w/ir/third_party/catapult/devil/bin/deps/linux2/x86_64/bin/adb -s 01fc0cb218c2a26c shell '( ps | grep -F org.chromium.webview_shell; echo "PIPESTATUS: ${PIPESTATUS[@]}" );echo %$?'
(INFO) 2018-05-22 03:33:06,407 cmd_helper._ValidateAndLogCommand:160  [host]> /b/swarming/w/ir/third_party/catapult/devil/bin/deps/linux2/x86_64/bin/adb -s 01fc0cb218c2a26c shell '( rm -f /data/local/tmp/webview-command-line );echo %$?'
(INFO) 2018-05-22 03:33:06,508 cmd_helper._ValidateAndLogCommand:160  [host]> /b/swarming/w/ir/third_party/catapult/devil/bin/deps/linux2/x86_64/bin/adb -s 01fc0cb218c2a26c shell '( test -e /data/local/tmp/webview-command-line );echo %$?'
(INFO) 2018-05-22 03:33:06,571 flag_changer._UpdateCommandLineFile:217  Flags now set on the device: []
(WARNING) 2018-05-22 03:33:06,572 shared_page_state.DumpStateUponFailure:132  Cannot dump browser state: No browser.
(INFO) 2018-05-22 03:33:06,572 cmd_helper._ValidateAndLogCommand:160  [host]> /b/swarming/w/ir/third_party/catapult/devil/bin/deps/linux2/x86_64/bin/adb -s 01fc0cb218c2a26c shell '( /system/bin/screencap -p /data/local/tmp/temp_file-ec70de5134a12.png );echo %$?'
(INFO) 2018-05-22 03:33:10,097 cmd_helper._ValidateAndLogCommand:160  [host]> /b/swarming/w/ir/third_party/catapult/devil/bin/deps/linux2/x86_64/bin/adb -s 01fc0cb218c2a26c pull /data/local/tmp/temp_file-ec70de5134a12.png /b/swarming/w/itz6krlr/tmpN0kAjB.png
(INFO) 2018-05-22 03:33:10,778 cmd_helper._ValidateAndLogCommand:160  [host]> /b/swarming/w/ir/third_party/catapult/devil/bin/deps/linux2/x86_64/bin/adb -s 01fc0cb218c2a26c shell 'rm -f /data/local/tmp/temp_file-ec70de5134a12.png'
(WARNING) 2018-05-22 03:33:10,780 artifact_results.AddArtifact:134  Moving artifact file '/b/swarming/w/itz6krlr/tmpN0kAjB.png' to '/b/swarming/w/itz6krlr/tmpmufmPmtelemetry/artifacts'
Traceback (most recent call last):
  File "/b/swarming/w/ir/third_party/catapult/telemetry/telemetry/internal/story_runner.py", line 118, in _RunStoryAndProcessErrorIfNeeded
    state.WillRunStory(story)
  File "/b/swarming/w/ir/third_party/catapult/common/py_trace_event/py_trace_event/trace_event_impl/decorators.py", line 52, in traced_function
    return func(*args, **kwargs)
  File "/b/swarming/w/ir/third_party/catapult/telemetry/telemetry/page/shared_page_state.py", line 236, in WillRunStory
    self._StartBrowser(page)
  File "/b/swarming/w/ir/third_party/catapult/common/py_trace_event/py_trace_event/trace_event_impl/decorators.py", line 52, in traced_function
    return func(*args, **kwargs)
  File "/b/swarming/w/ir/third_party/catapult/telemetry/telemetry/page/shared_page_state.py", line 200, in _StartBrowser
    self._browser = self._possible_browser.Create()
  File "/b/swarming/w/ir/third_party/catapult/telemetry/telemetry/internal/backends/chrome/android_browser_finder.py", line 165, in Create
    return self._GetBrowserInstance(existing=False)
  File "/b/swarming/w/ir/third_party/catapult/telemetry/telemetry/internal/backends/chrome/android_browser_finder.py", line 187, in _GetBrowserInstance
    find_existing=existing)
  File "/b/swarming/w/ir/third_party/catapult/telemetry/telemetry/internal/browser/browser.py", line 48, in __init__
    self._browser_backend.Start(startup_args, startup_url=startup_url)
  File "/b/swarming/w/ir/third_party/catapult/common/py_trace_event/py_trace_event/trace_event_impl/decorators.py", line 52, in traced_function
    return func(*args, **kwargs)
  File "/b/swarming/w/ir/third_party/catapult/telemetry/telemetry/internal/backends/chrome/android_browser_backend.py", line 73, in Start
    blocking=True)
  File "/b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py", line 57, in timeout_retry_wrapper
    retry_if_func=retry_if_func)
  File "/b/swarming/w/ir/third_party/catapult/devil/devil/utils/timeout_retry.py", line 158, in Run
    error_log_func=error_log_func)
  File "/b/swarming/w/ir/third_party/catapult/devil/devil/utils/reraiser_thread.py", line 189, in JoinAll
    self._JoinAll(watcher, timeout)
  File "/b/swarming/w/ir/third_party/catapult/devil/devil/utils/reraiser_thread.py", line 154, in _JoinAll
    (len(alive_threads), len(self._threads)))
CommandTimeoutError: Timed out waiting for 1 of 1 threads.
[  FAILED  ] speedometer-future/http://browserbench.org/Speedometer/ (126724 ms)
(INFO) 2018-05-22 03:33:11,300 cmd_helper._ValidateAndLogCommand:160  [host]> /b/swarming/w/ir/third_party/catapult/devil/bin/deps/linux2/x86_64/forwarder_host --adb=/b/swarming/w/ir/third_party/catapult/devil/bin/deps/linux2/x86_64/bin/adb --serial-id=01fc0cb218c2a26c --unmap 47983
(INFO) 2018-05-22 03:33:11,309 cmd_helper._ValidateAndLogCommand:160  [host]> /b/swarming/w/ir/third_party/catapult/devil/bin/deps/linux2/x86_64/bin/adb -s 01fc0cb218c2a26c shell '( ls /root );echo %$?'
(INFO) 2018-05-22 03:33:11,409 cmd_helper._ValidateAndLogCommand:160  [host]> /b/swarming/w/ir/third_party/catapult/devil/bin/deps/linux2/x86_64/bin/adb -s 01fc0cb218c2a26c shell '( cd /sys/devices/system/cpu && for CPU in cpu0 cpu1 cpu2 cpu3 cpu4 cpu5; do test -e "${CPU}/cpufreq/scaling_available_governors" && grep -q ondemand ${CPU}/cpufreq/scaling_available_governors && test -e "$CPU/cpufreq/scaling_governor" && echo ondemand > "$CPU/cpufreq/scaling_governor"; echo -n "%~%$?%~%"; done );echo %$?'
(INFO) 2018-05-22 03:33:11,541 perf_control._ConditionallyWriteEachCpuFile:128  Successfully set cpufreq/scaling_governor to 'ondemand' on: cpu0 cpu1 cpu2 cpu3 cpu4 cpu5
(INFO) 2018-05-22 03:33:11,541 cmd_helper._ValidateAndLogCommand:160  [host]> /b/swarming/w/ir/third_party/catapult/devil/bin/deps/linux2/x86_64/bin/adb -s 01fc0cb218c2a26c shell '( cd /sys/devices/system/cpu && for CPU in cpu0 cpu1 cpu2 cpu3 cpu4 cpu5; do cat "$CPU/online"; echo -n "%~%$?%~%"; done );echo %$?'
(CRITICAL) 2018-05-22 03:33:11,642 story_runner.RunBenchmark:369  Benchmark execution interrupted by a fatal exception.
(INFO) 2018-05-22 03:33:11,642 exception_formatter.PrintFormattedException:19  Try printing formatted exception: None None None
Traceback (most recent call last):
  RunBenchmark at /b/swarming/w/ir/third_party/catapult/telemetry/telemetry/internal/story_runner.py:362
    expectations=expectations, max_num_values=benchmark.MAX_NUM_VALUES)
  Run at /b/swarming/w/ir/third_party/catapult/telemetry/telemetry/internal/story_runner.py:227
    _RunStoryAndProcessErrorIfNeeded(story, results, state, test)
  _RunStoryAndProcessErrorIfNeeded at /b/swarming/w/ir/third_party/catapult/telemetry/telemetry/internal/story_runner.py:118
    state.WillRunStory(story)
  traced_function at /b/swarming/w/ir/third_party/catapult/common/py_trace_event/py_trace_event/trace_event_impl/decorators.py:52
    return func(*args, **kwargs)
  WillRunStory at /b/swarming/w/ir/third_party/catapult/telemetry/telemetry/page/shared_page_state.py:236
    self._StartBrowser(page)
  traced_function at /b/swarming/w/ir/third_party/catapult/common/py_trace_event/py_trace_event/trace_event_impl/decorators.py:52
    return func(*args, **kwargs)
  _StartBrowser at /b/swarming/w/ir/third_party/catapult/telemetry/telemetry/page/shared_page_state.py:200
    self._browser = self._possible_browser.Create()
  Create at /b/swarming/w/ir/third_party/catapult/telemetry/telemetry/internal/backends/chrome/android_browser_finder.py:165
    return self._GetBrowserInstance(existing=False)
  _GetBrowserInstance at /b/swarming/w/ir/third_party/catapult/telemetry/telemetry/internal/backends/chrome/android_browser_finder.py:187
    find_existing=existing)
  __init__ at /b/swarming/w/ir/third_party/catapult/telemetry/telemetry/internal/browser/browser.py:48
    self._browser_backend.Start(startup_args, startup_url=startup_url)
  traced_function at /b/swarming/w/ir/third_party/catapult/common/py_trace_event/py_trace_event/trace_event_impl/decorators.py:52
    return func(*args, **kwargs)
  Start at /b/swarming/w/ir/third_party/catapult/telemetry/telemetry/internal/backends/chrome/android_browser_backend.py:73
    blocking=True)
  timeout_retry_wrapper at /b/swarming/w/ir/third_party/catapult/devil/devil/android/decorators.py:57
    retry_if_func=retry_if_func)
  Run at /b/swarming/w/ir/third_party/catapult/devil/devil/utils/timeout_retry.py:158
    error_log_func=error_log_func)
  JoinAll at /b/swarming/w/ir/third_party/catapult/devil/devil/utils/reraiser_thread.py:189
    self._JoinAll(watcher, timeout)
  _JoinAll at /b/swarming/w/ir/third_party/catapult/devil/devil/utils/reraiser_thread.py:154
    (len(alive_threads), len(self._threads)))
CommandTimeoutError: Timed out waiting for 1 of 1 threads.
Locals:
  alive_threads : [<ReraiserThread(TimeoutThread-4-for-MainThread, stopped daemon 139840340002560)>]
  end_time      : 1526960015.93581
  thread        : <ReraiserThread(TimeoutThread-4-for-MainThread, stopped daemon 139840340002560)>
  timeout       : 60
  watcher       : <devil.utils.watchdog_timer.WatchdogTimer object at 0x7f2f23c29f10>
(INFO) 2018-05-22 03:33:11,643 cloud_storage.Insert:378  Uploading /b/swarming/w/itz6krlr/tmpmufmPmtelemetry/artifacts/telemetry_testGtggEb to gs://chrome-telemetry-output/da62d17a-5d70-11e8-a09a-0242ac110005
Uploading logs of page http://browserbench.org/Speedometer/ to https://console.developers.google.com/m/cloudstorage/b/chrome-telemetry-output/o/da62d17a-5d70-11e8-a09a-0242ac110005 (1 out of 1)
(INFO) 2018-05-22 03:33:12,829 cloud_storage.Insert:378  Uploading /b/swarming/w/itz6krlr/tmpmufmPmtelemetry/artifacts/tmpN0kAjB.png to gs://chrome-telemetry-output/db17d00c-5d70-11e8-a09a-0242ac110005
Uploading screenshot of page http://browserbench.org/Speedometer/ to https://console.developers.google.com/m/cloudstorage/b/chrome-telemetry-output/o/db17d00c-5d70-11e8-a09a-0242ac110005 (1 out of 1)
(INFO) 2018-05-22 03:33:14,510 memory_debug.LogHostMemoryUsage:60  Used 2.6 GiB out of 31.4 GiB memory available.
(INFO) 2018-05-22 03:33:14,510 memory_debug.LogHostMemoryUsage:61  Memory usage of top 10 processes groups
(INFO) 2018-05-22 03:33:14,512 memory_debug.LogHostMemoryUsage:77  - python - 181.2 MiB - pids: ['56', '31055', '31068', '31089', '31098', '31285', '31286']
(INFO) 2018-05-22 03:33:14,512 memory_debug.LogHostMemoryUsage:77  - adb - 3.1 MiB - pids: ['31270']
(INFO) 2018-05-22 03:33:14,512 memory_debug.LogHostMemoryUsage:77  - forwarder_host - 1.7 MiB - pids: ['2084']
(INFO) 2018-05-22 03:33:14,512 memory_debug.LogHostMemoryUsage:77  - su - 1.6 MiB - pids: ['55']
(INFO) 2018-05-22 03:33:14,512 memory_debug.LogHostMemoryUsage:77  - bash - 1.5 MiB - pids: ['1']
(INFO) 2018-05-22 03:33:14,512 memory_debug.LogHostMemoryUsage:78  Current process:
(INFO) 2018-05-22 03:33:14,513 memory_debug._LogProcessInfo:41  50.8 MiB (pid=31286)
[  PASSED  ] 0 tests.
[  FAILED  ] 1 test, listed below:
[  FAILED  ]  speedometer-future/http://browserbench.org/Speedometer/
1 FAILED TEST

Comment 2 by sullivan@chromium.org, May 22 2018

Cc: hablich@chromium.org
Project Member

Comment 3 by bugdroid1@chromium.org, May 22 2018 

The following revision refers to this bug:
  https://chromium.googlesource.com/chromium/src.git/+/397b5d1f683259812e68b828f9981d412241b6ab

commit 397b5d1f683259812e68b828f9981d412241b6ab
Author: Annie Sullivan <sullivan@chromium.org>
Date: Tue May 22 15:27:33 2018

Disable speedometer*-future on Webview.

NOTRY=true

Bug:  845508 
Change-Id: If36f242f5e6258203724659d52858e5dc54468dd
TBR: charliea@chromium.org
cc: hablich@chromium.org
Reviewed-on: https://chromium-review.googlesource.com/1069121
Reviewed-by: Annie Sullivan <sullivan@chromium.org>
Commit-Queue: Annie Sullivan <sullivan@chromium.org>
Cr-Commit-Position: refs/heads/master@{#560598}
[modify] https://crrev.com/397b5d1f683259812e68b828f9981d412241b6ab/tools/perf/expectations.config
Project Member

Comment 4 by 42576172...@developer.gserviceaccount.com, May 23 2018

Cc: cbruni@chromium.org
Owner: cbruni@chromium.org
Status: Assigned (was: Available)
📍 Found a significant difference after 1 commit.
https://pinpoint-dot-chromeperf.appspot.com/job/16f4a6bc240000

Flush ICache on startup deserialization after marking memory executable by cbruni@chromium.org
https://chromium.googlesource.com/v8/v8/+/05bcb12e554ea86e6bb03aef9db3c2fe220296ed

Understanding performance regressions:
  http://g.co/ChromePerformanceRegressions
Project Member

Comment 6 by 42576172...@developer.gserviceaccount.com, May 23 2018 

😿 Pinpoint job stopped with an error.
https://pinpoint-dot-chromeperf.appspot.com/job/1682316c240000

Buildbucket says the build completed successfully, but Pinpoint can't find the isolate hash.

Comment 7 by cbruni@chromium.org, May 23 2018

Blocking: 845877

Comment 8 by cbruni@chromium.org, May 23 2018 

Going to revert my CL. Further investigation is happening on  issue 845877 .
Project Member

Comment 9 by bugdroid1@chromium.org, May 23 2018 

The following revision refers to this bug:
  https://chromium.googlesource.com/v8/v8.git/+/45fa14f061b6bd869201facc956e01b57430799e

commit 45fa14f061b6bd869201facc956e01b57430799e
Author: Camillo Bruni <cbruni@chromium.org>
Date: Wed May 23 14:01:22 2018

Revert "Flush ICache on startup deserialization after marking memory executable"

This reverts commit 05bcb12e554ea86e6bb03aef9db3c2fe220296ed.

Reason for revert: Causes isolate startup regressions ( https://crbug.com/845508 )

Original change's description:
> Flush ICache on startup deserialization after marking memory executable
>
> Tentative fix for Android invoke crashers with write protection code
> enabled.
>
> Bug: chromium:842862
> Change-Id: If238b25b239b50c597f3745aa683f564a717434f
> Reviewed-on: https://chromium-review.googlesource.com/1061513
> Reviewed-by: Jakob Gruber <jgruber@chromium.org>
> Reviewed-by: Michael Starzinger <mstarzinger@chromium.org>
> Commit-Queue: Camillo Bruni <cbruni@chromium.org>
> Cr-Commit-Position: refs/heads/master@{#53209}

TBR=mstarzinger@chromium.org,cbruni@chromium.org,jgruber@chromium.org

# Not skipping CQ checks because original CL landed > 1 day ago.

Bug: chromium:842862,  chromium:845508 ,  chromium:845877 
Change-Id: Iff002e1ac75aca48c696053dddf1b413f372629e
Reviewed-on: https://chromium-review.googlesource.com/1068048
Commit-Queue: Camillo Bruni <cbruni@chromium.org>
Reviewed-by: Camillo Bruni <cbruni@chromium.org>
Cr-Commit-Position: refs/heads/master@{#53305}
[modify] https://crrev.com/45fa14f061b6bd869201facc956e01b57430799e/src/isolate.cc
[modify] https://crrev.com/45fa14f061b6bd869201facc956e01b57430799e/src/snapshot/startup-deserializer.cc
[modify] https://crrev.com/45fa14f061b6bd869201facc956e01b57430799e/src/snapshot/startup-deserializer.h

Comment 10 by cbruni@chromium.org, May 23 2018

Owner: sullivan@google.com
Assigning back to sullivan@google.com to revert https://chromium-review.googlesource.com/1069121 since I'm not a chrome comitter.

Reverted the CL in question, benchmarks should run again.

Comment 11 by jgruber@chromium.org, May 23 2018

Cc: jgruber@chromium.org
I wonder if this is somehow related to  https://crbug.com/837640#c58 , also on webview / arm64 android.

Comment 12 by sullivan@chromium.org, May 23 2018

Owner: cbruni@chromium.org
Revert is in CQ, reassigning to cbruni to either close this issue or work on relanding.
Project Member

Comment 13 by bugdroid1@chromium.org, May 23 2018 

The following revision refers to this bug:
  https://chromium.googlesource.com/chromium/src.git/+/8f67b488761d353669994f0071b8c7c0ea7a7790

commit 8f67b488761d353669994f0071b8c7c0ea7a7790
Author: Annie Sullivan <sullivan@chromium.org>
Date: Wed May 23 15:20:48 2018

Revert "Disable speedometer*-future on Webview."

This reverts commit 397b5d1f683259812e68b828f9981d412241b6ab.

Reason for revert: Culprit CL reverted, test should work now!

Original change's description:
> Disable speedometer*-future on Webview.
> 
> NOTRY=true
> 
> Bug:  845508 
> Change-Id: If36f242f5e6258203724659d52858e5dc54468dd
> TBR: charliea@chromium.org
> cc: hablich@chromium.org
> Reviewed-on: https://chromium-review.googlesource.com/1069121
> Reviewed-by: Annie Sullivan <sullivan@chromium.org>
> Commit-Queue: Annie Sullivan <sullivan@chromium.org>
> Cr-Commit-Position: refs/heads/master@{#560598}

TBR=sullivan@chromium.org

Change-Id: I36fc6566898ed5da52fb3aad5c525acd6a1df706
No-Presubmit: true
No-Tree-Checks: true
No-Try: true
Bug:  845508 
Reviewed-on: https://chromium-review.googlesource.com/1069889
Reviewed-by: Annie Sullivan <sullivan@chromium.org>
Commit-Queue: Annie Sullivan <sullivan@chromium.org>
Cr-Commit-Position: refs/heads/master@{#561091}
[modify] https://crrev.com/8f67b488761d353669994f0071b8c7c0ea7a7790/tools/perf/expectations.config

Comment 14 by cbruni@chromium.org, May 28 2018

Summary: Android 32bit Flushing ICache Regression (was: speedometer-future and speedometer2-future timing out on Nexus5X WebView Perf)

Comment 15 by cbruni@chromium.org, May 28 2018

Cc: mstarzinger@chromium.org sunyunjia@chromium.org
 Issue 845918  has been merged into this issue.

Comment 16 by cbruni@chromium.org, May 28 2018

Status: Fixed (was: Assigned)

Comment 17 by yangguo@chromium.org, Jun 1 2018

Cc: njankovic@chromium.org shuqianz@chromium.org abod...@chromium.org hsiangc@chromium.org songsuk@chromium.org yangguo@chromium.org xiaoyinh@chromium.org llozano@chromium.org dhadd...@chromium.org abodenha@chromium.org cmt...@chromium.org mkarkada@chromium.org pucchakayala@chromium.org sky@chromium.org jrbarnette@chromium.org djkurtz@chromium.org yunlian@chromium.org avkodipelli@chromium.org ajha@chromium.org ibezmenov@chromium.org brajkumar@chromium.org
 Issue 845219  has been merged into this issue.

Comment 18 by yangguo@chromium.org, Jun 1 2018

Labels: Merge-Request-68
The breaking commit shipped with 6.8.239. The revert shipped with 6.8.284. But we cut the branch at 6.8.275, so this crash still affects M68.
Project Member

Comment 19 by sheriffbot@chromium.org, Jun 1 2018

Labels: -Merge-Request-68 Hotlist-Merge-Review Merge-Review-68
This bug requires manual review: Reverts referenced in bugdroid comments after merge request.
Please contact the milestone owner if you have questions.
Owners: cmasso@(Android), kariahda@(iOS), bhthompson@(ChromeOS), abdulsyed@(Desktop)

For more details visit https://www.chromium.org/issue-tracking/autotriage - Your friendly Sheriffbot

Comment 20 by abdulsyed@google.com, Jun 1 2018 

which OS(s) does this impact? Can you please mark it in bug so merge review can route appropriately.

Comment 21 by yangguo@chromium.org, Jun 1 2018

Labels: OS-Android OS-Chrome
Project Member

Comment 22 by bugdroid1@chromium.org, Jun 4 2018

Labels: merge-merged-6.8
The following revision refers to this bug:
  https://chromium.googlesource.com/v8/v8.git/+/1262d17586f35fb8991c9bfa90893af3d427a8df

commit 1262d17586f35fb8991c9bfa90893af3d427a8df
Author: Yang Guo <yangguo@chromium.org>
Date: Mon Jun 04 07:55:23 2018

Merged: Revert "Flush ICache on startup deserialization after marking memory executable"

Revision: 45fa14f061b6bd869201facc956e01b57430799e

BUG=chromium:842862, chromium:845508 , chromium:845877 , chromium:845219 
LOG=N
NOTRY=true
NOPRESUBMIT=true
NOTREECHECKS=true
TBR=cbruni@chromium.org

Change-Id: I4c140554b96038de6b34c572a6a6f307300bf557
Reviewed-on: https://chromium-review.googlesource.com/1084477
Reviewed-by: Yang Guo <yangguo@chromium.org>
Cr-Commit-Position: refs/branch-heads/6.8@{#9}
Cr-Branched-From: 44d7d7d6b1041b57644400a00cb3fee35f6c51b2-refs/heads/6.8.275@{#1}
Cr-Branched-From: 5754f66f75136dc17b4c63fec84f31dfdb89186e-refs/heads/master@{#53286}
[modify] https://crrev.com/1262d17586f35fb8991c9bfa90893af3d427a8df/src/isolate.cc
[modify] https://crrev.com/1262d17586f35fb8991c9bfa90893af3d427a8df/src/snapshot/startup-deserializer.cc
[modify] https://crrev.com/1262d17586f35fb8991c9bfa90893af3d427a8df/src/snapshot/startup-deserializer.h

Comment 23 by cma...@chromium.org, Jun 4 2018

Labels: -Hotlist-Merge-Review -Merge-Review-68 Merge-Approved-68

Comment 24 by yunlian@chromium.org, Jun 5 2018 

Who should modify the DEPS file in M68 branch?

Comment 25 by hablich@chromium.org, Jun 6 2018 

Not sure what you mean. The builders reference https://chromium.googlesource.com/v8/v8/+/refs/heads/6.8-lkgr which already has this change included.

Comment 26 by hablich@chromium.org, Jun 6 2018

Components: Blink>JavaScript

Comment 27 by yunlian@chromium.org, Jun 6 2018 

The elm release builder for R68 is green now. Thanks

Comment 28 by kkan...@chromium.org, Jun 7 2018

Status: Verified (was: Fixed)
Seeing Results for Elm on stainless. Marking it verified.
Project Member

Comment 29 by sheriffbot@chromium.org, Jun 8 2018

Cc: cma...@chromium.org
This issue has been approved for a merge. Please merge the fix to any appropriate branches as soon as possible!

If all merges have been completed, please remove any remaining Merge-Approved labels from this issue.

Thanks for your time! To disable nags, add the Disable-Nags label.

For more details visit https://www.chromium.org/issue-tracking/autotriage - Your friendly Sheriffbot

Comment 30 by yangguo@chromium.org, Jun 8 2018

Labels: -Merge-Approved-68
►

Sign in to add a comment