2026-06-11 13:47:46,792 DEBUG zuul.Scheduler: Configured logging: 14.1.1.dev1 2026-06-11 13:47:46,792 DEBUG zuul.TimerDriver: Starting apscheduler 2026-06-11 13:47:46,792 INFO apscheduler.scheduler: Scheduler started 2026-06-11 13:47:46,793 DEBUG apscheduler.scheduler: Looking for jobs to run 2026-06-11 13:47:46,793 DEBUG apscheduler.scheduler: No jobs; waiting until a job is added 2026-06-11 13:47:46,793 DEBUG zuul.BubblewrapDriver: Initializing bubblewrap with oom_score_adj starting: 995, final: 1000 2026-06-11 13:47:46,795 INFO zuul.SQLConnection: Initializing SQL connection database (prefix: ) 2026-06-11 13:47:46,968 DEBUG zuul.zk.base.ZooKeeperClient: ZooKeeper connection (session: 0x100000f4822000f): CONNECTED 2026-06-11 13:47:46,978 INFO zuul.Component: Registering component in ZooKeeper /zuul/components/scheduler/zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local 2026-06-11 13:47:46,983 INFO zuul.ComponentRegistry: Noticed new scheduler component zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-11 13:47:46,984 DEBUG zuul.ComponentRegistry: Registry got event None for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-11 13:47:46,984 INFO zuul.ComponentRegistry: Component scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 updated: {'hostname': 'zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local', 'kind': 'scheduler', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-11 13:47:46,985 INFO zuul.ComponentRegistry: Noticed new executor component zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-11 13:47:46,986 DEBUG zuul.ComponentRegistry: Registry got event None for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-11 13:47:46,986 INFO zuul.ComponentRegistry: Component executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 updated: {'accepting_work': True, 'allow_unzoned': True, 'hostname': 'zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local', 'kind': 'executor', 'model_api': 37, 'process_merge_jobs': True, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8', 'zone': None} 2026-06-11 13:47:46,988 INFO zuul.ComponentRegistry: Noticed new merger component zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003 2026-06-11 13:47:46,988 DEBUG zuul.ComponentRegistry: Registry got event None for merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003 2026-06-11 13:47:46,988 INFO zuul.ComponentRegistry: Component merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003 updated: {'hostname': 'zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local', 'kind': 'merger', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-11 13:47:46,992 INFO zuul.ComponentRegistry: Noticed new web component zuul-web-6c6fd75fdc-5jpkm0000000005 2026-06-11 13:47:46,992 DEBUG zuul.ComponentRegistry: Registry got event None for web zuul-web-6c6fd75fdc-5jpkm0000000005 2026-06-11 13:47:46,992 INFO zuul.ComponentRegistry: Component web zuul-web-6c6fd75fdc-5jpkm0000000005 updated: {'hostname': 'zuul-web-6c6fd75fdc-5jpkm', 'kind': 'web', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-11 13:47:46,994 INFO zuul.ComponentRegistry: System minimum data model version 37; this component 37 2026-06-11 13:47:47,071 DEBUG zuul.zk.ZooKeeper: Initialize cache at /keystorage-oidc 2026-06-11 13:47:47,073 DEBUG zuul.zk.ZooKeeper: Cache at /keystorage-oidc is ready 2026-06-11 13:47:47,078 DEBUG zuul.ExecutorQueue: Creating executor queue at root /zuul/executor/unzoned 2026-06-11 13:47:47,084 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/executor/unzoned 2026-06-11 13:47:47,156 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/executor/unzoned is ready 2026-06-11 13:47:47,161 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/merger 2026-06-11 13:47:47,172 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/merger is ready 2026-06-11 13:47:47,177 DEBUG zuul.nodepool: Running nodepool watcher election 2026-06-11 13:47:47,178 DEBUG zuul.TimerDriver: Starting timer election loop 2026-06-11 13:47:47,182 INFO zuul.TimerDriver: Running timer election 2026-06-11 13:47:47,184 INFO zuul.nodepool: Watching nodepool requests 2026-06-11 13:47:47,187 INFO zuul.TimerDriver: Won timer election 2026-06-11 13:47:47,203 DEBUG zuul.SQLConnection: Current migration revision: 21d30f0bffef 2026-06-11 13:47:47,265 DEBUG zuul.GerritConnection: Starting Gerrit Connection/Watchers 2026-06-11 13:47:47,266 DEBUG zuul.GerritConnection: Creating Zookeeper branch cache 2026-06-11 13:47:47,274 INFO zuul.GerritConnection: Creating Zookeeper event queue 2026-06-11 13:47:47,277 DEBUG zuul.GerritConnection: Creating Zookeeper change cache 2026-06-11 13:47:47,279 INFO zuul.GerritConnection: Starting SSH event stream client 2026-06-11 13:47:47,280 INFO zuul.GerritConnection: gerrit: Gerrit Poller is disabled because no HTTP authentication is defined 2026-06-11 13:47:47,280 DEBUG zuul.connection.git: Creating Zookeeper change cache 2026-06-11 13:47:47,285 DEBUG zuul.connection.git: Starting Git Watcher 2026-06-11 13:47:47,285 DEBUG zuul.connection.git: Creating Zookeeper change cache 2026-06-11 13:47:47,287 DEBUG paramiko.transport: starting thread (client mode): 0x291450 2026-06-11 13:47:47,287 DEBUG paramiko.transport: Local version/idstring: SSH-2.0-paramiko_4.0.0 2026-06-11 13:47:47,288 DEBUG paramiko.transport: Remote version/idstring: SSH-2.0-GerritCodeReview_3.6.4 (APACHE-SSHD-2.9.2) 2026-06-11 13:47:47,288 INFO paramiko.transport: Connected (version 2.0, client GerritCodeReview_3.6.4) 2026-06-11 13:47:47,289 DEBUG paramiko.transport: === Key exchange possibilities === 2026-06-11 13:47:47,289 DEBUG paramiko.transport: kex algos: curve25519-sha256, curve25519-sha256@libssh.org, curve448-sha512, ecdh-sha2-nistp521, ecdh-sha2-nistp384, ecdh-sha2-nistp256, diffie-hellman-group-exchange-sha256, diffie-hellman-group18-sha512, diffie-hellman-group17-sha512, diffie-hellman-group16-sha512, diffie-hellman-group15-sha512, diffie-hellman-group14-sha256, ext-info-s 2026-06-11 13:47:47,289 DEBUG paramiko.transport: server key: ecdsa-sha2-nistp256, ecdsa-sha2-nistp384, ecdsa-sha2-nistp521, ssh-ed25519, rsa-sha2-512, rsa-sha2-256, ssh-rsa 2026-06-11 13:47:47,289 DEBUG paramiko.transport: client encrypt: chacha20-poly1305@openssh.com, aes128-ctr, aes192-ctr, aes256-ctr, aes128-gcm@openssh.com, aes256-gcm@openssh.com, aes128-cbc, aes192-cbc, aes256-cbc 2026-06-11 13:47:47,289 DEBUG paramiko.transport: server encrypt: chacha20-poly1305@openssh.com, aes128-ctr, aes192-ctr, aes256-ctr, aes128-gcm@openssh.com, aes256-gcm@openssh.com, aes128-cbc, aes192-cbc, aes256-cbc 2026-06-11 13:47:47,289 DEBUG paramiko.transport: client mac: hmac-sha2-256-etm@openssh.com, hmac-sha2-512-etm@openssh.com, hmac-sha1-etm@openssh.com, hmac-sha2-256, hmac-sha2-512, hmac-sha1 2026-06-11 13:47:47,289 DEBUG paramiko.transport: server mac: hmac-sha2-256-etm@openssh.com, hmac-sha2-512-etm@openssh.com, hmac-sha1-etm@openssh.com, hmac-sha2-256, hmac-sha2-512, hmac-sha1 2026-06-11 13:47:47,289 DEBUG paramiko.transport: client compress: none 2026-06-11 13:47:47,289 DEBUG paramiko.transport: server compress: none 2026-06-11 13:47:47,290 DEBUG paramiko.transport: client lang: 2026-06-11 13:47:47,290 DEBUG paramiko.transport: server lang: 2026-06-11 13:47:47,290 DEBUG paramiko.transport: kex follows: False 2026-06-11 13:47:47,290 DEBUG paramiko.transport: === Key exchange agreements === 2026-06-11 13:47:47,290 DEBUG paramiko.transport: Kex: curve25519-sha256@libssh.org 2026-06-11 13:47:47,290 DEBUG paramiko.transport: HostKey: ssh-ed25519 2026-06-11 13:47:47,290 DEBUG paramiko.transport: Cipher: aes128-ctr 2026-06-11 13:47:47,290 DEBUG paramiko.transport: MAC: hmac-sha2-256 2026-06-11 13:47:47,290 DEBUG paramiko.transport: Compression: none 2026-06-11 13:47:47,291 DEBUG paramiko.transport: === End of kex handshake === 2026-06-11 13:47:47,292 DEBUG zuul.connection.git.watcher: Walk through projects refs for connection: git-server 2026-06-11 13:47:47,293 DEBUG zuul.connection.git: Starting Git Watcher 2026-06-11 13:47:47,293 INFO zuul.Scheduler: Starting scheduler 2026-06-11 13:47:47,294 DEBUG zuul.Scheduler: Statsd enabled 2026-06-11 13:47:47,294 DEBUG zuul.Scheduler: Starting command processor 2026-06-11 13:47:47,294 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-11 13:47:47,295 DEBUG zuul.Scheduler: Run handler awake 2026-06-11 13:47:47,296 DEBUG zuul.Scheduler: Running stats election 2026-06-11 13:47:47,296 INFO apscheduler.scheduler: Scheduler started 2026-06-11 13:47:47,296 DEBUG apscheduler.scheduler: Looking for jobs to run 2026-06-11 13:47:47,297 DEBUG apscheduler.scheduler: No jobs; waiting until a job is added 2026-06-11 13:47:47,298 DEBUG zuul.connection.git.watcher: Walk through projects refs for connection: opendev.org 2026-06-11 13:47:47,302 INFO zuul.Scheduler: Priming scheduler config 2026-06-11 13:47:47,303 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-11 13:47:47,303 INFO zuul.ComponentRegistry: Component scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 updated: {'hostname': 'zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local', 'kind': 'scheduler', 'model_api': 37, 'state': 'initializing', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-11 13:47:47,304 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is None 2026-06-11 13:47:47,306 DEBUG zuul.Scheduler: Won stats election 2026-06-11 13:47:47,309 INFO zuul.Scheduler: Using system config from Zookeeper 2026-06-11 13:47:47,312 DEBUG zuul.Scheduler: Updating system config 2026-06-11 13:47:47,601 DEBUG paramiko.transport: kex engine KexCurve25519 specified hash_algo 2026-06-11 13:47:47,601 DEBUG paramiko.transport: Switch to new keys ... 2026-06-11 13:47:47,602 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'60c49fc3e99ecffa8d6c43c3e7f29b84' warnings.warn( 2026-06-11 13:47:48,959 DEBUG paramiko.transport: Trying discovered key b'484be8384d249684071beb82f892e66f' in /var/lib/zuul-ssh/..data/priv 2026-06-11 13:47:48,963 DEBUG paramiko.transport: userauth is OK 2026-06-11 13:47:48,964 DEBUG paramiko.transport: Finalizing pubkey algorithm for key of type 'ssh-rsa' 2026-06-11 13:47:48,964 DEBUG paramiko.transport: Our pubkey algorithm list: ['rsa-sha2-512', 'rsa-sha2-256', 'ssh-rsa'] 2026-06-11 13:47:48,964 DEBUG paramiko.transport: Server-side algorithm list: ['ecdsa-sha2-nistp256-cert-v01@openssh.com', 'ecdsa-sha2-nistp384-cert-v01@openssh.com', 'ecdsa-sha2-nistp521-cert-v01@openssh.com', 'ssh-ed25519-cert-v01@openssh.com', 'rsa-sha2-512-cert-v01@openssh.com', 'rsa-sha2-256-cert-v01@openssh.com', 'ecdsa-sha2-nistp256', 'ecdsa-sha2-nistp384', 'ecdsa-sha2-nistp521', 'ssh-ed25519', 'sk-ecdsa-sha2-nistp256@openssh.com', 'sk-ssh-ed25519@openssh.com', 'rsa-sha2-512', 'rsa-sha2-256', 'ssh-rsa'] 2026-06-11 13:47:48,964 DEBUG paramiko.transport: Agreed upon 'rsa-sha2-512' pubkey algorithm 2026-06-11 13:47:49,163 INFO paramiko.transport: Authentication (publickey) successful! 2026-06-11 13:47:49,163 DEBUG paramiko.transport: [chan 0] Max packet in: 32768 bytes 2026-06-11 13:47:49,300 DEBUG paramiko.transport: [chan 0] Max packet out: 32768 bytes 2026-06-11 13:47:49,300 DEBUG paramiko.transport: Secsh channel 0 opened. 2026-06-11 13:47:49,302 DEBUG paramiko.transport: [chan 0] Sesch channel 0 request ok 2026-06-11 13:47:49,303 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-11 13:47:49,363 DEBUG zuul.Scheduler: Wait for internal read tenant lock 2026-06-11 13:47:49,368 DEBUG zuul.Scheduler: Aquired internal read tenant lock 2026-06-11 13:47:49,587 INFO zuul.BranchCache.gerrit: Waiting for branch cache upgrade lock 2026-06-11 13:47:49,754 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/cache/connection/gerrit/project 2026-06-11 13:47:49,766 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/cache/connection/gerrit/project is ready 2026-06-11 13:47:49,766 INFO zuul.BranchCache.gerrit: Cache already upgraded 2026-06-11 13:47:54,371 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-11 13:47:54,372 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-11 13:47:54,372 DEBUG zuul.TenantParser: Using files from cache for project gerrit-sshd.sf/config @master: [] 2026-06-11 13:47:54,385 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/config-project.yaml@master 2026-06-11 13:47:54,393 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/container-jobs.yaml@master 2026-06-11 13:47:54,403 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/jobs-base.yaml@master 2026-06-11 13:47:54,406 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/dib-jobs.yaml@master 2026-06-11 13:47:54,454 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/k8s-secret.yaml@master 2026-06-11 13:47:54,456 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/docker-jobs.yaml@master 2026-06-11 13:47:54,463 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/sf-logserver-secret.yaml@master 2026-06-11 13:47:54,464 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/general-jobs.yaml@master 2026-06-11 13:47:54,475 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/go-jobs.yaml@master 2026-06-11 13:47:54,480 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/haskell-jobs.yaml@master 2026-06-11 13:47:54,486 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/helm-jobs.yaml@master 2026-06-11 13:47:54,491 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/js-jobs.yaml@master 2026-06-11 13:47:54,556 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/nim-jobs.yaml@master 2026-06-11 13:47:54,560 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/packer-jobs.yaml@master 2026-06-11 13:47:54,565 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/python-jobs.yaml@master 2026-06-11 13:47:54,584 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/system-jobs.yaml@master 2026-06-11 13:47:54,588 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/terraform-jobs.yaml@master 2026-06-11 13:47:54,597 DEBUG zuul.TenantParser: Created layout id 805881b388a44cd9977029bf0702c78c 2026-06-11 13:47:54,665 DEBUG zuul.Pipeline.internal.check: Building relative_priority queues 2026-06-11 13:47:54,674 DEBUG zuul.Pipeline.internal.gate: Building shared change queues 2026-06-11 13:47:54,674 DEBUG zuul.Pipeline.internal.gate: Created queue: 2026-06-11 13:47:54,675 DEBUG zuul.Pipeline.internal.gate: Added project config to default queue manager: 2026-06-11 13:47:54,683 DEBUG zuul.Pipeline.internal.post: Building relative_priority queues 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: 2 errors detected during internal tenant configuration loading 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: Zuul encountered a syntax error while parsing its 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: configuration in the repo system-config on branch master. The 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: problem was: 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: Decryption failed 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: The problem appears in the "base" job stanza: 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: job: 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: name: base 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: description: The base job. 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: parent: null 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: post-run: 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: - playbooks/base/post.yaml 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: pre-run: 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: - playbooks/base/pre.yaml 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: roles: 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: ... 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: in "system-config/zuul.d/jobs-base.yaml@master", line 5 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: Zuul encountered a syntax error while parsing its 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: configuration in the repo system-config on branch master. The 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: problem was: 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: Decryption failed 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: The problem appears in the "config-update" job stanza: 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: job: 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: name: config-update 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: description: Deploy config repo update. 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: parent: base 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: secrets: 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: - k8s_config 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: final: true 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: run: 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: - playbooks/config/update.yaml 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: ... 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: 2026-06-11 13:47:54,693 WARNING zuul.ConfigLoader: in "system-config/zuul.d/jobs-base.yaml@master", line 26 2026-06-11 13:47:54,693 DEBUG zuul.GerritConnection: Setting watched checkers to [] 2026-06-11 13:47:54,694 DEBUG zuul.GerritConnection: Setting watched event filters for internal to [, , , , , ] 2026-06-11 13:47:54,694 DEBUG zuul.GerritConnection: Setting watched event filters to {, , , , , } 2026-06-11 13:47:54,694 DEBUG zuul.TimerDriver: No jobs to remove for , 0 remain 2026-06-11 13:47:54,694 DEBUG zuul.Scheduler: Released internal read tenant lock 2026-06-11 13:47:54,699 DEBUG zuul.Scheduler: Wait for demo-tenant read tenant lock 2026-06-11 13:47:54,704 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock 2026-06-11 13:47:59,046 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-11 13:47:59,046 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-11 13:47:59,057 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-base-jobs.yaml@master 2026-06-11 13:47:59,062 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/jobs.yaml@master 2026-06-11 13:47:59,065 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-pipeline.yaml@master 2026-06-11 13:47:59,074 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/project.yaml@master 2026-06-11 13:47:59,076 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-project-pipeline.yaml@master 2026-06-11 13:47:59,085 DEBUG zuul.TenantParser: Created layout id 914e81a4efb84c2599a52c17da4be525 2026-06-11 13:47:59,093 DEBUG zuul.Pipeline.demo-tenant.check: Building relative_priority queues 2026-06-11 13:47:59,103 DEBUG zuul.Pipeline.demo-tenant.gate: Building shared change queues 2026-06-11 13:47:59,104 DEBUG zuul.Pipeline.demo-tenant.gate: Created queue: 2026-06-11 13:47:59,104 DEBUG zuul.Pipeline.demo-tenant.gate: Added project demo-tenant-config to default queue manager: 2026-06-11 13:47:59,104 DEBUG zuul.Pipeline.demo-tenant.gate: Created queue: 2026-06-11 13:47:59,104 DEBUG zuul.Pipeline.demo-tenant.gate: Added project demo-project to default queue manager: 2026-06-11 13:47:59,112 DEBUG zuul.Pipeline.demo-tenant.post: Building relative_priority queues 2026-06-11 13:47:59,121 DEBUG zuul.GerritConnection: Setting watched checkers to [] 2026-06-11 13:47:59,121 DEBUG zuul.GerritConnection: Setting watched event filters for demo-tenant to [, , , , , ] 2026-06-11 13:47:59,121 DEBUG zuul.GerritConnection: Setting watched event filters to {, , , , , } 2026-06-11 13:47:59,122 DEBUG zuul.TimerDriver: No jobs to remove for , 0 remain 2026-06-11 13:47:59,122 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock 2026-06-11 13:47:59,126 INFO zuul.Scheduler: Config priming complete (duration: 11.824 seconds) 2026-06-11 13:47:59,127 DEBUG zuul.Scheduler: Run handler awake 2026-06-11 13:47:59,157 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is None 2026-06-11 13:47:59,157 DEBUG zuul.RendezvousElection: Did not win election for /zuul/events/connection/gerrit/election 2026-06-11 13:47:59,157 DEBUG zuul.RendezvousElection: Did not win election for /zuul/events/connection/gerrit/election 2026-06-11 13:47:59,157 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-11 13:47:59,157 INFO zuul.ComponentRegistry: Component scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 updated: {'hostname': 'zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local', 'kind': 'scheduler', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-11 13:47:59,158 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-11 13:47:59,158 DEBUG zuul.RendezvousElection: Acquiring lock for /zuul/events/connection/gerrit/election 2026-06-11 13:47:59,167 INFO zuul.RendezvousElection: Won election for /zuul/events/connection/gerrit/election 2026-06-11 13:47:59,174 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 13:47:59,175 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 13:47:59,176 DEBUG zuul.Scheduler: Processing tenant management events in demo-tenant 2026-06-11 13:47:59,256 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock 2026-06-11 13:47:59,261 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-11 13:47:59,262 DEBUG zuul.Scheduler: Starting semaphore cleanup 2026-06-11 13:47:59,264 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-11 13:47:59,272 DEBUG zuul.Scheduler: Processing tenant trigger events in demo-tenant 2026-06-11 13:47:59,280 DEBUG zuul.Scheduler: Starting build request cleanup 2026-06-11 13:47:59,280 DEBUG zuul.Scheduler: Finished build request cleanup 2026-06-11 13:47:59,287 DEBUG zuul.Scheduler: Starting node request cleanup 2026-06-11 13:47:59,309 DEBUG zuul.Scheduler: Processing pipeline check in tenant demo-tenant 2026-06-11 13:47:59,325 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant demo-tenant 2026-06-11 13:47:59,365 DEBUG zuul.Scheduler: Processing pipeline gate in tenant demo-tenant 2026-06-11 13:47:59,382 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant demo-tenant 2026-06-11 13:47:59,392 DEBUG zuul.Scheduler: Processing pipeline post in tenant demo-tenant 2026-06-11 13:47:59,407 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant demo-tenant 2026-06-11 13:47:59,409 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock 2026-06-11 13:47:59,455 DEBUG zuul.Scheduler: Processing tenant management events in internal 2026-06-11 13:47:59,461 INFO apscheduler.scheduler: Added job "Scheduler._runSemaphoreCleanup" to job store "default" 2026-06-11 13:47:59,461 DEBUG apscheduler.scheduler: Looking for jobs to run 2026-06-11 13:47:59,462 DEBUG apscheduler.scheduler: Next wakeup is due at 2026-06-11 14:47:49.194038+00:00 (in 3589.732037 seconds) 2026-06-11 13:47:59,462 INFO apscheduler.scheduler: Added job "Scheduler._runBuildRequestCleanup" to job store "default" 2026-06-11 13:47:59,462 INFO apscheduler.scheduler: Added job "Scheduler._runMergeRequestCleanup" to job store "default" 2026-06-11 13:47:59,462 DEBUG apscheduler.scheduler: Looking for jobs to run 2026-06-11 13:47:59,463 INFO apscheduler.scheduler: Added job "Scheduler._runConnectionCleanup" to job store "default" 2026-06-11 13:47:59,463 DEBUG apscheduler.scheduler: Next wakeup is due at 2026-06-11 13:48:49.226178+00:00 (in 49.762455 seconds) 2026-06-11 13:47:59,463 DEBUG apscheduler.scheduler: Looking for jobs to run 2026-06-11 13:47:59,464 INFO apscheduler.scheduler: Added job "Scheduler._runGeneralCleanup" to job store "default" 2026-06-11 13:47:59,464 DEBUG apscheduler.scheduler: Next wakeup is due at 2026-06-11 13:48:49.226178+00:00 (in 49.761937 seconds) 2026-06-11 13:47:59,464 DEBUG apscheduler.scheduler: Looking for jobs to run 2026-06-11 13:47:59,464 DEBUG apscheduler.scheduler: Next wakeup is due at 2026-06-11 13:48:49.226178+00:00 (in 49.761790 seconds) 2026-06-11 13:47:59,472 DEBUG zuul.Scheduler: Aquired internal read tenant lock 2026-06-11 13:47:59,480 DEBUG zuul.Scheduler: Processing tenant trigger events in internal 2026-06-11 13:47:59,504 DEBUG zuul.Scheduler: Processing pipeline check in tenant internal 2026-06-11 13:47:59,514 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant internal 2026-06-11 13:47:59,521 DEBUG zuul.Scheduler: Processing pipeline gate in tenant internal 2026-06-11 13:47:59,531 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant internal 2026-06-11 13:47:59,558 DEBUG zuul.Scheduler: Processing pipeline post in tenant internal 2026-06-11 13:47:59,566 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant internal 2026-06-11 13:47:59,568 DEBUG zuul.Scheduler: Released internal read tenant lock 2026-06-11 13:47:59,571 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-11 13:48:39,502 DEBUG zuul.CommandSocket: Accepted socket connection 2026-06-11 13:48:39,502 DEBUG zuul.CommandSocket: Received b'full-reconfigure' from socket 2026-06-11 13:48:39,554 DEBUG zuul.Scheduler: Reconfiguration triggered 2026-06-11 13:48:39,575 DEBUG zuul.Scheduler: Configured logging: 14.1.1.dev1 2026-06-11 13:48:39,575 DEBUG zuul.Scheduler: [e: 77f88123604d40d3bd6a2cd84427a2ae] Submitting reconfiguration event 2026-06-11 13:48:39,578 DEBUG zuul.Scheduler: [e: 77f88123604d40d3bd6a2cd84427a2ae] Waiting for reconfiguration 2026-06-11 13:48:39,578 DEBUG zuul.Scheduler: Run handler awake 2026-06-11 13:48:39,578 DEBUG zuul.Scheduler: Fetching reconfiguration event 2026-06-11 13:48:39,578 INFO zuul.Scheduler: Reconfiguration beginning (smart=False, tenants=None) 2026-06-11 13:48:39,654 INFO zuul.ConfigLoader: Loading configuration from /var/lib/zuul/main.yaml 2026-06-11 13:48:39,856 DEBUG zuul.Scheduler: Wait for internal write tenant lock (id: RECONFIG) 2026-06-11 13:48:39,861 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'60c49fc3e99ecffa8d6c43c3e7f29b84' warnings.warn( 2026-06-11 13:48:42,661 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-6c6fd75fdc-5jpkm0000000005 2026-06-11 13:48:42,662 INFO zuul.ComponentRegistry: Component web zuul-web-6c6fd75fdc-5jpkm0000000005 updated: {'hostname': 'zuul-web-6c6fd75fdc-5jpkm', 'kind': 'web', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-11 13:48:42,662 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-11 13:48:42,667 DEBUG zuul.GerritConnection: SSH command: 2026-06-11 13:48:42,667 DEBUG zuul.GerritConnection: git-upload-pack config 2026-06-11 13:48:42,719 DEBUG zuul.GerritConnection.io: SSH received stdout: 2026-06-11 13:48:42,719 DEBUG zuul.GerritConnection.io: 00e993573c01d3eea0939e600f2a80f5e7f0a8e8c43b 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-11 13:48:42,719 DEBUG zuul.GerritConnection.io: 003f93573c01d3eea0939e600f2a80f5e7f0a8e8c43b refs/heads/master 2026-06-11 13:48:42,719 DEBUG zuul.GerritConnection.io: 003e46e3ca3a445680dba82bc6bda3df3061400e02d5 refs/meta/config 2026-06-11 13:48:42,719 DEBUG zuul.GerritConnection.io: 0000 2026-06-11 13:48:42,720 DEBUG zuul.GerritConnection: SSH exit status: 0 2026-06-11 13:48:42,720 DEBUG zuul.GerritConnection: Fetched 1 branches for config 2026-06-11 13:48:42,720 INFO zuul.GerritConnection: Got branches for config 2026-06-11 13:48:42,731 ERROR zuul.BranchCacheNew.gerrit: Exception loading ZKObject at /zuul/cache/connection/gerrit/project/data/config 2026-06-11 13:48:42,739 INFO zuul.GerritConnection: Got default branch for config: master 2026-06-11 13:48:42,990 DEBUG zuul.ComponentRegistry: Registry got event DELETED for web zuul-web-6c6fd75fdc-5jpkm0000000005 2026-06-11 13:48:42,990 INFO zuul.ComponentRegistry: Noticed web component zuul-web-6c6fd75fdc-5jpkm0000000005 disappeared 2026-06-11 13:48:42,990 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-11 13:48:43,097 DEBUG zuul.MergeClient: Submitting job f0ff254bdc204251a49de836438ec562 with data {'connection': 'gerrit', 'project': 'config', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']} 2026-06-11 13:48:43,156 DEBUG zuul.MergeClient: Submitting job ca0423d07eb84d9480360df3c9d011be with data {'connection': 'opendev.org', 'project': 'zuul/zuul-jobs', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']} 2026-06-11 13:48:43,157 DEBUG zuul.MergeClient: Submitting job 2cd4ddd4e6a044c4a62444efe8514456 with data {'connection': 'git-server', 'project': 'system-config', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']} 2026-06-11 13:48:43,166 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper 2026-06-11 13:48:43,166 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper 2026-06-11 13:48:43,171 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper 2026-06-11 13:48:43,368 DEBUG zuul.TenantParser: Submitting cat job for opendev.org zuul/zuul-jobs master 2026-06-11 13:48:43,372 DEBUG zuul.TenantParser: Submitting cat job for gerrit config master 2026-06-11 13:48:43,377 DEBUG zuul.TenantParser: Submitting cat job for git-server system-config master 2026-06-11 13:48:43,377 DEBUG zuul.TenantParser: Waiting for cat job 2026-06-11 13:48:44,003 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-11 13:48:44,003 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/container-jobs.yaml@master 2026-06-11 13:48:44,006 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/dib-jobs.yaml@master 2026-06-11 13:48:44,006 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/docker-jobs.yaml@master 2026-06-11 13:48:44,008 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/general-jobs.yaml@master 2026-06-11 13:48:44,013 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/go-jobs.yaml@master 2026-06-11 13:48:44,014 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/haskell-jobs.yaml@master 2026-06-11 13:48:44,017 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/helm-jobs.yaml@master 2026-06-11 13:48:44,018 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/js-jobs.yaml@master 2026-06-11 13:48:44,023 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/nim-jobs.yaml@master 2026-06-11 13:48:44,025 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/packer-jobs.yaml@master 2026-06-11 13:48:44,026 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/python-jobs.yaml@master 2026-06-11 13:48:44,056 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/system-jobs.yaml@master 2026-06-11 13:48:44,057 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/terraform-jobs.yaml@master 2026-06-11 13:48:44,534 DEBUG zuul.TenantParser: Waiting for cat job 2026-06-11 13:48:44,855 DEBUG zuul.TenantParser: Cat job got files dict_keys(['.zuul.yaml', 'zuul.yaml']) 2026-06-11 13:48:44,868 DEBUG zuul.TenantParser: Waiting for cat job 2026-06-11 13:48:44,884 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-11 13:48:44,884 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/config-project.yaml@master 2026-06-11 13:48:44,890 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/jobs-base.yaml@master 2026-06-11 13:48:44,892 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/k8s-secret.yaml@master 2026-06-11 13:48:44,893 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/sf-logserver-secret.yaml@master 2026-06-11 13:48:45,026 DEBUG zuul.TenantParser: Created layout id 3915c95d98864fb2b3c6229da989789d 2026-06-11 13:48:45,169 DEBUG zuul.Pipeline.internal.check: Building relative_priority queues 2026-06-11 13:48:45,176 DEBUG zuul.Pipeline.internal.gate: Building shared change queues 2026-06-11 13:48:45,177 DEBUG zuul.Pipeline.internal.gate: Created queue: 2026-06-11 13:48:45,177 DEBUG zuul.Pipeline.internal.gate: Added project config to default queue manager: 2026-06-11 13:48:45,185 DEBUG zuul.Pipeline.internal.post: Building relative_priority queues 2026-06-11 13:48:45,197 DEBUG zuul.GerritConnection: Setting watched checkers to [] 2026-06-11 13:48:45,197 DEBUG zuul.GerritConnection: Setting watched event filters for internal to [, , , , , ] 2026-06-11 13:48:45,198 DEBUG zuul.GerritConnection: Setting watched event filters to {, , , , , } 2026-06-11 13:48:45,198 DEBUG zuul.TimerDriver: No jobs to remove for , 0 remain 2026-06-11 13:48:45,229 DEBUG zuul.Scheduler: Setting layout state last reconfigure ltime to 5735 2026-06-11 13:48:45,274 DEBUG zuul.Scheduler: Released internal write tenant lock (id: RECONFIG) 2026-06-11 13:48:45,363 DEBUG zuul.Scheduler: Wait for demo-tenant write tenant lock (id: RECONFIG) 2026-06-11 13:48:45,367 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 13:48:45,368 DEBUG zuul.Scheduler: Aquired demo-tenant write tenant lock (id: RECONFIG) 2026-06-11 13:48:45,384 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 13:48:45,384 DEBUG zuul.GerritConnection: SSH command: 2026-06-11 13:48:45,384 DEBUG zuul.GerritConnection: git-upload-pack demo-tenant-config 2026-06-11 13:48:45,386 DEBUG zuul.GerritConnection: SSH command: 2026-06-11 13:48:45,386 DEBUG zuul.GerritConnection: git-upload-pack demo-project 2026-06-11 13:48:45,672 DEBUG zuul.GerritConnection.io: SSH received stdout: 2026-06-11 13:48:45,672 DEBUG zuul.GerritConnection.io: 00e9f488e9322379a1a22048e66cfcd389ad9887632d 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-11 13:48:45,672 DEBUG zuul.GerritConnection.io: 003ff488e9322379a1a22048e66cfcd389ad9887632d refs/heads/master 2026-06-11 13:48:45,672 DEBUG zuul.GerritConnection.io: 003e2b21b73ef59171280552a0d7eacb411176a92077 refs/meta/config 2026-06-11 13:48:45,672 DEBUG zuul.GerritConnection.io: 0000 2026-06-11 13:48:45,697 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 13:48:45,713 DEBUG zuul.GerritConnection: SSH exit status: 0 2026-06-11 13:48:45,715 DEBUG zuul.GerritConnection: Fetched 1 branches for demo-tenant-config 2026-06-11 13:48:45,715 INFO zuul.GerritConnection: Got branches for demo-tenant-config 2026-06-11 13:48:45,715 DEBUG zuul.GerritConnection.io: SSH received stdout: 2026-06-11 13:48:45,715 DEBUG zuul.GerritConnection.io: 00e926098dd8f472b049ff66adaf4cbbb16f3207d7fa 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-11 13:48:45,715 DEBUG zuul.GerritConnection.io: 003f26098dd8f472b049ff66adaf4cbbb16f3207d7fa refs/heads/master 2026-06-11 13:48:45,715 DEBUG zuul.GerritConnection.io: 003ed46a332a638126bd6445ac7c0dc1d0cf74ecbb00 refs/meta/config 2026-06-11 13:48:45,715 DEBUG zuul.GerritConnection.io: 0000 2026-06-11 13:48:45,715 DEBUG zuul.GerritConnection: SSH exit status: 0 2026-06-11 13:48:45,716 DEBUG zuul.GerritConnection: Fetched 1 branches for demo-project 2026-06-11 13:48:45,716 INFO zuul.GerritConnection: Got branches for demo-project 2026-06-11 13:48:45,734 ERROR zuul.BranchCacheNew.gerrit: Exception loading ZKObject at /zuul/cache/connection/gerrit/project/data/demo-tenant-config 2026-06-11 13:48:45,734 ERROR zuul.BranchCacheNew.gerrit: Exception loading ZKObject at /zuul/cache/connection/gerrit/project/data/demo-project 2026-06-11 13:48:45,741 INFO zuul.GerritConnection: Got default branch for demo-tenant-config: master 2026-06-11 13:48:45,743 INFO zuul.GerritConnection: Got default branch for demo-project: master 2026-06-11 13:48:45,806 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 13:48:45,807 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 13:48:45,815 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 13:48:45,923 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 13:48:45,924 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 13:48:45,934 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 13:48:46,045 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 13:48:46,046 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 13:48:46,062 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 13:48:46,175 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 13:48:46,177 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 13:48:46,190 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 13:48:46,288 DEBUG zuul.MergeClient: Submitting job 8bd5c4dcb3f241d29e4e157d8ba716b9 with data {'connection': 'gerrit', 'project': 'demo-tenant-config', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']} 2026-06-11 13:48:46,289 DEBUG zuul.MergeClient: Submitting job c10c02b344db4d5f85d675bcd53c6d9c with data {'connection': 'gerrit', 'project': 'demo-project', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']} 2026-06-11 13:48:46,298 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper 2026-06-11 13:48:46,299 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper 2026-06-11 13:48:46,314 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 13:48:46,316 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 13:48:46,319 DEBUG zuul.TenantParser: Submitting cat job for gerrit demo-tenant-config master 2026-06-11 13:48:46,320 DEBUG zuul.TenantParser: Submitting cat job for gerrit demo-project master 2026-06-11 13:48:46,320 DEBUG zuul.TenantParser: Waiting for cat job 2026-06-11 13:48:46,336 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 13:48:46,463 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 13:48:46,464 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 13:48:46,478 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 13:48:46,591 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 13:48:46,592 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 13:48:46,606 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 13:48:46,730 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 13:48:46,732 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 13:48:46,753 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 13:48:46,865 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 13:48:46,866 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 13:48:46,880 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 13:48:46,992 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 13:48:46,992 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 13:48:47,062 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 13:48:47,178 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 13:48:47,179 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 13:48:47,194 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 13:48:47,319 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 13:48:47,320 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 13:48:47,341 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 13:48:47,452 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 13:48:47,453 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 13:48:47,473 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 13:48:47,586 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 13:48:47,587 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 13:48:47,609 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 13:48:47,721 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 13:48:47,723 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 13:48:47,740 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 13:48:47,865 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 13:48:47,866 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 13:48:47,878 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 13:48:47,992 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 13:48:47,993 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 13:48:48,076 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 13:48:48,157 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-11 13:48:48,157 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-base-jobs.yaml@master 2026-06-11 13:48:48,158 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-pipeline.yaml@master 2026-06-11 13:48:48,165 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-project-pipeline.yaml@master 2026-06-11 13:48:48,192 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 13:48:48,194 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 13:48:48,272 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 13:48:48,360 DEBUG zuul.TenantParser: Waiting for cat job 2026-06-11 13:48:48,378 DEBUG zuul.TenantParser: Cat job got files dict_keys(['.zuul.d/jobs.yaml', '.zuul.d/project.yaml', '.zuul.yaml', 'zuul.yaml']) 2026-06-11 13:48:48,378 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/jobs.yaml@master 2026-06-11 13:48:48,380 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/project.yaml@master 2026-06-11 13:48:48,398 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 13:48:48,454 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 13:48:48,472 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 13:48:48,496 DEBUG zuul.TenantParser: Created layout id d9aec54ea51246928d90ee4423aaee9a 2026-06-11 13:48:48,503 DEBUG zuul.Pipeline.demo-tenant.check: Building relative_priority queues 2026-06-11 13:48:48,511 DEBUG zuul.Pipeline.demo-tenant.gate: Building shared change queues 2026-06-11 13:48:48,512 DEBUG zuul.Pipeline.demo-tenant.gate: Created queue: 2026-06-11 13:48:48,512 DEBUG zuul.Pipeline.demo-tenant.gate: Added project demo-tenant-config to default queue manager: 2026-06-11 13:48:48,512 DEBUG zuul.Pipeline.demo-tenant.gate: Created queue: 2026-06-11 13:48:48,512 DEBUG zuul.Pipeline.demo-tenant.gate: Added project demo-project to default queue manager: 2026-06-11 13:48:48,560 DEBUG zuul.Pipeline.demo-tenant.post: Building relative_priority queues 2026-06-11 13:48:48,578 DEBUG zuul.GerritConnection: Setting watched checkers to [] 2026-06-11 13:48:48,579 DEBUG zuul.GerritConnection: Setting watched event filters for demo-tenant to [, , , , , ] 2026-06-11 13:48:48,579 DEBUG zuul.GerritConnection: Setting watched event filters to {, , , , , } 2026-06-11 13:48:48,579 DEBUG zuul.TimerDriver: No jobs to remove for , 0 remain 2026-06-11 13:48:48,589 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 13:48:48,591 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 13:48:48,611 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 13:48:48,621 DEBUG zuul.Scheduler: Setting layout state last reconfigure ltime to 5735 2026-06-11 13:48:48,639 DEBUG zuul.Scheduler: Released demo-tenant write tenant lock (id: RECONFIG) 2026-06-11 13:48:48,658 INFO zuul.Scheduler: Reconfiguration complete (smart: False, tenants: None, duration: 9.08 seconds) 2026-06-11 13:48:48,660 DEBUG zuul.Scheduler: [e: 77f88123604d40d3bd6a2cd84427a2ae] Reconfiguration complete 2026-06-11 13:48:48,673 DEBUG zuul.Scheduler: Processing tenant management events in internal 2026-06-11 13:48:48,681 DEBUG zuul.Scheduler: Aquired internal read tenant lock 2026-06-11 13:48:48,686 DEBUG zuul.Scheduler: Processing tenant trigger events in internal 2026-06-11 13:48:48,702 DEBUG zuul.Scheduler: Processing pipeline check in tenant internal 2026-06-11 13:48:48,717 DEBUG zuul.Scheduler: Processing management event 2026-06-11 13:48:48,725 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 13:48:48,726 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 13:48:48,730 DEBUG zuul.Pipeline.internal.check: Starting queue processor: check 2026-06-11 13:48:48,730 DEBUG zuul.Pipeline.internal.check: Finished queue processor: check (changed: False) 2026-06-11 13:48:48,756 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-11 13:48:48,757 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-11 13:48:48,761 DEBUG zuul.Scheduler: Processing pipeline gate in tenant internal 2026-06-11 13:48:48,780 DEBUG zuul.Scheduler: Processing management event 2026-06-11 13:48:48,788 DEBUG zuul.Pipeline.internal.gate: Starting queue processor: gate 2026-06-11 13:48:48,788 DEBUG zuul.Pipeline.internal.gate: Finished queue processor: gate (changed: False) 2026-06-11 13:48:48,799 DEBUG zuul.Scheduler: Processing pipeline post in tenant internal 2026-06-11 13:48:48,811 DEBUG zuul.Scheduler: Processing management event 2026-06-11 13:48:48,818 DEBUG zuul.Pipeline.internal.post: Starting queue processor: post 2026-06-11 13:48:48,818 DEBUG zuul.Pipeline.internal.post: Finished queue processor: post (changed: False) 2026-06-11 13:48:48,824 DEBUG zuul.Scheduler: Released internal read tenant lock 2026-06-11 13:48:48,831 DEBUG zuul.Scheduler: Processing tenant management events in demo-tenant 2026-06-11 13:48:48,838 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock 2026-06-11 13:48:48,844 DEBUG zuul.Scheduler: Processing tenant trigger events in demo-tenant 2026-06-11 13:48:48,865 DEBUG zuul.Scheduler: Processing pipeline check in tenant demo-tenant 2026-06-11 13:48:48,874 DEBUG zuul.Scheduler: Processing management event 2026-06-11 13:48:48,880 DEBUG zuul.Pipeline.demo-tenant.check: Starting queue processor: check 2026-06-11 13:48:48,880 DEBUG zuul.Pipeline.demo-tenant.check: Finished queue processor: check (changed: False) 2026-06-11 13:48:48,889 DEBUG zuul.Scheduler: Processing pipeline gate in tenant demo-tenant 2026-06-11 13:48:48,898 DEBUG zuul.Scheduler: Processing management event 2026-06-11 13:48:48,960 DEBUG zuul.Pipeline.demo-tenant.gate: Starting queue processor: gate 2026-06-11 13:48:48,961 DEBUG zuul.Pipeline.demo-tenant.gate: Finished queue processor: gate (changed: False) 2026-06-11 13:48:48,978 DEBUG zuul.Scheduler: Processing pipeline post in tenant demo-tenant 2026-06-11 13:48:48,989 DEBUG zuul.Scheduler: Processing management event 2026-06-11 13:48:48,997 DEBUG zuul.Pipeline.demo-tenant.post: Starting queue processor: post 2026-06-11 13:48:48,997 DEBUG zuul.Pipeline.demo-tenant.post: Finished queue processor: post (changed: False) 2026-06-11 13:48:49,063 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock 2026-06-11 13:48:49,066 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-11 13:48:49,066 DEBUG zuul.Scheduler: Run handler awake 2026-06-11 13:48:49,085 DEBUG zuul.Scheduler: Processing tenant management events in internal 2026-06-11 13:48:49,092 DEBUG zuul.Scheduler: Aquired internal read tenant lock 2026-06-11 13:48:49,097 DEBUG zuul.Scheduler: Processing tenant trigger events in internal 2026-06-11 13:48:49,119 DEBUG zuul.Scheduler: Processing pipeline check in tenant internal 2026-06-11 13:48:49,124 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant internal 2026-06-11 13:48:49,131 DEBUG zuul.Scheduler: Processing pipeline gate in tenant internal 2026-06-11 13:48:49,134 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant internal 2026-06-11 13:48:49,139 DEBUG zuul.Scheduler: Processing pipeline post in tenant internal 2026-06-11 13:48:49,141 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant internal 2026-06-11 13:48:49,143 DEBUG zuul.Scheduler: Released internal read tenant lock 2026-06-11 13:48:49,149 DEBUG zuul.Scheduler: Processing tenant management events in demo-tenant 2026-06-11 13:48:49,159 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock 2026-06-11 13:48:49,164 DEBUG zuul.Scheduler: Processing tenant trigger events in demo-tenant 2026-06-11 13:48:49,178 DEBUG zuul.Scheduler: Processing pipeline check in tenant demo-tenant 2026-06-11 13:48:49,180 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant demo-tenant 2026-06-11 13:48:49,184 DEBUG zuul.Scheduler: Processing pipeline gate in tenant demo-tenant 2026-06-11 13:48:49,186 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant demo-tenant 2026-06-11 13:48:49,191 DEBUG zuul.Scheduler: Processing pipeline post in tenant demo-tenant 2026-06-11 13:48:49,193 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant demo-tenant 2026-06-11 13:48:49,194 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock 2026-06-11 13:48:49,196 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-11 13:48:49,230 DEBUG zuul.Scheduler: Starting merge request cleanup 2026-06-11 13:48:49,230 DEBUG zuul.Scheduler: Finished merge request cleanup 2026-06-11 13:48:49,367 DEBUG zuul.Scheduler: Starting build request cleanup 2026-06-11 13:48:49,367 DEBUG zuul.Scheduler: Finished build request cleanup 2026-06-11 13:48:55,980 INFO zuul.ComponentRegistry: Noticed new web component zuul-web-6c6fd75fdc-7qxfs0000000006 2026-06-11 13:48:55,981 DEBUG zuul.ComponentRegistry: Registry got event None for web zuul-web-6c6fd75fdc-7qxfs0000000006 2026-06-11 13:48:55,981 INFO zuul.ComponentRegistry: Component web zuul-web-6c6fd75fdc-7qxfs0000000006 updated: {'hostname': 'zuul-web-6c6fd75fdc-7qxfs', 'kind': 'web', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-11 13:48:55,981 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-11 13:48:56,206 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-6c6fd75fdc-7qxfs0000000006 2026-06-11 13:48:56,206 INFO zuul.ComponentRegistry: Component web zuul-web-6c6fd75fdc-7qxfs0000000006 updated: {'hostname': 'zuul-web-6c6fd75fdc-7qxfs', 'kind': 'web', 'model_api': 37, 'state': 'initializing', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-11 13:48:56,206 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-11 13:49:00,307 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-6c6fd75fdc-7qxfs0000000006 2026-06-11 13:49:00,307 INFO zuul.ComponentRegistry: Component web zuul-web-6c6fd75fdc-7qxfs0000000006 updated: {'hostname': 'zuul-web-6c6fd75fdc-7qxfs', 'kind': 'web', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-11 13:49:00,307 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-11 13:49:50,666 DEBUG zuul.Scheduler: Starting merge request cleanup 2026-06-11 13:49:50,666 DEBUG zuul.Scheduler: Finished merge request cleanup 2026-06-11 13:49:50,860 DEBUG zuul.Scheduler: Starting build request cleanup 2026-06-11 13:49:50,860 DEBUG zuul.Scheduler: Finished build request cleanup