+ 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 07:18:52,136 DEBUG zuul.Web: Configured logging: 14.1.1.dev1
2026-06-10 07:18:52,137 DEBUG zuul.TimerDriver: Starting apscheduler
2026-06-10 07:18:52,137 INFO apscheduler.scheduler: Scheduler started
2026-06-10 07:18:52,137 DEBUG apscheduler.scheduler: Looking for jobs to run
2026-06-10 07:18:52,138 DEBUG apscheduler.scheduler: No jobs; waiting until a job is added
2026-06-10 07:18:52,138 DEBUG zuul.BubblewrapDriver: Initializing bubblewrap with oom_score_adj starting: 995, final: 1000
2026-06-10 07:18:52,141 INFO zuul.SQLConnection: Initializing SQL connection database (prefix: )
2026-06-10 07:18:52,327 DEBUG zuul.zk.base.ZooKeeperClient: ZooKeeper connection (session: 0x1000011ae330007): CONNECTED
2026-06-10 07:18:52,336 DEBUG zuul.ExecutorQueue: Creating executor queue at root /zuul/executor/unzoned
2026-06-10 07:18:52,342 INFO zuul.Component: Registering component in ZooKeeper /zuul/components/web/zuul-web-79cd7bddd8-55qft
2026-06-10 07:18:52,352 INFO zuul.ComponentRegistry: Noticed new scheduler component zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003
2026-06-10 07:18:52,353 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f79163a6290> got event None for scheduler zuul-scheduler-0.zuul-scheduler.sf.svc.cluster.local0000000003
2026-06-10 07:18:52,353 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 07:18:52,355 INFO zuul.ComponentRegistry: Noticed new executor component zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003
2026-06-10 07:18:52,356 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f79163a6290> got event None for executor zuul-executor-0.zuul-executor-headless.sf.svc.cluster.local0000000003
2026-06-10 07:18:52,356 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 07:18:52,357 INFO zuul.ComponentRegistry: Noticed new merger component zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003
2026-06-10 07:18:52,358 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f79163a6290> got event None for merger zuul-merger-0.zuul-merger-headless.sf.svc.cluster.local0000000003
2026-06-10 07:18:52,358 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 07:18:52,361 INFO zuul.ComponentRegistry: Noticed new web component zuul-web-79cd7bddd8-55qft0000000006
2026-06-10 07:18:52,361 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f79163a6290> got event None for web zuul-web-79cd7bddd8-55qft0000000006
2026-06-10 07:18:52,362 INFO zuul.ComponentRegistry: Component web zuul-web-79cd7bddd8-55qft0000000006 updated: {'hostname': 'zuul-web-79cd7bddd8-55qft', 'kind': 'web', 'model_api': 37, 'state': 'stopped', 'version': '14.1.1.dev1 90eea2ed8'}
2026-06-10 07:18:52,363 INFO zuul.ComponentRegistry: System minimum data model version 37; this component 37
2026-06-10 07:18:52,365 DEBUG zuul.zk.ZooKeeper: Initialize cache at /keystorage-oidc
2026-06-10 07:18:52,367 DEBUG zuul.zk.ZooKeeper: Cache at /keystorage-oidc is ready
2026-06-10 07:18:52,412 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/images
2026-06-10 07:18:52,415 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/images is ready
2026-06-10 07:18:52,416 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/image-uploads
2026-06-10 07:18:52,418 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/image-uploads is ready
2026-06-10 07:18:52,418 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/nodeset
2026-06-10 07:18:52,421 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/nodeset is ready
2026-06-10 07:18:52,421 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/nodes
2026-06-10 07:18:52,423 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/nodes is ready
2026-06-10 07:18:52,451 DEBUG zuul.SQLConnection: Current migration revision: 21d30f0bffef
2026-06-10 07:18:52,475 DEBUG zuul.GerritConnection: Starting Gerrit Connection/Watchers
2026-06-10 07:18:52,475 DEBUG zuul.GerritConnection: Creating Zookeeper branch cache
2026-06-10 07:18:52,483 INFO zuul.GerritConnection: Creating Zookeeper event queue
2026-06-10 07:18:52,511 DEBUG zuul.connection.git: Creating Zookeeper change cache
2026-06-10 07:18:52,513 DEBUG zuul.connection.git: Creating Zookeeper change cache
2026-06-10 07:18:52,514 INFO zuul.WebServer: Zuul Web Server starting
2026-06-10 07:18:52,514 INFO zuul.web: ZuulWeb starting
2026-06-10 07:18:52,517 INFO zuul.web: Starting command processor
2026-06-10 07:18:52,519 INFO zuul.web: Waiting for system config from scheduler
2026-06-10 07:18:52,520 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f79163a6290> got event CHANGED for web zuul-web-79cd7bddd8-55qft0000000006
2026-06-10 07:18:52,520 INFO zuul.ComponentRegistry: Component web zuul-web-79cd7bddd8-55qft0000000006 updated: {'hostname': 'zuul-web-79cd7bddd8-55qft', 'kind': 'web', 'model_api': 37, 'state': 'initializing', 'version': '14.1.1.dev1 90eea2ed8'}
2026-06-10 07:18:52,532 DEBUG zuul.web: Updating system config
2026-06-10 07:18:53,252 INFO zuul.web: Waiting for all tenants to load
2026-06-10 07:18:53,252 DEBUG zuul.web: Updating layout state
2026-06-10 07:18:53,254 DEBUG zuul.web: Reloading tenant internal
2026-06-10 07:18:53,254 DEBUG zuul.web: Wait for internal read tenant lock
2026-06-10 07:18:53,259 DEBUG zuul.web: Aquired internal read tenant lock
2026-06-10 07:18:53,540 INFO zuul.BranchCache.gerrit: Waiting for branch cache upgrade lock
2026-06-10 07:18:53,827 DEBUG zuul.zk.ZooKeeper: Initialize cache at /zuul/cache/connection/gerrit/project
2026-06-10 07:18:53,837 DEBUG zuul.zk.ZooKeeper: Cache at /zuul/cache/connection/gerrit/project is ready
2026-06-10 07:18:53,837 INFO zuul.BranchCache.gerrit: Cache already upgraded
2026-06-10 07:18:54,302 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 07:18:54,304 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 07:18:54,304 DEBUG zuul.TenantParser: Using files from cache for project gerrit-sshd.sf/config @master: []
2026-06-10 07:18:54,317 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/config-project.yaml@master
2026-06-10 07:18:54,322 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/container-jobs.yaml@master
2026-06-10 07:18:54,329 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/jobs-base.yaml@master
2026-06-10 07:18:54,332 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/dib-jobs.yaml@master
2026-06-10 07:18:54,336 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/k8s-secret.yaml@master
2026-06-10 07:18:54,338 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/docker-jobs.yaml@master
2026-06-10 07:18:54,343 INFO zuul.TenantParser: Loading configuration from system-config/zuul.d/sf-logserver-secret.yaml@master
2026-06-10 07:18:54,345 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/general-jobs.yaml@master
2026-06-10 07:18:54,353 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/go-jobs.yaml@master
2026-06-10 07:18:54,357 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/haskell-jobs.yaml@master
2026-06-10 07:18:54,412 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/helm-jobs.yaml@master
2026-06-10 07:18:54,416 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/js-jobs.yaml@master
2026-06-10 07:18:54,423 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/nim-jobs.yaml@master
2026-06-10 07:18:54,426 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/packer-jobs.yaml@master
2026-06-10 07:18:54,430 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/python-jobs.yaml@master
2026-06-10 07:18:54,452 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/system-jobs.yaml@master
2026-06-10 07:18:54,456 INFO zuul.TenantParser: Loading configuration from zuul/zuul-jobs/zuul.d/terraform-jobs.yaml@master
2026-06-10 07:18:54,516 DEBUG zuul.TenantParser: Created layout id 79270e27d7c345fc973683226067dc33
2026-06-10 07:18:54,631 DEBUG zuul.web: Released internal read tenant lock
2026-06-10 07:18:54,635 DEBUG zuul.web: Reloading tenant demo-tenant
2026-06-10 07:18:54,635 DEBUG zuul.web: Wait for demo-tenant read tenant lock
2026-06-10 07:18:54,641 DEBUG zuul.web: Aquired demo-tenant read tenant lock
2026-06-10 07:18:55,465 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 07:18:55,466 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 07:18:55,472 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-base-jobs.yaml@master
2026-06-10 07:18:55,476 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-pipeline.yaml@master
2026-06-10 07:18:55,478 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/jobs.yaml@master
2026-06-10 07:18:55,482 INFO zuul.TenantParser: Loading configuration from demo-tenant-config/zuul.d/gerrit-project-pipeline.yaml@master
2026-06-10 07:18:55,483 INFO zuul.TenantParser: Loading configuration from demo-project/.zuul.d/project.yaml@master
2026-06-10 07:18:55,490 DEBUG zuul.TenantParser: Created layout id 3fc8ce09a2c8408886f0c3debbe78d14
2026-06-10 07:18:55,494 DEBUG zuul.web: Released demo-tenant read tenant lock
2026-06-10 07:18:55,496 DEBUG zuul.web: Done updating layout state
2026-06-10 07:18:55,496 INFO apscheduler.scheduler: Scheduler started
2026-06-10 07:18:55,497 DEBUG apscheduler.scheduler: Looking for jobs to run
2026-06-10 07:18:55,497 DEBUG apscheduler.scheduler: No jobs; waiting until a job is added
2026-06-10 07:18:55,497 INFO apscheduler.scheduler: Added job "Regular cherrypy stats reporting" to job store "default"
2026-06-10 07:18:55,498 INFO zuul.web: Starting HTTP listeners
2026-06-10 07:18:55,498 DEBUG apscheduler.scheduler: Looking for jobs to run
2026-06-10 07:18:55,499 DEBUG apscheduler.scheduler: Next wakeup is due at 2026-06-10 07:19:49.919590+00:00 (in 54.420616 seconds)
2026-06-10 07:18:55,607 DEBUG zuul.ComponentRegistry: Registry <zuul.zk.components.ComponentRegistry object at 0x7f79163a6290> got event CHANGED for web zuul-web-79cd7bddd8-55qft0000000006
2026-06-10 07:18:55,607 INFO zuul.ComponentRegistry: Component web zuul-web-79cd7bddd8-55qft0000000006 updated: {'hostname': 'zuul-web-79cd7bddd8-55qft', 'kind': 'web', 'model_api': 37, 'state': 'running', 'version': '14.1.1.dev1 90eea2ed8'}
2026-06-10 07:19:45,192 INFO cherrypy.access.140158068924304: [req: 38d7bb34d1534d6fb7640e17871ed1e8] 10.244.0.1 - - [10/Jun/2026:07:19:45] "GET /api/info HTTP/1.1" 200 352 "" "kube-probe/1.32"
2026-06-10 07:19:46,034 INFO cherrypy.access.140158068924304: [req: fcf3b0983ff4450a9c3ef924b6d3e952] 10.244.0.1 - - [10/Jun/2026:07:19:46] "GET /api/info HTTP/1.1" 200 352 "" "kube-probe/1.32"
2026-06-10 07:19:48,626 INFO cherrypy.access.140158068924304: [req: f9d3c1146de24e95afb60df413c11bfc] 10.244.0.46 - - [10/Jun/2026:07:19:48] "GET /api/info HTTP/1.1" 200 352 "" "python-requests/2.32.5"
2026-06-10 07:19:48,630 INFO zuul.auth.jwt: Issuer "zuul-admin" attempt to override User "CLI user" authorization granted
2026-06-10 07:19:48,630 DEBUG zuul.auth.jwt: ['internal']
2026-06-10 07:19:48,630 INFO zuul.web: [req: 11a18a5f3b8d4911be04c93b50c1bed0] User CLI user requesting autohold on internal/system-config
2026-06-10 07:19:48,631 DEBUG zuul.web: [req: 11a18a5f3b8d4911be04c93b50c1bed0] Autohold requested for ('internal', 'git-server/system-config', 'testytest', '.*')
2026-06-10 07:19:48,641 INFO cherrypy.access.140158068924304: [req: 11a18a5f3b8d4911be04c93b50c1bed0] 10.244.0.46 - - [10/Jun/2026:07:19:48] "POST /api/tenant/internal/project/system-config/autohold HTTP/1.1" 200 4 "" "python-requests/2.32.5"
2026-06-10 07:19:48,865 INFO cherrypy.access.140158068924304: [req: a2b15b2eb5e84e7d92594f0ec5fd95d4] 10.244.0.46 - - [10/Jun/2026:07:19:48] "GET /api/tenant/demo-tenant/builds HTTP/1.1" 200 2 "" "curl/7.76.1"
2026-06-10 07:19:49,919 DEBUG apscheduler.scheduler: Looking for jobs to run
2026-06-10 07:19:49,921 INFO apscheduler.executors.default: Running job "Regular cherrypy stats reporting (trigger: interval[0:01:00], next run at: 2026-06-10 07:19:49 UTC)" (scheduled at 2026-06-10 07:19:49.919590+00:00)
2026-06-10 07:19:49,922 DEBUG apscheduler.scheduler: Next wakeup is due at 2026-06-10 07:20:49.919590+00:00 (in 59.997507 seconds)
2026-06-10 07:19:49,922 INFO apscheduler.executors.default: Job "Regular cherrypy stats reporting (trigger: interval[0:01:00], next run at: 2026-06-10 07:20:49 UTC)" executed successfully
2026-06-10 07:19:55,041 INFO cherrypy.access.140158068924304: [req: 0bfe26f43b4b4c3ab959b03566233a13] 10.244.0.42 - - [10/Jun/2026:07:19:55] "GET /api/info HTTP/1.1" 200 352 "" "Go-http-client/1.1"
2026-06-10 07:19:55,054 INFO cherrypy.access.140158068924304: [req: 15183eae65a84801ac3ca72054f30774] 10.244.0.42 - - [10/Jun/2026:07:19:55] "GET /status HTTP/1.1" 200 670 "" "Go-http-client/1.1"
2026-06-10 07:19:56,033 INFO cherrypy.access.140158068924304: [req: 26e4538c5d964ec5baad79a30b18d6de] 10.244.0.1 - - [10/Jun/2026:07:19:56] "GET /api/info HTTP/1.1" 200 352 "" "kube-probe/1.32"
2026-06-10 07:20:05,179 INFO cherrypy.access.140158068924304: [req: 3ac3334f8895413cbefd27344ed827e0] 10.244.0.1 - - [10/Jun/2026:07:20:05] "GET /api/info HTTP/1.1" 200 352 "" "kube-probe/1.32"
2026-06-10 07:20:06,033 INFO cherrypy.access.140158068924304: [req: 58afeedaee39481e84e307828603b045] 10.244.0.1 - - [10/Jun/2026:07:20:06] "GET /api/info HTTP/1.1" 200 352 "" "kube-probe/1.32"