Closed Bug 1396309 Opened 7 years ago Closed 5 years ago

Intermittent docshell/test/navigation/test_sessionhistory.html | Test timed out.

Categories

(Core :: DOM: Navigation, defect, P2)

defect

Tracking

()

RESOLVED FIXED
mozilla72
Tracking Status
firefox70 --- wontfix
firefox71 --- fixed
firefox72 --- fixed

People

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

References

Details

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

Attachments

(1 file)

Filed by: archaeopteryx [at] coole-files.de

https://treeherder.mozilla.org/logviewer.html#?job_id=127960484&repo=autoland

https://queue.taskcluster.net/v1/task/PpkaYtzyQ9WcYLfn3HwH8A/runs/0/artifacts/public/test_info//plain-chunked_errorsummary.log

[task 2017-09-02T06:45:58.621712Z] 06:45:58     INFO - Running file_bug1379762-1.html
[task 2017-09-02T06:45:58.624889Z] 06:45:58     INFO - Buffered messages logged at 06:45:56
[task 2017-09-02T06:45:58.628234Z] 06:45:58     INFO - TEST-PASS | docshell/test/navigation/test_sessionhistory.html | We should only run once; otherwise the loadCount variable makes no sense 
[task 2017-09-02T06:45:58.631209Z] 06:45:58     INFO - TEST-PASS | docshell/test/navigation/test_sessionhistory.html | Should only get one onload 
[task 2017-09-02T06:45:58.635489Z] 06:45:58     INFO - Buffered messages finished
[task 2017-09-02T06:45:58.637960Z] 06:45:58     INFO - TEST-UNEXPECTED-FAIL | docshell/test/navigation/test_sessionhistory.html | Test timed out. 
[task 2017-09-02T06:45:58.644029Z] 06:45:58     INFO -     reportError@SimpleTest/TestRunner.js:121:7
[task 2017-09-02T06:45:58.645915Z] 06:45:58     INFO -     TestRunner._checkForHangs@SimpleTest/TestRunner.js:142:7
[task 2017-09-02T06:45:58.647721Z] 06:45:58     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2017-09-02T06:45:58.651469Z] 06:45:58     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2017-09-02T06:45:58.653471Z] 06:45:58     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2017-09-02T06:45:58.658639Z] 06:45:58     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2017-09-02T06:45:58.660618Z] 06:45:58     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2017-09-02T06:45:58.662500Z] 06:45:58     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2017-09-02T06:45:58.664680Z] 06:45:58     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2017-09-02T06:45:58.668454Z] 06:45:58     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2017-09-02T06:45:58.670234Z] 06:45:58     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2017-09-02T06:45:58.672514Z] 06:45:58     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2017-09-02T06:45:58.674305Z] 06:45:58     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2017-09-02T06:45:58.677679Z] 06:45:58     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2017-09-02T06:45:58.679729Z] 06:45:58     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2017-09-02T06:45:58.682704Z] 06:45:58     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2017-09-02T06:45:58.685885Z] 06:45:58     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2017-09-02T06:45:58.687730Z] 06:45:58     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2017-09-02T06:45:58.689515Z] 06:45:58     INFO -     setTimeout handler*TestRunner._checkForHangs@SimpleTest/TestRunner.js:163:5
[task 2017-09-02T06:45:58.696777Z] 06:45:58     INFO -     TestRunner.runTests@SimpleTest/TestRunner.js:380:5
[task 2017-09-02T06:45:58.698665Z] 06:45:58     INFO -     RunSet.runtests@SimpleTest/setup.js:194:3
[task 2017-09-02T06:45:58.700497Z] 06:45:58     INFO -     RunSet.runall@SimpleTest/setup.js:173:5
[task 2017-09-02T06:45:58.704920Z] 06:45:58     INFO -     hookupTests@SimpleTest/setup.js:266:5
[task 2017-09-02T06:45:58.707036Z] 06:45:58     INFO - parseTestManifest@http://mochi.test:8888/manifestLibrary.js:36:5
[task 2017-09-02T06:45:58.711376Z] 06:45:58     INFO - getTestManifest/req.onload@http://mochi.test:8888/manifestLibrary.js:49:11
[task 2017-09-02T06:45:58.713575Z] 06:45:58     INFO - EventHandlerNonNull*getTestManifest@http://mochi.test:8888/manifestLibrary.js:45:3
[task 2017-09-02T06:45:58.715200Z] 06:45:58     INFO -     hookup@SimpleTest/setup.js:246:5
[task 2017-09-02T06:45:58.717229Z] 06:45:58     INFO - EventHandlerNonNull*@http://mochi.test:8888/tests?autorun=1&closeWhenDone=1&consoleLevel=INFO&manifestFile=tests.json&dumpOutputDirectory=%2Ftmp&cleanupCrashes=true:11:1
https://wiki.mozilla.org/Bugmasters#Intermittent_Test_Failure_Cleanup
Status: NEW → RESOLVED
Closed: 7 years ago
Resolution: --- → INCOMPLETE
Status: REOPENED → RESOLVED
Closed: 7 years ago5 years ago
Resolution: --- → INCOMPLETE

If this happens now often, bug 1563587 could have affected here.
(But I didn't see this when pushing to try)

Flags: needinfo?(bugs)

There is a part here which is now by definition racy. I'll just remove a small subtest.

Assignee: nobody → bugs
Flags: needinfo?(bugs)

There have been 24 failures in the last 7 days: https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?startday=2019-09-16&endday=2019-09-23&tree=trunk&bug=1396309

Affected platforms are:

  • linux64 opt
  • linux64 debug
  • linux64-qr debug
  • macosx1014-64 debug

Recent failure log: https://treeherder.mozilla.org/logviewer.html#/jobs?job_id=267855995&repo=mozilla-central&lineNumber=5693

smaug, this is still happening, any new insight?

Flags: needinfo?(bugs)

(yes, I've been traveling the last two weeks)

:smaug, any updates on this?

Finally now. Looking. I was in a work week.

The changes try to ensure we haven't really started load process of the new page, just that
there is ongoing active request. history.back() will then only affect to the fragment navigation.

Pushed by opettay@mozilla.com:
https://hg.mozilla.org/integration/autoland/rev/7bdd8b2e2e67
try to make file_fragment_handling_during_load.html less racy, r=peterv
Priority: -- → P2
Status: REOPENED → RESOLVED
Closed: 5 years ago5 years ago
Resolution: --- → FIXED
Target Milestone: --- → mozilla72

Comment on attachment 9103549 [details]
Bug 1396309, try to make file_fragment_handling_during_load.html less racy, r=peterv

ESR Uplift Approval Request

  • If this is not a sec:{high,crit} bug, please state case for ESR consideration: If https://bugzilla.mozilla.org/show_bug.cgi?id=1563587#c39 is accepted, this failure starts to show up more often.
  • User impact if declined: NA, this is test only
  • Fix Landed on Version: 71
  • Risk to taking this patch: Low
  • Why is the change risky/not risky? (and alternatives if risky): test only
  • String or UUID changes made by this patch:
Attachment #9103549 - Flags: approval-mozilla-esr68?

Comment on attachment 9103549 [details]
Bug 1396309, try to make file_fragment_handling_during_load.html less racy, r=peterv

We're not taking bug 1563587, so this isn't needed.

Attachment #9103549 - Flags: approval-mozilla-esr68? → approval-mozilla-esr68-
See Also: → 1618401
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: