Closed Bug 1881957 Opened 2 years ago Closed 2 years ago

Intermittent SUT ERROR - unable to terminate process! | followed by [taskcluster:error] Task aborted - max run time exceeded

Categories

(Testing :: Mozbase, defect, P5)

defect

Tracking

(Not tracked)

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

References

Details

(Keywords: intermittent-failure)

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


[fetches 2024-02-25T11:41:18.753Z] finished fetching artifacts
[setup 2024-02-25T11:41:18.753Z] Setting up local python environment
[setup 2024-02-25T11:41:18.755Z] updated PATH with python artifact: Z:/task_170885544655622/fetches/python;C:\Windows\system32;C:\Windows;C:\Windows\System32\Wbem;C:\Windows\System32\WindowsPowerShell\v1.0\;C:\Windows\System32\OpenSSH\;C:\Program Files\Git\cmd;C:\Program Files\Puppet Labs\Puppet\bin;C:\Program Files (x86)\Windows Kits\10\Windows Performance Toolkit\;C:\Program Files (x86)\GNU\GnuPG\pub;C:\Program Files\Mercurial\;C:\mozilla-build\bin;C:\mozilla-build\kdiff3;C:\mozilla-build\msys2;C:\mozilla-build\python3;C:\mozilla-build\msys2\usr\bin;C:\Users\task_170885544655622\AppData\Local\Microsoft\WindowsApps
[task 2024-02-25T11:41:18.755Z] executing ['bash', '-cx', 'python3 ./mach python testing/mozharness/scripts/does_it_crash.py --run-for 30 --thing-url https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/HIXKLNYWTWeXm-jOqh4VLg/artifacts/public/build/target.installer.exe --thing-to-run core/firefox.exe']in build/src
[task 2024-02-25T11:41:18.785Z] + python3 ./mach python testing/mozharness/scripts/does_it_crash.py --run-for 30 --thing-url https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/HIXKLNYWTWeXm-jOqh4VLg/artifacts/public/build/target.installer.exe --thing-to-run core/firefox.exe
[task 2024-02-25T11:52:01.230Z] 11:52:01     INFO - ConsoleLogger online at 20240225 11:52:01Z in Z:\task_170885544655622\build\src
[task 2024-02-25T11:52:01.243Z] 11:52:01     INFO - Run as testing/mozharness/scripts/does_it_crash.py --run-for 30 --thing-url https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/HIXKLNYWTWeXm-jOqh4VLg/artifacts/public/build/target.installer.exe --thing-to-run core/firefox.exe
[task 2024-02-25T11:52:01.244Z] 11:52:01     INFO - Dumping config to Z:\task_170885544655622\build\src\logs\localconfig.json.
[task 2024-02-25T11:52:01.245Z] 11:52:01     INFO - {'append_to_log': False,
[task 2024-02-25T11:52:01.245Z] 11:52:01     INFO -  'base_work_dir': 'Z:\\task_170885544655622\\build\\src',
[task 2024-02-25T11:52:01.245Z] 11:52:01     INFO -  'config_files': (),
[task 2024-02-25T11:52:01.245Z] 11:52:01     INFO -  'log_level': 'info',
[task 2024-02-25T11:52:01.245Z] 11:52:01     INFO -  'log_to_console': True,
[task 2024-02-25T11:52:01.245Z] 11:52:01     INFO -  'opt_config_files': (),
[task 2024-02-25T11:52:01.245Z] 11:52:01     INFO -  'requires_gpu': False,
[task 2024-02-25T11:52:01.245Z] 11:52:01     INFO -  'run_for': 30,
[task 2024-02-25T11:52:01.245Z] 11:52:01     INFO -  'thing_args': (),
[task 2024-02-25T11:52:01.245Z] 11:52:01     INFO -  'thing_to_run': 'core/firefox.exe',
[task 2024-02-25T11:52:01.245Z] 11:52:01     INFO -  'thing_url': 'https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/HIXKLNYWTWeXm-jOqh4VLg/artifacts/public/build/target.installer.exe',
[task 2024-02-25T11:52:01.245Z] 11:52:01     INFO -  'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
[task 2024-02-25T11:52:01.245Z] 11:52:01     INFO -  'work_dir': 'build'}
[task 2024-02-25T11:52:01.245Z] 11:52:01     INFO - [mozharness: 2024-02-25 11:52:01.245895Z] Running download step.
[task 2024-02-25T11:52:01.245Z] 11:52:01     INFO - Running main action method: download
[task 2024-02-25T11:52:24.926Z] 11:52:24     INFO - [mozharness: 2024-02-25 11:52:24.926807Z] Finished download step (success)
[task 2024-02-25T11:52:24.926Z] 11:52:24     INFO - [mozharness: 2024-02-25 11:52:24.926807Z] Running run-thing step.
[task 2024-02-25T11:52:24.926Z] 11:52:24     INFO - Running main action method: run_thing
[task 2024-02-25T11:52:24.935Z] 11:52:24     INFO - Running Z:\task_170885544655622\build\src\thing\thing\core\firefox.exe with args []
[task 2024-02-25T11:53:26.979Z] 11:53:26     INFO - timeout detected: killing pid 7184
[task 2024-02-25T11:53:31.981Z] 11:53:31    ERROR - unable to terminate process!
[task 2024-02-25T11:53:36.982Z] 11:53:36    ERROR - unable to terminate process!
[task 2024-02-25T11:53:41.984Z] 11:53:41    ERROR - unable to terminate process!
[taskcluster:error] Aborting task...
[task 2024-02-25T12:40:30.223Z] 12:40:30     INFO - PASS: Z:\task_170885544655622\build\src\thing\thing\core\firefox.exe ran successfully for 30 seconds
[task 2024-02-25T12:40:30.223Z] 12:40:30     INFO - [mozharness: 2024-02-25 12:40:30.223533Z] Finished run-thing step (success)
[taskcluster 2024-02-25T12:40:30.249Z] SUCCESS: The process with PID 4076 (child process of PID 3088) has been terminated.
[taskcluster 2024-02-25T12:40:30.249Z] SUCCESS: The process with PID 4976 (child process of PID 3088) has been terminated.
[taskcluster 2024-02-25T12:40:30.249Z] SUCCESS: The process with PID 5564 (child process of PID 3088) has been terminated.
[taskcluster 2024-02-25T12:40:30.249Z] SUCCESS: The process with PID 7504 (child process of PID 3088) has been terminated.
[taskcluster 2024-02-25T12:40:30.249Z] SUCCESS: The process with PID 9636 (child process of PID 3088) has been terminated.
[taskcluster 2024-02-25T12:40:30.249Z] SUCCESS: The process with PID 5352 (child process of PID 3088) has been terminated.
[taskcluster 2024-02-25T12:40:30.249Z] SUCCESS: The process with PID 1380 (child process of PID 3088) has been terminated.
[taskcluster 2024-02-25T12:40:30.249Z] SUCCESS: The process with PID 3728 (child process of PID 3088) has been terminated.
[taskcluster 2024-02-25T12:40:30.249Z] SUCCESS: The process with PID 9504 (child process of PID 3088) has been terminated.
[taskcluster 2024-02-25T12:40:30.249Z] SUCCESS: The process with PID 9612 (child process of PID 3088) has been terminated.
[taskcluster 2024-02-25T12:40:30.249Z] SUCCESS: The process with PID 3088 (child process of PID 7184) has been terminated.
[taskcluster 2024-02-25T12:40:30.249Z] SUCCESS: The process with PID 7184 (child process of PID 4364) has been terminated.
[taskcluster 2024-02-25T12:40:30.249Z] SUCCESS: The process with PID 4364 (child process of PID 3656) has been terminated.
[taskcluster 2024-02-25T12:40:30.249Z] SUCCESS: The process with PID 3656 (child process of PID 2564) has been terminated.
[taskcluster 2024-02-25T12:40:30.249Z] SUCCESS: The process with PID 2564 (child process of PID 9748) has been terminated.
[taskcluster 2024-02-25T12:40:30.249Z] SUCCESS: The process with PID 9748 (child process of PID 10084) has been terminated.
[taskcluster 2024-02-25T12:40:30.249Z] SUCCESS: The process with PID 4400 (child process of PID 8860) has been terminated.
[taskcluster 2024-02-25T12:40:30.249Z] SUCCESS: The process with PID 10084 (child process of PID 8860) has been terminated.
[taskcluster 2024-02-25T12:40:30.249Z] SUCCESS: The process with PID 8860 (child process of PID 3288) has been terminated.
[taskcluster 2024-02-25T12:40:30.249Z] 
[taskcluster 2024-02-25T12:40:30.252Z] === Task Finished ===
[taskcluster 2024-02-25T12:40:30.252Z] Task Duration: 1h0m0.2099228s
[taskcluster 2024-02-25T12:40:30.252Z] [mounts] Preserving cache: Moving "Z:\\task_170885544655622\\build" to "Z:\\caches\\facayWmVSKCbn0QglEgt_w"
[taskcluster 2024-02-25T12:40:30.268Z] [mounts] Denying task_170885544655622 access to 'Z:\caches\facayWmVSKCbn0QglEgt_w'
[taskcluster 2024-02-25T12:40:30.939Z] Uploading link artifact public/logs/live.log to artifact public/logs/live_backing.log with expiry 2024-05-25T09:36:31.431Z
[taskcluster:error] Task aborted - max run time exceeded
Summary: Intermittent SUT ERROR - unable to terminate process! | followed by [taskcluster:error] Aborting task... | [mounts] Denying task_170885544655622 access to 'Z:\caches\facayWmVSKCbn0QglEgt_w' | [taskcluster:error] Task aborted - max run time exceeded → Intermittent SUT ERROR - unable to terminate process! | followed by [taskcluster:error] Task aborted - max run time exceeded
Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → INCOMPLETE
Status: RESOLVED → REOPENED
Resolution: INCOMPLETE → ---
Status: REOPENED → RESOLVED
Closed: 2 years ago2 years ago
Resolution: --- → INCOMPLETE
You need to log in before you can comment on or make changes to this bug.