Closed Bug 1474710 Opened 6 years ago Closed 6 years ago

Intermittent box-ordinal/dynamic-1-add-to-two-grouped-2.xul | application timed out after 370 seconds with no output

Categories

(Core :: XUL, defect, P5)

defect

Tracking

()

RESOLVED DUPLICATE of bug 1471222

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: nerli [at] mozilla.com https://treeherder.mozilla.org/logviewer.html#?job_id=187454640&repo=autoland https://queue.taskcluster.net/v1/task/Zf1hbc4RRTyX1Ab70p1IVw/runs/0/artifacts/public/logs/live_backing.log https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://queue.taskcluster.net/v1/task/Zf1hbc4RRTyX1Ab70p1IVw/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1 [task 2018-07-10T19:46:26.764Z] 19:46:26 INFO - REFTEST TEST-START | file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/box-ordinal/dynamic-1-add-to-two-grouped-2.xul == file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/box-ordinal/dynamic-1-ref.xul [task 2018-07-10T19:46:26.766Z] 19:46:26 INFO - REFTEST TEST-LOAD | file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/box-ordinal/dynamic-1-add-to-two-grouped-2.xul | 6 / 7 (85%) [task 2018-07-10T19:46:27.033Z] 19:46:27 INFO - REFTEST TEST-PASS | file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/box-ordinal/dynamic-1-add-to-two-grouped-2.xul == file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/box-ordinal/dynamic-1-ref.xul | image comparison, max difference: 0, number of differing pixels: 0 [task 2018-07-10T19:46:27.033Z] 19:46:27 INFO - REFTEST TEST-END | file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/box-ordinal/dynamic-1-add-to-two-grouped-2.xul == file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/box-ordinal/dynamic-1-ref.xul [task 2018-07-10T19:46:27.053Z] 19:46:27 INFO - REFTEST INFO | Slowest test took 426ms (file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/box-ordinal/box-ordinal-with-out-of-flow-1.html) [task 2018-07-10T19:46:27.054Z] 19:46:27 INFO - REFTEST INFO | Total canvas count = 2 [task 2018-07-10T19:46:27.306Z] 19:46:27 INFO - JavaScript error: chrome://reftest/content/reftest.jsm, line 1547: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPropertyBag2.getPropertyAsAString] [task 2018-07-10T19:46:27.352Z] 19:46:27 INFO - JavaScript error: chrome://reftest/content/reftest.jsm, line 1547: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPropertyBag2.getPropertyAsAString] [task 2018-07-10T19:46:27.801Z] 19:46:27 INFO - 1531251987788 Marionette DEBUG Received observer notification xpcom-will-shutdown [task 2018-07-10T19:46:27.801Z] 19:46:27 INFO - 1531251987788 Marionette INFO Stopped listening on port 2828 [task 2018-07-10T19:46:27.802Z] 19:46:27 INFO - 1531251987789 Marionette DEBUG Remote service is inactive [task 2018-07-10T19:46:28.496Z] 19:46:28 INFO - REFTEST INFO | Process mode: e10s [task 2018-07-10T19:46:28.497Z] 19:46:28 WARNING - leakcheck | refcount logging is off, so leaks can't be detected! [task 2018-07-10T19:46:28.498Z] 19:46:28 INFO - REFTEST INFO | Running tests in file:///builds/worker/workspace/build/tests/reftest/tests/image/test/reftest/bmp/reftest.list [task 2018-07-10T19:46:28.514Z] 19:46:28 INFO - REFTEST INFO | INFO | runtests.py | ASan using symbolizer at /builds/worker/workspace/build/application/firefox/llvm-symbolizer [task 2018-07-10T19:46:28.523Z] 19:46:28 INFO - REFTEST INFO | INFO | runtests.py | ASan running in default memory configuration [task 2018-07-10T19:46:28.524Z] 19:46:28 INFO - REFTEST INFO | Running with e10s: True [task 2018-07-10T19:46:28.525Z] 19:46:28 INFO - REFTEST INFO | Application command: /builds/worker/workspace/build/application/firefox/firefox -marionette -profile /tmp/tmpxzlCSd.mozrunner [task 2018-07-10T19:46:30.203Z] 19:46:30 INFO - 1531251990200 Marionette DEBUG Received observer notification profile-after-change [task 2018-07-10T19:46:30.299Z] 19:46:30 INFO - ATTENTION: default value of option force_s3tc_enable overridden by environment. [task 2018-07-10T19:46:30.360Z] 19:46:30 INFO - 1531251990359 Marionette DEBUG Received observer notification command-line-startup [task 2018-07-10T19:46:30.364Z] 19:46:30 INFO - 1531251990359 Marionette DEBUG Received observer notification nsPref:changed [task 2018-07-10T19:46:30.367Z] 19:46:30 INFO - 1531251990360 Marionette DEBUG Init aborted (running=false, enabled=true, finalUIStartup=false) [task 2018-07-10T19:46:30.687Z] 19:46:30 INFO - 1531251990685 Marionette DEBUG Received observer notification toplevel-window-ready [task 2018-07-10T19:46:33.390Z] 19:46:33 INFO - 1531251993384 Marionette DEBUG Received observer notification sessionstore-windows-restored [task 2018-07-10T19:46:33.390Z] 19:46:33 INFO - 1531251993384 Marionette DEBUG Waiting for delayed startup... [task 2018-07-10T19:46:34.931Z] 19:46:34 INFO - 1531251994930 Marionette DEBUG Waiting for startup tests... [task 2018-07-10T19:46:35.201Z] 19:46:35 INFO - 1531251995199 Marionette INFO Listening on port 2828 [task 2018-07-10T19:46:35.205Z] 19:46:35 INFO - 1531251995201 Marionette DEBUG Remote service is active [task 2018-07-10T19:46:35.290Z] 19:46:35 INFO - 1531251995286 Marionette DEBUG Accepted connection 0 from 127.0.0.1:50850 [task 2018-07-10T19:46:35.310Z] 19:46:35 INFO - 1531251995308 Marionette DEBUG Closed connection 0 [task 2018-07-10T19:46:35.320Z] 19:46:35 INFO - 1531251995314 Marionette DEBUG Accepted connection 1 from 127.0.0.1:50852 [task 2018-07-10T19:46:35.326Z] 19:46:35 INFO - 1531251995324 Marionette TRACE 1 -> [0,1,"WebDriver:NewSession",{}] [task 2018-07-10T19:46:35.826Z] 19:46:35 INFO - 1531251995823 Marionette DEBUG [2147483649] Frame script loaded [task 2018-07-10T19:46:35.842Z] 19:46:35 INFO - 1531251995838 Marionette DEBUG [2147483649] Frame script registered [task 2018-07-10T19:46:35.898Z] 19:46:35 INFO - 1531251995895 Marionette TRACE 1 <- [1,1,null,{"sessionId":"76c2a973-9183-45cf-9895-e18e85cf77df","capabilities":{"browserName":"firefox","browserVersion":"63.0a ... ssID":3974,"moz:profile":"/tmp/tmpxzlCSd.mozrunner","moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true}}] [task 2018-07-10T19:46:35.979Z] 19:46:35 INFO - 1531251995975 Marionette TRACE 1 -> [0,2,"Addon:Install",{"path":"/builds/worker/workspace/build/tests/reftest/reftest","temporary":true}] [task 2018-07-10T19:46:36.157Z] 19:46:36 INFO - 1531251996151 Marionette TRACE 1 <- [1,2,null,{"value":"reftest@mozilla.org"}] [task 2018-07-10T19:46:36.827Z] 19:46:36 INFO - 1531251996823 Marionette TRACE 1 -> [0,3,"WebDriver:DeleteSession",{}] [task 2018-07-10T19:46:36.834Z] 19:46:36 INFO - 1531251996828 Marionette TRACE 1 <- [1,3,null,{"value":null}] [task 2018-07-10T19:46:36.855Z] 19:46:36 INFO - 1531251996852 Marionette DEBUG Closed connection 1 [task 2018-07-10T19:46:38.859Z] 19:46:38 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x2D0101,name=PContent::Msg_AccumulateChildKeyedHistograms) Channel closing: too late to send/recv, messages will be lost [task 2018-07-10T19:46:38.859Z] 19:46:38 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x2D0105,name=PContent::Msg_RecordDiscardedData) Channel closing: too late to send/recv, messages will be lost [task 2018-07-10T19:46:40.514Z] 19:46:40 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x6F0001,name=PScriptCache::Msg___delete__) Channel closing: too late to send/recv, messages will be lost [task 2018-07-10T19:46:42.512Z] 19:46:42 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x2D0100,name=PContent::Msg_AccumulateChildHistograms) Channel closing: too late to send/recv, messages will be lost [task 2018-07-10T19:46:42.513Z] 19:46:42 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x2D0101,name=PContent::Msg_AccumulateChildKeyedHistograms) Channel closing: too late to send/recv, messages will be lost [task 2018-07-10T19:46:42.513Z] 19:46:42 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x2D0105,name=PContent::Msg_RecordDiscardedData) Channel closing: too late to send/recv, messages will be lost [task 2018-07-10T19:46:47.301Z] 19:46:47 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x2D0100,name=PContent::Msg_AccumulateChildHistograms) Channel closing: too late to send/recv, messages will be lost [task 2018-07-10T19:46:47.304Z] 19:46:47 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x2D0105,name=PContent::Msg_RecordDiscardedData) Channel closing: too late to send/recv, messages will be lost [task 2018-07-10T19:46:49.302Z] 19:46:49 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x2D0100,name=PContent::Msg_AccumulateChildHistograms) Channel closing: too late to send/recv, messages will be lost [task 2018-07-10T19:46:49.304Z] 19:46:49 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x2D0101,name=PContent::Msg_AccumulateChildKeyedHistograms) Channel closing: too late to send/recv, messages will be lost [task 2018-07-10T19:46:49.305Z] 19:46:49 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x2D0105,name=PContent::Msg_RecordDiscardedData) Channel closing: too late to send/recv, messages will be lost [task 2018-07-10T19:46:52.799Z] 19:46:52 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x550027,name=PNecko::Msg_RemoveRequestContext) Channel closing: too late to send/recv, messages will be lost [task 2018-07-10T19:46:53.615Z] 19:46:53 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x2D0100,name=PContent::Msg_AccumulateChildHistograms) Channel closing: too late to send/recv, messages will be lost [task 2018-07-10T19:46:53.615Z] 19:46:53 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x2D0105,name=PContent::Msg_RecordDiscardedData) Channel closing: too late to send/recv, messages will be lost [task 2018-07-10T19:46:55.618Z] 19:46:55 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x2D0100,name=PContent::Msg_AccumulateChildHistograms) Channel closing: too late to send/recv, messages will be lost [task 2018-07-10T19:46:55.620Z] 19:46:55 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x2D0101,name=PContent::Msg_AccumulateChildKeyedHistograms) Channel closing: too late to send/recv, messages will be lost [task 2018-07-10T19:46:55.621Z] 19:46:55 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x2D0105,name=PContent::Msg_RecordDiscardedData) Channel closing: too late to send/recv, messages will be lost [task 2018-07-10T19:47:19.917Z] 19:47:19 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x2D0102,name=PContent::Msg_UpdateChildScalars) Channel closing: too late to send/recv, messages will be lost [task 2018-07-10T19:47:19.920Z] 19:47:19 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x2D0105,name=PContent::Msg_RecordDiscardedData) Channel closing: too late to send/recv, messages will be lost [task 2018-07-10T19:47:34.253Z] 19:47:34 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x2D0100,name=PContent::Msg_AccumulateChildHistograms) Channel closing: too late to send/recv, messages will be lost [task 2018-07-10T19:47:34.255Z] 19:47:34 INFO - ###!!! [Child][MessageChannel] Error: (msgtype=0x2D0105,name=PContent::Msg_RecordDiscardedData) Channel closing: too late to send/recv, messages will be lost [task 2018-07-10T19:53:44.268Z] 19:53:44 ERROR - REFTEST ERROR | file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/box-ordinal/dynamic-1-add-to-two-grouped-2.xul | application timed out after 370 seconds with no output [task 2018-07-10T19:53:44.270Z] 19:53:44 ERROR - REFTEST ERROR | Force-terminating active process(es). [task 2018-07-10T19:53:44.272Z] 19:53:44 INFO - REFTEST TEST-INFO | started process screentopng [task 2018-07-10T19:53:44.927Z] 19:53:44 INFO - REFTEST TEST-INFO | screentopng: exit 0 [task 2018-07-10T19:53:44.927Z] 19:53:44 INFO - REFTEST INFO | Can't trigger Breakpad, just killing process [task 2018-07-10T19:53:45.030Z] 19:53:45 ERROR - TEST-UNEXPECTED-FAIL | file:///builds/worker/workspace/build/tests/reftest/tests/layout/reftests/box-ordinal/dynamic-1-add-to-two-grouped-2.xul | application terminated with exit code -15 [task 2018-07-10T19:53:45.034Z] 19:53:45 INFO - REFTEST INFO | Process mode: e10s
Status: NEW → RESOLVED
Closed: 6 years ago
Resolution: --- → DUPLICATE
You need to log in before you can comment on or make changes to this bug.