Closed Bug 1603319 Opened 6 years ago Closed 6 years ago

Intermittent TEST-UNEXPECTED-TIMEOUT | /webrtc/RTCDataChannelEvent-constructor.html | TestRunner hit external timeout (this may indicate a hang)

Categories

(Core :: WebRTC, defect, P5)

Product:
Core
Component:
WebRTC
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: ccoroiu [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=280767130&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/ZyeUsDlbS8meRtFQhcMlMQ/runs/0/artifacts/public/logs/live_backing.log

[task 2019-12-12T00:23:32.282Z] 00:23:32 INFO - TEST-START | /webrtc/RTCDataChannelEvent-constructor.html

task 2019-12-12T00:23:32.854Z] 00:23:32 INFO - PID 3536 | [Child 3557, Main Thread] WARNING: NS_ENSURE_TRUE(!mHasOrHasHadOwnerWindow || mOwnerWindow) failed: file /builds/worker/workspace/build/src/dom/events/DOMEventTargetHelper.cpp, line 321
[task 2019-12-12T00:23:32.854Z] 00:23:32 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deregistered 0x11b138c00 from the SCTP stack.
[task 2019-12-12T00:23:32.854Z] 00:23:32 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deregistered 0x11b13f400 from the SCTP stack.
[task 2019-12-12T00:23:32.855Z] 00:23:32 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deregistered 0x11b208c00 from the SCTP stack.
[task 2019-12-12T00:23:32.855Z] 00:23:32 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deregistered 0x11b20f800 from the SCTP stack.
[task 2019-12-12T00:23:32.855Z] 00:23:32 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deregistered 0x11b214400 from the SCTP stack.
[task 2019-12-12T00:23:32.855Z] 00:23:32 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deregistered 0x11b2f5800 from the SCTP stack.
[task 2019-12-12T00:23:32.855Z] 00:23:32 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deregistered 0x11b2fa400 from the SCTP stack.
[task 2019-12-12T00:23:32.855Z] 00:23:32 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deregistered 0x11b53d400 from the SCTP stack.
[task 2019-12-12T00:23:32.855Z] 00:23:32 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deregistered 0x11b541c00 from the SCTP stack.
[task 2019-12-12T00:23:32.865Z] 00:23:32 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deregistered 0x11b549c00 from the SCTP stack.
[task 2019-12-12T00:23:32.865Z] 00:23:32 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deregistered 0x11b678800 from the SCTP stack.
[task 2019-12-12T00:23:32.865Z] 00:23:32 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deregistered 0x11b76bc00 from the SCTP stack.
[task 2019-12-12T00:23:32.865Z] 00:23:32 INFO - PID 3536 | [Child 3557: Main Thread]: D/DataChannel Shutting down SCTP
[task 2019-12-12T00:24:02.223Z] 00:24:02 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deleting DataChannelConnection 0x11b680000
[task 2019-12-12T00:24:02.305Z] 00:24:02 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deleting DataChannelConnection 0x11a194400
[task 2019-12-12T00:24:02.305Z] 00:24:02 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deleting DataChannelConnection 0x11a197800
[task 2019-12-12T00:24:02.306Z] 00:24:02 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deleting DataChannelConnection 0x11abbf800
[task 2019-12-12T00:24:02.315Z] 00:24:02 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deleting DataChannelConnection 0x11a19ac00
[task 2019-12-12T00:24:02.315Z] 00:24:02 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deleting DataChannelConnection 0x11abc3800
[task 2019-12-12T00:24:02.315Z] 00:24:02 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deleting DataChannelConnection 0x11ae38800
[task 2019-12-12T00:24:02.315Z] 00:24:02 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deleting DataChannelConnection 0x11ae3e800
[task 2019-12-12T00:24:02.316Z] 00:24:02 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deleting DataChannelConnection 0x11b133800
[task 2019-12-12T00:24:02.316Z] 00:24:02 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deleting DataChannelConnection 0x11b138c00
[task 2019-12-12T00:24:02.316Z] 00:24:02 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deleting DataChannelConnection 0x11b13f400
[task 2019-12-12T00:24:02.316Z] 00:24:02 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deleting DataChannelConnection 0x11b208c00
[task 2019-12-12T00:24:02.316Z] 00:24:02 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deleting DataChannelConnection 0x11b20f800
[task 2019-12-12T00:24:02.316Z] 00:24:02 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deleting DataChannelConnection 0x11b214400
[task 2019-12-12T00:24:02.316Z] 00:24:02 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deleting DataChannelConnection 0x11b2f5800
[task 2019-12-12T00:24:02.317Z] 00:24:02 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deleting DataChannelConnection 0x11b2fa400
[task 2019-12-12T00:24:02.317Z] 00:24:02 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deleting DataChannelConnection 0x11b53d400
[task 2019-12-12T00:24:02.317Z] 00:24:02 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deleting DataChannelConnection 0x11b541c00
[task 2019-12-12T00:24:02.317Z] 00:24:02 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deleting DataChannelConnection 0x11b549c00
[task 2019-12-12T00:24:02.317Z] 00:24:02 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deleting DataChannelConnection 0x11b678800
[task 2019-12-12T00:24:02.317Z] 00:24:02 INFO - PID 3536 | [Child 3557: Socket Thread]: D/DataChannel Deleting DataChannelConnection 0x11b76bc00
[task 2019-12-12T00:24:17.240Z] 00:24:17 INFO - Got timeout in harness
[task 2019-12-12T00:24:17.241Z] 00:24:17 INFO - TEST-UNEXPECTED-TIMEOUT | /webrtc/RTCDataChannelEvent-constructor.html | TestRunner hit external timeout (this may indicate a hang)
[task 2019-12-12T00:24:17.241Z] 00:24:17 INFO - TEST-INFO took 45028ms
[task 2019-12-12T00:29:32.473Z] 00:29:32 INFO - IOError on command, setting status to CRASH
[task 2019-12-12T00:29:32.473Z] 00:29:32 WARNING - Traceback (most recent call last):
[task 2019-12-12T00:29:32.473Z] 00:29:32 WARNING - File "/Users/cltbld/tasks/task_1576107370/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/base.py", line 253, in run_test
[task 2019-12-12T00:29:32.473Z] 00:29:32 WARNING - result = self.do_test(test)
[task 2019-12-12T00:29:32.474Z] 00:29:32 WARNING - File "/Users/cltbld/tasks/task_1576107370/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/executormarionette.py", line 680, in do_test
[task 2019-12-12T00:29:32.474Z] 00:29:32 WARNING - assertion_count = self.protocol.asserts.get()
[task 2019-12-12T00:29:32.474Z] 00:29:32 WARNING - File "/Users/cltbld/tasks/task_1576107370/build/tests/web-platform/tests/tools/wptrunner/wptrunner/executors/executormarionette.py", line 369, in get
[task 2019-12-12T00:29:32.474Z] 00:29:32 WARNING - with self.marionette.using_context(self.marionette.CONTEXT_CHROME):
[task 2019-12-12T00:29:32.474Z] 00:29:32 WARNING - File "/usr/local/Cellar/python@2/2.7.16/Frameworks/Python.framework/Versions/2.7/lib/python2.7/contextlib.py", line 17, in enter
[task 2019-12-12T00:29:32.474Z] 00:29:32 WARNING - return self.gen.next()
[task 2019-12-12T00:29:32.474Z] 00:29:32 WARNING - File "/Users/cltbld/tasks/task_1576107370/build/venv/lib/python2.7/site-packages/marionette_driver/marionette.py", line 1327, in using_context
[task 2019-12-12T00:29:32.474Z] 00:29:32 WARNING - key="value")
[task 2019-12-12T00:29:32.474Z] 00:29:32 WARNING - File "/Users/cltbld/tasks/task_1576107370/build/venv/lib/python2.7/site-packages/marionette_driver/decorators.py", line 36, in _
[task 2019-12-12T00:29:32.474Z] 00:29:32 WARNING - m._handle_socket_failure()
[task 2019-12-12T00:29:32.474Z] 00:29:32 WARNING - File "/Users/cltbld/tasks/task_1576107370/build/venv/lib/python2.7/site-packages/marionette_driver/marionette.py", line 650, in _handle_socket_failure
[task 2019-12-12T00:29:32.474Z] 00:29:32 WARNING - reraise(exc, val, tb)
[task 2019-12-12T00:29:32.474Z] 00:29:32 WARNING - File "/Users/cltbld/tasks/task_1576107370/build/venv/lib/python2.7/site-packages/marionette_driver/decorators.py", line 26, in _
[task 2019-12-12T00:29:32.474Z] 00:29:32 WARNING - return func(*args, **kwargs)
[task 2019-12-12T00:29:32.474Z] 00:29:32 WARNING - File "/Users/cltbld/tasks/task_1576107370/build/venv/lib/python2.7/site-packages/marionette_driver/marionette.py", line 590, in _send_message
[task 2019-12-12T00:29:32.474Z] 00:29:32 WARNING - msg = self.client.request(name, params)
[task 2019-12-12T00:29:32.474Z] 00:29:32 WARNING - File "/Users/cltbld/tasks/task_1576107370/build/venv/lib/python2.7/site-packages/marionette_driver/transport.py", line 273, in request
[task 2019-12-12T00:29:32.475Z] 00:29:32 WARNING - return self.receive()
[task 2019-12-12T00:29:32.475Z] 00:29:32 WARNING - File "/Users/cltbld/tasks/task_1576107370/build/venv/lib/python2.7/site-packages/marionette_driver/transport.py", line 159, in receive
[task 2019-12-12T00:29:32.475Z] 00:29:32 WARNING - raise socket.error("No data received over socket")
[task 2019-12-12T00:29:32.475Z] 00:29:32 WARNING - error: No data received over socket

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → INCOMPLETE

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Status: REOPENED → RESOLVED
Closed: 6 years ago → 6 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.