Closed Bug 1471100 Opened 7 years ago Closed 7 years ago

Intermittent TEST-UNEXPECTED-TIMEOUT | devtools/client/inspector/markup/test/browser_markup_whitespace.js | application timed out after 370 seconds with no output

Categories

(DevTools :: Inspector, defect, P5)

Product:
DevTools
Component:
Inspector
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED DUPLICATE of bug 1471097

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: csabou [at] mozilla.com https://treeherder.mozilla.org/logviewer.html#?job_id=184828374&repo=mozilla-inbound https://queue.taskcluster.net/v1/task/HkvddccAQuSdvN-dt4UZnw/runs/0/artifacts/public/logs/live_backing.log [task 2018-06-26T01:30:56.171Z] 01:30:56 ERROR - TEST-UNEXPECTED-TIMEOUT | devtools/client/inspector/markup/test/browser_markup_whitespace.js | application timed out after 370 seconds with no output [task 2018-06-26T01:30:56.171Z] 01:30:56 ERROR - Force-terminating active process(es). [task 2018-06-26T01:30:56.172Z] 01:30:56 INFO - Determining child pids from psutil... [task 2018-06-26T01:30:56.181Z] 01:30:56 INFO - [] [task 2018-06-26T01:30:56.183Z] 01:30:56 INFO - ==> process 1752 launched child process 1774 [task 2018-06-26T01:30:56.183Z] 01:30:56 INFO - ==> process 1752 launched child process 1820 [task 2018-06-26T01:30:56.183Z] 01:30:56 INFO - ==> process 1752 launched child process 1864 [task 2018-06-26T01:30:56.183Z] 01:30:56 INFO - ==> process 1752 launched child process 1902 [task 2018-06-26T01:30:56.183Z] 01:30:56 INFO - ==> process 1752 launched child process 1932 [task 2018-06-26T01:30:56.183Z] 01:30:56 INFO - Found child pids: set([1864, 1932, 1820, 1902, 1774]) [task 2018-06-26T01:30:56.183Z] 01:30:56 INFO - Failed to get child procs [task 2018-06-26T01:30:56.183Z] 01:30:56 INFO - Killing process: 1864 [task 2018-06-26T01:30:56.183Z] 01:30:56 INFO - TEST-INFO | started process screentopng [task 2018-06-26T01:30:56.712Z] 01:30:56 INFO - TEST-INFO | screentopng: exit 0 [task 2018-06-26T01:30:56.716Z] 01:30:56 INFO - Can't trigger Breakpad, just killing process [task 2018-06-26T01:30:56.717Z] 01:30:56 INFO - Error: Failed to kill process 1864: psutil.NoSuchProcess no process found with pid 1864 [task 2018-06-26T01:30:56.718Z] 01:30:56 INFO - Killing process: 1932 [task 2018-06-26T01:30:56.719Z] 01:30:56 INFO - Not taking screenshot here: see the one that was previously logged [task 2018-06-26T01:30:56.719Z] 01:30:56 INFO - Can't trigger Breakpad, just killing process [task 2018-06-26T01:30:56.720Z] 01:30:56 INFO - Error: Failed to kill process 1932: psutil.NoSuchProcess no process found with pid 1932 [task 2018-06-26T01:30:56.720Z] 01:30:56 INFO - Killing process: 1820 [task 2018-06-26T01:30:56.720Z] 01:30:56 INFO - Not taking screenshot here: see the one that was previously logged [task 2018-06-26T01:30:56.721Z] 01:30:56 INFO - Can't trigger Breakpad, just killing process [task 2018-06-26T01:30:56.722Z] 01:30:56 INFO - Error: Failed to kill process 1820: psutil.NoSuchProcess no process found with pid 1820 [task 2018-06-26T01:30:56.722Z] 01:30:56 INFO - Killing process: 1902 [task 2018-06-26T01:30:56.722Z] 01:30:56 INFO - Not taking screenshot here: see the one that was previously logged [task 2018-06-26T01:30:56.723Z] 01:30:56 INFO - Can't trigger Breakpad, just killing process [task 2018-06-26T01:30:56.724Z] 01:30:56 INFO - Error: Failed to kill process 1902: psutil.NoSuchProcess no process found with pid 1902 [task 2018-06-26T01:30:56.724Z] 01:30:56 INFO - Killing process: 1774 [task 2018-06-26T01:30:56.725Z] 01:30:56 INFO - Not taking screenshot here: see the one that was previously logged [task 2018-06-26T01:30:56.725Z] 01:30:56 INFO - Can't trigger Breakpad, just killing process [task 2018-06-26T01:31:26.746Z] 01:31:26 INFO - failed to kill pid 1774 after 30s [task 2018-06-26T01:31:26.746Z] 01:31:26 INFO - Killing process: 1752 [task 2018-06-26T01:31:26.747Z] 01:31:26 INFO - Not taking screenshot here: see the one that was previously logged [task 2018-06-26T01:31:26.747Z] 01:31:26 INFO - Can't trigger Breakpad, just killing process [task 2018-06-26T01:31:26.751Z] 01:31:26 INFO - psutil found pid 1752 dead [task 2018-06-26T01:31:26.751Z] 01:31:26 INFO - psutil found pid 1752 dead [task 2018-06-26T01:31:26.787Z] 01:31:26 WARNING - runtests.py | Failed to get app exit code - running/crashed? [task 2018-06-26T01:31:26.788Z] 01:31:26 INFO - TEST-INFO | Main app process: exit 0 [task 2018-06-26T01:31:26.788Z] 01:31:26 INFO - runtests.py | Application ran for: 0:20:34.441422 [task 2018-06-26T01:31:26.789Z] 01:31:26 INFO - zombiecheck | Reading PID log: /tmp/tmpTdcrCWpidlog [task 2018-06-26T01:31:26.789Z] 01:31:26 INFO - ==> process 1752 launched child process 1774 [task 2018-06-26T01:31:26.790Z] 01:31:26 INFO - ==> process 1752 launched child process 1820 [task 2018-06-26T01:31:26.791Z] 01:31:26 INFO - ==> process 1752 launched child process 1864 [task 2018-06-26T01:31:26.792Z] 01:31:26 INFO - ==> process 1752 launched child process 1902 [task 2018-06-26T01:31:26.792Z] 01:31:26 INFO - ==> process 1752 launched child process 1932 [task 2018-06-26T01:31:26.793Z] 01:31:26 INFO - zombiecheck | Checking for orphan process with PID: 1864 [task 2018-06-26T01:31:26.794Z] 01:31:26 INFO - zombiecheck | Checking for orphan process with PID: 1932 [task 2018-06-26T01:31:26.794Z] 01:31:26 INFO - zombiecheck | Checking for orphan process with PID: 1820 [task 2018-06-26T01:31:26.795Z] 01:31:26 INFO - zombiecheck | Checking for orphan process with PID: 1902 [task 2018-06-26T01:31:26.795Z] 01:31:26 INFO - zombiecheck | Checking for orphan process with PID: 1774 [task 2018-06-26T01:31:26.796Z] 01:31:26 INFO - Stopping web server [task 2018-06-26T01:31:26.812Z] 01:31:26 INFO - Stopping web socket server [task 2018-06-26T01:31:26.833Z] 01:31:26 INFO - Stopping ssltunnel [task 2018-06-26T01:31:26.853Z] 01:31:26 WARNING - leakcheck | refcount logging is off, so leaks can't be detected! [task 2018-06-26T01:31:26.854Z] 01:31:26 INFO - runtests.py | Running tests: end. [task 2018-06-26T01:31:26.874Z] 01:31:26 INFO - Buffered messages finished [task 2018-06-26T01:31:26.875Z] 01:31:26 INFO - Running manifest: devtools/client/shared/components/test/browser/browser.ini [task 2018-06-26T01:31:26.876Z] 01:31:26 INFO - The following extra prefs will be set: [task 2018-06-26T01:31:26.876Z] 01:31:26 INFO - dom.animations-api.core.enabled=true [task 2018-06-26T01:31:26.912Z] 01:31:26 INFO - Setting pipeline to PAUSED ... [task 2018-06-26T01:31:26.912Z] 01:31:26 INFO - Pipeline is PREROLLING ... [task 2018-06-26T01:31:26.913Z] 01:31:26 INFO - Pipeline is PREROLLED ... [task 2018-06-26T01:31:26.913Z] 01:31:26 INFO - Setting pipeline to PLAYING ... [task 2018-06-26T01:31:26.913Z] 01:31:26 INFO - New clock: GstSystemClock [task 2018-06-26T01:31:26.941Z] 01:31:26 INFO - Got EOS from element "pipeline0". [task 2018-06-26T01:31:26.943Z] 01:31:26 INFO - Execution ended after 0:00:00.033492282 [task 2018-06-26T01:31:26.943Z] 01:31:26 INFO - Setting pipeline to PAUSED ... [task 2018-06-26T01:31:26.944Z] 01:31:26 INFO - Setting pipeline to READY ... [task 2018-06-26T01:31:26.944Z] 01:31:26 INFO - (gst-launch-1.0:2338): GStreamer-CRITICAL **: gst_object_unref: assertion '((GObject *) object)->ref_count > 0' failed [task 2018-06-26T01:31:26.944Z] 01:31:26 INFO - Setting pipeline to NULL ... [task 2018-06-26T01:31:26.944Z] 01:31:26 INFO - Freeing pipeline ...
Status: NEW → RESOLVED
Closed: 7 years ago
Resolution: --- → DUPLICATE
You need to log in before you can comment on or make changes to this bug.