$ OS_VIP00=10.247.39.11 tox -e func-target focal-xena-ha
func-target installed: aiohttp==3.8.1,aiosignal==1.2.0,aodhclient==1.3.0,appdirs==1.4.4,argcomplete==2.0.0,async-generator==1.10,async-timeout==4.0.2,attrs==22.1.0,autopage==0.5.1,Babel==2.10.3,bcrypt==4.0.0,boto3==1.24.61,botocore==1.27.61,cachetools==5.2.0,certifi==2022.6.15,cffi==1.15.1,charset-normalizer==2.1.1,cliff==4.0.0,cmd2==2.4.2,colorclass==2.2.2,cryptography==3.3.2,debtcollector==2.5.0,decorator==5.1.1,distlib==0.3.6,dnspython==2.2.1,dogpile.cache==1.1.8,fasteners==0.17.3,filelock==3.8.0,frozenlist==1.3.1,futurist==1.10.0,gnocchiclient==7.0.7,google-auth==2.11.0,hvac==0.6.4,idna==3.3,importlib-metadata==4.12.0,iso8601==1.0.2,Jinja2==3.1.2,jmespath==1.0.1,jsonpatch==1.32,jsonpointer==2.3,jsonschema==3.2.0,juju==2.9.11,juju-wait==2.8.4,jujubundlelib==0.5.7,keystoneauth1==5.0.0,kubernetes==24.2.0,lxml==4.9.1,macaroonbakery==1.3.1,MarkupSafe==2.1.1,monotonic==1.6,msgpack==1.0.4,multidict==6.0.2,munch==2.5.0,mypy-extensions==0.4.3,netaddr==0.8.0,netifaces==0.11.0,oauthlib==3.2.0,openstacksdk==0.101.0,os-client-config==2.1.0,os-service-types==1.7.0,osc-lib==2.6.2,oslo.concurrency==5.0.0,oslo.config==6.11.3,oslo.context==5.0.0,oslo.i18n==5.1.0,oslo.log==5.0.0,oslo.serialization==5.0.0,oslo.utils==6.0.1,osprofiler==3.4.3,packaging==21.3,paramiko==2.11.0,pbr==5.10.0,pika==1.3.0,platformdirs==2.5.2,pluggy==1.0.0,prettytable==0.7.2,protobuf==3.20.1,py==1.11.0,pyasn1==0.4.8,pyasn1-modules==0.2.8,pycparser==2.21,pyinotify==0.9.6,pymacaroons==0.13.0,pymongo==4.2.0,PyNaCl==1.5.0,pyOpenSSL==21.0.0,pyparsing==2.4.7,pyperclip==1.8.2,pyRFC3339==1.1,pyrsistent==0.18.1,python-barbicanclient==4.10.0,python-ceilometerclient==2.9.0,python-cinderclient==5.0.2,python-dateutil==2.8.2,python-designateclient==2.12.0,python-glanceclient==2.17.1,python-heatclient==1.18.1,python-ironicclient==5.0.0,python-keystoneclient==3.21.0,python-libmaas==0.6.8,python-magnumclient==3.7.0,python-manilaclient==1.29.0,python-neutronclient==6.14.1,python-novaclient==15.1.1,python-octaviaclient==1.10.1,python-openstackclient==4.0.2,python-swiftclient==3.8.1,pytz==2022.2.1,PyYAML==6.0,requests==2.28.1,requests-oauthlib==1.3.1,requestsexceptions==1.4.0,rfc3986==2.0.0,rsa==4.9,s3transfer==0.6.0,simplejson==3.17.6,six==1.16.0,stevedore==4.0.0,tenacity==8.0.1,terminaltables==3.1.10,theblues==0.5.2,toml==0.10.2,toposort==1.7,tox==3.25.1,typing-extensions==4.3.0,typing-inspect==0.8.0,ujson==5.4.0,urllib3==1.26.12,virtualenv==20.16.3,warlock==1.3.3,wcwidth==0.2.5,WebOb==1.8.7,websocket-client==1.4.0,websockets==10.3,wrapt==1.14.1,yarl==1.8.1,zaza @ git+https://github.com/openstack-charmers/zaza.git@68ffb80a02cff4358f98aed56bca36b990f2c881,zaza.openstack @ git+https://github.com/openstack-charmers/zaza-openstack-tests.git@a2d8e96d8e7e9b58244ba0885826af2ad02c88d1,zipp==3.8.1
func-target run-test-pre: PYTHONHASHSEED='0'
func-target run-test: commands[0] | functest-run-suite --keep-model --bundle focal-xena-ha
2022-08-30 11:15:41 [INFO] Could not determine correct model aliasfrom tests.yaml, using default
2022-08-30 11:15:44 [WARNING] unknown facade EnvironUpgrader
2022-08-30 11:15:44 [WARNING] unexpected facade EnvironUpgrader found, unable to decipher version to use
2022-08-30 11:15:46 [INFO] Deploying bundle '/home/frode/src/opendev.org/openstack/charm-octavia/src/tests/bundles/focal-xena-ha.yaml' on to 'zaza-53d75555945a' model
2022-08-30 11:15:47 [INFO] Rendered template '<Template 'local-charm-overlay.yaml.j2'>' to file '/tmp/tmpoxisbqz3/local-charm-overlay.yaml'
2022-08-30 11:15:48 [INFO] Deploying overlay '/tmp/tmpoxisbqz3/local-charm-overlay.yaml' on to 'zaza-53d75555945a' model
2022-08-30 11:15:49 [INFO] Located charm "glance" in charm-hub, channel ussuri/edge
2022-08-30 11:15:49 [INFO] Located charm "mysql-router" in charm-hub, channel 8.0.19/edge
2022-08-30 11:15:49 [INFO] Located charm "glance-simplestreams-sync" in charm-hub, channel ussuri/edge
2022-08-30 11:15:49 [INFO] Located charm "hacluster" in charm-hub, channel 2.0.3/stable
2022-08-30 11:15:50 [INFO] Located charm "keystone" in charm-hub, channel ussuri/edge
2022-08-30 11:15:50 [INFO] Located charm "mysql-router" in charm-hub, channel 8.0.19/edge
2022-08-30 11:15:50 [INFO] Located charm "mysql-innodb-cluster" in charm-hub, channel 8.0.19/edge
2022-08-30 11:15:50 [INFO] Located charm "neutron-api" in charm-hub, channel ussuri/edge
2022-08-30 11:15:50 [INFO] Located charm "mysql-router" in charm-hub, channel 8.0.19/edge
2022-08-30 11:15:51 [INFO] Located charm "neutron-openvswitch" in charm-hub, channel ussuri/edge
2022-08-30 11:15:51 [INFO] Located charm "neutron-openvswitch" in charm-hub, channel ussuri/edge
2022-08-30 11:15:51 [INFO] Located charm "nova-cloud-controller" in charm-hub, channel ussuri/edge
2022-08-30 11:15:52 [INFO] Located charm "nova-compute" in charm-hub, channel ussuri/edge
2022-08-30 11:15:52 [INFO] Located charm "mysql-router" in charm-hub, channel 8.0.19/edge
2022-08-30 11:15:52 [INFO] Located charm "octavia-diskimage-retrofit" in charm-hub, channel ussuri/edge
2022-08-30 11:15:52 [INFO] Located charm "mysql-router" in charm-hub, channel 8.0.19/edge
2022-08-30 11:15:52 [INFO] Located charm "placement" in charm-hub, channel ussuri/edge
2022-08-30 11:15:53 [INFO] Located charm "mysql-router" in charm-hub, channel 8.0.19/edge
2022-08-30 11:15:53 [INFO] Located charm "rabbitmq-server" in charm-hub, channel 3.8/stable
2022-08-30 11:15:53 [INFO] Located charm "vault" in charm-hub, channel 1.7/edge
2022-08-30 11:15:53 [INFO] Located charm "mysql-router" in charm-hub, channel 8.0.19/edge
2022-08-30 11:15:58 [INFO] Executing changes:
2022-08-30 11:15:58 [INFO] - upload charm glance from charm-hub for series focal from channel ussuri/edge with architecture=amd64
2022-08-30 11:15:59 [INFO] - deploy application glance from charm-hub on focal with ussuri/edge
2022-08-30 11:16:00 [INFO] added resource policyd-override
2022-08-30 11:16:00 [INFO] - upload charm mysql-router from charm-hub for series focal from channel 8.0.19/edge with architecture=amd64
2022-08-30 11:16:01 [INFO] - deploy application glance-mysql-router from charm-hub on focal with 8.0.19/edge using mysql-router
2022-08-30 11:16:01 [INFO] - upload charm glance-simplestreams-sync from charm-hub for series focal from channel ussuri/edge with architecture=amd64
2022-08-30 11:16:02 [INFO] - deploy application glance-simplestreams-sync from charm-hub on focal with ussuri/edge
2022-08-30 11:16:03 [INFO] - upload charm hacluster from charm-hub for series focal from channel 2.0.3/edge with architecture=amd64
2022-08-30 11:16:04 [INFO] - deploy application hacluster-octavia from charm-hub on focal with 2.0.3/edge using hacluster
2022-08-30 11:16:04 [INFO] - upload charm keystone from charm-hub for series focal from channel ussuri/edge with architecture=amd64
2022-08-30 11:16:05 [INFO] - deploy application keystone from charm-hub on focal with ussuri/edge
2022-08-30 11:16:06 [INFO] added resource policyd-override
2022-08-30 11:16:06 [INFO] - deploy application keystone-mysql-router from charm-hub on focal with 8.0.19/edge using mysql-router
2022-08-30 11:16:06 [INFO] - upload charm mysql-innodb-cluster from charm-hub for series focal from channel 8.0.19/edge with architecture=amd64
2022-08-30 11:16:07 [INFO] - deploy application mysql-innodb-cluster from charm-hub on focal with 8.0.19/edge
2022-08-30 11:16:08 [INFO] added resource mysql-shell
2022-08-30 11:16:08 [INFO] - upload charm neutron-api from charm-hub for series focal from channel ussuri/edge with architecture=amd64
2022-08-30 11:16:09 [INFO] - deploy application neutron-api from charm-hub on focal with ussuri/edge
2022-08-30 11:16:09 [INFO] added resource policyd-override
2022-08-30 11:16:09 [INFO] - deploy application neutron-mysql-router from charm-hub on focal with 8.0.19/edge using mysql-router
2022-08-30 11:16:10 [INFO] - upload charm neutron-openvswitch from charm-hub for series focal from channel ussuri/edge with architecture=amd64
2022-08-30 11:16:11 [INFO] - deploy application neutron-openvswitch from charm-hub on focal with ussuri/edge
2022-08-30 11:16:11 [INFO] - deploy application neutron-openvswitch-octavia from charm-hub on focal with ussuri/edge using neutron-openvswitch
2022-08-30 11:16:11 [INFO] - upload charm nova-cloud-controller from charm-hub for series focal from channel ussuri/edge with architecture=amd64
2022-08-30 11:16:13 [INFO] - deploy application nova-cloud-controller from charm-hub on focal with ussuri/edge
2022-08-30 11:16:13 [INFO] added resource policyd-override
2022-08-30 11:16:13 [INFO] - upload charm nova-compute from charm-hub for series focal from channel ussuri/edge with architecture=amd64
2022-08-30 11:16:15 [INFO] - deploy application nova-compute from charm-hub on focal with ussuri/edge
2022-08-30 11:16:15 [INFO] - deploy application nova-mysql-router from charm-hub on focal with 8.0.19/edge using mysql-router
2022-08-30 11:16:15 [INFO] - upload charm /home/frode/src/opendev.org/openstack/charm-octavia/octavia.charm for series focal with architecture=amd64
2022-08-30 11:16:18 [INFO] - deploy application octavia on focal
2022-08-30 11:16:18 [INFO] added resource policyd-override
2022-08-30 11:16:18 [INFO] - upload charm octavia-diskimage-retrofit from charm-hub for series focal from channel ussuri/edge with architecture=amd64
2022-08-30 11:16:21 [INFO] - deploy application octavia-diskimage-retrofit from charm-hub on focal with ussuri/edge
2022-08-30 11:16:22 [INFO] added resource core18
2022-08-30 11:16:22 [INFO] added resource octavia-diskimage-retrofit
2022-08-30 11:16:22 [INFO] added resource snapd
2022-08-30 11:16:22 [INFO] - deploy application octavia-mysql-router from charm-hub on focal with 8.0.19/edge using mysql-router
2022-08-30 11:16:22 [INFO] - upload charm placement from charm-hub for series focal from channel ussuri/edge with architecture=amd64
2022-08-30 11:16:24 [INFO] - deploy application placement from charm-hub on focal with ussuri/edge
2022-08-30 11:16:24 [INFO] - deploy application placement-mysql-router from charm-hub on focal with 8.0.19/edge using mysql-router
2022-08-30 11:16:24 [INFO] - upload charm rabbitmq-server from charm-hub for series focal from channel 3.8/edge with architecture=amd64
2022-08-30 11:16:25 [INFO] - deploy application rabbitmq-server from charm-hub on focal with 3.8/edge
2022-08-30 11:16:26 [INFO] - upload charm vault from charm-hub for series focal from channel 1.7/edge with architecture=amd64
2022-08-30 11:16:34 [INFO] - deploy application vault from charm-hub on focal with 1.7/edge
2022-08-30 11:16:34 [INFO] added resource core
2022-08-30 11:16:34 [INFO] added resource vault
2022-08-30 11:16:34 [INFO] - deploy application vault-mysql-router from charm-hub on focal with 8.0.19/edge using mysql-router
2022-08-30 11:16:35 [INFO] - add new machine 0
2022-08-30 11:16:35 [INFO] - add new machine 1
2022-08-30 11:16:35 [INFO] - add new machine 2
2022-08-30 11:16:35 [INFO] - add relation glance:image-service - nova-cloud-controller:image-service
2022-08-30 11:16:35 [INFO] - add relation glance:image-service - nova-compute:image-service
2022-08-30 11:16:35 [INFO] - add relation glance-mysql-router:shared-db - glance:shared-db
2022-08-30 11:16:35 [INFO] - add relation keystone-mysql-router:shared-db - keystone:shared-db
2022-08-30 11:16:35 [INFO] - add relation neutron-mysql-router:shared-db - neutron-api:shared-db
2022-08-30 11:16:35 [INFO] - add relation nova-mysql-router:shared-db - nova-cloud-controller:shared-db
2022-08-30 11:16:35 [INFO] - add relation octavia-mysql-router:shared-db - octavia:shared-db
2022-08-30 11:16:36 [INFO] - add relation keystone:identity-service - glance:identity-service
2022-08-30 11:16:36 [INFO] - add relation keystone:identity-service - nova-cloud-controller:identity-service
2022-08-30 11:16:36 [INFO] - add relation keystone:identity-service - neutron-api:identity-service
2022-08-30 11:16:36 [INFO] - add relation keystone:identity-service - octavia:identity-service
2022-08-30 11:16:36 [INFO] - add relation nova-compute:cloud-compute - nova-cloud-controller:cloud-compute
2022-08-30 11:16:36 [INFO] - add relation rabbitmq-server:amqp - neutron-api:amqp
2022-08-30 11:16:36 [INFO] - add relation rabbitmq-server:amqp - glance:amqp
2022-08-30 11:16:36 [INFO] - add relation rabbitmq-server:amqp - nova-cloud-controller:amqp
2022-08-30 11:16:36 [INFO] - add relation rabbitmq-server:amqp - nova-compute:amqp
2022-08-30 11:16:36 [INFO] - add relation rabbitmq-server:amqp - octavia:amqp
2022-08-30 11:16:36 [INFO] - add relation neutron-api:neutron-api - nova-cloud-controller:neutron-api
2022-08-30 11:16:36 [INFO] - add relation neutron-api:neutron-load-balancer - octavia:neutron-api
2022-08-30 11:16:37 [INFO] - add relation rabbitmq-server:amqp - neutron-openvswitch:amqp
2022-08-30 11:16:37 [INFO] - add relation neutron-api:neutron-plugin-api - neutron-openvswitch:neutron-plugin-api
2022-08-30 11:16:37 [INFO] - add relation neutron-openvswitch:neutron-plugin - nova-compute:neutron-plugin
2022-08-30 11:16:37 [INFO] - add relation rabbitmq-server:amqp - neutron-openvswitch-octavia:amqp
2022-08-30 11:16:37 [INFO] - add relation neutron-api:neutron-plugin-api - neutron-openvswitch-octavia:neutron-plugin-api
2022-08-30 11:16:37 [INFO] - add relation neutron-openvswitch-octavia:neutron-plugin - octavia:neutron-openvswitch
2022-08-30 11:16:37 [INFO] - add relation hacluster-octavia:ha - octavia:ha
2022-08-30 11:16:37 [INFO] - add relation glance-simplestreams-sync:juju-info - octavia-diskimage-retrofit:juju-info
2022-08-30 11:16:37 [INFO] - add relation keystone:identity-service - glance-simplestreams-sync:identity-service
2022-08-30 11:16:37 [INFO] - add relation keystone:identity-credentials - octavia-diskimage-retrofit:identity-credentials
2022-08-30 11:16:37 [INFO] - add relation placement - placement-mysql-router
2022-08-30 11:16:37 [INFO] - add relation placement - keystone
2022-08-30 11:16:37 [INFO] - add relation placement - nova-cloud-controller
2022-08-30 11:16:38 [INFO] - add relation vault:shared-db - vault-mysql-router:shared-db
2022-08-30 11:16:38 [INFO] - add relation vault:certificates - glance:certificates
2022-08-30 11:16:38 [INFO] - add relation vault:certificates - keystone:certificates
2022-08-30 11:16:38 [INFO] - add relation vault:certificates - neutron-api:certificates
2022-08-30 11:16:38 [INFO] - add relation vault:certificates - nova-cloud-controller:certificates
2022-08-30 11:16:38 [INFO] - add relation vault:certificates - octavia:certificates
2022-08-30 11:16:38 [INFO] - add relation vault:certificates - octavia-diskimage-retrofit:certificates
2022-08-30 11:16:38 [INFO] - add relation vault:certificates - glance-simplestreams-sync:certificates
2022-08-30 11:16:38 [INFO] - add relation vault:certificates - placement:certificates
2022-08-30 11:16:38 [INFO] - add relation octavia-mysql-router:db-router - mysql-innodb-cluster:db-router
2022-08-30 11:16:38 [INFO] - add relation keystone-mysql-router:db-router - mysql-innodb-cluster:db-router
2022-08-30 11:16:38 [INFO] - add relation nova-mysql-router:db-router - mysql-innodb-cluster:db-router
2022-08-30 11:16:39 [INFO] - add relation glance-mysql-router:db-router - mysql-innodb-cluster:db-router
2022-08-30 11:16:39 [INFO] - add relation neutron-mysql-router:db-router - mysql-innodb-cluster:db-router
2022-08-30 11:16:39 [INFO] - add relation placement-mysql-router:db-router - mysql-innodb-cluster:db-router
2022-08-30 11:16:39 [INFO] - add relation vault-mysql-router:db-router - mysql-innodb-cluster:db-router
2022-08-30 11:16:39 [INFO] - add unit nova-compute/0 to new machine 0
2022-08-30 11:16:41 [INFO] - add unit nova-compute/1 to new machine 1
2022-08-30 11:16:41 [INFO] - add unit nova-compute/2 to new machine 2
2022-08-30 11:16:42 [INFO] - add lxd container 0/lxd/0 on new machine 0
2022-08-30 11:16:44 [INFO] - add lxd container 2/lxd/0 on new machine 2
2022-08-30 11:16:45 [INFO] - add lxd container 1/lxd/0 on new machine 1
2022-08-30 11:16:46 [INFO] - add lxd container 0/lxd/1 on new machine 0
2022-08-30 11:16:47 [INFO] - add lxd container 1/lxd/1 on new machine 1
2022-08-30 11:16:48 [INFO] - add lxd container 2/lxd/1 on new machine 2
2022-08-30 11:16:48 [INFO] - add lxd container 2/lxd/2 on new machine 2
2022-08-30 11:16:49 [INFO] - add lxd container 0/lxd/2 on new machine 0
2022-08-30 11:16:49 [INFO] - add lxd container 0/lxd/3 on new machine 0
2022-08-30 11:16:50 [INFO] - add lxd container 1/lxd/2 on new machine 1
2022-08-30 11:16:50 [INFO] - add lxd container 2/lxd/3 on new machine 2
2022-08-30 11:16:50 [INFO] - add lxd container 0/lxd/4 on new machine 0
2022-08-30 11:16:50 [INFO] - add lxd container 1/lxd/3 on new machine 1
2022-08-30 11:16:51 [INFO] - add lxd container 1/lxd/4 on new machine 1
2022-08-30 11:16:51 [INFO] - add unit glance/0 to 0/lxd/0
2022-08-30 11:16:51 [INFO] - add unit glance-simplestreams-sync/0 to 2/lxd/0
2022-08-30 11:16:51 [INFO] - add unit keystone/0 to 1/lxd/0
2022-08-30 11:16:51 [INFO] - add unit mysql-innodb-cluster/0 to 0/lxd/1
2022-08-30 11:16:51 [INFO] - add unit mysql-innodb-cluster/1 to 1/lxd/1
2022-08-30 11:16:52 [INFO] - add unit mysql-innodb-cluster/2 to 2/lxd/1
2022-08-30 11:16:52 [INFO] - add unit neutron-api/0 to 2/lxd/2
2022-08-30 11:16:52 [INFO] - add unit nova-cloud-controller/0 to 0/lxd/2
2022-08-30 11:16:52 [INFO] - add unit octavia/0 to 0/lxd/3
2022-08-30 11:16:52 [INFO] - add unit octavia/1 to 1/lxd/2
2022-08-30 11:16:52 [INFO] - add unit octavia/2 to 2/lxd/3
2022-08-30 11:16:53 [INFO] - add unit placement/0 to 0/lxd/4
2022-08-30 11:16:53 [INFO] - add unit rabbitmq-server/0 to 1/lxd/3
2022-08-30 11:16:53 [INFO] - add unit vault/0 to 1/lxd/4
2022-08-30 11:16:53 [INFO] Deploy of bundle completed.
2022-08-30 11:16:53 [INFO] Waiting for environment to settle
2022-08-30 11:16:53 [INFO] Timeout for deployment to settle set to: 3600
2022-08-30 11:16:53 [INFO] Maximum resolve count for deployment set to: 0
2022-08-30 11:16:53 [INFO] Waiting for application states to reach targeted states.
2022-08-30 11:16:53 [WARNING] unknown facade EnvironUpgrader
2022-08-30 11:16:53 [WARNING] unexpected facade EnvironUpgrader found, unable to decipher version to use
2022-08-30 11:16:53 [INFO] Waiting for an application to be present
2022-08-30 11:16:53 [INFO] Now checking workload status and status messages
2022-08-30 11:26:54 [INFO] Applications left: octavia, neutron-openvswitch-octavia, nova-mysql-router, neutron-openvswitch, placement, placement-mysql-router, glance, neutron-mysql-router, nova-compute, rabbitmq-server, keystone, mysql-innodb-cluster, nova-cloud-controller, vault, keystone-mysql-router, octavia-mysql-router, neutron-api, octavia-diskimage-retrofit, glance-simplestreams-sync, hacluster-octavia, vault-mysql-router, glance-mysql-router
2022-08-30 11:30:54 [INFO] Application glance-simplestreams-sync is ready.
2022-08-30 11:34:32 [INFO] Application rabbitmq-server is ready.
2022-08-30 11:36:01 [INFO] Application nova-compute is ready.
2022-08-30 11:36:54 [INFO] Applications left: octavia, neutron-openvswitch-octavia, nova-mysql-router, neutron-openvswitch, placement, placement-mysql-router, glance, neutron-mysql-router, keystone, mysql-innodb-cluster, nova-cloud-controller, vault, keystone-mysql-router, octavia-mysql-router, neutron-api, octavia-diskimage-retrofit, hacluster-octavia, vault-mysql-router, glance-mysql-router
2022-08-30 11:39:29 [INFO] Application placement-mysql-router is ready.
2022-08-30 11:39:39 [INFO] Application mysql-innodb-cluster is ready.
2022-08-30 11:41:33 [INFO] Application keystone-mysql-router is ready.
2022-08-30 11:42:05 [INFO] Application neutron-mysql-router is ready.
2022-08-30 11:42:14 [INFO] Application vault-mysql-router is ready.
2022-08-30 11:42:28 [INFO] Application glance-mysql-router is ready.
2022-08-30 11:42:33 [INFO] Application vault is ready.
2022-08-30 11:43:44 [INFO] Application nova-mysql-router is ready.
2022-08-30 11:46:54 [INFO] Applications left: octavia, neutron-openvswitch-octavia, neutron-openvswitch, placement, glance, keystone, nova-cloud-controller, octavia-mysql-router, neutron-api, octavia-diskimage-retrofit, hacluster-octavia
2022-08-30 11:47:53 [INFO] Application octavia-diskimage-retrofit is ready.
2022-08-30 11:48:05 [INFO] Application glance is ready.
2022-08-30 11:48:20 [INFO] Application placement is ready.
2022-08-30 11:48:26 [INFO] Application neutron-api is ready.
2022-08-30 11:48:58 [INFO] Application keystone is ready.
2022-08-30 11:49:51 [INFO] Application nova-cloud-controller is ready.
2022-08-30 11:49:58 [INFO] Application neutron-openvswitch is ready.
2022-08-30 11:56:54 [INFO] Applications left: octavia, neutron-openvswitch-octavia, octavia-mysql-router, hacluster-octavia
2022-08-30 12:05:01 [INFO] Application hacluster-octavia is ready.
2022-08-30 12:05:30 [INFO] Application neutron-openvswitch-octavia is ready.
2022-08-30 12:06:30 [INFO] Application octavia-mysql-router is ready.
2022-08-30 12:06:55 [INFO] Applications left: octavia
2022-08-30 12:08:48 [INFO] Application octavia is ready.
2022-08-30 12:08:48 [INFO] All applications reached approved status, number of units (where relevant), and workload status message checks.
2022-08-30 12:08:48 [INFO] Waiting for zaza-53d75555945a to settle
2022-08-30 12:08:48 [INFO] Model zaza-53d75555945a has settled
2022-08-30 12:08:48 [INFO] configuring zaza-53d75555945a
2022-08-30 12:08:48 [INFO] Running auto_initialize
2022-08-30 12:09:04 [INFO] Waiting for at least one unit with agent status "executing"
2022-08-30 12:09:04 [INFO] Waiting for application states to reach targeted states.
2022-08-30 12:09:04 [INFO] Waiting for an application to be present
2022-08-30 12:09:04 [INFO] Now checking workload status and status messages
2022-08-30 12:09:05 [INFO] Application neutron-openvswitch-octavia is ready.
2022-08-30 12:09:05 [INFO] Application neutron-mysql-router is ready.
2022-08-30 12:09:05 [INFO] Application nova-compute is ready.
2022-08-30 12:09:05 [INFO] Application rabbitmq-server is ready.
2022-08-30 12:09:05 [INFO] Application mysql-innodb-cluster is ready.
2022-08-30 12:09:05 [INFO] Application nova-cloud-controller is ready.
2022-08-30 12:09:05 [INFO] Application vault is ready.
2022-08-30 12:09:05 [INFO] Application nova-mysql-router is ready.
2022-08-30 12:09:05 [INFO] Application neutron-openvswitch is ready.
2022-08-30 12:09:05 [INFO] Application keystone-mysql-router is ready.
2022-08-30 12:09:06 [INFO] Application octavia-mysql-router is ready.
2022-08-30 12:09:06 [INFO] Application glance-simplestreams-sync is ready.
2022-08-30 12:09:06 [INFO] Application hacluster-octavia is ready.
2022-08-30 12:09:06 [INFO] Application placement-mysql-router is ready.
2022-08-30 12:09:06 [INFO] Application vault-mysql-router is ready.
2022-08-30 12:09:06 [INFO] Application glance-mysql-router is ready.
2022-08-30 12:09:08 [INFO] Application octavia-diskimage-retrofit is ready.
2022-08-30 12:09:15 [INFO] Application glance is ready.
2022-08-30 12:09:23 [INFO] Application neutron-api is ready.
2022-08-30 12:09:26 [INFO] Application placement is ready.
2022-08-30 12:09:30 [INFO] Application octavia is ready.
2022-08-30 12:15:56 [INFO] Application keystone is ready.
2022-08-30 12:15:56 [INFO] All applications reached approved status, number of units (where relevant), and workload status message checks.
2022-08-30 12:15:56 [WARNING] run_in_model is deprecated. 
2022-08-30 12:15:57 [INFO] Attempting to connect to https://10.247.39.114:5000
2022-08-30 12:16:45 [INFO] Synchronising images using glance-simplestreams-sync
2022-08-30 12:16:46 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:16:47 [INFO] Using keystone API V3 (or later) for overcloud auth
2022-08-30 12:16:47 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:17:58 [INFO] Image architecture set to amd64
2022-08-30 12:17:59 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:17:59 [INFO] Using keystone API V3 (or later) for overcloud auth
2022-08-30 12:18:00 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:18:01 [INFO] Downloading image bionic
2022-08-30 12:18:01 [INFO] Cached image found at /tmp/bionic-server-cloudimg-amd64.img - Skipping download
2022-08-30 12:18:03 [INFO] Image status wait: resource fff95187-1f27-41b6-83a7-70ef1d9ed3a0 in active state, waiting for active
2022-08-30 12:18:03 [INFO] Setting image properties: None
2022-08-30 12:18:03 [INFO] Image architecture set to amd64
2022-08-30 12:18:04 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:18:04 [INFO] Using keystone API V3 (or later) for overcloud auth
2022-08-30 12:18:05 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:18:05 [INFO] Downloading image focal
2022-08-30 12:18:05 [INFO] Cached image found at /tmp/focal-server-cloudimg-amd64.img - Skipping download
2022-08-30 12:18:09 [INFO] Image status wait: resource e4c9d4ed-269d-45f3-b313-8f51631b57d5 in active state, waiting for active
2022-08-30 12:18:09 [INFO] Setting image properties: None
2022-08-30 12:18:09 [INFO] Running `retrofit-image` action on octavia-diskimage-retrofit/0
2022-08-30 12:24:01 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:24:02 [INFO] Using keystone API V3 (or later) for overcloud auth
2022-08-30 12:24:02 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:24:11 [INFO] Creating key zaza
2022-08-30 12:24:18 [INFO] Running `configure-resources` action on Octavia leader unit
2022-08-30 12:25:30 [INFO] Configuring certificates for mandatory Octavia client/server authentication (client being the ``Amphorae`` load balancer instances)
2022-08-30 12:25:32 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:25:32 [INFO] Using keystone API V3 (or later) for overcloud auth
2022-08-30 12:25:32 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:25:33 [INFO] Waiting for at least one unit with agent status "executing"
2022-08-30 12:25:33 [INFO] Waiting for application states to reach targeted states.
2022-08-30 12:25:33 [INFO] Waiting for an application to be present
2022-08-30 12:25:33 [INFO] Now checking workload status and status messages
2022-08-30 12:25:33 [INFO] Application neutron-openvswitch-octavia is ready.
2022-08-30 12:25:33 [INFO] Application glance is ready.
2022-08-30 12:25:33 [INFO] Application neutron-mysql-router is ready.
2022-08-30 12:25:33 [INFO] Application nova-compute is ready.
2022-08-30 12:25:33 [INFO] Application rabbitmq-server is ready.
2022-08-30 12:25:33 [INFO] Application keystone is ready.
2022-08-30 12:25:34 [INFO] Application mysql-innodb-cluster is ready.
2022-08-30 12:25:34 [INFO] Application nova-cloud-controller is ready.
2022-08-30 12:25:34 [INFO] Application vault is ready.
2022-08-30 12:25:34 [INFO] Application nova-mysql-router is ready.
2022-08-30 12:25:34 [INFO] Application neutron-openvswitch is ready.
2022-08-30 12:25:34 [INFO] Application placement is ready.
2022-08-30 12:25:34 [INFO] Application keystone-mysql-router is ready.
2022-08-30 12:25:34 [INFO] Application octavia-mysql-router is ready.
2022-08-30 12:25:34 [INFO] Application neutron-api is ready.
2022-08-30 12:25:34 [INFO] Application octavia-diskimage-retrofit is ready.
2022-08-30 12:25:34 [INFO] Application glance-simplestreams-sync is ready.
2022-08-30 12:25:34 [INFO] Application hacluster-octavia is ready.
2022-08-30 12:25:34 [INFO] Application placement-mysql-router is ready.
2022-08-30 12:25:34 [INFO] Application vault-mysql-router is ready.
2022-08-30 12:25:34 [INFO] Application glance-mysql-router is ready.
2022-08-30 12:26:17 [INFO] Application octavia is ready.
2022-08-30 12:26:17 [INFO] All applications reached approved status, number of units (where relevant), and workload status message checks.
2022-08-30 12:26:17 [INFO] Running `configure-resources` action again to ensure Octavia Nova SSH key pair is created after config change.
2022-08-30 12:26:34 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:26:34 [INFO] Using keystone API V3 (or later) for overcloud auth
2022-08-30 12:26:35 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:26:37 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:26:38 [INFO] Using keystone API V3 (or later) for overcloud auth
2022-08-30 12:26:38 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:26:40 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:26:40 [INFO] Using keystone API V3 (or later) for overcloud auth
2022-08-30 12:26:40 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:26:42 [INFO] Using config /home/frode/.local/share/juju/clouds.yaml
2022-08-30 12:26:44 [INFO] Machine 6racaf selected enp6s0 (00:16:3e:36:ed:0c) for external networking.
2022-08-30 12:26:44 [INFO] Machine xr6wap selected enp6s0 (00:16:3e:9c:5c:da) for external networking.
2022-08-30 12:26:44 [INFO] Machine wwpde6 selected enp6s0 (00:16:3e:01:f9:ed) for external networking.
2022-08-30 12:26:44 [INFO] Machine 6rckb6 selected enp6s0 (00:16:3e:bf:b4:c9) for external networking.
2022-08-30 12:26:44 [INFO] Machine ex3ahf selected enp6s0 (00:16:3e:7d:ec:0e) for external networking.
2022-08-30 12:26:44 [INFO] Machine fn8fdp selected enp6s0 (00:16:3e:4a:41:22) for external networking.
2022-08-30 12:26:44 [INFO] Machine hg6yb4 selected enp6s0 (00:16:3e:f0:d1:9e) for external networking.
2022-08-30 12:26:44 [INFO] Machine q8k4yt selected enp6s0 (00:16:3e:d2:c7:16) for external networking.
2022-08-30 12:26:44 [INFO] Machine 6abnh8 selected enp6s0 (00:16:3e:56:25:44) for external networking.
2022-08-30 12:26:44 [INFO] Machine w84mbc selected enp6s0 (00:16:3e:67:b0:55) for external networking.
2022-08-30 12:26:44 [INFO] Machine kqqg6k selected enp6s0 (00:16:3e:dd:4b:95) for external networking.
2022-08-30 12:26:44 [INFO] Machine 7xyqfq selected enp6s0 (00:16:3e:8e:22:ba) for external networking.
2022-08-30 12:26:44 [INFO] Machine dcpnmk selected enp6s0 (00:16:3e:86:fc:ba) for external networking.
2022-08-30 12:26:44 [INFO] Machine eagswy selected enp6s0 (00:16:3e:ae:cc:89) for external networking.
2022-08-30 12:26:44 [INFO] Machine 8cdnr3 selected enp6s0 (00:16:3e:e8:f2:29) for external networking.
2022-08-30 12:26:44 [INFO] Machine ghbp76 selected enp6s0 (00:16:3e:96:aa:14) for external networking.
2022-08-30 12:26:44 [INFO] Machine rg3rb6 selected enp6s0 (00:16:3e:c4:83:f7) for external networking.
2022-08-30 12:26:44 [INFO] Machine qcg8dm selected enp6s0 (00:16:3e:8c:9d:4b) for external networking.
2022-08-30 12:26:44 [INFO] Machine mr6nyk selected enp6s0 (00:16:3e:f3:47:12) for external networking.
2022-08-30 12:26:44 [INFO] Machine bcs74e selected enp6s0 (00:16:3e:d8:2d:20) for external networking.
2022-08-30 12:26:44 [INFO] Machine yqhk6c selected enp6s0 (00:16:3e:3a:24:cc) for external networking.
2022-08-30 12:26:44 [INFO] Machine f47sae selected enp6s0 (00:16:3e:a9:ad:2d) for external networking.
2022-08-30 12:26:44 [INFO] Machine hpe3k4 selected enp6s0 (00:16:3e:a1:db:7d) for external networking.
2022-08-30 12:26:44 [INFO] Machine 7n3ffr selected enp6s0 (00:16:3e:62:ce:7d) for external networking.
2022-08-30 12:26:44 [INFO] Machine a667qe selected enp6s0 (00:16:3e:9d:ba:00) for external networking.
2022-08-30 12:26:44 [INFO] Machine dcb46g selected enp6s0 (00:16:3e:37:e6:de) for external networking.
2022-08-30 12:26:44 [INFO] Machine w6kcft selected enp6s0 (00:16:3e:93:19:bc) for external networking.
2022-08-30 12:26:44 [INFO] Machine m7s3ne selected enp6s0 (00:16:3e:a7:7b:70) for external networking.
2022-08-30 12:26:44 [INFO] Setting {'data-port': 'br-ex:00:16:3e:01:f9:ed br-ex:00:16:3e:36:ed:0c br-ex:00:16:3e:37:e6:de br-ex:00:16:3e:3a:24:cc br-ex:00:16:3e:4a:41:22 br-ex:00:16:3e:56:25:44 br-ex:00:16:3e:62:ce:7d br-ex:00:16:3e:67:b0:55 br-ex:00:16:3e:7d:ec:0e br-ex:00:16:3e:86:fc:ba br-ex:00:16:3e:8c:9d:4b br-ex:00:16:3e:8e:22:ba br-ex:00:16:3e:93:19:bc br-ex:00:16:3e:96:aa:14 br-ex:00:16:3e:9c:5c:da br-ex:00:16:3e:9d:ba:00 br-ex:00:16:3e:a1:db:7d br-ex:00:16:3e:a7:7b:70 br-ex:00:16:3e:a9:ad:2d br-ex:00:16:3e:ae:cc:89 br-ex:00:16:3e:bf:b4:c9 br-ex:00:16:3e:c4:83:f7 br-ex:00:16:3e:d2:c7:16 br-ex:00:16:3e:d8:2d:20 br-ex:00:16:3e:dd:4b:95 br-ex:00:16:3e:e8:f2:29 br-ex:00:16:3e:f0:d1:9e br-ex:00:16:3e:f3:47:12'} on neutron-openvswitch
2022-08-30 12:26:44 [INFO] Waiting for at least one unit with agent status "executing"
2022-08-30 12:26:45 [INFO] Waiting for application states to reach targeted states.
2022-08-30 12:26:45 [INFO] Waiting for an application to be present
2022-08-30 12:26:45 [INFO] Now checking workload status and status messages
2022-08-30 12:26:46 [INFO] Application octavia is ready.
2022-08-30 12:26:46 [INFO] Application neutron-openvswitch-octavia is ready.
2022-08-30 12:26:46 [INFO] Application glance is ready.
2022-08-30 12:26:46 [INFO] Application neutron-mysql-router is ready.
2022-08-30 12:26:46 [INFO] Application nova-compute is ready.
2022-08-30 12:26:46 [INFO] Application rabbitmq-server is ready.
2022-08-30 12:26:46 [INFO] Application keystone is ready.
2022-08-30 12:26:46 [INFO] Application mysql-innodb-cluster is ready.
2022-08-30 12:26:46 [INFO] Application nova-cloud-controller is ready.
2022-08-30 12:26:46 [INFO] Application vault is ready.
2022-08-30 12:26:46 [INFO] Application nova-mysql-router is ready.
2022-08-30 12:26:46 [INFO] Application placement is ready.
2022-08-30 12:26:46 [INFO] Application keystone-mysql-router is ready.
2022-08-30 12:26:46 [INFO] Application octavia-mysql-router is ready.
2022-08-30 12:26:46 [INFO] Application neutron-api is ready.
2022-08-30 12:26:46 [INFO] Application octavia-diskimage-retrofit is ready.
2022-08-30 12:26:46 [INFO] Application glance-simplestreams-sync is ready.
2022-08-30 12:26:46 [INFO] Application hacluster-octavia is ready.
2022-08-30 12:26:46 [INFO] Application placement-mysql-router is ready.
2022-08-30 12:26:46 [INFO] Application vault-mysql-router is ready.
2022-08-30 12:26:46 [INFO] Application glance-mysql-router is ready.
2022-08-30 12:27:49 [INFO] Application neutron-openvswitch is ready.
2022-08-30 12:27:49 [INFO] All applications reached approved status, number of units (where relevant), and workload status message checks.
2022-08-30 12:27:49 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:27:50 [INFO] Configuring overcloud network
2022-08-30 12:27:50 [INFO] Creating flat external network: ext_net
2022-08-30 12:27:50 [INFO] Network ext_net created: 0c3a3b8f-99e3-4edb-87f5-5fba8d5bee26
2022-08-30 12:27:50 [INFO] Creating new subnet
2022-08-30 12:27:51 [INFO] New subnet created: 9c010f4a-ec49-46f2-a883-774a1c84eb60
2022-08-30 12:27:51 [INFO] Creating provider router for external network access
2022-08-30 12:27:51 [INFO] New router created: cb51cd54-f7bb-42b9-a95f-07aef0f7b7ac
2022-08-30 12:27:51 [INFO] Plugging router into ext_net
2022-08-30 12:27:53 [INFO] Router connected
2022-08-30 12:27:53 [INFO] Creating public address scope
2022-08-30 12:27:53 [INFO] New address scope created: 1bc669f0-59dc-489c-beec-2876f2df57b1
2022-08-30 12:27:53 [INFO] Creating subnetpool: pooled_subnets
2022-08-30 12:27:54 [INFO] Creating network: private
2022-08-30 12:27:54 [INFO] Creating subnet
2022-08-30 12:27:55 [INFO] Updating dns_nameservers (10.78.95.1) for subnet
2022-08-30 12:27:55 [INFO] Adding interface from subnet to provider-router
2022-08-30 12:27:58 [INFO] Adding ssh security group rule
2022-08-30 12:27:59 [INFO] Adding ping security group rule
2022-08-30 12:28:00 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:28:00 [INFO] Using keystone API V3 (or later) for overcloud auth
2022-08-30 12:28:01 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:28:07 [INFO] Finished configuring zaza-53d75555945a
2022-08-30 12:28:07 [INFO] Testing zaza-53d75555945a
2022-08-30 12:28:07 [INFO] ## Running Test zaza.openstack.charm_tests.octavia.tests.LBAASv2Test ##
2022-08-30 12:28:07 [WARNING] unknown facade EnvironUpgrader
2022-08-30 12:28:07 [WARNING] unexpected facade EnvironUpgrader found, unable to decipher version to use
2022-08-30 12:28:09 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:28:09 [INFO] Using keystone API V3 (or later) for overcloud auth
2022-08-30 12:28:10 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:28:18 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:28:18 [INFO] Grant "load-balancer_admin" role to current user with "project" scope...
2022-08-30 12:28:19 [INFO] test_create_loadbalancer (zaza.openstack.charm_tests.octavia.tests.LBAASv2Test)
2022-08-30 12:28:19 [INFO] Create load balancer.
2022-08-30 12:28:19 [INFO]  ... 
2022-08-30 12:28:19 [WARNING] Security group rules for ssh already added
2022-08-30 12:28:19 [WARNING] Security group rules for ping already added
2022-08-30 12:28:19 [INFO] Adding custom port 80 security group rule
2022-08-30 12:28:21 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:28:21 [INFO] Using keystone API V3 (or later) for overcloud auth
2022-08-30 12:28:22 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:28:23 [INFO] Launching instance zaza-octavia-ins-1
2022-08-30 12:28:24 [INFO] Checking instance is active
2022-08-30 12:28:24 [INFO] resource: resource cca815ef-3c51-41f5-8b4a-3a60b854ea6d in BUILD state, waiting for ACTIVE
2022-08-30 12:28:25 [INFO] resource: resource cca815ef-3c51-41f5-8b4a-3a60b854ea6d in BUILD state, waiting for ACTIVE
2022-08-30 12:28:28 [INFO] resource: resource cca815ef-3c51-41f5-8b4a-3a60b854ea6d in BUILD state, waiting for ACTIVE
2022-08-30 12:28:32 [INFO] resource: resource cca815ef-3c51-41f5-8b4a-3a60b854ea6d in BUILD state, waiting for ACTIVE
2022-08-30 12:28:40 [INFO] resource: resource cca815ef-3c51-41f5-8b4a-3a60b854ea6d in BUILD state, waiting for ACTIVE
2022-08-30 12:28:56 [INFO] resource: resource cca815ef-3c51-41f5-8b4a-3a60b854ea6d in BUILD state, waiting for ACTIVE
2022-08-30 12:29:29 [INFO] resource: resource cca815ef-3c51-41f5-8b4a-3a60b854ea6d in BUILD state, waiting for ACTIVE
2022-08-30 12:30:33 [INFO] resource: resource cca815ef-3c51-41f5-8b4a-3a60b854ea6d in BUILD state, waiting for ACTIVE
2022-08-30 12:32:33 [INFO] resource: resource cca815ef-3c51-41f5-8b4a-3a60b854ea6d in BUILD state, waiting for ACTIVE
2022-08-30 12:34:34 [INFO] resource: resource cca815ef-3c51-41f5-8b4a-3a60b854ea6d in ACTIVE state, waiting for ACTIVE
2022-08-30 12:34:34 [INFO] Checking cloud init is complete
2022-08-30 12:34:35 [INFO] Assigning floating ip.
2022-08-30 12:34:35 [INFO] Creating floatingip
2022-08-30 12:34:37 [INFO] Assigned floating IP 10.78.95.97 to zaza-octavia-ins-1
2022-08-30 12:34:39 [INFO] Testing ssh access.
2022-08-30 12:34:39 [INFO] Attempting to ssh to zaza-octavia-ins-1(10.78.95.97)
2022-08-30 12:34:39 [INFO] Connected (version 2.0, client OpenSSH_7.6p1)
2022-08-30 12:34:39 [INFO] Authentication (publickey) successful!
2022-08-30 12:34:39 [INFO] Running uname -n on zaza-octavia-ins-1
2022-08-30 12:34:40 [INFO] SSH to zaza-octavia-ins-1(10.78.95.97) successful
2022-08-30 12:34:42 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:34:42 [INFO] Using keystone API V3 (or later) for overcloud auth
2022-08-30 12:34:43 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:34:44 [INFO] Launching instance zaza-octavia-ins-2
2022-08-30 12:34:45 [INFO] Checking instance is active
2022-08-30 12:34:45 [INFO] resource: resource 4bf5022a-aa66-4bac-886d-f3c31f021280 in BUILD state, waiting for ACTIVE
2022-08-30 12:34:46 [INFO] resource: resource 4bf5022a-aa66-4bac-886d-f3c31f021280 in BUILD state, waiting for ACTIVE
2022-08-30 12:34:48 [INFO] resource: resource 4bf5022a-aa66-4bac-886d-f3c31f021280 in BUILD state, waiting for ACTIVE
2022-08-30 12:34:53 [INFO] resource: resource 4bf5022a-aa66-4bac-886d-f3c31f021280 in BUILD state, waiting for ACTIVE
2022-08-30 12:35:01 [INFO] resource: resource 4bf5022a-aa66-4bac-886d-f3c31f021280 in ACTIVE state, waiting for ACTIVE
2022-08-30 12:35:01 [INFO] Checking cloud init is complete
2022-08-30 12:36:07 [INFO] Assigning floating ip.
2022-08-30 12:36:07 [WARNING] A floating IP already exists but ports do not match Potentially creating more than one.
2022-08-30 12:36:07 [INFO] Creating floatingip
2022-08-30 12:36:09 [INFO] Assigned floating IP 10.78.95.121 to zaza-octavia-ins-2
2022-08-30 12:36:11 [INFO] Testing ssh access.
2022-08-30 12:36:11 [INFO] Attempting to ssh to zaza-octavia-ins-2(10.78.95.121)
2022-08-30 12:36:11 [INFO] Connected (version 2.0, client OpenSSH_7.6p1)
2022-08-30 12:36:11 [INFO] Authentication (publickey) successful!
2022-08-30 12:36:11 [INFO] Running uname -n on zaza-octavia-ins-2
2022-08-30 12:36:12 [INFO] SSH to zaza-octavia-ins-2(10.78.95.121) successful
2022-08-30 12:36:16 [INFO] Creating loadbalancer with provider amphora
2022-08-30 12:36:20 [INFO] Awaiting loadbalancer to reach provisioning_status "ACTIVE"
2022-08-30 12:36:22 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:26 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:27 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:28 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:29 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:30 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:31 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:32 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:33 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:34 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:35 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:36 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:37 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:38 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:39 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:40 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:41 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:42 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:43 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:45 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:46 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:47 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:48 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:49 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:50 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:51 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:52 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:53 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:54 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:55 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:56 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:57 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:58 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:36:59 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:00 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:01 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:02 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:03 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:04 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:05 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:06 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:07 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:08 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:09 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:11 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:12 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:13 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:14 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:15 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:16 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:17 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:18 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:19 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:20 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:21 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:22 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:23 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:24 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:25 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:26 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:27 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:28 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:29 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:30 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:31 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:33 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:34 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:35 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:36 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:37 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:38 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:39 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:40 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:41 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:42 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:43 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:44 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:45 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:46 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:47 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:48 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:49 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:50 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:51 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:52 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:53 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:54 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:55 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:57 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:58 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:37:59 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:00 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:01 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:02 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:03 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:04 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:05 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:06 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:07 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:08 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:09 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:10 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:11 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:12 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:13 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:14 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:15 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:16 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:17 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:18 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:19 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:20 [INFO] Current provisioning status: ACTIVE, waiting for ACTIVE
2022-08-30 12:38:20 [INFO] {'id': 'd17fcffb-6b81-475f-a6c9-e610921ddca6', 'name': 'zaza-amphora-0', 'description': 'Created by Zaza', 'provisioning_status': 'ACTIVE', 'operating_status': 'ONLINE', 'admin_state_up': True, 'project_id': '4f288fed250a47d6b82b6b970486a722', 'created_at': '2022-08-30T10:36:20', 'updated_at': '2022-08-30T10:38:20', 'vip_address': '10.42.0.206', 'vip_port_id': '8edb3a42-4675-4039-8453-852e2f47428a', 'vip_subnet_id': 'f366dfe5-7a3f-481c-93ca-5ca17c01f22e', 'vip_network_id': '4fa2eec3-8598-4844-9ed8-ae88edf06cac', 'listeners': [], 'pools': [], 'provider': 'amphora', 'flavor_id': None, 'vip_qos_policy_id': None, 'tags': [], 'availability_zone': None, 'tenant_id': '4f288fed250a47d6b82b6b970486a722'}
2022-08-30 12:38:21 [INFO] Awaiting listener to reach provisioning_status "ACTIVE"
2022-08-30 12:38:21 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:22 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:23 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:24 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:25 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:26 [INFO] Current provisioning status: ACTIVE, waiting for ACTIVE
2022-08-30 12:38:26 [INFO] {'id': '97096f0a-41d8-4123-bf79-85d6dbcd2ecf', 'name': 'listener1', 'description': '', 'provisioning_status': 'ACTIVE', 'operating_status': 'OFFLINE', 'admin_state_up': True, 'protocol': 'HTTP', 'protocol_port': 80, 'connection_limit': -1, 'default_tls_container_ref': None, 'sni_container_refs': [], 'project_id': '4f288fed250a47d6b82b6b970486a722', 'default_pool_id': None, 'l7policies': [], 'insert_headers': {}, 'created_at': '2022-08-30T10:38:21', 'updated_at': '2022-08-30T10:38:26', 'loadbalancers': [{'id': 'd17fcffb-6b81-475f-a6c9-e610921ddca6'}], 'timeout_client_data': 50000, 'timeout_member_connect': 5000, 'timeout_member_data': 50000, 'timeout_tcp_inspect': 0, 'tags': [], 'client_ca_tls_container_ref': None, 'client_authentication': 'NONE', 'client_crl_container_ref': None, 'allowed_cidrs': None, 'tls_ciphers': None, 'tls_versions': None, 'alpn_protocols': None, 'tenant_id': '4f288fed250a47d6b82b6b970486a722'}
2022-08-30 12:38:27 [INFO] Awaiting pool to reach provisioning_status "ACTIVE"
2022-08-30 12:38:27 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:28 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:29 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:30 [INFO] Current provisioning status: ACTIVE, waiting for ACTIVE
2022-08-30 12:38:30 [INFO] {'id': 'c38ab3da-d638-4c94-a4da-7bd3e8848be6', 'name': 'pool1', 'description': '', 'provisioning_status': 'ACTIVE', 'operating_status': 'OFFLINE', 'admin_state_up': True, 'protocol': 'HTTP', 'lb_algorithm': 'ROUND_ROBIN', 'session_persistence': None, 'project_id': '4f288fed250a47d6b82b6b970486a722', 'loadbalancers': [{'id': 'd17fcffb-6b81-475f-a6c9-e610921ddca6'}], 'listeners': [{'id': '97096f0a-41d8-4123-bf79-85d6dbcd2ecf'}], 'created_at': '2022-08-30T10:38:27', 'updated_at': '2022-08-30T10:38:30', 'members': [], 'tags': [], 'tls_container_ref': None, 'ca_tls_container_ref': None, 'crl_container_ref': None, 'tls_enabled': False, 'tls_ciphers': None, 'tls_versions': None, 'alpn_protocols': None, 'tenant_id': '4f288fed250a47d6b82b6b970486a722'}
2022-08-30 12:38:30 [INFO] Awaiting healthmonitor to reach provisioning_status "ACTIVE"
2022-08-30 12:38:30 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:31 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:32 [INFO] Current provisioning status: ACTIVE, waiting for ACTIVE
2022-08-30 12:38:32 [INFO] {'id': 'c43be3e4-cb33-4376-87ca-9726b8eda45f', 'name': '', 'type': 'HTTP', 'delay': 5, 'timeout': 10, 'max_retries': 4, 'max_retries_down': 3, 'http_method': 'GET', 'url_path': '/', 'expected_codes': '200', 'admin_state_up': True, 'project_id': '4f288fed250a47d6b82b6b970486a722', 'pools': [{'id': 'c38ab3da-d638-4c94-a4da-7bd3e8848be6'}], 'provisioning_status': 'ACTIVE', 'operating_status': 'ONLINE', 'created_at': '2022-08-30T10:38:31', 'updated_at': '2022-08-30T10:38:32', 'tags': [], 'http_version': None, 'domain_name': None, 'tenant_id': '4f288fed250a47d6b82b6b970486a722'}
2022-08-30 12:38:34 [INFO] Awaiting member to reach provisioning_status "ACTIVE"
2022-08-30 12:38:34 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:35 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:36 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:37 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:38 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:40 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:41 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:42 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:43 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:44 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:45 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:46 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:47 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:48 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:50 [INFO] Current provisioning status: ACTIVE, waiting for ACTIVE
2022-08-30 12:38:50 [INFO] {'id': '3cd6df97-0a47-432e-8d0a-88e8e894ec0b', 'name': '', 'operating_status': 'ONLINE', 'provisioning_status': 'ACTIVE', 'admin_state_up': True, 'address': '192.168.0.114', 'protocol_port': 80, 'weight': 1, 'backup': False, 'subnet_id': '8498bb48-8121-46ab-a586-65bbd3b5c2d4', 'project_id': '4f288fed250a47d6b82b6b970486a722', 'created_at': '2022-08-30T10:38:34', 'updated_at': '2022-08-30T10:38:50', 'monitor_address': None, 'monitor_port': None, 'tags': [], 'tenant_id': '4f288fed250a47d6b82b6b970486a722'}
2022-08-30 12:38:50 [INFO] Awaiting member to reach provisioning_status "ACTIVE"
2022-08-30 12:38:50 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:51 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:53 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:54 [INFO] Current provisioning status: PENDING_CREATE, waiting for ACTIVE
2022-08-30 12:38:55 [INFO] Current provisioning status: ACTIVE, waiting for ACTIVE
2022-08-30 12:38:55 [INFO] {'id': '1e3ce6ac-ce14-4b89-aac9-d4367865b6b0', 'name': '', 'operating_status': 'OFFLINE', 'provisioning_status': 'ACTIVE', 'admin_state_up': True, 'address': '192.168.0.183', 'protocol_port': 80, 'weight': 1, 'backup': False, 'subnet_id': '8498bb48-8121-46ab-a586-65bbd3b5c2d4', 'project_id': '4f288fed250a47d6b82b6b970486a722', 'created_at': '2022-08-30T10:38:51', 'updated_at': '2022-08-30T10:38:54', 'monitor_address': None, 'monitor_port': None, 'tags': [], 'tenant_id': '4f288fed250a47d6b82b6b970486a722'}
2022-08-30 12:38:55 [WARNING] A floating IP already exists but ports do not match Potentially creating more than one.
2022-08-30 12:38:55 [INFO] Creating floatingip
--2022-08-30 12:38:57--  http://10.78.95.150/
Connecting to 10.78.95.150:80... connected.
HTTP request sent, awaiting response... 200 OK
Length: 10918 (11K) [text/html]
Saving to: ‘STDOUT’

-                   100%[===================>]  10.66K  --.-KB/s    in 0s      

2022-08-30 12:38:58 (375 MB/s) - written to stdout [10918/10918]

2022-08-30 12:38:58 [INFO] Found "This is the default welcome page" in page retrieved through load balancer  (provider="amphora") at "http://10.78.95.150/"
2022-08-30 12:38:58 [INFO] Running resource cleanup
2022-08-30 12:38:59 [INFO] Current provisioning status: PENDING_DELETE, waiting for DELETED
2022-08-30 12:39:00 [INFO] Current provisioning status: PENDING_DELETE, waiting for DELETED
2022-08-30 12:39:01 [INFO] Current provisioning status: PENDING_DELETE, waiting for DELETED
2022-08-30 12:39:02 [INFO] Current provisioning status: PENDING_DELETE, waiting for DELETED
2022-08-30 12:39:03 [INFO] Current provisioning status: PENDING_DELETE, waiting for DELETED
2022-08-30 12:39:04 [INFO] Current provisioning status: PENDING_DELETE, waiting for DELETED
2022-08-30 12:39:28 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:39:28 [INFO] Revoke "load-balancer_admin" role from current user with "project" scope...
2022-08-30 12:39:29 [INFO] Removing instances launched by test (zaza-octavia*)
2022-08-30 12:39:37 [INFO] ok
2022-08-30 12:39:37 [INFO] ----------------------------------------------------------------------
2022-08-30 12:39:37 [INFO] Ran 1 test in 690.761s
2022-08-30 12:39:37 [INFO] OK
2022-08-30 12:39:37 [INFO] ## Running Test zaza.openstack.charm_tests.octavia.tests.CharmOperationTest ##
2022-08-30 12:39:37 [WARNING] unknown facade EnvironUpgrader
2022-08-30 12:39:37 [WARNING] unexpected facade EnvironUpgrader found, unable to decipher version to use
2022-08-30 12:39:40 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:39:40 [INFO] Using keystone API V3 (or later) for overcloud auth
2022-08-30 12:39:41 [INFO] looking at application: {'name': 'keystone', 'type': {'pkg': 'keystone', 'origin_setting': 'openstack-origin'}}
2022-08-30 12:39:41 [INFO] test_pause_resume (zaza.openstack.charm_tests.octavia.tests.CharmOperationTest)
2022-08-30 12:39:41 [INFO] Run pause and resume tests.
2022-08-30 12:39:41 [INFO]  ... 
2022-08-30 12:39:41 [INFO] Skipping pause resume test LP: #1886202...
2022-08-30 12:39:41 [INFO] ok
2022-08-30 12:39:41 [INFO] test_update_controller_ip_port_list (zaza.openstack.charm_tests.octavia.tests.CharmOperationTest)
2022-08-30 12:39:41 [INFO] Test update_controller_ip_port_list.
2022-08-30 12:39:41 [INFO]  ... 
2022-08-30 12:39:41 [INFO] skipped 'Skipping because of lp:1951858'
2022-08-30 12:39:41 [INFO] ----------------------------------------------------------------------
2022-08-30 12:39:41 [INFO] Ran 2 tests in 3.508s
2022-08-30 12:39:41 [INFO] OK
2022-08-30 12:39:41 [INFO]  (skipped=1)
2022-08-30 12:39:41 [INFO] Finished testing zaza-53d75555945a
2022-08-30 12:39:41 [INFO] Events:
  Configure zaza.openstack.charm_tests.glance_simplestreams_sync.setup.sync_images:
    Start: 1661854605.9155147
    Finish: 1661854678.5910633
    Elapsed Time: 72.6755485534668
    PCT Of Run Time: 2
  Configure zaza.openstack.charm_tests.neutron.setup.basic_overcloud_network:
    Start: 1661855199.14681
    Finish: 1661855279.3871088
    Elapsed Time: 80.24029874801636
    PCT Of Run Time: 2
  Configure zaza.openstack.charm_tests.nova.setup.create_flavors:
    Start: 1661855193.2634284
    Finish: 1661855196.5718856
    Elapsed Time: 3.308457136154175
    PCT Of Run Time: 1
  Configure zaza.openstack.charm_tests.nova.setup.manage_ssh_key:
    Start: 1661855196.5719476
    Finish: 1661855199.146771
    Elapsed Time: 2.5748233795166016
    PCT Of Run Time: 1
  Configure zaza.openstack.charm_tests.octavia.diskimage_retrofit.setup.retrofit_amphora_image:
    Start: 1661854689.059157
    Finish: 1661855040.911819
    Elapsed Time: 351.8526620864868
    PCT Of Run Time: 7
  Configure zaza.openstack.charm_tests.octavia.setup.centralized_fip_network:
    Start: 1661855279.3871627
    Finish: 1661855287.0413218
    Elapsed Time: 7.654159069061279
    PCT Of Run Time: 1
  Configure zaza.openstack.charm_tests.octavia.setup.configure_octavia:
    Start: 1661855040.9118912
    Finish: 1661855193.2633686
    Elapsed Time: 152.35147738456726
    PCT Of Run Time: 4
  Configure zaza.openstack.charm_tests.octavia.setup.ensure_lts_images:
    Start: 1661854678.5911036
    Finish: 1661854689.0590947
    Elapsed Time: 10.46799111366272
    PCT Of Run Time: 1
  Configure zaza.openstack.charm_tests.vault.setup.auto_initialize:
    Start: 1661854128.0862336
    Finish: 1661854605.9154718
    Elapsed Time: 477.8292381763458
    PCT Of Run Time: 10
  Deploy Bundle:
    Start: 1661850946.522301
    Finish: 1661851013.4996336
    Elapsed Time: 66.9773325920105
    PCT Of Run Time: 2
  Prepare Environment:
    Start: 1661850941.80525
    Finish: 1661850946.5220206
    Elapsed Time: 4.716770648956299
    PCT Of Run Time: 1
  Test zaza.openstack.charm_tests.octavia.tests.CharmOperationTest:
    Start: 1661855977.8041673
    Finish: 1661855981.3125234
    Elapsed Time: 3.5083560943603516
    PCT Of Run Time: 1
  Test zaza.openstack.charm_tests.octavia.tests.LBAASv2Test:
    Start: 1661855287.0416603
    Finish: 1661855977.80413
    Elapsed Time: 690.7624697685242
    PCT Of Run Time: 14
  Wait for Deployment:
    Start: 1661851013.4996395
    Finish: 1661854128.0850334
    Elapsed Time: 3114.5853939056396
    PCT Of Run Time: 62
