2026-06-07 00:25:20,923 DEBUG zuul.Scheduler: Configured logging: 14.1.1.dev1 2026-06-07 00:25:20,924 DEBUG zuul.TimerDriver: Starting apscheduler 2026-06-07 00:25:20,924 INFO apscheduler.scheduler: Scheduler started 2026-06-07 00:25:20,924 DEBUG apscheduler.scheduler: Looking for jobs to run 2026-06-07 00:25:20,925 DEBUG apscheduler.scheduler: No jobs; waiting until a job is added 2026-06-07 00:25:20,925 DEBUG zuul.BubblewrapDriver: Initializing bubblewrap with oom_score_adj starting: 995, final: 1000 2026-06-07 00:25:20,928 INFO zuul.SQLConnection: Initializing SQL connection database (prefix: ) 2026-06-07 00:25:21,217 DEBUG zuul.zk.base.ZooKeeperClient: ZooKeeper connection (session: 0x10000147b6e0004): CONNECTED 2026-06-07 00:25:21,230 INFO zuul.Component: Registering component in ZooKeeper /zuul/components/scheduler/zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local 2026-06-07 00:25:21,287 INFO zuul.ComponentRegistry: Noticed new scheduler component zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-07 00:25:21,290 DEBUG zuul.ComponentRegistry: Registry got event None for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-07 00:25:21,290 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-07 00:25:21,290 INFO zuul.ComponentRegistry: Noticed new scheduler component zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000002 2026-06-07 00:25:21,293 DEBUG zuul.ComponentRegistry: Registry got event None for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000002 2026-06-07 00:25:21,293 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-07 00:25:21,296 INFO zuul.ComponentRegistry: Noticed new executor component zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-07 00:25:21,298 DEBUG zuul.ComponentRegistry: Registry got event None for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-07 00:25:21,298 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-07 00:25:21,301 INFO zuul.ComponentRegistry: Noticed new merger component zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003 2026-06-07 00:25:21,303 DEBUG zuul.ComponentRegistry: Registry got event None for merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003 2026-06-07 00:25:21,303 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-07 00:25:21,311 INFO zuul.ComponentRegistry: Noticed new web component zuul-web-fbfc7d985-4bfw50000000005 2026-06-07 00:25:21,382 DEBUG zuul.ComponentRegistry: Registry got event None for web zuul-web-fbfc7d985-4bfw50000000005 2026-06-07 00:25:21,382 INFO zuul.ComponentRegistry: Component web zuul-web-fbfc7d985-4bfw50000000005 updated: {'hostname': 'zuul-web-fbfc7d985-4bfw5', 'kind': 'web', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-07 00:25:21,383 INFO zuul.ComponentRegistry: Noticed new web component zuul-web-678b594b9f-w6gxh0000000004 2026-06-07 00:25:21,385 DEBUG zuul.ComponentRegistry: Registry got event None for web zuul-web-678b594b9f-w6gxh0000000004 2026-06-07 00:25:21,385 INFO zuul.ComponentRegistry: Component web zuul-web-678b594b9f-w6gxh0000000004 updated: {'hostname': 'zuul-web-678b594b9f-w6gxh', 'kind': 'web', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-07 00:25:21,388 INFO zuul.ComponentRegistry: System minimum data model version 37; this component 37 2026-06-07 00:25:21,508 DEBUG zuul.zk.ZooKeeper: Initialize cache at /keystorage-oidc 2026-06-07 00:25:21,512 DEBUG zuul.zk.ZooKeeper: Cache at /keystorage-oidc is ready 2026-06-07 00:25:21,520 DEBUG zuul.ExecutorQueue: Creating executor queue at root /zuul/executor/unzoned 2026-06-07 00:25:21,528 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/executor/unzoned 2026-06-07 00:25:21,591 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/executor/unzoned is ready 2026-06-07 00:25:21,600 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/merger 2026-06-07 00:25:21,682 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/merger is ready 2026-06-07 00:25:21,689 DEBUG zuul.nodepool: Running nodepool watcher election 2026-06-07 00:25:21,690 DEBUG zuul.TimerDriver: Starting timer election loop 2026-06-07 00:25:21,698 INFO zuul.nodepool: Watching nodepool requests 2026-06-07 00:25:21,699 DEBUG zuul.TimerDriver: Waiting for scheduler to be primed 2026-06-07 00:25:21,721 DEBUG zuul.SQLConnection: Current migration revision: 21d30f0bffef 2026-06-07 00:25:21,749 DEBUG zuul.GerritConnection: Starting Gerrit Connection/Watchers 2026-06-07 00:25:21,749 DEBUG zuul.GerritConnection: Creating Zookeeper branch cache 2026-06-07 00:25:21,791 INFO zuul.GerritConnection: Creating Zookeeper event queue 2026-06-07 00:25:21,795 DEBUG zuul.GerritConnection: Creating Zookeeper change cache 2026-06-07 00:25:21,800 INFO zuul.GerritConnection: Starting SSH event stream client 2026-06-07 00:25:21,801 INFO zuul.GerritConnection: gerrit: Gerrit Poller is disabled because no HTTP authentication is defined 2026-06-07 00:25:21,802 DEBUG zuul.connection.git: Creating Zookeeper change cache 2026-06-07 00:25:21,810 DEBUG zuul.connection.git: Starting Git Watcher 2026-06-07 00:25:21,811 DEBUG zuul.connection.git: Creating Zookeeper change cache 2026-06-07 00:25:21,889 DEBUG zuul.connection.git: Starting Git Watcher 2026-06-07 00:25:21,890 INFO zuul.Scheduler: Starting scheduler 2026-06-07 00:25:21,891 DEBUG zuul.Scheduler: Statsd enabled 2026-06-07 00:25:21,891 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-07 00:25:21,891 DEBUG zuul.Scheduler: Run handler awake 2026-06-07 00:25:21,891 DEBUG zuul.Scheduler: Starting command processor 2026-06-07 00:25:21,893 DEBUG zuul.Scheduler: Running stats election 2026-06-07 00:25:21,894 INFO apscheduler.scheduler: Scheduler started 2026-06-07 00:25:21,895 DEBUG apscheduler.scheduler: Looking for jobs to run 2026-06-07 00:25:21,895 DEBUG apscheduler.scheduler: No jobs; waiting until a job is added 2026-06-07 00:25:21,901 INFO zuul.Scheduler: Priming scheduler config 2026-06-07 00:25:21,904 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-07 00:25:21,904 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-07 00:25:21,905 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is None 2026-06-07 00:25:21,982 DEBUG zuul.Scheduler: Won stats election 2026-06-07 00:25:21,994 INFO zuul.Scheduler: Using system config from Zookeeper 2026-06-07 00:25:21,999 DEBUG zuul.Scheduler: Updating system config 2026-06-07 00:25:22,829 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-07 00:25:22,890 DEBUG zuul.Scheduler: Wait for demo-tenant read tenant lock 2026-06-07 00:25:22,895 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock 2026-06-07 00:25:23,297 INFO zuul.BranchCache.gerrit: Waiting for branch cache upgrade lock 2026-06-07 00:25:23,487 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/cache/connection/gerrit/project 2026-06-07 00:25:23,505 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/cache/connection/gerrit/project is ready 2026-06-07 00:25:23,505 INFO zuul.BranchCache.gerrit: Cache already upgraded 2026-06-07 00:25:24,165 DEBUG zuul.TenantParser: Using files from cache for project gerrit-sshd.sf/demo-tenant-config @master: ['zuul.d/gerrit-base-jobs.yaml', 'zuul.d/gerrit-pipeline.yaml', 'zuul.d/gerrit-project-pipeline.yaml'] 2026-06-07 00:25:24,166 DEBUG zuul.TenantParser: Using files from cache for project opendev.org/zuul/zuul-jobs @master: ['zuul.d/container-jobs.yaml', 'zuul.d/dib-jobs.yaml', 'zuul.d/docker-jobs.yaml', 'zuul.d/general-jobs.yaml', 'zuul.d/go-jobs.yaml', 'zuul.d/haskell-jobs.yaml', 'zuul.d/helm-jobs.yaml', 'zuul.d/js-jobs.yaml', 'zuul.d/nim-jobs.yaml', 'zuul.d/packer-jobs.yaml', 'zuul.d/python-jobs.yaml', 'zuul.d/system-jobs.yaml', 'zuul.d/terraform-jobs.yaml'] 2026-06-07 00:25:24,168 DEBUG zuul.TenantParser: Using files from cache for project gerrit-sshd.sf/demo-project @master: ['.zuul.d/jobs.yaml', '.zuul.d/project.yaml'] 2026-06-07 00:25:24,188 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-base-jobs.yaml@master 2026-06-07 00:25:24,191 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/container-jobs.yaml@master 2026-06-07 00:25:24,205 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-pipeline.yaml@master 2026-06-07 00:25:24,211 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/dib-jobs.yaml@master 2026-06-07 00:25:24,213 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/jobs.yaml@master 2026-06-07 00:25:24,220 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-project-pipeline.yaml@master 2026-06-07 00:25:24,223 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/docker-jobs.yaml@master 2026-06-07 00:25:24,283 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/project.yaml@master 2026-06-07 00:25:24,288 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/general-jobs.yaml@master 2026-06-07 00:25:24,297 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/go-jobs.yaml@master 2026-06-07 00:25:24,302 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/haskell-jobs.yaml@master 2026-06-07 00:25:24,308 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/helm-jobs.yaml@master 2026-06-07 00:25:24,313 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/js-jobs.yaml@master 2026-06-07 00:25:24,320 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/nim-jobs.yaml@master 2026-06-07 00:25:24,326 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/packer-jobs.yaml@master 2026-06-07 00:25:24,331 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/python-jobs.yaml@master 2026-06-07 00:25:24,380 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/system-jobs.yaml@master 2026-06-07 00:25:24,386 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/terraform-jobs.yaml@master 2026-06-07 00:25:24,396 DEBUG zuul.TenantParser: Created layout id 0067fbd3e1b8435e8487579b0be7fd93 2026-06-07 00:25:24,403 DEBUG zuul.Pipeline.demo-tenant.check: Building relative_priority queues 2026-06-07 00:25:24,413 DEBUG zuul.Pipeline.demo-tenant.gate: Building shared change queues 2026-06-07 00:25:24,413 DEBUG zuul.Pipeline.demo-tenant.gate: Created queue: 2026-06-07 00:25:24,414 DEBUG zuul.Pipeline.demo-tenant.gate: Added project demo-tenant-config to default queue manager: 2026-06-07 00:25:24,414 DEBUG zuul.Pipeline.demo-tenant.gate: Created queue: 2026-06-07 00:25:24,414 DEBUG zuul.Pipeline.demo-tenant.gate: Added project demo-project to default queue manager: 2026-06-07 00:25:24,425 DEBUG zuul.Pipeline.demo-tenant.post: Building relative_priority queues 2026-06-07 00:25:24,434 DEBUG zuul.GerritConnection: Setting watched checkers to [] 2026-06-07 00:25:24,434 DEBUG zuul.GerritConnection: Setting watched event filters for demo-tenant to [, , , , , ] 2026-06-07 00:25:24,435 DEBUG zuul.GerritConnection: Setting watched event filters to {, , , , , } 2026-06-07 00:25:24,435 DEBUG zuul.TimerDriver: No jobs to remove for , 0 remain 2026-06-07 00:25:24,435 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock 2026-06-07 00:25:24,439 DEBUG zuul.Scheduler: Wait for internal read tenant lock 2026-06-07 00:25:24,445 DEBUG zuul.Scheduler: Aquired internal read tenant lock 2026-06-07 00:25:25,295 DEBUG zuul.ComponentRegistry: Registry got event DELETED for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000002 2026-06-07 00:25:25,295 INFO zuul.ComponentRegistry: Noticed scheduler component zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000002 disappeared 2026-06-07 00:25:25,295 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is None 2026-06-07 00:25:25,300 DEBUG zuul.connection.git.watcher: Walk through projects refs for connection: git-server 2026-06-07 00:25:25,302 DEBUG zuul.ComponentRegistry: Registry got event DELETED for web zuul-web-678b594b9f-w6gxh0000000004 2026-06-07 00:25:25,302 INFO zuul.ComponentRegistry: Noticed web component zuul-web-678b594b9f-w6gxh0000000004 disappeared 2026-06-07 00:25:25,302 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is None 2026-06-07 00:25:25,303 DEBUG zuul.connection.git.watcher: Walk through projects refs for connection: opendev.org 2026-06-07 00:25:25,306 DEBUG paramiko.transport: starting thread (client mode): 0x500daf50 2026-06-07 00:25:25,306 DEBUG paramiko.transport: Local version/idstring: SSH-2.0-paramiko_4.0.0 2026-06-07 00:25:25,306 DEBUG paramiko.transport: Remote version/idstring: SSH-2.0-GerritCodeReview_3.6.4 (APACHE-SSHD-2.9.2) 2026-06-07 00:25:25,306 INFO paramiko.transport: Connected (version 2.0, client GerritCodeReview_3.6.4) 2026-06-07 00:25:25,309 DEBUG paramiko.transport: === Key exchange possibilities === 2026-06-07 00:25:25,309 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-07 00:25:25,309 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-07 00:25:25,309 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-07 00:25:25,309 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-07 00:25:25,309 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-07 00:25:25,309 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-07 00:25:25,309 DEBUG paramiko.transport: client compress: none 2026-06-07 00:25:25,309 DEBUG paramiko.transport: server compress: none 2026-06-07 00:25:25,309 DEBUG paramiko.transport: client lang: 2026-06-07 00:25:25,309 DEBUG paramiko.transport: server lang: 2026-06-07 00:25:25,309 DEBUG paramiko.transport: kex follows: False 2026-06-07 00:25:25,309 DEBUG paramiko.transport: === Key exchange agreements === 2026-06-07 00:25:25,309 DEBUG paramiko.transport: Kex: curve25519-sha256@libssh.org 2026-06-07 00:25:25,309 DEBUG paramiko.transport: HostKey: ssh-ed25519 2026-06-07 00:25:25,309 DEBUG paramiko.transport: Cipher: aes128-ctr 2026-06-07 00:25:25,309 DEBUG paramiko.transport: MAC: hmac-sha2-256 2026-06-07 00:25:25,309 DEBUG paramiko.transport: Compression: none 2026-06-07 00:25:25,309 DEBUG paramiko.transport: === End of kex handshake === 2026-06-07 00:25:25,312 DEBUG paramiko.transport: kex engine KexCurve25519 specified hash_algo 2026-06-07 00:25:25,313 DEBUG paramiko.transport: Switch to new keys ... /usr/local/lib/python3.11/site-packages/paramiko/client.py:885: UserWarning: Unknown ssh-ed25519 host key for [gerrit-sshd.sf]:29418: b'1277f339273769f9c1a053e7e90c6a6a' warnings.warn( 2026-06-07 00:25:26,511 DEBUG zuul.connection.git.watcher: Read 1 refs for project system-config 2026-06-07 00:25:26,512 DEBUG zuul.connection.git.watcher: Read 1 refs for project zuul/zuul-jobs 2026-06-07 00:25:26,512 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-07 00:25:26,513 DEBUG paramiko.transport: Trying discovered key b'3e3aea35c3a9ebb5d60c59a105e0fadd' in /var/lib/zuul-ssh/..data/priv 2026-06-07 00:25:26,515 DEBUG paramiko.transport: userauth is OK 2026-06-07 00:25:26,515 DEBUG paramiko.transport: Finalizing pubkey algorithm for key of type 'ssh-rsa' 2026-06-07 00:25:26,515 DEBUG paramiko.transport: Our pubkey algorithm list: ['rsa-sha2-512', 'rsa-sha2-256', 'ssh-rsa'] 2026-06-07 00:25:26,515 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-07 00:25:26,516 DEBUG paramiko.transport: Agreed upon 'rsa-sha2-512' pubkey algorithm 2026-06-07 00:25:26,537 INFO paramiko.transport: Authentication (publickey) successful! 2026-06-07 00:25:26,538 DEBUG paramiko.transport: [chan 0] Max packet in: 32768 bytes 2026-06-07 00:25:26,539 DEBUG paramiko.transport: [chan 0] Max packet out: 32768 bytes 2026-06-07 00:25:26,539 DEBUG paramiko.transport: Secsh channel 0 opened. 2026-06-07 00:25:26,581 DEBUG paramiko.transport: [chan 0] Sesch channel 0 request ok 2026-06-07 00:25:26,592 DEBUG zuul.TenantParser: Using files from cache for project git-server/system-config @master: ['zuul.d/config-project.yaml', 'zuul.d/jobs-base.yaml', 'zuul.d/k8s-secret.yaml', 'zuul.d/sf-logserver-secret.yaml'] 2026-06-07 00:25:26,592 DEBUG zuul.TenantParser: Using files from cache for project gerrit-sshd.sf/config @master: [] 2026-06-07 00:25:26,606 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/config-project.yaml@master 2026-06-07 00:25:26,620 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/jobs-base.yaml@master 2026-06-07 00:25:26,625 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/k8s-secret.yaml@master 2026-06-07 00:25:26,636 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/sf-logserver-secret.yaml@master 2026-06-07 00:25:26,646 DEBUG zuul.TenantParser: Created layout id 613521a9fcec42a3b24d41b8dbc45ba7 2026-06-07 00:25:26,825 DEBUG zuul.Pipeline.internal.check: Building relative_priority queues 2026-06-07 00:25:26,836 DEBUG zuul.Pipeline.internal.gate: Building shared change queues 2026-06-07 00:25:26,836 DEBUG zuul.Pipeline.internal.gate: Created queue: 2026-06-07 00:25:26,836 DEBUG zuul.Pipeline.internal.gate: Added project config to default queue manager: 2026-06-07 00:25:26,887 DEBUG zuul.Pipeline.internal.post: Building relative_priority queues 2026-06-07 00:25:26,896 DEBUG zuul.GerritConnection: Setting watched checkers to [] 2026-06-07 00:25:26,896 DEBUG zuul.GerritConnection: Setting watched event filters for internal to [, , , , , ] 2026-06-07 00:25:26,897 DEBUG zuul.GerritConnection: Setting watched event filters to {, , , , , } 2026-06-07 00:25:26,897 DEBUG zuul.TimerDriver: No jobs to remove for , 0 remain 2026-06-07 00:25:26,897 DEBUG zuul.Scheduler: Released internal read tenant lock 2026-06-07 00:25:26,900 INFO zuul.Scheduler: Config priming complete (duration: 4.999 seconds) 2026-06-07 00:25:26,901 INFO zuul.TimerDriver: Running timer election 2026-06-07 00:25:26,901 DEBUG zuul.Scheduler: Run handler awake 2026-06-07 00:25:26,905 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is None 2026-06-07 00:25:26,905 DEBUG zuul.RendezvousElection: Did not win election for /zuul/events/connection/gerrit/election 2026-06-07 00:25:26,906 DEBUG zuul.RendezvousElection: Did not win election for /zuul/events/connection/gerrit/election 2026-06-07 00:25:26,910 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-07 00:25:26,910 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-07 00:25:26,910 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-07 00:25:26,911 DEBUG zuul.RendezvousElection: Acquiring lock for /zuul/events/connection/gerrit/election 2026-06-07 00:25:26,912 INFO zuul.TimerDriver: Won timer election 2026-06-07 00:25:26,919 INFO zuul.RendezvousElection: Won election for /zuul/events/connection/gerrit/election 2026-06-07 00:25:26,930 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-07 00:25:26,932 DEBUG zuul.Scheduler: Processing tenant management events in demo-tenant 2026-06-07 00:25:26,933 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-07 00:25:26,935 DEBUG zuul.Scheduler: Starting semaphore cleanup 2026-06-07 00:25:26,996 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock 2026-06-07 00:25:26,998 DEBUG zuul.Scheduler: Starting build request cleanup 2026-06-07 00:25:26,998 DEBUG zuul.Scheduler: Finished build request cleanup 2026-06-07 00:25:26,999 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-07 00:25:27,002 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-07 00:25:27,008 DEBUG zuul.Scheduler: Starting node request cleanup 2026-06-07 00:25:27,085 DEBUG zuul.Scheduler: Processing tenant trigger events in demo-tenant 2026-06-07 00:25:27,193 DEBUG zuul.Scheduler: Processing pipeline check in tenant demo-tenant 2026-06-07 00:25:27,211 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant demo-tenant 2026-06-07 00:25:27,289 DEBUG zuul.Scheduler: Processing pipeline gate in tenant demo-tenant 2026-06-07 00:25:27,309 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant demo-tenant 2026-06-07 00:25:27,319 DEBUG zuul.Scheduler: Processing pipeline post in tenant demo-tenant 2026-06-07 00:25:27,329 INFO apscheduler.scheduler: Added job "Scheduler._runSemaphoreCleanup" to job store "default" 2026-06-07 00:25:27,330 INFO apscheduler.scheduler: Added job "Scheduler._runBuildRequestCleanup" to job store "default" 2026-06-07 00:25:27,330 INFO apscheduler.scheduler: Added job "Scheduler._runMergeRequestCleanup" to job store "default" 2026-06-07 00:25:27,331 INFO apscheduler.scheduler: Added job "Scheduler._runConnectionCleanup" to job store "default" 2026-06-07 00:25:27,331 INFO apscheduler.scheduler: Added job "Scheduler._runGeneralCleanup" to job store "default" 2026-06-07 00:25:27,331 DEBUG apscheduler.scheduler: Looking for jobs to run 2026-06-07 00:25:27,331 DEBUG apscheduler.scheduler: Next wakeup is due at 2026-06-07 00:26:22.397865+00:00 (in 55.065939 seconds) 2026-06-07 00:25:27,336 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant demo-tenant 2026-06-07 00:25:27,339 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock 2026-06-07 00:25:27,348 DEBUG zuul.Scheduler: Processing tenant management events in internal 2026-06-07 00:25:27,361 DEBUG zuul.Scheduler: Aquired internal read tenant lock 2026-06-07 00:25:27,385 DEBUG zuul.Scheduler: Processing tenant trigger events in internal 2026-06-07 00:25:27,412 DEBUG zuul.Scheduler: Processing pipeline check in tenant internal 2026-06-07 00:25:27,424 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant internal 2026-06-07 00:25:27,433 DEBUG zuul.Scheduler: Processing pipeline gate in tenant internal 2026-06-07 00:25:27,489 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant internal 2026-06-07 00:25:27,501 DEBUG zuul.Scheduler: Processing pipeline post in tenant internal 2026-06-07 00:25:27,508 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant internal 2026-06-07 00:25:27,582 DEBUG zuul.Scheduler: Released internal read tenant lock 2026-06-07 00:25:27,586 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-07 00:26:20,581 DEBUG zuul.CommandSocket: Accepted socket connection 2026-06-07 00:26:20,581 DEBUG zuul.CommandSocket: Received b'tenant-reconfigure ["internal"]' from socket 2026-06-07 00:26:20,581 DEBUG zuul.Scheduler: Tenant reconfiguration triggered 2026-06-07 00:26:20,603 DEBUG zuul.Scheduler: Configured logging: 14.1.1.dev1 2026-06-07 00:26:20,603 DEBUG zuul.Scheduler: [e: e62ee2adfc4442cba8edf3135213cdb3] Submitting reconfiguration event 2026-06-07 00:26:20,609 DEBUG zuul.Scheduler: [e: e62ee2adfc4442cba8edf3135213cdb3] Waiting for reconfiguration 2026-06-07 00:26:20,609 DEBUG zuul.Scheduler: Run handler awake 2026-06-07 00:26:20,609 DEBUG zuul.Scheduler: Fetching reconfiguration event 2026-06-07 00:26:20,610 INFO zuul.Scheduler: Reconfiguration beginning (smart=False, tenants=['internal']) 2026-06-07 00:26:20,682 INFO zuul.ConfigLoader: Loading configuration from /var/lib/zuul/main.yaml 2026-06-07 00:26:20,886 DEBUG zuul.Scheduler: Wait for internal write tenant lock (id: RECONFIG) 2026-06-07 00:26:20,893 DEBUG zuul.Scheduler: Aquired internal write tenant lock (id: RECONFIG) /usr/local/lib/python3.11/site-packages/paramiko/client.py:885: UserWarning: Unknown ssh-ed25519 host key for [gerrit-sshd.sf]:29418: b'1277f339273769f9c1a053e7e90c6a6a' warnings.warn( 2026-06-07 00:26:23,802 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-fbfc7d985-4bfw50000000005 2026-06-07 00:26:23,803 INFO zuul.ComponentRegistry: Component web zuul-web-fbfc7d985-4bfw50000000005 updated: {'hostname': 'zuul-web-fbfc7d985-4bfw5', 'kind': 'web', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-07 00:26:23,803 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-07 00:26:23,806 DEBUG zuul.GerritConnection: SSH command: 2026-06-07 00:26:23,806 DEBUG zuul.GerritConnection: git-upload-pack config 2026-06-07 00:26:23,858 DEBUG zuul.GerritConnection.io: SSH received stdout: 2026-06-07 00:26:23,858 DEBUG zuul.GerritConnection.io: 00e9ac5ed56478e1a48f78a5870530983659eaeb2636 HEAD include-tag multi_ack_detailed multi_ack ofs-delta side-band side-band-64k thin-pack no-progress shallow agent=JGit/v6.4.0.202211300538-r-53-ga1901305b symref=HEAD:refs/heads/master 2026-06-07 00:26:23,858 DEBUG zuul.GerritConnection.io: 003fac5ed56478e1a48f78a5870530983659eaeb2636 refs/heads/master 2026-06-07 00:26:23,858 DEBUG zuul.GerritConnection.io: 003ee116ced2bfc2bfc15f54349ca0eb998e1a857ade refs/meta/config 2026-06-07 00:26:23,858 DEBUG zuul.GerritConnection.io: 0000 2026-06-07 00:26:23,858 DEBUG zuul.GerritConnection: SSH exit status: 0 2026-06-07 00:26:23,858 DEBUG zuul.GerritConnection: Fetched 1 branches for config 2026-06-07 00:26:23,858 INFO zuul.GerritConnection: Got branches for config 2026-06-07 00:26:23,896 ERROR zuul.BranchCacheNew.gerrit: Exception loading ZKObject at /zuul/cache/connection/gerrit/project/data/config 2026-06-07 00:26:23,907 INFO zuul.GerritConnection: Got default branch for config: master 2026-06-07 00:26:24,008 DEBUG zuul.ComponentRegistry: Registry got event DELETED for web zuul-web-fbfc7d985-4bfw50000000005 2026-06-07 00:26:24,008 INFO zuul.ComponentRegistry: Noticed web component zuul-web-fbfc7d985-4bfw50000000005 disappeared 2026-06-07 00:26:24,008 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-07 00:26:24,153 DEBUG zuul.MergeClient: Submitting job 93d0a5992d864954b13b9627fede3210 with data {'connection': 'git-server', 'project': 'system-config', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']} 2026-06-07 00:26:24,154 DEBUG zuul.MergeClient: Submitting job 31dc71ec682e4524a80fd46cdf695ec9 with data {'connection': 'gerrit', 'project': 'config', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']} 2026-06-07 00:26:24,154 DEBUG zuul.MergeClient: Submitting job a4af3cc334c9426e95a2a9791393fb55 with data {'connection': 'opendev.org', 'project': 'zuul/zuul-jobs', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']} 2026-06-07 00:26:24,161 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper 2026-06-07 00:26:24,162 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper 2026-06-07 00:26:24,163 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper 2026-06-07 00:26:24,191 DEBUG zuul.TenantParser: Submitting cat job for gerrit config master 2026-06-07 00:26:24,194 DEBUG zuul.TenantParser: Submitting cat job for git-server system-config master 2026-06-07 00:26:24,195 DEBUG zuul.TenantParser: Submitting cat job for opendev.org zuul/zuul-jobs master 2026-06-07 00:26:24,196 DEBUG zuul.TenantParser: Waiting for cat job 2026-06-07 00:26:25,587 DEBUG zuul.TenantParser: Cat job got files dict_keys(['.zuul.yaml', 'zuul.yaml']) 2026-06-07 00:26:25,603 DEBUG zuul.TenantParser: Waiting for cat job 2026-06-07 00:26:25,620 DEBUG zuul.TenantParser: Cat job got files dict_keys(['.zuul.yaml', 'zuul.d/config-project.yaml', 'zuul.d/jobs-base.yaml', 'zuul.d/k8s-secret.yaml', 'zuul.d/sf-logserver-secret.yaml', 'zuul.yaml']) 2026-06-07 00:26:25,620 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/config-project.yaml@master 2026-06-07 00:26:25,626 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/jobs-base.yaml@master 2026-06-07 00:26:25,628 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/k8s-secret.yaml@master 2026-06-07 00:26:25,629 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/sf-logserver-secret.yaml@master 2026-06-07 00:26:25,808 DEBUG zuul.Scheduler: Starting merge request cleanup 2026-06-07 00:26:25,809 DEBUG zuul.Scheduler: Finished merge request cleanup 2026-06-07 00:26:25,844 DEBUG zuul.TenantParser: Waiting for cat job 2026-06-07 00:26:25,884 DEBUG zuul.TenantParser: Cat job got files dict_keys(['.zuul.yaml', 'zuul.d/container-jobs.yaml', 'zuul.d/dib-jobs.yaml', 'zuul.d/docker-jobs.yaml', 'zuul.d/general-jobs.yaml', 'zuul.d/go-jobs.yaml', 'zuul.d/haskell-jobs.yaml', 'zuul.d/helm-jobs.yaml', 'zuul.d/js-jobs.yaml', 'zuul.d/nim-jobs.yaml', 'zuul.d/packer-jobs.yaml', 'zuul.d/python-jobs.yaml', 'zuul.d/system-jobs.yaml', 'zuul.d/terraform-jobs.yaml', 'zuul.yaml']) 2026-06-07 00:26:25,884 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/container-jobs.yaml@master 2026-06-07 00:26:25,886 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/dib-jobs.yaml@master 2026-06-07 00:26:25,887 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/docker-jobs.yaml@master 2026-06-07 00:26:25,889 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/general-jobs.yaml@master 2026-06-07 00:26:25,899 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/go-jobs.yaml@master 2026-06-07 00:26:25,901 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/haskell-jobs.yaml@master 2026-06-07 00:26:25,903 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/helm-jobs.yaml@master 2026-06-07 00:26:25,904 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/js-jobs.yaml@master 2026-06-07 00:26:25,908 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/nim-jobs.yaml@master 2026-06-07 00:26:25,909 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/packer-jobs.yaml@master 2026-06-07 00:26:25,910 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/python-jobs.yaml@master 2026-06-07 00:26:25,928 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/system-jobs.yaml@master 2026-06-07 00:26:25,929 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/terraform-jobs.yaml@master 2026-06-07 00:26:26,696 DEBUG zuul.TenantParser: Created layout id 3c2c40371e594f2d9b40e47ce9a006e3 2026-06-07 00:26:26,915 DEBUG zuul.Pipeline.internal.check: Building relative_priority queues 2026-06-07 00:26:26,927 DEBUG zuul.Pipeline.internal.gate: Building shared change queues 2026-06-07 00:26:26,928 DEBUG zuul.Pipeline.internal.gate: Created queue: 2026-06-07 00:26:26,928 DEBUG zuul.Pipeline.internal.gate: Added project config to default queue manager: 2026-06-07 00:26:26,988 DEBUG zuul.Pipeline.internal.post: Building relative_priority queues 2026-06-07 00:26:27,003 DEBUG zuul.GerritConnection: Setting watched checkers to [] 2026-06-07 00:26:27,003 DEBUG zuul.GerritConnection: Setting watched event filters for internal to [, , , , , ] 2026-06-07 00:26:27,003 DEBUG zuul.GerritConnection: Setting watched event filters to {, , , , , } 2026-06-07 00:26:27,003 DEBUG zuul.TimerDriver: No jobs to remove for , 0 remain 2026-06-07 00:26:27,108 DEBUG zuul.Scheduler: Setting layout state last reconfigure ltime to 5683 2026-06-07 00:26:27,198 DEBUG zuul.Scheduler: Released internal write tenant lock (id: RECONFIG) 2026-06-07 00:26:27,280 INFO zuul.Scheduler: Reconfiguration complete (smart: False, tenants: ['internal'], duration: 6.671 seconds) 2026-06-07 00:26:27,281 DEBUG zuul.Scheduler: [e: e62ee2adfc4442cba8edf3135213cdb3] Reconfiguration complete 2026-06-07 00:26:27,291 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-07 00:26:27,293 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-07 00:26:27,302 DEBUG zuul.Scheduler: Processing tenant management events in internal 2026-06-07 00:26:27,381 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-07 00:26:27,383 DEBUG zuul.Scheduler: Aquired internal read tenant lock 2026-06-07 00:26:27,383 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-07 00:26:27,392 DEBUG zuul.Scheduler: Processing tenant trigger events in internal 2026-06-07 00:26:27,408 DEBUG zuul.Scheduler: Processing pipeline check in tenant internal 2026-06-07 00:26:27,425 DEBUG zuul.Scheduler: Processing management event 2026-06-07 00:26:27,488 DEBUG zuul.Pipeline.internal.check: Starting queue processor: check 2026-06-07 00:26:27,488 DEBUG zuul.Pipeline.internal.check: Finished queue processor: check (changed: False) 2026-06-07 00:26:27,504 DEBUG zuul.Scheduler: Processing pipeline gate in tenant internal 2026-06-07 00:26:27,595 DEBUG zuul.Scheduler: Processing management event 2026-06-07 00:26:27,688 DEBUG zuul.Pipeline.internal.gate: Starting queue processor: gate 2026-06-07 00:26:27,688 DEBUG zuul.Pipeline.internal.gate: Finished queue processor: gate (changed: False) 2026-06-07 00:26:27,785 DEBUG zuul.Scheduler: Processing pipeline post in tenant internal 2026-06-07 00:26:27,892 DEBUG zuul.Scheduler: Processing management event 2026-06-07 00:26:27,982 DEBUG zuul.Pipeline.internal.post: Starting queue processor: post 2026-06-07 00:26:27,982 DEBUG zuul.Pipeline.internal.post: Finished queue processor: post (changed: False) 2026-06-07 00:26:27,991 DEBUG zuul.Scheduler: Released internal read tenant lock 2026-06-07 00:26:28,001 DEBUG zuul.Scheduler: Processing tenant management events in demo-tenant 2026-06-07 00:26:28,086 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock 2026-06-07 00:26:28,097 DEBUG zuul.Scheduler: Processing tenant trigger events in demo-tenant 2026-06-07 00:26:28,187 DEBUG zuul.Scheduler: Processing pipeline check in tenant demo-tenant 2026-06-07 00:26:28,192 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant demo-tenant 2026-06-07 00:26:28,200 DEBUG zuul.Scheduler: Processing pipeline gate in tenant demo-tenant 2026-06-07 00:26:28,204 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant demo-tenant 2026-06-07 00:26:28,211 DEBUG zuul.Scheduler: Processing pipeline post in tenant demo-tenant 2026-06-07 00:26:28,215 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant demo-tenant 2026-06-07 00:26:28,217 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock 2026-06-07 00:26:28,220 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-07 00:26:28,220 DEBUG zuul.Scheduler: Run handler awake 2026-06-07 00:26:28,295 DEBUG zuul.Scheduler: Processing tenant management events in internal 2026-06-07 00:26:28,306 DEBUG zuul.Scheduler: Aquired internal read tenant lock 2026-06-07 00:26:28,383 DEBUG zuul.Scheduler: Processing tenant trigger events in internal 2026-06-07 00:26:28,408 DEBUG zuul.Scheduler: Processing pipeline check in tenant internal 2026-06-07 00:26:28,415 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant internal 2026-06-07 00:26:28,424 DEBUG zuul.Scheduler: Processing pipeline gate in tenant internal 2026-06-07 00:26:28,489 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant internal 2026-06-07 00:26:28,510 DEBUG zuul.Scheduler: Processing pipeline post in tenant internal 2026-06-07 00:26:28,514 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant internal 2026-06-07 00:26:28,517 DEBUG zuul.Scheduler: Released internal read tenant lock 2026-06-07 00:26:28,526 DEBUG zuul.Scheduler: Processing tenant management events in demo-tenant 2026-06-07 00:26:28,535 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock 2026-06-07 00:26:28,580 DEBUG zuul.Scheduler: Processing tenant trigger events in demo-tenant 2026-06-07 00:26:28,602 DEBUG zuul.Scheduler: Processing pipeline check in tenant demo-tenant 2026-06-07 00:26:28,604 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant demo-tenant 2026-06-07 00:26:28,608 DEBUG zuul.Scheduler: Processing pipeline gate in tenant demo-tenant 2026-06-07 00:26:28,610 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant demo-tenant 2026-06-07 00:26:28,614 DEBUG zuul.Scheduler: Processing pipeline post in tenant demo-tenant 2026-06-07 00:26:28,616 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant demo-tenant 2026-06-07 00:26:28,617 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock 2026-06-07 00:26:28,618 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-07 00:26:37,806 INFO zuul.ComponentRegistry: Noticed new web component zuul-web-fbfc7d985-l9ght0000000006 2026-06-07 00:26:37,807 DEBUG zuul.ComponentRegistry: Registry got event None for web zuul-web-fbfc7d985-l9ght0000000006 2026-06-07 00:26:37,807 INFO zuul.ComponentRegistry: Component web zuul-web-fbfc7d985-l9ght0000000006 updated: {'hostname': 'zuul-web-fbfc7d985-l9ght', 'kind': 'web', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-07 00:26:37,808 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-07 00:26:38,086 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-fbfc7d985-l9ght0000000006 2026-06-07 00:26:38,087 INFO zuul.ComponentRegistry: Component web zuul-web-fbfc7d985-l9ght0000000006 updated: {'hostname': 'zuul-web-fbfc7d985-l9ght', 'kind': 'web', 'model_api': 37, 'state': 'initializing', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-07 00:26:38,087 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-07 00:26:41,705 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-fbfc7d985-l9ght0000000006 2026-06-07 00:26:41,706 INFO zuul.ComponentRegistry: Component web zuul-web-fbfc7d985-l9ght0000000006 updated: {'hostname': 'zuul-web-fbfc7d985-l9ght', 'kind': 'web', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-07 00:26:41,706 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-07 00:27:25,855 DEBUG zuul.Scheduler: Starting build request cleanup 2026-06-07 00:27:25,856 DEBUG zuul.Scheduler: Finished build request cleanup 2026-06-07 00:27:26,288 DEBUG zuul.Scheduler: Starting merge request cleanup 2026-06-07 00:27:26,288 DEBUG zuul.Scheduler: Finished merge request cleanup