Closed Bug 1695045 Opened 4 years ago Closed 4 years ago

Intermittent extensions/test/browser/browser_ext_slow_script.js | Uncaught exception - at chrome://*/content/browser/browser/components/extensions/test/browser/browser_ext_slow_script.js:66 - TypeError: can't access property "click", stopButton is null

Categories

(WebExtensions :: Untriaged, defect, P5)

Product:
WebExtensions
Component:
Untriaged
Type:
defect

Tracking

(firefox-esr78 unaffected, firefox86 unaffected, firefox87 unaffected, firefox88 fixed)

Status:
RESOLVED FIXED
Milestone:
88 Branch
Tracking Flags:
Tracking Status
firefox-esr78 --- unaffected
firefox86 --- unaffected
firefox87 --- unaffected
firefox88 --- fixed

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Regression)

Details

(Keywords: intermittent-failure, regression)

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

[task 2021-02-25T20:54:32.586Z] 20:54:32     INFO - TEST-START | browser/components/extensions/test/browser/browser_ext_slow_script.js
[task 2021-02-25T20:54:39.870Z] 20:54:39     INFO - TEST-INFO | started process screentopng
[task 2021-02-25T20:54:40.254Z] 20:54:40     INFO - TEST-INFO | screentopng: exit 0
[task 2021-02-25T20:54:40.255Z] 20:54:40     INFO - Buffered messages logged at 20:54:32
[task 2021-02-25T20:54:40.255Z] 20:54:40     INFO - Entering test bound test_slow_content_script
[task 2021-02-25T20:54:40.255Z] 20:54:40     INFO - Extension loaded
[task 2021-02-25T20:54:40.255Z] 20:54:40     INFO - Console message: Warning: attempting to write 25508 bytes to preference extensions.webextensions.uuids. This is bad for general performance and memory usage. Such an amount of data should rather be written to an external file. This preference will not be sent to any content processes.
[task 2021-02-25T20:54:40.255Z] 20:54:40     INFO - Buffered messages logged at 20:54:39
[task 2021-02-25T20:54:40.255Z] 20:54:40     INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_slow_script.js | Label is correct - 
[task 2021-02-25T20:54:40.256Z] 20:54:40     INFO - Buffered messages finished
[task 2021-02-25T20:54:40.257Z] 20:54:40     INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_slow_script.js | Uncaught exception - at chrome://mochitests/content/browser/browser/components/extensions/test/browser/browser_ext_slow_script.js:66 - TypeError: can't access property "click", stopButton is null
[task 2021-02-25T20:54:40.257Z] 20:54:40     INFO - Stack trace:
[task 2021-02-25T20:54:40.257Z] 20:54:40     INFO - test_slow_content_script@chrome://mochitests/content/browser/browser/components/extensions/test/browser/browser_ext_slow_script.js:66:3
[task 2021-02-25T20:54:40.257Z] 20:54:40     INFO - Leaving test bound test_slow_content_script
[task 2021-02-25T20:54:40.257Z] 20:54:40     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-02-25T20:54:40.258Z] 20:54:40     INFO - TEST-UNEXPECTED-FAIL | browser/components/extensions/test/browser/browser_ext_slow_script.js | Extension left running at test shutdown - 
[task 2021-02-25T20:54:40.258Z] 20:54:40     INFO - Stack trace:
[task 2021-02-25T20:54:40.258Z] 20:54:40     INFO - chrome://mochikit/content/browser-test.js:test_ok:1331
[task 2021-02-25T20:54:40.258Z] 20:54:40     INFO - chrome://mochikit/content/tests/SimpleTest/ExtensionTestUtils.js:ExtensionTestUtils.loadExtension/<:117
[task 2021-02-25T20:54:40.258Z] 20:54:40     INFO - chrome://mochikit/content/browser-test.js:nextTest:571
[task 2021-02-25T20:54:48.102Z] 20:54:48     INFO - Console message: [JavaScript Error: "Timeout while waiting for extension child to shutdown: "Slow Script Extension" (ID: ab306463d06e0c095f77bfd5f4fe7adc7d4a877b@temporary-addon, moz-extension://62269613-e324-443d-8319-551b6a928d3b/)" {file: "resource://gre/modules/Extension.jsm" line: 2754}]
[task 2021-02-25T20:54:48.102Z] 20:54:48     INFO - shutdown@resource://gre/modules/Extension.jsm:2754:10
[task 2021-02-25T20:54:48.102Z] 20:54:48     INFO - 
[task 2021-02-25T20:54:48.102Z] 20:54:48     INFO - Console message: Warning: attempting to write 25410 bytes to preference extensions.webextensions.uuids. This is bad for general performance and memory usage. Such an amount of data should rather be written to an external file. This preference will not be sent to any content processes.
[task 2021-02-25T20:54:48.747Z] 20:54:48     INFO - GECKO(1566) | JavaScript error: resource:///modules/ProcessHangMonitor.jsm, line 573: NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIAddonPolicyService.getExtensionName]
[task 2021-02-25T20:54:48.751Z] 20:54:48     INFO - Console message: [JavaScript Error: "NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIAddonPolicyService.getExtensionName]" {file: "resource:///modules/ProcessHangMonitor.jsm" line: 573}]
[task 2021-02-25T20:54:48.751Z] 20:54:48     INFO - showNotification@resource:///modules/ProcessHangMonitor.jsm:573:27
[task 2021-02-25T20:54:48.751Z] 20:54:48     INFO - updateWindow@resource:///modules/ProcessHangMonitor.jsm:539:12
[task 2021-02-25T20:54:48.751Z] 20:54:48     INFO - updateWindows@resource:///modules/ProcessHangMonitor.jsm:517:12
[task 2021-02-25T20:54:48.751Z] 20:54:48     INFO - reportHang@resource:///modules/ProcessHangMonitor.jsm:748:12
[task 2021-02-25T20:54:48.752Z] 20:54:48     INFO - observe@resource:///modules/ProcessHangMonitor.jsm:292:14
[task 2021-02-25T20:54:48.752Z] 20:54:48     INFO - 
[task 2021-02-25T20:54:51.748Z] 20:54:51     INFO - GECKO(1566) | JavaScript error: resource:///modules/ProcessHangMonitor.jsm, line 573: NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIAddonPolicyService.getExtensionName]
[task 2021-02-25T20:54:51.748Z] 20:54:51     INFO - Console message: [JavaScript Error: "NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIAddonPolicyService.getExtensionName]" {file: "resource:///modules/ProcessHangMonitor.jsm" line: 573}]
[task 2021-02-25T20:54:51.748Z] 20:54:51     INFO - showNotification@resource:///modules/ProcessHangMonitor.jsm:573:27
[task 2021-02-25T20:54:51.748Z] 20:54:51     INFO - updateWindow@resource:///modules/ProcessHangMonitor.jsm:539:12
[task 2021-02-25T20:54:51.748Z] 20:54:51     INFO - updateWindows@resource:///modules/ProcessHangMonitor.jsm:517:12
[task 2021-02-25T20:54:51.748Z] 20:54:51     INFO - reportHang@resource:///modules/ProcessHangMonitor.jsm:748:12
[task 2021-02-25T20:54:51.748Z] 20:54:51     INFO - observe@resource:///modules/ProcessHangMonitor.jsm:292:14
[task 2021-02-25T20:54:51.748Z] 20:54:51     INFO - 
[task 2021-02-25T20:54:54.749Z] 20:54:54     INFO - GECKO(1566) | JavaScript error: resource:///modules/ProcessHangMonitor.jsm, line 573: NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIAddonPolicyService.getExtensionName]
[task 2021-02-25T20:54:54.749Z] 20:54:54     INFO - Console message: [JavaScript Error: "NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIAddonPolicyService.getExtensionName]" {file: "resource:///modules/ProcessHangMonitor.jsm" line: 573}]
[task 2021-02-25T20:54:54.750Z] 20:54:54     INFO - showNotification@resource:///modules/ProcessHangMonitor.jsm:573:27
[task 2021-02-25T20:54:54.750Z] 20:54:54     INFO - updateWindow@resource:///modules/ProcessHangMonitor.jsm:539:12
[task 2021-02-25T20:54:54.750Z] 20:54:54     INFO - updateWindows@resource:///modules/ProcessHangMonitor.jsm:517:12
[task 2021-02-25T20:54:54.750Z] 20:54:54     INFO - reportHang@resource:///modules/ProcessHangMonitor.jsm:748:12
[task 2021-02-25T20:54:54.750Z] 20:54:54     INFO - observe@resource:///modules/ProcessHangMonitor.jsm:292:14
[task 2021-02-25T20:54:54.750Z] 20:54:54     INFO - 
[task 2021-02-25T20:54:57.750Z] 20:54:57     INFO - GECKO(1566) | JavaScript error: resource:///modules/ProcessHangMonitor.jsm, line 573: NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIAddonPolicyService.getExtensionName]
[task 2021-02-25T20:54:57.750Z] 20:54:57     INFO - Console message: [JavaScript Error: "NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIAddonPolicyService.getExtensionName]" {file: "resource:///modules/ProcessHangMonitor.jsm" line: 573}]
[task 2021-02-25T20:54:57.750Z] 20:54:57     INFO - showNotification@resource:///modules/ProcessHangMonitor.jsm:573:27
[task 2021-02-25T20:54:57.750Z] 20:54:57     INFO - updateWindow@resource:///modules/ProcessHangMonitor.jsm:539:12
[task 2021-02-25T20:54:57.750Z] 20:54:57     INFO - updateWindows@resource:///modules/ProcessHangMonitor.jsm:517:12
[task 2021-02-25T20:54:57.750Z] 20:54:57     INFO - reportHang@resource:///modules/ProcessHangMonitor.jsm:748:12
[task 2021-02-25T20:54:57.750Z] 20:54:57     INFO - observe@resource:///modules/ProcessHangMonitor.jsm:292:14
[task 2021-02-25T20:54:57.750Z] 20:54:57     INFO - 
[task 2021-02-25T20:55:00.750Z] 20:55:00     INFO - GECKO(1566) | JavaScript error: resource:///modules/ProcessHangMonitor.jsm, line 573: NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIAddonPolicyService.getExtensionName]
[task 2021-02-25T20:55:00.751Z] 20:55:00     INFO - Console message: [JavaScript Error: "NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIAddonPolicyService.getExtensionName]" {file: "resource:///modules/ProcessHangMonitor.jsm" line: 573}]
[task 2021-02-25T20:55:00.751Z] 20:55:00     INFO - showNotification@resource:///modules/ProcessHangMonitor.jsm:573:27
[task 2021-02-25T20:55:00.751Z] 20:55:00     INFO - updateWindow@resource:///modules/ProcessHangMonitor.jsm:539:12
[task 2021-02-25T20:55:00.751Z] 20:55:00     INFO - updateWindows@resource:///modules/ProcessHangMonitor.jsm:517:12
[task 2021-02-25T20:55:00.751Z] 20:55:00     INFO - reportHang@resource:///modules/ProcessHangMonitor.jsm:748:12
[task 2021-02-25T20:55:00.751Z] 20:55:00     INFO - observe@resource:///modules/ProcessHangMonitor.jsm:292:14
[task 2021-02-25T20:55:00.751Z] 20:55:00     INFO - 
[task 2021-02-25T20:55:03.747Z] 20:55:03     INFO - GECKO(1566) | JavaScript error: resource:///modules/ProcessHangMonitor.jsm, line 573: NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIAddonPolicyService.getExtensionName]
[task 2021-02-25T20:55:03.750Z] 20:55:03     INFO - Console message: [JavaScript Error: "NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIAddonPolicyService.getExtensionName]" {file: "resource:///modules/ProcessHangMonitor.jsm" line: 573}]
[task 2021-02-25T20:55:03.750Z] 20:55:03     INFO - showNotification@resource:///modules/ProcessHangMonitor.jsm:573:27
[task 2021-02-25T20:55:03.751Z] 20:55:03     INFO - updateWindow@resource:///modules/ProcessHangMonitor.jsm:539:12
[task 2021-02-25T20:55:03.751Z] 20:55:03     INFO - updateWindows@resource:///modules/ProcessHangMonitor.jsm:517:12
[task 2021-02-25T20:55:03.751Z] 20:55:03     INFO - reportHang@resource:///modules/ProcessHangMonitor.jsm:748:12
[task 2021-02-25T20:55:03.751Z] 20:55:03     INFO - observe@resource:///modules/ProcessHangMonitor.jsm:292:14
[task 2021-02-25T20:55:03.751Z] 20:55:03     INFO - 
[task 2021-02-25T20:55:06.751Z] 20:55:06     INFO - GECKO(1566) | JavaScript error: resource:///modules/ProcessHangMonitor.jsm, line 573: NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIAddonPolicyService.getExtensionName]
[task 2021-02-25T20:55:06.752Z] 20:55:06     INFO - Console message: [JavaScript Error: "NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIAddonPolicyService.getExtensionName]" {file: "resource:///modules/ProcessHangMonitor.jsm" line: 573}]
[task 2021-02-25T20:55:06.752Z] 20:55:06     INFO - showNotification@resource:///modules/ProcessHangMonitor.jsm:573:27
[task 2021-02-25T20:55:06.752Z] 20:55:06     INFO - updateWindow@resource:///modules/ProcessHangMonitor.jsm:539:12
[task 2021-02-25T20:55:06.752Z] 20:55:06     INFO - updateWindows@resource:///modules/ProcessHangMonitor.jsm:517:12
[task 2021-02-25T20:55:06.752Z] 20:55:06     INFO - reportHang@resource:///modules/ProcessHangMonitor.jsm:748:12
[task 2021-02-25T20:55:06.753Z] 20:55:06     INFO - observe@resource:///modules/ProcessHangMonitor.jsm:292:14
[task 2021-02-25T20:55:06.753Z] 20:55:06     INFO - 
[task 2021-02-25T20:55:09.760Z] 20:55:09     INFO - GECKO(1566) | JavaScript error: resource:///modules/ProcessHangMonitor.jsm, line 573: NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIAddonPolicyService.getExtensionName]
[task 2021-02-25T20:55:09.760Z] 20:55:09     INFO - Console message: [JavaScript Error: "NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIAddonPolicyService.getExtensionName]" {file: "resource:///modules/ProcessHangMonitor.jsm" line: 573}]
[task 2021-02-25T20:55:09.760Z] 20:55:09     INFO - showNotification@resource:///modules/ProcessHangMonitor.jsm:573:27
[task 2021-02-25T20:55:09.760Z] 20:55:09     INFO - updateWindow@resource:///modules/ProcessHangMonitor.jsm:539:12
[task 2021-02-25T20:55:09.760Z] 20:55:09     INFO - updateWindows@resource:///modules/ProcessHangMonitor.jsm:517:12
[task 2021-02-25T20:55:09.760Z] 20:55:09     INFO - reportHang@resource:///modules/ProcessHangMonitor.jsm:748:12
[task 2021-02-25T20:55:09.760Z] 20:55:09     INFO - observe@resource:///modules/ProcessHangMonitor.jsm:292:14
[task 2021-02-25T20:55:09.761Z] 20:55:09     INFO - 
[task 2021-02-25T20:55:12.748Z] 20:55:12     INFO - GECKO(1566) | JavaScript error: resource:///modules/ProcessHangMonitor.jsm, line 573: NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIAddonPolicyService.getExtensionName]
[task 2021-02-25T20:55:12.750Z] 20:55:12     INFO - Console message: [JavaScript Error: "NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIAddonPolicyService.getExtensionName]" {file: "resource:///modules/ProcessHangMonitor.jsm" line: 573}]
[task 2021-02-25T20:55:12.750Z] 20:55:12     INFO - showNotification@resource:///modules/ProcessHangMonitor.jsm:573:27
[task 2021-02-25T20:55:12.750Z] 20:55:12     INFO - updateWindow@resource:///modules/ProcessHangMonitor.jsm:539:12
[task 2021-02-25T20:55:12.750Z] 20:55:12     INFO - updateWindows@resource:///modules/ProcessHangMonitor.jsm:517:12
[task 2021-02-25T20:55:12.751Z] 20:55:12     INFO - reportHang@resource:///modules/ProcessHangMonitor.jsm:748:12
[task 2021-02-25T20:55:12.751Z] 20:55:12     INFO - observe@resource:///modules/ProcessHangMonitor.jsm:292:14
[task 2021-02-25T20:55:12.751Z] 20:55:12     INFO - 
[task 2021-02-25T20:55:15.758Z] 20:55:15     INFO - GECKO(1566) | JavaScript error: resource:///modules/ProcessHangMonitor.jsm, line 573: NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIAddonPolicyService.getExtensionName]
[task 2021-02-25T20:55:15.758Z] 20:55:15     INFO - Console message: [JavaScript Error: "NS_ERROR_ILLEGAL_VALUE: Component returned failure code: 0x80070057 (NS_ERROR_ILLEGAL_VALUE) [nsIAddonPolicyService.getExtensionName]" {file: "resource:///modules/ProcessHangMonitor.jsm" line: 573}]
[task 2021-02-25T20:55:15.758Z] 20:55:15     INFO - showNotification@resource:///modules/ProcessHangMonitor.jsm:573:27
[task 2021-02-25T20:55:15.758Z] 20:55:15     INFO - updateWindow@resource:///modules/ProcessHangMonitor.jsm:539:12
[task 2021-02-25T20:55:15.759Z] 20:55:15     INFO - updateWindows@resource:///modules/ProcessHangMonitor.jsm:517:12
[task 2021-02-25T20:55:15.759Z] 20:55:15     INFO - reportHang@resource:///modules/ProcessHangMonitor.jsm:748:12
[task 2021-02-25T20:55:15.759Z] 20:55:15     INFO - observe@resource:///modules/ProcessHangMonitor.jsm:292:14
[task 2021-02-25T20:55:15.759Z] 20:55:15     INFO - 
[task 2021-02-25T20:55:18.874Z] 20:55:18     INFO - GECKO(1566) | ==================
[task 2021-02-25T20:55:18.874Z] 20:55:18     INFO - GECKO(1566) | WARNING: ThreadSanitizer: data race (pid=1566)
...
...
...

Fixed by backout of bug 1694229.

Status: NEW → RESOLVED
Closed: 4 years ago
status-firefox86: --- → unaffected
status-firefox87: --- → unaffected
status-firefox88: --- → fixed
status-firefox-esr78: --- → unaffected
Regressed by: 1694229
Resolution: --- → FIXED
Target Milestone: --- → 88 Branch
Has Regression Range: --- → yes
Keywords: regression
You need to log in before you can comment on or make changes to this bug.