Closed
Bug 1892003
Opened 1 year ago
Closed 9 months ago
Intermittent browser/components/sessionstore/test/marionette/test_restore_manually_with_pinned_tabs.py TestSessionRestoreWithPinnedTabs.test_no_restore_with_quit | single tracking bug
Categories
(Firefox :: Session Restore, defect, P5)
Firefox
Session Restore
Tracking
()
RESOLVED
INCOMPLETE
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure, intermittent-testcase)
Filed by: pstanciu [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=454836139&repo=try
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/XFmmlaHZTh2nM1XrJqjtRg/runs/0/artifacts/public/logs/live_backing.log
[task 2024-04-17T12:08:41.836Z] 12:08:41 INFO - TEST-START | browser/components/sessionstore/test/marionette/test_restore_manually_with_pinned_tabs.py TestSessionRestoreWithPinnedTabs.test_no_restore_with_quit
[task 2024-04-17T12:08:41.837Z] 12:08:41 INFO - 1713355721837 Marionette DEBUG Closed connection 1
[task 2024-04-17T12:08:41.840Z] 12:08:41 INFO - 1713355721839 Marionette DEBUG Accepted connection 2 from 127.0.0.1:45236
[task 2024-04-17T12:08:41.842Z] 12:08:41 INFO - 1713355721841 Marionette DEBUG 2 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2024-04-17T12:08:41.843Z] 12:08:41 INFO - 1713355721843 Marionette DEBUG Waiting for initial application window
[task 2024-04-17T12:08:41.845Z] 12:08:41 INFO - 1713355721844 RemoteAgent TRACE [9] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=5000 waitForExplicitStart=false
[task 2024-04-17T12:08:41.846Z] 12:08:41 INFO - 1713355721845 RemoteAgent TRACE [9] ProgressListener Setting unload timer (5000ms)
[task 2024-04-17T12:08:41.846Z] 12:08:41 INFO - 1713355721846 RemoteAgent TRACE [9] Document already finished loading: about:blank
[task 2024-04-17T12:08:41.847Z] 12:08:41 INFO - 1713355721847 RemoteAgent TRACE [9] ProgressListener Stop: has error=false
[task 2024-04-17T12:08:41.851Z] 12:08:41 INFO - 1713355721850 Marionette DEBUG 2 <- [1,1,null,{"sessionId":"32268079-a8bc-431d-8983-c14e0538b2f5","capabilities":{"browserName":"firefox","browserVersion":"127.0","platformName":"linux","acceptInsecureCerts":false,"pageLoadStrategy":"normal","setWindowRect":true,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"strictFileInteractability":true,"unhandledPromptBehavior":"dismiss and notify","userAgent":"Mozilla/5.0 (X11; Linux x86_64; rv:127.0) Gecko/20100101 Firefox/127.0","moz:accessibilityChecks":false,"moz:buildID":"20240417092525","moz:headless":false,"moz:platformVersion":"4.4.0-1014-aws","moz:processID":6218,"moz:profile":"/tmp/tmpdj38cs25.mozrunner","moz:shutdownTimeout":60000,"moz:webdriverClick":true,"moz:windowless":false,"proxy":{}}}]
[task 2024-04-17T12:08:41.852Z] 12:08:41 INFO - 1713355721852 Marionette DEBUG 2 -> [0,2,"WebDriver:SetTimeouts",{"script":30000}]
[task 2024-04-17T12:08:41.854Z] 12:08:41 INFO - 1713355721853 Marionette DEBUG 2 <- [1,2,null,{"value":null}]
[task 2024-04-17T12:08:41.856Z] 12:08:41 INFO - 1713355721855 Marionette DEBUG 2 -> [0,3,"WebDriver:SetTimeouts",{"pageLoad":300000}]
[task 2024-04-17T12:08:41.856Z] 12:08:41 INFO - 1713355721856 Marionette DEBUG 2 <- [1,3,null,{"value":null}]
[task 2024-04-17T12:08:41.858Z] 12:08:41 INFO - 1713355721857 Marionette DEBUG 2 -> [0,4,"WebDriver:SetTimeouts",{"implicit":0}]
[task 2024-04-17T12:08:41.859Z] 12:08:41 INFO - 1713355721859 Marionette DEBUG 2 <- [1,4,null,{"value":null}]
[task 2024-04-17T12:08:41.860Z] 12:08:41 INFO - 1713355721860 Marionette DEBUG 2 -> [0,5,"Marionette:GetContext",{}]
[task 2024-04-17T12:08:41.862Z] 12:08:41 INFO - 1713355721861 Marionette DEBUG 2 <- [1,5,null,{"value":"content"}]
[task 2024-04-17T12:08:41.863Z] 12:08:41 INFO - 1713355721863 Marionette DEBUG 2 -> [0,6,"Marionette:SetContext",{"value":"chrome"}]
[task 2024-04-17T12:08:41.864Z] 12:08:41 INFO - 1713355721864 Marionette DEBUG 2 <- [1,6,null,{"value":null}]
[task 2024-04-17T12:08:41.865Z] 12:08:41 INFO - 1713355721865 Marionette DEBUG 2 -> [0,7,"WebDriver:GetWindowHandle",{}]
[task 2024-04-17T12:08:41.866Z] 12:08:41 INFO - 1713355721866 Marionette DEBUG 2 <- [1,7,null,{"value":"eec75a80-b747-4431-a06b-6d5f474557de"}]
[task 2024-04-17T12:08:41.867Z] 12:08:41 INFO - 1713355721867 Marionette DEBUG 2 -> [0,8,"Marionette:SetContext",{"value":"content"}]
[task 2024-04-17T12:08:41.868Z] 12:08:41 INFO - 1713355721868 Marionette DEBUG 2 <- [1,8,null,{"value":null}]
[task 2024-04-17T12:08:41.869Z] 12:08:41 INFO - 1713355721869 Marionette DEBUG 2 -> [0,9,"Marionette:GetContext",{}]
[task 2024-04-17T12:08:41.870Z] 12:08:41 INFO - 1713355721870 Marionette DEBUG 2 <- [1,9,null,{"value":"content"}]
[task 2024-04-17T12:08:41.871Z] 12:08:41 INFO - 1713355721871 Marionette DEBUG 2 -> [0,10,"Marionette:SetContext",{"value":"chrome"}]
[task 2024-04-17T12:08:41.872Z] 12:08:41 INFO - 1713355721872 Marionette DEBUG 2 <- [1,10,null,{"value":null}]
[task 2024-04-17T12:08:41.873Z] 12:08:41 INFO - 1713355721873 Marionette DEBUG 2 -> [0,11,"WebDriver:GetWindowHandles",{}]
[task 2024-04-17T12:08:41.874Z] 12:08:41 INFO - 1713355721874 Marionette DEBUG 2 <- [1,11,null,["eec75a80-b747-4431-a06b-6d5f474557de"]]
[task 2024-04-17T12:08:41.876Z] 12:08:41 INFO - 1713355721876 Marionette DEBUG 2 -> [0,12,"Marionette:SetContext",{"value":"content"}]
[task 2024-04-17T12:08:41.878Z] 12:08:41 INFO - 1713355721877 Marionette DEBUG 2 <- [1,12,null,{"value":null}]
[task 2024-04-17T12:08:41.879Z] 12:08:41 INFO - 1713355721879 Marionette DEBUG 2 -> [0,13,"Marionette:GetContext",{}]
[task 2024-04-17T12:08:41.880Z] 12:08:41 INFO - 1713355721879 Marionette DEBUG 2 <- [1,13,null,{"value":"content"}]
[task 2024-04-17T12:08:41.881Z] 12:08:41 INFO - 1713355721881 Marionette DEBUG 2 -> [0,14,"Marionette:SetContext",{"value":"content"}]
[task 2024-04-17T12:08:41.882Z] 12:08:41 INFO - 1713355721882 Marionette DEBUG 2 <- [1,14,null,{"value":null}]
[task 2024-04-17T12:08:41.883Z] 12:08:41 INFO - 1713355721883 Marionette DEBUG 2 -> [0,15,"WebDriver:GetWindowHandle",{}]
[task 2024-04-17T12:08:41.885Z] 12:08:41 INFO - 1713355721884 Marionette DEBUG 2 <- [1,15,null,{"value":"a3d226a6-ee5e-4e0a-ab43-15f3388e06d3"}]
[task 2024-04-17T12:08:41.886Z] 12:08:41 INFO - 1713355721885 Marionette DEBUG 2 -> [0,16,"Marionette:SetContext",{"value":"content"}]
[task 2024-04-17T12:08:41.888Z] 12:08:41 INFO - 1713355721887 Marionette DEBUG 2 <- [1,16,null,{"value":null}]
[task 2024-04-17T12:08:41.890Z] 12:08:41 INFO - 1713355721890 Marionette DEBUG 2 -> [0,17,"Marionette:GetContext",{}]
[task 2024-04-17T12:08:41.892Z] 12:08:41 INFO - 1713355721892 Marionette DEBUG 2 <- [1,17,null,{"value":"content"}]
[task 2024-04-17T12:08:41.894Z] 12:08:41 INFO - 1713355721894 Marionette DEBUG 2 -> [0,18,"Marionette:SetContext",{"value":"content"}]
[task 2024-04-17T12:08:41.896Z] 12:08:41 INFO - 1713355721896 Marionette DEBUG 2 <- [1,18,null,{"value":null}]
[task 2024-04-17T12:08:41.899Z] 12:08:41 INFO - 1713355721898 Marionette DEBUG 2 -> [0,19,"WebDriver:GetWindowHandles",{}]
[task 2024-04-17T12:08:41.900Z] 12:08:41 INFO - 1713355721899 Marionette DEBUG 2 <- [1,19,null,["a3d226a6-ee5e-4e0a-ab43-15f3388e06d3"]]
[task 2024-04-17T12:08:41.901Z] 12:08:41 INFO - 1713355721901 Marionette DEBUG 2 -> [0,20,"Marionette:SetContext",{"value":"content"}]
[task 2024-04-17T12:08:41.902Z] 12:08:41 INFO - 1713355721901 Marionette DEBUG 2 <- [1,20,null,{"value":null}]
[task 2024-04-17T12:08:41.903Z] 12:08:41 INFO - 1713355721903 Marionette DEBUG 2 -> [0,21,"Marionette:SetContext",{"value":"chrome"}]
[task 2024-04-17T12:08:41.904Z] 12:08:41 INFO - 1713355721904 Marionette DEBUG 2 <- [1,21,null,{"value":null}]
[task 2024-04-17T12:08:41.905Z] 12:08:41 INFO - 1713355721905 Marionette DEBUG 2 -> [0,22,"Marionette:GetContext",{}]
[task 2024-04-17T12:08:41.906Z] 12:08:41 INFO - 1713355721906 Marionette DEBUG 2 <- [1,22,null,{"value":"chrome"}]
[task 2024-04-17T12:08:41.907Z] 12:08:41 INFO - 1713355721907 Marionette DEBUG 2 -> [0,23,"Marionette:SetContext",{"value":"chrome"}]
[task 2024-04-17T12:08:41.908Z] 12:08:41 INFO - 1713355721908 Marionette DEBUG 2 <- [1,23,null,{"value":null}]
[task 2024-04-17T12:08:41.911Z] 12:08:41 INFO - 1713355721910 Marionette DEBUG 2 -> [0,24,"WebDriver:ExecuteScript",{"script":"let prefInterface = Components.classes[\"@mozilla.org/preferences-service;1\"]\n .g ... ref).toString();\n case prefInterface.PREF_INVALID:\n return false;\n }","args":[],"newSandbox":true,"sandbox":"default","line":1021,"filename":"../../venv/lib/python3.8/site-packages/marionette_driver/marionette.py"}]
[task 2024-04-17T12:08:41.916Z] 12:08:41 INFO - 1713355721916 RemoteAgent TRACE WebDriverProcessData actor created for PID 6218
[task 2024-04-17T12:08:41.918Z] 12:08:41 INFO - 1713355721918 Marionette TRACE [1] MarionetteCommands actor created for window id 2
[task 2024-04-17T12:08:41.922Z] 12:08:41 INFO - 1713355721921 Marionette DEBUG 2 <- [1,24,null,{"value":false}]
[task 2024-04-17T12:08:41.923Z] 12:08:41 INFO - 1713355721923 Marionette DEBUG 2 -> [0,25,"Marionette:SetContext",{"value":"chrome"}]
[task 2024-04-17T12:08:41.924Z] 12:08:41 INFO - 1713355721924 Marionette DEBUG 2 <- [1,25,null,{"value":null}]
[task 2024-04-17T12:08:41.926Z] 12:08:41 INFO - 1713355721925 Marionette DEBUG 2 -> [0,26,"Marionette:GetContext",{}]
[task 2024-04-17T12:08:41.927Z] 12:08:41 INFO - 1713355721926 Marionette DEBUG 2 <- [1,26,null,{"value":"chrome"}]
[task 2024-04-17T12:08:41.928Z] 12:08:41 INFO - 1713355721928 Marionette DEBUG 2 -> [0,27,"WebDriver:DeleteSession",{}]
[task 2024-04-17T12:08:41.929Z] 12:08:41 INFO - 1713355721929 Marionette TRACE [1] MarionetteCommands actor destroyed for window id 2
[task 2024-04-17T12:08:41.932Z] 12:08:41 INFO - 1713355721931 Marionette DEBUG 2 <- [1,27,null,{"value":null}]
[task 2024-04-17T12:08:41.979Z] 12:08:41 INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox -no-remote -marionette -profile /tmp/tmpi7zi1634.mozrunner
[task 2024-04-17T12:08:42.418Z] 12:08:42 INFO - ATTENTION: default value of option mesa_glthread overridden by environment.
[task 2024-04-17T12:08:42.443Z] 12:08:42 INFO - 1713355722443 Marionette INFO Marionette enabled
[task 2024-04-17T12:08:42.448Z] 12:08:42 INFO - 1713355722444 Marionette TRACE Received observer notification final-ui-startup
[task 2024-04-17T12:08:42.485Z] 12:08:42 INFO - ATTENTION: default value of option mesa_glthread overridden by environment.
[task 2024-04-17T12:08:42.508Z] 12:08:42 INFO - 1713355722508 Marionette INFO Listening on port 2828
[task 2024-04-17T12:08:42.513Z] 12:08:42 INFO - 1713355722509 Marionette DEBUG Marionette is listening
[task 2024-04-17T12:08:42.518Z] 12:08:42 INFO - 1713355722518 Marionette DEBUG Accepted connection 0 from 127.0.0.1:45248
[task 2024-04-17T12:08:42.569Z] 12:08:42 INFO - 1713355722568 Marionette DEBUG Accepted connection 1 from 127.0.0.1:45250
[task 2024-04-17T12:08:42.570Z] 12:08:42 INFO - 1713355722569 Marionette DEBUG Closed connection 0
[task 2024-04-17T12:08:42.695Z] 12:08:42 INFO - 1713355722694 Marionette DEBUG 1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2024-04-17T12:08:42.698Z] 12:08:42 INFO - 1713355722698 Marionette DEBUG Waiting for initial application window
[task 2024-04-17T12:08:45.616Z] 12:08:45 INFO - console.error: ({})
[task 2024-04-17T12:08:46.683Z] 12:08:46 INFO - 1713355726682 Marionette TRACE Received observer notification browser-idle-startup-tasks-finished
[task 2024-04-17T12:08:46.689Z] 12:08:46 INFO - 1713355726688 RemoteAgent TRACE [9] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=5000 waitForExplicitStart=false
[task 2024-04-17T12:08:46.690Z] 12:08:46 INFO - 1713355726688 RemoteAgent TRACE [9] ProgressListener Setting unload timer (5000ms)
[task 2024-04-17T12:08:46.690Z] 12:08:46 INFO - 1713355726688 RemoteAgent TRACE [9] Document already finished loading: about:home
[task 2024-04-17T12:08:46.691Z] 12:08:46 INFO - 1713355726688 RemoteAgent TRACE [9] ProgressListener Stop: has error=false
[task 2024-04-17T12:08:46.701Z] 12:08:46 INFO - 1713355726700 Marionette DEBUG 1 <- [1,1,null,{"sessionId":"2cfaf290-ea32-46f9-ae0f-3507b27e68fd","capabilities":{"browserName":"firefox","browserVersion":"127.0","platformName":"linux","acceptInsecureCerts":false,"pageLoadStrategy":"normal","setWindowRect":true,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"strictFileInteractability":true,"unhandledPromptBehavior":"dismiss and notify","userAgent":"Mozilla/5.0 (X11; Linux x86_64; rv:127.0) Gecko/20100101 Firefox/127.0","moz:accessibilityChecks":false,"moz:buildID":"20240417092525","moz:headless":false,"moz:platformVersion":"4.4.0-1014-aws","moz:processID":6441,"moz:profile":"/tmp/tmpi7zi1634.mozrunner","moz:shutdownTimeout":60000,"moz:webdriverClick":true,"moz:windowless":false,"proxy":{}}}]
[task 2024-04-17T12:08:46.715Z] 12:08:46 INFO - 1713355726705 Marionette DEBUG 1 -> [0,2,"Marionette:SetContext",{"value":"chrome"}]
[task 2024-04-17T12:08:46.715Z] 12:08:46 INFO - 1713355726706 Marionette DEBUG 1 <- [1,2,null,{"value":null}]
[task 2024-04-17T12:08:46.715Z] 12:08:46 INFO - 1713355726706 Marionette DEBUG 1 -> [0,3,"Marionette:GetContext",{}]
[task 2024-04-17T12:08:46.716Z] 12:08:46 INFO - 1713355726706 Marionette DEBUG 1 <- [1,3,null,{"value":"chrome"}]
[task 2024-04-17T12:08:46.716Z] 12:08:46 INFO - 1713355726707 Marionette DEBUG 1 -> [0,4,"Marionette:SetContext",{"value":"chrome"}]
[task 2024-04-17T12:08:46.716Z] 12:08:46 INFO - 1713355726707 Marionette DEBUG 1 <- [1,4,null,{"value":null}]
[task 2024-04-17T12:08:46.717Z] 12:08:46 INFO - 1713355726707 Marionette DEBUG 1 -> [0,5,"WebDriver:GetWindowHandle",{}]
[task 2024-04-17T12:08:46.717Z] 12:08:46 INFO - 1713355726708 Marionette DEBUG 1 <- [1,5,null,{"value":"9c8a2aa3-2bfd-4ab8-87e1-1afa22781c00"}]
[task 2024-04-17T12:08:46.717Z] 12:08:46 INFO - 1713355726708 Marionette DEBUG 1 -> [0,6,"Marionette:SetContext",{"value":"chrome"}]
[task 2024-04-17T12:08:46.718Z] 12:08:46 INFO - 1713355726708 Marionette DEBUG 1 <- [1,6,null,{"value":null}]
[task 2024-04-17T12:08:46.718Z] 12:08:46 INFO - 1713355726709 Marionette DEBUG 1 -> [0,7,"Marionette:GetContext",{}]
[task 2024-04-17T12:08:46.718Z] 12:08:46 INFO - 1713355726709 Marionette DEBUG 1 <- [1,7,null,{"value":"chrome"}]
[task 2024-04-17T12:08:46.718Z] 12:08:46 INFO - 1713355726709 Marionette DEBUG 1 -> [0,8,"Marionette:SetContext",{"value":"content"}]
[task 2024-04-17T12:08:46.718Z] 12:08:46 INFO - 1713355726709 Marionette DEBUG 1 <- [1,8,null,{"value":null}]
[task 2024-04-17T12:08:46.719Z] 12:08:46 INFO - 1713355726710 Marionette DEBUG 1 -> [0,9,"WebDriver:Navigate",{"url":"data:text/html;charset=utf-8,%3Cdiv%22%3Eipsum%3C/div%3E"}]
[task 2024-04-17T12:08:46.719Z] 12:08:46 INFO - 1713355726713 Marionette TRACE [9] Received event beforeunload for about:home
[task 2024-04-17T12:08:46.733Z] 12:08:46 INFO - 1713355726732 Marionette TRACE [9] Received event pagehide for about:home
[task 2024-04-17T12:08:46.758Z] 12:08:46 INFO - 1713355726757 Marionette TRACE [9] Received event DOMContentLoaded for data:text/html;charset=utf-8,%3Cdiv%22%3Eipsum%3C/div%3E
[task 2024-04-17T12:08:46.758Z] 12:08:46 INFO - 1713355726757 Marionette TRACE [9] Received event pageshow for data:text/html;charset=utf-8,%3Cdiv%22%3Eipsum%3C/div%3E
[task 2024-04-17T12:08:46.760Z] 12:08:46 INFO - 1713355726759 Marionette DEBUG 1 <- [1,9,null,{"value":null}]
[task 2024-04-17T12:08:46.776Z] 12:08:46 INFO - 1713355726776 Marionette DEBUG 1 -> [0,10,"Marionette:GetContext",{}]
[task 2024-04-17T12:08:46.777Z] 12:08:46 INFO - 1713355726776 Marionette DEBUG 1 <- [1,10,null,{"value":"content"}]
[task 2024-04-17T12:08:46.779Z] 12:08:46 INFO - 1713355726778 Marionette DEBUG 1 -> [0,11,"Marionette:SetContext",{"value":"content"}]
[task 2024-04-17T12:08:46.779Z] 12:08:46 INFO - 1713355726778 Marionette DEBUG 1 <- [1,11,null,{"value":null}]
[task 2024-04-17T12:08:46.781Z] 12:08:46 INFO - 1713355726780 Marionette DEBUG 1 -> [0,12,"WebDriver:GetWindowHandles",{}]
[task 2024-04-17T12:08:46.781Z] 12:08:46 INFO - 1713355726780 Marionette DEBUG 1 <- [1,12,null,["e6c0e180-2fa3-4fcd-82a2-46d35e99343d"]]
[task 2024-04-17T12:08:46.782Z] 12:08:46 INFO - 1713355726782 Marionette DEBUG 1 -> [0,13,"Marionette:SetContext",{"value":"content"}]
[task 2024-04-17T12:08:46.783Z] 12:08:46 INFO - 1713355726782 Marionette DEBUG 1 <- [1,13,null,{"value":null}]
[task 2024-04-17T12:08:46.784Z] 12:08:46 INFO - 1713355726784 Marionette DEBUG 1 -> [0,14,"WebDriver:NewWindow",{"type":"tab","focus":false,"private":false}]
[task 2024-04-17T12:08:46.802Z] 12:08:46 INFO - 1713355726802 RemoteAgent TRACE Received DOM event TabOpen for [object XULElement]
[task 2024-04-17T12:08:46.837Z] 12:08:46 INFO - 1713355726837 RemoteAgent TRACE Received DOM event TabSelect for [object XULElement]
[task 2024-04-17T12:08:46.857Z] 12:08:46 INFO - 1713355726857 RemoteAgent TRACE [12] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=5000 waitForExplicitStart=false
[task 2024-04-17T12:08:46.858Z] 12:08:46 INFO - 1713355726857 RemoteAgent TRACE [12] ProgressListener Document already loading about:blank
[task 2024-04-17T12:08:46.859Z] 12:08:46 INFO - 1713355726857 RemoteAgent TRACE [12] ProgressListener Check loading state: isStart=true isStop=false
[task 2024-04-17T12:08:46.860Z] 12:08:46 INFO - 1713355726857 RemoteAgent TRACE [12] ProgressListener state=start: about:blank
[task 2024-04-17T12:08:46.888Z] 12:08:46 INFO - 1713355726888 RemoteAgent TRACE [12] ProgressListener Check loading state: isStart=0 isStop=16
[task 2024-04-17T12:08:46.890Z] 12:08:46 INFO - 1713355726889 RemoteAgent TRACE [12] ProgressListener state=stop: about:blank
[task 2024-04-17T12:08:46.891Z] 12:08:46 INFO - 1713355726891 RemoteAgent TRACE [12] ProgressListener Stop: has error=false
[task 2024-04-17T12:08:46.893Z] 12:08:46 INFO - 1713355726893 Marionette DEBUG 1 <- [1,14,null,{"handle":"090c1c6b-d283-42b8-be58-5f2c91be8210","type":"tab"}]
[task 2024-04-17T12:08:46.895Z] 12:08:46 INFO - 1713355726895 Marionette DEBUG 1 -> [0,15,"Marionette:GetContext",{}]
[task 2024-04-17T12:08:46.897Z] 12:08:46 INFO - 1713355726896 Marionette DEBUG 1 <- [1,15,null,{"value":"content"}]
[task 2024-04-17T12:08:46.899Z] 12:08:46 INFO - 1713355726898 Marionette DEBUG 1 -> [0,16,"Marionette:SetContext",{"value":"content"}]
[task 2024-04-17T12:08:46.900Z] 12:08:46 INFO - 1713355726899 Marionette DEBUG 1 <- [1,16,null,{"value":null}]
[task 2024-04-17T12:08:46.905Z] 12:08:46 INFO - 1713355726904 Marionette DEBUG 1 -> [0,17,"WebDriver:GetWindowHandles",{}]
[task 2024-04-17T12:08:46.908Z] 12:08:46 INFO - 1713355726905 Marionette DEBUG 1 <- [1,17,null,["e6c0e180-2fa3-4fcd-82a2-46d35e99343d","090c1c6b-d283-42b8-be58-5f2c91be8210"]]
[task 2024-04-17T12:08:46.909Z] 12:08:46 INFO - 1713355726909 Marionette DEBUG 1 -> [0,18,"Marionette:SetContext",{"value":"content"}]
[task 2024-04-17T12:08:46.909Z] 12:08:46 INFO - 1713355726909 Marionette DEBUG 1 <- [1,18,null,{"value":null}]
[task 2024-04-17T12:08:46.910Z] 12:08:46 INFO - 1713355726910 Marionette DEBUG 1 -> [0,19,"Marionette:GetContext",{}]
[task 2024-04-17T12:08:46.910Z] 12:08:46 INFO - 1713355726910 Marionette DEBUG 1 <- [1,19,null,{"value":"content"}]
[task 2024-04-17T12:08:46.911Z] 12:08:46 INFO - 1713355726911 Marionette DEBUG 1 -> [0,20,"Marionette:SetContext",{"value":"content"}]
[task 2024-04-17T12:08:46.911Z] 12:08:46 INFO - 1713355726911 Marionette DEBUG 1 <- [1,20,null,{"value":null}]
[task 2024-04-17T12:08:46.912Z] 12:08:46 INFO - 1713355726912 Marionette DEBUG 1 -> [0,21,"WebDriver:GetWindowHandles",{}]
[task 2024-04-17T12:08:46.913Z] 12:08:46 INFO - 1713355726912 Marionette DEBUG 1 <- [1,21,null,["e6c0e180-2fa3-4fcd-82a2-46d35e99343d","090c1c6b-d283-42b8-be58-5f2c91be8210"]]
[task 2024-04-17T12:08:46.914Z] 12:08:46 INFO - 1713355726913 Marionette DEBUG 1 -> [0,22,"Marionette:SetContext",{"value":"content"}]
[task 2024-04-17T12:08:46.914Z] 12:08:46 INFO - 1713355726913 Marionette DEBUG 1 <- [1,22,null,{"value":null}]
[task 2024-04-17T12:08:46.915Z] 12:08:46 INFO - 1713355726914 Marionette DEBUG 1 -> [0,23,"WebDriver:SwitchToWindow",{"handle":"090c1c6b-d283-42b8-be58-5f2c91be8210","focus":true}]
[task 2024-04-17T12:08:46.920Z] 12:08:46 INFO - 1713355726919 RemoteAgent TRACE Received DOM event TabSelect for [object XULElement]
[task 2024-04-17T12:08:46.926Z] 12:08:46 INFO - 1713355726926 Marionette DEBUG 1 <- [1,23,null,{"value":null}]
[task 2024-04-17T12:08:46.928Z] 12:08:46 INFO - 1713355726928 Marionette DEBUG 1 -> [0,24,"WebDriver:Navigate",{"url":"data:text/html;charset=utf-8,%3Cdiv%22%3Edolor%3C/div%3E"}]
[task 2024-04-17T12:08:46.934Z] 12:08:46 INFO - 1713355726934 Marionette TRACE [12] Received event beforeunload for about:blank
[task 2024-04-17T12:08:46.946Z] 12:08:46 INFO - 1713355726946 Marionette TRACE Remoteness change detected. Set new top-level browsing context to 13
[task 2024-04-17T12:08:46.964Z] 12:08:46 INFO - 1713355726964 Marionette TRACE [13] Received event beforeunload for about:blank
[task 2024-04-17T12:08:46.966Z] 12:08:46 INFO - 1713355726965 Marionette TRACE [13] Received event pagehide for about:blank
[task 2024-04-17T12:08:46.973Z] 12:08:46 INFO - 1713355726973 Marionette TRACE [13] Received event DOMContentLoaded for data:text/html;charset=utf-8,%3Cdiv%22%3Edolor%3C/div%3E
[task 2024-04-17T12:08:46.974Z] 12:08:46 INFO - 1713355726974 Marionette TRACE [13] Received event pageshow for data:text/html;charset=utf-8,%3Cdiv%22%3Edolor%3C/div%3E
[task 2024-04-17T12:08:46.975Z] 12:08:46 INFO - 1713355726975 Marionette DEBUG 1 <- [1,24,null,{"value":null}]
[task 2024-04-17T12:08:46.980Z] 12:08:46 INFO - 1713355726979 Marionette DEBUG 1 -> [0,25,"Marionette:GetContext",{}]
[task 2024-04-17T12:08:46.980Z] 12:08:46 INFO - 1713355726980 Marionette DEBUG 1 <- [1,25,null,{"value":"content"}]
[task 2024-04-17T12:08:46.982Z] 12:08:46 INFO - 1713355726982 Marionette DEBUG 1 -> [0,26,"Marionette:SetContext",{"value":"content"}]
[task 2024-04-17T12:08:46.983Z] 12:08:46 INFO - 1713355726982 Marionette DEBUG 1 <- [1,26,null,{"value":null}]
[task 2024-04-17T12:08:46.983Z] 12:08:46 INFO - 1713355726983 Marionette DEBUG 1 -> [0,27,"WebDriver:GetWindowHandles",{}]
[task 2024-04-17T12:08:46.984Z] 12:08:46 INFO - 1713355726984 Marionette DEBUG 1 <- [1,27,null,["e6c0e180-2fa3-4fcd-82a2-46d35e99343d","090c1c6b-d283-42b8-be58-5f2c91be8210"]]
[task 2024-04-17T12:08:46.985Z] 12:08:46 INFO - 1713355726985 Marionette DEBUG 1 -> [0,28,"Marionette:SetContext",{"value":"content"}]
[task 2024-04-17T12:08:46.986Z] 12:08:46 INFO - 1713355726985 Marionette DEBUG 1 <- [1,28,null,{"value":null}]
[task 2024-04-17T12:08:46.987Z] 12:08:46 INFO - 1713355726986 Marionette DEBUG 1 -> [0,29,"WebDriver:NewWindow",{"type":"tab","focus":false,"private":false}]
[task 2024-04-17T12:08:46.999Z] 12:08:46 INFO - 1713355726998 RemoteAgent TRACE Received DOM event TabOpen for [object XULElement]
[task 2024-04-17T12:08:47.029Z] 12:08:47 INFO - 1713355727028 RemoteAgent TRACE Received DOM event TabSelect for [object XULElement]
[task 2024-04-17T12:08:47.037Z] 12:08:47 INFO - 1713355727036 RemoteAgent TRACE [14] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=5000 waitForExplicitStart=false
[task 2024-04-17T12:08:47.038Z] 12:08:47 INFO - 1713355727037 RemoteAgent TRACE [14] ProgressListener Document already loading about:blank
[task 2024-04-17T12:08:47.039Z] 12:08:47 INFO - 1713355727038 RemoteAgent TRACE [14] ProgressListener Check loading state: isStart=true isStop=false
[task 2024-04-17T12:08:47.039Z] 12:08:47 INFO - 1713355727039 RemoteAgent TRACE [14] ProgressListener state=start: about:blank
[task 2024-04-17T12:08:47.060Z] 12:08:47 INFO - 1713355727059 RemoteAgent TRACE [14] ProgressListener Check loading state: isStart=0 isStop=16
[task 2024-04-17T12:08:47.061Z] 12:08:47 INFO - 1713355727060 RemoteAgent TRACE [14] ProgressListener state=stop: about:blank
[task 2024-04-17T12:08:47.062Z] 12:08:47 INFO - 1713355727061 RemoteAgent TRACE [14] ProgressListener Stop: has error=false
[task 2024-04-17T12:08:47.063Z] 12:08:47 INFO - 1713355727063 Marionette DEBUG 1 <- [1,29,null,{"handle":"e8709d6b-58f9-442d-b338-edad6a351d70","type":"tab"}]
[task 2024-04-17T12:08:47.065Z] 12:08:47 INFO - 1713355727064 Marionette DEBUG 1 -> [0,30,"Marionette:GetContext",{}]
[task 2024-04-17T12:08:47.065Z] 12:08:47 INFO - 1713355727065 Marionette DEBUG 1 <- [1,30,null,{"value":"content"}]
[task 2024-04-17T12:08:47.066Z] 12:08:47 INFO - 1713355727066 Marionette DEBUG 1 -> [0,31,"Marionette:SetContext",{"value":"content"}]
[task 2024-04-17T12:08:47.067Z] 12:08:47 INFO - 1713355727066 Marionette DEBUG 1 <- [1,31,null,{"value":null}]
[task 2024-04-17T12:08:47.068Z] 12:08:47 INFO - 1713355727067 Marionette DEBUG 1 -> [0,32,"WebDriver:GetWindowHandles",{}]
[task 2024-04-17T12:08:47.069Z] 12:08:47 INFO - 1713355727068 Marionette DEBUG 1 <- [1,32,null,["e6c0e180-2fa3-4fcd-82a2-46d35e99343d","090c1c6b-d283-42b8-be58-5f2c91be8210","e8709d6b-58f9-442d-b338-edad6a351d70"]]
[task 2024-04-17T12:08:47.070Z] 12:08:47 INFO - 1713355727069 Marionette DEBUG 1 -> [0,33,"Marionette:SetContext",{"value":"content"}]
[task 2024-04-17T12:08:47.070Z] 12:08:47 INFO - 1713355727070 Marionette DEBUG 1 <- [1,33,null,{"value":null}]
[task 2024-04-17T12:08:47.071Z] 12:08:47 INFO - 1713355727071 Marionette DEBUG 1 -> [0,34,"Marionette:GetContext",{}]
[task 2024-04-17T12:08:47.072Z] 12:08:47 INFO - 1713355727072 Marionette DEBUG 1 <- [1,34,null,{"value":"content"}]
[task 2024-04-17T12:08:47.073Z] 12:08:47 INFO - 1713355727073 Marionette DEBUG 1 -> [0,35,"Marionette:SetContext",{"value":"content"}]
[task 2024-04-17T12:08:47.074Z] 12:08:47 INFO - 1713355727073 Marionette DEBUG 1 <- [1,35,null,{"value":null}]
[task 2024-04-17T12:08:47.075Z] 12:08:47 INFO - 1713355727075 Marionette DEBUG 1 -> [0,36,"WebDriver:GetWindowHandles",{}]
[task 2024-04-17T12:08:47.076Z] 12:08:47 INFO - 1713355727076 Marionette DEBUG 1 <- [1,36,null,["e6c0e180-2fa3-4fcd-82a2-46d35e99343d","090c1c6b-d283-42b8-be58-5f2c91be8210","e8709d6b-58f9-442d-b338-edad6a351d70"]]
[task 2024-04-17T12:08:47.077Z] 12:08:47 INFO - 1713355727077 Marionette DEBUG 1 -> [0,37,"Marionette:SetContext",{"value":"content"}]
[task 2024-04-17T12:08:47.078Z] 12:08:47 INFO - 1713355727078 Marionette DEBUG 1 <- [1,37,null,{"value":null}]
[task 2024-04-17T12:08:47.080Z] 12:08:47 INFO - 1713355727079 Marionette DEBUG 1 -> [0,38,"WebDriver:SwitchToWindow",{"handle":"e8709d6b-58f9-442d-b338-edad6a351d70","focus":true}]
[task 2024-04-17T12:08:47.085Z] 12:08:47 INFO - 1713355727084 RemoteAgent TRACE Received DOM event TabSelect for [object XULElement]
[task 2024-04-17T12:08:47.096Z] 12:08:47 INFO - 1713355727095 Marionette DEBUG 1 <- [1,38,null,{"value":null}]
[task 2024-04-17T12:08:47.104Z] 12:08:47 INFO - 1713355727103 Marionette DEBUG 1 -> [0,39,"WebDriver:Navigate",{"url":"data:text/html;charset=utf-8,%3Cdiv%22%3Eamet%3C/div%3E"}]
[task 2024-04-17T12:08:47.107Z] 12:08:47 INFO - 1713355727107 Marionette TRACE [14] Received event beforeunload for about:blank
[task 2024-04-17T12:08:47.115Z] 12:08:47 INFO - 1713355727114 Marionette TRACE Remoteness change detected. Set new top-level browsing context to 15
[task 2024-04-17T12:08:47.122Z] 12:08:47 INFO - 1713355727121 Marionette TRACE [15] Received event beforeunload for about:blank
[task 2024-04-17T12:08:47.123Z] 12:08:47 INFO - 1713355727123 Marionette TRACE [15] Received event pagehide for about:blank
[task 2024-04-17T12:08:47.131Z] 12:08:47 INFO - 1713355727131 Marionette TRACE [15] Received event DOMContentLoaded for data:text/html;charset=utf-8,%3Cdiv%22%3Eamet%3C/div%3E
[task 2024-04-17T12:08:47.132Z] 12:08:47 INFO - 1713355727132 Marionette TRACE [15] Received event pageshow for data:text/html;charset=utf-8,%3Cdiv%22%3Eamet%3C/div%3E
[task 2024-04-17T12:08:47.133Z] 12:08:47 INFO - 1713355727132 Marionette DEBUG 1 <- [1,39,null,{"value":null}]
[task 2024-04-17T12:08:47.138Z] 12:08:47 INFO - 1713355727137 Marionette DEBUG 1 -> [0,40,"Marionette:SetContext",{"value":"chrome"}]
[task 2024-04-17T12:08:47.138Z] 12:08:47 INFO - 1713355727138 Marionette DEBUG 1 <- [1,40,null,{"value":null}]
[task 2024-04-17T12:08:47.140Z] 12:08:47 INFO - 1713355727140 Marionette DEBUG 1 -> [0,41,"Marionette:GetContext",{}]
[task 2024-04-17T12:08:47.141Z] 12:08:47 INFO - 1713355727140 Marionette DEBUG 1 <- [1,41,null,{"value":"chrome"}]
[task 2024-04-17T12:08:47.142Z] 12:08:47 INFO - 1713355727142 Marionette DEBUG 1 -> [0,42,"Marionette:SetContext",{"value":"chrome"}]
[task 2024-04-17T12:08:47.142Z] 12:08:47 INFO - 1713355727142 Marionette DEBUG 1 <- [1,42,null,{"value":null}]
[task 2024-04-17T12:08:47.144Z] 12:08:47 INFO - 1713355727143 Marionette DEBUG 1 -> [0,43,"WebDriver:GetWindowHandles",{}]
[task 2024-04-17T12:08:47.144Z] 12:08:47 INFO - 1713355727144 Marionette DEBUG 1 <- [1,43,null,["9c8a2aa3-2bfd-4ab8-87e1-1afa22781c00"]]
[task 2024-04-17T12:08:47.145Z] 12:08:47 INFO - 1713355727145 Marionette DEBUG 1 -> [0,44,"Marionette:SetContext",{"value":"chrome"}]
[task 2024-04-17T12:08:47.146Z] 12:08:47 INFO - 1713355727146 Marionette DEBUG 1 <- [1,44,null,{"value":null}]
[task 2024-04-17T12:08:47.147Z] 12:08:47 INFO - 1713355727147 Marionette DEBUG 1 -> [0,45,"Marionette:GetContext",{}]
[task 2024-04-17T12:08:47.148Z] 12:08:47 INFO - 1713355727147 Marionette DEBUG 1 <- [1,45,null,{"value":"chrome"}]
[task 2024-04-17T12:08:47.149Z] 12:08:47 INFO - 1713355727148 Marionette DEBUG 1 -> [0,46,"Marionette:SetContext",{"value":"chrome"}]
[task 2024-04-17T12:08:47.149Z] 12:08:47 INFO - 1713355727149 Marionette DEBUG 1 <- [1,46,null,{"value":null}]
[task 2024-04-17T12:08:47.150Z] 12:08:47 INFO - 1713355727150 Marionette DEBUG 1 -> [0,47,"WebDriver:GetWindowHandle",{}]
[task 2024-04-17T12:08:47.151Z] 12:08:47 INFO - 1713355727151 Marionette DEBUG 1 <- [1,47,null,{"value":"9c8a2aa3-2bfd-4ab8-87e1-1afa22781c00"}]
[task 2024-04-17T12:08:47.153Z] 12:08:47 INFO - 1713355727153 Marionette DEBUG 1 -> [0,48,"Marionette:SetContext",{"value":"chrome"}]
[task 2024-04-17T12:08:47.154Z] 12:08:47 INFO - 1713355727154 Marionette DEBUG 1 <- [1,48,null,{"value":null}]
[task 2024-04-17T12:08:47.155Z] 12:08:47 INFO - 1713355727155 Marionette DEBUG 1 -> [0,49,"Marionette:GetContext",{}]
[task 2024-04-17T12:08:47.156Z] 12:08:47 INFO - 1713355727155 Marionette DEBUG 1 <- [1,49,null,{"value":"chrome"}]
[task 2024-04-17T12:08:47.157Z] 12:08:47 INFO - 1713355727157 Marionette DEBUG 1 -> [0,50,"Marionette:SetContext",{"value":"chrome"}]
[task 2024-04-17T12:08:47.158Z] 12:08:47 INFO - 1713355727158 Marionette DEBUG 1 <- [1,50,null,{"value":null}]
[task 2024-04-17T12:08:47.159Z] 12:08:47 INFO - 1713355727159 Marionette DEBUG 1 -> [0,51,"WebDriver:SwitchToWindow",{"handle":"9c8a2aa3-2bfd-4ab8-87e1-1afa22781c00","focus":true}]
[task 2024-04-17T12:08:47.160Z] 12:08:47 INFO - 1713355727160 Marionette DEBUG 1 <- [1,51,null,{"value":null}]
[task 2024-04-17T12:08:47.162Z] 12:08:47 INFO - 1713355727162 Marionette DEBUG 1 -> [0,52,"WebDriver:ExecuteScript",{"script":"return gBrowser.tabs.map(tab => {\n return tab.linkedBrowser.currentURI.spec;\n });","args":[],"newSandbox":true,"sandbox":"default","line":188,"filename":"tests/browser/components/sessionstore/test/marionette/session_store_test_case.py"}]
[task 2024-04-17T12:08:47.167Z] 12:08:47 INFO - 1713355727167 RemoteAgent TRACE WebDriverProcessData actor created for PID 6441
[task 2024-04-17T12:08:47.169Z] 12:08:47 INFO - 1713355727168 Marionette TRACE [1] MarionetteCommands actor created for window id 2
[task 2024-04-17T12:08:47.173Z] 12:08:47 INFO - 1713355727173 Marionette DEBUG 1 <- [1,52,null,{"value":["data:text/html;charset=utf-8,%3Cdiv%22%3Eipsum%3C/div%3E","data:text/html;charset=utf-8,%3Cdiv%22%3Edolor%3C/div%3E","data:text/html;charset=utf-8,%3Cdiv%22%3Eamet%3C/div%3E"]}]
[task 2024-04-17T12:08:47.175Z] 12:08:47 INFO - 1713355727175 Marionette DEBUG 1 -> [0,53,"Marionette:SetContext",{"value":"chrome"}]
[task 2024-04-17T12:08:47.176Z] 12:08:47 INFO - 1713355727175 Marionette DEBUG 1 <- [1,53,null,{"value":null}]
[task 2024-04-17T12:08:47.181Z] 12:08:47 INFO - 1713355727181 Marionette DEBUG 1 -> [0,54,"WebDriver:SwitchToWindow",{"handle":"9c8a2aa3-2bfd-4ab8-87e1-1afa22781c00","focus":true}]
[task 2024-04-17T12:08:47.182Z] 12:08:47 INFO - 1713355727182 Marionette DEBUG 1 <- [1,54,null,{"value":null}]
[task 2024-04-17T12:08:47.185Z] 12:08:47 INFO - 1713355727184 Marionette DEBUG 1 -> [0,55,"WebDriver:ExecuteAsyncScript",{"script":"let resolve = arguments[0];\n gBrowser.pinTab(gBrowser.tabs[0]);\n let { TabStateFlusher } = ChromeUtils. ... esource:///modules/sessionstore/TabStateFlusher.sys.mjs\");\n TabStateFlusher.flush(gBrowser.tabs[0]).then(resolve);","args":[],"newSandbox":true,"sandbox":"default","scriptTimeout":null,"line":43,"filename":"tests/browser/components/sessionstore/test/marionette/test_restore_manually_with_pinned_tabs.py"}]
[task 2024-04-17T12:08:47.190Z] 12:08:47 INFO - 1713355727189 Marionette DEBUG 1 <- [1,55,null,{"value":null}]
[task 2024-04-17T12:08:47.191Z] 12:08:47 INFO - 1713355727191 Marionette DEBUG 1 -> [0,56,"Marionette:AcceptConnections",{"value":false}]
[task 2024-04-17T12:08:47.192Z] 12:08:47 INFO - 1713355727191 Marionette INFO Stopped listening on port 2828
[task 2024-04-17T12:08:47.193Z] 12:08:47 INFO - 1713355727192 Marionette DEBUG 1 <- [1,56,null,{"value":null}]
[task 2024-04-17T12:08:47.194Z] 12:08:47 INFO - 1713355727194 Marionette DEBUG 1 -> [0,57,"Marionette:Quit",{}]
[task 2024-04-17T12:08:47.414Z] 12:08:47 INFO - 1713355727411 Marionette TRACE [1] MarionetteCommands actor destroyed for window id 2
[task 2024-04-17T12:08:47.674Z] 12:08:47 INFO - 1713355727674 Marionette TRACE Received observer notification quit-application
[task 2024-04-17T12:08:47.679Z] 12:08:47 INFO - 1713355727677 Marionette TRACE Received observer notification quit-application
[task 2024-04-17T12:08:47.682Z] 12:08:47 INFO - 1713355727678 Marionette DEBUG Marionette stopped listening
[task 2024-04-17T12:08:47.685Z] 12:08:47 INFO - 1713355727678 Marionette DEBUG 1 <- [1,57,null,{"cause":"shutdown","forced":false,"in_app":true}]
[task 2024-04-17T12:08:47.688Z] 12:08:47 INFO - 1713355727684 Marionette DEBUG Closed connection 1
[task 2024-04-17T12:08:47.930Z] 12:08:47 INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox -no-remote -marionette -profile /tmp/tmpi7zi1634.mozrunner
[task 2024-04-17T12:08:48.219Z] 12:08:48 INFO - ATTENTION: default value of option mesa_glthread overridden by environment.
[task 2024-04-17T12:08:48.237Z] 12:08:48 INFO - 1713355728237 Marionette INFO Marionette enabled
[task 2024-04-17T12:08:48.238Z] 12:08:48 INFO - 1713355728238 Marionette TRACE Received observer notification final-ui-startup
[task 2024-04-17T12:08:48.251Z] 12:08:48 INFO - ATTENTION: default value of option mesa_glthread overridden by environment.
[task 2024-04-17T12:08:48.272Z] 12:08:48 INFO - 1713355728271 Marionette INFO Listening on port 2828
[task 2024-04-17T12:08:48.273Z] 12:08:48 INFO - 1713355728272 Marionette DEBUG Marionette is listening
[task 2024-04-17T12:08:48.357Z] 12:08:48 INFO - 1713355728357 Marionette DEBUG Accepted connection 0 from 127.0.0.1:45260
[task 2024-04-17T12:08:48.364Z] 12:08:48 INFO - 1713355728364 Marionette DEBUG Closed connection 0
[task 2024-04-17T12:08:48.365Z] 12:08:48 INFO - 1713355728364 Marionette DEBUG Accepted connection 1 from 127.0.0.1:45262
[task 2024-04-17T12:08:48.375Z] 12:08:48 INFO - 1713355728374 Marionette DEBUG 1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2024-04-17T12:08:48.379Z] 12:08:48 INFO - 1713355728378 Marionette DEBUG Waiting for initial application window
[task 2024-04-17T12:08:51.102Z] 12:08:51 INFO - console.error: ({})
[task 2024-04-17T12:08:52.044Z] 12:08:52 INFO - 1713355732037 Marionette TRACE Received observer notification browser-idle-startup-tasks-finished
[task 2024-04-17T12:08:52.055Z] 12:08:52 INFO - 1713355732054 RemoteAgent TRACE [3] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=5000 waitForExplicitStart=false
[task 2024-04-17T12:08:52.061Z] 12:08:52 INFO - 1713355732060 RemoteAgent TRACE [3] ProgressListener Setting unload timer (5000ms)
[task 2024-04-17T12:08:52.062Z] 12:08:52 INFO - 1713355732060 RemoteAgent TRACE [3] Document already finished loading: about:home
[task 2024-04-17T12:08:52.062Z] 12:08:52 INFO - 1713355732060 RemoteAgent TRACE [3] ProgressListener Stop: has error=false
[task 2024-04-17T12:08:52.073Z] 12:08:52 INFO - 1713355732072 Marionette DEBUG 1 <- [1,1,null,{"sessionId":"130a47d4-0932-4ee1-ac54-a0fb2b6ff8b7","capabilities":{"browserName":"firefox","browserVersion":"127.0","platformName":"linux","acceptInsecureCerts":false,"pageLoadStrategy":"normal","setWindowRect":true,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"strictFileInteractability":true,"unhandledPromptBehavior":"dismiss and notify","userAgent":"Mozilla/5.0 (X11; Linux x86_64; rv:127.0) Gecko/20100101 Firefox/127.0","moz:accessibilityChecks":false,"moz:buildID":"20240417092525","moz:headless":false,"moz:platformVersion":"4.4.0-1014-aws","moz:processID":6700,"moz:profile":"/tmp/tmpi7zi1634.mozrunner","moz:shutdownTimeout":60000,"moz:webdriverClick":true,"moz:windowless":false,"proxy":{}}}]
[task 2024-04-17T12:08:52.093Z] 12:08:52 INFO - 1713355732093 Marionette DEBUG 1 -> [0,2,"Marionette:SetContext",{"value":"chrome"}]
[task 2024-04-17T12:08:52.094Z] 12:08:52 INFO - 1713355732094 Marionette DEBUG 1 <- [1,2,null,{"value":null}]
[task 2024-04-17T12:08:52.097Z] 12:08:52 INFO - 1713355732096 Marionette DEBUG 1 -> [0,3,"WebDriver:ExecuteScript",{"script":"return gBrowser.tabs.length","args":[],"newSandbox":true,"sandbox":"default","line":57,"filename":"tests/browser/components/sessionstore/test/marionette/test_restore_manually_with_pinned_tabs.py"}]
[task 2024-04-17T12:08:52.099Z] 12:08:52 INFO - 1713355732099 RemoteAgent TRACE WebDriverProcessData actor created for PID 6700
[task 2024-04-17T12:08:52.103Z] 12:08:52 INFO - 1713355732102 Marionette TRACE [1] MarionetteCommands actor created for window id 2
[task 2024-04-17T12:08:52.108Z] 12:08:52 INFO - 1713355732108 Marionette DEBUG 1 <- [1,3,null,{"value":2}]
[task 2024-04-17T12:08:52.110Z] 12:08:52 INFO - 1713355732109 Marionette DEBUG 1 -> [0,4,"WebDriver:ExecuteScript",{"script":"return gBrowser.tabs.filter(t => t.pinned).length","args":[],"newSandbox":true,"sandbox":"default","line":63,"filename":"tests/browser/components/sessionstore/test/marionette/test_restore_manually_with_pinned_tabs.py"}]
[task 2024-04-17T12:08:52.121Z] 12:08:52 INFO - 1713355732120 Marionette DEBUG 1 <- [1,4,null,{"value":1}]
[task 2024-04-17T12:08:52.127Z] 12:08:52 INFO - 1713355732122 Marionette DEBUG 1 -> [0,5,"WebDriver:ExecuteScript",{"script":"SessionStore.restoreLastSession();","args":[],"newSandbox":true,"sandbox":"default","line":70,"filename":"tests/browser/components/sessionstore/test/marionette/test_restore_manually_with_pinned_tabs.py"}]
[task 2024-04-17T12:08:52.208Z] 12:08:52 INFO - 1713355732207 Marionette DEBUG 1 <- [1,5,null,{"value":null}]
[task 2024-04-17T12:08:52.212Z] 12:08:52 INFO - 1713355732211 Marionette DEBUG 1 -> [0,6,"WebDriver:ExecuteScript",{"script":"return gBrowser.tabs.length;","args":[],"newSandbox":true,"sandbox":"default","line":95,"filename":"tests/browser/components/sessionstore/test/marionette/test_restore_manually_with_pinned_tabs.py"}]
[task 2024-04-17T12:08:52.215Z] 12:08:52 INFO - 1713355732214 Marionette DEBUG 1 <- [1,6,null,{"value":3}]
[task 2024-04-17T12:08:52.216Z] 12:08:52 INFO - 1713355732216 Marionette DEBUG 1 -> [0,7,"WebDriver:ExecuteScript",{"script":"return gBrowser.tabs.length","args":[],"newSandbox":true,"sandbox":"default","line":78,"filename":"tests/browser/components/sessionstore/test/marionette/test_restore_manually_with_pinned_tabs.py"}]
[task 2024-04-17T12:08:52.219Z] 12:08:52 INFO - 1713355732218 Marionette DEBUG 1 <- [1,7,null,{"value":3}]
[task 2024-04-17T12:08:52.220Z] 12:08:52 INFO - 1713355732220 Marionette DEBUG 1 -> [0,8,"WebDriver:ExecuteScript",{"script":"return gBrowser.tabs.filter(t => t.pinned).length","args":[],"newSandbox":true,"sandbox":"default","line":83,"filename":"tests/browser/components/sessionstore/test/marionette/test_restore_manually_with_pinned_tabs.py"}]
[task 2024-04-17T12:08:52.223Z] 12:08:52 INFO - 1713355732223 Marionette DEBUG 1 <- [1,8,null,{"value":1}]
[task 2024-04-17T12:08:52.225Z] 12:08:52 INFO - 1713355732225 Marionette DEBUG 1 -> [0,9,"Marionette:GetContext",{}]
[task 2024-04-17T12:08:52.226Z] 12:08:52 INFO - 1713355732226 Marionette DEBUG 1 <- [1,9,null,{"value":"chrome"}]
[task 2024-04-17T12:08:52.227Z] 12:08:52 INFO - 1713355732227 Marionette DEBUG 1 -> [0,10,"WebDriver:DeleteSession",{}]
[task 2024-04-17T12:08:52.229Z] 12:08:52 INFO - 1713355732228 Marionette TRACE [1] MarionetteCommands actor destroyed for window id 2
[task 2024-04-17T12:08:52.231Z] 12:08:52 INFO - 1713355732231 Marionette DEBUG 1 <- [1,10,null,{"value":null}]
[task 2024-04-17T12:08:52.281Z] 12:08:52 INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox -no-remote -marionette -profile /tmp/tmp_nzd9ngw.mozrunner
[task 2024-04-17T12:08:52.725Z] 12:08:52 INFO - Inconsistency detected by ld.so: ../elf/dl-tls.c: 481: _dl_allocate_tls_init: Assertion `listp->slotinfo[cnt].gen <= GL(dl_tls_generation)' failed!
[task 2024-04-17T12:08:52.793Z] 12:08:52 INFO - TEST-UNEXPECTED-ERROR | browser/components/sessionstore/test/marionette/test_restore_manually_with_pinned_tabs.py TestSessionRestoreWithPinnedTabs.test_no_restore_with_quit | marionette_driver.errors.InvalidSessionIdException: Please start a session
[task 2024-04-17T12:08:52.793Z] 12:08:52 INFO - Traceback (most recent call last):
[task 2024-04-17T12:08:52.793Z] 12:08:52 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_harness/marionette_test/testcases.py", line 231, in run
[task 2024-04-17T12:08:52.793Z] 12:08:52 INFO - self.tearDown()
[task 2024-04-17T12:08:52.794Z] 12:08:52 INFO - File "/builds/worker/workspace/build/tests/marionette/tests/browser/components/sessionstore/test/marionette/session_store_test_case.py", line 97, in tearDown
[task 2024-04-17T12:08:52.794Z] 12:08:52 INFO - super(SessionStoreTestCase, self).tearDown()
[task 2024-04-17T12:08:52.794Z] 12:08:52 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_harness/runner/mixins/window_manager.py", line 22, in tearDown
[task 2024-04-17T12:08:52.794Z] 12:08:52 INFO - if len(self.marionette.chrome_window_handles) > len(self.start_windows):
[task 2024-04-17T12:08:52.794Z] 12:08:52 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/marionette.py", line 1526, in chrome_window_handles
[task 2024-04-17T12:08:52.794Z] 12:08:52 INFO - with self.using_context("chrome"):
[task 2024-04-17T12:08:52.794Z] 12:08:52 INFO - File "/usr/lib/python3.8/contextlib.py", line 113, in __enter__
[task 2024-04-17T12:08:52.794Z] 12:08:52 INFO - return next(self.gen)
[task 2024-04-17T12:08:52.794Z] 12:08:52 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/marionette.py", line 1595, in using_context
[task 2024-04-17T12:08:52.795Z] 12:08:52 INFO - scope = self._send_message("Marionette:GetContext", key="value")
[task 2024-04-17T12:08:52.795Z] 12:08:52 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/decorators.py", line 24, in _
[task 2024-04-17T12:08:52.795Z] 12:08:52 INFO - return func(*args, **kwargs)
[task 2024-04-17T12:08:52.795Z] 12:08:52 INFO - File "/builds/worker/workspace/build/venv/lib/python3.8/site-packages/marionette_driver/marionette.py", line 766, in _send_message
[task 2024-04-17T12:08:52.795Z] 12:08:52 INFO - raise errors.InvalidSessionIdException("Please start a session")
[task 2024-04-17T12:08:52.795Z] 12:08:52 INFO - TEST-INFO took 10956ms
[task 2024-04-17T12:08:52.796Z] 12:08:52 INFO - TEST-START | browser/components/sessionstore/test/marionette/test_restore_windows_after_close_last_tabs.py TestSessionStoreEnabledAllWindows.test_close_tabs
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 2•1 year ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Status: NEW → RESOLVED
Closed: 1 year ago
Resolution: --- → INCOMPLETE
|
Reporter | |
Comment 3•1 year ago
|
||
| treeherder | ||
New failure instance: https://treeherder.mozilla.org/logviewer?job_id=480717578&repo=mozilla-central
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
| Comment hidden (Intermittent Failures Robot) |
|
|
||
Comment 5•1 year ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Status: REOPENED → RESOLVED
Closed: 1 year ago → 1 year ago
Resolution: --- → INCOMPLETE
|
|
Reporter | |
Comment 6•10 months ago
|
||
| treeherder | ||
New failure instance: https://treeherder.mozilla.org/logviewer?job_id=491150307&repo=mozilla-beta
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
| Comment hidden (Intermittent Failures Robot) |
|
|
||
Comment 8•9 months ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Status: REOPENED → RESOLVED
Closed: 1 year ago → 9 months ago
Resolution: --- → INCOMPLETE
| Comment hidden (Intermittent Failures Robot) |
You need to log in
before you can comment on or make changes to this bug.
Description
•