1665404 - Perma [tier2] browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | Test timed out -

Status: RESOLVED FIXED

(Firefox :: New Tab Page, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2020-09-16T11:39:46.203Z] 11:39:46     INFO - TEST-PASS | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | Navigated to a welcome screen - "about:welcome" == "about:welcome" - 
[task 2020-09-16T11:39:46.203Z] 11:39:46     INFO - Console message: [JavaScript Error: "Error: Minified React error #311; visit https://reactjs.org/docs/error-decoder.html?invariant=311 for the full message or use the non-minified dev environment for full errors and additional helpful warnings." {file: "resource://activity-stream/vendor/react-dom.js" line: 86}]
[task 2020-09-16T11:39:46.203Z] 11:39:46     INFO - Vc@resource://activity-stream/vendor/react-dom.js:86:131
[task 2020-09-16T11:39:46.203Z] 11:39:46     INFO - useState@resource://activity-stream/vendor/react-dom.js:218:226
[task 2020-09-16T11:39:46.203Z] 11:39:46     INFO - d.useState@resource://activity-stream/vendor/react.js:32:381
[task 2020-09-16T11:39:46.203Z] 11:39:46     INFO - MultiStageAboutWelcome@resource://activity-stream/aboutwelcome/aboutwelcome.bundle.js:327:85
[task 2020-09-16T11:39:46.203Z] 11:39:46     INFO - we@resource://activity-stream/vendor/react-dom.js:84:293
[task 2020-09-16T11:39:46.203Z] 11:39:46     INFO - He@resource://activity-stream/vendor/react-dom.js:97:464
[task 2020-09-16T11:39:46.203Z] 11:39:46     INFO - zj@resource://activity-stream/vendor/react-dom.js:228:406
[task 2020-09-16T11:39:46.203Z] 11:39:46     INFO - Th@resource://activity-stream/vendor/react-dom.js:152:225
[task 2020-09-16T11:39:46.203Z] 11:39:46     INFO - tj@resource://activity-stream/vendor/react-dom.js:152:152
[task 2020-09-16T11:39:46.203Z] 11:39:46     INFO - Te@resource://activity-stream/vendor/react-dom.js:146:151
[task 2020-09-16T11:39:46.204Z] 11:39:46     INFO - Pg/<@resource://activity-stream/vendor/react-dom.js:61:68
[task 2020-09-16T11:39:46.204Z] 11:39:46     INFO - unstable_runWithPriority@resource://activity-stream/vendor/react.js:25:260
[task 2020-09-16T11:39:46.204Z] 11:39:46     INFO - Da@resource://activity-stream/vendor/react-dom.js:60:280
[task 2020-09-16T11:39:46.204Z] 11:39:46     INFO - Pg@resource://activity-stream/vendor/react-dom.js:61:16
[task 2020-09-16T11:39:46.204Z] 11:39:46     INFO - ha@resource://activity-stream/vendor/react-dom.js:60:451
[task 2020-09-16T11:39:46.204Z] 11:39:46     INFO - @resource://activity-stream/vendor/react-dom.js:236:59
[task 2020-09-16T11:39:46.204Z] 11:39:46     INFO - Ei@resource://activity-stream/vendor/react-dom.js:41:90
[task 2020-09-16T11:39:46.204Z] 11:39:46     INFO - @resource://testing-common/content-task.js line 110 > eval:9:14
[task 2020-09-16T11:39:46.205Z] 11:39:46     INFO - 
[task 2020-09-16T11:39:46.205Z] 11:39:46     INFO - Console message: [JavaScript Error: "NS_ERROR_NOT_INITIALIZED" {file: "resource://testing-common/content-task.js" line: 120}]
[task 2020-09-16T11:39:46.205Z] 11:39:46     INFO - Buffered messages finished
[task 2020-09-16T11:39:46.205Z] 11:39:46     INFO - TEST-UNEXPECTED-FAIL | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | Test timed out - 
[task 2020-09-16T11:39:46.205Z] 11:39:46     INFO - GECKO(8228) | MEMORY STAT | vsize 3256MB | residentFast 509MB | heapAllocated 111MB
[task 2020-09-16T11:39:46.205Z] 11:39:46     INFO - TEST-OK | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | took 45101ms
[task 2020-09-16T11:39:46.207Z] 11:39:46     INFO - checking window state```

Comment 1

[Intermittent Failures Robot]

17 failures in 3760 pushes (0.005 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 17

Platform breakdown:

• linux1804-64-ccov: 17

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

Comment 2

[Intermittent Failures Robot]

17 failures in 4019 pushes (0.004 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 17

Platform breakdown:

• linux1804-64-ccov: 17

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

Comment 3

[Intermittent Failures Robot]

15 failures in 4195 pushes (0.004 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 15

Platform breakdown:

• linux1804-64-ccov: 15

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

Comment 4

[Intermittent Failures Robot]

17 failures in 4130 pushes (0.004 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 17

Platform breakdown:

• linux1804-64-ccov: 17

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

Comment 5

[Intermittent Failures Robot]

20 failures in 3694 pushes (0.005 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 20

Platform breakdown:

• linux1804-64-ccov: 20

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1665404&startday=2020-10-12&endday=2020-10-18&tree=all

Comment 6

[Andreea Pavel [:apavel]]

There are 25 total failures in the last 7 days on linux1804-64-ccov opt.

Recent failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=319660751&repo=mozilla-central&lineNumber=5397

[task 2020-10-24T22:57:03.957Z] 22:57:03 INFO - TEST-START | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js
[task 2020-10-24T22:57:04.264Z] 22:57:04 INFO - GECKO(4912) | [CodeCoverage] Setting handlers for process 5179.
[task 2020-10-24T22:57:08.143Z] 22:57:08 INFO - GECKO(4912) | JavaScript error: resource://activity-stream/vendor/react-dom.js, line 86: Error: Minified React error #311; visit https://reactjs.org/docs/error-decoder.html?invariant=311 for the full message or use the non-minified dev environment for full errors and additional helpful warnings.
[task 2020-10-24T22:57:08.245Z] 22:57:08 INFO - GECKO(4912) | JavaScript error: resource://testing-common/content-task.js, line 120: NS_ERROR_NOT_INITIALIZED
[task 2020-10-24T22:57:48.995Z] 22:57:48 INFO - TEST-INFO | started process screentopng
[task 2020-10-24T22:57:49.153Z] 22:57:49 INFO - TEST-INFO | screentopng: exit 0
[task 2020-10-24T22:57:49.155Z] 22:57:49 INFO - Buffered messages logged at 22:57:03
[task 2020-10-24T22:57:49.155Z] 22:57:49 INFO - TEST-PASS | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | Sanity check the temporary file doesn't exist. - true == true -
[task 2020-10-24T22:57:49.156Z] 22:57:49 INFO - Entering test bound test_multistage_zeroOnboarding_experimentAPI
[task 2020-10-24T22:57:49.157Z] 22:57:49 INFO - Buffered messages logged at 22:57:05
[task 2020-10-24T22:57:49.158Z] 22:57:49 INFO - TEST-PASS | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | Should not render div.onboardingContainer in Opens new tab - true == true -
[task 2020-10-24T22:57:49.159Z] 22:57:49 INFO - TEST-PASS | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | Should not render main.AW_STEP1 in Opens new tab - true == true -
[task 2020-10-24T22:57:49.160Z] 22:57:49 INFO - TEST-PASS | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | Navigated to a welcome screen - "about:welcome" == "about:welcome" -
[task 2020-10-24T22:57:49.160Z] 22:57:49 INFO - TEST-PASS | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | Cleanup done - 0 == 0 -
[task 2020-10-24T22:57:49.161Z] 22:57:49 INFO - Leaving test bound test_multistage_zeroOnboarding_experimentAPI
[task 2020-10-24T22:57:49.162Z] 22:57:49 INFO - Entering test bound test_multistage_aboutwelcome_experimentAPI
[task 2020-10-24T22:57:49.164Z] 22:57:49 INFO - Console message: [JavaScript Error: "JSON.parse: unexpected character at line 1 column 2 of the JSON data" {file: "resource:///actors/AboutWelcomeChild.jsm" line: 39}]
[task 2020-10-24T22:57:49.165Z] 22:57:49 INFO - _parseOverrideContent@resource:///actors/AboutWelcomeChild.jsm:39:27
[task 2020-10-24T22:57:49.165Z] 22:57:49 INFO - lazyGetter@resource://gre/modules/XPCOMUtils.jsm:339:26
[task 2020-10-24T22:57:49.166Z] 22:57:49 INFO - AWGetWelcomeOverrideContent@resource:///actors/AboutWelcomeChild.jsm:228:1
[task 2020-10-24T22:57:49.167Z] 22:57:49 INFO - retrieveRenderContent@resource://activity-stream/aboutwelcome/aboutwelcome.bundle.js:246:40
[task 2020-10-24T22:57:49.168Z] 22:57:49 INFO - mount@resource://activity-stream/aboutwelcome/aboutwelcome.bundle.js:298:13
[task 2020-10-24T22:57:49.169Z] 22:57:49 INFO - @resource://activity-stream/aboutwelcome/aboutwelcome.bundle.js:306:1
[task 2020-10-24T22:57:49.169Z] 22:57:49 INFO - webpack_require@resource://activity-stream/aboutwelcome/aboutwelcome.bundle.js:26:30
[task 2020-10-24T22:57:49.170Z] 22:57:49 INFO - @resource://activity-stream/aboutwelcome/aboutwelcome.bundle.js:90:18
[task 2020-10-24T22:57:49.171Z] 22:57:49 INFO - @resource://activity-stream/aboutwelcome/aboutwelcome.bundle.js:93:10
[task 2020-10-24T22:57:49.172Z] 22:57:49 INFO -
[task 2020-10-24T22:57:49.173Z] 22:57:49 INFO - Console message: [JavaScript Error: "can't access property "createInstance", Cc[("@mozilla.org/profile/migrator;1?app=browser&type=" + aKey)] is undefined" {file: "resource:///modules/MigrationUtils.jsm" line: 789}]
[task 2020-10-24T22:57:49.173Z] 22:57:49 INFO - MU_getMigrator@resource:///modules/MigrationUtils.jsm:789:1
[task 2020-10-24T22:57:49.174Z] 22:57:49 INFO - getImportableSites@resource:///actors/AboutWelcomeParent.jsm:61:43
[task 2020-10-24T22:57:49.175Z] 22:57:49 INFO -
[task 2020-10-24T22:57:49.176Z] 22:57:49 INFO - Console message: [JavaScript Error: "Unknown Collection "main/partitioning-exempt-urls"" {file: "resource://services-settings/RemoteSettingsClient.jsm" line: 160}]
[task 2020-10-24T22:57:49.177Z] 22:57:49 INFO - UnknownCollectionError@resource://services-settings/RemoteSettingsClient.jsm:160:5
[task 2020-10-24T22:57:49.177Z] 22:57:49 INFO - sync@resource://services-settings/RemoteSettingsClient.jsm:470:13
[task 2020-10-24T22:57:49.178Z] 22:57:49 INFO -
[task 2020-10-24T22:57:49.179Z] 22:57:49 INFO - Buffered messages logged at 22:57:06
[task 2020-10-24T22:57:49.180Z] 22:57:49 INFO - TEST-PASS | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | Should not render main.AW_STEP2 in multistage step 1 - true == true -
[task 2020-10-24T22:57:49.181Z] 22:57:49 INFO - TEST-PASS | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | Should not render main.AW_STEP3 in multistage step 1 - true == true -
[task 2020-10-24T22:57:49.182Z] 22:57:49 INFO - TEST-PASS | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | Should not render div.tiles-container.info in multistage step 1 - true == true -
[task 2020-10-24T22:57:49.182Z] 22:57:49 INFO - TEST-PASS | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | Navigated to a welcome screen - "about:welcome" == "about:welcome" -
[task 2020-10-24T22:57:49.183Z] 22:57:49 INFO - Buffered messages logged at 22:57:07
[task 2020-10-24T22:57:49.184Z] 22:57:49 INFO - TEST-PASS | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | Should not render main.AW_STEP1 in multistage step 2 - true == true -
[task 2020-10-24T22:57:49.185Z] 22:57:49 INFO - TEST-PASS | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | Should not render main.AW_STEP3 in multistage step 2 - true == true -
[task 2020-10-24T22:57:49.186Z] 22:57:49 INFO - TEST-PASS | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | Should not render div.secondary-cta.top in multistage step 2 - true == true -
[task 2020-10-24T22:57:49.186Z] 22:57:49 INFO - TEST-PASS | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | Navigated to a welcome screen - "about:welcome" == "about:welcome" -
[task 2020-10-24T22:57:49.187Z] 22:57:49 INFO - Buffered messages logged at 22:57:08
[task 2020-10-24T22:57:49.188Z] 22:57:49 INFO - TEST-PASS | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | Should not render main.AW_STEP1 in multistage step 3 - true == true -
[task 2020-10-24T22:57:49.189Z] 22:57:49 INFO - TEST-PASS | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | Should not render main.AW_STEP2 in multistage step 3 - true == true -
[task 2020-10-24T22:57:49.190Z] 22:57:49 INFO - TEST-PASS | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | Navigated to a welcome screen - "about:welcome" == "about:welcome" -
[task 2020-10-24T22:57:49.190Z] 22:57:49 INFO - Console message: [JavaScript Error: "Error: Minified React error #311; visit https://reactjs.org/docs/error-decoder.html?invariant=311 for the full message or use the non-minified dev environment for full errors and additional helpful warnings." {file: "resource://activity-stream/vendor/react-dom.js" line: 86}]
[task 2020-10-24T22:57:49.191Z] 22:57:49 INFO - Vc@resource://activity-stream/vendor/react-dom.js:86:131
[task 2020-10-24T22:57:49.192Z] 22:57:49 INFO - useState@resource://activity-stream/vendor/react-dom.js:218:226
[task 2020-10-24T22:57:49.193Z] 22:57:49 INFO - d.useState@resource://activity-stream/vendor/react.js:32:381
[task 2020-10-24T22:57:49.194Z] 22:57:49 INFO - MultiStageAboutWelcome@resource://activity-stream/aboutwelcome/aboutwelcome.bundle.js:388:85
[task 2020-10-24T22:57:49.194Z] 22:57:49 INFO - we@resource://activity-stream/vendor/react-dom.js:84:293
[task 2020-10-24T22:57:49.195Z] 22:57:49 INFO - He@resource://activity-stream/vendor/react-dom.js:97:464
[task 2020-10-24T22:57:49.196Z] 22:57:49 INFO - zj@resource://activity-stream/vendor/react-dom.js:228:406
[task 2020-10-24T22:57:49.197Z] 22:57:49 INFO - Th@resource://activity-stream/vendor/react-dom.js:152:225
[task 2020-10-24T22:57:49.198Z] 22:57:49 INFO - tj@resource://activity-stream/vendor/react-dom.js:152:152
[task 2020-10-24T22:57:49.198Z] 22:57:49 INFO - Te@resource://activity-stream/vendor/react-dom.js:146:151
[task 2020-10-24T22:57:49.199Z] 22:57:49 INFO - Pg/<@resource://activity-stream/vendor/react-dom.js:61:68
[task 2020-10-24T22:57:49.199Z] 22:57:49 INFO - unstable_runWithPriority@resource://activity-stream/vendor/react.js:25:260
[task 2020-10-24T22:57:49.199Z] 22:57:49 INFO - Da@resource://activity-stream/vendor/react-dom.js:60:280
[task 2020-10-24T22:57:49.200Z] 22:57:49 INFO - Pg@resource://activity-stream/vendor/react-dom.js:61:16
[task 2020-10-24T22:57:49.200Z] 22:57:49 INFO - ha@resource://activity-stream/vendor/react-dom.js:60:451
[task 2020-10-24T22:57:49.200Z] 22:57:49 INFO - @resource://activity-stream/vendor/react-dom.js:236:59
[task 2020-10-24T22:57:49.200Z] 22:57:49 INFO - Ei@resource://activity-stream/vendor/react-dom.js:41:90
[task 2020-10-24T22:57:49.200Z] 22:57:49 INFO - @resource://testing-common/content-task.js line 110 > eval:9:14
[task 2020-10-24T22:57:49.200Z] 22:57:49 INFO -
[task 2020-10-24T22:57:49.200Z] 22:57:49 INFO - Console message: [JavaScript Error: "NS_ERROR_NOT_INITIALIZED" {file: "resource://testing-common/content-task.js" line: 120}]
[task 2020-10-24T22:57:49.200Z] 22:57:49 INFO - Buffered messages finished
[task 2020-10-24T22:57:49.200Z] 22:57:49 INFO - TEST-UNEXPECTED-FAIL | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | Test timed out -
[task 2020-10-24T22:57:49.200Z] 22:57:49 INFO - GECKO(4912) | MEMORY STAT | vsize 3209MB | residentFast 491MB | heapAllocated 110MB
[task 2020-10-24T22:57:49.200Z] 22:57:49 INFO - TEST-OK | browser/components/newtab/test/browser/browser_aboutwelcome_multistage.js | took 45128ms
[task 2020-10-24T22:57:49.200Z] 22:57:49 INFO - checking window state

Scott can you assign someone to take a look?

Comment 7

[Intermittent Failures Robot]

24 failures in 4230 pushes (0.006 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 24

Platform breakdown:

• linux1804-64-ccov: 24

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

Comment 8

[Dan Mosedale (:dmosedale, :dmose)]

So I remember seeing a "React minified error" somewhat regularly while doing development, I suspect it was this one. Following the URL in the console log expands it to be "Should have a queue. This is likely a bug in React. Please file an issue.".

One such filed bug says that the hooks lint plugin found a bug in that person's code. We should try running that plugin on our code. I think we have a bug one file to add the plugin already.

Comment 9

[Punam Dahiya [:pdahiya]]

Attachment: Bug 1665404 - Code coverage crash on linux build for multistage welcome

Comment 10

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/f39954582bb1
Code coverage crash on linux build for multistage welcome r=dmose

Comment 11

[Atila Butkovits]

https://hg.mozilla.org/mozilla-central/rev/f39954582bb1

Comment 12

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 5

Platform breakdown:

• linux1804-64-ccov: 5

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