Closed Bug 1071356 Opened 10 years ago Closed 9 years ago

Intermittent browser_dbg_pause-exceptions-02.js | Test timed out - expected PASS | Found a tab after previous test timed out: http://example.com/browser/browser/devtools/debugger/test/doc_pause-exceptions.html - expected PASS (and more)

Categories

(DevTools :: Debugger, defect)

Product:
DevTools
Component:
Debugger
Platform:
x86_64
Windows 8.1
Type:
defect
Priority:
Not set
Severity:
normal

Tracking

(Not tracked)

Status:
RESOLVED WORKSFORME

People

(Reporter: KWierso, Unassigned)

References

(Blocks 1 open bug)

Details

(Keywords: intermittent-failure) 

https://tbpl.mozilla.org/php/getParsedLog.php?id=48614670&tree=Mozilla-Central
WINNT 6.2 mozilla-central debug test mochitest-devtools-chrome-1 on 2014-09-22 13:41:06 PDT for push d8688cafc752

slave: t-w864-ix-115



13:54:15     INFO -  394 INFO TEST-PASS | chrome://mochitests/content/browser/browser/devtools/debugger/test/browser_dbg_pause-exceptions-02.js | Enough 'cursorActivity' editor events have been fired.
13:54:15     INFO -  395 INFO Caret updated: 1, 1
13:54:15     INFO -  396 INFO Current editor caret position: 1, 1
13:54:15     INFO -  397 INFO Waiting for editor event: 'cursorActivity' to fire: 1 time(s).
13:54:15     INFO -  398 INFO Editor event 'cursorActivity' fired: 1 time(s).
13:54:15     INFO -  399 INFO TEST-PASS | chrome://mochitests/content/browser/browser/devtools/debugger/test/browser_dbg_pause-exceptions-02.js | Enough 'cursorActivity' editor events have been fired.
13:54:15     INFO -  400 INFO Caret updated: 1, 1
13:54:15     INFO -  401 INFO Current editor caret position: 1, 1
13:54:15     INFO -  402 INFO Waiting for editor event: 'cursorActivity' to fire: 1 time(s).
13:54:15     INFO -  403 INFO TEST-UNEXPECTED-FAIL | chrome://mochitests/content/browser/browser/devtools/debugger/test/browser_dbg_pause-exceptions-02.js | Test timed out - expected PASS
13:54:15     INFO -  --DOCSHELL 17324C00 == 11 [pid = 3352] [id = 776]
13:54:15     INFO -  --DOCSHELL 16921800 == 10 [pid = 3352] [id = 775]
13:54:15     INFO -  --DOCSHELL 09F8BC00 == 9 [pid = 3352] [id = 774]
13:54:15     INFO -  404 INFO TEST-OK | chrome://mochitests/content/browser/browser/devtools/debugger/test/browser_dbg_pause-exceptions-02.js | took 46008ms
13:54:15     INFO -  405 INFO TEST-UNEXPECTED-FAIL | chrome://mochitests/content/browser/browser/devtools/debugger/test/browser_dbg_pause-exceptions-02.js | Found a tab after previous test timed out: http://example.com/browser/browser/devtools/debugger/test/doc_pause-exceptions.html - expected PASS
13:54:15     INFO -  [3352] WARNING: NS_ENSURE_TRUE(mMutable) failed: file c:\builds\moz2_slave\m-cen-w32-d-000000000000000000\build\netwerk\base\src\nsSimpleURI.cpp, line 265
13:54:15     INFO -  ++DOCSHELL 0A68D800 == 10 [pid = 3352] [id = 777]
13:54:15     INFO -  ++DOMWINDOW == 26 (0A5BA600) [pid = 3352] [serial = 1845] [outer = 00000000]
13:54:15     INFO -  ++DOMWINDOW == 27 (0A5BF600) [pid = 3352] [serial = 1846] [outer = 0A5BA600]
13:54:15     INFO -  [3352] WARNING: NS_ENSURE_TRUE(mMutable) failed: file c:\builds\moz2_slave\m-cen-w32-d-000000000000000000\build\netwerk\base\src\nsSimpleURI.cpp, line 265
13:54:15     INFO -  406 INFO TEST-START | chrome://mochitests/content/browser/browser/devtools/debugger/test/browser_dbg_pause-resume.js
13:54:15     INFO -  ++DOCSHELL 0A681800 == 11 [pid = 3352] [id = 778]
13:54:15     INFO -  ++DOMWINDOW == 28 (0D888C00) [pid = 3352] [serial = 1847] [outer = 00000000]
13:54:15     INFO -  ++DOMWINDOW == 29 (0D88EE00) [pid = 3352] [serial = 1848] [outer = 0D888C00]


