1636827 - Intermittent TEST-UNEXPECTED-TIMEOUT | /html/cross-origin-opener-policy/iframe-popup-same-origin-allow-popups-to-same-origin-allow-popups.https.html | same-origin-allow-popups with SAME_SITE iframe opening popup a CROSS_ORIGIN with COOP: same-origin-all

Status: RESOLVED INCOMPLETE

(Core :: DOM: Core & HTML, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2020-05-11T01:50:21.314Z] 01:50:21 INFO - TEST-START | /permissions-request/idlharness.any.worker.html
[task 2020-05-11T01:50:21.321Z] 01:50:21 INFO - Closing window 25
[task 2020-05-11T01:50:21.410Z] 01:50:21 INFO - PID 30015 | [Parent 30015, Main Thread] WARNING: NS_ENSURE_TRUE(mPresShell) failed: file /builds/worker/checkouts/gecko/layout/generic/nsFrameSelection.cpp, line 1553
[task 2020-05-11T01:50:21.836Z] 01:50:21 INFO - PID 30015 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpSCLLqk/runtests_leaks_982_tab_pid30351.log
[task 2020-05-11T01:50:21.837Z] 01:50:21 INFO - PID 30015 | [30351, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp, line 225
[task 2020-05-11T01:50:22.297Z] 01:50:22 INFO - PID 30015 | [Child 30250, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/netwerk/base/nsNetUtil.cpp, line 2293
[task 2020-05-11T01:50:22.298Z] 01:50:22 INFO - PID 30015 | [Child 30250, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 398
[task 2020-05-11T01:50:22.298Z] 01:50:22 INFO - PID 30015 | [Child 30250, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 423
[task 2020-05-11T01:50:22.314Z] 01:50:22 INFO - PID 30015 | [Child 30250, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-05-11T01:50:22.353Z] 01:50:22 INFO - PID 30015 | [Child 30351, Main Thread] WARNING: could not set real-time limit at process startup: file /builds/worker/checkouts/gecko/dom/ipc/ContentChild.cpp, line 1640
[task 2020-05-11T01:50:24.432Z] 01:50:24 INFO - .......
[task 2020-05-11T01:50:24.433Z] 01:50:24 INFO - TEST-OK | /permissions-request/idlharness.any.worker.html | took 3118ms
[task 2020-05-11T01:50:24.455Z] 01:50:24 INFO - PID 30015 | 1589161824453 Marionette INFO Stopped listening on port 50965
[task 2020-05-11T01:50:24.929Z] 01:50:24 INFO - PID 30015 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-05-11T01:50:24.950Z] 01:50:24 INFO - PID 30015 | [Child 30313, Main Thread] WARNING: A runnable was posted to a worker that is already shutting down!: file /builds/worker/checkouts/gecko/dom/workers/WorkerPrivate.cpp, line 1433
[task 2020-05-11T01:50:24.951Z] 01:50:24 INFO - PID 30015 | [Child 30313, Main Thread] WARNING: Failed to dispatch offline status change event!: file /builds/worker/checkouts/gecko/dom/workers/WorkerPrivate.cpp, line 1916
[task 2020-05-11T01:50:24.986Z] 01:50:24 INFO - PID 30015 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-05-11T01:50:25.007Z] 01:50:25 INFO - PID 30015 | [2020-05-11T01:50:25Z WARN xulstore::persist] tried to remove key that isn't in the store
[task 2020-05-11T01:50:25.008Z] 01:50:25 INFO - PID 30015 | [2020-05-11T01:50:25Z WARN xulstore::persist] tried to remove key that isn't in the store
[task 2020-05-11T01:50:25.177Z] 01:50:25 INFO - PID 30015 | [Child 30171, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/netwerk/base/nsNetUtil.cpp, line 2293
[task 2020-05-11T01:50:25.177Z] 01:50:25 INFO - PID 30015 | [Child 30171, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 398
[task 2020-05-11T01:50:25.177Z] 01:50:25 INFO - PID 30015 | [Child 30171, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 423
[task 2020-05-11T01:50:25.199Z] 01:50:25 INFO - PID 30015 | [Child 30171, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-05-11T01:50:25.324Z] 01:50:25 INFO - PID 30015 | [Child 30191, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/netwerk/base/nsNetUtil.cpp, line 2293
[task 2020-05-11T01:50:25.324Z] 01:50:25 INFO - PID 30015 | [Child 30191, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 398
[task 2020-05-11T01:50:25.326Z] 01:50:25 INFO - PID 30015 | [Child 30191, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 423
[task 2020-05-11T01:50:25.326Z] 01:50:25 INFO - PID 30015 | [Child 30191, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/netwerk/base/nsNetUtil.cpp, line 2293
[task 2020-05-11T01:50:25.327Z] 01:50:25 INFO - PID 30015 | [Child 30191, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 398
[task 2020-05-11T01:50:25.328Z] 01:50:25 INFO - PID 30015 | [Child 30191, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 423
[task 2020-05-11T01:50:25.329Z] 01:50:25 INFO - PID 30015 | [Child 30191, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/netwerk/base/nsNetUtil.cpp, line 2293
[task 2020-05-11T01:50:25.330Z] 01:50:25 INFO - PID 30015 | [Child 30191, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 398
[task 2020-05-11T01:50:25.332Z] 01:50:25 INFO - PID 30015 | [Child 30191, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 423
[task 2020-05-11T01:50:25.333Z] 01:50:25 INFO - PID 30015 | [Child 30191, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/netwerk/base/nsNetUtil.cpp, line 2293
[task 2020-05-11T01:50:25.335Z] 01:50:25 INFO - PID 30015 | [Child 30191, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 398
[task 2020-05-11T01:50:25.336Z] 01:50:25 INFO - PID 30015 | [Child 30191, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 423
[task 2020-05-11T01:50:25.336Z] 01:50:25 INFO - PID 30015 | [Child 30191, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/netwerk/base/nsNetUtil.cpp, line 2293
[task 2020-05-11T01:50:25.338Z] 01:50:25 INFO - PID 30015 | [Child 30191, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 398
[task 2020-05-11T01:50:25.338Z] 01:50:25 INFO - PID 30015 | [Child 30191, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 423
[task 2020-05-11T01:50:25.367Z] 01:50:25 INFO - PID 30015 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-05-11T01:50:25.368Z] 01:50:25 INFO - PID 30015 | [Child 30191, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-05-11T01:50:25.591Z] 01:50:25 INFO - PID 30015 | [Child 30313, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/netwerk/base/nsNetUtil.cpp, line 2293
[task 2020-05-11T01:50:25.592Z] 01:50:25 INFO - PID 30015 | [Child 30313, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 398
[task 2020-05-11T01:50:25.592Z] 01:50:25 INFO - PID 30015 | [Child 30313, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 423
[task 2020-05-11T01:50:25.612Z] 01:50:25 INFO - PID 30015 | [Child 30313, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-05-11T01:50:25.723Z] 01:50:25 INFO - PID 30015 | [Child 30351, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-05-11T01:50:26.167Z] 01:50:26 INFO - PID 30015 | [Child 30277, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/netwerk/base/nsNetUtil.cpp, line 2293
[task 2020-05-11T01:50:26.167Z] 01:50:26 INFO - PID 30015 | [Child 30277, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 398
[task 2020-05-11T01:50:26.167Z] 01:50:26 INFO - PID 30015 | [Child 30277, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 423
[task 2020-05-11T01:50:26.188Z] 01:50:26 INFO - PID 30015 | [Child 30277, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-05-11T01:50:26.236Z] 01:50:26 INFO - PID 30015 | [Parent 30015, Main Thread] WARNING: NS_ENSURE_TRUE(mDB) failed: file /builds/worker/checkouts/gecko/netwerk/cache/nsDiskCacheDeviceSQL.cpp, line 1279
[task 2020-05-11T01:50:26.333Z] 01:50:26 INFO - PID 30015 | [Parent 30015, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/js/xpconnect/loader/mozJSComponentLoader.cpp, line 228
[task 2020-05-11T01:50:26.333Z] 01:50:26 INFO - PID 30015 | [Parent 30015, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/js/xpconnect/loader/mozJSComponentLoader.cpp, line 255
[task 2020-05-11T01:50:27.329Z] 01:50:27 INFO - PID 30015 | [Parent 30015, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/netwerk/base/nsNetUtil.cpp, line 2293
[task 2020-05-11T01:50:27.330Z] 01:50:27 INFO - PID 30015 | [Parent 30015, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 398
[task 2020-05-11T01:50:27.330Z] 01:50:27 INFO - PID 30015 | [Parent 30015, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 423
[task 2020-05-11T01:50:27.337Z] 01:50:27 INFO - PID 30015 | [Parent 30015, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-05-11T01:50:27.434Z] 01:50:27 INFO - Browser exited with return code 0
[task 2020-05-11T01:50:27.434Z] 01:50:27 INFO - PROCESS LEAKS /tmp/tmpSCLLqk/runtests_leaks_982.log
[task 2020-05-11T01:50:27.435Z] 01:50:27 INFO - leakcheck | Processing log file /tmp/tmpSCLLqk/runtests_leaks_982.log for scope /permissions-request
[task 2020-05-11T01:50:27.435Z] 01:50:27 INFO - TEST-INFO | leakcheck | default process: leak threshold set at 0 bytes
[task 2020-05-11T01:50:27.435Z] 01:50:27 INFO - TEST-INFO | leakcheck | forkserver process: leak threshold set at 0 bytes
[task 2020-05-11T01:50:27.436Z] 01:50:27 INFO - TEST-INFO | leakcheck | gmplugin process: leak threshold set at 20000 bytes
[task 2020-05-11T01:50:27.436Z] 01:50:27 INFO - TEST-INFO | leakcheck | gpu process: leak threshold set at 0 bytes
[task 2020-05-11T01:50:27.436Z] 01:50:27 INFO - TEST-INFO | leakcheck | plugin process: leak threshold set at 0 bytes
[task 2020-05-11T01:50:27.436Z] 01:50:27 INFO - TEST-INFO | leakcheck | rdd process: leak threshold set at 400 bytes
[task 2020-05-11T01:50:27.437Z] 01:50:27 INFO - TEST-INFO | leakcheck | socket process: leak threshold set at 0 bytes
[task 2020-05-11T01:50:27.437Z] 01:50:27 INFO - TEST-INFO | leakcheck | tab process: leak threshold set at 10000 bytes
[task 2020-05-11T01:50:27.438Z] 01:50:27 INFO - TEST-INFO | leakcheck | vr process: leak threshold set at 0 bytes
[task 2020-05-11T01:50:27.439Z] 01:50:27 INFO - leakcheck | Processing leak log file /tmp/tmpSCLLqk/runtests_leaks_982_tab_pid30277.log
[task 2020-05-11T01:50:27.439Z] 01:50:27 INFO -
[task 2020-05-11T01:50:27.440Z] 01:50:27 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 30277
[task 2020-05-11T01:50:27.440Z] 01:50:27 INFO -
[task 2020-05-11T01:50:27.441Z] 01:50:27 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2020-05-11T01:50:27.441Z] 01:50:27 INFO - | | Per-Inst Leaked| Total Rem|
[task 2020-05-11T01:50:27.442Z] 01:50:27 INFO - 0 |TOTAL | 30 0| 276964 0|
[task 2020-05-11T01:50:27.443Z] 01:50:27 INFO -
[task 2020-05-11T01:50:27.443Z] 01:50:27 INFO - nsTraceRefcnt::DumpStatistics: 985 entries
[task 2020-05-11T01:50:27.444Z] 01:50:27 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2020-05-11T01:50:27.445Z] 01:50:27 INFO - leakcheck | Processing leak log file /tmp/tmpSCLLqk/runtests_leaks_982_tab_pid30313.log
[task 2020-05-11T01:50:27.445Z] 01:50:27 INFO -
[task 2020-05-11T01:50:27.446Z] 01:50:27 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 30313
[task 2020-05-11T01:50:27.447Z] 01:50:27 INFO -
[task 2020-05-11T01:50:27.447Z] 01:50:27 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2020-05-11T01:50:27.448Z] 01:50:27 INFO - | | Per-Inst Leaked| Total Rem|
[task 2020-05-11T01:50:27.449Z] 01:50:27 INFO - 0 |TOTAL | 41 0| 48260 0|
[task 2020-05-11T01:50:27.450Z] 01:50:27 INFO -
[task 2020-05-11T01:50:27.450Z] 01:50:27 INFO - nsTraceRefcnt::DumpStatistics: 923 entries
[task 2020-05-11T01:50:27.451Z] 01:50:27 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2020-05-11T01:50:27.452Z] 01:50:27 INFO - leakcheck | Processing leak log file /tmp/tmpSCLLqk/runtests_leaks_982_tab_pid30171.log
[task 2020-05-11T01:50:27.453Z] 01:50:27 INFO -
[task 2020-05-11T01:50:27.453Z] 01:50:27 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 30171
[task 2020-05-11T01:50:27.453Z] 01:50:27 INFO -
[task 2020-05-11T01:50:27.454Z] 01:50:27 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2020-05-11T01:50:27.454Z] 01:50:27 INFO - | | Per-Inst Leaked| Total Rem|
[task 2020-05-11T01:50:27.454Z] 01:50:27 INFO - 0 |TOTAL | 39 0| 51953 0|
[task 2020-05-11T01:50:27.462Z] 01:50:27 INFO -
[task 2020-05-11T01:50:27.463Z] 01:50:27 INFO - nsTraceRefcnt::DumpStatistics: 862 entries
[task 2020-05-11T01:50:27.464Z] 01:50:27 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2020-05-11T01:50:27.465Z] 01:50:27 INFO - leakcheck | Processing leak log file /tmp/tmpSCLLqk/runtests_leaks_982_tab_pid30351.log
[task 2020-05-11T01:50:27.466Z] 01:50:27 INFO -
[task 2020-05-11T01:50:27.467Z] 01:50:27 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 30351
[task 2020-05-11T01:50:27.467Z] 01:50:27 INFO -
[task 2020-05-11T01:50:27.467Z] 01:50:27 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2020-05-11T01:50:27.468Z] 01:50:27 INFO - | | Per-Inst Leaked| Total Rem|
[task 2020-05-11T01:50:27.469Z] 01:50:27 INFO - 0 |TOTAL | 38 0| 17016 0|
[task 2020-05-11T01:50:27.469Z] 01:50:27 INFO -
[task 2020-05-11T01:50:27.470Z] 01:50:27 INFO - nsTraceRefcnt::DumpStatistics: 386 entries
[task 2020-05-11T01:50:27.471Z] 01:50:27 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2020-05-11T01:50:27.472Z] 01:50:27 INFO - leakcheck | Processing leak log file /tmp/tmpSCLLqk/runtests_leaks_982_tab_pid30250.log
[task 2020-05-11T01:50:27.473Z] 01:50:27 INFO -
[task 2020-05-11T01:50:27.473Z] 01:50:27 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 30250
[task 2020-05-11T01:50:27.474Z] 01:50:27 INFO -
[task 2020-05-11T01:50:27.474Z] 01:50:27 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2020-05-11T01:50:27.474Z] 01:50:27 INFO - | | Per-Inst Leaked| Total Rem|
[task 2020-05-11T01:50:27.474Z] 01:50:27 INFO - 0 |TOTAL | 41 0| 44131 0|
[task 2020-05-11T01:50:27.490Z] 01:50:27 INFO -
[task 2020-05-11T01:50:27.491Z] 01:50:27 INFO - nsTraceRefcnt::DumpStatistics: 882 entries
[task 2020-05-11T01:50:27.491Z] 01:50:27 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2020-05-11T01:50:27.491Z] 01:50:27 INFO - leakcheck | Processing leak log file /tmp/tmpSCLLqk/runtests_leaks_982.log
[task 2020-05-11T01:50:27.493Z] 01:50:27 INFO -
[task 2020-05-11T01:50:27.493Z] 01:50:27 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, default process 30015
[task 2020-05-11T01:50:27.494Z] 01:50:27 INFO -
[task 2020-05-11T01:50:27.494Z] 01:50:27 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2020-05-11T01:50:27.495Z] 01:50:27 INFO - | | Per-Inst Leaked| Total Rem|
[task 2020-05-11T01:50:27.495Z] 01:50:27 INFO - 0 |TOTAL | 37 0| 1826556 0|
[task 2020-05-11T01:50:27.512Z] 01:50:27 INFO -
[task 2020-05-11T01:50:27.512Z] 01:50:27 INFO - nsTraceRefcnt::DumpStatistics: 1936 entries
[task 2020-05-11T01:50:27.513Z] 01:50:27 INFO - TEST-PASS | leakcheck | default no leaks detected!
[task 2020-05-11T01:50:27.513Z] 01:50:27 INFO - leakcheck | Processing leak log file /tmp/tmpSCLLqk/runtests_leaks_982_tab_pid30191.log
[task 2020-05-11T01:50:27.514Z] 01:50:27 INFO -
[task 2020-05-11T01:50:27.515Z] 01:50:27 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 30191
[task 2020-05-11T01:50:27.515Z] 01:50:27 INFO -
[task 2020-05-11T01:50:27.516Z] 01:50:27 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2020-05-11T01:50:27.517Z] 01:50:27 INFO - | | Per-Inst Leaked| Total Rem|
[task 2020-05-11T01:50:27.518Z] 01:50:27 INFO - 0 |TOTAL | 38 0| 91567 0|
[task 2020-05-11T01:50:27.519Z] 01:50:27 INFO -
[task 2020-05-11T01:50:27.519Z] 01:50:27 INFO - nsTraceRefcnt::DumpStatistics: 865 entries
[task 2020-05-11T01:50:27.520Z] 01:50:27 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2020-05-11T01:50:27.522Z] 01:50:27 INFO - Closing logging queue
[task 2020-05-11T01:50:27.523Z] 01:50:27 INFO - queue closed
[task 2020-05-11T01:50:27.542Z] 01:50:27 INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox --marionette about:blank -profile /tmp/tmpm0H508
[task 2020-05-11T01:50:27.559Z] 01:50:27 INFO - Starting runner
[task 2020-05-11T01:50:27.598Z] 01:50:27 INFO - PID 30392 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpm0H508/runtests_leaks_982.log
[task 2020-05-11T01:50:27.599Z] 01:50:27 INFO - PID 30392 | [30392, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp, line 225
[task 2020-05-11T01:50:27.650Z] 01:50:27 INFO -
[task 2020-05-11T01:50:27.651Z] 01:50:27 INFO - TEST-PASS | /html/cross-origin-opener-policy/iframe-popup-same-origin-allow-popups-to-same-origin-allow-popups.https.html | same-origin-allow-popups with SAME_ORIGIN iframe opening popup a SAME_ORIGIN with COOP: same-origin-allow-popups
[task 2020-05-11T01:50:27.651Z] 01:50:27 INFO - TEST-PASS | /html/cross-origin-opener-policy/iframe-popup-same-origin-allow-popups-to-same-origin-allow-popups.https.html | same-origin-allow-popups with SAME_SITE iframe opening popup a SAME_ORIGIN with COOP: same-origin-allow-popups
[task 2020-05-11T01:50:27.651Z] 01:50:27 INFO - TEST-PASS | /html/cross-origin-opener-policy/iframe-popup-same-origin-allow-popups-to-same-origin-allow-popups.https.html | same-origin-allow-popups with CROSS_ORIGIN iframe opening popup a SAME_ORIGIN with COOP: same-origin-allow-popups
[task 2020-05-11T01:50:27.651Z] 01:50:27 INFO - TEST-PASS | /html/cross-origin-opener-policy/iframe-popup-same-origin-allow-popups-to-same-origin-allow-popups.https.html | same-origin-allow-popups with SAME_ORIGIN iframe opening popup a SAME_SITE with COOP: same-origin-allow-popups
[task 2020-05-11T01:50:27.652Z] 01:50:27 INFO - TEST-PASS | /html/cross-origin-opener-policy/iframe-popup-same-origin-allow-popups-to-same-origin-allow-popups.https.html | same-origin-allow-popups with SAME_SITE iframe opening popup a SAME_SITE with COOP: same-origin-allow-popups
[task 2020-05-11T01:50:27.652Z] 01:50:27 INFO - TEST-PASS | /html/cross-origin-opener-policy/iframe-popup-same-origin-allow-popups-to-same-origin-allow-popups.https.html | same-origin-allow-popups with CROSS_ORIGIN iframe opening popup a SAME_SITE with COOP: same-origin-allow-popups
[task 2020-05-11T01:50:27.652Z] 01:50:27 INFO - TEST-PASS | /html/cross-origin-opener-policy/iframe-popup-same-origin-allow-popups-to-same-origin-allow-popups.https.html | same-origin-allow-popups with SAME_ORIGIN iframe opening popup a CROSS_ORIGIN with COOP: same-origin-allow-popups
[task 2020-05-11T01:50:27.654Z] 01:50:27 INFO - TEST-UNEXPECTED-TIMEOUT | /html/cross-origin-opener-policy/iframe-popup-same-origin-allow-popups-to-same-origin-allow-popups.https.html | same-origin-allow-popups with SAME_SITE iframe opening popup a CROSS_ORIGIN with COOP: same-origin-allow-popups - Test timed out
[task 2020-05-11T01:50:27.659Z] 01:50:27 INFO - TEST-UNEXPECTED-TIMEOUT | /html/cross-origin-opener-policy/iframe-popup-same-origin-allow-popups-to-same-origin-allow-popups.https.html | expected OK
[task 2020-05-11T01:50:27.660Z] 01:50:27 INFO - TEST-INFO took 182364ms
[task 2020-05-11T01:50:27.709Z] 01:50:27 INFO - PID 22112 | 1589161827698 Marionette INFO Stopped listening on port 35028
[task 2020-05-11T01:50:27.715Z] 01:50:27 INFO - PID 22112 | JavaScript error: chrome://browser/content/browser.js, line 7818: TypeError: can't access property "processMessageManager", browser.messageManager is null
[task 2020-05-11T01:50:27.889Z] 01:50:27 INFO - PID 22112 | WARNING: A blocker encountered an error while we were waiting.
[task 2020-05-11T01:50:27.891Z] 01:50:27 INFO - PID 22112 | Blocker: SessionStore: flushing all windows
[task 2020-05-11T01:50:27.891Z] 01:50:27 INFO - PID 22112 | Phase: quit-application-granted
[task 2020-05-11T01:50:27.897Z] 01:50:27 INFO - PID 22112 | State: {"total":-1,"current":-1}
[task 2020-05-11T01:50:27.897Z] 01:50:27 INFO - PID 22112 | WARNING: TypeError: can't access property "sendAsyncMessage", mm is null
[task 2020-05-11T01:50:27.898Z] 01:50:27 INFO - PID 22112 | WARNING: flush@resource:///modules/sessionstore/TabStateFlusher.jsm:97:5
[task 2020-05-11T01:50:27.898Z] 01:50:27 INFO - PID 22112 | flushWindow@resource:///modules/sessionstore/TabStateFlusher.jsm:127:28
[task 2020-05-11T01:50:27.899Z] 01:50:27 INFO - PID 22112 | flushWindow@resource:///modules/sessionstore/TabStateFlusher.jsm:31:36
[task 2020-05-11T01:50:27.899Z] 01:50:27 INFO - PID 22112 | flushAllWindowsAsync@resource:///modules/sessionstore/SessionStore.jsm:2287:50
[task 2020-05-11T01:50:27.900Z] 01:50:27 INFO - PID 22112 | ssi_onQuitApplicationGranted/<@resource:///modules/sessionstore/SessionStore.jsm:2211:32
[task 2020-05-11T01:50:27.901Z] 01:50:27 INFO - PID 22112 | trigger@resource://gre/modules/AsyncShutdown.jsm:726:23
[task 2020-05-11T01:50:27.902Z] 01:50:27 INFO - PID 22112 | _wait@resource://gre/modules/AsyncShutdown.jsm:878:15
[task 2020-05-11T01:50:27.902Z] 01:50:27 INFO - PID 22112 | wait@resource://gre/modules/AsyncShutdown.jsm:859:34
[task 2020-05-11T01:50:27.903Z] 01:50:27 INFO - PID 22112 | observe@resource://gre/modules/AsyncShutdown.jsm:536:10
[task 2020-05-11T01:50:27.903Z] 01:50:27 INFO - PID 22112 | GeckoDriver.prototype.quit@chrome://marionette/content/driver.js:3514:20
[task 2020-05-11T01:50:27.905Z] 01:50:27 INFO - PID 22112 | despatch@chrome://marionette/content/server.js:305:40
[task 2020-05-11T01:50:27.905Z] 01:50:27 INFO - PID 22112 | execute@chrome://marionette/content/server.js:275:16
[task 2020-05-11T01:50:27.905Z] 01:50:27 INFO - PID 22112 | onPacket/<@chrome://marionette/content/server.js:248:20
[task 2020-05-11T01:50:27.906Z] 01:50:27 INFO - PID 22112 | onPacket@chrome://marionette/content/server.js:249:9
[task 2020-05-11T01:50:27.907Z] 01:50:27 INFO - PID 22112 | _onJSONObjectReady/<@chrome://marionette/content/transport.js:501:20
[task 2020-05-11T01:50:27.916Z] 01:50:27 INFO - PID 22112 | JavaScript error: resource:///modules/sessionstore/SessionStore.jsm, line 5854: TypeError: can't access property "sendAsyncMessage", browser.messageManager is null
[task 2020-05-11T01:50:28.157Z] 01:50:28 INFO - PID 22112 | JavaScript error: resource:///modules/sessionstore/TabStateFlusher.jsm, line 97: TypeError: can't access property "sendAsyncMessage", mm is null
[task 2020-05-11T01:50:28.201Z] 01:50:28 INFO - PID 22112 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-05-11T01:50:28.249Z] 01:50:28 INFO - PID 22112 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-05-11T01:50:28.278Z] 01:50:28 INFO - PID 22112 | [2020-05-11T01:50:28Z WARN xulstore::persist] tried to remove key that isn't in the store
[task 2020-05-11T01:50:28.278Z] 01:50:28 INFO - PID 22112 | [2020-05-11T01:50:28Z WARN xulstore::persist] tried to remove key that isn't in the store
[task 2020-05-11T01:50:28.461Z] 01:50:28 INFO - PID 22112 | [Child 22326, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/netwerk/base/nsNetUtil.cpp, line 2293
[task 2020-05-11T01:50:28.465Z] 01:50:28 INFO - PID 22112 | [Child 22326, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 398
[task 2020-05-11T01:50:28.465Z] 01:50:28 INFO - PID 22112 | [Child 22326, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 423
[task 2020-05-11T01:50:28.465Z] 01:50:28 INFO - PID 22112 | [Child 22326, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/netwerk/base/nsNetUtil.cpp, line 2293
[task 2020-05-11T01:50:28.465Z] 01:50:28 INFO - PID 22112 | [Child 22326, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 398
[task 2020-05-11T01:50:28.465Z] 01:50:28 INFO - PID 22112 | [Child 22326, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/caps/ContentPrincipal.cpp, line 423
[task 2020-05-11T01:50:28.522Z] 01:50:28 INFO - PID 22112 | [Child 22326, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 1

Platform breakdown:

• linux1804-64: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1636827&startday=2020-05-11&endday=2020-05-17&tree=all

Comment 2

[Anne (:annevk)]

Didn't happen in the last 22 days, closing.