2026-06-12 00:22:58,835 DEBUG zuul.Scheduler: Configured logging: 14.1.1.dev1 2026-06-12 00:22:58,835 DEBUG zuul.TimerDriver: Starting apscheduler 2026-06-12 00:22:58,836 INFO apscheduler.scheduler: Scheduler started 2026-06-12 00:22:58,836 DEBUG apscheduler.scheduler: Looking for jobs to run 2026-06-12 00:22:58,836 DEBUG apscheduler.scheduler: No jobs; waiting until a job is added 2026-06-12 00:22:58,837 DEBUG zuul.BubblewrapDriver: Initializing bubblewrap with oom_score_adj starting: 995, final: 1000 2026-06-12 00:22:58,839 INFO zuul.SQLConnection: Initializing SQL connection database (prefix: ) 2026-06-12 00:22:59,068 DEBUG zuul.zk.base.ZooKeeperClient: ZooKeeper connection (session: 0x100001044e9000f): CONNECTED 2026-06-12 00:22:59,077 INFO zuul.Component: Registering component in ZooKeeper /zuul/components/scheduler/zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local 2026-06-12 00:22:59,083 INFO zuul.ComponentRegistry: Noticed new scheduler component zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-12 00:22:59,084 DEBUG zuul.ComponentRegistry: Registry got event None for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-12 00:22:59,084 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-12 00:22:59,086 INFO zuul.ComponentRegistry: Noticed new executor component zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-12 00:22:59,086 DEBUG zuul.ComponentRegistry: Registry got event None for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-12 00:22:59,087 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-12 00:22:59,088 INFO zuul.ComponentRegistry: Noticed new merger component zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003 2026-06-12 00:22:59,089 DEBUG zuul.ComponentRegistry: Registry got event None for merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003 2026-06-12 00:22:59,089 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-12 00:22:59,093 INFO zuul.ComponentRegistry: Noticed new web component zuul-web-694698b5f-278wx0000000005 2026-06-12 00:22:59,094 DEBUG zuul.ComponentRegistry: Registry got event None for web zuul-web-694698b5f-278wx0000000005 2026-06-12 00:22:59,094 INFO zuul.ComponentRegistry: Component web zuul-web-694698b5f-278wx0000000005 updated: {'hostname': 'zuul-web-694698b5f-278wx', 'kind': 'web', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-12 00:22:59,099 INFO zuul.ComponentRegistry: System minimum data model version 37; this component 37 2026-06-12 00:22:59,143 DEBUG zuul.zk.ZooKeeper: Initialize cache at /keystorage-oidc 2026-06-12 00:22:59,145 DEBUG zuul.zk.ZooKeeper: Cache at /keystorage-oidc is ready 2026-06-12 00:22:59,151 DEBUG zuul.ExecutorQueue: Creating executor queue at root /zuul/executor/unzoned 2026-06-12 00:22:59,156 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/executor/unzoned 2026-06-12 00:22:59,191 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/executor/unzoned is ready 2026-06-12 00:22:59,199 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/merger 2026-06-12 00:22:59,210 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/merger is ready 2026-06-12 00:22:59,215 DEBUG zuul.nodepool: Running nodepool watcher election 2026-06-12 00:22:59,216 DEBUG zuul.TimerDriver: Starting timer election loop 2026-06-12 00:22:59,220 INFO zuul.TimerDriver: Running timer election 2026-06-12 00:22:59,228 INFO zuul.TimerDriver: Won timer election 2026-06-12 00:22:59,228 INFO zuul.nodepool: Watching nodepool requests 2026-06-12 00:22:59,244 DEBUG zuul.SQLConnection: Current migration revision: 21d30f0bffef 2026-06-12 00:22:59,306 DEBUG zuul.GerritConnection: Starting Gerrit Connection/Watchers 2026-06-12 00:22:59,307 DEBUG zuul.GerritConnection: Creating Zookeeper branch cache 2026-06-12 00:22:59,395 INFO zuul.GerritConnection: Creating Zookeeper event queue 2026-06-12 00:22:59,400 DEBUG zuul.GerritConnection: Creating Zookeeper change cache 2026-06-12 00:22:59,403 INFO zuul.GerritConnection: Starting SSH event stream client 2026-06-12 00:22:59,404 INFO zuul.GerritConnection: gerrit: Gerrit Poller is disabled because no HTTP authentication is defined 2026-06-12 00:22:59,405 DEBUG zuul.connection.git: Creating Zookeeper change cache 2026-06-12 00:22:59,411 DEBUG zuul.connection.git: Starting Git Watcher 2026-06-12 00:22:59,412 DEBUG zuul.connection.git: Creating Zookeeper change cache 2026-06-12 00:22:59,415 DEBUG paramiko.transport: starting thread (client mode): 0x6847ca10 2026-06-12 00:22:59,416 DEBUG paramiko.transport: Local version/idstring: SSH-2.0-paramiko_4.0.0 2026-06-12 00:22:59,416 DEBUG paramiko.transport: Remote version/idstring: SSH-2.0-GerritCodeReview_3.6.4 (APACHE-SSHD-2.9.2) 2026-06-12 00:22:59,416 INFO paramiko.transport: Connected (version 2.0, client GerritCodeReview_3.6.4) 2026-06-12 00:22:59,417 DEBUG paramiko.transport: === Key exchange possibilities === 2026-06-12 00:22:59,417 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 00:22:59,417 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 00:22:59,417 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 00:22:59,418 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 00:22:59,418 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 00:22:59,418 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 00:22:59,418 DEBUG paramiko.transport: client compress: none 2026-06-12 00:22:59,418 DEBUG paramiko.transport: server compress: none 2026-06-12 00:22:59,418 DEBUG paramiko.transport: client lang: 2026-06-12 00:22:59,418 DEBUG paramiko.transport: server lang: 2026-06-12 00:22:59,418 DEBUG paramiko.transport: kex follows: False 2026-06-12 00:22:59,418 DEBUG paramiko.transport: === Key exchange agreements === 2026-06-12 00:22:59,418 DEBUG paramiko.transport: Kex: curve25519-sha256@libssh.org 2026-06-12 00:22:59,418 DEBUG paramiko.transport: HostKey: ssh-ed25519 2026-06-12 00:22:59,418 DEBUG paramiko.transport: Cipher: aes128-ctr 2026-06-12 00:22:59,419 DEBUG paramiko.transport: MAC: hmac-sha2-256 2026-06-12 00:22:59,419 DEBUG paramiko.transport: Compression: none 2026-06-12 00:22:59,419 DEBUG paramiko.transport: === End of kex handshake === 2026-06-12 00:22:59,460 DEBUG paramiko.transport: kex engine KexCurve25519 specified hash_algo 2026-06-12 00:22:59,460 DEBUG paramiko.transport: Switch to new keys ... 2026-06-12 00:22:59,461 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'} /usr/local/lib/python3.11/site-packages/paramiko/client.py:885: UserWarning: Unknown ssh-ed25519 host key for [gerrit-sshd.sf]:29418: b'b5b35bfbc7e184840e842d8fdf725f53' warnings.warn( 2026-06-12 00:23:00,318 DEBUG paramiko.transport: Trying discovered key b'c10c2bfaf52ffce2d88b6e0e11a91467' in /var/lib/zuul-ssh/..data/priv 2026-06-12 00:23:00,320 DEBUG zuul.connection.git: Starting Git Watcher 2026-06-12 00:23:00,320 DEBUG paramiko.transport: userauth is OK 2026-06-12 00:23:00,321 DEBUG paramiko.transport: Finalizing pubkey algorithm for key of type 'ssh-rsa' 2026-06-12 00:23:00,321 DEBUG paramiko.transport: Our pubkey algorithm list: ['rsa-sha2-512', 'rsa-sha2-256', 'ssh-rsa'] 2026-06-12 00:23:00,321 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 00:23:00,321 DEBUG paramiko.transport: Agreed upon 'rsa-sha2-512' pubkey algorithm 2026-06-12 00:23:00,337 INFO zuul.Scheduler: Starting scheduler 2026-06-12 00:23:00,337 DEBUG zuul.Scheduler: Statsd enabled 2026-06-12 00:23:00,338 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-12 00:23:00,338 DEBUG zuul.Scheduler: Run handler awake 2026-06-12 00:23:00,338 DEBUG zuul.Scheduler: Starting command processor 2026-06-12 00:23:00,339 DEBUG zuul.connection.git.watcher: Walk through projects refs for connection: git-server 2026-06-12 00:23:00,344 INFO paramiko.transport: Authentication (publickey) successful! 2026-06-12 00:23:00,345 DEBUG paramiko.transport: [chan 0] Max packet in: 32768 bytes 2026-06-12 00:23:00,346 DEBUG paramiko.transport: [chan 0] Max packet out: 32768 bytes 2026-06-12 00:23:00,346 DEBUG paramiko.transport: Secsh channel 0 opened. 2026-06-12 00:23:00,347 DEBUG paramiko.transport: [chan 0] Sesch channel 0 request ok 2026-06-12 00:23:00,392 DEBUG zuul.Scheduler: Running stats election 2026-06-12 00:23:00,393 INFO apscheduler.scheduler: Scheduler started 2026-06-12 00:23:00,394 DEBUG apscheduler.scheduler: Looking for jobs to run 2026-06-12 00:23:00,394 DEBUG apscheduler.scheduler: No jobs; waiting until a job is added 2026-06-12 00:23:00,402 DEBUG zuul.connection.git.watcher: Walk through projects refs for connection: opendev.org 2026-06-12 00:23:00,403 INFO zuul.Scheduler: Priming scheduler config 2026-06-12 00:23:00,405 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-12 00:23:00,405 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-12 00:23:00,405 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is None 2026-06-12 00:23:00,407 DEBUG zuul.Scheduler: Won stats election 2026-06-12 00:23:00,414 INFO zuul.Scheduler: Using system config from Zookeeper 2026-06-12 00:23:00,416 DEBUG zuul.Scheduler: Updating system config 2026-06-12 00:23:01,314 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-12 00:23:01,324 DEBUG zuul.Scheduler: Wait for internal read tenant lock 2026-06-12 00:23:01,328 DEBUG zuul.Scheduler: Aquired internal read tenant lock 2026-06-12 00:23:01,621 INFO zuul.BranchCache.gerrit: Waiting for branch cache upgrade lock 2026-06-12 00:23:01,825 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/cache/connection/gerrit/project 2026-06-12 00:23:01,902 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/cache/connection/gerrit/project is ready 2026-06-12 00:23:01,902 INFO zuul.BranchCache.gerrit: Cache already upgraded 2026-06-12 00:23:02,712 DEBUG zuul.TenantParser: Using files from cache for project gerrit-sshd.sf/config @master: [] 2026-06-12 00:23:02,714 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-12 00:23:02,715 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-12 00:23:02,734 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/config-project.yaml@master 2026-06-12 00:23:02,742 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/container-jobs.yaml@master 2026-06-12 00:23:02,748 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/jobs-base.yaml@master 2026-06-12 00:23:02,752 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/dib-jobs.yaml@master 2026-06-12 00:23:02,791 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/k8s-secret.yaml@master 2026-06-12 00:23:02,793 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/docker-jobs.yaml@master 2026-06-12 00:23:02,798 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/sf-logserver-secret.yaml@master 2026-06-12 00:23:02,801 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/general-jobs.yaml@master 2026-06-12 00:23:02,810 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/go-jobs.yaml@master 2026-06-12 00:23:02,815 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/haskell-jobs.yaml@master 2026-06-12 00:23:02,820 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/helm-jobs.yaml@master 2026-06-12 00:23:02,824 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/js-jobs.yaml@master 2026-06-12 00:23:02,832 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/nim-jobs.yaml@master 2026-06-12 00:23:02,836 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/packer-jobs.yaml@master 2026-06-12 00:23:02,894 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/python-jobs.yaml@master 2026-06-12 00:23:02,914 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/system-jobs.yaml@master 2026-06-12 00:23:02,920 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/terraform-jobs.yaml@master 2026-06-12 00:23:02,929 DEBUG zuul.TenantParser: Created layout id d21f22146dd14a48821d2da15eea188c 2026-06-12 00:23:02,999 DEBUG zuul.Pipeline.internal.check: Building relative_priority queues 2026-06-12 00:23:03,009 DEBUG zuul.Pipeline.internal.gate: Building shared change queues 2026-06-12 00:23:03,009 DEBUG zuul.Pipeline.internal.gate: Created queue: 2026-06-12 00:23:03,009 DEBUG zuul.Pipeline.internal.gate: Added project config to default queue manager: 2026-06-12 00:23:03,017 DEBUG zuul.Pipeline.internal.post: Building relative_priority queues 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: 2 errors detected during internal tenant configuration loading 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: Zuul encountered a syntax error while parsing its 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: configuration in the repo system-config on branch master. The 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: problem was: 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: Decryption failed 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: The problem appears in the "base" job stanza: 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: job: 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: name: base 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: description: The base job. 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: parent: null 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: post-run: 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: - playbooks/base/post.yaml 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: pre-run: 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: - playbooks/base/pre.yaml 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: roles: 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: ... 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: in "system-config/zuul.d/jobs-base.yaml@master", line 5 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: Zuul encountered a syntax error while parsing its 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: configuration in the repo system-config on branch master. The 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: problem was: 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: Decryption failed 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: The problem appears in the "config-update" job stanza: 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: job: 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: name: config-update 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: description: Deploy config repo update. 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: parent: base 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: secrets: 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: - k8s_config 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: final: true 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: run: 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: - playbooks/config/update.yaml 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: ... 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: 2026-06-12 00:23:03,029 WARNING zuul.ConfigLoader: in "system-config/zuul.d/jobs-base.yaml@master", line 26 2026-06-12 00:23:03,029 DEBUG zuul.GerritConnection: Setting watched checkers to [] 2026-06-12 00:23:03,030 DEBUG zuul.GerritConnection: Setting watched event filters for internal to [, , , , , ] 2026-06-12 00:23:03,030 DEBUG zuul.GerritConnection: Setting watched event filters to {, , , , , } 2026-06-12 00:23:03,030 DEBUG zuul.TimerDriver: No jobs to remove for , 0 remain 2026-06-12 00:23:03,030 DEBUG zuul.Scheduler: Released internal read tenant lock 2026-06-12 00:23:03,034 DEBUG zuul.Scheduler: Wait for demo-tenant read tenant lock 2026-06-12 00:23:03,039 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock 2026-06-12 00:23:03,922 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-12 00:23:03,923 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-12 00:23:03,932 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-base-jobs.yaml@master 2026-06-12 00:23:03,938 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-pipeline.yaml@master 2026-06-12 00:23:03,942 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/jobs.yaml@master 2026-06-12 00:23:03,948 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-project-pipeline.yaml@master 2026-06-12 00:23:03,949 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/project.yaml@master 2026-06-12 00:23:03,956 DEBUG zuul.TenantParser: Created layout id 3eb53074490047bb927eb5bb83a522bd 2026-06-12 00:23:03,962 DEBUG zuul.Pipeline.demo-tenant.check: Building relative_priority queues 2026-06-12 00:23:03,970 DEBUG zuul.Pipeline.demo-tenant.gate: Building shared change queues 2026-06-12 00:23:03,970 DEBUG zuul.Pipeline.demo-tenant.gate: Created queue: 2026-06-12 00:23:03,971 DEBUG zuul.Pipeline.demo-tenant.gate: Added project demo-tenant-config to default queue manager: 2026-06-12 00:23:03,971 DEBUG zuul.Pipeline.demo-tenant.gate: Created queue: 2026-06-12 00:23:03,971 DEBUG zuul.Pipeline.demo-tenant.gate: Added project demo-project to default queue manager: 2026-06-12 00:23:03,997 DEBUG zuul.Pipeline.demo-tenant.post: Building relative_priority queues 2026-06-12 00:23:04,004 DEBUG zuul.GerritConnection: Setting watched checkers to [] 2026-06-12 00:23:04,004 DEBUG zuul.GerritConnection: Setting watched event filters for demo-tenant to [, , , , , ] 2026-06-12 00:23:04,005 DEBUG zuul.GerritConnection: Setting watched event filters to {, , , , , } 2026-06-12 00:23:04,005 DEBUG zuul.TimerDriver: No jobs to remove for , 0 remain 2026-06-12 00:23:04,005 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock 2026-06-12 00:23:04,007 INFO zuul.Scheduler: Config priming complete (duration: 3.603 seconds) 2026-06-12 00:23:04,007 DEBUG zuul.Scheduler: Run handler awake 2026-06-12 00:23:04,012 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is None 2026-06-12 00:23:04,012 DEBUG zuul.RendezvousElection: Did not win election for /zuul/events/connection/gerrit/election 2026-06-12 00:23:04,012 DEBUG zuul.RendezvousElection: Did not win election for /zuul/events/connection/gerrit/election 2026-06-12 00:23:04,014 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-12 00:23:04,014 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-12 00:23:04,014 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-12 00:23:04,014 DEBUG zuul.RendezvousElection: Acquiring lock for /zuul/events/connection/gerrit/election 2026-06-12 00:23:04,023 INFO zuul.RendezvousElection: Won election for /zuul/events/connection/gerrit/election 2026-06-12 00:23:04,024 DEBUG zuul.Scheduler: Starting semaphore cleanup 2026-06-12 00:23:04,031 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-12 00:23:04,032 DEBUG zuul.Scheduler: Processing tenant management events in demo-tenant 2026-06-12 00:23:04,033 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-12 00:23:04,098 DEBUG zuul.Scheduler: Starting build request cleanup 2026-06-12 00:23:04,098 DEBUG zuul.Scheduler: Finished build request cleanup 2026-06-12 00:23:04,108 DEBUG zuul.Scheduler: Starting node request cleanup 2026-06-12 00:23:04,108 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock 2026-06-12 00:23:04,111 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-12 00:23:04,113 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-12 00:23:04,121 DEBUG zuul.Scheduler: Processing tenant trigger events in demo-tenant 2026-06-12 00:23:04,152 DEBUG zuul.Scheduler: Processing pipeline check in tenant demo-tenant 2026-06-12 00:23:04,193 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant demo-tenant 2026-06-12 00:23:04,201 DEBUG zuul.Scheduler: Processing pipeline gate in tenant demo-tenant 2026-06-12 00:23:04,215 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant demo-tenant 2026-06-12 00:23:04,224 DEBUG zuul.Scheduler: Processing pipeline post in tenant demo-tenant 2026-06-12 00:23:04,237 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant demo-tenant 2026-06-12 00:23:04,239 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock 2026-06-12 00:23:04,250 DEBUG zuul.Scheduler: Processing tenant management events in internal 2026-06-12 00:23:04,258 INFO apscheduler.scheduler: Added job "Scheduler._runSemaphoreCleanup" to job store "default" 2026-06-12 00:23:04,259 INFO apscheduler.scheduler: Added job "Scheduler._runBuildRequestCleanup" to job store "default" 2026-06-12 00:23:04,259 INFO apscheduler.scheduler: Added job "Scheduler._runMergeRequestCleanup" to job store "default" 2026-06-12 00:23:04,259 INFO apscheduler.scheduler: Added job "Scheduler._runConnectionCleanup" to job store "default" 2026-06-12 00:23:04,259 INFO apscheduler.scheduler: Added job "Scheduler._runGeneralCleanup" to job store "default" 2026-06-12 00:23:04,259 DEBUG apscheduler.scheduler: Looking for jobs to run 2026-06-12 00:23:04,260 DEBUG apscheduler.scheduler: Next wakeup is due at 2026-06-12 00:23:59.832729+00:00 (in 55.572642 seconds) 2026-06-12 00:23:04,263 DEBUG zuul.Scheduler: Aquired internal read tenant lock 2026-06-12 00:23:04,268 DEBUG zuul.Scheduler: Processing tenant trigger events in internal 2026-06-12 00:23:04,312 DEBUG zuul.Scheduler: Processing pipeline check in tenant internal 2026-06-12 00:23:04,322 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant internal 2026-06-12 00:23:04,329 DEBUG zuul.Scheduler: Processing pipeline gate in tenant internal 2026-06-12 00:23:04,337 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant internal 2026-06-12 00:23:04,343 DEBUG zuul.Scheduler: Processing pipeline post in tenant internal 2026-06-12 00:23:04,352 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant internal 2026-06-12 00:23:04,354 DEBUG zuul.Scheduler: Released internal read tenant lock 2026-06-12 00:23:04,356 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-12 00:23:48,920 DEBUG zuul.CommandSocket: Accepted socket connection 2026-06-12 00:23:48,920 DEBUG zuul.CommandSocket: Received b'full-reconfigure' from socket 2026-06-12 00:23:48,921 DEBUG zuul.Scheduler: Reconfiguration triggered 2026-06-12 00:23:48,999 DEBUG zuul.Scheduler: Configured logging: 14.1.1.dev1 2026-06-12 00:23:48,999 DEBUG zuul.Scheduler: [e: 05f14b1f982b459086bd6aa7b3719906] Submitting reconfiguration event 2026-06-12 00:23:49,004 DEBUG zuul.Scheduler: [e: 05f14b1f982b459086bd6aa7b3719906] Waiting for reconfiguration 2026-06-12 00:23:49,004 DEBUG zuul.Scheduler: Run handler awake 2026-06-12 00:23:49,004 DEBUG zuul.Scheduler: Fetching reconfiguration event 2026-06-12 00:23:49,004 INFO zuul.Scheduler: Reconfiguration beginning (smart=False, tenants=None) 2026-06-12 00:23:49,007 INFO zuul.ConfigLoader: Loading configuration from /var/lib/zuul/main.yaml 2026-06-12 00:23:49,303 DEBUG zuul.Scheduler: Wait for internal write tenant lock (id: RECONFIG) 2026-06-12 00:23:49,308 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'b5b35bfbc7e184840e842d8fdf725f53' warnings.warn( 2026-06-12 00:23:51,999 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-694698b5f-278wx0000000005 2026-06-12 00:23:51,999 INFO zuul.ComponentRegistry: Component web zuul-web-694698b5f-278wx0000000005 updated: {'hostname': 'zuul-web-694698b5f-278wx', 'kind': 'web', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-12 00:23:51,999 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-12 00:23:52,005 DEBUG zuul.GerritConnection: SSH command: 2026-06-12 00:23:52,005 DEBUG zuul.GerritConnection: git-upload-pack config 2026-06-12 00:23:52,054 DEBUG zuul.GerritConnection.io: SSH received stdout: 2026-06-12 00:23:52,054 DEBUG zuul.GerritConnection.io: 00e9611967ae8731a94a9b65a63f90ce970ce2ff7093 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-12 00:23:52,054 DEBUG zuul.GerritConnection.io: 003f611967ae8731a94a9b65a63f90ce970ce2ff7093 refs/heads/master 2026-06-12 00:23:52,054 DEBUG zuul.GerritConnection.io: 003e51d82b8f1ec5da9cdc19e0b94998d0a4ac7c6c3f refs/meta/config 2026-06-12 00:23:52,054 DEBUG zuul.GerritConnection.io: 0000 2026-06-12 00:23:52,054 DEBUG zuul.GerritConnection: SSH exit status: 0 2026-06-12 00:23:52,054 DEBUG zuul.GerritConnection: Fetched 1 branches for config 2026-06-12 00:23:52,054 INFO zuul.GerritConnection: Got branches for config 2026-06-12 00:23:52,069 ERROR zuul.BranchCacheNew.gerrit: Exception loading ZKObject at /zuul/cache/connection/gerrit/project/data/config 2026-06-12 00:23:52,078 INFO zuul.GerritConnection: Got default branch for config: master 2026-06-12 00:23:52,124 DEBUG zuul.ComponentRegistry: Registry got event DELETED for web zuul-web-694698b5f-278wx0000000005 2026-06-12 00:23:52,124 INFO zuul.ComponentRegistry: Noticed web component zuul-web-694698b5f-278wx0000000005 disappeared 2026-06-12 00:23:52,124 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-12 00:23:52,413 DEBUG zuul.MergeClient: Submitting job 83a45551da924657ac3e3dbced1b41c2 with data {'connection': 'git-server', 'project': 'system-config', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']} 2026-06-12 00:23:52,415 DEBUG zuul.MergeClient: Submitting job d29b87e569e84a66a96e3e5bf57f02c7 with data {'connection': 'gerrit', 'project': 'config', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']} 2026-06-12 00:23:52,416 DEBUG zuul.MergeClient: Submitting job 360905e379e842a189ee2b830b379821 with data {'connection': 'opendev.org', 'project': 'zuul/zuul-jobs', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']} 2026-06-12 00:23:52,422 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper 2026-06-12 00:23:52,423 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper 2026-06-12 00:23:52,424 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper 2026-06-12 00:23:52,445 DEBUG zuul.TenantParser: Submitting cat job for git-server system-config master 2026-06-12 00:23:52,492 DEBUG zuul.TenantParser: Submitting cat job for gerrit config master 2026-06-12 00:23:52,493 DEBUG zuul.TenantParser: Submitting cat job for opendev.org zuul/zuul-jobs master 2026-06-12 00:23:52,493 DEBUG zuul.TenantParser: Waiting for cat job 2026-06-12 00:23:52,819 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-12 00:23:52,819 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/config-project.yaml@master 2026-06-12 00:23:52,825 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/jobs-base.yaml@master 2026-06-12 00:23:52,827 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/k8s-secret.yaml@master 2026-06-12 00:23:52,828 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/sf-logserver-secret.yaml@master 2026-06-12 00:23:52,950 DEBUG zuul.TenantParser: Waiting for cat job 2026-06-12 00:23:53,842 DEBUG zuul.TenantParser: Cat job got files dict_keys(['.zuul.yaml', 'zuul.yaml']) 2026-06-12 00:23:53,855 DEBUG zuul.TenantParser: Waiting for cat job 2026-06-12 00:23:53,900 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-12 00:23:53,901 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/container-jobs.yaml@master 2026-06-12 00:23:53,902 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/dib-jobs.yaml@master 2026-06-12 00:23:53,903 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/docker-jobs.yaml@master 2026-06-12 00:23:53,905 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/general-jobs.yaml@master 2026-06-12 00:23:53,910 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/go-jobs.yaml@master 2026-06-12 00:23:53,911 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/haskell-jobs.yaml@master 2026-06-12 00:23:53,912 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/helm-jobs.yaml@master 2026-06-12 00:23:53,914 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/js-jobs.yaml@master 2026-06-12 00:23:53,917 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/nim-jobs.yaml@master 2026-06-12 00:23:53,918 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/packer-jobs.yaml@master 2026-06-12 00:23:53,918 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/python-jobs.yaml@master 2026-06-12 00:23:53,938 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/system-jobs.yaml@master 2026-06-12 00:23:53,939 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/terraform-jobs.yaml@master 2026-06-12 00:23:54,447 DEBUG zuul.TenantParser: Created layout id 270a552b983d4df0927d13911a65e49a 2026-06-12 00:23:54,704 DEBUG zuul.Pipeline.internal.check: Building relative_priority queues 2026-06-12 00:23:54,713 DEBUG zuul.Pipeline.internal.gate: Building shared change queues 2026-06-12 00:23:54,713 DEBUG zuul.Pipeline.internal.gate: Created queue: 2026-06-12 00:23:54,713 DEBUG zuul.Pipeline.internal.gate: Added project config to default queue manager: 2026-06-12 00:23:54,720 DEBUG zuul.Pipeline.internal.post: Building relative_priority queues 2026-06-12 00:23:54,735 DEBUG zuul.GerritConnection: Setting watched checkers to [] 2026-06-12 00:23:54,735 DEBUG zuul.GerritConnection: Setting watched event filters for internal to [, , , , , ] 2026-06-12 00:23:54,735 DEBUG zuul.GerritConnection: Setting watched event filters to {, , , , , } 2026-06-12 00:23:54,735 DEBUG zuul.TimerDriver: No jobs to remove for , 0 remain 2026-06-12 00:23:54,763 DEBUG zuul.Scheduler: Setting layout state last reconfigure ltime to 4679 2026-06-12 00:23:54,802 DEBUG zuul.Scheduler: Released internal write tenant lock (id: RECONFIG) 2026-06-12 00:23:54,847 DEBUG zuul.Scheduler: Wait for demo-tenant write tenant lock (id: RECONFIG) 2026-06-12 00:23:54,849 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-12 00:23:54,851 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-12 00:23:54,852 DEBUG zuul.Scheduler: Aquired demo-tenant write tenant lock (id: RECONFIG) 2026-06-12 00:23:54,907 DEBUG zuul.GerritConnection: SSH command: 2026-06-12 00:23:54,907 DEBUG zuul.GerritConnection: git-upload-pack demo-tenant-config 2026-06-12 00:23:54,908 DEBUG zuul.GerritConnection: SSH command: 2026-06-12 00:23:54,908 DEBUG zuul.GerritConnection: git-upload-pack demo-project 2026-06-12 00:23:55,119 DEBUG zuul.GerritConnection.io: SSH received stdout: 2026-06-12 00:23:55,119 DEBUG zuul.GerritConnection.io: 00e99dc90b4fb420f70f7464517064d1d614913e480d 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-12 00:23:55,119 DEBUG zuul.GerritConnection.io: 003f9dc90b4fb420f70f7464517064d1d614913e480d refs/heads/master 2026-06-12 00:23:55,119 DEBUG zuul.GerritConnection.io: 003ea5972063a56c0fa6846aaf051a9d1bc0b1e4fb23 refs/meta/config 2026-06-12 00:23:55,119 DEBUG zuul.GerritConnection.io: 0000 2026-06-12 00:23:55,119 DEBUG zuul.GerritConnection: SSH exit status: 0 2026-06-12 00:23:55,120 DEBUG zuul.GerritConnection: Fetched 1 branches for demo-project 2026-06-12 00:23:55,120 INFO zuul.GerritConnection: Got branches for demo-project 2026-06-12 00:23:55,191 DEBUG zuul.GerritConnection.io: SSH received stdout: 2026-06-12 00:23:55,191 DEBUG zuul.GerritConnection.io: 00e9bfd268f1bcd148b7a539b9e9c62f4d9734ba1612 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-12 00:23:55,191 DEBUG zuul.GerritConnection.io: 003fbfd268f1bcd148b7a539b9e9c62f4d9734ba1612 refs/heads/master 2026-06-12 00:23:55,191 DEBUG zuul.GerritConnection.io: 003e0ce5dfc92c83ac5e3676e9201e97df08cac1dff2 refs/meta/config 2026-06-12 00:23:55,191 DEBUG zuul.GerritConnection.io: 0000 2026-06-12 00:23:55,191 DEBUG zuul.GerritConnection: SSH exit status: 0 2026-06-12 00:23:55,192 DEBUG zuul.GerritConnection: Fetched 1 branches for demo-tenant-config 2026-06-12 00:23:55,192 INFO zuul.GerritConnection: Got branches for demo-tenant-config 2026-06-12 00:23:55,210 ERROR zuul.BranchCacheNew.gerrit: Exception loading ZKObject at /zuul/cache/connection/gerrit/project/data/demo-project 2026-06-12 00:23:55,213 ERROR zuul.BranchCacheNew.gerrit: Exception loading ZKObject at /zuul/cache/connection/gerrit/project/data/demo-tenant-config 2026-06-12 00:23:55,214 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-12 00:23:55,220 INFO zuul.GerritConnection: Got default branch for demo-project: master 2026-06-12 00:23:55,224 INFO zuul.GerritConnection: Got default branch for demo-tenant-config: master 2026-06-12 00:23:55,326 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-12 00:23:55,327 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-12 00:23:55,340 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-12 00:23:55,453 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-12 00:23:55,454 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-12 00:23:55,470 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-12 00:23:55,582 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-12 00:23:55,583 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-12 00:23:55,597 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-12 00:23:55,706 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-12 00:23:55,707 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-12 00:23:55,721 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-12 00:23:55,839 DEBUG zuul.MergeClient: Submitting job 21eb3f2fbd1c492b96213c51d9bedaec with data {'connection': 'gerrit', 'project': 'demo-tenant-config', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']} 2026-06-12 00:23:55,840 DEBUG zuul.MergeClient: Submitting job 1c9f575a1a1740d48ec1df6a737623de with data {'connection': 'gerrit', 'project': 'demo-project', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']} 2026-06-12 00:23:55,847 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper 2026-06-12 00:23:55,849 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper 2026-06-12 00:23:55,850 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-12 00:23:55,852 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-12 00:23:55,897 DEBUG zuul.TenantParser: Submitting cat job for gerrit demo-tenant-config master 2026-06-12 00:23:55,898 DEBUG zuul.TenantParser: Submitting cat job for gerrit demo-project master 2026-06-12 00:23:55,899 DEBUG zuul.TenantParser: Waiting for cat job 2026-06-12 00:23:55,908 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-12 00:23:56,033 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-12 00:23:56,034 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-12 00:23:56,101 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-12 00:23:56,212 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-12 00:23:56,213 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-12 00:23:56,227 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-12 00:23:56,338 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-12 00:23:56,339 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-12 00:23:56,353 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-12 00:23:56,499 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-12 00:23:56,500 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-12 00:23:56,513 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-12 00:23:56,627 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-12 00:23:56,628 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-12 00:23:56,700 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-12 00:23:56,810 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-12 00:23:56,811 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-12 00:23:56,823 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-12 00:23:56,937 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-12 00:23:56,938 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-12 00:23:57,011 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-12 00:23:57,132 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-12 00:23:57,133 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-12 00:23:57,153 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-12 00:23:57,265 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-12 00:23:57,266 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-12 00:23:57,278 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-12 00:23:57,367 DEBUG zuul.TenantParser: Cat job got files dict_keys(['.zuul.yaml', 'zuul.d/gerrit-base-jobs.yaml', 'zuul.d/gerrit-pipeline.yaml', 'zuul.d/gerrit-project-pipeline.yaml', 'zuul.yaml']) 2026-06-12 00:23:57,367 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-base-jobs.yaml@master 2026-06-12 00:23:57,368 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-pipeline.yaml@master 2026-06-12 00:23:57,373 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-project-pipeline.yaml@master 2026-06-12 00:23:57,406 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-12 00:23:57,408 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-12 00:23:57,429 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-12 00:23:57,454 DEBUG zuul.TenantParser: Waiting for cat job 2026-06-12 00:23:57,540 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-12 00:23:57,541 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-12 00:23:57,553 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-12 00:23:57,672 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-12 00:23:57,673 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-12 00:23:57,687 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-12 00:23:57,726 DEBUG zuul.TenantParser: Cat job got files dict_keys(['.zuul.d/jobs.yaml', '.zuul.d/project.yaml', '.zuul.yaml', 'zuul.yaml']) 2026-06-12 00:23:57,726 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/jobs.yaml@master 2026-06-12 00:23:57,728 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/project.yaml@master 2026-06-12 00:23:57,788 DEBUG zuul.TenantParser: Created layout id 95dc037beb0c474291326b313b590324 2026-06-12 00:23:57,795 DEBUG zuul.Pipeline.demo-tenant.check: Building relative_priority queues 2026-06-12 00:23:57,808 DEBUG zuul.Pipeline.demo-tenant.gate: Building shared change queues 2026-06-12 00:23:57,808 DEBUG zuul.Pipeline.demo-tenant.gate: Created queue: 2026-06-12 00:23:57,808 DEBUG zuul.Pipeline.demo-tenant.gate: Added project demo-tenant-config to default queue manager: 2026-06-12 00:23:57,808 DEBUG zuul.Pipeline.demo-tenant.gate: Created queue: 2026-06-12 00:23:57,809 DEBUG zuul.Pipeline.demo-tenant.gate: Added project demo-project to default queue manager: 2026-06-12 00:23:57,811 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-12 00:23:57,813 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-12 00:23:57,817 DEBUG zuul.Pipeline.demo-tenant.post: Building relative_priority queues 2026-06-12 00:23:57,829 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-12 00:23:57,830 DEBUG zuul.GerritConnection: Setting watched checkers to [] 2026-06-12 00:23:57,830 DEBUG zuul.GerritConnection: Setting watched event filters for demo-tenant to [, , , , , ] 2026-06-12 00:23:57,830 DEBUG zuul.GerritConnection: Setting watched event filters to {, , , , , } 2026-06-12 00:23:57,830 DEBUG zuul.TimerDriver: No jobs to remove for , 0 remain 2026-06-12 00:23:57,853 DEBUG zuul.Scheduler: Setting layout state last reconfigure ltime to 4679 2026-06-12 00:23:57,869 DEBUG zuul.Scheduler: Released demo-tenant write tenant lock (id: RECONFIG) 2026-06-12 00:23:57,896 INFO zuul.Scheduler: Reconfiguration complete (smart: False, tenants: None, duration: 8.892 seconds) 2026-06-12 00:23:57,897 DEBUG zuul.Scheduler: [e: 05f14b1f982b459086bd6aa7b3719906] Reconfiguration complete 2026-06-12 00:23:57,906 DEBUG zuul.Scheduler: Processing tenant management events in internal 2026-06-12 00:23:57,912 DEBUG zuul.Scheduler: Aquired internal read tenant lock 2026-06-12 00:23:57,918 DEBUG zuul.Scheduler: Processing tenant trigger events in internal 2026-06-12 00:23:57,933 DEBUG zuul.Scheduler: Processing pipeline check in tenant internal 2026-06-12 00:23:57,998 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-12 00:23:57,999 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-12 00:23:58,015 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-12 00:23:58,015 DEBUG zuul.Scheduler: Processing management event 2026-06-12 00:23:58,017 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-12 00:23:58,027 DEBUG zuul.Pipeline.internal.check: Starting queue processor: check 2026-06-12 00:23:58,027 DEBUG zuul.Pipeline.internal.check: Finished queue processor: check (changed: False) 2026-06-12 00:23:58,039 DEBUG zuul.Scheduler: Processing pipeline gate in tenant internal 2026-06-12 00:23:58,052 DEBUG zuul.Scheduler: Processing management event 2026-06-12 00:23:58,059 DEBUG zuul.Pipeline.internal.gate: Starting queue processor: gate 2026-06-12 00:23:58,059 DEBUG zuul.Pipeline.internal.gate: Finished queue processor: gate (changed: False) 2026-06-12 00:23:58,093 DEBUG zuul.Scheduler: Processing pipeline post in tenant internal 2026-06-12 00:23:58,104 DEBUG zuul.Scheduler: Processing management event 2026-06-12 00:23:58,110 DEBUG zuul.Pipeline.internal.post: Starting queue processor: post 2026-06-12 00:23:58,110 DEBUG zuul.Pipeline.internal.post: Finished queue processor: post (changed: False) 2026-06-12 00:23:58,117 DEBUG zuul.Scheduler: Released internal read tenant lock 2026-06-12 00:23:58,124 DEBUG zuul.Scheduler: Processing tenant management events in demo-tenant 2026-06-12 00:23:58,193 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock 2026-06-12 00:23:58,199 DEBUG zuul.Scheduler: Processing tenant trigger events in demo-tenant 2026-06-12 00:23:58,215 DEBUG zuul.Scheduler: Processing pipeline check in tenant demo-tenant 2026-06-12 00:23:58,227 DEBUG zuul.Scheduler: Processing management event 2026-06-12 00:23:58,297 DEBUG zuul.Pipeline.demo-tenant.check: Starting queue processor: check 2026-06-12 00:23:58,298 DEBUG zuul.Pipeline.demo-tenant.check: Finished queue processor: check (changed: False) 2026-06-12 00:23:58,310 DEBUG zuul.Scheduler: Processing pipeline gate in tenant demo-tenant 2026-06-12 00:23:58,322 DEBUG zuul.Scheduler: Processing management event 2026-06-12 00:23:58,329 DEBUG zuul.Pipeline.demo-tenant.gate: Starting queue processor: gate 2026-06-12 00:23:58,329 DEBUG zuul.Pipeline.demo-tenant.gate: Finished queue processor: gate (changed: False) 2026-06-12 00:23:58,339 DEBUG zuul.Scheduler: Processing pipeline post in tenant demo-tenant 2026-06-12 00:23:58,356 DEBUG zuul.Scheduler: Processing management event 2026-06-12 00:23:58,366 DEBUG zuul.Pipeline.demo-tenant.post: Starting queue processor: post 2026-06-12 00:23:58,367 DEBUG zuul.Pipeline.demo-tenant.post: Finished queue processor: post (changed: False) 2026-06-12 00:23:58,374 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock 2026-06-12 00:23:58,376 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-12 00:23:58,376 DEBUG zuul.Scheduler: Run handler awake 2026-06-12 00:23:58,392 DEBUG zuul.Scheduler: Processing tenant management events in internal 2026-06-12 00:23:58,399 DEBUG zuul.Scheduler: Aquired internal read tenant lock 2026-06-12 00:23:58,404 DEBUG zuul.Scheduler: Processing tenant trigger events in internal 2026-06-12 00:23:58,419 DEBUG zuul.Scheduler: Processing pipeline check in tenant internal 2026-06-12 00:23:58,421 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant internal 2026-06-12 00:23:58,427 DEBUG zuul.Scheduler: Processing pipeline gate in tenant internal 2026-06-12 00:23:58,430 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant internal 2026-06-12 00:23:58,436 DEBUG zuul.Scheduler: Processing pipeline post in tenant internal 2026-06-12 00:23:58,438 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant internal 2026-06-12 00:23:58,440 DEBUG zuul.Scheduler: Released internal read tenant lock 2026-06-12 00:23:58,447 DEBUG zuul.Scheduler: Processing tenant management events in demo-tenant 2026-06-12 00:23:58,454 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock 2026-06-12 00:23:58,460 DEBUG zuul.Scheduler: Processing tenant trigger events in demo-tenant 2026-06-12 00:23:58,500 DEBUG zuul.Scheduler: Processing pipeline check in tenant demo-tenant 2026-06-12 00:23:58,504 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant demo-tenant 2026-06-12 00:23:58,510 DEBUG zuul.Scheduler: Processing pipeline gate in tenant demo-tenant 2026-06-12 00:23:58,514 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant demo-tenant 2026-06-12 00:23:58,520 DEBUG zuul.Scheduler: Processing pipeline post in tenant demo-tenant 2026-06-12 00:23:58,524 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant demo-tenant 2026-06-12 00:23:58,526 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock 2026-06-12 00:23:58,528 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-12 00:23:59,838 DEBUG zuul.Scheduler: Starting merge request cleanup 2026-06-12 00:23:59,838 DEBUG zuul.Scheduler: Finished merge request cleanup 2026-06-12 00:24:02,255 DEBUG zuul.Scheduler: Starting build request cleanup 2026-06-12 00:24:02,255 DEBUG zuul.Scheduler: Finished build request cleanup 2026-06-12 00:24:05,132 INFO zuul.ComponentRegistry: Noticed new web component zuul-web-694698b5f-7khmp0000000006 2026-06-12 00:24:05,133 DEBUG zuul.ComponentRegistry: Registry got event None for web zuul-web-694698b5f-7khmp0000000006 2026-06-12 00:24:05,133 INFO zuul.ComponentRegistry: Component web zuul-web-694698b5f-7khmp0000000006 updated: {'hostname': 'zuul-web-694698b5f-7khmp', 'kind': 'web', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-12 00:24:05,133 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-12 00:24:05,334 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-694698b5f-7khmp0000000006 2026-06-12 00:24:05,334 INFO zuul.ComponentRegistry: Component web zuul-web-694698b5f-7khmp0000000006 updated: {'hostname': 'zuul-web-694698b5f-7khmp', 'kind': 'web', 'model_api': 37, 'state': 'initializing', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-12 00:24:05,335 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-12 00:24:09,024 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-694698b5f-7khmp0000000006 2026-06-12 00:24:09,025 INFO zuul.ComponentRegistry: Component web zuul-web-694698b5f-7khmp0000000006 updated: {'hostname': 'zuul-web-694698b5f-7khmp', 'kind': 'web', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-12 00:24:09,025 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-12 00:25:00,902 DEBUG zuul.Scheduler: Starting merge request cleanup 2026-06-12 00:25:00,902 DEBUG zuul.Scheduler: Finished merge request cleanup 2026-06-12 00:25:06,507 DEBUG zuul.Scheduler: Starting build request cleanup 2026-06-12 00:25:06,507 DEBUG zuul.Scheduler: Finished build request cleanup