+ update-ca-trust extract -o /etc/pki/ca-trust/extracted + git config --global --add safe.directory '*' + exec /usr/local/bin/zuul-merger -f -d 2026-06-11 13:47:29,296 DEBUG zuul.Merger: Configured logging: 14.1.1.dev1 2026-06-11 13:47:29,468 DEBUG zuul.zk.base.ZooKeeperClient: ZooKeeper connection (session: 0x100000f4822000d): CONNECTED 2026-06-11 13:47:29,493 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/merger 2026-06-11 13:47:29,500 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/merger is ready 2026-06-11 13:47:29,501 INFO zuul.Component: Registering component in ZooKeeper /zuul/components/merger/zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local 2026-06-11 13:47:29,506 INFO zuul.ComponentRegistry: Noticed new executor component zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-11 13:47:29,506 DEBUG zuul.ComponentRegistry: Registry got event None for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-11 13:47:29,507 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-11 13:47:29,508 INFO zuul.ComponentRegistry: Noticed new merger component zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003 2026-06-11 13:47:29,508 DEBUG zuul.ComponentRegistry: Registry got event None for merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003 2026-06-11 13:47:29,508 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-11 13:47:29,511 INFO zuul.ComponentRegistry: Noticed new web component zuul-web-6c6fd75fdc-5jpkm0000000005 2026-06-11 13:47:29,511 DEBUG zuul.ComponentRegistry: Registry got event None for web zuul-web-6c6fd75fdc-5jpkm0000000005 2026-06-11 13:47:29,512 INFO zuul.ComponentRegistry: Component web zuul-web-6c6fd75fdc-5jpkm0000000005 updated: {'hostname': 'zuul-web-6c6fd75fdc-5jpkm', 'kind': 'web', 'model_api': 37, 'state': 'initializing', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-11 13:47:29,513 INFO zuul.ComponentRegistry: System minimum data model version 37; this component 37 2026-06-11 13:47:29,513 DEBUG zuul.MergeServer: Starting merger 2026-06-11 13:47:29,514 DEBUG zuul.MergeServer: Starting command processor 2026-06-11 13:47:29,517 DEBUG zuul.MergeServer: Joining merger 2026-06-11 13:47:29,517 DEBUG zuul.MergeServer: Joining base merge server 2026-06-11 13:47:29,518 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003 2026-06-11 13:47:29,518 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-11 13:47:37,801 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-6c6fd75fdc-5jpkm0000000005 2026-06-11 13:47:37,801 INFO zuul.ComponentRegistry: Component web zuul-web-6c6fd75fdc-5jpkm0000000005 updated: {'hostname': 'zuul-web-6c6fd75fdc-5jpkm', 'kind': 'web', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-11 13:47:46,982 INFO zuul.ComponentRegistry: Noticed new scheduler component zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-11 13:47:46,983 DEBUG zuul.ComponentRegistry: Registry got event None for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-11 13:47:46,983 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-11 13:47:47,303 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-11 13:47:47,303 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-11 13:47:59,133 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-11 13:47:59,133 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-11 13:48:42,331 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-6c6fd75fdc-5jpkm0000000005 2026-06-11 13:48:42,331 INFO zuul.ComponentRegistry: Component web zuul-web-6c6fd75fdc-5jpkm0000000005 updated: {'hostname': 'zuul-web-6c6fd75fdc-5jpkm', 'kind': 'web', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-11 13:48:42,988 DEBUG zuul.ComponentRegistry: Registry got event DELETED for web zuul-web-6c6fd75fdc-5jpkm0000000005 2026-06-11 13:48:42,988 INFO zuul.ComponentRegistry: Noticed web component zuul-web-6c6fd75fdc-5jpkm0000000005 disappeared 2026-06-11 13:48:43,460 DEBUG zuul.JobRequestQueue: [build: ca0423d07eb84d9480360df3c9d011be] Updating request 2026-06-11 13:48:43,465 DEBUG zuul.MergeServer: Next executed merge job: 2026-06-11 13:48:43,465 DEBUG zuul.MergeServer: Got cat job: ca0423d07eb84d9480360df3c9d011be 2026-06-11 13:48:43,483 INFO zuul.Merger: Updating local repository opendev.org/zuul/zuul-jobs 2026-06-11 13:48:43,485 DEBUG zuul.Repo: Updating repository /var/lib/zuul/git/opendev.org/zuul/zuul%2Fzuul-jobs 2026-06-11 13:48:43,916 DEBUG zuul.Repo: Resetting repository /var/lib/zuul/git/opendev.org/zuul/zuul%2Fzuul-jobs 2026-06-11 13:48:43,938 DEBUG zuul.Repo: Getting files for /var/lib/zuul/git/opendev.org/zuul/zuul%2Fzuul-jobs at 82e3e8b1292a25e38235bb92b157992d326531d1 2026-06-11 13:48:43,948 DEBUG zuul.MergeServer: Completed cat job ca0423d07eb84d9480360df3c9d011be: payload size: 44901 2026-06-11 13:48:43,948 INFO zuul.MergeServer: Merge complete, merged: False, updated: True, commit: None, branches: [] 2026-06-11 13:48:43,948 DEBUG zuul.MergeServer: Providing synchronous result via future for 2026-06-11 13:48:43,968 DEBUG zuul.JobRequestQueue: [build: ca0423d07eb84d9480360df3c9d011be] Updating request 2026-06-11 13:48:43,979 DEBUG zuul.MergerApi: Removing request 2026-06-11 13:48:44,016 DEBUG zuul.JobRequestQueue: [build: 2cd4ddd4e6a044c4a62444efe8514456] Updating request 2026-06-11 13:48:44,019 DEBUG zuul.MergeServer: Next executed merge job: 2026-06-11 13:48:44,019 DEBUG zuul.MergeServer: Got cat job: 2cd4ddd4e6a044c4a62444efe8514456 2026-06-11 13:48:44,031 INFO zuul.Merger: Updating local repository git-server/system-config 2026-06-11 13:48:44,032 DEBUG zuul.Repo: Updating repository /var/lib/zuul/git/git-server/system-config/system-config 2026-06-11 13:48:44,145 DEBUG zuul.Repo: Resetting repository /var/lib/zuul/git/git-server/system-config/system-config 2026-06-11 13:48:44,172 DEBUG zuul.Repo: Getting files for /var/lib/zuul/git/git-server/system-config/system-config at 1f8f35c843bbbec3cf372f605c8389421597e9a8 2026-06-11 13:48:44,179 DEBUG zuul.MergeServer: Completed cat job 2cd4ddd4e6a044c4a62444efe8514456: payload size: 15740 2026-06-11 13:48:44,179 INFO zuul.MergeServer: Merge complete, merged: False, updated: True, commit: None, branches: [] 2026-06-11 13:48:44,179 DEBUG zuul.MergeServer: Providing synchronous result via future for 2026-06-11 13:48:44,198 DEBUG zuul.JobRequestQueue: [build: 2cd4ddd4e6a044c4a62444efe8514456] Updating request 2026-06-11 13:48:44,204 DEBUG zuul.MergerApi: Removing request 2026-06-11 13:48:46,372 DEBUG zuul.JobRequestQueue: [build: c10c02b344db4d5f85d675bcd53c6d9c] Updating request 2026-06-11 13:48:46,374 DEBUG zuul.MergeServer: Next executed merge job: 2026-06-11 13:48:46,375 DEBUG zuul.MergeServer: Got cat job: c10c02b344db4d5f85d675bcd53c6d9c 2026-06-11 13:48:46,378 DEBUG paramiko.transport: starting thread (client mode): 0x4ed66090 2026-06-11 13:48:46,378 DEBUG paramiko.transport: Local version/idstring: SSH-2.0-paramiko_4.0.0 2026-06-11 13:48:46,378 DEBUG paramiko.transport: Remote version/idstring: SSH-2.0-GerritCodeReview_3.6.4 (APACHE-SSHD-2.9.2) 2026-06-11 13:48:46,378 INFO paramiko.transport: Connected (version 2.0, client GerritCodeReview_3.6.4) 2026-06-11 13:48:46,379 DEBUG paramiko.transport: === Key exchange possibilities === 2026-06-11 13:48:46,379 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-11 13:48:46,379 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-11 13:48:46,379 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-11 13:48:46,379 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-11 13:48:46,380 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-11 13:48:46,380 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-11 13:48:46,380 DEBUG paramiko.transport: client compress: none 2026-06-11 13:48:46,380 DEBUG paramiko.transport: server compress: none 2026-06-11 13:48:46,380 DEBUG paramiko.transport: client lang: 2026-06-11 13:48:46,380 DEBUG paramiko.transport: server lang: 2026-06-11 13:48:46,380 DEBUG paramiko.transport: kex follows: False 2026-06-11 13:48:46,380 DEBUG paramiko.transport: === Key exchange agreements === 2026-06-11 13:48:46,380 DEBUG paramiko.transport: Kex: curve25519-sha256@libssh.org 2026-06-11 13:48:46,380 DEBUG paramiko.transport: HostKey: ssh-ed25519 2026-06-11 13:48:46,380 DEBUG paramiko.transport: Cipher: aes128-ctr 2026-06-11 13:48:46,380 DEBUG paramiko.transport: MAC: hmac-sha2-256 2026-06-11 13:48:46,380 DEBUG paramiko.transport: Compression: none 2026-06-11 13:48:46,380 DEBUG paramiko.transport: === End of kex handshake === 2026-06-11 13:48:46,429 DEBUG paramiko.transport: kex engine KexCurve25519 specified hash_algo 2026-06-11 13:48:46,430 DEBUG paramiko.transport: Switch to new keys ... 2026-06-11 13:48:46,431 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-11 13:48:47,194 DEBUG paramiko.transport: Trying discovered key b'484be8384d249684071beb82f892e66f' in /var/lib/zuul-ssh/..data/priv 2026-06-11 13:48:47,195 DEBUG paramiko.transport: userauth is OK 2026-06-11 13:48:47,195 DEBUG paramiko.transport: Finalizing pubkey algorithm for key of type 'ssh-rsa' 2026-06-11 13:48:47,196 DEBUG paramiko.transport: Our pubkey algorithm list: ['rsa-sha2-512', 'rsa-sha2-256', 'ssh-rsa'] 2026-06-11 13:48:47,196 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-11 13:48:47,196 DEBUG paramiko.transport: Agreed upon 'rsa-sha2-512' pubkey algorithm 2026-06-11 13:48:47,262 INFO paramiko.transport: Authentication (publickey) successful! 2026-06-11 13:48:47,274 INFO zuul.Merger: Updating local repository gerrit/demo-project 2026-06-11 13:48:47,276 DEBUG zuul.Repo: Updating repository /var/lib/zuul/git/gerrit-sshd.sf/demo-project/demo-project 2026-06-11 13:48:47,362 DEBUG paramiko.transport: EOF in transport thread 2026-06-11 13:48:47,488 DEBUG zuul.Repo: Resetting repository /var/lib/zuul/git/gerrit-sshd.sf/demo-project/demo-project 2026-06-11 13:48:47,510 DEBUG zuul.Repo: Getting files for /var/lib/zuul/git/gerrit-sshd.sf/demo-project/demo-project at 26098dd8f472b049ff66adaf4cbbb16f3207d7fa 2026-06-11 13:48:47,515 DEBUG zuul.MergeServer: Completed cat job c10c02b344db4d5f85d675bcd53c6d9c: payload size: 652 2026-06-11 13:48:47,515 INFO zuul.MergeServer: Merge complete, merged: False, updated: True, commit: None, branches: [] 2026-06-11 13:48:47,515 DEBUG zuul.MergeServer: Providing synchronous result via future for 2026-06-11 13:48:47,526 DEBUG zuul.JobRequestQueue: [build: c10c02b344db4d5f85d675bcd53c6d9c] Updating request 2026-06-11 13:48:47,532 DEBUG zuul.MergerApi: Removing request 2026-06-11 13:48:55,980 INFO zuul.ComponentRegistry: Noticed new web component zuul-web-6c6fd75fdc-7qxfs0000000006 2026-06-11 13:48:55,981 DEBUG zuul.ComponentRegistry: Registry got event None for web zuul-web-6c6fd75fdc-7qxfs0000000006 2026-06-11 13:48:55,981 INFO zuul.ComponentRegistry: Component web zuul-web-6c6fd75fdc-7qxfs0000000006 updated: {'hostname': 'zuul-web-6c6fd75fdc-7qxfs', 'kind': 'web', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-11 13:48:56,206 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-6c6fd75fdc-7qxfs0000000006 2026-06-11 13:48:56,206 INFO zuul.ComponentRegistry: Component web zuul-web-6c6fd75fdc-7qxfs0000000006 updated: {'hostname': 'zuul-web-6c6fd75fdc-7qxfs', 'kind': 'web', 'model_api': 37, 'state': 'initializing', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-11 13:49:00,306 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-6c6fd75fdc-7qxfs0000000006 2026-06-11 13:49:00,306 INFO zuul.ComponentRegistry: Component web zuul-web-6c6fd75fdc-7qxfs0000000006 updated: {'hostname': 'zuul-web-6c6fd75fdc-7qxfs', 'kind': 'web', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'}