Closed Bug 1759146 Opened 3 years ago Closed 3 years ago

High frequency devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js | We loaded normal-script.js only once - Got 2, expected 1

Categories

(DevTools :: Debugger, defect, P5)

defect

Tracking

(firefox-esr91 unaffected, firefox98 unaffected, firefox99 unaffected, firefox100 fixed)

RESOLVED FIXED
100 Branch
Tracking Status
firefox-esr91 --- unaffected
firefox98 --- unaffected
firefox99 --- unaffected
firefox100 --- fixed

People

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

References

(Regression)

Details

(Keywords: intermittent-failure, regression, Whiteboard: [retriggered][stockwell disable-recommended])

Attachments

(1 file)

Filed by: apavel [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=370672009&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/WSO05ZK9SJqEQk-CmKcCRQ/runs/1/artifacts/public/logs/live_backing.log


[task 2022-03-11T12:23:47.837Z] 12:23:47     INFO - TEST-START | devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js
[task 2022-03-11T12:23:52.667Z] 12:23:52     INFO - TEST-INFO | started process screentopng
[task 2022-03-11T12:23:52.980Z] 12:23:52     INFO - TEST-INFO | screentopng: exit 0
[task 2022-03-11T12:23:52.980Z] 12:23:52     INFO - Buffered messages logged at 12:23:47
[task 2022-03-11T12:23:52.981Z] 12:23:52     INFO - Entering test bound testSourceTextContent
[task 2022-03-11T12:23:52.981Z] 12:23:52     INFO - Adding a new tab with URL: http://localhost:33200/index.html
[task 2022-03-11T12:23:52.981Z] 12:23:52     INFO - Buffered messages logged at 12:23:49
[task 2022-03-11T12:23:52.982Z] 12:23:52     INFO - Console message: [JavaScript Warning: "Loading failed for the <script> with source “http://localhost:33200/http-error-script.js”." {file: "http://localhost:33200/index.html" line: 6}]
[task 2022-03-11T12:23:52.982Z] 12:23:52     INFO - Tab added and finished loading
[task 2022-03-11T12:23:52.983Z] 12:23:52     INFO - TEST-PASS | devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js | index.html is loaded once before opening devtools - 
[task 2022-03-11T12:23:52.984Z] 12:23:52     INFO - TEST-PASS | devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js | We loaded http-error-script.js twice. - 
[task 2022-03-11T12:23:52.985Z] 12:23:52     INFO - Opening the toolbox
[task 2022-03-11T12:23:52.986Z] 12:23:52     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2022-03-11T12:23:52.986Z] 12:23:52     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2022-03-11T12:23:52.987Z] 12:23:52     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 62}]
[task 2022-03-11T12:23:52.988Z] 12:23:52     INFO - Buffered messages logged at 12:23:50
[task 2022-03-11T12:23:52.989Z] 12:23:52     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2022-03-11T12:23:52.989Z] 12:23:52     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 511}]
[task 2022-03-11T12:23:52.990Z] 12:23:52     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome" line: 62}]
[task 2022-03-11T12:23:52.990Z] 12:23:52     INFO - Console message: [JavaScript Warning: "Use of nsIFile in content process is deprecated." {file: "resource://gre/modules/NetUtil.jsm" line: 253}]
[task 2022-03-11T12:23:52.991Z] 12:23:52     INFO - Console message: [JavaScript Warning: "Use of nsIFile in content process is deprecated." {file: "resource://gre/modules/NetUtil.jsm" line: 253}]
[task 2022-03-11T12:23:52.991Z] 12:23:52     INFO - Console message: [JavaScript Warning: "Use of nsIFile in content process is deprecated." {file: "resource://gre/modules/NetUtil.jsm" line: 253}]
[task 2022-03-11T12:23:52.992Z] 12:23:52     INFO - Toolbox opened and focused
[task 2022-03-11T12:23:52.993Z] 12:23:52     INFO - Waiting on sources: index.html, normal-script.js, slow-loading-script.js
[task 2022-03-11T12:23:52.993Z] 12:23:52     INFO - Waiting for state change: source index.html exists
[task 2022-03-11T12:23:52.994Z] 12:23:52     INFO - Waiting for state change: source normal-script.js exists
[task 2022-03-11T12:23:52.994Z] 12:23:52     INFO - Waiting for state change: source slow-loading-script.js exists
[task 2022-03-11T12:23:52.995Z] 12:23:52     INFO - Finished waiting for state change: source normal-script.js exists
[task 2022-03-11T12:23:52.995Z] 12:23:52     INFO - Finished waiting for state change: source normal-script.js exists
[task 2022-03-11T12:23:52.996Z] 12:23:52     INFO - Console message: [JavaScript Warning: "‘src’ attribute of <script> element is not a valid URI: “/normal-script.js”" {file: "moz-nullprincipal:{8ccf5ade-9531-4194-9b81-1ab9b5f2dfcf}" line: 1}]
[task 2022-03-11T12:23:52.997Z] 12:23:52     INFO - Console message: [JavaScript Warning: "‘src’ attribute of <script> element is not a valid URI: “/slow-loading-script.js”" {file: "moz-nullprincipal:{8ccf5ade-9531-4194-9b81-1ab9b5f2dfcf}" line: 1}]
[task 2022-03-11T12:23:52.998Z] 12:23:52     INFO - Console message: [JavaScript Warning: "‘src’ attribute of <script> element is not a valid URI: “/http-error-script.js”" {file: "moz-nullprincipal:{8ccf5ade-9531-4194-9b81-1ab9b5f2dfcf}" line: 1}]
[task 2022-03-11T12:23:52.998Z] 12:23:52     INFO - Finished waiting for state change: source index.html exists
[task 2022-03-11T12:23:52.999Z] 12:23:52     INFO - Buffered messages logged at 12:23:51
[task 2022-03-11T12:23:53.000Z] 12:23:53     INFO - Finished waiting for state change: source slow-loading-script.js exists
[task 2022-03-11T12:23:53.001Z] 12:23:53     INFO - Finished waiting for state change: source slow-loading-script.js exists
[task 2022-03-11T12:23:53.004Z] 12:23:53     INFO - Finished waiting on sources: index.html, normal-script.js, slow-loading-script.js
[task 2022-03-11T12:23:53.005Z] 12:23:53     INFO - Buffered messages logged at 12:23:52
[task 2022-03-11T12:23:53.005Z] 12:23:53     INFO - Waiting for state change: selected source
[task 2022-03-11T12:23:53.006Z] 12:23:53     INFO - Finished waiting for state change: selected source
[task 2022-03-11T12:23:53.006Z] 12:23:53     INFO - TEST-PASS | devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js | undefined assertion name - 
[task 2022-03-11T12:23:53.007Z] 12:23:53     INFO - Waiting for state change: selected source
[task 2022-03-11T12:23:53.008Z] 12:23:53     INFO - Finished waiting for state change: selected source
[task 2022-03-11T12:23:53.008Z] 12:23:53     INFO - TEST-PASS | devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js | undefined assertion name - 
[task 2022-03-11T12:23:53.009Z] 12:23:53     INFO - Waiting for state change: selected source
[task 2022-03-11T12:23:53.010Z] 12:23:53     INFO - Finished waiting for state change: selected source
[task 2022-03-11T12:23:53.010Z] 12:23:53     INFO - TEST-PASS | devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js | undefined assertion name - 
[task 2022-03-11T12:23:53.010Z] 12:23:53     INFO - TEST-PASS | devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js | scripts with HTTP error code do not appear in the source list - 
[task 2022-03-11T12:23:53.011Z] 12:23:53     INFO - TEST-PASS | devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js | We loaded index.html twice - 
[task 2022-03-11T12:23:53.011Z] 12:23:53     INFO - Buffered messages finished
[task 2022-03-11T12:23:53.012Z] 12:23:53     INFO - TEST-UNEXPECTED-FAIL | devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js | We loaded normal-script.js only once - Got 2, expected 1
[task 2022-03-11T12:23:53.012Z] 12:23:53     INFO - Stack trace:
[task 2022-03-11T12:23:53.012Z] 12:23:53     INFO - chrome://mochikit/content/browser-test.js:test_is:1422
[task 2022-03-11T12:23:53.012Z] 12:23:53     INFO - chrome://mochitests/content/browser/devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js:testSourceTextContent:100
[task 2022-03-11T12:23:53.013Z] 12:23:53     INFO - chrome://mochikit/content/browser-test.js:handleTask:989
[task 2022-03-11T12:23:53.013Z] 12:23:53     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1061
[task 2022-03-11T12:23:53.013Z] 12:23:53     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1189
[task 2022-03-11T12:23:53.013Z] 12:23:53     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:978
[task 2022-03-11T12:23:53.014Z] 12:23:53     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1041
[task 2022-03-11T12:23:53.014Z] 12:23:53     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-03-11T12:23:53.015Z] 12:23:53     INFO - TEST-UNEXPECTED-FAIL | devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js | We loaded slow-loading-script.js only once - Got 2, expected 1
[task 2022-03-11T12:23:53.015Z] 12:23:53     INFO - Stack trace:
[task 2022-03-11T12:23:53.015Z] 12:23:53     INFO - chrome://mochikit/content/browser-test.js:test_is:1422
[task 2022-03-11T12:23:53.016Z] 12:23:53     INFO - chrome://mochitests/content/browser/devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js:testSourceTextContent:105
[task 2022-03-11T12:23:53.016Z] 12:23:53     INFO - chrome://mochikit/content/browser-test.js:handleTask:989
[task 2022-03-11T12:23:53.016Z] 12:23:53     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1061
[task 2022-03-11T12:23:53.016Z] 12:23:53     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1189
[task 2022-03-11T12:23:53.016Z] 12:23:53     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:978
[task 2022-03-11T12:23:53.016Z] 12:23:53     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1041
[task 2022-03-11T12:23:53.016Z] 12:23:53     INFO - TEST-PASS | devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js | We loaded http-error-script.js twice, only before the debugger is opened - 
[task 2022-03-11T12:23:53.016Z] 12:23:53     INFO - Leaving test bound testSourceTextContent

Alexandre, please take a look.

Flags: needinfo?(poirot.alex)

Set release status flags based on info from the regressing bug 1754407

Summary: Intermittent devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js | We loaded normal-script.js only once - Got 2, expected 1 → High frequency devtools/client/debugger/test/mochitest/browser_dbg-features-source-text-content.js | We loaded normal-script.js only once - Got 2, expected 1
Whiteboard: [retriggered][stockwell needswork:owner]
Has Regression Range: --- → yes

This test assert that the debugger doesn't get unexpected request while debugging a page.
But for that, we should open the page while the debugger is opened.
Otherwise the page resources might be GC-ed, forcing the debugger to fetch some content again.

Assignee: nobody → poirot.alex
Status: NEW → ASSIGNED
Flags: needinfo?(poirot.alex)
Pushed by apoirot@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/02616d03975b [devtools] Avoid unexpected GC while running testSourceTextContent. r=bomsy
Status: ASSIGNED → RESOLVED
Closed: 3 years ago
Resolution: --- → FIXED
Target Milestone: --- → 100 Branch
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: