+ 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-12 01:05:10,935 DEBUG zuul.Merger: Configured logging: 14.1.1.dev1
2026-06-12 01:05:11,444 DEBUG zuul.zk.base.ZooKeeperClient: ZooKeeper connection (session: 0x1000039da2c0003): CONNECTED
2026-06-12 01:05:11,556 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/merger
2026-06-12 01:05:11,653 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/merger is ready
2026-06-12 01:05:11,654 INFO zuul.Component: Registering component in ZooKeeper /zuul/components/merger/zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local
2026-06-12 01:05:11,749 INFO zuul.ComponentRegistry: Noticed new executor component zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000000
2026-06-12 01:05:11,751 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f23ad12cad0> got event None for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000000
2026-06-12 01:05:11,751 INFO zuul.ComponentRegistry: Component executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000000 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-12 01:05:11,757 INFO zuul.ComponentRegistry: Noticed new merger component zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000000
2026-06-12 01:05:11,758 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f23ad12cad0> got event None for merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000000
2026-06-12 01:05:11,759 INFO zuul.ComponentRegistry: Component merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000000 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-12 01:05:11,768 INFO zuul.ComponentRegistry: Noticed new web component zuul-web-74c88ff8b-x4pwd0000000000
2026-06-12 01:05:11,770 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f23ad12cad0> got event None for web zuul-web-74c88ff8b-x4pwd0000000000
2026-06-12 01:05:11,770 INFO zuul.ComponentRegistry: Component web zuul-web-74c88ff8b-x4pwd0000000000 updated: {'hostname': 'zuul-web-74c88ff8b-x4pwd', 'kind': 'web', 'model_api': 37, 'state': 'initializing', 'version': '14.1.1.dev1 90eea2ed8'}
2026-06-12 01:05:11,774 INFO zuul.ComponentRegistry: System minimum data model version 37; this component 37
2026-06-12 01:05:11,775 DEBUG zuul.MergeServer: Starting merger
2026-06-12 01:05:11,776 DEBUG zuul.MergeServer: Starting command processor
2026-06-12 01:05:11,781 DEBUG zuul.MergeServer: Joining merger
2026-06-12 01:05:11,781 DEBUG zuul.MergeServer: Joining base merge server
2026-06-12 01:05:11,788 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f23ad12cad0> got event CHANGED for merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000000
2026-06-12 01:05:11,788 INFO zuul.ComponentRegistry: Component merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000000 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-12 01:05:29,653 INFO zuul.ComponentRegistry: Noticed new scheduler component zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000000
2026-06-12 01:05:29,655 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f23ad12cad0> got event None for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000000
2026-06-12 01:05:29,655 INFO zuul.ComponentRegistry: Component scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000000 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-12 01:05:30,136 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f23ad12cad0> got event CHANGED for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000000
2026-06-12 01:05:30,137 INFO zuul.ComponentRegistry: Component scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000000 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-12 01:05:37,059 DEBUG zuul.JobRequestQueue: [build: b950e37d2234483282150dd97eb3e77a] Updating request <MergeRequest b950e37d2234483282150dd97eb3e77a, job_type=cat, state=running, path=/zuul/merger/requests/b950e37d2234483282150dd97eb3e77a>
2026-06-12 01:05:37,065 DEBUG zuul.MergeServer: Next executed merge job: <MergeRequest b950e37d2234483282150dd97eb3e77a, job_type=cat, state=running, path=/zuul/merger/requests/b950e37d2234483282150dd97eb3e77a>
2026-06-12 01:05:37,065 DEBUG zuul.MergeServer: Got cat job: b950e37d2234483282150dd97eb3e77a
2026-06-12 01:05:37,065 DEBUG zuul.Repo: Cloning from git://git-server/system-config to /var/lib/zuul/git/git-server/system-config/system-config
2026-06-12 01:05:37,209 INFO zuul.Merger: Updating local repository git-server/system-config
2026-06-12 01:05:37,211 DEBUG zuul.Repo: Updating repository /var/lib/zuul/git/git-server/system-config/system-config
2026-06-12 01:05:37,283 DEBUG zuul.Repo: Resetting repository /var/lib/zuul/git/git-server/system-config/system-config
2026-06-12 01:05:37,306 DEBUG zuul.Repo: Getting files for /var/lib/zuul/git/git-server/system-config/system-config at a64edd4c760d9ce190bbf00be95f8ce5ff63a329
2026-06-12 01:05:37,312 DEBUG zuul.MergeServer: Completed cat job b950e37d2234483282150dd97eb3e77a: payload size: 3276
2026-06-12 01:05:37,312 INFO zuul.MergeServer: Merge <MergeRequest b950e37d2234483282150dd97eb3e77a, job_type=cat, state=running, path=/zuul/merger/requests/b950e37d2234483282150dd97eb3e77a> complete, merged: False, updated: True, commit: None, branches: []
2026-06-12 01:05:37,312 DEBUG zuul.MergeServer: Providing synchronous result via future for <MergeRequest b950e37d2234483282150dd97eb3e77a, job_type=cat, state=running, path=/zuul/merger/requests/b950e37d2234483282150dd97eb3e77a>
2026-06-12 01:05:37,323 DEBUG zuul.JobRequestQueue: [build: b950e37d2234483282150dd97eb3e77a] Updating request <MergeRequest b950e37d2234483282150dd97eb3e77a, job_type=cat, state=completed, path=/zuul/merger/requests/b950e37d2234483282150dd97eb3e77a>
2026-06-12 01:05:37,329 DEBUG zuul.MergerApi: Removing request <MergeRequest b950e37d2234483282150dd97eb3e77a, job_type=cat, state=completed, path=/zuul/merger/requests/b950e37d2234483282150dd97eb3e77a>
2026-06-12 01:05:37,353 DEBUG zuul.JobRequestQueue: [build: f5678e29b5ec44b6aab887c7b6ba17c0] Updating request <MergeRequest f5678e29b5ec44b6aab887c7b6ba17c0, job_type=cat, state=running, path=/zuul/merger/requests/f5678e29b5ec44b6aab887c7b6ba17c0>
2026-06-12 01:05:37,355 DEBUG zuul.MergeServer: Next executed merge job: <MergeRequest f5678e29b5ec44b6aab887c7b6ba17c0, job_type=cat, state=running, path=/zuul/merger/requests/f5678e29b5ec44b6aab887c7b6ba17c0>
2026-06-12 01:05:37,356 DEBUG zuul.MergeServer: Got cat job: f5678e29b5ec44b6aab887c7b6ba17c0
2026-06-12 01:05:37,356 DEBUG zuul.Repo: Cloning from https://opendev.org/zuul/zuul-jobs to /var/lib/zuul/git/opendev.org/zuul/zuul%2Fzuul-jobs
2026-06-12 01:05:40,287 INFO zuul.Merger: Updating local repository opendev.org/zuul/zuul-jobs
2026-06-12 01:05:40,289 DEBUG zuul.Repo: Updating repository /var/lib/zuul/git/opendev.org/zuul/zuul%2Fzuul-jobs
2026-06-12 01:05:40,765 DEBUG zuul.Repo: Resetting repository /var/lib/zuul/git/opendev.org/zuul/zuul%2Fzuul-jobs
2026-06-12 01:05:40,788 DEBUG zuul.Repo: Getting files for /var/lib/zuul/git/opendev.org/zuul/zuul%2Fzuul-jobs at 82e3e8b1292a25e38235bb92b157992d326531d1
2026-06-12 01:05:40,795 DEBUG zuul.MergeServer: Completed cat job f5678e29b5ec44b6aab887c7b6ba17c0: payload size: 44900
2026-06-12 01:05:40,796 INFO zuul.MergeServer: Merge <MergeRequest f5678e29b5ec44b6aab887c7b6ba17c0, job_type=cat, state=running, path=/zuul/merger/requests/f5678e29b5ec44b6aab887c7b6ba17c0> complete, merged: False, updated: True, commit: None, branches: []
2026-06-12 01:05:40,796 DEBUG zuul.MergeServer: Providing synchronous result via future for <MergeRequest f5678e29b5ec44b6aab887c7b6ba17c0, job_type=cat, state=running, path=/zuul/merger/requests/f5678e29b5ec44b6aab887c7b6ba17c0>
2026-06-12 01:05:40,835 DEBUG zuul.JobRequestQueue: [build: f5678e29b5ec44b6aab887c7b6ba17c0] Updating request <MergeRequest f5678e29b5ec44b6aab887c7b6ba17c0, job_type=cat, state=completed, path=/zuul/merger/requests/f5678e29b5ec44b6aab887c7b6ba17c0>
2026-06-12 01:05:40,842 DEBUG zuul.MergerApi: Removing request <MergeRequest f5678e29b5ec44b6aab887c7b6ba17c0, job_type=cat, state=completed, path=/zuul/merger/requests/f5678e29b5ec44b6aab887c7b6ba17c0>
2026-06-12 01:05:42,934 DEBUG zuul.JobRequestQueue: [build: daf2353ca1d8457cbe067772044573d5] Updating request <MergeRequest daf2353ca1d8457cbe067772044573d5, job_type=cat, state=running, path=/zuul/merger/requests/daf2353ca1d8457cbe067772044573d5>
2026-06-12 01:05:42,937 DEBUG zuul.MergeServer: Next executed merge job: <MergeRequest daf2353ca1d8457cbe067772044573d5, job_type=cat, state=running, path=/zuul/merger/requests/daf2353ca1d8457cbe067772044573d5>
2026-06-12 01:05:42,937 DEBUG zuul.MergeServer: Got cat job: daf2353ca1d8457cbe067772044573d5
2026-06-12 01:05:42,941 DEBUG paramiko.transport: starting thread (client mode): 0xad0bf550
2026-06-12 01:05:42,942 DEBUG paramiko.transport: Local version/idstring: SSH-2.0-paramiko_4.0.0
2026-06-12 01:05:42,942 DEBUG paramiko.transport: Remote version/idstring: SSH-2.0-GerritCodeReview_3.6.4 (APACHE-SSHD-2.9.2)
2026-06-12 01:05:42,942 INFO paramiko.transport: Connected (version 2.0, client GerritCodeReview_3.6.4)
2026-06-12 01:05:42,943 DEBUG paramiko.transport: === Key exchange possibilities ===
2026-06-12 01:05:42,943 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-12 01:05:42,943 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-12 01:05:42,943 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-12 01:05:42,943 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-12 01:05:42,943 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-12 01:05:42,943 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-12 01:05:42,943 DEBUG paramiko.transport: client compress: none
2026-06-12 01:05:42,943 DEBUG paramiko.transport: server compress: none
2026-06-12 01:05:42,944 DEBUG paramiko.transport: client lang: <none>
2026-06-12 01:05:42,944 DEBUG paramiko.transport: server lang: <none>
2026-06-12 01:05:42,944 DEBUG paramiko.transport: kex follows: False
2026-06-12 01:05:42,944 DEBUG paramiko.transport: === Key exchange agreements ===
2026-06-12 01:05:42,944 DEBUG paramiko.transport: Kex: curve25519-sha256@libssh.org
2026-06-12 01:05:42,944 DEBUG paramiko.transport: HostKey: ssh-ed25519
2026-06-12 01:05:42,944 DEBUG paramiko.transport: Cipher: aes128-ctr
2026-06-12 01:05:42,944 DEBUG paramiko.transport: MAC: hmac-sha2-256
2026-06-12 01:05:42,944 DEBUG paramiko.transport: Compression: none
2026-06-12 01:05:42,944 DEBUG paramiko.transport: === End of kex handshake ===
2026-06-12 01:05:42,947 DEBUG paramiko.transport: kex engine KexCurve25519 specified hash_algo <built-in function openssl_sha256>
2026-06-12 01:05:42,948 DEBUG paramiko.transport: Switch to new keys ...
2026-06-12 01:05:42,949 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-12 01:05:42,949 DEBUG paramiko.transport: Adding ssh-ed25519 host key for [gerrit-sshd.sf]:29418: b'c949adaa3892c5be68387e3487e9bbdf'
2026-06-12 01:05:43,960 DEBUG paramiko.transport: Trying discovered key b'b276f7c237799664724ab35be46693e4' in /var/lib/zuul-ssh/..data/priv
2026-06-12 01:05:43,961 DEBUG paramiko.transport: userauth is OK
2026-06-12 01:05:43,961 DEBUG paramiko.transport: Finalizing pubkey algorithm for key of type 'ssh-rsa'
2026-06-12 01:05:43,961 DEBUG paramiko.transport: Our pubkey algorithm list: ['rsa-sha2-512', 'rsa-sha2-256', 'ssh-rsa']
2026-06-12 01:05:43,961 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-12 01:05:43,961 DEBUG paramiko.transport: Agreed upon 'rsa-sha2-512' pubkey algorithm
2026-06-12 01:05:43,992 INFO paramiko.transport: Authentication (publickey) successful!
2026-06-12 01:05:43,992 DEBUG zuul.Repo: Cloning from ssh://zuul@gerrit-sshd.sf:29418/demo-project to /var/lib/zuul/git/gerrit-sshd.sf/demo-project/demo-project
2026-06-12 01:05:44,093 DEBUG paramiko.transport: EOF in transport thread
2026-06-12 01:05:44,302 INFO zuul.Merger: Updating local repository gerrit/demo-project
2026-06-12 01:05:44,304 DEBUG zuul.Repo: Updating repository /var/lib/zuul/git/gerrit-sshd.sf/demo-project/demo-project
2026-06-12 01:05:44,488 DEBUG zuul.Repo: Resetting repository /var/lib/zuul/git/gerrit-sshd.sf/demo-project/demo-project
2026-06-12 01:05:44,508 DEBUG zuul.Repo: Getting files for /var/lib/zuul/git/gerrit-sshd.sf/demo-project/demo-project at c5b66007e5ff93cfd4b45a4fc56b6ef19b3ec858
2026-06-12 01:05:44,515 DEBUG zuul.MergeServer: Completed cat job daf2353ca1d8457cbe067772044573d5: payload size: 1572
2026-06-12 01:05:44,515 INFO zuul.MergeServer: Merge <MergeRequest daf2353ca1d8457cbe067772044573d5, job_type=cat, state=running, path=/zuul/merger/requests/daf2353ca1d8457cbe067772044573d5> complete, merged: False, updated: True, commit: None, branches: []
2026-06-12 01:05:44,515 DEBUG zuul.MergeServer: Providing synchronous result via future for <MergeRequest daf2353ca1d8457cbe067772044573d5, job_type=cat, state=running, path=/zuul/merger/requests/daf2353ca1d8457cbe067772044573d5>
2026-06-12 01:05:44,533 DEBUG zuul.JobRequestQueue: [build: daf2353ca1d8457cbe067772044573d5] Updating request <MergeRequest daf2353ca1d8457cbe067772044573d5, job_type=cat, state=completed, path=/zuul/merger/requests/daf2353ca1d8457cbe067772044573d5>
2026-06-12 01:05:44,538 DEBUG zuul.MergerApi: Removing request <MergeRequest daf2353ca1d8457cbe067772044573d5, job_type=cat, state=completed, path=/zuul/merger/requests/daf2353ca1d8457cbe067772044573d5>
2026-06-12 01:05:44,945 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f23ad12cad0> got event CHANGED for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000000
2026-06-12 01:05:44,945 INFO zuul.ComponentRegistry: Component scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000000 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-12 01:05:46,073 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f23ad12cad0> got event CHANGED for web zuul-web-74c88ff8b-x4pwd0000000000
2026-06-12 01:05:46,073 INFO zuul.ComponentRegistry: Component web zuul-web-74c88ff8b-x4pwd0000000000 updated: {'hostname': 'zuul-web-74c88ff8b-x4pwd', 'kind': 'web', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'}
2026-06-12 01:06:28,102 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f23ad12cad0> got event CHANGED for web zuul-web-74c88ff8b-x4pwd0000000000
2026-06-12 01:06:28,102 INFO zuul.ComponentRegistry: Component web zuul-web-74c88ff8b-x4pwd0000000000 updated: {'hostname': 'zuul-web-74c88ff8b-x4pwd', 'kind': 'web', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'}
2026-06-12 01:06:28,174 DEBUG zuul.JobRequestQueue: [build: 1b10b3de8ef74704a23cdc020bf055c8] Updating request <MergeRequest 1b10b3de8ef74704a23cdc020bf055c8, job_type=cat, state=running, path=/zuul/merger/requests/1b10b3de8ef74704a23cdc020bf055c8>
2026-06-12 01:06:28,178 DEBUG zuul.MergeServer: Next executed merge job: <MergeRequest 1b10b3de8ef74704a23cdc020bf055c8, job_type=cat, state=running, path=/zuul/merger/requests/1b10b3de8ef74704a23cdc020bf055c8>
2026-06-12 01:06:28,180 DEBUG zuul.MergeServer: Got cat job: 1b10b3de8ef74704a23cdc020bf055c8
2026-06-12 01:06:28,180 INFO zuul.Merger: Updating local repository git-server/system-config
2026-06-12 01:06:28,183 DEBUG zuul.Repo: Updating repository /var/lib/zuul/git/git-server/system-config/system-config
2026-06-12 01:06:28,305 DEBUG zuul.Repo: Resetting repository /var/lib/zuul/git/git-server/system-config/system-config
2026-06-12 01:06:28,323 DEBUG zuul.Repo: Getting files for /var/lib/zuul/git/git-server/system-config/system-config at 8232e6067f31542e4f9e2bc02fce31113b51bdcd
2026-06-12 01:06:28,329 DEBUG zuul.MergeServer: Completed cat job 1b10b3de8ef74704a23cdc020bf055c8: payload size: 15740
2026-06-12 01:06:28,329 INFO zuul.MergeServer: Merge <MergeRequest 1b10b3de8ef74704a23cdc020bf055c8, job_type=cat, state=running, path=/zuul/merger/requests/1b10b3de8ef74704a23cdc020bf055c8> complete, merged: False, updated: True, commit: None, branches: []
2026-06-12 01:06:28,329 DEBUG zuul.MergeServer: Providing synchronous result via future for <MergeRequest 1b10b3de8ef74704a23cdc020bf055c8, job_type=cat, state=running, path=/zuul/merger/requests/1b10b3de8ef74704a23cdc020bf055c8>
2026-06-12 01:06:28,350 DEBUG zuul.JobRequestQueue: [build: 1b10b3de8ef74704a23cdc020bf055c8] Updating request <MergeRequest 1b10b3de8ef74704a23cdc020bf055c8, job_type=cat, state=completed, path=/zuul/merger/requests/1b10b3de8ef74704a23cdc020bf055c8>
2026-06-12 01:06:28,354 DEBUG zuul.MergerApi: Removing request <MergeRequest 1b10b3de8ef74704a23cdc020bf055c8, job_type=cat, state=completed, path=/zuul/merger/requests/1b10b3de8ef74704a23cdc020bf055c8>
2026-06-12 01:06:28,384 DEBUG zuul.JobRequestQueue: [build: 1b0b7e9e57144366a6b283f78c1e3d83] Updating request <MergeRequest 1b0b7e9e57144366a6b283f78c1e3d83, job_type=cat, state=running, path=/zuul/merger/requests/1b0b7e9e57144366a6b283f78c1e3d83>
2026-06-12 01:06:28,388 DEBUG zuul.MergeServer: Next executed merge job: <MergeRequest 1b0b7e9e57144366a6b283f78c1e3d83, job_type=cat, state=running, path=/zuul/merger/requests/1b0b7e9e57144366a6b283f78c1e3d83>
2026-06-12 01:06:28,389 DEBUG zuul.MergeServer: Got cat job: 1b0b7e9e57144366a6b283f78c1e3d83
2026-06-12 01:06:28,389 INFO zuul.Merger: Updating local repository opendev.org/zuul/zuul-jobs
2026-06-12 01:06:28,392 DEBUG zuul.Repo: Updating repository /var/lib/zuul/git/opendev.org/zuul/zuul%2Fzuul-jobs
2026-06-12 01:06:28,815 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f23ad12cad0> got event DELETED for web zuul-web-74c88ff8b-x4pwd0000000000
2026-06-12 01:06:28,815 INFO zuul.ComponentRegistry: Noticed web component zuul-web-74c88ff8b-x4pwd0000000000 disappeared
2026-06-12 01:06:28,825 DEBUG zuul.Repo: Resetting repository /var/lib/zuul/git/opendev.org/zuul/zuul%2Fzuul-jobs
2026-06-12 01:06:28,848 DEBUG zuul.Repo: Getting files for /var/lib/zuul/git/opendev.org/zuul/zuul%2Fzuul-jobs at 82e3e8b1292a25e38235bb92b157992d326531d1
2026-06-12 01:06:28,856 DEBUG zuul.MergeServer: Completed cat job 1b0b7e9e57144366a6b283f78c1e3d83: payload size: 44901
2026-06-12 01:06:28,856 INFO zuul.MergeServer: Merge <MergeRequest 1b0b7e9e57144366a6b283f78c1e3d83, job_type=cat, state=running, path=/zuul/merger/requests/1b0b7e9e57144366a6b283f78c1e3d83> complete, merged: False, updated: True, commit: None, branches: []
2026-06-12 01:06:28,856 DEBUG zuul.MergeServer: Providing synchronous result via future for <MergeRequest 1b0b7e9e57144366a6b283f78c1e3d83, job_type=cat, state=running, path=/zuul/merger/requests/1b0b7e9e57144366a6b283f78c1e3d83>
2026-06-12 01:06:28,875 DEBUG zuul.JobRequestQueue: [build: 1b0b7e9e57144366a6b283f78c1e3d83] Updating request <MergeRequest 1b0b7e9e57144366a6b283f78c1e3d83, job_type=cat, state=completed, path=/zuul/merger/requests/1b0b7e9e57144366a6b283f78c1e3d83>
2026-06-12 01:06:28,881 DEBUG zuul.MergerApi: Removing request <MergeRequest 1b0b7e9e57144366a6b283f78c1e3d83, job_type=cat, state=completed, path=/zuul/merger/requests/1b0b7e9e57144366a6b283f78c1e3d83>
2026-06-12 01:06:45,722 INFO zuul.ComponentRegistry: Noticed new web component zuul-web-74c88ff8b-l76wt0000000001
2026-06-12 01:06:45,723 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f23ad12cad0> got event None for web zuul-web-74c88ff8b-l76wt0000000001
2026-06-12 01:06:45,723 INFO zuul.ComponentRegistry: Component web zuul-web-74c88ff8b-l76wt0000000001 updated: {'hostname': 'zuul-web-74c88ff8b-l76wt', 'kind': 'web', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'}
2026-06-12 01:06:45,903 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f23ad12cad0> got event CHANGED for web zuul-web-74c88ff8b-l76wt0000000001
2026-06-12 01:06:45,904 INFO zuul.ComponentRegistry: Component web zuul-web-74c88ff8b-l76wt0000000001 updated: {'hostname': 'zuul-web-74c88ff8b-l76wt', 'kind': 'web', 'model_api': 37, 'state': 'initializing', 'version': '14.1.1.dev1 90eea2ed8'}
2026-06-12 01:06:50,243 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f23ad12cad0> got event CHANGED for web zuul-web-74c88ff8b-l76wt0000000001
2026-06-12 01:06:50,244 INFO zuul.ComponentRegistry: Component web zuul-web-74c88ff8b-l76wt0000000001 updated: {'hostname': 'zuul-web-74c88ff8b-l76wt', 'kind': 'web', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'}
2026-06-12 01:07:59,336 DEBUG zuul.JobRequestQueue: [e: 1889e1e5b32e40d79c8952fb077d8e2c] [build: c8c84e52cad7467cb458bba1ff9d4e9c] Updating request <MergeRequest c8c84e52cad7467cb458bba1ff9d4e9c, job_type=merge, state=running, path=/zuul/merger/requests/c8c84e52cad7467cb458bba1ff9d4e9c>
2026-06-12 01:07:59,339 DEBUG zuul.MergeServer: Next executed merge job: <MergeRequest c8c84e52cad7467cb458bba1ff9d4e9c, job_type=merge, state=running, path=/zuul/merger/requests/c8c84e52cad7467cb458bba1ff9d4e9c>
2026-06-12 01:07:59,339 DEBUG zuul.MergeServer: Got merge job: c8c84e52cad7467cb458bba1ff9d4e9c
2026-06-12 01:07:59,343 DEBUG paramiko.transport: starting thread (client mode): 0xad1620d0
2026-06-12 01:07:59,343 DEBUG paramiko.transport: Local version/idstring: SSH-2.0-paramiko_4.0.0
2026-06-12 01:07:59,343 DEBUG paramiko.transport: Remote version/idstring: SSH-2.0-GerritCodeReview_3.6.4 (APACHE-SSHD-2.9.2)
2026-06-12 01:07:59,344 INFO paramiko.transport: Connected (version 2.0, client GerritCodeReview_3.6.4)
2026-06-12 01:07:59,345 DEBUG paramiko.transport: === Key exchange possibilities ===
2026-06-12 01:07:59,345 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-12 01:07:59,345 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-12 01:07:59,345 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-12 01:07:59,345 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-12 01:07:59,345 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-12 01:07:59,345 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-12 01:07:59,345 DEBUG paramiko.transport: client compress: none
2026-06-12 01:07:59,345 DEBUG paramiko.transport: server compress: none
2026-06-12 01:07:59,345 DEBUG paramiko.transport: client lang: <none>
2026-06-12 01:07:59,345 DEBUG paramiko.transport: server lang: <none>
2026-06-12 01:07:59,345 DEBUG paramiko.transport: kex follows: False
2026-06-12 01:07:59,345 DEBUG paramiko.transport: === Key exchange agreements ===
2026-06-12 01:07:59,345 DEBUG paramiko.transport: Kex: curve25519-sha256@libssh.org
2026-06-12 01:07:59,345 DEBUG paramiko.transport: HostKey: ssh-ed25519
2026-06-12 01:07:59,345 DEBUG paramiko.transport: Cipher: aes128-ctr
2026-06-12 01:07:59,345 DEBUG paramiko.transport: MAC: hmac-sha2-256
2026-06-12 01:07:59,345 DEBUG paramiko.transport: Compression: none
2026-06-12 01:07:59,345 DEBUG paramiko.transport: === End of kex handshake ===
2026-06-12 01:07:59,387 DEBUG paramiko.transport: kex engine KexCurve25519 specified hash_algo <built-in function openssl_sha256>
2026-06-12 01:07:59,387 DEBUG paramiko.transport: Switch to new keys ...
2026-06-12 01:07:59,387 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-12 01:08:00,082 DEBUG paramiko.transport: Trying discovered key b'b276f7c237799664724ab35be46693e4' in /var/lib/zuul-ssh/..data/priv
2026-06-12 01:08:00,132 DEBUG paramiko.transport: userauth is OK
2026-06-12 01:08:00,133 DEBUG paramiko.transport: Finalizing pubkey algorithm for key of type 'ssh-rsa'
2026-06-12 01:08:00,133 DEBUG paramiko.transport: Our pubkey algorithm list: ['rsa-sha2-512', 'rsa-sha2-256', 'ssh-rsa']
2026-06-12 01:08:00,133 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-12 01:08:00,133 DEBUG paramiko.transport: Agreed upon 'rsa-sha2-512' pubkey algorithm
2026-06-12 01:08:00,142 INFO paramiko.transport: Authentication (publickey) successful!
2026-06-12 01:08:00,143 DEBUG zuul.Repo: Cloning from ssh://zuul@gerrit-sshd.sf:29418/config to /var/lib/zuul/git/gerrit-sshd.sf/config/config
2026-06-12 01:08:00,243 DEBUG paramiko.transport: EOF in transport thread
2026-06-12 01:08:00,393 INFO zuul.Merger: Updating local repository gerrit/config
2026-06-12 01:08:00,395 DEBUG zuul.Repo: Updating repository /var/lib/zuul/git/gerrit-sshd.sf/config/config
2026-06-12 01:08:00,630 DEBUG zuul.Merger: [e: 1889e1e5b32e40d79c8952fb077d8e2c] Merging for change 7,1
2026-06-12 01:08:00,630 DEBUG zuul.Merger: [e: 1889e1e5b32e40d79c8952fb077d8e2c] Processing ref refs/changes/07/7/1 for project gerrit/config / master uuid c72461ec1bf34420be316bf3ffe16c65
2026-06-12 01:08:00,630 DEBUG zuul.Merger: [e: 1889e1e5b32e40d79c8952fb077d8e2c] No base commit found for ('gerrit', 'config', 'master')
2026-06-12 01:08:00,630 DEBUG zuul.Repo: [e: 1889e1e5b32e40d79c8952fb077d8e2c] Resetting repository /var/lib/zuul/git/gerrit-sshd.sf/config/config
2026-06-12 01:08:00,663 DEBUG zuul.Repo: [e: 1889e1e5b32e40d79c8952fb077d8e2c] Checking out 10fc0dfa2fc1acd0736c9aa548c0d95dccbeaa98
2026-06-12 01:08:00,961 DEBUG zuul.Repo: [e: 1889e1e5b32e40d79c8952fb077d8e2c] Merging refs/changes/07/7/1 with args ['-s', 'resolve', 'FETCH_HEAD']
2026-06-12 01:08:00,981 DEBUG zuul.Repo.Ref: [e: 1889e1e5b32e40d79c8952fb077d8e2c] Create reference refs/zuul/4f26aeafdb2367620a393c973eddbe8f8b846ebd at 898ecd3f7cefca9c974809eec1befff211b5b86a in /var/lib/zuul/git/gerrit-sshd.sf/config/config
2026-06-12 01:08:00,994 DEBUG zuul.Repo: Getting files for /var/lib/zuul/git/gerrit-sshd.sf/config/config at 898ecd3f7cefca9c974809eec1befff211b5b86a
2026-06-12 01:08:00,999 DEBUG zuul.MergeServer: Completed merge job c8c84e52cad7467cb458bba1ff9d4e9c: payload size: 454
2026-06-12 01:08:00,999 INFO zuul.MergeServer: [e: 1889e1e5b32e40d79c8952fb077d8e2c] Merge <MergeRequest c8c84e52cad7467cb458bba1ff9d4e9c, job_type=merge, state=running, path=/zuul/merger/requests/c8c84e52cad7467cb458bba1ff9d4e9c> complete, merged: True, updated: False, commit: 898ecd3f7cefca9c974809eec1befff211b5b86a, branches: []
2026-06-12 01:08:00,999 DEBUG zuul.MergeServer: [e: 1889e1e5b32e40d79c8952fb077d8e2c] Providing asynchronous result via result event for <MergeRequest c8c84e52cad7467cb458bba1ff9d4e9c, job_type=merge, state=running, path=/zuul/merger/requests/c8c84e52cad7467cb458bba1ff9d4e9c>
2026-06-12 01:08:01,036 DEBUG zuul.JobRequestQueue: [e: 1889e1e5b32e40d79c8952fb077d8e2c] [build: c8c84e52cad7467cb458bba1ff9d4e9c] Updating request <MergeRequest c8c84e52cad7467cb458bba1ff9d4e9c, job_type=merge, state=completed, path=/zuul/merger/requests/c8c84e52cad7467cb458bba1ff9d4e9c>
2026-06-12 01:08:01,043 DEBUG zuul.MergerApi: [e: 1889e1e5b32e40d79c8952fb077d8e2c] Removing request <MergeRequest c8c84e52cad7467cb458bba1ff9d4e9c, job_type=merge, state=completed, path=/zuul/merger/requests/c8c84e52cad7467cb458bba1ff9d4e9c>
2026-06-12 01:09:10,633 DEBUG zuul.JobRequestQueue: [e: ee10453209974829b2dfc1ab07a92f74] [build: bc79f400c5394a7296745746d4c208fc] Updating request <MergeRequest bc79f400c5394a7296745746d4c208fc, job_type=merge, state=running, path=/zuul/merger/requests/bc79f400c5394a7296745746d4c208fc>
2026-06-12 01:09:10,636 DEBUG zuul.MergeServer: Next executed merge job: <MergeRequest bc79f400c5394a7296745746d4c208fc, job_type=merge, state=running, path=/zuul/merger/requests/bc79f400c5394a7296745746d4c208fc>
2026-06-12 01:09:10,636 DEBUG zuul.MergeServer: Got merge job: bc79f400c5394a7296745746d4c208fc
2026-06-12 01:09:10,636 INFO zuul.Merger: Updating local repository gerrit/config
2026-06-12 01:09:10,638 DEBUG zuul.Repo: Updating repository /var/lib/zuul/git/gerrit-sshd.sf/config/config
2026-06-12 01:09:10,866 DEBUG zuul.Merger: [e: ee10453209974829b2dfc1ab07a92f74] Merging for change 7,2
2026-06-12 01:09:10,866 DEBUG zuul.Merger: [e: ee10453209974829b2dfc1ab07a92f74] Processing ref refs/changes/07/7/2 for project gerrit/config / master uuid 747bd901efbf48a790450c079ffbcd9c
2026-06-12 01:09:10,866 DEBUG zuul.Merger: [e: ee10453209974829b2dfc1ab07a92f74] No base commit found for ('gerrit', 'config', 'master')
2026-06-12 01:09:10,866 DEBUG zuul.Repo: [e: ee10453209974829b2dfc1ab07a92f74] Resetting repository /var/lib/zuul/git/gerrit-sshd.sf/config/config
2026-06-12 01:09:10,891 DEBUG zuul.Repo: [e: ee10453209974829b2dfc1ab07a92f74] Checking out 10fc0dfa2fc1acd0736c9aa548c0d95dccbeaa98
2026-06-12 01:09:11,080 DEBUG zuul.Repo: [e: ee10453209974829b2dfc1ab07a92f74] Merging refs/changes/07/7/2 with args ['-s', 'resolve', 'FETCH_HEAD']
2026-06-12 01:09:11,102 DEBUG zuul.Repo.Ref: [e: ee10453209974829b2dfc1ab07a92f74] Create reference refs/zuul/4f26aeafdb2367620a393c973eddbe8f8b846ebd at 81c6465de59b8289936d520ecd2d84a72719e7c6 in /var/lib/zuul/git/gerrit-sshd.sf/config/config
2026-06-12 01:09:11,115 DEBUG zuul.Repo: Getting files for /var/lib/zuul/git/gerrit-sshd.sf/config/config at 81c6465de59b8289936d520ecd2d84a72719e7c6
2026-06-12 01:09:11,120 DEBUG zuul.MergeServer: Completed merge job bc79f400c5394a7296745746d4c208fc: payload size: 456
2026-06-12 01:09:11,120 INFO zuul.MergeServer: [e: ee10453209974829b2dfc1ab07a92f74] Merge <MergeRequest bc79f400c5394a7296745746d4c208fc, job_type=merge, state=running, path=/zuul/merger/requests/bc79f400c5394a7296745746d4c208fc> complete, merged: True, updated: False, commit: 81c6465de59b8289936d520ecd2d84a72719e7c6, branches: []
2026-06-12 01:09:11,121 DEBUG zuul.MergeServer: [e: ee10453209974829b2dfc1ab07a92f74] Providing asynchronous result via result event for <MergeRequest bc79f400c5394a7296745746d4c208fc, job_type=merge, state=running, path=/zuul/merger/requests/bc79f400c5394a7296745746d4c208fc>
2026-06-12 01:09:11,247 DEBUG zuul.JobRequestQueue: [e: ee10453209974829b2dfc1ab07a92f74] [build: bc79f400c5394a7296745746d4c208fc] Updating request <MergeRequest bc79f400c5394a7296745746d4c208fc, job_type=merge, state=completed, path=/zuul/merger/requests/bc79f400c5394a7296745746d4c208fc>
2026-06-12 01:09:11,253 DEBUG zuul.MergerApi: [e: ee10453209974829b2dfc1ab07a92f74] Removing request <MergeRequest bc79f400c5394a7296745746d4c208fc, job_type=merge, state=completed, path=/zuul/merger/requests/bc79f400c5394a7296745746d4c208fc>
2026-06-12 01:09:12,159 DEBUG zuul.JobRequestQueue: [e: 9b5c899eeb2d4645a2cfccd7ab48408d] [build: 210b76a2ccb1424bb88e3f50c27cc5a3] Updating request <MergeRequest 210b76a2ccb1424bb88e3f50c27cc5a3, job_type=merge, state=running, path=/zuul/merger/requests/210b76a2ccb1424bb88e3f50c27cc5a3>
2026-06-12 01:09:12,161 DEBUG zuul.MergeServer: Next executed merge job: <MergeRequest 210b76a2ccb1424bb88e3f50c27cc5a3, job_type=merge, state=running, path=/zuul/merger/requests/210b76a2ccb1424bb88e3f50c27cc5a3>
2026-06-12 01:09:12,161 DEBUG zuul.MergeServer: Got merge job: 210b76a2ccb1424bb88e3f50c27cc5a3
2026-06-12 01:09:12,161 INFO zuul.Merger: Updating local repository gerrit/config
2026-06-12 01:09:12,164 DEBUG zuul.Repo: Updating repository /var/lib/zuul/git/gerrit-sshd.sf/config/config
2026-06-12 01:09:12,386 DEBUG zuul.Merger: [e: 9b5c899eeb2d4645a2cfccd7ab48408d] Merging for change 7,2
2026-06-12 01:09:12,386 DEBUG zuul.Merger: [e: 9b5c899eeb2d4645a2cfccd7ab48408d] Processing ref refs/changes/07/7/2 for project gerrit/config / master uuid 74f85e97e87042a182a5dfd025e56be6
2026-06-12 01:09:12,386 DEBUG zuul.Merger: [e: 9b5c899eeb2d4645a2cfccd7ab48408d] No base commit found for ('gerrit', 'config', 'master')
2026-06-12 01:09:12,386 DEBUG zuul.Repo: [e: 9b5c899eeb2d4645a2cfccd7ab48408d] Resetting repository /var/lib/zuul/git/gerrit-sshd.sf/config/config
2026-06-12 01:09:12,414 DEBUG zuul.Repo: [e: 9b5c899eeb2d4645a2cfccd7ab48408d] Checking out 10fc0dfa2fc1acd0736c9aa548c0d95dccbeaa98
2026-06-12 01:09:12,704 DEBUG zuul.Repo: [e: 9b5c899eeb2d4645a2cfccd7ab48408d] Merging refs/changes/07/7/2 with args ['-s', 'resolve', 'FETCH_HEAD']
2026-06-12 01:09:12,724 DEBUG zuul.Repo.Ref: [e: 9b5c899eeb2d4645a2cfccd7ab48408d] Create reference refs/zuul/4f26aeafdb2367620a393c973eddbe8f8b846ebd at 81c6465de59b8289936d520ecd2d84a72719e7c6 in /var/lib/zuul/git/gerrit-sshd.sf/config/config
2026-06-12 01:09:12,736 DEBUG zuul.Repo: Getting files for /var/lib/zuul/git/gerrit-sshd.sf/config/config at 81c6465de59b8289936d520ecd2d84a72719e7c6
2026-06-12 01:09:12,741 DEBUG zuul.MergeServer: Completed merge job 210b76a2ccb1424bb88e3f50c27cc5a3: payload size: 454
2026-06-12 01:09:12,741 INFO zuul.MergeServer: [e: 9b5c899eeb2d4645a2cfccd7ab48408d] Merge <MergeRequest 210b76a2ccb1424bb88e3f50c27cc5a3, job_type=merge, state=running, path=/zuul/merger/requests/210b76a2ccb1424bb88e3f50c27cc5a3> complete, merged: True, updated: False, commit: 81c6465de59b8289936d520ecd2d84a72719e7c6, branches: []
2026-06-12 01:09:12,741 DEBUG zuul.MergeServer: [e: 9b5c899eeb2d4645a2cfccd7ab48408d] Providing asynchronous result via result event for <MergeRequest 210b76a2ccb1424bb88e3f50c27cc5a3, job_type=merge, state=running, path=/zuul/merger/requests/210b76a2ccb1424bb88e3f50c27cc5a3>
2026-06-12 01:09:12,747 DEBUG zuul.JobRequestQueue: [e: 9b5c899eeb2d4645a2cfccd7ab48408d] [build: 210b76a2ccb1424bb88e3f50c27cc5a3] Updating request <MergeRequest 210b76a2ccb1424bb88e3f50c27cc5a3, job_type=merge, state=completed, path=/zuul/merger/requests/210b76a2ccb1424bb88e3f50c27cc5a3>
2026-06-12 01:09:12,753 DEBUG zuul.MergerApi: [e: 9b5c899eeb2d4645a2cfccd7ab48408d] Removing request <MergeRequest 210b76a2ccb1424bb88e3f50c27cc5a3, job_type=merge, state=completed, path=/zuul/merger/requests/210b76a2ccb1424bb88e3f50c27cc5a3>
2026-06-12 01:10:14,465 DEBUG zuul.JobRequestQueue: [e: 1bd5526ed6044c10b9a22b04075b87cd] [build: 847e3f9251c6424bb6f4afa7c71cae2c] Updating request <MergeRequest 847e3f9251c6424bb6f4afa7c71cae2c, job_type=refstate, state=running, path=/zuul/merger/requests/847e3f9251c6424bb6f4afa7c71cae2c>
2026-06-12 01:10:14,467 DEBUG zuul.MergeServer: Next executed merge job: <MergeRequest 847e3f9251c6424bb6f4afa7c71cae2c, job_type=refstate, state=running, path=/zuul/merger/requests/847e3f9251c6424bb6f4afa7c71cae2c>
2026-06-12 01:10:14,467 DEBUG zuul.MergeServer: Got refstate job: 847e3f9251c6424bb6f4afa7c71cae2c
2026-06-12 01:10:14,469 DEBUG zuul.Repo: Updating repository /var/lib/zuul/git/gerrit-sshd.sf/config/config
2026-06-12 01:10:14,742 DEBUG zuul.Repo: Resetting repository /var/lib/zuul/git/gerrit-sshd.sf/config/config
2026-06-12 01:10:14,764 DEBUG zuul.Repo: Updating repository /var/lib/zuul/git/opendev.org/zuul/zuul%2Fzuul-jobs
2026-06-12 01:10:15,395 DEBUG zuul.Repo: Resetting repository /var/lib/zuul/git/opendev.org/zuul/zuul%2Fzuul-jobs
2026-06-12 01:10:15,417 DEBUG zuul.Repo: Updating repository /var/lib/zuul/git/git-server/system-config/system-config
2026-06-12 01:10:15,485 DEBUG zuul.Repo: Resetting repository /var/lib/zuul/git/git-server/system-config/system-config
2026-06-12 01:10:15,507 DEBUG zuul.MergeServer: Completed refstate job 847e3f9251c6424bb6f4afa7c71cae2c: payload size: 486
2026-06-12 01:10:15,507 INFO zuul.MergeServer: [e: 1bd5526ed6044c10b9a22b04075b87cd] Merge <MergeRequest 847e3f9251c6424bb6f4afa7c71cae2c, job_type=refstate, state=running, path=/zuul/merger/requests/847e3f9251c6424bb6f4afa7c71cae2c> complete, merged: False, updated: True, commit: None, branches: []
2026-06-12 01:10:15,507 DEBUG zuul.MergeServer: [e: 1bd5526ed6044c10b9a22b04075b87cd] Providing asynchronous result via result event for <MergeRequest 847e3f9251c6424bb6f4afa7c71cae2c, job_type=refstate, state=running, path=/zuul/merger/requests/847e3f9251c6424bb6f4afa7c71cae2c>
2026-06-12 01:10:15,522 DEBUG zuul.JobRequestQueue: [e: 1bd5526ed6044c10b9a22b04075b87cd] [build: 847e3f9251c6424bb6f4afa7c71cae2c] Updating request <MergeRequest 847e3f9251c6424bb6f4afa7c71cae2c, job_type=refstate, state=completed, path=/zuul/merger/requests/847e3f9251c6424bb6f4afa7c71cae2c>
2026-06-12 01:10:15,528 DEBUG zuul.MergerApi: [e: 1bd5526ed6044c10b9a22b04075b87cd] Removing request <MergeRequest 847e3f9251c6424bb6f4afa7c71cae2c, job_type=refstate, state=completed, path=/zuul/merger/requests/847e3f9251c6424bb6f4afa7c71cae2c>
2026-06-12 01:12:15,035 DEBUG zuul.JobRequestQueue: [e: 45d3774267014c9e88b7de902dc522a2] [build: e5470e500cd8485495e8867ba342277a] Updating request <MergeRequest e5470e500cd8485495e8867ba342277a, job_type=refstate, state=running, path=/zuul/merger/requests/e5470e500cd8485495e8867ba342277a>
2026-06-12 01:12:15,038 DEBUG zuul.MergeServer: Next executed merge job: <MergeRequest e5470e500cd8485495e8867ba342277a, job_type=refstate, state=running, path=/zuul/merger/requests/e5470e500cd8485495e8867ba342277a>
2026-06-12 01:12:15,038 DEBUG zuul.MergeServer: Got refstate job: e5470e500cd8485495e8867ba342277a
2026-06-12 01:12:15,039 DEBUG zuul.Repo: Updating repository /var/lib/zuul/git/opendev.org/zuul/zuul%2Fzuul-jobs
2026-06-12 01:12:15,529 DEBUG zuul.Repo: Resetting repository /var/lib/zuul/git/opendev.org/zuul/zuul%2Fzuul-jobs
2026-06-12 01:12:15,555 DEBUG paramiko.transport: starting thread (client mode): 0xad15e010
2026-06-12 01:12:15,555 DEBUG paramiko.transport: Local version/idstring: SSH-2.0-paramiko_4.0.0
2026-06-12 01:12:15,555 DEBUG paramiko.transport: Remote version/idstring: SSH-2.0-GerritCodeReview_3.6.4 (APACHE-SSHD-2.9.2)
2026-06-12 01:12:15,556 INFO paramiko.transport: Connected (version 2.0, client GerritCodeReview_3.6.4)
2026-06-12 01:12:15,558 DEBUG paramiko.transport: === Key exchange possibilities ===
2026-06-12 01:12:15,558 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-12 01:12:15,558 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-12 01:12:15,558 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-12 01:12:15,558 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-12 01:12:15,558 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-12 01:12:15,558 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-12 01:12:15,558 DEBUG paramiko.transport: client compress: none
2026-06-12 01:12:15,558 DEBUG paramiko.transport: server compress: none
2026-06-12 01:12:15,558 DEBUG paramiko.transport: client lang: <none>
2026-06-12 01:12:15,559 DEBUG paramiko.transport: server lang: <none>
2026-06-12 01:12:15,559 DEBUG paramiko.transport: kex follows: False
2026-06-12 01:12:15,559 DEBUG paramiko.transport: === Key exchange agreements ===
2026-06-12 01:12:15,559 DEBUG paramiko.transport: Kex: curve25519-sha256@libssh.org
2026-06-12 01:12:15,559 DEBUG paramiko.transport: HostKey: ssh-ed25519
2026-06-12 01:12:15,559 DEBUG paramiko.transport: Cipher: aes128-ctr
2026-06-12 01:12:15,559 DEBUG paramiko.transport: MAC: hmac-sha2-256
2026-06-12 01:12:15,559 DEBUG paramiko.transport: Compression: none
2026-06-12 01:12:15,559 DEBUG paramiko.transport: === End of kex handshake ===
2026-06-12 01:12:15,561 DEBUG paramiko.transport: kex engine KexCurve25519 specified hash_algo <built-in function openssl_sha256>
2026-06-12 01:12:15,562 DEBUG paramiko.transport: Switch to new keys ...
2026-06-12 01:12:15,562 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-12 01:12:16,566 DEBUG paramiko.transport: Trying discovered key b'b276f7c237799664724ab35be46693e4' in /var/lib/zuul-ssh/..data/priv
2026-06-12 01:12:16,568 DEBUG paramiko.transport: userauth is OK
2026-06-12 01:12:16,568 DEBUG paramiko.transport: Finalizing pubkey algorithm for key of type 'ssh-rsa'
2026-06-12 01:12:16,568 DEBUG paramiko.transport: Our pubkey algorithm list: ['rsa-sha2-512', 'rsa-sha2-256', 'ssh-rsa']
2026-06-12 01:12:16,568 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-12 01:12:16,568 DEBUG paramiko.transport: Agreed upon 'rsa-sha2-512' pubkey algorithm
2026-06-12 01:12:16,585 INFO paramiko.transport: Authentication (publickey) successful!
2026-06-12 01:12:16,585 DEBUG zuul.Repo: Cloning from ssh://zuul@gerrit-sshd.sf:29418/demo-tenant-config to /var/lib/zuul/git/gerrit-sshd.sf/demo-tenant-config/demo-tenant-config
2026-06-12 01:12:16,686 DEBUG paramiko.transport: EOF in transport thread
2026-06-12 01:12:16,888 DEBUG zuul.Repo: Updating repository /var/lib/zuul/git/gerrit-sshd.sf/demo-tenant-config/demo-tenant-config
2026-06-12 01:12:17,137 DEBUG zuul.Repo: Resetting repository /var/lib/zuul/git/gerrit-sshd.sf/demo-tenant-config/demo-tenant-config
2026-06-12 01:12:17,169 DEBUG zuul.MergeServer: Completed refstate job e5470e500cd8485495e8867ba342277a: payload size: 398
2026-06-12 01:12:17,169 INFO zuul.MergeServer: [e: 45d3774267014c9e88b7de902dc522a2] Merge <MergeRequest e5470e500cd8485495e8867ba342277a, job_type=refstate, state=running, path=/zuul/merger/requests/e5470e500cd8485495e8867ba342277a> complete, merged: False, updated: True, commit: None, branches: []
2026-06-12 01:12:17,169 DEBUG zuul.MergeServer: [e: 45d3774267014c9e88b7de902dc522a2] Providing asynchronous result via result event for <MergeRequest e5470e500cd8485495e8867ba342277a, job_type=refstate, state=running, path=/zuul/merger/requests/e5470e500cd8485495e8867ba342277a>
2026-06-12 01:12:17,179 DEBUG zuul.JobRequestQueue: [e: 45d3774267014c9e88b7de902dc522a2] [build: e5470e500cd8485495e8867ba342277a] Updating request <MergeRequest e5470e500cd8485495e8867ba342277a, job_type=refstate, state=completed, path=/zuul/merger/requests/e5470e500cd8485495e8867ba342277a>
2026-06-12 01:12:17,184 DEBUG zuul.MergerApi: [e: 45d3774267014c9e88b7de902dc522a2] Removing request <MergeRequest e5470e500cd8485495e8867ba342277a, job_type=refstate, state=completed, path=/zuul/merger/requests/e5470e500cd8485495e8867ba342277a>