2026-06-11 00:20:50,323 DEBUG zuul.Scheduler: Configured logging: 14.1.1.dev1 2026-06-11 00:20:50,323 DEBUG zuul.TimerDriver: Starting apscheduler 2026-06-11 00:20:50,323 INFO apscheduler.scheduler: Scheduler started 2026-06-11 00:20:50,323 DEBUG apscheduler.scheduler: Looking for jobs to run 2026-06-11 00:20:50,324 DEBUG apscheduler.scheduler: No jobs; waiting until a job is added 2026-06-11 00:20:50,324 DEBUG zuul.BubblewrapDriver: Initializing bubblewrap with oom_score_adj starting: 995, final: 1000 2026-06-11 00:20:50,325 INFO zuul.SQLConnection: Initializing SQL connection database (prefix: ) 2026-06-11 00:20:50,448 DEBUG zuul.zk.base.ZooKeeperClient: ZooKeeper connection (session: 0x100000f5a7f000e): CONNECTED 2026-06-11 00:20:50,454 INFO zuul.Component: Registering component in ZooKeeper /zuul/components/scheduler/zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local 2026-06-11 00:20:50,459 INFO zuul.ComponentRegistry: Noticed new scheduler component zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-11 00:20:50,459 DEBUG zuul.ComponentRegistry: Registry got event None for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-11 00:20:50,459 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 00:20:50,460 INFO zuul.ComponentRegistry: Noticed new executor component zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-11 00:20:50,461 DEBUG zuul.ComponentRegistry: Registry got event None for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 2026-06-11 00:20:50,461 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 00:20:50,462 INFO zuul.ComponentRegistry: Noticed new merger component zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003 2026-06-11 00:20:50,462 DEBUG zuul.ComponentRegistry: Registry got event None for merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003 2026-06-11 00:20:50,462 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 00:20:50,488 INFO zuul.ComponentRegistry: Noticed new web component zuul-web-5c4577998d-4rh4c0000000005 2026-06-11 00:20:50,489 DEBUG zuul.ComponentRegistry: Registry got event None for web zuul-web-5c4577998d-4rh4c0000000005 2026-06-11 00:20:50,489 INFO zuul.ComponentRegistry: Component web zuul-web-5c4577998d-4rh4c0000000005 updated: {'hostname': 'zuul-web-5c4577998d-4rh4c', 'kind': 'web', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-11 00:20:50,490 INFO zuul.ComponentRegistry: System minimum data model version 37; this component 37 2026-06-11 00:20:50,514 DEBUG zuul.zk.ZooKeeper: Initialize cache at /keystorage-oidc 2026-06-11 00:20:50,515 DEBUG zuul.zk.ZooKeeper: Cache at /keystorage-oidc is ready 2026-06-11 00:20:50,518 DEBUG zuul.ExecutorQueue: Creating executor queue at root /zuul/executor/unzoned 2026-06-11 00:20:50,520 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/executor/unzoned 2026-06-11 00:20:50,526 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/executor/unzoned is ready 2026-06-11 00:20:50,529 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/merger 2026-06-11 00:20:50,536 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/merger is ready 2026-06-11 00:20:50,538 DEBUG zuul.nodepool: Running nodepool watcher election 2026-06-11 00:20:50,539 DEBUG zuul.TimerDriver: Starting timer election loop 2026-06-11 00:20:50,543 INFO zuul.TimerDriver: Running timer election 2026-06-11 00:20:50,544 INFO zuul.nodepool: Watching nodepool requests 2026-06-11 00:20:50,547 INFO zuul.TimerDriver: Won timer election 2026-06-11 00:20:50,555 DEBUG zuul.SQLConnection: Current migration revision: 21d30f0bffef 2026-06-11 00:20:50,602 DEBUG zuul.GerritConnection: Starting Gerrit Connection/Watchers 2026-06-11 00:20:50,603 DEBUG zuul.GerritConnection: Creating Zookeeper branch cache 2026-06-11 00:20:50,609 INFO zuul.GerritConnection: Creating Zookeeper event queue 2026-06-11 00:20:50,611 DEBUG zuul.GerritConnection: Creating Zookeeper change cache 2026-06-11 00:20:50,612 INFO zuul.GerritConnection: Starting SSH event stream client 2026-06-11 00:20:50,613 INFO zuul.GerritConnection: gerrit: Gerrit Poller is disabled because no HTTP authentication is defined 2026-06-11 00:20:50,613 DEBUG zuul.connection.git: Creating Zookeeper change cache 2026-06-11 00:20:50,617 DEBUG zuul.connection.git: Starting Git Watcher 2026-06-11 00:20:50,617 DEBUG zuul.connection.git: Creating Zookeeper change cache 2026-06-11 00:20:50,619 DEBUG paramiko.transport: starting thread (client mode): 0xdcf093d0 2026-06-11 00:20:50,619 DEBUG paramiko.transport: Local version/idstring: SSH-2.0-paramiko_4.0.0 2026-06-11 00:20:50,620 DEBUG paramiko.transport: Remote version/idstring: SSH-2.0-GerritCodeReview_3.6.4 (APACHE-SSHD-2.9.2) 2026-06-11 00:20:50,620 INFO paramiko.transport: Connected (version 2.0, client GerritCodeReview_3.6.4) 2026-06-11 00:20:50,621 DEBUG paramiko.transport: === Key exchange possibilities === 2026-06-11 00:20:50,621 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 00:20:50,621 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 00:20:50,622 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 00:20:50,622 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 00:20:50,622 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 00:20:50,622 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 00:20:50,622 DEBUG paramiko.transport: client compress: none 2026-06-11 00:20:50,622 DEBUG paramiko.transport: server compress: none 2026-06-11 00:20:50,622 DEBUG paramiko.transport: client lang: 2026-06-11 00:20:50,622 DEBUG paramiko.transport: server lang: 2026-06-11 00:20:50,622 DEBUG paramiko.transport: kex follows: False 2026-06-11 00:20:50,622 DEBUG paramiko.transport: === Key exchange agreements === 2026-06-11 00:20:50,622 DEBUG paramiko.transport: Kex: curve25519-sha256@libssh.org 2026-06-11 00:20:50,622 DEBUG paramiko.transport: HostKey: ssh-ed25519 2026-06-11 00:20:50,622 DEBUG paramiko.transport: Cipher: aes128-ctr 2026-06-11 00:20:50,622 DEBUG paramiko.transport: MAC: hmac-sha2-256 2026-06-11 00:20:50,623 DEBUG paramiko.transport: Compression: none 2026-06-11 00:20:50,623 DEBUG paramiko.transport: === End of kex handshake === 2026-06-11 00:20:50,625 DEBUG zuul.connection.git.watcher: Walk through projects refs for connection: git-server 2026-06-11 00:20:50,625 DEBUG zuul.connection.git: Starting Git Watcher 2026-06-11 00:20:50,625 INFO zuul.Scheduler: Starting scheduler 2026-06-11 00:20:50,625 DEBUG zuul.Scheduler: Statsd enabled 2026-06-11 00:20:50,626 DEBUG zuul.Scheduler: Starting command processor 2026-06-11 00:20:50,626 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-11 00:20:50,626 DEBUG zuul.Scheduler: Run handler awake 2026-06-11 00:20:50,627 DEBUG zuul.Scheduler: Running stats election 2026-06-11 00:20:50,627 INFO apscheduler.scheduler: Scheduler started 2026-06-11 00:20:50,627 DEBUG apscheduler.scheduler: Looking for jobs to run 2026-06-11 00:20:50,628 DEBUG apscheduler.scheduler: No jobs; waiting until a job is added 2026-06-11 00:20:50,630 DEBUG zuul.connection.git.watcher: Walk through projects refs for connection: opendev.org 2026-06-11 00:20:50,631 INFO zuul.Scheduler: Priming scheduler config 2026-06-11 00:20:50,632 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-11 00:20:50,632 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 00:20:50,632 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is None 2026-06-11 00:20:50,633 DEBUG zuul.Scheduler: Won stats election 2026-06-11 00:20:50,638 INFO zuul.Scheduler: Using system config from Zookeeper 2026-06-11 00:20:50,642 DEBUG zuul.Scheduler: Updating system config 2026-06-11 00:20:51,009 DEBUG paramiko.transport: kex engine KexCurve25519 specified hash_algo 2026-06-11 00:20:51,010 DEBUG paramiko.transport: Switch to new keys ... 2026-06-11 00:20:51,010 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'd8a14ebd2baa4427f307f7af6ce79371' warnings.warn( 2026-06-11 00:20:51,735 DEBUG paramiko.transport: Trying discovered key b'bb8e00395e6cabbbb613ccdfe79d5101' in /var/lib/zuul-ssh/..data/priv 2026-06-11 00:20:51,736 DEBUG paramiko.transport: userauth is OK 2026-06-11 00:20:51,736 DEBUG paramiko.transport: Finalizing pubkey algorithm for key of type 'ssh-rsa' 2026-06-11 00:20:51,736 DEBUG paramiko.transport: Our pubkey algorithm list: ['rsa-sha2-512', 'rsa-sha2-256', 'ssh-rsa'] 2026-06-11 00:20:51,736 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 00:20:51,736 DEBUG paramiko.transport: Agreed upon 'rsa-sha2-512' pubkey algorithm 2026-06-11 00:20:51,796 INFO paramiko.transport: Authentication (publickey) successful! 2026-06-11 00:20:51,796 DEBUG paramiko.transport: [chan 0] Max packet in: 32768 bytes 2026-06-11 00:20:51,841 DEBUG paramiko.transport: [chan 0] Max packet out: 32768 bytes 2026-06-11 00:20:51,841 DEBUG paramiko.transport: Secsh channel 0 opened. 2026-06-11 00:20:51,842 DEBUG paramiko.transport: [chan 0] Sesch channel 0 request ok 2026-06-11 00:20:51,928 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-11 00:20:51,936 DEBUG zuul.Scheduler: Wait for internal read tenant lock 2026-06-11 00:20:51,939 DEBUG zuul.Scheduler: Aquired internal read tenant lock 2026-06-11 00:20:52,218 INFO zuul.BranchCache.gerrit: Waiting for branch cache upgrade lock 2026-06-11 00:20:52,397 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/cache/connection/gerrit/project 2026-06-11 00:20:52,411 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/cache/connection/gerrit/project is ready 2026-06-11 00:20:52,411 INFO zuul.BranchCache.gerrit: Cache already upgraded 2026-06-11 00:20:52,981 DEBUG zuul.TenantParser: Using files from cache for project gerrit-sshd.sf/config @master: [] 2026-06-11 00:20:52,982 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 00:20:52,983 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 00:20:52,992 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/config-project.yaml@master 2026-06-11 00:20:52,996 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/container-jobs.yaml@master 2026-06-11 00:20:53,000 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/jobs-base.yaml@master 2026-06-11 00:20:53,002 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/dib-jobs.yaml@master 2026-06-11 00:20:53,005 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/k8s-secret.yaml@master 2026-06-11 00:20:53,006 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/docker-jobs.yaml@master 2026-06-11 00:20:53,009 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/sf-logserver-secret.yaml@master 2026-06-11 00:20:53,010 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/general-jobs.yaml@master 2026-06-11 00:20:53,017 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/go-jobs.yaml@master 2026-06-11 00:20:53,020 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/haskell-jobs.yaml@master 2026-06-11 00:20:53,023 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/helm-jobs.yaml@master 2026-06-11 00:20:53,027 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/js-jobs.yaml@master 2026-06-11 00:20:53,030 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/nim-jobs.yaml@master 2026-06-11 00:20:53,033 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/packer-jobs.yaml@master 2026-06-11 00:20:53,035 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/python-jobs.yaml@master 2026-06-11 00:20:53,044 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/system-jobs.yaml@master 2026-06-11 00:20:53,047 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/terraform-jobs.yaml@master 2026-06-11 00:20:53,091 DEBUG zuul.TenantParser: Created layout id 27302bd48e5d4275bfd5ce4254a782fc 2026-06-11 00:20:53,117 DEBUG zuul.Pipeline.internal.check: Building relative_priority queues 2026-06-11 00:20:53,123 DEBUG zuul.Pipeline.internal.gate: Building shared change queues 2026-06-11 00:20:53,123 DEBUG zuul.Pipeline.internal.gate: Created queue: 2026-06-11 00:20:53,123 DEBUG zuul.Pipeline.internal.gate: Added project config to default queue manager: 2026-06-11 00:20:53,128 DEBUG zuul.Pipeline.internal.post: Building relative_priority queues 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: 2 errors detected during internal tenant configuration loading 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: Zuul encountered a syntax error while parsing its 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: configuration in the repo system-config on branch master. The 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: problem was: 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: Decryption failed 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: The problem appears in the "base" job stanza: 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: job: 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: name: base 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: description: The base job. 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: parent: null 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: post-run: 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: - playbooks/base/post.yaml 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: pre-run: 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: - playbooks/base/pre.yaml 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: roles: 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: ... 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: in "system-config/zuul.d/jobs-base.yaml@master", line 5 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: Zuul encountered a syntax error while parsing its 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: configuration in the repo system-config on branch master. The 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: problem was: 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: Decryption failed 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: The problem appears in the "config-update" job stanza: 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: job: 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: name: config-update 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: description: Deploy config repo update. 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: parent: base 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: secrets: 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: - k8s_config 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: final: true 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: run: 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: - playbooks/config/update.yaml 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: ... 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: 2026-06-11 00:20:53,133 WARNING zuul.ConfigLoader: in "system-config/zuul.d/jobs-base.yaml@master", line 26 2026-06-11 00:20:53,133 DEBUG zuul.GerritConnection: Setting watched checkers to [] 2026-06-11 00:20:53,133 DEBUG zuul.GerritConnection: Setting watched event filters for internal to [, , , , , ] 2026-06-11 00:20:53,133 DEBUG zuul.GerritConnection: Setting watched event filters to {, , , , , } 2026-06-11 00:20:53,133 DEBUG zuul.TimerDriver: No jobs to remove for , 0 remain 2026-06-11 00:20:53,134 DEBUG zuul.Scheduler: Released internal read tenant lock 2026-06-11 00:20:53,136 DEBUG zuul.Scheduler: Wait for demo-tenant read tenant lock 2026-06-11 00:20:53,139 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock 2026-06-11 00:20:53,861 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 00:20:53,862 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 00:20:53,872 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-base-jobs.yaml@master 2026-06-11 00:20:53,877 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-pipeline.yaml@master 2026-06-11 00:20:53,880 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/jobs.yaml@master 2026-06-11 00:20:53,886 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-project-pipeline.yaml@master 2026-06-11 00:20:53,887 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/project.yaml@master 2026-06-11 00:20:53,893 DEBUG zuul.TenantParser: Created layout id 1ae61b1d7eb44832bfbc7088d213fe64 2026-06-11 00:20:53,900 DEBUG zuul.Pipeline.demo-tenant.check: Building relative_priority queues 2026-06-11 00:20:53,909 DEBUG zuul.Pipeline.demo-tenant.gate: Building shared change queues 2026-06-11 00:20:53,909 DEBUG zuul.Pipeline.demo-tenant.gate: Created queue: 2026-06-11 00:20:53,909 DEBUG zuul.Pipeline.demo-tenant.gate: Added project demo-tenant-config to default queue manager: 2026-06-11 00:20:53,909 DEBUG zuul.Pipeline.demo-tenant.gate: Created queue: 2026-06-11 00:20:53,909 DEBUG zuul.Pipeline.demo-tenant.gate: Added project demo-project to default queue manager: 2026-06-11 00:20:53,915 DEBUG zuul.Pipeline.demo-tenant.post: Building relative_priority queues 2026-06-11 00:20:53,920 DEBUG zuul.GerritConnection: Setting watched checkers to [] 2026-06-11 00:20:53,921 DEBUG zuul.GerritConnection: Setting watched event filters for demo-tenant to [, , , , , ] 2026-06-11 00:20:53,921 DEBUG zuul.GerritConnection: Setting watched event filters to {, , , , , } 2026-06-11 00:20:53,921 DEBUG zuul.TimerDriver: No jobs to remove for , 0 remain 2026-06-11 00:20:53,921 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock 2026-06-11 00:20:53,922 INFO zuul.Scheduler: Config priming complete (duration: 3.291 seconds) 2026-06-11 00:20:53,923 DEBUG zuul.Scheduler: Run handler awake 2026-06-11 00:20:53,927 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is None 2026-06-11 00:20:53,927 DEBUG zuul.RendezvousElection: Did not win election for /zuul/events/connection/gerrit/election 2026-06-11 00:20:53,927 DEBUG zuul.RendezvousElection: Did not win election for /zuul/events/connection/gerrit/election 2026-06-11 00:20:53,930 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 2026-06-11 00:20:53,930 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 00:20:53,930 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-11 00:20:53,930 DEBUG zuul.RendezvousElection: Acquiring lock for /zuul/events/connection/gerrit/election 2026-06-11 00:20:53,933 DEBUG zuul.Scheduler: Starting semaphore cleanup 2026-06-11 00:20:53,935 INFO zuul.RendezvousElection: Won election for /zuul/events/connection/gerrit/election 2026-06-11 00:20:53,942 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 00:20:53,943 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 00:20:53,944 DEBUG zuul.Scheduler: Processing tenant management events in demo-tenant 2026-06-11 00:20:53,948 DEBUG zuul.Scheduler: Starting build request cleanup 2026-06-11 00:20:53,948 DEBUG zuul.Scheduler: Finished build request cleanup 2026-06-11 00:20:53,957 DEBUG zuul.Scheduler: Starting node request cleanup 2026-06-11 00:20:53,988 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock 2026-06-11 00:20:53,989 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-11 00:20:53,991 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-11 00:20:54,006 DEBUG zuul.Scheduler: Processing tenant trigger events in demo-tenant 2026-06-11 00:20:54,099 DEBUG zuul.Scheduler: Processing pipeline check in tenant demo-tenant 2026-06-11 00:20:54,106 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant demo-tenant 2026-06-11 00:20:54,112 DEBUG zuul.Scheduler: Processing pipeline gate in tenant demo-tenant 2026-06-11 00:20:54,188 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant demo-tenant 2026-06-11 00:20:54,196 DEBUG zuul.Scheduler: Processing pipeline post in tenant demo-tenant 2026-06-11 00:20:54,207 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant demo-tenant 2026-06-11 00:20:54,210 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock 2026-06-11 00:20:54,216 DEBUG zuul.Scheduler: Processing tenant management events in internal 2026-06-11 00:20:54,220 INFO apscheduler.scheduler: Added job "Scheduler._runSemaphoreCleanup" to job store "default" 2026-06-11 00:20:54,220 INFO apscheduler.scheduler: Added job "Scheduler._runBuildRequestCleanup" to job store "default" 2026-06-11 00:20:54,220 INFO apscheduler.scheduler: Added job "Scheduler._runMergeRequestCleanup" to job store "default" 2026-06-11 00:20:54,220 INFO apscheduler.scheduler: Added job "Scheduler._runConnectionCleanup" to job store "default" 2026-06-11 00:20:54,220 INFO apscheduler.scheduler: Added job "Scheduler._runGeneralCleanup" to job store "default" 2026-06-11 00:20:54,220 DEBUG apscheduler.scheduler: Looking for jobs to run 2026-06-11 00:20:54,221 DEBUG apscheduler.scheduler: Next wakeup is due at 2026-06-11 00:21:50.390048+00:00 (in 56.168558 seconds) 2026-06-11 00:20:54,225 DEBUG zuul.Scheduler: Aquired internal read tenant lock 2026-06-11 00:20:54,229 DEBUG zuul.Scheduler: Processing tenant trigger events in internal 2026-06-11 00:20:54,239 DEBUG zuul.Scheduler: Processing pipeline check in tenant internal 2026-06-11 00:20:54,291 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant internal 2026-06-11 00:20:54,295 DEBUG zuul.Scheduler: Processing pipeline gate in tenant internal 2026-06-11 00:20:54,300 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant internal 2026-06-11 00:20:54,304 DEBUG zuul.Scheduler: Processing pipeline post in tenant internal 2026-06-11 00:20:54,309 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant internal 2026-06-11 00:20:54,310 DEBUG zuul.Scheduler: Released internal read tenant lock 2026-06-11 00:20:54,312 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-11 00:21:47,831 DEBUG zuul.CommandSocket: Accepted socket connection 2026-06-11 00:21:47,831 DEBUG zuul.CommandSocket: Received b'full-reconfigure' from socket 2026-06-11 00:21:47,831 DEBUG zuul.Scheduler: Reconfiguration triggered 2026-06-11 00:21:47,893 DEBUG zuul.Scheduler: Configured logging: 14.1.1.dev1 2026-06-11 00:21:47,893 DEBUG zuul.Scheduler: [e: 6f375cb5f98247d7944cc99055a51279] Submitting reconfiguration event 2026-06-11 00:21:47,897 DEBUG zuul.Scheduler: [e: 6f375cb5f98247d7944cc99055a51279] Waiting for reconfiguration 2026-06-11 00:21:47,897 DEBUG zuul.Scheduler: Run handler awake 2026-06-11 00:21:47,897 DEBUG zuul.Scheduler: Fetching reconfiguration event 2026-06-11 00:21:47,897 INFO zuul.Scheduler: Reconfiguration beginning (smart=False, tenants=None) 2026-06-11 00:21:47,899 INFO zuul.ConfigLoader: Loading configuration from /var/lib/zuul/main.yaml 2026-06-11 00:21:48,099 DEBUG zuul.Scheduler: Wait for internal write tenant lock (id: RECONFIG) 2026-06-11 00:21:48,103 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'd8a14ebd2baa4427f307f7af6ce79371' warnings.warn( 2026-06-11 00:21:50,708 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-5c4577998d-4rh4c0000000005 2026-06-11 00:21:50,708 INFO zuul.ComponentRegistry: Component web zuul-web-5c4577998d-4rh4c0000000005 updated: {'hostname': 'zuul-web-5c4577998d-4rh4c', 'kind': 'web', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-11 00:21:50,708 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-11 00:21:50,713 DEBUG zuul.GerritConnection: SSH command: 2026-06-11 00:21:50,713 DEBUG zuul.GerritConnection: git-upload-pack config 2026-06-11 00:21:50,714 DEBUG zuul.Scheduler: Starting merge request cleanup 2026-06-11 00:21:50,714 DEBUG zuul.Scheduler: Finished merge request cleanup 2026-06-11 00:21:50,763 DEBUG zuul.GerritConnection.io: SSH received stdout: 2026-06-11 00:21:50,763 DEBUG zuul.GerritConnection.io: 00e925fed5b474fe0bec333640e65190ad755cd14650 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 00:21:50,763 DEBUG zuul.GerritConnection.io: 003f25fed5b474fe0bec333640e65190ad755cd14650 refs/heads/master 2026-06-11 00:21:50,763 DEBUG zuul.GerritConnection.io: 003e7de6c52d146493a61b3bc6ab27bb00ee2fb6e115 refs/meta/config 2026-06-11 00:21:50,763 DEBUG zuul.GerritConnection.io: 0000 2026-06-11 00:21:50,763 DEBUG zuul.GerritConnection: SSH exit status: 0 2026-06-11 00:21:50,789 DEBUG zuul.GerritConnection: Fetched 1 branches for config 2026-06-11 00:21:50,789 INFO zuul.GerritConnection: Got branches for config 2026-06-11 00:21:50,791 DEBUG zuul.ComponentRegistry: Registry got event DELETED for web zuul-web-5c4577998d-4rh4c0000000005 2026-06-11 00:21:50,792 INFO zuul.ComponentRegistry: Noticed web component zuul-web-5c4577998d-4rh4c0000000005 disappeared 2026-06-11 00:21:50,792 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-11 00:21:50,800 ERROR zuul.BranchCacheNew.gerrit: Exception loading ZKObject at /zuul/cache/connection/gerrit/project/data/config 2026-06-11 00:21:50,815 INFO zuul.GerritConnection: Got default branch for config: master 2026-06-11 00:21:51,071 DEBUG zuul.MergeClient: Submitting job 3f43040770774ff89924c47c7cf328d9 with data {'connection': 'opendev.org', 'project': 'zuul/zuul-jobs', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']} 2026-06-11 00:21:51,072 DEBUG zuul.MergeClient: Submitting job 267b62bbc7bd44f3ad0559923351b271 with data {'connection': 'git-server', 'project': 'system-config', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']} 2026-06-11 00:21:51,073 DEBUG zuul.MergeClient: Submitting job 66a33308be8a4ee6803b17d6d4a4d62a with data {'connection': 'gerrit', 'project': 'config', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']} 2026-06-11 00:21:51,080 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper 2026-06-11 00:21:51,081 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper 2026-06-11 00:21:51,082 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper 2026-06-11 00:21:51,103 DEBUG zuul.TenantParser: Submitting cat job for opendev.org zuul/zuul-jobs master 2026-06-11 00:21:51,104 DEBUG zuul.TenantParser: Submitting cat job for git-server system-config master 2026-06-11 00:21:51,107 DEBUG zuul.TenantParser: Submitting cat job for gerrit config master 2026-06-11 00:21:51,107 DEBUG zuul.TenantParser: Waiting for cat job 2026-06-11 00:21:51,599 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 00:21:51,599 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/container-jobs.yaml@master 2026-06-11 00:21:51,602 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/dib-jobs.yaml@master 2026-06-11 00:21:51,602 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/docker-jobs.yaml@master 2026-06-11 00:21:51,603 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/general-jobs.yaml@master 2026-06-11 00:21:51,607 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/go-jobs.yaml@master 2026-06-11 00:21:51,609 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/haskell-jobs.yaml@master 2026-06-11 00:21:51,610 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/helm-jobs.yaml@master 2026-06-11 00:21:51,611 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/js-jobs.yaml@master 2026-06-11 00:21:51,615 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/nim-jobs.yaml@master 2026-06-11 00:21:51,615 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/packer-jobs.yaml@master 2026-06-11 00:21:51,616 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/python-jobs.yaml@master 2026-06-11 00:21:51,630 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/system-jobs.yaml@master 2026-06-11 00:21:51,631 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/terraform-jobs.yaml@master 2026-06-11 00:21:52,001 DEBUG zuul.Scheduler: Starting build request cleanup 2026-06-11 00:21:52,001 DEBUG zuul.Scheduler: Finished build request cleanup 2026-06-11 00:21:52,194 DEBUG zuul.TenantParser: Waiting for cat job 2026-06-11 00:21:52,203 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 00:21:52,203 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/config-project.yaml@master 2026-06-11 00:21:52,207 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/jobs-base.yaml@master 2026-06-11 00:21:52,207 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/k8s-secret.yaml@master 2026-06-11 00:21:52,208 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/sf-logserver-secret.yaml@master 2026-06-11 00:21:52,362 DEBUG zuul.TenantParser: Waiting for cat job 2026-06-11 00:21:52,453 DEBUG zuul.TenantParser: Cat job got files dict_keys(['.zuul.yaml', 'zuul.yaml']) 2026-06-11 00:21:52,465 DEBUG zuul.TenantParser: Created layout id 5ca89bdc190c44e5ac638a09f69f887b 2026-06-11 00:21:52,627 DEBUG zuul.Pipeline.internal.check: Building relative_priority queues 2026-06-11 00:21:52,634 DEBUG zuul.Pipeline.internal.gate: Building shared change queues 2026-06-11 00:21:52,634 DEBUG zuul.Pipeline.internal.gate: Created queue: 2026-06-11 00:21:52,634 DEBUG zuul.Pipeline.internal.gate: Added project config to default queue manager: 2026-06-11 00:21:52,689 DEBUG zuul.Pipeline.internal.post: Building relative_priority queues 2026-06-11 00:21:52,698 DEBUG zuul.GerritConnection: Setting watched checkers to [] 2026-06-11 00:21:52,699 DEBUG zuul.GerritConnection: Setting watched event filters for internal to [, , , , , ] 2026-06-11 00:21:52,699 DEBUG zuul.GerritConnection: Setting watched event filters to {, , , , , } 2026-06-11 00:21:52,699 DEBUG zuul.TimerDriver: No jobs to remove for , 0 remain 2026-06-11 00:21:52,718 DEBUG zuul.Scheduler: Setting layout state last reconfigure ltime to 5130 2026-06-11 00:21:52,791 DEBUG zuul.Scheduler: Released internal write tenant lock (id: RECONFIG) 2026-06-11 00:21:52,838 DEBUG zuul.Scheduler: Wait for demo-tenant write tenant lock (id: RECONFIG) 2026-06-11 00:21:52,838 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 00:21:52,839 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 00:21:52,842 DEBUG zuul.Scheduler: Aquired demo-tenant write tenant lock (id: RECONFIG) 2026-06-11 00:21:52,901 DEBUG zuul.GerritConnection: SSH command: 2026-06-11 00:21:52,901 DEBUG zuul.GerritConnection: git-upload-pack demo-tenant-config 2026-06-11 00:21:52,902 DEBUG zuul.GerritConnection: SSH command: 2026-06-11 00:21:52,902 DEBUG zuul.GerritConnection: git-upload-pack demo-project 2026-06-11 00:21:53,015 DEBUG zuul.GerritConnection.io: SSH received stdout: 2026-06-11 00:21:53,015 DEBUG zuul.GerritConnection.io: 00e96cb4fe477f91767db91821d3f799f28d2f248fff 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 00:21:53,015 DEBUG zuul.GerritConnection.io: 003f6cb4fe477f91767db91821d3f799f28d2f248fff refs/heads/master 2026-06-11 00:21:53,015 DEBUG zuul.GerritConnection.io: 003e4a2d8f04de48c7d2e97ce47a6d3e6755529c0ce6 refs/meta/config 2026-06-11 00:21:53,015 DEBUG zuul.GerritConnection.io: 0000 2026-06-11 00:21:53,016 DEBUG zuul.GerritConnection.io: SSH received stdout: 2026-06-11 00:21:53,016 DEBUG zuul.GerritConnection.io: 00e9e91e6806dcd7c03cbbe5931b167e97cd00cfb466 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 00:21:53,016 DEBUG zuul.GerritConnection.io: 003fe91e6806dcd7c03cbbe5931b167e97cd00cfb466 refs/heads/master 2026-06-11 00:21:53,016 DEBUG zuul.GerritConnection.io: 003e9023bb5d9d3c62091270f867550fc64f3b286224 refs/meta/config 2026-06-11 00:21:53,016 DEBUG zuul.GerritConnection.io: 0000 2026-06-11 00:21:53,016 DEBUG zuul.GerritConnection: SSH exit status: 0 2026-06-11 00:21:53,016 DEBUG zuul.GerritConnection: SSH exit status: 0 2026-06-11 00:21:53,017 DEBUG zuul.GerritConnection: Fetched 1 branches for demo-project 2026-06-11 00:21:53,017 DEBUG zuul.GerritConnection: Fetched 1 branches for demo-tenant-config 2026-06-11 00:21:53,018 INFO zuul.GerritConnection: Got branches for demo-project 2026-06-11 00:21:53,018 INFO zuul.GerritConnection: Got branches for demo-tenant-config 2026-06-11 00:21:53,091 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 00:21:53,094 ERROR zuul.BranchCacheNew.gerrit: Exception loading ZKObject at /zuul/cache/connection/gerrit/project/data/demo-tenant-config 2026-06-11 00:21:53,097 ERROR zuul.BranchCacheNew.gerrit: Exception loading ZKObject at /zuul/cache/connection/gerrit/project/data/demo-project 2026-06-11 00:21:53,101 INFO zuul.GerritConnection: Got default branch for demo-tenant-config: master 2026-06-11 00:21:53,105 INFO zuul.GerritConnection: Got default branch for demo-project: master 2026-06-11 00:21:53,204 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 00:21:53,205 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 00:21:53,217 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 00:21:53,328 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 00:21:53,329 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 00:21:53,340 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 00:21:53,453 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 00:21:53,455 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 00:21:53,470 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 00:21:53,584 DEBUG zuul.MergeClient: Submitting job fa78a0e1eae249e5bf62641d3d90ce65 with data {'connection': 'gerrit', 'project': 'demo-tenant-config', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']} 2026-06-11 00:21:53,586 DEBUG zuul.MergeClient: Submitting job 7b597f9a2ee7498ebcdde44fe670ce7f with data {'connection': 'gerrit', 'project': 'demo-project', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']} 2026-06-11 00:21:53,593 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 00:21:53,594 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper 2026-06-11 00:21:53,598 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper 2026-06-11 00:21:53,599 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 00:21:53,622 DEBUG zuul.TenantParser: Submitting cat job for gerrit demo-tenant-config master 2026-06-11 00:21:53,625 DEBUG zuul.TenantParser: Submitting cat job for gerrit demo-project master 2026-06-11 00:21:53,625 DEBUG zuul.TenantParser: Waiting for cat job 2026-06-11 00:21:53,631 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 00:21:53,797 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 00:21:53,797 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 00:21:53,809 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 00:21:53,919 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 00:21:53,920 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 00:21:53,934 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 00:21:54,047 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 00:21:54,048 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 00:21:54,062 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 00:21:54,173 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 00:21:54,174 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 00:21:54,186 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 00:21:54,298 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 00:21:54,299 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 00:21:54,314 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 00:21:54,430 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 00:21:54,430 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 00:21:54,441 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 00:21:54,553 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 00:21:54,554 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 00:21:54,568 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 00:21:54,679 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 00:21:54,679 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 00:21:54,693 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 00:21:54,813 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 00:21:54,814 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 00:21:54,828 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 00:21:54,947 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 00:21:54,948 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 00:21:54,960 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 00:21:54,960 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-base-jobs.yaml@master 2026-06-11 00:21:54,961 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-pipeline.yaml@master 2026-06-11 00:21:54,963 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-project-pipeline.yaml@master 2026-06-11 00:21:54,970 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 00:21:55,097 DEBUG zuul.TenantParser: Waiting for cat job 2026-06-11 00:21:55,114 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 00:21:55,116 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 00:21:55,192 DEBUG zuul.TenantParser: Cat job got files dict_keys(['.zuul.d/jobs.yaml', '.zuul.d/project.yaml', '.zuul.yaml', 'zuul.yaml']) 2026-06-11 00:21:55,193 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/jobs.yaml@master 2026-06-11 00:21:55,193 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/project.yaml@master 2026-06-11 00:21:55,204 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 00:21:55,311 DEBUG zuul.TenantParser: Created layout id 92e599b9b7984331986dc37dd67f1d42 2026-06-11 00:21:55,315 DEBUG zuul.Pipeline.demo-tenant.check: Building relative_priority queues 2026-06-11 00:21:55,322 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 00:21:55,323 DEBUG zuul.Pipeline.demo-tenant.gate: Building shared change queues 2026-06-11 00:21:55,323 DEBUG zuul.Pipeline.demo-tenant.gate: Created queue: 2026-06-11 00:21:55,323 DEBUG zuul.Pipeline.demo-tenant.gate: Added project demo-tenant-config to default queue manager: 2026-06-11 00:21:55,323 DEBUG zuul.Pipeline.demo-tenant.gate: Created queue: 2026-06-11 00:21:55,323 DEBUG zuul.Pipeline.demo-tenant.gate: Added project demo-project to default queue manager: 2026-06-11 00:21:55,324 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 00:21:55,388 DEBUG zuul.Pipeline.demo-tenant.post: Building relative_priority queues 2026-06-11 00:21:55,400 DEBUG zuul.Scheduler.LayoutUpdate: Skipping layout update of locked tenant demo-tenant 2026-06-11 00:21:55,404 DEBUG zuul.GerritConnection: Setting watched checkers to [] 2026-06-11 00:21:55,404 DEBUG zuul.GerritConnection: Setting watched event filters for demo-tenant to [, , , , , ] 2026-06-11 00:21:55,404 DEBUG zuul.GerritConnection: Setting watched event filters to {, , , , , } 2026-06-11 00:21:55,404 DEBUG zuul.TimerDriver: No jobs to remove for , 0 remain 2026-06-11 00:21:55,496 DEBUG zuul.Scheduler: Setting layout state last reconfigure ltime to 5130 2026-06-11 00:21:55,514 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 00:21:55,515 DEBUG zuul.Scheduler: Released demo-tenant write tenant lock (id: RECONFIG) 2026-06-11 00:21:55,515 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 00:21:55,524 INFO zuul.Scheduler: Reconfiguration complete (smart: False, tenants: None, duration: 7.627 seconds) 2026-06-11 00:21:55,524 DEBUG zuul.Scheduler: [e: 6f375cb5f98247d7944cc99055a51279] Reconfiguration complete 2026-06-11 00:21:55,594 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-11 00:21:55,595 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-11 00:21:55,601 DEBUG zuul.Scheduler: Processing tenant management events in internal 2026-06-11 00:21:55,608 DEBUG zuul.Scheduler: Aquired internal read tenant lock 2026-06-11 00:21:55,614 DEBUG zuul.Scheduler: Processing tenant trigger events in internal 2026-06-11 00:21:55,712 DEBUG zuul.Scheduler: Processing pipeline check in tenant internal 2026-06-11 00:21:55,796 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock 2026-06-11 00:21:55,798 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock 2026-06-11 00:21:55,814 DEBUG zuul.Scheduler: Processing management event 2026-06-11 00:21:55,818 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock 2026-06-11 00:21:55,819 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock 2026-06-11 00:21:55,825 DEBUG zuul.Pipeline.internal.check: Starting queue processor: check 2026-06-11 00:21:55,825 DEBUG zuul.Pipeline.internal.check: Finished queue processor: check (changed: False) 2026-06-11 00:21:55,837 DEBUG zuul.Scheduler: Processing pipeline gate in tenant internal 2026-06-11 00:21:55,849 DEBUG zuul.Scheduler: Processing management event 2026-06-11 00:21:55,857 DEBUG zuul.Pipeline.internal.gate: Starting queue processor: gate 2026-06-11 00:21:55,858 DEBUG zuul.Pipeline.internal.gate: Finished queue processor: gate (changed: False) 2026-06-11 00:21:55,867 DEBUG zuul.Scheduler: Processing pipeline post in tenant internal 2026-06-11 00:21:55,904 DEBUG zuul.Scheduler: Processing management event 2026-06-11 00:21:55,912 DEBUG zuul.Pipeline.internal.post: Starting queue processor: post 2026-06-11 00:21:55,912 DEBUG zuul.Pipeline.internal.post: Finished queue processor: post (changed: False) 2026-06-11 00:21:55,918 DEBUG zuul.Scheduler: Released internal read tenant lock 2026-06-11 00:21:55,925 DEBUG zuul.Scheduler: Processing tenant management events in demo-tenant 2026-06-11 00:21:55,931 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock 2026-06-11 00:21:55,936 DEBUG zuul.Scheduler: Processing tenant trigger events in demo-tenant 2026-06-11 00:21:55,949 DEBUG zuul.Scheduler: Processing pipeline check in tenant demo-tenant 2026-06-11 00:21:55,961 DEBUG zuul.Scheduler: Processing management event 2026-06-11 00:21:55,968 DEBUG zuul.Pipeline.demo-tenant.check: Starting queue processor: check 2026-06-11 00:21:55,968 DEBUG zuul.Pipeline.demo-tenant.check: Finished queue processor: check (changed: False) 2026-06-11 00:21:55,979 DEBUG zuul.Scheduler: Processing pipeline gate in tenant demo-tenant 2026-06-11 00:21:55,999 DEBUG zuul.Scheduler: Processing management event 2026-06-11 00:21:56,005 DEBUG zuul.Pipeline.demo-tenant.gate: Starting queue processor: gate 2026-06-11 00:21:56,005 DEBUG zuul.Pipeline.demo-tenant.gate: Finished queue processor: gate (changed: False) 2026-06-11 00:21:56,016 DEBUG zuul.Scheduler: Processing pipeline post in tenant demo-tenant 2026-06-11 00:21:56,090 DEBUG zuul.Scheduler: Processing management event 2026-06-11 00:21:56,096 DEBUG zuul.Pipeline.demo-tenant.post: Starting queue processor: post 2026-06-11 00:21:56,096 DEBUG zuul.Pipeline.demo-tenant.post: Finished queue processor: post (changed: False) 2026-06-11 00:21:56,102 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock 2026-06-11 00:21:56,104 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-11 00:21:56,104 DEBUG zuul.Scheduler: Run handler awake 2026-06-11 00:21:56,113 DEBUG zuul.Scheduler: Processing tenant management events in internal 2026-06-11 00:21:56,118 DEBUG zuul.Scheduler: Aquired internal read tenant lock 2026-06-11 00:21:56,123 DEBUG zuul.Scheduler: Processing tenant trigger events in internal 2026-06-11 00:21:56,198 DEBUG zuul.Scheduler: Processing pipeline check in tenant internal 2026-06-11 00:21:56,201 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant internal 2026-06-11 00:21:56,206 DEBUG zuul.Scheduler: Processing pipeline gate in tenant internal 2026-06-11 00:21:56,209 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant internal 2026-06-11 00:21:56,215 DEBUG zuul.Scheduler: Processing pipeline post in tenant internal 2026-06-11 00:21:56,218 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant internal 2026-06-11 00:21:56,221 DEBUG zuul.Scheduler: Released internal read tenant lock 2026-06-11 00:21:56,229 DEBUG zuul.Scheduler: Processing tenant management events in demo-tenant 2026-06-11 00:21:56,239 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock 2026-06-11 00:21:56,293 DEBUG zuul.Scheduler: Processing tenant trigger events in demo-tenant 2026-06-11 00:21:56,308 DEBUG zuul.Scheduler: Processing pipeline check in tenant demo-tenant 2026-06-11 00:21:56,310 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant demo-tenant 2026-06-11 00:21:56,315 DEBUG zuul.Scheduler: Processing pipeline gate in tenant demo-tenant 2026-06-11 00:21:56,318 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant demo-tenant 2026-06-11 00:21:56,323 DEBUG zuul.Scheduler: Processing pipeline post in tenant demo-tenant 2026-06-11 00:21:56,325 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant demo-tenant 2026-06-11 00:21:56,327 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock 2026-06-11 00:21:56,329 DEBUG zuul.Scheduler: Run handler sleeping 2026-06-11 00:22:02,369 INFO zuul.ComponentRegistry: Noticed new web component zuul-web-5c4577998d-gz8xh0000000006 2026-06-11 00:22:02,370 DEBUG zuul.ComponentRegistry: Registry got event None for web zuul-web-5c4577998d-gz8xh0000000006 2026-06-11 00:22:02,370 INFO zuul.ComponentRegistry: Component web zuul-web-5c4577998d-gz8xh0000000006 updated: {'hostname': 'zuul-web-5c4577998d-gz8xh', 'kind': 'web', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-11 00:22:02,370 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-11 00:22:02,541 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-5c4577998d-gz8xh0000000006 2026-06-11 00:22:02,541 INFO zuul.ComponentRegistry: Component web zuul-web-5c4577998d-gz8xh0000000006 updated: {'hostname': 'zuul-web-5c4577998d-gz8xh', 'kind': 'web', 'model_api': 37, 'state': 'initializing', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-11 00:22:02,541 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-11 00:22:05,683 DEBUG zuul.ComponentRegistry: Registry got event CHANGED for web zuul-web-5c4577998d-gz8xh0000000006 2026-06-11 00:22:05,684 INFO zuul.ComponentRegistry: Component web zuul-web-5c4577998d-gz8xh0000000006 updated: {'hostname': 'zuul-web-5c4577998d-gz8xh', 'kind': 'web', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'} 2026-06-11 00:22:05,684 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is 2026-06-11 00:22:51,038 DEBUG zuul.Scheduler: Starting merge request cleanup 2026-06-11 00:22:51,038 DEBUG zuul.Scheduler: Finished merge request cleanup 2026-06-11 00:22:54,284 DEBUG zuul.Scheduler: Starting build request cleanup 2026-06-11 00:22:54,284 DEBUG zuul.Scheduler: Finished build request cleanup