1598983 - Intermittent TEST-UNEXPECTED-PASS | /fetch/metadata/redirect/redirect-https-downgrade.tentative.sub.html | Https downgrade prefetch => No headers - expected TIMEOUT

Status: RESOLVED INCOMPLETE

(Core :: DOM: Networking, defect, P3)

Description

[Treeherder Bug Filer]

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

---

[task 2019-11-24T22:17:59.417Z] 22:17:59 INFO - TEST-PASS | /fetch/metadata/redirect/redirect-https-downgrade.tentative.sub.html | Https downgrade object
[task 2019-11-24T22:17:59.417Z] 22:17:59 INFO - TEST-UNEXPECTED-PASS | /fetch/metadata/redirect/redirect-https-downgrade.tentative.sub.html | Https downgrade prefetch => No headers - expected TIMEOUT
[task 2019-11-24T22:17:59.417Z] 22:17:59 INFO - TEST-INFO | expected TIMEOUT
[task 2019-11-24T22:17:59.418Z] 22:17:59 INFO - ......
[task 2019-11-24T22:17:59.418Z] 22:17:59 INFO - TEST-TIMEOUT | /fetch/metadata/redirect/redirect-https-downgrade.tentative.sub.html | took 30806ms
[task 2019-11-24T22:17:59.446Z] 22:17:59 INFO - PID 20877 | 1574633879440 Marionette INFO Stopped listening on port 45615
[task 2019-11-24T22:17:59.535Z] 22:17:59 INFO - PID 20877 | --DOCSHELL 0x7f1dcea19800 == 2 [pid = 20987] [id = {98d3e672-6737-462c-9f5e-cabff57a7372}] [url = moz-extension://a1816beb-133f-4e57-ba05-d86f765a1d24/_generated_background_page.html]
[task 2019-11-24T22:17:59.535Z] 22:17:59 INFO - PID 20877 | --DOCSHELL 0x7f1dcd0ec800 == 1 [pid = 20987] [id = {727322a8-80c8-4821-aef2-9a10b7df2e32}] [url = moz-extension://09f85d4d-78e4-4fd9-b0ba-b417f1f340ae/_generated_background_page.html]
[task 2019-11-24T22:17:59.535Z] 22:17:59 INFO - PID 20877 | --DOCSHELL 0x7f1dcea1c000 == 0 [pid = 20987] [id = {be3235eb-daf0-4125-9895-4a22bec4d612}] [url = moz-extension://99ae9c75-4940-40ba-a802-54f1bdbaccb6/_generated_background_page.html]
[task 2019-11-24T22:17:59.657Z] 22:17:59 INFO - PID 20877 | [GPU 20931, Compositor] WARNING: Possibly dropping task posted to updater thread: file /builds/worker/workspace/build/src/gfx/layers/apz/src/APZUpdater.cpp, line 429
[task 2019-11-24T22:17:59.672Z] 22:17:59 INFO - PID 20877 | --DOCSHELL 0x7fe215fce000 == 3 [pid = 21324] [id = {52b8cb23-64e8-42eb-a63a-359e96fdcc12}] [url = http://web-platform.test:8000/fetch/metadata/resources/post-to-owner.py?iframe-navigation01c4032d-88ba-4339-86b8-8098028b64a5&location=http%3A%2F%2Fweb-platform.test%3A8000%2Ffetch%2Fmetadata%2Fresources%2Fpost-to-owner.py%3Fiframe-navigation01c4032d-88ba-4339-86b8-8098028b64a5&count=1]
[task 2019-11-24T22:17:59.673Z] 22:17:59 INFO - PID 20877 | --DOCSHELL 0x7fe216353800 == 2 [pid = 21324] [id = {44ae45d8-3b9b-47e7-9669-b411b828bd13}] [url = http://web-platform.test:8000/fetch/metadata/resources/record-header.py?file=embed-https-redirect01c4032d-88ba-4339-86b8-8098028b64a5&location=http%3A%2F%2Fweb-platform.test%3A8000%2Ffetch%2Fmetadata%2Fresources%2Frecord-header.py%3Ffile%3Dembed-https-redirect01c4032d-88ba-4339-86b8-8098028b64a5&count=1]
[task 2019-11-24T22:17:59.673Z] 22:17:59 INFO - PID 20877 | --DOCSHELL 0x7fe215fc8000 == 1 [pid = 21324] [id = {eb667d7c-3a4b-46d3-9c28-ba65d7bbd5b5}] [url = http://web-platform.test:8000/fetch/metadata/resources/record-header.py?file=object-https-redirect01c4032d-88ba-4339-86b8-8098028b64a5&location=http%3A%2F%2Fweb-platform.test%3A8000%2Ffetch%2Fmetadata%2Fresources%2Frecord-header.py%3Ffile%3Dobject-https-redirect01c4032d-88ba-4339-86b8-8098028b64a5&count=1]
[task 2019-11-24T22:17:59.701Z] 22:17:59 INFO - PID 20877 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2019-11-24T22:17:59.717Z] 22:17:59 INFO - PID 20877 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2019-11-24T22:17:59.717Z] 22:17:59 INFO - PID 20877 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2019-11-24T22:17:59.814Z] 22:17:59 INFO - PID 20877 | --DOCSHELL 0x7fe2163e6000 == 0 [pid = 21324] [id = {b2bc8d5f-260f-404c-bf7c-cff029700b16}] [url = http://web-platform.test:8000/fetch/metadata/redirect/redirect-https-downgrade.tentative.sub.html]
[task 2019-11-24T22:17:59.834Z] 22:17:59 INFO - PID 20877 | [2019-11-24T22:17:59Z WARN xulstore::persist] tried to remove key that isn't in the store
[task 2019-11-24T22:17:59.834Z] 22:17:59 INFO - PID 20877 | [2019-11-24T22:17:59Z WARN xulstore::persist] tried to remove key that isn't in the store
[task 2019-11-24T22:17:59.891Z] 22:17:59 INFO - PID 20877 | --DOCSHELL 0x7f3ab6de5800 == 1 [pid = 21014] [id = {ae73823c-efe7-4ce5-b35d-2a62a182009d}] [url = http://web-platform.test:8000/testharness_runner.html]
[task 2019-11-24T22:17:59.898Z] 22:17:59 INFO - PID 20877 | --DOMWINDOW == 9 (0x7fe216ca8880) [pid = 21324] [serial = 6] [outer = (nil)] [url = http://web-platform.test:8000/fetch/metadata/resources/post-to-owner.py?top-level-navigation01c4032d-88ba-4339-86b8-8098028b64a5&location=http%3A%2F%2Fweb-platform.test%3A8000%2Ffetch%2Fmetadata%2Fresources%2Fpost-to-owner.py%3Ftop-level-navigation01c4032d-88ba-4339-86b8-8098028b64a5&count=1]
[task 2019-11-24T22:17:59.899Z] 22:17:59 INFO - PID 20877 | --DOMWINDOW == 8 (0x7fe216ca86a0) [pid = 21324] [serial = 5] [outer = (nil)] [url = http://web-platform.test:8000/fetch/metadata/resources/post-to-owner.py?iframe-navigation01c4032d-88ba-4339-86b8-8098028b64a5&location=http%3A%2F%2Fweb-platform.test%3A8000%2Ffetch%2Fmetadata%2Fresources%2Fpost-to-owner.py%3Fiframe-navigation01c4032d-88ba-4339-86b8-8098028b64a5&count=1]
[task 2019-11-24T22:17:59.899Z] 22:17:59 INFO - PID 20877 | --DOMWINDOW == 7 (0x7fe21639e200) [pid = 21324] [serial = 10] [outer = (nil)] [url = http://web-platform.test:8000/fetch/metadata/resources/record-header.py?file=embed-https-redirect01c4032d-88ba-4339-86b8-8098028b64a5&location=http%3A%2F%2Fweb-platform.test%3A8000%2Ffetch%2Fmetadata%2Fresources%2Frecord-header.py%3Ffile%3Dembed-https-redirect01c4032d-88ba-4339-86b8-8098028b64a5&count=1]
[task 2019-11-24T22:17:59.899Z] 22:17:59 INFO - PID 20877 | --DOMWINDOW == 6 (0x7fe21639e020) [pid = 21324] [serial = 12] [outer = (nil)] [url = http://web-platform.test:8000/fetch/metadata/resources/record-header.py?file=object-https-redirect01c4032d-88ba-4339-86b8-8098028b64a5&location=http%3A%2F%2Fweb-platform.test%3A8000%2Ffetch%2Fmetadata%2Fresources%2Frecord-header.py%3Ffile%3Dobject-https-redirect01c4032d-88ba-4339-86b8-8098028b64a5&count=1]
[task 2019-11-24T22:17:59.900Z] 22:17:59 INFO - PID 20877 | --DOMWINDOW == 5 (0x7fe216c23800) [pid = 21324] [serial = 8] [outer = (nil)] [url = about:blank]
[task 2019-11-24T22:17:59.900Z] 22:17:59 INFO - PID 20877 | --DOMWINDOW == 4 (0x7fe216c2c000) [pid = 21324] [serial = 9] [outer = (nil)] [url = http://web-platform.test:8000/fetch/metadata/resources/post-to-owner.py?iframe-navigation01c4032d-88ba-4339-86b8-8098028b64a5&location=http%3A%2F%2Fweb-platform.test%3A8000%2Ffetch%2Fmetadata%2Fresources%2Fpost-to-owner.py%3Fiframe-navigation01c4032d-88ba-4339-86b8-8098028b64a5&count=1]
[task 2019-11-24T22:17:59.900Z] 22:17:59 INFO - PID 20877 | --DOMWINDOW == 3 (0x7fe212c3a000) [pid = 21324] [serial = 11] [outer = (nil)] [url = http://web-platform.test:8000/fetch/metadata/resources/record-header.py?file=embed-https-redirect01c4032d-88ba-4339-86b8-8098028b64a5&location=http%3A%2F%2Fweb-platform.test%3A8000%2Ffetch%2Fmetadata%2Fresources%2Frecord-header.py%3Ffile%3Dembed-https-redirect01c4032d-88ba-4339-86b8-8098028b64a5&count=1]
[task 2019-11-24T22:17:59.901Z] 22:17:59 INFO - PID 20877 | --DOMWINDOW == 2 (0x7fe217de4000) [pid = 21324] [serial = 4] [outer = (nil)] [url = http://web-platform.test:8000/fetch/metadata/redirect/redirect-https-downgrade.tentative.sub.html]
[task 2019-11-24T22:17:59.901Z] 22:17:59 INFO - PID 20877 | --DOMWINDOW == 1 (0x7fe216ca7f20) [pid = 21324] [serial = 1] [outer = (nil)] [url = http://web-platform.test:8000/fetch/metadata/redirect/redirect-https-downgrade.tentative.sub.html]
[task 2019-11-24T22:17:59.903Z] 22:17:59 INFO - PID 20877 | --DOMWINDOW == 0 (0x7fe212c33400) [pid = 21324] [serial = 13] [outer = (nil)] [url = http://web-platform.test:8000/fetch/metadata/resources/record-header.py?file=object-https-redirect01c4032d-88ba-4339-86b8-8098028b64a5&location=http%3A%2F%2Fweb-platform.test%3A8000%2Ffetch%2Fmetadata%2Fresources%2Frecord-header.py%3Ffile%3Dobject-https-redirect01c4032d-88ba-4339-86b8-8098028b64a5&count=1]
[task 2019-11-24T22:17:59.903Z] 22:17:59 INFO - PID 20877 | --DOMWINDOW == 5 (0x7f1dced784c0) [pid = 20987] [serial = 1] [outer = (nil)] [url = moz-extension://09f85d4d-78e4-4fd9-b0ba-b417f1f340ae/_generated_background_page.html]
[task 2019-11-24T22:17:59.904Z] 22:17:59 INFO - PID 20877 | --DOMWINDOW == 4 (0x7f1dced77200) [pid = 20987] [serial = 3] [outer = (nil)] [url = moz-extension://a1816beb-133f-4e57-ba05-d86f765a1d24/_generated_background_page.html]
[task 2019-11-24T22:17:59.904Z] 22:17:59 INFO - PID 20877 | --DOMWINDOW == 3 (0x7f1dced773e0) [pid = 20987] [serial = 5] [outer = (nil)] [url = moz-extension://99ae9c75-4940-40ba-a802-54f1bdbaccb6/_generated_background_page.html]
[task 2019-11-24T22:17:59.905Z] 22:17:59 INFO - PID 20877 | --DOMWINDOW == 2 (0x7f1dcccb4800) [pid = 20987] [serial = 11] [outer = (nil)] [url = moz-extension://99ae9c75-4940-40ba-a802-54f1bdbaccb6/_generated_background_page.html]
[task 2019-11-24T22:17:59.905Z] 22:17:59 INFO - PID 20877 | --DOMWINDOW == 1 (0x7f1dcedae400) [pid = 20987] [serial = 10] [outer = (nil)] [url = moz-extension://a1816beb-133f-4e57-ba05-d86f765a1d24/_generated_background_page.html]
[task 2019-11-24T22:17:59.907Z] 22:17:59 INFO - PID 20877 | --DOMWINDOW == 0 (0x7f1dceaab400) [pid = 20987] [serial = 9] [outer = (nil)] [url = moz-extension://09f85d4d-78e4-4fd9-b0ba-b417f1f340ae/_generated_background_page.html]
[task 2019-11-24T22:17:59.943Z] 22:17:59 INFO - PID 20877 | nsStringStats
[task 2019-11-24T22:17:59.943Z] 22:17:59 INFO - PID 20877 | => mAllocCount: 12434
[task 2019-11-24T22:17:59.943Z] 22:17:59 INFO - PID 20877 | => mReallocCount: 0
[task 2019-11-24T22:17:59.944Z] 22:17:59 INFO - PID 20877 | => mFreeCount: 12434
[task 2019-11-24T22:17:59.944Z] 22:17:59 INFO - PID 20877 | => mShareCount: 16822
[task 2019-11-24T22:17:59.945Z] 22:17:59 INFO - PID 20877 | => mAdoptCount: 599
[task 2019-11-24T22:17:59.945Z] 22:17:59 INFO - PID 20877 | => mAdoptFreeCount: 627
[task 2019-11-24T22:17:59.945Z] 22:17:59 INFO - PID 20877 | => Process ID: 21324, Thread ID: 140609483843392

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-central: 1

Platform breakdown:

• linux64-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1598983&startday=2019-11-18&endday=2019-11-24&tree=all

Comment 2

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 2
• mozilla-central: 1
• try: 1

Platform breakdown:

• macosx1014-64: 3
• windows10-64-qr: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1598983&startday=2019-11-25&endday=2019-12-01&tree=all

Comment 3

[Intermittent Failures Robot]

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

Repository breakdown:

• try: 2

Platform breakdown:

• linux64: 2

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1598983&startday=2019-12-02&endday=2019-12-08&tree=all

Comment 4

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-release: 1

Platform breakdown:

• macosx1014-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1598983&startday=2019-12-30&endday=2020-01-05&tree=all

Comment 5

[Jens Stutte [:jstutte]]

Bulk closing some old intermittents.