Closed
Bug 1827757
Opened 2 years ago
Closed 2 years ago
Intermittent leakcheck | default 1808 bytes leaked (CondVar, Mutex, PSandboxTestingParent, RefCountedMonitor, ThreadEventTarget, ...)
Categories
(Core :: Security: Process Sandboxing, defect, P5)
Core
Security: Process Sandboxing
Tracking
()
RESOLVED
INCOMPLETE
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure)
Filed by: nbeleuzu [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=412236479&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/d0V96OVxRjKS1pkP3__Shw/runs/0/artifacts/public/logs/live_backing.log
[task 2023-04-12T22:39:30.234Z] 22:39:30 INFO - TEST-INFO | Confirming we saw 50 DOMWINDOW created and 50 destroyed log strings.
[task 2023-04-12T22:39:30.234Z] 22:39:30 INFO - runtests.py | Application ran for: 0:00:19.371740
[task 2023-04-12T22:39:30.234Z] 22:39:30 INFO - zombiecheck | Reading PID log: /tmp/tmpjm1ss6qopidlog
[task 2023-04-12T22:39:30.234Z] 22:39:30 INFO - ==> process 17132 launched child process 17152
[task 2023-04-12T22:39:30.234Z] 22:39:30 INFO - ==> process 17132 launched child process 17198
[task 2023-04-12T22:39:30.234Z] 22:39:30 INFO - ==> process 17132 launched child process 17225
[task 2023-04-12T22:39:30.234Z] 22:39:30 INFO - ==> process 17132 launched child process 17285
[task 2023-04-12T22:39:30.239Z] 22:39:30 INFO - ==> process 17132 launched child process 17288
[task 2023-04-12T22:39:30.239Z] 22:39:30 INFO - ==> process 17132 launched child process 17296
[task 2023-04-12T22:39:30.240Z] 22:39:30 INFO - ==> process 17132 launched child process 17320
[task 2023-04-12T22:39:30.241Z] 22:39:30 INFO - ==> process 17132 launched child process 17342
[task 2023-04-12T22:39:30.242Z] 22:39:30 INFO - ==> process 17132 launched child process 17381
[task 2023-04-12T22:39:30.243Z] 22:39:30 INFO - ==> process 17132 launched child process 17404
[task 2023-04-12T22:39:30.244Z] 22:39:30 INFO - ==> process 17132 launched child process 17429
[task 2023-04-12T22:39:30.245Z] 22:39:30 INFO - ==> process 17132 launched child process 17432
[task 2023-04-12T22:39:30.246Z] 22:39:30 INFO - ==> process 17132 launched child process 17446
[task 2023-04-12T22:39:30.247Z] 22:39:30 INFO - zombiecheck | Checking for orphan process with PID: 17152
[task 2023-04-12T22:39:30.248Z] 22:39:30 INFO - zombiecheck | Checking for orphan process with PID: 17285
[task 2023-04-12T22:39:30.248Z] 22:39:30 INFO - zombiecheck | Checking for orphan process with PID: 17381
[task 2023-04-12T22:39:30.248Z] 22:39:30 INFO - zombiecheck | Checking for orphan process with PID: 17446
[task 2023-04-12T22:39:30.249Z] 22:39:30 INFO - zombiecheck | Checking for orphan process with PID: 17288
[task 2023-04-12T22:39:30.249Z] 22:39:30 INFO - zombiecheck | Checking for orphan process with PID: 17225
[task 2023-04-12T22:39:30.249Z] 22:39:30 INFO - zombiecheck | Checking for orphan process with PID: 17320
[task 2023-04-12T22:39:30.249Z] 22:39:30 INFO - zombiecheck | Checking for orphan process with PID: 17198
[task 2023-04-12T22:39:30.249Z] 22:39:30 INFO - zombiecheck | Checking for orphan process with PID: 17296
[task 2023-04-12T22:39:30.249Z] 22:39:30 INFO - zombiecheck | Checking for orphan process with PID: 17429
[task 2023-04-12T22:39:30.249Z] 22:39:30 INFO - zombiecheck | Checking for orphan process with PID: 17432
[task 2023-04-12T22:39:30.249Z] 22:39:30 INFO - zombiecheck | Checking for orphan process with PID: 17404
[task 2023-04-12T22:39:30.250Z] 22:39:30 INFO - zombiecheck | Checking for orphan process with PID: 17342
[task 2023-04-12T22:39:30.250Z] 22:39:30 INFO - Stopping web server
[task 2023-04-12T22:39:30.250Z] 22:39:30 INFO - Server shut down.
[task 2023-04-12T22:39:30.256Z] 22:39:30 INFO - Web server killed.
[task 2023-04-12T22:39:30.256Z] 22:39:30 INFO - Stopping web socket server
[task 2023-04-12T22:39:30.275Z] 22:39:30 INFO - Stopping ssltunnel
[task 2023-04-12T22:39:30.296Z] 22:39:30 INFO - Stopping gst for v4l2loopback
[task 2023-04-12T22:39:30.297Z] 22:39:30 INFO - leakcheck | Processing log file /tmp/tmpvisdd075.mozrunner/runtests_leaks.log
[task 2023-04-12T22:39:30.298Z] 22:39:30 INFO - TEST-INFO | leakcheck | default process: leak threshold set at 0 bytes
[task 2023-04-12T22:39:30.300Z] 22:39:30 INFO - TEST-INFO | leakcheck | tab process: leak threshold set at 0 bytes
[task 2023-04-12T22:39:30.301Z] 22:39:30 INFO - TEST-INFO | leakcheck | gmplugin process: leak threshold set at 20000 bytes
[task 2023-04-12T22:39:30.302Z] 22:39:30 INFO - TEST-INFO | leakcheck | gpu process: leak threshold set at 0 bytes
[task 2023-04-12T22:39:30.304Z] 22:39:30 INFO - TEST-INFO | leakcheck | vr process: leak threshold set at 0 bytes
[task 2023-04-12T22:39:30.305Z] 22:39:30 INFO - TEST-INFO | leakcheck | rdd process: leak threshold set at 0 bytes
[task 2023-04-12T22:39:30.307Z] 22:39:30 INFO - TEST-INFO | leakcheck | socket process: leak threshold set at 0 bytes
[task 2023-04-12T22:39:30.308Z] 22:39:30 INFO - TEST-INFO | leakcheck | sandboxbroker process: leak threshold set at 0 bytes
[task 2023-04-12T22:39:30.309Z] 22:39:30 INFO - TEST-INFO | leakcheck | forkserver process: leak threshold set at 0 bytes
[task 2023-04-12T22:39:30.310Z] 22:39:30 INFO - TEST-INFO | leakcheck | utility process: leak threshold set at 0 bytes
[task 2023-04-12T22:39:30.312Z] 22:39:30 INFO - leakcheck | Processing leak log file /tmp/tmpvisdd075.mozrunner/runtests_leaks_rdd_pid17432.log
[task 2023-04-12T22:39:30.313Z] 22:39:30 INFO - TEST-PASS | leakcheck | rdd no leaks detected!
[task 2023-04-12T22:39:30.314Z] 22:39:30 INFO - leakcheck | Processing leak log file /tmp/tmpvisdd075.mozrunner/runtests_leaks_tab_pid17288.log
[task 2023-04-12T22:39:30.316Z] 22:39:30 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2023-04-12T22:39:30.317Z] 22:39:30 INFO - leakcheck | Processing leak log file /tmp/tmpvisdd075.mozrunner/runtests_leaks_gmplugin_pid17446.log
[task 2023-04-12T22:39:30.318Z] 22:39:30 INFO -
[task 2023-04-12T22:39:30.319Z] 22:39:30 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, gmplugin process 17446
[task 2023-04-12T22:39:30.321Z] 22:39:30 INFO -
[task 2023-04-12T22:39:30.322Z] 22:39:30 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2023-04-12T22:39:30.323Z] 22:39:30 INFO - | | Per-Inst Leaked| Total Rem|
[task 2023-04-12T22:39:30.325Z] 22:39:30 INFO - 0 |TOTAL | 88 3472| 299 45|
[task 2023-04-12T22:39:30.326Z] 22:39:30 INFO - 2 |BackgroundEventTarget | 152 152| 1 1|
[task 2023-04-12T22:39:30.327Z] 22:39:30 INFO - 8 |CondVar | 80 480| 11 6|
[task 2023-04-12T22:39:30.329Z] 22:39:30 INFO - 15 |IdlePeriod | 24 24| 1 1|
[task 2023-04-12T22:39:30.330Z] 22:39:30 INFO - 17 |MessageLoop::EventTarget | 144 144| 4 1|
[task 2023-04-12T22:39:30.331Z] 22:39:30 INFO - 18 |MessagePump | 16 16| 4 1|
[task 2023-04-12T22:39:30.333Z] 22:39:30 INFO - 20 |Mutex | 72 864| 34 12|
[task 2023-04-12T22:39:30.334Z] 22:39:30 INFO - 39 |ProfilerParentTracker | 72 72| 1 1|
[task 2023-04-12T22:39:30.335Z] 22:39:30 INFO - 44 |TaskController::ExecutePendingMTTasks(| 40 80| 2 2|
[task 2023-04-12T22:39:30.336Z] 22:39:30 INFO - 45 |TaskManager | 32 96| 3 3|
[task 2023-04-12T22:39:30.338Z] 22:39:30 INFO - 46 |ThreadEventTarget | 48 96| 3 2|
[task 2023-04-12T22:39:30.339Z] 22:39:30 INFO - 48 |ThreadTargetSink | 16 32| 3 2|
[task 2023-04-12T22:39:30.340Z] 22:39:30 INFO - 50 |WaitableEventKernel | 72 72| 4 1|
[task 2023-04-12T22:39:30.342Z] 22:39:30 INFO - 53 |XPCOMThreadWrapper | 88 88| 1 1|
[task 2023-04-12T22:39:30.343Z] 22:39:30 INFO - 55 |ipc::DoWorkRunnable | 40 40| 2 1|
[task 2023-04-12T22:39:30.344Z] 22:39:30 INFO - 59 |nsStringBuffer | 8 32| 60 4|
[task 2023-04-12T22:39:30.346Z] 22:39:30 INFO - 60 |nsThread | 448 896| 3 2|
[task 2023-04-12T22:39:30.347Z] 22:39:30 INFO - 62 |nsThreadPool | 40 80| 2 2|
[task 2023-04-12T22:39:30.349Z] 22:39:30 INFO - 67 |nsTimer | 32 32| 2 1|
[task 2023-04-12T22:39:30.350Z] 22:39:30 INFO - 68 |nsTimerImpl | 176 176| 2 1|
[task 2023-04-12T22:39:30.351Z] 22:39:30 INFO -
[task 2023-04-12T22:39:30.352Z] 22:39:30 INFO - nsTraceRefcnt::DumpStatistics: 68 entries
[task 2023-04-12T22:39:30.354Z] 22:39:30 INFO - TEST-INFO | leakcheck | gmplugin leaked 1 BackgroundEventTarget
[task 2023-04-12T22:39:30.355Z] 22:39:30 INFO - TEST-INFO | leakcheck | gmplugin leaked 6 CondVar
[task 2023-04-12T22:39:30.356Z] 22:39:30 INFO - TEST-INFO | leakcheck | gmplugin leaked 1 IdlePeriod
[task 2023-04-12T22:39:30.357Z] 22:39:30 INFO - TEST-INFO | leakcheck | gmplugin leaked 1 MessageLoop::EventTarget
[task 2023-04-12T22:39:30.358Z] 22:39:30 INFO - TEST-INFO | leakcheck | gmplugin leaked 1 MessagePump
[task 2023-04-12T22:39:30.360Z] 22:39:30 INFO - TEST-INFO | leakcheck | gmplugin leaked 12 Mutex
[task 2023-04-12T22:39:30.361Z] 22:39:30 INFO - TEST-INFO | leakcheck | gmplugin leaked 1 ProfilerParentTracker
[task 2023-04-12T22:39:30.362Z] 22:39:30 INFO - TEST-INFO | leakcheck | gmplugin leaked 2 TaskController::ExecutePendingMTTasks(
[task 2023-04-12T22:39:30.363Z] 22:39:30 INFO - TEST-INFO | leakcheck | gmplugin leaked 3 TaskManager
[task 2023-04-12T22:39:30.365Z] 22:39:30 INFO - TEST-INFO | leakcheck | gmplugin leaked 2 ThreadEventTarget
[task 2023-04-12T22:39:30.366Z] 22:39:30 INFO - TEST-INFO | leakcheck | gmplugin leaked 2 ThreadTargetSink
[task 2023-04-12T22:39:30.368Z] 22:39:30 INFO - TEST-INFO | leakcheck | gmplugin leaked 1 WaitableEventKernel
[task 2023-04-12T22:39:30.369Z] 22:39:30 INFO - TEST-INFO | leakcheck | gmplugin leaked 1 XPCOMThreadWrapper
[task 2023-04-12T22:39:30.370Z] 22:39:30 INFO - TEST-INFO | leakcheck | gmplugin leaked 1 ipc::DoWorkRunnable
[task 2023-04-12T22:39:30.371Z] 22:39:30 INFO - TEST-INFO | leakcheck | gmplugin leaked 4 nsStringBuffer
[task 2023-04-12T22:39:30.373Z] 22:39:30 INFO - TEST-INFO | leakcheck | gmplugin leaked 2 nsThread
[task 2023-04-12T22:39:30.373Z] 22:39:30 INFO - TEST-INFO | leakcheck | gmplugin leaked 2 nsThreadPool
[task 2023-04-12T22:39:30.374Z] 22:39:30 INFO - TEST-INFO | leakcheck | gmplugin leaked 1 nsTimer
[task 2023-04-12T22:39:30.375Z] 22:39:30 INFO - TEST-INFO | leakcheck | gmplugin leaked 1 nsTimerImpl
[task 2023-04-12T22:39:30.376Z] 22:39:30 INFO - WARNING | leakcheck | gmplugin 3472 bytes leaked (BackgroundEventTarget, CondVar, IdlePeriod, MessageLoop::EventTarget, MessagePump, ...)
[task 2023-04-12T22:39:30.378Z] 22:39:30 INFO -
[task 2023-04-12T22:39:30.379Z] 22:39:30 INFO - leakcheck | Processing leak log file /tmp/tmpvisdd075.mozrunner/runtests_leaks_tab_pid17404.log
[task 2023-04-12T22:39:30.380Z] 22:39:30 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2023-04-12T22:39:30.381Z] 22:39:30 INFO - leakcheck | Processing leak log file /tmp/tmpvisdd075.mozrunner/runtests_leaks_tab_pid17381.log
[task 2023-04-12T22:39:30.382Z] 22:39:30 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2023-04-12T22:39:30.382Z] 22:39:30 INFO - leakcheck | Processing leak log file /tmp/tmpvisdd075.mozrunner/runtests_leaks_tab_pid17225.log
[task 2023-04-12T22:39:30.383Z] 22:39:30 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2023-04-12T22:39:30.384Z] 22:39:30 INFO - leakcheck | Processing leak log file /tmp/tmpvisdd075.mozrunner/runtests_leaks.log
[task 2023-04-12T22:39:30.389Z] 22:39:30 INFO -
[task 2023-04-12T22:39:30.390Z] 22:39:30 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, default process 17132
[task 2023-04-12T22:39:30.390Z] 22:39:30 INFO -
[task 2023-04-12T22:39:30.391Z] 22:39:30 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2023-04-12T22:39:30.394Z] 22:39:30 INFO - | | Per-Inst Leaked| Total Rem|
[task 2023-04-12T22:39:30.395Z] 22:39:30 INFO - 0 |TOTAL | 54 1808| 890145 14|
[task 2023-04-12T22:39:30.396Z] 22:39:30 INFO - 184 |CondVar | 80 240| 464 3|
[task 2023-04-12T22:39:30.396Z] 22:39:30 INFO - 584 |Mutex | 72 288| 10507 4|
[task 2023-04-12T22:39:30.397Z] 22:39:30 INFO - 843 |PSandboxTestingParent | 368 368| 5 1|
[task 2023-04-12T22:39:30.398Z] 22:39:30 INFO - 1015 |RefCountedMonitor | 160 160| 117 1|
[task 2023-04-12T22:39:30.399Z] 22:39:30 INFO - 1218 |ThreadEventTarget | 48 48| 70 1|
[task 2023-04-12T22:39:30.400Z] 22:39:30 INFO - 1223 |ThreadTargetSink | 16 16| 70 1|
[task 2023-04-12T22:39:30.400Z] 22:39:30 INFO - 1462 |ipc::MessageChannel | 232 232| 117 1|
[task 2023-04-12T22:39:30.401Z] 22:39:30 INFO - 1895 |nsStringBuffer | 8 8| 189295 1|
[task 2023-04-12T22:39:30.402Z] 22:39:30 INFO - 1934 |nsThread | 448 448| 96 1|
[task 2023-04-12T22:39:30.403Z] 22:39:30 INFO -
[task 2023-04-12T22:39:30.404Z] 22:39:30 INFO - nsTraceRefcnt::DumpStatistics: 2034 entries
[task 2023-04-12T22:39:30.404Z] 22:39:30 INFO - TEST-INFO | leakcheck | default leaked 3 CondVar
[task 2023-04-12T22:39:30.404Z] 22:39:30 INFO - TEST-INFO | leakcheck | default leaked 4 Mutex
[task 2023-04-12T22:39:30.404Z] 22:39:30 INFO - TEST-INFO | leakcheck | default leaked 1 PSandboxTestingParent
[task 2023-04-12T22:39:30.405Z] 22:39:30 INFO - TEST-INFO | leakcheck | default leaked 1 RefCountedMonitor
[task 2023-04-12T22:39:30.405Z] 22:39:30 INFO - TEST-INFO | leakcheck | default leaked 1 ThreadEventTarget
[task 2023-04-12T22:39:30.405Z] 22:39:30 INFO - TEST-INFO | leakcheck | default leaked 1 ThreadTargetSink
[task 2023-04-12T22:39:30.405Z] 22:39:30 INFO - TEST-INFO | leakcheck | default leaked 1 ipc::MessageChannel
[task 2023-04-12T22:39:30.405Z] 22:39:30 INFO - TEST-INFO | leakcheck | default leaked 1 nsStringBuffer
[task 2023-04-12T22:39:30.405Z] 22:39:30 INFO - TEST-INFO | leakcheck | default leaked 1 nsThread
[task 2023-04-12T22:39:30.405Z] 22:39:30 INFO - TEST-UNEXPECTED-FAIL | leakcheck | default 1808 bytes leaked (CondVar, Mutex, PSandboxTestingParent, RefCountedMonitor, ThreadEventTarget, ...)
[task 2023-04-12T22:39:30.406Z] 22:39:30 INFO -
[task 2023-04-12T22:39:30.406Z] 22:39:30 INFO - leakcheck | Processing leak log file /tmp/tmpvisdd075.mozrunner/runtests_leaks_tab_pid17198.log
[task 2023-04-12T22:39:30.406Z] 22:39:30 INFO - TEST-PASS | leakcheck | tab no leaks detected!
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 2•2 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → INCOMPLETE
|
Reporter | |
Comment 3•2 years ago
|
||
| treeherder | ||
New failure instance: https://treeherder.mozilla.org/logviewer?job_id=420952369&repo=mozilla-esr102
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
| Comment hidden (Intermittent Failures Robot) |
|
|
||
Comment 5•2 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.
Status: REOPENED → RESOLVED
Closed: 2 years ago → 2 years ago
Resolution: --- → INCOMPLETE
You need to log in
before you can comment on or make changes to this bug.
Description
•