Closed Bug 1794715 Opened 2 years ago Closed 2 years ago

Intermittent browser/base/content/test/performance/browser_startup_mainthreadio.js | single tracking bug

Categories

(Firefox :: General, defect, P5)

defect

Tracking

()

RESOLVED FIXED
109 Branch
Tracking Status
firefox109 --- fixed
firefox110 --- fixed

People

(Reporter: intermittent-bug-filer, Assigned: florian)

References

Details

(Keywords: intermittent-failure, intermittent-testcase, Whiteboard: [retriggered])

Attachments

(1 file, 1 obsolete file)

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


[task 2022-10-11T23:19:03.082Z] 23:19:03     INFO - TEST-PASS | browser/base/content/test/performance/browser_startup_mainthreadio.js | close on /builds/worker/workspace/build/application/firefox/browser/features/webcompat@mozilla.org.xpi as many times as expected before opening first browser window - 
[task 2022-10-11T23:19:03.084Z] 23:19:03     INFO - known main thread IO paths during before first paint:
[task 2022-10-11T23:19:03.084Z] 23:19:03     INFO -   /builds/worker/workspace/build/application/firefox/browser/features/formautofill@mozilla.org.xpi - condition: true, stat: 1, close: 1, listedPath: XREAppFeat:formautofill@mozilla.org.xpi
[task 2022-10-11T23:19:03.085Z] 23:19:03     INFO -   *ld.so.conf* - condition: true, read: 22, close: 11, listedPath: *ld.so.conf*
[task 2022-10-11T23:19:03.085Z] 23:19:03     INFO -   /tmp/tmppxsycynp.mozrunner/d3d11layers.guard - ignoreIfUnused: true, stat: 1, listedPath: ProfD:d3d11layers.guard
[task 2022-10-11T23:19:03.086Z] 23:19:03     INFO -   /tmp/tmppxsycynp.mozrunner/glcontext.guard - ignoreIfUnused: true, stat: 1, listedPath: ProfD:glcontext.guard
[task 2022-10-11T23:19:03.087Z] 23:19:03     INFO -   /tmp/tmppxsycynp.mozrunner/wmfvpxvideo.guard - ignoreIfUnused: true, stat: 1, listedPath: ProfD:wmfvpxvideo.guard
[task 2022-10-11T23:19:03.088Z] 23:19:03     INFO - Buffered messages finished
[task 2022-10-11T23:19:03.089Z] 23:19:03     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/performance/browser_startup_mainthreadio.js | unexpected close on /builds/worker/workspace/build/application/firefox/browser/features/webcompat@mozilla.org.xpi before first paint - 
[task 2022-10-11T23:19:03.089Z] 23:19:03     INFO - Stack trace:
[task 2022-10-11T23:19:03.089Z] 23:19:03     INFO -   0x7f294a6c7386
[task 2022-10-11T23:19:03.089Z] 23:19:03     INFO -   Task nsJARChannel::ContinueOpenLocalFile
[task 2022-10-11T23:19:03.089Z] 23:19:03     INFO -   XREMain::XRE_main
[task 2022-10-11T23:19:03.090Z] 23:19:03     INFO - (NSPRIOInterposer) close - /builds/worker/workspace/build/application/firefox/browser/features/webcompat@mozilla.org.xpi
[task 2022-10-11T23:19:03.091Z] 23:19:03     INFO - (NSPRIOInterposer) stat - /builds/worker/workspace/build/application/firefox/browser/features/formautofill@mozilla.org.xpi
[task 2022-10-11T23:19:03.092Z] 23:19:03     INFO - (NSPRIOInterposer) close - /builds/worker/workspace/build/application/firefox/browser/features/formautofill@mozilla.org.xpi
[task 2022-10-11T23:19:03.093Z] 23:19:03     INFO - (NSPRIOInterposer) read - /etc/ld.so.conf
[task 2022-10-11T23:19:03.093Z] 23:19:03     INFO - (NSPRIOInterposer) read - /etc/ld.so.conf.d/x86_64-linux-gnu.conf
[task 2022-10-11T23:19:03.094Z] 23:19:03     INFO - (NSPRIOInterposer) read - /etc/ld.so.conf.d/x86_64-linux-gnu.conf
[task 2022-10-11T23:19:03.095Z] 23:19:03     INFO - (NSPRIOInterposer) close - /etc/ld.so.conf.d/x86_64-linux-gnu.conf
[task 2022-10-11T23:19:03.096Z] 23:19:03     INFO - (NSPRIOInterposer) read - /etc/ld.so.conf.d/libc.conf
[task 2022-10-11T23:19:03.097Z] 23:19:03     INFO - (NSPRIOInterposer) read - /etc/ld.so.conf.d/libc.conf
[task 2022-10-11T23:19:03.097Z] 23:19:03     INFO - (NSPRIOInterposer) close - /etc/ld.so.conf.d/libc.conf
[task 2022-10-11T23:19:03.098Z] 23:19:03     INFO - (NSPRIOInterposer) read - /etc/ld.so.conf.d/zz_x32-biarch-compat.conf
[task 2022-10-11T23:19:03.099Z] 23:19:03     INFO - (NSPRIOInterposer) read - /etc/ld.so.conf.d/zz_x32-biarch-compat.conf
[task 2022-10-11T23:19:03.100Z] 23:19:03     INFO - (NSPRIOInterposer) close - /etc/ld.so.conf.d/zz_x32-biarch-compat.conf
[task 2022-10-11T23:19:03.101Z] 23:19:03     INFO - (NSPRIOInterposer) read - /etc/ld.so.conf.d/zz_i386-biarch-compat.conf
[task 2022-10-11T23:19:03.102Z] 23:19:03     INFO - (NSPRIOInterposer) read - /etc/ld.so.conf.d/zz_i386-biarch-compat.conf
[task 2022-10-11T23:19:03.103Z] 23:19:03     INFO - (NSPRIOInterposer) close - /etc/ld.so.conf.d/zz_i386-biarch-compat.conf
[task 2022-10-11T23:19:03.103Z] 23:19:03     INFO - (NSPRIOInterposer) read - /etc/ld.so.conf.d/fakeroot-x86_64-linux-gnu.conf
[task 2022-10-11T23:19:03.104Z] 23:19:03     INFO - (NSPRIOInterposer) read - /etc/ld.so.conf.d/fakeroot-x86_64-linux-gnu.conf
[task 2022-10-11T23:19:03.105Z] 23:19:03     INFO - (NSPRIOInterposer) close - /etc/ld.so.conf.d/fakeroot-x86_64-linux-gnu.conf
[task 2022-10-11T23:19:03.106Z] 23:19:03     INFO - (NSPRIOInterposer) read - /etc/ld.so.conf.d/i386-linux-gnu.conf
[task 2022-10-11T23:19:03.107Z] 23:19:03     INFO - (NSPRIOInterposer) read - /etc/ld.so.conf.d/i386-linux-gnu.conf
[task 2022-10-11T23:19:03.107Z] 23:19:03     INFO - (NSPRIOInterposer) close - /etc/ld.so.conf.d/i386-linux-gnu.conf
[task 2022-10-11T23:19:03.108Z] 23:19:03     INFO - (NSPRIOInterposer) read - /etc/ld.so.conf
[task 2022-10-11T23:19:03.109Z] 23:19:03     INFO - (NSPRIOInterposer) close - /etc/ld.so.conf
[task 2022-10-11T23:19:03.110Z] 23:19:03     INFO - TEST-PASS | browser/base/content/test/performance/browser_startup_mainthreadio.js | stat on /builds/worker/workspace/build/application/firefox/browser/features/formautofill@mozilla.org.xpi as many times as expected before first paint -

