Open Bug 1725936 Opened 3 years ago Updated 3 years ago

Intermittent devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Error object first line has expected text - Got "waitForClipboard-known-value-0.9468136064727655", expected "Error: error object"

Categories

(DevTools :: Console, defect, P5)

defect

Tracking

(Not tracked)

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Blocks 1 open bug)

Details

(Keywords: intermittent-failure)

Filed by: mlaza [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=348519592&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/MRqFPKobS02bH-c9Uo4kzg/runs/0/artifacts/public/logs/live_backing.log


[task 2021-08-16T08:43:20.606Z] 08:43:20     INFO - TEST-START | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js
[task 2021-08-16T08:43:20.618Z] 08:43:20     INFO - GECKO(7056) | [Child 2332, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-08-16T08:43:20.642Z] 08:43:20     INFO - GECKO(7056) | [Child 2332: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 25fdd2bec00 == 0 [pid = 2332] [id = 0] [url = http://example.com/browser/devtools/client/webconsole/test/browser/test-console-trace-duplicates.html]
[task 2021-08-16T08:43:20.658Z] 08:43:20     INFO - GECKO(7056) | [Child 2332, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-08-16T08:43:20.684Z] 08:43:20     INFO - GECKO(7056) | [Child 2332, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-08-16T08:43:20.688Z] 08:43:20     INFO - GECKO(7056) | [Child 2332: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 2 (25fdd2c8900) [pid = 2332] [serial = 1] [outer = 0] [url = http://example.com/browser/devtools/client/webconsole/test/browser/test-console-trace-duplicates.html]
[task 2021-08-16T08:43:20.689Z] 08:43:20     INFO - GECKO(7056) | [Child 2332: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (25fdd942c00) [pid = 2332] [serial = 2] [outer = 0] [url = about:blank]
[task 2021-08-16T08:43:20.690Z] 08:43:20     INFO - GECKO(7056) | [Child 2332: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (25fdd947c00) [pid = 2332] [serial = 3] [outer = 0] [url = http://example.com/browser/devtools/client/webconsole/test/browser/test-console-trace-duplicates.html]
[task 2021-08-16T08:43:20.691Z] 08:43:20     INFO - GECKO(7056) | [Child 2332, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3357
[task 2021-08-16T08:43:20.692Z] 08:43:20     INFO - GECKO(7056) | [Child 2332, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-08-16T08:43:20.695Z] 08:43:20     INFO - GECKO(7056) | [Child 2332, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-08-16T08:43:20.695Z] 08:43:20     INFO - GECKO(7056) | [Child 2332, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-08-16T08:43:20.696Z] 08:43:20     INFO - GECKO(7056) | [Child 2332, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-08-16T08:43:20.701Z] 08:43:20     INFO - GECKO(7056) | [Child 2332, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4438
[task 2021-08-16T08:43:20.702Z] 08:43:20     INFO - GECKO(7056) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to C:\Users\task_162910169208486\AppData\Local\Temp\tmplpjm0yj0.mozrunner\runtests_leaks_tab_pid1676.log
[task 2021-08-16T08:43:20.703Z] 08:43:20     INFO - GECKO(7056) | [1676, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:248
[task 2021-08-16T08:43:20.715Z] 08:43:20     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: NS_ENSURE_TRUE(LoadIsPending()) failed: file /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpChannel.cpp:5518
[task 2021-08-16T08:43:20.847Z] 08:43:20     INFO - GECKO(7056) | [Child 1676: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 2203adc1c00 == 1 [pid = 1676] [id = 0]
[task 2021-08-16T08:43:20.848Z] 08:43:20     INFO - GECKO(7056) | [Child 1676: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (2203ad2e900) [pid = 1676] [serial = 1] [outer = 0]
[task 2021-08-16T08:43:20.849Z] 08:43:20     INFO - GECKO(7056) | [Child 1676: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (2203b542c00) [pid = 1676] [serial = 2] [outer = 2203ad2e900]
[task 2021-08-16T08:43:20.908Z] 08:43:20     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: NS_ENSURE_TRUE(mSuspendCount > 0) failed: file /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpChannel.cpp:5543
[task 2021-08-16T08:43:20.912Z] 08:43:20     INFO - GECKO(7056) | [Child 1676: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (2203b548400) [pid = 1676] [serial = 3] [outer = 2203ad2e900]
[task 2021-08-16T08:43:20.948Z] 08:43:20     INFO - GECKO(7056) | JavaScript error: http://localhost:50663/test.js, line 11: ReferenceError: z is not defined
[task 2021-08-16T08:43:20.971Z] 08:43:20     INFO - GECKO(7056) | [Parent 8480: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 26754d4a800 == 21 [pid = 8480] [id = 88]
[task 2021-08-16T08:43:20.982Z] 08:43:20     INFO - GECKO(7056) | [Parent 8480: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 70 (2674bc863c0) [pid = 8480] [serial = 216] [outer = 0]
[task 2021-08-16T08:43:20.983Z] 08:43:20     INFO - GECKO(7056) | [Parent 8480: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 71 (26754db0800) [pid = 8480] [serial = 217] [outer = 2674bc863c0]
[task 2021-08-16T08:43:20.996Z] 08:43:20     INFO - GECKO(7056) | [Child 1676, Main Thread] WARNING: Scrolled rect smaller than scrollport?: file /builds/worker/checkouts/gecko/layout/generic/nsGfxScrollFrame.cpp:7072
[task 2021-08-16T08:43:21.006Z] 08:43:21     INFO - GECKO(7056) | [Child 8976: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 1 (173630ba000) [pid = 8976] [serial = 31] [outer = 0] [url = about:blank]
[task 2021-08-16T08:43:21.007Z] 08:43:21     INFO - GECKO(7056) | [Child 8976: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 0 (17364d48c00) [pid = 8976] [serial = 32] [outer = 0] [url = data:text/html,<meta charset=utf8><script>    var bar = () => myFunc();    var rab = () => myFunc();    var myFunc = () => console.trace();    bar();bar();    rab();rab();  </script>]
[task 2021-08-16T08:43:21.020Z] 08:43:21     INFO - GECKO(7056) | [Parent 8480: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 72 (26754dbf000) [pid = 8480] [serial = 218] [outer = 2674bc863c0]
[task 2021-08-16T08:43:21.065Z] 08:43:21     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/dom/base/nsContentUtils.cpp:4002
[task 2021-08-16T08:43:21.231Z] 08:43:21     INFO - GECKO(7056) | [Parent 8480: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 26754db4c00 == 22 [pid = 8480] [id = 89]
[task 2021-08-16T08:43:21.236Z] 08:43:21     INFO - GECKO(7056) | [Parent 8480: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 73 (2675b39be40) [pid = 8480] [serial = 219] [outer = 0]
[task 2021-08-16T08:43:21.237Z] 08:43:21     INFO - GECKO(7056) | [Parent 8480: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 74 (2675da62800) [pid = 8480] [serial = 220] [outer = 2675b39be40]
[task 2021-08-16T08:43:21.247Z] 08:43:21     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/chrome/nsChromeRegistry.cpp:180
[task 2021-08-16T08:43:21.247Z] 08:43:21     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/dom/security/nsCSPService.cpp:191
[task 2021-08-16T08:43:21.448Z] 08:43:21     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/worker/checkouts/gecko/parser/html/nsHtml5StreamParser.cpp:1365
[task 2021-08-16T08:43:21.632Z] 08:43:21     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, nullptr) failed with result 0x804B000A (NS_ERROR_MALFORMED_URI): file /builds/worker/checkouts/gecko/extensions/permissions/Permission.cpp:45
[task 2021-08-16T08:43:21.642Z] 08:43:21     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: NS_ENSURE_TRUE(principal) failed: file /builds/worker/checkouts/gecko/extensions/permissions/Permission.cpp:57
[task 2021-08-16T08:43:22.334Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: Must complete empty transaction when compositing!: file /builds/worker/checkouts/gecko/layout/base/PresShell.cpp:6276
[task 2021-08-16T08:43:22.381Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: Must complete empty transaction when compositing!: file /builds/worker/checkouts/gecko/layout/base/PresShell.cpp:6276
[task 2021-08-16T08:43:22.389Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: Must complete empty transaction when compositing!: file /builds/worker/checkouts/gecko/layout/base/PresShell.cpp:6276
[task 2021-08-16T08:43:22.419Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: Must complete empty transaction when compositing!: file /builds/worker/checkouts/gecko/layout/base/PresShell.cpp:6276
[task 2021-08-16T08:43:22.427Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: Must complete empty transaction when compositing!: file /builds/worker/checkouts/gecko/layout/base/PresShell.cpp:6276
[task 2021-08-16T08:43:22.439Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: NS_ENSURE_TRUE(weakFrame.IsAlive()) failed: file /builds/worker/checkouts/gecko/layout/xul/nsXULPopupManager.cpp:1294
[task 2021-08-16T08:43:22.452Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: Must complete empty transaction when compositing!: file /builds/worker/checkouts/gecko/layout/base/PresShell.cpp:6276
[task 2021-08-16T08:43:22.481Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: NS_ENSURE_TRUE(weakFrame.IsAlive()) failed: file /builds/worker/checkouts/gecko/layout/xul/nsXULPopupManager.cpp:1294
[task 2021-08-16T08:43:22.504Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: Must complete empty transaction when compositing!: file /builds/worker/checkouts/gecko/layout/base/PresShell.cpp:6276
[task 2021-08-16T08:43:22.520Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: Must complete empty transaction when compositing!: file /builds/worker/checkouts/gecko/layout/base/PresShell.cpp:6276
[task 2021-08-16T08:43:22.528Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: NS_ENSURE_TRUE(weakFrame.IsAlive()) failed: file /builds/worker/checkouts/gecko/layout/xul/nsXULPopupManager.cpp:1294
[task 2021-08-16T08:43:22.541Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: Must complete empty transaction when compositing!: file /builds/worker/checkouts/gecko/layout/base/PresShell.cpp:6276
[task 2021-08-16T08:43:22.563Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: NS_ENSURE_TRUE(weakFrame.IsAlive()) failed: file /builds/worker/checkouts/gecko/layout/xul/nsXULPopupManager.cpp:1294
[task 2021-08-16T08:43:22.589Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: Must complete empty transaction when compositing!: file /builds/worker/checkouts/gecko/layout/base/PresShell.cpp:6276
[task 2021-08-16T08:43:22.650Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: Must complete empty transaction when compositing!: file /builds/worker/checkouts/gecko/layout/base/PresShell.cpp:6276
[task 2021-08-16T08:43:22.662Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: NS_ENSURE_TRUE(weakFrame.IsAlive()) failed: file /builds/worker/checkouts/gecko/layout/xul/nsXULPopupManager.cpp:1294
[task 2021-08-16T08:43:22.676Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: Must complete empty transaction when compositing!: file /builds/worker/checkouts/gecko/layout/base/PresShell.cpp:6276
[task 2021-08-16T08:43:22.698Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: NS_ENSURE_TRUE(weakFrame.IsAlive()) failed: file /builds/worker/checkouts/gecko/layout/xul/nsXULPopupManager.cpp:1294
[task 2021-08-16T08:43:22.719Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: Must complete empty transaction when compositing!: file /builds/worker/checkouts/gecko/layout/base/PresShell.cpp:6276
[task 2021-08-16T08:43:22.738Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: NS_ENSURE_TRUE(weakFrame.IsAlive()) failed: file /builds/worker/checkouts/gecko/layout/xul/nsXULPopupManager.cpp:1294
[task 2021-08-16T08:43:22.751Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: Must complete empty transaction when compositing!: file /builds/worker/checkouts/gecko/layout/base/PresShell.cpp:6276
[task 2021-08-16T08:43:22.771Z] 08:43:22     INFO - TEST-INFO | started process screenshot
[task 2021-08-16T08:43:22.834Z] 08:43:22     INFO - TEST-INFO | screenshot: exit 0
[task 2021-08-16T08:43:22.842Z] 08:43:22     INFO - Buffered messages logged at 08:43:20
[task 2021-08-16T08:43:22.842Z] 08:43:22     INFO - Entering test bound 
[task 2021-08-16T08:43:22.843Z] 08:43:22     INFO - Adding a new tab with URL: http://localhost:50663/
[task 2021-08-16T08:43:22.843Z] 08:43:22     INFO - Console message: [JavaScript Error: "ReferenceError: z is not defined" {file: "http://localhost:50663/test.js" line: 11}]
[task 2021-08-16T08:43:22.844Z] 08:43:22     INFO - @http://localhost:50663/test.js:11:5
[task 2021-08-16T08:43:22.844Z] 08:43:22     INFO - 
[task 2021-08-16T08:43:22.844Z] 08:43:22     INFO - Tab added and finished loading
[task 2021-08-16T08:43:22.845Z] 08:43:22     INFO - Opening the toolbox
[task 2021-08-16T08:43:22.845Z] 08:43:22     INFO - Buffered messages logged at 08:43:21
[task 2021-08-16T08:43:22.845Z] 08:43:22     INFO - Console message: Invalid chrome URI (need path): chrome://devtools/
[task 2021-08-16T08:43:22.846Z] 08:43:22     INFO - Console message: [JavaScript Error: "Content Security Policy: The pages settings blocked the loading of a resource at inline (default-src)." {file: "chrome" line: 511}]
[task 2021-08-16T08:43:22.847Z] 08:43:22     INFO - Console message: [JavaScript Error: "Content Security Policy: The pages settings blocked the loading of a resource at inline (default-src)." {file: "chrome" line: 511}]
[task 2021-08-16T08:43:22.848Z] 08:43:22     INFO - Console message: [JavaScript Error: "Content Security Policy: The pages settings blocked the loading of a resource at inline (default-src)." {file: "chrome" line: 75}]
[task 2021-08-16T08:43:22.848Z] 08:43:22     INFO - Console message: [JavaScript Error: "Content Security Policy: The pages settings blocked the loading of a resource at inline (default-src)." {file: "chrome" line: 511}]
[task 2021-08-16T08:43:22.849Z] 08:43:22     INFO - Console message: [JavaScript Error: "Content Security Policy: The pages settings blocked the loading of a resource at inline (default-src)." {file: "chrome" line: 511}]
[task 2021-08-16T08:43:22.849Z] 08:43:22     INFO - Console message: [JavaScript Error: "Content Security Policy: The pages settings blocked the loading of a resource at inline (default-src)." {file: "chrome" line: 75}]
[task 2021-08-16T08:43:22.850Z] 08:43:22     INFO - Buffered messages logged at 08:43:22
[task 2021-08-16T08:43:22.850Z] 08:43:22     INFO - Toolbox opened and focused
[task 2021-08-16T08:43:22.851Z] 08:43:22     INFO - Call the log function defined in the test page
[task 2021-08-16T08:43:22.851Z] 08:43:22     INFO - Test copy menu item with timestamp
[task 2021-08-16T08:43:22.851Z] 08:43:22     INFO - Test copy menu item for the simple log
[task 2021-08-16T08:43:22.852Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | copy menu item is enabled - 
[task 2021-08-16T08:43:22.852Z] 08:43:22     INFO - Initializing clipboard with "waitForClipboard-known-value-0.7156170280718773"...
[task 2021-08-16T08:43:22.853Z] 08:43:22     INFO - Succeeded initializing clipboard, start requested things...
[task 2021-08-16T08:43:22.853Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Clipboard has the given value: '08:43:22.078 simple text message test.js:3:15
[task 2021-08-16T08:43:22.854Z] 08:43:22     INFO - ' - 
[task 2021-08-16T08:43:22.854Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Clipboard text was found and saved - 
[task 2021-08-16T08:43:22.854Z] 08:43:22     INFO - Check copied text for simple log message
[task 2021-08-16T08:43:22.855Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | There are 2 lines in the copied text - 
[task 2021-08-16T08:43:22.855Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | The last line is an empty new line - 
[task 2021-08-16T08:43:22.856Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Line of simple log message has expected text - 
[task 2021-08-16T08:43:22.856Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Log line has the right format:
[task 2021-08-16T08:43:22.857Z] 08:43:22     INFO - 08:43:22.078 simple text message test.js:3:15 - 
[task 2021-08-16T08:43:22.857Z] 08:43:22     INFO - Test copy menu item for the console.trace message
[task 2021-08-16T08:43:22.857Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | copy menu item is enabled - 
[task 2021-08-16T08:43:22.858Z] 08:43:22     INFO - Initializing clipboard with "waitForClipboard-known-value-0.39496476011158177"...
[task 2021-08-16T08:43:22.858Z] 08:43:22     INFO - Succeeded initializing clipboard, start requested things...
[task 2021-08-16T08:43:22.859Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Clipboard has the given value: '08:43:22.082 console.trace() test.js:6:17
[task 2021-08-16T08:43:22.859Z] 08:43:22     INFO -     wrapper http://localhost:50663/test.js:6
[task 2021-08-16T08:43:22.859Z] 08:43:22     INFO -     logStuff http://localhost:50663/test.js:9
[task 2021-08-16T08:43:22.859Z] 08:43:22     INFO - ' - 
[task 2021-08-16T08:43:22.860Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Clipboard text was found and saved - 
[task 2021-08-16T08:43:22.860Z] 08:43:22     INFO - Check copied text for the console.trace message
[task 2021-08-16T08:43:22.861Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | There are 4 lines in the copied text - 
[task 2021-08-16T08:43:22.861Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | The last line is an empty new line - 
[task 2021-08-16T08:43:22.862Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Stacktrace first line has the expected text - 
[task 2021-08-16T08:43:22.862Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Log line has the right format:
[task 2021-08-16T08:43:22.862Z] 08:43:22     INFO - 08:43:22.082 console.trace() test.js:6:17 - 
[task 2021-08-16T08:43:22.863Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Stacktrace first line has the expected text - 
[task 2021-08-16T08:43:22.864Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Stacktrace second line has the expected text - 
[task 2021-08-16T08:43:22.864Z] 08:43:22     INFO - Test copy menu item for the error message
[task 2021-08-16T08:43:22.865Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | copy menu item is enabled - 
[task 2021-08-16T08:43:22.865Z] 08:43:22     INFO - Initializing clipboard with "waitForClipboard-known-value-0.9075374338770947"...
[task 2021-08-16T08:43:22.866Z] 08:43:22     INFO - Succeeded initializing clipboard, start requested things...
[task 2021-08-16T08:43:22.867Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Clipboard has the given value: '08:43:22.080 Error: error object
[task 2021-08-16T08:43:22.867Z] 08:43:22     INFO -     wrapper http://localhost:50663/test.js:5
[task 2021-08-16T08:43:22.867Z] 08:43:22     INFO -     logStuff http://localhost:50663/test.js:9
[task 2021-08-16T08:43:22.867Z] 08:43:22     INFO - test.js:5:17
[task 2021-08-16T08:43:22.868Z] 08:43:22     INFO - ' - 
[task 2021-08-16T08:43:22.868Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Clipboard text was found and saved - 
[task 2021-08-16T08:43:22.869Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Error object first line has expected text - 
[task 2021-08-16T08:43:22.870Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Log line has the right format:
[task 2021-08-16T08:43:22.870Z] 08:43:22     INFO - 08:43:22.080 Error: error object - 
[task 2021-08-16T08:43:22.870Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Error Stacktrace first line has the expected text - 
[task 2021-08-16T08:43:22.871Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Error Stacktrace second line has the expected text - 
[task 2021-08-16T08:43:22.872Z] 08:43:22     INFO - Test copy menu item for the reference error message
[task 2021-08-16T08:43:22.872Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | copy menu item is enabled - 
[task 2021-08-16T08:43:22.873Z] 08:43:22     INFO - Initializing clipboard with "waitForClipboard-known-value-0.719646983383821"...
[task 2021-08-16T08:43:22.873Z] 08:43:22     INFO - Succeeded initializing clipboard, start requested things...
[task 2021-08-16T08:43:22.874Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Clipboard has the given value: '08:43:20.956 Uncaught ReferenceError: z is not defined
[task 2021-08-16T08:43:22.874Z] 08:43:22     INFO -     <anonymous> http://localhost:50663/test.js:11
[task 2021-08-16T08:43:22.874Z] 08:43:22     INFO - test.js:11:5
[task 2021-08-16T08:43:22.874Z] 08:43:22     INFO - ' - 
[task 2021-08-16T08:43:22.875Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Clipboard text was found and saved - 
[task 2021-08-16T08:43:22.876Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | ReferenceError first line has expected text - 
[task 2021-08-16T08:43:22.876Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Log line has the right format:
[task 2021-08-16T08:43:22.876Z] 08:43:22     INFO - 08:43:20.956 Uncaught ReferenceError: z is not defined - 
[task 2021-08-16T08:43:22.877Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | ReferenceError second line has expected text - 
[task 2021-08-16T08:43:22.877Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | There is a Learn More link in the ReferenceError message - 
[task 2021-08-16T08:43:22.878Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | The Learn More text wasn't put in the clipboard - 
[task 2021-08-16T08:43:22.879Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | copy menu item is enabled - 
[task 2021-08-16T08:43:22.879Z] 08:43:22     INFO - Initializing clipboard with "waitForClipboard-known-value-0.5945763357700362"...
[task 2021-08-16T08:43:22.880Z] 08:43:22     INFO - Succeeded initializing clipboard, start requested things...
[task 2021-08-16T08:43:22.881Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Clipboard has the given value: '08:43:22.083 repeated 2 test.js:7:45
[task 2021-08-16T08:43:22.881Z] 08:43:22     INFO - ' - 
[task 2021-08-16T08:43:22.881Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Clipboard text was found and saved - 
[task 2021-08-16T08:43:22.882Z] 08:43:22     INFO - Test copy menu item without timestamp
[task 2021-08-16T08:43:22.883Z] 08:43:22     INFO - Test copy menu item for the simple log
[task 2021-08-16T08:43:22.883Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | copy menu item is enabled - 
[task 2021-08-16T08:43:22.884Z] 08:43:22     INFO - Initializing clipboard with "waitForClipboard-known-value-0.5454904117410493"...
[task 2021-08-16T08:43:22.884Z] 08:43:22     INFO - Succeeded initializing clipboard, start requested things...
[task 2021-08-16T08:43:22.885Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Clipboard has the given value: 'simple text message test.js:3:15
[task 2021-08-16T08:43:22.885Z] 08:43:22     INFO - ' - 
[task 2021-08-16T08:43:22.886Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Clipboard text was found and saved - 
[task 2021-08-16T08:43:22.886Z] 08:43:22     INFO - Check copied text for simple log message
[task 2021-08-16T08:43:22.887Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | There are 2 lines in the copied text - 
[task 2021-08-16T08:43:22.888Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | The last line is an empty new line - 
[task 2021-08-16T08:43:22.889Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Line of simple log message has expected text - 
[task 2021-08-16T08:43:22.889Z] 08:43:22     INFO - Test copy menu item for the console.trace message
[task 2021-08-16T08:43:22.890Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | copy menu item is enabled - 
[task 2021-08-16T08:43:22.890Z] 08:43:22     INFO - Initializing clipboard with "waitForClipboard-known-value-0.2660779153530646"...
[task 2021-08-16T08:43:22.891Z] 08:43:22     INFO - Succeeded initializing clipboard, start requested things...
[task 2021-08-16T08:43:22.892Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Clipboard has the given value: 'console.trace() test.js:6:17
[task 2021-08-16T08:43:22.892Z] 08:43:22     INFO -     wrapper http://localhost:50663/test.js:6
[task 2021-08-16T08:43:22.892Z] 08:43:22     INFO -     logStuff http://localhost:50663/test.js:9
[task 2021-08-16T08:43:22.892Z] 08:43:22     INFO - ' - 
[task 2021-08-16T08:43:22.893Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Clipboard text was found and saved - 
[task 2021-08-16T08:43:22.893Z] 08:43:22     INFO - Check copied text for the console.trace message
[task 2021-08-16T08:43:22.894Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | There are 4 lines in the copied text - 
[task 2021-08-16T08:43:22.894Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | The last line is an empty new line - 
[task 2021-08-16T08:43:22.895Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Stacktrace first line has the expected text - 
[task 2021-08-16T08:43:22.896Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Stacktrace first line has the expected text - 
[task 2021-08-16T08:43:22.896Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Stacktrace second line has the expected text - 
[task 2021-08-16T08:43:22.897Z] 08:43:22     INFO - Test copy menu item for the error message
[task 2021-08-16T08:43:22.898Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | copy menu item is enabled - 
[task 2021-08-16T08:43:22.898Z] 08:43:22     INFO - Initializing clipboard with "waitForClipboard-known-value-0.9468136064727655"...
[task 2021-08-16T08:43:22.899Z] 08:43:22     INFO - Succeeded initializing clipboard, start requested things...
[task 2021-08-16T08:43:22.899Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Clipboard has the given value: 'waitForClipboard-known-value-0.9468136064727655' - 
[task 2021-08-16T08:43:22.900Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Clipboard text was found and saved - 
[task 2021-08-16T08:43:22.900Z] 08:43:22     INFO - Buffered messages finished
[task 2021-08-16T08:43:22.902Z] 08:43:22     INFO - TEST-UNEXPECTED-FAIL | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Error object first line has expected text - Got "waitForClipboard-known-value-0.9468136064727655", expected "Error: error object"
[task 2021-08-16T08:43:22.902Z] 08:43:22     INFO - Stack trace:
[task 2021-08-16T08:43:22.902Z] 08:43:22     INFO - chrome://mochikit/content/browser-test.js:test_is:1364
[task 2021-08-16T08:43:22.902Z] 08:43:22     INFO - chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js:testMessagesCopy:134
[task 2021-08-16T08:43:22.902Z] 08:43:22     INFO - chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js:null:63
[task 2021-08-16T08:43:22.902Z] 08:43:22     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest/<:1091
[task 2021-08-16T08:43:22.902Z] 08:43:22     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1131
[task 2021-08-16T08:43:22.902Z] 08:43:22     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:939
[task 2021-08-16T08:43:22.902Z] 08:43:22     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1041
[task 2021-08-16T08:43:22.903Z] 08:43:22     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-08-16T08:43:22.904Z] 08:43:22     INFO - TEST-UNEXPECTED-FAIL | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Error Stacktrace first line has the expected text - Got undefined, expected "    wrapper http://localhost:50663/test.js:5"
[task 2021-08-16T08:43:22.904Z] 08:43:22     INFO - Stack trace:
[task 2021-08-16T08:43:22.904Z] 08:43:22     INFO - chrome://mochikit/content/browser-test.js:test_is:1364
[task 2021-08-16T08:43:22.905Z] 08:43:22     INFO - chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js:testMessagesCopy:145
[task 2021-08-16T08:43:22.905Z] 08:43:22     INFO - chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js:null:63
[task 2021-08-16T08:43:22.905Z] 08:43:22     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest/<:1091
[task 2021-08-16T08:43:22.905Z] 08:43:22     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1131
[task 2021-08-16T08:43:22.905Z] 08:43:22     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:939
[task 2021-08-16T08:43:22.905Z] 08:43:22     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1041
[task 2021-08-16T08:43:22.905Z] 08:43:22     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-08-16T08:43:22.907Z] 08:43:22     INFO - TEST-UNEXPECTED-FAIL | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Error Stacktrace second line has the expected text - Got undefined, expected "    logStuff http://localhost:50663/test.js:9"
[task 2021-08-16T08:43:22.907Z] 08:43:22     INFO - Stack trace:
[task 2021-08-16T08:43:22.907Z] 08:43:22     INFO - chrome://mochikit/content/browser-test.js:test_is:1364
[task 2021-08-16T08:43:22.907Z] 08:43:22     INFO - chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js:testMessagesCopy:150
[task 2021-08-16T08:43:22.907Z] 08:43:22     INFO - chrome://mochitests/content/browser/devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js:null:63
[task 2021-08-16T08:43:22.907Z] 08:43:22     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest/<:1091
[task 2021-08-16T08:43:22.907Z] 08:43:22     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1131
[task 2021-08-16T08:43:22.907Z] 08:43:22     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:939
[task 2021-08-16T08:43:22.907Z] 08:43:22     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1041
[task 2021-08-16T08:43:22.908Z] 08:43:22     INFO - Test copy menu item for the reference error message
[task 2021-08-16T08:43:22.908Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: NS_ENSURE_TRUE(weakFrame.IsAlive()) failed: file /builds/worker/checkouts/gecko/layout/xul/nsXULPopupManager.cpp:1294
[task 2021-08-16T08:43:22.909Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: Must complete empty transaction when compositing!: file /builds/worker/checkouts/gecko/layout/base/PresShell.cpp:6276
[task 2021-08-16T08:43:22.909Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | copy menu item is enabled - 
[task 2021-08-16T08:43:22.910Z] 08:43:22     INFO - Initializing clipboard with "waitForClipboard-known-value-0.25983631489014336"...
[task 2021-08-16T08:43:22.910Z] 08:43:22     INFO - Succeeded initializing clipboard, start requested things...
[task 2021-08-16T08:43:22.911Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Clipboard has the given value: 'Uncaught ReferenceError: z is not defined
[task 2021-08-16T08:43:22.911Z] 08:43:22     INFO -     <anonymous> http://localhost:50663/test.js:11
[task 2021-08-16T08:43:22.911Z] 08:43:22     INFO - test.js:11:5
[task 2021-08-16T08:43:22.911Z] 08:43:22     INFO - ' - 
[task 2021-08-16T08:43:22.912Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Clipboard text was found and saved - 
[task 2021-08-16T08:43:22.912Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | ReferenceError first line has expected text - 
[task 2021-08-16T08:43:22.913Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | ReferenceError second line has expected text - 
[task 2021-08-16T08:43:22.914Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | There is a Learn More link in the ReferenceError message - 
[task 2021-08-16T08:43:22.914Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | The Learn More text wasn't put in the clipboard - 
[task 2021-08-16T08:43:22.915Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: NS_ENSURE_TRUE(weakFrame.IsAlive()) failed: file /builds/worker/checkouts/gecko/layout/xul/nsXULPopupManager.cpp:1294
[task 2021-08-16T08:43:22.915Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: Must complete empty transaction when compositing!: file /builds/worker/checkouts/gecko/layout/base/PresShell.cpp:6276
[task 2021-08-16T08:43:22.916Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | copy menu item is enabled - 
[task 2021-08-16T08:43:22.917Z] 08:43:22     INFO - Initializing clipboard with "waitForClipboard-known-value-0.4927644424800327"...
[task 2021-08-16T08:43:22.917Z] 08:43:22     INFO - Succeeded initializing clipboard, start requested things...
[task 2021-08-16T08:43:22.917Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Clipboard has the given value: 'repeated 2 test.js:7:45
[task 2021-08-16T08:43:22.917Z] 08:43:22     INFO - ' - 
[task 2021-08-16T08:43:22.918Z] 08:43:22     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | Clipboard text was found and saved - 
[task 2021-08-16T08:43:22.918Z] 08:43:22     INFO - Leaving test bound 
[task 2021-08-16T08:43:22.919Z] 08:43:22     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: NS_ENSURE_TRUE(mPresShell) failed: file /builds/worker/checkouts/gecko/layout/generic/nsFrameSelection.cpp:1582
[task 2021-08-16T08:43:23.253Z] 08:43:23     INFO - GECKO(7056) | [Child 1872: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 3 (171e081eac0) [pid = 1872] [serial = 42] [outer = 0] [url = about:blank]
[task 2021-08-16T08:43:25.988Z] 08:43:25     INFO - GECKO(7056) | [Parent 8480: Main Thread]: I/DocShellAndDOMWindowLeak --DOMWINDOW == 73 (267547e9c00) [pid = 8480] [serial = 212] [outer = 0] [url = about:blank]
[task 2021-08-16T08:43:25.996Z] 08:43:25     INFO - GECKO(7056) | [Parent 8480: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 26752e55c00 == 21 [pid = 8480] [id = 86] [url = about:devtools-toolbox]
[task 2021-08-16T08:43:26.130Z] 08:43:26     INFO - Removing tab.
[task 2021-08-16T08:43:26.137Z] 08:43:26     INFO - Waiting for event: 'TabClose' on [object XULElement].
[task 2021-08-16T08:43:26.144Z] 08:43:26     INFO - Got event: 'TabClose' on [object XULElement].
[task 2021-08-16T08:43:26.146Z] 08:43:26     INFO - GECKO(7056) | console.warn: "IGNORED REDUX ACTION:" "AUTOCOMPLETE_CLEAR"
[task 2021-08-16T08:43:26.155Z] 08:43:26     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: '!inner', file /builds/worker/checkouts/gecko/dom/ipc/jsactor/JSWindowActorProtocol.cpp:184
[task 2021-08-16T08:43:26.157Z] 08:43:26     INFO - GECKO(7056) | [Parent 8480, Main Thread] WARNING: NS_ENSURE_TRUE(weakFrame.IsAlive()) failed: file /builds/worker/checkouts/gecko/layout/xul/nsXULPopupManager.cpp:1294
[task 2021-08-16T08:43:26.160Z] 08:43:26     INFO - Tab removed and finished closing
[task 2021-08-16T08:43:26.212Z] 08:43:26     INFO - TEST-PASS | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | The main process DevToolsServer has no pending connection when the test ends - 
[task 2021-08-16T08:43:26.222Z] 08:43:26     INFO - GECKO(7056) | [Child 1676, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-08-16T08:43:26.243Z] 08:43:26     INFO - GECKO(7056) | MEMORY STAT | vsize 2104523MB | vsizeMaxContiguous 64966164MB | residentFast 589MB | heapAllocated 287MB
[task 2021-08-16T08:43:26.246Z] 08:43:26     INFO - TEST-OK | devtools/client/webconsole/test/browser/browser_webconsole_context_menu_copy_entire_message.js | took 5638ms
[task 2021-08-16T08:43:26.255Z] 08:43:26     INFO - GECKO(7056) | [Child 1676, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-08-16T08:43:26.255Z] 08:43:26     INFO - GECKO(7056) | [Child 1676, Main Thread] WARNING: IPC message discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:527
[task 2021-08-16T08:43:26.256Z] 08:43:26     INFO - GECKO(7056) | [Child 2372: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 18c31daa400 == 2 [pid = 2372] [id = 19]
[task 2021-08-16T08:43:26.256Z] 08:43:26     INFO - GECKO(7056) | [Child 2372: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (18c38c88040) [pid = 2372] [serial = 44] [outer = 0]
[task 2021-08-16T08:43:26.257Z] 08:43:26     INFO - GECKO(7056) | [Child 2372: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 4 (18c31db9800) [pid = 2372] [serial = 45] [outer = 18c38c88040]
[task 2021-08-16T08:43:26.274Z] 08:43:26     INFO - checking window state
You need to log in before you can comment on or make changes to this bug.