1893814 - Intermittent FileNotFoundError: [WinError 2] The system cannot find the file specified: '\\\\?\\C:\\Users\\task_171423135650749\\AppData\\Local\\Temp\\tmpt1byyqu_.mozrunner\\plugins\\gmp-fake\\1.0\\manifest.json' | single tracking bug

Status: RESOLVED INCOMPLETE

(Core :: SVG, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: ctuns [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=456122207&repo=mozilla-esr115
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/cn5psavLQ5y3FfmjWr778g/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/cn5psavLQ5y3FfmjWr778g/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

---

[task 2024-04-27T15:35:33.135Z] 15:35:33     INFO - REFTEST TEST-PASS | layout/reftests/svg/smil/syncbase/filtered-interval-1.svg == layout/reftests/svg/smil/syncbase/green-box-ref.svg | image comparison, max difference: 0, number of differing pixels: 0
[task 2024-04-27T15:35:33.137Z] 15:35:33     INFO - REFTEST TEST-END | layout/reftests/svg/smil/syncbase/filtered-interval-1.svg == layout/reftests/svg/smil/syncbase/green-box-ref.svg
[task 2024-04-27T15:35:33.144Z] 15:35:33     INFO - REFTEST INFO | Slowest test took 238ms (file:///D:/task_171423135650749/build/tests/reftest/tests/layout/reftests/svg/smil/syncbase/cross-container-3.xhtml)
[task 2024-04-27T15:35:33.144Z] 15:35:33     INFO - REFTEST INFO | Total canvas count = 3
[task 2024-04-27T15:35:33.696Z] 15:35:33     INFO - 1714232133695	Marionette	TRACE	Received observer notification quit-application
[task 2024-04-27T15:35:33.696Z] 15:35:33     INFO - 1714232133695	Marionette	INFO	Stopped listening on port 2828
[task 2024-04-27T15:35:33.697Z] 15:35:33     INFO - 1714232133696	Marionette	DEBUG	Marionette stopped listening
[task 2024-04-27T15:35:33.777Z] 15:35:33     INFO - console.error: (new Error("Unexpected content-type \"text/plain;charset=US-ASCII\"", "resource://services-settings/Utils.sys.mjs", 399))
[task 2024-04-27T15:35:34.103Z] 15:35:34     INFO -  Traceback (most recent call last):
[task 2024-04-27T15:35:34.104Z] 15:35:34     INFO -    File "D:\task_171423135650749\build\tests\reftest\runreftest.py", line 1198, in <module>
[task 2024-04-27T15:35:34.104Z] 15:35:34     INFO -      sys.exit(run_test_harness(parser, options))
[task 2024-04-27T15:35:34.104Z] 15:35:34     INFO -               ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[task 2024-04-27T15:35:34.105Z] 15:35:34     INFO -    File "D:\task_171423135650749\build\tests\reftest\runreftest.py", line 1190, in run_test_harness
[task 2024-04-27T15:35:34.105Z] 15:35:34     INFO -      result = reftest.runTests(options.tests, options)
[task 2024-04-27T15:35:34.105Z] 15:35:34     INFO -               ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[task 2024-04-27T15:35:34.106Z] 15:35:34     INFO -    File "D:\task_171423135650749\build\tests\reftest\runreftest.py", line 711, in runTests
[task 2024-04-27T15:35:34.106Z] 15:35:34     INFO -      return self.runSerialTests(manifests, options, cmdargs)
[task 2024-04-27T15:35:34.107Z] 15:35:34     INFO -             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[task 2024-04-27T15:35:34.107Z] 15:35:34     INFO -    File "D:\task_171423135650749\build\tests\reftest\runreftest.py", line 1132, in runSerialTests
[task 2024-04-27T15:35:34.107Z] 15:35:34     INFO -      status = run(tests=tests)
[task 2024-04-27T15:35:34.107Z] 15:35:34     INFO -               ^^^^^^^^^^^^^^^^
[task 2024-04-27T15:35:34.108Z] 15:35:34     INFO -    File "D:\task_171423135650749\build\tests\reftest\runreftest.py", line 1081, in run
[task 2024-04-27T15:35:34.108Z] 15:35:34     INFO -      status = self.runApp(
[task 2024-04-27T15:35:34.108Z] 15:35:34     INFO -               ^^^^^^^^^^^^
[task 2024-04-27T15:35:34.108Z] 15:35:34     INFO -    File "D:\task_171423135650749\build\tests\reftest\runreftest.py", line 1022, in runApp
[task 2024-04-27T15:35:34.109Z] 15:35:34     INFO -      runner.cleanup()
[task 2024-04-27T15:35:34.109Z] 15:35:34     INFO -    File "D:\task_171423135650749\build\venv\Lib\site-packages\mozrunner\base\runner.py", line 278, in cleanup
[task 2024-04-27T15:35:34.109Z] 15:35:34     INFO -      self.profile.cleanup()
[task 2024-04-27T15:35:34.109Z] 15:35:34     INFO -    File "D:\task_171423135650749\build\venv\Lib\site-packages\mozprofile\profile.py", line 294, in cleanup
[task 2024-04-27T15:35:34.110Z] 15:35:34     INFO -      super(Profile, self).cleanup()
[task 2024-04-27T15:35:34.110Z] 15:35:34     INFO -    File "D:\task_171423135650749\build\venv\Lib\site-packages\mozprofile\profile.py", line 92, in cleanup
[task 2024-04-27T15:35:34.110Z] 15:35:34     INFO -      mozfile.remove(self.profile)
[task 2024-04-27T15:35:34.111Z] 15:35:34     INFO -    File "D:\task_171423135650749\build\venv\Lib\site-packages\mozfile\mozfile.py", line 305, in remove
[task 2024-04-27T15:35:34.111Z] 15:35:34     INFO -      _update_permissions(os.path.join(root, entry))
[task 2024-04-27T15:35:34.112Z] 15:35:34     INFO -    File "D:\task_171423135650749\build\venv\Lib\site-packages\mozfile\mozfile.py", line 265, in _update_permissions
[task 2024-04-27T15:35:34.112Z] 15:35:34     INFO -      stats = os.stat(path)
[task 2024-04-27T15:35:34.112Z] 15:35:34     INFO -              ^^^^^^^^^^^^^
[task 2024-04-27T15:35:34.112Z] 15:35:34     INFO -  FileNotFoundError: [WinError 2] The system cannot find the file specified: '\\\\?\\C:\\Users\\task_171423135650749\\AppData\\Local\\Temp\\tmpt1byyqu_.mozrunner\\plugins\\gmp-fake\\1.0\\manifest.json'
[task 2024-04-27T15:35:34.237Z] 15:35:34     INFO - Return code: 1
[task 2024-04-27T15:35:34.238Z] 15:35:34    ERROR - No suite end message was emitted by this harness.
[task 2024-04-27T15:35:34.238Z] 15:35:34     INFO - TinderboxPrint: reftest-reftest<br/>5905/0/0
[task 2024-04-27T15:35:34.238Z] 15:35:34  WARNING - setting return code to 2
[task 2024-04-27T15:35:34.239Z] 15:35:34     INFO - The reftest suite: reftest ran with return status: FAILURE
[task 2024-04-27T15:35:34.239Z] 15:35:34     INFO - Running post-action listener: _package_coverage_data
[task 2024-04-27T15:35:34.239Z] 15:35:34     INFO - Running post-action listener: _resource_record_post_action
[task 2024-04-27T15:35:34.239Z] 15:35:34     INFO - Running post-action listener: process_java_coverage_data
[task 2024-04-27T15:35:34.239Z] 15:35:34     INFO - [mozharness: 2024-04-27 15:35:34.239125Z] Finished run-tests step (success)
[task 2024-04-27T15:35:34.239Z] 15:35:34     INFO - [mozharness: 2024-04-27 15:35:34.239666Z] Running uninstall step.
[task 2024-04-27T15:35:34.239Z] 15:35:34     INFO - Running pre-action listener: _resource_record_pre_action
[task 2024-04-27T15:35:34.239Z] 15:35:34     INFO - Running main action method: uninstall
[task 2024-04-27T15:35:34.239Z] 15:35:34     INFO - Skipping uninstall for non-MSIX test
[task 2024-04-27T15:35:34.239Z] 15:35:34     INFO - Running post-action listener: _resource_record_post_action
[task 2024-04-27T15:35:34.240Z] 15:35:34     INFO - [mozharness: 2024-04-27 15:35:34.239666Z] Finished uninstall step (success)
[task 2024-04-27T15:35:34.240Z] 15:35:34     INFO - Running post-run listener: _resource_record_post_run
[task 2024-04-27T15:35:34.399Z] 15:35:34     INFO - instance_metadata.json not found; unable to determine instance type
[task 2024-04-27T15:35:34.401Z] 15:35:34     INFO - Validating Perfherder data against D:\task_171423135650749\mozharness\external_tools\performance-artifact-schema.json
[task 2024-04-27T15:35:34.403Z] 15:35:34     INFO - PERFHERDER_DATA: {"framework": {"name": "job_resource_usage"}, "suites": [{"name": "reftest.reftest.2.overall", "extraOptions": ["e10s", "buildbot-unknown"], "subtests": [{"name": "cpu_percent", "value": 29.948604269293934}, {"name": "io_write_bytes", "value": 2948302336}, {"name": "io.read_bytes", "value": 1907109376}, {"name": "io_write_time", "value": 276}, {"name": "io_read_time", "value": 155}]}, {"name": "reftest.reftest.2.start-pulseaudio", "subtests": [{"name": "time", "value": 0.00021457672119140625}, {"name": "cpu_percent", "value": 0}]}, {"name": "reftest.reftest.2.install", "subtests": [{"name": "time", "value": 3.3846426010131836}, {"name": "cpu_percent", "value": 33.55416666666667}]}, {"name": "reftest.reftest.2.stage-files", "subtests": [{"name": "time", "value": 0.0005424022674560547}, {"name": "cpu_percent", "value": 0}]}, {"name": "reftest.reftest.2.run-tests", "subtests": [{"name": "time", "value": 404.0846197605133}, {"name": "cpu_percent", "value": 29.938461538461546}]}, {"name": "reftest.reftest.2.uninstall", "subtests": [{"name": "time", "value": 0.0}, {"name": "cpu_percent", "value": 0}]}]}
[task 2024-04-27T15:35:34.403Z] 15:35:34     INFO - Total resource usage - Wall time: 407s; CPU: Can't collect data; Read bytes: 1907109376; Write bytes: 2948302336; Read time: 155; Write time: 276
[task 2024-04-27T15:35:34.403Z] 15:35:34     INFO - TinderboxPrint: I/O read bytes / time<br/>1,907,109,376 / 155
[task 2024-04-27T15:35:34.403Z] 15:35:34     INFO - TinderboxPrint: I/O write bytes / time<br/>2,948,302,336 / 276
[task 2024-04-27T15:35:34.403Z] 15:35:34     INFO - TinderboxPrint: CPU idle<br/>3,429.0 (69.9%)
[task 2024-04-27T15:35:34.403Z] 15:35:34     INFO - TinderboxPrint: CPU system<br/>562.2 (11.5%)
[task 2024-04-27T15:35:34.403Z] 15:35:34     INFO - TinderboxPrint: CPU user<br/>891.0 (18.2%)
[task 2024-04-27T15:35:34.404Z] 15:35:34     INFO - start-pulseaudio - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2024-04-27T15:35:34.404Z] 15:35:34     INFO - install - Wall time: 3s; CPU: 34%; Read bytes: 1817088; Write bytes: 31444992; Read time: 0; Write time: 1
[task 2024-04-27T15:35:34.405Z] 15:35:34     INFO - stage-files - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2024-04-27T15:35:34.408Z] 15:35:34     INFO - run-tests - Wall time: 404s; CPU: 30%; Read bytes: 1905199616; Write bytes: 2692560384; Read time: 155; Write time: 271
[task 2024-04-27T15:35:34.409Z] 15:35:34     INFO - uninstall - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2024-04-27T15:35:34.556Z] 15:35:34  WARNING - returning nonzero exit status 2
[taskcluster 2024-04-27T15:35:34.656Z]    Exit Code: 2
[taskcluster 2024-04-27T15:35:34.656Z]    User Time: 0s
[taskcluster 2024-04-27T15:35:34.656Z]  Kernel Time: 15.625ms
[taskcluster 2024-04-27T15:35:34.656Z]    Wall Time: 10m48.6094927s
[taskcluster 2024-04-27T15:35:34.656Z]       Result: FAILED
[taskcluster 2024-04-27T15:35:34.656Z] === Task Finished ===
[taskcluster 2024-04-27T15:35:34.656Z] Task Duration: 10m48.6105944s
[taskcluster 2024-04-27T15:35:35.579Z] Uploading artifact public/logs/localconfig.json from file D:\task_171423135650749\logs\localconfig.json with content encoding "gzip", mime type "application/json" and expiry 2024-07-26T13:21:30.978Z
[taskcluster 2024-04-27T15:35:35.873Z] Uploading artifact public/test_info/reftest_errorsummary.log from file D:\task_171423135650749\build\blobber_upload_dir\reftest_errorsummary.log with content encoding "gzip", mime type "text/plain" and expiry 2024-07-26T13:21:30.978Z
[taskcluster 2024-04-27T15:35:36.132Z] Uploading artifact public/test_info/resource-usage.json from file D:\task_171423135650749\build\blobber_upload_dir\resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2024-07-26T13:21:30.978Z
[taskcluster 2024-04-27T15:35:36.442Z] Uploading artifact public/test_info/system-info.log from file D:\task_171423135650749\build\blobber_upload_dir\system-info.log with content encoding "gzip", mime type "text/plain" and expiry 2024-07-26T13:21:30.978Z
[taskcluster 2024-04-27T15:35:36.694Z] Uploading link artifact public/logs/live.log to artifact public/logs/live_backing.log with expiry 2024-07-26T13:21:30.978Z
[taskcluster:error] exit status 2

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-esr115: 1

Platform and build breakdown:

• windows11-32-2009-shippable-qr: 1
  • opt: 1

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

Comment 2

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-beta: 1

Platform and build breakdown:

• windows11-32-2009-qr: 1
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1893814&startday=2024-07-15&endday=2024-07-21&tree=all

Comment 3

[Intermittent Failures Robot]

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

Repository breakdown:

• mozilla-esr128: 1
• mozilla-beta: 1

Platform and build breakdown:

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

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

Comment 4

[Intermittent Failures Robot]

1 failures in 4679 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
  • debug: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1893814&startday=2024-10-07&endday=2024-10-13&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.