Commited 907129

new_logs/907129/devstack_logs/devstacklog.txt

@@ -1 +1 @@
-/tmp/devstack_logs/devstacklog.txt.2024-02-18-095748
+/tmp/devstack_logs/devstacklog.txt.2024-02-18-104957

new_logs/907129/devstack_logs/devstacklog.txt.2024-02-18-104957.summary.2024-02-18-104957

@@ -0,0 +1,27 @@
+2024-02-18 10:49:57.333 | stack.sh log /tmp/devstack_logs/devstacklog.txt.2024-02-18-104957
+2024-02-18 10:50:13.057 | Installing package prerequisites
+2024-02-18 10:53:23.510 | Starting RabbitMQ
+2024-02-18 10:54:17.194 | Installing OpenStack project source
+2024-02-18 11:10:55.787 | Installing Tempest
+2024-02-18 11:11:04.190 | Configuring and starting MySQL
+2024-02-18 11:11:33.221 | Starting Keystone
+2024-02-18 11:12:22.422 | Configuring Horizon
+2024-02-18 11:13:30.526 | Configuring Glance
+2024-02-18 11:13:30.739 | Configuring Neutron
+2024-02-18 11:14:20.629 | Configuring Swift
+2024-02-18 11:14:20.868 | Configuring Cinder
+2024-02-18 11:14:21.097 | Configuring placement
+2024-02-18 11:14:42.115 | Configuring Nova
+2024-02-18 11:14:57.670 | Starting Swift
+2024-02-18 11:15:53.032 | Starting Nova API
+2024-02-18 11:15:58.532 | Starting OVN services
+2024-02-18 11:16:30.190 | Starting Neutron
+2024-02-18 11:16:37.320 | Starting Placement
+2024-02-18 11:16:45.514 | Creating initial neutron network elements
+2024-02-18 11:17:26.062 | Starting Nova
+2024-02-18 11:17:46.151 | Starting Cinder
+2024-02-18 11:17:59.159 | Starting Glance
+2024-02-18 11:18:04.227 | Uploading images
+2024-02-18 11:18:21.723 | Starting Horizon
+2024-02-18 11:18:48.519 | Configuring lvm.conf global device filter
+2024-02-18 11:18:48.824 | set lvm.conf device global_filter to: global_filter = [ "r|.*|" ] # from devstack

new_logs/907129/devstack_logs/devstacklog.txt.summary

@@ -1 +1 @@
-/tmp/devstack_logs/devstacklog.txt.2024-02-18-095748.summary.2024-02-18-095748
+/tmp/devstack_logs/devstacklog.txt.2024-02-18-104957.summary.2024-02-18-104957

new_logs/907129/devstack_logs/error.log

@@ -0,0 +1 @@
+[ERROR] /opt/stack/devstack/functions-common:713 git call failed: [git fetch origin master]

new_logs/907129/etc/cinder/cinder.conf

@@ -14,8 +14,8 @@ auth_type = password
 [DEFAULT]
 volume_name_template = openstack-ci-%s
 iscsi_helper = tgtadm
-cinder_internal_tenant_user_id = 700dd81c6e6c40a192e9141ac479a529
-cinder_internal_tenant_project_id = 61e2ec524ae04990b4ca6dc2497f0b56
+cinder_internal_tenant_user_id = 8c04af908dd6456a893d85a8bd10e52f
+cinder_internal_tenant_project_id = 622f41ec73504f19bddeffabc5237752
 graceful_shutdown_timeout = 5
 glance_api_servers = http://10.201.5.82/image
 osapi_volume_workers = 2

new_logs/907129/etc/glance/glance-api.conf

@@ -57,7 +57,7 @@ enforce_new_defaults = true
 enforce_scope = true
 
 [oslo_limit]
-endpoint_id = fce80bc9e1e74aec8c13f6fabf296075
+endpoint_id = f2b9e4d2fc1045f0a4e1e4d339e3c918
 system_scope = all
 auth_url = http://10.201.5.82/identity
 auth_type = password

new_logs/907129/etc/keystone/credential-keys/0