...


13:59:15     INFO -  584 INFO TEST-PASS | chrome://mochitests/content/browser/browser/devtools/debugger/test/browser_dbg_server-conditional-bp-01.js | The breakpoint on line 29 wasn't found.
13:59:15     INFO -  585 INFO TEST-PASS | chrome://mochitests/content/browser/browser/devtools/debugger/test/browser_dbg_server-conditional-bp-01.js | The breakpoint on line 29 should be enabled.
13:59:15     INFO -  586 INFO TEST-PASS | chrome://mochitests/content/browser/browser/devtools/debugger/test/browser_dbg_server-conditional-bp-01.js | The breakpoint on line 29 should not have opened a popup.
13:59:15     INFO -  587 INFO TEST-PASS | chrome://mochitests/content/browser/browser/devtools/debugger/test/browser_dbg_server-conditional-bp-01.js | The breakpoint conditional expression popup should not have been shown.
13:59:15     INFO -  588 INFO TEST-PASS | chrome://mochitests/content/browser/browser/devtools/debugger/test/browser_dbg_server-conditional-bp-01.js | The breakpoint's client url is correct
13:59:15     INFO -  589 INFO TEST-PASS | chrome://mochitests/content/browser/browser/devtools/debugger/test/browser_dbg_server-conditional-bp-01.js | The breakpoint's client line is correct
13:59:15     INFO -  590 INFO TEST-PASS | chrome://mochitests/content/browser/browser/devtools/debugger/test/browser_dbg_server-conditional-bp-01.js | The breakpoint on line 29 should have a conditional expression.
13:59:15     INFO -  591 INFO Current editor caret position: 29, 1
13:59:15     INFO -  592 INFO TEST-PASS | chrome://mochitests/content/browser/browser/devtools/debugger/test/browser_dbg_server-conditional-bp-01.js | The editor caret position is not properly set.
13:59:15     INFO -  593 INFO Waiting for debugger event: 'Debugger:AfterFramesCleared' to fire: 1 time(s).
13:59:15     INFO -  594 INFO Longer timeout required, waiting longer...  Remaining timeouts: 1
13:59:15     INFO -  595 INFO TEST-UNEXPECTED-FAIL | chrome://mochitests/content/browser/browser/devtools/debugger/test/browser_dbg_server-conditional-bp-01.js | Test timed out - expected PASS
13:59:15     INFO -  --DOCSHELL 176A3800 == 11 [pid = 3352] [id = 1013]
13:59:15     INFO -  --DOCSHELL 16F11C00 == 10 [pid = 3352] [id = 1012]
13:59:16     INFO -  --DOCSHELL 14FE9C00 == 9 [pid = 3352] [id = 1011]
13:59:16     INFO -  596 INFO TEST-OK | chrome://mochitests/content/browser/browser/devtools/debugger/test/browser_dbg_server-conditional-bp-01.js | took 91173ms
13:59:16     INFO -  597 INFO TEST-UNEXPECTED-FAIL | chrome://mochitests/content/browser/browser/devtools/debugger/test/browser_dbg_server-conditional-bp-01.js | Found a tab after previous test timed out: http://example.com/browser/browser/devtools/debugger/test/doc_conditional-breakpoints.html - expected PASS
13:59:16     INFO -  [3352] WARNING: NS_ENSURE_TRUE(mMutable) failed: file c:\builds\moz2_slave\m-cen-w32-d-000000000000000000\build\netwerk\base\src\nsSimpleURI.cpp, line 265
13:59:16     INFO -  ++DOCSHELL 0D02A000 == 10 [pid = 3352] [id = 1014]
13:59:16     INFO -  ++DOMWINDOW == 29 (0A90BC00) [pid = 3352] [serial = 2418] [outer = 00000000]
13:59:17     INFO -  ++DOMWINDOW == 30 (0D09D800) [pid = 3352] [serial = 2419] [outer = 0A90BC00]
13:59:17     INFO -  [3352] WARNING: NS_ENSURE_TRUE(mMutable) failed: file c:\builds\moz2_slave\m-cen-w32-d-000000000000000000\build\netwerk\base\src\nsSimpleURI.cpp, line 265
13:59:17     INFO -  598 INFO TEST-START | chrome://mochitests/content/browser/browser/devtools/debugger/test/browser_dbg_server-conditional-bp-02.js


...


13:59:48     INFO -  makeInfallible/<@resource://gre/modules/commonjs/toolkit/loader.js -> resource://gre/modules/devtools/DevToolsUtils.js:83:14
13:59:48     INFO -  " {file: "resource://gre/modules/commonjs/toolkit/loader.js -> resource://gre/modules/devtools/server/actors/script.js" line: 5408}]
13:59:48     INFO -  624 INFO Console message: [JavaScript Warning: "ReferenceError: reference to undefined property this._editorSource.url" {file: "chrome://browser/content/devtools/debugger-view.js" line: 393}]
13:59:48     INFO -  625 INFO Console message: [JavaScript Warning: "ReferenceError: reference to undefined property built.bgClass" {file: "chrome://browser/content/devtools/codemirror/codemirror.js" line: 834}]
13:59:48     INFO -  626 INFO Console message: [JavaScript Warning: "ReferenceError: reference to undefined property aItem.attachment.url" {file: "chrome://browser/content/devtools/debugger-panes.js" line: 256}]
13:59:48     INFO -  627 INFO Debugger client resumed successfully.
13:59:48     INFO -  628 INFO TEST-UNEXPECTED-FAIL | chrome://mochitests/content/browser/browser/devtools/debugger/test/browser_dbg_source-maps-04.js | The pause-on-exceptions pref should be disabled by default. - Got true, expected false
13:59:48     INFO -  Stack trace:
13:59:48     INFO -  chrome://mochikit/content/browser-test.js:test_is:793
13:59:48     INFO -  chrome://mochitests/content/browser/browser/devtools/debugger/test/browser_dbg_source-maps-04.js:test/<:27
13:59:48     INFO -  resource://gre/modules/devtools/deprecated-sync-thenables.js:resolve:40
13:59:48     INFO -  resource://gre/modules/devtools/deprecated-sync-thenables.js:resolve:40
13:59:48     INFO -  resource://gre/modules/devtools/deprecated-sync-thenables.js:then:20
13:59:48     INFO -  resource://gre/modules/devtools/deprecated-sync-thenables.js:resolve:72
13:59:48     INFO -  chrome://mochitests/content/browser/browser/devtools/debugger/test/head.js:initDebugger/</</<:521
13:59:48     INFO -  resource://gre/modules/devtools/dbg-client.jsm:eventSource/aProto.addOneTimeListener/l:132
13:59:48     INFO -  resource://gre/modules/devtools/dbg-client.jsm:eventSource/aProto.emit:189
13:59:48     INFO -  resource://gre/modules/devtools/dbg-client.jsm:DebuggerClient.prototype.onPacket/<:927
13:59:48     INFO -  resource://gre/modules/devtools/deprecated-sync-thenables.js:resolve:40
13:59:48     INFO -  resource://gre/modules/devtools/deprecated-sync-thenables.js:then:20
13:59:48     INFO -  resource://gre/modules/devtools/deprecated-sync-thenables.js:then:58
13:59:48     INFO -  resource://gre/modules/devtools/dbg-client.jsm:DebuggerClient.prototype.onPacket:869
13:59:48     INFO -  resource://gre/modules/devtools/dbg-client.jsm -> resource://gre/modules/devtools/transport/transport.js:LocalDebuggerTransport.prototype.send/<:545
13:59:48     INFO -  resource://gre/modules/commonjs/toolkit/loader.js -> resource://gre/modules/devtools/DevToolsUtils.js:makeInfallible/<:83
13:59:48     INFO -  resource://gre/modules/commonjs/toolkit/loader.js -> resource://gre/modules/devtools/DevToolsUtils.js:makeInfallible/<:83
13:59:48     INFO -  null:null:0
13:59:48     INFO -  629 INFO TEST-UNEXPECTED-FAIL | chrome://mochitests/content/browser/browser/devtools/debugger/test/browser_dbg_source-maps-04.js | The pause-on-exceptions menu item should not be checked. - Didn't expect true, but got it
13:59:48     INFO -  Stack trace:
13:59:48     INFO -  chrome://mochikit/content/browser-test.js:test_isnot:797
13:59:48     INFO -  chrome://mochitests/content/browser/browser/devtools/debugger/test/browser_dbg_source-maps-04.js:test/<:29
13:59:48     INFO -  resource://gre/modules/devtools/deprecated-sync-thenables.js:resolve:40
13:59:48     INFO -  resource://gre/modules/devtools/deprecated-sync-thenables.js:resolve:40
13:59:48     INFO -  resource://gre/modules/devtools/deprecated-sync-thenables.js:then:20
13:59:48     INFO -  resource://gre/modules/devtools/deprecated-sync-thenables.js:resolve:72
13:59:48     INFO -  chrome://mochitests/content/browser/browser/devtools/debugger/test/head.js:initDebugger/</</<:521


...


14:16:41     INFO -  --DOMWINDOW == 35 (0D8D2C00) [pid = 3352] [serial = 5605] [outer = 00000000] [url = about:blank]
14:16:41     INFO -  --DOMWINDOW == 34 (123BAE00) [pid = 3352] [serial = 5632] [outer = 00000000] [url = data:text/html;charset=UTF-8,<div%20id='two'%20style='color:green;'>TWO</div>]
14:16:41     INFO -  --DOMWINDOW == 33 (0E17B400) [pid = 3352] [serial = 44] [outer = 00000000] [url = about:newtab]
14:16:41     INFO -  --DOMWINDOW == 32 (17330000) [pid = 3352] [serial = 41] [outer = 00000000] [url = data:application/vnd.mozilla.xul+xml;charset=utf-8,<window%20id='win'/>]
14:16:41     INFO -  --DOMWINDOW == 31 (1EA56400) [pid = 3352] [serial = 5629] [outer = 00000000] [url = data:text/html,<html></html>]
14:16:41     INFO -  --DOMWINDOW == 30 (1C263000) [pid = 3352] [serial = 5612] [outer = 00000000] [url = about:blank]
14:16:41     INFO -  --DOMWINDOW == 29 (1CD24800) [pid = 3352] [serial = 5617] [outer = 00000000] [url = chrome://browser/content/devtools/cssruleview.xhtml]
14:16:41     INFO -  --DOMWINDOW == 28 (1C023800) [pid = 3352] [serial = 5634] [outer = 00000000] [url = about:blank]
14:16:43     INFO -  --DOMWINDOW == 27 (1BFDC000) [pid = 3352] [serial = 5609] [outer = 00000000] [url = chrome://browser/content/devtools/inspector/inspector.xul]
14:16:43     INFO -  --DOMWINDOW == 26 (16F15800) [pid = 3352] [serial = 5606] [outer = 00000000] [url = chrome://browser/content/devtools/framework/toolbox.xul]
14:16:43     INFO -  --DOMWINDOW == 25 (1C277C00) [pid = 3352] [serial = 5614] [outer = 00000000] [url = chrome://browser/content/devtools/computedview.xhtml]
14:16:52     INFO -  --DOMWINDOW == 24 (1C01B400) [pid = 3352] [serial = 5610] [outer = 00000000] [url = about:blank]
14:16:52     INFO -  --DOMWINDOW == 23 (1AF7F400) [pid = 3352] [serial = 5608] [outer = 00000000] [url = chrome://browser/content/devtools/framework/toolbox.xul]
14:16:52     INFO -  --DOMWINDOW == 22 (1CD29C00) [pid = 3352] [serial = 5618] [outer = 00000000] [url = chrome://browser/content/devtools/computedview.xhtml]
14:17:11     INFO -  FATAL ERROR: AsyncShutdown timeout in ShutdownLeaks: Wait for cleanup to be finished before checking for leaks Conditions: [{"name":"DevTools: Wait until toolbox is destroyed","state":"(none)","filename":"resource://gre/modules/commonjs/toolkit/loader.js -> resource:///modules/devtools/framework/toolbox.js","lineNumber":1591,"stack":["resource://gre/modules/commonjs/toolkit/loader.js -> resource:///modules/devtools/framework/toolbox.js:Toolbox.prototype.destroy/leakCheckObserver:1591","chrome://mochikit/content/browser-test.js:Tester.prototype.nextTest</<:527","null:null:0"]},{"name":"DevTools: Wait until toolbox is destroyed","state":"(none)","filename":"resource://gre/modules/commonjs/toolkit/loader.js -> resource:///modules/devtools/framework/toolbox.js","lineNumber":1591,"stack":["resource://gre/modules/commonjs/toolkit/loader.js -> resource:///modules/devtools/framework/toolbox.js:Toolbox.prototype.destroy/leakCheckObserver:1591","chrome://mochikit/content/browser-test.js:Tester.prototype.nextTest</<:527","null:null:0"]}] At least one completion condition failed to complete within a reasonable amount of time. Causing a crash to ensure that we do not leave the user with an unresponsive process draining resources.
14:17:11     INFO -  [3352] ###!!! ABORT: file resource://gre/modules/commonjs/toolkit/loader.js -> resource:///modules/devtools/framework/toolbox.js, line 1591
14:17:13     INFO -  TEST-INFO | Main app process: exit status 80000003
14:17:13  WARNING -  TEST-UNEXPECTED-FAIL | ShutdownLeaks | process() called before end of test suite
14:17:13     INFO -  909 INFO checking window state
14:17:13     INFO -  910 ERROR TEST-UNEXPECTED-FAIL | chrome://mochitests/content/browser/browser/devtools/inspector/test/browser_inspector_update-on-navigation.js | application terminated with exit code 2147483651
14:17:13     INFO -  runtests.py | Application ran for: 0:33:31.087000
14:17:13     INFO -  zombiecheck | Reading PID log: c:\users\cltbld~1.t-w\appdata\local\temp\tmpolz8expidlog
14:17:20     INFO -  mozcrash Saved minidump as C:\slave\test\build\blobber_upload_dir\22925ad5-c0b1-4b80-8088-1d8a480a1487.dmp
14:17:20     INFO -  mozcrash Saved app info as C:\slave\test\build\blobber_upload_dir\22925ad5-c0b1-4b80-8088-1d8a480a1487.extra
14:17:20  WARNING -  PROCESS-CRASH | chrome://mochitests/content/browser/browser/devtools/inspector/test/browser_inspector_update-on-navigation.js | application crashed [@ KERNELBASE.dll + 0x89ae4]
14:17:20     INFO -  Crash dump filename: c:\users\cltbld~1.t-w\appdata\local\temp\tmpn6gso8.mozrunner\minidumps\22925ad5-c0b1-4b80-8088-1d8a480a1487.dmp
14:17:20     INFO -  Operating system: Windows NT
14:17:20     INFO -                    6.2.9200
14:17:20     INFO -  CPU: x86
14:17:20     INFO -       GenuineIntel family 6 model 30 stepping 5
14:17:20     INFO -       8 CPUs
14:17:20     INFO -  Crash reason:  EXCEPTION_BREAKPOINT
14:17:20     INFO -  Crash address: 0x76599ae4
14:17:20     INFO -  Thread 0 (crashed)
14:17:20     INFO -   0  KERNELBASE.dll + 0x89ae4
14:17:20     INFO -      eip = 0x76599ae4   esp = 0x006bd098   ebp = 0x006bd4cc   ebx = 0xffffffff
14:17:20     INFO -      esi = 0x6f141ec6   edi = 0x00000000   eax = 0x00000000   ecx = 0x00000005
14:17:20     INFO -      edx = 0x0a1c4010   efl = 0x00200246
14:17:20     INFO -      Found by: given as instruction pointer in context
14:17:20     INFO -   1  xul.dll!nsDebugImpl::Abort(char const *,int) [nsDebugImpl.cpp:d8688cafc752 : 157 + 0x10]
14:17:20     INFO -      eip = 0x70f7f760   esp = 0x006bd4d4   ebp = 0x006bd4e8
14:17:20     INFO -      Found by: previous frame's frame pointer
14:17:20     INFO -   2  xul.dll!NS_InvokeByIndex [xptcinvoke.cpp:d8688cafc752 : 70 + 0x2]
14:17:20     INFO -      eip = 0x70fe9abd   esp = 0x006bd4f0   ebp = 0x006bd504
14:17:20     INFO -      Found by: call frame info
14:17:20     INFO -   3  xul.dll!CallMethodHelper::Invoke() [XPCWrappedNative.cpp:d8688cafc752 : 2392 + 0xe]
14:17:20     INFO -      eip = 0x7152e2d7   esp = 0x006bd50c   ebp = 0x006bd530
14:17:20     INFO -      Found by: call frame info
14:17:20     INFO -   4  xul.dll!CallMethodHelper::Call() [XPCWrappedNative.cpp:d8688cafc752 : 1744 + 0x6]
14:17:20     INFO -      eip = 0x71541cd7   esp = 0x006bd520   ebp = 0x006bd530
14:17:20     INFO -      Found by: call frame info
14:17:20     INFO -   5  xul.dll!XPCWrappedNative::CallMethod(XPCCallContext &,XPCWrappedNative::CallMode) [XPCWrappedNative.cpp:d8688cafc752 : 1711 + 0x11]
14:17:20     INFO -      eip = 0x71545577   esp = 0x006bd538   ebp = 0x006bd608
14:17:20     INFO -      Found by: call frame info
14:17:20     INFO -   6  nss3.dll!sqlite3Insert [sqlite3.c:d8688cafc752 : 95513 + 0x11]
14:17:20     INFO -      eip = 0x6f040006   esp = 0x006bd558   ebp = 0x006bd608
14:17:20     INFO -      Found by: stack scanning
14:17:20     INFO -   7  xul.dll!XPC_WN_CallMethod(JSContext *,unsigned int,JS::Value *) [XPCWrappedNativeJSOps.cpp:d8688cafc752 : 1247 + 0xc]
14:17:20     INFO -      eip = 0x7154591d   esp = 0x006bd610   ebp = 0x006bd6d0
14:17:20     INFO -      Found by: call frame info
14:17:20     INFO -   8  mozjs.dll!js::CallJSNative(JSContext *,bool (*)(JSContext *,unsigned int,JS::Value *),JS::CallArgs const &) [jscntxtinlines.h:d8688cafc752 : 231 + 0xe]
14:17:20     INFO -      eip = 0x70ce7511   esp = 0x006bd6d8   ebp = 0x006bd6f8
14:17:20     INFO -      Found by: call frame info
Blocks: dbg-test
Inactive; closing (see bug 1180138).
Status: NEW → RESOLVED
Closed: 9 years ago
Resolution: --- → WORKSFORME
Product: Firefox → DevTools
You need to log in before you can comment on or make changes to this bug.