Closed Bug 1470569 Opened 7 years ago Closed 7 years ago

Intermittent toolkit/components/remotebrowserutils/tests/browser/browser_RemoteWebNavigation.js | Test timed out -

Categories

(Core :: DOM: Navigation, defect, P5)

Product:
Core
Component:
DOM: Navigation
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: apavel [at] mozilla.com https://treeherder.mozilla.org/logviewer.html#?job_id=184391566&repo=mozilla-inbound https://queue.taskcluster.net/v1/task/ekKr3gRrTDW_iWgXLC8kqw/runs/0/artifacts/public/logs/live_backing.log [task 2018-06-22T16:28:12.128Z] 16:28:12 INFO - TEST-START | toolkit/components/remotebrowserutils/tests/browser/browser_RemoteWebNavigation.js [task 2018-06-22T16:29:42.581Z] 16:29:42 INFO - TEST-INFO | started process screentopng [task 2018-06-22T16:29:43.318Z] 16:29:43 INFO - TEST-INFO | screentopng: exit 0 [task 2018-06-22T16:29:43.319Z] 16:29:43 INFO - Buffered messages logged at 16:28:12 [task 2018-06-22T16:29:43.320Z] 16:29:43 INFO - Entering test bound test_referrer [task 2018-06-22T16:29:43.321Z] 16:29:43 INFO - Console message: [JavaScript Warning: "Use of nsIFile in content process is deprecated." {file: "resource://gre/modules/FileUtils.jsm" line: 170}] [task 2018-06-22T16:29:43.322Z] 16:29:43 INFO - Buffered messages logged at 16:28:14 [task 2018-06-22T16:29:43.322Z] 16:29:43 INFO - Console message: [JavaScript Warning: "Use of nsIFile in content process is deprecated." {file: "resource://gre/modules/FileUtils.jsm" line: 170}] [task 2018-06-22T16:29:43.322Z] 16:29:43 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: "http://example.com/browser/toolkit/modules/tests/browser/dummy_page.html" line: 0}] [task 2018-06-22T16:29:43.323Z] 16:29:43 INFO - TEST-PASS | toolkit/components/remotebrowserutils/tests/browser/browser_RemoteWebNavigation.js | Should have loaded the right URL - "http://example.com/browser/toolkit/modules/tests/browser/dummy_page.html" == "http://example.com/browser/toolkit/modules/tests/browser/dummy_page.html" - [task 2018-06-22T16:29:43.325Z] 16:29:43 INFO - TEST-PASS | toolkit/components/remotebrowserutils/tests/browser/browser_RemoteWebNavigation.js | Should have the right referrer - "http://example.org/browser/toolkit/modules/tests/browser/dummy_page.html" == "http://example.org/browser/toolkit/modules/tests/browser/dummy_page.html" - [task 2018-06-22T16:29:43.326Z] 16:29:43 INFO - Leaving test bound test_referrer [task 2018-06-22T16:29:43.327Z] 16:29:43 INFO - Entering test bound test_history [task 2018-06-22T16:29:43.329Z] 16:29:43 INFO - Buffered messages finished [task 2018-06-22T16:29:43.330Z] 16:29:43 INFO - TEST-UNEXPECTED-FAIL | toolkit/components/remotebrowserutils/tests/browser/browser_RemoteWebNavigation.js | Test timed out - [task 2018-06-22T16:29:43.332Z] 16:29:43 INFO - GECKO(4221) | MEMORY STAT vsizeMaxContiguous not supported in this build configuration. [task 2018-06-22T16:29:43.333Z] 16:29:43 INFO - GECKO(4221) | MEMORY STAT heapAllocated not supported in this build configuration. [task 2018-06-22T16:29:43.334Z] 16:29:43 INFO - GECKO(4221) | MEMORY STAT | vsize 20973904MB | residentFast 943MB [task 2018-06-22T16:29:43.336Z] 16:29:43 INFO - TEST-OK | toolkit/components/remotebrowserutils/tests/browser/browser_RemoteWebNavigation.js | took 90503ms [task 2018-06-22T16:29:43.337Z] 16:29:43 INFO - Not taking screenshot here: see the one that was previously logged [task 2018-06-22T16:29:43.338Z] 16:29:43 INFO - TEST-UNEXPECTED-FAIL | toolkit/components/remotebrowserutils/tests/browser/browser_RemoteWebNavigation.js | Found a tab after previous test timed out: about:blank - [task 2018-06-22T16:29:43.339Z] 16:29:43 INFO - checking window state [task 2018-06-22T16:29:52.979Z] 16:29:52 INFO - GECKO(4221) | WARNING: At least one completion condition is taking too long to complete. Conditions: [{"name":"ShutdownLeaks: Wait for tabs to finish closing","state":"(none)","filename":"chrome://mochikit/content/browser-test.js","lineNumber":959,"stack":["chrome://mochikit/content/browser-test.js:nextTest/<:959","chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<:795"]}] Barrier: ShutdownLeaks: Wait for cleanup to be finished before checking for leaks [task 2018-06-22T16:32:43.981Z] 16:32:43 INFO - GECKO(4221) | FATAL ERROR: AsyncShutdown timeout in ShutdownLeaks: Wait for cleanup to be finished before checking for leaks Conditions: [{"name":"ShutdownLeaks: Wait for tabs to finish closing","state":"(none)","filename":"chrome://mochikit/content/browser-test.js","lineNumber":959,"stack":["chrome://mochikit/content/browser-test.js:nextTest/<:959","chrome://mochikit/content/tests/SimpleTest/SimpleTest.js:SimpleTest.waitForFocus/waitForFocusInner/focusedOrLoaded/<:795"]}] At least one completion condition failed to complete within a reasonable amount of time. Causing a crash to ensure that we do not leave the user with an unresponsive process draining resources. [task 2018-06-22T16:32:43.983Z] 16:32:43 INFO - GECKO(4221) | WARNING: No crash reporter available [task 2018-06-22T16:32:43.985Z] 16:32:43 INFO - GECKO(4221) | [Parent 4221, Main Thread] ###!!! ABORT: file chrome://mochikit/content/browser-test.js, line 959 [task 2018-06-22T16:32:43.987Z] 16:32:43 INFO - GECKO(4221) | [Parent 4221, Main Thread] ###!!! ABORT: file chrome://mochikit/content/browser-test.js, line 959 [task 2018-06-22T16:32:43.989Z] 16:32:43 INFO - GECKO(4221) | AddressSanitizer:DEADLYSIGNAL [task 2018-06-22T16:32:43.991Z] 16:32:43 INFO - GECKO(4221) | ================================================================= [task 2018-06-22T16:32:43.992Z] 16:32:43 ERROR - GECKO(4221) | ==4221==ERROR: AddressSanitizer: SEGV on unknown address 0x000000000000 (pc 0x0000004f2ac7 bp 0x7fffc51976b0 sp 0x7fffc51976a0 T0) [task 2018-06-22T16:32:43.994Z] 16:32:43 INFO - GECKO(4221) | ==4221==The signal is caused by a WRITE memory access. [task 2018-06-22T16:32:43.998Z] 16:32:43 INFO - GECKO(4221) | ==4221==Hint: address points to the zero page. [task 2018-06-22T16:32:44.305Z] 16:32:44 INFO - GECKO(4221) | #0 0x4f2ac6 in mozalloc_abort /builds/worker/workspace/build/src/memory/mozalloc/mozalloc_abort.cpp:34:5 [task 2018-06-22T16:32:44.792Z] 16:32:44 INFO - GECKO(4221) | #1 0x7f07d6d0c395 in Abort(char const*) /builds/worker/workspace/build/src/xpcom/base/nsDebugImpl.cpp:457:3 [task 2018-06-22T16:32:44.792Z] 16:32:44 INFO - GECKO(4221) | #2 0x7f07d6d0bfbb in NS_DebugBreak /builds/worker/workspace/build/src/xpcom/base/nsDebugImpl.cpp [task 2018-06-22T16:32:44.794Z] 16:32:44 INFO - GECKO(4221) | #3 0x7f07d6d0c1d9 in nsDebugImpl::Abort(char const*, int) /builds/worker/workspace/build/src/xpcom/base/nsDebugImpl.cpp:146:3 [task 2018-06-22T16:32:44.795Z] 16:32:44 INFO - GECKO(4221) | #4 0x7f07d6efe971 in NS_InvokeByIndex /builds/worker/workspace/build/src/xpcom/reflect/xptcall/md/unix/xptcinvoke_asm_x86_64_unix.S:106 [task 2018-06-22T16:32:44.798Z] 16:32:44 INFO - GECKO(4221) | #5 0x7f07d87a4b99 in Invoke /builds/worker/workspace/build/src/js/xpconnect/src/XPCWrappedNative.cpp:1703:12 [task 2018-06-22T16:32:44.801Z] 16:32:44 INFO - GECKO(4221) | #6 0x7f07d87a4b99 in Call /builds/worker/workspace/build/src/js/xpconnect/src/XPCWrappedNative.cpp:1219 [task 2018-06-22T16:32:44.803Z] 16:32:44 INFO - GECKO(4221) | #7 0x7f07d87a4b99 in XPCWrappedNative::CallMethod(XPCCallContext&, XPCWrappedNative::CallMode) /builds/worker/workspace/build/src/js/xpconnect/src/XPCWrappedNative.cpp:1186 [task 2018-06-22T16:32:44.804Z] 16:32:44 INFO - GECKO(4221) | #8 0x7f07d87aa694 in XPC_WN_CallMethod(JSContext*, unsigned int, JS::Value*) /builds/worker/workspace/build/src/js/xpconnect/src/XPCWrappedNativeJSOps.cpp:893:12 [task 2018-06-22T16:32:44.806Z] 16:32:44 INFO - GECKO(4221) | #9 0x7f07e2e17213 in js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct) /builds/worker/workspace/build/src/js/src/vm/JSContext-inl.h:274:15 [task 2018-06-22T16:32:44.810Z] 16:32:44 INFO - GECKO(4221) | #10 0x7f07e2e01f51 in CallFromStack /builds/worker/workspace/build/src/js/src/vm/Interpreter.cpp:526:12 [task 2018-06-22T16:32:44.811Z] 16:32:44 INFO - GECKO(4221) | #11 0x7f07e2e01f51 in Interpret(JSContext*, js::RunState&) /builds/worker/workspace/build/src/js/src/vm/Interpreter.cpp:3122 [task 2018-06-22T16:32:44.813Z] 16:32:44 INFO - GECKO(4221) | #12 0x7f07e2de882a in js::RunScript(JSContext*, js::RunState&) /builds/worker/workspace/build/src/js/src/vm/Interpreter.cpp:421:12 [task 2018-06-22T16:32:44.814Z] 16:32:44 INFO - GECKO(4221) | #13 0x7f07e2e17a02 in js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct) /builds/worker/workspace/build/src/js/src/vm/Interpreter.cpp:493:15 [task 2018-06-22T16:32:44.815Z] 16:32:44 INFO - GECKO(4221) | #14 0x7f07e2e18802 in js::Call(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, js::AnyInvokeArgs const&, JS::MutableHandle<JS::Value>) /builds/worker/workspace/build/src/js/src/vm/Interpreter.cpp:539:10 [task 2018-06-22T16:32:44.819Z] 16:32:44 INFO - GECKO(4221) | #15 0x7f07e2f52596 in PromiseReactionJob(JSContext*, unsigned int, JS::Value*) /builds/worker/workspace/build/src/js/src/builtin/Promise.cpp:1238:14 [task 2018-06-22T16:32:44.820Z] 16:32:44 INFO - GECKO(4221) | #16 0x7f07e2e17213 in js::InternalCallOrConstruct(JSContext*, JS::CallArgs const&, js::MaybeConstruct) /builds/worker/workspace/build/src/js/src/vm/JSContext-inl.h:274:15 [task 2018-06-22T16:32:44.821Z] 16:32:44 INFO - GECKO(4221) | #17 0x7f07e2e18802 in js::Call(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, js::AnyInvokeArgs const&, JS::MutableHandle<JS::Value>) /builds/worker/workspace/build/src/js/src/vm/Interpreter.cpp:539:10 [task 2018-06-22T16:32:44.838Z] 16:32:44 INFO - GECKO(4221) | #18 0x7f07e393bb1a in JS::Call(JSContext*, JS::Handle<JS::Value>, JS::Handle<JS::Value>, JS::HandleValueArray const&, JS::MutableHandle<JS::Value>) /builds/worker/workspace/build/src/js/src/jsapi.cpp:2887:12 [task 2018-06-22T16:32:44.857Z] 16:32:44 INFO - GECKO(4221) | #19 0x7f07dab30a86 in mozilla::dom::PromiseJobCallback::Call(JSContext*, JS::Handle<JS::Value>, mozilla::ErrorResult&) /builds/worker/workspace/build/src/obj-firefox/dom/bindings/PromiseBinding.cpp:25:8 [task 2018-06-22T16:32:44.858Z] 16:32:44 INFO - GECKO(4221) | #20 0x7f07d6d3a319 in Call /builds/worker/workspace/build/src/obj-firefox/dist/include/mozilla/dom/PromiseBinding.h:91:12 [task 2018-06-22T16:32:44.859Z] 16:32:44 INFO - GECKO(4221) | #21 0x7f07d6d3a319 in Call /builds/worker/workspace/build/src/obj-firefox/dist/include/mozilla/dom/PromiseBinding.h:104 [task 2018-06-22T16:32:44.860Z] 16:32:44 INFO - GECKO(4221) | #22 0x7f07d6d3a319 in mozilla::PromiseJobRunnable::Run(mozilla::AutoSlowOperation&) /builds/worker/workspace/build/src/xpcom/base/CycleCollectedJSContext.cpp:224 [task 2018-06-22T16:32:44.862Z] 16:32:44 INFO - GECKO(4221) | #23 0x7f07d6d1a5c1 in mozilla::CycleCollectedJSContext::PerformMicroTaskCheckPoint() /builds/worker/workspace/build/src/xpcom/base/CycleCollectedJSContext.cpp:562:17 [task 2018-06-22T16:32:44.862Z] 16:32:44 INFO - GECKO(4221) | #24 0x7f07d6d1ae0d in mozilla::CycleCollectedJSContext::AfterProcessTask(unsigned int) /builds/worker/workspace/build/src/xpcom/base/CycleCollectedJSContext.cpp:393:3 [task 2018-06-22T16:32:44.867Z] 16:32:44 INFO - GECKO(4221) | #25 0x7f07d872bbcd in XPCJSContext::AfterProcessTask(unsigned int) /builds/worker/workspace/build/src/js/xpconnect/src/XPCJSContext.cpp:1218:30 [task 2018-06-22T16:32:44.868Z] 16:32:44 INFO - GECKO(4221) | #26 0x7f07d6ed15c4 in nsThread::ProcessNextEvent(bool, bool*) /builds/worker/workspace/build/src/xpcom/threads/nsThread.cpp:1086:24 [task 2018-06-22T16:32:44.868Z] 16:32:44 INFO - GECKO(4221) | #27 0x7f07d6ed7b78 in NS_ProcessNextEvent(nsIThread*, bool) /builds/worker/workspace/build/src/xpcom/threads/nsThreadUtils.cpp:519:10 [task 2018-06-22T16:32:44.869Z] 16:32:44 INFO - GECKO(4221) | #28 0x7f07d7dc70a6 in mozilla::ipc::MessagePump::Run(base::MessagePump::Delegate*) /builds/worker/workspace/build/src/ipc/glue/MessagePump.cpp:125:5 [task 2018-06-22T16:32:44.871Z] 16:32:44 INFO - GECKO(4221) | #29 0x7f07d7d1bdcc in RunInternal /builds/worker/workspace/build/src/ipc/chromium/src/base/message_loop.cc:325:10 [task 2018-06-22T16:32:44.871Z] 16:32:44 INFO - GECKO(4221) | #30 0x7f07d7d1bdcc in RunHandler /builds/worker/workspace/build/src/ipc/chromium/src/base/message_loop.cc:318 [task 2018-06-22T16:32:44.873Z] 16:32:44 INFO - GECKO(4221) | #31 0x7f07d7d1bdcc in MessageLoop::Run() /builds/worker/workspace/build/src/ipc/chromium/src/base/message_loop.cc:298 [task 2018-06-22T16:32:44.873Z] 16:32:44 INFO - GECKO(4221) | #32 0x7f07de87841a in nsBaseAppShell::Run() /builds/worker/workspace/build/src/widget/nsBaseAppShell.cpp:158:27 [task 2018-06-22T16:32:44.877Z] 16:32:44 INFO - GECKO(4221) | #33 0x7f07e290fecb in nsAppStartup::Run() /builds/worker/workspace/build/src/toolkit/components/startup/nsAppStartup.cpp:290:30 [task 2018-06-22T16:32:44.878Z] 16:32:44 INFO - GECKO(4221) | #34 0x7f07e2b3eb9b in XREMain::XRE_mainRun() /builds/worker/workspace/build/src/toolkit/xre/nsAppRunner.cpp:4746:22 [task 2018-06-22T16:32:44.878Z] 16:32:44 INFO - GECKO(4221) | #35 0x7f07e2b41cc3 in XREMain::XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/workspace/build/src/toolkit/xre/nsAppRunner.cpp:4891:8 [task 2018-06-22T16:32:44.879Z] 16:32:44 INFO - GECKO(4221) | #36 0x7f07e2b43178 in XRE_main(int, char**, mozilla::BootstrapConfig const&) /builds/worker/workspace/build/src/toolkit/xre/nsAppRunner.cpp:4983:21 [task 2018-06-22T16:32:44.880Z] 16:32:44 INFO - GECKO(4221) | #37 0x4f1abc in do_main /builds/worker/workspace/build/src/browser/app/nsBrowserApp.cpp:233:22 [task 2018-06-22T16:32:44.880Z] 16:32:44 INFO - GECKO(4221) | #38 0x4f1abc in main /builds/worker/workspace/build/src/browser/app/nsBrowserApp.cpp:311 [task 2018-06-22T16:32:44.959Z] 16:32:44 INFO - GECKO(4221) | #39 0x7f07f763982f in __libc_start_main /build/glibc-Cl5G7W/glibc-2.23/csu/../csu/libc-start.c:291 [task 2018-06-22T16:32:44.959Z] 16:32:44 INFO - GECKO(4221) | #40 0x4210e8 in _start (/builds/worker/workspace/build/application/firefox/firefox+0x4210e8) [task 2018-06-22T16:32:44.959Z] 16:32:44 INFO - GECKO(4221) | AddressSanitizer can not provide additional info. [task 2018-06-22T16:32:44.959Z] 16:32:44 INFO - GECKO(4221) | SUMMARY: AddressSanitizer: SEGV /builds/worker/workspace/build/src/memory/mozalloc/mozalloc_abort.cpp:34:5 in mozalloc_abort [task 2018-06-22T16:32:44.960Z] 16:32:44 INFO - GECKO(4221) | ==4221==ABORTING [task 2018-06-22T16:38:54.970Z] 16:38:54 INFO - Buffered messages finished [task 2018-06-22T16:38:54.972Z] 16:38:54 ERROR - TEST-UNEXPECTED-TIMEOUT | toolkit/components/remotebrowserutils/tests/browser/browser_RemoteWebNavigation.js | application timed out after 370 seconds with no output [task 2018-06-22T16:38:54.973Z] 16:38:54 ERROR - Force-terminating active process(es).
Summary: Intermittent toolkit/components/remotebrowserutils/tests/browser/browser_RemoteWebNavigation.js | Found a tab after previous test timed out: about:blank - → Intermittent toolkit/components/remotebrowserutils/tests/browser/browser_RemoteWebNavigation.js | Test timed out -
https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
Status: NEW → RESOLVED
Closed: 7 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.