Closed Bug 1006234 Opened 11 years ago Closed 4 years ago

Intermittent test_hangui.xhtml,test_hangui.xul | Test timed out. | test_idle_hang.xul | plugin minidump exists | plugin extra file exists | NS_ERROR_FILE_NOT_FOUND: Component returned failure code at resource://gre/modules/KeyValueParser.jsm:37

Categories

(Core Graveyard :: Plug-ins, defect, P3)

Product:
Core Graveyard
Component:
Plug-ins
Platform:
x86_64
Windows 8.1
Type:
defect

Tracking

(firefox32 wontfix, firefox33 fixed, firefox34 affected, firefox35 affected, firefox-esr24 unaffected, firefox-esr31 fixed, b2g-v2.0 fixed, b2g-v2.1 fixed)

Status:
RESOLVED WONTFIX
Tracking Flags:
Tracking Status
firefox32 --- wontfix
firefox33 --- fixed
firefox34 --- affected
firefox35 --- affected
firefox-esr24 --- unaffected
firefox-esr31 --- fixed
b2g-v2.0 --- fixed
b2g-v2.1 --- fixed

People

(Reporter: KWierso, Unassigned)

References

Details

(Keywords: intermittent-failure)

Attachments

(1 file, 1 obsolete file)

Fix timeouts in test_hangui.xul
5.27 KB, patch
benjamin
: review+
Details | Diff | Splinter Review
https://tbpl.mozilla.org/php/getParsedLog.php?id=39078218&tree=Mozilla-Inbound WINNT 6.2 mozilla-inbound debug test mochitest-other on 2014-05-05 14:14:40 PDT for push 745c46904041 slave: t-w864-ix-037 14:28:59 INFO - 1885 INFO TEST-INFO | dumping last 1 message(s) 14:28:59 INFO - 1886 INFO TEST-INFO | if you need more context, please use SimpleTest.requestCompleteLog() in your test 14:28:59 INFO - 1887 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_hangui.xul | Prime ChromeWorker 14:28:59 INFO - TEST-INFO | screenshot: exit status 0 14:28:59 INFO - 1888 INFO TEST-UNEXPECTED-FAIL | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_hangui.xul | Test timed out. 14:29:00 INFO - 1889 INFO TEST-INFO | MEMORY STAT vsize after test: 857198592 14:29:00 INFO - 1890 INFO TEST-INFO | MEMORY STAT vsizeMaxContiguous after test: 1893662720 14:29:00 INFO - 1891 INFO TEST-INFO | MEMORY STAT residentFast after test: 74866688 14:29:00 INFO - 1892 INFO TEST-END | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_hangui.xul | finished in 301293ms 14:29:00 INFO - ++DOMWINDOW == 24 (1EF56CE0) [pid = 2380] [serial = 1802] [outer = 18C611C8] 14:29:00 INFO - 1893 INFO TEST-START | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul 14:29:00 INFO - ++DOMWINDOW == 25 (1EF5B150) [pid = 2380] [serial = 1803] [outer = 18C611C8] 14:29:00 INFO - [Parent 2380] WARNING: NS_ENSURE_TRUE(obj) failed: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/content/base/src/nsObjectLoadingContent.cpp, line 3448 14:29:00 INFO - [Parent 2380] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004001: file c:\builds\moz2_slave\m-in-w32-d-0000000000000000000\build\content\xul\document\src\nsXULPrototypeCache.cpp, line 333 14:29:00 INFO - --DOCSHELL 21BCE1F0 == 10 [pid = 2380] [id = 339] 14:29:00 INFO - For application/x-test found plugin nptest.dll 14:29:07 INFO - [Parent 2380] WARNING: Failed to send message!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/dom/plugins/ipc/PluginScriptableObjectParent.cpp, line 166 14:29:07 INFO - ###!!! [Parent][MessageChannel] Error: Channel timeout: cannot send/recv 14:29:07 INFO - ###!!! [Parent][MessageChannel::Call] Error: Channel timeout: cannot send/recv 14:29:07 INFO - [Parent 2380] WARNING: Failed to send message!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/dom/plugins/ipc/PluginScriptableObjectParent.cpp, line 260 14:29:07 INFO - ###!!! [Parent][MessageChannel::Call] Error: Channel timeout: cannot send/recv 14:29:07 INFO - [Parent 2380] WARNING: Failed to send message!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/dom/plugins/ipc/PluginScriptableObjectParent.cpp, line 118 14:29:07 INFO - ###!!! [Parent][MessageChannel::Call] Error: Channel timeout: cannot send/recv 14:29:07 INFO - [Parent 2380] WARNING: Failed to send message!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/dom/plugins/ipc/PluginScriptableObjectParent.cpp, line 260 14:29:07 INFO - ###!!! [Parent][MessageChannel::Call] Error: Channel timeout: cannot send/recv 14:29:07 INFO - [Parent 2380] WARNING: Failed to send message!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/dom/plugins/ipc/PluginScriptableObjectParent.cpp, line 118 14:29:07 INFO - ###!!! [Parent][MessageChannel::Call] Error: Channel timeout: cannot send/recv 14:29:07 INFO - [Parent 2380] WARNING: Failed to send message!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/dom/plugins/ipc/PluginScriptableObjectParent.cpp, line 260 14:29:07 INFO - ###!!! [Parent][MessageChannel::Call] Error: Channel timeout: cannot send/recv 14:29:07 INFO - [Parent 2380] WARNING: Failed to send message!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/dom/plugins/ipc/PluginScriptableObjectParent.cpp, line 118 14:29:07 INFO - ###!!! [Parent][MessageChannel::Call] Error: Channel timeout: cannot send/recv 14:29:07 INFO - [Parent 2380] WARNING: Failed to send message!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/dom/plugins/ipc/PluginScriptableObjectParent.cpp, line 260 14:29:07 INFO - ###!!! [Parent][MessageChannel::Call] Error: Channel timeout: cannot send/recv 14:29:07 INFO - [Parent 2380] WARNING: Failed to send message!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/dom/plugins/ipc/PluginScriptableObjectParent.cpp, line 118 14:29:07 INFO - ###!!! [Parent][MessageChannel::Call] Error: Channel timeout: cannot send/recv 14:29:07 INFO - [Parent 2380] WARNING: Failed to send message!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/dom/plugins/ipc/PluginScriptableObjectParent.cpp, line 260 14:29:07 INFO - ###!!! [Parent][MessageChannel::Call] Error: Channel timeout: cannot send/recv 14:29:07 INFO - [Parent 2380] WARNING: Failed to send message!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/dom/plugins/ipc/PluginScriptableObjectParent.cpp, line 118 14:29:07 INFO - ###!!! [Parent][MessageChannel::Call] Error: Channel timeout: cannot send/recv 14:29:07 INFO - [Parent 2380] WARNING: Failed to send message!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/dom/plugins/ipc/PluginScriptableObjectParent.cpp, line 260 14:29:07 INFO - ###!!! [Parent][MessageChannel::Call] Error: Channel timeout: cannot send/recv 14:29:07 INFO - [Parent 2380] WARNING: Failed to send message!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/dom/plugins/ipc/PluginScriptableObjectParent.cpp, line 118 14:29:07 INFO - ###!!! [Parent][MessageChannel::Call] Error: Channel timeout: cannot send/recv 14:29:07 INFO - [Parent 2380] WARNING: Failed to send message!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/dom/plugins/ipc/PluginScriptableObjectParent.cpp, line 260 14:29:07 INFO - ###!!! [Parent][MessageChannel::Call] Error: Channel timeout: cannot send/recv 14:29:07 INFO - [Parent 2380] WARNING: Failed to send message!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/dom/plugins/ipc/PluginScriptableObjectParent.cpp, line 118 14:29:07 INFO - ###!!! [Parent][MessageChannel::Call] Error: Channel timeout: cannot send/recv 14:29:07 INFO - [Parent 2380] WARNING: Failed to send message!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/dom/plugins/ipc/PluginScriptableObjectParent.cpp, line 260 14:29:07 INFO - ###!!! [Parent][MessageChannel::Call] Error: Channel timeout: cannot send/recv 14:29:07 INFO - [Parent 2380] WARNING: Failed to send message!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/dom/plugins/ipc/PluginScriptableObjectParent.cpp, line 118 14:29:07 INFO - ###!!! [Parent][MessageChannel::Call] Error: Channel timeout: cannot send/recv 14:29:07 INFO - [Parent 2380] WARNING: Failed to send message!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/dom/plugins/ipc/PluginScriptableObjectParent.cpp, line 260 14:29:07 INFO - ###!!! [Parent][MessageChannel::Call] Error: Channel timeout: cannot send/recv 14:29:07 INFO - [Parent 2380] WARNING: Failed to send message!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/dom/plugins/ipc/PluginScriptableObjectParent.cpp, line 118 14:29:07 INFO - ###!!! [Parent][MessageChannel::Call] Error: Channel timeout: cannot send/recv 14:29:07 INFO - [Parent 2380] WARNING: Failed to send message!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/dom/plugins/ipc/PluginScriptableObjectParent.cpp, line 260 14:29:07 INFO - ###!!! [Parent][MessageChannel::Call] Error: Channel timeout: cannot send/recv 14:29:07 INFO - [Parent 2380] WARNING: Failed to send message!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/dom/plugins/ipc/PluginScriptableObjectParent.cpp, line 118 14:29:07 INFO - ###!!! [Parent][MessageChannel::Call] Error: Channel timeout: cannot send/recv 14:29:07 INFO - [Parent 2380] WARNING: Failed to send message!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/dom/plugins/ipc/PluginScriptableObjectParent.cpp, line 260 14:29:07 INFO - ###!!! [Parent][MessageChannel::Call] Error: Channel timeout: cannot send/recv 14:29:07 INFO - [Parent 2380] WARNING: Failed to send message!: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/dom/plugins/ipc/PluginScriptableObjectParent.cpp, line 118 14:29:07 INFO - 1894 INFO TEST-INFO | dumping last 6 message(s) 14:29:07 INFO - 1895 INFO TEST-INFO | if you need more context, please use SimpleTest.requestCompleteLog() in your test 14:29:07 INFO - 1896 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | Observer fired 14:29:07 INFO - 1897 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | Checking correct topic 14:29:07 INFO - 1898 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | Checking null data 14:29:07 INFO - 1899 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | got Propbag 14:29:07 INFO - 1900 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | got writable Propbag 14:29:07 INFO - 1901 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | got a non-empty plugin crash id 14:29:07 INFO - 1902 INFO TEST-UNEXPECTED-FAIL | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | plugin minidump exists 14:29:07 INFO - 1903 INFO TEST-UNEXPECTED-FAIL | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | plugin extra file exists 14:29:07 INFO - 1904 INFO TEST-INFO | dumping last 15 message(s) 14:29:07 INFO - 1905 INFO TEST-INFO | if you need more context, please use SimpleTest.requestCompleteLog() in your test 14:29:07 INFO - 1906 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | Observer fired 14:29:07 INFO - 1907 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | Checking correct topic 14:29:07 INFO - 1908 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | Checking null data 14:29:07 INFO - 1909 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | got Propbag 14:29:07 INFO - 1910 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | got writable Propbag 14:29:07 INFO - 1911 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | got a non-empty plugin crash id 14:29:07 INFO - 1912 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | plugin minidump exists 14:29:07 INFO - 1913 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | plugin extra file exists 14:29:07 INFO - 1914 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | got field for additional minidumps 14:29:07 INFO - 1915 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | browser in additional_minidumps 14:29:07 INFO - 1916 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | additional dump 'browser' exists 14:29:07 INFO - 1917 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | got extra field for plugin cpu usage 14:29:07 INFO - 1918 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | plugin cpu usage is 0% 14:29:07 INFO - 1919 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | got extra field for processor count 14:29:07 INFO - 1920 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | number of processors is >0 14:29:07 INFO - 1921 INFO TEST-UNEXPECTED-FAIL | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | uncaught exception - NS_ERROR_FILE_NOT_FOUND: Component returned failure code: 0x80520012 (NS_ERROR_FILE_NOT_FOUND) [nsIFileInputStream.init] at resource://gre/modules/KeyValueParser.jsm:37 14:29:07 INFO - JavaScript error: resource://gre/modules/KeyValueParser.jsm, line 37: NS_ERROR_FILE_NOT_FOUND: Component returned failure code: 0x80520012 (NS_ERROR_FILE_NOT_FOUND) [nsIFileInputStream.init] 14:29:07 INFO - 1922 INFO TEST-INFO | MEMORY STAT vsize after test: 864780288 14:29:07 INFO - 1923 INFO TEST-INFO | MEMORY STAT vsizeMaxContiguous after test: 1893662720 14:29:07 INFO - 1924 INFO TEST-INFO | MEMORY STAT residentFast after test: 123432960 14:29:07 INFO - 1925 INFO TEST-INFO | dumping last 9 message(s) 14:29:07 INFO - 1926 INFO TEST-INFO | if you need more context, please use SimpleTest.requestCompleteLog() in your test 14:29:07 INFO - 1927 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | Plugin crashed notification received 14:29:07 INFO - 1928 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | Observer should have fired first 14:29:07 INFO - 1929 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | event is correct type 14:29:07 INFO - 1930 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | Plugin crashed event target is plugin element 14:29:07 INFO - 1931 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | plugin crashed event has the right interface 14:29:07 INFO - 1932 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | got a non-empty dump ID 14:29:07 INFO - 1933 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | got correct plugin name 14:29:07 INFO - 1934 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | got a non-empty filename 14:29:07 INFO - 1935 INFO TEST-PASS | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | event said crash report was submitted 14:29:07 INFO - 1936 INFO TEST-UNEXPECTED-FAIL | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | [SimpleTest.finish()] this test already called finish! 14:29:07 INFO - 1937 ERROR TEST-UNEXPECTED-FAIL | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | called finish() multiple times 14:29:07 INFO - 1938 INFO TEST-END | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_idle_hang.xul | finished in 6496ms 14:29:07 INFO - ++DOMWINDOW == 26 (1EF5E810) [pid = 2380] [serial = 1804] [outer = 18C611C8] 14:29:07 INFO - 1939 INFO TEST-START | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_npruntime.xul 14:29:07 INFO - ++DOMWINDOW == 27 (1EF62360) [pid = 2380] [serial = 1805] [outer = 18C611C8] 14:29:07 INFO - [Parent 2380] WARNING: NS_ENSURE_TRUE(obj) failed: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/content/base/src/nsObjectLoadingContent.cpp, line 3448 14:29:07 INFO - For application/x-test found plugin nptest.dll 14:29:07 INFO - [3412] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file c:\builds\moz2_slave\m-in-w32-d-0000000000000000000\build\xpcom\base\nsTraceRefcnt.cpp, line 143 14:29:07 INFO - [3412] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file c:\builds\moz2_slave\m-in-w32-d-0000000000000000000\build\xpcom\base\nsTraceRefcnt.cpp, line 143 14:29:07 INFO - [3412] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file c:\builds\moz2_slave\m-in-w32-d-0000000000000000000\build\xpcom\base\nsTraceRefcnt.cpp, line 143 14:29:07 INFO - [3412] WARNING: XPCOM objects created/destroyed from static ctor/dtor: file c:\builds\moz2_slave\m-in-w32-d-0000000000000000000\build\xpcom\base\nsTraceRefcnt.cpp, line 143 14:29:07 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to c:\users\cltbld~1.t-w\appdata\local\temp\tmpnggm9_\runtests_leaks.log 14:29:07 INFO - 1940 INFO TEST-INFO | MEMORY STAT vsize after test: 864780288 14:29:07 INFO - 1941 INFO TEST-INFO | MEMORY STAT vsizeMaxContiguous after test: 1893662720 14:29:07 INFO - 1942 INFO TEST-INFO | MEMORY STAT residentFast after test: 143581184 14:29:07 INFO - 1943 INFO TEST-END | chrome://mochitests/content/chrome/dom/plugins/test/mochitest/test_npruntime.xul | finished in 340ms 14:48:59 INFO - [Parent 2380] WARNING: NS_ENSURE_TRUE(mDB) failed: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/netwerk/cache/nsDiskCacheDeviceSQL.cpp, line 1397 14:48:59 INFO - [1100] WARNING: pipe error: 109: file c:/builds/moz2_slave/m-in-w32-d-0000000000000000000/build/ipc/chromium/src/chrome/common/ipc_channel_win.cc, line 310 14:48:59 INFO - NPP_Destroy 14:48:59 INFO - NPP_Destroy 14:48:59 INFO - NPP_Destroy 14:48:59 INFO - NPP_Destroy 14:48:59 INFO - nsStringStats 14:48:59 INFO - => mAllocCount: 121 14:48:59 INFO - => mReallocCount: 1 14:48:59 INFO - => mFreeCount: 121 14:48:59 INFO - => mShareCount: 163 14:48:59 INFO - => mAdoptCount: 0 14:48:59 INFO - => mAdoptFreeCount: 0 14:48:59 INFO - => Process ID: 1100, Thread ID: 2660 14:54:29 WARNING - TEST-UNEXPECTED-FAIL | Shutdown | application timed out after 330 seconds with no output 14:54:29 INFO - Not taking screenshot here: see the one that was previously logged 14:54:29 INFO - TEST-INFO | crashinject: exit status 0 14:54:30 INFO - Single process terminated successfully 14:54:30 INFO - TEST-INFO | Main app process: exit status c0000005 14:54:30 WARNING - TEST-UNEXPECTED-FAIL | Shutdown | application terminated with exit code 3221225477 14:54:30 INFO - INFO | runtests.py | Application ran for: 0:36:52.544000 14:54:30 INFO - INFO | zombiecheck | Reading PID log: c:\users\cltbld~1.t-w\appdata\local\temp\tmpgep9jnpidlog 14:54:30 INFO - ==> process 2380 launched child process 2572 ("C:\slave\test\build\application\firefox\plugin-container.exe" --channel=2380.19065598.1526832782 -greomni "C:\slave\test\build\application\firefox\omni.ja" -appomni "C:\slave\test\build\application\firefox\browser\omni.ja" -appdir "C:\slave\test\build\application\firefox\browser" - 2380 "\\.\pipe\gecko-crash-server-pipe.2380" tab) 14:54:30 INFO - ==> process 2380 launched child process 3692 ("C:\slave\test\build\application\firefox\plugin-container.exe" --channel=2380.8bad908.1948721724 -greomni "C:\slave\test\build\application\firefox\omni.ja" -appomni "C:\slave\test\build\application\firefox\browser\omni.ja" -appdir "C:\slave\test\build\application\firefox\browser" - 2380 "\\.\pipe\gecko-crash-server-pipe.2380" tab) 14:54:30 INFO - ==> process 2380 launched child process 680 ("C:\slave\test\build\application\firefox\plugin-container.exe" --channel=2380.191032e0.830966372 "c:\users\cltbld~1.t-w\appdata\local\temp\tmpnggm9_\plugins\nptest.dll" -greomni "C:\slave\test\build\application\firefox\omni.ja" -appomni "C:\slave\test\build\application\firefox\browser\omni.ja" -appdir "C:\slave\test\build\application\firefox\browser" - 2380 "\\.\pipe\gecko-crash-server-pipe.2380" plugin) 14:54:30 INFO - ==> process 2380 launched child process 3824 ("C:\slave\test\build\application\firefox\plugin-container.exe" --channel=2380.19103da0.909766673 "c:\users\cltbld~1.t-w\appdata\local\temp\tmpnggm9_\plugins\nptest.dll" -greomni "C:\slave\test\build\application\firefox\omni.ja" -appomni "C:\slave\test\build\application\firefox\browser\omni.ja" -appdir "C:\slave\test\build\application\firefox\browser" - 2380 "\\.\pipe\gecko-crash-server-pipe.2380" plugin) 14:54:30 INFO - ==> process 2380 launched child process 1792 ("C:\slave\test\build\application\firefox\plugin-container.exe" --channel=2380.19103438.519832611 "c:\users\cltbld~1.t-w\appdata\local\temp\tmpnggm9_\plugins\nptest.dll" -greomni "C:\slave\test\build\application\firefox\omni.ja" -appomni "C:\slave\test\build\application\firefox\browser\omni.ja" -appdir "C:\slave\test\build\application\firefox\browser" - 2380 "\\.\pipe\gecko-crash-server-pipe.2380" plugin) 14:54:30 INFO - ==> process 2380 launched child process 2128 ("C:\slave\test\build\application\firefox\plugin-container.exe" --channel=2380.19105320.1376018101 "c:\users\cltbld~1.t-w\appdata\local\temp\tmpnggm9_\plugins\nptest.dll" -greomni "C:\slave\test\build\application\firefox\omni.ja" -appomni "C:\slave\test\build\application\firefox\browser\omni.ja" -appdir "C:\slave\test\build\application\firefox\browser" - 2380 "\\.\pipe\gecko-crash-server-pipe.2380" plugin) 14:54:30 INFO - ==> process 2380 launched child process 3988 ("C:\slave\test\build\application\firefox\plugin-container.exe" --channel=2380.1910b940.94591179 "c:\users\cltbld~1.t-w\appdata\local\temp\tmpnggm9_\plugins\nptest.dll" -greomni "C:\slave\test\build\application\firefox\omni.ja" -appomni "C:\slave\test\build\application\firefox\browser\omni.ja" -appdir "C:\slave\test\build\application\firefox\browser" - 2380 "\\.\pipe\gecko-crash-server-pipe.2380" plugin) 14:54:30 INFO - ==> process 2380 launched child process 708 ("C:\slave\test\build\application\firefox\plugin-container.exe" --channel=2380.19104b10.523786357 "c:\users\cltbld~1.t-w\appdata\local\temp\tmpnggm9_\plugins\nptest.dll" -greomni "C:\slave\test\build\application\firefox\omni.ja" -appomni "C:\slave\test\build\application\firefox\browser\omni.ja" -appdir "C:\slave\test\build\application\firefox\browser" - 2380 "\\.\pipe\gecko-crash-server-pipe.2380" plugin) 14:54:30 INFO - ==> process 2380 launched child process 3412 ("C:\slave\test\build\application\firefox\plugin-container.exe" --channel=2380.19103ef8.982389106 "c:\users\cltbld~1.t-w\appdata\local\temp\tmpnggm9_\plugins\nptest.dll" -greomni "C:\slave\test\build\application\firefox\omni.ja" -appomni "C:\slave\test\build\application\firefox\browser\omni.ja" -appdir "C:\slave\test\build\application\firefox\browser" - 2380 "\\.\pipe\gecko-crash-server-pipe.2380" plugin) 14:54:30 INFO - ==> process 2380 launched child process 2660 ("C:\slave\test\build\application\firefox\plugin-container.exe" --channel=2380.30083620.716426169 "c:\users\cltbld~1.t-w\appdata\local\temp\tmpnggm9_\plugins\nptest.dll" -greomni "C:\slave\test\build\application\firefox\omni.ja" -appomni "C:\slave\test\build\application\firefox\browser\omni.ja" -appdir "C:\slave\test\build\application\firefox\browser" - 2380 "\\.\pipe\gecko-crash-server-pipe.2380" plugin) 14:54:30 INFO - ==> process 2380 launched child process 1756 ("C:\slave\test\build\application\firefox\plugin-container.exe" --channel=2380.2fe99478.381685022 "c:\users\cltbld~1.t-w\appdata\local\temp\tmpnggm9_\plugins\nptest.dll" -greomni "C:\slave\test\build\application\firefox\omni.ja" -appomni "C:\slave\test\build\application\firefox\browser\omni.ja" -appdir "C:\slave\test\build\application\firefox\browser" - 2380 "\\.\pipe\gecko-crash-server-pipe.2380" plugin) 14:54:30 INFO - ==> process 2380 launched child process 4028 ("C:\slave\test\build\application\firefox\plugin-container.exe" --channel=2380.3027f940.1415269030 -greomni "C:\slave\test\build\application\firefox\omni.ja" -appomni "C:\slave\test\build\application\firefox\browser\omni.ja" -appdir "C:\slave\test\build\application\firefox\browser" - 2380 "\\.\pipe\gecko-crash-server-pipe.2380" tab) 14:54:30 INFO - ==> process 2380 launched child process 3284 ("C:\slave\test\build\application\firefox\plugin-container.exe" --channel=2380.30283b10.1695436471 -greomni "C:\slave\test\build\application\firefox\omni.ja" -appomni "C:\slave\test\build\application\firefox\browser\omni.ja" -appdir "C:\slave\test\build\application\firefox\browser" - 2380 "\\.\pipe\gecko-crash-server-pipe.2380" tab) 14:54:30 INFO - ==> process 2380 launched child process 212 ("C:\slave\test\build\application\firefox\plugin-container.exe" --channel=2380.30288b80.1001715479 -greomni "C:\slave\test\build\application\firefox\omni.ja" -appomni "C:\slave\test\build\application\firefox\browser\omni.ja" -appdir "C:\slave\test\build\application\firefox\browser" - 2380 "\\.\pipe\gecko-crash-server-pipe.2380" tab) 14:54:30 INFO - ==> process 2380 launched child process 1632 ("C:\slave\test\build\application\firefox\plugin-container.exe" --channel=2380.30635e98.1897773373 -greomni "C:\slave\test\build\application\firefox\omni.ja" -appomni "C:\slave\test\build\application\firefox\browser\omni.ja" -appdir "C:\slave\test\build\application\firefox\browser" - 2380 "\\.\pipe\gecko-crash-server-pipe.2380" tab) 14:54:30 INFO - ==> process 2380 launched child process 4068 ("C:\slave\test\build\application\firefox\plugin-container.exe" --channel=2380.3063b040.723755463 -greomni "C:\slave\test\build\application\firefox\omni.ja" -appomni "C:\slave\test\build\application\firefox\browser\omni.ja" -appdir "C:\slave\test\build\application\firefox\browser" - 2380 "\\.\pipe\gecko-crash-server-pipe.2380" tab) 14:54:30 INFO - ==> process 2380 launched child process 3096 ("C:\slave\test\build\application\firefox\plugin-container.exe" --channel=2380.3063d9b0.1195135529 -greomni "C:\slave\test\build\application\firefox\omni.ja" -appomni "C:\slave\test\build\application\firefox\browser\omni.ja" -appdir "C:\slave\test\build\application\firefox\browser" - 2380 "\\.\pipe\gecko-crash-server-pipe.2380" tab) 14:54:30 INFO - ==> process 2380 launched child process 1100 ("C:\slave\test\build\application\firefox\plugin-container.exe" --channel=2380.21ef6d80.747399907 "c:\users\cltbld~1.t-w\appdata\local\temp\tmpnggm9_\plugins\nptest.dll" -greomni "C:\slave\test\build\application\firefox\omni.ja" -appomni "C:\slave\test\build\application\firefox\browser\omni.ja" -appdir "C:\slave\test\build\application\firefox\browser" - 2380 "\\.\pipe\gecko-crash-server-pipe.2380" plugin) 14:54:37 WARNING - PROCESS-CRASH | Shutdown | application crashed [@ CrashingThread(void *)] 14:54:37 INFO - Crash dump filename: c:\users\cltbld~1.t-w\appdata\local\temp\tmpnggm9_\minidumps\decfefc2-f7c7-41f0-83b7-07e9b967d574.dmp 14:54:37 INFO - Operating system: Windows NT 14:54:37 INFO - 6.2.9200 14:54:37 INFO - CPU: x86 14:54:37 INFO - GenuineIntel family 6 model 30 stepping 5 14:54:37 INFO - 8 CPUs 14:54:37 INFO - Crash reason: EXCEPTION_ACCESS_VIOLATION_WRITE 14:54:37 INFO - Crash address: 0x0 14:54:37 INFO - Thread 39 (crashed) 14:54:37 INFO - 0 crashinjectdll.dll!CrashingThread(void *) [crashinjectdll.cpp:745c46904041 : 17 + 0x0] 14:54:37 INFO - eip = 0x6adb1000 esp = 0x0af0f8f8 ebp = 0x0af0f900 ebx = 0x00000000 14:54:37 INFO - esi = 0x00000000 edi = 0x00000000 eax = 0x75c28535 ecx = 0x00000000 14:54:37 INFO - edx = 0x6adb1000 efl = 0x00010246 14:54:37 INFO - Found by: given as instruction pointer in context 14:54:37 INFO - 1 kernel32.dll + 0x28542 14:54:37 INFO - eip = 0x75c28543 esp = 0x0af0f8fc ebp = 0x0af0f900 14:54:37 INFO - Found by: call frame info 14:54:37 INFO - 2 ntdll.dll + 0x5ac68 14:54:37 INFO - eip = 0x77b3ac69 esp = 0x0af0f908 ebp = 0x0af0f944 14:54:37 INFO - Found by: previous frame's frame pointer 14:54:37 INFO - 3 ntdll.dll + 0x5ac3b 14:54:37 INFO - eip = 0x77b3ac3c esp = 0x0af0f94c ebp = 0x0af0f95c 14:54:37 INFO - Found by: previous frame's frame pointer
Can we please get a plugin expert to take a look at this? It's happening with pretty high frequency.
Flags: needinfo?(georg.fritzsche)
I wrote it, I'll take it.
Assignee: nobody → aklotz
Flags: needinfo?(georg.fritzsche)
Attached patch Fix timeouts in test_hangui.xml (obsolete) — — Splinter Review
This should take care of it. When running it locally I noticed that the test's hook is seeing show events from windows that we're not interested in. As long as these events are occurring, we end up looping infinitely while waiting to see the window that we're interested in. Unfortunately if we're testing to ensure that a window _isn't_ shown, we never break. The main improvement in this patch is to take timestamps before and after waiting for show events and making sure that we break if we exceed the timeout value. As a bonus, this test now completes 12s sooner.
Attachment #8480042 - Flags: review?(benjamin)
Attached patch Fix timeouts in test_hangui.xul — — Splinter Review
Please see comment 223.
Attachment #8480042 - Attachment is obsolete: true
Attachment #8480042 - Flags: review?(benjamin)
Attachment #8480060 - Flags: review?(benjamin)
Attachment #8480060 - Flags: review?(benjamin) → review+
try: https://tbpl.mozilla.org/?tree=Try&rev=531b5505e0fb (bug# on push is wrong but it's the right patch)
Keywords: checkin-needed
(Also the incorrect bug# was corrected in the patch before attaching)
https://hg.mozilla.org/mozilla-central/rev/3609f0637243
Status: NEW → RESOLVED
Closed: 11 years ago
Resolution: --- → FIXED
Target Milestone: --- → mozilla34
(In reply to TBPL Robot from comment #230) :(
Status: RESOLVED → REOPENED
status-firefox34: fixed → affected
status-firefox35: --- → affected
Resolution: FIXED → ---
Target Milestone: mozilla34 → ---
In many of these logs there is a lot of extra output from Firefox between the start of test_hangui and the "Prime ChromeWorker" TEST-PASS line. At this point I suspect that a previous test in the suite has left behind some unfinished business that messes with test_hangui.
Depends on: 1262336
Assignee: aklotz → nobody
Bulk assigning P3 to all open intermittent bugs without a priority set in Firefox components per bug 1298978.
Priority: -- → P3

Bugbug thinks this bug is a regression, but please revert this change in case of error.

Keywords: regression
Summary: Intermittent test_hangui.xul | Test timed out. | test_idle_hang.xul | plugin minidump exists | plugin extra file exists | NS_ERROR_FILE_NOT_FOUND: Component returned failure code: 0x80520012 at resource://gre/modules/KeyValueParser.jsm:37 → Intermittent test_hangui.xhtml,test_hangui.xul | Test timed out. | test_idle_hang.xul | plugin minidump exists | plugin extra file exists | NS_ERROR_FILE_NOT_FOUND: Component returned failure code at resource://gre/modules/KeyValueParser.jsm:37
Resolving as wont fix, plugin support deprecated in Firefox 85.
Status: REOPENED → RESOLVED
Closed: 11 years ago → 4 years ago
Resolution: --- → WONTFIX
Product: Core → Core Graveyard
You need to log in before you can comment on or make changes to this bug.

Attachment

General

Creator:
Created:
Updated:
Size: