Skip to content

Instantly share code, notes, and snippets.

@EugenMayer
Created December 30, 2022 10:18
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save EugenMayer/2b600b0c24974b672616c746e3dcb6a7 to your computer and use it in GitHub Desktop.
Save EugenMayer/2b600b0c24974b672616c746e3dcb6a7 to your computer and use it in GitHub Desktop.
2022-12-30 11:17:29.286 7 INFO oslo.privsep.daemon [-] Running privsep helper: ['sudo', 'neutron-rootwrap', '/etc/neutron/rootwrap.conf', 'privsep-helper', '--config-file', '/etc/neutron/neutron.conf', '--config-file', '/etc/neutron/neutron_ovn_metadata_agent.ini', '--privsep_context', 'neutron.privileged.namespace_cmd', '--privsep_sock_path', '/tmp/tmpvm3yxofo/privsep.sock']
2022-12-30 11:17:29.298 24 INFO neutron.agent.ovn.metadata.ovsdb [-] Getting OvsdbSbOvnIdl for MetadataAgent with retry
2022-12-30 11:17:29.298 23 INFO neutron.agent.ovn.metadata.ovsdb [-] Getting OvsdbSbOvnIdl for MetadataAgent with retry
2022-12-30 11:17:29.298 24 INFO ovsdbapp.backend.ovs_idl.vlog [-] tcp:10.0.0.3:6642: connecting...
2022-12-30 11:17:29.298 23 INFO ovsdbapp.backend.ovs_idl.vlog [-] tcp:10.0.0.3:6642: connecting...
2022-12-30 11:17:29.298 24 INFO ovsdbapp.backend.ovs_idl.vlog [-] tcp:10.0.0.3:6642: connected
2022-12-30 11:17:29.299 23 INFO ovsdbapp.backend.ovs_idl.vlog [-] tcp:10.0.0.3:6642: connected
2022-12-30 11:17:29.348 24 INFO eventlet.wsgi.server [-] (24) wsgi starting up on http:/var/lib/neutron/kolla/metadata_proxy
2022-12-30 11:17:29.348 23 INFO eventlet.wsgi.server [-] (23) wsgi starting up on http:/var/lib/neutron/kolla/metadata_proxy
2022-12-30 11:17:29.532 7 INFO oslo.privsep.daemon [-] Spawned new privsep daemon via rootwrap
2022-12-30 11:17:29.497 29 INFO oslo.privsep.daemon [-] privsep daemon starting
2022-12-30 11:17:29.499 29 INFO oslo.privsep.daemon [-] privsep process running with uid/gid: 0/0
2022-12-30 11:17:29.500 29 INFO oslo.privsep.daemon [-] privsep process running with capabilities (eff/prm/inh): CAP_SYS_ADMIN/CAP_SYS_ADMIN/none
2022-12-30 11:17:29.500 29 INFO oslo.privsep.daemon [-] privsep daemon running as pid 29
2022-12-30 11:17:29.861 7 INFO oslo.privsep.daemon [-] Running privsep helper: ['sudo', 'neutron-rootwrap', '/etc/neutron/rootwrap.conf', 'privsep-helper', '--privsep_context', 'neutron.privileged.default', '--privsep_sock_path', '/tmp/tmpldxffrvd/privsep.sock']
2022-12-30 11:17:30.108 7 INFO oslo.privsep.daemon [-] Spawned new privsep daemon via rootwrap
2022-12-30 11:17:30.070 36 INFO oslo.privsep.daemon [-] privsep daemon starting
2022-12-30 11:17:30.073 36 INFO oslo.privsep.daemon [-] privsep process running with uid/gid: 0/0
2022-12-30 11:17:30.073 36 INFO oslo.privsep.daemon [-] privsep process running with capabilities (eff/prm/inh): CAP_DAC_OVERRIDE|CAP_DAC_READ_SEARCH|CAP_NET_ADMIN|CAP_SYS_ADMIN|CAP_SYS_PTRACE/CAP_DAC_OVERRIDE|CAP_DAC_READ_SEARCH|CAP_NET_ADMIN|CAP_SYS_ADMIN|CAP_SYS_PTRACE/none
2022-12-30 11:17:30.074 36 INFO oslo.privsep.daemon [-] privsep daemon running as pid 36
2022-12-30 11:17:30.439 7 INFO oslo.privsep.daemon [-] Running privsep helper: ['sudo', 'neutron-rootwrap', '/etc/neutron/rootwrap.conf', 'privsep-helper', '--config-file', '/etc/neutron/neutron.conf', '--config-file', '/etc/neutron/neutron_ovn_metadata_agent.ini', '--privsep_context', 'neutron.privileged.link_cmd', '--privsep_sock_path', '/tmp/tmprfun2h_x/privsep.sock']
2022-12-30 11:17:30.687 7 INFO oslo.privsep.daemon [-] Spawned new privsep daemon via rootwrap
2022-12-30 11:17:30.654 45 INFO oslo.privsep.daemon [-] privsep daemon starting
2022-12-30 11:17:30.656 45 INFO oslo.privsep.daemon [-] privsep process running with uid/gid: 0/0
2022-12-30 11:17:30.657 45 INFO oslo.privsep.daemon [-] privsep process running with capabilities (eff/prm/inh): CAP_NET_ADMIN|CAP_SYS_ADMIN/CAP_NET_ADMIN|CAP_SYS_ADMIN/none
2022-12-30 11:17:30.657 45 INFO oslo.privsep.daemon [-] privsep daemon running as pid 45
2022-12-30 11:17:31.048 7 CRITICAL neutron [-] Unhandled error: neutron.privileged.agent.linux.ip_lib.InterfaceOperationNotSupported: Operation not supported on interface tap415ba715-d1, namespace ovnmeta-415ba715-dc0b-4a5e-beb9-43f71b0666a2.
2022-12-30 11:17:31.048 7 ERROR neutron Traceback (most recent call last):
2022-12-30 11:17:31.048 7 ERROR neutron File "/var/lib/kolla/venv/bin/neutron-ovn-metadata-agent", line 8, in <module>
2022-12-30 11:17:31.048 7 ERROR neutron sys.exit(main())
2022-12-30 11:17:31.048 7 ERROR neutron File "/var/lib/kolla/venv/lib/python3.8/site-packages/neutron/cmd/eventlet/agents/ovn_metadata.py", line 24, in main
2022-12-30 11:17:31.048 7 ERROR neutron metadata_agent.main()
2022-12-30 11:17:31.048 7 ERROR neutron File "/var/lib/kolla/venv/lib/python3.8/site-packages/neutron/agent/ovn/metadata_agent.py", line 41, in main
2022-12-30 11:17:31.048 7 ERROR neutron agt.start()
2022-12-30 11:17:31.048 7 ERROR neutron File "/var/lib/kolla/venv/lib/python3.8/site-packages/neutron/agent/ovn/metadata/agent.py", line 276, in start
2022-12-30 11:17:31.048 7 ERROR neutron self.sync()
2022-12-30 11:17:31.048 7 ERROR neutron File "/var/lib/kolla/venv/lib/python3.8/site-packages/neutron/agent/ovn/metadata/agent.py", line 59, in wrapped
2022-12-30 11:17:31.048 7 ERROR neutron return f(*args, **kwargs)
2022-12-30 11:17:31.048 7 ERROR neutron File "/var/lib/kolla/venv/lib/python3.8/site-packages/neutron/agent/ovn/metadata/agent.py", line 351, in sync
2022-12-30 11:17:31.048 7 ERROR neutron self.ensure_all_networks_provisioned(nets)
2022-12-30 11:17:31.048 7 ERROR neutron File "/var/lib/kolla/venv/lib/python3.8/site-packages/neutron/agent/ovn/metadata/agent.py", line 560, in ensure_all_networks_provisioned
2022-12-30 11:17:31.048 7 ERROR neutron self.provision_datapath(datapath, net_name)
2022-12-30 11:17:31.048 7 ERROR neutron File "/var/lib/kolla/venv/lib/python3.8/site-packages/neutron/agent/ovn/metadata/agent.py", line 507, in provision_datapath
2022-12-30 11:17:31.048 7 ERROR neutron ip2.addr.delete(ipaddr)
2022-12-30 11:17:31.048 7 ERROR neutron File "/var/lib/kolla/venv/lib/python3.8/site-packages/neutron/agent/linux/ip_lib.py", line 540, in delete
2022-12-30 11:17:31.048 7 ERROR neutron delete_ip_address(cidr, self.name, self._parent.namespace)
2022-12-30 11:17:31.048 7 ERROR neutron File "/var/lib/kolla/venv/lib/python3.8/site-packages/neutron/agent/linux/ip_lib.py", line 834, in delete_ip_address
2022-12-30 11:17:31.048 7 ERROR neutron privileged.delete_ip_address(
2022-12-30 11:17:31.048 7 ERROR neutron File "/var/lib/kolla/venv/lib/python3.8/site-packages/oslo_privsep/priv_context.py", line 271, in _wrap
2022-12-30 11:17:31.048 7 ERROR neutron return self.channel.remote_call(name, args, kwargs,
2022-12-30 11:17:31.048 7 ERROR neutron File "/var/lib/kolla/venv/lib/python3.8/site-packages/oslo_privsep/daemon.py", line 216, in remote_call
2022-12-30 11:17:31.048 7 ERROR neutron raise exc_type(*result[2])
2022-12-30 11:17:31.048 7 ERROR neutron neutron.privileged.agent.linux.ip_lib.InterfaceOperationNotSupported: Operation not supported on interface tap415ba715-d1, namespace ovnmeta-415ba715-dc0b-4a5e-beb9-43f71b0666a2.
2022-12-30 11:17:31.048 7 ERROR neutron
c/neutron/neutron_ovn_metadata_agent.ini', '--privsep_context', 'neutron.privileged.namespace_cmd', '--privsep_sock_path', '/tmp/tmplru743ey/privsep.sock']
2022-12-30 10:33:43.824 23 INFO neutron.agent.ovn.metadata.ovsdb [-] Getting OvsdbSbOvnIdl for MetadataAgent with retry
2022-12-30 10:33:43.825 23 INFO ovsdbapp.backend.ovs_idl.vlog [-] tcp:10.0.0.3:6642: connecting...
2022-12-30 10:33:43.825 23 INFO ovsdbapp.backend.ovs_idl.vlog [-] tcp:10.0.0.3:6642: connected
2022-12-30 10:33:43.825 22 INFO neutron.agent.ovn.metadata.ovsdb [-] Getting OvsdbSbOvnIdl for MetadataAgent with retry
2022-12-30 10:33:43.826 22 INFO ovsdbapp.backend.ovs_idl.vlog [-] tcp:10.0.0.3:6642: connecting...
2022-12-30 10:33:43.826 22 INFO ovsdbapp.backend.ovs_idl.vlog [-] tcp:10.0.0.3:6642: connected
2022-12-30 10:33:43.893 23 INFO eventlet.wsgi.server [-] (23) wsgi starting up on http:/var/lib/neutron/kolla/metadata_proxy
2022-12-30 10:33:43.912 22 INFO eventlet.wsgi.server [-] (22) wsgi starting up on http:/var/lib/neutron/kolla/metadata_proxy
2022-12-30 10:33:44.173 6 INFO oslo.privsep.daemon [-] Spawned new privsep daemon via rootwrap
2022-12-30 10:33:44.114 28 INFO oslo.privsep.daemon [-] privsep daemon starting
2022-12-30 10:33:44.116 28 INFO oslo.privsep.daemon [-] privsep process running with uid/gid: 0/0
2022-12-30 10:33:44.117 28 INFO oslo.privsep.daemon [-] privsep process running with capabilities (eff/prm/inh): CAP_SYS_ADMIN/CAP_SYS_ADMIN/none
2022-12-30 10:33:44.117 28 INFO oslo.privsep.daemon [-] privsep daemon running as pid 28
2022-12-30 11:10:23.744 22 INFO ovsdbapp.backend.ovs_idl.vlog [-] tcp:10.0.0.3:6642: connection closed by peer
2022-12-30 11:10:23.744 23 INFO ovsdbapp.backend.ovs_idl.vlog [-] tcp:10.0.0.3:6642: connection closed by peer
2022-12-30 11:10:23.744 6 INFO ovsdbapp.backend.ovs_idl.vlog [-] tcp:10.0.0.3:6642: connection closed by peer
2022-12-30 11:10:23.745 6 INFO ovsdbapp.backend.ovs_idl.vlog [-] tcp:127.0.0.1:6640: connection closed by peer
2022-12-30 11:10:24.182 6 INFO oslo_service.service [-] Caught SIGTERM, stopping children
2022-12-30 11:10:24.184 23 INFO eventlet.wsgi.server [-] (23) wsgi exited, is_accepting=True
2022-12-30 11:10:24.184 22 INFO eventlet.wsgi.server [-] (22) wsgi exited, is_accepting=True
2022-12-30 11:10:24.188 6 INFO oslo_service.service [-] Waiting on 2 children to exit
2022-12-30 11:10:24.189 6 INFO oslo_service.service [-] Child 22 exited with status 0
2022-12-30 11:10:24.189 6 INFO oslo_service.service [-] Child 23 exited with status 0
2022-12-30 11:12:32.525 7 INFO neutron.common.config [-] Logging enabled!
2022-12-30 11:12:32.526 7 INFO neutron.common.config [-] /var/lib/kolla/venv/bin/neutron-ovn-metadata-agent version 19.4.1.dev106
2022-12-30 11:12:32.551 7 INFO ovsdbapp.backend.ovs_idl.vlog [-] tcp:127.0.0.1:6640: connecting...
2022-12-30 11:12:32.552 7 INFO ovsdbapp.backend.ovs_idl.vlog [-] tcp:127.0.0.1:6640: connected
2022-12-30 11:12:32.676 7 WARNING neutron.agent.ovn.metadata.agent [-] Can't read ovn-bridge external-id from OVSDB. Using br-int instead.
2022-12-30 11:12:32.676 7 INFO neutron.agent.ovn.metadata.agent [-] Loaded chassis name controller1 (UUID: 420f73a3-dc74-58cc-b662-a7580c173265) and ovn bridge br-int.
2022-12-30 11:12:32.691 7 INFO neutron.agent.ovn.metadata.ovsdb [-] Getting OvsdbSbOvnIdl for MetadataAgent with retry
2022-12-30 11:12:32.691 7 INFO ovsdbapp.backend.ovs_idl.vlog [-] tcp:10.0.0.3:6642: connecting...
2022-12-30 11:12:32.691 7 INFO ovsdbapp.backend.ovs_idl.vlog [-] tcp:10.0.0.3:6642: connected
2022-12-30 11:12:32.766 7 INFO oslo_service.service [-] Starting 2 workers
2022-12-30 11:12:32.772 7 INFO oslo.privsep.daemon [-] Running privsep helper: ['sudo', 'neutron-rootwrap', '/etc/neutron/rootwrap.conf', 'privsep-helper', '--config-file', '/etc/neutron/neutron.conf', '--config-file', '/etc/neutron/neutron_ovn_metadata_agent.ini', '--privsep_context', 'neutron.privileged.namespace_cmd', '--privsep_sock_path', '/tmp/tmpu1rtwrh_/privsep.sock']
2022-12-30 11:12:32.788 23 INFO neutron.agent.ovn.metadata.ovsdb [-] Getting OvsdbSbOvnIdl for MetadataAgent with retry
2022-12-30 11:12:32.789 23 INFO ovsdbapp.backend.ovs_idl.vlog [-] tcp:10.0.0.3:6642: connecting...
2022-12-30 11:12:32.789 23 INFO ovsdbapp.backend.ovs_idl.vlog [-] tcp:10.0.0.3:6642: connected
2022-12-30 11:12:32.808 24 INFO neutron.agent.ovn.metadata.ovsdb [-] Getting OvsdbSbOvnIdl for MetadataAgent with retry
2022-12-30 11:12:32.809 24 INFO ovsdbapp.backend.ovs_idl.vlog [-] tcp:10.0.0.3:6642: connecting...
2022-12-30 11:12:32.809 24 INFO ovsdbapp.backend.ovs_idl.vlog [-] tcp:10.0.0.3:6642: connected
2022-12-30 11:12:32.867 23 INFO eventlet.wsgi.server [-] (23) wsgi starting up on http:/var/lib/neutron/kolla/metadata_proxy
2022-12-30 11:12:32.911 24 INFO eventlet.wsgi.server [-] (24) wsgi starting up on http:/var/lib/neutron/kolla/metadata_proxy
2022-12-30 11:12:33.134 7 INFO oslo.privsep.daemon [-] Spawned new privsep daemon via rootwrap
2022-12-30 11:12:33.076 29 INFO oslo.privsep.daemon [-] privsep daemon starting
2022-12-30 11:12:33.079 29 INFO oslo.privsep.daemon [-] privsep process running with uid/gid: 0/0
2022-12-30 11:12:33.080 29 INFO oslo.privsep.daemon [-] privsep process running with capabilities (eff/prm/inh): CAP_SYS_ADMIN/CAP_SYS_ADMIN/none
2022-12-30 11:12:33.081 29 INFO oslo.privsep.daemon [-] privsep daemon running as pid 29
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment