Open
Bug 1916784
Opened 2 months ago
Updated 3 days ago
Intermittent TV leakcheck | default 12092 bytes leaked (AsyncPanZoomController, CompositorManagerParent, CondVar, GestureEventListener, ISurfaceAllocator, ...)
Categories
(Core :: Panning and Zooming, defect, P5)
Core
Panning and Zooming
Tracking
()
NEW
People
(Reporter: intermittent-bug-filer, Unassigned)
References
(Regression)
Details
(Keywords: intermittent-failure, regression, test-verify-fail)
Filed by: abutkovits [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=472922112&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/A7RRkZKaR6i-Nx9qe2sBng/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/A7RRkZKaR6i-Nx9qe2sBng/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1
[task 2024-09-04T16:29:10.275Z] 16:29:10 INFO - TEST-OK | gfx/layers/apz/test/mochitest/test_group_fission.html | took 6537ms
[task 2024-09-04T16:29:10.501Z] 16:29:10 INFO - TEST-START | Shutdown
[task 2024-09-04T16:29:10.503Z] 16:29:10 INFO - Passed: 44
[task 2024-09-04T16:29:10.505Z] 16:29:10 INFO - Failed: 0
[task 2024-09-04T16:29:10.507Z] 16:29:10 INFO - Todo: 0
[task 2024-09-04T16:29:10.508Z] 16:29:10 INFO - Mode: e10s
[task 2024-09-04T16:29:10.511Z] 16:29:10 INFO - Slowest: 9341ms - /tests/gfx/layers/apz/test/mochitest/test_group_fission.html
[task 2024-09-04T16:29:10.513Z] 16:29:10 INFO - TEST-INFO | Ran 11 Loops
[task 2024-09-04T16:29:10.514Z] 16:29:10 INFO - SimpleTest FINISHED
[task 2024-09-04T16:29:11.075Z] 16:29:11 INFO - GECKO(1106) | 1725467351074 Marionette TRACE Received observer notification quit-application
[task 2024-09-04T16:29:11.077Z] 16:29:11 INFO - GECKO(1106) | 1725467351074 Marionette INFO Stopped listening on port 2828
[task 2024-09-04T16:29:11.081Z] 16:29:11 INFO - GECKO(1106) | 1725467351080 Marionette DEBUG Marionette stopped listening
[task 2024-09-04T16:29:11.172Z] 16:29:11 INFO - GECKO(1106) | [Child 1364, IPC I/O Child] WARNING: [759EB492C232599E.2E1D891AB9AE2724]: GetUserData call for port '29085FCCDC175C7D.819B8FD5677B5D17' failed: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:424
[task 2024-09-04T16:29:11.176Z] 16:29:11 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: Not resolving response 'PIdleScheduler::Reply_RequestGC': actor is dead: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:861
[task 2024-09-04T16:29:11.192Z] 16:29:11 INFO - GECKO(1106) | [Parent 1106, IPC I/O Parent] WARNING: [1.1]: GetUserData call for port 'E425A65EAACFCD38.9F03B4D8937CC3A7' failed: file /builds/worker/checkouts/gecko/ipc/glue/NodeController.cpp:424
[task 2024-09-04T16:29:11.219Z] 16:29:11 INFO - GECKO(1106) | [Parent 1106, Socket Thread] WARNING: cannot post event if not initialized: file /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpConnectionMgr.cpp:240
[task 2024-09-04T16:29:11.219Z] 16:29:11 INFO - GECKO(1106) | [Parent 1106, Socket Thread] WARNING: cannot post event if not initialized: file /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpConnectionMgr.cpp:240
[task 2024-09-04T16:29:11.220Z] 16:29:11 INFO - GECKO(1106) | [Parent 1106, Socket Thread] WARNING: cannot post event if not initialized: file /builds/worker/checkouts/gecko/netwerk/protocol/http/nsHttpConnectionMgr.cpp:240
[task 2024-09-04T16:29:11.841Z] 16:29:11 INFO - GECKO(1106) | [Parent 1106, Main Thread] WARNING: BlockShutdown: Init failed: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/toolkit/components/antitracking/bouncetrackingprotection/BounceTrackingProtectionStorage.cpp:345
[task 2024-09-04T16:29:11.981Z] 16:29:11 INFO - GECKO(1106) | [Parent 1106, Main Thread] WARNING: kInitialModuleCount too low, consider increasing its value: file /builds/worker/checkouts/gecko/xpcom/base/Logging.cpp:567
[task 2024-09-04T16:29:11.982Z] 16:29:11 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: quota manager shutdown step: '0.000000s: startCrashBrowserTimer', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:11.984Z] 16:29:11 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: quota manager shutdown step: '0.000000s: initiateShutdownWorkThreads', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:11.985Z] 16:29:11 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: idb: '0.000000s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:11.987Z] 16:29:11 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: cache: '0.000000s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:11.987Z] 16:29:11 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: sdb: '0.000000s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:11.987Z] 16:29:11 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: fs: '0.000000s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:11.987Z] 16:29:11 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: ls: '0.000000s: starting', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:11.988Z] 16:29:11 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: quota manager shutdown step: '0.000000s: startKillActorsTimer', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:11.988Z] 16:29:11 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: idb: '0.004000s: Live database entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:11.988Z] 16:29:11 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: idb: '0.004000s: gLiveDatabaseHashtable entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:11.998Z] 16:29:11 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: idb: '0.016000s: Live database entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:11.999Z] 16:29:11 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: idb: '0.016000s: Live database entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:11.999Z] 16:29:11 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: idb: '0.016000s: gLiveDatabaseHashtable entry removed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:12.000Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, QuotaManager IO] WARNING: quota manager shutdown step: '0.016000s: ShutdownStorageOp::DoDirectoryWork -> ShutdownStorageInternal.', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:12.013Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: quota manager shutdown step: '0.032000s: stopKillActorsTimer', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:12.014Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: quota manager shutdown step: '0.032000s: shutdownAndJoinWorkThreads', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:12.015Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: idb: '0.032000s: completed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:12.016Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: cache: '0.032000s: completed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:12.017Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: sdb: '0.032000s: completed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:12.017Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: fs: '0.032000s: completed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:12.018Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: ls: '0.032000s: completed', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:12.019Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: quota manager shutdown step: '0.032000s: shutdownAndJoinIOThread', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:12.021Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: quota manager shutdown step: '0.032000s: invalidatePendingDirectoryLocks', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:12.022Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, IPDL Background] WARNING: quota manager shutdown step: '0.032000s: stopCrashBrowserTimer', file /builds/worker/checkouts/gecko/dom/quota/ActorsParent.cpp:2220
[task 2024-09-04T16:29:12.148Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, Main Thread] WARNING: NS_ENSURE_TRUE(aWindowContext) failed: file /builds/worker/checkouts/gecko/toolkit/components/antitracking/bouncetrackingprotection/BounceTrackingProtection.cpp:452
[task 2024-09-04T16:29:12.155Z] 16:29:12 INFO - GECKO(1106) | [Utility 1293, Main Thread] WARNING: IPC message 'PUtilityProcess::Msg_FOGData' discarded: actor cannot send: file /builds/worker/checkouts/gecko/ipc/glue/ProtocolUtils.cpp:557
[task 2024-09-04T16:29:12.193Z] 16:29:12 INFO - GECKO(1106) | Destroying context 7f15a674e2e0 surface 0 on display 7f15a67e3400
[task 2024-09-04T16:29:12.199Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, Main Thread] WARNING: kInitialModuleCount too low, consider increasing its value: file /builds/worker/checkouts/gecko/xpcom/base/Logging.cpp:567
[task 2024-09-04T16:29:12.216Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, Main Thread] WARNING: kInitialModuleCount too low, consider increasing its value: file /builds/worker/checkouts/gecko/xpcom/base/Logging.cpp:567
[task 2024-09-04T16:29:12.853Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, Main Thread] WARNING: NS_ENSURE_SUCCESS_VOID(rv) failed with result 0x8000FFFF (NS_ERROR_UNEXPECTED): file /builds/worker/checkouts/gecko/dom/file/uri/BlobURLProtocolHandler.cpp:406
[task 2024-09-04T16:29:12.855Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, Main Thread] WARNING: NS_ENSURE_TRUE(!!svc) failed: file /builds/worker/checkouts/gecko/dom/file/uri/BlobURLProtocolHandler.cpp:506
[task 2024-09-04T16:29:12.857Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, Main Thread] WARNING: NS_ENSURE_SUCCESS_VOID(rv) failed with result 0x8000FFFF (NS_ERROR_UNEXPECTED): file /builds/worker/checkouts/gecko/dom/file/uri/BlobURLProtocolHandler.cpp:406
[task 2024-09-04T16:29:12.858Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, Main Thread] WARNING: NS_ENSURE_TRUE(!!svc) failed: file /builds/worker/checkouts/gecko/dom/file/uri/BlobURLProtocolHandler.cpp:506
[task 2024-09-04T16:29:12.859Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, Main Thread] WARNING: NS_ENSURE_SUCCESS_VOID(rv) failed with result 0x8000FFFF (NS_ERROR_UNEXPECTED): file /builds/worker/checkouts/gecko/dom/file/uri/BlobURLProtocolHandler.cpp:406
[task 2024-09-04T16:29:12.862Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, Main Thread] WARNING: NS_ENSURE_TRUE(!!svc) failed: file /builds/worker/checkouts/gecko/dom/file/uri/BlobURLProtocolHandler.cpp:506
[task 2024-09-04T16:29:12.863Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, Main Thread] WARNING: NS_ENSURE_SUCCESS_VOID(rv) failed with result 0x8000FFFF (NS_ERROR_UNEXPECTED): file /builds/worker/checkouts/gecko/dom/file/uri/BlobURLProtocolHandler.cpp:406
[task 2024-09-04T16:29:12.863Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, Main Thread] WARNING: NS_ENSURE_TRUE(!!svc) failed: file /builds/worker/checkouts/gecko/dom/file/uri/BlobURLProtocolHandler.cpp:506
[task 2024-09-04T16:29:12.864Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, Main Thread] WARNING: NS_ENSURE_SUCCESS_VOID(rv) failed with result 0x8000FFFF (NS_ERROR_UNEXPECTED): file /builds/worker/checkouts/gecko/dom/file/uri/BlobURLProtocolHandler.cpp:406
[task 2024-09-04T16:29:12.865Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, Main Thread] WARNING: NS_ENSURE_TRUE(!!svc) failed: file /builds/worker/checkouts/gecko/dom/file/uri/BlobURLProtocolHandler.cpp:506
[task 2024-09-04T16:29:12.866Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, Main Thread] WARNING: NS_ENSURE_SUCCESS_VOID(rv) failed with result 0x8000FFFF (NS_ERROR_UNEXPECTED): file /builds/worker/checkouts/gecko/dom/file/uri/BlobURLProtocolHandler.cpp:406
[task 2024-09-04T16:29:12.868Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, Main Thread] WARNING: NS_ENSURE_TRUE(!!svc) failed: file /builds/worker/checkouts/gecko/dom/file/uri/BlobURLProtocolHandler.cpp:506
[task 2024-09-04T16:29:12.907Z] 16:29:12 INFO - GECKO(1106) | [Parent 1106, Main Thread] WARNING: kInitialModuleCount too low, consider increasing its value: file /builds/worker/checkouts/gecko/xpcom/base/Logging.cpp:567
[task 2024-09-04T16:29:12.924Z] 16:29:12 INFO - TEST-INFO | Main app process: exit 0
[...]
[task 2024-09-04T16:29:13.118Z] 16:29:13 INFO - TEST-INFO | leakcheck | default leaked 3 layers::GestureEventListener::HandleIn
[task 2024-09-04T16:29:13.119Z] 16:29:13 INFO - TEST-INFO | leakcheck | default leaked 1 nsThread
[task 2024-09-04T16:29:13.120Z] 16:29:13 INFO - TEST-UNEXPECTED-FAIL | leakcheck | default 12092 bytes leaked (AsyncPanZoomController, CompositorManagerParent, CondVar, GestureEventListener, ISurfaceAllocator, ...)
[task 2024-09-04T16:29:13.120Z] 16:29:13 INFO -
[task 2024-09-04T16:29:13.121Z] 16:29:13 INFO - leakcheck | Processing leak log file /tmp/tmpd2ftqlfi.mozrunner/runtests_leaks_tab_pid1438.log
[task 2024-09-04T16:29:13.122Z] 16:29:13 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2024-09-04T16:29:13.122Z] 16:29:13 INFO - leakcheck | Processing leak log file /tmp/tmpd2ftqlfi.mozrunner/runtests_leaks_tab_pid1308.log
[task 2024-09-04T16:29:13.123Z] 16:29:13 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2024-09-04T16:29:13.124Z] 16:29:13 INFO - leakcheck | Processing leak log file /tmp/tmpd2ftqlfi.mozrunner/runtests_leaks_tab_pid1766.log
[task 2024-09-04T16:29:13.124Z] 16:29:13 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2024-09-04T16:29:13.125Z] 16:29:13 INFO - leakcheck | Processing leak log file /tmp/tmpd2ftqlfi.mozrunner/runtests_leaks_tab_pid1566.log
[task 2024-09-04T16:29:13.126Z] 16:29:13 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2024-09-04T16:29:13.126Z] 16:29:13 INFO - leakcheck | Processing leak log file /tmp/tmpd2ftqlfi.mozrunner/runtests_leaks_tab_pid1966.log
[task 2024-09-04T16:29:13.127Z] 16:29:13 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2024-09-04T16:29:13.128Z] 16:29:13 INFO - leakcheck | Processing leak log file /tmp/tmpd2ftqlfi.mozrunner/runtests_leaks_tab_pid1364.log
[task 2024-09-04T16:29:13.129Z] 16:29:13 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2024-09-04T16:29:13.130Z] 16:29:13 INFO - leakcheck | Processing leak log file /tmp/tmpd2ftqlfi.mozrunner/runtests_leaks_tab_pid2194.log
[task 2024-09-04T16:29:13.132Z] 16:29:13 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2024-09-04T16:29:13.132Z] 16:29:13 INFO - leakcheck | Processing leak log file /tmp/tmpd2ftqlfi.mozrunner/runtests_leaks_tab_pid2245.log
[task 2024-09-04T16:29:13.134Z] 16:29:13 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2024-09-04T16:29:13.135Z] 16:29:13 INFO - leakcheck | Processing leak log file /tmp/tmpd2ftqlfi.mozrunner/runtests_leaks_tab_pid1641.log
[task 2024-09-04T16:29:13.136Z] 16:29:13 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2024-09-04T16:29:13.137Z] 16:29:13 INFO - leakcheck | Processing leak log file /tmp/tmpd2ftqlfi.mozrunner/runtests_leaks_tab_pid1591.log
[task 2024-09-04T16:29:13.139Z] 16:29:13 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2024-09-04T16:29:13.140Z] 16:29:13 INFO - leakcheck | Processing leak log file /tmp/tmpd2ftqlfi.mozrunner/runtests_leaks_tab_pid2270.log
[task 2024-09-04T16:29:13.141Z] 16:29:13 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2024-09-04T16:29:13.142Z] 16:29:13 INFO - leakcheck | Processing leak log file /tmp/tmpd2ftqlfi.mozrunner/runtests_leaks_tab_pid2096.log
[task 2024-09-04T16:29:13.144Z] 16:29:13 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2024-09-04T16:29:13.145Z] 16:29:13 INFO - leakcheck | Processing leak log file /tmp/tmpd2ftqlfi.mozrunner/runtests_leaks_tab_pid1490.log
[task 2024-09-04T16:29:13.147Z] 16:29:13 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2024-09-04T16:29:13.148Z] 16:29:13 INFO - leakcheck | Processing leak log file /tmp/tmpd2ftqlfi.mozrunner/runtests_leaks_tab_pid2296.log
[task 2024-09-04T16:29:13.150Z] 16:29:13 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2024-09-04T16:29:13.150Z] 16:29:13 INFO - leakcheck | Processing leak log file /tmp/tmpd2ftqlfi.mozrunner/runtests_leaks_tab_pid2395.log
[task 2024-09-04T16:29:13.152Z] 16:29:13 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2024-09-04T16:29:13.153Z] 16:29:13 INFO - leakcheck | Processing leak log file /tmp/tmpd2ftqlfi.mozrunner/runtests_leaks_tab_pid1616.log
[task 2024-09-04T16:29:13.154Z] 16:29:13 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2024-09-04T16:29:13.155Z] 16:29:13 INFO - leakcheck | Processing leak log file /tmp/tmpd2ftqlfi.mozrunner/runtests_leaks_tab_pid1992.log
[task 2024-09-04T16:29:13.157Z] 16:29:13 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2024-09-04T16:29:13.158Z] 16:29:13 INFO - runtests.py | Running tests: end.
[task 2024-09-04T16:29:13.273Z] 16:29:13 INFO - Buffered messages finished
[task 2024-09-04T16:29:13.274Z] 16:29:13 INFO - 0 INFO TEST-START | Shutdown
[task 2024-09-04T16:29:13.274Z] 16:29:13 INFO - 1 INFO Passed: 264
[task 2024-09-04T16:29:13.274Z] 16:29:13 INFO - 2 INFO Failed: 0
[task 2024-09-04T16:29:13.275Z] 16:29:13 INFO - 3 INFO Todo: 0
[task 2024-09-04T16:29:13.276Z] 16:29:13 INFO - 4 INFO Mode: e10s
[task 2024-09-04T16:29:13.276Z] 16:29:13 INFO - 5 INFO SimpleTest FINISHED
[task 2024-09-04T16:29:13.277Z] 16:29:13 INFO - Buffered messages finished
[task 2024-09-04T16:29:13.277Z] 16:29:13 INFO - SUITE-END | took 89s
[task 2024-09-04T16:29:13.278Z] 16:29:13 INFO - :::
[task 2024-09-04T16:29:13.278Z] 16:29:13 INFO - ::: Running test verification step "2. Run each test 5 times in a new browser each time."...
[task 2024-09-04T16:29:13.279Z] 16:29:13 INFO - :::
[task 2024-09-04T16:29:13.279Z] 16:29:13 INFO - Checking for ssltunnel processes...
[task 2024-09-04T16:29:13.280Z] 16:29:13 INFO - NOT killing {'ppid': 1035, 'pid': 1072, 'name': 'ssltunnel', 'username': 'worker'} (not an orphan?)
[task 2024-09-04T16:29:13.282Z] 16:29:13 INFO - Checking for xpcshell processes...
[task 2024-09-04T16:29:13.286Z] 16:29:13 INFO - NOT killing {'ppid': 1035, 'pid': 1069, 'name': 'xpcshell', 'username': 'worker'} (not an orphan?)
[task 2024-09-04T16:29:13.289Z] 16:29:13 INFO - mozcrash Removed pending crash reports at '/builds/worker/.mozilla/firefox/Crash Reports'
[task 2024-09-04T16:29:13.290Z] 16:29:13 INFO - SUITE-START | Running 1 tests
[task 2024-09-04T16:29:13.291Z] 16:29:13 INFO - Running manifest: gfx/layers/apz/test/mochitest/mochitest.toml
[task 2024-09-04T16:29:13.291Z] 16:29:13 INFO - The following extra prefs will be set:
[task 2024-09-04T16:29:13.291Z] 16:29:13 INFO - gfx.font_loader.delay=0
[task 2024-09-04T16:29:13.476Z] 16:29:13 INFO - Setting pipeline to PAUSED ...
[task 2024-09-04T16:29:13.478Z] 16:29:13 INFO - Pipeline is PREROLLING ...
[task 2024-09-04T16:29:13.479Z] 16:29:13 INFO - Pipeline is PREROLLED ...
[task 2024-09-04T16:29:13.479Z] 16:29:13 INFO - Setting pipeline to PLAYING ...
[task 2024-09-04T16:29:13.479Z] 16:29:13 INFO - New clock: GstSystemClock
[task 2024-09-04T16:29:13.513Z] 16:29:13 INFO - Got EOS from element "pipeline0".
[task 2024-09-04T16:29:13.513Z] 16:29:13 INFO - Execution ended after 0:00:00.033433251
[task 2024-09-04T16:29:13.514Z] 16:29:13 INFO - Setting pipeline to PAUSED ...
[task 2024-09-04T16:29:13.514Z] 16:29:13 INFO - Setting pipeline to READY ...
[task 2024-09-04T16:29:13.515Z] 16:29:13 INFO - (gst-launch-1.0:2557): GStreamer-CRITICAL **: 16:29:13.512: gst_object_unref: assertion '((GObject *) object)->ref_count > 0' failed
[task 2024-09-04T16:29:13.515Z] 16:29:13 INFO - Setting pipeline to NULL ...
[task 2024-09-04T16:29:13.515Z] 16:29:13 INFO - Freeing pipeline ...
[task 2024-09-04T16:29:13.745Z] 16:29:13 INFO - PID 2566 | pk12util: PKCS12 IMPORT SUCCESSFUL
[task 2024-09-04T16:29:13.746Z] 16:29:13 INFO -
[task 2024-09-04T16:29:13.759Z] 16:29:13 INFO - MochitestServer : launching ['/builds/worker/workspace/build/tests/bin/xpcshell', '-g', '/builds/worker/workspace/build/application/firefox', '-e', "const _PROFILE_PATH = '/tmp/tmpv_g2j7is.mozrunner'; const _SERVER_PORT = '8888'; const _SERVER_ADDR = '127.0.0.1'; const _TEST_PREFIX = undefined; const _DISPLAY_RESULTS = false; const _HTTPD_PATH = '/builds/worker/workspace/build/tests/bin/components';", '-f', '/builds/worker/workspace/build/tests/mochitest/server.js']
[task 2024-09-04T16:29:13.760Z] 16:29:13 INFO - runtests.py | Server pid: 2567
[task 2024-09-04T16:29:13.762Z] 16:29:13 INFO - runtests.py | Websocket server pid: 2568
[task 2024-09-04T16:29:13.771Z] 16:29:13 INFO - runtests.py | SSL tunnel pid: 2569
[task 2024-09-04T16:29:13.908Z] 16:29:13 INFO - Couldn't convert chrome URL: chrome://branding/locale/brand.properties
[task 2024-09-04T16:29:13.908Z] 16:29:13 INFO - [Parent 2567, Main Thread] WARNING: Could not get the program name for a cubeb stream.: 'NS_SUCCEEDED(rv)', file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:467
[task 2024-09-04T16:29:13.925Z] 16:29:13 INFO - use http3 server: 0
[task 2024-09-04T16:29:13.925Z] 16:29:13 INFO - runtests.py | Running with scheme: http
[task 2024-09-04T16:29:13.925Z] 16:29:13 INFO - runtests.py | Running with e10s: True
[task 2024-09-04T16:29:13.925Z] 16:29:13 INFO - runtests.py | Running with fission: True
[task 2024-09-04T16:29:13.925Z] 16:29:13 INFO - runtests.py | Running with cross-origin iframes: False
[task 2024-09-04T16:29:13.925Z] 16:29:13 INFO - runtests.py | Running with serviceworker_e10s: True
[task 2024-09-04T16:29:13.925Z] 16:29:13 INFO - runtests.py | Running with socketprocess_e10s: False
[task 2024-09-04T16:29:13.925Z] 16:29:13 INFO - runtests.py | Running tests: start.
[task 2024-09-04T16:29:13.925Z] 16:29:13 INFO -
[task 2024-09-04T16:29:13.937Z] 16:29:13 INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox -marionette -foreground -profile /tmp/tmpv_g2j7is.mozrunner
[task 2024-09-04T16:29:13.948Z] 16:29:13 INFO - runtests.py | Application pid: 2594
[task 2024-09-04T16:29:13.948Z] 16:29:13 INFO - TEST-INFO | started process GECKO(2594)
[task 2024-09-04T16:29:13.967Z] 16:29:13 INFO - GECKO(2594) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpv_g2j7is.mozrunner/runtests_leaks.log
[task 2024-09-04T16:29:14.483Z] 16:29:14 INFO - GECKO(2594) | [WARN rkv::backend::impl_safe::environment] `load_ratio()` is irrelevant for this storage backend.
[task 2024-09-04T16:29:14.777Z] 16:29:14 INFO - GECKO(2594) | ATTENTION: default value of option mesa_glthread overridden by environment.
[task 2024-09-04T16:29:14.783Z] 16:29:14 INFO - GECKO(2594) | [Parent 2594, Renderer] WARNING: Failed to create EGLContext with khr_rbab_attribs: file /builds/worker/checkouts/gecko/gfx/gl/GLContextProviderEGL.cpp:733
[task 2024-09-04T16:29:14.784Z] 16:29:14 INFO - GECKO(2594) | [Parent 2594, Renderer] WARNING: Failed to create EGLContext with khr_robustness_attribs: file /builds/worker/checkouts/gecko/gfx/gl/GLContextProviderEGL.cpp:745
[task 2024-09-04T16:29:14.789Z] 16:29:14 INFO - GECKO(2594) | Initializing context 7fb2c7d47820 surface 0 on display 7fb2c7da4100
[task 2024-09-04T16:29:14.793Z] 16:29:14 INFO - GECKO(2594) | GL_VENDOR: VMware, Inc.
[task 2024-09-04T16:29:14.794Z] 16:29:14 INFO - GECKO(2594) | mVendor: VMware, Inc.
[task 2024-09-04T16:29:14.794Z] 16:29:14 INFO - GECKO(2594) | GL_RENDERER: llvmpipe (LLVM 10.0.0, 256 bits)
[task 2024-09-04T16:29:14.795Z] 16:29:14 INFO - GECKO(2594) | mRenderer: Unknown
[task 2024-09-04T16:29:14.796Z] 16:29:14 INFO - GECKO(2594) | mIsMesa: 1
[task 2024-09-04T16:29:14.796Z] 16:29:14 INFO - GECKO(2594) | [Parent 2594, Renderer] WARNING: robust_buffer_access_behavior marked as unsupported: file /builds/worker/checkouts/gecko/gfx/gl/GLContextFeatures.cpp:644
[task 2024-09-04T16:29:14.797Z] 16:29:14 INFO - GECKO(2594) | [Parent 2594, Renderer] WARNING: Robustness supported, strategy is not LOSE_CONTEXT_ON_RESET!: file /builds/worker/checkouts/gecko/gfx/gl/GLContext.cpp:982
[task 2024-09-04T16:29:14.798Z] 16:29:14 INFO - GECKO(2594) | [Parent 2594, Renderer] WARNING: robustness marked as unsupported: file /builds/worker/checkouts/gecko/gfx/gl/GLContextFeatures.cpp:644
[task 2024-09-04T16:29:14.835Z] 16:29:14 INFO - GECKO(2594) | 1725467354834 Marionette INFO Marionette enabled
[task 2024-09-04T16:29:14.840Z] 16:29:14 INFO - GECKO(2594) | 1725467354839 Marionette TRACE Received observer notification final-ui-startup
[task 2024-09-04T16:29:14.939Z] 16:29:14 INFO - GECKO(2594) | console.error: "Warning: unrecognized command line flag" "-foreground"
[task 2024-09-04T16:29:14.973Z] 16:29:14 INFO - GECKO(2594) | ATTENTION: default value of option mesa_glthread overridden by environment.
[task 2024-09-04T16:29:14.977Z] 16:29:14 INFO - GECKO(2594) | [Parent 2594, Main Thread] WARNING: GLX_swap_control unsupported, ASAP mode may still block on buffer swaps.: file /builds/worker/checkouts/gecko/gfx/gl/GLContextProviderGLX.cpp:213
[task 2024-09-04T16:29:15.016Z] 16:29:15 INFO - GECKO(2594) | 1725467355015 Marionette INFO Listening on port 2828
[task 2024-09-04T16:29:15.021Z] 16:29:15 INFO - GECKO(2594) | 1725467355020 Marionette DEBUG Marionette is listening
[task 2024-09-04T16:29:15.031Z] 16:29:15 INFO - GECKO(2594) | [Parent 2594, Main Thread] WARNING: 'mColorSchemePreference == ComputeColorSchemeSetting()', file /builds/worker/checkouts/gecko/widget/gtk/nsLookAndFeel.cpp:1558
[task 2024-09-04T16:29:15.051Z] 16:29:15 INFO - GECKO(2594) | 1725467355050 Marionette DEBUG Accepted connection 0 from 127.0.0.1:32982
[task 2024-09-04T16:29:15.104Z] 16:29:15 INFO - GECKO(2594) | 1725467355103 Marionette DEBUG Closed connection 0
[task 2024-09-04T16:29:15.106Z] 16:29:15 INFO - GECKO(2594) | 1725467355104 Marionette DEBUG Accepted connection 1 from 127.0.0.1:32984
[task 2024-09-04T16:29:15.187Z] 16:29:15 INFO - GECKO(2594) | [WARN rkv::backend::impl_safe::environment] `load_ratio()` is irrelevant for this storage backend.
[task 2024-09-04T16:29:15.399Z] 16:29:15 INFO - GECKO(2594) | 1725467355398 Marionette DEBUG 1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2024-09-04T16:29:15.409Z] 16:29:15 INFO - GECKO(2594) | 1725467355408 Marionette DEBUG Waiting for initial application window
[task 2024-09-04T16:29:15.467Z] 16:29:15 INFO - GECKO(2594) | [WARN rkv::backend::impl_safe::environment] `load_ratio()` is irrelevant for this storage backend.
[task 2024-09-04T16:29:15.594Z] 16:29:15 INFO - GECKO(2594) | [Parent 2594, GMPThread] WARNING: Failed to delete GMP storage directory: file /builds/worker/checkouts/gecko/dom/media/gmp/GMPServiceParent.cpp:1888
[task 2024-09-04T16:29:15.608Z] 16:29:15 INFO - GECKO(2594) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpv_g2j7is.mozrunner/runtests_leaks_tab_pid2666.log
[task 2024-09-04T16:29:15.640Z] 16:29:15 INFO - GECKO(2594) | [Child 2666, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:757
[task 2024-09-04T16:29:15.753Z] 16:29:15 INFO - GECKO(2594) | [Parent 2594, Main Thread] WARNING: Please do not use mouseenter/leave events in chrome. They are slower than mouseover/out!: '!nsContentUtils::IsChromeDoc(window->GetExtantDoc())', file /builds/worker/checkouts/gecko/dom/events/EventListenerManager.cpp:461
[task 2024-09-04T16:29:15.905Z] 16:29:15 INFO - GECKO(2594) | [WARN webrender::device::gl] Missing optimized shader source for gpu_cache_update
[task 2024-09-04T16:29:15.925Z] 16:29:15 INFO - GECKO(2594) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpv_g2j7is.mozrunner/runtests_leaks_tab_pid2698.log
[task 2024-09-04T16:29:15.954Z] 16:29:15 INFO - GECKO(2594) | [Child 2698, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:757
[task 2024-09-04T16:29:17.961Z] 16:29:17 INFO - GECKO(2594) | [Parent 2594, Main Thread] WARNING: NS_ENSURE_TRUE(mPresShell) failed: file /builds/worker/checkouts/gecko/layout/generic/nsFrameSelection.cpp:1657
[task 2024-09-04T16:29:18.084Z] 16:29:18 INFO - GECKO(2594) | console.error: ({})
[task 2024-09-04T16:29:18.184Z] 16:29:18 INFO - GECKO(2594) | [WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-09-04T16:29:18.185Z] 16:29:18 INFO - GECKO(2594) | [WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-09-04T16:29:18.186Z] 16:29:18 INFO - GECKO(2594) | [WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-09-04T16:29:18.252Z] 16:29:18 INFO - GECKO(2594) | [WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-09-04T16:29:18.255Z] 16:29:18 INFO - GECKO(2594) | [WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-09-04T16:29:18.256Z] 16:29:18 INFO - GECKO(2594) | [WARN webrender::device::gl] Cropping texture upload Box2D((0, 0), (0, 1)) to None
[task 2024-09-04T16:29:18.636Z] 16:29:18 INFO - GECKO(2594) | [Parent 2594, Main Thread] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/worker/checkouts/gecko/parser/html/nsHtml5StreamParser.cpp:1215
[task 2024-09-04T16:29:19.751Z] 16:29:19 INFO - GECKO(2594) | [Parent 2594, Main Thread] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/worker/checkouts/gecko/parser/html/nsHtml5StreamParser.cpp:1215
[task 2024-09-04T16:29:19.906Z] 16:29:19 INFO - GECKO(2594) | [Parent 2594, Main Thread] WARNING: NS_ENSURE_TRUE(mNameHashtable.Get(aName, &index)) failed: file /builds/worker/checkouts/gecko/storage/mozStorageRow.cpp:91
[task 2024-09-04T16:29:20.017Z] 16:29:20 INFO - GECKO(2594) | [Parent 2594, Main Thread] WARNING: NS_ENSURE_TRUE(mNameHashtable.Get(aName, &index)) failed: file /builds/worker/checkouts/gecko/storage/mozStorageRow.cpp:91
[task 2024-09-04T16:29:20.674Z] 16:29:20 INFO - GECKO(2594) | [Parent 2594, QuotaManager IO] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80630001 (NS_ERROR_STORAGE_BUSY): file /builds/worker/checkouts/gecko/storage/mozStorageConnection.cpp:1191
[task 2024-09-04T16:29:20.676Z] 16:29:20 INFO - GECKO(2594) | [Parent 2594, QuotaManager IO] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80630001 (NS_ERROR_STORAGE_BUSY): file /builds/worker/checkouts/gecko/storage/mozStorageService.cpp:684
[task 2024-09-04T16:29:20.676Z] 16:29:20 INFO - GECKO(2594) | [Parent 2594, QuotaManager IO] WARNING: QM_TRY failure (ERROR): '::mozilla::ToResultInvoke< nsCOMPtr<mozIStorageConnection>>( ::std::mem_fn( &::mozilla::detail::DerefedType<decltype(aStorageService)>::OpenDatabaseWithFileURL), (aStorageService), &aFileURL, telemetryFilename, mozIStorageService::CONNECTION_INTERRUPTIBLE) failed with resultCode 0x80630001, resultName NS_ERROR_STORAGE_BUSY', file dom/indexedDB/ActorsParent.cpp:734
[task 2024-09-04T16:29:20.677Z] 16:29:20 INFO - GECKO(2594) | [Parent 2594, QuotaManager IO] WARNING: QM_TRY failure (WARNING): '"OpenDatabase(aStorageService, aFileURL, aTelemetryId) .map([](auto connection) -> ConnectionType { return Some(std::move(connection)); })" failed with resultCode 0x80630001, resultName NS_ERROR_STORAGE_BUSY', file dom/indexedDB/ActorsParent.cpp:758
[task 2024-09-04T16:29:20.677Z] 16:29:20 INFO - GECKO(2594) | [Parent 2594, QuotaManager IO] WARNING: Received NS_ERROR_STORAGE_BUSY when attempting to open database '3870112724rsegmnoittet-es.sqlite', retrying for up to 10 seconds: file /builds/worker/checkouts/gecko/dom/indexedDB/ActorsParent.cpp:770
[task 2024-09-04T16:29:20.966Z] 16:29:20 INFO - GECKO(2594) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpv_g2j7is.mozrunner/runtests_leaks_utility_pid2749.log
[task 2024-09-04T16:29:21.062Z] 16:29:21 INFO - GECKO(2594) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpv_g2j7is.mozrunner/runtests_leaks_tab_pid2759.log
[task 2024-09-04T16:29:21.112Z] 16:29:21 INFO - GECKO(2594) | [Child 2759, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:757
[task 2024-09-04T16:29:21.182Z] 16:29:21 INFO - GECKO(2594) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpv_g2j7is.mozrunner/runtests_leaks_tab_pid2765.log
[task 2024-09-04T16:29:21.221Z] 16:29:21 INFO - GECKO(2594) | [Child 2765, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:757
[task 2024-09-04T16:29:21.226Z] 16:29:21 INFO - GECKO(2594) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpv_g2j7is.mozrunner/runtests_leaks_tab_pid2771.log
[task 2024-09-04T16:29:21.243Z] 16:29:21 INFO - GECKO(2594) | [ERROR error_support::handling] suggest-unexpected: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base
[task 2024-09-04T16:29:21.262Z] 16:29:21 INFO - GECKO(2594) | [Child 2771, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:757
[task 2024-09-04T16:29:21.280Z] 16:29:21 INFO - GECKO(2594) | console.error: URLBar - QuickSuggest.SuggestBackendRust: "Ingest error for Amo: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base"
[task 2024-09-04T16:29:21.363Z] 16:29:21 INFO - GECKO(2594) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpv_g2j7is.mozrunner/runtests_leaks_tab_pid2817.log
[task 2024-09-04T16:29:21.406Z] 16:29:21 INFO - GECKO(2594) | [ERROR error_support::handling] suggest-unexpected: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base
[task 2024-09-04T16:29:21.413Z] 16:29:21 INFO - GECKO(2594) | [Child 2817, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:757
[task 2024-09-04T16:29:21.423Z] 16:29:21 INFO - GECKO(2594) | console.error: URLBar - QuickSuggest.SuggestBackendRust: "Ingest error for Amp: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base"
[task 2024-09-04T16:29:21.433Z] 16:29:21 INFO - GECKO(2594) | [ERROR error_support::handling] suggest-unexpected: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base
[task 2024-09-04T16:29:21.439Z] 16:29:21 INFO - GECKO(2594) | console.error: URLBar - QuickSuggest.SuggestBackendRust: "Ingest error for Wikipedia: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base"
[task 2024-09-04T16:29:21.443Z] 16:29:21 INFO - GECKO(2594) | 1725467361441 Marionette TRACE Received observer notification browser-idle-startup-tasks-finished
[task 2024-09-04T16:29:21.490Z] 16:29:21 INFO - GECKO(2594) | 1725467361489 RemoteAgent TRACE [9] ProgressListener Start: expectNavigation=false resolveWhenStarted=false unloadTimeout=40000 waitForExplicitStart=false
[task 2024-09-04T16:29:21.495Z] 16:29:21 INFO - GECKO(2594) | 1725467361495 RemoteAgent TRACE [9] ProgressListener Setting unload timer (40000ms)
[task 2024-09-04T16:29:21.498Z] 16:29:21 INFO - GECKO(2594) | 1725467361496 RemoteAgent TRACE [9] Wait for initial navigation: isInitial=false, isLoadingDocument=false
[task 2024-09-04T16:29:21.501Z] 16:29:21 INFO - GECKO(2594) | 1725467361498 RemoteAgent TRACE [9] Document already finished loading: about:blank
[task 2024-09-04T16:29:21.504Z] 16:29:21 INFO - GECKO(2594) | 1725467361500 RemoteAgent TRACE [9] ProgressListener Stop: has error=false url=about:blank
[task 2024-09-04T16:29:21.557Z] 16:29:21 INFO - GECKO(2594) | 1725467361555 Marionette DEBUG 1 <- [1,1,null,{"sessionId":"34eb0838-b733-4b5a-ab22-03a7eb82e5fd","capabilities":{"acceptInsecureCerts":false,"browserName":"firefox","browserVersion":"132.0a1","platformName":"linux","unhandledPromptBehavior":"dismiss and notify","userAgent":"Mozilla/5.0 (X11; Linux x86_64; rv:132.0) Gecko/20100101 Firefox/132.0","moz:buildID":"20240904160432","moz:headless":false,"moz:platformVersion":"4.4.0-1014-aws","moz:processID":2594,"moz:profile":"/tmp/tmpv_g2j7is.mozrunner","moz:shutdownTimeout":60000,"pageLoadStrategy":"normal","timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"setWindowRect":true,"strictFileInteractability":true,"moz:accessibilityChecks":false,"moz:webdriverClick":true,"moz:windowless":false,"proxy":{}}}]
[task 2024-09-04T16:29:21.624Z] 16:29:21 INFO - GECKO(2594) | [ERROR error_support::handling] suggest-unexpected: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base
[task 2024-09-04T16:29:21.627Z] 16:29:21 INFO - GECKO(2594) | console.error: URLBar - QuickSuggest.SuggestBackendRust: "Ingest error for Mdn: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base"
[task 2024-09-04T16:29:21.629Z] 16:29:21 INFO - GECKO(2594) | 1725467361627 Marionette DEBUG 1 -> [0,2,"Addon:Install",{"path":"/tmp/tmpnqcpyn4i.zip","temporary":false}]
[task 2024-09-04T16:29:21.673Z] 16:29:21 INFO - GECKO(2594) | [ERROR error_support::handling] suggest-unexpected: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base
[task 2024-09-04T16:29:21.675Z] 16:29:21 INFO - GECKO(2594) | console.error: URLBar - QuickSuggest.SuggestBackendRust: "Ingest error for Yelp: Error from Remote Settings: Error parsing URL: relative URL with a cannot-be-a-base base"
[task 2024-09-04T16:29:21.805Z] 16:29:21 INFO - GECKO(2594) | 1725467361804 Marionette DEBUG 1 <- [1,2,null,{"value":"special-powers@mozilla.org"}]
[task 2024-09-04T16:29:21.841Z] 16:29:21 INFO - GECKO(2594) | 1725467361840 Marionette DEBUG 1 -> [0,3,"Addon:Install",{"path":"/tmp/tmplvo575xl.zip","temporary":false}]
[task 2024-09-04T16:29:21.943Z] 16:29:21 INFO - GECKO(2594) | 1725467361942 Marionette DEBUG 1 <- [1,3,null,{"value":"mochikit@mozilla.org"}]
[task 2024-09-04T16:29:21.950Z] 16:29:21 INFO - GECKO(2594) | 1725467361949 Marionette DEBUG 1 -> [0,4,"Marionette:GetContext",{}]
[task 2024-09-04T16:29:21.951Z] 16:29:21 INFO - GECKO(2594) | 1725467361950 Marionette DEBUG 1 <- [1,4,null,{"value":"content"}]
[task 2024-09-04T16:29:21.954Z] 16:29:21 INFO - GECKO(2594) | 1725467361953 Marionette DEBUG 1 -> [0,5,"Marionette:SetContext",{"value":"chrome"}]
[task 2024-09-04T16:29:21.956Z] 16:29:21 INFO - GECKO(2594) | 1725467361955 Marionette DEBUG 1 <- [1,5,null,{"value":null}]
[task 2024-09-04T16:29:21.960Z] 16:29:21 INFO - GECKO(2594) | 1725467361958 Marionette DEBUG 1 -> [0,6,"WebDriver:ExecuteScript",{"script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distr ... s which flavor and url to load.\nlet ev = new CustomEvent(\"mochitest-load\", { detail: [flavor, url] });\nwin.dispatchEvent(ev);","args":[{"flavor":"mochitest","testUrl":"http://mochi.test:8888/tests/gfx/layers/apz/test/mochitest?autorun=1&closeWhenDone=1&consoleLevel=INFO&testname=tests/gfx/lay ... tml&manifestFile=tests.json&dumpOutputDirectory=%2Ftmp&cleanupCrashes=true&comparePrefs=true&ignorePrefsFile=ignorePrefs.json"}],"newSandbox":true,"sandbox":"default","line":2165,"filename":"tests/mochitest/runtests.py"}]
[task 2024-09-04T16:29:21.972Z] 16:29:21 INFO - GECKO(2594) | 1725467361971 RemoteAgent TRACE WebDriverProcessData actor created for PID 2594
[task 2024-09-04T16:29:21.976Z] 16:29:21 INFO - GECKO(2594) | 1725467361975 Marionette TRACE [1] MarionetteCommands actor created for window id 2
[task 2024-09-04T16:29:22.024Z] 16:29:22 INFO - GECKO(2594) | 1725467362023 Marionette DEBUG 1 <- [1,6,null,{"value":null}]
[task 2024-09-04T16:29:22.049Z] 16:29:22 INFO - GECKO(2594) | 1725467362048 Marionette DEBUG 1 -> [0,7,"Marionette:SetContext",{"value":"content"}]
[task 2024-09-04T16:29:22.050Z] 16:29:22 INFO - GECKO(2594) | 1725467362049 Marionette DEBUG 1 <- [1,7,null,{"value":null}]
[task 2024-09-04T16:29:22.070Z] 16:29:22 INFO - GECKO(2594) | 1725467362069 Marionette DEBUG 1 -> [0,8,"WebDriver:DeleteSession",{}]
[task 2024-09-04T16:29:22.076Z] 16:29:22 INFO - GECKO(2594) | 1725467362075 Marionette TRACE [1] MarionetteCommands actor destroyed for window id 2
[task 2024-09-04T16:29:22.081Z] 16:29:22 INFO - GECKO(2594) | 1725467362080 Marionette DEBUG 1 <- [1,8,null,{"value":null}]
[task 2024-09-04T16:29:22.136Z] 16:29:22 INFO - runtests.py | Waiting for browser...
[task 2024-09-04T16:29:22.164Z] 16:29:22 INFO - GECKO(2594) | 1725467362163 Marionette DEBUG Closed connection 1
[task 2024-09-04T16:29:22.846Z] 16:29:22 INFO - GECKO(2594) | [Parent 2594, Main Thread] WARNING: NS_ENSURE_TRUE(she && she->mInfo->mSharedState.Get()) failed: file /builds/worker/checkouts/gecko/docshell/shistory/SessionHistoryEntry.cpp:1160
[task 2024-09-04T16:29:23.027Z] 16:29:23 INFO - SimpleTest START
| Comment hidden (Intermittent Failures Robot) |
Keywords: regression
Regressed by: 1841896
|
||
Comment 2•10 days ago
|
||
:ajakobi, since you are the author of the regressor, bug 1841896, could you take a look?
For more information, please visit BugBot documentation.
Flags: needinfo?(ajakobi)
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 4•4 days ago
|
||
Will look into it.
|
||
Comment 5•3 days ago
|
||
As far as I can tell the leaks happen on helper_fission_tap_on_zoomed.html.
|
|
||
Comment 6•3 days ago
|
||
The leak is definitely related to apz.max_tap_time pref.
|
|
||
Updated•3 days ago
|
Flags: needinfo?(ajakobi)
You need to log in
before you can comment on or make changes to this bug.
Description
•