Closed Bug 1878820 Opened 2 years ago Closed 1 year ago

Intermittent from importlib.metadata import distribution | ModuleNotFoundError: No module named 'importlib.metadata'

Categories

(Testing :: Mozbase, defect, P5)

Product:
Testing
Component:
Mozbase
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure, intermittent-testcase)

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

Copy/paste: /opt/worker/tasks/task_170718721967606/build/venv/bin/mozinstall /opt/worker/tasks/task_170718721967606/build/target.dmg --destination /opt/worker/tasks/task_170718721967606/build/application
[task 2024-02-06T03:35:18.314Z] 03:35:18     INFO - Reading from file tmpfile_stderr
[task 2024-02-06T03:35:18.315Z] 03:35:18    ERROR - Errors received:
[task 2024-02-06T03:35:18.315Z] 03:35:18    ERROR -  Traceback (most recent call last):
[task 2024-02-06T03:35:18.315Z] 03:35:18    ERROR -    File "/opt/worker/tasks/task_170718721967606/build/venv/bin/mozinstall", line 10, in <module>
[task 2024-02-06T03:35:18.315Z] 03:35:18    ERROR -      from importlib.metadata import distribution
[task 2024-02-06T03:35:18.315Z] 03:35:18    ERROR -  ModuleNotFoundError: No module named 'importlib.metadata'
[task 2024-02-06T03:35:18.315Z] 03:35:18    ERROR -  During handling of the above exception, another exception occurred:
[task 2024-02-06T03:35:18.315Z] 03:35:18    ERROR -  Traceback (most recent call last):
[task 2024-02-06T03:35:18.315Z] 03:35:18    ERROR -    File "/opt/worker/tasks/task_170718721967606/build/venv/bin/mozinstall", line 13, in <module>
[task 2024-02-06T03:35:18.315Z] 03:35:18    ERROR -      from importlib_metadata import distribution
[task 2024-02-06T03:35:18.315Z] 03:35:18    ERROR -  ModuleNotFoundError: No module named 'importlib_metadata'
[task 2024-02-06T03:35:18.315Z] 03:35:18    ERROR -  During handling of the above exception, another exception occurred:
[task 2024-02-06T03:35:18.315Z] 03:35:18    ERROR -  Traceback (most recent call last):
[task 2024-02-06T03:35:18.315Z] 03:35:18    ERROR -    File "/opt/worker/tasks/task_170718721967606/build/venv/bin/mozinstall", line 15, in <module>
[task 2024-02-06T03:35:18.315Z] 03:35:18    ERROR -      from pkg_resources import load_entry_point
[task 2024-02-06T03:35:18.315Z] 03:35:18    ERROR -    File "/opt/worker/tasks/task_170718721967606/build/venv/lib/python3.7/site-packages/pkg_resources/__init__.py", line 3239, in <module>
[task 2024-02-06T03:35:18.315Z] 03:35:18    ERROR -      @_call_aside
[task 2024-02-06T03:35:18.315Z] 03:35:18    ERROR -    File "/opt/worker/tasks/task_170718721967606/build/venv/lib/python3.7/site-packages/pkg_resources/__init__.py", line 3223, in _call_aside
[task 2024-02-06T03:35:18.315Z] 03:35:18    ERROR -      f(*args, **kwargs)
[task 2024-02-06T03:35:18.315Z] 03:35:18    ERROR -    File "/opt/worker/tasks/task_170718721967606/build/venv/lib/python3.7/site-packages/pkg_resources/__init__.py", line 3252, in _initialize_master_working_set
[task 2024-02-06T03:35:18.315Z] 03:35:18    ERROR -      working_set = WorkingSet._build_master()
[task 2024-02-06T03:35:18.315Z] 03:35:18    ERROR -    File "/opt/worker/tasks/task_170718721967606/build/venv/lib/python3.7/site-packages/pkg_resources/__init__.py", line 568, in _build_master
[task 2024-02-06T03:35:18.315Z] 03:35:18    ERROR -      ws.require(__requires__)
[task 2024-02-06T03:35:18.315Z] 03:35:18    ERROR -    File "/opt/worker/tasks/task_170718721967606/build/venv/lib/python3.7/site-packages/pkg_resources/__init__.py", line 885, in require
[task 2024-02-06T03:35:18.316Z] 03:35:18    ERROR -      needed = self.resolve(parse_requirements(requirements))
[task 2024-02-06T03:35:18.316Z] 03:35:18    ERROR -    File "/opt/worker/tasks/task_170718721967606/build/venv/lib/python3.7/site-packages/pkg_resources/__init__.py", line 771, in resolve
[task 2024-02-06T03:35:18.316Z] 03:35:18    ERROR -      raise DistributionNotFound(req, requirers)
[task 2024-02-06T03:35:18.316Z] 03:35:18    ERROR -  pkg_resources.DistributionNotFound: The 'charset-normalizer~=2.0.0; python_version >= "3"' distribution was not found and is required by requests
[task 2024-02-06T03:35:18.316Z] 03:35:18     INFO - Return code: 1
[task 2024-02-06T03:35:18.316Z] 03:35:18  WARNING - setting return code to 3
[task 2024-02-06T03:35:18.316Z] 03:35:18    FATAL - Halting on failure while running ['/opt/worker/tasks/task_170718721967606/build/venv/bin/mozinstall', '/opt/worker/tasks/task_170718721967606/build/target.dmg', '--destination', '/opt/worker/tasks/task_170718721967606/build/application']
[task 2024-02-06T03:35:18.316Z] 03:35:18    FATAL - Running post_fatal callback...
[task 2024-02-06T03:35:18.316Z] 03:35:18    FATAL - Exiting 3
[task 2024-02-06T03:35:18.316Z] 03:35:18     INFO - Running post-action listener: _resource_record_post_action
[task 2024-02-06T03:35:18.316Z] 03:35:18     INFO - [mozharness: 2024-02-06 03:35:18.316748Z] Finished install step (failed)
[task 2024-02-06T03:35:18.316Z] 03:35:18     INFO - Running post-run listener: _resource_record_post_run
INFO - Total resource usage - Wall time: 1s; CPU: 9%; Read bytes: 0; Write bytes: 4096; Read time: 0; Write time: 1
[task 2024-02-06T03:35:18.352Z] 03:35:18     INFO - TinderboxPrint: CPU usage<br/>8.8%
[task 2024-02-06T03:35:18.352Z] 03:35:18     INFO - TinderboxPrint: I/O read bytes / time<br/>0 / 0
[task 2024-02-06T03:35:18.352Z] 03:35:18     INFO - TinderboxPrint: I/O write bytes / time<br/>4,096 / 1
[task 2024-02-06T03:35:18.353Z] 03:35:18     INFO - TinderboxPrint: CPU idle<br/>7.0 (90.9%)
[task 2024-02-06T03:35:18.353Z] 03:35:18     INFO - TinderboxPrint: CPU system<br/>0.2 (2.2%)
[task 2024-02-06T03:35:18.353Z] 03:35:18     INFO - TinderboxPrint: CPU user<br/>0.5 (6.9%)
[task 2024-02-06T03:35:18.353Z] 03:35:18     INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2024-02-06T03:35:18.353Z] 03:35:18     INFO - pull - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2024-02-06T03:35:18.353Z] 03:35:18     INFO - start-emulator - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2024-02-06T03:35:18.353Z] 03:35:18     INFO - verify-device - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2024-02-06T03:35:18.353Z] 03:35:18     INFO - install - Wall time: 1s; CPU: 9%; Read bytes: 0; Write bytes: 4096; Read time: 0; Write time: 1
[taskcluster 2024-02-06T03:35:18.378Z]    Exit Code: 3
[taskcluster 2024-02-06T03:35:18.378Z]    User Time: 1m21.652708s
[taskcluster 2024-02-06T03:35:18.378Z]  Kernel Time: 39.864046s
[taskcluster 2024-02-06T03:35:18.378Z]    Wall Time: 3m12.102374s
[taskcluster 2024-02-06T03:35:18.378Z]       Result: FAILED
[taskcluster 2024-02-06T03:35:18.379Z] === Task Finished ===
[taskcluster 2024-02-06T03:35:18.379Z] Task Duration: 3m12.106863s
[taskcluster 2024-02-06T03:35:18.444Z] Uploading artifact public/logs/localconfig.json from file /opt/worker/tasks/task_170718721967606/logs/localconfig.json with content encoding "gzip", mime type "application/json" and expiry 2024-05-06T03:12:20.082Z
[taskcluster 2024-02-06T03:35:18.772Z] Uploading artifact public/test_info/profile_resource-usage.json from file /opt/worker/tasks/task_170718721967606/build/blobber_upload_dir/profile_resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2024-05-06T03:12:20.082Z
[taskcluster 2024-02-06T03:35:19.024Z] Uploading artifact public/test_info/resource-usage.json from file /opt/worker/tasks/task_170718721967606/build/blobber_upload_dir/resource-usage.json with content encoding "gzip", mime type "application/json" and expiry 2024-05-06T03:12:20.082Z
[taskcluster 2024-02-06T03:35:19.286Z] Uploading link artifact public/logs/live.log to artifact public/logs/live_backing.log with expiry 2024-05-06T03:12:20.082Z
[taskcluster:error] exit status 3
Component: Release Automation: Updates → Mozbase
Product: Release Engineering → Testing
QA Contact: gbrown

Joel is this more fallout of python 3.11 prep?

Flags: needinfo?(jmaher)

I hadn't seen this specific error, but this is suspect of adding additional packages to pypi.moz.

Flags: needinfo?(jmaher)

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

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