1834900 - Intermittent caught OS error None: None while running ['Z:\\task_168496608752765\\build\\venv\\Scripts\\python', '-u', 'Z:\\task_168496608752765\\build\\tests\\web-platform\\runtests.py', '--log-raw=-', '--log-wptreport=Z:\\task_168496608752765\\build\\

Status: RESOLVED INCOMPLETE

(Release Engineering :: Applications: MozharnessCore, defect, P5)

Description

[Treeherder Bug Filer]

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

---

[task 2023-05-24T23:51:16.118Z] Exception in thread ProcessReader:
[task 2023-05-24T23:51:16.118Z] Traceback (most recent call last):
[task 2023-05-24T23:51:16.118Z]   File "c:\mozilla-build\python3\lib\threading.py", line 973, in _bootstrap_inner
[task 2023-05-24T23:51:16.118Z]     self.run()
[task 2023-05-24T23:51:16.118Z]   File "c:\mozilla-build\python3\lib\threading.py", line 910, in run
[task 2023-05-24T23:51:16.119Z]     self._target(*self._args, **self._kwargs)
[task 2023-05-24T23:51:16.119Z]   File "Z:\task_168496608752765\mozharness\mozprocess\processhandler.py", line 1160, in _read
[task 2023-05-24T23:51:16.120Z]     callback(line.rstrip())
[task 2023-05-24T23:51:16.120Z]   File "Z:\task_168496608752765\mozharness\mozprocess\processhandler.py", line 1066, in __call__
[task 2023-05-24T23:51:16.121Z]     e(*args, **kwargs)
[task 2023-05-24T23:51:16.121Z]   File "Z:\task_168496608752765\mozharness\mozharness\base\script.py", line 1600, in processOutput
[task 2023-05-24T23:51:16.121Z]     parser.add_lines(line)
[task 2023-05-24T23:51:16.121Z]   File "Z:\task_168496608752765\mozharness\mozharness\base\log.py", line 371, in add_lines
[task 2023-05-24T23:51:16.121Z]     self.parse_single_line(line)
[task 2023-05-24T23:51:16.121Z]   File "Z:\task_168496608752765\mozharness\mozharness\mozilla\structuredlog.py", line 124, in parse_single_line
[task 2023-05-24T23:51:16.122Z]     log_data = self.formatter(data)
[task 2023-05-24T23:51:16.122Z]   File "Z:\task_168496608752765\build\venv\Lib\site-packages\mozlog\formatters\tbplformatter.py", line 47, in __call__
[task 2023-05-24T23:51:16.122Z]     return super(TbplFormatter, self).__call__(data)
[task 2023-05-24T23:51:16.122Z]   File "Z:\task_168496608752765\build\venv\Lib\site-packages\mozlog\reader.py", line 72, in __call__
[task 2023-05-24T23:51:16.122Z]     return handler(data)
[task 2023-05-24T23:51:16.122Z]   File "Z:\task_168496608752765\build\venv\Lib\site-packages\mozlog\formatters\tbplformatter.py", line 311, in suite_end
[task 2023-05-24T23:51:16.123Z]     time = int((data["time"] - start_time) / 1000)
[task 2023-05-24T23:51:16.123Z] TypeError: unsupported operand type(s) for -: 'int' and 'NoneType'
[task 2023-05-24T23:54:46.260Z] Traceback (most recent call last):
[task 2023-05-24T23:54:46.260Z]   File "Z:\task_168496608752765\mozharness\mozprocess\processhandler.py", line 640, in _custom_wait
[task 2023-05-24T23:54:46.260Z]     item = self._process_events.get(timeout=timeout)
[task 2023-05-24T23:54:46.260Z]   File "c:\mozilla-build\python3\lib\queue.py", line 179, in get
[task 2023-05-24T23:54:46.260Z]     raise Empty
[task 2023-05-24T23:54:46.260Z] _queue.Empty
[task 2023-05-24T23:54:46.267Z] 23:54:46    ERROR - caught OS error None: None while running ['Z:\\task_168496608752765\\build\\venv\\Scripts\\python', '-u', 'Z:\\task_168496608752765\\build\\tests\\web-platform\\runtests.py', '--log-raw=-', '--log-wptreport=Z:\\task_168496608752765\\build\\blobber_upload_dir\\wptreport.json', '--log-errorsummary=Z:\\task_168496608752765\\build\\blobber_upload_dir\\wpt_errorsummary.log', '--symbols-path=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/EPF2rddvS2Cktza98Tzxqw/artifacts/public/build/target.crashreporter-symbols.zip', '--stackwalk-binary=Z:/task_168496608752765/fetches\\minidump-stackwalk\\minidump-stackwalk.exe', '--stackfix-dir=Z:\\task_168496608752765\\build\\tests\\bin', '--no-pause-after-test', '--instrument-to-file=Z:\\task_168496608752765\\build\\blobber_upload_dir\\wpt_instruments.txt', '--specialpowers-path=Z:\\task_168496608752765\\build\\tests\\extensions\\[e-mail]', '--processes=1', '--binary=Z:\\task_168496608752765\\build\\application\\firefox\\firefox.exe', '--install-fonts', '--test-type=testharness', '--setpref=media.peerconnection.mtransport_process=false', '--setpref=network.process.enabled=false', '--setpref=layers.d3d11.enable-blacklist=false', '--skip-timeout', '--skip-implementation-status=backlog', '--skip-implementation-status=not-implementing', '--test-groups=Z:/task_168496608752765/fetches\\wpt_tests_by_group.json', '--prefs-root=Z:\\task_168496608752765\\build\\tests\\web-platform\\prefs', '--config=Z:\\task_168496608752765\\build\\tests\\web-platform\\wptrunner.ini', '--ca-cert-path=Z:\\task_168496608752765\\build\\tests\\web-platform\\tests\\tools\\certs\\cacert.pem', '--host-key-path=Z:\\task_168496608752765\\build\\tests\\web-platform\\tests\\tools\\certs\\web-platform.test.key', '--host-cert-path=Z:\\task_168496608752765\\build\\tests\\web-platform\\tests\\tools\\certs\\web-platform.test.pem', '--certutil-binary=Z:\\task_168496608752765\\build\\tests\\bin\\certutil.exe', '--exclude=webgpu', '--exclude=_mozilla/webgpu', '/wasm/jsapi/instance', '/html/cross-origin-opener-policy/historical', '/css/css-typed-om/stylevalue-normalization', '/css/motion/animation', '/webaudio/the-audio-api/the-iirfilternode-interface', '/largest-contentful-paint', '/webrtc-encoded-transform', '/css/css-position', '/webaudio/the-audio-api/the-audioworklet-interface', '/_mozilla/webgpu/chunked/23', '/css/css-values/animations', '/navigation-api/state', '/mixed-content/gen/top.meta', '/cookies', '/fetch/api/response', '/css/css-color-adjust/parsing', '/clipboard-apis', '/web-animations/interfaces/KeyframeEffect', '/css/cssom', '/css/css-fonts/font-display', '/bluetooth/server', '/referrer-policy/gen/worker-classic.http-rp', '/css/css-box/parsing', '/pointerevents/pointerlock', '/permissions-policy', '/html/semantics/popovers', '/_mozilla/baselinecoverage', '/css/css-toggle', '/websockets', '/html/editing/focus', '/css/css-ruby', '/visual-viewport', '/svg/painting/scripted', '/css/css-content', '/infrastructure/testdriver', '/payment-request', '/css/css-grid/grid-definition', '/entries-api', '/web-otp', '/managed', '/delegated-ink', '/content-security-policy/parsing', '/xhr', '/dom/traversal', '/html/syntax/serializing-xml-fragments', '/navigation-api/currententrychange-event', '/upgrade-insecure-requests/gen/worker-classic.http-rp', '/_mozilla/webgpu/chunked/14', '/css/css-flexbox', '/dom', '/svg/extensibility/foreignObject', '/content-security-policy/default-src', '/cookies/samesite-none-secure', '/webaudio/the-audio-api/the-waveshapernode-interface', '/custom-elements/custom-element-registry', '/speculation-rules/prefetch/no-vary-search', '/web-animations/animation-model/animation-types', '/html/webappapis/scripting', '/css/css-outline', '/fetch/api', '/content-security-policy/style-src', '/import-maps/acquiring', '/client-hints', '/shadow-dom/untriaged/styles', '/mimesniff/media', '/_mozilla/fetch/api/redirect', '/webvtt/api', '/mathml/relations/css-styling', '/css/css-animations', '/css/css-scrollbars', '/_mozilla/xml', '/css/css-masking/animations', '/streams/transferable', '/is-input-pending/security', '/orientation-sensor', '/css/css-images/animation', '/uievents/interface', '/service-workers/service-worker/navigation-preload', '/css/CSS2/floats', '/css/compositing/parsing', '/webmessaging', '/html/links/icon', '/bluetooth/characteristic/getDescriptors', '/selection/textcontrols', '/workers/baseurl/alpha', '/css/css-text/line-breaking', '/WebCryptoAPI', '/push-api', '/websockets/opening-handshake', '/_mozilla/webgpu/chunked/50', '/hr-time', '/html/select', '/resource-timing/initiator-type', '/css/css-tables/parsing', '/fetch/images', '/mediacapture-fromelement', '/_mozilla/webgpu/chunked/41', '/workers/semantics/encodings', '/compute-pressure', '/upgrade-insecure-requests/gen/sharedworker-classic-data.http-rp', '/fetch/redirects', '/referrer-policy/css-integration/svg', '/webxr/depth-sensing/cpu', '/svg/shapes/scripted', '/bluetooth/device/forget', '/css/css-sizing', '/_mozilla/mediacapture-streams', '/fullscreen', '/autoplay-policy-detection', '/content-security-policy/inheritance', '/scroll-animations/scroll-timelines', '/timing-entrytypes-registry', '/html/browsers/the-window-object', '/encoding-detection', '/css/css-inline/text-box-trim', '/_mozilla/webgpu/chunked/32']
[task 2023-05-24T23:54:46.267Z] 23:54:46  WARNING - setting return code to 2
[task 2023-05-24T23:54:46.267Z] 23:54:46     INFO - Running post-action listener: _package_coverage_data
[task 2023-05-24T23:54:46.267Z] 23:54:46     INFO - Running post-action listener: _resource_record_post_action
[task 2023-05-24T23:54:46.268Z] 23:54:46     INFO - Running post-action listener: process_java_coverage_data
[task 2023-05-24T23:54:46.268Z] 23:54:46     INFO - Running post-action listener: stop_device
[task 2023-05-24T23:54:46.268Z] 23:54:46     INFO - [mozharness: 2023-05-24 23:54:46.268332Z] Finished run-tests step (success)
[task 2023-05-24T23:54:46.268Z] IO Completion Port unexpectedly closed23:54:46     INFO - Running post-run listener: _resource_record_post_run
[task 2023-05-24T23:54:46.268Z] 
[task 2023-05-24T23:54:46.573Z] 23:54:46     INFO - Total resource usage - Wall time: 2082s; CPU: 52%; Read bytes: 474725888; Write bytes: 4740111872; Read time: 61; Write time: 736
[task 2023-05-24T23:54:46.573Z] 23:54:46     INFO - TinderboxPrint: CPU usage<br/>52.1%
[task 2023-05-24T23:54:46.588Z] 23:54:46     INFO - TinderboxPrint: I/O read bytes / time<br/>474,725,888 / 61
[task 2023-05-24T23:54:46.588Z] 23:54:46     INFO - TinderboxPrint: I/O write bytes / time<br/>4,740,111,872 / 736
[task 2023-05-24T23:54:46.588Z] 23:54:46     INFO - TinderboxPrint: CPU idle<br/>8,005.8 (47.9%)
[task 2023-05-24T23:54:46.588Z] 23:54:46     INFO - TinderboxPrint: CPU system<br/>2,459.6 (14.7%)
[task 2023-05-24T23:54:46.588Z] 23:54:46     INFO - TinderboxPrint: CPU user<br/>6,192.3 (37.0%)
[task 2023-05-24T23:54:46.589Z] 23:54:46     INFO - pull - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2023-05-24T23:54:46.589Z] 23:54:46     INFO - start-emulator - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2023-05-24T23:54:46.590Z] 23:54:46     INFO - verify-device - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2023-05-24T23:54:46.590Z] 23:54:46     INFO - install - Wall time: 4s; CPU: 29%; Read bytes: 4954112; Write bytes: 96149504; Read time: 0; Write time: 6
[task 2023-05-24T23:54:46.602Z] 23:54:46     INFO - run-tests - Wall time: 2079s; CPU: 52%; Read bytes: 469047296; Write bytes: 4585664000; Read time: 61; Write time: 728
[task 2023-05-24T23:54:47.073Z] 23:54:47  WARNING - returning nonzero exit status 2
[taskcluster 2023-05-24T23:54:47.151Z]    Exit Code: 2
[taskcluster 2023-05-24T23:54:47.151Z]    User Time: 0s
[taskcluster 2023-05-24T23:54:47.151Z]  Kernel Time: 31.25ms
[taskcluster 2023-05-24T23:54:47.151Z]    Wall Time: 39m32.4636393s
[taskcluster 2023-05-24T23:54:47.151Z]       Result: FAILED
[taskcluster 2023-05-24T23:54:47.151Z] === Task Finished ===
[taskcluster 2023-05-24T23:54:47.151Z] Task Duration: 39m32.4969949s
[taskcluster 2023-05-24T23:54:47.302Z] Uploading artifact public/logs/localconfig.json from file logs\localconfig.json with content encoding "gzip", mime type "application/json" and expiry 2024-05-23T23:14:52.372Z
[taskcluster 2023-05-24T23:54:47.740Z] 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-23T23:14:52.372Z
[taskcluster 2023-05-24T23:54:48.361Z] Uploading artifact public/test_info/wpt_errorsummary.log from file build\blobber_upload_dir\wpt_errorsummary.log with content encoding "gzip", mime type "text/plain" and expiry 2024-05-23T23:14:52.372Z
[taskcluster 2023-05-24T23:54:48.552Z] Uploading artifact public/test_info/wpt_instruments.txt from file build\blobber_upload_dir\wpt_instruments.txt with content encoding "gzip", mime type "text/plain; charset=utf-8" and expiry 2024-05-23T23:14:52.372Z
[taskcluster 2023-05-24T23:54:48.779Z] Uploading artifact public/test_info/wptreport.json from file build\blobber_upload_dir\wptreport.json with content encoding "gzip", mime type "application/json" and expiry 2024-05-23T23:14:52.372Z
[taskcluster 2023-05-24T23:54:48.962Z] Uploading link artifact public/logs/live.log to artifact public/logs/live_backing.log with expiry 2024-05-23T23:14:52.372Z
[taskcluster:error] exit status 2

Comment 1

[Intermittent Failures Robot]

1 failures in 3946 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• windows11-64-2009-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1834900&startday=2023-05-22&endday=2023-05-28&tree=all

Comment 2

[Intermittent Failures Robot]

3 failures in 3471 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 3

Platform and build breakdown:

• windows11-32-2009-qr: 2
  • opt: 1
  • debug: 1
• windows11-64-2009-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1834900&startday=2023-05-29&endday=2023-06-04&tree=all

Comment 4

[Intermittent Failures Robot]

4 failures in 3885 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 4

Platform and build breakdown:

• windows11-32-2009-qr: 1
  • opt: 1
• windows11-64-2009-qr: 3
  • debug: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1834900&startday=2023-06-05&endday=2023-06-11&tree=all

Comment 5

[BugBot [:suhaib / :marco/ :calixte]]

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