2025-12-02 03:09:09.025797 | Job console starting 2025-12-02 03:09:09.037944 | Updating git repos 2025-12-02 03:09:09.105607 | Cloning repos into workspace 2025-12-02 03:09:09.319439 | Restoring repo states 2025-12-02 03:09:09.347330 | Merging changes 2025-12-02 03:09:09.347354 | Checking out repos 2025-12-02 03:09:09.574483 | Preparing playbooks 2025-12-02 03:09:11.303390 | Running Ansible setup 2025-12-02 03:09:18.190298 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-12-02 03:09:21.104600 | 2025-12-02 03:09:21.104723 | PLAY [Base pre] 2025-12-02 03:09:21.141663 | 2025-12-02 03:09:21.141786 | TASK [Setup log path fact] 2025-12-02 03:09:21.168937 | debian-bookworm | ok 2025-12-02 03:09:21.192394 | 2025-12-02 03:09:21.192514 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-02 03:09:21.271989 | debian-bookworm | ok 2025-12-02 03:09:21.285692 | 2025-12-02 03:09:21.285855 | TASK [emit-job-header : Print job information] 2025-12-02 03:09:21.415385 | # Job Information 2025-12-02 03:09:21.415528 | Ansible Version: 2.16.14 2025-12-02 03:09:21.415559 | Job: python-osism-test-setup 2025-12-02 03:09:21.415586 | Pipeline: periodic-daily 2025-12-02 03:09:21.415605 | Executor: 521e9411259a 2025-12-02 03:09:21.415623 | Triggered by: https://github.com/osism/python-osism 2025-12-02 03:09:21.415641 | Event ID: 0e29b9baf8af428c80295733ae679c72 2025-12-02 03:09:21.419558 | 2025-12-02 03:09:21.419645 | LOOP [emit-job-header : Print node information] 2025-12-02 03:09:21.820681 | debian-bookworm | ok: 2025-12-02 03:09:21.820980 | debian-bookworm | # Node Information 2025-12-02 03:09:21.821023 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-12-02 03:09:21.821045 | debian-bookworm | Hostname: debian 2025-12-02 03:09:21.821064 | debian-bookworm | Username: zuul 2025-12-02 03:09:21.821082 | debian-bookworm | Distro: Debian 12.12 2025-12-02 03:09:21.821102 | debian-bookworm | Provider: regiocloud-a 2025-12-02 03:09:21.821125 | debian-bookworm | Region: 2025-12-02 03:09:21.821147 | debian-bookworm | Label: debian-bookworm 2025-12-02 03:09:21.821167 | debian-bookworm | Product Name: OpenStack Nova 2025-12-02 03:09:21.821286 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe77:5495 2025-12-02 03:09:21.850481 | 2025-12-02 03:09:21.850592 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-02 03:09:23.144812 | debian-bookworm -> localhost | changed 2025-12-02 03:09:23.150634 | 2025-12-02 03:09:23.150755 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-02 03:09:26.459621 | debian-bookworm -> localhost | changed 2025-12-02 03:09:26.468567 | 2025-12-02 03:09:26.468666 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-02 03:09:27.469426 | debian-bookworm -> localhost | ok 2025-12-02 03:09:27.474766 | 2025-12-02 03:09:27.474990 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-02 03:09:27.514763 | debian-bookworm | ok 2025-12-02 03:09:27.565281 | debian-bookworm | included: /var/lib/zuul/builds/d8786a775e6c4412b1e900801ac76888/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-02 03:09:27.593913 | 2025-12-02 03:09:27.594018 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-02 03:09:30.848772 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-12-02 03:09:30.849043 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/d8786a775e6c4412b1e900801ac76888/work/d8786a775e6c4412b1e900801ac76888_id_rsa 2025-12-02 03:09:30.849088 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/d8786a775e6c4412b1e900801ac76888/work/d8786a775e6c4412b1e900801ac76888_id_rsa.pub 2025-12-02 03:09:30.849111 | debian-bookworm -> localhost | The key fingerprint is: 2025-12-02 03:09:30.849132 | debian-bookworm -> localhost | SHA256:/bYx/nHO6dVWYRDNiz6DgPG5HNXkS2RnCz2vcli4hX8 zuul-build-sshkey 2025-12-02 03:09:30.849151 | debian-bookworm -> localhost | The key's randomart image is: 2025-12-02 03:09:30.849178 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-12-02 03:09:30.849196 | debian-bookworm -> localhost | | oB=o | 2025-12-02 03:09:30.849214 | debian-bookworm -> localhost | | . .+.==.| 2025-12-02 03:09:30.849230 | debian-bookworm -> localhost | | + o =.++| 2025-12-02 03:09:30.849246 | debian-bookworm -> localhost | | . * +.=.o| 2025-12-02 03:09:30.849262 | debian-bookworm -> localhost | | S = oB ..| 2025-12-02 03:09:30.849284 | debian-bookworm -> localhost | | o o+++ E| 2025-12-02 03:09:30.849302 | debian-bookworm -> localhost | | =o+.=| 2025-12-02 03:09:30.849320 | debian-bookworm -> localhost | | o + *o| 2025-12-02 03:09:30.849337 | debian-bookworm -> localhost | | o.ooo| 2025-12-02 03:09:30.849353 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-12-02 03:09:30.849400 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.997642 2025-12-02 03:09:30.855345 | 2025-12-02 03:09:30.855516 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-02 03:09:30.893869 | debian-bookworm | ok 2025-12-02 03:09:30.916932 | debian-bookworm | included: /var/lib/zuul/builds/d8786a775e6c4412b1e900801ac76888/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-02 03:09:30.944319 | 2025-12-02 03:09:30.946477 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-02 03:09:30.985059 | debian-bookworm | skipping: Conditional result was False 2025-12-02 03:09:30.990643 | 2025-12-02 03:09:30.990756 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-02 03:09:31.886450 | debian-bookworm | changed 2025-12-02 03:09:31.891245 | 2025-12-02 03:09:31.891328 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-02 03:09:32.184957 | debian-bookworm | ok 2025-12-02 03:09:32.190782 | 2025-12-02 03:09:32.190973 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-02 03:09:32.879599 | debian-bookworm | changed 2025-12-02 03:09:32.887003 | 2025-12-02 03:09:32.887114 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-02 03:09:33.596167 | debian-bookworm | changed 2025-12-02 03:09:33.608033 | 2025-12-02 03:09:33.608143 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-02 03:09:33.641472 | debian-bookworm | skipping: Conditional result was False 2025-12-02 03:09:33.647284 | 2025-12-02 03:09:33.647383 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-02 03:09:34.322000 | debian-bookworm -> localhost | changed 2025-12-02 03:09:34.332350 | 2025-12-02 03:09:34.332447 | TASK [add-build-sshkey : Add back temp key] 2025-12-02 03:09:34.688932 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/d8786a775e6c4412b1e900801ac76888/work/d8786a775e6c4412b1e900801ac76888_id_rsa (zuul-build-sshkey) 2025-12-02 03:09:34.689143 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011956 2025-12-02 03:09:34.696889 | 2025-12-02 03:09:34.696987 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-02 03:09:35.189971 | debian-bookworm | ok 2025-12-02 03:09:35.196379 | 2025-12-02 03:09:35.196471 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-02 03:09:35.229979 | debian-bookworm | skipping: Conditional result was False 2025-12-02 03:09:35.245151 | 2025-12-02 03:09:35.245262 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-02 03:09:35.789625 | debian-bookworm | ok 2025-12-02 03:09:35.811638 | 2025-12-02 03:09:35.811801 | TASK [validate-host : Define zuul_info_dir fact] 2025-12-02 03:09:35.839840 | debian-bookworm | ok 2025-12-02 03:09:35.844840 | 2025-12-02 03:09:35.844932 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-12-02 03:09:36.100142 | debian-bookworm -> localhost | ok 2025-12-02 03:09:36.106188 | 2025-12-02 03:09:36.106274 | TASK [validate-host : Collect information about the host] 2025-12-02 03:09:37.272538 | debian-bookworm | ok 2025-12-02 03:09:37.301351 | 2025-12-02 03:09:37.301496 | TASK [validate-host : Sanitize hostname] 2025-12-02 03:09:37.444706 | debian-bookworm | ok 2025-12-02 03:09:37.483634 | 2025-12-02 03:09:37.483777 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-12-02 03:09:38.509685 | debian-bookworm -> localhost | changed 2025-12-02 03:09:38.515861 | 2025-12-02 03:09:38.516125 | TASK [validate-host : Collect information about zuul worker] 2025-12-02 03:09:39.443303 | debian-bookworm | ok 2025-12-02 03:09:39.455097 | 2025-12-02 03:09:39.455242 | TASK [validate-host : Write out all zuul information for each host] 2025-12-02 03:09:40.942188 | debian-bookworm -> localhost | changed 2025-12-02 03:09:40.988413 | 2025-12-02 03:09:40.988572 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-12-02 03:09:41.357170 | debian-bookworm | ok 2025-12-02 03:09:41.363645 | 2025-12-02 03:09:41.363798 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-12-02 03:09:43.116507 | debian-bookworm | changed: 2025-12-02 03:09:43.116743 | debian-bookworm | cd+++++++++ src/ 2025-12-02 03:09:43.116783 | debian-bookworm | cd+++++++++ src/github.com/ 2025-12-02 03:09:43.116809 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-12-02 03:09:43.116831 | debian-bookworm | cd+++++++++ src/github.com/osism/python-osism/ 2025-12-02 03:09:43.116852 | debian-bookworm | Containerfile 2025-12-02 03:09:43.116966 | debian-bookworm | Containerfile 2025-12-02 03:09:43.195174 | debian-bookworm | =2.0.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from ara==1.7.3->osism==0.20251130.2.dev6) (7.0.3) 2025-12-02 03:12:08.476551 | debian-bookworm | Requirement already satisfied: requests>=2.14.2 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from ara==1.7.3->osism==0.20251130.2.dev6) (2.32.5) 2025-12-02 03:12:08.573070 | debian-bookworm | Requirement already satisfied: billiard<5.0,>=4.2.1 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from celery[redis]==5.5.3->osism==0.20251130.2.dev6) (4.2.4) 2025-12-02 03:12:08.575347 | debian-bookworm | Requirement already satisfied: vine<6.0,>=5.1.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from celery[redis]==5.5.3->osism==0.20251130.2.dev6) (5.1.0) 2025-12-02 03:12:08.576737 | debian-bookworm | Requirement already satisfied: click<9.0,>=8.1.2 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from celery[redis]==5.5.3->osism==0.20251130.2.dev6) (8.3.1) 2025-12-02 03:12:08.578205 | debian-bookworm | Requirement already satisfied: click-didyoumean>=0.3.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from celery[redis]==5.5.3->osism==0.20251130.2.dev6) (0.3.1) 2025-12-02 03:12:08.579747 | debian-bookworm | Requirement already satisfied: click-repl>=0.2.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from celery[redis]==5.5.3->osism==0.20251130.2.dev6) (0.3.0) 2025-12-02 03:12:08.581293 | debian-bookworm | Requirement already satisfied: click-plugins>=1.1.1 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from celery[redis]==5.5.3->osism==0.20251130.2.dev6) (1.1.1.2) 2025-12-02 03:12:08.590842 | debian-bookworm | Requirement already satisfied: autopage>=0.4.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from cliff==4.12.0->osism==0.20251130.2.dev6) (0.5.2) 2025-12-02 03:12:08.592583 | debian-bookworm | Requirement already satisfied: cmd2>=1.0.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from cliff==4.12.0->osism==0.20251130.2.dev6) (2.7.0) 2025-12-02 03:12:08.594877 | debian-bookworm | Requirement already satisfied: PrettyTable>=0.7.2 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from cliff==4.12.0->osism==0.20251130.2.dev6) (3.17.0) 2025-12-02 03:12:08.596120 | debian-bookworm | Requirement already satisfied: stevedore>=2.0.1 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from cliff==4.12.0->osism==0.20251130.2.dev6) (5.6.0) 2025-12-02 03:12:08.631386 | debian-bookworm | Requirement already satisfied: orderly-set<6,>=5.4.1 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from deepdiff==8.6.1->osism==0.20251130.2.dev6) (5.5.0) 2025-12-02 03:12:08.647118 | debian-bookworm | Requirement already satisfied: urllib3>=1.26.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from docker==7.1.0->osism==0.20251130.2.dev6) (2.5.0) 2025-12-02 03:12:08.653721 | debian-bookworm | Requirement already satisfied: polling in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from dtrack-auditor==1.5.0->osism==0.20251130.2.dev6) (0.3.2) 2025-12-02 03:12:08.654675 | debian-bookworm | Requirement already satisfied: certifi in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from dtrack-auditor==1.5.0->osism==0.20251130.2.dev6) (2025.11.12) 2025-12-02 03:12:08.761569 | debian-bookworm | Collecting starlette<0.51.0,>=0.40.0 2025-12-02 03:12:08.773135 | debian-bookworm | Downloading starlette-0.50.0-py3-none-any.whl (74 kB) 2025-12-02 03:12:08.784125 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.0/74.0 kB 8.5 MB/s eta 0:00:00 2025-12-02 03:12:08.789245 | debian-bookworm | Requirement already satisfied: pydantic!=1.8,!=1.8.1,!=2.0.0,!=2.0.1,!=2.1.0,<3.0.0,>=1.7.4 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from fastapi==0.122.0->osism==0.20251130.2.dev6) (2.12.5) 2025-12-02 03:12:08.790670 | debian-bookworm | Requirement already satisfied: typing-extensions>=4.8.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from fastapi==0.122.0->osism==0.20251130.2.dev6) (4.15.0) 2025-12-02 03:12:08.816946 | debian-bookworm | Collecting annotated-doc>=0.0.2 2025-12-02 03:12:08.828138 | debian-bookworm | Downloading annotated_doc-0.0.4-py3-none-any.whl (5.3 kB) 2025-12-02 03:12:08.867023 | debian-bookworm | Requirement already satisfied: tornado<7.0.0,>=5.0.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from flower==2.0.1->osism==0.20251130.2.dev6) (6.5.2) 2025-12-02 03:12:08.868808 | debian-bookworm | Requirement already satisfied: prometheus-client>=0.8.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from flower==2.0.1->osism==0.20251130.2.dev6) (0.23.1) 2025-12-02 03:12:08.870342 | debian-bookworm | Requirement already satisfied: humanize in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from flower==2.0.1->osism==0.20251130.2.dev6) (4.14.0) 2025-12-02 03:12:08.872193 | debian-bookworm | Requirement already satisfied: pytz in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from flower==2.0.1->osism==0.20251130.2.dev6) (2025.2) 2025-12-02 03:12:08.892974 | debian-bookworm | Requirement already satisfied: gitdb<5,>=4.0.1 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from GitPython==3.1.45->osism==0.20251130.2.dev6) (4.0.12) 2025-12-02 03:12:08.909971 | debian-bookworm | Requirement already satisfied: ruamel.yaml>=0.15.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from jc==1.25.6->osism==0.20251130.2.dev6) (0.18.16) 2025-12-02 03:12:08.912090 | debian-bookworm | Requirement already satisfied: xmltodict>=0.12.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from jc==1.25.6->osism==0.20251130.2.dev6) (1.0.2) 2025-12-02 03:12:08.913345 | debian-bookworm | Requirement already satisfied: Pygments>=2.3.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from jc==1.25.6->osism==0.20251130.2.dev6) (2.19.2) 2025-12-02 03:12:08.923915 | debian-bookworm | Requirement already satisfied: MarkupSafe>=2.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from Jinja2==3.1.6->osism==0.20251130.2.dev6) (3.0.3) 2025-12-02 03:12:08.941312 | debian-bookworm | Requirement already satisfied: iso8601>=2.0.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from keystoneauth1==5.12.0->osism==0.20251130.2.dev6) (2.1.0) 2025-12-02 03:12:08.943281 | debian-bookworm | Requirement already satisfied: os-service-types>=1.2.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from keystoneauth1==5.12.0->osism==0.20251130.2.dev6) (1.8.2) 2025-12-02 03:12:08.977154 | debian-bookworm | Requirement already satisfied: amqp<6.0.0,>=5.1.1 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from kombu==5.5.4->osism==0.20251130.2.dev6) (5.3.1) 2025-12-02 03:12:08.979314 | debian-bookworm | Requirement already satisfied: tzdata>=2025.2 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from kombu==5.5.4->osism==0.20251130.2.dev6) (2025.2) 2025-12-02 03:12:08.980476 | debian-bookworm | Requirement already satisfied: packaging in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from kombu==5.5.4->osism==0.20251130.2.dev6) (25.0) 2025-12-02 03:12:08.998446 | debian-bookworm | Requirement already satisfied: six>=1.9.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from kubernetes==33.1.0->osism==0.20251130.2.dev6) (1.17.0) 2025-12-02 03:12:09.001259 | debian-bookworm | Requirement already satisfied: google-auth>=1.0.1 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from kubernetes==33.1.0->osism==0.20251130.2.dev6) (2.43.0) 2025-12-02 03:12:09.003048 | debian-bookworm | Requirement already satisfied: websocket-client!=0.40.0,!=0.41.*,!=0.42.*,>=0.32.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from kubernetes==33.1.0->osism==0.20251130.2.dev6) (1.9.0) 2025-12-02 03:12:09.004513 | debian-bookworm | Requirement already satisfied: requests-oauthlib in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from kubernetes==33.1.0->osism==0.20251130.2.dev6) (2.0.0) 2025-12-02 03:12:09.005986 | debian-bookworm | Requirement already satisfied: oauthlib>=3.2.2 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from kubernetes==33.1.0->osism==0.20251130.2.dev6) (3.3.1) 2025-12-02 03:12:09.007714 | debian-bookworm | Requirement already satisfied: durationpy>=0.7 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from kubernetes==33.1.0->osism==0.20251130.2.dev6) (0.10) 2025-12-02 03:12:09.102333 | debian-bookworm | Requirement already satisfied: cryptography>=2.7 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from openstacksdk==4.8.0->osism==0.20251130.2.dev6) (46.0.3) 2025-12-02 03:12:09.104245 | debian-bookworm | Requirement already satisfied: decorator>=4.4.1 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from openstacksdk==4.8.0->osism==0.20251130.2.dev6) (5.2.1) 2025-12-02 03:12:09.105408 | debian-bookworm | Requirement already satisfied: dogpile.cache>=0.6.5 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from openstacksdk==4.8.0->osism==0.20251130.2.dev6) (1.5.0) 2025-12-02 03:12:09.107103 | debian-bookworm | Requirement already satisfied: jmespath>=0.9.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from openstacksdk==4.8.0->osism==0.20251130.2.dev6) (1.0.1) 2025-12-02 03:12:09.108455 | debian-bookworm | Requirement already satisfied: jsonpatch!=1.20,>=1.16 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from openstacksdk==4.8.0->osism==0.20251130.2.dev6) (1.33) 2025-12-02 03:12:09.111005 | debian-bookworm | Requirement already satisfied: platformdirs>=3 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from openstacksdk==4.8.0->osism==0.20251130.2.dev6) (4.5.0) 2025-12-02 03:12:09.112987 | debian-bookworm | Requirement already satisfied: psutil>=3.2.2 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from openstacksdk==4.8.0->osism==0.20251130.2.dev6) (7.1.3) 2025-12-02 03:12:09.114741 | debian-bookworm | Requirement already satisfied: requestsexceptions>=1.2.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from openstacksdk==4.8.0->osism==0.20251130.2.dev6) (1.4.0) 2025-12-02 03:12:09.132532 | debian-bookworm | Requirement already satisfied: bcrypt>=3.2 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from paramiko==4.0.0->osism==0.20251130.2.dev6) (5.0.0) 2025-12-02 03:12:09.134222 | debian-bookworm | Requirement already satisfied: invoke>=2.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from paramiko==4.0.0->osism==0.20251130.2.dev6) (2.2.1) 2025-12-02 03:12:09.135826 | debian-bookworm | Requirement already satisfied: pynacl>=1.5 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from paramiko==4.0.0->osism==0.20251130.2.dev6) (1.6.1) 2025-12-02 03:12:09.149837 | debian-bookworm | Requirement already satisfied: redis>=4.2.0rc1 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from pottery==3.0.1->osism==0.20251130.2.dev6) (5.2.1) 2025-12-02 03:12:09.151390 | debian-bookworm | Requirement already satisfied: mmh3 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from pottery==3.0.1->osism==0.20251130.2.dev6) (5.2.0) 2025-12-02 03:12:09.165590 | debian-bookworm | Requirement already satisfied: wcwidth in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from prompt-toolkit==3.0.52->osism==0.20251130.2.dev6) (0.2.14) 2025-12-02 03:12:09.178299 | debian-bookworm | Requirement already satisfied: lxml in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from pyang==2.7.1->osism==0.20251130.2.dev6) (6.0.2) 2025-12-02 03:12:09.247730 | debian-bookworm | Requirement already satisfied: pytest>=6 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from pytest-testinfra==10.2.2->osism==0.20251130.2.dev6) (9.0.1) 2025-12-02 03:12:09.300168 | debian-bookworm | Requirement already satisfied: jsonpath_rw in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from redfish==3.3.4->osism==0.20251130.2.dev6) (1.4.0) 2025-12-02 03:12:09.301041 | debian-bookworm | Requirement already satisfied: jsonpointer in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from redfish==3.3.4->osism==0.20251130.2.dev6) (3.0.0) 2025-12-02 03:12:09.303271 | debian-bookworm | Requirement already satisfied: requests_toolbelt in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from redfish==3.3.4->osism==0.20251130.2.dev6) (1.0.0) 2025-12-02 03:12:09.304357 | debian-bookworm | Requirement already satisfied: requests-unixsocket in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from redfish==3.3.4->osism==0.20251130.2.dev6) (0.4.1) 2025-12-02 03:12:09.324375 | debian-bookworm | Requirement already satisfied: SQLAlchemy<2.1.0,>=2.0.14 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from sqlmodel==0.0.27->osism==0.20251130.2.dev6) (2.0.44) 2025-12-02 03:12:09.453456 | debian-bookworm | Collecting h11>=0.8 2025-12-02 03:12:09.464822 | debian-bookworm | Downloading h11-0.16.0-py3-none-any.whl (37 kB) 2025-12-02 03:12:09.555439 | debian-bookworm | Collecting httptools>=0.6.3 2025-12-02 03:12:09.567137 | debian-bookworm | Downloading httptools-0.7.1-cp311-cp311-manylinux1_x86_64.manylinux_2_28_x86_64.manylinux_2_5_x86_64.whl (456 kB) 2025-12-02 03:12:09.612629 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 456.6/456.6 kB 11.4 MB/s eta 0:00:00 2025-12-02 03:12:09.668635 | debian-bookworm | Collecting python-dotenv>=0.13 2025-12-02 03:12:09.680119 | debian-bookworm | Downloading python_dotenv-1.2.1-py3-none-any.whl (21 kB) 2025-12-02 03:12:09.796876 | debian-bookworm | Collecting uvloop>=0.15.1 2025-12-02 03:12:09.809355 | debian-bookworm | Downloading uvloop-0.22.1-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (3.8 MB) 2025-12-02 03:12:10.014280 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 3.8/3.8 MB 19.0 MB/s eta 0:00:00 2025-12-02 03:12:10.278221 | debian-bookworm | Collecting watchfiles>=0.13 2025-12-02 03:12:10.290785 | debian-bookworm | Downloading watchfiles-1.1.1-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (456 kB) 2025-12-02 03:12:10.315997 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 456.1/456.1 kB 23.1 MB/s eta 0:00:00 2025-12-02 03:12:10.776248 | debian-bookworm | Requirement already satisfied: pyperclip>=1.8 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from cmd2>=1.0.0->cliff==4.12.0->osism==0.20251130.2.dev6) (1.11.0) 2025-12-02 03:12:10.777958 | debian-bookworm | Requirement already satisfied: rich-argparse>=1.7.1 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from cmd2>=1.0.0->cliff==4.12.0->osism==0.20251130.2.dev6) (1.7.2) 2025-12-02 03:12:10.832767 | debian-bookworm | Requirement already satisfied: cffi>=2.0.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from cryptography>=2.7->openstacksdk==4.8.0->osism==0.20251130.2.dev6) (2.0.0) 2025-12-02 03:12:10.969355 | debian-bookworm | Requirement already satisfied: smmap<6,>=3.0.1 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from gitdb<5,>=4.0.1->GitPython==3.1.45->osism==0.20251130.2.dev6) (5.0.2) 2025-12-02 03:12:11.037716 | debian-bookworm | Requirement already satisfied: cachetools<7.0,>=2.0.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from google-auth>=1.0.1->kubernetes==33.1.0->osism==0.20251130.2.dev6) (6.2.2) 2025-12-02 03:12:11.039176 | debian-bookworm | Requirement already satisfied: pyasn1-modules>=0.2.1 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from google-auth>=1.0.1->kubernetes==33.1.0->osism==0.20251130.2.dev6) (0.4.2) 2025-12-02 03:12:11.040445 | debian-bookworm | Requirement already satisfied: rsa<5,>=3.1.4 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from google-auth>=1.0.1->kubernetes==33.1.0->osism==0.20251130.2.dev6) (4.9.1) 2025-12-02 03:12:11.704698 | debian-bookworm | Requirement already satisfied: annotated-types>=0.6.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from pydantic!=1.8,!=1.8.1,!=2.0.0,!=2.0.1,!=2.1.0,<3.0.0,>=1.7.4->fastapi==0.122.0->osism==0.20251130.2.dev6) (0.7.0) 2025-12-02 03:12:11.706449 | debian-bookworm | Requirement already satisfied: pydantic-core==2.41.5 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from pydantic!=1.8,!=1.8.1,!=2.0.0,!=2.0.1,!=2.1.0,<3.0.0,>=1.7.4->fastapi==0.122.0->osism==0.20251130.2.dev6) (2.41.5) 2025-12-02 03:12:11.708282 | debian-bookworm | Requirement already satisfied: typing-inspection>=0.4.2 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from pydantic!=1.8,!=1.8.1,!=2.0.0,!=2.0.1,!=2.1.0,<3.0.0,>=1.7.4->fastapi==0.122.0->osism==0.20251130.2.dev6) (0.4.2) 2025-12-02 03:12:11.898478 | debian-bookworm | Requirement already satisfied: iniconfig>=1.0.1 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from pytest>=6->pytest-testinfra==10.2.2->osism==0.20251130.2.dev6) (2.3.0) 2025-12-02 03:12:11.900542 | debian-bookworm | Requirement already satisfied: pluggy<2,>=1.5 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from pytest>=6->pytest-testinfra==10.2.2->osism==0.20251130.2.dev6) (1.6.0) 2025-12-02 03:12:12.038027 | debian-bookworm | Requirement already satisfied: async-timeout>=4.0.3 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from redis>=4.2.0rc1->pottery==3.0.1->osism==0.20251130.2.dev6) (5.0.1) 2025-12-02 03:12:12.088443 | debian-bookworm | Requirement already satisfied: charset_normalizer<4,>=2 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from requests>=2.14.2->ara==1.7.3->osism==0.20251130.2.dev6) (3.4.4) 2025-12-02 03:12:12.090246 | debian-bookworm | Requirement already satisfied: idna<4,>=2.5 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from requests>=2.14.2->ara==1.7.3->osism==0.20251130.2.dev6) (3.11) 2025-12-02 03:12:12.191438 | debian-bookworm | Requirement already satisfied: ruamel.yaml.clib>=0.2.7 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from ruamel.yaml>=0.15.0->jc==1.25.6->osism==0.20251130.2.dev6) (0.2.15) 2025-12-02 03:12:12.324739 | debian-bookworm | Requirement already satisfied: greenlet>=1 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from SQLAlchemy<2.1.0,>=2.0.14->sqlmodel==0.0.27->osism==0.20251130.2.dev6) (3.2.4) 2025-12-02 03:12:12.442899 | debian-bookworm | Collecting anyio<5,>=3.6.2 2025-12-02 03:12:12.455029 | debian-bookworm | Downloading anyio-4.12.0-py3-none-any.whl (113 kB) 2025-12-02 03:12:12.466215 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 113.4/113.4 kB 13.1 MB/s eta 0:00:00 2025-12-02 03:12:13.133359 | debian-bookworm | Requirement already satisfied: ply in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from jsonpath_rw->redfish==3.3.4->osism==0.20251130.2.dev6) (3.11) 2025-12-02 03:12:14.068009 | debian-bookworm | Requirement already satisfied: pycparser in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from cffi>=2.0.0->cryptography>=2.7->openstacksdk==4.8.0->osism==0.20251130.2.dev6) (2.23) 2025-12-02 03:12:14.469915 | debian-bookworm | Requirement already satisfied: pyasn1<0.7.0,>=0.6.1 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from pyasn1-modules>=0.2.1->google-auth>=1.0.1->kubernetes==33.1.0->osism==0.20251130.2.dev6) (0.6.1) 2025-12-02 03:12:14.602527 | debian-bookworm | Requirement already satisfied: rich>=11.0.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from rich-argparse>=1.7.1->cmd2>=1.0.0->cliff==4.12.0->osism==0.20251130.2.dev6) (14.2.0) 2025-12-02 03:12:15.079459 | debian-bookworm | Requirement already satisfied: markdown-it-py>=2.2.0 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from rich>=11.0.0->rich-argparse>=1.7.1->cmd2>=1.0.0->cliff==4.12.0->osism==0.20251130.2.dev6) (4.0.0) 2025-12-02 03:12:15.242816 | debian-bookworm | Requirement already satisfied: mdurl~=0.1 in /home/zuul/.local/share/virtualenvs/python-osism-A84SJ9It/lib/python3.11/site-packages (from markdown-it-py>=2.2.0->rich>=11.0.0->rich-argparse>=1.7.1->cmd2>=1.0.0->cliff==4.12.0->osism==0.20251130.2.dev6) (0.1.2) 2025-12-02 03:12:15.501953 | debian-bookworm | Building wheels for collected packages: osism 2025-12-02 03:12:15.502750 | debian-bookworm | Building wheel for osism (setup.py): started 2025-12-02 03:12:16.251382 | debian-bookworm | Building wheel for osism (setup.py): finished with status 'done' 2025-12-02 03:12:16.253207 | debian-bookworm | Created wheel for osism: filename=osism-0.20251130.2.dev6-py3-none-any.whl size=171887 sha256=8e605eb0bbe6e20bca7da194bf9e0a96daa1ce85af289d4500251eff55981e0e 2025-12-02 03:12:16.254052 | debian-bookworm | Stored in directory: /home/zuul/.cache/pip/wheels/a1/f3/73/4a66715db3e61cd6101f4a742f32969d09906101b6738a3792 2025-12-02 03:12:16.261295 | debian-bookworm | Successfully built osism 2025-12-02 03:12:17.142894 | debian-bookworm | Installing collected packages: websockets, uvloop, tabulate, python-dotenv, httptools, h11, anyio, annotated-doc, watchfiles, uvicorn, starlette, fastapi, osism 2025-12-02 03:12:18.449492 | debian-bookworm | Successfully installed annotated-doc-0.0.4 anyio-4.12.0 fastapi-0.122.0 h11-0.16.0 httptools-0.7.1 osism-0.20251130.2.dev6 python-dotenv-1.2.1 starlette-0.50.0 tabulate-0.9.0 uvicorn-0.38.0 uvloop-0.22.1 watchfiles-1.1.1 websockets-15.0.1 2025-12-02 03:12:18.812302 | debian-bookworm | ok: Runtime: 0:01:25.248462 2025-12-02 03:12:18.816042 | 2025-12-02 03:12:18.816125 | PLAY RECAP 2025-12-02 03:12:18.816179 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-02 03:12:18.816205 | 2025-12-02 03:12:18.956730 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/python-osism/playbooks/test-setup.yml@main] 2025-12-02 03:12:18.958914 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-02 03:12:19.755349 | 2025-12-02 03:12:19.755513 | PLAY [Base post] 2025-12-02 03:12:19.769947 | 2025-12-02 03:12:19.770100 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-12-02 03:12:20.701743 | debian-bookworm | changed 2025-12-02 03:12:20.711244 | 2025-12-02 03:12:20.711386 | PLAY RECAP 2025-12-02 03:12:20.711462 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-02 03:12:20.711541 | 2025-12-02 03:12:20.845375 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-12-02 03:12:20.846350 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-12-02 03:12:21.740333 | 2025-12-02 03:12:21.740506 | PLAY [Base post-logs] 2025-12-02 03:12:21.751923 | 2025-12-02 03:12:21.752073 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-02 03:12:22.222084 | localhost | changed 2025-12-02 03:12:22.239967 | 2025-12-02 03:12:22.240192 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-02 03:12:22.268404 | localhost | ok 2025-12-02 03:12:22.275178 | 2025-12-02 03:12:22.275360 | TASK [Set zuul-log-path fact] 2025-12-02 03:12:22.295770 | localhost | ok 2025-12-02 03:12:22.313519 | 2025-12-02 03:12:22.313832 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-02 03:12:22.343073 | localhost | ok 2025-12-02 03:12:22.349367 | 2025-12-02 03:12:22.349721 | TASK [upload-logs : Create log directories] 2025-12-02 03:12:22.876148 | localhost | changed 2025-12-02 03:12:22.879051 | 2025-12-02 03:12:22.879164 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-12-02 03:12:23.483200 | localhost -> localhost | ok: Runtime: 0:00:00.008478 2025-12-02 03:12:23.488184 | 2025-12-02 03:12:23.488319 | TASK [upload-logs : Upload logs to log server] 2025-12-02 03:12:24.148582 | localhost | Output suppressed because no_log was given 2025-12-02 03:12:24.151346 | 2025-12-02 03:12:24.151506 | LOOP [upload-logs : Compress console log and json output] 2025-12-02 03:12:24.254123 | localhost | skipping: Conditional result was False 2025-12-02 03:12:24.274114 | localhost | skipping: Conditional result was False 2025-12-02 03:12:24.286693 | 2025-12-02 03:12:24.286940 | LOOP [upload-logs : Upload compressed console log and json output] 2025-12-02 03:12:24.356590 | localhost | skipping: Conditional result was False 2025-12-02 03:12:24.356896 | 2025-12-02 03:12:24.362327 | localhost | skipping: Conditional result was False 2025-12-02 03:12:24.367247 | 2025-12-02 03:12:24.367384 | LOOP [upload-logs : Upload console log and json output]