2026-06-10 12:50:16,537 DEBUG zuul.Scheduler: Configured logging: 14.1.1.dev1 2026-06-10 12:50:16,537 DEBUG zuul.TimerDriver: Starting apscheduler 2026-06-10 12:50:16,537 INFO apscheduler.scheduler: Scheduler started 2026-06-10 12:50:16,538 DEBUG apscheduler.scheduler: Looking for jobs to run 2026-06-10 12:50:16,538 DEBUG apscheduler.scheduler: No jobs; waiting until a job is added 2026-06-10 12:50:16,538 DEBUG zuul.BubblewrapDriver: Initializing bubblewrap with oom_score_adj starting: 995, final: 1000 2026-06-10 12:50:16,540 INFO zuul.SQLConnection: Initializing SQL connection database (prefix: ) 2026-06-10 12:50:16,946 DEBUG zuul.zk.base.ZooKeeperClient: ZooKeeper connection (session: 0x10000105ea7000f): CONNECTED 2026-06-10 12:50:17,829 INFO zuul.Component: Registering component in ZooKeeper /zuul/components/scheduler/zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local 2026-06-10 12:50:17,843 INFO zuul.ComponentRegistry: Noticed new scheduler component zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-10 12:50:17,844 DEBUG zuul.ComponentRegistry: Registry got event None for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-10 12:50:17,845 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-10 12:50:17,853 INFO zuul.ComponentRegistry: Noticed new executor component zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-10 12:50:17,854 DEBUG zuul.ComponentRegistry: Registry got event None for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-10 12:50:17,854 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-10 12:50:17,855 INFO zuul.ComponentRegistry: Noticed new merger component zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003 2026-06-10 12:50:17,855 DEBUG zuul.ComponentRegistry: Registry got event None for merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003 2026-06-10 12:50:17,856 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-10 12:50:17,858 INFO zuul.ComponentRegistry: Noticed new web component zuul-web-86769b97b9-fcv820000000005 2026-06-10 12:50:17,858 DEBUG zuul.ComponentRegistry: Registry got event None for web zuul-web-86769b97b9-fcv820000000005 2026-06-10 12:50:17,858 INFO zuul.ComponentRegistry: Component web zuul-web-86769b97b9-fcv820000000005 updated: {'hostname': 'zuul-web-86769b97b9-fcv82', 'kind': 'web', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-10 12:50:17,859 INFO zuul.ComponentRegistry: System minimum data model version 37; this component 37 2026-06-10 12:50:17,886 DEBUG zuul.zk.ZooKeeper: Initialize cache at /keystorage-oidc 2026-06-10 12:50:17,887 DEBUG zuul.zk.ZooKeeper: Cache at /keystorage-oidc is ready 2026-06-10 12:50:17,891 DEBUG zuul.ExecutorQueue: Creating executor queue at root /zuul/executor/unzoned 2026-06-10 12:50:17,894 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/executor/unzoned 2026-06-10 12:50:17,901 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/executor/unzoned is ready 2026-06-10 12:50:17,904 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/merger 2026-06-10 12:50:17,910 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/merger is ready 2026-06-10 12:50:17,913 DEBUG zuul.nodepool: Running nodepool watcher election 2026-06-10 12:50:17,914 DEBUG zuul.TimerDriver: Starting timer election loop 2026-06-10 12:50:17,920 INFO zuul.TimerDriver: Running timer election 2026-06-10 12:50:17,920 INFO zuul.nodepool: Watching nodepool requests 2026-06-10 12:50:17,924 INFO zuul.TimerDriver: Won timer election 2026-06-10 12:50:17,942 DEBUG zuul.SQLConnection: Current migration revision: 21d30f0bffef 2026-06-10 12:50:17,960 DEBUG zuul.GerritConnection: Starting Gerrit Connection/Watchers 2026-06-10 12:50:17,960 DEBUG zuul.GerritConnection: Creating Zookeeper branch cache 2026-06-10 12:50:17,975 INFO zuul.GerritConnection: Creating Zookeeper event queue 2026-06-10 12:50:17,978 DEBUG zuul.GerritConnection: Creating Zookeeper change cache 2026-06-10 12:50:17,980 INFO zuul.GerritConnection: Starting SSH event stream client 2026-06-10 12:50:17,981 INFO zuul.GerritConnection: gerrit: Gerrit Poller is disabled because no HTTP authentication is defined 2026-06-10 12:50:17,981 DEBUG zuul.connection.git: Creating Zookeeper change cache 2026-06-10 12:50:17,987 DEBUG zuul.connection.git: Starting Git Watcher 2026-06-10 12:50:17,987 DEBUG zuul.connection.git: Creating Zookeeper change cache 2026-06-10 12:50:17,988 DEBUG paramiko.transport: starting thread (client mode): 0x8a1c4f10 2026-06-10 12:50:17,989 DEBUG paramiko.transport: Local version/idstring: SSH-2.0-paramiko_4.0.0 2026-06-10 12:50:17,990 DEBUG paramiko.transport: Remote version/idstring: SSH-2.0-GerritCodeReview_3.6.4 (APACHE-SSHD-2.9.2) 2026-06-10 12:50:17,990 INFO paramiko.transport: Connected (version 2.0, client GerritCodeReview_3.6.4) 2026-06-10 12:50:17,990 DEBUG paramiko.transport: === Key exchange possibilities === 2026-06-10 12:50:17,990 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-10 12:50:17,990 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-10 12:50:17,990 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-10 12:50:17,990 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-10 12:50:17,990 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-10 12:50:17,990 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-10 12:50:17,991 DEBUG paramiko.transport: client compress: none 2026-06-10 12:50:17,991 DEBUG paramiko.transport: server compress: none 2026-06-10 12:50:17,991 DEBUG paramiko.transport: client lang: 2026-06-10 12:50:17,991 DEBUG paramiko.transport: server lang: 2026-06-10 12:50:17,991 DEBUG paramiko.transport: kex follows: False 2026-06-10 12:50:17,991 DEBUG paramiko.transport: === Key exchange agreements === 2026-06-10 12:50:17,991 DEBUG paramiko.transport: Kex: curve25519-sha256@libssh.org 2026-06-10 12:50:17,991 DEBUG paramiko.transport: HostKey: ssh-ed25519 2026-06-10 12:50:17,991 DEBUG paramiko.transport: Cipher: aes128-ctr 2026-06-10 12:50:17,991 DEBUG paramiko.transport: MAC: hmac-sha2-256 2026-06-10 12:50:17,991 DEBUG paramiko.transport: Compression: none 2026-06-10 12:50:17,991 DEBUG paramiko.transport: === End of kex handshake === 2026-06-10 12:50:17,995 DEBUG zuul.connection.git.watcher: Walk through projects refs for connection: git-server 2026-06-10 12:50:17,996 DEBUG zuul.connection.git: Starting Git Watcher 2026-06-10 12:50:17,996 INFO zuul.Scheduler: Starting scheduler 2026-06-10 12:50:17,996 DEBUG zuul.Scheduler: Statsd enabled 2026-06-10 12:50:17,997 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-10 12:50:17,997 DEBUG zuul.Scheduler: Run handler awake 2026-06-10 12:50:17,997 DEBUG zuul.Scheduler: Starting command processor 2026-06-10 12:50:17,999 DEBUG zuul.Scheduler: Running stats election 2026-06-10 12:50:17,999 INFO apscheduler.scheduler: Scheduler started 2026-06-10 12:50:18,000 DEBUG apscheduler.scheduler: Looking for jobs to run 2026-06-10 12:50:18,000 DEBUG apscheduler.scheduler: No jobs; waiting until a job is added 2026-06-10 12:50:18,004 INFO zuul.Scheduler: Priming scheduler config 2026-06-10 12:50:18,004 DEBUG zuul.connection.git.watcher: Walk through projects refs for connection: opendev.org 2026-06-10 12:50:18,005 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-10 12:50:18,005 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-10 12:50:18,005 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is None 2026-06-10 12:50:18,034 DEBUG paramiko.transport: kex engine KexCurve25519 specified hash_algo 2026-06-10 12:50:18,035 DEBUG paramiko.transport: Switch to new keys ... 2026-06-10 12:50:18,036 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'3128e4c0f406e788a731cce84362af98' warnings.warn( 2026-06-10 12:50:18,777 DEBUG paramiko.transport: Trying discovered key b'54f66236ba92860b433311a76ab693f9' in /var/lib/zuul-ssh/..data/priv 2026-06-10 12:50:18,778 DEBUG zuul.Scheduler: Won stats election 2026-06-10 12:50:18,779 DEBUG paramiko.transport: userauth is OK 2026-06-10 12:50:18,779 DEBUG paramiko.transport: Finalizing pubkey algorithm for key of type 'ssh-rsa' 2026-06-10 12:50:18,779 DEBUG paramiko.transport: Our pubkey algorithm list: ['rsa-sha2-512', 'rsa-sha2-256', 'ssh-rsa'] 2026-06-10 12:50:18,779 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-10 12:50:18,779 DEBUG paramiko.transport: Agreed upon 'rsa-sha2-512' pubkey algorithm 2026-06-10 12:50:18,847 INFO paramiko.transport: Authentication (publickey) successful! 2026-06-10 12:50:18,847 DEBUG paramiko.transport: [chan 0] Max packet in: 32768 bytes 2026-06-10 12:50:18,848 DEBUG paramiko.transport: [chan 0] Max packet out: 32768 bytes 2026-06-10 12:50:18,849 DEBUG paramiko.transport: Secsh channel 0 opened. 2026-06-10 12:50:18,850 INFO zuul.Scheduler: Using system config from Zookeeper 2026-06-10 12:50:18,850 DEBUG paramiko.transport: [chan 0] Sesch channel 0 request ok 2026-06-10 12:50:18,856 DEBUG zuul.Scheduler: Updating system config 2026-06-10 12:50:19,337 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-10 12:50:19,345 DEBUG zuul.Scheduler: Wait for internal read tenant lock 2026-06-10 12:50:19,348 DEBUG zuul.Scheduler: Aquired internal read tenant lock 2026-06-10 12:50:19,561 INFO zuul.BranchCache.gerrit: Waiting for branch cache upgrade lock 2026-06-10 12:50:19,748 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/cache/connection/gerrit/project 2026-06-10 12:50:19,762 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/cache/connection/gerrit/project is ready 2026-06-10 12:50:19,762 INFO zuul.BranchCache.gerrit: Cache already upgraded 2026-06-10 12:50:20,409 DEBUG zuul.TenantParser: Using files from cache for project gerrit-sshd.sf/config @master: [] 2026-06-10 12:50:20,410 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-10 12:50:20,411 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-10 12:50:20,426 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/config-project.yaml@master 2026-06-10 12:50:20,434 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/container-jobs.yaml@master 2026-06-10 12:50:20,442 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/jobs-base.yaml@master 2026-06-10 12:50:20,446 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/dib-jobs.yaml@master 2026-06-10 12:50:20,452 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/k8s-secret.yaml@master 2026-06-10 12:50:20,454 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/docker-jobs.yaml@master 2026-06-10 12:50:20,461 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/sf-logserver-secret.yaml@master 2026-06-10 12:50:20,463 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/general-jobs.yaml@master 2026-06-10 12:50:20,475 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/go-jobs.yaml@master 2026-06-10 12:50:20,483 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/haskell-jobs.yaml@master 2026-06-10 12:50:20,490 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/helm-jobs.yaml@master 2026-06-10 12:50:20,496 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/js-jobs.yaml@master 2026-06-10 12:50:20,545 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/nim-jobs.yaml@master 2026-06-10 12:50:20,548 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/packer-jobs.yaml@master 2026-06-10 12:50:20,552 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/python-jobs.yaml@master 2026-06-10 12:50:20,566 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/system-jobs.yaml@master 2026-06-10 12:50:20,569 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/terraform-jobs.yaml@master 2026-06-10 12:50:20,574 DEBUG zuul.TenantParser: Created layout id cd5d2cbb934d4e5d99d66eb439aab332 2026-06-10 12:50:20,636 DEBUG zuul.Pipeline.internal.check: Building relative_priority queues 2026-06-10 12:50:20,644 DEBUG zuul.Pipeline.internal.gate: Building shared change queues 2026-06-10 12:50:20,644 DEBUG zuul.Pipeline.internal.gate: Created queue: 2026-06-10 12:50:20,644 DEBUG zuul.Pipeline.internal.gate: Added project config to default queue manager: 2026-06-10 12:50:20,649 DEBUG zuul.Pipeline.internal.post: Building relative_priority queues 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: 2 errors detected during internal tenant configuration loading 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: Zuul encountered a syntax error while parsing its 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: configuration in the repo system-config on branch master. The 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: problem was: 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: Decryption failed 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: The problem appears in the "base" job stanza: 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: job: 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: name: base 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: description: The base job. 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: parent: null 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: post-run: 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: - playbooks/base/post.yaml 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: pre-run: 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: - playbooks/base/pre.yaml 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: roles: 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: ... 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: in "system-config/zuul.d/jobs-base.yaml@master", line 5 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: Zuul encountered a syntax error while parsing its 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: configuration in the repo system-config on branch master. The 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: problem was: 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: Decryption failed 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: The problem appears in the "config-update" job stanza: 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: job: 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: name: config-update 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: description: Deploy config repo update. 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: parent: base 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: secrets: 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: - k8s_config 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: final: true 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: run: 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: - playbooks/config/update.yaml 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: ... 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: 2026-06-10 12:50:20,654 WARNING zuul.ConfigLoader: in "system-config/zuul.d/jobs-base.yaml@master", line 26 2026-06-10 12:50:20,655 DEBUG zuul.GerritConnection: Setting watched checkers to [] 2026-06-10 12:50:20,655 DEBUG zuul.GerritConnection: Setting watched event filters for internal to [, , , , , ] 2026-06-10 12:50:20,655 DEBUG zuul.GerritConnection: Setting watched event filters to {, , , , , } 2026-06-10 12:50:20,655 DEBUG zuul.TimerDriver: No jobs to remove for , 0 remain 2026-06-10 12:50:20,655 DEBUG zuul.Scheduler: Released internal read tenant lock 2026-06-10 12:50:20,657 DEBUG zuul.Scheduler: Wait for demo-tenant read tenant lock 2026-06-10 12:50:20,660 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock 2026-06-10 12:50:21,420 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-10 12:50:21,421 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-10 12:50:21,433 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-base-jobs.yaml@master 2026-06-10 12:50:21,438 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-pipeline.yaml@master 2026-06-10 12:50:21,443 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/jobs.yaml@master 2026-06-10 12:50:21,448 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-project-pipeline.yaml@master 2026-06-10 12:50:21,450 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/project.yaml@master 2026-06-10 12:50:21,458 DEBUG zuul.TenantParser: Created layout id 4bee4d37026141d1ae78a6976b7cc5bd 2026-06-10 12:50:21,468 DEBUG zuul.Pipeline.demo-tenant.check: Building relative_priority queues 2026-06-10 12:50:21,476 DEBUG zuul.Pipeline.demo-tenant.gate: Building shared change queues 2026-06-10 12:50:21,476 DEBUG zuul.Pipeline.demo-tenant.gate: Created queue: 2026-06-10 12:50:21,476 DEBUG zuul.Pipeline.demo-tenant.gate: Added project demo-tenant-config to default queue manager: 2026-06-10 12:50:21,476 DEBUG zuul.Pipeline.demo-tenant.gate: Created queue: 2026-06-10 12:50:21,476 DEBUG zuul.Pipeline.demo-tenant.gate: Added project demo-project to default queue manager: 2026-06-10 12:50:21,485 DEBUG zuul.Pipeline.demo-tenant.post: Building relative_priority queues 2026-06-10 12:50:21,540 DEBUG zuul.GerritConnection: Setting watched checkers to [] 2026-06-10 12:50:21,541 DEBUG zuul.GerritConnection: Setting watched event filters for demo-tenant to [, , , , , ] 2026-06-10 12:50:21,541 DEBUG zuul.GerritConnection: Setting watched event filters to {, , , , , } 2026-06-10 12:50:21,541 DEBUG zuul.TimerDriver: No jobs to remove for , 0 remain 2026-06-10 12:50:21,542 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock 2026-06-10 12:50:21,544 INFO zuul.Scheduler: Config priming complete (duration: 3.54 seconds) 2026-06-10 12:50:21,546 DEBUG zuul.Scheduler: Run handler awake 2026-06-10 12:50:21,549 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is None 2026-06-10 12:50:21,549 DEBUG zuul.RendezvousElection: Did not win election for /zuul/events/connection/gerrit/election 2026-06-10 12:50:21,549 DEBUG zuul.RendezvousElection: Did not win election for /zuul/events/connection/gerrit/election 2026-06-10 12:50:21,551 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-10 12:50:21,552 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-10 12:50:21,552 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-10 12:50:21,552 DEBUG zuul.RendezvousElection: Acquiring lock for /zuul/events/connection/gerrit/election 2026-06-10 12:50:21,562 INFO zuul.RendezvousElection: Won election for /zuul/events/connection/gerrit/election 2026-06-10 12:50:21,563 DEBUG zuul.Scheduler: Starting semaphore cleanup 2026-06-10 12:50:21,570 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-10 12:50:21,571 DEBUG zuul.Scheduler: Processing tenant management events in demo-tenant 2026-06-10 12:50:21,573 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-10 12:50:21,581 DEBUG zuul.Scheduler: Starting build request cleanup 2026-06-10 12:50:21,581 DEBUG zuul.Scheduler: Finished build request cleanup 2026-06-10 12:50:21,589 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock 2026-06-10 12:50:21,590 DEBUG zuul.Scheduler: Starting node request cleanup 2026-06-10 12:50:21,593 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-10 12:50:21,594 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-10 12:50:21,600 DEBUG zuul.Scheduler: Processing tenant trigger events in demo-tenant 2026-06-10 12:50:21,660 DEBUG zuul.Scheduler: Processing pipeline check in tenant demo-tenant 2026-06-10 12:50:21,670 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant demo-tenant 2026-06-10 12:50:21,677 DEBUG zuul.Scheduler: Processing pipeline gate in tenant demo-tenant 2026-06-10 12:50:21,688 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant demo-tenant 2026-06-10 12:50:21,695 DEBUG zuul.Scheduler: Processing pipeline post in tenant demo-tenant 2026-06-10 12:50:21,707 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant demo-tenant 2026-06-10 12:50:21,709 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock 2026-06-10 12:50:21,738 DEBUG zuul.Scheduler: Processing tenant management events in internal 2026-06-10 12:50:21,742 INFO apscheduler.scheduler: Added job "Scheduler._runSemaphoreCleanup" to job store "default" 2026-06-10 12:50:21,743 INFO apscheduler.scheduler: Added job "Scheduler._runBuildRequestCleanup" to job store "default" 2026-06-10 12:50:21,743 INFO apscheduler.scheduler: Added job "Scheduler._runMergeRequestCleanup" to job store "default" 2026-06-10 12:50:21,743 INFO apscheduler.scheduler: Added job "Scheduler._runConnectionCleanup" to job store "default" 2026-06-10 12:50:21,743 INFO apscheduler.scheduler: Added job "Scheduler._runGeneralCleanup" to job store "default" 2026-06-10 12:50:21,743 DEBUG apscheduler.scheduler: Looking for jobs to run 2026-06-10 12:50:21,743 DEBUG apscheduler.scheduler: Next wakeup is due at 2026-06-10 12:51:20.229817+00:00 (in 58.485926 seconds) 2026-06-10 12:50:21,750 DEBUG zuul.Scheduler: Aquired internal read tenant lock 2026-06-10 12:50:21,756 DEBUG zuul.Scheduler: Processing tenant trigger events in internal 2026-06-10 12:50:21,772 DEBUG zuul.Scheduler: Processing pipeline check in tenant internal 2026-06-10 12:50:21,778 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant internal 2026-06-10 12:50:21,783 DEBUG zuul.Scheduler: Processing pipeline gate in tenant internal 2026-06-10 12:50:21,790 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant internal 2026-06-10 12:50:21,796 DEBUG zuul.Scheduler: Processing pipeline post in tenant internal 2026-06-10 12:50:21,804 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant internal 2026-06-10 12:50:21,807 DEBUG zuul.Scheduler: Released internal read tenant lock 2026-06-10 12:50:21,809 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-10 12:51:13,377 DEBUG zuul.CommandSocket: Accepted socket connection 2026-06-10 12:51:13,378 DEBUG zuul.CommandSocket: Received b'full-reconfigure' from socket 2026-06-10 12:51:13,378 DEBUG zuul.Scheduler: Reconfiguration triggered 2026-06-10 12:51:13,455 DEBUG zuul.Scheduler: Configured logging: 14.1.1.dev1 2026-06-10 12:51:13,456 DEBUG zuul.Scheduler: [e: 83b48b65373143c9adef1dae50e4e701] Submitting reconfiguration event 2026-06-10 12:51:13,459 DEBUG zuul.Scheduler: [e: 83b48b65373143c9adef1dae50e4e701] Waiting for reconfiguration 2026-06-10 12:51:13,459 DEBUG zuul.Scheduler: Run handler awake 2026-06-10 12:51:13,460 DEBUG zuul.Scheduler: Fetching reconfiguration event 2026-06-10 12:51:13,460 INFO zuul.Scheduler: Reconfiguration beginning (smart=False, tenants=None) 2026-06-10 12:51:13,536 INFO zuul.ConfigLoader: Loading configuration from /var/lib/zuul/main.yaml 2026-06-10 12:51:13,661 DEBUG zuul.Scheduler: Wait for demo-tenant write tenant lock (id: RECONFIG) 2026-06-10 12:51:13,664 DEBUG zuul.Scheduler: Aquired demo-tenant 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'3128e4c0f406e788a731cce84362af98' warnings.warn( 2026-06-10 12:51:17,054 DEBUG zuul.GerritConnection: SSH command: 2026-06-10 12:51:17,054 DEBUG zuul.GerritConnection: git-upload-pack demo-project 2026-06-10 12:51:17,057 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-86769b97b9-fcv820000000005 2026-06-10 12:51:17,057 INFO zuul.ComponentRegistry: Noticed web component zuul-web-86769b97b9-fcv820000000005 disappeared 2026-06-10 12:51:17,058 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-10 12:51:17,060 DEBUG zuul.GerritConnection: SSH command: 2026-06-10 12:51:17,060 DEBUG zuul.GerritConnection: git-upload-pack demo-tenant-config 2026-06-10 12:51:17,106 DEBUG zuul.GerritConnection.io: SSH received stdout: 2026-06-10 12:51:17,106 DEBUG zuul.GerritConnection.io: 00e9b2da0fdeb39a7445246588ffc91deabe48cfacd9 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-10 12:51:17,106 DEBUG zuul.GerritConnection.io: 003fb2da0fdeb39a7445246588ffc91deabe48cfacd9 refs/heads/master 2026-06-10 12:51:17,106 DEBUG zuul.GerritConnection.io: 003e384bd886d2d1f12cceca764ff83c58bc041b4152 refs/meta/config 2026-06-10 12:51:17,106 DEBUG zuul.GerritConnection.io: 0000 2026-06-10 12:51:17,106 DEBUG zuul.GerritConnection: SSH exit status: 0 2026-06-10 12:51:17,107 DEBUG zuul.GerritConnection: Fetched 1 branches for demo-project 2026-06-10 12:51:17,107 INFO zuul.GerritConnection: Got branches for demo-project 2026-06-10 12:51:17,110 DEBUG zuul.GerritConnection.io: SSH received stdout: 2026-06-10 12:51:17,110 DEBUG zuul.GerritConnection.io: 00e920eaf370b89641a44b7580dc1f9b139186a48d9e 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-10 12:51:17,110 DEBUG zuul.GerritConnection.io: 003f20eaf370b89641a44b7580dc1f9b139186a48d9e refs/heads/master 2026-06-10 12:51:17,110 DEBUG zuul.GerritConnection.io: 003e64bab93b4630cfa69b76fef35d7fe2cb957f95b6 refs/meta/config 2026-06-10 12:51:17,110 DEBUG zuul.GerritConnection.io: 0000 2026-06-10 12:51:17,111 DEBUG zuul.GerritConnection: SSH exit status: 0 2026-06-10 12:51:17,111 DEBUG zuul.GerritConnection: Fetched 1 branches for demo-tenant-config 2026-06-10 12:51:17,111 INFO zuul.GerritConnection: Got branches for demo-tenant-config 2026-06-10 12:51:17,118 ERROR zuul.BranchCacheNew.gerrit: Exception loading ZKObject at /zuul/cache/connection/gerrit/project/data/demo-project 2026-06-10 12:51:17,126 ERROR zuul.BranchCacheNew.gerrit: Exception loading ZKObject at /zuul/cache/connection/gerrit/project/data/demo-tenant-config 2026-06-10 12:51:17,130 INFO zuul.GerritConnection: Got default branch for demo-project: master 2026-06-10 12:51:17,136 INFO zuul.GerritConnection: Got default branch for demo-tenant-config: master 2026-06-10 12:51:17,174 DEBUG zuul.MergeClient: Submitting job e9b6696690fe4fea9eb1da9ce5ef06db with data {'connection': 'gerrit', 'project': 'demo-project', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']} 2026-06-10 12:51:17,176 DEBUG zuul.MergeClient: Submitting job 3cac46fa6b1847f191f62d10a7af2b4d with data {'connection': 'opendev.org', 'project': 'zuul/zuul-jobs', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']} 2026-06-10 12:51:17,178 DEBUG zuul.MergeClient: Submitting job 31ac590839e8421293bc5945354993f2 with data {'connection': 'gerrit', 'project': 'demo-tenant-config', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']} 2026-06-10 12:51:17,187 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper 2026-06-10 12:51:17,190 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper 2026-06-10 12:51:17,191 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper 2026-06-10 12:51:17,240 DEBUG zuul.TenantParser: Submitting cat job for gerrit demo-project master 2026-06-10 12:51:17,242 DEBUG zuul.TenantParser: Submitting cat job for opendev.org zuul/zuul-jobs master 2026-06-10 12:51:17,244 DEBUG zuul.TenantParser: Submitting cat job for gerrit demo-tenant-config master 2026-06-10 12:51:17,245 DEBUG zuul.TenantParser: Waiting for cat job 2026-06-10 12:51:18,372 DEBUG zuul.TenantParser: Cat job got files dict_keys(['.zuul.d/jobs.yaml', '.zuul.d/project.yaml', '.zuul.yaml', 'zuul.yaml']) 2026-06-10 12:51:18,372 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/jobs.yaml@master 2026-06-10 12:51:18,374 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/project.yaml@master 2026-06-10 12:51:18,449 DEBUG zuul.TenantParser: Waiting for cat job 2026-06-10 12:51:18,465 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-10 12:51:18,465 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/container-jobs.yaml@master 2026-06-10 12:51:18,467 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/dib-jobs.yaml@master 2026-06-10 12:51:18,467 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/docker-jobs.yaml@master 2026-06-10 12:51:18,469 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/general-jobs.yaml@master 2026-06-10 12:51:18,473 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/go-jobs.yaml@master 2026-06-10 12:51:18,474 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/haskell-jobs.yaml@master 2026-06-10 12:51:18,475 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/helm-jobs.yaml@master 2026-06-10 12:51:18,477 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/js-jobs.yaml@master 2026-06-10 12:51:18,480 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/nim-jobs.yaml@master 2026-06-10 12:51:18,480 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/packer-jobs.yaml@master 2026-06-10 12:51:18,483 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/python-jobs.yaml@master 2026-06-10 12:51:18,498 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/system-jobs.yaml@master 2026-06-10 12:51:18,499 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/terraform-jobs.yaml@master 2026-06-10 12:51:18,753 DEBUG zuul.TenantParser: Waiting for cat job 2026-06-10 12:51:19,028 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-10 12:51:19,029 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-base-jobs.yaml@master 2026-06-10 12:51:19,029 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-pipeline.yaml@master 2026-06-10 12:51:19,034 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-project-pipeline.yaml@master 2026-06-10 12:51:19,148 DEBUG zuul.TenantParser: Created layout id 1f9725ca213e4b83aa81b50ae0fad3fa 2026-06-10 12:51:19,154 DEBUG zuul.Pipeline.demo-tenant.check: Building relative_priority queues 2026-06-10 12:51:19,163 DEBUG zuul.Pipeline.demo-tenant.gate: Building shared change queues 2026-06-10 12:51:19,163 DEBUG zuul.Pipeline.demo-tenant.gate: Created queue: 2026-06-10 12:51:19,163 DEBUG zuul.Pipeline.demo-tenant.gate: Added project demo-tenant-config to default queue manager: 2026-06-10 12:51:19,163 DEBUG zuul.Pipeline.demo-tenant.gate: Created queue: 2026-06-10 12:51:19,163 DEBUG zuul.Pipeline.demo-tenant.gate: Added project demo-project to default queue manager: 2026-06-10 12:51:19,171 DEBUG zuul.Pipeline.demo-tenant.post: Building relative_priority queues 2026-06-10 12:51:19,243 DEBUG zuul.GerritConnection: Setting watched checkers to [] 2026-06-10 12:51:19,243 DEBUG zuul.GerritConnection: Setting watched event filters for demo-tenant to [, , , , , ] 2026-06-10 12:51:19,243 DEBUG zuul.GerritConnection: Setting watched event filters to {, , , , , } 2026-06-10 12:51:19,243 DEBUG zuul.TimerDriver: No jobs to remove for , 0 remain 2026-06-10 12:51:19,268 DEBUG zuul.Scheduler: Setting layout state last reconfigure ltime to 4725 2026-06-10 12:51:19,343 DEBUG zuul.Scheduler: Released demo-tenant write tenant lock (id: RECONFIG) 2026-06-10 12:51:19,375 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-10 12:51:19,376 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-10 12:51:19,376 DEBUG zuul.Scheduler: Wait for internal write tenant lock (id: RECONFIG) 2026-06-10 12:51:19,381 DEBUG zuul.Scheduler: Aquired internal write tenant lock (id: RECONFIG) 2026-06-10 12:51:19,393 DEBUG zuul.GerritConnection: SSH command: 2026-06-10 12:51:19,393 DEBUG zuul.GerritConnection: git-upload-pack config 2026-06-10 12:51:19,484 DEBUG zuul.GerritConnection.io: SSH received stdout: 2026-06-10 12:51:19,484 DEBUG zuul.GerritConnection.io: 00e93106c23b42b3e968bf79ad26257c8859c56fa9e3 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-10 12:51:19,484 DEBUG zuul.GerritConnection.io: 003f3106c23b42b3e968bf79ad26257c8859c56fa9e3 refs/heads/master 2026-06-10 12:51:19,484 DEBUG zuul.GerritConnection.io: 003e7367c8a0b30523c09b5dbb27412b5706b58d4418 refs/meta/config 2026-06-10 12:51:19,484 DEBUG zuul.GerritConnection.io: 0000 2026-06-10 12:51:19,485 DEBUG zuul.GerritConnection: SSH exit status: 0 2026-06-10 12:51:19,485 DEBUG zuul.GerritConnection: Fetched 1 branches for config 2026-06-10 12:51:19,537 INFO zuul.GerritConnection: Got branches for config 2026-06-10 12:51:19,554 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant internal 2026-06-10 12:51:19,554 ERROR zuul.BranchCacheNew.gerrit: Exception loading ZKObject at /zuul/cache/connection/gerrit/project/data/config 2026-06-10 12:51:19,558 INFO zuul.GerritConnection: Got default branch for config: master 2026-06-10 12:51:19,666 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-10 12:51:19,667 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-10 12:51:19,685 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant internal 2026-06-10 12:51:19,798 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-10 12:51:19,799 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-10 12:51:19,810 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant internal 2026-06-10 12:51:19,921 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-10 12:51:19,922 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-10 12:51:19,935 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant internal 2026-06-10 12:51:20,048 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-10 12:51:20,049 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-10 12:51:20,064 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant internal 2026-06-10 12:51:20,208 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-10 12:51:20,223 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-10 12:51:20,232 DEBUG zuul.MergeClient: Submitting job 2bde1599a98f494dafb6aad45741891e with data {'connection': 'git-server', 'project': 'system-config', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']} 2026-06-10 12:51:20,233 DEBUG zuul.MergeClient: Submitting job 92f6e29db6eb4f77b70c229e07da95e1 with data {'connection': 'gerrit', 'project': 'config', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']} 2026-06-10 12:51:20,238 DEBUG zuul.Scheduler: Starting merge request cleanup 2026-06-10 12:51:20,238 DEBUG zuul.Scheduler: Finished merge request cleanup 2026-06-10 12:51:20,239 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper 2026-06-10 12:51:20,241 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper 2026-06-10 12:51:20,247 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant internal 2026-06-10 12:51:20,256 DEBUG zuul.TenantParser: Submitting cat job for git-server system-config master 2026-06-10 12:51:20,257 DEBUG zuul.TenantParser: Submitting cat job for gerrit config master 2026-06-10 12:51:20,257 DEBUG zuul.TenantParser: Waiting for cat job 2026-06-10 12:51:20,310 DEBUG zuul.Scheduler: Starting build request cleanup 2026-06-10 12:51:20,310 DEBUG zuul.Scheduler: Finished build request cleanup 2026-06-10 12:51:20,357 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-10 12:51:20,358 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-10 12:51:20,368 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant internal 2026-06-10 12:51:20,451 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-10 12:51:20,451 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/config-project.yaml@master 2026-06-10 12:51:20,456 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/jobs-base.yaml@master 2026-06-10 12:51:20,457 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/k8s-secret.yaml@master 2026-06-10 12:51:20,457 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/sf-logserver-secret.yaml@master 2026-06-10 12:51:20,547 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-10 12:51:20,548 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-10 12:51:20,562 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant internal 2026-06-10 12:51:20,614 DEBUG zuul.TenantParser: Waiting for cat job 2026-06-10 12:51:20,669 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-10 12:51:20,670 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-10 12:51:20,678 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant internal 2026-06-10 12:51:20,844 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-10 12:51:20,845 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-10 12:51:20,858 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant internal 2026-06-10 12:51:20,969 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-10 12:51:20,970 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-10 12:51:20,985 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant internal 2026-06-10 12:51:21,097 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-10 12:51:21,097 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-10 12:51:21,106 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant internal 2026-06-10 12:51:21,220 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-10 12:51:21,221 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-10 12:51:21,234 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant internal 2026-06-10 12:51:21,347 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-10 12:51:21,347 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-10 12:51:21,360 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant internal 2026-06-10 12:51:21,449 DEBUG zuul.TenantParser: Cat job got files dict_keys(['.zuul.yaml', 'zuul.yaml']) 2026-06-10 12:51:21,458 DEBUG zuul.TenantParser: Created layout id 55095d1791e441fba502d84327ba1fda 2026-06-10 12:51:21,564 DEBUG zuul.Pipeline.internal.check: Building relative_priority queues 2026-06-10 12:51:21,571 DEBUG zuul.Pipeline.internal.gate: Building shared change queues 2026-06-10 12:51:21,571 DEBUG zuul.Pipeline.internal.gate: Created queue: 2026-06-10 12:51:21,571 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-10 12:51:21,572 DEBUG zuul.Pipeline.internal.gate: Added project config to default queue manager: 2026-06-10 12:51:21,573 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-10 12:51:21,579 DEBUG zuul.Pipeline.internal.post: Building relative_priority queues 2026-06-10 12:51:21,584 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant internal 2026-06-10 12:51:21,587 DEBUG zuul.GerritConnection: Setting watched checkers to [] 2026-06-10 12:51:21,587 DEBUG zuul.GerritConnection: Setting watched event filters for internal to [, , , , , ] 2026-06-10 12:51:21,587 DEBUG zuul.GerritConnection: Setting watched event filters to {, , , , , } 2026-06-10 12:51:21,587 DEBUG zuul.TimerDriver: No jobs to remove for , 0 remain 2026-06-10 12:51:21,642 DEBUG zuul.Scheduler: Setting layout state last reconfigure ltime to 4725 2026-06-10 12:51:21,654 DEBUG zuul.Scheduler: Released internal write tenant lock (id: RECONFIG) 2026-06-10 12:51:21,664 INFO zuul.Scheduler: Reconfiguration complete (smart: False, tenants: None, duration: 8.205 seconds) 2026-06-10 12:51:21,665 DEBUG zuul.Scheduler: [e: 83b48b65373143c9adef1dae50e4e701] Reconfiguration complete 2026-06-10 12:51:21,673 DEBUG zuul.Scheduler: Processing tenant management events in internal 2026-06-10 12:51:21,679 DEBUG zuul.Scheduler: Aquired internal read tenant lock 2026-06-10 12:51:21,683 DEBUG zuul.Scheduler: Processing tenant trigger events in internal 2026-06-10 12:51:21,692 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-10 12:51:21,693 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-10 12:51:21,701 DEBUG zuul.Scheduler: Processing pipeline check in tenant internal 2026-06-10 12:51:21,702 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-10 12:51:21,703 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-10 12:51:21,714 DEBUG zuul.Scheduler: Processing management event 2026-06-10 12:51:21,737 DEBUG zuul.Pipeline.internal.check: Starting queue processor: check 2026-06-10 12:51:21,737 DEBUG zuul.Pipeline.internal.check: Finished queue processor: check (changed: False) 2026-06-10 12:51:21,746 DEBUG zuul.Scheduler: Processing pipeline gate in tenant internal 2026-06-10 12:51:21,757 DEBUG zuul.Scheduler: Processing management event 2026-06-10 12:51:21,763 DEBUG zuul.Pipeline.internal.gate: Starting queue processor: gate 2026-06-10 12:51:21,763 DEBUG zuul.Pipeline.internal.gate: Finished queue processor: gate (changed: False) 2026-06-10 12:51:21,771 DEBUG zuul.Scheduler: Processing pipeline post in tenant internal 2026-06-10 12:51:21,848 DEBUG zuul.Scheduler: Processing management event 2026-06-10 12:51:21,857 DEBUG zuul.Pipeline.internal.post: Starting queue processor: post 2026-06-10 12:51:21,857 DEBUG zuul.Pipeline.internal.post: Finished queue processor: post (changed: False) 2026-06-10 12:51:21,864 DEBUG zuul.Scheduler: Released internal read tenant lock 2026-06-10 12:51:21,871 DEBUG zuul.Scheduler: Processing tenant management events in demo-tenant 2026-06-10 12:51:21,877 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock 2026-06-10 12:51:21,881 DEBUG zuul.Scheduler: Processing tenant trigger events in demo-tenant 2026-06-10 12:51:21,894 DEBUG zuul.Scheduler: Processing pipeline check in tenant demo-tenant 2026-06-10 12:51:21,902 DEBUG zuul.Scheduler: Processing management event 2026-06-10 12:51:21,908 DEBUG zuul.Pipeline.demo-tenant.check: Starting queue processor: check 2026-06-10 12:51:21,908 DEBUG zuul.Pipeline.demo-tenant.check: Finished queue processor: check (changed: False) 2026-06-10 12:51:21,917 DEBUG zuul.Scheduler: Processing pipeline gate in tenant demo-tenant 2026-06-10 12:51:21,925 DEBUG zuul.Scheduler: Processing management event 2026-06-10 12:51:21,930 DEBUG zuul.Pipeline.demo-tenant.gate: Starting queue processor: gate 2026-06-10 12:51:21,930 DEBUG zuul.Pipeline.demo-tenant.gate: Finished queue processor: gate (changed: False) 2026-06-10 12:51:21,944 DEBUG zuul.Scheduler: Processing pipeline post in tenant demo-tenant 2026-06-10 12:51:21,956 DEBUG zuul.Scheduler: Processing management event 2026-06-10 12:51:21,962 DEBUG zuul.Pipeline.demo-tenant.post: Starting queue processor: post 2026-06-10 12:51:21,962 DEBUG zuul.Pipeline.demo-tenant.post: Finished queue processor: post (changed: False) 2026-06-10 12:51:21,969 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock 2026-06-10 12:51:21,971 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-10 12:51:21,971 DEBUG zuul.Scheduler: Run handler awake 2026-06-10 12:51:21,981 DEBUG zuul.Scheduler: Processing tenant management events in internal 2026-06-10 12:51:21,989 DEBUG zuul.Scheduler: Aquired internal read tenant lock 2026-06-10 12:51:21,996 DEBUG zuul.Scheduler: Processing tenant trigger events in internal 2026-06-10 12:51:22,008 DEBUG zuul.Scheduler: Processing pipeline check in tenant internal 2026-06-10 12:51:22,010 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant internal 2026-06-10 12:51:22,015 DEBUG zuul.Scheduler: Processing pipeline gate in tenant internal 2026-06-10 12:51:22,018 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant internal 2026-06-10 12:51:22,024 DEBUG zuul.Scheduler: Processing pipeline post in tenant internal 2026-06-10 12:51:22,028 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant internal 2026-06-10 12:51:22,031 DEBUG zuul.Scheduler: Released internal read tenant lock 2026-06-10 12:51:22,037 DEBUG zuul.Scheduler: Processing tenant management events in demo-tenant 2026-06-10 12:51:22,042 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock 2026-06-10 12:51:22,050 DEBUG zuul.Scheduler: Processing tenant trigger events in demo-tenant 2026-06-10 12:51:22,064 DEBUG zuul.Scheduler: Processing pipeline check in tenant demo-tenant 2026-06-10 12:51:22,066 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant demo-tenant 2026-06-10 12:51:22,071 DEBUG zuul.Scheduler: Processing pipeline gate in tenant demo-tenant 2026-06-10 12:51:22,073 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant demo-tenant 2026-06-10 12:51:22,076 DEBUG zuul.Scheduler: Processing pipeline post in tenant demo-tenant 2026-06-10 12:51:22,079 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant demo-tenant 2026-06-10 12:51:22,080 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock 2026-06-10 12:51:22,082 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-10 12:51:28,841 INFO zuul.ComponentRegistry: Noticed new web component zuul-web-86769b97b9-7knqt0000000006 2026-06-10 12:51:28,842 DEBUG zuul.ComponentRegistry: Registry got event None for web zuul-web-86769b97b9-7knqt0000000006 2026-06-10 12:51:28,842 INFO zuul.ComponentRegistry: Component web zuul-web-86769b97b9-7knqt0000000006 updated: {'hostname': 'zuul-web-86769b97b9-7knqt', 'kind': 'web', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-10 12:51:28,842 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-10 12:51:28,952 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-86769b97b9-7knqt0000000006 2026-06-10 12:51:28,952 INFO zuul.ComponentRegistry: Component web zuul-web-86769b97b9-7knqt0000000006 updated: {'hostname': 'zuul-web-86769b97b9-7knqt', 'kind': 'web', 'model_api': 37, 'state': 'initializing', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-10 12:51:28,952 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-10 12:51:31,749 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-86769b97b9-7knqt0000000006 2026-06-10 12:51:31,749 INFO zuul.ComponentRegistry: Component web zuul-web-86769b97b9-7knqt0000000006 updated: {'hostname': 'zuul-web-86769b97b9-7knqt', 'kind': 'web', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-10 12:51:31,749 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-10 12:52:21,997 DEBUG zuul.Scheduler: Starting build request cleanup 2026-06-10 12:52:21,997 DEBUG zuul.Scheduler: Finished build request cleanup 2026-06-10 12:52:23,388 DEBUG zuul.Scheduler: Starting merge request cleanup 2026-06-10 12:52:23,388 DEBUG zuul.Scheduler: Finished merge request cleanup