+ 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-09 09:12:05,276 DEBUG zuul.Executor: Configured logging: 14.1.1.dev1 2026-06-09 09:12:05,276 DEBUG zuul.TimerDriver: Starting apscheduler 2026-06-09 09:12:05,276 INFO apscheduler.scheduler: Scheduler started 2026-06-09 09:12:05,277 DEBUG apscheduler.scheduler: Looking for jobs to run 2026-06-09 09:12:05,277 DEBUG apscheduler.scheduler: No jobs; waiting until a job is added 2026-06-09 09:12:05,278 DEBUG zuul.BubblewrapDriver: Initializing bubblewrap with oom_score_adj starting: 995, final: 1000 2026-06-09 09:12:05,280 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-09 09:12:05,370 INFO zuul.Executor: Starting log streamer 2026-06-09 09:12:05,371 DEBUG zuul.log_streamer: LogStreamer starting on port 7900 2026-06-09 09:12:05,497 DEBUG zuul.zk.base.ZooKeeperClient: ZooKeeper connection (session: 0x1000014a849000a): CONNECTED 2026-06-09 09:12:05,515 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/merger 2026-06-09 09:12:05,585 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/merger is ready 2026-06-09 09:12:05,586 DEBUG zuul.zk.ZooKeeper: Initialize cache at /keystorage-oidc 2026-06-09 09:12:05,590 DEBUG zuul.zk.ZooKeeper: Cache at /keystorage-oidc is ready 2026-06-09 09:12:05,591 INFO zuul.Component: Registering component in ZooKeeper /zuul/components/executor/zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local 2026-06-09 09:12:05,600 INFO zuul.ComponentRegistry: Noticed new executor component zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-09 09:12:05,601 DEBUG zuul.ComponentRegistry: Registry got event None for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-09 09:12:05,601 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-09 09:12:05,615 INFO zuul.ComponentRegistry: System minimum data model version 37; this component 37 2026-06-09 09:12:05,623 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-09 09:12:05,623 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-09 09:12:05,626 INFO zuul.ExecutorServer: Starting executor (hostname: zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local) in unpaused mode 2026-06-09 09:12:05,628 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-09 09:12:05,629 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-09 09:12:05,980 INFO zuul.ComponentRegistry: Noticed new web component zuul-web-86458cd576-7jfmp0000000005 2026-06-09 09:12:05,981 DEBUG zuul.ComponentRegistry: Registry got event None for web zuul-web-86458cd576-7jfmp0000000005 2026-06-09 09:12:05,981 INFO zuul.ComponentRegistry: Component web zuul-web-86458cd576-7jfmp0000000005 updated: {'hostname': 'zuul-web-86458cd576-7jfmp', 'kind': 'web', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-09 09:12:06,118 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-86458cd576-7jfmp0000000005 2026-06-09 09:12:06,118 INFO zuul.ComponentRegistry: Component web zuul-web-86458cd576-7jfmp0000000005 updated: {'hostname': 'zuul-web-86458cd576-7jfmp', 'kind': 'web', 'model_api': 37, 'state': 'initializing', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-09 09:12:06,128 INFO zuul.ansible_manager: Ansible version 9 information: 2026-06-09 09:12:06,128 INFO zuul.ansible_manager: ansible [core 2.16.18] 2026-06-09 09:12:06,128 INFO zuul.ansible_manager: config file = None 2026-06-09 09:12:06,128 INFO zuul.ansible_manager: configured module search path = ['/var/lib/zuul/.ansible/plugins/modules', '/usr/share/ansible/plugins/modules'] 2026-06-09 09:12:06,128 INFO zuul.ansible_manager: ansible python module location = /usr/lib/zuul/ansible/9/lib/python3.11/site-packages/ansible 2026-06-09 09:12:06,128 INFO zuul.ansible_manager: ansible collection location = /var/lib/zuul/.ansible/collections:/usr/share/ansible/collections 2026-06-09 09:12:06,128 INFO zuul.ansible_manager: executable location = /usr/lib/zuul/ansible/9/bin/ansible 2026-06-09 09:12:06,128 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-09 09:12:06,128 INFO zuul.ansible_manager: jinja version = 3.1.6 2026-06-09 09:12:06,128 INFO zuul.ansible_manager: libyaml = True 2026-06-09 09:12:06,128 INFO zuul.ansible_manager: 2026-06-09 09:12:06,812 INFO zuul.ansible_manager: Ansible version 11 information: 2026-06-09 09:12:06,812 INFO zuul.ansible_manager: ansible [core 2.18.16] 2026-06-09 09:12:06,812 INFO zuul.ansible_manager: config file = None 2026-06-09 09:12:06,812 INFO zuul.ansible_manager: configured module search path = ['/var/lib/zuul/.ansible/plugins/modules', '/usr/share/ansible/plugins/modules'] 2026-06-09 09:12:06,812 INFO zuul.ansible_manager: ansible python module location = /usr/lib/zuul/ansible/11/lib/python3.11/site-packages/ansible 2026-06-09 09:12:06,812 INFO zuul.ansible_manager: ansible collection location = /var/lib/zuul/.ansible/collections:/usr/share/ansible/collections 2026-06-09 09:12:06,812 INFO zuul.ansible_manager: executable location = /usr/lib/zuul/ansible/11/bin/ansible 2026-06-09 09:12:06,812 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-09 09:12:06,812 INFO zuul.ansible_manager: jinja version = 3.1.6 2026-06-09 09:12:06,812 INFO zuul.ansible_manager: libyaml = True 2026-06-09 09:12:06,812 INFO zuul.ansible_manager: 2026-06-09 09:12:06,920 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-09 09:12:06,920 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-09 09:12:06,921 DEBUG zuul.ExecutorQueue: Creating executor queue at root /zuul/executor/unzoned 2026-06-09 09:12:06,927 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/executor/unzoned 2026-06-09 09:12:06,940 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/executor/unzoned is ready 2026-06-09 09:12:06,940 DEBUG zuul.ExecutorServer: Starting merger 2026-06-09 09:12:06,980 DEBUG zuul.ExecutorServer: Starting command processor 2026-06-09 09:12:06,981 DEBUG zuul.ExecutorServer: Starting 8 update workers 2026-06-09 09:12:06,988 DEBUG zuul.ExecutorServer: Joining executor 2026-06-09 09:12:06,990 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-09 09:12:06,990 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-09 09:12:08,607 INFO zuul.ComponentRegistry: Noticed new merger component zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003 2026-06-09 09:12:08,609 DEBUG zuul.ComponentRegistry: Registry got event None for merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003 2026-06-09 09:12:08,609 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-09 09:12:08,631 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003 2026-06-09 09:12:08,631 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-09 09:12:15,036 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-86458cd576-7jfmp0000000005 2026-06-09 09:12:15,036 INFO zuul.ComponentRegistry: Component web zuul-web-86458cd576-7jfmp0000000005 updated: {'hostname': 'zuul-web-86458cd576-7jfmp', 'kind': 'web', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-09 09:12:22,287 INFO zuul.ComponentRegistry: Noticed new scheduler component zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-09 09:12:22,288 DEBUG zuul.ComponentRegistry: Registry got event None for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-09 09:12:22,288 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-09 09:12:22,508 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-09 09:12:22,509 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-09 09:12:26,495 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-09 09:12:26,496 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-09 09:13:23,643 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-86458cd576-7jfmp0000000005 2026-06-09 09:13:23,643 INFO zuul.ComponentRegistry: Component web zuul-web-86458cd576-7jfmp0000000005 updated: {'hostname': 'zuul-web-86458cd576-7jfmp', 'kind': 'web', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-09 09:13:24,172 DEBUG zuul.ComponentRegistry: Registry got event DELETED for web zuul-web-86458cd576-7jfmp0000000005 2026-06-09 09:13:24,172 INFO zuul.ComponentRegistry: Noticed web component zuul-web-86458cd576-7jfmp0000000005 disappeared 2026-06-09 09:13:24,497 DEBUG zuul.JobRequestQueue: [build: 3303e44dfe7e455e97e751043c4025f4] Updating request 2026-06-09 09:13:24,501 DEBUG zuul.ExecutorServer: Next executed merge job: 2026-06-09 09:13:24,501 DEBUG zuul.ExecutorServer: Got cat job: 3303e44dfe7e455e97e751043c4025f4 2026-06-09 09:13:24,501 INFO zuul.ExecutorServer: Updating repo git-server/system-config 2026-06-09 09:13:24,516 INFO zuul.Merger: Updating local repository git-server/system-config 2026-06-09 09:13:24,517 DEBUG zuul.Repo: Updating repository /var/lib/zuul/executor-git/git-server/system-config/system-config 2026-06-09 09:13:24,680 DEBUG zuul.ExecutorServer: Finished updating repo git-server/system-config 2026-06-09 09:13:24,681 DEBUG zuul.Repo: Resetting repository /var/lib/zuul/executor-git/git-server/system-config/system-config 2026-06-09 09:13:24,699 DEBUG zuul.Repo: Getting files for /var/lib/zuul/executor-git/git-server/system-config/system-config at 6889f94739ca52833a3640fc4807bb6164de52cf 2026-06-09 09:13:24,706 DEBUG zuul.ExecutorServer: Completed cat job 3303e44dfe7e455e97e751043c4025f4: payload size: 15740 2026-06-09 09:13:24,706 INFO zuul.ExecutorServer: Merge complete, merged: False, updated: True, commit: None, branches: [] 2026-06-09 09:13:24,706 DEBUG zuul.ExecutorServer: Providing synchronous result via future for 2026-06-09 09:13:24,730 DEBUG zuul.JobRequestQueue: [build: 3303e44dfe7e455e97e751043c4025f4] Updating request 2026-06-09 09:13:24,737 DEBUG zuul.MergerApi: Removing request 2026-06-09 09:13:24,871 DEBUG zuul.JobRequestQueue: [build: 4e0d7441944242bb954edb6e02f2e1ee] Updating request 2026-06-09 09:13:24,874 DEBUG zuul.ExecutorServer: Next executed merge job: 2026-06-09 09:13:24,874 DEBUG zuul.ExecutorServer: Got cat job: 4e0d7441944242bb954edb6e02f2e1ee 2026-06-09 09:13:24,874 INFO zuul.ExecutorServer: Updating repo opendev.org/zuul/zuul-jobs 2026-06-09 09:13:24,884 INFO zuul.Merger: Updating local repository opendev.org/zuul/zuul-jobs 2026-06-09 09:13:24,885 DEBUG zuul.Repo: Updating repository /var/lib/zuul/executor-git/opendev.org/zuul/zuul%2Fzuul-jobs 2026-06-09 09:13:25,232 DEBUG zuul.ExecutorServer: Finished updating repo opendev.org/zuul/zuul-jobs 2026-06-09 09:13:25,232 DEBUG zuul.Repo: Resetting repository /var/lib/zuul/executor-git/opendev.org/zuul/zuul%2Fzuul-jobs 2026-06-09 09:13:25,250 DEBUG zuul.Repo: Getting files for /var/lib/zuul/executor-git/opendev.org/zuul/zuul%2Fzuul-jobs at 82e3e8b1292a25e38235bb92b157992d326531d1 2026-06-09 09:13:25,260 DEBUG zuul.ExecutorServer: Completed cat job 4e0d7441944242bb954edb6e02f2e1ee: payload size: 44900 2026-06-09 09:13:25,261 INFO zuul.ExecutorServer: Merge complete, merged: False, updated: True, commit: None, branches: [] 2026-06-09 09:13:25,261 DEBUG zuul.ExecutorServer: Providing synchronous result via future for 2026-06-09 09:13:25,282 DEBUG zuul.JobRequestQueue: [build: 4e0d7441944242bb954edb6e02f2e1ee] Updating request 2026-06-09 09:13:25,286 DEBUG zuul.MergerApi: Removing request 2026-06-09 09:13:27,978 DEBUG zuul.JobRequestQueue: [build: f366bf3f5a2e4c77a9a7800b12a27d4f] Updating request 2026-06-09 09:13:27,981 DEBUG zuul.ExecutorServer: Next executed merge job: 2026-06-09 09:13:27,981 DEBUG zuul.ExecutorServer: Got cat job: f366bf3f5a2e4c77a9a7800b12a27d4f 2026-06-09 09:13:27,981 INFO zuul.ExecutorServer: Updating repo gerrit/demo-project 2026-06-09 09:13:27,987 DEBUG paramiko.transport: starting thread (client mode): 0xfda9bbd0 2026-06-09 09:13:27,987 DEBUG paramiko.transport: Local version/idstring: SSH-2.0-paramiko_4.0.0 2026-06-09 09:13:27,987 DEBUG paramiko.transport: Remote version/idstring: SSH-2.0-GerritCodeReview_3.6.4 (APACHE-SSHD-2.9.2) 2026-06-09 09:13:27,987 INFO paramiko.transport: Connected (version 2.0, client GerritCodeReview_3.6.4) 2026-06-09 09:13:27,989 DEBUG paramiko.transport: === Key exchange possibilities === 2026-06-09 09:13:27,989 DEBUG paramiko.transport: kex algos: curve25519-sha256, curve25519-sha256@libssh.org, curve448-sha512, ecdh-sha2-nistp521, ecdh-sha2-nistp384, ecdh-sha2-nistp256, diffie-hellman-group-exchange-sha256, diffie-hellman-group18-sha512, diffie-hellman-group17-sha512, diffie-hellman-group16-sha512, diffie-hellman-group15-sha512, diffie-hellman-group14-sha256, ext-info-s 2026-06-09 09:13:27,989 DEBUG paramiko.transport: server key: ecdsa-sha2-nistp256, ecdsa-sha2-nistp384, ecdsa-sha2-nistp521, ssh-ed25519, rsa-sha2-512, rsa-sha2-256, ssh-rsa 2026-06-09 09:13:27,989 DEBUG paramiko.transport: client encrypt: chacha20-poly1305@openssh.com, aes128-ctr, aes192-ctr, aes256-ctr, aes128-gcm@openssh.com, aes256-gcm@openssh.com, aes128-cbc, aes192-cbc, aes256-cbc 2026-06-09 09:13:27,989 DEBUG paramiko.transport: server encrypt: chacha20-poly1305@openssh.com, aes128-ctr, aes192-ctr, aes256-ctr, aes128-gcm@openssh.com, aes256-gcm@openssh.com, aes128-cbc, aes192-cbc, aes256-cbc 2026-06-09 09:13:27,989 DEBUG paramiko.transport: client mac: hmac-sha2-256-etm@openssh.com, hmac-sha2-512-etm@openssh.com, hmac-sha1-etm@openssh.com, hmac-sha2-256, hmac-sha2-512, hmac-sha1 2026-06-09 09:13:27,989 DEBUG paramiko.transport: server mac: hmac-sha2-256-etm@openssh.com, hmac-sha2-512-etm@openssh.com, hmac-sha1-etm@openssh.com, hmac-sha2-256, hmac-sha2-512, hmac-sha1 2026-06-09 09:13:27,989 DEBUG paramiko.transport: client compress: none 2026-06-09 09:13:27,989 DEBUG paramiko.transport: server compress: none 2026-06-09 09:13:27,989 DEBUG paramiko.transport: client lang: 2026-06-09 09:13:27,989 DEBUG paramiko.transport: server lang: 2026-06-09 09:13:27,989 DEBUG paramiko.transport: kex follows: False 2026-06-09 09:13:27,989 DEBUG paramiko.transport: === Key exchange agreements === 2026-06-09 09:13:27,989 DEBUG paramiko.transport: Kex: curve25519-sha256@libssh.org 2026-06-09 09:13:27,989 DEBUG paramiko.transport: HostKey: ssh-ed25519 2026-06-09 09:13:27,989 DEBUG paramiko.transport: Cipher: aes128-ctr 2026-06-09 09:13:27,989 DEBUG paramiko.transport: MAC: hmac-sha2-256 2026-06-09 09:13:27,989 DEBUG paramiko.transport: Compression: none 2026-06-09 09:13:27,989 DEBUG paramiko.transport: === End of kex handshake === 2026-06-09 09:13:27,994 DEBUG paramiko.transport: kex engine KexCurve25519 specified hash_algo 2026-06-09 09:13:27,995 DEBUG paramiko.transport: Switch to new keys ... 2026-06-09 09:13:28,884 DEBUG paramiko.transport: Trying discovered key b'8177c37b663e20df3728f55cf32838b3' in /var/lib/zuul-ssh/..data/priv 2026-06-09 09:13:28,886 DEBUG paramiko.transport: Got EXT_INFO: {'server-sig-algs': b'ecdsa-sha2-nistp256-cert-v01@openssh.com,ecdsa-sha2-nistp384-cert-v01@openssh.com,ecdsa-sha2-nistp521-cert-v01@openssh.com,ssh-ed25519-cert-v01@openssh.com,rsa-sha2-512-cert-v01@openssh.com,rsa-sha2-256-cert-v01@openssh.com,ecdsa-sha2-nistp256,ecdsa-sha2-nistp384,ecdsa-sha2-nistp521,ssh-ed25519,sk-ecdsa-sha2-nistp256@openssh.com,sk-ssh-ed25519@openssh.com,rsa-sha2-512,rsa-sha2-256,ssh-rsa'} 2026-06-09 09:13:28,887 DEBUG paramiko.transport: userauth is OK 2026-06-09 09:13:28,887 DEBUG paramiko.transport: Finalizing pubkey algorithm for key of type 'ssh-rsa' 2026-06-09 09:13:28,888 DEBUG paramiko.transport: Our pubkey algorithm list: ['rsa-sha2-512', 'rsa-sha2-256', 'ssh-rsa'] 2026-06-09 09:13:28,888 DEBUG paramiko.transport: Server-side algorithm list: ['ecdsa-sha2-nistp256-cert-v01@openssh.com', 'ecdsa-sha2-nistp384-cert-v01@openssh.com', 'ecdsa-sha2-nistp521-cert-v01@openssh.com', 'ssh-ed25519-cert-v01@openssh.com', 'rsa-sha2-512-cert-v01@openssh.com', 'rsa-sha2-256-cert-v01@openssh.com', 'ecdsa-sha2-nistp256', 'ecdsa-sha2-nistp384', 'ecdsa-sha2-nistp521', 'ssh-ed25519', 'sk-ecdsa-sha2-nistp256@openssh.com', 'sk-ssh-ed25519@openssh.com', 'rsa-sha2-512', 'rsa-sha2-256', 'ssh-rsa'] 2026-06-09 09:13:28,888 DEBUG paramiko.transport: Agreed upon 'rsa-sha2-512' pubkey algorithm 2026-06-09 09:13:28,973 INFO paramiko.transport: Authentication (publickey) successful! 2026-06-09 09:13:28,974 DEBUG zuul.Repo: Cloning from ssh://zuul@gerrit-sshd.sf:29418/demo-project to /var/lib/zuul/executor-git/gerrit-sshd.sf/demo-project/demo-project 2026-06-09 09:13:29,073 DEBUG paramiko.transport: EOF in transport thread 2026-06-09 09:13:29,196 INFO zuul.Merger: Updating local repository gerrit/demo-project 2026-06-09 09:13:29,197 DEBUG zuul.Repo: Updating repository /var/lib/zuul/executor-git/gerrit-sshd.sf/demo-project/demo-project 2026-06-09 09:13:29,442 DEBUG zuul.ExecutorServer: Finished updating repo gerrit/demo-project 2026-06-09 09:13:29,443 DEBUG zuul.Repo: Resetting repository /var/lib/zuul/executor-git/gerrit-sshd.sf/demo-project/demo-project 2026-06-09 09:13:29,459 DEBUG zuul.Repo: Getting files for /var/lib/zuul/executor-git/gerrit-sshd.sf/demo-project/demo-project at 4d460c56e8e0e4f3f1e0d79ca9cf940b4253415b 2026-06-09 09:13:29,463 DEBUG zuul.ExecutorServer: Completed cat job f366bf3f5a2e4c77a9a7800b12a27d4f: payload size: 652 2026-06-09 09:13:29,463 INFO zuul.ExecutorServer: Merge complete, merged: False, updated: True, commit: None, branches: [] 2026-06-09 09:13:29,463 DEBUG zuul.ExecutorServer: Providing synchronous result via future for 2026-06-09 09:13:29,476 DEBUG zuul.JobRequestQueue: [build: f366bf3f5a2e4c77a9a7800b12a27d4f] Updating request 2026-06-09 09:13:29,481 DEBUG zuul.MergerApi: Removing request 2026-06-09 09:13:36,703 INFO zuul.ComponentRegistry: Noticed new web component zuul-web-86458cd576-xvxx80000000006 2026-06-09 09:13:36,704 DEBUG zuul.ComponentRegistry: Registry got event None for web zuul-web-86458cd576-xvxx80000000006 2026-06-09 09:13:36,705 INFO zuul.ComponentRegistry: Component web zuul-web-86458cd576-xvxx80000000006 updated: {'hostname': 'zuul-web-86458cd576-xvxx8', 'kind': 'web', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-09 09:13:36,926 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-86458cd576-xvxx80000000006 2026-06-09 09:13:36,926 INFO zuul.ComponentRegistry: Component web zuul-web-86458cd576-xvxx80000000006 updated: {'hostname': 'zuul-web-86458cd576-xvxx8', 'kind': 'web', 'model_api': 37, 'state': 'initializing', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-09 09:13:40,431 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-86458cd576-xvxx80000000006 2026-06-09 09:13:40,432 INFO zuul.ComponentRegistry: Component web zuul-web-86458cd576-xvxx80000000006 updated: {'hostname': 'zuul-web-86458cd576-xvxx8', 'kind': 'web', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'}