2026-06-10 10:05:49,594 DEBUG zuul.Scheduler: Configured logging: 13.1.0
2026-06-10 10:05:49,594 DEBUG zuul.TimerDriver: Starting apscheduler
2026-06-10 10:05:49,594 INFO apscheduler.scheduler: Scheduler started
2026-06-10 10:05:49,595 DEBUG apscheduler.scheduler: Looking for jobs to run
2026-06-10 10:05:49,595 DEBUG apscheduler.scheduler: No jobs; waiting until a job is added
2026-06-10 10:05:49,595 DEBUG zuul.BubblewrapDriver: Initializing bubblewrap with oom_score_adj starting: 995, final: 1000
2026-06-10 10:05:49,598 INFO zuul.SQLConnection: Initializing SQL connection database (prefix: )
2026-06-10 10:05:49,894 DEBUG zuul.zk.base.ZooKeeperClient: ZooKeeper connection (session: 0x1000006a8500001): CONNECTED
2026-06-10 10:05:50,002 INFO zuul.Component: Registering component in ZooKeeper /zuul/components/scheduler/zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local
2026-06-10 10:05:50,043 INFO zuul.ComponentRegistry: Noticed new scheduler component zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000000
2026-06-10 10:05:50,056 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f14a2606290> got event None for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000000
2026-06-10 10:05:50,056 INFO zuul.ComponentRegistry: Component scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000000 updated: {'hostname': 'zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local', 'kind': 'scheduler', 'model_api': 36, 'state': 'stopped', 'version': '13.1.0'}
2026-06-10 10:05:50,223 INFO zuul.ComponentRegistry: System minimum data model version 36; this component 36
2026-06-10 10:05:50,280 DEBUG zuul.zk.ZooKeeper: Initialize cache at /keystorage-oidc
2026-06-10 10:05:50,296 DEBUG zuul.zk.ZooKeeper: Cache at /keystorage-oidc is ready
2026-06-10 10:05:50,305 DEBUG zuul.ExecutorQueue: Creating executor queue at root /zuul/executor/unzoned
2026-06-10 10:05:50,523 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/executor/unzoned
2026-06-10 10:05:50,537 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/executor/unzoned is ready
2026-06-10 10:05:50,723 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/merger
2026-06-10 10:05:50,735 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/merger is ready
2026-06-10 10:05:50,810 DEBUG zuul.nodepool: Running nodepool watcher election
2026-06-10 10:05:50,811 DEBUG zuul.TimerDriver: Starting timer election loop
2026-06-10 10:05:50,811 INFO zuul.TimerDriver: Running timer election
2026-06-10 10:05:50,913 INFO zuul.nodepool: Watching nodepool requests
2026-06-10 10:05:50,915 INFO zuul.TimerDriver: Won timer election
2026-06-10 10:05:50,930 DEBUG zuul.SQLConnection: Current migration revision: None
2026-06-10 10:05:56,899 INFO zuul.ComponentRegistry: Noticed new web component zuul-web-67f8dff85-shtwv0000000000
2026-06-10 10:05:56,900 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f14a2606290> got event None for web zuul-web-67f8dff85-shtwv0000000000
2026-06-10 10:05:56,900 INFO zuul.ComponentRegistry: Component web zuul-web-67f8dff85-shtwv0000000000 updated: {'hostname': 'zuul-web-67f8dff85-shtwv', 'kind': 'web', 'model_api': 36, 'state': 'stopped', 'version': '13.1.0'}
2026-06-10 10:06:08,836 DEBUG zuul.GerritConnection: Starting Gerrit Connection/Watchers
2026-06-10 10:06:08,836 DEBUG zuul.GerritConnection: Creating Zookeeper branch cache
2026-06-10 10:06:08,921 ERROR zuul.BranchCache.gerrit: Exception loading ZKObject at /zuul/cache/connection/gerrit/branches/data
2026-06-10 10:06:08,963 INFO zuul.GerritConnection: Creating Zookeeper event queue
2026-06-10 10:06:09,132 DEBUG zuul.GerritConnection: Creating Zookeeper change cache
2026-06-10 10:06:09,173 INFO zuul.GerritConnection: Starting SSH event stream client
2026-06-10 10:06:09,173 INFO zuul.GerritConnection: gerrit: Gerrit Poller is disabled because no HTTP authentication is defined
2026-06-10 10:06:09,174 DEBUG zuul.connection.git: Creating Zookeeper change cache
2026-06-10 10:06:09,199 DEBUG zuul.connection.git: Starting Git Watcher
2026-06-10 10:06:09,200 DEBUG zuul.connection.git: Creating Zookeeper change cache
2026-06-10 10:06:09,210 DEBUG paramiko.transport: starting thread (client mode): 0xa0417410
2026-06-10 10:06:09,210 DEBUG paramiko.transport: Local version/idstring: SSH-2.0-paramiko_4.0.0
2026-06-10 10:06:09,210 DEBUG paramiko.transport: Remote version/idstring: SSH-2.0-GerritCodeReview_3.6.4 (APACHE-SSHD-2.9.2)
2026-06-10 10:06:09,210 INFO paramiko.transport: Connected (version 2.0, client GerritCodeReview_3.6.4)
2026-06-10 10:06:09,211 DEBUG paramiko.transport: === Key exchange possibilities ===
2026-06-10 10:06:09,212 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 10:06:09,212 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 10:06:09,212 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 10:06:09,212 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 10:06:09,212 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 10:06:09,212 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 10:06:09,212 DEBUG paramiko.transport: client compress: none
2026-06-10 10:06:09,212 DEBUG paramiko.transport: server compress: none
2026-06-10 10:06:09,212 DEBUG paramiko.transport: client lang: <none>
2026-06-10 10:06:09,212 DEBUG paramiko.transport: server lang: <none>
2026-06-10 10:06:09,212 DEBUG paramiko.transport: kex follows: False
2026-06-10 10:06:09,212 DEBUG paramiko.transport: === Key exchange agreements ===
2026-06-10 10:06:09,213 DEBUG paramiko.transport: Kex: curve25519-sha256@libssh.org
2026-06-10 10:06:09,213 DEBUG paramiko.transport: HostKey: ssh-ed25519
2026-06-10 10:06:09,213 DEBUG paramiko.transport: Cipher: aes128-ctr
2026-06-10 10:06:09,213 DEBUG paramiko.transport: MAC: hmac-sha2-256
2026-06-10 10:06:09,213 DEBUG paramiko.transport: Compression: none
2026-06-10 10:06:09,213 DEBUG paramiko.transport: === End of kex handshake ===
2026-06-10 10:06:09,216 DEBUG paramiko.transport: kex engine KexCurve25519 specified hash_algo <built-in function openssl_sha256>
2026-06-10 10:06:09,221 DEBUG paramiko.transport: Switch to new keys ...
/usr/local/lib/python3.11/site-packages/paramiko/client.py:885: UserWarning: Unknown ssh-ed25519 host key for [gerrit-sshd.sf]:29418: b'be5273107ff261580c8f76ff20e26d79'
  warnings.warn(
2026-06-10 10:06:09,699 DEBUG paramiko.transport: Got EXT_INFO: {'server-sig-algs': b'ecdsa-sha2-nistp256-cert-v01@openssh.com,ecdsa-sha2-nistp384-cert-v01@openssh.com,ecdsa-sha2-nistp521-cert-v01@openssh.com,ssh-ed25519-cert-v01@openssh.com,rsa-sha2-512-cert-v01@openssh.com,rsa-sha2-256-cert-v01@openssh.com,ecdsa-sha2-nistp256,ecdsa-sha2-nistp384,ecdsa-sha2-nistp521,ssh-ed25519,sk-ecdsa-sha2-nistp256@openssh.com,sk-ssh-ed25519@openssh.com,rsa-sha2-512,rsa-sha2-256,ssh-rsa'}
2026-06-10 10:06:09,701 DEBUG paramiko.transport: Trying discovered key b'2f096ebe5e04a9084616a65c6ec34aac' in /var/lib/zuul-ssh/..data/priv
2026-06-10 10:06:09,702 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f14a2606290> got event CHANGED for web zuul-web-67f8dff85-shtwv0000000000
2026-06-10 10:06:09,702 INFO zuul.ComponentRegistry: Component web zuul-web-67f8dff85-shtwv0000000000 updated: {'hostname': 'zuul-web-67f8dff85-shtwv', 'kind': 'web', 'model_api': 36, 'state': 'initializing', 'version': '13.1.0'}
2026-06-10 10:06:09,702 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is None
2026-06-10 10:06:09,702 DEBUG paramiko.transport: userauth is OK
2026-06-10 10:06:09,702 DEBUG paramiko.transport: Finalizing pubkey algorithm for key of type 'ssh-rsa'
2026-06-10 10:06:09,702 DEBUG paramiko.transport: Our pubkey algorithm list: ['rsa-sha2-512', 'rsa-sha2-256', 'ssh-rsa']
2026-06-10 10:06:09,702 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 10:06:09,703 DEBUG paramiko.transport: Agreed upon 'rsa-sha2-512' pubkey algorithm
2026-06-10 10:06:09,760 DEBUG zuul.connection.git: Starting Git Watcher
2026-06-10 10:06:09,762 INFO zuul.Scheduler: Starting scheduler
2026-06-10 10:06:09,762 DEBUG zuul.Scheduler: Statsd enabled
2026-06-10 10:06:09,762 DEBUG zuul.Scheduler: Starting command processor
2026-06-10 10:06:09,762 DEBUG zuul.Scheduler: Run handler sleeping
2026-06-10 10:06:09,763 DEBUG zuul.Scheduler: Run handler awake
2026-06-10 10:06:09,766 DEBUG zuul.Scheduler: Running stats election
2026-06-10 10:06:09,766 INFO apscheduler.scheduler: Scheduler started
2026-06-10 10:06:09,767 DEBUG apscheduler.scheduler: Looking for jobs to run
2026-06-10 10:06:09,767 DEBUG apscheduler.scheduler: No jobs; waiting until a job is added
2026-06-10 10:06:09,770 INFO paramiko.transport: Authentication (publickey) successful!
2026-06-10 10:06:09,770 DEBUG paramiko.transport: [chan 0] Max packet in: 32768 bytes
2026-06-10 10:06:09,772 DEBUG zuul.connection.git.watcher: Walk through projects refs for connection: git-server
2026-06-10 10:06:09,773 DEBUG paramiko.transport: [chan 0] Max packet out: 32768 bytes
2026-06-10 10:06:09,773 DEBUG paramiko.transport: Secsh channel 0 opened.
2026-06-10 10:06:09,779 DEBUG paramiko.transport: [chan 0] Sesch channel 0 request ok
2026-06-10 10:06:09,781 INFO zuul.Scheduler: Priming scheduler config
2026-06-10 10:06:09,787 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f14a2606290> got event CHANGED for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000000
2026-06-10 10:06:09,787 INFO zuul.ComponentRegistry: Component scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000000 updated: {'hostname': 'zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local', 'kind': 'scheduler', 'model_api': 36, 'state': 'initializing', 'version': '13.1.0'}
2026-06-10 10:06:09,787 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is None
2026-06-10 10:06:09,797 DEBUG zuul.Scheduler: Won stats election
2026-06-10 10:06:09,800 DEBUG zuul.Scheduler: Run handler sleeping
2026-06-10 10:06:09,801 DEBUG zuul.connection.git.watcher: Walk through projects refs for connection: opendev.org
2026-06-10 10:06:09,803 INFO zuul.Scheduler: Creating initial system config
2026-06-10 10:06:09,804 INFO zuul.ConfigLoader: Loading configuration from /var/lib/zuul/main.yaml
2026-06-10 10:06:09,820 DEBUG zuul.Scheduler: Run handler awake
2026-06-10 10:06:09,825 INFO zuul.KeyStorage: Generating a new secrets key for git-server/system-config
2026-06-10 10:06:10,389 INFO zuul.KeyStorage: Generating a new secrets key for gerrit/config
2026-06-10 10:06:10,992 INFO zuul.KeyStorage: Generating a new secrets key for opendev.org/zuul/zuul-jobs
2026-06-10 10:06:11,818 INFO zuul.KeyStorage: Generating a new SSH key for git-server/system-config
2026-06-10 10:06:11,849 INFO zuul.KeyStorage: Generating a new SSH key for gerrit/config
2026-06-10 10:06:11,874 INFO zuul.KeyStorage: Generating a new SSH key for opendev.org/zuul/zuul-jobs
2026-06-10 10:06:11,903 INFO zuul.KeyStorage: Generating a new secrets key for gerrit/demo-tenant-config
2026-06-10 10:06:16,873 INFO zuul.KeyStorage: Generating a new secrets key for gerrit/demo-project
2026-06-10 10:06:18,070 DEBUG zuul.Scheduler: Wait for internal write tenant lock (id: None)
2026-06-10 10:06:18,075 DEBUG zuul.Scheduler: Run handler sleeping
2026-06-10 10:06:18,081 DEBUG zuul.Scheduler: Aquired internal write tenant lock (id: None)
2026-06-10 10:06:18,093 INFO zuul.KeyStorage: Generating a new SSH key for internal
2026-06-10 10:06:18,291 DEBUG paramiko.transport: starting thread (client mode): 0xa02ef610
2026-06-10 10:06:18,292 DEBUG paramiko.transport: Local version/idstring: SSH-2.0-paramiko_4.0.0
2026-06-10 10:06:18,293 DEBUG paramiko.transport: Remote version/idstring: SSH-2.0-GerritCodeReview_3.6.4 (APACHE-SSHD-2.9.2)
2026-06-10 10:06:18,293 INFO paramiko.transport: Connected (version 2.0, client GerritCodeReview_3.6.4)
2026-06-10 10:06:18,296 DEBUG paramiko.transport: === Key exchange possibilities ===
2026-06-10 10:06:18,296 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 10:06:18,296 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 10:06:18,296 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 10:06:18,296 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 10:06:18,296 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 10:06:18,296 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 10:06:18,297 DEBUG paramiko.transport: client compress: none
2026-06-10 10:06:18,297 DEBUG paramiko.transport: server compress: none
2026-06-10 10:06:18,297 DEBUG paramiko.transport: client lang: <none>
2026-06-10 10:06:18,297 DEBUG paramiko.transport: server lang: <none>
2026-06-10 10:06:18,297 DEBUG paramiko.transport: kex follows: False
2026-06-10 10:06:18,297 DEBUG paramiko.transport: === Key exchange agreements ===
2026-06-10 10:06:18,297 DEBUG paramiko.transport: Kex: curve25519-sha256@libssh.org
2026-06-10 10:06:18,297 DEBUG paramiko.transport: HostKey: ssh-ed25519
2026-06-10 10:06:18,297 DEBUG paramiko.transport: Cipher: aes128-ctr
2026-06-10 10:06:18,297 DEBUG paramiko.transport: MAC: hmac-sha2-256
2026-06-10 10:06:18,297 DEBUG paramiko.transport: Compression: none
2026-06-10 10:06:18,297 DEBUG paramiko.transport: === End of kex handshake ===
2026-06-10 10:06:18,356 DEBUG paramiko.transport: kex engine KexCurve25519 specified hash_algo <built-in function openssl_sha256>
2026-06-10 10:06:18,357 DEBUG paramiko.transport: Switch to new keys ...
2026-06-10 10:06:18,357 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'be5273107ff261580c8f76ff20e26d79'
  warnings.warn(
2026-06-10 10:06:19,055 DEBUG paramiko.transport: Trying discovered key b'2f096ebe5e04a9084616a65c6ec34aac' in /var/lib/zuul-ssh/..data/priv
2026-06-10 10:06:19,056 DEBUG paramiko.transport: userauth is OK
2026-06-10 10:06:19,056 DEBUG paramiko.transport: Finalizing pubkey algorithm for key of type 'ssh-rsa'
2026-06-10 10:06:19,056 DEBUG paramiko.transport: Our pubkey algorithm list: ['rsa-sha2-512', 'rsa-sha2-256', 'ssh-rsa']
2026-06-10 10:06:19,056 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 10:06:19,056 DEBUG paramiko.transport: Agreed upon 'rsa-sha2-512' pubkey algorithm
2026-06-10 10:06:19,067 INFO paramiko.transport: Authentication (publickey) successful!
2026-06-10 10:06:19,067 DEBUG zuul.GerritConnection: SSH command:
2026-06-10 10:06:19,067 DEBUG zuul.GerritConnection:   git-upload-pack config
2026-06-10 10:06:19,068 DEBUG paramiko.transport: [chan 0] Max packet in: 32768 bytes
2026-06-10 10:06:19,069 DEBUG paramiko.transport: [chan 0] Max packet out: 32768 bytes
2026-06-10 10:06:19,069 DEBUG paramiko.transport: Secsh channel 0 opened.
2026-06-10 10:06:19,069 DEBUG paramiko.transport: [chan 0] Sesch channel 0 request ok
2026-06-10 10:06:19,118 DEBUG paramiko.transport: [chan 0] EOF received (0)
2026-06-10 10:06:19,118 DEBUG zuul.GerritConnection.io: SSH received stdout:
2026-06-10 10:06:19,118 DEBUG zuul.GerritConnection.io:   00e9a6ba7db52ebbb17072bec92e1f94e1507c079fe8 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 10:06:19,118 DEBUG zuul.GerritConnection.io:   003fa6ba7db52ebbb17072bec92e1f94e1507c079fe8 refs/heads/master
2026-06-10 10:06:19,118 DEBUG zuul.GerritConnection.io:   003e705a4f4e42e80d972b9d88e69a1d3b756a137971 refs/meta/config
2026-06-10 10:06:19,118 DEBUG zuul.GerritConnection.io:   0000
2026-06-10 10:06:19,118 DEBUG zuul.GerritConnection: SSH exit status: 0
2026-06-10 10:06:19,119 DEBUG paramiko.transport: [chan 0] EOF sent (0)
2026-06-10 10:06:19,119 DEBUG zuul.GerritConnection: Fetched 1 branches for config
2026-06-10 10:06:19,119 INFO zuul.GerritConnection: Got branches for config
2026-06-10 10:06:19,144 INFO zuul.GerritConnection: Got default branch for config: master
2026-06-10 10:06:19,601 DEBUG zuul.MergeClient: Submitting job 3b861345018446afb95d18c4c4807c7b with data {'connection': 'git-server', 'project': 'system-config', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']}
2026-06-10 10:06:19,601 DEBUG zuul.MergeClient: Submitting job 041a0c71762d4ee2b9f34d366fc7f004 with data {'connection': 'gerrit', 'project': 'config', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']}
2026-06-10 10:06:19,602 DEBUG zuul.MergeClient: Submitting job 9f4d7e25ee1547879b28aa4d3080495b with data {'connection': 'opendev.org', 'project': 'zuul/zuul-jobs', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']}
2026-06-10 10:06:19,608 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper <MergeRequest 3b861345018446afb95d18c4c4807c7b, job_type=cat, state=requested, path=/zuul/merger/requests/3b861345018446afb95d18c4c4807c7b>
2026-06-10 10:06:19,609 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper <MergeRequest 041a0c71762d4ee2b9f34d366fc7f004, job_type=cat, state=requested, path=/zuul/merger/requests/041a0c71762d4ee2b9f34d366fc7f004>
2026-06-10 10:06:19,610 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper <MergeRequest 9f4d7e25ee1547879b28aa4d3080495b, job_type=cat, state=requested, path=/zuul/merger/requests/9f4d7e25ee1547879b28aa4d3080495b>
2026-06-10 10:06:19,624 DEBUG zuul.TenantParser: Submitting cat job <JobResultFuture request_path=/zuul/merger/requests/3b861345018446afb95d18c4c4807c7b> for git-server system-config master
2026-06-10 10:06:19,627 DEBUG zuul.TenantParser: Submitting cat job <JobResultFuture request_path=/zuul/merger/requests/041a0c71762d4ee2b9f34d366fc7f004> for gerrit config master
2026-06-10 10:06:19,628 DEBUG zuul.TenantParser: Submitting cat job <JobResultFuture request_path=/zuul/merger/requests/9f4d7e25ee1547879b28aa4d3080495b> for opendev.org zuul/zuul-jobs master
2026-06-10 10:06:19,628 DEBUG zuul.TenantParser: Waiting for cat job <JobResultFuture request_path=/zuul/merger/requests/3b861345018446afb95d18c4c4807c7b>
2026-06-10 10:06:30,910 INFO zuul.ComponentRegistry: Noticed new executor component zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000000
2026-06-10 10:06:30,912 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f14a2606290> got event None for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000000
2026-06-10 10:06:30,913 INFO zuul.ComponentRegistry: Component executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000000 updated: {'accepting_work': False, 'allow_unzoned': False, 'hostname': 'zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local', 'kind': 'executor', 'model_api': 36, 'process_merge_jobs': False, 'state': 'stopped', 'version': '13.1.0', 'zone': None}
2026-06-10 10:06:30,913 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is None
2026-06-10 10:06:30,953 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f14a2606290> got event CHANGED for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000000
2026-06-10 10:06:30,953 INFO zuul.ComponentRegistry: Component executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000000 updated: {'accepting_work': False, 'allow_unzoned': False, 'hostname': 'zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local', 'kind': 'executor', 'model_api': 36, 'process_merge_jobs': False, 'state': 'stopped', 'version': '13.1.0', 'zone': None}
2026-06-10 10:06:30,953 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is None
2026-06-10 10:06:30,968 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f14a2606290> got event CHANGED for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000000
2026-06-10 10:06:30,968 INFO zuul.ComponentRegistry: Component executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000000 updated: {'accepting_work': False, 'allow_unzoned': True, 'hostname': 'zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local', 'kind': 'executor', 'model_api': 36, 'process_merge_jobs': False, 'state': 'stopped', 'version': '13.1.0', 'zone': None}
2026-06-10 10:06:30,968 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is None
2026-06-10 10:06:30,981 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f14a2606290> got event CHANGED for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000000
2026-06-10 10:06:30,981 INFO zuul.ComponentRegistry: Component executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000000 updated: {'accepting_work': True, 'allow_unzoned': True, 'hostname': 'zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local', 'kind': 'executor', 'model_api': 36, 'process_merge_jobs': False, 'state': 'stopped', 'version': '13.1.0', 'zone': None}
2026-06-10 10:06:30,981 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is None
2026-06-10 10:06:32,171 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f14a2606290> got event CHANGED for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000000
2026-06-10 10:06:32,171 INFO zuul.ComponentRegistry: Component executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000000 updated: {'accepting_work': True, 'allow_unzoned': True, 'hostname': 'zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local', 'kind': 'executor', 'model_api': 36, 'process_merge_jobs': True, 'state': 'stopped', 'version': '13.1.0', 'zone': None}
2026-06-10 10:06:32,171 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is None
2026-06-10 10:06:32,367 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f14a2606290> got event CHANGED for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000000
2026-06-10 10:06:32,368 INFO zuul.ComponentRegistry: Component executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000000 updated: {'accepting_work': True, 'allow_unzoned': True, 'hostname': 'zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local', 'kind': 'executor', 'model_api': 36, 'process_merge_jobs': True, 'state': 'running', 'version': '13.1.0', 'zone': None}
2026-06-10 10:06:32,368 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is None
2026-06-10 10:06:32,416 INFO zuul.ComponentRegistry: Noticed new merger component zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000000
2026-06-10 10:06:32,420 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f14a2606290> got event None for merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000000
2026-06-10 10:06:32,420 INFO zuul.ComponentRegistry: Component merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000000 updated: {'hostname': 'zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local', 'kind': 'merger', 'model_api': 36, 'state': 'stopped', 'version': '13.1.0'}
2026-06-10 10:06:32,420 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is None
2026-06-10 10:06:32,536 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f14a2606290> got event CHANGED for merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000000
2026-06-10 10:06:32,536 INFO zuul.ComponentRegistry: Component merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000000 updated: {'hostname': 'zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local', 'kind': 'merger', 'model_api': 36, 'state': 'running', 'version': '13.1.0'}
2026-06-10 10:06:32,536 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is None
2026-06-10 10:06:33,536 DEBUG zuul.TenantParser: Cat job <JobResultFuture request_path=/zuul/merger/requests/3b861345018446afb95d18c4c4807c7b> got files dict_keys(['.zuul.yaml', 'zuul.d/config-project.yaml', 'zuul.d/jobs-base.yaml', 'zuul.yaml'])
2026-06-10 10:06:33,537 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/config-project.yaml@master
2026-06-10 10:06:33,541 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/jobs-base.yaml@master
2026-06-10 10:06:33,962 DEBUG zuul.TenantParser: Waiting for cat job <JobResultFuture request_path=/zuul/merger/requests/041a0c71762d4ee2b9f34d366fc7f004>
2026-06-10 10:06:34,873 DEBUG zuul.TenantParser: Cat job <JobResultFuture request_path=/zuul/merger/requests/041a0c71762d4ee2b9f34d366fc7f004> got files dict_keys(['.zuul.yaml', 'zuul.yaml'])
2026-06-10 10:06:34,955 DEBUG zuul.TenantParser: Waiting for cat job <JobResultFuture request_path=/zuul/merger/requests/9f4d7e25ee1547879b28aa4d3080495b>
2026-06-10 10:06:37,478 DEBUG zuul.TenantParser: Cat job <JobResultFuture request_path=/zuul/merger/requests/9f4d7e25ee1547879b28aa4d3080495b> 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 10:06:37,479 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/container-jobs.yaml@master
2026-06-10 10:06:37,480 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/dib-jobs.yaml@master
2026-06-10 10:06:37,480 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/docker-jobs.yaml@master
2026-06-10 10:06:37,481 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/general-jobs.yaml@master
2026-06-10 10:06:37,483 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/go-jobs.yaml@master
2026-06-10 10:06:37,484 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/haskell-jobs.yaml@master
2026-06-10 10:06:37,485 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/helm-jobs.yaml@master
2026-06-10 10:06:37,486 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/js-jobs.yaml@master
2026-06-10 10:06:37,488 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/nim-jobs.yaml@master
2026-06-10 10:06:37,488 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/packer-jobs.yaml@master
2026-06-10 10:06:37,489 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/python-jobs.yaml@master
2026-06-10 10:06:37,499 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/system-jobs.yaml@master
2026-06-10 10:06:37,500 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/terraform-jobs.yaml@master
2026-06-10 10:06:38,594 DEBUG zuul.TenantParser: Created layout id cb02c6e7659e4c9aba23516efbb5f500
2026-06-10 10:06:38,598 DEBUG zuul.Pipeline.internal.check: Building relative_priority queues
2026-06-10 10:06:38,609 ERROR zuul.Pipeline.internal.check: Exception loading ZKObject at /zuul/tenant/internal/pipeline/check
2026-06-10 10:06:38,609 WARNING zuul.Pipeline.internal.check: Initializing pipeline state for check; this is expected only for new pipelines
2026-06-10 10:06:38,668 WARNING zuul.Pipeline.internal.check: Initializing pipeline change list for check; this is expected only for new pipelines
2026-06-10 10:06:38,678 DEBUG zuul.Pipeline.internal.gate: Building shared change queues
2026-06-10 10:06:38,678 DEBUG zuul.Pipeline.internal.gate: Created queue: <zuul.manager.shared.ChangeQueueManager object at 0x7f14a0443c50>
2026-06-10 10:06:38,678 DEBUG zuul.Pipeline.internal.gate: Added project config to queue managers: <zuul.manager.shared.ChangeQueueManager object at 0x7f14a0443c50>
2026-06-10 10:06:38,686 ERROR zuul.Pipeline.internal.gate: Exception loading ZKObject at /zuul/tenant/internal/pipeline/gate
2026-06-10 10:06:38,686 WARNING zuul.Pipeline.internal.gate: Initializing pipeline state for gate; this is expected only for new pipelines
2026-06-10 10:06:38,756 WARNING zuul.Pipeline.internal.gate: Initializing pipeline change list for gate; this is expected only for new pipelines
2026-06-10 10:06:38,775 DEBUG zuul.Pipeline.internal.post: Building relative_priority queues
2026-06-10 10:06:38,786 ERROR zuul.Pipeline.internal.post: Exception loading ZKObject at /zuul/tenant/internal/pipeline/post
2026-06-10 10:06:38,786 WARNING zuul.Pipeline.internal.post: Initializing pipeline state for post; this is expected only for new pipelines
2026-06-10 10:06:38,790 WARNING zuul.Pipeline.internal.post: Initializing pipeline change list for post; this is expected only for new pipelines
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader: 2 errors detected during internal tenant configuration loading
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader: Zuul encountered a syntax error while parsing its
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:   configuration in the repo system-config on branch master.  The
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:   problem was:
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:   
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:     The secret "site_sflogs" was not found.
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:   
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:   The problem appears in the the "base" job stanza:
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:   
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:     job:
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:         name: base
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:         description: The base job.
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:         parent: null
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:         post-run:
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:             - playbooks/base/post.yaml
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:         pre-run:
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:             - playbooks/base/pre.yaml
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:         roles:
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:     ...
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:   
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:     in "system-config/zuul.d/jobs-base.yaml@master", line 5
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader: Zuul encountered a syntax error while parsing its
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:   configuration in the repo system-config on branch master.  The
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:   problem was:
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:   
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:     The secret "k8s_config" was not found.
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:   
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:   The problem appears in the the "config-update" job stanza:
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:   
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:     job:
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:         name: config-update
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:         description: Deploy config repo update.
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:         parent: base
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:         secrets:
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:             - k8s_config
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:         final: true
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:         run:
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:             - playbooks/config/update.yaml
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:     ...
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:   
2026-06-10 10:06:38,864 WARNING zuul.ConfigLoader:     in "system-config/zuul.d/jobs-base.yaml@master", line 26
2026-06-10 10:06:38,973 DEBUG zuul.GerritConnection: Setting watched checkers to []
2026-06-10 10:06:38,973 DEBUG zuul.GerritConnection: Setting watched event filters for internal to [<GerritEventFilter connection: gerrit types: patchset-created ignore_deletes: True>, <GerritEventFilter connection: gerrit types: change-restored ignore_deletes: True>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True comments: (?i)^(Patch Set [0-9]+:)?( [\w\+-]*)*(\n\n)?\s*(recheck|reverify)>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True event_approvals: Workflow:1>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True event_approvals: Verified:1 usernames: zuul>, <GerritEventFilter connection: gerrit types: ref-updated refs: ^refs/heads/master$, ^refs/heads/main$ ignore_deletes: True>]
2026-06-10 10:06:38,973 DEBUG zuul.GerritConnection: Setting watched event filters to {<GerritEventFilter connection: gerrit types: change-restored ignore_deletes: True>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True comments: (?i)^(Patch Set [0-9]+:)?( [\w\+-]*)*(\n\n)?\s*(recheck|reverify)>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True event_approvals: Workflow:1>, <GerritEventFilter connection: gerrit types: patchset-created ignore_deletes: True>, <GerritEventFilter connection: gerrit types: ref-updated refs: ^refs/heads/master$, ^refs/heads/main$ ignore_deletes: True>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True event_approvals: Verified:1 usernames: zuul>}
2026-06-10 10:06:39,174 DEBUG zuul.Scheduler: Run handler awake
2026-06-10 10:06:39,270 DEBUG zuul.Scheduler: Skipping management event queue for tenant internal
2026-06-10 10:06:39,358 DEBUG zuul.Scheduler: Skipping locked tenant internal
2026-06-10 10:06:39,360 DEBUG zuul.Scheduler: Run handler sleeping
2026-06-10 10:06:39,360 DEBUG zuul.Scheduler: Run handler awake
2026-06-10 10:06:39,372 DEBUG zuul.Scheduler: Skipping management event queue for tenant internal
2026-06-10 10:06:39,380 DEBUG zuul.Scheduler: Skipping locked tenant internal
2026-06-10 10:06:39,382 DEBUG zuul.Scheduler: Run handler sleeping
2026-06-10 10:06:39,382 DEBUG zuul.Scheduler: Run handler awake
2026-06-10 10:06:39,463 DEBUG zuul.Scheduler: Skipping management event queue for tenant internal
2026-06-10 10:06:39,557 DEBUG zuul.Scheduler: Skipping locked tenant internal
2026-06-10 10:06:39,558 DEBUG zuul.Scheduler: Run handler sleeping
2026-06-10 10:06:39,558 DEBUG zuul.Scheduler: Run handler awake
2026-06-10 10:06:39,569 DEBUG zuul.Scheduler: Setting layout state last reconfigure ltime to current ltime 528
2026-06-10 10:06:39,570 DEBUG zuul.Scheduler: Skipping management event queue for tenant internal
2026-06-10 10:06:39,578 DEBUG zuul.Scheduler: Skipping locked tenant internal
2026-06-10 10:06:39,579 DEBUG zuul.Scheduler: Run handler sleeping
2026-06-10 10:06:39,579 DEBUG zuul.Scheduler: Run handler awake
2026-06-10 10:06:39,588 DEBUG zuul.GerritConnection: Setting watched checkers to []
2026-06-10 10:06:39,589 DEBUG zuul.GerritConnection: Setting watched event filters for internal to [<GerritEventFilter connection: gerrit types: patchset-created ignore_deletes: True>, <GerritEventFilter connection: gerrit types: change-restored ignore_deletes: True>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True comments: (?i)^(Patch Set [0-9]+:)?( [\w\+-]*)*(\n\n)?\s*(recheck|reverify)>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True event_approvals: Workflow:1>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True event_approvals: Verified:1 usernames: zuul>, <GerritEventFilter connection: gerrit types: ref-updated refs: ^refs/heads/master$, ^refs/heads/main$ ignore_deletes: True>]
2026-06-10 10:06:39,589 DEBUG zuul.GerritConnection: Setting watched event filters to {<GerritEventFilter connection: gerrit types: change-restored ignore_deletes: True>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True comments: (?i)^(Patch Set [0-9]+:)?( [\w\+-]*)*(\n\n)?\s*(recheck|reverify)>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True event_approvals: Workflow:1>, <GerritEventFilter connection: gerrit types: patchset-created ignore_deletes: True>, <GerritEventFilter connection: gerrit types: ref-updated refs: ^refs/heads/master$, ^refs/heads/main$ ignore_deletes: True>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True event_approvals: Verified:1 usernames: zuul>}
2026-06-10 10:06:39,589 DEBUG zuul.Scheduler: Released internal write tenant lock (id: None)
2026-06-10 10:06:39,592 DEBUG zuul.Scheduler: Wait for demo-tenant write tenant lock (id: None)
2026-06-10 10:06:39,592 DEBUG zuul.Scheduler: Processing tenant management events in internal
2026-06-10 10:06:39,681 DEBUG zuul.Scheduler: Aquired demo-tenant write tenant lock (id: None)
2026-06-10 10:06:39,697 DEBUG zuul.GerritConnection: SSH command:
2026-06-10 10:06:39,697 DEBUG zuul.GerritConnection:   git-upload-pack demo-tenant-config
2026-06-10 10:06:39,697 DEBUG paramiko.transport: [chan 1] Max packet in: 32768 bytes
2026-06-10 10:06:39,697 DEBUG zuul.Scheduler: Aquired internal read tenant lock
2026-06-10 10:06:39,698 DEBUG zuul.GerritConnection: SSH command:
2026-06-10 10:06:39,698 DEBUG zuul.GerritConnection:   git-upload-pack demo-project
2026-06-10 10:06:39,698 DEBUG paramiko.transport: [chan 2] Max packet in: 32768 bytes
2026-06-10 10:06:39,699 DEBUG paramiko.transport: [chan 1] Max packet out: 32768 bytes
2026-06-10 10:06:39,699 DEBUG paramiko.transport: Secsh channel 1 opened.
2026-06-10 10:06:39,700 DEBUG paramiko.transport: [chan 2] Max packet out: 32768 bytes
2026-06-10 10:06:39,700 DEBUG paramiko.transport: Secsh channel 2 opened.
2026-06-10 10:06:39,700 DEBUG paramiko.transport: [chan 1] Sesch channel 1 request ok
2026-06-10 10:06:39,706 DEBUG paramiko.transport: [chan 1] EOF received (1)
2026-06-10 10:06:39,706 DEBUG zuul.GerritConnection.io: SSH received stdout:
2026-06-10 10:06:39,706 DEBUG zuul.GerritConnection.io:   00e9492eb5645d23dda3fb5211306f8a32552e268bc4 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 10:06:39,706 DEBUG zuul.GerritConnection.io:   003f492eb5645d23dda3fb5211306f8a32552e268bc4 refs/heads/master
2026-06-10 10:06:39,706 DEBUG zuul.GerritConnection.io:   003eb72b9943fd2a07577a7198145d11b8cade978e52 refs/meta/config
2026-06-10 10:06:39,706 DEBUG zuul.GerritConnection.io:   0000
2026-06-10 10:06:39,711 INFO zuul.KeyStorage: Generating a new SSH key for demo-tenant
2026-06-10 10:06:39,760 DEBUG paramiko.transport: [chan 1] EOF sent (1)
2026-06-10 10:06:39,761 DEBUG paramiko.transport: [chan 2] Sesch channel 2 request ok
2026-06-10 10:06:39,763 DEBUG zuul.GerritConnection: SSH exit status: 0
2026-06-10 10:06:39,763 DEBUG zuul.GerritConnection: Fetched 1 branches for demo-tenant-config
2026-06-10 10:06:39,763 INFO zuul.GerritConnection: Got branches for demo-tenant-config
2026-06-10 10:06:39,780 DEBUG zuul.Scheduler: Processing tenant trigger events in internal
2026-06-10 10:06:39,790 INFO zuul.GerritConnection: Got default branch for demo-tenant-config: master
2026-06-10 10:06:39,804 DEBUG paramiko.transport: [chan 2] EOF received (2)
2026-06-10 10:06:39,804 DEBUG zuul.GerritConnection.io: SSH received stdout:
2026-06-10 10:06:39,804 DEBUG zuul.GerritConnection.io:   00e96cec53985d85a8acd4d263a6c06830c50872ee4d 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 10:06:39,804 DEBUG zuul.GerritConnection.io:   003f6cec53985d85a8acd4d263a6c06830c50872ee4d refs/heads/master
2026-06-10 10:06:39,804 DEBUG zuul.GerritConnection.io:   003e814e30514af86d9e8ee7c254bc80687bf359a774 refs/meta/config
2026-06-10 10:06:39,804 DEBUG zuul.GerritConnection.io:   0000
2026-06-10 10:06:39,844 DEBUG paramiko.transport: [chan 2] EOF sent (2)
2026-06-10 10:06:39,844 DEBUG zuul.GerritConnection: SSH exit status: 0
2026-06-10 10:06:39,844 DEBUG zuul.GerritConnection: Fetched 1 branches for demo-project
2026-06-10 10:06:39,845 INFO zuul.GerritConnection: Got branches for demo-project
2026-06-10 10:06:39,857 DEBUG zuul.Scheduler: Processing pipeline check in tenant internal
2026-06-10 10:06:39,864 WARNING zuul.PipelineSummary: No pipeline summary found (may not be created yet)
2026-06-10 10:06:39,868 DEBUG zuul.Scheduler: Processing management event <zuul.model.PipelinePostConfigEvent object at 0x7f14a026aad0>
2026-06-10 10:06:39,876 DEBUG zuul.Pipeline.internal.check: Starting queue processor: check
2026-06-10 10:06:39,876 DEBUG zuul.Pipeline.internal.check: Finished queue processor: check (changed: False)
2026-06-10 10:06:39,894 DEBUG zuul.Scheduler: Processing pipeline gate in tenant internal
2026-06-10 10:06:39,961 WARNING zuul.PipelineSummary: No pipeline summary found (may not be created yet)
2026-06-10 10:06:39,968 DEBUG zuul.Scheduler: Processing management event <zuul.model.PipelinePostConfigEvent object at 0x7f14a026a0d0>
2026-06-10 10:06:39,985 INFO zuul.GerritConnection: Got default branch for demo-project: master
2026-06-10 10:06:39,990 DEBUG zuul.Pipeline.internal.gate: Starting queue processor: gate
2026-06-10 10:06:39,990 DEBUG zuul.Pipeline.internal.gate: Finished queue processor: gate (changed: False)
2026-06-10 10:06:40,073 DEBUG zuul.Scheduler: Processing pipeline post in tenant internal
2026-06-10 10:06:40,078 WARNING zuul.PipelineSummary: No pipeline summary found (may not be created yet)
2026-06-10 10:06:40,083 DEBUG zuul.Scheduler: Processing management event <zuul.model.PipelinePostConfigEvent object at 0x7f14a048bdd0>
2026-06-10 10:06:40,157 DEBUG zuul.Pipeline.internal.post: Starting queue processor: post
2026-06-10 10:06:40,157 DEBUG zuul.Pipeline.internal.post: Finished queue processor: post (changed: False)
2026-06-10 10:06:40,177 DEBUG zuul.Scheduler: Released internal read tenant lock
2026-06-10 10:06:40,179 DEBUG zuul.Scheduler: Run handler sleeping
2026-06-10 10:06:40,179 DEBUG zuul.Scheduler: Run handler awake
2026-06-10 10:06:40,188 DEBUG zuul.Scheduler: Processing tenant management events in internal
2026-06-10 10:06:40,195 DEBUG zuul.Scheduler: Aquired internal read tenant lock
2026-06-10 10:06:40,263 DEBUG zuul.Scheduler: Processing tenant trigger events in internal
2026-06-10 10:06:40,274 DEBUG zuul.Scheduler: Processing pipeline check in tenant internal
2026-06-10 10:06:40,275 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant internal
2026-06-10 10:06:40,279 DEBUG zuul.Scheduler: Processing pipeline gate in tenant internal
2026-06-10 10:06:40,281 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant internal
2026-06-10 10:06:40,285 DEBUG zuul.Scheduler: Processing pipeline post in tenant internal
2026-06-10 10:06:40,290 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant internal
2026-06-10 10:06:40,291 DEBUG zuul.Scheduler: Released internal read tenant lock
2026-06-10 10:06:40,294 DEBUG zuul.Scheduler: Run handler sleeping
2026-06-10 10:06:40,366 DEBUG zuul.MergeClient: Submitting job 9342ee9c45b046d7ac88cc1657fa17a6 with data {'connection': 'gerrit', 'project': 'demo-tenant-config', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']}
2026-06-10 10:06:40,367 DEBUG zuul.MergeClient: Submitting job 5957e925ab8b4225a3b4268555f5a227 with data {'connection': 'gerrit', 'project': 'demo-project', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']}
2026-06-10 10:06:40,373 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper <MergeRequest 9342ee9c45b046d7ac88cc1657fa17a6, job_type=cat, state=requested, path=/zuul/merger/requests/9342ee9c45b046d7ac88cc1657fa17a6>
2026-06-10 10:06:40,374 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper <MergeRequest 5957e925ab8b4225a3b4268555f5a227, job_type=cat, state=requested, path=/zuul/merger/requests/5957e925ab8b4225a3b4268555f5a227>
2026-06-10 10:06:40,457 DEBUG zuul.TenantParser: Submitting cat job <JobResultFuture request_path=/zuul/merger/requests/9342ee9c45b046d7ac88cc1657fa17a6> for gerrit demo-tenant-config master
2026-06-10 10:06:40,458 DEBUG zuul.TenantParser: Submitting cat job <JobResultFuture request_path=/zuul/merger/requests/5957e925ab8b4225a3b4268555f5a227> for gerrit demo-project master
2026-06-10 10:06:40,459 DEBUG zuul.TenantParser: Waiting for cat job <JobResultFuture request_path=/zuul/merger/requests/9342ee9c45b046d7ac88cc1657fa17a6>
2026-06-10 10:06:42,080 DEBUG zuul.TenantParser: Cat job <JobResultFuture request_path=/zuul/merger/requests/9342ee9c45b046d7ac88cc1657fa17a6> 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 10:06:42,081 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-base-jobs.yaml@master
2026-06-10 10:06:42,082 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-pipeline.yaml@master
2026-06-10 10:06:42,087 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-project-pipeline.yaml@master
2026-06-10 10:06:42,365 DEBUG zuul.TenantParser: Waiting for cat job <JobResultFuture request_path=/zuul/merger/requests/5957e925ab8b4225a3b4268555f5a227>
2026-06-10 10:06:42,391 DEBUG zuul.TenantParser: Cat job <JobResultFuture request_path=/zuul/merger/requests/5957e925ab8b4225a3b4268555f5a227> got files dict_keys(['.zuul.d/jobs.yaml', '.zuul.d/project.yaml', '.zuul.yaml', 'zuul.yaml'])
2026-06-10 10:06:42,391 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/jobs.yaml@master
2026-06-10 10:06:42,393 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/project.yaml@master
2026-06-10 10:06:42,566 DEBUG zuul.TenantParser: Created layout id 16bc2e2817ad4d8793d6d97c3a1eb6bc
2026-06-10 10:06:42,570 DEBUG zuul.Pipeline.demo-tenant.check: Building relative_priority queues
2026-06-10 10:06:42,581 ERROR zuul.Pipeline.demo-tenant.check: Exception loading ZKObject at /zuul/tenant/demo-tenant/pipeline/check
2026-06-10 10:06:42,581 WARNING zuul.Pipeline.demo-tenant.check: Initializing pipeline state for check; this is expected only for new pipelines
2026-06-10 10:06:42,659 WARNING zuul.Pipeline.demo-tenant.check: Initializing pipeline change list for check; this is expected only for new pipelines
2026-06-10 10:06:42,672 DEBUG zuul.Pipeline.demo-tenant.gate: Building shared change queues
2026-06-10 10:06:42,672 DEBUG zuul.Pipeline.demo-tenant.gate: Created queue: <zuul.manager.shared.ChangeQueueManager object at 0x7f14a026b950>
2026-06-10 10:06:42,672 DEBUG zuul.Pipeline.demo-tenant.gate: Added project demo-tenant-config to queue managers: <zuul.manager.shared.ChangeQueueManager object at 0x7f14a026b950>
2026-06-10 10:06:42,672 DEBUG zuul.Pipeline.demo-tenant.gate: Created queue: <zuul.manager.shared.ChangeQueueManager object at 0x7f14a0316350>
2026-06-10 10:06:42,672 DEBUG zuul.Pipeline.demo-tenant.gate: Added project demo-project to queue managers: <zuul.manager.shared.ChangeQueueManager object at 0x7f14a0316350>
2026-06-10 10:06:42,684 ERROR zuul.Pipeline.demo-tenant.gate: Exception loading ZKObject at /zuul/tenant/demo-tenant/pipeline/gate
2026-06-10 10:06:42,685 WARNING zuul.Pipeline.demo-tenant.gate: Initializing pipeline state for gate; this is expected only for new pipelines
2026-06-10 10:06:42,690 WARNING zuul.Pipeline.demo-tenant.gate: Initializing pipeline change list for gate; this is expected only for new pipelines
2026-06-10 10:06:42,765 DEBUG zuul.Pipeline.demo-tenant.post: Building relative_priority queues
2026-06-10 10:06:42,781 ERROR zuul.Pipeline.demo-tenant.post: Exception loading ZKObject at /zuul/tenant/demo-tenant/pipeline/post
2026-06-10 10:06:42,781 WARNING zuul.Pipeline.demo-tenant.post: Initializing pipeline state for post; this is expected only for new pipelines
2026-06-10 10:06:42,787 WARNING zuul.Pipeline.demo-tenant.post: Initializing pipeline change list for post; this is expected only for new pipelines
2026-06-10 10:06:43,001 DEBUG zuul.GerritConnection: Setting watched checkers to []
2026-06-10 10:06:43,001 DEBUG zuul.GerritConnection: Setting watched event filters for demo-tenant to [<GerritEventFilter connection: gerrit types: patchset-created ignore_deletes: True>, <GerritEventFilter connection: gerrit types: change-restored ignore_deletes: True>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True comments: (?i)^(Patch Set [0-9]+:)?( [\w\+-]*)*(\n\n)?\s*(recheck|reverify)>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True event_approvals: Workflow:1>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True event_approvals: Verified:1 usernames: zuul>, <GerritEventFilter connection: gerrit types: ref-updated refs: ^refs/heads/master$, ^refs/heads/main$ ignore_deletes: True>]
2026-06-10 10:06:43,001 DEBUG zuul.GerritConnection: Setting watched event filters to {<GerritEventFilter connection: gerrit types: change-restored ignore_deletes: True>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True comments: (?i)^(Patch Set [0-9]+:)?( [\w\+-]*)*(\n\n)?\s*(recheck|reverify)>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True event_approvals: Workflow:1>, <GerritEventFilter connection: gerrit types: patchset-created ignore_deletes: True>, <GerritEventFilter connection: gerrit types: ref-updated refs: ^refs/heads/master$, ^refs/heads/main$ ignore_deletes: True>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True event_approvals: Verified:1 usernames: zuul>}
2026-06-10 10:06:43,099 DEBUG zuul.Scheduler: Run handler awake
2026-06-10 10:06:43,160 DEBUG zuul.Scheduler: Processing tenant management events in internal
2026-06-10 10:06:43,377 DEBUG zuul.Scheduler: Aquired internal read tenant lock
2026-06-10 10:06:43,392 DEBUG zuul.Scheduler: Processing tenant trigger events in internal
2026-06-10 10:06:43,474 DEBUG zuul.Scheduler: Processing pipeline check in tenant internal
2026-06-10 10:06:43,480 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant internal
2026-06-10 10:06:43,489 DEBUG zuul.Scheduler: Processing pipeline gate in tenant internal
2026-06-10 10:06:43,557 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant internal
2026-06-10 10:06:43,570 DEBUG zuul.Scheduler: Processing pipeline post in tenant internal
2026-06-10 10:06:43,584 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant internal
2026-06-10 10:06:43,591 DEBUG zuul.Scheduler: Released internal read tenant lock
2026-06-10 10:06:43,659 DEBUG zuul.Scheduler: Setting layout state last reconfigure ltime to current ltime 802
2026-06-10 10:06:43,663 DEBUG zuul.Scheduler: Skipping management event queue for tenant demo-tenant
2026-06-10 10:06:43,673 DEBUG zuul.Scheduler: Skipping locked tenant demo-tenant
2026-06-10 10:06:43,675 DEBUG zuul.Scheduler: Run handler sleeping
2026-06-10 10:06:43,675 DEBUG zuul.Scheduler: Run handler awake
2026-06-10 10:06:43,680 DEBUG zuul.GerritConnection: Setting watched checkers to []
2026-06-10 10:06:43,680 DEBUG zuul.GerritConnection: Setting watched event filters for demo-tenant to [<GerritEventFilter connection: gerrit types: patchset-created ignore_deletes: True>, <GerritEventFilter connection: gerrit types: change-restored ignore_deletes: True>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True comments: (?i)^(Patch Set [0-9]+:)?( [\w\+-]*)*(\n\n)?\s*(recheck|reverify)>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True event_approvals: Workflow:1>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True event_approvals: Verified:1 usernames: zuul>, <GerritEventFilter connection: gerrit types: ref-updated refs: ^refs/heads/master$, ^refs/heads/main$ ignore_deletes: True>]
2026-06-10 10:06:43,680 DEBUG zuul.GerritConnection: Setting watched event filters to {<GerritEventFilter connection: gerrit types: change-restored ignore_deletes: True>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True comments: (?i)^(Patch Set [0-9]+:)?( [\w\+-]*)*(\n\n)?\s*(recheck|reverify)>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True event_approvals: Workflow:1>, <GerritEventFilter connection: gerrit types: patchset-created ignore_deletes: True>, <GerritEventFilter connection: gerrit types: ref-updated refs: ^refs/heads/master$, ^refs/heads/main$ ignore_deletes: True>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True event_approvals: Verified:1 usernames: zuul>}
2026-06-10 10:06:43,680 DEBUG zuul.Scheduler: Released demo-tenant write tenant lock (id: None)
2026-06-10 10:06:43,683 INFO zuul.Scheduler: Config priming complete (duration: 33.901 seconds)
2026-06-10 10:06:43,686 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is None
2026-06-10 10:06:43,686 DEBUG zuul.RendezvousElection: Did not win election for /zuul/events/connection/gerrit/election
2026-06-10 10:06:43,686 DEBUG zuul.RendezvousElection: Did not win election for /zuul/events/connection/gerrit/election
2026-06-10 10:06:43,688 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f14a2606290> got event CHANGED for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000000
2026-06-10 10:06:43,689 INFO zuul.ComponentRegistry: Component scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000000 updated: {'hostname': 'zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local', 'kind': 'scheduler', 'model_api': 36, 'state': 'running', 'version': '13.1.0'}
2026-06-10 10:06:43,689 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is <SchedulerComponent {'hostname': 'zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local', 'state': 'running', 'kind': 'scheduler', 'version': '13.1.0', 'model_api': 36}>
2026-06-10 10:06:43,689 DEBUG zuul.RendezvousElection: Acquiring lock for /zuul/events/connection/gerrit/election
2026-06-10 10:06:43,763 DEBUG zuul.Scheduler: Processing tenant management events in internal
2026-06-10 10:06:43,764 INFO zuul.RendezvousElection: Won election for /zuul/events/connection/gerrit/election
2026-06-10 10:06:43,777 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock
2026-06-10 10:06:43,779 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock
2026-06-10 10:06:43,860 DEBUG zuul.Scheduler: Aquired internal read tenant lock
2026-06-10 10:06:43,870 DEBUG zuul.Scheduler: Starting semaphore cleanup
2026-06-10 10:06:43,882 DEBUG zuul.Scheduler: Processing tenant trigger events in internal
2026-06-10 10:06:43,883 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock
2026-06-10 10:06:43,886 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock
2026-06-10 10:06:43,970 DEBUG zuul.Scheduler: Starting build request cleanup
2026-06-10 10:06:43,970 DEBUG zuul.Scheduler: Finished build request cleanup
2026-06-10 10:06:44,003 DEBUG zuul.Scheduler: Starting node request cleanup
2026-06-10 10:06:44,072 DEBUG zuul.Scheduler: Skipping locked pipeline check in tenant internal
2026-06-10 10:06:44,105 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock
2026-06-10 10:06:44,111 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock
2026-06-10 10:06:44,167 DEBUG zuul.Scheduler: Skipping locked pipeline gate in tenant internal
2026-06-10 10:06:44,179 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock
2026-06-10 10:06:44,181 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock
2026-06-10 10:06:44,181 DEBUG zuul.Scheduler: Processing pipeline post in tenant internal
2026-06-10 10:06:44,185 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant internal
2026-06-10 10:06:44,187 DEBUG zuul.Scheduler: Released internal read tenant lock
2026-06-10 10:06:44,259 DEBUG zuul.Scheduler: Processing tenant management events in demo-tenant
2026-06-10 10:06:44,272 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock
2026-06-10 10:06:44,358 DEBUG zuul.Scheduler: Processing tenant trigger events in demo-tenant
2026-06-10 10:06:44,398 INFO apscheduler.scheduler: Added job "Scheduler._runSemaphoreCleanup" to job store "default"
2026-06-10 10:06:44,398 DEBUG apscheduler.scheduler: Looking for jobs to run
2026-06-10 10:06:44,399 DEBUG apscheduler.scheduler: Next wakeup is due at 2026-06-10 11:06:10.341005+00:00 (in 3565.941959 seconds)
2026-06-10 10:06:44,399 INFO apscheduler.scheduler: Added job "Scheduler._runBuildRequestCleanup" to job store "default"
2026-06-10 10:06:44,399 INFO apscheduler.scheduler: Added job "Scheduler._runMergeRequestCleanup" to job store "default"
2026-06-10 10:06:44,399 INFO apscheduler.scheduler: Added job "Scheduler._runConnectionCleanup" to job store "default"
2026-06-10 10:06:44,400 INFO apscheduler.scheduler: Added job "Scheduler._runGeneralCleanup" to job store "default"
2026-06-10 10:06:44,400 DEBUG apscheduler.scheduler: Looking for jobs to run
2026-06-10 10:06:44,400 DEBUG apscheduler.scheduler: Next wakeup is due at 2026-06-10 10:06:50.221140+00:00 (in 5.820725 seconds)
2026-06-10 10:06:44,419 DEBUG zuul.Scheduler: Processing pipeline check in tenant demo-tenant
2026-06-10 10:06:44,460 WARNING zuul.PipelineSummary: No pipeline summary found (may not be created yet)
2026-06-10 10:06:44,465 DEBUG zuul.Scheduler: Processing management event <zuul.model.PipelinePostConfigEvent object at 0x7f14a0231390>
2026-06-10 10:06:44,472 DEBUG zuul.Pipeline.demo-tenant.check: Starting queue processor: check
2026-06-10 10:06:44,472 DEBUG zuul.Pipeline.demo-tenant.check: Finished queue processor: check (changed: False)
2026-06-10 10:06:44,495 DEBUG zuul.Scheduler: Processing pipeline gate in tenant demo-tenant
2026-06-10 10:06:44,501 WARNING zuul.PipelineSummary: No pipeline summary found (may not be created yet)
2026-06-10 10:06:44,505 DEBUG zuul.Scheduler: Processing management event <zuul.model.PipelinePostConfigEvent object at 0x7f14a0247850>
2026-06-10 10:06:44,512 DEBUG zuul.Pipeline.demo-tenant.gate: Starting queue processor: gate
2026-06-10 10:06:44,512 DEBUG zuul.Pipeline.demo-tenant.gate: Finished queue processor: gate (changed: False)
2026-06-10 10:06:44,557 DEBUG zuul.Scheduler: Processing pipeline post in tenant demo-tenant
2026-06-10 10:06:44,564 WARNING zuul.PipelineSummary: No pipeline summary found (may not be created yet)
2026-06-10 10:06:44,568 DEBUG zuul.Scheduler: Processing management event <zuul.model.PipelinePostConfigEvent object at 0x7f14a0232990>
2026-06-10 10:06:44,577 DEBUG zuul.Pipeline.demo-tenant.post: Starting queue processor: post
2026-06-10 10:06:44,578 DEBUG zuul.Pipeline.demo-tenant.post: Finished queue processor: post (changed: False)
2026-06-10 10:06:44,597 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock
2026-06-10 10:06:44,658 DEBUG zuul.Scheduler: Run handler sleeping
2026-06-10 10:06:44,659 DEBUG zuul.Scheduler: Run handler awake
2026-06-10 10:06:44,672 DEBUG zuul.Scheduler: Processing tenant management events in internal
2026-06-10 10:06:44,682 DEBUG zuul.Scheduler: Aquired internal read tenant lock
2026-06-10 10:06:44,689 DEBUG zuul.Scheduler: Processing tenant trigger events in internal
2026-06-10 10:06:44,770 DEBUG zuul.Scheduler: Processing pipeline check in tenant internal
2026-06-10 10:06:44,774 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant internal
2026-06-10 10:06:44,784 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f14a2606290> got event CHANGED for web zuul-web-67f8dff85-shtwv0000000000
2026-06-10 10:06:44,784 INFO zuul.ComponentRegistry: Component web zuul-web-67f8dff85-shtwv0000000000 updated: {'hostname': 'zuul-web-67f8dff85-shtwv', 'kind': 'web', 'model_api': 36, 'state': 'running', 'version': '13.1.0'}
2026-06-10 10:06:44,784 DEBUG zuul.RendezvousElection: Election winner for /zuul/events/connection/gerrit/election is <SchedulerComponent {'hostname': 'zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local', 'state': 'running', 'kind': 'scheduler', 'version': '13.1.0', 'model_api': 36}>
2026-06-10 10:06:44,786 DEBUG zuul.Scheduler: Processing pipeline gate in tenant internal
2026-06-10 10:06:44,790 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant internal
2026-06-10 10:06:44,859 DEBUG zuul.Scheduler: Processing pipeline post in tenant internal
2026-06-10 10:06:44,861 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant internal
2026-06-10 10:06:44,863 DEBUG zuul.Scheduler: Released internal read tenant lock
2026-06-10 10:06:44,871 DEBUG zuul.Scheduler: Processing tenant management events in demo-tenant
2026-06-10 10:06:44,879 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock
2026-06-10 10:06:44,885 DEBUG zuul.Scheduler: Processing tenant trigger events in demo-tenant
2026-06-10 10:06:44,972 DEBUG zuul.Scheduler: Processing pipeline check in tenant demo-tenant
2026-06-10 10:06:44,975 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant demo-tenant
2026-06-10 10:06:44,981 DEBUG zuul.Scheduler: Processing pipeline gate in tenant demo-tenant
2026-06-10 10:06:44,984 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant demo-tenant
2026-06-10 10:06:44,990 DEBUG zuul.Scheduler: Processing pipeline post in tenant demo-tenant
2026-06-10 10:06:44,992 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant demo-tenant
2026-06-10 10:06:44,994 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock
2026-06-10 10:06:45,058 DEBUG zuul.Scheduler: Run handler sleeping
2026-06-10 10:06:50,221 DEBUG apscheduler.scheduler: Looking for jobs to run
2026-06-10 10:06:50,222 INFO apscheduler.executors.default: Running job "Scheduler._runMergeRequestCleanup (trigger: interval[0:01:00], next run at: 2026-06-10 10:06:50 UTC)" (scheduled at 2026-06-10 10:06:50.221140+00:00)
2026-06-10 10:06:50,222 DEBUG apscheduler.scheduler: Next wakeup is due at 2026-06-10 10:06:53.249937+00:00 (in 3.027495 seconds)
2026-06-10 10:06:50,231 DEBUG zuul.Scheduler: Starting merge request cleanup
2026-06-10 10:06:50,231 DEBUG zuul.Scheduler: Finished merge request cleanup
2026-06-10 10:06:50,233 INFO apscheduler.executors.default: Job "Scheduler._runMergeRequestCleanup (trigger: interval[0:01:00], next run at: 2026-06-10 10:07:53 UTC)" executed successfully
2026-06-10 10:06:53,250 DEBUG apscheduler.scheduler: Looking for jobs to run
2026-06-10 10:06:53,250 DEBUG apscheduler.scheduler: Next wakeup is due at 2026-06-10 10:07:53.912644+00:00 (in 60.662018 seconds)
2026-06-10 10:06:53,250 INFO apscheduler.executors.default: Running job "Scheduler._runBuildRequestCleanup (trigger: interval[0:01:00], next run at: 2026-06-10 10:07:56 UTC)" (scheduled at 2026-06-10 10:06:53.249937+00:00)
2026-06-10 10:06:53,256 DEBUG zuul.Scheduler: Starting build request cleanup
2026-06-10 10:06:53,256 DEBUG zuul.Scheduler: Finished build request cleanup
2026-06-10 10:06:53,259 INFO apscheduler.executors.default: Job "Scheduler._runBuildRequestCleanup (trigger: interval[0:01:00], next run at: 2026-06-10 10:07:56 UTC)" executed successfully
2026-06-10 10:07:09,833 DEBUG paramiko.transport: Sending global request "keepalive@lag.net"
2026-06-10 10:07:31,387 DEBUG zuul.CommandSocket: Accepted socket connection <socket.socket fd=12, family=1, type=1, proto=0, laddr=/var/lib/zuul/scheduler.socket>
2026-06-10 10:07:31,388 DEBUG zuul.CommandSocket: Received b'tenant-reconfigure ["internal"]' from socket
2026-06-10 10:07:31,388 DEBUG zuul.Scheduler: Tenant reconfiguration triggered
2026-06-10 10:07:31,469 DEBUG zuul.Scheduler: Configured logging: 13.1.0
2026-06-10 10:07:31,469 DEBUG zuul.Scheduler: [e: 85bc107e773247da877b501d54b58d58] Submitting reconfiguration event
2026-06-10 10:07:31,510 DEBUG zuul.Scheduler: [e: 85bc107e773247da877b501d54b58d58] Waiting for reconfiguration
2026-06-10 10:07:31,555 DEBUG zuul.Scheduler: Run handler awake
2026-06-10 10:07:31,555 DEBUG zuul.Scheduler: Fetching reconfiguration event
2026-06-10 10:07:31,555 INFO zuul.Scheduler: Reconfiguration beginning (smart=False, tenants=['internal'])
2026-06-10 10:07:31,556 INFO zuul.ConfigLoader: Loading configuration from /var/lib/zuul/main.yaml
2026-06-10 10:07:31,695 DEBUG zuul.Scheduler: Wait for internal write tenant lock (id: RECONFIG)
2026-06-10 10:07:31,769 DEBUG zuul.Scheduler: Aquired internal write tenant lock (id: RECONFIG)
2026-06-10 10:07:32,265 DEBUG zuul.GerritConnection: SSH command:
2026-06-10 10:07:32,265 DEBUG zuul.GerritConnection:   git-upload-pack config
2026-06-10 10:07:32,355 DEBUG zuul.GerritConnection.io: SSH received stdout:
2026-06-10 10:07:32,355 DEBUG zuul.GerritConnection.io:   00e9a6ba7db52ebbb17072bec92e1f94e1507c079fe8 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 10:07:32,355 DEBUG zuul.GerritConnection.io:   003fa6ba7db52ebbb17072bec92e1f94e1507c079fe8 refs/heads/master
2026-06-10 10:07:32,355 DEBUG zuul.GerritConnection.io:   003e705a4f4e42e80d972b9d88e69a1d3b756a137971 refs/meta/config
2026-06-10 10:07:32,355 DEBUG zuul.GerritConnection.io:   0000
2026-06-10 10:07:32,356 DEBUG zuul.GerritConnection: SSH exit status: 0
2026-06-10 10:07:32,356 DEBUG zuul.GerritConnection: Fetched 1 branches for config
2026-06-10 10:07:32,356 INFO zuul.GerritConnection: Got branches for config
2026-06-10 10:07:32,387 INFO zuul.GerritConnection: Got default branch for config: master
2026-06-10 10:07:32,974 DEBUG zuul.MergeClient: Submitting job 1863b4087f964986baf65c0ce2bd0471 with data {'connection': 'git-server', 'project': 'system-config', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']}
2026-06-10 10:07:32,978 DEBUG zuul.MergeClient: Submitting job 7d8aeaf37c8a473c8acbd0da4cb37c29 with data {'connection': 'gerrit', 'project': 'config', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']}
2026-06-10 10:07:32,980 DEBUG zuul.MergeClient: Submitting job 30da038ec6c742fea8120184cae6f1ae with data {'connection': 'opendev.org', 'project': 'zuul/zuul-jobs', 'branch': 'master', 'files': ['zuul.yaml', '.zuul.yaml'], 'dirs': ['zuul.d', '.zuul.d']}
2026-06-10 10:07:32,985 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper <MergeRequest 1863b4087f964986baf65c0ce2bd0471, job_type=cat, state=requested, path=/zuul/merger/requests/1863b4087f964986baf65c0ce2bd0471>
2026-06-10 10:07:32,986 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper <MergeRequest 7d8aeaf37c8a473c8acbd0da4cb37c29, job_type=cat, state=requested, path=/zuul/merger/requests/7d8aeaf37c8a473c8acbd0da4cb37c29>
2026-06-10 10:07:32,988 DEBUG zuul.MergerApi: Submitting job request to ZooKeeper <MergeRequest 30da038ec6c742fea8120184cae6f1ae, job_type=cat, state=requested, path=/zuul/merger/requests/30da038ec6c742fea8120184cae6f1ae>
2026-06-10 10:07:33,056 DEBUG zuul.TenantParser: Submitting cat job <JobResultFuture request_path=/zuul/merger/requests/1863b4087f964986baf65c0ce2bd0471> for git-server system-config master
2026-06-10 10:07:33,057 DEBUG zuul.TenantParser: Submitting cat job <JobResultFuture request_path=/zuul/merger/requests/7d8aeaf37c8a473c8acbd0da4cb37c29> for gerrit config master
2026-06-10 10:07:33,064 DEBUG zuul.TenantParser: Submitting cat job <JobResultFuture request_path=/zuul/merger/requests/30da038ec6c742fea8120184cae6f1ae> for opendev.org zuul/zuul-jobs master
2026-06-10 10:07:33,064 DEBUG zuul.TenantParser: Waiting for cat job <JobResultFuture request_path=/zuul/merger/requests/1863b4087f964986baf65c0ce2bd0471>
2026-06-10 10:07:33,264 DEBUG zuul.TenantParser: Cat job <JobResultFuture request_path=/zuul/merger/requests/1863b4087f964986baf65c0ce2bd0471> 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 10:07:33,264 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/config-project.yaml@master
2026-06-10 10:07:33,268 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/jobs-base.yaml@master
2026-06-10 10:07:33,269 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/k8s-secret.yaml@master
2026-06-10 10:07:33,270 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/sf-logserver-secret.yaml@master
2026-06-10 10:07:33,460 DEBUG zuul.TenantParser: Waiting for cat job <JobResultFuture request_path=/zuul/merger/requests/7d8aeaf37c8a473c8acbd0da4cb37c29>
2026-06-10 10:07:33,478 DEBUG zuul.TenantParser: Cat job <JobResultFuture request_path=/zuul/merger/requests/7d8aeaf37c8a473c8acbd0da4cb37c29> got files dict_keys(['.zuul.yaml', 'zuul.yaml'])
2026-06-10 10:07:33,495 DEBUG zuul.TenantParser: Waiting for cat job <JobResultFuture request_path=/zuul/merger/requests/30da038ec6c742fea8120184cae6f1ae>
2026-06-10 10:07:33,713 DEBUG zuul.TenantParser: Cat job <JobResultFuture request_path=/zuul/merger/requests/30da038ec6c742fea8120184cae6f1ae> 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 10:07:33,713 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/container-jobs.yaml@master
2026-06-10 10:07:33,715 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/dib-jobs.yaml@master
2026-06-10 10:07:33,715 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/docker-jobs.yaml@master
2026-06-10 10:07:33,716 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/general-jobs.yaml@master
2026-06-10 10:07:33,719 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/go-jobs.yaml@master
2026-06-10 10:07:33,720 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/haskell-jobs.yaml@master
2026-06-10 10:07:33,721 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/helm-jobs.yaml@master
2026-06-10 10:07:33,722 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/js-jobs.yaml@master
2026-06-10 10:07:33,724 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/nim-jobs.yaml@master
2026-06-10 10:07:33,725 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/packer-jobs.yaml@master
2026-06-10 10:07:33,725 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/python-jobs.yaml@master
2026-06-10 10:07:33,737 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/system-jobs.yaml@master
2026-06-10 10:07:33,738 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/terraform-jobs.yaml@master
2026-06-10 10:07:34,112 DEBUG zuul.TenantParser: Created layout id 2efcc9e998f84378b205e16c28b0fde3
2026-06-10 10:07:34,282 DEBUG zuul.Pipeline.internal.check: Building relative_priority queues
2026-06-10 10:07:34,290 DEBUG zuul.Pipeline.internal.gate: Building shared change queues
2026-06-10 10:07:34,290 DEBUG zuul.Pipeline.internal.gate: Created queue: <zuul.manager.shared.ChangeQueueManager object at 0x7f14a0292c90>
2026-06-10 10:07:34,291 DEBUG zuul.Pipeline.internal.gate: Added project config to queue managers: <zuul.manager.shared.ChangeQueueManager object at 0x7f14a0292c90>
2026-06-10 10:07:34,298 DEBUG zuul.Pipeline.internal.post: Building relative_priority queues
2026-06-10 10:07:34,306 DEBUG zuul.GerritConnection: Setting watched checkers to []
2026-06-10 10:07:34,306 DEBUG zuul.GerritConnection: Setting watched event filters for internal to [<GerritEventFilter connection: gerrit types: patchset-created ignore_deletes: True>, <GerritEventFilter connection: gerrit types: change-restored ignore_deletes: True>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True comments: (?i)^(Patch Set [0-9]+:)?( [\w\+-]*)*(\n\n)?\s*(recheck|reverify)>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True event_approvals: Workflow:1>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True event_approvals: Verified:1 usernames: zuul>, <GerritEventFilter connection: gerrit types: ref-updated refs: ^refs/heads/master$, ^refs/heads/main$ ignore_deletes: True>]
2026-06-10 10:07:34,306 DEBUG zuul.GerritConnection: Setting watched event filters to {<GerritEventFilter connection: gerrit types: change-restored ignore_deletes: True>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True comments: (?i)^(Patch Set [0-9]+:)?( [\w\+-]*)*(\n\n)?\s*(recheck|reverify)>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True event_approvals: Workflow:1>, <GerritEventFilter connection: gerrit types: patchset-created ignore_deletes: True>, <GerritEventFilter connection: gerrit types: ref-updated refs: ^refs/heads/master$, ^refs/heads/main$ ignore_deletes: True>, <GerritEventFilter connection: gerrit types: comment-added ignore_deletes: True event_approvals: Verified:1 usernames: zuul>}
2026-06-10 10:07:34,362 DEBUG zuul.Scheduler: Setting layout state last reconfigure ltime to 945
2026-06-10 10:07:34,389 DEBUG zuul.Scheduler: Released internal write tenant lock (id: RECONFIG)
2026-06-10 10:07:34,472 INFO zuul.Scheduler: Reconfiguration complete (smart: False, tenants: ['internal'], duration: 2.916 seconds)
2026-06-10 10:07:34,473 DEBUG zuul.Scheduler: [e: 85bc107e773247da877b501d54b58d58] Reconfiguration complete
2026-06-10 10:07:34,482 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock
2026-06-10 10:07:34,484 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock
2026-06-10 10:07:34,492 DEBUG zuul.Scheduler: Processing tenant management events in internal
2026-06-10 10:07:34,556 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock
2026-06-10 10:07:34,721 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock
2026-06-10 10:07:34,722 DEBUG zuul.Scheduler: Aquired internal read tenant lock
2026-06-10 10:07:34,924 DEBUG zuul.Scheduler: Processing tenant trigger events in internal
2026-06-10 10:07:35,222 DEBUG zuul.Scheduler.LayoutUpdate: Aquired internal read tenant lock
2026-06-10 10:07:35,224 DEBUG zuul.Scheduler.LayoutUpdate: Released internal read tenant lock
2026-06-10 10:07:35,566 DEBUG zuul.Scheduler.LayoutUpdate: Aquired demo-tenant read tenant lock
2026-06-10 10:07:35,608 DEBUG zuul.Scheduler.LayoutUpdate: Released demo-tenant read tenant lock
2026-06-10 10:07:35,663 DEBUG zuul.Scheduler: Processing pipeline check in tenant internal
2026-06-10 10:07:35,741 DEBUG zuul.Scheduler: Processing management event <zuul.model.PipelinePostConfigEvent object at 0x7f14a0246310>
2026-06-10 10:07:35,806 DEBUG zuul.Pipeline.internal.check: Starting queue processor: check
2026-06-10 10:07:35,807 DEBUG zuul.Pipeline.internal.check: Finished queue processor: check (changed: False)
2026-06-10 10:07:36,559 DEBUG zuul.Scheduler: Processing pipeline gate in tenant internal
2026-06-10 10:07:36,673 DEBUG zuul.Scheduler: Processing management event <zuul.model.PipelinePostConfigEvent object at 0x7f14a0217990>
2026-06-10 10:07:36,722 DEBUG zuul.Pipeline.internal.gate: Starting queue processor: gate
2026-06-10 10:07:36,722 DEBUG zuul.Pipeline.internal.gate: Finished queue processor: gate (changed: False)
2026-06-10 10:07:36,940 DEBUG zuul.Scheduler: Processing pipeline post in tenant internal
2026-06-10 10:07:37,100 DEBUG zuul.Scheduler: Processing management event <zuul.model.PipelinePostConfigEvent object at 0x7f14a01e0dd0>
2026-06-10 10:07:37,155 DEBUG zuul.Pipeline.internal.post: Starting queue processor: post
2026-06-10 10:07:37,155 DEBUG zuul.Pipeline.internal.post: Finished queue processor: post (changed: False)
2026-06-10 10:07:37,954 DEBUG zuul.Scheduler: Released internal read tenant lock
2026-06-10 10:07:38,424 DEBUG zuul.Scheduler: Processing tenant management events in demo-tenant
2026-06-10 10:07:38,796 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock
2026-06-10 10:07:38,891 DEBUG zuul.Scheduler: Processing tenant trigger events in demo-tenant
2026-06-10 10:07:39,133 DEBUG zuul.Scheduler: Processing pipeline check in tenant demo-tenant
2026-06-10 10:07:39,137 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant demo-tenant
2026-06-10 10:07:39,208 DEBUG zuul.Scheduler: Processing pipeline gate in tenant demo-tenant
2026-06-10 10:07:39,212 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant demo-tenant
2026-06-10 10:07:39,290 DEBUG zuul.Scheduler: Processing pipeline post in tenant demo-tenant
2026-06-10 10:07:39,293 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant demo-tenant
2026-06-10 10:07:39,347 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock
2026-06-10 10:07:39,394 DEBUG zuul.Scheduler: Run handler sleeping
2026-06-10 10:07:39,394 DEBUG zuul.Scheduler: Run handler awake
2026-06-10 10:07:39,512 DEBUG zuul.Scheduler: Processing tenant management events in internal
2026-06-10 10:07:39,553 DEBUG zuul.Scheduler: Aquired internal read tenant lock
2026-06-10 10:07:39,563 DEBUG zuul.Scheduler: Processing tenant trigger events in internal
2026-06-10 10:07:39,584 DEBUG zuul.Scheduler: Processing pipeline check in tenant internal
2026-06-10 10:07:39,587 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant internal
2026-06-10 10:07:39,595 DEBUG zuul.Scheduler: Processing pipeline gate in tenant internal
2026-06-10 10:07:39,599 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant internal
2026-06-10 10:07:39,606 DEBUG zuul.Scheduler: Processing pipeline post in tenant internal
2026-06-10 10:07:39,609 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant internal
2026-06-10 10:07:39,610 DEBUG zuul.Scheduler: Released internal read tenant lock
2026-06-10 10:07:39,617 DEBUG zuul.Scheduler: Processing tenant management events in demo-tenant
2026-06-10 10:07:39,625 DEBUG zuul.Scheduler: Aquired demo-tenant read tenant lock
2026-06-10 10:07:39,630 DEBUG zuul.Scheduler: Processing tenant trigger events in demo-tenant
2026-06-10 10:07:39,645 DEBUG zuul.Scheduler: Processing pipeline check in tenant demo-tenant
2026-06-10 10:07:39,647 DEBUG zuul.Scheduler: No events to process for pipeline check in tenant demo-tenant
2026-06-10 10:07:39,653 DEBUG zuul.Scheduler: Processing pipeline gate in tenant demo-tenant
2026-06-10 10:07:39,655 DEBUG zuul.Scheduler: No events to process for pipeline gate in tenant demo-tenant
2026-06-10 10:07:39,660 DEBUG zuul.Scheduler: Processing pipeline post in tenant demo-tenant
2026-06-10 10:07:39,663 DEBUG zuul.Scheduler: No events to process for pipeline post in tenant demo-tenant
2026-06-10 10:07:39,664 DEBUG zuul.Scheduler: Released demo-tenant read tenant lock
2026-06-10 10:07:39,666 DEBUG zuul.Scheduler: Run handler sleeping
2026-06-10 10:07:53,941 DEBUG zuul.Scheduler: Starting merge request cleanup
2026-06-10 10:07:53,941 DEBUG zuul.Scheduler: Finished merge request cleanup
2026-06-10 10:07:56,986 DEBUG zuul.Scheduler: Starting build request cleanup
2026-06-10 10:07:56,986 DEBUG zuul.Scheduler: Finished build request cleanup