Closed
Bug 1708478
Opened 3 years ago
Closed 3 years ago
Intermittent toolkit/components/printing/tests/browser_modal_print.js | application terminated with exit code 11
Categories
(Toolkit :: Printing, defect, P5)
Toolkit
Printing
Tracking
()
RESOLVED
INCOMPLETE
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure)
Filed by: csabou [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=338163334&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/Z41mVb_lT_WZy6aLENXp5A/runs/0/artifacts/public/logs/live_backing.log
[task 2021-04-29T14:27:15.818Z] 14:27:15 INFO - TEST-PASS | toolkit/components/printing/tests/browser_modal_print.js | The URL of the browser is the one we expect -
[task 2021-04-29T14:27:15.819Z] 14:27:15 INFO - Leaving test bound testPrintMultiple
[task 2021-04-29T14:27:15.819Z] 14:27:15 INFO - Entering test bound testCancelButton
[task 2021-04-29T14:27:15.820Z] 14:27:15 INFO - withTestPage: http://example.com/browser/toolkit/components/printing/tests/simplifyArticleSample.html
[task 2021-04-29T14:27:15.820Z] 14:27:15 INFO - Buffered messages finished
[task 2021-04-29T14:27:15.821Z] 14:27:15 ERROR - TEST-UNEXPECTED-FAIL | toolkit/components/printing/tests/browser_modal_print.js | application terminated with exit code 11
[task 2021-04-29T14:27:15.822Z] 14:27:15 INFO - runtests.py | Application ran for: 0:02:16.373183
[task 2021-04-29T14:27:15.823Z] 14:27:15 INFO - zombiecheck | Reading PID log: /tmp/tmpvOG7sgpidlog
[task 2021-04-29T14:27:15.824Z] 14:27:15 INFO - ==> process 29927 launched child process 29949
[task 2021-04-29T14:27:15.826Z] 14:27:15 INFO - ==> process 29927 launched child process 29993
[task 2021-04-29T14:27:15.827Z] 14:27:15 INFO - ==> process 29927 launched child process 30004
[task 2021-04-29T14:27:15.827Z] 14:27:15 INFO - ==> process 29927 launched child process 30085
[task 2021-04-29T14:27:15.828Z] 14:27:15 INFO - ==> process 29927 launched child process 30090
[task 2021-04-29T14:27:15.829Z] 14:27:15 INFO - ==> process 29927 launched child process 30109
[task 2021-04-29T14:27:15.829Z] 14:27:15 INFO - ==> process 29927 launched child process 30173
[task 2021-04-29T14:27:15.829Z] 14:27:15 INFO - ==> process 29927 launched child process 30200
[task 2021-04-29T14:27:15.830Z] 14:27:15 INFO - ==> process 29927 launched child process 30202
[task 2021-04-29T14:27:15.830Z] 14:27:15 INFO - ==> process 29927 launched child process 30205
[task 2021-04-29T14:27:15.830Z] 14:27:15 INFO - ==> process 29927 launched child process 30270
[task 2021-04-29T14:27:15.831Z] 14:27:15 INFO - ==> process 29927 launched child process 30298
[task 2021-04-29T14:27:15.831Z] 14:27:15 INFO - ==> process 29927 launched child process 30329
[task 2021-04-29T14:27:15.831Z] 14:27:15 INFO - ==> process 29927 launched child process 30337
[task 2021-04-29T14:27:15.831Z] 14:27:15 INFO - ==> process 29927 launched child process 30382
[task 2021-04-29T14:27:15.832Z] 14:27:15 INFO - zombiecheck | Checking for orphan process with PID: 30202
[task 2021-04-29T14:27:15.833Z] 14:27:15 INFO - zombiecheck | Checking for orphan process with PID: 30298
[task 2021-04-29T14:27:15.833Z] 14:27:15 INFO - zombiecheck | Checking for orphan process with PID: 30085
task 2021-04-29T14:27:15.834Z] 14:27:15 INFO - zombiecheck | Checking for orphan process with PID: 30337
[task 2021-04-29T14:27:15.834Z] 14:27:15 INFO - zombiecheck | Checking for orphan process with PID: 29993
[task 2021-04-29T14:27:15.835Z] 14:27:15 INFO - zombiecheck | Checking for orphan process with PID: 30090
[task 2021-04-29T14:27:15.835Z] 14:27:15 INFO - zombiecheck | Checking for orphan process with PID: 30382
[task 2021-04-29T14:27:15.836Z] 14:27:15 INFO - zombiecheck | Checking for orphan process with PID: 29949
[task 2021-04-29T14:27:15.836Z] 14:27:15 INFO - zombiecheck | Checking for orphan process with PID: 30004
[task 2021-04-29T14:27:15.838Z] 14:27:15 INFO - zombiecheck | Checking for orphan process with PID: 30200
[task 2021-04-29T14:27:15.838Z] 14:27:15 INFO - zombiecheck | Checking for orphan process with PID: 30329
[task 2021-04-29T14:27:15.838Z] 14:27:15 INFO - zombiecheck | Checking for orphan process with PID: 30173
[task 2021-04-29T14:27:15.839Z] 14:27:15 INFO - zombiecheck | Checking for orphan process with PID: 30205
[task 2021-04-29T14:27:15.839Z] 14:27:15 INFO - zombiecheck | Checking for orphan process with PID: 30109
[task 2021-04-29T14:27:15.840Z] 14:27:15 INFO - zombiecheck | Checking for orphan process with PID: 30270
[task 2021-04-29T14:27:15.840Z] 14:27:15 INFO - Stopping web server
[task 2021-04-29T14:27:15.902Z] 14:27:15 INFO - Server shut down.
[task 2021-04-29T14:27:15.936Z] 14:27:15 INFO - Web server killed.
[task 2021-04-29T14:27:15.936Z] 14:27:15 INFO - Stopping web socket server
[task 2021-04-29T14:27:15.956Z] 14:27:15 INFO - Stopping ssltunnel
[task 2021-04-29T14:27:15.977Z] 14:27:15 WARNING - leakcheck | refcount logging is off, so leaks can't be detected!
[task 2021-04-29T14:27:15.977Z] 14:27:15 INFO - runtests.py | Running tests: end.
[task 2021-04-29T14:27:16.018Z] 14:27:16 INFO - Buffered messages finished
[task 2021-04-29T14:27:16.018Z] 14:27:16 INFO - Running manifest: toolkit/components/remotebrowserutils/tests/browser/browser.ini
[task 2021-04-29T14:27:16.140Z] 14:27:16 INFO - Setting pipeline to PAUSED ...
[task 2021-04-29T14:27:16.143Z] 14:27:16 INFO - Pipeline is PREROLLING ...
[task 2021-04-29T14:27:16.148Z] 14:27:16 INFO - Pipeline is PREROLLED ...
[task 2021-04-29T14:27:16.149Z] 14:27:16 INFO - Setting pipeline to PLAYING ...
[task 2021-04-29T14:27:16.149Z] 14:27:16 INFO - New clock: GstSystemClock
[task 2021-04-29T14:27:16.183Z] 14:27:16 INFO - Got EOS from element "pipeline0".
[task 2021-04-29T14:27:16.183Z] 14:27:16 INFO - Execution ended after 0:00:00.033348663
[task 2021-04-29T14:27:16.184Z] 14:27:16 INFO - Setting pipeline to PAUSED ...
[task 2021-04-29T14:27:16.184Z] 14:27:16 INFO - Setting pipeline to READY ...
[task 2021-04-29T14:27:16.185Z] 14:27:16 INFO - (gst-launch-1.0:30412): GStreamer-CRITICAL **: 14:27:16.181: gst_object_unref: assertion '((GObject *) object)->ref_count > 0' failed
[task 2021-04-29T14:27:16.185Z] 14:27:16 INFO - Setting pipeline to NULL ...
[task 2021-04-29T14:27:16.186Z] 14:27:16 INFO - Freeing pipeline ...
[task 2021-04-29T14:27:16.645Z] 14:27:16 INFO - PID 30428 | pk12util: PKCS12 IMPORT SUCCESSFUL
[task 2021-04-29T14:27:16.709Z] 14:27:16 INFO - MochitestServer : launching [u'/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/tmpbaVPKl.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-04-29T14:27:16.710Z] 14:27:16 INFO - runtests.py | Server pid: 30431
[task 2021-04-29T14:27:16.718Z] 14:27:16 INFO - runtests.py | Websocket server pid: 30434
[task 2021-04-29T14:27:16.734Z] 14:27:16 INFO - runtests.py | SSL tunnel pid: 30438
[task 2021-04-29T14:27:17.032Z] 14:27:17 INFO - runtests.py | Running with scheme: http
[task 2021-04-29T14:27:17.032Z] 14:27:17 INFO - runtests.py | Running with e10s: True
[task 2021-04-29T14:27:17.032Z] 14:27:17 INFO - runtests.py | Running with fission: True
[task 2021-04-29T14:27:17.032Z] 14:27:17 INFO - runtests.py | Running with cross-origin iframes: False
[task 2021-04-29T14:27:17.032Z] 14:27:17 INFO - runtests.py | Running with serviceworker_e10s: True
[task 2021-04-29T14:27:17.032Z] 14:27:17 INFO - runtests.py | Running with socketprocess_e10s: False
[task 2021-04-29T14:27:17.032Z] 14:27:17 INFO - runtests.py | Running tests: start.
[task 2021-04-29T14:27:17.032Z] 14:27:17 INFO -
[task 2021-04-29T14:27:17.148Z] 14:27:17 INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox -marionette -foreground -profile /tmp/tmpbaVPKl.mozrunner
[task 2021-04-29T14:27:17.164Z] 14:27:17 INFO - runtests.py | Application pid: 30456
[task 2021-04-29T14:27:17.164Z] 14:27:17 INFO - TEST-INFO | started process GECKO(30456)
[task 2021-04-29T14:27:17.998Z] 14:27:17 INFO - GECKO(30456) | 1619706437990 Marionette INFO Marionette enabled
[task 2021-04-29T14:27:18.199Z] 14:27:18 INFO - GECKO(30456) | 1619706438188 Marionette TRACE Received observer notification toplevel-window-ready
[task 2021-04-29T14:27:20.147Z] 14:27:20 INFO - GECKO(30456) | console.warn: SearchSettings: "get: No settings file exists, new profile?" (new NotFoundError("Could not open the file at /tmp/tmpbaVPKl.mozrunner/search.json.mozlz4", (void 0)))
[task 2021-04-29T14:27:20.956Z] 14:27:20 INFO - GECKO(30456) | 1619706440953 Marionette TRACE Received observer notification marionette-startup-requested
[task 2021-04-29T14:27:20.957Z] 14:27:20 INFO - GECKO(30456) | 1619706440954 Marionette TRACE Waiting until startup recorder finished recording startup scripts...
[task 2021-04-29T14:27:21.014Z] 14:27:21 INFO - GECKO(30456) | 1619706441003 Marionette TRACE All scripts recorded.
[task 2021-04-29T14:27:21.022Z] 14:27:21 INFO - GECKO(30456) | 1619706441019 Marionette INFO Listening on port 2828
[task 2021-04-29T14:27:21.024Z] 14:27:21 INFO - GECKO(30456) | 1619706441019 Marionette DEBUG Marionette is listening
[task 2021-04-29T14:27:21.100Z] 14:27:21 INFO - GECKO(30456) | 1619706441090 Marionette DEBUG Accepted connection 0 from 127.0.0.1:45178
[task 2021-04-29T14:27:21.103Z] 14:27:21 INFO - GECKO(30456) | 1619706441101 Marionette DEBUG Closed connection 0
[task 2021-04-29T14:27:21.103Z] 14:27:21 INFO - GECKO(30456) | 1619706441101 Marionette DEBUG Accepted connection 1 from 127.0.0.1:45180
[task 2021-04-29T14:27:21.124Z] 14:27:21 INFO - GECKO(30456) | 1619706441121 Marionette DEBUG 1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2021-04-29T14:27:21.152Z] 14:27:21 INFO - GECKO(30456) | 1619706441148 Marionette DEBUG 1 <- [1,1,null,{"sessionId":"2d403c9f-8c3f-46e3-9390-05f76891936a","capabilities":{"browserName":"firefox","browserVersion":"90.0a ... mp/tmpbaVPKl.mozrunner","moz:shutdownTimeout":60000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true}}]
[task 2021-04-29T14:27:21.212Z] 14:27:21 INFO - GECKO(30456) | 1619706441209 Marionette DEBUG 1 -> [0,2,"Addon:Install",{"path":"/tmp/tmpEKSm6g.zip","temporary":false}]
[task 2021-04-29T14:27:21.381Z] 14:27:21 INFO - GECKO(30456) | 1619706441375 Marionette TRACE [41] MarionetteEvents actor created for window id 26
[task 2021-04-29T14:27:21.462Z] 14:27:21 INFO - GECKO(30456) | 1619706441455 Marionette DEBUG 1 <- [1,2,null,{"value":"special-powers@mozilla.org"}]
[task 2021-04-29T14:27:21.538Z] 14:27:21 INFO - GECKO(30456) | 1619706441527 Marionette DEBUG 1 -> [0,3,"Addon:Install",{"path":"/tmp/tmptcRrrG.zip","temporary":false}]
[task 2021-04-29T14:27:21.560Z] 14:27:21 INFO - GECKO(30456) | 1619706441557 Marionette DEBUG 1 <- [1,3,null,{"value":"mochikit@mozilla.org"}]
[task 2021-04-29T14:27:21.561Z] 14:27:21 INFO - GECKO(30456) | 1619706441559 Marionette DEBUG 1 -> [0,4,"Marionette:GetContext",{}]
[task 2021-04-29T14:27:21.562Z] 14:27:21 INFO - GECKO(30456) | 1619706441559 Marionette DEBUG 1 <- [1,4,null,{"value":"content"}]
[task 2021-04-29T14:27:21.566Z] 14:27:21 INFO - GECKO(30456) | 1619706441561 Marionette DEBUG 1 -> [0,5,"Marionette:SetContext",{"value":"chrome"}]
[task 2021-04-29T14:27:21.566Z] 14:27:21 INFO - GECKO(30456) | 1619706441563 Marionette DEBUG 1 <- [1,5,null,{"value":null}]
[task 2021-04-29T14:27:21.569Z] 14:27:21 INFO - GECKO(30456) | 1619706441566 Marionette DEBUG 1 -> [0,6,"WebDriver:ExecuteScript",{"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, ... testUrl":"about:blank","flavor":"browser-chrome"}],"filename":"tests/mochitest/runtests.py","sandbox":"default","line":1935}]
[task 2021-04-29T14:27:21.577Z] 14:27:21 INFO - GECKO(30456) | 1619706441571 Marionette TRACE [7] MarionetteCommands actor created for window id 2
[task 2021-04-29T14:27:21.577Z] 14:27:21 INFO - GECKO(30456) | 1619706441575 Marionette TRACE [19] MarionetteEvents actor created for window id 2147483649
[task 2021-04-29T14:27:21.601Z] 14:27:21 INFO - GECKO(30456) | 1619706441598 Marionette TRACE Received observer notification toplevel-window-ready
[task 2021-04-29T14:27:21.609Z] 14:27:21 INFO - GECKO(30456) | 1619706441604 Marionette DEBUG 1 <- [1,6,null,{"value":null}]
[task 2021-04-29T14:27:21.609Z] 14:27:21 INFO - GECKO(30456) | 1619706441606 Marionette DEBUG 1 -> [0,7,"Marionette:SetContext",{"value":"content"}]
[task 2021-04-29T14:27:21.617Z] 14:27:21 INFO - GECKO(30456) | 1619706441610 Marionette DEBUG 1 <- [1,7,null,{"value":null}]
[task 2021-04-29T14:27:21.617Z] 14:27:21 INFO - GECKO(30456) | 1619706441611 Marionette DEBUG 1 -> [0,8,"WebDriver:DeleteSession",{}]
[task 2021-04-29T14:27:21.617Z] 14:27:21 INFO - GECKO(30456) | 1619706441615 Marionette DEBUG 1 <- [1,8,null,{"value":null}]
[task 2021-04-29T14:27:21.642Z] 14:27:21 INFO - runtests.py | Waiting for browser...
[task 2021-04-29T14:27:21.646Z] 14:27:21 INFO - GECKO(30456) | 1619706441643 Marionette DEBUG Closed connection 1
[task 2021-04-29T14:27:21.684Z] 14:27:21 INFO - GECKO(30456) | 1619706441678 Marionette TRACE [41] MarionetteEvents actor created for window id 6442450945
[task 2021-04-29T14:27:21.699Z] 14:27:21 INFO - GECKO(30456) | JavaScript error: , line 0: NotFoundError: No such JSWindowActor 'MarionetteEvents'
[task 2021-04-29T14:27:21.912Z] 14:27:21 INFO - TEST-START | toolkit/components/remotebrowserutils/tests/browser/browser_RemoteWebNavigation.js```
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 2•3 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → INCOMPLETE
You need to log in
before you can comment on or make changes to this bug.
Description
•