Closed Bug 1428900 Opened 6 years ago Closed 6 years ago

Intermittent netwerk/test/browser/browser_nsIFormPOSTActionChannel.js | Test timed out - test-verify e10s - should have been skipped

Categories

(Core :: Networking, defect)

defect
Not set
normal

Tracking

()

RESOLVED DUPLICATE of bug 1428465

People

(Reporter: intermittent-bug-filer, Assigned: gbrown)

References

Details

(Keywords: intermittent-failure, Whiteboard: [necko-triaged][stockwell fixed:other])

Filed by: apavel [at] mozilla.com

https://treeherder.mozilla.org/logviewer.html#?job_id=154812530&repo=autoland

https://queue.taskcluster.net/v1/task/acELVPiXRJWT-fZeTchIKg/runs/0/artifacts/public/logs/live_backing.log

20:25:02     INFO -  2 INFO TEST-START | netwerk/test/browser/browser_nsIFormPOSTActionChannel.js
20:25:02     INFO -  GECKO(9104) | ++DOMWINDOW == 6 (000001B327748400) [pid = 32] [serial = 6] [outer = 000001B324CC2850]
20:25:02     INFO -  GECKO(9104) | Chrome file doesn't exist: Z:\task_1515441865\build\tests\mochitest\browser\netwerk\test\browser\head.js
20:25:02     INFO -  GECKO(9104) | ++DOMWINDOW == 5 (000002273BD13C00) [pid = 5304] [serial = 5] [outer = 00000227397BC200]
20:25:02     INFO -  GECKO(9104) | DLL blocklist was unable to intercept AppInit DLLs.
20:25:02     INFO -  GECKO(9104) | ++DOMWINDOW == 7 (000001B32774D400) [pid = 32] [serial = 7] [outer = 000001B324CC2850]
20:25:02     INFO -  GECKO(9104) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to c:\users\genericworker\appdata\local\temp\tmpahwvl0.mozrunner\runtests_leaks_tab_pid1916.log
20:25:02     INFO -  GECKO(9104) | [Child 1916, Main Thread] WARNING: No CID found when attempting to map contract ID: file z:/build/build/src/xpcom/components/nsComponentManager.cpp, line 508
20:25:03     INFO -  GECKO(9104) | ++DOCSHELL 0000020581642000 == 1 [pid = 1916] [id = {31e1db81-0f35-45df-b33c-a7d1e2708541}]
20:25:03     INFO -  GECKO(9104) | ++DOMWINDOW == 1 (00000205854D0470) [pid = 1916] [serial = 1] [outer = 0000000000000000]
20:25:03     INFO -  GECKO(9104) | ++DOMWINDOW == 2 (0000020587BEC000) [pid = 1916] [serial = 2] [outer = 00000205854D0470]
20:25:03     INFO -  GECKO(9104) | Unable to read VR Path Registry from C:\Users\GenericWorker\AppData\Local\openvr\openvrpaths.vrpath
20:25:03     INFO -  GECKO(9104) | [Child 1916, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x804B0012: file z:/build/build/src/netwerk/base/nsNetUtil.cpp, line 182
20:25:03     INFO -  GECKO(9104) | JavaScript error: chrome://global/content/browser-child.js, line 360: NS_ERROR_UNKNOWN_PROTOCOL: Component returned failure code: 0x804b0012 (NS_ERROR_UNKNOWN_PROTOCOL) [nsIWebNavigation.loadURIWithOptions]
20:25:03     INFO -  GECKO(9104) | ++DOMWINDOW == 3 (0000020587BF5400) [pid = 1916] [serial = 3] [outer = 00000205854D0470]
20:25:03     INFO -  GECKO(9104) | [Child 1916, Main Thread] WARNING: attempt to modify an immutable nsStandardURL: file z:/build/build/src/netwerk/base/nsStandardURL.cpp, line 1698
20:25:04     INFO -  GECKO(9104) | DLL blocklist was unable to intercept AppInit DLLs.
20:25:04     INFO -  GECKO(9104) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to c:\users\genericworker\appdata\local\temp\tmpahwvl0.mozrunner\runtests_leaks_tab_pid6160.log
20:25:04     INFO -  GECKO(9104) | [Child 6160, Main Thread] WARNING: No CID found when attempting to map contract ID: file z:/build/build/src/xpcom/components/nsComponentManager.cpp, line 508
20:25:06     INFO -  GECKO(9104) | --DOCSHELL 0000021CA7D64000 == 5 [pid = 9104] [id = {07dbfd4f-07f1-4524-b9a0-1cfcd19b3942}]
20:25:07     INFO -  GECKO(9104) | --DOCSHELL 0000021CACA60800 == 4 [pid = 9104] [id = {2b86ce62-20b2-4d65-a19f-c9df923bfc2f}]
20:25:08     INFO -  GECKO(9104) | --DOCSHELL 000001B320E41000 == 1 [pid = 32] [id = {a87ad691-8afa-49b3-a6e2-7af0328d2724}]
20:25:09     INFO -  GECKO(9104) | --DOCSHELL 0000022735941000 == 1 [pid = 5304] [id = {358eb8fd-897a-476e-bc1f-522e1cc9ca00}]
20:25:11     INFO -  GECKO(9104) | --DOMWINDOW == 12 (0000021CA6D6C800) [pid = 9104] [serial = 4] [outer = 0000000000000000] [url = about:blank]
20:25:12     INFO -  GECKO(9104) | --DOMWINDOW == 6 (000001B3258AA000) [pid = 32] [serial = 2] [outer = 0000000000000000] [url = about:blank]
20:25:12     INFO -  GECKO(9104) | --DOMWINDOW == 5 (000001B327748400) [pid = 32] [serial = 6] [outer = 0000000000000000] [url = about:blank]
20:25:14     INFO -  GECKO(9104) | --DOMWINDOW == 11 (0000021CAC3D4C30) [pid = 9104] [serial = 9] [outer = 0000000000000000] [url = about:blank]
20:25:15     INFO -  GECKO(9104) | --DOMWINDOW == 4 (000001B324CC2470) [pid = 32] [serial = 1] [outer = 0000000000000000] [url = about:blank]
20:25:17     INFO -  GECKO(9104) | --DOMWINDOW == 4 (000002273A3A1C00) [pid = 5304] [serial = 2] [outer = 0000000000000000] [url = about:blank]
20:25:17     INFO -  GECKO(9104) | [DEBUG SHUTDOWN] Shutdown: decoder=000002273C07FC00 state machine=00000227359CB000
20:25:17     INFO -  GECKO(9104) | --DOMWINDOW == 3 (00000227397BB470) [pid = 5304] [serial = 1] [outer = 0000000000000000] [url = chrome://gfxsanity/content/sanitytest.html]
20:25:17     INFO -  GECKO(9104) | [DEBUG SHUTDOWN] Enter: state machine=0000022739561870 reader=000002273954B8B0
20:25:17     INFO -  GECKO(9104) | [DEBUG SHUTDOWN] Shutdown: reader=0000022739562000 shutdown demuxer=0000022739561160
20:25:17     INFO -  GECKO(9104) | [DEBUG SHUTDOWN] Shutdown: pool=000002273A31BB00 count=1
20:25:17     INFO -  GECKO(9104) | [DEBUG SHUTDOWN] operator (): pool=000002273A31BB00 shutdown=true count=0
20:25:17     INFO -  GECKO(9104) | [DEBUG SHUTDOWN] TearDownDecoders: reader=0000022739562000 shut down audio task queue
20:25:17     INFO -  GECKO(9104) | [DEBUG SHUTDOWN] TearDownDecoders: reader=0000022739562000 shut down video task queue
20:25:17     INFO -  GECKO(9104) | [DEBUG SHUTDOWN] FinishShutdown: state machine=00000227359CB000
20:25:17     INFO -  GECKO(9104) | [DEBUG SHUTDOWN] Unregister: decoder=000002273C07FC00, count=0
20:25:18     INFO -  GECKO(9104) | --DOMWINDOW == 2 (0000020587BEC000) [pid = 1916] [serial = 2] [outer = 0000000000000000] [url = about:blank]
20:25:18     INFO -  GECKO(9104) | --DOMWINDOW == 10 (0000021CACB70C00) [pid = 9104] [serial = 10] [outer = 0000000000000000] [url = about:blank]
20:25:19     INFO -  GECKO(9104) | --DOMWINDOW == 2 (000002273BDACC00) [pid = 5304] [serial = 3] [outer = 0000000000000000] [url = chrome://gfxsanity/content/sanitytest.html]
20:25:19     INFO -  GECKO(9104) | --DOMWINDOW == 3 (000001B327747000) [pid = 32] [serial = 4] [outer = 0000000000000000] [url = about:blank]
20:25:19     INFO -  GECKO(9104) | --DOMWINDOW == 2 (000001B3258A3400) [pid = 32] [serial = 3] [outer = 0000000000000000] [url = about:blank]
20:25:22     INFO -  GECKO(9104) | [Parent 9104, Main Thread] WARNING: NS_ENSURE_SUCCESS(rv, rv) failed with result 0x80520012: file z:/build/build/src/dom/fetch/FetchDriver.cpp, line 696
20:26:32     INFO -  TEST-INFO | started process screenshot
20:26:32     INFO -  TEST-INFO | screenshot: exit 0
20:26:32     INFO -  Buffered messages logged at 20:25:02
20:26:32     INFO -  3 INFO Entering test bound
20:26:32     INFO -  4 INFO Leaving test bound
20:26:32     INFO -  5 INFO Entering test bound
20:26:32     INFO -  6 INFO Console message: [JavaScript Warning: "Use of nsIFile in content process is deprecated." {file: "resource://gre/modules/FileUtils.jsm" line: 174}]
20:26:32     INFO -  Buffered messages logged at 20:25:03
20:26:32     INFO -  7 INFO Console message: [JavaScript Warning: "Use of nsIFile in content process is deprecated." {file: "resource://gre/modules/FileUtils.jsm" line: 174}]
20:26:32     INFO -  8 INFO Console message: [JavaScript Error: "NS_ERROR_UNKNOWN_PROTOCOL: Component returned failure code: 0x804b0012 (NS_ERROR_UNKNOWN_PROTOCOL) [nsIWebNavigation.loadURIWithOptions]" {file: "chrome://global/content/browser-child.js" line: 360}]
20:26:32     INFO -  Buffered messages finished
20:26:32    ERROR -  9 INFO TEST-UNEXPECTED-FAIL | netwerk/test/browser/browser_nsIFormPOSTActionChannel.js | Test timed out -
20:26:32     INFO -  GECKO(9104) | MEMORY STAT | vsize 1806MB | vsizeMaxContiguous 131839103MB | residentFast 251MB | heapAllocated 83MB
20:26:32     INFO -  10 INFO TEST-OK | netwerk/test/browser/browser_nsIFormPOSTActionChannel.js | took 90061ms
20:26:32     INFO -  Not taking screenshot here: see the one that was previously logged
20:26:32    ERROR -  11 INFO TEST-UNEXPECTED-FAIL | netwerk/test/browser/browser_nsIFormPOSTActionChannel.js | Found a tab after previous test timed out: x-bug1241377://dummy/form/normal.html -
20:26:32     INFO -  GECKO(9104) | ++DOCSHELL 0000018522C1E800 == 1 [pid = 6160] [id = {0b0a68e7-bc12-4a38-8938-d9e94edb2ccd}]
20:26:32     INFO -  GECKO(9104) | ++DOMWINDOW == 1 (00000185206B8470) [pid = 6160] [serial = 1] [outer = 0000000000000000]
20:26:32     INFO -  12 INFO checking window state
20:26:33     INFO -  GECKO(9104) | ++DOMWINDOW == 11 (0000021CA63D9000) [pid = 9104] [serial = 14] [outer = 0000021CA63E8AB0]
20:26:33     INFO -  GECKO(9104) | ++DOMWINDOW == 12 (0000021CA63DA800) [pid = 9104] [serial = 15] [outer = 0000021CA63E8AB0]
20:26:33     INFO -  GECKO(9104) | ++DOMWINDOW == 2 (0000018521237800) [pid = 6160] [serial = 2] [outer = 00000185206B8470]
20:26:33     INFO -  GECKO(9104) | --DOCSHELL 000002273BD2C000 == 0 [pid = 5304] [id = {cd2fb683-1701-4d4f-9189-96428cc18291}]
20:26:33     INFO -  GECKO(9104) | --DOCSHELL 0000020581642000 == 0 [pid = 1916] [id = {31e1db81-0f35-45df-b33c-a7d1e2708541}]
20:26:33     INFO -  GECKO(9104) | --DOMWINDOW == 1 (00000227397BC200) [pid = 5304] [serial = 4] [outer = 0000000000000000] [url = about:blank]
20:26:33     INFO -  GECKO(9104) | --DOMWINDOW == 0 (000002273BD13C00) [pid = 5304] [serial = 5] [outer = 0000000000000000] [url = about:blank]
20:26:33     INFO -  GECKO(9104) | --DOMWINDOW == 1 (00000205854D0470) [pid = 1916] [serial = 1] [outer = 0000000000000000] [url = about:neterror?e=unknownProtocolFound&u=x-bug1241377%3A//dummy/form/normal.html&c=UTF-8&f=regular&d=Firefox%20doesn%E2%80%99t%20know%20how%20to%20open%20this%20address%2C%20because%20one%20of%20the%20following%20protocols%20%28x-bug1241377%29%20isn%E2%80%99t%20associated%20with%20any%20program%20or%20is%20not%20allowed%20in%20this%20context.]
20:26:33     INFO -  GECKO(9104) | --DOMWINDOW == 0 (0000020587BF5400) [pid = 1916] [serial = 3] [outer = 0000000000000000] [url = about:neterror?e=unknownProtocolFound&u=x-bug1241377%3A//dummy/form/normal.html&c=UTF-8&f=regular&d=Firefox%20doesn%E2%80%99t%20know%20how%20to%20open%20this%20address%2C%20because%20one%20of%20the%20following%20protocols%20%28x-bug1241377%29%20isn%E2%80%99t%20associated%20with%20any%20program%20or%20is%20not%20allowed%20in%20this%20context.]
20:26:33     INFO -  GECKO(9104) | --DOCSHELL 000001B327772000 == 0 [pid = 32] [id = {8f3c0b71-04d4-426e-8833-3b971cf05399}]
20:26:33     INFO -  GECKO(9104) | --DOMWINDOW == 1 (000001B324CC2850) [pid = 32] [serial = 5] [outer = 0000000000000000] [url = about:newtab]
20:26:33     INFO -  GECKO(9104) | --DOMWINDOW == 0 (000001B32774D400) [pid = 32] [serial = 7] [outer = 0000000000000000] [url = about:newtab]
20:26:33     INFO -  GECKO(9104) | [Parent 9104, Main Thread] WARNING: Failed to GC worker!: file z:/build/build/src/dom/workers/WorkerPrivate.cpp, line 3597
20:26:33     INFO -  GECKO(9104) | [Parent 9104, Main Thread] WARNING: Failed to CC worker!: file z:/build/build/src/dom/workers/WorkerPrivate.cpp, line 3611
20:26:33     INFO -  GECKO(9104) | [Parent 9104, Main Thread] WARNING: '!runnable->Dispatch()', file z:/build/build/src/dom/workers/WorkerPrivate.cpp, line 3673
20:26:34     INFO -  GECKO(9104) | --DOMWINDOW == 11 (0000021CA63D9000) [pid = 9104] [serial = 14] [outer = 0000000000000000] [url = about:blank]
20:26:34     INFO -  GECKO(9104) | --DOMWINDOW == 10 (0000021CADBA8400) [pid = 9104] [serial = 11] [outer = 0000000000000000] [url = about:blank]
20:26:35     INFO -  GECKO(9104) | Completed ShutdownLeaks collections in process 5304
20:26:35     INFO -  GECKO(9104) | Completed ShutdownLeaks collections in process 6160
20:26:35     INFO -  GECKO(9104) | Completed ShutdownLeaks collections in process 1916
20:26:35     INFO -  13 INFO Console message: [JavaScript Warning: "Use of nsIFile in content process is deprecated." {file: "resource://gre/modules/FileUtils.jsm" line: 174}]
20:26:35     INFO -  GECKO(9104) | Completed ShutdownLeaks collections in process 32
20:26:37     INFO -  GECKO(9104) | Completed ShutdownLeaks collections in process 9104
20:26:37     INFO -  14 INFO TEST-START | Shutdown
20:26:37     INFO -  15 INFO Browser Chrome Test Summary
20:26:37     INFO -  16 INFO Passed:  0
20:26:37  WARNING -  17 INFO Failed:  2
20:26:37  WARNING -  One or more unittests failed.
20:26:37     INFO -  18 INFO Todo:    0
20:26:37     INFO -  19 INFO Mode:    e10s
20:26:37     INFO -  20 INFO *** End BrowserChrome Test Results ***
This started because after bug 1426501 landed, happening on test-verify-e10s tests.
However, this test is marked skip-if = e10s [1]
It seems test-verify doesn't properly skip this test.

[1] https://searchfox.org/mozilla-central/rev/cf149b7b63ff97023e28723167725e38cf5df757/netwerk/test/browser/browser.ini#11

It seems this has already been noted in bug 1406407 comment 6. This is blocked until it is fixed.
Depends on: 1406407
Summary: Intermittent netwerk/test/browser/browser_nsIFormPOSTActionChannel.js | Test timed out - → Intermittent netwerk/test/browser/browser_nsIFormPOSTActionChannel.js | Test timed out - test-verify e10s - should have been skipped
Whiteboard: [necko-triaged]
Assignee: nobody → gbrown
Status: NEW → RESOLVED
Closed: 6 years ago
No longer depends on: 1406407
Resolution: --- → DUPLICATE
See Also: → 1406407
Whiteboard: [necko-triaged][stockwell needswork:owner] → [necko-triaged][stockwell fixed:other]
You need to log in before you can comment on or make changes to this bug.