Closed Bug 1834857 Opened 2 years ago Closed 2 years ago

Intermittent tp5n | expected string or bytes-like object

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)

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

[task 2023-05-24T19:20:08.945Z] 19:20:08     INFO -  TEST-INFO | started process 9176 (Z:\task_168495102455469\build\application\firefox\firefox -wait-for-browser -no-deelevate -profile C:\Users\task_168495102455469\AppData\Local\Temp\tmpc79pcknj\profile)
[task 2023-05-24T19:20:09.121Z] 19:20:09     INFO -  PID 9176 | [GFX1-]: VendorIDMismatch V 0 0x1414
[task 2023-05-24T19:20:09.419Z] 19:20:09     INFO -  PID 9176 | [GFX1-]: [D3D11] create swap chain failed: 0x887a0022, 0
[task 2023-05-24T19:20:09.419Z] 19:20:09     INFO -  PID 9176 | [GFX1-]: Failed to initialize CompositorD3D11 for SWGL: FEATURE_FAILURE_D3D11_SWAP_CHAIN
[task 2023-05-24T19:20:09.575Z] 19:20:09     INFO -  PID 9176 | [GFX1-]: RenderCompositorSWGL failed mapping default framebuffer, no dt
[task 2023-05-24T19:20:09.669Z] 19:20:09     INFO -  PID 9176 | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-05-24T19:20:10.768Z] 19:20:10     INFO -  PID 9176 | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-05-24T19:20:10.780Z] 19:20:10     INFO -  PID 9176 | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-05-24T19:20:11.066Z] 19:20:11     INFO -  PID 9176 | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-05-24T19:20:11.066Z] 19:20:11     INFO -  PID 9176 | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-05-24T19:20:11.066Z] 19:20:11     INFO -  PID 9176 | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-05-24T19:20:15.287Z] 19:20:15     INFO -  PID 9176 | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-05-24T19:20:41.617Z] 19:20:41     INFO -  PID 9176 | console.error: (new Error("Polling for changes failed: Unexpected content-type \"text/plain;charset=US-ASCII\".", "resource://services-settings/remote-settings.sys.mjs", 324))
[task 2023-05-24T19:20:41.631Z] 19:20:41     INFO -  PID 9176 | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-05-24T19:20:41.631Z] 19:20:41     INFO -  PID 9176 | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-05-24T19:20:45.915Z] 19:20:45     INFO -  PID 9176 | 1684956045916	addons.xpi	ERROR	System addon update list error Error: Failed downloading XML, status: 0, channelStatus: 2152398861, errorCode: 2, reason: error
[task 2023-05-24T19:20:45.931Z] 19:20:45     INFO -  PID 9176 | console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2023-05-24T19:50:08.953Z] 19:50:08     INFO -  Timeout waiting for test completion; killing browser...
[task 2023-05-24T19:50:08.959Z] 19:50:08     INFO -  mozcrash Writing a dump to C:\Users\task_168495102455469\AppData\Local\Temp\tmpc79pcknj\profile\minidumps\6875c15e-55b6-4b70-a0c8-9bfaaae028c6.dmp for [5340]
[task 2023-05-24T19:50:09.439Z] 19:50:09     INFO -  PID 9176 | Exiting due to channel error.
[task 2023-05-24T19:50:09.470Z] 19:50:09     INFO -  mozcrash checking C:\Users\task_168495102455469\AppData\Local\Temp\tmpc79pcknj\profile\minidumps for minidumps...
[task 2023-05-24T19:50:09.470Z] 19:50:09     INFO -  mozcrash Downloading symbols from: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/WQ1oDNoeQ0uFDC4lNU0Fgg/artifacts/public/build/target.crashreporter-symbols.zip
[task 2023-05-24T19:50:53.016Z] 19:50:53     INFO -  mozcrash Copy/paste: Z:/task_168495102455469/fetches\minidump-stackwalk\minidump-stackwalk.exe --symbols-url=https://symbols.mozilla.org/ --cyborg=C:\Users\task_168495102455469\AppData\Local\Temp\tmpzoso7bxr\6875c15e-55b6-4b70-a0c8-9bfaaae028c6.trace C:\Users\task_168495102455469\AppData\Local\Temp\tmpc79pcknj\profile\minidumps\6875c15e-55b6-4b70-a0c8-9bfaaae028c6.dmp C:\Users\task_168495102455469\AppData\Local\Temp\tmp_fw9sbgp
[task 2023-05-24T19:51:01.956Z] 19:51:01     INFO -  TEST-UNEXPECTED-ERROR | tp5n | expected string or bytes-like object
[task 2023-05-24T19:51:01.959Z] 19:51:01    ERROR -  Traceback (most recent call last):
[task 2023-05-24T19:51:01.959Z] 19:51:01     INFO -    File "Z:\task_168495102455469\build\tests\talos\talos\ttest.py", line 191, in _runTest
[task 2023-05-24T19:51:01.959Z] 19:51:01     INFO -      pcontext = run_browser(
[task 2023-05-24T19:51:01.960Z] 19:51:01     INFO -    File "Z:\task_168495102455469\build\tests\talos\talos\talos_process.py", line 174, in run_browser
[task 2023-05-24T19:51:01.960Z] 19:51:01     INFO -      raise TalosError("timeout")
[task 2023-05-24T19:51:01.960Z] 19:51:01     INFO -  talos.utils.TalosError: timeout
[task 2023-05-24T19:51:01.960Z] 19:51:01     INFO -  During handling of the above exception, another exception occurred:
[task 2023-05-24T19:51:01.960Z] 19:51:01    ERROR -  Traceback (most recent call last):
[task 2023-05-24T19:51:01.961Z] 19:51:01     INFO -    File "Z:\task_168495102455469\build\tests\talos\talos\run_tests.py", line 357, in run_tests
[task 2023-05-24T19:51:01.961Z] 19:51:01     INFO -      talos_results.add(mytest.runTest(browser_config, test))
[task 2023-05-24T19:51:01.961Z] 19:51:01     INFO -    File "Z:\task_168495102455469\build\tests\talos\talos\ttest.py", line 61, in runTest
[task 2023-05-24T19:51:01.961Z] 19:51:01     INFO -      return self._runTest(browser_config, test_config, setup)
[task 2023-05-24T19:51:01.961Z] 19:51:01     INFO -    File "Z:\task_168495102455469\build\tests\talos\talos\ttest.py", line 205, in _runTest
[task 2023-05-24T19:51:01.962Z] 19:51:01     INFO -      self.check_for_crashes(
[task 2023-05-24T19:51:01.962Z] 19:51:01     INFO -    File "Z:\task_168495102455469\build\tests\talos\talos\ttest.py", line 39, in check_for_crashes
[task 2023-05-24T19:51:01.962Z] 19:51:01     INFO -      found = mozcrash.check_for_crashes(
[task 2023-05-24T19:51:01.962Z] 19:51:01     INFO -    File "Z:\task_168495102455469\build\venv\lib\site-packages\mozcrash\mozcrash.py", line 115, in check_for_crashes
[task 2023-05-24T19:51:01.962Z] 19:51:01     INFO -      for info in crash_info:
[task 2023-05-24T19:51:01.963Z] 19:51:01     INFO -    File "Z:\task_168495102455469\build\venv\lib\site-packages\mozcrash\mozcrash.py", line 327, in __iter__
[task 2023-05-24T19:51:01.963Z] 19:51:01     INFO -      rv = self._process_dump_file(path, extra)
[task 2023-05-24T19:51:01.963Z] 19:51:01     INFO -    File "Z:\task_168495102455469\build\venv\lib\site-packages\mozcrash\mozcrash.py", line 402, in _process_dump_file
[task 2023-05-24T19:51:01.963Z] 19:51:01     INFO -      pmatch = re.search(r"(.*)\(.*\)", signature)
[task 2023-05-24T19:51:01.963Z] 19:51:01     INFO -    File "c:\mozilla-build\python3\lib\re.py", line 201, in search
[task 2023-05-24T19:51:01.963Z] 19:51:01     INFO -      return _compile(pattern, flags).search(string)
[task 2023-05-24T19:51:01.964Z] 19:51:01    ERROR -  TypeError: expected string or bytes-like object
[task 2023-05-24T19:51:01.964Z] 19:51:01     INFO -  TEST-INFO took 1895399ms
[task 2023-05-24T19:51:01.964Z] 19:51:01     INFO -  SUITE-END | took 1895s
[task 2023-05-24T19:51:02.363Z] 19:51:02     INFO - Return code: 2
[task 2023-05-24T19:51:02.363Z] 19:51:02  WARNING - setting return code to 2
[task 2023-05-24T19:51:02.363Z] 19:51:02     INFO - Running post-action listener: _package_coverage_data
[task 2023-05-24T19:51:02.363Z] 19:51:02     INFO - Running post-action listener: _resource_record_post_action
[task 2023-05-24T19:51:02.363Z] 19:51:02     INFO - Running post-action listener: process_java_coverage_data
[task 2023-05-24T19:51:02.363Z] 19:51:02     INFO - [mozharness: 2023-05-24 19:51:02.363851Z] Finished run-tests step (success)
[task 2023-05-24T19:51:02.363Z] 19:51:02     INFO - Running post-run listener: _resource_record_post_run
[task 2023-05-24T19:51:03.035Z] 19:51:03     INFO - Total resource usage - Wall time: 1898s; CPU: 20%; Read bytes: 325459456; Write bytes: 1977846272; Read time: 8; Write time: 51
[task 2023-05-24T19:51:03.035Z] 19:51:03     INFO - TinderboxPrint: CPU usage<br/>19.7%
[task 2023-05-24T19:51:03.035Z] 19:51:03     INFO - TinderboxPrint: I/O read bytes / time<br/>325,459,456 / 8
[task 2023-05-24T19:51:03.045Z] 19:51:03     INFO - TinderboxPrint: I/O write bytes / time<br/>1,977,846,272 / 51
[task 2023-05-24T19:51:03.045Z] 19:51:03     INFO - TinderboxPrint: CPU idle<br/>12,189.5 (80.3%)
[task 2023-05-24T19:51:03.045Z] 19:51:03     INFO - TinderboxPrint: CPU system<br/>1,132.4 (7.5%)
[task 2023-05-24T19:51:03.045Z] 19:51:03     INFO - TinderboxPrint: CPU user<br/>1,861.0 (12.3%)
[task 2023-05-24T19:51:03.046Z] 19:51:03     INFO - install - Wall time: 3s; CPU: 31%; Read bytes: 341504; Write bytes: 45047808; Read time: 0; Write time: 1
[task 2023-05-24T19:51:03.057Z] 19:51:03     INFO - run-tests - Wall time: 1896s; CPU: 20%; Read bytes: 324760064; Write bytes: 1918917120; Read time: 8; Write time: 50
[task 2023-05-24T19:51:03.472Z] 19:51:03  WARNING - returning nonzero exit status 2
[taskcluster 2023-05-24T19:51:03.535Z]    Exit Code: 2
[taskcluster 2023-05-24T19:51:03.535Z]    User Time: 0s
[taskcluster 2023-05-24T19:51:03.535Z]  Kernel Time: 0s
[taskcluster 2023-05-24T19:51:03.535Z]    Wall Time: 34m50.4263102s
[taskcluster 2023-05-24T19:51:03.535Z]       Result: FAILED
[taskcluster 2023-05-24T19:51:03.535Z] === Task Finished ===
[taskcluster 2023-05-24T19:51:03.535Z] Task Duration: 34m50.4311345s
[taskcluster 2023-05-24T19:51:03.657Z] Uploading artifact public/logs/localconfig.json from file logs\localconfig.json with content encoding "gzip", mime type "application/json" and expiry 2024-05-23T17:30:05.958Z
[taskcluster 2023-05-24T19:51:04.132Z] 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 2024-05-23T17:30:05.958Z
[taskcluster 2023-05-24T19:51:04.750Z] Uploading artifact public/test_info/xperf_errorsummary.log from file build\blobber_upload_dir\xperf_errorsummary.log with content encoding "gzip", mime type "text/plain" and expiry 2024-05-23T17:30:05.958Z
[taskcluster 2023-05-24T19:51:05.323Z] Uploading link artifact public/logs/live.log to artifact public/logs/live_backing.log with expiry 2024-05-23T17:30:05.958Z
[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: 2 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.