First occurrence so far with the new error: https://treeherder.mozilla.org/jobs?repo=autoland&group_state=expanded&selectedTaskRun=O2JdqLqzQo-nN0EaOXtS4A.0&searchStr=linux%2C18.04%2Cx64%2Cwebrender%2Copt%2Cmochitests%2Cwith%2Csoftware%2Cwebrender%2Cenabled%2Ctest-linux1804-64-qr%2Fopt-mochitest-browser-chrome-swr%2Cbc1&tochange=f36d9e78e41726fe8cd299e04b7fad07d208ec79&fromchange=77ad8aa7c1cf0ca257cf24c08368c3a9bd5759cc

TEST-UNEXPECTED-FAIL | browser/base/content/test/performance/browser_startup_mainthreadio.js | unexpected close on /builds/worker/workspace/build/application/firefox/browser/features/webcompat@mozilla.org.xpi before first paint -

Whiteboard: [retriggered]

Update:

There have been 46 failures within the last 7 days:

  • 25 failures on Linux 18.04 x64 WebRender opt
  • 16 failures on Linux 18.04 x64 WebRender Shippable opt
  • 2 failures on Windows 10 x64 2004 CCov WebRender opt
  • 2 failures on Windows 10 x64 2004 WebRender opt
  • 1 failure on Windows 10 x64 2004 WebRender Shippable opt