Metadata: {}

___________________________________ summary ____________________________________
  func-target: commands succeeded
  congratulations :)

$ juju run -m zaza-53d75555945a --application nova-compute 'dpkg -l | grep openvswitch'
- Stdout: |
    ii  neutron-openvswitch-agent             2:19.4.0-0ubuntu1~cloud0                             all          Neutron is a virtual network service for Openstack - Open vSwitch plugin agent
    ii  openvswitch-common                    2.16.4-0ubuntu1~cloud0                               amd64        Open vSwitch common components
    ii  openvswitch-switch                    2.16.4-0ubuntu1~cloud0                               amd64        Open vSwitch switch implementations
    ii  python3-openvswitch                   2.16.4-0ubuntu1~cloud0                               all          Python 3 bindings for Open vSwitch
  UnitId: nova-compute/0
- Stdout: |
    ii  neutron-openvswitch-agent             2:19.4.0-0ubuntu1~cloud0                             all          Neutron is a virtual network service for Openstack - Open vSwitch plugin agent
    ii  openvswitch-common                    2.16.4-0ubuntu1~cloud0                               amd64        Open vSwitch common components
    ii  openvswitch-switch                    2.16.4-0ubuntu1~cloud0                               amd64        Open vSwitch switch implementations
    ii  python3-openvswitch                   2.16.4-0ubuntu1~cloud0                               all          Python 3 bindings for Open vSwitch
  UnitId: nova-compute/1
