Closed Bug 1646356 Opened 4 years ago Closed 3 years ago

Intermittent browser/components/sessionstore/test/browser_sessionHistory.js | Test timed out -

Categories

(Firefox :: Session Restore, defect, P5)

defect

Tracking

()

RESOLVED FIXED
91 Branch
Tracking Status
firefox91 --- fixed

People

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

Details

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

Attachments

(2 files)

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


[task 2020-06-17T12:52:12.124Z] 12:52:12 INFO - TEST-START | browser/components/sessionstore/test/browser_sessionHistory.js
[task 2020-06-17T12:53:42.185Z] 12:53:42 INFO - TEST-INFO | started process screenshot
[task 2020-06-17T12:53:42.254Z] 12:53:42 INFO - TEST-INFO | screenshot: exit 0
[task 2020-06-17T12:53:42.254Z] 12:53:42 INFO - Buffered messages logged at 12:52:12
[task 2020-06-17T12:53:42.254Z] 12:53:42 INFO - Entering test bound test_load_start
[task 2020-06-17T12:53:42.254Z] 12:53:42 INFO - TEST-PASS | browser/components/sessionstore/test/browser_sessionHistory.js | url is correct -
[task 2020-06-17T12:53:42.254Z] 12:53:42 INFO - Leaving test bound test_load_start
[task 2020-06-17T12:53:42.254Z] 12:53:42 INFO - Entering test bound test_hashchange
[task 2020-06-17T12:53:42.255Z] 12:53:42 INFO - Console message: [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "http://example.com/browser/browser/components/sessionstore/test/file_sessionHistory_hashchange.html" line: 0}]
[task 2020-06-17T12:53:42.255Z] 12:53:42 INFO - TEST-PASS | browser/components/sessionstore/test/browser_sessionHistory.js | there is one shistory entry -
[task 2020-06-17T12:53:42.255Z] 12:53:42 INFO - Buffered messages logged at 12:52:57
[task 2020-06-17T12:53:42.255Z] 12:53:42 INFO - Longer timeout required, waiting longer... Remaining timeouts: 1
[task 2020-06-17T12:53:42.255Z] 12:53:42 INFO - Buffered messages finished
[task 2020-06-17T12:53:42.255Z] 12:53:42 INFO - TEST-UNEXPECTED-FAIL | browser/components/sessionstore/test/browser_sessionHistory.js | Test timed out -
[task 2020-06-17T12:53:42.255Z] 12:53:42 INFO - GECKO(9484) | MEMORY STAT | vsize 2104659MB | vsizeMaxContiguous 65664421MB | residentFast 387MB | heapAllocated 92MB
[task 2020-06-17T12:53:42.256Z] 12:53:42 INFO - TEST-OK | browser/components/sessionstore/test/browser_sessionHistory.js | took 90099ms
[task 2020-06-17T12:53:42.256Z] 12:53:42 INFO - Not taking screenshot here: see the one that was previously logged
[task 2020-06-17T12:53:42.256Z] 12:53:42 INFO - TEST-UNEXPECTED-FAIL | browser/components/sessionstore/test/browser_sessionHistory.js | Found a tab after previous test timed out: http://example.com/browser/browser/components/sessionstore/test/file_sessionHistory_hashchange.html -
[task 2020-06-17T12:53:42.256Z] 12:53:42 INFO - checking window state

Update:

There have been 40 failures within the last 7 days:

  • 21 failures on Windows 10 x64 WebRender Shippable opt
  • 2 failures on Windows 10 x64 CCov WebRender opt
  • 17 failures on Windows 10 x64 WebRender opt

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

[task 2021-06-19T11:06:27.961Z] 11:06:27     INFO - TEST-PASS | browser/components/sessionstore/test/browser_sessionHistory.js | there is one shistory entry - 
[task 2021-06-19T11:06:27.961Z] 11:06:27     INFO - Buffered messages logged at 11:05:42
[task 2021-06-19T11:06:27.962Z] 11:06:27     INFO - Longer timeout required, waiting longer...  Remaining timeouts: 1
[task 2021-06-19T11:06:27.962Z] 11:06:27     INFO - Buffered messages finished
[task 2021-06-19T11:06:27.963Z] 11:06:27     INFO - TEST-UNEXPECTED-FAIL | browser/components/sessionstore/test/browser_sessionHistory.js | Test timed out - 
[task 2021-06-19T11:06:27.963Z] 11:06:27     INFO - GECKO(10984) | MEMORY STAT | vsize 2104562MB | vsizeMaxContiguous 65125316MB | residentFast 344MB | heapAllocated 98MB
[task 2021-06-19T11:06:27.964Z] 11:06:27     INFO - TEST-OK | browser/components/sessionstore/test/browser_sessionHistory.js | took 90111ms
[task 2021-06-19T11:06:27.964Z] 11:06:27     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-06-19T11:06:27.965Z] 11:06:27     INFO - TEST-UNEXPECTED-FAIL | browser/components/sessionstore/test/browser_sessionHistory.js | Found a tab after previous test timed out: http://example.com/browser/browser/components/sessionstore/test/file_sessionHistory_hashchange.html - 
[task 2021-06-19T11:06:27.965Z] 11:06:27     INFO - checking window state
Whiteboard: [stockwell needswork:owner]

:kashav as the owner of this component, could you please assign this to someone?
Thank you.

Flags: needinfo?(kmadan)

Anny is looking at this.

Flags: needinfo?(kmadan) → needinfo?(agakhokidze)
Assignee: nobody → agakhokidze
Status: NEW → ASSIGNED
Pushed by agakhokidze@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/d0b8984194c6 Add extra logs to browser_sessionHistory.js, r=zombie
Flags: needinfo?(agakhokidze)
Keywords: leave-open

There are 51 total failures in the last 7 days on

[task 2021-07-01T16:28:33.546Z] 16:28:33 INFO - TEST-START | browser/components/sessionstore/test/browser_sessionHistory.js
[task 2021-07-01T16:30:03.583Z] 16:30:03 INFO - TEST-INFO | started process screenshot
[task 2021-07-01T16:30:03.643Z] 16:30:03 INFO - TEST-INFO | screenshot: exit 0
[task 2021-07-01T16:30:03.643Z] 16:30:03 INFO - Buffered messages logged at 16:28:33
[task 2021-07-01T16:30:03.643Z] 16:30:03 INFO - Entering test bound test_load_start
[task 2021-07-01T16:30:03.644Z] 16:30:03 INFO - TEST-PASS | browser/components/sessionstore/test/browser_sessionHistory.js | url is correct -
[task 2021-07-01T16:30:03.644Z] 16:30:03 INFO - Leaving test bound test_load_start
[task 2021-07-01T16:30:03.645Z] 16:30:03 INFO - Entering test bound test_hashchange
[task 2021-07-01T16:30:03.645Z] 16:30:03 INFO - Buffered messages logged at 16:28:34
[task 2021-07-01T16:30:03.646Z] 16:30:03 INFO - Console message: [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "http://example.com/browser/browser/components/sessionstore/test/file_sessionHistory_hashchange.html" line: 0}]
[task 2021-07-01T16:30:03.646Z] 16:30:03 INFO - TEST-PASS | browser/components/sessionstore/test/browser_sessionHistory.js | there is one shistory entry -
[task 2021-07-01T16:30:03.646Z] 16:30:03 INFO - About to watch for a hash change event
[task 2021-07-01T16:30:03.647Z] 16:30:03 INFO - Buffered messages logged at 16:29:18
[task 2021-07-01T16:30:03.647Z] 16:30:03 INFO - Longer timeout required, waiting longer... Remaining timeouts: 1
[task 2021-07-01T16:30:03.648Z] 16:30:03 INFO - Buffered messages finished
[task 2021-07-01T16:30:03.648Z] 16:30:03 INFO - TEST-UNEXPECTED-FAIL | browser/components/sessionstore/test/browser_sessionHistory.js | Test timed out -
[task 2021-07-01T16:30:03.648Z] 16:30:03 INFO - GECKO(10696) | MEMORY STAT | vsize 2104550MB | vsizeMaxContiguous 67070917MB | residentFast 339MB | heapAllocated 97MB
[task 2021-07-01T16:30:03.649Z] 16:30:03 INFO - TEST-OK | browser/components/sessionstore/test/browser_sessionHistory.js | took 90069ms
[task 2021-07-01T16:30:03.649Z] 16:30:03 INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-07-01T16:30:03.650Z] 16:30:03 INFO - TEST-UNEXPECTED-FAIL | browser/components/sessionstore/test/browser_sessionHistory.js | Found a tab after previous test timed out: http://example.com/browser/browser/components/sessionstore/test/file_sessionHistory_hashchange.html -
[task 2021-07-01T16:30:03.650Z] 16:30:03 INFO - checking window state

Anny, are you still working on this?

Flags: needinfo?(agakhokidze)

yup still looking!

Flags: needinfo?(agakhokidze)
Whiteboard: [stockwell disable-recommended] → [stockwell needswork:owner]
Attachment #9230374 - Attachment description: WIP: Bug 1646356 - Wait for hashchange event in a different way for browser_sessionHistory.js, r=kashav! → Bug 1646356 - Wait for hashchange event in a different way for browser_sessionHistory.js, r=kashav!
Attachment #9230374 - Attachment description: Bug 1646356 - Wait for hashchange event in a different way for browser_sessionHistory.js, r=kashav! → Bug 1646356 - In browser_sessionHistory.js wait for hashchange event in a different way, r=kashav!
Attachment #9230374 - Attachment description: Bug 1646356 - In browser_sessionHistory.js wait for hashchange event in a different way, r=kashav! → WIP: Bug 1646356 - Wait for hashchange event in a different way for browser_sessionHistory.js, r=kashav!
Attachment #9230374 - Attachment description: WIP: Bug 1646356 - Wait for hashchange event in a different way for browser_sessionHistory.js, r=kashav! → Bug 1646356 - Wait for hashchange event in a different way for browser_sessionHistory.js, r=kashav!
Pushed by agakhokidze@mozilla.com: https://hg.mozilla.org/integration/autoland/rev/c1e6d9d31d9e Wait for hashchange event in a different way for browser_sessionHistory.js, r=kashav
Status: ASSIGNED → RESOLVED
Closed: 3 years ago
Keywords: leave-open
Resolution: --- → FIXED
Target Milestone: --- → 91 Branch
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Created:
Updated:
Size: