1629273 - Intermittent extensions/permissions/test/unit/test_permmanager_load_invalid_entries.js | xpcshell return code: 0

Status: RESOLVED FIXED

(Core :: Permission Manager, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: malexandru [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=297245448&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/IwVaCuj4T8mTwItvHbcFMg/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/IwVaCuj4T8mTwItvHbcFMg/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

---

[task 2020-04-11T15:30:27.452Z] 15:30:27     INFO -  ::: Test verification summary for: /Users/cltbld/tasks/task_1586617441/build/tests/xpcshell/tests/extensions/permissions/test/unit/test_permmanager_migrate_5-7b.js
[task 2020-04-11T15:30:27.452Z] 15:30:27     INFO -  :::
[task 2020-04-11T15:30:27.452Z] 15:30:27     INFO -  ::: 1. Run each test 10 times, sequentially. : Pass
[task 2020-04-11T15:30:27.452Z] 15:30:27     INFO -  ::: 2. Run each test 10 times, sequentially, in chaos mode. : Pass
[task 2020-04-11T15:30:27.452Z] 15:30:27     INFO -  :::
[task 2020-04-11T15:30:27.452Z] 15:30:27     INFO -  ::: Test verification PASSED
[task 2020-04-11T15:30:27.452Z] 15:30:27     INFO -  :::
[task 2020-04-11T15:30:27.452Z] 15:30:27     INFO -  Node moz-http2 server shutting down ...
[task 2020-04-11T15:30:27.452Z] 15:30:27     INFO -  http3Server server shutting down ...
[task 2020-04-11T15:30:27.598Z] 15:30:27     INFO - Return code: 0
[task 2020-04-11T15:30:27.598Z] 15:30:27     INFO - TinderboxPrint: xpcshell-xpcshell<br/>20/0/0
[task 2020-04-11T15:30:27.598Z] 15:30:27     INFO - # TBPL SUCCESS #
[task 2020-04-11T15:30:27.598Z] 15:30:27     INFO - TinderboxPrint: Per-test run of .../test_permmanager_migrate_5-7b.js<br/>: SUCCESS
[task 2020-04-11T15:30:27.598Z] 15:30:27     INFO - Running command: ['/Users/cltbld/tasks/task_1586617441/build/venv/bin/python', '-u', '/Users/cltbld/tasks/task_1586617441/build/tests/xpcshell/runxpcshelltests.py', '--setpref=media.peerconnection.mtransport_process=false', '--setpref=network.process.enabled=false', u'--symbols-path=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/AJSIgeXVRLS3jyx8Nx0y8w/artifacts/public/build/target.crashreporter-symbols.zip', '--test-plugin-path=/Users/cltbld/tasks/task_1586617441/build/application/Firefox Nightly.app/Contents/Resources/plugins', '--log-raw=/Users/cltbld/tasks/task_1586617441/build/blobber_upload_dir/xpcshell_raw.log', '--log-errorsummary=/Users/cltbld/tasks/task_1586617441/build/blobber_upload_dir/xpcshell_errorsummary.log', '--utility-path=tests/bin', '--xpcshell=/Users/cltbld/tasks/task_1586617441/build/application/Firefox Nightly.app/Contents/MacOS/xpcshell', '--manifest=tests/xpcshell/tests/xpcshell.ini', '--verify-max-time=900', '--verify', u'extensions/permissions/test/unit/test_permmanager_load_invalid_entries.js'] in /Users/cltbld/tasks/task_1586617441/build
[task 2020-04-11T15:30:27.599Z] 15:30:27     INFO - Copy/paste: /Users/cltbld/tasks/task_1586617441/build/venv/bin/python -u /Users/cltbld/tasks/task_1586617441/build/tests/xpcshell/runxpcshelltests.py --setpref=media.peerconnection.mtransport_process=false --setpref=network.process.enabled=false --symbols-path=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/AJSIgeXVRLS3jyx8Nx0y8w/artifacts/public/build/target.crashreporter-symbols.zip "--test-plugin-path=/Users/cltbld/tasks/task_1586617441/build/application/Firefox Nightly.app/Contents/Resources/plugins" --log-raw=/Users/cltbld/tasks/task_1586617441/build/blobber_upload_dir/xpcshell_raw.log --log-errorsummary=/Users/cltbld/tasks/task_1586617441/build/blobber_upload_dir/xpcshell_errorsummary.log --utility-path=tests/bin "--xpcshell=/Users/cltbld/tasks/task_1586617441/build/application/Firefox Nightly.app/Contents/MacOS/xpcshell" --manifest=tests/xpcshell/tests/xpcshell.ini --verify-max-time=900 --verify extensions/permissions/test/unit/test_permmanager_load_invalid_entries.js
[task 2020-04-11T15:30:27.599Z] 15:30:27     INFO - Using env: (same as previous command)
[task 2020-04-11T15:30:27.599Z] 15:30:27     INFO - Calling ['/Users/cltbld/tasks/task_1586617441/build/venv/bin/python', '-u', '/Users/cltbld/tasks/task_1586617441/build/tests/xpcshell/runxpcshelltests.py', '--setpref=media.peerconnection.mtransport_process=false', '--setpref=network.process.enabled=false', u'--symbols-path=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/AJSIgeXVRLS3jyx8Nx0y8w/artifacts/public/build/target.crashreporter-symbols.zip', '--test-plugin-path=/Users/cltbld/tasks/task_1586617441/build/application/Firefox Nightly.app/Contents/Resources/plugins', '--log-raw=/Users/cltbld/tasks/task_1586617441/build/blobber_upload_dir/xpcshell_raw.log', '--log-errorsummary=/Users/cltbld/tasks/task_1586617441/build/blobber_upload_dir/xpcshell_errorsummary.log', '--utility-path=tests/bin', '--xpcshell=/Users/cltbld/tasks/task_1586617441/build/application/Firefox Nightly.app/Contents/MacOS/xpcshell', '--manifest=tests/xpcshell/tests/xpcshell.ini', '--verify-max-time=900', '--verify', u'extensions/permissions/test/unit/test_permmanager_load_invalid_entries.js'] with output_timeout 1000
[task 2020-04-11T15:30:27.855Z] 15:30:27     INFO -  Found node at /Users/cltbld/tasks/task_1586617441/fetches/node/bin/node
[task 2020-04-11T15:30:27.855Z] 15:30:27     INFO -  Found moz-http2 at /Users/cltbld/tasks/task_1586617441/build/tests/xpcshell/moz-http2/moz-http2.js
[task 2020-04-11T15:30:28.002Z] 15:30:28     INFO -  Found /Users/cltbld/tasks/task_1586617441/build/tests/xpcshell/http3server/http3server
[task 2020-04-11T15:30:28.003Z] 15:30:28     INFO -  Using /Users/cltbld/tasks/task_1586617441/build/tests/xpcshell/http3server/http3serverDB
[task 2020-04-11T15:30:28.352Z] 15:30:28     INFO -  :::
[task 2020-04-11T15:30:28.352Z] 15:30:28     INFO -  ::: Running test verification step "1. Run each test 10 times, sequentially."...
[task 2020-04-11T15:30:28.352Z] 15:30:28     INFO -  :::
[task 2020-04-11T15:30:28.352Z] 15:30:28     INFO -  Using at most 16 threads.
[task 2020-04-11T15:30:28.352Z] 15:30:28     INFO -  SUITE-START | Running 1 tests
[task 2020-04-11T15:30:28.363Z] 15:30:28     INFO -  TEST-START | extensions/permissions/test/unit/test_permmanager_load_invalid_entries.js
[task 2020-04-11T15:30:28.671Z] 15:30:28  WARNING -  TEST-UNEXPECTED-FAIL | extensions/permissions/test/unit/test_permmanager_load_invalid_entries.js | xpcshell return code: 0
[task 2020-04-11T15:30:28.671Z] 15:30:28     INFO -  TEST-INFO took 296ms
[task 2020-04-11T15:30:28.671Z] 15:30:28     INFO -  >>>>>>>
[task 2020-04-11T15:30:28.671Z] 15:30:28     INFO -  (xpcshell/head.js) | test MAIN run_test pending (1)
[task 2020-04-11T15:30:28.671Z] 15:30:28     INFO -  TEST-PASS | extensions/permissions/test/unit/test_permmanager_load_invalid_entries.js | run_test - [run_test : 17] true == true
[task 2020-04-11T15:30:28.671Z] 15:30:28     INFO -  NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [mozIStorageConnection.executeSimpleSQL]
[task 2020-04-11T15:30:28.671Z] 15:30:28     INFO -  run_test@/Users/cltbld/tasks/task_1586617441/build/tests/xpcshell/tests/extensions/permissions/test/unit/test_permmanager_load_invalid_entries.js:20:14
[task 2020-04-11T15:30:28.671Z] 15:30:28     INFO -  _execute_test@/Users/cltbld/tasks/task_1586617441/build/tests/xpcshell/head.js:567:7
[task 2020-04-11T15:30:28.672Z] 15:30:28     INFO -  @-e:1:1
[task 2020-04-11T15:30:28.672Z] 15:30:28     INFO -  "CONSOLE_MESSAGE: (info) No chrome package registered for chrome://branding/locale/brand.properties"
[task 2020-04-11T15:30:28.672Z] 15:30:28     INFO -  <<<<<<<
[task 2020-04-11T15:30:28.679Z] 15:30:28     INFO -  TEST-START | extensions/permissions/test/unit/test_permmanager_load_invalid_entries.js
[task 2020-04-11T15:30:28.922Z] 15:30:28  WARNING -  TEST-UNEXPECTED-FAIL | extensions/permissions/test/unit/test_permmanager_load_invalid_entries.js | xpcshell return code: 0
[task 2020-04-11T15:30:28.922Z] 15:30:28     INFO -  TEST-INFO took 243ms
[task 2020-04-11T15:30:28.923Z] 15:30:28     INFO -  >>>>>>>
[task 2020-04-11T15:30:28.923Z] 15:30:28     INFO -  (xpcshell/head.js) | test MAIN run_test pending (1)

Comment 1

[Bogdan Tara[:bogdan_tara | bogdant]]

Seeing this on tier 1: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=297256978&repo=mozilla-central&lineNumber=6309

Comment 2

[Andrea Marchesini [:baku]]

Attachment: Bug 1629273 - Fix intermittent failure in test_permmanager_load_invalid_entries.js, r=timhuang

Comment 3

[Intermittent Failures Robot]

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

This is the #50 most frequent failure this week.

Repository breakdown:

• autoland: 14
• mozilla-central: 9
• try: 6

Platform breakdown:

• windows10-64-shippable: 11
• windows7-32-shippable: 7
• linux1804-64-shippable: 1
• macosx1014-64-shippable: 1
• windows10-64: 2
• windows10-64-ccov: 3
• linux1804-64-asan: 1
• windows10-64-devedition: 2
• windows7-32-devedition: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1629273&startday=2020-04-06&endday=2020-04-12&tree=all

Comment 4

[Intermittent Failures Robot]

33 failures in 500 pushes (0.066 failures/push) were associated with this bug yesterday.

Repository breakdown:

• autoland: 13
• mozilla-central: 10
• try: 10

Platform breakdown:

• windows10-64-shippable: 17
• windows7-32: 2
• windows10-64: 5
• windows7-32-shippable: 7
• windows10-64-devedition: 1
• windows7-32-devedition: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1629273&startday=2020-04-13&endday=2020-04-13&tree=all

Comment 5

[Pulsebot]

Pushed by [e-mail]:
https://hg.mozilla.org/integration/autoland/rev/f1d9689ea300
Fix intermittent failure in test_permmanager_load_invalid_entries.js, r=timhuang

Comment 6

[Andrei Ciure[:aciure]]

https://hg.mozilla.org/mozilla-central/rev/f1d9689ea300

Comment 7

[Intermittent Failures Robot]

47 failures in 4528 pushes (0.01 failures/push) were associated with this bug in the last 7 days.

This is the #29 most frequent failure this week.

** This failure happened more than 30 times this week! Resolving this bug is a high priority. **

** Try to resolve this bug as soon as possible. If unresolved for 2 weeks, the affected test(s) may be disabled. **

Repository breakdown:

• autoland: 18
• mozilla-central: 15
• try: 14

Platform breakdown:

• windows10-64-shippable: 25
• windows7-32: 2
• windows10-64: 7
• windows7-32-shippable: 9
• windows10-64-devedition: 2
• windows7-32-devedition: 1
• windows10-64-ccov: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1629273&startday=2020-04-13&endday=2020-04-19&tree=all