Closed Bug 1724711 Opened 3 years ago Closed 2 years ago

Intermittent browser/base/content/test/general/browser_middleMouse_noJSPaste.js | Test timed out -

Categories

(Core :: Panning and Zooming, defect, P5)

defect

Tracking

()

RESOLVED DUPLICATE of bug 1775724

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure, Whiteboard: [stockwell disabled])

Attachments

(1 file)

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


[task 2021-08-09T12:21:48.945Z] 12:21:48     INFO - TEST-START | browser/base/content/test/general/browser_middleMouse_noJSPaste.js
[task 2021-08-09T12:21:48.960Z] 12:21:48     INFO - GECKO(993) | JavaScript error: resource://gre/actors/AutoScrollChild.jsm, line 73: TypeError: node.closest is not a function
[task 2021-08-09T12:22:34.024Z] 12:22:34     INFO - TEST-INFO | started process screencapture
[task 2021-08-09T12:22:34.164Z] 12:22:34     INFO - TEST-INFO | screencapture: exit 0
[task 2021-08-09T12:22:34.165Z] 12:22:34     INFO - Buffered messages logged at 12:21:48
[task 2021-08-09T12:22:34.165Z] 12:22:34     INFO - Entering test bound 
[task 2021-08-09T12:22:34.165Z] 12:22:34     INFO - Initializing clipboard with "waitForClipboard-known-value-0.38891950296328703"...
[task 2021-08-09T12:22:34.165Z] 12:22:34     INFO - Succeeded initializing clipboard, start requested things...
[task 2021-08-09T12:22:34.165Z] 12:22:34     INFO - TEST-PASS | browser/base/content/test/general/browser_middleMouse_noJSPaste.js | Clipboard has the given value: 'javascript:http://www.example.com/' - 
[task 2021-08-09T12:22:34.165Z] 12:22:34     INFO - Middle clicking
[task 2021-08-09T12:22:34.166Z] 12:22:34     INFO - Console message: [JavaScript Error: "TypeError: node.closest is not a function" {file: "resource://gre/actors/AutoScrollChild.jsm" line: 73}]
[task 2021-08-09T12:22:34.166Z] 12:22:34     INFO - isAutoscrollBlocker@resource://gre/actors/AutoScrollChild.jsm:73:12
[task 2021-08-09T12:22:34.166Z] 12:22:34     INFO - handleEvent@resource://gre/actors/AutoScrollChild.jsm:380:17
[task 2021-08-09T12:22:34.166Z] 12:22:34     INFO - synthesizeMouseAtPoint@chrome://mochikit/content/tests/SimpleTest/EventUtils.js:644:13
[task 2021-08-09T12:22:34.166Z] 12:22:34     INFO - synthesizeMouse/<@resource://testing-common/BrowserTestUtilsChild.jsm:334:34
[task 2021-08-09T12:22:34.166Z] 12:22:34     INFO - wrapHandlingUserInput@resource://gre/modules/E10SUtils.jsm:924:7
[task 2021-08-09T12:22:34.166Z] 12:22:34     INFO - synthesizeMouse@resource://testing-common/BrowserTestUtilsChild.jsm:330:15
[task 2021-08-09T12:22:34.166Z] 12:22:34     INFO - receiveMessage@resource://testing-common/BrowserTestUtilsChild.jsm:149:21
[task 2021-08-09T12:22:34.166Z] 12:22:34     INFO - 
[task 2021-08-09T12:22:34.166Z] 12:22:34     INFO - Buffered messages finished
[task 2021-08-09T12:22:34.166Z] 12:22:34     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/general/browser_middleMouse_noJSPaste.js | Test timed out - 
[task 2021-08-09T12:22:34.166Z] 12:22:34     INFO - GECKO(993) | MEMORY STAT | vsize 410954MB | residentFast 617MB | heapAllocated 144MB
[task 2021-08-09T12:22:34.166Z] 12:22:34     INFO - TEST-OK | browser/base/content/test/general/browser_middleMouse_noJSPaste.js | took 45086ms
[task 2021-08-09T12:22:34.166Z] 12:22:34     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-08-09T12:22:34.166Z] 12:22:34     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/general/browser_middleMouse_noJSPaste.js | Found a tab after previous test timed out: about:blank - 
[task 2021-08-09T12:22:34.167Z] 12:22:34     INFO - checking window state
[task 2021-08-09T12:22:34.167Z] 12:22:34     INFO - TEST-START | browser/base/content/test/general/browser_minimize.js
[task 2021-08-09T12:22:34.167Z] 12:22:34     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-08-09T12:22:34.167Z] 12:22:34     INFO - Buffered messages logged at 12:22:34
[task 2021-08-09T12:22:34.167Z] 12:22:34     INFO - Entering test bound 
[task 2021-08-09T12:22:34.167Z] 12:22:34     INFO - Buffered messages finished
[task 2021-08-09T12:22:34.167Z] 12:22:34     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/general/browser_minimize.js | Docshell should be active when starting the test - 
[task 2021-08-09T12:22:34.167Z] 12:22:34     INFO - Stack trace:
[task 2021-08-09T12:22:34.167Z] 12:22:34     INFO - chrome://mochikit/content/browser-test.js:test_ok:1343
[task 2021-08-09T12:22:34.167Z] 12:22:34     INFO - chrome://mochitests/content/browser/browser/base/content/test/general/browser_minimize.js:null:12
[task 2021-08-09T12:22:34.167Z] 12:22:34     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest/<:1098
[task 2021-08-09T12:22:34.167Z] 12:22:34     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1138
[task 2021-08-09T12:22:34.167Z] 12:22:34     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:946
[task 2021-08-09T12:22:34.167Z] 12:22:34     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1041
[task 2021-08-09T12:22:34.168Z] 12:22:34     INFO - Calling window.minimize
[task 2021-08-09T12:22:34.659Z] 12:22:34     INFO - TEST-PASS | browser/base/content/test/general/browser_minimize.js | Docshell should be Inactive - 
[task 2021-08-09T12:22:34.660Z] 12:22:34     INFO - Calling window.restore
[task 2021-08-09T12:22:35.219Z] 12:22:35     INFO - TEST-PASS | browser/base/content/test/general/browser_minimize.js | Docshell should be active again - 
[task 2021-08-09T12:22:35.219Z] 12:22:35     INFO - Leaving test bound 
[task 2021-08-09T12:22:35.222Z] 12:22:35     INFO - GECKO(993) | MEMORY STAT | vsize 410934MB | residentFast 617MB | heapAllocated 146MB
[task 2021-08-09T12:22:35.223Z] 12:22:35     INFO - TEST-OK | browser/base/content/test/general/browser_minimize.js | took 1159ms
[task 2021-08-09T12:22:35.232Z] 12:22:35     INFO - checking window state
[task 2021-08-09T12:22:35.238Z] 12:22:35     INFO - TEST-START | browser/base/content/test/general/browser_modifiedclick_inherit_principal.js

