+ update-ca-trust extract -o /etc/pki/ca-trust/extracted + git config --global --add safe.directory '*' + exec /usr/local/bin/zuul-executor -f -d 2026-06-08 11:14:21,642 DEBUG zuul.Executor: Configured logging: 14.1.1.dev1 2026-06-08 11:14:21,643 DEBUG zuul.TimerDriver: Starting apscheduler 2026-06-08 11:14:21,643 INFO apscheduler.scheduler: Scheduler started 2026-06-08 11:14:21,644 DEBUG apscheduler.scheduler: Looking for jobs to run 2026-06-08 11:14:21,644 DEBUG apscheduler.scheduler: No jobs; waiting until a job is added 2026-06-08 11:14:21,644 DEBUG zuul.BubblewrapDriver: Initializing bubblewrap with oom_score_adj starting: 995, final: 1000 2026-06-08 11:14:21,647 DEBUG zuul.BubblewrapExecutionContext: Bubblewrap command: setpriv --ambient-caps -all choom -n 1000 -- bwrap --tmpfs /tmp --dir /var --dir /var/tmp --dir /run/user/65534 --ro-bind /usr /usr --ro-bind /lib /lib --ro-bind /bin /bin --ro-bind /sbin /sbin --ro-bind /etc/ld.so.cache /etc/ld.so.cache --ro-bind /etc/resolv.conf /etc/resolv.conf --ro-bind /etc/hosts /etc/hosts --ro-bind /etc/localtime /etc/localtime --bind /tmp /tmp --tmpfs /tmp/tmp --proc /proc --dev /dev --chdir /tmp --unshare-all --die-with-parent --uid 65534 --gid 65534 --file 3 /etc/passwd --file 4 /etc/group --unshare-user --disable-userns --ro-bind /lib64 /lib64 --ro-bind /etc/nsswitch.conf /etc/nsswitch.conf --ro-bind /etc/alternatives /etc/alternatives --ro-bind /etc/ssl/certs /etc/ssl/certs --ro-bind /etc/subuid /etc/subuid --share-net 2026-06-08 11:14:21,727 INFO zuul.Executor: Starting log streamer 2026-06-08 11:14:21,728 DEBUG zuul.log_streamer: LogStreamer starting on port 7900 2026-06-08 11:14:21,955 DEBUG zuul.zk.base.ZooKeeperClient: ZooKeeper connection (session: 0x1000012ef4a0000): CONNECTED 2026-06-08 11:14:22,153 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/merger 2026-06-08 11:14:22,262 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/merger is ready 2026-06-08 11:14:22,263 DEBUG zuul.zk.ZooKeeper: Initialize cache at /keystorage-oidc 2026-06-08 11:14:22,270 DEBUG zuul.zk.ZooKeeper: Cache at /keystorage-oidc is ready 2026-06-08 11:14:22,270 INFO zuul.Component: Registering component in ZooKeeper /zuul/components/executor/zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local 2026-06-08 11:14:22,333 INFO zuul.ComponentRegistry: Noticed new scheduler component zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000002 2026-06-08 11:14:22,340 DEBUG zuul.ComponentRegistry: Registry got event None for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000002 2026-06-08 11:14:22,340 INFO zuul.ComponentRegistry: Component scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000002 updated: {'hostname': 'zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local', 'kind': 'scheduler', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-08 11:14:22,343 INFO zuul.ComponentRegistry: Noticed new executor component zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-08 11:14:22,344 DEBUG zuul.ComponentRegistry: Registry got event None for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-08 11:14:22,345 INFO zuul.ComponentRegistry: Component executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 updated: {'accepting_work': False, 'allow_unzoned': False, 'hostname': 'zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local', 'kind': 'executor', 'model_api': 37, 'process_merge_jobs': False, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8', 'zone': None} 2026-06-08 11:14:22,352 INFO zuul.ComponentRegistry: Noticed new web component zuul-web-6d4fbf9c8c-tfthr0000000004 2026-06-08 11:14:22,353 DEBUG zuul.ComponentRegistry: Registry got event None for web zuul-web-6d4fbf9c8c-tfthr0000000004 2026-06-08 11:14:22,353 INFO zuul.ComponentRegistry: Component web zuul-web-6d4fbf9c8c-tfthr0000000004 updated: {'hostname': 'zuul-web-6d4fbf9c8c-tfthr', 'kind': 'web', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-08 11:14:22,356 INFO zuul.ComponentRegistry: System minimum data model version 37; this component 37 2026-06-08 11:14:22,409 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-08 11:14:22,409 INFO zuul.ComponentRegistry: Component executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 updated: {'accepting_work': False, 'allow_unzoned': True, 'hostname': 'zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local', 'kind': 'executor', 'model_api': 37, 'process_merge_jobs': False, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8', 'zone': None} 2026-06-08 11:14:22,411 INFO zuul.ExecutorServer: Starting executor (hostname: zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local) in unpaused mode 2026-06-08 11:14:22,433 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-08 11:14:22,433 INFO zuul.ComponentRegistry: Component executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 updated: {'accepting_work': True, 'allow_unzoned': True, 'hostname': 'zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local', 'kind': 'executor', 'model_api': 37, 'process_merge_jobs': False, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8', 'zone': None} 2026-06-08 11:14:22,855 INFO zuul.ComponentRegistry: Noticed new web component zuul-web-6589c46586-x4sm90000000005 2026-06-08 11:14:22,857 DEBUG zuul.ComponentRegistry: Registry got event None for web zuul-web-6589c46586-x4sm90000000005 2026-06-08 11:14:22,857 INFO zuul.ComponentRegistry: Component web zuul-web-6589c46586-x4sm90000000005 updated: {'hostname': 'zuul-web-6589c46586-x4sm9', 'kind': 'web', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-08 11:14:22,938 INFO zuul.ansible_manager: Ansible version 9 information: 2026-06-08 11:14:22,938 INFO zuul.ansible_manager: ansible [core 2.16.18] 2026-06-08 11:14:22,938 INFO zuul.ansible_manager: config file = None 2026-06-08 11:14:22,938 INFO zuul.ansible_manager: configured module search path = ['/var/lib/zuul/.ansible/plugins/modules', '/usr/share/ansible/plugins/modules'] 2026-06-08 11:14:22,938 INFO zuul.ansible_manager: ansible python module location = /usr/lib/zuul/ansible/9/lib/python3.11/site-packages/ansible 2026-06-08 11:14:22,938 INFO zuul.ansible_manager: ansible collection location = /var/lib/zuul/.ansible/collections:/usr/share/ansible/collections 2026-06-08 11:14:22,938 INFO zuul.ansible_manager: executable location = /usr/lib/zuul/ansible/9/bin/ansible 2026-06-08 11:14:22,938 INFO zuul.ansible_manager: python version = 3.11.13 (main, Apr 17 2026, 00:00:00) [GCC 11.5.0 20240719 (Red Hat 11.5.0-11)] (/usr/lib/zuul/ansible/9/bin/python) 2026-06-08 11:14:22,938 INFO zuul.ansible_manager: jinja version = 3.1.6 2026-06-08 11:14:22,938 INFO zuul.ansible_manager: libyaml = True 2026-06-08 11:14:22,938 INFO zuul.ansible_manager: 2026-06-08 11:14:23,456 INFO zuul.ComponentRegistry: Noticed new merger component zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003 2026-06-08 11:14:23,458 DEBUG zuul.ComponentRegistry: Registry got event None for merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003 2026-06-08 11:14:23,458 INFO zuul.ComponentRegistry: Component merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003 updated: {'hostname': 'zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local', 'kind': 'merger', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-08 11:14:23,540 INFO zuul.ansible_manager: Ansible version 11 information: 2026-06-08 11:14:23,540 INFO zuul.ansible_manager: ansible [core 2.18.16] 2026-06-08 11:14:23,540 INFO zuul.ansible_manager: config file = None 2026-06-08 11:14:23,540 INFO zuul.ansible_manager: configured module search path = ['/var/lib/zuul/.ansible/plugins/modules', '/usr/share/ansible/plugins/modules'] 2026-06-08 11:14:23,540 INFO zuul.ansible_manager: ansible python module location = /usr/lib/zuul/ansible/11/lib/python3.11/site-packages/ansible 2026-06-08 11:14:23,540 INFO zuul.ansible_manager: ansible collection location = /var/lib/zuul/.ansible/collections:/usr/share/ansible/collections 2026-06-08 11:14:23,540 INFO zuul.ansible_manager: executable location = /usr/lib/zuul/ansible/11/bin/ansible 2026-06-08 11:14:23,540 INFO zuul.ansible_manager: python version = 3.11.13 (main, Apr 17 2026, 00:00:00) [GCC 11.5.0 20240719 (Red Hat 11.5.0-11)] (/usr/lib/zuul/ansible/11/bin/python) 2026-06-08 11:14:23,540 INFO zuul.ansible_manager: jinja version = 3.1.6 2026-06-08 11:14:23,540 INFO zuul.ansible_manager: libyaml = True 2026-06-08 11:14:23,540 INFO zuul.ansible_manager: 2026-06-08 11:14:23,630 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-08 11:14:23,630 INFO zuul.ComponentRegistry: Component executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 updated: {'accepting_work': True, 'allow_unzoned': True, 'hostname': 'zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local', 'kind': 'executor', 'model_api': 37, 'process_merge_jobs': True, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8', 'zone': None} 2026-06-08 11:14:23,631 DEBUG zuul.ExecutorQueue: Creating executor queue at root /zuul/executor/unzoned 2026-06-08 11:14:23,632 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003 2026-06-08 11:14:23,633 INFO zuul.ComponentRegistry: Component merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003 updated: {'hostname': 'zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local', 'kind': 'merger', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-08 11:14:23,642 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-6589c46586-x4sm90000000005 2026-06-08 11:14:23,643 INFO zuul.ComponentRegistry: Component web zuul-web-6589c46586-x4sm90000000005 updated: {'hostname': 'zuul-web-6589c46586-x4sm9', 'kind': 'web', 'model_api': 37, 'state': 'initializing', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-08 11:14:23,737 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/executor/unzoned 2026-06-08 11:14:23,751 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/executor/unzoned is ready 2026-06-08 11:14:23,751 DEBUG zuul.ExecutorServer: Starting merger 2026-06-08 11:14:23,754 DEBUG zuul.ExecutorServer: Starting command processor 2026-06-08 11:14:23,755 DEBUG zuul.ExecutorServer: Starting 8 update workers 2026-06-08 11:14:23,833 DEBUG zuul.ExecutorServer: Joining executor 2026-06-08 11:14:23,842 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-08 11:14:23,842 INFO zuul.ComponentRegistry: Component executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 updated: {'accepting_work': True, 'allow_unzoned': True, 'hostname': 'zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local', 'kind': 'executor', 'model_api': 37, 'process_merge_jobs': True, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8', 'zone': None} 2026-06-08 11:14:27,078 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-6589c46586-x4sm90000000005 2026-06-08 11:14:27,079 INFO zuul.ComponentRegistry: Component web zuul-web-6589c46586-x4sm90000000005 updated: {'hostname': 'zuul-web-6589c46586-x4sm9', 'kind': 'web', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-08 11:14:35,545 INFO zuul.ComponentRegistry: Noticed new scheduler component zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-08 11:14:35,546 DEBUG zuul.ComponentRegistry: Registry got event None for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-08 11:14:35,546 INFO zuul.ComponentRegistry: Component scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 updated: {'hostname': 'zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local', 'kind': 'scheduler', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-08 11:14:35,932 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-08 11:14:35,932 INFO zuul.ComponentRegistry: Component scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 updated: {'hostname': 'zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local', 'kind': 'scheduler', 'model_api': 37, 'state': 'initializing', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-08 11:14:38,672 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-08 11:14:38,672 INFO zuul.ComponentRegistry: Component scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 updated: {'hostname': 'zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local', 'kind': 'scheduler', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-08 11:14:41,141 DEBUG zuul.ComponentRegistry: Registry got event DELETED for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000002 2026-06-08 11:14:41,141 INFO zuul.ComponentRegistry: Noticed scheduler component zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000002 disappeared 2026-06-08 11:14:41,146 DEBUG zuul.ComponentRegistry: Registry got event DELETED for web zuul-web-6d4fbf9c8c-tfthr0000000004 2026-06-08 11:14:41,146 INFO zuul.ComponentRegistry: Noticed web component zuul-web-6d4fbf9c8c-tfthr0000000004 disappeared 2026-06-08 11:15:39,255 DEBUG zuul.JobRequestQueue: [build: e41e12da3239422784a7f358c2ed293b] Updating request 2026-06-08 11:15:39,258 DEBUG zuul.ExecutorServer: Next executed merge job: 2026-06-08 11:15:39,258 DEBUG zuul.ExecutorServer: Got cat job: e41e12da3239422784a7f358c2ed293b 2026-06-08 11:15:39,260 INFO zuul.ExecutorServer: Updating repo opendev.org/zuul/zuul-jobs 2026-06-08 11:15:39,270 INFO zuul.Merger: Updating local repository opendev.org/zuul/zuul-jobs 2026-06-08 11:15:39,271 DEBUG zuul.Repo: Updating repository /var/lib/zuul/executor-git/opendev.org/zuul/zuul%2Fzuul-jobs 2026-06-08 11:15:39,428 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-6589c46586-x4sm90000000005 2026-06-08 11:15:39,428 INFO zuul.ComponentRegistry: Component web zuul-web-6589c46586-x4sm90000000005 updated: {'hostname': 'zuul-web-6589c46586-x4sm9', 'kind': 'web', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-08 11:15:39,609 DEBUG zuul.ExecutorServer: Finished updating repo opendev.org/zuul/zuul-jobs 2026-06-08 11:15:39,610 DEBUG zuul.Repo: Resetting repository /var/lib/zuul/executor-git/opendev.org/zuul/zuul%2Fzuul-jobs 2026-06-08 11:15:39,625 DEBUG zuul.Repo: Getting files for /var/lib/zuul/executor-git/opendev.org/zuul/zuul%2Fzuul-jobs at 82e3e8b1292a25e38235bb92b157992d326531d1 2026-06-08 11:15:39,632 DEBUG zuul.ExecutorServer: Completed cat job e41e12da3239422784a7f358c2ed293b: payload size: 44900 2026-06-08 11:15:39,632 INFO zuul.ExecutorServer: Merge complete, merged: False, updated: True, commit: None, branches: [] 2026-06-08 11:15:39,632 DEBUG zuul.ExecutorServer: Providing synchronous result via future for 2026-06-08 11:15:39,645 DEBUG zuul.JobRequestQueue: [build: e41e12da3239422784a7f358c2ed293b] Updating request 2026-06-08 11:15:39,648 DEBUG zuul.MergerApi: Removing request 2026-06-08 11:15:39,755 DEBUG zuul.JobRequestQueue: [build: 05067ce5333e4936990cb68185d075be] Updating request 2026-06-08 11:15:39,757 DEBUG zuul.ExecutorServer: Next executed merge job: 2026-06-08 11:15:39,757 DEBUG zuul.ExecutorServer: Got cat job: 05067ce5333e4936990cb68185d075be 2026-06-08 11:15:39,758 INFO zuul.ExecutorServer: Updating repo git-server/system-config 2026-06-08 11:15:39,770 INFO zuul.Merger: Updating local repository git-server/system-config 2026-06-08 11:15:39,771 DEBUG zuul.Repo: Updating repository /var/lib/zuul/executor-git/git-server/system-config/system-config 2026-06-08 11:15:39,857 DEBUG zuul.ComponentRegistry: Registry got event DELETED for web zuul-web-6589c46586-x4sm90000000005 2026-06-08 11:15:39,857 INFO zuul.ComponentRegistry: Noticed web component zuul-web-6589c46586-x4sm90000000005 disappeared 2026-06-08 11:15:39,877 DEBUG zuul.ExecutorServer: Finished updating repo git-server/system-config 2026-06-08 11:15:39,878 DEBUG zuul.Repo: Resetting repository /var/lib/zuul/executor-git/git-server/system-config/system-config 2026-06-08 11:15:39,893 DEBUG zuul.Repo: Getting files for /var/lib/zuul/executor-git/git-server/system-config/system-config at b46c7d9a85aa9be7b0e8d5e11a8b3fd6819f684a 2026-06-08 11:15:39,898 DEBUG zuul.ExecutorServer: Completed cat job 05067ce5333e4936990cb68185d075be: payload size: 15739 2026-06-08 11:15:39,898 INFO zuul.ExecutorServer: Merge complete, merged: False, updated: True, commit: None, branches: [] 2026-06-08 11:15:39,898 DEBUG zuul.ExecutorServer: Providing synchronous result via future for 2026-06-08 11:15:39,939 DEBUG zuul.JobRequestQueue: [build: 05067ce5333e4936990cb68185d075be] Updating request 2026-06-08 11:15:39,943 DEBUG zuul.MergerApi: Removing request 2026-06-08 11:15:50,552 INFO zuul.ComponentRegistry: Noticed new web component zuul-web-6589c46586-cdqqx0000000006 2026-06-08 11:15:50,556 DEBUG zuul.ComponentRegistry: Registry got event None for web zuul-web-6589c46586-cdqqx0000000006 2026-06-08 11:15:50,556 INFO zuul.ComponentRegistry: Component web zuul-web-6589c46586-cdqqx0000000006 updated: {'hostname': 'zuul-web-6589c46586-cdqqx', 'kind': 'web', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-08 11:15:50,736 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-6589c46586-cdqqx0000000006 2026-06-08 11:15:50,736 INFO zuul.ComponentRegistry: Component web zuul-web-6589c46586-cdqqx0000000006 updated: {'hostname': 'zuul-web-6589c46586-cdqqx', 'kind': 'web', 'model_api': 37, 'state': 'initializing', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-08 11:15:53,565 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-6589c46586-cdqqx0000000006 2026-06-08 11:15:53,566 INFO zuul.ComponentRegistry: Component web zuul-web-6589c46586-cdqqx0000000006 updated: {'hostname': 'zuul-web-6589c46586-cdqqx', 'kind': 'web', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'}