Closed
Bug 1662891
Opened 5 years ago
Closed 5 years ago
Intermittent leakcheck | tab 14040 bytes leaked (ChannelEvent, ChannelEventQueue, CondVar, ConsoleReportCollector, CookieJarSettings, ...) while running shared-worker/eventsource-url.htm
Categories
(Core :: DOM: Events, defect, P5)
Core
DOM: Events
Tracking
()
RESOLVED
INCOMPLETE
People
(Reporter: intermittent-bug-filer, Unassigned)
Details
(Keywords: intermittent-failure)
Filed by: malexandru [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=314736434&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/BMVWO3a6S3-q6uGIJTPqFQ/runs/0/artifacts/public/logs/live_backing.log
[task 2020-09-02T20:02:20.595Z] 20:02:20 INFO - TEST-OK | /eventsource/shared-worker/eventsource-prototype.htm | took 545ms
[task 2020-09-02T20:02:20.595Z] 20:02:20 INFO - TEST-START | /eventsource/shared-worker/eventsource-url.htm
[task 2020-09-02T20:02:20.595Z] 20:02:20 INFO - Closing window 48
[task 2020-09-02T20:02:20.655Z] 20:02:20 INFO - PID 2799 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-09-02T20:02:21.277Z] 20:02:21 INFO - .
[task 2020-09-02T20:02:21.277Z] 20:02:21 INFO - TEST-OK | /eventsource/shared-worker/eventsource-url.htm | took 703ms
[task 2020-09-02T20:02:21.302Z] 20:02:21 INFO - Restarting browser for new test group
[task 2020-09-02T20:02:21.324Z] 20:02:21 INFO - PID 2799 | 1599076941318 Marionette INFO Stopped listening on port 50545
[task 2020-09-02T20:02:21.682Z] 20:02:21 INFO - PID 2799 | [Child 2801, Main Thread] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/checkouts/gecko/widget/cocoa/nsAppShell.mm, line 714
[task 2020-09-02T20:02:21.682Z] 20:02:21 INFO - PID 2799 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-09-02T20:02:21.734Z] 20:02:21 INFO - PID 2799 | [Child 2802, Main Thread] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/checkouts/gecko/widget/cocoa/nsAppShell.mm, line 714
[task 2020-09-02T20:02:21.816Z] 20:02:21 INFO - PID 2799 | [2020-09-02T20:02:21Z WARN xulstore::persist] tried to remove key that isn't in the store
[task 2020-09-02T20:02:21.817Z] 20:02:21 INFO - PID 2799 | [2020-09-02T20:02:21Z WARN xulstore::persist] tried to remove key that isn't in the store
[task 2020-09-02T20:02:21.817Z] 20:02:21 INFO - PID 2799 | [Child 2802, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-09-02T20:02:21.848Z] 20:02:21 INFO - PID 2799 | [Child 2802, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp, line 4286
[task 2020-09-02T20:02:21.859Z] 20:02:21 INFO - PID 2799 | [Child 2801, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-09-02T20:02:21.882Z] 20:02:21 INFO - PID 2799 | [Child 2801, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp, line 4286
[task 2020-09-02T20:02:22.271Z] 20:02:22 INFO - PID 2799 | [Child 2803, Main Thread] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/checkouts/gecko/widget/cocoa/nsAppShell.mm, line 714
[task 2020-09-02T20:02:22.273Z] 20:02:22 INFO - PID 2799 | [Child 2804, Main Thread] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/checkouts/gecko/widget/cocoa/nsAppShell.mm, line 714
[task 2020-09-02T20:02:22.274Z] 20:02:22 INFO - PID 2799 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
[task 2020-09-02T20:02:22.310Z] 20:02:22 INFO - PID 2799 | [Child 2804, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-09-02T20:02:22.312Z] 20:02:22 INFO - PID 2799 | [Child 2804, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp, line 4286
[task 2020-09-02T20:02:22.579Z] 20:02:22 INFO - PID 2799 | [Parent 2799, Main Thread] WARNING: NS_ENSURE_TRUE(mDB) failed: file /builds/worker/checkouts/gecko/netwerk/cache/nsDiskCacheDeviceSQL.cpp, line 1276
[task 2020-09-02T20:02:22.580Z] 20:02:22 INFO - PID 2799 | [Parent 2799, Main Thread] WARNING: nsAppShell::Exit() called redundantly: file /builds/worker/checkouts/gecko/widget/cocoa/nsAppShell.mm, line 714
[task 2020-09-02T20:02:22.649Z] 20:02:22 INFO - PID 2799 | [Parent 2799, 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-09-02T20:02:22.649Z] 20:02:22 INFO - PID 2799 | [Parent 2799, 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 256
[task 2020-09-02T20:02:22.667Z] 20:02:22 INFO - PID 2799 | [Child 2803, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-09-02T20:02:22.691Z] 20:02:22 INFO - PID 2799 | [Child 2803, Main Thread] ###!!! ASSERTION: 1 dynamic atom(s) with non-zero refcount: http://web-platform.test:8000: 'nonZeroRefcountAtomsCount == 0', file /builds/worker/checkouts/gecko/xpcom/ds/nsAtomTable.cpp, line 444
[task 2020-09-02T20:02:22.691Z] 20:02:22 INFO - PID 2799 | [Child 2803, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp, line 4286
[task 2020-09-02T20:02:22.691Z] 20:02:22 INFO - PID 2799 | Leaked URLs:
[task 2020-09-02T20:02:22.691Z] 20:02:22 INFO - PID 2799 | http://web-platform.test:8000/eventsource/shared-worker/eventsource-close.js
[task 2020-09-02T20:02:22.691Z] 20:02:22 INFO - PID 2799 | http://web-platform.test:8000/
[task 2020-09-02T20:02:22.691Z] 20:02:22 INFO - PID 2799 | http://web-platform.test:8000/eventsource/resources/message.py
[task 2020-09-02T20:02:22.691Z] 20:02:22 INFO - PID 2799 | http://web-platform.test:8000/eventsource/shared-worker/eventsource-onopen.js
[task 2020-09-02T20:02:22.692Z] 20:02:22 INFO - PID 2799 | http://web-platform.test:8000/
[task 2020-09-02T20:02:22.692Z] 20:02:22 INFO - PID 2799 | http://web-platform.test:8000/eventsource/resources/message.py
[task 2020-09-02T20:02:22.692Z] 20:02:22 INFO - PID 2799 | nsStringStats
[task 2020-09-02T20:02:22.692Z] 20:02:22 INFO - PID 2799 | => mAllocCount: 19940
[task 2020-09-02T20:02:22.692Z] 20:02:22 INFO - PID 2799 | => mReallocCount: 0
[task 2020-09-02T20:02:22.692Z] 20:02:22 INFO - PID 2799 | => mFreeCount: 19883 -- LEAKED 57 !!!
[task 2020-09-02T20:02:22.692Z] 20:02:22 INFO - PID 2799 | => mShareCount: 34352
[task 2020-09-02T20:02:22.692Z] 20:02:22 INFO - PID 2799 | => mAdoptCount: 580
[task 2020-09-02T20:02:22.692Z] 20:02:22 INFO - PID 2799 | => mAdoptFreeCount: 656
[task 2020-09-02T20:02:22.692Z] 20:02:22 INFO - PID 2799 | => Process ID: 2803, Thread ID: 4632221120
[task 2020-09-02T20:02:23.565Z] 20:02:23 INFO - PID 2799 | [Parent 2799, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp, line 3359
[task 2020-09-02T20:02:23.609Z] 20:02:23 INFO - PID 2799 | [Parent 2799, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp, line 4286
[task 2020-09-02T20:02:23.665Z] 20:02:23 INFO - Browser exited with return code 0
[task 2020-09-02T20:02:23.665Z] 20:02:23 INFO - PROCESS LEAKS /var/folders/ng/1t75hz8x645gs2cfs1nk8qk0000017/T/tmp76jgbJ/runtests_leaks_2736.log
[task 2020-09-02T20:02:23.666Z] 20:02:23 INFO - leakcheck | Processing log file /var/folders/ng/1t75hz8x645gs2cfs1nk8qk0000017/T/tmp76jgbJ/runtests_leaks_2736.log for scope /eventsource/shared-worker
[task 2020-09-02T20:02:23.666Z] 20:02:23 INFO - TEST-INFO | leakcheck | default process: leak threshold set at 51200 bytes
[task 2020-09-02T20:02:23.666Z] 20:02:23 INFO - TEST-INFO | leakcheck | forkserver process: leak threshold set at 0 bytes
[task 2020-09-02T20:02:23.666Z] 20:02:23 INFO - TEST-INFO | leakcheck | gmplugin process: leak threshold set at 20000 bytes
[task 2020-09-02T20:02:23.666Z] 20:02:23 INFO - TEST-INFO | leakcheck | gpu process: leak threshold set at 0 bytes
[task 2020-09-02T20:02:23.666Z] 20:02:23 INFO - TEST-INFO | leakcheck | plugin process: leak threshold set at 0 bytes
[task 2020-09-02T20:02:23.666Z] 20:02:23 INFO - TEST-INFO | leakcheck | rdd process: leak threshold set at 400 bytes
[task 2020-09-02T20:02:23.666Z] 20:02:23 INFO - TEST-INFO | leakcheck | socket process: leak threshold set at 0 bytes
[task 2020-09-02T20:02:23.667Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab process: leak threshold set at 10000 bytes
[task 2020-09-02T20:02:23.667Z] 20:02:23 INFO - TEST-INFO | leakcheck | vr process: leak threshold set at 0 bytes
[task 2020-09-02T20:02:23.667Z] 20:02:23 INFO - leakcheck | Processing leak log file /var/folders/ng/1t75hz8x645gs2cfs1nk8qk0000017/T/tmp76jgbJ/runtests_leaks_2736.log
[task 2020-09-02T20:02:23.667Z] 20:02:23 INFO -
[task 2020-09-02T20:02:23.667Z] 20:02:23 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, default process 2799
[task 2020-09-02T20:02:23.667Z] 20:02:23 INFO -
[task 2020-09-02T20:02:23.667Z] 20:02:23 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2020-09-02T20:02:23.668Z] 20:02:23 INFO - | | Per-Inst Leaked| Total Rem|
[task 2020-09-02T20:02:23.668Z] 20:02:23 INFO - 0 |TOTAL | 34 0| 5159046 0|
[task 2020-09-02T20:02:23.668Z] 20:02:23 INFO -
[task 2020-09-02T20:02:23.668Z] 20:02:23 INFO - nsTraceRefcnt::DumpStatistics: 1977 entries
[task 2020-09-02T20:02:23.668Z] 20:02:23 INFO - TEST-PASS | leakcheck | default no leaks detected!
[task 2020-09-02T20:02:23.668Z] 20:02:23 INFO - leakcheck | Processing leak log file /var/folders/ng/1t75hz8x645gs2cfs1nk8qk0000017/T/tmp76jgbJ/runtests_leaks_2736_tab_pid2802.log
[task 2020-09-02T20:02:23.668Z] 20:02:23 INFO -
[task 2020-09-02T20:02:23.668Z] 20:02:23 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 2802
[task 2020-09-02T20:02:23.669Z] 20:02:23 INFO -
[task 2020-09-02T20:02:23.669Z] 20:02:23 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2020-09-02T20:02:23.669Z] 20:02:23 INFO - | | Per-Inst Leaked| Total Rem|
[task 2020-09-02T20:02:23.669Z] 20:02:23 INFO - 0 |TOTAL | 35 0| 69568 0|
[task 2020-09-02T20:02:23.669Z] 20:02:23 INFO -
[task 2020-09-02T20:02:23.676Z] 20:02:23 INFO - nsTraceRefcnt::DumpStatistics: 849 entries
[task 2020-09-02T20:02:23.677Z] 20:02:23 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2020-09-02T20:02:23.677Z] 20:02:23 INFO - leakcheck | Processing leak log file /var/folders/ng/1t75hz8x645gs2cfs1nk8qk0000017/T/tmp76jgbJ/runtests_leaks_2736_tab_pid2803.log
[task 2020-09-02T20:02:23.677Z] 20:02:23 INFO -
[task 2020-09-02T20:02:23.677Z] 20:02:23 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 2803
[task 2020-09-02T20:02:23.677Z] 20:02:23 INFO -
[task 2020-09-02T20:02:23.677Z] 20:02:23 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2020-09-02T20:02:23.677Z] 20:02:23 INFO - | | Per-Inst Leaked| Total Rem|
[task 2020-09-02T20:02:23.678Z] 20:02:23 INFO - 0 |TOTAL | 46 14040| 191054 201|
[task 2020-09-02T20:02:23.678Z] 20:02:23 INFO - 45 |ChannelEvent | 8 64| 249 8|
[task 2020-09-02T20:02:23.678Z] 20:02:23 INFO - 46 |ChannelEventQueue | 248 496| 52 2|
[task 2020-09-02T20:02:23.678Z] 20:02:23 INFO - 75 |CondVar | 80 240| 140 3|
[task 2020-09-02T20:02:23.678Z] 20:02:23 INFO - 79 |ConsoleReportCollector | 136 272| 100 2|
[task 2020-09-02T20:02:23.678Z] 20:02:23 INFO - 82 |CookieJarSettings | 72 144| 59 2|
[task 2020-09-02T20:02:23.678Z] 20:02:23 INFO - 105 |DataStorage | 496 992| 4 2|
[task 2020-09-02T20:02:23.679Z] 20:02:23 INFO - 133 |EventSourceImpl | 504 1008| 11 2|
[task 2020-09-02T20:02:23.679Z] 20:02:23 INFO - 190 |IdlePeriod | 24 24| 1 1|
[task 2020-09-02T20:02:23.679Z] 20:02:23 INFO - 195 |IdleSchedulerChild | 128 128| 1 1|
[task 2020-09-02T20:02:23.679Z] 20:02:23 INFO - 226 |LoadInfo | 424 848| 153 2|
[task 2020-09-02T20:02:23.679Z] 20:02:23 INFO - 260 |Mutex | 104 2288| 1150 22|
[task 2020-09-02T20:02:23.679Z] 20:02:23 INFO - 356 |PHttpChannelChild | 48 96| 52 2|
[task 2020-09-02T20:02:23.679Z] 20:02:23 INFO - 359 |PIdleSchedulerChild | 56 56| 1 1|
[task 2020-09-02T20:02:23.679Z] 20:02:23 INFO - 408 |Permission | 72 144| 21 2|
[task 2020-09-02T20:02:23.680Z] 20:02:23 INFO - 413 |PollableEvent | 32 32| 1 1|
[task 2020-09-02T20:02:23.680Z] 20:02:23 INFO - 450 |RequestContextService | 80 80| 1 1|
[task 2020-09-02T20:02:23.680Z] 20:02:23 INFO - 528 |TaskManager | 32 64| 2 2|
[task 2020-09-02T20:02:23.680Z] 20:02:23 INFO - 532 |ThreadEventTarget | 48 48| 61 1|
[task 2020-09-02T20:02:23.680Z] 20:02:23 INFO - 538 |ThreadTargetSink | 16 16| 61 1|
[task 2020-09-02T20:02:23.680Z] 20:02:23 INFO - 571 |WeakReference | 32 64| 390 2|
[task 2020-09-02T20:02:23.680Z] 20:02:23 INFO - 666 |nsAuthURLParser | 24 24| 2 1|
[task 2020-09-02T20:02:23.681Z] 20:02:23 INFO - 683 |nsCORSListenerProxy | 224 448| 6 2|
[task 2020-09-02T20:02:23.681Z] 20:02:23 INFO - 686 |nsCategoryObserver | 104 104| 2 1|
[task 2020-09-02T20:02:23.681Z] 20:02:23 INFO - 710 |nsDeque | 104 208| 99 2|
[task 2020-09-02T20:02:23.681Z] 20:02:23 INFO - 711 |nsDequeBase | 96 192| 99 2|
[task 2020-09-02T20:02:23.681Z] 20:02:23 INFO - 789 |nsHttpAuthCache::OriginClearObserver | 32 64| 2 2|
[task 2020-09-02T20:02:23.681Z] 20:02:23 INFO - 790 |nsHttpHandler | 1240 1240| 1 1|
[task 2020-09-02T20:02:23.681Z] 20:02:23 INFO - 791 |nsHttpRequestHead | 200 400| 52 2|
[task 2020-09-02T20:02:23.681Z] 20:02:23 INFO - 796 |nsIOService | 520 520| 1 1|
[task 2020-09-02T20:02:23.682Z] 20:02:23 INFO - 810 |nsJSPrincipals | 24 96| 580 4|
[task 2020-09-02T20:02:23.682Z] 20:02:23 INFO - 821 |nsMainThreadPtrHolder<T> | 40 80| 18 2|
[task 2020-09-02T20:02:23.682Z] 20:02:23 INFO - 838 |nsObserverService | 80 80| 1 1|
[task 2020-09-02T20:02:23.682Z] 20:02:23 INFO - 871 |nsSiteSecurityService | 80 80| 1 1|
[task 2020-09-02T20:02:23.682Z] 20:02:23 INFO - 873 |nsSocketTransportService | 400 400| 1 1|
[task 2020-09-02T20:02:23.682Z] 20:02:23 INFO - 874 |nsStandardURL | 248 1488| 1329 6|
[task 2020-09-02T20:02:23.682Z] 20:02:23 INFO - 880 |nsStringBuffer | 8 456| 19939 57|
[task 2020-09-02T20:02:23.683Z] 20:02:23 INFO - 914 |nsTArray_base | 8 360| 73662 45|
[task 2020-09-02T20:02:23.683Z] 20:02:23 INFO - 917 |nsThread | 336 336| 23 1|
[task 2020-09-02T20:02:23.683Z] 20:02:23 INFO - 932 |nsWeakReference | 40 360| 286 9|
[task 2020-09-02T20:02:23.683Z] 20:02:23 INFO -
[task 2020-09-02T20:02:23.683Z] 20:02:23 INFO - nsTraceRefcnt::DumpStatistics: 955 entries
[task 2020-09-02T20:02:23.683Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 8 ChannelEvent
[task 2020-09-02T20:02:23.683Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 2 ChannelEventQueue
[task 2020-09-02T20:02:23.683Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 3 CondVar
[task 2020-09-02T20:02:23.684Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 2 ConsoleReportCollector
[task 2020-09-02T20:02:23.684Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 2 CookieJarSettings
[task 2020-09-02T20:02:23.684Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 2 DataStorage
[task 2020-09-02T20:02:23.684Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 2 EventSourceImpl
[task 2020-09-02T20:02:23.684Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 1 IdlePeriod
[task 2020-09-02T20:02:23.684Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 1 IdleSchedulerChild
[task 2020-09-02T20:02:23.684Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 2 LoadInfo
[task 2020-09-02T20:02:23.684Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 22 Mutex
[task 2020-09-02T20:02:23.685Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 2 PHttpChannelChild
[task 2020-09-02T20:02:23.691Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 1 PIdleSchedulerChild
[task 2020-09-02T20:02:23.692Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 2 Permission
[task 2020-09-02T20:02:23.692Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 1 PollableEvent
[task 2020-09-02T20:02:23.692Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 1 RequestContextService
[task 2020-09-02T20:02:23.692Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 2 TaskManager
[task 2020-09-02T20:02:23.692Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 1 ThreadEventTarget
[task 2020-09-02T20:02:23.692Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 1 ThreadTargetSink
[task 2020-09-02T20:02:23.692Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 2 WeakReference
[task 2020-09-02T20:02:23.693Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 1 nsAuthURLParser
[task 2020-09-02T20:02:23.693Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 2 nsCORSListenerProxy
[task 2020-09-02T20:02:23.693Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 1 nsCategoryObserver
[task 2020-09-02T20:02:23.693Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 2 nsDeque
[task 2020-09-02T20:02:23.693Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 2 nsDequeBase
[task 2020-09-02T20:02:23.693Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 2 nsHttpAuthCache::OriginClearObserver
[task 2020-09-02T20:02:23.693Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 1 nsHttpHandler
[task 2020-09-02T20:02:23.693Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 2 nsHttpRequestHead
[task 2020-09-02T20:02:23.694Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 1 nsIOService
[task 2020-09-02T20:02:23.694Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 4 nsJSPrincipals
[task 2020-09-02T20:02:23.694Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 2 nsMainThreadPtrHolder<T>
[task 2020-09-02T20:02:23.694Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 1 nsObserverService
[task 2020-09-02T20:02:23.694Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 1 nsSiteSecurityService
[task 2020-09-02T20:02:23.694Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 1 nsSocketTransportService
[task 2020-09-02T20:02:23.694Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 6 nsStandardURL
[task 2020-09-02T20:02:23.695Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 57 nsStringBuffer
[task 2020-09-02T20:02:23.695Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 45 nsTArray_base
[task 2020-09-02T20:02:23.695Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 1 nsThread
[task 2020-09-02T20:02:23.695Z] 20:02:23 INFO - TEST-INFO | leakcheck | tab leaked 9 nsWeakReference
[task 2020-09-02T20:02:23.695Z] 20:02:23 INFO - TEST-UNEXPECTED-FAIL | leakcheck | tab 14040 bytes leaked (ChannelEvent, ChannelEventQueue, CondVar, ConsoleReportCollector, CookieJarSettings, ...)
[task 2020-09-02T20:02:23.695Z] 20:02:23 INFO -
[task 2020-09-02T20:02:23.695Z] 20:02:23 INFO - leakcheck | Processing leak log file /var/folders/ng/1t75hz8x645gs2cfs1nk8qk0000017/T/tmp76jgbJ/runtests_leaks_2736_tab_pid2801.log
[task 2020-09-02T20:02:23.695Z] 20:02:23 INFO -
[task 2020-09-02T20:02:23.696Z] 20:02:23 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 2801
[task 2020-09-02T20:02:23.696Z] 20:02:23 INFO -
[task 2020-09-02T20:02:23.696Z] 20:02:23 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2020-09-02T20:02:23.696Z] 20:02:23 INFO - | | Per-Inst Leaked| Total Rem|
[task 2020-09-02T20:02:23.696Z] 20:02:23 INFO - 0 |TOTAL | 39 0| 88338 0|
[task 2020-09-02T20:02:23.697Z] 20:02:23 INFO -
[task 2020-09-02T20:02:23.697Z] 20:02:23 INFO - nsTraceRefcnt::DumpStatistics: 814 entries
[task 2020-09-02T20:02:23.697Z] 20:02:23 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2020-09-02T20:02:23.697Z] 20:02:23 INFO - leakcheck | Processing leak log file /var/folders/ng/1t75hz8x645gs2cfs1nk8qk0000017/T/tmp76jgbJ/runtests_leaks_2736_tab_pid2804.log
[task 2020-09-02T20:02:23.697Z] 20:02:23 INFO -
[task 2020-09-02T20:02:23.697Z] 20:02:23 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 2804
[task 2020-09-02T20:02:23.697Z] 20:02:23 INFO -
[task 2020-09-02T20:02:23.698Z] 20:02:23 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
[task 2020-09-02T20:02:23.698Z] 20:02:23 INFO - | | Per-Inst Leaked| Total Rem|
[task 2020-09-02T20:02:23.698Z] 20:02:23 INFO - 0 |TOTAL | 34 0| 16254 0|
[task 2020-09-02T20:02:23.698Z] 20:02:23 INFO -
[task 2020-09-02T20:02:23.698Z] 20:02:23 INFO - nsTraceRefcnt::DumpStatistics: 375 entries
[task 2020-09-02T20:02:23.698Z] 20:02:23 INFO - TEST-PASS | leakcheck | tab no leaks detected!
[task 2020-09-02T20:02:23.701Z] 20:02:23 INFO - Closing logging queue
[task 2020-09-02T20:02:23.701Z] 20:02:23 INFO - queue closed
[task 2020-09-02T20:02:23.727Z] 20:02:23 INFO - Application command: /Users/cltbld/tasks/task_1599066405/build/application/Firefox NightlyDebug.app/Contents/MacOS/firefox --marionette about:blank -foreground -profile /var/folders/ng/1t75hz8x645gs2cfs1nk8qk0000017/T/tmpAZgJ5E
[task 2020-09-02T20:02:23.727Z] 20:02:23 INFO - Starting runner
[task 2020-09-02T20:02:23.775Z] 20:02:23 INFO - PID 2805 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/ng/1t75hz8x645gs2cfs1nk8qk0000017/T/tmpAZgJ5E/runtests_leaks_2736.log
[task 2020-09-02T20:02:23.776Z] 20:02:23 INFO - PID 2805 | [2805, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp, line 246
[task 2020-09-02T20:02:24.777Z] 20:02:24 INFO - PID 2805 | [2020-09-02T20:02:24Z WARN rkv::backend::impl_safe::environment] `load_ratio()` is irrelevant for this storage backend.
[task 2020-09-02T20:02:24.988Z] 20:02:24 INFO - PID 2805 | [2805, Main Thread] WARNING: 'NS_FAILED(rv)', file /builds/worker/checkouts/gecko/dom/presentation/provider/MulticastDNSDeviceProvider.cpp, line 124
[task 2020-09-02T20:02:24.988Z] 20:02:24 INFO - PID 2805 | [2805, Main Thread] WARNING: 'NS_FAILED(rv = Init())', file /builds/worker/checkouts/gecko/dom/presentation/provider/MulticastDNSDeviceProvider.cpp, line 568
[task 2020-09-02T20:02:25.372Z] 20:02:25 INFO - PID 2805 | [2805, Main Thread] WARNING: NS_ENSURE_TRUE(rootFrame) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp, line 4271
[task 2020-09-02T20:02:25.475Z] 20:02:25 INFO - PID 2805 | [2805, Main Thread] WARNING: NS_ENSURE_TRUE(rootFrame) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp, line 4271
[task 2020-09-02T20:02:26.142Z] 20:02:26 INFO - PID 2805 | [2805, Main Thread] WARNING: NS_ENSURE_TRUE(presShell) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp, line 4269
[task 2020-09-02T20:02:26.223Z] 20:02:26 INFO - PID 2805 | [2807, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-09-02T20:02:26.223Z] 20:02:26 INFO - PID 2805 | [2807, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-09-02T20:02:26.223Z] 20:02:26 INFO - PID 2805 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/ng/1t75hz8x645gs2cfs1nk8qk0000017/T/tmpAZgJ5E/runtests_leaks_2736_tab_pid2807.log
[task 2020-09-02T20:02:26.223Z] 20:02:26 INFO - PID 2805 | [2807, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-09-02T20:02:26.226Z] 20:02:26 INFO - PID 2805 | [2807, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-09-02T20:02:26.226Z] 20:02:26 INFO - PID 2805 | [2807, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp, line 246
[task 2020-09-02T20:02:26.226Z] 20:02:26 INFO - PID 2805 | [Parent 2805, GMPThread] WARNING: Failed to delete GMP storage directory: file /builds/worker/checkouts/gecko/dom/media/gmp/GMPServiceParent.cpp, line 1561
[task 2020-09-02T20:02:26.235Z] 20:02:26 INFO - PID 2805 | [Parent 2805, Main Thread] WARNING: Need BrowserChild to get the nativeWindow from!: file /builds/worker/checkouts/gecko/widget/PuppetWidget.cpp, line 1086
[task 2020-09-02T20:02:26.251Z] 20:02:26 INFO - PID 2805 | [Parent 2805, Main Thread] WARNING: Need BrowserChild to get the nativeWindow from!: file /builds/worker/checkouts/gecko/widget/PuppetWidget.cpp, line 1086
[task 2020-09-02T20:02:26.252Z] 20:02:26 INFO - PID 2805 | [Parent 2805, Main Thread] WARNING: Need BrowserChild to get the nativeWindow from!: file /builds/worker/checkouts/gecko/widget/PuppetWidget.cpp, line 1086
[task 2020-09-02T20:02:26.252Z] 20:02:26 INFO - PID 2805 | [Parent 2805, Main Thread] WARNING: Need BrowserChild to get the nativeWindow from!: file /builds/worker/checkouts/gecko/widget/PuppetWidget.cpp, line 1086
[task 2020-09-02T20:02:26.485Z] 20:02:26 INFO - PID 2805 | [Child 2807, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp, line 2680
[task 2020-09-02T20:02:26.494Z] 20:02:26 INFO - PID 2805 | [Child 2807, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp, line 2680
[task 2020-09-02T20:02:26.499Z] 20:02:26 INFO - PID 2805 | [Child 2807, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp, line 2680
[task 2020-09-02T20:02:26.509Z] 20:02:26 INFO - PID 2805 | [Child 2807, Main Thread] WARNING: Fallback to BasicLayerManager: file /builds/worker/checkouts/gecko/dom/ipc/BrowserChild.cpp, line 2680
[task 2020-09-02T20:02:26.533Z] 20:02:26 INFO - PID 2805 | [2808, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-09-02T20:02:26.533Z] 20:02:26 INFO - PID 2805 | [2808, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-09-02T20:02:26.533Z] 20:02:26 INFO - PID 2805 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/ng/1t75hz8x645gs2cfs1nk8qk0000017/T/tmpAZgJ5E/runtests_leaks_2736_tab_pid2808.log
[task 2020-09-02T20:02:26.534Z] 20:02:26 INFO - PID 2805 | [2808, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-09-02T20:02:26.534Z] 20:02:26 INFO - PID 2805 | [2808, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-09-02T20:02:26.534Z] 20:02:26 INFO - PID 2805 | [2808, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp, line 246
[task 2020-09-02T20:02:26.869Z] 20:02:26 INFO - PID 2805 | [Parent 2805, Main Thread] WARNING: NS_ENSURE_TRUE(presShell) failed: file /builds/worker/checkouts/gecko/dom/base/nsGlobalWindowOuter.cpp, line 4269
[task 2020-09-02T20:02:27.357Z] 20:02:27 INFO - PID 2805 | [Parent 2805, Main Thread] WARNING: NS_ENSURE_TRUE(mPresShell) failed: file /builds/worker/checkouts/gecko/layout/generic/nsFrameSelection.cpp, line 1598
[task 2020-09-02T20:02:27.688Z] 20:02:27 INFO - PID 2805 | console.error: SearchCache: "_readCacheFile: Error reading cache file:" (new Error("", "(unknown module)"))
[task 2020-09-02T20:02:28.272Z] 20:02:28 INFO - PID 2805 | [Parent 2805, StreamTrans #29] WARNING: Existing entry in StartupCache.: file /builds/worker/checkouts/gecko/startupcache/StartupCache.cpp, line 977
[task 2020-09-02T20:02:28.566Z] 20:02:28 INFO - PID 2805 | [Parent 2805, Main Thread] WARNING: Suboptimal indexes for the SQL statement 0x15598ec60 (http://mzl.la/1FuID0j).: file /builds/worker/checkouts/gecko/storage/mozStoragePrivateHelpers.cpp, line 113
[task 2020-09-02T20:02:28.718Z] 20:02:28 INFO - PID 2805 | [Parent 2805, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005 (NS_ERROR_FAILURE): file /builds/worker/checkouts/gecko/dom/base/ThirdPartyUtil.cpp, line 402
[task 2020-09-02T20:02:28.724Z] 20:02:28 INFO - PID 2805 | [Parent 2805, Main Thread] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/worker/checkouts/gecko/parser/html/nsHtml5StreamParser.cpp, line 1131
[task 2020-09-02T20:02:29.439Z] 20:02:29 INFO - PID 2805 | [2809, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-09-02T20:02:29.440Z] 20:02:29 INFO - PID 2805 | [2809, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-09-02T20:02:29.440Z] 20:02:29 INFO - PID 2805 | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /var/folders/ng/1t75hz8x645gs2cfs1nk8qk0000017/T/tmpAZgJ5E/runtests_leaks_2736_tab_pid2809.log
[task 2020-09-02T20:02:29.440Z] 20:02:29 INFO - PID 2805 | [2809, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-09-02T20:02:29.440Z] 20:02:29 INFO - PID 2805 | [2809, MainThread] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file /builds/worker/checkouts/gecko/xpcom/base/nsTraceRefcnt.cpp, line 202
[task 2020-09-02T20:02:29.441Z] 20:02:29 INFO - PID 2805 | [2809, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp, line 246
[task 2020-09-02T20:02:30.251Z] 20:02:30 INFO - PID 2805 | 1599076950229 Marionette INFO Listening on port 50610
[task 2020-09-02T20:02:30.836Z] 20:02:30 INFO - TEST-START | /html/canvas/element/compositing/2d.composite.canvas.copy.html
| Comment hidden (Intermittent Failures Robot) |
| Comment hidden (Intermittent Failures Robot) |
|
||
Comment 3•5 years ago
|
||
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.
Status: NEW → RESOLVED
Closed: 5 years ago
Resolution: --- → INCOMPLETE
You need to log in
before you can comment on or make changes to this bug.
Description
•