Closed Bug 1875664 Opened 1 year ago Closed 11 months ago

Intermittent motionmark_webgl | single tracking bug

Categories

(Testing :: Talos, defect, P5)

Product:
Testing
Component:
Talos
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, intermittent-testcase)

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

[task 2024-01-21T04:53:27.391Z] 04:53:27     INFO -   'TASK_ID': 'LJgzXrqgTQu6V2BvlfOu3w',
[task 2024-01-21T04:53:27.391Z] 04:53:27     INFO -   'TERM': 'xterm-256color',
[task 2024-01-21T04:53:27.391Z] 04:53:27     INFO -   'TMOUT': '86400',
[task 2024-01-21T04:53:27.391Z] 04:53:27     INFO -   'USER': 'cltbld',
[task 2024-01-21T04:53:27.392Z] 04:53:27     INFO -   'VIRTUAL_ENV': 'venv',
[task 2024-01-21T04:53:27.392Z] 04:53:27     INFO -   'VTE_VERSION': '5202',
[task 2024-01-21T04:53:27.392Z] 04:53:27     INFO -   'XDG_CONFIG_DIRS': '/etc/xdg/xdg-ubuntu:/etc/xdg',
[task 2024-01-21T04:53:27.392Z] 04:53:27     INFO -   'XDG_CURRENT_DESKTOP': 'GNOME',
[task 2024-01-21T04:53:27.392Z] 04:53:27     INFO -   'XDG_DATA_DIRS': '/usr/share/ubuntu:/usr/share/gnome:/usr/local/share:/usr/share:/var/lib/snapd/desktop',
[task 2024-01-21T04:53:27.392Z] 04:53:27     INFO -   'XDG_MENU_PREFIX': 'gnome-',
[task 2024-01-21T04:53:27.392Z] 04:53:27     INFO -   'XDG_RUNTIME_DIR': '/run/user/1006',
[task 2024-01-21T04:53:27.393Z] 04:53:27     INFO -   'XDG_SESSION_ID': 'c1',
[task 2024-01-21T04:53:27.393Z] 04:53:27     INFO -   'XMODIFIERS': '@im=ibus',
[task 2024-01-21T04:53:27.393Z] 04:53:27     INFO -   '_': '/usr/local/bin/start-worker'}
[task 2024-01-21T04:53:27.393Z] 04:53:27     INFO -  TEST-INFO | started process 5273 (/home/cltbld/tasks/task_170581258483164/build/application/firefox/firefox -profile /tmp/tmpmbj2jy0_/profile)
[task 2024-01-21T04:53:28.132Z] 04:53:28     INFO -  PID 5273 | console.error: ({})
[task 2024-01-21T04:53:29.370Z] 04:53:29     INFO -  PID 5273 | Inconsistency detected by ld.so: ../elf/dl-tls.c: 481: _dl_allocate_tls_init: Assertion `listp->slotinfo[cnt].gen <= GL(dl_tls_generation)' failed!
[task 2024-01-21T04:53:29.384Z] 04:53:29     INFO -  PID 5273 | Exiting due to channel error.
[task 2024-01-21T04:53:29.384Z] 04:53:29     INFO -  PID 5273 | Exiting due to channel error.
[task 2024-01-21T04:53:29.384Z] 04:53:29     INFO -  PID 5273 | Exiting due to channel error.
[task 2024-01-21T04:53:29.384Z] 04:53:29     INFO -  PID 5273 | Exiting due to channel error.
[task 2024-01-21T04:53:29.385Z] 04:53:29     INFO -  PID 5273 | Exiting due to channel error.
[task 2024-01-21T04:53:29.386Z] 04:53:29     INFO -  PID 5273 | Exiting due to channel error.
[task 2024-01-21T04:53:29.396Z] 04:53:29     INFO -  PID 5273 | Exiting due to channel error.
[task 2024-01-21T04:53:29.438Z] 04:53:29     INFO -  TEST-INFO | 5273: exit 127
[task 2024-01-21T04:53:29.454Z] 04:53:29     INFO -  mozcrash checking /tmp/tmpmbj2jy0_/profile/minidumps for minidumps...
[task 2024-01-21T04:53:29.455Z] 04:53:29     INFO -  TEST-UNEXPECTED-ERROR | motionmark_webgl | Could not find report in browser output: [('tsformat', ('__start_report', '__end_report')), ('tpformat', ('__start_tp_report', '__end_tp_report'))]
[task 2024-01-21T04:53:29.456Z] 04:53:29    ERROR -  Traceback (most recent call last):
[task 2024-01-21T04:53:29.456Z] 04:53:29     INFO -    File "/home/cltbld/tasks/task_170581258483164/build/tests/talos/talos/run_tests.py", line 370, in run_tests
[task 2024-01-21T04:53:29.456Z] 04:53:29     INFO -      mytest.runTest(browser_config, test, utility_path=utility_path)
[task 2024-01-21T04:53:29.457Z] 04:53:29     INFO -    File "/home/cltbld/tasks/task_170581258483164/build/tests/talos/talos/ttest.py", line 61, in runTest
[task 2024-01-21T04:53:29.457Z] 04:53:29     INFO -      return self._runTest(
[task 2024-01-21T04:53:29.458Z] 04:53:29     INFO -    File "/home/cltbld/tasks/task_170581258483164/build/tests/talos/talos/ttest.py", line 261, in _runTest
[task 2024-01-21T04:53:29.458Z] 04:53:29     INFO -      test_results.add(
[task 2024-01-21T04:53:29.459Z] 04:53:29     INFO -    File "/home/cltbld/tasks/task_170581258483164/build/tests/talos/talos/results.py", line 92, in add
[task 2024-01-21T04:53:29.459Z] 04:53:29     INFO -      browserLog = BrowserLogResults(
[task 2024-01-21T04:53:29.460Z] 04:53:29     INFO -    File "/home/cltbld/tasks/task_170581258483164/build/tests/talos/talos/results.py", line 347, in __init__
[task 2024-01-21T04:53:29.460Z] 04:53:29     INFO -      self.parse()
[task 2024-01-21T04:53:29.461Z] 04:53:29     INFO -    File "/home/cltbld/tasks/task_170581258483164/build/tests/talos/talos/results.py", line 373, in parse
[task 2024-01-21T04:53:29.461Z] 04:53:29     INFO -      self.error(
[task 2024-01-21T04:53:29.462Z] 04:53:29     INFO -    File "/home/cltbld/tasks/task_170581258483164/build/tests/talos/talos/results.py", line 358, in error
[task 2024-01-21T04:53:29.462Z] 04:53:29     INFO -      raise utils.TalosError(message)
[task 2024-01-21T04:53:29.463Z] 04:53:29     INFO -  talos.utils.TalosError: Could not find report in browser output: [('tsformat', ('__start_report', '__end_report')), ('tpformat', ('__start_tp_report', '__end_tp_report'))]
[task 2024-01-21T04:53:29.463Z] 04:53:29     INFO -  TEST-INFO took 7167ms
[task 2024-01-21T04:53:29.463Z] 04:53:29     INFO -  SUITE-END | took 141s
[task 2024-01-21T04:53:29.915Z] 04:53:29     INFO - Return code: 2
[task 2024-01-21T04:53:29.915Z] 04:53:29  WARNING - setting return code to 2
[task 2024-01-21T04:53:29.916Z] 04:53:29     INFO - Running post-action listener: _package_coverage_data
[task 2024-01-21T04:53:29.916Z] 04:53:29     INFO - Running post-action listener: _resource_record_post_action
[task 2024-01-21T04:53:29.916Z] 04:53:29     INFO - Running post-action listener: process_java_coverage_data
[task 2024-01-21T04:53:29.916Z] 04:53:29     INFO - [mozharness: 2024-01-21 04:53:29.916301Z] Finished run-tests step (success)
[task 2024-01-21T04:53:29.916Z] 04:53:29     INFO - Running post-run listener: _resource_record_post_run
[task 2024-01-21T04:53:30.124Z] 04:53:30     INFO - Total resource usage - Wall time: 153s; CPU: 16%; Read bytes: 38715392; Write bytes: 1109245952; Read time: 30880; Write time: 62216
[task 2024-01-21T04:53:30.124Z] 04:53:30     INFO - TinderboxPrint: CPU usage<br/>15.7%
[task 2024-01-21T04:53:30.124Z] 04:53:30     INFO - TinderboxPrint: I/O read bytes / time<br/>38,715,392 / 30,880
[task 2024-01-21T04:53:30.124Z] 04:53:30     INFO - TinderboxPrint: I/O write bytes / time<br/>1,109,245,952 / 62,216
[task 2024-01-21T04:53:30.124Z] 04:53:30     INFO - TinderboxPrint: CPU idle<br/>999.4 (82.0%)
[task 2024-01-21T04:53:30.124Z] 04:53:30     INFO - TinderboxPrint: CPU iowait<br/>25.9 (2.1%)
[task 2024-01-21T04:53:30.124Z] 04:53:30     INFO - TinderboxPrint: CPU system<br/>44.5 (3.6%)
[task 2024-01-21T04:53:30.124Z] 04:53:30     INFO - TinderboxPrint: CPU user<br/>146.4 (12.0%)
[task 2024-01-21T04:53:30.124Z] 04:53:30     INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2024-01-21T04:53:30.129Z] 04:53:30     INFO - install - Wall time: 11s; CPU: 13%; Read bytes: 237568; Write bytes: 20561920; Read time: 0; Write time: 80
[task 2024-01-21T04:53:30.177Z] 04:53:30     INFO - run-tests - Wall time: 142s; CPU: 16%; Read bytes: 38477824; Write bytes: 1088684032; Read time: 30880; Write time: 62136
[task 2024-01-21T04:53:31.184Z] 04:53:31  WARNING - returning nonzero exit status 2
[taskcluster 2024-01-21T04:53:31.243Z]    Exit Code: 2
[taskcluster 2024-01-21T04:53:31.243Z]    User Time: 3m9.512616s
[taskcluster 2024-01-21T04:53:31.243Z]  Kernel Time: 41.911038s
[taskcluster 2024-01-21T04:53:31.243Z]    Wall Time: 3m44.509783955s
[taskcluster 2024-01-21T04:53:31.243Z]       Result: FAILED
[taskcluster 2024-01-21T04:53:31.243Z] === Task Finished ===
[taskcluster 2024-01-21T04:53:31.243Z] Task Duration: 3m44.513070844s
[taskcluster 2024-01-21T04:53:31.375Z] Uploading artifact public/logs/localconfig.json from file logs/localconfig.json with content encoding "gzip", mime type "application/json" and expiry 2025-01-20T01:05:15.284Z
[taskcluster 2024-01-21T04:53:31.672Z] Uploading artifact public/test_info/profile_resource-usage.json from file build/blobber_upload_dir/profile_resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2025-01-20T01:05:15.284Z
[taskcluster 2024-01-21T04:53:31.964Z] Uploading artifact public/test_info/resource-usage.json from file build/blobber_upload_dir/resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2025-01-20T01:05:15.284Z
[taskcluster 2024-01-21T04:53:32.310Z] Uploading artifact public/test_info/webgl_errorsummary.log from file build/blobber_upload_dir/webgl_errorsummary.log with content encoding "gzip", mime type "text/plain" and expiry 2025-01-20T01:05:15.284Z
[taskcluster 2024-01-21T04:53:32.577Z] Uploading link artifact public/logs/live.log to artifact public/logs/live_backing.log with expiry 2025-01-20T01:05:15.284Z
[taskcluster:error] exit status 2

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

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