1692349 - Intermittent browser/components/extensions/test/xpcshell/test_ext_menu_caller.js | test_create_menu_ext_error - [test_create_menu_ext_error : 53] Frame function name - null == "background/<"

Status: RESOLVED FIXED

(WebExtensions :: General, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2021-02-11T23:19:42.934Z] 23:19:42     INFO -  TEST-START | xpcshell.ini:browser/components/extensions/test/xpcshell/test_ext_menu_caller.js
[task 2021-02-11T23:19:47.151Z] 23:19:47  WARNING -  TEST-UNEXPECTED-FAIL | xpcshell.ini:browser/components/extensions/test/xpcshell/test_ext_menu_caller.js | xpcshell return code: 0
[task 2021-02-11T23:19:47.151Z] 23:19:47     INFO -  TEST-INFO took 4216ms
[task 2021-02-11T23:19:47.151Z] 23:19:47     INFO -  >>>>>>>
[task 2021-02-11T23:19:47.152Z] 23:19:47     INFO -  PID 29926 | [CodeCoverage] Setting handlers for process 29926.
[task 2021-02-11T23:19:47.152Z] 23:19:47     INFO -  (xpcshell/head.js) | test MAIN run_test pending (1)
[task 2021-02-11T23:19:47.152Z] 23:19:47     INFO -  (xpcshell/head.js) | test run_next_test 0 pending (2)
[task 2021-02-11T23:19:47.152Z] 23:19:47     INFO -  (xpcshell/head.js) | test MAIN run_test finished (2)
[task 2021-02-11T23:19:47.152Z] 23:19:47     INFO -  running event loop
[task 2021-02-11T23:19:47.153Z] 23:19:47     INFO -  xpcshell.ini:browser/components/extensions/test/xpcshell/test_ext_menu_caller.js | Starting test_create_menu_ext_error
[task 2021-02-11T23:19:47.153Z] 23:19:47     INFO -  (xpcshell/head.js) | test test_create_menu_ext_error pending (2)
[task 2021-02-11T23:19:47.153Z] 23:19:47     INFO -  "Extension attached"
[task 2021-02-11T23:19:47.153Z] 23:19:47     INFO -  (xpcshell/head.js) | test run_next_test 0 finished (2)
[task 2021-02-11T23:19:47.153Z] 23:19:47     INFO -  PID 29926 | [CodeCoverage] Setting handlers for process 29958.
[task 2021-02-11T23:19:47.153Z] 23:19:47     INFO -  "CONSOLE_MESSAGE: (error) [JavaScript Error: "Unchecked lastError value: Error: ID already exists: muted-tab" {file: "moz-extension://1a29c8af-d18d-4ece-ae0c-cfa3eabf8f7c/%7B7cc6e17b-7fbc-455c-bedd-91d939eef018%7D.js" line: 9}]
[task 2021-02-11T23:19:47.153Z] 23:19:47     INFO -  @moz-extension://1a29c8af-d18d-4ece-ae0c-cfa3eabf8f7c/%7B7cc6e17b-7fbc-455c-bedd-91d939eef018%7D.js:9:23
[task 2021-02-11T23:19:47.153Z] 23:19:47     INFO -  "
[task 2021-02-11T23:19:47.153Z] 23:19:47     INFO -  "CONSOLE_MESSAGE: (info) === console listener 0.9610759646168807 done ==="
[task 2021-02-11T23:19:47.153Z] 23:19:47     INFO -  TEST-PASS | xpcshell.ini:browser/components/extensions/test/xpcshell/test_ext_menu_caller.js | test_create_menu_ext_error - [test_create_menu_ext_error : 40] Message source - "moz-extension://1a29c8af-d18d-4ece-ae0c-cfa3eabf8f7c/%7B7cc6e17b-7fbc-455c-bedd-91d939eef018%7D.js" == "moz-extension://1a29c8af-d18d-4ece-ae0c-cfa3eabf8f7c/%7B7cc6e17b-7fbc-455c-bedd-91d939eef018%7D.js"
[task 2021-02-11T23:19:47.153Z] 23:19:47     INFO -  TEST-PASS | xpcshell.ini:browser/components/extensions/test/xpcshell/test_ext_menu_caller.js | test_create_menu_ext_error - [test_create_menu_ext_error : 42] Message content - "Unchecked lastError value: Error: ID already exists: muted-tab" == "Unchecked lastError value: Error: ID already exists: muted-tab"
[task 2021-02-11T23:19:47.153Z] 23:19:47     INFO -  TEST-PASS | xpcshell.ini:browser/components/extensions/test/xpcshell/test_ext_menu_caller.js | test_create_menu_ext_error - [test_create_menu_ext_error : 47] Message line - 9 == 9
[task 2021-02-11T23:19:47.153Z] 23:19:47     INFO -  TEST-PASS | xpcshell.ini:browser/components/extensions/test/xpcshell/test_ext_menu_caller.js | test_create_menu_ext_error - [test_create_menu_ext_error : 50] Frame source - "moz-extension://1a29c8af-d18d-4ece-ae0c-cfa3eabf8f7c/%7B7cc6e17b-7fbc-455c-bedd-91d939eef018%7D.js" == "moz-extension://1a29c8af-d18d-4ece-ae0c-cfa3eabf8f7c/%7B7cc6e17b-7fbc-455c-bedd-91d939eef018%7D.js"
[task 2021-02-11T23:19:47.153Z] 23:19:47     INFO -  TEST-PASS | xpcshell.ini:browser/components/extensions/test/xpcshell/test_ext_menu_caller.js | test_create_menu_ext_error - [test_create_menu_ext_error : 51] Frame line - 9 == 9
[task 2021-02-11T23:19:47.153Z] 23:19:47     INFO -  TEST-PASS | xpcshell.ini:browser/components/extensions/test/xpcshell/test_ext_menu_caller.js | test_create_menu_ext_error - [test_create_menu_ext_error : 52] Frame column - 23 == 23
[task 2021-02-11T23:19:47.153Z] 23:19:47  WARNING -  TEST-UNEXPECTED-FAIL | xpcshell.ini:browser/components/extensions/test/xpcshell/test_ext_menu_caller.js | test_create_menu_ext_error - [test_create_menu_ext_error : 53] Frame function name - null == "background/<"
[task 2021-02-11T23:19:47.153Z] 23:19:47     INFO -  /builds/worker/workspace/build/tests/xpcshell/tests/browser/components/extensions/test/xpcshell/test_ext_menu_caller.js:test_create_menu_ext_error:53
[task 2021-02-11T23:19:47.154Z] 23:19:47     INFO -  /builds/worker/workspace/build/tests/xpcshell/head.js:_do_main:239
[task 2021-02-11T23:19:47.154Z] 23:19:47     INFO -  /builds/worker/workspace/build/tests/xpcshell/head.js:_execute_test:567
[task 2021-02-11T23:19:47.154Z] 23:19:47     INFO -  -e:null:1
[task 2021-02-11T23:19:47.154Z] 23:19:47     INFO -  exiting test
[task 2021-02-11T23:19:47.154Z] 23:19:47     INFO -  Unexpected exception NS_ERROR_ABORT:
[task 2021-02-11T23:19:47.154Z] 23:19:47     INFO -  _abort_failed_test@/builds/worker/workspace/build/tests/xpcshell/head.js:827:20
[task 2021-02-11T23:19:47.154Z] 23:19:47     INFO -  do_report_result@/builds/worker/workspace/build/tests/xpcshell/head.js:928:5
[task 2021-02-11T23:19:47.154Z] 23:19:47     INFO -  Assert<@/builds/worker/workspace/build/tests/xpcshell/head.js:73:21
[task 2021-02-11T23:19:47.154Z] 23:19:47     INFO -  proto.report@resource://testing-common/Assert.jsm:233:10
[task 2021-02-11T23:19:47.154Z] 23:19:47     INFO -  equal@resource://testing-common/Assert.jsm:275:8
[task 2021-02-11T23:19:47.154Z] 23:19:47     INFO -  test_create_menu_ext_error@/builds/worker/workspace/build/tests/xpcshell/tests/browser/components/extensions/test/xpcshell/test_ext_menu_caller.js:53:8
[task 2021-02-11T23:19:47.154Z] 23:19:47     INFO -  _do_main@/builds/worker/workspace/build/tests/xpcshell/head.js:239:6
[task 2021-02-11T23:19:47.154Z] 23:19:47     INFO -  _execute_test@/builds/worker/workspace/build/tests/xpcshell/head.js:567:5
[task 2021-02-11T23:19:47.154Z] 23:19:47     INFO -  @-e:1:1
[task 2021-02-11T23:19:47.154Z] 23:19:47     INFO -  exiting test```

Comment 1

[Intermittent Failures Robot]

19 failures in 756 pushes (0.025 failures/push) were associated with this bug yesterday.

Repository breakdown:

• mozilla-central: 19

Platform and build breakdown:

• linux1804-64-ccov: 17
  • opt: 17
• windows10-64-ccov-qr: 2
  • opt: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1692349&startday=2021-02-11&endday=2021-02-11&tree=all

Comment 2

[Sebastian Hengst [:aryx] (needinfo me if it's about an intermittent or backout)]

Sunday, do you want to check why the test added in bug 1588616 frequently fails on these slow platforms?

Comment 3

[BugBot [:suhaib / :marco/ :calixte]]

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

Comment 4

[Sunday Mgbogu [:digitalsimboja]]

I would check

Comment 5

[Rob Wu [:robwu]]

The failure only happens in the CCov job, and the error is:

TEST-UNEXPECTED-FAIL | xpcshell.ini:browser/components/extensions/test/xpcshell/test_ext_menu_caller.js | test_create_menu_ext_error - [test_create_menu_ext_error : 53] Frame function name - null == "background/<"

I don't know the exact cause of the issue, but changes to stack traces or debugging information is something that may happen when code coverage instrumentation is added.

To resolve this bug, I suggest to simply remove the assertion, i.e. remove this line: https://hg.mozilla.org/mozilla-central/rev/3b9a479c0705#l2.57

Comment 6

[Sunday Mgbogu [:digitalsimboja]]

Alright, I will remove the line suggested and commit again. Thanks

Comment 7

[Sunday Mgbogu [:digitalsimboja]]

Attachment: Bug 1692349 - Remove unreliable assertion in test_ext_menu_caller.js r=robwu

Comment 8

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/03490065acf6
Remove unreliable assertion in test_ext_menu_caller.js r=robwu

Comment 9

[Natalia Csoregi [:nataliaCs]]

https://hg.mozilla.org/mozilla-central/rev/03490065acf6

Comment 10

[Intermittent Failures Robot]

28 failures in 4322 pushes (0.006 failures/push) were associated with this bug in the last 7 days.

This is the #46 most frequent failure this week.

Repository breakdown:

• mozilla-central: 28

Platform and build breakdown:

• linux1804-64-ccov: 19
  • opt: 19
• windows10-64-ccov-qr: 9
  • opt: 9

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1692349&startday=2021-02-08&endday=2021-02-14&tree=all