Closed
Bug 1692397
Opened 5 years ago
Closed 5 years ago
Intermittent testing/firefox-ui/tests/functional/sessionstore/test_restore_windows_after_restart_and_quit.py TestSessionStoreDisabled.test_restore_with_restart | AssertionError: Non private browsing windows should have
Categories
(Testing :: Firefox UI Tests, defect, P5)
Testing
Firefox UI Tests
Tracking
(Not tracked)
RESOLVED
DUPLICATE
of bug 1382453
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: assertion, intermittent-failure)
Filed by: apavel [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=329739992&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/W7mzfXN6QpaDS4NRjK1uNw/runs/0/artifacts/public/logs/live_backing.log
[task 2021-02-12T05:10:39.206Z] 05:10:39 INFO - 1613106639203 Marionette DEBUG 1 <- [1,134,null,{"cause":"restart"}]
[task 2021-02-12T05:10:39.402Z] 05:10:39 INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-12T05:10:39.406Z] 05:10:39 INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-12T05:10:39.410Z] 05:10:39 INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-12T05:10:39.410Z] 05:10:39 INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-12T05:10:39.417Z] 05:10:39 INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-12T05:10:39.417Z] 05:10:39 INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-12T05:10:39.417Z] 05:10:39 INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-12T05:10:39.417Z] 05:10:39 INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-12T05:10:39.436Z] 05:10:39 INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-12T05:10:39.436Z] 05:10:39 INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-12T05:10:39.439Z] 05:10:39 INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-12T05:10:39.441Z] 05:10:39 INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-12T05:10:39.445Z] 05:10:39 INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-12T05:10:39.445Z] 05:10:39 INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-12T05:10:39.446Z] 05:10:39 INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-12T05:10:39.454Z] 05:10:39 INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-12T05:10:39.454Z] 05:10:39 INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-12T05:10:39.470Z] 05:10:39 INFO - 1613106639467 Marionette DEBUG Closed connection 1
[task 2021-02-12T05:10:39.651Z] 05:10:39 INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-12T05:10:39.651Z] 05:10:39 INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-12T05:10:39.651Z] 05:10:39 INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-12T05:10:39.668Z] 05:10:39 INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-12T05:10:39.683Z] 05:10:39 INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-12T05:10:40.167Z] 05:10:40 INFO - 1613106640150 Marionette TRACE Received observer notification xpcom-will-shutdown
[task 2021-02-12T05:10:40.168Z] 05:10:40 INFO - 1613106640151 Marionette DEBUG Marionette stopped listening
[task 2021-02-12T05:10:40.175Z] 05:10:40 INFO - ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2021-02-12T05:10:51.986Z] 05:10:51 INFO - [CodeCoverage] Setting handlers for process 2433.
[task 2021-02-12T05:10:53.491Z] 05:10:53 INFO - 1613106653488 Marionette TRACE Marionette enabled
[task 2021-02-12T05:10:53.491Z] 05:10:53 INFO - 1613106653489 Marionette TRACE Received observer notification profile-after-change
[task 2021-02-12T05:10:53.552Z] 05:10:53 INFO - 1613106653547 Marionette TRACE Received observer notification command-line-startup
[task 2021-02-12T05:10:54.719Z] 05:10:54 INFO - 1613106654717 Marionette TRACE Received observer notification toplevel-window-ready
[task 2021-02-12T05:10:54.734Z] 05:10:54 INFO - 1613106654729 Marionette TRACE Received observer notification toplevel-window-ready
[task 2021-02-12T05:10:57.036Z] 05:10:57 INFO - 1613106657031 Marionette TRACE Received observer notification marionette-startup-requested
[task 2021-02-12T05:10:57.036Z] 05:10:57 INFO - 1613106657031 Marionette TRACE Waiting until startup recorder finished recording startup scripts...
[task 2021-02-12T05:10:57.120Z] 05:10:57 INFO - 1613106657117 Marionette TRACE All scripts recorded.
[task 2021-02-12T05:10:57.128Z] 05:10:57 INFO - 1613106657120 Marionette INFO Listening on port 2828
[task 2021-02-12T05:10:57.128Z] 05:10:57 INFO - 1613106657122 Marionette DEBUG Marionette is listening
[task 2021-02-12T05:10:57.184Z] 05:10:57 INFO - 1613106657171 Marionette DEBUG Accepted connection 0 from 127.0.0.1:37322
[task 2021-02-12T05:10:57.184Z] 05:10:57 INFO - 1613106657181 Marionette DEBUG Accepted connection 1 from 127.0.0.1:37324
[task 2021-02-12T05:10:57.199Z] 05:10:57 INFO - 1613106657192 Marionette DEBUG Closed connection 0
[task 2021-02-12T05:10:57.247Z] 05:10:57 INFO - 1613106657241 Marionette DEBUG 1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2021-02-12T05:10:57.263Z] 05:10:57 INFO - 1613106657259 Marionette DEBUG 1 <- [1,1,null,{"sessionId":"4d1c9322-065a-465d-bbdc-7c94f0a2a01c","capabilities":{"browserName":"firefox","browserVersion":"87.0a ... ld/tmpFiBj69.mozrunner","moz:shutdownTimeout":60000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true}}]
[task 2021-02-12T05:10:57.270Z] 05:10:57 INFO - 1613106657264 Marionette DEBUG 1 -> [0,2,"Marionette:SetContext",{"value":"chrome"}]
[task 2021-02-12T05:10:57.271Z] 05:10:57 INFO - 1613106657265 Marionette DEBUG 1 <- [1,2,null,{"value":null}]
[task 2021-02-12T05:10:57.286Z] 05:10:57 INFO - 1613106657283 Marionette DEBUG 1 -> [0,3,"WebDriver:GetChromeWindowHandles",{}]
[task 2021-02-12T05:10:57.286Z] 05:10:57 INFO - 1613106657284 Marionette DEBUG 1 <- [1,3,null,["1","29","30"]]
[task 2021-02-12T05:10:57.294Z] 05:10:57 INFO - 1613106657289 Marionette DEBUG 1 -> [0,4,"WebDriver:GetChromeWindowHandle",{}]
[task 2021-02-12T05:10:57.294Z] 05:10:57 INFO - 1613106657290 Marionette DEBUG 1 <- [1,4,null,{"value":"30"}]
[task 2021-02-12T05:10:57.297Z] 05:10:57 INFO - 1613106657293 Marionette DEBUG 1 -> [0,5,"Marionette:GetContext",{}]
[task 2021-02-12T05:10:57.297Z] 05:10:57 INFO - 1613106657294 Marionette DEBUG 1 <- [1,5,null,{"value":"chrome"}]
[task 2021-02-12T05:10:57.297Z] 05:10:57 INFO - 1613106657296 Marionette DEBUG 1 -> [0,6,"Marionette:SetContext",{"value":"chrome"}]
[task 2021-02-12T05:10:57.299Z] 05:10:57 INFO - 1613106657296 Marionette DEBUG 1 <- [1,6,null,{"value":null}]
[task 2021-02-12T05:10:57.302Z] 05:10:57 INFO - 1613106657299 Marionette DEBUG 1 -> [0,7,"WebDriver:SwitchToWindow",{"handle":"1","focus":true}]
[task 2021-02-12T05:10:57.310Z] 05:10:57 INFO - 1613106657306 Marionette TRACE Received DOM event activate for [object Window]
[task 2021-02-12T05:10:57.310Z] 05:10:57 INFO - 1613106657308 Marionette TRACE Received DOM event focus for [object HTMLDocument]
[task 2021-02-12T05:10:57.317Z] 05:10:57 INFO - 1613106657315 Marionette DEBUG 1 <- [1,7,null,{"value":null}]
[task 2021-02-12T05:10:57.333Z] 05:10:57 INFO - 1613106657320 Marionette DEBUG 1 -> [0,8,"WebDriver:ExecuteScript",{"script":"return gBrowser.tabs.map(tab => {\n return tab.linkedBrowser.cur ... ilename":"tests/testing/firefox-ui/tests/functional/sessionstore/session_store_test_case.py","sandbox":"default","line":165}]
[task 2021-02-12T05:10:57.333Z] 05:10:57 INFO - 1613106657325 Marionette TRACE [1] MarionetteCommands actor created for window id 2
[task 2021-02-12T05:10:57.334Z] 05:10:57 INFO - 1613106657333 Marionette DEBUG 1 <- [1,8,null,{"value":["about:blank","about:blank"]}]
[task 2021-02-12T05:10:57.342Z] 05:10:57 INFO - 1613106657339 Marionette DEBUG 1 -> [0,9,"Marionette:SetContext",{"value":"chrome"}]
[task 2021-02-12T05:10:57.342Z] 05:10:57 INFO - 1613106657340 Marionette DEBUG 1 <- [1,9,null,{"value":null}]
[task 2021-02-12T05:10:57.349Z] 05:10:57 INFO - 1613106657344 Marionette DEBUG 1 -> [0,10,"WebDriver:SwitchToWindow",{"handle":"30","focus":true}]
[task 2021-02-12T05:10:57.353Z] 05:10:57 INFO - 1613106657351 Marionette TRACE Received DOM event activate for [object Window]
[task 2021-02-12T05:10:57.354Z] 05:10:57 INFO - 1613106657352 Marionette TRACE Received DOM event focus for [object HTMLDocument]
[task 2021-02-12T05:10:57.355Z] 05:10:57 INFO - 1613106657354 Marionette DEBUG 1 <- [1,10,null,{"value":null}]
[task 2021-02-12T05:10:57.371Z] 05:10:57 INFO - 1613106657364 Marionette DEBUG 1 -> [0,11,"WebDriver:GetChromeWindowHandle",{}]
[task 2021-02-12T05:10:57.371Z] 05:10:57 INFO - 1613106657365 Marionette DEBUG 1 <- [1,11,null,{"value":"30"}]
[task 2021-02-12T05:10:57.379Z] 05:10:57 INFO - 1613106657375 Marionette DEBUG 1 -> [0,12,"Marionette:GetContext",{}]
[task 2021-02-12T05:10:57.379Z] 05:10:57 INFO - 1613106657376 Marionette DEBUG 1 <- [1,12,null,{"value":"chrome"}]
[task 2021-02-12T05:10:57.395Z] 05:10:57 INFO - 1613106657388 Marionette DEBUG 1 -> [0,13,"Marionette:SetContext",{"value":"chrome"}]
[task 2021-02-12T05:10:57.395Z] 05:10:57 INFO - 1613106657389 Marionette DEBUG 1 <- [1,13,null,{"value":null}]
[task 2021-02-12T05:10:57.395Z] 05:10:57 INFO - 1613106657391 Marionette DEBUG 1 -> [0,14,"WebDriver:SwitchToWindow",{"handle":"29","focus":true}]
[task 2021-02-12T05:10:57.398Z] 05:10:57 INFO - 1613106657396 Marionette TRACE Received DOM event activate for [object Window]
[task 2021-02-12T05:10:57.399Z] 05:10:57 INFO - 1613106657397 Marionette TRACE Received DOM event focus for [object HTMLDocument]
[task 2021-02-12T05:10:57.400Z] 05:10:57 INFO - 1613106657399 Marionette DEBUG 1 <- [1,14,null,{"value":null}]
[task 2021-02-12T05:10:57.407Z] 05:10:57 INFO - 1613106657403 Marionette DEBUG 1 -> [0,15,"WebDriver:ExecuteScript",{"script":"return gBrowser.tabs.map(tab => {\n return tab.linkedBrowser.cu ... ilename":"tests/testing/firefox-ui/tests/functional/sessionstore/session_store_test_case.py","sandbox":"default","line":165}]
[task 2021-02-12T05:10:57.415Z] 05:10:57 INFO - 1613106657410 Marionette TRACE [29] MarionetteCommands actor created for window id 11
[task 2021-02-12T05:10:57.423Z] 05:10:57 INFO - 1613106657417 Marionette DEBUG 1 <- [1,15,null,{"value":["about:blank","about:blank"]}]
[task 2021-02-12T05:10:57.423Z] 05:10:57 INFO - 1613106657419 Marionette DEBUG 1 -> [0,16,"Marionette:SetContext",{"value":"chrome"}]
[task 2021-02-12T05:10:57.423Z] 05:10:57 INFO - 1613106657420 Marionette DEBUG 1 <- [1,16,null,{"value":null}]
[task 2021-02-12T05:10:57.423Z] 05:10:57 INFO - 1613106657421 Marionette DEBUG 1 -> [0,17,"WebDriver:SwitchToWindow",{"handle":"30","focus":true}]
[task 2021-02-12T05:10:57.430Z] 05:10:57 INFO - 1613106657427 Marionette TRACE Received DOM event activate for [object Window]
[task 2021-02-12T05:10:57.430Z] 05:10:57 INFO - 1613106657427 Marionette TRACE Received DOM event focus for [object HTMLDocument]
[task 2021-02-12T05:10:57.430Z] 05:10:57 INFO - 1613106657428 Marionette DEBUG 1 <- [1,17,null,{"value":null}]
[task 2021-02-12T05:10:57.434Z] 05:10:57 INFO - 1613106657431 Marionette DEBUG 1 -> [0,18,"WebDriver:GetChromeWindowHandle",{}]
[task 2021-02-12T05:10:57.434Z] 05:10:57 INFO - 1613106657432 Marionette DEBUG 1 <- [1,18,null,{"value":"30"}]
[task 2021-02-12T05:10:57.442Z] 05:10:57 INFO - 1613106657436 Marionette DEBUG 1 -> [0,19,"Marionette:GetContext",{}]
[task 2021-02-12T05:10:57.442Z] 05:10:57 INFO - 1613106657436 Marionette DEBUG 1 <- [1,19,null,{"value":"chrome"}]
[task 2021-02-12T05:10:57.442Z] 05:10:57 INFO - 1613106657438 Marionette DEBUG 1 -> [0,20,"Marionette:SetContext",{"value":"chrome"}]
[task 2021-02-12T05:10:57.442Z] 05:10:57 INFO - 1613106657438 Marionette DEBUG 1 <- [1,20,null,{"value":null}]
[task 2021-02-12T05:10:57.477Z] 05:10:57 INFO - 1613106657468 Marionette DEBUG 1 -> [0,21,"WebDriver:SwitchToWindow",{"handle":"30","focus":true}]
[task 2021-02-12T05:10:57.478Z] 05:10:57 INFO - 1613106657469 Marionette DEBUG 1 <- [1,21,null,{"value":null}]
[task 2021-02-12T05:10:57.479Z] 05:10:57 INFO - 1613106657471 Marionette DEBUG 1 -> [0,22,"WebDriver:ExecuteScript",{"script":"return gBrowser.tabs.map(tab => {\n return tab.linkedBrowser.cu ... ilename":"tests/testing/firefox-ui/tests/functional/sessionstore/session_store_test_case.py","sandbox":"default","line":165}]
[task 2021-02-12T05:10:57.479Z] 05:10:57 INFO - 1613106657474 Marionette TRACE [30] MarionetteCommands actor created for window id 13
[task 2021-02-12T05:10:57.487Z] 05:10:57 INFO - 1613106657481 Marionette DEBUG 1 <- [1,22,null,{"value":["about:blank"]}]
[task 2021-02-12T05:10:57.487Z] 05:10:57 INFO - 1613106657483 Marionette DEBUG 1 -> [0,23,"Marionette:SetContext",{"value":"chrome"}]
[task 2021-02-12T05:10:57.487Z] 05:10:57 INFO - 1613106657483 Marionette DEBUG 1 <- [1,23,null,{"value":null}]
[task 2021-02-12T05:10:57.487Z] 05:10:57 INFO - 1613106657484 Marionette DEBUG 1 -> [0,24,"WebDriver:SwitchToWindow",{"handle":"30","focus":true}]
[task 2021-02-12T05:10:57.487Z] 05:10:57 INFO - 1613106657486 Marionette DEBUG 1 <- [1,24,null,{"value":null}]
[task 2021-02-12T05:10:57.490Z] 05:10:57 INFO - 1613106657488 Marionette DEBUG 1 -> [0,25,"Marionette:GetContext",{}]
[task 2021-02-12T05:10:57.491Z] 05:10:57 INFO - 1613106657489 Marionette DEBUG 1 <- [1,25,null,{"value":"chrome"}]
[task 2021-02-12T05:10:57.492Z] 05:10:57 INFO - 1613106657490 Marionette DEBUG 1 -> [0,26,"Marionette:SetContext",{"value":"chrome"}]
[task 2021-02-12T05:10:57.493Z] 05:10:57 INFO - 1613106657491 Marionette DEBUG 1 <- [1,26,null,{"value":null}]
[task 2021-02-12T05:10:57.497Z] 05:10:57 INFO - 1613106657494 Marionette DEBUG 1 -> [0,27,"WebDriver:TakeScreenshot",{"full":true,"hash":false,"id":null,"scroll":true}]
[task 2021-02-12T05:11:00.133Z] 05:11:00 INFO - [CodeCoverage] Setting handlers for process 2487.
[task 2021-02-12T05:11:00.295Z] 05:11:00 INFO - 1613106660290 Marionette TRACE [26] MarionetteEvents actor created for window id 4
[task 2021-02-12T05:11:00.357Z] 05:11:00 INFO - 1613106660355 Marionette TRACE [26] MarionetteEvents actor created for window id 2147483649
[task 2021-02-12T05:11:01.885Z] 05:11:01 INFO - [CodeCoverage] Setting handlers for process 2501.
[task 2021-02-12T05:11:02.102Z] 05:11:02 INFO - 1613106662096 Marionette TRACE [33] MarionetteEvents actor created for window id 15
[task 2021-02-12T05:11:02.231Z] 05:11:02 INFO - 1613106662225 Marionette TRACE [33] MarionetteEvents actor created for window id 4294967297
[task 2021-02-12T05:11:02.247Z] 05:11:02 INFO - [CodeCoverage] Setting handlers for process 2502.
[task 2021-02-12T05:11:02.389Z] 05:11:02 INFO - [CodeCoverage] Setting handlers for process 2503.
[task 2021-02-12T05:11:02.627Z] 05:11:02 INFO - 1613106662613 Marionette DEBUG 1 <- [1,27,null,{"value":"iVBORw0KGgoAAAANSUhEUgAABQAAAAQQCAYAAAC9RfbYAAAgAElEQVR4nOzd32+chZ3vcV/kMtf9A/IH9MarvTqXvcpNFNFIFCSQoA2r ... QgAAAAAIwJQAAAAAAYE4AAAAAAMCYAAQAAAGBMAAIAAADAmAAEAAAAgDEBCAAAAABjAhAAAAAAxgQgAAAAAIwJQAAAAAAYC2lCJ8xwgDJmAAAAAElFTkSuQmCC"}]
[task 2021-02-12T05:11:02.663Z] 05:11:02 INFO - 1613106662655 Marionette DEBUG 1 -> [0,28,"Marionette:SetContext",{"value":"chrome"}]
[task 2021-02-12T05:11:02.664Z] 05:11:02 INFO - 1613106662657 Marionette DEBUG 1 <- [1,28,null,{"value":null}]
[task 2021-02-12T05:11:02.665Z] 05:11:02 INFO - [CodeCoverage] Setting handlers for process 2504.
[task 2021-02-12T05:11:02.681Z] 05:11:02 INFO - 1613106662671 Marionette TRACE [35] MarionetteEvents actor created for window id 18
[task 2021-02-12T05:11:02.682Z] 05:11:02 INFO - 1613106662673 Marionette DEBUG 1 -> [0,29,"Marionette:GetContext",{}]
[task 2021-02-12T05:11:02.683Z] 05:11:02 INFO - 1613106662676 Marionette DEBUG 1 <- [1,29,null,{"value":"chrome"}]
[task 2021-02-12T05:11:02.687Z] 05:11:02 INFO - 1613106662684 Marionette TRACE [37] MarionetteEvents actor created for window id 22
[task 2021-02-12T05:11:02.695Z] 05:11:02 INFO - 1613106662688 Marionette DEBUG 1 -> [0,30,"Marionette:SetContext",{"value":"content"}]
[task 2021-02-12T05:11:02.695Z] 05:11:02 INFO - 1613106662690 Marionette DEBUG 1 <- [1,30,null,{"value":null}]
[task 2021-02-12T05:11:02.714Z] 05:11:02 INFO - 1613106662702 Marionette DEBUG 1 -> [0,31,"WebDriver:GetPageSource",{}]
[task 2021-02-12T05:11:02.750Z] 05:11:02 INFO - 1613106662745 Marionette TRACE [35] MarionetteCommands actor created for window id 6442450945
[task 2021-02-12T05:11:02.786Z] 05:11:02 INFO - 1613106662776 Marionette TRACE [39] MarionetteEvents actor created for window id 24
[task 2021-02-12T05:11:02.813Z] 05:11:02 INFO - 1613106662810 Marionette DEBUG 1 <- [1,31,{"error":"unknown error","message":"TypeError: can't access property \"outerHTML\", this.document.documentElement is nu ... onetteCommandsChild.jsm:337:5\nreceiveMessage@chrome://marionette/content/actors/MarionetteCommandsChild.jsm:121:31\n"},null]
[task 2021-02-12T05:11:02.821Z] 05:11:02 INFO - 1613106662815 Marionette TRACE [35] MarionetteEvents actor created for window id 6442450945
[task 2021-02-12T05:11:02.882Z] 05:11:02 INFO - 1613106662865 Marionette DEBUG 1 -> [0,32,"Marionette:SetContext",{"value":"chrome"}]
[task 2021-02-12T05:11:02.883Z] 05:11:02 INFO - 1613106662867 Marionette DEBUG 1 <- [1,32,null,{"value":null}]
[task 2021-02-12T05:11:02.884Z] 05:11:02 WARNING - Failed to gather test failure debug: TypeError: can't access property "outerHTML", this.document.documentElement is null
[task 2021-02-12T05:11:02.884Z] 05:11:02 WARNING - stacktrace:
[task 2021-02-12T05:11:02.885Z] 05:11:02 WARNING - getPageSource@chrome://marionette/content/actors/MarionetteCommandsChild.jsm:337:5
[task 2021-02-12T05:11:02.885Z] 05:11:02 WARNING - receiveMessage@chrome://marionette/content/actors/MarionetteCommandsChild.jsm:121:31
[task 2021-02-12T05:11:02.885Z] 05:11:02 WARNING -
[task 2021-02-12T05:11:02.920Z] 05:11:02 INFO - TEST-UNEXPECTED-FAIL | testing/firefox-ui/tests/functional/sessionstore/test_restore_windows_after_restart_and_quit.py TestSessionStoreDisabled.test_restore_with_restart | AssertionError: Non private browsing windows should have
[task 2021-02-12T05:11:02.921Z] 05:11:02 INFO - been restored. Expected set([('http://127.0.0.1:37311/layout/mozilla_organizations.html', 'http://127.0.0.1:37311/layout/mozilla_community.html'), ('http://127.0.0.1:37311/layout/mozilla_governance.html', 'http://127.0.0.1:37311/layout/mozilla_grants.html'), ('http://127.0.0.1:37311/layout/mozilla.html',)]), got set([(u'about:blank', u'about:blank'), (u'about:blank',)]).
[task 2021-02-12T05:11:02.921Z] 05:11:02 INFO - Traceback (most recent call last):
[task 2021-02-12T05:11:02.921Z] 05:11:02 INFO - File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_harness/marionette_test/testcases.py", line 214, in run
[task 2021-02-12T05:11:02.921Z] 05:11:02 INFO - testMethod()
[task 2021-02-12T05:11:02.921Z] 05:11:02 INFO - File "/builds/worker/workspace/build/tests/firefox-ui/tests/testing/firefox-ui/tests/functional/sessionstore/test_restore_windows_after_restart_and_quit.py", line 110, in test_restore_with_restart
[task 2021-02-12T05:11:02.921Z] 05:11:02 INFO - self.test_windows, current_windows_set
[task 2021-02-12T05:11:02.921Z] 05:11:02 INFO - TEST-INFO took 57960ms
[task 2021-02-12T05:11:02.921Z] 05:11:02 INFO - 1613106662900 Marionette DEBUG 1 -> [0,33,"Marionette:GetContext",{}]
[task 2021-02-12T05:11:02.921Z] 05:11:02 INFO - 1613106662901 Marionette DEBUG 1 <- [1,33,null,{"value":"chrome"}]
[task 2021-02-12T05:11:02.956Z] 05:11:02 INFO - 1613106662948 Marionette DEBUG 1 -> [0,34,"WebDriver:DeleteSession",{}]
[task 2021-02-12T05:11:02.958Z] 05:11:02 INFO - 1613106662955 Marionette DEBUG 1 <- [1,34,null,{"value":null}]
[task 2021-02-12T05:11:03.035Z] 05:11:03 INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox -no-remote -marionette -profile /builds/worker/workspace/build/tmpWr7LyK.mozrunner
[task 2021-02-12T05:11:03.103Z] 05:11:03 INFO - [CodeCoverage] Setting handlers for process 2698.
[task 2021-02-12T05:11:04.326Z] 05:11:04 INFO - 1613106664316 Marionette TRACE Marionette enabled
[task 2021-02-12T05:11:04.527Z] 05:11:04 INFO - 1613106664524 Marionette TRACE Received observer notification toplevel-window-ready
[task 2021-02-12T05:11:07.165Z] 05:11:07 INFO - console.warn: SearchSettings: "get: No settings file exists, new profile?" (new Error("", "(unknown module)"))
[task 2021-02-12T05:11:09.021Z] 05:11:09 INFO - 1613106669014 Marionette TRACE Received observer notification marionette-startup-requested
[task 2021-02-12T05:11:09.022Z] 05:11:09 INFO - 1613106669015 Marionette TRACE Waiting until startup recorder finished recording startup scripts...
[task 2021-02-12T05:11:09.078Z] 05:11:09 INFO - 1613106669067 Marionette TRACE All scripts recorded.
[task 2021-02-12T05:11:09.078Z] 05:11:09 INFO - 1613106669072 Marionette INFO Listening on port 2828
[task 2021-02-12T05:11:09.078Z] 05:11:09 INFO - 1613106669073 Marionette DEBUG Marionette is listening
[task 2021-02-12T05:11:09.218Z] 05:11:09 INFO - 1613106669210 Marionette DEBUG Accepted connection 0 from 127.0.0.1:37488
[task 2021-02-12T05:11:09.239Z] 05:11:09 INFO - 1613106669230 Marionette DEBUG Closed connection 0
[task 2021-02-12T05:11:09.239Z] 05:11:09 INFO - 1613106669232 Marionette DEBUG Accepted connection 1 from 127.0.0.1:37490
[task 2021-02-12T05:11:09.262Z] 05:11:09 INFO - 1613106669259 Marionette DEBUG 1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2021-02-12T05:11:09.298Z] 05:11:09 INFO - 1613106669289 Marionette DEBUG 1 <- [1,1,null,{"sessionId":"46ace54e-f44c-4391-88ea-fc328755652e","capabilities":{"browserName":"firefox","browserVersion":"87.0a ... ld/tmpWr7LyK.mozrunner","moz:shutdownTimeout":60000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true}}]
[task 2021-02-12T05:11:09.318Z] 05:11:09 INFO - 1613106669310 Marionette DEBUG 1 -> [0,2,"Marionette:SetContext",{"value":"chrome"}]
[task 2021-02-12T05:11:09.318Z] 05:11:09 INFO - 1613106669311 Marionette DEBUG 1 <- [1,2,null,{"value":null}]
[task 2021-02-12T05:11:09.326Z] 05:11:09 INFO - 1613106669319 Marionette DEBUG 1 -> [0,3,"WebDriver:GetChromeWindowHandles",{}]
[task 2021-02-12T05:11:09.326Z] 05:11:09 INFO - 1613106669320 Marionette DEBUG 1 <- [1,3,null,["6"]]
[task 2021-02-12T05:11:09.326Z] 05:11:09 INFO - 1613106669323 Marionette DEBUG 1 -> [0,4,"WebDriver:GetWindowHandles",{}]
[task 2021-02-12T05:11:09.326Z] 05:11:09 INFO - 1613106669324 Marionette DEBUG 1 <- [1,4,null,["17"]]
[task 2021-02-12T05:11:09.334Z] 05:11:09 INFO - 1613106669328 Marionette DEBUG 1 -> [0,5,"WebDriver:DeleteSession",{}]
[task 2021-02-12T05:11:09.334Z] 05:11:09 INFO - 1613106669330 Marionette DEBUG 1 <- [1,5,null,{"value":null}]```
|
||
Updated•5 years ago
|
Status: NEW → RESOLVED
Closed: 5 years ago
Resolution: --- → DUPLICATE
| Comment hidden (Intermittent Failures Robot) |
You need to log in
before you can comment on or make changes to this bug.
Description
•