Closed
Bug 1306175
Opened 8 years ago
Closed 6 years ago
Intermittent TEST-UNEXPECTED-TIMEOUT | dom/media/tests/mochitest/test_peerConnection_remoteRollback.html | application timed out after 330 seconds with no output
Categories
(Core :: WebRTC, defect, P3)
Core
WebRTC
Tracking
()
RESOLVED
INCOMPLETE
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure)
Filed by: philringnalda [at] gmail.com https://treeherder.mozilla.org/logviewer.html#?job_id=36666136&repo=mozilla-inbound https://queue.taskcluster.net/v1/task/PYd1DmXdSBqTp-Ex9qkv3A/runs/0/artifacts/public%2Flogs%2Flive_backing.log
Updated•8 years ago
|
Rank: 35
Priority: -- → P3
Updated•8 years ago
|
Status: NEW → RESOLVED
Closed: 8 years ago
Resolution: --- → DUPLICATE
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment 4•6 years ago
|
||
Recent failure log: https://treeherder.mozilla.org/logviewer.html#?job_id=161810256&repo=autoland&lineNumber=5647 [task 2018-02-12T22:42:54.012Z] 22:42:54 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_remoteRollback.html | loopback interface is absent from SDP [task 2018-02-12T22:42:54.012Z] 22:42:54 INFO - No ICE candidate in SDP -> requiring trickle ICE [task 2018-02-12T22:42:54.013Z] 22:42:54 INFO - expected audio tracks: 1 [task 2018-02-12T22:42:54.014Z] 22:42:54 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_remoteRollback.html | audio m-line is present in SDP [task 2018-02-12T22:42:54.015Z] 22:42:54 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_remoteRollback.html | OPUS codec is present in SDP [task 2018-02-12T22:42:54.016Z] 22:42:54 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_remoteRollback.html | RTCP Mux is offered in SDP [task 2018-02-12T22:42:54.017Z] 22:42:54 INFO - expected video tracks: 0 [task 2018-02-12T22:42:54.018Z] 22:42:54 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_remoteRollback.html | video m-line is absent from SDP [task 2018-02-12T22:42:54.019Z] 22:42:54 INFO - Run step 48: PC_LOCAL_CHECK_CAN_TRICKLE_SYNC [task 2018-02-12T22:42:54.019Z] 22:42:54 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_remoteRollback.html | Local thinks that remote can trickle [task 2018-02-12T22:42:54.020Z] 22:42:54 INFO - Run step 49: PC_LOCAL_WAIT_FOR_ICE_CONNECTED [task 2018-02-12T22:42:54.021Z] 22:42:54 INFO - TEST-PASS | dom/media/tests/mochitest/test_peerConnection_remoteRollback.html | iceGetheringState should not be undefined [task 2018-02-12T22:42:54.022Z] 22:42:54 INFO - PeerConnectionWrapper (pcLocal): onicegatheringstatechange fired, new state is: gathering [task 2018-02-12T22:42:54.023Z] 22:42:54 INFO - Buffered messages finished [task 2018-02-12T22:42:54.024Z] 22:42:54 ERROR - TEST-UNEXPECTED-TIMEOUT | dom/media/tests/mochitest/test_peerConnection_remoteRollback.html | application timed out after 370 seconds with no output [task 2018-02-12T22:42:54.025Z] 22:42:54 ERROR - Force-terminating active process(es). [task 2018-02-12T22:42:54.026Z] 22:42:54 INFO - Determining child pids from psutil... [task 2018-02-12T22:42:54.027Z] 22:42:54 INFO - [1158] [task 2018-02-12T22:42:54.028Z] 22:42:54 INFO - ==> process 1062 launched child process 1084 [task 2018-02-12T22:42:54.029Z] 22:42:54 INFO - ==> process 1062 launched child process 1116 [task 2018-02-12T22:42:54.030Z] 22:42:54 INFO - ==> process 1062 launched child process 1158 [task 2018-02-12T22:42:54.031Z] 22:42:54 INFO - ==> process 1062 launched child process 1411 [task 2018-02-12T22:42:54.032Z] 22:42:54 INFO - Found child pids: set([1116, 1411, 1084, 1158]) [task 2018-02-12T22:42:54.033Z] 22:42:54 INFO - Failed to get child procs [task 2018-02-12T22:42:54.034Z] 22:42:54 INFO - Killing process: 1116 [task 2018-02-12T22:42:54.035Z] 22:42:54 INFO - TEST-INFO | started process screentopng [task 2018-02-12T22:42:54.239Z] 22:42:54 INFO - TEST-INFO | screentopng: exit 0 [task 2018-02-12T22:42:54.239Z] 22:42:54 INFO - Can't trigger Breakpad, process no longer exists [task 2018-02-12T22:42:54.240Z] 22:42:54 INFO - Killing process: 1411 [task 2018-02-12T22:42:54.240Z] 22:42:54 INFO - Not taking screenshot here: see the one that was previously logged [task 2018-02-12T22:42:54.241Z] 22:42:54 INFO - Can't trigger Breakpad, process no longer exists [task 2018-02-12T22:42:54.241Z] 22:42:54 INFO - Killing process: 1084 [task 2018-02-12T22:42:54.242Z] 22:42:54 INFO - Not taking screenshot here: see the one that was previously logged [task 2018-02-12T22:42:54.242Z] 22:42:54 INFO - Can't trigger Breakpad, process no longer exists [task 2018-02-12T22:42:54.242Z] 22:42:54 INFO - Killing process: 1158 [task 2018-02-12T22:42:54.243Z] 22:42:54 INFO - Not taking screenshot here: see the one that was previously logged [task 2018-02-12T22:42:54.243Z] 22:42:54 INFO - Killing process: 1062 [task 2018-02-12T22:42:54.243Z] 22:42:54 INFO - Not taking screenshot here: see the one that was previously logged [task 2018-02-12T22:42:54.373Z] 22:42:54 INFO - psutil found pid 1062 dead [task 2018-02-12T22:42:54.495Z] 22:42:54 WARNING - runtests.py | Failed to get app exit code - running/crashed? [task 2018-02-12T22:42:54.496Z] 22:42:54 INFO - TEST-INFO | Main app process: exit 0 [task 2018-02-12T22:42:54.497Z] 22:42:54 INFO - runtests.py | Application ran for: 0:06:57.680660 [task 2018-02-12T22:42:54.498Z] 22:42:54 INFO - zombiecheck | Reading PID log: /tmp/tmp9udN78pidlog [task 2018-02-12T22:42:54.498Z] 22:42:54 INFO - ==> process 1062 launched child process 1084 [task 2018-02-12T22:42:54.498Z] 22:42:54 INFO - ==> process 1062 launched child process 1116 [task 2018-02-12T22:42:54.499Z] 22:42:54 INFO - ==> process 1062 launched child process 1158 [task 2018-02-12T22:42:54.500Z] 22:42:54 INFO - ==> process 1062 launched child process 1411 [task 2018-02-12T22:42:54.500Z] 22:42:54 INFO - zombiecheck | Checking for orphan process with PID: 1116 [task 2018-02-12T22:42:54.501Z] 22:42:54 INFO - zombiecheck | Checking for orphan process with PID: 1411 [task 2018-02-12T22:42:54.502Z] 22:42:54 INFO - zombiecheck | Checking for orphan process with PID: 1084 [task 2018-02-12T22:42:54.502Z] 22:42:54 INFO - zombiecheck | Checking for orphan process with PID: 1158 [task 2018-02-12T22:42:54.503Z] 22:42:54 INFO - mozcrash Downloading symbols from: https://queue.taskcluster.net/v1/task/KbpFuMOcTG-AqFyKCB3b_A/artifacts/public/build/target.crashreporter-symbols.zip [task 2018-02-12T22:42:59.841Z] 22:42:59 INFO - mozcrash Copy/paste: /usr/local/bin/linux64-minidump_stackwalk /tmp/tmpIhWqmM.mozrunner/minidumps/0f3d1d8d-b36b-2777-4407-c23c216a5c70.dmp /tmp/tmpsNORo2 [task 2018-02-12T22:43:05.864Z] 22:43:05 INFO - mozcrash Saved minidump as /builds/worker/workspace/build/blobber_upload_dir/0f3d1d8d-b36b-2777-4407-c23c216a5c70.dmp [task 2018-02-12T22:43:05.864Z] 22:43:05 INFO - mozcrash Saved app info as /builds/worker/workspace/build/blobber_upload_dir/0f3d1d8d-b36b-2777-4407-c23c216a5c70.extra [task 2018-02-12T22:43:05.925Z] 22:43:05 INFO - PROCESS-CRASH | Main app process exited normally | application crashed [@ libc-2.23.so + 0xfb74d] [task 2018-02-12T22:43:05.926Z] 22:43:05 INFO - Crash dump filename: /tmp/tmpIhWqmM.mozrunner/minidumps/0f3d1d8d-b36b-2777-4407-c23c216a5c70.dmp [task 2018-02-12T22:43:05.926Z] 22:43:05 INFO - Operating system: Linux [task 2018-02-12T22:43:05.928Z] 22:43:05 INFO - 0.0.0 Linux 4.4.0-98-generic #121~14.04.1-Ubuntu SMP Wed Oct 11 11:54:55 UTC 2017 x86_64 [task 2018-02-12T22:43:05.928Z] 22:43:05 INFO - CPU: amd64 [task 2018-02-12T22:43:05.929Z] 22:43:05 INFO - family 6 model 62 stepping 4 [task 2018-02-12T22:43:05.930Z] 22:43:05 INFO - 2 CPUs [task 2018-02-12T22:43:05.931Z] 22:43:05 INFO - [task 2018-02-12T22:43:05.932Z] 22:43:05 INFO - GPU: UNKNOWN [task 2018-02-12T22:43:05.933Z] 22:43:05 INFO - [task 2018-02-12T22:43:05.934Z] 22:43:05 INFO - Crash reason: SIGABRT [task 2018-02-12T22:43:05.935Z] 22:43:05 INFO - Crash address: 0x3e8000003e4 [task 2018-02-12T22:43:05.936Z] 22:43:05 INFO - Process uptime: not available [task 2018-02-12T22:43:05.936Z] 22:43:05 INFO - [task 2018-02-12T22:43:05.937Z] 22:43:05 INFO - Thread 0 (crashed) [task 2018-02-12T22:43:05.937Z] 22:43:05 INFO - 0 libc-2.23.so + 0xfb74d [task 2018-02-12T22:43:05.938Z] 22:43:05 INFO - rax = 0xfffffffffffffffc rdx = 0x00000000ffffffff [task 2018-02-12T22:43:05.938Z] 22:43:05 INFO - rcx = 0x00007f53b836e74d rbx = 0x00007f5388b4ac70 [task 2018-02-12T22:43:05.939Z] 22:43:05 INFO - rsi = 0x0000000000000005 rdi = 0x00007f5388b4ac70 [task 2018-02-12T22:43:05.939Z] 22:43:05 INFO - rbp = 0x00007ffd7f5a52a0 rsp = 0x00007ffd7f5a5270 [task 2018-02-12T22:43:05.939Z] 22:43:05 INFO - r8 = 0x0000000000000005 r9 = 0x0000000000000001 [task 2018-02-12T22:43:05.940Z] 22:43:05 INFO - r10 = 0x00007f5388d8a660 r11 = 0x0000000000000293 [task 2018-02-12T22:43:05.942Z] 22:43:05 INFO - r12 = 0x0000000000000005 r13 = 0x00000000ffffffff [task 2018-02-12T22:43:05.942Z] 22:43:05 INFO - r14 = 0x00007f53aa958af0 r15 = 0x0000000000000005 [task 2018-02-12T22:43:05.943Z] 22:43:05 INFO - rip = 0x00007f53b836e74d [task 2018-02-12T22:43:05.943Z] 22:43:05 INFO - Found by: given as instruction pointer in context [task 2018-02-12T22:43:05.943Z] 22:43:05 INFO - 1 libxul.so!PollWrapper [nsAppShell.cpp:f1cc283d848558ef6e477bb4b8bd33770555ca92 : 53 + 0xf] [task 2018-02-12T22:43:05.944Z] 22:43:05 INFO - rbp = 0x00007ffd7f5a52a0 rsp = 0x00007ffd7f5a5280 [task 2018-02-12T22:43:05.945Z] 22:43:05 INFO - rip = 0x00007f53aa958b1f [task 2018-02-12T22:43:05.945Z] 22:43:05 INFO - Found by: stack scanning [task 2018-02-12T22:43:05.945Z] 22:43:05 INFO - 2 libglib-2.0.so.0.4800.2 + 0x4a38c [task 2018-02-12T22:43:05.945Z] 22:43:05 INFO - rbx = 0x00007f53b80db2f0 rbp = 0x0000000000000005 [task 2018-02-12T22:43:05.946Z] 22:43:05 INFO - rsp = 0x00007ffd7f5a52b0 r12 = 0x00007f5388b4ac70 [task 2018-02-12T22:43:05.946Z] 22:43:05 INFO - r13 = 0x00000000ffffffff rip = 0x00007f53b316e38c [task 2018-02-12T22:43:05.947Z] 22:43:05 INFO - Found by: call frame info [task 2018-02-12T22:43:05.947Z] 22:43:05 INFO - 3 libglib-2.0.so.0.4800.2 + 0x4a49c [task 2018-02-12T22:43:05.948Z] 22:43:05 INFO - rsp = 0x00007ffd7f5a5310 rip = 0x00007f53b316e49c [task 2018-02-12T22:43:05.948Z] 22:43:05 INFO - Found by: stack scanning [task 2018-02-12T22:43:05.949Z] 22:43:05 INFO - 4 libxul.so!nsAppShell::ProcessNextNativeEvent [nsAppShell.cpp:f1cc283d848558ef6e477bb4b8bd33770555ca92 : 295 + 0x5] [task 2018-02-12T22:43:05.949Z] 22:43:05 INFO - rsp = 0x00007ffd7f5a5330 rip = 0x00007f53aa958adf [task 2018-02-12T22:43:05.950Z] 22:43:05 INFO - Found by: stack scanning [task 2018-02-12T22:43:05.950Z] 22:43:05 INFO - 5 libxul.so!nsBaseAppShell::OnProcessNextEvent(nsIThreadInternal*, bool) + 0x289 [task 2018-02-12T22:43:05.951Z] 22:43:05 INFO - rsp = 0x00007ffd7f5a5340 rip = 0x00007f53aa956289 [task 2018-02-12T22:43:05.951Z] 22:43:05 INFO - Found by: stack scanning [task 2018-02-12T22:43:08.040Z] 22:43:08 INFO - mozcrash Copy/paste: /usr/local/bin/linux64-minidump_stackwalk /tmp/tmpIhWqmM.mozrunner/minidumps/2d067658-e8e9-897d-ace2-a022e69aed5e.dmp /tmp/tmpsNORo2 [task 2018-02-12T22:43:13.472Z] 22:43:13 INFO - mozcrash Saved minidump as /builds/worker/workspace/build/blobber_upload_dir/2d067658-e8e9-897d-ace2-a022e69aed5e.dmp [task 2018-02-12T22:43:13.474Z] 22:43:13 INFO - mozcrash Saved app info as /builds/worker/workspace/build/blobber_upload_dir/2d067658-e8e9-897d-ace2-a022e69aed5e.extra [task 2018-02-12T22:43:13.522Z] 22:43:13 INFO - PROCESS-CRASH | Main app process exited normally | application crashed [@ mozilla::NrUdpSocketIpc::create] [task 2018-02-12T22:43:13.523Z] 22:43:13 INFO - Crash dump filename: /tmp/tmpIhWqmM.mozrunner/minidumps/2d067658-e8e9-897d-ace2-a022e69aed5e.dmp [task 2018-02-12T22:43:13.523Z] 22:43:13 INFO - Operating system: Linux [task 2018-02-12T22:43:13.524Z] 22:43:13 INFO - 0.0.0 Linux 4.4.0-98-generic #121~14.04.1-Ubuntu SMP Wed Oct 11 11:54:55 UTC 2017 x86_64 [task 2018-02-12T22:43:13.524Z] 22:43:13 INFO - CPU: amd64 [task 2018-02-12T22:43:13.524Z] 22:43:13 INFO - family 6 model 62 stepping 4 [task 2018-02-12T22:43:13.524Z] 22:43:13 INFO - 2 CPUs [task 2018-02-12T22:43:13.525Z] 22:43:13 INFO - [task 2018-02-12T22:43:13.525Z] 22:43:13 INFO - GPU: UNKNOWN [task 2018-02-12T22:43:13.526Z] 22:43:13 INFO - [task 2018-02-12T22:43:13.526Z] 22:43:13 INFO - Crash reason: SIGSEGV [task 2018-02-12T22:43:13.527Z] 22:43:13 INFO - Crash address: 0x0 [task 2018-02-12T22:43:13.527Z] 22:43:13 INFO - Process uptime: not available [task 2018-02-12T22:43:13.527Z] 22:43:13 INFO - [task 2018-02-12T22:43:13.527Z] 22:43:13 INFO - Thread 5 (crashed) [task 2018-02-12T22:43:13.528Z] 22:43:13 INFO - 0 libxul.so!mozilla::NrUdpSocketIpc::create [nsIEventTarget.h: : 37 + 0x0] [task 2018-02-12T22:43:13.528Z] 22:43:13 INFO - rax = 0x00007ff3fb268b00 rdx = 0x0000000000000003 [task 2018-02-12T22:43:13.529Z] 22:43:13 INFO - rcx = 0x00007ff4178d3244 rbx = 0x00007ff3fcf3d000 [task 2018-02-12T22:43:13.529Z] 22:43:13 INFO - rsi = 0x00007ff3f48fb1ec rdi = 0x00007ff3fcf3d000 [task 2018-02-12T22:43:13.530Z] 22:43:13 INFO - rbp = 0x00007ff40d0f0890 rsp = 0x00007ff40d0f0810 [task 2018-02-12T22:43:13.530Z] 22:43:13 INFO - r8 = 0x00007ff4178d3244 r9 = 0x0000000000000000 [task 2018-02-12T22:43:13.531Z] 22:43:13 INFO - r10 = 0x0000000000000001 r11 = 0x00007ff3fb268004 [task 2018-02-12T22:43:13.531Z] 22:43:13 INFO - r12 = 0x0000000000000000 r13 = 0x00007ff3fb268b00 [task 2018-02-12T22:43:13.532Z] 22:43:13 INFO - r14 = 0x00007ff40d0f0840 r15 = 0x00007ff40d0f0850 [task 2018-02-12T22:43:13.532Z] 22:43:13 INFO - rip = 0x00007ff414889cb7 [task 2018-02-12T22:43:13.533Z] 22:43:13 INFO - Found by: given as instruction pointer in context [task 2018-02-12T22:43:13.533Z] 22:43:13 INFO - 1 libxul.so!mozilla::NrSocketBase::CreateSocket [nr_socket_prsock.cpp:f1cc283d848558ef6e477bb4b8bd33770555ca92 : 2185 + 0xa] [task 2018-02-12T22:43:13.533Z] 22:43:13 INFO - rbx = 0x00007ff3fcf3d000 rbp = 0x00007ff40d0f08d0 [task 2018-02-12T22:43:13.534Z] 22:43:13 INFO - rsp = 0x00007ff40d0f08a0 r12 = 0x00007ff40d0f08e8 [task 2018-02-12T22:43:13.535Z] 22:43:13 INFO - r13 = 0x00007ff40d0f0ac0 r14 = 0x00007ff418d2a758 [task 2018-02-12T22:43:13.535Z] 22:43:13 INFO - r15 = 0x00007ff3f4808bcc rip = 0x00007ff41488b74f [task 2018-02-12T22:43:13.536Z] 22:43:13 INFO - Found by: call frame info [task 2018-02-12T22:43:13.536Z] 22:43:13 INFO - 2 libxul.so!nr_socket_local_create [nr_socket_prsock.cpp:f1cc283d848558ef6e477bb4b8bd33770555ca92 : 2201 + 0x5] [task 2018-02-12T22:43:13.537Z] 22:43:13 INFO - rbx = 0x00007ff40d0f1170 rbp = 0x00007ff40d0f0900 [task 2018-02-12T22:43:13.537Z] 22:43:13 INFO - rsp = 0x00007ff40d0f08e0 r12 = 0x00007ff40d0f0928 [task 2018-02-12T22:43:13.538Z] 22:43:13 INFO - r13 = 0x00007ff40d0f0928 r14 = 0x0000000000000000 [task 2018-02-12T22:43:13.538Z] 22:43:13 INFO - r15 = 0x00007ff3f4808bcc rip = 0x00007ff41488b79f [task 2018-02-12T22:43:13.538Z] 22:43:13 INFO - Found by: call frame info [task 2018-02-12T22:43:13.539Z] 22:43:13 INFO - 3 libxul.so!nr_ice_get_default_local_address [ice_ctx.c:f1cc283d848558ef6e477bb4b8bd33770555ca92 : 651 + 0x13] [task 2018-02-12T22:43:13.539Z] 22:43:13 INFO - rbx = 0x00007ff40d0f1170 rbp = 0x00007ff40d0f0e10 [task 2018-02-12T22:43:13.540Z] 22:43:13 INFO - rsp = 0x00007ff40d0f0910 r12 = 0x00007ff40d0f0e40 [task 2018-02-12T22:43:13.540Z] 22:43:13 INFO - r13 = 0x00007ff40d0f0928 r14 = 0x0000000000000000 [task 2018-02-12T22:43:13.541Z] 22:43:13 INFO - r15 = 0x00007ff3f4808bcc rip = 0x00007ff41624d437 [task 2018-02-12T22:43:13.541Z] 22:43:13 INFO - Found by: call frame info [task 2018-02-12T22:43:13.542Z] 22:43:13 INFO - 4 libxul.so!nr_ice_set_local_addresses [ice_ctx.c:f1cc283d848558ef6e477bb4b8bd33770555ca92 : 755 + 0x1a] [task 2018-02-12T22:43:13.542Z] 22:43:13 INFO - rbx = 0x00007ff3f4808bcc rbp = 0x00007ff40d0fb100 [task 2018-02-12T22:43:13.542Z] 22:43:13 INFO - rsp = 0x00007ff40d0f0e20 r12 = 0x0000000000000000 [task 2018-02-12T22:43:13.543Z] 22:43:13 INFO - r13 = 0x00007ff40d0f0e40 r14 = 0x00007ff40d0f1170 [task 2018-02-12T22:43:13.543Z] 22:43:13 INFO - r15 = 0x00007ff40d0f1170 rip = 0x00007ff41624e34a [task 2018-02-12T22:43:13.544Z] 22:43:13 INFO - Found by: call frame info [task 2018-02-12T22:43:13.544Z] 22:43:13 INFO - 5 libxul.so!NR_async_timer_set [nr_timer.cpp:f1cc283d848558ef6e477bb4b8bd33770555ca92 : 237 + 0x16] [task 2018-02-12T22:43:13.545Z] 22:43:13 INFO - rbp = 0x00007ff40d0fb100 rsp = 0x00007ff40d0f0e50 [task 2018-02-12T22:43:13.545Z] 22:43:13 INFO - rip = 0x00007ff41488bc87 [task 2018-02-12T22:43:13.546Z] 22:43:13 INFO - Found by: stack scanning
Status: RESOLVED → REOPENED
Resolution: DUPLICATE → ---
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment hidden (Intermittent Failures Robot) |
Comment 8•6 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
Status: REOPENED → RESOLVED
Closed: 8 years ago → 6 years ago
Resolution: --- → INCOMPLETE
You need to log in
before you can comment on or make changes to this bug.
Description
•