Bug 1578594 Comment 30 Edit History

Note: The actual edited comment in the bug view page will always show the original commenter’s name and original timestamp.

This seems to have been fixed at the end of January https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?startday=2020-01-16&endday=2020-02-15&tree=trunk&bug=1578594 but started again on the 13th of February. 

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

[task 2020-02-15T11:00:56.431Z] 11:00:56     INFO - TEST-START | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js
[task 2020-02-15T11:00:57.747Z] 11:00:57     INFO - GECKO(10851) | console.log: "simple message 1"
[task 2020-02-15T11:02:26.446Z] 11:02:26     INFO - TEST-INFO | started process screentopng
[task 2020-02-15T11:02:26.689Z] 11:02:26     INFO - TEST-INFO | screentopng: exit 0
[task 2020-02-15T11:02:26.689Z] 11:02:26     INFO - Buffered messages logged at 11:00:56
[task 2020-02-15T11:02:26.689Z] 11:02:26     INFO - Entering test bound testContentBlockingMessage
[task 2020-02-15T11:02:26.689Z] 11:02:26     INFO - Adding a new tab with URL: http://example.org/browser/devtools/client/webconsole/test/browser/test-warning-groups.html
[task 2020-02-15T11:02:26.689Z] 11:02:26     INFO - Buffered messages logged at 11:00:57
[task 2020-02-15T11:02:26.689Z] 11:02:26     INFO - Tab added and finished loading
[task 2020-02-15T11:02:26.689Z] 11:02:26     INFO - Opening the toolbox
[task 2020-02-15T11:02:26.689Z] 11:02:26     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome://global/content/elements/panel.js" line: 62}]
[task 2020-02-15T11:02:26.689Z] 11:02:26     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome://global/content/elements/panel.js" line: 62}]
[task 2020-02-15T11:02:26.703Z] 11:02:26     INFO - Toolbox opened and focused
[task 2020-02-15T11:02:26.704Z] 11:02:26     INFO - Log a tracking protection message to check a single message isn't grouped
[task 2020-02-15T11:02:26.705Z] 11:02:26     INFO - Console message: [JavaScript Warning: "The resource at “http://tracking.example.com/browser/devtools/client/webconsole/test/browser/test-image.png?1-1581764456435” was blocked because content blocking is enabled." {file: "http://example.org/browser/devtools/client/webconsole/test/browser/test-warning-groups.html" line: 0}]
[task 2020-02-15T11:02:26.705Z] 11:02:26     INFO - Matched a message with text: "http://tracking.example.com/browser/devtools/client/webconsole/test/browser/test-image.png", all messages received.
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | The message has the expected style - 
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | The message has the expected indent - 
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - Log a simple message
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - Matched a message with text: "simple message 1", all messages received.
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - Log a second tracking protection message to check that it causes the grouping
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - Console message: [JavaScript Warning: "The resource at “http://tracking.example.com/browser/devtools/client/webconsole/test/browser/test-image.png?2-1581764456435” was blocked because content blocking is enabled." {file: "http://example.org/browser/devtools/client/webconsole/test/browser/test-warning-groups.html" line: 0}]
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - Matched a message with text: "The resource at “<URL>” was blocked because content blocking is enabled.", all messages received.
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | The badge has the expected text - 
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | Got the expected number of messages - 
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - Checking "▶︎⚠ The resource at “<URL>” was blocked because content blocking is enabled."
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | There's a collapsed arrow - 
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | The warningGroup has the expected indent - 
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | The message has the expected indent - 
[task 2020-02-15T11:02:26.707Z] 11:02:26     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | Message includes the expected "The resource at “<URL>” was blocked because content blocking is enabled." content - "The resource at “<URL>” was blocked because content blocking is enabled. 2" - 
[task 2020-02-15T11:02:26.707Z] 11:02:26     INFO - Checking "simple message 1"
[task 2020-02-15T11:02:26.707Z] 11:02:26     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | The message has the expected indent - 
[task 2020-02-15T11:02:26.707Z] 11:02:26     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | Message includes the expected "simple message 1" content - "simple message 1 browser_webconsole_warning_group_multiples.js:303:21" - 
[task 2020-02-15T11:02:26.709Z] 11:02:26     INFO - Console message: [JavaScript Warning: "Request to access cookie or storage on “http://example.com/browser/devtools/client/webconsole/test/browser/test-image.png?3-1581764456435” was blocked because we are blocking all third-party storage access requests and content blocking is enabled."]
[task 2020-02-15T11:02:26.714Z] 11:02:26     INFO - Console message: [JavaScript Warning: "Request to access cookie or storage on “http://example.com/browser/devtools/client/webconsole/test/browser/test-image.png?3-1581764456435” was blocked because we are blocking all third-party storage access requests and content blocking is enabled."]
[task 2020-02-15T11:02:26.715Z] 11:02:26     INFO - Buffered messages logged at 11:01:41
[task 2020-02-15T11:02:26.716Z] 11:02:26     INFO - Longer timeout required, waiting longer...  Remaining timeouts: 1
[task 2020-02-15T11:02:26.717Z] 11:02:26     INFO - Buffered messages finished
[task 2020-02-15T11:02:26.717Z] 11:02:26     INFO - TEST-UNEXPECTED-FAIL | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | Test timed out - 
[task 2020-02-15T11:02:26.718Z] 11:02:26     INFO - Removing tab.
[task 2020-02-15T11:02:26.720Z] 11:02:26     INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2020-02-15T11:02:26.720Z] 11:02:26     INFO - Got event: 'TabClose' on [object XULElement].
[task 2020-02-15T11:02:26.721Z] 11:02:26     INFO - GECKO(10851) | console.warn: "IGNORED REDUX ACTION:" ({type:"AUTOCOMPLETE_CLEAR"})
[task 2020-02-15T11:02:26.721Z] 11:02:26     INFO - Tab removed and finished closing
[task 2020-02-15T11:02:26.721Z] 11:02:26     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | The main process DebuggerServer has no pending connection when the test ends - 
[task 2020-02-15T11:02:26.798Z] 11:02:26     INFO - GECKO(10851) | MEMORY STAT | vsize 4050MB | residentFast 528MB | heapAllocated 160MB
[task 2020-02-15T11:02:26.798Z] 11:02:26     INFO - TEST-OK | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | took 90371ms

