1844440 - Intermittent toolkit/components/pdfjs/test/browser_pdfjs_load_telemetry.js | single tracking bug

Status: RESOLVED INCOMPLETE

(Firefox :: PDF Viewer, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2023-07-19T17:49:30.705Z] 17:49:30     INFO - TEST-PASS | toolkit/components/pdfjs/test/browser_pdfjs_load_telemetry.js | "undefined" == "undefined" - 
[task 2023-07-19T17:49:30.705Z] 17:49:30     INFO - TEST-PASS | toolkit/components/pdfjs/test/browser_pdfjs_load_telemetry.js | 0 == 0 - 
[task 2023-07-19T17:49:30.706Z] 17:49:30     INFO - Buffered messages finished
[task 2023-07-19T17:49:30.706Z] 17:49:30     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/pdfjs/test/browser_pdfjs_load_telemetry.js | Test timed out - 
[task 2023-07-19T17:49:30.707Z] 17:49:30     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-19T17:49:30.714Z] 17:49:30     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/pdfjs/test/browser_pdfjs_load_telemetry.js | waiting for vsync to be disabled - timed out after 50 tries. - false == true - {"filename":"chrome://mochikit/content/browser-test.js","name":"ensureVsyncDisabled","sourceId":542,"lineNumber":603,"columnNumber":19,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"nextTest","sourceId":542,"lineNumber":768,"columnNumber":18,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"timeoutFn","sourceId":542,"lineNumber":1437,"columnNumber":18,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"Tester_execTest","sourceId":542,"lineNumber":1379,"columnNumber":45,"sourceLine":"","asyncCause":"setTimeout handler","asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"nextTest/<","sourceId":542,"lineNumber":1120,"columnNumber":14,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/tests/SimpleTest/SimpleTest.js","name":"SimpleTest.waitForFocus/<","sourceId":566,"lineNumber":1056,"columnNumber":13,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":null,"formattedStack":"SimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"nextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"setTimeout handler*Tester_execTest@chrome://mochikit/content/browser-test.js:1379:45\nnextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"caller":null,"formattedStack":"timeoutFn@chrome://mochikit/content/browser-test.js:1437:18\nsetTimeout handler*Tester_execTest@chrome://mochikit/content/browser-test.js:1379:45\nnextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"async*nextTest@chrome://mochikit/content/browser-test.js:768:18\ntimeoutFn@chrome://mochikit/content/browser-test.js:1437:18\nsetTimeout handler*Tester_execTest@chrome://mochikit/content/browser-test.js:1379:45\nnextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"caller":null,"formattedStack":"ensureVsyncDisabled@chrome://mochikit/content/browser-test.js:603:19\nasync*nextTest@chrome://mochikit/content/browser-test.js:768:18\ntimeoutFn@chrome://mochikit/content/browser-test.js:1437:18\nsetTimeout handler*Tester_execTest@chrome://mochikit/content/browser-test.js:1379:45\nnextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}}
[task 2023-07-19T17:49:30.714Z] 17:49:30     INFO - Stack trace:
[task 2023-07-19T17:49:30.714Z] 17:49:30     INFO - chrome://mochikit/content/browser-test.js:ensureVsyncDisabled:603
[task 2023-07-19T17:49:30.714Z] 17:49:30     INFO - chrome://mochikit/content/browser-test.js:nextTest:768
[task 2023-07-19T17:49:30.714Z] 17:49:30     INFO - chrome://mochikit/content/browser-test.js:timeoutFn:1437
[task 2023-07-19T17:49:30.714Z] 17:49:30     INFO - setTimeout handler*chrome://mochikit/content/browser-test.js:Tester_execTest:1379
[task 2023-07-19T17:49:30.714Z] 17:49:30     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1120
[task 2023-07-19T17:49:30.714Z] 17:49:30     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1056
[task 2023-07-19T17:49:30.715Z] 17:49:30     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-19T17:49:30.722Z] 17:49:30     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/pdfjs/test/browser_pdfjs_load_telemetry.js | vsync remained enabled at the end of the test. Is there an animation still running? Consider talking to the performance team for tips to solve this. - false == true - {"filename":"chrome://mochikit/content/browser-test.js","name":"ensureVsyncDisabled","sourceId":542,"lineNumber":604,"columnNumber":19,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"nextTest","sourceId":542,"lineNumber":768,"columnNumber":18,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"timeoutFn","sourceId":542,"lineNumber":1437,"columnNumber":18,"sourceLine":"","asyncCause":null,"asyncCaller":{"filename":"chrome://mochikit/content/browser-test.js","name":"Tester_execTest","sourceId":542,"lineNumber":1379,"columnNumber":45,"sourceLine":"","asyncCause":"setTimeout handler","asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/browser-test.js","name":"nextTest/<","sourceId":542,"lineNumber":1120,"columnNumber":14,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":{"filename":"chrome://mochikit/content/tests/SimpleTest/SimpleTest.js","name":"SimpleTest.waitForFocus/<","sourceId":566,"lineNumber":1056,"columnNumber":13,"sourceLine":"","asyncCause":null,"asyncCaller":null,"caller":null,"formattedStack":"SimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"nextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"setTimeout handler*Tester_execTest@chrome://mochikit/content/browser-test.js:1379:45\nnextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"caller":null,"formattedStack":"timeoutFn@chrome://mochikit/content/browser-test.js:1437:18\nsetTimeout handler*Tester_execTest@chrome://mochikit/content/browser-test.js:1379:45\nnextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"formattedStack":"async*nextTest@chrome://mochikit/content/browser-test.js:768:18\ntimeoutFn@chrome://mochikit/content/browser-test.js:1437:18\nsetTimeout handler*Tester_execTest@chrome://mochikit/content/browser-test.js:1379:45\nnextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}},"caller":null,"formattedStack":"ensureVsyncDisabled@chrome://mochikit/content/browser-test.js:604:19\nasync*nextTest@chrome://mochikit/content/browser-test.js:768:18\ntimeoutFn@chrome://mochikit/content/browser-test.js:1437:18\nsetTimeout handler*Tester_execTest@chrome://mochikit/content/browser-test.js:1379:45\nnextTest/<@chrome://mochikit/content/browser-test.js:1120:14\nSimpleTest.waitForFocus/<@chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:1056:13\n","nativeSavedFrame":{}}
[task 2023-07-19T17:49:30.722Z] 17:49:30     INFO - Stack trace:
[task 2023-07-19T17:49:30.722Z] 17:49:30     INFO - chrome://mochikit/content/browser-test.js:ensureVsyncDisabled:604
[task 2023-07-19T17:49:30.722Z] 17:49:30     INFO - chrome://mochikit/content/browser-test.js:nextTest:768
[task 2023-07-19T17:49:30.722Z] 17:49:30     INFO - chrome://mochikit/content/browser-test.js:timeoutFn:1437
[task 2023-07-19T17:49:30.722Z] 17:49:30     INFO - setTimeout handler*chrome://mochikit/content/browser-test.js:Tester_execTest:1379
[task 2023-07-19T17:49:30.722Z] 17:49:30     INFO - chrome://mochikit/content/browser-test.js:nextTest/<:1120
[task 2023-07-19T17:49:30.722Z] 17:49:30     INFO - chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/<:1056
[task 2023-07-19T17:49:30.722Z] 17:49:30     INFO - GECKO(4684) | MEMORY STAT | vsize 2104451MB | vsizeMaxContiguous 70030201MB | residentFast 338MB | heapAllocated 103MB
[task 2023-07-19T17:49:30.723Z] 17:49:30     INFO - TEST-OK | toolkit/components/pdfjs/test/browser_pdfjs_load_telemetry.js | took 50552ms
[task 2023-07-19T17:49:30.724Z] 17:49:30     INFO - Not taking screenshot here: see the one that was previously logged
[task 2023-07-19T17:49:30.724Z] 17:49:30     INFO - TEST-UNEXPECTED-FAIL | toolkit/components/pdfjs/test/browser_pdfjs_load_telemetry.js | Found a tab after previous test timed out: about:blank - 
[task 2023-07-19T17:49:30.725Z] 17:49:30     INFO - checking window state
[task 2023-07-19T17:49:30.725Z] 17:49:30     INFO - TEST-START | toolkit/components/pdfjs/test/browser_pdfjs_main.js

Comment 1

[Intermittent Failures Robot]

1 failures in 3520 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• windows11-64-2009-ccov-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1844440&startday=2023-07-17&endday=2023-07-23&tree=all

Comment 2

[BugBot [:suhaib / :marco]]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.

Comment 3

[Treeherder Bug Filer]

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=441061373&repo=autoland

Comment 4

[Intermittent Failures Robot]

1 failures in 3349 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1844440&startday=2023-12-18&endday=2023-12-24&tree=all

Comment 5

[Intermittent Failures Robot]

1 failures in 2274 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1844440&startday=2024-01-01&endday=2024-01-07&tree=all

Comment 6

[Intermittent Failures Robot]

2 failures in 3217 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1
• try: 1

Platform and build breakdown:

• linux1804-64-qr: 2
  • opt: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1844440&startday=2024-01-08&endday=2024-01-14&tree=all

Comment 7

[BugBot [:suhaib / :marco]]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.

Comment 8

[Treeherder Bug Filer]

New failure instance: https://treeherder.mozilla.org/logviewer?job_id=452655622&repo=mozilla-central

Comment 9

[Intermittent Failures Robot]

1 failures in 3590 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• linux1804-64-shippable-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1844440&startday=2024-03-25&endday=2024-03-31&tree=all

Comment 10

[BugBot [:suhaib / :marco]]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.