Closed Bug 1261151 Opened 9 years ago Closed 9 years ago

'TelemetryStopwatch: key "FX_TAB_SWITCH_TOTAL_MS" was already initialized' spam during tests

Categories

(Firefox :: General, defect)

Product:
Firefox
Component:
General
Type:
defect
Priority:
Not set
Severity:
normal

Tracking

()

Status:
RESOLVED DUPLICATE of bug 1261738

People

(Reporter: mconley, Unassigned)

Details

Example: http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1459356525/fx-team_snowleopard_test-mochitest-browser-chrome-7-bm108-tests1-macosx-build496.txt.gz 11:10:52 INFO - 184 INFO TEST-START | browser/base/content/test/general/browser_bug575561.js 11:10:52 INFO - 185 INFO Waiting for browser load 11:10:53 INFO - 186 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/browser/base/content/test/general/app_bug575561.html" line: 0}] 11:10:53 INFO - 187 INFO Saw state c0010 and status 0 11:10:53 INFO - 188 INFO Browser loaded http://example.com/browser/browser/base/content/test/general/app_bug575561.html 11:10:53 INFO - 189 INFO Waiting for browser load 11:10:53 INFO - 190 INFO Clicking same domain 11:10:53 INFO - 191 INFO Saw state f0001 and status 0 11:10:53 INFO - 192 INFO Saw state c0010 and status 0 11:10:53 INFO - 193 INFO Browser loaded http://example.com/browser/browser/base/content/test/general/dummy_page.html 11:10:53 INFO - 194 INFO TEST-PASS | browser/base/content/test/general/browser_bug575561.js | Link should not open in a new tab - 11:10:53 INFO - 195 INFO Waiting for browser load 11:10:53 INFO - 196 INFO Console message: [JavaScript Error: "TelemetryStopwatch: key "FX_TAB_SWITCH_TOTAL_MS" was already initialized" {file: "resource://gre/modules/TelemetryStopwatch.jsm" line: 282}] 11:10:53 INFO - this.TelemetryStopwatchImpl.start@resource://gre/modules/TelemetryStopwatch.jsm:282:7 11:10:53 INFO - this.TelemetryStopwatch.start@resource://gre/modules/TelemetryStopwatch.jsm:136:12 11:10:53 INFO - updateCurrentBrowser@chrome://browser/content/tabbrowser.xml:1036:17 11:10:53 INFO - onselect@chrome://browser/content/browser.xul:1:44 11:10:53 INFO - set_selectedIndex@chrome://global/content/bindings/tabbox.xml:656:13 11:10:53 INFO - set_selectedPanel@chrome://global/content/bindings/tabbox.xml:675:13 11:10:53 INFO - set_selectedIndex@chrome://global/content/bindings/tabbox.xml:403:15 11:10:53 INFO - set_selectedItem@chrome://global/content/bindings/tabbox.xml:435:34 11:10:53 INFO - set_selectedTab@chrome://global/content/bindings/tabbox.xml:114:15 11:10:53 INFO - set_selectedTab@chrome://browser/content/tabbrowser.xml:2841:11 11:10:53 INFO - testLink<@chrome://mochitests/content/browser/browser/base/content/test/general/browser_bug575561.js:64:3 11:10:53 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:319:40 11:10:53 INFO - TaskImpl@resource://gre/modules/Task.jsm:280:3 11:10:53 INFO - createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:254:14 11:10:53 INFO - @chrome://mochitests/content/browser/browser/base/content/test/general/browser_bug575561.js:13:9 11:10:53 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:319:40 11:10:53 INFO - Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:937:23 11:10:53 INFO - this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 11:10:53 INFO - Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 11:10:53 INFO - this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 11:10:53 INFO - this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 11:10:53 INFO - waitForDocLoadComplete/</listener.onStateChange@chrome://mochitests/content/browser/browser/base/content/test/general/head.js:478:11 11:10:53 INFO - callListeners@chrome://browser/content/tabbrowser.xml:501:24 11:10:53 INFO - _callProgressListeners@chrome://browser/content/tabbrowser.xml:516:13 11:10:53 INFO - mTabProgressListener/<._callProgressListeners@chrome://browser/content/tabbrowser.xml:571:22 11:10:53 INFO - mTabProgressListener/<.onStateChange@chrome://browser/content/tabbrowser.xml:726:17 11:10:53 INFO - 197 INFO Console message: [JavaScript Error: "TelemetryStopwatch: requesting elapsed time for nonexisting stopwatch. Histogram: "FX_TAB_SWITCH_TOTAL_MS", key: "null"" {file: "resource://gre/modules/TelemetryStopwatch.jsm" line: 297}] 11:10:53 INFO - this.TelemetryStopwatchImpl.timeElapsed@resource://gre/modules/TelemetryStopwatch.jsm:297:7 11:10:53 INFO - this.TelemetryStopwatchImpl.finish@resource://gre/modules/TelemetryStopwatch.jsm:315:17 11:10:53 INFO - this.TelemetryStopwatch.finish@resource://gre/modules/TelemetryStopwatch.jsm:192:12 11:10:53 INFO - onMozAfterPaint@chrome://browser/content/tabbrowser.xml:1038:19 11:10:53 INFO - EventListener.handleEvent*updateCurrentBrowser@chrome://browser/content/tabbrowser.xml:1037:17 11:10:53 INFO - onselect@chrome://browser/content/browser.xul:1:44 11:10:53 INFO - set_selectedIndex@chrome://global/content/bindings/tabbox.xml:656:13 11:10:53 INFO - set_selectedPanel@chrome://global/content/bindings/tabbox.xml:675:13 11:10:53 INFO - set_selectedIndex@chrome://global/content/bindings/tabbox.xml:403:15 11:10:53 INFO - set_selectedItem@chrome://global/content/bindings/tabbox.xml:435:34 11:10:53 INFO - set_selectedTab@chrome://global/content/bindings/tabbox.xml:114:15 11:10:53 INFO - set_selectedTab@chrome://browser/content/tabbrowser.xml:2841:11 11:10:53 INFO - _blurTab@chrome://browser/content/tabbrowser.xml:2492:13 11:10:53 INFO - _endRemoveTab@chrome://browser/content/tabbrowser.xml:2366:13 11:10:53 INFO - removeTab@chrome://browser/content/tabbrowser.xml:2208:15 11:10:53 INFO - testLink<@chrome://mochitests/content/browser/browser/base/content/test/general/browser_bug575561.js:85:3 11:10:53 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:319:40 11:10:53 INFO - Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:937:23 11:10:53 INFO - this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 11:10:53 INFO - Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 11:10:53 INFO - this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 11:10:53 INFO - this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 11:10:53 INFO - waitForDocLoadComplete/</listener.onStateChange@chrome://mochitests/content/browser/browser/base/content/test/general/head.js:478:11 11:10:53 INFO - callListeners@chrome://browser/content/tabbrowser.xml:501:24 11:10:53 INFO - _callProgressListeners@chrome://browser/content/tabbrowser.xml:516:13 11:10:53 INFO - mTabProgressListener/<._callProgressListeners@chrome://browser/content/tabbrowser.xml:571:22 11:10:53 INFO - mTabProgressListener/<.onStateChange@chrome://browser/content/tabbrowser.xml:726:17 11:10:53 INFO - 198 INFO Console message: [JavaScript Error: "TelemetryStopwatch: requesting elapsed time for nonexisting stopwatch. Histogram: "FX_TAB_SWITCH_TOTAL_MS", key: "null"" {file: "resource://gre/modules/TelemetryStopwatch.jsm" line: 297}] 11:10:53 INFO - this.TelemetryStopwatchImpl.timeElapsed@resource://gre/modules/TelemetryStopwatch.jsm:297:7 11:10:53 INFO - this.TelemetryStopwatchImpl.finish@resource://gre/modules/TelemetryStopwatch.jsm:315:17 11:10:53 INFO - this.TelemetryStopwatch.finish@resource://gre/modules/TelemetryStopwatch.jsm:192:12 11:10:53 INFO - onMozAfterPaint@chrome://browser/content/tabbrowser.xml:1038:19 11:10:53 INFO - EventListener.handleEvent*updateCurrentBrowser@chrome://browser/content/tabbrowser.xml:1037:17 11:10:53 INFO - onselect@chrome://browser/content/browser.xul:1:44 11:10:53 INFO - set_selectedIndex@chrome://global/content/bindings/tabbox.xml:656:13 11:10:53 INFO - set_selectedPanel@chrome://global/content/bindings/tabbox.xml:675:13 11:10:53 INFO - set_selectedIndex@chrome://global/content/bindings/tabbox.xml:403:15 11:10:53 INFO - set_selectedItem@chrome://global/content/bindings/tabbox.xml:435:34 11:10:53 INFO - set_selectedTab@chrome://global/content/bindings/tabbox.xml:114:15 11:10:53 INFO - set_selectedTab@chrome://browser/content/tabbrowser.xml:2841:11 11:10:53 INFO - testLink<@chrome://mochitests/content/browser/browser/base/content/test/general/browser_bug575561.js:64:3 11:10:53 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:319:40 11:10:53 INFO - TaskImpl@resource://gre/modules/Task.jsm:280:3 11:10:53 INFO - createAsyncFunction/asyncFunction@resource://gre/modules/Task.jsm:254:14 11:10:53 INFO - @chrome://mochitests/content/browser/browser/base/content/test/general/browser_bug575561.js:13:9 11:10:53 INFO - TaskImpl_run@resource://gre/modules/Task.jsm:319:40 11:10:53 INFO - Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:937:23 11:10:53 INFO - this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 11:10:53 INFO - Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 11:10:53 INFO - this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 11:10:53 INFO - this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 11:10:53 INFO - waitForDocLoadComplete/</listener.onStateChange@chrome://mochitests/content/browser/browser/base/content/test/general/head.js:478:11 11:10:53 INFO - callListeners@chrome://browser/content/tabbrowser.xml:501:24 11:10:53 INFO - _callProgressListeners@chrome://browser/content/tabbrowser.xml:516:13 11:10:53 INFO - mTabProgressListener/<._callProgressListeners@chrome://browser/content/tabbrowser.xml:571:22 11:10:53 INFO - mTabProgressListener/<.onStateChange@chrome://browser/content/tabbrowser.xml:726:17 11:10:53 INFO - 199 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/browser/base/content/test/general/app_bug575561.html" line: 0}] 11:10:53 INFO - 200 INFO Console message: [JavaScript Warning: "The character encoding of a framed document was not declared. The document may appear different if viewed without the document framing it." {file: "http://example.com/browser/browser/base/content/test/general/app_subframe_bug575561.html" line: 0}] 11:10:53 INFO - 201 INFO Saw state c0010 and status 0 11:10:53 INFO - 202 INFO Browser loaded http://example.com/browser/browser/base/content/test/general/app_bug575561.html 11:10:53 INFO - 203 INFO Waiting for TabOpen 11:10:53 INFO - 204 INFO Clicking same domain (different subdomain) 11:10:53 INFO - 205 INFO Saw TabOpen 11:10:53 INFO - 206 INFO TEST-PASS | browser/base/content/test/general/browser_bug575561.js | Link should open a new tab -
Status: NEW → RESOLVED
Closed: 9 years ago
Resolution: --- → DUPLICATE
You need to log in before you can comment on or make changes to this bug.