There are 37 total failures in the last 7 days on macosx1100-64-shippable-qr opt
Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=369856349&repo=autoland&lineNumber=2801

[task 2022-03-03T20:03:01.838Z] 20:03:01     INFO - TEST-START | browser/base/content/test/general/browser_middleMouse_noJSPaste.js
[task 2022-03-03T20:03:01.853Z] 20:03:01     INFO - GECKO(1134) | JavaScript error: resource://gre/actors/AutoScrollChild.jsm, line 73: TypeError: node.closest is not a function
[task 2022-03-03T20:03:46.917Z] 20:03:46     INFO - TEST-INFO | started process screencapture
[task 2022-03-03T20:03:47.060Z] 20:03:47     INFO - TEST-INFO | screencapture: exit 0
[task 2022-03-03T20:03:47.060Z] 20:03:47     INFO - Buffered messages logged at 20:03:01
[task 2022-03-03T20:03:47.061Z] 20:03:47     INFO - Entering test bound 
[task 2022-03-03T20:03:47.061Z] 20:03:47     INFO - Initializing clipboard with "waitForClipboard-known-value-0.8853507112420669"...
[task 2022-03-03T20:03:47.061Z] 20:03:47     INFO - Succeeded initializing clipboard, start requested things...
[task 2022-03-03T20:03:47.061Z] 20:03:47     INFO - TEST-PASS | browser/base/content/test/general/browser_middleMouse_noJSPaste.js | Clipboard has the given value: 'javascript:http://www.example.com/' - 
[task 2022-03-03T20:03:47.061Z] 20:03:47     INFO - Middle clicking
[task 2022-03-03T20:03:47.061Z] 20:03:47     INFO - Console message: [JavaScript Error: "TypeError: node.closest is not a function" {file: "resource://gre/actors/AutoScrollChild.jsm" line: 73}]
[task 2022-03-03T20:03:47.061Z] 20:03:47     INFO - isAutoscrollBlocker@resource://gre/actors/AutoScrollChild.jsm:73:12
[task 2022-03-03T20:03:47.061Z] 20:03:47     INFO - handleEvent@resource://gre/actors/AutoScrollChild.jsm:380:17
[task 2022-03-03T20:03:47.061Z] 20:03:47     INFO - synthesizeMouseAtPoint@chrome://mochikit/content/tests/SimpleTest/EventUtils.js:644:13
[task 2022-03-03T20:03:47.061Z] 20:03:47     INFO - synthesizeMouse/<@resource://testing-common/BrowserTestUtilsChild.jsm:334:34
[task 2022-03-03T20:03:47.062Z] 20:03:47     INFO - wrapHandlingUserInput@resource://gre/modules/E10SUtils.jsm:870:7
[task 2022-03-03T20:03:47.062Z] 20:03:47     INFO - synthesizeMouse@resource://testing-common/BrowserTestUtilsChild.jsm:330:15
[task 2022-03-03T20:03:47.062Z] 20:03:47     INFO - receiveMessage@resource://testing-common/BrowserTestUtilsChild.jsm:149:21
[task 2022-03-03T20:03:47.062Z] 20:03:47     INFO - 
[task 2022-03-03T20:03:47.062Z] 20:03:47     INFO - Buffered messages finished
[task 2022-03-03T20:03:47.062Z] 20:03:47     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/general/browser_middleMouse_noJSPaste.js | Test timed out - 
[task 2022-03-03T20:03:47.062Z] 20:03:47     INFO - GECKO(1134) | MEMORY STAT | vsize 410949MB | residentFast 622MB | heapAllocated 151MB
[task 2022-03-03T20:03:47.062Z] 20:03:47     INFO - TEST-OK | browser/base/content/test/general/browser_middleMouse_noJSPaste.js | took 45084ms
[task 2022-03-03T20:03:47.062Z] 20:03:47     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-03-03T20:03:47.062Z] 20:03:47     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/general/browser_middleMouse_noJSPaste.js | Found a tab after previous test timed out: about:blank - 
[task 2022-03-03T20:03:47.062Z] 20:03:47     INFO - checking window state
[task 2022-03-03T20:03:47.063Z] 20:03:47     INFO - TEST-START | browser/base/content/test/general/browser_minimize.js
[task 2022-03-03T20:03:47.063Z] 20:03:47     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-03-03T20:03:47.063Z] 20:03:47     INFO - Buffered messages logged at 20:03:46
[task 2022-03-03T20:03:47.063Z] 20:03:47     INFO - Entering test bound 
[task 2022-03-03T20:03:47.063Z] 20:03:47     INFO - Buffered messages finished
[task 2022-03-03T20:03:47.063Z] 20:03:47     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/general/browser_minimize.js | Docshell should be active when starting the test - 
[task 2022-03-03T20:03:47.063Z] 20:03:47     INFO - Stack trace:
[task 2022-03-03T20:03:47.063Z] 20:03:47     INFO - chrome://mochikit/content/browser-test.js:test_ok:1394
[task 2022-03-03T20:03:47.063Z] 20:03:47     INFO - chrome://mochitests/content/browser/browser/base/content/test/general/browser_minimize.js:null:12
[task 2022-03-03T20:03:47.063Z] 20:03:47     INFO - chrome://mochikit/content/browser-test.js:handleTask:989
[task 2022-03-03T20:03:47.063Z] 20:03:47     INFO - chrome://mochikit/content/browser-test.js:_runTaskBasedTest:1061
[task 2022-03-03T20:03:47.063Z] 20:03:47     INFO - chrome://mochikit/content/browser-test.js:Tester_execTest:1189
[task 2022-03-03T20:03:47.063Z] 20:03:47     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:978
[task 2022-03-03T20:03:47.063Z] 20:03:47     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1041
[task 2022-03-03T20:03:47.063Z] 20:03:47     INFO - Calling window.minimize
[task 2022-03-03T20:03:47.550Z] 20:03:47     INFO - TEST-PASS | browser/base/content/test/general/browser_minimize.js | Docshell should be Inactive - 
[task 2022-03-03T20:03:47.550Z] 20:03:47     INFO - Calling window.restore
[task 2022-03-03T20:03:48.115Z] 20:03:48     INFO - TEST-PASS | browser/base/content/test/general/browser_minimize.js | Docshell should be active again - 
[task 2022-03-03T20:03:48.115Z] 20:03:48     INFO - Leaving test bound 
[task 2022-03-03T20:03:48.117Z] 20:03:48     INFO - GECKO(1134) | MEMORY STAT | vsize 410952MB | residentFast 623MB | heapAllocated 152MB
[task 2022-03-03T20:03:48.118Z] 20:03:48     INFO - TEST-OK | browser/base/content/test/general/browser_minimize.js | took 1161ms
[task 2022-03-03T20:03:48.128Z] 20:03:48     INFO - checking window state
[task 2022-03-03T20:03:48.131Z] 20:03:48     INFO - TEST-START | browser/base/content/test/general/browser_modifiedclick_inherit_principal.js
[task 2022-03-03T20:03:48.155Z] 20:03:48     INFO - GECKO(1134) | JavaScript error: chrome://browser/content/places/browserPlacesViews.js, line 137: Error: No DOM node set for aPlacesNode.
[task 2022-03-03T20:03:48.155Z] 20:03:48     INFO - GECKO(1134) | node.type: 0. node.parent: [xpconnect wrapped nsINavHistoryResultNode]
[task 2022-03-03T20:03:48.924Z] 20:03:48     INFO - GECKO(1134) | MEMORY STAT | vsize 410953MB | residentFast 623MB | heapAllocated 154MB
[task 2022-03-03T20:03:48.924Z] 20:03:48     INFO - TEST-OK | browser/base/content/test/general/browser_modifiedclick_inherit_principal.js | took 793ms
[task 2022-03-03T20:03:48.932Z] 20:03:48     INFO - checking window state
[task 2022-03-03T20:03:48.939Z] 20:03:48     INFO - TEST-START | browser/base/content/test/general/browser_newTabDrop.js
[task 2022-03-03T20:03:49.175Z] 20:03:49     INFO - GECKO(1134) | Assertion failure
[task 2022-03-03T20:03:49.175Z] 20:03:49     INFO - GECKO(1134) | assert@resource:///modules/AsyncTabSwitcher.jsm:499:36
[task 2022-03-03T20:03:49.175Z] 20:03:49     INFO - GECKO(1134) | onLayersCleared@resource:///modules/AsyncTabSwitcher.jsm:811:12
[task 2022-03-03T20:03:49.175Z] 20:03:49     INFO - GECKO(1134) | handleEvent@resource:///modules/AsyncTabSwitcher.jsm:1099:16
[task 2022-03-03T20:03:49.286Z] 20:03:49     INFO - GECKO(1134) | Assertion failure
[task 2022-03-03T20:03:49.287Z] 20:03:49     INFO - GECKO(1134) | assert@resource:///modules/AsyncTabSwitcher.jsm:499:36
[task 2022-03-03T20:03:49.287Z] 20:03:49     INFO - GECKO(1134) | onLayersCleared@resource:///modules/AsyncTabSwitcher.jsm:811:12
[task 2022-03-03T20:03:49.287Z] 20:03:49     INFO - GECKO(1134) | handleEvent@resource:///modules/AsyncTabSwitcher.jsm:1099:16
[task 2022-03-03T20:03:49.867Z] 20:03:49     INFO - GECKO(1134) | Assertion failure
[task 2022-03-03T20:03:49.867Z] 20:03:49     INFO - GECKO(1134) | assert@resource:///modules/AsyncTabSwitcher.jsm:499:36
[task 2022-03-03T20:03:49.867Z] 20:03:49     INFO - GECKO(1134) | onLayersCleared@resource:///modules/AsyncTabSwitcher.jsm:811:12
[task 2022-03-03T20:03:49.868Z] 20:03:49     INFO - GECKO(1134) | handleEvent@resource:///modules/AsyncTabSwitcher.jsm:1099:16
[task 2022-03-03T20:03:50.717Z] 20:03:50     INFO - GECKO(1134) | JavaScript error: chrome://browser/content/places/browserPlacesViews.js, line 137: Error: No DOM node set for aPlacesNode.
[task 2022-03-03T20:03:50.717Z] 20:03:50     INFO - GECKO(1134) | node.type: 0. node.parent: [xpconnect wrapped nsINavHistoryResultNode]
[task 2022-03-03T20:03:50.757Z] 20:03:50     INFO - GECKO(1134) | MEMORY STAT | vsize 419149MB | residentFast 627MB | heapAllocated 174MB
[task 2022-03-03T20:03:50.757Z] 20:03:50     INFO - TEST-OK | browser/base/content/test/general/browser_newTabDrop.js | took 1818ms
[task 2022-03-03T20:03:50.762Z] 20:03:50     INFO - checking window state