Recent failure log: https://treeherder.mozilla.org/logviewer?job_id=395746742&repo=autoland&lineNumber=3832

[task 2022-11-07T10:39:50.214Z] 10:39:50     INFO - TEST-PASS | browser/base/content/test/performance/browser_startup_mainthreadio.js | close on /builds/worker/workspace/build/application/firefox/browser/features/webcompat@mozilla.org.xpi as many times as expected before opening first browser window - 
[task 2022-11-07T10:39:50.215Z] 10:39:50     INFO - known main thread IO paths during before first paint:
[task 2022-11-07T10:39:50.215Z] 10:39:50     INFO -   /builds/worker/workspace/build/application/firefox/browser/features/formautofill@mozilla.org.xpi - condition: true, stat: 1, close: 1, listedPath: XREAppFeat:formautofill@mozilla.org.xpi
[task 2022-11-07T10:39:50.216Z] 10:39:50     INFO -   *ld.so.conf* - condition: true, read: 22, close: 11, listedPath: *ld.so.conf*
[task 2022-11-07T10:39:50.216Z] 10:39:50     INFO -   /tmp/tmphpuxmi5b.mozrunner/d3d11layers.guard - ignoreIfUnused: true, stat: 1, listedPath: ProfD:d3d11layers.guard
[task 2022-11-07T10:39:50.216Z] 10:39:50     INFO -   /tmp/tmphpuxmi5b.mozrunner/glcontext.guard - ignoreIfUnused: true, stat: 1, listedPath: ProfD:glcontext.guard
[task 2022-11-07T10:39:50.217Z] 10:39:50     INFO -   /tmp/tmphpuxmi5b.mozrunner/wmfvpxvideo.guard - ignoreIfUnused: true, stat: 1, listedPath: ProfD:wmfvpxvideo.guard
[task 2022-11-07T10:39:50.217Z] 10:39:50     INFO - Buffered messages finished
[task 2022-11-07T10:39:50.218Z] 10:39:50     INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/performance/browser_startup_mainthreadio.js | unexpected close on /builds/worker/workspace/build/application/firefox/browser/features/webcompat@mozilla.org.xpi before first paint - 
[task 2022-11-07T10:39:50.218Z] 10:39:50     INFO - Stack trace:
[task 2022-11-07T10:39:50.218Z] 10:39:50     INFO -   0x7f34f5fd75f6
[task 2022-11-07T10:39:50.218Z] 10:39:50     INFO -   Task nsJARChannel::ContinueOpenLocalFile
[task 2022-11-07T10:39:50.219Z] 10:39:50     INFO -   XREMain::XRE_main
[task 2022-11-07T10:39:50.219Z] 10:39:50     INFO - (NSPRIOInterposer) close - /builds/worker/workspace/build/application/firefox/browser/features/webcompat@mozilla.org.xpi

Dave, can you help us assign this to someone?
Thank you.

Flags: needinfo?(dtownsend)
Whiteboard: [retriggered] → [retriggered][stockwell needswork:owner]

There have been 35 total failures in the last 7 days, recent failure log.
Affected platforms are:

  • linux1804-64-qr
  • linux1804-64-shippable-qr
  • windows10-64-2004-qr
  • windows10-64-2004-shippable-qr
  • windows7-32-qr

There have been 46 total failures in the last 7 days, recent failure log.
Affected platforms are:

  • linux1804-64-qr
  • linux1804-64-shippable-qr
  • macosx1015-64-qr
  • windows10-32-2004-qr
  • windows10-64-2004-qr
  • windows10-64-2004-shippable-qr
  • windows7-32-qr
Assignee: nobody → csabou
Status: NEW → ASSIGNED
Flags: needinfo?(dtownsend)
Pushed by fqueze@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/bd717140fb06
adjust the known main thread I/O list and disable browser_startup_mainthreadio.js on Windows 32 bits where NSS is sometimes initialized too early, r=jmaher.
Keywords: leave-open
Assignee: csabou → nobody
Status: ASSIGNED → NEW
Whiteboard: [retriggered][stockwell disable-recommended] → [retriggered][stockwell needswork:owner]
Whiteboard: [retriggered][stockwell disable-recommended] → [retriggered][stockwell needswork:owner]
Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → FIXED
Whiteboard: [retriggered][stockwell needswork:owner] → [retriggered]
Target Milestone: --- → 109 Branch
Assignee: nobody → florian
Attachment #9305963 - Attachment is obsolete: true
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: