Closed Bug 1671965 Opened 4 years ago Closed 4 years ago

Intermittent [Fission] browser/base/content/test/sanitize/browser_purgehistory_clears_sh.js | New value for webNavigation.canGoForward -

Categories

(Toolkit :: Data Sanitization, defect, P5)

defect

Tracking

()

RESOLVED FIXED
85 Branch
Tracking Status
firefox-esr78 --- unaffected
firefox82 --- unaffected
firefox83 --- unaffected
firefox84 --- disabled
firefox85 --- fixed

People

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

References

(Regression)

Details

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

Attachments

(1 file)

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


TEST-START | browser/base/content/test/sanitize/browser_purgehistory_clears_sh.js
[task 2020-10-19T14:54:53.259Z] 14:54:53 INFO - GECKO(2221) | [Child 2462: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x7f19f4fe4400 == 1 [pid = 2462] [id = 0]
[task 2020-10-19T14:54:53.295Z] 14:54:53 INFO - GECKO(2221) | [Child 2462: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 1 (0x7f1a0b392520) [pid = 2462] [serial = 1] [outer = (nil)]
[task 2020-10-19T14:54:53.295Z] 14:54:53 INFO - GECKO(2221) | [Child 2462: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 2 (0x7f19eec54c00) [pid = 2462] [serial = 2] [outer = 0x7f1a0b392520]
[task 2020-10-19T14:54:53.440Z] 14:54:53 INFO - GECKO(2221) | [2587, Unnamed thread 7f775205f5e0] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:202
[task 2020-10-19T14:54:53.441Z] 14:54:53 INFO - GECKO(2221) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmposII4o.mozrunner/runtests_leaks.log
[task 2020-10-19T14:54:53.442Z] 14:54:53 INFO - GECKO(2221) | [2587, Unnamed thread 7f775205f5e0] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp:202
[task 2020-10-19T14:54:53.443Z] 14:54:53 INFO - GECKO(2221) | [2587, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:249
[task 2020-10-19T14:54:53.495Z] 14:54:53 INFO - GECKO(2221) | [Child 2462: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 3 (0x7f19eef42800) [pid = 2462] [serial = 3] [outer = 0x7f1a0b392520]
[task 2020-10-19T14:54:53.571Z] 14:54:53 INFO - GECKO(2221) | [Child 2587, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:626
[task 2020-10-19T14:54:53.611Z] 14:54:53 INFO - GECKO(2221) | [Child 2458: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x7fc8b7de7400 == 2 [pid = 2458] [id = 0] [url = about:blank]
[task 2020-10-19T14:54:53.613Z] 14:54:53 INFO - GECKO(2221) | [Child 2458: Main Thread]: I/DocShellAndDOMWindowLeak --DOCSHELL 0x7fc8b1ab3000 == 1 [pid = 2458] [id = 1] [url = about:blank]
[task 2020-10-19T14:54:53.861Z] 14:54:53 INFO - TEST-INFO | started process screentopng
[task 2020-10-19T14:54:54.118Z] 14:54:54 INFO - TEST-INFO | screentopng: exit 0
[task 2020-10-19T14:54:54.120Z] 14:54:54 INFO - Buffered messages logged at 14:54:53
[task 2020-10-19T14:54:54.121Z] 14:54:54 INFO - Entering test bound purgeHistoryTest
[task 2020-10-19T14:54:54.122Z] 14:54:54 INFO - TEST-PASS | browser/base/content/test/sanitize/browser_purgehistory_clears_sh.js | Initial value for webNavigation.canGoBack -
[task 2020-10-19T14:54:54.123Z] 14:54:54 INFO - TEST-PASS | browser/base/content/test/sanitize/browser_purgehistory_clears_sh.js | Initial value for webNavigation.canGoBack -
[task 2020-10-19T14:54:54.124Z] 14:54:54 INFO - TEST-PASS | browser/base/content/test/sanitize/browser_purgehistory_clears_sh.js | Back button is disabled -
[task 2020-10-19T14:54:54.124Z] 14:54:54 INFO - TEST-PASS | browser/base/content/test/sanitize/browser_purgehistory_clears_sh.js | Forward button is disabled -
[task 2020-10-19T14:54:54.125Z] 14:54:54 INFO - TEST-PASS | browser/base/content/test/sanitize/browser_purgehistory_clears_sh.js | Initial SHistory size - 1 == 1 -
[task 2020-10-19T14:54:54.125Z] 14:54:54 INFO - TEST-PASS | browser/base/content/test/sanitize/browser_purgehistory_clears_sh.js | New SHistory size - 3 == 3 -
[task 2020-10-19T14:54:54.125Z] 14:54:54 INFO - TEST-PASS | browser/base/content/test/sanitize/browser_purgehistory_clears_sh.js | New value for webNavigation.canGoBack -
[task 2020-10-19T14:54:54.126Z] 14:54:54 INFO - Buffered messages finished
[task 2020-10-19T14:54:54.126Z] 14:54:54 INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/sanitize/browser_purgehistory_clears_sh.js | New value for webNavigation.canGoForward -
[task 2020-10-19T14:54:54.126Z] 14:54:54 INFO - Stack trace:
[task 2020-10-19T14:54:54.127Z] 14:54:54 INFO - chrome://mochikit/content/browser-test.js:test_ok:1304
[task 2020-10-19T14:54:54.128Z] 14:54:54 INFO - chrome://mochitests/content/browser/browser/base/content/test/sanitize/browser_purgehistory_clears_sh.js:purgeHistoryTestInner:47
[task 2020-10-19T14:54:54.129Z] 14:54:54 INFO - TEST-PASS | browser/base/content/test/sanitize/browser_purgehistory_clears_sh.js | Back button was enabled -
[task 2020-10-19T14:54:54.130Z] 14:54:54 INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-10-19T14:54:54.130Z] 14:54:54 INFO - TEST-UNEXPECTED-FAIL | browser/base/content/test/sanitize/browser_purgehistory_clears_sh.js | Forward button was enabled -
[task 2020-10-19T14:54:54.130Z] 14:54:54 INFO - Stack trace:
[task 2020-10-19T14:54:54.130Z] 14:54:54 INFO - chrome://mochikit/content/browser-test.js:test_ok:1304
[task 2020-10-19T14:54:54.131Z] 14:54:54 INFO - chrome://mochitests/content/browser/browser/base/content/test/sanitize/browser_purgehistory_clears_sh.js:purgeHistoryTestInner:52
[task 2020-10-19T14:54:54.131Z] 14:54:54 INFO - GECKO(2221) | [Parent 2221, GMPThread] WARNING: Failed to delete GMP storage directory: file /builds/worker/checkouts/gecko/dom/media/gmp/GMPServiceParent.cpp:1553
[task 2020-10-19T14:54:54.132Z] 14:54:54 INFO - GECKO(2221) | [Parent 2221, Main Thread] WARNING: Suboptimal indexes for the SQL statement 0x7f45994f6f60 (http://mzl.la/1FuID0j).: file /builds/worker/checkouts/gecko/storage/mozStoragePrivateHelpers.cpp:113
[task 2020-10-19T14:54:54.132Z] 14:54:54 INFO - TEST-PASS | browser/base/content/test/sanitize/browser_purgehistory_clears_sh.js | SHistory correctly cleared - 1 == 1 -
[task 2020-10-19T14:54:54.132Z] 14:54:54 INFO - TEST-PASS | browser/base/content/test/sanitize/browser_purgehistory_clears_sh.js | webNavigation.canGoBack correctly cleared -
[task 2020-10-19T14:54:54.132Z] 14:54:54 INFO - TEST-PASS | browser/base/content/test/sanitize/browser_purgehistory_clears_sh.js | webNavigation.canGoForward correctly cleared -
[task 2020-10-19T14:54:54.133Z] 14:54:54 INFO - TEST-PASS | browser/base/content/test/sanitize/browser_purgehistory_clears_sh.js | Back button was disabled -
[task 2020-10-19T14:54:54.133Z] 14:54:54 INFO - TEST-PASS | browser/base/content/test/sanitize/browser_purgehistory_clears_sh.js | Forward button was disabled -
[task 2020-10-19T14:54:54.133Z] 14:54:54 INFO - Leaving test bound purgeHistoryTest
[task 2020-10-19T14:54:54.133Z] 14:54:54 INFO - GECKO(2221) | [Parent 2221, Main Thread] WARNING: Not implemented in the parent process!: file /builds/worker/checkouts/gecko/docshell/shistory/SessionHistoryEntry.cpp:503
[task 2020-10-19T14:54:54.143Z] 14:54:54 INFO - GECKO(2221) | MEMORY STAT | vsize 2882MB | residentFast 351MB | heapAllocated 106MB
[task 2020-10-19T14:54:54.144Z] 14:54:54 INFO - TEST-OK | browser/base/content/test/sanitize/browser_purgehistory_clears_sh.js | took 904ms
[task 2020-10-19T14:54:54.144Z] 14:54:54 INFO - GECKO(2221) | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-10-19T14:54:54.159Z] 14:54:54 INFO - GECKO(2221) | [Child 2353: Main Thread]: I/DocShellAndDOMWindowLeak ++DOCSHELL 0x7f9df6c93800 == 2 [pid = 2353] [id = 3]
[task 2020-10-19T14:54:54.160Z] 14:54:54 INFO - GECKO(2221) | [Child 2353: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 6 (0x7f9e133926f0) [pid = 2353] [serial = 9] [outer = (nil)]
[task 2020-10-19T14:54:54.160Z] 14:54:54 INFO - GECKO(2221) | [Child 2353: Main Thread]: I/DocShellAndDOMWindowLeak ++DOMWINDOW == 7 (0x7f9df6c96000) [pid = 2353] [serial = 10] [outer = 0x7f9e133926f0]
[task 2020-10-19T14:54:54.200Z] 14:54:54 INFO - checking window state
[task 2020-10-19T14:54:54.241Z] 14:54:54 INFO - TEST-START | browser/base/content/test/sanitize/browser_sanitize-formhistory.js

This test got enabled in bug 1671223.

Flags: needinfo?(peterv)
Keywords: regression
Regressed by: 1671223
Has Regression Range: --- → yes
Summary: Intermittent browser/base/content/test/sanitize/browser_purgehistory_clears_sh.js | New value for webNavigation.canGoForward - → Intermittent [Fission] browser/base/content/test/sanitize/browser_purgehistory_clears_sh.js | New value for webNavigation.canGoForward -

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

In the last 7 days, there have been 22 occurrences on linux1804-64 debug and linux1804-64-shippable opt.

Recent failure: https://treeherder.mozilla.org/logviewer?job_id=321005394&repo=autoland&lineNumber=12378

Johann, could you, please, point this to the appropriate person?

Flags: needinfo?(jhofmann)
Whiteboard: [stockwell needswork:owner]

I think Peter or Smaug are the right people to look at this but OTOH it also doesn't feel like this is urgent enough to warrant spending their time on right now.

Flags: needinfo?(jhofmann)

In the last 7 days there have been 20 occurrences on linux1804-64 debug and linux1804-64-shippable opt.

Recent failure: https://treeherder.mozilla.org/logviewer?job_id=322606872&repo=mozilla-central&lineNumber=4955

Assignee: nobody → bugs
Status: NEW → ASSIGNED
Pushed by opettay@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/566509c23ad7 don't rely on timers but use popstate event in browser_purgehistory_clears_sh.js, r=peterv
Status: ASSIGNED → RESOLVED
Closed: 4 years ago
Resolution: --- → FIXED
Target Milestone: --- → 85 Branch
Flags: needinfo?(peterv)
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: