<%2Fdiv>]
02:40:14 INFO - [Child 27356] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:40:14 INFO - nsStringStats
02:40:14 INFO - => mAllocCount: 29890
02:40:14 INFO - => mReallocCount: 1122
02:40:14 INFO - => mFreeCount: 29890
02:40:14 INFO - => mShareCount: 16676
02:40:14 INFO - => mAdoptCount: 3117
02:40:14 INFO - => mAdoptFreeCount: 3117
02:40:14 INFO - => Process ID: 27356, Thread ID: 2967071040
02:40:16 INFO - ++DOCSHELL 0xa3b0e000 == 1 [pid = 27400] [id = 1]
02:40:16 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=27400 error="No such file or directory"
02:40:16 INFO - ++DOMWINDOW == 1 (0xa3b96c00) [pid = 27400] [serial = 1] [outer = (nil)]
02:40:16 INFO - ++DOCSHELL 0xa3b0e000 == 1 [pid = 27407] [id = 1]
02:40:16 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=27407 error="No such file or directory"
02:40:16 INFO - ++DOMWINDOW == 1 (0xa3b93c00) [pid = 27407] [serial = 1] [outer = (nil)]
02:40:16 INFO - ++DOMWINDOW == 2 (0x9e14ac00) [pid = 27400] [serial = 2] [outer = 0xa3b96c00]
02:40:16 INFO - ++DOMWINDOW == 2 (0x9e14ac00) [pid = 27407] [serial = 2] [outer = 0xa3b93c00]
02:40:18 INFO - 1359 INFO Console message: [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "data:text/html,%20Custom%20User%20Agent%20test" line: 0}]
02:40:18 INFO - 1360 INFO URL 'data:text/html, Custom User Agent test' loading complete
02:40:18 INFO - 1361 INFO Waiting for event: 'on' on [object Object].
02:40:18 INFO - 1362 INFO Waiting for event: 'content-resize' on [object Object].
02:40:19 INFO - 1363 INFO Got event: 'content-resize' on [object Object].
02:40:19 INFO - 1364 INFO Got event: 'on' on [object Object].
02:40:20 INFO - 1365 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_customuseragent.js | UA should be set to Mozilla/5.0 (X11; Linux i686; rv:52.0) Gecko/20100101 Firefox/52.0 -
02:40:20 INFO - 1366 INFO Setting UA to Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/41.0.2228.0 Safari/537.36
02:40:20 INFO - 1367 INFO Waiting for event: 'userAgentChanged' on [object Object].
02:40:20 INFO - ++DOMWINDOW == 3 (0x9bd22400) [pid = 27407] [serial = 3] [outer = 0xa3b93c00]
02:40:21 INFO - --DOCSHELL 0xa44f5000 == 7 [pid = 27193] [id = 11]
02:40:21 INFO - --DOMWINDOW == 18 (0xa44f8800) [pid = 27193] [serial = 25] [outer = (nil)] [url = about:blank]
02:40:21 INFO - --DOMWINDOW == 17 (0xa5e8e800) [pid = 27193] [serial = 23] [outer = (nil)] [url = chrome://devtools/content/commandline/commandlineoutput.xhtml]
02:40:21 INFO - --DOMWINDOW == 16 (0x94d2f800) [pid = 27193] [serial = 22] [outer = (nil)] [url = chrome://devtools/content/commandline/commandlinetooltip.xhtml]
02:40:21 INFO - 1368 INFO Console message: [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "data:text/html,%20Custom%20User%20Agent%20test" line: 0}]
02:40:21 INFO - 1369 INFO Got event: 'userAgentChanged' on [object Object].
02:40:21 INFO - 1370 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_customuseragent.js | UA input should be highlighted -
02:40:21 INFO - 1371 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_customuseragent.js | UA should be set to Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/41.0.2228.0 Safari/537.36 -
02:40:21 INFO - 1372 INFO Resetting UA
02:40:21 INFO - 1373 INFO Waiting for event: 'userAgentChanged' on [object Object].
02:40:21 INFO - ++DOMWINDOW == 4 (0x9bd2d400) [pid = 27407] [serial = 4] [outer = 0xa3b93c00]
02:40:21 INFO - 1374 INFO Console message: [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "data:text/html,%20Custom%20User%20Agent%20test" line: 0}]
02:40:21 INFO - 1375 INFO Got event: 'userAgentChanged' on [object Object].
02:40:21 INFO - 1376 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_customuseragent.js | UA input shouldn't be highlighted -
02:40:21 INFO - 1377 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_customuseragent.js | UA should be set to Mozilla/5.0 (X11; Linux i686; rv:52.0) Gecko/20100101 Firefox/52.0 -
02:40:22 INFO - 1378 INFO Setting UA to Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/41.0.2228.0 Safari/537.36
02:40:22 INFO - 1379 INFO Waiting for event: 'userAgentChanged' on [object Object].
02:40:22 INFO - ++DOMWINDOW == 5 (0x9bdc7800) [pid = 27407] [serial = 5] [outer = 0xa3b93c00]
02:40:22 INFO - 1380 INFO Console message: [JavaScript Error: "The character encoding of the HTML document was not declared. The document will render with garbled text in some browser configurations if the document contains characters from outside the US-ASCII range. The character encoding of the page must be declared in the document or in the transfer protocol." {file: "data:text/html,%20Custom%20User%20Agent%20test" line: 0}]
02:40:22 INFO - 1381 INFO Got event: 'userAgentChanged' on [object Object].
02:40:22 INFO - 1382 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_customuseragent.js | UA input should be highlighted -
02:40:22 INFO - 1383 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_customuseragent.js | UA should be set to Mozilla/5.0 (Windows NT 6.1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/41.0.2228.0 Safari/537.36 -
02:40:22 INFO - 1384 INFO Closing responsive mode
02:40:22 INFO - 1385 INFO Waiting for event: 'off' on [object Object].
02:40:22 INFO - 1386 INFO Waiting for event: 'content-resize' on [object Object].
02:40:22 INFO - 1387 INFO Got event: 'content-resize' on [object Object].
02:40:22 INFO - 1388 INFO Got event: 'off' on [object Object].
02:40:22 INFO - 1389 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_customuseragent.js | UA should be set to Mozilla/5.0 (X11; Linux i686; rv:52.0) Gecko/20100101 Firefox/52.0 -
02:40:22 INFO - 1390 INFO Leaving test bound
02:40:22 INFO - 1391 INFO Removing tab.
02:40:22 INFO - 1392 INFO Waiting for event: 'TabClose' on [object XULElement].
02:40:22 INFO - 1393 INFO Got event: 'TabClose' on [object XULElement].
02:40:23 INFO - 1394 INFO Tab removed and finished closing
02:40:23 INFO - MEMORY STAT | vsize 795MB | residentFast 227MB | heapAllocated 90MB
02:40:23 INFO - 1395 INFO TEST-OK | devtools/client/responsivedesign/test/browser_responsiveui_customuseragent.js | took 12287ms
02:40:23 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpcb3nbb.mozrunner/runtests_leaks_tab_pid27448.log
02:40:24 INFO - 1396 INFO TEST-START | devtools/client/responsivedesign/test/browser_responsiveui_touch.js
02:40:24 INFO - 1397 INFO Entering test bound
02:40:24 INFO - 1398 INFO Adding a new tab with URL: 'http://mochi.test:8888/browser/devtools/client/responsivedesign/test/touch.html'
02:40:24 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpcb3nbb.mozrunner/runtests_leaks_tab_pid27455.log
02:40:24 INFO - [Child 27407] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:40:24 INFO - --DOMWINDOW == 15 (0xa44f5400) [pid = 27193] [serial = 24] [outer = (nil)] [url = about:logo]
02:40:24 INFO - [Child 27400] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:40:25 INFO - --DOCSHELL 0xa3b0e000 == 0 [pid = 27400] [id = 1]
02:40:25 INFO - --DOCSHELL 0xa3b0e000 == 0 [pid = 27407] [id = 1]
02:40:26 INFO - [Child 27448] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:40:26 INFO - [Child 27455] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:40:26 INFO - --DOMWINDOW == 1 (0xa3b96c00) [pid = 27400] [serial = 1] [outer = (nil)] [url = about:blank]
02:40:26 INFO - --DOMWINDOW == 0 (0x9e14ac00) [pid = 27400] [serial = 2] [outer = (nil)] [url = about:blank]
02:40:27 INFO - [Child 27400] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:40:27 INFO - nsStringStats
02:40:27 INFO - => mAllocCount: 25846
02:40:27 INFO - => mReallocCount: 832
02:40:27 INFO - => mFreeCount: 25846
02:40:27 INFO - => mShareCount: 12231
02:40:27 INFO - => mAdoptCount: 2170
02:40:27 INFO - => mAdoptFreeCount: 2170
02:40:27 INFO - => Process ID: 27400, Thread ID: 2966886720
02:40:27 INFO - --DOMWINDOW == 4 (0xa3b93c00) [pid = 27407] [serial = 1] [outer = (nil)] [url = data:text/html,%20Custom%20User%20Agent%20test]
02:40:27 INFO - --DOMWINDOW == 3 (0x9e14ac00) [pid = 27407] [serial = 2] [outer = (nil)] [url = about:blank]
02:40:27 INFO - --DOMWINDOW == 2 (0x9bd22400) [pid = 27407] [serial = 3] [outer = (nil)] [url = data:text/html,%20Custom%20User%20Agent%20test]
02:40:27 INFO - --DOMWINDOW == 1 (0x9bd2d400) [pid = 27407] [serial = 4] [outer = (nil)] [url = data:text/html,%20Custom%20User%20Agent%20test]
02:40:27 INFO - --DOMWINDOW == 0 (0x9bdc7800) [pid = 27407] [serial = 5] [outer = (nil)] [url = data:text/html,%20Custom%20User%20Agent%20test]
02:40:27 INFO - [Child 27407] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:40:27 INFO - nsStringStats
02:40:27 INFO - => mAllocCount: 29974
02:40:27 INFO - => mReallocCount: 1128
02:40:27 INFO - => mFreeCount: 29974
02:40:27 INFO - => mShareCount: 16904
02:40:27 INFO - => mAdoptCount: 3227
02:40:27 INFO - => mAdoptFreeCount: 3227
02:40:27 INFO - => Process ID: 27407, Thread ID: 2966878528
02:40:29 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 27448] [id = 1]
02:40:29 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=27448 error="No such file or directory"
02:40:29 INFO - ++DOMWINDOW == 1 (0xa3a97000) [pid = 27448] [serial = 1] [outer = (nil)]
02:40:29 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 27455] [id = 1]
02:40:29 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=27455 error="No such file or directory"
02:40:29 INFO - ++DOMWINDOW == 1 (0xa3a94400) [pid = 27455] [serial = 1] [outer = (nil)]
02:40:29 INFO - ++DOMWINDOW == 2 (0x9e085c00) [pid = 27448] [serial = 2] [outer = 0xa3a97000]
02:40:29 INFO - ++DOMWINDOW == 2 (0x9e085c00) [pid = 27455] [serial = 2] [outer = 0xa3a94400]
02:40:31 INFO - [Child 27455] WARNING: site security information will not be persisted: file /builds/slave/ash-lx-d-000000000000000000000/build/src/security/manager/ssl/nsSiteSecurityService.cpp, line 267
02:40:31 INFO - ++DOMWINDOW == 3 (0x9dc5a400) [pid = 27455] [serial = 3] [outer = 0xa3a94400]
02:40:32 INFO - 1399 INFO URL 'http://mochi.test:8888/browser/devtools/client/responsivedesign/test/touch.html' loading complete
02:40:32 INFO - 1400 INFO Waiting for event: 'on' on [object Object].
02:40:32 INFO - 1401 INFO Waiting for event: 'content-resize' on [object Object].
02:40:33 INFO - 1402 INFO Got event: 'content-resize' on [object Object].
02:40:33 INFO - --DOMWINDOW == 14 (0x8741e000) [pid = 27193] [serial = 26] [outer = (nil)] [url = about:logo]
02:40:33 INFO - 1403 INFO Got event: 'on' on [object Object].
02:40:34 INFO - 1404 INFO testWithNoTouch: Initial test parameter and mouse mouse outside div element
02:40:34 INFO - 1405 INFO testWithNoTouch: Move mouse into the div element
02:40:34 INFO - 1406 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_touch.js | mouseenter or mouseover should work -
02:40:34 INFO - 1407 INFO testWithNoTouch: Drag the div element
02:40:34 INFO - 1408 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_touch.js | touchmove shouldn't work -
02:40:34 INFO - 1409 INFO testWithNoTouch: Move mouse out of the div element
02:40:34 INFO - 1410 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_touch.js | mouseout or mouseleave should work -
02:40:34 INFO - 1411 INFO testWithNoTouch: Click the div element
02:40:34 INFO - 1412 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_touch.js | 300ms delay between touch events and mouse events should not work -
02:40:34 INFO - 1413 INFO testWithTouch: Initial test parameter and mouse mouse outside div element
02:40:34 INFO - 1414 INFO testWithTouch: Move mouse into the div element
02:40:34 INFO - 1415 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_touch.js | mouseenter or mouseover should not work -
02:40:34 INFO - 1416 INFO testWithTouch: Drag the div element
02:40:34 INFO - 1417 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_touch.js | touchmove should work -
02:40:34 INFO - 1418 INFO testWithTouch: Move mouse out of the div element
02:40:34 INFO - 1419 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_touch.js | mouseout or mouseleave should not work -
02:40:34 INFO - 1420 INFO testWithMetaViewportEnabled: click the div element with
02:40:34 INFO - 1421 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_touch.js | 300ms delay between touch events and mouse events should work -
02:40:34 INFO - 1422 INFO testWithMetaViewportEnabled: click the div element with
02:40:34 INFO - 1423 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_touch.js | 300ms delay between touch events and mouse events should not work -
02:40:34 INFO - 1424 INFO testWithMetaViewportEnabled: click the div element with
02:40:34 INFO - 1425 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_touch.js | 300ms delay between touch events and mouse events should not work -
02:40:34 INFO - 1426 INFO testWithMetaViewportEnabled: click the div element with
02:40:34 INFO - 1427 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_touch.js | 300ms delay between touch events and mouse events should not work -
02:40:34 INFO - 1428 INFO testWithMetaViewportDisabled: click the div element with
02:40:35 INFO - 1429 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_touch.js | 300ms delay between touch events and mouse events should work -
02:40:35 INFO - 1430 INFO testWithNoTouch: Initial test parameter and mouse mouse outside div element
02:40:35 INFO - 1431 INFO testWithNoTouch: Move mouse into the div element
02:40:35 INFO - 1432 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_touch.js | mouseenter or mouseover should work -
02:40:35 INFO - 1433 INFO testWithNoTouch: Drag the div element
02:40:35 INFO - 1434 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_touch.js | touchmove shouldn't work -
02:40:35 INFO - 1435 INFO testWithNoTouch: Move mouse out of the div element
02:40:35 INFO - 1436 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_touch.js | mouseout or mouseleave should work -
02:40:35 INFO - 1437 INFO testWithNoTouch: Click the div element
02:40:35 INFO - 1438 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveui_touch.js | 300ms delay between touch events and mouse events should not work -
02:40:35 INFO - 1439 INFO Waiting for event: 'off' on [object Object].
02:40:35 INFO - 1440 INFO Waiting for event: 'content-resize' on [object Object].
02:40:35 INFO - 1441 INFO Got event: 'content-resize' on [object Object].
02:40:35 INFO - 1442 INFO Got event: 'off' on [object Object].
02:40:35 INFO - 1443 INFO Leaving test bound
02:40:35 INFO - 1444 INFO Removing tab.
02:40:35 INFO - 1445 INFO Waiting for event: 'TabClose' on [object XULElement].
02:40:35 INFO - 1446 INFO Got event: 'TabClose' on [object XULElement].
02:40:35 INFO - 1447 INFO Tab removed and finished closing
02:40:36 INFO - MEMORY STAT | vsize 788MB | residentFast 227MB | heapAllocated 91MB
02:40:36 INFO - 1448 INFO TEST-OK | devtools/client/responsivedesign/test/browser_responsiveui_touch.js | took 12165ms
02:40:36 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpcb3nbb.mozrunner/runtests_leaks_tab_pid27495.log
02:40:36 INFO - [Child 27455] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:40:36 INFO - 1449 INFO TEST-START | devtools/client/responsivedesign/test/browser_responsiveuiaddcustompreset.js
02:40:36 INFO - 1450 INFO Entering test bound
02:40:36 INFO - 1451 INFO Adding a new tab with URL: 'data:text/html;charset=utf8,Test RDM custom presets'
02:40:37 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpcb3nbb.mozrunner/runtests_leaks_tab_pid27502.log
02:40:37 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 27455] [id = 1]
02:40:37 INFO - [Child 27455] WARNING: Wrong button set to eContextMenu event?: 'mMessage != eContextMenu || button == ((mContextMenuTrigger == eNormal) ? eRightButton : eLeftButton)', file /builds/slave/ash-lx-d-000000000000000000000/build/src/obj-firefox/dist/include/mozilla/MouseEvents.h, line 256
02:40:37 INFO - [Child 27455] WARNING: Wrong button set to eContextMenu event?: 'mMessage != eContextMenu || button == ((mContextMenuTrigger == eNormal) ? eRightButton : eLeftButton)', file /builds/slave/ash-lx-d-000000000000000000000/build/src/obj-firefox/dist/include/mozilla/MouseEvents.h, line 256
02:40:37 INFO - [Child 27455] WARNING: Wrong button set to eContextMenu event?: 'mMessage != eContextMenu || button == ((mContextMenuTrigger == eNormal) ? eRightButton : eLeftButton)', file /builds/slave/ash-lx-d-000000000000000000000/build/src/obj-firefox/dist/include/mozilla/MouseEvents.h, line 256
02:40:37 INFO - [Child 27455] WARNING: Wrong button set to eContextMenu event?: 'mMessage != eContextMenu || button == ((mContextMenuTrigger == eNormal) ? eRightButton : eLeftButton)', file /builds/slave/ash-lx-d-000000000000000000000/build/src/obj-firefox/dist/include/mozilla/MouseEvents.h, line 256
02:40:37 INFO - [Child 27455] WARNING: Wrong button set to eContextMenu event?: 'mMessage != eContextMenu || button == ((mContextMenuTrigger == eNormal) ? eRightButton : eLeftButton)', file /builds/slave/ash-lx-d-000000000000000000000/build/src/obj-firefox/dist/include/mozilla/MouseEvents.h, line 256
02:40:37 INFO - [Child 27455] WARNING: Wrong button set to eContextMenu event?: 'mMessage != eContextMenu || button == ((mContextMenuTrigger == eNormal) ? eRightButton : eLeftButton)', file /builds/slave/ash-lx-d-000000000000000000000/build/src/obj-firefox/dist/include/mozilla/MouseEvents.h, line 256
02:40:38 INFO - [Child 27448] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:40:38 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 27448] [id = 1]
02:40:39 INFO - --DOMWINDOW == 2 (0xa3a94400) [pid = 27455] [serial = 1] [outer = (nil)] [url = http://mochi.test:8888/browser/devtools/client/responsivedesign/test/touch.html]
02:40:39 INFO - --DOMWINDOW == 1 (0x9e085c00) [pid = 27455] [serial = 2] [outer = (nil)] [url = about:blank]
02:40:39 INFO - --DOMWINDOW == 0 (0x9dc5a400) [pid = 27455] [serial = 3] [outer = (nil)] [url = http://mochi.test:8888/browser/devtools/client/responsivedesign/test/touch.html]
02:40:39 INFO - [Child 27455] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:40:39 INFO - nsStringStats
02:40:39 INFO - => mAllocCount: 29549
02:40:39 INFO - => mReallocCount: 968
02:40:39 INFO - => mFreeCount: 29549
02:40:39 INFO - => mShareCount: 15153
02:40:39 INFO - => mAdoptCount: 2836
02:40:39 INFO - => mAdoptFreeCount: 2836
02:40:39 INFO - => Process ID: 27455, Thread ID: 2966681920
02:40:39 INFO - [Child 27495] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:40:40 INFO - [Child 27502] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:40:40 INFO - --DOMWINDOW == 1 (0xa3a97000) [pid = 27448] [serial = 1] [outer = (nil)] [url = about:blank]
02:40:40 INFO - --DOMWINDOW == 0 (0x9e085c00) [pid = 27448] [serial = 2] [outer = (nil)] [url = about:blank]
02:40:40 INFO - [Child 27448] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:40:40 INFO - nsStringStats
02:40:40 INFO - => mAllocCount: 25854
02:40:40 INFO - => mReallocCount: 832
02:40:40 INFO - => mFreeCount: 25854
02:40:40 INFO - => mShareCount: 12233
02:40:40 INFO - => mAdoptCount: 2167
02:40:40 INFO - => mAdoptFreeCount: 2167
02:40:40 INFO - => Process ID: 27448, Thread ID: 2966284608
02:40:42 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 27495] [id = 1]
02:40:42 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=27495 error="No such file or directory"
02:40:42 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 27502] [id = 1]
02:40:42 INFO - ++DOMWINDOW == 1 (0xa3a97000) [pid = 27495] [serial = 1] [outer = (nil)]
02:40:42 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=27502 error="No such file or directory"
02:40:42 INFO - ++DOMWINDOW == 1 (0xa3a94400) [pid = 27502] [serial = 1] [outer = (nil)]
02:40:42 INFO - ++DOMWINDOW == 2 (0x9e085c00) [pid = 27495] [serial = 2] [outer = 0xa3a97000]
02:40:42 INFO - ++DOMWINDOW == 2 (0x9e085c00) [pid = 27502] [serial = 2] [outer = 0xa3a94400]
02:40:44 INFO - 1452 INFO URL 'data:text/html;charset=utf8,Test RDM custom presets' loading complete
02:40:44 INFO - 1453 INFO Waiting for event: 'on' on [object Object].
02:40:44 INFO - 1454 INFO Waiting for event: 'content-resize' on [object Object].
02:40:45 INFO - 1455 INFO Got event: 'content-resize' on [object Object].
02:40:46 INFO - 1456 INFO Got event: 'on' on [object Object].
02:40:46 INFO - 1457 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveuiaddcustompreset.js | Should be in responsive mode. -
02:40:46 INFO - 1458 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveuiaddcustompreset.js | RDM instance should be attached to the tab. -
02:40:46 INFO - 1459 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveuiaddcustompreset.js | selected item shouldn't change after add preset and cancel -
02:40:46 INFO - 1460 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveuiaddcustompreset.js | number of presets shouldn't change after add preset and cancel -
02:40:46 INFO - 1461 INFO Waiting for event: 'content-resize' on [object Object].
02:40:46 INFO - 1462 INFO Got event: 'content-resize' on [object Object].
02:40:46 INFO - 1463 INFO Waiting for event: 'off' on [object Object].
02:40:46 INFO - 1464 INFO Waiting for event: 'content-resize' on [object Object].
02:40:46 INFO - 1465 INFO Got event: 'content-resize' on [object Object].
02:40:46 INFO - 1466 INFO Got event: 'off' on [object Object].
02:40:46 INFO - 1467 INFO Waiting for event: 'on' on [object Object].
02:40:46 INFO - 1468 INFO Waiting for event: 'content-resize' on [object Object].
02:40:46 INFO - 1469 INFO Got event: 'content-resize' on [object Object].
02:40:47 INFO - 1470 INFO Got event: 'on' on [object Object].
02:40:47 INFO - 1471 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveuiaddcustompreset.js | Should be in responsive mode. -
02:40:47 INFO - 1472 INFO Current preset: 3, change to: 8
02:40:47 INFO - 1473 INFO Waiting for event: 'content-resize' on [object Object].
02:40:47 INFO - 1474 INFO Got event: 'content-resize' on [object Object].
02:40:47 INFO - 1475 INFO Current preset: 8, change to: 7
02:40:47 INFO - 1476 INFO Waiting for event: 'content-resize' on [object Object].
02:40:47 INFO - 1477 INFO Got event: 'content-resize' on [object Object].
02:40:47 INFO - 1478 INFO Current preset: 7, change to: 6
02:40:47 INFO - 1479 INFO Waiting for event: 'content-resize' on [object Object].
02:40:47 INFO - 1480 INFO Got event: 'content-resize' on [object Object].
02:40:47 INFO - 1481 INFO Current preset: 6, change to: 5
02:40:47 INFO - 1482 INFO Waiting for event: 'content-resize' on [object Object].
02:40:48 INFO - 1483 INFO Got event: 'content-resize' on [object Object].
02:40:48 INFO - 1484 INFO Current preset: 5, change to: 4
02:40:48 INFO - 1485 INFO Waiting for event: 'content-resize' on [object Object].
02:40:48 INFO - 1486 INFO Got event: 'content-resize' on [object Object].
02:40:48 INFO - 1487 INFO Current preset: 4, change to: 3
02:40:48 INFO - 1488 INFO Waiting for event: 'content-resize' on [object Object].
02:40:48 INFO - 1489 INFO Got event: 'content-resize' on [object Object].
02:40:48 INFO - 1490 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveuiaddcustompreset.js | (idx = 3) should be the previously added preset in the list of items -
02:40:48 INFO - 1491 INFO Current preset: 3, change to: 3
02:40:48 INFO - 1492 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveuiaddcustompreset.js | Selecting preset should change the width - 456 == 456 -
02:40:48 INFO - 1493 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveuiaddcustompreset.js | Selecting preset should change the height - 123 == 123 -
02:40:48 INFO - 1494 INFO menulist count: 12
02:40:48 INFO - 1495 INFO Current preset: -1, change to: 2
02:40:48 INFO - 1496 INFO Waiting for event: 'content-resize' on [object Object].
02:40:48 INFO - 1497 INFO Got event: 'content-resize' on [object Object].
02:40:48 INFO - 1498 INFO Current preset: -1, change to: 2
02:40:48 INFO - 1499 INFO Waiting for event: 'content-resize' on [object Object].
02:40:48 INFO - 1500 INFO Got event: 'content-resize' on [object Object].
02:40:48 INFO - 1501 INFO Waiting for event: 'off' on [object Object].
02:40:48 INFO - 1502 INFO Waiting for event: 'content-resize' on [object Object].
02:40:48 INFO - 1503 INFO Got event: 'content-resize' on [object Object].
02:40:48 INFO - 1504 INFO Got event: 'off' on [object Object].
02:40:48 INFO - 1505 INFO Waiting for event: 'on' on [object Object].
02:40:48 INFO - 1506 INFO Waiting for event: 'content-resize' on [object Object].
02:40:49 INFO - 1507 INFO Got event: 'content-resize' on [object Object].
02:40:49 INFO - 1508 INFO Got event: 'on' on [object Object].
02:40:49 INFO - 1509 INFO Current preset: -1, change to: 5
02:40:49 INFO - 1510 INFO Waiting for event: 'content-resize' on [object Object].
02:40:49 INFO - 1511 INFO Got event: 'content-resize' on [object Object].
02:40:49 INFO - 1512 INFO Current preset: 5, change to: 4
02:40:49 INFO - 1513 INFO Waiting for event: 'content-resize' on [object Object].
02:40:49 INFO - 1514 INFO Got event: 'content-resize' on [object Object].
02:40:49 INFO - 1515 INFO Current preset: 4, change to: 3
02:40:49 INFO - 1516 INFO Waiting for event: 'content-resize' on [object Object].
02:40:49 INFO - 1517 INFO Got event: 'content-resize' on [object Object].
02:40:49 INFO - 1518 INFO Current preset: 3, change to: 2
02:40:49 INFO - 1519 INFO Waiting for event: 'content-resize' on [object Object].
02:40:49 INFO - 1520 INFO Got event: 'content-resize' on [object Object].
02:40:50 INFO - 1521 INFO Current preset: 2, change to: 1
02:40:50 INFO - 1522 INFO Waiting for event: 'content-resize' on [object Object].
02:40:50 INFO - 1523 INFO Got event: 'content-resize' on [object Object].
02:40:50 INFO - 1524 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveuiaddcustompreset.js | Deleted preset 360×640 should not be in the list anymore -
02:40:50 INFO - 1525 INFO Current preset: 1, change to: 5
02:40:50 INFO - 1526 INFO Waiting for event: 'content-resize' on [object Object].
02:40:50 INFO - 1527 INFO Got event: 'content-resize' on [object Object].
02:40:50 INFO - 1528 INFO Current preset: 5, change to: 4
02:40:50 INFO - 1529 INFO Waiting for event: 'content-resize' on [object Object].
02:40:50 INFO - 1530 INFO Got event: 'content-resize' on [object Object].
02:40:50 INFO - 1531 INFO Current preset: 4, change to: 3
02:40:50 INFO - 1532 INFO Waiting for event: 'content-resize' on [object Object].
02:40:50 INFO - 1533 INFO Got event: 'content-resize' on [object Object].
02:40:50 INFO - 1534 INFO Current preset: 3, change to: 2
02:40:50 INFO - 1535 INFO Waiting for event: 'content-resize' on [object Object].
02:40:50 INFO - 1536 INFO Got event: 'content-resize' on [object Object].
02:40:50 INFO - 1537 INFO Current preset: 2, change to: 1
02:40:50 INFO - 1538 INFO Waiting for event: 'content-resize' on [object Object].
02:40:50 INFO - 1539 INFO Got event: 'content-resize' on [object Object].
02:40:50 INFO - 1540 INFO TEST-PASS | devtools/client/responsivedesign/test/browser_responsiveuiaddcustompreset.js | Deleted preset 768×1024 should not be in the list anymore -
02:40:50 INFO - 1541 INFO Waiting for event: 'off' on [object Object].
02:40:50 INFO - 1542 INFO Waiting for event: 'content-resize' on [object Object].
02:40:51 INFO - 1543 INFO Got event: 'content-resize' on [object Object].
02:40:51 INFO - 1544 INFO Got event: 'off' on [object Object].
02:40:51 INFO - 1545 INFO Leaving test bound
02:40:51 INFO - 1546 INFO Removing tab.
02:40:51 INFO - 1547 INFO Waiting for event: 'TabClose' on [object XULElement].
02:40:51 INFO - 1548 INFO Got event: 'TabClose' on [object XULElement].
02:40:51 INFO - 1549 INFO Tab removed and finished closing
02:40:51 INFO - MEMORY STAT | vsize 805MB | residentFast 233MB | heapAllocated 91MB
02:40:51 INFO - 1550 INFO TEST-OK | devtools/client/responsivedesign/test/browser_responsiveuiaddcustompreset.js | took 14875ms
02:40:51 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpcb3nbb.mozrunner/runtests_leaks_tab_pid27542.log
02:40:52 INFO - ++DOMWINDOW == 15 (0x864f3c00) [pid = 27193] [serial = 27] [outer = 0x94d25400]
02:40:52 INFO - --DOCSHELL 0xa2a68800 == 6 [pid = 27193] [id = 5]
02:40:52 INFO - ++DOMWINDOW == 16 (0x94f88400) [pid = 27193] [serial = 28] [outer = 0x94d25400]
02:40:52 INFO - [Child 27502] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:40:53 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 27502] [id = 1]
02:40:53 INFO - --DOMWINDOW == 1 (0xa3a94400) [pid = 27502] [serial = 1] [outer = (nil)] [url = data:text/html;charset=utf8,Test%20RDM%20custom%20presets]
02:40:53 INFO - --DOMWINDOW == 0 (0x9e085c00) [pid = 27502] [serial = 2] [outer = (nil)] [url = about:blank]
02:40:53 INFO - [Child 27502] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:40:53 INFO - nsStringStats
02:40:53 INFO - => mAllocCount: 29502
02:40:53 INFO - => mReallocCount: 1087
02:40:53 INFO - => mFreeCount: 29502
02:40:53 INFO - => mShareCount: 16556
02:40:53 INFO - => mAdoptCount: 2781
02:40:53 INFO - => mAdoptFreeCount: 2781
02:40:53 INFO - => Process ID: 27502, Thread ID: 2966436160
02:40:54 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 27495] [id = 1]
02:40:54 INFO - --DOCSHELL 0xa2a6d800 == 5 [pid = 27193] [id = 6]
02:40:54 INFO - --DOCSHELL 0x91473000 == 4 [pid = 27193] [id = 8]
02:40:58 INFO - --DOMWINDOW == 15 (0x864f3c00) [pid = 27193] [serial = 27] [outer = (nil)] [url = about:blank]
02:40:58 INFO - --DOMWINDOW == 14 (0x98f48400) [pid = 27193] [serial = 19] [outer = (nil)] [url = about:newtab]
02:40:58 INFO - --DOMWINDOW == 13 (0x943ecc00) [pid = 27193] [serial = 9] [outer = (nil)] [url = about:blank]
02:40:58 INFO - --DOMWINDOW == 12 (0x943bb000) [pid = 27193] [serial = 14] [outer = (nil)] [url = about:blank]
02:40:58 INFO - --DOMWINDOW == 11 (0xa2b42c00) [pid = 27193] [serial = 12] [outer = (nil)] [url = data:application/vnd.mozilla.xul+xml;charset=utf-8,]
02:40:58 INFO - --DOMWINDOW == 10 (0x943c5000) [pid = 27193] [serial = 17] [outer = (nil)] [url = about:newtab]
02:40:58 INFO - --DOMWINDOW == 9 (0xa2a6e000) [pid = 27193] [serial = 13] [outer = (nil)] [url = about:blank]
02:40:58 INFO - --DOMWINDOW == 8 (0xa2a68c00) [pid = 27193] [serial = 10] [outer = (nil)] [url = data:application/vnd.mozilla.xul+xml;charset=utf-8,]
02:40:59 INFO - [Child 27542] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:41:00 INFO - --DOMWINDOW == 1 (0xa3a97000) [pid = 27495] [serial = 1] [outer = (nil)] [url = about:blank]
02:41:00 INFO - --DOMWINDOW == 0 (0x9e085c00) [pid = 27495] [serial = 2] [outer = (nil)] [url = about:blank]
02:41:00 INFO - Completed ShutdownLeaks collections in process 27495
02:41:00 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x4A011A,name=PContent::Msg_AccumulateChildHistogram) Closed channel: cannot send/recv
02:41:00 INFO - [Child 27495] WARNING: MsgDropped in ContentChild: file /builds/slave/ash-lx-d-000000000000000000000/build/src/dom/ipc/ContentChild.cpp, line 2269
02:41:00 INFO - [Child 27495] WARNING: '!contentChild->SendAccumulateChildHistogram(accumulationsToSend)', file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/components/telemetry/TelemetryHistogram.cpp, line 2638
02:41:00 INFO - [Child 27495] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:41:00 INFO - [Child 27495] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:41:00 INFO - nsStringStats
02:41:00 INFO - => mAllocCount: 25888
02:41:00 INFO - => mReallocCount: 832
02:41:00 INFO - => mFreeCount: 25888
02:41:00 INFO - => mShareCount: 12231
02:41:00 INFO - => mAdoptCount: 2174
02:41:00 INFO - => mAdoptFreeCount: 2174
02:41:00 INFO - => Process ID: 27495, Thread ID: 2966784320
02:41:03 INFO - ++DOCSHELL 0xa3a0dc00 == 1 [pid = 27542] [id = 1]
02:41:03 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=27542 error="No such file or directory"
02:41:03 INFO - ++DOMWINDOW == 1 (0xa3a96000) [pid = 27542] [serial = 1] [outer = (nil)]
02:41:04 INFO - ++DOMWINDOW == 2 (0x9e083c00) [pid = 27542] [serial = 2] [outer = 0xa3a96000]
02:41:06 INFO - Completed ShutdownLeaks collections in process 27193
02:41:08 INFO - Completed ShutdownLeaks collections in process 27542
02:41:09 INFO - --DOCSHELL 0x943f0c00 == 3 [pid = 27193] [id = 7]
02:41:09 INFO - --DOCSHELL 0x9be45c00 == 2 [pid = 27193] [id = 1]
02:41:09 INFO - [Child 27542] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:41:09 INFO - --DOCSHELL 0xa3a0dc00 == 0 [pid = 27542] [id = 1]
02:41:10 INFO - --DOMWINDOW == 1 (0xa3a96000) [pid = 27542] [serial = 1] [outer = (nil)] [url = about:blank]
02:41:10 INFO - --DOMWINDOW == 0 (0x9e083c00) [pid = 27542] [serial = 2] [outer = (nil)] [url = about:blank]
02:41:10 INFO - [Child 27542] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:41:10 INFO - nsStringStats
02:41:10 INFO - => mAllocCount: 25780
02:41:10 INFO - => mReallocCount: 832
02:41:10 INFO - => mFreeCount: 25780
02:41:10 INFO - => mShareCount: 12236
02:41:10 INFO - => mAdoptCount: 2265
02:41:10 INFO - => mAdoptFreeCount: 2265
02:41:10 INFO - => Process ID: 27542, Thread ID: 2966157632
02:41:10 INFO - --DOCSHELL 0x94d25000 == 1 [pid = 27193] [id = 3]
02:41:10 INFO - --DOCSHELL 0x98f4a800 == 0 [pid = 27193] [id = 2]
02:41:13 INFO - [Parent 27193] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:41:13 INFO - [Parent 27193] WARNING: 'NS_FAILED(RemovePermissionChangeObserver())', file /builds/slave/ash-lx-d-000000000000000000000/build/src/dom/notification/Notification.cpp, line 674
02:41:16 INFO - --DOMWINDOW == 7 (0x9919ec00) [pid = 27193] [serial = 4] [outer = (nil)] [url = about:blank]
02:41:16 INFO - --DOMWINDOW == 6 (0x943f3400) [pid = 27193] [serial = 15] [outer = (nil)] [url = chrome://mochikit/content/browser-harness.xul]
02:41:16 INFO - --DOMWINDOW == 5 (0x98f4ac00) [pid = 27193] [serial = 3] [outer = (nil)] [url = chrome://browser/content/browser.xul]
02:41:16 INFO - --DOMWINDOW == 4 (0x943f3c00) [pid = 27193] [serial = 16] [outer = (nil)] [url = about:blank]
02:41:16 INFO - --DOMWINDOW == 3 (0x94d25400) [pid = 27193] [serial = 6] [outer = (nil)] [url = about:blank]
02:41:16 INFO - --DOMWINDOW == 2 (0x94f88400) [pid = 27193] [serial = 28] [outer = (nil)] [url = about:blank]
02:41:16 INFO - --DOMWINDOW == 1 (0x9be46000) [pid = 27193] [serial = 1] [outer = (nil)] [url = resource://gre-resources/hiddenWindow.html]
02:41:16 INFO - --DOMWINDOW == 0 (0x98ac4000) [pid = 27193] [serial = 5] [outer = (nil)] [url = resource://gre-resources/hiddenWindow.html]
02:41:16 INFO - [Parent 27193] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:41:16 INFO - nsStringStats
02:41:16 INFO - => mAllocCount: 258865
02:41:16 INFO - => mReallocCount: 13983
02:41:16 INFO - => mFreeCount: 258865
02:41:16 INFO - => mShareCount: 167758
02:41:16 INFO - => mAdoptCount: 11786
02:41:16 INFO - => mAdoptFreeCount: 11786
02:41:16 INFO - => Process ID: 27193, Thread ID: 3074369280
02:41:16 INFO - TEST-INFO | Main app process: exit 0
02:41:16 INFO - runtests.py | Application ran for: 0:02:17.825663
02:41:16 INFO - zombiecheck | Reading PID log: /tmp/tmpps0IBgpidlog
02:41:16 INFO - ==> process 27193 launched child process 27213
02:41:16 INFO - ==> process 27193 launched child process 27244
02:41:16 INFO - ==> process 27193 launched child process 27279
02:41:16 INFO - ==> process 27193 launched child process 27286
02:41:16 INFO - ==> process 27193 launched child process 27327
02:41:16 INFO - ==> process 27193 launched child process 27349
02:41:16 INFO - ==> process 27193 launched child process 27356
02:41:16 INFO - ==> process 27193 launched child process 27400
02:41:16 INFO - ==> process 27193 launched child process 27407
02:41:16 INFO - ==> process 27193 launched child process 27448
02:41:16 INFO - ==> process 27193 launched child process 27455
02:41:16 INFO - ==> process 27193 launched child process 27495
02:41:16 INFO - ==> process 27193 launched child process 27502
02:41:16 INFO - ==> process 27193 launched child process 27542
02:41:16 INFO - zombiecheck | Checking for orphan process with PID: 27213
02:41:16 INFO - zombiecheck | Checking for orphan process with PID: 27244
02:41:16 INFO - zombiecheck | Checking for orphan process with PID: 27279
02:41:16 INFO - zombiecheck | Checking for orphan process with PID: 27286
02:41:16 INFO - zombiecheck | Checking for orphan process with PID: 27327
02:41:16 INFO - zombiecheck | Checking for orphan process with PID: 27349
02:41:16 INFO - zombiecheck | Checking for orphan process with PID: 27356
02:41:16 INFO - zombiecheck | Checking for orphan process with PID: 27400
02:41:16 INFO - zombiecheck | Checking for orphan process with PID: 27407
02:41:16 INFO - zombiecheck | Checking for orphan process with PID: 27448
02:41:16 INFO - zombiecheck | Checking for orphan process with PID: 27455
02:41:16 INFO - zombiecheck | Checking for orphan process with PID: 27495
02:41:16 INFO - zombiecheck | Checking for orphan process with PID: 27502
02:41:16 INFO - zombiecheck | Checking for orphan process with PID: 27542
02:41:16 INFO - Stopping web server
02:41:16 INFO - Stopping web socket server
02:41:16 INFO - Stopping ssltunnel
02:41:16 INFO - TEST-INFO | leakcheck | default process: leak threshold set at 0 bytes
02:41:16 INFO - TEST-INFO | leakcheck | plugin process: leak threshold set at 0 bytes
02:41:16 INFO - TEST-INFO | leakcheck | tab process: leak threshold set at 10000 bytes
02:41:16 INFO - TEST-INFO | leakcheck | geckomediaplugin process: leak threshold set at 20000 bytes
02:41:16 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 27400
02:41:16 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
02:41:16 INFO - | | Per-Inst Leaked| Total Rem|
02:41:16 INFO - 0 |TOTAL | 24 0| 81075 0|
02:41:16 INFO - nsTraceRefcnt::DumpStatistics: 522 entries
02:41:16 INFO - TEST-PASS | leakcheck | tab process: no leaks detected!
02:41:16 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 27349
02:41:16 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
02:41:16 INFO - | | Per-Inst Leaked| Total Rem|
02:41:16 INFO - 0 |TOTAL | 24 0| 84945 0|
02:41:16 INFO - nsTraceRefcnt::DumpStatistics: 525 entries
02:41:16 INFO - TEST-PASS | leakcheck | tab process: no leaks detected!
02:41:16 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 27356
02:41:16 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
02:41:16 INFO - | | Per-Inst Leaked| Total Rem|
02:41:16 INFO - 0 |TOTAL | 20 0| 231173 0|
02:41:16 INFO - nsTraceRefcnt::DumpStatistics: 726 entries
02:41:16 INFO - TEST-PASS | leakcheck | tab process: no leaks detected!
02:41:16 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 27279
02:41:16 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
02:41:16 INFO - | | Per-Inst Leaked| Total Rem|
02:41:16 INFO - 0 |TOTAL | 24 0| 81986 0|
02:41:16 INFO - nsTraceRefcnt::DumpStatistics: 525 entries
02:41:16 INFO - TEST-PASS | leakcheck | tab process: no leaks detected!
02:41:16 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 27244
02:41:16 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
02:41:16 INFO - | | Per-Inst Leaked| Total Rem|
02:41:16 INFO - 0 |TOTAL | 24 0| 98275 0|
02:41:16 INFO - nsTraceRefcnt::DumpStatistics: 663 entries
02:41:16 INFO - TEST-PASS | leakcheck | tab process: no leaks detected!
02:41:16 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 27286
02:41:16 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
02:41:16 INFO - | | Per-Inst Leaked| Total Rem|
02:41:16 INFO - 0 |TOTAL | 22 0| 177639 0|
02:41:16 INFO - nsTraceRefcnt::DumpStatistics: 704 entries
02:41:16 INFO - TEST-PASS | leakcheck | tab process: no leaks detected!
02:41:16 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 27495
02:41:16 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
02:41:16 INFO - | | Per-Inst Leaked| Total Rem|
02:41:16 INFO - 0 |TOTAL | 24 0| 84596 0|
02:41:16 INFO - nsTraceRefcnt::DumpStatistics: 526 entries
02:41:16 INFO - TEST-PASS | leakcheck | tab process: no leaks detected!
02:41:16 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 27542
02:41:16 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
02:41:16 INFO - | | Per-Inst Leaked| Total Rem|
02:41:16 INFO - 0 |TOTAL | 24 0| 79975 0|
02:41:16 INFO - nsTraceRefcnt::DumpStatistics: 525 entries
02:41:16 INFO - TEST-PASS | leakcheck | tab process: no leaks detected!
02:41:16 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, default process 27193
02:41:16 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
02:41:16 INFO - | | Per-Inst Leaked| Total Rem|
02:41:16 INFO - 0 |TOTAL | 18 0| 7748731 0|
02:41:16 INFO - nsTraceRefcnt::DumpStatistics: 1430 entries
02:41:16 INFO - TEST-PASS | leakcheck | default process: no leaks detected!
02:41:16 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 27502
02:41:16 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
02:41:16 INFO - | | Per-Inst Leaked| Total Rem|
02:41:16 INFO - 0 |TOTAL | 21 0| 191165 0|
02:41:16 INFO - nsTraceRefcnt::DumpStatistics: 698 entries
02:41:16 INFO - TEST-PASS | leakcheck | tab process: no leaks detected!
02:41:16 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 27448
02:41:16 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
02:41:16 INFO - | | Per-Inst Leaked| Total Rem|
02:41:16 INFO - 0 |TOTAL | 24 0| 81240 0|
02:41:16 INFO - nsTraceRefcnt::DumpStatistics: 522 entries
02:41:16 INFO - TEST-PASS | leakcheck | tab process: no leaks detected!
02:41:16 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 27327
02:41:16 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
02:41:16 INFO - | | Per-Inst Leaked| Total Rem|
02:41:16 INFO - 0 |TOTAL | 24 0| 77803 0|
02:41:16 INFO - nsTraceRefcnt::DumpStatistics: 522 entries
02:41:16 INFO - TEST-PASS | leakcheck | tab process: no leaks detected!
02:41:16 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 27407
02:41:16 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
02:41:16 INFO - | | Per-Inst Leaked| Total Rem|
02:41:16 INFO - 0 |TOTAL | 22 0| 139760 0|
02:41:16 INFO - nsTraceRefcnt::DumpStatistics: 695 entries
02:41:16 INFO - TEST-PASS | leakcheck | tab process: no leaks detected!
02:41:16 INFO - == BloatView: ALL (cumulative) LEAK AND BLOAT STATISTICS, tab process 27455
02:41:16 INFO - |<----------------Class--------------->|<-----Bytes------>|<----Objects---->|
02:41:16 INFO - | | Per-Inst Leaked| Total Rem|
02:41:16 INFO - 0 |TOTAL | 22 0| 148518 0|
02:41:16 INFO - nsTraceRefcnt::DumpStatistics: 731 entries
02:41:16 INFO - TEST-PASS | leakcheck | tab process: no leaks detected!
02:41:16 INFO - runtests.py | Running tests: end.
02:41:16 INFO - 1551 INFO checking window state
02:41:16 INFO - 1552 INFO TEST-START | Shutdown
02:41:16 INFO - 1553 INFO Browser Chrome Test Summary
02:41:16 INFO - 1554 INFO Passed: 158
02:41:16 INFO - 1555 INFO Failed: 0
02:41:16 INFO - 1556 INFO Todo: 0
02:41:16 INFO - 1557 INFO Mode: e10s
02:41:16 INFO - 1558 INFO *** End BrowserChrome Test Results ***
02:41:16 INFO - dir: devtools/client/scratchpad/test
02:41:17 INFO - Setting pipeline to PAUSED ...
02:41:17 INFO - Pipeline is PREROLLING ...
02:41:17 INFO - Pipeline is PREROLLED ...
02:41:17 INFO - Setting pipeline to PLAYING ...
02:41:17 INFO - New clock: GstSystemClock
02:41:17 INFO - Got EOS from element "pipeline0".
02:41:17 INFO - Execution ended after 32665815 ns.
02:41:17 INFO - Setting pipeline to PAUSED ...
02:41:17 INFO - Setting pipeline to READY ...
02:41:17 INFO - Setting pipeline to NULL ...
02:41:17 INFO - Freeing pipeline ...
02:41:17 INFO - mozprofile.addons WARNING | Could not install /builds/slave/test/build/tests/mochitest/extensions/mozscreenshots: [Errno 2] No such file or directory: '/builds/slave/test/build/tests/mochitest/extensions/mozscreenshots/install.rdf'
02:41:19 INFO - pk12util: PKCS12 IMPORT SUCCESSFUL
02:41:20 INFO - MochitestServer : launching [u'/builds/slave/test/build/tests/bin/xpcshell', '-g', '/builds/slave/test/build/application/firefox', '-v', '170', '-f', '/builds/slave/test/build/tests/bin/components/httpd.js', '-e', "const _PROFILE_PATH = '/tmp/tmpgABcHD.mozrunner'; const _SERVER_PORT = '8888'; const _SERVER_ADDR = '127.0.0.1'; const _TEST_PREFIX = undefined; const _DISPLAY_RESULTS = false;", '-f', '/builds/slave/test/build/tests/mochitest/server.js']
02:41:20 INFO - runtests.py | Server pid: 27592
02:41:20 INFO - runtests.py | Websocket server pid: 27609
02:41:21 INFO - Couldn't convert chrome URL: chrome://branding/locale/brand.properties
02:41:21 INFO - Couldn't convert chrome URL: chrome://branding/locale/brand.properties
02:41:21 INFO - [27592] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012: file /builds/slave/ash-lx-d-000000000000000000000/build/src/netwerk/base/nsIOService.cpp, line 795
02:41:21 INFO - [27592] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012: file /builds/slave/ash-lx-d-000000000000000000000/build/src/netwerk/base/nsNetUtilInlines.h, line 180
02:41:21 INFO - [27592] WARNING: Could not get the program name for a cubeb stream.: 'NS_SUCCEEDED(rv)', file /builds/slave/ash-lx-d-000000000000000000000/build/src/dom/media/CubebUtils.cpp, line 189
02:41:21 INFO - runtests.py | SSL tunnel pid: 27612
02:41:21 INFO - runtests.py | Running with e10s: True
02:41:21 INFO - runtests.py | Running tests: start.
02:41:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox -marionette -foreground -profile /tmp/tmpgABcHD.mozrunner
02:41:22 INFO - runtests.py | Application pid: 27619
02:41:22 INFO - TEST-INFO | started process Main app process
02:41:22 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks.log
02:41:26 INFO - ATTENTION: default value of option force_s3tc_enable overridden by environment.
02:41:26 INFO - [27619] WARNING: GLX_swap_control unsupported, ASAP mode may still block on buffer swaps.: file /builds/slave/ash-lx-d-000000000000000000000/build/src/gfx/gl/GLContextProviderGLX.cpp, line 273
02:41:26 INFO - [27619] WARNING: SGI_video_sync unsupported. Falling back to software vsync.: file /builds/slave/ash-lx-d-000000000000000000000/build/src/gfx/thebes/gfxPlatformGtk.cpp, line 894
02:41:26 INFO - ++DOCSHELL 0x9be45c00 == 1 [pid = 27619] [id = 1]
02:41:26 INFO - ++DOMWINDOW == 1 (0x9be46000) [pid = 27619] [serial = 1] [outer = (nil)]
02:41:26 INFO - ++DOMWINDOW == 2 (0x9be46800) [pid = 27619] [serial = 2] [outer = 0x9be46000]
02:41:27 INFO - 1476092487725 Marionette DEBUG Marionette enabled via command-line flag
02:41:28 INFO - 1476092488175 Marionette INFO Listening on port 2828
02:41:28 INFO - ++DOCSHELL 0x98f4b800 == 2 [pid = 27619] [id = 2]
02:41:28 INFO - ++DOMWINDOW == 3 (0x98f4bc00) [pid = 27619] [serial = 3] [outer = (nil)]
02:41:28 INFO - ++DOMWINDOW == 4 (0x9919ac00) [pid = 27619] [serial = 4] [outer = 0x98f4bc00]
02:41:28 INFO - LoadPlugin() /tmp/tmpgABcHD.mozrunner/plugins/libnptest.so returned 98def740
02:41:28 INFO - LoadPlugin() /tmp/tmpgABcHD.mozrunner/plugins/libnpthirdtest.so returned 98def940
02:41:28 INFO - LoadPlugin() /tmp/tmpgABcHD.mozrunner/plugins/libnptestjava.so returned 98def9a0
02:41:28 INFO - LoadPlugin() /tmp/tmpgABcHD.mozrunner/plugins/libnpctrltest.so returned 98defae0
02:41:28 INFO - LoadPlugin() /tmp/tmpgABcHD.mozrunner/plugins/libnpsecondtest.so returned 98df66a0
02:41:28 INFO - LoadPlugin() /tmp/tmpgABcHD.mozrunner/plugins/libnpswftest.so returned 98df6700
02:41:28 INFO - LoadPlugin() /usr/lib/mozilla/plugins/librhythmbox-itms-detection-plugin.so returned 98df68a0
02:41:28 INFO - LoadPlugin() /usr/lib/mozilla/plugins/libtotem-narrowspace-plugin.so returned b7189c40
02:41:28 INFO - LoadPlugin() /usr/lib/mozilla/plugins/libtotem-cone-plugin.so returned 98ac80a0
02:41:28 INFO - LoadPlugin() /usr/lib/mozilla/plugins/libtotem-gmp-plugin.so returned 98ac8b40
02:41:28 INFO - LoadPlugin() /usr/lib/mozilla/plugins/libtotem-mully-plugin.so returned 98acc620
02:41:28 INFO - ++DOMWINDOW == 5 (0x98ac2400) [pid = 27619] [serial = 5] [outer = 0x9be46000]
02:41:28 INFO - 1476092488883 Marionette DEBUG Accepted connection conn0 from 127.0.0.1:57552
02:41:28 INFO - 1476092488971 Marionette DEBUG Accepted connection conn1 from 127.0.0.1:57553
02:41:28 INFO - 1476092488981 Marionette DEBUG Closed connection conn0
02:41:29 INFO - 1476092489152 Marionette DEBUG Accepted connection conn2 from 127.0.0.1:57554
02:41:29 INFO - 1476092489161 Marionette DEBUG Closed connection conn1
02:41:29 INFO - 1476092489242 Marionette TRACE conn2 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
02:41:29 INFO - 1476092489288 Marionette CONFIG Changing capabilities: {"browserName":"firefox","browserVersion":"52.0a1","platformName":"linux","platformVersion":"3.2.0-76-generic-pae","specificationLevel":0,"raisesAccessibilityExceptions":false,"rotatable":false,"acceptSslCerts":false,"takesElementScreenshot":true,"takesScreenshot":true,"proxy":{},"platform":"LINUX","XULappId":"{ec8030f7-c20a-464f-9b0e-13a3a9e97384}","appBuildId":"20161010002018","processId":27619,"version":"52.0a1"}
02:41:30 INFO - [27619] WARNING: attempt to modify an immutable nsStandardURL: file /builds/slave/ash-lx-d-000000000000000000000/build/src/netwerk/base/nsStandardURL.cpp, line 1558
02:41:30 INFO - [27619] WARNING: attempt to modify an immutable nsStandardURL: file /builds/slave/ash-lx-d-000000000000000000000/build/src/netwerk/base/nsStandardURL.cpp, line 1558
02:41:30 INFO - [27619] WARNING: Failed to retarget HTML data delivery to the parser thread.: file /builds/slave/ash-lx-d-000000000000000000000/build/src/parser/html/nsHtml5StreamParser.cpp, line 970
02:41:31 INFO - ++DOCSHELL 0x94540c00 == 3 [pid = 27619] [id = 3]
02:41:31 INFO - ++DOMWINDOW == 6 (0x94541000) [pid = 27619] [serial = 6] [outer = (nil)]
02:41:32 INFO - ++DOCSHELL 0x93e7a800 == 4 [pid = 27619] [id = 4]
02:41:32 INFO - ++DOMWINDOW == 7 (0x93e7ac00) [pid = 27619] [serial = 7] [outer = (nil)]
02:41:32 INFO - ++DOMWINDOW == 8 (0x93aa0800) [pid = 27619] [serial = 8] [outer = 0x93e7ac00]
02:41:32 INFO - [Parent 27619] WARNING: OpenGL-accelerated layers are not supported on this system: file /builds/slave/ash-lx-d-000000000000000000000/build/src/gfx/thebes/gfxPlatform.cpp, line 2443
02:41:32 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid27672.log
02:41:33 INFO - ++DOMWINDOW == 9 (0x93be7800) [pid = 27619] [serial = 9] [outer = 0x94541000]
02:41:33 INFO - [Child 27672] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:41:36 INFO - ++DOCSHELL 0xa4e83400 == 1 [pid = 27672] [id = 1]
02:41:36 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=27672 error="No such file or directory"
02:41:36 INFO - ++DOMWINDOW == 1 (0xa4e8d800) [pid = 27672] [serial = 1] [outer = (nil)]
02:41:37 INFO - ++DOMWINDOW == 2 (0x9e4c9000) [pid = 27672] [serial = 2] [outer = 0xa4e8d800]
02:41:38 INFO - 1476092498909 Marionette TRACE conn2 <- [1,1,null,{"sessionId":"ddb5da81-43d8-4254-8307-b079d667abaf","capabilities":{"browserName":"firefox","browserVersion":"52.0a1","platformName":"linux","platformVersion":"3.2.0-76-generic-pae","specificationLevel":0,"raisesAccessibilityExceptions":false,"rotatable":false,"acceptSslCerts":false,"takesElementScreenshot":true,"takesScreenshot":true,"proxy":{},"platform":"LINUX","XULappId":"{ec8030f7-c20a-464f-9b0e-13a3a9e97384}","appBuildId":"20161010002018","processId":27619,"version":"52.0a1","command_id":1}}]
02:41:39 INFO - 1476092499063 Marionette TRACE conn2 -> [0,2,"getContext",null]
02:41:39 INFO - 1476092499075 Marionette TRACE conn2 <- [1,2,null,{"value":"content"}]
02:41:39 INFO - 1476092499219 Marionette TRACE conn2 -> [0,3,"setContext",{"value":"chrome"}]
02:41:39 INFO - 1476092499235 Marionette TRACE conn2 <- [1,3,null,{}]
02:41:39 INFO - 1476092499387 Marionette TRACE conn2 -> [0,4,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":true,"script":"\n let fileUtils = Components.utils.import(\"resource://gre/modules/FileUtils.jsm\");\n let FileUtils = fileUtils.FileUtils;\n Components.utils.import(\"resource://gre/modules/AddonManager.jsm\");\n let listener = {\n onInstallEnded: function(install, addon) {\n marionetteScriptFinished([addon.id, 0]);\n },\n\n onInstallFailed: function(install) {\n marionetteScriptFinished([null, install.error]);\n },\n\n onInstalled: function(addon) {\n AddonManager.removeAddonListener(listener);\n marionetteScriptFinished([addon.id, 0]);\n }\n }\n\n let file = new FileUtils.File(arguments[0]);\n let temp = arguments[1];\n\n if (!temp) {\n AddonManager.getInstallForFile(file, function(aInstall) {\n if (aInstall.error != 0) {\n marionetteScriptFinished([null, aInstall.error]);\n }\n aInstall.addListener(listener);\n aInstall.install();\n });\n } else {\n AddonManager.addAddonListener(listener);\n AddonManager.installTemporaryAddon(file);\n }\n ","newSandbox":true,"line":90,"args":["/builds/slave/test/build/tests/mochitest/extensions/specialpowers",true],"filename":"addons.py"}]
02:41:39 INFO - ++DOMWINDOW == 3 (0x9d2a5c00) [pid = 27672] [serial = 3] [outer = 0xa4e8d800]
02:41:39 INFO - 1476092499910 Marionette TRACE conn2 <- [1,4,null,{"value":["special-powers@mozilla.org",0]}]
02:41:40 INFO - 1476092500297 Marionette TRACE conn2 -> [0,5,"setContext",{"value":"content"}]
02:41:40 INFO - 1476092500304 Marionette TRACE conn2 <- [1,5,null,{}]
02:41:40 INFO - 1476092500326 Marionette TRACE conn2 -> [0,6,"getContext",null]
02:41:40 INFO - 1476092500335 Marionette TRACE conn2 <- [1,6,null,{"value":"content"}]
02:41:40 INFO - 1476092500384 Marionette TRACE conn2 -> [0,7,"setContext",{"value":"chrome"}]
02:41:40 INFO - 1476092500393 Marionette TRACE conn2 <- [1,7,null,{}]
02:41:40 INFO - 1476092500459 Marionette TRACE conn2 -> [0,8,"executeAsyncScript",{"scriptTimeout":null,"sandbox":"default","debug_script":true,"script":"\n let fileUtils = Components.utils.import(\"resource://gre/modules/FileUtils.jsm\");\n let FileUtils = fileUtils.FileUtils;\n Components.utils.import(\"resource://gre/modules/AddonManager.jsm\");\n let listener = {\n onInstallEnded: function(install, addon) {\n marionetteScriptFinished([addon.id, 0]);\n },\n\n onInstallFailed: function(install) {\n marionetteScriptFinished([null, install.error]);\n },\n\n onInstalled: function(addon) {\n AddonManager.removeAddonListener(listener);\n marionetteScriptFinished([addon.id, 0]);\n }\n }\n\n let file = new FileUtils.File(arguments[0]);\n let temp = arguments[1];\n\n if (!temp) {\n AddonManager.getInstallForFile(file, function(aInstall) {\n if (aInstall.error != 0) {\n marionetteScriptFinished([null, aInstall.error]);\n }\n aInstall.addListener(listener);\n aInstall.install();\n });\n } else {\n AddonManager.addAddonListener(listener);\n AddonManager.installTemporaryAddon(file);\n }\n ","newSandbox":true,"line":90,"args":["/builds/slave/test/build/tests/mochitest/mochijar",true],"filename":"addons.py"}]
02:41:40 INFO - 1476092500758 Marionette TRACE conn2 <- [1,8,null,{"value":["mochikit@mozilla.org",0]}]
02:41:40 INFO - ++DOCSHELL 0xa08cfc00 == 5 [pid = 27619] [id = 5]
02:41:40 INFO - ++DOMWINDOW == 10 (0xa1486c00) [pid = 27619] [serial = 10] [outer = (nil)]
02:41:40 INFO - ++DOMWINDOW == 11 (0xa148bc00) [pid = 27619] [serial = 11] [outer = 0xa1486c00]
02:41:41 INFO - 1476092501010 Marionette TRACE conn2 -> [0,9,"setContext",{"value":"content"}]
02:41:41 INFO - 1476092501017 Marionette TRACE conn2 <- [1,9,null,{}]
02:41:41 INFO - ++DOMWINDOW == 12 (0xa2a72000) [pid = 27619] [serial = 12] [outer = 0xa1486c00]
02:41:41 INFO - ++DOCSHELL 0x8fe10800 == 6 [pid = 27619] [id = 6]
02:41:41 INFO - ++DOMWINDOW == 13 (0x8fe11400) [pid = 27619] [serial = 13] [outer = (nil)]
02:41:41 INFO - ++DOMWINDOW == 14 (0xa0468c00) [pid = 27619] [serial = 14] [outer = 0x8fe11400]
02:41:41 INFO - [Parent 27619] WARNING: Could not get disk status from nsIDiskSpaceWatcher: file /builds/slave/ash-lx-d-000000000000000000000/build/src/uriloader/prefetch/nsOfflineCacheUpdateService.cpp, line 283
02:41:41 INFO - 1476092501367 Marionette TRACE conn2 -> [0,10,"getContext",null]
02:41:41 INFO - 1476092501373 Marionette TRACE conn2 <- [1,10,null,{"value":"content"}]
02:41:41 INFO - 1476092501513 Marionette TRACE conn2 -> [0,11,"setContext",{"value":"chrome"}]
02:41:41 INFO - 1476092501524 Marionette TRACE conn2 <- [1,11,null,{}]
02:41:41 INFO - 1476092501682 Marionette TRACE conn2 -> [0,12,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":["browser-chrome","about:blank","browser-chrome","about:blank","browser-chrome","about:blank","browser-chrome","about:blank","browser-chrome","about:blank"],"filename":"runtests.py","script":"/* This Source Code Form is subject to the terms of the Mozilla Public\n * License, v. 2.0. If a copy of the MPL was not distributed with this\n * file, You can obtain one at http://mozilla.org/MPL/2.0/. */\n\nconst flavor = __webDriverArguments[0]\nconst url = __webDriverArguments[1]\n\nlet wm = Cc[\"@mozilla.org/appshell/window-mediator;1\"]\n .getService(Ci.nsIWindowMediator);\nlet win = wm.getMostRecentWindow(\"navigator:browser\");\n\n// mochikit's bootstrap.js has set up a listener for this event. It's\n// used so bootstrap.js knows which flavor and url to load.\nlet ev = new CustomEvent('mochitest-load', {'detail': [flavor, url]});\nwin.dispatchEvent(ev);\n","sandbox":"default","line":1552}]
02:41:41 INFO - 1476092501846 Marionette TRACE conn2 <- [1,12,null,{"value":null}]
02:41:41 INFO - ++DOMWINDOW == 4 (0x9d0b8400) [pid = 27672] [serial = 4] [outer = 0xa4e8d800]
02:41:42 INFO - 1476092502271 Marionette TRACE conn2 -> [0,13,"setContext",{"value":"content"}]
02:41:42 INFO - 1476092502275 Marionette TRACE conn2 <- [1,13,null,{}]
02:41:42 INFO - ++DOCSHELL 0x91c81400 == 7 [pid = 27619] [id = 7]
02:41:42 INFO - ++DOMWINDOW == 15 (0x91c82800) [pid = 27619] [serial = 15] [outer = (nil)]
02:41:42 INFO - ++DOMWINDOW == 16 (0x93becc00) [pid = 27619] [serial = 16] [outer = 0x91c82800]
02:41:42 INFO - 1476092502546 Marionette TRACE conn2 -> [0,14,"deleteSession",null]
02:41:42 INFO - 1476092502567 Marionette TRACE conn2 <- [1,14,null,{}]
02:41:42 INFO - 1476092502680 Marionette DEBUG Closed connection conn2
02:41:44 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid27707.log
02:41:44 INFO - ++DOCSHELL 0x947ae000 == 8 [pid = 27619] [id = 8]
02:41:44 INFO - ++DOMWINDOW == 17 (0x94fdb000) [pid = 27619] [serial = 17] [outer = (nil)]
02:41:44 INFO - ++DOMWINDOW == 18 (0x96b7c000) [pid = 27619] [serial = 18] [outer = 0x94fdb000]
02:41:45 INFO - 1559 INFO TEST-START | devtools/client/scratchpad/test/browser_scratchpad_autocomplete.js
02:41:45 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid27714.log
02:41:45 INFO - --DOCSHELL 0x93e7a800 == 7 [pid = 27619] [id = 4]
02:41:45 INFO - ++DOMWINDOW == 19 (0x93661000) [pid = 27619] [serial = 19] [outer = 0x94fdb000]
02:41:46 INFO - [Child 27672] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:41:46 INFO - --DOCSHELL 0xa4e83400 == 0 [pid = 27672] [id = 1]
02:41:47 INFO - [Child 27707] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:41:47 INFO - [Parent 27619] WARNING: GetDefaultCharsetForLocale: need to add multi locale support: file /builds/slave/ash-lx-d-000000000000000000000/build/src/intl/locale/unix/nsUNIXCharset.cpp, line 98
02:41:47 INFO - [Child 27714] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:41:48 INFO - --DOMWINDOW == 3 (0xa4e8d800) [pid = 27672] [serial = 1] [outer = (nil)] [url = about:blank]
02:41:48 INFO - --DOMWINDOW == 2 (0x9e4c9000) [pid = 27672] [serial = 2] [outer = (nil)] [url = about:blank]
02:41:48 INFO - --DOMWINDOW == 1 (0x9d2a5c00) [pid = 27672] [serial = 3] [outer = (nil)] [url = about:blank]
02:41:48 INFO - --DOMWINDOW == 0 (0x9d0b8400) [pid = 27672] [serial = 4] [outer = (nil)] [url = about:blank]
02:41:48 INFO - [Child 27672] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:41:48 INFO - nsStringStats
02:41:48 INFO - => mAllocCount: 27302
02:41:48 INFO - => mReallocCount: 901
02:41:48 INFO - => mFreeCount: 27302
02:41:48 INFO - => mShareCount: 13779
02:41:48 INFO - => mAdoptCount: 2260
02:41:48 INFO - => mAdoptFreeCount: 2260
02:41:48 INFO - => Process ID: 27672, Thread ID: 2966133056
02:41:50 INFO - ++DOCSHELL 0xa3a0dc00 == 1 [pid = 27714] [id = 1]
02:41:50 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 27707] [id = 1]
02:41:50 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=27714 error="No such file or directory"
02:41:50 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=27707 error="No such file or directory"
02:41:50 INFO - ++DOMWINDOW == 1 (0xa3a8cc00) [pid = 27714] [serial = 1] [outer = (nil)]
02:41:50 INFO - ++DOMWINDOW == 1 (0xa3a8f000) [pid = 27707] [serial = 1] [outer = (nil)]
02:41:50 INFO - ++DOMWINDOW == 2 (0x9e084c00) [pid = 27714] [serial = 2] [outer = 0xa3a8cc00]
02:41:50 INFO - ++DOMWINDOW == 2 (0x9e084c00) [pid = 27707] [serial = 2] [outer = 0xa3a8f000]
02:41:52 INFO - ++DOCSHELL 0x91251400 == 8 [pid = 27619] [id = 9]
02:41:52 INFO - ++DOMWINDOW == 20 (0x93beb000) [pid = 27619] [serial = 20] [outer = (nil)]
02:41:52 INFO - ++DOMWINDOW == 21 (0x9472c400) [pid = 27619] [serial = 21] [outer = 0x93beb000]
02:41:53 INFO - ++DOCSHELL 0x8e836000 == 9 [pid = 27619] [id = 10]
02:41:53 INFO - ++DOMWINDOW == 22 (0x8e836400) [pid = 27619] [serial = 22] [outer = (nil)]
02:41:54 INFO - ++DOMWINDOW == 23 (0x8e83c800) [pid = 27619] [serial = 23] [outer = 0x8e836400]
02:41:58 INFO - --DOCSHELL 0x91251400 == 8 [pid = 27619] [id = 9]
02:41:58 INFO - MEMORY STAT vsizeMaxContiguous not supported in this build configuration.
02:41:58 INFO - MEMORY STAT | vsize 775MB | residentFast 240MB | heapAllocated 98MB
02:41:58 INFO - 1560 INFO TEST-OK | devtools/client/scratchpad/test/browser_scratchpad_autocomplete.js | took 13302ms
02:41:58 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid27755.log
02:41:59 INFO - 1561 INFO TEST-START | devtools/client/scratchpad/test/browser_scratchpad_browser_last_window_closing.js
02:41:59 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid27762.log
02:41:59 INFO - [Child 27714] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:41:59 INFO - [Child 27707] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:42:00 INFO - --DOCSHELL 0xa3a0dc00 == 0 [pid = 27714] [id = 1]
02:42:00 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 27707] [id = 1]
02:42:01 INFO - [Child 27755] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:42:01 INFO - --DOMWINDOW == 1 (0xa3a8cc00) [pid = 27714] [serial = 1] [outer = (nil)] [url = data:text/html;charset=utf8,test%20scratchpad%20autocomplete]
02:42:01 INFO - --DOMWINDOW == 0 (0x9e084c00) [pid = 27714] [serial = 2] [outer = (nil)] [url = about:blank]
02:42:01 INFO - [Child 27762] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:42:01 INFO - --DOMWINDOW == 1 (0xa3a8f000) [pid = 27707] [serial = 1] [outer = (nil)] [url = about:blank]
02:42:01 INFO - --DOMWINDOW == 0 (0x9e084c00) [pid = 27707] [serial = 2] [outer = (nil)] [url = about:blank]
02:42:01 INFO - [Child 27714] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:42:02 INFO - nsStringStats
02:42:02 INFO - => mAllocCount: 26841
02:42:02 INFO - => mReallocCount: 908
02:42:02 INFO - => mFreeCount: 26841
02:42:02 INFO - => mShareCount: 13186
02:42:02 INFO - => mAdoptCount: 2292
02:42:02 INFO - => mAdoptFreeCount: 2292
02:42:02 INFO - => Process ID: 27714, Thread ID: 2966403392
02:42:02 INFO - [Child 27707] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:42:02 INFO - nsStringStats
02:42:02 INFO - => mAllocCount: 25728
02:42:02 INFO - => mReallocCount: 826
02:42:02 INFO - => mFreeCount: 25728
02:42:02 INFO - => mShareCount: 12160
02:42:02 INFO - => mAdoptCount: 2160
02:42:02 INFO - => mAdoptFreeCount: 2160
02:42:02 INFO - => Process ID: 27707, Thread ID: 2966116672
02:42:03 INFO - --DOCSHELL 0x8e836000 == 7 [pid = 27619] [id = 10]
02:42:03 INFO - --DOMWINDOW == 22 (0x93e7ac00) [pid = 27619] [serial = 7] [outer = (nil)] [url = about:blank]
02:42:04 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 27755] [id = 1]
02:42:04 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 27762] [id = 1]
02:42:04 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=27755 error="No such file or directory"
02:42:04 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=27762 error="No such file or directory"
02:42:04 INFO - ++DOMWINDOW == 1 (0xa3a97400) [pid = 27755] [serial = 1] [outer = (nil)]
02:42:04 INFO - ++DOMWINDOW == 1 (0xa3a95400) [pid = 27762] [serial = 1] [outer = (nil)]
02:42:05 INFO - ++DOMWINDOW == 2 (0x9e085c00) [pid = 27755] [serial = 2] [outer = 0xa3a97400]
02:42:05 INFO - ++DOMWINDOW == 2 (0x9e086c00) [pid = 27762] [serial = 2] [outer = 0xa3a95400]
02:42:07 INFO - ++DOCSHELL 0x86a04400 == 8 [pid = 27619] [id = 11]
02:42:07 INFO - ++DOMWINDOW == 23 (0x86a60c00) [pid = 27619] [serial = 24] [outer = (nil)]
02:42:07 INFO - ++DOMWINDOW == 24 (0x86a66400) [pid = 27619] [serial = 25] [outer = 0x86a60c00]
02:42:07 INFO - ++DOCSHELL 0x86a67000 == 9 [pid = 27619] [id = 12]
02:42:07 INFO - ++DOMWINDOW == 25 (0x86a69400) [pid = 27619] [serial = 26] [outer = (nil)]
02:42:08 INFO - ++DOMWINDOW == 26 (0x86ae7c00) [pid = 27619] [serial = 27] [outer = 0x86a69400]
02:42:11 INFO - --DOCSHELL 0x86a04400 == 8 [pid = 27619] [id = 11]
02:42:12 INFO - MEMORY STAT | vsize 792MB | residentFast 235MB | heapAllocated 91MB
02:42:12 INFO - 1562 INFO TEST-OK | devtools/client/scratchpad/test/browser_scratchpad_browser_last_window_closing.js | took 12997ms
02:42:12 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid27802.log
02:42:12 INFO - 1563 INFO TEST-START | devtools/client/scratchpad/test/browser_scratchpad_chrome_context_pref.js
02:42:12 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid27809.log
02:42:13 INFO - [Child 27762] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:42:13 INFO - [Child 27755] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:42:13 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 27762] [id = 1]
02:42:14 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 27755] [id = 1]
02:42:14 INFO - [Child 27802] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:42:15 INFO - --DOMWINDOW == 1 (0xa3a95400) [pid = 27762] [serial = 1] [outer = (nil)] [url = data:text/html;charset=utf8,
test%20browser%20last%20window%20closing
]
02:42:15 INFO - --DOMWINDOW == 0 (0x9e086c00) [pid = 27762] [serial = 2] [outer = (nil)] [url = about:blank]
02:42:15 INFO - --DOMWINDOW == 1 (0xa3a97400) [pid = 27755] [serial = 1] [outer = (nil)] [url = about:blank]
02:42:15 INFO - --DOMWINDOW == 0 (0x9e085c00) [pid = 27755] [serial = 2] [outer = (nil)] [url = about:blank]
02:42:15 INFO - [Child 27762] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:42:15 INFO - nsStringStats
02:42:15 INFO - => mAllocCount: 26879
02:42:15 INFO - => mReallocCount: 908
02:42:15 INFO - => mFreeCount: 26879
02:42:15 INFO - => mShareCount: 13193
02:42:15 INFO - => mAdoptCount: 2293
02:42:15 INFO - => mAdoptFreeCount: 2293
02:42:15 INFO - => Process ID: 27762, Thread ID: 2966481216
02:42:15 INFO - [Child 27755] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:42:15 INFO - nsStringStats
02:42:15 INFO - => mAllocCount: 25730
02:42:15 INFO - => mReallocCount: 826
02:42:15 INFO - => mFreeCount: 25730
02:42:15 INFO - => mShareCount: 12160
02:42:15 INFO - => mAdoptCount: 2161
02:42:15 INFO - => mAdoptFreeCount: 2161
02:42:15 INFO - => Process ID: 27755, Thread ID: 2966427968
02:42:15 INFO - [Child 27809] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:42:17 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 27802] [id = 1]
02:42:17 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=27802 error="No such file or directory"
02:42:17 INFO - ++DOMWINDOW == 1 (0xa3a92000) [pid = 27802] [serial = 1] [outer = (nil)]
02:42:17 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 27809] [id = 1]
02:42:17 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=27809 error="No such file or directory"
02:42:17 INFO - ++DOMWINDOW == 1 (0xa3a95000) [pid = 27809] [serial = 1] [outer = (nil)]
02:42:17 INFO - ++DOMWINDOW == 2 (0x9e085c00) [pid = 27802] [serial = 2] [outer = 0xa3a92000]
02:42:18 INFO - ++DOMWINDOW == 2 (0x9e086c00) [pid = 27809] [serial = 2] [outer = 0xa3a95000]
02:42:20 INFO - ++DOCSHELL 0x8d2a8000 == 9 [pid = 27619] [id = 13]
02:42:20 INFO - ++DOMWINDOW == 27 (0x8d2a8400) [pid = 27619] [serial = 28] [outer = (nil)]
02:42:20 INFO - ++DOMWINDOW == 28 (0x8d2a8c00) [pid = 27619] [serial = 29] [outer = 0x8d2a8400]
02:42:20 INFO - ++DOCSHELL 0x8d10e400 == 10 [pid = 27619] [id = 14]
02:42:20 INFO - ++DOMWINDOW == 29 (0x8d2a4400) [pid = 27619] [serial = 30] [outer = (nil)]
02:42:20 INFO - ++DOMWINDOW == 30 (0x8e839000) [pid = 27619] [serial = 31] [outer = 0x8d2a4400]
02:42:22 INFO - --DOCSHELL 0x8d2a8000 == 9 [pid = 27619] [id = 13]
02:42:23 INFO - MEMORY STAT | vsize 795MB | residentFast 241MB | heapAllocated 95MB
02:42:23 INFO - 1564 INFO TEST-OK | devtools/client/scratchpad/test/browser_scratchpad_chrome_context_pref.js | took 10749ms
02:42:23 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid27849.log
02:42:23 INFO - 1565 INFO TEST-START | devtools/client/scratchpad/test/browser_scratchpad_close_toolbox.js
02:42:24 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid27856.log
02:42:24 INFO - [Child 27809] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:42:24 INFO - [Child 27802] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:42:25 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 27809] [id = 1]
02:42:25 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 27802] [id = 1]
02:42:26 INFO - [Child 27849] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:42:26 INFO - --DOMWINDOW == 1 (0xa3a95000) [pid = 27809] [serial = 1] [outer = (nil)] [url = data:text/html,Scratchpad%20test%20for%20bug%20646070%20-%20chrome%20context%20preference]
02:42:26 INFO - --DOMWINDOW == 0 (0x9e086c00) [pid = 27809] [serial = 2] [outer = (nil)] [url = about:blank]
02:42:26 INFO - --DOMWINDOW == 1 (0xa3a92000) [pid = 27802] [serial = 1] [outer = (nil)] [url = about:blank]
02:42:26 INFO - [Child 27856] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:42:26 INFO - --DOMWINDOW == 0 (0x9e085c00) [pid = 27802] [serial = 2] [outer = (nil)] [url = about:blank]
02:42:26 INFO - [Child 27809] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:42:26 INFO - nsStringStats
02:42:26 INFO - => mAllocCount: 26986
02:42:26 INFO - => mReallocCount: 909
02:42:26 INFO - => mFreeCount: 26986
02:42:26 INFO - => mShareCount: 13208
02:42:26 INFO - => mAdoptCount: 2298
02:42:26 INFO - => mAdoptFreeCount: 2298
02:42:26 INFO - => Process ID: 27809, Thread ID: 2966698304
02:42:26 INFO - [Child 27802] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:42:26 INFO - nsStringStats
02:42:26 INFO - => mAllocCount: 25730
02:42:26 INFO - => mReallocCount: 826
02:42:26 INFO - => mFreeCount: 25730
02:42:26 INFO - => mShareCount: 12160
02:42:26 INFO - => mAdoptCount: 2161
02:42:26 INFO - => mAdoptFreeCount: 2161
02:42:26 INFO - => Process ID: 27802, Thread ID: 2966423872
02:42:28 INFO - ++DOCSHELL 0xa3b0e000 == 1 [pid = 27849] [id = 1]
02:42:29 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=27849 error="No such file or directory"
02:42:29 INFO - ++DOMWINDOW == 1 (0xa3b95c00) [pid = 27849] [serial = 1] [outer = (nil)]
02:42:29 INFO - ++DOMWINDOW == 2 (0x9e140c00) [pid = 27849] [serial = 2] [outer = 0xa3b95c00]
02:42:29 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 27856] [id = 1]
02:42:29 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=27856 error="No such file or directory"
02:42:29 INFO - ++DOMWINDOW == 1 (0xa3a96000) [pid = 27856] [serial = 1] [outer = (nil)]
02:42:30 INFO - ++DOMWINDOW == 2 (0x9e087c00) [pid = 27856] [serial = 2] [outer = 0xa3a96000]
02:42:32 INFO - ++DOCSHELL 0x86c02400 == 10 [pid = 27619] [id = 15]
02:42:32 INFO - ++DOMWINDOW == 31 (0x86c03400) [pid = 27619] [serial = 32] [outer = (nil)]
02:42:32 INFO - ++DOMWINDOW == 32 (0x86c03c00) [pid = 27619] [serial = 33] [outer = 0x86c03400]
02:42:32 INFO - ++DOCSHELL 0x86ae2800 == 11 [pid = 27619] [id = 16]
02:42:32 INFO - ++DOMWINDOW == 33 (0x86c04400) [pid = 27619] [serial = 34] [outer = (nil)]
02:42:32 INFO - ++DOMWINDOW == 34 (0x86a0d800) [pid = 27619] [serial = 35] [outer = 0x86c04400]
02:42:36 INFO - --DOMWINDOW == 33 (0x9be46800) [pid = 27619] [serial = 2] [outer = (nil)] [url = about:blank]
02:42:36 INFO - --DOMWINDOW == 32 (0x93aa0800) [pid = 27619] [serial = 8] [outer = (nil)] [url = about:blank]
02:42:36 INFO - --DOMWINDOW == 31 (0xa148bc00) [pid = 27619] [serial = 11] [outer = (nil)] [url = about:blank]
02:42:36 INFO - --DOMWINDOW == 30 (0x96b7c000) [pid = 27619] [serial = 18] [outer = (nil)] [url = about:blank]
02:42:37 INFO - ++DOCSHELL 0x863de000 == 12 [pid = 27619] [id = 17]
02:42:37 INFO - ++DOMWINDOW == 31 (0x863e3800) [pid = 27619] [serial = 36] [outer = (nil)]
02:42:37 INFO - ++DOMWINDOW == 32 (0x863e4000) [pid = 27619] [serial = 37] [outer = 0x863e3800]
02:42:38 INFO - ++DOMWINDOW == 33 (0x86a5f400) [pid = 27619] [serial = 38] [outer = 0x863e3800]
02:42:39 INFO - ++DOCSHELL 0x8d4e3800 == 13 [pid = 27619] [id = 18]
02:42:39 INFO - ++DOMWINDOW == 34 (0x8d4e3c00) [pid = 27619] [serial = 39] [outer = (nil)]
02:42:39 INFO - ++DOMWINDOW == 35 (0x8d4e4800) [pid = 27619] [serial = 40] [outer = 0x8d4e3c00]
02:42:39 INFO - [GFX3-]: Surface width or height <= 0!
02:42:39 INFO - [GFX3-]: Surface width or height <= 0!
02:42:39 INFO - [GFX3-]: Surface width or height <= 0!
02:42:39 INFO - [GFX3-]: Surface width or height <= 0!
02:42:43 INFO - [Parent 27619] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004001: file /builds/slave/ash-lx-d-000000000000000000000/build/src/dom/xul/nsXULPrototypeCache.cpp, line 326
02:42:43 INFO - [GFX3-]: Surface width or height <= 0!
02:42:43 INFO - [GFX3-]: Surface width or height <= 0!
02:42:46 INFO - --DOMWINDOW == 34 (0x93beb000) [pid = 27619] [serial = 20] [outer = (nil)] [url = chrome://devtools/content/scratchpad/scratchpad.xul]
02:42:46 INFO - --DOMWINDOW == 33 (0x8e836400) [pid = 27619] [serial = 22] [outer = (nil)] [url = data:text/html;charset=utf8,%20%20%20%20%20%20%20%20%20%20]
02:42:48 INFO - --DOCSHELL 0x8d10e400 == 12 [pid = 27619] [id = 14]
02:42:48 INFO - --DOCSHELL 0x86a67000 == 11 [pid = 27619] [id = 12]
02:42:48 INFO - --DOCSHELL 0x863de000 == 10 [pid = 27619] [id = 17]
02:42:48 INFO - --DOCSHELL 0x8d4e3800 == 9 [pid = 27619] [id = 18]
02:42:48 INFO - --DOMWINDOW == 32 (0x8e83c800) [pid = 27619] [serial = 23] [outer = (nil)] [url = data:text/html;charset=utf8,%20%20%20%20%20%20%20%20%20%20]
02:42:48 INFO - --DOMWINDOW == 31 (0x9472c400) [pid = 27619] [serial = 21] [outer = (nil)] [url = about:blank]
02:42:49 INFO - --DOMWINDOW == 30 (0x8d2a4400) [pid = 27619] [serial = 30] [outer = (nil)] [url = data:text/html;charset=utf8,%20%20%20%20%20%20%20%20%20%20]
02:42:49 INFO - --DOMWINDOW == 29 (0x86a69400) [pid = 27619] [serial = 26] [outer = (nil)] [url = data:text/html;charset=utf8,%20%20%20%20%20%20%20%20%20%20]
02:42:49 INFO - --DOMWINDOW == 28 (0x8d2a8400) [pid = 27619] [serial = 28] [outer = (nil)] [url = chrome://devtools/content/scratchpad/scratchpad.xul]
02:42:49 INFO - --DOMWINDOW == 27 (0x86a60c00) [pid = 27619] [serial = 24] [outer = (nil)] [url = chrome://devtools/content/scratchpad/scratchpad.xul]
02:42:49 INFO - --DOCSHELL 0x86ae2800 == 8 [pid = 27619] [id = 16]
02:42:49 INFO - --DOCSHELL 0x86c02400 == 7 [pid = 27619] [id = 15]
02:42:50 INFO - MEMORY STAT | vsize 818MB | residentFast 288MB | heapAllocated 122MB
02:42:50 INFO - 1566 INFO TEST-OK | devtools/client/scratchpad/test/browser_scratchpad_close_toolbox.js | took 26228ms
02:42:50 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid27899.log
02:42:50 INFO - 1567 INFO TEST-START | devtools/client/scratchpad/test/browser_scratchpad_contexts.js
02:42:51 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid27906.log
02:42:51 INFO - [Child 27856] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:42:51 INFO - [Child 27856] WARNING: Finishing incremental GC in progress during CC: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/base/nsCycleCollector.cpp, line 3538
02:42:51 INFO - [Child 27849] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:42:51 INFO - --DOCSHELL 0xa3b0e000 == 0 [pid = 27849] [id = 1]
02:42:52 INFO - [Child 27856] WARNING: 'NS_FAILED(DebuggerOnGCRunnable::Enqueue(aContext, aDesc)) && reason != JS::gcreason::SHUTDOWN_CC && reason != JS::gcreason::DESTROY_RUNTIME && reason != JS::gcreason::XPCONNECT_SHUTDOWN', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/base/CycleCollectedJSContext.cpp, line 827
02:42:52 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 27856] [id = 1]
02:42:53 INFO - --DOMWINDOW == 1 (0x9e140c00) [pid = 27849] [serial = 2] [outer = (nil)] [url = about:blank]
02:42:53 INFO - --DOMWINDOW == 0 (0xa3b95c00) [pid = 27849] [serial = 1] [outer = (nil)] [url = about:blank]
02:42:53 INFO - [Child 27899] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:42:53 INFO - [Child 27849] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:42:53 INFO - nsStringStats
02:42:53 INFO - => mAllocCount: 25732
02:42:53 INFO - => mReallocCount: 826
02:42:53 INFO - => mFreeCount: 25732
02:42:53 INFO - => mShareCount: 12160
02:42:53 INFO - => mAdoptCount: 2238
02:42:53 INFO - => mAdoptFreeCount: 2238
02:42:53 INFO - => Process ID: 27849, Thread ID: 2966817088
02:42:53 INFO - [Child 27906] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:42:53 INFO - [Child 27856] WARNING: 'NS_FAILED(DebuggerOnGCRunnable::Enqueue(aContext, aDesc)) && reason != JS::gcreason::SHUTDOWN_CC && reason != JS::gcreason::DESTROY_RUNTIME && reason != JS::gcreason::XPCONNECT_SHUTDOWN', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/base/CycleCollectedJSContext.cpp, line 827
02:42:54 INFO - [Child 27856] WARNING: 'NS_FAILED(DebuggerOnGCRunnable::Enqueue(aContext, aDesc)) && reason != JS::gcreason::SHUTDOWN_CC && reason != JS::gcreason::DESTROY_RUNTIME && reason != JS::gcreason::XPCONNECT_SHUTDOWN', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/base/CycleCollectedJSContext.cpp, line 827
02:42:56 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 27899] [id = 1]
02:42:56 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=27899 error="No such file or directory"
02:42:56 INFO - ++DOMWINDOW == 1 (0xa3a94000) [pid = 27899] [serial = 1] [outer = (nil)]
02:42:56 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 27906] [id = 1]
02:42:56 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=27906 error="No such file or directory"
02:42:57 INFO - ++DOMWINDOW == 1 (0xa3a96000) [pid = 27906] [serial = 1] [outer = (nil)]
02:42:57 INFO - ++DOMWINDOW == 2 (0x9e088c00) [pid = 27899] [serial = 2] [outer = 0xa3a94000]
02:42:57 INFO - --DOMWINDOW == 1 (0x9e087c00) [pid = 27856] [serial = 2] [outer = (nil)] [url = about:blank]
02:42:57 INFO - --DOMWINDOW == 0 (0xa3a96000) [pid = 27856] [serial = 1] [outer = (nil)] [url = data:text/html;charset=utf8,test%20closing%20toolbox%20and%20then%20reusing%20scratchpad]
02:42:57 INFO - ++DOMWINDOW == 2 (0x9e088c00) [pid = 27906] [serial = 2] [outer = 0xa3a96000]
02:42:57 INFO - [Child 27856] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:42:57 INFO - nsStringStats
02:42:57 INFO - => mAllocCount: 39445
02:42:57 INFO - => mReallocCount: 1347
02:42:57 INFO - => mFreeCount: 39445
02:42:57 INFO - => mShareCount: 18533
02:42:57 INFO - => mAdoptCount: 3523
02:42:57 INFO - => mAdoptFreeCount: 3523
02:42:57 INFO - => Process ID: 27856, Thread ID: 2966260032
02:43:00 INFO - ++DOCSHELL 0x83ee4400 == 8 [pid = 27619] [id = 19]
02:43:00 INFO - ++DOMWINDOW == 28 (0x83ee5c00) [pid = 27619] [serial = 41] [outer = (nil)]
02:43:00 INFO - ++DOMWINDOW == 29 (0x83ee9400) [pid = 27619] [serial = 42] [outer = 0x83ee5c00]
02:43:00 INFO - ++DOCSHELL 0x83f6a800 == 9 [pid = 27619] [id = 20]
02:43:00 INFO - ++DOMWINDOW == 30 (0x84745800) [pid = 27619] [serial = 43] [outer = (nil)]
02:43:00 INFO - ++DOMWINDOW == 31 (0x86318400) [pid = 27619] [serial = 44] [outer = 0x84745800]
02:43:05 INFO - [Parent 27619] WARNING: We should have hit the document element...: file /builds/slave/ash-lx-d-000000000000000000000/build/src/layout/xul/BoxObject.cpp, line 175
02:43:07 INFO - [Parent 27619] WARNING: We should have hit the document element...: file /builds/slave/ash-lx-d-000000000000000000000/build/src/layout/xul/BoxObject.cpp, line 175
02:43:07 INFO - --DOCSHELL 0x83ee4400 == 8 [pid = 27619] [id = 19]
02:43:08 INFO - MEMORY STAT | vsize 847MB | residentFast 290MB | heapAllocated 124MB
02:43:08 INFO - 1568 INFO TEST-OK | devtools/client/scratchpad/test/browser_scratchpad_contexts.js | took 17812ms
02:43:08 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid27946.log
02:43:09 INFO - 1569 INFO TEST-START | devtools/client/scratchpad/test/browser_scratchpad_disable_view_menu_items.js
02:43:09 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid27953.log
02:43:09 INFO - [Child 27906] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:43:10 INFO - [Child 27899] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:43:10 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 27906] [id = 1]
02:43:10 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 27899] [id = 1]
02:43:11 INFO - [Child 27946] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:43:11 INFO - --DOMWINDOW == 1 (0x9e088c00) [pid = 27899] [serial = 2] [outer = (nil)] [url = about:blank]
02:43:11 INFO - --DOMWINDOW == 0 (0xa3a94000) [pid = 27899] [serial = 1] [outer = (nil)] [url = about:blank]
02:43:11 INFO - [Child 27899] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:43:12 INFO - nsStringStats
02:43:12 INFO - => mAllocCount: 25832
02:43:12 INFO - => mReallocCount: 832
02:43:12 INFO - => mFreeCount: 25832
02:43:12 INFO - => mShareCount: 12233
02:43:12 INFO - => mAdoptCount: 2171
02:43:12 INFO - => mAdoptFreeCount: 2171
02:43:12 INFO - => Process ID: 27899, Thread ID: 2966063424
02:43:12 INFO - [Child 27953] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:43:12 INFO - --DOMWINDOW == 1 (0xa3a96000) [pid = 27906] [serial = 1] [outer = (nil)] [url = data:text/html,test%20context%20switch%20in%20Scratchpad]
02:43:12 INFO - --DOMWINDOW == 0 (0x9e088c00) [pid = 27906] [serial = 2] [outer = (nil)] [url = about:blank]
02:43:12 INFO - [Child 27906] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:43:12 INFO - nsStringStats
02:43:12 INFO - => mAllocCount: 29246
02:43:12 INFO - => mReallocCount: 1002
02:43:12 INFO - => mFreeCount: 29246
02:43:12 INFO - => mShareCount: 14203
02:43:12 INFO - => mAdoptCount: 2657
02:43:12 INFO - => mAdoptFreeCount: 2657
02:43:12 INFO - => Process ID: 27906, Thread ID: 2966542656
02:43:14 INFO - ++DOCSHELL 0xa3b0e000 == 1 [pid = 27946] [id = 1]
02:43:14 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=27946 error="No such file or directory"
02:43:14 INFO - ++DOMWINDOW == 1 (0xa3b96c00) [pid = 27946] [serial = 1] [outer = (nil)]
02:43:14 INFO - ++DOCSHELL 0xa3b0e000 == 1 [pid = 27953] [id = 1]
02:43:14 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=27953 error="No such file or directory"
02:43:14 INFO - ++DOMWINDOW == 1 (0xa3b94c00) [pid = 27953] [serial = 1] [outer = (nil)]
02:43:14 INFO - ++DOMWINDOW == 2 (0x9e140c00) [pid = 27946] [serial = 2] [outer = 0xa3b96c00]
02:43:14 INFO - ++DOMWINDOW == 2 (0x9e146c00) [pid = 27953] [serial = 2] [outer = 0xa3b94c00]
02:43:16 INFO - ++DOCSHELL 0x83eeb000 == 9 [pid = 27619] [id = 21]
02:43:16 INFO - ++DOMWINDOW == 32 (0x84a98000) [pid = 27619] [serial = 45] [outer = (nil)]
02:43:16 INFO - ++DOMWINDOW == 33 (0x8631cc00) [pid = 27619] [serial = 46] [outer = 0x84a98000]
02:43:17 INFO - ++DOCSHELL 0x8e818400 == 10 [pid = 27619] [id = 22]
02:43:17 INFO - ++DOMWINDOW == 34 (0x8e819c00) [pid = 27619] [serial = 47] [outer = (nil)]
02:43:17 INFO - ++DOMWINDOW == 35 (0x8e840400) [pid = 27619] [serial = 48] [outer = 0x8e819c00]
02:43:39 INFO - --DOCSHELL 0x83eeb000 == 9 [pid = 27619] [id = 21]
02:43:40 INFO - MEMORY STAT | vsize 869MB | residentFast 306MB | heapAllocated 137MB
02:43:40 INFO - 1570 INFO TEST-OK | devtools/client/scratchpad/test/browser_scratchpad_disable_view_menu_items.js | took 30932ms
02:43:40 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid27993.log
02:43:40 INFO - 1571 INFO TEST-START | devtools/client/scratchpad/test/browser_scratchpad_display_non_error_exceptions.js
02:43:40 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid28000.log
02:43:41 INFO - [Child 27953] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:43:41 INFO - [Child 27946] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:43:41 INFO - --DOCSHELL 0xa3b0e000 == 0 [pid = 27953] [id = 1]
02:43:41 INFO - --DOCSHELL 0xa3b0e000 == 0 [pid = 27946] [id = 1]
02:43:42 INFO - [Child 27993] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:43:43 INFO - --DOMWINDOW == 1 (0x9e146c00) [pid = 27953] [serial = 2] [outer = (nil)] [url = about:blank]
02:43:43 INFO - --DOMWINDOW == 0 (0xa3b94c00) [pid = 27953] [serial = 1] [outer = (nil)] [url = data:text/html;charset=utf8,test%20if%20view%20menu%20items%20"Larger%20Font"%20and%20"Smaller%20Font"%20are%20enabled/disabled.]
02:43:43 INFO - --DOMWINDOW == 1 (0x9e140c00) [pid = 27946] [serial = 2] [outer = (nil)] [url = about:blank]
02:43:43 INFO - --DOMWINDOW == 0 (0xa3b96c00) [pid = 27946] [serial = 1] [outer = (nil)] [url = about:blank]
02:43:43 INFO - [Child 27953] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:43:43 INFO - nsStringStats
02:43:43 INFO - => mAllocCount: 27163
02:43:43 INFO - => mReallocCount: 914
02:43:43 INFO - => mFreeCount: 27163
02:43:43 INFO - => mShareCount: 13264
02:43:43 INFO - => mAdoptCount: 2379
02:43:43 INFO - => mAdoptFreeCount: 2379
02:43:43 INFO - => Process ID: 27953, Thread ID: 2966907200
02:43:43 INFO - [Child 28000] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:43:43 INFO - [Child 27946] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:43:43 INFO - nsStringStats
02:43:43 INFO - => mAllocCount: 26029
02:43:43 INFO - => mReallocCount: 832
02:43:43 INFO - => mFreeCount: 26029
02:43:43 INFO - => mShareCount: 12233
02:43:43 INFO - => mAdoptCount: 2246
02:43:43 INFO - => mAdoptFreeCount: 2246
02:43:43 INFO - => Process ID: 27946, Thread ID: 2966759744
02:43:45 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 27993] [id = 1]
02:43:45 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=27993 error="No such file or directory"
02:43:45 INFO - ++DOMWINDOW == 1 (0xa3a97400) [pid = 27993] [serial = 1] [outer = (nil)]
02:43:45 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 28000] [id = 1]
02:43:45 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=28000 error="No such file or directory"
02:43:45 INFO - ++DOMWINDOW == 1 (0xa3a95400) [pid = 28000] [serial = 1] [outer = (nil)]
02:43:45 INFO - ++DOMWINDOW == 2 (0x9e085c00) [pid = 27993] [serial = 2] [outer = 0xa3a97400]
02:43:45 INFO - ++DOMWINDOW == 2 (0x9e086c00) [pid = 28000] [serial = 2] [outer = 0xa3a95400]
02:43:47 INFO - ++DOCSHELL 0x81b01400 == 10 [pid = 27619] [id = 23]
02:43:47 INFO - ++DOMWINDOW == 36 (0x81b06c00) [pid = 27619] [serial = 49] [outer = (nil)]
02:43:47 INFO - ++DOMWINDOW == 37 (0x83361c00) [pid = 27619] [serial = 50] [outer = 0x81b06c00]
02:43:48 INFO - ++DOCSHELL 0x81b0b800 == 11 [pid = 27619] [id = 24]
02:43:48 INFO - ++DOMWINDOW == 38 (0x83360c00) [pid = 27619] [serial = 51] [outer = (nil)]
02:43:48 INFO - ++DOMWINDOW == 39 (0x83ed0400) [pid = 27619] [serial = 52] [outer = 0x83360c00]
02:43:54 INFO - --DOCSHELL 0x81b01400 == 10 [pid = 27619] [id = 23]
02:43:54 INFO - MEMORY STAT | vsize 875MB | residentFast 307MB | heapAllocated 135MB
02:43:54 INFO - 1572 INFO TEST-OK | devtools/client/scratchpad/test/browser_scratchpad_display_non_error_exceptions.js | took 14326ms
02:43:55 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid28041.log
02:43:55 INFO - 1573 INFO TEST-START | devtools/client/scratchpad/test/browser_scratchpad_display_outputs_errors.js
02:43:55 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid28048.log
02:43:56 INFO - [Child 28000] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:43:56 INFO - [Child 28000] WARNING: Finishing incremental GC in progress during CC: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/base/nsCycleCollector.cpp, line 3538
02:43:56 INFO - [Child 27993] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:43:56 INFO - [Child 27993] WARNING: Finishing incremental GC in progress during CC: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/base/nsCycleCollector.cpp, line 3538
02:43:56 INFO - [Child 27993] WARNING: 'NS_FAILED(DebuggerOnGCRunnable::Enqueue(aContext, aDesc)) && reason != JS::gcreason::SHUTDOWN_CC && reason != JS::gcreason::DESTROY_RUNTIME && reason != JS::gcreason::XPCONNECT_SHUTDOWN', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/base/CycleCollectedJSContext.cpp, line 827
02:43:56 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 27993] [id = 1]
02:43:56 INFO - [Child 28000] WARNING: 'NS_FAILED(DebuggerOnGCRunnable::Enqueue(aContext, aDesc)) && reason != JS::gcreason::SHUTDOWN_CC && reason != JS::gcreason::DESTROY_RUNTIME && reason != JS::gcreason::XPCONNECT_SHUTDOWN', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/base/CycleCollectedJSContext.cpp, line 827
02:43:56 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 28000] [id = 1]
02:43:57 INFO - [Child 28041] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:43:58 INFO - [Child 28048] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:43:58 INFO - --DOMWINDOW == 1 (0xa3a97400) [pid = 27993] [serial = 1] [outer = (nil)] [url = about:blank]
02:43:58 INFO - --DOMWINDOW == 0 (0x9e085c00) [pid = 27993] [serial = 2] [outer = (nil)] [url = about:blank]
02:43:58 INFO - [Child 27993] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:43:58 INFO - nsStringStats
02:43:58 INFO - => mAllocCount: 25852
02:43:58 INFO - => mReallocCount: 832
02:43:58 INFO - => mFreeCount: 25852
02:43:58 INFO - => mShareCount: 12233
02:43:58 INFO - => mAdoptCount: 2170
02:43:58 INFO - => mAdoptFreeCount: 2170
02:43:58 INFO - => Process ID: 27993, Thread ID: 2966735168
02:43:59 INFO - --DOMWINDOW == 1 (0xa3a95400) [pid = 28000] [serial = 1] [outer = (nil)] [url = data:text/html,%20test%20that%20exceptions%20are%20output%20as%20comments%20correctly%20in%20Scratchpad]
02:43:59 INFO - --DOMWINDOW == 0 (0x9e086c00) [pid = 28000] [serial = 2] [outer = (nil)] [url = about:blank]
02:43:59 INFO - [Child 28000] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:43:59 INFO - nsStringStats
02:43:59 INFO - => mAllocCount: 29416
02:43:59 INFO - => mReallocCount: 1007
02:43:59 INFO - => mFreeCount: 29416
02:43:59 INFO - => mShareCount: 14277
02:43:59 INFO - => mAdoptCount: 2652
02:43:59 INFO - => mAdoptFreeCount: 2652
02:43:59 INFO - => Process ID: 28000, Thread ID: 2966415680
02:44:00 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 28041] [id = 1]
02:44:00 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=28041 error="No such file or directory"
02:44:01 INFO - ++DOMWINDOW == 1 (0xa3a99000) [pid = 28041] [serial = 1] [outer = (nil)]
02:44:01 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 28048] [id = 1]
02:44:01 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=28048 error="No such file or directory"
02:44:01 INFO - ++DOMWINDOW == 1 (0xa3a95000) [pid = 28048] [serial = 1] [outer = (nil)]
02:44:01 INFO - ++DOMWINDOW == 2 (0x9e088c00) [pid = 28041] [serial = 2] [outer = 0xa3a99000]
02:44:01 INFO - ++DOMWINDOW == 2 (0x9e089c00) [pid = 28048] [serial = 2] [outer = 0xa3a95000]
02:44:03 INFO - ++DOCSHELL 0x83ee2000 == 11 [pid = 27619] [id = 25]
02:44:03 INFO - ++DOMWINDOW == 40 (0x83ee7400) [pid = 27619] [serial = 53] [outer = (nil)]
02:44:03 INFO - ++DOMWINDOW == 41 (0x83f69800) [pid = 27619] [serial = 54] [outer = 0x83ee7400]
02:44:04 INFO - ++DOCSHELL 0x83218000 == 12 [pid = 27619] [id = 26]
02:44:04 INFO - ++DOMWINDOW == 42 (0x83218400) [pid = 27619] [serial = 55] [outer = (nil)]
02:44:04 INFO - ++DOMWINDOW == 43 (0x8321c000) [pid = 27619] [serial = 56] [outer = 0x83218400]
02:44:09 INFO - --DOCSHELL 0x83ee2000 == 11 [pid = 27619] [id = 25]
02:44:10 INFO - MEMORY STAT | vsize 874MB | residentFast 311MB | heapAllocated 137MB
02:44:10 INFO - 1574 INFO TEST-OK | devtools/client/scratchpad/test/browser_scratchpad_display_outputs_errors.js | took 14780ms
02:44:10 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid28088.log
02:44:11 INFO - 1575 INFO TEST-START | devtools/client/scratchpad/test/browser_scratchpad_edit_ui_updates.js
02:44:11 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid28095.log
02:44:11 INFO - [Child 28048] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:44:11 INFO - [Child 28041] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:44:11 INFO - --DOCSHELL 0x83f6a800 == 10 [pid = 27619] [id = 20]
02:44:12 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 28041] [id = 1]
02:44:12 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 28048] [id = 1]
02:44:13 INFO - --DOCSHELL 0x8e818400 == 9 [pid = 27619] [id = 22]
02:44:13 INFO - [Child 28088] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:44:13 INFO - --DOMWINDOW == 1 (0xa3a99000) [pid = 28041] [serial = 1] [outer = (nil)] [url = about:blank]
02:44:13 INFO - --DOMWINDOW == 0 (0x9e088c00) [pid = 28041] [serial = 2] [outer = (nil)] [url = about:blank]
02:44:13 INFO - [Child 28041] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:44:13 INFO - nsStringStats
02:44:13 INFO - => mAllocCount: 25853
02:44:13 INFO - => mReallocCount: 832
02:44:13 INFO - => mFreeCount: 25853
02:44:13 INFO - => mShareCount: 12233
02:44:13 INFO - => mAdoptCount: 2169
02:44:13 INFO - => mAdoptFreeCount: 2169
02:44:13 INFO - => Process ID: 28041, Thread ID: 2966092096
02:44:13 INFO - [Child 28095] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:44:14 INFO - --DOMWINDOW == 1 (0xa3a95000) [pid = 28048] [serial = 1] [outer = (nil)] [url = data:text/html,
test%20that%20exceptions%20are%20output%20as%20comments%20for%20'display'%20and%20not%20sent%20to%20the%20console%20in%20Scratchpad]
02:44:14 INFO - --DOMWINDOW == 0 (0x9e089c00) [pid = 28048] [serial = 2] [outer = (nil)] [url = about:blank]
02:44:14 INFO - [Child 28048] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:44:14 INFO - nsStringStats
02:44:14 INFO - => mAllocCount: 29391
02:44:14 INFO - => mReallocCount: 1013
02:44:14 INFO - => mFreeCount: 29391
02:44:14 INFO - => mShareCount: 14285
02:44:14 INFO - => mAdoptCount: 2651
02:44:14 INFO - => mAdoptFreeCount: 2651
02:44:14 INFO - => Process ID: 28048, Thread ID: 2966899008
02:44:16 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 28088] [id = 1]
02:44:16 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=28088 error="No such file or directory"
02:44:16 INFO - ++DOMWINDOW == 1 (0xa3a97000) [pid = 28088] [serial = 1] [outer = (nil)]
02:44:16 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 28095] [id = 1]
02:44:16 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=28095 error="No such file or directory"
02:44:16 INFO - ++DOMWINDOW == 1 (0xa3a95000) [pid = 28095] [serial = 1] [outer = (nil)]
02:44:16 INFO - ++DOMWINDOW == 2 (0x9e086c00) [pid = 28088] [serial = 2] [outer = 0xa3a97000]
02:44:17 INFO - ++DOMWINDOW == 2 (0x9e086c00) [pid = 28095] [serial = 2] [outer = 0xa3a95000]
02:44:18 INFO - ++DOCSHELL 0x8024f800 == 10 [pid = 27619] [id = 27]
02:44:18 INFO - ++DOMWINDOW == 44 (0x80253c00) [pid = 27619] [serial = 57] [outer = (nil)]
02:44:18 INFO - ++DOMWINDOW == 45 (0x8025a800) [pid = 27619] [serial = 58] [outer = 0x80253c00]
02:44:19 INFO - ++DOCSHELL 0x8025a400 == 11 [pid = 27619] [id = 28]
02:44:19 INFO - ++DOMWINDOW == 46 (0x8025b400) [pid = 27619] [serial = 59] [outer = (nil)]
02:44:19 INFO - ++DOMWINDOW == 47 (0x81b09800) [pid = 27619] [serial = 60] [outer = 0x8025b400]
02:44:23 INFO - [Parent 27619] WARNING: We should have hit the document element...: file /builds/slave/ash-lx-d-000000000000000000000/build/src/layout/xul/BoxObject.cpp, line 175
02:44:24 INFO - --DOCSHELL 0x8024f800 == 10 [pid = 27619] [id = 27]
02:44:25 INFO - MEMORY STAT | vsize 959MB | residentFast 311MB | heapAllocated 130MB
02:44:25 INFO - 1576 INFO TEST-OK | devtools/client/scratchpad/test/browser_scratchpad_edit_ui_updates.js | took 14356ms
02:44:25 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid28136.log
02:44:25 INFO - 1577 INFO TEST-START | devtools/client/scratchpad/test/browser_scratchpad_eval_func.js
02:44:26 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid28143.log
02:44:26 INFO - [Child 28095] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:44:26 INFO - [Child 28088] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:44:27 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 28095] [id = 1]
02:44:27 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 28088] [id = 1]
02:44:28 INFO - [Child 28136] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:44:28 INFO - --DOMWINDOW == 1 (0xa3a95000) [pid = 28095] [serial = 1] [outer = (nil)] [url = data:text/html,test%20Edit%20menu%20updates%20Scratchpad%20-%20bug%20699130]
02:44:28 INFO - --DOMWINDOW == 0 (0x9e086c00) [pid = 28095] [serial = 2] [outer = (nil)] [url = about:blank]
02:44:28 INFO - [Child 28143] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:44:28 INFO - --DOMWINDOW == 1 (0xa3a97000) [pid = 28088] [serial = 1] [outer = (nil)] [url = about:blank]
02:44:28 INFO - --DOMWINDOW == 0 (0x9e086c00) [pid = 28088] [serial = 2] [outer = (nil)] [url = about:blank]
02:44:28 INFO - [Child 28095] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:44:28 INFO - nsStringStats
02:44:28 INFO - => mAllocCount: 27115
02:44:28 INFO - => mReallocCount: 915
02:44:28 INFO - => mFreeCount: 27115
02:44:28 INFO - => mShareCount: 13276
02:44:28 INFO - => mAdoptCount: 2305
02:44:28 INFO - => mAdoptFreeCount: 2305
02:44:28 INFO - => Process ID: 28095, Thread ID: 2966337856
02:44:29 INFO - [Child 28088] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:44:29 INFO - nsStringStats
02:44:29 INFO - => mAllocCount: 25857
02:44:29 INFO - => mReallocCount: 832
02:44:29 INFO - => mFreeCount: 25857
02:44:29 INFO - => mShareCount: 12233
02:44:29 INFO - => mAdoptCount: 2168
02:44:29 INFO - => mAdoptFreeCount: 2168
02:44:29 INFO - => Process ID: 28088, Thread ID: 2966550848
02:44:30 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 28136] [id = 1]
02:44:30 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=28136 error="No such file or directory"
02:44:31 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 28143] [id = 1]
02:44:31 INFO - ++DOMWINDOW == 1 (0xa3a93000) [pid = 28136] [serial = 1] [outer = (nil)]
02:44:31 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=28143 error="No such file or directory"
02:44:31 INFO - ++DOMWINDOW == 1 (0xa3a91000) [pid = 28143] [serial = 1] [outer = (nil)]
02:44:31 INFO - ++DOMWINDOW == 2 (0x9e085c00) [pid = 28136] [serial = 2] [outer = 0xa3a93000]
02:44:31 INFO - ++DOMWINDOW == 2 (0x9e086c00) [pid = 28143] [serial = 2] [outer = 0xa3a91000]
02:44:34 INFO - ++DOCSHELL 0x86d72400 == 11 [pid = 27619] [id = 29]
02:44:34 INFO - ++DOMWINDOW == 48 (0x86d74800) [pid = 27619] [serial = 61] [outer = (nil)]
02:44:34 INFO - ++DOMWINDOW == 49 (0x86d79c00) [pid = 27619] [serial = 62] [outer = 0x86d74800]
02:44:34 INFO - ++DOCSHELL 0x86d73000 == 12 [pid = 27619] [id = 30]
02:44:34 INFO - ++DOMWINDOW == 50 (0x86d73400) [pid = 27619] [serial = 63] [outer = (nil)]
02:44:34 INFO - ++DOMWINDOW == 51 (0x86e2ac00) [pid = 27619] [serial = 64] [outer = 0x86d73400]
02:44:39 INFO - --DOCSHELL 0x86d72400 == 11 [pid = 27619] [id = 29]
02:44:39 INFO - MEMORY STAT | vsize 979MB | residentFast 322MB | heapAllocated 138MB
02:44:39 INFO - 1578 INFO TEST-OK | devtools/client/scratchpad/test/browser_scratchpad_eval_func.js | took 13712ms
02:44:39 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid28186.log
02:44:40 INFO - 1579 INFO TEST-START | devtools/client/scratchpad/test/browser_scratchpad_execute_print.js
02:44:40 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid28193.log
02:44:40 INFO - [Child 28143] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:44:41 INFO - [Child 28136] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:44:41 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 28136] [id = 1]
02:44:42 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 28143] [id = 1]
02:44:42 INFO - [Child 28186] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:44:43 INFO - [Child 28193] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:44:43 INFO - --DOMWINDOW == 1 (0xa3a93000) [pid = 28136] [serial = 1] [outer = (nil)] [url = about:blank]
02:44:43 INFO - --DOMWINDOW == 0 (0x9e085c00) [pid = 28136] [serial = 2] [outer = (nil)] [url = about:blank]
02:44:43 INFO - [Child 28136] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:44:43 INFO - nsStringStats
02:44:43 INFO - => mAllocCount: 25859
02:44:43 INFO - => mReallocCount: 832
02:44:43 INFO - => mFreeCount: 25859
02:44:43 INFO - => mShareCount: 12233
02:44:43 INFO - => mAdoptCount: 2169
02:44:43 INFO - => mAdoptFreeCount: 2169
02:44:43 INFO - => Process ID: 28136, Thread ID: 2966473024
02:44:43 INFO - --DOMWINDOW == 1 (0xa3a91000) [pid = 28143] [serial = 1] [outer = (nil)] [url = data:text/html;charset=utf8,test%20Scratchpad%20eval%20function.]
02:44:43 INFO - --DOMWINDOW == 0 (0x9e086c00) [pid = 28143] [serial = 2] [outer = (nil)] [url = about:blank]
02:44:44 INFO - [Child 28143] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:44:44 INFO - nsStringStats
02:44:44 INFO - => mAllocCount: 29179
02:44:44 INFO - => mReallocCount: 999
02:44:44 INFO - => mFreeCount: 29179
02:44:44 INFO - => mShareCount: 14187
02:44:44 INFO - => mAdoptCount: 2643
02:44:44 INFO - => mAdoptFreeCount: 2643
02:44:44 INFO - => Process ID: 28143, Thread ID: 2966571328
02:44:45 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 28186] [id = 1]
02:44:45 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=28186 error="No such file or directory"
02:44:45 INFO - ++DOMWINDOW == 1 (0xa3a97000) [pid = 28186] [serial = 1] [outer = (nil)]
02:44:45 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 28193] [id = 1]
02:44:45 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=28193 error="No such file or directory"
02:44:45 INFO - ++DOMWINDOW == 1 (0xa3a95400) [pid = 28193] [serial = 1] [outer = (nil)]
02:44:46 INFO - ++DOMWINDOW == 2 (0x9e086c00) [pid = 28186] [serial = 2] [outer = 0xa3a97000]
02:44:46 INFO - ++DOMWINDOW == 2 (0x9e087c00) [pid = 28193] [serial = 2] [outer = 0xa3a95400]
02:44:48 INFO - ++DOCSHELL 0x86d67400 == 12 [pid = 27619] [id = 31]
02:44:48 INFO - ++DOMWINDOW == 52 (0x86d72400) [pid = 27619] [serial = 65] [outer = (nil)]
02:44:48 INFO - ++DOMWINDOW == 53 (0x86d79800) [pid = 27619] [serial = 66] [outer = 0x86d72400]
02:44:48 INFO - ++DOCSHELL 0x86c0b400 == 13 [pid = 27619] [id = 32]
02:44:48 INFO - ++DOMWINDOW == 54 (0x86c0b800) [pid = 27619] [serial = 67] [outer = (nil)]
02:44:49 INFO - ++DOMWINDOW == 55 (0x80254400) [pid = 27619] [serial = 68] [outer = 0x86c0b800]
02:44:49 INFO - --DOCSHELL 0x83218000 == 12 [pid = 27619] [id = 26]
02:44:49 INFO - --DOCSHELL 0x81b0b800 == 11 [pid = 27619] [id = 24]
02:44:54 INFO - --DOCSHELL 0x86d67400 == 10 [pid = 27619] [id = 31]
02:44:55 INFO - MEMORY STAT | vsize 993MB | residentFast 322MB | heapAllocated 139MB
02:44:55 INFO - 1580 INFO TEST-OK | devtools/client/scratchpad/test/browser_scratchpad_execute_print.js | took 14916ms
02:44:55 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid28233.log
02:44:55 INFO - 1581 INFO TEST-START | devtools/client/scratchpad/test/browser_scratchpad_falsy.js
02:44:55 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid28240.log
02:44:56 INFO - --DOMWINDOW == 54 (0x83360c00) [pid = 27619] [serial = 51] [outer = (nil)] [url = data:text/html;charset=utf8,%20%20
%20%20%20%20%20%20%20%20]
02:44:56 INFO - [Child 28193] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:44:56 INFO - [Child 28186] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:44:56 INFO - [Child 28186] WARNING: Finishing incremental GC in progress during CC: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/base/nsCycleCollector.cpp, line 3538
02:44:57 INFO - [Child 28186] WARNING: 'NS_FAILED(DebuggerOnGCRunnable::Enqueue(aContext, aDesc)) && reason != JS::gcreason::SHUTDOWN_CC && reason != JS::gcreason::DESTROY_RUNTIME && reason != JS::gcreason::XPCONNECT_SHUTDOWN', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/base/CycleCollectedJSContext.cpp, line 827
02:44:57 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 28186] [id = 1]
02:44:57 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 28193] [id = 1]
02:44:58 INFO - [Child 28233] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:44:58 INFO - [Child 28240] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:44:59 INFO - --DOMWINDOW == 1 (0xa3a97000) [pid = 28186] [serial = 1] [outer = (nil)] [url = about:blank]
02:44:59 INFO - --DOMWINDOW == 0 (0x9e086c00) [pid = 28186] [serial = 2] [outer = (nil)] [url = about:blank]
02:44:59 INFO - [Child 28186] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:44:59 INFO - nsStringStats
02:44:59 INFO - => mAllocCount: 25856
02:44:59 INFO - => mReallocCount: 832
02:44:59 INFO - => mFreeCount: 25856
02:44:59 INFO - => mShareCount: 12233
02:44:59 INFO - => mAdoptCount: 2169
02:44:59 INFO - => mAdoptFreeCount: 2169
02:44:59 INFO - => Process ID: 28186, Thread ID: 2966645056
02:44:59 INFO - --DOMWINDOW == 1 (0xa3a95400) [pid = 28193] [serial = 1] [outer = (nil)] [url = data:text/html,
test%20run()%20and%20display()%20in%20Scratchpad]
02:44:59 INFO - --DOMWINDOW == 0 (0x9e087c00) [pid = 28193] [serial = 2] [outer = (nil)] [url = about:blank]
02:45:00 INFO - [Child 28193] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:45:00 INFO - nsStringStats
02:45:00 INFO - => mAllocCount: 29309
02:45:00 INFO - => mReallocCount: 1002
02:45:00 INFO - => mFreeCount: 29309
02:45:00 INFO - => mShareCount: 14207
02:45:00 INFO - => mAdoptCount: 2648
02:45:00 INFO - => mAdoptFreeCount: 2648
02:45:00 INFO - => Process ID: 28193, Thread ID: 2966497600
02:45:03 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 28233] [id = 1]
02:45:03 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 28240] [id = 1]
02:45:03 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=28233 error="No such file or directory"
02:45:03 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=28240 error="No such file or directory"
02:45:03 INFO - ++DOMWINDOW == 1 (0xa3aa2000) [pid = 28233] [serial = 1] [outer = (nil)]
02:45:03 INFO - ++DOMWINDOW == 1 (0xa3aa0400) [pid = 28240] [serial = 1] [outer = (nil)]
02:45:03 INFO - ++DOMWINDOW == 2 (0x9e090c00) [pid = 28233] [serial = 2] [outer = 0xa3aa2000]
02:45:03 INFO - ++DOMWINDOW == 2 (0x9e092000) [pid = 28240] [serial = 2] [outer = 0xa3aa0400]
02:45:06 INFO - ++DOCSHELL 0x80445400 == 11 [pid = 27619] [id = 33]
02:45:06 INFO - ++DOMWINDOW == 55 (0x80449800) [pid = 27619] [serial = 69] [outer = (nil)]
02:45:06 INFO - ++DOMWINDOW == 56 (0x8044a000) [pid = 27619] [serial = 70] [outer = 0x80449800]
02:45:06 INFO - ++DOCSHELL 0x80446400 == 12 [pid = 27619] [id = 34]
02:45:06 INFO - ++DOMWINDOW == 57 (0x8044ac00) [pid = 27619] [serial = 71] [outer = (nil)]
02:45:06 INFO - ++DOMWINDOW == 58 (0x807f9000) [pid = 27619] [serial = 72] [outer = 0x8044ac00]
02:45:11 INFO - [Parent 27619] WARNING: We should have hit the document element...: file /builds/slave/ash-lx-d-000000000000000000000/build/src/layout/xul/BoxObject.cpp, line 175
02:45:13 INFO - --DOCSHELL 0x80445400 == 11 [pid = 27619] [id = 33]
02:45:14 INFO - MEMORY STAT | vsize 1018MB | residentFast 326MB | heapAllocated 138MB
02:45:14 INFO - 1582 INFO TEST-OK | devtools/client/scratchpad/test/browser_scratchpad_falsy.js | took 18481ms
02:45:14 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid28280.log
02:45:14 INFO - 1583 INFO TEST-START | devtools/client/scratchpad/test/browser_scratchpad_files.js
02:45:15 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid28287.log
02:45:15 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 28240] [id = 1]
02:45:15 INFO - [Child 28240] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:45:15 INFO - [Child 28233] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:45:16 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 28233] [id = 1]
02:45:17 INFO - [Child 28280] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:45:17 INFO - --DOMWINDOW == 1 (0x9e090c00) [pid = 28233] [serial = 2] [outer = (nil)] [url = about:blank]
02:45:17 INFO - --DOMWINDOW == 0 (0xa3aa2000) [pid = 28233] [serial = 1] [outer = (nil)] [url = about:blank]
02:45:17 INFO - [Child 28287] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80004005: file /builds/slave/ash-lx-d-000000000000000000000/build/src/toolkit/xre/nsXREDirProvider.cpp, line 1703
02:45:17 INFO - [Child 28233] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:45:17 INFO - nsStringStats
02:45:17 INFO - => mAllocCount: 25842
02:45:17 INFO - => mReallocCount: 832
02:45:17 INFO - => mFreeCount: 25842
02:45:17 INFO - => mShareCount: 12233
02:45:17 INFO - => mAdoptCount: 2170
02:45:17 INFO - => mAdoptFreeCount: 2170
02:45:17 INFO - => Process ID: 28233, Thread ID: 2966260032
02:45:18 INFO - --DOMWINDOW == 1 (0xa3aa0400) [pid = 28240] [serial = 1] [outer = (nil)] [url = data:text/html,
test%20falsy%20display()%20values%20in%20Scratchpad]
02:45:18 INFO - --DOMWINDOW == 0 (0x9e092000) [pid = 28240] [serial = 2] [outer = (nil)] [url = about:blank]
02:45:18 INFO - [Child 28240] WARNING: '!compMgr', file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/glue/nsComponentManagerUtils.cpp, line 63
02:45:18 INFO - nsStringStats
02:45:18 INFO - => mAllocCount: 29298
02:45:18 INFO - => mReallocCount: 1000
02:45:18 INFO - => mFreeCount: 29298
02:45:18 INFO - => mShareCount: 14206
02:45:18 INFO - => mAdoptCount: 2662
02:45:18 INFO - => mAdoptFreeCount: 2662
02:45:18 INFO - => Process ID: 28240, Thread ID: 2966202688
02:45:19 INFO - ++DOCSHELL 0xa3a0e000 == 1 [pid = 28280] [id = 1]
02:45:19 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=28280 error="No such file or directory"
02:45:19 INFO - ++DOMWINDOW == 1 (0xa3a97400) [pid = 28280] [serial = 1] [outer = (nil)]
02:45:19 INFO - ++DOCSHELL 0xa3b0e000 == 1 [pid = 28287] [id = 1]
02:45:19 INFO - Sandbox: SandboxBroker: denied op=1 rflags=5 perms=3 path=/usr/lib32/pango/1.6.0/module-files.d for pid=28287 error="No such file or directory"
02:45:20 INFO - ++DOMWINDOW == 1 (0xa3b94c00) [pid = 28287] [serial = 1] [outer = (nil)]
02:45:20 INFO - ++DOMWINDOW == 2 (0x9e085c00) [pid = 28280] [serial = 2] [outer = 0xa3a97400]
02:45:20 INFO - ++DOMWINDOW == 2 (0x9e146c00) [pid = 28287] [serial = 2] [outer = 0xa3b94c00]
02:45:22 INFO - ++DOCSHELL 0x833b2c00 == 12 [pid = 27619] [id = 35]
02:45:22 INFO - ++DOMWINDOW == 59 (0x86e36400) [pid = 27619] [serial = 73] [outer = (nil)]
02:45:22 INFO - ++DOMWINDOW == 60 (0xa2c23c00) [pid = 27619] [serial = 74] [outer = 0x86e36400]
02:45:22 INFO - ++DOCSHELL 0x81cf6000 == 13 [pid = 27619] [id = 36]
02:45:22 INFO - ++DOMWINDOW == 61 (0x81cf6400) [pid = 27619] [serial = 75] [outer = (nil)]
02:45:23 INFO - ++DOMWINDOW == 62 (0x81cf9c00) [pid = 27619] [serial = 76] [outer = 0x81cf6400]
02:45:26 INFO - --DOCSHELL 0x833b2c00 == 12 [pid = 27619] [id = 35]
02:45:27 INFO - MEMORY STAT | vsize 1032MB | residentFast 328MB | heapAllocated 144MB
02:45:27 INFO - 1584 INFO TEST-OK | devtools/client/scratchpad/test/browser_scratchpad_files.js | took 12126ms
02:45:27 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid28330.log
02:45:27 INFO - 1585 INFO TEST-START | devtools/client/scratchpad/test/browser_scratchpad_goto_line_ui.js
02:45:27 INFO - ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpgABcHD.mozrunner/runtests_leaks_tab_pid28337.log
02:45:28 INFO - [Child 28287] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:45:28 INFO - [Child 28280] WARNING: NS_ENSURE_TRUE(maybeContext) failed: file /builds/slave/ash-lx-d-000000000000000000000/build/src/xpcom/threads/nsThread.cpp, line 935
02:45:28 INFO - --DOCSHELL 0xa3b0e000 == 0 [pid = 28287] [id = 1]
02:45:28 INFO - --DOCSHELL 0xa3a0e000 == 0 [pid = 28280] [id = 1]
02:45:29 INFO - --DOCSHELL 0x8025a400 == 11 [pid = 27619] [id = 28]
02:45:29 INFO - --DOCSHELL 0x86c0b400 == 10 [pid = 27619] [id = 32]
02:45:29 INFO - --DOCSHELL 0x86d73000 == 9 [pid = 27619] [id = 30]
02:45:29 INFO - --DOMWINDOW == 61 (0x8e839000) [pid = 27619] [serial = 31] [outer = (nil)] [url = data:text/html;charset=utf8,%20%20