1630218 - Intermittent remote/test/browser/runtime/browser_executionContext.js | Received Runtime context events in expected order - ["Runtime.executionContextDestroyed","Runtime.executionContextsCleared"] deepEqual ["Runtime.executionContextDestroyed","Runtime

Status: RESOLVED INCOMPLETE

(Remote Protocol :: Agent, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: rgurzau [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=297705604&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/WvBNx7hBRXmYvt9o0F6Wtg/runs/0/artifacts/public/logs/live_backing.log

---

[task 2020-04-15T10:00:08.382Z] 10:00:08 INFO - Navigate via window.location and Runtime.evaluate
[task 2020-04-15T10:00:08.382Z] 10:00:08 INFO - Buffered messages logged at 10:00:07
[task 2020-04-15T10:00:08.385Z] 10:00:08 INFO - Received Runtime.executionContextDestroyed for id 3
[task 2020-04-15T10:00:08.387Z] 10:00:08 INFO - Received Runtime.executionContextsCleared
[task 2020-04-15T10:00:08.389Z] 10:00:08 INFO - Buffered messages finished
[task 2020-04-15T10:00:08.390Z] 10:00:08 INFO - TEST-UNEXPECTED-FAIL | remote/test/browser/runtime/browser_executionContext.js | Received Runtime context events in expected order - ["Runtime.executionContextDestroyed","Runtime.executionContextsCleared"] deepEqual ["Runtime.executionContextDestroyed","Runtime.executionContextsCleared","Runtime.executionContextCreated"] - JS frame :: chrome://mochitests/content/browser/remote/test/browser/runtime/browser_executionContext.js :: assertEventOrder :: line 265
[task 2020-04-15T10:00:08.390Z] 10:00:08 INFO - Stack trace:
[task 2020-04-15T10:00:08.391Z] 10:00:08 INFO - chrome://mochitests/content/browser/remote/test/browser/runtime/browser_executionContext.js:assertEventOrder:265
[task 2020-04-15T10:00:08.391Z] 10:00:08 INFO - chrome://mochitests/content/browser/remote/test/browser/runtime/browser_executionContext.js:testNavigateViaLocation:174
[task 2020-04-15T10:00:08.391Z] 10:00:08 INFO - chrome://mochitests/content/browser/remote/test/browser/runtime/browser_executionContext.js:null:20
[task 2020-04-15T10:00:08.391Z] 10:00:08 INFO - chrome://mochitests/content/browser/remote/test/browser/head.js:fn:67
[task 2020-04-15T10:00:08.391Z] 10:00:08 INFO - chrome://mochikit/content/browser-test.js:Tester_execTest/<:1039
[task 2020-04-15T10:00:08.391Z] 10:00:08 INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1074
[task 2020-04-15T10:00:08.391Z] 10:00:08 INFO - chrome://mochikit/content/browser-test.js:nextTest/<:904
[task 2020-04-15T10:00:08.391Z] 10:00:08 INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<:918
[task 2020-04-15T10:00:08.392Z] 10:00:08 INFO - TEST-PASS | remote/test/browser/runtime/browser_executionContext.js | The destroyed event reports the previous context id -
[task 2020-04-15T10:00:13.220Z] 10:00:13 INFO - CDP client closed
[task 2020-04-15T10:00:13.238Z] 10:00:13 INFO - GECKO(4681) | 1586944813228 RemoteAgent TRACE <-(connection {6973fdd7-fe38-4fc1-9b7d-cfe07c0cb063}) {"method":"Target.targetDestroyed","params":{"targetId":138}}
[task 2020-04-15T10:00:13.238Z] 10:00:13 INFO - GECKO(4681) | 1586944813229 RemoteAgent TRACE <-(connection {6973fdd7-fe38-4fc1-9b7d-cfe07c0cb063}) {"method":"Target.targetDestroyed","params":{"targetId":"51e20837-67a6-4fef-8aa4-1a12de94734f"}}
[task 2020-04-15T10:00:13.238Z] 10:00:13 INFO - GECKO(4681) | 1586944813230 RemoteAgent TRACE <-(connection {6973fdd7-fe38-4fc1-9b7d-cfe07c0cb063}) {"method":"Target.targetDestroyed","params":{"targetId":140}}
[task 2020-04-15T10:00:13.256Z] 10:00:13 INFO - CDP server stopped
[task 2020-04-15T10:00:13.314Z] 10:00:13 INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-04-15T10:00:13.314Z] 10:00:13 INFO - TEST-UNEXPECTED-FAIL | remote/test/browser/runtime/browser_executionContext.js | Uncaught exception - at chrome://mochitests/content/browser/remote/test/browser/runtime/browser_executionContext.js:273 - TypeError: can't access property "id", context is undefined
[task 2020-04-15T10:00:13.314Z] 10:00:13 INFO - Stack trace:
[task 2020-04-15T10:00:13.314Z] 10:00:13 INFO - checkDefaultContext@chrome://mochitests/content/browser/remote/test/browser/runtime/browser_executionContext.js:273:7
[task 2020-04-15T10:00:13.314Z] 10:00:13 INFO - testNavigateViaLocation@chrome://mochitests/content/browser/remote/test/browser/runtime/browser_executionContext.js:183:22
[task 2020-04-15T10:00:13.314Z] 10:00:13 INFO - async*@chrome://mochitests/content/browser/remote/test/browser/runtime/browser_executionContext.js:20:26
[task 2020-04-15T10:00:13.314Z] 10:00:13 INFO - asyncfn@chrome://mochitests/content/browser/remote/test/browser/head.js:67:13
[task 2020-04-15T10:00:13.314Z] 10:00:13 INFO - AsyncTester_execTest/<@chrome://mochikit/content/browser-test.js:1039:34
[task 2020-04-15T10:00:13.314Z] 10:00:13 INFO - Tester_execTest@chrome://mochikit/content/browser-test.js:1074:11
[task 2020-04-15T10:00:13.314Z] 10:00:13 INFO - nextTest/<@chrome://mochikit/content/browser-test.js:904:14
[task 2020-04-15T10:00:13.314Z] 10:00:13 INFO - SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:918:23
[task 2020-04-15T10:00:13.314Z] 10:00:13 INFO - Leaving test bound
[task 2020-04-15T10:00:13.314Z] 10:00:13 INFO - Entering test bound testRuntimeNotEnabled

Comment 1

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

There is a Runtime.executionContextCreated event missing:

[task 2020-04-15T10:00:08.390Z] 10:00:08 INFO - TEST-UNEXPECTED-FAIL | remote/test/browser/runtime/browser_executionContext.js | Received Runtime context events in expected order - ["Runtime.executionContextDestroyed","Runtime.executionContextsCleared"] deepEqual ["Runtime.executionContextDestroyed","Runtime.executionContextsCleared","Runtime.executionContextCreated"] - JS frame :: chrome://mochitests/content/browser/remote/test/browser/runtime/browser_executionContext.js :: assertEventOrder :: line 265

Comment 2

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1
• autoland: 1

Platform breakdown:

• linux1804-64-qr: 2

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

Comment 3

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2

Platform breakdown:

• linux1804-64-qr: 2

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

Comment 4

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• linux1804-64-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1630218&startday=2020-04-27&endday=2020-05-03&tree=all

Comment 5

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

Failure on Ubuntu 18.04 only. Might be fixed with the patch on bug 1638196.

Comment 6

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

Actually it didn't fail in the last month.