Dave, can you please take a look or assign this to someone who can?
Thank you!

Flags: needinfo?(dtownsend)
Whiteboard: [stockwell needswork:owner]
Assignee: nobody → ctuns
Status: NEW → ASSIGNED
Assignee: ctuns → nobody
Status: ASSIGNED → NEW
Keywords: leave-open
Whiteboard: [stockwell needswork:owner] → [stockwell needswork:owner] [stockwell disabled]
Pushed by ctuns@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/0710ea95edca
disable browser_middleMouse_noJSPaste on macos r=intermittent-reviewers,jmaher DONTBUILD

Sorry Neil, looks like you touched this last could you take a look or recommend an alternate?

Flags: needinfo?(dtownsend) → needinfo?(enndeakin)
Whiteboard: [stockwell disabled][stockwell unknown] → [stockwell disabled]

[task 2021-08-09T12:22:34.166Z] 12:22:34 INFO - Console message: [JavaScript Error: "TypeError: node.closest is not a function" {file: "resource://gre/actors/AutoScrollChild.jsm" line: 73}]

^-- this seems to be a relevant error in the log. Since this is AutoScrollChild.jsm, we're going to move this over to Core :: Panning and Zooming.

Component: General → Panning and Zooming
Product: Firefox → Core
Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → DUPLICATE
Flags: needinfo?(enndeakin)
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Creator:
Created:
Updated:
Size: