Closed Bug 1686423 Opened 4 years ago Closed 4 years ago

Intermittent TEST-UNEXPECTED-TIMEOUT | http://mochi.test:8888/tests/layout/style/test/test_bug1451199-1.html | application timed out after 370 seconds with no output

Categories

(Core :: CSS Parsing and Computation, defect, P5)

Product:
Core
Component:
CSS Parsing and Computation
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: smolnar [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=326566239&repo=mozilla-central
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/brrzRtBnQeyyHGBCISqtLw/runs/0/artifacts/public/logs/live_backing.log

INFO - TEST-START | http://mochi.test:8888/tests/layout/style/test/test_bug1451199-1.html
[task 2021-01-13T10:29:59.769Z] 10:29:59     INFO - GECKO(1535) | ### XPCOM_MEM_BLOAT_LOG defined -- logging bloat/leaks to /tmp/tmpfIwKFt.mozrunner/runtests_leaks_tab_pid2957.log
[task 2021-01-13T10:29:59.770Z] 10:29:59     INFO - GECKO(1535) | [2957, Main Thread] WARNING: XPCOM_MEM_BLOAT_LOG is set, disabling native allocations.: file /builds/worker/checkouts/gecko/tools/profiler/core/platform.cpp:251
[task 2021-01-13T10:29:59.847Z] 10:29:59     INFO - GECKO(1535) | [Child 2878, Main Thread] WARNING: '!topWindow', file /builds/worker/checkouts/gecko/dom/html/HTMLIFrameElement.cpp:240
[task 2021-01-13T10:29:59.963Z] 10:29:59     INFO - GECKO(1535) | [Child 2850, Main Thread] WARNING: Extra shutdown CC: 'i < NORMAL_SHUTDOWN_COLLECTIONS', file /builds/worker/checkouts/gecko/xpcom/base/nsCycleCollector.cpp:3364
[task 2021-01-13T10:29:59.967Z] 10:29:59     INFO - GECKO(1535) | [Child 2957, Main Thread] WARNING: could not set real-time limit in CubebUtils::InitLibrary: file /builds/worker/checkouts/gecko/dom/media/CubebUtils.cpp:629
[task 2021-01-13T10:30:00.004Z] 10:30:00     INFO - GECKO(1535) | [Child 2850, Main Thread] WARNING: NS_ENSURE_TRUE(Preferences::InitStaticMembers()) failed: file /builds/worker/checkouts/gecko/modules/libpref/Preferences.cpp:4378
[task 2021-01-13T10:35:10.512Z] 10:35:10     INFO - GECKO(1535) | JavaScript error: http://mochi.xorigin-test:8888/tests/SimpleTest/TestRunner.js, line 162: SecurityError: Permission denied to access property "wrappedJSObject" on cross-origin object
[task 2021-01-13T10:37:32.247Z] 10:37:32     INFO - GECKO(1535) | 1610534252236	addons.xpi	ERROR	System addon update list error Error: got node name: html, expected: updates
[task 2021-01-13T10:43:42.261Z] 10:43:42     INFO - Buffered messages finished
[task 2021-01-13T10:43:42.262Z] 10:43:42    ERROR - TEST-UNEXPECTED-TIMEOUT | http://mochi.test:8888/tests/layout/style/test/test_bug1451199-1.html | application timed out after 370 seconds with no output
[task 2021-01-13T10:43:42.262Z] 10:43:42    ERROR - Force-terminating active process(es).
[task 2021-01-13T10:43:42.263Z] 10:43:42     INFO - Determining child pids from psutil...
[task 2021-01-13T10:43:42.279Z] 10:43:42     INFO - [2052, 2585, 2078, 2473, 2772, 1969, 2611, 2104, 1598, 2743, 2637, 2156, 2183, 2668, 1678, 1703, 1711, 2234, 2850, 2260, 1751, 2286, 1779, 2821, 1812, 2720, 2338, 2694, 1864, 2891, 2957, 2390, 2313, 1890, 2364, 2413, 2878, 2025, 1916, 2446, 2798, 1942, 1838, 2208, 2925, 2504, 1999, 2530, 2130, 1618, 2552]
[task 2021-01-13T10:43:42.280Z] 10:43:42     INFO - ==> process 1535 launched child process 1559
...
INFO - ==> process 1535 launched child process 2957
[task 2021-01-13T10:43:42.323Z] 10:43:42     INFO - Found child pids: set([2052, 2821, 2694, 2183, 2156, 2957, 1678, 2925, 1812, 2798, 1942, 1559, 2585, 2078, 2720, 2850, 1618, 1703, 2473, 1838, 1711, 1969, 2611, 2743, 2104, 2234, 2364, 1598, 2208, 2891, 2504, 1864, 2338, 2637, 1999, 2530, 2130, 2260, 2446, 2390, 1751, 2313, 1890, 2025, 2668, 2413, 2286, 1779, 2878, 2552, 2772, 1916])
[task 2021-01-13T10:43:42.328Z] 10:43:42     INFO - Failed to get child procs
[task 2021-01-13T10:43:42.328Z] 10:43:42     INFO - Killing process: 2052
[task 2021-01-13T10:43:42.328Z] 10:43:42     INFO - TEST-INFO | started process screentopng
[task 2021-01-13T10:43:42.452Z] 10:43:42     INFO - TEST-INFO | screentopng: exit 0
[task 2021-01-13T10:43:42.454Z] 10:43:42     INFO - Killing process: 2821
[task 2021-01-13T10:43:42.455Z] 10:43:42     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-01-13T10:43:42.456Z] 10:43:42     INFO - Killing process: 2694
...
INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-01-13T10:43:42.640Z] 10:43:42     INFO - psutil found pid 1535 dead
[task 2021-01-13T10:43:42.683Z] 10:43:42  WARNING - runtests.py | Failed to get app exit code - running/crashed?
[task 2021-01-13T10:43:42.684Z] 10:43:42     INFO - TEST-INFO | Main app process: exit 0
[task 2021-01-13T10:43:42.685Z] 10:43:42     INFO - runtests.py | Application ran for: 0:14:41.660724
[task 2021-01-13T10:43:42.686Z] 10:43:42     INFO - zombiecheck | Reading PID log: /tmp/tmpIxkfpUpidlog
[task 2021-01-13T10:43:42.688Z] 10:43:42     INFO - ==> process 1535 launched child process 1559
...
INFO - zombiecheck | Checking for orphan process with PID: 2552
[task 2021-01-13T10:43:42.734Z] 10:43:42     INFO - zombiecheck | Checking for orphan process with PID: 2772
[task 2021-01-13T10:43:42.735Z] 10:43:42     INFO - zombiecheck | Checking for orphan process with PID: 1916
[task 2021-01-13T10:43:42.735Z] 10:43:42     INFO - mozcrash Copy/paste: /builds/worker/fetches/minidump_stackwalk/minidump_stackwalk /tmp/tmpfIwKFt.mozrunner/minidumps/4b8dddfd-cb28-851d-0b73-10413ea46635.dmp /builds/worker/workspace/build/symbols
[task 2021-01-13T10:43:47.044Z] 10:43:47     INFO - mozcrash Saved minidump as /builds/worker/workspace/build/blobber_upload_dir/4b8dddfd-cb28-851d-0b73-10413ea46635.dmp
[task 2021-01-13T10:43:47.044Z] 10:43:47     INFO - mozcrash Saved app info as /builds/worker/workspace/build/blobber_upload_dir/4b8dddfd-cb28-851d-0b73-10413ea46635.extra
[task 2021-01-13T10:43:47.157Z] 10:43:47     INFO - PROCESS-CRASH | Main app process exited normally | application crashed [@ libc.so.6 + 0x114cf9]
[task 2021-01-13T10:43:47.158Z] 10:43:47     INFO - Crash dump filename: /tmp/tmpfIwKFt.mozrunner/minidumps/4b8dddfd-cb28-851d-0b73-10413ea46635.dmp
[task 2021-01-13T10:43:47.158Z] 10:43:47     INFO - Operating system: Linux
[task 2021-01-13T10:43:47.159Z] 10:43:47     INFO -                   0.0.0 Linux 4.4.0-1014-aws #14taskcluster1-Ubuntu SMP Tue Apr 3 10:27:00 UTC 2018 x86_64
[task 2021-01-13T10:43:47.159Z] 10:43:47     INFO - CPU: amd64
[task 2021-01-13T10:43:47.159Z] 10:43:47     INFO -      family 6 model 85 stepping 4
[task 2021-01-13T10:43:47.160Z] 10:43:47     INFO -      2 CPUs
[task 2021-01-13T10:43:47.161Z] 10:43:47     INFO - 
[task 2021-01-13T10:43:47.161Z] 10:43:47     INFO - GPU: UNKNOWN
[task 2021-01-13T10:43:47.161Z] 10:43:47     INFO - 
[task 2021-01-13T10:43:47.162Z] 10:43:47     INFO - Crash reason:  SIGABRT
[task 2021-01-13T10:43:47.162Z] 10:43:47     INFO - Crash address: 0x3e8000005c0
[task 2021-01-13T10:43:47.163Z] 10:43:47     INFO - Process uptime: not available```

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit auto_nag documentation.

Status: NEW → RESOLVED
Closed: 4 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.