Closed Bug 1724676 Opened 4 years ago Closed 4 years ago

Intermittent layout/base/tests/test_reftests_with_caret.html | application terminated with exit code 1

Categories

(Core :: Layout, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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


[task 2021-08-09T07:24:09.139Z] 07:24:09     INFO - TEST-START | layout/base/tests/test_reftests_with_caret.html
[task 2021-08-09T07:24:34.989Z] 07:24:34     INFO - GECKO(20006) | JavaScript error: resource://autofill/FormAutofillHandler.jsm, line 1232: TypeError: can't access property "windowUtils", this.window is null
[task 2021-08-09T07:24:40.301Z] 07:24:40     INFO - GECKO(20006) | Gdk-Message: 07:24:40.300: firefox: Fatal IO error 11 (Resource temporarily unavailable) on X server :0.
[task 2021-08-09T07:24:40.326Z] 07:24:40     INFO - GECKO(20006) | Exiting due to channel error.
[task 2021-08-09T07:24:40.326Z] 07:24:40     INFO - GECKO(20006) | Exiting due to channel error.
[task 2021-08-09T07:24:40.352Z] 07:24:40     INFO - GECKO(20006) | Exiting due to channel error.
[task 2021-08-09T07:24:40.353Z] 07:24:40     INFO - GECKO(20006) | Exiting due to channel error.
[task 2021-08-09T07:24:40.354Z] 07:24:40     INFO - GECKO(20006) | Exiting due to channel error.
[task 2021-08-09T07:24:40.354Z] 07:24:40     INFO - GECKO(20006) | Exiting due to channel error.
[task 2021-08-09T07:24:40.357Z] 07:24:40     INFO - GECKO(20006) | Exiting due to channel error.
[task 2021-08-09T07:24:40.377Z] 07:24:40     INFO - TEST-INFO | Main app process: exit 1
[task 2021-08-09T07:24:40.377Z] 07:24:40     INFO - Buffered messages logged at 07:24:09
[task 2021-08-09T07:24:40.377Z] 07:24:40     INFO - must wait for load
[task 2021-08-09T07:24:40.378Z] 07:24:40     INFO - TEST-PASS | layout/base/tests/test_reftests_with_caret.html | reftest comparison: == http://mochi.test:8888/tests/layout/base/tests/bug106855-1.html http://mochi.test:8888/tests/layout/base/tests/bug106855-1-ref.html 
<...>
[task 2021-08-09T07:24:40.594Z] 07:24:40     INFO - TEST-PASS | layout/base/tests/test_reftests_with_caret.html | reftest comparison: == http://mochi.test:8888/tests/layout/base/tests/bug1637476-2.html http://mochi.test:8888/tests/layout/base/tests/bug1637476-2-ref.html 
[task 2021-08-09T07:24:40.594Z] 07:24:40     INFO - Buffered messages finished
[task 2021-08-09T07:24:40.594Z] 07:24:40    ERROR - TEST-UNEXPECTED-FAIL | layout/base/tests/test_reftests_with_caret.html | application terminated with exit code 1
[task 2021-08-09T07:24:40.595Z] 07:24:40     INFO - runtests.py | Application ran for: 0:01:22.504471
[task 2021-08-09T07:24:40.595Z] 07:24:40     INFO - zombiecheck | Reading PID log: /tmp/tmpxujuwkx6pidlog
[task 2021-08-09T07:24:40.595Z] 07:24:40     INFO - ==> process 20006 launched child process 20025
<...>
[task 2021-08-09T07:24:40.696Z] 07:24:40     INFO - zombiecheck | Checking for orphan process with PID: 22521
[task 2021-08-09T07:24:40.697Z] 07:24:40     INFO - Stopping web server
[task 2021-08-09T07:24:40.697Z] 07:24:40     INFO - Server shut down.
[task 2021-08-09T07:24:40.698Z] 07:24:40     INFO - Web server killed.
[task 2021-08-09T07:24:40.699Z] 07:24:40     INFO - Stopping web socket server
[task 2021-08-09T07:24:40.699Z] 07:24:40     INFO - Stopping ssltunnel
[task 2021-08-09T07:24:40.700Z] 07:24:40  WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2021-08-09T07:24:40.700Z] 07:24:40     INFO - runtests.py | Running tests: end.
[task 2021-08-09T07:24:40.701Z] 07:24:40     INFO - Buffered messages finished
[task 2021-08-09T07:24:40.702Z] 07:24:40     INFO - Running manifest: layout/generic/test/mochitest.ini
[task 2021-08-09T07:24:40.703Z] 07:24:40     INFO - The following extra prefs will be set:
[task 2021-08-09T07:24:40.703Z] 07:24:40     INFO -   gfx.font_loader.delay=0
[task 2021-08-09T07:24:40.724Z] 07:24:40     INFO -  Setting pipeline to PAUSED ...
[task 2021-08-09T07:24:40.725Z] 07:24:40     INFO -  Pipeline is PREROLLING ...
[task 2021-08-09T07:24:40.727Z] 07:24:40     INFO -  Pipeline is PREROLLED ...
[task 2021-08-09T07:24:40.727Z] 07:24:40     INFO -  Setting pipeline to PLAYING ...
[task 2021-08-09T07:24:40.727Z] 07:24:40     INFO -  New clock: GstSystemClock
[task 2021-08-09T07:24:40.761Z] 07:24:40     INFO -  Got EOS from element "pipeline0".
[task 2021-08-09T07:24:40.761Z] 07:24:40     INFO -  Execution ended after 0:00:00.033390554
[task 2021-08-09T07:24:40.761Z] 07:24:40     INFO -  Setting pipeline to PAUSED ...
[task 2021-08-09T07:24:40.761Z] 07:24:40     INFO -  Setting pipeline to READY ...
[task 2021-08-09T07:24:40.762Z] 07:24:40     INFO -  (gst-launch-1.0:22689): GStreamer-CRITICAL **: 07:24:40.760: gst_object_unref: assertion '((GObject *) object)->ref_count > 0' failed
[task 2021-08-09T07:24:40.762Z] 07:24:40     INFO -  Setting pipeline to NULL ...
[task 2021-08-09T07:24:40.762Z] 07:24:40     INFO -  Freeing pipeline ...
[task 2021-08-09T07:24:41.008Z] 07:24:41     INFO - PID 22702 | pk12util: PKCS12 IMPORT SUCCESSFUL
[task 2021-08-09T07:24:41.069Z] 07:24:41     INFO - MochitestServer : launching ['/builds/worker/workspace/build/tests/bin/xpcshell', '-g', '/builds/worker/workspace/build/application/firefox', '-f', '/builds/worker/workspace/build/tests/bin/components/httpd.js', '-e', "const _PROFILE_PATH = '/tmp/tmps9bdeoif.mozrunner'; const _SERVER_PORT = '8888'; const _SERVER_ADDR = '127.0.0.1'; const _TEST_PREFIX = undefined; const _DISPLAY_RESULTS = false;", '-f', '/builds/worker/workspace/build/tests/mochitest/server.js']
[task 2021-08-09T07:24:41.069Z] 07:24:41     INFO - runtests.py | Server pid: 22708
[task 2021-08-09T07:24:41.089Z] 07:24:41     INFO - runtests.py | Websocket server pid: 22711
[task 2021-08-09T07:24:41.114Z] 07:24:41     INFO - runtests.py | SSL tunnel pid: 22715
[task 2021-08-09T07:24:41.167Z] 07:24:41     INFO - runtests.py | Running with scheme: http
[task 2021-08-09T07:24:41.168Z] 07:24:41     INFO - runtests.py | Running with e10s: True
[task 2021-08-09T07:24:41.169Z] 07:24:41     INFO - runtests.py | Running with fission: True
[task 2021-08-09T07:24:41.170Z] 07:24:41     INFO - runtests.py | Running with cross-origin iframes: True
[task 2021-08-09T07:24:41.171Z] 07:24:41     INFO - runtests.py | Running with serviceworker_e10s: True
[task 2021-08-09T07:24:41.175Z] 07:24:41     INFO - runtests.py | Running with socketprocess_e10s: False
[task 2021-08-09T07:24:41.175Z] 07:24:41     INFO - runtests.py | Running tests: start.
[task 2021-08-09T07:24:41.175Z] 07:24:41     INFO - 
[task 2021-08-09T07:24:41.240Z] 07:24:41     INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox -marionette -foreground -profile /tmp/tmps9bdeoif.mozrunner
[task 2021-08-09T07:24:41.251Z] 07:24:41     INFO - runtests.py | Application pid: 22733
[task 2021-08-09T07:24:41.251Z] 07:24:41     INFO - TEST-INFO | started process GECKO(22733)
[task 2021-08-09T07:24:41.864Z] 07:24:41     INFO - GECKO(22733) | 1628493881863	Marionette	INFO	Marionette enabled
[task 2021-08-09T07:24:41.918Z] 07:24:41     INFO - GECKO(22733) | 1628493881918	Marionette	TRACE	Received observer notification toplevel-window-ready
[task 2021-08-09T07:24:45.448Z] 07:24:45     INFO - GECKO(22733) | console.warn: SearchSettings: "get: No settings file exists, new profile?" (new NotFoundError("Could not open the file at /tmp/tmps9bdeoif.mozrunner/search.json.mozlz4", (void 0)))
[task 2021-08-09T07:24:46.053Z] 07:24:46     INFO - GECKO(22733) | 1628493886052	Marionette	TRACE	Received observer notification marionette-startup-requested
[task 2021-08-09T07:24:46.054Z] 07:24:46     INFO - GECKO(22733) | 1628493886052	Marionette	TRACE	Waiting until startup recorder finished recording startup scripts...
[task 2021-08-09T07:24:46.069Z] 07:24:46     INFO - GECKO(22733) | 1628493886068	Marionette	TRACE	All scripts recorded.
[task 2021-08-09T07:24:46.071Z] 07:24:46     INFO - GECKO(22733) | 1628493886070	Marionette	INFO	Listening on port 2828
[task 2021-08-09T07:24:46.072Z] 07:24:46     INFO - GECKO(22733) | 1628493886070	Marionette	DEBUG	Marionette is listening
[task 2021-08-09T07:24:46.195Z] 07:24:46     INFO - GECKO(22733) | 1628493886194	Marionette	DEBUG	Accepted connection 0 from 127.0.0.1:48036
[task 2021-08-09T07:24:46.200Z] 07:24:46     INFO - GECKO(22733) | 1628493886198	Marionette	DEBUG	Closed connection 0
[task 2021-08-09T07:24:46.201Z] 07:24:46     INFO - GECKO(22733) | 1628493886199	Marionette	DEBUG	Accepted connection 1 from 127.0.0.1:48038
[task 2021-08-09T07:24:46.209Z] 07:24:46     INFO - GECKO(22733) | 1628493886208	Marionette	DEBUG	1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2021-08-09T07:24:46.223Z] 07:24:46     INFO - GECKO(22733) | 1628493886222	Marionette	DEBUG	1 <- [1,1,null,{"sessionId":"32502dac-f845-4665-bd07-1c36d4a09f0e","capabilities":{"browserName":"firefox","browserVersion":"92.0a ... f.mozrunner","moz:shutdownTimeout":60000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true,"proxy":{}}}]
[task 2021-08-09T07:24:46.238Z] 07:24:46     INFO - GECKO(22733) | 1628493886237	Marionette	DEBUG	1 -> [0,2,"Addon:Install",{"path":"/tmp/tmpahf0x4wz.zip","temporary":false}]
[task 2021-08-09T07:24:46.301Z] 07:24:46     INFO - GECKO(22733) | 1628493886297	Marionette	DEBUG	1 <- [1,2,null,{"value":"special-powers@mozilla.org"}]
[task 2021-08-09T07:24:46.384Z] 07:24:46     INFO - GECKO(22733) | 1628493886380	Marionette	DEBUG	1 -> [0,3,"Addon:Install",{"path":"/tmp/tmp4tx0jyhd.zip","temporary":false}]
[task 2021-08-09T07:24:46.412Z] 07:24:46     INFO - GECKO(22733) | 1628493886411	Marionette	DEBUG	1 <- [1,3,null,{"value":"mochikit@mozilla.org"}]
[task 2021-08-09T07:24:46.415Z] 07:24:46     INFO - GECKO(22733) | 1628493886414	Marionette	DEBUG	1 -> [0,4,"Marionette:GetContext",{}]
[task 2021-08-09T07:24:46.417Z] 07:24:46     INFO - GECKO(22733) | 1628493886415	Marionette	DEBUG	1 <- [1,4,null,{"value":"content"}]
[task 2021-08-09T07:24:46.420Z] 07:24:46     INFO - GECKO(22733) | 1628493886419	Marionette	DEBUG	1 -> [0,5,"Marionette:SetContext",{"value":"chrome"}]
[task 2021-08-09T07:24:46.421Z] 07:24:46     INFO - GECKO(22733) | 1628493886419	Marionette	DEBUG	1 <- [1,5,null,{"value":null}]
[task 2021-08-09T07:24:46.423Z] 07:24:46     INFO - GECKO(22733) | 1628493886422	Marionette	DEBUG	1 -> [0,6,"WebDriver:ExecuteScript",{"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, ... rashes=true&xOriginTests=true"}],"newSandbox":true,"sandbox":"default","line":1936,"filename":"tests/mochitest/runtests.py"}]
[task 2021-08-09T07:24:46.427Z] 07:24:46     INFO - GECKO(22733) | 1628493886426	Marionette	TRACE	[7] MarionetteCommands actor created for window id 2
[task 2021-08-09T07:24:46.433Z] 07:24:46     INFO - GECKO(22733) | 1628493886431	Marionette	DEBUG	1 <- [1,6,null,{"value":null}]
[task 2021-08-09T07:24:46.438Z] 07:24:46     INFO - GECKO(22733) | 1628493886438	Marionette	DEBUG	1 -> [0,7,"Marionette:SetContext",{"value":"content"}]
[task 2021-08-09T07:24:46.439Z] 07:24:46     INFO - GECKO(22733) | 1628493886438	Marionette	DEBUG	1 <- [1,7,null,{"value":null}]
[task 2021-08-09T07:24:46.452Z] 07:24:46     INFO - runtests.py | Waiting for browser...
[task 2021-08-09T07:24:46.455Z] 07:24:46     INFO - GECKO(22733) | 1628493886448	Marionette	DEBUG	1 -> [0,8,"WebDriver:DeleteSession",{}]
[task 2021-08-09T07:24:46.457Z] 07:24:46     INFO - GECKO(22733) | 1628493886449	Marionette	DEBUG	1 <- [1,8,null,{"value":null}]
[task 2021-08-09T07:24:46.458Z] 07:24:46     INFO - GECKO(22733) | 1628493886454	Marionette	DEBUG	Closed connection 1
[task 2021-08-09T07:24:46.638Z] 07:24:46     INFO - GECKO(22733) | JavaScript error: , line 0: NotFoundError: No such JSWindowActor 'MarionetteEvents'
[task 2021-08-09T07:24:46.880Z] 07:24:46     INFO - TEST-START | layout/generic/test/test_bug1062406.html
Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 4 years ago4 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.