+ update-ca-trust extract -o /etc/pki/ca-trust/extracted
+ git config --global --add safe.directory '*'
+ exec /usr/local/bin/zuul-web -f -d
2026-06-10 10:08:34,540 DEBUG zuul.Web: Configured logging: 14.1.1.dev1
2026-06-10 10:08:34,541 DEBUG zuul.TimerDriver: Starting apscheduler
2026-06-10 10:08:34,541 INFO apscheduler.scheduler: Scheduler started
2026-06-10 10:08:34,542 DEBUG apscheduler.scheduler: Looking for jobs to run
2026-06-10 10:08:34,542 DEBUG apscheduler.scheduler: No jobs; waiting until a job is added
2026-06-10 10:08:34,542 DEBUG zuul.BubblewrapDriver: Initializing bubblewrap with oom_score_adj starting: 995, final: 1000
2026-06-10 10:08:34,545 INFO zuul.SQLConnection: Initializing SQL connection database (prefix: )
2026-06-10 10:08:34,858 DEBUG zuul.zk.base.ZooKeeperClient: ZooKeeper connection (session: 0x100001140de0007): CONNECTED
2026-06-10 10:08:34,923 DEBUG zuul.ExecutorQueue: Creating executor queue at root /zuul/executor/unzoned
2026-06-10 10:08:34,935 INFO zuul.Component: Registering component in ZooKeeper /zuul/components/web/zuul-web-7444b8b5dd-m47fz
2026-06-10 10:08:35,035 INFO zuul.ComponentRegistry: Noticed new scheduler component zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003
2026-06-10 10:08:35,037 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7fb41c0efcd0> got event None for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003
2026-06-10 10:08:35,037 INFO zuul.ComponentRegistry: Component scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003 updated: {'hostname': 'zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local', 'kind': 'scheduler', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'}
2026-06-10 10:08:35,039 INFO zuul.ComponentRegistry: Noticed new executor component zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003
2026-06-10 10:08:35,040 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7fb41c0efcd0> got event None for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003
2026-06-10 10:08:35,040 INFO zuul.ComponentRegistry: Component executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003 updated: {'accepting_work': True, 'allow_unzoned': True, 'hostname': 'zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local', 'kind': 'executor', 'model_api': 37, 'process_merge_jobs': True, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8', 'zone': None}
2026-06-10 10:08:35,042 INFO zuul.ComponentRegistry: Noticed new merger component zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003
2026-06-10 10:08:35,042 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7fb41c0efcd0> got event None for merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003
2026-06-10 10:08:35,043 INFO zuul.ComponentRegistry: Component merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003 updated: {'hostname': 'zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local', 'kind': 'merger', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'}
2026-06-10 10:08:35,046 INFO zuul.ComponentRegistry: Noticed new web component zuul-web-7444b8b5dd-m47fz0000000006
2026-06-10 10:08:35,047 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7fb41c0efcd0> got event None for web zuul-web-7444b8b5dd-m47fz0000000006
2026-06-10 10:08:35,047 INFO zuul.ComponentRegistry: Component web zuul-web-7444b8b5dd-m47fz0000000006 updated: {'hostname': 'zuul-web-7444b8b5dd-m47fz', 'kind': 'web', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'}
2026-06-10 10:08:35,049 INFO zuul.ComponentRegistry: System minimum data model version 37; this component 37
2026-06-10 10:08:35,051 DEBUG zuul.zk.ZooKeeper: Initialize cache at /keystorage-oidc
2026-06-10 10:08:35,055 DEBUG zuul.zk.ZooKeeper: Cache at /keystorage-oidc is ready
2026-06-10 10:08:35,060 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/images
2026-06-10 10:08:35,065 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/images is ready
2026-06-10 10:08:35,065 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/image-uploads
2026-06-10 10:08:35,069 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/image-uploads is ready
2026-06-10 10:08:35,069 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/nodeset
2026-06-10 10:08:35,072 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/nodeset is ready
2026-06-10 10:08:35,073 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/nodes
2026-06-10 10:08:35,076 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/nodes is ready
2026-06-10 10:08:35,208 DEBUG zuul.SQLConnection: Current migration revision: 21d30f0bffef
2026-06-10 10:08:35,234 DEBUG zuul.GerritConnection: Starting Gerrit Connection/Watchers
2026-06-10 10:08:35,234 DEBUG zuul.GerritConnection: Creating Zookeeper branch cache
2026-06-10 10:08:35,244 INFO zuul.GerritConnection: Creating Zookeeper event queue
2026-06-10 10:08:35,246 DEBUG zuul.connection.git: Creating Zookeeper change cache
2026-06-10 10:08:35,247 DEBUG zuul.connection.git: Creating Zookeeper change cache
2026-06-10 10:08:35,249 INFO zuul.WebServer: Zuul Web Server starting
2026-06-10 10:08:35,250 INFO zuul.web: ZuulWeb starting
2026-06-10 10:08:35,258 INFO zuul.web: Starting command processor
2026-06-10 10:08:35,258 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7fb41c0efcd0> got event CHANGED for web zuul-web-7444b8b5dd-m47fz0000000006
2026-06-10 10:08:35,259 INFO zuul.ComponentRegistry: Component web zuul-web-7444b8b5dd-m47fz0000000006 updated: {'hostname': 'zuul-web-7444b8b5dd-m47fz', 'kind': 'web', 'model_api': 37, 'state': 'initializing', 'version': '14.1.1.dev1 90eea2ed8'}
2026-06-10 10:08:35,260 INFO zuul.web: Waiting for system config from scheduler
2026-06-10 10:08:35,297 DEBUG zuul.web: Updating system config
2026-06-10 10:08:36,048 INFO zuul.web: Waiting for all tenants to load
2026-06-10 10:08:36,048 DEBUG zuul.web: Updating layout state
2026-06-10 10:08:36,050 DEBUG zuul.web: Reloading tenant internal
2026-06-10 10:08:36,050 DEBUG zuul.web: Wait for internal read tenant lock
2026-06-10 10:08:36,057 DEBUG zuul.web: Aquired internal read tenant lock
2026-06-10 10:08:36,344 INFO zuul.BranchCache.gerrit: Waiting for branch cache upgrade lock
2026-06-10 10:08:36,643 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/cache/connection/gerrit/project
2026-06-10 10:08:36,655 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/cache/connection/gerrit/project is ready
2026-06-10 10:08:36,655 INFO zuul.BranchCache.gerrit: Cache already upgraded
2026-06-10 10:08:37,171 DEBUG zuul.TenantParser: Using files from cache for project git-server/system-config @master: ['zuul.d/config-project.yaml', 'zuul.d/jobs-base.yaml', 'zuul.d/k8s-secret.yaml', 'zuul.d/sf-logserver-secret.yaml']
2026-06-10 10:08:37,172 DEBUG zuul.TenantParser: Using files from cache for project opendev.org/zuul/zuul-jobs @master: ['zuul.d/container-jobs.yaml', 'zuul.d/dib-jobs.yaml', 'zuul.d/docker-jobs.yaml', 'zuul.d/general-jobs.yaml', 'zuul.d/go-jobs.yaml', 'zuul.d/haskell-jobs.yaml', 'zuul.d/helm-jobs.yaml', 'zuul.d/js-jobs.yaml', 'zuul.d/nim-jobs.yaml', 'zuul.d/packer-jobs.yaml', 'zuul.d/python-jobs.yaml', 'zuul.d/system-jobs.yaml', 'zuul.d/terraform-jobs.yaml']
2026-06-10 10:08:37,173 DEBUG zuul.TenantParser: Using files from cache for project gerrit-sshd.sf/config @master: []
2026-06-10 10:08:37,185 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/config-project.yaml@master
2026-06-10 10:08:37,190 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/container-jobs.yaml@master
2026-06-10 10:08:37,198 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/jobs-base.yaml@master
2026-06-10 10:08:37,200 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/dib-jobs.yaml@master
2026-06-10 10:08:37,205 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/k8s-secret.yaml@master
2026-06-10 10:08:37,206 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/docker-jobs.yaml@master
2026-06-10 10:08:37,211 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/sf-logserver-secret.yaml@master
2026-06-10 10:08:37,212 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/general-jobs.yaml@master
2026-06-10 10:08:37,229 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/go-jobs.yaml@master
2026-06-10 10:08:37,234 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/haskell-jobs.yaml@master
2026-06-10 10:08:37,239 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/helm-jobs.yaml@master
2026-06-10 10:08:37,244 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/js-jobs.yaml@master
2026-06-10 10:08:37,249 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/nim-jobs.yaml@master
2026-06-10 10:08:37,253 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/packer-jobs.yaml@master
2026-06-10 10:08:37,256 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/python-jobs.yaml@master
2026-06-10 10:08:37,272 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/system-jobs.yaml@master
2026-06-10 10:08:37,275 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/terraform-jobs.yaml@master
2026-06-10 10:08:37,327 DEBUG zuul.TenantParser: Created layout id 6c2c83361dfc4f1890d840f50737b5f7
2026-06-10 10:08:37,528 DEBUG zuul.web: Released internal read tenant lock
2026-06-10 10:08:37,532 DEBUG zuul.web: Reloading tenant demo-tenant
2026-06-10 10:08:37,532 DEBUG zuul.web: Wait for demo-tenant read tenant lock
2026-06-10 10:08:37,536 DEBUG zuul.web: Aquired demo-tenant read tenant lock
2026-06-10 10:08:38,302 DEBUG zuul.TenantParser: Using files from cache for project gerrit-sshd.sf/demo-tenant-config @master: ['zuul.d/gerrit-base-jobs.yaml', 'zuul.d/gerrit-pipeline.yaml', 'zuul.d/gerrit-project-pipeline.yaml']
2026-06-10 10:08:38,304 DEBUG zuul.TenantParser: Using files from cache for project gerrit-sshd.sf/demo-project @master: ['.zuul.d/jobs.yaml', '.zuul.d/project.yaml']
2026-06-10 10:08:38,317 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-base-jobs.yaml@master
2026-06-10 10:08:38,324 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-pipeline.yaml@master
2026-06-10 10:08:38,326 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/jobs.yaml@master
2026-06-10 10:08:38,333 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-project-pipeline.yaml@master
2026-06-10 10:08:38,334 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/project.yaml@master
2026-06-10 10:08:38,343 DEBUG zuul.TenantParser: Created layout id b093e7c722e64ebfbc517c3c31c60807
2026-06-10 10:08:38,349 DEBUG zuul.web: Released demo-tenant read tenant lock
2026-06-10 10:08:38,351 DEBUG zuul.web: Done updating layout state
2026-06-10 10:08:38,352 INFO apscheduler.scheduler: Scheduler started
2026-06-10 10:08:38,352 DEBUG apscheduler.scheduler: Looking for jobs to run
2026-06-10 10:08:38,352 DEBUG apscheduler.scheduler: No jobs; waiting until a job is added
2026-06-10 10:08:38,353 INFO apscheduler.scheduler: Added job "Regular cherrypy stats reporting" to job store "default"
2026-06-10 10:08:38,353 INFO zuul.web: Starting HTTP listeners
2026-06-10 10:08:38,353 DEBUG apscheduler.scheduler: Looking for jobs to run
2026-06-10 10:08:38,353 DEBUG apscheduler.scheduler: Next wakeup is due at 2026-06-10 10:09:32.632801+00:00 (in 54.278923 seconds)
2026-06-10 10:08:38,464 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7fb41c0efcd0> got event CHANGED for web zuul-web-7444b8b5dd-m47fz0000000006
2026-06-10 10:08:38,464 INFO zuul.ComponentRegistry: Component web zuul-web-7444b8b5dd-m47fz0000000006 updated: {'hostname': 'zuul-web-7444b8b5dd-m47fz', 'kind': 'web', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'}
2026-06-10 10:09:27,420 INFO cherrypy.access.140411676109072: [req: 20fd9f6802004ae28f4bc77894e5f94e] 10.244.0.1 - - [10/Jun/2026:10:09:27] "GET /api/info HTTP/1.1" 200 352 "" "kube-probe/1.32"
2026-06-10 10:09:27,928 INFO cherrypy.access.140411676109072: [req: 1cac218fc05c44bab64956ec1ab860c0] 10.244.0.1 - - [10/Jun/2026:10:09:27] "GET /api/info HTTP/1.1" 200 352 "" "kube-probe/1.32"
2026-06-10 10:09:30,744 INFO cherrypy.access.140411676109072: [req: 90e143b1283b457bb0d6033eedb6ab27] 10.244.0.44 - - [10/Jun/2026:10:09:30] "GET /api/info HTTP/1.1" 200 352 "" "python-requests/2.32.5"
2026-06-10 10:09:30,747 INFO zuul.auth.jwt: Issuer "zuul-admin" attempt to override User "CLI user" authorization granted
2026-06-10 10:09:30,747 DEBUG zuul.auth.jwt: ['internal']
2026-06-10 10:09:30,748 INFO zuul.web: [req: 7bc66e6efb7b4747808639aba61f6402] User CLI user requesting autohold on internal/system-config
2026-06-10 10:09:30,748 DEBUG zuul.web: [req: 7bc66e6efb7b4747808639aba61f6402] Autohold requested for ('internal', 'git-server/system-config', 'testytest', '.*')
2026-06-10 10:09:30,757 INFO cherrypy.access.140411676109072: [req: 7bc66e6efb7b4747808639aba61f6402] 10.244.0.44 - - [10/Jun/2026:10:09:30] "POST /api/tenant/internal/project/system-config/autohold HTTP/1.1" 200 4 "" "python-requests/2.32.5"
2026-06-10 10:09:31,027 INFO cherrypy.access.140411676109072: [req: 288e43a0fa9641aa81613e6ff1b10b65] 10.244.0.44 - - [10/Jun/2026:10:09:31] "GET /api/tenant/demo-tenant/builds HTTP/1.1" 200 2 "" "curl/7.76.1"
2026-06-10 10:09:32,633 DEBUG apscheduler.scheduler: Looking for jobs to run
2026-06-10 10:09:32,634 INFO apscheduler.executors.default: Running job "Regular cherrypy stats reporting (trigger: interval[0:01:00], next run at: 2026-06-10 10:09:32 UTC)" (scheduled at 2026-06-10 10:09:32.632801+00:00)
2026-06-10 10:09:32,634 DEBUG apscheduler.scheduler: Next wakeup is due at 2026-06-10 10:10:32.632801+00:00 (in 59.998342 seconds)
2026-06-10 10:09:32,634 INFO apscheduler.executors.default: Job "Regular cherrypy stats reporting (trigger: interval[0:01:00], next run at: 2026-06-10 10:10:32 UTC)" executed successfully
2026-06-10 10:09:37,931 INFO cherrypy.access.140411676109072: [req: a8a384334d8741f7b265e337299d1090] 10.244.0.1 - - [10/Jun/2026:10:09:37] "GET /api/info HTTP/1.1" 200 352 "" "kube-probe/1.32"
2026-06-10 10:09:47,412 INFO cherrypy.access.140411676109072: [req: 7df5579b0c0d4ddc9588ba9c773c56fd] 10.244.0.1 - - [10/Jun/2026:10:09:47] "GET /api/info HTTP/1.1" 200 352 "" "kube-probe/1.32"
2026-06-10 10:09:47,929 INFO cherrypy.access.140411676109072: [req: 3388c71995f648c3bcfbc6340c115b50] 10.244.0.1 - - [10/Jun/2026:10:09:47] "GET /api/info HTTP/1.1" 200 352 "" "kube-probe/1.32"
2026-06-10 10:09:57,928 INFO cherrypy.access.140411676109072: [req: 5b6b40deecdd4b3da950a613d524b192] 10.244.0.1 - - [10/Jun/2026:10:09:57] "GET /api/info HTTP/1.1" 200 352 "" "kube-probe/1.32"
2026-06-10 10:09:57,980 INFO cherrypy.access.140411676109072: [req: 73f3acf118494bd9ae1b8543936502f7] 10.244.0.52 - - [10/Jun/2026:10:09:57] "HEAD /api/components HTTP/1.1" 200 537 "" "curl/7.76.1"
2026-06-10 10:09:58,143 INFO cherrypy.access.140411676109072: [req: e1c36301fd614a8084eab27755023388] 10.244.0.52 - - [10/Jun/2026:10:09:58] "GET /api/components HTTP/1.1" 200 537 "" "curl/7.76.1"
2026-06-10 10:10:07,411 INFO cherrypy.access.140411676109072: [req: 9340b23bfed440af9eb9b9db082cf032] 10.244.0.1 - - [10/Jun/2026:10:10:07] "GET /api/info HTTP/1.1" 200 352 "" "kube-probe/1.32"
2026-06-10 10:10:07,928 INFO cherrypy.access.140411676109072: [req: 93ec0dd73f244091b695e061328f7586] 10.244.0.1 - - [10/Jun/2026:10:10:07] "GET /api/info HTTP/1.1" 200 352 "" "kube-probe/1.32"