1749416 - Intermittent dom/security/test/https-first/test_redirect_downgrade.html | Test timed out. -

Status: RESOLVED DUPLICATE of bug 1781673

(Core :: DOM: Security, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2022-01-10T22:49:39.295Z] 22:49:39     INFO - TEST-START | dom/security/test/https-first/test_redirect_downgrade.html
[task 2022-01-10T22:49:39.314Z] 22:49:39     INFO - GECKO(9546) | JavaScript error: resource://gre/modules/URLQueryStrippingListService.jsm, line 90: TypeError: can't access property "removeEventListener", Services.cpmm.sharedData is null
[task 2022-01-10T22:49:39.321Z] 22:49:39     INFO - GECKO(9546) | ###!!! [Parent][PCompositorManagerParent] Error: RunMessage(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost
[task 2022-01-10T22:49:39.322Z] 22:49:39     INFO - GECKO(9546) | ###!!! [Parent][PImageBridgeParent] Error: RunMessage(msgname=PImageBridge::Msg_WillClose) Channel closing: too late to send/recv, messages will be lost
[task 2022-01-10T22:49:41.913Z] 22:49:41     INFO - GECKO(9546) | ###!!! [Parent][PCompositorManagerParent] Error: RunMessage(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost
[task 2022-01-10T22:49:41.915Z] 22:49:41     INFO - GECKO(9546) | ###!!! [Parent][PImageBridgeParent] Error: RunMessage(msgname=PImageBridge::Msg_WillClose) Channel closing: too late to send/recv, messages will be lost
[task 2022-01-10T22:49:46.309Z] 22:49:46     INFO - GECKO(9546) | [CodeCoverage] Setting handlers for process 10940.
[task 2022-01-10T22:49:46.322Z] 22:49:46     INFO - GECKO(9546) | [CodeCoverage] Setting handlers for process 10948.
[task 2022-01-10T22:49:46.348Z] 22:49:46     INFO - GECKO(9546) | [CodeCoverage] Setting handlers for process 10945.
[task 2022-01-10T22:49:46.390Z] 22:49:46     INFO - GECKO(9546) | [CodeCoverage] Setting handlers for process 10946.
[task 2022-01-10T22:54:47.060Z] 22:54:47     INFO - TEST-INFO | started process screentopng
[task 2022-01-10T22:54:47.238Z] 22:54:47     INFO - TEST-INFO | screentopng: exit 0
[task 2022-01-10T22:54:47.239Z] 22:54:47     INFO - TEST-UNEXPECTED-FAIL | dom/security/test/https-first/test_redirect_downgrade.html | Test timed out. - 
[task 2022-01-10T22:54:48.066Z] 22:54:48     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-01-10T22:54:48.067Z] 22:54:48     INFO - TEST-UNEXPECTED-FAIL | dom/security/test/https-first/test_redirect_downgrade.html | [SimpleTest.finish()] No checks actually run. (You need to call ok(), is(), or similar functions at least once.  Make sure you use SimpleTest.waitForExplicitFinish() if you need it.) 
[task 2022-01-10T22:54:48.067Z] 22:54:48     INFO -     SimpleTest.ok@SimpleTest/SimpleTest.js:417:16
[task 2022-01-10T22:54:48.067Z] 22:54:48     INFO -     afterCleanup@SimpleTest/SimpleTest.js:1416:18
[task 2022-01-10T22:54:48.068Z] 22:54:48     INFO -     executeCleanupFunction@SimpleTest/SimpleTest.js:1481:7
[task 2022-01-10T22:54:48.068Z] 22:54:48     INFO -     SimpleTest.finish@SimpleTest/SimpleTest.js:1501:3
[task 2022-01-10T22:54:48.068Z] 22:54:48     INFO -     @SimpleTest/SimpleTest.js:2141:16
[task 2022-01-10T22:54:48.080Z] 22:54:48     INFO - GECKO(9546) | MEMORY STAT | vsize 2778MB | residentFast 324MB | heapAllocated 5MB
[task 2022-01-10T22:54:48.092Z] 22:54:48     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-01-10T22:54:48.097Z] 22:54:48     INFO - TEST-UNEXPECTED-FAIL | dom/security/test/https-first/test_redirect_downgrade.html | Redirected successful to 'http' for ?test1a 
[task 2022-01-10T22:54:48.097Z] 22:54:48     INFO -     SimpleTest.ok@SimpleTest/SimpleTest.js:417:16
[task 2022-01-10T22:54:48.098Z] 22:54:48     INFO -     receiveMessage@dom/security/test/https-first/test_redirect_downgrade.html?currentTestURL=dom%2Fsecurity%2Ftest%2Fhttps-first%2Ftest_redirect_downgrade.html&closeWhenDone=1&showTestReport=false&expected=pass:37:5
[task 2022-01-10T22:54:48.098Z] 22:54:48     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-01-10T22:54:48.098Z] 22:54:48     INFO - TEST-UNEXPECTED-FAIL | dom/security/test/https-first/test_redirect_downgrade.html | scheme is 'http' for ?test1a 
[task 2022-01-10T22:54:48.098Z] 22:54:48     INFO -     SimpleTest.ok@SimpleTest/SimpleTest.js:417:16
[task 2022-01-10T22:54:48.098Z] 22:54:48     INFO -     receiveMessage@dom/security/test/https-first/test_redirect_downgrade.html?currentTestURL=dom%2Fsecurity%2Ftest%2Fhttps-first%2Ftest_redirect_downgrade.html&closeWhenDone=1&showTestReport=false&expected=pass:38:5
[task 2022-01-10T22:54:48.208Z] 22:54:48     INFO - GECKO(9546) | JavaScript error: resource://gre/modules/URLQueryStrippingListService.jsm, line 90: TypeError: can't access property "removeEventListener", Services.cpmm.sharedData is null
[task 2022-01-10T22:54:48.219Z] 22:54:48     INFO - GECKO(9546) | ###!!! [Parent][PCompositorManagerParent] Error: RunMessage(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost
[task 2022-01-10T22:54:48.221Z] 22:54:48     INFO - GECKO(9546) | ###!!! [Parent][PImageBridgeParent] Error: RunMessage(msgname=PImageBridge::Msg_WillClose) Channel closing: too late to send/recv, messages will be lost
[task 2022-01-10T22:54:48.244Z] 22:54:48     INFO - TEST-OK | dom/security/test/https-first/test_redirect_downgrade.html | took 308950ms
[task 2022-01-10T22:54:48.672Z] 22:54:48     INFO - GECKO(9546) | ###!!! [Parent][PCompositorManagerParent] Error: RunMessage(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost
[task 2022-01-10T22:54:48.672Z] 22:54:48     INFO - GECKO(9546) | ###!!! [Parent][PImageBridgeParent] Error: RunMessage(msgname=PImageBridge::Msg_WillClose) Channel closing: too late to send/recv, messages will be lost
[task 2022-01-10T22:54:48.791Z] 22:54:48     INFO - TEST-PASS | dom/security/test/https-first/test_redirect_downgrade.html | Redirected successful to 'http' for ?test2a 
[task 2022-01-10T22:54:48.793Z] 22:54:48     INFO - TEST-PASS | dom/security/test/https-first/test_redirect_downgrade.html | scheme is 'http' for ?test2a 
[task 2022-01-10T22:54:49.006Z] 22:54:49     INFO - GECKO(9546) | ###!!! [Parent][PCompositorManagerParent] Error: RunMessage(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost
[task 2022-01-10T22:54:49.006Z] 22:54:49     INFO - GECKO(9546) | ###!!! [Parent][PImageBridgeParent] Error: RunMessage(msgname=PImageBridge::Msg_WillClose) Channel closing: too late to send/recv, messages will be lost
[task 2022-01-10T22:54:49.286Z] 22:54:49     INFO - Not taking screenshot here: see the one that was previously logged
[task 2022-01-10T22:54:49.286Z] 22:54:49     INFO - TEST-UNEXPECTED-FAIL | dom/security/test/https-first/test_redirect_downgrade.html | Redirected successful to 'http' for ?test3a 
[task 2022-01-10T22:54:49.286Z] 22:54:49     INFO -     SimpleTest.ok@SimpleTest/SimpleTest.js:417:16
[task 2022-01-10T22:54:49.286Z] 22:54:49     INFO -     receiveMessage@dom/security/test/https-first/test_redirect_downgrade.html?currentTestURL=dom%2Fsecurity%2Ftest%2Fhttps-first%2Ftest_redirect_downgrade.html&closeWhenDone=1&showTestReport=false&expected=pass:37:5
[task 2022-01-10T22:54:49.286Z] 22:54:49     INFO - TEST-PASS | dom/security/test/https-first/test_redirect_downgrade.html | scheme is 'http' for ?test3a 
[task 2022-01-10T22:54:49.287Z] 22:54:49    ERROR - TEST-UNEXPECTED-FAIL | SimpleTest | this test already called finish!
[task 2022-01-10T22:54:49.431Z] 22:54:49     INFO - TEST-UNEXPECTED-ERROR | dom/security/test/https-first/test_redirect_downgrade.html | called finish() multiple times
[task 2022-01-10T22:54:49.431Z] 22:54:49     INFO - TEST-INFO 
[task 2022-01-10T22:54:49.494Z] 22:54:49     INFO - GECKO(9546) | ###!!! [Parent][PCompositorManagerParent] Error: RunMessage(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost
[task 2022-01-10T22:54:50.413Z] 22:54:50     INFO - GECKO(9546) | JavaScript error: resource://gre/modules/URLQueryStrippingListService.jsm, line 90: TypeError: can't access property "removeEventListener", Services.cpmm.sharedData is null
[task 2022-01-10T22:54:50.420Z] 22:54:50     INFO - GECKO(9546) | ###!!! [Parent][PBackgroundParent] Error: RunMessage(msgname=PRemoteWorkerService::Msg___delete__) Channel closing: too late to send/recv, messages will be lost
[task 2022-01-10T22:54:50.420Z] 22:54:50     INFO - GECKO(9546) | ###!!! [Parent][PCompositorManagerParent] Error: RunMessage(msgname=PCompositorBridge::Msg___delete__) Channel closing: too late to send/recv, messages will be lost
[task 2022-01-10T22:54:50.424Z] 22:54:50     INFO - GECKO(9546) | ###!!! [Parent][PImageBridgeParent] Error: RunMessage(msgname=PImageBridge::Msg_WillClose) Channel closing: too late to send/recv, messages will be lost
[task 2022-01-10T22:54:50.430Z] 22:54:50     INFO - TEST-START | dom/security/test/https-first/test_referrer_policy.html

Comment 1

[Intermittent Failures Robot]

1 failures in 3060 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-ccov-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1749416&startday=2022-01-10&endday=2022-01-16&tree=all

Comment 2

[BugBot [:suhaib / :marco/ :calixte]]

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

Comment 3

[Treeherder Bug Filer]

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

Comment 4

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• windows10-32-2004-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1749416&startday=2022-06-06&endday=2022-06-12&tree=all

Comment 5

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

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

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1749416&startday=2022-06-13&endday=2022-06-19&tree=all

Comment 6

[BugBot [:suhaib / :marco/ :calixte]]

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

Comment 7

[Treeherder Bug Filer]

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

Comment 8

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 5

Platform and build breakdown:

• linux1804-64-ccov-qr: 5
  • opt: 5

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

Comment 9

[Intermittent Failures Robot]

1 failures in 3497 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-ccov-qr: 1
  • opt: 1

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