- Stdout: |
    ii  neutron-openvswitch-agent             2:19.4.0-0ubuntu1~cloud0                             all          Neutron is a virtual network service for Openstack - Open vSwitch plugin agent
    ii  openvswitch-common                    2.16.4-0ubuntu1~cloud0                               amd64        Open vSwitch common components
    ii  openvswitch-switch                    2.16.4-0ubuntu1~cloud0                               amd64        Open vSwitch switch implementations
    ii  python3-openvswitch                   2.16.4-0ubuntu1~cloud0                               all          Python 3 bindings for Open vSwitch
  UnitId: nova-compute/2

$ juju run -m zaza-53d75555945a --application octavia 'dpkg -l | grep openvswitch'
- Stdout: |
    ii  neutron-openvswitch-agent      2:19.4.0-0ubuntu1~cloud0                    all          Neutron is a virtual network service for Openstack - Open vSwitch plugin agent
    ii  openvswitch-common             2.16.4-0ubuntu1~cloud0                      amd64        Open vSwitch common components
    ii  openvswitch-switch             2.16.4-0ubuntu1~cloud0                      amd64        Open vSwitch switch implementations
    ii  python3-openvswitch            2.16.4-0ubuntu1~cloud0                      all          Python 3 bindings for Open vSwitch
  UnitId: octavia/0
- Stdout: |
    ii  neutron-openvswitch-agent      2:19.4.0-0ubuntu1~cloud0                    all          Neutron is a virtual network service for Openstack - Open vSwitch plugin agent
    ii  openvswitch-common             2.16.4-0ubuntu1~cloud0                      amd64        Open vSwitch common components
    ii  openvswitch-switch             2.16.4-0ubuntu1~cloud0                      amd64        Open vSwitch switch implementations
    ii  python3-openvswitch            2.16.4-0ubuntu1~cloud0                      all          Python 3 bindings for Open vSwitch
  UnitId: octavia/1
- Stdout: |
    ii  neutron-openvswitch-agent      2:19.4.0-0ubuntu1~cloud0                    all          Neutron is a virtual network service for Openstack - Open vSwitch plugin agent
    ii  openvswitch-common             2.16.4-0ubuntu1~cloud0                      amd64        Open vSwitch common components
    ii  openvswitch-switch             2.16.4-0ubuntu1~cloud0                      amd64        Open vSwitch switch implementations
    ii  python3-openvswitch            2.16.4-0ubuntu1~cloud0                      all          Python 3 bindings for Open vSwitch
  UnitId: octavia/2