1249393 - browser_aboutperformance.js is going to permafail when Gecko 47 merges to Aurora

Status: RESOLVED FIXED

(Toolkit :: Performance Monitoring, defect)

Description

[Ryan VanderMeulen [:RyanVM]]

Attachment: test screenshot

[Tracking Requested - why for this release]: Merge day permafail.

This uplift simulation was on top of today's m-c tip. Happens across all platforms and e10s/non-e10s.

https://treeherder.mozilla.org/logviewer.html#?job_id=16904101&repo=try

11:02:22     INFO -  118 INFO TEST-START | toolkit/components/aboutperformance/tests/browser/browser_aboutperformance.js
11:03:07     INFO -  TEST-INFO | started process screentopng
11:03:08     INFO -  TEST-INFO | screentopng: exit 0
11:03:08     INFO -  119 INFO *** Start BrowserChrome Test Results ***
11:03:08     INFO -  120 INFO checking window state
11:03:08     INFO -  121 INFO TEST-INFO | (browser-test.js) | Console message: [JavaScript Error: "TelemetryStopwatch: requesting elapsed time for nonexisting stopwatch. Histogram: "FX_PAGE_LOAD_MS", key: "null"" {file: "resource://gre/modules/TelemetryStopwatch.jsm" line: 297}]
11:03:08     INFO -  this.TelemetryStopwatchImpl.timeElapsed@resource://gre/modules/TelemetryStopwatch.jsm:297:7
11:03:08     INFO -  this.TelemetryStopwatchImpl.finish@resource://gre/modules/TelemetryStopwatch.jsm:315:17
11:03:08     INFO -  this.TelemetryStopwatch.finish@resource://gre/modules/TelemetryStopwatch.jsm:192:12
11:03:08     INFO -  TabsProgressListener.onStateChange@chrome://browser/content/browser.js:4648:11
11:03:08     INFO -  callListeners@chrome://browser/content/tabbrowser.xml:501:24
11:03:08     INFO -  _callProgressListeners@chrome://browser/content/tabbrowser.xml:522:13
11:03:08     INFO -  mTabProgressListener/<._callProgressListeners@chrome://browser/content/tabbrowser.xml:571:22
11:03:08     INFO -  mTabProgressListener/<.onStateChange@chrome://browser/content/tabbrowser.xml:729:15
11:03:08     INFO -  stop@chrome://global/content/bindings/browser.xml:100:13
11:03:08     INFO -  stop@chrome://browser/content/tabbrowser.xml:3838:20
11:03:08     INFO -  Tester_waitForWindowsState@chrome://mochikit/content/browser-test.js:306:7
11:03:08     INFO -  Tester.prototype.nextTest<@chrome://mochikit/content/browser-test.js:594:5
11:03:08     INFO -  TaskImpl_run@resource://gre/modules/Task.jsm:319:40
11:03:08     INFO -  TaskImpl@resource://gre/modules/Task.jsm:280:3
11:03:08     INFO -  createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:254:14
11:03:08     INFO -  waitForGraphicsTestWindowToBeGone@chrome://mochikit/content/browser-test.js:281:5
11:03:08     INFO -  Tester_start@chrome://mochikit/content/browser-test.js:265:7
11:03:08     INFO -  createTester/</<@chrome://mochikit/content/browser-harness.xul:255:11
11:03:08     INFO -  122 INFO Entering test bound init
11:03:08     INFO -  123 INFO Setting up about:performance
11:03:08     INFO -  124 INFO Console message: [JavaScript Error: "[Exception... "Component returned failure code: 0x804b000a (NS_ERROR_MALFORMED_URI) [nsIWebNavigation.loadURIWithOptions]"  nsresult: "0x804b000a (NS_ERROR_MALFORMED_URI)"  location: "JS frame :: chrome://browser/content/browser.js :: _loadURIWithFlags :: line 842"  data: no]" {file: "chrome://browser/content/tabbrowser.xml" line: 1967}]
11:03:08     INFO -  addTab@chrome://browser/content/tabbrowser.xml:1967:17
11:03:08     INFO -  init@chrome://mochitests/content/browser/toolkit/components/aboutperformance/tests/browser/browser_aboutperformance.js:189:49
11:03:08     INFO -  TaskImpl_run@resource://gre/modules/Task.jsm:319:40
11:03:08     INFO -  TaskImpl@resource://gre/modules/Task.jsm:280:3
11:03:08     INFO -  createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:254:14
11:03:08     INFO -  Task_spawn@resource://gre/modules/Task.jsm:168:12
11:03:08     INFO -  TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:388:16
11:03:08     INFO -  TaskImpl_run@resource://gre/modules/Task.jsm:327:13
11:03:08     INFO -  TaskImpl@resource://gre/modules/Task.jsm:280:3
11:03:08     INFO -  createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:254:14
11:03:08     INFO -  Task_spawn@resource://gre/modules/Task.jsm:168:12
11:03:08     INFO -  Tester_execTest@chrome://mochikit/content/browser-test.js:790:9
11:03:08     INFO -  Tester.prototype.nextTest</<@chrome://mochikit/content/browser-test.js:710:7
11:03:08     INFO -  SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:741:59
11:03:08     INFO -  125 INFO Setting up http://example.com/browser/toolkit/components/aboutperformance/tests/browser/browser_compartments.html?test=0.7198192774298801
11:03:08     INFO -  126 INFO Leaving test bound init
11:03:08     INFO -  127 INFO Entering test bound test_find_title
11:03:08     INFO -  128 INFO Testing with autoRefresh, in recent mode
11:03:08     INFO -  129 INFO Console message: [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "http://example.com/browser/toolkit/components/aboutperformance/tests/browser/browser_compartments.html?test=0.7198192774298801" line: 0}]
11:03:08     INFO -  130 INFO TEST-UNEXPECTED-FAIL | toolkit/components/aboutperformance/tests/browser/browser_aboutperformance.js | Test timed out -
11:03:08     INFO -  MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
11:03:08     INFO -  MEMORY STAT | vsize 622MB | residentFast 166MB | heapAllocated 76MB
11:03:08     INFO -  131 INFO TEST-OK | toolkit/components/aboutperformance/tests/browser/browser_aboutperformance.js | took 45176ms
11:03:08     INFO -  Not taking screenshot here: see the one that was previously logged
11:03:08     INFO -  132 INFO TEST-UNEXPECTED-FAIL | toolkit/components/aboutperformance/tests/browser/browser_aboutperformance.js | Found a tab after previous test timed out: http://example.com/browser/toolkit/components/aboutperformance/tests/browser/browser_compartments.html?test=0.7198192774298801 -
11:03:08     INFO -  Not taking screenshot here: see the one that was previously logged
11:03:08     INFO -  133 INFO TEST-UNEXPECTED-FAIL | toolkit/components/aboutperformance/tests/browser/browser_aboutperformance.js | Found a tab after previous test timed out: about:performance -
11:03:08     INFO -  134 INFO checking window state
11:03:08     INFO -  135 INFO Console message: [JavaScript Error: "TelemetryStopwatch: requesting elapsed time for nonexisting stopwatch. Histogram: "FX_PAGE_LOAD_MS", key: "null"" {file: "resource://gre/modules/TelemetryStopwatch.jsm" line: 297}]
11:03:08     INFO -  this.TelemetryStopwatchImpl.timeElapsed@resource://gre/modules/TelemetryStopwatch.jsm:297:7
11:03:08     INFO -  this.TelemetryStopwatchImpl.finish@resource://gre/modules/TelemetryStopwatch.jsm:315:17
11:03:08     INFO -  this.TelemetryStopwatch.finish@resource://gre/modules/TelemetryStopwatch.jsm:192:12
11:03:08     INFO -  TabsProgressListener.onStateChange@chrome://browser/content/browser.js:4648:11
11:03:08     INFO -  callListeners@chrome://browser/content/tabbrowser.xml:501:24
11:03:08     INFO -  _callProgressListeners@chrome://browser/content/tabbrowser.xml:522:13
11:03:08     INFO -  mTabProgressListener/<._callProgressListeners@chrome://browser/content/tabbrowser.xml:571:22
11:03:08     INFO -  mTabProgressListener/<.onStateChange@chrome://browser/content/tabbrowser.xml:729:15
11:03:08     INFO -  stop@chrome://global/content/bindings/browser.xml:100:13
11:03:08     INFO -  stop@chrome://browser/content/tabbrowser.xml:3838:20
11:03:08     INFO -  Tester_waitForWindowsState@chrome://mochikit/content/browser-test.js:306:7
11:03:08     INFO -  Tester.prototype.nextTest<@chrome://mochikit/content/browser-test.js:594:5
11:03:08     INFO -  TaskImpl_run@resource://gre/modules/Task.jsm:319:40
11:03:08     INFO -  promise callback*TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:395:7
11:03:08     INFO -  TaskImpl_run@resource://gre/modules/Task.jsm:327:13
11:03:08     INFO -  TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:400:7
11:03:08     INFO -  TaskImpl_run@resource://gre/modules/Task.jsm:327:13
11:03:08     INFO -  TaskImpl_handleResultValue@resource://gre/modules/Task.jsm:400:7
11:03:08     INFO -  TaskImpl_run@resource://gre/modules/Task.jsm:327:13
11:03:08     INFO -  TaskImpl@resource://gre/modules/Task.jsm:280:3
11:03:08     INFO -  createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:254:14
11:03:08     INFO -  timeoutFn@chrome://mochikit/content/browser-test.js:872:9
11:03:08     INFO -  setTimeout handler*Tester_execTest@chrome://mochikit/content/browser-test.js:834:9
11:03:08     INFO -  Tester.prototype.nextTest</<@chrome://mochikit/content/browser-test.js:710:7
11:03:08     INFO -  SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:741:59
11:03:09     INFO -  Completed ShutdownLeaks collections in process 2907

Comment 1

[David Teller [:Yoric] - still alive but not very active]

That's... interesting.

Comment 2

[David Teller [:Yoric] - still alive but not very active]

I lost track of your Aurora simulation patch, could you remind me where I can find it?

Comment 3

[Phil Ringnalda (:philor)]

The general answer is https://treeherder.mozilla.org/#/jobs?repo=try&author=[e-mail] but specifically right now, https://hg.mozilla.org/try/rev/656be1ae0016

Comment 4

[Ryan VanderMeulen [:RyanVM]]

About a week to go until the merge - any news here?

Comment 5

[David Teller [:Yoric] - still alive but not very active]

I haven't found the issue yet, but I'm looking into it.

Comment 6

[David Teller [:Yoric] - still alive but not very active]

Attachment: MozReview Request: Trunk as Aurora Simulation: Version bumps, enable PGO, and mozconfig changes.

Review commit: https://reviewboard.mozilla.org/r/37221/diff/#index_header
See other reviews: https://reviewboard.mozilla.org/r/37221/

Comment 7

[David Teller [:Yoric] - still alive but not very active]

Attachment: MozReview Request: Bug 1249393 - Getting rid of more Nightly-only gates for about:performance;r=self

Review commit: https://reviewboard.mozilla.org/r/37223/diff/#index_header
See other reviews: https://reviewboard.mozilla.org/r/37223/

Comment 8

[David Teller [:Yoric] - still alive but not very active]

Comment on attachment 8724910 [details]
MozReview Request: Bug 1249393 - Getting rid of more Nightly-only gates for about:performance;r=self

Review request updated; see interdiff: https://reviewboard.mozilla.org/r/37223/diff/1-2/

Comment 9

[David Teller [:Yoric] - still alive but not very active]

Comment on attachment 8724910 [details]
MozReview Request: Bug 1249393 - Getting rid of more Nightly-only gates for about:performance;r=self

https://reviewboard.mozilla.org/r/37223/#review33913

Comment 10

[Pulsebot]

https://hg.mozilla.org/integration/mozilla-inbound/rev/f5e475aff6f0

Comment 11

[Wes Kocher (:KWierso) (Not reading bugmail; email directly if needed)]

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

Comment 12

[Ritu Kothari (:ritu) (Inactive, please n-i to RyanVM, jcristau, or pascal)]

Don't feel the need to track this since it's fixed.