Occurs only on mozilla-central on linux1804-64 opt and debug and windows10-64 opt.
This seems to have been fixed at the end of January https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?startday=2020-01-16&endday=2020-02-15&tree=trunk&bug=1578594 but started again on the 13th of February. 

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

[task 2020-02-15T11:00:56.431Z] 11:00:56     INFO - TEST-START | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js
[task 2020-02-15T11:00:57.747Z] 11:00:57     INFO - GECKO(10851) | console.log: "simple message 1"
[task 2020-02-15T11:02:26.446Z] 11:02:26     INFO - TEST-INFO | started process screentopng
[task 2020-02-15T11:02:26.689Z] 11:02:26     INFO - TEST-INFO | screentopng: exit 0
[task 2020-02-15T11:02:26.689Z] 11:02:26     INFO - Buffered messages logged at 11:00:56
[task 2020-02-15T11:02:26.689Z] 11:02:26     INFO - Entering test bound testContentBlockingMessage
[task 2020-02-15T11:02:26.689Z] 11:02:26     INFO - Adding a new tab with URL: http://example.org/browser/devtools/client/webconsole/test/browser/test-warning-groups.html
[task 2020-02-15T11:02:26.689Z] 11:02:26     INFO - Buffered messages logged at 11:00:57
[task 2020-02-15T11:02:26.689Z] 11:02:26     INFO - Tab added and finished loading
[task 2020-02-15T11:02:26.689Z] 11:02:26     INFO - Opening the toolbox
[task 2020-02-15T11:02:26.689Z] 11:02:26     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome://global/content/elements/panel.js" line: 62}]
[task 2020-02-15T11:02:26.689Z] 11:02:26     INFO - Console message: [JavaScript Error: "Content Security Policy: The page’s settings blocked the loading of a resource at inline (“default-src”)." {file: "chrome://global/content/elements/panel.js" line: 62}]
[task 2020-02-15T11:02:26.703Z] 11:02:26     INFO - Toolbox opened and focused
[task 2020-02-15T11:02:26.704Z] 11:02:26     INFO - Log a tracking protection message to check a single message isn't grouped
[task 2020-02-15T11:02:26.705Z] 11:02:26     INFO - Console message: [JavaScript Warning: "The resource at “http://tracking.example.com/browser/devtools/client/webconsole/test/browser/test-image.png?1-1581764456435” was blocked because content blocking is enabled." {file: "http://example.org/browser/devtools/client/webconsole/test/browser/test-warning-groups.html" line: 0}]
[task 2020-02-15T11:02:26.705Z] 11:02:26     INFO - Matched a message with text: "http://tracking.example.com/browser/devtools/client/webconsole/test/browser/test-image.png", all messages received.
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | The message has the expected style - 
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | The message has the expected indent - 
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - Log a simple message
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - Matched a message with text: "simple message 1", all messages received.
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - Log a second tracking protection message to check that it causes the grouping
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - Console message: [JavaScript Warning: "The resource at “http://tracking.example.com/browser/devtools/client/webconsole/test/browser/test-image.png?2-1581764456435” was blocked because content blocking is enabled." {file: "http://example.org/browser/devtools/client/webconsole/test/browser/test-warning-groups.html" line: 0}]
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - Matched a message with text: "The resource at “<URL>” was blocked because content blocking is enabled.", all messages received.
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | The badge has the expected text - 
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | Got the expected number of messages - 
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - Checking "▶︎⚠ The resource at “<URL>” was blocked because content blocking is enabled."
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | There's a collapsed arrow - 
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | The warningGroup has the expected indent - 
[task 2020-02-15T11:02:26.706Z] 11:02:26     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | The message has the expected indent - 
[task 2020-02-15T11:02:26.707Z] 11:02:26     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | Message includes the expected "The resource at “<URL>” was blocked because content blocking is enabled." content - "The resource at “<URL>” was blocked because content blocking is enabled. 2" - 
[task 2020-02-15T11:02:26.707Z] 11:02:26     INFO - Checking "simple message 1"
[task 2020-02-15T11:02:26.707Z] 11:02:26     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | The message has the expected indent - 
[task 2020-02-15T11:02:26.707Z] 11:02:26     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | Message includes the expected "simple message 1" content - "simple message 1 browser_webconsole_warning_group_multiples.js:303:21" - 
[task 2020-02-15T11:02:26.709Z] 11:02:26     INFO - Console message: [JavaScript Warning: "Request to access cookie or storage on “http://example.com/browser/devtools/client/webconsole/test/browser/test-image.png?3-1581764456435” was blocked because we are blocking all third-party storage access requests and content blocking is enabled."]
[task 2020-02-15T11:02:26.714Z] 11:02:26     INFO - Console message: [JavaScript Warning: "Request to access cookie or storage on “http://example.com/browser/devtools/client/webconsole/test/browser/test-image.png?3-1581764456435” was blocked because we are blocking all third-party storage access requests and content blocking is enabled."]
[task 2020-02-15T11:02:26.715Z] 11:02:26     INFO - Buffered messages logged at 11:01:41
[task 2020-02-15T11:02:26.716Z] 11:02:26     INFO - Longer timeout required, waiting longer...  Remaining timeouts: 1
[task 2020-02-15T11:02:26.717Z] 11:02:26     INFO - Buffered messages finished
[task 2020-02-15T11:02:26.717Z] 11:02:26     INFO - TEST-UNEXPECTED-FAIL | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | Test timed out - 
[task 2020-02-15T11:02:26.718Z] 11:02:26     INFO - Removing tab.
[task 2020-02-15T11:02:26.720Z] 11:02:26     INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2020-02-15T11:02:26.720Z] 11:02:26     INFO - Got event: 'TabClose' on [object XULElement].
[task 2020-02-15T11:02:26.721Z] 11:02:26     INFO - GECKO(10851) | console.warn: "IGNORED REDUX ACTION:" ({type:"AUTOCOMPLETE_CLEAR"})
[task 2020-02-15T11:02:26.721Z] 11:02:26     INFO - Tab removed and finished closing
[task 2020-02-15T11:02:26.721Z] 11:02:26     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | The main process DebuggerServer has no pending connection when the test ends - 
[task 2020-02-15T11:02:26.798Z] 11:02:26     INFO - GECKO(10851) | MEMORY STAT | vsize 4050MB | residentFast 528MB | heapAllocated 160MB
[task 2020-02-15T11:02:26.798Z] 11:02:26     INFO - TEST-OK | devtools/client/webconsole/test/browser/browser_webconsole_warning_group_multiples.js | took 90371ms

This is perma-failing only on mozilla-central on linux1804-64 opt and debug and windows10-64 opt starting with this merge https://hg.mozilla.org/mozilla-central/pushloghtml?changeset=b47e32ff95b8d544ea1e94374e1d5ad8929bba39

Back to Bug 1578594 Comment 30