1472227 - Intermittent testing/marionette/harness/marionette_harness/tests/unit/test_quit_restart.py TestQuitRestart.test_reset_context_after_quit_by_using_context | MarionetteException: Please start a session

Reporter

Description

•

6 years ago

treeherder

Filed by: btara [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=185576564&repo=mozilla-inbound

https://queue.taskcluster.net/v1/task/FycVC02LQpGhBjcOPZOCYw/runs/0/artifacts/public/logs/live_backing.log

[task 2018-06-29T13:49:45.381Z] 13:49:45     INFO - TEST-START | testing/marionette/harness/marionette_harness/tests/unit/test_quit_restart.py TestQuitRestart.test_reset_context_after_quit_by_using_context
[task 2018-06-29T13:49:45.382Z] 13:49:45     INFO -  1530280185369	Marionette	TRACE	1 <- [1,7,null,{"value":null}]
[task 2018-06-29T13:49:45.384Z] 13:49:45     INFO -  1530280185373	Marionette	DEBUG	Closed connection 1
[task 2018-06-29T13:49:45.385Z] 13:49:45     INFO -  1530280185376	Marionette	DEBUG	Accepted connection 2 from 127.0.0.1:38138
[task 2018-06-29T13:49:45.421Z] 13:49:45     INFO -  1530280185409	Marionette	TRACE	2 -> [0,1,"WebDriver:NewSession",{}]
[task 2018-06-29T13:49:45.426Z] 13:49:45     INFO -  1530280185420	Marionette	DEBUG	[2147483649] Frame script loaded
[task 2018-06-29T13:49:45.434Z] 13:49:45     INFO -  1530280185431	Marionette	DEBUG	[2147483649] Frame script registered
[task 2018-06-29T13:49:45.441Z] 13:49:45     INFO -  1530280185439	Marionette	TRACE	2 <- [1,1,null,{"sessionId":"4ac4023d-95db-47df-bf16-4d0b5a72ef0d","capabilities":{"browserName":"firefox","browserVersion":"63.0a ... ssID":6471,"moz:profile":"/tmp/tmpP4OqHt.mozrunner","moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true}}]
[task 2018-06-29T13:49:45.457Z] 13:49:45     INFO -  1530280185452	Marionette	TRACE	2 -> [0,2,"WebDriver:SetTimeouts",{"script":30000}]
[task 2018-06-29T13:49:45.458Z] 13:49:45     INFO -  1530280185454	Marionette	TRACE	2 <- [1,2,null,{"value":null}]
[task 2018-06-29T13:49:45.466Z] 13:49:45     INFO -  1530280185460	Marionette	TRACE	2 -> [0,3,"WebDriver:SetTimeouts",{"pageLoad":300000}]
[task 2018-06-29T13:49:45.467Z] 13:49:45     INFO -  1530280185463	Marionette	TRACE	2 <- [1,3,null,{"value":null}]
[task 2018-06-29T13:49:45.483Z] 13:49:45     INFO -  1530280185477	Marionette	TRACE	2 -> [0,4,"WebDriver:SetTimeouts",{"implicit":0}]
[task 2018-06-29T13:49:45.499Z] 13:49:45     INFO -  1530280185488	Marionette	TRACE	2 <- [1,4,null,{"value":null}]
[task 2018-06-29T13:49:45.501Z] 13:49:45     INFO -  1530280185491	Marionette	TRACE	2 -> [0,5,"Marionette:GetContext",{}]
[task 2018-06-29T13:49:45.502Z] 13:49:45     INFO -  1530280185492	Marionette	TRACE	2 <- [1,5,null,{"value":"content"}]
[task 2018-06-29T13:49:45.504Z] 13:49:45     INFO -  1530280185495	Marionette	TRACE	2 -> [0,6,"Marionette:SetContext",{"value":"chrome"}]
[task 2018-06-29T13:49:45.505Z] 13:49:45     INFO -  1530280185497	Marionette	TRACE	2 <- [1,6,null,{"value":null}]
[task 2018-06-29T13:49:45.521Z] 13:49:45     INFO -  1530280185506	Marionette	TRACE	2 -> [0,7,"WebDriver:ExecuteScript",{"scriptTimeout":null,"newSandbox":true,"args":["startup.homepage_welcome_url",false,"unspecif ... tBranch});\n                return prefs.get(pref, null, Components.interfaces[valueType]);","sandbox":"default","line":895}]
[task 2018-06-29T13:49:45.522Z] 13:49:45     INFO -  1530280185516	Marionette	TRACE	2 <- [1,7,null,{"value":""}]
[task 2018-06-29T13:49:45.523Z] 13:49:45     INFO -  1530280185519	Marionette	TRACE	2 -> [0,8,"Marionette:SetContext",{"value":"content"}]
[task 2018-06-29T13:49:45.524Z] 13:49:45     INFO -  1530280185520	Marionette	TRACE	2 <- [1,8,null,{"value":null}]
[task 2018-06-29T13:49:45.585Z] 13:49:45     INFO -  1530280185580	Marionette	TRACE	2 -> [0,9,"Marionette:GetContext",{}]
[task 2018-06-29T13:49:45.587Z] 13:49:45     INFO -  1530280185584	Marionette	TRACE	2 <- [1,9,null,{"value":"content"}]
[task 2018-06-29T13:49:45.603Z] 13:49:45     INFO -  1530280185595	Marionette	TRACE	2 -> [0,10,"Marionette:SetContext",{"value":"chrome"}]
[task 2018-06-29T13:49:45.604Z] 13:49:45     INFO -  1530280185597	Marionette	TRACE	2 <- [1,10,null,{"value":null}]
[task 2018-06-29T13:49:45.680Z] 13:49:45     INFO -  1530280185670	Marionette	TRACE	2 -> [0,11,"WebDriver:ExecuteScript",{"scriptTimeout":null,"newSandbox":true,"args":["startup.homepage_welcome_url","about:about", ... = new Preferences({defaultBranch: defaultBranch});\n                prefs.set(pref, value);","sandbox":"default","line":929}]
[task 2018-06-29T13:49:45.688Z] 13:49:45     INFO -  1530280185680	Marionette	TRACE	2 <- [1,11,null,{"value":null}]
[task 2018-06-29T13:49:45.739Z] 13:49:45     INFO -  1530280185734	Marionette	TRACE	2 -> [0,12,"Marionette:SetContext",{"value":"content"}]
[task 2018-06-29T13:49:45.739Z] 13:49:45     INFO -  1530280185736	Marionette	TRACE	2 <- [1,12,null,{"value":null}]
[task 2018-06-29T13:49:45.747Z] 13:49:45     INFO -  1530280185743	Marionette	TRACE	2 -> [0,13,"WebDriver:GetCurrentURL",{}]
[task 2018-06-29T13:49:45.748Z] 13:49:45     INFO -  1530280185744	Marionette	TRACE	2 <- [1,13,null,{"value":"about:blank"}]
[task 2018-06-29T13:49:45.755Z] 13:49:45     INFO -  1530280185751	Marionette	TRACE	2 -> [0,14,"Marionette:GetContext",{}]
[task 2018-06-29T13:49:45.756Z] 13:49:45     INFO -  1530280185753	Marionette	TRACE	2 <- [1,14,null,{"value":"content"}]
[task 2018-06-29T13:49:45.776Z] 13:49:45     INFO -  1530280185773	Marionette	TRACE	2 -> [0,15,"Marionette:SetContext",{"value":"chrome"}]
[task 2018-06-29T13:49:45.777Z] 13:49:45     INFO -  1530280185774	Marionette	TRACE	2 <- [1,15,null,{"value":null}]
[task 2018-06-29T13:49:45.785Z] 13:49:45     INFO -  1530280185778	Marionette	TRACE	2 -> [0,16,"Marionette:GetContext",{}]
[task 2018-06-29T13:49:45.786Z] 13:49:45     INFO -  1530280185779	Marionette	TRACE	2 <- [1,16,null,{"value":"chrome"}]
[task 2018-06-29T13:49:45.786Z] 13:49:45     INFO -  1530280185781	Marionette	TRACE	2 -> [0,17,"Marionette:SetContext",{"value":"chrome"}]
[task 2018-06-29T13:49:45.787Z] 13:49:45     INFO -  1530280185783	Marionette	TRACE	2 <- [1,17,null,{"value":null}]
[task 2018-06-29T13:49:45.794Z] 13:49:45     INFO -  1530280185790	Marionette	TRACE	2 -> [0,18,"WebDriver:ExecuteScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"../../venv/lib/python2.7/site-p ... ancelQuit, \"quit-application-requested\", null);\n                return cancelQuit.data;","sandbox":"default","line":1064}]
[task 2018-06-29T13:49:45.815Z] 13:49:45     INFO -  1530280185812	Marionette	TRACE	2 <- [1,18,null,{"value":false}]
[task 2018-06-29T13:49:45.822Z] 13:49:45     INFO -  1530280185820	Marionette	TRACE	2 -> [0,19,"Marionette:SetContext",{"value":"chrome"}]
[task 2018-06-29T13:49:45.823Z] 13:49:45     INFO -  1530280185821	Marionette	TRACE	2 <- [1,19,null,{"value":null}]
[task 2018-06-29T13:49:45.839Z] 13:49:45     INFO -  1530280185831	Marionette	TRACE	2 -> [0,20,"Marionette:Quit",{"flags":["eForceQuit"]}]
[task 2018-06-29T13:49:45.840Z] 13:49:45     INFO -  1530280185832	Marionette	INFO	Stopped listening on port 2828
[task 2018-06-29T13:49:46.037Z] 13:49:46     INFO -  1530280186030	Marionette	TRACE	2 <- [1,20,null,{"cause":"shutdown"}]
[task 2018-06-29T13:49:46.146Z] 13:49:46     INFO -  1530280186142	Marionette	DEBUG	Closed connection 2
[task 2018-06-29T13:49:46.687Z] 13:49:46     INFO -  1530280186682	Marionette	DEBUG	Received observer notification xpcom-will-shutdown
[task 2018-06-29T13:49:46.688Z] 13:49:46     INFO -  1530280186682	Marionette	DEBUG	Remote service is inactive
[task 2018-06-29T13:49:47.295Z] 13:49:47     INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox -no-remote -marionette -profile /tmp/tmpP4OqHt.mozrunner
[task 2018-06-29T13:51:47.363Z] 13:51:47     INFO - TEST-UNEXPECTED-ERROR | testing/marionette/harness/marionette_harness/tests/unit/test_quit_restart.py TestQuitRestart.test_reset_context_after_quit_by_using_context | MarionetteException: Please start a session
[task 2018-06-29T13:51:47.364Z] 13:51:47     INFO - Traceback (most recent call last):
[task 2018-06-29T13:51:47.364Z] 13:51:47     INFO -   File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_harness/marionette_test/testcases.py", line 159, in run
[task 2018-06-29T13:51:47.365Z] 13:51:47     INFO -     testMethod()
[task 2018-06-29T13:51:47.365Z] 13:51:47     INFO -   File "/builds/worker/workspace/build/tests/marionette/tests/testing/marionette/harness/marionette_harness/tests/unit/test_quit_restart.py", line 321, in test_reset_context_after_quit_by_using_context
[task 2018-06-29T13:51:47.366Z] 13:51:47     INFO -     "Not in content context after quit with using_context")
[task 2018-06-29T13:51:47.367Z] 13:51:47     INFO -   File "/usr/lib/python2.7/contextlib.py", line 35, in __exit__
[task 2018-06-29T13:51:47.368Z] 13:51:47     INFO -     self.gen.throw(type, value, traceback)
[task 2018-06-29T13:51:47.368Z] 13:51:47     INFO -   File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/marionette.py", line 1454, in using_context
[task 2018-06-29T13:51:47.369Z] 13:51:47     INFO -     self.set_context(scope)
[task 2018-06-29T13:51:47.369Z] 13:51:47     INFO -   File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/marionette.py", line 1431, in set_context
[task 2018-06-29T13:51:47.370Z] 13:51:47     INFO -     {"value": context})
[task 2018-06-29T13:51:47.371Z] 13:51:47     INFO -   File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/decorators.py", line 26, in _
[task 2018-06-29T13:51:47.371Z] 13:51:47     INFO -     return func(*args, **kwargs)
[task 2018-06-29T13:51:47.372Z] 13:51:47     INFO -   File "/builds/worker/workspace/build/venv/lib/python2.7/site-packages/marionette_driver/marionette.py", line 750, in _send_message
[task 2018-06-29T13:51:47.372Z] 13:51:47     INFO -     raise errors.MarionetteException("Please start a session")
[task 2018-06-29T13:51:47.373Z] 13:51:47     INFO - TEST-INFO took 121990ms

Henrik Skupin [:whimboo][⌚️UTC+1]

Updated

•

6 years ago

Depends on: 1433873

Comment hidden (Intermittent Failures Robot)

2 failures in 718 pushes (0.003 failures/push) were associated with this bug in the last 7 days.    

Repository breakdown:
* mozilla-inbound: 2

Platform breakdown:
* linux64: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1472227&startday=2018-06-25&endday=2018-07-01&tree=trunk

Comment hidden (Intermittent Failures Robot)

2 failures in 622 pushes (0.003 failures/push) were associated with this bug in the last 7 days.    

Repository breakdown:
* mozilla-beta: 1
* autoland: 1

Platform breakdown:
* linux64: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1472227&startday=2018-07-02&endday=2018-07-08&tree=trunk

Comment hidden (Intermittent Failures Robot)

2 failures in 623 pushes (0.003 failures/push) were associated with this bug in the last 7 days.    

Repository breakdown:
* mozilla-inbound: 2

Platform breakdown:
* linux64: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1472227&startday=2018-07-09&endday=2018-07-15&tree=trunk

Comment hidden (Intermittent Failures Robot)

1 failures in 653 pushes (0.002 failures/push) were associated with this bug in the last 7 days.    

Repository breakdown:
* mozilla-inbound: 1

Platform breakdown:
* linux64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1472227&startday=2018-07-16&endday=2018-07-22&tree=trunk

Comment hidden (Intermittent Failures Robot)

2 failures in 760 pushes (0.003 failures/push) were associated with this bug in the last 7 days.    

Repository breakdown:
* mozilla-beta: 2

Platform breakdown:
* linux64: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1472227&startday=2018-07-23&endday=2018-07-29&tree=trunk

Comment hidden (Intermittent Failures Robot)

3 failures in 2579 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* autoland: 1
* mozilla-beta: 1
* try: 1

Platform breakdown:
* linux64: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1472227&startday=2018-08-06&endday=2018-08-12&tree=all

Comment hidden (Intermittent Failures Robot)

9 failures in 2672 pushes (0.003 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* try: 2
* mozilla-beta: 2
* autoland: 2
* mozilla-inbound: 3

Platform breakdown:
* linux64: 9

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1472227&startday=2018-08-13&endday=2018-08-19&tree=all

Comment hidden (Intermittent Failures Robot)

5 failures in 2568 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-central: 1
* mozilla-inbound: 3
* autoland: 1

Platform breakdown:
* linux64: 5

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1472227&startday=2018-08-20&endday=2018-08-26&tree=all

Comment hidden (Intermittent Failures Robot)

3 failures in 2545 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:
* mozilla-central: 1
* mozilla-inbound: 1
* autoland: 1

Platform breakdown:
* linux64: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1472227&startday=2018-08-27&endday=2018-09-02&tree=all

Firefox Bug Husbandry Bot

Comment 10

•

6 years ago

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

Status: NEW → RESOLVED

Closed: 6 years ago

Resolution: --- → INCOMPLETE

Henrik Skupin [:whimboo][⌚️UTC+1]

Comment 11

•

6 years ago

This was actually an ASAN only hang during startup of Firefox, and got fixed by bug 1495404.

Assignee: nobody → stransky

status-firefox63: --- → fixed

status-firefox64: --- → fixed

status-firefox-esr60: --- → fixed

Depends on: 1495404

Resolution: INCOMPLETE → FIXED

Target Milestone: --- → mozilla64

BMO Automation

Updated

•

1 year ago

Product: Testing → Remote Protocol

BMO Automation

Comment 12

•

1 year ago

Moving bug to Testing::Marionette Client and Harness component per bug 1815831.

Component: Marionette → Marionette Client and Harness

Product: Remote Protocol → Testing

Bugzilla

Quick Search

Intermittent testing/marionette/harness/marionette_harness/tests/unit/test_quit_restart.py TestQuitRestart.test_reset_context_after_quit_by_using_context | MarionetteException: Please start a session

Categories

(Testing :: Marionette Client and Harness, defect, P5)

Tracking

(firefox-esr60 fixed, firefox63 fixed, firefox64 fixed)

People

(Reporter: intermittent-bug-filer, Assigned: stransky)

References

Details

(Keywords: intermittent-failure)

Crash Data

Security

(public)

User Story

Description

Updated

Comment 1

Comment 2

Comment 3

Comment 4

Comment 5

Comment 6

Comment 7

Comment 8

Comment 9

Comment 10

Comment 11

Updated

Comment 12