Filed by sheriff-o-matic@appspot.gserviceaccount.com on behalf of sullivan@google.com
battor.trivial_pages/TrivialFullscreenVideoPageSharedPageState and 1 other(s) in battor.trivial_pages failing on multiple builders
Builders failed on:
- Mac 10.11 Perf:
https://build.chromium.org/p/chromium.perf/builders/Mac%2010.11%20Perf
- Mac Pro 10.11 Perf:
https://build.chromium.org/p/chromium.perf/builders/Mac%20Pro%2010.11%20Perf
Here are the errors I see in the logs:
https://logs.chromium.org/v/?s=chrome%2Fbb%2Fchromium.perf%2FMac_10.11_Perf%2F1762%2F%2B%2Frecipes%2Fsteps%2Fbattor.trivial_pages_on_Intel_GPU_on_Mac_on_Mac-10.11%2F0%2Fstdout
2018-01-28 22:10:43.208 Google Chrome[5151:38723] Errors logged by ksadmin: KSKeyedPersistentStore store directory does not exist. [com.google.UpdateEngine.CommonErrorDomain:501 - '/Library/Google/GoogleSoftwareUpdate/TicketStore' - 'KSKeyedPersistentStore.m:372']
KSPersistentTicketStore failed to load tickets. (productID: com.google.Chrome) [com.google.UpdateEngine.CoreErrorDomain:1051 - '/Library/Google/GoogleSoftwareUpdate/TicketStore/Keystone.ticketstore'] (KSKeyedPersistentStore store directory does not exist. - '/Library/Google/GoogleSoftwareUpdate/TicketStore' [com.google.UpdateEngine.CommonErrorDomain:501])
ksadmin cannot access the ticket store:<KSUpdateError:0x101110b60
domain="com.google.UpdateEngine.CoreErrorDomain"
code=1051
userInfo={
function = "-[KSProductKeyedStore(ProtectedMethods) errorForStoreError:productID:message:timeoutMessage:]";
date = 2018-01-29 06:10:43 +0000;
productids = {(
"com.google.Chrome"
)};
filename = "KSProductKeyedStore.m";
line = 91;
NSFilePath = "/Library/Google/GoogleSoftwareUpdate/TicketStore/Keystone.ticketstore";
NSUnderlyingError = <KSError:0x10110e9f0
domain="com.google.UpdateEngine.CommonErrorDomain"
code=501
userInfo={
date = 2018-01-29 06:10:43 +0000;
line = 372;
filename = "KSKeyedPersistentStore.m";
function = "-[KSKeyedPersistentStore(PrivateMethods) validateStorePath]";
NSFilePath = "/Library/Google/GoogleSoftwareUpdate/TicketStore";
NSLocalizedDescription = "KSKeyedPersistentStore store directory does not exist.";
}
>;
NSLocalizedDescription = "KSPersistentTicketStore failed to load tickets.";
}
>
(INFO) 2018-01-28 22:12:13,629 browser.DumpStateUponFailure:350 *********** END OF BROWSER STANDARD OUTPUT ************
(INFO) 2018-01-28 22:12:13,629 browser.DumpStateUponFailure:352 ********************* BROWSER LOG *********************
(INFO) 2018-01-28 22:12:13,629 browser.DumpStateUponFailure:354 No log file
(INFO) 2018-01-28 22:12:13,629 browser.DumpStateUponFailure:357 ***************** END OF BROWSER LOG ******************
(WARNING) 2018-01-28 22:12:13,707 artifact_results.AddArtifact:128 Moving artifact file '/b/s/w/it2BRX83/tmpvkFAIO.png' to '/b/s/w/it2BRX83/tmpgcjsvitelemetry/artifacts'
Traceback (most recent call last):
File "/b/s/w/ir/third_party/catapult/telemetry/telemetry/internal/story_runner.py", line 126, in _RunStoryAndProcessErrorIfNeeded
state.RunStory(results)
File "/b/s/w/ir/third_party/catapult/common/py_trace_event/py_trace_event/trace_event_impl/decorators.py", line 75, in traced_function
return func(*args, **kwargs)
File "/b/s/w/ir/third_party/catapult/telemetry/telemetry/page/shared_page_state.py", line 311, in RunStory
self._current_page.Run(self)
File "/b/s/w/ir/third_party/catapult/telemetry/telemetry/page/__init__.py", line 100, in Run
self.RunPageInteractions(action_runner)
File "/b/s/w/ir/tools/perf/page_sets/trivial_sites.py", line 104, in RunPageInteractions
action_runner.PressKey("Return")
File "/b/s/w/ir/third_party/catapult/common/py_trace_event/py_trace_event/trace_event_impl/decorators.py", line 75, in traced_function
return func(*args, **kwargs)
File "/b/s/w/ir/third_party/catapult/telemetry/telemetry/internal/actions/action_runner.py", line 662, in PressKey
self._RunAction(KeyPressAction(key, timeout=timeout))
File "/b/s/w/ir/third_party/catapult/common/py_trace_event/py_trace_event/trace_event_impl/decorators.py", line 75, in traced_function
return func(*args, **kwargs)
File "/b/s/w/ir/third_party/catapult/telemetry/telemetry/internal/actions/action_runner.py", line 62, in _RunAction
action.RunAction(self._tab)
File "/b/s/w/ir/third_party/catapult/common/py_trace_event/py_trace_event/trace_event_impl/decorators.py", line 75, in traced_function
return func(*args, **kwargs)
File "/b/s/w/ir/third_party/catapult/telemetry/telemetry/internal/actions/key_event.py", line 88, in RunAction
timeout=self._timeout)
File "/b/s/w/ir/third_party/catapult/common/py_trace_event/py_trace_event/trace_event_impl/decorators.py", line 75, in traced_function
return func(*args, **kwargs)
File "/b/s/w/ir/third_party/catapult/telemetry/telemetry/internal/browser/web_contents.py", line 392, in DispatchKeyEvent
is_system_key=is_system_key, timeout=timeout)
File "/b/s/w/ir/third_party/catapult/common/py_trace_event/py_trace_event/trace_event_impl/decorators.py", line 75, in traced_function
return func(*args, **kwargs)
File "/b/s/w/ir/third_party/catapult/telemetry/telemetry/internal/backends/chrome_inspector/inspector_backend.py", line 41, in Inner
inspector_backend._ConvertExceptionFromInspectorWebsocket(e)
File "/b/s/w/ir/third_party/catapult/common/py_trace_event/py_trace_event/trace_event_impl/decorators.py", line 75, in traced_function
return func(*args, **kwargs)
File "/b/s/w/ir/third_party/catapult/telemetry/telemetry/internal/backends/chrome_inspector/inspector_backend.py", line 38, in Inner
return func(inspector_backend, *args, **kwargs)
File "/b/s/w/ir/third_party/catapult/telemetry/telemetry/internal/backends/chrome_inspector/inspector_backend.py", line 448, in DispatchKeyEvent
return self._runtime.RunInspectorCommand(key_command, timeout)
File "/b/s/w/ir/third_party/catapult/telemetry/telemetry/internal/backends/chrome_inspector/inspector_runtime.py", line 94, in RunInspectorCommand
res = self._inspector_websocket.SyncRequest(command, timeout)
File "/b/s/w/ir/third_party/catapult/telemetry/telemetry/internal/backends/chrome_inspector/inspector_websocket.py", line 116, in SyncRequest
res = self._Receive(timeout)
File "/b/s/w/ir/third_party/catapult/telemetry/telemetry/internal/backends/chrome_inspector/inspector_websocket.py", line 155, in _Receive
data = self._socket.recv()
File "/b/s/w/ir/third_party/catapult/telemetry/third_party/websocket-client/websocket/_core.py", line 293, in recv
opcode, data = self.recv_data()
File "/b/s/w/ir/third_party/catapult/telemetry/third_party/websocket-client/websocket/_core.py", line 310, in recv_data
opcode, frame = self.recv_data_frame(control_frame)
File "/b/s/w/ir/third_party/catapult/telemetry/third_party/websocket-client/websocket/_core.py", line 323, in recv_data_frame
frame = self.recv_frame()
File "/b/s/w/ir/third_party/catapult/telemetry/third_party/websocket-client/websocket/_core.py", line 357, in recv_frame
return self.frame_buffer.recv_frame()
File "/b/s/w/ir/third_party/catapult/telemetry/third_party/websocket-client/websocket/_abnf.py", line 336, in recv_frame
self.recv_header()
File "/b/s/w/ir/third_party/catapult/telemetry/third_party/websocket-client/websocket/_abnf.py", line 286, in recv_header
header = self.recv_strict(2)
File "/b/s/w/ir/third_party/catapult/telemetry/third_party/websocket-client/websocket/_abnf.py", line 371, in recv_strict
bytes_ = self.recv(min(16384, shortage))
File "/b/s/w/ir/third_party/catapult/telemetry/third_party/websocket-client/websocket/_core.py", line 427, in _recv
return recv(self.sock, bufsize)
File "/b/s/w/ir/third_party/catapult/telemetry/third_party/websocket-client/websocket/_socket.py", line 83, in recv
raise WebSocketTimeoutException(message)
TimeoutException: <unprintable TimeoutException object>
(INFO) 2018-01-28 22:12:43,715 devtools_client_backend._IsDevToolsAgentAvailable:145 Devtools client not yet ready: timed out
(INFO) 2018-01-28 22:12:43,716 exception_formatter.PrintFormattedException:19 Try printing formatted exception: None None None
Exception raised when cleaning story run:
Traceback (most recent call last):
_RunStoryAndProcessErrorIfNeeded at /b/s/w/ir/third_party/catapult/telemetry/telemetry/internal/story_runner.py:151
test.DidRunStory(state.platform, results)
DidRunStory at /b/s/w/ir/third_party/catapult/telemetry/telemetry/web_perf/timeline_based_measurement.py:290
trace_result, _ = platform.tracing_controller.StopTracing()
StopTracing at /b/s/w/ir/third_party/catapult/telemetry/telemetry/core/tracing_controller.py:53
return self._tracing_controller_backend.StopTracing()
StopTracing at /b/s/w/ir/third_party/catapult/telemetry/telemetry/internal/platform/tracing_controller_backend.py:109
self._IssueClockSyncMarker()
_IssueClockSyncMarker at /b/s/w/ir/third_party/catapult/telemetry/telemetry/internal/platform/tracing_controller_backend.py:215
self._RecordIssuerClockSyncMarker)
RecordClockSyncMarker at /b/s/w/ir/third_party/catapult/telemetry/telemetry/internal/platform/tracing_agent/chrome_tracing_agent.py:178
raise ChromeClockSyncError('Cannot issue clock sync. No devtools clients')
ChromeClockSyncError: Cannot issue clock sync. No devtools clients
Locals:
devtools_clients : []
record_controller_clock_sync_marker_callback : <bound method TracingControllerBackend._RecordIssuerClockSyncMarker of <telemetry.internal.platform.tracing_controller_backend.TracingControllerBackend object at 0x10bd16c50>>
sync_id : '4aeee488-2649-4169-a689-5243fe836355'
[ FAILED ] TrivialFullscreenVideoPageSharedPageState (120961 ms)
Comment 1 by sullivan@chromium.org
, Jan 29 2018