@@ -1 +1 @@
-VR5zuPkmsLUU8bc04aZvji0uROZJHD2Q5DlFqJiSMyg=
+UYIzmUUJ24x_IffeJTVeXHdX_2ygSarpyneAb27ihjI=

new_logs/907129/etc/keystone/credential-keys/1

@@ -1 +1 @@
-lEE7GV-GRmGr1YfXIKP2WcHASF7FrjKNF6s8OH3O2bU=
+xm3_M7IvcL9hquujF1XU5Qiws1zuxqjLstyLDmg0vCQ=

new_logs/907129/etc/keystone/fernet-keys/0

@@ -1 +1 @@
-7xIJSVUDONn20ZjCdH27KIReVMqfIiQrxIG0Yxmqix8=
+qW3VDfZVOnhYTgHGz_0ak2jk0E_SvhpeIxT1PWK2IAg=

new_logs/907129/etc/keystone/fernet-keys/1

@@ -1 +1 @@
-z9VB2De5kSS5egHJNBY6ik9RuSm7XwvKClCUL6CIc7M=
+u36U7OSSQa9Hie4NYa_W4Ie7qUV2KYk3_wsWx2GF5WY=

new_logs/907129/etcd.service

@@ -1,60 +1,61 @@
-Feb 18 10:21:24 ubuntu systemd[1]: Starting Devstack [email protected]...
-Feb 18 10:21:24 ubuntu etcd[65406]: WARNING: Package "github.com/golang/protobuf/protoc-gen-go/generator" is deprecated.
-Feb 18 10:21:24 ubuntu etcd[65406]:         A future release of golang/protobuf will delete this package,
-Feb 18 10:21:24 ubuntu etcd[65406]:         which has long been excluded from the compatibility promise.
-Feb 18 10:21:24 ubuntu etcd[65406]: [WARNING] Deprecated '--debug' flag is set to true (use '--log-level=debug' instead
-Feb 18 10:21:24 ubuntu etcd[65406]: [WARNING] Deprecated '--debug' flag is set to true with inconsistent '--log-level=info' flag
-Feb 18 10:21:24 ubuntu etcd[65406]: [WARNING] Deprecated '--logger=capnslog' flag is set; use '--logger=zap' flag instead
-Feb 18 10:21:24 ubuntu etcd[65406]: [WARNING] Deprecated '--debug' flag is set to true (use '--log-level=debug' instead
-Feb 18 10:21:24 ubuntu etcd[65406]: [WARNING] Deprecated '--debug' flag is set to true with inconsistent '--log-level=info' flag
-Feb 18 10:21:24 ubuntu etcd[65406]: [WARNING] Deprecated '--logger=capnslog' flag is set; use '--logger=zap' flag instead
-Feb 18 10:21:24 ubuntu etcd[65406]: Running http and grpc server on single port. This is not recommended for production.
-Feb 18 10:21:24 ubuntu etcd[65406]: etcd Version: 3.4.27
-Feb 18 10:21:24 ubuntu etcd[65406]: Git SHA: c92fb80f3
-Feb 18 10:21:24 ubuntu etcd[65406]: Go Version: go1.19.10
-Feb 18 10:21:24 ubuntu etcd[65406]: Go OS/Arch: linux/amd64
-Feb 18 10:21:24 ubuntu etcd[65406]: setting maximum number of CPUs to 4, total number of available CPUs is 4
-Feb 18 10:21:24 ubuntu etcd[65406]: Running http and grpc server on single port. This is not recommended for production.
-Feb 18 10:21:24 ubuntu etcd[65406]: name = ubuntu
-Feb 18 10:21:24 ubuntu etcd[65406]: data dir = /opt/stack/data/etcd
-Feb 18 10:21:24 ubuntu etcd[65406]: member dir = /opt/stack/data/etcd/member
-Feb 18 10:21:24 ubuntu etcd[65406]: heartbeat = 100ms
-Feb 18 10:21:24 ubuntu etcd[65406]: election = 1000ms
-Feb 18 10:21:24 ubuntu etcd[65406]: snapshot count = 100000
-Feb 18 10:21:24 ubuntu etcd[65406]: advertise client URLs = http://10.201.5.82:2379
-Feb 18 10:21:24 ubuntu etcd[65406]: check file permission: directory "/opt/stack/data/etcd" exist, but the permission is "dtrwxrwxrwx". The recommended permission is "-rwx------" to prevent possible unprivileged access to the data.
-Feb 18 10:21:24 ubuntu etcd[65406]: starting member 43038365673ccf7b in cluster 4e30dcbc85f3b47b
-Feb 18 10:21:24 ubuntu etcd[65406]: raft2024/02/18 10:21:24 INFO: 43038365673ccf7b switched to configuration voters=()
-Feb 18 10:21:24 ubuntu etcd[65406]: raft2024/02/18 10:21:24 INFO: 43038365673ccf7b became follower at term 0
-Feb 18 10:21:24 ubuntu etcd[65406]: raft2024/02/18 10:21:24 INFO: newRaft 43038365673ccf7b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]
-Feb 18 10:21:24 ubuntu etcd[65406]: raft2024/02/18 10:21:24 INFO: 43038365673ccf7b became follower at term 1
-Feb 18 10:21:24 ubuntu etcd[65406]: raft2024/02/18 10:21:24 INFO: 43038365673ccf7b switched to configuration voters=(4828847697018277755)
-Feb 18 10:21:24 ubuntu etcd[65406]: simple token is not cryptographically signed
-Feb 18 10:21:24 ubuntu etcd[65406]: starting server... [version: 3.4.27, cluster version: to_be_decided]
-Feb 18 10:21:24 ubuntu etcd[65406]: started to purge file, dir: /opt/stack/data/etcd/member/snap, suffix: snap.db, max: 5, interval: 30s
-Feb 18 10:21:24 ubuntu etcd[65406]: started to purge file, dir: /opt/stack/data/etcd/member/snap, suffix: snap, max: 5, interval: 30s
-Feb 18 10:21:24 ubuntu etcd[65406]: started to purge file, dir: /opt/stack/data/etcd/member/wal, suffix: wal, max: 5, interval: 30s
-Feb 18 10:21:24 ubuntu etcd[65406]: 43038365673ccf7b as single-node; fast-forwarding 9 ticks (election ticks 10)
-Feb 18 10:21:24 ubuntu etcd[65406]: raft2024/02/18 10:21:24 INFO: 43038365673ccf7b switched to configuration voters=(4828847697018277755)
-Feb 18 10:21:24 ubuntu etcd[65406]: added member 43038365673ccf7b [http://10.201.5.82:2380] to cluster 4e30dcbc85f3b47b
-Feb 18 10:21:24 ubuntu etcd[65406]: listening for peers on [::]:2380
-Feb 18 10:21:25 ubuntu etcd[65406]: raft2024/02/18 10:21:25 INFO: 43038365673ccf7b is starting a new election at term 1
-Feb 18 10:21:25 ubuntu etcd[65406]: raft2024/02/18 10:21:25 INFO: 43038365673ccf7b became candidate at term 2
-Feb 18 10:21:25 ubuntu etcd[65406]: raft2024/02/18 10:21:25 INFO: 43038365673ccf7b received MsgVoteResp from 43038365673ccf7b at term 2
-Feb 18 10:21:25 ubuntu etcd[65406]: raft2024/02/18 10:21:25 INFO: 43038365673ccf7b became leader at term 2
-Feb 18 10:21:25 ubuntu etcd[65406]: raft2024/02/18 10:21:25 INFO: raft.node: 43038365673ccf7b elected leader 43038365673ccf7b at term 2
-Feb 18 10:21:25 ubuntu etcd[65406]: INFO: 2024/02/18 10:21:25 parsed scheme: ""
-Feb 18 10:21:25 ubuntu etcd[65406]: INFO: 2024/02/18 10:21:25 scheme "" not registered, fallback to default scheme
-Feb 18 10:21:25 ubuntu etcd[65406]: INFO: 2024/02/18 10:21:25 ccResolverWrapper: sending update to cc: {[{10.201.5.82:2379  <nil> 0 <nil>}] <nil> <nil>}
-Feb 18 10:21:25 ubuntu etcd[65406]: INFO: 2024/02/18 10:21:25 ClientConn switching balancer to "pick_first"
-Feb 18 10:21:25 ubuntu etcd[65406]: published {Name:ubuntu ClientURLs:[http://10.201.5.82:2379]} to cluster 4e30dcbc85f3b47b
-Feb 18 10:21:25 ubuntu etcd[65406]: setting up the initial cluster version to 3.4
-Feb 18 10:21:25 ubuntu etcd[65406]: ready to serve client requests
-Feb 18 10:21:25 ubuntu systemd[1]: Started Devstack [email protected].
-Feb 18 10:21:25 ubuntu etcd[65406]: set the initial cluster version to 3.4
-Feb 18 10:21:25 ubuntu etcd[65406]: enabled capabilities for version 3.4
-Feb 18 10:21:25 ubuntu etcd[65406]: serving insecure client requests on 10.201.5.82:2379, this is strongly discouraged!
-Feb 18 10:27:46 ubuntu etcd[65406]: start time = 2024-02-18 10:27:46.770037581 +0000 UTC m=+382.762326880, time spent = 1.019875ms, remote = 10.201.5.82:60578, response type = /etcdserverpb.Lease/LeaseGrant, request count = -1, request size = -1, response count = -1, response size = -1, request content = 
-Feb 18 10:27:46 ubuntu etcd[65406]: start time = 2024-02-18 10:27:46.84336692 +0000 UTC m=+382.835656219, time spent = 263.422µs, remote = 10.201.5.82:60578, response type = /etcdserverpb.Lease/LeaseGrant, request count = -1, request size = -1, response count = -1, response size = -1, request content = 
-Feb 18 10:27:53 ubuntu etcd[65406]: start time = 2024-02-18 10:27:53.686133325 +0000 UTC m=+389.678422623, time spent = 461.613µs, remote = 10.201.5.82:60578, response type = /etcdserverpb.Lease/LeaseGrant, request count = -1, request size = -1, response count = -1, response size = -1, request content = 
-Feb 18 10:27:55 ubuntu etcd[65406]: start time = 2024-02-18 10:27:55.711768894 +0000 UTC m=+391.704058181, time spent = 478.043µs, remote = 10.201.5.82:60578, response type = /etcdserverpb.Lease/LeaseGrant, request count = -1, request size = -1, response count = -1, response size = -1, request content = 
+Feb 18 11:11:31 ubuntu systemd[1]: Starting Devstack [email protected]...
+Feb 18 11:11:31 ubuntu etcd[65202]: WARNING: Package "github.com/golang/protobuf/protoc-gen-go/generator" is deprecated.
+Feb 18 11:11:31 ubuntu etcd[65202]:         A future release of golang/protobuf will delete this package,
+Feb 18 11:11:31 ubuntu etcd[65202]:         which has long been excluded from the compatibility promise.
+Feb 18 11:11:31 ubuntu etcd[65202]: [WARNING] Deprecated '--debug' flag is set to true (use '--log-level=debug' instead
+Feb 18 11:11:31 ubuntu etcd[65202]: [WARNING] Deprecated '--debug' flag is set to true with inconsistent '--log-level=info' flag
+Feb 18 11:11:31 ubuntu etcd[65202]: [WARNING] Deprecated '--logger=capnslog' flag is set; use '--logger=zap' flag instead
+Feb 18 11:11:31 ubuntu etcd[65202]: [WARNING] Deprecated '--debug' flag is set to true (use '--log-level=debug' instead
+Feb 18 11:11:31 ubuntu etcd[65202]: [WARNING] Deprecated '--debug' flag is set to true with inconsistent '--log-level=info' flag
+Feb 18 11:11:31 ubuntu etcd[65202]: [WARNING] Deprecated '--logger=capnslog' flag is set; use '--logger=zap' flag instead
+Feb 18 11:11:31 ubuntu etcd[65202]: Running http and grpc server on single port. This is not recommended for production.
+Feb 18 11:11:31 ubuntu etcd[65202]: etcd Version: 3.4.27
+Feb 18 11:11:31 ubuntu etcd[65202]: Git SHA: c92fb80f3
+Feb 18 11:11:31 ubuntu etcd[65202]: Go Version: go1.19.10
+Feb 18 11:11:31 ubuntu etcd[65202]: Go OS/Arch: linux/amd64
+Feb 18 11:11:31 ubuntu etcd[65202]: setting maximum number of CPUs to 4, total number of available CPUs is 4
+Feb 18 11:11:31 ubuntu etcd[65202]: Running http and grpc server on single port. This is not recommended for production.
+Feb 18 11:11:31 ubuntu etcd[65202]: name = ubuntu
+Feb 18 11:11:31 ubuntu etcd[65202]: data dir = /opt/stack/data/etcd
+Feb 18 11:11:31 ubuntu etcd[65202]: member dir = /opt/stack/data/etcd/member
+Feb 18 11:11:31 ubuntu etcd[65202]: heartbeat = 100ms
+Feb 18 11:11:31 ubuntu etcd[65202]: election = 1000ms
+Feb 18 11:11:31 ubuntu etcd[65202]: snapshot count = 100000
+Feb 18 11:11:31 ubuntu etcd[65202]: advertise client URLs = http://10.201.5.82:2379
+Feb 18 11:11:31 ubuntu etcd[65202]: check file permission: directory "/opt/stack/data/etcd" exist, but the permission is "dtrwxrwxrwx". The recommended permission is "-rwx------" to prevent possible unprivileged access to the data.
+Feb 18 11:11:31 ubuntu etcd[65202]: starting member 43038365673ccf7b in cluster 4e30dcbc85f3b47b
+Feb 18 11:11:31 ubuntu etcd[65202]: raft2024/02/18 11:11:31 INFO: 43038365673ccf7b switched to configuration voters=()
+Feb 18 11:11:31 ubuntu etcd[65202]: raft2024/02/18 11:11:31 INFO: 43038365673ccf7b became follower at term 0
+Feb 18 11:11:31 ubuntu etcd[65202]: raft2024/02/18 11:11:31 INFO: newRaft 43038365673ccf7b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]
+Feb 18 11:11:31 ubuntu etcd[65202]: raft2024/02/18 11:11:31 INFO: 43038365673ccf7b became follower at term 1
+Feb 18 11:11:31 ubuntu etcd[65202]: raft2024/02/18 11:11:31 INFO: 43038365673ccf7b switched to configuration voters=(4828847697018277755)
+Feb 18 11:11:31 ubuntu etcd[65202]: simple token is not cryptographically signed
+Feb 18 11:11:31 ubuntu etcd[65202]: starting server... [version: 3.4.27, cluster version: to_be_decided]
+Feb 18 11:11:31 ubuntu etcd[65202]: 43038365673ccf7b as single-node; fast-forwarding 9 ticks (election ticks 10)
+Feb 18 11:11:31 ubuntu etcd[65202]: started to purge file, dir: /opt/stack/data/etcd/member/snap, suffix: snap.db, max: 5, interval: 30s
+Feb 18 11:11:31 ubuntu etcd[65202]: started to purge file, dir: /opt/stack/data/etcd/member/snap, suffix: snap, max: 5, interval: 30s
+Feb 18 11:11:31 ubuntu etcd[65202]: started to purge file, dir: /opt/stack/data/etcd/member/wal, suffix: wal, max: 5, interval: 30s
+Feb 18 11:11:31 ubuntu etcd[65202]: raft2024/02/18 11:11:31 INFO: 43038365673ccf7b switched to configuration voters=(4828847697018277755)
+Feb 18 11:11:31 ubuntu etcd[65202]: added member 43038365673ccf7b [http://10.201.5.82:2380] to cluster 4e30dcbc85f3b47b
+Feb 18 11:11:31 ubuntu etcd[65202]: listening for peers on [::]:2380
+Feb 18 11:11:32 ubuntu etcd[65202]: raft2024/02/18 11:11:32 INFO: 43038365673ccf7b is starting a new election at term 1
+Feb 18 11:11:32 ubuntu etcd[65202]: raft2024/02/18 11:11:32 INFO: 43038365673ccf7b became candidate at term 2
+Feb 18 11:11:32 ubuntu etcd[65202]: raft2024/02/18 11:11:32 INFO: 43038365673ccf7b received MsgVoteResp from 43038365673ccf7b at term 2
+Feb 18 11:11:32 ubuntu etcd[65202]: raft2024/02/18 11:11:32 INFO: 43038365673ccf7b became leader at term 2
+Feb 18 11:11:32 ubuntu etcd[65202]: raft2024/02/18 11:11:32 INFO: raft.node: 43038365673ccf7b elected leader 43038365673ccf7b at term 2
+Feb 18 11:11:32 ubuntu etcd[65202]: published {Name:ubuntu ClientURLs:[http://10.201.5.82:2379]} to cluster 4e30dcbc85f3b47b
+Feb 18 11:11:32 ubuntu etcd[65202]: ready to serve client requests
+Feb 18 11:11:32 ubuntu etcd[65202]: INFO: 2024/02/18 11:11:32 parsed scheme: ""
+Feb 18 11:11:32 ubuntu etcd[65202]: INFO: 2024/02/18 11:11:32 scheme "" not registered, fallback to default scheme
+Feb 18 11:11:32 ubuntu etcd[65202]: setting up the initial cluster version to 3.4
+Feb 18 11:11:32 ubuntu etcd[65202]: INFO: 2024/02/18 11:11:32 ccResolverWrapper: sending update to cc: {[{10.201.5.82:2379  <nil> 0 <nil>}] <nil> <nil>}
+Feb 18 11:11:32 ubuntu etcd[65202]: INFO: 2024/02/18 11:11:32 ClientConn switching balancer to "pick_first"
+Feb 18 11:11:32 ubuntu etcd[65202]: set the initial cluster version to 3.4
+Feb 18 11:11:32 ubuntu etcd[65202]: enabled capabilities for version 3.4
+Feb 18 11:11:32 ubuntu systemd[1]: Started Devstack [email protected].
+Feb 18 11:11:32 ubuntu etcd[65202]: serving insecure client requests on 10.201.5.82:2379, this is strongly discouraged!
+Feb 18 11:17:49 ubuntu etcd[65202]: start time = 2024-02-18 11:17:49.752514424 +0000 UTC m=+377.917840410, time spent = 1.700861ms, remote = 10.201.5.82:51918, response type = /etcdserverpb.Lease/LeaseGrant, request count = -1, request size = -1, response count = -1, response size = -1, request content = 
+Feb 18 11:17:49 ubuntu etcd[65202]: start time = 2024-02-18 11:17:49.756199116 +0000 UTC m=+377.921525103, time spent = 231.332µs, remote = 10.201.5.82:51918, response type = /etcdserverpb.Lease/LeaseGrant, request count = -1, request size = -1, response count = -1, response size = -1, request content = 
+Feb 18 11:17:56 ubuntu etcd[65202]: start time = 2024-02-18 11:17:56.659568823 +0000 UTC m=+384.824894822, time spent = 212.887µs, remote = 10.201.5.82:51918, response type = /etcdserverpb.Lease/LeaseGrant, request count = -1, request size = -1, response count = -1, response size = -1, request content = 
+Feb 18 11:17:58 ubuntu etcd[65202]: start time = 2024-02-18 11:17:58.516831946 +0000 UTC m=+386.682157932, time spent = 487.48µs, remote = 10.201.5.82:51918, response type = /etcdserverpb.Lease/LeaseGrant, request count = -1, request size = -1, response count = -1, response size = -1, request content = 
+Feb 18 12:15:50 ubuntu etcd[65202]: INFO: 2024/02/18 12:15:50 Failed to decode request: http: invalid Read on closed Body